treason 11 Posted November 29, 2015 Share Posted November 29, 2015 I got this message. Here are the logs: http://xbmclogs.com/pdzdog5pu Thanks for the help Link to comment Share on other sites More sharing options...
xnappo 1593 Posted November 29, 2015 Share Posted November 29, 2015 Please post another log when it crashes, with log level set to INFO instead of DEBUG. We need the log from when the crash happens. xnappo 1 Link to comment Share on other sites More sharing options...
Angelblue05 4130 Posted November 29, 2015 Share Posted November 29, 2015 Actually, you need to post the log, after pressing ok in the pop up dialog, otherwise the error doesn't get raised in the log. Link to comment Share on other sites More sharing options...
treason 11 Posted November 30, 2015 Author Share Posted November 30, 2015 Here are the lines with the exception 19:56:24 T:140568390768384 NOTICE: EMBY WriteKodiMusicDB -> UPDATE album to Kodi library, Id: e269c1c6cbbd0e20c6676ae534a2100c - Title: Total Recall 19:56:24 T:140568390768384 NOTICE: EMBY WriteKodiMusicDB -> UPDATE album to Kodi library, Id: e2b53bbf418990936bc6cc2a2c481ff6 - Title: So Much Fun 19:56:24 T:140568390768384 NOTICE: EMBY WriteKodiMusicDB -> UPDATE album to Kodi library, Id: e477e5aa0fa0ac03f48283399bfde77e - Title: So Much Fun 19:56:24 T:140569451325312 DEBUG: ------ Window Init (DialogOK.xml) ------ 19:56:24 T:140569451325312 INFO: Loading skin file: DialogOK.xml, load type: KEEP_IN_MEMORY 19:56:44 T:140568539903744 DEBUG: Thread JobWorker 140568539903744 terminating (autodelete) 19:56:44 T:140568575342336 DEBUG: Thread JobWorker 140568575342336 terminating (autodelete) 19:56:47 T:140569451325312 DEBUG: SECTION:UnloadDelayed(DLL: special://xbmcbin/system/ImageLib-x86_64-linux.so) 19:56:47 T:140569451325312 DEBUG: Unloading: /ImageLib-x86_64-linux.so 19:57:15 T:140569451325312 DEBUG: ------ Window Init (Pointer.xml) ------ 19:57:16 T:140569451325312 DEBUG: ------ Window Deinit (Pointer.xml) ------ 19:57:16 T:140569451325312 DEBUG: ProcessMouse: trying mouse action leftclick 19:57:16 T:140569451325312 DEBUG: ------ Window Deinit (DialogOK.xml) ------ 19:57:16 T:140568390768384 ERROR: Exception in thread Thread-10: Traceback (most recent call last): File "/home/stephan/projects/openelec-5.0/build.OpenELEC-Generic.x86_64-5.0.8/Python-2.7.3/.install_pkg/usr/lib/python2.7/threading.py", line 551, in __bootstrap_inner File "/storage/.kodi/addons/plugin.video.emby/resources/lib/LibrarySync.py", line 1059, in run self.run_internal() File "/storage/.kodi/addons/plugin.video.emby/resources/lib/LibrarySync.py", line 1144, in run_internal self.IncrementalSync(listItems) File "/storage/.kodi/addons/plugin.video.emby/resources/lib/LibrarySync.py", line 775, in IncrementalSync WriteKodiMusicDB().addOrUpdateAlbumToKodiLibrary(MBitem, connection, cursor) File "/storage/.kodi/addons/plugin.video.emby/resources/lib/WriteKodiMusicDB.py", line 184, in addOrUpdateAlbumToKodiLibrary cursor.execute(query, (name, musicBrainzId, artists, year, genre, bio, thumb, lastScraped, dateadded, albumid)) IntegrityError: UNIQUE constraint failed: album.strMusicBrainzAlbumID 19:57:17 T:140569451325312 DEBUG: ------ Window Init (Pointer.xml) ------ 19:57:17 T:140568399161088 NOTICE: EMBY WebSocketThread -> Message: {"MessageType":"PlaybackStart","Data":{"SupportedCommands":["MoveUp","MoveDown","MoveLeft","MoveRight","Select","Back","GoHome","SendString","GoToSearch","GoToSettings","DisplayContent","SetAudioStreamIndex","SetSubtitleStreamIndex"],"QueueableMediaTypes":["Video"],"PlayableMediaTypes":["Audio","Video","Photo"],"Id":"155fa597a6c9a129281e432fd669b7a2","UserId":"f6bb5a38556e5e794eea46108474f0de","UserPrimaryImageTag":"90bbc59428a5c0d5bd9d8ff7aebf39de","UserName":"XX","AdditionalUsers":[],"ApplicationVersion":"2.15","Client":"Roku","LastActivityDate":"2015-11-30T00:57:19.0077488Z","DeviceName":"Roku 3","NowPlayingItem":{"Name":"1988-02-28 Jeds Birthday","Id":"56c7afc7a1ba8ff3fb6b615f91843681","Type":"Video","MediaType":"Video","RunTimeTicks":12120320000,"PrimaryImageTag":"883f1189efd4cc8c2ddbbb166ada2269","PrimaryImageItemId":"56c7afc7a1ba8ff3fb6b615f91843681","Artists":[],"MediaStreams":[{"Codec":"h264","Language":"und","IsInterlaced":false,"BitRate":1696298,"BitDepth":8,"RefFrames":4,"IsDefault":true,"IsForced":false,"Height":480,"Width":640,"AverageFrameRate":29.97003,"RealFrameRate":29.97003,"Profile":"Main","Type":"Video","AspectRatio":"4:3","Index":0,"IsExternal":false,"IsTextSubtitleStream":false,"SupportsExternalStream":false,"PixelFormat":"yuv420p","Level":40,"IsAnamorphic":false,"IsCabac":true},{"Codec":"aac","Language":"und","IsInterlaced":false,"ChannelLayout":"stereo","BitRate":163577,"Channels":2,"SampleRate":48000,"IsDefault":true,"IsForced":false,"Profile":"LC","Type":"Audio","Index":1,"IsExternal":false,"IsTextSubtitleStream":false,"SupportsExternalStream":false,"Level":0}],"ChapterImagesItemId":"56c7afc7a1ba8ff3fb6b615f91843681","Chapters":[{"StartPositionTicks":0,"Name":"Chapter 1","ImageTag":"5ee63b021b64a8a2091a171ea3a81aea"},{"StartPositionTicks":3000000000,"Name":"Chapter 2","ImageTag":"7131a67241c0e361bf346e4289aa289f"},{"StartPositionTicks":6000000000,"Name":"Chapter 3","ImageTag":"a644d87c521e61d38eb4ffebd709c27a"},{"StartPositionTicks":9000000000,"Name":"Chapter 4","ImageTag":"45637665abb5a0ad6937855085024c43"},{"StartPositionTicks":12000000000,"Name":"Chapter 5","ImageTag":"951733d55ba32e8439a76d10a42e8c54"}]},"DeviceId":"1GU44F070999","SupportsRemoteControl":true,"PlayState":{"PositionTicks":1280000000,"CanSeek":true,"IsPaused":true,"IsMuted":false,"AudioStreamIndex":1,"MediaSourceId":"56c7afc7a1ba8ff3fb6b615f91843681","PlayMethod":"DirectStream","RepeatMode":"RepeatNone"}}} 19:57:18 T:140568399161088 NOTICE: EMBY WebSocketThread -> Message: {"MessageType":"UserDataChanged","Data":{"UserId":"f6bb5a38556e5e794eea46108474f0de","UserDataList":[{"PlayedPercentage":10.5607772732073,"PlaybackPositionTicks":1280000000,"PlayCount":3,"IsFavorite":false,"LastPlayedDate":"2015-11-30T00:57:19.0077488Z","Played":false,"Key":"56c7afc7-a1ba-8ff3-fb6b-615f91843681","ItemId":"56c7afc7a1ba8ff3fb6b615f91843681"},{"PlayedPercentage":4.27863961375793,"UnplayedItemCount":179,"PlaybackPositionTicks":0,"PlayCount":0,"IsFavorite":false,"Played":false,"Key":"c380e579-75d2-2b72-418a-0ad5f5acc597","ItemId":"c380e57975d22b72418a0ad5f5acc597"}]}} 19:57:18 T:140568399161088 NOTICE: EMBY WebSocketThread -> Message: Doing UserDataChanged: UserDataList: [{u'ItemId': u'56c7afc7a1ba8ff3fb6b615f91843681', u'IsFavorite': False, u'Played': False, u'PlayedPercentage': 10.5607772732073, u'LastPlayedDate': u'2015-11-30T00:57:19.0077488Z', u'PlaybackPositionTicks': 1280000000, u'Key': u'56c7afc7-a1ba-8ff3-fb6b-615f91843681', u'PlayCount': 3}, {u'ItemId': u'c380e57975d22b72418a0ad5f5acc597', u'IsFavorite': False, u'Played': False, u'PlayedPercentage': 4.2786396137579299, u'UnplayedItemCount': 179, u'PlaybackPositionTicks': 0, u'Key': u'c380e579-75d2-2b72-418a-0ad5f5acc597', u'PlayCount': 0}] 19:57:18 T:140568399161088 NOTICE: EMBY LibrarySync -> Doing LibraryChanged : Processing User Data Changed : [{u'ItemId': u'56c7afc7a1ba8ff3fb6b615f91843681', u'IsFavorite': False, u'Played': False, u'PlayedPercentage': 10.5607772732073, u'LastPlayedDate': u'2015-11-30T00:57:19.0077488Z', u'PlaybackPositionTicks': 1280000000, u'Key': u'56c7afc7-a1ba-8ff3-fb6b-615f91843681', u'PlayCount': 3}, {u'ItemId': u'c380e57975d22b72418a0ad5f5acc597', u'IsFavorite': False, u'Played': False, u'PlayedPercentage': 4.2786396137579299, u'UnplayedItemCount': 179, u'PlaybackPositionTicks': 0, u'Key': u'c380e579-75d2-2b72-418a-0ad5f5acc597', u'PlayCount': 0}] 19:57:24 T:140569451325312 DEBUG: ------ Window Deinit (Pointer.xml) ------ key violation. Thanks for the help Link to comment Share on other sites More sharing options...
Angelblue05 4130 Posted November 30, 2015 Share Posted November 30, 2015 (edited) Ok, for now you can disable the music library in the add-on settings. I'm still looking into this. Edited November 30, 2015 by Angelblue05 Link to comment Share on other sites More sharing options...
SwanStream 59 Posted November 30, 2015 Share Posted November 30, 2015 I'm getting sync crash as well. Started a few days ago. Let me know if logs would be useful otherwise I'll just assume it's related and watch this space for more info. Thx. Link to comment Share on other sites More sharing options...
xnappo 1593 Posted November 30, 2015 Share Posted November 30, 2015 (edited) No, please post logs. Almost certainly it is NOT the same unless you look in the log and see the exact same thing. Edited November 30, 2015 by xnappo Link to comment Share on other sites More sharing options...
SwanStream 59 Posted November 30, 2015 Share Posted November 30, 2015 No, please post logs. Almost certainly it is NOT the same unless you look in the log and see the exact same thing. @@xnappo - After a bit of swearing and resetting the db a few times, rebooting, etc, seems that MAYBE kodi hath healed itself. At the moment I'm unsure as it's "compressing the database for the last hour, which doesn't seem right but might be, lots of stuff. Anyway here's the link to log set at debug:https://www.dropbox.com/s/5hidcrjmtbqxg6t/kodi.log?dl=0 Thanks in advance. Link to comment Share on other sites More sharing options...
Angelblue05 4130 Posted November 30, 2015 Share Posted November 30, 2015 (edited) Weird that it doesn't show the error. It seems near the end, the Kodi library update was running, but I don't see it ending which is quite odd. It falls in line with what you said... As for the compressing message, it's attached to the Kodi library update. If you want to disable it the notification, in Kodi settings > video > hide library update progress. Edited November 30, 2015 by Angelblue05 Link to comment Share on other sites More sharing options...
SwanStream 59 Posted November 30, 2015 Share Posted November 30, 2015 Well I don't want to hijack this other guys thread... but... I don't mind seeing the compressing message. But I'm also stuck at a 'please wait' while it's doing it's thing. Do I just close kodi and reopen it or will that bugger up the db again? Thanks! Link to comment Share on other sites More sharing options...
Angelblue05 4130 Posted November 30, 2015 Share Posted November 30, 2015 Normally the Kodi scan shouldn't take long, because we control the database. Kodi scan in our usage case is only to "refresh" the displayed information. Try restarting Kodi, let me know what happens. BTW don't enable the add-on debug set to Debug, but set it to Info instead. This should reduce the size of your logs since we don't need all this extra information. Link to comment Share on other sites More sharing options...
SwanStream 59 Posted November 30, 2015 Share Posted November 30, 2015 (edited) So, what does MACdiscovery failed for embydummy mean anyway? I've been getting that for a few months.... back to the issue at hand. Restarted, no automatic update happened as normally does. Started a manual sync and got kicked back with another error. Here's that log set to info: https://www.dropbox.com/s/cdll3mfd3imh6kq/kodi2.log?dl=0 edit: Now on its own it seems to be continuing, flipping back and forth between boxsets and TV. Boxsets stays at 1 of xx and tv seems to be progressing. edit #2: after a couple more restarts it's asked me what version the db was created with, and finally seems to be completing a sync! Edited November 30, 2015 by bikesquid 1 Link to comment Share on other sites More sharing options...
Angelblue05 4130 Posted November 30, 2015 Share Posted November 30, 2015 (edited) The embydummy is to make masterlock work. The error is nothing to be worried about, as it's expected. It's just to force Kodi to acknowledge there's content in the database, since we don't add sources. Edit: I see something strange in your logs, checking it out right now. Edited November 30, 2015 by Angelblue05 Link to comment Share on other sites More sharing options...
SwanStream 59 Posted November 30, 2015 Share Posted November 30, 2015 @@Angelblue05 check the edits above, seems to have self resolved....I think. Link to comment Share on other sites More sharing options...
Angelblue05 4130 Posted November 30, 2015 Share Posted November 30, 2015 Ok keep me posted if you see otherwise. Link to comment Share on other sites More sharing options...
mobamoba 12 Posted December 1, 2015 Share Posted December 1, 2015 I've been getting this error a ton recently. I notice it mostly when Emby delete is offered, though I'm not sure if that's the cause or just an unrelated timing thing. Below is the chunk of my log before and after the error: 20:51:29 T:3144 NOTICE: Previous line repeats 6 times.20:51:29 T:3144 NOTICE: CDVDPlayerAudio::OutputPacket duplicate 1 packets of duration 2320:51:30 T:7844 NOTICE: DXVA::CDecoder::Close - closing decoder20:51:30 T:7844 NOTICE: DXVA::Close - closing decoder context20:51:30 T:7844 NOTICE: CDVDVideoCodecFFmpeg::GetFormat - Creating DXVA(1280x720)20:51:30 T:3144 NOTICE: CDVDPlayerAudio::OutputPacket skipping a packets of duration 2320:51:30 T:3144 NOTICE: Previous line repeats 6 times.20:51:30 T:3144 NOTICE: CDVDPlayerAudio::OutputPacket duplicate 1 packets of duration 2320:51:31 T:7844 NOTICE: DXVA::CDecoder::Close - closing decoder20:51:31 T:7844 NOTICE: DXVA::Close - closing decoder context20:51:31 T:7844 NOTICE: CDVDVideoCodecFFmpeg::GetFormat - Creating DXVA(1280x720)20:51:31 T:3144 NOTICE: CDVDPlayerAudio::OutputPacket skipping a packets of duration 2320:51:32 T:7844 NOTICE: Previous line repeats 1 times.20:51:32 T:7844 NOTICE: DXVA::CDecoder::Close - closing decoder20:51:32 T:7844 NOTICE: DXVA::Close - closing decoder context20:51:32 T:7844 NOTICE: CDVDVideoCodecFFmpeg::GetFormat - Creating DXVA(1280x720)20:51:32 T:3144 NOTICE: CDVDPlayerAudio::OutputPacket duplicate 1 packets of duration 2320:51:32 T:3144 NOTICE: CDVDPlayerAudio::OutputPacket skipping a packets of duration 2320:51:33 T:7844 NOTICE: Previous line repeats 6 times.20:51:33 T:7844 NOTICE: DXVA::CDecoder::Close - closing decoder20:51:33 T:7844 NOTICE: DXVA::Close - closing decoder context20:51:33 T:7844 NOTICE: CDVDVideoCodecFFmpeg::GetFormat - Creating DXVA(1280x720)20:51:33 T:3144 NOTICE: CDVDPlayerAudio::OutputPacket duplicate 1 packets of duration 2320:51:33 T:3144 NOTICE: CDVDPlayerAudio::OutputPacket skipping a packets of duration 2320:51:33 T:3144 NOTICE: Previous line repeats 7 times.20:51:33 T:3144 NOTICE: CDVDPlayerAudio::OutputPacket duplicate 1 packets of duration 2320:51:36 T:2748 NOTICE: CDVDPlayer::CloseFile()20:51:36 T:2748 NOTICE: DVDPlayer: waiting for threads to exit20:51:36 T:4832 NOTICE: CDVDPlayer::OnExit()20:51:36 T:4832 NOTICE: Closing stream player 120:51:36 T:4832 NOTICE: Waiting for audio thread to exit20:51:36 T:3144 NOTICE: thread end: CDVDPlayerAudio::OnExit()20:51:36 T:4832 NOTICE: Closing audio device20:51:36 T:4832 NOTICE: Deleting audio codec20:51:36 T:4832 NOTICE: Closing stream player 220:51:36 T:4832 NOTICE: waiting for video thread to exit20:51:36 T:7844 NOTICE: thread end: video_thread20:51:36 T:4832 NOTICE: deleting video codec20:51:36 T:4832 NOTICE: DXVA::CDecoder::Close - closing decoder20:51:36 T:4832 NOTICE: DXVA::Close - closing decoder context20:51:36 T:2748 NOTICE: DVDPlayer: finished waiting20:51:36 T:5796 NOTICE: Thread BackgroundLoader start, auto delete: false20:51:36 T:1932 NOTICE: Previous line repeats 1 times.20:51:36 T:1932 NOTICE: Thread LanguageInvoker start, auto delete: false20:51:36 T:5420 NOTICE: Thread JobWorker start, auto delete: true20:51:36 T:2748 NOTICE: CDVDPlayer::CloseFile()20:51:36 T:2748 NOTICE: DVDPlayer: waiting for threads to exit20:51:36 T:2748 NOTICE: DVDPlayer: finished waiting20:51:36 T:2748 NOTICE: CDVDPlayer::CloseFile()20:51:36 T:2748 NOTICE: DVDPlayer: waiting for threads to exit20:51:36 T:2748 NOTICE: DVDPlayer: finished waiting20:51:36 T:1932 NOTICE: -->Python Interpreter Initialized<--20:51:36 T:1932 NOTICE: duration script running20:51:37 T:6268 NOTICE: EMBY LibrarySync -> Doing LibraryChanged : Processing User Data Changed : [{u'ItemId': u'57833088dc79736bd7e723a35e821c75', u'IsFavorite': False, u'Played': True, u'LastPlayedDate': u'2015-12-01T01:23:51.6103807Z', u'PlaybackPositionTicks': 0, u'Key': u'57833088-dc79-736b-d7e7-23a35e821c75', u'PlayCount': 1}, {u'ItemId': u'cc50c586c8e784f915ca8a2b3d08a406', u'IsFavorite': False, u'Played': False, u'PlayedPercentage': 50, u'UnplayedItemCount': 1, u'PlaybackPositionTicks': 0, u'Key': u'74626012', u'PlayCount': 0}]20:51:37 T:4444 NOTICE: EMBY LibrarySync -> Sync Database, Incremental Sync Using Client Time -5 min: 2015-12-01T01:46:37Z20:51:37 T:4444 NOTICE: EMBY LibrarySync -> Sync Database, Incremental Sync Setting Last Run Time Saved: 2015-12-01T01:46:37Z20:51:37 T:5420 NOTICE: VideoInfoScanner: Starting scan ..20:51:37 T:5420 NOTICE: VideoInfoScanner: Finished scan. Scanning for video info took 00:0020:51:37 T:4936 NOTICE: Thread BackgroundLoader start, auto delete: false20:51:39 T:3824 NOTICE: Previous line repeats 1 times.20:51:39 T:3824 NOTICE: Thread LanguageInvoker start, auto delete: false20:51:39 T:3824 NOTICE: -->Python Interpreter Initialized<--20:51:40 T:3824 NOTICE: plugin.video.emby started20:51:40 T:3824 NOTICE: Parameter string: ?filename=24 - Quarter-Final Results.mp4&id=ceedb044b31e011677572f1d81552b9a&mode=play20:51:40 T:3824 NOTICE: plugin.video.emby stopped20:51:40 T:2748 NOTICE: DVDPlayer: Opening: R:\Recorded TV\Sorted\The X Factor\Season 12\24 - Quarter-Final Results.mp420:51:40 T:2748 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED20:51:40 T:3128 NOTICE: Thread DVDPlayer start, auto delete: false20:51:40 T:3128 NOTICE: Creating InputStream20:51:40 T:3128 NOTICE: Creating Demuxer20:51:40 T:3128 NOTICE: Opening stream: 0 source: 25620:51:40 T:3128 NOTICE: Creating video codec with codec id: 2820:51:40 T:3128 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: H.264 / AVC / MPEG-4 AVC / MPEG-4 part 1020:51:40 T:3128 NOTICE: Creating video thread20:51:40 T:3128 NOTICE: Opening stream: 1 source: 25620:51:40 T:3128 NOTICE: Finding audio codec for: 8601820:51:40 T:5524 NOTICE: Thread DVDPlayerVideo start, auto delete: false20:51:40 T:5524 NOTICE: running thread: video_thread20:51:40 T:3128 NOTICE: Creating audio thread20:51:40 T:3560 NOTICE: Thread DVDPlayerAudio start, auto delete: false20:51:40 T:3560 NOTICE: running thread: CDVDPlayerAudio::Process()20:51:40 T:3560 NOTICE: Creating audio stream (codec id: 86018, channels: 2, sample rate: 44100, no pass-through)20:51:40 T:5524 NOTICE: CDVDVideoCodecFFmpeg::GetFormat - Creating DXVA(1280x720)20:51:40 T:5524 NOTICE: fps: 29.970030, pwidth: 1280, pheight: 720, dwidth: 1280, dheight: 72020:51:40 T:5524 NOTICE: Display resolution DESKTOP : 1842x1036@ 60.00 - Full Screen (16)20:51:40 T:5524 NOTICE: D3D: rendering method forced to DXVA processor20:51:40 T:2748 WARNING: CWinRenderer::UpdateVideoFilter - chosen scaling method 1 is not supported by renderer20:51:40 T:3560 NOTICE: CDVDPlayerAudio::OutputPacket skipping a packets of duration 2320:51:41 T:6268 NOTICE: Previous line repeats 4 times.20:51:41 T:6268 NOTICE: EMBY LibrarySync -> Doing LibraryChanged : Processing User Data Changed : [{u'ItemId': u'57833088dc79736bd7e723a35e821c75', u'IsFavorite': False, u'Played': True, u'LastPlayedDate': u'2015-12-01T01:23:51.6103807Z', u'PlaybackPositionTicks': 0, u'Key': u'57833088-dc79-736b-d7e7-23a35e821c75', u'PlayCount': 1}, {u'ItemId': u'cc50c586c8e784f915ca8a2b3d08a406', u'IsFavorite': False, u'Played': False, u'PlayedPercentage': 50, u'UnplayedItemCount': 1, u'PlaybackPositionTicks': 0, u'Key': u'74626012', u'PlayCount': 0}]20:51:46 T:3128 ERROR: CDVDMsgGeneralSynchronize - timeout20:51:46 T:5524 NOTICE: DXVA::CDecoder::Close - closing decoder20:51:46 T:5524 NOTICE: DXVA::Close - closing decoder context20:51:46 T:5524 NOTICE: CDVDVideoCodecFFmpeg::GetFormat - Creating DXVA(1280x720)20:51:46 T:3560 NOTICE: CDVDPlayerAudio::OutputPacket skipping a packets of duration 2320:51:48 T:7060 NOTICE: Previous line repeats 1 times.20:51:48 T:7060 ERROR: EXCEPTION Thrown (PythonToCppException) : -->Python callback/script returned the following error<-- - NOTE: IGNORING THIS CAN LEAD TO MEMORY LEAKS! Error Type: <class 'sqlite3.OperationalError'> Error Contents: database is locked Traceback (most recent call last): File "C:\Users\Matt\AppData\Roaming\Kodi\addons\plugin.video.emby\resources\lib\Player.py", line 51, in onPlayBackStarted self.stopAll() File "C:\Users\Matt\AppData\Roaming\Kodi\addons\plugin.video.emby\resources\lib\Player.py", line 413, in stopAll LibrarySync().removefromDB(listItem, True) File "C:\Users\Matt\AppData\Roaming\Kodi\addons\plugin.video.emby\resources\lib\LibrarySync.py", line 860, in removefromDB WriteKodiVideoDB().deleteItemFromKodiLibrary(item, connection, cursor) File "C:\Users\Matt\AppData\Roaming\Kodi\addons\plugin.video.emby\resources\lib\WriteKodiVideoDB.py", line 769, in deleteItemFromKodiLibrary cursor.execute("DELETE FROM episode WHERE idEpisode = ?", (kodi_id,)) OperationalError: database is locked -->End of Python script error report<--20:51:53 T:6268 NOTICE: EMBY LibrarySync -> Doing LibraryChanged : Processing Deleted : [u'57833088dc79736bd7e723a35e821c75']20:51:53 T:4444 ERROR: Exception in thread Thread-32: Traceback (most recent call last): File "C:\Program Files (x86)\Kodi\system\python\Lib\threading.py", line 810, in __bootstrap_inner self.run() File "C:\Users\Matt\AppData\Roaming\Kodi\addons\plugin.video.emby\resources\lib\LibrarySync.py", line 1059, in run self.run_internal() File "C:\Users\Matt\AppData\Roaming\Kodi\addons\plugin.video.emby\resources\lib\LibrarySync.py", line 1153, in run_internal self.setUserdata(listItems) File "C:\Users\Matt\AppData\Roaming\Kodi\addons\plugin.video.emby\resources\lib\LibrarySync.py", line 962, in setUserdata WriteKodiVideoDB().updateUserdata(userdata, connection, cursor) File "C:\Users\Matt\AppData\Roaming\Kodi\addons\plugin.video.emby\resources\lib\WriteKodiVideoDB.py", line 1327, in updateUserdata self.setKodiResumePoint(fileid, resume, total, cursor, playcount, dateplayed) File "C:\Users\Matt\AppData\Roaming\Kodi\addons\plugin.video.emby\resources\lib\WriteKodiVideoDB.py", line 857, in setKodiResumePoint cursor.execute("DELETE FROM bookmark WHERE idFile = ?", (fileid,)) OperationalError: database is locked20:52:01 T:5524 NOTICE: DXVA::CDecoder::Close - closing decoder20:52:01 T:5524 NOTICE: DXVA::Close - closing decoder context20:52:01 T:5524 NOTICE: CDVDVideoCodecFFmpeg::GetFormat - Creating DXVA(1280x720)20:52:02 T:3560 NOTICE: CDVDPlayerAudio::OutputPacket skipping a packets of duration 2320:52:02 T:3560 NOTICE: Previous line repeats 6 times.20:52:02 T:3560 NOTICE: CDVDPlayerAudio::OutputPacket duplicate 1 packets of duration 2320:52:02 T:5524 NOTICE: DXVA::CDecoder::Close - closing decoder20:52:02 T:5524 NOTICE: DXVA::Close - closing decoder context20:52:02 T:5524 NOTICE: CDVDVideoCodecFFmpeg::GetFormat - Creating DXVA(1280x720)20:52:02 T:3560 NOTICE: CDVDPlayerAudio::OutputPacket skipping a packets of duration 2320:52:02 T:3560 NOTICE: Previous line repeats 6 times.20:52:02 T:3560 NOTICE: CDVDPlayerAudio::OutputPacket duplicate 1 packets of duration 2320:52:03 T:5524 NOTICE: DXVA::CDecoder::Close - closing decoder20:52:03 T:5524 NOTICE: DXVA::Close - closing decoder context20:52:03 T:5524 NOTICE: CDVDVideoCodecFFmpeg::GetFormat - Creating DXVA(1280x720)20:52:03 T:3560 NOTICE: CDVDPlayerAudio::OutputPacket skipping a packets of duration 2320:52:04 T:5524 NOTICE: Previous line repeats 1 times.20:52:04 T:5524 NOTICE: DXVA::CDecoder::Close - closing decoder20:52:04 T:5524 NOTICE: DXVA::Close - closing decoder context20:52:04 T:5524 NOTICE: CDVDVideoCodecFFmpeg::GetFormat - Creating DXVA(1280x720)20:52:04 T:3560 NOTICE: CDVDPlayerAudio::OutputPacket skipping a packets of duration 2320:52:04 T:3560 NOTICE: Previous line repeats 6 times.20:52:04 T:3560 NOTICE: CDVDPlayerAudio::OutputPacket duplicate 1 packets of duration 2320:52:06 T:5524 NOTICE: DXVA::CDecoder::Close - closing decoder20:52:06 T:5524 NOTICE: DXVA::Close - closing decoder context20:52:06 T:5524 NOTICE: CDVDVideoCodecFFmpeg::GetFormat - Creating DXVA(1280x720)20:52:06 T:3560 NOTICE: CDVDPlayerAudio::OutputPacket skipping a packets of duration 2320:52:06 T:3560 NOTICE: Previous line repeats 7 times.20:52:06 T:3560 NOTICE: CDVDPlayerAudio::OutputPacket duplicate 1 packets of duration 2320:52:07 T:5524 NOTICE: DXVA::CDecoder::Close - closing decoder20:52:07 T:5524 NOTICE: DXVA::Close - closing decoder context20:52:07 T:5524 NOTICE: CDVDVideoCodecFFmpeg::GetFormat - Creating DXVA(1280x720)20:52:07 T:3560 NOTICE: CDVDPlayerAudio::OutputPacket skipping a packets of duration 2320:52:08 T:5524 NOTICE: Previous line repeats 1 times.20:52:08 T:5524 NOTICE: DXVA::CDecoder::Close - closing decoder20:52:08 T:5524 NOTICE: DXVA::Close - closing decoder context20:52:08 T:5524 NOTICE: CDVDVideoCodecFFmpeg::GetFormat - Creating DXVA(1280x720)20:52:08 T:3560 NOTICE: CDVDPlayerAudio::OutputPacket duplicate 1 packets of duration 23 1 Link to comment Share on other sites More sharing options...
Angelblue05 4130 Posted December 1, 2015 Share Posted December 1, 2015 (edited) Ok, thanks for the information. Edit: Ok, I think I found the problem. I will be making a build soon. Thanks for your patience. Edited December 1, 2015 by Angelblue05 Link to comment Share on other sites More sharing options...
mobamoba 12 Posted December 1, 2015 Share Posted December 1, 2015 I see you're working on a fix, but here's another log of this error in case it helps; I wasn't even using Kodi at the time (it was minimized on my system): 09:20:09 T:3276 NOTICE: Previous line repeats 4 times.09:20:09 T:3276 NOTICE: Thread BackgroundLoader start, auto delete: false09:20:09 T:6444 NOTICE: Previous line repeats 1 times.09:20:09 T:6444 NOTICE: Thread LanguageInvoker start, auto delete: false09:20:09 T:7144 NOTICE: Thread JobWorker start, auto delete: true09:20:09 T:6444 NOTICE: -->Python Interpreter Initialized<--09:20:09 T:6444 NOTICE: duration script running10:29:01 T:3684 NOTICE: EMBY LibrarySync -> Doing LibraryChanged : Processing Added and Updated : [u'7adc9608d9707b21e21d186705adee08', u'19b5ff044ce1933bd1af13c4d876a2d5', u'ccd5d614edea257cd3a8715e01cb4522', u'f21b45f1f13d692d8234b0a4a9c5b5dc', u'48b4200cbd721d7b804fe565630f5065', u'65e91141a57670dee86738dd626f0673', u'177bd314e6500eada1e9a26a8ba58fd0', u'bece7b1d1f3f0eb95772ab6c69ec0e89', u'917cf61d9ee9a03435fcb1a1e631bb8f', u'171bab205baae635afc9b8fcc2867ed2', u'f1f10b21a15ff0064e8fffb3124b2548']10:29:07 T:3684 NOTICE: EMBY LibrarySync -> Doing LibraryChanged : Processing Added and Updated : [u'fe0509234c8232477dcb95f55417869b']10:29:18 T:3684 NOTICE: EMBY LibrarySync -> Doing LibraryChanged : Processing Added and Updated : [u'43349e57e195d78659494e69f52c2eac', u'6c7712666ccac1b04433756b9420d301', u'dd6408ef94338815f7f7f66b1afd7668', u'410145a1b34f63937f36d0794d614cba', u'7cb62a4bce604bdfa33ba691d86f0536', u'6c3a49a93d9fe8074e9e0913f156eefc', u'1779f44c6f868fc3941ce93dd9265bcf']10:29:33 T:3684 NOTICE: EMBY LibrarySync -> Doing LibraryChanged : Processing Added and Updated : [u'234d935e7a935def3d81d74c76a35504', u'8f4857688b41f4b15ea623020011bef1', u'f0e3fc9190ed0067bc4547928548b605', u'f97bf3698de513fb140f29074bd9f419', u'faf89f5b2bdf3107c81422f505c9a1ca', u'5d38f6e9b7a77f9068ca21f957b74128']10:29:49 T:3684 NOTICE: EMBY LibrarySync -> Doing LibraryChanged : Processing Added and Updated : [u'a7300394c265e38288add365ad51c588', u'9d46b39b32d19fe7ebb040bb165e4aac', u'23e011abc05e4f1baad7786f59d5e199', u'830c24522a73a8cd9ffd30428a0835be', u'10cd47a4ba2940134dc1bc522403d8d3', u'd3514caf078026e8ee8b95e89a44f5f7', u'39f55abe56d66fffc951265cf600186d']10:29:58 T:3684 NOTICE: EMBY LibrarySync -> Doing LibraryChanged : Processing Added and Updated : [u'b299acc6ad7626d90a72434c256acee6', u'b88516cb60385c0dd508db05667bdab3']10:30:16 T:3684 NOTICE: EMBY LibrarySync -> Doing LibraryChanged : Processing Added and Updated : [u'7505dd244e5a42e68775fdcd388e2a64', u'abd7b9795d3ccb4f76e316da1048c56e', u'8713dae63b8a105fb7cd444226d06902', u'174a70e88dcabffe7d7672e46787f903']10:30:23 T:3684 NOTICE: EMBY LibrarySync -> Doing LibraryChanged : Processing Added and Updated : [u'c6336cbd85f99141a965c8652ce9690e', u'5f1096f7c187a573d458cfc0c3e5689e']10:31:04 T:3684 NOTICE: EMBY LibrarySync -> Doing LibraryChanged : Processing Added and Updated : [u'e30c773ba77524aa494c02836cfa5272']10:32:46 T:3684 NOTICE: EMBY LibrarySync -> Doing LibraryChanged : Processing Added and Updated : [u'0538054f382b84c9dc61a41593c779ea']10:33:00 T:3684 NOTICE: EMBY LibrarySync -> Doing LibraryChanged : Processing Added and Updated : [u'b1295e7c483ec72768b09d528bcc3b5f', u'c824b2d5c217f5f3a95c0e6edb9c3483', u'6aeae897cbe65997397c740fdaec8c31', u'bca7a167e23bcacd1cd42109f8192dac']10:33:40 T:3684 NOTICE: EMBY LibrarySync -> Doing LibraryChanged : Processing Added and Updated : [u'a7300394c265e38288add365ad51c588', u'8713dae63b8a105fb7cd444226d06902', u'b299acc6ad7626d90a72434c256acee6', u'fe0509234c8232477dcb95f55417869b', u'917cf61d9ee9a03435fcb1a1e631bb8f', u'19b5ff044ce1933bd1af13c4d876a2d5', u'48b4200cbd721d7b804fe565630f5065', u'177bd314e6500eada1e9a26a8ba58fd0', u'bece7b1d1f3f0eb95772ab6c69ec0e89', u'171bab205baae635afc9b8fcc2867ed2', u'f1f10b21a15ff0064e8fffb3124b2548', u'1779f44c6f868fc3941ce93dd9265bcf', u'234d935e7a935def3d81d74c76a35504', u'8f4857688b41f4b15ea623020011bef1', u'f97bf3698de513fb140f29074bd9f419', u'9d46b39b32d19fe7ebb040bb165e4aac', u'23e011abc05e4f1baad7786f59d5e199', u'39f55abe56d66fffc951265cf600186d', u'b88516cb60385c0dd508db05667bdab3', u'174a70e88dcabffe7d7672e46787f903', u'5f1096f7c187a573d458cfc0c3e5689e', u'7adc9608d9707b21e21d186705adee08', u'ccd5d614edea257cd3a8715e01cb4522', u'f21b45f1f13d692d8234b0a4a9c5b5dc', u'65e91141a57670dee86738dd626f0673']10:33:46 T:3684 NOTICE: EMBY LibrarySync -> Doing LibraryChanged : Processing Added and Updated : [u'fe0509234c8232477dcb95f55417869b']10:33:57 T:3684 NOTICE: EMBY LibrarySync -> Doing LibraryChanged : Processing Added and Updated : [u'43349e57e195d78659494e69f52c2eac', u'6c7712666ccac1b04433756b9420d301', u'dd6408ef94338815f7f7f66b1afd7668', u'410145a1b34f63937f36d0794d614cba', u'7cb62a4bce604bdfa33ba691d86f0536', u'6c3a49a93d9fe8074e9e0913f156eefc', u'1779f44c6f868fc3941ce93dd9265bcf']10:34:13 T:3684 NOTICE: EMBY LibrarySync -> Doing LibraryChanged : Processing Added and Updated : [u'234d935e7a935def3d81d74c76a35504', u'8f4857688b41f4b15ea623020011bef1', u'f0e3fc9190ed0067bc4547928548b605', u'f97bf3698de513fb140f29074bd9f419', u'faf89f5b2bdf3107c81422f505c9a1ca', u'5d38f6e9b7a77f9068ca21f957b74128']10:34:29 T:3684 NOTICE: EMBY LibrarySync -> Doing LibraryChanged : Processing Added and Updated : [u'a7300394c265e38288add365ad51c588', u'9d46b39b32d19fe7ebb040bb165e4aac', u'23e011abc05e4f1baad7786f59d5e199', u'830c24522a73a8cd9ffd30428a0835be', u'10cd47a4ba2940134dc1bc522403d8d3', u'd3514caf078026e8ee8b95e89a44f5f7', u'39f55abe56d66fffc951265cf600186d']10:34:39 T:3684 NOTICE: EMBY LibrarySync -> Doing LibraryChanged : Processing Added and Updated : [u'b299acc6ad7626d90a72434c256acee6', u'b88516cb60385c0dd508db05667bdab3']10:34:56 T:3684 NOTICE: EMBY LibrarySync -> Doing LibraryChanged : Processing Added and Updated : [u'7505dd244e5a42e68775fdcd388e2a64', u'abd7b9795d3ccb4f76e316da1048c56e', u'8713dae63b8a105fb7cd444226d06902', u'174a70e88dcabffe7d7672e46787f903']10:35:03 T:3684 NOTICE: EMBY LibrarySync -> Doing LibraryChanged : Processing Added and Updated : [u'c6336cbd85f99141a965c8652ce9690e', u'5f1096f7c187a573d458cfc0c3e5689e']10:35:42 T:3684 NOTICE: EMBY LibrarySync -> Doing LibraryChanged : Processing Added and Updated : [u'e30c773ba77524aa494c02836cfa5272']10:37:30 T:3684 NOTICE: EMBY LibrarySync -> Doing LibraryChanged : Processing Added and Updated : [u'0538054f382b84c9dc61a41593c779ea']10:38:11 T:3684 NOTICE: EMBY LibrarySync -> Doing LibraryChanged : Processing Added and Updated : [u'b1295e7c483ec72768b09d528bcc3b5f', u'c824b2d5c217f5f3a95c0e6edb9c3483', u'6aeae897cbe65997397c740fdaec8c31', u'bca7a167e23bcacd1cd42109f8192dac', u'a7300394c265e38288add365ad51c588', u'8713dae63b8a105fb7cd444226d06902', u'b299acc6ad7626d90a72434c256acee6', u'fe0509234c8232477dcb95f55417869b', u'917cf61d9ee9a03435fcb1a1e631bb8f', u'19b5ff044ce1933bd1af13c4d876a2d5', u'48b4200cbd721d7b804fe565630f5065', u'177bd314e6500eada1e9a26a8ba58fd0', u'bece7b1d1f3f0eb95772ab6c69ec0e89', u'171bab205baae635afc9b8fcc2867ed2', u'f1f10b21a15ff0064e8fffb3124b2548', u'1779f44c6f868fc3941ce93dd9265bcf', u'234d935e7a935def3d81d74c76a35504', u'8f4857688b41f4b15ea623020011bef1', u'f97bf3698de513fb140f29074bd9f419', u'9d46b39b32d19fe7ebb040bb165e4aac', u'23e011abc05e4f1baad7786f59d5e199', u'39f55abe56d66fffc951265cf600186d', u'b88516cb60385c0dd508db05667bdab3', u'174a70e88dcabffe7d7672e46787f903', u'5f1096f7c187a573d458cfc0c3e5689e', u'7adc9608d9707b21e21d186705adee08', u'ccd5d614edea257cd3a8715e01cb4522', u'f21b45f1f13d692d8234b0a4a9c5b5dc', u'65e91141a57670dee86738dd626f0673']10:38:17 T:3684 NOTICE: EMBY LibrarySync -> Doing LibraryChanged : Processing Added and Updated : [u'fe0509234c8232477dcb95f55417869b']10:38:28 T:3684 NOTICE: EMBY LibrarySync -> Doing LibraryChanged : Processing Added and Updated : [u'43349e57e195d78659494e69f52c2eac', u'6c7712666ccac1b04433756b9420d301', u'dd6408ef94338815f7f7f66b1afd7668', u'410145a1b34f63937f36d0794d614cba', u'7cb62a4bce604bdfa33ba691d86f0536', u'6c3a49a93d9fe8074e9e0913f156eefc', u'1779f44c6f868fc3941ce93dd9265bcf']10:38:44 T:3684 NOTICE: EMBY LibrarySync -> Doing LibraryChanged : Processing Added and Updated : [u'234d935e7a935def3d81d74c76a35504', u'8f4857688b41f4b15ea623020011bef1', u'f0e3fc9190ed0067bc4547928548b605', u'f97bf3698de513fb140f29074bd9f419', u'faf89f5b2bdf3107c81422f505c9a1ca', u'5d38f6e9b7a77f9068ca21f957b74128']10:39:00 T:3684 NOTICE: EMBY LibrarySync -> Doing LibraryChanged : Processing Added and Updated : [u'a7300394c265e38288add365ad51c588', u'9d46b39b32d19fe7ebb040bb165e4aac', u'23e011abc05e4f1baad7786f59d5e199', u'830c24522a73a8cd9ffd30428a0835be', u'10cd47a4ba2940134dc1bc522403d8d3', u'd3514caf078026e8ee8b95e89a44f5f7', u'39f55abe56d66fffc951265cf600186d']10:39:09 T:3684 NOTICE: EMBY LibrarySync -> Doing LibraryChanged : Processing Added and Updated : [u'b299acc6ad7626d90a72434c256acee6', u'b88516cb60385c0dd508db05667bdab3']10:39:26 T:3684 NOTICE: EMBY LibrarySync -> Doing LibraryChanged : Processing Added and Updated : [u'7505dd244e5a42e68775fdcd388e2a64', u'abd7b9795d3ccb4f76e316da1048c56e', u'8713dae63b8a105fb7cd444226d06902', u'174a70e88dcabffe7d7672e46787f903']10:39:33 T:3684 NOTICE: EMBY LibrarySync -> Doing LibraryChanged : Processing Added and Updated : [u'c6336cbd85f99141a965c8652ce9690e', u'5f1096f7c187a573d458cfc0c3e5689e']10:40:13 T:3684 NOTICE: EMBY LibrarySync -> Doing LibraryChanged : Processing Added and Updated : [u'e30c773ba77524aa494c02836cfa5272']10:42:04 T:3684 NOTICE: EMBY LibrarySync -> Doing LibraryChanged : Processing Added and Updated : [u'0538054f382b84c9dc61a41593c779ea']10:42:19 T:3684 NOTICE: EMBY LibrarySync -> Doing LibraryChanged : Processing Added and Updated : [u'b1295e7c483ec72768b09d528bcc3b5f', u'c824b2d5c217f5f3a95c0e6edb9c3483', u'6aeae897cbe65997397c740fdaec8c31', u'bca7a167e23bcacd1cd42109f8192dac', u'a7300394c265e38288add365ad51c588', u'8713dae63b8a105fb7cd444226d06902', u'b299acc6ad7626d90a72434c256acee6', u'fe0509234c8232477dcb95f55417869b', u'917cf61d9ee9a03435fcb1a1e631bb8f', u'19b5ff044ce1933bd1af13c4d876a2d5', u'48b4200cbd721d7b804fe565630f5065', u'177bd314e6500eada1e9a26a8ba58fd0', u'bece7b1d1f3f0eb95772ab6c69ec0e89', u'171bab205baae635afc9b8fcc2867ed2', u'f1f10b21a15ff0064e8fffb3124b2548', u'1779f44c6f868fc3941ce93dd9265bcf', u'234d935e7a935def3d81d74c76a35504', u'8f4857688b41f4b15ea623020011bef1', u'f97bf3698de513fb140f29074bd9f419', u'9d46b39b32d19fe7ebb040bb165e4aac', u'23e011abc05e4f1baad7786f59d5e199', u'39f55abe56d66fffc951265cf600186d', u'b88516cb60385c0dd508db05667bdab3', u'174a70e88dcabffe7d7672e46787f903', u'5f1096f7c187a573d458cfc0c3e5689e']11:05:35 T:7724 NOTICE: Thread JobWorker start, auto delete: true11:05:39 T:7472 NOTICE: Previous line repeats 1 times.11:05:39 T:7472 ERROR: Exception in thread Thread-71: Traceback (most recent call last): File "C:\Program Files (x86)\Kodi\system\python\Lib\threading.py", line 810, in __bootstrap_inner self.run() File "C:\Users\Matt\AppData\Roaming\Kodi\addons\plugin.video.emby\resources\lib\LibrarySync.py", line 1059, in run self.run_internal() File "C:\Users\Matt\AppData\Roaming\Kodi\addons\plugin.video.emby\resources\lib\LibrarySync.py", line 1144, in run_internal self.IncrementalSync(listItems) File "C:\Users\Matt\AppData\Roaming\Kodi\addons\plugin.video.emby\resources\lib\LibrarySync.py", line 775, in IncrementalSync WriteKodiMusicDB().addOrUpdateAlbumToKodiLibrary(MBitem, connection, cursor) File "C:\Users\Matt\AppData\Roaming\Kodi\addons\plugin.video.emby\resources\lib\WriteKodiMusicDB.py", line 177, in addOrUpdateAlbumToKodiLibrary cursor.execute(query, (name, musicBrainzId, artists, year, genre, bio, thumb, lastScraped, dateadded, "album", albumid)) IntegrityError: UNIQUE constraint failed: album.strMusicBrainzAlbumID Link to comment Share on other sites More sharing options...
Angelblue05 4130 Posted December 1, 2015 Share Posted December 1, 2015 Your issue is a bit different. The error comes from Kodi already having an item with the same musicbrainz Id you are trying to update the album with. You can either reset your database, that should fix it. Or disable the music library in the add-on settings until I make the fix announcement. Sent from my iPhone using Tapatalk Link to comment Share on other sites More sharing options...
Recommended Posts