Jump to content

embyforkodi (next-gen) 7.X.X support


quickmic

Recommended Posts

DiscoDuck79
8 minutes ago, quickmic said:

Was it a restart or a stop/start?

What's the turnaround time of a restart?

Please try stop/start and wait at least 15 seconds after stop (that's the current timeout).

 

This currently an awful workaround addressing a specific issues 99.9% never appears. When it happens, it's mostly related to music content updates and live recordings. I try to get rid of it asap but right now I found no better way. It only delays the realtime content updates, not the progress updates.

 

Emby server reports (on realtime updates) all changes. The plugin skips the not applicable ones (not synced content). It will not affect the sync and I cannot be exclude them from realtime updates. Emby server would need some sort of subscription model to exclude content from realtime updates.

On startup sync I can define what should be synced, cause it's not a push from Emby server. It's pull request were the plugin can query the content by Library ID.

 

I'll check if possible, but there are also Kodi limitations. A list view in Kodi requires a content definition. 

e.g. impossible to include pictures and videos in node (not related to "in progress" node, just a general info)

Maybe possible for episodes and movies for "in progress". Also there is a difference between in progress TVShows and in progress episodes.

 

 

 

 

Was it a restart or a stop/start?

Log from container shutdown and container start = Container stop, then container start. I tried again and the behavior and log is the same. Emby container stopped around 09:14:57  so the socket fails after 15s as per your timeout settings.

Spoiler
2022-04-03 09:15:12.665 T:10216    INFO <general>: Emby.hooks.websocket: --->[ websocket reconnecting ]
2022-04-03 09:15:12.665 T:10214    INFO <general>: Emby.hooks.websocket: ---<[ websocket ]
2022-04-03 09:15:17.667 T:10216    INFO <general>: Emby.hooks.websocket: [ websocket reconnecting failed ]
2022-04-03 09:15:17.667 T:10216    INFO <general>: Emby.hooks.websocket: --->[ websocket reconnecting ]
2022-04-03 09:15:22.669 T:10216    INFO <general>: Emby.hooks.websocket: [ websocket reconnecting failed ]
2022-04-03 09:15:22.669 T:10216    INFO <general>: Emby.hooks.websocket: --->[ websocket reconnecting ]
2022-04-03 09:15:27.671 T:10216    INFO <general>: Emby.hooks.websocket: [ websocket reconnecting failed ]
2022-04-03 09:15:27.671 T:10216    INFO <general>: Emby.hooks.websocket: --->[ websocket reconnecting ]
2022-04-03 09:15:32.673 T:10216    INFO <general>: Emby.hooks.websocket: [ websocket reconnecting failed ]
2022-04-03 09:15:32.673 T:10216    INFO <general>: Emby.hooks.websocket: --->[ websocket reconnecting ]
2022-04-03 09:15:37.675 T:10216    INFO <general>: Emby.hooks.websocket: [ websocket reconnecting failed ]
2022-04-03 09:15:37.675 T:10216    INFO <general>: Emby.hooks.websocket: --->[ websocket reconnecting ]
2022-04-03 09:15:42.676 T:10216    INFO <general>: Emby.hooks.websocket: [ websocket reconnecting failed ]
2022-04-03 09:15:42.677 T:10216    INFO <general>: Emby.hooks.websocket: --->[ websocket reconnecting ]
2022-04-03 09:15:47.679 T:10216    INFO <general>: Emby.hooks.websocket: [ websocket reconnecting failed ]
2022-04-03 09:15:47.679 T:10216    INFO <general>: Emby.hooks.websocket: --->[ websocket reconnecting ]
2022-04-03 09:15:52.684 T:10216    INFO <general>: Emby.hooks.websocket: [ websocket reconnecting failed ]
2022-04-03 09:15:52.685 T:10216    INFO <general>: Emby.hooks.websocket: --->[ websocket reconnecting ]
2022-04-03 09:15:57.686 T:10216    INFO <general>: Emby.hooks.websocket: [ websocket reconnecting failed ]
2022-04-03 09:15:57.686 T:10216    INFO <general>: Emby.hooks.websocket: --->[ websocket reconnecting ]
2022-04-03 09:16:02.688 T:10216    INFO <general>: Emby.hooks.websocket: [ websocket reconnecting failed ]
2022-04-03 09:16:02.688 T:10216    INFO <general>: Emby.hooks.websocket: --->[ websocket reconnecting ]
2022-04-03 09:16:07.689 T:10216    INFO <general>: Emby.hooks.websocket: [ websocket reconnecting failed ]
2022-04-03 09:16:07.689 T:10216    INFO <general>: Emby.hooks.websocket: --->[ websocket reconnecting ]
2022-04-03 09:16:12.691 T:10216    INFO <general>: Emby.hooks.websocket: [ websocket reconnecting failed ]
2022-04-03 09:16:12.692 T:10216    INFO <general>: Emby.hooks.websocket: --->[ websocket reconnecting ]
2022-04-03 09:16:17.693 T:10216    INFO <general>: Emby.hooks.websocket: [ websocket reconnecting failed ]
2022-04-03 09:16:17.693 T:10216    INFO <general>: Emby.hooks.websocket: --->[ websocket reconnecting ]
2022-04-03 09:16:22.695 T:10216    INFO <general>: Emby.hooks.websocket: [ websocket reconnecting failed ]
2022-04-03 09:16:22.695 T:10216    INFO <general>: Emby.hooks.websocket: --->[ websocket reconnecting ]
2022-04-03 09:16:27.696 T:10216    INFO <general>: Emby.hooks.websocket: [ websocket reconnecting failed ]
2022-04-03 09:16:27.696 T:10216    INFO <general>: Emby.hooks.websocket: --->[ websocket reconnecting ]
2022-04-03 09:16:32.697 T:10216    INFO <general>: Emby.hooks.websocket: [ websocket reconnecting failed ]
2022-04-03 09:16:32.697 T:10216    INFO <general>: Emby.hooks.websocket: --->[ websocket reconnecting ]
2022-04-03 09:16:37.699 T:10216    INFO <general>: Emby.hooks.websocket: [ websocket reconnecting failed ]
2022-04-03 09:16:37.699 T:10216    INFO <general>: Emby.hooks.websocket: --->[ websocket reconnecting ]
2022-04-03 09:16:42.701 T:10216    INFO <general>: Emby.hooks.websocket: [ websocket reconnecting failed ]
2022-04-03 09:16:42.702 T:10216    INFO <general>: Emby.hooks.websocket: --->[ websocket reconnecting ]
2022-04-03 09:16:47.704 T:10216    INFO <general>: Emby.hooks.websocket: [ websocket reconnecting failed ]
2022-04-03 09:16:47.704 T:10216    INFO <general>: Emby.hooks.websocket: --->[ websocket reconnecting ]
2022-04-03 09:16:52.705 T:10216    INFO <general>: Emby.hooks.websocket: [ websocket reconnecting failed ]
2022-04-03 09:16:52.705 T:10216    INFO <general>: Emby.hooks.websocket: --->[ websocket reconnecting ]
2022-04-03 09:16:57.706 T:10216    INFO <general>: Emby.hooks.websocket: [ websocket reconnecting failed ]
2022-04-03 09:16:57.707 T:10216    INFO <general>: Emby.hooks.websocket: --->[ websocket reconnecting ]
2022-04-03 09:17:02.708 T:10216    INFO <general>: Emby.hooks.websocket: [ websocket reconnecting failed ]
2022-04-03 09:17:02.708 T:10216    INFO <general>: Emby.hooks.websocket: --->[ websocket reconnecting ]
2022-04-03 09:17:07.715 T:10216    INFO <general>: Emby.hooks.websocket: ---<[ websocket reconnecting ]

 

Restart of container is quick, I'd say ~20s, it's long enough that I get websocket reconnecting notifications in the log.

FYI, after the websocket reconnecting entries into the log there's no more communication with the server visible in the log. On the Emby server I can see that the client is connected, but messages can't be sent.

For clarification regarding In progress. I meant for episodes and movies, not tv shows since that's a whole category. My main use (assume like many others) is to use this as a widget so if it's just set like type video and ideally linked to where "Emby favourite xyz" are located then it wouldn't end up in the shows or movies section. Would that be an option? In progress Tv shows is ok after the latest update with: fix next episode

  • Thanks 1
Link to comment
Share on other sites

DiscoDuck79

Got an error after the reboots/restarts of the docker container earlier today, I experienced the same error on the previous build as well but thought the db caved in. It doesn't seem to like the LastPlayedDate?

Spoiler
2022-04-03 18:14:54.896 T:4127     INFO <general>: EMBY.hooks.webservice: -->[ webservice/57342 ]
2022-04-03 18:14:54.896 T:4092     INFO <general>: EMBY.service: [ Start Emby-next-gen ]
2022-04-03 18:14:55.211 T:4096     INFO <general>: ## CoreELEC Addon ## updates::updateThread ## Started
2022-04-03 18:14:55.214 T:4096     INFO <general>: ## CoreELEC Addon ## updates::set_auto_update ## manual
2022-04-03 18:14:55.251 T:4129    ERROR <general>: EMBY.hooks.webservice: No Emby servers found
2022-04-03 18:14:55.252 T:4084     INFO <general>: CPythonInvoker(0, /storage/.kodi/addons/plugin.video.emby-next-gen/events.py): script successfully run
2022-04-03 18:14:55.419 T:4092     INFO <general>: EMBY.helper.utils: Copied special://xbmc/system/library/video/
2022-04-03 18:14:55.594 T:4084     INFO <general>: Python interpreter stopped
2022-04-03 18:14:55.609 T:4083    ERROR <general>: GetDirectory - Error getting plugin://plugin.video.emby-next-gen/?libraryname=Serier&mode=nextepisodes&limit=25
2022-04-03 18:14:55.609 T:4083    ERROR <general>: GetDirectory - Error getting library://video/emby_tvshows_Serier/nextepisodes.xml/
2022-04-03 18:14:55.609 T:4083    ERROR <general>: GetDirectory - Error getting -
2022-04-03 18:14:55.853 T:4092     INFO <general>: EMBY.helper.utils: Copied special://xbmc/system/library/music/
2022-04-03 18:14:56.036 T:4142    ERROR <general>: EMBY.hooks.webservice: No Emby servers found
2022-04-03 18:14:56.038 T:4092     INFO <general>: EMBY.database.dbio: --->[ database: video3715080832/1/setup ]
2022-04-03 18:14:56.051 T:4143    ERROR <general>: EMBY.hooks.webservice: No Emby servers found
2022-04-03 18:14:56.054 T:4092     INFO <general>: EMBY.database.dbio: --->[video3715080832] 0 rows updated on db close
2022-04-03 18:14:56.054 T:4092     INFO <general>: EMBY.database.dbio: ---<[video3715080832] 0 rows updated on db close
2022-04-03 18:14:56.054 T:4092     INFO <general>: EMBY.database.dbio: ---<[ database: video3715080832/0/setup ]
2022-04-03 18:14:56.073 T:4144    ERROR <general>: EMBY.hooks.webservice: No Emby servers found
2022-04-03 18:14:56.106 T:4092     INFO <general>: Skipped 1 duplicate messages..
2022-04-03 18:14:56.106 T:4092     INFO <general>: EMBY.core.connection_manager: Begin connectToServer
2022-04-03 18:14:56.122 T:4092     INFO <general>: EMBY.database.library: --->[ library ]
2022-04-03 18:14:56.122 T:4092     INFO <general>: EMBY.emby.emby: ---[ INIT EMBYCLIENT: ]---
2022-04-03 18:14:56.122 T:4092     INFO <general>: EMBY.emby.emby: --[ server/DEFAULT ]
2022-04-03 18:14:56.154 T:4092     INFO <general>: EMBY.core.connection_manager: Begin connect
2022-04-03 18:14:56.154 T:4092     INFO <general>: EMBY.core.connection_manager: testing connection mode 0 with server Emby
2022-04-03 18:14:56.155 T:4092     INFO <general>: EMBY.core.connection_manager: tryConnect url: http://192.168.10.20:8096/emby/system/info/public
2022-04-03 18:14:56.162 T:4148     INFO <general>: ## CoreELEC Addon ## _service_::run ## WAITING:
2022-04-03 18:14:56.218 T:4147     INFO <general>: ## CoreELEC Addon ## xdbus Monitor started. ##
2022-04-03 18:14:56.240 T:4092     INFO <general>: EMBY.core.connection_manager: calling onSuccessfulConnection with connection mode 0 with server Emby
2022-04-03 18:14:56.257 T:4092     INFO <general>: EMBY.emby.emby: User is authenticated.
2022-04-03 18:14:56.258 T:4092     INFO <general>: EMBY.emby.emby: ---[ START EMBYCLIENT: b4c3377815e44e1881de0c497a94e8d1 ]---
2022-04-03 18:14:56.394 T:4092     INFO <general>: EMBY.database.dbio: --->[ database: b4c3377815e44e1881de0c497a94e8d13715080832/1/load_settings ]
2022-04-03 18:14:56.439 T:4092     INFO <general>: EMBY.database.dbio: --->[ database: video3715080832/1/load_settings ]
2022-04-03 18:14:56.442 T:4092     INFO <general>: EMBY.database.dbio: ---<[ database: video3715080832/0/load_settings ]
2022-04-03 18:14:56.452 T:4092     INFO <general>: EMBY.database.dbio: --->[ database: music3715080832/1/load_settings ]
2022-04-03 18:14:56.453 T:4092     INFO <general>: EMBY.database.dbio: --->[music3715080832] 2 rows updated on db close
2022-04-03 18:14:56.468 T:4092     INFO <general>: EMBY.database.dbio: ---<[music3715080832] 2 rows updated on db close
2022-04-03 18:14:56.468 T:4092     INFO <general>: EMBY.database.dbio: ---<[ database: music3715080832/0/load_settings ]
2022-04-03 18:14:56.470 T:4092     INFO <general>: EMBY.database.dbio: --->[b4c3377815e44e1881de0c497a94e8d13715080832] 0 rows updated on db close
2022-04-03 18:14:56.470 T:4092     INFO <general>: EMBY.database.dbio: ---<[b4c3377815e44e1881de0c497a94e8d13715080832] 0 rows updated on db close
2022-04-03 18:14:56.470 T:4092     INFO <general>: EMBY.database.dbio: ---<[ database: b4c3377815e44e1881de0c497a94e8d13715080832/0/load_settings ]
2022-04-03 18:14:56.490 T:4150     INFO <general>: Emby.hooks.websocket: --->[ websocket ]
2022-04-03 18:14:56.491 T:4092     INFO <general>: EMBY.emby.emby: [ Server Online ]
2022-04-03 18:14:56.494 T:4149     INFO <general>: EMBY.database.dbio: --->[ database: b4c3377815e44e1881de0c497a94e8d13324879488/1/remove ]
2022-04-03 18:14:56.497 T:4149     INFO <general>: EMBY.database.dbio: ---<[ database: b4c3377815e44e1881de0c497a94e8d13324879488/0/remove ]
2022-04-03 18:14:56.498 T:4149     INFO <general>: EMBY.database.library: [ worker remove exit ] queue size: 0
2022-04-03 18:14:56.500 T:4149     INFO <general>: EMBY.database.dbio: --->[ database: b4c3377815e44e1881de0c497a94e8d13324879488/1/update ]
2022-04-03 18:14:56.507 T:4149     INFO <general>: EMBY.database.dbio: ---<[ database: b4c3377815e44e1881de0c497a94e8d13324879488/0/update ]
2022-04-03 18:14:56.513 T:4149     INFO <general>: EMBY.database.library: [ worker update exit ] queue size: 0
2022-04-03 18:14:56.515 T:4149     INFO <general>: EMBY.database.dbio: --->[ database: b4c3377815e44e1881de0c497a94e8d13324879488/1/userdata ]
2022-04-03 18:14:56.519 T:4149     INFO <general>: EMBY.database.library: -->[ worker userdata started ] queue size: 1
2022-04-03 18:14:56.537 T:4149    ERROR <general>: Exception in thread
2022-04-03 18:14:56.537 T:4149    ERROR <general>: Thread-7
2022-04-03 18:14:56.537 T:4149    ERROR <general>: :
2022-04-03 18:14:56.537 T:4149    ERROR <general>: Traceback (most recent call last):
2022-04-03 18:14:56.537 T:4149    ERROR <general>:   File "/usr/lib/python3.8/threading.py", line 932, in _bootstrap_inner
2022-04-03 18:14:56.538 T:4149    ERROR <general>:   File "/usr/lib/python3.8/threading.py", line 870, in run
2022-04-03 18:14:56.541 T:4149    ERROR <general>:   File "/storage/.kodi/addons/plugin.video.emby-next-gen/database/library.py", line 128, in InitSync
2022-04-03 18:14:56.542 T:4149    ERROR <general>:
2022-04-03 18:14:56.542 T:4149    ERROR <general>: self.RunJobs()
2022-04-03 18:14:56.542 T:4149    ERROR <general>:
2022-04-03 18:14:56.542 T:4149    ERROR <general>:   File "/storage/.kodi/addons/plugin.video.emby-next-gen/database/library.py", line 494, in RunJobs
2022-04-03 18:14:56.544 T:4149    ERROR <general>:
2022-04-03 18:14:56.544 T:4149    ERROR <general>: if self.worker_userdata():
2022-04-03 18:14:56.544 T:4149    ERROR <general>:
2022-04-03 18:14:56.544 T:4149    ERROR <general>:   File "/storage/.kodi/addons/plugin.video.emby-next-gen/database/library.py", line 205, in worker_userdata
2022-04-03 18:14:56.544 T:4149    ERROR <general>:
2022-04-03 18:14:56.544 T:4149    ERROR <general>: Items.append({"Id": UserDataItem['ItemId'], "KodiItemId": e_item[0], "KodiFileId": e_item[1], "KodiType": e_item[4], "Type": e_item[5], 'PlaybackPositionTicks': UserDataItem['PlaybackPositionTicks'], 'PlayCount': UserDataItem['PlayCount'], 'IsFavorite': UserDataItem['IsFavorite'], 'LastPlayedDate': UserDataItem['LastPlayedDate'], 'Played': UserDataItem['Played'], "UpdateItem": str(UserDataItem)})
2022-04-03 18:14:56.544 T:4149    ERROR <general>:
2022-04-03 18:14:56.544 T:4149    ERROR <general>: KeyError
2022-04-03 18:14:56.544 T:4149    ERROR <general>: :
2022-04-03 18:14:56.544 T:4149    ERROR <general>: 'LastPlayedDate'
2022-04-03 18:14:56.544 T:4149    ERROR <general>:

 

Edit: This makes the "Processing updates" spinner get stuck at 0%

Edited by DiscoDuck79
  • Like 1
Link to comment
Share on other sites

quickmic
12 hours ago, DiscoDuck79 said:

Got an error after the reboots/restarts of the docker container earlier today, I experienced the same error on the previous build as well but thought the db caved in. It doesn't seem to like the LastPlayedDate?

  Hide contents
2022-04-03 18:14:54.896 T:4127     INFO <general>: EMBY.hooks.webservice: -->[ webservice/57342 ]
2022-04-03 18:14:54.896 T:4092     INFO <general>: EMBY.service: [ Start Emby-next-gen ]
2022-04-03 18:14:55.211 T:4096     INFO <general>: ## CoreELEC Addon ## updates::updateThread ## Started
2022-04-03 18:14:55.214 T:4096     INFO <general>: ## CoreELEC Addon ## updates::set_auto_update ## manual
2022-04-03 18:14:55.251 T:4129    ERROR <general>: EMBY.hooks.webservice: No Emby servers found
2022-04-03 18:14:55.252 T:4084     INFO <general>: CPythonInvoker(0, /storage/.kodi/addons/plugin.video.emby-next-gen/events.py): script successfully run
2022-04-03 18:14:55.419 T:4092     INFO <general>: EMBY.helper.utils: Copied special://xbmc/system/library/video/
2022-04-03 18:14:55.594 T:4084     INFO <general>: Python interpreter stopped
2022-04-03 18:14:55.609 T:4083    ERROR <general>: GetDirectory - Error getting plugin://plugin.video.emby-next-gen/?libraryname=Serier&mode=nextepisodes&limit=25
2022-04-03 18:14:55.609 T:4083    ERROR <general>: GetDirectory - Error getting library://video/emby_tvshows_Serier/nextepisodes.xml/
2022-04-03 18:14:55.609 T:4083    ERROR <general>: GetDirectory - Error getting -
2022-04-03 18:14:55.853 T:4092     INFO <general>: EMBY.helper.utils: Copied special://xbmc/system/library/music/
2022-04-03 18:14:56.036 T:4142    ERROR <general>: EMBY.hooks.webservice: No Emby servers found
2022-04-03 18:14:56.038 T:4092     INFO <general>: EMBY.database.dbio: --->[ database: video3715080832/1/setup ]
2022-04-03 18:14:56.051 T:4143    ERROR <general>: EMBY.hooks.webservice: No Emby servers found
2022-04-03 18:14:56.054 T:4092     INFO <general>: EMBY.database.dbio: --->[video3715080832] 0 rows updated on db close
2022-04-03 18:14:56.054 T:4092     INFO <general>: EMBY.database.dbio: ---<[video3715080832] 0 rows updated on db close
2022-04-03 18:14:56.054 T:4092     INFO <general>: EMBY.database.dbio: ---<[ database: video3715080832/0/setup ]
2022-04-03 18:14:56.073 T:4144    ERROR <general>: EMBY.hooks.webservice: No Emby servers found
2022-04-03 18:14:56.106 T:4092     INFO <general>: Skipped 1 duplicate messages..
2022-04-03 18:14:56.106 T:4092     INFO <general>: EMBY.core.connection_manager: Begin connectToServer
2022-04-03 18:14:56.122 T:4092     INFO <general>: EMBY.database.library: --->[ library ]
2022-04-03 18:14:56.122 T:4092     INFO <general>: EMBY.emby.emby: ---[ INIT EMBYCLIENT: ]---
2022-04-03 18:14:56.122 T:4092     INFO <general>: EMBY.emby.emby: --[ server/DEFAULT ]
2022-04-03 18:14:56.154 T:4092     INFO <general>: EMBY.core.connection_manager: Begin connect
2022-04-03 18:14:56.154 T:4092     INFO <general>: EMBY.core.connection_manager: testing connection mode 0 with server Emby
2022-04-03 18:14:56.155 T:4092     INFO <general>: EMBY.core.connection_manager: tryConnect url: http://192.168.10.20:8096/emby/system/info/public
2022-04-03 18:14:56.162 T:4148     INFO <general>: ## CoreELEC Addon ## _service_::run ## WAITING:
2022-04-03 18:14:56.218 T:4147     INFO <general>: ## CoreELEC Addon ## xdbus Monitor started. ##
2022-04-03 18:14:56.240 T:4092     INFO <general>: EMBY.core.connection_manager: calling onSuccessfulConnection with connection mode 0 with server Emby
2022-04-03 18:14:56.257 T:4092     INFO <general>: EMBY.emby.emby: User is authenticated.
2022-04-03 18:14:56.258 T:4092     INFO <general>: EMBY.emby.emby: ---[ START EMBYCLIENT: b4c3377815e44e1881de0c497a94e8d1 ]---
2022-04-03 18:14:56.394 T:4092     INFO <general>: EMBY.database.dbio: --->[ database: b4c3377815e44e1881de0c497a94e8d13715080832/1/load_settings ]
2022-04-03 18:14:56.439 T:4092     INFO <general>: EMBY.database.dbio: --->[ database: video3715080832/1/load_settings ]
2022-04-03 18:14:56.442 T:4092     INFO <general>: EMBY.database.dbio: ---<[ database: video3715080832/0/load_settings ]
2022-04-03 18:14:56.452 T:4092     INFO <general>: EMBY.database.dbio: --->[ database: music3715080832/1/load_settings ]
2022-04-03 18:14:56.453 T:4092     INFO <general>: EMBY.database.dbio: --->[music3715080832] 2 rows updated on db close
2022-04-03 18:14:56.468 T:4092     INFO <general>: EMBY.database.dbio: ---<[music3715080832] 2 rows updated on db close
2022-04-03 18:14:56.468 T:4092     INFO <general>: EMBY.database.dbio: ---<[ database: music3715080832/0/load_settings ]
2022-04-03 18:14:56.470 T:4092     INFO <general>: EMBY.database.dbio: --->[b4c3377815e44e1881de0c497a94e8d13715080832] 0 rows updated on db close
2022-04-03 18:14:56.470 T:4092     INFO <general>: EMBY.database.dbio: ---<[b4c3377815e44e1881de0c497a94e8d13715080832] 0 rows updated on db close
2022-04-03 18:14:56.470 T:4092     INFO <general>: EMBY.database.dbio: ---<[ database: b4c3377815e44e1881de0c497a94e8d13715080832/0/load_settings ]
2022-04-03 18:14:56.490 T:4150     INFO <general>: Emby.hooks.websocket: --->[ websocket ]
2022-04-03 18:14:56.491 T:4092     INFO <general>: EMBY.emby.emby: [ Server Online ]
2022-04-03 18:14:56.494 T:4149     INFO <general>: EMBY.database.dbio: --->[ database: b4c3377815e44e1881de0c497a94e8d13324879488/1/remove ]
2022-04-03 18:14:56.497 T:4149     INFO <general>: EMBY.database.dbio: ---<[ database: b4c3377815e44e1881de0c497a94e8d13324879488/0/remove ]
2022-04-03 18:14:56.498 T:4149     INFO <general>: EMBY.database.library: [ worker remove exit ] queue size: 0
2022-04-03 18:14:56.500 T:4149     INFO <general>: EMBY.database.dbio: --->[ database: b4c3377815e44e1881de0c497a94e8d13324879488/1/update ]
2022-04-03 18:14:56.507 T:4149     INFO <general>: EMBY.database.dbio: ---<[ database: b4c3377815e44e1881de0c497a94e8d13324879488/0/update ]
2022-04-03 18:14:56.513 T:4149     INFO <general>: EMBY.database.library: [ worker update exit ] queue size: 0
2022-04-03 18:14:56.515 T:4149     INFO <general>: EMBY.database.dbio: --->[ database: b4c3377815e44e1881de0c497a94e8d13324879488/1/userdata ]
2022-04-03 18:14:56.519 T:4149     INFO <general>: EMBY.database.library: -->[ worker userdata started ] queue size: 1
2022-04-03 18:14:56.537 T:4149    ERROR <general>: Exception in thread
2022-04-03 18:14:56.537 T:4149    ERROR <general>: Thread-7
2022-04-03 18:14:56.537 T:4149    ERROR <general>: :
2022-04-03 18:14:56.537 T:4149    ERROR <general>: Traceback (most recent call last):
2022-04-03 18:14:56.537 T:4149    ERROR <general>:   File "/usr/lib/python3.8/threading.py", line 932, in _bootstrap_inner
2022-04-03 18:14:56.538 T:4149    ERROR <general>:   File "/usr/lib/python3.8/threading.py", line 870, in run
2022-04-03 18:14:56.541 T:4149    ERROR <general>:   File "/storage/.kodi/addons/plugin.video.emby-next-gen/database/library.py", line 128, in InitSync
2022-04-03 18:14:56.542 T:4149    ERROR <general>:
2022-04-03 18:14:56.542 T:4149    ERROR <general>: self.RunJobs()
2022-04-03 18:14:56.542 T:4149    ERROR <general>:
2022-04-03 18:14:56.542 T:4149    ERROR <general>:   File "/storage/.kodi/addons/plugin.video.emby-next-gen/database/library.py", line 494, in RunJobs
2022-04-03 18:14:56.544 T:4149    ERROR <general>:
2022-04-03 18:14:56.544 T:4149    ERROR <general>: if self.worker_userdata():
2022-04-03 18:14:56.544 T:4149    ERROR <general>:
2022-04-03 18:14:56.544 T:4149    ERROR <general>:   File "/storage/.kodi/addons/plugin.video.emby-next-gen/database/library.py", line 205, in worker_userdata
2022-04-03 18:14:56.544 T:4149    ERROR <general>:
2022-04-03 18:14:56.544 T:4149    ERROR <general>: Items.append({"Id": UserDataItem['ItemId'], "KodiItemId": e_item[0], "KodiFileId": e_item[1], "KodiType": e_item[4], "Type": e_item[5], 'PlaybackPositionTicks': UserDataItem['PlaybackPositionTicks'], 'PlayCount': UserDataItem['PlayCount'], 'IsFavorite': UserDataItem['IsFavorite'], 'LastPlayedDate': UserDataItem['LastPlayedDate'], 'Played': UserDataItem['Played'], "UpdateItem": str(UserDataItem)})
2022-04-03 18:14:56.544 T:4149    ERROR <general>:
2022-04-03 18:14:56.544 T:4149    ERROR <general>: KeyError
2022-04-03 18:14:56.544 T:4149    ERROR <general>: :
2022-04-03 18:14:56.544 T:4149    ERROR <general>: 'LastPlayedDate'
2022-04-03 18:14:56.544 T:4149    ERROR <general>:

 

Edit: This makes the "Processing updates" spinner get stuck at 0%

Thanks, I'll check it. Did a Kodi restart fix the issue?

  • Thanks 1
Link to comment
Share on other sites

DiscoDuck79
5 minutes ago, quickmic said:

Thanks, I'll check it. Did a Kodi restart fix the issue?

No, the log posted yesterday is from after a reboot on the client. The issue was present before, I tried to restart Kodi and reboot the client but the error was persistent. I've only seen this issue appear after the server has been down/restarted. It doesn't happen straight away after a restart of the server, it happens after a while. Only solution was a db reset.

 

  • Like 1
Link to comment
Share on other sites

phunzie

not sure if this is only a 7.xx issue, but since that's what i'm using, i'll ask this here....occasionally, but not often, the Processing Updates status bar gets stuck...if i exit Kodi and come back it will be gone, but if i manually initiate a library update, it will pop up again with the same status point

 

UpdateStuck.PNG

Link to comment
Share on other sites

quickmic
1 minute ago, phunzie said:

not sure if this is only a 7.xx issue, but since that's what i'm using, i'll ask this here....occasionally, but not often, the Processing Updates status bar gets stuck...if i exit Kodi and come back it will be gone, but if i manually initiate a library update, it will pop up again with the same status point

 

UpdateStuck.PNG

Please be patient, I'll release a new version soon with several fixes and performance/stability improvements.

Link to comment
Share on other sites

quickmic

New version available: 7.0.0-build 634

 

Delta changelog:

add upcoming episode support

fix musicvideos Artists
additional emby server notifications
threading improvements
db access improvements
remove 5 minute sync delay
fix progress updates

Edited by quickmic
  • Thanks 1
Link to comment
Share on other sites

DiscoDuck79

@quickmicTested the new version, I still need to restart the client after a container restart but after that it syncs. Anything we should look out for in this version?

Link to comment
Share on other sites

quickmic
1 hour ago, DiscoDuck79 said:

@quickmicTested the new version, I still need to restart the client after a container restart but after that it syncs. Anything we should look out for in this version?

ok, actually I've tested all sorts of shutdown but I'll continue review.

I don't use docker, therefore I cannot test this specific case but I run Emby server in a LXC container which is quite similar.

 

Link to comment
Share on other sites

DiscoDuck79

Stumbled on what might be a bug.

A movie was wrongly identified when added on the server. Changed it to the correct movie, on the server all looks good as it should. But on the client the old cover remains and the cast now contains actors from both the old and the "new" movie. It's like it added to the db and not replaced the information.

Link to comment
Share on other sites

phunzie

i noticed the same thing...movie was incorrectly identified by Emby server, so wrong metadata and coverart was displayed in Kodi/E4K....so i manually re-identified the movie in Emby server correcting the metadata and coverart, but the changes never made it into Kodi...had to remove movie and re-add it to get the correct info to show in Kodi

Link to comment
Share on other sites

quickmic
11 hours ago, phunzie said:

i noticed the same thing...movie was incorrectly identified by Emby server, so wrong metadata and coverart was displayed in Kodi/E4K....so i manually re-identified the movie in Emby server correcting the metadata and coverart, but the changes never made it into Kodi...had to remove movie and re-add it to get the correct info to show in Kodi

I'll check it. Have you tested with stock skin confirming this is not a issue with skin or skin helpers?

Link to comment
Share on other sites

DiscoDuck79
1 minute ago, quickmic said:

I'll check it. Have you tested with stock skin confirming this is not a issue with skin or skin helpers?

I checked it with Estuary as well yesterday just to confirm that it wasnt a skin issue and it was the same.

  • Like 1
Link to comment
Share on other sites

quickmic
2 hours ago, DiscoDuck79 said:

I checked it with Estuary as well yesterday just to confirm that it wasnt a skin issue and it was the same.

I found the problem, will be fixed in next version.

  • Thanks 2
Link to comment
Share on other sites

838Joel

Hi,

I'm using emby plugin into Kodi 19.3 on Android TV

The plug-in version 6.2.15 is fine.

But since there is a new version 7.0.0 (all build) I tried it, but it seems to jam importing always at the same place into the tv-shows... (Movies fine)

Don't Know if it is a specific show or if I have too many shows!

Anyone had this problem?

I will try to remove that specific show where it stop and test again... Will let you know!

....

Ok I completely remove the show that stop to sync, now it jam at the same % but on another show... So it is not the show the problem but looks like a limitation in the DB??? Just trying to guess....

I will downgrade again to 6.2.15 plugin has this is always jamming on 7.0.0 (any build).

....

I gave another try by resetting all my Kodi and reinstall from scratch and same thing.

Just did reinstall with 6.2.15 plugin and all sync with no problem...

So something is wrong with 7.0.0 plugin!😐 Any idea? I tried to just sync with the tv-shows without the movies and same thing. This just happen on tv-shows!!! Strange

Link to comment
Share on other sites

quickmic
9 hours ago, 838Joel said:

Hi,

I'm using emby plugin into Kodi 19.3 on Android TV

The plug-in version 6.2.15 is fine.

But since there is a new version 7.0.0 (all build) I tried it, but it seems to jam importing always at the same place into the tv-shows... (Movies fine)

Don't Know if it is a specific show or if I have too many shows!

Anyone had this problem?

I will try to remove that specific show where it stop and test again... Will let you know!

....

Ok I completely remove the show that stop to sync, now it jam at the same % but on another show... So it is not the show the problem but looks like a limitation in the DB??? Just trying to guess....

I will downgrade again to 6.2.15 plugin has this is always jamming on 7.0.0 (any build).

....

I gave another try by resetting all my Kodi and reinstall from scratch and same thing.

Just did reinstall with 6.2.15 plugin and all sync with no problem...

So something is wrong with 7.0.0 plugin!😐 Any idea? I tried to just sync with the tv-shows without the movies and same thing. This just happen on tv-shows!!! Strange

Please send me a kodi.log for review.

Link to comment
Share on other sites

838Joel
9 hours ago, quickmic said:

kodi.log

Should I retry the 7.0.0 plugin to create the problem? Or it will still in the log?

How do I get the log from my Android TV? An easy way to do this?

Link to comment
Share on other sites

quickmic
1 minute ago, 838Joel said:

Should I retry the 7.0.0 plugin to create the problem? Or it will still in the log?

How do I get the log from my Android TV? An easy way to do this?

I think it has nothing todo with Android, so better perform a test with a PC/Mac/Linux. Kodi.logs are also much more convenient to access.

Old(er) kodi.logs will be overwritten on each Kodi start so makes no sense to grab the current logs from Android.

Link to comment
Share on other sites

838Joel
1 hour ago, quickmic said:

I think it has nothing todo with Android, so better perform a test with a PC/Mac/Linux. Kodi.logs are also much more convenient to access.

Old(er) kodi.logs will be overwritten on each Kodi start so makes no sense to grab the current logs from Android.

ok I will check to get it after I redo a test with the 7.0.0 plugin.

Link to comment
Share on other sites

838Joel
21 hours ago, 838Joel said:

ok I will check to get it after I redo a test with the 7.0.0 plugin.

Ok finally I could get the logs... but was a pain since the log uploader is not able to deal with file bigger then 1Mb... And this one was 2.7Mb...

 

Anyhow, I copy the last lines that where the sync (tv-show stop 78% on Satellite of Love)... Hope this is helpful to find the problem:

2022-04-14 09:22:26.838 T:31552    INFO <general>: EMBY.core.tvshows: ADD episode [623/1325/19097/19097] 295234: Satellite of Love
2022-04-14 09:22:27.126 T:31552   ERROR <general>: Exception ignored in thread started by
2022-04-14 09:22:27.126 T:31552   ERROR <general>: : 
2022-04-14 09:22:27.127 T:31552   ERROR <general>: <bound method Library.InitSync of <database.library.Library object at 0x829e7a78>>
2022-04-14 09:22:27.128 T:31552   ERROR <general>: 
                                                   
2022-04-14 09:22:27.129 T:31552   ERROR <general>: Traceback (most recent call last):
                                                   
2022-04-14 09:22:27.130 T:31552   ERROR <general>:   File "/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/plugin.video.emby-next-gen/database/library.py", line 132, in InitSync
                                                   
2022-04-14 09:22:27.142 T:31552   ERROR <general>:     
2022-04-14 09:22:27.142 T:31552   ERROR <general>: self.select_libraries("AddLibrarySelection")
2022-04-14 09:22:27.143 T:31552   ERROR <general>: 
                                                   
2022-04-14 09:22:27.143 T:31552   ERROR <general>:   File "/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/plugin.video.emby-next-gen/database/library.py", line 645, in select_libraries
                                                   
2022-04-14 09:22:27.147 T:31552   ERROR <general>:     
2022-04-14 09:22:27.147 T:31552   ERROR <general>: self.worker_library()
2022-04-14 09:22:27.147 T:31552   ERROR <general>: 
                                                   
2022-04-14 09:22:27.147 T:31552   ERROR <general>:   File "/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/plugin.video.emby-next-gen/database/library.py", line 404, in worker_library
                                                   
2022-04-14 09:22:27.150 T:31552   ERROR <general>:     
2022-04-14 09:22:27.150 T:31552   ERROR <general>: Continue, embydb, kodidb = self.ItemOps(index, TotalRecords, Item, embydb, kodidb, SyncItem[4], "add/update")
2022-04-14 09:22:27.151 T:31552   ERROR <general>: 
                                                   
2022-04-14 09:22:27.151 T:31552   ERROR <general>:   File "/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/plugin.video.emby-next-gen/database/library.py", line 452, in ItemOps
                                                   
2022-04-14 09:22:27.154 T:31552   ERROR <general>:     
2022-04-14 09:22:27.154 T:31552   ERROR <general>: Ret = self.ContentObject.episode(Item)
2022-04-14 09:22:27.154 T:31552   ERROR <general>: 
                                                   
2022-04-14 09:22:27.154 T:31552   ERROR <general>:   File "/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/plugin.video.emby-next-gen/core/tvshows.py", line 207, in episode
                                                   
2022-04-14 09:22:27.158 T:31552   ERROR <general>:     
2022-04-14 09:22:27.158 T:31552   ERROR <general>: common.get_streams(item)
2022-04-14 09:22:27.158 T:31552   ERROR <general>: 
                                                   
2022-04-14 09:22:27.158 T:31552   ERROR <general>:   File "/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/plugin.video.emby-next-gen/core/common.py", line 331, in get_streams
                                                   
2022-04-14 09:22:27.161 T:31552   ERROR <general>:     
2022-04-14 09:22:27.161 T:31552   ERROR <general>: StreamData = {'codec': Stream.get('Codec').lower(), 'height': Stream.get('Height'), 'width': Stream.get('Width'), '3d': Stream.get('Video3DFormat'), 'BitRate': Stream.get('BitRate'), 'Index': Index}
2022-04-14 09:22:27.161 T:31552   ERROR <general>: 
                                                   
2022-04-14 09:22:27.161 T:31552   ERROR <general>: AttributeError
2022-04-14 09:22:27.161 T:31552   ERROR <general>: : 
2022-04-14 09:22:27.161 T:31552   ERROR <general>: 'NoneType' object has no attribute 'lower'
2022-04-14 09:22:27.161 T:31552   ERROR <general>: 
                                                   

 

  • Thanks 1
Link to comment
Share on other sites

quickmic
16 minutes ago, 838Joel said:

Ok finally I could get the logs... but was a pain since the log uploader is not able to deal with file bigger then 1Mb... And this one was 2.7Mb...

 

Anyhow, I copy the last lines that where the sync (tv-show stop 78% on Satellite of Love)... Hope this is helpful to find the problem:

2022-04-14 09:22:26.838 T:31552    INFO <general>: EMBY.core.tvshows: ADD episode [623/1325/19097/19097] 295234: Satellite of Love
2022-04-14 09:22:27.126 T:31552   ERROR <general>: Exception ignored in thread started by
2022-04-14 09:22:27.126 T:31552   ERROR <general>: : 
2022-04-14 09:22:27.127 T:31552   ERROR <general>: <bound method Library.InitSync of <database.library.Library object at 0x829e7a78>>
2022-04-14 09:22:27.128 T:31552   ERROR <general>: 
                                                   
2022-04-14 09:22:27.129 T:31552   ERROR <general>: Traceback (most recent call last):
                                                   
2022-04-14 09:22:27.130 T:31552   ERROR <general>:   File "/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/plugin.video.emby-next-gen/database/library.py", line 132, in InitSync
                                                   
2022-04-14 09:22:27.142 T:31552   ERROR <general>:     
2022-04-14 09:22:27.142 T:31552   ERROR <general>: self.select_libraries("AddLibrarySelection")
2022-04-14 09:22:27.143 T:31552   ERROR <general>: 
                                                   
2022-04-14 09:22:27.143 T:31552   ERROR <general>:   File "/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/plugin.video.emby-next-gen/database/library.py", line 645, in select_libraries
                                                   
2022-04-14 09:22:27.147 T:31552   ERROR <general>:     
2022-04-14 09:22:27.147 T:31552   ERROR <general>: self.worker_library()
2022-04-14 09:22:27.147 T:31552   ERROR <general>: 
                                                   
2022-04-14 09:22:27.147 T:31552   ERROR <general>:   File "/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/plugin.video.emby-next-gen/database/library.py", line 404, in worker_library
                                                   
2022-04-14 09:22:27.150 T:31552   ERROR <general>:     
2022-04-14 09:22:27.150 T:31552   ERROR <general>: Continue, embydb, kodidb = self.ItemOps(index, TotalRecords, Item, embydb, kodidb, SyncItem[4], "add/update")
2022-04-14 09:22:27.151 T:31552   ERROR <general>: 
                                                   
2022-04-14 09:22:27.151 T:31552   ERROR <general>:   File "/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/plugin.video.emby-next-gen/database/library.py", line 452, in ItemOps
                                                   
2022-04-14 09:22:27.154 T:31552   ERROR <general>:     
2022-04-14 09:22:27.154 T:31552   ERROR <general>: Ret = self.ContentObject.episode(Item)
2022-04-14 09:22:27.154 T:31552   ERROR <general>: 
                                                   
2022-04-14 09:22:27.154 T:31552   ERROR <general>:   File "/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/plugin.video.emby-next-gen/core/tvshows.py", line 207, in episode
                                                   
2022-04-14 09:22:27.158 T:31552   ERROR <general>:     
2022-04-14 09:22:27.158 T:31552   ERROR <general>: common.get_streams(item)
2022-04-14 09:22:27.158 T:31552   ERROR <general>: 
                                                   
2022-04-14 09:22:27.158 T:31552   ERROR <general>:   File "/storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/addons/plugin.video.emby-next-gen/core/common.py", line 331, in get_streams
                                                   
2022-04-14 09:22:27.161 T:31552   ERROR <general>:     
2022-04-14 09:22:27.161 T:31552   ERROR <general>: StreamData = {'codec': Stream.get('Codec').lower(), 'height': Stream.get('Height'), 'width': Stream.get('Width'), '3d': Stream.get('Video3DFormat'), 'BitRate': Stream.get('BitRate'), 'Index': Index}
2022-04-14 09:22:27.161 T:31552   ERROR <general>: 
                                                   
2022-04-14 09:22:27.161 T:31552   ERROR <general>: AttributeError
2022-04-14 09:22:27.161 T:31552   ERROR <general>: : 
2022-04-14 09:22:27.161 T:31552   ERROR <general>: 'NoneType' object has no attribute 'lower'
2022-04-14 09:22:27.161 T:31552   ERROR <general>: 
                                                   

 

Thanks, yes this helps and it's quite easy to fix. Will do so in next version, btw

Also you should check "Satellite of love", this episode seems to be broken. -> no codec information available.

Link to comment
Share on other sites

Hi

Latest version of experimental 7.

Emby server latest stable on windows server.

kodi running latest 19.4 version on nvidia.

Problem: After deleting some music files and updating library on emby server , plugin do not remove deleted artists/albums on kodi

Link to comment
Share on other sites

quickmic
1 hour ago, Onana said:

Hi

Latest version of experimental 7.

Emby server latest stable on windows server.

kodi running latest 19.4 version on nvidia.

Problem: After deleting some music files and updating library on emby server , plugin do not remove deleted artists/albums on kodi

I have the same issues. Are the Artist/Albums empty? Maybe I can write a workaround. No sure, but seems Emby is not consistent reporting deleted content.

Edited by quickmic
Link to comment
Share on other sites

quickmic

I mean what is wrong on Kodi. Are there empty Artist/Albums or invalid links?

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
×
×
  • Create New...