Skip to content

Instantly share code, notes, and snippets.

@elmiko
Created May 1, 2014 19:04
Show Gist options
  • Star 0 You must be signed in to star a gist
  • Fork 0 You must be signed in to fork a gist
  • Save elmiko/b34a526b76bd764f5b3d to your computer and use it in GitHub Desktop.
Save elmiko/b34a526b76bd764f5b3d to your computer and use it in GitHub Desktop.
2014-05-01 ambari-server.log
18:23:13,979 INFO [main] Configuration:344 - Generation of file with password
18:23:15,668 INFO [main] Configuration:547 - Hosts Mapping File null
18:23:15,674 INFO [main] HostsMap:60 - Using hostsmap file null
18:24:06,988 INFO [main] AmbariServer:521 - Getting the controller
18:25:04,362 INFO [main] StackExtensionHelper:358 - No services defined for stack: HDP-1.3.3
18:25:30,952 INFO [Stack Version Loading Thread] LatestRepoCallable:73 - Loading latest URL info from http://public-repo-1.hortonworks.com/HDP/hdp_urlinfo.json
18:25:31,135 ERROR [Stack Version Loading Thread] LatestRepoCallable:90 - Could not load the URI http://public-repo-1.hortonworks.com/HDP/hdp_urlinfo.json (public-repo-1.hortonworks.com)
18:25:31,218 INFO [main] ActionDefinitionManager:124 - Added custom action definition for ambari_hdfs_rebalancer
18:25:31,221 INFO [main] ActionDefinitionManager:124 - Added custom action definition for nagios_update_ignore
18:25:31,225 INFO [main] CertificateManager:69 - Initialization of root certificate
18:25:31,228 INFO [main] CertificateManager:71 - Certificate exists:false
18:25:31,230 INFO [main] CertificateManager:138 - Generation of server certificate
18:25:32,740 INFO [main] ShellCommandUtil:44 - Command openssl genrsa -des3 -passout pass:**** -out /var/lib/ambari-server/keys/ca.key 4096 was finished with exit code: 0 - the operation was completely successfully.
18:25:33,412 INFO [main] ShellCommandUtil:44 - Command openssl req -passin pass:**** -new -key /var/lib/ambari-server/keys/ca.key -out /var/lib/ambari-server/keys/ca.csr -batch was finished with exit code: 0 - the operation was completely successfully.
18:25:34,285 INFO [main] ShellCommandUtil:44 - Command open**** ca -create_serial -out /var/lib/ambari-server/keys/ca.crt -days 365 -keyfile /var/lib/ambari-server/keys/ca.key -key PKAlCNtk76MwY6WR2ls728h8FgKySGnLI1b6eykjrxWK3nejpt -selfsign -extensions jdk7_ca -config /var/lib/ambari-server/keys/ca.config -batch -infiles /var/lib/ambari-server/keys/ca.csr was finished with exit code: 0 - the operation was completely successfully.
18:25:34,947 INFO [main] ShellCommandUtil:44 - Command openssl pkcs12 -export -in /var/lib/ambari-server/keys/ca.crt -inkey /var/lib/ambari-server/keys/ca.key -certfile /var/lib/ambari-server/keys/ca.crt -out /var/lib/ambari-server/keys/keystore.p12 -password pass:**** -passin pass:****
was finished with exit code: 0 - the operation was completely successfully.
18:25:41,290 INFO [main] Configuration:436 - Credential provider creation failed. Reason: Master key initialization failed.
18:25:52,105 INFO [main] StackExtensionHelper:358 - No services defined for stack: HDP-1.3.3
18:25:56,456 INFO [Stack Version Loading Thread] LatestRepoCallable:73 - Loading latest URL info from http://public-repo-1.hortonworks.com/HDP/hdp_urlinfo.json
18:25:56,472 ERROR [Stack Version Loading Thread] LatestRepoCallable:90 - Could not load the URI http://public-repo-1.hortonworks.com/HDP/hdp_urlinfo.json (public-repo-1.hortonworks.com)
18:25:56,512 WARN [main] ActionDefinitionManager:117 - Ignoring action definition as a different definition by that name already exists. ActionDefinition: actionName: ambari_hdfs_rebalancer actionType: SYSTEM inputs: threshold,[principal],[keytab] description: HDFS Rebalance targetService: HDFS targetComponent: NAMENODE defaultTimeout: 600 targetType: ANY
18:25:56,516 WARN [main] ActionDefinitionManager:117 - Ignoring action definition as a different definition by that name already exists. ActionDefinition: actionName: nagios_update_ignore actionType: SYSTEM inputs: [nagios_ignore] description: Used to create an alert blackout targetService: NAGIOS targetComponent: NAGIOS_SERVER defaultTimeout: 60 targetType: ANY
18:25:56,519 INFO [main] AmbariServer:142 - ********* Meta Info initialized **********
18:25:56,669 INFO [main] ClustersImpl:103 - Initializing the ClustersImpl
18:26:06,546 INFO [main] AmbariManagementControllerImpl:225 - Initializing the AmbariManagementControllerImpl
18:26:09,732 INFO [main] AmbariServer:463 - Checking DB store version
18:26:09,799 INFO [main] AmbariServer:482 - DB store version is compatible
18:26:10,256 INFO [main] ClassPathXmlApplicationContext:456 - Refreshing org.springframework.context.support.ClassPathXmlApplicationContext@2ada52a1: startup date [Thu May 01 18:26:10 GMT 2014]; root of context hierarchy
18:26:11,039 INFO [main] DefaultListableBeanFactory:557 - Pre-instantiating singletons in org.springframework.beans.factory.support.DefaultListableBeanFactory@c4be179: defining beans []; root of factory hierarchy
18:26:11,181 INFO [main] ClassPathXmlApplicationContext:456 - Refreshing org.springframework.context.support.ClassPathXmlApplicationContext@6fbae5f5: startup date [Thu May 01 18:26:11 GMT 2014]; parent: org.springframework.context.support.ClassPathXmlApplicationContext@2ada52a1
18:26:11,226 INFO [main] XmlBeanDefinitionReader:315 - Loading XML bean definitions from class path resource [webapp/WEB-INF/spring-security.xml]
18:26:13,953 INFO [main] SpringSecurityCoreVersion:33 - You are running with Spring Security Core 3.1.2.RELEASE
18:26:13,960 INFO [main] SecurityNamespaceHandler:59 - Spring Security 'config' module version is 3.1.2.RELEASE
18:26:14,556 INFO [main] FilterInvocationSecurityMetadataSourceParser:134 - Creating access control expression attribute 'isAuthenticated()' for /**
18:26:14,565 INFO [main] FilterInvocationSecurityMetadataSourceParser:134 - Creating access control expression attribute 'hasRole('ADMIN')' for /**
18:26:14,770 INFO [main] HttpSecurityBeanDefinitionParser:264 - Checking sorted filter chain: [Root bean: class [org.springframework.security.web.context.SecurityContextPersistenceFilter]; scope=; abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=null; factoryMethodName=null; initMethodName=null; destroyMethodName=null, order = 300, Root bean: class [org.springframework.security.web.authentication.www.BasicAuthenticationFilter]; scope=; abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=null; factoryMethodName=null; initMethodName=null; destroyMethodName=null, order = 1200, <internalTokenAuthenticationFilter>, order = 1201, Root bean: class [org.springframework.security.web.savedrequest.RequestCacheAwareFilter]; scope=; abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=null; factoryMethodName=null; initMethodName=null; destroyMethodName=null, order = 1300, Root bean: class [org.springframework.security.web.servletapi.SecurityContextHolderAwareRequestFilter]; scope=; abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=null; factoryMethodName=null; initMethodName=null; destroyMethodName=null, order = 1400, Root bean: class [org.springframework.security.web.authentication.AnonymousAuthenticationFilter]; scope=; abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=null; factoryMethodName=null; initMethodName=null; destroyMethodName=null, order = 1700, Root bean: class [org.springframework.security.web.session.SessionManagementFilter]; scope=; abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=null; factoryMethodName=null; initMethodName=null; destroyMethodName=null, order = 1800, Root bean: class [org.springframework.security.web.access.ExceptionTranslationFilter]; scope=; abstract=false; lazyInit=false; autowireMode=0; dependencyCheck=0; autowireCandidate=true; primary=false; factoryBeanName=null; factoryMethodName=null; initMethodName=null; destroyMethodName=null, order = 1900, <org.springframework.security.web.access.intercept.FilterSecurityInterceptor#0>, order = 2000]
18:26:14,939 INFO [main] DefaultListableBeanFactory:557 - Pre-instantiating singletons in org.springframework.beans.factory.support.DefaultListableBeanFactory@7db81d4f: defining beans [org.springframework.security.filterChains,org.springframework.security.filterChainProxy,org.springframework.security.web.PortMapperImpl#0,org.springframework.security.web.PortResolverImpl#0,org.springframework.security.config.authentication.AuthenticationManagerFactoryBean#0,org.springframework.security.authentication.ProviderManager#0,org.springframework.security.web.context.HttpSessionSecurityContextRepository#0,org.springframework.security.web.authentication.session.SessionFixationProtectionStrategy#0,org.springframework.security.web.savedrequest.HttpSessionRequestCache#0,org.springframework.security.web.access.expression.DefaultWebSecurityExpressionHandler#0,org.springframework.security.access.vote.AffirmativeBased#0,org.springframework.security.web.access.intercept.FilterSecurityInterceptor#0,org.springframework.security.web.access.DefaultWebInvocationPrivilegeEvaluator#0,org.springframework.security.authentication.AnonymousAuthenticationProvider#0,org.springframework.security.userDetailsServiceFactory,org.springframework.security.web.DefaultSecurityFilterChain#0,org.springframework.security.authentication.dao.DaoAuthenticationProvider#0,org.springframework.security.authentication.DefaultAuthenticationEventPublisher#0,org.springframework.security.authenticationManager,ambariEntryPoint]; parent: org.springframework.beans.factory.support.DefaultListableBeanFactory@c4be179
18:26:18,905 INFO [main] DefaultSecurityFilterChain:28 - Creating filter chain: org.springframework.security.web.util.AnyRequestMatcher@1, [org.springframework.security.web.context.SecurityContextPersistenceFilter@1d264bf5, org.springframework.security.web.authentication.www.BasicAuthenticationFilter@3d44d0c6, org.apache.ambari.server.security.authorization.internal.InternalTokenAuthenticationFilter@70e69696, org.springframework.security.web.savedrequest.RequestCacheAwareFilter@32a88bc2, org.springframework.security.web.servletapi.SecurityContextHolderAwareRequestFilter@576f8789, org.springframework.security.web.authentication.AnonymousAuthenticationFilter@5b2b6037, org.springframework.security.web.session.SessionManagementFilter@7cb9e9a3, org.springframework.security.web.access.ExceptionTranslationFilter@119a0c4e, org.springframework.security.web.access.intercept.FilterSecurityInterceptor@189ddde9]
18:26:19,510 INFO [main] Configuration:538 - Web App DIR test /usr/lib/ambari-server/web
18:26:19,555 INFO [main] CertificateManager:69 - Initialization of root certificate
18:26:19,557 INFO [main] CertificateManager:71 - Certificate exists:true
18:26:20,124 INFO [main] AmbariServer:387 - ********* Initializing Clusters **********
18:26:20,126 INFO [main] AmbariServer:391 - ********* Current Clusters State *********
18:26:20,127 INFO [main] AmbariServer:392 - Clusters=[ ]
18:26:20,129 INFO [main] AmbariServer:394 - ********* Initializing ActionManager **********
18:26:20,130 INFO [main] AmbariServer:396 - ********* Initializing Controller **********
18:26:20,131 INFO [main] AmbariServer:400 - ********* Initializing Scheduled Request Manager **********
18:26:20,160 INFO [main] Server:266 - jetty-7.6.7.v20120910
18:26:21,116 INFO [main] ContextHandler:744 - started o.e.j.s.ServletContextHandler{/,file:/usr/lib/ambari-server/web/}
18:27:00,353 INFO [main] AbstractConnector:338 - Started SelectChannelConnector@0.0.0.0:8080
18:27:00,357 INFO [main] Server:266 - jetty-7.6.7.v20120910
18:27:00,366 INFO [main] ContextHandler:744 - started o.e.j.s.ServletContextHandler{/,null}
18:27:23,139 INFO [main] SslContextFactory:300 - Enabled Protocols [SSLv2Hello, SSLv3, TLSv1] of [SSLv2Hello, SSLv3, TLSv1]
18:27:23,378 INFO [main] AbstractConnector:338 - Started SslSelectChannelConnector@0.0.0.0:8440
18:27:23,996 INFO [main] SslContextFactory:300 - Enabled Protocols [SSLv2Hello, SSLv3, TLSv1] of [SSLv2Hello, SSLv3, TLSv1]
18:27:24,102 INFO [main] AbstractConnector:338 - Started SslSelectChannelConnector@0.0.0.0:8441
18:27:24,113 INFO [main] AmbariServer:416 - ********* Started Server **********
18:27:24,115 INFO [main] ActionManager:73 - Starting scheduler thread
18:27:24,624 INFO [main] AmbariServer:419 - ********* Started ActionManager **********
18:27:24,626 INFO [main] ExecutionScheduleManager:146 - Starting scheduler
18:27:26,351 INFO [main] MLog:80 - MLog clients using log4j logging.
18:27:27,284 INFO [main] C3P0Registry:204 - Initializing c3p0-0.9.1.1 [built 15-March-2007 01:32:31; debug? true; trace: 10]
18:27:27,711 INFO [main] StdSchedulerFactory:1184 - Using default implementation for ThreadExecutor
18:27:27,975 INFO [main] SchedulerSignalerImpl:61 - Initialized Scheduler Signaller of type: class org.quartz.core.SchedulerSignalerImpl
18:27:27,978 INFO [main] QuartzScheduler:240 - Quartz Scheduler v.2.2.1 created.
18:27:27,990 INFO [main] JobStoreTX:670 - Using thread monitor-based data access locking (synchronization).
18:27:27,999 INFO [main] JobStoreTX:59 - JobStoreTX initialized.
18:27:28,010 INFO [main] QuartzScheduler:305 - Scheduler meta-data: Quartz Scheduler (v2.2.1) 'ExecutionScheduler' with instanceId 'NON_CLUSTERED'
Scheduler class: 'org.quartz.core.QuartzScheduler' - running locally.
NOT STARTED.
Currently in standby mode.
Number of jobs executed: 0
Using thread pool 'org.quartz.simpl.SimpleThreadPool' - with 5 threads.
Using job-store 'org.quartz.impl.jdbcjobstore.JobStoreTX' - which supports persistence. and is not clustered.
18:27:28,013 INFO [main] StdSchedulerFactory:1339 - Quartz scheduler 'ExecutionScheduler' initialized from an externally provided properties instance.
18:27:28,014 INFO [main] StdSchedulerFactory:1343 - Quartz scheduler version: 2.2.1
18:27:28,015 INFO [main] QuartzScheduler:2311 - JobFactory set to: org.apache.ambari.server.state.scheduler.GuiceJobFactory@43afebc9
18:27:28,024 INFO [main] AmbariServer:422 - ********* Started Scheduled Request Manager **********
18:27:38,143 WARN [qtp1270843969-40] nio:651 - java.io.IOException: Broken pipe
18:27:42,959 WARN [qtp1270843969-41] nio:651 - java.io.IOException: Broken pipe
18:27:54,013 WARN [qtp1270843969-40] nio:651 - java.io.IOException: Broken pipe
18:28:27,192 INFO [qtp1270843969-42] HostImpl:261 - Received host registration, host=[hostname=cluster-1-worker-node-001,fqdn=cluster-1-worker-node-001.novalocal,domain=novalocal,architecture=x86_64,processorcount=2,physicalprocessorcount=2,osname=redhat,osversion=6.4,osfamily=redhat,memory=4055036,uptime_hours=0,mounts=(available=6520172,mountpoint=/,used=3265940,percent=34%,size=10309828,device=/dev/vda1,type=ext4)(available=2027516,mountpoint=/dev/shm,used=0,percent=0%,size=2027516,device=tmpfs,type=tmpfs)]
, registrationTime=1398968906216, agentVersion=1.5.1.110
18:28:43,321 INFO [qtp1270843969-42] HostImpl:261 - Received host registration, host=[hostname=cluster-1-worker-node-002,fqdn=cluster-1-worker-node-002.novalocal,domain=novalocal,architecture=x86_64,processorcount=2,physicalprocessorcount=2,osname=redhat,osversion=6.4,osfamily=redhat,memory=4055036,uptime_hours=0,mounts=(available=6520196,mountpoint=/,used=3265916,percent=34%,size=10309828,device=/dev/vda1,type=ext4)(available=2027516,mountpoint=/dev/shm,used=0,percent=0%,size=2027516,device=tmpfs,type=tmpfs)]
, registrationTime=1398968922878, agentVersion=1.5.1.110
18:28:48,978 INFO [qtp1270843969-53] HostImpl:261 - Received host registration, host=[hostname=cluster-1-master-node-001,fqdn=cluster-1-master-node-001.novalocal,domain=novalocal,architecture=x86_64,processorcount=2,physicalprocessorcount=2,osname=redhat,osversion=6.4,osfamily=redhat,memory=4055036,uptime_hours=0,mounts=(available=6471800,mountpoint=/,used=3314312,percent=34%,size=10309828,device=/dev/vda1,type=ext4)(available=2027516,mountpoint=/dev/shm,used=0,percent=0%,size=2027516,device=tmpfs,type=tmpfs)]
, registrationTime=1398968928908, agentVersion=1.5.1.110
18:29:30,644 INFO [Thread-26] AbstractPoolBackedDataSource:462 - Initializing c3p0 pool... com.mchange.v2.c3p0.ComboPooledDataSource [ acquireIncrement -> 3, acquireRetryAttempts -> 30, acquireRetryDelay -> 1000, autoCommitOnClose -> false, automaticTestTable -> null, breakAfterAcquireFailure -> false, checkoutTimeout -> 0, connectionCustomizerClassName -> null, connectionTesterClassName -> com.mchange.v2.c3p0.impl.DefaultConnectionTester, dataSourceName -> 1br9pmq911fcbojzxytsan|4d737e47, debugUnreturnedConnectionStackTraces -> false, description -> null, driverClass -> org.postgresql.Driver, factoryClassLocation -> null, forceIgnoreUnresolvedTransactions -> false, identityToken -> 1br9pmq911fcbojzxytsan|4d737e47, idleConnectionTestPeriod -> 50, initialPoolSize -> 3, jdbcUrl -> jdbc:postgresql://localhost/ambari, lastAcquisitionFailureDefaultUser -> null, maxAdministrativeTaskTime -> 0, maxConnectionAge -> 0, maxIdleTime -> 0, maxIdleTimeExcessConnections -> 0, maxPoolSize -> 5, maxStatements -> 0, maxStatementsPerConnection -> 120, minPoolSize -> 1, numHelperThreads -> 3, numThreadsAwaitingCheckoutDefaultUser -> 0, preferredTestQuery -> select 0, properties -> {user=******, password=******}, propertyCycle -> 0, testConnectionOnCheckin -> true, testConnectionOnCheckout -> false, unreturnedConnectionTimeout -> 0, usesTraditionalReflectiveProxies -> false ]
18:29:38,045 INFO [Thread-26] JobStoreTX:861 - Freed 0 triggers from 'acquired' / 'blocked' state.
18:29:38,313 INFO [Thread-26] JobStoreTX:871 - Recovering 0 jobs that were in-progress at the time of the last shut-down.
18:29:38,315 INFO [Thread-26] JobStoreTX:884 - Recovery complete.
18:29:38,330 INFO [Thread-26] JobStoreTX:891 - Removed 0 'complete' triggers.
18:29:38,344 INFO [Thread-26] JobStoreTX:896 - Removed 0 stale fired job entries.
18:29:38,416 INFO [Thread-26] QuartzScheduler:575 - Scheduler ExecutionScheduler_$_NON_CLUSTERED started.
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment