{ "duration" : 12083.164, "empty" : False, "failCount" : 0, "passCount" : 124, "skipCount" : 4, "suites" : [ { "cases" : [ { "age" : 0, "className" : "org.subshare.core.crypto.EncrypterDecrypterStreamTest", "duration" : 19.838, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "symmetricWithoutIv", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "\nsymmetricWithoutIv: cipherTransformation=AES_CBC_PKCS5PADDING\nsymmetricWithoutIv: Generating 9747943 random bytes plaintext took 249 ms.\n13:26:12.539 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\nsymmetricWithoutIv: Creating symmetric key took 1003 ms.\nsymmetricWithoutIv: Encrypting 9747943 bytes plaintext to 9747958 bytes ciphertext took 1686 ms.\nsymmetricWithoutIv: Decrypting 9747958 bytes ciphertext to 9747943 bytes plaintext took 621 ms\n...[truncated 37130 chars]...\n43876 bytes plaintext took 62 ms.\n\nasymmetricCombiWithRandomIv: asymmetricCipherTransformation=RSA_OAEPWITHSHA1ANDMGF1PADDING\nasymmetricCombiWithRandomIv: symmetricCipherTransformation=TWOFISH_CFB_NOPADDING\nasymmetricCombiWithRandomIv: Generating 9971144 random bytes plaintext took 83 ms.\nasymmetricCombiWithRandomIv: Encrypting 9971144 bytes plaintext to 9971688 bytes ciphertext took 497 ms.\nasymmetricCombiWithRandomIv: Decrypting 9971688 bytes ciphertext to 9971144 bytes plaintext took 501 ms.\n" }, { "age" : 0, "className" : "org.subshare.core.crypto.EncrypterDecrypterStreamTest", "duration" : 10.071, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "symmetricWithRandomIv", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "\nsymmetricWithoutIv: cipherTransformation=AES_CBC_PKCS5PADDING\nsymmetricWithoutIv: Generating 9747943 random bytes plaintext took 249 ms.\n13:26:12.539 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\nsymmetricWithoutIv: Creating symmetric key took 1003 ms.\nsymmetricWithoutIv: Encrypting 9747943 bytes plaintext to 9747958 bytes ciphertext took 1686 ms.\nsymmetricWithoutIv: Decrypting 9747958 bytes ciphertext to 9747943 bytes plaintext took 621 ms\n...[truncated 37130 chars]...\n43876 bytes plaintext took 62 ms.\n\nasymmetricCombiWithRandomIv: asymmetricCipherTransformation=RSA_OAEPWITHSHA1ANDMGF1PADDING\nasymmetricCombiWithRandomIv: symmetricCipherTransformation=TWOFISH_CFB_NOPADDING\nasymmetricCombiWithRandomIv: Generating 9971144 random bytes plaintext took 83 ms.\nasymmetricCombiWithRandomIv: Encrypting 9971144 bytes plaintext to 9971688 bytes ciphertext took 497 ms.\nasymmetricCombiWithRandomIv: Decrypting 9971688 bytes ciphertext to 9971144 bytes plaintext took 501 ms.\n" }, { "age" : 0, "className" : "org.subshare.core.crypto.EncrypterDecrypterStreamTest", "duration" : 11.106, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "asymmetricPlain", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "\nsymmetricWithoutIv: cipherTransformation=AES_CBC_PKCS5PADDING\nsymmetricWithoutIv: Generating 9747943 random bytes plaintext took 249 ms.\n13:26:12.539 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\nsymmetricWithoutIv: Creating symmetric key took 1003 ms.\nsymmetricWithoutIv: Encrypting 9747943 bytes plaintext to 9747958 bytes ciphertext took 1686 ms.\nsymmetricWithoutIv: Decrypting 9747958 bytes ciphertext to 9747943 bytes plaintext took 621 ms\n...[truncated 37130 chars]...\n43876 bytes plaintext took 62 ms.\n\nasymmetricCombiWithRandomIv: asymmetricCipherTransformation=RSA_OAEPWITHSHA1ANDMGF1PADDING\nasymmetricCombiWithRandomIv: symmetricCipherTransformation=TWOFISH_CFB_NOPADDING\nasymmetricCombiWithRandomIv: Generating 9971144 random bytes plaintext took 83 ms.\nasymmetricCombiWithRandomIv: Encrypting 9971144 bytes plaintext to 9971688 bytes ciphertext took 497 ms.\nasymmetricCombiWithRandomIv: Decrypting 9971688 bytes ciphertext to 9971144 bytes plaintext took 501 ms.\n" }, { "age" : 0, "className" : "org.subshare.core.crypto.EncrypterDecrypterStreamTest", "duration" : 17.994, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "asymmetricCombiWithRandomIv", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "\nsymmetricWithoutIv: cipherTransformation=AES_CBC_PKCS5PADDING\nsymmetricWithoutIv: Generating 9747943 random bytes plaintext took 249 ms.\n13:26:12.539 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\nsymmetricWithoutIv: Creating symmetric key took 1003 ms.\nsymmetricWithoutIv: Encrypting 9747943 bytes plaintext to 9747958 bytes ciphertext took 1686 ms.\nsymmetricWithoutIv: Decrypting 9747958 bytes ciphertext to 9747943 bytes plaintext took 621 ms\n...[truncated 37130 chars]...\n43876 bytes plaintext took 62 ms.\n\nasymmetricCombiWithRandomIv: asymmetricCipherTransformation=RSA_OAEPWITHSHA1ANDMGF1PADDING\nasymmetricCombiWithRandomIv: symmetricCipherTransformation=TWOFISH_CFB_NOPADDING\nasymmetricCombiWithRandomIv: Generating 9971144 random bytes plaintext took 83 ms.\nasymmetricCombiWithRandomIv: Encrypting 9971144 bytes plaintext to 9971688 bytes ciphertext took 497 ms.\nasymmetricCombiWithRandomIv: Decrypting 9971688 bytes ciphertext to 9971144 bytes plaintext took 501 ms.\n" } ], "duration" : 59.009, "id" : None, "name" : "org.subshare.core.crypto.EncrypterDecrypterStreamTest", "stderr" : "", "stdout" : "\nsymmetricWithoutIv: cipherTransformation=AES_CBC_PKCS5PADDING\nsymmetricWithoutIv: Generating 9747943 random bytes plaintext took 249 ms.\n13:26:12.539 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\nsymmetricWithoutIv: Creating symmetric key took 1003 ms.\nsymmetricWithoutIv: Encrypting 9747943 bytes plaintext to 9747958 bytes ciphertext took 1686 ms.\nsymmetricWithoutIv: Decrypting 9747958 bytes ciphertext to 9747943 bytes plaintext took 621 ms\n...[truncated 37130 chars]...\n43876 bytes plaintext took 62 ms.\n\nasymmetricCombiWithRandomIv: asymmetricCipherTransformation=RSA_OAEPWITHSHA1ANDMGF1PADDING\nasymmetricCombiWithRandomIv: symmetricCipherTransformation=TWOFISH_CFB_NOPADDING\nasymmetricCombiWithRandomIv: Generating 9971144 random bytes plaintext took 83 ms.\nasymmetricCombiWithRandomIv: Encrypting 9971144 bytes plaintext to 9971688 bytes ciphertext took 497 ms.\nasymmetricCombiWithRandomIv: Decrypting 9971688 bytes ciphertext to 9971144 bytes plaintext took 501 ms.\n", "timestamp" : "2020-05-01T11:26:12" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.core.file.EncryptedDataFileTest", "duration" : 1.294, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "writeReadSimpleEncryptedDataFile", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "" } ], "duration" : 1.294, "id" : None, "name" : "org.subshare.core.file.EncryptedDataFileTest", "stderr" : "", "stdout" : "", "timestamp" : "2020-05-01T11:26:10" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.core.gpg.GnuPgTest", "duration" : 5.21, "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.766, "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.353, "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.034, "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.363, "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-05-01T11:26:08" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.core.io.LimitedInputStreamTest", "duration" : 2.329, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "randomLengthWithUnderlyingSameLength", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "" } ], "duration" : 2.329, "id" : None, "name" : "org.subshare.core.io.LimitedInputStreamTest", "stderr" : "", "stdout" : "", "timestamp" : "2020-05-01T11:26:09" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.core.io.MultiInputStreamTest", "duration" : 1.832, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "randomCombi", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "" } ], "duration" : 1.832, "id" : None, "name" : "org.subshare.core.io.MultiInputStreamTest", "stderr" : "", "stdout" : "", "timestamp" : "2020-05-01T11:26:08" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.core.pgp.PgpTest", "duration" : 9.778, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "inlineSignThenEncryptAndDecryptThenVerify", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:26:10.595 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n13:26:10.649 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:26:10.775 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/rD4FiIqx8LSeH76pQQJovw/.gnupg\n13:26:10.785 [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/rD4FiIqx8LSeH76pQQJovw/.gnupg\n13:26:11.61\n...[truncated 28385 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)\n13:26:29.157 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.core.pgp.PgpTest", "duration" : 0.114, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "signAndVerifyViaPgpSignable", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:26:10.595 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n13:26:10.649 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:26:10.775 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/rD4FiIqx8LSeH76pQQJovw/.gnupg\n13:26:10.785 [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/rD4FiIqx8LSeH76pQQJovw/.gnupg\n13:26:11.61\n...[truncated 28385 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)\n13:26:29.157 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.core.pgp.PgpTest", "duration" : 4.971, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "inlineSignAndVerify", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:26:10.595 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n13:26:10.649 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:26:10.775 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/rD4FiIqx8LSeH76pQQJovw/.gnupg\n13:26:10.785 [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/rD4FiIqx8LSeH76pQQJovw/.gnupg\n13:26:11.61\n...[truncated 28385 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)\n13:26:29.157 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.core.pgp.PgpTest", "duration" : 0.239, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "exportImportPublicKey", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:26:10.595 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n13:26:10.649 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:26:10.775 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/rD4FiIqx8LSeH76pQQJovw/.gnupg\n13:26:10.785 [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/rD4FiIqx8LSeH76pQQJovw/.gnupg\n13:26:11.61\n...[truncated 28385 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)\n13:26:29.157 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.core.pgp.PgpTest", "duration" : 2.564, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "detachedSignAndVerify", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:26:10.595 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n13:26:10.649 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:26:10.775 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/rD4FiIqx8LSeH76pQQJovw/.gnupg\n13:26:10.785 [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/rD4FiIqx8LSeH76pQQJovw/.gnupg\n13:26:11.61\n...[truncated 28385 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)\n13:26:29.157 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" } ], "duration" : 17.666, "id" : None, "name" : "org.subshare.core.pgp.PgpTest", "stderr" : "", "stdout" : "13:26:10.595 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n13:26:10.649 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:26:10.775 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/rD4FiIqx8LSeH76pQQJovw/.gnupg\n13:26:10.785 [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/rD4FiIqx8LSeH76pQQJovw/.gnupg\n13:26:11.61\n...[truncated 28385 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)\n13:26:29.157 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n", "timestamp" : "2020-05-01T11:26:11" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.core.user.AddDuplicateUserRepoKeyPublicKeyToUserTest", "duration" : 1.27, "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.011, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "addSameUserRepoKeyPublicKeyTwiceToUser", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "" }, { "age" : 0, "className" : "org.subshare.core.user.AddDuplicateUserRepoKeyPublicKeyToUserTest", "duration" : 0.01, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "addDifferentUserRepoKeyPublicKeysToUser", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "" } ], "duration" : 1.294, "id" : None, "name" : "org.subshare.core.user.AddDuplicateUserRepoKeyPublicKeyToUserTest", "stderr" : "", "stdout" : "", "timestamp" : "2020-05-01T11:26:09" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.core.user.UserRegistryTest", "duration" : 2.858, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "addUser", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:26:15.686 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n13:26:15.711 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:26:15.763 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/k-nqtMUFuizKr4xGoQ7KRA/.gnupg\n13:26:15.765 [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/k-nqtMUFuizKr4xGoQ7KRA/.gnupg\n13:26:16.05\n...[truncated 13989 chars]...\ntance.\n13:26:37.032 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance.\n13:26:41.796 [Test worker] INFO o.s.c.c.KeyFactory - Creating asymmetric key pair with defaults took 4761 ms.\n13:26:41.809 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance.\n13:26:41.917 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance.\n13:26:41.994 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.core.user.UserRegistryTest", "duration" : 8.315, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "testGpgKeyTrustLevels", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:26:15.686 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n13:26:15.711 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:26:15.763 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/k-nqtMUFuizKr4xGoQ7KRA/.gnupg\n13:26:15.765 [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/k-nqtMUFuizKr4xGoQ7KRA/.gnupg\n13:26:16.05\n...[truncated 13989 chars]...\ntance.\n13:26:37.032 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance.\n13:26:41.796 [Test worker] INFO o.s.c.c.KeyFactory - Creating asymmetric key pair with defaults took 4761 ms.\n13:26:41.809 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance.\n13:26:41.917 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance.\n13:26:41.994 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.core.user.UserRegistryTest", "duration" : 15.127, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "initUserRegistryFromGpgKeys", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:26:15.686 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n13:26:15.711 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:26:15.763 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/k-nqtMUFuizKr4xGoQ7KRA/.gnupg\n13:26:15.765 [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/k-nqtMUFuizKr4xGoQ7KRA/.gnupg\n13:26:16.05\n...[truncated 13989 chars]...\ntance.\n13:26:37.032 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance.\n13:26:41.796 [Test worker] INFO o.s.c.c.KeyFactory - Creating asymmetric key pair with defaults took 4761 ms.\n13:26:41.809 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance.\n13:26:41.917 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance.\n13:26:41.994 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" } ], "duration" : 26.3, "id" : None, "name" : "org.subshare.core.user.UserRegistryTest", "stderr" : "", "stdout" : "13:26:15.686 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n13:26:15.711 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:26:15.763 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=build/k-nqtMUFuizKr4xGoQ7KRA/.gnupg\n13:26:15.765 [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/k-nqtMUFuizKr4xGoQ7KRA/.gnupg\n13:26:16.05\n...[truncated 13989 chars]...\ntance.\n13:26:37.032 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance.\n13:26:41.796 [Test worker] INFO o.s.c.c.KeyFactory - Creating asymmetric key pair with defaults took 4761 ms.\n13:26:41.809 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance.\n13:26:41.917 [Test worker] DEBUG o.s.c.p.PgpRegistry - getPgpOrFail: returning existing Pgp instance.\n13:26:41.994 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n", "timestamp" : "2020-05-01T11:26:15" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.core.user.UserRepoKeyRingVsPublicKeysUserImplTest", "duration" : 0.949, "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.1, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "firstCreateUserRepoKeyRingThenAddPublicKeys", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "" } ], "duration" : 1.049, "id" : None, "name" : "org.subshare.core.user.UserRepoKeyRingVsPublicKeysUserImplTest", "stderr" : "", "stdout" : "", "timestamp" : "2020-05-01T11:26:09" }, { "cases" : [ { "age" : 33, "className" : "org.subshare.crypto.AsymmetricKeyTest", "duration" : 0.0, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 11, "name" : "generateManySymmetricKeys", "skipped" : True, "skippedMessage" : None, "status" : "SKIPPED", "stderr" : "", "stdout" : "" }, { "age" : 0, "className" : "org.subshare.crypto.AsymmetricKeyTest", "duration" : 16.589, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "encodeDecodeRSAwithOAEPwithSHA1andMGF1Padding", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "" }, { "age" : 0, "className" : "org.subshare.crypto.AsymmetricKeyTest", "duration" : 6.028, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "encodeDecodeRSA", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "" } ], "duration" : 22.617, "id" : None, "name" : "org.subshare.crypto.AsymmetricKeyTest", "stderr" : "", "stdout" : "", "timestamp" : "2020-05-01T11:27:25" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.crypto.CipherTest", "duration" : 4.627, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "testLookupAllSupportedCiphers", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:27:30.192 [Test worker] INFO o.s.c.CipherTest - testLookupAllSupportedCiphers: Successfully created 29934 ciphers in 3186 msec.\n13:27:30.560 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//\n13:27:30.580 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyParameter: Transformation \"AES.FAST//\" does not support IV => Skipping.\n13:27:30.597 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//NOPADDING\n13:27:30.601 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyP\n...[truncated 3456005 chars]...\ns.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding\n13:27:45.383 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding\n13:27:45.414 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CBC/PKCS5Padding\n13:27:45.963 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CFB/NoPadding\n13:27:46.681 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding\n13:27:47.281 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding\n" }, { "age" : 0, "className" : "org.subshare.crypto.CipherTest", "duration" : 10.324, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "testNullAsKeyParameter", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:27:30.192 [Test worker] INFO o.s.c.CipherTest - testLookupAllSupportedCiphers: Successfully created 29934 ciphers in 3186 msec.\n13:27:30.560 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//\n13:27:30.580 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyParameter: Transformation \"AES.FAST//\" does not support IV => Skipping.\n13:27:30.597 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//NOPADDING\n13:27:30.601 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyP\n...[truncated 3456005 chars]...\ns.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding\n13:27:45.383 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding\n13:27:45.414 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CBC/PKCS5Padding\n13:27:45.963 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CFB/NoPadding\n13:27:46.681 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding\n13:27:47.281 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding\n" }, { "age" : 0, "className" : "org.subshare.crypto.CipherTest", "duration" : 0.169, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "testLookupCompatibilityWithJCE", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:27:30.192 [Test worker] INFO o.s.c.CipherTest - testLookupAllSupportedCiphers: Successfully created 29934 ciphers in 3186 msec.\n13:27:30.560 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//\n13:27:30.580 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyParameter: Transformation \"AES.FAST//\" does not support IV => Skipping.\n13:27:30.597 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//NOPADDING\n13:27:30.601 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyP\n...[truncated 3456005 chars]...\ns.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding\n13:27:45.383 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding\n13:27:45.414 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CBC/PKCS5Padding\n13:27:45.963 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CFB/NoPadding\n13:27:46.681 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding\n13:27:47.281 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding\n" }, { "age" : 0, "className" : "org.subshare.crypto.CipherTest", "duration" : 6.789, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "testSymmetricEncryptionWithoutIv", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:27:30.192 [Test worker] INFO o.s.c.CipherTest - testLookupAllSupportedCiphers: Successfully created 29934 ciphers in 3186 msec.\n13:27:30.560 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//\n13:27:30.580 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyParameter: Transformation \"AES.FAST//\" does not support IV => Skipping.\n13:27:30.597 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//NOPADDING\n13:27:30.601 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyP\n...[truncated 3456005 chars]...\ns.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding\n13:27:45.383 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding\n13:27:45.414 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CBC/PKCS5Padding\n13:27:45.963 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CFB/NoPadding\n13:27:46.681 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding\n13:27:47.281 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding\n" }, { "age" : 0, "className" : "org.subshare.crypto.CipherTest", "duration" : 0.141, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "testSymmetricEncryptionCompatibilityWithJCE_BouncyCastleProvider", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:27:30.192 [Test worker] INFO o.s.c.CipherTest - testLookupAllSupportedCiphers: Successfully created 29934 ciphers in 3186 msec.\n13:27:30.560 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//\n13:27:30.580 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyParameter: Transformation \"AES.FAST//\" does not support IV => Skipping.\n13:27:30.597 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//NOPADDING\n13:27:30.601 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyP\n...[truncated 3456005 chars]...\ns.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding\n13:27:45.383 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding\n13:27:45.414 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CBC/PKCS5Padding\n13:27:45.963 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CFB/NoPadding\n13:27:46.681 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding\n13:27:47.281 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding\n" } ], "duration" : 22.050001, "id" : None, "name" : "org.subshare.crypto.CipherTest", "stderr" : "", "stdout" : "13:27:30.192 [Test worker] INFO o.s.c.CipherTest - testLookupAllSupportedCiphers: Successfully created 29934 ciphers in 3186 msec.\n13:27:30.560 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//\n13:27:30.580 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyParameter: Transformation \"AES.FAST//\" does not support IV => Skipping.\n13:27:30.597 [Test worker] INFO o.s.c.CipherTest - transformation=AES.FAST//NOPADDING\n13:27:30.601 [Test worker] INFO o.s.c.CipherTest - testNullAsKeyP\n...[truncated 3456005 chars]...\ns.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding\n13:27:45.383 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding\n13:27:45.414 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CBC/PKCS5Padding\n13:27:45.963 [Test worker] INFO o.s.c.CipherTest - transformation=AES/CFB/NoPadding\n13:27:46.681 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CBC/PKCS5Padding\n13:27:47.281 [Test worker] INFO o.s.c.CipherTest - transformation=Twofish/CFB/NoPadding\n", "timestamp" : "2020-05-01T11:27:25" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.crypto.GCMTest", "duration" : 6.064, "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.67, "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" : 8.734, "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-05-01T11:27:26" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.crypto.MACBenchmark", "duration" : 0.291, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "testByteOrder", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:27:26.612 [Test worker] INFO o.s.c.MACBenchmark - short1 = 27382\n13:27:26.625 [Test worker] INFO o.s.c.MACBenchmark - short2 = 27382\n13:27:26.637 [Test worker] INFO o.s.c.MACBenchmark - int1 = 27382\n" }, { "age" : 0, "className" : "org.subshare.crypto.MACBenchmark", "duration" : 10.962, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "benchmarkCreateManyInitialisedMACCalculators", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:27:26.612 [Test worker] INFO o.s.c.MACBenchmark - short1 = 27382\n13:27:26.625 [Test worker] INFO o.s.c.MACBenchmark - short2 = 27382\n13:27:26.637 [Test worker] INFO o.s.c.MACBenchmark - int1 = 27382\n" }, { "age" : 0, "className" : "org.subshare.crypto.MACBenchmark", "duration" : 0.173, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "benchmarkCreateManyUNinitialisedMACCalculators", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:27:26.612 [Test worker] INFO o.s.c.MACBenchmark - short1 = 27382\n13:27:26.625 [Test worker] INFO o.s.c.MACBenchmark - short2 = 27382\n13:27:26.637 [Test worker] INFO o.s.c.MACBenchmark - int1 = 27382\n" }, { "age" : 0, "className" : "org.subshare.crypto.MACBenchmark", "duration" : 19.251, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "benchmarkCalculateManyMACsWithNewMACCalculator", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:27:26.612 [Test worker] INFO o.s.c.MACBenchmark - short1 = 27382\n13:27:26.625 [Test worker] INFO o.s.c.MACBenchmark - short2 = 27382\n13:27:26.637 [Test worker] INFO o.s.c.MACBenchmark - int1 = 27382\n" }, { "age" : 0, "className" : "org.subshare.crypto.MACBenchmark", "duration" : 16.584, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "benchmarkCalculateManyMACsWithSameMACCalculator", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:27:26.612 [Test worker] INFO o.s.c.MACBenchmark - short1 = 27382\n13:27:26.625 [Test worker] INFO o.s.c.MACBenchmark - short2 = 27382\n13:27:26.637 [Test worker] INFO o.s.c.MACBenchmark - int1 = 27382\n" } ], "duration" : 47.261, "id" : None, "name" : "org.subshare.crypto.MACBenchmark", "stderr" : "", "stdout" : "13:27:26.612 [Test worker] INFO o.s.c.MACBenchmark - short1 = 27382\n13:27:26.625 [Test worker] INFO o.s.c.MACBenchmark - short2 = 27382\n13:27:26.637 [Test worker] INFO o.s.c.MACBenchmark - int1 = 27382\n", "timestamp" : "2020-05-01T11:27:26" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.crypto.MACTest", "duration" : 3.815, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "testAllSupportedMACs", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "" } ], "duration" : 3.815, "id" : None, "name" : "org.subshare.crypto.MACTest", "stderr" : "", "stdout" : "", "timestamp" : "2020-05-01T11:27:23" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.crypto.ShowSupportedAlgosForDocumentation", "duration" : 2.775, "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.129, "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.112, "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.088, "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.104, "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-05-01T11:27:23" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.local.CryptreeImplGrantRevokeReadPermissionTest", "duration" : 117.201, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "grantAndRevokeReadPermission", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:29:00.550 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n13:29:00.823 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:02.690 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [166938b1]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.local/build/repo/k9o46pd8-cf7ef-local'\n13:29:02.776 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 198\n...[truncated 32878 chars]...\nNFO o.s.l.CryptreeImplGrantRevokeReadPermissionTest - Local sync...: 90.83%\n13:30:56.281 [Test worker] INFO o.s.l.CryptreeImplGrantRevokeReadPermissionTest - Local sync...: 96.55%\n13:30:56.572 [Test worker] INFO o.s.l.CryptreeImplGrantRevokeReadPermissionTest - Local sync...: 100.00%\n13:30:57.247 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [166938b1]close: Deferring shut down of real LocalRepoManager 20000 ms.\n13:30:57.302 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" } ], "duration" : 117.201, "id" : None, "name" : "org.subshare.local.CryptreeImplGrantRevokeReadPermissionTest", "stderr" : "", "stdout" : "13:29:00.550 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n13:29:00.823 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:02.690 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [166938b1]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.local/build/repo/k9o46pd8-cf7ef-local'\n13:29:02.776 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 198\n...[truncated 32878 chars]...\nNFO o.s.l.CryptreeImplGrantRevokeReadPermissionTest - Local sync...: 90.83%\n13:30:56.281 [Test worker] INFO o.s.l.CryptreeImplGrantRevokeReadPermissionTest - Local sync...: 96.55%\n13:30:56.572 [Test worker] INFO o.s.l.CryptreeImplGrantRevokeReadPermissionTest - Local sync...: 100.00%\n13:30:57.247 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [166938b1]close: Deferring shut down of real LocalRepoManager 20000 ms.\n13:30:57.302 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n", "timestamp" : "2020-05-01T11:29:00" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.local.CryptreeImplGrantRevokeWritePermissionTest", "duration" : 104.826, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "grantWritePermissionWithoutGrantPermission", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:28:58.504 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n13:28:58.858 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:01.258 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [574234ad]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.local/build/repo/k9o46o84-aeojk-local'\n13:29:01.463 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 198\n...[truncated 149024 chars]...\nnTest - Local sync...: 79.60%\n13:33:54.441 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 90.83%\n13:33:54.468 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 96.55%\n13:33:54.495 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 100.00%\n13:33:54.521 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [bab3a9e]close: Deferring shut down of real LocalRepoManager 20000 ms.\n13:33:54.524 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.local.CryptreeImplGrantRevokeWritePermissionTest", "duration" : 45.219, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "writeWithWritePermissionInParentParent", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:28:58.504 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n13:28:58.858 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:01.258 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [574234ad]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.local/build/repo/k9o46o84-aeojk-local'\n13:29:01.463 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 198\n...[truncated 149024 chars]...\nnTest - Local sync...: 79.60%\n13:33:54.441 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 90.83%\n13:33:54.468 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 96.55%\n13:33:54.495 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 100.00%\n13:33:54.521 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [bab3a9e]close: Deferring shut down of real LocalRepoManager 20000 ms.\n13:33:54.524 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.local.CryptreeImplGrantRevokeWritePermissionTest", "duration" : 32.205, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "writeWithWritePermissionInParent", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:28:58.504 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n13:28:58.858 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:01.258 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [574234ad]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.local/build/repo/k9o46o84-aeojk-local'\n13:29:01.463 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 198\n...[truncated 149024 chars]...\nnTest - Local sync...: 79.60%\n13:33:54.441 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 90.83%\n13:33:54.468 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 96.55%\n13:33:54.495 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 100.00%\n13:33:54.521 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [bab3a9e]close: Deferring shut down of real LocalRepoManager 20000 ms.\n13:33:54.524 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.local.CryptreeImplGrantRevokeWritePermissionTest", "duration" : 30.506, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "writeWithWritePermissionDirectDir", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:28:58.504 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n13:28:58.858 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:01.258 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [574234ad]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.local/build/repo/k9o46o84-aeojk-local'\n13:29:01.463 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 198\n...[truncated 149024 chars]...\nnTest - Local sync...: 79.60%\n13:33:54.441 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 90.83%\n13:33:54.468 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 96.55%\n13:33:54.495 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 100.00%\n13:33:54.521 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [bab3a9e]close: Deferring shut down of real LocalRepoManager 20000 ms.\n13:33:54.524 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.local.CryptreeImplGrantRevokeWritePermissionTest", "duration" : 25.245, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "writeWithoutWritePermission", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:28:58.504 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n13:28:58.858 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:01.258 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [574234ad]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.local/build/repo/k9o46o84-aeojk-local'\n13:29:01.463 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 198\n...[truncated 149024 chars]...\nnTest - Local sync...: 79.60%\n13:33:54.441 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 90.83%\n13:33:54.468 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 96.55%\n13:33:54.495 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 100.00%\n13:33:54.521 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [bab3a9e]close: Deferring shut down of real LocalRepoManager 20000 ms.\n13:33:54.524 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.local.CryptreeImplGrantRevokeWritePermissionTest", "duration" : 28.926, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "writeWithWritePermissionInParentParentGrantedIndirectly", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:28:58.504 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n13:28:58.858 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:01.258 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [574234ad]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.local/build/repo/k9o46o84-aeojk-local'\n13:29:01.463 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 198\n...[truncated 149024 chars]...\nnTest - Local sync...: 79.60%\n13:33:54.441 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 90.83%\n13:33:54.468 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 96.55%\n13:33:54.495 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 100.00%\n13:33:54.521 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [bab3a9e]close: Deferring shut down of real LocalRepoManager 20000 ms.\n13:33:54.524 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.local.CryptreeImplGrantRevokeWritePermissionTest", "duration" : 29.482, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "writeWithWritePermissionDirectFile", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:28:58.504 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n13:28:58.858 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:01.258 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [574234ad]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.local/build/repo/k9o46o84-aeojk-local'\n13:29:01.463 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 198\n...[truncated 149024 chars]...\nnTest - Local sync...: 79.60%\n13:33:54.441 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 90.83%\n13:33:54.468 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 96.55%\n13:33:54.495 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 100.00%\n13:33:54.521 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [bab3a9e]close: Deferring shut down of real LocalRepoManager 20000 ms.\n13:33:54.524 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" } ], "duration" : 296.409, "id" : None, "name" : "org.subshare.local.CryptreeImplGrantRevokeWritePermissionTest", "stderr" : "", "stdout" : "13:28:58.504 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n13:28:58.858 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:01.258 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [574234ad]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.local/build/repo/k9o46o84-aeojk-local'\n13:29:01.463 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 198\n...[truncated 149024 chars]...\nnTest - Local sync...: 79.60%\n13:33:54.441 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 90.83%\n13:33:54.468 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 96.55%\n13:33:54.495 [Test worker] INFO o.s.l.AbstractPermissionTest - Local sync...: 100.00%\n13:33:54.521 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [bab3a9e]close: Deferring shut down of real LocalRepoManager 20000 ms.\n13:33:54.524 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n", "timestamp" : "2020-05-01T11:28:58" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.local.FilePaddingLengthRandomTest", "duration" : 7.632, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "testDistribution", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "lengthCategory2HitCount: {_100K=299978, _1M=148160, _10M=47013, _100M=2936, _1G=1913, _10G=0}\nlengthCategory2HitPercentage: {_100K=600, _1M=296, _10M=94, _100M=6, _1G=4, _10G=0}\n953341\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=299978, _1M=148160, _10M=47013, _100M=2936, _1G=1913, _10G=0}\nlengthCategory2HitPercentage: {_100K=600, _1M=296, _10M=94, _100M=6, _1G=4, _10G=0}\n953341\n" } ], "duration" : 7.638, "id" : None, "name" : "org.subshare.local.FilePaddingLengthRandomTest", "stderr" : "", "stdout" : "lengthCategory2HitCount: {_100K=299978, _1M=148160, _10M=47013, _100M=2936, _1G=1913, _10G=0}\nlengthCategory2HitPercentage: {_100K=600, _1M=296, _10M=94, _100M=6, _1G=4, _10G=0}\n953341\n", "timestamp" : "2020-05-01T11:31:12" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.local.db.DbMigrateFromDerbyToPostgresqlTest", "duration" : 139.37, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "migrateFromDerbyToPostgresql", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:28:59.899 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n13:29:00.081 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:02.498 [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/k9o46p3k-xeow4-local'\n13:29:02.695 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 199\n...[truncated 1326212 chars]...\nObjects: pcClass=org.subshare.local.persistence.UserRepoKeyPublicKeyReplacementRequestDeletion: *EMPTY*\n13:31:18.805 [Test worker] INFO D.D.Retrieve - Object with id \"1\" not found !\n13:31:18.822 [Test worker] INFO c.c.c.l.d.DatabaseMigrater - migrateIfNeeded: localRoot='build/repo/k9o46p3k-xeow4-local': Migration complete!\n13:31:18.846 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:31:19.145 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n" } ], "duration" : 139.37, "id" : None, "name" : "org.subshare.local.db.DbMigrateFromDerbyToPostgresqlTest", "stderr" : "", "stdout" : "13:28:59.899 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n13:29:00.081 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:02.498 [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/k9o46p3k-xeow4-local'\n13:29:02.695 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 199\n...[truncated 1326212 chars]...\nObjects: pcClass=org.subshare.local.persistence.UserRepoKeyPublicKeyReplacementRequestDeletion: *EMPTY*\n13:31:18.805 [Test worker] INFO D.D.Retrieve - Object with id \"1\" not found !\n13:31:18.822 [Test worker] INFO c.c.c.l.d.DatabaseMigrater - migrateIfNeeded: localRoot='build/repo/k9o46p3k-xeow4-local': Migration complete!\n13:31:18.846 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:31:19.145 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n", "timestamp" : "2020-05-01T11:28:59" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.local.db.DbMigrateFromPostgresqlToDerbyTest", "duration" : 132.937, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "migrateFromPostgresqlToDerby", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:28:59.395 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n13:28:59.565 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n13:28:59.778 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:01.890 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [1fe5d7b5]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.local/build/repo/k9o46ooq-w95fi-local'\n13\n...[truncated 1478255 chars]...\nObjects: pcClass=org.subshare.local.persistence.UserRepoKeyPublicKeyReplacementRequestDeletion: *EMPTY*\n13:31:12.467 [Test worker] INFO D.D.Retrieve - Object with id \"1\" not found !\n13:31:12.492 [Test worker] INFO c.c.c.l.d.DatabaseMigrater - migrateIfNeeded: localRoot='build/repo/k9o46ooq-w95fi-local': Migration complete!\n13:31:12.517 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:31:12.856 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n" } ], "duration" : 132.937, "id" : None, "name" : "org.subshare.local.db.DbMigrateFromPostgresqlToDerbyTest", "stderr" : "", "stdout" : "13:28:59.395 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n13:28:59.565 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n13:28:59.778 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:01.890 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [1fe5d7b5]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.local/build/repo/k9o46ooq-w95fi-local'\n13\n...[truncated 1478255 chars]...\nObjects: pcClass=org.subshare.local.persistence.UserRepoKeyPublicKeyReplacementRequestDeletion: *EMPTY*\n13:31:12.467 [Test worker] INFO D.D.Retrieve - Object with id \"1\" not found !\n13:31:12.492 [Test worker] INFO c.c.c.l.d.DatabaseMigrater - migrateIfNeeded: localRoot='build/repo/k9o46ooq-w95fi-local': Migration complete!\n13:31:12.517 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:31:12.856 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n", "timestamp" : "2020-05-01T11:28:59" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.local.persistence.CollisionTest", "duration" : 1.661, "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.663, "id" : None, "name" : "org.subshare.local.persistence.CollisionTest", "stderr" : "", "stdout" : "", "timestamp" : "2020-05-01T11:28:59" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.local.sign.SignableTest", "duration" : 2.994, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "signAndSerializeAndVerify", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:29:01.083 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n13:29:02.382 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load().\n13:29:02.468 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1989 ms.\n13:29:04.503 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg\n13:29:04.504 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg\n13\n...[truncated 905 chars]...\n o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:10.895 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:11.011 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:11.068 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:11.141 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:11.211 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:11.348 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.local.sign.SignableTest", "duration" : 0.269, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "signAndModifyCryptoKeyIdAndVerify", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:29:01.083 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n13:29:02.382 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load().\n13:29:02.468 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1989 ms.\n13:29:04.503 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg\n13:29:04.504 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg\n13\n...[truncated 905 chars]...\n o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:10.895 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:11.011 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:11.068 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:11.141 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:11.211 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:11.348 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.local.sign.SignableTest", "duration" : 0.177, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "signAndVerify", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:29:01.083 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n13:29:02.382 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load().\n13:29:02.468 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1989 ms.\n13:29:04.503 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg\n13:29:04.504 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg\n13\n...[truncated 905 chars]...\n o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:10.895 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:11.011 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:11.068 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:11.141 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:11.211 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:11.348 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.local.sign.SignableTest", "duration" : 0.124, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "signAndModifySignatureCreatedAndVerify", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:29:01.083 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n13:29:02.382 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load().\n13:29:02.468 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1989 ms.\n13:29:04.503 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg\n13:29:04.504 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg\n13\n...[truncated 905 chars]...\n o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:10.895 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:11.011 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:11.068 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:11.141 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:11.211 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:11.348 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.local.sign.SignableTest", "duration" : 0.213, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "signAndModifyCryptoRepoFileIdAndVerify", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:29:01.083 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n13:29:02.382 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load().\n13:29:02.468 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1989 ms.\n13:29:04.503 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg\n13:29:04.504 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg\n13\n...[truncated 905 chars]...\n o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:10.895 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:11.011 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:11.068 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:11.141 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:11.211 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:11.348 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" } ], "duration" : 3.7770002, "id" : None, "name" : "org.subshare.local.sign.SignableTest", "stderr" : "", "stdout" : "13:29:01.083 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n13:29:02.382 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load().\n13:29:02.468 [Test worker] INFO c.c.c.c.c.ConfigImpl - getLastModifiedAndWaitIfNeeded: Waiting 1989 ms.\n13:29:04.503 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg\n13:29:04.504 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg\n13\n...[truncated 905 chars]...\n o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:10.895 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:11.011 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:11.068 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:11.141 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:11.211 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:29:11.348 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n", "timestamp" : "2020-05-01T11:29:07" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.local.sign.SignerVerifierStreamTest", "duration" : 17.696, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "signRsaWithSha1", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:31:19.202 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load().\n13:31:19.204 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg\n13:31:19.205 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg\n13:31:19.205 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - load: secringFile='/home/tomcat/.gnupg/secring.gpg'\n13:31:19.205 [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\n13:32:24.759 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:32:25.012 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:32:29.213 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.local.sign.SignerVerifierStreamTest", "duration" : 0.559, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "signAndVerifySimpleBlockRead", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:31:19.202 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load().\n13:31:19.204 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg\n13:31:19.205 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg\n13:31:19.205 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - load: secringFile='/home/tomcat/.gnupg/secring.gpg'\n13:31:19.205 [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\n13:32:24.759 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:32:25.012 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:32:29.213 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.local.sign.SignerVerifierStreamTest", "duration" : 22.9, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "sha1Digest", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:31:19.202 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load().\n13:31:19.204 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg\n13:31:19.205 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg\n13:31:19.205 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - load: secringFile='/home/tomcat/.gnupg/secring.gpg'\n13:31:19.205 [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\n13:32:24.759 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:32:25.012 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:32:29.213 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.local.sign.SignerVerifierStreamTest", "duration" : 2.397, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "signAndVerifyRandomBroken", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:31:19.202 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load().\n13:31:19.204 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg\n13:31:19.205 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg\n13:31:19.205 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - load: secringFile='/home/tomcat/.gnupg/secring.gpg'\n13:31:19.205 [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\n13:32:24.759 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:32:25.012 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:32:29.213 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.local.sign.SignerVerifierStreamTest", "duration" : 21.856, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "signAndVerifyRandomManySmall", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:31:19.202 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load().\n13:31:19.204 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg\n13:31:19.205 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg\n13:31:19.205 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - load: secringFile='/home/tomcat/.gnupg/secring.gpg'\n13:31:19.205 [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\n13:32:24.759 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:32:25.012 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:32:29.213 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" }, { "age" : 0, "className" : "org.subshare.local.sign.SignerVerifierStreamTest", "duration" : 4.454, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "signAndVerifyRandom", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:31:19.202 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load().\n13:31:19.204 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg\n13:31:19.205 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg\n13:31:19.205 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - load: secringFile='/home/tomcat/.gnupg/secring.gpg'\n13:31:19.205 [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\n13:32:24.759 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:32:25.012 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:32:29.213 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n" } ], "duration" : 69.862, "id" : None, "name" : "org.subshare.local.sign.SignerVerifierStreamTest", "stderr" : "", "stdout" : "13:31:19.202 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load().\n13:31:19.204 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: dirString=${user.home}/.gnupg\n13:31:19.205 [Test worker] DEBUG o.s.c.p.g.GnuPgDir - getFile: result=/home/tomcat/.gnupg\n13:31:19.205 [Test worker] DEBUG o.s.c.p.g.BcWithLocalGnuPgPgp - load: secringFile='/home/tomcat/.gnupg/secring.gpg'\n13:31:19.205 [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\n13:32:24.759 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:32:25.012 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:32:29.213 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n", "timestamp" : "2020-05-01T11:31:19" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.rest.client.transport.CryptreeRepoTransportTest", "duration" : 42.547, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "encryptAndSignAndVerifyAndDecrypt", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:34:02.408 [Test worker] INFO co.codewizards.cloudstore.core.oio.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n13:34:02.872 [Test worker] DEBUG org.subshare.core.pgp.gnupg.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load().\n13:34:02.898 [Test worker] DEBUG co.codewizards.cloudstore.core.config.ConfigImpl - getPropertyAsNonEmptyTrimmedString: System property with key='subshare.gnupg.dir' is not set (config is queried next).\n13:34:02.899 [Test worker] DEBUG co.codewizar\n...[truncated 48767 chars]...\n\n13:34:44.338 [Test worker] DEBUG co.codewizards.cloudstore.core.config.ConfigImpl - getPropertyAsNonEmptyTrimmedString: System property with key='subshare.symmetricCipherTransformation' is not set (config is queried next).\n\n13:34:44.769 [Test worker] DEBUG org.subshare.rest.client.transport.CryptreeRestRepoTransportImpl - close: There is no localRepoManager.\n13:34:44.769 [Test worker] DEBUG org.subshare.rest.client.transport.CryptreeRestRepoTransportImpl - close: There is no restRepoTransport.\n" } ], "duration" : 42.547, "id" : None, "name" : "org.subshare.rest.client.transport.CryptreeRepoTransportTest", "stderr" : "", "stdout" : "13:34:02.408 [Test worker] INFO co.codewizards.cloudstore.core.oio.OioRegistry - Preferred implementation 'IoFileFactory' for fileFactory\n13:34:02.872 [Test worker] DEBUG org.subshare.core.pgp.gnupg.BcWithLocalGnuPgPgp - loadIfNeeded: invoking load().\n13:34:02.898 [Test worker] DEBUG co.codewizards.cloudstore.core.config.ConfigImpl - getPropertyAsNonEmptyTrimmedString: System property with key='subshare.gnupg.dir' is not set (config is queried next).\n13:34:02.899 [Test worker] DEBUG co.codewizar\n...[truncated 48767 chars]...\n\n13:34:44.338 [Test worker] DEBUG co.codewizards.cloudstore.core.config.ConfigImpl - getPropertyAsNonEmptyTrimmedString: System property with key='subshare.symmetricCipherTransformation' is not set (config is queried next).\n\n13:34:44.769 [Test worker] DEBUG org.subshare.rest.client.transport.CryptreeRestRepoTransportImpl - close: There is no localRepoManager.\n13:34:44.769 [Test worker] DEBUG org.subshare.rest.client.transport.CryptreeRestRepoTransportImpl - close: There is no restRepoTransport.\n", "timestamp" : "2020-05-01T11:34:02" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.BackupRestoreRepoToRepoSyncIT", "duration" : 231.574, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "backupRestoreClientRepo", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "14:06:20.776 [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/2Is7Thk6dNMxtiyHWkdeLw/.subshare/ssl.client\n14:06:20.776 [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/2Is7Thk6dNMxtiyHWkdeLw/.subshare/repoRegistry.properties\n14:06:20.777 [Test work\n...[truncated 5247006 chars]...\nynchronising...: 100.00%\n14:10:12.248 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [52bc680f]getCloseDeferredMillis: closeDeferredMillis=10000\n14:10:12.248 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [52bc680f]close: Deferring shut down of real LocalRepoManager 10000 ms.\n14:10:12.351 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n14:10:13.489 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ieki_2V3Ja82_61rJdjbyQ].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 12, "className" : "org.subshare.test.BackupRestoreRepoToRepoSyncIT", "duration" : 0.0, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 32, "name" : "backupRestoreServerRepo", "skipped" : True, "skippedMessage" : None, "status" : "SKIPPED", "stderr" : "", "stdout" : "14:06:20.776 [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/2Is7Thk6dNMxtiyHWkdeLw/.subshare/ssl.client\n14:06:20.776 [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/2Is7Thk6dNMxtiyHWkdeLw/.subshare/repoRegistry.properties\n14:06:20.777 [Test work\n...[truncated 5247006 chars]...\nynchronising...: 100.00%\n14:10:12.248 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [52bc680f]getCloseDeferredMillis: closeDeferredMillis=10000\n14:10:12.248 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [52bc680f]close: Deferring shut down of real LocalRepoManager 10000 ms.\n14:10:12.351 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n14:10:13.489 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ieki_2V3Ja82_61rJdjbyQ].afterClass: entered. testInstanceCounter=1\n" } ], "duration" : 231.574, "id" : None, "name" : "org.subshare.test.BackupRestoreRepoToRepoSyncIT", "stderr" : "", "stdout" : "14:06:20.776 [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/2Is7Thk6dNMxtiyHWkdeLw/.subshare/ssl.client\n14:06:20.776 [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/2Is7Thk6dNMxtiyHWkdeLw/.subshare/repoRegistry.properties\n14:06:20.777 [Test work\n...[truncated 5247006 chars]...\nynchronising...: 100.00%\n14:10:12.248 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [52bc680f]getCloseDeferredMillis: closeDeferredMillis=10000\n14:10:12.248 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [52bc680f]close: Deferring shut down of real LocalRepoManager 10000 ms.\n14:10:12.351 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n14:10:13.489 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ieki_2V3Ja82_61rJdjbyQ].afterClass: entered. testInstanceCounter=1\n", "timestamp" : "2020-05-01T12:06:20" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.BrokenSignatureIT", "duration" : 247.839, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "uploadBrokenSignature", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:35:03.391 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n13:35:03.633 [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/X9r3P19qpvcf4NWE6PQKMg/.subshare/logback.client.xml\n13:35:03.659 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshar\n...[truncated 6379277 chars]...\n71 common frames omitted\n13:42:40.233 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [17e1799d]getCloseDeferredMillis: closeDeferredMillis=20000\n13:42:40.235 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [17e1799d]close: Deferring shut down of real LocalRepoManager 20000 ms.\n13:42:40.236 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:42:41.114 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [uRTgXqXOkXrPaJxZH2wDjw].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.BrokenSignatureIT", "duration" : 177.129, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "downloadBrokenSignature", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:35:03.391 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n13:35:03.633 [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/X9r3P19qpvcf4NWE6PQKMg/.subshare/logback.client.xml\n13:35:03.659 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshar\n...[truncated 6379277 chars]...\n71 common frames omitted\n13:42:40.233 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [17e1799d]getCloseDeferredMillis: closeDeferredMillis=20000\n13:42:40.235 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [17e1799d]close: Deferring shut down of real LocalRepoManager 20000 ms.\n13:42:40.236 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:42:41.114 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [uRTgXqXOkXrPaJxZH2wDjw].afterClass: entered. testInstanceCounter=1\n" } ], "duration" : 424.96802, "id" : None, "name" : "org.subshare.test.BrokenSignatureIT", "stderr" : "", "stdout" : "13:35:03.391 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n13:35:03.633 [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/X9r3P19qpvcf4NWE6PQKMg/.subshare/logback.client.xml\n13:35:03.659 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshar\n...[truncated 6379277 chars]...\n71 common frames omitted\n13:42:40.233 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [17e1799d]getCloseDeferredMillis: closeDeferredMillis=20000\n13:42:40.235 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [17e1799d]close: Deferring shut down of real LocalRepoManager 20000 ms.\n13:42:40.236 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:42:41.114 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [uRTgXqXOkXrPaJxZH2wDjw].afterClass: entered. testInstanceCounter=1\n", "timestamp" : "2020-05-01T11:35:35" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.CollisionOnClientRepoToRepoSyncIT", "duration" : 186.458, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "newFileVsNewFileCollisionOnClient", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:58:56.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/81pW-yU00IIhc0aF8UhtLA/.subshare/localServer.properties\n13:58:56.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/81pW-yU00IIhc0aF8UhtLA/.subshare/ssl.client\n13:58:56.595 [Test worker] INFO \n...[truncated 31539714 chars]...\ncalRepoManager 20000 ms.\n14:17:42.378 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [172a963e]getCloseDeferredMillis: closeDeferredMillis=20000\n14:17:42.378 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [172a963e]close: Deferring shut down of real LocalRepoManager 20000 ms.\n14:17:42.378 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n14:17:43.286 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [erqwqH8bgcqqV0CSrIxleQ].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.CollisionOnClientRepoToRepoSyncIT", "duration" : 195.495, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "newDirectoryVsNewDirectoryCollisionOnClient", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:58:56.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/81pW-yU00IIhc0aF8UhtLA/.subshare/localServer.properties\n13:58:56.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/81pW-yU00IIhc0aF8UhtLA/.subshare/ssl.client\n13:58:56.595 [Test worker] INFO \n...[truncated 31539714 chars]...\ncalRepoManager 20000 ms.\n14:17:42.378 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [172a963e]getCloseDeferredMillis: closeDeferredMillis=20000\n14:17:42.378 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [172a963e]close: Deferring shut down of real LocalRepoManager 20000 ms.\n14:17:42.378 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n14:17:43.286 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [erqwqH8bgcqqV0CSrIxleQ].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.CollisionOnClientRepoToRepoSyncIT", "duration" : 218.397, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "modifiedFileVsDeletedFileCollisionOnClient", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:58:56.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/81pW-yU00IIhc0aF8UhtLA/.subshare/localServer.properties\n13:58:56.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/81pW-yU00IIhc0aF8UhtLA/.subshare/ssl.client\n13:58:56.595 [Test worker] INFO \n...[truncated 31539714 chars]...\ncalRepoManager 20000 ms.\n14:17:42.378 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [172a963e]getCloseDeferredMillis: closeDeferredMillis=20000\n14:17:42.378 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [172a963e]close: Deferring shut down of real LocalRepoManager 20000 ms.\n14:17:42.378 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n14:17:43.286 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [erqwqH8bgcqqV0CSrIxleQ].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.CollisionOnClientRepoToRepoSyncIT", "duration" : 251.232, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "modifiedFileVsModifiedFileCollisionOnClient", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:58:56.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/81pW-yU00IIhc0aF8UhtLA/.subshare/localServer.properties\n13:58:56.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/81pW-yU00IIhc0aF8UhtLA/.subshare/ssl.client\n13:58:56.595 [Test worker] INFO \n...[truncated 31539714 chars]...\ncalRepoManager 20000 ms.\n14:17:42.378 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [172a963e]getCloseDeferredMillis: closeDeferredMillis=20000\n14:17:42.378 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [172a963e]close: Deferring shut down of real LocalRepoManager 20000 ms.\n14:17:42.378 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n14:17:43.286 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [erqwqH8bgcqqV0CSrIxleQ].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.CollisionOnClientRepoToRepoSyncIT", "duration" : 157.956, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "deletedFileVsModifiedFileCollisionOnClient", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:58:56.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/81pW-yU00IIhc0aF8UhtLA/.subshare/localServer.properties\n13:58:56.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/81pW-yU00IIhc0aF8UhtLA/.subshare/ssl.client\n13:58:56.595 [Test worker] INFO \n...[truncated 31539714 chars]...\ncalRepoManager 20000 ms.\n14:17:42.378 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [172a963e]getCloseDeferredMillis: closeDeferredMillis=20000\n14:17:42.378 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [172a963e]close: Deferring shut down of real LocalRepoManager 20000 ms.\n14:17:42.378 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n14:17:43.286 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [erqwqH8bgcqqV0CSrIxleQ].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.CollisionOnClientRepoToRepoSyncIT", "duration" : 116.244, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "newFileVsNewDirectoryCollisionOnClient", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:58:56.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/81pW-yU00IIhc0aF8UhtLA/.subshare/localServer.properties\n13:58:56.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/81pW-yU00IIhc0aF8UhtLA/.subshare/ssl.client\n13:58:56.595 [Test worker] INFO \n...[truncated 31539714 chars]...\ncalRepoManager 20000 ms.\n14:17:42.378 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [172a963e]getCloseDeferredMillis: closeDeferredMillis=20000\n14:17:42.378 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [172a963e]close: Deferring shut down of real LocalRepoManager 20000 ms.\n14:17:42.378 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n14:17:43.286 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [erqwqH8bgcqqV0CSrIxleQ].afterClass: entered. testInstanceCounter=1\n" } ], "duration" : 1125.782, "id" : None, "name" : "org.subshare.test.CollisionOnClientRepoToRepoSyncIT", "stderr" : "", "stdout" : "13:58:56.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/81pW-yU00IIhc0aF8UhtLA/.subshare/localServer.properties\n13:58:56.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/81pW-yU00IIhc0aF8UhtLA/.subshare/ssl.client\n13:58:56.595 [Test worker] INFO \n...[truncated 31539714 chars]...\ncalRepoManager 20000 ms.\n14:17:42.378 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [172a963e]getCloseDeferredMillis: closeDeferredMillis=20000\n14:17:42.378 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [172a963e]close: Deferring shut down of real LocalRepoManager 20000 ms.\n14:17:42.378 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n14:17:43.286 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [erqwqH8bgcqqV0CSrIxleQ].afterClass: entered. testInstanceCounter=1\n", "timestamp" : "2020-05-01T11:58:56" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.CollisionOnServerRepoToRepoSyncIT", "duration" : 447.158, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "newFileVsNewFileUploadedCollisionOnServer", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:35:04.530 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n13:35:04.784 [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/3t8eSl8-XkHDYbaGBchBEQ/.subshare/logback.client.xml\n13:35:04.806 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshar\n...[truncated 15500443 chars]...\ncalRepoManager 20000 ms.\n13:52:30.461 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [7f33d883]getCloseDeferredMillis: closeDeferredMillis=20000\n13:52:30.463 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [7f33d883]close: Deferring shut down of real LocalRepoManager 20000 ms.\n13:52:30.464 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:52:31.720 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [OSE5Zl8OBik-yJAjA0gm9w].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.CollisionOnServerRepoToRepoSyncIT", "duration" : 560.402, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "newFileVsNewFileUploadingCollisionOnServer", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:35:04.530 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n13:35:04.784 [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/3t8eSl8-XkHDYbaGBchBEQ/.subshare/logback.client.xml\n13:35:04.806 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshar\n...[truncated 15500443 chars]...\ncalRepoManager 20000 ms.\n13:52:30.461 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [7f33d883]getCloseDeferredMillis: closeDeferredMillis=20000\n13:52:30.463 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [7f33d883]close: Deferring shut down of real LocalRepoManager 20000 ms.\n13:52:30.464 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:52:31.720 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [OSE5Zl8OBik-yJAjA0gm9w].afterClass: entered. testInstanceCounter=1\n" } ], "duration" : 1007.55994, "id" : None, "name" : "org.subshare.test.CollisionOnServerRepoToRepoSyncIT", "stderr" : "", "stdout" : "13:35:04.530 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n13:35:04.784 [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/3t8eSl8-XkHDYbaGBchBEQ/.subshare/logback.client.xml\n13:35:04.806 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshar\n...[truncated 15500443 chars]...\ncalRepoManager 20000 ms.\n13:52:30.461 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [7f33d883]getCloseDeferredMillis: closeDeferredMillis=20000\n13:52:30.463 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [7f33d883]close: Deferring shut down of real LocalRepoManager 20000 ms.\n13:52:30.464 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:52:31.720 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [OSE5Zl8OBik-yJAjA0gm9w].afterClass: entered. testInstanceCounter=1\n", "timestamp" : "2020-05-01T11:35:42" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.IgnoreRuleRepoToRepoSyncIT", "duration" : 425.569, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "ignoreRulesAddedAfterFilesSynced", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:35:05.633 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n13:35:05.987 [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/81pW-yU00IIhc0aF8UhtLA/.subshare/logback.client.xml\n13:35:06.023 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshar\n...[truncated 18036842 chars]...\ncalRepoManager 20000 ms.\n13:50:17.076 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [78717e77]getCloseDeferredMillis: closeDeferredMillis=20000\n13:50:17.076 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [78717e77]close: Deferring shut down of real LocalRepoManager 20000 ms.\n13:50:17.077 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:50:18.187 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [erqwqH8bgcqqV0CSrIxleQ].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.IgnoreRuleRepoToRepoSyncIT", "duration" : 224.482, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "ignoreRulesBecomeDisabled", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:35:05.633 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n13:35:05.987 [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/81pW-yU00IIhc0aF8UhtLA/.subshare/logback.client.xml\n13:35:06.023 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshar\n...[truncated 18036842 chars]...\ncalRepoManager 20000 ms.\n13:50:17.076 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [78717e77]getCloseDeferredMillis: closeDeferredMillis=20000\n13:50:17.076 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [78717e77]close: Deferring shut down of real LocalRepoManager 20000 ms.\n13:50:17.077 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:50:18.187 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [erqwqH8bgcqqV0CSrIxleQ].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.IgnoreRuleRepoToRepoSyncIT", "duration" : 235.892, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "ignoreRulesExistBeforeAffectedFiles", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:35:05.633 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n13:35:05.987 [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/81pW-yU00IIhc0aF8UhtLA/.subshare/logback.client.xml\n13:35:06.023 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshar\n...[truncated 18036842 chars]...\ncalRepoManager 20000 ms.\n13:50:17.076 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [78717e77]getCloseDeferredMillis: closeDeferredMillis=20000\n13:50:17.076 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [78717e77]close: Deferring shut down of real LocalRepoManager 20000 ms.\n13:50:17.077 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:50:18.187 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [erqwqH8bgcqqV0CSrIxleQ].afterClass: entered. testInstanceCounter=1\n" } ], "duration" : 885.943, "id" : None, "name" : "org.subshare.test.IgnoreRuleRepoToRepoSyncIT", "stderr" : "", "stdout" : "13:35:05.633 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n13:35:05.987 [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/81pW-yU00IIhc0aF8UhtLA/.subshare/logback.client.xml\n13:35:06.023 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshar\n...[truncated 18036842 chars]...\ncalRepoManager 20000 ms.\n13:50:17.076 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [78717e77]getCloseDeferredMillis: closeDeferredMillis=20000\n13:50:17.076 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [78717e77]close: Deferring shut down of real LocalRepoManager 20000 ms.\n13:50:17.077 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:50:18.187 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [erqwqH8bgcqqV0CSrIxleQ].afterClass: entered. testInstanceCounter=1\n", "timestamp" : "2020-05-01T11:35:31" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.InterruptedRepoToRepoSyncIT", "duration" : 173.533, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "interruptSyncDownAndResume", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:52:31.744 [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/3t8eSl8-XkHDYbaGBchBEQ/.subshare/localServer.properties\n13:52:31.744 [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/3t8eSl8-XkHDYbaGBchBEQ/.subshare/ssl.client\n13:52:31.744 [Test worker] INFO \n...[truncated 8376159 chars]...\ncalRepoManager 20000 ms.\n13:57:54.641 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [234857e5]getCloseDeferredMillis: closeDeferredMillis=20000\n13:57:54.641 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [234857e5]close: Deferring shut down of real LocalRepoManager 20000 ms.\n13:57:54.642 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:57:55.650 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [OSE5Zl8OBik-yJAjA0gm9w].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.InterruptedRepoToRepoSyncIT", "duration" : 149.364, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "interruptSyncUpAndResume", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:52:31.744 [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/3t8eSl8-XkHDYbaGBchBEQ/.subshare/localServer.properties\n13:52:31.744 [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/3t8eSl8-XkHDYbaGBchBEQ/.subshare/ssl.client\n13:52:31.744 [Test worker] INFO \n...[truncated 8376159 chars]...\ncalRepoManager 20000 ms.\n13:57:54.641 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [234857e5]getCloseDeferredMillis: closeDeferredMillis=20000\n13:57:54.641 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [234857e5]close: Deferring shut down of real LocalRepoManager 20000 ms.\n13:57:54.642 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:57:55.650 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [OSE5Zl8OBik-yJAjA0gm9w].afterClass: entered. testInstanceCounter=1\n" } ], "duration" : 322.897, "id" : None, "name" : "org.subshare.test.InterruptedRepoToRepoSyncIT", "stderr" : "", "stdout" : "13:52:31.744 [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/3t8eSl8-XkHDYbaGBchBEQ/.subshare/localServer.properties\n13:52:31.744 [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/3t8eSl8-XkHDYbaGBchBEQ/.subshare/ssl.client\n13:52:31.744 [Test worker] INFO \n...[truncated 8376159 chars]...\ncalRepoManager 20000 ms.\n13:57:54.641 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [234857e5]getCloseDeferredMillis: closeDeferredMillis=20000\n13:57:54.641 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [234857e5]close: Deferring shut down of real LocalRepoManager 20000 ms.\n13:57:54.642 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:57:55.650 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [OSE5Zl8OBik-yJAjA0gm9w].afterClass: entered. testInstanceCounter=1\n", "timestamp" : "2020-05-01T11:52:31" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.InviteUserAndSyncIT", "duration" : 196.571, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "inviteUserAndSync_singleReadPermissionOnSubdir", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "14:03:54.331 [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/V5f2AC73BexfCPODkEKbew/.subshare/ssl.client\n14:03:54.331 [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/V5f2AC73BexfCPODkEKbew/.subshare/serverRepoRegistry.subshare\n14:03:54.332 [Test \n...[truncated 16231604 chars]...\ncalRepoManager 20000 ms.\n14:14:46.953 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [721c891b]getCloseDeferredMillis: closeDeferredMillis=20000\n14:14:46.953 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [721c891b]close: Deferring shut down of real LocalRepoManager 20000 ms.\n14:14:46.954 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n14:14:47.455 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ZZQrOz4-vS0r6LxXVU5YxA].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.InviteUserAndSyncIT", "duration" : 239.915, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "inviteUserAndSync_singleWritePermissionOnRoot", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "14:03:54.331 [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/V5f2AC73BexfCPODkEKbew/.subshare/ssl.client\n14:03:54.331 [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/V5f2AC73BexfCPODkEKbew/.subshare/serverRepoRegistry.subshare\n14:03:54.332 [Test \n...[truncated 16231604 chars]...\ncalRepoManager 20000 ms.\n14:14:46.953 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [721c891b]getCloseDeferredMillis: closeDeferredMillis=20000\n14:14:46.953 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [721c891b]close: Deferring shut down of real LocalRepoManager 20000 ms.\n14:14:46.954 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n14:14:47.455 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ZZQrOz4-vS0r6LxXVU5YxA].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.InviteUserAndSyncIT", "duration" : 216.137, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "inviteUserAndSync_singleReadPermissionOnRoot", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "14:03:54.331 [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/V5f2AC73BexfCPODkEKbew/.subshare/ssl.client\n14:03:54.331 [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/V5f2AC73BexfCPODkEKbew/.subshare/serverRepoRegistry.subshare\n14:03:54.332 [Test \n...[truncated 16231604 chars]...\ncalRepoManager 20000 ms.\n14:14:46.953 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [721c891b]getCloseDeferredMillis: closeDeferredMillis=20000\n14:14:46.953 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [721c891b]close: Deferring shut down of real LocalRepoManager 20000 ms.\n14:14:46.954 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n14:14:47.455 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ZZQrOz4-vS0r6LxXVU5YxA].afterClass: entered. testInstanceCounter=1\n" } ], "duration" : 652.623, "id" : None, "name" : "org.subshare.test.InviteUserAndSyncIT", "stderr" : "", "stdout" : "14:03:54.331 [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/V5f2AC73BexfCPODkEKbew/.subshare/ssl.client\n14:03:54.331 [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/V5f2AC73BexfCPODkEKbew/.subshare/serverRepoRegistry.subshare\n14:03:54.332 [Test \n...[truncated 16231604 chars]...\ncalRepoManager 20000 ms.\n14:14:46.953 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [721c891b]getCloseDeferredMillis: closeDeferredMillis=20000\n14:14:46.953 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [721c891b]close: Deferring shut down of real LocalRepoManager 20000 ms.\n14:14:46.954 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n14:14:47.455 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ZZQrOz4-vS0r6LxXVU5YxA].afterClass: entered. testInstanceCounter=1\n", "timestamp" : "2020-05-01T12:03:54" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.InviteUserWithNormalAndMetaOnlyRepoIT", "duration" : 335.926, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "inviteUserAndSync_withMetaOnly_singleWritePermissionOnRoot", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:46:35.472 [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/2Is7Thk6dNMxtiyHWkdeLw/.subshare/localServer.properties\n13:46:35.472 [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/2Is7Thk6dNMxtiyHWkdeLw/.subshare/ssl.client\n13:46:35.473 [Test worker] INFO \n...[truncated 7143480 chars]...\nLocalRepoManager 20000 ms.\n13:52:11.393 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [b664534]getCloseDeferredMillis: closeDeferredMillis=20000\n13:52:11.393 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [b664534]close: Deferring shut down of real LocalRepoManager 20000 ms.\n13:52:11.402 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:52:12.122 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ieki_2V3Ja82_61rJdjbyQ].afterClass: entered. testInstanceCounter=1\n" } ], "duration" : 335.926, "id" : None, "name" : "org.subshare.test.InviteUserWithNormalAndMetaOnlyRepoIT", "stderr" : "", "stdout" : "13:46:35.472 [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/2Is7Thk6dNMxtiyHWkdeLw/.subshare/localServer.properties\n13:46:35.472 [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/2Is7Thk6dNMxtiyHWkdeLw/.subshare/ssl.client\n13:46:35.473 [Test worker] INFO \n...[truncated 7143480 chars]...\nLocalRepoManager 20000 ms.\n13:52:11.393 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [b664534]getCloseDeferredMillis: closeDeferredMillis=20000\n13:52:11.393 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [b664534]close: Deferring shut down of real LocalRepoManager 20000 ms.\n13:52:11.402 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:52:12.122 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ieki_2V3Ja82_61rJdjbyQ].afterClass: entered. testInstanceCounter=1\n", "timestamp" : "2020-05-01T11:46:35" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.Issue4IT", "duration" : 149.658, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "issue_4_syncFileDeletedAfterLocalSync", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:42:41.145 [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/X9r3P19qpvcf4NWE6PQKMg/.subshare/localServer.properties\n13:42:41.157 [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/X9r3P19qpvcf4NWE6PQKMg/.subshare/ssl.client\n13:42:41.157 [Test worker] INFO \n...[truncated 3103326 chars]...\nynchronising...: 100.00%\n13:45:10.821 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4448ea76]getCloseDeferredMillis: closeDeferredMillis=20000\n13:45:10.821 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4448ea76]close: Deferring shut down of real LocalRepoManager 20000 ms.\n13:45:10.821 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:45:12.354 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [uRTgXqXOkXrPaJxZH2wDjw].afterClass: entered. testInstanceCounter=1\n" } ], "duration" : 149.658, "id" : None, "name" : "org.subshare.test.Issue4IT", "stderr" : "", "stdout" : "13:42:41.145 [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/X9r3P19qpvcf4NWE6PQKMg/.subshare/localServer.properties\n13:42:41.157 [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/X9r3P19qpvcf4NWE6PQKMg/.subshare/ssl.client\n13:42:41.157 [Test worker] INFO \n...[truncated 3103326 chars]...\nynchronising...: 100.00%\n13:45:10.821 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4448ea76]getCloseDeferredMillis: closeDeferredMillis=20000\n13:45:10.821 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [4448ea76]close: Deferring shut down of real LocalRepoManager 20000 ms.\n13:45:10.821 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:45:12.354 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [uRTgXqXOkXrPaJxZH2wDjw].afterClass: entered. testInstanceCounter=1\n", "timestamp" : "2020-05-01T11:42:41" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.Issue5IT", "duration" : 474.78, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "issue_5_inviteMultipleFriends", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:35:04.756 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n13:35:05.227 [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/V5f2AC73BexfCPODkEKbew/.subshare/logback.client.xml\n13:35:05.282 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshar\n...[truncated 8044209 chars]...\ncalRepoManager 20000 ms.\n13:43:24.383 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [7eb6e90b]getCloseDeferredMillis: closeDeferredMillis=20000\n13:43:24.383 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [7eb6e90b]close: Deferring shut down of real LocalRepoManager 20000 ms.\n13:43:24.384 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:43:24.897 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ZZQrOz4-vS0r6LxXVU5YxA].afterClass: entered. testInstanceCounter=1\n" } ], "duration" : 474.78, "id" : None, "name" : "org.subshare.test.Issue5IT", "stderr" : "", "stdout" : "13:35:04.756 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n13:35:05.227 [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/V5f2AC73BexfCPODkEKbew/.subshare/logback.client.xml\n13:35:05.282 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshar\n...[truncated 8044209 chars]...\ncalRepoManager 20000 ms.\n13:43:24.383 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [7eb6e90b]getCloseDeferredMillis: closeDeferredMillis=20000\n13:43:24.383 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [7eb6e90b]close: Deferring shut down of real LocalRepoManager 20000 ms.\n13:43:24.384 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:43:24.897 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ZZQrOz4-vS0r6LxXVU5YxA].afterClass: entered. testInstanceCounter=1\n", "timestamp" : "2020-05-01T11:35:29" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.Issue8IT", "duration" : 514.399, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "issue_8_threesomeWithFreshmen", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:50:18.251 [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/81pW-yU00IIhc0aF8UhtLA/.subshare/localServer.properties\n13:50:18.251 [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/81pW-yU00IIhc0aF8UhtLA/.subshare/ssl.client\n13:50:18.251 [Test worker] INFO \n...[truncated 11839244 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')\n13:58:52.650 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [76675359]close: Deferring shut down of real LocalRepoManager 20000 ms.\n13:58:56.568 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [erqwqH8bgcqqV0CSrIxleQ].afterClass: entered. testInstanceCounter=1\n" } ], "duration" : 514.399, "id" : None, "name" : "org.subshare.test.Issue8IT", "stderr" : "", "stdout" : "13:50:18.251 [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/81pW-yU00IIhc0aF8UhtLA/.subshare/localServer.properties\n13:50:18.251 [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/81pW-yU00IIhc0aF8UhtLA/.subshare/ssl.client\n13:50:18.251 [Test worker] INFO \n...[truncated 11839244 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')\n13:58:52.650 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [76675359]close: Deferring shut down of real LocalRepoManager 20000 ms.\n13:58:56.568 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [erqwqH8bgcqqV0CSrIxleQ].afterClass: entered. testInstanceCounter=1\n", "timestamp" : "2020-05-01T11:50:18" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.LocalServerClientIT", "duration" : 1.127, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "invokeSimpleStaticMethod", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:43:24.936 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ZZQrOz4-vS0r6LxXVU5YxA].beforeClass: entered. testInstanceCounter=1\n13:43:25.552 [Test worker] INFO c.c.c.l.s.LocalServer - logMemoryStats: max=512.0 MiB, allocated=165.0 MiB, used=95.3 MiB, available=416.7 MiB\n13:43:26.752 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:43:27.872 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:43:28.323 [Test worker] INFO o.s.c.p.PgpRegistry - clearCach\n...[truncated 64999 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)\n13:43:31.768 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:43:42.840 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ZZQrOz4-vS0r6LxXVU5YxA].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.LocalServerClientIT", "duration" : 3.892, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "invokeDeniedMethods", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:43:24.936 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ZZQrOz4-vS0r6LxXVU5YxA].beforeClass: entered. testInstanceCounter=1\n13:43:25.552 [Test worker] INFO c.c.c.l.s.LocalServer - logMemoryStats: max=512.0 MiB, allocated=165.0 MiB, used=95.3 MiB, available=416.7 MiB\n13:43:26.752 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:43:27.872 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:43:28.323 [Test worker] INFO o.s.c.p.PgpRegistry - clearCach\n...[truncated 64999 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)\n13:43:31.768 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:43:42.840 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ZZQrOz4-vS0r6LxXVU5YxA].afterClass: entered. testInstanceCounter=1\n" } ], "duration" : 5.019, "id" : None, "name" : "org.subshare.test.LocalServerClientIT", "stderr" : "", "stdout" : "13:43:24.936 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ZZQrOz4-vS0r6LxXVU5YxA].beforeClass: entered. testInstanceCounter=1\n13:43:25.552 [Test worker] INFO c.c.c.l.s.LocalServer - logMemoryStats: max=512.0 MiB, allocated=165.0 MiB, used=95.3 MiB, available=416.7 MiB\n13:43:26.752 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:43:27.872 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:43:28.323 [Test worker] INFO o.s.c.p.PgpRegistry - clearCach\n...[truncated 64999 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)\n13:43:31.768 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:43:42.840 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ZZQrOz4-vS0r6LxXVU5YxA].afterClass: entered. testInstanceCounter=1\n", "timestamp" : "2020-05-01T11:43:26" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.LockerSyncIT", "duration" : 18.24, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncServerRegistry", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "14:03:18.477 [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/V5f2AC73BexfCPODkEKbew/.subshare/ssl.client\n14:03:18.477 [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/V5f2AC73BexfCPODkEKbew/.subshare/repoRegistry.properties\n14:03:18.477 [Test work\n...[truncated 176832 chars]...\neyIds=[a58da7d810b74edf]\n14:03:50.702 [Test worker] DEBUG o.s.c.p.g.BcPgpDecoder - verifySignature: signingPgpKeyIds=[d7a92a24aa97ddbd]\n14:03:51.369 [Timer-3] DEBUG c.c.c.r.c.CloudStoreRestClient - execute: starting try 2 of 3\n14:03:51.378 [Timer-3] DEBUG c.c.c.r.c.CloudStoreRestClient - determineBaseUrl: hostURL='https://server1.domain.tld:12345/': entered.\n14:03:54.274 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ZZQrOz4-vS0r6LxXVU5YxA].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.LockerSyncIT", "duration" : 14.028, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncUserRegistry", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "14:03:18.477 [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/V5f2AC73BexfCPODkEKbew/.subshare/ssl.client\n14:03:18.477 [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/V5f2AC73BexfCPODkEKbew/.subshare/repoRegistry.properties\n14:03:18.477 [Test work\n...[truncated 176832 chars]...\neyIds=[a58da7d810b74edf]\n14:03:50.702 [Test worker] DEBUG o.s.c.p.g.BcPgpDecoder - verifySignature: signingPgpKeyIds=[d7a92a24aa97ddbd]\n14:03:51.369 [Timer-3] DEBUG c.c.c.r.c.CloudStoreRestClient - execute: starting try 2 of 3\n14:03:51.378 [Timer-3] DEBUG c.c.c.r.c.CloudStoreRestClient - determineBaseUrl: hostURL='https://server1.domain.tld:12345/': entered.\n14:03:54.274 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ZZQrOz4-vS0r6LxXVU5YxA].afterClass: entered. testInstanceCounter=1\n" } ], "duration" : 32.267998, "id" : None, "name" : "org.subshare.test.LockerSyncIT", "stderr" : "", "stdout" : "14:03:18.477 [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/V5f2AC73BexfCPODkEKbew/.subshare/ssl.client\n14:03:18.477 [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/V5f2AC73BexfCPODkEKbew/.subshare/repoRegistry.properties\n14:03:18.477 [Test work\n...[truncated 176832 chars]...\neyIds=[a58da7d810b74edf]\n14:03:50.702 [Test worker] DEBUG o.s.c.p.g.BcPgpDecoder - verifySignature: signingPgpKeyIds=[d7a92a24aa97ddbd]\n14:03:51.369 [Timer-3] DEBUG c.c.c.r.c.CloudStoreRestClient - execute: starting try 2 of 3\n14:03:51.378 [Timer-3] DEBUG c.c.c.r.c.CloudStoreRestClient - determineBaseUrl: hostURL='https://server1.domain.tld:12345/': entered.\n14:03:54.274 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ZZQrOz4-vS0r6LxXVU5YxA].afterClass: entered. testInstanceCounter=1\n", "timestamp" : "2020-05-01T12:03:18" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.MetaOnlyRepoSyncIT", "duration" : 305.21, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncFromLocalToRemoteToMetaOnlyAddingFiles", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:35:04.436 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n13:35:04.850 [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/2Is7Thk6dNMxtiyHWkdeLw/.subshare/logback.client.xml\n13:35:04.903 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshar\n...[truncated 11424382 chars]...\ncalRepoManager 20000 ms.\n13:46:33.745 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [680a109e]getCloseDeferredMillis: closeDeferredMillis=20000\n13:46:33.745 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [680a109e]close: Deferring shut down of real LocalRepoManager 20000 ms.\n13:46:33.749 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:46:35.293 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ieki_2V3Ja82_61rJdjbyQ].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.MetaOnlyRepoSyncIT", "duration" : 180.59, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncFromLocalToRemoteToMetaOnly", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:35:04.436 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n13:35:04.850 [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/2Is7Thk6dNMxtiyHWkdeLw/.subshare/logback.client.xml\n13:35:04.903 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshar\n...[truncated 11424382 chars]...\ncalRepoManager 20000 ms.\n13:46:33.745 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [680a109e]getCloseDeferredMillis: closeDeferredMillis=20000\n13:46:33.745 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [680a109e]close: Deferring shut down of real LocalRepoManager 20000 ms.\n13:46:33.749 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:46:35.293 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ieki_2V3Ja82_61rJdjbyQ].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.MetaOnlyRepoSyncIT", "duration" : 175.747, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncFromLocalToRemoteToMetaOnlyRemovingFiles", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:35:04.436 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n13:35:04.850 [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/2Is7Thk6dNMxtiyHWkdeLw/.subshare/logback.client.xml\n13:35:04.903 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshar\n...[truncated 11424382 chars]...\ncalRepoManager 20000 ms.\n13:46:33.745 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [680a109e]getCloseDeferredMillis: closeDeferredMillis=20000\n13:46:33.745 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [680a109e]close: Deferring shut down of real LocalRepoManager 20000 ms.\n13:46:33.749 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:46:35.293 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ieki_2V3Ja82_61rJdjbyQ].afterClass: entered. testInstanceCounter=1\n" } ], "duration" : 661.547, "id" : None, "name" : "org.subshare.test.MetaOnlyRepoSyncIT", "stderr" : "", "stdout" : "13:35:04.436 [Test worker] INFO c.c.c.c.o.OioRegistry - Preferred implementation 'NioFileFactory' for fileFactory\n13:35:04.850 [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/2Is7Thk6dNMxtiyHWkdeLw/.subshare/logback.client.xml\n13:35:04.903 [Test worker] INFO o.s.t.AbstractIT - abstractIT_beforeClass: Deleting recursively: /home/tomcat/.jenkins/workspace/org.subshar\n...[truncated 11424382 chars]...\ncalRepoManager 20000 ms.\n13:46:33.745 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [680a109e]getCloseDeferredMillis: closeDeferredMillis=20000\n13:46:33.745 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [680a109e]close: Deferring shut down of real LocalRepoManager 20000 ms.\n13:46:33.749 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:46:35.293 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ieki_2V3Ja82_61rJdjbyQ].afterClass: entered. testInstanceCounter=1\n", "timestamp" : "2020-05-01T11:35:32" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.MultiplePgpKeysSingleUserRegistryIT", "duration" : 4.408, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "multiplePgpKeysSingleUserRegistry", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "14:21:06.615 [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/3t8eSl8-XkHDYbaGBchBEQ/.subshare/localServer.properties\n14:21:06.615 [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/3t8eSl8-XkHDYbaGBchBEQ/.subshare/ssl.client\n14:21:06.615 [Test worker] INFO \n...[truncated 4285 chars]...\nrRepoKey: pgpKey=PgpKey[bbef20af171556db, [Alexander Bieber (TEST) ]], userRepoKey=UserRepoKeyImpl[userRepoKeyId=cKdUe8NfsjlmpgXm5Kp5rQ, invitation=false]\n14:21:10.947 [Test worker] DEBUG o.s.c.p.g.BcPgpDecoder - verifySignature: signingPgpKeyIds=[d7a92a24aa97ddbd]\n14:21:11.024 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n14:21:11.453 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [OSE5Zl8OBik-yJAjA0gm9w].afterClass: entered. testInstanceCounter=1\n" } ], "duration" : 4.408, "id" : None, "name" : "org.subshare.test.MultiplePgpKeysSingleUserRegistryIT", "stderr" : "", "stdout" : "14:21:06.615 [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/3t8eSl8-XkHDYbaGBchBEQ/.subshare/localServer.properties\n14:21:06.615 [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/3t8eSl8-XkHDYbaGBchBEQ/.subshare/ssl.client\n14:21:06.615 [Test worker] INFO \n...[truncated 4285 chars]...\nrRepoKey: pgpKey=PgpKey[bbef20af171556db, [Alexander Bieber (TEST) ]], userRepoKey=UserRepoKeyImpl[userRepoKeyId=cKdUe8NfsjlmpgXm5Kp5rQ, invitation=false]\n14:21:10.947 [Test worker] DEBUG o.s.c.p.g.BcPgpDecoder - verifySignature: signingPgpKeyIds=[d7a92a24aa97ddbd]\n14:21:11.024 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n14:21:11.453 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [OSE5Zl8OBik-yJAjA0gm9w].afterClass: entered. testInstanceCounter=1\n", "timestamp" : "2020-05-01T12:21:06" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.PathPrefixedConfigInheritanceRepoToRepoSyncIT", "duration" : 303.728, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "parentConfigWithRemotePathPrefix", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:45:12.368 [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/X9r3P19qpvcf4NWE6PQKMg/.subshare/localServer.properties\n13:45:12.368 [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/X9r3P19qpvcf4NWE6PQKMg/.subshare/ssl.client\n13:45:12.368 [Test worker] INFO \n...[truncated 8300354 chars]...\ncalRepoManager 20000 ms.\n13:50:16.093 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [25a3a466]getCloseDeferredMillis: closeDeferredMillis=20000\n13:50:16.093 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [25a3a466]close: Deferring shut down of real LocalRepoManager 20000 ms.\n13:50:16.097 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:50:17.587 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [uRTgXqXOkXrPaJxZH2wDjw].afterClass: entered. testInstanceCounter=1\n" } ], "duration" : 303.728, "id" : None, "name" : "org.subshare.test.PathPrefixedConfigInheritanceRepoToRepoSyncIT", "stderr" : "", "stdout" : "13:45:12.368 [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/X9r3P19qpvcf4NWE6PQKMg/.subshare/localServer.properties\n13:45:12.368 [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/X9r3P19qpvcf4NWE6PQKMg/.subshare/ssl.client\n13:45:12.368 [Test worker] INFO \n...[truncated 8300354 chars]...\ncalRepoManager 20000 ms.\n13:50:16.093 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [25a3a466]getCloseDeferredMillis: closeDeferredMillis=20000\n13:50:16.093 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [25a3a466]close: Deferring shut down of real LocalRepoManager 20000 ms.\n13:50:16.097 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:50:17.587 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [uRTgXqXOkXrPaJxZH2wDjw].afterClass: entered. testInstanceCounter=1\n", "timestamp" : "2020-05-01T11:45:12" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.PermissionIT", "duration" : 270.363, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "interruptPermissionSetInheritance", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:52:12.145 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ieki_2V3Ja82_61rJdjbyQ].beforeClass: entered. testInstanceCounter=1\n13:52:12.155 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:52:13.425 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [65467c16]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/repo/k9o50inh-xeaxn-local-src'\n13:52:13.437 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [65467\n...[truncated 21476626 chars]...\ncalRepoManager 20000 ms.\n14:06:19.857 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5db0d57c]getCloseDeferredMillis: closeDeferredMillis=20000\n14:06:19.857 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5db0d57c]close: Deferring shut down of real LocalRepoManager 20000 ms.\n14:06:19.862 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n14:06:20.750 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ieki_2V3Ja82_61rJdjbyQ].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.PermissionIT", "duration" : 292.858, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "uploadBackdatedSignature", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:52:12.145 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ieki_2V3Ja82_61rJdjbyQ].beforeClass: entered. testInstanceCounter=1\n13:52:12.155 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:52:13.425 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [65467c16]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/repo/k9o50inh-xeaxn-local-src'\n13:52:13.437 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [65467\n...[truncated 21476626 chars]...\ncalRepoManager 20000 ms.\n14:06:19.857 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5db0d57c]getCloseDeferredMillis: closeDeferredMillis=20000\n14:06:19.857 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5db0d57c]close: Deferring shut down of real LocalRepoManager 20000 ms.\n14:06:19.862 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n14:06:20.750 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ieki_2V3Ja82_61rJdjbyQ].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.PermissionIT", "duration" : 284.495, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "nonOwnerAdminGrantsWritePermission", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:52:12.145 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ieki_2V3Ja82_61rJdjbyQ].beforeClass: entered. testInstanceCounter=1\n13:52:12.155 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:52:13.425 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [65467c16]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/repo/k9o50inh-xeaxn-local-src'\n13:52:13.437 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [65467\n...[truncated 21476626 chars]...\ncalRepoManager 20000 ms.\n14:06:19.857 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5db0d57c]getCloseDeferredMillis: closeDeferredMillis=20000\n14:06:19.857 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5db0d57c]close: Deferring shut down of real LocalRepoManager 20000 ms.\n14:06:19.862 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n14:06:20.750 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ieki_2V3Ja82_61rJdjbyQ].afterClass: entered. testInstanceCounter=1\n" } ], "duration" : 847.716, "id" : None, "name" : "org.subshare.test.PermissionIT", "stderr" : "", "stdout" : "13:52:12.145 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ieki_2V3Ja82_61rJdjbyQ].beforeClass: entered. testInstanceCounter=1\n13:52:12.155 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:52:13.425 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [65467c16]: localRoot='/home/tomcat/.jenkins/workspace/org.subshare_java_11/org.subshare/org.subshare.test/build/repo/k9o50inh-xeaxn-local-src'\n13:52:13.437 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [65467\n...[truncated 21476626 chars]...\ncalRepoManager 20000 ms.\n14:06:19.857 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5db0d57c]getCloseDeferredMillis: closeDeferredMillis=20000\n14:06:19.857 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [5db0d57c]close: Deferring shut down of real LocalRepoManager 20000 ms.\n14:06:19.862 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n14:06:20.750 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ieki_2V3Ja82_61rJdjbyQ].afterClass: entered. testInstanceCounter=1\n", "timestamp" : "2020-05-01T11:52:12" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.PgpSyncIT", "duration" : 2.889, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "testPgpSync", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "14:17:43.309 [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/81pW-yU00IIhc0aF8UhtLA/.subshare/localServer.properties\n14:17:43.309 [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/81pW-yU00IIhc0aF8UhtLA/.subshare/ssl.client\n14:17:43.309 [Test worker] INFO \n...[truncated 3207 chars]...\n7:47.427 [Test worker] DEBUG c.c.c.r.c.CloudStoreRestClient - execute: invocation took 10 ms\n14:17:47.427 [Test worker] DEBUG c.c.c.r.c.CloudStoreRestClient - execute: starting try 1 of 3\n14:17:47.502 [Test worker] DEBUG c.c.c.r.c.CloudStoreRestClient - execute: invocation took 75 ms\n14:17:47.558 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n14:17:48.067 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [erqwqH8bgcqqV0CSrIxleQ].afterClass: entered. testInstanceCounter=1\n" } ], "duration" : 2.889, "id" : None, "name" : "org.subshare.test.PgpSyncIT", "stderr" : "", "stdout" : "14:17:43.309 [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/81pW-yU00IIhc0aF8UhtLA/.subshare/localServer.properties\n14:17:43.309 [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/81pW-yU00IIhc0aF8UhtLA/.subshare/ssl.client\n14:17:43.309 [Test worker] INFO \n...[truncated 3207 chars]...\n7:47.427 [Test worker] DEBUG c.c.c.r.c.CloudStoreRestClient - execute: invocation took 10 ms\n14:17:47.427 [Test worker] DEBUG c.c.c.r.c.CloudStoreRestClient - execute: starting try 1 of 3\n14:17:47.502 [Test worker] DEBUG c.c.c.r.c.CloudStoreRestClient - execute: invocation took 75 ms\n14:17:47.558 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n14:17:48.067 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [erqwqH8bgcqqV0CSrIxleQ].afterClass: entered. testInstanceCounter=1\n", "timestamp" : "2020-05-01T12:17:44" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.PostgresqlRepoToRepoSyncIT", "duration" : 152.022, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncFromLocalToRemoteToLocalAfterCreateAndDeleteFile", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:43:43.330 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ZZQrOz4-vS0r6LxXVU5YxA].beforeClass: entered. testInstanceCounter=1\n13:43:43.333 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n13:43:43.340 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:43:44.550 [closeDeferredTimer-7eb6e90b-1] INFO c.c.c.l.LocalRepoManagerImpl - [7eb6e90b]_close: Shutting down real LocalRepoManager.\n13:43:44.550 [closeDeferredTimer-52551ab2-1] INFO \n...[truncated 37886982 chars]...\n6]getCloseDeferredMillis: closeDeferredMillis=20000\n14:03:17.283 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2fdd8466]close: Deferring shut down of real LocalRepoManager 20000 ms.\n14:03:17.285 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n14:03:18.443 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n14:03:18.444 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ZZQrOz4-vS0r6LxXVU5YxA].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.PostgresqlRepoToRepoSyncIT", "duration" : 181.14, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncFromLocalToRemoteToLocalWithPathPrefixWithWritePermissionGrantedAndRevoked", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:43:43.330 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ZZQrOz4-vS0r6LxXVU5YxA].beforeClass: entered. testInstanceCounter=1\n13:43:43.333 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n13:43:43.340 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:43:44.550 [closeDeferredTimer-7eb6e90b-1] INFO c.c.c.l.LocalRepoManagerImpl - [7eb6e90b]_close: Shutting down real LocalRepoManager.\n13:43:44.550 [closeDeferredTimer-52551ab2-1] INFO \n...[truncated 37886982 chars]...\n6]getCloseDeferredMillis: closeDeferredMillis=20000\n14:03:17.283 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2fdd8466]close: Deferring shut down of real LocalRepoManager 20000 ms.\n14:03:17.285 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n14:03:18.443 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n14:03:18.444 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ZZQrOz4-vS0r6LxXVU5YxA].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.PostgresqlRepoToRepoSyncIT", "duration" : 106.267, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncFromLocalToRemoteToLocal", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:43:43.330 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ZZQrOz4-vS0r6LxXVU5YxA].beforeClass: entered. testInstanceCounter=1\n13:43:43.333 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n13:43:43.340 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:43:44.550 [closeDeferredTimer-7eb6e90b-1] INFO c.c.c.l.LocalRepoManagerImpl - [7eb6e90b]_close: Shutting down real LocalRepoManager.\n13:43:44.550 [closeDeferredTimer-52551ab2-1] INFO \n...[truncated 37886982 chars]...\n6]getCloseDeferredMillis: closeDeferredMillis=20000\n14:03:17.283 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2fdd8466]close: Deferring shut down of real LocalRepoManager 20000 ms.\n14:03:17.285 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n14:03:18.443 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n14:03:18.444 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ZZQrOz4-vS0r6LxXVU5YxA].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.PostgresqlRepoToRepoSyncIT", "duration" : 83.003, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncFromLocalToRemoteToLocalWithPathPrefixWithoutSubdirClearanceKey", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:43:43.330 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ZZQrOz4-vS0r6LxXVU5YxA].beforeClass: entered. testInstanceCounter=1\n13:43:43.333 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n13:43:43.340 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:43:44.550 [closeDeferredTimer-7eb6e90b-1] INFO c.c.c.l.LocalRepoManagerImpl - [7eb6e90b]_close: Shutting down real LocalRepoManager.\n13:43:44.550 [closeDeferredTimer-52551ab2-1] INFO \n...[truncated 37886982 chars]...\n6]getCloseDeferredMillis: closeDeferredMillis=20000\n14:03:17.283 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2fdd8466]close: Deferring shut down of real LocalRepoManager 20000 ms.\n14:03:17.285 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n14:03:18.443 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n14:03:18.444 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ZZQrOz4-vS0r6LxXVU5YxA].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.PostgresqlRepoToRepoSyncIT", "duration" : 127.874, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncFromLocalToRemoteToLocalWithPathPrefix", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:43:43.330 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ZZQrOz4-vS0r6LxXVU5YxA].beforeClass: entered. testInstanceCounter=1\n13:43:43.333 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n13:43:43.340 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:43:44.550 [closeDeferredTimer-7eb6e90b-1] INFO c.c.c.l.LocalRepoManagerImpl - [7eb6e90b]_close: Shutting down real LocalRepoManager.\n13:43:44.550 [closeDeferredTimer-52551ab2-1] INFO \n...[truncated 37886982 chars]...\n6]getCloseDeferredMillis: closeDeferredMillis=20000\n14:03:17.283 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2fdd8466]close: Deferring shut down of real LocalRepoManager 20000 ms.\n14:03:17.285 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n14:03:18.443 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n14:03:18.444 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ZZQrOz4-vS0r6LxXVU5YxA].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.PostgresqlRepoToRepoSyncIT", "duration" : 124.665, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncFromLocalToRemoteToLocalThenDeleteFileAndSyncAgain", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:43:43.330 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ZZQrOz4-vS0r6LxXVU5YxA].beforeClass: entered. testInstanceCounter=1\n13:43:43.333 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n13:43:43.340 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:43:44.550 [closeDeferredTimer-7eb6e90b-1] INFO c.c.c.l.LocalRepoManagerImpl - [7eb6e90b]_close: Shutting down real LocalRepoManager.\n13:43:44.550 [closeDeferredTimer-52551ab2-1] INFO \n...[truncated 37886982 chars]...\n6]getCloseDeferredMillis: closeDeferredMillis=20000\n14:03:17.283 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2fdd8466]close: Deferring shut down of real LocalRepoManager 20000 ms.\n14:03:17.285 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n14:03:18.443 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n14:03:18.444 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ZZQrOz4-vS0r6LxXVU5YxA].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.PostgresqlRepoToRepoSyncIT", "duration" : 240.647, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncFromLocalToRemoteToLocalWithPathPrefixWithSubdirClearanceKey", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:43:43.330 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ZZQrOz4-vS0r6LxXVU5YxA].beforeClass: entered. testInstanceCounter=1\n13:43:43.333 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n13:43:43.340 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:43:44.550 [closeDeferredTimer-7eb6e90b-1] INFO c.c.c.l.LocalRepoManagerImpl - [7eb6e90b]_close: Shutting down real LocalRepoManager.\n13:43:44.550 [closeDeferredTimer-52551ab2-1] INFO \n...[truncated 37886982 chars]...\n6]getCloseDeferredMillis: closeDeferredMillis=20000\n14:03:17.283 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2fdd8466]close: Deferring shut down of real LocalRepoManager 20000 ms.\n14:03:17.285 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n14:03:18.443 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n14:03:18.444 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ZZQrOz4-vS0r6LxXVU5YxA].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.PostgresqlRepoToRepoSyncIT", "duration" : 158.331, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "multiSyncFromLocalToRemoteToLocalWithPathPrefixWithSubdirClearanceKey", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:43:43.330 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ZZQrOz4-vS0r6LxXVU5YxA].beforeClass: entered. testInstanceCounter=1\n13:43:43.333 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n13:43:43.340 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:43:44.550 [closeDeferredTimer-7eb6e90b-1] INFO c.c.c.l.LocalRepoManagerImpl - [7eb6e90b]_close: Shutting down real LocalRepoManager.\n13:43:44.550 [closeDeferredTimer-52551ab2-1] INFO \n...[truncated 37886982 chars]...\n6]getCloseDeferredMillis: closeDeferredMillis=20000\n14:03:17.283 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2fdd8466]close: Deferring shut down of real LocalRepoManager 20000 ms.\n14:03:17.285 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n14:03:18.443 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n14:03:18.444 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ZZQrOz4-vS0r6LxXVU5YxA].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 12, "className" : "org.subshare.test.PostgresqlRepoToRepoSyncIT", "duration" : 0.0, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 32, "name" : "syncFromLocalToRemoteToLocalThenCauseDeleteCollisionOnServerDuringUpSync", "skipped" : True, "skippedMessage" : None, "status" : "SKIPPED", "stderr" : "", "stdout" : "13:43:43.330 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ZZQrOz4-vS0r6LxXVU5YxA].beforeClass: entered. testInstanceCounter=1\n13:43:43.333 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n13:43:43.340 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:43:44.550 [closeDeferredTimer-7eb6e90b-1] INFO c.c.c.l.LocalRepoManagerImpl - [7eb6e90b]_close: Shutting down real LocalRepoManager.\n13:43:44.550 [closeDeferredTimer-52551ab2-1] INFO \n...[truncated 37886982 chars]...\n6]getCloseDeferredMillis: closeDeferredMillis=20000\n14:03:17.283 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2fdd8466]close: Deferring shut down of real LocalRepoManager 20000 ms.\n14:03:17.285 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n14:03:18.443 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n14:03:18.444 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ZZQrOz4-vS0r6LxXVU5YxA].afterClass: entered. testInstanceCounter=1\n" } ], "duration" : 1173.949, "id" : None, "name" : "org.subshare.test.PostgresqlRepoToRepoSyncIT", "stderr" : "", "stdout" : "13:43:43.330 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ZZQrOz4-vS0r6LxXVU5YxA].beforeClass: entered. testInstanceCounter=1\n13:43:43.333 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n13:43:43.340 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:43:44.550 [closeDeferredTimer-7eb6e90b-1] INFO c.c.c.l.LocalRepoManagerImpl - [7eb6e90b]_close: Shutting down real LocalRepoManager.\n13:43:44.550 [closeDeferredTimer-52551ab2-1] INFO \n...[truncated 37886982 chars]...\n6]getCloseDeferredMillis: closeDeferredMillis=20000\n14:03:17.283 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [2fdd8466]close: Deferring shut down of real LocalRepoManager 20000 ms.\n14:03:17.285 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n14:03:18.443 [Test worker] INFO c.c.c.l.d.DatabaseAdapterFactoryRegistry - clearCache: entered.\n14:03:18.444 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ZZQrOz4-vS0r6LxXVU5YxA].afterClass: entered. testInstanceCounter=1\n", "timestamp" : "2020-05-01T11:43:43" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.ReadUserIdentityIT", "duration" : 261.361, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "inviteWithReadInvitationAndGrantReadUserIdentityPermissionLater", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:50:17.613 [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/X9r3P19qpvcf4NWE6PQKMg/.subshare/localServer.properties\n13:50:17.613 [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/X9r3P19qpvcf4NWE6PQKMg/.subshare/ssl.client\n13:50:17.613 [Test worker] INFO \n...[truncated 6713143 chars]...\ncalRepoManager 20000 ms.\n13:54:38.971 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [249ccfea]getCloseDeferredMillis: closeDeferredMillis=20000\n13:54:38.971 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [249ccfea]close: Deferring shut down of real LocalRepoManager 20000 ms.\n13:54:38.972 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:54:39.405 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [uRTgXqXOkXrPaJxZH2wDjw].afterClass: entered. testInstanceCounter=1\n" } ], "duration" : 261.361, "id" : None, "name" : "org.subshare.test.ReadUserIdentityIT", "stderr" : "", "stdout" : "13:50:17.613 [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/X9r3P19qpvcf4NWE6PQKMg/.subshare/localServer.properties\n13:50:17.613 [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/X9r3P19qpvcf4NWE6PQKMg/.subshare/ssl.client\n13:50:17.613 [Test worker] INFO \n...[truncated 6713143 chars]...\ncalRepoManager 20000 ms.\n13:54:38.971 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [249ccfea]getCloseDeferredMillis: closeDeferredMillis=20000\n13:54:38.971 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [249ccfea]close: Deferring shut down of real LocalRepoManager 20000 ms.\n13:54:38.972 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n13:54:39.405 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [uRTgXqXOkXrPaJxZH2wDjw].afterClass: entered. testInstanceCounter=1\n", "timestamp" : "2020-05-01T11:50:17" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.RepoToRepoSyncIT", "duration" : 183.262, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncFromLocalToRemoteToLocalAfterCreateAndDeleteFile", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:57:55.686 [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/3t8eSl8-XkHDYbaGBchBEQ/.subshare/localServer.properties\n13:57:55.686 [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/3t8eSl8-XkHDYbaGBchBEQ/.subshare/ssl.client\n13:57:55.687 [Test worker] INFO \n...[truncated 42147402 chars]...\ncalRepoManager 20000 ms.\n14:21:05.737 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [36ab2370]getCloseDeferredMillis: closeDeferredMillis=20000\n14:21:05.737 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [36ab2370]close: Deferring shut down of real LocalRepoManager 20000 ms.\n14:21:05.738 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n14:21:06.593 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [OSE5Zl8OBik-yJAjA0gm9w].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.RepoToRepoSyncIT", "duration" : 268.855, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncFromLocalToRemoteToLocalWithPathPrefixWithWritePermissionGrantedAndRevoked", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:57:55.686 [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/3t8eSl8-XkHDYbaGBchBEQ/.subshare/localServer.properties\n13:57:55.686 [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/3t8eSl8-XkHDYbaGBchBEQ/.subshare/ssl.client\n13:57:55.687 [Test worker] INFO \n...[truncated 42147402 chars]...\ncalRepoManager 20000 ms.\n14:21:05.737 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [36ab2370]getCloseDeferredMillis: closeDeferredMillis=20000\n14:21:05.737 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [36ab2370]close: Deferring shut down of real LocalRepoManager 20000 ms.\n14:21:05.738 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n14:21:06.593 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [OSE5Zl8OBik-yJAjA0gm9w].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.RepoToRepoSyncIT", "duration" : 180.326, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncFromLocalToRemoteToLocal", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:57:55.686 [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/3t8eSl8-XkHDYbaGBchBEQ/.subshare/localServer.properties\n13:57:55.686 [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/3t8eSl8-XkHDYbaGBchBEQ/.subshare/ssl.client\n13:57:55.687 [Test worker] INFO \n...[truncated 42147402 chars]...\ncalRepoManager 20000 ms.\n14:21:05.737 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [36ab2370]getCloseDeferredMillis: closeDeferredMillis=20000\n14:21:05.737 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [36ab2370]close: Deferring shut down of real LocalRepoManager 20000 ms.\n14:21:05.738 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n14:21:06.593 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [OSE5Zl8OBik-yJAjA0gm9w].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.RepoToRepoSyncIT", "duration" : 153.728, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncFromLocalToRemoteToLocalWithPathPrefixWithoutSubdirClearanceKey", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:57:55.686 [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/3t8eSl8-XkHDYbaGBchBEQ/.subshare/localServer.properties\n13:57:55.686 [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/3t8eSl8-XkHDYbaGBchBEQ/.subshare/ssl.client\n13:57:55.687 [Test worker] INFO \n...[truncated 42147402 chars]...\ncalRepoManager 20000 ms.\n14:21:05.737 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [36ab2370]getCloseDeferredMillis: closeDeferredMillis=20000\n14:21:05.737 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [36ab2370]close: Deferring shut down of real LocalRepoManager 20000 ms.\n14:21:05.738 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n14:21:06.593 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [OSE5Zl8OBik-yJAjA0gm9w].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.RepoToRepoSyncIT", "duration" : 193.115, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncFromLocalToRemoteToLocalWithPathPrefix", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:57:55.686 [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/3t8eSl8-XkHDYbaGBchBEQ/.subshare/localServer.properties\n13:57:55.686 [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/3t8eSl8-XkHDYbaGBchBEQ/.subshare/ssl.client\n13:57:55.687 [Test worker] INFO \n...[truncated 42147402 chars]...\ncalRepoManager 20000 ms.\n14:21:05.737 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [36ab2370]getCloseDeferredMillis: closeDeferredMillis=20000\n14:21:05.737 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [36ab2370]close: Deferring shut down of real LocalRepoManager 20000 ms.\n14:21:05.738 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n14:21:06.593 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [OSE5Zl8OBik-yJAjA0gm9w].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.RepoToRepoSyncIT", "duration" : 131.877, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncFromLocalToRemoteToLocalThenDeleteFileAndSyncAgain", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:57:55.686 [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/3t8eSl8-XkHDYbaGBchBEQ/.subshare/localServer.properties\n13:57:55.686 [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/3t8eSl8-XkHDYbaGBchBEQ/.subshare/ssl.client\n13:57:55.687 [Test worker] INFO \n...[truncated 42147402 chars]...\ncalRepoManager 20000 ms.\n14:21:05.737 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [36ab2370]getCloseDeferredMillis: closeDeferredMillis=20000\n14:21:05.737 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [36ab2370]close: Deferring shut down of real LocalRepoManager 20000 ms.\n14:21:05.738 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n14:21:06.593 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [OSE5Zl8OBik-yJAjA0gm9w].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.RepoToRepoSyncIT", "duration" : 166.528, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "syncFromLocalToRemoteToLocalWithPathPrefixWithSubdirClearanceKey", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:57:55.686 [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/3t8eSl8-XkHDYbaGBchBEQ/.subshare/localServer.properties\n13:57:55.686 [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/3t8eSl8-XkHDYbaGBchBEQ/.subshare/ssl.client\n13:57:55.687 [Test worker] INFO \n...[truncated 42147402 chars]...\ncalRepoManager 20000 ms.\n14:21:05.737 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [36ab2370]getCloseDeferredMillis: closeDeferredMillis=20000\n14:21:05.737 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [36ab2370]close: Deferring shut down of real LocalRepoManager 20000 ms.\n14:21:05.738 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n14:21:06.593 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [OSE5Zl8OBik-yJAjA0gm9w].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 12, "className" : "org.subshare.test.RepoToRepoSyncIT", "duration" : 0.0, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 32, "name" : "syncFromLocalToRemoteToLocalThenCauseDeleteCollisionOnServerDuringUpSync", "skipped" : True, "skippedMessage" : None, "status" : "SKIPPED", "stderr" : "", "stdout" : "13:57:55.686 [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/3t8eSl8-XkHDYbaGBchBEQ/.subshare/localServer.properties\n13:57:55.686 [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/3t8eSl8-XkHDYbaGBchBEQ/.subshare/ssl.client\n13:57:55.687 [Test worker] INFO \n...[truncated 42147402 chars]...\ncalRepoManager 20000 ms.\n14:21:05.737 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [36ab2370]getCloseDeferredMillis: closeDeferredMillis=20000\n14:21:05.737 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [36ab2370]close: Deferring shut down of real LocalRepoManager 20000 ms.\n14:21:05.738 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n14:21:06.593 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [OSE5Zl8OBik-yJAjA0gm9w].afterClass: entered. testInstanceCounter=1\n" }, { "age" : 0, "className" : "org.subshare.test.RepoToRepoSyncIT", "duration" : 112.349, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "multiSyncFromLocalToRemoteToLocalWithPathPrefixWithSubdirClearanceKey", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "13:57:55.686 [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/3t8eSl8-XkHDYbaGBchBEQ/.subshare/localServer.properties\n13:57:55.686 [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/3t8eSl8-XkHDYbaGBchBEQ/.subshare/ssl.client\n13:57:55.687 [Test worker] INFO \n...[truncated 42147402 chars]...\ncalRepoManager 20000 ms.\n14:21:05.737 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [36ab2370]getCloseDeferredMillis: closeDeferredMillis=20000\n14:21:05.737 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [36ab2370]close: Deferring shut down of real LocalRepoManager 20000 ms.\n14:21:05.738 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n14:21:06.593 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [OSE5Zl8OBik-yJAjA0gm9w].afterClass: entered. testInstanceCounter=1\n" } ], "duration" : 1390.0399, "id" : None, "name" : "org.subshare.test.RepoToRepoSyncIT", "stderr" : "", "stdout" : "13:57:55.686 [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/3t8eSl8-XkHDYbaGBchBEQ/.subshare/localServer.properties\n13:57:55.686 [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/3t8eSl8-XkHDYbaGBchBEQ/.subshare/ssl.client\n13:57:55.687 [Test worker] INFO \n...[truncated 42147402 chars]...\ncalRepoManager 20000 ms.\n14:21:05.737 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [36ab2370]getCloseDeferredMillis: closeDeferredMillis=20000\n14:21:05.737 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [36ab2370]close: Deferring shut down of real LocalRepoManager 20000 ms.\n14:21:05.738 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n14:21:06.593 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [OSE5Zl8OBik-yJAjA0gm9w].afterClass: entered. testInstanceCounter=1\n", "timestamp" : "2020-05-01T11:57:55" }, { "cases" : [ { "age" : 0, "className" : "org.subshare.test.SymlinkCollisionOnClientRepoToRepoSyncIT", "duration" : 237.008, "errorDetails" : None, "errorStackTrace" : None, "failedSince" : 0, "name" : "newFileVsNewSymlinkCollisionOnClient", "skipped" : False, "skippedMessage" : None, "status" : "PASSED", "stderr" : "", "stdout" : "14:10:13.515 [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/2Is7Thk6dNMxtiyHWkdeLw/.subshare/ssl.client\n14:10:13.515 [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/2Is7Thk6dNMxtiyHWkdeLw/.subshare/repoRegistry.properties\n14:10:13.516 [Test work\n...[truncated 5230023 chars]...\ncalRepoManager 20000 ms.\n14:14:10.522 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [6315e595]getCloseDeferredMillis: closeDeferredMillis=20000\n14:14:10.522 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [6315e595]close: Deferring shut down of real LocalRepoManager 20000 ms.\n14:14:10.523 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n14:14:11.637 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ieki_2V3Ja82_61rJdjbyQ].afterClass: entered. testInstanceCounter=1\n" } ], "duration" : 237.008, "id" : None, "name" : "org.subshare.test.SymlinkCollisionOnClientRepoToRepoSyncIT", "stderr" : "", "stdout" : "14:10:13.515 [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/2Is7Thk6dNMxtiyHWkdeLw/.subshare/ssl.client\n14:10:13.515 [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/2Is7Thk6dNMxtiyHWkdeLw/.subshare/repoRegistry.properties\n14:10:13.516 [Test work\n...[truncated 5230023 chars]...\ncalRepoManager 20000 ms.\n14:14:10.522 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [6315e595]getCloseDeferredMillis: closeDeferredMillis=20000\n14:14:10.522 [Test worker] INFO c.c.c.l.LocalRepoManagerImpl - [6315e595]close: Deferring shut down of real LocalRepoManager 20000 ms.\n14:14:10.523 [Test worker] INFO o.s.c.p.PgpRegistry - clearCache: entered.\n14:14:11.637 [Test worker] DEBUG c.c.c.t.CloudStoreServerTestSupport - [ieki_2V3Ja82_61rJdjbyQ].afterClass: entered. testInstanceCounter=1\n", "timestamp" : "2020-05-01T12:10:13" } ] }