Saviq 22 Posted June 20, 2019 Share Posted June 20, 2019 I think it's updating Emby that broke Music playback for me altogether for me: 2019-06-20 08:37:57.900 T:4091480464 ERROR: CCurlFile::Stat - Failed: HTTP response code said error(22) for https://media.server:443/emby/Audio/77265/stream.flac 2019-06-20 08:37:57.960 T:3824149360 NOTICE: EMBY.objects.player -> [ onPlayBackStarted ] 2019-06-20 08:37:57.961 T:3824149360 NOTICE: EMBY.hooks.player -> [ played info ] {} 2019-06-20 08:37:57.966 T:3824149360 NOTICE: EMBY.objects.monitor -> [ xbmc/Info.OnChanged ] 2019-06-20 08:37:57.973 T:3549160304 NOTICE: EMBY.hooks.monitor -> -->[ q:monitor/Player.OnPlay ] 2019-06-20 08:37:57.976 T:3549160304 NOTICE: EMBY.objects.monitor -> [ play ] kodi_id: 706 media: song 2019-06-20 08:37:58.233 T:3434083184 ERROR: CCurlFile::Stat - Failed: HTTP response code said error(22) for https://media.server:443/emby/Audio/77265/stream.flac 2019-06-20 08:37:58.266 T:3434083184 ERROR: CCurlFile::FillBuffer - Failed: HTTP returned error 401 2019-06-20 08:37:58.266 T:3434083184 ERROR: CCurlFile::Open failed with code 401 for https://media.server:443/emby/Audio/77265/stream.flac: 2019-06-20 08:37:58.421 T:3434083184 ERROR: CCurlFile::FillBuffer - Failed: HTTP returned error 401 2019-06-20 08:37:58.422 T:3434083184 ERROR: CCurlFile::Open failed with code 401 for https://media.server:443/emby/Audio/77265/stream.flac: 2019-06-20 08:37:58.426 T:3434083184 ERROR: Open - failed to open source <https://media.server:443/emby/Audio/77265/stream.flac> 2019-06-20 08:37:58.426 T:3434083184 ERROR: Init: Error opening file musicdb://recentlyplayedalbums/40/706.flac?albumid=40 2019-06-20 08:37:58.426 T:3434083184 ERROR: CAudioDecoder: Unable to Init Codec while loading file https://media.server:443/emby/Audio/77265/stream.flac 2019-06-20 08:37:58.426 T:3434083184 WARNING: PAPlayer::QueueNextFileEx - Failed to create the decoder 2019-06-20 08:37:58.499 T:3824149360 NOTICE: EMBY.objects.monitor -> [ xbmc/Player.OnAVStart ] 2019-06-20 08:37:58.501 T:3824149360 NOTICE: EMBY.objects.player -> [ onAVStarted ] 2019-06-20 08:37:58.501 T:3824149360 ERROR: EXCEPTION: XBMC is not playing any file 2019-06-20 08:37:58.502 T:3824149360 NOTICE: EMBY.helper.wrapper -> ERROR:: XBMC is not playing any file 2019-06-20 08:37:58.503 T:3824149360 NOTICE: EMBY.hooks.player -> Filename is invalid 2019-06-20 08:37:58.505 T:3824149360 NOTICE: EMBY.objects.monitor -> [ xbmc/Player.OnStop ] 2019-06-20 08:37:58.664 T:3824149360 NOTICE: EMBY.hooks.player -> [ played info ] {} 2019-06-20 08:37:58.682 T:3824149360 NOTICE: EMBY.hooks.player -> --<<[ playback ] 2019-06-20 08:37:59.010 T:3832542064 ERROR: EXCEPTION: XBMC is not playing any media file 2019-06-20 08:37:59.011 T:3832542064 ERROR: EXCEPTION Thrown (PythonToCppException) : -->Python callback/script returned the following error<-- - NOTE: IGNORING THIS CAN LEAD TO MEMORY LEAKS! Error Type: <type 'exceptions.RuntimeError'> Error Contents: XBMC is not playing any media file Traceback (most recent call last): File "/storage/.kodi/addons/service.autosubs/default.py", line 119, in onPlayBackStarted totalTime = xbmc.Player().getTotalTime() RuntimeError: XBMC is not playing any media file -->End of Python script error report<-- Link to comment Share on other sites More sharing options...
Angelblue05 4130 Posted June 20, 2019 Share Posted June 20, 2019 Kodi doesn’t support flac. Link to comment Share on other sites More sharing options...
Saviq 22 Posted June 20, 2019 Author Share Posted June 20, 2019 (edited) Hmm¿? Playing FLACs from file just fine… 2019-06-20 20:36:58.685 T:3362780016 NOTICE: CDVDAudioCodecFFmpeg::Open() Successful opened audio decoder flac 2019-06-20 20:36:58.754 T:3544183664 NOTICE: EMBY.hooks.monitor -> -->[ q:monitor/Playlist.OnAdd ] 2019-06-20 20:36:58.756 T:3544183664 NOTICE: EMBY.objects.monitor -> {u'item': {u'album': u'RAMMSTEIN', u'track': 1, u'title': u'DEUTSCHLAND', u'type': u'song', u'artist': [u'Rammstein']}, u'playlistid': 0, 'MonitorMethod': 'Playlist.OnAdd', u'position': 1} 2019-06-20 20:36:58.855 T:3837141872 NOTICE: EMBY.objects.player -> [ onPlayBackStarted ] 2019-06-20 20:36:58.857 T:3837141872 NOTICE: EMBY.hooks.player -> [ played info ] {} 2019-06-20 20:36:58.861 T:3837141872 NOTICE: EMBY.objects.monitor -> [ xbmc/Info.OnChanged ] 2019-06-20 20:36:58.879 T:3294696304 NOTICE: EMBY.hooks.monitor -> -->[ q:monitor/Player.OnPlay ] 2019-06-20 20:36:59.856 T:3837141872 NOTICE: EMBY.objects.monitor -> [ xbmc/Player.OnAVStart ] 2019-06-20 20:36:59.859 T:3837141872 NOTICE: EMBY.objects.player -> [ onAVStarted ] 2019-06-20 20:37:04.938 T:4057985904 WARNING: ActiveAE::RunStages - viz ran out of free buffers 2019-06-20 20:37:05.073 T:3639550832 ERROR: EXCEPTION: XBMC is not playing any media file 2019-06-20 20:37:05.173 T:3837141872 NOTICE: EMBY.objects.monitor -> [ xbmc/Player.OnStop ] 2019-06-20 20:37:05.181 T:3837141872 NOTICE: EMBY.hooks.player -> [ played info ] {} 2019-06-20 20:37:05.267 T:3837141872 NOTICE: EMBY.hooks.player -> --<[ playback ] From Emby, I can't play mp3s either… 2019-06-20 20:37:48.590 T:4089399696 ERROR: CCurlFile::Stat - Failed: HTTP response code said error(22) for https://media.sawicz.net:443/emby/Audio/83562/stream.mp3 2019-06-20 20:37:48.735 T:3837141872 NOTICE: EMBY.objects.monitor -> [ xbmc/Info.OnChanged ] 2019-06-20 20:37:48.737 T:3837141872 NOTICE: EMBY.objects.player -> [ onPlayBackStarted ] 2019-06-20 20:37:48.738 T:3837141872 NOTICE: EMBY.hooks.player -> [ played info ] {} 2019-06-20 20:37:48.753 T:3187159920 NOTICE: EMBY.hooks.monitor -> -->[ q:monitor/Player.OnPlay ] 2019-06-20 20:37:48.755 T:3187159920 NOTICE: EMBY.objects.monitor -> [ play ] kodi_id: 560 media: song 2019-06-20 20:37:48.954 T:3294696304 ERROR: CCurlFile::Stat - Failed: HTTP response code said error(22) for https://media.sawicz.net:443/emby/Audio/83562/stream.mp3 2019-06-20 20:37:49.279 T:3294696304 ERROR: CCurlFile::FillBuffer - Failed: HTTP returned error 401 2019-06-20 20:37:49.279 T:3294696304 ERROR: CCurlFile::Open failed with code 401 for https://media.sawicz.net:443/emby/Audio/83562/stream.mp3: 2019-06-20 20:37:49.497 T:3294696304 ERROR: CCurlFile::FillBuffer - Failed: HTTP returned error 401 2019-06-20 20:37:49.497 T:3294696304 ERROR: CCurlFile::Open failed with code 401 for https://media.sawicz.net:443/emby/Audio/83562/stream.mp3: 2019-06-20 20:37:49.521 T:3294696304 ERROR: Open - failed to open source <https://media.sawicz.net:443/emby/Audio/83562/stream.mp3> 2019-06-20 20:37:49.521 T:3294696304 ERROR: Init: Error opening file musicdb://recentlyplayedalbums/31/560.mp3?albumid=31 2019-06-20 20:37:49.522 T:3294696304 ERROR: CAudioDecoder: Unable to Init Codec while loading file https://media.sawicz.net:443/emby/Audio/83562/stream.mp3 2019-06-20 20:37:49.522 T:3294696304 WARNING: PAPlayer::QueueNextFileEx - Failed to create the decoder 2019-06-20 20:37:49.539 T:3837141872 NOTICE: EMBY.objects.monitor -> [ xbmc/Player.OnAVStart ] 2019-06-20 20:37:49.541 T:3837141872 NOTICE: EMBY.objects.player -> [ onAVStarted ] 2019-06-20 20:37:49.542 T:3837141872 ERROR: EXCEPTION: XBMC is not playing any file 2019-06-20 20:37:49.543 T:3837141872 NOTICE: EMBY.helper.wrapper -> ERROR:: XBMC is not playing any file 2019-06-20 20:37:49.544 T:3837141872 NOTICE: EMBY.hooks.player -> Filename is invalid 2019-06-20 20:37:49.545 T:3837141872 NOTICE: EMBY.objects.monitor -> [ xbmc/Player.OnStop ] 2019-06-20 20:37:49.660 T:3698299760 ERROR: EXCEPTION: XBMC is not playing any media file 2019-06-20 20:37:49.697 T:3698299760 ERROR: EXCEPTION Thrown (PythonToCppException) : -->Python callback/script returned the following error<-- - NOTE: IGNORING THIS CAN LEAD TO MEMORY LEAKS! Error Type: <type 'exceptions.RuntimeError'> Error Contents: XBMC is not playing any media file Traceback (most recent call last): File "/storage/.kodi/addons/service.autosubs/default.py", line 119, in onPlayBackStarted totalTime = xbmc.Player().getTotalTime() RuntimeError: XBMC is not playing any media file -->End of Python script error report<-- 2019-06-20 20:37:49.748 T:3837141872 NOTICE: EMBY.hooks.player -> [ played info ] {} 2019-06-20 20:37:49.753 T:3837141872 NOTICE: EMBY.hooks.player -> --<<[ playback ] 2019-06-20 20:37:53.929 T:3639550832 ERROR: EXCEPTION: XBMC is not playing any media file I checked on two user profiles, both behave the same. When I visit the URL that gives 401, I get: Access token is invalid or expired. I really doubt it is a Kodi problem, as I was using this same setup just fine until a couple days ago. Edited June 20, 2019 by Saviq 1 Link to comment Share on other sites More sharing options...
Luke 36881 Posted June 20, 2019 Share Posted June 20, 2019 @@Saviq Please attach the emby server log, thanks. Link to comment Share on other sites More sharing options...
Angelblue05 4130 Posted June 20, 2019 Share Posted June 20, 2019 Ok I am being told by Luke it’s a change that has been reinforced with audio urls. It needs the api key attached to it. Now there is a good chance this will break music support in Kodi for addon playback. I may have to change it back to direct paths only or disabling music sync to Kodi support... Link to comment Share on other sites More sharing options...
Luke 36881 Posted June 20, 2019 Share Posted June 20, 2019 We'll find a solution. We might just need a new url that can include the apikey without a query string param. 1 Link to comment Share on other sites More sharing options...
Angelblue05 4130 Posted June 20, 2019 Share Posted June 20, 2019 We’ll figure something out, thanks for the info Luke. I’ll make whatever necessary adjustments to support music. Hopefully moving forward, Kodi will have better music support. Link to comment Share on other sites More sharing options...
Saviq 22 Posted July 3, 2019 Author Share Posted July 3, 2019 Anything I can help with? Link to comment Share on other sites More sharing options...
Luke 36881 Posted July 3, 2019 Share Posted July 3, 2019 We haven't gotten to this yet. Thanks. Link to comment Share on other sites More sharing options...
adam.niescierowicz 6 Posted August 14, 2019 Share Posted August 14, 2019 @@Luke can you update status? Link to comment Share on other sites More sharing options...
Angelblue05 4130 Posted August 14, 2019 Share Posted August 14, 2019 @@Luke can you update status? This has already been resolved. Just repair your music library. Check the changelog thread, I always post it. Link to comment Share on other sites More sharing options...
adam.niescierowicz 6 Posted August 14, 2019 Share Posted August 14, 2019 I did the library reset, unfortunately it still doesn't work. I'm using emby 4.1.13. 1 Link to comment Share on other sites More sharing options...
Angelblue05 4130 Posted August 15, 2019 Share Posted August 15, 2019 (edited) Provide your Kodi log trying to play music then. Because music playback works here and the OP confirmed that as well. Thanks. Edited August 15, 2019 by Angelblue05 Link to comment Share on other sites More sharing options...
adam.niescierowicz 6 Posted August 16, 2019 Share Posted August 16, 2019 Provide your Kodi log trying to play music then. Because music playback works here and the OP confirmed that as well. Thanks. Hi, Log: https://pastebin.com/9Sy8Mxt9 1 Link to comment Share on other sites More sharing options...
Angelblue05 4130 Posted August 19, 2019 Share Posted August 19, 2019 Thanks for the log. It's returning error 400 strangely. Can you tell me how you are accessing that music so we can try to replicate this? If you go directly under songs, does it work? @@sualfred check line 65 of the log. What is that? Link to comment Share on other sites More sharing options...
sualfred 677 Posted August 19, 2019 Share Posted August 19, 2019 You mean " Init: Error opening file musicdb://recentlyplayedalbums/37/568.mp3?albumid=37" ? He is accessing the last played albums. In Embuary go the music hub and then "library" to find it. It's just a internal sorting node. 1 Link to comment Share on other sites More sharing options...
Angelblue05 4130 Posted August 19, 2019 Share Posted August 19, 2019 Ok thank you. Yep that works here too. Adam In the add-on settings > advanced > disable mask sensitive information in log temporarily. Try playing, check your log, search for "EMBY.hooks.webservice -> path:" And test the path in your browser, does it work? Link to comment Share on other sites More sharing options...
adam.niescierowicz 6 Posted August 19, 2019 Share Posted August 19, 2019 Thanks for the log. It's returning error 400 strangely. Can you tell me how you are accessing that music so we can try to replicate this? If you go directly under songs, does it work? Unfortunately, music doesn't work anywhere. I checked: - Kodi->Music->Last Played - Kodi->Music->Authors - Kodi->Music->Albums - Addons->Music->Emby->Music->{Authors,Albums,Songs,*} I think that problems is in the song url ERROR: CCurlFile::Open failed with code 400 for http://127.0.0.1:57578/emby/Audio/557006/stream.mp3 here server address is 127.0.0.1 and real server address is outside od loopback interface. Link to comment Share on other sites More sharing options...
sualfred 677 Posted August 19, 2019 Share Posted August 19, 2019 (edited) The addon has its own internal webserver shipped that is used as wrapper to access the files on the server and to create the required actions in/for the Kodi player. That's why you see this localhost url. What happens if you open the url in the browser from the same machine? (Edit: While Kodi is running ) Edited August 19, 2019 by sualfred Link to comment Share on other sites More sharing options...
Saviq 22 Posted August 20, 2019 Author Share Posted August 20, 2019 (edited) I stopped playing for me again, too, looking at the log: 2019-08-20 09:05:07.754 T:3501192048 WARNING: <[ webservice/3574451216/0 ] 2019-08-20 09:05:07.780 T:3253207920 NOTICE: EMBY.hooks.webservice -> path: http://{emby-server}/emby/Audio/202220/stream.m4a?api_key={emby-token} 2019-08-20 09:05:07.784 T:3501192048 WARNING: <[ webservice/3574451216/1 ] 2019-08-20 09:05:07.838 T:3491222384 NOTICE: EMBY.objects.player -> [ onPlayBackStarted ] 2019-08-20 09:05:07.840 T:3491222384 NOTICE: EMBY.hooks.player -> [ skip stop ] http://{emby-server}/emby/Videos/198455/stream?static=true&MediaSourceId={media-id}&api_key={emby-token} 2019-08-20 09:05:07.842 T:3491222384 NOTICE: EMBY.objects.monitor -> [ xbmc/Info.OnChanged ] 2019-08-20 09:05:07.846 T:3253207920 NOTICE: EMBY.hooks.monitor -> -->[ q:monitor/Player.OnPlay ] 2019-08-20 09:05:07.847 T:3253207920 NOTICE: EMBY.objects.monitor -> [ play ] kodi_id: 8317 media: song 2019-08-20 09:05:20.112 T:3261600624 ERROR: Open - Error, could not open file http://10.0.5.143:8096/emby/Audio/202220/stream.m4a?api_key={emby-token} 2019-08-20 09:05:20.122 T:3261600624 ERROR: Init: Error creating demuxer 2019-08-20 09:05:20.123 T:3261600624 ERROR: CAudioDecoder: Unable to Init Codec while loading file http://127.0.0.1:57578/emby/Audio/202220/stream.m4a 2019-08-20 09:05:20.123 T:3261600624 WARNING: PAPlayer::QueueNextFileEx - Failed to create the decoder 2019-08-20 09:05:20.171 T:3491222384 NOTICE: EMBY.objects.monitor -> [ xbmc/Player.OnAVStart ] 2019-08-20 09:05:20.173 T:3491222384 NOTICE: EMBY.objects.player -> [ onAVStarted ] 2019-08-20 09:05:20.174 T:3491222384 ERROR: EXCEPTION: XBMC is not playing any file 2019-08-20 09:05:20.175 T:3491222384 NOTICE: EMBY.helper.wrapper -> ERROR:: XBMC is not playing any file 2019-08-20 09:05:20.176 T:3491222384 NOTICE: EMBY.hooks.player -> Filename is invalid 2019-08-20 09:05:20.178 T:3491222384 NOTICE: EMBY.objects.monitor -> [ xbmc/Player.OnStop ] 2019-08-20 09:05:20.417 T:3491222384 NOTICE: EMBY.hooks.player -> [ skip stop ] http://{emby-server}/emby/Videos/198455/stream?static=true&MediaSourceId={media-id}&api_key={emby-token} 2019-08-20 09:05:20.424 T:3491222384 NOTICE: EMBY.hooks.player -> --<<[ playback ] My Emby installation is behind a reverse proxy, and it's failing to stream from the internal IP: http://10.0.5.143:8096/. It should be using the external URL as configured in Emby server. Edited August 20, 2019 by Saviq Link to comment Share on other sites More sharing options...
nerdwork 0 Posted October 11, 2019 Share Posted October 11, 2019 I'm getting music playback issues, on my Vero4K and Kodi 18.4 on my MacBook Pro. Logs here are from MBP. I've set up a fresh installation of Kodi, added Emby Add-on and synced Movies, TV and Music. Movies and TV work fine. If I select a song to play Music -> Album -> Song it fails playing the first time. If I cancel trying to play, then select the same song again it works. Seeing this repeatedly but just posting a snippet here, from Kodi log and Emby Server log - failed play and subsequent successful song play: Kodi Log 2019-10-11 16:00:29.541 T:123145361600512 WARNING: <[ webservice/105553281684512/0 ] 2019-10-11 16:00:29.543 T:123145361600512 WARNING: <[ webservice/105553280355568/0 ] 2019-10-11 16:00:29.545 T:123145391046656 NOTICE: EMBY.hooks.webservice -> path: http://192.168.1.150:8096/emby/Audio/29634/stream.m4a?api_key=XXXXXXXXX 2019-10-11 16:00:29.545 T:123145361600512 WARNING: <[ webservice/105553148691744/1 ] 2019-10-11 16:00:29.638 T:123145391046656 NOTICE: EMBY.hooks.monitor -> -->[ q:monitor/Playlist.OnClear ] 2019-10-11 16:00:29.640 T:123145395253248 NOTICE: EMBY.hooks.monitor -> -->[ q:monitor/Playlist.OnAdd ] 2019-10-11 16:00:29.640 T:123145395253248 NOTICE: EMBY.objects.monitor -> [ reset autoplay ] 2019-10-11 16:00:29.641 T:123145399459840 NOTICE: EMBY.hooks.monitor -> -->[ q:monitor/Playlist.OnAdd ] 2019-10-11 16:00:29.641 T:123145399459840 NOTICE: EMBY.objects.monitor -> {u'item': {u'type': u'song', u'id': 10618}, u'playlistid': 0, 'MonitorMethod': 'Playlist.OnAdd', u'position': 1} 2019-10-11 16:00:29.642 T:123145395253248 NOTICE: EMBY.objects.monitor -> {u'item': {u'type': u'song', u'id': 10617}, u'playlistid': 0, 'MonitorMethod': 'Playlist.OnAdd', u'position': 0} 2019-10-11 16:00:29.643 T:123145399459840 NOTICE: EMBY.hooks.monitor -> -->[ q:monitor/Playlist.OnAdd ] 2019-10-11 16:00:29.643 T:123145399459840 NOTICE: Previous line repeats 1 times. 2019-10-11 16:00:29.643 T:123145399459840 NOTICE: EMBY.objects.monitor -> {u'item': {u'type': u'song', u'id': 10619}, u'playlistid': 0, 'MonitorMethod': 'Playlist.OnAdd', u'position': 2} 2019-10-11 16:00:29.644 T:123145395253248 NOTICE: EMBY.objects.monitor -> {u'item': {u'type': u'song', u'id': 10620}, u'playlistid': 0, 'MonitorMethod': 'Playlist.OnAdd', u'position': 3} 2019-10-11 16:00:29.645 T:123145399459840 NOTICE: EMBY.hooks.monitor -> -->[ q:monitor/Playlist.OnAdd ] 2019-10-11 16:00:29.645 T:123145399459840 NOTICE: Previous line repeats 1 times. 2019-10-11 16:00:29.645 T:123145399459840 NOTICE: EMBY.objects.monitor -> {u'item': {u'type': u'song', u'id': 10621}, u'playlistid': 0, 'MonitorMethod': 'Playlist.OnAdd', u'position': 4} 2019-10-11 16:00:29.646 T:123145395253248 NOTICE: EMBY.objects.monitor -> {u'item': {u'type': u'song', u'id': 10622}, u'playlistid': 0, 'MonitorMethod': 'Playlist.OnAdd', u'position': 5} 2019-10-11 16:00:29.646 T:123145391046656 NOTICE: EMBY.hooks.monitor -> -->[ q:monitor/Playlist.OnAdd ] 2019-10-11 16:00:29.646 T:123145391046656 NOTICE: EMBY.objects.monitor -> {u'item': {u'type': u'song', u'id': 10623}, u'playlistid': 0, 'MonitorMethod': 'Playlist.OnAdd', u'position': 6} 2019-10-11 16:00:29.647 T:123145395253248 NOTICE: EMBY.hooks.monitor -> -->[ q:monitor/Playlist.OnAdd ] 2019-10-11 16:00:29.647 T:123145395253248 NOTICE: Previous line repeats 1 times. 2019-10-11 16:00:29.647 T:123145395253248 NOTICE: EMBY.objects.monitor -> {u'item': {u'type': u'song', u'id': 10624}, u'playlistid': 0, 'MonitorMethod': 'Playlist.OnAdd', u'position': 7} 2019-10-11 16:00:29.648 T:123145399459840 NOTICE: EMBY.objects.monitor -> {u'item': {u'type': u'song', u'id': 10625}, u'playlistid': 0, 'MonitorMethod': 'Playlist.OnAdd', u'position': 8} 2019-10-11 16:00:29.648 T:123145395253248 NOTICE: EMBY.hooks.monitor -> -->[ q:monitor/Playlist.OnAdd ] 2019-10-11 16:00:29.649 T:123145395253248 NOTICE: Previous line repeats 1 times. 2019-10-11 16:00:29.649 T:123145395253248 NOTICE: EMBY.objects.monitor -> {u'item': {u'type': u'song', u'id': 10626}, u'playlistid': 0, 'MonitorMethod': 'Playlist.OnAdd', u'position': 9} 2019-10-11 16:00:29.649 T:123145399459840 NOTICE: EMBY.hooks.monitor -> -->[ q:monitor/Playlist.OnAdd ] 2019-10-11 16:00:29.649 T:123145391046656 NOTICE: EMBY.objects.monitor -> {u'item': {u'type': u'song', u'id': 10627}, u'playlistid': 0, 'MonitorMethod': 'Playlist.OnAdd', u'position': 10} 2019-10-11 16:00:29.650 T:123145399459840 NOTICE: EMBY.objects.monitor -> {u'item': {u'type': u'song', u'id': 10628}, u'playlistid': 0, 'MonitorMethod': 'Playlist.OnAdd', u'position': 11} 2019-10-11 16:00:29.650 T:123145395253248 NOTICE: EMBY.hooks.monitor -> -->[ q:monitor/Playlist.OnAdd ] 2019-10-11 16:00:29.652 T:123145395253248 NOTICE: Previous line repeats 1 times. 2019-10-11 16:00:29.652 T:123145395253248 NOTICE: EMBY.objects.monitor -> {u'item': {u'type': u'song', u'id': 10629}, u'playlistid': 0, 'MonitorMethod': 'Playlist.OnAdd', u'position': 12} 2019-10-11 16:00:29.653 T:123145391046656 NOTICE: EMBY.objects.monitor -> {u'item': {u'type': u'song', u'id': 10630}, u'playlistid': 0, 'MonitorMethod': 'Playlist.OnAdd', u'position': 13} 2019-10-11 16:00:29.653 T:123145399459840 NOTICE: EMBY.hooks.monitor -> -->[ q:monitor/Playlist.OnAdd ] 2019-10-11 16:00:29.654 T:123145399459840 NOTICE: EMBY.objects.monitor -> {u'item': {u'type': u'song', u'id': 10631}, u'playlistid': 0, 'MonitorMethod': 'Playlist.OnAdd', u'position': 14} 2019-10-11 16:00:29.654 T:123145391046656 NOTICE: EMBY.hooks.monitor -> -->[ q:monitor/Playlist.OnAdd ] 2019-10-11 16:00:29.655 T:123145391046656 NOTICE: Previous line repeats 1 times. 2019-10-11 16:00:29.655 T:123145391046656 NOTICE: EMBY.objects.monitor -> {u'item': {u'type': u'song', u'id': 10632}, u'playlistid': 0, 'MonitorMethod': 'Playlist.OnAdd', u'position': 15} 2019-10-11 16:00:29.655 T:123145395253248 NOTICE: EMBY.objects.monitor -> {u'item': {u'type': u'song', u'id': 10633}, u'playlistid': 0, 'MonitorMethod': 'Playlist.OnAdd', u'position': 16} 2019-10-11 16:00:29.655 T:123145365807104 NOTICE: EMBY.objects.player -> [ onPlayBackStarted ] 2019-10-11 16:00:29.656 T:123145399459840 NOTICE: EMBY.hooks.monitor -> -->[ q:monitor/Playlist.OnAdd ] 2019-10-11 16:00:29.656 T:123145399459840 NOTICE: Previous line repeats 1 times. 2019-10-11 16:00:29.656 T:123145399459840 NOTICE: EMBY.objects.monitor -> {u'item': {u'type': u'song', u'id': 10635}, u'playlistid': 0, 'MonitorMethod': 'Playlist.OnAdd', u'position': 18} 2019-10-11 16:00:29.656 T:123145391046656 NOTICE: EMBY.objects.monitor -> {u'item': {u'type': u'song', u'id': 10634}, u'playlistid': 0, 'MonitorMethod': 'Playlist.OnAdd', u'position': 17} 2019-10-11 16:00:29.657 T:123145365807104 NOTICE: EMBY.objects.monitor -> [ xbmc/Info.OnChanged ] 2019-10-11 16:00:29.659 T:123145395253248 NOTICE: EMBY.hooks.monitor -> -->[ q:monitor/Player.OnPlay ] 2019-10-11 16:00:29.659 T:123145395253248 NOTICE: EMBY.objects.monitor -> [ play ] kodi_id: 10617 media: song 2019-10-11 16:00:33.452 T:123145351413760 ERROR: Open - Error, could not open file http://192.168.1.150:8096/emby/Audio/29634/stream.m4a?api_key=XXXXXXXX 2019-10-11 16:00:33.453 T:123145351413760 ERROR: Init: Error creating demuxer 2019-10-11 16:00:33.453 T:123145351413760 ERROR: CAudioDecoder: Unable to Init Codec while loading file http://127.0.0.1:57578/emby/Audio/29634/stream.m4a 2019-10-11 16:00:33.453 T:123145351413760 WARNING: PAPlayer::QueueNextFileEx - Failed to create the decoder 2019-10-11 16:00:33.466 T:123145361600512 WARNING: <[ webservice/105553282985808/0 ] 2019-10-11 16:00:33.467 T:123145391046656 NOTICE: EMBY.hooks.webservice -> path: http://192.168.1.150:8096/emby/Audio/29649/stream.m4a?api_key=XXXXXXXXXX 2019-10-11 16:00:33.467 T:123145361600512 WARNING: <[ webservice/105553280308176/1 ] 2019-10-11 16:00:33.532 T:123145365807104 NOTICE: EMBY.objects.monitor -> [ xbmc/Player.OnAVStart ] 2019-10-11 16:00:33.533 T:123145365807104 NOTICE: EMBY.objects.player -> [ onAVStarted ] 2019-10-11 16:00:33.533 T:123145365807104 NOTICE: EMBY.hooks.player -> -->[ play/29634 ] {u'PlaySessionId': u'431388f009b243ddafe91785faae64fe', 'Muted': False, u'SubtitleStreamIndex': None, 'Server': <emby.client.EmbyClient object at 0x60000262fea0>, u'MediaSourceId': u'29634', u'AudioStreamIndex': None, u'CurrentEpisode': None, u'ServerId': None, u'Runtime': 859340000, u'Type': u'Audio', u'PlayMethod': u'DirectStream', 'Volume': 100, u'LiveStreamId': None, u'SubsMapping': None, u'CurrentPosition': 4, 'Track': False, 'Paused': False, u'DeviceId': u'240F8449A87848D38BBB2FA57CF6D2BC', 'File': 'http://127.0.0.1:57578/emby/Audio/29634/stream.m4a', u'PlayOption': u'Native', u'Path': u'http://127.0.0.1:57578/emby/Audio/29634/stream.m4a', u'Id': u'29634', u'AutoSwitched': None} 2019-10-11 16:00:34.153 T:123145365807104 NOTICE: EMBY.entrypoint.service -> [ onNotification/plugin.video.emby/UserDataChanged ] 2019-10-11 16:00:34.154 T:123145365807104 NOTICE: EMBY.entrypoint.service -> [ UserDataChanged ] {u'UserId': u'5d46c5fa93b244e39ad3e7e6d5bf1873', u'UserDataList': [{u'ItemId': u'29634', u'IsFavorite': False, u'Played': True, u'LastPlayedDate': u'2019-10-11T05:00:34.0000000+00:00', u'PlaybackPositionTicks': 0, u'PlayCount': 1}, {u'ItemId': u'29596', u'PlayCount': 0, u'PlaybackPositionTicks': 0, u'IsFavorite': False, u'Played': False}]} 2019-10-11 16:00:34.154 T:123145365807104 NOTICE: EMBY.library -> ---[ userdata:2 ] 2019-10-11 16:00:35.005 T:123145386840064 NOTICE: EMBY.library -> -->[ q:download/105553157308960 ] 2019-10-11 16:00:36.025 T:123145391046656 NOTICE: EMBY.downloader -> --<[ q:download/105553157308960/2 ] 2019-10-11 16:00:36.025 T:123145391046656 NOTICE: EMBY.downloader -> --[ q:download/remove ] [] 2019-10-11 16:00:37.658 T:123145391046656 NOTICE: EMBY.hooks.monitor -> -->[ q:monitor/ReportProgressRequested ] 2019-10-11 16:00:38.017 T:123145386840064 NOTICE: EMBY.library -> -->[ q:userdata/MusicAlbum/105553155417248 ] 2019-10-11 16:00:38.059 T:123145395253248 NOTICE: EMBY.objects.core.music -> USERDATA album [792] 29596: ...and Out Come the Wolves 2019-10-11 16:00:38.335 T:123145350877184 ERROR: Open - Error, could not open file http://192.168.1.150:8096/emby/Audio/29649/stream.m4a?api_key=XXXXXXXXXXX 2019-10-11 16:00:38.336 T:123145350877184 ERROR: Init: Error creating demuxer 2019-10-11 16:00:38.336 T:123145350877184 ERROR: CAudioDecoder: Unable to Init Codec while loading file http://127.0.0.1:57578/emby/Audio/29649/stream.m4a 2019-10-11 16:00:38.336 T:123145350877184 WARNING: PAPlayer::QueueNextFileEx - Failed to create the decoder 2019-10-11 16:00:38.374 T:123145365807104 NOTICE: EMBY.objects.monitor -> [ xbmc/Player.OnAVStart ] 2019-10-11 16:00:38.374 T:123145365807104 NOTICE: EMBY.objects.player -> [ onPlayBackStarted ] 2019-10-11 16:00:38.375 T:123145365807104 NOTICE: EMBY.hooks.player -> [ played info ] {u'PlaySessionId': u'431388f009b243ddafe91785faae64fe', 'Muted': False, u'SubtitleStreamIndex': -1, 'Server': <emby.client.EmbyClient object at 0x60000262fea0>, u'MediaSourceId': u'29634', u'AudioStreamIndex': 1, u'CurrentEpisode': None, u'ServerId': None, u'Runtime': 859340000, u'Type': u'Audio', u'PlayMethod': u'DirectStream', 'Volume': 100, u'LiveStreamId': None, u'SubsMapping': None, u'CurrentPosition': 4, 'Track': True, 'Paused': False, u'DeviceId': u'240F8449A87848D38BBB2FA57CF6D2BC', 'File': 'http://127.0.0.1:57578/emby/Audio/29634/stream.m4a', u'PlayOption': u'Native', u'Path': u'http://127.0.0.1:57578/emby/Audio/29634/stream.m4a', u'Id': u'29634', u'AutoSwitched': None} 2019-10-11 16:00:38.403 T:123145365807104 NOTICE: EMBY.objects.monitor -> [ xbmc/Info.OnChanged ] 2019-10-11 16:00:38.404 T:123145399459840 NOTICE: EMBY.hooks.monitor -> -->[ q:monitor/Player.OnPlay ] 2019-10-11 16:00:38.404 T:123145399459840 NOTICE: EMBY.objects.monitor -> [ play ] kodi_id: 10618 media: song 2019-10-11 16:00:38.455 T:123145361600512 WARNING: <[ webservice/105553148691744/0 ] 2019-10-11 16:00:38.458 T:123145403666432 NOTICE: EMBY.hooks.webservice -> path: http://192.168.1.150:8096/emby/Audio/29632/stream.m4a?api_key=XXXXXXXXXX 2019-10-11 16:00:38.458 T:123145361600512 WARNING: <[ webservice/105553281450016/1 ] 2019-10-11 16:00:38.508 T:123145365807104 NOTICE: EMBY.objects.player -> [ onAVStarted ] 2019-10-11 16:00:38.509 T:123145365807104 NOTICE: EMBY.hooks.player -> -->[ play/29649 ] {u'PlaySessionId': u'e38ee4f8f00c4be49c770a28bba6f9d0', 'Muted': False, u'SubtitleStreamIndex': None, 'Server': <emby.client.EmbyClient object at 0x60000262fea0>, u'MediaSourceId': u'29649', u'AudioStreamIndex': None, u'CurrentEpisode': None, u'ServerId': None, u'Runtime': 1480670000, u'Type': u'Audio', u'PlayMethod': u'DirectStream', 'Volume': 100, u'LiveStreamId': None, u'SubsMapping': None, u'CurrentPosition': 4, 'Track': False, 'Paused': False, u'DeviceId': u'240F8449A87848D38BBB2FA57CF6D2BC', 'File': 'http://127.0.0.1:57578/emby/Audio/29649/stream.m4a', u'PlayOption': u'Native', u'Path': u'http://127.0.0.1:57578/emby/Audio/29649/stream.m4a', u'Id': u'29649', u'AutoSwitched': None} 2019-10-11 16:00:39.060 T:123145395253248 NOTICE: EMBY.database -> [emby] 1 rows updated. 2019-10-11 16:00:39.064 T:123145395253248 NOTICE: EMBY.library -> --<[ q:userdata/105553155417248 ] 2019-10-11 16:00:39.133 T:123145365807104 NOTICE: EMBY.entrypoint.service -> [ onNotification/plugin.video.emby/UserDataChanged ] 2019-10-11 16:00:39.134 T:123145365807104 NOTICE: EMBY.entrypoint.service -> [ UserDataChanged ] {u'UserId': u'5d46c5fa93b244e39ad3e7e6d5bf1873', u'UserDataList': [{u'ItemId': u'29634', u'IsFavorite': False, u'Played': True, u'LastPlayedDate': u'2019-10-11T05:00:34.0000000+00:00', u'PlaybackPositionTicks': 0, u'PlayCount': 1}, {u'ItemId': u'29596', u'PlayCount': 0, u'PlaybackPositionTicks': 0, u'IsFavorite': False, u'Played': False}, {u'ItemId': u'29649', u'IsFavorite': False, u'Played': True, u'LastPlayedDate': u'2019-10-11T05:00:39.0000000+00:00', u'PlaybackPositionTicks': 0, u'PlayCount': 1}]} 2019-10-11 16:00:39.135 T:123145365807104 NOTICE: EMBY.library -> ---[ userdata:3 ] 2019-10-11 16:00:39.442 T:123145365807104 NOTICE: EMBY.objects.monitor -> [ xbmc/Player.OnStop ] 2019-10-11 16:00:41.061 T:123145386840064 NOTICE: EMBY.library -> -->[ q:download/105553155494816 ] 2019-10-11 16:00:41.064 T:123145386840064 NOTICE: EMBY.library -> -->[ q:userdata/Audio/105553156702304 ] 2019-10-11 16:00:41.108 T:123145395253248 NOTICE: EMBY.objects.core.music -> USERDATA song [10617] 29634: Maxwell Murder 2019-10-11 16:00:41.164 T:123145395253248 NOTICE: Previous line repeats 1 times. 2019-10-11 16:00:41.164 T:123145395253248 NOTICE: EMBY.objects.core.music -> USERDATA song [10618] 29649: The 11th Hour 2019-10-11 16:00:42.112 T:123145391046656 NOTICE: EMBY.downloader -> --<[ q:download/105553155494816/3 ] 2019-10-11 16:00:42.113 T:123145391046656 NOTICE: EMBY.downloader -> --[ q:download/remove ] [] 2019-10-11 16:00:42.169 T:123145395253248 NOTICE: EMBY.database -> [emby] 3 rows updated. 2019-10-11 16:00:42.173 T:123145395253248 NOTICE: EMBY.database -> [music] 3 rows updated. 2019-10-11 16:00:42.174 T:123145395253248 NOTICE: EMBY.library -> --<[ q:userdata/105553156702304 ] 2019-10-11 16:00:43.712 T:123145351413760 ERROR: Open - Error, could not open file http://192.168.1.150:8096/emby/Audio/29632/stream.m4a?api_key=XXXXXXXXXXX 2019-10-11 16:00:43.713 T:123145351413760 ERROR: Init: Error creating demuxer 2019-10-11 16:00:43.713 T:123145351413760 ERROR: CAudioDecoder: Unable to Init Codec while loading file http://127.0.0.1:57578/emby/Audio/29632/stream.m4a 2019-10-11 16:00:43.713 T:123145351413760 WARNING: PAPlayer::QueueNextFileEx - Failed to create the decoder 2019-10-11 16:00:43.742 T:123145365807104 NOTICE: EMBY.objects.monitor -> [ xbmc/Player.OnAVStart ] 2019-10-11 16:00:43.843 T:123145365807104 NOTICE: EMBY.hooks.player -> [ skip stop ] http://127.0.0.1:57578/emby/Audio/29634/stream.m4a 2019-10-11 16:00:43.843 T:123145365807104 NOTICE: EMBY.hooks.player -> [ played info ] {u'PlaySessionId': u'e38ee4f8f00c4be49c770a28bba6f9d0', 'Muted': False, u'SubtitleStreamIndex': None, 'Server': <emby.client.EmbyClient object at 0x60000262fea0>, u'MediaSourceId': u'29649', u'AudioStreamIndex': None, u'CurrentEpisode': None, u'ServerId': None, u'Runtime': 1480670000, u'Type': u'Audio', u'PlayMethod': u'DirectStream', 'Volume': 100, u'LiveStreamId': None, u'SubsMapping': None, u'CurrentPosition': 4, 'Track': True, 'Paused': False, u'DeviceId': u'240F8449A87848D38BBB2FA57CF6D2BC', 'File': 'http://127.0.0.1:57578/emby/Audio/29649/stream.m4a', u'PlayOption': u'Native', u'Path': u'http://127.0.0.1:57578/emby/Audio/29649/stream.m4a', u'Id': u'29649', u'AutoSwitched': None} 2019-10-11 16:00:43.874 T:123145365807104 NOTICE: EMBY.hooks.player -> --<[ playback ] 2019-10-11 16:00:43.874 T:123145365807104 NOTICE: EMBY.objects.player -> [ onAVStarted ] 2019-10-11 16:00:43.874 T:123145365807104 ERROR: EXCEPTION: XBMC is not playing any file 2019-10-11 16:00:43.874 T:123145365807104 NOTICE: EMBY.helper.wrapper -> ERROR:: XBMC is not playing any file 2019-10-11 16:00:43.874 T:123145365807104 NOTICE: EMBY.hooks.player -> Filename is invalid 2019-10-11 16:00:44.642 T:123145365807104 NOTICE: EMBY.entrypoint.service -> [ onNotification/plugin.video.emby/UserDataChanged ] 2019-10-11 16:00:44.643 T:123145365807104 NOTICE: EMBY.entrypoint.service -> [ UserDataChanged ] {u'UserId': u'5d46c5fa93b244e39ad3e7e6d5bf1873', u'UserDataList': [{u'ItemId': u'29649', u'IsFavorite': False, u'Played': True, u'LastPlayedDate': u'2019-10-11T05:00:39.0000000+00:00', u'PlaybackPositionTicks': 0, u'PlayCount': 1}, {u'ItemId': u'29596', u'PlayCount': 0, u'PlaybackPositionTicks': 0, u'IsFavorite': False, u'Played': False}]} 2019-10-11 16:00:44.643 T:123145365807104 NOTICE: EMBY.library -> ---[ userdata:2 ] 2019-10-11 16:00:46.800 T:123145386840064 NOTICE: EMBY.library -> -->[ q:download/105553157455328 ] 2019-10-11 16:00:46.800 T:123145386840064 NOTICE: EMBY.library -> -->[ q:userdata/MusicAlbum/105553157444256 ] 2019-10-11 16:00:46.840 T:123145395253248 NOTICE: EMBY.objects.core.music -> USERDATA album [792] 29596: ...and Out Come the Wolves 2019-10-11 16:00:47.849 T:123145391046656 NOTICE: Previous line repeats 1 times. 2019-10-11 16:00:47.849 T:123145391046656 NOTICE: EMBY.downloader -> --<[ q:download/105553157455328/2 ] 2019-10-11 16:00:47.849 T:123145391046656 NOTICE: EMBY.downloader -> --[ q:download/remove ] [] 2019-10-11 16:00:47.881 T:123145395253248 NOTICE: EMBY.database -> [emby] 2 rows updated. 2019-10-11 16:00:47.885 T:123145395253248 NOTICE: EMBY.library -> --<[ q:userdata/105553157444256 ] 2019-10-11 16:00:49.844 T:123145386840064 NOTICE: EMBY.library -> -->[ q:userdata/Audio/105553158499872 ] 2019-10-11 16:00:49.883 T:123145391046656 NOTICE: EMBY.objects.core.music -> USERDATA song [10618] 29649: The 11th Hour 2019-10-11 16:00:50.887 T:123145391046656 NOTICE: EMBY.database -> [emby] 1 rows updated. 2019-10-11 16:00:50.889 T:123145391046656 NOTICE: EMBY.database -> [music] 1 rows updated. 2019-10-11 16:00:50.896 T:123145391046656 NOTICE: EMBY.library -> --<[ q:userdata/105553158499872 ] 2019-10-11 16:00:52.910 T:123145386840064 NOTICE: EMBY.library -> --[ sync/2019-10-11T04:58:52z ] 2019-10-11 16:01:12.703 T:123145361600512 WARNING: <[ webservice/105553281273312/0 ] 2019-10-11 16:01:12.704 T:123145361600512 WARNING: <[ webservice/105553211619984/0 ] 2019-10-11 16:01:12.757 T:123145391046656 NOTICE: EMBY.hooks.monitor -> -->[ q:monitor/Playlist.OnClear ] 2019-10-11 16:01:12.758 T:123145395253248 NOTICE: EMBY.hooks.monitor -> -->[ q:monitor/Playlist.OnAdd ] 2019-10-11 16:01:12.758 T:123145395253248 NOTICE: EMBY.objects.monitor -> [ reset autoplay ] 2019-10-11 16:01:12.759 T:123145395253248 NOTICE: EMBY.objects.monitor -> {u'item': {u'type': u'song', u'id': 10617}, u'playlistid': 0, 'MonitorMethod': 'Playlist.OnAdd', u'position': 0} 2019-10-11 16:01:12.760 T:123145395253248 NOTICE: EMBY.hooks.monitor -> -->[ q:monitor/Playlist.OnAdd ] 2019-10-11 16:01:12.760 T:123145395253248 NOTICE: EMBY.objects.monitor -> {u'item': {u'type': u'song', u'id': 10618}, u'playlistid': 0, 'MonitorMethod': 'Playlist.OnAdd', u'position': 1} 2019-10-11 16:01:12.761 T:123145391046656 NOTICE: EMBY.hooks.monitor -> -->[ q:monitor/Playlist.OnAdd ] 2019-10-11 16:01:12.762 T:123145391046656 NOTICE: Previous line repeats 1 times. 2019-10-11 16:01:12.762 T:123145391046656 NOTICE: EMBY.objects.monitor -> {u'item': {u'type': u'song', u'id': 10619}, u'playlistid': 0, 'MonitorMethod': 'Playlist.OnAdd', u'position': 2} 2019-10-11 16:01:12.762 T:123145399459840 NOTICE: EMBY.hooks.monitor -> -->[ q:monitor/Playlist.OnAdd ] 2019-10-11 16:01:12.762 T:123145395253248 NOTICE: EMBY.objects.monitor -> {u'item': {u'type': u'song', u'id': 10620}, u'playlistid': 0, 'MonitorMethod': 'Playlist.OnAdd', u'position': 3} 2019-10-11 16:01:12.763 T:123145391046656 NOTICE: EMBY.hooks.monitor -> -->[ q:monitor/Playlist.OnAdd ] 2019-10-11 16:01:12.763 T:123145399459840 NOTICE: EMBY.objects.monitor -> {u'item': {u'type': u'song', u'id': 10621}, u'playlistid': 0, 'MonitorMethod': 'Playlist.OnAdd', u'position': 4} 2019-10-11 16:01:12.763 T:123145395253248 NOTICE: EMBY.hooks.monitor -> -->[ q:monitor/Playlist.OnAdd ] 2019-10-11 16:01:12.764 T:123145391046656 NOTICE: EMBY.objects.monitor -> {u'item': {u'type': u'song', u'id': 10622}, u'playlistid': 0, 'MonitorMethod': 'Playlist.OnAdd', u'position': 5} 2019-10-11 16:01:12.764 T:123145399459840 NOTICE: EMBY.hooks.monitor -> -->[ q:monitor/Playlist.OnAdd ] 2019-10-11 16:01:12.764 T:123145395253248 NOTICE: EMBY.objects.monitor -> {u'item': {u'type': u'song', u'id': 10623}, u'playlistid': 0, 'MonitorMethod': 'Playlist.OnAdd', u'position': 6} 2019-10-11 16:01:12.764 T:123145399459840 NOTICE: EMBY.objects.monitor -> {u'item': {u'type': u'song', u'id': 10624}, u'playlistid': 0, 'MonitorMethod': 'Playlist.OnAdd', u'position': 7} 2019-10-11 16:01:12.764 T:123145391046656 NOTICE: EMBY.hooks.monitor -> -->[ q:monitor/Playlist.OnAdd ] 2019-10-11 16:01:12.765 T:123145391046656 NOTICE: Previous line repeats 1 times. 2019-10-11 16:01:12.765 T:123145391046656 NOTICE: EMBY.objects.monitor -> {u'item': {u'type': u'song', u'id': 10625}, u'playlistid': 0, 'MonitorMethod': 'Playlist.OnAdd', u'position': 8} 2019-10-11 16:01:12.765 T:123145395253248 NOTICE: EMBY.objects.monitor -> {u'item': {u'type': u'song', u'id': 10626}, u'playlistid': 0, 'MonitorMethod': 'Playlist.OnAdd', u'position': 9} 2019-10-11 16:01:12.766 T:123145391046656 NOTICE: EMBY.hooks.monitor -> -->[ q:monitor/Playlist.OnAdd ] 2019-10-11 16:01:12.766 T:123145391046656 NOTICE: Previous line repeats 1 times. 2019-10-11 16:01:12.766 T:123145391046656 NOTICE: EMBY.objects.monitor -> {u'item': {u'type': u'song', u'id': 10627}, u'playlistid': 0, 'MonitorMethod': 'Playlist.OnAdd', u'position': 10} 2019-10-11 16:01:12.766 T:123145399459840 NOTICE: EMBY.hooks.monitor -> -->[ q:monitor/Playlist.OnAdd ] 2019-10-11 16:01:12.767 T:123145395253248 NOTICE: EMBY.objects.monitor -> {u'item': {u'type': u'song', u'id': 10628}, u'playlistid': 0, 'MonitorMethod': 'Playlist.OnAdd', u'position': 11} 2019-10-11 16:01:12.767 T:123145399459840 NOTICE: EMBY.objects.monitor -> {u'item': {u'type': u'song', u'id': 10629}, u'playlistid': 0, 'MonitorMethod': 'Playlist.OnAdd', u'position': 12} 2019-10-11 16:01:12.767 T:123145391046656 NOTICE: EMBY.hooks.monitor -> -->[ q:monitor/Playlist.OnAdd ] 2019-10-11 16:01:12.768 T:123145391046656 NOTICE: Previous line repeats 2 times. 2019-10-11 16:01:12.768 T:123145391046656 NOTICE: EMBY.objects.monitor -> {u'item': {u'type': u'song', u'id': 10630}, u'playlistid': 0, 'MonitorMethod': 'Playlist.OnAdd', u'position': 13} 2019-10-11 16:01:12.768 T:123145399459840 NOTICE: EMBY.objects.monitor -> {u'item': {u'type': u'song', u'id': 10631}, u'playlistid': 0, 'MonitorMethod': 'Playlist.OnAdd', u'position': 14} 2019-10-11 16:01:12.768 T:123145395253248 NOTICE: EMBY.objects.monitor -> {u'item': {u'type': u'song', u'id': 10632}, u'playlistid': 0, 'MonitorMethod': 'Playlist.OnAdd', u'position': 15} 2019-10-11 16:01:12.769 T:123145391046656 NOTICE: EMBY.hooks.monitor -> -->[ q:monitor/Playlist.OnAdd ] 2019-10-11 16:01:12.769 T:123145365807104 NOTICE: Previous line repeats 1 times. 2019-10-11 16:01:12.769 T:123145365807104 NOTICE: EMBY.objects.player -> [ onPlayBackStarted ] 2019-10-11 16:01:12.769 T:123145391046656 NOTICE: EMBY.objects.monitor -> {u'item': {u'type': u'song', u'id': 10633}, u'playlistid': 0, 'MonitorMethod': 'Playlist.OnAdd', u'position': 16} 2019-10-11 16:01:12.770 T:123145399459840 NOTICE: EMBY.objects.monitor -> {u'item': {u'type': u'song', u'id': 10634}, u'playlistid': 0, 'MonitorMethod': 'Playlist.OnAdd', u'position': 17} 2019-10-11 16:01:12.770 T:123145391046656 NOTICE: EMBY.hooks.monitor -> -->[ q:monitor/Playlist.OnAdd ] 2019-10-11 16:01:12.771 T:123145391046656 NOTICE: EMBY.objects.monitor -> {u'item': {u'type': u'song', u'id': 10635}, u'playlistid': 0, 'MonitorMethod': 'Playlist.OnAdd', u'position': 18} 2019-10-11 16:01:12.771 T:123145365807104 NOTICE: EMBY.objects.monitor -> [ xbmc/Info.OnChanged ] 2019-10-11 16:01:12.774 T:123145399459840 NOTICE: EMBY.hooks.monitor -> -->[ q:monitor/Player.OnPlay ] 2019-10-11 16:01:12.774 T:123145399459840 NOTICE: EMBY.objects.monitor -> [ play ] kodi_id: 10617 media: song 2019-10-11 16:01:12.809 T:123145403666432 NOTICE: EMBY.hooks.webservice -> path: http://192.168.1.150:8096/emby/Audio/29634/stream.m4a?api_key=XXXXXXXXXXX 2019-10-11 16:01:12.809 T:123145361600512 WARNING: <[ webservice/105553282629664/1 ] 2019-10-11 16:01:12.942 T:123145351413760 NOTICE: CDVDAudioCodecFFmpeg::Open() Successful opened audio decoder aac 2019-10-11 16:01:12.947 T:123145403666432 NOTICE: EMBY.hooks.webservice -> path: http://192.168.1.150:8096/emby/Audio/29634/stream.m4a?api_key=XXXXXXXXXXXX 2019-10-11 16:01:12.947 T:123145361600512 WARNING: <[ webservice/105553281390960/1 ] 2019-10-11 16:01:13.079 T:123145365807104 NOTICE: EMBY.objects.monitor -> [ xbmc/Player.OnAVStart ] 2019-10-11 16:01:13.081 T:123145365807104 NOTICE: EMBY.objects.player -> [ onAVStarted ] 2019-10-11 16:01:13.082 T:123145365807104 NOTICE: EMBY.hooks.player -> -->[ play/29634 ] {u'PlaySessionId': u'47c8805ffe1c4f8db947bc9dc8f64fe5', 'Muted': False, u'SubtitleStreamIndex': None, 'Server': <emby.client.EmbyClient object at 0x60000262fea0>, u'MediaSourceId': u'29634', u'AudioStreamIndex': None, u'CurrentEpisode': None, u'ServerId': None, u'Runtime': 859340000, u'Type': u'Audio', u'PlayMethod': u'DirectStream', 'Volume': 100, u'LiveStreamId': None, u'SubsMapping': None, u'CurrentPosition': 0, 'Track': False, 'Paused': False, u'DeviceId': u'240F8449A87848D38BBB2FA57CF6D2BC', 'File': 'http://127.0.0.1:57578/emby/Audio/29634/stream.m4a', u'PlayOption': u'Native', u'Path': u'http://127.0.0.1:57578/emby/Audio/29634/stream.m4a', u'Id': u'29634', u'AutoSwitched': None} 2019-10-11 16:01:13.906 T:123145365807104 NOTICE: EMBY.entrypoint.service -> [ onNotification/plugin.video.emby/UserDataChanged ] 2019-10-11 16:01:13.907 T:123145365807104 NOTICE: EMBY.entrypoint.service -> [ UserDataChanged ] {u'UserId': u'5d46c5fa93b244e39ad3e7e6d5bf1873', u'UserDataList': [{u'ItemId': u'29634', u'IsFavorite': False, u'Played': True, u'LastPlayedDate': u'2019-10-11T05:01:13.0000000+00:00', u'PlaybackPositionTicks': 0, u'PlayCount': 2}, {u'ItemId': u'29596', u'PlayCount': 0, u'PlaybackPositionTicks': 0, u'IsFavorite': False, u'Played': False}]} 2019-10-11 16:01:13.907 T:123145365807104 NOTICE: EMBY.library -> ---[ userdata:2 ] 2019-10-11 16:01:14.132 T:123145386840064 NOTICE: EMBY.library -> -->[ q:download/105553157031776 ] 2019-10-11 16:01:15.148 T:123145391046656 NOTICE: EMBY.downloader -> --<[ q:download/105553157031776/2 ] 2019-10-11 16:01:15.149 T:123145391046656 NOTICE: EMBY.downloader -> --[ q:download/remove ] [] 2019-10-11 16:01:17.153 T:123145386840064 NOTICE: EMBY.library -> -->[ q:userdata/MusicAlbum/105553157039520 ] 2019-10-11 16:01:17.187 T:123145391046656 NOTICE: EMBY.objects.core.music -> USERDATA album [792] 29596: ...and Out Come the Wolves 2019-10-11 16:01:17.204 T:123145395253248 NOTICE: EMBY.hooks.monitor -> -->[ q:monitor/ReportProgressRequested ] 2019-10-11 16:01:18.188 T:123145391046656 NOTICE: EMBY.database -> [emby] 1 rows updated. 2019-10-11 16:01:18.190 T:123145391046656 NOTICE: EMBY.library -> --<[ q:userdata/105553157039520 ] 2019-10-11 16:01:20.190 T:123145386840064 NOTICE: EMBY.library -> -->[ q:userdata/Audio/105553158759008 ] 2019-10-11 16:01:20.230 T:123145391046656 NOTICE: EMBY.objects.core.music -> USERDATA song [10617] 29634: Maxwell Murder 2019-10-11 16:01:21.232 T:123145391046656 NOTICE: EMBY.database -> [emby] 1 rows updated. 2019-10-11 16:01:21.234 T:123145391046656 NOTICE: EMBY.database -> [music] 1 rows updated. 2019-10-11 16:01:21.235 T:123145391046656 NOTICE: EMBY.library -> --<[ q:userdata/105553158759008 ] 2019-10-11 16:01:22.210 T:123145391046656 NOTICE: EMBY.hooks.monitor -> -->[ q:monitor/ReportProgressRequested ] 2019-10-11 16:01:22.210 T:123145391046656 NOTICE: EMBY.objects.player -> [ no next episode detected ] 2019-10-11 16:01:22.925 T:123145365807104 NOTICE: EMBY.objects.monitor -> [ xbmc/Player.OnStop ] 2019-10-11 16:01:23.029 T:123145365807104 NOTICE: EMBY.hooks.player -> [ played info ] {u'PlaySessionId': u'47c8805ffe1c4f8db947bc9dc8f64fe5', 'Muted': False, u'SubtitleStreamIndex': -1, 'Server': <emby.client.EmbyClient object at 0x60000262fea0>, u'MediaSourceId': u'29634', u'AudioStreamIndex': 1, u'CurrentEpisode': None, u'ServerId': None, u'Runtime': 859340000, u'Type': u'Audio', u'PlayMethod': u'DirectStream', 'Volume': 100, u'LiveStreamId': None, u'SubsMapping': None, u'CurrentPosition': 9, 'Track': True, 'Paused': False, u'DeviceId': u'240F8449A87848D38BBB2FA57CF6D2BC', 'File': 'http://127.0.0.1:57578/emby/Audio/29634/stream.m4a', u'PlayOption': u'Native', u'Path': u'http://127.0.0.1:57578/emby/Audio/29634/stream.m4a', u'Id': u'29634', u'AutoSwitched': None} 2019-10-11 16:01:23.059 T:123145365807104 NOTICE: EMBY.hooks.player -> --<[ playback ] 2019-10-11 16:01:23.251 T:123145386840064 NOTICE: EMBY.library -> --[ sync/2019-10-11T04:59:23z ] 2019-10-11 16:01:23.670 T:123145365807104 NOTICE: EMBY.entrypoint.service -> [ onNotification/plugin.video.emby/UserDataChanged ] 2019-10-11 16:01:23.671 T:123145365807104 NOTICE: EMBY.entrypoint.service -> [ UserDataChanged ] {u'UserId': u'5d46c5fa93b244e39ad3e7e6d5bf1873', u'UserDataList': [{u'ItemId': u'29634', u'IsFavorite': False, u'Played': True, u'LastPlayedDate': u'2019-10-11T05:01:13.0000000+00:00', u'PlaybackPositionTicks': 0, u'PlayCount': 2}, {u'ItemId': u'29596', u'PlayCount': 0, u'PlaybackPositionTicks': 0, u'IsFavorite': False, u'Played': False}]} 2019-10-11 16:01:23.671 T:123145365807104 NOTICE: EMBY.library -> ---[ userdata:2 ] 2019-10-11 16:01:26.274 T:123145386840064 NOTICE: EMBY.library -> -->[ q:download/105553157342944 ] 2019-10-11 16:01:27.290 T:123145391046656 NOTICE: EMBY.downloader -> --<[ q:download/105553157342944/2 ] 2019-10-11 16:01:27.291 T:123145391046656 NOTICE: EMBY.downloader -> --[ q:download/remove ] [] 2019-10-11 16:01:29.303 T:123145386840064 NOTICE: EMBY.library -> -->[ q:userdata/MusicAlbum/105553158588448 ] 2019-10-11 16:01:29.338 T:123145391046656 NOTICE: EMBY.objects.core.music -> USERDATA album [792] 29596: ...and Out Come the Wolves 2019-10-11 16:01:30.341 T:123145391046656 NOTICE: EMBY.database -> [emby] 1 rows updated. 2019-10-11 16:01:30.344 T:123145391046656 NOTICE: EMBY.library -> --<[ q:userdata/105553158588448 ] 2019-10-11 16:01:32.345 T:123145386840064 NOTICE: EMBY.library -> -->[ q:userdata/Audio/105553159165664 ] 2019-10-11 16:01:32.382 T:123145391046656 NOTICE: EMBY.objects.core.music -> USERDATA song [10617] 29634: Maxwell Murder 2019-10-11 16:01:33.386 T:123145391046656 NOTICE: EMBY.database -> [emby] 1 rows updated. 2019-10-11 16:01:33.388 T:123145391046656 NOTICE: EMBY.database -> [music] 1 rows updated. 2019-10-11 16:01:33.395 T:123145391046656 NOTICE: EMBY.library -> --<[ q:userdata/105553159165664 ] 2019-10-11 16:01:35.414 T:123145386840064 NOTICE: EMBY.library -> --[ sync/2019-10-11T04:59:35z ] Emby Server Log 2019-10-11 16:00:19.287 Info HttpServer: HTTP Response 206 to 192.168.1.241. Time: 3ms. http://192.168.1.150:8096/emby/Items/29634/Images/Primary/0?EnableImageEnhancers=True&Tag=64959f344463245c3875a95892b5fdf6 2019-10-11 16:00:30.091 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/Audio/29634/stream.m4a. UserAgent: Kodi/18.4 (Macintosh; Intel Mac OS X 10_14_6) App_Bitness/64 Version/18.4-Git:20190831-3ade758ceb 2019-10-11 16:00:30.094 Info App: ProcessRun 'StreamTranscode 4c5ccf' Execute: /Applications/EmbyServer.app/Contents/MacOS/ffmpeg -i file:"/Volumes/Qmultimedia/music/Rancid/Rancid [1995] ...and Out Come the Wolves/01 - Maxwell Murder.m4a" -threads 0 -vn -ac 2 -ar 44100 -id3v2_version 3 -write_id3v1 1 -y "/Users/shaunlowe/.config/emby-server/transcoding-temp/9dc0e57a896242d49cf1c34bc7a86749.m4a" 2019-10-11 16:00:30.103 Info App: ProcessRun 'StreamTranscode 4c5ccf' Started. 2019-10-11 16:00:30.213 Info App: ffmpeg successfully started 2019-10-11 16:00:30.218 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/Users/5d46c5fa93b244e39ad3e7e6d5bf1873/Items/29634. UserAgent: Emby-Kodi/4.1.14 2019-10-11 16:00:30.223 Info HttpServer: HTTP Response 200 to 192.168.1.241. Time: 5ms. http://192.168.1.150:8096/emby/Users/5d46c5fa93b244e39ad3e7e6d5bf1873/Items/29634 2019-10-11 16:00:31.331 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/Audio/29634/stream.m4a. UserAgent: Kodi/18.4 (Macintosh; Intel Mac OS X 10_14_6) App_Bitness/64 Version/18.4-Git:20190831-3ade758ceb 2019-10-11 16:00:31.331 Info HttpServer: SocketException: http://192.168.1.150:8096/emby/Audio/29634/stream.m4a?api_key=XXXXXXXXXXXXXXX 2019-10-11 16:00:31.331 Info HttpServer: HTTP Response 200 to 192.168.1.241. Time: 1240ms. http://192.168.1.150:8096/emby/Audio/29634/stream.m4a 2019-10-11 16:00:31.706 Info App: ProcessRun 'StreamTranscode 4c5ccf' Process exited with code 0 2019-10-11 16:00:31.706 Info App: FFMpeg exited with code 0 2019-10-11 16:00:33.873 Info HttpServer: HTTP Response 200 to 192.168.1.241. Time: 2542ms. http://192.168.1.150:8096/emby/Audio/29634/stream.m4a 2019-10-11 16:00:34.012 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/Audio/29649/stream.m4a. UserAgent: Kodi/18.4 (Macintosh; Intel Mac OS X 10_14_6) App_Bitness/64 Version/18.4-Git:20190831-3ade758ceb 2019-10-11 16:00:34.015 Info App: ProcessRun 'StreamTranscode ba6176' Execute: /Applications/EmbyServer.app/Contents/MacOS/ffmpeg -i file:"/Volumes/Qmultimedia/music/Rancid/Rancid [1995] ...and Out Come the Wolves/02 - The 11th Hour.m4a" -threads 0 -vn -ac 2 -ar 44100 -id3v2_version 3 -write_id3v1 1 -y "/Users/shaunlowe/.config/emby-server/transcoding-temp/ff6b776f62ee9f9dd32686c730b1dd3e.m4a" 2019-10-11 16:00:34.024 Info App: ProcessRun 'StreamTranscode ba6176' Started. 2019-10-11 16:00:34.080 Info HttpServer: HTTP POST http://192.168.1.150:8096/emby/Sessions/Playing. UserAgent: Emby-Kodi/4.1.14 2019-10-11 16:00:34.085 Info SessionManager: Playback start reported by app Kodi 4.1.14 playing Maxwell Murder. Started at 4000 ms 2019-10-11 16:00:34.085 Info HttpServer: HTTP Response 204 to 192.168.1.241. Time: 6ms. http://192.168.1.150:8096/emby/Sessions/Playing 2019-10-11 16:00:34.091 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=7&minDate=2019-10-10T05%3A00%3A33.546Z&hasUserId=true. UserAgent: Mozilla/5.0 (Macintosh; Intel Mac OS X 10.14; rv:69.0) Gecko/20100101 Firefox/69.0 2019-10-11 16:00:34.096 Info HttpServer: HTTP Response 200 to 192.168.1.241. Time: 4ms. http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=7&minDate=2019-10-10T05%3A00%3A33.546Z&hasUserId=true 2019-10-11 16:00:34.096 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=4&minDate=2019-10-04T05%3A00%3A33.547Z&hasUserId=false. UserAgent: Mozilla/5.0 (Macintosh; Intel Mac OS X 10.14; rv:69.0) Gecko/20100101 Firefox/69.0 2019-10-11 16:00:34.099 Info HttpServer: HTTP Response 200 to 192.168.1.241. Time: 4ms. http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=4&minDate=2019-10-04T05%3A00%3A33.547Z&hasUserId=false 2019-10-11 16:00:34.100 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=7&minDate=2019-10-10T05%3A00%3A33.547Z&hasUserId=true. UserAgent: Mozilla/5.0 (Macintosh; Intel Mac OS X 10.14; rv:69.0) Gecko/20100101 Firefox/69.0 2019-10-11 16:00:34.100 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=4&minDate=2019-10-04T05%3A00%3A33.548Z&hasUserId=false. UserAgent: Mozilla/5.0 (Macintosh; Intel Mac OS X 10.14; rv:69.0) Gecko/20100101 Firefox/69.0 2019-10-11 16:00:34.105 Info HttpServer: HTTP Response 200 to 192.168.1.241. Time: 5ms. http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=7&minDate=2019-10-10T05%3A00%3A33.547Z&hasUserId=true 2019-10-11 16:00:34.114 Info HttpServer: HTTP Response 200 to 192.168.1.241. Time: 14ms. http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=4&minDate=2019-10-04T05%3A00%3A33.548Z&hasUserId=false 2019-10-11 16:00:34.129 Info App: ffmpeg successfully started 2019-10-11 16:00:35.139 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/Audio/29649/stream.m4a. UserAgent: Kodi/18.4 (Macintosh; Intel Mac OS X 10_14_6) App_Bitness/64 Version/18.4-Git:20190831-3ade758ceb 2019-10-11 16:00:35.140 Info HttpServer: SocketException: http://192.168.1.150:8096/emby/Audio/29649/stream.m4a?api_key=XXXXXXXXXXX 2019-10-11 16:00:35.140 Info HttpServer: HTTP Response 200 to 192.168.1.241. Time: 1127ms. http://192.168.1.150:8096/emby/Audio/29649/stream.m4a 2019-10-11 16:00:35.554 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/Users/5d46c5fa93b244e39ad3e7e6d5bf1873/Items?Fields=Path%2CGenres%2CSortName%2CStudios%2CWriter%2CTaglines%2CLocalTrailerCount%2CVideo3DFormat%2COfficialRating%2CCumulativeRunTimeTicks%2CItemCounts%2CPremiereDate%2CProductionYear%2CMetascore%2CAirTime%2CDateCreated%2CPeople%2COverview%2CCommunityRating%2CStartDate%2CCriticRating%2CCriticRatingSummary%2CEtag%2CShortOverview%2CProductionLocations%2CTags%2CProviderIds%2CParentId%2CRemoteTrailers%2CSpecialEpisodeNumbers%2CStatus%2CEndDate%2CMediaSources%2CVoteCount%2CRecursiveItemCount%2CPrimaryImageAspectRatio%2CDisplayOrder%2CPresentationUniqueKey%2COriginalTitle&Ids=29634%2C29596. UserAgent: Emby-Kodi/4.1.14 2019-10-11 16:00:35.559 Info HttpServer: HTTP Response 200 to 192.168.1.241. Time: 5ms. http://192.168.1.150:8096/emby/Users/5d46c5fa93b244e39ad3e7e6d5bf1873/Items?Fields=Path%2CGenres%2CSortName%2CStudios%2CWriter%2CTaglines%2CLocalTrailerCount%2CVideo3DFormat%2COfficialRating%2CCumulativeRunTimeTicks%2CItemCounts%2CPremiereDate%2CProductionYear%2CMetascore%2CAirTime%2CDateCreated%2CPeople%2COverview%2CCommunityRating%2CStartDate%2CCriticRating%2CCriticRatingSummary%2CEtag%2CShortOverview%2CProductionLocations%2CTags%2CProviderIds%2CParentId%2CRemoteTrailers%2CSpecialEpisodeNumbers%2CStatus%2CEndDate%2CMediaSources%2CVoteCount%2CRecursiveItemCount%2CPrimaryImageAspectRatio%2CDisplayOrder%2CPresentationUniqueKey%2COriginalTitle&Ids=29634%2C29596 2019-10-11 16:00:36.640 Info App: ProcessRun 'StreamTranscode ba6176' Process exited with code 0 2019-10-11 16:00:36.640 Info App: FFMpeg exited with code 0 2019-10-11 16:00:37.011 Info HttpServer: HTTP SUBSCRIBE http://192.168.1.150:8096/dlna/ddd98d3a76a8409e874beb4b916dc02b/contentdirectory/events. UserAgent: 2019-10-11 16:00:37.011 Info HttpServer: HTTP Response 200 to 192.168.1.7. Time: 0ms. http://192.168.1.150:8096/dlna/ddd98d3a76a8409e874beb4b916dc02b/contentdirectory/events 2019-10-11 16:00:37.357 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/Users/5d46c5fa93b244e39ad3e7e6d5bf1873/Items?Fields=Path%2CGenres%2CSortName%2CStudios%2CWriter%2CTaglines%2CLocalTrailerCount%2CVideo3DFormat%2COfficialRating%2CCumulativeRunTimeTicks%2CItemCounts%2CPremiereDate%2CProductionYear%2CMetascore%2CAirTime%2CDateCreated%2CPeople%2COverview%2CCommunityRating%2CStartDate%2CCriticRating%2CCriticRatingSummary%2CEtag%2CShortOverview%2CProductionLocations%2CTags%2CProviderIds%2CParentId%2CRemoteTrailers%2CSpecialEpisodeNumbers%2CStatus%2CEndDate%2CMediaSources%2CVoteCount%2CRecursiveItemCount%2CPrimaryImageAspectRatio%2CDisplayOrder%2CPresentationUniqueKey%2COriginalTitle&Ids=29634%2C29596. UserAgent: Emby-Kodi/4.1.14 2019-10-11 16:00:37.360 Info HttpServer: HTTP Response 200 to 192.168.1.10. Time: 3ms. http://192.168.1.150:8096/emby/Users/5d46c5fa93b244e39ad3e7e6d5bf1873/Items?Fields=Path%2CGenres%2CSortName%2CStudios%2CWriter%2CTaglines%2CLocalTrailerCount%2CVideo3DFormat%2COfficialRating%2CCumulativeRunTimeTicks%2CItemCounts%2CPremiereDate%2CProductionYear%2CMetascore%2CAirTime%2CDateCreated%2CPeople%2COverview%2CCommunityRating%2CStartDate%2CCriticRating%2CCriticRatingSummary%2CEtag%2CShortOverview%2CProductionLocations%2CTags%2CProviderIds%2CParentId%2CRemoteTrailers%2CSpecialEpisodeNumbers%2CStatus%2CEndDate%2CMediaSources%2CVoteCount%2CRecursiveItemCount%2CPrimaryImageAspectRatio%2CDisplayOrder%2CPresentationUniqueKey%2COriginalTitle&Ids=29634%2C29596 2019-10-11 16:00:38.205 Info HttpServer: HTTP POST http://192.168.1.150:8096/emby/Sessions/Playing/Progress. UserAgent: Emby-Kodi/4.1.14 2019-10-11 16:00:38.206 Info HttpServer: HTTP Response 204 to 192.168.1.241. Time: 1ms. http://192.168.1.150:8096/emby/Sessions/Playing/Progress 2019-10-11 16:00:38.834 Info HttpServer: HTTP Response 200 to 192.168.1.241. Time: 3695ms. http://192.168.1.150:8096/emby/Audio/29649/stream.m4a 2019-10-11 16:00:38.920 Info HttpServer: HTTP POST http://192.168.1.150:8096/emby/Sessions/Playing/Stopped. UserAgent: Emby-Kodi/4.1.14 2019-10-11 16:00:38.921 Info SessionManager: Playback stopped reported by app Kodi 4.1.14 playing Maxwell Murder. Stopped at 4000 ms 2019-10-11 16:00:38.922 Info HttpServer: HTTP Response 204 to 192.168.1.241. Time: 1ms. http://192.168.1.150:8096/emby/Sessions/Playing/Stopped 2019-10-11 16:00:38.927 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=7&minDate=2019-10-10T05%3A00%3A38.382Z&hasUserId=true. UserAgent: Mozilla/5.0 (Macintosh; Intel Mac OS X 10.14; rv:69.0) Gecko/20100101 Firefox/69.0 2019-10-11 16:00:38.927 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=4&minDate=2019-10-04T05%3A00%3A38.383Z&hasUserId=false. UserAgent: Mozilla/5.0 (Macintosh; Intel Mac OS X 10.14; rv:69.0) Gecko/20100101 Firefox/69.0 2019-10-11 16:00:38.928 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=7&minDate=2019-10-10T05%3A00%3A38.384Z&hasUserId=true. UserAgent: Mozilla/5.0 (Macintosh; Intel Mac OS X 10.14; rv:69.0) Gecko/20100101 Firefox/69.0 2019-10-11 16:00:38.929 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=4&minDate=2019-10-04T05%3A00%3A38.384Z&hasUserId=false. UserAgent: Mozilla/5.0 (Macintosh; Intel Mac OS X 10.14; rv:69.0) Gecko/20100101 Firefox/69.0 2019-10-11 16:00:38.929 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/Users/5d46c5fa93b244e39ad3e7e6d5bf1873/Items/29634. UserAgent: Emby-Kodi/4.1.14 2019-10-11 16:00:38.931 Info HttpServer: HTTP Response 200 to 192.168.1.241. Time: 4ms. http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=4&minDate=2019-10-04T05%3A00%3A38.383Z&hasUserId=false 2019-10-11 16:00:38.932 Info HttpServer: HTTP Response 200 to 192.168.1.241. Time: 3ms. http://192.168.1.150:8096/emby/Users/5d46c5fa93b244e39ad3e7e6d5bf1873/Items/29634 2019-10-11 16:00:38.933 Info HttpServer: HTTP Response 200 to 192.168.1.241. Time: 6ms. http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=7&minDate=2019-10-10T05%3A00%3A38.382Z&hasUserId=true 2019-10-11 16:00:38.935 Info HttpServer: HTTP Response 200 to 192.168.1.241. Time: 7ms. http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=7&minDate=2019-10-10T05%3A00%3A38.384Z&hasUserId=true 2019-10-11 16:00:38.936 Info HttpServer: HTTP Response 200 to 192.168.1.241. Time: 7ms. http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=4&minDate=2019-10-04T05%3A00%3A38.384Z&hasUserId=false 2019-10-11 16:00:38.959 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/Users/5d46c5fa93b244e39ad3e7e6d5bf1873/Items/29649. UserAgent: Emby-Kodi/4.1.14 2019-10-11 16:00:38.961 Info HttpServer: HTTP Response 200 to 192.168.1.241. Time: 2ms. http://192.168.1.150:8096/emby/Users/5d46c5fa93b244e39ad3e7e6d5bf1873/Items/29649 2019-10-11 16:00:39.002 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/Audio/29632/stream.m4a. UserAgent: Kodi/18.4 (Macintosh; Intel Mac OS X 10_14_6) App_Bitness/64 Version/18.4-Git:20190831-3ade758ceb 2019-10-11 16:00:39.005 Info App: ProcessRun 'StreamTranscode 4b00d9' Execute: /Applications/EmbyServer.app/Contents/MacOS/ffmpeg -i file:"/Volumes/Qmultimedia/music/Rancid/Rancid [1995] ...and Out Come the Wolves/03 - Roots Radicals.m4a" -threads 0 -vn -ac 2 -ar 44100 -id3v2_version 3 -write_id3v1 1 -y "/Users/shaunlowe/.config/emby-server/transcoding-temp/c521fb2bf23a4c6a90db3f4be56bff2b.m4a" 2019-10-11 16:00:39.014 Info App: ProcessRun 'StreamTranscode 4b00d9' Started. 2019-10-11 16:00:39.055 Info HttpServer: HTTP POST http://192.168.1.150:8096/emby/Sessions/Playing. UserAgent: Emby-Kodi/4.1.14 2019-10-11 16:00:39.061 Info SessionManager: Playback start reported by app Kodi 4.1.14 playing The 11th Hour. Started at 4000 ms 2019-10-11 16:00:39.061 Info HttpServer: HTTP Response 204 to 192.168.1.241. Time: 7ms. http://192.168.1.150:8096/emby/Sessions/Playing 2019-10-11 16:00:39.068 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=7&minDate=2019-10-10T05%3A00%3A38.522Z&hasUserId=true. UserAgent: Mozilla/5.0 (Macintosh; Intel Mac OS X 10.14; rv:69.0) Gecko/20100101 Firefox/69.0 2019-10-11 16:00:39.068 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=4&minDate=2019-10-04T05%3A00%3A38.522Z&hasUserId=false. UserAgent: Mozilla/5.0 (Macintosh; Intel Mac OS X 10.14; rv:69.0) Gecko/20100101 Firefox/69.0 2019-10-11 16:00:39.073 Info HttpServer: HTTP Response 200 to 192.168.1.241. Time: 5ms. http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=7&minDate=2019-10-10T05%3A00%3A38.522Z&hasUserId=true 2019-10-11 16:00:39.073 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=7&minDate=2019-10-10T05%3A00%3A38.525Z&hasUserId=true. UserAgent: Mozilla/5.0 (Macintosh; Intel Mac OS X 10.14; rv:69.0) Gecko/20100101 Firefox/69.0 2019-10-11 16:00:39.079 Info HttpServer: HTTP Response 200 to 192.168.1.241. Time: 6ms. http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=7&minDate=2019-10-10T05%3A00%3A38.525Z&hasUserId=true 2019-10-11 16:00:39.082 Info HttpServer: HTTP Response 200 to 192.168.1.241. Time: 14ms. http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=4&minDate=2019-10-04T05%3A00%3A38.522Z&hasUserId=false 2019-10-11 16:00:39.082 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=4&minDate=2019-10-04T05%3A00%3A38.526Z&hasUserId=false. UserAgent: Mozilla/5.0 (Macintosh; Intel Mac OS X 10.14; rv:69.0) Gecko/20100101 Firefox/69.0 2019-10-11 16:00:39.085 Info HttpServer: HTTP Response 200 to 192.168.1.241. Time: 12ms. http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=4&minDate=2019-10-04T05%3A00%3A38.526Z&hasUserId=false 2019-10-11 16:00:39.169 Info App: ffmpeg successfully started 2019-10-11 16:00:40.176 Info HttpServer: SocketException: http://192.168.1.150:8096/emby/Audio/29632/stream.m4a?api_key=XXXXXXXXXXX 2019-10-11 16:00:40.177 Info HttpServer: HTTP Response 200 to 192.168.1.241. Time: 1174ms. http://192.168.1.150:8096/emby/Audio/29632/stream.m4a 2019-10-11 16:00:40.177 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/Audio/29632/stream.m4a. UserAgent: Kodi/18.4 (Macintosh; Intel Mac OS X 10_14_6) App_Bitness/64 Version/18.4-Git:20190831-3ade758ceb 2019-10-11 16:00:40.456 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/Users/5d46c5fa93b244e39ad3e7e6d5bf1873/Items?Fields=Path%2CGenres%2CSortName%2CStudios%2CWriter%2CTaglines%2CLocalTrailerCount%2CVideo3DFormat%2COfficialRating%2CCumulativeRunTimeTicks%2CItemCounts%2CPremiereDate%2CProductionYear%2CMetascore%2CAirTime%2CDateCreated%2CPeople%2COverview%2CCommunityRating%2CStartDate%2CCriticRating%2CCriticRatingSummary%2CEtag%2CShortOverview%2CProductionLocations%2CTags%2CProviderIds%2CParentId%2CRemoteTrailers%2CSpecialEpisodeNumbers%2CStatus%2CEndDate%2CMediaSources%2CVoteCount%2CRecursiveItemCount%2CPrimaryImageAspectRatio%2CDisplayOrder%2CPresentationUniqueKey%2COriginalTitle&Ids=29634%2C29596%2C29649. UserAgent: Emby-Kodi/4.1.14 2019-10-11 16:00:40.464 Info HttpServer: HTTP Response 200 to 192.168.1.10. Time: 8ms. http://192.168.1.150:8096/emby/Users/5d46c5fa93b244e39ad3e7e6d5bf1873/Items?Fields=Path%2CGenres%2CSortName%2CStudios%2CWriter%2CTaglines%2CLocalTrailerCount%2CVideo3DFormat%2COfficialRating%2CCumulativeRunTimeTicks%2CItemCounts%2CPremiereDate%2CProductionYear%2CMetascore%2CAirTime%2CDateCreated%2CPeople%2COverview%2CCommunityRating%2CStartDate%2CCriticRating%2CCriticRatingSummary%2CEtag%2CShortOverview%2CProductionLocations%2CTags%2CProviderIds%2CParentId%2CRemoteTrailers%2CSpecialEpisodeNumbers%2CStatus%2CEndDate%2CMediaSources%2CVoteCount%2CRecursiveItemCount%2CPrimaryImageAspectRatio%2CDisplayOrder%2CPresentationUniqueKey%2COriginalTitle&Ids=29634%2C29596%2C29649 2019-10-11 16:00:41.617 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/Users/5d46c5fa93b244e39ad3e7e6d5bf1873/Items?Fields=Path%2CGenres%2CSortName%2CStudios%2CWriter%2CTaglines%2CLocalTrailerCount%2CVideo3DFormat%2COfficialRating%2CCumulativeRunTimeTicks%2CItemCounts%2CPremiereDate%2CProductionYear%2CMetascore%2CAirTime%2CDateCreated%2CPeople%2COverview%2CCommunityRating%2CStartDate%2CCriticRating%2CCriticRatingSummary%2CEtag%2CShortOverview%2CProductionLocations%2CTags%2CProviderIds%2CParentId%2CRemoteTrailers%2CSpecialEpisodeNumbers%2CStatus%2CEndDate%2CMediaSources%2CVoteCount%2CRecursiveItemCount%2CPrimaryImageAspectRatio%2CDisplayOrder%2CPresentationUniqueKey%2COriginalTitle&Ids=29634%2C29596%2C29649. UserAgent: Emby-Kodi/4.1.14 2019-10-11 16:00:41.622 Info HttpServer: HTTP Response 200 to 192.168.1.241. Time: 6ms. http://192.168.1.150:8096/emby/Users/5d46c5fa93b244e39ad3e7e6d5bf1873/Items?Fields=Path%2CGenres%2CSortName%2CStudios%2CWriter%2CTaglines%2CLocalTrailerCount%2CVideo3DFormat%2COfficialRating%2CCumulativeRunTimeTicks%2CItemCounts%2CPremiereDate%2CProductionYear%2CMetascore%2CAirTime%2CDateCreated%2CPeople%2COverview%2CCommunityRating%2CStartDate%2CCriticRating%2CCriticRatingSummary%2CEtag%2CShortOverview%2CProductionLocations%2CTags%2CProviderIds%2CParentId%2CRemoteTrailers%2CSpecialEpisodeNumbers%2CStatus%2CEndDate%2CMediaSources%2CVoteCount%2CRecursiveItemCount%2CPrimaryImageAspectRatio%2CDisplayOrder%2CPresentationUniqueKey%2COriginalTitle&Ids=29634%2C29596%2C29649 2019-10-11 16:00:42.008 Info App: ProcessRun 'StreamTranscode 4b00d9' Process exited with code 0 2019-10-11 16:00:42.008 Info App: FFMpeg exited with code 0 2019-10-11 16:00:44.187 Info HttpServer: HTTP Response 200 to 192.168.1.241. Time: 4010ms. http://192.168.1.150:8096/emby/Audio/29632/stream.m4a 2019-10-11 16:00:44.389 Info HttpServer: HTTP POST http://192.168.1.150:8096/emby/Sessions/Playing/Stopped. UserAgent: Emby-Kodi/4.1.14 2019-10-11 16:00:44.390 Info SessionManager: Playback stopped reported by app Kodi 4.1.14 playing The 11th Hour. Stopped at 4000 ms 2019-10-11 16:00:44.390 Info HttpServer: HTTP Response 204 to 192.168.1.241. Time: 1ms. http://192.168.1.150:8096/emby/Sessions/Playing/Stopped 2019-10-11 16:00:44.395 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=7&minDate=2019-10-10T05%3A00%3A43.851Z&hasUserId=true. UserAgent: Mozilla/5.0 (Macintosh; Intel Mac OS X 10.14; rv:69.0) Gecko/20100101 Firefox/69.0 2019-10-11 16:00:44.397 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=4&minDate=2019-10-04T05%3A00%3A43.852Z&hasUserId=false. UserAgent: Mozilla/5.0 (Macintosh; Intel Mac OS X 10.14; rv:69.0) Gecko/20100101 Firefox/69.0 2019-10-11 16:00:44.397 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=7&minDate=2019-10-10T05%3A00%3A43.852Z&hasUserId=true. UserAgent: Mozilla/5.0 (Macintosh; Intel Mac OS X 10.14; rv:69.0) Gecko/20100101 Firefox/69.0 2019-10-11 16:00:44.397 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=4&minDate=2019-10-04T05%3A00%3A43.853Z&hasUserId=false. UserAgent: Mozilla/5.0 (Macintosh; Intel Mac OS X 10.14; rv:69.0) Gecko/20100101 Firefox/69.0 2019-10-11 16:00:44.399 Info HttpServer: HTTP Response 200 to 192.168.1.241. Time: 4ms. http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=7&minDate=2019-10-10T05%3A00%3A43.851Z&hasUserId=true 2019-10-11 16:00:44.399 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/Users/5d46c5fa93b244e39ad3e7e6d5bf1873/Items/29649. UserAgent: Emby-Kodi/4.1.14 2019-10-11 16:00:44.403 Info HttpServer: HTTP Response 200 to 192.168.1.241. Time: 4ms. http://192.168.1.150:8096/emby/Users/5d46c5fa93b244e39ad3e7e6d5bf1873/Items/29649 2019-10-11 16:00:44.406 Info HttpServer: HTTP Response 200 to 192.168.1.241. Time: 9ms. http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=7&minDate=2019-10-10T05%3A00%3A43.852Z&hasUserId=true 2019-10-11 16:00:44.409 Info HttpServer: HTTP Response 200 to 192.168.1.241. Time: 12ms. http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=4&minDate=2019-10-04T05%3A00%3A43.853Z&hasUserId=false 2019-10-11 16:00:44.412 Info HttpServer: HTTP Response 200 to 192.168.1.241. Time: 15ms. http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=4&minDate=2019-10-04T05%3A00%3A43.852Z&hasUserId=false 2019-10-11 16:00:46.546 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/Users/5d46c5fa93b244e39ad3e7e6d5bf1873/Items?Fields=Path%2CGenres%2CSortName%2CStudios%2CWriter%2CTaglines%2CLocalTrailerCount%2CVideo3DFormat%2COfficialRating%2CCumulativeRunTimeTicks%2CItemCounts%2CPremiereDate%2CProductionYear%2CMetascore%2CAirTime%2CDateCreated%2CPeople%2COverview%2CCommunityRating%2CStartDate%2CCriticRating%2CCriticRatingSummary%2CEtag%2CShortOverview%2CProductionLocations%2CTags%2CProviderIds%2CParentId%2CRemoteTrailers%2CSpecialEpisodeNumbers%2CStatus%2CEndDate%2CMediaSources%2CVoteCount%2CRecursiveItemCount%2CPrimaryImageAspectRatio%2CDisplayOrder%2CPresentationUniqueKey%2COriginalTitle&Ids=29649%2C29596. UserAgent: Emby-Kodi/4.1.14 2019-10-11 16:00:46.549 Info HttpServer: HTTP Response 200 to 192.168.1.10. Time: 3ms. http://192.168.1.150:8096/emby/Users/5d46c5fa93b244e39ad3e7e6d5bf1873/Items?Fields=Path%2CGenres%2CSortName%2CStudios%2CWriter%2CTaglines%2CLocalTrailerCount%2CVideo3DFormat%2COfficialRating%2CCumulativeRunTimeTicks%2CItemCounts%2CPremiereDate%2CProductionYear%2CMetascore%2CAirTime%2CDateCreated%2CPeople%2COverview%2CCommunityRating%2CStartDate%2CCriticRating%2CCriticRatingSummary%2CEtag%2CShortOverview%2CProductionLocations%2CTags%2CProviderIds%2CParentId%2CRemoteTrailers%2CSpecialEpisodeNumbers%2CStatus%2CEndDate%2CMediaSources%2CVoteCount%2CRecursiveItemCount%2CPrimaryImageAspectRatio%2CDisplayOrder%2CPresentationUniqueKey%2COriginalTitle&Ids=29649%2C29596 2019-10-11 16:00:47.382 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/Users/5d46c5fa93b244e39ad3e7e6d5bf1873/Items?Fields=Path%2CGenres%2CSortName%2CStudios%2CWriter%2CTaglines%2CLocalTrailerCount%2CVideo3DFormat%2COfficialRating%2CCumulativeRunTimeTicks%2CItemCounts%2CPremiereDate%2CProductionYear%2CMetascore%2CAirTime%2CDateCreated%2CPeople%2COverview%2CCommunityRating%2CStartDate%2CCriticRating%2CCriticRatingSummary%2CEtag%2CShortOverview%2CProductionLocations%2CTags%2CProviderIds%2CParentId%2CRemoteTrailers%2CSpecialEpisodeNumbers%2CStatus%2CEndDate%2CMediaSources%2CVoteCount%2CRecursiveItemCount%2CPrimaryImageAspectRatio%2CDisplayOrder%2CPresentationUniqueKey%2COriginalTitle&Ids=29649%2C29596. UserAgent: Emby-Kodi/4.1.14 2019-10-11 16:00:47.384 Info HttpServer: HTTP Response 200 to 192.168.1.241. Time: 3ms. http://192.168.1.150:8096/emby/Users/5d46c5fa93b244e39ad3e7e6d5bf1873/Items?Fields=Path%2CGenres%2CSortName%2CStudios%2CWriter%2CTaglines%2CLocalTrailerCount%2CVideo3DFormat%2COfficialRating%2CCumulativeRunTimeTicks%2CItemCounts%2CPremiereDate%2CProductionYear%2CMetascore%2CAirTime%2CDateCreated%2CPeople%2COverview%2CCommunityRating%2CStartDate%2CCriticRating%2CCriticRatingSummary%2CEtag%2CShortOverview%2CProductionLocations%2CTags%2CProviderIds%2CParentId%2CRemoteTrailers%2CSpecialEpisodeNumbers%2CStatus%2CEndDate%2CMediaSources%2CVoteCount%2CRecursiveItemCount%2CPrimaryImageAspectRatio%2CDisplayOrder%2CPresentationUniqueKey%2COriginalTitle&Ids=29649%2C29596 2019-10-11 16:01:13.330 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/Users/5d46c5fa93b244e39ad3e7e6d5bf1873/Items/29634. UserAgent: Emby-Kodi/4.1.14 2019-10-11 16:01:13.332 Info HttpServer: HTTP Response 200 to 192.168.1.241. Time: 2ms. http://192.168.1.150:8096/emby/Users/5d46c5fa93b244e39ad3e7e6d5bf1873/Items/29634 2019-10-11 16:01:13.455 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/Audio/29634/stream.m4a. UserAgent: Kodi/18.4 (Macintosh; Intel Mac OS X 10_14_6) App_Bitness/64 Version/18.4-Git:20190831-3ade758ceb 2019-10-11 16:01:13.462 Info HttpServer: SocketException: http://192.168.1.150:8096/emby/Audio/29634/stream.m4a?api_key=XXXXXXXXXXXXXX 2019-10-11 16:01:13.462 Info HttpServer: HTTP Response 200 to 192.168.1.241. Time: 8ms. http://192.168.1.150:8096/emby/Audio/29634/stream.m4a 2019-10-11 16:01:13.462 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/Audio/29634/stream.m4a. UserAgent: Kodi/18.4 (Macintosh; Intel Mac OS X 10_14_6) App_Bitness/64 Version/18.4-Git:20190831-3ade758ceb 2019-10-11 16:01:13.492 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/Audio/29634/stream.m4a. UserAgent: Kodi/18.4 (Macintosh; Intel Mac OS X 10_14_6) App_Bitness/64 Version/18.4-Git:20190831-3ade758ceb 2019-10-11 16:01:13.496 Info HttpServer: SocketException: http://192.168.1.150:8096/emby/Audio/29634/stream.m4a?api_key=XXXXXXXXXXXXXXX 2019-10-11 16:01:13.496 Info HttpServer: HTTP Response 200 to 192.168.1.241. Time: 4ms. http://192.168.1.150:8096/emby/Audio/29634/stream.m4a 2019-10-11 16:01:13.627 Info HttpServer: HTTP POST http://192.168.1.150:8096/emby/Sessions/Playing. UserAgent: Emby-Kodi/4.1.14 2019-10-11 16:01:13.629 Info SessionManager: Playback start reported by app Kodi 4.1.14 playing Maxwell Murder. Started at 0 ms 2019-10-11 16:01:13.629 Info HttpServer: HTTP Response 204 to 192.168.1.241. Time: 2ms. http://192.168.1.150:8096/emby/Sessions/Playing 2019-10-11 16:01:13.634 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=7&minDate=2019-10-10T05%3A01%3A13.090Z&hasUserId=true. UserAgent: Mozilla/5.0 (Macintosh; Intel Mac OS X 10.14; rv:69.0) Gecko/20100101 Firefox/69.0 2019-10-11 16:01:13.634 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=4&minDate=2019-10-04T05%3A01%3A13.090Z&hasUserId=false. UserAgent: Mozilla/5.0 (Macintosh; Intel Mac OS X 10.14; rv:69.0) Gecko/20100101 Firefox/69.0 2019-10-11 16:01:13.636 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=4&minDate=2019-10-04T05%3A01%3A13.091Z&hasUserId=false. UserAgent: Mozilla/5.0 (Macintosh; Intel Mac OS X 10.14; rv:69.0) Gecko/20100101 Firefox/69.0 2019-10-11 16:01:13.637 Info HttpServer: HTTP Response 200 to 192.168.1.241. Time: 3ms. http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=7&minDate=2019-10-10T05%3A01%3A13.090Z&hasUserId=true 2019-10-11 16:01:13.639 Info HttpServer: HTTP Response 200 to 192.168.1.241. Time: 4ms. http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=4&minDate=2019-10-04T05%3A01%3A13.090Z&hasUserId=false 2019-10-11 16:01:13.640 Info HttpServer: HTTP Response 200 to 192.168.1.241. Time: 4ms. http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=4&minDate=2019-10-04T05%3A01%3A13.091Z&hasUserId=false 2019-10-11 16:01:13.641 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=7&minDate=2019-10-10T05%3A01%3A13.090Z&hasUserId=true. UserAgent: Mozilla/5.0 (Macintosh; Intel Mac OS X 10.14; rv:69.0) Gecko/20100101 Firefox/69.0 2019-10-11 16:01:13.643 Info HttpServer: HTTP Response 200 to 192.168.1.241. Time: 2ms. http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=7&minDate=2019-10-10T05%3A01%3A13.090Z&hasUserId=true 2019-10-11 16:01:14.681 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/Users/5d46c5fa93b244e39ad3e7e6d5bf1873/Items?Fields=Path%2CGenres%2CSortName%2CStudios%2CWriter%2CTaglines%2CLocalTrailerCount%2CVideo3DFormat%2COfficialRating%2CCumulativeRunTimeTicks%2CItemCounts%2CPremiereDate%2CProductionYear%2CMetascore%2CAirTime%2CDateCreated%2CPeople%2COverview%2CCommunityRating%2CStartDate%2CCriticRating%2CCriticRatingSummary%2CEtag%2CShortOverview%2CProductionLocations%2CTags%2CProviderIds%2CParentId%2CRemoteTrailers%2CSpecialEpisodeNumbers%2CStatus%2CEndDate%2CMediaSources%2CVoteCount%2CRecursiveItemCount%2CPrimaryImageAspectRatio%2CDisplayOrder%2CPresentationUniqueKey%2COriginalTitle&Ids=29634%2C29596. UserAgent: Emby-Kodi/4.1.14 2019-10-11 16:01:14.683 Info HttpServer: HTTP Response 200 to 192.168.1.241. Time: 3ms. http://192.168.1.150:8096/emby/Users/5d46c5fa93b244e39ad3e7e6d5bf1873/Items?Fields=Path%2CGenres%2CSortName%2CStudios%2CWriter%2CTaglines%2CLocalTrailerCount%2CVideo3DFormat%2COfficialRating%2CCumulativeRunTimeTicks%2CItemCounts%2CPremiereDate%2CProductionYear%2CMetascore%2CAirTime%2CDateCreated%2CPeople%2COverview%2CCommunityRating%2CStartDate%2CCriticRating%2CCriticRatingSummary%2CEtag%2CShortOverview%2CProductionLocations%2CTags%2CProviderIds%2CParentId%2CRemoteTrailers%2CSpecialEpisodeNumbers%2CStatus%2CEndDate%2CMediaSources%2CVoteCount%2CRecursiveItemCount%2CPrimaryImageAspectRatio%2CDisplayOrder%2CPresentationUniqueKey%2COriginalTitle&Ids=29634%2C29596 2019-10-11 16:01:15.565 Info HttpServer: HTTP Response 200 to 192.168.1.241. Time: 2102ms. http://192.168.1.150:8096/emby/Audio/29634/stream.m4a 2019-10-11 16:01:16.936 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/Users/5d46c5fa93b244e39ad3e7e6d5bf1873/Items?Fields=Path%2CGenres%2CSortName%2CStudios%2CWriter%2CTaglines%2CLocalTrailerCount%2CVideo3DFormat%2COfficialRating%2CCumulativeRunTimeTicks%2CItemCounts%2CPremiereDate%2CProductionYear%2CMetascore%2CAirTime%2CDateCreated%2CPeople%2COverview%2CCommunityRating%2CStartDate%2CCriticRating%2CCriticRatingSummary%2CEtag%2CShortOverview%2CProductionLocations%2CTags%2CProviderIds%2CParentId%2CRemoteTrailers%2CSpecialEpisodeNumbers%2CStatus%2CEndDate%2CMediaSources%2CVoteCount%2CRecursiveItemCount%2CPrimaryImageAspectRatio%2CDisplayOrder%2CPresentationUniqueKey%2COriginalTitle&Ids=29634%2C29596. UserAgent: Emby-Kodi/4.1.14 2019-10-11 16:01:16.939 Info HttpServer: HTTP Response 200 to 192.168.1.10. Time: 3ms. http://192.168.1.150:8096/emby/Users/5d46c5fa93b244e39ad3e7e6d5bf1873/Items?Fields=Path%2CGenres%2CSortName%2CStudios%2CWriter%2CTaglines%2CLocalTrailerCount%2CVideo3DFormat%2COfficialRating%2CCumulativeRunTimeTicks%2CItemCounts%2CPremiereDate%2CProductionYear%2CMetascore%2CAirTime%2CDateCreated%2CPeople%2COverview%2CCommunityRating%2CStartDate%2CCriticRating%2CCriticRatingSummary%2CEtag%2CShortOverview%2CProductionLocations%2CTags%2CProviderIds%2CParentId%2CRemoteTrailers%2CSpecialEpisodeNumbers%2CStatus%2CEndDate%2CMediaSources%2CVoteCount%2CRecursiveItemCount%2CPrimaryImageAspectRatio%2CDisplayOrder%2CPresentationUniqueKey%2COriginalTitle&Ids=29634%2C29596 2019-10-11 16:01:17.749 Info HttpServer: HTTP POST http://192.168.1.150:8096/emby/Sessions/Playing/Progress. UserAgent: Emby-Kodi/4.1.14 2019-10-11 16:01:17.751 Info HttpServer: HTTP Response 204 to 192.168.1.241. Time: 2ms. http://192.168.1.150:8096/emby/Sessions/Playing/Progress 2019-10-11 16:01:23.575 Info HttpServer: HTTP POST http://192.168.1.150:8096/emby/Sessions/Playing/Stopped. UserAgent: Emby-Kodi/4.1.14 2019-10-11 16:01:23.576 Info SessionManager: Playback stopped reported by app Kodi 4.1.14 playing Maxwell Murder. Stopped at 9000 ms 2019-10-11 16:01:23.576 Info HttpServer: HTTP Response 204 to 192.168.1.241. Time: 1ms. http://192.168.1.150:8096/emby/Sessions/Playing/Stopped 2019-10-11 16:01:23.582 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=7&minDate=2019-10-10T05%3A01%3A23.037Z&hasUserId=true. UserAgent: Mozilla/5.0 (Macintosh; Intel Mac OS X 10.14; rv:69.0) Gecko/20100101 Firefox/69.0 2019-10-11 16:01:23.582 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=4&minDate=2019-10-04T05%3A01%3A23.038Z&hasUserId=false. UserAgent: Mozilla/5.0 (Macintosh; Intel Mac OS X 10.14; rv:69.0) Gecko/20100101 Firefox/69.0 2019-10-11 16:01:23.583 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=7&minDate=2019-10-10T05%3A01%3A23.038Z&hasUserId=true. UserAgent: Mozilla/5.0 (Macintosh; Intel Mac OS X 10.14; rv:69.0) Gecko/20100101 Firefox/69.0 2019-10-11 16:01:23.583 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/Users/5d46c5fa93b244e39ad3e7e6d5bf1873/Items/29634. UserAgent: Emby-Kodi/4.1.14 2019-10-11 16:01:23.585 Info HttpServer: HTTP Response 200 to 192.168.1.241. Time: 4ms. http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=7&minDate=2019-10-10T05%3A01%3A23.037Z&hasUserId=true 2019-10-11 16:01:23.586 Info HttpServer: HTTP Response 200 to 192.168.1.241. Time: 2ms. http://192.168.1.150:8096/emby/Users/5d46c5fa93b244e39ad3e7e6d5bf1873/Items/29634 2019-10-11 16:01:23.588 Info HttpServer: HTTP Response 200 to 192.168.1.241. Time: 6ms. http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=4&minDate=2019-10-04T05%3A01%3A23.038Z&hasUserId=false 2019-10-11 16:01:23.590 Info HttpServer: HTTP Response 200 to 192.168.1.241. Time: 6ms. http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=7&minDate=2019-10-10T05%3A01%3A23.038Z&hasUserId=true 2019-10-11 16:01:23.591 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=4&minDate=2019-10-04T05%3A01%3A23.038Z&hasUserId=false. UserAgent: Mozilla/5.0 (Macintosh; Intel Mac OS X 10.14; rv:69.0) Gecko/20100101 Firefox/69.0 2019-10-11 16:01:23.593 Info HttpServer: HTTP Response 200 to 192.168.1.241. Time: 2ms. http://192.168.1.150:8096/emby/System/ActivityLog/Entries?startIndex=0&limit=4&minDate=2019-10-04T05%3A01%3A23.038Z&hasUserId=false 2019-10-11 16:01:26.068 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/Users/5d46c5fa93b244e39ad3e7e6d5bf1873/Items?Fields=Path%2CGenres%2CSortName%2CStudios%2CWriter%2CTaglines%2CLocalTrailerCount%2CVideo3DFormat%2COfficialRating%2CCumulativeRunTimeTicks%2CItemCounts%2CPremiereDate%2CProductionYear%2CMetascore%2CAirTime%2CDateCreated%2CPeople%2COverview%2CCommunityRating%2CStartDate%2CCriticRating%2CCriticRatingSummary%2CEtag%2CShortOverview%2CProductionLocations%2CTags%2CProviderIds%2CParentId%2CRemoteTrailers%2CSpecialEpisodeNumbers%2CStatus%2CEndDate%2CMediaSources%2CVoteCount%2CRecursiveItemCount%2CPrimaryImageAspectRatio%2CDisplayOrder%2CPresentationUniqueKey%2COriginalTitle&Ids=29634%2C29596. UserAgent: Emby-Kodi/4.1.14 2019-10-11 16:01:26.070 Info HttpServer: HTTP Response 200 to 192.168.1.10. Time: 3ms. http://192.168.1.150:8096/emby/Users/5d46c5fa93b244e39ad3e7e6d5bf1873/Items?Fields=Path%2CGenres%2CSortName%2CStudios%2CWriter%2CTaglines%2CLocalTrailerCount%2CVideo3DFormat%2COfficialRating%2CCumulativeRunTimeTicks%2CItemCounts%2CPremiereDate%2CProductionYear%2CMetascore%2CAirTime%2CDateCreated%2CPeople%2COverview%2CCommunityRating%2CStartDate%2CCriticRating%2CCriticRatingSummary%2CEtag%2CShortOverview%2CProductionLocations%2CTags%2CProviderIds%2CParentId%2CRemoteTrailers%2CSpecialEpisodeNumbers%2CStatus%2CEndDate%2CMediaSources%2CVoteCount%2CRecursiveItemCount%2CPrimaryImageAspectRatio%2CDisplayOrder%2CPresentationUniqueKey%2COriginalTitle&Ids=29634%2C29596 2019-10-11 16:01:26.823 Info HttpServer: HTTP GET http://192.168.1.150:8096/emby/Users/5d46c5fa93b244e39ad3e7e6d5bf1873/Items?Fields=Path%2CGenres%2CSortName%2CStudios%2CWriter%2CTaglines%2CLocalTrailerCount%2CVideo3DFormat%2COfficialRating%2CCumulativeRunTimeTicks%2CItemCounts%2CPremiereDate%2CProductionYear%2CMetascore%2CAirTime%2CDateCreated%2CPeople%2COverview%2CCommunityRating%2CStartDate%2CCriticRating%2CCriticRatingSummary%2CEtag%2CShortOverview%2CProductionLocations%2CTags%2CProviderIds%2CParentId%2CRemoteTrailers%2CSpecialEpisodeNumbers%2CStatus%2CEndDate%2CMediaSources%2CVoteCount%2CRecursiveItemCount%2CPrimaryImageAspectRatio%2CDisplayOrder%2CPresentationUniqueKey%2COriginalTitle&Ids=29634%2C29596. UserAgent: Emby-Kodi/4.1.14 2019-10-11 16:01:26.826 Info HttpServer: HTTP Response 200 to 192.168.1.241. Time: 3ms. http://192.168.1.150:8096/emby/Users/5d46c5fa93b244e39ad3e7e6d5bf1873/Items?Fields=Path%2CGenres%2CSortName%2CStudios%2CWriter%2CTaglines%2CLocalTrailerCount%2CVideo3DFormat%2COfficialRating%2CCumulativeRunTimeTicks%2CItemCounts%2CPremiereDate%2CProductionYear%2CMetascore%2CAirTime%2CDateCreated%2CPeople%2COverview%2CCommunityRating%2CStartDate%2CCriticRating%2CCriticRatingSummary%2CEtag%2CShortOverview%2CProductionLocations%2CTags%2CProviderIds%2CParentId%2CRemoteTrailers%2CSpecialEpisodeNumbers%2CStatus%2CEndDate%2CMediaSources%2CVoteCount%2CRecursiveItemCount%2CPrimaryImageAspectRatio%2CDisplayOrder%2CPresentationUniqueKey%2COriginalTitle&Ids=29634%2C29596 2019-10-11 16:01:50.003 Info HttpServer: HTTP SUBSCRIBE http://192.168.1.150:8096/dlna/ddd98d3a76a8409e874beb4b916dc02b/contentdirectory/events. UserAgent: 2019-10-11 16:01:50.003 Info HttpServer: HTTP Response 200 to 192.168.1.7. Time: 0ms. http://192.168.1.150:8096/dlna/ddd98d3a76a8409e874beb4b916dc02b/contentdirectory/events API Keys removed. I can perform further testing on this and other devices and provide full logs if needed. Link to comment Share on other sites More sharing options...
Luke 36881 Posted October 11, 2019 Share Posted October 11, 2019 Hi there, how does the web app compare? Link to comment Share on other sites More sharing options...
nerdwork 0 Posted October 11, 2019 Share Posted October 11, 2019 Hi there, how does the web app compare? No issues with web app or iOS apps. I don’t think it’s a server issue, it’s something with Kodi addon or Kodi itself. I’d like to nail the issue down, happy to try any testing you suggest. Link to comment Share on other sites More sharing options...
Luke 36881 Posted October 19, 2019 Share Posted October 19, 2019 Are you still running into this? Link to comment Share on other sites More sharing options...
nerdwork 0 Posted October 19, 2019 Share Posted October 19, 2019 Are you still running into this? I am Luke. Just tested again on my Vero4K, same issue persists. Any other logs or anything I can grab? Link to comment Share on other sites More sharing options...
Recommended Posts