REPL hang after Mac sleep
mfikes opened this issue · 2 comments
mfikes commented
Establish a REPL to a simulator and evaluate a few simple forms. Then let the Mac go to sleep. Wake up and evaluate a form. The REPL can hang. (The threads in the simulator show nothing suspicious.)
Here's a thread dump for the REPL after sleeping and trying to evaluate a form:
2015-04-29 00:29:52
Full thread dump Java HotSpot(TM) 64-Bit Server VM (25.45-b02 mixed mode):
"Thread-5" #26 prio=5 os_prio=31 tid=0x00007fde9a182000 nid=0x4f07 runnable [0x0000000139dbe000]
java.lang.Thread.State: RUNNABLE
at java.net.SocketInputStream.socketRead0(Native Method)
at java.net.SocketInputStream.socketRead(SocketInputStream.java:116)
at java.net.SocketInputStream.read(SocketInputStream.java:170)
at java.net.SocketInputStream.read(SocketInputStream.java:141)
at java.io.BufferedInputStream.read1(BufferedInputStream.java:284)
at java.io.BufferedInputStream.read(BufferedInputStream.java:345)
- locked <0x0000000743763bd8> (a java.io.BufferedInputStream)
at sun.nio.cs.StreamDecoder.readBytes(StreamDecoder.java:284)
at sun.nio.cs.StreamDecoder.implRead(StreamDecoder.java:326)
at sun.nio.cs.StreamDecoder.read(StreamDecoder.java:178)
- locked <0x0000000743765c10> (a java.io.InputStreamReader)
at java.io.InputStreamReader.read(InputStreamReader.java:184)
at java.io.BufferedReader.fill(BufferedReader.java:161)
at java.io.BufferedReader.read(BufferedReader.java:182)
- locked <0x0000000743765c10> (a java.io.InputStreamReader)
at sun.reflect.GeneratedMethodAccessor2.invoke(Unknown Source)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:497)
at clojure.lang.Reflector.invokeMatchingMethod(Reflector.java:93)
at clojure.lang.Reflector.invokeNoArgInstanceMember(Reflector.java:313)
at ambly.repl.jsc$read_messages.invoke(jsc.clj:176)
at ambly.repl.jsc$start_reading_messages$fn__4379.invoke(jsc.clj:188)
at clojure.lang.AFn.run(AFn.java:22)
at java.lang.Thread.run(Thread.java:745)
"Service Thread" #17 daemon prio=9 os_prio=31 tid=0x00007fde9a01f000 nid=0x7503 runnable [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"C1 CompilerThread11" #16 daemon prio=9 os_prio=31 tid=0x00007fde9e830000 nid=0x7303 waiting on condition [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"C1 CompilerThread10" #15 daemon prio=9 os_prio=31 tid=0x00007fde9c80b000 nid=0x7103 waiting on condition [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"C1 CompilerThread9" #14 daemon prio=9 os_prio=31 tid=0x00007fde9d000800 nid=0x6f03 waiting on condition [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"C1 CompilerThread8" #13 daemon prio=9 os_prio=31 tid=0x00007fde9e82f000 nid=0x6d03 waiting on condition [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"C2 CompilerThread7" #12 daemon prio=9 os_prio=31 tid=0x00007fde9b811000 nid=0x6b03 waiting on condition [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"C2 CompilerThread6" #11 daemon prio=9 os_prio=31 tid=0x00007fde9b810800 nid=0x6903 waiting on condition [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"C2 CompilerThread5" #10 daemon prio=9 os_prio=31 tid=0x00007fde9b80f800 nid=0x6703 waiting on condition [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"C2 CompilerThread4" #9 daemon prio=9 os_prio=31 tid=0x00007fde9b807000 nid=0x6503 waiting on condition [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"C2 CompilerThread3" #8 daemon prio=9 os_prio=31 tid=0x00007fde9e826800 nid=0x6303 waiting on condition [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"C2 CompilerThread2" #7 daemon prio=9 os_prio=31 tid=0x00007fde9e825800 nid=0x6103 waiting on condition [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"C2 CompilerThread1" #6 daemon prio=9 os_prio=31 tid=0x00007fde9e818000 nid=0x5f03 waiting on condition [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"C2 CompilerThread0" #5 daemon prio=9 os_prio=31 tid=0x00007fde9e816000 nid=0x5d03 waiting on condition [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"Signal Dispatcher" #4 daemon prio=9 os_prio=31 tid=0x00007fde9e824000 nid=0x5013 waiting on condition [0x0000000000000000]
java.lang.Thread.State: RUNNABLE
"Finalizer" #3 daemon prio=8 os_prio=31 tid=0x00007fde9a863000 nid=0x4903 in Object.wait() [0x0000000135724000]
java.lang.Thread.State: WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
- waiting on <0x0000000640011320> (a java.lang.ref.ReferenceQueue$Lock)
at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:143)
- locked <0x0000000640011320> (a java.lang.ref.ReferenceQueue$Lock)
at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:164)
at java.lang.ref.Finalizer$FinalizerThread.run(Finalizer.java:209)
"Reference Handler" #2 daemon prio=10 os_prio=31 tid=0x00007fde9a862800 nid=0x4703 in Object.wait() [0x0000000135621000]
java.lang.Thread.State: WAITING (on object monitor)
at java.lang.Object.wait(Native Method)
- waiting on <0x0000000640009578> (a java.lang.ref.Reference$Lock)
at java.lang.Object.wait(Object.java:502)
at java.lang.ref.Reference$ReferenceHandler.run(Reference.java:157)
- locked <0x0000000640009578> (a java.lang.ref.Reference$Lock)
"main" #1 prio=5 os_prio=31 tid=0x00007fde9a00d000 nid=0x1303 waiting on condition [0x000000010e74d000]
java.lang.Thread.State: WAITING (parking)
at sun.misc.Unsafe.park(Native Method)
- parking to wait for <0x000000074d726730> (a java.util.concurrent.CountDownLatch$Sync)
at java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
at java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:836)
at java.util.concurrent.locks.AbstractQueuedSynchronizer.doAcquireSharedInterruptibly(AbstractQueuedSynchronizer.java:997)
at java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireSharedInterruptibly(AbstractQueuedSynchronizer.java:1304)
at java.util.concurrent.CountDownLatch.await(CountDownLatch.java:231)
at clojure.core$promise$reify__6773.deref(core.clj:6812)
at clojure.core$deref.invoke(core.clj:2204)
at ambly.repl.jsc$jsc_eval.invoke(jsc.clj:265)
at ambly.repl.jsc.JscEnv._evaluate(jsc.clj:460)
at cljs.repl$evaluate_form.invoke(repl.clj:463)
at cljs.repl$eval_cljs.invoke(repl.clj:541)
at cljs.repl$repl_STAR_$read_eval_print__4229.invoke(repl.clj:807)
at cljs.repl$repl_STAR_$fn__4235$fn__4242.invoke(repl.clj:844)
at cljs.repl$repl_STAR_$fn__4235.invoke(repl.clj:843)
at cljs.compiler$with_core_cljs.invoke(compiler.clj:964)
at cljs.repl$repl_STAR_.invoke(repl.clj:809)
at cljs.repl$repl.doInvoke(repl.clj:925)
at clojure.lang.RestFn.invoke(RestFn.java:410)
at ambly.repl.jsc$_main.invoke(jsc.clj:479)
at clojure.lang.Var.invoke(Var.java:375)
at user$eval5.invoke(form-init7232893021789623209.clj:1)
at clojure.lang.Compiler.eval(Compiler.java:6792)
at clojure.lang.Compiler.eval(Compiler.java:6782)
at clojure.lang.Compiler.load(Compiler.java:7237)
at clojure.lang.Compiler.loadFile(Compiler.java:7175)
at clojure.main$load_script.invoke(main.clj:275)
at clojure.main$init_opt.invoke(main.clj:280)
at clojure.main$initialize.invoke(main.clj:308)
at clojure.main$null_opt.invoke(main.clj:343)
at clojure.main$main.doInvoke(main.clj:421)
at clojure.lang.RestFn.invoke(RestFn.java:421)
at clojure.lang.Var.invoke(Var.java:383)
at clojure.lang.AFn.applyToHelper(AFn.java:156)
at clojure.lang.Var.applyTo(Var.java:700)
at clojure.main.main(main.java:37)
"VM Thread" os_prio=31 tid=0x00007fde9a85f800 nid=0x4503 runnable
"GC task thread#0 (ParallelGC)" os_prio=31 tid=0x00007fde9a805800 nid=0x2103 runnable
"GC task thread#1 (ParallelGC)" os_prio=31 tid=0x00007fde9a806800 nid=0x2303 runnable
"GC task thread#2 (ParallelGC)" os_prio=31 tid=0x00007fde9a807000 nid=0x2503 runnable
"GC task thread#3 (ParallelGC)" os_prio=31 tid=0x00007fde9b002800 nid=0x2703 runnable
"GC task thread#4 (ParallelGC)" os_prio=31 tid=0x00007fde9a807800 nid=0x2903 runnable
"GC task thread#5 (ParallelGC)" os_prio=31 tid=0x00007fde9a016000 nid=0x2b03 runnable
"GC task thread#6 (ParallelGC)" os_prio=31 tid=0x00007fde9a016800 nid=0x2d03 runnable
"GC task thread#7 (ParallelGC)" os_prio=31 tid=0x00007fde9a017000 nid=0x2f03 runnable
"GC task thread#8 (ParallelGC)" os_prio=31 tid=0x00007fde9a018000 nid=0x3103 runnable
"GC task thread#9 (ParallelGC)" os_prio=31 tid=0x00007fde9a808000 nid=0x3303 runnable
"GC task thread#10 (ParallelGC)" os_prio=31 tid=0x00007fde9a809000 nid=0x3503 runnable
"GC task thread#11 (ParallelGC)" os_prio=31 tid=0x00007fde9a809800 nid=0x3703 runnable
"GC task thread#12 (ParallelGC)" os_prio=31 tid=0x00007fde9a80a000 nid=0x3903 runnable
"GC task thread#13 (ParallelGC)" os_prio=31 tid=0x00007fde9a80a800 nid=0x3b03 runnable
"GC task thread#14 (ParallelGC)" os_prio=31 tid=0x00007fde9a80b800 nid=0x3d03 runnable
"GC task thread#15 (ParallelGC)" os_prio=31 tid=0x00007fde9a80c000 nid=0x3f03 runnable
"GC task thread#16 (ParallelGC)" os_prio=31 tid=0x00007fde9a80c800 nid=0x4103 runnable
"GC task thread#17 (ParallelGC)" os_prio=31 tid=0x00007fde9a80d000 nid=0x4303 runnable
"VM Periodic Task Thread" os_prio=31 tid=0x00007fde9a079000 nid=0x7703 waiting on condition
JNI global references: 403
Heap
PSYoungGen total 322048K, used 235496K [0x0000000740000000, 0x0000000755e80000, 0x00000007c0000000)
eden space 309248K, 72% used [0x0000000740000000,0x000000074d981288,0x0000000752e00000)
from space 12800K, 99% used [0x0000000753e80000,0x0000000754af8e98,0x0000000754b00000)
to space 16896K, 0% used [0x0000000752e00000,0x0000000752e00000,0x0000000753e80000)
ParOldGen total 142848K, used 11577K [0x0000000640000000, 0x0000000648b80000, 0x0000000740000000)
object space 142848K, 8% used [0x0000000640000000,0x0000000640b4e408,0x0000000648b80000)
Metaspace used 27115K, capacity 34988K, committed 35072K, reserved 1075200K
class space used 6257K, capacity 8666K, committed 8704K, reserved 1048576K
mfikes commented
This appears to now be fixed for REPLs into the simulator owing to #82.
I want to still check for this in the case where a Mac is connected to an actual device and the Mac sleeps.
mfikes commented
Appears to be fixed.