Jump to content

Emby for Kodi stops syncing once a month like clock work


brian1709
 Share

Recommended Posts

brian1709

Hi, the screen shot is cut off. I cannot find the manual update link for latest experimental

Download link for manual update: https://github.com/MediaBrowser/plugin.video....

3 hours ago, quickmic said:

Please update to latest versions if you go with experimental. 30ex5 is already "damn old", it's a work in progress. I'm sure all those issues are already fixed.

Latest versions are always available here (page one), and a new version will be released soon ūüėČ:

 

 

Link to comment
Share on other sites

quickmic
26 minutes ago, brian1709 said:

Hi, the sync just never finishes. It keeps on failing on the TV shows section about 15-20% in.

kodi.log 212.41 kB · 0 downloads kodi.old.log 2.14 MB · 0 downloads

Thanks, I see the problem. -> ERROR: EMBY.core.HTTP: [ ServerTimeout ]

 

Is there really no network problem. Frankly, all these issues you have tells me, there is something seriously wrong.

Anyway, I can try to use workarounds, but this will not solve your core issue.

 

A Kodi restart should continue the sync...

Edited by quickmic
Link to comment
Share on other sites

brian1709

Seriously no network issue. 

The sync always stops in the same place with the same file.

If I do the sync  Movies, music, tv it goes through everything till it gets to Evil in TV shows, and believe me my music collection is huge it takes about 6 hours to sync, so no diconnect

If I do TV first it never gets through it just stalls at that area

So why would it disconnect at the same place on the same file, sometimes after 5 hours sometimes after 5 minutes, depending on when it gets to that file area.

 

 

2021-09-11 15:20:57.965 T:10216    INFO <general>: INFO: EMBY.core.tvshows.TVShows: UPDATE tvshow [2/432] 76257: Evil
2021-09-11 15:21:00.892 T:10216    INFO <general>: INFO: EMBY.core.tvshows.TVShows: UPDATE episode [432/877/8998/12844] 293083: Pilot
2021-09-11 15:21:01.017 T:10216    INFO <general>: INFO: EMBY.core.tvshows.TVShows: UPDATE episode [432/877/8999/12845] 293084: 177 Minutes
2021-09-11 15:21:01.170 T:10216    INFO <general>: INFO: EMBY.core.tvshows.TVShows: UPDATE episode [432/877/9000/12846] 293085: 3 Stars
2021-09-11 15:21:01.329 T:10216    INFO <general>: INFO: EMBY.core.tvshows.TVShows: UPDATE episode [432/877/9001/12847] 293086: Rose390
2021-09-11 15:21:01.451 T:10216    INFO <general>: INFO: EMBY.core.tvshows.TVShows: UPDATE episode [432/877/9002/12848] 293087: October 31
2021-09-11 15:21:01.584 T:10216    INFO <general>: INFO: EMBY.core.tvshows.TVShows: UPDATE episode [432/877/9003/12849] 293088: Let x = 9
2021-09-11 15:21:01.710 T:10216    INFO <general>: INFO: EMBY.core.tvshows.TVShows: UPDATE episode [432/877/9004/12850] 293089: Vatican III
2021-09-11 15:21:01.870 T:10216    INFO <general>: INFO: EMBY.core.tvshows.TVShows: UPDATE episode [432/877/9005/12851] 293090: 2 Fathers
2021-09-11 15:21:02.019 T:10216    INFO <general>: INFO: EMBY.core.tvshows.TVShows: UPDATE episode [432/877/9006/12852] 293091: Exorcism Part 2
2021-09-11 15:21:02.161 T:10216    INFO <general>: INFO: EMBY.core.tvshows.TVShows: UPDATE episode [432/877/9007/12853] 293092: 7 Swans A Singin'
2021-09-11 15:21:02.300 T:10216    INFO <general>: INFO: EMBY.core.tvshows.TVShows: UPDATE episode [432/877/9008/12854] 293093: Room 320
2021-09-11 15:21:02.389 T:10216    INFO <general>: INFO: EMBY.core.tvshows.TVShows: UPDATE episode [432/877/9009/12855] 293094: Justice x 2
2021-09-11 15:21:02.486 T:10216    INFO <general>: INFO: EMBY.core.tvshows.TVShows: UPDATE episode [432/877/9010/12856] 293095: Book 27
2021-09-11 15:21:03.854 T:10216    INFO <general>: INFO: EMBY.core.tvshows.TVShows: UPDATE episode [432/878/9011/12857] 508848: N is for Night Terrors
2021-09-11 15:21:03.948 T:10216    INFO <general>: INFO: EMBY.core.tvshows.TVShows: UPDATE episode [432/878/9012/12858] 513861: A is for Avenging Angel
2021-09-11 15:21:04.016 T:10216    INFO <general>: INFO: EMBY.core.tvshows.TVShows: UPDATE episode [432/878/9013/12859] 513862: F is for Fire
2021-09-11 15:21:04.089 T:10216    INFO <general>: INFO: EMBY.core.tvshows.TVShows: UPDATE episode [432/878/9014/12860] 513863: E is for Elevator
2021-09-11 15:21:04.165 T:10216    INFO <general>: INFO: EMBY.core.tvshows.TVShows: UPDATE episode [432/878/9015/12861] 514959: Z is for Zombies
2021-09-11 15:21:04.236 T:10216    INFO <general>: INFO: EMBY.core.tvshows.TVShows: UPDATE episode [432/878/9016/12862] 515807: C is for Cop
2021-09-11 15:21:04.308 T:10216    INFO <general>: INFO: EMBY.core.tvshows.TVShows: UPDATE episode [432/878/9017/12863] 526620: S is for Silence
2021-09-11 15:21:04.374 T:10216    INFO <general>: INFO: EMBY.core.tvshows.TVShows: UPDATE episode [432/878/9018/12864] 529548: T is for Temporoparietal Lobes
2021-09-11 15:21:04.834 T:10216    INFO <general>: INFO: EMBY.core.tvshows.TVShows: UPDATE tvshow [2/433] 318253: Exit (2019)
2021-09-11 15:21:18.700 T:8844     INFO <general>: initializing python engine.
2021-09-11 15:21:19.933 T:9120  WARNING <general>: CGUIWindowManager - CGUIWindowManager::HandleAction - ignoring action 103, because topmost modal dialog closing animation is running
2021-09-11 15:21:20.167 T:8844     INFO <general>: CPythonInvoker(44, C:\Users\Willem\AppData\Roaming\Kodi\addons\script.logviewer\default.py): script successfully run
2021-09-11 15:21:20.661 T:8844     INFO <general>: Python interpreter stopped
2021-09-11 15:21:26.825 T:7248     INFO <general>: initializing python engine.
2021-09-11 15:21:33.182 T:7248     INFO <general>: CPythonInvoker(45, C:\Users\Willem\AppData\Roaming\Kodi\addons\script.logviewer\default.py): script successfully run
2021-09-11 15:21:33.750 T:7248     INFO <general>: Python interpreter stopped
2021-09-11 15:22:04.877 T:10216   ERROR <general>: ERROR: EMBY.core.HTTP: [ ServerTimeout ]
2021-09-11 15:22:04.878 T:10216    INFO <general>: INFO: EMBY.database.db_open.io: [video] 19646 rows updated.
2021-09-11 15:22:04.981 T:10216    INFO <general>: INFO: EMBY.database.db_open.io: [b8424b13a59f42d6b4df3f0be4e65ad3] 10725 rows updated.
2021-09-11 15:22:04.991 T:10216   ERROR <general>: Exception in thread 
2021-09-11 15:22:04.992 T:10216   ERROR <general>: Thread-9
2021-09-11 15:22:04.992 T:10216   ERROR <general>: :
                                                   
2021-09-11 15:22:04.992 T:10216   ERROR <general>: Traceback (most recent call last):
                                                   
2021-09-11 15:22:04.992 T:10216   ERROR <general>:   File "C:\Program Files\Kodi\system\python\Lib\threading.py", line 932, in _bootstrap_inner
                                                   
2021-09-11 15:22:04.992 T:10216   ERROR <general>:     
2021-09-11 15:22:04.993 T:10216   ERROR <general>: self.run()
2021-09-11 15:22:04.993 T:10216   ERROR <general>: 
                                                   
2021-09-11 15:22:04.993 T:10216   ERROR <general>:   File "C:\Program Files\Kodi\system\python\Lib\threading.py", line 870, in run
                                                   
2021-09-11 15:22:04.993 T:10216   ERROR <general>:     
2021-09-11 15:22:04.993 T:10216   ERROR <general>: self._target(*self._args, **self._kwargs)
2021-09-11 15:22:04.993 T:10216   ERROR <general>: 
                                                   
2021-09-11 15:22:04.993 T:10216   ERROR <general>:   File "C:\Users\Willem\AppData\Roaming\Kodi\addons\plugin.video.emby-next-gen\database\library.py", line 565, in RunJobs
                                                   
2021-09-11 15:22:04.994 T:10216   ERROR <general>:     
2021-09-11 15:22:04.994 T:10216   ERROR <general>: self.worker_library()
2021-09-11 15:22:04.994 T:10216   ERROR <general>: 
                                                   
2021-09-11 15:22:04.994 T:10216   ERROR <general>:   File "C:\Users\Willem\AppData\Roaming\Kodi\addons\plugin.video.emby-next-gen\database\library.py", line 447, in worker_library
                                                   
2021-09-11 15:22:04.994 T:10216   ERROR <general>:     
2021-09-11 15:22:04.995 T:10216   ERROR <general>: DBObject(Item, LibraryData, ProgressValue, False)
2021-09-11 15:22:04.995 T:10216   ERROR <general>: 
                                                   
2021-09-11 15:22:04.995 T:10216   ERROR <general>:   File "C:\Users\Willem\AppData\Roaming\Kodi\addons\plugin.video.emby-next-gen\core\tvshows.py", line 121, in tvshow
                                                   
2021-09-11 15:22:04.995 T:10216   ERROR <general>:     
2021-09-11 15:22:04.995 T:10216   ERROR <general>: Seasons = self.EmbyServer.API.get_seasons(obj['Id'])['Items']
2021-09-11 15:22:04.995 T:10216   ERROR <general>: 
                                                   
2021-09-11 15:22:04.995 T:10216   ERROR <general>: KeyError
2021-09-11 15:22:04.995 T:10216   ERROR <general>: : 
2021-09-11 15:22:04.995 T:10216   ERROR <general>: 'Items'
2021-09-11 15:22:04.995 T:10216   ERROR <general>: 
                                                   
2021-09-11 15:22:22.424 T:9588     INFO <general>: CActiveAESink::OpenSink - initialize sink
2021-09-11 15:22:23.503 T:9588  WARNING <general>: CWin32DirectSound::GetSpace - buffer underrun - W:42840, P:28544, O:42304.
2021-09-11 15:22:44.315 T:7672     INFO <general>: initializing python engine.
2021-09-11 15:22:50.525 T:7672     INFO <general>: CPythonInvoker(46, C:\Users\Willem\AppData\Roaming\Kodi\addons\script.logviewer\default.py): script successfully run
2021-09-11 15:22:51.062 T:7672     INFO <general>: Python interpreter stopped
2021-09-11 15:24:41.870 T:6400     INFO <general>: initializing python engine.
2021-09-11 15:24:52.246 T:6400     INFO <general>: CPythonInvoker(47, C:\Users\Willem\AppData\Roaming\Kodi\addons\script.logviewer\default.py): script successfully run
2021-09-11 15:24:52.793 T:6400     INFO <general>: Python interpreter stopped
2021-09-11 15:25:17.622 T:8464     INFO <general>: initializing python engine.
2021-09-11 15:25:23.109 T:8464     INFO <general>: CPythonInvoker(48, C:\Users\Willem\AppData\Roaming\Kodi\addons\script.logviewer\default.py): script successfully run
2021-09-11 15:25:23.558 T:8464     INFO <general>: Python interpreter stopped
2021-09-11 15:25:33.962 T:9120     INFO <general>: Stopping player
2021-09-11 15:25:33.962 T:9120     INFO <general>: Storing total System Uptime
2021-09-11 15:25:33.962 T:9120     INFO <general>: Saving settings
2021-09-11 15:25:33.966 T:9120     INFO <general>: Saving skin settings
2021-09-11 15:25:33.976 T:9120     INFO <general>: Stopping all
2021-09-11 15:25:34.566 T:6128  WARNING <general>: WARNING: EMBY.entrypoint.Service: ---<[ EXITING ]
2021-09-11 15:25:34.566 T:8984     INFO <general>: INFO: EMBY.hooks.webservice.WebService: ---<[ webservice/57578 ]
2021-09-11 15:25:34.567 T:6128     INFO <general>: INFO: EMBY.emby.main: ---[ STOP EMBYCLIENT: b8424b13a59f42d6b4df3f0be4e65ad3 ]---
2021-09-11 15:25:34.567 T:2156     INFO <general>: INFO: Emby.hooks.websocket: ---<[ websocket ]
2021-09-11 15:25:34.567 T:6128  WARNING <general>: WARNING: EMBY.core.HTTP: --<[ session/2678261889008 ]
2021-09-11 15:25:34.568 T:6128  WARNING <general>: [ emby-for-kodi-next-gen shutdown ]
2021-09-11 15:25:34.568 T:6128     INFO <general>: CPythonInvoker(4, C:\Users\Willem\AppData\Roaming\Kodi\addons\plugin.video.emby-next-gen\service.py): script successfully run
2021-09-11 15:25:34.568 T:6128     INFO <general>: CPythonInvoker(4, C:\Users\Willem\AppData\Roaming\Kodi\addons\plugin.video.emby-next-gen\service.py): waiting on thread 8032
2021-09-11 15:25:43.854 T:6128     INFO <general>: CPythonInvoker(4, C:\Users\Willem\AppData\Roaming\Kodi\addons\plugin.video.emby-next-gen\service.py): waiting on thread 9500
 

Link to comment
Share on other sites

brian1709

well figured it out. There was an episode in there that had a space in the name      Exit.S01 E01 which made it fail all the time.

Took the space out and it completed the sync. A bit surprised that something like that could make it fail. and only on this one machine, the rest ran straight over that issue.

  • Like 1
Link to comment
Share on other sites

brian1709

Spoke to quickly, it just went a little further and then found a new folder/TV Show it didn't like and now it hangs on that. (Fighting Season)

Ran it three times in different order, movies first(complete), TV second (fails)

Music first(complete) Movies(complete) TV (fails)

TV first (fails)

The folder contain 6 episodes, correctly named and numbered and nfo file for each

kodi.log kodi.old.log

Link to comment
Share on other sites

quickmic
16 minutes ago, brian1709 said:

Spoke to quickly, it just went a little further and then found a new folder/TV Show it didn't like and now it hangs on that. (Fighting Season)

Ran it three times in different order, movies first(complete), TV second (fails)

Music first(complete) Movies(complete) TV (fails)

TV first (fails)

The folder contain 6 episodes, correctly named and numbered and nfo file for each

kodi.log 2.2 MB · 0 downloads kodi.old.log 417.4 kB · 0 downloads

It's always the same issue:

ERROR: EMBY.core.HTTP: [ ServerTimeout ]

I'll add a workaround in next version, but a ServerTimeout should never appear.

The timeout settings is 60 seconds and this exactly what you log shows.

The server didn't response for 60 seconds what is totally odd.

 

Please send me the emby server log. Next-gen waited here for server answer:

2021-09-12 18:53:48.287 T:1916     INFO <general>: INFO: EMBY.core.tvshows.TVShows: ADD tvshow [2/459] 330672: Fighting Season
2021-09-12 18:54:48.320 T:1916    ERROR <general>: ERROR: EMBY.core.HTTP: [ ServerTimeout ]

 

I wanna check the emby server log for this timespan, probably there is something odd in the log.

 

 

Edited by quickmic
Link to comment
Share on other sites

brian1709

Same thing happened at

2021-09-12 17:39:34.929 T:4940     INFO <general>: INFO: EMBY.core.tvshows.TVShows: ADD tvshow [2/458] 330672: Fighting Season
2021-09-12 17:40:35.005 T:4940    ERROR <general>: ERROR: EMBY.core.HTTP: [ ServerTimeout ]
2021-09-12 17:40:35.005 T:4940     INFO <general>: INFO: EMBY.database.db_open.io: [video] 33134 rows updated.
2021-09-12 17:40:35.187 T:3248     INFO <general>: VideoInfoScanner: Finished scan. Scanning for video info took 01:21
2021-09-12 17:40:35.194 T:4940     INFO <general>: INFO: EMBY.database.db_open.io: [b8424b13a59f42d6b4df3f0be4e65ad3] 14239 rows updated.

 

which is also in the log, and like I said it used to happen continuously on another TV Show  EXIT till I changed the naming of the files to delete a space.

So it seems to have an issue with a folder or file and then times out (60 sec)

Link to comment
Share on other sites

quickmic

Please drop the naming which stalled the sync.

Also tell me which tag field in metadata manager on Emby server caused the issue. Probably you can post a screenshot?

And the nfo file if you use them.

Edited by quickmic
Link to comment
Share on other sites

brian1709
1 hour ago, quickmic said:

 

Also tell me which tag field in metadata manager on Emby server caused the issue. Probably you can post a screenshot?

 

where would I find this?

Link to comment
Share on other sites

brian1709

Thought so, but there is no tags applied.

I did change the name of the folder from Fighting.Season to Fighting Season as well as the six media files inside.

Here is the new nfo

Untitled.jpg

tvshow.nfo

Link to comment
Share on other sites

quickmic
11 minutes ago, brian1709 said:

I did change the name of the folder from Fighting.Season to Fighting Season as well as the six media files inside.

"Fighting.Season" was the folder name on you harddrive which caused the problem, right? After rename to "Fighting Season" it works?

Please confirm, and I'll design a test case based on that.

Link to comment
Share on other sites

brian1709

testing it now.

What I did notice is that both folders that caused lockups were considered foreign by way of the tag setting which by default is English USA

While EXIT was Norwegian with subs, Fighting Season is Australian English ?

Link to comment
Share on other sites

brian1709

Ok, it went right past Fighting Season no problem.

Then just got stuck a little bit further on Generation 56K

Again the Folder is named Generation.56K and is Foreign (Italian)

The log shows the same error     ERROR <general>: ERROR: EMBY.core.HTTP: [ ServerTimeout ]

but that cannot be right as I can play content from the server while it is supposedly disconnected or timing out.

I tried it a couple of times. Restart the sync, as soon as it stalls tries to play something and it works fine, so it is definitely connected to the server while the sync says it is not.

Also tried by starting to play a movie and while it is playing starting the sync, it just gets stuck at Generation.56K and then times out.

Something on the naming convention or the fact that it is "Foreign" is causing it to crap out.

Of course the DB comes from EMBY and is perfect in EMBYCON and Emby Theatre

Link to comment
Share on other sites

brian1709

Definitely something with folder/file naming.

Changed Generation.56k to Generation 56k on both file s and folder and it just went through right away

Link to comment
Share on other sites

quickmic
1 minute ago, brian1709 said:

Definitely something with folder/file naming.

Changed Generation.56k to Generation 56k on both file s and folder and it just went through right away

I'm performing a test right now... I hope I can reproduce the issue...

Link to comment
Share on other sites

brian1709

Folder not file naming.

Got another one, Folder Gomorrah (Italian) with subs

The Italian show was just Gomorra, Changed folder to Gomorra and left file names Gomorrah and it went through.

  • Like 1
Link to comment
Share on other sites

quickmic
9 minutes ago, brian1709 said:

Folder not file naming.

Got another one, Folder Gomorrah (Italian) with subs

The Italian show was just Gomorra, Changed folder to Gomorra and left file names Gomorrah and it went through.

I'm not able to reproduce the issue. If you find another one, don't fix it. Please let send me th ekodi long and emby server log.

I'll build a command based on that info and post it here with instuctions how to use it.

Sorry for the inconviniance, but this is a tough issue....

Edited by quickmic
Link to comment
Share on other sites

brian1709

OK, will do.

Could not fix Gomorra/h at all. Removed the folder and it continued freeze stopped and sync continued on

Link to comment
Share on other sites

quickmic
6 minutes ago, brian1709 said:

OK, will do.

Could not fix Gomorra/h at all. Removed the folder and it continued freeze stopped and sync continued on

I assume, but this pure speculation, there are special charecter is the foldername or subfolders or metatag which stalls Kodi or the Emby server.

Special charecters -> I mean invisible ones (hard to describe), machine command charecters, something like that.

Anyway, I try to build the command Kodi sent manually.  This request could be dropped into the browser and review the response.

Also you can enable debug log mode on Kodi and Emby server.

 

Edited by quickmic
Link to comment
Share on other sites

Create an account or sign in to comment

You need to be a member in order to leave a comment

Create an account

Sign up for a new account in our community. It's easy!

Register a new account

Sign in

Already have an account? Sign in here.

Sign In Now
 Share

×
×
  • Create New...