Uploaded image for project: 'Hadoop Common'
  1. Hadoop Common
  2. HADOOP-14949

TestKMS#testACLs fails intermittently

    XMLWordPrintableJSON

Details

    • Bug
    • Status: Resolved
    • Major
    • Resolution: Fixed
    • None
    • 2.9.0, 3.0.0
    • kms, test
    • None
    • Reviewed

    Description

      We have seen some intermittent failures of this test:

      Error Message

      java.lang.AssertionError
      

      Stack Trace

      java.lang.AssertionError: Should not have been able to reencryptEncryptedKey
      	at org.junit.Assert.fail(Assert.java:88)
      	at org.apache.hadoop.crypto.key.kms.server.TestKMS$11$15.run(TestKMS.java:1616)
      	at org.apache.hadoop.crypto.key.kms.server.TestKMS$11$15.run(TestKMS.java:1608)
      	at java.security.AccessController.doPrivileged(Native Method)
      	at javax.security.auth.Subject.doAs(Subject.java:415)
      	at org.apache.hadoop.security.UserGroupInformation.doAs(UserGroupInformation.java:1917)
      	at org.apache.hadoop.crypto.key.kms.server.TestKMS.doAs(TestKMS.java:313)
      	at org.apache.hadoop.crypto.key.kms.server.TestKMS.access$100(TestKMS.java:97)
      

      Standard Output

      2017-10-07 09:44:11,112 INFO  log - jetty-6.1.26.cloudera.4
      2017-10-07 09:44:11,131 INFO  KMSWebApp - -------------------------------------------------------------
      2017-10-07 09:44:11,131 INFO  KMSWebApp -   Java runtime version : 1.7.0_121-b00
      2017-10-07 09:44:11,131 INFO  KMSWebApp -   User: slave
      2017-10-07 09:44:11,131 INFO  KMSWebApp -   KMS Hadoop Version: 2.6.0-cdh5.14.0-SNAPSHOT
      2017-10-07 09:44:11,131 INFO  KMSWebApp - -------------------------------------------------------------
      2017-10-07 09:44:11,134 INFO  KMSACLs - 'CREATE' ACL 'CREATE,SET_KEY_MATERIAL'
      2017-10-07 09:44:11,134 INFO  KMSACLs - 'DELETE' ACL 'DELETE'
      2017-10-07 09:44:11,134 INFO  KMSACLs - 'ROLLOVER' ACL 'ROLLOVER,SET_KEY_MATERIAL'
      2017-10-07 09:44:11,134 INFO  KMSACLs - 'GET' ACL 'GET'
      2017-10-07 09:44:11,135 INFO  KMSACLs - 'GET_KEYS' ACL 'GET_KEYS'
      2017-10-07 09:44:11,135 INFO  KMSACLs - 'GET_METADATA' ACL 'GET_METADATA'
      2017-10-07 09:44:11,135 INFO  KMSACLs - 'SET_KEY_MATERIAL' ACL 'SET_KEY_MATERIAL'
      2017-10-07 09:44:11,135 INFO  KMSACLs - 'GENERATE_EEK' ACL 'GENERATE_EEK'
      2017-10-07 09:44:11,135 INFO  KMSACLs - 'DECRYPT_EEK' ACL 'DECRYPT_EEK'
      2017-10-07 09:44:11,135 INFO  KMSACLs - KEY_NAME 'k0' KEY_OP 'ALL' ACL '*'
      2017-10-07 09:44:11,135 INFO  KMSACLs - KEY_NAME 'k1' KEY_OP 'ALL' ACL '*'
      2017-10-07 09:44:11,136 INFO  KMSAudit - No audit logger configured, using default.
      2017-10-07 09:44:11,137 INFO  KMSAudit - Initializing audit logger class org.apache.hadoop.crypto.key.kms.server.SimpleKMSAuditLogger
      2017-10-07 09:44:11,137 INFO  KMSWebApp - Initialized KeyProvider CachingKeyProvider: jceks://file@/tmp/run_tha_testUYG3Cl/hadoop-common-project/hadoop-kms/target/ddbffdf2-e7d8-4e75-982a-debebb227075/kms.keystore
      2017-10-07 09:44:11,138 INFO  KMSWebApp - Initialized KeyProviderCryptoExtension EagerKeyGeneratorKeyProviderCryptoExtension: KeyProviderCryptoExtension: CachingKeyProvider: jceks://file@/tmp/run_tha_testUYG3Cl/hadoop-common-project/hadoop-kms/target/ddbffdf2-e7d8-4e75-982a-debebb227075/kms.keystore
      2017-10-07 09:44:11,138 INFO  KMSWebApp - Default key bitlength is 128
      2017-10-07 09:44:11,138 INFO  KMSWebApp - KMS Started
      2017-10-07 09:44:11,141 INFO  PackagesResourceConfig - Scanning for root resource and provider classes in the packages:
        org.apache.hadoop.crypto.key.kms.server
      2017-10-07 09:44:11,146 INFO  ScanningResourceConfig - Root resource classes found:
        class org.apache.hadoop.crypto.key.kms.server.KMS
      2017-10-07 09:44:11,146 INFO  ScanningResourceConfig - Provider classes found:
        class org.apache.hadoop.crypto.key.kms.server.KMSJSONWriter
        class org.apache.hadoop.crypto.key.kms.server.KMSExceptionsProvider
        class org.apache.hadoop.crypto.key.kms.server.KMSJSONReader
      2017-10-07 09:44:11,147 INFO  WebApplicationImpl - Initiating Jersey application, version 'Jersey: 1.9 09/02/2011 11:17 AM'
      2017-10-07 09:44:11,224 INFO  log - Started SocketConnector@localhost:46764
      Test KMS running at: http://localhost:46764/kms
      2017-10-07 09:44:11,254 INFO  kms-audit - UNAUTHORIZED[op=CREATE_KEY, key=k, user=client] 
      2017-10-07 09:44:11,255 WARN  KMS - User client@EXAMPLE.COM (auth:KERBEROS) request POST http://localhost:46764/kms/v1/keys caused exception.
      2017-10-07 09:44:11,256 WARN  LoadBalancingKMSClientProvider - KMS provider at [http://localhost:46764/kms/v1/] threw an IOException [User:client not allowed to do 'CREATE_KEY' on 'k']!!
      2017-10-07 09:44:11,256 WARN  LoadBalancingKMSClientProvider - Aborting since the Request has failed with all KMS providers in the group. !!
      2017-10-07 09:44:11,270 INFO  kms-audit - UNAUTHORIZED[op=CREATE_KEY, key=k, user=client] 
      2017-10-07 09:44:11,270 WARN  KMS - User client@EXAMPLE.COM (auth:KERBEROS) request POST http://localhost:46764/kms/v1/keys caused exception.
      2017-10-07 09:44:11,271 WARN  LoadBalancingKMSClientProvider - KMS provider at [http://localhost:46764/kms/v1/] threw an IOException [User:client not allowed to do 'CREATE_KEY' on 'k']!!
      2017-10-07 09:44:11,271 WARN  LoadBalancingKMSClientProvider - Aborting since the Request has failed with all KMS providers in the group. !!
      2017-10-07 09:44:11,284 INFO  kms-audit - UNAUTHORIZED[op=ROLL_NEW_VERSION, key=k, user=client] 
      2017-10-07 09:44:11,284 WARN  KMS - User client@EXAMPLE.COM (auth:KERBEROS) request POST http://localhost:46764/kms/v1/key/k caused exception.
      2017-10-07 09:44:11,285 WARN  LoadBalancingKMSClientProvider - KMS provider at [http://localhost:46764/kms/v1/] threw an IOException [User:client not allowed to do 'ROLL_NEW_VERSION' on 'k']!!
      2017-10-07 09:44:11,285 WARN  LoadBalancingKMSClientProvider - Aborting since the Request has failed with all KMS providers in the group. !!
      2017-10-07 09:44:11,300 INFO  kms-audit - UNAUTHORIZED[op=ROLL_NEW_VERSION, key=k, user=client] 
      2017-10-07 09:44:11,300 WARN  KMS - User client@EXAMPLE.COM (auth:KERBEROS) request POST http://localhost:46764/kms/v1/key/k caused exception.
      2017-10-07 09:44:11,301 WARN  LoadBalancingKMSClientProvider - KMS provider at [http://localhost:46764/kms/v1/] threw an IOException [User:client not allowed to do 'ROLL_NEW_VERSION' on 'k']!!
      2017-10-07 09:44:11,301 WARN  LoadBalancingKMSClientProvider - Aborting since the Request has failed with all KMS providers in the group. !!
      2017-10-07 09:44:11,315 INFO  kms-audit - UNAUTHORIZED[op=GET_KEYS, user=client] 
      2017-10-07 09:44:11,315 WARN  KMS - User client@EXAMPLE.COM (auth:KERBEROS) request GET http://localhost:46764/kms/v1/keys/names caused exception.
      2017-10-07 09:44:11,316 WARN  LoadBalancingKMSClientProvider - KMS provider at [http://localhost:46764/kms/v1/] threw an IOException [User:client not allowed to do 'GET_KEYS']!!
      2017-10-07 09:44:11,316 WARN  LoadBalancingKMSClientProvider - Aborting since the Request has failed with all KMS providers in the group. !!
      2017-10-07 09:44:11,330 INFO  kms-audit - UNAUTHORIZED[op=GET_KEYS_METADATA, user=client] 
      2017-10-07 09:44:11,330 WARN  KMS - User client@EXAMPLE.COM (auth:KERBEROS) request GET http://localhost:46764/kms/v1/keys/metadata?key=k caused exception.
      2017-10-07 09:44:11,331 WARN  LoadBalancingKMSClientProvider - KMS provider at [http://localhost:46764/kms/v1/] threw an IOException [User:client not allowed to do 'GET_KEYS_METADATA']!!
      2017-10-07 09:44:11,331 WARN  LoadBalancingKMSClientProvider - Aborting since the Request has failed with all KMS providers in the group. !!
      2017-10-07 09:44:11,344 INFO  kms-audit - UNAUTHORIZED[op=GET_KEY_VERSION, user=client] 
      2017-10-07 09:44:11,344 WARN  KMS - User client@EXAMPLE.COM (auth:KERBEROS) request GET http://localhost:46764/kms/v1/keyversion/k%400 caused exception.
      2017-10-07 09:44:11,345 WARN  LoadBalancingKMSClientProvider - KMS provider at [http://localhost:46764/kms/v1/] threw an IOException [User:client not allowed to do 'GET_KEY_VERSION']!!
      2017-10-07 09:44:11,345 WARN  LoadBalancingKMSClientProvider - Aborting since the Request has failed with all KMS providers in the group. !!
      2017-10-07 09:44:11,358 INFO  kms-audit - UNAUTHORIZED[op=GET_CURRENT_KEY, key=k, user=client] 
      2017-10-07 09:44:11,358 WARN  KMS - User client@EXAMPLE.COM (auth:KERBEROS) request GET http://localhost:46764/kms/v1/key/k/_currentversion caused exception.
      2017-10-07 09:44:11,359 WARN  LoadBalancingKMSClientProvider - KMS provider at [http://localhost:46764/kms/v1/] threw an IOException [User:client not allowed to do 'GET_CURRENT_KEY' on 'k']!!
      2017-10-07 09:44:11,359 WARN  LoadBalancingKMSClientProvider - Aborting since the Request has failed with all KMS providers in the group. !!
      2017-10-07 09:44:11,372 INFO  kms-audit - UNAUTHORIZED[op=GET_METADATA, key=k, user=client] 
      2017-10-07 09:44:11,372 WARN  KMS - User client@EXAMPLE.COM (auth:KERBEROS) request GET http://localhost:46764/kms/v1/key/k/_metadata caused exception.
      2017-10-07 09:44:11,373 WARN  LoadBalancingKMSClientProvider - KMS provider at [http://localhost:46764/kms/v1/] threw an IOException [User:client not allowed to do 'GET_METADATA' on 'k']!!
      2017-10-07 09:44:11,373 WARN  LoadBalancingKMSClientProvider - Aborting since the Request has failed with all KMS providers in the group. !!
      2017-10-07 09:44:11,386 INFO  kms-audit - UNAUTHORIZED[op=GET_KEY_VERSIONS, key=k, user=client] 
      2017-10-07 09:44:11,386 WARN  KMS - User client@EXAMPLE.COM (auth:KERBEROS) request GET http://localhost:46764/kms/v1/key/k/_versions caused exception.
      2017-10-07 09:44:11,387 WARN  LoadBalancingKMSClientProvider - KMS provider at [http://localhost:46764/kms/v1/] threw an IOException [User:client not allowed to do 'GET_KEY_VERSIONS' on 'k']!!
      2017-10-07 09:44:11,387 WARN  LoadBalancingKMSClientProvider - Aborting since the Request has failed with all KMS providers in the group. !!
      2017-10-07 09:44:11,407 INFO  kms-audit - UNAUTHORIZED[op=MANAGEMENT, key=k0, user=CREATE] 
      2017-10-07 09:44:11,409 INFO  kms-audit - OK[op=CREATE_KEY, key=k0, user=CREATE] UserProvidedMaterial:false Description:null
      2017-10-07 09:44:11,435 INFO  kms-audit - UNAUTHORIZED[op=MANAGEMENT, key=k0, user=DELETE] 
      2017-10-07 09:44:11,437 INFO  kms-audit - OK[op=DELETE_KEY, key=k0, user=DELETE] 
      2017-10-07 09:44:11,457 INFO  kms-audit - UNAUTHORIZED[op=MANAGEMENT, key=k1, user=SET_KEY_MATERIAL] 
      2017-10-07 09:44:11,459 INFO  kms-audit - OK[op=CREATE_KEY, key=k1, user=SET_KEY_MATERIAL] UserProvidedMaterial:true Description:null
      2017-10-07 09:44:11,482 INFO  kms-audit - UNAUTHORIZED[op=MANAGEMENT, key=k1, user=ROLLOVER] 
      2017-10-07 09:44:11,487 INFO  kms-audit - OK[op=ROLL_NEW_VERSION, key=k1, user=ROLLOVER] UserProvidedMaterial:false NewVersion:k1@1
      2017-10-07 09:44:11,489 INFO  kms-audit - UNAUTHORIZED[op=MANAGEMENT, key=k1, user=ROLLOVER] 
      2017-10-07 09:44:11,489 INFO  kms-audit - OK[op=INVALIDATE_CACHE, key=k1, user=ROLLOVER] 
      2017-10-07 09:44:11,491 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=ROLLOVER] 
      2017-10-07 09:44:11,491 WARN  KMS - User ROLLOVER@EXAMPLE.COM (auth:KERBEROS) request GET http://localhost:46764/kms/v1/key/k1/_eek?num_keys=150&eek_op=generate caused exception.
      2017-10-07 09:44:11,506 INFO  kms-audit - UNAUTHORIZED[op=MANAGEMENT, key=k1, user=ROLLOVER] 
      2017-10-07 09:44:11,506 INFO  kms-audit - OK[op=INVALIDATE_CACHE, key=k1, user=ROLLOVER] 
      2017-10-07 09:44:11,507 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=ROLLOVER] 
      2017-10-07 09:44:11,507 WARN  KMS - User ROLLOVER@EXAMPLE.COM (auth:KERBEROS) request GET http://localhost:46764/kms/v1/key/k1/_eek?num_keys=150&eek_op=generate caused exception.
      2017-10-07 09:44:11,530 INFO  kms-audit - UNAUTHORIZED[op=MANAGEMENT, key=k1, user=SET_KEY_MATERIAL] 
      2017-10-07 09:44:11,532 INFO  kms-audit - OK[op=ROLL_NEW_VERSION, key=k1, user=SET_KEY_MATERIAL] UserProvidedMaterial:true NewVersion:k1@2
      2017-10-07 09:44:11,534 INFO  kms-audit - UNAUTHORIZED[op=MANAGEMENT, key=k1, user=SET_KEY_MATERIAL] 
      2017-10-07 09:44:11,534 INFO  kms-audit - OK[op=INVALIDATE_CACHE, key=k1, user=SET_KEY_MATERIAL] 
      2017-10-07 09:44:11,535 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=SET_KEY_MATERIAL] 
      2017-10-07 09:44:11,535 WARN  KMS - User SET_KEY_MATERIAL@EXAMPLE.COM (auth:KERBEROS) request GET http://localhost:46764/kms/v1/key/k1/_eek?num_keys=150&eek_op=generate caused exception.
      2017-10-07 09:44:11,550 INFO  kms-audit - UNAUTHORIZED[op=MANAGEMENT, key=k1, user=SET_KEY_MATERIAL] 
      2017-10-07 09:44:11,550 INFO  kms-audit - OK[op=INVALIDATE_CACHE, key=k1, user=SET_KEY_MATERIAL] 
      2017-10-07 09:44:11,551 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=SET_KEY_MATERIAL] 
      2017-10-07 09:44:11,551 WARN  KMS - User SET_KEY_MATERIAL@EXAMPLE.COM (auth:KERBEROS) request GET http://localhost:46764/kms/v1/key/k1/_eek?num_keys=150&eek_op=generate caused exception.
      2017-10-07 09:44:11,571 INFO  kms-audit - UNAUTHORIZED[op=READ, key=k1, user=GET] 
      2017-10-07 09:44:11,571 INFO  kms-audit - OK[op=GET_KEY_VERSION, key=k1, user=GET, accessCount=1, interval=0ms] 
      2017-10-07 09:44:11,574 INFO  kms-audit - UNAUTHORIZED[op=READ, key=k1, user=GET] 
      2017-10-07 09:44:11,575 INFO  kms-audit - OK[op=GET_CURRENT_KEY, key=k1, user=GET, accessCount=1, interval=0ms] 
      2017-10-07 09:44:11,598 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,599 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,604 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,604 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,604 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,604 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,604 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,604 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,604 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,604 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,604 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,604 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,604 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,604 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,604 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,604 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,604 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,604 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,604 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,605 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,605 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,605 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,605 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,605 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,605 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,605 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,605 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,605 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,605 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,605 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,605 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,605 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,605 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,605 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,605 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,605 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,605 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,605 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,605 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,605 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,605 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,605 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,605 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,605 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,605 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,605 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,605 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,606 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,606 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,606 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,606 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,606 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,606 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,606 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,606 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,606 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,606 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,606 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,606 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,606 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,606 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,606 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,606 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,606 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,606 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,606 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,606 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,606 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,607 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,607 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,607 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,607 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,607 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,607 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,607 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,607 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,607 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,607 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,607 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,607 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,607 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,607 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,607 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,607 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,607 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,607 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,607 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,607 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,608 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,608 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,608 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,608 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,608 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,608 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,608 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,608 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,608 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,608 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,608 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,608 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,608 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,608 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,608 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,613 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,613 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,614 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,614 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,614 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,614 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,614 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,614 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,614 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,614 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,614 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,614 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,614 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,614 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,614 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,614 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,614 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,614 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,614 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,614 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,614 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,614 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,614 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,614 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,615 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,615 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,615 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,615 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,615 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,615 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,615 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,615 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,615 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,615 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,615 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,615 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,615 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,615 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,615 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,615 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,615 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,615 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,615 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,615 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,615 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,616 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,616 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,616 INFO  kms-audit - OK[op=GENERATE_EEK, key=k1, user=GENERATE_EEK, accessCount=1, interval=0ms] 
      2017-10-07 09:44:11,645 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,645 INFO  kms-audit - OK[op=REENCRYPT_EEK, key=k1, user=GENERATE_EEK, accessCount=1, interval=0ms] 
      2017-10-07 09:44:11,648 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:11,648 INFO  kms-audit - OK[op=REENCRYPT_EEK_BATCH, key=k1, user=GENERATE_EEK] reencrypted 2 keys
      2017-10-07 09:44:11,648 INFO  KMS - reencryptEncryptedKeys 2 keys for key k1 took 347.5 ?s
      2017-10-07 09:44:11,674 INFO  kms-audit - UNAUTHORIZED[op=DECRYPT_EEK, key=k1, user=DECRYPT_EEK] 
      2017-10-07 09:44:11,674 INFO  kms-audit - OK[op=DECRYPT_EEK, key=k1, user=DECRYPT_EEK, accessCount=1, interval=0ms] 
      2017-10-07 09:44:11,698 INFO  kms-audit - OK[op=GET_KEYS, user=GET_KEYS] 
      2017-10-07 09:44:11,721 INFO  kms-audit - UNAUTHORIZED[op=READ, key=k1, user=GET_METADATA] 
      2017-10-07 09:44:11,722 INFO  kms-audit - OK[op=GET_METADATA, key=k1, user=GET_METADATA] 
      2017-10-07 09:44:11,725 INFO  kms-audit - UNAUTHORIZED[op=READ, key=k1, user=GET_METADATA] 
      2017-10-07 09:44:11,725 INFO  kms-audit - OK[op=GET_KEYS_METADATA, user=GET_METADATA] 
      2017-10-07 09:44:12,000 INFO  SessionTrackerImpl - SessionTrackerImpl exited loop!
      2017-10-07 09:44:12,771 WARN  KMS - User CREATE@EXAMPLE.COM (auth:KERBEROS) request POST http://localhost:46764/kms/v1/keys caused exception.
      2017-10-07 09:44:12,772 WARN  LoadBalancingKMSClientProvider - KMS provider at [http://localhost:46764/kms/v1/] threw an IOException [User [CREATE] is not authorized to create key !!]!!
      2017-10-07 09:44:12,772 WARN  LoadBalancingKMSClientProvider - Aborting since the Request has failed with all KMS providers in the group. !!
      2017-10-07 09:44:12,795 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,795 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,795 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,795 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,795 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,795 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,795 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,795 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,795 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,795 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,795 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,795 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,795 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,795 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,795 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,795 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,795 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,795 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,795 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,795 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,795 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,795 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,795 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,795 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,795 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,795 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,795 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,795 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,796 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,796 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,796 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,796 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,796 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,796 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,796 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,796 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,796 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,796 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,796 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,796 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,796 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,796 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,796 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,796 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,796 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,796 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,796 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,796 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,796 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,796 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,796 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,796 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,796 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,797 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,802 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,802 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,802 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,802 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,802 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,802 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,802 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,802 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,802 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,802 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,802 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,802 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,802 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,802 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,802 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,803 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,803 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,803 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,803 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,803 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,803 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,803 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,803 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,803 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,803 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,803 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,803 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,803 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,803 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,803 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,803 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,803 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,803 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,803 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,803 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,803 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,803 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,804 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,804 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,804 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,804 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,804 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,804 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,804 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,804 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,804 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,804 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,804 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,804 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,804 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,804 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,804 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,804 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,804 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,804 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,804 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,804 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,804 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,804 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,805 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,805 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,805 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,805 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,805 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,805 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,805 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,805 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,805 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,805 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,805 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,805 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,805 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,805 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,805 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,805 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,805 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,805 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,805 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,805 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,805 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,805 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,805 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,806 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,806 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,806 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,806 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,806 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,806 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,806 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,806 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,806 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,806 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,806 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,806 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,806 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,806 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,837 INFO  kms-audit - UNAUTHORIZED[op=GENERATE_EEK, key=k1, user=GENERATE_EEK] 
      2017-10-07 09:44:12,838 INFO  log - Stopped SocketConnector@localhost:46764
      2017-10-07 09:44:12,840 INFO  KMSWebApp - KMS Stopped
      
      

      Attachments

        1. HADOOP-14949.03.patch
          4 kB
          Xiao Chen
        2. HADOOP-14949.02.patch
          4 kB
          Xiao Chen
        3. HADOOP-14949.01.patch
          3 kB
          Xiao Chen

        Activity

          People

            xiaochen Xiao Chen
            xiaochen Xiao Chen
            Votes:
            0 Vote for this issue
            Watchers:
            3 Start watching this issue

            Dates

              Created:
              Updated:
              Resolved: