[svn2060] occasional freezes on startup

Where bugs go to lie down and rest

Moderator: Moderator

Post Reply
Message
Author
yufra
Perspiring Physicist
Posts: 1332
Joined: Tue Jul 13, 2010 2:53 pm

[svn2060] occasional freezes on startup

#1 Post by yufra »

I have seen a few references to this on the forums, and decided to go ahead and report it. This happens maybe 1 in 3 times, and killing the process and restarting it usually works. Here is the excerpt from the stdout when the process hangs, with a bunch of "77 ticks" appearing until the process is killed. Maybe it is the getnews coroutine?

Specifics: svn2060, Mac OSX 10.6

Code: Select all

[MUSIC] playing	The saga begins.ogg	userdata: 0x18f6024	 :: current ? 	nil
play music 175075d0 -1 0
[COROUTINE] registering	getnews	thread: 0x17555910
[ENGINE] Setting requested FPS to 30 (33 ms)
1 ticks  in 12.505 seconds = 0.079968 TPS
77 ticks  in 10.01 seconds = 7.69231 TPS
EDIT: Just happened again, here is the backtrace with some user information removed. Not terribly helpful, at least not to me.

Code: Select all

(gdb) bt
#0  0x941dd0fa in mach_msg_trap ()
#1  0x941dd867 in mach_msg ()
#2  0x94200b18 in mach_port_insert_member ()
#3  0x94854130 in __CFRunLoopRun ()
#4  0x94852464 in CFRunLoopRunSpecific ()
#5  0x94852291 in CFRunLoopRunInMode ()
#6  0x9004df9c in RunCurrentEventLoopInMode ()
#7  0x9004dd51 in ReceiveNextEventCommon ()
#8  0x9004dbd6 in BlockUntilNextEventMatchingListInMode ()
#9  0x9054678d in _DPSNextEvent ()
#10 0x90545fce in -[NSApplication nextEventMatchingMask:untilDate:inMode:dequeue:] ()
#11 0x00245950 in SDL_SoftStretch ()
#12 0x00216af5 in SDL_PollEvent ()
#13 0x0006b174 in tengine_main (argc=1, argv=0x407fc0) at t-engine4/mac/T-Engine/../../src/main.c:745
#14 0x000440be in -[SDLMain applicationDidFinishLaunching:] (self=0x40ae60, _cmd=0x94073502, note=0x436370) at t-engine4/mac/T-Engine/../../src/mac/SDLMain.m:213
#15 0x959954df in _nsnote_callback ()
#16 0x94871793 in __CFXNotificationPost ()
#17 0x9487119a in _CFXNotificationPostNotification ()
#18 0x9598a384 in -[NSNotificationCenter postNotificationName:object:userInfo:] ()
#19 0x95997789 in -[NSNotificationCenter postNotificationName:object:] ()
#20 0x90576422 in -[NSApplication _postDidFinishNotification] ()
#21 0x90576332 in -[NSApplication _sendFinishLaunchingNotification] ()
#22 0x906cd4ed in -[NSApplication(NSAppleEventHandling) _handleAEOpen:] ()
#23 0x906cd10d in -[NSApplication(NSAppleEventHandling) _handleCoreEvent:withReplyEvent:] ()
#24 0x959ca7a4 in -[NSAppleEventManager dispatchRawAppleEvent:withRawReply:handlerRefCon:] ()
#25 0x959ca568 in _NSAppleEventManagerGenericHandler ()
#26 0x92d4cf58 in aeDispatchAppleEvent ()
#27 0x92d4ce57 in dispatchEventAndSendReply ()
#28 0x92d4cd61 in aeProcessAppleEvent ()
#29 0x90055323 in AEProcessAppleEvent ()
#30 0x905469ca in _DPSNextEvent ()
#31 0x90545fce in -[NSApplication nextEventMatchingMask:untilDate:inMode:dequeue:] ()
#32 0x90508247 in -[NSApplication run] ()
#33 0x00043ed2 in CustomApplicationMain (argc=1, argv=0xbffff720) at t-engine4/mac/T-Engine/../../src/mac/SDLMain.m:150
#34 0x000441dc in main (argc=1, argv=0xbffff720) at t-engine4/mac/T-Engine/../../src/mac/SDLMain.m:244
EDIT2: Another oddity... apparently I can still select menu options. The screen is still black with the cursor showing up in the top left, but the stdout shows this after I hit enter:

Code: Select all

Creating module	angband	:: (as dir)	true	:: (as team)	nil	
Loaded module definition for angband-1.0.0 using engine te4-0.9.16
Creating module	boot	:: (as dir)	true	:: (as team)	nil	
Loaded module definition for boot-0.9.16 using engine te4-0.9.16
Creating module	crimelike	:: (as dir)	true	:: (as team)	nil	
Module mismatch engine version crime-0.1.6 using engine te4-0.9.13
Creating module	example	:: (as dir)	true	:: (as team)	nil	
Loaded module definition for example-1.0.0 using engine te4-0.9.16
Creating module	example_realtime	:: (as dir)	true	:: (as team)	nil	
Loaded module definition for example_realtime-1.0.0 using engine te4-0.9.16
Creating module	noise.team	:: (as dir)	false	:: (as team)	6	
Module mismatch engine version noise-1.0.0 using engine te4-1.0.0
Creating module	tome	:: (as dir)	true	:: (as team)	nil	
Loaded module definition for tome-3.9.16 using engine te4-0.9.16
Creating module	tome.team	:: (as dir)	false	:: (as team)	5	
Module mismatch engine version tome-4.0.0 using engine te4-1.0.0
Creating module	viralresistance	:: (as dir)	true	:: (as team)	nil	
Module mismatch engine version viralresistance-0.1.6 using engine te4-0.9.14
tome	angband
example	tome
angband	example
boot	angband
angband	example_realtime
angband	boot
angband	tome
example	example_realtime
boot	example
* Module: tome
 ** 3.9.16
* Module: angband
 ** 1.0.0
* Module: boot
 ** 0.9.16
* Module: example
 ** 1.0.0
* Module: example_realtime
 ** 1.0.0
Curiouser and curiouser...
<DarkGod> lets say it's intended

darkgod
Master of Eyal
Posts: 10751
Joined: Wed Jul 24, 2002 9:26 pm
Location: Angolwen
Contact:

Re: [svn2060] occasional freezes on startup

#2 Post by darkgod »

Interresting ..

Can you try adding:

Code: Select all

	core.game.setFPS(config.settings.display_fps)
At line 123 of game/engines/default/modules/boot/class/Game.lua, just before the "end"
[tome] joylove: You can't just release an expansion like one would release a Kraken XD
--
[tome] phantomfrettchen: your ability not to tease anyone is simply stunning ;)

yufra
Perspiring Physicist
Posts: 1332
Joined: Tue Jul 13, 2010 2:53 pm

Re: [svn2060] occasional freezes on startup

#3 Post by yufra »

Added, I will let you know if it clears up.
<DarkGod> lets say it's intended

yufra
Perspiring Physicist
Posts: 1332
Joined: Tue Jul 13, 2010 2:53 pm

Re: [svn2060] occasional freezes on startup

#4 Post by yufra »

Nope, got it again. :?
<DarkGod> lets say it's intended

yufra
Perspiring Physicist
Posts: 1332
Joined: Tue Jul 13, 2010 2:53 pm

Re: [svn2060] occasional freezes on startup

#5 Post by yufra »

I used Neil's 15b and a self-compiled SVN 1992 (had to add serial.c and serial.h to the Xcode project), restarted several times and no problems. I then used a self-compiled SVN 2077 (had to add the serial and src/fov files) and right out of the gate:

Code: Select all

[COROUTINE] registering	getnews	thread: 0x193745c0
[ENGINE] Setting requested FPS to 30 (33 ms)
[ENGINE] Setting requested FPS to 30 (33 ms)
[ONLINE PROFILE] get news
[THREAD] registering	table: 0x6bb780	userdata: 0x684cb4	1
1 ticks  in 13.69 seconds = 0.073046 TPS
[ONLINE PROFILE] async rpc called	http://te4.org/lua/profilesrpc.ws/GetNews
Latest engine version available: 	te4	0	9	13
[COROUTINE] dead	getnews
77 ticks  in 10.009 seconds = 7.69308 TPS
If I hit some keys (enter, etc) I can coax some more stdout but nothing show up on the screen. I had to restart 3 more times for it to finally work. Any ideas?
<DarkGod> lets say it's intended

yufra
Perspiring Physicist
Posts: 1332
Joined: Tue Jul 13, 2010 2:53 pm

Re: [svn2060] occasional freezes on startup

#6 Post by yufra »

Here is the latest SVN 2090 stdout from a crash:
[MUSIC] playing The saga begins.ogg userdata: 0x1755cc14 :: current ? nil
play music 175efce0 -1 0
[COROUTINE] registering getnews thread: 0x175faad0
[ENGINE] Setting requested FPS to 30 (33 ms)
[ENGINE] Setting requested FPS to 30 (33 ms)
[ONLINE PROFILE] get news
[THREAD] registering table: 0x696600 userdata: 0x62b5a4 1
1 ticks in 13.192 seconds = 0.0758035 TPS
[ONLINE PROFILE] async rpc called http://te4.org/lua/profilesrpc.ws/GetNews
Latest engine version available: te4 0 9 13
[COROUTINE] dead getnews
77 ticks in 10.01 seconds = 7.69231 TPS
77 ticks in 10.01 seconds = 7.69231 TPS
... and from a successful launch:
[MUSIC] playing The saga begins.ogg userdata: 0x18507464 :: current ? nil
play music 4e2f00 -1 0
[COROUTINE] registering getnews thread: 0x1850d640
[ENGINE] Setting requested FPS to 30 (33 ms)
[ENGINE] Setting requested FPS to 30 (33 ms)
1 frames in 1.12 seconds = 0.892857 FPS (237 keyframes)
Loading tile border_7.png
Threw error #201 (XML parsing failure) in CreatePropertiesFromXMPData()
Loading tile border_9.png
Loading tile border_1.png
Loading tile border_3.png
Loading tile border_8.png
Loading tile border_4.png
[ONLINE PROFILE] get news
[THREAD] registering table: 0x17580370 userdata: 0x17578144 1
[ONLINE PROFILE] async rpc called http://te4.org/lua/profilesrpc.ws/GetNews
24 frames in 1 seconds = 24 FPS (807 keyframes)
Latest engine version available: te4 0 9 13
[COROUTINE] dead getnews
9 ticks in 10.119 seconds = 0.889416 TPS
24 frames in 1 seconds = 24 FPS (30 keyframes)
25 frames in 1 seconds = 25 FPS (32 keyframes)
<DarkGod> lets say it's intended

Post Reply