[
https://issues.apache.org/jira/browse/SPARK-15329?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=15291290#comment-15291290
]
Jon edited comment on SPARK-15329 at 5/19/16 3:28 PM:
------------------------------------------------------
hadoopadmin@master:/usr/local/hadoop-2.7.1/sbin$ yarn logs -applicationId
applica tion_1463670715317_0001
16/05/19 16:17:59 INFO client.RMProxy: Connecting to ResourceManager at
/0.0.0.0 :8032
Container: container_1463670715317_0001_01_000001 on masternode_52694
============================================================================
LogType:stderr
Log Upload Time:Thu May 19 16:12:37 +0100 2016
LogLength:2551
Log Contents:
SLF4J: Class path contains multiple SLF4J bindings.
SLF4J: Found binding in
[jar:file:/tmp/hadoop-hadoopadmin/nm-local-dir/usercache
/hadoopadmin/filecache/11/spark-assembly-1.6.1-hadoop2.6.0.jar!/org/slf4j/impl/S
taticLoggerBinder.class]
SLF4J: Found binding in
[jar:file:/usr/local/hadoop-2.7.1/share/hadoop/common/li
b/slf4j-log4j12-1.7.10.jar!/org/slf4j/impl/StaticLoggerBinder.class]
SLF4J: See http://www.slf4j.org/codes.html#multiple_bindings for an explanation.
SLF4J: Actual binding is of type [org.slf4j.impl.Log4jLoggerFactory]
16/05/19 16:12:27 INFO yarn.ApplicationMaster: Registered signal handlers for
[T ERM, HUP, INT]
16/05/19 16:12:28 INFO yarn.ApplicationMaster: ApplicationAttemptId:
appattempt_ 1463670715317_0001_000001
16/05/19 16:12:28 INFO spark.SecurityManager: Changing view acls to: hadoopadmin
16/05/19 16:12:28 INFO spark.SecurityManager: Changing modify acls to:
hadoopadm in
16/05/19 16:12:28 INFO spark.SecurityManager: SecurityManager: authentication
di sabled; ui acls disabled; users with view permissions: Set(hadoopadmin);
users w ith modify permissions: Set(hadoopadmin)
16/05/19 16:12:29 INFO yarn.ApplicationMaster: Waiting for Spark driver to be
re achable.
16/05/19 16:12:29 INFO yarn.ApplicationMaster: Driver now available:
10.17.0.50: 47660
16/05/19 16:12:29 INFO yarn.ApplicationMaster$AMEndpoint: Add WebUI Filter.
AddW
ebUIFilter(org.apache.hadoop.yarn.server.webproxy.amfilter.AmIpFilter,Map(PROXY_
HOSTS -> masternode, PROXY_URI_BASES -> http://masternode:8088/proxy/a
pplication_1463670715317_0001),/proxy/application_1463670715317_0001)
16/05/19 16:12:29 INFO client.RMProxy: Connecting to ResourceManager at
/0.0.0.0 :8030
16/05/19 16:12:29 INFO yarn.YarnRMClient: Registering the ApplicationMaster
16/05/19 16:12:29 INFO yarn.YarnAllocator: Will request 2 executor containers,
e ach with 1 cores and 1408 MB memory including 384 MB overhead
16/05/19 16:12:29 INFO yarn.YarnAllocator: Container request (host: Any,
capabil ity: <memory:1408, vCores:1>)
16/05/19 16:12:29 INFO yarn.YarnAllocator: Container request (host: Any,
capabil ity: <memory:1408, vCores:1>)
16/05/19 16:12:30 INFO yarn.ApplicationMaster: Started progress reporter thread
with (heartbeat : 3000, initial allocation : 200) intervals
16/05/19 16:12:30 ERROR yarn.ApplicationMaster: RECEIVED SIGNAL 15: SIGTERM
16/05/19 16:12:30 INFO yarn.ApplicationMaster: Final app status: UNDEFINED,
exit Code: 0, (reason: Shutdown hook called before final status was reported.)
16/05/19 16:12:30 INFO util.ShutdownHookManager: Shutdown hook called
End of LogType:stderr
LogType:stdout
Log Upload Time:Thu May 19 16:12:37 +0100 2016
LogLength:0
Log Contents:
End of LogType:stdout
Container: container_1463670715317_0001_02_000002 on masternode_52694
============================================================================
LogType:stderr
Log Upload Time:Thu May 19 16:12:37 +0100 2016
LogLength:737
Log Contents:
SLF4J: Class path contains multiple SLF4J bindings.
SLF4J: Found binding in
[jar:file:/tmp/hadoop-hadoopadmin/nm-local-dir/usercache
/hadoopadmin/filecache/11/spark-assembly-1.6.1-hadoop2.6.0.jar!/org/slf4j/impl/S
taticLoggerBinder.class]
SLF4J: Found binding in
[jar:file:/usr/local/hadoop-2.7.1/share/hadoop/common/li
b/slf4j-log4j12-1.7.10.jar!/org/slf4j/impl/StaticLoggerBinder.class]
SLF4J: See http://www.slf4j.org/codes.html#multiple_bindings for an explanation.
SLF4J: Actual binding is of type [org.slf4j.impl.Log4jLoggerFactory]
16/05/19 16:12:35 INFO executor.CoarseGrainedExecutorBackend: Registered signal
handlers for [TERM, HUP, INT]
16/05/19 16:12:36 ERROR executor.CoarseGrainedExecutorBackend: RECEIVED SIGNAL
1 5: SIGTERM
End of LogType:stderr
LogType:stdout
Log Upload Time:Thu May 19 16:12:37 +0100 2016
LogLength:0
Log Contents:
End of LogType:stdout
Container: container_1463670715317_0001_02_000001 on masternode_52694
============================================================================
LogType:stderr
Log Upload Time:Thu May 19 16:12:37 +0100 2016
LogLength:6133
Log Contents:
SLF4J: Class path contains multiple SLF4J bindings.
SLF4J: Found binding in
[jar:file:/tmp/hadoop-hadoopadmin/nm-local-dir/usercache
/hadoopadmin/filecache/11/spark-assembly-1.6.1-hadoop2.6.0.jar!/org/slf4j/impl/S
taticLoggerBinder.class]
SLF4J: Found binding in
[jar:file:/usr/local/hadoop-2.7.1/share/hadoop/common/li
b/slf4j-log4j12-1.7.10.jar!/org/slf4j/impl/StaticLoggerBinder.class]
SLF4J: See http://www.slf4j.org/codes.html#multiple_bindings for an explanation.
SLF4J: Actual binding is of type [org.slf4j.impl.Log4jLoggerFactory]
16/05/19 16:12:31 INFO yarn.ApplicationMaster: Registered signal handlers for
[T ERM, HUP, INT]
16/05/19 16:12:32 INFO yarn.ApplicationMaster: ApplicationAttemptId:
appattempt_ 1463670715317_0001_000002
16/05/19 16:12:32 INFO spark.SecurityManager: Changing view acls to: hadoopadmin
16/05/19 16:12:32 INFO spark.SecurityManager: Changing modify acls to:
hadoopadm in
16/05/19 16:12:32 INFO spark.SecurityManager: SecurityManager: authentication
di sabled; ui acls disabled; users with view permissions: Set(hadoopadmin);
users w ith modify permissions: Set(hadoopadmin)
16/05/19 16:12:33 INFO yarn.ApplicationMaster: Waiting for Spark driver to be
re achable.
16/05/19 16:12:33 INFO yarn.ApplicationMaster: Driver now available:
10.17.0.50: 47660
16/05/19 16:12:33 INFO yarn.ApplicationMaster$AMEndpoint: Add WebUI Filter.
AddW
ebUIFilter(org.apache.hadoop.yarn.server.webproxy.amfilter.AmIpFilter,Map(PROXY_
HOSTS -> masternode, PROXY_URI_BASES -> http://masternode:8088/proxy/a
pplication_1463670715317_0001),/proxy/application_1463670715317_0001)
16/05/19 16:12:33 INFO client.RMProxy: Connecting to ResourceManager at
/0.0.0.0 :8030
16/05/19 16:12:33 INFO yarn.YarnRMClient: Registering the ApplicationMaster
16/05/19 16:12:33 INFO yarn.YarnAllocator: Will request 2 executor containers,
e ach with 1 cores and 1408 MB memory including 384 MB overhead
16/05/19 16:12:33 INFO yarn.YarnAllocator: Container request (host: Any,
capabil ity: <memory:1408, vCores:1>)
16/05/19 16:12:33 INFO yarn.YarnAllocator: Container request (host: Any,
capabil ity: <memory:1408, vCores:1>)
16/05/19 16:12:33 INFO yarn.ApplicationMaster: Started progress reporter thread
with (heartbeat : 3000, initial allocation : 200) intervals
16/05/19 16:12:34 INFO impl.AMRMClientImpl: Received new token for :
master.dei.u c.pt:52694
16/05/19 16:12:34 INFO yarn.YarnAllocator: Launching container
container_1463670 715317_0001_02_000002 for on host masternode
16/05/19 16:12:34 INFO yarn.YarnAllocator: Launching ExecutorRunnable.
driverUrl : spark://CoarseGrainedScheduler@10.17.0.50:47660, executorHostname:
masternode
16/05/19 16:12:34 INFO yarn.ExecutorRunnable: Starting Executor Container
16/05/19 16:12:34 INFO yarn.YarnAllocator: Received 1 containers from YARN,
laun ching executors on 1 of them.
16/05/19 16:12:34 INFO impl.ContainerManagementProtocolProxy:
yarn.client.max-ca ched-nodemanagers-proxies : 0
16/05/19 16:12:34 INFO yarn.ExecutorRunnable: Setting up ContainerLaunchContext
16/05/19 16:12:34 INFO yarn.ExecutorRunnable: Preparing Local resources
16/05/19 16:12:34 INFO yarn.ExecutorRunnable: Prepared Local resources
Map(__spa rk__.jar -> resource { scheme: "hdfs" host: "localhost" port: 9000
file: "/user/
hadoopadmin/.sparkStaging/application_1463670715317_0001/spark-assembly-1.6.1-ha
doop2.6.0.jar" } size: 187698038 timestamp: 1463670742144 type: FILE
visibility: PRIVATE)
16/05/19 16:12:34 INFO yarn.ExecutorRunnable:
===============================================================================
YARN executor launch context:
env:
CLASSPATH ->
{{PWD}}<CPS>{{PWD}}/__spark__.jar<CPS>$HADOOP_CONF_DIR<CPS>$HAD
OOP_COMMON_HOME/share/hadoop/common/*<CPS>$HADOOP_COMMON_HOME/share/hadoop/commo
n/lib/*<CPS>$HADOOP_HDFS_HOME/share/hadoop/hdfs/*<CPS>$HADOOP_HDFS_HOME/share/ha
doop/hdfs/lib/*<CPS>$HADOOP_YARN_HOME/share/hadoop/yarn/*<CPS>$HADOOP_YARN_HOME/
share/hadoop/yarn/lib/*<CPS>$HADOOP_MAPRED_HOME/share/hadoop/mapreduce/*<CPS>$HA
DOOP_MAPRED_HOME/share/hadoop/mapreduce/lib/*
SPARK_LOG_URL_STDERR -> http://masternode:8042/node/containerlogs/conta
iner_1463670715317_0001_02_000002/hadoopadmin/stderr?start=-4096
SPARK_YARN_STAGING_DIR -> .sparkStaging/application_1463670715317_0001
SPARK_YARN_CACHE_FILES_FILE_SIZES -> 187698038
SPARK_USER -> hadoopadmin
SPARK_YARN_CACHE_FILES_VISIBILITIES -> PRIVATE
SPARK_YARN_MODE -> true
SPARK_YARN_CACHE_FILES_TIME_STAMPS -> 1463670742144
SPARK_LOG_URL_STDOUT -> http://masternode:8042/node/containerlogs/conta
iner_1463670715317_0001_02_000002/hadoopadmin/stdout?start=-4096
SPARK_YARN_CACHE_FILES ->
hdfs://localhost:9000/user/hadoopadmin/.sparkStagi
ng/application_1463670715317_0001/spark-assembly-1.6.1-hadoop2.6.0.jar#__spark__
.jar
command:
{{JAVA_HOME}}/bin/java -server -XX:OnOutOfMemoryError='kill %p' -Xms1024m
-X mx1024m -Djava.io.tmpdir={{PWD}}/tmp '-Dspark.driver.port=47660'
-Dspark.yarn.ap p.container.log.dir=<LOG_DIR>
org.apache.spark.executor.CoarseGrainedExecutorBac kend --driver-url
spark://CoarseGrainedScheduler@10.17.0.50:47660 --executor-id 1 --hostname
masternode --cores 1 --app-id application_1463670715317_0001 - -user-class-path
file:$PWD/__app__.jar 1> <LOG_DIR>/stdout 2> <LOG_DIR>/stderr
===============================================================================
16/05/19 16:12:34 INFO impl.ContainerManagementProtocolProxy: Opening proxy :
masternode:52694
16/05/19 16:12:36 ERROR yarn.ApplicationMaster: RECEIVED SIGNAL 15: SIGTERM
16/05/19 16:12:36 INFO yarn.ApplicationMaster: Final app status: UNDEFINED,
exit Code: 0, (reason: Shutdown hook called before final status was reported.)
16/05/19 16:12:36 INFO yarn.ApplicationMaster: Unregistering ApplicationMaster
w ith UNDEFINED (diag message: Shutdown hook called before final status was
report ed.)
16/05/19 16:12:36 INFO impl.AMRMClientImpl: Waiting for application to be
succes sfully unregistered.
16/05/19 16:12:36 INFO yarn.ApplicationMaster: Deleting staging directory
.spark Staging/application_1463670715317_0001
16/05/19 16:12:36 INFO util.ShutdownHookManager: Shutdown hook called
End of LogType:stderr
LogType:stdout
Log Upload Time:Thu May 19 16:12:37 +0100 2016
LogLength:0
Log Contents:
End of LogType:stdout
hadoopadmin@master:/usr/local/hadoop-2.7.1/sbin$
hadoopadmin@master:/usr/local/hadoop-2.7.1/sbin$ clear
hadoopadmin@master:/usr/local/hadoop-2.7.1/sbin$ cd
hadoopadmin@master:~$ clear
hadoopadmin@master:~$ yarn logs -applicationId application_1463670715317_0002
16/05/19 16:20:42 INFO client.RMProxy: Connecting to ResourceManager at
/0.0.0.0 :8032
Container: container_1463670715317_0002_02_000001 on masternode_52694
============================================================================
LogType:stderr
Log Upload Time:Thu May 19 16:19:54 +0100 2016
LogLength:6133
Log Contents:
SLF4J: Class path contains multiple SLF4J bindings.
SLF4J: Found binding in
[jar:file:/tmp/hadoop-hadoopadmin/nm-local-dir/usercache
/hadoopadmin/filecache/13/spark-assembly-1.6.1-hadoop2.6.0.jar!/org/slf4j/impl/S
taticLoggerBinder.class]
SLF4J: Found binding in
[jar:file:/usr/local/hadoop-2.7.1/share/hadoop/common/li
b/slf4j-log4j12-1.7.10.jar!/org/slf4j/impl/StaticLoggerBinder.class]
SLF4J: See http://www.slf4j.org/codes.html#multiple_bindings for an explanation.
SLF4J: Actual binding is of type [org.slf4j.impl.Log4jLoggerFactory]
16/05/19 16:19:49 INFO yarn.ApplicationMaster: Registered signal handlers for
[T ERM, HUP, INT]
16/05/19 16:19:50 INFO yarn.ApplicationMaster: ApplicationAttemptId:
appattempt_ 1463670715317_0002_000002
16/05/19 16:19:50 INFO spark.SecurityManager: Changing view acls to: hadoopadmin
16/05/19 16:19:50 INFO spark.SecurityManager: Changing modify acls to:
hadoopadm in
16/05/19 16:19:50 INFO spark.SecurityManager: SecurityManager: authentication
di sabled; ui acls disabled; users with view permissions: Set(hadoopadmin);
users w ith modify permissions: Set(hadoopadmin)
16/05/19 16:19:51 INFO yarn.ApplicationMaster: Waiting for Spark driver to be
re achable.
16/05/19 16:19:51 INFO yarn.ApplicationMaster: Driver now available:
10.17.0.50: 43771
16/05/19 16:19:51 INFO yarn.ApplicationMaster$AMEndpoint: Add WebUI Filter.
AddW
ebUIFilter(org.apache.hadoop.yarn.server.webproxy.amfilter.AmIpFilter,Map(PROXY_
HOSTS -> masternode, PROXY_URI_BASES -> http://masternode:8088/proxy/a
pplication_1463670715317_0002),/proxy/application_1463670715317_0002)
16/05/19 16:19:51 INFO client.RMProxy: Connecting to ResourceManager at
/0.0.0.0 :8030
16/05/19 16:19:51 INFO yarn.YarnRMClient: Registering the ApplicationMaster
16/05/19 16:19:51 INFO yarn.YarnAllocator: Will request 2 executor containers,
e ach with 1 cores and 1408 MB memory including 384 MB overhead
16/05/19 16:19:51 INFO yarn.YarnAllocator: Container request (host: Any,
capabil ity: <memory:1408, vCores:1>)
16/05/19 16:19:51 INFO yarn.YarnAllocator: Container request (host: Any,
capabil ity: <memory:1408, vCores:1>)
16/05/19 16:19:51 INFO yarn.ApplicationMaster: Started progress reporter thread
with (heartbeat : 3000, initial allocation : 200) intervals
16/05/19 16:19:53 INFO impl.AMRMClientImpl: Received new token for :
masternode:52694
16/05/19 16:19:53 INFO yarn.YarnAllocator: Launching container
container_1463670 715317_0002_02_000002 for on host masternode
16/05/19 16:19:53 INFO yarn.YarnAllocator: Launching ExecutorRunnable.
driverUrl : spark://CoarseGrainedScheduler@10.17.0.50:43771, executorHostname:
masternode
16/05/19 16:19:53 INFO yarn.YarnAllocator: Received 1 containers from YARN,
laun ching executors on 1 of them.
16/05/19 16:19:53 INFO yarn.ExecutorRunnable: Starting Executor Container
16/05/19 16:19:53 INFO impl.ContainerManagementProtocolProxy:
yarn.client.max-ca ched-nodemanagers-proxies : 0
16/05/19 16:19:53 INFO yarn.ExecutorRunnable: Setting up ContainerLaunchContext
16/05/19 16:19:53 INFO yarn.ExecutorRunnable: Preparing Local resources
16/05/19 16:19:53 INFO yarn.ExecutorRunnable: Prepared Local resources
Map(__spa rk__.jar -> resource { scheme: "hdfs" host: "localhost" port: 9000
file: "/user/
hadoopadmin/.sparkStaging/application_1463670715317_0002/spark-assembly-1.6.1-ha
doop2.6.0.jar" } size: 187698038 timestamp: 1463671182405 type: FILE
visibility: PRIVATE)
16/05/19 16:19:53 INFO yarn.ExecutorRunnable:
===============================================================================
YARN executor launch context:
env:
CLASSPATH ->
{{PWD}}<CPS>{{PWD}}/__spark__.jar<CPS>$HADOOP_CONF_DIR<CPS>$HAD
OOP_COMMON_HOME/share/hadoop/common/*<CPS>$HADOOP_COMMON_HOME/share/hadoop/commo
n/lib/*<CPS>$HADOOP_HDFS_HOME/share/hadoop/hdfs/*<CPS>$HADOOP_HDFS_HOME/share/ha
doop/hdfs/lib/*<CPS>$HADOOP_YARN_HOME/share/hadoop/yarn/*<CPS>$HADOOP_YARN_HOME/
share/hadoop/yarn/lib/*<CPS>$HADOOP_MAPRED_HOME/share/hadoop/mapreduce/*<CPS>$HA
DOOP_MAPRED_HOME/share/hadoop/mapreduce/lib/*
SPARK_LOG_URL_STDERR -> http://masternode:8042/node/containerlogs/conta
iner_1463670715317_0002_02_000002/hadoopadmin/stderr?start=-4096
SPARK_YARN_STAGING_DIR -> .sparkStaging/application_1463670715317_0002
SPARK_YARN_CACHE_FILES_FILE_SIZES -> 187698038
SPARK_USER -> hadoopadmin
SPARK_YARN_CACHE_FILES_VISIBILITIES -> PRIVATE
SPARK_YARN_MODE -> true
SPARK_YARN_CACHE_FILES_TIME_STAMPS -> 1463671182405
SPARK_LOG_URL_STDOUT -> http://masternode:8042/node/containerlogs/conta
iner_1463670715317_0002_02_000002/hadoopadmin/stdout?start=-4096
SPARK_YARN_CACHE_FILES ->
hdfs://localhost:9000/user/hadoopadmin/.sparkStagi
ng/application_1463670715317_0002/spark-assembly-1.6.1-hadoop2.6.0.jar#__spark__
.jar
command:
{{JAVA_HOME}}/bin/java -server -XX:OnOutOfMemoryError='kill %p' -Xms1024m
-X mx1024m -Djava.io.tmpdir={{PWD}}/tmp '-Dspark.driver.port=43771'
-Dspark.yarn.ap p.container.log.dir=<LOG_DIR>
org.apache.spark.executor.CoarseGrainedExecutorBac kend --driver-url
spark://CoarseGrainedScheduler@10.17.0.50:43771 --executor-id 1 --hostname
masternode --cores 1 --app-id application_1463670715317_0002 - -user-class-path
file:$PWD/__app__.jar 1> <LOG_DIR>/stdout 2> <LOG_DIR>/stderr
===============================================================================
16/05/19 16:19:53 INFO impl.ContainerManagementProtocolProxy: Opening proxy :
masternode:52694
16/05/19 16:19:54 ERROR yarn.ApplicationMaster: RECEIVED SIGNAL 15: SIGTERM
16/05/19 16:19:54 INFO yarn.ApplicationMaster: Final app status: UNDEFINED,
exit Code: 0, (reason: Shutdown hook called before final status was reported.)
16/05/19 16:19:54 INFO yarn.ApplicationMaster: Unregistering ApplicationMaster
w ith UNDEFINED (diag message: Shutdown hook called before final status was
report ed.)
16/05/19 16:19:54 INFO impl.AMRMClientImpl: Waiting for application to be
succes sfully unregistered.
16/05/19 16:19:54 INFO yarn.ApplicationMaster: Deleting staging directory
.spark Staging/application_1463670715317_0002
16/05/19 16:19:54 INFO util.ShutdownHookManager: Shutdown hook called
End of LogType:stderr
LogType:stdout
Log Upload Time:Thu May 19 16:19:54 +0100 2016
LogLength:0
Log Contents:
End of LogType:stdout
Container: container_1463670715317_0002_01_000002 on masternode_52694
============================================================================
LogType:stderr
Log Upload Time:Thu May 19 16:19:54 +0100 2016
LogLength:0
Log Contents:
End of LogType:stderr
LogType:stdout
Log Upload Time:Thu May 19 16:19:54 +0100 2016
LogLength:0
Log Contents:
End of LogType:stdout
Container: container_1463670715317_0002_01_000001 on masternode_52694
============================================================================
LogType:stderr
Log Upload Time:Thu May 19 16:19:54 +0100 2016
LogLength:5748
Log Contents:
SLF4J: Class path contains multiple SLF4J bindings.
SLF4J: Found binding in
[jar:file:/tmp/hadoop-hadoopadmin/nm-local-dir/usercache
/hadoopadmin/filecache/13/spark-assembly-1.6.1-hadoop2.6.0.jar!/org/slf4j/impl/S
taticLoggerBinder.class]
SLF4J: Found binding in
[jar:file:/usr/local/hadoop-2.7.1/share/hadoop/common/li
b/slf4j-log4j12-1.7.10.jar!/org/slf4j/impl/StaticLoggerBinder.class]
SLF4J: See http://www.slf4j.org/codes.html#multiple_bindings for an explanation.
SLF4J: Actual binding is of type [org.slf4j.impl.Log4jLoggerFactory]
16/05/19 16:19:44 INFO yarn.ApplicationMaster: Registered signal handlers for
[T ERM, HUP, INT]
16/05/19 16:19:45 INFO yarn.ApplicationMaster: ApplicationAttemptId:
appattempt_ 1463670715317_0002_000001
16/05/19 16:19:46 INFO spark.SecurityManager: Changing view acls to: hadoopadmin
16/05/19 16:19:46 INFO spark.SecurityManager: Changing modify acls to:
hadoopadm in
16/05/19 16:19:46 INFO spark.SecurityManager: SecurityManager: authentication
di sabled; ui acls disabled; users with view permissions: Set(hadoopadmin);
users w ith modify permissions: Set(hadoopadmin)
16/05/19 16:19:46 INFO yarn.ApplicationMaster: Waiting for Spark driver to be
re achable.
16/05/19 16:19:46 INFO yarn.ApplicationMaster: Driver now available:
10.17.0.50: 43771
16/05/19 16:19:47 INFO yarn.ApplicationMaster$AMEndpoint: Add WebUI Filter.
AddW
ebUIFilter(org.apache.hadoop.yarn.server.webproxy.amfilter.AmIpFilter,Map(PROXY_
HOSTS -> masternode, PROXY_URI_BASES -> http://masternode:8088/proxy/a
pplication_1463670715317_0002),/proxy/application_1463670715317_0002)
16/05/19 16:19:47 INFO client.RMProxy: Connecting to ResourceManager at
/0.0.0.0 :8030
16/05/19 16:19:47 INFO yarn.YarnRMClient: Registering the ApplicationMaster
16/05/19 16:19:47 INFO yarn.YarnAllocator: Will request 2 executor containers,
e ach with 1 cores and 1408 MB memory including 384 MB overhead
16/05/19 16:19:47 INFO yarn.YarnAllocator: Container request (host: Any,
capabil ity: <memory:1408, vCores:1>)
16/05/19 16:19:47 INFO yarn.YarnAllocator: Container request (host: Any,
capabil ity: <memory:1408, vCores:1>)
16/05/19 16:19:47 INFO yarn.ApplicationMaster: Started progress reporter thread
with (heartbeat : 3000, initial allocation : 200) intervals
16/05/19 16:19:47 INFO impl.AMRMClientImpl: Received new token for :
masternode:52694
16/05/19 16:19:47 INFO yarn.YarnAllocator: Launching container
container_1463670 715317_0002_01_000002 for on host masternode
16/05/19 16:19:47 INFO yarn.YarnAllocator: Launching ExecutorRunnable.
driverUrl : spark://CoarseGrainedScheduler@10.17.0.50:43771, executorHostname:
masternode
16/05/19 16:19:47 INFO yarn.ExecutorRunnable: Starting Executor Container
16/05/19 16:19:47 INFO yarn.YarnAllocator: Received 1 containers from YARN,
laun ching executors on 1 of them.
16/05/19 16:19:47 INFO impl.ContainerManagementProtocolProxy:
yarn.client.max-ca ched-nodemanagers-proxies : 0
16/05/19 16:19:47 INFO yarn.ExecutorRunnable: Setting up ContainerLaunchContext
16/05/19 16:19:47 INFO yarn.ExecutorRunnable: Preparing Local resources
16/05/19 16:19:47 INFO yarn.ExecutorRunnable: Prepared Local resources
Map(__spa rk__.jar -> resource { scheme: "hdfs" host: "localhost" port: 9000
file: "/user/
hadoopadmin/.sparkStaging/application_1463670715317_0002/spark-assembly-1.6.1-ha
doop2.6.0.jar" } size: 187698038 timestamp: 1463671182405 type: FILE
visibility: PRIVATE)
16/05/19 16:19:48 INFO yarn.ExecutorRunnable:
===============================================================================
YARN executor launch context:
env:
CLASSPATH ->
{{PWD}}<CPS>{{PWD}}/__spark__.jar<CPS>$HADOOP_CONF_DIR<CPS>$HAD
OOP_COMMON_HOME/share/hadoop/common/*<CPS>$HADOOP_COMMON_HOME/share/hadoop/commo
n/lib/*<CPS>$HADOOP_HDFS_HOME/share/hadoop/hdfs/*<CPS>$HADOOP_HDFS_HOME/share/ha
doop/hdfs/lib/*<CPS>$HADOOP_YARN_HOME/share/hadoop/yarn/*<CPS>$HADOOP_YARN_HOME/
share/hadoop/yarn/lib/*<CPS>$HADOOP_MAPRED_HOME/share/hadoop/mapreduce/*<CPS>$HA
DOOP_MAPRED_HOME/share/hadoop/mapreduce/lib/*
SPARK_LOG_URL_STDERR -> http://masternode:8042/node/containerlogs/conta
iner_1463670715317_0002_01_000002/hadoopadmin/stderr?start=-4096
SPARK_YARN_STAGING_DIR -> .sparkStaging/application_1463670715317_0002
SPARK_YARN_CACHE_FILES_FILE_SIZES -> 187698038
SPARK_USER -> hadoopadmin
SPARK_YARN_CACHE_FILES_VISIBILITIES -> PRIVATE
SPARK_YARN_MODE -> true
SPARK_YARN_CACHE_FILES_TIME_STAMPS -> 1463671182405
SPARK_LOG_URL_STDOUT -> http://masternode:8042/node/containerlogs/conta
iner_1463670715317_0002_01_000002/hadoopadmin/stdout?start=-4096
SPARK_YARN_CACHE_FILES ->
hdfs://localhost:9000/user/hadoopadmin/.sparkStagi
ng/application_1463670715317_0002/spark-assembly-1.6.1-hadoop2.6.0.jar#__spark__
.jar
command:
{{JAVA_HOME}}/bin/java -server -XX:OnOutOfMemoryError='kill %p' -Xms1024m
-X mx1024m -Djava.io.tmpdir={{PWD}}/tmp '-Dspark.driver.port=43771'
-Dspark.yarn.ap p.container.log.dir=<LOG_DIR>
org.apache.spark.executor.CoarseGrainedExecutorBac kend --driver-url
spark://CoarseGrainedScheduler@10.17.0.50:43771 --executor-id 1 --hostname
masternode --cores 1 --app-id application_1463670715317_0002 - -user-class-path
file:$PWD/__app__.jar 1> <LOG_DIR>/stdout 2> <LOG_DIR>/stderr
===============================================================================
16/05/19 16:19:48 INFO impl.ContainerManagementProtocolProxy: Opening proxy :
masternode:52694
16/05/19 16:19:48 ERROR yarn.ApplicationMaster: RECEIVED SIGNAL 15: SIGTERM
16/05/19 16:19:48 INFO yarn.ApplicationMaster: Final app status: UNDEFINED,
exit Code: 0, (reason: Shutdown hook called before final status was reported.)
16/05/19 16:19:48 INFO util.ShutdownHookManager: Shutdown hook called
End of LogType:stderr
LogType:stdout
Log Upload Time:Thu May 19 16:19:54 +0100 2016
LogLength:0
Log Contents:
End of LogType:stdout
Container: container_1463670715317_0002_02_000002 on masternode_52694
============================================================================
LogType:stderr
Log Upload Time:Thu May 19 16:19:54 +0100 2016
LogLength:737
Log Contents:
SLF4J: Class path contains multiple SLF4J bindings.
SLF4J: Found binding in
[jar:file:/tmp/hadoop-hadoopadmin/nm-local-dir/usercache
/hadoopadmin/filecache/13/spark-assembly-1.6.1-hadoop2.6.0.jar!/org/slf4j/impl/S
taticLoggerBinder.class]
SLF4J: Found binding in
[jar:file:/usr/local/hadoop-2.7.1/share/hadoop/common/li
b/slf4j-log4j12-1.7.10.jar!/org/slf4j/impl/StaticLoggerBinder.class]
SLF4J: See http://www.slf4j.org/codes.html#multiple_bindings for an explanation.
SLF4J: Actual binding is of type [org.slf4j.impl.Log4jLoggerFactory]
16/05/19 16:19:54 INFO executor.CoarseGrainedExecutorBackend: Registered signal
handlers for [TERM, HUP, INT]
16/05/19 16:19:54 ERROR executor.CoarseGrainedExecutorBackend: RECEIVED SIGNAL
1 5: SIGTERM
End of LogType:stderr
LogType:stdout
Log Upload Time:Thu May 19 16:19:54 +0100 2016
LogLength:0
Log Contents:
End of LogType:stdout
hadoopadmin@master:~$
was (Author: joncod):
hadoopadmin@master:/usr/local/hadoop-2.7.1/sbin$ yarn logs -applicationId
applica tion_1463670715317_0001
16/05/19 16:17:59 INFO client.RMProxy: Connecting to ResourceManager at
/0.0.0.0 :8032
Container: container_1463670715317_0001_01_000001 on masternode_52694
============================================================================
LogType:stderr
Log Upload Time:Thu May 19 16:12:37 +0100 2016
LogLength:2551
Log Contents:
SLF4J: Class path contains multiple SLF4J bindings.
SLF4J: Found binding in
[jar:file:/tmp/hadoop-hadoopadmin/nm-local-dir/usercache
/hadoopadmin/filecache/11/spark-assembly-1.6.1-hadoop2.6.0.jar!/org/slf4j/impl/S
taticLoggerBinder.class]
SLF4J: Found binding in
[jar:file:/usr/local/hadoop-2.7.1/share/hadoop/common/li
b/slf4j-log4j12-1.7.10.jar!/org/slf4j/impl/StaticLoggerBinder.class]
SLF4J: See http://www.slf4j.org/codes.html#multiple_bindings for an explanation.
SLF4J: Actual binding is of type [org.slf4j.impl.Log4jLoggerFactory]
16/05/19 16:12:27 INFO yarn.ApplicationMaster: Registered signal handlers for
[T ERM, HUP, INT]
16/05/19 16:12:28 INFO yarn.ApplicationMaster: ApplicationAttemptId:
appattempt_ 1463670715317_0001_000001
16/05/19 16:12:28 INFO spark.SecurityManager: Changing view acls to: hadoopadmin
16/05/19 16:12:28 INFO spark.SecurityManager: Changing modify acls to:
hadoopadm in
16/05/19 16:12:28 INFO spark.SecurityManager: SecurityManager: authentication
di sabled; ui acls disabled; users with view permissions: Set(hadoopadmin);
users w ith modify permissions: Set(hadoopadmin)
16/05/19 16:12:29 INFO yarn.ApplicationMaster: Waiting for Spark driver to be
re achable.
16/05/19 16:12:29 INFO yarn.ApplicationMaster: Driver now available:
10.17.0.50: 47660
16/05/19 16:12:29 INFO yarn.ApplicationMaster$AMEndpoint: Add WebUI Filter.
AddW
ebUIFilter(org.apache.hadoop.yarn.server.webproxy.amfilter.AmIpFilter,Map(PROXY_
HOSTS -> masternode, PROXY_URI_BASES -> http://masternode:8088/proxy/a
pplication_1463670715317_0001),/proxy/application_1463670715317_0001)
16/05/19 16:12:29 INFO client.RMProxy: Connecting to ResourceManager at
/0.0.0.0 :8030
16/05/19 16:12:29 INFO yarn.YarnRMClient: Registering the ApplicationMaster
16/05/19 16:12:29 INFO yarn.YarnAllocator: Will request 2 executor containers,
e ach with 1 cores and 1408 MB memory including 384 MB overhead
16/05/19 16:12:29 INFO yarn.YarnAllocator: Container request (host: Any,
capabil ity: <memory:1408, vCores:1>)
16/05/19 16:12:29 INFO yarn.YarnAllocator: Container request (host: Any,
capabil ity: <memory:1408, vCores:1>)
16/05/19 16:12:30 INFO yarn.ApplicationMaster: Started progress reporter thread
with (heartbeat : 3000, initial allocation : 200) intervals
16/05/19 16:12:30 ERROR yarn.ApplicationMaster: RECEIVED SIGNAL 15: SIGTERM
16/05/19 16:12:30 INFO yarn.ApplicationMaster: Final app status: UNDEFINED,
exit Code: 0, (reason: Shutdown hook called before final status was reported.)
16/05/19 16:12:30 INFO util.ShutdownHookManager: Shutdown hook called
End of LogType:stderr
LogType:stdout
Log Upload Time:Thu May 19 16:12:37 +0100 2016
LogLength:0
Log Contents:
End of LogType:stdout
Container: container_1463670715317_0001_02_000002 on masternode_52694
============================================================================
LogType:stderr
Log Upload Time:Thu May 19 16:12:37 +0100 2016
LogLength:737
Log Contents:
SLF4J: Class path contains multiple SLF4J bindings.
SLF4J: Found binding in
[jar:file:/tmp/hadoop-hadoopadmin/nm-local-dir/usercache
/hadoopadmin/filecache/11/spark-assembly-1.6.1-hadoop2.6.0.jar!/org/slf4j/impl/S
taticLoggerBinder.class]
SLF4J: Found binding in
[jar:file:/usr/local/hadoop-2.7.1/share/hadoop/common/li
b/slf4j-log4j12-1.7.10.jar!/org/slf4j/impl/StaticLoggerBinder.class]
SLF4J: See http://www.slf4j.org/codes.html#multiple_bindings for an explanation.
SLF4J: Actual binding is of type [org.slf4j.impl.Log4jLoggerFactory]
16/05/19 16:12:35 INFO executor.CoarseGrainedExecutorBackend: Registered signal
handlers for [TERM, HUP, INT]
16/05/19 16:12:36 ERROR executor.CoarseGrainedExecutorBackend: RECEIVED SIGNAL
1 5: SIGTERM
End of LogType:stderr
LogType:stdout
Log Upload Time:Thu May 19 16:12:37 +0100 2016
LogLength:0
Log Contents:
End of LogType:stdout
Container: container_1463670715317_0001_02_000001 on masternode_52694
============================================================================
LogType:stderr
Log Upload Time:Thu May 19 16:12:37 +0100 2016
LogLength:6133
Log Contents:
SLF4J: Class path contains multiple SLF4J bindings.
SLF4J: Found binding in
[jar:file:/tmp/hadoop-hadoopadmin/nm-local-dir/usercache
/hadoopadmin/filecache/11/spark-assembly-1.6.1-hadoop2.6.0.jar!/org/slf4j/impl/S
taticLoggerBinder.class]
SLF4J: Found binding in
[jar:file:/usr/local/hadoop-2.7.1/share/hadoop/common/li
b/slf4j-log4j12-1.7.10.jar!/org/slf4j/impl/StaticLoggerBinder.class]
SLF4J: See http://www.slf4j.org/codes.html#multiple_bindings for an explanation.
SLF4J: Actual binding is of type [org.slf4j.impl.Log4jLoggerFactory]
16/05/19 16:12:31 INFO yarn.ApplicationMaster: Registered signal handlers for
[T ERM, HUP, INT]
16/05/19 16:12:32 INFO yarn.ApplicationMaster: ApplicationAttemptId:
appattempt_ 1463670715317_0001_000002
16/05/19 16:12:32 INFO spark.SecurityManager: Changing view acls to: hadoopadmin
16/05/19 16:12:32 INFO spark.SecurityManager: Changing modify acls to:
hadoopadm in
16/05/19 16:12:32 INFO spark.SecurityManager: SecurityManager: authentication
di sabled; ui acls disabled; users with view permissions: Set(hadoopadmin);
users w ith modify permissions: Set(hadoopadmin)
16/05/19 16:12:33 INFO yarn.ApplicationMaster: Waiting for Spark driver to be
re achable.
16/05/19 16:12:33 INFO yarn.ApplicationMaster: Driver now available:
10.17.0.50: 47660
16/05/19 16:12:33 INFO yarn.ApplicationMaster$AMEndpoint: Add WebUI Filter.
AddW
ebUIFilter(org.apache.hadoop.yarn.server.webproxy.amfilter.AmIpFilter,Map(PROXY_
HOSTS -> masternode, PROXY_URI_BASES -> http://masternode:8088/proxy/a
pplication_1463670715317_0001),/proxy/application_1463670715317_0001)
16/05/19 16:12:33 INFO client.RMProxy: Connecting to ResourceManager at
/0.0.0.0 :8030
16/05/19 16:12:33 INFO yarn.YarnRMClient: Registering the ApplicationMaster
16/05/19 16:12:33 INFO yarn.YarnAllocator: Will request 2 executor containers,
e ach with 1 cores and 1408 MB memory including 384 MB overhead
16/05/19 16:12:33 INFO yarn.YarnAllocator: Container request (host: Any,
capabil ity: <memory:1408, vCores:1>)
16/05/19 16:12:33 INFO yarn.YarnAllocator: Container request (host: Any,
capabil ity: <memory:1408, vCores:1>)
16/05/19 16:12:33 INFO yarn.ApplicationMaster: Started progress reporter thread
with (heartbeat : 3000, initial allocation : 200) intervals
16/05/19 16:12:34 INFO impl.AMRMClientImpl: Received new token for :
master.dei.u c.pt:52694
16/05/19 16:12:34 INFO yarn.YarnAllocator: Launching container
container_1463670 715317_0001_02_000002 for on host masternode
16/05/19 16:12:34 INFO yarn.YarnAllocator: Launching ExecutorRunnable.
driverUrl : spark://CoarseGrainedScheduler@10.17.0.50:47660, executorHostname:
master.dei. uc.pt
16/05/19 16:12:34 INFO yarn.ExecutorRunnable: Starting Executor Container
16/05/19 16:12:34 INFO yarn.YarnAllocator: Received 1 containers from YARN,
laun ching executors on 1 of them.
16/05/19 16:12:34 INFO impl.ContainerManagementProtocolProxy:
yarn.client.max-ca ched-nodemanagers-proxies : 0
16/05/19 16:12:34 INFO yarn.ExecutorRunnable: Setting up ContainerLaunchContext
16/05/19 16:12:34 INFO yarn.ExecutorRunnable: Preparing Local resources
16/05/19 16:12:34 INFO yarn.ExecutorRunnable: Prepared Local resources
Map(__spa rk__.jar -> resource { scheme: "hdfs" host: "localhost" port: 9000
file: "/user/
hadoopadmin/.sparkStaging/application_1463670715317_0001/spark-assembly-1.6.1-ha
doop2.6.0.jar" } size: 187698038 timestamp: 1463670742144 type: FILE
visibility: PRIVATE)
16/05/19 16:12:34 INFO yarn.ExecutorRunnable:
===============================================================================
YARN executor launch context:
env:
CLASSPATH ->
{{PWD}}<CPS>{{PWD}}/__spark__.jar<CPS>$HADOOP_CONF_DIR<CPS>$HAD
OOP_COMMON_HOME/share/hadoop/common/*<CPS>$HADOOP_COMMON_HOME/share/hadoop/commo
n/lib/*<CPS>$HADOOP_HDFS_HOME/share/hadoop/hdfs/*<CPS>$HADOOP_HDFS_HOME/share/ha
doop/hdfs/lib/*<CPS>$HADOOP_YARN_HOME/share/hadoop/yarn/*<CPS>$HADOOP_YARN_HOME/
share/hadoop/yarn/lib/*<CPS>$HADOOP_MAPRED_HOME/share/hadoop/mapreduce/*<CPS>$HA
DOOP_MAPRED_HOME/share/hadoop/mapreduce/lib/*
SPARK_LOG_URL_STDERR -> http://masternode:8042/node/containerlogs/conta
iner_1463670715317_0001_02_000002/hadoopadmin/stderr?start=-4096
SPARK_YARN_STAGING_DIR -> .sparkStaging/application_1463670715317_0001
SPARK_YARN_CACHE_FILES_FILE_SIZES -> 187698038
SPARK_USER -> hadoopadmin
SPARK_YARN_CACHE_FILES_VISIBILITIES -> PRIVATE
SPARK_YARN_MODE -> true
SPARK_YARN_CACHE_FILES_TIME_STAMPS -> 1463670742144
SPARK_LOG_URL_STDOUT -> http://masternode:8042/node/containerlogs/conta
iner_1463670715317_0001_02_000002/hadoopadmin/stdout?start=-4096
SPARK_YARN_CACHE_FILES ->
hdfs://localhost:9000/user/hadoopadmin/.sparkStagi
ng/application_1463670715317_0001/spark-assembly-1.6.1-hadoop2.6.0.jar#__spark__
.jar
command:
{{JAVA_HOME}}/bin/java -server -XX:OnOutOfMemoryError='kill %p' -Xms1024m
-X mx1024m -Djava.io.tmpdir={{PWD}}/tmp '-Dspark.driver.port=47660'
-Dspark.yarn.ap p.container.log.dir=<LOG_DIR>
org.apache.spark.executor.CoarseGrainedExecutorBac kend --driver-url
spark://CoarseGrainedScheduler@10.17.0.50:47660 --executor-id 1 --hostname
masternode --cores 1 --app-id application_1463670715317_0001 - -user-class-path
file:$PWD/__app__.jar 1> <LOG_DIR>/stdout 2> <LOG_DIR>/stderr
===============================================================================
16/05/19 16:12:34 INFO impl.ContainerManagementProtocolProxy: Opening proxy :
sg d34.dei.uc.pt:52694
16/05/19 16:12:36 ERROR yarn.ApplicationMaster: RECEIVED SIGNAL 15: SIGTERM
16/05/19 16:12:36 INFO yarn.ApplicationMaster: Final app status: UNDEFINED,
exit Code: 0, (reason: Shutdown hook called before final status was reported.)
16/05/19 16:12:36 INFO yarn.ApplicationMaster: Unregistering ApplicationMaster
w ith UNDEFINED (diag message: Shutdown hook called before final status was
report ed.)
16/05/19 16:12:36 INFO impl.AMRMClientImpl: Waiting for application to be
succes sfully unregistered.
16/05/19 16:12:36 INFO yarn.ApplicationMaster: Deleting staging directory
.spark Staging/application_1463670715317_0001
16/05/19 16:12:36 INFO util.ShutdownHookManager: Shutdown hook called
End of LogType:stderr
LogType:stdout
Log Upload Time:Thu May 19 16:12:37 +0100 2016
LogLength:0
Log Contents:
End of LogType:stdout
hadoopadmin@master:/usr/local/hadoop-2.7.1/sbin$
hadoopadmin@master:/usr/local/hadoop-2.7.1/sbin$ clear
hadoopadmin@master:/usr/local/hadoop-2.7.1/sbin$ cd
hadoopadmin@master:~$ clear
hadoopadmin@master:~$ yarn logs -applicationId application_1463670715317_0002
16/05/19 16:20:42 INFO client.RMProxy: Connecting to ResourceManager at
/0.0.0.0 :8032
Container: container_1463670715317_0002_02_000001 on masternode_52694
============================================================================
LogType:stderr
Log Upload Time:Thu May 19 16:19:54 +0100 2016
LogLength:6133
Log Contents:
SLF4J: Class path contains multiple SLF4J bindings.
SLF4J: Found binding in
[jar:file:/tmp/hadoop-hadoopadmin/nm-local-dir/usercache
/hadoopadmin/filecache/13/spark-assembly-1.6.1-hadoop2.6.0.jar!/org/slf4j/impl/S
taticLoggerBinder.class]
SLF4J: Found binding in
[jar:file:/usr/local/hadoop-2.7.1/share/hadoop/common/li
b/slf4j-log4j12-1.7.10.jar!/org/slf4j/impl/StaticLoggerBinder.class]
SLF4J: See http://www.slf4j.org/codes.html#multiple_bindings for an explanation.
SLF4J: Actual binding is of type [org.slf4j.impl.Log4jLoggerFactory]
16/05/19 16:19:49 INFO yarn.ApplicationMaster: Registered signal handlers for
[T ERM, HUP, INT]
16/05/19 16:19:50 INFO yarn.ApplicationMaster: ApplicationAttemptId:
appattempt_ 1463670715317_0002_000002
16/05/19 16:19:50 INFO spark.SecurityManager: Changing view acls to: hadoopadmin
16/05/19 16:19:50 INFO spark.SecurityManager: Changing modify acls to:
hadoopadm in
16/05/19 16:19:50 INFO spark.SecurityManager: SecurityManager: authentication
di sabled; ui acls disabled; users with view permissions: Set(hadoopadmin);
users w ith modify permissions: Set(hadoopadmin)
16/05/19 16:19:51 INFO yarn.ApplicationMaster: Waiting for Spark driver to be
re achable.
16/05/19 16:19:51 INFO yarn.ApplicationMaster: Driver now available:
10.17.0.50: 43771
16/05/19 16:19:51 INFO yarn.ApplicationMaster$AMEndpoint: Add WebUI Filter.
AddW
ebUIFilter(org.apache.hadoop.yarn.server.webproxy.amfilter.AmIpFilter,Map(PROXY_
HOSTS -> masternode, PROXY_URI_BASES -> http://masternode:8088/proxy/a
pplication_1463670715317_0002),/proxy/application_1463670715317_0002)
16/05/19 16:19:51 INFO client.RMProxy: Connecting to ResourceManager at
/0.0.0.0 :8030
16/05/19 16:19:51 INFO yarn.YarnRMClient: Registering the ApplicationMaster
16/05/19 16:19:51 INFO yarn.YarnAllocator: Will request 2 executor containers,
e ach with 1 cores and 1408 MB memory including 384 MB overhead
16/05/19 16:19:51 INFO yarn.YarnAllocator: Container request (host: Any,
capabil ity: <memory:1408, vCores:1>)
16/05/19 16:19:51 INFO yarn.YarnAllocator: Container request (host: Any,
capabil ity: <memory:1408, vCores:1>)
16/05/19 16:19:51 INFO yarn.ApplicationMaster: Started progress reporter thread
with (heartbeat : 3000, initial allocation : 200) intervals
16/05/19 16:19:53 INFO impl.AMRMClientImpl: Received new token for :
master.dei.u c.pt:52694
16/05/19 16:19:53 INFO yarn.YarnAllocator: Launching container
container_1463670 715317_0002_02_000002 for on host masternode
16/05/19 16:19:53 INFO yarn.YarnAllocator: Launching ExecutorRunnable.
driverUrl : spark://CoarseGrainedScheduler@10.17.0.50:43771, executorHostname:
master.dei. uc.pt
16/05/19 16:19:53 INFO yarn.YarnAllocator: Received 1 containers from YARN,
laun ching executors on 1 of them.
16/05/19 16:19:53 INFO yarn.ExecutorRunnable: Starting Executor Container
16/05/19 16:19:53 INFO impl.ContainerManagementProtocolProxy:
yarn.client.max-ca ched-nodemanagers-proxies : 0
16/05/19 16:19:53 INFO yarn.ExecutorRunnable: Setting up ContainerLaunchContext
16/05/19 16:19:53 INFO yarn.ExecutorRunnable: Preparing Local resources
16/05/19 16:19:53 INFO yarn.ExecutorRunnable: Prepared Local resources
Map(__spa rk__.jar -> resource { scheme: "hdfs" host: "localhost" port: 9000
file: "/user/
hadoopadmin/.sparkStaging/application_1463670715317_0002/spark-assembly-1.6.1-ha
doop2.6.0.jar" } size: 187698038 timestamp: 1463671182405 type: FILE
visibility: PRIVATE)
16/05/19 16:19:53 INFO yarn.ExecutorRunnable:
===============================================================================
YARN executor launch context:
env:
CLASSPATH ->
{{PWD}}<CPS>{{PWD}}/__spark__.jar<CPS>$HADOOP_CONF_DIR<CPS>$HAD
OOP_COMMON_HOME/share/hadoop/common/*<CPS>$HADOOP_COMMON_HOME/share/hadoop/commo
n/lib/*<CPS>$HADOOP_HDFS_HOME/share/hadoop/hdfs/*<CPS>$HADOOP_HDFS_HOME/share/ha
doop/hdfs/lib/*<CPS>$HADOOP_YARN_HOME/share/hadoop/yarn/*<CPS>$HADOOP_YARN_HOME/
share/hadoop/yarn/lib/*<CPS>$HADOOP_MAPRED_HOME/share/hadoop/mapreduce/*<CPS>$HA
DOOP_MAPRED_HOME/share/hadoop/mapreduce/lib/*
SPARK_LOG_URL_STDERR -> http://masternode:8042/node/containerlogs/conta
iner_1463670715317_0002_02_000002/hadoopadmin/stderr?start=-4096
SPARK_YARN_STAGING_DIR -> .sparkStaging/application_1463670715317_0002
SPARK_YARN_CACHE_FILES_FILE_SIZES -> 187698038
SPARK_USER -> hadoopadmin
SPARK_YARN_CACHE_FILES_VISIBILITIES -> PRIVATE
SPARK_YARN_MODE -> true
SPARK_YARN_CACHE_FILES_TIME_STAMPS -> 1463671182405
SPARK_LOG_URL_STDOUT -> http://masternode:8042/node/containerlogs/conta
iner_1463670715317_0002_02_000002/hadoopadmin/stdout?start=-4096
SPARK_YARN_CACHE_FILES ->
hdfs://localhost:9000/user/hadoopadmin/.sparkStagi
ng/application_1463670715317_0002/spark-assembly-1.6.1-hadoop2.6.0.jar#__spark__
.jar
command:
{{JAVA_HOME}}/bin/java -server -XX:OnOutOfMemoryError='kill %p' -Xms1024m
-X mx1024m -Djava.io.tmpdir={{PWD}}/tmp '-Dspark.driver.port=43771'
-Dspark.yarn.ap p.container.log.dir=<LOG_DIR>
org.apache.spark.executor.CoarseGrainedExecutorBac kend --driver-url
spark://CoarseGrainedScheduler@10.17.0.50:43771 --executor-id 1 --hostname
masternode --cores 1 --app-id application_1463670715317_0002 - -user-class-path
file:$PWD/__app__.jar 1> <LOG_DIR>/stdout 2> <LOG_DIR>/stderr
===============================================================================
16/05/19 16:19:53 INFO impl.ContainerManagementProtocolProxy: Opening proxy :
sg d34.dei.uc.pt:52694
16/05/19 16:19:54 ERROR yarn.ApplicationMaster: RECEIVED SIGNAL 15: SIGTERM
16/05/19 16:19:54 INFO yarn.ApplicationMaster: Final app status: UNDEFINED,
exit Code: 0, (reason: Shutdown hook called before final status was reported.)
16/05/19 16:19:54 INFO yarn.ApplicationMaster: Unregistering ApplicationMaster
w ith UNDEFINED (diag message: Shutdown hook called before final status was
report ed.)
16/05/19 16:19:54 INFO impl.AMRMClientImpl: Waiting for application to be
succes sfully unregistered.
16/05/19 16:19:54 INFO yarn.ApplicationMaster: Deleting staging directory
.spark Staging/application_1463670715317_0002
16/05/19 16:19:54 INFO util.ShutdownHookManager: Shutdown hook called
End of LogType:stderr
LogType:stdout
Log Upload Time:Thu May 19 16:19:54 +0100 2016
LogLength:0
Log Contents:
End of LogType:stdout
Container: container_1463670715317_0002_01_000002 on masternode_52694
============================================================================
LogType:stderr
Log Upload Time:Thu May 19 16:19:54 +0100 2016
LogLength:0
Log Contents:
End of LogType:stderr
LogType:stdout
Log Upload Time:Thu May 19 16:19:54 +0100 2016
LogLength:0
Log Contents:
End of LogType:stdout
Container: container_1463670715317_0002_01_000001 on masternode_52694
============================================================================
LogType:stderr
Log Upload Time:Thu May 19 16:19:54 +0100 2016
LogLength:5748
Log Contents:
SLF4J: Class path contains multiple SLF4J bindings.
SLF4J: Found binding in
[jar:file:/tmp/hadoop-hadoopadmin/nm-local-dir/usercache
/hadoopadmin/filecache/13/spark-assembly-1.6.1-hadoop2.6.0.jar!/org/slf4j/impl/S
taticLoggerBinder.class]
SLF4J: Found binding in
[jar:file:/usr/local/hadoop-2.7.1/share/hadoop/common/li
b/slf4j-log4j12-1.7.10.jar!/org/slf4j/impl/StaticLoggerBinder.class]
SLF4J: See http://www.slf4j.org/codes.html#multiple_bindings for an explanation.
SLF4J: Actual binding is of type [org.slf4j.impl.Log4jLoggerFactory]
16/05/19 16:19:44 INFO yarn.ApplicationMaster: Registered signal handlers for
[T ERM, HUP, INT]
16/05/19 16:19:45 INFO yarn.ApplicationMaster: ApplicationAttemptId:
appattempt_ 1463670715317_0002_000001
16/05/19 16:19:46 INFO spark.SecurityManager: Changing view acls to: hadoopadmin
16/05/19 16:19:46 INFO spark.SecurityManager: Changing modify acls to:
hadoopadm in
16/05/19 16:19:46 INFO spark.SecurityManager: SecurityManager: authentication
di sabled; ui acls disabled; users with view permissions: Set(hadoopadmin);
users w ith modify permissions: Set(hadoopadmin)
16/05/19 16:19:46 INFO yarn.ApplicationMaster: Waiting for Spark driver to be
re achable.
16/05/19 16:19:46 INFO yarn.ApplicationMaster: Driver now available:
10.17.0.50: 43771
16/05/19 16:19:47 INFO yarn.ApplicationMaster$AMEndpoint: Add WebUI Filter.
AddW
ebUIFilter(org.apache.hadoop.yarn.server.webproxy.amfilter.AmIpFilter,Map(PROXY_
HOSTS -> masternode, PROXY_URI_BASES -> http://masternode:8088/proxy/a
pplication_1463670715317_0002),/proxy/application_1463670715317_0002)
16/05/19 16:19:47 INFO client.RMProxy: Connecting to ResourceManager at
/0.0.0.0 :8030
16/05/19 16:19:47 INFO yarn.YarnRMClient: Registering the ApplicationMaster
16/05/19 16:19:47 INFO yarn.YarnAllocator: Will request 2 executor containers,
e ach with 1 cores and 1408 MB memory including 384 MB overhead
16/05/19 16:19:47 INFO yarn.YarnAllocator: Container request (host: Any,
capabil ity: <memory:1408, vCores:1>)
16/05/19 16:19:47 INFO yarn.YarnAllocator: Container request (host: Any,
capabil ity: <memory:1408, vCores:1>)
16/05/19 16:19:47 INFO yarn.ApplicationMaster: Started progress reporter thread
with (heartbeat : 3000, initial allocation : 200) intervals
16/05/19 16:19:47 INFO impl.AMRMClientImpl: Received new token for :
master.dei.u c.pt:52694
16/05/19 16:19:47 INFO yarn.YarnAllocator: Launching container
container_1463670 715317_0002_01_000002 for on host masternode
16/05/19 16:19:47 INFO yarn.YarnAllocator: Launching ExecutorRunnable.
driverUrl : spark://CoarseGrainedScheduler@10.17.0.50:43771, executorHostname:
master.dei. uc.pt
16/05/19 16:19:47 INFO yarn.ExecutorRunnable: Starting Executor Container
16/05/19 16:19:47 INFO yarn.YarnAllocator: Received 1 containers from YARN,
laun ching executors on 1 of them.
16/05/19 16:19:47 INFO impl.ContainerManagementProtocolProxy:
yarn.client.max-ca ched-nodemanagers-proxies : 0
16/05/19 16:19:47 INFO yarn.ExecutorRunnable: Setting up ContainerLaunchContext
16/05/19 16:19:47 INFO yarn.ExecutorRunnable: Preparing Local resources
16/05/19 16:19:47 INFO yarn.ExecutorRunnable: Prepared Local resources
Map(__spa rk__.jar -> resource { scheme: "hdfs" host: "localhost" port: 9000
file: "/user/
hadoopadmin/.sparkStaging/application_1463670715317_0002/spark-assembly-1.6.1-ha
doop2.6.0.jar" } size: 187698038 timestamp: 1463671182405 type: FILE
visibility: PRIVATE)
16/05/19 16:19:48 INFO yarn.ExecutorRunnable:
===============================================================================
YARN executor launch context:
env:
CLASSPATH ->
{{PWD}}<CPS>{{PWD}}/__spark__.jar<CPS>$HADOOP_CONF_DIR<CPS>$HAD
OOP_COMMON_HOME/share/hadoop/common/*<CPS>$HADOOP_COMMON_HOME/share/hadoop/commo
n/lib/*<CPS>$HADOOP_HDFS_HOME/share/hadoop/hdfs/*<CPS>$HADOOP_HDFS_HOME/share/ha
doop/hdfs/lib/*<CPS>$HADOOP_YARN_HOME/share/hadoop/yarn/*<CPS>$HADOOP_YARN_HOME/
share/hadoop/yarn/lib/*<CPS>$HADOOP_MAPRED_HOME/share/hadoop/mapreduce/*<CPS>$HA
DOOP_MAPRED_HOME/share/hadoop/mapreduce/lib/*
SPARK_LOG_URL_STDERR -> http://masternode:8042/node/containerlogs/conta
iner_1463670715317_0002_01_000002/hadoopadmin/stderr?start=-4096
SPARK_YARN_STAGING_DIR -> .sparkStaging/application_1463670715317_0002
SPARK_YARN_CACHE_FILES_FILE_SIZES -> 187698038
SPARK_USER -> hadoopadmin
SPARK_YARN_CACHE_FILES_VISIBILITIES -> PRIVATE
SPARK_YARN_MODE -> true
SPARK_YARN_CACHE_FILES_TIME_STAMPS -> 1463671182405
SPARK_LOG_URL_STDOUT -> http://masternode:8042/node/containerlogs/conta
iner_1463670715317_0002_01_000002/hadoopadmin/stdout?start=-4096
SPARK_YARN_CACHE_FILES ->
hdfs://localhost:9000/user/hadoopadmin/.sparkStagi
ng/application_1463670715317_0002/spark-assembly-1.6.1-hadoop2.6.0.jar#__spark__
.jar
command:
{{JAVA_HOME}}/bin/java -server -XX:OnOutOfMemoryError='kill %p' -Xms1024m
-X mx1024m -Djava.io.tmpdir={{PWD}}/tmp '-Dspark.driver.port=43771'
-Dspark.yarn.ap p.container.log.dir=<LOG_DIR>
org.apache.spark.executor.CoarseGrainedExecutorBac kend --driver-url
spark://CoarseGrainedScheduler@10.17.0.50:43771 --executor-id 1 --hostname
masternode --cores 1 --app-id application_1463670715317_0002 - -user-class-path
file:$PWD/__app__.jar 1> <LOG_DIR>/stdout 2> <LOG_DIR>/stderr
===============================================================================
16/05/19 16:19:48 INFO impl.ContainerManagementProtocolProxy: Opening proxy :
sg d34.dei.uc.pt:52694
16/05/19 16:19:48 ERROR yarn.ApplicationMaster: RECEIVED SIGNAL 15: SIGTERM
16/05/19 16:19:48 INFO yarn.ApplicationMaster: Final app status: UNDEFINED,
exit Code: 0, (reason: Shutdown hook called before final status was reported.)
16/05/19 16:19:48 INFO util.ShutdownHookManager: Shutdown hook called
End of LogType:stderr
LogType:stdout
Log Upload Time:Thu May 19 16:19:54 +0100 2016
LogLength:0
Log Contents:
End of LogType:stdout
Container: container_1463670715317_0002_02_000002 on masternode_52694
============================================================================
LogType:stderr
Log Upload Time:Thu May 19 16:19:54 +0100 2016
LogLength:737
Log Contents:
SLF4J: Class path contains multiple SLF4J bindings.
SLF4J: Found binding in
[jar:file:/tmp/hadoop-hadoopadmin/nm-local-dir/usercache
/hadoopadmin/filecache/13/spark-assembly-1.6.1-hadoop2.6.0.jar!/org/slf4j/impl/S
taticLoggerBinder.class]
SLF4J: Found binding in
[jar:file:/usr/local/hadoop-2.7.1/share/hadoop/common/li
b/slf4j-log4j12-1.7.10.jar!/org/slf4j/impl/StaticLoggerBinder.class]
SLF4J: See http://www.slf4j.org/codes.html#multiple_bindings for an explanation.
SLF4J: Actual binding is of type [org.slf4j.impl.Log4jLoggerFactory]
16/05/19 16:19:54 INFO executor.CoarseGrainedExecutorBackend: Registered signal
handlers for [TERM, HUP, INT]
16/05/19 16:19:54 ERROR executor.CoarseGrainedExecutorBackend: RECEIVED SIGNAL
1 5: SIGTERM
End of LogType:stderr
LogType:stdout
Log Upload Time:Thu May 19 16:19:54 +0100 2016
LogLength:0
Log Contents:
End of LogType:stdout
hadoopadmin@master:~$
> When start spark with yarn: spark.SparkContext: Error initializing
> SparkContext.
> ----------------------------------------------------------------------------------
>
> Key: SPARK-15329
> URL: https://issues.apache.org/jira/browse/SPARK-15329
> Project: Spark
> Issue Type: Bug
> Components: EC2
> Reporter: Jon
>
> Hi, Im trying to start spark with yarn-client, like this "spark-shell
> --master yarn-client" but Im getting the error below.
> If I start spark just with "spark-shell" everything works fine.
> I have a single node machine where I have all hadoop processes running, and a
> hive metastore server running.
> I already try more than 30 different configurations, but nothing is working,
> the config that I have now is this:
> core-site.xml:
> <configuration>
> <property>
> <name>fs.defaultFS</name>
> <value>hdfs://masternode:9000</value>
> </property>
> </configuration>
> hdfs-site.xml:
> <configuration>
> <property>
> <name>dfs.replication</name>
> <value>1</value>
> </property>
> </configuration>
> yarn-site.xml:
> <configuration>
> <property>
> <name>yarn.resourcemanager.resource-tracker.address</name>
> <value>masternode:8031</value>
> </property>
> <property>
> <name>yarn.resourcemanager.address</name>
> <value>masternode:8032</value>
> </property>
> <property>
> <name>yarn.resourcemanager.scheduler.address</name>
> <value>masternode:8030</value>
> </property>
> <property>
> <name>yarn.resourcemanager.admin.address</name>
> <value>masternode:8033</value>
> </property>
> <property>
> <name>yarn.resourcemanager.webapp.address</name>
> <value>masternode:8088</value>
> </property>
> </configuration>
> About spark confs:
> spark-env.sh:
> HADOOP_CONF_DIR=/usr/local/hadoop-2.7.1/hadoop
> SPARK_MASTER_IP=masternode
> spark-defaults.conf
> spark.master spark://masternode:7077
> spark.serializer org.apache.spark.serializer.KryoSerializer
> Do you understand why this is happening?
> hadoopadmin@mn:~$ spark-shell --master yarn-client
> 16/05/14 23:21:07 WARN util.NativeCodeLoader: Unable to load native-hadoop
> library for your platform... using builtin-java classes where applicable
> 16/05/14 23:21:07 INFO spark.SecurityManager: Changing view acls to:
> hadoopadmin
> 16/05/14 23:21:07 INFO spark.SecurityManager: Changing modify acls to:
> hadoopadmin
> 16/05/14 23:21:07 INFO spark.SecurityManager: SecurityManager: authentication
> disabled; ui acls disabled; users with view permissions: Set(hadoopadmin);
> users with modify permissions: Set(hadoopadmin)
> 16/05/14 23:21:08 INFO spark.HttpServer: Starting HTTP Server
> 16/05/14 23:21:08 INFO server.Server: jetty-8.y.z-SNAPSHOT
> 16/05/14 23:21:08 INFO server.AbstractConnector: Started
> SocketConnector@0.0.0.0:36979
> 16/05/14 23:21:08 INFO util.Utils: Successfully started service 'HTTP class
> server' on port 36979.
> Welcome to
> ____ __
> / __/__ ___ _____/ /__
> _\ \/ _ \/ _ `/ __/ '_/
> /___/ .__/\_,_/_/ /_/\_\ version 1.6.1
> /_/
> Using Scala version 2.10.5 (Java HotSpot(TM) 64-Bit Server VM, Java 1.8.0_77)
> Type in expressions to have them evaluated.
> Type :help for more information.
> 16/05/14 23:21:12 INFO spark.SparkContext: Running Spark version 1.6.1
> 16/05/14 23:21:12 INFO spark.SecurityManager: Changing view acls to:
> hadoopadmin
> 16/05/14 23:21:12 INFO spark.SecurityManager: Changing modify acls to:
> hadoopadmin
> 16/05/14 23:21:12 INFO spark.SecurityManager: SecurityManager: authentication
> disabled; ui acls disabled; users with view permissions: Set(hadoopadmin);
> users with modify permissions: Set(hadoopadmin)
> 16/05/14 23:21:12 INFO util.Utils: Successfully started service 'sparkDriver'
> on port 33128.
> 16/05/14 23:21:13 INFO slf4j.Slf4jLogger: Slf4jLogger started
> 16/05/14 23:21:13 INFO Remoting: Starting remoting
> 16/05/14 23:21:13 INFO Remoting: Remoting started; listening on addresses
> :[akka.tcp://sparkDriverActorSystem@10.15.0.11:34382]
> 16/05/14 23:21:13 INFO util.Utils: Successfully started service
> 'sparkDriverActorSystem' on port 34382.
> 16/05/14 23:21:13 INFO spark.SparkEnv: Registering MapOutputTracker
> 16/05/14 23:21:13 INFO spark.SparkEnv: Registering BlockManagerMaster
> 16/05/14 23:21:13 INFO storage.DiskBlockManager: Created local directory at
> /tmp/blockmgr-a0048199-bf2f-404b-9cd2-b5988367783f
> 16/05/14 23:21:13 INFO storage.MemoryStore: MemoryStore started with capacity
> 511.1 MB
> 16/05/14 23:21:13 INFO spark.SparkEnv: Registering OutputCommitCoordinator
> 16/05/14 23:21:13 INFO server.Server: jetty-8.y.z-SNAPSHOT
> 16/05/14 23:21:13 INFO server.AbstractConnector: Started
> SelectChannelConnector@0.0.0.0:4040
> 16/05/14 23:21:13 INFO util.Utils: Successfully started service 'SparkUI' on
> port 4040.
> 16/05/14 23:21:13 INFO ui.SparkUI: Started SparkUI at http://10.15.0.11:4040
> 16/05/14 23:21:14 INFO client.RMProxy: Connecting to ResourceManager at
> localhost/127.0.0.1:8032
> 16/05/14 23:21:14 INFO yarn.Client: Requesting a new application from cluster
> with 1 NodeManagers
> 16/05/14 23:21:14 INFO yarn.Client: Verifying our application has not
> requested more than the maximum memory capability of the cluster (8192 MB per
> container)
> 16/05/14 23:21:14 INFO yarn.Client: Will allocate AM container, with 896 MB
> memory including 384 MB overhead
> 16/05/14 23:21:14 INFO yarn.Client: Setting up container launch context for
> our AM
> 16/05/14 23:21:14 INFO yarn.Client: Setting up the launch environment for our
> AM container
> 16/05/14 23:21:14 INFO yarn.Client: Preparing resources for our AM container
> 16/05/14 23:21:15 INFO yarn.Client: Uploading resource
> file:/usr/local/spark-1.6.1-bin-hadoop2.6/lib/spark-assembly-1.6.1-hadoop2.6.0.jar
> ->
> hdfs://localhost:9000/user/hadoopadmin/.sparkStaging/application_1463264445515_0001/spark-assembly-1.6.1-hadoop2.6.0.jar
> 16/05/14 23:21:17 INFO yarn.Client: Uploading resource
> file:/tmp/spark-3df9a858-4bdb-4c3f-87cb-8768fb2987e7/__spark_conf__6806563942591505644.zip
> ->
> hdfs://localhost:9000/user/hadoopadmin/.sparkStaging/application_1463264445515_0001/__spark_conf__6806563942591505644.zip
> 16/05/14 23:21:17 INFO spark.SecurityManager: Changing view acls to:
> hadoopadmin
> 16/05/14 23:21:17 INFO spark.SecurityManager: Changing modify acls to:
> hadoopadmin
> 16/05/14 23:21:17 INFO spark.SecurityManager: SecurityManager: authentication
> disabled; ui acls disabled; users with view permissions: Set(hadoopadmin);
> users with modify permissions: Set(hadoopadmin)
> 16/05/14 23:21:17 INFO yarn.Client: Submitting application 1 to
> ResourceManager
> 16/05/14 23:21:17 INFO impl.YarnClientImpl: Submitted application
> application_1463264445515_0001
> 16/05/14 23:21:19 INFO yarn.Client: Application report for
> application_1463264445515_0001 (state: ACCEPTED)
> 16/05/14 23:21:19 INFO yarn.Client:
> client token: N/A
> diagnostics: N/A
> ApplicationMaster host: N/A
> ApplicationMaster RPC port: -1
> queue: default
> start time: 1463264477898
> final status: UNDEFINED
> tracking URL:
> http://masternode:8088/proxy/application_1463264445515_0001/
> user: hadoopadmin
> 16/05/14 23:21:20 INFO yarn.Client: Application report for
> application_1463264445515_0001 (state: ACCEPTED)
> 16/05/14 23:21:21 INFO yarn.Client: Application report for
> application_1463264445515_0001 (state: ACCEPTED)
> 16/05/14 23:21:22 INFO yarn.Client: Application report for
> application_1463264445515_0001 (state: ACCEPTED)
> 16/05/14 23:21:23 INFO yarn.Client: Application report for
> application_1463264445515_0001 (state: ACCEPTED)
> 16/05/14 23:21:24 INFO yarn.Client: Application report for
> application_1463264445515_0001 (state: ACCEPTED)
> 16/05/14 23:21:24 INFO cluster.YarnSchedulerBackend$YarnSchedulerEndpoint:
> ApplicationMaster registered as NettyRpcEndpointRef(null)
> 16/05/14 23:21:24 INFO cluster.YarnClientSchedulerBackend: Add WebUI Filter.
> org.apache.hadoop.yarn.server.webproxy.amfilter.AmIpFilter, Map(PROXY_HOSTS
> -> masternode, PROXY_URI_BASES ->
> http://masternode:8088/proxy/application_1463264445515_0001),
> /proxy/application_1463264445515_0001
> 16/05/14 23:21:24 INFO ui.JettyUtils: Adding filter:
> org.apache.hadoop.yarn.server.webproxy.amfilter.AmIpFilter
> 16/05/14 23:21:25 INFO yarn.Client: Application report for
> application_1463264445515_0001 (state: RUNNING)
> 16/05/14 23:21:25 INFO yarn.Client:
> client token: N/A
> diagnostics: N/A
> ApplicationMaster host: 10.15.0.11
> ApplicationMaster RPC port: 0
> queue: default
> start time: 1463264477898
> final status: UNDEFINED
> tracking URL:
> http://masternode:8088/proxy/application_1463264445515_0001/
> user: hadoopadmin
> 16/05/14 23:21:25 INFO cluster.YarnClientSchedulerBackend: Application
> application_1463264445515_0001 has started running.
> 16/05/14 23:21:25 INFO util.Utils: Successfully started service
> 'org.apache.spark.network.netty.NettyBlockTransferService' on port 45282.
> 16/05/14 23:21:25 INFO netty.NettyBlockTransferService: Server created on
> 45282
> 16/05/14 23:21:25 INFO storage.BlockManagerMaster: Trying to register
> BlockManager
> 16/05/14 23:21:25 INFO storage.BlockManagerMasterEndpoint: Registering block
> manager 10.15.0.11:45282 with 511.1 MB RAM, BlockManagerId(driver,
> 10.15.0.11, 45282)
> 16/05/14 23:21:25 INFO storage.BlockManagerMaster: Registered BlockManager
> 16/05/14 23:21:31 INFO cluster.YarnSchedulerBackend$YarnSchedulerEndpoint:
> ApplicationMaster registered as NettyRpcEndpointRef(null)
> 16/05/14 23:21:31 INFO cluster.YarnClientSchedulerBackend: Add WebUI Filter.
> org.apache.hadoop.yarn.server.webproxy.amfilter.AmIpFilter, Map(PROXY_HOSTS
> -> masternode, PROXY_URI_BASES ->
> http://masternode:8088/proxy/application_1463264445515_0001),
> /proxy/application_1463264445515_0001
> 16/05/14 23:21:31 INFO ui.JettyUtils: Adding filter:
> org.apache.hadoop.yarn.server.webproxy.amfilter.AmIpFilter
> 16/05/14 23:21:34 ERROR cluster.YarnClientSchedulerBackend: Yarn application
> has already exited with state FINISHED!
> 16/05/14 23:21:34 INFO handler.ContextHandler: stopped
> o.s.j.s.ServletContextHandler{/metrics/json,null}
> 16/05/14 23:21:34 INFO handler.ContextHandler: stopped
> o.s.j.s.ServletContextHandler{/stages/stage/kill,null}
> 16/05/14 23:21:34 INFO handler.ContextHandler: stopped
> o.s.j.s.ServletContextHandler{/api,null}
> 16/05/14 23:21:34 INFO handler.ContextHandler: stopped
> o.s.j.s.ServletContextHandler{/,null}
> 16/05/14 23:21:34 INFO handler.ContextHandler: stopped
> o.s.j.s.ServletContextHandler{/static,null}
> 16/05/14 23:21:34 INFO handler.ContextHandler: stopped
> o.s.j.s.ServletContextHandler{/executors/threadDump/json,null}
> 16/05/14 23:21:34 INFO handler.ContextHandler: stopped
> o.s.j.s.ServletContextHandler{/executors/threadDump,null}
> 16/05/14 23:21:34 INFO handler.ContextHandler: stopped
> o.s.j.s.ServletContextHandler{/executors/json,null}
> 16/05/14 23:21:34 INFO handler.ContextHandler: stopped
> o.s.j.s.ServletContextHandler{/executors,null}
> 16/05/14 23:21:34 INFO handler.ContextHandler: stopped
> o.s.j.s.ServletContextHandler{/environment/json,null}
> 16/05/14 23:21:34 INFO handler.ContextHandler: stopped
> o.s.j.s.ServletContextHandler{/environment,null}
> 16/05/14 23:21:34 INFO handler.ContextHandler: stopped
> o.s.j.s.ServletContextHandler{/storage/rdd/json,null}
> 16/05/14 23:21:34 INFO handler.ContextHandler: stopped
> o.s.j.s.ServletContextHandler{/storage/rdd,null}
> 16/05/14 23:21:34 INFO handler.ContextHandler: stopped
> o.s.j.s.ServletContextHandler{/storage/json,null}
> 16/05/14 23:21:34 INFO handler.ContextHandler: stopped
> o.s.j.s.ServletContextHandler{/storage,null}
> 16/05/14 23:21:34 INFO handler.ContextHandler: stopped
> o.s.j.s.ServletContextHandler{/stages/pool/json,null}
> 16/05/14 23:21:34 INFO handler.ContextHandler: stopped
> o.s.j.s.ServletContextHandler{/stages/pool,null}
> 16/05/14 23:21:34 INFO handler.ContextHandler: stopped
> o.s.j.s.ServletContextHandler{/stages/stage/json,null}
> 16/05/14 23:21:34 INFO handler.ContextHandler: stopped
> o.s.j.s.ServletContextHandler{/stages/stage,null}
> 16/05/14 23:21:34 INFO handler.ContextHandler: stopped
> o.s.j.s.ServletContextHandler{/stages/json,null}
> 16/05/14 23:21:34 INFO handler.ContextHandler: stopped
> o.s.j.s.ServletContextHandler{/stages,null}
> 16/05/14 23:21:34 INFO handler.ContextHandler: stopped
> o.s.j.s.ServletContextHandler{/jobs/job/json,null}
> 16/05/14 23:21:34 INFO handler.ContextHandler: stopped
> o.s.j.s.ServletContextHandler{/jobs/job,null}
> 16/05/14 23:21:34 INFO handler.ContextHandler: stopped
> o.s.j.s.ServletContextHandler{/jobs/json,null}
> 16/05/14 23:21:34 INFO handler.ContextHandler: stopped
> o.s.j.s.ServletContextHandler{/jobs,null}
> 16/05/14 23:21:34 INFO ui.SparkUI: Stopped Spark web UI at
> http://10.15.0.11:4040
> 16/05/14 23:21:34 INFO cluster.YarnClientSchedulerBackend: Shutting down all
> executors
> 16/05/14 23:21:34 INFO cluster.YarnClientSchedulerBackend: Asking each
> executor to shut down
> 16/05/14 23:21:34 INFO cluster.YarnClientSchedulerBackend: Stopped
> 16/05/14 23:21:34 INFO spark.MapOutputTrackerMasterEndpoint:
> MapOutputTrackerMasterEndpoint stopped!
> 16/05/14 23:21:34 INFO storage.MemoryStore: MemoryStore cleared
> 16/05/14 23:21:34 INFO storage.BlockManager: BlockManager stopped
> 16/05/14 23:21:34 INFO storage.BlockManagerMaster: BlockManagerMaster stopped
> 16/05/14 23:21:34 INFO
> scheduler.OutputCommitCoordinator$OutputCommitCoordinatorEndpoint:
> OutputCommitCoordinator stopped!
> 16/05/14 23:21:34 INFO remote.RemoteActorRefProvider$RemotingTerminator:
> Shutting down remote daemon.
> 16/05/14 23:21:34 INFO spark.SparkContext: Successfully stopped SparkContext
> 16/05/14 23:21:34 INFO remote.RemoteActorRefProvider$RemotingTerminator:
> Remote daemon shut down; proceeding with flushing remote transports.
> 16/05/14 23:21:34 INFO remote.RemoteActorRefProvider$RemotingTerminator:
> Remoting shut down.
> 16/05/14 23:21:44 INFO cluster.YarnClientSchedulerBackend: SchedulerBackend
> is ready for scheduling beginning after waiting
> maxRegisteredResourcesWaitingTime: 30000(ms)
> 16/05/14 23:21:44 ERROR spark.SparkContext: Error initializing SparkContext.
> java.lang.NullPointerException
> at org.apache.spark.SparkContext.<init>(SparkContext.scala:584)
> at
> org.apache.spark.repl.SparkILoop.createSparkContext(SparkILoop.scala:1017)
> at $line3.$read$$iwC$$iwC.<init>(<console>:15)
> at $line3.$read$$iwC.<init>(<console>:24)
> at $line3.$read.<init>(<console>:26)
> at $line3.$read$.<init>(<console>:30)
> at $line3.$read$.<clinit>(<console>)
> at $line3.$eval$.<init>(<console>:7)
> at $line3.$eval$.<clinit>(<console>)
> at $line3.$eval.$print(<console>)
> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> at
> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
> at
> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> at java.lang.reflect.Method.invoke(Method.java:498)
> at
> org.apache.spark.repl.SparkIMain$ReadEvalPrint.call(SparkIMain.scala:1065)
> at
> org.apache.spark.repl.SparkIMain$Request.loadAndRun(SparkIMain.scala:1346)
> at
> org.apache.spark.repl.SparkIMain.loadAndRunReq$1(SparkIMain.scala:840)
> at org.apache.spark.repl.SparkIMain.interpret(SparkIMain.scala:871)
> at org.apache.spark.repl.SparkIMain.interpret(SparkIMain.scala:819)
> at
> org.apache.spark.repl.SparkILoop.reallyInterpret$1(SparkILoop.scala:857)
> at
> org.apache.spark.repl.SparkILoop.interpretStartingWith(SparkILoop.scala:902)
> at org.apache.spark.repl.SparkILoop.command(SparkILoop.scala:814)
> at
> org.apache.spark.repl.SparkILoopInit$$anonfun$initializeSpark$1.apply(SparkILoopInit.scala:125)
> at
> org.apache.spark.repl.SparkILoopInit$$anonfun$initializeSpark$1.apply(SparkILoopInit.scala:124)
> at
> org.apache.spark.repl.SparkIMain.beQuietDuring(SparkIMain.scala:324)
> at
> org.apache.spark.repl.SparkILoopInit$class.initializeSpark(SparkILoopInit.scala:124)
> at
> org.apache.spark.repl.SparkILoop.initializeSpark(SparkILoop.scala:64)
> at
> org.apache.spark.repl.SparkILoop$$anonfun$org$apache$spark$repl$SparkILoop$$process$1$$anonfun$apply$mcZ$sp$5.apply$mcV$sp(SparkILoop.scala:974)
> at
> org.apache.spark.repl.SparkILoopInit$class.runThunks(SparkILoopInit.scala:159)
> at org.apache.spark.repl.SparkILoop.runThunks(SparkILoop.scala:64)
> at
> org.apache.spark.repl.SparkILoopInit$class.postInitialization(SparkILoopInit.scala:108)
> at
> org.apache.spark.repl.SparkILoop.postInitialization(SparkILoop.scala:64)
> at
> org.apache.spark.repl.SparkILoop$$anonfun$org$apache$spark$repl$SparkILoop$$process$1.apply$mcZ$sp(SparkILoop.scala:991)
> at
> org.apache.spark.repl.SparkILoop$$anonfun$org$apache$spark$repl$SparkILoop$$process$1.apply(SparkILoop.scala:945)
> at
> org.apache.spark.repl.SparkILoop$$anonfun$org$apache$spark$repl$SparkILoop$$process$1.apply(SparkILoop.scala:945)
> at
> scala.tools.nsc.util.ScalaClassLoader$.savingContextLoader(ScalaClassLoader.scala:135)
> at
> org.apache.spark.repl.SparkILoop.org$apache$spark$repl$SparkILoop$$process(SparkILoop.scala:945)
> at org.apache.spark.repl.SparkILoop.process(SparkILoop.scala:1059)
> at org.apache.spark.repl.Main$.main(Main.scala:31)
> at org.apache.spark.repl.Main.main(Main.scala)
> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> at
> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
> at
> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> at java.lang.reflect.Method.invoke(Method.java:498)
> at
> org.apache.spark.deploy.SparkSubmit$.org$apache$spark$deploy$SparkSubmit$$runMain(SparkSubmit.scala:731)
> at
> org.apache.spark.deploy.SparkSubmit$.doRunMain$1(SparkSubmit.scala:181)
> at org.apache.spark.deploy.SparkSubmit$.submit(SparkSubmit.scala:206)
> at org.apache.spark.deploy.SparkSubmit$.main(SparkSubmit.scala:121)
> at org.apache.spark.deploy.SparkSubmit.main(SparkSubmit.scala)
> 16/05/14 23:21:44 INFO spark.SparkContext: SparkContext already stopped.
> java.lang.NullPointerException
> at org.apache.spark.SparkContext.<init>(SparkContext.scala:584)
> at
> org.apache.spark.repl.SparkILoop.createSparkContext(SparkILoop.scala:1017)
> at $iwC$$iwC.<init>(<console>:15)
> at $iwC.<init>(<console>:24)
> at <init>(<console>:26)
> at .<init>(<console>:30)
> at .<clinit>(<console>)
> at .<init>(<console>:7)
> at .<clinit>(<console>)
> at $print(<console>)
> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> at
> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
> at
> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> at java.lang.reflect.Method.invoke(Method.java:498)
> at
> org.apache.spark.repl.SparkIMain$ReadEvalPrint.call(SparkIMain.scala:1065)
> at
> org.apache.spark.repl.SparkIMain$Request.loadAndRun(SparkIMain.scala:1346)
> at
> org.apache.spark.repl.SparkIMain.loadAndRunReq$1(SparkIMain.scala:840)
> at org.apache.spark.repl.SparkIMain.interpret(SparkIMain.scala:871)
> at org.apache.spark.repl.SparkIMain.interpret(SparkIMain.scala:819)
> at
> org.apache.spark.repl.SparkILoop.reallyInterpret$1(SparkILoop.scala:857)
> at
> org.apache.spark.repl.SparkILoop.interpretStartingWith(SparkILoop.scala:902)
> at org.apache.spark.repl.SparkILoop.command(SparkILoop.scala:814)
> at
> org.apache.spark.repl.SparkILoopInit$$anonfun$initializeSpark$1.apply(SparkILoopInit.scala:125)
> at
> org.apache.spark.repl.SparkILoopInit$$anonfun$initializeSpark$1.apply(SparkILoopInit.scala:124)
> at
> org.apache.spark.repl.SparkIMain.beQuietDuring(SparkIMain.scala:324)
> at
> org.apache.spark.repl.SparkILoopInit$class.initializeSpark(SparkILoopInit.scala:124)
> at
> org.apache.spark.repl.SparkILoop.initializeSpark(SparkILoop.scala:64)
> at
> org.apache.spark.repl.SparkILoop$$anonfun$org$apache$spark$repl$SparkILoop$$process$1$$anonfun$apply$mcZ$sp$5.apply$mcV$sp(SparkILoop.scala:974)
> at
> org.apache.spark.repl.SparkILoopInit$class.runThunks(SparkILoopInit.scala:159)
> at org.apache.spark.repl.SparkILoop.runThunks(SparkILoop.scala:64)
> at
> org.apache.spark.repl.SparkILoopInit$class.postInitialization(SparkILoopInit.scala:108)
> at
> org.apache.spark.repl.SparkILoop.postInitialization(SparkILoop.scala:64)
> at
> org.apache.spark.repl.SparkILoop$$anonfun$org$apache$spark$repl$SparkILoop$$process$1.apply$mcZ$sp(SparkILoop.scala:991)
> at
> org.apache.spark.repl.SparkILoop$$anonfun$org$apache$spark$repl$SparkILoop$$process$1.apply(SparkILoop.scala:945)
> at
> org.apache.spark.repl.SparkILoop$$anonfun$org$apache$spark$repl$SparkILoop$$process$1.apply(SparkILoop.scala:945)
> at
> scala.tools.nsc.util.ScalaClassLoader$.savingContextLoader(ScalaClassLoader.scala:135)
> at
> org.apache.spark.repl.SparkILoop.org$apache$spark$repl$SparkILoop$$process(SparkILoop.scala:945)
> at org.apache.spark.repl.SparkILoop.process(SparkILoop.scala:1059)
> at org.apache.spark.repl.Main$.main(Main.scala:31)
> at org.apache.spark.repl.Main.main(Main.scala)
> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> at
> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
> at
> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> at java.lang.reflect.Method.invoke(Method.java:498)
> at
> org.apache.spark.deploy.SparkSubmit$.org$apache$spark$deploy$SparkSubmit$$runMain(SparkSubmit.scala:731)
> at
> org.apache.spark.deploy.SparkSubmit$.doRunMain$1(SparkSubmit.scala:181)
> at org.apache.spark.deploy.SparkSubmit$.submit(SparkSubmit.scala:206)
> at org.apache.spark.deploy.SparkSubmit$.main(SparkSubmit.scala:121)
> at org.apache.spark.deploy.SparkSubmit.main(SparkSubmit.scala)
> java.lang.NullPointerException
> at
> org.apache.spark.sql.SQLContext$.createListenerAndUI(SQLContext.scala:1367)
> at org.apache.spark.sql.hive.HiveContext.<init>(HiveContext.scala:101)
> at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native
> Method)
> at
> sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62)
> at
> sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45)
> at java.lang.reflect.Constructor.newInstance(Constructor.java:423)
> at
> org.apache.spark.repl.SparkILoop.createSQLContext(SparkILoop.scala:1028)
> at $iwC$$iwC.<init>(<console>:15)
> at $iwC.<init>(<console>:24)
> at <init>(<console>:26)
> at .<init>(<console>:30)
> at .<clinit>(<console>)
> at .<init>(<console>:7)
> at .<clinit>(<console>)
> at $print(<console>)
> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> at
> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
> at
> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> at java.lang.reflect.Method.invoke(Method.java:498)
> at
> org.apache.spark.repl.SparkIMain$ReadEvalPrint.call(SparkIMain.scala:1065)
> at
> org.apache.spark.repl.SparkIMain$Request.loadAndRun(SparkIMain.scala:1346)
> at
> org.apache.spark.repl.SparkIMain.loadAndRunReq$1(SparkIMain.scala:840)
> at org.apache.spark.repl.SparkIMain.interpret(SparkIMain.scala:871)
> at org.apache.spark.repl.SparkIMain.interpret(SparkIMain.scala:819)
> at
> org.apache.spark.repl.SparkILoop.reallyInterpret$1(SparkILoop.scala:857)
> at
> org.apache.spark.repl.SparkILoop.interpretStartingWith(SparkILoop.scala:902)
> at org.apache.spark.repl.SparkILoop.command(SparkILoop.scala:814)
> at
> org.apache.spark.repl.SparkILoopInit$$anonfun$initializeSpark$1.apply(SparkILoopInit.scala:132)
> at
> org.apache.spark.repl.SparkILoopInit$$anonfun$initializeSpark$1.apply(SparkILoopInit.scala:124)
> at
> org.apache.spark.repl.SparkIMain.beQuietDuring(SparkIMain.scala:324)
> at
> org.apache.spark.repl.SparkILoopInit$class.initializeSpark(SparkILoopInit.scala:124)
> at
> org.apache.spark.repl.SparkILoop.initializeSpark(SparkILoop.scala:64)
> at
> org.apache.spark.repl.SparkILoop$$anonfun$org$apache$spark$repl$SparkILoop$$process$1$$anonfun$apply$mcZ$sp$5.apply$mcV$sp(SparkILoop.scala:974)
> at
> org.apache.spark.repl.SparkILoopInit$class.runThunks(SparkILoopInit.scala:159)
> at org.apache.spark.repl.SparkILoop.runThunks(SparkILoop.scala:64)
> at
> org.apache.spark.repl.SparkILoopInit$class.postInitialization(SparkILoopInit.scala:108)
> at
> org.apache.spark.repl.SparkILoop.postInitialization(SparkILoop.scala:64)
> at
> org.apache.spark.repl.SparkILoop$$anonfun$org$apache$spark$repl$SparkILoop$$process$1.apply$mcZ$sp(SparkILoop.scala:991)
> at
> org.apache.spark.repl.SparkILoop$$anonfun$org$apache$spark$repl$SparkILoop$$process$1.apply(SparkILoop.scala:945)
> at
> org.apache.spark.repl.SparkILoop$$anonfun$org$apache$spark$repl$SparkILoop$$process$1.apply(SparkILoop.scala:945)
> at
> scala.tools.nsc.util.ScalaClassLoader$.savingContextLoader(ScalaClassLoader.scala:135)
> at
> org.apache.spark.repl.SparkILoop.org$apache$spark$repl$SparkILoop$$process(SparkILoop.scala:945)
> at org.apache.spark.repl.SparkILoop.process(SparkILoop.scala:1059)
> at org.apache.spark.repl.Main$.main(Main.scala:31)
> at org.apache.spark.repl.Main.main(Main.scala)
> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> at
> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
> at
> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> at java.lang.reflect.Method.invoke(Method.java:498)
> at
> org.apache.spark.deploy.SparkSubmit$.org$apache$spark$deploy$SparkSubmit$$runMain(SparkSubmit.scala:731)
> at
> org.apache.spark.deploy.SparkSubmit$.doRunMain$1(SparkSubmit.scala:181)
> at org.apache.spark.deploy.SparkSubmit$.submit(SparkSubmit.scala:206)
> at org.apache.spark.deploy.SparkSubmit$.main(SparkSubmit.scala:121)
> at org.apache.spark.deploy.SparkSubmit.main(SparkSubmit.scala)
> <console>:16: error: not found: value sqlContext
> import sqlContext.implicits._
> ^
> <console>:16: error: not found: value sqlContext
> import sqlContext.sql
> Versions:
> spark-1.6.1-bin-hadoop2.6.tgz and hadoop-2.7.1
> Yarn NodeManager logs:
> 2016-05-15 00:06:03,188 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.container.ContainerImpl:
> Container container_1463267120616_0001_01_000001 transitioned from
> LOCALIZING to LOCALIZED
> 2016-05-15 00:06:03,234 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.container.ContainerImpl:
> Container container_1463267120616_0001_01_000001 transitioned from LOCALIZED
> to RUNNING
> 2016-05-15 00:06:03,243 INFO
> org.apache.hadoop.yarn.server.nodemanager.DefaultContainerExecutor:
> launchContainer: [bash,
> /tmp/hadoop-hadoopadmin/nm-local-dir/usercache/hadoopadmin/appcache/application_1463267120616_0001/container_1463267120616_0001_01_000001/default_container_executor.sh]
> 2016-05-15 00:06:05,144 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.monitor.ContainersMonitorImpl:
> Starting resource-monitoring for container_1463267120616_0001_01_000001
> 2016-05-15 00:06:05,271 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.monitor.ContainersMonitorImpl:
> Memory usage of ProcessTree 10000 for container-id
> container_1463267120616_0001_01_000001: 125.3 MB of 1 GB physical memory
> used; 2.1 GB of 2.1 GB virtual memory used
> 2016-05-15 00:06:07,045 INFO SecurityLogger.org.apache.hadoop.ipc.Server:
> Auth successful for appattempt_1463267120616_0001_000001 (auth:SIMPLE)
> 2016-05-15 00:06:07,063 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.ContainerManagerImpl:
> Start request for container_1463267120616_0001_01_000002 by user hadoopadmin
> 2016-05-15 00:06:07,064 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.application.ApplicationImpl:
> Adding container_1463267120616_0001_01_000002 to application
> application_1463267120616_0001
> 2016-05-15 00:06:07,065 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.container.ContainerImpl:
> Container container_1463267120616_0001_01_000002 transitioned from NEW to
> LOCALIZING
> 2016-05-15 00:06:07,065 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.AuxServices: Got
> event CONTAINER_INIT for appId application_1463267120616_0001
> 2016-05-15 00:06:07,065 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.container.ContainerImpl:
> Container container_1463267120616_0001_01_000002 transitioned from
> LOCALIZING to LOCALIZED
> 2016-05-15 00:06:07,064 INFO
> org.apache.hadoop.yarn.server.nodemanager.NMAuditLogger: USER=hadoopadmin
> IP=10.15.0.11 OPERATION=Start Container Request
> TARGET=ContainerManageImpl RESULT=SUCCESS
> APPID=application_1463267120616_0001
> CONTAINERID=container_1463267120616_0001_01_000002
> 2016-05-15 00:06:07,192 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.container.ContainerImpl:
> Container container_1463267120616_0001_01_000002 transitioned from LOCALIZED
> to RUNNING
> 2016-05-15 00:06:07,213 INFO
> org.apache.hadoop.yarn.server.nodemanager.DefaultContainerExecutor:
> launchContainer: [bash,
> /tmp/hadoop-hadoopadmin/nm-local-dir/usercache/hadoopadmin/appcache/application_1463267120616_0001/container_1463267120616_0001_01_000002/default_container_executor.sh]
> 2016-05-15 00:06:07,972 INFO SecurityLogger.org.apache.hadoop.ipc.Server:
> Auth successful for appattempt_1463267120616_0001_000001 (auth:SIMPLE)
> 2016-05-15 00:06:07,987 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.ContainerManagerImpl:
> Start request for container_1463267120616_0001_01_000003 by user hadoopadmin
> 2016-05-15 00:06:07,988 INFO
> org.apache.hadoop.yarn.server.nodemanager.NMAuditLogger: USER=hadoopadmin
> IP=10.15.0.11 OPERATION=Start Container Request
> TARGET=ContainerManageImpl RESULT=SUCCESS
> APPID=application_1463267120616_0001
> CONTAINERID=container_1463267120616_0001_01_000003
> 2016-05-15 00:06:07,988 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.application.ApplicationImpl:
> Adding container_1463267120616_0001_01_000003 to application
> application_1463267120616_0001
> 2016-05-15 00:06:07,988 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.container.ContainerImpl:
> Container container_1463267120616_0001_01_000003 transitioned from NEW to
> LOCALIZING
> 2016-05-15 00:06:07,989 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.AuxServices: Got
> event CONTAINER_INIT for appId application_1463267120616_0001
> 2016-05-15 00:06:07,989 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.container.ContainerImpl:
> Container container_1463267120616_0001_01_000003 transitioned from
> LOCALIZING to LOCALIZED
> 2016-05-15 00:06:08,099 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.container.ContainerImpl:
> Container container_1463267120616_0001_01_000003 transitioned from LOCALIZED
> to RUNNING
> 2016-05-15 00:06:08,117 INFO
> org.apache.hadoop.yarn.server.nodemanager.DefaultContainerExecutor:
> launchContainer: [bash,
> /tmp/hadoop-hadoopadmin/nm-local-dir/usercache/hadoopadmin/appcache/application_1463267120616_0001/container_1463267120616_0001_01_000003/default_container_executor.sh]
> 2016-05-15 00:06:08,271 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.monitor.ContainersMonitorImpl:
> Starting resource-monitoring for container_1463267120616_0001_01_000002
> 2016-05-15 00:06:08,272 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.monitor.ContainersMonitorImpl:
> Starting resource-monitoring for container_1463267120616_0001_01_000003
> 2016-05-15 00:06:08,368 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.monitor.ContainersMonitorImpl:
> Memory usage of ProcessTree 10000 for container-id
> container_1463267120616_0001_01_000001: 264.2 MB of 1 GB physical memory
> used; 2.2 GB of 2.1 GB virtual memory used
> 2016-05-15 00:06:08,368 WARN
> org.apache.hadoop.yarn.server.nodemanager.containermanager.monitor.ContainersMonitorImpl:
> Process tree for container: container_1463267120616_0001_01_000001 has
> processes older than 1 iteration running over the configured limit.
> Limit=2254857728, current usage = 2331357184
> 2016-05-15 00:06:08,374 WARN
> org.apache.hadoop.yarn.server.nodemanager.containermanager.monitor.ContainersMonitorImpl:
> Container [pid=10000,containerID=container_1463267120616_0001_01_000001] is
> running beyond virtual memory limits. Current usage: 264.2 MB of 1 GB
> physical memory used; 2.2 GB of 2.1 GB virtual memory used. Killing container.
> Dump of the process-tree for container_1463267120616_0001_01_000001 :
> |- PID PPID PGRPID SESSID CMD_NAME USER_MODE_TIME(MILLIS)
> SYSTEM_TIME(MILLIS) VMEM_USAGE(BYTES) RSSMEM_USAGE(PAGES) FULL_CMD_LINE
> |- 10000 9998 10000 10000 (bash) 0 0 17043456 309 /bin/bash -c
> /usr/lib/jvm/java-8-oracle/bin/java -server -Xmx512m
> -Djava.io.tmpdir=/tmp/hadoop-hadoopadmin/nm-local-dir/usercache/hadoopadmin/appcache/application_1463267120616_0001/container_1463267120616_0001_01_000001/tmp
>
> -Dspark.yarn.app.container.log.dir=/usr/local/hadoop-2.7.1/logs/userlogs/application_1463267120616_0001/container_1463267120616_0001_01_000001
> org.apache.spark.deploy.yarn.ExecutorLauncher --arg '10.15.0.11:49099'
> --executor-memory 1024m --executor-cores 1 --properties-file
> /tmp/hadoop-hadoopadmin/nm-local-dir/usercache/hadoopadmin/appcache/application_1463267120616_0001/container_1463267120616_0001_01_000001/__spark_conf__/__spark_conf__.properties
> 1>
> /usr/local/hadoop-2.7.1/logs/userlogs/application_1463267120616_0001/container_1463267120616_0001_01_000001/stdout
> 2>
> /usr/local/hadoop-2.7.1/logs/userlogs/application_1463267120616_0001/container_1463267120616_0001_01_000001/stderr
> |- 10004 10000 10000 10000 (java) 639 27 2314313728 67323
> /usr/lib/jvm/java-8-oracle/bin/java -server -Xmx512m
> -Djava.io.tmpdir=/tmp/hadoop-hadoopadmin/nm-local-dir/usercache/hadoopadmin/appcache/application_1463267120616_0001/container_1463267120616_0001_01_000001/tmp
>
> -Dspark.yarn.app.container.log.dir=/usr/local/hadoop-2.7.1/logs/userlogs/application_1463267120616_0001/container_1463267120616_0001_01_000001
> org.apache.spark.deploy.yarn.ExecutorLauncher --arg 10.15.0.11:49099
> --executor-memory 1024m --executor-cores 1 --properties-file
> /tmp/hadoop-hadoopadmin/nm-local-dir/usercache/hadoopadmin/appcache/application_1463267120616_0001/container_1463267120616_0001_01_000001/__spark_conf__/__spark_conf__.properties
> 2016-05-15 00:06:08,382 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.container.ContainerImpl:
> Container container_1463267120616_0001_01_000001 transitioned from RUNNING
> to KILLING
> 2016-05-15 00:06:08,382 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.launcher.ContainerLaunch:
> Cleaning up container container_1463267120616_0001_01_000001
> 2016-05-15 00:06:08,383 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.monitor.ContainersMonitorImpl:
> Removed ProcessTree with root 10000
> 2016-05-15 00:06:08,457 WARN
> org.apache.hadoop.yarn.server.nodemanager.DefaultContainerExecutor: Exit code
> from container container_1463267120616_0001_01_000001 is : 143
> 2016-05-15 00:06:08,516 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.monitor.ContainersMonitorImpl:
> Memory usage of ProcessTree 10043 for container-id
> container_1463267120616_0001_01_000002: 83.0 MB of 2 GB physical memory used;
> 2.6 GB of 4.2 GB virtual memory used
> 2016-05-15 00:06:08,562 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.container.ContainerImpl:
> Container container_1463267120616_0001_01_000001 transitioned from KILLING
> to CONTAINER_CLEANEDUP_AFTER_KILL
> 2016-05-15 00:06:08,582 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.monitor.ContainersMonitorImpl:
> Memory usage of ProcessTree 10067 for container-id
> container_1463267120616_0001_01_000003: 43.2 MB of 2 GB physical memory used;
> 2.6 GB of 4.2 GB virtual memory used
> 2016-05-15 00:06:08,583 INFO
> org.apache.hadoop.yarn.server.nodemanager.DefaultContainerExecutor: Deleting
> absolute path :
> /tmp/hadoop-hadoopadmin/nm-local-dir/usercache/hadoopadmin/appcache/application_1463267120616_0001/container_1463267120616_0001_01_000001
> 2016-05-15 00:06:08,585 INFO
> org.apache.hadoop.yarn.server.nodemanager.NMAuditLogger: USER=hadoopadmin
> OPERATION=Container Finished - Killed TARGET=ContainerImpl
> RESULT=SUCCESS APPID=application_1463267120616_0001
> CONTAINERID=container_1463267120616_0001_01_000001
> 2016-05-15 00:06:08,593 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.container.ContainerImpl:
> Container container_1463267120616_0001_01_000001 transitioned from
> CONTAINER_CLEANEDUP_AFTER_KILL to DONE
> 2016-05-15 00:06:08,593 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.application.ApplicationImpl:
> Removing container_1463267120616_0001_01_000001 from application
> application_1463267120616_0001
> 2016-05-15 00:06:08,593 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.AuxServices: Got
> event CONTAINER_STOP for appId application_1463267120616_0001
> 2016-05-15 00:06:09,574 INFO SecurityLogger.org.apache.hadoop.ipc.Server:
> Auth successful for appattempt_1463267120616_0001_000001 (auth:SIMPLE)
> 2016-05-15 00:06:09,601 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.ContainerManagerImpl:
> Stopping container with container Id: container_1463267120616_0001_01_000001
> 2016-05-15 00:06:09,601 INFO
> org.apache.hadoop.yarn.server.nodemanager.NMAuditLogger: USER=hadoopadmin
> IP=10.15.0.11 OPERATION=Stop Container Request
> TARGET=ContainerManageImpl RESULT=SUCCESS
> APPID=application_1463267120616_0001
> CONTAINERID=container_1463267120616_0001_01_000001
> 2016-05-15 00:06:09,608 INFO
> org.apache.hadoop.yarn.server.nodemanager.NodeStatusUpdaterImpl: Removed
> completed containers from NM context: [container_1463267120616_0001_01_000001]
> 2016-05-15 00:06:09,609 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.container.ContainerImpl:
> Container container_1463267120616_0001_01_000002 transitioned from RUNNING
> to KILLING
> 2016-05-15 00:06:09,609 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.container.ContainerImpl:
> Container container_1463267120616_0001_01_000003 transitioned from RUNNING
> to KILLING
> 2016-05-15 00:06:09,609 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.launcher.ContainerLaunch:
> Cleaning up container container_1463267120616_0001_01_000002
> 2016-05-15 00:06:09,661 INFO SecurityLogger.org.apache.hadoop.ipc.Server:
> Auth successful for appattempt_1463267120616_0001_000002 (auth:SIMPLE)
> 2016-05-15 00:06:09,689 WARN
> org.apache.hadoop.yarn.server.nodemanager.DefaultContainerExecutor: Exit code
> from container container_1463267120616_0001_01_000002 is : 143
> 2016-05-15 00:06:09,710 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.ContainerManagerImpl:
> Start request for container_1463267120616_0001_02_000001 by user hadoopadmin
> 2016-05-15 00:06:09,710 INFO
> org.apache.hadoop.yarn.server.nodemanager.NMAuditLogger: USER=hadoopadmin
> IP=10.15.0.11 OPERATION=Start Container Request
> TARGET=ContainerManageImpl RESULT=SUCCESS
> APPID=application_1463267120616_0001
> CONTAINERID=container_1463267120616_0001_02_000001
> 2016-05-15 00:06:09,734 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.launcher.ContainerLaunch:
> Cleaning up container container_1463267120616_0001_01_000003
> 2016-05-15 00:06:09,767 WARN
> org.apache.hadoop.yarn.server.nodemanager.DefaultContainerExecutor: Exit code
> from container container_1463267120616_0001_01_000003 is : 143
> 2016-05-15 00:06:09,796 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.container.ContainerImpl:
> Container container_1463267120616_0001_01_000002 transitioned from KILLING
> to CONTAINER_CLEANEDUP_AFTER_KILL
> 2016-05-15 00:06:09,796 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.application.ApplicationImpl:
> Adding container_1463267120616_0001_02_000001 to application
> application_1463267120616_0001
> 2016-05-15 00:06:09,796 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.container.ContainerImpl:
> Container container_1463267120616_0001_01_000003 transitioned from KILLING
> to CONTAINER_CLEANEDUP_AFTER_KILL
> 2016-05-15 00:06:09,796 INFO
> org.apache.hadoop.yarn.server.nodemanager.DefaultContainerExecutor: Deleting
> absolute path :
> /tmp/hadoop-hadoopadmin/nm-local-dir/usercache/hadoopadmin/appcache/application_1463267120616_0001/container_1463267120616_0001_01_000002
> 2016-05-15 00:06:09,797 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.container.ContainerImpl:
> Container container_1463267120616_0001_02_000001 transitioned from NEW to
> LOCALIZING
> 2016-05-15 00:06:09,797 INFO
> org.apache.hadoop.yarn.server.nodemanager.NMAuditLogger: USER=hadoopadmin
> OPERATION=Container Finished - Killed TARGET=ContainerImpl
> RESULT=SUCCESS APPID=application_1463267120616_0001
> CONTAINERID=container_1463267120616_0001_01_000002
> 2016-05-15 00:06:09,797 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.container.ContainerImpl:
> Container container_1463267120616_0001_01_000002 transitioned from
> CONTAINER_CLEANEDUP_AFTER_KILL to DONE
> 2016-05-15 00:06:09,797 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.AuxServices: Got
> event CONTAINER_INIT for appId application_1463267120616_0001
> 2016-05-15 00:06:09,797 INFO
> org.apache.hadoop.yarn.server.nodemanager.DefaultContainerExecutor: Deleting
> absolute path :
> /tmp/hadoop-hadoopadmin/nm-local-dir/usercache/hadoopadmin/appcache/application_1463267120616_0001/container_1463267120616_0001_01_000003
> 2016-05-15 00:06:09,798 INFO
> org.apache.hadoop.yarn.server.nodemanager.NMAuditLogger: USER=hadoopadmin
> OPERATION=Container Finished - Killed TARGET=ContainerImpl
> RESULT=SUCCESS APPID=application_1463267120616_0001
> CONTAINERID=container_1463267120616_0001_01_000003
> 2016-05-15 00:06:09,798 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.container.ContainerImpl:
> Container container_1463267120616_0001_01_000003 transitioned from
> CONTAINER_CLEANEDUP_AFTER_KILL to DONE
> 2016-05-15 00:06:09,798 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.application.ApplicationImpl:
> Removing container_1463267120616_0001_01_000002 from application
> application_1463267120616_0001
> 2016-05-15 00:06:09,798 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.AuxServices: Got
> event CONTAINER_STOP for appId application_1463267120616_0001
> 2016-05-15 00:06:09,798 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.container.ContainerImpl:
> Container container_1463267120616_0001_02_000001 transitioned from
> LOCALIZING to LOCALIZED
> 2016-05-15 00:06:09,798 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.application.ApplicationImpl:
> Removing container_1463267120616_0001_01_000003 from application
> application_1463267120616_0001
> 2016-05-15 00:06:09,798 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.AuxServices: Got
> event CONTAINER_STOP for appId application_1463267120616_0001
> 2016-05-15 00:06:09,821 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.container.ContainerImpl:
> Container container_1463267120616_0001_02_000001 transitioned from LOCALIZED
> to RUNNING
> 2016-05-15 00:06:09,827 INFO
> org.apache.hadoop.yarn.server.nodemanager.DefaultContainerExecutor:
> launchContainer: [bash,
> /tmp/hadoop-hadoopadmin/nm-local-dir/usercache/hadoopadmin/appcache/application_1463267120616_0001/container_1463267120616_0001_02_000001/default_container_executor.sh]
> 2016-05-15 00:06:11,583 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.monitor.ContainersMonitorImpl:
> Starting resource-monitoring for container_1463267120616_0001_02_000001
> 2016-05-15 00:06:11,583 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.monitor.ContainersMonitorImpl:
> Stopping resource-monitoring for container_1463267120616_0001_01_000001
> 2016-05-15 00:06:11,583 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.monitor.ContainersMonitorImpl:
> Stopping resource-monitoring for container_1463267120616_0001_01_000002
> 2016-05-15 00:06:11,583 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.monitor.ContainersMonitorImpl:
> Stopping resource-monitoring for container_1463267120616_0001_01_000003
> 2016-05-15 00:06:11,668 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.monitor.ContainersMonitorImpl:
> Memory usage of ProcessTree 10121 for container-id
> container_1463267120616_0001_02_000001: 121.8 MB of 1 GB physical memory
> used; 2.1 GB of 2.1 GB virtual memory used
> 2016-05-15 00:06:13,645 INFO
> org.apache.hadoop.yarn.server.nodemanager.NodeStatusUpdaterImpl: Removed
> completed containers from NM context:
> [container_1463267120616_0001_01_000002,
> container_1463267120616_0001_01_000003]
> 2016-05-15 00:06:14,567 INFO SecurityLogger.org.apache.hadoop.ipc.Server:
> Auth successful for appattempt_1463267120616_0001_000002 (auth:SIMPLE)
> 2016-05-15 00:06:14,571 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.ContainerManagerImpl:
> Start request for container_1463267120616_0001_02_000002 by user hadoopadmin
> 2016-05-15 00:06:14,572 INFO
> org.apache.hadoop.yarn.server.nodemanager.NMAuditLogger: USER=hadoopadmin
> IP=10.15.0.11 OPERATION=Start Container Request
> TARGET=ContainerManageImpl RESULT=SUCCESS
> APPID=application_1463267120616_0001
> CONTAINERID=container_1463267120616_0001_02_000002
> 2016-05-15 00:06:14,572 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.application.ApplicationImpl:
> Adding container_1463267120616_0001_02_000002 to application
> application_1463267120616_0001
> 2016-05-15 00:06:14,572 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.container.ContainerImpl:
> Container container_1463267120616_0001_02_000002 transitioned from NEW to
> LOCALIZING
> 2016-05-15 00:06:14,572 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.AuxServices: Got
> event CONTAINER_INIT for appId application_1463267120616_0001
> 2016-05-15 00:06:14,573 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.container.ContainerImpl:
> Container container_1463267120616_0001_02_000002 transitioned from
> LOCALIZING to LOCALIZED
> 2016-05-15 00:06:14,594 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.container.ContainerImpl:
> Container container_1463267120616_0001_02_000002 transitioned from LOCALIZED
> to RUNNING
> 2016-05-15 00:06:14,597 INFO
> org.apache.hadoop.yarn.server.nodemanager.DefaultContainerExecutor:
> launchContainer: [bash,
> /tmp/hadoop-hadoopadmin/nm-local-dir/usercache/hadoopadmin/appcache/application_1463267120616_0001/container_1463267120616_0001_02_000002/default_container_executor.sh]
> 2016-05-15 00:06:14,668 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.monitor.ContainersMonitorImpl:
> Starting resource-monitoring for container_1463267120616_0001_02_000002
> 2016-05-15 00:06:14,700 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.monitor.ContainersMonitorImpl:
> Memory usage of ProcessTree 10159 for container-id
> container_1463267120616_0001_02_000002: 23.0 MB of 2 GB physical memory used;
> 2.6 GB of 4.2 GB virtual memory used
> 2016-05-15 00:06:14,722 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.monitor.ContainersMonitorImpl:
> Memory usage of ProcessTree 10121 for container-id
> container_1463267120616_0001_02_000001: 222.1 MB of 1 GB physical memory
> used; 2.1 GB of 2.1 GB virtual memory used
> 2016-05-15 00:06:14,722 WARN
> org.apache.hadoop.yarn.server.nodemanager.containermanager.monitor.ContainersMonitorImpl:
> Process tree for container: container_1463267120616_0001_02_000001 has
> processes older than 1 iteration running over the configured limit.
> Limit=2254857728, current usage = 2285281280
> 2016-05-15 00:06:14,723 WARN
> org.apache.hadoop.yarn.server.nodemanager.containermanager.monitor.ContainersMonitorImpl:
> Container [pid=10121,containerID=container_1463267120616_0001_02_000001] is
> running beyond virtual memory limits. Current usage: 222.1 MB of 1 GB
> physical memory used; 2.1 GB of 2.1 GB virtual memory used. Killing container.
> Dump of the process-tree for container_1463267120616_0001_02_000001 :
> |- PID PPID PGRPID SESSID CMD_NAME USER_MODE_TIME(MILLIS)
> SYSTEM_TIME(MILLIS) VMEM_USAGE(BYTES) RSSMEM_USAGE(PAGES) FULL_CMD_LINE
> |- 10121 10119 10121 10121 (bash) 0 0 17043456 308 /bin/bash -c
> /usr/lib/jvm/java-8-oracle/bin/java -server -Xmx512m
> -Djava.io.tmpdir=/tmp/hadoop-hadoopadmin/nm-local-dir/usercache/hadoopadmin/appcache/application_1463267120616_0001/container_1463267120616_0001_02_000001/tmp
>
> -Dspark.yarn.app.container.log.dir=/usr/local/hadoop-2.7.1/logs/userlogs/application_1463267120616_0001/container_1463267120616_0001_02_000001
> org.apache.spark.deploy.yarn.ExecutorLauncher --arg '10.15.0.11:49099'
> --executor-memory 1024m --executor-cores 1 --properties-file
> /tmp/hadoop-hadoopadmin/nm-local-dir/usercache/hadoopadmin/appcache/application_1463267120616_0001/container_1463267120616_0001_02_000001/__spark_conf__/__spark_conf__.properties
> 1>
> /usr/local/hadoop-2.7.1/logs/userlogs/application_1463267120616_0001/container_1463267120616_0001_02_000001/stdout
> 2>
> /usr/local/hadoop-2.7.1/logs/userlogs/application_1463267120616_0001/container_1463267120616_0001_02_000001/stderr
> |- 10125 10121 10121 10121 (java) 524 28 2268237824 56548
> /usr/lib/jvm/java-8-oracle/bin/java -server -Xmx512m
> -Djava.io.tmpdir=/tmp/hadoop-hadoopadmin/nm-local-dir/usercache/hadoopadmin/appcache/application_1463267120616_0001/container_1463267120616_0001_02_000001/tmp
>
> -Dspark.yarn.app.container.log.dir=/usr/local/hadoop-2.7.1/logs/userlogs/application_1463267120616_0001/container_1463267120616_0001_02_000001
> org.apache.spark.deploy.yarn.ExecutorLauncher --arg 10.15.0.11:49099
> --executor-memory 1024m --executor-cores 1 --properties-file
> /tmp/hadoop-hadoopadmin/nm-local-dir/usercache/hadoopadmin/appcache/application_1463267120616_0001/container_1463267120616_0001_02_000001/__spark_conf__/__spark_conf__.properties
> 2016-05-15 00:06:14,723 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.container.ContainerImpl:
> Container container_1463267120616_0001_02_000001 transitioned from RUNNING
> to KILLING
> 2016-05-15 00:06:14,723 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.launcher.ContainerLaunch:
> Cleaning up container container_1463267120616_0001_02_000001
> 2016-05-15 00:06:14,724 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.monitor.ContainersMonitorImpl:
> Removed ProcessTree with root 10121
> 2016-05-15 00:06:14,762 WARN
> org.apache.hadoop.yarn.server.nodemanager.DefaultContainerExecutor: Exit code
> from container container_1463267120616_0001_02_000001 is : 143
> 2016-05-15 00:06:14,784 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.container.ContainerImpl:
> Container container_1463267120616_0001_02_000001 transitioned from KILLING
> to CONTAINER_CLEANEDUP_AFTER_KILL
> 2016-05-15 00:06:14,785 INFO
> org.apache.hadoop.yarn.server.nodemanager.DefaultContainerExecutor: Deleting
> absolute path :
> /tmp/hadoop-hadoopadmin/nm-local-dir/usercache/hadoopadmin/appcache/application_1463267120616_0001/container_1463267120616_0001_02_000001
> 2016-05-15 00:06:14,791 INFO
> org.apache.hadoop.yarn.server.nodemanager.NMAuditLogger: USER=hadoopadmin
> OPERATION=Container Finished - Killed TARGET=ContainerImpl
> RESULT=SUCCESS APPID=application_1463267120616_0001
> CONTAINERID=container_1463267120616_0001_02_000001
> 2016-05-15 00:06:14,791 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.container.ContainerImpl:
> Container container_1463267120616_0001_02_000001 transitioned from
> CONTAINER_CLEANEDUP_AFTER_KILL to DONE
> 2016-05-15 00:06:14,791 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.application.ApplicationImpl:
> Removing container_1463267120616_0001_02_000001 from application
> application_1463267120616_0001
> 2016-05-15 00:06:14,792 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.AuxServices: Got
> event CONTAINER_STOP for appId application_1463267120616_0001
> 2016-05-15 00:06:15,685 INFO SecurityLogger.org.apache.hadoop.ipc.Server:
> Auth successful for appattempt_1463267120616_0001_000002 (auth:SIMPLE)
> 2016-05-15 00:06:15,716 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.ContainerManagerImpl:
> Stopping container with container Id: container_1463267120616_0001_02_000001
> 2016-05-15 00:06:15,717 INFO
> org.apache.hadoop.yarn.server.nodemanager.NMAuditLogger: USER=hadoopadmin
> IP=10.15.0.11 OPERATION=Stop Container Request
> TARGET=ContainerManageImpl RESULT=SUCCESS
> APPID=application_1463267120616_0001
> CONTAINERID=container_1463267120616_0001_02_000001
> 2016-05-15 00:06:15,720 INFO
> org.apache.hadoop.yarn.server.nodemanager.NodeStatusUpdaterImpl: Removed
> completed containers from NM context: [container_1463267120616_0001_02_000001]
> 2016-05-15 00:06:15,724 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.application.ApplicationImpl:
> Application application_1463267120616_0001 transitioned from RUNNING to
> FINISHING_CONTAINERS_WAIT
> 2016-05-15 00:06:15,724 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.container.ContainerImpl:
> Container container_1463267120616_0001_02_000002 transitioned from RUNNING
> to KILLING
> 2016-05-15 00:06:15,724 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.launcher.ContainerLaunch:
> Cleaning up container container_1463267120616_0001_02_000002
> 2016-05-15 00:06:15,759 WARN
> org.apache.hadoop.yarn.server.nodemanager.DefaultContainerExecutor: Exit code
> from container container_1463267120616_0001_02_000002 is : 143
> 2016-05-15 00:06:15,776 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.container.ContainerImpl:
> Container container_1463267120616_0001_02_000002 transitioned from KILLING
> to CONTAINER_CLEANEDUP_AFTER_KILL
> 2016-05-15 00:06:15,777 INFO
> org.apache.hadoop.yarn.server.nodemanager.DefaultContainerExecutor: Deleting
> absolute path :
> /tmp/hadoop-hadoopadmin/nm-local-dir/usercache/hadoopadmin/appcache/application_1463267120616_0001/container_1463267120616_0001_02_000002
> 2016-05-15 00:06:15,778 INFO
> org.apache.hadoop.yarn.server.nodemanager.NMAuditLogger: USER=hadoopadmin
> OPERATION=Container Finished - Killed TARGET=ContainerImpl
> RESULT=SUCCESS APPID=application_1463267120616_0001
> CONTAINERID=container_1463267120616_0001_02_000002
> 2016-05-15 00:06:15,778 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.container.ContainerImpl:
> Container container_1463267120616_0001_02_000002 transitioned from
> CONTAINER_CLEANEDUP_AFTER_KILL to DONE
> 2016-05-15 00:06:15,778 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.application.ApplicationImpl:
> Removing container_1463267120616_0001_02_000002 from application
> application_1463267120616_0001
> 2016-05-15 00:06:15,778 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.application.ApplicationImpl:
> Application application_1463267120616_0001 transitioned from
> FINISHING_CONTAINERS_WAIT to APPLICATION_RESOURCES_CLEANINGUP
> 2016-05-15 00:06:15,778 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.AuxServices: Got
> event CONTAINER_STOP for appId application_1463267120616_0001
> 2016-05-15 00:06:15,779 INFO
> org.apache.hadoop.yarn.server.nodemanager.DefaultContainerExecutor: Deleting
> absolute path :
> /tmp/hadoop-hadoopadmin/nm-local-dir/usercache/hadoopadmin/appcache/application_1463267120616_0001
> 2016-05-15 00:06:15,779 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.AuxServices: Got
> event APPLICATION_STOP for appId application_1463267120616_0001
> 2016-05-15 00:06:15,779 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.application.ApplicationImpl:
> Application application_1463267120616_0001 transitioned from
> APPLICATION_RESOURCES_CLEANINGUP to FINISHED
> 2016-05-15 00:06:15,779 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.loghandler.NonAggregatingLogHandler:
> Scheduling Log Deletion for application: application_1463267120616_0001,
> with delay of 10800 seconds
> 2016-05-15 00:06:16,726 WARN
> org.apache.hadoop.yarn.server.nodemanager.containermanager.ContainerManagerImpl:
> Event EventType: KILL_CONTAINER sent to absent container
> container_1463267120616_0001_02_000002
> 2016-05-15 00:06:17,724 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.monitor.ContainersMonitorImpl:
> Stopping resource-monitoring for container_1463267120616_0001_02_000001
> 2016-05-15 00:06:17,725 INFO
> org.apache.hadoop.yarn.server.nodemanager.containermanager.monitor.ContainersMonitorImpl:
> Stopping resource-monitoring for container_1463267120616_0001_02_000002
> 2016-05-15 03:06:15,785 INFO
> org.apache.hadoop.yarn.server.nodemanager.DefaultContainerExecutor: Deleting
> path : /usr/local/hadoop-2.7.1/logs/userlogs/application_1463267120616_0001
> 2016-05-16 00:05:20,714 INFO
> org.apache.hadoop.yarn.server.nodemanager.security.NMContainerTokenSecretManager:
> Rolling master-key for container-tokens, got key with id -22032173
> 2016-05-16 00:05:20,714 INFO
> org.apache.hadoop.yarn.server.nodemanager.security.NMTokenSecretMan
--
This message was sent by Atlassian JIRA
(v6.3.4#6332)
---------------------------------------------------------------------
To unsubscribe, e-mail: issues-unsubscr...@spark.apache.org
For additional commands, e-mail: issues-h...@spark.apache.org
