现在的位置: 首页 > 综合 > 正文

Client与Server交互的错误信息

2013年12月18日 ⁄ 综合 ⁄ 共 7292字 ⁄ 字号 评论关闭

以下是今天调整了相关日志信息后,再次捕获到的导致错误异常的日志信息。

Client端日志信息:

 

2012-07-09 09:36:12,614 [Thread-181] DEBUG ipc.RPC (RPC.java:invoke(229)) - Call: setReplication 4
2012-07-09 09:36:12,614 [Thread-181] DEBUG ipc.Client (Client.java:sendParam(774)) - IPC Client (47) connection to master/192.168.2.20:8021 from hadoop sending #3183
2012-07-09 09:36:12,614 [Thread-181] DEBUG ipc.Client (Client.java:sendParam(787)) - send end id=3183 dataLength=108
2012-07-09 09:36:12,615 [IPC Client (47) connection to master/192.168.2.20:8021 from hadoop] DEBUG ipc.Client (Client.java:receiveResponse(816)) - IPC Client (47) connection to master/192.168.2.20:8021 from hadoop got value #3183
2012-07-09 09:36:12,615 [Thread-181] DEBUG ipc.RPC (RPC.java:invoke(229)) - Call: getProtocolVersion 1
2012-07-09 09:36:12,639 [Thread-188] DEBUG ipc.Client (Client.java:sendParam(774)) - IPC Client (47) connection to master/192.168.2.20:8020 from hadoop sending #3184
2012-07-09 09:36:12,640 [IPC Client (47) connection to master/192.168.2.20:8020 from hadoop] DEBUG ipc.Client (Client.java:receiveResponse(816)) - IPC Client (47) connection to master/192.168.2.20:8020 from hadoop got value #3182
2012-07-09 09:36:12,640 [Thread-182] DEBUG ipc.RPC (RPC.java:invoke(229)) - Call: setReplication 27
2012-07-09 09:36:12,640 [Thread-188] DEBUG ipc.Client (Client.java:sendParam(787)) - send end id=3184 dataLength=319
2012-07-09 09:36:12,640 [Thread-182] DEBUG ipc.Client (Client.java:sendParam(774)) - IPC Client (47) connection to master/192.168.2.20:8021 from hadoop sending #3185
2012-07-09 09:36:12,641 [Thread-182] DEBUG ipc.Client (Client.java:sendParam(787)) - send end id=3185 dataLength=108
2012-07-09 09:36:12,642 [IPC Client (47) connection to master/192.168.2.20:8021 from hadoop] DEBUG ipc.Client (Client.java:receiveResponse(816)) - IPC Client (47) connection to master/192.168.2.20:8021 from hadoop got value #3185
2012-07-09 09:36:12,642 [Thread-182] DEBUG ipc.RPC (RPC.java:invoke(229)) - Call: getProtocolVersion 2
2012-07-09 09:36:12,656 [Thread-182] DEBUG ipc.Client (Client.java:sendParam(774)) - IPC Client (47) connection to master/192.168.2.20:8020 from hadoop sending #3186
2012-07-09 09:36:12,656 [Thread-182] DEBUG ipc.Client (Client.java:sendParam(787)) - send end id=3186 dataLength=108
2012-07-09 09:36:12,657 [Thread-181] DEBUG ipc.Client (Client.java:sendParam(774)) - IPC Client (47) connection to master/192.168.2.20:8020 from hadoop sending #3187
2012-07-09 09:36:12,657 [IPC Client (47) connection to master/192.168.2.20:8020 from hadoop] DEBUG ipc.Client (Client.java:receiveResponse(816)) - IPC Client (47) connection to master/192.168.2.20:8020 from hadoop got value #3184
2012-07-09 09:36:12,657 [Thread-188] DEBUG ipc.RPC (RPC.java:invoke(229)) - Call: addBlock 18
2012-07-09 09:36:12,657 [Thread-181] DEBUG ipc.Client (Client.java:sendParam(791)) -
send ERROR id=3187

 

 

 

Server端:

2012-07-09 09:36:12,640 [pool-1-thread-18] DEBUG org.apache.hadoop.ipc.Server: IPC Server listener on 8020 readSelector=1
2012-07-09 09:36:12,640 [pool-1-thread-18] DEBUG org.apache.hadoop.ipc.Server: Iteratorsun.nio.ch.SelectionKeyImpl@184a185c
2012-07-09 09:36:12,640 [pool-1-thread-18] DEBUG org.apache.hadoop.ipc.Server: Key is readable---------------192.168.2.20:54143
2012-07-09 09:36:12,640 [pool-1-thread-18] DEBUG org.apache.hadoop.ipc.Server:   -------start read loop----------
2012-07-09 09:36:12,640 [pool-1-thread-18] DEBUG org.apache.hadoop.ipc.Server: get dataLengthBuffer=4
2012-07-09 09:36:12,640 [pool-1-thread-18] DEBUG org.apache.hadoop.ipc.Server: set rpcHeaderRead=true
2012-07-09 09:36:12,640 [pool-1-thread-18] DEBUG org.apache.hadoop.ipc.Server: create data bytes=319
2012-07-09 09:36:12,640 [pool-1-thread-18] DEBUG org.apache.hadoop.ipc.Server: set channelRead!------- =319
2012-07-09 09:36:12,640 [pool-1-thread-18] DEBUG org.apache.hadoop.ipc.Server: set channelRead  data!------- =0
2012-07-09 09:36:12,640 [pool-1-thread-18] DEBUG org.apache.hadoop.ipc.Server: start process request informat bytes size=319
2012-07-09 09:36:12,640 [pool-1-thread-18] DEBUG org.apache.hadoop.ipc.Server:  got #3184
2012-07-09 09:36:12,640 [pool-1-thread-18] DEBUG org.apache.hadoop.ipc.Server: return count=319
2012-07-09 09:36:12,640 [IPC Server handler 244 on 8020] DEBUG org.apache.hadoop.ipc.Server: IPC Server handler 244 on 8020: has #3184 from 192.168      .2.20:54143
2012-07-09 09:36:12,640 [IPC Server handler 244 on 8020] INFO org.apache.hadoop.hdfs.StateChange: BLOCK* NameSystem.allocateBlock: /tmp/hive-hadoop      /hive_2012-07-09_09-34-03_890_1120870095797150533/-mr-10064/74f7c291-a632-4f15-9e11-f685a8b335d4. blk_1835771220904597385_442823
2012-07-09 09:36:12,640 [IPC Server handler 244 on 8020] DEBUG org.apache.hadoop.ipc.Server: Served: addBlock queueTime= 0 procesingTime= 0
2012-07-09 09:36:12,640 [IPC Server handler 244 on 8020] DEBUG org.apache.hadoop.ipc.Server: IPC Server Responder: responding to #3184 from 192.168      .2.20:54143
2012-07-09 09:36:12,640 [IPC Server handler 244 on 8020] DEBUG org.apache.hadoop.ipc.Server: IPC Server Responder: responding to #3184 from 192.168      .2.20:54143 Wrote 539 bytes.
2012-07-09 09:36:12,657 [pool-1-thread-18] DEBUG org.apache.hadoop.ipc.Server: IPC Server listener on 8020 readSelector=1
2012-07-09 09:36:12,657 [pool-1-thread-18] DEBUG org.apache.hadoop.ipc.Server: Iteratorsun.nio.ch.SelectionKeyImpl@184a185c
2012-07-09 09:36:12,657 [pool-1-thread-18] DEBUG org.apache.hadoop.ipc.Server: Key is readable---------------192.168.2.20:54143
2012-07-09 09:36:12,657 [pool-1-thread-18] DEBUG org.apache.hadoop.ipc.Server:   -------start read loop----------
2012-07-09 09:36:12,657 [pool-1-thread-18] DEBUG org.apache.hadoop.ipc.Server: get dataLengthBuffer=4
2012-07-09 09:36:12,657 [pool-1-thread-18] DEBUG org.apache.hadoop.ipc.Server: set rpcHeaderRead=true
2012-07-09 09:36:12,657 [pool-1-thread-18] DEBUG org.apache.hadoop.ipc.Server: create data bytes=108
2012-07-09 09:36:12,657 [pool-1-thread-18] DEBUG org.apache.hadoop.ipc.Server: set channelRead!------- =108
2012-07-09 09:36:12,657 [pool-1-thread-18] DEBUG org.apache.hadoop.ipc.Server: set channelRead  data!------- =0
2012-07-09 09:36:12,657 [pool-1-thread-18] DEBUG org.apache.hadoop.ipc.Server: start process request informat bytes size=108
2012-07-09 09:36:12,657 [pool-1-thread-18] DEBUG org.apache.hadoop.ipc.Server:  got #3186
2012-07-09 09:36:12,657 [pool-1-thread-18] DEBUG org.apache.hadoop.ipc.Server: return count=108
2012-07-09 09:36:12,657 [IPC Server handler 246 on 8020] DEBUG org.apache.hadoop.ipc.Server: IPC Server handler 246 on 8020: has #3186 from 192.168      .2.20:54143
2012-07-09 09:36:12,657 [IPC Server handler 246 on 8020] DEBUG org.apache.hadoop.ipc.Server: Served: getProtocolVersion queueTime= 0 procesingTime=       0
2012-07-09 09:36:12,657 [IPC Server handler 246 on 8020] DEBUG org.apache.hadoop.ipc.Server: IPC Server Responder: responding to #3186 from 192.168      .2.20:54143
2012-07-09 09:36:12,657 [IPC Server handler 246 on 8020] DEBUG org.apache.hadoop.ipc.Server: IPC Server Responder: responding to #3186 from 192.168      .2.20:54143 Wrote 22 bytes.
2012-07-09 09:36:12,657 [pool-1-thread-18] DEBUG org.apache.hadoop.ipc.Server: IPC Server listener on 8020 readSelector=1
2012-07-09 09:36:12,657 [pool-1-thread-18] DEBUG org.apache.hadoop.ipc.Server: Iteratorsun.nio.ch.SelectionKeyImpl@184a185c
2012-07-09 09:36:12,657 [pool-1-thread-18] DEBUG org.apache.hadoop.ipc.Server: Key is readable---------------192.168.2.20:54143
2012-07-09 09:36:12,657 [pool-1-thread-18] DEBUG org.apache.hadoop.ipc.Server:   -------start read loop----------
2012-07-09 09:36:12,657 [pool-1-thread-18] DEBUG org.apache.hadoop.ipc.Server: get dataLengthBuffer=-1
2012-07-09 09:36:12,657 [pool-1-thread-18] DEBUG org.apache.hadoop.ipc.Server: 1count=-1
2012-07-09 09:36:12,657 [pool-1-thread-18] DEBUG org.apache.hadoop.ipc.Server: IPC Server listener on 8020: disconnecting client 192.168.2.20:54143      . Number of active connections: 106 wait for 2 second

抱歉!评论已关闭.