[11u] test NoInvalidateSocketException.java failing since 8274736

[Zhengyu Gu]

Hi Goetz,

Sorry for the delay. I finally found a system that could reproduce this 
failure.

I filed JDK-8280158 [1] to track the issue. I don't think the backport 
is an issue, rather it reveals something wrong / diverge in 11u 
implementation.

Thanks,

-Zhengyu

[1] https://bugs.openjdk.java.net/browse/JDK-8280158

On 1/13/22 04:00, Lindenmaier, Goetz wrote:
> Hi Zhengyu,
> 
> Yes, we see failures every night.
> Tonight:
> Linux aarch64 Ubuntu 18.04 product
> Linux s390 SLES 15.2 fastdebug
> Windows x86_64 Server 2016 fastdebug
> 
> Last night:
> Linux aarch64 Ubuntu 18.04 product
> Linux s390 SLES 15.2 fastdebug
> Windows x86_64 Server 2016 fastdebug
> 
> These three seem to fail with a high probability.
> 
> But we also saw it on
> Linux x86_64 SLES 12.2 fastdebug
> Mac x86_64 11.5.2 fastdebug
> Mac aarch64 11.6.1  fastdebug
> 
> Best regards,
>    Goetz,
> 
> 
> 
> 
>> -----Original Message-----l
>> From: Zhengyu Gu <zgu at redhat.com>
>> Sent: Wednesday, January 12, 2022 4:58 PM
>> To: Lindenmaier, Goetz <goetz.lindenmaier at sap.com>; jdk-updates-
>> dev at openjdk.java.net
>> Cc: Doerr, Martin <martin.doerr at sap.com>; Zeller, Arno
>> <arno.zeller at sap.com>
>> Subject: Re: [11u] test NoInvalidateSocketException.java failing since
>> 8274736
>>
>> Hi Goetz,
>>
>> I could not reproduce on Windows 10 neither, release and fastdebug. Are
>> you still seeing failures?
>>
>> Thanks,
>>
>> -Zhengyu
>>
>> On 1/11/22 09:47, Lindenmaier, Goetz wrote:
>>> Hi Zhengyu,
>>>
>>> we see above test failing since it was pushed to 11.
>>>
>>> It happens on all platforms and machines sporadically, roughly
>>>
>>> every third run.  It fails only in 11.
>>>
>>> It seems not to be related to the two issues mentioned
>>>
>>> In 8274736: 8274524 and 8277970. See also the log below.
>>>
>>> Best regards,
>>>
>>>     Goetz
>>>
>>> …
>>>
>>> 335262374876357: Main Client Thread: *** OPENED NEW SESSION ***:
>>> Session(1640081713614|TLS_AES_256_GCM_SHA384)
>>>
>>> 335262376364735: Client Reader Thread: Started reading from
>>> SSLSocket at 4e5adc37
>>>
>>> 335262388254500: Main Client Thread: Closing SSLSocket at 4e5adc37
>>>
>>> 335262393544543: Main Client Thread: Closed SSLSocket at 4e5adc37
>>>
>>> 335262393794628: Server Reader Thread: Received: -1 bytes of data
>>>
>>> 335262395736985: Client Reader Thread: Exception reading from
>>> SSLSocket at 4e5adc37: java.net.SocketException: Socket closed
>>>
>>> java.net.SocketException: Socket closed
>>>
>>>            at java.base/java.net.SocketInputStream.socketRead0(Native
>> Method)
>>>
>>>            at
>>>
>> java.base/java.net.SocketInputStream.socketRead(SocketInputStream.java:
>> 115)
>>>
>>>            at
>>> java.base/java.net.SocketInputStream.read(SocketInputStream.java:168)
>>>
>>>            at
>>> java.base/java.net.SocketInputStream.read(SocketInputStream.java:140)
>>>
>>>            at
>>>
>> java.base/sun.security.ssl.SSLSocketInputRecord.read(SSLSocketInputRecor
>> d.java:478)
>>>
>>>            at
>>>
>> java.base/sun.security.ssl.SSLSocketInputRecord.readHeader(SSLSocketInpu
>> tRecord.java:472)
>>>
>>>            at
>>>
>> java.base/sun.security.ssl.SSLSocketInputRecord.bytesInCompletePacket(SS
>> LSocketInputRecord.java:70)
>>>
>>>            at
>>>
>> java.base/sun.security.ssl.SSLSocketImpl.readApplicationRecord(SSLSocketI
>> mpl.java:1449)
>>>
>>>            at
>>>
>> java.base/sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketI
>> mpl.java:1060)
>>>
>>>            at
>>>
>> java.base/sun.security.ssl.SSLSocketImpl$AppInputStream.read(SSLSocketI
>> mpl.java:967)
>>>
>>>            at
>>>
>> NoInvalidateSocketException.readFromSSLSocket(NoInvalidateSocketExcept
>> ion.java:249)
>>>
>>>            at
>>>
>> NoInvalidateSocketException$ReaderThread.run(NoInvalidateSocketExcepti
>> on.java:180)
>>>
>>> 335262888066936: Main Client Thread: ***
>>> Session(1640081713614|TLS_AES_256_GCM_SHA384) IS VALID ***
>>>
>>> 335263891069822: Main Client Thread: Opened SSLSocket at 15cf8e42
>>>
>>> 335263891241055: Main Client Thread: Started handshake on
>> SSLSocket at 15cf8e42
>>>
>>> …
>>>
>>> javax.net.ssl|ALL|1A|Server Reader Thread|2021-12-21 10:15:26.646
>>> GMT|SSLSessionImpl.java:242|Session initialized:
>>> Session(1640081713614|TLS_AES_256_GCM_SHA384)
>>>
>>> javax.net.ssl|ALL|10|Client Reader Thread|2021-12-21 10:15:26.661
>>> GMT|SSLSessionImpl.java:242|Session initialized:
>>> Session(1640081713614|TLS_AES_256_GCM_SHA384)
>>>
>>> java.lang.RuntimeException: One or more sessions were improperly
>>> invalidated.
>>>
>>>            at
>>> NoInvalidateSocketException.main(NoInvalidateSocketException.java:88)
>>>
>>>            at
>>> java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native
>>> Method)
>>>
>>>            at
>>>
>> java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMet
>> hodAccessorImpl.java:62)
>>>
>>>            at
>>>
>> java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(Delega
>> tingMethodAccessorImpl.java:43)
>>>
>>>            at java.base/java.lang.reflect.Method.invoke(Method.java:566)
>>>
>>>            at
>>>
>> com.sun.javatest.regtest.agent.MainWrapper$MainThread.run(MainWrapp
>> er.java:127)
>>>
>>>            at java.base/java.lang.Thread.run(Thread.java:829)
>>>
>>> JavaTest Message: Test threw exception: java.lang.RuntimeException: One
>>> or more sessions were improperly invalidated.
>>>
>>> JavaTest Message: shutting down test
>>>
>