Start/stop of server throws and fails on 124.524

Log copy is at the end of this message...
This was not so bad with previous EAP build.
Then it left a pid file I needed to clean up manually.
(http://youtrack.jetbrains.com/issue/RUBY-12835)
Now there is this long stack trace
and I have to both manually remove that file and kill the runaway jruby process (with the task manager).
Have I got something wrong?
Thanks,
Gordon




runnerw.exe C:\SWTOOLS\ruby\jruby-1.7.2\bin\jruby.exe --1.9 -e $stdout.sync=true;$stderr.sync=true;load($0=ARGV.shift) C:/active/deon/jb/deonJr/script/rails server -b 127.0.0.1 -p 3010 -e development
=> Booting WEBrick
=> Rails 3.2.11 application starting in development on http://127.0.0.1:3010
=> Call with -d to detach
=> Ctrl-C to shutdown server
[2013-01-16 15:10:49] INFO  WEBrick 1.3.1
[2013-01-16 15:10:49] INFO  ruby 1.9.3 (2013-01-04) [java]
[2013-01-16 15:10:49] INFO  WEBrick::HTTPServer#start: pid=3368 port=3010
2013-01-16 15:11:18
Full thread dump Java HotSpot(TM) Client VM (20.12-b01 mixed mode, sharing):

"JRubyJIT-2" daemon prio=2 tid=0x0639e800 nid=0x2198 waiting on condition [0x06c1f000]
   java.lang.Thread.State: WAITING (parking)
    at sun.misc.Unsafe.park(Native Method)
    - parking to wait for  <0x1f74e588> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject)
    at java.util.concurrent.locks.LockSupport.park(Unknown Source)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(Unknown Source)
    at java.util.concurrent.LinkedBlockingQueue.take(Unknown Source)
    at java.util.concurrent.ThreadPoolExecutor.getTask(Unknown Source)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
    at java.lang.Thread.run(Unknown Source)

"JRubyJIT-1" daemon prio=2 tid=0x06394800 nid=0x1888 waiting on condition [0x06a1f000]
   java.lang.Thread.State: WAITING (parking)
    at sun.misc.Unsafe.park(Native Method)
    - parking to wait for  <0x1f74e588> (a java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject)
    at java.util.concurrent.locks.LockSupport.park(Unknown Source)
    at java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(Unknown Source)
    at java.util.concurrent.LinkedBlockingQueue.take(Unknown Source)
    at java.util.concurrent.ThreadPoolExecutor.getTask(Unknown Source)
    at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
    at java.lang.Thread.run(Unknown Source)

"jnr.ffi.util.ref.internal.Finalizer" daemon prio=10 tid=0x06328800 nid=0x16f8 in Object.wait() [0x0681f000]
   java.lang.Thread.State: WAITING (on object monitor)
    at java.lang.Object.wait(Native Method)
    - waiting on <0x1faee3f0> (a java.lang.ref.ReferenceQueue$Lock)
    at java.lang.ref.ReferenceQueue.remove(Unknown Source)
    - locked <0x1faee3f0> (a java.lang.ref.ReferenceQueue$Lock)
    at java.lang.ref.ReferenceQueue.remove(Unknown Source)
    at jnr.ffi.util.ref.internal.Finalizer.run(Finalizer.java:126)

"Low Memory Detector" daemon prio=6 tid=0x0208e400 nid=0x23e0 runnable [0x00000000]
   java.lang.Thread.State: RUNNABLE

"C1 CompilerThread0" daemon prio=10 tid=0x02089800 nid=0x2240 waiting on condition [0x00000000]
   java.lang.Thread.State: RUNNABLE

"Attach Listener" daemon prio=10 tid=0x02088800 nid=0x2214 runnable [0x00000000]
   java.lang.Thread.State: RUNNABLE

"Signal Dispatcher" daemon prio=10 tid=0x02085800 nid=0x40c waiting on condition [0x00000000]
   java.lang.Thread.State: RUNNABLE

"Finalizer" daemon prio=8 tid=0x0207b000 nid=0x1fac in Object.wait() [0x04f8f000]
   java.lang.Thread.State: WAITING (on object monitor)
    at java.lang.Object.wait(Native Method)
    - waiting on <0x1f7e69c8> (a java.lang.ref.ReferenceQueue$Lock)
    at java.lang.ref.ReferenceQueue.remove(Unknown Source)
    - locked <0x1f7e69c8> (a java.lang.ref.ReferenceQueue$Lock)
    at java.lang.ref.ReferenceQueue.remove(Unknown Source)
    at java.lang.ref.Finalizer$FinalizerThread.run(Unknown Source)

"Reference Handler" daemon prio=10 tid=0x02079400 nid=0x828 in Object.wait() [0x04d8f000]
   java.lang.Thread.State: WAITING (on object monitor)
    at java.lang.Object.wait(Native Method)
    - waiting on <0x1f7e6a58> (a java.lang.ref.Reference$Lock)
    at java.lang.Object.wait(Object.java:485)
    at java.lang.ref.Reference$ReferenceHandler.run(Unknown Source)
    - locked <0x1f7e6a58> (a java.lang.ref.Reference$Lock)

"main" prio=6 tid=0x02189800 nid=0x170c runnable [0x0028b000]
   java.lang.Thread.State: RUNNABLE
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll0(Native Method)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.poll(Unknown Source)
    at sun.nio.ch.WindowsSelectorImpl$SubSelector.access$400(Unknown Source)
    at sun.nio.ch.WindowsSelectorImpl.doSelect(Unknown Source)
    at sun.nio.ch.SelectorImpl.lockAndDoSelect(Unknown Source)
    - locked <0x162fd118> (a sun.nio.ch.Util$2)
    - locked <0x162fd108> (a java.util.Collections$UnmodifiableSet)
    - locked <0x162fcee8> (a sun.nio.ch.WindowsSelectorImpl)
    at sun.nio.ch.SelectorImpl.select(Unknown Source)
    at org.jruby.util.io.SelectBlob.doSelect(SelectBlob.java:257)
    at org.jruby.util.io.SelectBlob.goForIt(SelectBlob.java:89)
    at org.jruby.RubyIO.select_static(RubyIO.java:3507)
    at org.jruby.RubyIO.select(RubyIO.java:3503)
    at org.jruby.RubyIO$INVOKER$s$0$3$select.call(RubyIO$INVOKER$s$0$3$select.gen)
    at org.jruby.runtime.callsite.CachingCallSite.call(CachingCallSite.java:70)
    at org.jruby.ast.CallManyArgsNode.interpret(CallManyArgsNode.java:59)
    at org.jruby.ast.DAsgnNode.interpret(DAsgnNode.java:110)
    at org.jruby.ast.IfNode.interpret(IfNode.java:110)
    at org.jruby.ast.NewlineNode.interpret(NewlineNode.java:105)
    at org.jruby.ast.RescueNode.executeBody(RescueNode.java:224)
    at org.jruby.ast.RescueNode.interpret(RescueNode.java:119)
    at org.jruby.ast.BeginNode.interpret(BeginNode.java:83)
    at org.jruby.ast.NewlineNode.interpret(NewlineNode.java:105)
    at org.jruby.ast.WhileNode.interpret(WhileNode.java:131)
    at org.jruby.ast.NewlineNode.interpret(NewlineNode.java:105)
    at org.jruby.ast.BlockNode.interpret(BlockNode.java:71)
    at org.jruby.evaluator.ASTInterpreter.INTERPRET_BLOCK(ASTInterpreter.java:112)
    at org.jruby.runtime.Interpreted19Block.evalBlockBody(Interpreted19Block.java:209)
    at org.jruby.runtime.Interpreted19Block.yield(Interpreted19Block.java:160)
    at org.jruby.runtime.Interpreted19Block.yieldSpecific(Interpreted19Block.java:133)
    at org.jruby.runtime.Block.yieldSpecific(Block.java:99)
    at org.jruby.ast.ZYieldNode.interpret(ZYieldNode.java:25)
    at org.jruby.ast.NewlineNode.interpret(NewlineNode.java:105)
    at org.jruby.evaluator.ASTInterpreter.INTERPRET_METHOD(ASTInterpreter.java:75)
    at org.jruby.internal.runtime.methods.InterpretedMethod.call(InterpretedMethod.java:161)
    at org.jruby.internal.runtime.methods.DefaultMethod.call(DefaultMethod.java:180)
    at org.jruby.runtime.callsite.CachingCallSite.cacheAndCall(CachingCallSite.java:316)
    at org.jruby.runtime.callsite.CachingCallSite.callBlock(CachingCallSite.java:145)
    at org.jruby.runtime.callsite.CachingCallSite.callIter(CachingCallSite.java:154)
    at org.jruby.ast.CallNoArgBlockNode.interpret(CallNoArgBlockNode.java:64)
    at org.jruby.ast.NewlineNode.interpret(NewlineNode.java:105)
    at org.jruby.ast.BlockNode.interpret(BlockNode.java:71)
    at org.jruby.evaluator.ASTInterpreter.INTERPRET_METHOD(ASTInterpreter.java:75)
    at org.jruby.internal.runtime.methods.InterpretedMethod.call(InterpretedMethod.java:139)
    at org.jruby.internal.runtime.methods.DefaultMethod.call(DefaultMethod.java:172)
    at org.jruby.runtime.callsite.CachingCallSite.cacheAndCall(CachingCallSite.java:306)
    at org.jruby.runtime.callsite.CachingCallSite.call(CachingCallSite.java:136)
    at org.jruby.ast.CallNoArgNode.interpret(CallNoArgNode.java:64)
    at org.jruby.ast.NewlineNode.interpret(NewlineNode.java:105)
    at org.jruby.ast.BlockNode.interpret(BlockNode.java:71)
    at org.jruby.evaluator.ASTInterpreter.INTERPRET_METHOD(ASTInterpreter.java:75)
    at org.jruby.internal.runtime.methods.InterpretedMethod.call(InterpretedMethod.java:247)
    at org.jruby.internal.runtime.methods.DefaultMethod.call(DefaultMethod.java:212)
    at org.jruby.runtime.callsite.CachingCallSite.cacheAndCall(CachingCallSite.java:356)
    at org.jruby.runtime.callsite.CachingCallSite.callBlock(CachingCallSite.java:213)
    at org.jruby.runtime.callsite.CachingCallSite.call(CachingCallSite.java:217)
    at org.jruby.ast.CallTwoArgBlockPassNode.interpret(CallTwoArgBlockPassNode.java:62)
    at org.jruby.ast.NewlineNode.interpret(NewlineNode.java:105)
    at org.jruby.ast.BlockNode.interpret(BlockNode.java:71)
    at org.jruby.evaluator.ASTInterpreter.INTERPRET_METHOD(ASTInterpreter.java:75)
    at org.jruby.internal.runtime.methods.InterpretedMethod.call(InterpretedMethod.java:161)
    at org.jruby.internal.runtime.methods.DefaultMethod.call(DefaultMethod.java:180)
    at org.jruby.runtime.callsite.SuperCallSite.cacheAndCall(SuperCallSite.java:346)
    at org.jruby.runtime.callsite.SuperCallSite.callBlock(SuperCallSite.java:146)
    at org.jruby.runtime.callsite.SuperCallSite.call(SuperCallSite.java:151)
    at org.jruby.runtime.callsite.SuperCallSite.callVarargs(SuperCallSite.java:107)
    at org.jruby.ast.ZSuperNode.interpret(ZSuperNode.java:104)
    at org.jruby.ast.NewlineNode.interpret(NewlineNode.java:105)
    at org.jruby.ast.BlockNode.interpret(BlockNode.java:71)
    at org.jruby.ast.EnsureNode.interpret(EnsureNode.java:96)
    at org.jruby.evaluator.ASTInterpreter.INTERPRET_METHOD(ASTInterpreter.java:75)
    at org.jruby.internal.runtime.methods.InterpretedMethod.call(InterpretedMethod.java:139)
    at org.jruby.internal.runtime.methods.DefaultMethod.call(DefaultMethod.java:172)
    at org.jruby.runtime.callsite.CachingCallSite.cacheAndCall(CachingCallSite.java:306)
    at org.jruby.runtime.callsite.CachingCallSite.call(CachingCallSite.java:136)
    at org.jruby.ast.CallNoArgNode.interpret(CallNoArgNode.java:64)
    at org.jruby.ast.NewlineNode.interpret(NewlineNode.java:105)
    at org.jruby.ast.BlockNode.interpret(BlockNode.java:71)
    at org.jruby.evaluator.ASTInterpreter.INTERPRET_BLOCK(ASTInterpreter.java:112)
    at org.jruby.runtime.Interpreted19Block.evalBlockBody(Interpreted19Block.java:209)
    at org.jruby.runtime.Interpreted19Block.yield(Interpreted19Block.java:160)
    at org.jruby.runtime.Block.yield(Block.java:130)
    at org.jruby.RubyKernel.tap(RubyKernel.java:1754)
    at org.jruby.RubyKernel$INVOKER$s$0$0$tap.call(RubyKernel$INVOKER$s$0$0$tap.gen)
    at org.jruby.runtime.callsite.CachingCallSite.cacheAndCall(CachingCallSite.java:316)
    at org.jruby.runtime.callsite.CachingCallSite.callBlock(CachingCallSite.java:145)
    at org.jruby.runtime.callsite.CachingCallSite.callIter(CachingCallSite.java:154)
    at org.jruby.ast.CallNoArgBlockNode.interpret(CallNoArgBlockNode.java:64)
    at org.jruby.ast.NewlineNode.interpret(NewlineNode.java:105)
    at org.jruby.ast.BlockNode.interpret(BlockNode.java:71)
    at org.jruby.ast.WhenOneArgNode.whenSlowTest(WhenOneArgNode.java:36)
    at org.jruby.ast.WhenOneArgNode.when(WhenOneArgNode.java:46)
    at org.jruby.ast.CaseNode.interpret(CaseNode.java:132)
    at org.jruby.ast.NewlineNode.interpret(NewlineNode.java:105)
    at org.jruby.ast.BlockNode.interpret(BlockNode.java:71)
    at org.jruby.ast.RootNode.interpret(RootNode.java:129)
    at org.jruby.evaluator.ASTInterpreter.INTERPRET_ROOT(ASTInterpreter.java:120)
    at org.jruby.Ruby.runInterpreter(Ruby.java:837)
    at org.jruby.Ruby.loadFile(Ruby.java:2629)
    at org.jruby.runtime.load.ExternalScript.load(ExternalScript.java:66)
    at org.jruby.runtime.load.LoadService.tryLoadingLibraryOrScript(LoadService.java:937)
    at org.jruby.runtime.load.LoadService.smartLoadInternal(LoadService.java:557)
    at org.jruby.runtime.load.LoadService.requireCommon(LoadService.java:441)
    at org.jruby.runtime.load.LoadService.require(LoadService.java:405)
    at org.jruby.RubyKernel.requireCommon(RubyKernel.java:1033)
    at org.jruby.RubyKernel.require19(RubyKernel.java:1027)
    at org.jruby.RubyKernel$INVOKER$s$1$0$require19.call(RubyKernel$INVOKER$s$1$0$require19.gen)
    at org.jruby.internal.runtime.methods.JavaMethod$JavaMethodOneOrNBlock.call(JavaMethod.java:331)
    at org.jruby.internal.runtime.methods.AliasMethod.call(AliasMethod.java:61)
    at org.jruby.internal.runtime.methods.AliasMethod.call(AliasMethod.java:61)
    at org.jruby.runtime.callsite.CachingCallSite.cacheAndCall(CachingCallSite.java:326)
    at org.jruby.runtime.callsite.CachingCallSite.call(CachingCallSite.java:170)
    at org.jruby.ast.FCallOneArgNode.interpret(FCallOneArgNode.java:36)
    at org.jruby.ast.NewlineNode.interpret(NewlineNode.java:105)
    at org.jruby.ast.BlockNode.interpret(BlockNode.java:71)
    at org.jruby.ast.RootNode.interpret(RootNode.java:129)
    at org.jruby.evaluator.ASTInterpreter.INTERPRET_ROOT(ASTInterpreter.java:120)
    at org.jruby.Ruby.runInterpreter(Ruby.java:837)
    at org.jruby.Ruby.loadFile(Ruby.java:2629)
    at org.jruby.runtime.load.ExternalScript.load(ExternalScript.java:66)
    at org.jruby.runtime.load.LoadService.load(LoadService.java:351)
    at org.jruby.RubyKernel.loadCommon(RubyKernel.java:1054)
    at org.jruby.RubyKernel.load19(RubyKernel.java:1046)
    at org.jruby.RubyKernel$INVOKER$s$0$1$load19.call(RubyKernel$INVOKER$s$0$1$load19.gen)
    at org.jruby.internal.runtime.methods.DynamicMethod.call(DynamicMethod.java:208)
    at org.jruby.internal.runtime.methods.DynamicMethod.call(DynamicMethod.java:204)
    at org.jruby.runtime.callsite.CachingCallSite.cacheAndCall(CachingCallSite.java:326)
    at org.jruby.runtime.callsite.CachingCallSite.call(CachingCallSite.java:170)
    at ruby.__dash_e__.__file__(-e:1)
    at ruby.__dash_e__.load(-e)
    at org.jruby.Ruby.runScript(Ruby.java:810)
    at org.jruby.Ruby.runScript(Ruby.java:803)
    at org.jruby.Ruby.runNormally(Ruby.java:674)
    at org.jruby.Ruby.runFromMain(Ruby.java:523)
    at org.jruby.Main.doRunFromMain(Main.java:390)
    at org.jruby.Main.internalRun(Main.java:279)
    at org.jruby.Main.run(Main.java:221)
    at org.jruby.Main.main(Main.java:201)

"VM Thread" prio=10 tid=0x0203d800 nid=0xdf4 runnable

"VM Periodic Task Thread" prio=10 tid=0x020a8000 nid=0x15d8 waiting on condition

JNI global references: 1022

Heap
def new generation   total 23744K, used 19156K [0x150a0000, 0x16a60000, 0x1f740000)
  eden space 21120K,  90% used [0x150a0000, 0x16355270, 0x16540000)
  from space 2624K,   0% used [0x16540000, 0x16540000, 0x167d0000)
  to   space 2624K,   0% used [0x167d0000, 0x167d0000, 0x16a60000)
tenured generation   total 52680K, used 31607K [0x1f740000, 0x22ab2000, 0x344a0000)
   the space 52680K,  59% used [0x1f740000, 0x2161dff8, 0x2161e000, 0x22ab2000)
compacting perm gen  total 21504K, used 21320K [0x344a0000, 0x359a0000, 0x384a0000)
   the space 21504K,  99% used [0x344a0000, 0x35972098, 0x35972200, 0x359a0000)
    ro space 10240K,  51% used [0x384a0000, 0x389d0500, 0x389d0600, 0x38ea0000)
    rw space 12288K,  55% used [0x38ea0000, 0x3953bd40, 0x3953be00, 0x39aa0000)


Process finished with exit code -1073741510

1 comment
Comment actions Permalink

Hi,

I'm affraid this is a result of my "preparation refactoring" I've done for http://youtrack.jetbrains.com/issue/RUBY-12835 :(
This should go aways as soon as the bug will be fixed comletely (though I doubt this is a good exuse :()

Sorry, Oleg.

0

Please sign in to leave a comment.