Found some more details. Seems to be saying it's out of memory. How is this different from getting a LowSpaceDebug log?
Cheers, Bob
Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: warning, processHasThreadId flag is unset; cannot function as a threaded VM if so. Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: warning: Process doesn't have threadId; VM will not thread Jan 7 00:07:22: --- last message repeated 9 times --- Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: out of memory Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: C stack backtrace: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: Smalltalk stack dump: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: 0xbff8e1d0 M Delay class>handleTimerEvent 157474072: a(n) Delay class Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: 0xbff8e1f0 I Delay class>runTimerEventLoop 157474072: a(n) Delay class Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: 0x9851140 s [] in Delay class>startTimerEventLoop Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: 0x9851260 s [] in BlockClosure>newProcess Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: Most recent primitives Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: at:put: Jan 7 00:07:22: --- last message repeated 1 time --- Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: findSubstring:in:startingAt:matchTable: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: indexOfAscii:inString:startingAt: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: value Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: compare:with:collated: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: at:put: Jan 7 00:07:22: --- last message repeated 11 times --- Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: findSubstring:in:startingAt:matchTable: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: indexOfAscii:inString:startingAt: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: value Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: compare:with:collated: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: at:put: Jan 7 00:07:22: --- last message repeated 11 times --- Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: findSubstring:in:startingAt:matchTable: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: indexOfAscii:inString:startingAt: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: value Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: compare:with:collated: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: at:put: Jan 7 00:07:22: --- last message repeated 13 times --- Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: at:put: Jan 7 00:07:22: --- last message repeated 1 time --- Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: yield Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: wait Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: signal Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: wait Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: findNextUnwindContextUpTo: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: tempAt: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: tempAt:put: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: tempAt: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: terminateTo: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: findNextUnwindContextUpTo: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: tempAt: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: tempAt:put: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: tempAt: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: terminateTo: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: signal Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: findNextUnwindContextUpTo: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: terminateTo: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: millisecondClockValue Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: basicNew Jan 7 00:07:22: --- last message repeated 1 time --- Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: millisecondClockValue Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: wait Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: signal Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: at:put: Jan 7 00:07:22: --- last message repeated 3 times --- Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: millisecondClockValue Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: primSignal:atMilliseconds: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: millisecondClockValue Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: wait Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: signal Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: wait Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: millisecondClockValue Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: signal Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: at:put: Jan 7 00:07:22: --- last message repeated 7 times --- Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: primSignal:atMilliseconds: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: millisecondClockValue Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: wait Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: millisecondClockValue Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: @ Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: actualScreenSize Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: species Jan 7 00:07:22: --- last message repeated 1 time --- Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: millisecondClockValue Jan 7 00:07:22: --- last message repeated 1 time --- Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: new: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: primGetNextEvent: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: basicNew Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: new: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: at:put: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: new: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: basicNew Jan 7 00:07:22: --- last message repeated 3 times --- Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: at:put: Jan 7 00:07:22: --- last message repeated 1 time --- Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: basicNew Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: new: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: basicNew Jan 7 00:07:22: --- last message repeated 1 time --- Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: millisecondClockValue Jan 7 00:07:22: --- last message repeated 2 times --- Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: wait Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: signal Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: yield Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: wait Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: signal Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: wait Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: findNextUnwindContextUpTo: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: tempAt: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: tempAt:put: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: tempAt: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: terminateTo: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: findNextUnwindContextUpTo: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: tempAt: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: tempAt:put: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: tempAt: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: terminateTo: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: signal Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: findNextUnwindContextUpTo: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: terminateTo: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: millisecondClockValue Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: basicNew Jan 7 00:07:22: --- last message repeated 1 time --- Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: millisecondClockValue Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: wait Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: signal Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: at:put: Jan 7 00:07:22: --- last message repeated 3 times --- Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: millisecondClockValue Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: primSignal:atMilliseconds: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: millisecondClockValue Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: wait Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: signal Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: wait Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: millisecondClockValue Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: signal Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: at:put: Jan 7 00:07:22: --- last message repeated 7 times --- Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: primSignal:atMilliseconds: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: millisecondClockValue Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: wait Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: millisecondClockValue Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: @ Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: actualScreenSize Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: species Jan 7 00:07:22: --- last message repeated 1 time --- Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: millisecondClockValue Jan 7 00:07:22: --- last message repeated 1 time --- Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: new: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: millisecondClockValue Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: signal Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: at:put: Jan 7 00:07:22: --- last message repeated 5 times --- Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: primSignal:atMilliseconds: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: millisecondClockValue Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: wait Jan 7 00:07:25 robert-arnings-computer ReportCrash[65021]: Formulating crash report for process Croquet[64493] Jan 7 00:07:26 robert-arnings-computer ReportCrash[65021]: Saved crashreport to /Users/bob/Library/Logs/CrashReporter/Croquet_2012-01-07-000722_robert-arnings-computer.crash using uid: 503 gid: 503, euid: 503 egid: 503 Jan 7 00:07:25 robert-arnings-computer com.apple.launchd[157] ([0x0-0x1ad1ad0].com.squeak.Cog[64493]): Exited abnormally: Abort trap
On Sat, Jan 7, 2012 at 7:28 AM, Bob Arning arning315@comcast.net wrote:
Found some more details. Seems to be saying it's out of memory. How is this different from getting a LowSpaceDebug log?
LowSpaceDebug.log is written from the image when a low space condition is detected. The VM aborting with out of memory means an allocation in the VM (e.g. in a primitive) faled and the VM had not option but to abort. If when the VM signals the low space semaphore the image doesn't take appropriate action in response (i.e. stop allocating and free up space) the system may progress to the point of an allocation failure.
BTW, the below is not as useful as the crash.log file.
Cheers, Bob
Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: warning, processHasThreadId flag is unset; cannot function as a threaded VM if so. Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: warning: Process doesn't have threadId; VM will not thread Jan 7 00:07:22: --- last message repeated 9 times --- Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: out of memory Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: C stack backtrace: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: Smalltalk stack dump: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: 0xbff8e1d0 M Delay class>handleTimerEvent 157474072: a(n) Delay class Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: 0xbff8e1f0 I Delay class>runTimerEventLoop 157474072: a(n) Delay class Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: 0x9851140 s [] in Delay class>startTimerEventLoop Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: 0x9851260 s [] in BlockClosure>newProcess Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: Most recent primitives Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: at:put: Jan 7 00:07:22: --- last message repeated 1 time --- Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: findSubstring:in:startingAt:matchTable: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: indexOfAscii:inString:startingAt: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: value Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: compare:with:collated: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: at:put: Jan 7 00:07:22: --- last message repeated 11 times --- Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: findSubstring:in:startingAt:matchTable: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: indexOfAscii:inString:startingAt: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: value Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: compare:with:collated: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: at:put: Jan 7 00:07:22: --- last message repeated 11 times --- Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: findSubstring:in:startingAt:matchTable: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: indexOfAscii:inString:startingAt: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: value Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: compare:with:collated: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: at:put: Jan 7 00:07:22: --- last message repeated 13 times --- Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: at:put: Jan 7 00:07:22: --- last message repeated 1 time --- Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: yield Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: wait Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: signal Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: wait Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: findNextUnwindContextUpTo: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: tempAt: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: tempAt:put: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: tempAt: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: terminateTo: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: findNextUnwindContextUpTo: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: tempAt: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: tempAt:put: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: tempAt: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: terminateTo: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: signal Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: findNextUnwindContextUpTo: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: terminateTo: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: millisecondClockValue Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: basicNew Jan 7 00:07:22: --- last message repeated 1 time --- Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: millisecondClockValue Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: wait Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: signal Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: at:put: Jan 7 00:07:22: --- last message repeated 3 times --- Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: millisecondClockValue Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: primSignal:atMilliseconds: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: millisecondClockValue Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: wait Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: signal Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: wait Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: millisecondClockValue Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: signal Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: at:put: Jan 7 00:07:22: --- last message repeated 7 times --- Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: primSignal:atMilliseconds: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: millisecondClockValue Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: wait Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: millisecondClockValue Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: @ Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: actualScreenSize Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: species Jan 7 00:07:22: --- last message repeated 1 time --- Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: millisecondClockValue Jan 7 00:07:22: --- last message repeated 1 time --- Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: new: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: primGetNextEvent: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: basicNew Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: new: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: at:put: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: new: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: basicNew Jan 7 00:07:22: --- last message repeated 3 times --- Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: shallowCopy Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: perform:with:with: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: at:put: Jan 7 00:07:22: --- last message repeated 1 time --- Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: basicNew Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: new: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: basicNew Jan 7 00:07:22: --- last message repeated 1 time --- Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: millisecondClockValue Jan 7 00:07:22: --- last message repeated 2 times --- Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: wait Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: signal Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: yield Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: wait Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: signal Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: wait Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: findNextUnwindContextUpTo: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: tempAt: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: tempAt:put: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: tempAt: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: terminateTo: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: findNextUnwindContextUpTo: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: tempAt: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: tempAt:put: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: tempAt: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: terminateTo: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: signal Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: findNextUnwindContextUpTo: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: terminateTo: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: millisecondClockValue Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: basicNew Jan 7 00:07:22: --- last message repeated 1 time --- Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: millisecondClockValue Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: wait Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: signal Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: at:put: Jan 7 00:07:22: --- last message repeated 3 times --- Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: millisecondClockValue Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: primSignal:atMilliseconds: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: millisecondClockValue Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: wait Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: signal Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: wait Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: millisecondClockValue Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: signal Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: at:put: Jan 7 00:07:22: --- last message repeated 7 times --- Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: primSignal:atMilliseconds: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: millisecondClockValue Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: wait Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: millisecondClockValue Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: @ Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: actualScreenSize Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: species Jan 7 00:07:22: --- last message repeated 1 time --- Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: millisecondClockValue Jan 7 00:07:22: --- last message repeated 1 time --- Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: new: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: millisecondClockValue Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: signal Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: at:put: Jan 7 00:07:22: --- last message repeated 5 times --- Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: primSignal:atMilliseconds: Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: millisecondClockValue Jan 7 00:07:22 robert-arnings-computer [0x0-0x1ad1ad0].com.squeak.Cog[64493]: wait Jan 7 00:07:25 robert-arnings-computer ReportCrash[65021]: Formulating crash report for process Croquet[64493] Jan 7 00:07:26 robert-arnings-computer ReportCrash[65021]: Saved crashreport to /Users/bob/Library/Logs/CrashReporter/Croquet_2012-01-07-000722_robert-arnings-computer.crash using uid: 503 gid: 503, euid: 503 egid: 503 Jan 7 00:07:25 robert-arnings-computer com.apple.launchd[157] ([0x0-0x1ad1ad0].com.squeak.Cog[64493]): Exited abnormally: Abort trap
On Sat, Jan 7, 2012 at 6:22 PM, Bob Arning arning315@comcast.net wrote:
Is that the first file I posted, or yet another file? I looked and did not see anything specifically named "crash.log"
Oops. It is called crash.dmp and is produced in whatever the image file's directory is (a poor choice in certain circumstances, but it has to go somewhere).
Cheers, Bob
On 1/7/12 6:35 PM, Eliot Miranda wrote:
BTW, the below is not as useful as the crash.log file.
Does it take something special to generate one of those? The most recent I have is 18 months old.
Cheers, Bob
On 1/8/12 6:34 PM, Eliot Miranda wrote:
On Sat, Jan 7, 2012 at 6:22 PM, Bob Arning <arning315@comcast.net mailto:arning315@comcast.net> wrote:
Is that the first file I posted, or yet another file? I looked and did not see anything specifically named "crash.log"
Oops. It is called crash.dmp and is produced in whatever the image file's directory is (a poor choice in certain circumstances, but it has to go somewhere).
Cheers, Bob On 1/7/12 6:35 PM, Eliot Miranda wrote:
BTW, the below is not as useful as the crash.log file.
-- best, Eliot
On Sun, Jan 8, 2012 at 4:20 PM, Bob Arning arning315@comcast.net wrote:
Does it take something special to generate one of those? The most recent I have is 18 months old.
They're produced either when the VM experiences a fatal error (either an internal call of error or catching a fatal signal etc). How up-to-date is your VM? That you're seeing messages on the console and not getting a crash.dmp might indicate your VM is old.
Cheers, Bob
On 1/8/12 6:34 PM, Eliot Miranda wrote:
On Sat, Jan 7, 2012 at 6:22 PM, Bob Arning arning315@comcast.net wrote:
Is that the first file I posted, or yet another file? I looked and did not see anything specifically named "crash.log"
Oops. It is called crash.dmp and is produced in whatever the image file's directory is (a poor choice in certain circumstances, but it has to go somewhere).
Cheers, Bob
On 1/7/12 6:35 PM, Eliot Miranda wrote:
BTW, the below is not as useful as the crash.log file.
-- best, Eliot
The most recent crash was with Cog 2522 which I just downloaded a day or two ago. FWIW, I'm not actually seeing these message on a console - I locate the files manually after the fact. I'm not very console oriented.
Cheers, Bob
On 1/9/12 4:05 PM, Eliot Miranda wrote:
On Sun, Jan 8, 2012 at 4:20 PM, Bob Arning <arning315@comcast.net mailto:arning315@comcast.net> wrote:
Does it take something special to generate one of those? The most recent I have is 18 months old.
They're produced either when the VM experiences a fatal error (either an internal call of error or catching a fatal signal etc). How up-to-date is your VM? That you're seeing messages on the console and not getting a crash.dmp might indicate your VM is old.
Cheers, Bob On 1/8/12 6:34 PM, Eliot Miranda wrote:
On Sat, Jan 7, 2012 at 6:22 PM, Bob Arning <arning315@comcast.net <mailto:arning315@comcast.net>> wrote: Is that the first file I posted, or yet another file? I looked and did not see anything specifically named "crash.log" Oops. It is called crash.dmp and is produced in whatever the image file's directory is (a poor choice in certain circumstances, but it has to go somewhere). Cheers, Bob On 1/7/12 6:35 PM, Eliot Miranda wrote:
BTW, the below is not as useful as the crash.log file.
-- best, Eliot
-- best, Eliot
A little more info on these crashes:
I had 4 crashes in the space of about 5 days, then none for 10 days, then another today. This time I happened to be looking at Squeak and noticed that it was no longer writing simulation results to the screen. It was sluggish to come to the front and would not accept CMD-period. Looking in Activity Monitor, real memory usage had gone from the normal 210M to 510M and it seemed to spend about 10 minutes in gargage collection before crashing completely. Any thoughts on how to debug this?
Cheers, Bob
===this is what Activity Monitor saw happening (repeated as often as I chose to sample it)=== Sampling process 306 for 3 seconds with 1 millisecond of run time between samples Sampling completed, processing symbols... Analysis of sampling Croquet (pid 306) every 1 millisecond Call graph: 2506 Thread_2507 2506 start 2506 main 2506 RunApplicationEventLoopWithSqueak 2506 RunApplicationEventLoop 2506 ToolboxEventDispatcher 2506 SendEventToEventTarget 2506 SendEventToEventTargetInternal(OpaqueEventRef*, OpaqueEventTargetRef*, HandlerCallRec*) 2506 DispatchEventToHandlers(EventTargetRec*, OpaqueEventRef*, HandlerCallRec*) 2506 ToolboxEventDispatcherHandler(OpaqueEventHandlerCallRef*, OpaqueEventRef*, void*) 2506 SendEventToEventTargetWithOptions 2506 SendEventToEventTargetInternal(OpaqueEventRef*, OpaqueEventTargetRef*, HandlerCallRec*) 2506 DispatchEventToHandlers(EventTargetRec*, OpaqueEventRef*, HandlerCallRec*) 2506 EventLoopEventHandler 2506 initStackPagesAndInterpret 2506 0x906dd9c 2506 ceSendFromInLineCacheMiss 2505 executeNewMethod 2505 primitiveNew 2505 sufficientSpaceAfterGC 2497 fullGC 1260 markPhase 688 markAndTraceStackPage 688 markAndTrace 688 markAndTrace 566 markAndTraceInterpreterOops 566 markAndTraceStackPage 566 markAndTrace 566 markAndTrace 6 markAndTraceObjectsOrFreeMachineCode 6 markAndTraceOrFreeCogMethodfirstVisit 5 markLiteralsAndUnlinkIfUnmarkedSendpcmethod 3 markAndTraceOrFreeCogMethodfirstVisit 3 markLiteralsAndUnlinkIfUnmarkedSendpcmethod 3 markAndTraceOrFreeCogMethodfirstVisit 2 markLiteralsAndUnlinkIfUnmarkedSendpcmethod 2 markAndTraceOrFreeCogMethodfirstVisit 2 markLiteralsAndUnlinkIfUnmarkedSendpcmethod 1 markAndTraceOrFreeCogMethodfirstVisit 1 markAndTraceOrFreeCogMethodfirstVisit 1 markLiteralsAndUnlinkIfUnmarkedSendpcmethod 1 startOfMemory 1 startOfMemory 2 markAndTrace 2 markAndTrace 1 markAndTraceOrFreeCogMethodfirstVisit 800 incCompBody 800 mapPointersInObjectsFromto 797 mapPointersInObjectsFromto 3 mapObjectReferencesInMachineCode 2 remap 2 remap 1 remapIfObjectRefpchasYoung 1 remap 1 remap 432 fullGC 5 finalizeReference 5 finalizeReference 8 incrementalGC 8 markPhase 8 markAndTraceInterpreterOops 7 markAndTraceStackPage 6 markAndTrace 6 markAndTrace 1 markAndTraceStackPage 1 markAndTraceInterpreterOops 1 activateCoggedNewMethod 1 checkForEventsMayContextSwitch 1 ioProcessEvents 1 ReceiveNextEvent 1 ReceiveNextEventCommon 1 RunCurrentEventLoopInMode 1 CFStringCompare 1 CFStringCompareWithOptions 1 CFStringCompareWithOptionsAndLocale 1 CFUniCharGetBitmapPtrForPlane 1 CFUniCharGetBitmapPtrForPlane 2506 Thread_2603 2506 thread_start 2506 _pthread_start 2506 beatStateMachine 2487 __semwait_signal 2487 __semwait_signal 11 nanosleep$UNIX2003 10 clock_get_time 10 mach_msg 10 mach_msg_trap 10 mach_msg_trap 1 nanosleep$UNIX2003 2 __udivdi3 2 __udivdi3 2 beatStateMachine 2 cerror 2 __error 2 __error 1 __error 1 __error 1 forceInterruptCheckFromHeartbeat 1 forceInterruptCheckFromHeartbeat
Total number in stack (recursive counted multiple, when >=5): 5 markAndTraceOrFreeCogMethodfirstVisit
Sort by top of stack, same collapsed (when >= 5): __semwait_signal 2487 markAndTrace 1262 mapPointersInObjectsFromto 797 fullGC 432 mach_msg_trap 10 finalizeReference 5 Sample analysis of process 306 written to file /dev/stdout
===this appeared on the console=== Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: out of memory Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: C stack backtrace: Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: Smalltalk stack dump: Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: 0xbffa8308 M Delay class>handleTimerEvent 157474072: a(n) Delay class Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: 0xbffa8320 M Delay Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: class>runTimerEventLoop 157474072: a(n) Delay class Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: 0x9851140 s [] in Delay class>startTimerEventLoop Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: 0x9851260 s [] in BlockClosure>newProcess Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: Most recent primitives Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: wait Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: basicNew Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: primSignal:atMilliseconds: Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: wait Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: basicNew ...repeated items snipped... Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: wait Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: primSignal:atMilliseconds: Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: wait Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: primSignal:atMilliseconds: Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: wait Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: primSignal:atMilliseconds: Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: wait Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: primSignal:atMilliseconds: Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: wait Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: primSignal:atMilliseconds: Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: wait Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: (out of memory) Jan 19 07:37:19 robert-arnings-computer com.apple.launchd[102] ([0x0-0x25025].com.squeak.Cog[306]): Exited abnormally: Abort trap
On 1/9/12 4:05 PM, Eliot Miranda wrote:
On Sun, Jan 8, 2012 at 4:20 PM, Bob Arning <arning315@comcast.net mailto:arning315@comcast.net> wrote:
Does it take something special to generate one of those? The most recent I have is 18 months old.
They're produced either when the VM experiences a fatal error (either an internal call of error or catching a fatal signal etc). How up-to-date is your VM? That you're seeing messages on the console and not getting a crash.dmp might indicate your VM is old.
Cheers, Bob On 1/8/12 6:34 PM, Eliot Miranda wrote:
On Sat, Jan 7, 2012 at 6:22 PM, Bob Arning <arning315@comcast.net <mailto:arning315@comcast.net>> wrote: Is that the first file I posted, or yet another file? I looked and did not see anything specifically named "crash.log" Oops. It is called crash.dmp and is produced in whatever the image file's directory is (a poor choice in certain circumstances, but it has to go somewhere). Cheers, Bob On 1/7/12 6:35 PM, Eliot Miranda wrote:
BTW, the below is not as useful as the crash.log file.
-- best, Eliot
-- best, Eliot
A little more info...
Smalltalk installLowSpaceWatcher; useUpMemory == crashes VM
Smalltalk installLowSpaceWatcher; useUpMemoryWithArrays == produces low space debugger
Smalltalk installLowSpaceWatcher; useUpMemoryWithContexts == crashes VM
Smalltalk installLowSpaceWatcher; useUpMemoryWithTinyObjects == produces low space debugger
Cheers, Bob
On 1/19/12 8:12 AM, Bob Arning wrote:
A little more info on these crashes:
I had 4 crashes in the space of about 5 days, then none for 10 days, then another today. This time I happened to be looking at Squeak and noticed that it was no longer writing simulation results to the screen. It was sluggish to come to the front and would not accept CMD-period. Looking in Activity Monitor, real memory usage had gone from the normal 210M to 510M and it seemed to spend about 10 minutes in gargage collection before crashing completely. Any thoughts on how to debug this?
Cheers, Bob
===this is what Activity Monitor saw happening (repeated as often as I chose to sample it)=== Sampling process 306 for 3 seconds with 1 millisecond of run time between samples Sampling completed, processing symbols... Analysis of sampling Croquet (pid 306) every 1 millisecond Call graph: 2506 Thread_2507 2506 start 2506 main 2506 RunApplicationEventLoopWithSqueak 2506 RunApplicationEventLoop 2506 ToolboxEventDispatcher 2506 SendEventToEventTarget 2506 SendEventToEventTargetInternal(OpaqueEventRef*, OpaqueEventTargetRef*, HandlerCallRec*) 2506 DispatchEventToHandlers(EventTargetRec*, OpaqueEventRef*, HandlerCallRec*) 2506 ToolboxEventDispatcherHandler(OpaqueEventHandlerCallRef*, OpaqueEventRef*, void*) 2506 SendEventToEventTargetWithOptions 2506 SendEventToEventTargetInternal(OpaqueEventRef*, OpaqueEventTargetRef*, HandlerCallRec*) 2506 DispatchEventToHandlers(EventTargetRec*, OpaqueEventRef*, HandlerCallRec*) 2506 EventLoopEventHandler 2506 initStackPagesAndInterpret 2506 0x906dd9c 2506 ceSendFromInLineCacheMiss 2505 executeNewMethod 2505 primitiveNew 2505 sufficientSpaceAfterGC 2497 fullGC 1260 markPhase 688 markAndTraceStackPage 688 markAndTrace 688 markAndTrace 566 markAndTraceInterpreterOops 566 markAndTraceStackPage 566 markAndTrace 566 markAndTrace 6 markAndTraceObjectsOrFreeMachineCode 6 markAndTraceOrFreeCogMethodfirstVisit 5 markLiteralsAndUnlinkIfUnmarkedSendpcmethod 3 markAndTraceOrFreeCogMethodfirstVisit 3 markLiteralsAndUnlinkIfUnmarkedSendpcmethod 3 markAndTraceOrFreeCogMethodfirstVisit 2 markLiteralsAndUnlinkIfUnmarkedSendpcmethod 2 markAndTraceOrFreeCogMethodfirstVisit 2 markLiteralsAndUnlinkIfUnmarkedSendpcmethod 1 markAndTraceOrFreeCogMethodfirstVisit 1 markAndTraceOrFreeCogMethodfirstVisit 1 markLiteralsAndUnlinkIfUnmarkedSendpcmethod 1 startOfMemory 1 startOfMemory 2 markAndTrace 2 markAndTrace 1 markAndTraceOrFreeCogMethodfirstVisit 800 incCompBody 800 mapPointersInObjectsFromto 797 mapPointersInObjectsFromto 3 mapObjectReferencesInMachineCode 2 remap 2 remap 1 remapIfObjectRefpchasYoung 1 remap 1 remap 432 fullGC 5 finalizeReference 5 finalizeReference 8 incrementalGC 8 markPhase 8 markAndTraceInterpreterOops 7 markAndTraceStackPage 6 markAndTrace 6 markAndTrace 1 markAndTraceStackPage 1 markAndTraceInterpreterOops 1 activateCoggedNewMethod 1 checkForEventsMayContextSwitch 1 ioProcessEvents 1 ReceiveNextEvent 1 ReceiveNextEventCommon 1 RunCurrentEventLoopInMode 1 CFStringCompare 1 CFStringCompareWithOptions 1 CFStringCompareWithOptionsAndLocale 1 CFUniCharGetBitmapPtrForPlane 1 CFUniCharGetBitmapPtrForPlane 2506 Thread_2603 2506 thread_start 2506 _pthread_start 2506 beatStateMachine 2487 __semwait_signal 2487 __semwait_signal 11 nanosleep$UNIX2003 10 clock_get_time 10 mach_msg 10 mach_msg_trap 10 mach_msg_trap 1 nanosleep$UNIX2003 2 __udivdi3 2 __udivdi3 2 beatStateMachine 2 cerror 2 __error 2 __error 1 __error 1 __error 1 forceInterruptCheckFromHeartbeat 1 forceInterruptCheckFromHeartbeat
Total number in stack (recursive counted multiple, when >=5): 5 markAndTraceOrFreeCogMethodfirstVisit
Sort by top of stack, same collapsed (when >= 5): __semwait_signal 2487 markAndTrace 1262 mapPointersInObjectsFromto 797 fullGC 432 mach_msg_trap 10 finalizeReference 5 Sample analysis of process 306 written to file /dev/stdout
===this appeared on the console=== Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: out of memory Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: C stack backtrace: Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: Smalltalk stack dump: Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: 0xbffa8308 M Delay class>handleTimerEvent 157474072: a(n) Delay class Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: 0xbffa8320 M Delay Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: class>runTimerEventLoop 157474072: a(n) Delay class Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: 0x9851140 s [] in Delay class>startTimerEventLoop Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: 0x9851260 s [] in BlockClosure>newProcess Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: Most recent primitives Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: wait Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: basicNew Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: primSignal:atMilliseconds: Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: wait Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: basicNew ...repeated items snipped... Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: wait Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: primSignal:atMilliseconds: Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: wait Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: primSignal:atMilliseconds: Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: wait Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: primSignal:atMilliseconds: Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: wait Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: primSignal:atMilliseconds: Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: wait Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: primSignal:atMilliseconds: Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: wait Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: (out of memory) Jan 19 07:37:19 robert-arnings-computer com.apple.launchd[102] ([0x0-0x25025].com.squeak.Cog[306]): Exited abnormally: Abort trap
On 1/9/12 4:05 PM, Eliot Miranda wrote:
On Sun, Jan 8, 2012 at 4:20 PM, Bob Arning <arning315@comcast.net mailto:arning315@comcast.net> wrote:
Does it take something special to generate one of those? The most recent I have is 18 months old.
They're produced either when the VM experiences a fatal error (either an internal call of error or catching a fatal signal etc). How up-to-date is your VM? That you're seeing messages on the console and not getting a crash.dmp might indicate your VM is old.
Cheers, Bob On 1/8/12 6:34 PM, Eliot Miranda wrote:
On Sat, Jan 7, 2012 at 6:22 PM, Bob Arning <arning315@comcast.net <mailto:arning315@comcast.net>> wrote: Is that the first file I posted, or yet another file? I looked and did not see anything specifically named "crash.log" Oops. It is called crash.dmp and is produced in whatever the image file's directory is (a poor choice in certain circumstances, but it has to go somewhere). Cheers, Bob On 1/7/12 6:35 PM, Eliot Miranda wrote:
BTW, the below is not as useful as the crash.log file.
-- best, Eliot
-- best, Eliot
Still hoping to debug this in Smalltalk, I'm exploring the bounds a bit.
for Smalltalk installLowSpaceWatcher; useUpMemory
I tried increasing the lowSpaceThreshold in case that was the reason I was not getting a low space log. The nominal size (200k) and 300k both lead to vm crashes. Larger numbers cause the vm to spend forever in garbage collection (well, 15 minutes at least)
10M hangs at 476M real 1M hangs at 490M real 400K hangs at 491.5M real 300K ==crashes VM at 499M real (approximate) 200K ==crashes VM -------------------------------------------------------------------------------------- repeating the experiment for Smalltalk installLowSpaceWatcher; useUpMemoryWithContexts
had similar results although the crash-to-hang threshold was a bit higher 12M hangs at 493M real 1M ==crashesVM around 508M real 600K ==crashesVM around 507M real 400K ==crashesVM around 508M real 200K ==crashes VM
------------------------------------------------------------------------------------ The interesting thing about this test is that it get a low space debugger, but not where the code expects it. The error is signalled when allocating the String, not the Arrays.
Smalltalk installLowSpaceWatcher; useUpMemoryWithArrays == produces low space debugger
------------------------------------------------------------------------------------ So, I made a slightly different version that allocates a slightly smaller, but still huge String and then allocates Arrays of a particular size. It appears that for smaller array sizes, the vm hangs, while for larger sizes, it will signal low space.
Smalltalk installLowSpaceWatcher; useUpMemoryWithArrays: 100 -- hangs at 509M Smalltalk installLowSpaceWatcher; useUpMemoryWithArrays: 300 -- hangs at 509M Smalltalk installLowSpaceWatcher; useUpMemoryWithArrays: 500 -- hangs at 515M Smalltalk installLowSpaceWatcher; useUpMemoryWithArrays: 700 -- low space at 509M Smalltalk installLowSpaceWatcher; useUpMemoryWithArrays: 1000 -- low space at 509M
============ useUpMemoryWithArrays: arraySize
| b bytesLeft lsp req count |
req _ (bytesLeft _ self bytesLeft) - (lsp _ self lowSpaceThreshold) - (20*1024*1024). count _ 50000000 // arraySize // 4. Transcript show: bytesLeft asStringWithCommas,' bytesLeft(before)'; cr; show: lsp asStringWithCommas,' lowSpaceThreshold'; cr; show: req asStringWithCommas,' string size requested'; cr; show: count asStringWithCommas,' Arrays to be requested'; cr; show: arraySize asStringWithCommas,' Array size requested'; cr; yourself. self confirm: 'ready to allocate the string'. b := String new: req. self confirm: 'we got the string ',b size asStringWithCommas.
(1 to: count) collect: [:i | Array new: arraySize].
self confirm: 'oops! no problems detected'. =============
--------------------------------------------------------------------------------------
On 1/19/12 10:26 AM, Bob Arning wrote:
A little more info...
Smalltalk installLowSpaceWatcher; useUpMemory == crashes VM
Smalltalk installLowSpaceWatcher; useUpMemoryWithArrays == produces low space debugger
Smalltalk installLowSpaceWatcher; useUpMemoryWithContexts == crashes VM
Smalltalk installLowSpaceWatcher; useUpMemoryWithTinyObjects == produces low space debugger
Cheers, Bob
On 1/19/12 8:12 AM, Bob Arning wrote:
A little more info on these crashes:
I had 4 crashes in the space of about 5 days, then none for 10 days, then another today. This time I happened to be looking at Squeak and noticed that it was no longer writing simulation results to the screen. It was sluggish to come to the front and would not accept CMD-period. Looking in Activity Monitor, real memory usage had gone from the normal 210M to 510M and it seemed to spend about 10 minutes in gargage collection before crashing completely. Any thoughts on how to debug this?
Cheers, Bob
===this is what Activity Monitor saw happening (repeated as often as I chose to sample it)=== Sampling process 306 for 3 seconds with 1 millisecond of run time between samples Sampling completed, processing symbols... Analysis of sampling Croquet (pid 306) every 1 millisecond Call graph: 2506 Thread_2507 2506 start 2506 main 2506 RunApplicationEventLoopWithSqueak 2506 RunApplicationEventLoop 2506 ToolboxEventDispatcher 2506 SendEventToEventTarget 2506 SendEventToEventTargetInternal(OpaqueEventRef*, OpaqueEventTargetRef*, HandlerCallRec*) 2506 DispatchEventToHandlers(EventTargetRec*, OpaqueEventRef*, HandlerCallRec*) 2506 ToolboxEventDispatcherHandler(OpaqueEventHandlerCallRef*, OpaqueEventRef*, void*) 2506 SendEventToEventTargetWithOptions 2506 SendEventToEventTargetInternal(OpaqueEventRef*, OpaqueEventTargetRef*, HandlerCallRec*) 2506 DispatchEventToHandlers(EventTargetRec*, OpaqueEventRef*, HandlerCallRec*) 2506 EventLoopEventHandler 2506 initStackPagesAndInterpret 2506 0x906dd9c 2506 ceSendFromInLineCacheMiss 2505 executeNewMethod 2505 primitiveNew 2505 sufficientSpaceAfterGC 2497 fullGC 1260 markPhase 688 markAndTraceStackPage 688 markAndTrace 688 markAndTrace 566 markAndTraceInterpreterOops 566 markAndTraceStackPage 566 markAndTrace 566 markAndTrace 6 markAndTraceObjectsOrFreeMachineCode 6 markAndTraceOrFreeCogMethodfirstVisit 5 markLiteralsAndUnlinkIfUnmarkedSendpcmethod 3 markAndTraceOrFreeCogMethodfirstVisit 3 markLiteralsAndUnlinkIfUnmarkedSendpcmethod 3 markAndTraceOrFreeCogMethodfirstVisit 2 markLiteralsAndUnlinkIfUnmarkedSendpcmethod 2 markAndTraceOrFreeCogMethodfirstVisit 2 markLiteralsAndUnlinkIfUnmarkedSendpcmethod 1 markAndTraceOrFreeCogMethodfirstVisit 1 markAndTraceOrFreeCogMethodfirstVisit 1 markLiteralsAndUnlinkIfUnmarkedSendpcmethod 1 startOfMemory 1 startOfMemory 2 markAndTrace 2 markAndTrace 1 markAndTraceOrFreeCogMethodfirstVisit 800 incCompBody 800 mapPointersInObjectsFromto 797 mapPointersInObjectsFromto 3 mapObjectReferencesInMachineCode 2 remap 2 remap 1 remapIfObjectRefpchasYoung 1 remap 1 remap 432 fullGC 5 finalizeReference 5 finalizeReference 8 incrementalGC 8 markPhase 8 markAndTraceInterpreterOops 7 markAndTraceStackPage 6 markAndTrace 6 markAndTrace 1 markAndTraceStackPage 1 markAndTraceInterpreterOops 1 activateCoggedNewMethod 1 checkForEventsMayContextSwitch 1 ioProcessEvents 1 ReceiveNextEvent 1 ReceiveNextEventCommon 1 RunCurrentEventLoopInMode 1 CFStringCompare 1 CFStringCompareWithOptions 1 CFStringCompareWithOptionsAndLocale 1 CFUniCharGetBitmapPtrForPlane 1 CFUniCharGetBitmapPtrForPlane 2506 Thread_2603 2506 thread_start 2506 _pthread_start 2506 beatStateMachine 2487 __semwait_signal 2487 __semwait_signal 11 nanosleep$UNIX2003 10 clock_get_time 10 mach_msg 10 mach_msg_trap 10 mach_msg_trap 1 nanosleep$UNIX2003 2 __udivdi3 2 __udivdi3 2 beatStateMachine 2 cerror 2 __error 2 __error 1 __error 1 __error 1 forceInterruptCheckFromHeartbeat 1 forceInterruptCheckFromHeartbeat
Total number in stack (recursive counted multiple, when >=5): 5 markAndTraceOrFreeCogMethodfirstVisit
Sort by top of stack, same collapsed (when >= 5): __semwait_signal 2487 markAndTrace 1262 mapPointersInObjectsFromto 797 fullGC 432 mach_msg_trap 10 finalizeReference 5 Sample analysis of process 306 written to file /dev/stdout
===this appeared on the console=== Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: out of memory Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: C stack backtrace: Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: Smalltalk stack dump: Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: 0xbffa8308 M Delay class>handleTimerEvent 157474072: a(n) Delay class Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: 0xbffa8320 M Delay Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: class>runTimerEventLoop 157474072: a(n) Delay class Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: 0x9851140 s [] in Delay class>startTimerEventLoop Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: 0x9851260 s [] in BlockClosure>newProcess Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: Most recent primitives Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: wait Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: basicNew Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: primSignal:atMilliseconds: Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: wait Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: basicNew ...repeated items snipped... Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: wait Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: primSignal:atMilliseconds: Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: wait Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: primSignal:atMilliseconds: Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: wait Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: primSignal:atMilliseconds: Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: wait Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: primSignal:atMilliseconds: Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: wait Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: primSignal:atMilliseconds: Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: wait Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: (out of memory) Jan 19 07:37:19 robert-arnings-computer com.apple.launchd[102] ([0x0-0x25025].com.squeak.Cog[306]): Exited abnormally: Abort trap
On 1/9/12 4:05 PM, Eliot Miranda wrote:
On Sun, Jan 8, 2012 at 4:20 PM, Bob Arning <arning315@comcast.net mailto:arning315@comcast.net> wrote:
Does it take something special to generate one of those? The most recent I have is 18 months old.
They're produced either when the VM experiences a fatal error (either an internal call of error or catching a fatal signal etc). How up-to-date is your VM? That you're seeing messages on the console and not getting a crash.dmp might indicate your VM is old.
Cheers, Bob On 1/8/12 6:34 PM, Eliot Miranda wrote:
On Sat, Jan 7, 2012 at 6:22 PM, Bob Arning <arning315@comcast.net <mailto:arning315@comcast.net>> wrote: Is that the first file I posted, or yet another file? I looked and did not see anything specifically named "crash.log" Oops. It is called crash.dmp and is produced in whatever the image file's directory is (a poor choice in certain circumstances, but it has to go somewhere). Cheers, Bob On 1/7/12 6:35 PM, Eliot Miranda wrote:
BTW, the below is not as useful as the crash.log file.
-- best, Eliot
-- best, Eliot
Bob,
the error clearly says
Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: *out of memory*
So you have an infinite recursion somewhere. If you have advance warning (e.g. the system starts to get sluggish) you can use kill -USR1 to get a dump of all processes. Alternatively you can run the VM under gdb, put a halt in error, and do
gdb> call printAllStacks()
when the error is reached. You can use pushOutputFile to get the stack dump written to a particular file, e.g.
gdb> call pushOutputFile("stacktraces.txt") gdb> call printAllStacks() gdb> call popOutputFile()
HTH Eliot
On Thu, Jan 19, 2012 at 5:12 AM, Bob Arning arning315@comcast.net wrote:
A little more info on these crashes:
I had 4 crashes in the space of about 5 days, then none for 10 days, then another today. This time I happened to be looking at Squeak and noticed that it was no longer writing simulation results to the screen. It was sluggish to come to the front and would not accept CMD-period. Looking in Activity Monitor, real memory usage had gone from the normal 210M to 510M and it seemed to spend about 10 minutes in gargage collection before crashing completely. Any thoughts on how to debug this?
Cheers, Bob
===this is what Activity Monitor saw happening (repeated as often as I chose to sample it)=== Sampling process 306 for 3 seconds with 1 millisecond of run time between samples Sampling completed, processing symbols... Analysis of sampling Croquet (pid 306) every 1 millisecond Call graph: 2506 Thread_2507 2506 start 2506 main 2506 RunApplicationEventLoopWithSqueak 2506 RunApplicationEventLoop 2506 ToolboxEventDispatcher 2506 SendEventToEventTarget 2506 SendEventToEventTargetInternal(OpaqueEventRef*, OpaqueEventTargetRef*, HandlerCallRec*) 2506 DispatchEventToHandlers(EventTargetRec*, OpaqueEventRef*, HandlerCallRec*) 2506 ToolboxEventDispatcherHandler(OpaqueEventHandlerCallRef*, OpaqueEventRef*, void*) 2506 SendEventToEventTargetWithOptions 2506 SendEventToEventTargetInternal(OpaqueEventRef*, OpaqueEventTargetRef*, HandlerCallRec*) 2506 DispatchEventToHandlers(EventTargetRec*, OpaqueEventRef*, HandlerCallRec*) 2506 EventLoopEventHandler 2506 initStackPagesAndInterpret 2506 0x906dd9c 2506 ceSendFromInLineCacheMiss 2505 executeNewMethod 2505 primitiveNew 2505 sufficientSpaceAfterGC 2497 fullGC 1260 markPhase 688 markAndTraceStackPage 688 markAndTrace 688 markAndTrace 566 markAndTraceInterpreterOops 566 markAndTraceStackPage 566 markAndTrace 566 markAndTrace 6 markAndTraceObjectsOrFreeMachineCode 6 markAndTraceOrFreeCogMethodfirstVisit 5 markLiteralsAndUnlinkIfUnmarkedSendpcmethod 3 markAndTraceOrFreeCogMethodfirstVisit 3 markLiteralsAndUnlinkIfUnmarkedSendpcmethod 3 markAndTraceOrFreeCogMethodfirstVisit 2 markLiteralsAndUnlinkIfUnmarkedSendpcmethod 2 markAndTraceOrFreeCogMethodfirstVisit 2 markLiteralsAndUnlinkIfUnmarkedSendpcmethod 1 markAndTraceOrFreeCogMethodfirstVisit 1 markAndTraceOrFreeCogMethodfirstVisit 1 markLiteralsAndUnlinkIfUnmarkedSendpcmethod 1 startOfMemory 1 startOfMemory 2 markAndTrace 2 markAndTrace 1 markAndTraceOrFreeCogMethodfirstVisit 800 incCompBody 800 mapPointersInObjectsFromto 797 mapPointersInObjectsFromto 3 mapObjectReferencesInMachineCode 2 remap 2 remap 1 remapIfObjectRefpchasYoung 1 remap 1 remap 432 fullGC 5 finalizeReference 5 finalizeReference 8 incrementalGC 8 markPhase 8 markAndTraceInterpreterOops 7 markAndTraceStackPage 6 markAndTrace 6 markAndTrace 1 markAndTraceStackPage 1 markAndTraceInterpreterOops 1 activateCoggedNewMethod 1 checkForEventsMayContextSwitch 1 ioProcessEvents 1 ReceiveNextEvent 1 ReceiveNextEventCommon 1 RunCurrentEventLoopInMode 1 CFStringCompare 1 CFStringCompareWithOptions 1 CFStringCompareWithOptionsAndLocale 1 CFUniCharGetBitmapPtrForPlane 1 CFUniCharGetBitmapPtrForPlane 2506 Thread_2603 2506 thread_start 2506 _pthread_start 2506 beatStateMachine 2487 __semwait_signal 2487 __semwait_signal 11 nanosleep$UNIX2003 10 clock_get_time 10 mach_msg 10 mach_msg_trap 10 mach_msg_trap 1 nanosleep$UNIX2003 2 __udivdi3 2 __udivdi3 2 beatStateMachine 2 cerror 2 __error 2 __error 1 __error 1 __error 1 forceInterruptCheckFromHeartbeat 1 forceInterruptCheckFromHeartbeat
Total number in stack (recursive counted multiple, when >=5): 5 markAndTraceOrFreeCogMethodfirstVisit
Sort by top of stack, same collapsed (when >= 5): __semwait_signal 2487 markAndTrace 1262 mapPointersInObjectsFromto 797 fullGC 432 mach_msg_trap 10 finalizeReference 5 Sample analysis of process 306 written to file /dev/stdout
===this appeared on the console=== Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: out of memory Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: C stack backtrace: Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: Smalltalk stack dump: Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: 0xbffa8308 M Delay class>handleTimerEvent 157474072: a(n) Delay class Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: 0xbffa8320 M Delay Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: class>runTimerEventLoop 157474072: a(n) Delay class Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: 0x9851140 s [] in Delay class>startTimerEventLoop Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: 0x9851260 s [] in BlockClosure>newProcess Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: Most recent primitives Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: wait Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: basicNew Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: primSignal:atMilliseconds: Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: wait Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: basicNew ...repeated items snipped... Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: wait Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: primSignal:atMilliseconds: Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: wait Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: primSignal:atMilliseconds: Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: wait Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: primSignal:atMilliseconds: Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: wait Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: primSignal:atMilliseconds: Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: wait Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: primSignal:atMilliseconds: Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: millisecondClockValue Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: wait Jan 19 07:37:15 robert-arnings-computer [0x0-0x25025].com.squeak.Cog[306]: (out of memory) Jan 19 07:37:19 robert-arnings-computer com.apple.launchd[102] ([0x0-0x25025].com.squeak.Cog[306]): Exited abnormally: Abort trap
On 1/9/12 4:05 PM, Eliot Miranda wrote:
On Sun, Jan 8, 2012 at 4:20 PM, Bob Arning arning315@comcast.net wrote:
Does it take something special to generate one of those? The most recent I have is 18 months old.
They're produced either when the VM experiences a fatal error (either an internal call of error or catching a fatal signal etc). How up-to-date is your VM? That you're seeing messages on the console and not getting a crash.dmp might indicate your VM is old.
Cheers, Bob
On 1/8/12 6:34 PM, Eliot Miranda wrote:
On Sat, Jan 7, 2012 at 6:22 PM, Bob Arning arning315@comcast.net wrote:
Is that the first file I posted, or yet another file? I looked and did not see anything specifically named "crash.log"
Oops. It is called crash.dmp and is produced in whatever the image file's directory is (a poor choice in certain circumstances, but it has to go somewhere).
Cheers, Bob
On 1/7/12 6:35 PM, Eliot Miranda wrote:
BTW, the below is not as useful as the crash.log file.
-- best, Eliot
-- best, Eliot
Crashed again overnight. Still no crash.dmp to be found. This time using latest non-MT Cog (2522).
Cheers, Bob
On 1/8/12 6:34 PM, Eliot Miranda wrote:
On Sat, Jan 7, 2012 at 6:22 PM, Bob Arning <arning315@comcast.net mailto:arning315@comcast.net> wrote:
Is that the first file I posted, or yet another file? I looked and did not see anything specifically named "crash.log"
Oops. It is called crash.dmp and is produced in whatever the image file's directory is (a poor choice in certain circumstances, but it has to go somewhere).
Cheers, Bob On 1/7/12 6:35 PM, Eliot Miranda wrote:
BTW, the below is not as useful as the crash.log file.
-- best, Eliot
On Sat, Jan 7, 2012 at 6:35 PM, Eliot Miranda eliot.miranda@gmail.com wrote:
On Sat, Jan 7, 2012 at 7:28 AM, Bob Arning arning315@comcast.net wrote:
Found some more details. Seems to be saying it's out of memory. How is this different from getting a LowSpaceDebug log?
LowSpaceDebug.log is written from the image ]
Like
Back in 05 Tim and I looked at this, you can steal space from the GC reserved space btw, chewing it down from MB to kilobytes. But what Tim and I realized was that the condition was usually fatal, so why bother. To fix what you have to do is suspend/debug all tasks not associated with running the image, and let the developer figure out who is the bad guy. Right now it suspects the running process which usually isn't the evil one. Or attempts to ask the developer to fix the issue, but you are milliseconds from death...
vm-dev@lists.squeakfoundation.org