{ "duration" : 12178.542, "empty" : False, "failCount" : 0, "passCount" : 124, "skipCount" : 4, "suites" : [ { "cases" : [ { "age" : 0, "className" : "org.subshare.core.crypto.EncrypterDecrypterStreamTest", "duration" : 22.427, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "symmetricWithoutIv", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "\nsymmetricWithoutIv: cipherTransformation=AES_CBC_PKCS5PADDING\nsymmetricWithoutIv: Generating 9682506 random bytes plaintext took 185 ms.\n18:12:20.967 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\nsymmetricWithoutIv: Creating symmetric key took 963 ms.\nsymmetricWithoutIv: Encrypting 9682506 bytes plaintext to 9682518 bytes ciphertext took 1097 ms.\nsymmetricWithoutIv: Decrypting 9682518 bytes ciphertext to 9682506 bytes plaintext took 1230 ms\n...[truncated 37172 chars]...\n8113 bytes plaintext took 211 ms.\n\nasymmetricCombiWithRandomIv: asymmetricCipherTransformation=RSA_OAEPWITHSHA1ANDMGF1PADDING\nasymmetricCombiWithRandomIv: symmetricCipherTransformation=TWOFISH_CFB_NOPADDING\nasymmetricCombiWithRandomIv: Generating 6590720 random bytes plaintext took 42 ms.\nasymmetricCombiWithRandomIv: Encrypting 6590720 bytes plaintext to 6591264 bytes ciphertext took 328 ms.\nasymmetricCombiWithRandomIv: Decrypting 6591264 bytes ciphertext to 6590720 bytes plaintext took 337 ms.\n" }, { "age" : 0, "className" : "org.subshare.core.crypto.EncrypterDecrypterStreamTest", "duration" : 19.602, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "symmetricWithRandomIv", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "\nsymmetricWithoutIv: cipherTransformation=AES_CBC_PKCS5PADDING\nsymmetricWithoutIv: Generating 9682506 random bytes plaintext took 185 ms.\n18:12:20.967 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\nsymmetricWithoutIv: Creating symmetric key took 963 ms.\nsymmetricWithoutIv: Encrypting 9682506 bytes plaintext to 9682518 bytes ciphertext took 1097 ms.\nsymmetricWithoutIv: Decrypting 9682518 bytes ciphertext to 9682506 bytes plaintext took 1230 ms\n...[truncated 37172 chars]...\n8113 bytes plaintext took 211 ms.\n\nasymmetricCombiWithRandomIv: asymmetricCipherTransformation=RSA_OAEPWITHSHA1ANDMGF1PADDING\nasymmetricCombiWithRandomIv: symmetricCipherTransformation=TWOFISH_CFB_NOPADDING\nasymmetricCombiWithRandomIv: Generating 6590720 random bytes plaintext took 42 ms.\nasymmetricCombiWithRandomIv: Encrypting 6590720 bytes plaintext to 6591264 bytes ciphertext took 328 ms.\nasymmetricCombiWithRandomIv: Decrypting 6591264 bytes ciphertext to 6590720 bytes plaintext took 337 ms.\n" }, { "age" : 0, "className" : "org.subshare.core.crypto.EncrypterDecrypterStreamTest", "duration" : 6.457, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "asymmetricPlain", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "\nsymmetricWithoutIv: cipherTransformation=AES_CBC_PKCS5PADDING\nsymmetricWithoutIv: Generating 9682506 random bytes plaintext took 185 ms.\n18:12:20.967 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\nsymmetricWithoutIv: Creating symmetric key took 963 ms.\nsymmetricWithoutIv: Encrypting 9682506 bytes plaintext to 9682518 bytes ciphertext took 1097 ms.\nsymmetricWithoutIv: Decrypting 9682518 bytes ciphertext to 9682506 bytes plaintext took 1230 ms\n...[truncated 37172 chars]...\n8113 bytes plaintext took 211 ms.\n\nasymmetricCombiWithRandomIv: asymmetricCipherTransformation=RSA_OAEPWITHSHA1ANDMGF1PADDING\nasymmetricCombiWithRandomIv: symmetricCipherTransformation=TWOFISH_CFB_NOPADDING\nasymmetricCombiWithRandomIv: Generating 6590720 random bytes plaintext took 42 ms.\nasymmetricCombiWithRandomIv: Encrypting 6590720 bytes plaintext to 6591264 bytes ciphertext took 328 ms.\nasymmetricCombiWithRandomIv: Decrypting 6591264 bytes ciphertext to 6590720 bytes plaintext took 337 ms.\n" }, { "age" : 0, "className" : "org.subshare.core.crypto.EncrypterDecrypterStreamTest", "duration" : 23.476, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "asymmetricCombiWithRandomIv", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "\nsymmetricWithoutIv: cipherTransformation=AES_CBC_PKCS5PADDING\nsymmetricWithoutIv: Generating 9682506 random bytes plaintext took 185 ms.\n18:12:20.967 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\nsymmetricWithoutIv: Creating symmetric key took 963 ms.\nsymmetricWithoutIv: Encrypting 9682506 bytes plaintext to 9682518 bytes ciphertext took 1097 ms.\nsymmetricWithoutIv: Decrypting 9682518 bytes ciphertext to 9682506 bytes plaintext took 1230 ms\n...[truncated 37172 chars]...\n8113 bytes plaintext took 211 ms.\n\nasymmetricCombiWithRandomIv: asymmetricCipherTransformation=RSA_OAEPWITHSHA1ANDMGF1PADDING\nasymmetricCombiWithRandomIv: symmetricCipherTransformation=TWOFISH_CFB_NOPADDING\nasymmetricCombiWithRandomIv: Generating 6590720 random bytes plaintext took 42 ms.\nasymmetricCombiWithRandomIv: Encrypting 6590720 bytes plaintext to 6591264 bytes ciphertext took 328 ms.\nasymmetricCombiWithRandomIv: Decrypting 6591264 bytes ciphertext to 6590720 bytes plaintext took 337 ms.\n" } ], "duration" : 71.962, "id" : None, "name" : "org.subshare.core.crypto.EncrypterDecrypterStreamTest", "stderr" : "", "stdout" : "\nsymmetricWithoutIv: cipherTransformation=AES_CBC_PKCS5PADDING\nsymmetricWithoutIv: Generating 9682506 random bytes plaintext took 185 ms.\n18:12:20.967 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\nsymmetricWithoutIv: Creating symmetric key took 963 ms.\nsymmetricWithoutIv: Encrypting 9682506 bytes plaintext to 9682518 bytes ciphertext took 1097 ms.\nsymmetricWithoutIv: Decrypting 9682518 bytes ciphertext to 9682506 bytes plaintext took 1230 ms\n...[truncated 37172 chars]...\n8113 bytes plaintext took 211 ms.\n\nasymmetricCombiWithRandomIv: asymmetricCipherTransformation=RSA_OAEPWITHSHA1ANDMGF1PADDING\nasymmetricCombiWithRandomIv: symmetricCipherTransformation=TWOFISH_CFB_NOPADDING\nasymmetricCombiWithRandomIv: Generating 6590720 random bytes plaintext took 42 ms.\nasymmetricCombiWithRandomIv: Encrypting 6590720 bytes plaintext to 6591264 bytes ciphertext took 328 ms.\nasymmetricCombiWithRandomIv: Decrypting 6591264 bytes ciphertext to 6590720 bytes plaintext took 337 ms.\n", "timestamp" : "2020-04-19T16:12:20" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.core.file.EncryptedDataFileTest", "duration" : 1.642, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "writeReadSimpleEncryptedDataFile", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "" } ], "duration" : 1.642, "id" : None, "name" : "org.subshare.core.file.EncryptedDataFileTest", "stderr" : "", "stdout" : "", "timestamp" : "2020-04-19T16:12:21" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.core.gpg.GnuPgTest", "duration" : 5.249, "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" : 1.746, "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.551, "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.033, "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" : 7.579, "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" : "2020-04-19T16:12:16" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.core.io.LimitedInputStreamTest", "duration" : 2.025, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "randomLengthWithUnderlyingSameLength", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "" } ], "duration" : 2.025, "id" : None, "name" : "org.subshare.core.io.LimitedInputStreamTest", "stderr" : "", "stdout" : "", "timestamp" : "2020-04-19T16:12:17" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.core.io.MultiInputStreamTest", "duration" : 6.944, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "randomCombi", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "" } ], "duration" : 6.944, "id" : None, "name" : "org.subshare.core.io.MultiInputStreamTest", "stderr" : "", "stdout" : "", "timestamp" : "2020-04-19T16:12:14" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.core.pgp.PgpTest", "duration" : 10.971, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "inlineSignThenEncryptAndDecryptThenVerify", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:12:18.829 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n18:12:18.878 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:12:18.994 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/KPBBpYq4VZr9KSsC7vey8A/.gnupg\n18:12:18.998 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.core/build/KPBBpYq4VZr9KSsC7vey8A/.gnupg\n18:12:19.87\n...[truncated 28528 chars]...\nle.internal.concurrent.ManagedExecutorImpl$1.run(ManagedExecutorImpl.java:48)\n\tat java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)\n\tat java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)\n\tat org.gradle.internal.concurrent.ThreadFactoryImpl$ManagedThreadRunnable.run(ThreadFactoryImpl.java:56)\n\tat java.base/java.lang.Thread.run(Thread.java:834)\n18:12:42.829 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.core.pgp.PgpTest", "duration" : 0.143, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "signAndVerifyViaPgpSignable", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:12:18.829 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n18:12:18.878 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:12:18.994 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/KPBBpYq4VZr9KSsC7vey8A/.gnupg\n18:12:18.998 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.core/build/KPBBpYq4VZr9KSsC7vey8A/.gnupg\n18:12:19.87\n...[truncated 28528 chars]...\nle.internal.concurrent.ManagedExecutorImpl$1.run(ManagedExecutorImpl.java:48)\n\tat java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)\n\tat java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)\n\tat org.gradle.internal.concurrent.ThreadFactoryImpl$ManagedThreadRunnable.run(ThreadFactoryImpl.java:56)\n\tat java.base/java.lang.Thread.run(Thread.java:834)\n18:12:42.829 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.core.pgp.PgpTest", "duration" : 1.469, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "inlineSignAndVerify", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:12:18.829 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n18:12:18.878 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:12:18.994 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/KPBBpYq4VZr9KSsC7vey8A/.gnupg\n18:12:18.998 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.core/build/KPBBpYq4VZr9KSsC7vey8A/.gnupg\n18:12:19.87\n...[truncated 28528 chars]...\nle.internal.concurrent.ManagedExecutorImpl$1.run(ManagedExecutorImpl.java:48)\n\tat java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)\n\tat java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)\n\tat org.gradle.internal.concurrent.ThreadFactoryImpl$ManagedThreadRunnable.run(ThreadFactoryImpl.java:56)\n\tat java.base/java.lang.Thread.run(Thread.java:834)\n18:12:42.829 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.core.pgp.PgpTest", "duration" : 0.253, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "exportImportPublicKey", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:12:18.829 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n18:12:18.878 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:12:18.994 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/KPBBpYq4VZr9KSsC7vey8A/.gnupg\n18:12:18.998 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.core/build/KPBBpYq4VZr9KSsC7vey8A/.gnupg\n18:12:19.87\n...[truncated 28528 chars]...\nle.internal.concurrent.ManagedExecutorImpl$1.run(ManagedExecutorImpl.java:48)\n\tat java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)\n\tat java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)\n\tat org.gradle.internal.concurrent.ThreadFactoryImpl$ManagedThreadRunnable.run(ThreadFactoryImpl.java:56)\n\tat java.base/java.lang.Thread.run(Thread.java:834)\n18:12:42.829 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.core.pgp.PgpTest", "duration" : 10.278, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "detachedSignAndVerify", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:12:18.829 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n18:12:18.878 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:12:18.994 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/KPBBpYq4VZr9KSsC7vey8A/.gnupg\n18:12:18.998 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.core/build/KPBBpYq4VZr9KSsC7vey8A/.gnupg\n18:12:19.87\n...[truncated 28528 chars]...\nle.internal.concurrent.ManagedExecutorImpl$1.run(ManagedExecutorImpl.java:48)\n\tat java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)\n\tat java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)\n\tat org.gradle.internal.concurrent.ThreadFactoryImpl$ManagedThreadRunnable.run(ThreadFactoryImpl.java:56)\n\tat java.base/java.lang.Thread.run(Thread.java:834)\n18:12:42.829 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" } ], "duration" : 23.113998, "id" : None, "name" : "org.subshare.core.pgp.PgpTest", "stderr" : "", "stdout" : "18:12:18.829 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n18:12:18.878 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:12:18.994 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/KPBBpYq4VZr9KSsC7vey8A/.gnupg\n18:12:18.998 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.core/build/KPBBpYq4VZr9KSsC7vey8A/.gnupg\n18:12:19.87\n...[truncated 28528 chars]...\nle.internal.concurrent.ManagedExecutorImpl$1.run(ManagedExecutorImpl.java:48)\n\tat java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)\n\tat java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)\n\tat org.gradle.internal.concurrent.ThreadFactoryImpl$ManagedThreadRunnable.run(ThreadFactoryImpl.java:56)\n\tat java.base/java.lang.Thread.run(Thread.java:834)\n18:12:42.829 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n", "timestamp" : "2020-04-19T16:12:19" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.core.user.AddDuplicateUserRepoKeyPublicKeyToUserTest", "duration" : 0.764, "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.003, "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.011, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "addDifferentUserRepoKeyPublicKeysToUser", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "" } ], "duration" : 0.782, "id" : None, "name" : "org.subshare.core.user.AddDuplicateUserRepoKeyPublicKeyToUserTest", "stderr" : "", "stdout" : "", "timestamp" : "2020-04-19T16:12:17" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.core.user.UserRegistryTest", "duration" : 2.688, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "addUser", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:12:24.652 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n18:12:24.683 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:12:24.717 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/EhRJdIXNW1xHR0Z7YKsMRw/.gnupg\n18:12:24.718 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.core/build/EhRJdIXNW1xHR0Z7YKsMRw/.gnupg\n18:12:24.89\n...[truncated 14216 chars]...\ntance.\n18:12:46.327 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance.\n18:12:53.750 [Test worker] INFO o.s.c.c.KeyFactory - Creating asymmetric key pair with defaults took 7418 ms.\n18:12:53.761 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance.\n18:12:53.868 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance.\n18:12:53.938 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.core.user.UserRegistryTest", "duration" : 8.82, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "testGpgKeyTrustLevels", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:12:24.652 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n18:12:24.683 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:12:24.717 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/EhRJdIXNW1xHR0Z7YKsMRw/.gnupg\n18:12:24.718 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.core/build/EhRJdIXNW1xHR0Z7YKsMRw/.gnupg\n18:12:24.89\n...[truncated 14216 chars]...\ntance.\n18:12:46.327 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance.\n18:12:53.750 [Test worker] INFO o.s.c.c.KeyFactory - Creating asymmetric key pair with defaults took 7418 ms.\n18:12:53.761 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance.\n18:12:53.868 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance.\n18:12:53.938 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.core.user.UserRegistryTest", "duration" : 17.766, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "initUserRegistryFromGpgKeys", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:12:24.652 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n18:12:24.683 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:12:24.717 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/EhRJdIXNW1xHR0Z7YKsMRw/.gnupg\n18:12:24.718 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.core/build/EhRJdIXNW1xHR0Z7YKsMRw/.gnupg\n18:12:24.89\n...[truncated 14216 chars]...\ntance.\n18:12:46.327 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance.\n18:12:53.750 [Test worker] INFO o.s.c.c.KeyFactory - Creating asymmetric key pair with defaults took 7418 ms.\n18:12:53.761 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance.\n18:12:53.868 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance.\n18:12:53.938 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" } ], "duration" : 29.274, "id" : None, "name" : "org.subshare.core.user.UserRegistryTest", "stderr" : "", "stdout" : "18:12:24.652 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n18:12:24.683 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:12:24.717 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/EhRJdIXNW1xHR0Z7YKsMRw/.gnupg\n18:12:24.718 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.core/build/EhRJdIXNW1xHR0Z7YKsMRw/.gnupg\n18:12:24.89\n...[truncated 14216 chars]...\ntance.\n18:12:46.327 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance.\n18:12:53.750 [Test worker] INFO o.s.c.c.KeyFactory - Creating asymmetric key pair with defaults took 7418 ms.\n18:12:53.761 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance.\n18:12:53.868 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance.\n18:12:53.938 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n", "timestamp" : "2020-04-19T16:12:24" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.core.user.UserRepoKeyRingVsPublicKeysUserImplTest", "duration" : 0.815, "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.153, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "firstCreateUserRepoKeyRingThenAddPublicKeys", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "" } ], "duration" : 0.968, "id" : None, "name" : "org.subshare.core.user.UserRepoKeyRingVsPublicKeysUserImplTest", "stderr" : "", "stdout" : "", "timestamp" : "2020-04-19T16:12:17" }, { "cases" : [ { "age" : 29, "className" : "org.subshare.crypto.AsymmetricKeyTest", "duration" : 0.017, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 11, "name" : "generateManySymmetricKeys", "skipped" : True, "skippedMessage" : None, "status" : "SKIPPED", "stderr" : "", "stdout" : "" }, { "age" : 0, "className" : "org.subshare.crypto.AsymmetricKeyTest", "duration" : 13.17, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "encodeDecodeRSAwithOAEPwithSHA1andMGF1Padding", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "" }, { "age" : 0, "className" : "org.subshare.crypto.AsymmetricKeyTest", "duration" : 4.506, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "encodeDecodeRSA", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "" } ], "duration" : 17.693, "id" : None, "name" : "org.subshare.crypto.AsymmetricKeyTest", "stderr" : "", "stdout" : "", "timestamp" : "2020-04-19T16:13:47" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.crypto.CipherTest", "duration" : 6.438, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "testLookupAllSupportedCiphers", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:13:54.267 [Test worker] INFO o.s.c.CipherTest - testLookupAllSupportedCiphers: Successfully created 29934 ciphers in 4624 msec.\n18:13:54.812 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//\n18:13:54.836 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyParameter: Transformation \"AES.FAST//\" does not support IV => Skipping.\n18:13:54.840 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//NOPADDING\n18:13:54.844 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyP\n...[truncated 3456005 chars]...\ns.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding\n18:14:11.205 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding\n18:14:11.355 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CBC/PKCS5Padding\n18:14:11.520 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CFB/NoPadding\n18:14:12.354 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding\n18:14:12.538 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding\n" }, { "age" : 0, "className" : "org.subshare.crypto.CipherTest", "duration" : 11.987, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "testNullAsKeyParameter", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:13:54.267 [Test worker] INFO o.s.c.CipherTest - testLookupAllSupportedCiphers: Successfully created 29934 ciphers in 4624 msec.\n18:13:54.812 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//\n18:13:54.836 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyParameter: Transformation \"AES.FAST//\" does not support IV => Skipping.\n18:13:54.840 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//NOPADDING\n18:13:54.844 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyP\n...[truncated 3456005 chars]...\ns.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding\n18:14:11.205 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding\n18:14:11.355 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CBC/PKCS5Padding\n18:14:11.520 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CFB/NoPadding\n18:14:12.354 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding\n18:14:12.538 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding\n" }, { "age" : 0, "className" : "org.subshare.crypto.CipherTest", "duration" : 0.202, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "testLookupCompatibilityWithJCE", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:13:54.267 [Test worker] INFO o.s.c.CipherTest - testLookupAllSupportedCiphers: Successfully created 29934 ciphers in 4624 msec.\n18:13:54.812 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//\n18:13:54.836 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyParameter: Transformation \"AES.FAST//\" does not support IV => Skipping.\n18:13:54.840 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//NOPADDING\n18:13:54.844 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyP\n...[truncated 3456005 chars]...\ns.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding\n18:14:11.205 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding\n18:14:11.355 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CBC/PKCS5Padding\n18:14:11.520 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CFB/NoPadding\n18:14:12.354 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding\n18:14:12.538 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding\n" }, { "age" : 0, "className" : "org.subshare.crypto.CipherTest", "duration" : 6.579, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "testSymmetricEncryptionWithoutIv", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:13:54.267 [Test worker] INFO o.s.c.CipherTest - testLookupAllSupportedCiphers: Successfully created 29934 ciphers in 4624 msec.\n18:13:54.812 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//\n18:13:54.836 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyParameter: Transformation \"AES.FAST//\" does not support IV => Skipping.\n18:13:54.840 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//NOPADDING\n18:13:54.844 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyP\n...[truncated 3456005 chars]...\ns.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding\n18:14:11.205 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding\n18:14:11.355 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CBC/PKCS5Padding\n18:14:11.520 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CFB/NoPadding\n18:14:12.354 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding\n18:14:12.538 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding\n" }, { "age" : 0, "className" : "org.subshare.crypto.CipherTest", "duration" : 0.172, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "testSymmetricEncryptionCompatibilityWithJCE_BouncyCastleProvider", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:13:54.267 [Test worker] INFO o.s.c.CipherTest - testLookupAllSupportedCiphers: Successfully created 29934 ciphers in 4624 msec.\n18:13:54.812 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//\n18:13:54.836 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyParameter: Transformation \"AES.FAST//\" does not support IV => Skipping.\n18:13:54.840 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//NOPADDING\n18:13:54.844 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyP\n...[truncated 3456005 chars]...\ns.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding\n18:14:11.205 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding\n18:14:11.355 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CBC/PKCS5Padding\n18:14:11.520 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CFB/NoPadding\n18:14:12.354 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding\n18:14:12.538 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding\n" } ], "duration" : 25.378002, "id" : None, "name" : "org.subshare.crypto.CipherTest", "stderr" : "", "stdout" : "18:13:54.267 [Test worker] INFO o.s.c.CipherTest - testLookupAllSupportedCiphers: Successfully created 29934 ciphers in 4624 msec.\n18:13:54.812 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//\n18:13:54.836 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyParameter: Transformation \"AES.FAST//\" does not support IV => Skipping.\n18:13:54.840 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//NOPADDING\n18:13:54.844 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyP\n...[truncated 3456005 chars]...\ns.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding\n18:14:11.205 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding\n18:14:11.355 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CBC/PKCS5Padding\n18:14:11.520 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CFB/NoPadding\n18:14:12.354 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding\n18:14:12.538 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding\n", "timestamp" : "2020-04-19T16:13:47" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.crypto.GCMTest", "duration" : 6.605, "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.623, "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.228, "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" : "2020-04-19T16:13:50" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.crypto.MACBenchmark", "duration" : 0.213, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "testByteOrder", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:13:47.855 [Test worker] INFO o.s.c.MACBenchmark - short1 = 29208\n18:13:47.877 [Test worker] INFO o.s.c.MACBenchmark - short2 = 29208\n18:13:47.879 [Test worker] INFO o.s.c.MACBenchmark - int1 = 29208\n" }, { "age" : 0, "className" : "org.subshare.crypto.MACBenchmark", "duration" : 13.941, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "benchmarkCreateManyInitialisedMACCalculators", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:13:47.855 [Test worker] INFO o.s.c.MACBenchmark - short1 = 29208\n18:13:47.877 [Test worker] INFO o.s.c.MACBenchmark - short2 = 29208\n18:13:47.879 [Test worker] INFO o.s.c.MACBenchmark - int1 = 29208\n" }, { "age" : 0, "className" : "org.subshare.crypto.MACBenchmark", "duration" : 0.201, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "benchmarkCreateManyUNinitialisedMACCalculators", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:13:47.855 [Test worker] INFO o.s.c.MACBenchmark - short1 = 29208\n18:13:47.877 [Test worker] INFO o.s.c.MACBenchmark - short2 = 29208\n18:13:47.879 [Test worker] INFO o.s.c.MACBenchmark - int1 = 29208\n" }, { "age" : 0, "className" : "org.subshare.crypto.MACBenchmark", "duration" : 19.639, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "benchmarkCalculateManyMACsWithNewMACCalculator", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:13:47.855 [Test worker] INFO o.s.c.MACBenchmark - short1 = 29208\n18:13:47.877 [Test worker] INFO o.s.c.MACBenchmark - short2 = 29208\n18:13:47.879 [Test worker] INFO o.s.c.MACBenchmark - int1 = 29208\n" }, { "age" : 0, "className" : "org.subshare.crypto.MACBenchmark", "duration" : 15.999, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "benchmarkCalculateManyMACsWithSameMACCalculator", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:13:47.855 [Test worker] INFO o.s.c.MACBenchmark - short1 = 29208\n18:13:47.877 [Test worker] INFO o.s.c.MACBenchmark - short2 = 29208\n18:13:47.879 [Test worker] INFO o.s.c.MACBenchmark - int1 = 29208\n" } ], "duration" : 49.993, "id" : None, "name" : "org.subshare.crypto.MACBenchmark", "stderr" : "", "stdout" : "18:13:47.855 [Test worker] INFO o.s.c.MACBenchmark - short1 = 29208\n18:13:47.877 [Test worker] INFO o.s.c.MACBenchmark - short2 = 29208\n18:13:47.879 [Test worker] INFO o.s.c.MACBenchmark - int1 = 29208\n", "timestamp" : "2020-04-19T16:13:47" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.crypto.MACTest", "duration" : 6.363, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "testAllSupportedMACs", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "" } ], "duration" : 6.363, "id" : None, "name" : "org.subshare.crypto.MACTest", "stderr" : "", "stdout" : "", "timestamp" : "2020-04-19T16:13:46" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.crypto.ShowSupportedAlgosForDocumentation", "duration" : 3.085, "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.084, "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.026, "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.049, "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" : 3.2440002, "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" : "2020-04-19T16:13:47" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.local.CryptreeImplGrantRevokeReadPermissionTest", "duration" : 124.344, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "grantAndRevokeReadPermission", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:15:30.321 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n18:15:30.640 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:33.044 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [401cdea4]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.local/build/repo/k9794xfs-ccg7w-local'\n18:15:33.233 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 199\n...[truncated 32881 chars]...\nNFO o.s.l.CryptreeImplGrantRevokeReadPermissionTest - Local sync...: 90.83%\n18:17:33.542 [Test worker] INFO o.s.l.CryptreeImplGrantRevokeReadPermissionTest - Local sync...: 96.55%\n18:17:33.604 [Test worker] INFO o.s.l.CryptreeImplGrantRevokeReadPermissionTest - Local sync...: 100.00%\n18:17:34.222 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [401cdea4]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:17:34.279 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" } ], "duration" : 124.344, "id" : None, "name" : "org.subshare.local.CryptreeImplGrantRevokeReadPermissionTest", "stderr" : "", "stdout" : "18:15:30.321 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n18:15:30.640 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:33.044 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [401cdea4]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.local/build/repo/k9794xfs-ccg7w-local'\n18:15:33.233 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 199\n...[truncated 32881 chars]...\nNFO o.s.l.CryptreeImplGrantRevokeReadPermissionTest - Local sync...: 90.83%\n18:17:33.542 [Test worker] INFO o.s.l.CryptreeImplGrantRevokeReadPermissionTest - Local sync...: 96.55%\n18:17:33.604 [Test worker] INFO o.s.l.CryptreeImplGrantRevokeReadPermissionTest - Local sync...: 100.00%\n18:17:34.222 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [401cdea4]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:17:34.279 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n", "timestamp" : "2020-04-19T16:15:29" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.local.CryptreeImplGrantRevokeWritePermissionTest", "duration" : 107.768, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "grantWritePermissionWithoutGrantPermission", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:15:30.426 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n18:15:30.644 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:32.752 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2f759101]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.local/build/repo/k9794x8z-ji0s1-local'\n18:15:32.972 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 199\n...[truncated 149035 chars]...\nTest - Local sync...: 79.60%\n18:20:36.801 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 90.83%\n18:20:36.829 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 96.55%\n18:20:36.858 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 100.00%\n18:20:36.887 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [10a041b3]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:20:36.888 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.local.CryptreeImplGrantRevokeWritePermissionTest", "duration" : 44.784, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "writeWithWritePermissionInParentParent", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:15:30.426 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n18:15:30.644 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:32.752 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2f759101]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.local/build/repo/k9794x8z-ji0s1-local'\n18:15:32.972 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 199\n...[truncated 149035 chars]...\nTest - Local sync...: 79.60%\n18:20:36.801 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 90.83%\n18:20:36.829 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 96.55%\n18:20:36.858 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 100.00%\n18:20:36.887 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [10a041b3]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:20:36.888 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.local.CryptreeImplGrantRevokeWritePermissionTest", "duration" : 33.499, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "writeWithWritePermissionInParent", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:15:30.426 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n18:15:30.644 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:32.752 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2f759101]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.local/build/repo/k9794x8z-ji0s1-local'\n18:15:32.972 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 199\n...[truncated 149035 chars]...\nTest - Local sync...: 79.60%\n18:20:36.801 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 90.83%\n18:20:36.829 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 96.55%\n18:20:36.858 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 100.00%\n18:20:36.887 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [10a041b3]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:20:36.888 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.local.CryptreeImplGrantRevokeWritePermissionTest", "duration" : 33.421, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "writeWithWritePermissionDirectDir", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:15:30.426 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n18:15:30.644 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:32.752 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2f759101]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.local/build/repo/k9794x8z-ji0s1-local'\n18:15:32.972 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 199\n...[truncated 149035 chars]...\nTest - Local sync...: 79.60%\n18:20:36.801 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 90.83%\n18:20:36.829 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 96.55%\n18:20:36.858 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 100.00%\n18:20:36.887 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [10a041b3]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:20:36.888 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.local.CryptreeImplGrantRevokeWritePermissionTest", "duration" : 29.287, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "writeWithoutWritePermission", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:15:30.426 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n18:15:30.644 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:32.752 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2f759101]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.local/build/repo/k9794x8z-ji0s1-local'\n18:15:32.972 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 199\n...[truncated 149035 chars]...\nTest - Local sync...: 79.60%\n18:20:36.801 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 90.83%\n18:20:36.829 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 96.55%\n18:20:36.858 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 100.00%\n18:20:36.887 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [10a041b3]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:20:36.888 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.local.CryptreeImplGrantRevokeWritePermissionTest", "duration" : 30.825, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "writeWithWritePermissionInParentParentGrantedIndirectly", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:15:30.426 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n18:15:30.644 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:32.752 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2f759101]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.local/build/repo/k9794x8z-ji0s1-local'\n18:15:32.972 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 199\n...[truncated 149035 chars]...\nTest - Local sync...: 79.60%\n18:20:36.801 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 90.83%\n18:20:36.829 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 96.55%\n18:20:36.858 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 100.00%\n18:20:36.887 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [10a041b3]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:20:36.888 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.local.CryptreeImplGrantRevokeWritePermissionTest", "duration" : 27.323, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "writeWithWritePermissionDirectFile", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:15:30.426 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n18:15:30.644 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:32.752 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2f759101]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.local/build/repo/k9794x8z-ji0s1-local'\n18:15:32.972 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 199\n...[truncated 149035 chars]...\nTest - Local sync...: 79.60%\n18:20:36.801 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 90.83%\n18:20:36.829 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 96.55%\n18:20:36.858 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 100.00%\n18:20:36.887 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [10a041b3]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:20:36.888 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" } ], "duration" : 306.907, "id" : None, "name" : "org.subshare.local.CryptreeImplGrantRevokeWritePermissionTest", "stderr" : "", "stdout" : "18:15:30.426 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n18:15:30.644 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:32.752 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2f759101]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.local/build/repo/k9794x8z-ji0s1-local'\n18:15:32.972 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 199\n...[truncated 149035 chars]...\nTest - Local sync...: 79.60%\n18:20:36.801 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 90.83%\n18:20:36.829 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 96.55%\n18:20:36.858 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 100.00%\n18:20:36.887 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [10a041b3]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:20:36.888 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n", "timestamp" : "2020-04-19T16:15:29" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.local.FilePaddingLengthRandomTest", "duration" : 7.355, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "testDistribution", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "lengthCategory2HitCount: {_100K=300976, _1M=147231, _10M=46802, _100M=3005, _1G=1986, _10G=0}\nlengthCategory2HitPercentage: {_100K=602, _1M=294, _10M=94, _100M=6, _1G=4, _10G=0}\n5818\n" }, { "age" : 0, "className" : "org.subshare.local.FilePaddingLengthRandomTest", "duration" : 0.006, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "generateOneRandomLength", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "lengthCategory2HitCount: {_100K=300976, _1M=147231, _10M=46802, _100M=3005, _1G=1986, _10G=0}\nlengthCategory2HitPercentage: {_100K=602, _1M=294, _10M=94, _100M=6, _1G=4, _10G=0}\n5818\n" } ], "duration" : 7.361, "id" : None, "name" : "org.subshare.local.FilePaddingLengthRandomTest", "stderr" : "", "stdout" : "lengthCategory2HitCount: {_100K=300976, _1M=147231, _10M=46802, _100M=3005, _1G=1986, _10G=0}\nlengthCategory2HitPercentage: {_100K=602, _1M=294, _10M=94, _100M=6, _1G=4, _10G=0}\n5818\n", "timestamp" : "2020-04-19T16:17:43" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.local.db.DbMigrateFromDerbyToPostgresqlTest", "duration" : 139.815, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "migrateFromDerbyToPostgresql", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:15:30.405 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n18:15:30.709 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:33.024 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [26f3155e]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.local/build/repo/k9794xh1-awge2-local'\n18:15:33.193 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 198\n...[truncated 1313677 chars]...\nproblems?\n18:17:49.570 [Test worker] INFO o.s.l.d.SsDatabaseMigrater - testTargetPersistence: entered.\n18:17:49.830 [Test worker] INFO D.D.Retrieve - Object with id \"1\" not found !\n18:17:49.837 [Test worker] INFO c.c.c.l.d.DatabaseMigrater - migrateIfNeeded: localRoot='build/repo/k9794xh1-awge2-local': Migration complete!\n18:17:49.855 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:17:50.119 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n" } ], "duration" : 139.815, "id" : None, "name" : "org.subshare.local.db.DbMigrateFromDerbyToPostgresqlTest", "stderr" : "", "stdout" : "18:15:30.405 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n18:15:30.709 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:33.024 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [26f3155e]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.local/build/repo/k9794xh1-awge2-local'\n18:15:33.193 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 198\n...[truncated 1313677 chars]...\nproblems?\n18:17:49.570 [Test worker] INFO o.s.l.d.SsDatabaseMigrater - testTargetPersistence: entered.\n18:17:49.830 [Test worker] INFO D.D.Retrieve - Object with id \"1\" not found !\n18:17:49.837 [Test worker] INFO c.c.c.l.d.DatabaseMigrater - migrateIfNeeded: localRoot='build/repo/k9794xh1-awge2-local': Migration complete!\n18:17:49.855 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:17:50.119 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n", "timestamp" : "2020-04-19T16:15:30" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.local.db.DbMigrateFromPostgresqlToDerbyTest", "duration" : 133.023, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "migrateFromPostgresqlToDerby", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:15:30.233 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n18:15:30.363 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n18:15:30.460 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:32.392 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [61a37112]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.local/build/repo/k9794wzr-9651q-local'\n18\n...[truncated 1468447 chars]...\nproblems?\n18:17:42.786 [Test worker] INFO o.s.l.d.SsDatabaseMigrater - testTargetPersistence: entered.\n18:17:43.321 [Test worker] INFO D.D.Retrieve - Object with id \"1\" not found !\n18:17:43.349 [Test worker] INFO c.c.c.l.d.DatabaseMigrater - migrateIfNeeded: localRoot='build/repo/k9794wzr-9651q-local': Migration complete!\n18:17:43.390 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:17:43.853 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n" } ], "duration" : 133.023, "id" : None, "name" : "org.subshare.local.db.DbMigrateFromPostgresqlToDerbyTest", "stderr" : "", "stdout" : "18:15:30.233 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n18:15:30.363 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n18:15:30.460 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:32.392 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [61a37112]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.local/build/repo/k9794wzr-9651q-local'\n18\n...[truncated 1468447 chars]...\nproblems?\n18:17:42.786 [Test worker] INFO o.s.l.d.SsDatabaseMigrater - testTargetPersistence: entered.\n18:17:43.321 [Test worker] INFO D.D.Retrieve - Object with id \"1\" not found !\n18:17:43.349 [Test worker] INFO c.c.c.l.d.DatabaseMigrater - migrateIfNeeded: localRoot='build/repo/k9794wzr-9651q-local': Migration complete!\n18:17:43.390 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:17:43.853 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n", "timestamp" : "2020-04-19T16:15:30" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.local.persistence.CollisionTest", "duration" : 1.646, "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.002, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "xorUids2", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "" } ], "duration" : 1.648, "id" : None, "name" : "org.subshare.local.persistence.CollisionTest", "stderr" : "", "stdout" : "", "timestamp" : "2020-04-19T16:15:29" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.local.sign.SignableTest", "duration" : 4.316, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "signAndSerializeAndVerify", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:15:31.844 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n18:15:33.205 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load().\n18:15:33.289 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1977 ms.\n18:15:35.287 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg\n18:15:35.289 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg\n18\n...[truncated 905 chars]...\n o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:42.507 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:42.629 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:42.752 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:42.889 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:42.984 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:43.093 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.local.sign.SignableTest", "duration" : 0.531, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "signAndModifyCryptoKeyIdAndVerify", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:15:31.844 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n18:15:33.205 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load().\n18:15:33.289 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1977 ms.\n18:15:35.287 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg\n18:15:35.289 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg\n18\n...[truncated 905 chars]...\n o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:42.507 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:42.629 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:42.752 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:42.889 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:42.984 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:43.093 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.local.sign.SignableTest", "duration" : 0.235, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "signAndVerify", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:15:31.844 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n18:15:33.205 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load().\n18:15:33.289 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1977 ms.\n18:15:35.287 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg\n18:15:35.289 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg\n18\n...[truncated 905 chars]...\n o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:42.507 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:42.629 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:42.752 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:42.889 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:42.984 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:43.093 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.local.sign.SignableTest", "duration" : 0.242, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "signAndModifySignatureCreatedAndVerify", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:15:31.844 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n18:15:33.205 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load().\n18:15:33.289 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1977 ms.\n18:15:35.287 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg\n18:15:35.289 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg\n18\n...[truncated 905 chars]...\n o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:42.507 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:42.629 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:42.752 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:42.889 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:42.984 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:43.093 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.local.sign.SignableTest", "duration" : 0.221, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "signAndModifyCryptoRepoFileIdAndVerify", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:15:31.844 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n18:15:33.205 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load().\n18:15:33.289 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1977 ms.\n18:15:35.287 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg\n18:15:35.289 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg\n18\n...[truncated 905 chars]...\n o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:42.507 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:42.629 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:42.752 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:42.889 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:42.984 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:43.093 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" } ], "duration" : 5.5450006, "id" : None, "name" : "org.subshare.local.sign.SignableTest", "stderr" : "", "stdout" : "18:15:31.844 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n18:15:33.205 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load().\n18:15:33.289 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1977 ms.\n18:15:35.287 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg\n18:15:35.289 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg\n18\n...[truncated 905 chars]...\n o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:42.507 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:42.629 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:42.752 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:42.889 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:42.984 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:15:43.093 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n", "timestamp" : "2020-04-19T16:15:37" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.local.sign.SignerVerifierStreamTest", "duration" : 18.36, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "signRsaWithSha1", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:17:50.160 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load().\n18:17:50.161 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg\n18:17:50.162 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg\n18:17:50.162 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - load: secringFile='/home/tomcat/.gnupg/secring.gpg'\n18:17:50.162 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - load: pubringFile='/home/tomcat/.gnupg/\n...[truncated 4838 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\n18:19:02.603 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:19:02.844 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:19:16.984 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.local.sign.SignerVerifierStreamTest", "duration" : 0.575, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "signAndVerifySimpleBlockRead", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:17:50.160 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load().\n18:17:50.161 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg\n18:17:50.162 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg\n18:17:50.162 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - load: secringFile='/home/tomcat/.gnupg/secring.gpg'\n18:17:50.162 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - load: pubringFile='/home/tomcat/.gnupg/\n...[truncated 4838 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\n18:19:02.603 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:19:02.844 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:19:16.984 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.local.sign.SignerVerifierStreamTest", "duration" : 21.895, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "sha1Digest", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:17:50.160 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load().\n18:17:50.161 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg\n18:17:50.162 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg\n18:17:50.162 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - load: secringFile='/home/tomcat/.gnupg/secring.gpg'\n18:17:50.162 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - load: pubringFile='/home/tomcat/.gnupg/\n...[truncated 4838 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\n18:19:02.603 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:19:02.844 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:19:16.984 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.local.sign.SignerVerifierStreamTest", "duration" : 10.771, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "signAndVerifyRandomBroken", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:17:50.160 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load().\n18:17:50.161 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg\n18:17:50.162 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg\n18:17:50.162 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - load: secringFile='/home/tomcat/.gnupg/secring.gpg'\n18:17:50.162 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - load: pubringFile='/home/tomcat/.gnupg/\n...[truncated 4838 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\n18:19:02.603 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:19:02.844 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:19:16.984 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.local.sign.SignerVerifierStreamTest", "duration" : 20.704, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "signAndVerifyRandomManySmall", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:17:50.160 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load().\n18:17:50.161 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg\n18:17:50.162 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg\n18:17:50.162 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - load: secringFile='/home/tomcat/.gnupg/secring.gpg'\n18:17:50.162 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - load: pubringFile='/home/tomcat/.gnupg/\n...[truncated 4838 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\n18:19:02.603 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:19:02.844 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:19:16.984 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.local.sign.SignerVerifierStreamTest", "duration" : 14.381, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "signAndVerifyRandom", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:17:50.160 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load().\n18:17:50.161 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg\n18:17:50.162 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg\n18:17:50.162 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - load: secringFile='/home/tomcat/.gnupg/secring.gpg'\n18:17:50.162 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - load: pubringFile='/home/tomcat/.gnupg/\n...[truncated 4838 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\n18:19:02.603 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:19:02.844 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:19:16.984 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" } ], "duration" : 86.686, "id" : None, "name" : "org.subshare.local.sign.SignerVerifierStreamTest", "stderr" : "", "stdout" : "18:17:50.160 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load().\n18:17:50.161 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg\n18:17:50.162 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg\n18:17:50.162 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - load: secringFile='/home/tomcat/.gnupg/secring.gpg'\n18:17:50.162 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - load: pubringFile='/home/tomcat/.gnupg/\n...[truncated 4838 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\n18:19:02.603 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:19:02.844 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:19:16.984 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n", "timestamp" : "2020-04-19T16:17:50" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.rest.client.transport.CryptreeRepoTransportTest", "duration" : 39.018, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "encryptAndSignAndVerifyAndDecrypt", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:20:45.413 [Test worker] INFO co.codewizards.cloudstore.core.oio.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n18:20:45.874 [Test worker] DEBUG org.subshare.core.pgp.gnupg.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load().\n18:20:45.896 [Test worker] DEBUG co.codewizards.cloudstore.core.config.ConfigImpl - getPropertyAsNonEmptyTrimmedString: System property with key='subshare.gnupg.dir' is not set (config is queried next).\n18:20:45.897 [Test worker] DEBUG co.codewizar\n...[truncated 48766 chars]...\n\n18:21:24.176 [Test worker] DEBUG co.codewizards.cloudstore.core.config.ConfigImpl - getPropertyAsNonEmptyTrimmedString: System property with key='subshare.symmetricCipherTransformation' is not set (config is queried next).\n\n18:21:24.210 [Test worker] DEBUG org.subshare.rest.client.transport.CryptreeRestRepoTransportImpl - close: There is no localRepoManager.\n18:21:24.210 [Test worker] DEBUG org.subshare.rest.client.transport.CryptreeRestRepoTransportImpl - close: There is no restRepoTransport.\n" } ], "duration" : 39.018, "id" : None, "name" : "org.subshare.rest.client.transport.CryptreeRepoTransportTest", "stderr" : "", "stdout" : "18:20:45.413 [Test worker] INFO co.codewizards.cloudstore.core.oio.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n18:20:45.874 [Test worker] DEBUG org.subshare.core.pgp.gnupg.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load().\n18:20:45.896 [Test worker] DEBUG co.codewizards.cloudstore.core.config.ConfigImpl - getPropertyAsNonEmptyTrimmedString: System property with key='subshare.gnupg.dir' is not set (config is queried next).\n18:20:45.897 [Test worker] DEBUG co.codewizar\n...[truncated 48766 chars]...\n\n18:21:24.176 [Test worker] DEBUG co.codewizards.cloudstore.core.config.ConfigImpl - getPropertyAsNonEmptyTrimmedString: System property with key='subshare.symmetricCipherTransformation' is not set (config is queried next).\n\n18:21:24.210 [Test worker] DEBUG org.subshare.rest.client.transport.CryptreeRestRepoTransportImpl - close: There is no localRepoManager.\n18:21:24.210 [Test worker] DEBUG org.subshare.rest.client.transport.CryptreeRestRepoTransportImpl - close: There is no restRepoTransport.\n", "timestamp" : "2020-04-19T16:20:45" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.BackupRestoreRepoToRepoSyncIT", "duration" : 244.941, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "backupRestoreClientRepo", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:52:40.946 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/kL7V6NCPNOlycijr4iMfsA/.subshare/ssl.client\n18:52:40.946 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/kL7V6NCPNOlycijr4iMfsA/.subshare/repoRegistry.properties\n18:52:40.946 [Test work\n...[truncated 5413741 chars]...\nynchronising...: 100.00%\n18:56:45.839 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [397ba794]getCloseDeferredMillis: closeDeferredMillis=10000\n18:56:45.839 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [397ba794]close: Deferring shut down of real LocalRepoManager 10000 ms.\n18:56:45.887 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:56:47.164 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [k7THL-bqql8NtoGeyJCQxA].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 8, "className" : "org.subshare.test.BackupRestoreRepoToRepoSyncIT", "duration" : 0.001, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 32, "name" : "backupRestoreServerRepo", "skipped" : True, "skippedMessage" : None, "status" : "SKIPPED", "stderr" : "", "stdout" : "18:52:40.946 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/kL7V6NCPNOlycijr4iMfsA/.subshare/ssl.client\n18:52:40.946 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/kL7V6NCPNOlycijr4iMfsA/.subshare/repoRegistry.properties\n18:52:40.946 [Test work\n...[truncated 5413741 chars]...\nynchronising...: 100.00%\n18:56:45.839 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [397ba794]getCloseDeferredMillis: closeDeferredMillis=10000\n18:56:45.839 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [397ba794]close: Deferring shut down of real LocalRepoManager 10000 ms.\n18:56:45.887 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:56:47.164 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [k7THL-bqql8NtoGeyJCQxA].afterClass: entered. testInstanceCounter=1\n" } ], "duration" : 244.942, "id" : None, "name" : "org.subshare.test.BackupRestoreRepoToRepoSyncIT", "stderr" : "", "stdout" : "18:52:40.946 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/kL7V6NCPNOlycijr4iMfsA/.subshare/ssl.client\n18:52:40.946 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/kL7V6NCPNOlycijr4iMfsA/.subshare/repoRegistry.properties\n18:52:40.946 [Test work\n...[truncated 5413741 chars]...\nynchronising...: 100.00%\n18:56:45.839 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [397ba794]getCloseDeferredMillis: closeDeferredMillis=10000\n18:56:45.839 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [397ba794]close: Deferring shut down of real LocalRepoManager 10000 ms.\n18:56:45.887 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:56:47.164 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [k7THL-bqql8NtoGeyJCQxA].afterClass: entered. testInstanceCounter=1\n", "timestamp" : "2020-04-19T16:52:40" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.BrokenSignatureIT", "duration" : 256.578, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "uploadBrokenSignature", "skipped" : False, "skippedMessage" : None, "status" : "FIXED", "stderr" : "", "stdout" : "18:21:43.949 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n18:21:44.177 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/1RMV_7vMR60tX2t9kquVow/.subshare/logback.client.xml\n18:21:44.197 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshar\n...[truncated 6222585 chars]...\n67 common frames omitted\n18:29:03.169 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [27fa6531]getCloseDeferredMillis: closeDeferredMillis=20000\n18:29:03.170 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [27fa6531]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:29:03.187 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:29:04.962 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [YbuAdeXEm5nIXiQuMNBu-w].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.BrokenSignatureIT", "duration" : 157.478, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "downloadBrokenSignature", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:21:43.949 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n18:21:44.177 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/1RMV_7vMR60tX2t9kquVow/.subshare/logback.client.xml\n18:21:44.197 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshar\n...[truncated 6222585 chars]...\n67 common frames omitted\n18:29:03.169 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [27fa6531]getCloseDeferredMillis: closeDeferredMillis=20000\n18:29:03.170 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [27fa6531]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:29:03.187 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:29:04.962 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [YbuAdeXEm5nIXiQuMNBu-w].afterClass: entered. testInstanceCounter=1\n" } ], "duration" : 414.056, "id" : None, "name" : "org.subshare.test.BrokenSignatureIT", "stderr" : "", "stdout" : "18:21:43.949 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n18:21:44.177 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/1RMV_7vMR60tX2t9kquVow/.subshare/logback.client.xml\n18:21:44.197 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshar\n...[truncated 6222585 chars]...\n67 common frames omitted\n18:29:03.169 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [27fa6531]getCloseDeferredMillis: closeDeferredMillis=20000\n18:29:03.170 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [27fa6531]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:29:03.187 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:29:04.962 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [YbuAdeXEm5nIXiQuMNBu-w].afterClass: entered. testInstanceCounter=1\n", "timestamp" : "2020-04-19T16:22:09" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.CollisionOnClientRepoToRepoSyncIT", "duration" : 268.987, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "newFileVsNewFileCollisionOnClient", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:46:18.722 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/mDDPsg1D_-ESlv4ZVKKSKg/.subshare/localServer.properties\n18:46:18.722 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/mDDPsg1D_-ESlv4ZVKKSKg/.subshare/ssl.client\n18:46:18.722 [Test worker] INFO \n...[truncated 32563380 chars]...\ncalRepoManager 20000 ms.\n19:04:54.876 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [59e3131d]getCloseDeferredMillis: closeDeferredMillis=20000\n19:04:54.876 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [59e3131d]close: Deferring shut down of real LocalRepoManager 20000 ms.\n19:04:54.884 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n19:04:55.777 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [REGNwo54vosW8Fo2Wgt65Q].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.CollisionOnClientRepoToRepoSyncIT", "duration" : 190.112, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "newDirectoryVsNewDirectoryCollisionOnClient", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:46:18.722 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/mDDPsg1D_-ESlv4ZVKKSKg/.subshare/localServer.properties\n18:46:18.722 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/mDDPsg1D_-ESlv4ZVKKSKg/.subshare/ssl.client\n18:46:18.722 [Test worker] INFO \n...[truncated 32563380 chars]...\ncalRepoManager 20000 ms.\n19:04:54.876 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [59e3131d]getCloseDeferredMillis: closeDeferredMillis=20000\n19:04:54.876 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [59e3131d]close: Deferring shut down of real LocalRepoManager 20000 ms.\n19:04:54.884 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n19:04:55.777 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [REGNwo54vosW8Fo2Wgt65Q].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.CollisionOnClientRepoToRepoSyncIT", "duration" : 201.688, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "modifiedFileVsDeletedFileCollisionOnClient", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:46:18.722 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/mDDPsg1D_-ESlv4ZVKKSKg/.subshare/localServer.properties\n18:46:18.722 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/mDDPsg1D_-ESlv4ZVKKSKg/.subshare/ssl.client\n18:46:18.722 [Test worker] INFO \n...[truncated 32563380 chars]...\ncalRepoManager 20000 ms.\n19:04:54.876 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [59e3131d]getCloseDeferredMillis: closeDeferredMillis=20000\n19:04:54.876 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [59e3131d]close: Deferring shut down of real LocalRepoManager 20000 ms.\n19:04:54.884 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n19:04:55.777 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [REGNwo54vosW8Fo2Wgt65Q].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.CollisionOnClientRepoToRepoSyncIT", "duration" : 191.484, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "modifiedFileVsModifiedFileCollisionOnClient", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:46:18.722 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/mDDPsg1D_-ESlv4ZVKKSKg/.subshare/localServer.properties\n18:46:18.722 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/mDDPsg1D_-ESlv4ZVKKSKg/.subshare/ssl.client\n18:46:18.722 [Test worker] INFO \n...[truncated 32563380 chars]...\ncalRepoManager 20000 ms.\n19:04:54.876 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [59e3131d]getCloseDeferredMillis: closeDeferredMillis=20000\n19:04:54.876 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [59e3131d]close: Deferring shut down of real LocalRepoManager 20000 ms.\n19:04:54.884 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n19:04:55.777 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [REGNwo54vosW8Fo2Wgt65Q].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.CollisionOnClientRepoToRepoSyncIT", "duration" : 142.301, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "deletedFileVsModifiedFileCollisionOnClient", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:46:18.722 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/mDDPsg1D_-ESlv4ZVKKSKg/.subshare/localServer.properties\n18:46:18.722 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/mDDPsg1D_-ESlv4ZVKKSKg/.subshare/ssl.client\n18:46:18.722 [Test worker] INFO \n...[truncated 32563380 chars]...\ncalRepoManager 20000 ms.\n19:04:54.876 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [59e3131d]getCloseDeferredMillis: closeDeferredMillis=20000\n19:04:54.876 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [59e3131d]close: Deferring shut down of real LocalRepoManager 20000 ms.\n19:04:54.884 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n19:04:55.777 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [REGNwo54vosW8Fo2Wgt65Q].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.CollisionOnClientRepoToRepoSyncIT", "duration" : 121.587, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "newFileVsNewDirectoryCollisionOnClient", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:46:18.722 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/mDDPsg1D_-ESlv4ZVKKSKg/.subshare/localServer.properties\n18:46:18.722 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/mDDPsg1D_-ESlv4ZVKKSKg/.subshare/ssl.client\n18:46:18.722 [Test worker] INFO \n...[truncated 32563380 chars]...\ncalRepoManager 20000 ms.\n19:04:54.876 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [59e3131d]getCloseDeferredMillis: closeDeferredMillis=20000\n19:04:54.876 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [59e3131d]close: Deferring shut down of real LocalRepoManager 20000 ms.\n19:04:54.884 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n19:04:55.777 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [REGNwo54vosW8Fo2Wgt65Q].afterClass: entered. testInstanceCounter=1\n" } ], "duration" : 1116.159, "id" : None, "name" : "org.subshare.test.CollisionOnClientRepoToRepoSyncIT", "stderr" : "", "stdout" : "18:46:18.722 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/mDDPsg1D_-ESlv4ZVKKSKg/.subshare/localServer.properties\n18:46:18.722 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/mDDPsg1D_-ESlv4ZVKKSKg/.subshare/ssl.client\n18:46:18.722 [Test worker] INFO \n...[truncated 32563380 chars]...\ncalRepoManager 20000 ms.\n19:04:54.876 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [59e3131d]getCloseDeferredMillis: closeDeferredMillis=20000\n19:04:54.876 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [59e3131d]close: Deferring shut down of real LocalRepoManager 20000 ms.\n19:04:54.884 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n19:04:55.777 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [REGNwo54vosW8Fo2Wgt65Q].afterClass: entered. testInstanceCounter=1\n", "timestamp" : "2020-04-19T16:46:18" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.CollisionOnServerRepoToRepoSyncIT", "duration" : 462.413, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "newFileVsNewFileUploadedCollisionOnServer", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:21:43.959 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n18:21:44.367 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/ianvza_gNjGmaNW-ikFkow/.subshare/logback.client.xml\n18:21:44.380 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshar\n...[truncated 17027993 chars]...\ncalRepoManager 20000 ms.\n18:42:19.252 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5d4972ae]getCloseDeferredMillis: closeDeferredMillis=20000\n18:42:19.252 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5d4972ae]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:42:19.256 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:42:20.572 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [pzO8IDJNh0bKsMHDJA_rQw].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.CollisionOnServerRepoToRepoSyncIT", "duration" : 717.992, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "newFileVsNewFileUploadingCollisionOnServer", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:21:43.959 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n18:21:44.367 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/ianvza_gNjGmaNW-ikFkow/.subshare/logback.client.xml\n18:21:44.380 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshar\n...[truncated 17027993 chars]...\ncalRepoManager 20000 ms.\n18:42:19.252 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5d4972ae]getCloseDeferredMillis: closeDeferredMillis=20000\n18:42:19.252 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5d4972ae]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:42:19.256 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:42:20.572 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [pzO8IDJNh0bKsMHDJA_rQw].afterClass: entered. testInstanceCounter=1\n" } ], "duration" : 1180.405, "id" : None, "name" : "org.subshare.test.CollisionOnServerRepoToRepoSyncIT", "stderr" : "", "stdout" : "18:21:43.959 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n18:21:44.367 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/ianvza_gNjGmaNW-ikFkow/.subshare/logback.client.xml\n18:21:44.380 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshar\n...[truncated 17027993 chars]...\ncalRepoManager 20000 ms.\n18:42:19.252 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5d4972ae]getCloseDeferredMillis: closeDeferredMillis=20000\n18:42:19.252 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5d4972ae]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:42:19.256 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:42:20.572 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [pzO8IDJNh0bKsMHDJA_rQw].afterClass: entered. testInstanceCounter=1\n", "timestamp" : "2020-04-19T16:22:38" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.IgnoreRuleRepoToRepoSyncIT", "duration" : 429.385, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "ignoreRulesAddedAfterFilesSynced", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:21:43.771 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n18:21:44.221 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/mDDPsg1D_-ESlv4ZVKKSKg/.subshare/logback.client.xml\n18:21:44.269 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshar\n...[truncated 18363004 chars]...\nLocalRepoManager 20000 ms.\n18:37:49.046 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [99dc11d]getCloseDeferredMillis: closeDeferredMillis=20000\n18:37:49.046 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [99dc11d]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:37:49.046 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:37:50.169 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [REGNwo54vosW8Fo2Wgt65Q].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.IgnoreRuleRepoToRepoSyncIT", "duration" : 275.474, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "ignoreRulesBecomeDisabled", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:21:43.771 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n18:21:44.221 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/mDDPsg1D_-ESlv4ZVKKSKg/.subshare/logback.client.xml\n18:21:44.269 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshar\n...[truncated 18363004 chars]...\nLocalRepoManager 20000 ms.\n18:37:49.046 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [99dc11d]getCloseDeferredMillis: closeDeferredMillis=20000\n18:37:49.046 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [99dc11d]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:37:49.046 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:37:50.169 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [REGNwo54vosW8Fo2Wgt65Q].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.IgnoreRuleRepoToRepoSyncIT", "duration" : 236.754, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "ignoreRulesExistBeforeAffectedFiles", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:21:43.771 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n18:21:44.221 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/mDDPsg1D_-ESlv4ZVKKSKg/.subshare/logback.client.xml\n18:21:44.269 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshar\n...[truncated 18363004 chars]...\nLocalRepoManager 20000 ms.\n18:37:49.046 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [99dc11d]getCloseDeferredMillis: closeDeferredMillis=20000\n18:37:49.046 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [99dc11d]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:37:49.046 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:37:50.169 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [REGNwo54vosW8Fo2Wgt65Q].afterClass: entered. testInstanceCounter=1\n" } ], "duration" : 941.61304, "id" : None, "name" : "org.subshare.test.IgnoreRuleRepoToRepoSyncIT", "stderr" : "", "stdout" : "18:21:43.771 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n18:21:44.221 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/mDDPsg1D_-ESlv4ZVKKSKg/.subshare/logback.client.xml\n18:21:44.269 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshar\n...[truncated 18363004 chars]...\nLocalRepoManager 20000 ms.\n18:37:49.046 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [99dc11d]getCloseDeferredMillis: closeDeferredMillis=20000\n18:37:49.046 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [99dc11d]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:37:49.046 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:37:50.169 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [REGNwo54vosW8Fo2Wgt65Q].afterClass: entered. testInstanceCounter=1\n", "timestamp" : "2020-04-19T16:22:07" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.InterruptedRepoToRepoSyncIT", "duration" : 175.788, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "interruptSyncDownAndResume", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:42:20.594 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/ianvza_gNjGmaNW-ikFkow/.subshare/localServer.properties\n18:42:20.595 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/ianvza_gNjGmaNW-ikFkow/.subshare/ssl.client\n18:42:20.595 [Test worker] INFO \n...[truncated 9067700 chars]...\nl LocalRepoManager 20000 ms.\n18:48:21.329 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [238453]getCloseDeferredMillis: closeDeferredMillis=20000\n18:48:21.329 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [238453]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:48:21.329 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:48:22.224 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [pzO8IDJNh0bKsMHDJA_rQw].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.InterruptedRepoToRepoSyncIT", "duration" : 184.943, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "interruptSyncUpAndResume", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:42:20.594 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/ianvza_gNjGmaNW-ikFkow/.subshare/localServer.properties\n18:42:20.595 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/ianvza_gNjGmaNW-ikFkow/.subshare/ssl.client\n18:42:20.595 [Test worker] INFO \n...[truncated 9067700 chars]...\nl LocalRepoManager 20000 ms.\n18:48:21.329 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [238453]getCloseDeferredMillis: closeDeferredMillis=20000\n18:48:21.329 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [238453]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:48:21.329 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:48:22.224 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [pzO8IDJNh0bKsMHDJA_rQw].afterClass: entered. testInstanceCounter=1\n" } ], "duration" : 360.731, "id" : None, "name" : "org.subshare.test.InterruptedRepoToRepoSyncIT", "stderr" : "", "stdout" : "18:42:20.594 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/ianvza_gNjGmaNW-ikFkow/.subshare/localServer.properties\n18:42:20.595 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/ianvza_gNjGmaNW-ikFkow/.subshare/ssl.client\n18:42:20.595 [Test worker] INFO \n...[truncated 9067700 chars]...\nl LocalRepoManager 20000 ms.\n18:48:21.329 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [238453]getCloseDeferredMillis: closeDeferredMillis=20000\n18:48:21.329 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [238453]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:48:21.329 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:48:22.224 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [pzO8IDJNh0bKsMHDJA_rQw].afterClass: entered. testInstanceCounter=1\n", "timestamp" : "2020-04-19T16:42:20" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.InviteUserAndSyncIT", "duration" : 200.662, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "inviteUserAndSync_singleReadPermissionOnSubdir", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:50:49.437 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/VoVRLph-XDw90A37LNRotg/.subshare/ssl.client\n18:50:49.438 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/VoVRLph-XDw90A37LNRotg/.subshare/serverRepoRegistry.subshare\n18:50:49.438 [Test \n...[truncated 16361097 chars]...\ncalRepoManager 20000 ms.\n19:01:27.334 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [311f5afe]getCloseDeferredMillis: closeDeferredMillis=20000\n19:01:27.334 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [311f5afe]close: Deferring shut down of real LocalRepoManager 20000 ms.\n19:01:27.344 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n19:01:27.939 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [63iicalqht4nsyjQTlVpaw].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.InviteUserAndSyncIT", "duration" : 261.421, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "inviteUserAndSync_singleWritePermissionOnRoot", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:50:49.437 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/VoVRLph-XDw90A37LNRotg/.subshare/ssl.client\n18:50:49.438 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/VoVRLph-XDw90A37LNRotg/.subshare/serverRepoRegistry.subshare\n18:50:49.438 [Test \n...[truncated 16361097 chars]...\ncalRepoManager 20000 ms.\n19:01:27.334 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [311f5afe]getCloseDeferredMillis: closeDeferredMillis=20000\n19:01:27.334 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [311f5afe]close: Deferring shut down of real LocalRepoManager 20000 ms.\n19:01:27.344 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n19:01:27.939 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [63iicalqht4nsyjQTlVpaw].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.InviteUserAndSyncIT", "duration" : 175.824, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "inviteUserAndSync_singleReadPermissionOnRoot", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:50:49.437 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/VoVRLph-XDw90A37LNRotg/.subshare/ssl.client\n18:50:49.438 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/VoVRLph-XDw90A37LNRotg/.subshare/serverRepoRegistry.subshare\n18:50:49.438 [Test \n...[truncated 16361097 chars]...\ncalRepoManager 20000 ms.\n19:01:27.334 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [311f5afe]getCloseDeferredMillis: closeDeferredMillis=20000\n19:01:27.334 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [311f5afe]close: Deferring shut down of real LocalRepoManager 20000 ms.\n19:01:27.344 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n19:01:27.939 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [63iicalqht4nsyjQTlVpaw].afterClass: entered. testInstanceCounter=1\n" } ], "duration" : 637.907, "id" : None, "name" : "org.subshare.test.InviteUserAndSyncIT", "stderr" : "", "stdout" : "18:50:49.437 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/VoVRLph-XDw90A37LNRotg/.subshare/ssl.client\n18:50:49.438 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/VoVRLph-XDw90A37LNRotg/.subshare/serverRepoRegistry.subshare\n18:50:49.438 [Test \n...[truncated 16361097 chars]...\ncalRepoManager 20000 ms.\n19:01:27.334 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [311f5afe]getCloseDeferredMillis: closeDeferredMillis=20000\n19:01:27.334 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [311f5afe]close: Deferring shut down of real LocalRepoManager 20000 ms.\n19:01:27.344 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n19:01:27.939 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [63iicalqht4nsyjQTlVpaw].afterClass: entered. testInstanceCounter=1\n", "timestamp" : "2020-04-19T16:50:49" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.InviteUserWithNormalAndMetaOnlyRepoIT", "duration" : 317.588, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "inviteUserAndSync_withMetaOnly_singleWritePermissionOnRoot", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:33:45.131 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/kL7V6NCPNOlycijr4iMfsA/.subshare/localServer.properties\n18:33:45.132 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/kL7V6NCPNOlycijr4iMfsA/.subshare/ssl.client\n18:33:45.132 [Test worker] INFO \n...[truncated 6929915 chars]...\ncalRepoManager 20000 ms.\n18:39:02.722 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4025ffd3]getCloseDeferredMillis: closeDeferredMillis=20000\n18:39:02.722 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4025ffd3]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:39:02.723 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:39:03.314 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [k7THL-bqql8NtoGeyJCQxA].afterClass: entered. testInstanceCounter=1\n" } ], "duration" : 317.588, "id" : None, "name" : "org.subshare.test.InviteUserWithNormalAndMetaOnlyRepoIT", "stderr" : "", "stdout" : "18:33:45.131 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/kL7V6NCPNOlycijr4iMfsA/.subshare/localServer.properties\n18:33:45.132 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/kL7V6NCPNOlycijr4iMfsA/.subshare/ssl.client\n18:33:45.132 [Test worker] INFO \n...[truncated 6929915 chars]...\ncalRepoManager 20000 ms.\n18:39:02.722 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4025ffd3]getCloseDeferredMillis: closeDeferredMillis=20000\n18:39:02.722 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4025ffd3]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:39:02.723 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:39:03.314 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [k7THL-bqql8NtoGeyJCQxA].afterClass: entered. testInstanceCounter=1\n", "timestamp" : "2020-04-19T16:33:45" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.Issue4IT", "duration" : 139.17, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "issue_4_syncFileDeletedAfterLocalSync", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:29:04.993 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/1RMV_7vMR60tX2t9kquVow/.subshare/localServer.properties\n18:29:04.994 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/1RMV_7vMR60tX2t9kquVow/.subshare/ssl.client\n18:29:04.994 [Test worker] INFO \n...[truncated 2959471 chars]...\nynchronising...: 100.00%\n18:31:24.163 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [760dabd9]getCloseDeferredMillis: closeDeferredMillis=20000\n18:31:24.163 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [760dabd9]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:31:24.167 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:31:25.439 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [YbuAdeXEm5nIXiQuMNBu-w].afterClass: entered. testInstanceCounter=1\n" } ], "duration" : 139.17, "id" : None, "name" : "org.subshare.test.Issue4IT", "stderr" : "", "stdout" : "18:29:04.993 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/1RMV_7vMR60tX2t9kquVow/.subshare/localServer.properties\n18:29:04.994 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/1RMV_7vMR60tX2t9kquVow/.subshare/ssl.client\n18:29:04.994 [Test worker] INFO \n...[truncated 2959471 chars]...\nynchronising...: 100.00%\n18:31:24.163 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [760dabd9]getCloseDeferredMillis: closeDeferredMillis=20000\n18:31:24.163 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [760dabd9]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:31:24.167 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:31:25.439 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [YbuAdeXEm5nIXiQuMNBu-w].afterClass: entered. testInstanceCounter=1\n", "timestamp" : "2020-04-19T16:29:04" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.Issue5IT", "duration" : 542.097, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "issue_5_inviteMultipleFriends", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:21:43.870 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n18:21:44.319 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/VoVRLph-XDw90A37LNRotg/.subshare/logback.client.xml\n18:21:44.357 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshar\n...[truncated 8752587 chars]...\ncalRepoManager 20000 ms.\n18:31:19.122 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [7f088eb0]getCloseDeferredMillis: closeDeferredMillis=20000\n18:31:19.122 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [7f088eb0]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:31:19.123 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:31:19.676 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [63iicalqht4nsyjQTlVpaw].afterClass: entered. testInstanceCounter=1\n" } ], "duration" : 542.097, "id" : None, "name" : "org.subshare.test.Issue5IT", "stderr" : "", "stdout" : "18:21:43.870 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n18:21:44.319 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/VoVRLph-XDw90A37LNRotg/.subshare/logback.client.xml\n18:21:44.357 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshar\n...[truncated 8752587 chars]...\ncalRepoManager 20000 ms.\n18:31:19.122 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [7f088eb0]getCloseDeferredMillis: closeDeferredMillis=20000\n18:31:19.122 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [7f088eb0]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:31:19.123 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:31:19.676 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [63iicalqht4nsyjQTlVpaw].afterClass: entered. testInstanceCounter=1\n", "timestamp" : "2020-04-19T16:22:17" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.Issue8IT", "duration" : 504.428, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "issue_8_threesomeWithFreshmen", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:37:50.220 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/mDDPsg1D_-ESlv4ZVKKSKg/.subshare/localServer.properties\n18:37:50.220 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/mDDPsg1D_-ESlv4ZVKKSKg/.subshare/ssl.client\n18:37:50.221 [Test worker] INFO \n...[truncated 12106282 chars]...\n - SELECT \"a0\".\"changed\",\"a0\".\"created\",\"a0\".\"id\",\"a0\".\"repositoryid\",\"a0\".\"revision\",\"a0\".\"discriminator\" FROM \"repository\" \"a0\" WHERE (\"a0\".\"discriminator\" = 'LocalRepository' OR \"a0\".\"discriminator\" = 'SsLocalRepository')\n18:46:14.648 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [1a6df57d]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:46:18.697 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [REGNwo54vosW8Fo2Wgt65Q].afterClass: entered. testInstanceCounter=1\n" } ], "duration" : 504.428, "id" : None, "name" : "org.subshare.test.Issue8IT", "stderr" : "", "stdout" : "18:37:50.220 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/mDDPsg1D_-ESlv4ZVKKSKg/.subshare/localServer.properties\n18:37:50.220 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/mDDPsg1D_-ESlv4ZVKKSKg/.subshare/ssl.client\n18:37:50.221 [Test worker] INFO \n...[truncated 12106282 chars]...\n - SELECT \"a0\".\"changed\",\"a0\".\"created\",\"a0\".\"id\",\"a0\".\"repositoryid\",\"a0\".\"revision\",\"a0\".\"discriminator\" FROM \"repository\" \"a0\" WHERE (\"a0\".\"discriminator\" = 'LocalRepository' OR \"a0\".\"discriminator\" = 'SsLocalRepository')\n18:46:14.648 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [1a6df57d]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:46:18.697 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [REGNwo54vosW8Fo2Wgt65Q].afterClass: entered. testInstanceCounter=1\n", "timestamp" : "2020-04-19T16:37:50" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.LocalServerClientIT", "duration" : 0.842, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "invokeSimpleStaticMethod", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:31:19.721 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [63iicalqht4nsyjQTlVpaw].beforeClass: entered. testInstanceCounter=1\n18:31:20.131 [Test worker] INFO c.c.c.l.s.LocalServer - logMemoryStats: max=512.0 MiB, allocated=270.0 MiB, used=155.8 MiB, available=356.2 MiB\n18:31:21.140 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:31:21.964 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:31:22.492 [Test worker] INFO o.s.c.p.PgpRegistry - clearCac\n...[truncated 65000 chars]...\ner(ThreadPoolExecutor.java:1128)\n\tat java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)\n\tat org.gradle.internal.concurrent.ThreadFactoryImpl$ManagedThreadRunnable.run(ThreadFactoryImpl.java:56)\n\tat java.base/java.lang.Thread.run(Thread.java:834)\n18:31:25.986 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:31:36.874 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [63iicalqht4nsyjQTlVpaw].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.LocalServerClientIT", "duration" : 4.021, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "invokeDeniedMethods", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:31:19.721 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [63iicalqht4nsyjQTlVpaw].beforeClass: entered. testInstanceCounter=1\n18:31:20.131 [Test worker] INFO c.c.c.l.s.LocalServer - logMemoryStats: max=512.0 MiB, allocated=270.0 MiB, used=155.8 MiB, available=356.2 MiB\n18:31:21.140 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:31:21.964 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:31:22.492 [Test worker] INFO o.s.c.p.PgpRegistry - clearCac\n...[truncated 65000 chars]...\ner(ThreadPoolExecutor.java:1128)\n\tat java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)\n\tat org.gradle.internal.concurrent.ThreadFactoryImpl$ManagedThreadRunnable.run(ThreadFactoryImpl.java:56)\n\tat java.base/java.lang.Thread.run(Thread.java:834)\n18:31:25.986 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:31:36.874 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [63iicalqht4nsyjQTlVpaw].afterClass: entered. testInstanceCounter=1\n" } ], "duration" : 4.863, "id" : None, "name" : "org.subshare.test.LocalServerClientIT", "stderr" : "", "stdout" : "18:31:19.721 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [63iicalqht4nsyjQTlVpaw].beforeClass: entered. testInstanceCounter=1\n18:31:20.131 [Test worker] INFO c.c.c.l.s.LocalServer - logMemoryStats: max=512.0 MiB, allocated=270.0 MiB, used=155.8 MiB, available=356.2 MiB\n18:31:21.140 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:31:21.964 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:31:22.492 [Test worker] INFO o.s.c.p.PgpRegistry - clearCac\n...[truncated 65000 chars]...\ner(ThreadPoolExecutor.java:1128)\n\tat java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)\n\tat org.gradle.internal.concurrent.ThreadFactoryImpl$ManagedThreadRunnable.run(ThreadFactoryImpl.java:56)\n\tat java.base/java.lang.Thread.run(Thread.java:834)\n18:31:25.986 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:31:36.874 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [63iicalqht4nsyjQTlVpaw].afterClass: entered. testInstanceCounter=1\n", "timestamp" : "2020-04-19T16:31:21" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.LockerSyncIT", "duration" : 20.525, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncServerRegistry", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:50:11.623 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/VoVRLph-XDw90A37LNRotg/.subshare/ssl.client\n18:50:11.623 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/VoVRLph-XDw90A37LNRotg/.subshare/repoRegistry.properties\n18:50:11.624 [Test work\n...[truncated 182037 chars]...\neyIds=[a58da7d810b74edf]\n18:50:46.007 [Test worker] DEBUG o.s.c.p.g.BcPgpDecoder - verifySignature: signingPgpKeyIds=[d7a92a24aa97ddbd]\n18:50:47.861 [Timer-3] DEBUG c.c.c.r.c.CloudStoreRestClient - execute: starting try 3 of 3\n18:50:47.862 [Timer-3] DEBUG c.c.c.r.c.CloudStoreRestClient - determineBaseUrl: hostURL='https://server1.domain.tld:12345/': entered.\n18:50:49.356 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [63iicalqht4nsyjQTlVpaw].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.LockerSyncIT", "duration" : 13.924, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncUserRegistry", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:50:11.623 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/VoVRLph-XDw90A37LNRotg/.subshare/ssl.client\n18:50:11.623 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/VoVRLph-XDw90A37LNRotg/.subshare/repoRegistry.properties\n18:50:11.624 [Test work\n...[truncated 182037 chars]...\neyIds=[a58da7d810b74edf]\n18:50:46.007 [Test worker] DEBUG o.s.c.p.g.BcPgpDecoder - verifySignature: signingPgpKeyIds=[d7a92a24aa97ddbd]\n18:50:47.861 [Timer-3] DEBUG c.c.c.r.c.CloudStoreRestClient - execute: starting try 3 of 3\n18:50:47.862 [Timer-3] DEBUG c.c.c.r.c.CloudStoreRestClient - determineBaseUrl: hostURL='https://server1.domain.tld:12345/': entered.\n18:50:49.356 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [63iicalqht4nsyjQTlVpaw].afterClass: entered. testInstanceCounter=1\n" } ], "duration" : 34.448997, "id" : None, "name" : "org.subshare.test.LockerSyncIT", "stderr" : "", "stdout" : "18:50:11.623 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/VoVRLph-XDw90A37LNRotg/.subshare/ssl.client\n18:50:11.623 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/VoVRLph-XDw90A37LNRotg/.subshare/repoRegistry.properties\n18:50:11.624 [Test work\n...[truncated 182037 chars]...\neyIds=[a58da7d810b74edf]\n18:50:46.007 [Test worker] DEBUG o.s.c.p.g.BcPgpDecoder - verifySignature: signingPgpKeyIds=[d7a92a24aa97ddbd]\n18:50:47.861 [Timer-3] DEBUG c.c.c.r.c.CloudStoreRestClient - execute: starting try 3 of 3\n18:50:47.862 [Timer-3] DEBUG c.c.c.r.c.CloudStoreRestClient - determineBaseUrl: hostURL='https://server1.domain.tld:12345/': entered.\n18:50:49.356 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [63iicalqht4nsyjQTlVpaw].afterClass: entered. testInstanceCounter=1\n", "timestamp" : "2020-04-19T16:50:11" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.MetaOnlyRepoSyncIT", "duration" : 345.205, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncFromLocalToRemoteToMetaOnlyAddingFiles", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:21:42.747 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n18:21:43.176 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/kL7V6NCPNOlycijr4iMfsA/.subshare/logback.client.xml\n18:21:43.201 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshar\n...[truncated 11524362 chars]...\ncalRepoManager 20000 ms.\n18:33:43.716 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [36653864]getCloseDeferredMillis: closeDeferredMillis=20000\n18:33:43.716 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [36653864]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:33:43.717 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:33:45.085 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [k7THL-bqql8NtoGeyJCQxA].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.MetaOnlyRepoSyncIT", "duration" : 158.824, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncFromLocalToRemoteToMetaOnly", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:21:42.747 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n18:21:43.176 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/kL7V6NCPNOlycijr4iMfsA/.subshare/logback.client.xml\n18:21:43.201 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshar\n...[truncated 11524362 chars]...\ncalRepoManager 20000 ms.\n18:33:43.716 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [36653864]getCloseDeferredMillis: closeDeferredMillis=20000\n18:33:43.716 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [36653864]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:33:43.717 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:33:45.085 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [k7THL-bqql8NtoGeyJCQxA].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.MetaOnlyRepoSyncIT", "duration" : 186.355, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncFromLocalToRemoteToMetaOnlyRemovingFiles", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:21:42.747 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n18:21:43.176 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/kL7V6NCPNOlycijr4iMfsA/.subshare/logback.client.xml\n18:21:43.201 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshar\n...[truncated 11524362 chars]...\ncalRepoManager 20000 ms.\n18:33:43.716 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [36653864]getCloseDeferredMillis: closeDeferredMillis=20000\n18:33:43.716 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [36653864]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:33:43.717 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:33:45.085 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [k7THL-bqql8NtoGeyJCQxA].afterClass: entered. testInstanceCounter=1\n" } ], "duration" : 690.384, "id" : None, "name" : "org.subshare.test.MetaOnlyRepoSyncIT", "stderr" : "", "stdout" : "18:21:42.747 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n18:21:43.176 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/kL7V6NCPNOlycijr4iMfsA/.subshare/logback.client.xml\n18:21:43.201 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshar\n...[truncated 11524362 chars]...\ncalRepoManager 20000 ms.\n18:33:43.716 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [36653864]getCloseDeferredMillis: closeDeferredMillis=20000\n18:33:43.716 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [36653864]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:33:43.717 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:33:45.085 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [k7THL-bqql8NtoGeyJCQxA].afterClass: entered. testInstanceCounter=1\n", "timestamp" : "2020-04-19T16:22:13" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.MultiplePgpKeysSingleUserRegistryIT", "duration" : 3.512, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "multiplePgpKeysSingleUserRegistry", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "19:09:07.609 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/ianvza_gNjGmaNW-ikFkow/.subshare/localServer.properties\n19:09:07.610 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/ianvza_gNjGmaNW-ikFkow/.subshare/ssl.client\n19:09:07.610 [Test worker] INFO \n...[truncated 4286 chars]...\nrRepoKey: pgpKey=PgpKey[bbef20af171556db, [Alexander Bieber (TEST) ]], userRepoKey=UserRepoKeyImpl[userRepoKeyId=Tpv7aiuHu6ccDsbRivoHjg, invitation=false]\n19:09:11.051 [Test worker] DEBUG o.s.c.p.g.BcPgpDecoder - verifySignature: signingPgpKeyIds=[d7a92a24aa97ddbd]\n19:09:11.122 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n19:09:11.561 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [pzO8IDJNh0bKsMHDJA_rQw].afterClass: entered. testInstanceCounter=1\n" } ], "duration" : 3.512, "id" : None, "name" : "org.subshare.test.MultiplePgpKeysSingleUserRegistryIT", "stderr" : "", "stdout" : "19:09:07.609 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/ianvza_gNjGmaNW-ikFkow/.subshare/localServer.properties\n19:09:07.610 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/ianvza_gNjGmaNW-ikFkow/.subshare/ssl.client\n19:09:07.610 [Test worker] INFO \n...[truncated 4286 chars]...\nrRepoKey: pgpKey=PgpKey[bbef20af171556db, [Alexander Bieber (TEST) ]], userRepoKey=UserRepoKeyImpl[userRepoKeyId=Tpv7aiuHu6ccDsbRivoHjg, invitation=false]\n19:09:11.051 [Test worker] DEBUG o.s.c.p.g.BcPgpDecoder - verifySignature: signingPgpKeyIds=[d7a92a24aa97ddbd]\n19:09:11.122 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n19:09:11.561 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [pzO8IDJNh0bKsMHDJA_rQw].afterClass: entered. testInstanceCounter=1\n", "timestamp" : "2020-04-19T17:09:07" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.PathPrefixedConfigInheritanceRepoToRepoSyncIT", "duration" : 277.522, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "parentConfigWithRemotePathPrefix", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:31:25.453 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/1RMV_7vMR60tX2t9kquVow/.subshare/localServer.properties\n18:31:25.454 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/1RMV_7vMR60tX2t9kquVow/.subshare/ssl.client\n18:31:25.454 [Test worker] INFO \n...[truncated 8101763 chars]...\ncalRepoManager 20000 ms.\n18:36:02.974 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4969d8d9]getCloseDeferredMillis: closeDeferredMillis=20000\n18:36:02.975 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4969d8d9]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:36:02.977 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:36:03.846 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [YbuAdeXEm5nIXiQuMNBu-w].afterClass: entered. testInstanceCounter=1\n" } ], "duration" : 277.522, "id" : None, "name" : "org.subshare.test.PathPrefixedConfigInheritanceRepoToRepoSyncIT", "stderr" : "", "stdout" : "18:31:25.453 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/1RMV_7vMR60tX2t9kquVow/.subshare/localServer.properties\n18:31:25.454 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/1RMV_7vMR60tX2t9kquVow/.subshare/ssl.client\n18:31:25.454 [Test worker] INFO \n...[truncated 8101763 chars]...\ncalRepoManager 20000 ms.\n18:36:02.974 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4969d8d9]getCloseDeferredMillis: closeDeferredMillis=20000\n18:36:02.975 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4969d8d9]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:36:02.977 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:36:03.846 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [YbuAdeXEm5nIXiQuMNBu-w].afterClass: entered. testInstanceCounter=1\n", "timestamp" : "2020-04-19T16:31:25" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.PermissionIT", "duration" : 202.713, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "interruptPermissionSetInheritance", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:39:03.368 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [k7THL-bqql8NtoGeyJCQxA].beforeClass: entered. testInstanceCounter=1\n18:39:03.384 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:39:04.646 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5c010032]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/repo/k979z6wz-pje60-local-src'\n18:39:04.652 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5c010\n...[truncated 21066263 chars]...\ncalRepoManager 20000 ms.\n18:52:39.822 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [7f5cdc86]getCloseDeferredMillis: closeDeferredMillis=20000\n18:52:39.822 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [7f5cdc86]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:52:39.823 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:52:40.926 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [k7THL-bqql8NtoGeyJCQxA].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.PermissionIT", "duration" : 299.617, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "uploadBackdatedSignature", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:39:03.368 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [k7THL-bqql8NtoGeyJCQxA].beforeClass: entered. testInstanceCounter=1\n18:39:03.384 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:39:04.646 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5c010032]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/repo/k979z6wz-pje60-local-src'\n18:39:04.652 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5c010\n...[truncated 21066263 chars]...\ncalRepoManager 20000 ms.\n18:52:39.822 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [7f5cdc86]getCloseDeferredMillis: closeDeferredMillis=20000\n18:52:39.822 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [7f5cdc86]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:52:39.823 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:52:40.926 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [k7THL-bqql8NtoGeyJCQxA].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.PermissionIT", "duration" : 314.124, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "nonOwnerAdminGrantsWritePermission", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:39:03.368 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [k7THL-bqql8NtoGeyJCQxA].beforeClass: entered. testInstanceCounter=1\n18:39:03.384 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:39:04.646 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5c010032]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/repo/k979z6wz-pje60-local-src'\n18:39:04.652 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5c010\n...[truncated 21066263 chars]...\ncalRepoManager 20000 ms.\n18:52:39.822 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [7f5cdc86]getCloseDeferredMillis: closeDeferredMillis=20000\n18:52:39.822 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [7f5cdc86]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:52:39.823 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:52:40.926 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [k7THL-bqql8NtoGeyJCQxA].afterClass: entered. testInstanceCounter=1\n" } ], "duration" : 816.454, "id" : None, "name" : "org.subshare.test.PermissionIT", "stderr" : "", "stdout" : "18:39:03.368 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [k7THL-bqql8NtoGeyJCQxA].beforeClass: entered. testInstanceCounter=1\n18:39:03.384 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:39:04.646 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5c010032]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/repo/k979z6wz-pje60-local-src'\n18:39:04.652 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5c010\n...[truncated 21066263 chars]...\ncalRepoManager 20000 ms.\n18:52:39.822 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [7f5cdc86]getCloseDeferredMillis: closeDeferredMillis=20000\n18:52:39.822 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [7f5cdc86]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:52:39.823 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:52:40.926 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [k7THL-bqql8NtoGeyJCQxA].afterClass: entered. testInstanceCounter=1\n", "timestamp" : "2020-04-19T16:39:03" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.PgpSyncIT", "duration" : 2.833, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "testPgpSync", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "19:04:55.813 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/mDDPsg1D_-ESlv4ZVKKSKg/.subshare/localServer.properties\n19:04:55.813 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/mDDPsg1D_-ESlv4ZVKKSKg/.subshare/ssl.client\n19:04:55.813 [Test worker] INFO \n...[truncated 3206 chars]...\n05:00.070 [Test worker] DEBUG c.c.c.r.c.CloudStoreRestClient - execute: invocation took 9 ms\n19:05:00.071 [Test worker] DEBUG c.c.c.r.c.CloudStoreRestClient - execute: starting try 1 of 3\n19:05:00.098 [Test worker] DEBUG c.c.c.r.c.CloudStoreRestClient - execute: invocation took 27 ms\n19:05:00.143 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n19:05:00.622 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [REGNwo54vosW8Fo2Wgt65Q].afterClass: entered. testInstanceCounter=1\n" } ], "duration" : 2.833, "id" : None, "name" : "org.subshare.test.PgpSyncIT", "stderr" : "", "stdout" : "19:04:55.813 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/mDDPsg1D_-ESlv4ZVKKSKg/.subshare/localServer.properties\n19:04:55.813 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/mDDPsg1D_-ESlv4ZVKKSKg/.subshare/ssl.client\n19:04:55.813 [Test worker] INFO \n...[truncated 3206 chars]...\n05:00.070 [Test worker] DEBUG c.c.c.r.c.CloudStoreRestClient - execute: invocation took 9 ms\n19:05:00.071 [Test worker] DEBUG c.c.c.r.c.CloudStoreRestClient - execute: starting try 1 of 3\n19:05:00.098 [Test worker] DEBUG c.c.c.r.c.CloudStoreRestClient - execute: invocation took 27 ms\n19:05:00.143 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n19:05:00.622 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [REGNwo54vosW8Fo2Wgt65Q].afterClass: entered. testInstanceCounter=1\n", "timestamp" : "2020-04-19T17:04:57" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.PostgresqlRepoToRepoSyncIT", "duration" : 158.271, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncFromLocalToRemoteToLocalAfterCreateAndDeleteFile", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:31:37.555 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [63iicalqht4nsyjQTlVpaw].beforeClass: entered. testInstanceCounter=1\n18:31:37.568 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n18:31:37.580 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:31:39.243 [closeDeferredTimer-7f088eb0-1] INFO c.c.c.l.LocalRepoManagerImpl - [7f088eb0]_close: Shutting down real LocalRepoManager.\n18:31:39.247 [closeDeferredTimer-41661ce8-1] INFO \n...[truncated 37531263 chars]...\n9]getCloseDeferredMillis: closeDeferredMillis=20000\n18:50:10.315 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [632544e9]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:50:10.318 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:50:11.556 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n18:50:11.557 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [63iicalqht4nsyjQTlVpaw].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.PostgresqlRepoToRepoSyncIT", "duration" : 198.481, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncFromLocalToRemoteToLocalWithPathPrefixWithWritePermissionGrantedAndRevoked", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:31:37.555 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [63iicalqht4nsyjQTlVpaw].beforeClass: entered. testInstanceCounter=1\n18:31:37.568 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n18:31:37.580 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:31:39.243 [closeDeferredTimer-7f088eb0-1] INFO c.c.c.l.LocalRepoManagerImpl - [7f088eb0]_close: Shutting down real LocalRepoManager.\n18:31:39.247 [closeDeferredTimer-41661ce8-1] INFO \n...[truncated 37531263 chars]...\n9]getCloseDeferredMillis: closeDeferredMillis=20000\n18:50:10.315 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [632544e9]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:50:10.318 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:50:11.556 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n18:50:11.557 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [63iicalqht4nsyjQTlVpaw].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.PostgresqlRepoToRepoSyncIT", "duration" : 110.282, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncFromLocalToRemoteToLocal", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:31:37.555 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [63iicalqht4nsyjQTlVpaw].beforeClass: entered. testInstanceCounter=1\n18:31:37.568 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n18:31:37.580 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:31:39.243 [closeDeferredTimer-7f088eb0-1] INFO c.c.c.l.LocalRepoManagerImpl - [7f088eb0]_close: Shutting down real LocalRepoManager.\n18:31:39.247 [closeDeferredTimer-41661ce8-1] INFO \n...[truncated 37531263 chars]...\n9]getCloseDeferredMillis: closeDeferredMillis=20000\n18:50:10.315 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [632544e9]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:50:10.318 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:50:11.556 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n18:50:11.557 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [63iicalqht4nsyjQTlVpaw].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.PostgresqlRepoToRepoSyncIT", "duration" : 92.598, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncFromLocalToRemoteToLocalWithPathPrefixWithoutSubdirClearanceKey", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:31:37.555 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [63iicalqht4nsyjQTlVpaw].beforeClass: entered. testInstanceCounter=1\n18:31:37.568 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n18:31:37.580 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:31:39.243 [closeDeferredTimer-7f088eb0-1] INFO c.c.c.l.LocalRepoManagerImpl - [7f088eb0]_close: Shutting down real LocalRepoManager.\n18:31:39.247 [closeDeferredTimer-41661ce8-1] INFO \n...[truncated 37531263 chars]...\n9]getCloseDeferredMillis: closeDeferredMillis=20000\n18:50:10.315 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [632544e9]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:50:10.318 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:50:11.556 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n18:50:11.557 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [63iicalqht4nsyjQTlVpaw].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.PostgresqlRepoToRepoSyncIT", "duration" : 79.495, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncFromLocalToRemoteToLocalWithPathPrefix", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:31:37.555 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [63iicalqht4nsyjQTlVpaw].beforeClass: entered. testInstanceCounter=1\n18:31:37.568 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n18:31:37.580 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:31:39.243 [closeDeferredTimer-7f088eb0-1] INFO c.c.c.l.LocalRepoManagerImpl - [7f088eb0]_close: Shutting down real LocalRepoManager.\n18:31:39.247 [closeDeferredTimer-41661ce8-1] INFO \n...[truncated 37531263 chars]...\n9]getCloseDeferredMillis: closeDeferredMillis=20000\n18:50:10.315 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [632544e9]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:50:10.318 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:50:11.556 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n18:50:11.557 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [63iicalqht4nsyjQTlVpaw].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.PostgresqlRepoToRepoSyncIT", "duration" : 131.287, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncFromLocalToRemoteToLocalThenDeleteFileAndSyncAgain", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:31:37.555 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [63iicalqht4nsyjQTlVpaw].beforeClass: entered. testInstanceCounter=1\n18:31:37.568 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n18:31:37.580 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:31:39.243 [closeDeferredTimer-7f088eb0-1] INFO c.c.c.l.LocalRepoManagerImpl - [7f088eb0]_close: Shutting down real LocalRepoManager.\n18:31:39.247 [closeDeferredTimer-41661ce8-1] INFO \n...[truncated 37531263 chars]...\n9]getCloseDeferredMillis: closeDeferredMillis=20000\n18:50:10.315 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [632544e9]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:50:10.318 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:50:11.556 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n18:50:11.557 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [63iicalqht4nsyjQTlVpaw].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.PostgresqlRepoToRepoSyncIT", "duration" : 193.979, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncFromLocalToRemoteToLocalWithPathPrefixWithSubdirClearanceKey", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:31:37.555 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [63iicalqht4nsyjQTlVpaw].beforeClass: entered. testInstanceCounter=1\n18:31:37.568 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n18:31:37.580 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:31:39.243 [closeDeferredTimer-7f088eb0-1] INFO c.c.c.l.LocalRepoManagerImpl - [7f088eb0]_close: Shutting down real LocalRepoManager.\n18:31:39.247 [closeDeferredTimer-41661ce8-1] INFO \n...[truncated 37531263 chars]...\n9]getCloseDeferredMillis: closeDeferredMillis=20000\n18:50:10.315 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [632544e9]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:50:10.318 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:50:11.556 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n18:50:11.557 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [63iicalqht4nsyjQTlVpaw].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.PostgresqlRepoToRepoSyncIT", "duration" : 148.352, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "multiSyncFromLocalToRemoteToLocalWithPathPrefixWithSubdirClearanceKey", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:31:37.555 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [63iicalqht4nsyjQTlVpaw].beforeClass: entered. testInstanceCounter=1\n18:31:37.568 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n18:31:37.580 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:31:39.243 [closeDeferredTimer-7f088eb0-1] INFO c.c.c.l.LocalRepoManagerImpl - [7f088eb0]_close: Shutting down real LocalRepoManager.\n18:31:39.247 [closeDeferredTimer-41661ce8-1] INFO \n...[truncated 37531263 chars]...\n9]getCloseDeferredMillis: closeDeferredMillis=20000\n18:50:10.315 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [632544e9]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:50:10.318 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:50:11.556 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n18:50:11.557 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [63iicalqht4nsyjQTlVpaw].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 8, "className" : "org.subshare.test.PostgresqlRepoToRepoSyncIT", "duration" : 0.0, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 32, "name" : "syncFromLocalToRemoteToLocalThenCauseDeleteCollisionOnServerDuringUpSync", "skipped" : True, "skippedMessage" : None, "status" : "SKIPPED", "stderr" : "", "stdout" : "18:31:37.555 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [63iicalqht4nsyjQTlVpaw].beforeClass: entered. testInstanceCounter=1\n18:31:37.568 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n18:31:37.580 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:31:39.243 [closeDeferredTimer-7f088eb0-1] INFO c.c.c.l.LocalRepoManagerImpl - [7f088eb0]_close: Shutting down real LocalRepoManager.\n18:31:39.247 [closeDeferredTimer-41661ce8-1] INFO \n...[truncated 37531263 chars]...\n9]getCloseDeferredMillis: closeDeferredMillis=20000\n18:50:10.315 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [632544e9]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:50:10.318 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:50:11.556 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n18:50:11.557 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [63iicalqht4nsyjQTlVpaw].afterClass: entered. testInstanceCounter=1\n" } ], "duration" : 1112.745, "id" : None, "name" : "org.subshare.test.PostgresqlRepoToRepoSyncIT", "stderr" : "", "stdout" : "18:31:37.555 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [63iicalqht4nsyjQTlVpaw].beforeClass: entered. testInstanceCounter=1\n18:31:37.568 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n18:31:37.580 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:31:39.243 [closeDeferredTimer-7f088eb0-1] INFO c.c.c.l.LocalRepoManagerImpl - [7f088eb0]_close: Shutting down real LocalRepoManager.\n18:31:39.247 [closeDeferredTimer-41661ce8-1] INFO \n...[truncated 37531263 chars]...\n9]getCloseDeferredMillis: closeDeferredMillis=20000\n18:50:10.315 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [632544e9]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:50:10.318 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:50:11.556 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n18:50:11.557 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [63iicalqht4nsyjQTlVpaw].afterClass: entered. testInstanceCounter=1\n", "timestamp" : "2020-04-19T16:31:37" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.ReadUserIdentityIT", "duration" : 298.613, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "inviteWithReadInvitationAndGrantReadUserIdentityPermissionLater", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:36:03.871 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/1RMV_7vMR60tX2t9kquVow/.subshare/localServer.properties\n18:36:03.871 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/1RMV_7vMR60tX2t9kquVow/.subshare/ssl.client\n18:36:03.871 [Test worker] INFO \n...[truncated 6841259 chars]...\ncalRepoManager 20000 ms.\n18:41:02.476 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4c2795a1]getCloseDeferredMillis: closeDeferredMillis=20000\n18:41:02.476 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4c2795a1]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:41:02.483 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:41:03.016 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [YbuAdeXEm5nIXiQuMNBu-w].afterClass: entered. testInstanceCounter=1\n" } ], "duration" : 298.613, "id" : None, "name" : "org.subshare.test.ReadUserIdentityIT", "stderr" : "", "stdout" : "18:36:03.871 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/1RMV_7vMR60tX2t9kquVow/.subshare/localServer.properties\n18:36:03.871 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/1RMV_7vMR60tX2t9kquVow/.subshare/ssl.client\n18:36:03.871 [Test worker] INFO \n...[truncated 6841259 chars]...\ncalRepoManager 20000 ms.\n18:41:02.476 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4c2795a1]getCloseDeferredMillis: closeDeferredMillis=20000\n18:41:02.476 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4c2795a1]close: Deferring shut down of real LocalRepoManager 20000 ms.\n18:41:02.483 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n18:41:03.016 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [YbuAdeXEm5nIXiQuMNBu-w].afterClass: entered. testInstanceCounter=1\n", "timestamp" : "2020-04-19T16:36:03" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.RepoToRepoSyncIT", "duration" : 185.663, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncFromLocalToRemoteToLocalAfterCreateAndDeleteFile", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:48:22.281 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/ianvza_gNjGmaNW-ikFkow/.subshare/localServer.properties\n18:48:22.282 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/ianvza_gNjGmaNW-ikFkow/.subshare/ssl.client\n18:48:22.282 [Test worker] INFO \n...[truncated 42331165 chars]...\ncalRepoManager 20000 ms.\n19:09:06.727 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [556b8983]getCloseDeferredMillis: closeDeferredMillis=20000\n19:09:06.727 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [556b8983]close: Deferring shut down of real LocalRepoManager 20000 ms.\n19:09:06.728 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n19:09:07.594 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [pzO8IDJNh0bKsMHDJA_rQw].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.RepoToRepoSyncIT", "duration" : 260.476, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncFromLocalToRemoteToLocalWithPathPrefixWithWritePermissionGrantedAndRevoked", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:48:22.281 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/ianvza_gNjGmaNW-ikFkow/.subshare/localServer.properties\n18:48:22.282 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/ianvza_gNjGmaNW-ikFkow/.subshare/ssl.client\n18:48:22.282 [Test worker] INFO \n...[truncated 42331165 chars]...\ncalRepoManager 20000 ms.\n19:09:06.727 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [556b8983]getCloseDeferredMillis: closeDeferredMillis=20000\n19:09:06.727 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [556b8983]close: Deferring shut down of real LocalRepoManager 20000 ms.\n19:09:06.728 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n19:09:07.594 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [pzO8IDJNh0bKsMHDJA_rQw].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.RepoToRepoSyncIT", "duration" : 158.168, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncFromLocalToRemoteToLocal", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:48:22.281 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/ianvza_gNjGmaNW-ikFkow/.subshare/localServer.properties\n18:48:22.282 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/ianvza_gNjGmaNW-ikFkow/.subshare/ssl.client\n18:48:22.282 [Test worker] INFO \n...[truncated 42331165 chars]...\ncalRepoManager 20000 ms.\n19:09:06.727 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [556b8983]getCloseDeferredMillis: closeDeferredMillis=20000\n19:09:06.727 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [556b8983]close: Deferring shut down of real LocalRepoManager 20000 ms.\n19:09:06.728 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n19:09:07.594 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [pzO8IDJNh0bKsMHDJA_rQw].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.RepoToRepoSyncIT", "duration" : 126.77, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncFromLocalToRemoteToLocalWithPathPrefixWithoutSubdirClearanceKey", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:48:22.281 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/ianvza_gNjGmaNW-ikFkow/.subshare/localServer.properties\n18:48:22.282 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/ianvza_gNjGmaNW-ikFkow/.subshare/ssl.client\n18:48:22.282 [Test worker] INFO \n...[truncated 42331165 chars]...\ncalRepoManager 20000 ms.\n19:09:06.727 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [556b8983]getCloseDeferredMillis: closeDeferredMillis=20000\n19:09:06.727 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [556b8983]close: Deferring shut down of real LocalRepoManager 20000 ms.\n19:09:06.728 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n19:09:07.594 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [pzO8IDJNh0bKsMHDJA_rQw].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.RepoToRepoSyncIT", "duration" : 103.833, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncFromLocalToRemoteToLocalWithPathPrefix", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:48:22.281 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/ianvza_gNjGmaNW-ikFkow/.subshare/localServer.properties\n18:48:22.282 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/ianvza_gNjGmaNW-ikFkow/.subshare/ssl.client\n18:48:22.282 [Test worker] INFO \n...[truncated 42331165 chars]...\ncalRepoManager 20000 ms.\n19:09:06.727 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [556b8983]getCloseDeferredMillis: closeDeferredMillis=20000\n19:09:06.727 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [556b8983]close: Deferring shut down of real LocalRepoManager 20000 ms.\n19:09:06.728 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n19:09:07.594 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [pzO8IDJNh0bKsMHDJA_rQw].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.RepoToRepoSyncIT", "duration" : 129.074, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncFromLocalToRemoteToLocalThenDeleteFileAndSyncAgain", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:48:22.281 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/ianvza_gNjGmaNW-ikFkow/.subshare/localServer.properties\n18:48:22.282 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/ianvza_gNjGmaNW-ikFkow/.subshare/ssl.client\n18:48:22.282 [Test worker] INFO \n...[truncated 42331165 chars]...\ncalRepoManager 20000 ms.\n19:09:06.727 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [556b8983]getCloseDeferredMillis: closeDeferredMillis=20000\n19:09:06.727 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [556b8983]close: Deferring shut down of real LocalRepoManager 20000 ms.\n19:09:06.728 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n19:09:07.594 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [pzO8IDJNh0bKsMHDJA_rQw].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.RepoToRepoSyncIT", "duration" : 164.405, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncFromLocalToRemoteToLocalWithPathPrefixWithSubdirClearanceKey", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:48:22.281 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/ianvza_gNjGmaNW-ikFkow/.subshare/localServer.properties\n18:48:22.282 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/ianvza_gNjGmaNW-ikFkow/.subshare/ssl.client\n18:48:22.282 [Test worker] INFO \n...[truncated 42331165 chars]...\ncalRepoManager 20000 ms.\n19:09:06.727 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [556b8983]getCloseDeferredMillis: closeDeferredMillis=20000\n19:09:06.727 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [556b8983]close: Deferring shut down of real LocalRepoManager 20000 ms.\n19:09:06.728 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n19:09:07.594 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [pzO8IDJNh0bKsMHDJA_rQw].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 8, "className" : "org.subshare.test.RepoToRepoSyncIT", "duration" : 0.0, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 32, "name" : "syncFromLocalToRemoteToLocalThenCauseDeleteCollisionOnServerDuringUpSync", "skipped" : True, "skippedMessage" : None, "status" : "SKIPPED", "stderr" : "", "stdout" : "18:48:22.281 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/ianvza_gNjGmaNW-ikFkow/.subshare/localServer.properties\n18:48:22.282 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/ianvza_gNjGmaNW-ikFkow/.subshare/ssl.client\n18:48:22.282 [Test worker] INFO \n...[truncated 42331165 chars]...\ncalRepoManager 20000 ms.\n19:09:06.727 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [556b8983]getCloseDeferredMillis: closeDeferredMillis=20000\n19:09:06.727 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [556b8983]close: Deferring shut down of real LocalRepoManager 20000 ms.\n19:09:06.728 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n19:09:07.594 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [pzO8IDJNh0bKsMHDJA_rQw].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.RepoToRepoSyncIT", "duration" : 116.051, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "multiSyncFromLocalToRemoteToLocalWithPathPrefixWithSubdirClearanceKey", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:48:22.281 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/ianvza_gNjGmaNW-ikFkow/.subshare/localServer.properties\n18:48:22.282 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/ianvza_gNjGmaNW-ikFkow/.subshare/ssl.client\n18:48:22.282 [Test worker] INFO \n...[truncated 42331165 chars]...\ncalRepoManager 20000 ms.\n19:09:06.727 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [556b8983]getCloseDeferredMillis: closeDeferredMillis=20000\n19:09:06.727 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [556b8983]close: Deferring shut down of real LocalRepoManager 20000 ms.\n19:09:06.728 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n19:09:07.594 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [pzO8IDJNh0bKsMHDJA_rQw].afterClass: entered. testInstanceCounter=1\n" } ], "duration" : 1244.4401, "id" : None, "name" : "org.subshare.test.RepoToRepoSyncIT", "stderr" : "", "stdout" : "18:48:22.281 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/ianvza_gNjGmaNW-ikFkow/.subshare/localServer.properties\n18:48:22.282 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/ianvza_gNjGmaNW-ikFkow/.subshare/ssl.client\n18:48:22.282 [Test worker] INFO \n...[truncated 42331165 chars]...\ncalRepoManager 20000 ms.\n19:09:06.727 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [556b8983]getCloseDeferredMillis: closeDeferredMillis=20000\n19:09:06.727 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [556b8983]close: Deferring shut down of real LocalRepoManager 20000 ms.\n19:09:06.728 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n19:09:07.594 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [pzO8IDJNh0bKsMHDJA_rQw].afterClass: entered. testInstanceCounter=1\n", "timestamp" : "2020-04-19T16:48:22" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.SymlinkCollisionOnClientRepoToRepoSyncIT", "duration" : 193.094, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "newFileVsNewSymlinkCollisionOnClient", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "18:56:47.202 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/kL7V6NCPNOlycijr4iMfsA/.subshare/ssl.client\n18:56:47.203 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/kL7V6NCPNOlycijr4iMfsA/.subshare/repoRegistry.properties\n18:56:47.203 [Test work\n...[truncated 5363177 chars]...\nLocalRepoManager 20000 ms.\n19:00:00.290 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [6ca8bb3]getCloseDeferredMillis: closeDeferredMillis=20000\n19:00:00.291 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [6ca8bb3]close: Deferring shut down of real LocalRepoManager 20000 ms.\n19:00:00.297 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n19:00:01.448 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [k7THL-bqql8NtoGeyJCQxA].afterClass: entered. testInstanceCounter=1\n" } ], "duration" : 193.094, "id" : None, "name" : "org.subshare.test.SymlinkCollisionOnClientRepoToRepoSyncIT", "stderr" : "", "stdout" : "18:56:47.202 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: NOT deleting: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/kL7V6NCPNOlycijr4iMfsA/.subshare/ssl.client\n18:56:47.203 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/jvm/kL7V6NCPNOlycijr4iMfsA/.subshare/repoRegistry.properties\n18:56:47.203 [Test work\n...[truncated 5363177 chars]...\nLocalRepoManager 20000 ms.\n19:00:00.290 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [6ca8bb3]getCloseDeferredMillis: closeDeferredMillis=20000\n19:00:00.291 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [6ca8bb3]close: Deferring shut down of real LocalRepoManager 20000 ms.\n19:00:00.297 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n19:00:01.448 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [k7THL-bqql8NtoGeyJCQxA].afterClass: entered. testInstanceCounter=1\n", "timestamp" : "2020-04-19T16:56:47" } ] }