DCERouter dying

[digitaldan]

Hi,

I posted this last night in a different conversation, but i wanted this problem to have its own topic.  After a clean wipe of the system and a fresh install (actually many fresh installs, always reformating the partitions) the DCERouter dies as soon as it starts up. The script that spawns this process tries up to 200 times and then stop all together.  I have a GDB trace of the seg-fault, it seems to be choking trying to read the DBName var from some where (pluto.conf?), very strange.  I'm hoping someone can help me out here since I think this is effecting many people who are having the "black" screen problems.  My hardware is very standard and I did install linuxmce last week without this issue, so it may be a updated package that is causing the problem.  The database is working correctly, i can connect to it as root and query pluto_main, my pluto.conf also looks fine.... I will post that below if it helps.

Anyways, here is the GDB bt.

root@dcerouter:/usr/pluto/bin# gdb ./DCERouter
GNU gdb 6.4.90-debian
Copyright (C) 2006 Free Software Foundation, Inc.
GDB is free software, covered by the GNU General Public License, and you are
welcome to change it and/or distribute copies of it under certain conditions.
Type "show copying" to see the conditions.
There is absolutely no warranty for GDB.  Type "show warranty" for details.
This GDB was configured as "i486-linux-gnu"...Using host libthread_db library "/lib/tls/i686/cmov/libthread_db.so.1".

(gdb) run -h localhost
Starting program: /usr/pluto/bin/DCERouter -h localhost
[Thread debugging using libthread_db enabled]
[New Thread -1226340688 (LWP 20843)]
Copyright (C) 2004 Pluto, Inc., a Florida Corporation
www.plutohome.com
Phone: +1 (877) 758-8648
This program is distributed according to the terms of the Pluto Public License, available at:
http://plutohome.com/index.php?section=public_license
This program is distributed in the hope that it will be useful, but WITHOUT ANY WARRANTY;
without even the implied warranty of MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE.
See the Pluto Public License for more details.
---------------

[New Thread -1226441824 (LWP 20868)]
21      04/11/07 22:31:01.800           lock(0x80dee80) (>2) messagequeue: DCERouter.cpp:1782  <0xb6e5fba0>
21      04/11/07 22:31:01.801           acquired(0x80dee80) #0 (>2) messagequeue DCERouter.cpp:1782  <0xb6e5fba0>
10      04/11/07 22:31:01.801           ProcessQueue going to sleep <0xb6e5fba0>
21      04/11/07 22:31:01.801           start cond wait DCERouter.cpp:1782 (0x80dee80)  <0xb6e5fba0>
10      04/11/07 22:31:01.800           Running as device: 2 installation: 12610 using path: /usr/pluto/ <0xb6e786b0>
10      04/11/07 22:31:01.812           AlarmManager::AlarmManager 0x80e4730 <0xb6e786b0>
21      04/11/07 22:31:01.812           lock(0x80e4774) (>3) alarm: AlarmManager.cpp:87  <0xb6e786b0>
21      04/11/07 22:31:01.813           acquired(0x80e4774) #0 (>3) alarm AlarmManager.cpp:87  <0xb6e786b0>
21      04/11/07 22:31:01.813           unlock(0x80e4774) #0 (>3) alarm: AlarmManager.cpp:87  <0xb6e786b0>
21      04/11/07 22:31:01.813           removed from map (0x80e4774) #0 (>3) alarm: AlarmManager.cpp:87  was: 2 size, now 1 Rel: Y Got: Y <0xb6e786b0>
[New Thread -1234834528 (LWP 20870)]
21      04/11/07 22:31:01.814           lock(0x80e4774) (>4) alarm: AlarmManager.cpp:102  <0xb665eba0>
21      04/11/07 22:31:01.814           acquired(0x80e4774) #0 (>4) alarm AlarmManager.cpp:102  <0xb665eba0>
21      04/11/07 22:31:01.814           start cond wait AlarmManager.cpp:102 (0x80e4774)  <0xb665eba0>
[New Thread -1243227232 (LWP 20871)]
21      04/11/07 22:31:01.815           lock(0x80e4774) (>5) alarm: AlarmManager.cpp:102  <0xb5e5dba0>
21      04/11/07 22:31:01.815           acquired(0x80e4774) #0 (>5) alarm AlarmManager.cpp:102  <0xb5e5dba0>
21      04/11/07 22:31:01.815           start cond wait AlarmManager.cpp:102 (0x80e4774)  <0xb5e5dba0>
[New Thread -1251619936 (LWP 20872)]
21      04/11/07 22:31:01.816           lock(0x80e4774) (>6) alarm: AlarmManager.cpp:102  <0xb565cba0>
21      04/11/07 22:31:01.816           acquired(0x80e4774) #0 (>6) alarm AlarmManager.cpp:102  <0xb565cba0>
21      04/11/07 22:31:01.817           start cond wait AlarmManager.cpp:102 (0x80e4774)  <0xb565cba0>
[New Thread -1260012640 (LWP 20873)]
10      04/11/07 22:31:01.818           Executed query UPDATE Device SET Registered=0,psc_mod=psc_mod (0 rows) <0xb6e786b0>
21      04/11/07 22:31:01.818           lock(0x80e4774) (>Cool alarm: AlarmManager.cpp:102  <0xb4e5bba0>
21      04/11/07 22:31:01.818           acquired(0x80e4774) #0 (>Cool alarm AlarmManager.cpp:102  <0xb4e5bba0>
21      04/11/07 22:31:01.818           start cond wait AlarmManager.cpp:102 (0x80e4774)  <0xb4e5bba0>
10      04/11/07 22:31:01.961           Created the server device: 1 CORE <0xb6e786b0>
10      04/11/07 22:31:01.961           Created device 2 DCERouter (mdl: 1) routed to: 2 (1 CORE) <0xb6e786b0>
10      04/11/07 22:31:01.961           Created DCE device 3 File Grids Plug-in (mdl: 10) routed to: 3 (1 CORE) <0xb6e786b0>
10      04/11/07 22:31:01.961           Created DCE device 4 General Info Plug-in (mdl: 27) routed to: 4 (1 CORE) <0xb6e786b0>
10      04/11/07 22:31:01.961           Created DCE device 5 Climate Plug-in (mdl: 31) routed to: 5 (1 CORE) <0xb6e786b0>
10      04/11/07 22:31:01.961           Created DCE device 6 Datagrid Plug-in (mdl: 9) routed to: 6 (1 CORE) <0xb6e786b0>
10      04/11/07 22:31:01.962           Created DCE device 7 Infrared Plug-in (mdl: 39) routed to: 7 (1 CORE) <0xb6e786b0>
10      04/11/07 22:31:01.962           Created DCE device 8 Lighting Plug-in (mdl: 32) routed to: 8 (1 CORE) <0xb6e786b0>
10      04/11/07 22:31:01.962           Created DCE device 9 Orbiter Plug-in (mdl: 12) routed to: 9 (1 CORE) <0xb6e786b0>
10      04/11/07 22:31:01.962           Created DCE device 10 Media Plug-in (mdl: 2) routed to: 10 (1 CORE) <0xb6e786b0>
10      04/11/07 22:31:01.962           Created DCE device 11 Telecom Plug-in (mdl: 34) routed to: 11 (1 CORE) <0xb6e786b0>
10      04/11/07 22:31:01.962           Created DCE device 12 Event Plug-in (mdl: 52) routed to: 12 (1 CORE) <0xb6e786b0>
10      04/11/07 22:31:01.962           Created DCE device 13 Security Plug-in (mdl: 33) routed to: 13 (1 CORE) <0xb6e786b0>
10      04/11/07 22:31:01.962           Created DCE device 14 Plug And Play Plug-in (mdl: 1809) routed to: 14 (1 CORE) <0xb6e786b0>
10      04/11/07 22:31:01.962           Created DCE device 23 Xine Plug-in (mdl: 6) routed to: 23 (1 CORE) <0xb6e786b0>
10      04/11/07 22:31:01.962           Created DCE device 25 MythTV Plug-In (mdl: 36) routed to: 25 (1 CORE) <0xb6e786b0>
10      04/11/07 22:31:01.962           Created DCE device 15 App Server (mdl: 26) routed to: 15 (1 CORE) <0xb6e786b0>
10      04/11/07 22:31:01.962           Created DCE device 16 Asterisk (mdl: 45) routed to: 16 (1 CORE) <0xb6e786b0>
10      04/11/07 22:31:01.962           Created DCE device 17 Text To Speech (mdl: 57) routed to: 17 (1 CORE) <0xb6e786b0>
10      04/11/07 22:31:01.962           Created the server device: 18 Generic PC as MD <0xb6e786b0>
10      04/11/07 22:31:01.962           Created DCE device 19 OnScreen Orbiter (mdl: 62) routed to: 19 (1 CORE) <0xb6e786b0>
10      04/11/07 22:31:01.962           Created DCE device 20 Orbiter Embedded Phone (mdl: 1759) routed to: 20 (1 CORE) <0xb6e786b0>
10      04/11/07 22:31:01.962           Created DCE device 22 Xine Player (mdl: 5) routed to: 22 (1 CORE) <0xb6e786b0>
10      04/11/07 22:31:01.962           Created DCE device 24 MythTV Player (mdl: 35) routed to: 24 (1 CORE) <0xb6e786b0>
10      04/11/07 22:31:01.962           Created DCE device 26 Disk Drive (mdl: 11) routed to: 26 (1 CORE) <0xb6e786b0>
10      04/11/07 22:31:01.962           Created DCE device 27 Photo Screen Saver (mdl: 1825) routed to: 27 (1 CORE) <0xb6e786b0>
10      04/11/07 22:31:01.962           Created DCE device 21 HAL (mdl: 1808) routed to: 21 (1 CORE) <0xb6e786b0>
10      04/11/07 22:31:01.963           Created device 28 GeForce or TNT2 (mdl: 1736) routed to: 28 (1 CORE) <0xb6e786b0>
[New Thread -1268405344 (LWP 20910)]
13      04/11/07 22:31:01.976           TCPIP: Listening on 3450. <0xb465aba0>
13      04/11/07 22:31:01.978           TCPIP: Accepting incoming connection on socket 9, port 3450, from IP 127.0.0.1. <0xb465aba0>
21      04/11/07 22:31:01.978           lock(0x80decb8) (>9) listener Router Dev #0: SocketListener.cpp:234  <0xb465aba0>
21      04/11/07 22:31:01.978           acquired(0x80decb8) #0 (>9) listener Router Dev #0 SocketListener.cpp:234  <0xb465aba0>
10      04/11/07 22:31:01.978           ServerSocket::Created 0x8102358 m_Socket: 9 <0xb465aba0>
[New Thread -1276798048 (LWP 20912)]
10      04/11/07 22:31:01.980           Thread created for Incoming_Conn Socket 9 127.0.0.1 dev -1 ptr 0x8102358 <0xb465aba0>
21      04/11/07 22:31:01.980           unlock(0x80decb8) #0 (>9) listener Router Dev #0: SocketListener.cpp:234  <0xb465aba0>
21      04/11/07 22:31:01.980           removed from map (0x80decb8) #0 (>9) listener Router Dev #0: SocketListener.cpp:234  was: 6 size, now 5 Rel: Y Got: Y <0xb465aba0>
10      04/11/07 22:31:01.980           Running socket 0x8102358... m_bTerminate: 0 <0xb3e59ba0>
10      04/11/07 22:31:02.480           Waiting for listener thread <0xb6e786b0>
10      04/11/07 22:31:02.481           DCERouter Version: 1.0 <0xb6e786b0>
05      04/11/07 22:31:02.818           Loaded plug-in device: 3 master device: 10 -- ./File_Grids_Plugin.so <0xb6e786b0>
05      04/11/07 22:31:03.064           Loaded plug-in device: 4 master device: 27 -- ./General_Info_Plugin.so <0xb6e786b0>
05      04/11/07 22:31:03.123           Loaded plug-in device: 5 master device: 31 -- ./Climate_Plugin.so <0xb6e786b0>
05      04/11/07 22:31:03.175           Loaded plug-in device: 6 master device: 9 -- ./Datagrid_Plugin.so <0xb6e786b0>
05      04/11/07 22:31:03.254           Loaded plug-in device: 7 master device: 39 -- ./Infrared_Plugin.so <0xb6e786b0>
05      04/11/07 22:31:03.326           Loaded plug-in device: 8 master device: 32 -- ./Lighting_Plugin.so <0xb6e786b0>
05      04/11/07 22:31:03.603           Loaded plug-in device: 9 master device: 12 -- ./Orbiter_Plugin.so <0xb6e786b0>
05      04/11/07 22:31:04.058           Loaded plug-in device: 10 master device: 2 -- ./Media_Plugin.so <0xb6e786b0>
05      04/11/07 22:31:04.276           Loaded plug-in device: 11 master device: 34 -- ./Telecom_Plugin.so <0xb6e786b0>
05      04/11/07 22:31:04.362           Loaded plug-in device: 12 master device: 52 -- ./Event_Plugin.so <0xb6e786b0>
05      04/11/07 22:31:04.458           Loaded plug-in device: 13 master device: 33 -- ./Security_Plugin.so <0xb6e786b0>
05      04/11/07 22:31:04.571           Loaded plug-in device: 14 master device: 1809 -- ./Plug_And_Play_Plugin.so <0xb6e786b0>
05      04/11/07 22:31:04.664           Loaded plug-in device: 23 master device: 6 -- ./Xine_Plugin.so <0xb6e786b0>
05      04/11/07 22:31:04.789           Loaded plug-in device: 25 master device: 36 -- ./MythTV_PlugIn.so <0xb6e786b0>
10      04/11/07 22:31:04.796           Activating 14 plug-ins <0xb6e786b0>
10      04/11/07 22:31:04.796           Device: 3 loaded as plug-in <0xb6e786b0>
[New Thread -1296467040 (LWP 20913)]
21      04/11/07 22:31:04.801           lock(0x82e0278) (>44) MessageQueue: Command_Impl.cpp:769  <0xb2b97ba0>
21      04/11/07 22:31:04.801           acquired(0x82e0278) #0 (>44) MessageQueue Command_Impl.cpp:769  <0xb2b97ba0>
21      04/11/07 22:31:04.801           start cond wait Command_Impl.cpp:769 (0x82e0278)  <0xb2b97ba0>
13      04/11/07 22:31:04.801           TCPIP: Accepting incoming connection on socket 11, port 3450, from IP 127.0.0.1. <0xb465aba0>
21      04/11/07 22:31:04.801           lock(0x80decb8) (>45) listener Router Dev #0: SocketListener.cpp:234  <0xb465aba0>
21      04/11/07 22:31:04.801           acquired(0x80decb8) #0 (>45) listener Router Dev #0 SocketListener.cpp:234  <0xb465aba0>
10      04/11/07 22:31:04.801           ServerSocket::Created 0x81663a0 m_Socket: 11 <0xb465aba0>
[New Thread -1304859744 (LWP 20914)]
10      04/11/07 22:31:04.803           Thread created for Incoming_Conn Socket 11 127.0.0.1 dev -1 ptr 0x81663a0 <0xb465aba0>
21      04/11/07 22:31:04.803           unlock(0x80decb8) #0 (>45) listener Router Dev #0: SocketListener.cpp:234  <0xb465aba0>
21      04/11/07 22:31:04.804           removed from map (0x80decb8) #0 (>45) listener Router Dev #0: SocketListener.cpp:234  was: 9 size, now 8 Rel: Y Got: Y <0xb465aba0>
10      04/11/07 22:31:04.804           Running socket 0x81663a0... m_bTerminate: 0 <0xb2396ba0>
21      04/11/07 22:31:04.804           lock(0x80dee08) (>71) core: DCERouter.cpp:1449  <0xb2396ba0>
21      04/11/07 22:31:04.804           acquired(0x80dee08) #0 (>71) core DCERouter.cpp:1449  <0xb2396ba0>
21      04/11/07 22:31:04.804           unlock(0x80dee08) #0 (>71) core: DCERouter.cpp:1449  <0xb2396ba0>
21      04/11/07 22:31:04.804           removed from map (0x80dee08) #0 (>71) core: DCERouter.cpp:1449  was: 9 size, now 8 Rel: Y Got: Y <0xb2396ba0>
10      04/11/07 22:31:04.804           Setting timeout for socket 10 to 30 <0xb6e786b0>

Program received signal SIGSEGV, Segmentation fault.
[Switching to Thread -1226340688 (LWP 20843)]
0xb70cb1bf in std::basic_string<char, std::char_traits<char>, std::allocator<char> >::basic_string () from /usr/lib/libstdc++.so.6
(gdb) bt
#0  0xb70cb1bf in std::basic_string<char, std::char_traits<char>, std::allocator<char> >::basic_string () from /usr/lib/libstdc++.so.6
#1  0xb3645c02 in DCE::Router::sDBName_get (this=0x82e0150) at ../DCE/DCERouter.h:244
#2  0xb36416ca in DCE::File_Grids_Plugin::GetConfig (this=0x82e0150) at File_Grids_Plugin.cpp:72
#3  0xb363afc6 in RegisterAsPlugIn (pRouter=0x80dec90, PK_Device=3, pPlutoLogger=0x80e1ec8) at Main.cpp:98
#4  0x0808bfec in DCE::Router::PlugIn_Activate (this=0x80dec90, PK_Device=3, RegisterAsPlugin=0xb363ae82 <RegisterAsPlugIn>, sLogFile=@0xbf8d3108) at DCERouter.cpp:613
#5  0x0808d6b1 in DCE::Router::RegisterAllPlugins (this=0x80dec90) at DCERouter.cpp:512
#6  0x0808dc37 in DCE::Router::Run (this=0x80dec90) at DCERouter.cpp:1589
#7  0x080774b9 in main (argc=3, argv=0xbf8d3304) at Main.cpp:184
(gdb)



pluto.conf
# Pluto config file
MySqlHost = localhost
MySqlUser = root
MySqlPassword =
MySqlDBName = pluto_main
DCERouter = localhost
MySqlPort = 3306
DCERouterPort = 3450
PK_Device = 1
Activation_Code = 1111
PK_Installation = 12610
PK_Users = 1
PK_Distro = 14
Display = 4
OfflineMode = false

PlutoVersion = 1.0
Bookmark_Media = 4,5
RA_CheckRemotePort = 1
TimeZoneSet = 1
FirstBoot = false
AVWizardDone = 1

[corwin]

Did the install complete with no errors?

[digitaldan]

it did, as far as i can tell.  It as least gave my the GUI dialog sayng it was successfull, is there a install log some where I can double check?

D-

[cckrobinson]

Something similar is happening to me as well.  My system had been running fine for several days without a reboot.  When I turned on the TV today I got a message that LMCE had installed updates and it needed to be restarted.  When I rebooted I initially got the transparency manager error.  I had been running UI2 with alpha-blending.  I tried switching over to UI1 and now all that I get is a black screen with a white cursor.  The pluto.log \ and DCERouter.log indicate the server is continually crashing :


========== NEW LOG SECTION ==========
1       04/14/07 18:24:46       DCERouter (server)      Starting... 69
Sat Apr 14 18:24:46 CDT 2007 Starting
05      04/14/07 18:24:46.972           Router::RemoveAndDeleteSocket 0x85d7770 17 <0x8033aba0>
05      04/14/07 18:24:46.973           Socket::ReceiveData 0x85d9d20 failed, bytes left 0 start: 2560000 1: 0 1b: 0 2: 0 2b: 0 m_Socket: 111 Incoming_Conn Socket 111 127.0.0.1EVENT 17 T=57 Event #17 <0x89b4dba0>
05      04/14/07 18:24:46.974           Socket::ReceiveString2 ReceiveData failed m_Socket: -1 Incoming_Conn Socket 111 127.0.0.1EVENT 17 T=57 Event #17 <0x89b4dba0>
05      04/14/07 18:24:46.974           TCPIP: Closing connection to 17 (Router Dev #0) 0x85d9d20 m_Socket: -1 <0x89b4dba0>
05      04/14/07 18:24:46.974           Router::RemoveAndDeleteSocket 0x85d9d20 17 <0x89b4dba0>
05      04/14/07 18:24:46.974           Socket::ReceiveData 0x85e0c78 failed, bytes left 0 start: 2560000 1: 0 1b: 0 2: 0 2b: 0 m_Socket: 117 Incoming_Conn Socket 117 127.0.0.1EVENT 17 T=57 Event #17 <0x7eb37ba0>
05      04/14/07 18:24:46.974           Socket::ReceiveString2 ReceiveData failed m_Socket: -1 Incoming_Conn Socket 117 127.0.0.1EVENT 17 T=57 Event #17 <0x7eb37ba0>
05      04/14/07 18:24:46.974           TCPIP: Closing connection to 17 (Router Dev #0) 0x85e0c78 m_Socket: -1 <0x7eb37ba0>
05      04/14/07 18:24:46.974           Router::RemoveAndDeleteSocket 0x85e0c78 17 <0x7eb37ba0>
05      04/14/07 18:24:47.859           Router::RemoveAndDeleteSocket 0x85e0fc8 15 <0x7eb37ba0>
05      04/14/07 18:24:47.861           Socket::ReceiveData 0x85b6620 failed, bytes left 0 start: 2570000 1: 0 1b: 0 2: 0 2b: 0 m_Socket: 129 Incoming_Conn Socket 129 127.0.0.1EVENT 15 T=26 Event #15 <0x7fb39ba0>
05      04/14/07 18:24:47.861           Socket::ReceiveString2 ReceiveData failed m_Socket: -1 Incoming_Conn Socket 129 127.0.0.1EVENT 15 T=26 Event #15 <0x7fb39ba0>
05      04/14/07 18:24:47.861           TCPIP: Closing connection to 15 (Router Dev #0) 0x85b6620 m_Socket: -1 <0x7fb39ba0>
05      04/14/07 18:24:47.861           Router::RemoveAndDeleteSocket 0x85b6620 15 <0x7fb39ba0>
05      04/14/07 18:24:47.862           Socket::ReceiveData 0x85dfdc0 failed, bytes left 0 start: 2540000 1: 0 1b: 0 2: 0 2b: 0 m_Socket: 132 Incoming_Conn Socket 132 127.0.0.1EVENT 15 T=26 Event #15 <0x88b4bba0>
05      04/14/07 18:24:47.862           Socket::ReceiveString2 ReceiveData failed m_Socket: -1 Incoming_Conn Socket 132 127.0.0.1EVENT 15 T=26 Event #15 <0x88b4bba0>
05      04/14/07 18:24:47.862           TCPIP: Closing connection to 15 (Router Dev #0) 0x85dfdc0 m_Socket: -1 <0x88b4bba0>
05      04/14/07 18:24:47.862           Router::RemoveAndDeleteSocket 0x85dfdc0 15 <0x88b4bba0>
 <0xb4724ba0>/07 18:24:48.444           Failed to bind to port.

I'm stuck.

[cckrobinson]

I was able to get past my issue.  It turns out that I had 2 different problems.

1. At some point I unchecked asterisk and text to speech under Devices->Core.  I must have done that several days ago, but it didn't mess things up until I rebooted.  There's a bug that requires these boxes to be checked.
2. This allowed me to run UI1, but I still couldn't do UI2 alpha-blending without getting the transparency manager error.  Reinstalling the nvidia drivers fixed it.

I'm really confused as to why I needed to re-install the drivers.

[digitaldan]

I have kinda come to my whits end here.  Could one of the linuxmce guys help me out?  I can not figure out why the DCERouter dies, I must have done 10 clean installs hoping to have missed something.  Whats wierd is that I had downloaded this and successfully had it running the second day after the initial anouncement with little issue.  I wish I had just kept going with that install rather then wanting a fresh instance.  Now the DCERouter just dies the minute the box boots up.

By the way I understand what a HUGE task it was to make this installable as packages on ubuntu, I have been folowing the pluto project for over a year and was always amazed by the amount of code neaded to glue all the different pieces together and how sensitive it was to a specific release of Debian.  Thanks for the great work.

D-

[Hugolp]

My DCERouter dies at starup as well and I get the black screen. Clean installation as well.

I tried cckrobinson solution but no luck. Didnt solve it for me.

Hugo

[sharlee_angelo]

can you post DCERouter.log?

[Hugolp]

I have been checking this with the guys that help through the yahoo messenger and no luck. I think I am going to wait for the feisty version as fesity solves a couple of other problems I had.

Hugo

[Provide]

1. At some point I unchecked asterisk and text to speech under Devices->Core.  I must have done that several days ago, but it didn't mess things up until I rebooted.  There's a bug that requires these boxes to be checked.

FWIW, I am seriously starting to believe this is what broke my previous two installs of MCE.

Oh well, off to do another fresh install....

[sharlee_angelo]

before reinstall, can you post DCERouter.log?