Manual Sync Fail; Repair Fail; Perform Local DB Reset Fail - Log attached

[Groty 5]

All operations are failing.  Nothing has been added to the local Kodi DB since the end of August, so I can't view any new content.  Even went as far as attempting to perform a local database reset and it dropped a turd.

 

Emby Server is on OpenMediaVault

Kodi is running on a FireTV

 

Log is attached

kodi.log

Edited September 16, 2016 by Groty

[Angelblue05 4130]

Your log contains no errors. It was updating your movies and I see that the log ended before it was done updating them.

 

Edit: Was it a library sync exited error? Let me know.

Edited September 16, 2016 by Angelblue05

[Groty 5]

Your log contains no errors. It was updating your movies and I see that the log ended before it was done updating them.

 

Edit: Was it a library sync exited error? Let me know.

 

Yes - the failure notification said restart Kodi and post about it on the forums.  I tried the Repair and Reset afterwards as well.  Finally I rebooted again and the same message popped.  

[Angelblue05 4130]

What version of the add-on are you running? Can you try to repeat the error, make sure you press ok to the dialogue before grabbing the log. It seems it was left out of your previous log. Thanks.

[Groty 5]

Okay, on it.  Takes a while though.

[Groty 5]

"Library sync thread has exited! You should restart Kodi now.  Please report this on the forum."

Please see below:

19:36:26 T:18446744072593434032  NOTICE: EMBY.itemtypes -> UPDATE movie itemid: d0688952c7e538e7243f50a58f52b2ac - Title: Elite Squad
19:36:27 T:18446744072593434032  NOTICE: EMBY.itemtypes -> movieid: 463 fileid: 463 pathid: 460
19:36:27 T:18446744072593434032  NOTICE: EMBY.itemtypes -> UPDATE movie itemid: 6630919c2c375b4d5c7ee9b72df98b9f - Title: Elite Squad: The Enemy Within
19:36:29 T:18446744072593434032  NOTICE: EMBY.itemtypes -> movieid: 464 fileid: 464 pathid: 461
19:36:29 T:18446744072593434032  NOTICE: EMBY.itemtypes -> UPDATE movie itemid: 6bcaa114ce787fe40fd744308165a2b9 - Title: Elvis
19:36:29 T:18446744072593434032  NOTICE: EMBY.artwork -> Updating Art url for thumb kodiId: 14560 (http://192.168.100.185:8096/emby/Items/cfa55e2fc36596aa123752681d11facb/Images/Primary?MaxWidth=400&MaxHeight=400&Index=0&Tag=ebd55bec3ae036ce806e75a6179972b2) -> (http://192.168.100.185:8096/emby/Items/cfa55e2fc36596aa123752681d11facb/Images/Primary?MaxWidth=400&MaxHeight=400&Index=0&Tag=d968d8fe347699aa218fc202d8e34cd6)
19:38:08 T:18446744072593434032  NOTICE: EMBY.librarysync -> ERROR:: database disk image is malformed
                                            Traceback (most recent call last):
                                              File "/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/plugin.video.emby/resources/lib/librarysync.py", line 901, in run
                                                self.run_internal()
                                              File "/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/plugin.video.emby/resources/lib/librarysync.py", line 972, in run_internal
                                                librarySync = self.startSync()
                                              File "/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/plugin.video.emby/resources/lib/librarysync.py", line 95, in startSync
                                                completed = ManualSync().sync()
                                              File "/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/plugin.video.emby/resources/lib/librarysync.py", line 1026, in sync
                                                return self.fullSync(manualrun=True)
                                              File "/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/plugin.video.emby/resources/lib/librarysync.py", line 257, in fullSync
                                                completed = process[itemtype](embycursor, kodicursor, pDialog)
                                              File "/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/plugin.video.emby/resources/lib/librarysync.py", line 1102, in movies
                                                movies.add_update(embymovie, viewName, viewId)
                                              File "/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/plugin.video.emby/resources/lib/itemtypes.py", line 483, in add_update
                                                self.kodi_db.addTags(movieid, tags, "movie")
                                              File "/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/plugin.video.emby/resources/lib/kodidb_functions.py", line 718, in addTags
                                                self.cursor.execute(query, (kodiid, mediatype))
                                            DatabaseError: database disk image is malformed
19:38:08 T:18446744072593434032   ERROR: Exception in thread Thread-14:
                                            Traceback (most recent call last):
                                              File "/home/jenkins/workspace/Android-ARM/tools/depends/xbmc-depends/arm-linux-androideabi-android-17/lib/python2.6/threading.py", line 532, in __bootstrap_inner
                                              File "/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/plugin.video.emby/resources/lib/librarysync.py", line 901, in run
                                                self.run_internal()
                                              File "/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/plugin.video.emby/resources/lib/librarysync.py", line 972, in run_internal
                                                librarySync = self.startSync()
                                              File "/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/plugin.video.emby/resources/lib/librarysync.py", line 95, in startSync
                                                completed = ManualSync().sync()
                                              File "/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/plugin.video.emby/resources/lib/librarysync.py", line 1026, in sync
                                                return self.fullSync(manualrun=True)
                                              File "/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/plugin.video.emby/resources/lib/librarysync.py", line 257, in fullSync
                                                completed = process[itemtype](embycursor, kodicursor, pDialog)
                                              File "/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/plugin.video.emby/resources/lib/librarysync.py", line 1102, in movies
                                                movies.add_update(embymovie, viewName, viewId)
                                              File "/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/plugin.video.emby/resources/lib/itemtypes.py", line 483, in add_update
                                                self.kodi_db.addTags(movieid, tags, "movie")
                                              File "/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/plugin.video.emby/resources/lib/kodidb_functions.py", line 718, in addTags
                                                self.cursor.execute(query, (kodiid, mediatype))
                                            DatabaseError: database disk image is malformed
19:38:19 T:18446744072509609520  NOTICE: Storing total System Uptime
19:38:19 T:18446744072509609520  NOTICE: Saving settings
19:38:19 T:18446744072509609520  NOTICE: stop all
19:38:19 T:18446744072509609520  NOTICE: stop player
19:38:19 T:18446744072509609520  NOTICE: ES: Stopping event server
19:38:19 T:18446744072509609520  NOTICE: stopping upnp
19:38:19 T:18446744072528107488  NOTICE: ES: UDP Event server stopped
19:38:19 T:18446744072521759216  NOTICE: EMBY.kodimonitor -> Method: System.OnQuit Data: {"exitcode":0}
19:38:19 T:18446744072509609520  NOTICE: stopping zeroconf publishing
19:38:19 T:18446744072509609520  NOTICE: WebServer: Stopped the webserver
19:38:19 T:18446744072509609520  NOTICE: stop sap announcement listener
19:38:19 T:18446744072509609520  NOTICE: clean cached files!
19:38:19 T:18446744072509609520  NOTICE: unload skin
19:38:19 T:18446744072521711400  NOTICE: Skin Helper Service --> Shutdown requested !
19:38:19 T:18446744072521711400  NOTICE: Skin Helper Service --> BackgroundsUpdater - stop called
19:38:19 T:18446744072521711400  NOTICE: Skin Helper Service --> ListItemMonitor - stop called
19:38:19 T:18446744072521711400  NOTICE: Skin Helper Service --> WebService - stop called
19:38:19 T:18446744072521711400  NOTICE: Skin Helper Service --> skin helper service version 1.0.100 stopped
19:38:20 T:18446744072521712888  NOTICE: script.tv.show.next.aired: ### abort requested -- stopping background processing
19:38:21 T:18446744072521759216  NOTICE: EMBY.websocket_client -> Stopping thread.
19:38:21 T:18446744072585274640  NOTICE: EMBY.websocket_client -> ##===---- WebSocketClient Stopped ----===##
19:38:21 T:18446744072568889200  NOTICE: EMBY.userclient -> ##===---- UserClient Stopped ----===##
19:38:21 T:18446744072521759216  NOTICE: EMBY.service -> ======== STOP EMBY ========
19:38:22 T:18446744072521759216 WARNING: CPythonInvoker(5, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/plugin.video.emby/service.py): the python script "/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/plugin.video.emby/service.py" has left several classes in memory that we couldn't clean up. The classes include: N9XBMCAddon9xbmcaddon5AddonE,N9XBMCAddon4xbmc7MonitorE,N9XBMCAddon9xbmcaddon5AddonE,N9XBMCAddon9xbmcaddon5AddonE,N9XBMCAddon9xbmcaddon5AddonE,N9XBMCAddon4xbmc7MonitorE,N9XBMCAddon4xbmc6PlayerE,N9XBMCAddon9xbmcaddon5AddonE
19:38:22 T:18446744072521765928 WARNING: CPythonInvoker(6, /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/service.scrobbler.lastfm/scrobbler.py): the python script "/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/service.scrobbler.lastfm/scrobbler.py" has left several classes in memory that we couldn't clean up. The classes include: N14PythonBindings31XBMCAddon_xbmc_Monitor_DirectorE,N14PythonBindings30XBMCAddon_xbmc_Player_DirectorE
19:38:23 T:18446744072509609520  NOTICE: stopped
19:38:23 T:18446744072509609520  NOTICE: destroy
19:38:23 T:18446744072509609520  NOTICE: closing down remote control service
19:38:23 T:18446744072509609520  NOTICE: unload sections
19:38:23 T:18446744072509609520  NOTICE: special://profile/ is mapped to: special://masterprofile/
19:38:23 T:18446744072509609520  NOTICE: destroy
19:38:23 T:18446744072509609520 WARNING: Attempted to remove window 10013 from the window manager when it didn't exist
19:38:23 T:18446744072509609520 WARNING: Attempted to remove window 10014 from the window manager when it didn't exist
19:38:23 T:18446744072509609520 WARNING: Attempted to remove window 10015 from the window manager when it didn't exist
19:38:23 T:18446744072509609520 WARNING: Attempted to remove window 10016 from the window manager when it didn't exist
19:38:23 T:18446744072509609520 WARNING: Attempted to remove window 10017 from the window manager when it didn't exist
19:38:23 T:18446744072509609520 WARNING: Attempted to remove window 10018 from the window manager when it didn't exist
19:38:23 T:18446744072509609520 WARNING: Attempted to remove window 10019 from the window manager when it didn't exist
19:38:23 T:18446744072509609520 WARNING: Attempted to remove window 10021 from the window manager when it didn't exist
19:38:23 T:18446744072509609520 WARNING: Attempted to remove window 10107 from the window manager when it didn't exist
19:38:23 T:18446744072509609520 WARNING: Attempted to remove window 10115 from the window manager when it didn't exist
19:38:23 T:18446744072509609520 WARNING: Attempted to remove window 10104 from the window manager when it didn't exist
19:38:23 T:18446744072509609520  NOTICE: closing down remote control service
19:38:23 T:18446744072509609520  NOTICE: unload sections
19:38:23 T:18446744072509609520  NOTICE: application stopped...

[Angelblue05 4130]

@@Groty

 

Ok, seems the database file is corrupted. That's why everything is failing. Head over to your Kodi folder > userdata > database > delete the myvideosxx.db file. Start Kodi, it will create a new myvideosxx.db file, then proceed to launching the emby add-on > reset local database. It should work this time.

[Groty 5]

Figures

 

Should I delete myvideosxx, tvxx, and musicxx?  All three of them?  Or just videos?

[Angelblue05 4130]

It seems to get stuck while trying to add movies, so it seems only myvideosxx is corrupted. Anyway, with the reset, it will start from scratch, so you could always delete musicxx.db if you wanted.

 

Edit: "Figures"? Does this happen often? Do you lose power to your device a lot? Let me know.

Edited September 17, 2016 by Angelblue05

[Groty 5]

Lose power?  No.  My FireTV drops network connectivity every single day.  It's connected to a wireless bridge.  Nothing else does, just the FireTV.  I have to reboot it to get it to see the network again.

 

I'm setting up OpenELEC on a Pi right now, see if does any better.

 

Honestly, I'm to the point in which I'm strongly considering dumping these small machines and building a proper HTPC.  They hang like crazy, buffer like crap when streaming, and can't run the heavier skins.

[Groty 5]

I use Pi3's in my house and they are great, I use https://libreelec.tv

 

What remote do you use?  I'd love to have a small BT remote that works out of the box, not full keyboard.