2017-02-08 02:23:12,274 INFO - [main:] ~ Loading atlas-application.properties from file:/home/hduser/atlas/distro/target/apache-atlas-0.8-incubating-SNAPSHOT-bin/apache-atlas-0.8-incubating-SNAPSHOT/conf/atlas-application.properties (ApplicationProperties:86) 2017-02-08 02:23:12,309 INFO - [main:] ~ Not running setup per configuration atlas.server.run.setup.on.start. (Atlas:134) 2017-02-08 02:23:12,309 INFO - [main:] ~ ######################################################################################## Atlas Server (STARTUP) project.name: apache-atlas project.description: Metadata Management and Data Governance Platform over Hadoop build.user: hduser build.epoch: 1486035797347 project.version: 0.8-incubating-SNAPSHOT build.version: 0.8-incubating-SNAPSHOT-rf640da72112cd2647b6dee5a5ac498b360a83ee3 vc.revision: f640da72112cd2647b6dee5a5ac498b360a83ee3 vc.source.url: scm:git:git://git.apache.org/incubator-atlas.git/atlas-webapp ######################################################################################## (Atlas:202) 2017-02-08 02:23:12,309 INFO - [main:] ~ >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> (Atlas:203) 2017-02-08 02:23:12,310 INFO - [main:] ~ Server starting with TLS ? false on port 21000 (Atlas:204) 2017-02-08 02:23:12,311 INFO - [main:] ~ <<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<< (Atlas:205) 2017-02-08 02:23:20,263 INFO - [main:] ~ Loading Guice modules (GuiceServletConfig:63) 2017-02-08 02:23:20,291 INFO - [main:] ~ No authentication method configured. Defaulting to simple authentication (LoginProcessor:102) 2017-02-08 02:23:20,513 INFO - [main:] ~ Logged in user hduser (auth:SIMPLE) (LoginProcessor:77) 2017-02-08 02:23:20,982 INFO - [main:] ~ Instantiated HBase compatibility layer supporting runtime HBase version 1.1.2: com.thinkaurelius.titan.diskstorage.hbase.HBaseCompat1_1 (HBaseCompatLoader:69) 2017-02-08 02:23:21,075 INFO - [main:] ~ Copied host list from root.storage.hostname to hbase.zookeeper.quorum: localhost (HBaseStoreManager:320) 2017-02-08 02:23:22,956 INFO - [main:] ~ Loaded 1.x Hbase Client Store Manager (HBaseStoreManager:478) 2017-02-08 02:23:23,181 INFO - [main:] ~ Loaded and initialized config classes: 8 OK out of 12 attempts in Duration[20 ms] (ReflectiveConfigOptionLoader:158) 2017-02-08 02:23:29,596 WARN - [main:] ~ could not create Dir using directory from url file:/usr/lib/jvm/java-7-openjdk-amd64/jre/lib/ext/libatk-wrapper.so. skipping. (Vfs:104) java.lang.RuntimeException: cannot use dir /usr/lib/jvm/java-7-openjdk-amd64/jre/lib/ext/libatk-wrapper.so at org.reflections.vfs.SystemDir.(SystemDir.java:20) at org.reflections.vfs.Vfs$DefaultUrlTypes$3.createDir(Vfs.java:237) at org.reflections.vfs.Vfs.fromURL(Vfs.java:99) at org.reflections.vfs.Vfs.fromURL(Vfs.java:91) at org.reflections.Reflections.scan(Reflections.java:231) at org.reflections.Reflections.scan(Reflections.java:204) at org.reflections.Reflections.(Reflections.java:129) at com.thinkaurelius.titan.core.util.ReflectiveConfigOptionLoader.loadAllClassesUnsafe(ReflectiveConfigOptionLoader.java:222) at com.thinkaurelius.titan.core.util.ReflectiveConfigOptionLoader.load(ReflectiveConfigOptionLoader.java:194) at com.thinkaurelius.titan.core.util.ReflectiveConfigOptionLoader.loadAll(ReflectiveConfigOptionLoader.java:86) at com.thinkaurelius.titan.diskstorage.configuration.ConfigNamespace.getChild(ConfigNamespace.java:71) at com.thinkaurelius.titan.diskstorage.configuration.ConfigElement.parse(ConfigElement.java:169) at com.thinkaurelius.titan.diskstorage.configuration.BasicConfiguration.getAll(BasicConfiguration.java:80) at com.thinkaurelius.titan.graphdb.configuration.GraphDatabaseConfiguration.(GraphDatabaseConfiguration.java:1344) at com.thinkaurelius.titan.core.TitanFactory.open(TitanFactory.java:93) at com.thinkaurelius.titan.core.TitanFactory.open(TitanFactory.java:73) at org.apache.atlas.repository.graphdb.titan0.Titan0GraphDatabase.getGraphInstance(Titan0GraphDatabase.java:115) at org.apache.atlas.repository.graphdb.titan0.Titan0GraphDatabase.getGraph(Titan0GraphDatabase.java:171) at org.apache.atlas.repository.graph.AtlasGraphProvider.getGraphInstance(AtlasGraphProvider.java:38) at org.apache.atlas.repository.graph.GraphHelper.getInstance(GraphHelper.java:111) at org.apache.atlas.repository.graph.DeleteHandler.(DeleteHandler.java:54) at java.lang.Class.forName0(Native Method) at java.lang.Class.forName(Class.java:195) at org.apache.atlas.ApplicationProperties.getClass(ApplicationProperties.java:115) at org.apache.atlas.util.AtlasRepositoryConfiguration.getDeleteHandlerImpl(AtlasRepositoryConfiguration.java:89) at org.apache.atlas.RepositoryMetadataModule.configure(RepositoryMetadataModule.java:116) at com.google.inject.AbstractModule.configure(AbstractModule.java:62) at com.google.inject.spi.Elements$RecordingBinder.install(Elements.java:340) at com.google.inject.spi.Elements.getElements(Elements.java:110) at com.google.inject.internal.InjectorShell$Builder.build(InjectorShell.java:138) at com.google.inject.internal.InternalInjectorCreator.build(InternalInjectorCreator.java:104) at com.google.inject.Guice.createInjector(Guice.java:99) at com.google.inject.Guice.createInjector(Guice.java:84) at org.apache.atlas.web.listeners.GuiceServletConfig.getInjector(GuiceServletConfig.java:76) at com.google.inject.servlet.GuiceServletContextListener.contextInitialized(GuiceServletContextListener.java:47) at org.apache.atlas.web.listeners.GuiceServletConfig.contextInitialized(GuiceServletConfig.java:140) at org.eclipse.jetty.server.handler.ContextHandler.callContextInitialized(ContextHandler.java:800) at org.eclipse.jetty.servlet.ServletContextHandler.callContextInitialized(ServletContextHandler.java:444) at org.eclipse.jetty.server.handler.ContextHandler.startContext(ContextHandler.java:791) at org.eclipse.jetty.servlet.ServletContextHandler.startContext(ServletContextHandler.java:294) at org.eclipse.jetty.webapp.WebAppContext.startWebapp(WebAppContext.java:1349) at org.eclipse.jetty.webapp.WebAppContext.startContext(WebAppContext.java:1342) at org.eclipse.jetty.server.handler.ContextHandler.doStart(ContextHandler.java:741) at org.eclipse.jetty.webapp.WebAppContext.doStart(WebAppContext.java:505) at org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:68) at org.eclipse.jetty.util.component.ContainerLifeCycle.start(ContainerLifeCycle.java:132) at org.eclipse.jetty.server.Server.start(Server.java:387) at org.eclipse.jetty.util.component.ContainerLifeCycle.doStart(ContainerLifeCycle.java:114) at org.eclipse.jetty.server.handler.AbstractHandler.doStart(AbstractHandler.java:61) at org.eclipse.jetty.server.Server.doStart(Server.java:354) at org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:68) at org.apache.atlas.web.service.EmbeddedServer.start(EmbeddedServer.java:92) at org.apache.atlas.Atlas.main(Atlas.java:118) 2017-02-08 02:23:29,599 WARN - [main:] ~ could not create Vfs.Dir from url. ignoring the exception and continuing (Reflections:208) org.reflections.ReflectionsException: could not create Vfs.Dir from url, no matching UrlType was found [file:/usr/lib/jvm/java-7-openjdk-amd64/jre/lib/ext/libatk-wrapper.so] either use fromURL(final URL url, final List urlTypes) or use the static setDefaultURLTypes(final List urlTypes) or addDefaultURLTypes(UrlType urlType) with your specialized UrlType. at org.reflections.vfs.Vfs.fromURL(Vfs.java:109) at org.reflections.vfs.Vfs.fromURL(Vfs.java:91) at org.reflections.Reflections.scan(Reflections.java:231) at org.reflections.Reflections.scan(Reflections.java:204) at org.reflections.Reflections.(Reflections.java:129) at com.thinkaurelius.titan.core.util.ReflectiveConfigOptionLoader.loadAllClassesUnsafe(ReflectiveConfigOptionLoader.java:222) at com.thinkaurelius.titan.core.util.ReflectiveConfigOptionLoader.load(ReflectiveConfigOptionLoader.java:194) at com.thinkaurelius.titan.core.util.ReflectiveConfigOptionLoader.loadAll(ReflectiveConfigOptionLoader.java:86) at com.thinkaurelius.titan.diskstorage.configuration.ConfigNamespace.getChild(ConfigNamespace.java:71) at com.thinkaurelius.titan.diskstorage.configuration.ConfigElement.parse(ConfigElement.java:169) at com.thinkaurelius.titan.diskstorage.configuration.BasicConfiguration.getAll(BasicConfiguration.java:80) at com.thinkaurelius.titan.graphdb.configuration.GraphDatabaseConfiguration.(GraphDatabaseConfiguration.java:1344) at com.thinkaurelius.titan.core.TitanFactory.open(TitanFactory.java:93) at com.thinkaurelius.titan.core.TitanFactory.open(TitanFactory.java:73) at org.apache.atlas.repository.graphdb.titan0.Titan0GraphDatabase.getGraphInstance(Titan0GraphDatabase.java:115) at org.apache.atlas.repository.graphdb.titan0.Titan0GraphDatabase.getGraph(Titan0GraphDatabase.java:171) at org.apache.atlas.repository.graph.AtlasGraphProvider.getGraphInstance(AtlasGraphProvider.java:38) at org.apache.atlas.repository.graph.GraphHelper.getInstance(GraphHelper.java:111) at org.apache.atlas.repository.graph.DeleteHandler.(DeleteHandler.java:54) at java.lang.Class.forName0(Native Method) at java.lang.Class.forName(Class.java:195) at org.apache.atlas.ApplicationProperties.getClass(ApplicationProperties.java:115) at org.apache.atlas.util.AtlasRepositoryConfiguration.getDeleteHandlerImpl(AtlasRepositoryConfiguration.java:89) at org.apache.atlas.RepositoryMetadataModule.configure(RepositoryMetadataModule.java:116) at com.google.inject.AbstractModule.configure(AbstractModule.java:62) at com.google.inject.spi.Elements$RecordingBinder.install(Elements.java:340) at com.google.inject.spi.Elements.getElements(Elements.java:110) at com.google.inject.internal.InjectorShell$Builder.build(InjectorShell.java:138) at com.google.inject.internal.InternalInjectorCreator.build(InternalInjectorCreator.java:104) at com.google.inject.Guice.createInjector(Guice.java:99) at com.google.inject.Guice.createInjector(Guice.java:84) at org.apache.atlas.web.listeners.GuiceServletConfig.getInjector(GuiceServletConfig.java:76) at com.google.inject.servlet.GuiceServletContextListener.contextInitialized(GuiceServletContextListener.java:47) at org.apache.atlas.web.listeners.GuiceServletConfig.contextInitialized(GuiceServletConfig.java:140) at org.eclipse.jetty.server.handler.ContextHandler.callContextInitialized(ContextHandler.java:800) at org.eclipse.jetty.servlet.ServletContextHandler.callContextInitialized(ServletContextHandler.java:444) at org.eclipse.jetty.server.handler.ContextHandler.startContext(ContextHandler.java:791) at org.eclipse.jetty.servlet.ServletContextHandler.startContext(ServletContextHandler.java:294) at org.eclipse.jetty.webapp.WebAppContext.startWebapp(WebAppContext.java:1349) at org.eclipse.jetty.webapp.WebAppContext.startContext(WebAppContext.java:1342) at org.eclipse.jetty.server.handler.ContextHandler.doStart(ContextHandler.java:741) at org.eclipse.jetty.webapp.WebAppContext.doStart(WebAppContext.java:505) at org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:68) at org.eclipse.jetty.util.component.ContainerLifeCycle.start(ContainerLifeCycle.java:132) at org.eclipse.jetty.server.Server.start(Server.java:387) at org.eclipse.jetty.util.component.ContainerLifeCycle.doStart(ContainerLifeCycle.java:114) at org.eclipse.jetty.server.handler.AbstractHandler.doStart(AbstractHandler.java:61) at org.eclipse.jetty.server.Server.doStart(Server.java:354) at org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:68) at org.apache.atlas.web.service.EmbeddedServer.start(EmbeddedServer.java:92) at org.apache.atlas.Atlas.main(Atlas.java:118) 2017-02-08 02:23:29,838 INFO - [main:] ~ Generated unique-instance-id=7f0001013168-ubuntu1 (GraphDatabaseConfiguration:1469) 2017-02-08 02:23:29,875 INFO - [main:] ~ Copied host list from root.storage.hostname to hbase.zookeeper.quorum: localhost (HBaseStoreManager:320) 2017-02-08 02:23:29,887 INFO - [main:] ~ Configuring index [search] (Backend:407) 2017-02-08 02:23:29,921 INFO - [main:] ~ Zookeeper connect timeout : 60000 (Solr5Index:222) 2017-02-08 02:23:29,922 INFO - [main:] ~ Zookeeper session timeout : 60000 (Solr5Index:225) 2017-02-08 02:23:29,958 INFO - [main:] ~ Initiated backend operations thread pool of size 2 (Backend:168) 2017-02-08 02:23:29,975 INFO - [main:] ~ Loaded 1.x Hbase Client Store Manager (HBaseStoreManager:478) 2017-02-08 02:23:29,993 INFO - [main:] ~ Loaded 1.x Hbase Client Store Manager (HBaseStoreManager:478) 2017-02-08 02:23:30,001 INFO - [main:] ~ Loaded 1.x Hbase Client Store Manager (HBaseStoreManager:478) 2017-02-08 02:23:30,013 INFO - [main:] ~ Loaded 1.x Hbase Client Store Manager (HBaseStoreManager:478) 2017-02-08 02:23:30,047 INFO - [main:] ~ Loaded 1.x Hbase Client Store Manager (HBaseStoreManager:478) 2017-02-08 02:23:30,057 INFO - [main:] ~ Loaded 1.x Hbase Client Store Manager (HBaseStoreManager:478) 2017-02-08 02:23:30,072 INFO - [main:] ~ Hashing index keys (IndexSerializer:71) 2017-02-08 02:23:30,129 INFO - [main:] ~ Loaded unidentified ReadMarker start time Timepoint[1486549410129000 μs] into com.thinkaurelius.titan.diskstorage.log.kcvs.KCVSLog$MessagePuller@7863a1c2 (KCVSLog$MessagePuller:733) 2017-02-08 02:23:31,652 INFO - [main:] ~ HA configuration is disabled, not activating ActiveServerFilter (GuiceServletConfig$1:120) 2017-02-08 02:23:31,652 INFO - [main:] ~ Jersey loading from packages: org.apache.atlas.web.resources,org.apache.atlas.web.params,org.apache.atlas.web.rest,org.apache.atlas.web.errors (GuiceServletConfig$1:105) 2017-02-08 02:23:32,365 INFO - [main:] ~ Global indexes already exist for graph (GraphBackedSearchIndexer:141) 2017-02-08 02:23:32,374 INFO - [main:] ~ Restoring type system from the store (DefaultMetadataService:156) 2017-02-08 02:23:32,474 INFO - [main:] ~ Restoring type ENUM.file_action.file_action (GraphBackedTypeStore:243) 2017-02-08 02:23:32,636 INFO - [main:] ~ Restoring type CLASS.storm_bolt.storm_bolt (GraphBackedTypeStore:243) 2017-02-08 02:23:32,686 INFO - [main:] ~ Restoring type CLASS.hive_db.hive_db (GraphBackedTypeStore:243) 2017-02-08 02:23:32,720 INFO - [main:] ~ Restoring type CLASS.Asset.Asset (GraphBackedTypeStore:243) 2017-02-08 02:23:32,743 INFO - [main:] ~ Restoring type CLASS.kafka_topic.kafka_topic (GraphBackedTypeStore:243) 2017-02-08 02:23:32,762 INFO - [main:] ~ Restoring type CLASS.storm_topology.storm_topology (GraphBackedTypeStore:243) 2017-02-08 02:23:32,797 INFO - [main:] ~ Restoring type STRUCT.fs_permissions.fs_permissions (GraphBackedTypeStore:243) 2017-02-08 02:23:32,823 INFO - [main:] ~ Restoring type CLASS.falcon_feed_replication.falcon_feed_replication (GraphBackedTypeStore:243) 2017-02-08 02:23:32,830 INFO - [main:] ~ Restoring type CLASS.jms_topic.jms_topic (GraphBackedTypeStore:243) 2017-02-08 02:23:32,846 INFO - [main:] ~ Restoring type CLASS.Referenceable.Referenceable (GraphBackedTypeStore:243) 2017-02-08 02:23:32,858 INFO - [main:] ~ Restoring type CLASS.sqoop_process.sqoop_process (GraphBackedTypeStore:243) 2017-02-08 02:23:32,887 INFO - [main:] ~ Restoring type CLASS.hdfs_path.hdfs_path (GraphBackedTypeStore:243) 2017-02-08 02:23:32,918 INFO - [main:] ~ Restoring type CLASS.hbase_column.hbase_column (GraphBackedTypeStore:243) 2017-02-08 02:23:32,934 INFO - [main:] ~ Restoring type CLASS.falcon_feed_creation.falcon_feed_creation (GraphBackedTypeStore:243) 2017-02-08 02:23:32,948 INFO - [main:] ~ Restoring type STRUCT.hive_order.hive_order (GraphBackedTypeStore:243) 2017-02-08 02:23:32,966 INFO - [main:] ~ Restoring type CLASS.Infrastructure.Infrastructure (GraphBackedTypeStore:243) 2017-02-08 02:23:32,971 INFO - [main:] ~ Restoring type CLASS.storm_spout.storm_spout (GraphBackedTypeStore:243) 2017-02-08 02:23:32,986 INFO - [main:] ~ Restoring type CLASS.hbase_table.hbase_table (GraphBackedTypeStore:243) 2017-02-08 02:23:32,998 INFO - [main:] ~ Restoring type CLASS.Process.Process (GraphBackedTypeStore:243) 2017-02-08 02:23:33,017 INFO - [main:] ~ Restoring type CLASS.hive_table.hive_table (GraphBackedTypeStore:243) 2017-02-08 02:23:33,101 INFO - [main:] ~ Restoring type CLASS.falcon_feed.falcon_feed (GraphBackedTypeStore:243) 2017-02-08 02:23:33,131 INFO - [main:] ~ Restoring type CLASS.hive_column.hive_column (GraphBackedTypeStore:243) 2017-02-08 02:23:33,159 INFO - [main:] ~ Restoring type STRUCT.hive_serde.hive_serde (GraphBackedTypeStore:243) 2017-02-08 02:23:33,187 INFO - [main:] ~ Restoring type CLASS.sqoop_dbdatastore.sqoop_dbdatastore (GraphBackedTypeStore:243) 2017-02-08 02:23:33,234 INFO - [main:] ~ Restoring type CLASS.hive_process.hive_process (GraphBackedTypeStore:243) 2017-02-08 02:23:33,337 INFO - [main:] ~ Restoring type CLASS.DataSet.DataSet (GraphBackedTypeStore:243) 2017-02-08 02:23:33,349 INFO - [main:] ~ Restoring type CLASS.hbase_column_family.hbase_column_family (GraphBackedTypeStore:243) 2017-02-08 02:23:33,374 INFO - [main:] ~ Restoring type ENUM.hive_principal_type.hive_principal_type (GraphBackedTypeStore:243) 2017-02-08 02:23:33,418 INFO - [main:] ~ Restoring type CLASS.storm_node.storm_node (GraphBackedTypeStore:243) 2017-02-08 02:23:33,456 INFO - [main:] ~ Restoring type CLASS.fs_path.fs_path (GraphBackedTypeStore:243) 2017-02-08 02:23:33,503 INFO - [main:] ~ Restoring type CLASS.hive_column_lineage.hive_column_lineage (GraphBackedTypeStore:243) 2017-02-08 02:23:33,543 INFO - [main:] ~ Restoring type CLASS.falcon_process.falcon_process (GraphBackedTypeStore:243) 2017-02-08 02:23:33,570 INFO - [main:] ~ Restoring type CLASS.hive_storagedesc.hive_storagedesc (GraphBackedTypeStore:243) 2017-02-08 02:23:33,650 INFO - [main:] ~ Restoring type CLASS.falcon_cluster.falcon_cluster (GraphBackedTypeStore:243) 2017-02-08 02:23:33,687 INFO - [main:] ~ Number of types got from transient type system: 34 (DefaultMetadataService:169) 2017-02-08 02:23:33,688 INFO - [main:] ~ Restored type system from the store (DefaultMetadataService:162) 2017-02-08 02:23:33,691 INFO - [main:] ~ Global indexes already exist for graph (GraphBackedSearchIndexer:141) 2017-02-08 02:23:35,607 INFO - [main:] ~ No new type in file /home/hduser/atlas/distro/target/apache-atlas-0.8-incubating-SNAPSHOT-bin/apache-atlas-0.8-incubating-SNAPSHOT/models/0010-base_model.json (AtlasTypeDefStoreInitializer:124) 2017-02-08 02:23:35,624 INFO - [main:] ~ No new type in file /home/hduser/atlas/distro/target/apache-atlas-0.8-incubating-SNAPSHOT-bin/apache-atlas-0.8-incubating-SNAPSHOT/models/0020-fs_model.json (AtlasTypeDefStoreInitializer:124) 2017-02-08 02:23:35,628 INFO - [main:] ~ No new type in file /home/hduser/atlas/distro/target/apache-atlas-0.8-incubating-SNAPSHOT-bin/apache-atlas-0.8-incubating-SNAPSHOT/models/0030-hive_model.json (AtlasTypeDefStoreInitializer:124) 2017-02-08 02:23:35,630 INFO - [main:] ~ No new type in file /home/hduser/atlas/distro/target/apache-atlas-0.8-incubating-SNAPSHOT-bin/apache-atlas-0.8-incubating-SNAPSHOT/models/0040-sqoop_model.json (AtlasTypeDefStoreInitializer:124) 2017-02-08 02:23:35,634 INFO - [main:] ~ No new type in file /home/hduser/atlas/distro/target/apache-atlas-0.8-incubating-SNAPSHOT-bin/apache-atlas-0.8-incubating-SNAPSHOT/models/0050-falcon_model.json (AtlasTypeDefStoreInitializer:124) 2017-02-08 02:23:35,639 INFO - [main:] ~ No new type in file /home/hduser/atlas/distro/target/apache-atlas-0.8-incubating-SNAPSHOT-bin/apache-atlas-0.8-incubating-SNAPSHOT/models/0060-hbase_model.json (AtlasTypeDefStoreInitializer:124) 2017-02-08 02:23:35,640 INFO - [main:] ~ No new type in file /home/hduser/atlas/distro/target/apache-atlas-0.8-incubating-SNAPSHOT-bin/apache-atlas-0.8-incubating-SNAPSHOT/models/0070-kafka_model.json (AtlasTypeDefStoreInitializer:124) 2017-02-08 02:23:35,646 INFO - [main:] ~ No new type in file /home/hduser/atlas/distro/target/apache-atlas-0.8-incubating-SNAPSHOT-bin/apache-atlas-0.8-incubating-SNAPSHOT/models/0080-storm_model.json (AtlasTypeDefStoreInitializer:124) 2017-02-08 02:23:35,652 INFO - [main:] ~ Applying patches in file /home/hduser/atlas/distro/target/apache-atlas-0.8-incubating-SNAPSHOT-bin/apache-atlas-0.8-incubating-SNAPSHOT/models/patches/001-hive_column_add_position.json (AtlasTypeDefStoreInitializer:172) 2017-02-08 02:23:35,662 INFO - [main:] ~ patch skipped: typeName=hive_column; applyToVersion=1.0; updateToVersion=1.1 (AtlasTypeDefStoreInitializer$AddAttributePatchHandler:372) 2017-02-08 02:23:35,663 INFO - [main:] ~ Applying patches in file /home/hduser/atlas/distro/target/apache-atlas-0.8-incubating-SNAPSHOT-bin/apache-atlas-0.8-incubating-SNAPSHOT/models/patches/002-hive_column_table_add_options.json (AtlasTypeDefStoreInitializer:172) 2017-02-08 02:23:35,666 INFO - [main:] ~ patch skipped: typeName=hive_column; applyToVersion=1.1; updateToVersion=1.2 (AtlasTypeDefStoreInitializer$UpdateTypeDefOptionsPatchHandler:446) 2017-02-08 02:23:35,667 INFO - [main:] ~ patch skipped: typeName=hive_table; applyToVersion=1.0; updateToVersion=1.1 (AtlasTypeDefStoreInitializer$UpdateTypeDefOptionsPatchHandler:446) 2017-02-08 02:23:35,709 WARN - [main-SendThread(localhost:9026):] ~ Session 0x0 for server null, unexpected error, closing socket connection and attempting reconnect (ClientCnxn$SendThread:1102) java.net.ConnectException: Connection refused at sun.nio.ch.SocketChannelImpl.checkConnect(Native Method) at sun.nio.ch.SocketChannelImpl.finishConnect(SocketChannelImpl.java:744) at org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:361) at org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1081) 2017-02-08 02:23:35,723 INFO - [main:] ~ Guice modules loaded (GuiceServletConfig:128) 2017-02-08 02:23:35,728 INFO - [main:] ~ Starting services (GuiceServletConfig:148) 2017-02-08 02:23:35,740 INFO - [main:] ~ Starting service org.apache.atlas.repository.audit.HBaseBasedAuditRepository (Services:44) 2017-02-08 02:23:35,779 INFO - [main:] ~ HA is disabled. Hence creating table on startup. (HBaseBasedAuditRepository:378) 2017-02-08 02:23:35,780 INFO - [main:] ~ Checking if table apache_atlas_entity_audit exists (HBaseBasedAuditRepository:337) 2017-02-08 02:23:35,789 INFO - [main:] ~ Table apache_atlas_entity_audit exists (HBaseBasedAuditRepository:349) 2017-02-08 02:23:35,789 INFO - [main:] ~ Starting service org.apache.atlas.web.service.ActiveInstanceElectorService (Services:44) 2017-02-08 02:23:35,789 INFO - [main:] ~ HA is not enabled, no need to start leader election service (ActiveInstanceElectorService:101) 2017-02-08 02:23:35,789 INFO - [main:] ~ Starting service org.apache.atlas.kafka.KafkaNotification (Services:44) 2017-02-08 02:23:36,973 INFO - [main:] ~ Starting service org.apache.atlas.notification.NotificationHookConsumer (Services:44) 2017-02-08 02:23:36,973 INFO - [main:] ~ HA is disabled, starting consumers inline. (NotificationHookConsumer:96) 2017-02-08 02:23:36,973 INFO - [main:] ~ Consumer property: auto.commit.enable: false (KafkaNotification:297) 2017-02-08 02:23:36,981 WARN - [main:] ~ Property bootstrap.servers is not valid (Logging$class:83) 2017-02-08 02:23:36,981 WARN - [main:] ~ Property broker.id is not valid (Logging$class:83) 2017-02-08 02:23:36,981 WARN - [main:] ~ Property data is not valid (Logging$class:83) 2017-02-08 02:23:36,982 WARN - [main:] ~ Property hook.group.id is not valid (Logging$class:83) 2017-02-08 02:23:36,982 WARN - [main:] ~ Property host.name is not valid (Logging$class:83) 2017-02-08 02:23:36,982 WARN - [main:] ~ Property key.deserializer is not valid (Logging$class:83) 2017-02-08 02:23:36,982 WARN - [main:] ~ Property key.serializer is not valid (Logging$class:83) 2017-02-08 02:23:36,982 WARN - [main:] ~ Property log.dirs is not valid (Logging$class:83) 2017-02-08 02:23:36,983 WARN - [main:] ~ Property log.flush.interval.messages is not valid (Logging$class:83) 2017-02-08 02:23:36,983 WARN - [main:] ~ Property port is not valid (Logging$class:83) 2017-02-08 02:23:36,983 WARN - [main:] ~ Property value.deserializer is not valid (Logging$class:83) 2017-02-08 02:23:36,983 WARN - [main:] ~ Property value.serializer is not valid (Logging$class:83) 2017-02-08 02:23:37,511 INFO - [NotificationHookConsumer thread-0:] ~ Atlas Server is ready, can start reading Kafka events. (NotificationHookConsumer$HookConsumer:305) 2017-02-08 02:23:40,295 INFO - [main:] ~ AtlasAuthenticationFilter initialization started (AtlasAuthenticationFilter:92) 2017-02-08 02:23:40,295 INFO - [main:] ~ AtlasAuthenticationFilter initialization started (AtlasAuthenticationFilter:109) 2017-02-08 02:23:40,299 INFO - [main:] ~ No authentication method configured. Defaulting to simple authentication (AtlasAuthenticationFilter:188) 2017-02-08 02:23:40,300 INFO - [main:] ~ No host name configured. Defaulting to local host name. (AtlasAuthenticationFilter:216) 2017-02-08 02:23:40,334 INFO - [main:] ~ Configuration obtained :: org.apache.atlas.ApplicationProperties@3d776cf3 (AtlasCSRFPreventionFilter:52) 2017-02-08 02:23:40,334 INFO - [main:] ~ Adding cross-site request forgery (CSRF) protection (AtlasCSRFPreventionFilter:98) 2017-02-08 02:23:41,473 INFO - [main:] ~ AuditFilter initialization started (AuditFilter:59) 2017-02-08 02:23:46,419 WARN - [NIOServerCxn.Factory:localhost/127.0.0.1:9026:] ~ caught end of stream exception (NIOServerCnxn:357) EndOfStreamException: Unable to read additional data from client sessionid 0x15a1d3ff7990000, likely client has closed socket at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228) at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208) at java.lang.Thread.run(Thread.java:745) 2017-02-08 02:33:36,253 INFO - [Thread-0:] ~ ==> Shutdown of Atlas (Atlas$1:60) 2017-02-08 02:33:36,273 INFO - [Thread-0:] ~ Starting servlet context destroy (GuiceServletConfig:167) 2017-02-08 02:33:36,273 INFO - [Thread-0:] ~ Stopping services (GuiceServletConfig:184) 2017-02-08 02:33:36,273 INFO - [Thread-0:] ~ Stopping service org.apache.atlas.repository.audit.HBaseBasedAuditRepository (Services:54) 2017-02-08 02:33:36,277 INFO - [Thread-0:] ~ Stopping service org.apache.atlas.web.service.ActiveInstanceElectorService (Services:54) 2017-02-08 02:33:36,278 INFO - [Thread-0:] ~ HA is not enabled, no need to stop leader election service (ActiveInstanceElectorService:131) 2017-02-08 02:33:36,278 INFO - [Thread-0:] ~ Stopping service org.apache.atlas.kafka.KafkaNotification (Services:54) 2017-02-08 02:33:38,682 INFO - [Thread-0:] ~ Stopping service org.apache.atlas.notification.NotificationHookConsumer (Services:54) 2017-02-08 02:33:38,786 WARN - [Thread-0:] ~ Failed to remove shutdown hook (StandardTitanGraph:194) java.lang.IllegalStateException: Shutdown in progress at java.lang.ApplicationShutdownHooks.remove(ApplicationShutdownHooks.java:82) at java.lang.Runtime.removeShutdownHook(Runtime.java:239) at com.thinkaurelius.titan.graphdb.database.StandardTitanGraph.removeHook(StandardTitanGraph.java:192) at com.thinkaurelius.titan.graphdb.database.StandardTitanGraph.shutdown(StandardTitanGraph.java:160) at org.apache.atlas.repository.graphdb.titan0.Titan0Graph.shutdown(Titan0Graph.java:172) at org.apache.atlas.web.listeners.GuiceServletConfig.contextDestroyed(GuiceServletConfig.java:175) at org.eclipse.jetty.server.handler.ContextHandler.callContextDestroyed(ContextHandler.java:808) at org.eclipse.jetty.servlet.ServletContextHandler.callContextDestroyed(ServletContextHandler.java:457) at org.eclipse.jetty.server.handler.ContextHandler.doStop(ContextHandler.java:842) at org.eclipse.jetty.servlet.ServletContextHandler.doStop(ServletContextHandler.java:215) at org.eclipse.jetty.webapp.WebAppContext.doStop(WebAppContext.java:529) at org.eclipse.jetty.util.component.AbstractLifeCycle.stop(AbstractLifeCycle.java:89) at org.eclipse.jetty.util.component.ContainerLifeCycle.stop(ContainerLifeCycle.java:143) at org.eclipse.jetty.util.component.ContainerLifeCycle.doStop(ContainerLifeCycle.java:162) at org.eclipse.jetty.server.handler.AbstractHandler.doStop(AbstractHandler.java:73) at org.eclipse.jetty.server.Server.doStop(Server.java:456) at org.eclipse.jetty.util.component.AbstractLifeCycle.stop(AbstractLifeCycle.java:89) at org.apache.atlas.web.service.EmbeddedServer.stop(EmbeddedServer.java:98) at org.apache.atlas.Atlas.shutdown(Atlas.java:73) at org.apache.atlas.Atlas.access$100(Atlas.java:42) at org.apache.atlas.Atlas$1.run(Atlas.java:62) at org.apache.hadoop.util.ShutdownHookManager$1.run(ShutdownHookManager.java:54) 2017-02-08 02:46:15,622 INFO - [main:] ~ Loading atlas-application.properties from file:/home/hduser/atlas/distro/target/apache-atlas-0.8-incubating-SNAPSHOT-bin/apache-atlas-0.8-incubating-SNAPSHOT/conf/atlas-application.properties (ApplicationProperties:86) 2017-02-08 02:46:15,670 INFO - [main:] ~ Not running setup per configuration atlas.server.run.setup.on.start. (Atlas:134) 2017-02-08 02:46:15,671 INFO - [main:] ~