You are viewing a plain text version of this content. The canonical link for it is here.
Posted to common-issues@hadoop.apache.org by "Steve Loughran (JIRA)" <ji...@apache.org> on 2015/12/20 15:53:47 UTC
[jira] [Commented] (HADOOP-12660)
TestZKDelegationTokenSecretManager.testMultiNodeOperations failing
[ https://issues.apache.org/jira/browse/HADOOP-12660?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=15065790#comment-15065790 ]
Steve Loughran commented on HADOOP-12660:
-----------------------------------------
full stack
{code}
2015-12-19 01:44:08,343 INFO server.ZooKeeperServerMain (ZooKeeperServerMain.java:runFromConfig(95)) - Starting server
2015-12-19 01:44:08,371 INFO server.ZooKeeperServer (Environment.java:logEnv(100)) - Server environment:zookeeper.version=3.4.6-1569965, built on 02/20/2014 09:09 GMT
2015-12-19 01:44:08,378 INFO server.ZooKeeperServer (Environment.java:logEnv(100)) - Server environment:host.name=asf904.gq1.ygridcore.net
2015-12-19 01:44:08,385 INFO server.ZooKeeperServer (Environment.java:logEnv(100)) - Server environment:java.version=1.8.0
2015-12-19 01:44:08,386 INFO server.ZooKeeperServer (Environment.java:logEnv(100)) - Server environment:java.vendor=Oracle Corporation
2015-12-19 01:44:08,386 INFO server.ZooKeeperServer (Environment.java:logEnv(100)) - Server environment:java.home=/home/jenkins/tools/java/jdk1.8.0/jre
2015-12-19 01:44:08,387 INFO server.ZooKeeperServer (Environment.java:logEnv(100)) - Server environment:java.class.path=/home/jenkins/jenkins-slave/workspace/Hadoop-common-trunk-Java8/hadoop-common-project/hadoop-common/target/test-classes:/home/jenkins/jenkins-slave/workspace/Hadoop-common-trunk-Java8/hadoop-common-project/hadoop-common/target/classes:/home/jenkins/jenkins-slave/workspace/Hadoop-common-trunk-Java8/hadoop-common-project/hadoop-annotations/target/hadoop-annotations-3.0.0-SNAPSHOT.jar:/home/jenkins/tools/java/jdk1.8.0/jre/../lib/tools.jar:/home/jenkins/.m2/repository/com/google/guava/guava/11.0.2/guava-11.0.2.jar:/home/jenkins/.m2/repository/commons-cli/commons-cli/1.2/commons-cli-1.2.jar:/home/jenkins/.m2/repository/org/apache/commons/commons-math3/3.1.1/commons-math3-3.1.1.jar:/home/jenkins/.m2/repository/xmlenc/xmlenc/0.52/xmlenc-0.52.jar:/home/jenkins/.m2/repository/commons-httpclient/commons-httpclient/3.1/commons-httpclient-3.1.jar:/home/jenkins/.m2/repository/commons-codec/commons-codec/1.4/commons-codec-1.4.jar:/home/jenkins/.m2/repository/commons-io/commons-io/2.4/commons-io-2.4.jar:/home/jenkins/.m2/repository/commons-net/commons-net/3.1/commons-net-3.1.jar:/home/jenkins/.m2/repository/commons-collections/commons-collections/3.2.2/commons-collections-3.2.2.jar:/home/jenkins/.m2/repository/javax/servlet/servlet-api/2.5/servlet-api-2.5.jar:/home/jenkins/.m2/repository/org/mortbay/jetty/jetty/6.1.26/jetty-6.1.26.jar:/home/jenkins/.m2/repository/org/mortbay/jetty/jetty-util/6.1.26/jetty-util-6.1.26.jar:/home/jenkins/.m2/repository/javax/servlet/jsp/jsp-api/2.1/jsp-api-2.1.jar:/home/jenkins/.m2/repository/com/sun/jersey/jersey-core/1.9/jersey-core-1.9.jar:/home/jenkins/.m2/repository/com/sun/jersey/jersey-json/1.9/jersey-json-1.9.jar:/home/jenkins/.m2/repository/org/codehaus/jettison/jettison/1.1/jettison-1.1.jar:/home/jenkins/.m2/repository/com/sun/xml/bind/jaxb-impl/2.2.3-1/jaxb-impl-2.2.3-1.jar:/home/jenkins/.m2/repository/javax/xml/bind/jaxb-api/2.2.2/jaxb-api-2.2.2.jar:/home/jenkins/.m2/repository/javax/xml/stream/stax-api/1.0-2/stax-api-1.0-2.jar:/home/jenkins/.m2/repository/javax/activation/activation/1.1/activation-1.1.jar:/home/jenkins/.m2/repository/org/codehaus/jackson/jackson-jaxrs/1.9.13/jackson-jaxrs-1.9.13.jar:/home/jenkins/.m2/repository/org/codehaus/jackson/jackson-xc/1.9.13/jackson-xc-1.9.13.jar:/home/jenkins/.m2/repository/com/sun/jersey/jersey-server/1.9/jersey-server-1.9.jar:/home/jenkins/.m2/repository/asm/asm/3.2/asm-3.2.jar:/home/jenkins/.m2/repository/commons-logging/commons-logging/1.1.3/commons-logging-1.1.3.jar:/home/jenkins/.m2/repository/log4j/log4j/1.2.17/log4j-1.2.17.jar:/home/jenkins/.m2/repository/net/java/dev/jets3t/jets3t/0.9.0/jets3t-0.9.0.jar:/home/jenkins/.m2/repository/org/apache/httpcomponents/httpclient/4.2.5/httpclient-4.2.5.jar:/home/jenkins/.m2/repository/org/apache/httpcomponents/httpcore/4.2.5/httpcore-4.2.5.jar:/home/jenkins/.m2/repository/com/jamesmurty/utils/java-xmlbuilder/0.4/java-xmlbuilder-0.4.jar:/home/jenkins/.m2/repository/junit/junit/4.11/junit-4.11.jar:/home/jenkins/.m2/repository/org/hamcrest/hamcrest-core/1.3/hamcrest-core-1.3.jar:/home/jenkins/.m2/repository/commons-lang/commons-lang/2.6/commons-lang-2.6.jar:/home/jenkins/.m2/repository/commons-configuration/commons-configuration/1.6/commons-configuration-1.6.jar:/home/jenkins/.m2/repository/commons-digester/commons-digester/1.8/commons-digester-1.8.jar:/home/jenkins/.m2/repository/commons-beanutils/commons-beanutils/1.7.0/commons-beanutils-1.7.0.jar:/home/jenkins/.m2/repository/commons-beanutils/commons-beanutils-core/1.8.0/commons-beanutils-core-1.8.0.jar:/home/jenkins/.m2/repository/org/slf4j/slf4j-api/1.7.10/slf4j-api-1.7.10.jar:/home/jenkins/.m2/repository/org/slf4j/slf4j-log4j12/1.7.10/slf4j-log4j12-1.7.10.jar:/home/jenkins/.m2/repository/org/codehaus/jackson/jackson-core-asl/1.9.13/jackson-core-asl-1.9.13.jar:/home/jenkins/.m2/repository/org/codehaus/jackson/jackson-mapper-asl/1.9.13/jackson-mapper-asl-1.9.13.jar:/home/jenkins/.m2/repository/org/mockito/mockito-all/1.8.5/mockito-all-1.8.5.jar:/home/jenkins/.m2/repository/org/apache/avro/avro/1.7.4/avro-1.7.4.jar:/home/jenkins/.m2/repository/com/thoughtworks/paranamer/paranamer/2.3/paranamer-2.3.jar:/home/jenkins/.m2/repository/org/xerial/snappy/snappy-java/1.0.4.1/snappy-java-1.0.4.1.jar:/home/jenkins/.m2/repository/org/apache/ant/ant/1.8.1/ant-1.8.1.jar:/home/jenkins/.m2/repository/org/apache/ant/ant-launcher/1.8.1/ant-launcher-1.8.1.jar:/home/jenkins/.m2/repository/com/google/re2j/re2j/1.0/re2j-1.0.jar:/home/jenkins/.m2/repository/com/google/protobuf/protobuf-java/2.5.0/protobuf-java-2.5.0.jar:/home/jenkins/.m2/repository/com/google/code/gson/gson/2.2.4/gson-2.2.4.jar:/home/jenkins/jenkins-slave/workspace/Hadoop-common-trunk-Java8/hadoop-common-project/hadoop-auth/target/hadoop-auth-3.0.0-SNAPSHOT.jar:/home/jenkins/.m2/repository/com/nimbusds/nimbus-jose-jwt/3.9/nimbus-jose-jwt-3.9.jar:/home/jenkins/.m2/repository/net/jcip/jcip-annotations/1.0/jcip-annotations-1.0.jar:/home/jenkins/.m2/repository/net/minidev/json-smart/1.1.1/json-smart-1.1.1.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-kerberos-codec/2.0.0-M15/apacheds-kerberos-codec-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-i18n/2.0.0-M15/apacheds-i18n-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/api/api-asn1-api/1.0.0-M20/api-asn1-api-1.0.0-M20.jar:/home/jenkins/.m2/repository/org/apache/directory/api/api-util/1.0.0-M20/api-util-1.0.0-M20.jar:/home/jenkins/.m2/repository/org/apache/curator/curator-framework/2.7.1/curator-framework-2.7.1.jar:/home/jenkins/jenkins-slave/workspace/Hadoop-common-trunk-Java8/hadoop-common-project/hadoop-auth/target/hadoop-auth-3.0.0-SNAPSHOT-tests.jar:/home/jenkins/jenkins-slave/workspace/Hadoop-common-trunk-Java8/hadoop-common-project/hadoop-minikdc/target/hadoop-minikdc-3.0.0-SNAPSHOT.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-core-api/2.0.0-M15/apacheds-core-api-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-core-constants/2.0.0-M15/apacheds-core-constants-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/api/api-i18n/1.0.0-M20/api-i18n-1.0.0-M20.jar:/home/jenkins/.m2/repository/org/apache/directory/api/api-ldap-client-api/1.0.0-M20/api-ldap-client-api-1.0.0-M20.jar:/home/jenkins/.m2/repository/org/apache/directory/api/api-ldap-codec-core/1.0.0-M20/api-ldap-codec-core-1.0.0-M20.jar:/home/jenkins/.m2/repository/org/apache/directory/api/api-ldap-extras-aci/1.0.0-M20/api-ldap-extras-aci-1.0.0-M20.jar:/home/jenkins/.m2/repository/org/apache/directory/api/api-ldap-extras-util/1.0.0-M20/api-ldap-extras-util-1.0.0-M20.jar:/home/jenkins/.m2/repository/org/apache/directory/api/api-ldap-model/1.0.0-M20/api-ldap-model-1.0.0-M20.jar:/home/jenkins/.m2/repository/org/apache/mina/mina-core/2.0.0-M5/mina-core-2.0.0-M5.jar:/home/jenkins/.m2/repository/net/sf/ehcache/ehcache-core/2.4.4/ehcache-core-2.4.4.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-interceptor-kerberos/2.0.0-M15/apacheds-interceptor-kerberos-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-core/2.0.0-M15/apacheds-core-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-interceptors-admin/2.0.0-M15/apacheds-interceptors-admin-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-interceptors-authn/2.0.0-M15/apacheds-interceptors-authn-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-interceptors-authz/2.0.0-M15/apacheds-interceptors-authz-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-interceptors-changelog/2.0.0-M15/apacheds-interceptors-changelog-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-interceptors-collective/2.0.0-M15/apacheds-interceptors-collective-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-interceptors-event/2.0.0-M15/apacheds-interceptors-event-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-interceptors-exception/2.0.0-M15/apacheds-interceptors-exception-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-interceptors-journal/2.0.0-M15/apacheds-interceptors-journal-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-interceptors-normalization/2.0.0-M15/apacheds-interceptors-normalization-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-interceptors-operational/2.0.0-M15/apacheds-interceptors-operational-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-interceptors-referral/2.0.0-M15/apacheds-interceptors-referral-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-interceptors-schema/2.0.0-M15/apacheds-interceptors-schema-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-interceptors-subtree/2.0.0-M15/apacheds-interceptors-subtree-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-interceptors-trigger/2.0.0-M15/apacheds-interceptors-trigger-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/api/api-ldap-extras-trigger/1.0.0-M20/api-ldap-extras-trigger-1.0.0-M20.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-protocol-shared/2.0.0-M15/apacheds-protocol-shared-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-protocol-kerberos/2.0.0-M15/apacheds-protocol-kerberos-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-core-shared/2.0.0-M15/apacheds-core-shared-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-ldif-partition/2.0.0-M15/apacheds-ldif-partition-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-xdbm-partition/2.0.0-M15/apacheds-xdbm-partition-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-mavibot-partition/2.0.0-M15/apacheds-mavibot-partition-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/mavibot/mavibot/1.0.0-M1/mavibot-1.0.0-M1.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-core-avl/2.0.0-M15/apacheds-core-avl-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/api/api-all/1.0.0-M20/api-all-1.0.0-M20.jar:/home/jenkins/.m2/repository/commons-pool/commons-pool/1.6/commons-pool-1.6.jar:/home/jenkins/.m2/repository/antlr/antlr/2.7.7/antlr-2.7.7.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-jdbm-partition/2.0.0-M15/apacheds-jdbm-partition-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/jdbm/apacheds-jdbm1/2.0.0-M2/apacheds-jdbm1-2.0.0-M2.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-protocol-ldap/2.0.0-M15/apacheds-protocol-ldap-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/api/api-asn1-ber/1.0.0-M20/api-asn1-ber-1.0.0-M20.jar:/home/jenkins/.m2/repository/org/apache/directory/api/api-ldap-extras-codec-api/1.0.0-M20/api-ldap-extras-codec-api-1.0.0-M20.jar:/home/jenkins/.m2/repository/org/apache/directory/api/api-ldap-extras-codec/1.0.0-M20/api-ldap-extras-codec-1.0.0-M20.jar:/home/jenkins/.m2/repository/org/apache/directory/api/api-ldap-extras-sp/1.0.0-M20/api-ldap-extras-sp-1.0.0-M20.jar:/home/jenkins/.m2/repository/bouncycastle/bcprov-jdk15/140/bcprov-jdk15-140.jar:/home/jenkins/.m2/repository/com/jcraft/jsch/0.1.51/jsch-0.1.51.jar:/home/jenkins/.m2/repository/org/apache/curator/curator-test/2.7.1/curator-test-2.7.1.jar:/home/jenkins/.m2/repository/org/javassist/javassist/3.18.1-GA/javassist-3.18.1-GA.jar:/home/jenkins/.m2/repository/org/apache/commons/commons-math/2.2/commons-math-2.2.jar:/home/jenkins/.m2/repository/org/apache/curator/curator-client/2.7.1/curator-client-2.7.1.jar:/home/jenkins/.m2/repository/org/apache/curator/curator-recipes/2.7.1/curator-recipes-2.7.1.jar:/home/jenkins/.m2/repository/com/google/code/findbugs/jsr305/3.0.0/jsr305-3.0.0.jar:/home/jenkins/.m2/repository/org/apache/sshd/sshd-core/0.14.0/sshd-core-0.14.0.jar:/home/jenkins/.m2/repository/org/apache/htrace/htrace-core4/4.0.1-incubating/htrace-core4-4.0.1-incubating.jar:/home/jenkins/.m2/repository/org/apache/zookeeper/zookeeper/3.4.6/zookeeper-3.4.6.jar:/home/jenkins/.m2/repository/io/netty/netty/3.6.2.Final/netty-3.6.2.Final.jar:/home/jenkins/.m2/repository/org/apache/zookeeper/zookeeper/3.4.6/zookeeper-3.4.6-tests.jar:/home/jenkins/.m2/repository/org/apache/commons/commons-compress/1.4.1/commons-compress-1.4.1.jar:/home/jenkins/.m2/repository/org/tukaani/xz/1.0/xz-1.0.jar:/home/jenkins/.m2/repository/org/bouncycastle/bcprov-jdk16/1.46/bcprov-jdk16-1.46.jar:
2015-12-19 01:44:08,389 INFO server.ZooKeeperServer (Environment.java:logEnv(100)) - Server environment:java.library.path=${env.LD_LIBRARY_PATH}:/home/jenkins/jenkins-slave/workspace/Hadoop-common-trunk-Java8/hadoop-common-project/hadoop-common/target/native/target/usr/local/lib:/home/jenkins/jenkins-slave/workspace/Hadoop-common-trunk-Java8/hadoop-common-project/hadoop-common/../../hadoop-common-project/hadoop-common/target/native/target/usr/local/lib:/usr/java/packages/lib/amd64:/usr/lib64:/lib64:/lib:/usr/lib
2015-12-19 01:44:08,389 INFO server.ZooKeeperServer (Environment.java:logEnv(100)) - Server environment:java.io.tmpdir=/tmp
2015-12-19 01:44:08,390 INFO server.ZooKeeperServer (Environment.java:logEnv(100)) - Server environment:java.compiler=<NA>
2015-12-19 01:44:08,391 INFO server.ZooKeeperServer (Environment.java:logEnv(100)) - Server environment:os.name=Linux
2015-12-19 01:44:08,391 INFO server.ZooKeeperServer (Environment.java:logEnv(100)) - Server environment:os.arch=amd64
2015-12-19 01:44:08,392 INFO server.ZooKeeperServer (Environment.java:logEnv(100)) - Server environment:os.version=3.13.0-36-lowlatency
2015-12-19 01:44:08,392 INFO server.ZooKeeperServer (Environment.java:logEnv(100)) - Server environment:user.name=jenkins
2015-12-19 01:44:08,393 INFO server.ZooKeeperServer (Environment.java:logEnv(100)) - Server environment:user.home=/home/jenkins
2015-12-19 01:44:08,393 INFO server.ZooKeeperServer (Environment.java:logEnv(100)) - Server environment:user.dir=/home/jenkins/jenkins-slave/workspace/Hadoop-common-trunk-Java8/hadoop-common-project/hadoop-common
2015-12-19 01:44:08,423 INFO server.ZooKeeperServer (ZooKeeperServer.java:setTickTime(755)) - tickTime set to 3000
2015-12-19 01:44:08,424 INFO server.ZooKeeperServer (ZooKeeperServer.java:setMinSessionTimeout(764)) - minSessionTimeout set to -1
2015-12-19 01:44:08,425 INFO server.ZooKeeperServer (ZooKeeperServer.java:setMaxSessionTimeout(773)) - maxSessionTimeout set to -1
2015-12-19 01:44:08,452 INFO server.NIOServerCnxnFactory (NIOServerCnxnFactory.java:configure(94)) - binding to port 0.0.0.0/0.0.0.0:58855
2015-12-19 01:44:10,247 INFO delegation.ZKDelegationTokenSecretManager (ZKDelegationTokenSecretManager.java:<init>(181)) - Connecting to ZooKeeper without authentication
2015-12-19 01:44:10,379 INFO imps.CuratorFrameworkImpl (CuratorFrameworkImpl.java:start(224)) - Starting
2015-12-19 01:44:10,389 INFO zookeeper.ZooKeeper (Environment.java:logEnv(100)) - Client environment:zookeeper.version=3.4.6-1569965, built on 02/20/2014 09:09 GMT
2015-12-19 01:44:10,389 INFO zookeeper.ZooKeeper (Environment.java:logEnv(100)) - Client environment:host.name=asf904.gq1.ygridcore.net
2015-12-19 01:44:10,391 INFO zookeeper.ZooKeeper (Environment.java:logEnv(100)) - Client environment:java.version=1.8.0
2015-12-19 01:44:10,391 INFO zookeeper.ZooKeeper (Environment.java:logEnv(100)) - Client environment:java.vendor=Oracle Corporation
2015-12-19 01:44:10,391 INFO zookeeper.ZooKeeper (Environment.java:logEnv(100)) - Client environment:java.home=/home/jenkins/tools/java/jdk1.8.0/jre
2015-12-19 01:44:10,391 INFO zookeeper.ZooKeeper (Environment.java:logEnv(100)) - Client environment:java.class.path=/home/jenkins/jenkins-slave/workspace/Hadoop-common-trunk-Java8/hadoop-common-project/hadoop-common/target/test-classes:/home/jenkins/jenkins-slave/workspace/Hadoop-common-trunk-Java8/hadoop-common-project/hadoop-common/target/classes:/home/jenkins/jenkins-slave/workspace/Hadoop-common-trunk-Java8/hadoop-common-project/hadoop-annotations/target/hadoop-annotations-3.0.0-SNAPSHOT.jar:/home/jenkins/tools/java/jdk1.8.0/jre/../lib/tools.jar:/home/jenkins/.m2/repository/com/google/guava/guava/11.0.2/guava-11.0.2.jar:/home/jenkins/.m2/repository/commons-cli/commons-cli/1.2/commons-cli-1.2.jar:/home/jenkins/.m2/repository/org/apache/commons/commons-math3/3.1.1/commons-math3-3.1.1.jar:/home/jenkins/.m2/repository/xmlenc/xmlenc/0.52/xmlenc-0.52.jar:/home/jenkins/.m2/repository/commons-httpclient/commons-httpclient/3.1/commons-httpclient-3.1.jar:/home/jenkins/.m2/repository/commons-codec/commons-codec/1.4/commons-codec-1.4.jar:/home/jenkins/.m2/repository/commons-io/commons-io/2.4/commons-io-2.4.jar:/home/jenkins/.m2/repository/commons-net/commons-net/3.1/commons-net-3.1.jar:/home/jenkins/.m2/repository/commons-collections/commons-collections/3.2.2/commons-collections-3.2.2.jar:/home/jenkins/.m2/repository/javax/servlet/servlet-api/2.5/servlet-api-2.5.jar:/home/jenkins/.m2/repository/org/mortbay/jetty/jetty/6.1.26/jetty-6.1.26.jar:/home/jenkins/.m2/repository/org/mortbay/jetty/jetty-util/6.1.26/jetty-util-6.1.26.jar:/home/jenkins/.m2/repository/javax/servlet/jsp/jsp-api/2.1/jsp-api-2.1.jar:/home/jenkins/.m2/repository/com/sun/jersey/jersey-core/1.9/jersey-core-1.9.jar:/home/jenkins/.m2/repository/com/sun/jersey/jersey-json/1.9/jersey-json-1.9.jar:/home/jenkins/.m2/repository/org/codehaus/jettison/jettison/1.1/jettison-1.1.jar:/home/jenkins/.m2/repository/com/sun/xml/bind/jaxb-impl/2.2.3-1/jaxb-impl-2.2.3-1.jar:/home/jenkins/.m2/repository/javax/xml/bind/jaxb-api/2.2.2/jaxb-api-2.2.2.jar:/home/jenkins/.m2/repository/javax/xml/stream/stax-api/1.0-2/stax-api-1.0-2.jar:/home/jenkins/.m2/repository/javax/activation/activation/1.1/activation-1.1.jar:/home/jenkins/.m2/repository/org/codehaus/jackson/jackson-jaxrs/1.9.13/jackson-jaxrs-1.9.13.jar:/home/jenkins/.m2/repository/org/codehaus/jackson/jackson-xc/1.9.13/jackson-xc-1.9.13.jar:/home/jenkins/.m2/repository/com/sun/jersey/jersey-server/1.9/jersey-server-1.9.jar:/home/jenkins/.m2/repository/asm/asm/3.2/asm-3.2.jar:/home/jenkins/.m2/repository/commons-logging/commons-logging/1.1.3/commons-logging-1.1.3.jar:/home/jenkins/.m2/repository/log4j/log4j/1.2.17/log4j-1.2.17.jar:/home/jenkins/.m2/repository/net/java/dev/jets3t/jets3t/0.9.0/jets3t-0.9.0.jar:/home/jenkins/.m2/repository/org/apache/httpcomponents/httpclient/4.2.5/httpclient-4.2.5.jar:/home/jenkins/.m2/repository/org/apache/httpcomponents/httpcore/4.2.5/httpcore-4.2.5.jar:/home/jenkins/.m2/repository/com/jamesmurty/utils/java-xmlbuilder/0.4/java-xmlbuilder-0.4.jar:/home/jenkins/.m2/repository/junit/junit/4.11/junit-4.11.jar:/home/jenkins/.m2/repository/org/hamcrest/hamcrest-core/1.3/hamcrest-core-1.3.jar:/home/jenkins/.m2/repository/commons-lang/commons-lang/2.6/commons-lang-2.6.jar:/home/jenkins/.m2/repository/commons-configuration/commons-configuration/1.6/commons-configuration-1.6.jar:/home/jenkins/.m2/repository/commons-digester/commons-digester/1.8/commons-digester-1.8.jar:/home/jenkins/.m2/repository/commons-beanutils/commons-beanutils/1.7.0/commons-beanutils-1.7.0.jar:/home/jenkins/.m2/repository/commons-beanutils/commons-beanutils-core/1.8.0/commons-beanutils-core-1.8.0.jar:/home/jenkins/.m2/repository/org/slf4j/slf4j-api/1.7.10/slf4j-api-1.7.10.jar:/home/jenkins/.m2/repository/org/slf4j/slf4j-log4j12/1.7.10/slf4j-log4j12-1.7.10.jar:/home/jenkins/.m2/repository/org/codehaus/jackson/jackson-core-asl/1.9.13/jackson-core-asl-1.9.13.jar:/home/jenkins/.m2/repository/org/codehaus/jackson/jackson-mapper-asl/1.9.13/jackson-mapper-asl-1.9.13.jar:/home/jenkins/.m2/repository/org/mockito/mockito-all/1.8.5/mockito-all-1.8.5.jar:/home/jenkins/.m2/repository/org/apache/avro/avro/1.7.4/avro-1.7.4.jar:/home/jenkins/.m2/repository/com/thoughtworks/paranamer/paranamer/2.3/paranamer-2.3.jar:/home/jenkins/.m2/repository/org/xerial/snappy/snappy-java/1.0.4.1/snappy-java-1.0.4.1.jar:/home/jenkins/.m2/repository/org/apache/ant/ant/1.8.1/ant-1.8.1.jar:/home/jenkins/.m2/repository/org/apache/ant/ant-launcher/1.8.1/ant-launcher-1.8.1.jar:/home/jenkins/.m2/repository/com/google/re2j/re2j/1.0/re2j-1.0.jar:/home/jenkins/.m2/repository/com/google/protobuf/protobuf-java/2.5.0/protobuf-java-2.5.0.jar:/home/jenkins/.m2/repository/com/google/code/gson/gson/2.2.4/gson-2.2.4.jar:/home/jenkins/jenkins-slave/workspace/Hadoop-common-trunk-Java8/hadoop-common-project/hadoop-auth/target/hadoop-auth-3.0.0-SNAPSHOT.jar:/home/jenkins/.m2/repository/com/nimbusds/nimbus-jose-jwt/3.9/nimbus-jose-jwt-3.9.jar:/home/jenkins/.m2/repository/net/jcip/jcip-annotations/1.0/jcip-annotations-1.0.jar:/home/jenkins/.m2/repository/net/minidev/json-smart/1.1.1/json-smart-1.1.1.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-kerberos-codec/2.0.0-M15/apacheds-kerberos-codec-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-i18n/2.0.0-M15/apacheds-i18n-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/api/api-asn1-api/1.0.0-M20/api-asn1-api-1.0.0-M20.jar:/home/jenkins/.m2/repository/org/apache/directory/api/api-util/1.0.0-M20/api-util-1.0.0-M20.jar:/home/jenkins/.m2/repository/org/apache/curator/curator-framework/2.7.1/curator-framework-2.7.1.jar:/home/jenkins/jenkins-slave/workspace/Hadoop-common-trunk-Java8/hadoop-common-project/hadoop-auth/target/hadoop-auth-3.0.0-SNAPSHOT-tests.jar:/home/jenkins/jenkins-slave/workspace/Hadoop-common-trunk-Java8/hadoop-common-project/hadoop-minikdc/target/hadoop-minikdc-3.0.0-SNAPSHOT.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-core-api/2.0.0-M15/apacheds-core-api-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-core-constants/2.0.0-M15/apacheds-core-constants-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/api/api-i18n/1.0.0-M20/api-i18n-1.0.0-M20.jar:/home/jenkins/.m2/repository/org/apache/directory/api/api-ldap-client-api/1.0.0-M20/api-ldap-client-api-1.0.0-M20.jar:/home/jenkins/.m2/repository/org/apache/directory/api/api-ldap-codec-core/1.0.0-M20/api-ldap-codec-core-1.0.0-M20.jar:/home/jenkins/.m2/repository/org/apache/directory/api/api-ldap-extras-aci/1.0.0-M20/api-ldap-extras-aci-1.0.0-M20.jar:/home/jenkins/.m2/repository/org/apache/directory/api/api-ldap-extras-util/1.0.0-M20/api-ldap-extras-util-1.0.0-M20.jar:/home/jenkins/.m2/repository/org/apache/directory/api/api-ldap-model/1.0.0-M20/api-ldap-model-1.0.0-M20.jar:/home/jenkins/.m2/repository/org/apache/mina/mina-core/2.0.0-M5/mina-core-2.0.0-M5.jar:/home/jenkins/.m2/repository/net/sf/ehcache/ehcache-core/2.4.4/ehcache-core-2.4.4.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-interceptor-kerberos/2.0.0-M15/apacheds-interceptor-kerberos-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-core/2.0.0-M15/apacheds-core-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-interceptors-admin/2.0.0-M15/apacheds-interceptors-admin-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-interceptors-authn/2.0.0-M15/apacheds-interceptors-authn-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-interceptors-authz/2.0.0-M15/apacheds-interceptors-authz-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-interceptors-changelog/2.0.0-M15/apacheds-interceptors-changelog-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-interceptors-collective/2.0.0-M15/apacheds-interceptors-collective-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-interceptors-event/2.0.0-M15/apacheds-interceptors-event-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-interceptors-exception/2.0.0-M15/apacheds-interceptors-exception-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-interceptors-journal/2.0.0-M15/apacheds-interceptors-journal-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-interceptors-normalization/2.0.0-M15/apacheds-interceptors-normalization-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-interceptors-operational/2.0.0-M15/apacheds-interceptors-operational-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-interceptors-referral/2.0.0-M15/apacheds-interceptors-referral-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-interceptors-schema/2.0.0-M15/apacheds-interceptors-schema-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-interceptors-subtree/2.0.0-M15/apacheds-interceptors-subtree-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-interceptors-trigger/2.0.0-M15/apacheds-interceptors-trigger-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/api/api-ldap-extras-trigger/1.0.0-M20/api-ldap-extras-trigger-1.0.0-M20.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-protocol-shared/2.0.0-M15/apacheds-protocol-shared-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-protocol-kerberos/2.0.0-M15/apacheds-protocol-kerberos-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-core-shared/2.0.0-M15/apacheds-core-shared-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-ldif-partition/2.0.0-M15/apacheds-ldif-partition-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-xdbm-partition/2.0.0-M15/apacheds-xdbm-partition-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-mavibot-partition/2.0.0-M15/apacheds-mavibot-partition-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/mavibot/mavibot/1.0.0-M1/mavibot-1.0.0-M1.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-core-avl/2.0.0-M15/apacheds-core-avl-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/api/api-all/1.0.0-M20/api-all-1.0.0-M20.jar:/home/jenkins/.m2/repository/commons-pool/commons-pool/1.6/commons-pool-1.6.jar:/home/jenkins/.m2/repository/antlr/antlr/2.7.7/antlr-2.7.7.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-jdbm-partition/2.0.0-M15/apacheds-jdbm-partition-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/jdbm/apacheds-jdbm1/2.0.0-M2/apacheds-jdbm1-2.0.0-M2.jar:/home/jenkins/.m2/repository/org/apache/directory/server/apacheds-protocol-ldap/2.0.0-M15/apacheds-protocol-ldap-2.0.0-M15.jar:/home/jenkins/.m2/repository/org/apache/directory/api/api-asn1-ber/1.0.0-M20/api-asn1-ber-1.0.0-M20.jar:/home/jenkins/.m2/repository/org/apache/directory/api/api-ldap-extras-codec-api/1.0.0-M20/api-ldap-extras-codec-api-1.0.0-M20.jar:/home/jenkins/.m2/repository/org/apache/directory/api/api-ldap-extras-codec/1.0.0-M20/api-ldap-extras-codec-1.0.0-M20.jar:/home/jenkins/.m2/repository/org/apache/directory/api/api-ldap-extras-sp/1.0.0-M20/api-ldap-extras-sp-1.0.0-M20.jar:/home/jenkins/.m2/repository/bouncycastle/bcprov-jdk15/140/bcprov-jdk15-140.jar:/home/jenkins/.m2/repository/com/jcraft/jsch/0.1.51/jsch-0.1.51.jar:/home/jenkins/.m2/repository/org/apache/curator/curator-test/2.7.1/curator-test-2.7.1.jar:/home/jenkins/.m2/repository/org/javassist/javassist/3.18.1-GA/javassist-3.18.1-GA.jar:/home/jenkins/.m2/repository/org/apache/commons/commons-math/2.2/commons-math-2.2.jar:/home/jenkins/.m2/repository/org/apache/curator/curator-client/2.7.1/curator-client-2.7.1.jar:/home/jenkins/.m2/repository/org/apache/curator/curator-recipes/2.7.1/curator-recipes-2.7.1.jar:/home/jenkins/.m2/repository/com/google/code/findbugs/jsr305/3.0.0/jsr305-3.0.0.jar:/home/jenkins/.m2/repository/org/apache/sshd/sshd-core/0.14.0/sshd-core-0.14.0.jar:/home/jenkins/.m2/repository/org/apache/htrace/htrace-core4/4.0.1-incubating/htrace-core4-4.0.1-incubating.jar:/home/jenkins/.m2/repository/org/apache/zookeeper/zookeeper/3.4.6/zookeeper-3.4.6.jar:/home/jenkins/.m2/repository/io/netty/netty/3.6.2.Final/netty-3.6.2.Final.jar:/home/jenkins/.m2/repository/org/apache/zookeeper/zookeeper/3.4.6/zookeeper-3.4.6-tests.jar:/home/jenkins/.m2/repository/org/apache/commons/commons-compress/1.4.1/commons-compress-1.4.1.jar:/home/jenkins/.m2/repository/org/tukaani/xz/1.0/xz-1.0.jar:/home/jenkins/.m2/repository/org/bouncycastle/bcprov-jdk16/1.46/bcprov-jdk16-1.46.jar:
2015-12-19 01:44:10,394 INFO zookeeper.ZooKeeper (Environment.java:logEnv(100)) - Client environment:java.library.path=${env.LD_LIBRARY_PATH}:/home/jenkins/jenkins-slave/workspace/Hadoop-common-trunk-Java8/hadoop-common-project/hadoop-common/target/native/target/usr/local/lib:/home/jenkins/jenkins-slave/workspace/Hadoop-common-trunk-Java8/hadoop-common-project/hadoop-common/../../hadoop-common-project/hadoop-common/target/native/target/usr/local/lib:/usr/java/packages/lib/amd64:/usr/lib64:/lib64:/lib:/usr/lib
2015-12-19 01:44:10,394 INFO zookeeper.ZooKeeper (Environment.java:logEnv(100)) - Client environment:java.io.tmpdir=/tmp
2015-12-19 01:44:10,394 INFO zookeeper.ZooKeeper (Environment.java:logEnv(100)) - Client environment:java.compiler=<NA>
2015-12-19 01:44:10,394 INFO zookeeper.ZooKeeper (Environment.java:logEnv(100)) - Client environment:os.name=Linux
2015-12-19 01:44:10,395 INFO zookeeper.ZooKeeper (Environment.java:logEnv(100)) - Client environment:os.arch=amd64
2015-12-19 01:44:10,395 INFO zookeeper.ZooKeeper (Environment.java:logEnv(100)) - Client environment:os.version=3.13.0-36-lowlatency
2015-12-19 01:44:10,395 INFO zookeeper.ZooKeeper (Environment.java:logEnv(100)) - Client environment:user.name=jenkins
2015-12-19 01:44:10,396 INFO zookeeper.ZooKeeper (Environment.java:logEnv(100)) - Client environment:user.home=/home/jenkins
2015-12-19 01:44:10,396 INFO zookeeper.ZooKeeper (Environment.java:logEnv(100)) - Client environment:user.dir=/home/jenkins/jenkins-slave/workspace/Hadoop-common-trunk-Java8/hadoop-common-project/hadoop-common
2015-12-19 01:44:10,399 INFO zookeeper.ZooKeeper (ZooKeeper.java:<init>(438)) - Initiating client connection, connectString=127.0.0.1:58855 sessionTimeout=10000 watcher=org.apache.curator.ConnectionState@3f197a46
2015-12-19 01:44:10,440 INFO zookeeper.ClientCnxn (ClientCnxn.java:logStartConnect(975)) - Opening socket connection to server 127.0.0.1/127.0.0.1:58855. Will not attempt to authenticate using SASL (unknown error)
2015-12-19 01:44:10,443 INFO server.NIOServerCnxnFactory (NIOServerCnxnFactory.java:run(197)) - Accepted socket connection from /127.0.0.1:53002
2015-12-19 01:44:10,444 INFO zookeeper.ClientCnxn (ClientCnxn.java:primeConnection(852)) - Socket connection established to 127.0.0.1/127.0.0.1:58855, initiating session
2015-12-19 01:44:10,451 INFO server.ZooKeeperServer (ZooKeeperServer.java:processConnectRequest(868)) - Client attempting to establish new session at /127.0.0.1:53002
2015-12-19 01:44:10,467 INFO persistence.FileTxnLog (FileTxnLog.java:append(199)) - Creating new log file: log.1
2015-12-19 01:44:10,565 INFO server.ZooKeeperServer (ZooKeeperServer.java:finishSessionInit(617)) - Established session 0x151b7e8882a0000 with negotiated timeout 10000 for client /127.0.0.1:53002
2015-12-19 01:44:10,566 INFO zookeeper.ClientCnxn (ClientCnxn.java:onConnected(1235)) - Session establishment complete on server 127.0.0.1/127.0.0.1:58855, sessionid = 0x151b7e8882a0000, negotiated timeout = 10000
2015-12-19 01:44:10,581 INFO state.ConnectionStateManager (ConnectionStateManager.java:postState(228)) - State change: CONNECTED
2015-12-19 01:44:10,675 INFO delegation.AbstractDelegationTokenSecretManager (AbstractDelegationTokenSecretManager.java:updateCurrentKey(336)) - Updating the current master key for generating delegation tokens
2015-12-19 01:44:10,750 INFO delegation.ZKDelegationTokenSecretManager (ZKDelegationTokenSecretManager.java:<init>(181)) - Connecting to ZooKeeper without authentication
2015-12-19 01:44:10,823 INFO delegation.AbstractDelegationTokenSecretManager (AbstractDelegationTokenSecretManager.java:run(649)) - Starting expired delegation token remover thread, tokenRemoverScanInterval=1440 min(s)
2015-12-19 01:44:10,826 INFO imps.CuratorFrameworkImpl (CuratorFrameworkImpl.java:start(224)) - Starting
2015-12-19 01:44:10,833 INFO delegation.AbstractDelegationTokenSecretManager (AbstractDelegationTokenSecretManager.java:updateCurrentKey(336)) - Updating the current master key for generating delegation tokens
2015-12-19 01:44:10,849 INFO zookeeper.ZooKeeper (ZooKeeper.java:<init>(438)) - Initiating client connection, connectString=127.0.0.1:58855 sessionTimeout=10000 watcher=org.apache.curator.ConnectionState@55141def
2015-12-19 01:44:10,851 INFO zookeeper.ClientCnxn (ClientCnxn.java:logStartConnect(975)) - Opening socket connection to server 127.0.0.1/127.0.0.1:58855. Will not attempt to authenticate using SASL (unknown error)
2015-12-19 01:44:10,851 INFO server.NIOServerCnxnFactory (NIOServerCnxnFactory.java:run(197)) - Accepted socket connection from /127.0.0.1:53003
2015-12-19 01:44:10,853 INFO zookeeper.ClientCnxn (ClientCnxn.java:primeConnection(852)) - Socket connection established to 127.0.0.1/127.0.0.1:58855, initiating session
2015-12-19 01:44:10,856 INFO server.ZooKeeperServer (ZooKeeperServer.java:processConnectRequest(868)) - Client attempting to establish new session at /127.0.0.1:53003
2015-12-19 01:44:10,858 INFO server.ZooKeeperServer (ZooKeeperServer.java:finishSessionInit(617)) - Established session 0x151b7e8882a0001 with negotiated timeout 10000 for client /127.0.0.1:53003
2015-12-19 01:44:10,861 INFO zookeeper.ClientCnxn (ClientCnxn.java:onConnected(1235)) - Session establishment complete on server 127.0.0.1/127.0.0.1:58855, sessionid = 0x151b7e8882a0001, negotiated timeout = 10000
2015-12-19 01:44:10,861 INFO state.ConnectionStateManager (ConnectionStateManager.java:postState(228)) - State change: CONNECTED
2015-12-19 01:44:11,882 INFO server.PrepRequestProcessor (PrepRequestProcessor.java:pRequest(645)) - Got user-level KeeperException when processing sessionid:0x151b7e8882a0001 type:create cxid:0x3 zxid:0xe txntype:-1 reqpath:n/a Error Path:/testPath/ZKDTSMRoot/ZKDTSMSeqNumRoot Error:KeeperErrorCode = NodeExists for /testPath/ZKDTSMRoot/ZKDTSMSeqNumRoot
2015-12-19 01:44:11,893 INFO server.PrepRequestProcessor (PrepRequestProcessor.java:pRequest(645)) - Got user-level KeeperException when processing sessionid:0x151b7e8882a0001 type:create cxid:0x5 zxid:0xf txntype:-1 reqpath:n/a Error Path:/testPath/ZKDTSMRoot/ZKDTSMKeyIdRoot Error:KeeperErrorCode = NodeExists for /testPath/ZKDTSMRoot/ZKDTSMKeyIdRoot
2015-12-19 01:44:11,901 INFO server.PrepRequestProcessor (PrepRequestProcessor.java:pRequest(645)) - Got user-level KeeperException when processing sessionid:0x151b7e8882a0001 type:create cxid:0x7 zxid:0x10 txntype:-1 reqpath:n/a Error Path:/testPath/ZKDTSMRoot/ZKDTSMMasterKeyRoot Error:KeeperErrorCode = NodeExists for /testPath/ZKDTSMRoot/ZKDTSMMasterKeyRoot
2015-12-19 01:44:11,903 INFO server.PrepRequestProcessor (PrepRequestProcessor.java:pRequest(645)) - Got user-level KeeperException when processing sessionid:0x151b7e8882a0001 type:create cxid:0x8 zxid:0x11 txntype:-1 reqpath:n/a Error Path:/testPath/ZKDTSMRoot/ZKDTSMTokensRoot Error:KeeperErrorCode = NodeExists for /testPath/ZKDTSMRoot/ZKDTSMTokensRoot
2015-12-19 01:44:11,941 INFO delegation.AbstractDelegationTokenSecretManager (AbstractDelegationTokenSecretManager.java:updateCurrentKey(336)) - Updating the current master key for generating delegation tokens
2015-12-19 01:44:11,970 INFO delegation.AbstractDelegationTokenSecretManager (AbstractDelegationTokenSecretManager.java:run(649)) - Starting expired delegation token remover thread, tokenRemoverScanInterval=1440 min(s)
2015-12-19 01:44:11,982 INFO delegation.AbstractDelegationTokenSecretManager (AbstractDelegationTokenSecretManager.java:updateCurrentKey(336)) - Updating the current master key for generating delegation tokens
2015-12-19 01:44:12,159 INFO delegation.AbstractDelegationTokenSecretManager (AbstractDelegationTokenSecretManager.java:createPassword(396)) - Creating password for identifier: owner=jenkins, renewer=foo, realUser=, issueDate=1450489452155, maxDate=1450575852155, sequenceNumber=1, masterKeyId=2, currentKey: 2
2015-12-19 01:44:12,175 INFO delegation.AbstractDelegationTokenSecretManager (AbstractDelegationTokenSecretManager.java:renewToken(480)) - Token renewal for identifier: owner=jenkins, renewer=foo, realUser=, issueDate=1450489452155, maxDate=1450575852155, sequenceNumber=1, masterKeyId=2; total currentTokens 1
2015-12-19 01:44:12,180 INFO delegation.AbstractDelegationTokenSecretManager (AbstractDelegationTokenSecretManager.java:cancelToken(531)) - Token cancelation requested for identifier: owner=jenkins, renewer=foo, realUser=, issueDate=1450489452155, maxDate=1450575852155, sequenceNumber=1, masterKeyId=2
2015-12-19 01:44:12,200 ERROR delegation.ZKDelegationTokenSecretManager (ZKDelegationTokenSecretManager.java:getTokenInfoFromZK(660)) - No node in path [/ZKDTSMTokensRoot/DT_1]
2015-12-19 01:44:12,204 INFO delegation.AbstractDelegationTokenSecretManager (AbstractDelegationTokenSecretManager.java:createPassword(396)) - Creating password for identifier: owner=jenkins, renewer=bar, realUser=, issueDate=1450489452201, maxDate=1450575852201, sequenceNumber=2, masterKeyId=4, currentKey: 4
2015-12-19 01:44:12,213 INFO delegation.AbstractDelegationTokenSecretManager (AbstractDelegationTokenSecretManager.java:renewToken(480)) - Token renewal for identifier: owner=jenkins, renewer=bar, realUser=, issueDate=1450489452201, maxDate=1450575852201, sequenceNumber=2, masterKeyId=4; total currentTokens 1
2015-12-19 01:44:12,224 INFO delegation.AbstractDelegationTokenSecretManager (AbstractDelegationTokenSecretManager.java:cancelToken(531)) - Token cancelation requested for identifier: owner=jenkins, renewer=bar, realUser=, issueDate=1450489452201, maxDate=1450575852201, sequenceNumber=2, masterKeyId=4
2015-12-19 01:44:12,229 ERROR delegation.ZKDelegationTokenSecretManager (ZKDelegationTokenSecretManager.java:getTokenInfoFromZK(660)) - No node in path [/ZKDTSMTokensRoot/DT_2]
2015-12-19 01:44:12,229 ERROR delegation.AbstractDelegationTokenSecretManager (AbstractDelegationTokenSecretManager.java:run(670)) - ExpiredTokenRemover received java.lang.InterruptedException: sleep interrupted
2015-12-19 01:44:12,240 INFO server.PrepRequestProcessor (PrepRequestProcessor.java:pRequest2Txn(494)) - Processed session termination for sessionid: 0x151b7e8882a0000
2015-12-19 01:44:12,242 INFO server.NIOServerCnxn (NIOServerCnxn.java:closeSock(1007)) - Closed socket connection for client /127.0.0.1:53002 which had sessionid 0x151b7e8882a0000
2015-12-19 01:44:12,243 INFO zookeeper.ZooKeeper (ZooKeeper.java:close(684)) - Session: 0x151b7e8882a0000 closed
2015-12-19 01:44:12,243 INFO zookeeper.ClientCnxn (ClientCnxn.java:run(512)) - EventThread shut down
2015-12-19 01:44:12,544 ERROR delegation.AbstractDelegationTokenSecretManager (AbstractDelegationTokenSecretManager.java:run(670)) - ExpiredTokenRemover received java.lang.InterruptedException: sleep interrupted
2015-12-19 01:44:12,553 INFO server.PrepRequestProcessor (PrepRequestProcessor.java:pRequest2Txn(494)) - Processed session termination for sessionid: 0x151b7e8882a0001
2015-12-19 01:44:12,554 INFO server.NIOServerCnxn (NIOServerCnxn.java:closeSock(1007)) - Closed socket connection for client /127.0.0.1:53003 which had sessionid 0x151b7e8882a0001
2015-12-19 01:44:12,555 INFO zookeeper.ClientCnxn (ClientCnxn.java:run(512)) - EventThread shut down
2015-12-19 01:44:12,555 INFO zookeeper.ZooKeeper (ZooKeeper.java:close(684)) - Session: 0x151b7e8882a0001 closed
2015-12-19 01:44:12,893 INFO delegation.ZKDelegationTokenSecretManager (ZKDelegationTokenSecretManager.java:<init>(181)) - Connecting to ZooKeeper without authentication
2015-12-19 01:44:12,895 INFO imps.CuratorFrameworkImpl (CuratorFrameworkImpl.java:start(224)) - Starting
2015-12-19 01:44:12,897 INFO zookeeper.ZooKeeper (ZooKeeper.java:<init>(438)) - Initiating client connection, connectString=127.0.0.1:58855 sessionTimeout=10000 watcher=org.apache.curator.ConnectionState@40005471
2015-12-19 01:44:12,916 INFO zookeeper.ClientCnxn (ClientCnxn.java:logStartConnect(975)) - Opening socket connection to server 127.0.0.1/127.0.0.1:58855. Will not attempt to authenticate using SASL (unknown error)
2015-12-19 01:44:12,931 INFO zookeeper.ClientCnxn (ClientCnxn.java:primeConnection(852)) - Socket connection established to 127.0.0.1/127.0.0.1:58855, initiating session
2015-12-19 01:44:12,932 INFO server.NIOServerCnxnFactory (NIOServerCnxnFactory.java:run(197)) - Accepted socket connection from /127.0.0.1:53004
2015-12-19 01:44:12,933 INFO server.ZooKeeperServer (ZooKeeperServer.java:processConnectRequest(868)) - Client attempting to establish new session at /127.0.0.1:53004
2015-12-19 01:44:12,938 INFO server.ZooKeeperServer (ZooKeeperServer.java:finishSessionInit(617)) - Established session 0x151b7e8882a0002 with negotiated timeout 10000 for client /127.0.0.1:53004
2015-12-19 01:44:12,938 INFO zookeeper.ClientCnxn (ClientCnxn.java:onConnected(1235)) - Session establishment complete on server 127.0.0.1/127.0.0.1:58855, sessionid = 0x151b7e8882a0002, negotiated timeout = 10000
2015-12-19 01:44:12,939 INFO state.ConnectionStateManager (ConnectionStateManager.java:postState(228)) - State change: CONNECTED
2015-12-19 01:44:13,941 INFO server.PrepRequestProcessor (PrepRequestProcessor.java:pRequest(645)) - Got user-level KeeperException when processing sessionid:0x151b7e8882a0002 type:create cxid:0x3 zxid:0x22 txntype:-1 reqpath:n/a Error Path:/testPath/ZKDTSMRoot/ZKDTSMSeqNumRoot Error:KeeperErrorCode = NodeExists for /testPath/ZKDTSMRoot/ZKDTSMSeqNumRoot
2015-12-19 01:44:13,947 INFO server.PrepRequestProcessor (PrepRequestProcessor.java:pRequest(645)) - Got user-level KeeperException when processing sessionid:0x151b7e8882a0002 type:create cxid:0x5 zxid:0x23 txntype:-1 reqpath:n/a Error Path:/testPath/ZKDTSMRoot/ZKDTSMKeyIdRoot Error:KeeperErrorCode = NodeExists for /testPath/ZKDTSMRoot/ZKDTSMKeyIdRoot
2015-12-19 01:44:13,949 INFO server.PrepRequestProcessor (PrepRequestProcessor.java:pRequest(645)) - Got user-level KeeperException when processing sessionid:0x151b7e8882a0002 type:create cxid:0x7 zxid:0x24 txntype:-1 reqpath:n/a Error Path:/testPath/ZKDTSMRoot/ZKDTSMMasterKeyRoot Error:KeeperErrorCode = NodeExists for /testPath/ZKDTSMRoot/ZKDTSMMasterKeyRoot
2015-12-19 01:44:13,950 INFO server.PrepRequestProcessor (PrepRequestProcessor.java:pRequest(645)) - Got user-level KeeperException when processing sessionid:0x151b7e8882a0002 type:create cxid:0x8 zxid:0x25 txntype:-1 reqpath:n/a Error Path:/testPath/ZKDTSMRoot/ZKDTSMTokensRoot Error:KeeperErrorCode = NodeExists for /testPath/ZKDTSMRoot/ZKDTSMTokensRoot
2015-12-19 01:44:13,959 INFO delegation.AbstractDelegationTokenSecretManager (AbstractDelegationTokenSecretManager.java:updateCurrentKey(336)) - Updating the current master key for generating delegation tokens
2015-12-19 01:44:13,963 INFO delegation.ZKDelegationTokenSecretManager (ZKDelegationTokenSecretManager.java:<init>(181)) - Connecting to ZooKeeper without authentication
2015-12-19 01:44:13,976 INFO imps.CuratorFrameworkImpl (CuratorFrameworkImpl.java:start(224)) - Starting
2015-12-19 01:44:13,976 INFO zookeeper.ZooKeeper (ZooKeeper.java:<init>(438)) - Initiating client connection, connectString=127.0.0.1:58855 sessionTimeout=10000 watcher=org.apache.curator.ConnectionState@752325ad
2015-12-19 01:44:13,976 INFO delegation.AbstractDelegationTokenSecretManager (AbstractDelegationTokenSecretManager.java:run(649)) - Starting expired delegation token remover thread, tokenRemoverScanInterval=1440 min(s)
2015-12-19 01:44:13,994 INFO zookeeper.ClientCnxn (ClientCnxn.java:logStartConnect(975)) - Opening socket connection to server 127.0.0.1/127.0.0.1:58855. Will not attempt to authenticate using SASL (unknown error)
2015-12-19 01:44:13,995 INFO server.NIOServerCnxnFactory (NIOServerCnxnFactory.java:run(197)) - Accepted socket connection from /127.0.0.1:53006
2015-12-19 01:44:13,995 INFO zookeeper.ClientCnxn (ClientCnxn.java:primeConnection(852)) - Socket connection established to 127.0.0.1/127.0.0.1:58855, initiating session
2015-12-19 01:44:13,997 INFO server.ZooKeeperServer (ZooKeeperServer.java:processConnectRequest(868)) - Client attempting to establish new session at /127.0.0.1:53006
2015-12-19 01:44:14,013 INFO server.ZooKeeperServer (ZooKeeperServer.java:finishSessionInit(617)) - Established session 0x151b7e8882a0003 with negotiated timeout 10000 for client /127.0.0.1:53006
2015-12-19 01:44:14,013 INFO zookeeper.ClientCnxn (ClientCnxn.java:onConnected(1235)) - Session establishment complete on server 127.0.0.1/127.0.0.1:58855, sessionid = 0x151b7e8882a0003, negotiated timeout = 10000
2015-12-19 01:44:14,015 INFO state.ConnectionStateManager (ConnectionStateManager.java:postState(228)) - State change: CONNECTED
2015-12-19 01:44:14,016 INFO delegation.AbstractDelegationTokenSecretManager (AbstractDelegationTokenSecretManager.java:updateCurrentKey(336)) - Updating the current master key for generating delegation tokens
2015-12-19 01:44:15,018 INFO server.PrepRequestProcessor (PrepRequestProcessor.java:pRequest(645)) - Got user-level KeeperException when processing sessionid:0x151b7e8882a0003 type:create cxid:0x3 zxid:0x2c txntype:-1 reqpath:n/a Error Path:/testPath/ZKDTSMRoot/ZKDTSMSeqNumRoot Error:KeeperErrorCode = NodeExists for /testPath/ZKDTSMRoot/ZKDTSMSeqNumRoot
2015-12-19 01:44:15,019 INFO server.PrepRequestProcessor (PrepRequestProcessor.java:pRequest(645)) - Got user-level KeeperException when processing sessionid:0x151b7e8882a0003 type:create cxid:0x5 zxid:0x2d txntype:-1 reqpath:n/a Error Path:/testPath/ZKDTSMRoot/ZKDTSMKeyIdRoot Error:KeeperErrorCode = NodeExists for /testPath/ZKDTSMRoot/ZKDTSMKeyIdRoot
2015-12-19 01:44:15,021 INFO server.PrepRequestProcessor (PrepRequestProcessor.java:pRequest(645)) - Got user-level KeeperException when processing sessionid:0x151b7e8882a0003 type:create cxid:0x7 zxid:0x2e txntype:-1 reqpath:n/a Error Path:/testPath/ZKDTSMRoot/ZKDTSMMasterKeyRoot Error:KeeperErrorCode = NodeExists for /testPath/ZKDTSMRoot/ZKDTSMMasterKeyRoot
2015-12-19 01:44:15,023 INFO server.PrepRequestProcessor (PrepRequestProcessor.java:pRequest(645)) - Got user-level KeeperException when processing sessionid:0x151b7e8882a0003 type:create cxid:0x8 zxid:0x2f txntype:-1 reqpath:n/a Error Path:/testPath/ZKDTSMRoot/ZKDTSMTokensRoot Error:KeeperErrorCode = NodeExists for /testPath/ZKDTSMRoot/ZKDTSMTokensRoot
2015-12-19 01:44:15,037 INFO delegation.AbstractDelegationTokenSecretManager (AbstractDelegationTokenSecretManager.java:updateCurrentKey(336)) - Updating the current master key for generating delegation tokens
2015-12-19 01:44:15,042 INFO delegation.AbstractDelegationTokenSecretManager (AbstractDelegationTokenSecretManager.java:run(649)) - Starting expired delegation token remover thread, tokenRemoverScanInterval=1440 min(s)
2015-12-19 01:44:15,044 INFO delegation.AbstractDelegationTokenSecretManager (AbstractDelegationTokenSecretManager.java:createPassword(396)) - Creating password for identifier: owner=jenkins, renewer=foo, realUser=, issueDate=1450489455042, maxDate=1450575855042, sequenceNumber=3, masterKeyId=6, currentKey: 6
2015-12-19 01:44:15,068 INFO delegation.AbstractDelegationTokenSecretManager (AbstractDelegationTokenSecretManager.java:updateCurrentKey(336)) - Updating the current master key for generating delegation tokens
2015-12-19 01:44:15,069 INFO delegation.AbstractDelegationTokenSecretManager (AbstractDelegationTokenSecretManager.java:renewToken(480)) - Token renewal for identifier: owner=jenkins, renewer=foo, realUser=, issueDate=1450489455042, maxDate=1450575855042, sequenceNumber=3, masterKeyId=6; total currentTokens 1
2015-12-19 01:44:15,072 INFO delegation.AbstractDelegationTokenSecretManager (AbstractDelegationTokenSecretManager.java:cancelToken(531)) - Token cancelation requested for identifier: owner=jenkins, renewer=foo, realUser=, issueDate=1450489455042, maxDate=1450575855042, sequenceNumber=3, masterKeyId=6
2015-12-19 01:44:16,091 ERROR delegation.ZKDelegationTokenSecretManager (ZKDelegationTokenSecretManager.java:getTokenInfoFromZK(660)) - No node in path [/ZKDTSMTokensRoot/DT_3]
2015-12-19 01:44:16,094 INFO delegation.AbstractDelegationTokenSecretManager (AbstractDelegationTokenSecretManager.java:createPassword(396)) - Creating password for identifier: owner=jenkins, renewer=bar, realUser=, issueDate=1450489456091, maxDate=1450575856091, sequenceNumber=4, masterKeyId=8, currentKey: 8
2015-12-19 01:44:16,100 INFO delegation.AbstractDelegationTokenSecretManager (AbstractDelegationTokenSecretManager.java:renewToken(480)) - Token renewal for identifier: owner=jenkins, renewer=bar, realUser=, issueDate=1450489456091, maxDate=1450575856091, sequenceNumber=4, masterKeyId=8; total currentTokens 1
2015-12-19 01:44:16,103 INFO delegation.AbstractDelegationTokenSecretManager (AbstractDelegationTokenSecretManager.java:cancelToken(531)) - Token cancelation requested for identifier: owner=jenkins, renewer=bar, realUser=, issueDate=1450489456091, maxDate=1450575856091, sequenceNumber=4, masterKeyId=8
2015-12-19 01:44:21,113 INFO server.NIOServerCnxn (NIOServerCnxn.java:closeSock(1007)) - Closed socket connection for client /127.0.0.1:53006 which had sessionid 0x151b7e8882a0003
2015-12-19 01:44:21,114 INFO zookeeper.ClientCnxn (ClientCnxn.java:run(1098)) - Unable to read additional data from server sessionid 0x151b7e8882a0003, likely server has closed socket, closing socket connection and attempting reconnect
2015-12-19 01:44:21,115 INFO server.NIOServerCnxn (NIOServerCnxn.java:closeSock(1007)) - Closed socket connection for client /127.0.0.1:53004 which had sessionid 0x151b7e8882a0002
2015-12-19 01:44:21,115 INFO zookeeper.ClientCnxn (ClientCnxn.java:run(1098)) - Unable to read additional data from server sessionid 0x151b7e8882a0002, likely server has closed socket, closing socket connection and attempting reconnect
2015-12-19 01:44:21,117 INFO server.NIOServerCnxnFactory (NIOServerCnxnFactory.java:run(224)) - NIOServerCnxn factory exited run method
2015-12-19 01:44:21,117 INFO server.ZooKeeperServer (ZooKeeperServer.java:shutdown(441)) - shutting down
2015-12-19 01:44:21,117 INFO server.ZooKeeperServer (ZooKeeperServer.java:shutdown(441)) - shutting down
2015-12-19 01:44:21,118 INFO server.SessionTrackerImpl (SessionTrackerImpl.java:shutdown(225)) - Shutting down
2015-12-19 01:44:21,118 INFO server.PrepRequestProcessor (PrepRequestProcessor.java:shutdown(761)) - Shutting down
2015-12-19 01:44:21,117 INFO server.SessionTrackerImpl (SessionTrackerImpl.java:shutdown(225)) - Shutting down
2015-12-19 01:44:21,118 INFO server.PrepRequestProcessor (PrepRequestProcessor.java:shutdown(761)) - Shutting down
2015-12-19 01:44:21,118 INFO server.PrepRequestProcessor (PrepRequestProcessor.java:run(143)) - PrepRequestProcessor exited loop!
2015-12-19 01:44:21,118 INFO server.SyncRequestProcessor (SyncRequestProcessor.java:shutdown(209)) - Shutting down
2015-12-19 01:44:21,118 INFO server.SyncRequestProcessor (SyncRequestProcessor.java:shutdown(209)) - Shutting down
2015-12-19 01:44:21,119 INFO server.SyncRequestProcessor (SyncRequestProcessor.java:run(187)) - SyncRequestProcessor exited!
2015-12-19 01:44:21,119 INFO server.FinalRequestProcessor (FinalRequestProcessor.java:shutdown(415)) - shutdown of request processor complete
2015-12-19 01:44:21,119 INFO server.FinalRequestProcessor (FinalRequestProcessor.java:shutdown(415)) - shutdown of request processor complete
{code}
> TestZKDelegationTokenSecretManager.testMultiNodeOperations failing
> ------------------------------------------------------------------
>
> Key: HADOOP-12660
> URL: https://issues.apache.org/jira/browse/HADOOP-12660
> Project: Hadoop Common
> Issue Type: Bug
> Components: ha, test
> Affects Versions: 3.0.0
> Environment: Jenkins Java8
> Reporter: Steve Loughran
>
> Test failure
> {code}
> java.lang.AssertionError: Expected InvalidToken
> at org.junit.Assert.fail(Assert.java:88)
> at org.apache.hadoop.security.token.delegation.TestZKDelegationTokenSecretManager.testMultiNodeOperations(TestZKDelegationTokenSecretManager.java:127)
> {code}
--
This message was sent by Atlassian JIRA
(v6.3.4#6332)