[
https://issues.apache.org/jira/browse/HADOOP-14949?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=16204434#comment-16204434
]
Xiao Chen commented on HADOOP-14949:
------------------------------------
With the fix in patch 1, it passes 100 separate runs.
http://dist-test.cloudera.org/job?job_id=hadoop.xiao.1507937904.2138
Previously the failure rate in our internal infra was ~30%.
> TestKMS#testACLs fails intermitently
> ------------------------------------
>
> Key: HADOOP-14949
> URL: https://issues.apache.org/jira/browse/HADOOP-14949
> Project: Hadoop Common
> Issue Type: Bug
> Components: kms, test
> Reporter: Xiao Chen
> Assignee: Xiao Chen
> Attachments: HADOOP-14949.01.patch
>
>
> We have seen some intermittent failures of this test:
> Error Message
> {noformat}
> java.lang.AssertionError
> {noformat}
> Stack Trace
> {noformat}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)
> {noformat}
> Standard Output
> {noformat}
> 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 cli...@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 cli...@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 cli...@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 cli...@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 cli...@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 cli...@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 cli...@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 cli...@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 cli...@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 cli...@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 rollo...@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 rollo...@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_mater...@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_mater...@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 cre...@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
> {noformat}
--
This message was sent by Atlassian JIRA
(v6.4.14#64029)
---------------------------------------------------------------------
To unsubscribe, e-mail: common-issues-unsubscr...@hadoop.apache.org
For additional commands, e-mail: common-issues-h...@hadoop.apache.org
