Statement.setQueryTimeout在Oracle 18c jdbc驱动程序上不起作用

Question

我们在payara 5.2020服务器上有一个J2EE应用程序，它执行一个长时间运行的查询（执行几个小时的PL/SQL）。为了避免超时异常，我们在语句级别使用以下语句：

statement.setQueryTimeout(0);

这使用Oracle jdbc驱动程序版本12c工作，但是当我们迁移到Oracle 18c，并且我们将驱动程序更改为版本18c时，查询执行在15分钟后停止，但有此异常。这段代码适用于Oracle 12，Oracle 18是驱动程序jar中的变化导致了这个问题。该问题已在Linux和Windows机器中重现：

2021-06-14T07:50:01.762+0200|SEVERE: java.sql.SQLRecoverableException: Error de E/S: Socket read interrupted
    at oracle.jdbc.driver.T4CCallableStatement.executeForRows(T4CCallableStatement.java:946)
    at oracle.jdbc.driver.OracleStatement.doExecuteWithTimeout(OracleStatement.java:1136)
    at oracle.jdbc.driver.OraclePreparedStatement.executeInternal(OraclePreparedStatement.java:3640)
    at oracle.jdbc.driver.T4CCallableStatement.executeInternal(T4CCallableStatement.java:1318)
    at oracle.jdbc.driver.OraclePreparedStatement.execute(OraclePreparedStatement.java:3752)
    at oracle.jdbc.driver.OracleCallableStatement.execute(OracleCallableStatement.java:4242)
    at oracle.jdbc.driver.OraclePreparedStatementWrapper.execute(OraclePreparedStatementWrapper.java:1079)
    at com.sun.gjc.spi.base.PreparedStatementWrapper.execute(PreparedStatementWrapper.java:532)
    at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
    at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
    at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
    at java.base/java.lang.reflect.Method.invoke(Method.java:566)
    at com.sun.gjc.spi.jdbc40.ProfiledConnectionWrapper40$1.invoke(ProfiledConnectionWrapper40.java:437)
    at com.sun.proxy.$Proxy324.execute(Unknown Source)
    at org.apache.jsp.index_jsp.callPL(index_jsp.java:49)
    at org.apache.jsp.index_jsp._jspService(index_jsp.java:108)
    at org.apache.jasper.runtime.HttpJspBase.service(HttpJspBase.java:111)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:750)
    at org.apache.jasper.servlet.JspServletWrapper.service(JspServletWrapper.java:411)
    at org.apache.jasper.servlet.JspServlet.serviceJspFile(JspServlet.java:473)
    at org.apache.jasper.servlet.JspServlet.service(JspServlet.java:377)
    at javax.servlet.http.HttpServlet.service(HttpServlet.java:750)
    at org.apache.catalina.core.StandardWrapper.service(StandardWrapper.java:1636)
    at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:259)
    at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:161)
    at org.apache.catalina.core.StandardPipeline.doInvoke(StandardPipeline.java:757)
    at org.apache.catalina.core.StandardPipeline.invoke(StandardPipeline.java:577)
    at com.sun.enterprise.web.WebPipeline.invoke(WebPipeline.java:99)
    at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:158)
    at org.apache.catalina.connector.CoyoteAdapter.doService(CoyoteAdapter.java:371)
    at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:238)
    at com.sun.enterprise.v3.services.impl.ContainerMapper$HttpHandlerCallable.call(ContainerMapper.java:520)
    at com.sun.enterprise.v3.services.impl.ContainerMapper.service(ContainerMapper.java:217)
    at org.glassfish.grizzly.http.server.HttpHandler.runService(HttpHandler.java:182)
    at org.glassfish.grizzly.http.server.HttpHandler.doHandle(HttpHandler.java:156)
    at org.glassfish.grizzly.http.server.HttpServerFilter.handleRead(HttpServerFilter.java:218)
    at org.glassfish.grizzly.filterchain.ExecutorResolver$9.execute(ExecutorResolver.java:95)
    at org.glassfish.grizzly.filterchain.DefaultFilterChain.executeFilter(DefaultFilterChain.java:260)
    at org.glassfish.grizzly.filterchain.DefaultFilterChain.executeChainPart(DefaultFilterChain.java:177)
    at org.glassfish.grizzly.filterchain.DefaultFilterChain.execute(DefaultFilterChain.java:109)
    at org.glassfish.grizzly.filterchain.DefaultFilterChain.process(DefaultFilterChain.java:88)
    at org.glassfish.grizzly.ProcessorExecutor.execute(ProcessorExecutor.java:53)
    at org.glassfish.grizzly.nio.transport.TCPNIOTransport.fireIOEvent(TCPNIOTransport.java:524)
    at org.glassfish.grizzly.strategies.AbstractIOStrategy.fireIOEvent(AbstractIOStrategy.java:89)
    at org.glassfish.grizzly.strategies.WorkerThreadIOStrategy.run0(WorkerThreadIOStrategy.java:94)
    at org.glassfish.grizzly.strategies.WorkerThreadIOStrategy.access$100(WorkerThreadIOStrategy.java:33)
    at org.glassfish.grizzly.strategies.WorkerThreadIOStrategy$WorkerThreadRunnable.run(WorkerThreadIOStrategy.java:114)
    at org.glassfish.grizzly.threadpool.AbstractThreadPool$Worker.doWork(AbstractThreadPool.java:569)
    at org.glassfish.grizzly.threadpool.AbstractThreadPool$Worker.run(AbstractThreadPool.java:549)
    at java.base/java.lang.Thread.run(Thread.java:834)
Caused by: java.io.InterruptedIOException: Socket read interrupted
    at oracle.net.nt.TimeoutSocketChannel.handleInterrupt(TimeoutSocketChannel.java:262)
    at oracle.net.nt.TimeoutSocketChannel.read(TimeoutSocketChannel.java:184)
    at oracle.net.ns.NSProtocolNIO.doSocketRead(NSProtocolNIO.java:544)
    at oracle.net.ns.NIOPacket.readHeader(NIOPacket.java:234)
    at oracle.net.ns.NIOPacket.readPacketFromSocketChannel(NIOPacket.java:174)
    at oracle.net.ns.NIOPacket.readFromSocketChannel(NIOPacket.java:122)
    at oracle.net.ns.NIOPacket.readFromSocketChannel(NIOPacket.java:100)
    at oracle.net.ns.NIONSDataChannel.readDataFromSocketChannel(NIONSDataChannel.java:86)
    at oracle.jdbc.driver.T4CMAREngineNIO.prepareForUnmarshall(T4CMAREngineNIO.java:762)
    at oracle.jdbc.driver.T4CMAREngineNIO.unmarshalUB1(T4CMAREngineNIO.java:427)
    at oracle.jdbc.driver.T4CTTIfun.receive(T4CTTIfun.java:394)
    at oracle.jdbc.driver.T4CTTIfun.doRPC(T4CTTIfun.java:255)
    at oracle.jdbc.driver.T4C8Oall.doOALL(T4C8Oall.java:610)
    at oracle.jdbc.driver.T4CCallableStatement.doOall8(T4CCallableStatement.java:249)
    at oracle.jdbc.driver.T4CCallableStatement.doOall8(T4CCallableStatement.java:82)
    at oracle.jdbc.driver.T4CCallableStatement.executeForRows(T4CCallableStatement.java:924)

似乎传输层已经迁移到java.nio并且方法setQueryTimeout不再是

我们尝试过的事情：

1. 在payara控制台的JDBC连接池高级属性屏幕中将默认语句超时设置为-1。

• oracle.net.CONNECT\u超时
• oracle.net.READ\u超时
• oracle.jdbc.ReadTimeout

资料来源：

• Oracle 18c网络服务最佳做法

4.-由于我们通过payara数据源池访问数据源，我们无法将com.sun.gjc.spi.jdbc40.DataSource40（payara提供的类）强制转换为OracleDataSource，但我们通过编程创建了DataSorce，以设置如图所示的连接属性，并设置上图所示的属性，但它不起作用：

public static Properties oracleProperties() {
    // Already tried -1 and 0
    Properties properties = new Properties();
    properties.put("Oracle.net.CONNECT_TIMEOUT", 0);
    properties.put("Oracle.net.READ_TIMEOUT", 0);
    properties.put("Oracle.jdbc.ReadTimeout", 0);
    return properties;
}

public static OracleDataSource createDataSource() throws Exception {
    OracleDataSource ods = new OracleDataSource();
    ods.setURL("jdbc:oracle:thin:@itauc4602x:1521/BDExp");
    ods.setUser("enevac");
    ods.setPassword("enevac");
    ods.setDataSourceName("OracleXADataSource");
    ods.setLoginTimeout(0);
    // default connection properties to avoid timeoutException
    ods.setConnectionProperties(oracleProperties());
    return ods;
}

1. 有没有人遇到过这个问题，知道如何避免超时限制吗？
2. 为什么是15分钟？根据参考资料，oracle.net.ReadTimeout的默认值为10分钟

更新：为了更详细地解释为什么我认为问题出在驱动程序中以及为什么我放弃了异常的其他可能来源，我假设超时可以从三个来源引发：

• 网络超时：我放弃它，因为我正在本地计算机上针对开发数据库测试payara服务器，中间没有防火墙。
• 数据库服务器：DBA已经检查了Oracle net services配置，没有设置限制来解释15分钟的缩短。此外，在这种情况下，可能会出现一个带有某种ORA xxx错误代码的SQLException。
• JDBC：可以在连接级别、语句级别和事务级别进行设置。正如我在开始时所说的，该代码与oracle 12c驱动程序一起针对oracle 12和oracle 18服务器工作，是驱动程序jar的更改导致代码停止工作

Answer 1

由于默认tcp连接超时，查询执行可能会停止。能否将keepalive属性“oracle.net.keepalive”设置为“true”并进行验证？

Answer 2

最后，在payara池中配置OracleDataSource的“连接属性”自定义属性解决了这个问题。正如@ibre5041所指出的，设置属性oracle.jdbc.javaNetNio=false改变了驱动程序使用的传输层，它开始作为oracle 12c以前的版本工作。

根据Oracle参考，OracleDataSource实现者可以作为java.util.properties对象接收连接属性。

表8-2 Oracle扩展数据源属性

• 名称：connectionProperties

要在Payara管理控制台中为jdbc池设置多值属性，必须将属性设置为（prop1=value1，prop2=value2），（再次感谢Ondro Mihályi）。因此，在我们的案例中，我们设置：

oracle.jdbc.ReadTimeout=0，oracle.jdbc.javaNetNio=false）

作为使用Oracle 18c jdbc驱动程序（每一步都单独测试）的可用和不可用之处的总结：

>

在语句级别设置超时不起作用：

语句。setQueryTimeout（0）

在连接级别使用-1或0设置超时不起作用：

conn.setNetworkTimeout（Executors.newFixedThreadPool（1），超时以毫秒为单位）

使用OracleDataSource在java.util.connection中以编程方式设置超时属性，使其如问题所示工作。

将超时属性设置为JVM属性可以使其在限制低于15分钟时工作，但如果您设置了一个值

因此，这使得查询在10秒后停止：-Doracle.net.CONNECT\u TIMEOUT=10000-Doracle.net.READ\u TIMEOUT=10000-Doracle.jdbc.ReadTimeout=10000

但这会在15分钟后停止：-Doracle.net.CONNECT\u TIMEOUT=-1-Doracle.net.READ\u TIMEOUT=-1-Doracle.jdbc.ReadTimeout=-1

• 将oracle.net.keepAlive=true设置为@Nirmala建议的JVM属性无效。
• 将oracle.jdbc.javaNetNio=false作为JVM属性设置为@ibre5041可以使其正常工作。因此，它指出了java.nio传输层的一些问题

不管怎样，我们打开了一个对Oracle的支持问题，因为jdbc apistatement.setQueryTimeout（0）应该可以工作，而不必配置数据源，我会把响应当案例关闭。