[mythtv-users] mythlogserver multiple copies high cpu

Sun Mar 10 08:41:14 UTC 2013

Hi,

I'm also seeing issues with mythlogserver running multiple copies, one 
of which will end up using 100% cpu.  This is on a remote frontend only 
machine that I use suspend to ram on (which I think is possibly key in 
my case).  It would seem that the mythlogserver process is getting 
confused by suspend to ram and resume because I think my extra processes 
are appearing when I wake the machine from a sleep.

Last night I was watching a movie, and only had a single mythfrontend 
end mythlogserver process (I know because 100% cpu causes the fans to 
spin up which I can hear - which is how I originally noticed this problem!).

This morning, I've just woken up the frontend and lo and behold two 
mythlogserver processes.  I've just done another couple of tests and 
each time I suspend and resume I get another instance of mythlogserver 
running.

 From the logs below it looks like mythfrontend starts a new 
mythlogserver first thing this morning, even though the one that was 
running last night should still be there - I suspended the frontend at 
about 10:30pm last night and woke it from sleep about 8:20am this morning.

Does this sound like it could be a reasonable explaination?  If so I 
might just add something to my suspend script to kill off mythlogserver, 
but it would be nice to not have to :-)

Rob.

MythTV Version : v0.26.0
MythTV Branch : fixes/0.26
Network Protocol : 75
Library API : 0.26.20130112-1
QT Version : 4.8.4
Options compiled in:
  linux profile use_hidesyms using_alsa using_oss using_backend 
using_bindings_php using_dvb using_frontend using_hdhomerun using_ceton 
using_hdpvr using_iptv using_ivtv using_libcrypto using_libdns_sd 
using_libxml2 using_libudf using_lirc using_mheg using_opengl_video 
using_qtwebkit using_qtscript using_qtdbus using_v4l2 using_x11 
using_xrandr using_xv using_bindings_php using_mythtranscode 
using_opengl using_vdpau using_ffmpeg_threads using_live using_mheg 
using_libxml2 using_libudf

----------------
mythfrontend.log
----------------
2013-03-09 22:21:59.342368 I [13994/13994] CoreContext tv_play.cpp:405 
(StartTV) - TV: Exiting main playback loop.
2013-03-09 22:21:59.391309 N [13994/13994] CoreContext 
mythmainwindow.cpp:2606 (PauseIdleTimer) - Resuming idle timer
2013-03-09 22:22:04.766798 I [13994/14059] PreviewGeneratorQueue 
mythdbcon.cpp:409 (PurgeIdleConnections) - New DB connection, total: 3

2013-03-10 08:20:34.049329 I [13994/14004] Logger logging.cpp:487 
(launchLogServer) - Starting mythlogserver

-----------------
mythlogserver.log
-----------------
2013-03-09 20:21:33.703073 N [18551/18551] CoreContext 
mythcontext.cpp:493 (LoadDatabaseSettings) - Empty LocalHostName.
2013-03-09 20:21:33.703110 I [18551/18551] CoreContext 
mythcontext.cpp:501 (LoadDatabaseSettings) - Using localhost value of 
mythfe2
2013-03-09 20:21:33.703197 I [18551/18551] CoreContext 
mythcontext.cpp:682 (TestDBconnection) - Testing network connectivity to 
'192.168.0.104'
2013-03-09 20:21:33.710364 I [18551/18568] SystemSignalManager 
system-unix.cpp:490 (run) - Starting process signal handler
2013-03-09 20:21:33.710765 I [18551/18570] SystemIOHandlerW 
system-unix.cpp:90 (run) - Starting IO manager (write)
2013-03-09 20:21:33.710954 I [18551/18567] SystemManager 
system-unix.cpp:263 (run) - Starting process manager
2013-03-09 20:21:33.711125 I [18551/18569] SystemIOHandlerR 
system-unix.cpp:90 (run) - Starting IO manager (read)
2013-03-09 20:21:33.790124 I [18551/18552] Logger logging.cpp:364 (run) 
- Added logging to mythlogserver locally
2013-03-09 20:21:33.805327 I [18551/18559] LogForward 
loggingserver.cpp:1310 (forwardMessage) - New Client: 
0005317ab4ade24365a27f2e8981f4e303 (#1)
2013-03-09 20:21:33.805402 I [18551/18559] LogForward 
loggingserver.cpp:138 (FileLogger) - Added logging to 
/var/log/mythtv/mythfrontend.20130308174121.13994.log
2013-03-09 20:21:33.810180 I [18551/18559] LogForward 
loggingserver.cpp:1310 (forwardMessage) - New Client: 
00559d49b7d014459e90d9eadc9652825c (#2)
2013-03-09 20:21:33.810195 I [18551/18559] LogForward 
loggingserver.cpp:1315 (forwardMessage) - Aborting shutdown timer
2013-03-09 20:21:33.811731 I [18551/18559] LogForward 
loggingserver.cpp:138 (FileLogger) - Added logging to 
/var/log/mythtv/mythlogserver.20130309202133.18551.log
2013-03-09 20:21:33.902373 N [18551/18551] CoreContext 
mythcorecontext.cpp:1283 (InitLocale) - Setting QT default locale to en_US
2013-03-09 20:21:33.902415 I [18551/18551] CoreContext 
mythcorecontext.cpp:1316 (SaveLocaleDefaults) - Current locale en_US
2013-03-09 20:21:33.902540 N [18551/18551] CoreContext 
mythlocale.cpp:121 (LoadDefaultsFromXML) - Reading locale defaults from 
/usr/share/mythtv//locales/en_us.xml

2013-03-10 08:20:25.235845 I [18551/18559] LogForward 
loggingserver.cpp:1204 (expireClients) - Expiring client 
0005317ab4ade24365a27f2e8981f4e303 (#1)
2013-03-10 08:20:25.235867 I [18551/18559] LogForward 
loggingserver.cpp:148 (~FileLogger) - Removed logging to 
/var/log/mythtv/mythfrontend.20130308174121.13994.log
2013-03-10 08:20:25.236049 I [18551/18559] LogForward 
loggingserver.cpp:1204 (expireClients) - Expiring client 
00559d49b7d014459e90d9eadc9652825c (#0)
2013-03-10 08:20:25.236062 I [18551/18559] LogForward 
loggingserver.cpp:148 (~FileLogger) - Removed logging to 
/var/log/mythtv/mythlogserver.20130309202133.18551.log
2013-03-10 08:20:25.336742 I [18551/18559] LogForward 
loggingserver.cpp:1310 (forwardMessage) - New Client: 
00559d49b7d014459e90d9eadc9652825c (#1)
2013-03-10 08:20:25.336795 I [18551/18559] LogForward 
loggingserver.cpp:138 (FileLogger) - Added logging to 
/var/log/mythtv/mythlogserver.20130309202133.18551.log
2013-03-10 08:20:25.337050 I [18551/18559] LogForward 
loggingserver.cpp:1234 (expireClients) - Starting 5min shutdown timer
2013-03-10 08:20:34.741908 I [18551/18559] LogForward 
loggingserver.cpp:1310 (forwardMessage) - New Client: 
0005317ab4ade24365a27f2e8981f4e303 (#2)
2013-03-10 08:20:34.741923 I [18551/18559] LogForward 
loggingserver.cpp:1315 (forwardMessage) - Aborting shutdown timer
2013-03-10 08:20:34.742243 I [18551/18559] LogForward 
loggingserver.cpp:138 (FileLogger) - Added logging to 
/var/log/mythtv/mythfrontend.20130308174121.13994.log