[I can't seem to change the Subject of this email in GMail, sorry for the "(no subject)"]
In my latest test I ran: - the async file server example from the command line - the async reverse proxy example from Eclipse with output redirected to a file - JMeter form the command line. After about 40 minutes, the async file server not only disappeared but crashed the command line window it was running in. I am attributing this for now to Oracle Java 7 lameness. I am going to switch to running all tests under Java 8 and see if that helps. Another round of tests I need to do is to use HTTPS everywhere in stress tests which is what my customer will want to do in the end. Gary On Wed, Nov 21, 2018 at 3:25 PM Gary Gregory <[email protected]> wrote: > Actually, I'm not even sure the dump below is from the same test. I might > have been from a different run. I will run the test again and see if I can > do a CTRL-BREAK after the OOM. > > Gary > > On Wed, Nov 21, 2018 at 3:24 PM Gary Gregory <[email protected]> > wrote: > >> Hi Oleg: >> >> The only thing I got in addition at the time is this dump from the JVM: >> >> # >> # There is insufficient memory for the Java Runtime Environment to >> continue. >> # Native memory allocation (malloc) failed to allocate 1952 bytes for >> AllocateHeap >> # Possible reasons: >> # The system is out of physical RAM or swap space >> # In 32 bit mode, the process size limit was hit >> # Possible solutions: >> # Reduce memory load on the system >> # Increase physical memory or swap space >> # Check if swap backing store is full >> # Use 64 bit Java on a 64 bit OS >> # Decrease Java heap size (-Xmx/-Xms) >> # Decrease number of Java threads >> # Decrease Java thread stack sizes (-Xss) >> # Set larger code cache with -XX:ReservedCodeCacheSize= >> # This output file may be truncated or incomplete. >> # >> # Out of Memory Error (memory/allocation.inline.hpp:61), pid=2832, >> tid=24680 >> # >> # JRE version: Java(TM) SE Runtime Environment (7.0_80-b15) (build >> 1.7.0_80-b15) >> # Java VM: Java HotSpot(TM) 64-Bit Server VM (24.80-b11 mixed mode >> windows-amd64 compressed oops) >> # Failed to write core dump. Minidumps are not enabled by default on >> client versions of Windows >> # >> >> --------------- T H R E A D --------------- >> >> Current thread (0x0000000013412000): JavaThread "server-dispatch-2" >> daemon [_thread_in_Java, id=24680, >> stack(0x0000000013c00000,0x0000000013d00000)] >> >> Stack: [0x0000000013c00000,0x0000000013d00000] >> Java frames: (J=compiled Java code, j=interpreted, Vv=VM code) >> v blob 0x00000000051174fa >> J 723 C2 >> org.apache.hc.core5.http.examples.AsyncFileServerExample$1.handle(Lorg/apache/hc/core5/http/Message;Lorg/apache/hc/core5/http/nio/AsyncServerRequestHandler$ResponseTrigger;Lorg/apache/hc/core5/http/protocol/HttpContext;)V >> (393 bytes) @ 0x00000000053011e8 [0x00000000052ff500+0x1ce8] >> J 581 C2 >> org.apache.hc.core5.http.impl.nio.ServerHttp1StreamDuplexer.consumeHeader(Lorg/apache/hc/core5/http/HttpRequest;Lorg/apache/hc/core5/http/EntityDetails;)V >> (155 bytes) @ 0x00000000052955a4 [0x00000000052940e0+0x14c4] >> J 331 C2 >> org.apache.hc.core5.http.impl.nio.AbstractHttp1StreamDuplexer.onInput()V >> (533 bytes) @ 0x00000000051ee33c [0x00000000051ed980+0x9bc] >> J 328 C2 org.apache.hc.core5.reactor.InternalDataChannel.onIOEvent(I)V >> (378 bytes) @ 0x00000000051d7574 [0x00000000051d71e0+0x394] >> J 230 C2 >> org.apache.hc.core5.reactor.SingleCoreIOReactor.processEvents(Ljava/util/Set;)V >> (67 bytes) @ 0x00000000051b29d4 [0x00000000051b26a0+0x334] >> J 239% C2 org.apache.hc.core5.reactor.SingleCoreIOReactor.doExecute()V >> (165 bytes) @ 0x00000000051b7cc0 [0x00000000051b7c60+0x60] >> j org.apache.hc.core5.reactor.AbstractSingleCoreIOReactor.execute()V+17 >> j org.apache.hc.core5.reactor.IOReactorWorker.run()V+4 >> j java.lang.Thread.run()V+11 >> v ~StubRoutines::call_stub >> >> --------------- P R O C E S S --------------- >> >> Java Threads: ( => current thread ) >> 0x0000000013415800 JavaThread "server-dispatch-4" daemon >> [_thread_in_native, id=20340, stack(0x0000000013e00000,0x0000000013f00000)] >> 0x0000000013414800 JavaThread "server-dispatch-3" daemon >> [_thread_in_native, id=4648, stack(0x0000000013d00000,0x0000000013e00000)] >> =>0x0000000013412000 JavaThread "server-dispatch-2" daemon >> [_thread_in_Java, id=24680, stack(0x0000000013c00000,0x0000000013d00000)] >> 0x000000001340f000 JavaThread "server-dispatch-1" daemon >> [_thread_in_native, id=31940, stack(0x0000000013b00000,0x0000000013c00000)] >> 0x0000000013380000 JavaThread "server-listener-1" daemon >> [_thread_in_native, id=24164, stack(0x0000000013a00000,0x0000000013b00000)] >> 0x000000001194b000 JavaThread "Service Thread" daemon [_thread_blocked, >> id=24752, stack(0x00000000130c0000,0x00000000131c0000)] >> 0x000000001193c000 JavaThread "C2 CompilerThread1" daemon >> [_thread_blocked, id=33576, stack(0x0000000012fc0000,0x00000000130c0000)] >> 0x0000000011937000 JavaThread "C2 CompilerThread0" daemon >> [_thread_blocked, id=20512, stack(0x0000000012ec0000,0x0000000012fc0000)] >> 0x0000000011936000 JavaThread "Attach Listener" daemon >> [_thread_blocked, id=27868, stack(0x0000000012dc0000,0x0000000012ec0000)] >> 0x0000000011932800 JavaThread "Signal Dispatcher" daemon >> [_thread_blocked, id=23832, stack(0x0000000012cc0000,0x0000000012dc0000)] >> 0x00000000118ff800 JavaThread "Finalizer" daemon [_thread_blocked, >> id=11184, stack(0x0000000012bc0000,0x0000000012cc0000)] >> 0x00000000118f6000 JavaThread "Reference Handler" daemon >> [_thread_blocked, id=33464, stack(0x0000000012ac0000,0x0000000012bc0000)] >> 0x0000000004ede800 JavaThread "main" [_thread_blocked, id=24668, >> stack(0x0000000004ee0000,0x0000000004fe0000)] >> >> Other Threads: >> 0x00000000118f2000 VMThread [stack: >> 0x00000000129c0000,0x0000000012ac0000] [id=27732] >> 0x0000000011955800 WatcherThread [stack: >> 0x00000000131c0000,0x00000000132c0000] [id=26368] >> >> VM state:not at safepoint (normal execution) >> >> VM Mutex/Monitor currently owned by a thread: None >> >> Heap >> PSYoungGen total 31232K, used 15150K [0x00000007adc80000, >> 0x00000007b1b80000, 0x0000000800000000) >> eden space 30720K, 49% used >> [0x00000007adc80000,0x00000007aeb43a80,0x00000007afa80000) >> from space 512K, 6% used >> [0x00000007b1b00000,0x00000007b1b08000,0x00000007b1b80000) >> to space 512K, 0% used >> [0x00000007b1a80000,0x00000007b1a80000,0x00000007b1b00000) >> ParOldGen total 167936K, used 893K [0x0000000709600000, >> 0x0000000713a00000, 0x00000007adc80000) >> object space 167936K, 0% used >> [0x0000000709600000,0x00000007096df478,0x0000000713a00000) >> PSPermGen total 21504K, used 5892K [0x0000000704400000, >> 0x0000000705900000, 0x0000000709600000) >> object space 21504K, 27% used >> [0x0000000704400000,0x00000007049c13f8,0x0000000705900000) >> >> Card table byte_map: [0x00000000080e0000,0x00000000088c0000] >> byte_map_base: 0x00000000048be000 >> >> Polling page: 0x0000000003550000 >> >> Code Cache [0x00000000050e0000, 0x0000000005350000, 0x00000000080e0000) >> total_blobs=1033 nmethods=771 adapters=214 free_code_cache=46930Kb >> largest_free_block=47996608 >> >> Compilation events (10 events): >> Event: 1055.206 Thread 0x000000001193c000 nmethod 775 0x00000000053116d0 >> code [0x00000000053118a0, 0x0000000005312c28] >> Event: 1055.206 Thread 0x0000000011937000 nmethod 776 0x000000000519f9d0 >> code [0x000000000519fba0, 0x00000000051a0e88] >> Event: 1055.206 Thread 0x000000001193c000 777 >> sun.nio.cs.StreamEncoder::implFlushBuffer (15 bytes) >> Event: 1055.206 Thread 0x0000000011937000 778 >> sun.nio.cs.StreamEncoder::writeBytes (132 bytes) >> Event: 1055.222 Thread 0x0000000011937000 nmethod 778 0x0000000005316290 >> code [0x0000000005316440, 0x0000000005317308] >> Event: 1055.222 Thread 0x0000000011937000 779 ! >> java.io.PrintStream::write (69 bytes) >> Event: 1055.223 Thread 0x000000001193c000 nmethod 777 0x000000000530fad0 >> code [0x000000000530fc80, 0x0000000005310b48] >> Event: 1055.223 Thread 0x000000001193c000 780 s >> java.io.BufferedOutputStream::write (67 bytes) >> Event: 1055.227 Thread 0x000000001193c000 nmethod 780 0x0000000005313d90 >> code [0x0000000005313ee0, 0x00000000053143e8] >> Event: 1055.234 Thread 0x0000000011937000 nmethod 779 0x0000000005314c90 >> code [0x0000000005314e40, 0x0000000005315b08] >> >> GC Heap History (10 events): >> Event: 1764.694 GC heap before >> {Heap before GC invocations=330 (full 0): >> PSYoungGen total 31232K, used 30784K [0x00000007adc80000, >> 0x00000007b1b80000, 0x0000000800000000) >> eden space 30720K, 100% used >> [0x00000007adc80000,0x00000007afa80000,0x00000007afa80000) >> from space 512K, 12% used >> [0x00000007b1a80000,0x00000007b1a90000,0x00000007b1b00000) >> to space 512K, 0% used >> [0x00000007b1b00000,0x00000007b1b00000,0x00000007b1b80000) >> ParOldGen total 167936K, used 893K [0x0000000709600000, >> 0x0000000713a00000, 0x00000007adc80000) >> object space 167936K, 0% used >> [0x0000000709600000,0x00000007096df478,0x0000000713a00000) >> PSPermGen total 21504K, used 5892K [0x0000000704400000, >> 0x0000000705900000, 0x0000000709600000) >> object space 21504K, 27% used >> [0x0000000704400000,0x00000007049c13f8,0x0000000705900000) >> Event: 1764.695 GC heap after >> Heap after GC invocations=330 (full 0): >> PSYoungGen total 31232K, used 32K [0x00000007adc80000, >> 0x00000007b1b80000, 0x0000000800000000) >> eden space 30720K, 0% used >> [0x00000007adc80000,0x00000007adc80000,0x00000007afa80000) >> from space 512K, 6% used >> [0x00000007b1b00000,0x00000007b1b08000,0x00000007b1b80000) >> to space 512K, 0% used >> [0x00000007b1a80000,0x00000007b1a80000,0x00000007b1b00000) >> ParOldGen total 167936K, used 893K [0x0000000709600000, >> 0x0000000713a00000, 0x00000007adc80000) >> object space 167936K, 0% used >> [0x0000000709600000,0x00000007096df478,0x0000000713a00000) >> PSPermGen total 21504K, used 5892K [0x0000000704400000, >> 0x0000000705900000, 0x0000000709600000) >> object space 21504K, 27% used >> [0x0000000704400000,0x00000007049c13f8,0x0000000705900000) >> } >> Event: 1769.053 GC heap before >> {Heap before GC invocations=331 (full 0): >> PSYoungGen total 31232K, used 30752K [0x00000007adc80000, >> 0x00000007b1b80000, 0x0000000800000000) >> eden space 30720K, 100% used >> [0x00000007adc80000,0x00000007afa80000,0x00000007afa80000) >> from space 512K, 6% used >> [0x00000007b1b00000,0x00000007b1b08000,0x00000007b1b80000) >> to space 512K, 0% used >> [0x00000007b1a80000,0x00000007b1a80000,0x00000007b1b00000) >> ParOldGen total 167936K, used 893K [0x0000000709600000, >> 0x0000000713a00000, 0x00000007adc80000) >> object space 167936K, 0% used >> [0x0000000709600000,0x00000007096df478,0x0000000713a00000) >> PSPermGen total 21504K, used 5892K [0x0000000704400000, >> 0x0000000705900000, 0x0000000709600000) >> object space 21504K, 27% used >> [0x0000000704400000,0x00000007049c13f8,0x0000000705900000) >> Event: 1769.057 GC heap after >> Heap after GC invocations=331 (full 0): >> PSYoungGen total 31232K, used 64K [0x00000007adc80000, >> 0x00000007b1b80000, 0x0000000800000000) >> eden space 30720K, 0% used >> [0x00000007adc80000,0x00000007adc80000,0x00000007afa80000) >> from space 512K, 12% used >> [0x00000007b1a80000,0x00000007b1a90000,0x00000007b1b00000) >> to space 512K, 0% used >> [0x00000007b1b00000,0x00000007b1b00000,0x00000007b1b80000) >> ParOldGen total 167936K, used 893K [0x0000000709600000, >> 0x0000000713a00000, 0x00000007adc80000) >> object space 167936K, 0% used >> [0x0000000709600000,0x00000007096df478,0x0000000713a00000) >> PSPermGen total 21504K, used 5892K [0x0000000704400000, >> 0x0000000705900000, 0x0000000709600000) >> object space 21504K, 27% used >> [0x0000000704400000,0x00000007049c13f8,0x0000000705900000) >> } >> Event: 1774.659 GC heap before >> {Heap before GC invocations=332 (full 0): >> PSYoungGen total 31232K, used 30777K [0x00000007adc80000, >> 0x00000007b1b80000, 0x0000000800000000) >> eden space 30720K, 99% used >> [0x00000007adc80000,0x00000007afa7e5a8,0x00000007afa80000) >> from space 512K, 12% used >> [0x00000007b1a80000,0x00000007b1a90000,0x00000007b1b00000) >> to space 512K, 0% used >> [0x00000007b1b00000,0x00000007b1b00000,0x00000007b1b80000) >> ParOldGen total 167936K, used 893K [0x0000000709600000, >> 0x0000000713a00000, 0x00000007adc80000) >> object space 167936K, 0% used >> [0x0000000709600000,0x00000007096df478,0x0000000713a00000) >> PSPermGen total 21504K, used 5892K [0x0000000704400000, >> 0x0000000705900000, 0x0000000709600000) >> object space 21504K, 27% used >> [0x0000000704400000,0x00000007049c13f8,0x0000000705900000) >> Event: 1774.668 GC heap after >> Heap after GC invocations=332 (full 0): >> PSYoungGen total 31232K, used 32K [0x00000007adc80000, >> 0x00000007b1b80000, 0x0000000800000000) >> eden space 30720K, 0% used >> [0x00000007adc80000,0x00000007adc80000,0x00000007afa80000) >> from space 512K, 6% used >> [0x00000007b1b00000,0x00000007b1b08000,0x00000007b1b80000) >> to space 512K, 0% used >> [0x00000007b1a80000,0x00000007b1a80000,0x00000007b1b00000) >> ParOldGen total 167936K, used 893K [0x0000000709600000, >> 0x0000000713a00000, 0x00000007adc80000) >> object space 167936K, 0% used >> [0x0000000709600000,0x00000007096df478,0x0000000713a00000) >> PSPermGen total 21504K, used 5892K [0x0000000704400000, >> 0x0000000705900000, 0x0000000709600000) >> object space 21504K, 27% used >> [0x0000000704400000,0x00000007049c13f8,0x0000000705900000) >> } >> Event: 1779.136 GC heap before >> {Heap before GC invocations=333 (full 0): >> PSYoungGen total 31232K, used 30752K [0x00000007adc80000, >> 0x00000007b1b80000, 0x0000000800000000) >> eden space 30720K, 100% used >> [0x00000007adc80000,0x00000007afa80000,0x00000007afa80000) >> from space 512K, 6% used >> [0x00000007b1b00000,0x00000007b1b08000,0x00000007b1b80000) >> to space 512K, 0% used >> [0x00000007b1a80000,0x00000007b1a80000,0x00000007b1b00000) >> ParOldGen total 167936K, used 893K [0x0000000709600000, >> 0x0000000713a00000, 0x00000007adc80000) >> object space 167936K, 0% used >> [0x0000000709600000,0x00000007096df478,0x0000000713a00000) >> PSPermGen total 21504K, used 5892K [0x0000000704400000, >> 0x0000000705900000, 0x0000000709600000) >> object space 21504K, 27% used >> [0x0000000704400000,0x00000007049c13f8,0x0000000705900000) >> Event: 1779.137 GC heap after >> Heap after GC invocations=333 (full 0): >> PSYoungGen total 31232K, used 64K [0x00000007adc80000, >> 0x00000007b1b80000, 0x0000000800000000) >> eden space 30720K, 0% used >> [0x00000007adc80000,0x00000007adc80000,0x00000007afa80000) >> from space 512K, 12% used >> [0x00000007b1a80000,0x00000007b1a90000,0x00000007b1b00000) >> to space 512K, 0% used >> [0x00000007b1b00000,0x00000007b1b00000,0x00000007b1b80000) >> ParOldGen total 167936K, used 893K [0x0000000709600000, >> 0x0000000713a00000, 0x00000007adc80000) >> object space 167936K, 0% used >> [0x0000000709600000,0x00000007096df478,0x0000000713a00000) >> PSPermGen total 21504K, used 5892K [0x0000000704400000, >> 0x0000000705900000, 0x0000000709600000) >> object space 21504K, 27% used >> [0x0000000704400000,0x00000007049c13f8,0x0000000705900000) >> } >> Event: 1783.045 GC heap before >> {Heap before GC invocations=334 (full 0): >> PSYoungGen total 31232K, used 30784K [0x00000007adc80000, >> 0x00000007b1b80000, 0x0000000800000000) >> eden space 30720K, 100% used >> [0x00000007adc80000,0x00000007afa80000,0x00000007afa80000) >> from space 512K, 12% used >> [0x00000007b1a80000,0x00000007b1a90000,0x00000007b1b00000) >> to space 512K, 0% used >> [0x00000007b1b00000,0x00000007b1b00000,0x00000007b1b80000) >> ParOldGen total 167936K, used 893K [0x0000000709600000, >> 0x0000000713a00000, 0x00000007adc80000) >> object space 167936K, 0% used >> [0x0000000709600000,0x00000007096df478,0x0000000713a00000) >> PSPermGen total 21504K, used 5892K [0x0000000704400000, >> 0x0000000705900000, 0x0000000709600000) >> object space 21504K, 27% used >> [0x0000000704400000,0x00000007049c13f8,0x0000000705900000) >> Event: 1783.046 GC heap after >> Heap after GC invocations=334 (full 0): >> PSYoungGen total 31232K, used 32K [0x00000007adc80000, >> 0x00000007b1b80000, 0x0000000800000000) >> eden space 30720K, 0% used >> [0x00000007adc80000,0x00000007adc80000,0x00000007afa80000) >> from space 512K, 6% used >> [0x00000007b1b00000,0x00000007b1b08000,0x00000007b1b80000) >> to space 512K, 0% used >> [0x00000007b1a80000,0x00000007b1a80000,0x00000007b1b00000) >> ParOldGen total 167936K, used 893K [0x0000000709600000, >> 0x0000000713a00000, 0x00000007adc80000) >> object space 167936K, 0% used >> [0x0000000709600000,0x00000007096df478,0x0000000713a00000) >> PSPermGen total 21504K, used 5892K [0x0000000704400000, >> 0x0000000705900000, 0x0000000709600000) >> object space 21504K, 27% used >> [0x0000000704400000,0x00000007049c13f8,0x0000000705900000) >> } >> >> Deoptimization events (10 events): >> Event: 147.271 Thread 0x0000000013412000 Uncommon trap: reason=bimorphic >> action=maybe_recompile pc=0x00000000051aca88 >> method=java.util.HashMap.getEntry(Ljava/lang/Object;)Ljava/util/HashMap$Entry; >> @ 68 >> Event: 151.675 Thread 0x0000000013415800 Uncommon trap: reason=bimorphic >> action=maybe_recompile pc=0x00000000051aca88 >> method=java.util.HashMap.getEntry(Ljava/lang/Object;)Ljava/util/HashMap$Entry; >> @ 68 >> Event: 151.678 Thread 0x0000000013415800 Uncommon trap: reason=bimorphic >> action=maybe_recompile pc=0x00000000051aca88 >> method=java.util.HashMap.getEntry(Ljava/lang/Object;)Ljava/util/HashMap$Entry; >> @ 68 >> Event: 153.887 Thread 0x0000000013412000 Uncommon trap: reason=bimorphic >> action=maybe_recompile pc=0x000000000516fe30 >> method=java.util.HashMap.getEntry(Ljava/lang/Object;)Ljava/util/HashMap$Entry; >> @ 68 >> Event: 403.985 Thread 0x0000000013380000 Uncommon trap: >> reason=unstable_if action=reinterpret pc=0x00000000052530b4 >> method=org.apache.hc.core5.reactor.SingleCoreListeningIOReactor.processEvents(I)V >> @ 15 >> Event: 904.452 Thread 0x0000000013414800 Uncommon trap: >> reason=unstable_if action=reinterpret pc=0x0000000005307354 >> method=java.util.GregorianCalendar.computeFields(II)I @ 223 >> Event: 1022.540 Thread 0x000000001340f000 Uncommon trap: >> reason=unstable_if action=reinterpret pc=0x0000000005214638 >> method=java.io.BufferedOutputStream.write([BII)V @ 35 >> Event: 1022.546 Thread 0x0000000013412000 Uncommon trap: >> reason=unstable_if action=reinterpret pc=0x000000000520c110 >> method=java.io.BufferedOutputStream.write([BII)V @ 35 >> Event: 1022.553 Thread 0x0000000013414800 Uncommon trap: >> reason=unstable_if action=reinterpret pc=0x000000000520f050 >> method=java.io.BufferedOutputStream.write([BII)V @ 35 >> Event: 1784.800 Thread 0x0000000013412000 Uncommon trap: >> reason=unstable_if action=reinterpret pc=0x00000000053011e8 >> method=java.io.File.exists()Z @ 34 >> >> Internal exceptions (10 events): >> Event: 1784.782 Thread 0x0000000013414800 Threw 0x00000007aeb030c0 at >> C:\re\jdk7u80\2329\hotspot\src\share\vm\prims\jni.cpp:717 >> Event: 1784.783 Thread 0x0000000013414800 Threw 0x00000007aeb05d90 at >> C:\re\jdk7u80\2329\hotspot\src\share\vm\prims\jni.cpp:717 >> Event: 1784.788 Thread 0x0000000013415800 Threw 0x00000007aeade968 at >> C:\re\jdk7u80\2329\hotspot\src\share\vm\prims\jni.cpp:717 >> Event: 1784.788 Thread 0x0000000013415800 Threw 0x00000007aeadeb10 at >> C:\re\jdk7u80\2329\hotspot\src\share\vm\prims\jni.cpp:717 >> Event: 1784.788 Thread 0x0000000013415800 Threw 0x00000007aeadec88 at >> C:\re\jdk7u80\2329\hotspot\src\share\vm\prims\jni.cpp:717 >> Event: 1784.789 Thread 0x0000000013415800 Threw 0x00000007aeae1958 at >> C:\re\jdk7u80\2329\hotspot\src\share\vm\prims\jni.cpp:717 >> Event: 1784.795 Thread 0x000000001340f000 Threw 0x00000007aeacee78 at >> C:\re\jdk7u80\2329\hotspot\src\share\vm\prims\jni.cpp:717 >> Event: 1784.795 Thread 0x000000001340f000 Threw 0x00000007aeacf020 at >> C:\re\jdk7u80\2329\hotspot\src\share\vm\prims\jni.cpp:717 >> Event: 1784.795 Thread 0x000000001340f000 Threw 0x00000007aeacf198 at >> C:\re\jdk7u80\2329\hotspot\src\share\vm\prims\jni.cpp:717 >> Event: 1784.796 Thread 0x000000001340f000 Threw 0x00000007aead1e68 at >> C:\re\jdk7u80\2329\hotspot\src\share\vm\prims\jni.cpp:717 >> >> Events (10 events): >> Event: 1769.053 Executing VM operation: ParallelGCFailedAllocation >> Event: 1769.057 Executing VM operation: ParallelGCFailedAllocation done >> Event: 1774.659 Executing VM operation: ParallelGCFailedAllocation >> Event: 1774.668 Executing VM operation: ParallelGCFailedAllocation done >> Event: 1779.136 Executing VM operation: ParallelGCFailedAllocation >> Event: 1779.137 Executing VM operation: ParallelGCFailedAllocation done >> Event: 1783.044 Executing VM operation: ParallelGCFailedAllocation >> Event: 1783.046 Executing VM operation: ParallelGCFailedAllocation done >> Event: 1784.800 Thread 0x0000000013412000 Uncommon trap: >> trap_request=0xffffff75 fr.pc=0x00000000053011e8 >> Event: 1784.800 Thread 0x0000000013412000 DEOPT PACKING >> pc=0x00000000053011e8 sp=0x0000000013cfef50 >> >> >> Dynamic libraries: >> 0x00007ff66dee0000 - 0x00007ff66df13000 C:\Program >> Files\Java\jdk1.7.0_80\bin\javaw.exe >> 0x00007ffa04e80000 - 0x00007ffa05060000 C:\WINDOWS\SYSTEM32\ntdll.dll >> 0x00007ffa02880000 - 0x00007ffa0292e000 C:\WINDOWS\System32\KERNEL32.DLL >> 0x00007ffa01e10000 - 0x00007ffa02076000 >> C:\WINDOWS\System32\KERNELBASE.dll >> 0x00007ffa04a20000 - 0x00007ffa04ac1000 C:\WINDOWS\System32\ADVAPI32.dll >> 0x00007ffa04460000 - 0x00007ffa044fd000 C:\WINDOWS\System32\msvcrt.dll >> 0x00007ffa02350000 - 0x00007ffa023ab000 C:\WINDOWS\System32\sechost.dll >> 0x00007ffa023b0000 - 0x00007ffa024cf000 C:\WINDOWS\System32\RPCRT4.dll >> 0x00007ffa026f0000 - 0x00007ffa0287f000 C:\WINDOWS\System32\USER32.dll >> 0x00007ffa014d0000 - 0x00007ffa014f0000 C:\WINDOWS\System32\win32u.dll >> 0x00007ffa04e20000 - 0x00007ffa04e48000 C:\WINDOWS\System32\GDI32.dll >> 0x00007ffa012d0000 - 0x00007ffa01463000 C:\WINDOWS\System32\gdi32full.dll >> 0x00007ffa02100000 - 0x00007ffa0219b000 C:\WINDOWS\System32\msvcp_win.dll >> 0x00007ffa02250000 - 0x00007ffa02345000 C:\WINDOWS\System32\ucrtbase.dll >> 0x00007ff9efca0000 - 0x00007ff9eff09000 >> C:\WINDOWS\WinSxS\amd64_microsoft.windows.common-controls_6595b64144ccf1df_6.0.16299.726_none_15ccdb369361144a\COMCTL32.dll >> 0x00007ffa04710000 - 0x00007ffa04a17000 C:\WINDOWS\System32\combase.dll >> 0x00007ffa02080000 - 0x00007ffa020f2000 >> C:\WINDOWS\System32\bcryptPrimitives.dll >> 0x00007ffa02650000 - 0x00007ffa0267d000 C:\WINDOWS\System32\IMM32.DLL >> 0x0000000072280000 - 0x00000000722b9000 >> C:\PROGRA~2\Sophos\SOPHOS~1\SOPHOS~2.DLL >> 0x00007ffa04510000 - 0x00007ffa04518000 C:\WINDOWS\System32\PSAPI.DLL >> 0x0000000070350000 - 0x0000000070422000 C:\Program >> Files\Java\jdk1.7.0_80\jre\bin\msvcr100.dll >> 0x000000006e430000 - 0x000000006ec09000 C:\Program >> Files\Java\jdk1.7.0_80\jre\bin\server\jvm.dll >> 0x00007ff9e8ce0000 - 0x00007ff9e8ce9000 C:\WINDOWS\SYSTEM32\WSOCK32.dll >> 0x00007ffa02680000 - 0x00007ffa026ec000 C:\WINDOWS\System32\WS2_32.dll >> 0x00007ff9f7d90000 - 0x00007ff9f7db3000 C:\WINDOWS\SYSTEM32\WINMM.dll >> 0x00007ff9f7d30000 - 0x00007ff9f7d5a000 C:\WINDOWS\SYSTEM32\WINMMBASE.dll >> 0x00007ffa01280000 - 0x00007ffa012ca000 C:\WINDOWS\System32\cfgmgr32.dll >> 0x0000000070340000 - 0x000000007034f000 C:\Program >> Files\Java\jdk1.7.0_80\jre\bin\verify.dll >> 0x0000000070310000 - 0x0000000070338000 C:\Program >> Files\Java\jdk1.7.0_80\jre\bin\java.dll >> 0x00000000702f0000 - 0x0000000070306000 C:\Program >> Files\Java\jdk1.7.0_80\jre\bin\zip.dll >> 0x00000000702d0000 - 0x00000000702ea000 C:\Program >> Files\Java\jdk1.7.0_80\jre\bin\net.dll >> 0x00007ffa00a60000 - 0x00007ffa00ac6000 C:\WINDOWS\system32\mswsock.dll >> 0x00000000702b0000 - 0x00000000702c1000 C:\Program >> Files\Java\jdk1.7.0_80\jre\bin\nio.dll >> 0x00007ff9e4200000 - 0x00007ff9e4216000 C:\WINDOWS\system32\napinsp.dll >> 0x00007ff9e41e0000 - 0x00007ff9e41fa000 C:\WINDOWS\system32\pnrpnsp.dll >> 0x00007ff9fa960000 - 0x00007ff9fa978000 C:\WINDOWS\system32\NLAapi.dll >> 0x00007ffa00830000 - 0x00007ffa008e6000 C:\WINDOWS\SYSTEM32\DNSAPI.dll >> 0x00007ffa02ea0000 - 0x00007ffa02ea8000 C:\WINDOWS\System32\NSI.dll >> 0x00007ffa007f0000 - 0x00007ffa00829000 C:\WINDOWS\SYSTEM32\IPHLPAPI.DLL >> 0x00007ff9e8a40000 - 0x00007ff9e8a4e000 C:\WINDOWS\System32\winrnr.dll >> 0x00007ff9e41c0000 - 0x00007ff9e41d5000 C:\WINDOWS\System32\wshbth.dll >> 0x00007ff9f99d0000 - 0x00007ff9f99da000 C:\Windows\System32\rasadhlp.dll >> 0x00007ff9fdc80000 - 0x00007ff9fdcf0000 C:\WINDOWS\System32\fwpuclnt.dll >> 0x00007ffa00d30000 - 0x00007ffa00d55000 C:\WINDOWS\SYSTEM32\bcrypt.dll >> 0x00007ffa00c20000 - 0x00007ffa00c37000 C:\WINDOWS\SYSTEM32\CRYPTSP.dll >> 0x00007ffa00660000 - 0x00007ffa00693000 C:\WINDOWS\system32\rsaenh.dll >> 0x00007ffa01100000 - 0x00007ffa01129000 C:\WINDOWS\SYSTEM32\USERENV.dll >> 0x00007ffa011f0000 - 0x00007ffa0120b000 C:\WINDOWS\System32\profapi.dll >> 0x00007ffa00c40000 - 0x00007ffa00c4b000 C:\WINDOWS\SYSTEM32\CRYPTBASE.dll >> >> VM Arguments: >> jvm_args: -Dfile.encoding=UTF-8 >> java_command: org.apache.hc.core5.http.examples.AsyncFileServerExample >> C:\temp >> Launcher Type: SUN_STANDARD >> >> Environment Variables: >> JAVA_HOME=C:\Program Files\Java\jdk1.8.0_191 >> USERNAME=ggregory >> OS=Windows_NT >> PROCESSOR_IDENTIFIER=Intel64 Family 6 Model 78 Stepping 3, GenuineIntel >> >> >> >> --------------- S Y S T E M --------------- >> >> OS: Windows 8.1 , 64 bit Build 9600 >> >> CPU:total 4 (2 cores per cpu, 2 threads per core) family 6 model 78 >> stepping 3, cmov, cx8, fxsr, mmx, sse, sse2, sse3, ssse3, sse4.1, sse4.2, >> popcnt, avx, avx2, aes, erms, ht, tsc, tscinvbit >> >> Memory: 4k page, physical 16162472k(447756k free), swap 47249876k(0k free) >> >> vm_info: Java HotSpot(TM) 64-Bit Server VM (24.80-b11) for windows-amd64 >> JRE (1.7.0_80-b15), built on Apr 10 2015 11:26:34 by "java_re" with unknown >> MS VC++:1600 >> >> time: Tue Nov 20 17:14:44 2018 >> elapsed time: 1784 seconds >> >> --- >> >> Gary >> >> On Wed, Nov 21, 2018 at 3:06 PM Oleg Kalnichevski <[email protected]> >> wrote: >> >>> On Wed, 2018-11-21 at 11:17 -0700, Gary Gregory wrote: >>> > Hi All: >>> > >>> > This could have nothing to do with HttpCore code and all to do with >>> > whatever else was going on on my machine at the time but I still >>> > wanted to >>> > post this as I got the following running AsyncFileServerExample in a >>> > 'forever' test. >>> > >>> > ... >>> > 2018-11-20 22:35:15.489 -0700 | 127.0.0.1:8080<->127.0.0.1:36505 | >>> > serving >>> > file C:\temp\one-byte.txt >>> > 2018-11-20 22:35:15.489 -0700 | 127.0.0.1:8080<->127.0.0.1:36507 | >>> > serving >>> > file C:\temp\one-byte.txt >>> > 2018-11-20 22:35:15.489 -0700 | 127.0.0.1:8080<->127.0.0.1:36509 | >>> > serving >>> > file C:\temp\one-byte.txt >>> > File C:\temp\one-byte.txt not found >>> > Exception in thread "server-dispatch-2" java.lang.OutOfMemoryError >>> > at java.lang.ClassLoader.defineClass1(Native Method) >>> > at java.lang.ClassLoader.defineClass(ClassLoader.java:800) >>> > at >>> > java.security.SecureClassLoader.defineClass(SecureClassLoader.java:14 >>> > 2) >>> > at java.net.URLClassLoader.defineClass(URLClassLoader.java:449) >>> > at java.net.URLClassLoader.access$100(URLClassLoader.java:71) >>> > at java.net.URLClassLoader$1.run(URLClassLoader.java:361) >>> > at java.net.URLClassLoader$1.run(URLClassLoader.java:355) >>> > at java.security.AccessController.doPrivileged(Native Method) >>> > at java.net.URLClassLoader.findClass(URLClassLoader.java:354) >>> > at java.lang.ClassLoader.loadClass(ClassLoader.java:425) >>> > at sun.misc.Launcher$AppClassLoader.loadClass(Launcher.java:308) >>> > at java.lang.ClassLoader.loadClass(ClassLoader.java:358) >>> > at >>> > org.apache.hc.core5.http.nio.BasicResponseProducer.<init>(BasicRespon >>> > seProducer.java:66) >>> > at >>> > org.apache.hc.core5.http.nio.BasicResponseProducer.<init>(BasicRespon >>> > seProducer.java:74) >>> > at >>> > org.apache.hc.core5.http.examples.AsyncFileServerExample$1.handle(Asy >>> > ncFileServerExample.java:120) >>> > at >>> > org.apache.hc.core5.http.examples.AsyncFileServerExample$1.handle(Asy >>> > ncFileServerExample.java:1) >>> > at >>> > org.apache.hc.core5.http.nio.support.BasicServerExchangeHandler.handl >>> > e(BasicServerExchangeHandler.java:67) >>> > at >>> > org.apache.hc.core5.http.nio.support.AbstractServerExchangeHandler$2. >>> > completed(AbstractServerExchangeHandler.java:139) >>> > at >>> > org.apache.hc.core5.http.nio.BasicRequestConsumer.consumeRequest(Basi >>> > cRequestConsumer.java:99) >>> > at >>> > org.apache.hc.core5.http.nio.support.AbstractServerExchangeHandler.ha >>> > ndleRequest(AbstractServerExchangeHandler.java:134) >>> > at >>> > org.apache.hc.core5.http.nio.support.BasicAsyncServerExpectationDecor >>> > ator.handleRequest(BasicAsyncServerExpectationDecorator.java:90) >>> > at >>> > org.apache.hc.core5.http.impl.nio.ServerHttp1StreamHandler.consumeHea >>> > der(ServerHttp1StreamHandler.java:251) >>> > at >>> > org.apache.hc.core5.http.impl.nio.ServerHttp1StreamDuplexer.consumeHe >>> > ader(ServerHttp1StreamDuplexer.java:327) >>> > at >>> > org.apache.hc.core5.http.impl.nio.ServerHttp1StreamDuplexer.consumeHe >>> > ader(ServerHttp1StreamDuplexer.java:1) >>> > at >>> > org.apache.hc.core5.http.impl.nio.AbstractHttp1StreamDuplexer.onInput >>> > (AbstractHttp1StreamDuplexer.java:283) >>> > at >>> > org.apache.hc.core5.http.impl.nio.AbstractHttp1IOEventHandler.inputRe >>> > ady(AbstractHttp1IOEventHandler.java:63) >>> > at >>> > org.apache.hc.core5.http.impl.nio.ServerHttp1IOEventHandler.inputRead >>> > y(ServerHttp1IOEventHandler.java:1) >>> > at >>> > org.apache.hc.core5.reactor.InternalDataChannel.onIOEvent(InternalDat >>> > aChannel.java:163) >>> > at >>> > org.apache.hc.core5.reactor.InternalChannel.handleIOEvent(InternalCha >>> > nnel.java:51) >>> > at >>> > org.apache.hc.core5.reactor.SingleCoreIOReactor.processEvents(SingleC >>> > oreIOReactor.java:174) >>> > at >>> > org.apache.hc.core5.reactor.SingleCoreIOReactor.doExecute(SingleCoreI >>> > OReactor.java:124) >>> > at >>> > org.apache.hc.core5.reactor.AbstractSingleCoreIOReactor.execute(Abstr >>> > actSingleCoreIOReactor.java:80) >>> > at >>> > org.apache.hc.core5.reactor.IOReactorWorker.run(IOReactorWorker.java: >>> > 44) >>> > at java.lang.Thread.run(Thread.java:745) >>> > >>> > I launched this example with the argument 'C:\temp', from Eclipse, >>> > using >>> > Oracle Java 7 on Windows 10: >>> > >>> > Java version: 1.7.0_80, vendor: Oracle Corporation, runtime: >>> > C:\Program >>> > Files\Java\jdk1.7.0_80\jre >>> > Default locale: en_US, platform encoding: Cp1252 >>> > OS name: "windows 8.1", version: "6.3", arch: "amd64", family: >>> > "windows" >>> > >>> > I had left this test running while AFK, but based on the JMeter >>> > output, I'd >>> > say the test had been running for 334K requests over 2,654,360 >>> > milliseconds or ~44 minutes. >>> > >>> >>> Could you please make a heap dump and let me know instances of which >>> classes fill up the heap? >>> >>> Oleg >>> >>> >>> >>> --------------------------------------------------------------------- >>> To unsubscribe, e-mail: [email protected] >>> For additional commands, e-mail: [email protected] >>> >>>
