20,808
社区成员
发帖
与我相关
我的任务
分享
<configuration>
<property>
<name>fs.default.name</name>
<value>hdfs://master:9000</value>
</property>
<property>
<name>fs.checkpoint.dir</name>
<value>/data/hadoop/hdfs/namesecondary</value>
</property>
<property>
<name>fs.checkpoint.period</name>
<value>1800</value>
</property>
<property>
<name>fs.checkpoint.size</name>
<value>33554432</value>
</property>
<property>
<name>io.compression.codecs</name>
<value>org.apache.hadoop.io.compress.DefaultCodec,org.apache.hadoop.io.compress.GzipCodec,org.apache.hadoop.io.compress.BZip2Codec</value>
</property>
<property>
<name>fs.trash.interval</name>
<value>1440</value>
</property>
</configuration>
[code=text]
************************************************************/
2014-10-20 03:22:28,760 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: STARTUP_MSG:
/************************************************************
STARTUP_MSG: Starting DataNode
STARTUP_MSG: host = master/192.168.1.100
STARTUP_MSG: args = []
STARTUP_MSG: version = 1.0.3
STARTUP_MSG: build = https://svn.apache.org/repos/asf/hadoop/common/branches/branch-1.0 -r 1335192; compiled by 'hortonfo' on Tue May 8 20:31:25 UTC 2012
************************************************************/
2014-10-20 03:22:29,015 INFO org.apache.hadoop.metrics2.impl.MetricsConfig: loaded properties from hadoop-metrics2.properties
2014-10-20 03:22:29,032 INFO org.apache.hadoop.metrics2.impl.MetricsSourceAdapter: MBean for source MetricsSystem,sub=Stats registered.
2014-10-20 03:22:29,038 INFO org.apache.hadoop.metrics2.impl.MetricsSystemImpl: Scheduled snapshot period at 10 second(s).
2014-10-20 03:22:29,038 INFO org.apache.hadoop.metrics2.impl.MetricsSystemImpl: DataNode metrics system started
2014-10-20 03:22:29,192 INFO org.apache.hadoop.metrics2.impl.MetricsSourceAdapter: MBean for source ugi registered.
2014-10-20 03:22:29,754 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: Registered FSDatasetStatusMBean
2014-10-20 03:22:29,839 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: Opened info server at 50010
2014-10-20 03:22:29,842 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: Balancing bandwith is 1048576 bytes/s
2014-10-20 03:22:29,984 INFO org.mortbay.log: Logging to org.slf4j.impl.Log4jLoggerAdapter(org.mortbay.log) via org.mortbay.log.Slf4jLog
2014-10-20 03:22:30,250 INFO org.apache.hadoop.http.HttpServer: Added global filtersafety (class=org.apache.hadoop.http.HttpServer$QuotingInputFilter)
2014-10-20 03:22:30,260 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: dfs.webhdfs.enabled = false
2014-10-20 03:22:30,260 INFO org.apache.hadoop.http.HttpServer: Port returned by webServer.getConnectors()[0].getLocalPort() before open() is -1. Opening the listener on 50075
2014-10-20 03:22:30,261 INFO org.apache.hadoop.http.HttpServer: listener.getLocalPort() returned 50075 webServer.getConnectors()[0].getLocalPort() returned 50075
2014-10-20 03:22:30,261 INFO org.apache.hadoop.http.HttpServer: Jetty bound to port 50075
2014-10-20 03:22:30,261 INFO org.mortbay.log: jetty-6.1.26
2014-10-20 03:22:30,292 WARN org.mortbay.log: Can't reuse /tmp/Jetty_0_0_0_0_50075_datanode____hwtdwq, using /tmp/Jetty_0_0_0_0_50075_datanode____hwtdwq_2018615579564531004
2014-10-20 03:22:30,781 INFO org.mortbay.log: Started SelectChannelConnector@0.0.0.0:50075
2014-10-20 03:22:30,784 INFO org.apache.hadoop.metrics2.impl.MetricsSourceAdapter: MBean for source jvm registered.
2014-10-20 03:22:30,785 INFO org.apache.hadoop.metrics2.impl.MetricsSourceAdapter: MBean for source DataNode registered.
2014-10-20 03:22:31,873 INFO org.apache.hadoop.metrics2.impl.MetricsSourceAdapter: MBean for source RpcDetailedActivityForPort50020 registered.
2014-10-20 03:22:31,874 INFO org.apache.hadoop.metrics2.impl.MetricsSourceAdapter: MBean for source RpcActivityForPort50020 registered.
2014-10-20 03:22:31,876 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: dnRegistration = DatanodeRegistration(master:50010, storageID=DS-1696742302-192.168.1.100-50010-1413704373290, infoPort=50075, ipcPort=50020)
2014-10-20 03:22:31,884 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: Starting asynchronous block report scan
2014-10-20 03:22:31,892 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: Finished asynchronous block report scan in 8ms
2014-10-20 03:22:31,923 INFO org.apache.hadoop.ipc.Server: Starting SocketReader
2014-10-20 03:22:31,924 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: DatanodeRegistration(192.168.1.100:50010, storageID=DS-1696742302-192.168.1.100-50010-1413704373290, infoPort=50075, ipcPort=50020)In DataNode.run, data = FSDataset{dirpath='/data/hadoop/hdfs/data/current'}
2014-10-20 03:22:31,924 INFO org.apache.hadoop.ipc.Server: IPC Server Responder: starting
2014-10-20 03:22:31,925 INFO org.apache.hadoop.ipc.Server: IPC Server listener on 50020: starting
2014-10-20 03:22:31,942 INFO org.apache.hadoop.ipc.Server: IPC Server handler 0 on 50020: starting
2014-10-20 03:22:31,944 INFO org.apache.hadoop.ipc.Server: IPC Server handler 1 on 50020: starting
2014-10-20 03:22:31,944 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: using BLOCKREPORT_INTERVAL of 3600000msec Initial delay: 0msec
2014-10-20 03:22:31,947 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: Reconciled asynchronous block report against current state in 1 ms
2014-10-20 03:22:31,956 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: BlockReport of 102 blocks took 1 msec to generate and 9 msecs for RPC and NN processing
2014-10-20 03:22:31,956 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: Starting Periodic block scanner.
2014-10-20 03:22:31,957 INFO org.apache.hadoop.ipc.Server: IPC Server handler 2 on 50020: starting
2014-10-20 03:22:31,966 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: Generated rough (lockless) block report in 9 ms
2014-10-20 03:22:31,966 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: Reconciled asynchronous block report against current state in 0 ms
2014-10-20 03:22:32,669 INFO org.apache.hadoop.hdfs.server.datanode.DataBlockScanner: Verification succeeded for blk_3918413853414315562_2376
2014-10-20 03:22:46,957 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: DatanodeCommand action: DNA_REGISTER
2014-10-20 03:22:46,958 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: Starting asynchronous block report scan
2014-10-20 03:22:46,964 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: Finished asynchronous block report scan in 5ms
2014-10-20 03:22:49,964 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: DatanodeCommand action: DNA_REGISTER
2014-10-20 03:22:52,980 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: DatanodeCommand action: DNA_REGISTER
2014-10-20 03:22:55,984 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: DatanodeCommand action: DNA_REGISTER
2014-10-20 03:22:58,982 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: DatanodeCommand action: DNA_REGISTER
2014-10-20 03:23:01,981 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: DatanodeCommand action: DNA_REGISTER
2014-10-20 03:23:04,981 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: DatanodeCommand action: DNA_REGISTER
2014-10-20 03:23:07,993 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: DatanodeCommand action: DNA_REGISTER
2014-10-20 03:23:11,001 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: DatanodeCommand action: DNA_REGISTER
2014-10-20 03:23:14,001 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: DatanodeCommand action: DNA_REGISTER
2014-10-20 03:23:17,000 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: DatanodeCommand action: DNA_REGISTER
2014-10-20 03:23:20,006 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: DatanodeCommand action: DNA_REGISTER
2014-10-20 03:23:23,003 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: DatanodeCommand action: DNA_REGISTER
2014-10-20 03:23:26,006 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: DatanodeCommand action: DNA_REGISTER
2014-10-20 03:23:29,015 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: DatanodeCommand action: DNA_REGISTER
2014-10-20 03:23:32,013 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: DatanodeCommand action: DNA_REGISTER
2014-10-20 03:23:35,033 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: DatanodeCommand action: DNA_REGISTER
2014-10-20 03:23:38,017 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: DatanodeCommand action: DNA_REGISTER
2014-10-20 03:23:41,021 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: DatanodeCommand action: DNA_REGISTER
2014-10-20 03:23:44,035 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: DatanodeCommand action: DNA_REGISTER
2014-10-20 03:23:47,033 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: DatanodeCommand action: DNA_REGISTER
2014-10-20 03:23:50,040 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: DatanodeCommand action: DNA_REGISTER
2014-10-20 03:23:53,038 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: DatanodeCommand action: DNA_REGISTER
2014-10-20 03:23:56,044 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: DatanodeCommand action: DNA_REGISTER
2014-10-20 03:23:59,041 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: DatanodeCommand action: DNA_REGISTER
2014-10-20 03:24:02,044 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: DatanodeCommand action: DNA_REGISTER
2014-10-20 03:24:05,046 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: DatanodeCommand action: DNA_REGISTER
2014-10-20 03:24:08,047 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: DatanodeCommand action: DNA_REGISTER
2014-10-20 03:24:11,050 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: DatanodeCommand action: DNA_REGISTER
2014-10-20 03:24:14,050 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: DatanodeCommand action: DNA_REGISTER
2014-10-20 03:24:17,058 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: DatanodeCommand action: DNA_REGISTER
2014-10-20 03:24:20,068 INFO org.apache.hadoop.hdfs.server.datanode.DataNode: DatanodeCommand action: DNA_REGISTER
[/code]
2014-10-20 03:27:42,614 FATAL org.apache.hadoop.hdfs.StateChange: BLOCK* NameSystem.getDatanode: Data node 192.168.1.101:50010 is attempting to report storage ID DS-1696742302-192.168.1.100-50010-1413704373290. Node 192.168.1.100:50010 is expected to serve this storage.
2014-10-20 03:27:42,617 INFO org.apache.hadoop.hdfs.StateChange: BLOCK* NameSystem.registerDatanode: node registration from 192.168.1.101:50010 storage DS-1696742302-192.168.1.100-50010-1413704373290
2014-10-20 03:27:42,618 INFO org.apache.hadoop.hdfs.StateChange: BLOCK* NameSystem.registerDatanode: node 192.168.1.100:50010 is replaced by 192.168.1.101:50010 with the same storageID DS-1696742302-192.168.1.100-50010-1413704373290
2014-10-20 03:27:42,618 INFO org.apache.hadoop.net.NetworkTopology: Removing a node: /default-rack/192.168.1.100:50010
2014-10-20 03:27:42,618 INFO org.apache.hadoop.net.NetworkTopology: Adding a new node: /default-rack/192.168.1.101:50010
2014-10-20 03:27:44,234 FATAL org.apache.hadoop.hdfs.StateChange: BLOCK* NameSystem.getDatanode: Data node 192.168.1.100:50010 is attempting to report storage ID DS-1696742302-192.168.1.100-50010-1413704373290. Node 192.168.1.101:50010 is expected to serve this storage.
2014-10-20 03:27:44,535 INFO org.apache.hadoop.hdfs.StateChange: BLOCK* NameSystem.registerDatanode: node registration from 192.168.1.100:50010 storage DS-1696742302-192.168.1.100-50010-1413704373290
2014-10-20 03:27:44,536 INFO org.apache.hadoop.hdfs.StateChange: BLOCK* NameSystem.registerDatanode: node 192.168.1.101:50010 is replaced by 192.168.1.100:50010 with the same storageID DS-1696742302-192.168.1.100-50010-1413704373290
2014-10-20 03:27:44,536 INFO org.apache.hadoop.net.NetworkTopology: Removing a node: /default-rack/192.168.1.101:50010
2014-10-20 03:27:44,536 INFO org.apache.hadoop.net.NetworkTopology: Adding a new node: /default-rack/192.168.1.100:50010
2014-10-20 03:27:45,615 FATAL org.apache.hadoop.hdfs.StateChange: BLOCK* NameSystem.getDatanode: Data node 192.168.1.101:50010 is attempting to report storage ID DS-1696742302-192.168.1.100-50010-1413704373290. Node 192.168.1.100:50010 is expected to serve this storage.
2014-10-20 03:27:45,618 INFO org.apache.hadoop.hdfs.StateChange: BLOCK* NameSystem.registerDatanode: node registration from 192.168.1.101:50010 storage DS-1696742302-192.168.1.100-50010-1413704373290
2014-10-20 03:27:45,618 INFO org.apache.hadoop.hdfs.StateChange: BLOCK* NameSystem.registerDatanode: node 192.168.1.100:50010 is replaced by 192.168.1.101:50010 with the same storageID DS-1696742302-192.168.1.100-50010-1413704373290
2014-10-20 03:27:45,618 INFO org.apache.hadoop.net.NetworkTopology: Removing a node: /default-rack/192.168.1.100:50010
2014-10-20 03:27:45,619 INFO org.apache.hadoop.net.NetworkTopology: Adding a new node: /default-rack/192.168.1.101:50010
2014-10-20 03:27:45,939 ERROR org.apache.hadoop.security.UserGroupInformation: PriviledgedActionException as:hadoop cause:org.apache.hadoop.hdfs.server.namenode.SafeModeException: Cannot delete /data/hadoop/mapred/mrsystem. Name node is in safe mode.
The ratio of reported blocks 0.9902 has not reached the threshold 0.9990. Safe mode will be turned off automatically.
2014-10-20 03:27:45,939 INFO org.apache.hadoop.ipc.Server: IPC Server handler 0 on 9000, call delete(/data/hadoop/mapred/mrsystem, true) from 192.168.1.100:59461: error: org.apache.hadoop.hdfs.server.namenode.SafeModeException: Cannot delete /data/hadoop/mapred/mrsystem. Name node is in safe mode.
The ratio of reported blocks 0.9902 has not reached the threshold 0.9990. Safe mode will be turned off automatically.
org.apache.hadoop.hdfs.server.namenode.SafeModeException: Cannot delete /data/hadoop/mapred/mrsystem. Name node is in safe mode.
The ratio of reported blocks 0.9902 has not reached the threshold 0.9990. Safe mode will be turned off automatically.
at org.apache.hadoop.hdfs.server.namenode.FSNamesystem.deleteInternal(FSNamesystem.java:1994)
at org.apache.hadoop.hdfs.server.namenode.FSNamesystem.delete(FSNamesystem.java:1974)
at org.apache.hadoop.hdfs.server.namenode.NameNode.delete(NameNode.java:792)
at sun.reflect.GeneratedMethodAccessor6.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
at java.lang.reflect.Method.invoke(Method.java:597)
at org.apache.hadoop.ipc.RPC$Server.call(RPC.java:563)
at org.apache.hadoop.ipc.Server$Handler$1.run(Server.java:1388)
at org.apache.hadoop.ipc.Server$Handler$1.run(Server.java:1384)
at java.security.AccessController.doPrivileged(Native Method)
at javax.security.auth.Subject.doAs(Subject.java:396)
at org.apache.hadoop.security.UserGroupInformation.doAs(UserGroupInformation.java:1121)
at org.apache.hadoop.ipc.Server$Handler.run(Server.java:1382)
2014-10-20 03:27:47,238 FATAL org.apache.hadoop.hdfs.StateChange: BLOCK* NameSystem.getDatanode: Data node 192.168.1.100:50010 is attempting to report storage ID DS-1696742302-192.168.1.100-50010-1413704373290. Node 192.168.1.101:50010 is expected to serve this storage.
2014-10-20 03:27:47,241 INFO org.apache.hadoop.hdfs.StateChange: BLOCK* NameSystem.registerDatanode: node registration from 192.168.1.100:50010 storage DS-1696742302-192.168.1.100-50010-1413704373290
2014-10-20 03:27:47,241 INFO org.apache.hadoop.hdfs.StateChange: BLOCK* NameSystem.registerDatanode: node 192.168.1.101:50010 is replaced by 192.168.1.100:50010 with the same storageID DS-1696742302-192.168.1.100-50010-1413704373290
2014-10-20 03:27:47,241 INFO org.apache.hadoop.net.NetworkTopology: Removing a node: /default-rack/192.168.1.101:50010
2014-10-20 03:27:47,241 INFO org.apache.hadoop.net.NetworkTopology: Adding a new node: /default-rack/192.168.1.100:50010
2014-10-20 03:27:48,618 FATAL org.apache.hadoop.hdfs.StateChange: BLOCK* NameSystem.getDatanode: Data node 192.168.1.101:50010 is attempting to report storage ID DS-1696742302-192.168.1.100-50010-1413704373290. Node 192.168.1.100:50010 is expected to serve this storage.
2014-10-20 03:27:48,621 INFO org.apache.hadoop.hdfs.StateChange: BLOCK* NameSystem.registerDatanode: node registration from 192.168.1.101:50010 storage DS-1696742302-192.168.1.100-50010-1413704373290
2014-10-20 03:27:48,622 INFO org.apache.hadoop.hdfs.StateChange: BLOCK* NameSystem.registerDatanode: node 192.168.1.100:50010 is replaced by 192.168.1.101:50010 with the same storageID DS-1696742302-192.168.1.100-50010-1413704373290
2014-10-20 03:27:48,622 INFO org.apache.hadoop.net.NetworkTopology: Removing a node: /default-rack/192.168.1.100:50010
2014-10-20 03:27:48,622 INFO org.apache.hadoop.net.NetworkTopology: Adding a new node: /default-rack/192.168.1.101:50010
2014-10-20 03:27:50,238 FATAL org.apache.hadoop.hdfs.StateChange: BLOCK* NameSystem.getDatanode: Data node 192.168.1.100:50010 is attempting to report storage ID DS-1696742302-192.168.1.100-50010-1413704373290. Node 192.168.1.101:50010 is expected to serve this storage.
2014-10-20 03:27:50,239 INFO org.apache.hadoop.hdfs.StateChange: BLOCK* NameSystem.registerDatanode: node registration from 192.168.1.100:50010 storage DS-1696742302-192.168.1.100-50010-1413704373290
2014-10-20 03:27:50,239 INFO org.apache.hadoop.hdfs.StateChange: BLOCK* NameSystem.registerDatanode: node 192.168.1.101:50010 is replaced by 192.168.1.100:50010 with the same storageID DS-1696742302-192.168.1.100-50010-1413704373290
2014-10-20 03:27:50,239 INFO org.apache.hadoop.net.NetworkTopology: Removing a node: /default-rack/192.168.1.101:50010
2014-10-20 03:27:50,239 INFO org.apache.hadoop.net.NetworkTopology: Adding a new node: /default-rack/192.168.1.100:50010
2014-10-20 03:27:51,630 FATAL org.apache.hadoop.hdfs.StateChange: BLOCK* NameSystem.getDatanode: Data node 192.168.1.101:50010 is attempting to report storage ID DS-1696742302-192.168.1.100-50010-1413704373290. Node 192.168.1.100:50010 is expected to serve this storage.
2014-10-20 03:27:51,632 INFO org.apache.hadoop.hdfs.StateChange: BLOCK* NameSystem.registerDatanode: node registration from 192.168.1.101:50010 storage DS-1696742302-192.168.1.100-50010-1413704373290
2014-10-20 03:27:51,632 INFO org.apache.hadoop.hdfs.StateChange: BLOCK* NameSystem.registerDatanode: node 192.168.1.100:50010 is replaced by 192.168.1.101:50010 with the same storageID DS-1696742302-192.168.1.100-50010-1413704373290
2014-10-20 03:27:51,632 INFO org.apache.hadoop.net.NetworkTopology: Removing a node: /default-rack/192.168.1.100:50010
2014-10-20 03:27:51,632 INFO org.apache.hadoop.net.NetworkTopology: Adding a new node: /default-rack/192.168.1.101:50010
2014-10-20 03:27:53,240 FATAL org.apache.hadoop.hdfs.StateChange: BLOCK* NameSystem.getDatanode: Data node 192.168.1.100:50010 is attempting to report storage ID DS-1696742302-192.168.1.100-50010-1413704373290. Node 192.168.1.101:50010 is expected to serve this storage.
2014-10-20 03:27:53,240 INFO org.apache.hadoop.hdfs.StateChange: BLOCK* NameSystem.registerDatanode: node registration from 192.168.1.100:50010 storage DS-1696742302-192.168.1.100-50010-1413704373290
2014-10-20 03:27:53,240 INFO org.apache.hadoop.hdfs.StateChange: BLOCK* NameSystem.registerDatanode: node 192.168.1.101:50010 is replaced by 192.168.1.100:50010 with the same storageID DS-1696742302-192.168.1.100-50010-1413704373290
2014-10-20 03:27:53,240 INFO org.apache.hadoop.net.NetworkTopology: Removing a node: /default-rack/192.168.1.101:50010
2014-10-20 03:27:53,241 INFO org.apache.hadoop.net.NetworkTopology: Adding a new node: /default-rack/192.168.1.100:50010
master datanode