一、TThreadedSelectorServer线程模型:
该服务会启动1个AcceptThread, 2个SelectorThread(默认为2个,可设置),一个woker线程池(池的大小可设置),
一个AcceptThread执行accept操作,将accept到的Transport交给SelectorThread线程, AcceptThread中有个balance均衡器分配到SelectorThread;
SelectorThread执行read,write操作,read到一个FrameBuffer(封装了方法名,参数,参数类型等数据,和读取写入,调用方法的操作)交给WorkerProcess线程池执行方法调用。
二、SelectorThread中FrameBuffer读取的过程
每个SelectorThread线程使用FrameBuffer来读取数据。
org.apache.thrift.server.AbstractNonblockingServer.FrameBuffer:
private boolean internalRead() {
try {
if (trans_.read(buffer_) < 0) {
return false;
}
return true;
} catch (IOException e) {
LOGGER.warn("Got an IOException in internalRead!", e);
return false;
}
}
代码中trans 为 TNonblockingSocket对象,
org.apache.thrift.transport.TNonblockingSocket:
public int read(ByteBuffer buffer) throws IOException {
return socketChannel_.read(buffer);
}
实际上就是,从socketChannel中读取数据到FrameBuffer的buffer_ (堆内存) 变量中。
socketChannel的read方法中参数传的就是FrameBuffer的buffer_变量。
public int read(ByteBuffer var1) // var1 即为FrameBuffer的buffer_变量
socketChannel在读取数据到FrameBuffer.buffer_的过程中,使用了sun.nio.ch.Util 和 sun.nio.ch.IOUtil 类来分配临时的直接内存,来实现数据的读取。
sun.nio.ch.Util 类中持有一个线程内的环形缓存区,元素为分配的DirectByteBuffer,每次进行read和write时先从该缓存中拿DirectByteBuffer,条件是其中的DirectByteBuffer的size大于或等于需要的size。
如果没有满足条件的元素,则创建新的DirectByteBuffer,新的使用完后再放回环形缓存区,如果此时缓存区已满则,则释放该DirectByteBuffer:
sun.nio.ch.Util:
小结:
Frame读取数据分两步: 先读取frame的size大小,再读取整个frame的数据
- 读取frameSize(4个字节): 先分配4个字节的堆内存,然后从socketChannel中读取4个字节的数据,过程中从环形缓冲区中产生了或复用了一个字节长度大于等于4的直接内存。
- 读取整个frame数据: 先分配(4 + frameSize)大小的堆内存,接着将frameSize(4个字节)这个int值放入分配的堆内存中,然后从socketChannel中读取一个字节长度为frameSize的数据,同样从socketChannel中读取,过程中从环形缓冲区中产生了或复用了一个字节长度大于等于frameSize的直接内存。
三、java.lang.OutOfMemoryError: Direct buffer memory 分析
监控分析工具介绍:
1. 调整JVM启动参数,如下:
-Dcom.sun.management.jmxremote.port=9988 -Dcom.sun.management.jmxremote.ssl=false -Dcom.sun.management.jmxremote.authenticate=false -XX:+PrintGC -XX:+HeapDumpBeforeFullGC -XX:+HeapDumpAfterFullGC
开启JMX服务,可实现远程通过jconsole.exe 和 jvisualvm.exe 来监控JVM的性能参数,其中jconsole可看到堆外内存的使用情况(使用了BufferPoolMXBean);
开启了JVM做full gc前后做一次dump操作,用于分析堆内存的使用。
2.另外使用Oracle官网上找到的MonBuffers 类来实时监控堆外内存的使用, 代码见附录;
3. Memory Analysis工具用于分析dump文件;
3.tcpdump,wireshake分别用于捕获和分析Thrift服务接收到的字节流。
OOM问题分析过程:
在监控的过程中,发现某个时间点堆外内存急剧上升达到1个多G,
此时jvm做了一次full gc并做了dump操作:
用Memory Analysis 对 java_pid27220.hprof.2 dump文件进行分析
发现在SelectorThread中一个大的字节数组, 长度为1195725860字节,根据对代码的分析,这个字节数组中的数据正是从直接内存读取出来的,这和直接内存激增吻合。
接下来分析这个大的byte[]中的内容:
发现是一个http的get请求数据,就此猜测可能由于Thrfit服务收到http get请求导致内存激增,
重新启动一个Thrift服务,通过浏览器发送一个http get请求,复现了这个问题
并且最后直接内存的字节数也为1195725860和堆中的byte[]长度吻合。
将1195725860减去4等于1195725856,转成16进制等于0x47455420,
通过tcpdump和wireshake分析Thrfit服务收到的http get请求字节包
这个4个字节吻合,证实直接内存激增是由于Thrfit收到http get包导致的。
那为什么会出现OOM呢,我们的JVM参数中有 -XX:MaxDirectMemorySize=2048M, 直接内存是2G。
当同一个SelectorThread收到多次http get请求会复用环形缓存区中的DirectByteBuffer,所以不会导致直接内存的OOM,但是我们默认是2个SelectorThread,则当2个SelectorThread都收到http get请求则,直接内存会达到1195725860×2=2391451720 > 2G
总结:
这次的OOM问题是由于Thrift服务收到HTTP get请求导致, 这应该算Thrift的一个漏洞吧,至于解决方法,Thrfit好像有限制包长度的参数,有待继续研究。
问题已解决,解决方案如下链接:
http://my.oschina.net/shipley/blog/467670
四、附录:
MonBuffers 类:
import java.io.File;
import java.lang.management.BufferPoolMXBean;
import java.lang.management.ManagementFactory;
import java.text.DateFormat;
import java.text.SimpleDateFormat;
import java.util.ArrayList;
import java.util.Date;
import java.util.List;
import java.util.Set;
import javax.management.MBeanServerConnection;
import javax.management.ObjectName;
import javax.management.remote.JMXConnector;
import javax.management.remote.JMXConnectorFactory;
import javax.management.remote.JMXServiceURL;
// Attach API
import com.sun.tools.attach.VirtualMachine;
/**
* Simple tool to attach to running VM to report buffer pool usage.
*/
public class MonBuffers {
static final String CONNECTOR_ADDRESS =
"com.sun.management.jmxremote.localConnectorAddress";
public static void main(String args[]) throws Exception {
// attach to target VM to get connector address
VirtualMachine vm = VirtualMachine.attach(args[0]);
String connectorAddress = vm.getAgentProperties().getProperty(CONNECTOR_ADDRESS);
if (connectorAddress == null) {
// start management agent
String agent = vm.getSystemProperties().getProperty("java.home") +
File.separator + "lib" + File.separator + "management-agent.jar";
vm.loadAgent(agent);
connectorAddress = vm.getAgentProperties().getProperty(CONNECTOR_ADDRESS);
assert connectorAddress != null;
}
// connect to agent
JMXServiceURL url = new JMXServiceURL(connectorAddress);
JMXConnector c = JMXConnectorFactory.connect(url);
MBeanServerConnection server = c.getMBeanServerConnection();
// get the list of pools
Set<ObjectName> mbeans = server.queryNames(
new ObjectName("java.nio:type=BufferPool,*"), null);
List<BufferPoolMXBean> pools = new ArrayList<BufferPoolMXBean>();
for (ObjectName name: mbeans) {
BufferPoolMXBean pool = ManagementFactory
.newPlatformMXBeanProxy(server, name.toString(), BufferPoolMXBean.class);
pools.add(pool);
}
// print headers
for (BufferPoolMXBean pool: pools)
System.out.format(" %18s ", pool.getName());
System.out.println();
System.out.format("%20s", "timestamp");
for (int i=0; i<pools.size(); i++)
System.out.format("%6s %10s %10s ", "Count", "Capacity", "Memory");
System.out.println();
DateFormat df = new SimpleDateFormat("yyyy-MM-dd HH:mm:ss");
// poll and print usage
for (;;) {
System.out.format("%10s", df.format(new Date()));
for (BufferPoolMXBean pool: pools) {
System.out.format("%6d %10d %10d ",
pool.getCount(), pool.getTotalCapacity(), pool.getMemoryUsed());
}
System.out.println();
Thread.sleep(2000);
}
}
}