Completed 1.1.6 Sync Failure

[MSattler 387]

It starts syncing fine, and then crashes with this:

 

15:37:19 605.370728 T:140257713227840  NOTICE: VideoPlayer: OnLostDisplay received

15:37:19 605.406494 T:140257713227840  NOTICE: VideoPlayer: OnResetDisplay received

15:37:19 605.444153 T:140257713227840  NOTICE: GL: Selecting Single Pass YUV 2 RGB shader

15:37:19 605.464417 T:140257713227840  NOTICE: GL: NPOT texture support detected

15:37:19 605.464478 T:140257713227840  NOTICE: GL: Using GL_ARB_pixel_buffer_object

15:37:19 605.464478 T:140257713227840  NOTICE: Using GL_TEXTURE_2D

15:37:19 605.471619 T:140257713227840  NOTICE: GL: Selecting Single Pass YUV 2 RGB shader

15:37:19 605.486145 T:140257713227840  NOTICE: GL: NPOT texture support detected

15:37:19 605.486206 T:140257713227840  NOTICE: GL: Using GL_ARB_pixel_buffer_object

15:37:19 605.571472 T:140255011624704  NOTICE: EMBY WebSocket_Client -> Message: {"MessageType":"UserDataChanged","Data":{"UserId":"5fc23353005e41f29c063f3a9e7c53ab","UserDataList":[{"PlaybackPositionTicks":0,"PlayCount":1,"IsFavorite":false,"LastPlayedDate":"2015-12-26T20:40:19.9649138Z","Played":false,"Key":"261023","ItemId":"97e7394cfac23a96f70e32fd38398ef4"},{"PlayedPercentage":17.2785148048322,"UnplayedItemCount":556,"PlaybackPositionTicks":0,"PlayCount":0,"IsFavorite":false,"Played":false,"Key":"98732bca-e2e7-8a67-c90b-bc0ed1c78a1a","ItemId":"98732bcae2e78a67c90bbc0ed1c78a1a"}]}}

15:37:19 605.571716 T:140255011624704  NOTICE: EMBY LibrarySync -> Queue userdata: [u'97e7394cfac23a96f70e32fd38398ef4', u'98732bcae2e78a67c90bbc0ed1c78a1a']

15:37:29 615.708252 T:140255025944320   ERROR: Exception in thread Thread-10:

                                            Traceback (most recent call last):

                                              File "/home/neil/projects/OpenELEC.tv/build.OpenELEC-Generic.x86_64-7.0-devel/Python-2.7.10/.install_pkg/usr/lib/python2.7/threading.py", line 810, in __bootstrap_inner

                                              File "/storage/.kodi/addons/plugin.video.emby/resources/lib/librarysync.py", line 1212, in run

                                                self.run_internal()

                                              File "/storage/.kodi/addons/plugin.video.emby/resources/lib/librarysync.py", line 1294, in run_internal

                                                librarySync = self.startSync()

                                              File "/storage/.kodi/addons/plugin.video.emby/resources/lib/librarysync.py", line 94, in startSync

                                                completed = self.fullSync(manualrun=True)

                                              File "/storage/.kodi/addons/plugin.video.emby/resources/lib/librarysync.py", line 237, in fullSync

                                                completed = process[itemtype](embycursor, kodicursor, pDialog, compare=manualrun)

                                              File "/storage/.kodi/addons/plugin.video.emby/resources/lib/librarysync.py", line 941, in tvshows

                                                pdialog.update(percentage, message="%s - %s" % (title, episodetitle))

                                            UnboundLocalError: local variable 'percentage' referenced before assignment

 

 

 

Let me know if you need the full log.

 

-Marcus

[Angelblue05 4130]

Good catch Give me a few minutes to fix it.

[Angelblue05 4130]

The fix is in 1.1.67 - Let me know that it works correctly for you, thanks!

[MSattler 387]

The fix is in 1.1.67 - Let me know that it works correctly for you, thanks!

 

Here is the latest:  14:03:55 236.710510 T:139786676185152 WARNING: Skin has invalid include: Animation_FanartFade

14:03:55 236.750549 T:139786676185152 WARNING: Trying to add unsupported control type 1

14:03:56 237.538300 T:139783974188800 WARNING: Previous line repeats 18 times.

14:03:56 237.538361 T:139783974188800  NOTICE: script.tv.show.next.aired: ### TV Show - Next Aired starting GUI proc (6.0.15)

14:04:01 241.863159 T:139784106260224   ERROR: Exception in thread Thread-10:

                                            Traceback (most recent call last):

                                              File "/home/neil/projects/OpenELEC.tv/build.OpenELEC-Generic.x86_64-7.0-devel/Python-2.7.10/.install_pkg/usr/lib/python2.7/threading.py", line 810, in __bootstrap_inner

                                              File "/storage/.kodi/addons/plugin.video.emby/resources/lib/librarysync.py", line 1218, in run

                                                self.run_internal()

                                              File "/storage/.kodi/addons/plugin.video.emby/resources/lib/librarysync.py", line 1300, in run_internal

                                                librarySync = self.startSync()

                                              File "/storage/.kodi/addons/plugin.video.emby/resources/lib/librarysync.py", line 94, in startSync

                                                completed = self.fullSync(manualrun=True)

                                              File "/storage/.kodi/addons/plugin.video.emby/resources/lib/librarysync.py", line 237, in fullSync

                                                completed = process[itemtype](embycursor, kodicursor, pDialog, compare=manualrun)

                                              File "/storage/.kodi/addons/plugin.video.emby/resources/lib/librarysync.py", line 941, in tvshows

                                                pdialog.update(percentage, message=title)

                                            UnboundLocalError: local variable 'title' referenced before assignment

 

 

Let me know if you need a full log.  This is on 1.1.67.

 

Thanks!

[Angelblue05 4130]

Ok thanks. I'll fix this asap!

 

 

Sent from my iPhone using Tapatalk

[Angelblue05 4130]

Fix is in 1.1.68

 

Let me know that it works for you.

[MSattler 387]

Fix is in 1.1.68

 

Let me know that it works for you.

 

Got further again  This I believe is related to Music now:

 

18:44:23 597.374817 T:140553073194752  NOTICE: EMBY Service -> Server is online and ready.

18:44:29 603.176697 T:140551043143424   ERROR: Exception in thread Thread-10:

                                            Traceback (most recent call last):

                                              File "/home/neil/projects/OpenELEC.tv/build.OpenELEC-Generic.x86_64-7.0-devel/Python-2.7.10/.install_pkg/usr/lib/python2.7/threading.py", line 810, in __bootstrap_inner

                                              File "/storage/.kodi/addons/plugin.video.emby/resources/lib/librarysync.py", line 1216, in run

                                                self.run_internal()

                                              File "/storage/.kodi/addons/plugin.video.emby/resources/lib/librarysync.py", line 1298, in run_internal

                                                librarySync = self.startSync()

                                              File "/storage/.kodi/addons/plugin.video.emby/resources/lib/librarysync.py", line 94, in startSync

                                                completed = self.fullSync(manualrun=True)

                                              File "/storage/.kodi/addons/plugin.video.emby/resources/lib/librarysync.py", line 263, in fullSync

                                                completed = self.music(embycursor, musiccursor, pDialog, compare=manualrun)

                                              File "/storage/.kodi/addons/plugin.video.emby/resources/lib/librarysync.py", line 1017, in music

                                                all_embyitems = process[type][0](basic=True)

                                              File "/storage/.kodi/addons/plugin.video.emby/resources/lib/read_embyserver.py", line 377, in getAlbums

                                                items = self.getSection(None, "MusicAlbum", sortby="DateCreated", basic=basic)

                                              File "/storage/.kodi/addons/plugin.video.emby/resources/lib/read_embyserver.py", line 188, in getSection

                                                items['Items'].extend(result['Items'])

                                            TypeError: string indices must be integers, not str

[Angelblue05 4130]

I don't see the entire log, but I'm guessing your server is unable to respond within 30 seconds when we request 200 items at a time. Go to the add-on settings > sync option > adjust the number requested to 150. Restart Kodi, then it should be fine.

[MSattler 387]

I don't see the entire log, but I'm guessing your server is unable to respond within 30 seconds when we request 200 items at a time. Go to the add-on settings > sync option > adjust the number requested to 150. Restart Kodi, then it should be fine.

 

Let me go ahead and try that.  I'm wondering if it's the client that cannot handle the return from the server fast enough.... could that be?  Hard to believe the server cannot respond fast enough, it's a VM with 8 cores i7 with 12GB of memory.  Let me try lowering the request number.

[Angelblue05 4130]

No, it's the server. Is there anything happening on your server at this moment? Transcode or maybe a task running? This will delay server response. I've set 200 as a default, but honestly it's quite high, especially when we ask the server to return all the metadata info about every items.

Edited December 29, 2015 by Angelblue05

[MSattler 387]

Let me go ahead and try that.  I'm wondering if it's the client that cannot handle the return from the server fast enough.... could that be?  Hard to believe the server cannot respond fast enough, it's a VM with 8 cores i7 with 12GB of memory.  Let me try lowering the request number.

 

Works!  Thanks again!