DiscoDuck79 Posted April 3 Share Posted April 3 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 1 Link to comment Share on other sites More sharing options...
DiscoDuck79 Posted April 3 Share Posted April 3 (edited) 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 April 3 by DiscoDuck79 1 Link to comment Share on other sites More sharing options...
quickmic Posted April 4 Author Share Posted April 4 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? 1 Link to comment Share on other sites More sharing options...
DiscoDuck79 Posted April 4 Share Posted April 4 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. 1 Link to comment Share on other sites More sharing options...
phunzie Posted April 8 Share Posted April 8 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 Link to comment Share on other sites More sharing options...
quickmic Posted April 8 Author Share Posted April 8 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 Please be patient, I'll release a new version soon with several fixes and performance/stability improvements. Link to comment Share on other sites More sharing options...
quickmic Posted April 10 Author Share Posted April 10 (edited) 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 April 10 by quickmic 1 Link to comment Share on other sites More sharing options...
DiscoDuck79 Posted April 10 Share Posted April 10 @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 More sharing options...
quickmic Posted April 10 Author Share Posted April 10 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 More sharing options...
DiscoDuck79 Posted April 11 Share Posted April 11 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 More sharing options...
phunzie Posted April 11 Share Posted April 11 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 More sharing options...
quickmic Posted April 12 Author Share Posted April 12 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 More sharing options...
DiscoDuck79 Posted April 12 Share Posted April 12 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. 1 Link to comment Share on other sites More sharing options...
quickmic Posted April 12 Author Share Posted April 12 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. 2 Link to comment Share on other sites More sharing options...
838Joel Posted April 12 Share Posted April 12 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 More sharing options...
quickmic Posted April 13 Author Share Posted April 13 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 More sharing options...
838Joel Posted April 13 Share Posted April 13 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 More sharing options...
quickmic Posted April 13 Author Share Posted April 13 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 More sharing options...
838Joel Posted April 13 Share Posted April 13 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 More sharing options...
838Joel Posted April 14 Share Posted April 14 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>: 1 Link to comment Share on other sites More sharing options...
quickmic Posted April 14 Author Share Posted April 14 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 More sharing options...
Onana Posted April 14 Share Posted April 14 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 More sharing options...
quickmic Posted April 14 Author Share Posted April 14 (edited) 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 April 14 by quickmic Link to comment Share on other sites More sharing options...
Onana Posted April 14 Share Posted April 14 I just removed 2/3 folders. Emby update fine, but plugin not. Link to comment Share on other sites More sharing options...
quickmic Posted April 14 Author Share Posted April 14 I mean what is wrong on Kodi. Are there empty Artist/Albums or invalid links? Link to comment Share on other sites More sharing options...
Recommended Posts
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 accountSign in
Already have an account? Sign in here.
Sign In Now