Jump to content

Library Sync Crashed, report on the forum

treason

By treason
in Kodi

 Share

Recommended Posts

xnappo

xnappo   1593

Posted
Posted

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

  • Like 1
Link to comment
Share on other sites
Angelblue05

Angelblue05   4130

Posted
Posted

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
treason

treason   11

Posted
  • Author
Posted

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
Angelblue05

Angelblue05   4130

Posted
Posted (edited)

Ok, for now you can disable the music library in the add-on settings. I'm still looking into this.

Edited by Angelblue05
Link to comment
Share on other sites
SwanStream

SwanStream   59

Posted
Posted

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
xnappo

xnappo   1593

Posted
Posted (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 by xnappo
Link to comment
Share on other sites
SwanStream

SwanStream   59

Posted
Posted

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
Angelblue05

Angelblue05   4130

Posted
Posted (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 by Angelblue05
Link to comment
Share on other sites
SwanStream

SwanStream   59

Posted
Posted

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
Angelblue05

Angelblue05   4130

Posted
Posted

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
SwanStream

SwanStream   59

Posted
Posted (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 by bikesquid
  • Like 1
Link to comment
Share on other sites
Angelblue05

Angelblue05   4130

Posted
Posted (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 by Angelblue05
Link to comment
Share on other sites
mobamoba

mobamoba   12

Posted
Posted

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 23
20:51:30 T:7844  NOTICE: DXVA::CDecoder::Close - closing decoder
20:51:30 T:7844  NOTICE: DXVA::Close - closing decoder context
20:51:30 T:7844  NOTICE: CDVDVideoCodecFFmpeg::GetFormat - Creating DXVA(1280x720)
20:51:30 T:3144  NOTICE: CDVDPlayerAudio::OutputPacket skipping a packets of duration 23
20:51:30 T:3144  NOTICE: Previous line repeats 6 times.
20:51:30 T:3144  NOTICE: CDVDPlayerAudio::OutputPacket duplicate 1 packets of duration 23
20:51:31 T:7844  NOTICE: DXVA::CDecoder::Close - closing decoder
20:51:31 T:7844  NOTICE: DXVA::Close - closing decoder context
20:51:31 T:7844  NOTICE: CDVDVideoCodecFFmpeg::GetFormat - Creating DXVA(1280x720)
20:51:31 T:3144  NOTICE: CDVDPlayerAudio::OutputPacket skipping a packets of duration 23
20:51:32 T:7844  NOTICE: Previous line repeats 1 times.
20:51:32 T:7844  NOTICE: DXVA::CDecoder::Close - closing decoder
20:51:32 T:7844  NOTICE: DXVA::Close - closing decoder context
20:51:32 T:7844  NOTICE: CDVDVideoCodecFFmpeg::GetFormat - Creating DXVA(1280x720)
20:51:32 T:3144  NOTICE: CDVDPlayerAudio::OutputPacket duplicate 1 packets of duration 23
20:51:32 T:3144  NOTICE: CDVDPlayerAudio::OutputPacket skipping a packets of duration 23
20:51:33 T:7844  NOTICE: Previous line repeats 6 times.
20:51:33 T:7844  NOTICE: DXVA::CDecoder::Close - closing decoder
20:51:33 T:7844  NOTICE: DXVA::Close - closing decoder context
20:51:33 T:7844  NOTICE: CDVDVideoCodecFFmpeg::GetFormat - Creating DXVA(1280x720)
20:51:33 T:3144  NOTICE: CDVDPlayerAudio::OutputPacket duplicate 1 packets of duration 23
20:51:33 T:3144  NOTICE: CDVDPlayerAudio::OutputPacket skipping a packets of duration 23
20:51:33 T:3144  NOTICE: Previous line repeats 7 times.
20:51:33 T:3144  NOTICE: CDVDPlayerAudio::OutputPacket duplicate 1 packets of duration 23
20:51:36 T:2748  NOTICE: CDVDPlayer::CloseFile()
20:51:36 T:2748  NOTICE: DVDPlayer: waiting for threads to exit
20:51:36 T:4832  NOTICE: CDVDPlayer::OnExit()
20:51:36 T:4832  NOTICE: Closing stream player 1
20:51:36 T:4832  NOTICE: Waiting for audio thread to exit
20:51:36 T:3144  NOTICE: thread end: CDVDPlayerAudio::OnExit()
20:51:36 T:4832  NOTICE: Closing audio device
20:51:36 T:4832  NOTICE: Deleting audio codec
20:51:36 T:4832  NOTICE: Closing stream player 2
20:51:36 T:4832  NOTICE: waiting for video thread to exit
20:51:36 T:7844  NOTICE: thread end: video_thread
20:51:36 T:4832  NOTICE: deleting video codec
20:51:36 T:4832  NOTICE: DXVA::CDecoder::Close - closing decoder
20:51:36 T:4832  NOTICE: DXVA::Close - closing decoder context
20:51:36 T:2748  NOTICE: DVDPlayer: finished waiting
20:51:36 T:5796  NOTICE: Thread BackgroundLoader start, auto delete: false
20:51:36 T:1932  NOTICE: Previous line repeats 1 times.
20:51:36 T:1932  NOTICE: Thread LanguageInvoker start, auto delete: false
20:51:36 T:5420  NOTICE: Thread JobWorker start, auto delete: true
20:51:36 T:2748  NOTICE: CDVDPlayer::CloseFile()
20:51:36 T:2748  NOTICE: DVDPlayer: waiting for threads to exit
20:51:36 T:2748  NOTICE: DVDPlayer: finished waiting
20:51:36 T:2748  NOTICE: CDVDPlayer::CloseFile()
20:51:36 T:2748  NOTICE: DVDPlayer: waiting for threads to exit
20:51:36 T:2748  NOTICE: DVDPlayer: finished waiting
20:51:36 T:1932  NOTICE: -->Python Interpreter Initialized<--
20:51:36 T:1932  NOTICE: duration script running
20: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:37Z
20:51:37 T:4444  NOTICE: EMBY LibrarySync -> Sync Database, Incremental Sync Setting Last Run Time Saved: 2015-12-01T01:46:37Z
20:51:37 T:5420  NOTICE: VideoInfoScanner: Starting scan ..
20:51:37 T:5420  NOTICE: VideoInfoScanner: Finished scan. Scanning for video info took 00:00
20:51:37 T:4936  NOTICE: Thread BackgroundLoader start, auto delete: false
20:51:39 T:3824  NOTICE: Previous line repeats 1 times.
20:51:39 T:3824  NOTICE: Thread LanguageInvoker start, auto delete: false
20:51:39 T:3824  NOTICE: -->Python Interpreter Initialized<--
20:51:40 T:3824  NOTICE: plugin.video.emby started
20:51:40 T:3824  NOTICE: Parameter string: ?filename=24 - Quarter-Final Results.mp4&id=ceedb044b31e011677572f1d81552b9a&mode=play
20:51:40 T:3824  NOTICE: plugin.video.emby stopped
20:51:40 T:2748  NOTICE: DVDPlayer: Opening: R:\Recorded TV\Sorted\The X Factor\Season 12\24 - Quarter-Final Results.mp4
20:51:40 T:2748 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
20:51:40 T:3128  NOTICE: Thread DVDPlayer start, auto delete: false
20:51:40 T:3128  NOTICE: Creating InputStream
20:51:40 T:3128  NOTICE: Creating Demuxer
20:51:40 T:3128  NOTICE: Opening stream: 0 source: 256
20:51:40 T:3128  NOTICE: Creating video codec with codec id: 28
20:51:40 T:3128  NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10
20:51:40 T:3128  NOTICE: Creating video thread
20:51:40 T:3128  NOTICE: Opening stream: 1 source: 256
20:51:40 T:3128  NOTICE: Finding audio codec for: 86018
20:51:40 T:5524  NOTICE: Thread DVDPlayerVideo start, auto delete: false
20:51:40 T:5524  NOTICE: running thread: video_thread
20:51:40 T:3128  NOTICE: Creating audio thread
20:51:40 T:3560  NOTICE: Thread DVDPlayerAudio start, auto delete: false
20: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: 720
20: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 processor
20:51:40 T:2748 WARNING: CWinRenderer::UpdateVideoFilter - chosen scaling method 1 is not supported by renderer
20:51:40 T:3560  NOTICE: CDVDPlayerAudio::OutputPacket skipping a packets of duration 23
20: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 - timeout
20:51:46 T:5524  NOTICE: DXVA::CDecoder::Close - closing decoder
20:51:46 T:5524  NOTICE: DXVA::Close - closing decoder context
20:51:46 T:5524  NOTICE: CDVDVideoCodecFFmpeg::GetFormat - Creating DXVA(1280x720)
20:51:46 T:3560  NOTICE: CDVDPlayerAudio::OutputPacket skipping a packets of duration 23
20: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 locked
20:52:01 T:5524  NOTICE: DXVA::CDecoder::Close - closing decoder
20:52:01 T:5524  NOTICE: DXVA::Close - closing decoder context
20:52:01 T:5524  NOTICE: CDVDVideoCodecFFmpeg::GetFormat - Creating DXVA(1280x720)
20:52:02 T:3560  NOTICE: CDVDPlayerAudio::OutputPacket skipping a packets of duration 23
20:52:02 T:3560  NOTICE: Previous line repeats 6 times.
20:52:02 T:3560  NOTICE: CDVDPlayerAudio::OutputPacket duplicate 1 packets of duration 23
20:52:02 T:5524  NOTICE: DXVA::CDecoder::Close - closing decoder
20:52:02 T:5524  NOTICE: DXVA::Close - closing decoder context
20:52:02 T:5524  NOTICE: CDVDVideoCodecFFmpeg::GetFormat - Creating DXVA(1280x720)
20:52:02 T:3560  NOTICE: CDVDPlayerAudio::OutputPacket skipping a packets of duration 23
20:52:02 T:3560  NOTICE: Previous line repeats 6 times.
20:52:02 T:3560  NOTICE: CDVDPlayerAudio::OutputPacket duplicate 1 packets of duration 23
20:52:03 T:5524  NOTICE: DXVA::CDecoder::Close - closing decoder
20:52:03 T:5524  NOTICE: DXVA::Close - closing decoder context
20:52:03 T:5524  NOTICE: CDVDVideoCodecFFmpeg::GetFormat - Creating DXVA(1280x720)
20:52:03 T:3560  NOTICE: CDVDPlayerAudio::OutputPacket skipping a packets of duration 23
20:52:04 T:5524  NOTICE: Previous line repeats 1 times.
20:52:04 T:5524  NOTICE: DXVA::CDecoder::Close - closing decoder
20:52:04 T:5524  NOTICE: DXVA::Close - closing decoder context
20:52:04 T:5524  NOTICE: CDVDVideoCodecFFmpeg::GetFormat - Creating DXVA(1280x720)
20:52:04 T:3560  NOTICE: CDVDPlayerAudio::OutputPacket skipping a packets of duration 23
20:52:04 T:3560  NOTICE: Previous line repeats 6 times.
20:52:04 T:3560  NOTICE: CDVDPlayerAudio::OutputPacket duplicate 1 packets of duration 23
20:52:06 T:5524  NOTICE: DXVA::CDecoder::Close - closing decoder
20:52:06 T:5524  NOTICE: DXVA::Close - closing decoder context
20:52:06 T:5524  NOTICE: CDVDVideoCodecFFmpeg::GetFormat - Creating DXVA(1280x720)
20:52:06 T:3560  NOTICE: CDVDPlayerAudio::OutputPacket skipping a packets of duration 23
20:52:06 T:3560  NOTICE: Previous line repeats 7 times.
20:52:06 T:3560  NOTICE: CDVDPlayerAudio::OutputPacket duplicate 1 packets of duration 23
20:52:07 T:5524  NOTICE: DXVA::CDecoder::Close - closing decoder
20:52:07 T:5524  NOTICE: DXVA::Close - closing decoder context
20:52:07 T:5524  NOTICE: CDVDVideoCodecFFmpeg::GetFormat - Creating DXVA(1280x720)
20:52:07 T:3560  NOTICE: CDVDPlayerAudio::OutputPacket skipping a packets of duration 23
20:52:08 T:5524  NOTICE: Previous line repeats 1 times.
20:52:08 T:5524  NOTICE: DXVA::CDecoder::Close - closing decoder
20:52:08 T:5524  NOTICE: DXVA::Close - closing decoder context
20:52:08 T:5524  NOTICE: CDVDVideoCodecFFmpeg::GetFormat - Creating DXVA(1280x720)
20:52:08 T:3560  NOTICE: CDVDPlayerAudio::OutputPacket duplicate 1 packets of duration 23

  • Like 1
Link to comment
Share on other sites
Angelblue05

Angelblue05   4130

Posted
Posted (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 by Angelblue05
Link to comment
Share on other sites
mobamoba

mobamoba   12

Posted
Posted

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: false
09:20:09 T:6444  NOTICE: Previous line repeats 1 times.
09:20:09 T:6444  NOTICE: Thread LanguageInvoker start, auto delete: false
09:20:09 T:7144  NOTICE: Thread JobWorker start, auto delete: true
09:20:09 T:6444  NOTICE: -->Python Interpreter Initialized<--
09:20:09 T:6444  NOTICE: duration script running
10: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: true
11: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
Angelblue05

Angelblue05   4130

Posted
Posted

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
Guest
This topic is now closed to further replies.
 Share
Go to topic listing
×
×
  • Create New...