1. ##############################################################
  2. Content of MrMC Log
  3. ##############################################################
  4. 10:09:20.710 T:6140620800 NOTICE: special://profile/ is mapped to: special://masterprofile/
  5. 10:09:20.711 T:6140620800 NOTICE: -----------------------------------------------------------------------
  6. 10:09:20.711 T:6140620800 NOTICE: Starting MrMC (3.7-1 Git:2018-12-10-ffaedaf). Platform: TVOS ARM64 64-bit
  7. 10:09:20.711 T:6140620800 NOTICE: Using Release MrMC x64 build
  8. 10:09:20.711 T:6140620800 NOTICE: MrMC compiled Dec 10 2018 by Clang 10.0.0 (clang-1000.11.45.5) for TVOS ARM64 64-bit version 10.2.0 (100200)
  9. 10:09:20.711 T:6140620800 NOTICE: Running on Apple Inc. AppleTV6,2 with TVOS 12.1.1, kernel: Darwin ARM 64-bit version 18.2.0
  10. 10:09:20.711 T:6140620800 NOTICE: Host CPU: arm64 v8, 3 cores available
  11. 10:09:20.711 T:6140620800 NOTICE: ARM Features: Neon enabled
  12. 10:09:20.711 T:6140620800 NOTICE: special://xbmc/ is mapped to: /private/var/containers/Bundle/Application/69FC7311-4838-4F49-BB51-F1976B1645C6/MrMC.app/AppData/AppHome
  13. 10:09:20.711 T:6140620800 NOTICE: special://xbmcbin/ is mapped to: /private/var/containers/Bundle/Application/69FC7311-4838-4F49-BB51-F1976B1645C6/MrMC.app/AppData/AppHome
  14. 10:09:20.711 T:6140620800 NOTICE: special://masterprofile/ is mapped to: /var/mobile/Containers/Data/Application/57282B23-8E36-4342-9788-26AAC2138188/Library/Caches/home/userdata
  15. 10:09:20.711 T:6140620800 NOTICE: special://home/ is mapped to: /var/mobile/Containers/Data/Application/57282B23-8E36-4342-9788-26AAC2138188/Library/Caches/home
  16. 10:09:20.711 T:6140620800 NOTICE: special://temp/ is mapped to: /private/var/mobile/Containers/Data/Application/57282B23-8E36-4342-9788-26AAC2138188/tmp/temp
  17. 10:09:20.711 T:6140620800 NOTICE: special://logs/ is mapped to: /var/mobile/Containers/Data/Application/57282B23-8E36-4342-9788-26AAC2138188/Library/Caches/logs/
  18. 10:09:20.711 T:6140620800 NOTICE: special://frameworks/ is mapped to: /var/containers/Bundle/Application/69FC7311-4838-4F49-BB51-F1976B1645C6/MrMC.app/Frameworks
  19. 10:09:20.711 T:6140620800 NOTICE: The executable running is: /var/containers/Bundle/Application/69FC7311-4838-4F49-BB51-F1976B1645C6/MrMC.app/MrMC
  20. 10:09:20.711 T:6140620800 NOTICE: Local hostname: Living-Room
  21. 10:09:20.711 T:6140620800 NOTICE: Log File is located: special://logs/mrmc.log
  22. 10:09:20.711 T:6140620800 NOTICE: -----------------------------------------------------------------------
  23. 10:09:20.744 T:6140620800 NOTICE: load settings...
  24. 10:09:20.752 T:6140620800 WARNING: CSettingString: unknown options filler "timezonecountries" of "locale.timezonecountry"
  25. 10:09:20.752 T:6140620800 WARNING: CSettingString: unknown options filler "timezones" of "locale.timezone"
  26. 10:09:20.753 T:6140620800 WARNING: CSettingInt: unknown options filler "audiocdactions" of "audiocds.autoaction"
  27. 10:09:20.756 T:6140620800 WARNING: CSetting: duplicate <update> definition for "lookandfeel.soundskin"
  28. 10:09:20.756 T:6140620800 ERROR: CSetting: missing <control> tag of "videoscreen.vsync"
  29. 10:09:20.756 T:6140620800 WARNING: CSettingGroup: unable to read setting "videoscreen.vsync"
  30. 10:09:20.757 T:6140620800 NOTICE: Found 1 Lists of Devices
  31. 10:09:20.757 T:6140620800 NOTICE: Enumerated DARWINIOS devices:
  32. 10:09:20.757 T:6140620800 NOTICE: Device 1
  33. 10:09:20.757 T:6140620800 NOTICE: m_deviceName : default
  34. 10:09:20.757 T:6140620800 NOTICE: m_displayName : Default
  35. 10:09:20.757 T:6140620800 NOTICE: m_displayNameExtra:
  36. 10:09:20.757 T:6140620800 NOTICE: m_deviceType : AE_DEVTYPE_HDMI
  37. 10:09:20.757 T:6140620800 NOTICE: m_channels : FL,FR,FC,LFE,BL,BR,SL,SR
  38. 10:09:20.757 T:6140620800 NOTICE: m_sampleRates : 44100,48000
  39. 10:09:20.758 T:6140620800 NOTICE: m_dataFormats : AE_FMT_RAW,AE_FMT_S16LE,AE_FMT_FLOAT
  40. 10:09:20.758 T:6140620800 NOTICE: m_streamTypes : STREAM_TYPE_AC3,STREAM_TYPE_EAC3,STREAM_TYPE_DTS_512,STREAM_TYPE_DTS_1024,STREAM_TYPE_DTS_2048,STREAM_TYPE_DTSHD_CORE
  41. 10:09:20.823 T:6140620800 NOTICE: No settings file to load (special://xbmc/system/advancedsettings.xml)
  42. 10:09:20.823 T:6140620800 NOTICE: No settings file to load (special://masterprofile/advancedsettings.xml)
  43. 10:09:20.823 T:6140620800 NOTICE: Default DVD Player: dvdplayer
  44. 10:09:20.823 T:6140620800 NOTICE: Default Video Player: dvdplayer
  45. 10:09:20.823 T:6140620800 NOTICE: Default Audio Player: paplayer
  46. 10:09:20.823 T:6140620800 NOTICE: Enabled debug logging due to GUI setting (2)
  47. 10:09:20.823 T:6140620800 NOTICE: Log level changed to "LOG_LEVEL_DEBUG_FREEMEM"
  48. 10:09:20.823 T:6140620800 NOTICE: CMediaSourceSettings: loading media sources from special://masterprofile/sources.xml
  49. 10:09:20.823 T:6140620800 DEBUG: found key /userdata/sources.xml
  50. 10:09:20.824 T:6140620800 NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml.
  51. 10:09:20.825 T:6140620800 DEBUG: CPlayerCoreConfig::<ctor>: created player DVDPlayer for core 1
  52. 10:09:20.825 T:6140620800 DEBUG: CPlayerCoreConfig::<ctor>: created player oldmplayercore for core 1
  53. 10:09:20.825 T:6140620800 DEBUG: CPlayerCoreConfig::<ctor>: created player PAPlayer for core 3
  54. 10:09:20.825 T:6140620800 DEBUG: CPlayerSelectionRule::Initialize: creating rule: system rules
  55. 10:09:20.825 T:6140620800 DEBUG: CPlayerSelectionRule::Initialize: creating rule: hdhomerun/mms/udp
  56. 10:09:20.825 T:6140620800 DEBUG: CPlayerSelectionRule::Initialize: creating rule: lastfm/shout
  57. 10:09:20.825 T:6140620800 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtmp
  58. 10:09:20.825 T:6140620800 DEBUG: CPlayerSelectionRule::Initialize: creating rule: rtsp
  59. 10:09:20.825 T:6140620800 DEBUG: CPlayerSelectionRule::Initialize: creating rule: streams
  60. 10:09:20.825 T:6140620800 DEBUG: CPlayerSelectionRule::Initialize: creating rule: aacp/sdp
  61. 10:09:20.825 T:6140620800 DEBUG: CPlayerSelectionRule::Initialize: creating rule: mp2
  62. 10:09:20.825 T:6140620800 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvd
  63. 10:09:20.825 T:6140620800 DEBUG: CPlayerSelectionRule::Initialize: creating rule: dvdimage
  64. 10:09:20.825 T:6140620800 DEBUG: CPlayerSelectionRule::Initialize: creating rule: sdp/asf
  65. 10:09:20.825 T:6140620800 DEBUG: CPlayerSelectionRule::Initialize: creating rule: M4V
  66. 10:09:20.825 T:6140620800 DEBUG: CPlayerSelectionRule::Initialize: creating rule: nsv
  67. 10:09:20.825 T:6140620800 DEBUG: CPlayerSelectionRule::Initialize: creating rule: radio
  68. 10:09:20.825 T:6140620800 NOTICE: Loaded playercorefactory configuration
  69. 10:09:20.826 T:6140620800 DEBUG: found key /userdata/playercorefactory.xml
  70. 10:09:20.826 T:6140620800 NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml.
  71. 10:09:20.826 T:6140620800 DEBUG: found key /userdata/playercorefactory.xml
  72. 10:09:20.826 T:6140620800 NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping.
  73. 10:09:20.826 T:6140620800 DEBUG: found key /userdata/wakeonlan.xml
  74. 10:09:20.827 T:6140620800 DEBUG: found key /userdata/profiles.xml
  75. 10:09:20.827 T:6140620800 DEBUG: Previous line repeats 1 times.
  76. 10:09:20.827 T:6140620800 DEBUG: NSUSerDefaults: compressed /userdata/profiles.xml from 923 to 324
  77. 10:09:20.828 T:6140620800 DEBUG: found key /userdata/guisettings.xml
  78. 10:09:20.829 T:6140620800 DEBUG: Previous line repeats 1 times.
  79. 10:09:20.829 T:6140620800 DEBUG: NSUSerDefaults: compressed /userdata/guisettings.xml from 35403 to 6831
  80. 10:09:20.829 T:6140620800 INFO: creating subdirectories
  81. 10:09:20.829 T:6140620800 INFO: userdata folder: special://masterprofile/
  82. 10:09:20.829 T:6140620800 INFO: recording folder:
  83. 10:09:20.829 T:6140620800 INFO: screenshots folder:
  84. 10:09:20.834 T:6142341120 INFO: CActiveAESink::OpenSink - initialize sink
  85. 10:09:20.834 T:6142341120 DEBUG: CActiveAESink::OpenSink - trying to open device DARWINIOS:default
  86. 10:09:20.836 T:6142341120 DEBUG: virtual bool CAESinkDARWINIOS::Initialize(AEAudioFormat &, std::string &): AudioStreamBasicDescription: [lpcm] Mixable Interleaved 2 Channel 32-bit Floating Point LE (48000Hz) pcm
  87. 10:09:20.842 T:6142341120 NOTICE: bool CAAudioUnitSink::setupAudio() setting channels 2
  88. 10:09:20.842 T:6142341120 NOTICE: bool CAAudioUnitSink::setupAudio() setting samplerate 48000.000000
  89. 10:09:20.842 T:6142341120 NOTICE: bool CAAudioUnitSink::setupAudio() setting buffer duration to 0.042667
  90. 10:09:20.850 T:6142341120 NOTICE: bool CAAudioUnitSink::setupAudio() total latency = 0.044500
  91. 10:09:20.850 T:6142341120 NOTICE: bool CAAudioUnitSink::setupAudio() setup audio format: [lpcm] Mixable Interleaved 2 Channel 32-bit Floating Point LE (48000Hz)
  92. 10:09:20.851 T:6142341120 NOTICE: void dumpAVAudioSessionProperties() audio route = HDMIOutput
  93. 10:09:20.851 T:6142341120 NOTICE: void dumpAVAudioSessionProperties() sampleRate 48000.000000
  94. 10:09:20.851 T:6142341120 NOTICE: void dumpAVAudioSessionProperties() outputLatency 0.001833
  95. 10:09:20.851 T:6142341120 NOTICE: void dumpAVAudioSessionProperties() IOBufferDuration 0.042667
  96. 10:09:20.851 T:6142341120 NOTICE: void dumpAVAudioSessionProperties() outputNumberOfChannels 2
  97. 10:09:20.851 T:6142341120 NOTICE: void dumpAVAudioSessionProperties() maximumOutputNumberOfChannels 32
  98. 10:09:20.851 T:6142341120 DEBUG: DumpAudioDescriptions: void dumpAVAudioSessionProperties()
  99. 10:09:20.852 T:6142341120 DEBUG: DumpAudioDescriptions: input count = 0
  100. 10:09:20.852 T:6142341120 DEBUG: DumpAudioDescriptions: output count = 1
  101. 10:09:20.852 T:6142341120 DEBUG: DumpAudioDescriptions : portName, Living Room
  102. 10:09:20.852 T:6142341120 DEBUG: DumpAudioDescriptions: channelLabel, 1
  103. 10:09:20.852 T:6142341120 DEBUG: DumpAudioDescriptions: channelName , Living Room 1
  104. 10:09:20.852 T:6142341120 DEBUG: DumpAudioDescriptions: channelLabel, 2
  105. 10:09:20.852 T:6142341120 DEBUG: DumpAudioDescriptions: channelName , Living Room 2
  106. 10:09:20.857 T:6142341120 DEBUG: CActiveAESink::OpenSink - DARWINIOS Initialized:
  107. 10:09:20.857 T:6142341120 DEBUG: Output Device : Default
  108. 10:09:20.857 T:6142341120 DEBUG: Sample Rate : 48000
  109. 10:09:20.857 T:6142341120 DEBUG: Sample Format : AE_FMT_FLOAT
  110. 10:09:20.857 T:6142341120 DEBUG: Channel Count : 2
  111. 10:09:20.857 T:6142341120 DEBUG: Channel Layout: FL,FR
  112. 10:09:20.857 T:6142341120 DEBUG: Frames : 1024
  113. 10:09:20.857 T:6142341120 DEBUG: Frame Size : 8
  114. 10:09:20.859 T:6142341120 DEBUG: CActiveAESink::GenerateNoise - noiseFactor = 0.000010
  115. 10:09:20.897 T:6140620800 NOTICE: Running database version Addons20
  116. 10:09:20.897 T:6140620800 DEBUG: SECTION:LoadDLL(libcpluff.framework/libcpluff)
  117. 10:09:20.897 T:6140620800 DEBUG: Loading: /var/containers/Bundle/Application/69FC7311-4838-4F49-BB51-F1976B1645C6/MrMC.app/Frameworks/libcpluff.framework/libcpluff
  118. 10:09:20.917 T:6140620800 INFO: ADDON: cpluff: 'Could not read plug-in directory /var/mobile/Containers/Data/Application/57282B23-8E36-4342-9788-26AAC2138188/Library/Caches/home/addons: No such file or directory'
  119. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.ca_es has been installed.'
  120. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.mt_mt has been installed.'
  121. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.az_az has been installed.'
  122. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.vi_vn has been installed.'
  123. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.ja_jp has been installed.'
  124. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.eo has been installed.'
  125. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.images.weathericons.default has been installed.'
  126. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.pl_pl has been installed.'
  127. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in webinterface.default has been installed.'
  128. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in skin.ariana has been installed.'
  129. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.en_au has been installed.'
  130. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in kodi.audiodecoder has been installed.'
  131. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.fr_ca has been installed.'
  132. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in pvr.argustv has been installed.'
  133. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.sr_rs has been installed.'
  134. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.ofdb.de has been installed.'
  135. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.fa_af has been installed.'
  136. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in metadata.themoviedb.org has been installed.'
  137. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.bg_bg has been installed.'
  138. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in xbmc.metadata has been installed.'
  139. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.hu_hu has been installed.'
  140. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in pvr.dvblink has been installed.'
  141. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.da_dk has been installed.'
  142. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.mk_mk has been installed.'
  143. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.pt_pt has been installed.'
  144. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.nb_no has been installed.'
  145. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.is_is has been installed.'
  146. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.ms_my has been installed.'
  147. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.sv_se has been installed.'
  148. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.ru_ru has been installed.'
  149. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in xbmc.gui has been installed.'
  150. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in script.keymap has been installed.'
  151. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.os_os has been installed.'
  152. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in script.advanced.wol has been installed.'
  153. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.es_mx has been installed.'
  154. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.nl_nl has been installed.'
  155. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in metadata.musicvideos.theaudiodb.com has been installed.'
  156. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.ta_in has been installed.'
  157. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.gl_es has been installed.'
  158. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in pvr.pctv has been installed.'
  159. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in pvr.tvmosaic has been installed.'
  160. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.slideshow has been installed.'
  161. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in pvr.iptvsimple has been installed.'
  162. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in skin.blackglassnova has been installed.'
  163. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in skin.opacity has been installed.'
  164. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.ko_kr has been installed.'
  165. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.fa_ir has been installed.'
  166. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in pvr.njoy has been installed.'
  167. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.uz_uz has been installed.'
  168. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.movieposterdb.com has been installed.'
  169. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.tg_tj has been installed.'
  170. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.htbackdrops.com has been installed.'
  171. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.my_mm has been installed.'
  172. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in pvr.dvbviewer has been installed.'
  173. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.en_gb has been installed.'
  174. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in skin.amber has been installed.'
  175. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.port.hu has been installed.'
  176. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in visualization.spectrum has been installed.'
  177. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in pvr.stalker has been installed.'
  178. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.hr_hr has been installed.'
  179. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.zh_tw has been installed.'
  180. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.musicbrainz.org has been installed.'
  181. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.fo_fo has been installed.'
  182. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.zh_cn has been installed.'
  183. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in metadata.local has been installed.'
  184. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in xbmc.webinterface has been installed.'
  185. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.ro_ro has been installed.'
  186. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.fi_fi has been installed.'
  187. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.de_de has been installed.'
  188. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.themoviedb.org has been installed.'
  189. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.theaudiodb.com has been installed.'
  190. 10:09:21.070 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in pvr.filmon has been installed.'
  191. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.en_nz has been installed.'
  192. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in script.xbmc.unpausejumpback has been installed.'
  193. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in visualization.waveform has been installed.'
  194. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.szl has been installed.'
  195. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.en_us has been installed.'
  196. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in xbmc.json has been installed.'
  197. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.tr_tr has been installed.'
  198. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.fanart.tv has been installed.'
  199. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in xbmc.audioencoder has been installed.'
  200. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in pvr.vbox has been installed.'
  201. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.sk_sk has been installed.'
  202. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.uisounds.mrmc has been installed.'
  203. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in metadata.mymovies.dk has been installed.'
  204. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.pt_br has been installed.'
  205. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.id_id has been installed.'
  206. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.th_th has been installed.'
  207. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.black has been installed.'
  208. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in pvr.vdr.vnsi has been installed.'
  209. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in kodi.guilib has been installed.'
  210. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.sl_si has been installed.'
  211. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.system has been installed.'
  212. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.am_et has been installed.'
  213. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.fr_fr has been installed.'
  214. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.es_ar has been installed.'
  215. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in pvr.mediaportal.tvserver has been installed.'
  216. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.eu_es has been installed.'
  217. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.bs_ba has been installed.'
  218. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.sr_rs@latin has been installed.'
  219. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in metadata.universal has been installed.'
  220. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.cs_cz has been installed.'
  221. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in skin.mrmc has been installed.'
  222. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.mi has been installed.'
  223. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in screensaver.xbmc.builtin.dim has been installed.'
  224. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in service.libraryautoupdate has been installed.'
  225. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.sq_al has been installed.'
  226. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.el_gr has been installed.'
  227. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.hi_in has been installed.'
  228. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in pvr.wmc has been installed.'
  229. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.ml_in has been installed.'
  230. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in script.plex has been installed.'
  231. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in pvr.hdhomerun has been installed.'
  232. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.cy_gb has been installed.'
  233. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in kodi.resource has been installed.'
  234. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.af_za has been installed.'
  235. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.uk_ua has been installed.'
  236. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.uisounds.tvos has been installed.'
  237. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.hy_am has been installed.'
  238. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.lt_lt has been installed.'
  239. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.si_lk has been installed.'
  240. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in pvr.vuplus has been installed.'
  241. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.it_it has been installed.'
  242. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in pvr.mythtv has been installed.'
  243. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in xbmc.core has been installed.'
  244. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.mn_mn has been installed.'
  245. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.ar_sa has been installed.'
  246. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in metadata.tvshows.themoviedb.org has been installed.'
  247. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in script.module.requests has been installed.'
  248. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.lv_lv has been installed.'
  249. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in skin.pm3-hd has been installed.'
  250. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.te_in has been installed.'
  251. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in xbmc.pvr has been installed.'
  252. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in pvr.nextpvr has been installed.'
  253. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.uisounds.amber has been installed.'
  254. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.et_ee has been installed.'
  255. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in metadata.album.universal has been installed.'
  256. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.allmusic.com has been installed.'
  257. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in metadata.tvdb.com has been installed.'
  258. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.omdbapi.com has been installed.'
  259. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in metadata.artists.universal has been installed.'
  260. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in xbmc.python has been installed.'
  261. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.he_il has been installed.'
  262. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in metadata.common.imdb.com has been installed.'
  263. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in pvr.hts has been installed.'
  264. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in xbmc.addon has been installed.'
  265. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in xbmc.codec has been installed.'
  266. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.es_es has been installed.'
  267. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Plug-in resource.language.be_by has been installed.'
  268. 10:09:21.071 T:6140620800 DEBUG: ADDON: cpluff: 'Not all directories were successfully scanned.'
  269. 10:09:21.077 T:6140620800 INFO: CKeyboardLayoutManager: loading keyboard layouts from special://xbmc/system/keyboardlayouts...
  270. 10:09:21.081 T:6140620800 DEBUG: CKeyboardLayoutManager: keyboard layout "Chinese BasePY" successfully loaded
  271. 10:09:21.081 T:6140620800 DEBUG: CKeyboardLayoutManager: keyboard layout "Chinese BaiduPY" successfully loaded
  272. 10:09:21.082 T:6140620800 DEBUG: CKeyboardLayoutManager: keyboard layout "Lithuanian AZERTY" successfully loaded
  273. 10:09:21.082 T:6140620800 DEBUG: CKeyboardLayoutManager: keyboard layout "Lithuanian QWERTY" successfully loaded
  274. 10:09:21.082 T:6140620800 DEBUG: CKeyboardLayoutManager: keyboard layout "Russian ЙЦУКЕН" successfully loaded
  275. 10:09:21.082 T:6140620800 DEBUG: CKeyboardLayoutManager: keyboard layout "Russian АБВ" successfully loaded
  276. 10:09:21.083 T:6140620800 DEBUG: CKeyboardLayoutManager: keyboard layout "Danish QWERTY" successfully loaded
  277. 10:09:21.084 T:6140620800 DEBUG: CKeyboardLayoutManager: keyboard layout "French AZERTY" successfully loaded
  278. 10:09:21.084 T:6140620800 DEBUG: CKeyboardLayoutManager: keyboard layout "Arabic QWERTY" successfully loaded
  279. 10:09:21.085 T:6140620800 DEBUG: CKeyboardLayoutManager: keyboard layout "Czech QWERTZ" successfully loaded
  280. 10:09:21.085 T:6140620800 DEBUG: CKeyboardLayoutManager: keyboard layout "Norwegian QWERTY" successfully loaded
  281. 10:09:21.086 T:6140620800 DEBUG: CKeyboardLayoutManager: keyboard layout "German QWERTZ" successfully loaded
  282. 10:09:21.086 T:6140620800 DEBUG: CKeyboardLayoutManager: keyboard layout "Bulgarian ЯВЕРТЪ" successfully loaded
  283. 10:09:21.086 T:6140620800 DEBUG: CKeyboardLayoutManager: keyboard layout "Bulgarian АБВ" successfully loaded
  284. 10:09:21.087 T:6140620800 DEBUG: CKeyboardLayoutManager: keyboard layout "Swedish QWERTY" successfully loaded
  285. 10:09:21.088 T:6140620800 DEBUG: CKeyboardLayoutManager: keyboard layout "Turkish QWERTY" successfully loaded
  286. 10:09:21.088 T:6140620800 DEBUG: CKeyboardLayoutManager: keyboard layout "Hungarian QWERTZ" successfully loaded
  287. 10:09:21.089 T:6140620800 DEBUG: CKeyboardLayoutManager: keyboard layout "Romanian QWERTY" successfully loaded
  288. 10:09:21.090 T:6140620800 DEBUG: CKeyboardLayoutManager: keyboard layout "Spanish QWERTY" successfully loaded
  289. 10:09:21.091 T:6140620800 DEBUG: CKeyboardLayoutManager: keyboard layout "Hebrew QWERTY" successfully loaded
  290. 10:09:21.091 T:6140620800 DEBUG: CKeyboardLayoutManager: keyboard layout "Hebrew ABC" successfully loaded
  291. 10:09:21.092 T:6140620800 DEBUG: CKeyboardLayoutManager: keyboard layout "Portuguese (Portugal) QWERTY" successfully loaded
  292. 10:09:21.092 T:6140620800 DEBUG: CKeyboardLayoutManager: keyboard layout "Greek QWERTY" successfully loaded
  293. 10:09:21.093 T:6140620800 DEBUG: CKeyboardLayoutManager: keyboard layout "Polish QWERTY" successfully loaded
  294. 10:09:21.094 T:6140620800 DEBUG: CKeyboardLayoutManager: keyboard layout "Korean ㄱㄴㄷ" successfully loaded
  295. 10:09:21.095 T:6140620800 DEBUG: CKeyboardLayoutManager: keyboard layout "Ukrainian ЙЦУКЕН" successfully loaded
  296. 10:09:21.095 T:6140620800 DEBUG: CKeyboardLayoutManager: keyboard layout "Ukrainian АБВ" successfully loaded
  297. 10:09:21.095 T:6140620800 DEBUG: CKeyboardLayoutManager: keyboard layout "English QWERTY" successfully loaded
  298. 10:09:21.095 T:6140620800 DEBUG: CKeyboardLayoutManager: keyboard layout "English AZERTY" successfully loaded
  299. 10:09:21.095 T:6140620800 DEBUG: CKeyboardLayoutManager: keyboard layout "English ABC" successfully loaded
  300. 10:09:21.096 T:6140620800 DEBUG: Current resolution Screen: 0 with 3840 x 2160
  301. 10:09:21.096 T:6140620800 NOTICE: Found possible resolution for display 0 with 3840 x 2160
  302. 10:09:21.096 T:6140620800 NOTICE: Checking resolution 16
  303. 10:09:21.096 T:6140620800 DEBUG: About to switch to 3840 x 2160 on screen 0
  304. 10:09:21.096 T:6140620800 DEBUG: Found matching mode
  305. 10:09:21.096 T:6140620800 INFO: GLES: Maximum texture width: 2048
  306. 10:09:21.096 T:6140620800 DEBUG: EGL_EXTENSIONS: GL_OES_standard_derivatives GL_KHR_texture_compression_astc_ldr GL_EXT_color_buffer_half_float GL_EXT_debug_label GL_EXT_debug_marker GL_EXT_pvrtc_sRGB GL_EXT_read_format_bgra GL_EXT_separate_shader_objects GL_EXT_shader_framebuffer_fetch GL_EXT_shader_texture_lod GL_EXT_shadow_samplers GL_EXT_texture_filter_anisotropic GL_APPLE_clip_distance GL_APPLE_color_buffer_packed_float GL_APPLE_copy_texture_levels GL_APPLE_rgb_422 GL_APPLE_texture_format_BGRA8888 GL_IMG_read_format GL_IMG_texture_compression_pvrtc
  307. 10:09:21.096 T:6140620800 NOTICE: GL_VENDOR = Apple Inc.
  308. 10:09:21.096 T:6140620800 NOTICE: GL_RENDERER = Apple A10X GPU
  309. 10:09:21.096 T:6140620800 NOTICE: GL_VERSION = OpenGL ES 3.0 Metal - 58.4
  310. 10:09:21.096 T:6140620800 NOTICE: GL_SHADING_LANGUAGE_VERSION = OpenGL ES GLSL ES 3.00
  311. 10:09:21.096 T:6140620800 DEBUG: GLES: Extension Support Test - GL_NVX_gpu_memory_info NO
  312. 10:09:21.096 T:6140620800 NOTICE: GL_EXTENSIONS = GL_OES_standard_derivatives GL_KHR_texture_compression_astc_ldr GL_EXT_color_buffer_half_float GL_EXT_debug_label GL_EXT_debug_marker GL_EXT_pvrtc_sRGB GL_EXT_read_format_bgra GL_EXT_separate_shader_objects GL_EXT_shader_framebuffer_fetch GL_EXT_shader_texture_lod GL_EXT_shadow_samplers GL_EXT_texture_filter_anisotropic GL_APPLE_clip_distance GL_APPLE_color_buffer_packed_float GL_APPLE_copy_texture_levels GL_APPLE_rgb_422 GL_APPLE_texture_format_BGRA8888 GL_IMG_read_format GL_IMG_texture_compression_pvrtc
  313. 10:09:21.096 T:6140620800 DEBUG: GLES: Extension Support Test - GL_EXT_texture_format_BGRA8888 NO
  314. 10:09:21.096 T:6140620800 DEBUG: GLES: Extension Support Test - GL_IMG_texture_format_BGRA8888 NO
  315. 10:09:21.096 T:6140620800 DEBUG: GLES: Extension Support Test - GL_APPLE_texture_format_BGRA8888 YES
  316. 10:09:21.096 T:6140620800 DEBUG: GLES: Extension Support Test - GL_EXT_unpack_subimage NO
  317. 10:09:21.110 T:6140620800 DEBUG: GUI Shader [guishader_frag_default.glsl]- Initialise successful : 0x283a0c900
  318. 10:09:21.112 T:6140620800 DEBUG: GUI Shader [guishader_frag_texture.glsl]- Initialise successful : 0x283a082d0
  319. 10:09:21.114 T:6140620800 DEBUG: GUI Shader [guishader_frag_multi.glsl]- Initialise successful : 0x283a366d0
  320. 10:09:21.116 T:6140620800 DEBUG: GUI Shader [guishader_frag_fonts.glsl]- Initialise successful : 0x283a08510
  321. 10:09:21.119 T:6140620800 DEBUG: GUI Shader [guishader_frag_texture_noblend.glsl]- Initialise successful : 0x283a36910
  322. 10:09:21.121 T:6140620800 DEBUG: GUI Shader [guishader_frag_multi_blendcolor.glsl]- Initialise successful : 0x283a099e0
  323. 10:09:21.123 T:6140620800 DEBUG: GUI Shader [guishader_frag_rgba.glsl]- Initialise successful : 0x283a09a70
  324. 10:09:21.123 T:6140620800 DEBUG: GLES: Extension Support Test - GL_OES_EGL_image_external NO
  325. 10:09:21.126 T:6140620800 DEBUG: GUI Shader [guishader_frag_rgba_blendcolor.glsl]- Initialise successful : 0x283a36b50
  326. 10:09:21.128 T:6140620800 DEBUG: GUI Shader [guishader_frag_rgba_bob.glsl]- Initialise successful : 0x283a09cb0
  327. 10:09:21.128 T:6140620800 DEBUG: GLES: Extension Support Test - GL_OES_EGL_image_external NO
  328. 10:09:21.128 T:6140620800 DEBUG: About to switch to 3840 x 2160 on screen 0
  329. 10:09:21.128 T:6140620800 DEBUG: Found matching mode
  330. 10:09:21.128 T:6140620800 INFO: GLES: Maximum texture width: 16384
  331. 10:09:21.129 T:6140620800 INFO: load keymapping
  332. 10:09:21.131 T:6140620800 INFO: Loading special://xbmc/system/keymaps/customcontroller.SiriRemote.xml
  333. 10:09:21.132 T:6140620800 INFO: Loading special://xbmc/system/keymaps/keyboard.xml
  334. 10:09:21.136 T:6140620800 INFO: Loading special://masterprofile/keymaps/customcontroller.SiriRemote.xml
  335. 10:09:21.136 T:6140620800 DEBUG: found key /userdata/keymaps/customcontroller.SiriRemote.xml
  336. 10:09:21.136 T:6140620800 INFO: Loading special://profile/keymaps/customcontroller.SiriRemote.xml
  337. 10:09:21.136 T:6140620800 DEBUG: found key /userdata/keymaps/customcontroller.SiriRemote.xml
  338. 10:09:21.137 T:6140620800 INFO: GUI format 3840x2160, Display 3840x2160@ 59.94 - Full Screen
  339. 10:09:21.137 T:6140620800 DEBUG: guilib: Fill viewport on change for solving rendering passes
  340. 10:09:21.137 T:6140620800 INFO: CLangInfo: loading resource.language.en_gb language information...
  341. 10:09:21.138 T:6140620800 DEBUG: trying to set locale to en_US.UTF-8
  342. 10:09:21.141 T:6140620800 INFO: global locale set to C
  343. 10:09:21.141 T:6140620800 INFO: CLangInfo: loading resource.language.en_gb language strings...
  344. 10:09:21.146 T:6140620800 DEBUG: POParser: loaded 3845 strings from file resource://resource.language.en_gb/strings.po
  345. 10:09:21.148 T:6144061440 NOTICE: Running database version Addons20
  346. 10:09:21.148 T:6144061440 DEBUG: Initialize, updating databases...
  347. 10:09:21.149 T:6144061440 NOTICE: Running database version ViewModes6
  348. 10:09:21.150 T:6144061440 NOTICE: Running database version Textures13
  349. 10:09:21.153 T:6144061440 NOTICE: Running database version MyMusic60
  350. 10:09:21.158 T:6144061440 NOTICE: Running database version MyVideos107
  351. 10:09:21.159 T:6144061440 NOTICE: Running database version TV29
  352. 10:09:21.160 T:6144061440 NOTICE: Running database version Epg11
  353. 10:09:21.161 T:6144061440 DEBUG: Initialize, updating databases... DONE
  354. 10:09:21.161 T:6140620800 INFO: DPMS: not supported on this platform
  355. 10:09:21.169 T:6140620800 DEBUG: found key /userdata/modulepasswords.xml
  356. 10:09:21.179 T:6140620800 DEBUG: Previous line repeats 2 times.
  357. 10:09:21.179 T:6140620800 DEBUG: found key /userdata/addon_data/skin.ariana/settings.xml
  358. 10:09:21.180 T:6140620800 INFO: Unloading old skin ...
  359. 10:09:21.181 T:6140620800 INFO: load skin from: /private/var/containers/Bundle/Application/69FC7311-4838-4F49-BB51-F1976B1645C6/MrMC.app/AppData/AppHome/addons/skin.ariana (version: 1.2.4)
  360. 10:09:21.181 T:6140620800 INFO: load fonts for skin...
  361. 10:09:21.183 T:6140620800 INFO: Loading fonts from /private/var/containers/Bundle/Application/69FC7311-4838-4F49-BB51-F1976B1645C6/MrMC.app/AppData/AppHome/addons/skin.ariana/xml/Font.xml
  362. 10:09:21.231 T:6140620800 DEBUG: LocalizeStrings: no strings.po file exist at /private/var/containers/Bundle/Application/69FC7311-4838-4F49-BB51-F1976B1645C6/MrMC.app/AppData/AppHome/addons/skin.ariana/language/English, fallback to strings.xml
  363. 10:09:21.232 T:6140620800 INFO: Loading skin includes from /private/var/containers/Bundle/Application/69FC7311-4838-4F49-BB51-F1976B1645C6/MrMC.app/AppData/AppHome/addons/skin.ariana/xml/Includes.xml
  364. 10:09:21.233 T:6140620800 DEBUG: found key /userdata/addon_data/skin.ariana/Includes_Variables.xml
  365. 10:09:21.235 T:6140620800 DEBUG: found key /userdata/addon_data/skin.ariana/defaults.xml
  366. 10:09:21.236 T:6140620800 DEBUG: found key /userdata/addon_data/skin.ariana/Includes_Home.xml
  367. 10:09:21.237 T:6140620800 DEBUG: found key /userdata/addon_data/skin.ariana/Includes_Views.xml
  368. 10:09:21.239 T:6140620800 DEBUG: found key /userdata/addon_data/skin.ariana/View_50.xml
  369. 10:09:21.240 T:6140620800 DEBUG: found key /userdata/addon_data/skin.ariana/View_51.xml
  370. 10:09:21.241 T:6140620800 DEBUG: found key /userdata/addon_data/skin.ariana/View_52.xml
  371. 10:09:21.242 T:6140620800 DEBUG: found key /userdata/addon_data/skin.ariana/View_53.xml
  372. 10:09:21.243 T:6140620800 DEBUG: found key /userdata/addon_data/skin.ariana/View_57_58_59_Showcase.xml
  373. 10:09:21.244 T:6140620800 INFO: load new skin...
  374. 10:09:21.244 T:6140620800 INFO: Loading user windows, path /private/var/containers/Bundle/Application/69FC7311-4838-4F49-BB51-F1976B1645C6/MrMC.app/AppData/AppHome/addons/skin.ariana/xml
  375. 10:09:21.253 T:6140620800 DEBUG: Load Skin XML: 8.50ms
  376. 10:09:21.253 T:6140620800 INFO: initialize new skin...
  377. 10:09:21.253 T:6140620800 DEBUG: guilib: Fill viewport on change for solving rendering passes
  378. 10:09:21.253 T:6140620800 INFO: Loading skin file: Pointer.xml, load type: LOAD_ON_GUI_INIT
  379. 10:09:21.258 T:6140620800 DEBUG: OpenBundle - Opened bundle /private/var/containers/Bundle/Application/69FC7311-4838-4F49-BB51-F1976B1645C6/MrMC.app/AppData/AppHome/addons/skin.ariana/media/Textures.xbt
  380. 10:09:21.258 T:6140620800 INFO: Loading skin file: DialogVolumeBar.xml, load type: LOAD_ON_GUI_INIT
  381. 10:09:21.262 T:6140620800 INFO: Loading skin file: DialogKaiToast.xml, load type: LOAD_ON_GUI_INIT
  382. 10:09:21.263 T:6140620800 INFO: Loading skin file: DialogSeekBar.xml, load type: LOAD_ON_GUI_INIT
  383. 10:09:21.265 T:6140620800 INFO: Loading skin file: DialogBusy.xml, load type: LOAD_ON_GUI_INIT
  384. 10:09:21.266 T:6140620800 INFO: Loading skin file: DialogExtendedProgressBar.xml, load type: LOAD_ON_GUI_INIT
  385. 10:09:21.268 T:6140620800 INFO: Loading resource://resource.uisounds.tvos/sounds.xml
  386. 10:09:21.269 T:6140620800 INFO: skin loaded...
  387. 10:09:21.279 T:6140620800 DEBUG: JSONRPC: JSON schema type definition references an unknown type Setting.Details.Setting
  388. 10:09:21.279 T:6140620800 WARNING: JSONRPC: Could not parse type "Setting.Details.SettingList"
  389. 10:09:21.279 T:6140620800 INFO: JSONRPC: Adding type "Setting.Details.SettingList" to list of incomplete definitions (waiting for "Setting.Details.Setting")
  390. 10:09:21.279 T:6140620800 INFO: JSONRPC: Resolving incomplete types/methods referencing Setting.Details.Setting
  391. 10:09:21.282 T:6140620800 ERROR: JSONRPC: Missing implementation for method "VideoLibrary.GetInProgressTvShows"
  392. 10:09:21.285 T:6140620800 INFO: JSONRPC v6.32.5: Successfully initialized
  393. 10:09:21.285 T:6140620800 DEBUG: ADDON: Starting service addons.
  394. 10:09:21.285 T:6140620800 DEBUG: Activating window ID: 12999
  395. 10:09:21.285 T:6140620800 DEBUG: ------ Window Init (Startup.xml) ------
  396. 10:09:21.285 T:6140620800 INFO: Loading skin file: Startup.xml, load type: LOAD_EVERY_TIME
  397. 10:09:21.287 T:6144061440 NOTICE: PVRManager - starting up
  398. 10:09:21.288 T:6140620800 DEBUG: Activating window ID: 10000
  399. 10:09:21.288 T:6140620800 DEBUG: ------ Window Deinit (Startup.xml) ------
  400. 10:09:21.288 T:6140620800 DEBUG: ------ Window Init (Home.xml) ------
  401. 10:09:21.288 T:6140620800 INFO: Loading skin file: Home.xml, load type: KEEP_IN_MEMORY
  402. 10:09:21.290 T:6145208320 DEBUG: RegisterClient - registering add-on 'TV Mosaic PVR Client'
  403. 10:09:21.291 T:6145208320 DEBUG: found key /userdata/addon_data/pvr.tvmosaic/settings.xml
  404. 10:09:21.292 T:6145208320 DEBUG: RegisterClient - registering add-on 'TV Mosaic PVR Client'
  405. 10:09:21.292 T:6145208320 DEBUG: PVR - Create - creating PVR add-on instance 'TV Mosaic PVR Client'
  406. 10:09:21.292 T:6145208320 DEBUG: ADDON: Dll Initializing - TV Mosaic PVR Client
  407. 10:09:21.294 T:6145208320 DEBUG: SECTION:LoadDLL(/var/containers/Bundle/Application/69FC7311-4838-4F49-BB51-F1976B1645C6/MrMC.app/Frameworks/pvr.tvmosaic.framework/pvr.tvmosaic)
  408. 10:09:21.294 T:6145208320 DEBUG: Loading: /var/containers/Bundle/Application/69FC7311-4838-4F49-BB51-F1976B1645C6/MrMC.app/Frameworks/pvr.tvmosaic.framework/pvr.tvmosaic
  409. 10:09:21.296 T:6144061440 DEBUG: CHomeShelfJob::UpdateMusic() - Running HomeShelf screen update
  410. 10:09:21.298 T:6140620800 ERROR: Control 9000 in window 10000 has been asked to focus, but it can't
  411. 10:09:21.298 T:6140620800 NOTICE: ActiveAE DSP - starting
  412. 10:09:21.298 T:6140620800 INFO: removing tempfiles
  413. 10:09:21.298 T:6144061440 DEBUG: CHomeShelfJob::UpdateVideos() - Running HomeShelf screen update
  414. 10:09:21.298 T:6140620800 DEBUG: ADDON: Starting service addons.
  415. 10:09:21.298 T:6140620800 NOTICE: initialize done
  416. 10:09:21.298 T:6140620800 NOTICE: Running the application...
  417. 10:09:21.298 T:6140620800 DEBUG: NetworkMessage - Starting network services
  418. 10:09:21.298 T:6140620800 NOTICE: starting zeroconf publishing
  419. 10:09:21.299 T:6140620800 NOTICE: WebServer: Started the webserver
  420. 10:09:21.299 T:6140620800 NOTICE: starting upnp client
  421. 10:09:21.299 T:6145781760 DEBUG: CZeroconfOSX::doPublishService identifier: servers.webserver type: _http._tcp name:MrMC (Living-Room) port:8080
  422. 10:09:21.301 T:6145781760 DEBUG: CZeroconfOSX::doPublishService identifier: servers.jsonrpc-http type: _xbmc-jsonrpc-h._tcp name:MrMC (Living-Room) port:8080
  423. 10:09:21.306 T:6140620800 INFO: JSONRPC Server: Successfully initialized
  424. 10:09:21.306 T:6150942720 NOTICE: ES: Starting UDP Event server on 127.0.0.1:9777
  425. 10:09:21.306 T:6150942720 NOTICE: UDP: Listening on port 9777
  426. 10:09:21.307 T:6145781760 DEBUG: CZeroconfOSX::doPublishService identifier: servers.jsonrpc-tpc type: _xbmc-jsonrpc._tcp name:MrMC (Living-Room) port:9090
  427. 10:09:21.307 T:6152089600 DEBUG: CPlexServices::Process bgn
  428. 10:09:21.312 T:6145781760 DEBUG: CZeroconfOSX::doPublishService identifier: servers.eventserver type: _xbmc-events._udp name:MrMC (Living-Room) port:9777
  429. 10:09:21.315 T:6140620800 INFO: GLES: Enabling VSYNC
  430. 10:09:21.315 T:6140620800 INFO: GLES: Selected vsync mode 10
  431. 10:09:21.467 T:6145208320 DEBUG: AddOnLog: TV Mosaic PVR Client: ADDON_Create - Creating the PVR DVBlink add-on
  432. 10:09:21.467 T:6145208320 NOTICE: AddOnLog: TV Mosaic PVR Client: Generated guid 2cc51f58-98a1-c0c6-56d6-44f3e490d9ad to use as a DVBLink client ID
  433. 10:09:21.467 T:6145208320 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'TV Mosaic PVR Client' requests setting 'host'
  434. 10:09:21.467 T:6145208320 DEBUG: found key /userdata/addon_data/pvr.tvmosaic/settings.xml
  435. 10:09:21.467 T:6145208320 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'TV Mosaic PVR Client' requests setting 'username'
  436. 10:09:21.467 T:6145208320 DEBUG: found key /userdata/addon_data/pvr.tvmosaic/settings.xml
  437. 10:09:21.468 T:6145208320 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'TV Mosaic PVR Client' requests setting 'password'
  438. 10:09:21.468 T:6145208320 DEBUG: found key /userdata/addon_data/pvr.tvmosaic/settings.xml
  439. 10:09:21.468 T:6145208320 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'TV Mosaic PVR Client' requests setting 'enable_transcoding'
  440. 10:09:21.468 T:6145208320 DEBUG: found key /userdata/addon_data/pvr.tvmosaic/settings.xml
  441. 10:09:21.468 T:6145208320 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'TV Mosaic PVR Client' requests setting 'port'
  442. 10:09:21.468 T:6145208320 DEBUG: found key /userdata/addon_data/pvr.tvmosaic/settings.xml
  443. 10:09:21.469 T:6145208320 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'TV Mosaic PVR Client' requests setting 'timeshift'
  444. 10:09:21.469 T:6145208320 DEBUG: found key /userdata/addon_data/pvr.tvmosaic/settings.xml
  445. 10:09:21.469 T:6145208320 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'TV Mosaic PVR Client' requests setting 'showinfomsg'
  446. 10:09:21.469 T:6145208320 DEBUG: found key /userdata/addon_data/pvr.tvmosaic/settings.xml
  447. 10:09:21.469 T:6145208320 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'TV Mosaic PVR Client' requests setting 'add_rec_episode_info'
  448. 10:09:21.469 T:6145208320 DEBUG: found key /userdata/addon_data/pvr.tvmosaic/settings.xml
  449. 10:09:21.469 T:6145208320 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'TV Mosaic PVR Client' requests setting 'group_recordings_by_series'
  450. 10:09:21.469 T:6145208320 DEBUG: found key /userdata/addon_data/pvr.tvmosaic/settings.xml
  451. 10:09:21.470 T:6145208320 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'TV Mosaic PVR Client' requests setting 'no_group_for_single_record'
  452. 10:09:21.470 T:6145208320 DEBUG: found key /userdata/addon_data/pvr.tvmosaic/settings.xml
  453. 10:09:21.470 T:6145208320 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'TV Mosaic PVR Client' requests setting 'height'
  454. 10:09:21.470 T:6145208320 DEBUG: found key /userdata/addon_data/pvr.tvmosaic/settings.xml
  455. 10:09:21.470 T:6145208320 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'TV Mosaic PVR Client' requests setting 'width'
  456. 10:09:21.476 T:6145208320 DEBUG: found key /userdata/addon_data/pvr.tvmosaic/settings.xml
  457. 10:09:21.476 T:6145208320 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'TV Mosaic PVR Client' requests setting 'bitrate'
  458. 10:09:21.476 T:6145208320 DEBUG: found key /userdata/addon_data/pvr.tvmosaic/settings.xml
  459. 10:09:21.476 T:6145208320 DEBUG: CAddonCallbacksAddon - GetAddonSetting - add-on 'TV Mosaic PVR Client' requests setting 'audiotrack'
  460. 10:09:21.477 T:6145208320 DEBUG: found key /userdata/addon_data/pvr.tvmosaic/settings.xml
  461. 10:09:21.477 T:6145208320 DEBUG: AddOnLog: TV Mosaic PVR Client: settings: enable_transcoding='0' host='192.168.2.10', port=9270
  462. 10:09:21.524 T:6145208320 INFO: AddOnLog: TV Mosaic PVR Client: Connected to DVBLink Server '192.168.2.10'
  463. 10:09:21.527 T:6154383360 DEBUG: AddOnLog: TV Mosaic PVR Client: DVBLinkUpdateProcess:: thread started
  464. 10:09:21.535 T:6145208320 DEBUG: POParser: loaded 67 strings from file /private/var/containers/Bundle/Application/69FC7311-4838-4F49-BB51-F1976B1645C6/MrMC.app/AppData/AppHome/addons/pvr.tvmosaic/resources/language/resource.language.en_gb/strings.po
  465. 10:09:21.573 T:6144634880 DEBUG: PVRManager - Load - active clients found. continue to start
  466. 10:09:21.584 T:6140620800 DEBUG: ------ Window Init (DialogExtendedProgressBar.xml) ------
  467. 10:09:21.584 T:6144634880 DEBUG: CPVRChannelGroups - Load - loading all radio channel groups
  468. 10:09:21.585 T:6144634880 DEBUG: CPVRChannelGroups - Load - 1 radio groups fetched from the database
  469. 10:09:21.585 T:6144634880 DEBUG: PVRChannelGroup - Load - 0 channels loaded from the database for group 'All channels'
  470. 10:09:21.586 T:6144634880 INFO: AddOnLog: TV Mosaic PVR Client: Getting channels (22 channels on server)
  471. 10:09:21.587 T:6144634880 DEBUG: CPVRChannelGroups - LoadUserDefinedChannelGroups - 2 new user defined radio channel groups fetched from clients
  472. 10:09:21.587 T:6144634880 DEBUG: PVRChannelGroup - Load - 0 channels loaded from the database for group 'TV'
  473. 10:09:21.587 T:6144634880 DEBUG: PVR - GetChannelGroupMembers - get group members for group 'TV' from add-on 'DVBLink Server:192.168.2.10'
  474. 10:09:21.587 T:6144634880 DEBUG: PVRChannelGroup - Load - 0 channels loaded from the database for group 'Radio'
  475. 10:09:21.587 T:6144634880 DEBUG: PVR - GetChannelGroupMembers - get group members for group 'Radio' from add-on 'DVBLink Server:192.168.2.10'
  476. 10:09:21.587 T:6144634880 DEBUG: CPVRChannelGroups - LoadUserDefinedChannelGroups - deleting empty group 'TV'
  477. 10:09:21.587 T:6144634880 DEBUG: CPVRChannelGroups - LoadUserDefinedChannelGroups - deleting empty group 'Radio'
  478. 10:09:21.587 T:6144634880 DEBUG: CPVRChannelGroups - PersistAll - persisting all changes in channel groups
  479. 10:09:21.587 T:6144634880 DEBUG: CPVRChannelGroups - Load - 1 radio channel groups loaded
  480. 10:09:21.587 T:6144634880 DEBUG: CPVRChannelGroups - Load - loading all TV channel groups
  481. 10:09:21.607 T:6144634880 DEBUG: PVR - Get - group 'All channels' loaded from the database
  482. 10:09:21.607 T:6144634880 DEBUG: PVR - Get - group 'TV' loaded from the database
  483. 10:09:21.607 T:6144634880 DEBUG: CPVRChannelGroups - Load - 2 TV groups fetched from the database
  484. 10:09:21.608 T:6144634880 DEBUG: PVRChannelGroup - Load - 22 channels loaded from the database for group 'All channels'
  485. 10:09:21.608 T:6144634880 INFO: AddOnLog: TV Mosaic PVR Client: Getting channels (22 channels on server)
  486. 10:09:21.608 T:6144634880 DEBUG: CPVRChannelGroups - LoadUserDefinedChannelGroups - 1 new user defined TV channel groups fetched from clients
  487. 10:09:21.608 T:6144634880 DEBUG: PVRChannelGroup - Load - 22 channels loaded from the database for group 'TV'
  488. 10:09:21.608 T:6144634880 DEBUG: PVR - GetChannelGroupMembers - get group members for group 'TV' from add-on 'DVBLink Server:192.168.2.10'
  489. 10:09:21.608 T:6144634880 DEBUG: PVRChannelGroup - Load - 0 channels loaded from the database for group 'Radio'
  490. 10:09:21.608 T:6144634880 DEBUG: PVR - GetChannelGroupMembers - get group members for group 'Radio' from add-on 'DVBLink Server:192.168.2.10'
  491. 10:09:21.608 T:6144634880 DEBUG: CPVRChannelGroups - LoadUserDefinedChannelGroups - deleting empty group 'Radio'
  492. 10:09:21.608 T:6144634880 DEBUG: CPVRChannelGroups - PersistAll - persisting all changes in channel groups
  493. 10:09:21.608 T:6144634880 DEBUG: CPVRChannelGroup - Persist - persisting channel group 'All channels' with 22 channels
  494. 10:09:21.611 T:6144634880 DEBUG: CPVRChannelGroup - Persist - persisting channel group 'TV' with 22 channels
  495. 10:09:21.620 T:6144634880 DEBUG: CPVRChannelGroups - Load - 2 TV channel groups loaded
  496. 10:09:21.620 T:6144634880 DEBUG: CPVRTimers - Update - updating timers
  497. 10:09:21.654 T:6144634880 INFO: AddOnLog: TV Mosaic PVR Client: Found 6 timers
  498. 10:09:21.669 T:6144634880 INFO: AddOnLog: TV Mosaic PVR Client: Found 9 schedules
  499. 10:09:21.671 T:6144634880 INFO: AddOnLog: TV Mosaic PVR Client: Added EPG schedule : 1
  500. 10:09:21.671 T:6144634880 INFO: AddOnLog: TV Mosaic PVR Client: Added EPG schedule : 3
  501. 10:09:21.671 T:6144634880 INFO: AddOnLog: TV Mosaic PVR Client: Added EPG schedule : 6
  502. 10:09:21.671 T:6144634880 INFO: AddOnLog: TV Mosaic PVR Client: Added EPG schedule : 14
  503. 10:09:21.671 T:6144634880 INFO: AddOnLog: TV Mosaic PVR Client: Added EPG schedule : 15
  504. 10:09:21.671 T:6144634880 INFO: AddOnLog: TV Mosaic PVR Client: Added EPG schedule : 16
  505. 10:09:21.671 T:6144634880 INFO: AddOnLog: TV Mosaic PVR Client: Added EPG schedule : 17
  506. 10:09:21.671 T:6144634880 INFO: AddOnLog: TV Mosaic PVR Client: Added EPG schedule : 18
  507. 10:09:21.671 T:6144634880 INFO: AddOnLog: TV Mosaic PVR Client: Added EPG schedule : 19
  508. 10:09:21.672 T:6144634880 INFO: AddOnLog: TV Mosaic PVR Client: Added EPG timer : Jeopardy! *
  509. 10:09:21.672 T:6144634880 INFO: Previous line repeats 5 times.
  510. 10:09:21.672 T:6144634880 DEBUG: PVRTimers - UpdateEntries - added timer 10 on client 1
  511. 10:09:21.672 T:6144634880 DEBUG: PVRTimers - UpdateEntries - added timer 11 on client 1
  512. 10:09:21.672 T:6144634880 DEBUG: PVRTimers - UpdateEntries - added timer 12 on client 1
  513. 10:09:21.672 T:6144634880 DEBUG: PVRTimers - UpdateEntries - added timer 13 on client 1
  514. 10:09:21.672 T:6144634880 DEBUG: PVRTimers - UpdateEntries - added timer 14 on client 1
  515. 10:09:21.672 T:6144634880 DEBUG: PVRTimers - UpdateEntries - added timer 15 on client 1
  516. 10:09:21.672 T:6144634880 DEBUG: PVRTimers - UpdateEntries - added timer 16 on client 1
  517. 10:09:21.672 T:6144634880 DEBUG: PVRTimers - UpdateEntries - added timer 17 on client 1
  518. 10:09:21.672 T:6144634880 DEBUG: PVRTimers - UpdateEntries - added timer 18 on client 1
  519. 10:09:21.672 T:6144634880 DEBUG: PVRTimers - UpdateEntries - added timer 19 on client 1
  520. 10:09:21.672 T:6144634880 DEBUG: PVRTimers - UpdateEntries - added timer 20 on client 1
  521. 10:09:21.672 T:6144634880 DEBUG: PVRTimers - UpdateEntries - added timer 21 on client 1
  522. 10:09:21.672 T:6144634880 DEBUG: PVRTimers - UpdateEntries - added timer 22 on client 1
  523. 10:09:21.672 T:6144634880 DEBUG: PVRTimers - UpdateEntries - added timer 23 on client 1
  524. 10:09:21.672 T:6144634880 DEBUG: PVRTimers - UpdateEntries - added timer 24 on client 1
  525. 10:09:21.684 T:6144634880 DEBUG: CPVRRecordings - Update - updating recordings
  526. 10:09:21.722 T:6144634880 INFO: AddOnLog: TV Mosaic PVR Client: Found 12 recordings
  527. 10:09:21.751 T:6144634880 DEBUG: PVRManager - Process - entering main loop
  528. 10:09:21.751 T:6145781760 INFO: PVRChannelGroupsContainer - SearchMissingChannelIcons - starting channel icon search
  529. 10:09:21.917 T:6144061440 NOTICE: Start - EPG thread started
  530. 10:09:22.065 T:6152089600 INFO: easy_aquire - Created session to http://www.msftncsi.com
  531. 10:09:22.146 T:6152089600 ERROR: CCurlFile::Exists - Failed: Couldn't connect to server(7) for http://www.msftncsi.com/ncsi.txt
  532. 10:09:22.146 T:6152089600 INFO: easy_aquire - Created session to http://www.w3.org
  533. 10:09:22.234 T:6140620800 DEBUG: ------ Window Deinit (DialogExtendedProgressBar.xml) ------
  534. 10:09:22.365 T:6152089600 DEBUG: CPlexServices::Process has gateway1
  535. 10:09:22.365 T:6152089600 DEBUG: CurlFile::Open(0x11a9720b0) https://plex.tv/pms/resources?includeHttps=1
  536. 10:09:22.365 T:6152089600 INFO: easy_aquire - Created session to https://plex.tv
  537. 10:09:22.956 T:6140620800 DEBUG: ------ Window Init (DialogExtendedProgressBar.xml) ------
  538. 10:09:22.963 T:6144634880 DEBUG: CPVRTimers - Update - updating timers
  539. 10:09:22.971 T:6144061440 INFO: PVRChannelGroupsContainer - SearchMissingChannelIcons - starting channel icon search
  540. 10:09:22.971 T:6141767680 DEBUG: CActiveAE - device change event
  541. 10:09:22.971 T:4391316352 DEBUG: enterActiveDelayed: AVPlayerHDRMode = 6
  542. 10:09:22.994 T:6144634880 INFO: AddOnLog: TV Mosaic PVR Client: Found 6 timers
  543. 10:09:23.001 T:6140620800 DEBUG: ------ Window Deinit (DialogExtendedProgressBar.xml) ------
  544. 10:09:23.010 T:6144634880 INFO: AddOnLog: TV Mosaic PVR Client: Found 9 schedules
  545. 10:09:23.011 T:6144634880 INFO: AddOnLog: TV Mosaic PVR Client: Added EPG schedule : 1
  546. 10:09:23.011 T:6144634880 INFO: AddOnLog: TV Mosaic PVR Client: Added EPG schedule : 3
  547. 10:09:23.011 T:6144634880 INFO: AddOnLog: TV Mosaic PVR Client: Added EPG schedule : 6
  548. 10:09:23.011 T:6144634880 INFO: AddOnLog: TV Mosaic PVR Client: Added EPG schedule : 14
  549. 10:09:23.011 T:6144634880 INFO: AddOnLog: TV Mosaic PVR Client: Added EPG schedule : 15
  550. 10:09:23.011 T:6144634880 INFO: AddOnLog: TV Mosaic PVR Client: Added EPG schedule : 16
  551. 10:09:23.012 T:6144634880 INFO: AddOnLog: TV Mosaic PVR Client: Added EPG schedule : 17
  552. 10:09:23.012 T:6144634880 INFO: AddOnLog: TV Mosaic PVR Client: Added EPG schedule : 18
  553. 10:09:23.012 T:6144634880 INFO: AddOnLog: TV Mosaic PVR Client: Added EPG schedule : 19
  554. 10:09:23.012 T:6144634880 INFO: AddOnLog: TV Mosaic PVR Client: Added EPG timer : Jeopardy! *
  555. 10:09:23.013 T:6144634880 INFO: Previous line repeats 5 times.
  556. 10:09:23.013 T:6144634880 DEBUG: PVRTimers - UpdateEntries - updated timer 10 on client 1
  557. 10:09:23.013 T:6144634880 DEBUG: PVRTimers - UpdateEntries - updated timer 11 on client 1
  558. 10:09:23.013 T:6144634880 DEBUG: PVRTimers - UpdateEntries - updated timer 12 on client 1
  559. 10:09:23.013 T:6144634880 DEBUG: PVRTimers - UpdateEntries - updated timer 13 on client 1
  560. 10:09:23.013 T:6144634880 DEBUG: PVRTimers - UpdateEntries - updated timer 14 on client 1
  561. 10:09:23.013 T:6144634880 DEBUG: PVRTimers - UpdateEntries - updated timer 15 on client 1
  562. 10:09:23.013 T:6144634880 DEBUG: PVRTimers - UpdateEntries - updated timer 16 on client 1
  563. 10:09:23.013 T:6144634880 DEBUG: PVRTimers - UpdateEntries - updated timer 17 on client 1
  564. 10:09:23.013 T:6144634880 DEBUG: PVRTimers - UpdateEntries - updated timer 18 on client 1
  565. 10:09:23.013 T:6144634880 DEBUG: PVRTimers - UpdateEntries - updated timer 19 on client 1
  566. 10:09:23.013 T:6144634880 DEBUG: PVRTimers - UpdateEntries - updated timer 20 on client 1
  567. 10:09:23.013 T:6144634880 DEBUG: PVRTimers - UpdateEntries - updated timer 21 on client 1
  568. 10:09:23.013 T:6144634880 DEBUG: PVRTimers - UpdateEntries - updated timer 22 on client 1
  569. 10:09:23.013 T:6144634880 DEBUG: PVRTimers - UpdateEntries - updated timer 23 on client 1
  570. 10:09:23.013 T:6144634880 DEBUG: PVRTimers - UpdateEntries - updated timer 24 on client 1
  571. 10:09:23.018 T:6144634880 DEBUG: CPVRChannelGroupsContainer - Update - updating channel groups
  572. 10:09:23.018 T:6144634880 INFO: AddOnLog: TV Mosaic PVR Client: Getting channels (22 channels on server)
  573. 10:09:23.018 T:6144634880 DEBUG: PVR - GetChannelGroupMembers - get group members for group 'TV' from add-on 'DVBLink Server:192.168.2.10'
  574. 10:09:23.018 T:6144634880 DEBUG: PVR - GetChannelGroupMembers - get group members for group 'Radio' from add-on 'DVBLink Server:192.168.2.10'
  575. 10:09:23.018 T:6144634880 DEBUG: CPVRChannelGroups - PersistAll - persisting all changes in channel groups
  576. 10:09:23.019 T:6144634880 INFO: AddOnLog: TV Mosaic PVR Client: Getting channels (22 channels on server)
  577. 10:09:23.019 T:6144634880 DEBUG: PVR - GetChannelGroupMembers - get group members for group 'TV' from add-on 'DVBLink Server:192.168.2.10'
  578. 10:09:23.019 T:6144634880 DEBUG: PVR - GetChannelGroupMembers - get group members for group 'Radio' from add-on 'DVBLink Server:192.168.2.10'
  579. 10:09:23.019 T:6144634880 DEBUG: CPVRChannelGroups - PersistAll - persisting all changes in channel groups
  580. 10:09:23.020 T:6144634880 DEBUG: CPVRChannelGroupsContainer - Update - updating channels
  581. 10:09:23.020 T:6144634880 INFO: AddOnLog: TV Mosaic PVR Client: Getting channels (22 channels on server)
  582. 10:09:23.020 T:6144634880 DEBUG: CPVRChannelGroups - PersistAll - persisting all changes in channel groups
  583. 10:09:23.020 T:6144634880 INFO: AddOnLog: TV Mosaic PVR Client: Getting channels (22 channels on server)
  584. 10:09:23.020 T:6144634880 DEBUG: CPVRChannelGroups - PersistAll - persisting all changes in channel groups
  585. 10:09:23.020 T:6144634880 DEBUG: CPVRRecordings - Update - updating recordings
  586. 10:09:23.028 T:6144634880 INFO: AddOnLog: TV Mosaic PVR Client: Found 12 recordings
  587. 10:09:23.034 T:6144634880 DEBUG: CPVRTimers - Update - updating timers
  588. 10:09:23.045 T:6141767680 DEBUG: EnumerateDevices:Device(default)
  589. 10:09:23.045 T:6141767680 NOTICE: Found 1 Lists of Devices
  590. 10:09:23.045 T:6141767680 NOTICE: Enumerated DARWINIOS devices:
  591. 10:09:23.045 T:6141767680 NOTICE: Device 1
  592. 10:09:23.045 T:6141767680 NOTICE: m_deviceName : default
  593. 10:09:23.045 T:6141767680 NOTICE: m_displayName : Default
  594. 10:09:23.045 T:6141767680 NOTICE: m_displayNameExtra:
  595. 10:09:23.045 T:6141767680 NOTICE: m_deviceType : AE_DEVTYPE_HDMI
  596. 10:09:23.045 T:6141767680 NOTICE: m_channels : FL,FR,FC,LFE,BL,BR,SL,SR
  597. 10:09:23.045 T:6141767680 NOTICE: m_sampleRates : 44100,48000
  598. 10:09:23.045 T:6141767680 NOTICE: m_dataFormats : AE_FMT_RAW,AE_FMT_S16LE,AE_FMT_FLOAT
  599. 10:09:23.045 T:6141767680 NOTICE: m_streamTypes : STREAM_TYPE_AC3,STREAM_TYPE_EAC3,STREAM_TYPE_DTS_512,STREAM_TYPE_DTS_1024,STREAM_TYPE_DTS_2048,STREAM_TYPE_DTSHD_CORE
  600. 10:09:23.045 T:6142341120 INFO: CActiveAESink::OpenSink - initialize sink
  601. 10:09:23.045 T:6142341120 DEBUG: CActiveAESink::OpenSink - trying to open device DARWINIOS:default
  602. 10:09:23.048 T:6142341120 DEBUG: virtual bool CAESinkDARWINIOS::Initialize(AEAudioFormat &, std::string &): AudioStreamBasicDescription: [lpcm] Mixable Interleaved 2 Channel 32-bit Floating Point LE (48000Hz) pcm
  603. 10:09:23.052 T:6142341120 NOTICE: bool CAAudioUnitSink::setupAudio() setting channels 2
  604. 10:09:23.052 T:6142341120 NOTICE: bool CAAudioUnitSink::setupAudio() setting samplerate 48000.000000
  605. 10:09:23.052 T:6142341120 NOTICE: bool CAAudioUnitSink::setupAudio() setting buffer duration to 0.042667
  606. 10:09:23.057 T:6144634880 INFO: AddOnLog: TV Mosaic PVR Client: Found 6 timers
  607. 10:09:23.074 T:6144634880 INFO: AddOnLog: TV Mosaic PVR Client: Found 9 schedules
  608. 10:09:23.074 T:6144634880 INFO: AddOnLog: TV Mosaic PVR Client: Added EPG schedule : 1
  609. 10:09:23.075 T:6144634880 INFO: AddOnLog: TV Mosaic PVR Client: Added EPG schedule : 3
  610. 10:09:23.076 T:6144634880 INFO: AddOnLog: TV Mosaic PVR Client: Added EPG schedule : 6
  611. 10:09:23.076 T:6144634880 INFO: AddOnLog: TV Mosaic PVR Client: Added EPG schedule : 14
  612. 10:09:23.077 T:6144634880 INFO: AddOnLog: TV Mosaic PVR Client: Added EPG schedule : 15
  613. 10:09:23.077 T:6144634880 INFO: AddOnLog: TV Mosaic PVR Client: Added EPG schedule : 16
  614. 10:09:23.078 T:6144634880 INFO: AddOnLog: TV Mosaic PVR Client: Added EPG schedule : 17
  615. 10:09:23.078 T:6144634880 INFO: AddOnLog: TV Mosaic PVR Client: Added EPG schedule : 18
  616. 10:09:23.078 T:6144634880 INFO: AddOnLog: TV Mosaic PVR Client: Added EPG schedule : 19
  617. 10:09:23.078 T:6144634880 INFO: AddOnLog: TV Mosaic PVR Client: Added EPG timer : Jeopardy! *
  618. 10:09:23.079 T:6144634880 INFO: Previous line repeats 5 times.
  619. 10:09:23.079 T:6144634880 DEBUG: PVRTimers - UpdateEntries - updated timer 10 on client 1
  620. 10:09:23.079 T:6144634880 DEBUG: PVRTimers - UpdateEntries - updated timer 11 on client 1
  621. 10:09:23.079 T:6144634880 DEBUG: PVRTimers - UpdateEntries - updated timer 12 on client 1
  622. 10:09:23.079 T:6144634880 DEBUG: PVRTimers - UpdateEntries - updated timer 13 on client 1
  623. 10:09:23.079 T:6144634880 DEBUG: PVRTimers - UpdateEntries - updated timer 14 on client 1
  624. 10:09:23.080 T:6144634880 DEBUG: PVRTimers - UpdateEntries - updated timer 15 on client 1
  625. 10:09:23.080 T:6144634880 DEBUG: PVRTimers - UpdateEntries - updated timer 16 on client 1
  626. 10:09:23.080 T:6144634880 DEBUG: PVRTimers - UpdateEntries - updated timer 17 on client 1
  627. 10:09:23.080 T:6144634880 DEBUG: PVRTimers - UpdateEntries - updated timer 18 on client 1
  628. 10:09:23.080 T:6144634880 DEBUG: PVRTimers - UpdateEntries - updated timer 19 on client 1
  629. 10:09:23.080 T:6144634880 DEBUG: PVRTimers - UpdateEntries - updated timer 20 on client 1
  630. 10:09:23.080 T:6144634880 DEBUG: PVRTimers - UpdateEntries - updated timer 21 on client 1
  631. 10:09:23.081 T:6144634880 DEBUG: PVRTimers - UpdateEntries - updated timer 22 on client 1
  632. 10:09:23.081 T:6144634880 DEBUG: PVRTimers - UpdateEntries - updated timer 23 on client 1
  633. 10:09:23.081 T:6144634880 DEBUG: PVRTimers - UpdateEntries - updated timer 24 on client 1
  634. 10:09:23.081 T:6142341120 NOTICE: bool CAAudioUnitSink::setupAudio() total latency = 0.044500
  635. 10:09:23.081 T:6142341120 NOTICE: bool CAAudioUnitSink::setupAudio() setup audio format: [lpcm] Mixable Interleaved 2 Channel 32-bit Floating Point LE (48000Hz)
  636. 10:09:23.082 T:6142341120 NOTICE: void dumpAVAudioSessionProperties() audio route = HDMIOutput
  637. 10:09:23.083 T:6142341120 NOTICE: void dumpAVAudioSessionProperties() sampleRate 48000.000000
  638. 10:09:23.083 T:6142341120 NOTICE: void dumpAVAudioSessionProperties() outputLatency 0.001833
  639. 10:09:23.084 T:6142341120 NOTICE: void dumpAVAudioSessionProperties() IOBufferDuration 0.042667
  640. 10:09:23.084 T:6142341120 NOTICE: void dumpAVAudioSessionProperties() outputNumberOfChannels 2
  641. 10:09:23.085 T:6142341120 NOTICE: void dumpAVAudioSessionProperties() maximumOutputNumberOfChannels 32
  642. 10:09:23.085 T:6142341120 DEBUG: DumpAudioDescriptions: void dumpAVAudioSessionProperties()
  643. 10:09:23.086 T:6142341120 DEBUG: DumpAudioDescriptions: input count = 0
  644. 10:09:23.087 T:6142341120 DEBUG: DumpAudioDescriptions: output count = 1
  645. 10:09:23.087 T:6142341120 DEBUG: DumpAudioDescriptions : portName, Living Room
  646. 10:09:23.087 T:6142341120 DEBUG: DumpAudioDescriptions: channelLabel, 1
  647. 10:09:23.087 T:6142341120 DEBUG: DumpAudioDescriptions: channelName , Living Room 1
  648. 10:09:23.087 T:6142341120 DEBUG: DumpAudioDescriptions: channelLabel, 2
  649. 10:09:23.087 T:6142341120 DEBUG: DumpAudioDescriptions: channelName , Living Room 2
  650. 10:09:23.127 T:6142341120 DEBUG: CActiveAESink::OpenSink - DARWINIOS Initialized:
  651. 10:09:23.127 T:6142341120 DEBUG: Output Device : Default
  652. 10:09:23.127 T:6142341120 DEBUG: Sample Rate : 48000
  653. 10:09:23.127 T:6142341120 DEBUG: Sample Format : AE_FMT_FLOAT
  654. 10:09:23.127 T:6142341120 DEBUG: Channel Count : 2
  655. 10:09:23.127 T:6142341120 DEBUG: Channel Layout: FL,FR
  656. 10:09:23.127 T:6142341120 DEBUG: Frames : 1024
  657. 10:09:23.127 T:6142341120 DEBUG: Frame Size : 8
  658. 10:09:23.127 T:6142341120 DEBUG: CActiveAESink::GenerateNoise - noiseFactor = 0.000010
  659. 10:09:23.127 T:6141767680 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
  660. 10:09:23.221 T:6152089600 DEBUG: CurlFile::Open(0x16eb16380) https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct:32400/identity
  661. 10:09:23.221 T:6152089600 INFO: easy_aquire - Created session to https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct
  662. 10:09:23.360 T:6152089600 DEBUG: CPlexClient::Init serverName(Desktop), ipAddress(https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct:32400), protocol(https)
  663. 10:09:23.360 T:6152089600 DEBUG: CurlFile::Open(0x16eb16650) https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct:32400/library/sections
  664. 10:09:23.412 T:6152089600 DEBUG: CPlexClient::ParseSections Desktop found 5 movie sections
  665. 10:09:23.412 T:6152089600 DEBUG: CPlexClient::ParseSections Desktop found 3 shows sections
  666. 10:09:23.412 T:6152089600 DEBUG: CPlexClient::ParseSections Desktop found 0 artist sections
  667. 10:09:23.412 T:6152089600 DEBUG: CPlexClient::ParseSections Desktop found 0 photo sections
  668. 10:09:23.412 T:6152089600 DEBUG: CurlFile::Open(0x16eb16650) https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct:32400/playlists
  669. 10:09:23.452 T:6152089600 DEBUG: CPlexClient::ParseSections Desktop found 0 playlist sections
  670. 10:09:23.452 T:6152089600 NOTICE: CPlexServices: Server found via plex.tv Desktop
  671. 10:09:23.452 T:6144061440 DEBUG: CGUIWindowHome::Announce, type: 16, from xbmc, message UpdateRecentlyAdded
  672. 10:09:23.453 T:6152089600 DEBUG: CurlFile::Open(0x16eb16380) https://192-168-1-15.f1b672659c584dff9a232bd8fda325f3.plex.direct:32400/identity
  673. 10:09:23.453 T:6144061440 DEBUG: CGUIWindowHome::Announce, type: 32, from xbmc, message UpdateRecentlyAdded
  674. 10:09:23.453 T:6152089600 INFO: easy_aquire - Created session to https://192-168-1-15.f1b672659c584dff9a232bd8fda325f3.plex.direct
  675. 10:09:23.460 T:6145781760 DEBUG: CHomeShelfJob::UpdateVideos() - Running HomeShelf screen update
  676. 10:09:23.466 T:6145781760 DEBUG: CurlFile::Open(0x16e5109f0) https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct:32400/hubs/home/recentlyAdded?X-Plex-Container-Size=20&X-Plex-Container-Start=0&X-Plex-Token=PLEXTOKEN&type=2
  677. 10:09:23.563 T:6145781760 DEBUG: CurlFile::Open(0x16e5109f0) https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct:32400/hubs/home/recentlyAdded?X-Plex-Container-Size=20&X-Plex-Container-Start=0&X-Plex-Token=PLEXTOKEN&type=1
  678. 10:09:23.603 T:6145781760 DEBUG: CurlFile::Open(0x16e5109f0) https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct:32400/hubs/home/onDeck?X-Plex-Container-Size=20&X-Plex-Container-Start=0&X-Plex-Token=PLEXTOKEN&type=2
  679. 10:09:23.708 T:6145781760 DEBUG: CurlFile::Open(0x16e5109e0) https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct:32400/library/onDeck?X-Plex-Container-Size=20&X-Plex-Container-Start=0&X-Plex-Token=PLEXTOKEN&type=1
  680. 10:09:23.752 T:6145781760 DEBUG: CurlFile::Open(0x16e5108c0) https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct:32400/hubs/home/continueWatching?X-Plex-Token=PLEXTOKEN
  681. 10:09:23.829 T:6145781760 DEBUG: CFileCache::Open - opening <photo/:/transcode> using cache
  682. 10:09:23.829 T:6145781760 DEBUG: CurlFile::Open(0x10618b400) https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct:32400/photo/:/transcode?X-Plex-Token=PLEXTOKEN&height=800&url=%2flibrary%2fmetadata%2f11552%2fthumb%2f1545319391&width=800
  683. 10:09:23.985 T:6145781760 DEBUG: CFileCache::Open - opening <photo/:/transcode> using cache
  684. 10:09:23.985 T:6145781760 DEBUG: CurlFile::Open(0x106902200) https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct:32400/photo/:/transcode?X-Plex-Token=PLEXTOKEN&height=800&quality=90&url=%2flibrary%2fmetadata%2f11551%2fthumb%2f1545319036&width=800
  685. 10:09:24.099 T:6145781760 DEBUG: CFileCache::Open - opening <photo/:/transcode> using cache
  686. 10:09:24.099 T:6145781760 DEBUG: CurlFile::Open(0x10613ec00) https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct:32400/photo/:/transcode?X-Plex-Token=PLEXTOKEN&height=800&quality=90&url=%2flibrary%2fmetadata%2f11548%2fthumb%2f1545278337&width=800
  687. 10:09:24.155 T:6145781760 DEBUG: CFileCache::Open - opening <photo/:/transcode> using cache
  688. 10:09:24.155 T:6145781760 DEBUG: CurlFile::Open(0x107181400) https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct:32400/photo/:/transcode?X-Plex-Token=PLEXTOKEN&height=800&quality=90&url=%2flibrary%2fmetadata%2f11546%2fthumb%2f1545239640&width=800
  689. 10:09:24.184 T:6145781760 DEBUG: CFileCache::Open - opening <photo/:/transcode> using cache
  690. 10:09:24.184 T:6145781760 DEBUG: CurlFile::Open(0x106902200) https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct:32400/photo/:/transcode?X-Plex-Token=PLEXTOKEN&height=800&quality=90&url=%2flibrary%2fmetadata%2f11547%2fthumb%2f1545239644&width=800
  691. 10:09:24.261 T:6145781760 DEBUG: CFileCache::Open - opening <photo/:/transcode> using cache
  692. 10:09:24.262 T:6145781760 DEBUG: CurlFile::Open(0x106131000) https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct:32400/photo/:/transcode?height=800&url=%2flibrary%2fmetadata%2f11529%2fthumb%2f1545275070&width=800
  693. 10:09:24.293 T:6145781760 DEBUG: CFileCache::Open - opening <photo/:/transcode> using cache
  694. 10:09:24.293 T:6145781760 DEBUG: CurlFile::Open(0x106131000) https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct:32400/photo/:/transcode?height=800&quality=90&url=%2flibrary%2fmetadata%2f10768%2fthumb%2f1544555868&width=800
  695. 10:09:24.359 T:6145781760 DEBUG: CFileCache::Open - opening <photo/:/transcode> using cache
  696. 10:09:24.359 T:6145781760 DEBUG: CurlFile::Open(0x106902200) https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct:32400/photo/:/transcode?height=800&quality=90&url=%2flibrary%2fmetadata%2f11079%2fthumb%2f1537626320&width=800
  697. 10:09:24.391 T:6145781760 DEBUG: CFileCache::Open - opening <photo/:/transcode> using cache
  698. 10:09:24.391 T:6145781760 DEBUG: CurlFile::Open(0x107181400) https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct:32400/photo/:/transcode?X-Plex-Token=PLEXTOKEN&height=800&url=%2flibrary%2fmetadata%2f11540%2fthumb%2f1545018022&width=800
  699. 10:09:24.460 T:6145781760 DEBUG: CFileCache::Open - opening <photo/:/transcode> using cache
  700. 10:09:24.460 T:6145781760 DEBUG: CurlFile::Open(0x106131000) https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct:32400/photo/:/transcode?X-Plex-Token=PLEXTOKEN&height=800&quality=90&url=%2flibrary%2fmetadata%2f6678%2fthumb%2f1542355566&width=800
  701. 10:09:24.500 T:6145781760 DEBUG: CFileCache::Open - opening <photo/:/transcode> using cache
  702. 10:09:24.500 T:6145781760 DEBUG: CurlFile::Open(0x106902200) https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct:32400/photo/:/transcode?height=800&url=%2flibrary%2fmetadata%2f11368%2fthumb%2f1541516134&width=800
  703. 10:09:24.581 T:6145781760 DEBUG: CFileCache::Open - opening <photo/:/transcode> using cache
  704. 10:09:24.582 T:6145781760 DEBUG: CurlFile::Open(0x10613ec00) https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct:32400/photo/:/transcode?height=800&quality=90&url=%2flibrary%2fmetadata%2f11519%2fthumb%2f1544579441&width=800
  705. 10:09:24.614 T:6145781760 DEBUG: CFileCache::Open - opening <photo/:/transcode> using cache
  706. 10:09:24.615 T:6145781760 DEBUG: CurlFile::Open(0x107181400) https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct:32400/photo/:/transcode?height=800&quality=90&url=%2flibrary%2fmetadata%2f10390%2fthumb%2f1537254628&width=800
  707. 10:09:24.693 T:6145781760 DEBUG: CHomeShelfJob::UpdateMusic() - Running HomeShelf screen update
  708. 10:09:24.694 T:6145781760 DEBUG: CurlFile::Open(0x16e5120a0) https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct:32400/hubs/home/recentlyAdded?X-Plex-Container-Size=10&X-Plex-Container-Start=0&X-Plex-Token=PLEXTOKEN&type=8
  709. 10:09:24.729 T:6140620800 ERROR: CGUITextureManager::GetTexturePath: could not find texture 'thumbs/OverlayWatched.png'
  710. 10:09:24.834 T:6144061440 ERROR: Previous line repeats 1 times.
  711. 10:09:24.834 T:6144061440 INFO: easy_aquire - Created session to https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct
  712. 10:09:24.834 T:6145781760 ERROR: CPlexUtils::ParsePlexArtistsAlbum directory is null https://HOSTNAME:32400/hubs/home/recentlyAdded|&X-Plex-Container-Size=10&X-Plex-Container-Start=0&X-Plex-Token=PLEXTOKEN&type=8
  713. 10:09:24.890 T:6144061440 DEBUG: CCurlFile::GetMimeType - https://HOSTNAME:32400/photo/:/transcode?height=800&url=%2flibrary%2fmetadata%2f11552%2fthumb%2f1545319391&width=800|&X-Plex-Token=PLEXTOKEN -> image/jpeg
  714. 10:09:24.890 T:6144061440 DEBUG: CFileCache::Open - opening <photo/:/transcode> using cache
  715. 10:09:24.890 T:6144061440 DEBUG: CurlFile::Open(0x1071ea400) https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct:32400/photo/:/transcode?height=800&url=%2flibrary%2fmetadata%2f11552%2fthumb%2f1545319391&width=800
  716. 10:09:24.961 T:6144061440 DEBUG: Caching image 'https://HOSTNAME:32400/photo/:/transcode?height=800&url=%2flibrary%2fmetadata%2f11552%2fthumb%2f1545319391&width=800|&X-Plex-Token=PLEXTOKEN' to '4/44fb3e5c.jpg':
  717. 10:09:25.105 T:6145781760 DEBUG: CCurlFile::GetMimeType - https://HOSTNAME:32400/photo/:/transcode?height=800&quality=90&url=%2flibrary%2fmetadata%2f11551%2fthumb%2f1545319036&width=800|&X-Plex-Token=PLEXTOKEN -> image/jpeg
  718. 10:09:25.106 T:6145781760 DEBUG: CFileCache::Open - opening <photo/:/transcode> using cache
  719. 10:09:25.106 T:6145781760 DEBUG: CurlFile::Open(0x10697ae00) https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct:32400/photo/:/transcode?height=800&quality=90&url=%2flibrary%2fmetadata%2f11551%2fthumb%2f1545319036&width=800
  720. 10:09:25.180 T:6145781760 DEBUG: Caching image 'https://HOSTNAME:32400/photo/:/transcode?height=800&quality=90&url=%2flibrary%2fmetadata%2f11551%2fthumb%2f1545319036&width=800|&X-Plex-Token=PLEXTOKEN' to '3/34307838.jpg':
  721. 10:09:28.159 T:6140620800 DEBUG: Activating window ID: 10004
  722. 10:09:28.289 T:6140620800 DEBUG: ------ Window Deinit (Home.xml) ------
  723. 10:09:28.289 T:6140620800 DEBUG: ------ Window Init (Settings.xml) ------
  724. 10:09:28.289 T:6140620800 INFO: Loading skin file: Settings.xml, load type: KEEP_IN_MEMORY
  725. 10:09:31.193 T:6140620800 DEBUG: Activating window ID: 10016
  726. 10:09:31.323 T:6140620800 DEBUG: ------ Window Deinit (Settings.xml) ------
  727. 10:09:31.324 T:6140620800 DEBUG: ------ Window Init (SettingsCategory.xml) ------
  728. 10:09:31.324 T:6140620800 INFO: Loading skin file: SettingsCategory.xml, load type: KEEP_IN_MEMORY
  729. 10:09:34.875 T:6140620800 DEBUG: found key /userdata/profiles.xml
  730. 10:09:34.875 T:6140620800 DEBUG: Previous line repeats 1 times.
  731. 10:09:34.875 T:6140620800 DEBUG: NSUSerDefaults: compressed /userdata/profiles.xml from 923 to 324
  732. 10:09:34.875 T:6140620800 DEBUG: found key /userdata/guisettings.xml
  733. 10:09:34.876 T:6140620800 DEBUG: Previous line repeats 1 times.
  734. 10:09:34.876 T:6140620800 DEBUG: NSUSerDefaults: compressed /userdata/guisettings.xml from 35403 to 6831
  735. 10:09:34.877 T:6140620800 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
  736. 10:09:35.007 T:6140620800 DEBUG: ------ Window Deinit (SettingsCategory.xml) ------
  737. 10:09:35.008 T:6140620800 DEBUG: CGUIWindowManager::PreviousWindow: Activate new
  738. 10:09:35.008 T:6140620800 DEBUG: ------ Window Init (Settings.xml) ------
  739. 10:09:42.609 T:6140620800 DEBUG: Activating window ID: 10018
  740. 10:09:42.750 T:6140620800 DEBUG: ------ Window Deinit (Settings.xml) ------
  741. 10:09:42.751 T:6140620800 DEBUG: ------ Window Init (SettingsCategory.xml) ------
  742. 10:09:43.996 T:6140620800 DEBUG: found key /userdata/profiles.xml
  743. 10:09:43.998 T:6140620800 DEBUG: Previous line repeats 1 times.
  744. 10:09:43.998 T:6140620800 DEBUG: NSUSerDefaults: compressed /userdata/profiles.xml from 923 to 324
  745. 10:09:43.999 T:6140620800 DEBUG: found key /userdata/guisettings.xml
  746. 10:09:44.010 T:6140620800 DEBUG: Previous line repeats 1 times.
  747. 10:09:44.010 T:6140620800 DEBUG: NSUSerDefaults: compressed /userdata/guisettings.xml from 35403 to 6831
  748. 10:09:44.011 T:6140620800 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
  749. 10:09:44.115 T:6140620800 DEBUG: ------ Window Deinit (SettingsCategory.xml) ------
  750. 10:09:44.115 T:6140620800 DEBUG: CGUIWindowManager::PreviousWindow: Activate new
  751. 10:09:44.116 T:6140620800 DEBUG: ------ Window Init (Settings.xml) ------
  752. 10:09:45.628 T:6140620800 DEBUG: Activating window ID: 10016
  753. 10:09:45.750 T:6140620800 DEBUG: ------ Window Deinit (Settings.xml) ------
  754. 10:09:45.751 T:6140620800 DEBUG: ------ Window Init (SettingsCategory.xml) ------
  755. 10:09:52.991 T:6140620800 DEBUG: found key /userdata/profiles.xml
  756. 10:09:52.992 T:6140620800 DEBUG: Previous line repeats 1 times.
  757. 10:09:52.992 T:6140620800 DEBUG: NSUSerDefaults: compressed /userdata/profiles.xml from 923 to 324
  758. 10:09:52.992 T:6140620800 DEBUG: found key /userdata/guisettings.xml
  759. 10:09:52.995 T:6140620800 DEBUG: Previous line repeats 1 times.
  760. 10:09:52.995 T:6140620800 DEBUG: NSUSerDefaults: compressed /userdata/guisettings.xml from 35403 to 6831
  761. 10:09:52.996 T:6140620800 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
  762. 10:09:53.107 T:6140620800 DEBUG: ------ Window Deinit (SettingsCategory.xml) ------
  763. 10:09:53.107 T:6140620800 DEBUG: CGUIWindowManager::PreviousWindow: Activate new
  764. 10:09:53.107 T:6140620800 DEBUG: ------ Window Init (Settings.xml) ------
  765. 10:09:54.308 T:6140620800 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
  766. 10:09:54.443 T:6140620800 DEBUG: ------ Window Deinit (Settings.xml) ------
  767. 10:09:54.444 T:6140620800 DEBUG: CGUIWindowManager::PreviousWindow: Activate new
  768. 10:09:54.445 T:6140620800 DEBUG: ------ Window Init (Home.xml) ------
  769. 10:09:54.454 T:6153809920 DEBUG: CHomeShelfJob::UpdateMusic() - Running HomeShelf screen update
  770. 10:09:54.455 T:6153809920 DEBUG: CurlFile::Open(0x16ecba0a0) https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct:32400/hubs/home/recentlyAdded?X-Plex-Container-Size=10&X-Plex-Container-Start=0&X-Plex-Token=PLEXTOKEN&type=8
  771. 10:09:54.494 T:6153809920 ERROR: CPlexUtils::ParsePlexArtistsAlbum directory is null https://HOSTNAME:32400/hubs/home/recentlyAdded|&X-Plex-Container-Size=10&X-Plex-Container-Start=0&X-Plex-Token=PLEXTOKEN&type=8
  772. 10:09:54.494 T:6153809920 DEBUG: CHomeShelfJob::UpdateVideos() - Running HomeShelf screen update
  773. 10:09:54.494 T:6153809920 DEBUG: CurlFile::Open(0x16ecb89f0) https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct:32400/hubs/home/recentlyAdded?X-Plex-Container-Size=20&X-Plex-Container-Start=0&X-Plex-Token=PLEXTOKEN&type=2
  774. 10:09:54.587 T:6153809920 DEBUG: CurlFile::Open(0x16ecb89f0) https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct:32400/hubs/home/recentlyAdded?X-Plex-Container-Size=20&X-Plex-Container-Start=0&X-Plex-Token=PLEXTOKEN&type=1
  775. 10:09:54.626 T:6153809920 DEBUG: CurlFile::Open(0x16ecb89f0) https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct:32400/hubs/home/onDeck?X-Plex-Container-Size=20&X-Plex-Container-Start=0&X-Plex-Token=PLEXTOKEN&type=2
  776. 10:09:54.709 T:6153809920 DEBUG: CurlFile::Open(0x16ecb89e0) https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct:32400/library/onDeck?X-Plex-Container-Size=20&X-Plex-Container-Start=0&X-Plex-Token=PLEXTOKEN&type=1
  777. 10:09:54.735 T:6153809920 DEBUG: CurlFile::Open(0x16ecb88c0) https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct:32400/hubs/home/continueWatching?X-Plex-Token=PLEXTOKEN
  778. 10:09:54.824 T:6140620800 ERROR: CGUITextureManager::GetTexturePath: could not find texture 'thumbs/OverlayWatched.png'
  779. 10:09:57.236 T:6140620800 INFO: Loading skin file: DialogContextMenu.xml, load type: KEEP_IN_MEMORY
  780. 10:09:57.238 T:6140620800 DEBUG: ------ Window Init (DialogContextMenu.xml) ------
  781. 10:09:58.580 T:6140620800 DEBUG: ------ Window Deinit (DialogContextMenu.xml) ------
  782. 10:09:58.583 T:6140620800 DEBUG: CurlFile::Open(0x16e023440) https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct:32400/library/metadata/6678?X-Plex-Token=PLEXTOKEN
  783. 10:09:58.712 T:6140620800 DEBUG: CCurlFile::GetMimeType - https://HOSTNAME:32400/library/parts/7549/1477323503/file.mkv|&X-Plex-Token=PLEXTOKEN -> video/x-matroska
  784. 10:09:58.729 T:6140620800 DEBUG: Loading settings for https://HOSTNAME:32400/library/parts/7549/1477323503/file.mkv|&X-Plex-Token=PLEXTOKEN
  785. 10:09:58.743 T:6140620800 DEBUG: CPlayerCoreFactory::GetPlayers(https://HOSTNAME:32400/library/parts/7549/1477323503/file.mkv|&X-Plex-Token=PLEXTOKEN)
  786. 10:09:58.743 T:6140620800 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules
  787. 10:09:58.743 T:6140620800 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: streams
  788. 10:09:58.743 T:6140620800 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (1)
  789. 10:09:58.744 T:6140620800 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0
  790. 10:09:58.744 T:6140620800 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
  791. 10:09:58.744 T:6140620800 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1)
  792. 10:09:58.744 T:6140620800 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players
  793. 10:09:58.748 T:6140620800 NOTICE: CDVDPlayer::Opening: https://HOSTNAME:32400/library/parts/7549/1477323503/file.mkv|&X-Plex-Token=PLEXTOKEN
  794. 10:09:58.748 T:6140620800 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
  795. 10:09:58.753 T:6136606720 NOTICE: Creating InputStream
  796. 10:09:58.753 T:6136606720 DEBUG: CurlFile::Open(0x16dc52650) https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct:32400/library/parts/7549/1477323503/file.mkv
  797. 10:09:58.807 T:6136606720 DEBUG: CFileCache::Open - opening <library/parts/7549/1477323503/file.mkv> using cache
  798. 10:09:58.807 T:6136606720 DEBUG: CurlFile::Open(0x1070be000) https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct:32400/library/parts/7549/1477323503/file.mkv
  799. 10:09:58.886 T:6136606720 DEBUG: CurlFile::Open(0x16dc521d0) https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct:32400/library/metadata/6678?X-Plex-Token=PLEXTOKEN
  800. 10:09:58.887 T:6136606720 INFO: easy_aquire - Created session to https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct
  801. 10:09:58.930 T:6136606720 DEBUG: ScanForExternalSubtitles: Searching for subtitles...
  802. 10:09:58.930 T:6136606720 DEBUG: ScanForExternalSubtitles: END (total time: 1 ms)
  803. 10:09:58.931 T:6136606720 NOTICE: Creating Demuxer
  804. 10:09:58.933 T:6136606720 DEBUG: Open - m_ioContext->max_packet_size(1) = 0
  805. 10:09:58.968 T:6136606720 DEBUG: Open - probing detected format [matroska,webm]
  806. 10:09:59.598 T:6136606720 DEBUG: Seek - waiting for position 13702151758.
  807. 10:09:59.663 T:6136606720 DEBUG: Open - avformat_find_stream_info starting
  808. 10:09:59.715 T:6136606720 DEBUG: ffmpeg[16DC53000]: [h264] Reinit context to 1920x800, pix_fmt: yuv420p
  809. 10:09:59.732 T:6136606720 DEBUG: ffmpeg[16DC53000]: [dca] Forcing XLL recovery mode
  810. 10:09:59.734 T:6136606720 DEBUG: ffmpeg[16DC53000]: [h264] Increasing reorder buffer to 1
  811. 10:09:59.752 T:6140620800 DEBUG: ------ Window Init (DialogBusy.xml) ------
  812. 10:09:59.753 T:6136606720 DEBUG: ffmpeg[16DC53000]: [matroska,webm] max_analyze_duration 5000000 reached at 5015000 microseconds st:2
  813. 10:09:59.755 T:6136606720 DEBUG: ffmpeg[16DC53000]: [matroska,webm] Could not find codec parameters for stream 3 (Subtitle: hdmv_pgs_subtitle): unspecified size
  814. 10:09:59.755 T:6136606720 DEBUG: ffmpeg[16DC53000]: [matroska,webm] Consider increasing the value for the 'analyzeduration' and 'probesize' options
  815. 10:09:59.755 T:6136606720 DEBUG: Open - av_find_stream_info finished
  816. 10:09:59.755 T:6136606720 INFO: ffmpeg[16DC53000]: Input #0, matroska,webm, https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct:32400/library/parts/7549/1477323503/file.mk':
  817. 10:09:59.755 T:6136606720 INFO: ffmpeg[16DC53000]: Metadata:
  818. 10:09:59.755 T:6136606720 INFO: ffmpeg[16DC53000]: title : The Hobbit: The Battle of the Five Armies
  819. 10:09:59.755 T:6136606720 INFO: ffmpeg[16DC53000]: encoder : libebml v1.3.3 + libmatroska v1.4.4
  820. 10:09:59.755 T:6136606720 INFO: ffmpeg[16DC53000]: creation_time : 2016-10-24T15:34:37.000000Z
  821. 10:09:59.755 T:6136606720 INFO: ffmpeg[16DC53000]: Duration: 02:24:29.07, start: 0.000000, bitrate: 12644 kb/s
  822. 10:09:59.755 T:6136606720 INFO: ffmpeg[16DC53000]: Chapter #0:0: start 0.000000, end 312.395000
  823. 10:09:59.755 T:6136606720 INFO: ffmpeg[16DC53000]: Metadata:
  824. 10:09:59.755 T:6136606720 INFO: ffmpeg[16DC53000]: title : Fire and Water
  825. 10:09:59.755 T:6136606720 INFO: ffmpeg[16DC53000]: Chapter #0:1: start 312.395000, end 746.287000
  826. 10:09:59.755 T:6136606720 INFO: ffmpeg[16DC53000]: Metadata:
  827. 10:09:59.755 T:6136606720 INFO: ffmpeg[16DC53000]: title : Bard the Dragon-Slayer
  828. 10:09:59.755 T:6136606720 INFO: ffmpeg[16DC53000]: Chapter #0:2: start 746.287000, end 778.527000
  829. 10:09:59.755 T:6136606720 INFO: ffmpeg[16DC53000]: Metadata:
  830. 10:09:59.755 T:6136606720 INFO: ffmpeg[16DC53000]: title : Dungeons of the Dark Lord
  831. 10:09:59.755 T:6136606720 INFO: ffmpeg[16DC53000]: Chapter #0:3: start 778.527000, end 1116.657000
  832. 10:09:59.755 T:6136606720 INFO: ffmpeg[16DC53000]: Metadata:
  833. 10:09:59.755 T:6136606720 INFO: ffmpeg[16DC53000]: title : Shores of the Long Lake
  834. 10:09:59.755 T:6136606720 INFO: ffmpeg[16DC53000]: Chapter #0:4: start 1116.657000, end 1401.399000
  835. 10:09:59.755 T:6136606720 INFO: ffmpeg[16DC53000]: Metadata:
  836. 10:09:59.755 T:6136606720 INFO: ffmpeg[16DC53000]: title : Not at Home
  837. 10:09:59.755 T:6136606720 INFO: ffmpeg[16DC53000]: Chapter #0:5: start 1401.399000, end 1475.390000
  838. 10:09:59.755 T:6136606720 INFO: ffmpeg[16DC53000]: Metadata:
  839. 10:09:59.755 T:6136606720 INFO: ffmpeg[16DC53000]: title : "Others Will Now Look to the Mountain"
  840. 10:09:59.755 T:6136606720 INFO: ffmpeg[16DC53000]: Chapter #0:6: start 1475.390000, end 1543.625000
  841. 10:09:59.755 T:6136606720 INFO: ffmpeg[16DC53000]: Metadata:
  842. 10:09:59.755 T:6136606720 INFO: ffmpeg[16DC53000]: title : Legions of the Defiler
  843. 10:09:59.755 T:6136606720 INFO: ffmpeg[16DC53000]: Chapter #0:7: start 1543.625000, end 1632.255000
  844. 10:09:59.755 T:6136606720 INFO: ffmpeg[16DC53000]: Metadata:
  845. 10:09:59.756 T:6136606720 INFO: ffmpeg[16DC53000]: title : The Mark of Gundabad
  846. 10:09:59.756 T:6136606720 INFO: ffmpeg[16DC53000]: Chapter #0:8: start 1632.255000, end 2070.109000
  847. 10:09:59.756 T:6136606720 INFO: ffmpeg[16DC53000]: Metadata:
  848. 10:09:59.756 T:6136606720 INFO: ffmpeg[16DC53000]: title : Attack on Dol Guldur
  849. 10:09:59.756 T:6136606720 INFO: ffmpeg[16DC53000]: Chapter #0:9: start 2070.109000, end 2307.722000
  850. 10:09:59.756 T:6136606720 INFO: ffmpeg[16DC53000]: Metadata:
  851. 10:09:59.756 T:6136606720 INFO: ffmpeg[16DC53000]: title : The King's Jewel
  852. 10:09:59.756 T:6136606720 INFO: ffmpeg[16DC53000]: Chapter #0:10: start 2307.722000, end 2386.967000
  853. 10:09:59.756 T:6136606720 INFO: ffmpeg[16DC53000]: Metadata:
  854. 10:09:59.756 T:6136606720 INFO: ffmpeg[16DC53000]: title : The Ruins of Dale
  855. 10:09:59.756 T:6136606720 INFO: ffmpeg[16DC53000]: Chapter #0:11: start 2386.967000, end 2457.580000
  856. 10:09:59.756 T:6136606720 INFO: ffmpeg[16DC53000]: Metadata:
  857. 10:09:59.756 T:6136606720 INFO: ffmpeg[16DC53000]: title : Erebor Fortified
  858. 10:09:59.756 T:6136606720 INFO: ffmpeg[16DC53000]: Chapter #0:12: start 2457.580000, end 2634.506000
  859. 10:09:59.756 T:6136606720 INFO: ffmpeg[16DC53000]: Metadata:
  860. 10:09:59.756 T:6136606720 INFO: ffmpeg[16DC53000]: title : The Elvenking's Aid
  861. 10:09:59.756 T:6136606720 INFO: ffmpeg[16DC53000]: Chapter #0:13: start 2634.506000, end 2946.026000
  862. 10:09:59.756 T:6136606720 INFO: ffmpeg[16DC53000]: Metadata:
  863. 10:09:59.756 T:6136606720 INFO: ffmpeg[16DC53000]: title : The Gathering of the Clouds
  864. 10:09:59.756 T:6136606720 INFO: ffmpeg[16DC53000]: Chapter #0:14: start 2946.026000, end 3156.319000
  865. 10:09:59.756 T:6136606720 INFO: ffmpeg[16DC53000]: Metadata:
  866. 10:09:59.756 T:6136606720 INFO: ffmpeg[16DC53000]: title : A Token of Friendship
  867. 10:09:59.756 T:6136606720 INFO: ffmpeg[16DC53000]: Chapter #0:15: start 3156.319000, end 3233.188000
  868. 10:09:59.756 T:6136606720 INFO: ffmpeg[16DC53000]: Metadata:
  869. 10:09:59.756 T:6136606720 INFO: ffmpeg[16DC53000]: title : The Shadow of Gundabad
  870. 10:09:59.756 T:6136606720 INFO: ffmpeg[16DC53000]: Chapter #0:16: start 3233.188000, end 3369.657000
  871. 10:09:59.756 T:6136606720 INFO: ffmpeg[16DC53000]: Metadata:
  872. 10:09:59.756 T:6136606720 INFO: ffmpeg[16DC53000]: title : "The Last Move in a Master Plan"
  873. 10:09:59.756 T:6136606720 INFO: ffmpeg[16DC53000]: Chapter #0:17: start 3369.657000, end 3484.731000
  874. 10:09:59.756 T:6136606720 INFO: ffmpeg[16DC53000]: Metadata:
  875. 10:09:59.756 T:6136606720 INFO: ffmpeg[16DC53000]: title : Bolg of the North
  876. 10:09:59.756 T:6136606720 INFO: ffmpeg[16DC53000]: Chapter #0:18: start 3484.731000, end 3717.964000
  877. 10:09:59.756 T:6136606720 INFO: ffmpeg[16DC53000]: Metadata:
  878. 10:09:59.756 T:6136606720 INFO: ffmpeg[16DC53000]: title : A Thief in the Night
  879. 10:09:59.756 T:6136606720 INFO: ffmpeg[16DC53000]: Chapter #0:19: start 3717.964000, end 4033.696000
  880. 10:09:59.756 T:6136606720 INFO: ffmpeg[16DC53000]: Metadata:
  881. 10:09:59.756 T:6136606720 INFO: ffmpeg[16DC53000]: title : An Honest Burglar
  882. 10:09:59.758 T:6136606720 INFO: ffmpeg[16DC53000]: Chapter #0:20: start 4033.696000, end 4200.446000
  883. 10:09:59.758 T:6136606720 INFO: ffmpeg[16DC53000]: Metadata:
  884. 10:09:59.758 T:6136606720 INFO: ffmpeg[16DC53000]: title : Dain Ironfoot
  885. 10:09:59.758 T:6136606720 INFO: ffmpeg[16DC53000]: Chapter #0:21: start 4200.446000, end 4349.887000
  886. 10:09:59.758 T:6136606720 INFO: ffmpeg[16DC53000]: Metadata:
  887. 10:09:59.758 T:6136606720 INFO: ffmpeg[16DC53000]: title : The Clouds Burst
  888. 10:09:59.758 T:6136606720 INFO: ffmpeg[16DC53000]: Chapter #0:22: start 4349.887000, end 4611.523000
  889. 10:09:59.758 T:6136606720 INFO: ffmpeg[16DC53000]: Metadata:
  890. 10:09:59.758 T:6136606720 INFO: ffmpeg[16DC53000]: title : The Battle at Dale
  891. 10:09:59.758 T:6136606720 INFO: ffmpeg[16DC53000]: Chapter #0:23: start 4611.523000, end 4805.926000
  892. 10:09:59.758 T:6136606720 INFO: ffmpeg[16DC53000]: Metadata:
  893. 10:09:59.758 T:6136606720 INFO: ffmpeg[16DC53000]: title : The Darkest Hour
  894. 10:09:59.758 T:6136606720 INFO: ffmpeg[16DC53000]: Chapter #0:24: start 4805.926000, end 4935.347000
  895. 10:09:59.758 T:6136606720 INFO: ffmpeg[16DC53000]: Metadata:
  896. 10:09:59.758 T:6136606720 INFO: ffmpeg[16DC53000]: title : Dragon Sickness
  897. 10:09:59.758 T:6136606720 INFO: ffmpeg[16DC53000]: Chapter #0:25: start 4935.347000, end 5065.226000
  898. 10:09:59.758 T:6136606720 INFO: ffmpeg[16DC53000]: Metadata:
  899. 10:09:59.758 T:6136606720 INFO: ffmpeg[16DC53000]: title : The Return of Thorin Oakenshield
  900. 10:09:59.758 T:6136606720 INFO: ffmpeg[16DC53000]: Chapter #0:26: start 5065.226000, end 5195.899000
  901. 10:09:59.758 T:6136606720 INFO: ffmpeg[16DC53000]: Metadata:
  902. 10:09:59.759 T:6136606720 INFO: ffmpeg[16DC53000]: title : Sons of Durin
  903. 10:09:59.759 T:6136606720 INFO: ffmpeg[16DC53000]: Chapter #0:27: start 5195.899000, end 5358.895000
  904. 10:09:59.759 T:6136606720 INFO: ffmpeg[16DC53000]: Metadata:
  905. 10:09:59.759 T:6136606720 INFO: ffmpeg[16DC53000]: title : "To the King!"
  906. 10:09:59.759 T:6136606720 INFO: ffmpeg[16DC53000]: Chapter #0:28: start 5358.895000, end 5477.388000
  907. 10:09:59.759 T:6136606720 INFO: ffmpeg[16DC53000]: Metadata:
  908. 10:09:59.759 T:6136606720 INFO: ffmpeg[16DC53000]: title : Thorin's Plan
  909. 10:09:59.759 T:6136606720 INFO: ffmpeg[16DC53000]: Chapter #0:29: start 5477.388000, end 5523.851000
  910. 10:09:59.759 T:6136606720 INFO: ffmpeg[16DC53000]: Metadata:
  911. 10:09:59.759 T:6136606720 INFO: ffmpeg[16DC53000]: title : The Fifth Army
  912. 10:09:59.759 T:6136606720 INFO: ffmpeg[16DC53000]: Chapter #0:30: start 5523.851000, end 5581.575000
  913. 10:09:59.759 T:6136606720 INFO: ffmpeg[16DC53000]: Metadata:
  914. 10:09:59.759 T:6136606720 INFO: ffmpeg[16DC53000]: title : Scouting Rayenhill
  915. 10:09:59.759 T:6136606720 INFO: ffmpeg[16DC53000]: Chapter #0:31: start 5581.575000, end 5758.169000
  916. 10:09:59.759 T:6136606720 INFO: ffmpeg[16DC53000]: Metadata:
  917. 10:09:59.759 T:6136606720 INFO: ffmpeg[16DC53000]: title : Blood of The Eldar
  918. 10:09:59.759 T:6136606720 INFO: ffmpeg[16DC53000]: Chapter #0:32: start 5758.169000, end 5812.431000
  919. 10:09:59.759 T:6136606720 INFO: ffmpeg[16DC53000]: Metadata:
  920. 10:09:59.759 T:6136606720 INFO: ffmpeg[16DC53000]: title : Courage and Cowardice
  921. 10:09:59.759 T:6136606720 INFO: ffmpeg[16DC53000]: Chapter #0:33: start 5812.431000, end 6016.385000
  922. 10:09:59.759 T:6136606720 INFO: ffmpeg[16DC53000]: Metadata:
  923. 10:09:59.759 T:6136606720 INFO: ffmpeg[16DC53000]: title : The Fallen
  924. 10:09:59.759 T:6136606720 INFO: ffmpeg[16DC53000]: Chapter #0:34: start 6016.385000, end 6495.530000
  925. 10:09:59.759 T:6136606720 INFO: ffmpeg[16DC53000]: Metadata:
  926. 10:09:59.759 T:6136606720 INFO: ffmpeg[16DC53000]: title : The Battle at Ravenhill
  927. 10:09:59.759 T:6136606720 INFO: ffmpeg[16DC53000]: Chapter #0:35: start 6495.530000, end 6862.438000
  928. 10:09:59.759 T:6136606720 INFO: ffmpeg[16DC53000]: Metadata:
  929. 10:09:59.759 T:6136606720 INFO: ffmpeg[16DC53000]: title : To the Death
  930. 10:09:59.759 T:6136606720 INFO: ffmpeg[16DC53000]: Chapter #0:36: start 6862.438000, end 7061.637000
  931. 10:09:59.759 T:6136606720 INFO: ffmpeg[16DC53000]: Metadata:
  932. 10:09:59.759 T:6136606720 INFO: ffmpeg[16DC53000]: title : Parting in Friendship
  933. 10:09:59.759 T:6136606720 INFO: ffmpeg[16DC53000]: Chapter #0:37: start 7061.637000, end 7247.907000
  934. 10:09:59.759 T:6136606720 INFO: ffmpeg[16DC53000]: Metadata:
  935. 10:09:59.759 T:6136606720 INFO: ffmpeg[16DC53000]: title : The Sorrow of Elves
  936. 10:09:59.759 T:6136606720 INFO: ffmpeg[16DC53000]: Chapter #0:38: start 7247.907000, end 7608.434000
  937. 10:09:59.759 T:6136606720 INFO: ffmpeg[16DC53000]: Metadata:
  938. 10:09:59.759 T:6136606720 INFO: ffmpeg[16DC53000]: title : The Return Journey
  939. 10:09:59.759 T:6136606720 INFO: ffmpeg[16DC53000]: Chapter #0:39: start 7608.434000, end 7891.300000
  940. 10:09:59.759 T:6136606720 INFO: ffmpeg[16DC53000]: Metadata:
  941. 10:09:59.759 T:6136606720 INFO: ffmpeg[16DC53000]: title : The Last Stage
  942. 10:09:59.759 T:6136606720 INFO: ffmpeg[16DC53000]: Chapter #0:40: start 7891.300000, end 8669.065000
  943. 10:09:59.759 T:6136606720 INFO: ffmpeg[16DC53000]: Metadata:
  944. 10:09:59.759 T:6136606720 INFO: ffmpeg[16DC53000]: title : Credits
  945. 10:09:59.759 T:6136606720 INFO: ffmpeg[16DC53000]: Stream #0:0: Video: h264 (High), yuv420p(progressive), 1920x800 [SAR 1:1 DAR 12:5], 23.98 fps, 23.98 tbr, 1k tbn, 47.95 tbc (default)
  946. 10:09:59.759 T:6136606720 INFO: ffmpeg[16DC53000]: Metadata:
  947. 10:09:59.760 T:6136606720 INFO: ffmpeg[16DC53000]: BPS : 7000245
  948. 10:09:59.760 T:6136606720 INFO: ffmpeg[16DC53000]: BPS-eng : 7000245
  949. 10:09:59.760 T:6136606720 INFO: ffmpeg[16DC53000]: DURATION : 02:24:28.076000000
  950. 10:09:59.760 T:6136606720 INFO: ffmpeg[16DC53000]: DURATION-eng : 02:24:28.076000000
  951. 10:09:59.760 T:6136606720 INFO: ffmpeg[16DC53000]: NUMBER_OF_FRAMES: 207826
  952. 10:09:59.760 T:6136606720 INFO: ffmpeg[16DC53000]: NUMBER_OF_FRAMES-eng: 207826
  953. 10:09:59.760 T:6136606720 INFO: ffmpeg[16DC53000]: NUMBER_OF_BYTES : 7584832137
  954. 10:09:59.760 T:6136606720 INFO: ffmpeg[16DC53000]: NUMBER_OF_BYTES-eng: 7584832137
  955. 10:09:59.760 T:6136606720 INFO: ffmpeg[16DC53000]: _STATISTICS_WRITING_APP: mkvmerge v9.2.0 ('Photograph') 64bit
  956. 10:09:59.760 T:6136606720 INFO: ffmpeg[16DC53000]: _STATISTICS_WRITING_APP-eng: mkvmerge v9.2.0 ('Photograph') 64bit
  957. 10:09:59.760 T:6136606720 INFO: ffmpeg[16DC53000]: _STATISTICS_WRITING_DATE_UTC: 2016-10-24 15:34:37
  958. 10:09:59.760 T:6136606720 INFO: ffmpeg[16DC53000]: _STATISTICS_WRITING_DATE_UTC-eng: 2016-10-24 15:34:37
  959. 10:09:59.760 T:6136606720 INFO: ffmpeg[16DC53000]: _STATISTICS_TAGS: BPS DURATION NUMBER_OF_FRAMES NUMBER_OF_BYTES
  960. 10:09:59.760 T:6136606720 INFO: ffmpeg[16DC53000]: _STATISTICS_TAGS-eng: BPS DURATION NUMBER_OF_FRAMES NUMBER_OF_BYTES
  961. 10:09:59.760 T:6136606720 INFO: ffmpeg[16DC53000]: Stream #0:1(eng): Audio: dts (DTS-HD MA), 48000 Hz, 7.1, s32p (24 bit) (default)
  962. 10:09:59.760 T:6136606720 INFO: ffmpeg[16DC53000]: Metadata:
  963. 10:09:59.760 T:6136606720 INFO: ffmpeg[16DC53000]: BPS : 4720387
  964. 10:09:59.760 T:6136606720 INFO: ffmpeg[16DC53000]: BPS-eng : 4720387
  965. 10:09:59.760 T:6136606720 INFO: ffmpeg[16DC53000]: DURATION : 02:24:29.045000000
  966. 10:09:59.760 T:6136606720 INFO: ffmpeg[16DC53000]: DURATION-eng : 02:24:29.045000000
  967. 10:09:59.760 T:6136606720 INFO: ffmpeg[16DC53000]: NUMBER_OF_FRAMES: 812723
  968. 10:09:59.760 T:6136606720 INFO: ffmpeg[16DC53000]: NUMBER_OF_FRAMES-eng: 812723
  969. 10:09:59.760 T:6136606720 INFO: ffmpeg[16DC53000]: NUMBER_OF_BYTES : 5115156776
  970. 10:09:59.760 T:6136606720 INFO: ffmpeg[16DC53000]: NUMBER_OF_BYTES-eng: 5115156776
  971. 10:09:59.760 T:6136606720 INFO: ffmpeg[16DC53000]: _STATISTICS_WRITING_APP: mkvmerge v9.2.0 ('Photograph') 64bit
  972. 10:09:59.760 T:6136606720 INFO: ffmpeg[16DC53000]: _STATISTICS_WRITING_APP-eng: mkvmerge v9.2.0 ('Photograph') 64bit
  973. 10:09:59.760 T:6136606720 INFO: ffmpeg[16DC53000]: _STATISTICS_WRITING_DATE_UTC: 2016-10-24 15:34:37
  974. 10:09:59.760 T:6136606720 INFO: ffmpeg[16DC53000]: _STATISTICS_WRITING_DATE_UTC-eng: 2016-10-24 15:34:37
  975. 10:09:59.760 T:6136606720 INFO: ffmpeg[16DC53000]: _STATISTICS_TAGS: BPS DURATION NUMBER_OF_FRAMES NUMBER_OF_BYTES
  976. 10:09:59.760 T:6136606720 INFO: ffmpeg[16DC53000]: _STATISTICS_TAGS-eng: BPS DURATION NUMBER_OF_FRAMES NUMBER_OF_BYTES
  977. 10:09:59.760 T:6136606720 INFO: ffmpeg[16DC53000]: Stream #0:2(eng): Audio: aac (LC), 48000 Hz, 5.1, fltp
  978. 10:09:59.760 T:6136606720 INFO: ffmpeg[16DC53000]: Metadata:
  979. 10:09:59.760 T:6136606720 INFO: ffmpeg[16DC53000]: BPS : 912141
  980. 10:09:59.760 T:6136606720 INFO: ffmpeg[16DC53000]: BPS-eng : 912141
  981. 10:09:59.760 T:6136606720 INFO: ffmpeg[16DC53000]: DURATION : 02:24:29.056000000
  982. 10:09:59.760 T:6136606720 INFO: ffmpeg[16DC53000]: DURATION-eng : 02:24:29.056000000
  983. 10:09:59.760 T:6136606720 INFO: ffmpeg[16DC53000]: NUMBER_OF_FRAMES: 406362
  984. 10:09:59.760 T:6136606720 INFO: ffmpeg[16DC53000]: NUMBER_OF_FRAMES-eng: 406362
  985. 10:09:59.760 T:6136606720 INFO: ffmpeg[16DC53000]: NUMBER_OF_BYTES : 988426245
  986. 10:09:59.760 T:6136606720 INFO: ffmpeg[16DC53000]: NUMBER_OF_BYTES-eng: 988426245
  987. 10:09:59.760 T:6136606720 INFO: ffmpeg[16DC53000]: _STATISTICS_WRITING_APP: mkvmerge v9.2.0 ('Photograph') 64bit
  988. 10:09:59.760 T:6136606720 INFO: ffmpeg[16DC53000]: _STATISTICS_WRITING_APP-eng: mkvmerge v9.2.0 ('Photograph') 64bit
  989. 10:09:59.761 T:6136606720 INFO: ffmpeg[16DC53000]: _STATISTICS_WRITING_DATE_UTC: 2016-10-24 15:34:37
  990. 10:09:59.761 T:6136606720 INFO: ffmpeg[16DC53000]: _STATISTICS_WRITING_DATE_UTC-eng: 2016-10-24 15:34:37
  991. 10:09:59.761 T:6136606720 INFO: ffmpeg[16DC53000]: _STATISTICS_TAGS: BPS DURATION NUMBER_OF_FRAMES NUMBER_OF_BYTES
  992. 10:09:59.761 T:6136606720 INFO: ffmpeg[16DC53000]: _STATISTICS_TAGS-eng: BPS DURATION NUMBER_OF_FRAMES NUMBER_OF_BYTES
  993. 10:09:59.761 T:6136606720 INFO: ffmpeg[16DC53000]: Stream #0:3(eng): Subtitle: hdmv_pgs_subtitle (default)
  994. 10:09:59.761 T:6136606720 INFO: ffmpeg[16DC53000]: Metadata:
  995. 10:09:59.761 T:6136606720 INFO: ffmpeg[16DC53000]: BPS : 8413
  996. 10:09:59.761 T:6136606720 INFO: ffmpeg[16DC53000]: BPS-eng : 8413
  997. 10:09:59.761 T:6136606720 INFO: ffmpeg[16DC53000]: DURATION : 02:23:20.947000000
  998. 10:09:59.761 T:6136606720 INFO: ffmpeg[16DC53000]: DURATION-eng : 02:23:20.947000000
  999. 10:09:59.761 T:6136606720 INFO: ffmpeg[16DC53000]: NUMBER_OF_FRAMES: 3096
  1000. 10:09:59.761 T:6136606720 INFO: ffmpeg[16DC53000]: NUMBER_OF_FRAMES-eng: 3096
  1001. 10:09:59.761 T:6136606720 INFO: ffmpeg[16DC53000]: NUMBER_OF_BYTES : 9045123
  1002. 10:09:59.761 T:6136606720 INFO: ffmpeg[16DC53000]: NUMBER_OF_BYTES-eng: 9045123
  1003. 10:09:59.761 T:6136606720 INFO: ffmpeg[16DC53000]: _STATISTICS_WRITING_APP: mkvmerge v9.2.0 ('Photograph') 64bit
  1004. 10:09:59.761 T:6136606720 INFO: ffmpeg[16DC53000]: _STATISTICS_WRITING_APP-eng: mkvmerge v9.2.0 ('Photograph') 64bit
  1005. 10:09:59.761 T:6136606720 INFO: ffmpeg[16DC53000]: _STATISTICS_WRITING_DATE_UTC: 2016-10-24 15:34:37
  1006. 10:09:59.761 T:6136606720 INFO: ffmpeg[16DC53000]: _STATISTICS_WRITING_DATE_UTC-eng: 2016-10-24 15:34:37
  1007. 10:09:59.761 T:6136606720 INFO: ffmpeg[16DC53000]: _STATISTICS_TAGS: BPS DURATION NUMBER_OF_FRAMES NUMBER_OF_BYTES
  1008. 10:09:59.761 T:6136606720 INFO: ffmpeg[16DC53000]: _STATISTICS_TAGS-eng: BPS DURATION NUMBER_OF_FRAMES NUMBER_OF_BYTES
  1009. 10:09:59.761 T:6136606720 DEBUG: CDVDDemuxFFmpeg::AddStream(0, ...) -> 0
  1010. 10:09:59.761 T:6136606720 DEBUG: CDVDDemuxFFmpeg::AddStream(1, ...) -> 1
  1011. 10:09:59.761 T:6136606720 DEBUG: CDVDDemuxFFmpeg::AddStream(2, ...) -> 2
  1012. 10:09:59.761 T:6136606720 DEBUG: CDVDDemuxFFmpeg::AddStream(3, ...) -> 3
  1013. 10:09:59.761 T:6136606720 DEBUG: CDVDInputStreamFile::SetReadRate - set cache throttle rate to 1738638 bytes per second
  1014. 10:09:59.761 T:6136606720 NOTICE: Opening stream: 0 source: 256
  1015. 10:09:59.762 T:6136606720 NOTICE: Creating video codec with codec id: 28
  1016. 10:09:59.762 T:6136606720 DEBUG: FactoryCodec - Video: avf- - Opening
  1017. 10:09:59.771 T:6136606720 DEBUG: FactoryCodec - Video: avf-h264 - Opened
  1018. 10:09:59.772 T:6136606720 NOTICE: Creating video thread
  1019. 10:09:59.772 T:6138327040 DEBUG: CDVDVideoCodecAVFoundation::Process Started
  1020. 10:09:59.772 T:6136606720 NOTICE: Opening stream: 1 source: 256
  1021. 10:09:59.772 T:6136606720 NOTICE: Finding audio codec for: 86020
  1022. 10:09:59.772 T:6141194240 NOTICE: running thread: video_thread
  1023. 10:09:59.772 T:6136606720 DEBUG: FactoryCodec - Audio: FFmpeg - Opening
  1024. 10:09:59.773 T:6136606720 DEBUG: FactoryCodec - Audio: FFmpeg - Opened
  1025. 10:09:59.773 T:6136606720 NOTICE: Creating audio thread
  1026. 10:09:59.773 T:6136606720 NOTICE: Opening stream: 0 source: 1024
  1027. 10:09:59.773 T:6142914560 NOTICE: running thread: CDVDPlayerAudio::Process()
  1028. 10:09:59.773 T:6136606720 DEBUG: CFileCache::Open - opening <library/streams/18525> using cache
  1029. 10:09:59.773 T:6136606720 DEBUG: CurlFile::Open(0x106943800) https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct:32400/library/streams/18525
  1030. 10:09:59.773 T:6136606720 INFO: easy_aquire - Created session to https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct
  1031. 10:09:59.783 T:6138327040 DEBUG: Process - CDVDVideoCodecAVFoundation::Start player_s(0.011336)
  1032. 10:09:59.942 T:6136606720 DEBUG: Process - Start position set to last stopped position: 4191000
  1033. 10:09:59.984 T:6136606720 DEBUG: Seek - waiting for position 13702027039.
  1034. 10:10:00.092 T:6136606720 DEBUG: Process - starting demuxer from: 4191000
  1035. 10:10:00.093 T:6136606720 DEBUG: OnPlayBackStarted: play state was 1, starting 1
  1036. 10:10:00.102 T:6141194240 INFO: CDVDPlayerVideo - Stillframe left, switching to normal playback
  1037. 10:10:00.102 T:6141194240 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0
  1038. 10:10:00.107 T:6142914560 DEBUG: ffmpeg[16E257000]: [dca] Forcing XLL recovery mode
  1039. 10:10:00.107 T:6142914560 NOTICE: Creating audio stream (codec id: 86020, channels: 8, sample rate: 48000, no pass-through)
  1040. 10:10:00.107 T:6142914560 DEBUG: CDVDPlayerAudio:: synctype set to 0: clock feedback
  1041. 10:10:00.109 T:6141194240 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0
  1042. 10:10:00.119 T:6140620800 DEBUG: Previous line repeats 1 times.
  1043. 10:10:00.119 T:6140620800 DEBUG: PlayFile: OpenFile succeed, play state 2
  1044. 10:10:00.119 T:6140620800 DEBUG: OnPlayBackStarted: play state was 2, starting 0
  1045. 10:10:00.121 T:6140620800 DEBUG: CGUIInfoManager::SetCurrentMovie(https://HOSTNAME:32400/library/parts/7549/1477323503/file.mkv|&X-Plex-Token=PLEXTOKEN)
  1046. 10:10:00.122 T:6141194240 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0
  1047. 10:10:00.151 T:6142341120 DEBUG: Previous line repeats 4 times.
  1048. 10:10:00.151 T:6142341120 INFO: CActiveAESink::OpenSink - initialize sink
  1049. 10:10:00.157 T:6141194240 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0
  1050. 10:10:00.193 T:4391316352 DEBUG: Previous line repeats 6 times.
  1051. 10:10:00.193 T:4391316352 DEBUG: adjusting playback timeBase_s(0.410007) player_s(4191.100634), sampleBuffers(1), trackerQueue(15)
  1052. 10:10:00.198 T:6142341120 DEBUG: CActiveAESink::OpenSink - trying to open device DARWINIOS:default
  1053. 10:10:00.202 T:6141194240 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0
  1054. 10:10:00.207 T:6142341120 DEBUG: virtual bool CAESinkDARWINIOS::Initialize(AEAudioFormat &, std::string &): AudioStreamBasicDescription: [lpcm] Mixable Interleaved 8 Channel 32-bit Floating Point LE (48000Hz) pcm
  1055. 10:10:00.209 T:6141194240 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0
  1056. 10:10:00.210 T:6142341120 NOTICE: bool CAAudioUnitSink::setupAudio() setting channels 8
  1057. 10:10:00.210 T:6142341120 NOTICE: bool CAAudioUnitSink::setupAudio() setting samplerate 48000.000000
  1058. 10:10:00.210 T:6142341120 NOTICE: bool CAAudioUnitSink::setupAudio() setting buffer duration to 0.170667
  1059. 10:10:00.219 T:6141194240 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0
  1060. 10:10:00.229 T:6140620800 DEBUG: Previous line repeats 1 times.
  1061. 10:10:00.229 T:6140620800 DEBUG: ------ Window Deinit (DialogBusy.xml) ------
  1062. 10:10:00.233 T:6141194240 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0
  1063. 10:10:00.262 T:6153236480 DEBUG: Previous line repeats 4 times.
  1064. 10:10:00.262 T:6153236480 DEBUG: CurlFile::Open(0x16ec2e600) https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct:32400/:/timeline?ratingKey=6678&key=%2Flibrary%2Fmetadata%2F6678&state=playing&time=4191000&duration=8669000
  1065. 10:10:00.265 T:6141194240 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0
  1066. 10:10:00.307 T:6136606720 DEBUG: Previous line repeats 6 times.
  1067. 10:10:00.307 T:6136606720 DEBUG: CDVDPlayer::LogCacheState(HandlePlaySpeed) - CACHESTATE_WAITSTREAM
  1068. 10:10:00.309 T:6141194240 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0
  1069. 10:10:00.342 T:6142341120 DEBUG: Previous line repeats 5 times.
  1070. 10:10:00.342 T:6142341120 WARNING: number of channels do not match: asked 8, is 6
  1071. 10:10:00.343 T:6142341120 NOTICE: bool CAAudioUnitSink::setupAudio() total latency = 0.072000
  1072. 10:10:00.343 T:6142341120 NOTICE: bool CAAudioUnitSink::setupAudio() setup audio format: [lpcm] Mixable Interleaved 8 Channel 32-bit Floating Point LE (48000Hz)
  1073. 10:10:00.343 T:6142341120 NOTICE: void dumpAVAudioSessionProperties() audio route = HDMIOutput
  1074. 10:10:00.343 T:6142341120 NOTICE: void dumpAVAudioSessionProperties() sampleRate 48000.000000
  1075. 10:10:00.343 T:6142341120 NOTICE: void dumpAVAudioSessionProperties() outputLatency 0.040000
  1076. 10:10:00.343 T:6142341120 NOTICE: void dumpAVAudioSessionProperties() IOBufferDuration 0.032000
  1077. 10:10:00.343 T:6142341120 NOTICE: void dumpAVAudioSessionProperties() outputNumberOfChannels 6
  1078. 10:10:00.344 T:6142341120 NOTICE: void dumpAVAudioSessionProperties() maximumOutputNumberOfChannels 32
  1079. 10:10:00.344 T:6142341120 DEBUG: DumpAudioDescriptions: void dumpAVAudioSessionProperties()
  1080. 10:10:00.344 T:6142341120 DEBUG: DumpAudioDescriptions: input count = 0
  1081. 10:10:00.344 T:6142341120 DEBUG: DumpAudioDescriptions: output count = 1
  1082. 10:10:00.344 T:6142341120 DEBUG: DumpAudioDescriptions : portName, Living Room
  1083. 10:10:00.344 T:6142341120 DEBUG: DumpAudioDescriptions: channelLabel, -1
  1084. 10:10:00.344 T:6142341120 DEBUG: DumpAudioDescriptions: channelName , Living Room 1
  1085. 10:10:00.344 T:6142341120 DEBUG: DumpAudioDescriptions: channelLabel, -1
  1086. 10:10:00.344 T:6142341120 DEBUG: DumpAudioDescriptions: channelName , Living Room 2
  1087. 10:10:00.344 T:6141194240 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0
  1088. 10:10:00.397 T:6142341120 DEBUG: Previous line repeats 8 times.
  1089. 10:10:00.397 T:6142341120 DEBUG: CActiveAESink::OpenSink - DARWINIOS Initialized:
  1090. 10:10:00.397 T:6142341120 DEBUG: Output Device : Default
  1091. 10:10:00.397 T:6142341120 DEBUG: Sample Rate : 48000
  1092. 10:10:00.397 T:6142341120 DEBUG: Sample Format : AE_FMT_FLOAT
  1093. 10:10:00.397 T:6142341120 DEBUG: Channel Count : 8
  1094. 10:10:00.397 T:6142341120 DEBUG: Channel Layout: FL,FR,LFE,FC,SL,SR,BL,BR
  1095. 10:10:00.397 T:6142341120 DEBUG: Frames : 1024
  1096. 10:10:00.397 T:6142341120 DEBUG: Frame Size : 32
  1097. 10:10:00.397 T:6142341120 DEBUG: CActiveAESink::GenerateNoise - noiseFactor = 0.000010
  1098. 10:10:00.397 T:6141194240 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0
  1099. 10:10:00.399 T:6138327040 DEBUG: Process - CDVDVideoCodecAVFoundation::Pause
  1100. 10:10:00.399 T:6141767680 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
  1101. 10:10:00.399 T:6142914560 DEBUG: Previous line repeats 1 times.
  1102. 10:10:00.399 T:6142914560 DEBUG: CDVDAudio::Pause - pausing audio stream
  1103. 10:10:00.404 T:6141194240 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0
  1104. 10:10:00.411 T:6136606720 DEBUG: Previous line repeats 1 times.
  1105. 10:10:00.411 T:6136606720 DEBUG: CDVDPlayer::HandleMessages - player started DVDPLAYER_AUDIO
  1106. 10:10:00.416 T:6141194240 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0
  1107. 10:10:00.423 T:6141194240 NOTICE: fps: 23.976024, pwidth: 1920, pheight: 800, dwidth: 1920, dheight: 800, colorrange: Limited, colorspace: unknown, colortransfer: unknown
  1108. 10:10:00.423 T:6141194240 DEBUG: OutputPicture - change configuration. 1920x800. framerate: 23.98. format: BYPASS
  1109. 10:10:00.423 T:6141194240 NOTICE: Display resolution DESKTOP : 3840x2160@ 59.94 - Full Screen (16)
  1110. 10:10:00.423 T:6141194240 DEBUG: displayRateSwitch request: refreshRate = 23.98, dynamicRange = SDR
  1111. 10:10:00.423 T:6141194240 DEBUG: CXBMCRenderManager::Configure - 3
  1112. 10:10:00.424 T:4391316352 DEBUG: CWinSystemIOS::AnnounceOnLostDevice
  1113. 10:10:00.459 T:6140620800 DEBUG: Activating window ID: 12005
  1114. 10:10:00.459 T:6140620800 DEBUG: ------ Window Deinit (Home.xml) ------
  1115. 10:10:00.459 T:6140620800 DEBUG: ------ Window Init (VideoFullScreen.xml) ------
  1116. 10:10:00.459 T:6140620800 INFO: Loading skin file: VideoFullScreen.xml, load type: KEEP_IN_MEMORY
  1117. 10:10:00.460 T:4391316352 NOTICE: CDVDPlayer: OnLostDevice received
  1118. 10:10:00.460 T:4391316352 DEBUG: displayModeSwitchInProgress == YES, refreshRate = 23.98, dynamicRange = SDR
  1119. 10:10:00.460 T:6142914560 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_PAUSE: 1
  1120. 10:10:00.462 T:6140620800 NOTICE: Using GL_TEXTURE_2D
  1121. 10:10:00.472 T:6140620800 DEBUG: GL: Requested render method: 0
  1122. 10:10:00.472 T:6140620800 NOTICE: GL: Using BYPASS render method
  1123. 10:10:00.472 T:6140620800 NOTICE: GL: NPOT texture support detected
  1124. 10:10:00.472 T:6140620800 DEBUG: CLinuxRendererGLES: Reorder drawpoints due to method change from 1 to 256
  1125. 10:10:00.473 T:6141194240 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_PAUSE: 1
  1126. 10:10:00.711 T:4391316352 DEBUG: -[MainController displayLinkTick:]: displayRate = 23.976025
  1127. 10:10:03.463 T:6143488000 DEBUG: CWinSystemIOS::AnnounceOnResetDevice
  1128. 10:10:03.463 T:6143488000 NOTICE: CDVDPlayer: OnResetDevice received
  1129. 10:10:03.463 T:6141767680 DEBUG: CActiveAE - display reset event
  1130. 10:10:03.463 T:6142341120 INFO: CActiveAESink::OpenSink - initialize sink
  1131. 10:10:03.463 T:6142341120 DEBUG: CActiveAESink::OpenSink - trying to open device DARWINIOS:default
  1132. 10:10:03.464 T:6142341120 DEBUG: virtual bool CAESinkDARWINIOS::Initialize(AEAudioFormat &, std::string &): AudioStreamBasicDescription: [lpcm] Mixable Interleaved 8 Channel 32-bit Floating Point LE (48000Hz) pcm
  1133. 10:10:03.465 T:6142341120 NOTICE: bool CAAudioUnitSink::setupAudio() setting channels 8
  1134. 10:10:03.465 T:6142341120 NOTICE: bool CAAudioUnitSink::setupAudio() setting samplerate 48000.000000
  1135. 10:10:03.465 T:6142341120 NOTICE: bool CAAudioUnitSink::setupAudio() setting buffer duration to 0.170667
  1136. 10:10:03.491 T:6142341120 WARNING: number of channels do not match: asked 8, is 6
  1137. 10:10:03.492 T:6142341120 NOTICE: bool CAAudioUnitSink::setupAudio() total latency = 0.072000
  1138. 10:10:03.492 T:6142341120 NOTICE: bool CAAudioUnitSink::setupAudio() setup audio format: [lpcm] Mixable Interleaved 8 Channel 32-bit Floating Point LE (48000Hz)
  1139. 10:10:03.492 T:6142341120 NOTICE: void dumpAVAudioSessionProperties() audio route = HDMIOutput
  1140. 10:10:03.492 T:6142341120 NOTICE: void dumpAVAudioSessionProperties() sampleRate 48000.000000
  1141. 10:10:03.493 T:6142341120 NOTICE: void dumpAVAudioSessionProperties() outputLatency 0.040000
  1142. 10:10:03.493 T:6142341120 NOTICE: void dumpAVAudioSessionProperties() IOBufferDuration 0.032000
  1143. 10:10:03.493 T:6142341120 NOTICE: void dumpAVAudioSessionProperties() outputNumberOfChannels 6
  1144. 10:10:03.493 T:6142341120 NOTICE: void dumpAVAudioSessionProperties() maximumOutputNumberOfChannels 32
  1145. 10:10:03.493 T:6142341120 DEBUG: DumpAudioDescriptions: void dumpAVAudioSessionProperties()
  1146. 10:10:03.493 T:6142341120 DEBUG: DumpAudioDescriptions: input count = 0
  1147. 10:10:03.493 T:6142341120 DEBUG: DumpAudioDescriptions: output count = 1
  1148. 10:10:03.493 T:6142341120 DEBUG: DumpAudioDescriptions : portName, Living Room
  1149. 10:10:03.493 T:6142341120 DEBUG: DumpAudioDescriptions: channelLabel, -1
  1150. 10:10:03.493 T:6142341120 DEBUG: DumpAudioDescriptions: channelName , Living Room 1
  1151. 10:10:03.493 T:6142341120 DEBUG: DumpAudioDescriptions: channelLabel, -1
  1152. 10:10:03.493 T:6142341120 DEBUG: DumpAudioDescriptions: channelName , Living Room 2
  1153. 10:10:03.544 T:6142341120 DEBUG: CActiveAESink::OpenSink - DARWINIOS Initialized:
  1154. 10:10:03.544 T:6142341120 DEBUG: Output Device : Default
  1155. 10:10:03.544 T:6142341120 DEBUG: Sample Rate : 48000
  1156. 10:10:03.544 T:6142341120 DEBUG: Sample Format : AE_FMT_FLOAT
  1157. 10:10:03.544 T:6142341120 DEBUG: Channel Count : 8
  1158. 10:10:03.544 T:6142341120 DEBUG: Channel Layout: FL,FR,LFE,FC,SL,SR,BL,BR
  1159. 10:10:03.544 T:6142341120 DEBUG: Frames : 1024
  1160. 10:10:03.544 T:6142341120 DEBUG: Frame Size : 32
  1161. 10:10:03.544 T:6142341120 DEBUG: CActiveAESink::GenerateNoise - noiseFactor = 0.000010
  1162. 10:10:03.546 T:6141767680 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
  1163. 10:10:03.581 T:4391316352 DEBUG: Previous line repeats 2 times.
  1164. 10:10:03.581 T:4391316352 DEBUG: CWinSystemIOS::AnnounceOnResetDevice
  1165. 10:10:03.581 T:4391316352 NOTICE: CDVDPlayer: OnResetDevice received
  1166. 10:10:03.581 T:4391316352 DEBUG: displayModeSwitchInProgress == DONE, refreshRate = 23.98, dynamicRange = SDR
  1167. 10:10:07.583 T:6136606720 DEBUG: CDVDPlayer::HandleMessages - player started DVDPLAYER_VIDEO
  1168. 10:10:07.583 T:6136606720 DEBUG: CDVDPlayer::LogCacheState(HandlePlaySpeed) - CACHESTATE_WAITCODEC
  1169. 10:10:07.583 T:6136606720 DEBUG: CDVDPlayer::LogCacheState(HandlePlaySpeed) - CACHESTATE_DONE
  1170. 10:10:07.583 T:6136606720 DEBUG: CDVDPlayer::Sync - Audio - pts: 4189033999.000000, cache: 466666.684469, totalcache: 685333.311558
  1171. 10:10:07.584 T:6141194240 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_PAUSE: 0
  1172. 10:10:07.584 T:6142914560 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_PAUSE: 0
  1173. 10:10:07.584 T:6136606720 DEBUG: CDVDPlayer::Sync - Video - pts: -4503599627370496.000000, cache: 50000.000000, totalcache: 100000.000000
  1174. 10:10:07.584 T:6142914560 DEBUG: CDVDPlayerAudio - CDVDMsg::GENERAL_RESYNC(4188567332.315531)
  1175. 10:10:07.585 T:6142914560 DEBUG: CDVDAudio::Resume - resume audio stream
  1176. 10:10:07.585 T:6141194240 DEBUG: CDVDPlayerVideo - CDVDMsg::GENERAL_RESYNC(4188567332.315531)
  1177. 10:10:07.585 T:6141194240 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 0
  1178. 10:10:07.587 T:6141767680 DEBUG: ActiveAE - start sync of audio stream
  1179. 10:10:07.592 T:6141194240 DEBUG: CDVDPlayerVideo::CalcDropRequirement - hurry: 1
  1180. 10:10:07.607 T:4391316352 DEBUG: Previous line repeats 2 times.
  1181. 10:10:07.607 T:4391316352 DEBUG: adjusting playback timeBase_s(4191.205513) player_s(4188.590290), sampleBuffers(0), trackerQueue(50)
  1182. 10:10:07.703 T:6141767680 DEBUG: ActiveAE::SyncStream - average error of 267.588389, start adjusting
  1183. 10:10:07.712 T:4391316352 DEBUG: adjusting playback timeBase_s(4188.104476) player_s(4188.695082), sampleBuffers(0), trackerQueue(50)
  1184. 10:10:07.813 T:4391316352 DEBUG: adjusting playback timeBase_s(4188.100732) player_s(4188.795959), sampleBuffers(0), trackerQueue(49)
  1185. 10:10:07.896 T:6141767680 DEBUG: ActiveAE::SyncStream - average error 20.654549, last average error: 267.588389
  1186. 10:10:07.918 T:4391316352 DEBUG: adjusting playback timeBase_s(4188.105453) player_s(4188.901539), sampleBuffers(0), trackerQueue(49)
  1187. 10:10:08.019 T:4391316352 DEBUG: adjusting playback timeBase_s(4188.100779) player_s(4189.002529), sampleBuffers(0), trackerQueue(49)
  1188. 10:10:08.024 T:6141767680 DEBUG: ActiveAE::SyncStream - average error of 17.696904, start adjusting
  1189. 10:10:08.024 T:6141767680 DEBUG: ActiveAE::SyncStream - average error 0.696904 below threshold of 30.000000
  1190. 10:10:21.973 T:6140620800 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
  1191. 10:10:22.221 T:6140620800 DEBUG: ------ Window Deinit (VideoFullScreen.xml) ------
  1192. 10:10:22.225 T:6140620800 DEBUG: found key /userdata/profiles.xml
  1193. 10:10:22.226 T:6140620800 DEBUG: Previous line repeats 1 times.
  1194. 10:10:22.226 T:6140620800 DEBUG: NSUSerDefaults: compressed /userdata/profiles.xml from 923 to 324
  1195. 10:10:22.227 T:6140620800 DEBUG: found key /userdata/guisettings.xml
  1196. 10:10:22.233 T:6140620800 DEBUG: Previous line repeats 1 times.
  1197. 10:10:22.233 T:6140620800 DEBUG: NSUSerDefaults: compressed /userdata/guisettings.xml from 35403 to 6831
  1198. 10:10:22.234 T:6140620800 DEBUG: CGUIWindowManager::PreviousWindow: Activate new
  1199. 10:10:22.234 T:6140620800 DEBUG: ------ Window Init (Home.xml) ------
  1200. 10:10:22.239 T:6145781760 DEBUG: CHomeShelfJob::UpdateMusic() - Running HomeShelf screen update
  1201. 10:10:22.239 T:6145781760 DEBUG: CurlFile::Open(0x16e5120a0) https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct:32400/hubs/home/recentlyAdded?X-Plex-Container-Size=10&X-Plex-Container-Start=0&X-Plex-Token=PLEXTOKEN&type=8
  1202. 10:10:22.243 T:6140620800 NOTICE: CDVDPlayer::CloseFile()
  1203. 10:10:22.243 T:6140620800 NOTICE: DVDPlayer: waiting for threads to exit
  1204. 10:10:22.255 T:6136606720 NOTICE: CDVDPlayer::OnExit()
  1205. 10:10:22.255 T:6136606720 NOTICE: Closing stream player 1
  1206. 10:10:22.255 T:6136606720 NOTICE: Waiting for audio thread to exit
  1207. 10:10:22.263 T:6142914560 NOTICE: thread end: CDVDPlayerAudio::OnExit()
  1208. 10:10:22.264 T:6136606720 NOTICE: Closing audio device
  1209. 10:10:22.271 T:6145781760 ERROR: CPlexUtils::ParsePlexArtistsAlbum directory is null https://HOSTNAME:32400/hubs/home/recentlyAdded|&X-Plex-Container-Size=10&X-Plex-Container-Start=0&X-Plex-Token=PLEXTOKEN&type=8
  1210. 10:10:22.271 T:6145781760 DEBUG: CHomeShelfJob::UpdateVideos() - Running HomeShelf screen update
  1211. 10:10:22.271 T:6145781760 DEBUG: CurlFile::Open(0x16e5109f0) https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct:32400/hubs/home/recentlyAdded?X-Plex-Container-Size=20&X-Plex-Container-Start=0&X-Plex-Token=PLEXTOKEN&type=2
  1212. 10:10:22.304 T:6136606720 DEBUG: CDVDAudio::Flush - flush audio stream
  1213. 10:10:22.304 T:6141767680 DEBUG: CActiveAE::DiscardStream - audio stream deleted
  1214. 10:10:22.305 T:6141767680 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
  1215. 10:10:22.306 T:6142341120 DEBUG: Previous line repeats 2 times.
  1216. 10:10:22.306 T:6142341120 INFO: CActiveAESink::OpenSink - initialize sink
  1217. 10:10:22.308 T:6136606720 NOTICE: Deleting audio codec
  1218. 10:10:22.308 T:6136606720 NOTICE: Closing stream player 2
  1219. 10:10:22.308 T:6136606720 NOTICE: waiting for video thread to exit
  1220. 10:10:22.330 T:6142341120 DEBUG: CActiveAESink::OpenSink - trying to open device DARWINIOS:default
  1221. 10:10:22.332 T:6142341120 DEBUG: virtual bool CAESinkDARWINIOS::Initialize(AEAudioFormat &, std::string &): AudioStreamBasicDescription: [lpcm] Mixable Interleaved 2 Channel 32-bit Floating Point LE (48000Hz) pcm
  1222. 10:10:22.335 T:6142341120 NOTICE: bool CAAudioUnitSink::setupAudio() setting channels 2
  1223. 10:10:22.336 T:6142341120 NOTICE: bool CAAudioUnitSink::setupAudio() setting samplerate 48000.000000
  1224. 10:10:22.336 T:6142341120 NOTICE: bool CAAudioUnitSink::setupAudio() setting buffer duration to 0.042667
  1225. 10:10:22.339 T:6141194240 NOTICE: thread end: video_thread
  1226. 10:10:22.341 T:6136606720 NOTICE: deleting video codec
  1227. 10:10:22.342 T:6138327040 DEBUG: CDVDVideoCodecAVFoundation::Process Stopped
  1228. 10:10:22.342 T:6136606720 NOTICE: Closing stream player 3
  1229. 10:10:22.353 T:6136606720 DEBUG: OnPlayBackStopped: play state was 2, starting 0
  1230. 10:10:22.353 T:6140620800 NOTICE: DVDPlayer: finished waiting
  1231. 10:10:22.354 T:6153236480 DEBUG: CurlFile::Open(0x16ec2e600) https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct:32400/:/timeline?ratingKey=6678&key=%2Flibrary%2Fmetadata%2F6678&state=stopped&time=4191000&duration=8669000
  1232. 10:10:22.354 T:6140620800 DEBUG: displayRateReset
  1233. 10:10:22.364 T:6140620800 NOTICE: CDVDPlayer::CloseFile()
  1234. 10:10:22.364 T:6140620800 NOTICE: DVDPlayer: waiting for threads to exit
  1235. 10:10:22.364 T:6140620800 NOTICE: DVDPlayer: finished waiting
  1236. 10:10:22.364 T:6140620800 NOTICE: CDVDPlayer::CloseFile()
  1237. 10:10:22.364 T:6140620800 NOTICE: DVDPlayer: waiting for threads to exit
  1238. 10:10:22.364 T:6140620800 NOTICE: DVDPlayer: finished waiting
  1239. 10:10:22.365 T:6145781760 DEBUG: CurlFile::Open(0x16e5109f0) https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct:32400/hubs/home/recentlyAdded?X-Plex-Container-Size=20&X-Plex-Container-Start=0&X-Plex-Token=PLEXTOKEN&type=1
  1240. 10:10:22.399 T:6145781760 DEBUG: CurlFile::Open(0x16e5109f0) https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct:32400/hubs/home/onDeck?X-Plex-Container-Size=20&X-Plex-Container-Start=0&X-Plex-Token=PLEXTOKEN&type=2
  1241. 10:10:22.447 T:4391316352 DEBUG: CWinSystemIOS::AnnounceOnLostDevice
  1242. 10:10:22.450 T:6142341120 NOTICE: bool CAAudioUnitSink::setupAudio() total latency = 0.044500
  1243. 10:10:22.450 T:6142341120 NOTICE: bool CAAudioUnitSink::setupAudio() setup audio format: [lpcm] Mixable Interleaved 2 Channel 32-bit Floating Point LE (48000Hz)
  1244. 10:10:22.451 T:6142341120 NOTICE: void dumpAVAudioSessionProperties() audio route = HDMIOutput
  1245. 10:10:22.451 T:6142341120 NOTICE: void dumpAVAudioSessionProperties() sampleRate 48000.000000
  1246. 10:10:22.451 T:6142341120 NOTICE: void dumpAVAudioSessionProperties() outputLatency 0.001833
  1247. 10:10:22.451 T:6142341120 NOTICE: void dumpAVAudioSessionProperties() IOBufferDuration 0.042667
  1248. 10:10:22.451 T:6142341120 NOTICE: void dumpAVAudioSessionProperties() outputNumberOfChannels 2
  1249. 10:10:22.451 T:6142341120 NOTICE: void dumpAVAudioSessionProperties() maximumOutputNumberOfChannels 32
  1250. 10:10:22.451 T:6142341120 DEBUG: DumpAudioDescriptions: void dumpAVAudioSessionProperties()
  1251. 10:10:22.451 T:6142341120 DEBUG: DumpAudioDescriptions: input count = 0
  1252. 10:10:22.452 T:6142341120 DEBUG: DumpAudioDescriptions: output count = 1
  1253. 10:10:22.452 T:6142341120 DEBUG: DumpAudioDescriptions : portName, Living Room
  1254. 10:10:22.452 T:6142341120 DEBUG: DumpAudioDescriptions: channelLabel, 1
  1255. 10:10:22.452 T:6142341120 DEBUG: DumpAudioDescriptions: channelName , Living Room 1
  1256. 10:10:22.452 T:6142341120 DEBUG: DumpAudioDescriptions: channelLabel, 2
  1257. 10:10:22.452 T:6142341120 DEBUG: DumpAudioDescriptions: channelName , Living Room 2
  1258. 10:10:22.506 T:6145781760 DEBUG: CurlFile::Open(0x16e5109e0) https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct:32400/library/onDeck?X-Plex-Container-Size=20&X-Plex-Container-Start=0&X-Plex-Token=PLEXTOKEN&type=1
  1259. 10:10:22.513 T:6142341120 DEBUG: CActiveAESink::OpenSink - DARWINIOS Initialized:
  1260. 10:10:22.513 T:6142341120 DEBUG: Output Device : Default
  1261. 10:10:22.513 T:6142341120 DEBUG: Sample Rate : 48000
  1262. 10:10:22.513 T:6142341120 DEBUG: Sample Format : AE_FMT_FLOAT
  1263. 10:10:22.513 T:6142341120 DEBUG: Channel Count : 2
  1264. 10:10:22.513 T:6142341120 DEBUG: Channel Layout: FL,FR
  1265. 10:10:22.513 T:6142341120 DEBUG: Frames : 1024
  1266. 10:10:22.513 T:6142341120 DEBUG: Frame Size : 8
  1267. 10:10:22.513 T:6142341120 DEBUG: CActiveAESink::GenerateNoise - noiseFactor = 0.000010
  1268. 10:10:22.514 T:6141767680 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
  1269. 10:10:22.531 T:6145781760 DEBUG: Previous line repeats 1 times.
  1270. 10:10:22.531 T:6145781760 DEBUG: CurlFile::Open(0x16e5108c0) https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct:32400/hubs/home/continueWatching?X-Plex-Token=PLEXTOKEN
  1271. 10:10:22.601 T:4391316352 DEBUG: displayModeSwitchInProgress == YES, refreshRate = 23.98, dynamicRange = SDR
  1272. 10:10:22.645 T:4391316352 DEBUG: -[MainController displayLinkTick:]: displayRate = 59.940060
  1273. 10:10:23.341 T:6153809920 DEBUG: CurlFile::Open(0x16ecba600) https://192-168-2-10.97851b48348b48088ad5cfe04bd25fb7.plex.direct:32400/:/timeline?ratingKey=6678&key=%2Flibrary%2Fmetadata%2F6678&state=stopped&time=4202000&duration=8669000
  1274. 10:10:23.345 T:6140620800 ERROR: CGUITextureManager::GetTexturePath: could not find texture 'thumbs/OverlayWatched.png'
  1275. 10:10:25.606 T:6136606720 DEBUG: CWinSystemIOS::AnnounceOnResetDevice
  1276. 10:10:25.606 T:6141767680 DEBUG: CActiveAE - display reset event
  1277. 10:10:25.607 T:6142341120 INFO: CActiveAESink::OpenSink - initialize sink
  1278. 10:10:25.607 T:6142341120 DEBUG: CActiveAESink::OpenSink - trying to open device DARWINIOS:default
  1279. 10:10:25.611 T:6142341120 DEBUG: virtual bool CAESinkDARWINIOS::Initialize(AEAudioFormat &, std::string &): AudioStreamBasicDescription: [lpcm] Mixable Interleaved 2 Channel 32-bit Floating Point LE (48000Hz) pcm
  1280. 10:10:25.621 T:6142341120 NOTICE: bool CAAudioUnitSink::setupAudio() setting channels 2
  1281. 10:10:25.621 T:6142341120 NOTICE: bool CAAudioUnitSink::setupAudio() setting samplerate 48000.000000
  1282. 10:10:25.621 T:6142341120 NOTICE: bool CAAudioUnitSink::setupAudio() setting buffer duration to 0.042667
  1283. 10:10:25.655 T:6142341120 NOTICE: bool CAAudioUnitSink::setupAudio() total latency = 0.044500
  1284. 10:10:25.655 T:6142341120 NOTICE: bool CAAudioUnitSink::setupAudio() setup audio format: [lpcm] Mixable Interleaved 2 Channel 32-bit Floating Point LE (48000Hz)
  1285. 10:10:25.656 T:6142341120 NOTICE: void dumpAVAudioSessionProperties() audio route = HDMIOutput
  1286. 10:10:25.657 T:6142341120 NOTICE: void dumpAVAudioSessionProperties() sampleRate 48000.000000
  1287. 10:10:25.657 T:6142341120 NOTICE: void dumpAVAudioSessionProperties() outputLatency 0.001833
  1288. 10:10:25.657 T:6142341120 NOTICE: void dumpAVAudioSessionProperties() IOBufferDuration 0.042667
  1289. 10:10:25.657 T:6142341120 NOTICE: void dumpAVAudioSessionProperties() outputNumberOfChannels 2
  1290. 10:10:25.657 T:6142341120 NOTICE: void dumpAVAudioSessionProperties() maximumOutputNumberOfChannels 32
  1291. 10:10:25.657 T:6142341120 DEBUG: DumpAudioDescriptions: void dumpAVAudioSessionProperties()
  1292. 10:10:25.658 T:6142341120 DEBUG: DumpAudioDescriptions: input count = 0
  1293. 10:10:25.659 T:6142341120 DEBUG: DumpAudioDescriptions: output count = 1
  1294. 10:10:25.659 T:6142341120 DEBUG: DumpAudioDescriptions : portName, Living Room
  1295. 10:10:25.659 T:6142341120 DEBUG: DumpAudioDescriptions: channelLabel, 1
  1296. 10:10:25.659 T:6142341120 DEBUG: DumpAudioDescriptions: channelName , Living Room 1
  1297. 10:10:25.659 T:6142341120 DEBUG: DumpAudioDescriptions: channelLabel, 2
  1298. 10:10:25.659 T:6142341120 DEBUG: DumpAudioDescriptions: channelName , Living Room 2
  1299. 10:10:25.812 T:4391316352 DEBUG: CWinSystemIOS::AnnounceOnResetDevice
  1300. 10:10:25.812 T:4391316352 DEBUG: displayModeSwitchInProgress == DONE, refreshRate = 59.94, dynamicRange = SDR
  1301. 10:10:25.842 T:6142341120 DEBUG: CActiveAESink::OpenSink - DARWINIOS Initialized:
  1302. 10:10:25.843 T:6142341120 DEBUG: Output Device : Default
  1303. 10:10:25.843 T:6142341120 DEBUG: Sample Rate : 48000
  1304. 10:10:25.843 T:6142341120 DEBUG: Sample Format : AE_FMT_FLOAT
  1305. 10:10:25.843 T:6142341120 DEBUG: Channel Count : 2
  1306. 10:10:25.843 T:6142341120 DEBUG: Channel Layout: FL,FR
  1307. 10:10:25.843 T:6142341120 DEBUG: Frames : 1024
  1308. 10:10:25.843 T:6142341120 DEBUG: Frame Size : 8
  1309. 10:10:25.844 T:6142341120 DEBUG: CActiveAESink::GenerateNoise - noiseFactor = 0.000010
  1310. 10:10:25.849 T:6141767680 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
  1311. 10:10:32.858 T:6136033280 DEBUG: webserver: request received for /
  1312. 10:10:32.947 T:6136033280 DEBUG: webserver: request received for /css/core.css?1.3.57
  1313. 10:10:32.950 T:6137180160 DEBUG: webserver: request received for /css/ipad.css?1.0.5
  1314. 10:10:32.952 T:6138327040 DEBUG: webserver: request received for /js/xbmc.launcher.js?v=2.1.0
  1315. 10:10:32.982 T:6138327040 DEBUG: webserver: request received for /images/ajax-loader.gif
  1316. 10:10:33.049 T:6136033280 DEBUG: webserver: request received for /js/jquery-1.8.2.min.js?2.1.0
  1317. 10:10:33.050 T:6138327040 DEBUG: webserver: request received for /js/json2.js?2.1.0
  1318. 10:10:33.050 T:6137180160 DEBUG: webserver: request received for /js/iscroll-min.js?2.1.0
  1319. 10:10:33.057 T:6138900480 DEBUG: webserver: request received for /js/xbmc.core.js?2.1.0
  1320. 10:10:33.058 T:6141194240 DEBUG: webserver: request received for /js/MediaLibrary.js?2.1.0
  1321. 10:10:33.058 T:6142914560 DEBUG: webserver: request received for /js/NowPlayingManager.js?2.1.0
  1322. 10:10:33.059 T:6143488000 DEBUG: webserver: request received for /js/xbmc.init.js?2.1.0
  1323. 10:10:33.059 T:6139473920 DEBUG: webserver: request received for /js/xbmc.rpc.js?2.1.0
  1324. 10:10:33.144 T:6136033280 DEBUG: webserver: request received for /jsonrpc?Playlist.GetPlaylists
  1325. 10:10:33.183 T:6136033280 DEBUG: webserver: request received for /jsonrpc?Player.GetActivePlayers
  1326. 10:10:33.196 T:6136033280 DEBUG: webserver: request received for /favicon.ico
  1327. 10:10:33.749 T:6136033280 DEBUG: webserver: request received for /jsonrpc?System.IsLite
  1328. 10:10:33.770 T:6136033280 DEBUG: webserver: request received for /vfs%2Fspecial%3A%2F%2Flogs%2Fmrmc.log?1545322233823

audio channel mapping wrong. center out of left surround.