[INFO] [INFO] ------------------------------------------------------------------------ [INFO] Building org.cumulus4j.keystore 1.2.1-SNAPSHOT [INFO] ------------------------------------------------------------------------ [INFO] [INFO] --- maven-clean-plugin:2.4.1:clean (default-clean) @ org.cumulus4j.keystore --- [INFO] Deleting /home/tomcat/.jenkins/workspace/org.cumulus4j/org.cumulus4j/org.cumulus4j.keystore/target [INFO] Deleting /home/tomcat/.jenkins/workspace/org.cumulus4j/org.cumulus4j/org.cumulus4j.keystore (includes = [*.log, $jarplug.work/**], excludes = []) [INFO] [INFO] --- maven-resources-plugin:2.5:resources (default-resources) @ org.cumulus4j.keystore --- [debug] execute contextualize [INFO] Using 'UTF-8' encoding to copy filtered resources. [INFO] skip non existing resourceDirectory /home/tomcat/.jenkins/workspace/org.cumulus4j/org.cumulus4j/org.cumulus4j.keystore/src/main/resources [INFO] Copying 1 resource [INFO] Copying 0 resource [INFO] [INFO] --- maven-compiler-plugin:2.3.2:compile (default-compile) @ org.cumulus4j.keystore --- [INFO] Compiling 27 source files to /home/tomcat/.jenkins/workspace/org.cumulus4j/org.cumulus4j/org.cumulus4j.keystore/target/classes [INFO] [INFO] --- maven-resources-plugin:2.5:testResources (default-testResources) @ org.cumulus4j.keystore --- [debug] execute contextualize [INFO] Using 'UTF-8' encoding to copy filtered resources. [INFO] Copying 19 resources [INFO] [INFO] --- maven-compiler-plugin:2.3.2:testCompile (default-testCompile) @ org.cumulus4j.keystore --- [INFO] Compiling 12 source files to /home/tomcat/.jenkins/workspace/org.cumulus4j/org.cumulus4j/org.cumulus4j.keystore/target/test-classes [INFO] [INFO] --- maven-surefire-plugin:2.8.1:test (default-test) @ org.cumulus4j.keystore --- [INFO] Surefire report directory: /home/tomcat/.jenkins/workspace/org.cumulus4j/org.cumulus4j/org.cumulus4j.keystore/target/surefire-reports ------------------------------------------------------- T E S T S ------------------------------------------------------- Running org.cumulus4j.keystore.test.KeyStoreKey_AES_CBC_PKCS5Padding_Test 09:00:57,284 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is not set. Using default key size (256 bit). 09:00:57,288 INFO [main][KeyStore] createUser: Created master-key with a size of 256 bits. This key will not be modified for this key-store anymore. 09:00:57,290 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is set to 'AES/CBC/PKCS5Padding'. Using this encryption algorithm. 09:00:57,631 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="DES" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$DES" 09:00:57,631 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="DESMAC" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$DES" 09:00:57,633 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="DES64" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$DES64" 09:00:57,633 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="DES64MAC" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$DES64" 09:00:57,634 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="DES/CFB8" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$DESCFB8" 09:00:57,635 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="DESMAC/CFB8" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$DESCFB8" 09:00:57,636 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="DESWITHISO9797" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$DES9797Alg3" 09:00:57,636 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="DESWITHISO9797MAC" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$DES9797Alg3" 09:00:57,636 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="ISO9797ALG3" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$DES9797Alg3" 09:00:57,637 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="ISO9797ALG3MAC" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$DES9797Alg3" 09:00:57,640 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="ISO9797ALG3WITHISO7816-4PADDING" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$DES9797Alg3with7816d4" 09:00:57,640 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="ISO9797ALG3MACWITHISO7816-4PADDING" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$DES9797Alg3with7816d4" 09:00:57,641 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="RC2" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$RC2" 09:00:57,642 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="RC2MAC" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$RC2" 09:00:57,643 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="RC2/CFB8" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$RC2CFB8" 09:00:57,643 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="RC2MAC/CFB8" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$RC2CFB8" 09:00:57,667 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="GOST28147" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$GOST28147" 09:00:57,670 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="GOST28147MAC" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$GOST28147" 09:00:57,672 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="OLDHMACSHA384" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$OldSHA384" 09:00:57,720 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="OLDHMACSHA512" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$OldSHA512" 09:00:57,721 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="HMACMD2" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$MD2" 09:00:57,722 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="HMAC-MD2" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$MD2" 09:00:57,722 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="HMAC/MD2" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$MD2" 09:00:57,723 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="HMACMD4" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$MD4" 09:00:57,723 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="HMAC-MD4" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$MD4" 09:00:57,724 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="HMAC/MD4" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$MD4" 09:00:57,732 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="HMACMD5" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$MD5" 09:00:57,739 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="HMAC-MD5" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$MD5" 09:00:57,740 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="HMAC/MD5" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$MD5" 09:00:57,742 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="HMACSHA1" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$SHA1" 09:00:57,743 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="HMAC-SHA1" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$SHA1" 09:00:57,743 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="HMAC/SHA1" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$SHA1" 09:00:57,744 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="HMACSHA224" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$SHA224" 09:00:57,745 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="HMAC-SHA224" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$SHA224" 09:00:57,746 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="HMAC/SHA224" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$SHA224" 09:00:57,748 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="HMACSHA256" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$SHA256" 09:00:57,749 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="HMAC-SHA256" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$SHA256" 09:00:57,749 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="HMAC/SHA256" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$SHA256" 09:00:57,750 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="HMACSHA384" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$SHA384" 09:00:57,765 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="HMAC-SHA384" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$SHA384" 09:00:57,767 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="HMAC/SHA384" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$SHA384" 09:00:57,768 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="HMACSHA512" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$SHA512" 09:00:57,770 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="HMAC-SHA512" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$SHA512" 09:00:57,773 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="HMAC/SHA512" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$SHA512" 09:00:57,780 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="HMACRIPEMD128" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$RIPEMD128" 09:00:57,782 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="HMAC-RIPEMD128" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$RIPEMD128" 09:00:57,792 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="HMAC/RIPEMD128" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$RIPEMD128" 09:00:57,804 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="HMACRIPEMD160" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$RIPEMD160" 09:00:57,805 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="HMAC-RIPEMD160" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$RIPEMD160" 09:00:57,808 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="HMAC/RIPEMD160" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$RIPEMD160" 09:00:57,810 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="HMACTIGER" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$Tiger" 09:00:57,816 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="HMAC-TIGER" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$Tiger" 09:00:57,817 TRACE [main][CryptoRegistry] registerMACCalculatorFactory: algorithmName="HMAC/TIGER" factoryClass="org.cumulus4j.crypto.internal.mac.MACCalculatorFactoryImpl$Tiger" 09:00:57,879 TRACE [main][CryptoRegistry] registerAsymmetricEngineClass: algorithmName="ElGamal" engineClass="org.bouncycastle.crypto.engines.ElGamalEngine" 09:00:57,884 TRACE [main][CryptoRegistry] registerAsymmetricEngineClass: algorithmName="NaccacheStern" engineClass="org.bouncycastle.crypto.engines.NaccacheSternEngine" 09:00:57,916 TRACE [main][CryptoRegistry] registerAsymmetricEngineClass: algorithmName="RSA" engineClass="org.bouncycastle.crypto.engines.RSABlindedEngine" 09:00:57,933 TRACE [main][CryptoRegistry] registerSymmetricEngineClass: algorithmName="AES" engineClass="org.bouncycastle.crypto.engines.AESEngine" 09:00:57,981 TRACE [main][CryptoRegistry] registerSymmetricEngineClass: algorithmName="AES.fast" engineClass="org.bouncycastle.crypto.engines.AESFastEngine" 09:00:57,999 TRACE [main][CryptoRegistry] registerSymmetricEngineClass: algorithmName="AES.light" engineClass="org.bouncycastle.crypto.engines.AESLightEngine" 09:00:58,033 TRACE [main][CryptoRegistry] registerSymmetricEngineClass: algorithmName="Blowfish" engineClass="org.bouncycastle.crypto.engines.BlowfishEngine" 09:00:58,049 TRACE [main][CryptoRegistry] registerSymmetricEngineClass: algorithmName="Camellia" engineClass="org.bouncycastle.crypto.engines.CamelliaEngine" 09:00:58,080 TRACE [main][CryptoRegistry] registerSymmetricEngineClass: algorithmName="Camellia.light" engineClass="org.bouncycastle.crypto.engines.CamelliaLightEngine" 09:00:58,122 TRACE [main][CryptoRegistry] registerSymmetricEngineClass: algorithmName="CAST5" engineClass="org.bouncycastle.crypto.engines.CAST5Engine" 09:00:58,159 TRACE [main][CryptoRegistry] registerSymmetricEngineClass: algorithmName="CAST6" engineClass="org.bouncycastle.crypto.engines.CAST6Engine" 09:00:58,185 TRACE [main][CryptoRegistry] registerSymmetricEngineClass: algorithmName="DESede" engineClass="org.bouncycastle.crypto.engines.DESedeEngine" 09:00:58,192 TRACE [main][CryptoRegistry] registerSymmetricEngineClass: algorithmName="DES" engineClass="org.bouncycastle.crypto.engines.DESEngine" 09:00:58,221 TRACE [main][CryptoRegistry] registerSymmetricEngineClass: algorithmName="GOST28147" engineClass="org.bouncycastle.crypto.engines.GOST28147Engine" 09:00:58,242 TRACE [main][CryptoRegistry] registerSymmetricEngineClass: algorithmName="Noekeon" engineClass="org.bouncycastle.crypto.engines.NoekeonEngine" 09:00:58,248 TRACE [main][CryptoRegistry] registerSymmetricEngineClass: algorithmName="Null" engineClass="org.bouncycastle.crypto.engines.NullEngine" 09:00:58,271 TRACE [main][CryptoRegistry] registerSymmetricEngineClass: algorithmName="RC2" engineClass="org.bouncycastle.crypto.engines.RC2Engine" 09:00:58,286 TRACE [main][CryptoRegistry] registerSymmetricEngineClass: algorithmName="RC5-32" engineClass="org.bouncycastle.crypto.engines.RC532Engine" 09:00:58,311 TRACE [main][CryptoRegistry] registerSymmetricEngineClass: algorithmName="RC5-64" engineClass="org.bouncycastle.crypto.engines.RC564Engine" 09:00:58,317 TRACE [main][CryptoRegistry] registerSymmetricEngineClass: algorithmName="RC6" engineClass="org.bouncycastle.crypto.engines.RC6Engine" 09:00:58,326 TRACE [main][CryptoRegistry] registerSymmetricEngineClass: algorithmName="Rijndael" engineClass="org.bouncycastle.crypto.engines.RijndaelEngine" 09:00:58,331 TRACE [main][CryptoRegistry] registerSymmetricEngineClass: algorithmName="SEED" engineClass="org.bouncycastle.crypto.engines.SEEDEngine" 09:00:58,337 TRACE [main][CryptoRegistry] registerSymmetricEngineClass: algorithmName="Serpent" engineClass="org.bouncycastle.crypto.engines.SerpentEngine" 09:00:58,339 TRACE [main][CryptoRegistry] registerSymmetricEngineClass: algorithmName="SKIPJACK" engineClass="org.bouncycastle.crypto.engines.SkipjackEngine" 09:00:58,349 TRACE [main][CryptoRegistry] registerSymmetricEngineClass: algorithmName="TEA" engineClass="org.bouncycastle.crypto.engines.TEAEngine" 09:00:58,354 TRACE [main][CryptoRegistry] registerSymmetricEngineClass: algorithmName="Twofish" engineClass="org.bouncycastle.crypto.engines.TwofishEngine" 09:00:58,356 TRACE [main][CryptoRegistry] registerSymmetricEngineClass: algorithmName="XTEA" engineClass="org.bouncycastle.crypto.engines.XTEAEngine" 09:00:58,359 TRACE [main][CryptoRegistry] registerSymmetricEngineClass: algorithmName="Grain-128" engineClass="org.bouncycastle.crypto.engines.Grain128Engine" 09:00:58,362 TRACE [main][CryptoRegistry] registerSymmetricEngineClass: algorithmName="GRAIN-V1" engineClass="org.bouncycastle.crypto.engines.Grainv1Engine" 09:00:58,364 TRACE [main][CryptoRegistry] registerSymmetricEngineClass: algorithmName="HC-128" engineClass="org.bouncycastle.crypto.engines.HC128Engine" 09:00:58,366 TRACE [main][CryptoRegistry] registerSymmetricEngineClass: algorithmName="HC-256" engineClass="org.bouncycastle.crypto.engines.HC256Engine" 09:00:58,368 TRACE [main][CryptoRegistry] registerSymmetricEngineClass: algorithmName="ISAAC" engineClass="org.bouncycastle.crypto.engines.ISAACEngine" 09:00:58,369 TRACE [main][CryptoRegistry] registerSymmetricEngineClass: algorithmName="RC4" engineClass="org.bouncycastle.crypto.engines.RC4Engine" 09:00:58,374 TRACE [main][CryptoRegistry] registerSymmetricEngineClass: algorithmName="Salsa20" engineClass="org.bouncycastle.crypto.engines.Salsa20Engine" 09:00:58,378 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="CBC" modeClass="org.bouncycastle.crypto.modes.CBCBlockCipher" 09:00:58,384 TRACE [main][CryptoRegistry] registerAEADBlockCipherMode: modeName="CCM" modeClass="org.bouncycastle.crypto.modes.CCMBlockCipher" 09:00:58,391 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="CFB" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jCFBBlockCipher" 09:00:58,394 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="CFB8" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jCFBBlockCipher" 09:00:58,394 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="CFB16" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jCFBBlockCipher" 09:00:58,394 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="CFB24" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jCFBBlockCipher" 09:00:58,394 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="CFB32" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jCFBBlockCipher" 09:00:58,395 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="CFB40" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jCFBBlockCipher" 09:00:58,395 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="CFB48" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jCFBBlockCipher" 09:00:58,396 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="CFB56" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jCFBBlockCipher" 09:00:58,396 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="CFB64" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jCFBBlockCipher" 09:00:58,396 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="CFB72" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jCFBBlockCipher" 09:00:58,397 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="CFB80" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jCFBBlockCipher" 09:00:58,397 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="CFB88" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jCFBBlockCipher" 09:00:58,397 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="CFB96" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jCFBBlockCipher" 09:00:58,397 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="CFB104" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jCFBBlockCipher" 09:00:58,398 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="CFB112" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jCFBBlockCipher" 09:00:58,398 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="CFB120" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jCFBBlockCipher" 09:00:58,398 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="CFB128" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jCFBBlockCipher" 09:00:58,399 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="CFB136" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jCFBBlockCipher" 09:00:58,399 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="CFB144" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jCFBBlockCipher" 09:00:58,399 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="CFB152" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jCFBBlockCipher" 09:00:58,400 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="CFB160" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jCFBBlockCipher" 09:00:58,400 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="CFB168" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jCFBBlockCipher" 09:00:58,400 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="CFB176" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jCFBBlockCipher" 09:00:58,403 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="CFB184" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jCFBBlockCipher" 09:00:58,404 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="CFB192" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jCFBBlockCipher" 09:00:58,405 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="CFB200" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jCFBBlockCipher" 09:00:58,405 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="CFB208" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jCFBBlockCipher" 09:00:58,405 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="CFB216" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jCFBBlockCipher" 09:00:58,405 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="CFB224" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jCFBBlockCipher" 09:00:58,405 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="CFB232" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jCFBBlockCipher" 09:00:58,406 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="CFB240" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jCFBBlockCipher" 09:00:58,407 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="CFB248" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jCFBBlockCipher" 09:00:58,407 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="CFB256" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jCFBBlockCipher" 09:00:58,411 TRACE [main][CryptoRegistry] registerBufferedBlockCipherMode: modeName="CTS" modeClass="org.bouncycastle.crypto.modes.CTSBlockCipher" 09:00:58,413 TRACE [main][CryptoRegistry] registerBufferedBlockCipherMode: modeName="CBC-CTS" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jCBCCTSBlockCipher" 09:00:58,416 TRACE [main][CryptoRegistry] registerAEADBlockCipherMode: modeName="EAX" modeClass="org.bouncycastle.crypto.modes.EAXBlockCipher" 09:00:58,444 TRACE [main][CryptoRegistry] registerAEADBlockCipherMode: modeName="GCM" modeClass="org.bouncycastle.crypto.modes.GCMBlockCipher" 09:00:58,469 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="GOFB" modeClass="org.bouncycastle.crypto.modes.GOFBBlockCipher" 09:00:58,471 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="OFB" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jOFBBlockCipher" 09:00:58,474 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="OFB8" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jOFBBlockCipher" 09:00:58,496 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="OFB16" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jOFBBlockCipher" 09:00:58,496 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="OFB24" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jOFBBlockCipher" 09:00:58,496 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="OFB32" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jOFBBlockCipher" 09:00:58,497 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="OFB40" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jOFBBlockCipher" 09:00:58,504 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="OFB48" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jOFBBlockCipher" 09:00:58,505 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="OFB56" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jOFBBlockCipher" 09:00:58,505 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="OFB64" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jOFBBlockCipher" 09:00:58,505 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="OFB72" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jOFBBlockCipher" 09:00:58,505 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="OFB80" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jOFBBlockCipher" 09:00:58,505 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="OFB88" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jOFBBlockCipher" 09:00:58,506 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="OFB96" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jOFBBlockCipher" 09:00:58,506 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="OFB104" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jOFBBlockCipher" 09:00:58,506 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="OFB112" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jOFBBlockCipher" 09:00:58,506 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="OFB120" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jOFBBlockCipher" 09:00:58,507 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="OFB128" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jOFBBlockCipher" 09:00:58,508 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="OFB136" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jOFBBlockCipher" 09:00:58,508 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="OFB144" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jOFBBlockCipher" 09:00:58,508 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="OFB152" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jOFBBlockCipher" 09:00:58,509 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="OFB160" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jOFBBlockCipher" 09:00:58,510 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="OFB168" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jOFBBlockCipher" 09:00:58,510 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="OFB176" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jOFBBlockCipher" 09:00:58,510 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="OFB184" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jOFBBlockCipher" 09:00:58,511 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="OFB192" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jOFBBlockCipher" 09:00:58,515 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="OFB200" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jOFBBlockCipher" 09:00:58,516 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="OFB208" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jOFBBlockCipher" 09:00:58,520 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="OFB216" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jOFBBlockCipher" 09:00:58,521 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="OFB224" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jOFBBlockCipher" 09:00:58,521 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="OFB232" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jOFBBlockCipher" 09:00:58,521 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="OFB240" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jOFBBlockCipher" 09:00:58,522 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="OFB248" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jOFBBlockCipher" 09:00:58,522 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="OFB256" modeClass="org.cumulus4j.crypto.internal.symmetric.mode.C4jOFBBlockCipher" 09:00:58,524 TRACE [main][CryptoRegistry] registerBlockCipherMode: modeName="SIC" modeClass="org.bouncycastle.crypto.modes.SICBlockCipher" 09:00:58,656 DEBUG [main][CryptoRegistry] registerBlockCipherPadding: paddingName="ISO10126-2" paddingClass="org.bouncycastle.crypto.paddings.ISO10126d2Padding" 09:00:58,656 TRACE [main][CryptoRegistry] registerBlockCipherPadding: paddingName="ISO10126" paddingClass="org.bouncycastle.crypto.paddings.ISO10126d2Padding" 09:00:58,658 DEBUG [main][CryptoRegistry] registerBlockCipherPadding: paddingName="ISO7816-4" paddingClass="org.bouncycastle.crypto.paddings.ISO7816d4Padding" 09:00:58,659 DEBUG [main][CryptoRegistry] registerBlockCipherPadding: paddingName="PKCS7" paddingClass="org.bouncycastle.crypto.paddings.PKCS7Padding" 09:00:58,659 TRACE [main][CryptoRegistry] registerBlockCipherPadding: paddingName="PKCS5" paddingClass="org.bouncycastle.crypto.paddings.PKCS7Padding" 09:00:58,668 DEBUG [main][CryptoRegistry] registerBlockCipherPadding: paddingName="TBC" paddingClass="org.bouncycastle.crypto.paddings.TBCPadding" 09:00:58,669 DEBUG [main][CryptoRegistry] registerBlockCipherPadding: paddingName="X9.23" paddingClass="org.bouncycastle.crypto.paddings.X923Padding" 09:00:58,684 DEBUG [main][CryptoRegistry] registerBlockCipherPadding: paddingName="ZeroByte" paddingClass="org.bouncycastle.crypto.paddings.ZeroBytePadding" 09:00:58,686 TRACE [main][CryptoRegistry] registerAsymmetricBlockCipherPadding: paddingName="ISO9796-1" paddingClass="org.bouncycastle.crypto.encodings.ISO9796d1Encoding" 09:00:58,689 TRACE [main][CryptoRegistry] registerAsymmetricBlockCipherPadding: paddingName="OAEP" paddingClass="org.bouncycastle.crypto.encodings.OAEPEncoding" 09:00:58,690 TRACE [main][CryptoRegistry] registerAsymmetricBlockCipherPadding: paddingName="OAEPWITHSHA1ANDMGF1" paddingClass="org.bouncycastle.crypto.encodings.OAEPEncoding" 09:00:58,691 TRACE [main][CryptoRegistry] registerAsymmetricBlockCipherPadding: paddingName="PKCS1" paddingClass="org.bouncycastle.crypto.encodings.PKCS1Encoding" 09:00:58,705 TRACE [main][CryptoRegistry] registerAsymmetricCipherKeyPairGeneratorFactory: algorithmName="DH" factoryClass="org.cumulus4j.crypto.internal.asymmetric.keypairgenerator.DHBasicKeyPairGeneratorFactory" 09:00:58,769 TRACE [main][CryptoRegistry] registerAsymmetricCipherKeyPairGeneratorFactory: algorithmName="DSA" factoryClass="org.cumulus4j.crypto.internal.asymmetric.keypairgenerator.DSAKeyPairGeneratorFactory" 09:00:58,770 TRACE [main][CryptoRegistry] registerAsymmetricCipherKeyPairGeneratorFactory: algorithmName="ElGamal" factoryClass="org.cumulus4j.crypto.internal.asymmetric.keypairgenerator.ElGamalKeyPairGeneratorFactory" 09:00:58,771 TRACE [main][CryptoRegistry] registerAsymmetricCipherKeyPairGeneratorFactory: algorithmName="GOST3410" factoryClass="org.cumulus4j.crypto.internal.asymmetric.keypairgenerator.GOST3410KeyPairGeneratorFactory" 09:00:58,772 TRACE [main][CryptoRegistry] registerAsymmetricCipherKeyPairGeneratorFactory: algorithmName="NaccacheStern" factoryClass="org.cumulus4j.crypto.internal.asymmetric.keypairgenerator.NaccacheSternKeyPairGeneratorFactory" 09:00:58,774 TRACE [main][CryptoRegistry] registerAsymmetricCipherKeyPairGeneratorFactory: algorithmName="RSA" factoryClass="org.cumulus4j.crypto.internal.asymmetric.keypairgenerator.RSAKeyPairGeneratorFactory" 09:00:58,786 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is set to 'HMACSHA1'. Using this MAC algorithm. 09:01:01,298 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@60c94dfd 09:01:17,561 INFO [main][KeyStoreKeyTest] generateAndReadManyKeysBulk (35000 keys): 00.generateManyKeysBulk invocationCount=1 recursionLevel=0 invocationCount=1 accumulatedTime=15733 minTime=15733 maxTime=15733 07.readKeyStore invocationCount=1 recursionLevel=0 invocationCount=1 accumulatedTime=495 minTime=495 maxTime=495 10.readManyKeys invocationCount=1 recursionLevel=0 invocationCount=1 accumulatedTime=2366 minTime=2366 maxTime=2366 09:01:17,582 WARN [main][KeyStore] getMasterKey: Unknown userName: marco 09:01:17,589 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is not set. Using default key size (256 bit). 09:01:17,590 INFO [main][KeyStore] createUser: Created master-key with a size of 256 bits. This key will not be modified for this key-store anymore. 09:01:17,591 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is set to 'AES/CBC/PKCS5Padding'. Using this encryption algorithm. 09:01:17,598 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is set to 'HMACSHA1'. Using this MAC algorithm. 09:01:17,606 WARN [main][KeyStore] getMasterKey: Caught CryptoException indicating a wrong password for user "marco"! 09:01:17,607 WARN [main][KeyStore] getMasterKey: Wrong password for user "marco"! MAC verification failed. 09:01:17,608 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is not set. Using default key size (256 bit). 09:01:17,609 INFO [main][KeyStore] createUser: Created master-key with a size of 256 bits. This key will not be modified for this key-store anymore. 09:01:17,609 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is set to 'AES/CBC/PKCS5Padding'. Using this encryption algorithm. 09:01:17,616 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is set to 'HMACSHA1'. Using this MAC algorithm. 09:01:17,632 DEBUG [main][CachedMasterKey] clear: Clearing for userName='marco'. 09:01:17,632 DEBUG [main][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@724af044 09:01:17,640 DEBUG [main][CachedMasterKey] clear: Clearing for userName='marco'. 09:01:17,640 DEBUG [main][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@4678c730 09:01:17,660 DEBUG [main][CachedMasterKey] clear: Clearing for userName='marco'. 09:01:17,660 DEBUG [main][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@6767c1fc 09:01:17,670 DEBUG [main][CachedMasterKey] clear: Clearing for userName='marco'. 09:01:17,670 DEBUG [main][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@29ee9faa 09:01:17,688 DEBUG [main][CachedMasterKey] clear: Clearing for userName='marco'. 09:01:17,688 DEBUG [main][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@c038203 09:01:17,712 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is not set. Using default key size (256 bit). 09:01:17,712 INFO [main][KeyStore] createUser: Created master-key with a size of 256 bits. This key will not be modified for this key-store anymore. 09:01:17,715 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is set to 'AES/CBC/PKCS5Padding'. Using this encryption algorithm. 09:01:17,737 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is set to 'HMACSHA1'. Using this MAC algorithm. 09:01:17,755 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is set to 'HMACSHA1'. Using this MAC algorithm. 09:01:17,756 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is set to 'AES/CBC/PKCS5Padding'. Using this encryption algorithm. 09:01:17,756 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is not set. Using default key size (256 bit). 09:01:17,797 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is not set. Using default key size (256 bit). 09:01:17,797 INFO [main][KeyStore] createUser: Created master-key with a size of 256 bits. This key will not be modified for this key-store anymore. 09:01:17,797 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is set to 'AES/CBC/PKCS5Padding'. Using this encryption algorithm. 09:01:17,804 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is set to 'HMACSHA1'. Using this MAC algorithm. 09:01:57,254 DEBUG [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: 1 users left in cache. 09:02:00,952 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@6e0eaf94 09:02:00,953 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@6a31268d 09:02:00,959 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:02:00,960 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@6a31268d 09:02:00,960 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@2f33a5af 09:02:00,960 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:02:00,960 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@2f33a5af 09:02:00,960 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@53fa311 09:02:00,961 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@1e56ce2d 09:02:00,961 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@c038203 09:02:00,961 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@29ee9faa 09:02:00,961 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@6767c1fc 09:02:00,961 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@4678c730 09:02:00,961 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@724af044 09:02:00,961 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@7db09624 09:02:00,961 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:02:00,961 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@1e56ce2d 09:02:00,962 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@4f1c5ae0 09:02:00,968 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@37434f39 09:02:00,968 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:02:00,968 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@37434f39 09:02:15,195 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:02:17,581 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:02:17,590 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:02:17,608 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:02:17,715 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:02:17,748 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:02:17,758 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:02:17,811 DEBUG [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: 1 users left in cache. 09:02:19,475 INFO [main][KeyStoreKeyTest] generateAndReadManyKeysIndividually: firstKeyID=1 lastKeyID=5000 09:02:19,645 INFO [main][KeyStoreKeyTest] generateAndReadManyKeysIndividually (5000 keys): 00.generateManyKeysIndividually invocationCount=1 recursionLevel=0 invocationCount=1 accumulatedTime=61670 minTime=61670 maxTime=61670 05.generateOneKey invocationCount=5000 recursionLevel=0 invocationCount=5000 accumulatedTime=61341 minTime=0 maxTime=157 07.readKeyStore invocationCount=1 recursionLevel=0 invocationCount=1 accumulatedTime=23 minTime=23 maxTime=23 10.readManyKeys invocationCount=1 recursionLevel=0 invocationCount=1 accumulatedTime=146 minTime=146 maxTime=146 Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 84.399 sec Running org.cumulus4j.keystore.test.DateDependentKeyStrategyTest 09:02:19,663 DEBUG [main][DateDependentKeyStrategy] init: Calculated numberOfKeysToGenerate=5761 09:02:19,664 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is not set. Using default key size (256 bit). 09:02:19,664 INFO [main][KeyStore] createUser: Created master-key with a size of 256 bits. This key will not be modified for this key-store anymore. 09:02:19,664 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is not set. Using default algorithm 'Twofish/GCM/NoPadding'. 09:02:19,679 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is not set. Using default MAC algorithm 'NONE'. 09:02:22,544 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@1f4cd85a 09:02:22,561 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@66b47c21 09:02:22,577 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:02:22,577 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@66b47c21 09:02:22,580 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@4b52e14d 09:02:22,581 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:02:22,581 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@4b52e14d Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.496 sec Running org.cumulus4j.keystore.test.KeyStorePropertyTest 09:02:23,226 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is not set. Using default key size (256 bit). 09:02:23,226 INFO [main][KeyStore] createUser: Created master-key with a size of 256 bits. This key will not be modified for this key-store anymore. 09:02:23,226 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is not set. Using default algorithm 'Twofish/GCM/NoPadding'. 09:02:23,233 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is not set. Using default MAC algorithm 'NONE'. 09:02:23,247 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is not set. Using default key size (256 bit). 09:02:23,248 INFO [main][KeyStore] createUser: Created master-key with a size of 256 bits. This key will not be modified for this key-store anymore. 09:02:23,249 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is not set. Using default algorithm 'Twofish/GCM/NoPadding'. 09:02:23,256 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is not set. Using default MAC algorithm 'NONE'. 09:02:23,266 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is not set. Using default key size (256 bit). 09:02:23,266 INFO [main][KeyStore] createUser: Created master-key with a size of 256 bits. This key will not be modified for this key-store anymore. 09:02:23,267 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is not set. Using default algorithm 'Twofish/GCM/NoPadding'. 09:02:23,274 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is not set. Using default MAC algorithm 'NONE'. 09:02:23,307 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is not set. Using default key size (256 bit). 09:02:23,308 INFO [main][KeyStore] createUser: Created master-key with a size of 256 bits. This key will not be modified for this key-store anymore. 09:02:23,308 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is not set. Using default algorithm 'Twofish/GCM/NoPadding'. 09:02:23,337 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is not set. Using default MAC algorithm 'NONE'. 09:02:23,410 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is not set. Using default key size (256 bit). 09:02:23,410 INFO [main][KeyStore] createUser: Created master-key with a size of 256 bits. This key will not be modified for this key-store anymore. 09:02:23,411 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is not set. Using default algorithm 'Twofish/GCM/NoPadding'. 09:02:23,418 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is not set. Using default MAC algorithm 'NONE'. Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.223 sec Running org.cumulus4j.keystore.test.KeyStoreKeyTest 09:02:23,476 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is not set. Using default key size (256 bit). 09:02:23,481 INFO [main][KeyStore] createUser: Created master-key with a size of 256 bits. This key will not be modified for this key-store anymore. 09:02:23,481 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is not set. Using default algorithm 'Twofish/GCM/NoPadding'. 09:02:23,488 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is not set. Using default MAC algorithm 'NONE'. 09:02:25,555 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@66c55599 09:02:25,556 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@1fb2cf13 09:02:25,576 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:02:25,576 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@5a22edb0 09:02:25,576 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@6a62730 09:02:25,576 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@5a22edb0 09:02:25,577 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:02:25,577 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@4a03d3e0 09:02:25,577 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@4a03d3e0 09:02:25,577 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:02:25,577 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@434057e4 09:02:25,577 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@ec27d51 09:02:25,577 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@434057e4 09:02:25,578 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:02:25,578 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@1fb2cf13 09:02:25,578 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@396a541e 09:02:25,578 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@6d220c00 09:02:25,578 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:02:25,579 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@2c9c8937 09:02:25,579 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@2c9c8937 09:02:25,579 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:02:25,579 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@31295100 09:02:25,579 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@31295100 09:02:25,579 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:02:25,579 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@5a08299f 09:02:25,579 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@27376cd2 09:02:25,579 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@5a08299f 09:02:25,581 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:02:25,582 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@6f2a8c32 09:02:25,582 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@14706186 09:02:25,582 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@6f2a8c32 09:02:25,582 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:02:25,582 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@6d220c00 09:02:44,197 INFO [main][KeyStoreKeyTest] generateAndReadManyKeysBulk (35000 keys): 00.generateManyKeysBulk invocationCount=1 recursionLevel=0 invocationCount=1 accumulatedTime=16221 minTime=16221 maxTime=16221 07.readKeyStore invocationCount=1 recursionLevel=0 invocationCount=1 accumulatedTime=260 minTime=260 maxTime=260 10.readManyKeys invocationCount=1 recursionLevel=0 invocationCount=1 accumulatedTime=4205 minTime=4205 maxTime=4205 09:02:44,201 WARN [main][KeyStore] getMasterKey: Unknown userName: marco 09:02:44,203 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is not set. Using default key size (256 bit). 09:02:44,203 INFO [main][KeyStore] createUser: Created master-key with a size of 256 bits. This key will not be modified for this key-store anymore. 09:02:44,204 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is not set. Using default algorithm 'Twofish/GCM/NoPadding'. 09:02:44,213 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is not set. Using default MAC algorithm 'NONE'. 09:02:44,221 WARN [main][KeyStore] getMasterKey: Caught CryptoException indicating a wrong password for user "marco"! 09:02:44,221 WARN [main][KeyStore] getMasterKey: Wrong password for user "marco"! MAC verification failed. 09:02:44,225 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is not set. Using default key size (256 bit). 09:02:44,225 INFO [main][KeyStore] createUser: Created master-key with a size of 256 bits. This key will not be modified for this key-store anymore. 09:02:44,226 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is not set. Using default algorithm 'Twofish/GCM/NoPadding'. 09:02:44,233 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is not set. Using default MAC algorithm 'NONE'. 09:02:44,250 DEBUG [main][CachedMasterKey] clear: Clearing for userName='marco'. 09:02:44,257 DEBUG [main][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@26653222 09:02:44,272 DEBUG [main][CachedMasterKey] clear: Clearing for userName='marco'. 09:02:44,272 DEBUG [main][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@3532ec19 09:02:44,280 DEBUG [main][CachedMasterKey] clear: Clearing for userName='marco'. 09:02:44,281 DEBUG [main][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@68c4039c 09:02:44,288 DEBUG [main][CachedMasterKey] clear: Clearing for userName='marco'. 09:02:44,289 DEBUG [main][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@ae45eb6 09:02:44,296 DEBUG [main][CachedMasterKey] clear: Clearing for userName='marco'. 09:02:44,296 DEBUG [main][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@59f99ea 09:02:44,305 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is not set. Using default key size (256 bit). 09:02:44,305 INFO [main][KeyStore] createUser: Created master-key with a size of 256 bits. This key will not be modified for this key-store anymore. 09:02:44,305 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is not set. Using default algorithm 'Twofish/GCM/NoPadding'. 09:02:44,315 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is not set. Using default MAC algorithm 'NONE'. 09:02:44,351 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is not set. Using default MAC algorithm 'NONE'. 09:02:44,352 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is not set. Using default algorithm 'Twofish/GCM/NoPadding'. 09:02:44,367 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is not set. Using default key size (256 bit). 09:02:44,391 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is not set. Using default key size (256 bit). 09:02:44,391 INFO [main][KeyStore] createUser: Created master-key with a size of 256 bits. This key will not be modified for this key-store anymore. 09:02:44,392 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is not set. Using default algorithm 'Twofish/GCM/NoPadding'. 09:02:44,412 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is not set. Using default MAC algorithm 'NONE'. 09:02:57,254 DEBUG [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: 1 users left in cache. 09:03:17,797 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:03:19,499 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:03:19,661 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:03:21,091 INFO [main][KeyStoreKeyTest] generateAndReadManyKeysIndividually: firstKeyID=1 lastKeyID=5000 09:03:21,522 INFO [main][KeyStoreKeyTest] generateAndReadManyKeysIndividually (5000 keys): 00.generateManyKeysIndividually invocationCount=1 recursionLevel=0 invocationCount=1 accumulatedTime=36679 minTime=36679 maxTime=36679 05.generateOneKey invocationCount=5000 recursionLevel=0 invocationCount=5000 accumulatedTime=36548 minTime=0 maxTime=355 07.readKeyStore invocationCount=1 recursionLevel=0 invocationCount=1 accumulatedTime=11 minTime=11 maxTime=11 10.readManyKeys invocationCount=1 recursionLevel=0 invocationCount=1 accumulatedTime=418 minTime=418 maxTime=418 Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 58.062 sec Running org.cumulus4j.keystore.test.KeyStoreCompatibilityTest 09:03:21,532 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is not set. Using default key size (256 bit). 09:03:21,532 INFO [main][KeyStore] createUser: Created master-key with a size of 256 bits. This key will not be modified for this key-store anymore. 09:03:21,532 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is not set. Using default algorithm 'Twofish/GCM/NoPadding'. 09:03:21,540 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is not set. Using default MAC algorithm 'NONE'. 09:03:21,876 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is set to 128 bit. Using this key size. 09:03:21,876 INFO [main][KeyStore] createUser: Created master-key with a size of 128 bits. This key will not be modified for this key-store anymore. 09:03:21,876 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is set to 'AES/CFB/NoPadding'. Using this encryption algorithm. 09:03:21,880 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is set to 'HMAC/SHA1'. Using this MAC algorithm. 09:03:22,097 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is set to 128 bit. Using this key size. 09:03:22,098 INFO [main][KeyStore] createUser: Created master-key with a size of 128 bits. This key will not be modified for this key-store anymore. 09:03:22,098 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is set to 'AES/CBC/PKCS5Padding'. Using this encryption algorithm. 09:03:22,103 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is set to 'HMAC/SHA1'. Using this MAC algorithm. 09:03:22,385 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is set to 256 bit. Using this key size. 09:03:22,385 INFO [main][KeyStore] createUser: Created master-key with a size of 256 bits. This key will not be modified for this key-store anymore. 09:03:22,392 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is set to 'AES/CFB/NoPadding'. Using this encryption algorithm. 09:03:22,411 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is set to 'HMAC/SHA1'. Using this MAC algorithm. 09:03:22,608 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is set to 256 bit. Using this key size. 09:03:22,608 INFO [main][KeyStore] createUser: Created master-key with a size of 256 bits. This key will not be modified for this key-store anymore. 09:03:22,608 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is set to 'AES/CBC/PKCS5Padding'. Using this encryption algorithm. 09:03:22,614 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is set to 'HMAC/SHA1'. Using this MAC algorithm. 09:03:22,862 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is set to 128 bit. Using this key size. 09:03:22,862 INFO [main][KeyStore] createUser: Created master-key with a size of 128 bits. This key will not be modified for this key-store anymore. 09:03:22,863 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is set to 'Twofish/CFB/NoPadding'. Using this encryption algorithm. 09:03:22,872 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is set to 'HMAC/SHA1'. Using this MAC algorithm. 09:03:23,227 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:03:23,228 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is set to 128 bit. Using this key size. 09:03:23,228 INFO [main][KeyStore] createUser: Created master-key with a size of 128 bits. This key will not be modified for this key-store anymore. 09:03:23,228 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is set to 'Twofish/CBC/PKCS5Padding'. Using this encryption algorithm. 09:03:23,233 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is set to 'HMAC/SHA1'. Using this MAC algorithm. 09:03:23,247 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:03:23,265 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:03:23,290 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:03:23,307 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:03:23,387 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:03:23,411 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:03:23,429 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:03:23,476 DEBUG [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: 1 users left in cache. 09:03:23,611 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is set to 256 bit. Using this key size. 09:03:23,612 INFO [main][KeyStore] createUser: Created master-key with a size of 256 bits. This key will not be modified for this key-store anymore. 09:03:23,612 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is set to 'Twofish/CFB/NoPadding'. Using this encryption algorithm. 09:03:23,618 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is set to 'HMAC/SHA1'. Using this MAC algorithm. 09:03:23,921 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is set to 256 bit. Using this key size. 09:03:23,921 INFO [main][KeyStore] createUser: Created master-key with a size of 256 bits. This key will not be modified for this key-store anymore. 09:03:23,921 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is set to 'Twofish/CBC/PKCS5Padding'. Using this encryption algorithm. 09:03:23,928 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is set to 'HMAC/SHA1'. Using this MAC algorithm. 09:03:24,290 INFO [main][KeyStoreCompatibilityTest] openReferenceKeystore: Reference-KeyStore was successfully opened. 09:03:24,291 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is not set. Using default MAC algorithm 'NONE'. 09:03:24,291 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is not set. Using default algorithm 'Twofish/GCM/NoPadding'. 09:03:24,291 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is not set. Using default key size (256 bit). 09:03:24,293 INFO [main][KeyStoreCompatibilityTest] openReferenceKeystore: New key was successfully generated. 09:03:24,301 INFO [main][KeyStoreCompatibilityTest] openReferenceKeystore: Reference-KeyStore was successfully opened. 09:03:24,301 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is set to 'HMAC/SHA1'. Using this MAC algorithm. 09:03:24,301 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is set to 'AES/CFB/NoPadding'. Using this encryption algorithm. 09:03:24,301 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is set to 128 bit. Using this key size. 09:03:24,341 INFO [main][KeyStoreCompatibilityTest] openReferenceKeystore: New key was successfully generated. 09:03:24,352 INFO [main][KeyStoreCompatibilityTest] openReferenceKeystore: Reference-KeyStore was successfully opened. 09:03:24,352 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is set to 'HMAC/SHA1'. Using this MAC algorithm. 09:03:24,352 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is set to 'AES/CBC/PKCS5Padding'. Using this encryption algorithm. 09:03:24,352 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is set to 128 bit. Using this key size. 09:03:24,354 INFO [main][KeyStoreCompatibilityTest] openReferenceKeystore: New key was successfully generated. 09:03:24,365 INFO [main][KeyStoreCompatibilityTest] openReferenceKeystore: Reference-KeyStore was successfully opened. 09:03:24,365 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is set to 'HMAC/SHA1'. Using this MAC algorithm. 09:03:24,365 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is set to 'AES/CFB/NoPadding'. Using this encryption algorithm. 09:03:24,365 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is set to 256 bit. Using this key size. 09:03:24,367 INFO [main][KeyStoreCompatibilityTest] openReferenceKeystore: New key was successfully generated. 09:03:24,377 INFO [main][KeyStoreCompatibilityTest] openReferenceKeystore: Reference-KeyStore was successfully opened. 09:03:24,378 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is set to 'HMAC/SHA1'. Using this MAC algorithm. 09:03:24,378 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is set to 'AES/CBC/PKCS5Padding'. Using this encryption algorithm. 09:03:24,378 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is set to 256 bit. Using this key size. 09:03:24,454 INFO [main][KeyStoreCompatibilityTest] openReferenceKeystore: New key was successfully generated. 09:03:24,472 INFO [main][KeyStoreCompatibilityTest] openReferenceKeystore: Reference-KeyStore was successfully opened. 09:03:24,472 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is set to 'HMAC/SHA1'. Using this MAC algorithm. 09:03:24,472 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is set to 'Twofish/CFB/NoPadding'. Using this encryption algorithm. 09:03:24,472 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is set to 128 bit. Using this key size. 09:03:24,474 INFO [main][KeyStoreCompatibilityTest] openReferenceKeystore: New key was successfully generated. 09:03:24,482 INFO [main][KeyStoreCompatibilityTest] openReferenceKeystore: Reference-KeyStore was successfully opened. 09:03:24,482 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is set to 'HMAC/SHA1'. Using this MAC algorithm. 09:03:24,482 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is set to 'Twofish/CBC/PKCS5Padding'. Using this encryption algorithm. 09:03:24,484 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is set to 128 bit. Using this key size. 09:03:24,486 INFO [main][KeyStoreCompatibilityTest] openReferenceKeystore: New key was successfully generated. 09:03:24,497 INFO [main][KeyStoreCompatibilityTest] openReferenceKeystore: Reference-KeyStore was successfully opened. 09:03:24,497 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is set to 'HMAC/SHA1'. Using this MAC algorithm. 09:03:24,497 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is set to 'Twofish/CFB/NoPadding'. Using this encryption algorithm. 09:03:24,497 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is set to 256 bit. Using this key size. 09:03:24,500 INFO [main][KeyStoreCompatibilityTest] openReferenceKeystore: New key was successfully generated. 09:03:24,511 INFO [main][KeyStoreCompatibilityTest] openReferenceKeystore: Reference-KeyStore was successfully opened. 09:03:24,511 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is set to 'HMAC/SHA1'. Using this MAC algorithm. 09:03:24,511 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is set to 'Twofish/CBC/PKCS5Padding'. Using this encryption algorithm. 09:03:24,511 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is set to 256 bit. Using this key size. 09:03:24,531 INFO [main][KeyStoreCompatibilityTest] openReferenceKeystore: New key was successfully generated. 09:03:24,544 INFO [main][KeyStoreCompatibilityTest] openReferenceKeystore: Reference-KeyStore was successfully opened. 09:03:24,544 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is not set. Using default MAC algorithm 'NONE'. 09:03:24,544 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is not set. Using default algorithm 'Twofish/GCM/NoPadding'. 09:03:24,544 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is not set. Using default key size (256 bit). 09:03:24,549 INFO [main][KeyStoreCompatibilityTest] openReferenceKeystore: New key was successfully generated. 09:03:24,558 INFO [main][KeyStoreCompatibilityTest] openReferenceKeystore: Reference-KeyStore was successfully opened. 09:03:24,558 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is set to 'HMAC/SHA1'. Using this MAC algorithm. 09:03:24,558 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is set to 'AES/CFB/NoPadding'. Using this encryption algorithm. 09:03:24,558 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is set to 128 bit. Using this key size. 09:03:24,561 INFO [main][KeyStoreCompatibilityTest] openReferenceKeystore: New key was successfully generated. 09:03:24,570 INFO [main][KeyStoreCompatibilityTest] openReferenceKeystore: Reference-KeyStore was successfully opened. 09:03:24,570 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is set to 'HMAC/SHA1'. Using this MAC algorithm. 09:03:24,570 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is set to 'AES/CBC/PKCS5Padding'. Using this encryption algorithm. 09:03:24,570 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is set to 128 bit. Using this key size. 09:03:24,605 INFO [main][KeyStoreCompatibilityTest] openReferenceKeystore: New key was successfully generated. 09:03:24,618 INFO [main][KeyStoreCompatibilityTest] openReferenceKeystore: Reference-KeyStore was successfully opened. 09:03:24,618 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is set to 'HMAC/SHA1'. Using this MAC algorithm. 09:03:24,618 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is set to 'AES/CFB/NoPadding'. Using this encryption algorithm. 09:03:24,618 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is set to 256 bit. Using this key size. 09:03:24,620 INFO [main][KeyStoreCompatibilityTest] openReferenceKeystore: New key was successfully generated. 09:03:24,639 INFO [main][KeyStoreCompatibilityTest] openReferenceKeystore: Reference-KeyStore was successfully opened. 09:03:24,639 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is set to 'HMAC/SHA1'. Using this MAC algorithm. 09:03:24,640 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is set to 'AES/CBC/PKCS5Padding'. Using this encryption algorithm. 09:03:24,640 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is set to 256 bit. Using this key size. 09:03:24,689 INFO [main][KeyStoreCompatibilityTest] openReferenceKeystore: New key was successfully generated. 09:03:24,701 INFO [main][KeyStoreCompatibilityTest] openReferenceKeystore: Reference-KeyStore was successfully opened. 09:03:24,701 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is set to 'HMAC/SHA1'. Using this MAC algorithm. 09:03:24,701 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is set to 'Twofish/CFB/NoPadding'. Using this encryption algorithm. 09:03:24,701 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is set to 128 bit. Using this key size. 09:03:24,704 INFO [main][KeyStoreCompatibilityTest] openReferenceKeystore: New key was successfully generated. 09:03:24,711 INFO [main][KeyStoreCompatibilityTest] openReferenceKeystore: Reference-KeyStore was successfully opened. 09:03:24,711 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is set to 'HMAC/SHA1'. Using this MAC algorithm. 09:03:24,711 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is set to 'Twofish/CBC/PKCS5Padding'. Using this encryption algorithm. 09:03:24,712 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is set to 128 bit. Using this key size. 09:03:24,714 INFO [main][KeyStoreCompatibilityTest] openReferenceKeystore: New key was successfully generated. 09:03:24,725 INFO [main][KeyStoreCompatibilityTest] openReferenceKeystore: Reference-KeyStore was successfully opened. 09:03:24,726 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is set to 'HMAC/SHA1'. Using this MAC algorithm. 09:03:24,726 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is set to 'Twofish/CFB/NoPadding'. Using this encryption algorithm. 09:03:24,726 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is set to 256 bit. Using this key size. 09:03:24,728 INFO [main][KeyStoreCompatibilityTest] openReferenceKeystore: New key was successfully generated. 09:03:24,739 INFO [main][KeyStoreCompatibilityTest] openReferenceKeystore: Reference-KeyStore was successfully opened. 09:03:24,739 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is set to 'HMAC/SHA1'. Using this MAC algorithm. 09:03:24,739 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is set to 'Twofish/CBC/PKCS5Padding'. Using this encryption algorithm. 09:03:24,739 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is set to 256 bit. Using this key size. 09:03:24,773 INFO [main][KeyStoreCompatibilityTest] openReferenceKeystore: New key was successfully generated. Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.248 sec Running org.cumulus4j.keystore.test.KeyStoreKey_Twofish_CBC_PKCS5Padding_Test 09:03:24,787 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is not set. Using default key size (256 bit). 09:03:24,787 INFO [main][KeyStore] createUser: Created master-key with a size of 256 bits. This key will not be modified for this key-store anymore. 09:03:24,787 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is set to 'Twofish/CBC/PKCS5Padding'. Using this encryption algorithm. 09:03:24,794 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is set to 'HMACSHA1'. Using this MAC algorithm. 09:03:25,645 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@f2ff646 09:03:25,645 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:03:25,645 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@13e25a8d 09:03:25,645 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@28121fdf 09:03:25,645 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@26653222 09:03:25,645 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@3532ec19 09:03:25,645 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@68c4039c 09:03:25,645 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@ae45eb6 09:03:25,646 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@59f99ea 09:03:25,646 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@13e25a8d 09:03:25,646 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@3ff9370a 09:03:25,646 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:03:25,646 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@4f147b75 09:03:25,646 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@4f147b75 09:03:25,646 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:03:25,646 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@4ea36628 09:03:25,646 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@4ea36628 09:03:25,646 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:03:25,646 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@76f764c4 09:03:25,647 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@c05c77 09:03:25,647 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@76f764c4 09:03:25,648 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@6c6350c9 09:03:25,648 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@39a4f94b 09:03:25,648 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:03:25,648 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@39a4f94b 09:03:25,648 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@74387bff 09:03:25,648 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:03:25,648 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@74387bff 09:03:25,648 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@7699a2eb 09:03:25,648 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:03:25,648 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@7699a2eb 09:03:25,649 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@8a51e9 09:03:25,649 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:03:25,649 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@8a51e9 09:03:25,649 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@1e7a8e12 09:03:25,649 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:03:25,649 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@1e7a8e12 09:03:25,649 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@29aae9a1 09:03:25,649 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:03:25,650 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@29aae9a1 09:03:25,650 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@129f9885 09:03:25,650 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:03:25,650 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@129f9885 09:03:25,650 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@40489626 09:03:25,650 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:03:25,650 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@40489626 09:03:25,650 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@a888a23 09:03:25,650 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:03:25,650 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@a888a23 09:03:25,651 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@74119d32 09:03:25,651 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:03:25,651 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@74119d32 09:03:25,651 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@1a246885 09:03:25,651 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:03:25,651 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@1a246885 09:03:25,651 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@1ed92441 09:03:25,651 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:03:25,652 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@1ed92441 09:03:25,652 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@50ce7c2b 09:03:25,652 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:03:25,652 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@50ce7c2b 09:03:25,652 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@284e830d 09:03:25,652 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:03:25,652 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@284e830d 09:03:25,652 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@1197a6c1 09:03:25,652 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:03:25,652 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@1197a6c1 09:03:25,652 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@463b639e 09:03:25,652 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:03:25,652 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@463b639e 09:03:25,653 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@65377056 09:03:25,653 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:03:25,653 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@65377056 09:03:25,653 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@393dd116 09:03:25,653 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:03:25,653 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@393dd116 09:03:25,653 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@15b0c95e 09:03:25,653 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@88a6fe5 09:03:25,653 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:03:25,653 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@15b0c95e 09:03:25,653 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@56610b62 09:03:25,653 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@183c5d9 09:03:25,654 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:03:25,654 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@56610b62 09:03:25,654 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@126a168e 09:03:25,654 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@4944b661 09:03:25,654 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:03:25,654 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@126a168e 09:03:25,654 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@17a09e30 09:03:25,654 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@8922c10 09:03:25,654 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:03:25,654 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@17a09e30 09:03:25,654 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@4a8e95ea 09:03:25,654 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@2615c564 09:03:25,654 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:03:25,655 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@4a8e95ea 09:03:25,655 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@35d79e88 09:03:25,655 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@2cbcc68e 09:03:25,655 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:03:25,655 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@35d79e88 09:03:25,655 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@12233736 09:03:25,656 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@1a15eef3 09:03:25,656 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:03:25,656 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@12233736 09:03:25,656 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@13bf10e7 09:03:25,656 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@597d3ca8 09:03:25,656 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:03:25,656 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@13bf10e7 09:03:25,656 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@52ec3a36 09:03:25,656 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@673b34ee 09:03:25,656 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:03:25,656 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@52ec3a36 09:03:25,656 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@c6828c6 09:03:25,656 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:03:25,657 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@c6828c6 09:03:38,234 INFO [main][KeyStoreKeyTest] generateAndReadManyKeysBulk (35000 keys): 00.generateManyKeysBulk invocationCount=1 recursionLevel=0 invocationCount=1 accumulatedTime=10655 minTime=10655 maxTime=10655 07.readKeyStore invocationCount=1 recursionLevel=0 invocationCount=1 accumulatedTime=117 minTime=117 maxTime=117 10.readManyKeys invocationCount=1 recursionLevel=0 invocationCount=1 accumulatedTime=2645 minTime=2645 maxTime=2645 09:03:38,238 WARN [main][KeyStore] getMasterKey: Unknown userName: marco 09:03:38,239 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is not set. Using default key size (256 bit). 09:03:38,239 INFO [main][KeyStore] createUser: Created master-key with a size of 256 bits. This key will not be modified for this key-store anymore. 09:03:38,239 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is set to 'Twofish/CBC/PKCS5Padding'. Using this encryption algorithm. 09:03:38,246 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is set to 'HMACSHA1'. Using this MAC algorithm. 09:03:38,253 WARN [main][KeyStore] getMasterKey: Caught CryptoException indicating a wrong password for user "marco"! 09:03:38,253 WARN [main][KeyStore] getMasterKey: Wrong password for user "marco"! MAC verification failed. 09:03:38,256 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is not set. Using default key size (256 bit). 09:03:38,256 INFO [main][KeyStore] createUser: Created master-key with a size of 256 bits. This key will not be modified for this key-store anymore. 09:03:38,256 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is set to 'Twofish/CBC/PKCS5Padding'. Using this encryption algorithm. 09:03:38,262 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is set to 'HMACSHA1'. Using this MAC algorithm. 09:03:38,270 DEBUG [main][CachedMasterKey] clear: Clearing for userName='marco'. 09:03:38,270 DEBUG [main][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@4883b407 09:03:38,277 DEBUG [main][CachedMasterKey] clear: Clearing for userName='marco'. 09:03:38,277 DEBUG [main][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@7d9d1a19 09:03:38,285 DEBUG [main][CachedMasterKey] clear: Clearing for userName='marco'. 09:03:38,285 DEBUG [main][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@39c0f4a 09:03:38,292 DEBUG [main][CachedMasterKey] clear: Clearing for userName='marco'. 09:03:38,292 DEBUG [main][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@1794d431 09:03:38,300 DEBUG [main][CachedMasterKey] clear: Clearing for userName='marco'. 09:03:38,300 DEBUG [main][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@42e26948 09:03:38,310 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is not set. Using default key size (256 bit). 09:03:38,310 INFO [main][KeyStore] createUser: Created master-key with a size of 256 bits. This key will not be modified for this key-store anymore. 09:03:38,310 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is set to 'Twofish/CBC/PKCS5Padding'. Using this encryption algorithm. 09:03:38,317 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is set to 'HMACSHA1'. Using this MAC algorithm. 09:03:38,324 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is set to 'HMACSHA1'. Using this MAC algorithm. 09:03:38,325 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is set to 'Twofish/CBC/PKCS5Padding'. Using this encryption algorithm. 09:03:38,325 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is not set. Using default key size (256 bit). 09:03:38,334 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is not set. Using default key size (256 bit). 09:03:38,334 INFO [main][KeyStore] createUser: Created master-key with a size of 256 bits. This key will not be modified for this key-store anymore. 09:03:38,334 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is set to 'Twofish/CBC/PKCS5Padding'. Using this encryption algorithm. 09:03:38,341 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is set to 'HMACSHA1'. Using this MAC algorithm. 09:03:39,751 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@3cc0cd9f 09:03:39,751 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@f4e7dbb 09:03:39,766 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:03:39,766 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@f4e7dbb 09:03:39,766 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@316cb4f8 09:03:39,767 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:03:39,767 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@316cb4f8 09:03:39,767 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@7c0f840b 09:03:39,767 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@46991220 09:03:39,767 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@42e26948 09:03:39,768 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@1794d431 09:03:39,768 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@39c0f4a 09:03:39,768 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@7d9d1a19 09:03:39,768 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@4883b407 09:03:39,768 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@3ac61ced 09:03:39,768 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:03:39,768 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@46991220 09:03:39,768 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@6e59b439 09:03:39,769 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@6e765a25 09:03:39,769 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:03:39,769 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@6e765a25 09:03:39,993 DEBUG [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: 1 users left in cache. 09:03:44,201 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:03:44,203 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:03:44,225 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:03:44,304 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:03:44,333 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:03:44,369 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:03:44,392 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:03:57,254 DEBUG [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: 1 users left in cache. 09:04:13,112 INFO [main][KeyStoreKeyTest] generateAndReadManyKeysIndividually: firstKeyID=1 lastKeyID=5000 09:04:13,439 INFO [main][KeyStoreKeyTest] generateAndReadManyKeysIndividually (5000 keys): 00.generateManyKeysIndividually invocationCount=1 recursionLevel=0 invocationCount=1 accumulatedTime=34771 minTime=34771 maxTime=34771 05.generateOneKey invocationCount=5000 recursionLevel=0 invocationCount=5000 accumulatedTime=34613 minTime=0 maxTime=100 07.readKeyStore invocationCount=1 recursionLevel=0 invocationCount=1 accumulatedTime=14 minTime=14 maxTime=14 10.readManyKeys invocationCount=1 recursionLevel=0 invocationCount=1 accumulatedTime=313 minTime=313 maxTime=313 Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 48.66 sec Running org.cumulus4j.keystore.test.LongPropertyTest Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.019 sec Running org.cumulus4j.keystore.test.KeyStoreUserTest 09:04:13,471 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is not set. Using default key size (256 bit). 09:04:13,471 INFO [main][KeyStore] createUser: Created master-key with a size of 256 bits. This key will not be modified for this key-store anymore. 09:04:13,471 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is not set. Using default algorithm 'Twofish/GCM/NoPadding'. 09:04:13,477 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is not set. Using default MAC algorithm 'NONE'. 09:04:13,478 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is not set. Using default key size (256 bit). 09:04:13,478 INFO [main][KeyStore] createUser: Created master-key with a size of 256 bits. This key will not be modified for this key-store anymore. 09:04:13,478 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is not set. Using default algorithm 'Twofish/GCM/NoPadding'. 09:04:13,484 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is not set. Using default MAC algorithm 'NONE'. 09:04:13,497 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is not set. Using default key size (256 bit). 09:04:13,497 INFO [main][KeyStore] createUser: Created master-key with a size of 256 bits. This key will not be modified for this key-store anymore. 09:04:13,497 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is not set. Using default algorithm 'Twofish/GCM/NoPadding'. 09:04:13,503 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is not set. Using default MAC algorithm 'NONE'. 09:04:13,504 WARN [main][KeyStore] getMasterKey: Unknown userName: null 09:04:13,505 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is not set. Using default key size (256 bit). 09:04:13,505 INFO [main][KeyStore] createUser: Created master-key with a size of 256 bits. This key will not be modified for this key-store anymore. 09:04:13,505 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is not set. Using default algorithm 'Twofish/GCM/NoPadding'. 09:04:13,511 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is not set. Using default MAC algorithm 'NONE'. 09:04:13,518 WARN [main][KeyStore] getMasterKey: Caught CryptoException indicating a wrong password for user "marco"! 09:04:13,518 WARN [main][KeyStore] getMasterKey: Wrong password for user "marco"! MAC verification failed. 09:04:13,518 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is not set. Using default key size (256 bit). 09:04:13,518 INFO [main][KeyStore] createUser: Created master-key with a size of 256 bits. This key will not be modified for this key-store anymore. 09:04:13,519 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is not set. Using default algorithm 'Twofish/GCM/NoPadding'. 09:04:13,525 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is not set. Using default MAC algorithm 'NONE'. 09:04:13,543 DEBUG [main][CachedMasterKey] clear: Clearing for userName='marco'. 09:04:13,543 DEBUG [main][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@343f4d3d 09:04:13,544 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is not set. Using default key size (256 bit). 09:04:13,544 INFO [main][KeyStore] createUser: Created master-key with a size of 256 bits. This key will not be modified for this key-store anymore. 09:04:13,544 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is not set. Using default algorithm 'Twofish/GCM/NoPadding'. 09:04:13,551 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is not set. Using default MAC algorithm 'NONE'. 09:04:13,569 DEBUG [main][CachedMasterKey] clear: Clearing for userName='bieber'. 09:04:13,569 DEBUG [main][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@53b32d7 09:04:13,570 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is not set. Using default key size (256 bit). 09:04:13,570 INFO [main][KeyStore] createUser: Created master-key with a size of 256 bits. This key will not be modified for this key-store anymore. 09:04:13,570 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is not set. Using default algorithm 'Twofish/GCM/NoPadding'. 09:04:13,577 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is not set. Using default MAC algorithm 'NONE'. 09:04:13,601 DEBUG [main][CachedMasterKey] clear: Clearing for userName='marco'. 09:04:13,601 DEBUG [main][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@5442a311 09:04:13,602 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is not set. Using default key size (256 bit). 09:04:13,603 INFO [main][KeyStore] createUser: Created master-key with a size of 256 bits. This key will not be modified for this key-store anymore. 09:04:13,603 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is not set. Using default algorithm 'Twofish/GCM/NoPadding'. 09:04:13,610 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is not set. Using default MAC algorithm 'NONE'. 09:04:13,649 WARN [main][KeyStore] getMasterKey: Caught CryptoException indicating a wrong password for user "bieber"! 09:04:13,649 WARN [main][KeyStore] getMasterKey: Wrong password for user "bieber"! MAC verification failed. 09:04:13,649 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is not set. Using default key size (256 bit). 09:04:13,650 INFO [main][KeyStore] createUser: Created master-key with a size of 256 bits. This key will not be modified for this key-store anymore. 09:04:13,650 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is not set. Using default algorithm 'Twofish/GCM/NoPadding'. 09:04:13,656 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is not set. Using default MAC algorithm 'NONE'. 09:04:13,682 WARN [main][KeyStore] getMasterKey: Caught CryptoException indicating a wrong password for user "marco"! 09:04:13,682 WARN [main][KeyStore] getMasterKey: Wrong password for user "marco"! MAC verification failed. Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.22 sec Running org.cumulus4j.keystore.test.KeyStoreKey_Twofish_CFB_NoPadding_Test 09:04:13,688 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is not set. Using default key size (256 bit). 09:04:13,688 INFO [main][KeyStore] createUser: Created master-key with a size of 256 bits. This key will not be modified for this key-store anymore. 09:04:13,688 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is set to 'Twofish/CFB/NoPadding'. Using this encryption algorithm. 09:04:13,694 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is set to 'HMACSHA1'. Using this MAC algorithm. 09:04:17,466 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:04:17,467 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@60f05dd9 09:04:17,468 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@6a5b045e 09:04:17,468 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@49809d50 09:04:17,469 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@157b5137 09:04:17,469 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@7787c8d4 09:04:17,470 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:04:17,470 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@49809d50 09:04:17,470 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@45cc4b8e 09:04:17,470 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@86b347a 09:04:17,471 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@47d63ea9 09:04:17,471 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@e5e8fef 09:04:17,472 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='bieber'. 09:04:17,472 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@45cc4b8e 09:04:17,472 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:04:17,472 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@47d63ea9 09:04:17,473 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@29e93591 09:04:17,473 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@5442a311 09:04:17,473 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@78f00c32 09:04:17,474 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='bieber'. 09:04:17,474 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@29e93591 09:04:17,474 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@53b32d7 09:04:17,474 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@ea556f3 09:04:17,474 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@74fe813f 09:04:17,475 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:04:17,476 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@ea556f3 09:04:17,476 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@145b778c 09:04:17,476 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@343f4d3d 09:04:17,476 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@6c3268a9 09:04:17,477 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='bieber'. 09:04:17,477 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@145b778c 09:04:17,477 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@4804b912 09:04:17,478 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@48733e54 09:04:17,478 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@7dbd7c1 09:04:17,478 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@785390b3 09:04:17,479 DEBUG [Finalizer][CachedMasterKey] clear: Clearing for userName='marco'. 09:04:17,479 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@7dbd7c1 09:04:17,479 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@15f27a82 09:04:17,480 DEBUG [Finalizer][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@60f05dd9 09:04:21,104 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:04:21,532 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:04:21,876 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:04:22,098 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:04:22,385 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:04:22,386 INFO [main][KeyStoreKeyTest] generateAndReadManyKeysBulk (35000 keys): 00.generateManyKeysBulk invocationCount=1 recursionLevel=0 invocationCount=1 accumulatedTime=6848 minTime=6848 maxTime=6848 07.readKeyStore invocationCount=1 recursionLevel=0 invocationCount=1 accumulatedTime=109 minTime=109 maxTime=109 10.readManyKeys invocationCount=1 recursionLevel=0 invocationCount=1 accumulatedTime=1715 minTime=1715 maxTime=1715 09:04:22,388 WARN [main][KeyStore] getMasterKey: Unknown userName: marco 09:04:22,389 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is not set. Using default key size (256 bit). 09:04:22,389 INFO [main][KeyStore] createUser: Created master-key with a size of 256 bits. This key will not be modified for this key-store anymore. 09:04:22,389 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is set to 'Twofish/CFB/NoPadding'. Using this encryption algorithm. 09:04:22,396 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is set to 'HMACSHA1'. Using this MAC algorithm. 09:04:22,401 WARN [main][KeyStore] verifyMAC: MAC verification failed! macAlgorithm=HMACSHA1 expectedMAC=f894f2f590785773e75f68788cdb2662291253f9 calculatedMAC=425e99e901f8e69e489df1f17aecb0b6f0fb8b76 09:04:22,402 WARN [main][KeyStore] getMasterKey: Wrong password for user "marco"! MAC verification failed. 09:04:22,402 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is not set. Using default key size (256 bit). 09:04:22,402 INFO [main][KeyStore] createUser: Created master-key with a size of 256 bits. This key will not be modified for this key-store anymore. 09:04:22,402 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is set to 'Twofish/CFB/NoPadding'. Using this encryption algorithm. 09:04:22,408 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is set to 'HMACSHA1'. Using this MAC algorithm. 09:04:22,414 DEBUG [main][CachedMasterKey] clear: Clearing for userName='marco'. 09:04:22,414 DEBUG [main][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@548e7350 09:04:22,420 DEBUG [main][CachedMasterKey] clear: Clearing for userName='marco'. 09:04:22,420 DEBUG [main][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@1a968a59 09:04:22,426 DEBUG [main][CachedMasterKey] clear: Clearing for userName='marco'. 09:04:22,427 DEBUG [main][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@4667ae56 09:04:22,433 DEBUG [main][CachedMasterKey] clear: Clearing for userName='marco'. 09:04:22,433 DEBUG [main][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@77cd7a0 09:04:22,439 DEBUG [main][CachedMasterKey] clear: Clearing for userName='marco'. 09:04:22,439 DEBUG [main][MasterKey] clear: Clearing org.cumulus4j.keystore.MasterKey@204f30ec 09:04:22,446 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is not set. Using default key size (256 bit). 09:04:22,446 INFO [main][KeyStore] createUser: Created master-key with a size of 256 bits. This key will not be modified for this key-store anymore. 09:04:22,446 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is set to 'Twofish/CFB/NoPadding'. Using this encryption algorithm. 09:04:22,452 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is set to 'HMACSHA1'. Using this MAC algorithm. 09:04:22,458 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is set to 'HMACSHA1'. Using this MAC algorithm. 09:04:22,458 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is set to 'Twofish/CFB/NoPadding'. Using this encryption algorithm. 09:04:22,459 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is not set. Using default key size (256 bit). 09:04:22,466 INFO [main][KeyStore] getKeySize: System property 'cumulus4j.KeyStore.keySize' is not set. Using default key size (256 bit). 09:04:22,466 INFO [main][KeyStore] createUser: Created master-key with a size of 256 bits. This key will not be modified for this key-store anymore. 09:04:22,466 INFO [main][KeyStore] getEncryptionAlgorithm: System property 'cumulus4j.KeyStore.encryptionAlgorithm' is set to 'Twofish/CFB/NoPadding'. Using this encryption algorithm. 09:04:22,472 INFO [main][KeyStore] getMACAlgorithm: System property 'cumulus4j.KeyStore.macAlgorithm' is set to 'HMACSHA1'. Using this MAC algorithm. 09:04:22,608 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:04:22,862 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:04:23,229 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:04:23,476 DEBUG [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: 1 users left in cache. 09:04:23,612 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:04:23,922 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:04:24,284 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:04:24,298 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:04:24,348 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:04:24,360 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:04:24,372 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:04:24,469 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:04:24,479 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:04:24,491 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:04:24,505 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:04:24,536 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:04:24,554 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:04:24,566 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:04:24,611 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:04:24,632 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:04:24,696 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:04:24,708 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:04:24,720 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:04:24,733 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:04:24,787 DEBUG [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: 1 users left in cache. 09:04:35,590 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:04:38,238 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:04:38,240 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:04:38,256 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:04:38,311 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:04:38,319 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:04:38,325 INFO [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: KeyStore has been garbage-collected. Removing this ExipreCacheEntryTimerTask. 09:04:38,336 DEBUG [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: 1 users left in cache. 09:04:39,994 DEBUG [KeyStore][KeyStore$ExipreCacheEntryTimerTask] run: 1 users left in cache. 09:04:51,154 INFO [main][KeyStoreKeyTest] generateAndReadManyKeysIndividually: firstKeyID=1 lastKeyID=5000 09:04:51,416 INFO [main][KeyStoreKeyTest] generateAndReadManyKeysIndividually (5000 keys): 00.generateManyKeysIndividually invocationCount=1 recursionLevel=0 invocationCount=1 accumulatedTime=28681 minTime=28681 maxTime=28681 05.generateOneKey invocationCount=5000 recursionLevel=0 invocationCount=5000 accumulatedTime=28562 minTime=0 maxTime=23 07.readKeyStore invocationCount=1 recursionLevel=0 invocationCount=1 accumulatedTime=11 minTime=11 maxTime=11 10.readManyKeys invocationCount=1 recursionLevel=0 invocationCount=1 accumulatedTime=251 minTime=251 maxTime=251 Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 37.734 sec Results : Tests run: 42, Failures: 0, Errors: 0, Skipped: 0 [JENKINS] Recording test results [INFO] [INFO] --- maven-bundle-plugin:2.3.4:bundle (default-bundle) @ org.cumulus4j.keystore --- [INFO] [INFO] --- maven-source-plugin:2.1.2:jar-no-fork (attach-sources) @ org.cumulus4j.keystore --- [INFO] org already added, skipping [INFO] org/cumulus4j already added, skipping [INFO] org/cumulus4j/keystore already added, skipping [INFO] org/cumulus4j/keystore/prop already added, skipping [INFO] LICENCE.txt already added, skipping [INFO] Building jar: /home/tomcat/.jenkins/workspace/org.cumulus4j/org.cumulus4j/org.cumulus4j.keystore/target/org.cumulus4j.keystore-1.2.1-SNAPSHOT-sources.jar [INFO] org already added, skipping [INFO] org/cumulus4j already added, skipping [INFO] org/cumulus4j/keystore already added, skipping [INFO] org/cumulus4j/keystore/prop already added, skipping [INFO] LICENCE.txt already added, skipping [INFO] [INFO] --- maven-install-plugin:2.4:install (default-install) @ org.cumulus4j.keystore --- [INFO] Installing /home/tomcat/.jenkins/workspace/org.cumulus4j/org.cumulus4j/org.cumulus4j.keystore/target/org.cumulus4j.keystore-1.2.1-SNAPSHOT.jar to /home/tomcat/.m2/repository/org/cumulus4j/org.cumulus4j.keystore/1.2.1-SNAPSHOT/org.cumulus4j.keystore-1.2.1-SNAPSHOT.jar [INFO] Installing /home/tomcat/.jenkins/workspace/org.cumulus4j/org.cumulus4j/org.cumulus4j.keystore/pom.xml to /home/tomcat/.m2/repository/org/cumulus4j/org.cumulus4j.keystore/1.2.1-SNAPSHOT/org.cumulus4j.keystore-1.2.1-SNAPSHOT.pom [INFO] Installing /home/tomcat/.jenkins/workspace/org.cumulus4j/org.cumulus4j/org.cumulus4j.keystore/target/org.cumulus4j.keystore-1.2.1-SNAPSHOT-sources.jar to /home/tomcat/.m2/repository/org/cumulus4j/org.cumulus4j.keystore/1.2.1-SNAPSHOT/org.cumulus4j.keystore-1.2.1-SNAPSHOT-sources.jar [INFO] [INFO] --- maven-bundle-plugin:2.3.4:install (default-install) @ org.cumulus4j.keystore --- [WARNING] Ignoring project type bundle - supportedProjectTypes = []