18:39:32 T:18446744072287368120 DEBUG: Radio UECP (RDS) Processor - new CDVDRadioRDSData 18:39:32 T:18446744072287368120 NOTICE: VideoPlayer: Opening: http://d1l0nb3g075aoz.cloudfront.net/dm/1$AOAGZA014O5RE,55B43369/videoquality$1080p/b/e/6/be6f77bd-6944-47d4-b9ae-2253954f9a37/843ce528-e0de-4b68-9258-08a076280459_corrected.mpd 18:39:32 T:18446744072287368120 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 18:39:32 T:18446744072287368120 DEBUG: CCurlFile::GetMimeType - http://d1l0nb3g075aoz.cloudfront.net/dm/1$AOAGZA014O5RE,55B43369/videoquality$1080p/b/e/6/be6f77bd-6944-47d4-b9ae-2253954f9a37/843ce528-e0de-4b68-9258-08a076280459_corrected.mpd -> application/octet-stream 18:39:32 T:18446744072287368120 DEBUG: LinuxRendererGL: Cleaning up GL resources 18:39:32 T:18446744072310926472 DEBUG: Thread VideoPlayer start, auto delete: false 18:39:32 T:18446744072310926472 NOTICE: Creating InputStream 18:39:32 T:18446744072310926472 DEBUG: ADDON: Dll Initializing - InputStream MPEG DASH 18:39:32 T:18446744072310926472 DEBUG: SECTION:LoadDLL(/data/app/org.xbmc.kodi-1/lib/arm/libinputstream.mpd.so) 18:39:32 T:18446744072310926472 DEBUG: Loading: /data/app/org.xbmc.kodi-1/lib/arm/libinputstream.mpd.so 18:39:32 T:18446744072310926472 DEBUG: AddOnLog: InputStream MPEG DASH: libXBMC_addon successfully loaded 18:39:32 T:18446744072310926472 DEBUG: AddOnLog: InputStream MPEG DASH: ADDON_Create() 18:39:32 T:18446744072310926472 INFO: AddOnLog: InputStream MPEG DASH: SetVideoResolution (1920 x 1080) 18:39:32 T:18446744072310926472 DEBUG: AddOnLog: InputStream MPEG DASH: Open() 18:39:32 T:18446744072310926472 DEBUG: AddOnLog: InputStream MPEG DASH: found inputstream.mpd.license_key: [not shown] 18:39:32 T:18446744072310926472 DEBUG: AddOnLog: InputStream MPEG DASH: found inputstream.mpd.license_type: com.widevine.alpha 18:39:32 T:18446744072310926472 DEBUG: AddOnLog: InputStream MPEG DASH: Initial bandwidth: 0 18:39:32 T:18446744072310926472 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream MPEG DASH' requests setting 'MAXRESOLUTION' 18:39:32 T:18446744072310926472 DEBUG: AddOnLog: InputStream MPEG DASH: MAXRESOLUTION selected: 1 18:39:32 T:18446744072310926472 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream MPEG DASH' requests setting 'STREAMSELECTION' 18:39:32 T:18446744072310926472 DEBUG: AddOnLog: InputStream MPEG DASH: STREAMSELECTION selected: 1 18:39:32 T:18446744072310926472 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream MPEG DASH' requests setting 'MEDIATYPE' 18:39:32 T:18446744072310926472 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'InputStream MPEG DASH' requests setting 'DECRYPTERPATH' 18:39:32 T:18446744072310926472 DEBUG: AddOnLog: InputStream MPEG DASH: Searching for decrypters in: /storage/emulated/0/Android/data/org.xbmc.kodi/files/.kodi/cdm 18:39:32 T:18446744072310926472 DEBUG: AddOnLog: InputStream MPEG DASH: Supported URN: 18:39:32 T:18446744072310926472 DEBUG: CurlFile::Open(0xac9813f8) http://d1l0nb3g075aoz.cloudfront.net/dm/1$AOAGZA014O5RE,55B43369/videoquality$1080p/b/e/6/be6f77bd-6944-47d4-b9ae-2253954f9a37/843ce528-e0de-4b68-9258-08a076280459_corrected.mpd 18:39:32 T:18446744072316917184 DEBUG: UPnP Translated id to 'musicdb://artists/18/?albumartistsonly=false' 18:39:32 T:18446744072316917184 INFO: UPnP: Received Browse DirectChildren request for object 'musicdb://artists/18/?albumartistsonly=false', with sort criteria 18:39:32 T:18446744072316917184 DEBUG: GetAlbumsByWhere query: SELECT albumview.* FROM albumview WHERE (EXISTS (SELECT 1 FROM song JOIN song_artist ON song.idSong = song_artist.idSong WHERE song.idAlbum = albumview.idAlbum AND song_artist.idArtist = 18 AND song_artist.idRole = 1 ) OR EXISTS (SELECT 1 FROM album_artist WHERE album_artist.idAlbum = albumview.idAlbum AND album_artist.idArtist = 18)) 18:39:33 T:18446744072316917184 DEBUG: GetAlbumsByWhere - query took 362 ms 18:39:33 T:18446744072316917184 DEBUG: Custom album format = [%B] 18:39:33 T:18446744072316917184 DEBUG: Building UPnP response with filter 'res@resolution,res@nrAudioChannels,res@sampleFrequency,res@bitrate,dc:creator,res@dlna:cleartextSize,dc:date,upnp:genre,res,res@duration,res@size,upnp:albumArtURI,upnp:originalTrackNumber,upnp:album,upnp:artist,upnp:author', starting @ 0 with 30 requested 18:39:33 T:18446744072287368120 DEBUG: ------ Window Init (DialogBusy.xml) ------ 18:39:33 T:18446744072287368120 DEBUG: Window DialogBusy.xml was already loaded 18:39:33 T:18446744072287368120 DEBUG: Alloc resources: 0.04ms 18:39:33 T:18446744072316917184 DEBUG: Preparing upnp object for item 'musicdb://artists/18/30/?albumartistsonly=false&artistid=18' 18:39:33 T:18446744072316917184 DEBUG: UPnP: Building didl for object 'musicdb://artists/18/30/?albumartistsonly=false&artistid=18' 18:39:33 T:18446744072316917184 DEBUG: Preparing upnp object for item 'musicdb://artists/18/34/?albumartistsonly=false&artistid=18' 18:39:33 T:18446744072316917184 DEBUG: UPnP: Building didl for object 'musicdb://artists/18/34/?albumartistsonly=false&artistid=18' 18:39:33 T:18446744072316917184 DEBUG: Preparing upnp object for item 'musicdb://artists/18/35/?albumartistsonly=false&artistid=18' 18:39:33 T:18446744072316917184 DEBUG: UPnP: Building didl for object 'musicdb://artists/18/35/?albumartistsonly=false&artistid=18' 18:39:33 T:18446744072316917184 DEBUG: Preparing upnp object for item 'musicdb://artists/18/36/?albumartistsonly=false&artistid=18' 18:39:33 T:18446744072316917184 DEBUG: UPnP: Building didl for object 'musicdb://artists/18/36/?albumartistsonly=false&artistid=18' 18:39:33 T:18446744072316917184 DEBUG: Preparing upnp object for item 'musicdb://artists/18/37/?albumartistsonly=false&artistid=18' 18:39:33 T:18446744072316917184 DEBUG: UPnP: Building didl for object 'musicdb://artists/18/37/?albumartistsonly=false&artistid=18' 18:39:33 T:18446744072316917184 DEBUG: Preparing upnp object for item 'musicdb://artists/18/33/?albumartistsonly=false&artistid=18' 18:39:33 T:18446744072316917184 DEBUG: UPnP: Building didl for object 'musicdb://artists/18/33/?albumartistsonly=false&artistid=18' 18:39:33 T:18446744072316917184 DEBUG: Preparing upnp object for item 'musicdb://artists/18/31/?albumartistsonly=false&artistid=18' 18:39:33 T:18446744072316917184 DEBUG: UPnP: Building didl for object 'musicdb://artists/18/31/?albumartistsonly=false&artistid=18' 18:39:33 T:18446744072316917184 DEBUG: Preparing upnp object for item 'musicdb://artists/18/32/?albumartistsonly=false&artistid=18' 18:39:33 T:18446744072316917184 DEBUG: UPnP: Building didl for object 'musicdb://artists/18/32/?albumartistsonly=false&artistid=18' 18:39:33 T:18446744072316917184 DEBUG: Preparing upnp object for item 'musicdb://artists/18/38/?albumartistsonly=false&artistid=18' 18:39:33 T:18446744072316917184 DEBUG: UPnP: Building didl for object 'musicdb://artists/18/38/?albumartistsonly=false&artistid=18' 18:39:33 T:18446744072316917184 DEBUG: Preparing upnp object for item 'musicdb://artists/18/39/?albumartistsonly=false&artistid=18' 18:39:33 T:18446744072316917184 DEBUG: UPnP: Building didl for object 'musicdb://artists/18/39/?albumartistsonly=false&artistid=18' 18:39:33 T:18446744072316917184 DEBUG: Preparing upnp object for item 'musicdb://artists/18/40/?albumartistsonly=false&artistid=18' 18:39:33 T:18446744072316917184 DEBUG: UPnP: Building didl for object 'musicdb://artists/18/40/?albumartistsonly=false&artistid=18' 18:39:33 T:18446744072316917184 DEBUG: Returning UPnP response with 11 items out of 11 total matches 18:39:33 T:18446744072310926472 DEBUG: AddOnLog: InputStream MPEG DASH: Download http://d1l0nb3g075aoz.cloudfront.net/dm/1$AOAGZA014O5RE,55B43369/videoquality$1080p/b/e/6/be6f77bd-6944-47d4-b9ae-2253954f9a37/843ce528-e0de-4b68-9258-08a076280459_corrected.mpd finished 18:39:33 T:18446744072310926472 ERROR: AddOnLog: InputStream MPEG DASH: Could not open / parse mpdURL (http://d1l0nb3g075aoz.cloudfront.net/dm/1$AOAGZA014O5RE,55B43369/videoquality$1080p/b/e/6/be6f77bd-6944-47d4-b9ae-2253954f9a37/843ce528-e0de-4b68-9258-08a076280459_corrected.mpd) 18:39:33 T:18446744072310926472 DEBUG: AddOnLog: InputStream MPEG DASH: GetStreamIds() 18:39:33 T:18446744072310926472 ERROR: CVideoPlayer::OpenInputStream - error opening [http://d1l0nb3g075aoz.cloudfront.net/dm/1$AOAGZA014O5RE,55B43369/videoquality$1080p/b/e/6/be6f77bd-6944-47d4-b9ae-2253954f9a37/843ce528-e0de-4b68-9258-08a076280459_corrected.mpd] 18:39:33 T:18446744072310926472 NOTICE: CVideoPlayer::OnExit() 18:39:33 T:18446744072310926472 DEBUG: AddOnLog: InputStream MPEG DASH: Close() 18:39:33 T:18446744072310926472 INFO: ADDON: Dll Stopped - InputStream MPEG DASH 18:39:33 T:18446744072310926472 DEBUG: OnPlayBackStopped: play state was 1, starting 1 18:39:33 T:18446744072310926472 DEBUG: Thread VideoPlayer 18446744072310926472 terminating 18:39:33 T:18446744072287368120 DEBUG: OnPlayBackStopped: play state was 3, starting 0 18:39:33 T:18446744072287368120 ERROR: Playlist Player: skipping unplayable item: 0, path [plugin://plugin.video.amazon-test/?asin=B00KP1TE24&mode=PlayVideo&adult=0&name=Star+Trek+VIII%3A+First+Contact+%5BOV%5D&trailer=0&selbitrate=0] 18:39:33 T:18446744072287368120 DEBUG: Playlist Player: no more playable items... aborting playback 18:39:33 T:18446744072333277512 DEBUG: Thread BackgroundLoader start, auto delete: false 18:39:33 T:18446744072287368120 DEBUG: Keyboard: scancode: 0x42, sym: 0x000d, unicode: 0x000a, modifier: 0x0 18:39:33 T:18446744072287381928 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc 18:39:33 T:18446744072287381928 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop 18:39:33 T:18446744072287368120 NOTICE: CVideoPlayer::CloseFile() 18:39:33 T:18446744072287368120 NOTICE: VideoPlayer: waiting for threads to exit 18:39:33 T:18446744072287368120 NOTICE: VideoPlayer: finished waiting 18:39:33 T:18446744072287368120 DEBUG: DeleteRenderer - deleting renderer 18:39:33 T:18446744072287368120 DEBUG: LinuxRendererGL: Cleaning up GL resources 18:39:33 T:18446744072287368120 NOTICE: CVideoPlayer::CloseFile() 18:39:33 T:18446744072287368120 NOTICE: VideoPlayer: waiting for threads to exit 18:39:33 T:18446744072287368120 NOTICE: VideoPlayer: finished waiting 18:39:33 T:18446744072287368120 DEBUG: Radio UECP (RDS) Processor - delete ~CDVDRadioRDSData 18:39:33 T:18446744072295204968 DEBUG: Skin Helper Service --> Kodi_Monitor: sender xbmc - method: Player.OnStop - data: {"end":false,"item":{"title":"Star Trek VIII: First Contact [OV]","type":"movie","year":1996}} 18:39:33 T:18446744072295204968 DEBUG: Skin Helper Service --> Video database changed - type: movie - resetAll: False, refreshing widgets.... 18:39:33 T:18446744072333277512 DEBUG: Thread BackgroundLoader 18446744072333277512 terminating 18:39:33 T:18446744072287368120 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 18:39:33 T:18446744072316761912 DEBUG: DoWork - Saving file state for video item plugin://plugin.video.amazon-test/?asin=B00KP1TE24&mode=PlayVideo&adult=0&name=Star+Trek+VIII%3A+First+Contact+%5BOV%5D&trailer=0&selbitrate=0 18:39:33 T:18446744072316761912 DEBUG: Mysql execute: insert into files (idFile, idPath, strFileName) values(NULL, 662, 'plugin://plugin.video.amazon-test/?asin=B00KP1TE24&mode=PlayVideo&adult=0&name=Star+Trek+VIII%3A+First+Contact+%5BOV%5D&trailer=0&selbitrate=0') 18:39:33 T:18446744072316761912 DEBUG: Mysql execute: update files set playCount=NULL,lastPlayed='2016-11-06 18:39:33' where idFile=2512 18:39:33 T:18446744072316761912 DEBUG: Mysql Start transaction 18:39:33 T:18446744072316761912 DEBUG: Mysql execute: DELETE FROM streamdetails WHERE idFile = 2512 18:39:33 T:18446744072316761912 DEBUG: Mysql execute: INSERT INTO streamdetails (idFile, iStreamType, strVideoCodec, fVideoAspect, iVideoWidth, iVideoHeight, iVideoDuration, strStereoMode, strVideoLanguage) VALUES (2512,0,'',0.000000,1920,1080,0,'','') 18:39:33 T:18446744072316761912 DEBUG: Mysql execute: INSERT INTO streamdetails (idFile, iStreamType, strAudioCodec, iAudioChannels, strAudioLanguage) VALUES (2512,1,'ac3',6,'') 18:39:33 T:18446744072316761912 DEBUG: Mysql commit transaction