Login at Kodi Home

**rocketpants** · 2011-05-24, 10:35

Hi all,

from time to time I get a runtime error on exiting XBMC as shown below

Here is the log from the latest crash. I didn't have debug turned on so it may not be of much use.

This doesn't occur everytime I exit but does occur on two different machines both running Win7 Home Premium. I read somewhere here that updating to the latest video drivers may fix this so I upgraded about a month ago but the problem has persisted.

The error occurs when I bring up the exit menu ('s') and select exit XBMC.

Any ideas on why this is occuring?

Thanks

System details
1. Mac Mini C2D P7550
NVIDIA GeForce 9400 - Driver version 270.61
Dharma 10.1 stable with Transparency
Win7 Home Premium

2. AsRock ION330HT
Atom
NVidaia ION - Driver version 270.61
Dharma 10.1 stable with Transparency
Win7 Home premium

**rocketpants** · 2011-06-01, 10:20

Any ideas on this?

jhsrennie · 2011-06-01, 10:59

It's not something I've ever seen.

You can enable debug logging without the irritating display at the top of the screen. You just need to create an advancedsettings.xml file. Usual Win noob howto follows - apologies if I'm teaching granny to suck eggs:

Press Windows-R and in the Run dialog type:

notepad "%appdata%\xbmc\userdata\advancedsettings.xml"

and click OK. If you're asked to crearte a new file answer Yes. Copy and paste the following then close Notepad and save the changes.

Code:
<advancedsettings>

  <loglevel>1</loglevel>

</advancedsettings>

JR

**rocketpants** · 2011-06-02, 03:01

Thanks JR. I'd forgotten you can tun on debug without the OSD.

There were a few posts from some years back that referenced the same issue but IIRC they were pre-win7, pre-Dharma etc so I'm not sure how relevent they are to this.

Oh - and this issue happened pre and post Win7 SP1.

Jazzik · 2011-06-06, 19:16

I have this exact problem.

Win 7 x64. Its a nuisance because it also prevents the PC shutting down with the timer.

**rocketpants** · 2011-06-07, 05:05

@Jazzik, can you enable debug as explained by JR above and post a log when this happens to you again. I haven't had the problem for a while but I know it will come back at some stage and do want to get it sorted.

miljbee · 2011-06-08, 00:47

I don't know, if this will help you, but I have had this problem today, and it seems that it's now solved !

I Had problems with path in my sources that were no more reachable.
Once I corrected my problems with the path, XBMC exits without errors.

GCWB · (This post was last modified: 2011-08-16, 21:06 by GCWB.)

Has this problem not been solved? I am getting the exact same issue. I shall post a crash log in a moment.

edit: Weird, I can't recreate the issue. It's just stopped crashing, I'll be back if it returns.

GCWB · 2011-08-17, 05:03

If someone could help me out, it would be of a great help. The issue doesn't appear all the time, but I found it happens nearly everytime on shutdown after prolonged usage (after a film basically).

http://pastebin.com/9L7EXwuV

It's a dealbreaker for my HTPC as it's made for my parents. Simpletons. They can't be getting errors, its distressing.

jhsrennie · 2011-08-17, 10:32

Does it crash if you use the Confluence skin?

I'd guess it's something to do with a Python script or add-on. There seem to be five "python started" entries and only one "python stopped".

JR

**rocketpants** · 2011-08-17, 10:33

I managed to fix the problem by posting about it here. Ever since I did that I haven't had the error on exit. Some may say this is coincidence but I prefer to think of it as some sort of magic Smile

Seriously - no idea. But I haven't had the problem since increasing the default log level on the PC. And I only did that one one machine. The other one stopped having errors all by itself. Maybe a windows update sorted it out for me.

GCWB · 2011-08-17, 16:57

jhsrennie Wrote:Does it crash if you use the Confluence skin?

I'd guess it's something to do with a Python script or add-on. There seem to be five "python started" entries and only one "python stopped".

JR

I haven't tried, I'll give it a go later today, as it takes a 'prolonged' usage. If I just boot up XBMC and shut it down, it works fine. Or boot it up and browse for 5 minutes.

I am using Aeon MQ 2, the stable version.
And XBMC Dharma.

By python, what do you mean? I'm a long time user of XBMC yet I've never really got down and dirty with the software. I use Advanced Launcher to launch itunes, could this be the case? I remember setting it up really shakily, so it could easily be corrupt.

Stueck · (This post was last modified: 2015-01-10, 19:43 by Stueck.)

I have exactly the same problem.

Could it be a problem using a mysql database?
Maybe is the plugin WatchDog a problem? I tried to deactivate it, and than it didn't crash for the last tries.
Easy reproducable if a movie is running while I exit xbmc/kodi. But crashes also sometimes (30%-50%) when nothing is running and I am in the main menu.

I have here a debug log - had to cut the first part, because of the letter limit in this forum:

Code:
14:46 T:9548   DEBUG: ------ Window Init (VideoOSD.xml) ------

14:46 T:9548    INFO: Loading skin file: VideoOSD.xml, load type: KEEP_IN_MEMORY

14:46 T:8972    INFO: CPythonInvoker(3, C:\Users\xbmc\AppData\Roaming\XBMC\addons\script.module.simple.downloader\default.py): script successfully run

14:47 T:8972    INFO: Python script stopped

14:47 T:8972   DEBUG: Thread LanguageInvoker 8972 terminating

14:47 T:9848   DEBUG: [service.watchdog] watching <smb://192.168.2.2/Videos/sd/> using <class 'core.polling_xbmc._Recursive'>

14:47 T:9728   DEBUG: [Cinema Experience] - settings() - __init__

14:47 T:9728   DEBUG: [Cinema Experience] - settings() - start

14:47 T:9728   DEBUG: [Cinema Experience] - Reading settings.xml

14:47 T:7380   DEBUG: Skin Widgets: script version 0.0.29 started

14:47 T:9728   DEBUG: [Cinema Experience] - Reading settings.xml

14:47 T:7380   DEBUG: CVideoDatabase::RunQuery took 52 ms for 258 items query: select * from movieview  WHERE ((movieview.playCount IS NULL OR movieview.playCount < 1))

14:47 T:9728   DEBUG: [Cinema Experience] - Cinema Experience service script version 4.0.10 started

14:47 T:9728   DEBUG: [Cinema Experience] - Reading settings.xml

14:47 T:9728   DEBUG: [Cinema Experience] - settings() - start

14:47 T:9728   DEBUG: [Cinema Experience] - Reading settings.xml

14:47 T:3360   DEBUG: Library Data Provider: service version 0.0.7 started

14:47 T:9848   DEBUG: [service.watchdog] watching <smb://192.168.2.2/Videos/Serien/> using <class 'core.polling_xbmc._Recursive'>

14:48 T:9848   DEBUG: [service.watchdog] watching <smb://192.168.2.2/Videos/hd/> using <class 'core.polling_xbmc._Recursive'>

14:48 T:9848   DEBUG: [service.watchdog] watching <smb://192.168.2.2/Videos/3D/> using <class 'core.polling_xbmc._Recursive'>

14:48 T:9848   DEBUG: [service.watchdog] watching <smb://192.168.2.2/Videos/dokus/> using <class 'core.polling_xbmc._Recursive'>

14:48 T:9848   DEBUG: [service.watchdog] initialization done

14:48 T:3360   DEBUG: CVideoDatabase::RunQuery took 27 ms for 258 items query: select * from movieview  WHERE ((movieview.playCount IS NULL OR movieview.playCount < 1))

14:48 T:8900   DEBUG: CDVDPlayerAudio:: Dropping packet of 10 ms

14:48 T:9548   DEBUG: Previous line repeats 3 times.

14:48 T:9548   DEBUG: ------ Window Deinit (DialogExtendedProgressBar.xml) ------

14:49 T:9548   DEBUG: Keyboard: scancode: 0x01, sym: 0x001b, unicode: 0x001b, modifier: 0x0

14:49 T:9548   DEBUG: CApplication::OnKey: escape (0xf01b) pressed, action is PreviousMenu

14:49 T:3360   DEBUG: CVideoDatabase::RunQuery took 206 ms for 1145 items query: select * from episodeview  WHERE ((episodeview.playCount IS NULL OR episodeview.playCount < 1))

14:49 T:7380   DEBUG: CVideoDatabase::RunQuery took 252 ms for 1145 items query: select * from episodeview  WHERE ((episodeview.playCount IS NULL OR episodeview.playCount < 1))

14:49 T:9548   DEBUG: ------ Window Deinit (VideoOSD.xml) ------

14:49 T:3360   DEBUG: CMusicDatabase::GetSongsByWhere query = SELECT songview.* FROM songview  WHERE ((CAST(songview.iTimesPlayed as DECIMAL(5,1)) < 1))

14:49 T:3360   DEBUG: CMusicDatabase::GetAlbumsByWhere query: SELECT albumview.* FROM albumview  WHERE albumview.strAlbum <> ''

14:49 T:3360   DEBUG: CMusicDatabase::GetAlbumsByWhere - query took 9 ms

14:49 T:3360   DEBUG: CVideoDatabase::RunQuery took 36 ms for 258 items query: select * from movieview  WHERE ((movieview.playCount IS NULL OR movieview.playCount = 0))

14:50 T:7380   DEBUG: CVideoDatabase::RunQuery took 1 ms for 0 items query: select * from musicvideoview

14:50 T:7380   DEBUG: CMusicDatabase::GetAlbumsByWhere query: SELECT albumview.* FROM albumview  WHERE albumview.strAlbum <> ''

14:50 T:7380   DEBUG: CMusicDatabase::GetAlbumsByWhere - query took 8 ms

14:50 T:7380   DEBUG: CMusicDatabase::GetArtistsByWhere query: SELECT artistview.* FROM artistview  WHERE (artistview.idArtist IN (SELECT song_artist.idArtist FROM song_artist) OR artistview.idArtist IN (SELECT album_artist.idArtist FROM album_artist)) and artistview.strArtist != '' and artistview.strArtist <> 'Verschiedene Interpreten'

14:50 T:7380   DEBUG: Time to retrieve artists from dataset = 2

14:50 T:7380   DEBUG: CMusicDatabase::GetSongsByWhere query = SELECT songview.* FROM songview  WHERE ((CAST(songview.iTimesPlayed as DECIMAL(5,1)) < 1))

14:50 T:7380   DEBUG: Skin Widgets: Total time needed to request random queries: 0:00:02.606000

14:50 T:7380   DEBUG: CVideoDatabase::RunQuery took 13 ms for 31 items query: select * from movieview  WHERE (movieview.idFile  IN (SELECT DISTINCT idFile FROM bookmark WHERE type = 1))

14:50 T:3360   DEBUG: CVideoDatabase::RunQuery took 104 ms for 1145 items query: select * from episodeview  WHERE ((episodeview.playCount IS NULL OR episodeview.playCount < 1))

14:50 T:8900   DEBUG: CDVDPlayerAudio:: Dropping packet of 10 ms

14:50 T:6532   DEBUG: Previous line repeats 2 times.

14:50 T:6532    INFO: CPythonInvoker(1, C:\Users\xbmc\AppData\Roaming\XBMC\addons\service.xbmc.versioncheck\service.py): script successfully run

14:50 T:6532    INFO: Python script stopped

14:50 T:6532   DEBUG: Thread LanguageInvoker 6532 terminating

14:50 T:9548   DEBUG: ------ Window Init (VideoOSD.xml) ------

14:50 T:3360   DEBUG: CMusicDatabase::GetAlbumsByWhere query: SELECT albumview.* FROM albumview  WHERE albumview.strAlbum <> ''

14:50 T:3360   DEBUG: CMusicDatabase::GetAlbumsByWhere - query took 7 ms

14:50 T:3360   DEBUG: CVideoDatabase::RunQuery took 24 ms for 31 items query: select * from movieview  WHERE (movieview.idFile  IN (SELECT DISTINCT idFile FROM bookmark WHERE type = 1))

14:50 T:7380   DEBUG: CVideoDatabase::RunQuery took 140 ms for 15 items query: SELECT * FROM tvshowview  WHERE ( ((tvshowview.watchedcount > 0 AND tvshowview.watchedcount < tvshowview.totalCount) OR (tvshowview.watchedcount = 0 AND EXISTS (SELECT 1 FROM episodeview WHERE episodeview.idShow = tvshowview.idShow AND episodeview.resumeTimeInSeconds > 0))))

14:50 T:7380   DEBUG: CVideoDatabase::GetStackedTvShowList query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=36) order by idShow

14:50 T:7380   DEBUG: CVideoDatabase::RunQuery took 4 ms for 24 items query: select * from episodeview  WHERE (episodeview.idShow = 36) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))

14:50 T:7380   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25

14:51 T:7380   DEBUG: CVideoDatabase::GetStackedTvShowList query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=32) order by idShow

14:51 T:7380   DEBUG: CVideoDatabase::RunQuery took 5 ms for 11 items query: select * from episodeview  WHERE (episodeview.idShow = 32) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))

14:51 T:7380   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25

14:51 T:7380   DEBUG: CVideoDatabase::GetStackedTvShowList query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=57) order by idShow

14:51 T:3360   DEBUG: CVideoDatabase::RunQuery took 98 ms for 15 items query: SELECT * FROM tvshowview  WHERE ( ((tvshowview.watchedcount > 0 AND tvshowview.watchedcount < tvshowview.totalCount) OR (tvshowview.watchedcount = 0 AND EXISTS (SELECT 1 FROM episodeview WHERE episodeview.idShow = tvshowview.idShow AND episodeview.resumeTimeInSeconds > 0))))

14:51 T:7380   DEBUG: CVideoDatabase::RunQuery took 12 ms for 34 items query: select * from episodeview  WHERE (episodeview.idShow = 57) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))

14:51 T:7380   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25

14:51 T:7772   DEBUG: CPullupCorrection: detected pattern of length 1: 41708.33, frameduration: 41708.333333

14:51 T:3360   DEBUG: CVideoDatabase::GetStackedTvShowList query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=36) order by idShow

14:51 T:3360   DEBUG: CVideoDatabase::RunQuery took 4 ms for 24 items query: select * from episodeview  WHERE (episodeview.idShow = 36) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))

14:51 T:3360   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25

14:51 T:7380   DEBUG: CVideoDatabase::GetStackedTvShowList query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=45) order by idShow

14:51 T:7380   DEBUG: CVideoDatabase::RunQuery took 4 ms for 2 items query: select * from episodeview  WHERE (episodeview.idShow = 45) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))

14:51 T:7380   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25

14:51 T:3360   DEBUG: CVideoDatabase::GetStackedTvShowList query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=32) order by idShow

14:51 T:3360   DEBUG: CVideoDatabase::RunQuery took 3 ms for 11 items query: select * from episodeview  WHERE (episodeview.idShow = 32) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))

14:51 T:3360   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25

14:51 T:3360   DEBUG: CVideoDatabase::GetStackedTvShowList query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=57) order by idShow

14:51 T:3360   DEBUG: CVideoDatabase::RunQuery took 4 ms for 34 items query: select * from episodeview  WHERE (episodeview.idShow = 57) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))

14:51 T:3360   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25

14:51 T:3360   DEBUG: CVideoDatabase::GetStackedTvShowList query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=45) order by idShow

14:51 T:3360   DEBUG: CVideoDatabase::RunQuery took 6 ms for 2 items query: select * from episodeview  WHERE (episodeview.idShow = 45) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))

14:51 T:3360   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25

14:51 T:7380   DEBUG: CVideoDatabase::GetStackedTvShowList query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=64) order by idShow

14:51 T:7380   DEBUG: CVideoDatabase::RunQuery took 4 ms for 15 items query: select * from episodeview  WHERE (episodeview.idShow = 64) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))

14:51 T:7380   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25

14:51 T:3360   DEBUG: CVideoDatabase::GetStackedTvShowList query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=64) order by idShow

14:51 T:3360   DEBUG: CVideoDatabase::RunQuery took 5 ms for 15 items query: select * from episodeview  WHERE (episodeview.idShow = 64) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))

14:51 T:3360   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25

14:51 T:7380   DEBUG: CVideoDatabase::GetStackedTvShowList query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=18) order by idShow

14:51 T:7380   DEBUG: Previous line repeats 1 times.

14:51 T:7380   DEBUG: CVideoDatabase::RunQuery took 7 ms for 9 items query: select * from episodeview  WHERE (episodeview.idShow = 18) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))

14:51 T:7380   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25

14:51 T:3360   DEBUG: CVideoDatabase::RunQuery took 11 ms for 9 items query: select * from episodeview  WHERE (episodeview.idShow = 18) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))

14:51 T:3360   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25

14:51 T:9548   DEBUG: Keyboard: scancode: 0x01, sym: 0x001b, unicode: 0x001b, modifier: 0x0

14:51 T:9548   DEBUG: CApplication::OnKey: escape (0xf01b) pressed, action is PreviousMenu

14:51 T:9548   DEBUG: ------ Window Deinit (Pointer.xml) ------

14:51 T:3360   DEBUG: CVideoDatabase::GetStackedTvShowList query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=13) order by idShow

14:51 T:3360   DEBUG: CVideoDatabase::RunQuery took 15 ms for 125 items query: select * from episodeview  WHERE (episodeview.idShow = 13) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))

14:51 T:3360   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25

14:51 T:7380   DEBUG: CVideoDatabase::GetStackedTvShowList query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=13) order by idShow

14:51 T:7380   DEBUG: CVideoDatabase::RunQuery took 15 ms for 125 items query: select * from episodeview  WHERE (episodeview.idShow = 13) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))

14:51 T:7380   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25

14:51 T:3360   DEBUG: CVideoDatabase::GetStackedTvShowList query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=35) order by idShow

14:51 T:3360   DEBUG: CVideoDatabase::RunQuery took 3 ms for 6 items query: select * from episodeview  WHERE (episodeview.idShow = 35) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))

14:51 T:3360   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25

14:51 T:3360   DEBUG: CVideoDatabase::GetStackedTvShowList query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=26) order by idShow

14:51 T:3360   DEBUG: CVideoDatabase::RunQuery took 5 ms for 25 items query: select * from episodeview  WHERE (episodeview.idShow = 26) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))

14:51 T:3360   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25

14:51 T:7380   DEBUG: CVideoDatabase::GetStackedTvShowList query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=35) order by idShow

14:51 T:7380   DEBUG: CVideoDatabase::RunQuery took 3 ms for 6 items query: select * from episodeview  WHERE (episodeview.idShow = 35) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))

14:51 T:7380   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25

14:51 T:9548   DEBUG: ------ Window Deinit (VideoOSD.xml) ------

14:51 T:3360   DEBUG: CVideoDatabase::GetStackedTvShowList query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=19) order by idShow

14:51 T:3360   DEBUG: CVideoDatabase::RunQuery took 5 ms for 37 items query: select * from episodeview  WHERE (episodeview.idShow = 19) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))

14:51 T:3360   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25

14:51 T:3360   DEBUG: CVideoDatabase::GetStackedTvShowList query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=22) order by idShow

14:51 T:3360   DEBUG: CVideoDatabase::RunQuery took 16 ms for 109 items query: select * from episodeview  WHERE (episodeview.idShow = 22) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))

14:51 T:3360   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25

14:51 T:3360   DEBUG: CVideoDatabase::GetStackedTvShowList query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=49) order by idShow

14:51 T:3360   DEBUG: CVideoDatabase::RunQuery took 11 ms for 35 items query: select * from episodeview  WHERE (episodeview.idShow = 49) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))

14:51 T:3360   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25

14:51 T:3360   DEBUG: CVideoDatabase::GetStackedTvShowList query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=23) order by idShow

14:51 T:3360   DEBUG: CVideoDatabase::RunQuery took 7 ms for 24 items query: select * from episodeview  WHERE (episodeview.idShow = 23) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))

14:51 T:3360   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25

14:52 T:7380   DEBUG: CVideoDatabase::GetStackedTvShowList query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=26) order by idShow

14:52 T:7380   DEBUG: CVideoDatabase::RunQuery took 5 ms for 25 items query: select * from episodeview  WHERE (episodeview.idShow = 26) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))

14:52 T:7380   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25

14:52 T:3360   DEBUG: CVideoDatabase::GetStackedTvShowList query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=14) order by idShow

14:52 T:3360   DEBUG: CVideoDatabase::RunQuery took 7 ms for 13 items query: select * from episodeview  WHERE (episodeview.idShow = 14) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))

14:52 T:3360   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25

14:52 T:3360   DEBUG: CVideoDatabase::GetStackedTvShowList query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=1) order by idShow

14:52 T:3360   DEBUG: CVideoDatabase::RunQuery took 7 ms for 19 items query: select * from episodeview  WHERE (episodeview.idShow = 1) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))

14:52 T:3360   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25

14:52 T:7380   DEBUG: CVideoDatabase::GetStackedTvShowList query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=19) order by idShow

14:52 T:7380   DEBUG: CVideoDatabase::RunQuery took 8 ms for 37 items query: select * from episodeview  WHERE (episodeview.idShow = 19) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))

14:52 T:7380   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25

14:52 T:3360   DEBUG: CMusicDatabase::GetAlbumsByWhere query: SELECT albumview.* FROM albumview  WHERE albumview.strAlbum <> ''

14:52 T:3360   DEBUG: CMusicDatabase::GetAlbumsByWhere - query took 14 ms

14:52 T:3360   DEBUG: Library Data Provider: Total time needed for all queries: 0:00:04.333000

14:52 T:7380   DEBUG: CVideoDatabase::GetStackedTvShowList query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=22) order by idShow

14:52 T:7380   DEBUG: CVideoDatabase::RunQuery took 18 ms for 109 items query: select * from episodeview  WHERE (episodeview.idShow = 22) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))

14:52 T:7380   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25

14:52 T:7380   DEBUG: CVideoDatabase::GetStackedTvShowList query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=49) order by idShow

14:52 T:7380   DEBUG: CVideoDatabase::RunQuery took 13 ms for 35 items query: select * from episodeview  WHERE (episodeview.idShow = 49) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))

14:52 T:7380   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25

14:52 T:7380   DEBUG: CVideoDatabase::GetStackedTvShowList query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=23) order by idShow

14:52 T:7380   DEBUG: CVideoDatabase::RunQuery took 6 ms for 24 items query: select * from episodeview  WHERE (episodeview.idShow = 23) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))

14:52 T:7380   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25

14:53 T:7380   DEBUG: CVideoDatabase::GetStackedTvShowList query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=14) order by idShow

14:53 T:7380   DEBUG: CVideoDatabase::RunQuery took 8 ms for 13 items query: select * from episodeview  WHERE (episodeview.idShow = 14) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))

14:53 T:7380   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25

14:53 T:9548   DEBUG: ------ Window Init (Pointer.xml) ------

14:53 T:9548   DEBUG: ------ Window Init (VideoOSD.xml) ------

14:53 T:7380   DEBUG: CVideoDatabase::GetStackedTvShowList query: select idShow from tvshow where c00 like (select c00 from tvshow where idShow=1) order by idShow

14:53 T:7380   DEBUG: CVideoDatabase::RunQuery took 7 ms for 19 items query: select * from episodeview  WHERE (episodeview.idShow = 1) AND (((episodeview.playCount IS NULL OR episodeview.playCount = 0)))

14:53 T:7380   DEBUG: DatabaseUtils::GetSortFieldList: unknown field 25

14:53 T:7380   DEBUG: CMusicDatabase::GetAlbumsByWhere query: SELECT albumview.* FROM albumview  WHERE albumview.strAlbum <> ''

14:53 T:7380   DEBUG: CMusicDatabase::GetAlbumsByWhere - query took 13 ms

14:53 T:7380   DEBUG: CVideoDatabase::RunQuery took 2 ms for 0 items query: select * from musicvideoview

14:53 T:7380   DEBUG: Skin Widgets: Total time needed to request recommended queries: 0:00:03.082000

14:53 T:7380   DEBUG: CVideoDatabase::RunQuery took 51 ms for 258 items query: select * from movieview  WHERE ((movieview.playCount IS NULL OR movieview.playCount = 0))

14:54 T:7380   DEBUG: CVideoDatabase::RunQuery took 197 ms for 1145 items query: select * from episodeview  WHERE ((episodeview.playCount IS NULL OR episodeview.playCount < 1))

14:56 T:9548   DEBUG: Keyboard: scancode: 0x01, sym: 0x001b, unicode: 0x001b, modifier: 0x0

14:56 T:9548   DEBUG: CApplication::OnKey: escape (0xf01b) pressed, action is PreviousMenu

14:56 T:9548   DEBUG: ------ Window Deinit (Pointer.xml) ------

14:56 T:9548   DEBUG: ------ Window Deinit (VideoOSD.xml) ------

14:56 T:9548   DEBUG: ------ Window Init (Pointer.xml) ------

14:56 T:9548   DEBUG: ------ Window Init (VideoOSD.xml) ------

14:56 T:7380   DEBUG: CVideoDatabase::RunQuery took 2 ms for 0 items query: select * from musicvideoview

14:56 T:7380   DEBUG: CMusicDatabase::GetAlbumsByWhere query: SELECT albumview.* FROM albumview  WHERE albumview.strAlbum <> ''

14:56 T:7380   DEBUG: CMusicDatabase::GetAlbumsByWhere - query took 14 ms

14:56 T:7380   DEBUG: Skin Widgets: Total time needed to request recent items queries: 0:00:03.543000

14:56 T:7380   DEBUG: Skin Widgets: Total time needed for all queries: 0:00:09.231000

15:05 T:9548   DEBUG: ------ Window Deinit (Pointer.xml) ------

15:06 T:9548   DEBUG: Activating window ID: 10025

15:06 T:9548   DEBUG: ------ Window Deinit (VideoOSD.xml) ------

15:06 T:9548   DEBUG: ------ Window Deinit (VideoFullScreen.xml) ------

15:06 T:9548   DEBUG: ------ Window Init (MyVideoNav.xml) ------

15:06 T:9548    INFO: Loading skin file: MyVideoNav.xml, load type: KEEP_IN_MEMORY

15:06 T:9548   DEBUG: CGUIMediaWindow::GetDirectory (videodb://tvshows/titles/)

15:06 T:9548   DEBUG:   ParentPath = [videodb://tvshows/titles/]

15:06 T:9548   DEBUG: CVideoDatabase::RunQuery took 102 ms for 44 items query: SELECT * FROM tvshowview

15:06 T:8604  NOTICE: Thread BackgroundLoader start, auto delete: false

15:06 T:8604   DEBUG: Thread BackgroundLoader 8604 terminating

15:09 T:9548   DEBUG: CApplication::OnKey: 169 (0xa9) pressed, action is Left

15:10 T:8900   DEBUG: CDVDPlayerAudio:: Dropping packet of 10 ms

15:11 T:9548    INFO: XCURL::DllLibCurlGlobal::CheckIdle - Closing session to http://feeds.feedburner.com (easy=087A2070, multi=00517F28)

15:11 T:9016   DEBUG: Thread JobWorker 9016 terminating (autodelete)

15:11 T:9548   DEBUG: CApplication::OnKey: menu (0xd8) pressed, action is Back

15:11 T:7772   DEBUG: CPullupCorrection: detected pattern of length 1: 41708.33, frameduration: 41708.333333

15:12 T:9732   DEBUG: Thread JobWorker 9732 terminating (autodelete)

15:12 T:9548   DEBUG: CApplication::OnKey: menu (0xd8) pressed, action is Back

15:12 T:9548   DEBUG: CGUIWindowManager::PreviousWindow: Deactivate

15:12 T:9548   DEBUG: ------ Window Deinit (MyVideoNav.xml) ------

15:12 T:9548   DEBUG: CGUIWindowManager::PreviousWindow: Activate new

15:12 T:9548   DEBUG: ------ Window Init (VideoFullScreen.xml) ------

15:13 T:9548   DEBUG: CApplication::OnKey: menu (0xd8) pressed, action is Back

15:13 T:9548   DEBUG: CGUIWindowManager::PreviousWindow: Deactivate

15:13 T:9548   DEBUG: ------ Window Deinit (VideoFullScreen.xml) ------

15:13 T:9548   DEBUG: CGUIWindowManager::PreviousWindow: Activate new

15:13 T:9548   DEBUG: ------ Window Init (Home.xml) ------

15:13 T:10236  NOTICE: Thread JobWorker start, auto delete: true

15:13 T:10236   DEBUG: CRecentlyAddedJob::UpdateMusic() - Running RecentlyAdded home screen update

15:13 T:10236   DEBUG: GetRecentlyAddedAlbumSongs() query: SELECT songview.* FROM (SELECT idAlbum FROM albumview ORDER BY idAlbum DESC LIMIT 10) AS recentalbums JOIN songview ON songview.idAlbum=recentalbums.idAlbum

15:13 T:10236   DEBUG: CMusicDatabase::GetRecentlyAddedAlbums query: select * from albumview where strAlbum != '' order by idAlbum desc limit 10

15:13 T:10236   DEBUG: CRecentlyAddedJob::UpdateVideos() - Running RecentlyAdded home screen update

15:13 T:10236   DEBUG: CVideoDatabase::RunQuery took 87 ms for 10 items query: select * from movieview  ORDER BY dateAdded desc, idMovie desc LIMIT 10

15:14 T:10236   DEBUG: CVideoDatabase::RunQuery took 275 ms for 10 items query: select * from episodeview  ORDER BY dateAdded desc, idEpisode desc LIMIT 10

15:14 T:6984  NOTICE: Thread JobWorker start, auto delete: true

15:14 T:10236   DEBUG: CVideoDatabase::RunQuery took 10 ms for 0 items query: select * from musicvideoview  ORDER BY dateAdded desc, idMVideo desc LIMIT 10

15:14 T:10236   DEBUG: CRecentlyAddedJob::UpdateTotal() - Running RecentlyAdded home screen update

15:15 T:9548   DEBUG: CApplication::OnKey: 167 (0xa7) pressed, action is Down

15:17 T:9548   DEBUG: Previous line repeats 1 times.

15:17 T:9548   DEBUG: CApplication::OnKey: 11 (0x0b) pressed, action is Select

15:17 T:9548   DEBUG: Activating window ID: 10111

15:17 T:9548   DEBUG: ------ Window Init (DialogButtonMenu.xml) ------

15:17 T:9548    INFO: Loading skin file: DialogButtonMenu.xml, load type: KEEP_IN_MEMORY

15:18 T:9548   DEBUG: CApplication::OnKey: 11 (0x0b) pressed, action is Select

15:18 T:9548   DEBUG: CAnnouncementManager - Announcement: OnQuit from xbmc

15:18 T:9548   DEBUG: GOT ANNOUNCEMENT, type: 8, from xbmc, message OnQuit

15:18 T:9548   DEBUG: CSaveFileStateJob::DoWork - Saving file state for video item smb://192.168.2.2/Videos/hd/[cut].mkv

15:18 T:9548   DEBUG: Mysql execute: update files set playCount=NULL,lastPlayed='2015-01-10 18:15:18' where idFile=2884

15:18 T:9548   DEBUG: CAnnouncementManager - Announcement: OnUpdate from xbmc

15:18 T:9548   DEBUG: GOT ANNOUNCEMENT, type: 16, from xbmc, message OnUpdate

15:18 T:9548   DEBUG: Mysql execute: update settings set Deinterlace=1,ViewMode=0,ZoomAmount=1.000000,PixelRatio=1.000000,VerticalShift=0.000000,AudioStream=0,SubtitleStream=0,SubtitleDelay=0.000000,SubtitlesOn=1,Brightness=50.000000,Contrast=50.000000,Gamma=20.000000,VolumeAmplification=0.000000,AudioDelay=0.000000,OutputToAllSpeakers=0,Sharpness=0.000000,NoiseReduction=0.000000,NonLinStretch=0,PostProcess=0,ScalingMethod=1,DeinterlaceMode=0,ResumeTime=0,Crop=0,CropLeft=0,CropRight=0,CropTop=0,CropBottom=0,StereoMode=0,StereoInvert=0 where idFile=2884

15:18 T:9548  NOTICE: Storing total System Uptime

15:18 T:9548  NOTICE: Saving settings

15:18 T:9548  NOTICE: stop all

15:18 T:6984   DEBUG: Thread JobWorker 6984 terminating (autodelete)

15:18 T:10236   DEBUG: Thread JobWorker 10236 terminating (autodelete)

15:18 T:9548  NOTICE: stop player

15:18 T:9548  NOTICE: CDVDPlayer::CloseFile()

15:18 T:9548  NOTICE: DVDPlayer: waiting for threads to exit

15:18 T:9468  NOTICE: CDVDPlayer::OnExit()

15:18 T:9468  NOTICE: DVDPlayer: closing audio stream

15:18 T:9468  NOTICE: Closing audio stream

15:18 T:9468  NOTICE: Waiting for audio thread to exit

15:18 T:8900  NOTICE: thread end: CDVDPlayerAudio::OnExit()

15:18 T:9468  NOTICE: Closing audio device

15:18 T:8900   DEBUG: Thread DVDPlayerAudio 8900 terminating

15:18 T:2272   DEBUG: CActiveAE::DiscardStream - audio stream deleted

15:18 T:2272   DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted

15:18 T:4952   DEBUG: Previous line repeats 1 times.

15:18 T:4952    INFO: CActiveAESink::OpenSink - initialize sink

15:18 T:9468  NOTICE: Deleting audio codec

15:18 T:9468  NOTICE: DVDPlayer: closing video stream

15:18 T:9468  NOTICE: Closing video stream

15:18 T:9468  NOTICE: waiting for video thread to exit

15:18 T:4952   DEBUG: CAESinkDirectSound::Deinitialize: Cleaning up

15:18 T:4952   DEBUG: CActiveAESink::OpenSink - trying to open device DIRECTSOUND:{46CDA66C-4249-4340-930D-3526E1AEAFFC}

15:18 T:4952   DEBUG: CAESinkDirectSound::Initialize: Using Window handle: 459654

15:18 T:4952   DEBUG: CAESinkDirectSound::Initialize: secondary buffer created

15:18 T:4952   DEBUG: CAESinkDirectSound::Initialize: Initializing DirectSound with the following parameters:

15:18 T:4952   DEBUG:   Audio Device    : AMD HDMI Output (AMD High Definition Audio Device)

15:18 T:4952   DEBUG:   Sample Rate     : 44100

15:18 T:4952   DEBUG:   Sample Format   : AE_FMT_FLOAT

15:18 T:4952   DEBUG:   Bits Per Sample : 32

15:18 T:4952   DEBUG:   Valid Bits/Samp : 32

15:18 T:4952   DEBUG:   Channel Count   : 2

15:18 T:4952   DEBUG:   Block Align     : 8

15:18 T:4952   DEBUG:   Avg. Bytes Sec  : 352800

15:18 T:4952   DEBUG:   Samples/Block   : 32

15:18 T:4952   DEBUG:   Format cBSize   : 22

15:18 T:4952   DEBUG:   Channel Layout  : FL,FR

15:18 T:4952   DEBUG:   Channel Mask    : 3

15:18 T:4952   DEBUG:   Frames          : 661

15:18 T:4952   DEBUG:   Frame Samples   : 1322

15:18 T:4952   DEBUG:   Frame Size      : 8

15:18 T:4952   DEBUG: CActiveAESink::OpenSink - DIRECTSOUND Initialized:

15:18 T:4952   DEBUG:   Output Device : HDMI - AMD HDMI Output (AMD High Definition Audio Device)

15:18 T:4952   DEBUG:   Sample Rate   : 44100

15:18 T:4952   DEBUG:   Sample Format : AE_FMT_FLOAT

15:18 T:4952   DEBUG:   Channel Count : 2

15:18 T:4952   DEBUG:   Channel Layout: FL,FR

15:18 T:4952   DEBUG:   Frames        : 661

15:18 T:4952   DEBUG:   Frame Samples : 1322

15:18 T:4952   DEBUG:   Frame Size    : 8

15:18 T:7772  NOTICE: thread end: video_thread

15:18 T:7772   DEBUG: Thread DVDPlayerVideo 7772 terminating

15:18 T:2272   DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted

15:18 T:9468  NOTICE: deleting video codec

15:18 T:9468  NOTICE: DVDPlayer: closing subtitle stream

15:18 T:9468  NOTICE: Closing subtitle stream

15:18 T:9468  NOTICE: CDVDPlayer::OnExit() deleting demuxer

15:18 T:9468  NOTICE: CDVDPlayer::OnExit() deleting input stream

15:18 T:9468   DEBUG: CApplication::OnPlayBackStopped : play state was 2, starting 0

15:18 T:9468   DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc

15:18 T:9468   DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop

15:18 T:9468   DEBUG: Thread DVDPlayer 9468 terminating

15:18 T:9548  NOTICE: DVDPlayer: finished waiting

15:18 T:9548  NOTICE: CDVDPlayer::CloseFile()

15:18 T:9548  NOTICE: DVDPlayer: waiting for threads to exit

15:18 T:9548  NOTICE: DVDPlayer: finished waiting

15:18 T:9600   DEBUG: CVideoReferenceClock: Cleaning up Direct3d

15:18 T:9548    INFO: stopping PVRManager

15:18 T:9548   DEBUG: CNetwork::NetworkMessage - Signaling network services to stop

15:18 T:9548  NOTICE: ES: Stopping event server

15:18 T:9548   DEBUG: CNetwork::NetworkMessage - Waiting for network services to stop

15:18 T:9600   DEBUG: Thread VideoReferenceClock 9600 terminating

15:18 T:4952   DEBUG: CAESinkDirectSound::CheckPlayStatus: Resuming Playback

15:19 T:9584   DEBUG: Thread TCPServer 9584 terminating

15:19 T:6480   DEBUG: [service.watchdog] [xbmcif] executing builtin: 'CleanLibrary(video,False)'

15:19 T:6480   DEBUG: [service.watchdog] [xbmcif] waiting for scan/clean start..

15:19 T:9280  NOTICE: ES: UDP Event server stopped

15:19 T:9280   DEBUG: Thread EventServer 9280 terminating

15:19 T:7332   DEBUG: Thread PeripBusUSB 7332 terminating

15:19 T:9548  NOTICE: stop sap announcement listener

15:19 T:9548  NOTICE: clean cached files!

15:19 T:9548  NOTICE: unload skin

15:19 T:9548    INFO: Unloading old skin ...

15:19 T:9548   DEBUG: ------ Window Deinit (Home.xml) ------

15:19 T:8968   DEBUG: Thread PeripBusCEC 8968 terminating

15:19 T:9548   DEBUG: CTextureBundleXBT::Cleanup - Closed bundle

15:19 T:9548   DEBUG: Infobool 'player.showcodec' still used by 2 instances

15:19 T:9548   DEBUG: ADDON: Stopping service addons.

15:19 T:2876   DEBUG: CMMNotificationClient::OnPropertyValueChanged: Changed device property of {0.0.0.00000000}.{46cda66c-4249-4340-930d-3526e1aeaffc} is {9855c4cd-df8c-449c-a181-8191b68bd06c}#0

15:21 T:9032   DEBUG: CU LRC Lyrics: script version 2.0.12 ended

15:21 T:9032    INFO: CPythonInvoker(0, C:\Users\xbmc\AppData\Roaming\XBMC\addons\script.cu.lrclyrics\default.py): script successfully run

15:21 T:9548   DEBUG: CPythonInvoker(0, C:\Users\xbmc\AppData\Roaming\XBMC\addons\script.cu.lrclyrics\default.py): script termination took 2354ms

15:21 T:9032 WARNING: CPythonInvoker(0, C:\Users\xbmc\AppData\Roaming\XBMC\addons\script.cu.lrclyrics\default.py): the python script "C:\Users\xbmc\AppData\Roaming\XBMC\addons\script.cu.lrclyrics\default.py" has left several classes in memory that we couldn't clean up. The classes include: class PythonBindings::XBMCAddon_xbmc_Monitor_Director,class PythonBindings::XBMCAddon_xbmc_Player_Director

15:21 T:9032    INFO: Python script interrupted by user

15:22 T:7380   DEBUG: Skin Widgets: script version 0.0.29 stopped

15:22 T:7380    INFO: CPythonInvoker(2, C:\Users\xbmc\AppData\Roaming\XBMC\addons\service.skin.widgets\default.py): script successfully run

15:22 T:9548   DEBUG: CPythonInvoker(2, C:\Users\xbmc\AppData\Roaming\XBMC\addons\service.skin.widgets\default.py): script termination took 141ms

15:22 T:7380 WARNING: CPythonInvoker(2, C:\Users\xbmc\AppData\Roaming\XBMC\addons\service.skin.widgets\default.py): the python script "C:\Users\xbmc\AppData\Roaming\XBMC\addons\service.skin.widgets\default.py" has left several classes in memory that we couldn't clean up. The classes include: class XBMCAddon::xbmcgui::Window,class PythonBindings::XBMCAddon_xbmc_Monitor_Director,class PythonBindings::XBMCAddon_xbmc_Player_Director

15:22 T:7380    INFO: Python script interrupted by user

15:22 T:6612  NOTICE: StorageServer-2.5.4 Closed down

15:22 T:6612    INFO: CPythonInvoker(10, C:\Users\xbmc\AppData\Roaming\XBMC\addons\script.common.plugin.cache\default.py): script successfully run

15:22 T:9548   DEBUG: CPythonInvoker(10, C:\Users\xbmc\AppData\Roaming\XBMC\addons\script.common.plugin.cache\default.py): script termination took 76ms

15:22 T:6612    INFO: Python script interrupted by user

15:22 T:9848   DEBUG: [service.watchdog] stopping..

15:22 T:6480   DEBUG: [service.watchdog] [xbmcif] wait for scan/clean timed out.

15:22 T:6480   DEBUG: [service.watchdog] [xbmcif] scan/clean started.

15:22 T:6480   DEBUG: [service.watchdog] [xbmcif] waiting for scan/clean end..

15:22 T:6480   DEBUG: [service.watchdog] [xbmcif] scan/clean ended.

15:23 T:6480   DEBUG: [service.watchdog] [xbmcif] executing builtin: 'UpdateLibrary(video,,False)'

15:23 T:6480   DEBUG: [service.watchdog] [xbmcif] waiting for scan/clean start..

15:26 T:6480   DEBUG: [service.watchdog] [xbmcif] wait for scan/clean timed out.

15:26 T:6480   DEBUG: [service.watchdog] [xbmcif] scan/clean started.

15:26 T:6480   DEBUG: [service.watchdog] [xbmcif] waiting for scan/clean end..

15:26 T:6480   DEBUG: [service.watchdog] [xbmcif] scan/clean ended.

15:27 T:9548   ERROR: CPythonInvoker(4, C:\Users\xbmc\AppData\Roaming\XBMC\addons\service.watchdog\service.py): script didn't stop in 5 seconds - let's kill it

15:27 T:7380   DEBUG: Thread LanguageInvoker 7380 terminating

16:28 T:4952   DEBUG: CAESinkDirectSound::Deinitialize: Cleaning up

Complete log: http://stueckinger.net/files/xbmc_runtimeerror.log

Any suggestions?

Thank you

Stueck · 2015-01-13, 21:43

Is it a bug in Watchdog or in my configuration?