Re: [Freevo-users] Traceback on shutdown with rel-1
John Molohan wrote: Duncan Webb wrote: John Molohan wrote: Duncan Webb wrote: John Molohan wrote: 2007-11-08 21:24:28,198 DEBUGautoshutdown.py (773): Executing syscall: ps -eo cmd | egrep -v grep | egrep (/|[[:space:]]|^)(urpm|urpmi|transcode|cdrecord|mplayer|xine|mencoder)($|[[:space:]]) 2007-11-08 21:24:28,241 DEBUGautoshutdown.py (756): no external process(es) running 2007-11-08 21:24:28,243 DEBUGautoshutdown.py (385): Shutdown issued by autoshutdown timer! 2007-11-08 21:24:28,244 DEBUGautoshutdown.py (492): shutdown wakeup 2007-11-08 21:24:31,801 DEBUGautoshutdown.py (454): No more recordings available 2007-11-08 21:24:31,802 DEBUGautoshutdown.py (732): Default wakeup at Fri Nov 9 13:00:00 2007 2007-11-08 21:24:31,803 DEBUGautoshutdown.py (478): Picked wakeup at Fri Nov 9 13:00:00 2007 2007-11-08 21:24:31,804 DEBUGautoshutdown.py (549): Wakeup-command /usr/local/bin/set_acpi.sh 2007-11-09 12:57 2007-11-08 21:24:31,805 DEBUGautoshutdown.py (773): Executing syscall: /usr/local/bin/set_acpi.sh 2007-11-09 12:57 2007-11-08 21:24:32,856 DEBUGautoshutdown.py (502): shutdown system 2007-11-08 21:24:33,895 ERRORremoved timer 1 Traceback (most recent call last): File /usr/lib/python2.5/site-packages/kaa/notifier/pynotifier/nf_generic.py, line 153, in step if not timer[ CALLBACK ](): File /usr/lib/python2.5/site-packages/kaa/notifier/timer.py, line 90, in __call__ return super(Timer, self).__call__(*args, **kwargs) File /usr/lib/python2.5/site-packages/kaa/notifier/nf_wrapper.py, line 96, in __call__ ret = super(NotifierCallback, self).__call__(*args, **kwargs) File /usr/lib/python2.5/site-packages/kaa/notifier/callback.py, line 168, in __call__ result = cb(*cb_args, **cb_kwargs) File /usr/lib/python2.5/site-packages/freevo/rc.py, line 624, in poll c[0](*c[4]) File /usr/lib/python2.5/site-packages/freevo/plugin.py, line 155, in poll_wrapper self.real_poll() File /usr/lib/python2.5/site-packages/freevo/plugins/autoshutdown.py, line 386, in poll shutdown_action(action=Shutdown.SHUTDOWN_WAKEUP) File /usr/lib/python2.5/site-packages/freevo/plugins/autoshutdown.py, line 503, in shutdown_action __cleanup_freevo() File /usr/lib/python2.5/site-packages/freevo/plugins/autoshutdown.py, line 619, in __cleanup_freevo plugin.shutdown() File /usr/lib/python2.5/site-packages/freevo/plugin.py, line 352, in shutdown p.shutdown() File /usr/lib/python2.5/site-packages/freevo/www/__init__.py, line 57, in shutdown print 'Stopping webserver plugin.' File /usr/lib/python2.5/site-packages/freevo/config.py, line 129, in write sys.__stdout__.flush() IOError: [Errno 5] Input/output error This is a bit strange, looks as if stdout is already closed. What happens when the webserver is not started as a plug-in but as a daemon. This could, but I suspect doesn't, have anything to do with the kaa.notifier changes. Duncan Hi Duncan, I haven't been able to reproduce that error yet but got a different one on shutdown tonight. Freevo had been started by freevo -fs from a ssh session and this was on the console: Unhandled exception in thread started by bound method Identify_Thread.__bootstrap of Identify_Thread(Thread-2, stopped daemon) Traceback (most recent call last): File /usr/lib/python2.5/threading.py, line 482, in __bootstrap (most likely raised during interpreter shutdown):) File /usr/lib/python2.5/site-packages/freevo/config.py, line 124, in write lock.acquire() AttributeError: 'NoneType' object has no attribute 'acquire' This is a strange error from config as lock is a global object that is set at the beginning, the idea is to ensure that debug messages don't overlap from the main thread and other threads. Just in case I've added a test for lock. Duncan Freevo shut down but the PC didn't power off as it should. As mentioned in the feature request I think this could be due to the audioscrobbler plugin, I had disabled it over the last few days and had no problem. I re-enabled it today. /var/log/freevo/main-0.log shows: 2007-11-14 21:04:08,500 DEBUGchildapp.py (171): sending SeekRelative+15 to pid 19250 2007-11-14 21:56:13,105 DEBUGchildapp.py (442): stderr: no data, closing log 2007-11-14 21:56:13,600 DEBUGxine.py (135): '' possible 2007-11-14 21:56:13,604 DEBUGmplayer.py (98): u'dvd://' possible 2007-11-14 21:56:13,605 DEBUGxine.py (123): u'dvd://' good 2007-11-14 22:31:32,914 DEBUGautoshutdown.py (673): Scheduled recording 0 at Thu Nov 15 03:45:00 2007 is Thu 2007-11-15 03:45-04:45 (03:45) south-east.bbc1.bbc.co.uk Sign Zone:Michael Palin's New Europe 2007-11-14 22:31:32,915 DEBUGautoshutdown.py (773): Executing
Re: [Freevo-users] Traceback on shutdown with rel-1
John Molohan wrote: Duncan Webb wrote: John Molohan wrote: 2007-11-08 21:24:28,198 DEBUGautoshutdown.py (773): Executing syscall: ps -eo cmd | egrep -v grep | egrep (/|[[:space:]]|^)(urpm|urpmi|transcode|cdrecord|mplayer|xine|mencoder)($|[[:space:]]) 2007-11-08 21:24:28,241 DEBUGautoshutdown.py (756): no external process(es) running 2007-11-08 21:24:28,243 DEBUGautoshutdown.py (385): Shutdown issued by autoshutdown timer! 2007-11-08 21:24:28,244 DEBUGautoshutdown.py (492): shutdown wakeup 2007-11-08 21:24:31,801 DEBUGautoshutdown.py (454): No more recordings available 2007-11-08 21:24:31,802 DEBUGautoshutdown.py (732): Default wakeup at Fri Nov 9 13:00:00 2007 2007-11-08 21:24:31,803 DEBUGautoshutdown.py (478): Picked wakeup at Fri Nov 9 13:00:00 2007 2007-11-08 21:24:31,804 DEBUGautoshutdown.py (549): Wakeup-command /usr/local/bin/set_acpi.sh 2007-11-09 12:57 2007-11-08 21:24:31,805 DEBUGautoshutdown.py (773): Executing syscall: /usr/local/bin/set_acpi.sh 2007-11-09 12:57 2007-11-08 21:24:32,856 DEBUGautoshutdown.py (502): shutdown system 2007-11-08 21:24:33,895 ERRORremoved timer 1 Traceback (most recent call last): File /usr/lib/python2.5/site-packages/kaa/notifier/pynotifier/nf_generic.py, line 153, in step if not timer[ CALLBACK ](): File /usr/lib/python2.5/site-packages/kaa/notifier/timer.py, line 90, in __call__ return super(Timer, self).__call__(*args, **kwargs) File /usr/lib/python2.5/site-packages/kaa/notifier/nf_wrapper.py, line 96, in __call__ ret = super(NotifierCallback, self).__call__(*args, **kwargs) File /usr/lib/python2.5/site-packages/kaa/notifier/callback.py, line 168, in __call__ result = cb(*cb_args, **cb_kwargs) File /usr/lib/python2.5/site-packages/freevo/rc.py, line 624, in poll c[0](*c[4]) File /usr/lib/python2.5/site-packages/freevo/plugin.py, line 155, in poll_wrapper self.real_poll() File /usr/lib/python2.5/site-packages/freevo/plugins/autoshutdown.py, line 386, in poll shutdown_action(action=Shutdown.SHUTDOWN_WAKEUP) File /usr/lib/python2.5/site-packages/freevo/plugins/autoshutdown.py, line 503, in shutdown_action __cleanup_freevo() File /usr/lib/python2.5/site-packages/freevo/plugins/autoshutdown.py, line 619, in __cleanup_freevo plugin.shutdown() File /usr/lib/python2.5/site-packages/freevo/plugin.py, line 352, in shutdown p.shutdown() File /usr/lib/python2.5/site-packages/freevo/www/__init__.py, line 57, in shutdown print 'Stopping webserver plugin.' File /usr/lib/python2.5/site-packages/freevo/config.py, line 129, in write sys.__stdout__.flush() IOError: [Errno 5] Input/output error This is a bit strange, looks as if stdout is already closed. What happens when the webserver is not started as a plug-in but as a daemon. This could, but I suspect doesn't, have anything to do with the kaa.notifier changes. Duncan I've been testing quite a bit recently so this could make sense as I was starting freevo from ssh sessions and from within screen sessions. Normally it would have been started as a daemon, I'll see if I can reproduce it. I don't think that screen would close the stdout, unless there is an option to do this in screen. Duncan - This SF.net email is sponsored by: Splunk Inc. Still grepping through log files to find problems? Stop. Now Search log events and configuration files using AJAX and a browser. Download your FREE copy of Splunk now http://get.splunk.com/ ___ Freevo-users mailing list Freevo-users@lists.sourceforge.net https://lists.sourceforge.net/lists/listinfo/freevo-users
Re: [Freevo-users] Traceback on shutdown with rel-1
John Molohan wrote: Duncan Webb wrote: John Molohan wrote: 2007-11-08 21:24:28,198 DEBUGautoshutdown.py (773): Executing syscall: ps -eo cmd | egrep -v grep | egrep (/|[[:space:]]|^)(urpm|urpmi|transcode|cdrecord|mplayer|xine|mencoder)($|[[:space:]]) 2007-11-08 21:24:28,241 DEBUGautoshutdown.py (756): no external process(es) running 2007-11-08 21:24:28,243 DEBUGautoshutdown.py (385): Shutdown issued by autoshutdown timer! 2007-11-08 21:24:28,244 DEBUGautoshutdown.py (492): shutdown wakeup 2007-11-08 21:24:31,801 DEBUGautoshutdown.py (454): No more recordings available 2007-11-08 21:24:31,802 DEBUGautoshutdown.py (732): Default wakeup at Fri Nov 9 13:00:00 2007 2007-11-08 21:24:31,803 DEBUGautoshutdown.py (478): Picked wakeup at Fri Nov 9 13:00:00 2007 2007-11-08 21:24:31,804 DEBUGautoshutdown.py (549): Wakeup-command /usr/local/bin/set_acpi.sh 2007-11-09 12:57 2007-11-08 21:24:31,805 DEBUGautoshutdown.py (773): Executing syscall: /usr/local/bin/set_acpi.sh 2007-11-09 12:57 2007-11-08 21:24:32,856 DEBUGautoshutdown.py (502): shutdown system 2007-11-08 21:24:33,895 ERRORremoved timer 1 Traceback (most recent call last): File /usr/lib/python2.5/site-packages/kaa/notifier/pynotifier/nf_generic.py, line 153, in step if not timer[ CALLBACK ](): File /usr/lib/python2.5/site-packages/kaa/notifier/timer.py, line 90, in __call__ return super(Timer, self).__call__(*args, **kwargs) File /usr/lib/python2.5/site-packages/kaa/notifier/nf_wrapper.py, line 96, in __call__ ret = super(NotifierCallback, self).__call__(*args, **kwargs) File /usr/lib/python2.5/site-packages/kaa/notifier/callback.py, line 168, in __call__ result = cb(*cb_args, **cb_kwargs) File /usr/lib/python2.5/site-packages/freevo/rc.py, line 624, in poll c[0](*c[4]) File /usr/lib/python2.5/site-packages/freevo/plugin.py, line 155, in poll_wrapper self.real_poll() File /usr/lib/python2.5/site-packages/freevo/plugins/autoshutdown.py, line 386, in poll shutdown_action(action=Shutdown.SHUTDOWN_WAKEUP) File /usr/lib/python2.5/site-packages/freevo/plugins/autoshutdown.py, line 503, in shutdown_action __cleanup_freevo() File /usr/lib/python2.5/site-packages/freevo/plugins/autoshutdown.py, line 619, in __cleanup_freevo plugin.shutdown() File /usr/lib/python2.5/site-packages/freevo/plugin.py, line 352, in shutdown p.shutdown() File /usr/lib/python2.5/site-packages/freevo/www/__init__.py, line 57, in shutdown print 'Stopping webserver plugin.' File /usr/lib/python2.5/site-packages/freevo/config.py, line 129, in write sys.__stdout__.flush() IOError: [Errno 5] Input/output error This is a bit strange, looks as if stdout is already closed. What happens when the webserver is not started as a plug-in but as a daemon. This could, but I suspect doesn't, have anything to do with the kaa.notifier changes. Duncan Hi Duncan, I haven't been able to reproduce that error yet but got a different one on shutdown tonight. Freevo had been started by freevo -fs from a ssh session and this was on the console: Unhandled exception in thread started by bound method Identify_Thread.__bootstrap of Identify_Thread(Thread-2, stopped daemon) Traceback (most recent call last): File /usr/lib/python2.5/threading.py, line 482, in __bootstrap (most likely raised during interpreter shutdown):) File /usr/lib/python2.5/site-packages/freevo/config.py, line 124, in write lock.acquire() AttributeError: 'NoneType' object has no attribute 'acquire' This is a strange error from config as lock is a global object that is set at the beginning, the idea is to ensure that debug messages don't overlap from the main thread and other threads. Just in case I've added a test for lock. Duncan Freevo shut down but the PC didn't power off as it should. As mentioned in the feature request I think this could be due to the audioscrobbler plugin, I had disabled it over the last few days and had no problem. I re-enabled it today. /var/log/freevo/main-0.log shows: 2007-11-14 21:04:08,500 DEBUGchildapp.py (171): sending SeekRelative+15 to pid 19250 2007-11-14 21:56:13,105 DEBUGchildapp.py (442): stderr: no data, closing log 2007-11-14 21:56:13,600 DEBUGxine.py (135): '' possible 2007-11-14 21:56:13,604 DEBUGmplayer.py (98): u'dvd://' possible 2007-11-14 21:56:13,605 DEBUGxine.py (123): u'dvd://' good 2007-11-14 22:31:32,914 DEBUGautoshutdown.py (673): Scheduled recording 0 at Thu Nov 15 03:45:00 2007 is Thu 2007-11-15 03:45-04:45 (03:45) south-east.bbc1.bbc.co.uk Sign Zone:Michael Palin's New Europe 2007-11-14 22:31:32,915 DEBUGautoshutdown.py (773): Executing syscall: ps -eo cmd | egrep -v grep | egrep (/|[[:space:]]|^)(urpm|urpmi|transcode|cdrecord|mplayer|xine|mencoder)($|[[:space:]]) 2007-11-14
Re: [Freevo-users] Traceback on shutdown with rel-1
Duncan Webb wrote: John Molohan wrote: Duncan Webb wrote: John Molohan wrote: 2007-11-08 21:24:28,198 DEBUGautoshutdown.py (773): Executing syscall: ps -eo cmd | egrep -v grep | egrep (/|[[:space:]]|^)(urpm|urpmi|transcode|cdrecord|mplayer|xine|mencoder)($|[[:space:]]) 2007-11-08 21:24:28,241 DEBUGautoshutdown.py (756): no external process(es) running 2007-11-08 21:24:28,243 DEBUGautoshutdown.py (385): Shutdown issued by autoshutdown timer! 2007-11-08 21:24:28,244 DEBUGautoshutdown.py (492): shutdown wakeup 2007-11-08 21:24:31,801 DEBUGautoshutdown.py (454): No more recordings available 2007-11-08 21:24:31,802 DEBUGautoshutdown.py (732): Default wakeup at Fri Nov 9 13:00:00 2007 2007-11-08 21:24:31,803 DEBUGautoshutdown.py (478): Picked wakeup at Fri Nov 9 13:00:00 2007 2007-11-08 21:24:31,804 DEBUGautoshutdown.py (549): Wakeup-command /usr/local/bin/set_acpi.sh 2007-11-09 12:57 2007-11-08 21:24:31,805 DEBUGautoshutdown.py (773): Executing syscall: /usr/local/bin/set_acpi.sh 2007-11-09 12:57 2007-11-08 21:24:32,856 DEBUGautoshutdown.py (502): shutdown system 2007-11-08 21:24:33,895 ERRORremoved timer 1 Traceback (most recent call last): File /usr/lib/python2.5/site-packages/kaa/notifier/pynotifier/nf_generic.py, line 153, in step if not timer[ CALLBACK ](): File /usr/lib/python2.5/site-packages/kaa/notifier/timer.py, line 90, in __call__ return super(Timer, self).__call__(*args, **kwargs) File /usr/lib/python2.5/site-packages/kaa/notifier/nf_wrapper.py, line 96, in __call__ ret = super(NotifierCallback, self).__call__(*args, **kwargs) File /usr/lib/python2.5/site-packages/kaa/notifier/callback.py, line 168, in __call__ result = cb(*cb_args, **cb_kwargs) File /usr/lib/python2.5/site-packages/freevo/rc.py, line 624, in poll c[0](*c[4]) File /usr/lib/python2.5/site-packages/freevo/plugin.py, line 155, in poll_wrapper self.real_poll() File /usr/lib/python2.5/site-packages/freevo/plugins/autoshutdown.py, line 386, in poll shutdown_action(action=Shutdown.SHUTDOWN_WAKEUP) File /usr/lib/python2.5/site-packages/freevo/plugins/autoshutdown.py, line 503, in shutdown_action __cleanup_freevo() File /usr/lib/python2.5/site-packages/freevo/plugins/autoshutdown.py, line 619, in __cleanup_freevo plugin.shutdown() File /usr/lib/python2.5/site-packages/freevo/plugin.py, line 352, in shutdown p.shutdown() File /usr/lib/python2.5/site-packages/freevo/www/__init__.py, line 57, in shutdown print 'Stopping webserver plugin.' File /usr/lib/python2.5/site-packages/freevo/config.py, line 129, in write sys.__stdout__.flush() IOError: [Errno 5] Input/output error This is a bit strange, looks as if stdout is already closed. What happens when the webserver is not started as a plug-in but as a daemon. This could, but I suspect doesn't, have anything to do with the kaa.notifier changes. Duncan Hi Duncan, I haven't been able to reproduce that error yet but got a different one on shutdown tonight. Freevo had been started by freevo -fs from a ssh session and this was on the console: Unhandled exception in thread started by bound method Identify_Thread.__bootstrap of Identify_Thread(Thread-2, stopped daemon) Traceback (most recent call last): File /usr/lib/python2.5/threading.py, line 482, in __bootstrap (most likely raised during interpreter shutdown):) File /usr/lib/python2.5/site-packages/freevo/config.py, line 124, in write lock.acquire() AttributeError: 'NoneType' object has no attribute 'acquire' This is a strange error from config as lock is a global object that is set at the beginning, the idea is to ensure that debug messages don't overlap from the main thread and other threads. Just in case I've added a test for lock. Duncan Freevo shut down but the PC didn't power off as it should. As mentioned in the feature request I think this could be due to the audioscrobbler plugin, I had disabled it over the last few days and had no problem. I re-enabled it today. /var/log/freevo/main-0.log shows: 2007-11-14 21:04:08,500 DEBUGchildapp.py (171): sending SeekRelative+15 to pid 19250 2007-11-14 21:56:13,105 DEBUGchildapp.py (442): stderr: no data, closing log 2007-11-14 21:56:13,600 DEBUGxine.py (135): '' possible 2007-11-14 21:56:13,604 DEBUGmplayer.py (98): u'dvd://' possible 2007-11-14 21:56:13,605 DEBUGxine.py (123): u'dvd://' good 2007-11-14 22:31:32,914 DEBUGautoshutdown.py (673): Scheduled recording 0 at Thu Nov 15 03:45:00 2007 is Thu 2007-11-15 03:45-04:45 (03:45) south-east.bbc1.bbc.co.uk Sign Zone:Michael Palin's New Europe 2007-11-14 22:31:32,915 DEBUGautoshutdown.py (773): Executing syscall: ps -eo cmd | egrep -v grep | egrep
Re: [Freevo-users] Traceback on shutdown with rel-1
Duncan Webb wrote: John Molohan wrote: Duncan Webb wrote: John Molohan wrote: 2007-11-08 21:24:28,198 DEBUGautoshutdown.py (773): Executing syscall: ps -eo cmd | egrep -v grep | egrep (/|[[:space:]]|^)(urpm|urpmi|transcode|cdrecord|mplayer|xine|mencoder)($|[[:space:]]) 2007-11-08 21:24:28,241 DEBUGautoshutdown.py (756): no external process(es) running 2007-11-08 21:24:28,243 DEBUGautoshutdown.py (385): Shutdown issued by autoshutdown timer! 2007-11-08 21:24:28,244 DEBUGautoshutdown.py (492): shutdown wakeup 2007-11-08 21:24:31,801 DEBUGautoshutdown.py (454): No more recordings available 2007-11-08 21:24:31,802 DEBUGautoshutdown.py (732): Default wakeup at Fri Nov 9 13:00:00 2007 2007-11-08 21:24:31,803 DEBUGautoshutdown.py (478): Picked wakeup at Fri Nov 9 13:00:00 2007 2007-11-08 21:24:31,804 DEBUGautoshutdown.py (549): Wakeup-command /usr/local/bin/set_acpi.sh 2007-11-09 12:57 2007-11-08 21:24:31,805 DEBUGautoshutdown.py (773): Executing syscall: /usr/local/bin/set_acpi.sh 2007-11-09 12:57 2007-11-08 21:24:32,856 DEBUGautoshutdown.py (502): shutdown system 2007-11-08 21:24:33,895 ERRORremoved timer 1 Traceback (most recent call last): File /usr/lib/python2.5/site-packages/kaa/notifier/pynotifier/nf_generic.py, line 153, in step if not timer[ CALLBACK ](): File /usr/lib/python2.5/site-packages/kaa/notifier/timer.py, line 90, in __call__ return super(Timer, self).__call__(*args, **kwargs) File /usr/lib/python2.5/site-packages/kaa/notifier/nf_wrapper.py, line 96, in __call__ ret = super(NotifierCallback, self).__call__(*args, **kwargs) File /usr/lib/python2.5/site-packages/kaa/notifier/callback.py, line 168, in __call__ result = cb(*cb_args, **cb_kwargs) File /usr/lib/python2.5/site-packages/freevo/rc.py, line 624, in poll c[0](*c[4]) File /usr/lib/python2.5/site-packages/freevo/plugin.py, line 155, in poll_wrapper self.real_poll() File /usr/lib/python2.5/site-packages/freevo/plugins/autoshutdown.py, line 386, in poll shutdown_action(action=Shutdown.SHUTDOWN_WAKEUP) File /usr/lib/python2.5/site-packages/freevo/plugins/autoshutdown.py, line 503, in shutdown_action __cleanup_freevo() File /usr/lib/python2.5/site-packages/freevo/plugins/autoshutdown.py, line 619, in __cleanup_freevo plugin.shutdown() File /usr/lib/python2.5/site-packages/freevo/plugin.py, line 352, in shutdown p.shutdown() File /usr/lib/python2.5/site-packages/freevo/www/__init__.py, line 57, in shutdown print 'Stopping webserver plugin.' File /usr/lib/python2.5/site-packages/freevo/config.py, line 129, in write sys.__stdout__.flush() IOError: [Errno 5] Input/output error This is a bit strange, looks as if stdout is already closed. What happens when the webserver is not started as a plug-in but as a daemon. This could, but I suspect doesn't, have anything to do with the kaa.notifier changes. Duncan I've been testing quite a bit recently so this could make sense as I was starting freevo from ssh sessions and from within screen sessions. Normally it would have been started as a daemon, I'll see if I can reproduce it. I don't think that screen would close the stdout, unless there is an option to do this in screen. Duncan If it was just a ssh session that had launched freevo -fs and then died? I'd hazard a guess that was probably it. John - This SF.net email is sponsored by: Microsoft Defy all challenges. Microsoft(R) Visual Studio 2005. http://clk.atdmt.com/MRT/go/vse012070mrt/direct/01/ ___ Freevo-users mailing list Freevo-users@lists.sourceforge.net https://lists.sourceforge.net/lists/listinfo/freevo-users
Re: [Freevo-users] Traceback on shutdown with rel-1
Duncan Webb wrote: John Molohan wrote: 2007-11-08 21:24:28,198 DEBUGautoshutdown.py (773): Executing syscall: ps -eo cmd | egrep -v grep | egrep (/|[[:space:]]|^)(urpm|urpmi|transcode|cdrecord|mplayer|xine|mencoder)($|[[:space:]]) 2007-11-08 21:24:28,241 DEBUGautoshutdown.py (756): no external process(es) running 2007-11-08 21:24:28,243 DEBUGautoshutdown.py (385): Shutdown issued by autoshutdown timer! 2007-11-08 21:24:28,244 DEBUGautoshutdown.py (492): shutdown wakeup 2007-11-08 21:24:31,801 DEBUGautoshutdown.py (454): No more recordings available 2007-11-08 21:24:31,802 DEBUGautoshutdown.py (732): Default wakeup at Fri Nov 9 13:00:00 2007 2007-11-08 21:24:31,803 DEBUGautoshutdown.py (478): Picked wakeup at Fri Nov 9 13:00:00 2007 2007-11-08 21:24:31,804 DEBUGautoshutdown.py (549): Wakeup-command /usr/local/bin/set_acpi.sh 2007-11-09 12:57 2007-11-08 21:24:31,805 DEBUGautoshutdown.py (773): Executing syscall: /usr/local/bin/set_acpi.sh 2007-11-09 12:57 2007-11-08 21:24:32,856 DEBUGautoshutdown.py (502): shutdown system 2007-11-08 21:24:33,895 ERRORremoved timer 1 Traceback (most recent call last): File /usr/lib/python2.5/site-packages/kaa/notifier/pynotifier/nf_generic.py, line 153, in step if not timer[ CALLBACK ](): File /usr/lib/python2.5/site-packages/kaa/notifier/timer.py, line 90, in __call__ return super(Timer, self).__call__(*args, **kwargs) File /usr/lib/python2.5/site-packages/kaa/notifier/nf_wrapper.py, line 96, in __call__ ret = super(NotifierCallback, self).__call__(*args, **kwargs) File /usr/lib/python2.5/site-packages/kaa/notifier/callback.py, line 168, in __call__ result = cb(*cb_args, **cb_kwargs) File /usr/lib/python2.5/site-packages/freevo/rc.py, line 624, in poll c[0](*c[4]) File /usr/lib/python2.5/site-packages/freevo/plugin.py, line 155, in poll_wrapper self.real_poll() File /usr/lib/python2.5/site-packages/freevo/plugins/autoshutdown.py, line 386, in poll shutdown_action(action=Shutdown.SHUTDOWN_WAKEUP) File /usr/lib/python2.5/site-packages/freevo/plugins/autoshutdown.py, line 503, in shutdown_action __cleanup_freevo() File /usr/lib/python2.5/site-packages/freevo/plugins/autoshutdown.py, line 619, in __cleanup_freevo plugin.shutdown() File /usr/lib/python2.5/site-packages/freevo/plugin.py, line 352, in shutdown p.shutdown() File /usr/lib/python2.5/site-packages/freevo/www/__init__.py, line 57, in shutdown print 'Stopping webserver plugin.' File /usr/lib/python2.5/site-packages/freevo/config.py, line 129, in write sys.__stdout__.flush() IOError: [Errno 5] Input/output error This is a bit strange, looks as if stdout is already closed. What happens when the webserver is not started as a plug-in but as a daemon. This could, but I suspect doesn't, have anything to do with the kaa.notifier changes. Duncan Hi Duncan, I haven't been able to reproduce that error yet but got a different one on shutdown tonight. Freevo had been started by freevo -fs from a ssh session and this was on the console: Unhandled exception in thread started by bound method Identify_Thread.__bootstrap of Identify_Thread(Thread-2, stopped daemon) Traceback (most recent call last): File /usr/lib/python2.5/threading.py, line 482, in __bootstrap (most likely raised during interpreter shutdown):) File /usr/lib/python2.5/site-packages/freevo/config.py, line 124, in write lock.acquire() AttributeError: 'NoneType' object has no attribute 'acquire' Freevo shut down but the PC didn't power off as it should. As mentioned in the feature request I think this could be due to the audioscrobbler plugin, I had disabled it over the last few days and had no problem. I re-enabled it today. /var/log/freevo/main-0.log shows: 2007-11-14 21:04:08,500 DEBUGchildapp.py (171): sending SeekRelative+15 to pid 19250 2007-11-14 21:56:13,105 DEBUGchildapp.py (442): stderr: no data, closing log 2007-11-14 21:56:13,600 DEBUGxine.py (135): '' possible 2007-11-14 21:56:13,604 DEBUGmplayer.py (98): u'dvd://' possible 2007-11-14 21:56:13,605 DEBUGxine.py (123): u'dvd://' good 2007-11-14 22:31:32,914 DEBUGautoshutdown.py (673): Scheduled recording 0 at Thu Nov 15 03:45:00 2007 is Thu 2007-11-15 03:45-04:45 (03:45) south-east.bbc1.bbc.co.uk Sign Zone:Michael Palin's New Europe 2007-11-14 22:31:32,915 DEBUGautoshutdown.py (773): Executing syscall: ps -eo cmd | egrep -v grep | egrep (/|[[:space:]]|^)(urpm|urpmi|transcode|cdrecord|mplayer|xine|mencoder)($|[[:space:]]) 2007-11-14 22:31:33,073 DEBUGautoshutdown.py (756): no external process(es) running 2007-11-14 22:31:33,074 DEBUGautoshutdown.py (385): Shutdown issued by autoshutdown timer! 2007-11-14 22:31:33,075 DEBUGautoshutdown.py (492): shutdown wakeup 2007-11-14 22:31:43,463 DEBUGautoshutdown.py (673):
Re: [Freevo-users] Traceback on shutdown with rel-1
Duncan Webb wrote: John Molohan wrote: 2007-11-08 21:24:28,198 DEBUGautoshutdown.py (773): Executing syscall: ps -eo cmd | egrep -v grep | egrep (/|[[:space:]]|^)(urpm|urpmi|transcode|cdrecord|mplayer|xine|mencoder)($|[[:space:]]) 2007-11-08 21:24:28,241 DEBUGautoshutdown.py (756): no external process(es) running 2007-11-08 21:24:28,243 DEBUGautoshutdown.py (385): Shutdown issued by autoshutdown timer! 2007-11-08 21:24:28,244 DEBUGautoshutdown.py (492): shutdown wakeup 2007-11-08 21:24:31,801 DEBUGautoshutdown.py (454): No more recordings available 2007-11-08 21:24:31,802 DEBUGautoshutdown.py (732): Default wakeup at Fri Nov 9 13:00:00 2007 2007-11-08 21:24:31,803 DEBUGautoshutdown.py (478): Picked wakeup at Fri Nov 9 13:00:00 2007 2007-11-08 21:24:31,804 DEBUGautoshutdown.py (549): Wakeup-command /usr/local/bin/set_acpi.sh 2007-11-09 12:57 2007-11-08 21:24:31,805 DEBUGautoshutdown.py (773): Executing syscall: /usr/local/bin/set_acpi.sh 2007-11-09 12:57 2007-11-08 21:24:32,856 DEBUGautoshutdown.py (502): shutdown system 2007-11-08 21:24:33,895 ERRORremoved timer 1 Traceback (most recent call last): File /usr/lib/python2.5/site-packages/kaa/notifier/pynotifier/nf_generic.py, line 153, in step if not timer[ CALLBACK ](): File /usr/lib/python2.5/site-packages/kaa/notifier/timer.py, line 90, in __call__ return super(Timer, self).__call__(*args, **kwargs) File /usr/lib/python2.5/site-packages/kaa/notifier/nf_wrapper.py, line 96, in __call__ ret = super(NotifierCallback, self).__call__(*args, **kwargs) File /usr/lib/python2.5/site-packages/kaa/notifier/callback.py, line 168, in __call__ result = cb(*cb_args, **cb_kwargs) File /usr/lib/python2.5/site-packages/freevo/rc.py, line 624, in poll c[0](*c[4]) File /usr/lib/python2.5/site-packages/freevo/plugin.py, line 155, in poll_wrapper self.real_poll() File /usr/lib/python2.5/site-packages/freevo/plugins/autoshutdown.py, line 386, in poll shutdown_action(action=Shutdown.SHUTDOWN_WAKEUP) File /usr/lib/python2.5/site-packages/freevo/plugins/autoshutdown.py, line 503, in shutdown_action __cleanup_freevo() File /usr/lib/python2.5/site-packages/freevo/plugins/autoshutdown.py, line 619, in __cleanup_freevo plugin.shutdown() File /usr/lib/python2.5/site-packages/freevo/plugin.py, line 352, in shutdown p.shutdown() File /usr/lib/python2.5/site-packages/freevo/www/__init__.py, line 57, in shutdown print 'Stopping webserver plugin.' File /usr/lib/python2.5/site-packages/freevo/config.py, line 129, in write sys.__stdout__.flush() IOError: [Errno 5] Input/output error This is a bit strange, looks as if stdout is already closed. What happens when the webserver is not started as a plug-in but as a daemon. This could, but I suspect doesn't, have anything to do with the kaa.notifier changes. Duncan I've been testing quite a bit recently so this could make sense as I was starting freevo from ssh sessions and from within screen sessions. Normally it would have been started as a daemon, I'll see if I can reproduce it. John - This SF.net email is sponsored by: Splunk Inc. Still grepping through log files to find problems? Stop. Now Search log events and configuration files using AJAX and a browser. Download your FREE copy of Splunk now http://get.splunk.com/ ___ Freevo-users mailing list Freevo-users@lists.sourceforge.net https://lists.sourceforge.net/lists/listinfo/freevo-users