{ "duration" : 10647.758, "empty" : False, "failCount" : 0, "passCount" : 114, "skipCount" : 3, "suites" : [ { "cases" : [ { "age" : 0, "className" : "org.subshare.core.crypto.EncrypterDecrypterStreamTest", "duration" : 14.46, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "symmetricWithoutIv", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "\nsymmetricWithoutIv: cipherTransformation=AES_CBC_PKCS5PADDING\nsymmetricWithoutIv: Generating 6166332 random bytes plaintext took 257 ms.\n08:45:25.713 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\nsymmetricWithoutIv: Creating symmetric key took 2758 ms.\nsymmetricWithoutIv: Encrypting 6166332 bytes plaintext to 6166342 bytes ciphertext took 670 ms.\nsymmetricWithoutIv: Decrypting 6166342 bytes ciphertext to 6166332 bytes plaintext took 509 ms.\n...[truncated 37174 chars]...\n4651 bytes plaintext took 244 ms.\n\nasymmetricCombiWithRandomIv: asymmetricCipherTransformation=RSA_OAEPWITHSHA1ANDMGF1PADDING\nasymmetricCombiWithRandomIv: symmetricCipherTransformation=TWOFISH_CFB_NOPADDING\nasymmetricCombiWithRandomIv: Generating 9226021 random bytes plaintext took 61 ms.\nasymmetricCombiWithRandomIv: Encrypting 9226021 bytes plaintext to 9226565 bytes ciphertext took 465 ms.\nasymmetricCombiWithRandomIv: Decrypting 9226565 bytes ciphertext to 9226021 bytes plaintext took 516 ms.\n" }, { "age" : 0, "className" : "org.subshare.core.crypto.EncrypterDecrypterStreamTest", "duration" : 14.362, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "symmetricWithRandomIv", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "\nsymmetricWithoutIv: cipherTransformation=AES_CBC_PKCS5PADDING\nsymmetricWithoutIv: Generating 6166332 random bytes plaintext took 257 ms.\n08:45:25.713 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\nsymmetricWithoutIv: Creating symmetric key took 2758 ms.\nsymmetricWithoutIv: Encrypting 6166332 bytes plaintext to 6166342 bytes ciphertext took 670 ms.\nsymmetricWithoutIv: Decrypting 6166342 bytes ciphertext to 6166332 bytes plaintext took 509 ms.\n...[truncated 37174 chars]...\n4651 bytes plaintext took 244 ms.\n\nasymmetricCombiWithRandomIv: asymmetricCipherTransformation=RSA_OAEPWITHSHA1ANDMGF1PADDING\nasymmetricCombiWithRandomIv: symmetricCipherTransformation=TWOFISH_CFB_NOPADDING\nasymmetricCombiWithRandomIv: Generating 9226021 random bytes plaintext took 61 ms.\nasymmetricCombiWithRandomIv: Encrypting 9226021 bytes plaintext to 9226565 bytes ciphertext took 465 ms.\nasymmetricCombiWithRandomIv: Decrypting 9226565 bytes ciphertext to 9226021 bytes plaintext took 516 ms.\n" }, { "age" : 0, "className" : "org.subshare.core.crypto.EncrypterDecrypterStreamTest", "duration" : 5.562, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "asymmetricPlain", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "\nsymmetricWithoutIv: cipherTransformation=AES_CBC_PKCS5PADDING\nsymmetricWithoutIv: Generating 6166332 random bytes plaintext took 257 ms.\n08:45:25.713 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\nsymmetricWithoutIv: Creating symmetric key took 2758 ms.\nsymmetricWithoutIv: Encrypting 6166332 bytes plaintext to 6166342 bytes ciphertext took 670 ms.\nsymmetricWithoutIv: Decrypting 6166342 bytes ciphertext to 6166332 bytes plaintext took 509 ms.\n...[truncated 37174 chars]...\n4651 bytes plaintext took 244 ms.\n\nasymmetricCombiWithRandomIv: asymmetricCipherTransformation=RSA_OAEPWITHSHA1ANDMGF1PADDING\nasymmetricCombiWithRandomIv: symmetricCipherTransformation=TWOFISH_CFB_NOPADDING\nasymmetricCombiWithRandomIv: Generating 9226021 random bytes plaintext took 61 ms.\nasymmetricCombiWithRandomIv: Encrypting 9226021 bytes plaintext to 9226565 bytes ciphertext took 465 ms.\nasymmetricCombiWithRandomIv: Decrypting 9226565 bytes ciphertext to 9226021 bytes plaintext took 516 ms.\n" }, { "age" : 0, "className" : "org.subshare.core.crypto.EncrypterDecrypterStreamTest", "duration" : 15.501, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "asymmetricCombiWithRandomIv", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "\nsymmetricWithoutIv: cipherTransformation=AES_CBC_PKCS5PADDING\nsymmetricWithoutIv: Generating 6166332 random bytes plaintext took 257 ms.\n08:45:25.713 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\nsymmetricWithoutIv: Creating symmetric key took 2758 ms.\nsymmetricWithoutIv: Encrypting 6166332 bytes plaintext to 6166342 bytes ciphertext took 670 ms.\nsymmetricWithoutIv: Decrypting 6166342 bytes ciphertext to 6166332 bytes plaintext took 509 ms.\n...[truncated 37174 chars]...\n4651 bytes plaintext took 244 ms.\n\nasymmetricCombiWithRandomIv: asymmetricCipherTransformation=RSA_OAEPWITHSHA1ANDMGF1PADDING\nasymmetricCombiWithRandomIv: symmetricCipherTransformation=TWOFISH_CFB_NOPADDING\nasymmetricCombiWithRandomIv: Generating 9226021 random bytes plaintext took 61 ms.\nasymmetricCombiWithRandomIv: Encrypting 9226021 bytes plaintext to 9226565 bytes ciphertext took 465 ms.\nasymmetricCombiWithRandomIv: Decrypting 9226565 bytes ciphertext to 9226021 bytes plaintext took 516 ms.\n" } ], "duration" : 49.885, "id" : None, "name" : "org.subshare.core.crypto.EncrypterDecrypterStreamTest", "stderr" : "", "stdout" : "\nsymmetricWithoutIv: cipherTransformation=AES_CBC_PKCS5PADDING\nsymmetricWithoutIv: Generating 6166332 random bytes plaintext took 257 ms.\n08:45:25.713 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\nsymmetricWithoutIv: Creating symmetric key took 2758 ms.\nsymmetricWithoutIv: Encrypting 6166332 bytes plaintext to 6166342 bytes ciphertext took 670 ms.\nsymmetricWithoutIv: Decrypting 6166342 bytes ciphertext to 6166332 bytes plaintext took 509 ms.\n...[truncated 37174 chars]...\n4651 bytes plaintext took 244 ms.\n\nasymmetricCombiWithRandomIv: asymmetricCipherTransformation=RSA_OAEPWITHSHA1ANDMGF1PADDING\nasymmetricCombiWithRandomIv: symmetricCipherTransformation=TWOFISH_CFB_NOPADDING\nasymmetricCombiWithRandomIv: Generating 9226021 random bytes plaintext took 61 ms.\nasymmetricCombiWithRandomIv: Encrypting 9226021 bytes plaintext to 9226565 bytes ciphertext took 465 ms.\nasymmetricCombiWithRandomIv: Decrypting 9226565 bytes ciphertext to 9226021 bytes plaintext took 516 ms.\n", "timestamp" : "2018-12-25T07:45:23" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.core.file.EncryptedDataFileTest", "duration" : 1.533, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "writeReadSimpleEncryptedDataFile", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "" } ], "duration" : 1.533, "id" : None, "name" : "org.subshare.core.file.EncryptedDataFileTest", "stderr" : "", "stdout" : "", "timestamp" : "2018-12-25T07:45:29" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.core.gpg.GnuPgTest", "duration" : 5.96, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "encryptSignAndDecryptVerify", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : ">>> pub >>>\nkeyID: 16686379b818da48\nfingerprint: E8:3E:05:6D:B9:48:9E:0E:4B:56:05:89:16:68:63:79:B8:18:DA:48\nmasterKey: true\nencryptionKey: false\nuserID: Niklas Schiffler \nuserID: Niklas Schiffler \nsignature.keyID: 16686379b818da48\nsignature.signatureType: POSITIVE_CERTIFICATION\nsignature.keyID: 3a7e3c9cbce48dc2\nsignature.signatureType: POSITIVE_CERTIFICATION\nsignature.keyID: ead508863c3db998\nsignature.signatureType: POSITIVE_CERTIFICATION\nsignature.ke\n...[truncated 26887 chars]...\newizards.co>\nsignature.keyID: d7a92a24aa97ddbd\nsignature.signatureType: POSITIVE_CERTIFICATION\n<<< pub <<<\n>>> pub >>>\nkeyID: a58da7d810b74edf\nfingerprint: 6F:EA:38:9D:83:64:EE:9E:0C:D9:9B:86:A5:8D:A7:D8:10:B7:4E:DF\nmasterKey: false\nencryptionKey: true\nsignature.keyID: d7a92a24aa97ddbd\nsignature.signatureType: SUBKEY_BINDING\n<<< pub <<<\n>>> sec >>>\nkeyID: d7a92a24aa97ddbd\nuserID: Marco หงุ่ยตระกูล-Schulze (TEST) \n<<< sec <<<\n>>> sec >>>\nkeyID: a58da7d810b74edf\n<<< sec <<<\n\n" }, { "age" : 0, "className" : "org.subshare.core.gpg.GnuPgTest", "duration" : 0.427, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "encryptAndDecrypt", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : ">>> pub >>>\nkeyID: 16686379b818da48\nfingerprint: E8:3E:05:6D:B9:48:9E:0E:4B:56:05:89:16:68:63:79:B8:18:DA:48\nmasterKey: true\nencryptionKey: false\nuserID: Niklas Schiffler \nuserID: Niklas Schiffler \nsignature.keyID: 16686379b818da48\nsignature.signatureType: POSITIVE_CERTIFICATION\nsignature.keyID: 3a7e3c9cbce48dc2\nsignature.signatureType: POSITIVE_CERTIFICATION\nsignature.keyID: ead508863c3db998\nsignature.signatureType: POSITIVE_CERTIFICATION\nsignature.ke\n...[truncated 26887 chars]...\newizards.co>\nsignature.keyID: d7a92a24aa97ddbd\nsignature.signatureType: POSITIVE_CERTIFICATION\n<<< pub <<<\n>>> pub >>>\nkeyID: a58da7d810b74edf\nfingerprint: 6F:EA:38:9D:83:64:EE:9E:0C:D9:9B:86:A5:8D:A7:D8:10:B7:4E:DF\nmasterKey: false\nencryptionKey: true\nsignature.keyID: d7a92a24aa97ddbd\nsignature.signatureType: SUBKEY_BINDING\n<<< pub <<<\n>>> sec >>>\nkeyID: d7a92a24aa97ddbd\nuserID: Marco หงุ่ยตระกูล-Schulze (TEST) \n<<< sec <<<\n>>> sec >>>\nkeyID: a58da7d810b74edf\n<<< sec <<<\n\n" }, { "age" : 0, "className" : "org.subshare.core.gpg.GnuPgTest", "duration" : 0.214, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "readPubringGpg", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : ">>> pub >>>\nkeyID: 16686379b818da48\nfingerprint: E8:3E:05:6D:B9:48:9E:0E:4B:56:05:89:16:68:63:79:B8:18:DA:48\nmasterKey: true\nencryptionKey: false\nuserID: Niklas Schiffler \nuserID: Niklas Schiffler \nsignature.keyID: 16686379b818da48\nsignature.signatureType: POSITIVE_CERTIFICATION\nsignature.keyID: 3a7e3c9cbce48dc2\nsignature.signatureType: POSITIVE_CERTIFICATION\nsignature.keyID: ead508863c3db998\nsignature.signatureType: POSITIVE_CERTIFICATION\nsignature.ke\n...[truncated 26887 chars]...\newizards.co>\nsignature.keyID: d7a92a24aa97ddbd\nsignature.signatureType: POSITIVE_CERTIFICATION\n<<< pub <<<\n>>> pub >>>\nkeyID: a58da7d810b74edf\nfingerprint: 6F:EA:38:9D:83:64:EE:9E:0C:D9:9B:86:A5:8D:A7:D8:10:B7:4E:DF\nmasterKey: false\nencryptionKey: true\nsignature.keyID: d7a92a24aa97ddbd\nsignature.signatureType: SUBKEY_BINDING\n<<< pub <<<\n>>> sec >>>\nkeyID: d7a92a24aa97ddbd\nuserID: Marco หงุ่ยตระกูล-Schulze (TEST) \n<<< sec <<<\n>>> sec >>>\nkeyID: a58da7d810b74edf\n<<< sec <<<\n\n" }, { "age" : 0, "className" : "org.subshare.core.gpg.GnuPgTest", "duration" : 0.021, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "readSecringGpg", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : ">>> pub >>>\nkeyID: 16686379b818da48\nfingerprint: E8:3E:05:6D:B9:48:9E:0E:4B:56:05:89:16:68:63:79:B8:18:DA:48\nmasterKey: true\nencryptionKey: false\nuserID: Niklas Schiffler \nuserID: Niklas Schiffler \nsignature.keyID: 16686379b818da48\nsignature.signatureType: POSITIVE_CERTIFICATION\nsignature.keyID: 3a7e3c9cbce48dc2\nsignature.signatureType: POSITIVE_CERTIFICATION\nsignature.keyID: ead508863c3db998\nsignature.signatureType: POSITIVE_CERTIFICATION\nsignature.ke\n...[truncated 26887 chars]...\newizards.co>\nsignature.keyID: d7a92a24aa97ddbd\nsignature.signatureType: POSITIVE_CERTIFICATION\n<<< pub <<<\n>>> pub >>>\nkeyID: a58da7d810b74edf\nfingerprint: 6F:EA:38:9D:83:64:EE:9E:0C:D9:9B:86:A5:8D:A7:D8:10:B7:4E:DF\nmasterKey: false\nencryptionKey: true\nsignature.keyID: d7a92a24aa97ddbd\nsignature.signatureType: SUBKEY_BINDING\n<<< pub <<<\n>>> sec >>>\nkeyID: d7a92a24aa97ddbd\nuserID: Marco หงุ่ยตระกูล-Schulze (TEST) \n<<< sec <<<\n>>> sec >>>\nkeyID: a58da7d810b74edf\n<<< sec <<<\n\n" } ], "duration" : 6.622, "id" : None, "name" : "org.subshare.core.gpg.GnuPgTest", "stderr" : "", "stdout" : ">>> pub >>>\nkeyID: 16686379b818da48\nfingerprint: E8:3E:05:6D:B9:48:9E:0E:4B:56:05:89:16:68:63:79:B8:18:DA:48\nmasterKey: true\nencryptionKey: false\nuserID: Niklas Schiffler \nuserID: Niklas Schiffler \nsignature.keyID: 16686379b818da48\nsignature.signatureType: POSITIVE_CERTIFICATION\nsignature.keyID: 3a7e3c9cbce48dc2\nsignature.signatureType: POSITIVE_CERTIFICATION\nsignature.keyID: ead508863c3db998\nsignature.signatureType: POSITIVE_CERTIFICATION\nsignature.ke\n...[truncated 26887 chars]...\newizards.co>\nsignature.keyID: d7a92a24aa97ddbd\nsignature.signatureType: POSITIVE_CERTIFICATION\n<<< pub <<<\n>>> pub >>>\nkeyID: a58da7d810b74edf\nfingerprint: 6F:EA:38:9D:83:64:EE:9E:0C:D9:9B:86:A5:8D:A7:D8:10:B7:4E:DF\nmasterKey: false\nencryptionKey: true\nsignature.keyID: d7a92a24aa97ddbd\nsignature.signatureType: SUBKEY_BINDING\n<<< pub <<<\n>>> sec >>>\nkeyID: d7a92a24aa97ddbd\nuserID: Marco หงุ่ยตระกูล-Schulze (TEST) \n<<< sec <<<\n>>> sec >>>\nkeyID: a58da7d810b74edf\n<<< sec <<<\n\n", "timestamp" : "2018-12-25T07:45:22" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.core.io.LimitedInputStreamTest", "duration" : 1.847, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "randomLengthWithUnderlyingSameLength", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "" } ], "duration" : 1.847, "id" : None, "name" : "org.subshare.core.io.LimitedInputStreamTest", "stderr" : "", "stdout" : "", "timestamp" : "2018-12-25T07:45:20" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.core.io.MultiInputStreamTest", "duration" : 7.949, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "randomCombi", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "" } ], "duration" : 7.949, "id" : None, "name" : "org.subshare.core.io.MultiInputStreamTest", "stderr" : "", "stdout" : "", "timestamp" : "2018-12-25T07:45:21" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.core.pgp.PgpTest", "duration" : 8.051, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "inlineSignThenEncryptAndDecryptThenVerify", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "08:45:25.040 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n08:45:25.100 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:45:25.202 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/E6sXHcLvjb4RucWYp4-rgg/.gnupg\n08:45:25.207 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.core/build/E6sXHcLvjb4RucWYp4-rgg/.gnupg\n08:45:26.615 [Test \n...[truncated 27265 chars]...\n:54) [gradle-base-services-3.1.jar:3.1]\n\tat org.gradle.internal.concurrent.StoppableExecutorImpl$1.run(StoppableExecutorImpl.java:40) [gradle-base-services-3.1.jar:3.1]\n\tat java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [na:1.8.0_191]\n\tat java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [na:1.8.0_191]\n\tat java.lang.Thread.run(Thread.java:748) [na:1.8.0_191]\n08:45:38.681 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.core.pgp.PgpTest", "duration" : 0.084, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "signAndVerifyViaPgpSignable", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "08:45:25.040 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n08:45:25.100 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:45:25.202 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/E6sXHcLvjb4RucWYp4-rgg/.gnupg\n08:45:25.207 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.core/build/E6sXHcLvjb4RucWYp4-rgg/.gnupg\n08:45:26.615 [Test \n...[truncated 27265 chars]...\n:54) [gradle-base-services-3.1.jar:3.1]\n\tat org.gradle.internal.concurrent.StoppableExecutorImpl$1.run(StoppableExecutorImpl.java:40) [gradle-base-services-3.1.jar:3.1]\n\tat java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [na:1.8.0_191]\n\tat java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [na:1.8.0_191]\n\tat java.lang.Thread.run(Thread.java:748) [na:1.8.0_191]\n08:45:38.681 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.core.pgp.PgpTest", "duration" : 1.728, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "inlineSignAndVerify", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "08:45:25.040 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n08:45:25.100 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:45:25.202 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/E6sXHcLvjb4RucWYp4-rgg/.gnupg\n08:45:25.207 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.core/build/E6sXHcLvjb4RucWYp4-rgg/.gnupg\n08:45:26.615 [Test \n...[truncated 27265 chars]...\n:54) [gradle-base-services-3.1.jar:3.1]\n\tat org.gradle.internal.concurrent.StoppableExecutorImpl$1.run(StoppableExecutorImpl.java:40) [gradle-base-services-3.1.jar:3.1]\n\tat java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [na:1.8.0_191]\n\tat java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [na:1.8.0_191]\n\tat java.lang.Thread.run(Thread.java:748) [na:1.8.0_191]\n08:45:38.681 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.core.pgp.PgpTest", "duration" : 0.218, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "exportImportPublicKey", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "08:45:25.040 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n08:45:25.100 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:45:25.202 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/E6sXHcLvjb4RucWYp4-rgg/.gnupg\n08:45:25.207 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.core/build/E6sXHcLvjb4RucWYp4-rgg/.gnupg\n08:45:26.615 [Test \n...[truncated 27265 chars]...\n:54) [gradle-base-services-3.1.jar:3.1]\n\tat org.gradle.internal.concurrent.StoppableExecutorImpl$1.run(StoppableExecutorImpl.java:40) [gradle-base-services-3.1.jar:3.1]\n\tat java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [na:1.8.0_191]\n\tat java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [na:1.8.0_191]\n\tat java.lang.Thread.run(Thread.java:748) [na:1.8.0_191]\n08:45:38.681 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.core.pgp.PgpTest", "duration" : 2.153, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "detachedSignAndVerify", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "08:45:25.040 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n08:45:25.100 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:45:25.202 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/E6sXHcLvjb4RucWYp4-rgg/.gnupg\n08:45:25.207 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.core/build/E6sXHcLvjb4RucWYp4-rgg/.gnupg\n08:45:26.615 [Test \n...[truncated 27265 chars]...\n:54) [gradle-base-services-3.1.jar:3.1]\n\tat org.gradle.internal.concurrent.StoppableExecutorImpl$1.run(StoppableExecutorImpl.java:40) [gradle-base-services-3.1.jar:3.1]\n\tat java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [na:1.8.0_191]\n\tat java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [na:1.8.0_191]\n\tat java.lang.Thread.run(Thread.java:748) [na:1.8.0_191]\n08:45:38.681 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" } ], "duration" : 12.233999, "id" : None, "name" : "org.subshare.core.pgp.PgpTest", "stderr" : "", "stdout" : "08:45:25.040 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n08:45:25.100 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:45:25.202 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/E6sXHcLvjb4RucWYp4-rgg/.gnupg\n08:45:25.207 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.core/build/E6sXHcLvjb4RucWYp4-rgg/.gnupg\n08:45:26.615 [Test \n...[truncated 27265 chars]...\n:54) [gradle-base-services-3.1.jar:3.1]\n\tat org.gradle.internal.concurrent.StoppableExecutorImpl$1.run(StoppableExecutorImpl.java:40) [gradle-base-services-3.1.jar:3.1]\n\tat java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [na:1.8.0_191]\n\tat java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [na:1.8.0_191]\n\tat java.lang.Thread.run(Thread.java:748) [na:1.8.0_191]\n08:45:38.681 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n", "timestamp" : "2018-12-25T07:45:26" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.core.user.AddDuplicateUserRepoKeyPublicKeyToUserTest", "duration" : 3.192, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "addAllDifferentUserRepoKeyPublicKeysToUser", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "" }, { "age" : 0, "className" : "org.subshare.core.user.AddDuplicateUserRepoKeyPublicKeyToUserTest", "duration" : 0.005, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "addAllSameUserRepoKeyPublicKeyInCollectionToUser", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "" }, { "age" : 0, "className" : "org.subshare.core.user.AddDuplicateUserRepoKeyPublicKeyToUserTest", "duration" : 0.004, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "addSameUserRepoKeyPublicKeyTwiceToUser", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "" }, { "age" : 0, "className" : "org.subshare.core.user.AddDuplicateUserRepoKeyPublicKeyToUserTest", "duration" : 0.01, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "addDifferentUserRepoKeyPublicKeysToUser", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "" } ], "duration" : 3.211, "id" : None, "name" : "org.subshare.core.user.AddDuplicateUserRepoKeyPublicKeyToUserTest", "stderr" : "", "stdout" : "", "timestamp" : "2018-12-25T07:45:21" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.core.user.UserRegistryTest", "duration" : 3.243, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "addUser", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "08:45:29.663 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n08:45:29.800 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:45:29.909 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/mVDqngWAj7QZZnbhpvcZUA/.gnupg\n08:45:29.911 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.core/build/mVDqngWAj7QZZnbhpvcZUA/.gnupg\n08:45:30.047 [Test \n...[truncated 13386 chars]...\ntance.\n08:45:50.895 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance.\n08:45:57.231 [Test worker] INFO o.s.c.c.KeyFactory - Creating asymmetric key pair with defaults took 6332 ms.\n08:45:57.245 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance.\n08:45:57.350 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance.\n08:45:57.405 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.core.user.UserRegistryTest", "duration" : 7.734, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "testGpgKeyTrustLevels", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "08:45:29.663 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n08:45:29.800 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:45:29.909 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/mVDqngWAj7QZZnbhpvcZUA/.gnupg\n08:45:29.911 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.core/build/mVDqngWAj7QZZnbhpvcZUA/.gnupg\n08:45:30.047 [Test \n...[truncated 13386 chars]...\ntance.\n08:45:50.895 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance.\n08:45:57.231 [Test worker] INFO o.s.c.c.KeyFactory - Creating asymmetric key pair with defaults took 6332 ms.\n08:45:57.245 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance.\n08:45:57.350 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance.\n08:45:57.405 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.core.user.UserRegistryTest", "duration" : 16.636, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "initUserRegistryFromGpgKeys", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "08:45:29.663 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n08:45:29.800 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:45:29.909 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/mVDqngWAj7QZZnbhpvcZUA/.gnupg\n08:45:29.911 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.core/build/mVDqngWAj7QZZnbhpvcZUA/.gnupg\n08:45:30.047 [Test \n...[truncated 13386 chars]...\ntance.\n08:45:50.895 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance.\n08:45:57.231 [Test worker] INFO o.s.c.c.KeyFactory - Creating asymmetric key pair with defaults took 6332 ms.\n08:45:57.245 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance.\n08:45:57.350 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance.\n08:45:57.405 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" } ], "duration" : 27.612999, "id" : None, "name" : "org.subshare.core.user.UserRegistryTest", "stderr" : "", "stdout" : "08:45:29.663 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n08:45:29.800 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:45:29.909 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/mVDqngWAj7QZZnbhpvcZUA/.gnupg\n08:45:29.911 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.core/build/mVDqngWAj7QZZnbhpvcZUA/.gnupg\n08:45:30.047 [Test \n...[truncated 13386 chars]...\ntance.\n08:45:50.895 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance.\n08:45:57.231 [Test worker] INFO o.s.c.c.KeyFactory - Creating asymmetric key pair with defaults took 6332 ms.\n08:45:57.245 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance.\n08:45:57.350 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance.\n08:45:57.405 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n", "timestamp" : "2018-12-25T07:45:29" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.core.user.UserRepoKeyRingVsPublicKeysUserImplTest", "duration" : 2.342, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "firstAddPublicKeysThenCreateUserRepoKeyRing", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "" }, { "age" : 0, "className" : "org.subshare.core.user.UserRepoKeyRingVsPublicKeysUserImplTest", "duration" : 0.082, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "firstCreateUserRepoKeyRingThenAddPublicKeys", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "" } ], "duration" : 2.424, "id" : None, "name" : "org.subshare.core.user.UserRepoKeyRingVsPublicKeysUserImplTest", "stderr" : "", "stdout" : "", "timestamp" : "2018-12-25T07:45:21" }, { "cases" : [ { "age" : 104, "className" : "org.subshare.crypto.AsymmetricKeyTest", "duration" : 0.0, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 257, "name" : "generateManySymmetricKeys", "skipped" : True, "skippedMessage" : None, "status" : "SKIPPED", "stderr" : "", "stdout" : "" }, { "age" : 0, "className" : "org.subshare.crypto.AsymmetricKeyTest", "duration" : 10.905, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "encodeDecodeRSAwithOAEPwithSHA1andMGF1Padding", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "" }, { "age" : 0, "className" : "org.subshare.crypto.AsymmetricKeyTest", "duration" : 3.587, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "encodeDecodeRSA", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "" } ], "duration" : 14.492, "id" : None, "name" : "org.subshare.crypto.AsymmetricKeyTest", "stderr" : "", "stdout" : "", "timestamp" : "2018-12-25T07:46:24" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.crypto.CipherTest", "duration" : 2.704, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "testLookupAllSupportedCiphers", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "08:46:32.981 [Test worker] INFO o.s.c.CipherTest - testLookupAllSupportedCiphers: Successfully created 29934 ciphers in 2542 msec.\n08:46:33.115 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//\n08:46:33.119 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyParameter: Transformation \"AES.FAST//\" does not support IV => Skipping.\n08:46:33.122 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//NOPADDING\n08:46:33.130 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyP\n...[truncated 3456005 chars]...\ns.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding\n08:46:45.948 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding\n08:46:45.997 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CBC/PKCS5Padding\n08:46:46.290 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CFB/NoPadding\n08:46:46.646 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding\n08:46:46.693 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding\n" }, { "age" : 0, "className" : "org.subshare.crypto.CipherTest", "duration" : 8.619, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "testNullAsKeyParameter", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "08:46:32.981 [Test worker] INFO o.s.c.CipherTest - testLookupAllSupportedCiphers: Successfully created 29934 ciphers in 2542 msec.\n08:46:33.115 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//\n08:46:33.119 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyParameter: Transformation \"AES.FAST//\" does not support IV => Skipping.\n08:46:33.122 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//NOPADDING\n08:46:33.130 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyP\n...[truncated 3456005 chars]...\ns.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding\n08:46:45.948 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding\n08:46:45.997 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CBC/PKCS5Padding\n08:46:46.290 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CFB/NoPadding\n08:46:46.646 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding\n08:46:46.693 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding\n" }, { "age" : 0, "className" : "org.subshare.crypto.CipherTest", "duration" : 0.111, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "testLookupCompatibilityWithJCE", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "08:46:32.981 [Test worker] INFO o.s.c.CipherTest - testLookupAllSupportedCiphers: Successfully created 29934 ciphers in 2542 msec.\n08:46:33.115 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//\n08:46:33.119 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyParameter: Transformation \"AES.FAST//\" does not support IV => Skipping.\n08:46:33.122 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//NOPADDING\n08:46:33.130 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyP\n...[truncated 3456005 chars]...\ns.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding\n08:46:45.948 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding\n08:46:45.997 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CBC/PKCS5Padding\n08:46:46.290 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CFB/NoPadding\n08:46:46.646 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding\n08:46:46.693 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding\n" }, { "age" : 0, "className" : "org.subshare.crypto.CipherTest", "duration" : 5.372, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "testSymmetricEncryptionWithoutIv", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "08:46:32.981 [Test worker] INFO o.s.c.CipherTest - testLookupAllSupportedCiphers: Successfully created 29934 ciphers in 2542 msec.\n08:46:33.115 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//\n08:46:33.119 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyParameter: Transformation \"AES.FAST//\" does not support IV => Skipping.\n08:46:33.122 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//NOPADDING\n08:46:33.130 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyP\n...[truncated 3456005 chars]...\ns.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding\n08:46:45.948 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding\n08:46:45.997 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CBC/PKCS5Padding\n08:46:46.290 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CFB/NoPadding\n08:46:46.646 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding\n08:46:46.693 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding\n" }, { "age" : 0, "className" : "org.subshare.crypto.CipherTest", "duration" : 0.134, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "testSymmetricEncryptionCompatibilityWithJCE_BouncyCastleProvider", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "08:46:32.981 [Test worker] INFO o.s.c.CipherTest - testLookupAllSupportedCiphers: Successfully created 29934 ciphers in 2542 msec.\n08:46:33.115 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//\n08:46:33.119 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyParameter: Transformation \"AES.FAST//\" does not support IV => Skipping.\n08:46:33.122 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//NOPADDING\n08:46:33.130 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyP\n...[truncated 3456005 chars]...\ns.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding\n08:46:45.948 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding\n08:46:45.997 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CBC/PKCS5Padding\n08:46:46.290 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CFB/NoPadding\n08:46:46.646 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding\n08:46:46.693 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding\n" } ], "duration" : 16.94, "id" : None, "name" : "org.subshare.crypto.CipherTest", "stderr" : "", "stdout" : "08:46:32.981 [Test worker] INFO o.s.c.CipherTest - testLookupAllSupportedCiphers: Successfully created 29934 ciphers in 2542 msec.\n08:46:33.115 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//\n08:46:33.119 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyParameter: Transformation \"AES.FAST//\" does not support IV => Skipping.\n08:46:33.122 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//NOPADDING\n08:46:33.130 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyP\n...[truncated 3456005 chars]...\ns.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding\n08:46:45.948 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding\n08:46:45.997 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CBC/PKCS5Padding\n08:46:46.290 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CFB/NoPadding\n08:46:46.646 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding\n08:46:46.693 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding\n", "timestamp" : "2018-12-25T07:46:30" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.crypto.GCMTest", "duration" : 6.473, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "testEncryptionWithCipher", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "*** 0 ***\n*** 1 ***\n*** 2 ***\n*** 3 ***\n*** 4 ***\n*** 5 ***\n*** 6 ***\n*** 7 ***\n*** 8 ***\n*** 9 ***\n*** 10 ***\n*** 11 ***\n*** 12 ***\n*** 13 ***\n*** 14 ***\n*** 15 ***\n*** 16 ***\n*** 17 ***\n*** 18 ***\n*** 19 ***\n*** 20 ***\n*** 21 ***\n*** 22 ***\n*** 23 ***\n*** 24 ***\n*** 25 ***\n*** 26 ***\n*** 27 ***\n*** 28 ***\n*** 29 ***\n*** 30 ***\n*** 31 ***\n*** 32 ***\n*** 33 ***\n*** 34 ***\n*** 35 ***\n*** 36 ***\n*** 37 ***\n*** 38 ***\n*** 39 ***\n*** 40 ***\n*** 41 ***\n*** 42 ***\n*** 43 ***\n*** 44 ***\n*** 45 ***\n*** \n...[truncated 296780 chars]...\n70 ***\n*** gcm 9971 ***\n*** gcm 9972 ***\n*** gcm 9973 ***\n*** gcm 9974 ***\n*** gcm 9975 ***\n*** gcm 9976 ***\n*** gcm 9977 ***\n*** gcm 9978 ***\n*** gcm 9979 ***\n*** gcm 9980 ***\n*** gcm 9981 ***\n*** gcm 9982 ***\n*** gcm 9983 ***\n*** gcm 9984 ***\n*** gcm 9985 ***\n*** gcm 9986 ***\n*** gcm 9987 ***\n*** gcm 9988 ***\n*** gcm 9989 ***\n*** gcm 9990 ***\n*** gcm 9991 ***\n*** gcm 9992 ***\n*** gcm 9993 ***\n*** gcm 9994 ***\n*** gcm 9995 ***\n*** gcm 9996 ***\n*** gcm 9997 ***\n*** gcm 9998 ***\n*** gcm 9999 ***\n" }, { "age" : 0, "className" : "org.subshare.crypto.GCMTest", "duration" : 2.651, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "testEncryptionWithBCLowLevelAPI", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "*** 0 ***\n*** 1 ***\n*** 2 ***\n*** 3 ***\n*** 4 ***\n*** 5 ***\n*** 6 ***\n*** 7 ***\n*** 8 ***\n*** 9 ***\n*** 10 ***\n*** 11 ***\n*** 12 ***\n*** 13 ***\n*** 14 ***\n*** 15 ***\n*** 16 ***\n*** 17 ***\n*** 18 ***\n*** 19 ***\n*** 20 ***\n*** 21 ***\n*** 22 ***\n*** 23 ***\n*** 24 ***\n*** 25 ***\n*** 26 ***\n*** 27 ***\n*** 28 ***\n*** 29 ***\n*** 30 ***\n*** 31 ***\n*** 32 ***\n*** 33 ***\n*** 34 ***\n*** 35 ***\n*** 36 ***\n*** 37 ***\n*** 38 ***\n*** 39 ***\n*** 40 ***\n*** 41 ***\n*** 42 ***\n*** 43 ***\n*** 44 ***\n*** 45 ***\n*** \n...[truncated 296780 chars]...\n70 ***\n*** gcm 9971 ***\n*** gcm 9972 ***\n*** gcm 9973 ***\n*** gcm 9974 ***\n*** gcm 9975 ***\n*** gcm 9976 ***\n*** gcm 9977 ***\n*** gcm 9978 ***\n*** gcm 9979 ***\n*** gcm 9980 ***\n*** gcm 9981 ***\n*** gcm 9982 ***\n*** gcm 9983 ***\n*** gcm 9984 ***\n*** gcm 9985 ***\n*** gcm 9986 ***\n*** gcm 9987 ***\n*** gcm 9988 ***\n*** gcm 9989 ***\n*** gcm 9990 ***\n*** gcm 9991 ***\n*** gcm 9992 ***\n*** gcm 9993 ***\n*** gcm 9994 ***\n*** gcm 9995 ***\n*** gcm 9996 ***\n*** gcm 9997 ***\n*** gcm 9998 ***\n*** gcm 9999 ***\n" } ], "duration" : 9.124001, "id" : None, "name" : "org.subshare.crypto.GCMTest", "stderr" : "", "stdout" : "*** 0 ***\n*** 1 ***\n*** 2 ***\n*** 3 ***\n*** 4 ***\n*** 5 ***\n*** 6 ***\n*** 7 ***\n*** 8 ***\n*** 9 ***\n*** 10 ***\n*** 11 ***\n*** 12 ***\n*** 13 ***\n*** 14 ***\n*** 15 ***\n*** 16 ***\n*** 17 ***\n*** 18 ***\n*** 19 ***\n*** 20 ***\n*** 21 ***\n*** 22 ***\n*** 23 ***\n*** 24 ***\n*** 25 ***\n*** 26 ***\n*** 27 ***\n*** 28 ***\n*** 29 ***\n*** 30 ***\n*** 31 ***\n*** 32 ***\n*** 33 ***\n*** 34 ***\n*** 35 ***\n*** 36 ***\n*** 37 ***\n*** 38 ***\n*** 39 ***\n*** 40 ***\n*** 41 ***\n*** 42 ***\n*** 43 ***\n*** 44 ***\n*** 45 ***\n*** \n...[truncated 296780 chars]...\n70 ***\n*** gcm 9971 ***\n*** gcm 9972 ***\n*** gcm 9973 ***\n*** gcm 9974 ***\n*** gcm 9975 ***\n*** gcm 9976 ***\n*** gcm 9977 ***\n*** gcm 9978 ***\n*** gcm 9979 ***\n*** gcm 9980 ***\n*** gcm 9981 ***\n*** gcm 9982 ***\n*** gcm 9983 ***\n*** gcm 9984 ***\n*** gcm 9985 ***\n*** gcm 9986 ***\n*** gcm 9987 ***\n*** gcm 9988 ***\n*** gcm 9989 ***\n*** gcm 9990 ***\n*** gcm 9991 ***\n*** gcm 9992 ***\n*** gcm 9993 ***\n*** gcm 9994 ***\n*** gcm 9995 ***\n*** gcm 9996 ***\n*** gcm 9997 ***\n*** gcm 9998 ***\n*** gcm 9999 ***\n", "timestamp" : "2018-12-25T07:46:27" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.crypto.MACBenchmark", "duration" : 0.143, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "testByteOrder", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "08:46:28.126 [Test worker] INFO o.s.c.MACBenchmark - short1 = -24848\n08:46:28.170 [Test worker] INFO o.s.c.MACBenchmark - short2 = -24848\n08:46:28.173 [Test worker] INFO o.s.c.MACBenchmark - int1 = 40688\n" }, { "age" : 0, "className" : "org.subshare.crypto.MACBenchmark", "duration" : 5.301, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "benchmarkCreateManyInitialisedMACCalculators", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "08:46:28.126 [Test worker] INFO o.s.c.MACBenchmark - short1 = -24848\n08:46:28.170 [Test worker] INFO o.s.c.MACBenchmark - short2 = -24848\n08:46:28.173 [Test worker] INFO o.s.c.MACBenchmark - int1 = 40688\n" }, { "age" : 0, "className" : "org.subshare.crypto.MACBenchmark", "duration" : 0.15, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "benchmarkCreateManyUNinitialisedMACCalculators", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "08:46:28.126 [Test worker] INFO o.s.c.MACBenchmark - short1 = -24848\n08:46:28.170 [Test worker] INFO o.s.c.MACBenchmark - short2 = -24848\n08:46:28.173 [Test worker] INFO o.s.c.MACBenchmark - int1 = 40688\n" }, { "age" : 0, "className" : "org.subshare.crypto.MACBenchmark", "duration" : 21.414, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "benchmarkCalculateManyMACsWithNewMACCalculator", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "08:46:28.126 [Test worker] INFO o.s.c.MACBenchmark - short1 = -24848\n08:46:28.170 [Test worker] INFO o.s.c.MACBenchmark - short2 = -24848\n08:46:28.173 [Test worker] INFO o.s.c.MACBenchmark - int1 = 40688\n" }, { "age" : 0, "className" : "org.subshare.crypto.MACBenchmark", "duration" : 17.66, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "benchmarkCalculateManyMACsWithSameMACCalculator", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "08:46:28.126 [Test worker] INFO o.s.c.MACBenchmark - short1 = -24848\n08:46:28.170 [Test worker] INFO o.s.c.MACBenchmark - short2 = -24848\n08:46:28.173 [Test worker] INFO o.s.c.MACBenchmark - int1 = 40688\n" } ], "duration" : 44.668, "id" : None, "name" : "org.subshare.crypto.MACBenchmark", "stderr" : "", "stdout" : "08:46:28.126 [Test worker] INFO o.s.c.MACBenchmark - short1 = -24848\n08:46:28.170 [Test worker] INFO o.s.c.MACBenchmark - short2 = -24848\n08:46:28.173 [Test worker] INFO o.s.c.MACBenchmark - int1 = 40688\n", "timestamp" : "2018-12-25T07:46:28" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.crypto.MACTest", "duration" : 3.936, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "testAllSupportedMACs", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "" } ], "duration" : 3.936, "id" : None, "name" : "org.subshare.crypto.MACTest", "stderr" : "", "stdout" : "", "timestamp" : "2018-12-25T07:46:26" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.crypto.ShowSupportedAlgosForDocumentation", "duration" : 0.111, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "showSupportedBlockCipherModes", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : ">>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>\n*** BlockCipherMode ***\n\nCBC\nCBC-CTS\nCCM\nCFB\nCFB104\nCFB112\nCFB120\nCFB128\nCFB136\nCFB144\nCFB152\nCFB16\nCFB160\nCFB168\nCFB176\nCFB184\nCFB192\nCFB200\nCFB208\nCFB216\nCFB224\nCFB232\nCFB24\nCFB240\nCFB248\nCFB256\nCFB32\nCFB40\nCFB48\nCFB56\nCFB64\nCFB72\nCFB8\nCFB80\nCFB88\nCFB96\nCTS\nEAX\nECB\nGCM\nGOFB\nOFB\nOFB104\nOFB112\nOFB120\nOFB128\nOFB136\nOFB144\nOFB152\nOFB16\nOFB160\nOFB168\nOFB176\nOFB184\nOFB192\nOFB200\nOFB208\nOFB216\nOFB224\nOFB232\nOFB24\nOFB240\nOFB248\nOFB256\nOFB32\nOFB40\nOFB48\nOFB56\nOFB64\n...[truncated 1515 chars]...\nADDING\nNOPADDING\nPKCS5\nPKCS5PADDING\nPKCS7\nPKCS7PADDING\nTBC\nTBCPADDING\nX9.23\nX9.23PADDING\nZEROBYTE\nZEROBYTEPADDING\n<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<\n>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>\n*** Padding/asymmetricBlock ***\n\nISO9796-1\nISO9796-1PADDING\nNOPADDING\nOAEP\nOAEPPADDING\nOAEPWITHSHA1ANDMGF1\nOAEPWITHSHA1ANDMGF1PADDING\nPKCS1\nPKCS1PADDING\n<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<\n>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>\n*** Padding/symmetricStream ***\n\nNOPADDING\n<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<\n" }, { "age" : 0, "className" : "org.subshare.crypto.ShowSupportedAlgosForDocumentation", "duration" : 0.064, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "showSupportedCipherEngines", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : ">>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>\n*** BlockCipherMode ***\n\nCBC\nCBC-CTS\nCCM\nCFB\nCFB104\nCFB112\nCFB120\nCFB128\nCFB136\nCFB144\nCFB152\nCFB16\nCFB160\nCFB168\nCFB176\nCFB184\nCFB192\nCFB200\nCFB208\nCFB216\nCFB224\nCFB232\nCFB24\nCFB240\nCFB248\nCFB256\nCFB32\nCFB40\nCFB48\nCFB56\nCFB64\nCFB72\nCFB8\nCFB80\nCFB88\nCFB96\nCTS\nEAX\nECB\nGCM\nGOFB\nOFB\nOFB104\nOFB112\nOFB120\nOFB128\nOFB136\nOFB144\nOFB152\nOFB16\nOFB160\nOFB168\nOFB176\nOFB184\nOFB192\nOFB200\nOFB208\nOFB216\nOFB224\nOFB232\nOFB24\nOFB240\nOFB248\nOFB256\nOFB32\nOFB40\nOFB48\nOFB56\nOFB64\n...[truncated 1515 chars]...\nADDING\nNOPADDING\nPKCS5\nPKCS5PADDING\nPKCS7\nPKCS7PADDING\nTBC\nTBCPADDING\nX9.23\nX9.23PADDING\nZEROBYTE\nZEROBYTEPADDING\n<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<\n>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>\n*** Padding/asymmetricBlock ***\n\nISO9796-1\nISO9796-1PADDING\nNOPADDING\nOAEP\nOAEPPADDING\nOAEPWITHSHA1ANDMGF1\nOAEPWITHSHA1ANDMGF1PADDING\nPKCS1\nPKCS1PADDING\n<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<\n>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>\n*** Padding/symmetricStream ***\n\nNOPADDING\n<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<\n" }, { "age" : 0, "className" : "org.subshare.crypto.ShowSupportedAlgosForDocumentation", "duration" : 0.076, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "showSupportedMACs", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : ">>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>\n*** BlockCipherMode ***\n\nCBC\nCBC-CTS\nCCM\nCFB\nCFB104\nCFB112\nCFB120\nCFB128\nCFB136\nCFB144\nCFB152\nCFB16\nCFB160\nCFB168\nCFB176\nCFB184\nCFB192\nCFB200\nCFB208\nCFB216\nCFB224\nCFB232\nCFB24\nCFB240\nCFB248\nCFB256\nCFB32\nCFB40\nCFB48\nCFB56\nCFB64\nCFB72\nCFB8\nCFB80\nCFB88\nCFB96\nCTS\nEAX\nECB\nGCM\nGOFB\nOFB\nOFB104\nOFB112\nOFB120\nOFB128\nOFB136\nOFB144\nOFB152\nOFB16\nOFB160\nOFB168\nOFB176\nOFB184\nOFB192\nOFB200\nOFB208\nOFB216\nOFB224\nOFB232\nOFB24\nOFB240\nOFB248\nOFB256\nOFB32\nOFB40\nOFB48\nOFB56\nOFB64\n...[truncated 1515 chars]...\nADDING\nNOPADDING\nPKCS5\nPKCS5PADDING\nPKCS7\nPKCS7PADDING\nTBC\nTBCPADDING\nX9.23\nX9.23PADDING\nZEROBYTE\nZEROBYTEPADDING\n<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<\n>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>\n*** Padding/asymmetricBlock ***\n\nISO9796-1\nISO9796-1PADDING\nNOPADDING\nOAEP\nOAEPPADDING\nOAEPWITHSHA1ANDMGF1\nOAEPWITHSHA1ANDMGF1PADDING\nPKCS1\nPKCS1PADDING\n<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<\n>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>\n*** Padding/symmetricStream ***\n\nNOPADDING\n<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<\n" }, { "age" : 0, "className" : "org.subshare.crypto.ShowSupportedAlgosForDocumentation", "duration" : 0.025, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "showSupportedPaddings", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : ">>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>\n*** BlockCipherMode ***\n\nCBC\nCBC-CTS\nCCM\nCFB\nCFB104\nCFB112\nCFB120\nCFB128\nCFB136\nCFB144\nCFB152\nCFB16\nCFB160\nCFB168\nCFB176\nCFB184\nCFB192\nCFB200\nCFB208\nCFB216\nCFB224\nCFB232\nCFB24\nCFB240\nCFB248\nCFB256\nCFB32\nCFB40\nCFB48\nCFB56\nCFB64\nCFB72\nCFB8\nCFB80\nCFB88\nCFB96\nCTS\nEAX\nECB\nGCM\nGOFB\nOFB\nOFB104\nOFB112\nOFB120\nOFB128\nOFB136\nOFB144\nOFB152\nOFB16\nOFB160\nOFB168\nOFB176\nOFB184\nOFB192\nOFB200\nOFB208\nOFB216\nOFB224\nOFB232\nOFB24\nOFB240\nOFB248\nOFB256\nOFB32\nOFB40\nOFB48\nOFB56\nOFB64\n...[truncated 1515 chars]...\nADDING\nNOPADDING\nPKCS5\nPKCS5PADDING\nPKCS7\nPKCS7PADDING\nTBC\nTBCPADDING\nX9.23\nX9.23PADDING\nZEROBYTE\nZEROBYTEPADDING\n<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<\n>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>\n*** Padding/asymmetricBlock ***\n\nISO9796-1\nISO9796-1PADDING\nNOPADDING\nOAEP\nOAEPPADDING\nOAEPWITHSHA1ANDMGF1\nOAEPWITHSHA1ANDMGF1PADDING\nPKCS1\nPKCS1PADDING\n<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<\n>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>\n*** Padding/symmetricStream ***\n\nNOPADDING\n<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<\n" } ], "duration" : 0.27600002, "id" : None, "name" : "org.subshare.crypto.ShowSupportedAlgosForDocumentation", "stderr" : "", "stdout" : ">>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>\n*** BlockCipherMode ***\n\nCBC\nCBC-CTS\nCCM\nCFB\nCFB104\nCFB112\nCFB120\nCFB128\nCFB136\nCFB144\nCFB152\nCFB16\nCFB160\nCFB168\nCFB176\nCFB184\nCFB192\nCFB200\nCFB208\nCFB216\nCFB224\nCFB232\nCFB24\nCFB240\nCFB248\nCFB256\nCFB32\nCFB40\nCFB48\nCFB56\nCFB64\nCFB72\nCFB8\nCFB80\nCFB88\nCFB96\nCTS\nEAX\nECB\nGCM\nGOFB\nOFB\nOFB104\nOFB112\nOFB120\nOFB128\nOFB136\nOFB144\nOFB152\nOFB16\nOFB160\nOFB168\nOFB176\nOFB184\nOFB192\nOFB200\nOFB208\nOFB216\nOFB224\nOFB232\nOFB24\nOFB240\nOFB248\nOFB256\nOFB32\nOFB40\nOFB48\nOFB56\nOFB64\n...[truncated 1515 chars]...\nADDING\nNOPADDING\nPKCS5\nPKCS5PADDING\nPKCS7\nPKCS7PADDING\nTBC\nTBCPADDING\nX9.23\nX9.23PADDING\nZEROBYTE\nZEROBYTEPADDING\n<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<\n>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>\n*** Padding/asymmetricBlock ***\n\nISO9796-1\nISO9796-1PADDING\nNOPADDING\nOAEP\nOAEPPADDING\nOAEPWITHSHA1ANDMGF1\nOAEPWITHSHA1ANDMGF1PADDING\nPKCS1\nPKCS1PADDING\n<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<\n>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>\n*** Padding/symmetricStream ***\n\nNOPADDING\n<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<\n", "timestamp" : "2018-12-25T07:46:27" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.local.CryptreeImplGrantRevokeReadPermissionTest", "duration" : 82.274, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "grantAndRevokeReadPermission", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "08:47:40.120 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n08:47:40.353 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:47:42.802 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2fecfd57]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.local/build/repo/jq3g73y3-o9ynl-local'\n08:47:43.042 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1958 ms.\n08\n...[truncated 41186 chars]...\nNFO o.s.l.CryptreeImplGrantRevokeReadPermissionTest - Local sync...: 90.83%\n08:49:01.996 [Test worker] INFO o.s.l.CryptreeImplGrantRevokeReadPermissionTest - Local sync...: 96.55%\n08:49:02.168 [Test worker] INFO o.s.l.CryptreeImplGrantRevokeReadPermissionTest - Local sync...: 100.00%\n08:49:02.434 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2fecfd57]close: Deferring shut down of real LocalRepoManager 20000 ms.\n08:49:02.442 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" } ], "duration" : 82.274, "id" : None, "name" : "org.subshare.local.CryptreeImplGrantRevokeReadPermissionTest", "stderr" : "", "stdout" : "08:47:40.120 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n08:47:40.353 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:47:42.802 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2fecfd57]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.local/build/repo/jq3g73y3-o9ynl-local'\n08:47:43.042 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1958 ms.\n08\n...[truncated 41186 chars]...\nNFO o.s.l.CryptreeImplGrantRevokeReadPermissionTest - Local sync...: 90.83%\n08:49:01.996 [Test worker] INFO o.s.l.CryptreeImplGrantRevokeReadPermissionTest - Local sync...: 96.55%\n08:49:02.168 [Test worker] INFO o.s.l.CryptreeImplGrantRevokeReadPermissionTest - Local sync...: 100.00%\n08:49:02.434 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2fecfd57]close: Deferring shut down of real LocalRepoManager 20000 ms.\n08:49:02.442 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n", "timestamp" : "2018-12-25T07:47:40" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.local.CryptreeImplGrantRevokeWritePermissionTest", "duration" : 71.839, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "grantWritePermissionWithoutGrantPermission", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "08:47:41.014 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n08:47:41.214 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:47:43.320 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [274f72dc]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.local/build/repo/jq3g74dp-nient-local'\n08:47:43.472 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1528 ms.\n08\n...[truncated 205355 chars]...\nTest - Local sync...: 79.60%\n08:52:01.399 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 90.83%\n08:52:01.428 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 96.55%\n08:52:01.450 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 100.00%\n08:52:01.482 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5be8eb9c]close: Deferring shut down of real LocalRepoManager 20000 ms.\n08:52:01.484 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.local.CryptreeImplGrantRevokeWritePermissionTest", "duration" : 32.683, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "writeWithWritePermissionInParentParent", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "08:47:41.014 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n08:47:41.214 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:47:43.320 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [274f72dc]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.local/build/repo/jq3g74dp-nient-local'\n08:47:43.472 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1528 ms.\n08\n...[truncated 205355 chars]...\nTest - Local sync...: 79.60%\n08:52:01.399 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 90.83%\n08:52:01.428 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 96.55%\n08:52:01.450 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 100.00%\n08:52:01.482 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5be8eb9c]close: Deferring shut down of real LocalRepoManager 20000 ms.\n08:52:01.484 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.local.CryptreeImplGrantRevokeWritePermissionTest", "duration" : 32.503, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "writeWithWritePermissionInParent", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "08:47:41.014 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n08:47:41.214 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:47:43.320 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [274f72dc]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.local/build/repo/jq3g74dp-nient-local'\n08:47:43.472 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1528 ms.\n08\n...[truncated 205355 chars]...\nTest - Local sync...: 79.60%\n08:52:01.399 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 90.83%\n08:52:01.428 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 96.55%\n08:52:01.450 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 100.00%\n08:52:01.482 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5be8eb9c]close: Deferring shut down of real LocalRepoManager 20000 ms.\n08:52:01.484 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.local.CryptreeImplGrantRevokeWritePermissionTest", "duration" : 30.673, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "writeWithWritePermissionDirectDir", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "08:47:41.014 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n08:47:41.214 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:47:43.320 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [274f72dc]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.local/build/repo/jq3g74dp-nient-local'\n08:47:43.472 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1528 ms.\n08\n...[truncated 205355 chars]...\nTest - Local sync...: 79.60%\n08:52:01.399 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 90.83%\n08:52:01.428 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 96.55%\n08:52:01.450 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 100.00%\n08:52:01.482 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5be8eb9c]close: Deferring shut down of real LocalRepoManager 20000 ms.\n08:52:01.484 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.local.CryptreeImplGrantRevokeWritePermissionTest", "duration" : 30.533, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "writeWithoutWritePermission", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "08:47:41.014 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n08:47:41.214 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:47:43.320 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [274f72dc]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.local/build/repo/jq3g74dp-nient-local'\n08:47:43.472 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1528 ms.\n08\n...[truncated 205355 chars]...\nTest - Local sync...: 79.60%\n08:52:01.399 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 90.83%\n08:52:01.428 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 96.55%\n08:52:01.450 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 100.00%\n08:52:01.482 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5be8eb9c]close: Deferring shut down of real LocalRepoManager 20000 ms.\n08:52:01.484 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.local.CryptreeImplGrantRevokeWritePermissionTest", "duration" : 30.681, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "writeWithWritePermissionInParentParentGrantedIndirectly", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "08:47:41.014 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n08:47:41.214 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:47:43.320 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [274f72dc]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.local/build/repo/jq3g74dp-nient-local'\n08:47:43.472 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1528 ms.\n08\n...[truncated 205355 chars]...\nTest - Local sync...: 79.60%\n08:52:01.399 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 90.83%\n08:52:01.428 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 96.55%\n08:52:01.450 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 100.00%\n08:52:01.482 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5be8eb9c]close: Deferring shut down of real LocalRepoManager 20000 ms.\n08:52:01.484 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.local.CryptreeImplGrantRevokeWritePermissionTest", "duration" : 31.49, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "writeWithWritePermissionDirectFile", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "08:47:41.014 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n08:47:41.214 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:47:43.320 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [274f72dc]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.local/build/repo/jq3g74dp-nient-local'\n08:47:43.472 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1528 ms.\n08\n...[truncated 205355 chars]...\nTest - Local sync...: 79.60%\n08:52:01.399 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 90.83%\n08:52:01.428 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 96.55%\n08:52:01.450 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 100.00%\n08:52:01.482 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5be8eb9c]close: Deferring shut down of real LocalRepoManager 20000 ms.\n08:52:01.484 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" } ], "duration" : 260.402, "id" : None, "name" : "org.subshare.local.CryptreeImplGrantRevokeWritePermissionTest", "stderr" : "", "stdout" : "08:47:41.014 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n08:47:41.214 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:47:43.320 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [274f72dc]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.local/build/repo/jq3g74dp-nient-local'\n08:47:43.472 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1528 ms.\n08\n...[truncated 205355 chars]...\nTest - Local sync...: 79.60%\n08:52:01.399 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 90.83%\n08:52:01.428 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 96.55%\n08:52:01.450 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 100.00%\n08:52:01.482 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5be8eb9c]close: Deferring shut down of real LocalRepoManager 20000 ms.\n08:52:01.484 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n", "timestamp" : "2018-12-25T07:47:41" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.local.FilePaddingLengthRandomTest", "duration" : 15.421, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "testDistribution", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "08:47:41.959 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\nlengthCategory2HitCount: {_100K=300327, _1M=147399, _10M=47269, _100M=3053, _1G=1952, _10G=0}\nlengthCategory2HitPercentage: {_100K=601, _1M=295, _10M=95, _100M=6, _1G=4, _10G=0}\n27565\n" }, { "age" : 0, "className" : "org.subshare.local.FilePaddingLengthRandomTest", "duration" : 0.073, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "generateOneRandomLength", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "08:47:41.959 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\nlengthCategory2HitCount: {_100K=300327, _1M=147399, _10M=47269, _100M=3053, _1G=1952, _10G=0}\nlengthCategory2HitPercentage: {_100K=601, _1M=295, _10M=95, _100M=6, _1G=4, _10G=0}\n27565\n" } ], "duration" : 15.4939995, "id" : None, "name" : "org.subshare.local.FilePaddingLengthRandomTest", "stderr" : "", "stdout" : "08:47:41.959 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\nlengthCategory2HitCount: {_100K=300327, _1M=147399, _10M=47269, _100M=3053, _1G=1952, _10G=0}\nlengthCategory2HitPercentage: {_100K=601, _1M=295, _10M=95, _100M=6, _1G=4, _10G=0}\n27565\n", "timestamp" : "2018-12-25T07:47:37" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.local.persistence.CollisionTest", "duration" : 3.586, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "xorUids1", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "" }, { "age" : 0, "className" : "org.subshare.local.persistence.CollisionTest", "duration" : 0.007, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "xorUids2", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "" } ], "duration" : 3.593, "id" : None, "name" : "org.subshare.local.persistence.CollisionTest", "stderr" : "", "stdout" : "", "timestamp" : "2018-12-25T07:47:38" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.local.sign.SignableTest", "duration" : 3.667, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "signAndSerializeAndVerify", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "08:47:41.932 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n08:47:43.794 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load().\n08:47:43.826 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1174 ms.\n08:47:45.075 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg\n08:47:45.079 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg\n08\n...[truncated 905 chars]...\n o.s.c.p.PgpRegistry - clearCache: entered.\n08:47:51.513 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:47:51.591 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:47:51.635 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:47:51.764 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:47:51.800 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:47:51.886 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.local.sign.SignableTest", "duration" : 0.126, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "signAndModifyCryptoKeyIdAndVerify", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "08:47:41.932 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n08:47:43.794 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load().\n08:47:43.826 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1174 ms.\n08:47:45.075 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg\n08:47:45.079 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg\n08\n...[truncated 905 chars]...\n o.s.c.p.PgpRegistry - clearCache: entered.\n08:47:51.513 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:47:51.591 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:47:51.635 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:47:51.764 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:47:51.800 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:47:51.886 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.local.sign.SignableTest", "duration" : 0.118, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "signAndVerify", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "08:47:41.932 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n08:47:43.794 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load().\n08:47:43.826 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1174 ms.\n08:47:45.075 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg\n08:47:45.079 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg\n08\n...[truncated 905 chars]...\n o.s.c.p.PgpRegistry - clearCache: entered.\n08:47:51.513 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:47:51.591 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:47:51.635 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:47:51.764 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:47:51.800 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:47:51.886 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.local.sign.SignableTest", "duration" : 0.172, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "signAndModifySignatureCreatedAndVerify", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "08:47:41.932 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n08:47:43.794 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load().\n08:47:43.826 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1174 ms.\n08:47:45.075 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg\n08:47:45.079 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg\n08\n...[truncated 905 chars]...\n o.s.c.p.PgpRegistry - clearCache: entered.\n08:47:51.513 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:47:51.591 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:47:51.635 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:47:51.764 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:47:51.800 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:47:51.886 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.local.sign.SignableTest", "duration" : 0.12, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "signAndModifyCryptoRepoFileIdAndVerify", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "08:47:41.932 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n08:47:43.794 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load().\n08:47:43.826 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1174 ms.\n08:47:45.075 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg\n08:47:45.079 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg\n08\n...[truncated 905 chars]...\n o.s.c.p.PgpRegistry - clearCache: entered.\n08:47:51.513 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:47:51.591 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:47:51.635 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:47:51.764 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:47:51.800 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:47:51.886 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" } ], "duration" : 4.203, "id" : None, "name" : "org.subshare.local.sign.SignableTest", "stderr" : "", "stdout" : "08:47:41.932 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n08:47:43.794 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load().\n08:47:43.826 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1174 ms.\n08:47:45.075 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg\n08:47:45.079 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg\n08\n...[truncated 905 chars]...\n o.s.c.p.PgpRegistry - clearCache: entered.\n08:47:51.513 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:47:51.591 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:47:51.635 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:47:51.764 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:47:51.800 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:47:51.886 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n", "timestamp" : "2018-12-25T07:47:47" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.local.sign.SignerVerifierStreamTest", "duration" : 25.109, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "signRsaWithSha1", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "08:47:40.977 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n08:47:42.440 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load().\n08:47:42.520 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1480 ms.\n08:47:44.018 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg\n08:47:44.020 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg\n08\n...[truncated 5059 chars]...\nall run #93\nsignAndVerifyRandomManySmall run #94\nsignAndVerifyRandomManySmall run #95\nsignAndVerifyRandomManySmall run #96\nsignAndVerifyRandomManySmall run #97\nsignAndVerifyRandomManySmall run #98\nsignAndVerifyRandomManySmall run #99\nsignAndVerifyRandomManySmall run #100\n08:48:53.064 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:48:53.094 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:49:04.639 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.local.sign.SignerVerifierStreamTest", "duration" : 0.119, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "signAndVerifySimpleBlockRead", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "08:47:40.977 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n08:47:42.440 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load().\n08:47:42.520 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1480 ms.\n08:47:44.018 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg\n08:47:44.020 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg\n08\n...[truncated 5059 chars]...\nall run #93\nsignAndVerifyRandomManySmall run #94\nsignAndVerifyRandomManySmall run #95\nsignAndVerifyRandomManySmall run #96\nsignAndVerifyRandomManySmall run #97\nsignAndVerifyRandomManySmall run #98\nsignAndVerifyRandomManySmall run #99\nsignAndVerifyRandomManySmall run #100\n08:48:53.064 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:48:53.094 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:49:04.639 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.local.sign.SignerVerifierStreamTest", "duration" : 22.964, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "sha1Digest", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "08:47:40.977 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n08:47:42.440 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load().\n08:47:42.520 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1480 ms.\n08:47:44.018 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg\n08:47:44.020 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg\n08\n...[truncated 5059 chars]...\nall run #93\nsignAndVerifyRandomManySmall run #94\nsignAndVerifyRandomManySmall run #95\nsignAndVerifyRandomManySmall run #96\nsignAndVerifyRandomManySmall run #97\nsignAndVerifyRandomManySmall run #98\nsignAndVerifyRandomManySmall run #99\nsignAndVerifyRandomManySmall run #100\n08:48:53.064 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:48:53.094 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:49:04.639 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.local.sign.SignerVerifierStreamTest", "duration" : 3.217, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "signAndVerifyRandomBroken", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "08:47:40.977 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n08:47:42.440 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load().\n08:47:42.520 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1480 ms.\n08:47:44.018 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg\n08:47:44.020 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg\n08\n...[truncated 5059 chars]...\nall run #93\nsignAndVerifyRandomManySmall run #94\nsignAndVerifyRandomManySmall run #95\nsignAndVerifyRandomManySmall run #96\nsignAndVerifyRandomManySmall run #97\nsignAndVerifyRandomManySmall run #98\nsignAndVerifyRandomManySmall run #99\nsignAndVerifyRandomManySmall run #100\n08:48:53.064 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:48:53.094 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:49:04.639 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.local.sign.SignerVerifierStreamTest", "duration" : 16.585, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "signAndVerifyRandomManySmall", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "08:47:40.977 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n08:47:42.440 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load().\n08:47:42.520 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1480 ms.\n08:47:44.018 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg\n08:47:44.020 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg\n08\n...[truncated 5059 chars]...\nall run #93\nsignAndVerifyRandomManySmall run #94\nsignAndVerifyRandomManySmall run #95\nsignAndVerifyRandomManySmall run #96\nsignAndVerifyRandomManySmall run #97\nsignAndVerifyRandomManySmall run #98\nsignAndVerifyRandomManySmall run #99\nsignAndVerifyRandomManySmall run #100\n08:48:53.064 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:48:53.094 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:49:04.639 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.local.sign.SignerVerifierStreamTest", "duration" : 11.573, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "signAndVerifyRandom", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "08:47:40.977 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n08:47:42.440 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load().\n08:47:42.520 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1480 ms.\n08:47:44.018 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg\n08:47:44.020 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg\n08\n...[truncated 5059 chars]...\nall run #93\nsignAndVerifyRandomManySmall run #94\nsignAndVerifyRandomManySmall run #95\nsignAndVerifyRandomManySmall run #96\nsignAndVerifyRandomManySmall run #97\nsignAndVerifyRandomManySmall run #98\nsignAndVerifyRandomManySmall run #99\nsignAndVerifyRandomManySmall run #100\n08:48:53.064 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:48:53.094 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:49:04.639 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" } ], "duration" : 79.567, "id" : None, "name" : "org.subshare.local.sign.SignerVerifierStreamTest", "stderr" : "", "stdout" : "08:47:40.977 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n08:47:42.440 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load().\n08:47:42.520 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1480 ms.\n08:47:44.018 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg\n08:47:44.020 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg\n08\n...[truncated 5059 chars]...\nall run #93\nsignAndVerifyRandomManySmall run #94\nsignAndVerifyRandomManySmall run #95\nsignAndVerifyRandomManySmall run #96\nsignAndVerifyRandomManySmall run #97\nsignAndVerifyRandomManySmall run #98\nsignAndVerifyRandomManySmall run #99\nsignAndVerifyRandomManySmall run #100\n08:48:53.064 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:48:53.094 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:49:04.639 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n", "timestamp" : "2018-12-25T07:47:45" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.rest.client.transport.CryptreeRepoTransportTest", "duration" : 35.107, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "encryptAndSignAndVerifyAndDecrypt", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "08:52:08.022 [Test worker] INFO c.c.cloudstore.core.oio.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n08:52:08.842 [Test worker] DEBUG o.s.c.pgp.gnupg.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load().\n08:52:08.863 [Test worker] DEBUG c.c.c.core.config.ConfigImpl - getPropertyAsNonEmptyTrimmedString: System property with key='subshare.gnupg.dir' is not set (config is queried next).\n08:52:08.865 [Test worker] DEBUG c.c.c.core.config.ConfigImpl - read: Reading propertie\n...[truncated 44522 chars]...\ny='subshare.signerTransformation' is not set (config is queried next).\n08:52:42.514 [Test worker] DEBUG c.c.c.core.config.ConfigImpl - getPropertyAsNonEmptyTrimmedString: System property with key='subshare.symmetricCipherTransformation' is not set (config is queried next).\n\n08:52:42.687 [Test worker] DEBUG o.s.r.c.t.CryptreeRestRepoTransportImpl - close: There is no localRepoManager.\n08:52:42.687 [Test worker] DEBUG o.s.r.c.t.CryptreeRestRepoTransportImpl - close: There is no restRepoTransport.\n" } ], "duration" : 35.107, "id" : None, "name" : "org.subshare.rest.client.transport.CryptreeRepoTransportTest", "stderr" : "", "stdout" : "08:52:08.022 [Test worker] INFO c.c.cloudstore.core.oio.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n08:52:08.842 [Test worker] DEBUG o.s.c.pgp.gnupg.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load().\n08:52:08.863 [Test worker] DEBUG c.c.c.core.config.ConfigImpl - getPropertyAsNonEmptyTrimmedString: System property with key='subshare.gnupg.dir' is not set (config is queried next).\n08:52:08.865 [Test worker] DEBUG c.c.c.core.config.ConfigImpl - read: Reading propertie\n...[truncated 44522 chars]...\ny='subshare.signerTransformation' is not set (config is queried next).\n08:52:42.514 [Test worker] DEBUG c.c.c.core.config.ConfigImpl - getPropertyAsNonEmptyTrimmedString: System property with key='subshare.symmetricCipherTransformation' is not set (config is queried next).\n\n08:52:42.687 [Test worker] DEBUG o.s.r.c.t.CryptreeRestRepoTransportImpl - close: There is no localRepoManager.\n08:52:42.687 [Test worker] DEBUG o.s.r.c.t.CryptreeRestRepoTransportImpl - close: There is no restRepoTransport.\n", "timestamp" : "2018-12-25T07:52:07" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.BackupRestoreRepoToRepoSyncIT", "duration" : 283.496, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "backupRestoreClientRepo", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "09:18:04.062 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n09:18:04.868 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5fc81efc]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3ha5z5-83lzy-local-src'\n09:18:04.872 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5fc81efc]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3ha5z5-83lzy-local-src' locke\n...[truncated 336650 chars]...\naction.localRevision=154 remoteFromLocalRevision=144\n09:22:46.824 [qtp1012151284-4058] INFO c.c.c.l.LocalRepoManagerImpl - [64b437df]close: Deferring shut down of real LocalRepoManager 10000 ms.\n09:22:46.828 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00%\n09:22:46.828 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [78ad6da5]close: Deferring shut down of real LocalRepoManager 10000 ms.\n09:22:47.556 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 70, "className" : "org.subshare.test.BackupRestoreRepoToRepoSyncIT", "duration" : 0.0, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 291, "name" : "backupRestoreServerRepo", "skipped" : True, "skippedMessage" : None, "status" : "SKIPPED", "stderr" : "", "stdout" : "09:18:04.062 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n09:18:04.868 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5fc81efc]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3ha5z5-83lzy-local-src'\n09:18:04.872 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5fc81efc]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3ha5z5-83lzy-local-src' locke\n...[truncated 336650 chars]...\naction.localRevision=154 remoteFromLocalRevision=144\n09:22:46.824 [qtp1012151284-4058] INFO c.c.c.l.LocalRepoManagerImpl - [64b437df]close: Deferring shut down of real LocalRepoManager 10000 ms.\n09:22:46.828 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00%\n09:22:46.828 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [78ad6da5]close: Deferring shut down of real LocalRepoManager 10000 ms.\n09:22:47.556 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" } ], "duration" : 283.496, "id" : None, "name" : "org.subshare.test.BackupRestoreRepoToRepoSyncIT", "stderr" : "", "stdout" : "09:18:04.062 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n09:18:04.868 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5fc81efc]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3ha5z5-83lzy-local-src'\n09:18:04.872 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5fc81efc]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3ha5z5-83lzy-local-src' locke\n...[truncated 336650 chars]...\naction.localRevision=154 remoteFromLocalRevision=144\n09:22:46.824 [qtp1012151284-4058] INFO c.c.c.l.LocalRepoManagerImpl - [64b437df]close: Deferring shut down of real LocalRepoManager 10000 ms.\n09:22:46.828 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00%\n09:22:46.828 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [78ad6da5]close: Deferring shut down of real LocalRepoManager 10000 ms.\n09:22:47.556 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n", "timestamp" : "2018-12-25T08:18:04" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.BrokenSignatureIT", "duration" : 199.674, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "uploadBrokenSignature", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "Dec 25, 2018 8:53:12 AM org.glassfish.jersey.server.ApplicationHandler initialize\nINFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00...\nDec 25, 2018 8:53:16 AM org.glassfish.jersey.server.ApplicationHandler initialize\nINFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00...\n", "stdout" : "08:52:58.048 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n08:53:01.664 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/37tnTTLY7vBtv2rXaQHRKQ/.subshare/ssl.server/keystore' does not exist!\n08:53:01.682 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil\n...[truncated 453725 chars]...\nncurrent.ExecutorPolicy$CatchAndRecordFailures.onExecute(ExecutorPolicy.java:54) [gradle-base-services-3.1.jar:3.1]\n\tat org.gradle.internal.concurrent.StoppableExecutorImpl$1.run(StoppableExecutorImpl.java:40) [gradle-base-services-3.1.jar:3.1]\n\tat java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [na:1.8.0_191]\n\tat java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [na:1.8.0_191]\n\tat java.lang.Thread.run(Thread.java:748) [na:1.8.0_191]\n" }, { "age" : 0, "className" : "org.subshare.test.BrokenSignatureIT", "duration" : 144.013, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "downloadBrokenSignature", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "Dec 25, 2018 8:53:12 AM org.glassfish.jersey.server.ApplicationHandler initialize\nINFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00...\nDec 25, 2018 8:53:16 AM org.glassfish.jersey.server.ApplicationHandler initialize\nINFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00...\n", "stdout" : "08:52:58.048 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n08:53:01.664 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/37tnTTLY7vBtv2rXaQHRKQ/.subshare/ssl.server/keystore' does not exist!\n08:53:01.682 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil\n...[truncated 453725 chars]...\nncurrent.ExecutorPolicy$CatchAndRecordFailures.onExecute(ExecutorPolicy.java:54) [gradle-base-services-3.1.jar:3.1]\n\tat org.gradle.internal.concurrent.StoppableExecutorImpl$1.run(StoppableExecutorImpl.java:40) [gradle-base-services-3.1.jar:3.1]\n\tat java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [na:1.8.0_191]\n\tat java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [na:1.8.0_191]\n\tat java.lang.Thread.run(Thread.java:748) [na:1.8.0_191]\n" } ], "duration" : 343.687, "id" : None, "name" : "org.subshare.test.BrokenSignatureIT", "stderr" : "Dec 25, 2018 8:53:12 AM org.glassfish.jersey.server.ApplicationHandler initialize\nINFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00...\nDec 25, 2018 8:53:16 AM org.glassfish.jersey.server.ApplicationHandler initialize\nINFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00...\n", "stdout" : "08:52:58.048 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n08:53:01.664 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/37tnTTLY7vBtv2rXaQHRKQ/.subshare/ssl.server/keystore' does not exist!\n08:53:01.682 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil\n...[truncated 453725 chars]...\nncurrent.ExecutorPolicy$CatchAndRecordFailures.onExecute(ExecutorPolicy.java:54) [gradle-base-services-3.1.jar:3.1]\n\tat org.gradle.internal.concurrent.StoppableExecutorImpl$1.run(StoppableExecutorImpl.java:40) [gradle-base-services-3.1.jar:3.1]\n\tat java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [na:1.8.0_191]\n\tat java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [na:1.8.0_191]\n\tat java.lang.Thread.run(Thread.java:748) [na:1.8.0_191]\n", "timestamp" : "2018-12-25T07:53:19" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.CollisionOnClientRepoToRepoSyncIT", "duration" : 236.086, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "newFileVsNewFileCollisionOnClient", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "09:15:56.704 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n09:15:58.013 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2c26567]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3h7g38-szd6u-local-src'\n09:15:58.018 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2c26567]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3h7g38-szd6u-local-src' locked \n...[truncated 1872543 chars]...\nons: query.execute(...) took 4 ms.\n09:31:55.698 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: Loading result-set with 1 elements took 5 ms.\n09:31:55.699 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [41a59306]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:31:55.700 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4d1b3cf2]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:31:56.055 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.test.CollisionOnClientRepoToRepoSyncIT", "duration" : 184.529, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "newDirectoryVsNewDirectoryCollisionOnClient", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "09:15:56.704 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n09:15:58.013 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2c26567]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3h7g38-szd6u-local-src'\n09:15:58.018 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2c26567]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3h7g38-szd6u-local-src' locked \n...[truncated 1872543 chars]...\nons: query.execute(...) took 4 ms.\n09:31:55.698 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: Loading result-set with 1 elements took 5 ms.\n09:31:55.699 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [41a59306]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:31:55.700 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4d1b3cf2]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:31:56.055 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.test.CollisionOnClientRepoToRepoSyncIT", "duration" : 186.463, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "modifiedFileVsDeletedFileCollisionOnClient", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "09:15:56.704 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n09:15:58.013 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2c26567]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3h7g38-szd6u-local-src'\n09:15:58.018 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2c26567]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3h7g38-szd6u-local-src' locked \n...[truncated 1872543 chars]...\nons: query.execute(...) took 4 ms.\n09:31:55.698 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: Loading result-set with 1 elements took 5 ms.\n09:31:55.699 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [41a59306]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:31:55.700 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4d1b3cf2]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:31:56.055 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.test.CollisionOnClientRepoToRepoSyncIT", "duration" : 142.653, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "modifiedFileVsModifiedFileCollisionOnClient", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "09:15:56.704 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n09:15:58.013 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2c26567]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3h7g38-szd6u-local-src'\n09:15:58.018 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2c26567]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3h7g38-szd6u-local-src' locked \n...[truncated 1872543 chars]...\nons: query.execute(...) took 4 ms.\n09:31:55.698 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: Loading result-set with 1 elements took 5 ms.\n09:31:55.699 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [41a59306]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:31:55.700 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4d1b3cf2]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:31:56.055 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.test.CollisionOnClientRepoToRepoSyncIT", "duration" : 111.529, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "deletedFileVsModifiedFileCollisionOnClient", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "09:15:56.704 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n09:15:58.013 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2c26567]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3h7g38-szd6u-local-src'\n09:15:58.018 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2c26567]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3h7g38-szd6u-local-src' locked \n...[truncated 1872543 chars]...\nons: query.execute(...) took 4 ms.\n09:31:55.698 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: Loading result-set with 1 elements took 5 ms.\n09:31:55.699 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [41a59306]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:31:55.700 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4d1b3cf2]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:31:56.055 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.test.CollisionOnClientRepoToRepoSyncIT", "duration" : 98.074, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "newFileVsNewDirectoryCollisionOnClient", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "09:15:56.704 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n09:15:58.013 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2c26567]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3h7g38-szd6u-local-src'\n09:15:58.018 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2c26567]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3h7g38-szd6u-local-src' locked \n...[truncated 1872543 chars]...\nons: query.execute(...) took 4 ms.\n09:31:55.698 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: Loading result-set with 1 elements took 5 ms.\n09:31:55.699 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [41a59306]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:31:55.700 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4d1b3cf2]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:31:56.055 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" } ], "duration" : 959.334, "id" : None, "name" : "org.subshare.test.CollisionOnClientRepoToRepoSyncIT", "stderr" : "", "stdout" : "09:15:56.704 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n09:15:58.013 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2c26567]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3h7g38-szd6u-local-src'\n09:15:58.018 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2c26567]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3h7g38-szd6u-local-src' locked \n...[truncated 1872543 chars]...\nons: query.execute(...) took 4 ms.\n09:31:55.698 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: Loading result-set with 1 elements took 5 ms.\n09:31:55.699 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [41a59306]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:31:55.700 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4d1b3cf2]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:31:56.055 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n", "timestamp" : "2018-12-25T08:15:56" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.CollisionOnServerRepoToRepoSyncIT", "duration" : 339.897, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "newFileVsNewFileUploadedCollisionOnServer", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "Dec 25, 2018 8:53:17 AM org.glassfish.jersey.server.ApplicationHandler initialize\nINFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00...\nDec 25, 2018 8:53:21 AM org.glassfish.jersey.server.ApplicationHandler initialize\nINFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00...\n", "stdout" : "08:52:58.203 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n08:53:01.845 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/uoEAxXSetSzw3WUyaeIF1Q/.subshare/ssl.server/keystore' does not exist!\n08:53:01.854 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil\n...[truncated 910526 chars]...\nons: query.execute(...) took 6 ms.\n09:09:26.362 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: Loading result-set with 2 elements took 7 ms.\n09:09:26.365 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [496c511e]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:09:26.377 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [23085548]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:09:26.814 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.test.CollisionOnServerRepoToRepoSyncIT", "duration" : 621.725, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "newFileVsNewFileUploadingCollisionOnServer", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "Dec 25, 2018 8:53:17 AM org.glassfish.jersey.server.ApplicationHandler initialize\nINFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00...\nDec 25, 2018 8:53:21 AM org.glassfish.jersey.server.ApplicationHandler initialize\nINFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00...\n", "stdout" : "08:52:58.203 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n08:53:01.845 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/uoEAxXSetSzw3WUyaeIF1Q/.subshare/ssl.server/keystore' does not exist!\n08:53:01.854 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil\n...[truncated 910526 chars]...\nons: query.execute(...) took 6 ms.\n09:09:26.362 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: Loading result-set with 2 elements took 7 ms.\n09:09:26.365 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [496c511e]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:09:26.377 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [23085548]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:09:26.814 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" } ], "duration" : 961.62195, "id" : None, "name" : "org.subshare.test.CollisionOnServerRepoToRepoSyncIT", "stderr" : "Dec 25, 2018 8:53:17 AM org.glassfish.jersey.server.ApplicationHandler initialize\nINFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00...\nDec 25, 2018 8:53:21 AM org.glassfish.jersey.server.ApplicationHandler initialize\nINFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00...\n", "stdout" : "08:52:58.203 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n08:53:01.845 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/uoEAxXSetSzw3WUyaeIF1Q/.subshare/ssl.server/keystore' does not exist!\n08:53:01.854 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil\n...[truncated 910526 chars]...\nons: query.execute(...) took 6 ms.\n09:09:26.362 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: Loading result-set with 2 elements took 7 ms.\n09:09:26.365 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [496c511e]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:09:26.377 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [23085548]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:09:26.814 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n", "timestamp" : "2018-12-25T07:53:25" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.IgnoreRuleRepoToRepoSyncIT", "duration" : 317.687, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "ignoreRulesAddedAfterFilesSynced", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "Dec 25, 2018 8:53:12 AM org.glassfish.jersey.server.ApplicationHandler initialize\nINFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00...\nDec 25, 2018 8:53:17 AM org.glassfish.jersey.server.ApplicationHandler initialize\nINFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00...\n", "stdout" : "08:52:58.135 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n08:53:02.303 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/ULo3FC2Wq8KQnBJy378pgw/.subshare/ssl.server/keystore' does not exist!\n08:53:02.318 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil\n...[truncated 952967 chars]...\nose: Deferring shut down of real LocalRepoManager 20000 ms.\n09:06:40.299 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00%\n09:06:40.300 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [1ede7c47]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:06:40.301 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [32ceb64e]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:06:40.721 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.test.IgnoreRuleRepoToRepoSyncIT", "duration" : 285.926, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "ignoreRulesBecomeDisabled", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "Dec 25, 2018 8:53:12 AM org.glassfish.jersey.server.ApplicationHandler initialize\nINFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00...\nDec 25, 2018 8:53:17 AM org.glassfish.jersey.server.ApplicationHandler initialize\nINFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00...\n", "stdout" : "08:52:58.135 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n08:53:02.303 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/ULo3FC2Wq8KQnBJy378pgw/.subshare/ssl.server/keystore' does not exist!\n08:53:02.318 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil\n...[truncated 952967 chars]...\nose: Deferring shut down of real LocalRepoManager 20000 ms.\n09:06:40.299 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00%\n09:06:40.300 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [1ede7c47]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:06:40.301 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [32ceb64e]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:06:40.721 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.test.IgnoreRuleRepoToRepoSyncIT", "duration" : 196.506, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "ignoreRulesExistBeforeAffectedFiles", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "Dec 25, 2018 8:53:12 AM org.glassfish.jersey.server.ApplicationHandler initialize\nINFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00...\nDec 25, 2018 8:53:17 AM org.glassfish.jersey.server.ApplicationHandler initialize\nINFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00...\n", "stdout" : "08:52:58.135 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n08:53:02.303 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/ULo3FC2Wq8KQnBJy378pgw/.subshare/ssl.server/keystore' does not exist!\n08:53:02.318 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil\n...[truncated 952967 chars]...\nose: Deferring shut down of real LocalRepoManager 20000 ms.\n09:06:40.299 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00%\n09:06:40.300 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [1ede7c47]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:06:40.301 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [32ceb64e]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:06:40.721 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" } ], "duration" : 800.119, "id" : None, "name" : "org.subshare.test.IgnoreRuleRepoToRepoSyncIT", "stderr" : "Dec 25, 2018 8:53:12 AM org.glassfish.jersey.server.ApplicationHandler initialize\nINFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00...\nDec 25, 2018 8:53:17 AM org.glassfish.jersey.server.ApplicationHandler initialize\nINFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00...\n", "stdout" : "08:52:58.135 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n08:53:02.303 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/ULo3FC2Wq8KQnBJy378pgw/.subshare/ssl.server/keystore' does not exist!\n08:53:02.318 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil\n...[truncated 952967 chars]...\nose: Deferring shut down of real LocalRepoManager 20000 ms.\n09:06:40.299 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00%\n09:06:40.300 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [1ede7c47]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:06:40.301 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [32ceb64e]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:06:40.721 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n", "timestamp" : "2018-12-25T07:53:20" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.InterruptedRepoToRepoSyncIT", "duration" : 201.404, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "interruptSyncDownAndResume", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "09:09:27.853 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n09:09:28.834 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [23d57684]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3gz3sw-ppiw0-local-src'\n09:09:28.839 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [23d57684]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3gz3sw-ppiw0-local-src' locke\n...[truncated 435279 chars]...\nose: Deferring shut down of real LocalRepoManager 20000 ms.\n09:15:55.366 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00%\n09:15:55.459 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [39c85d2f]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:15:55.472 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [69e73bab]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:15:56.045 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.test.InterruptedRepoToRepoSyncIT", "duration" : 186.799, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "interruptSyncUpAndResume", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "09:09:27.853 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n09:09:28.834 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [23d57684]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3gz3sw-ppiw0-local-src'\n09:09:28.839 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [23d57684]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3gz3sw-ppiw0-local-src' locke\n...[truncated 435279 chars]...\nose: Deferring shut down of real LocalRepoManager 20000 ms.\n09:15:55.366 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00%\n09:15:55.459 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [39c85d2f]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:15:55.472 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [69e73bab]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:15:56.045 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" } ], "duration" : 388.203, "id" : None, "name" : "org.subshare.test.InterruptedRepoToRepoSyncIT", "stderr" : "", "stdout" : "09:09:27.853 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n09:09:28.834 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [23d57684]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3gz3sw-ppiw0-local-src'\n09:09:28.839 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [23d57684]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3gz3sw-ppiw0-local-src' locke\n...[truncated 435279 chars]...\nose: Deferring shut down of real LocalRepoManager 20000 ms.\n09:15:55.366 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00%\n09:15:55.459 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [39c85d2f]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:15:55.472 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [69e73bab]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:15:56.045 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n", "timestamp" : "2018-12-25T08:09:27" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.InviteUserAndSyncIT", "duration" : 189.28, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "inviteUserAndSync_singleReadPermissionOnSubdir", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "09:17:10.058 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>>>>>>>>>>>>> ***\n09:17:10.061 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>> before >>> ***\n09:17:10.066 [Timer-4] WARN c.c.c.r.c.CloudStoreRestClient - execute: invocation failed (will retry): javax.ws.rs.ProcessingException: java.net.UnknownHostException: server3.oink.org\njavax.ws.rs.ProcessingException: java.net.UnknownHostException: server3.oink.org\n\tat org.glassfish.jersey.client.HttpUrlConnector.apply(HttpUr\n...[truncated 1381539 chars]...\n<<< inviteUserAndSync_singleReadPermissionOnRoot <<< ***\n09:26:27.409 [Test worker] INFO o.s.t.InviteUserAndSyncIT - *** <<<<<<<<<<<<<<<<<<<<<<<<< ***\n09:26:27.412 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [685c1fdf]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:26:27.413 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [12cba146]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:26:27.795 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.test.InviteUserAndSyncIT", "duration" : 196.292, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "inviteUserAndSync_singleWritePermissionOnRoot", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "09:17:10.058 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>>>>>>>>>>>>> ***\n09:17:10.061 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>> before >>> ***\n09:17:10.066 [Timer-4] WARN c.c.c.r.c.CloudStoreRestClient - execute: invocation failed (will retry): javax.ws.rs.ProcessingException: java.net.UnknownHostException: server3.oink.org\njavax.ws.rs.ProcessingException: java.net.UnknownHostException: server3.oink.org\n\tat org.glassfish.jersey.client.HttpUrlConnector.apply(HttpUr\n...[truncated 1381539 chars]...\n<<< inviteUserAndSync_singleReadPermissionOnRoot <<< ***\n09:26:27.409 [Test worker] INFO o.s.t.InviteUserAndSyncIT - *** <<<<<<<<<<<<<<<<<<<<<<<<< ***\n09:26:27.412 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [685c1fdf]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:26:27.413 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [12cba146]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:26:27.795 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.test.InviteUserAndSyncIT", "duration" : 172.157, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "inviteUserAndSync_singleReadPermissionOnRoot", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "09:17:10.058 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>>>>>>>>>>>>> ***\n09:17:10.061 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>> before >>> ***\n09:17:10.066 [Timer-4] WARN c.c.c.r.c.CloudStoreRestClient - execute: invocation failed (will retry): javax.ws.rs.ProcessingException: java.net.UnknownHostException: server3.oink.org\njavax.ws.rs.ProcessingException: java.net.UnknownHostException: server3.oink.org\n\tat org.glassfish.jersey.client.HttpUrlConnector.apply(HttpUr\n...[truncated 1381539 chars]...\n<<< inviteUserAndSync_singleReadPermissionOnRoot <<< ***\n09:26:27.409 [Test worker] INFO o.s.t.InviteUserAndSyncIT - *** <<<<<<<<<<<<<<<<<<<<<<<<< ***\n09:26:27.412 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [685c1fdf]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:26:27.413 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [12cba146]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:26:27.795 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" } ], "duration" : 557.729, "id" : None, "name" : "org.subshare.test.InviteUserAndSyncIT", "stderr" : "", "stdout" : "09:17:10.058 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>>>>>>>>>>>>> ***\n09:17:10.061 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>> before >>> ***\n09:17:10.066 [Timer-4] WARN c.c.c.r.c.CloudStoreRestClient - execute: invocation failed (will retry): javax.ws.rs.ProcessingException: java.net.UnknownHostException: server3.oink.org\njavax.ws.rs.ProcessingException: java.net.UnknownHostException: server3.oink.org\n\tat org.glassfish.jersey.client.HttpUrlConnector.apply(HttpUr\n...[truncated 1381539 chars]...\n<<< inviteUserAndSync_singleReadPermissionOnRoot <<< ***\n09:26:27.409 [Test worker] INFO o.s.t.InviteUserAndSyncIT - *** <<<<<<<<<<<<<<<<<<<<<<<<< ***\n09:26:27.412 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [685c1fdf]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:26:27.413 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [12cba146]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:26:27.795 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n", "timestamp" : "2018-12-25T08:17:10" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.InviteUserWithNormalAndMetaOnlyRepoIT", "duration" : 347.345, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "inviteUserAndSync_withMetaOnly_singleWritePermissionOnRoot", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "09:03:46.674 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>>>>>>>>>>>>> ***\n09:03:46.675 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>> before >>> ***\n09:03:47.016 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n09:03:47.025 [Test worker] INFO o.s.t.PgpTestUtil - setupPgp: ownerName=marco\n09:03:47.025 [Test worker] INFO o.s.t.PgpTestUtil - copyResource: sourceResName='gpg/marco/pubring.gpg' destinationFile='/home/tomcat/.jenkins/workspace/org.subshare/org.\n...[truncated 434465 chars]...\n<<<<<<<<<<< ***\n09:09:32.615 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2fb317f]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:09:32.616 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2288969a]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:09:33.039 [closeDeferredTimer-7a96a439-2] INFO c.c.c.l.LocalRepoManagerImpl - [7a96a439]_close: Shutting down real LocalRepoManager.\n09:09:34.013 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" } ], "duration" : 347.345, "id" : None, "name" : "org.subshare.test.InviteUserWithNormalAndMetaOnlyRepoIT", "stderr" : "", "stdout" : "09:03:46.674 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>>>>>>>>>>>>> ***\n09:03:46.675 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>> before >>> ***\n09:03:47.016 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n09:03:47.025 [Test worker] INFO o.s.t.PgpTestUtil - setupPgp: ownerName=marco\n09:03:47.025 [Test worker] INFO o.s.t.PgpTestUtil - copyResource: sourceResName='gpg/marco/pubring.gpg' destinationFile='/home/tomcat/.jenkins/workspace/org.subshare/org.\n...[truncated 434465 chars]...\n<<<<<<<<<<< ***\n09:09:32.615 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2fb317f]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:09:32.616 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2288969a]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:09:33.039 [closeDeferredTimer-7a96a439-2] INFO c.c.c.l.LocalRepoManagerImpl - [7a96a439]_close: Shutting down real LocalRepoManager.\n09:09:34.013 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n", "timestamp" : "2018-12-25T08:03:46" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.Issue4IT", "duration" : 132.419, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "issue_4_syncFileDeletedAfterLocalSync", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "08:59:03.644 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:59:04.571 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [1c96350a]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3glq47-awhv1-local-src'\n08:59:04.576 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [1c96350a]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3glq47-awhv1-local-src' locke\n...[truncated 150560 chars]...\nansaction.localRevision=94 remoteFromLocalRevision=147\n09:01:15.735 [qtp1052339566-885] INFO c.c.c.l.LocalRepoManagerImpl - [c827e27]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:01:15.738 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00%\n09:01:15.738 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [1c96350a]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:01:16.057 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" } ], "duration" : 132.419, "id" : None, "name" : "org.subshare.test.Issue4IT", "stderr" : "", "stdout" : "08:59:03.644 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n08:59:04.571 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [1c96350a]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3glq47-awhv1-local-src'\n08:59:04.576 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [1c96350a]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3glq47-awhv1-local-src' locke\n...[truncated 150560 chars]...\nansaction.localRevision=94 remoteFromLocalRevision=147\n09:01:15.735 [qtp1052339566-885] INFO c.c.c.l.LocalRepoManagerImpl - [c827e27]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:01:15.738 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00%\n09:01:15.738 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [1c96350a]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:01:16.057 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n", "timestamp" : "2018-12-25T07:59:03" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.Issue5IT", "duration" : 430.642, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "issue_5_inviteMultipleFriends", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "Dec 25, 2018 8:53:15 AM org.glassfish.jersey.server.ApplicationHandler initialize\nINFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00...\nDec 25, 2018 8:53:19 AM org.glassfish.jersey.server.ApplicationHandler initialize\nINFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00...\n", "stdout" : "08:52:57.987 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n08:53:01.774 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/SSoQAlM_44e8DtPCzAoLHw/.subshare/ssl.server/keystore' does not exist!\n08:53:01.790 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil\n...[truncated 515289 chars]...\ning...: 100.00%\n09:00:33.311 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [7abaf81d]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:00:33.311 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [15ad2ba4]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:00:33.312 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [52108c60]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:00:33.664 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" } ], "duration" : 430.642, "id" : None, "name" : "org.subshare.test.Issue5IT", "stderr" : "Dec 25, 2018 8:53:15 AM org.glassfish.jersey.server.ApplicationHandler initialize\nINFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00...\nDec 25, 2018 8:53:19 AM org.glassfish.jersey.server.ApplicationHandler initialize\nINFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00...\n", "stdout" : "08:52:57.987 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n08:53:01.774 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/SSoQAlM_44e8DtPCzAoLHw/.subshare/ssl.server/keystore' does not exist!\n08:53:01.790 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil\n...[truncated 515289 chars]...\ning...: 100.00%\n09:00:33.311 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [7abaf81d]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:00:33.311 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [15ad2ba4]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:00:33.312 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [52108c60]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:00:33.664 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n", "timestamp" : "2018-12-25T07:53:23" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.Issue8IT", "duration" : 599.827, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "issue_8_threesomeWithFreshmen", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "\n09:06:46.675 [Test worker] INFO o.s.t.AbstractMultiUserIT - \n09:06:46.680 [Test worker] INFO o.s.t.AbstractMultiUserIT - ********************************************************************\n09:06:46.681 [Test worker] INFO o.s.t.AbstractMultiUserIT - *** marco ***\n09:06:46.688 [Test worker] INFO o.s.t.PgpTestUtil - setupPgp: ownerName=marco\n09:06:46.689 [Test worker] INFO o.s.t.AbstractMultiUserIT - MockUp.getInstance: testUser=marco\n09:06:46.690 [Test worker] INFO o.s.t.PgpTestU\n...[truncated 1212811 chars]...\nnager 20000 ms.\n09:16:38.174 [Test worker] INFO o.s.t.AbstractMultiUserIT - MockUp.getInstance: testUser=xenia\n09:16:38.175 [Test worker] INFO o.s.t.AbstractMultiUserIT - MockUp.getInstance: testUser=xenia\n09:16:38.208 [Test worker] INFO o.s.t.AbstractMultiUserIT - MockUp.getInstance: testUser=xenia\n09:16:38.209 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [1f810ba7]close: Deferring shut down of real LocalRepoManager 20000 ms.\n" } ], "duration" : 599.827, "id" : None, "name" : "org.subshare.test.Issue8IT", "stderr" : "", "stdout" : "\n09:06:46.675 [Test worker] INFO o.s.t.AbstractMultiUserIT - \n09:06:46.680 [Test worker] INFO o.s.t.AbstractMultiUserIT - ********************************************************************\n09:06:46.681 [Test worker] INFO o.s.t.AbstractMultiUserIT - *** marco ***\n09:06:46.688 [Test worker] INFO o.s.t.PgpTestUtil - setupPgp: ownerName=marco\n09:06:46.689 [Test worker] INFO o.s.t.AbstractMultiUserIT - MockUp.getInstance: testUser=marco\n09:06:46.690 [Test worker] INFO o.s.t.PgpTestU\n...[truncated 1212811 chars]...\nnager 20000 ms.\n09:16:38.174 [Test worker] INFO o.s.t.AbstractMultiUserIT - MockUp.getInstance: testUser=xenia\n09:16:38.175 [Test worker] INFO o.s.t.AbstractMultiUserIT - MockUp.getInstance: testUser=xenia\n09:16:38.208 [Test worker] INFO o.s.t.AbstractMultiUserIT - MockUp.getInstance: testUser=xenia\n09:16:38.209 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [1f810ba7]close: Deferring shut down of real LocalRepoManager 20000 ms.\n", "timestamp" : "2018-12-25T08:06:41" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.LocalServerClientIT", "duration" : 0.924, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "invokeSimpleStaticMethod", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "09:00:34.327 [Test worker] INFO c.c.c.l.s.LocalServer - logMemoryStats: max=455.5 MiB, allocated=330.5 MiB, used=100.8 MiB, available=354.7 MiB\n09:00:35.253 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n09:00:36.166 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n09:00:36.176 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n09:00:36.638 [qtp1049679073-1028] ERROR c.c.c.l.r.s.DefaultExceptionMapper - java.lang.SecurityException: Invocation denied: Me\n...[truncated 72961 chars]...\n:54) [gradle-base-services-3.1.jar:3.1]\n\tat org.gradle.internal.concurrent.StoppableExecutorImpl$1.run(StoppableExecutorImpl.java:40) [gradle-base-services-3.1.jar:3.1]\n\tat java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [na:1.8.0_191]\n\tat java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [na:1.8.0_191]\n\tat java.lang.Thread.run(Thread.java:748) [na:1.8.0_191]\n09:00:39.501 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.test.LocalServerClientIT", "duration" : 3.328, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "invokeDeniedMethods", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "09:00:34.327 [Test worker] INFO c.c.c.l.s.LocalServer - logMemoryStats: max=455.5 MiB, allocated=330.5 MiB, used=100.8 MiB, available=354.7 MiB\n09:00:35.253 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n09:00:36.166 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n09:00:36.176 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n09:00:36.638 [qtp1049679073-1028] ERROR c.c.c.l.r.s.DefaultExceptionMapper - java.lang.SecurityException: Invocation denied: Me\n...[truncated 72961 chars]...\n:54) [gradle-base-services-3.1.jar:3.1]\n\tat org.gradle.internal.concurrent.StoppableExecutorImpl$1.run(StoppableExecutorImpl.java:40) [gradle-base-services-3.1.jar:3.1]\n\tat java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [na:1.8.0_191]\n\tat java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [na:1.8.0_191]\n\tat java.lang.Thread.run(Thread.java:748) [na:1.8.0_191]\n09:00:39.501 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" } ], "duration" : 4.252, "id" : None, "name" : "org.subshare.test.LocalServerClientIT", "stderr" : "", "stdout" : "09:00:34.327 [Test worker] INFO c.c.c.l.s.LocalServer - logMemoryStats: max=455.5 MiB, allocated=330.5 MiB, used=100.8 MiB, available=354.7 MiB\n09:00:35.253 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n09:00:36.166 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n09:00:36.176 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n09:00:36.638 [qtp1049679073-1028] ERROR c.c.c.l.r.s.DefaultExceptionMapper - java.lang.SecurityException: Invocation denied: Me\n...[truncated 72961 chars]...\n:54) [gradle-base-services-3.1.jar:3.1]\n\tat org.gradle.internal.concurrent.StoppableExecutorImpl$1.run(StoppableExecutorImpl.java:40) [gradle-base-services-3.1.jar:3.1]\n\tat java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [na:1.8.0_191]\n\tat java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [na:1.8.0_191]\n\tat java.lang.Thread.run(Thread.java:748) [na:1.8.0_191]\n09:00:39.501 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n", "timestamp" : "2018-12-25T08:00:35" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.LockerSyncIT", "duration" : 16.565, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncServerRegistry", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "09:16:43.255 [Test worker] INFO o.s.t.PgpTestUtil - setupPgp: ownerName=marco\n09:16:43.271 [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/ULo3FC2Wq8KQnBJy378pgw/client1/.gnupg/pubring.gpg'\n09:16:43.272 [Test worker] INFO o.s.t.PgpTestUtil - copyResource: sourceResName='gpg/marco/secring.gpg' destinationFile='/home/tomcat/.jenkins/workspace/org.subs\n...[truncated 122428 chars]...\nker] INFO o.s.c.l.s.LockerSync - syncDown: serverId='0281_3rKYf0ZjP3ttsduOw' serverName='null' pgpKeyId=d7a92a24aa97ddbd lockerContentName='userRegistry.subshare'\n09:17:07.297 [Test worker] DEBUG o.s.c.p.g.BcPgpDecoder - verifySignature: signingPgpKeyIds=[d7a92a24aa97ddbd]\n09:17:07.300 [Test worker] DEBUG o.s.c.p.g.BcPgpDecoder - decodeEncrypted: encryptingPgpKeyIds=[a58da7d810b74edf]\n09:17:07.388 [Test worker] DEBUG o.s.c.p.g.BcPgpDecoder - verifySignature: signingPgpKeyIds=[d7a92a24aa97ddbd]\n" }, { "age" : 0, "className" : "org.subshare.test.LockerSyncIT", "duration" : 12.309, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncUserRegistry", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "09:16:43.255 [Test worker] INFO o.s.t.PgpTestUtil - setupPgp: ownerName=marco\n09:16:43.271 [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/ULo3FC2Wq8KQnBJy378pgw/client1/.gnupg/pubring.gpg'\n09:16:43.272 [Test worker] INFO o.s.t.PgpTestUtil - copyResource: sourceResName='gpg/marco/secring.gpg' destinationFile='/home/tomcat/.jenkins/workspace/org.subs\n...[truncated 122428 chars]...\nker] INFO o.s.c.l.s.LockerSync - syncDown: serverId='0281_3rKYf0ZjP3ttsduOw' serverName='null' pgpKeyId=d7a92a24aa97ddbd lockerContentName='userRegistry.subshare'\n09:17:07.297 [Test worker] DEBUG o.s.c.p.g.BcPgpDecoder - verifySignature: signingPgpKeyIds=[d7a92a24aa97ddbd]\n09:17:07.300 [Test worker] DEBUG o.s.c.p.g.BcPgpDecoder - decodeEncrypted: encryptingPgpKeyIds=[a58da7d810b74edf]\n09:17:07.388 [Test worker] DEBUG o.s.c.p.g.BcPgpDecoder - verifySignature: signingPgpKeyIds=[d7a92a24aa97ddbd]\n" } ], "duration" : 28.874, "id" : None, "name" : "org.subshare.test.LockerSyncIT", "stderr" : "", "stdout" : "09:16:43.255 [Test worker] INFO o.s.t.PgpTestUtil - setupPgp: ownerName=marco\n09:16:43.271 [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/ULo3FC2Wq8KQnBJy378pgw/client1/.gnupg/pubring.gpg'\n09:16:43.272 [Test worker] INFO o.s.t.PgpTestUtil - copyResource: sourceResName='gpg/marco/secring.gpg' destinationFile='/home/tomcat/.jenkins/workspace/org.subs\n...[truncated 122428 chars]...\nker] INFO o.s.c.l.s.LockerSync - syncDown: serverId='0281_3rKYf0ZjP3ttsduOw' serverName='null' pgpKeyId=d7a92a24aa97ddbd lockerContentName='userRegistry.subshare'\n09:17:07.297 [Test worker] DEBUG o.s.c.p.g.BcPgpDecoder - verifySignature: signingPgpKeyIds=[d7a92a24aa97ddbd]\n09:17:07.300 [Test worker] DEBUG o.s.c.p.g.BcPgpDecoder - decodeEncrypted: encryptingPgpKeyIds=[a58da7d810b74edf]\n09:17:07.388 [Test worker] DEBUG o.s.c.p.g.BcPgpDecoder - verifySignature: signingPgpKeyIds=[d7a92a24aa97ddbd]\n", "timestamp" : "2018-12-25T08:16:41" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.MetaOnlyRepoSyncIT", "duration" : 254.325, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncFromLocalToRemoteToMetaOnlyAddingFiles", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "Dec 25, 2018 8:53:13 AM org.glassfish.jersey.server.ApplicationHandler initialize\nINFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00...\nDec 25, 2018 8:53:18 AM org.glassfish.jersey.server.ApplicationHandler initialize\nINFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00...\n", "stdout" : "08:52:58.312 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n08:53:02.771 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/Yh35udI5KJ4JqWBID8k5RA/.subshare/ssl.server/keystore' does not exist!\n08:53:02.776 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil\n...[truncated 593382 chars]...\n o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 80.08%\n09:03:45.799 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00%\n09:03:45.813 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [7d1b96a7]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:03:45.817 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [3824b4c0]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:03:46.266 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.test.MetaOnlyRepoSyncIT", "duration" : 167.824, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncFromLocalToRemoteToMetaOnly", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "Dec 25, 2018 8:53:13 AM org.glassfish.jersey.server.ApplicationHandler initialize\nINFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00...\nDec 25, 2018 8:53:18 AM org.glassfish.jersey.server.ApplicationHandler initialize\nINFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00...\n", "stdout" : "08:52:58.312 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n08:53:02.771 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/Yh35udI5KJ4JqWBID8k5RA/.subshare/ssl.server/keystore' does not exist!\n08:53:02.776 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil\n...[truncated 593382 chars]...\n o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 80.08%\n09:03:45.799 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00%\n09:03:45.813 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [7d1b96a7]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:03:45.817 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [3824b4c0]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:03:46.266 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.test.MetaOnlyRepoSyncIT", "duration" : 203.122, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncFromLocalToRemoteToMetaOnlyRemovingFiles", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "Dec 25, 2018 8:53:13 AM org.glassfish.jersey.server.ApplicationHandler initialize\nINFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00...\nDec 25, 2018 8:53:18 AM org.glassfish.jersey.server.ApplicationHandler initialize\nINFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00...\n", "stdout" : "08:52:58.312 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n08:53:02.771 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/Yh35udI5KJ4JqWBID8k5RA/.subshare/ssl.server/keystore' does not exist!\n08:53:02.776 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil\n...[truncated 593382 chars]...\n o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 80.08%\n09:03:45.799 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00%\n09:03:45.813 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [7d1b96a7]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:03:45.817 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [3824b4c0]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:03:46.266 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" } ], "duration" : 625.271, "id" : None, "name" : "org.subshare.test.MetaOnlyRepoSyncIT", "stderr" : "Dec 25, 2018 8:53:13 AM org.glassfish.jersey.server.ApplicationHandler initialize\nINFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00...\nDec 25, 2018 8:53:18 AM org.glassfish.jersey.server.ApplicationHandler initialize\nINFO: Initiating Jersey application, version Jersey: 2.5.1 2014-01-02 13:43:00...\n", "stdout" : "08:52:58.312 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n08:53:02.771 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: keyStoreFile='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/jvm/Yh35udI5KJ4JqWBID8k5RA/.subshare/ssl.server/keystore' does not exist!\n08:53:02.776 [cloudStoreServerThread] INFO c.c.c.s.CloudStoreServer - initKeyStore: Creating RSA key pair (this might take a whil\n...[truncated 593382 chars]...\n o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 80.08%\n09:03:45.799 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00%\n09:03:45.813 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [7d1b96a7]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:03:45.817 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [3824b4c0]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:03:46.266 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n", "timestamp" : "2018-12-25T07:53:20" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.MultiplePgpKeysSingleUserRegistryIT", "duration" : 3.869, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "multiplePgpKeysSingleUserRegistry", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "09:29:36.606 [Test worker] INFO o.s.t.PgpTestUtil - setupPgp: ownerName=marco\n09:29:36.609 [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/37tnTTLY7vBtv2rXaQHRKQ/.gnupg/pubring.gpg'\n09:29:36.610 [Test worker] INFO o.s.t.PgpTestUtil - copyResource: sourceResName='gpg/marco/secring.gpg' destinationFile='/home/tomcat/.jenkins/workspace/org.subshare/org\n...[truncated 2804 chars]...\ny pair with publicExponent='65537' strength='1024' certainty='12' took 23 ms.\n09:29:39.578 [Test worker] DEBUG o.s.c.u.UserImpl - createUserRepoKey: pgpKey=PgpKey[bbef20af171556db, [Alexander Bieber (TEST) ]], userRepoKey=UserRepoKeyImpl[userRepoKeyId=GuXAtJAI_ZcHy352nfowKg, invitation=false]\n09:29:39.614 [Test worker] DEBUG o.s.c.p.g.BcPgpDecoder - verifySignature: signingPgpKeyIds=[d7a92a24aa97ddbd]\n09:29:40.085 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" } ], "duration" : 3.869, "id" : None, "name" : "org.subshare.test.MultiplePgpKeysSingleUserRegistryIT", "stderr" : "", "stdout" : "09:29:36.606 [Test worker] INFO o.s.t.PgpTestUtil - setupPgp: ownerName=marco\n09:29:36.609 [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/37tnTTLY7vBtv2rXaQHRKQ/.gnupg/pubring.gpg'\n09:29:36.610 [Test worker] INFO o.s.t.PgpTestUtil - copyResource: sourceResName='gpg/marco/secring.gpg' destinationFile='/home/tomcat/.jenkins/workspace/org.subshare/org\n...[truncated 2804 chars]...\ny pair with publicExponent='65537' strength='1024' certainty='12' took 23 ms.\n09:29:39.578 [Test worker] DEBUG o.s.c.u.UserImpl - createUserRepoKey: pgpKey=PgpKey[bbef20af171556db, [Alexander Bieber (TEST) ]], userRepoKey=UserRepoKeyImpl[userRepoKeyId=GuXAtJAI_ZcHy352nfowKg, invitation=false]\n09:29:39.614 [Test worker] DEBUG o.s.c.p.g.BcPgpDecoder - verifySignature: signingPgpKeyIds=[d7a92a24aa97ddbd]\n09:29:40.085 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n", "timestamp" : "2018-12-25T08:29:36" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.PathPrefixedConfigInheritanceRepoToRepoSyncIT", "duration" : 304.467, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "parentConfigWithRemotePathPrefix", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "09:09:34.059 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n09:09:34.956 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5e248a59]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3gz8is-n7x4z-local-src'\n09:09:34.967 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5e248a59]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3gz8is-n7x4z-local-src' locke\n...[truncated 481538 chars]...\nose: Deferring shut down of real LocalRepoManager 20000 ms.\n09:14:38.080 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00%\n09:14:38.125 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5e248a59]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:14:38.135 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [61d39ba3]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:14:38.523 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" } ], "duration" : 304.467, "id" : None, "name" : "org.subshare.test.PathPrefixedConfigInheritanceRepoToRepoSyncIT", "stderr" : "", "stdout" : "09:09:34.059 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n09:09:34.956 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5e248a59]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3gz8is-n7x4z-local-src'\n09:09:34.967 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5e248a59]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3gz8is-n7x4z-local-src' locke\n...[truncated 481538 chars]...\nose: Deferring shut down of real LocalRepoManager 20000 ms.\n09:14:38.080 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00%\n09:14:38.125 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5e248a59]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:14:38.135 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [61d39ba3]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:14:38.523 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n", "timestamp" : "2018-12-25T08:09:34" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.PermissionIT", "duration" : 329.371, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "interruptPermissionSetInheritance", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "09:00:51.217 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n09:00:52.170 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [42f3e403]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3go14x-4euic-local-src'\n09:00:52.179 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [42f3e403]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3go14x-4euic-local-src' locke\n...[truncated 1391663 chars]...\nlose: Deferring shut down of real LocalRepoManager 20000 ms.\n09:18:03.200 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00%\n09:18:03.266 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [246788d]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:18:03.272 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [58afbc5d]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:18:03.669 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.test.PermissionIT", "duration" : 335.843, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "uploadBackdatedSignature", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "09:00:51.217 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n09:00:52.170 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [42f3e403]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3go14x-4euic-local-src'\n09:00:52.179 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [42f3e403]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3go14x-4euic-local-src' locke\n...[truncated 1391663 chars]...\nlose: Deferring shut down of real LocalRepoManager 20000 ms.\n09:18:03.200 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00%\n09:18:03.266 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [246788d]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:18:03.272 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [58afbc5d]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:18:03.669 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.test.PermissionIT", "duration" : 367.239, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "nonOwnerAdminGrantsWritePermission", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "09:00:51.217 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n09:00:52.170 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [42f3e403]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3go14x-4euic-local-src'\n09:00:52.179 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [42f3e403]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3go14x-4euic-local-src' locke\n...[truncated 1391663 chars]...\nlose: Deferring shut down of real LocalRepoManager 20000 ms.\n09:18:03.200 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00%\n09:18:03.266 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [246788d]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:18:03.272 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [58afbc5d]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:18:03.669 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" } ], "duration" : 1032.453, "id" : None, "name" : "org.subshare.test.PermissionIT", "stderr" : "", "stdout" : "09:00:51.217 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n09:00:52.170 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [42f3e403]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3go14x-4euic-local-src'\n09:00:52.179 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [42f3e403]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3go14x-4euic-local-src' locke\n...[truncated 1391663 chars]...\nlose: Deferring shut down of real LocalRepoManager 20000 ms.\n09:18:03.200 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00%\n09:18:03.266 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [246788d]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:18:03.272 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [58afbc5d]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:18:03.669 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n", "timestamp" : "2018-12-25T08:00:51" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.PgpSyncIT", "duration" : 2.588, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "testPgpSync", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "09:31:58.422 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n09:32:01.005 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" } ], "duration" : 2.588, "id" : None, "name" : "org.subshare.test.PgpSyncIT", "stderr" : "", "stdout" : "09:31:58.422 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n09:32:01.005 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n", "timestamp" : "2018-12-25T08:31:58" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.ReadUserIdentityIT", "duration" : 277.692, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "inviteWithReadInvitationAndGrantReadUserIdentityPermissionLater", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "09:14:38.949 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>>>>>>>>>>>>> ***\n09:14:38.949 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>> before >>> ***\n09:14:39.460 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n09:14:39.460 [Test worker] INFO o.s.t.PgpTestUtil - setupPgp: ownerName=marco\n09:14:39.461 [Test worker] INFO o.s.t.PgpTestUtil - copyResource: sourceResName='gpg/marco/pubring.gpg' destinationFile='/home/tomcat/.jenkins/workspace/org.subshare/org.\n...[truncated 456315 chars]...\nose: Deferring shut down of real LocalRepoManager 20000 ms.\n09:19:15.707 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00%\n09:19:16.174 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5e0e40c6]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:19:16.181 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [135309e5]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:19:16.636 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" } ], "duration" : 277.692, "id" : None, "name" : "org.subshare.test.ReadUserIdentityIT", "stderr" : "", "stdout" : "09:14:38.949 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>>>>>>>>>>>>> ***\n09:14:38.949 [Test worker] INFO o.s.t.AbstractUserRegistryIT - *** >>> before >>> ***\n09:14:39.460 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n09:14:39.460 [Test worker] INFO o.s.t.PgpTestUtil - setupPgp: ownerName=marco\n09:14:39.461 [Test worker] INFO o.s.t.PgpTestUtil - copyResource: sourceResName='gpg/marco/pubring.gpg' destinationFile='/home/tomcat/.jenkins/workspace/org.subshare/org.\n...[truncated 456315 chars]...\nose: Deferring shut down of real LocalRepoManager 20000 ms.\n09:19:15.707 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00%\n09:19:16.174 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5e0e40c6]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:19:16.181 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [135309e5]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:19:16.636 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n", "timestamp" : "2018-12-25T08:14:38" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.RepoToRepoSyncIT", "duration" : 227.565, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncFromLocalToRemoteToLocalAfterCreateAndDeleteFile", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "09:01:16.760 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n09:01:17.394 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [50605e46]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3goklk-eglvu-local-src'\n09:01:17.399 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [50605e46]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3goklk-eglvu-local-src' locke\n...[truncated 2454685 chars]...\nose: Deferring shut down of real LocalRepoManager 20000 ms.\n09:29:35.477 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00%\n09:29:35.513 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5e57dd63]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:29:35.514 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [77a034b4]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:29:35.867 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.test.RepoToRepoSyncIT", "duration" : 288.318, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncFromLocalToRemoteToLocalWithPathPrefixWithWritePermissionGrantedAndRevoked", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "09:01:16.760 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n09:01:17.394 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [50605e46]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3goklk-eglvu-local-src'\n09:01:17.399 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [50605e46]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3goklk-eglvu-local-src' locke\n...[truncated 2454685 chars]...\nose: Deferring shut down of real LocalRepoManager 20000 ms.\n09:29:35.477 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00%\n09:29:35.513 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5e57dd63]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:29:35.514 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [77a034b4]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:29:35.867 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.test.RepoToRepoSyncIT", "duration" : 206.71, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncFromLocalToRemoteToLocal", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "09:01:16.760 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n09:01:17.394 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [50605e46]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3goklk-eglvu-local-src'\n09:01:17.399 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [50605e46]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3goklk-eglvu-local-src' locke\n...[truncated 2454685 chars]...\nose: Deferring shut down of real LocalRepoManager 20000 ms.\n09:29:35.477 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00%\n09:29:35.513 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5e57dd63]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:29:35.514 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [77a034b4]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:29:35.867 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.test.RepoToRepoSyncIT", "duration" : 170.52, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncFromLocalToRemoteToLocalWithPathPrefixWithoutSubdirClearanceKey", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "09:01:16.760 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n09:01:17.394 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [50605e46]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3goklk-eglvu-local-src'\n09:01:17.399 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [50605e46]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3goklk-eglvu-local-src' locke\n...[truncated 2454685 chars]...\nose: Deferring shut down of real LocalRepoManager 20000 ms.\n09:29:35.477 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00%\n09:29:35.513 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5e57dd63]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:29:35.514 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [77a034b4]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:29:35.867 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.test.RepoToRepoSyncIT", "duration" : 193.756, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncFromLocalToRemoteToLocalWithPathPrefix", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "09:01:16.760 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n09:01:17.394 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [50605e46]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3goklk-eglvu-local-src'\n09:01:17.399 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [50605e46]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3goklk-eglvu-local-src' locke\n...[truncated 2454685 chars]...\nose: Deferring shut down of real LocalRepoManager 20000 ms.\n09:29:35.477 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00%\n09:29:35.513 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5e57dd63]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:29:35.514 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [77a034b4]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:29:35.867 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.test.RepoToRepoSyncIT", "duration" : 210.671, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncFromLocalToRemoteToLocalThenDeleteFileAndSyncAgain", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "09:01:16.760 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n09:01:17.394 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [50605e46]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3goklk-eglvu-local-src'\n09:01:17.399 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [50605e46]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3goklk-eglvu-local-src' locke\n...[truncated 2454685 chars]...\nose: Deferring shut down of real LocalRepoManager 20000 ms.\n09:29:35.477 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00%\n09:29:35.513 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5e57dd63]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:29:35.514 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [77a034b4]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:29:35.867 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.test.RepoToRepoSyncIT", "duration" : 266.408, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncFromLocalToRemoteToLocalWithPathPrefixWithSubdirClearanceKey", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "09:01:16.760 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n09:01:17.394 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [50605e46]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3goklk-eglvu-local-src'\n09:01:17.399 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [50605e46]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3goklk-eglvu-local-src' locke\n...[truncated 2454685 chars]...\nose: Deferring shut down of real LocalRepoManager 20000 ms.\n09:29:35.477 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00%\n09:29:35.513 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5e57dd63]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:29:35.514 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [77a034b4]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:29:35.867 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 104, "className" : "org.subshare.test.RepoToRepoSyncIT", "duration" : 0.0, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 257, "name" : "syncFromLocalToRemoteToLocalThenCauseDeleteCollisionOnServerDuringUpSync", "skipped" : True, "skippedMessage" : None, "status" : "SKIPPED", "stderr" : "", "stdout" : "09:01:16.760 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n09:01:17.394 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [50605e46]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3goklk-eglvu-local-src'\n09:01:17.399 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [50605e46]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3goklk-eglvu-local-src' locke\n...[truncated 2454685 chars]...\nose: Deferring shut down of real LocalRepoManager 20000 ms.\n09:29:35.477 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00%\n09:29:35.513 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5e57dd63]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:29:35.514 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [77a034b4]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:29:35.867 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.test.RepoToRepoSyncIT", "duration" : 135.143, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "multiSyncFromLocalToRemoteToLocalWithPathPrefixWithSubdirClearanceKey", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "09:01:16.760 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n09:01:17.394 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [50605e46]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3goklk-eglvu-local-src'\n09:01:17.399 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [50605e46]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3goklk-eglvu-local-src' locke\n...[truncated 2454685 chars]...\nose: Deferring shut down of real LocalRepoManager 20000 ms.\n09:29:35.477 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00%\n09:29:35.513 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5e57dd63]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:29:35.514 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [77a034b4]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:29:35.867 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" } ], "duration" : 1699.0911, "id" : None, "name" : "org.subshare.test.RepoToRepoSyncIT", "stderr" : "", "stdout" : "09:01:16.760 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n09:01:17.394 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [50605e46]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3goklk-eglvu-local-src'\n09:01:17.399 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [50605e46]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3goklk-eglvu-local-src' locke\n...[truncated 2454685 chars]...\nose: Deferring shut down of real LocalRepoManager 20000 ms.\n09:29:35.477 [Test worker] INFO o.s.t.AbstractRepoToRepoSyncIT - Synchronising...: 100.00%\n09:29:35.513 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5e57dd63]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:29:35.514 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [77a034b4]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:29:35.867 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n", "timestamp" : "2018-12-25T08:01:16" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.SymlinkCollisionOnClientRepoToRepoSyncIT", "duration" : 181.383, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "newFileVsNewSymlinkCollisionOnClient", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "09:22:48.036 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n09:22:48.992 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [300de6d7]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3hg97f-f3iw3-local-src'\n09:22:48.999 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [300de6d7]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3hg97f-f3iw3-local-src' locke\n...[truncated 297878 chars]...\nions: query.execute(...) took 7 ms.\n09:25:48.978 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: Loading result-set with 1 elements took 8 ms.\n09:25:48.980 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [300de6d7]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:25:48.983 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5d59ac5]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:25:49.417 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" } ], "duration" : 181.383, "id" : None, "name" : "org.subshare.test.SymlinkCollisionOnClientRepoToRepoSyncIT", "stderr" : "", "stdout" : "09:22:48.036 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n09:22:48.992 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [300de6d7]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3hg97f-f3iw3-local-src'\n09:22:48.999 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [300de6d7]initLockFile: Repository '/home/tomcat/.jenkins/workspace/org.subshare/org.subshare/org.subshare.test/build/repo/jq3hg97f-f3iw3-local-src' locke\n...[truncated 297878 chars]...\nions: query.execute(...) took 7 ms.\n09:25:48.978 [Test worker] INFO o.s.l.p.CollisionDao - getCollisions: Loading result-set with 1 elements took 8 ms.\n09:25:48.980 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [300de6d7]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:25:48.983 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5d59ac5]close: Deferring shut down of real LocalRepoManager 20000 ms.\n09:25:49.417 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n", "timestamp" : "2018-12-25T08:22:48" } ] }