18:33:00 252.171341 T:1961263104 NOTICE: special://profile/ is mapped to: special://masterprofile/ 18:33:00 252.171432 T:1961263104 NOTICE: ----------------------------------------------------------------------- 18:33:00 252.171478 T:1961263104 NOTICE: Starting Kodi (17.0-BETA4 Git:57eb7af). Platform: Linux ARM 32-bit 18:33:00 252.171509 T:1961263104 NOTICE: Using Release Kodi x32 build (version for Raspberry Pi) 18:33:00 252.171555 T:1961263104 NOTICE: Kodi compiled Oct 11 2016 by GCC 5.4.0 for Linux ARM 32-bit version 4.8.1 (264193) 18:33:00 252.171722 T:1961263104 NOTICE: Running on LibreELEC (Milhouse) - Version: devel-20161011042929-#1010-g5661f32 [Build #1010] 8.0, kernel: Linux ARM 32-bit version 4.8.1 18:33:00 252.171814 T:1961263104 NOTICE: FFmpeg version/source: ffmpeg-3.1-kodi 18:33:00 252.171844 T:1961263104 NOTICE: Host CPU: ARMv7 Processor rev 4 (v7l), 4 cores available 18:33:00 252.171875 T:1961263104 NOTICE: ARM Features: Neon enabled 18:33:00 252.171906 T:1961263104 NOTICE: special://xbmc/ is mapped to: /usr/share/kodi/ 18:33:00 252.171951 T:1961263104 NOTICE: special://xbmcbin/ is mapped to: /usr/lib/kodi 18:33:00 252.171982 T:1961263104 NOTICE: special://xbmcbinaddons/ is mapped to: /usr/lib/kodi/addons 18:33:00 252.172012 T:1961263104 NOTICE: special://masterprofile/ is mapped to: /storage/.kodi/userdata 18:33:00 252.172043 T:1961263104 NOTICE: special://envhome/ is mapped to: /storage 18:33:00 252.172073 T:1961263104 NOTICE: special://home/ is mapped to: /storage/.kodi 18:33:00 252.172104 T:1961263104 NOTICE: special://temp/ is mapped to: /storage/.kodi/temp 18:33:00 252.172134 T:1961263104 NOTICE: special://logpath/ is mapped to: /storage/.kodi/temp 18:33:00 252.172195 T:1961263104 NOTICE: The executable running is: /usr/lib/kodi/kodi.bin 18:33:00 252.172256 T:1961263104 NOTICE: Local hostname: LibreELEC 18:33:00 252.172318 T:1961263104 NOTICE: Log File is located: /storage/.kodi/temp//kodi.log 18:33:00 252.172379 T:1961263104 NOTICE: ----------------------------------------------------------------------- 18:33:00 252.178864 T:1961263104 NOTICE: load settings... 18:33:00 252.275223 T:1961263104 NOTICE: Found 2 Lists of Devices 18:33:00 252.275314 T:1961263104 NOTICE: Enumerated PI devices: 18:33:00 252.275345 T:1961263104 NOTICE: Device 1 18:33:00 252.275726 T:1961263104 NOTICE: m_deviceName : HDMI 18:33:00 252.275772 T:1961263104 NOTICE: m_displayName : HDMI 18:33:00 252.275803 T:1961263104 NOTICE: m_displayNameExtra: 18:33:00 252.275833 T:1961263104 NOTICE: m_deviceType : AE_DEVTYPE_HDMI 18:33:00 252.275864 T:1961263104 NOTICE: m_channels : FL,FR 18:33:00 252.275894 T:1961263104 NOTICE: m_sampleRates : 8000,11025,16000,22050,24000,32000,44100,48000,88200,96000,176400,192000 18:33:00 252.275940 T:1961263104 NOTICE: m_dataFormats : AE_FMT_FLOAT,AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S32LE,AE_FMT_S16LE,AE_FMT_FLOATP,AE_FMT_S32NEP,AE_FMT_S16NEP,AE_FMT_RAW 18:33:00 252.275970 T:1961263104 NOTICE: m_streamTypes : STREAM_TYPE_AC3,STREAM_TYPE_EAC3,STREAM_TYPE_DTSHD_CORE,STREAM_TYPE_DTS_2048,STREAM_TYPE_DTS_1024,STREAM_TYPE_DTS_512 18:33:00 252.276031 T:1961263104 NOTICE: Device 2 18:33:00 252.276093 T:1961263104 NOTICE: m_deviceName : Analogue 18:33:00 252.276123 T:1961263104 NOTICE: m_displayName : Analogue 18:33:00 252.276154 T:1961263104 NOTICE: m_displayNameExtra: 18:33:00 252.276184 T:1961263104 NOTICE: m_deviceType : AE_DEVTYPE_PCM 18:33:00 252.276215 T:1961263104 NOTICE: m_channels : FL,FR 18:33:00 252.276245 T:1961263104 NOTICE: m_sampleRates : 48000 18:33:00 252.276291 T:1961263104 NOTICE: m_dataFormats : AE_FMT_FLOAT,AE_FMT_S32LE,AE_FMT_S16LE,AE_FMT_FLOATP,AE_FMT_S32NEP,AE_FMT_S16NEP 18:33:00 252.276321 T:1961263104 NOTICE: m_streamTypes : No passthrough capabilities 18:33:00 252.276352 T:1961263104 NOTICE: Device 3 18:33:00 252.276413 T:1961263104 NOTICE: m_deviceName : Both 18:33:00 252.276474 T:1961263104 NOTICE: m_displayName : HDMI and Analogue 18:33:00 252.276505 T:1961263104 NOTICE: m_displayNameExtra: 18:33:00 252.276535 T:1961263104 NOTICE: m_deviceType : AE_DEVTYPE_PCM 18:33:00 252.276566 T:1961263104 NOTICE: m_channels : FL,FR 18:33:00 252.276627 T:1961263104 NOTICE: m_sampleRates : 48000 18:33:00 252.276657 T:1961263104 NOTICE: m_dataFormats : AE_FMT_FLOAT,AE_FMT_S32LE,AE_FMT_S16LE,AE_FMT_FLOATP,AE_FMT_S32NEP,AE_FMT_S16NEP 18:33:00 252.276688 T:1961263104 NOTICE: m_streamTypes : No passthrough capabilities 18:33:00 252.276733 T:1961263104 NOTICE: Enumerated PULSE devices: 18:33:00 252.276764 T:1961263104 NOTICE: Device 1 18:33:00 252.276825 T:1961263104 NOTICE: m_deviceName : Default 18:33:00 252.276855 T:1961263104 NOTICE: m_displayName : Default 18:33:00 252.276901 T:1961263104 NOTICE: m_displayNameExtra: Bluetooth Audio (PULSEAUDIO) 18:33:00 252.276932 T:1961263104 NOTICE: m_deviceType : AE_DEVTYPE_PCM 18:33:00 252.276962 T:1961263104 NOTICE: m_channels : FL,FR 18:33:00 252.276993 T:1961263104 NOTICE: m_sampleRates : 5512,8000,11025,16000,22050,32000,44100,48000,64000,88200,96000,176400,192000,384000 18:33:00 252.277023 T:1961263104 NOTICE: m_dataFormats : AE_FMT_U8,AE_FMT_S16NE,AE_FMT_S24NE3,AE_FMT_S24NE4,AE_FMT_S32NE,AE_FMT_FLOAT 18:33:00 252.277054 T:1961263104 NOTICE: m_streamTypes : No passthrough capabilities 18:33:00 252.290955 T:1961263104 NOTICE: Loaded settings file from special://xbmc/system/advancedsettings.xml 18:33:00 252.291245 T:1961263104 NOTICE: Contents of special://xbmc/system/advancedsettings.xml are... false 720 540 30 18:33:00 252.292709 T:1961263104 NOTICE: No settings file to load (special://masterprofile/advancedsettings.xml) 18:33:00 252.292755 T:1961263104 NOTICE: Default Video Player: VideoPlayer 18:33:00 252.292786 T:1961263104 NOTICE: Default Audio Player: paplayer 18:33:00 252.292831 T:1961263104 NOTICE: Disabled debug logging due to GUI setting. Level 0. 18:33:00 252.292862 T:1961263104 NOTICE: Log level changed to "LOG_LEVEL_NORMAL" 18:33:00 252.293045 T:1961263104 NOTICE: CMediaSourceSettings: loading media sources from special://masterprofile/sources.xml 18:33:00 252.293762 T:1961263104 NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml. 18:33:00 252.294571 T:1961263104 NOTICE: Loaded playercorefactory configuration 18:33:00 252.294815 T:1961263104 NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml. 18:33:00 252.294983 T:1961263104 NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping. 18:33:00 252.320358 T:1961263104 NOTICE: Running database version Addons26 18:33:01 252.736313 T:1961263104 NOTICE: ADDONS: Using repository repository.kodi.game 18:33:01 252.736435 T:1961263104 NOTICE: ADDONS: Using repository repository.libreelec.tv 18:33:01 252.736481 T:1961263104 NOTICE: ADDONS: Using repository repository.xbmc.org 18:33:01 252.894882 T:1961263104 NOTICE: Raspberry PI firmware version: Oct 4 2016 19:03:30 Copyright (c) 2012 Broadcom version c844c61ad08f94946910d0d5e1be076df4c8c56d (clean) (release) 18:33:01 252.895020 T:1961263104 NOTICE: ARM mem: 752MB GPU mem: 256MB MPG2:0 WVC1:0 18:33:01 252.895050 T:1961263104 NOTICE: cache.memorysize: 20MB 18:33:01 252.895325 T:1961263104 NOTICE: Config: arm_freq=1200 audio_pwm_mode=1 config_hdmi_boost=5 core_freq=400 desired_osc_freq=0x36ee80 disable_commandline_tags=2 disable_l2cache=1 force_eeprom_read=1 force_pwm_open=1 framebuffer_ignore_alpha=1 framebuffer_swap=1 gpu_freq=300 hdmi_channel_map=8 hdmi_force_cec_address=65535 hdmi_ignore_cec_init=1 init_uart_clock=0x2dc6c00 lcd_framerate=60 over_voltage_avs=0x13d62 overscan_bottom=48 overscan_left=48 overscan_right=48 overscan_top=48 pause_burst_frames=1 program_serial_random=1 sdram_freq=450 temp_limit=85 18:33:01 252.895447 T:1961263104 NOTICE: Config: device_tree=- 18:33:01 252.895493 T:1961263104 NOTICE: InitWindowSystem: Using EGL Implementation: raspberrypi 18:33:01 252.897324 T:1961263104 NOTICE: Found resolution 640 x 480 for display 0 with 640 x 480 @ 60.000000 Hz 18:33:01 252.897385 T:1961263104 NOTICE: Found resolution 640 x 480 for display 0 with 640 x 480 @ 59.940063 Hz 18:33:01 252.897430 T:1961263104 NOTICE: Found resolution 800 x 600 for display 0 with 800 x 600 @ 60.000000 Hz 18:33:01 252.897461 T:1961263104 NOTICE: Found resolution 800 x 600 for display 0 with 800 x 600 @ 59.940063 Hz 18:33:01 252.897491 T:1961263104 NOTICE: Found resolution 1024 x 768 for display 0 with 1024 x 768 @ 60.000000 Hz 18:33:01 252.897537 T:1961263104 NOTICE: Found resolution 1024 x 768 for display 0 with 1024 x 768 @ 59.940063 Hz 18:33:01 252.897568 T:1961263104 NOTICE: Found resolution 1280 x 1024 for display 0 with 1280 x 1024 @ 60.000000 Hz 18:33:01 252.897614 T:1961263104 NOTICE: Found resolution 1280 x 1024 for display 0 with 1280 x 1024 @ 59.940063 Hz 18:33:01 252.897659 T:1961263104 NOTICE: Found resolution 1600 x 900 for display 0 with 1600 x 900 @ 60.000000 Hz 18:33:01 252.897690 T:1961263104 NOTICE: Found resolution 1600 x 900 for display 0 with 1600 x 900 @ 59.940063 Hz 18:33:01 252.897720 T:1961263104 NOTICE: Found resolution 720 x 480 for display 0 with 720 x 480 @ 60.000000 Hz 18:33:01 252.897766 T:1961263104 NOTICE: Found resolution 720 x 480 for display 0 with 720 x 480 @ 59.940063 Hz 18:33:01 252.897797 T:1961263104 NOTICE: Found resolution 1280 x 720 for display 0 with 1280 x 720 @ 60.000000 Hz 18:33:01 252.897842 T:1961263104 NOTICE: Found resolution 1280 x 720 for display 0 with 1280 x 720 @ 59.940063 Hz 18:33:01 252.897873 T:1961263104 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 60.000000 Hz 18:33:01 252.897903 T:1961263104 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 59.940063 Hz 18:33:01 252.897964 T:1961263104 NOTICE: Found resolution 720 x 576 for display 0 with 720 x 576 @ 50.000000 Hz 18:33:01 252.897995 T:1961263104 NOTICE: Found resolution 1280 x 720 for display 0 with 1280 x 720 @ 50.000000 Hz 18:33:01 252.898056 T:1961263104 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 50.000000 Hz 18:33:01 252.898087 T:1961263104 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 24.000000 Hz 18:33:01 252.898132 T:1961263104 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 23.976025 Hz 18:33:01 252.898163 T:1961263104 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 30.000000 Hz 18:33:01 252.898193 T:1961263104 NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 29.970032 Hz 18:33:01 252.898239 T:1961263104 NOTICE: Found (1920x1080@60.000000) at 30, setting to RES_DESKTOP at 16 18:33:01 252.898331 T:1961263104 NOTICE: Checking resolution 16 18:33:06 258.249023 T:1961263104 NOTICE: GL_VENDOR = Broadcom 18:33:06 258.338196 T:1961263104 NOTICE: GL_RENDERER = VideoCore IV HW 18:33:06 258.338287 T:1961263104 NOTICE: GL_VERSION = OpenGL ES 2.0 18:33:06 258.338318 T:1961263104 NOTICE: GL_SHADING_LANGUAGE_VERSION = OpenGL ES GLSL ES 1.00 18:33:06 258.338379 T:1961263104 NOTICE: GL_EXTENSIONS = GL_OES_compressed_ETC1_RGB8_texture GL_OES_compressed_paletted_texture GL_OES_texture_npot GL_OES_depth24 GL_OES_vertex_half_float GL_OES_EGL_image GL_OES_EGL_image_external GL_EXT_discard_framebuffer GL_OES_rgb8_rgba8 GL_OES_depth32 GL_OES_mapbuffer GL_EXT_texture_format_BGRA8888 GL_APPLE_rgb_422 GL_EXT_debug_marker 18:33:07 258.985474 T:1961263104 NOTICE: Running database version Addons26 18:33:07 258.987213 T:1961263104 NOTICE: Running database version ViewModes6 18:33:07 258.989014 T:1961263104 NOTICE: Running database version Textures13 18:33:07 258.994659 T:1961263104 NOTICE: Running database version MyMusic60 18:33:07 259.004089 T:1961263104 NOTICE: Running database version MyVideos107 18:33:07 259.006561 T:1961263104 NOTICE: Running database version TV29 18:33:07 259.008575 T:1961263104 NOTICE: Running database version Epg11 18:33:07 259.011322 T:1961263104 NOTICE: start dvd mediatype detection 18:33:07 259.088715 T:1831859104 NOTICE: Register - new cec device registered on cec->RPI: CEC Adapter (2708:1001) 18:33:08 259.518616 T:1961263104 WARNING: JSONRPC: Could not parse type "Setting.Details.SettingList" 18:33:08 259.579193 T:1961263104 ERROR: JSONRPC: Unable to parse JSON Schema definition for "" 18:33:08 259.579285 T:1961263104 ERROR: JSONRPC: Invalid JSON Schema definition for method "" 18:33:08 260.079590 T:1778381728 ERROR: GetDirectory - Error getting 18:33:08 260.080414 T:1961263104 NOTICE: initialize done 18:33:08 260.080505 T:1961263104 NOTICE: Running the application... 18:33:08 260.109741 T:1961263104 NOTICE: starting upnp client 18:33:08 260.210083 T:1961263104 NOTICE: flirc.tv flirc: keys:35 ext:64 but:0 rel:1 abs:0 m_deviceType:c bits:111000 18:33:08 260.429565 T:1761604512 WARNING: CSkinInfo: failed to load skin settings 18:33:31 282.567261 T:1769993120 NOTICE: Start - EPG thread started 18:34:32 344.366180 T:1961263104 NOTICE: PVRManager - stopping 18:34:38 349.871979 T:1649402784 WARNING: CPVRRecording::CPVRRecording - unable to determine channel type. Defaulting to TV. 18:34:40 352.347809 T:1769993120 WARNING: Previous line repeats 20 times. 18:34:40 352.347961 T:1769993120 NOTICE: Start - EPG thread started 18:34:41 352.572662 T:1649402784 ERROR: CCurlFile::FillBuffer - Failed: HTTP returned error 403 18:34:41 352.572815 T:1649402784 ERROR: CCurlFile::Open failed with code 403 for http://zattoo.com/zapi/playlist|acceptencoding=gzip 18:34:41 352.572937 T:1649402784 ERROR: Open - failed to open source 18:34:41 352.665039 T:1649402784 ERROR: CCurlFile::FillBuffer - Failed: HTTP returned error 403 18:34:41 352.665222 T:1649402784 ERROR: CCurlFile::Open failed with code 403 for http://zattoo.com/zapi/session/hello|acceptencoding=gzip&postdata=dXVpZD04ODhiNGY1NC1jMTI3LTExZTUtOTkxMi1iYTBiZTA0ODNjMTgmbGFuZz1lbiZmb3JtYXQ9anNvbiZjbGllbnRfYXBwX3Rva2VuPWVlOGZkMmYxYmNjYjNhYTM2ZmJjMjIyYmIyYTczZDhm 18:34:41 352.665375 T:1649402784 ERROR: Open - failed to open source 18:34:41 352.665466 T:1649402784 ERROR: AddOnLog: Zattoo PVR Client: Open URL failed during init. 18:34:41 352.665527 T:1649402784 ERROR: AddOnLog: Zattoo PVR Client: Hello failed. 18:34:41 352.665558 T:1649402784 ERROR: AddOnLog: Zattoo PVR Client: Re-init of session. Failed. 18:34:54 365.617767 T:1632625568 NOTICE: DecodeJpeg: unable to decode http://images.zattic.com/system/images/bbca/50d5/1de9/9ecc/6c51/format_480x360.jpg 480x360 18:34:54 365.632568 T:1603261344 NOTICE: DecodeJpeg: unable to decode http://images.zattic.com/system/images/c15d/761f/ce7e/5156/3ed4/format_480x360.jpg 480x360 18:34:54 365.777588 T:1930425248 NOTICE: CAESinkPi:AddPackets Underrun (delay:0.00 frames:1102) 18:35:21 392.729095 T:1961263104 NOTICE: VideoPlayer: Opening: pvr://channels/tv/All channels/pvr.zattoo_4245367.pvr 18:35:21 392.729340 T:1961263104 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 18:35:21 392.730438 T:1611658144 NOTICE: Creating InputStream 18:35:21 393.037567 T:1611658144 NOTICE: Creating Demuxer 18:35:22 393.639099 T:1611658144 NOTICE: Opening stream: 0 source: 256 18:35:22 393.639313 T:1611658144 NOTICE: Creating video codec with codec id: 28 18:35:22 393.648315 T:1611658144 NOTICE: Creating video thread 18:35:22 393.648560 T:1553986464 NOTICE: running thread: video_thread 18:35:22 393.648621 T:1611658144 NOTICE: Opening stream: 1 source: 256 18:35:22 393.648651 T:1611658144 NOTICE: Finding audio codec for: 86018 18:35:22 393.650238 T:1611658144 NOTICE: Creating audio thread 18:35:22 393.650421 T:1545597856 NOTICE: running thread: CVideoPlayerAudio::Process() 18:35:22 393.661011 T:1545597856 NOTICE: Creating audio stream (codec id: 86018, channels: 2, sample rate: 48000, no pass-through) 18:35:22 394.255890 T:1553986464 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer 18:35:28 399.673431 T:1961263104 NOTICE: CVideoPlayer::CloseFile() 18:35:28 399.673676 T:1961263104 NOTICE: VideoPlayer: waiting for threads to exit 18:35:28 399.679230 T:1611658144 NOTICE: CVideoPlayer::OnExit() 18:35:28 399.679352 T:1611658144 NOTICE: Closing stream player 1 18:35:28 399.679413 T:1611658144 NOTICE: Waiting for audio thread to exit 18:35:28 399.688538 T:1545597856 NOTICE: thread end: CVideoPlayerAudio::OnExit() 18:35:28 399.688751 T:1611658144 NOTICE: Closing audio device 18:35:28 399.716492 T:1611658144 NOTICE: Deleting audio codec 18:35:28 399.716858 T:1611658144 NOTICE: Closing stream player 2 18:35:28 399.717010 T:1611658144 NOTICE: waiting for video thread to exit 18:35:28 399.731873 T:1553986464 NOTICE: thread end: video_thread 18:35:28 399.734161 T:1611658144 NOTICE: deleting video codec 18:35:28 399.814209 T:1961263104 NOTICE: VideoPlayer: finished waiting 18:35:28 400.288177 T:1961263104 NOTICE: CVideoPlayer::CloseFile() 18:35:28 400.288300 T:1961263104 NOTICE: VideoPlayer: waiting for threads to exit 18:35:28 400.288330 T:1961263104 NOTICE: VideoPlayer: finished waiting 18:35:28 400.288483 T:1961263104 NOTICE: CVideoPlayer::CloseFile() 18:35:28 400.288513 T:1961263104 NOTICE: VideoPlayer: waiting for threads to exit 18:35:28 400.288544 T:1961263104 NOTICE: VideoPlayer: finished waiting 18:35:32 403.977295 T:1961263104 NOTICE: VideoPlayer: Opening: pvr://channels/tv/All channels/pvr.zattoo_3631865.pvr 18:35:32 403.977509 T:1961263104 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 18:35:32 403.977997 T:1594872736 NOTICE: Creating InputStream 18:35:32 404.174438 T:1594872736 NOTICE: Creating Demuxer 18:35:33 404.759064 T:1594872736 NOTICE: Opening stream: 0 source: 256 18:35:33 404.759308 T:1594872736 NOTICE: Creating video codec with codec id: 28 18:35:33 404.766479 T:1594872736 NOTICE: Creating video thread 18:35:33 404.766602 T:1594872736 NOTICE: Opening stream: 1 source: 256 18:35:33 404.766663 T:1611658144 NOTICE: running thread: video_thread 18:35:33 404.766724 T:1594872736 NOTICE: Finding audio codec for: 86018 18:35:33 404.768158 T:1594872736 NOTICE: Creating audio thread 18:35:33 404.768341 T:1553986464 NOTICE: running thread: CVideoPlayerAudio::Process() 18:35:33 404.778839 T:1553986464 NOTICE: Creating audio stream (codec id: 86018, channels: 2, sample rate: 48000, no pass-through) 18:35:33 405.372559 T:1611658144 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer 18:35:35 407.376740 T:1594872736 NOTICE: Creating Demuxer 18:35:36 407.895569 T:1594872736 NOTICE: Opening stream: 0 source: 256 18:35:36 407.895844 T:1594872736 NOTICE: Opening stream: 1 source: 256 18:35:36 407.895874 T:1594872736 NOTICE: Finding audio codec for: 86018 18:35:36 408.472565 T:1611658144 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer 18:35:44 416.439728 T:1961263104 NOTICE: CVideoPlayer::CloseFile() 18:35:44 416.439880 T:1961263104 NOTICE: VideoPlayer: waiting for threads to exit 18:35:44 416.443756 T:1594872736 NOTICE: CVideoPlayer::OnExit() 18:35:44 416.443848 T:1594872736 NOTICE: Closing stream player 1 18:35:44 416.443939 T:1594872736 NOTICE: Waiting for audio thread to exit 18:35:44 416.467987 T:1553986464 NOTICE: thread end: CVideoPlayerAudio::OnExit() 18:35:44 416.468140 T:1594872736 NOTICE: Closing audio device 18:35:44 416.496094 T:1594872736 NOTICE: Deleting audio codec 18:35:44 416.496399 T:1594872736 NOTICE: Closing stream player 2 18:35:44 416.496490 T:1594872736 NOTICE: waiting for video thread to exit 18:35:44 416.497833 T:1611658144 NOTICE: thread end: video_thread 18:35:44 416.500397 T:1594872736 NOTICE: deleting video codec 18:35:45 416.913452 T:1961263104 NOTICE: VideoPlayer: finished waiting 18:35:45 417.415863 T:1961263104 NOTICE: CVideoPlayer::CloseFile() 18:35:45 417.415985 T:1961263104 NOTICE: VideoPlayer: waiting for threads to exit 18:35:45 417.416016 T:1961263104 NOTICE: VideoPlayer: finished waiting 18:35:45 417.416077 T:1961263104 NOTICE: CVideoPlayer::CloseFile() 18:35:45 417.416107 T:1961263104 NOTICE: VideoPlayer: waiting for threads to exit 18:35:45 417.416138 T:1961263104 NOTICE: VideoPlayer: finished waiting 18:36:01 433.266815 T:1961263104 NOTICE: VideoPlayer: Opening: http://zh2-4-hls-pvr.zahs.tv/HD_tsi1/1476009900/1476017100.m3u8?z32=NVQXQ4TBORST2MBGOVZWK4S7NFSD2MRRG43TGMBQG4THK5LJMQ6TQOBYMI2GMNJUFVRTCMRXFUYTCZJVFU4TSMJSFVRGCMDCMUYDIOBTMMYTQJTJNZUXI2LBNRZGC5DFHUYCM43JM46TGNTDMRRTOOLFMU2GKZDGGAZTQNBXGRQWKNBZMM2DONBVGQ2TQNJGNVUW44TBORST2NRQGATGG2DBNZXGK3B5INEF6SDJKFPXI43JGETGG43JMQ6TCNBXIM4DONSDHE2DGMRWIM4TGLJVGAYUMRBTGI4DSNZUIJATQRJU 18:36:01 433.267059 T:1961263104 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 18:36:01 433.277313 T:1545597856 NOTICE: Creating InputStream 18:36:01 433.407104 T:1545597856 NOTICE: Creating Demuxer 18:36:02 433.768616 T:1545597856 NOTICE: Opening stream: 0 source: 256 18:36:02 433.768890 T:1545597856 NOTICE: Creating video codec with codec id: 28 18:36:02 433.776123 T:1545597856 NOTICE: Creating video thread 18:36:02 433.776276 T:1545597856 NOTICE: Opening stream: 1 source: 256 18:36:02 433.776306 T:1518334880 NOTICE: running thread: video_thread 18:36:02 433.776367 T:1545597856 NOTICE: Finding audio codec for: 86018 18:36:02 433.777832 T:1545597856 NOTICE: Creating audio thread 18:36:02 433.777985 T:1594872736 NOTICE: running thread: CVideoPlayerAudio::Process() 18:36:02 433.789398 T:1594872736 NOTICE: Creating audio stream (codec id: 86018, channels: 2, sample rate: 48000, no pass-through) 18:37:11 503.189240 T:1518334880 WARNING: CRenderManager::WaitForBuffer - timeout waiting for buffer 18:37:16 508.506226 T:1961263104 WARNING: Previous line repeats 2 times. 18:37:16 508.506317 T:1961263104 NOTICE: CVideoPlayer::CloseFile() 18:37:16 508.506409 T:1961263104 NOTICE: VideoPlayer: waiting for threads to exit 18:37:16 508.506470 T:1545597856 NOTICE: CVideoPlayer::OnExit() 18:37:16 508.506500 T:1545597856 NOTICE: Closing stream player 1 18:37:16 508.506561 T:1545597856 NOTICE: Waiting for audio thread to exit 18:37:17 508.516937 T:1594872736 NOTICE: thread end: CVideoPlayerAudio::OnExit() 18:37:17 508.516998 T:1545597856 NOTICE: Closing audio device 18:37:17 508.543396 T:1545597856 NOTICE: Deleting audio codec 18:37:17 508.543610 T:1545597856 NOTICE: Closing stream player 2 18:37:17 508.543671 T:1545597856 NOTICE: waiting for video thread to exit 18:37:17 508.556000 T:1518334880 NOTICE: thread end: video_thread 18:37:17 508.557251 T:1545597856 NOTICE: deleting video codec 18:37:17 508.562256 T:1961263104 NOTICE: VideoPlayer: finished waiting 18:37:17 508.706757 T:1961263104 NOTICE: CVideoPlayer::CloseFile() 18:37:17 508.706879 T:1961263104 NOTICE: VideoPlayer: waiting for threads to exit 18:37:17 508.706909 T:1961263104 NOTICE: VideoPlayer: finished waiting 18:37:17 508.707001 T:1961263104 NOTICE: CVideoPlayer::CloseFile() 18:37:17 508.707031 T:1961263104 NOTICE: VideoPlayer: waiting for threads to exit 18:37:17 508.707062 T:1961263104 NOTICE: VideoPlayer: finished waiting 18:37:21 513.098328 T:1961263104 NOTICE: VideoPlayer: Opening: pvr://channels/tv/All channels/pvr.zattoo_4245367.pvr 18:37:21 513.098572 T:1961263104 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 18:37:21 513.099243 T:1545597856 NOTICE: Creating InputStream 18:37:21 513.302734 T:1545597856 ERROR: CCurlFile::FillBuffer - Failed: HTTP returned error 403 18:37:21 513.302856 T:1545597856 ERROR: CCurlFile::Open failed with code 403 for http://zattoo.com/zapi/watch|acceptencoding=gzip&postdata=Y2lkPXNmLTEmc3RyZWFtX3R5cGU9aGxzJmZvcm1hdD1qc29u 18:37:21 513.302979 T:1545597856 ERROR: Open - failed to open source 18:37:21 513.392822 T:1545597856 ERROR: CCurlFile::FillBuffer - Failed: HTTP returned error 403 18:37:21 513.392944 T:1545597856 ERROR: CCurlFile::Open failed with code 403 for http://zattoo.com/zapi/session/hello|acceptencoding=gzip&postdata=dXVpZD04ODhiNGY1NC1jMTI3LTExZTUtOTkxMi1iYTBiZTA0ODNjMTgmbGFuZz1lbiZmb3JtYXQ9anNvbiZjbGllbnRfYXBwX3Rva2VuPWVlOGZkMmYxYmNjYjNhYTM2ZmJjMjIyYmIyYTczZDhm 18:37:21 513.393005 T:1545597856 ERROR: Open - failed to open source 18:37:21 513.393066 T:1545597856 ERROR: AddOnLog: Zattoo PVR Client: Open URL failed during init. 18:37:21 513.393127 T:1545597856 ERROR: AddOnLog: Zattoo PVR Client: Hello failed. 18:37:21 513.393188 T:1545597856 ERROR: AddOnLog: Zattoo PVR Client: Re-init of session. Failed. 18:37:21 513.393372 T:1545597856 ERROR: CDVDInputStreamPVRManager::Open - error opening [] 18:37:21 513.393433 T:1545597856 ERROR: CVideoPlayer::OpenInputStream - error opening [pvr://channels/tv/All channels/pvr.zattoo_4245367.pvr] 18:37:21 513.393494 T:1545597856 NOTICE: CVideoPlayer::OnExit() 18:37:21 513.467834 T:1961263104 ERROR: PlayMedia could not play media: pvr://channels/tv/All channels/pvr.zattoo_4245367.pvr 18:37:21 513.470825 T:1961263104 NOTICE: CVideoPlayer::CloseFile() 18:37:21 513.470947 T:1961263104 NOTICE: VideoPlayer: waiting for threads to exit 18:37:21 513.470947 T:1961263104 NOTICE: VideoPlayer: finished waiting 18:37:21 513.471130 T:1961263104 NOTICE: CVideoPlayer::CloseFile() 18:37:21 513.471130 T:1961263104 NOTICE: VideoPlayer: waiting for threads to exit 18:37:21 513.471191 T:1961263104 NOTICE: VideoPlayer: finished waiting 18:37:25 517.358948 T:1961263104 NOTICE: VideoPlayer: Opening: pvr://channels/tv/All channels/pvr.zattoo_4245367.pvr 18:37:25 517.359131 T:1961263104 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 18:37:25 517.359985 T:1545597856 NOTICE: Creating InputStream 18:37:25 517.467285 T:1545597856 ERROR: CCurlFile::FillBuffer - Failed: HTTP returned error 403 18:37:25 517.467407 T:1545597856 ERROR: CCurlFile::Open failed with code 403 for http://zattoo.com/zapi/watch|acceptencoding=gzip&postdata=Y2lkPXNmLTEmc3RyZWFtX3R5cGU9aGxzJmZvcm1hdD1qc29u 18:37:25 517.467529 T:1545597856 ERROR: Open - failed to open source 18:37:26 517.555603 T:1545597856 ERROR: CCurlFile::FillBuffer - Failed: HTTP returned error 403 18:37:26 517.555725 T:1545597856 ERROR: CCurlFile::Open failed with code 403 for http://zattoo.com/zapi/session/hello|acceptencoding=gzip&postdata=dXVpZD04ODhiNGY1NC1jMTI3LTExZTUtOTkxMi1iYTBiZTA0ODNjMTgmbGFuZz1lbiZmb3JtYXQ9anNvbiZjbGllbnRfYXBwX3Rva2VuPWVlOGZkMmYxYmNjYjNhYTM2ZmJjMjIyYmIyYTczZDhm 18:37:26 517.555786 T:1545597856 ERROR: Open - failed to open source 18:37:26 517.555908 T:1545597856 ERROR: AddOnLog: Zattoo PVR Client: Open URL failed during init. 18:37:26 517.555908 T:1545597856 ERROR: AddOnLog: Zattoo PVR Client: Hello failed. 18:37:26 517.555969 T:1545597856 ERROR: AddOnLog: Zattoo PVR Client: Re-init of session. Failed. 18:37:26 517.556152 T:1545597856 ERROR: CDVDInputStreamPVRManager::Open - error opening [] 18:37:26 517.556213 T:1545597856 ERROR: CVideoPlayer::OpenInputStream - error opening [pvr://channels/tv/All channels/pvr.zattoo_4245367.pvr] 18:37:26 517.556213 T:1545597856 NOTICE: CVideoPlayer::OnExit() 18:37:26 517.629456 T:1961263104 ERROR: PlayMedia could not play media: pvr://channels/tv/All channels/pvr.zattoo_4245367.pvr 18:37:26 517.632324 T:1961263104 NOTICE: CVideoPlayer::CloseFile() 18:37:26 517.632446 T:1961263104 NOTICE: VideoPlayer: waiting for threads to exit 18:37:26 517.632507 T:1961263104 NOTICE: VideoPlayer: finished waiting 18:37:26 517.632690 T:1961263104 NOTICE: CVideoPlayer::CloseFile() 18:37:26 517.632751 T:1961263104 NOTICE: VideoPlayer: waiting for threads to exit 18:37:26 517.632751 T:1961263104 NOTICE: VideoPlayer: finished waiting 18:37:31 522.793884 T:1961263104 NOTICE: VideoPlayer: Opening: pvr://channels/tv/All channels/pvr.zattoo_4245367.pvr 18:37:31 522.794128 T:1961263104 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 18:37:31 522.794739 T:1769993120 NOTICE: Creating InputStream 18:37:31 522.946228 T:1769993120 ERROR: CCurlFile::FillBuffer - Failed: HTTP returned error 403 18:37:31 522.946472 T:1769993120 ERROR: CCurlFile::Open failed with code 403 for http://zattoo.com/zapi/watch|acceptencoding=gzip&postdata=Y2lkPXNmLTEmc3RyZWFtX3R5cGU9aGxzJmZvcm1hdD1qc29u 18:37:31 522.946655 T:1769993120 ERROR: Open - failed to open source 18:37:31 523.039001 T:1769993120 ERROR: CCurlFile::FillBuffer - Failed: HTTP returned error 403 18:37:31 523.039124 T:1769993120 ERROR: CCurlFile::Open failed with code 403 for http://zattoo.com/zapi/session/hello|acceptencoding=gzip&postdata=dXVpZD04ODhiNGY1NC1jMTI3LTExZTUtOTkxMi1iYTBiZTA0ODNjMTgmbGFuZz1lbiZmb3JtYXQ9anNvbiZjbGllbnRfYXBwX3Rva2VuPWVlOGZkMmYxYmNjYjNhYTM2ZmJjMjIyYmIyYTczZDhm 18:37:31 523.039307 T:1769993120 ERROR: Open - failed to open source 18:37:31 523.039429 T:1769993120 ERROR: AddOnLog: Zattoo PVR Client: Open URL failed during init. 18:37:31 523.039490 T:1769993120 ERROR: AddOnLog: Zattoo PVR Client: Hello failed. 18:37:31 523.039551 T:1769993120 ERROR: AddOnLog: Zattoo PVR Client: Re-init of session. Failed. 18:37:31 523.039917 T:1769993120 ERROR: CDVDInputStreamPVRManager::Open - error opening [] 18:37:31 523.040100 T:1769993120 ERROR: CVideoPlayer::OpenInputStream - error opening [pvr://channels/tv/All channels/pvr.zattoo_4245367.pvr] 18:37:31 523.040161 T:1769993120 NOTICE: CVideoPlayer::OnExit() 18:37:31 523.112671 T:1961263104 NOTICE: CVideoPlayer::CloseFile() 18:37:31 523.112854 T:1961263104 NOTICE: VideoPlayer: waiting for threads to exit 18:37:31 523.112915 T:1961263104 NOTICE: VideoPlayer: finished waiting 18:37:31 523.113159 T:1961263104 NOTICE: CVideoPlayer::CloseFile() 18:37:31 523.113281 T:1961263104 NOTICE: VideoPlayer: waiting for threads to exit 18:37:31 523.113342 T:1961263104 NOTICE: VideoPlayer: finished waiting 18:38:16 567.522888 T:1961263104 NOTICE: Log level changed to "LOG_LEVEL_DEBUG_FREEMEM" 18:38:16 567.523132 T:1961263104 NOTICE: Enabled debug logging due to GUI setting. Level 2. 18:38:16 567.524597 T:1961263104 DEBUG: ------ Window Init () ------ 18:38:16 567.634460 T:1803547552 DEBUG: PushCecKeypress - received key b duration 123 (rep:0 size:0) 18:38:16 567.634644 T:1803547552 DEBUG: PushCecKeypress - ignored key b 18:38:18 570.059204 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 18:38:18 570.059326 T:1803547552 DEBUG: PushCecKeypress - added key a7 18:38:18 570.072693 T:1961263104 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 18:38:18 570.180908 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 121 (rep:0 size:0) 18:38:18 570.181091 T:1803547552 DEBUG: PushCecKeypress - ignored key a7 18:38:19 570.659363 T:1803547552 DEBUG: PushCecKeypress - received key b duration 0 (rep:0 size:0) 18:38:19 570.659546 T:1803547552 DEBUG: PushCecKeypress - added key b 18:38:19 570.672852 T:1961263104 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 18:38:19 570.781372 T:1803547552 DEBUG: PushCecKeypress - received key b duration 122 (rep:0 size:0) 18:38:19 570.781555 T:1803547552 DEBUG: PushCecKeypress - ignored key b 18:38:20 571.867493 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 18:38:20 571.867676 T:1803547552 DEBUG: PushCecKeypress - added key a7 18:38:20 571.889404 T:1961263104 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 18:38:20 571.988831 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 121 (rep:0 size:0) 18:38:20 571.989075 T:1803547552 DEBUG: PushCecKeypress - ignored key a7 18:38:21 572.545288 T:1803547552 DEBUG: PushCecKeypress - received key b duration 0 (rep:0 size:0) 18:38:21 572.545471 T:1803547552 DEBUG: PushCecKeypress - added key b 18:38:21 572.572815 T:1961263104 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 18:38:21 572.574036 T:1961263104 DEBUG: ------ Window Init (DialogSelect.xml) ------ 18:38:21 572.574280 T:1961263104 INFO: Loading skin file: DialogSelect.xml, load type: KEEP_IN_MEMORY 18:38:21 572.666992 T:1803547552 DEBUG: PushCecKeypress - received key b duration 122 (rep:0 size:0) 18:38:21 572.667175 T:1803547552 DEBUG: PushCecKeypress - ignored key b 18:38:27 578.855591 T:1803547552 DEBUG: PushCecKeypress - received key a6 duration 0 (rep:0 size:0) 18:38:27 578.855835 T:1803547552 DEBUG: PushCecKeypress - added key a6 18:38:27 578.872742 T:1961263104 DEBUG: OnKey: 166 (0xa6, obc89) pressed, action is Up 18:38:27 578.976624 T:1803547552 DEBUG: PushCecKeypress - received key a6 duration 121 (rep:0 size:0) 18:38:27 578.976807 T:1803547552 DEBUG: PushCecKeypress - ignored key a6 18:38:32 584.379517 T:1803547552 DEBUG: PushCecKeypress - received key d8 duration 0 (rep:0 size:0) 18:38:32 584.379639 T:1803547552 DEBUG: PushCecKeypress - added key d8 18:38:32 584.389282 T:1961263104 DEBUG: OnKey: menu (0xd8) pressed, action is Back 18:38:32 584.501221 T:1803547552 DEBUG: PushCecKeypress - received key d8 duration 122 (rep:0 size:0) 18:38:32 584.501343 T:1803547552 DEBUG: PushCecKeypress - ignored key d8 18:38:33 584.664307 T:1961263104 DEBUG: ------ Window Deinit (DialogSelect.xml) ------ 18:38:45 597.310181 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 18:38:45 597.310425 T:1803547552 DEBUG: PushCecKeypress - added key a7 18:38:45 597.322754 T:1961263104 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 18:38:46 597.610840 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 18:38:46 597.610962 T:1803547552 DEBUG: PushCecKeypress - added key a7 18:38:46 597.622803 T:1961263104 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 18:38:46 597.791382 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 482 (rep:0 size:0) 18:38:46 597.791565 T:1803547552 DEBUG: PushCecKeypress - ignored key a7 18:38:48 600.272583 T:1803547552 DEBUG: PushCecKeypress - received key d8 duration 0 (rep:0 size:0) 18:38:48 600.272766 T:1803547552 DEBUG: PushCecKeypress - added key d8 18:38:48 600.273438 T:1961263104 DEBUG: OnKey: menu (0xd8) pressed, action is PreviousMenu 18:38:48 600.340393 T:1961263104 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 18:38:48 600.393494 T:1803547552 DEBUG: PushCecKeypress - received key d8 duration 121 (rep:0 size:0) 18:38:48 600.393677 T:1803547552 DEBUG: PushCecKeypress - ignored key d8 18:38:49 600.593750 T:1961263104 DEBUG: ------ Window Deinit (SettingsCategory.xml) ------ 18:38:49 600.606018 T:1961263104 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 18:38:49 600.606140 T:1961263104 DEBUG: ------ Window Init (Settings.xml) ------ 18:38:52 604.168823 T:1803547552 DEBUG: PushCecKeypress - received key a6 duration 0 (rep:0 size:0) 18:38:52 604.169006 T:1803547552 DEBUG: PushCecKeypress - added key a6 18:38:52 604.206909 T:1961263104 DEBUG: OnKey: 166 (0xa6, obc89) pressed, action is Up 18:38:52 604.290649 T:1803547552 DEBUG: PushCecKeypress - received key a6 duration 122 (rep:0 size:0) 18:38:52 604.290833 T:1803547552 DEBUG: PushCecKeypress - ignored key a6 18:38:53 604.991882 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 18:38:53 604.992065 T:1803547552 DEBUG: PushCecKeypress - added key a7 18:38:53 605.027222 T:1961263104 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 18:38:53 605.113464 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 122 (rep:0 size:0) 18:38:53 605.113647 T:1803547552 DEBUG: PushCecKeypress - ignored key a7 18:38:54 605.574036 T:1803547552 DEBUG: PushCecKeypress - received key a9 duration 0 (rep:0 size:0) 18:38:54 605.574219 T:1803547552 DEBUG: PushCecKeypress - added key a9 18:38:54 605.586853 T:1961263104 DEBUG: OnKey: 169 (0xa9, obc86) pressed, action is Left 18:38:54 605.723450 T:1803547552 DEBUG: PushCecKeypress - received key a9 duration 150 (rep:0 size:0) 18:38:54 605.723572 T:1803547552 DEBUG: PushCecKeypress - ignored key a9 18:38:55 606.756287 T:1803547552 DEBUG: PushCecKeypress - received key a9 duration 0 (rep:0 size:0) 18:38:55 606.756409 T:1803547552 DEBUG: PushCecKeypress - added key a9 18:38:55 606.799316 T:1961263104 DEBUG: OnKey: 169 (0xa9, obc86) pressed, action is Left 18:38:55 606.878296 T:1803547552 DEBUG: PushCecKeypress - received key a9 duration 122 (rep:0 size:0) 18:38:55 606.878479 T:1803547552 DEBUG: PushCecKeypress - ignored key a9 18:38:55 607.058472 T:1803547552 DEBUG: PushCecKeypress - received key a6 duration 0 (rep:0 size:0) 18:38:55 607.058655 T:1803547552 DEBUG: PushCecKeypress - added key a6 18:38:55 607.072815 T:1961263104 DEBUG: OnKey: 166 (0xa6, obc89) pressed, action is Up 18:38:55 607.180542 T:1803547552 DEBUG: PushCecKeypress - received key a6 duration 122 (rep:0 size:0) 18:38:55 607.180725 T:1803547552 DEBUG: PushCecKeypress - ignored key a6 18:38:56 607.602112 T:1803547552 DEBUG: PushCecKeypress - received key b duration 0 (rep:0 size:0) 18:38:56 607.602295 T:1803547552 DEBUG: PushCecKeypress - added key b 18:38:56 607.636780 T:1961263104 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 18:38:56 607.637024 T:1961263104 DEBUG: Activating window ID: 10031 18:38:56 607.723511 T:1803547552 DEBUG: PushCecKeypress - received key b duration 121 (rep:0 size:0) 18:38:56 607.723755 T:1803547552 DEBUG: PushCecKeypress - ignored key b 18:38:56 607.946228 T:1961263104 DEBUG: ------ Window Deinit (Settings.xml) ------ 18:38:56 607.955994 T:1961263104 DEBUG: ------ Window Init (SettingsCategory.xml) ------ 18:38:58 609.658997 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 18:38:58 609.659180 T:1803547552 DEBUG: PushCecKeypress - added key a7 18:38:58 609.668701 T:1961263104 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 18:38:58 609.959229 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 18:38:58 609.959412 T:1803547552 DEBUG: PushCecKeypress - added key a7 18:38:58 609.972839 T:1961263104 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 18:38:58 610.028198 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 369 (rep:0 size:0) 18:38:58 610.028381 T:1803547552 DEBUG: PushCecKeypress - ignored key a7 18:38:59 611.398132 T:1803547552 DEBUG: PushCecKeypress - received key a8 duration 0 (rep:0 size:0) 18:38:59 611.398254 T:1803547552 DEBUG: PushCecKeypress - added key a8 18:38:59 611.408081 T:1961263104 DEBUG: OnKey: 168 (0xa8, obc87) pressed, action is Right 18:39:00 611.519897 T:1803547552 DEBUG: PushCecKeypress - received key a8 duration 122 (rep:0 size:0) 18:39:00 611.520142 T:1803547552 DEBUG: PushCecKeypress - ignored key a8 18:39:00 612.489380 T:1803547552 DEBUG: PushCecKeypress - received key d3 duration 0 (rep:0 size:0) 18:39:00 612.489563 T:1803547552 DEBUG: PushCecKeypress - added key d3 18:39:01 612.522766 T:1961263104 DEBUG: OnKey: rightshift (0xd3) pressed, action is PageDown 18:39:01 612.610352 T:1803547552 DEBUG: PushCecKeypress - received key d3 duration 121 (rep:0 size:0) 18:39:01 612.610535 T:1803547552 DEBUG: PushCecKeypress - ignored key d3 18:39:01 613.202515 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 18:39:01 613.202637 T:1803547552 DEBUG: PushCecKeypress - added key a7 18:39:01 613.206116 T:1961263104 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 18:39:01 613.502686 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 18:39:01 613.502808 T:1803547552 DEBUG: PushCecKeypress - added key a7 18:39:01 613.505981 T:1961263104 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 18:39:02 613.802979 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 18:39:02 613.803162 T:1803547552 DEBUG: PushCecKeypress - added key a7 18:39:02 613.806091 T:1961263104 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 18:39:02 613.954224 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 752 (rep:0 size:0) 18:39:02 613.954407 T:1803547552 DEBUG: PushCecKeypress - ignored key a7 18:39:12 623.637451 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 18:39:12 623.637634 T:1803547552 DEBUG: PushCecKeypress - added key a7 18:39:12 623.656067 T:1961263104 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 18:39:12 623.937256 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 18:39:12 623.937439 T:1803547552 DEBUG: PushCecKeypress - added key a7 18:39:12 623.939392 T:1961263104 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 18:39:12 624.237427 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 18:39:12 624.237610 T:1803547552 DEBUG: PushCecKeypress - added key a7 18:39:12 624.239441 T:1961263104 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 18:39:13 624.537354 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 18:39:13 624.537537 T:1803547552 DEBUG: PushCecKeypress - added key a7 18:39:13 624.556396 T:1961263104 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 18:39:13 624.837158 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 18:39:13 624.837280 T:1803547552 DEBUG: PushCecKeypress - added key a7 18:39:13 624.839294 T:1961263104 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 18:39:13 625.137146 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 18:39:13 625.137268 T:1803547552 DEBUG: PushCecKeypress - added key a7 18:39:13 625.139282 T:1961263104 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 18:39:13 625.437195 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 18:39:13 625.437317 T:1803547552 DEBUG: PushCecKeypress - added key a7 18:39:13 625.439270 T:1961263104 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 18:39:14 625.737061 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 18:39:14 625.737122 T:1803547552 DEBUG: PushCecKeypress - added key a7 18:39:14 625.739319 T:1961263104 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 18:39:14 626.037048 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 18:39:14 626.037170 T:1803547552 DEBUG: PushCecKeypress - added key a7 18:39:14 626.039307 T:1961263104 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 18:39:14 626.105896 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 2468 (rep:0 size:0) 18:39:14 626.106018 T:1803547552 DEBUG: PushCecKeypress - ignored key a7 18:39:15 627.360596 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 18:39:15 627.360718 T:1803547552 DEBUG: PushCecKeypress - added key a7 18:39:15 627.372742 T:1961263104 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 18:39:16 627.660706 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 18:39:16 627.660828 T:1803547552 DEBUG: PushCecKeypress - added key a7 18:39:16 627.689331 T:1961263104 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 18:39:16 627.960876 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 18:39:16 627.961060 T:1803547552 DEBUG: PushCecKeypress - added key a7 18:39:16 627.989319 T:1961263104 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 18:39:16 628.260681 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 18:39:16 628.260864 T:1803547552 DEBUG: PushCecKeypress - added key a7 18:39:16 628.272705 T:1961263104 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 18:39:17 628.560791 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 18:39:17 628.560913 T:1803547552 DEBUG: PushCecKeypress - added key a7 18:39:17 628.572693 T:1961263104 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 18:39:17 628.860718 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 18:39:17 628.860840 T:1803547552 DEBUG: PushCecKeypress - added key a7 18:39:17 628.872864 T:1961263104 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 18:39:17 628.966125 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 1606 (rep:0 size:0) 18:39:17 628.966309 T:1803547552 DEBUG: PushCecKeypress - ignored key a7 18:39:19 630.942017 T:1803547552 DEBUG: PushCecKeypress - received key a9 duration 0 (rep:0 size:0) 18:39:19 630.942139 T:1803547552 DEBUG: PushCecKeypress - added key a9 18:39:19 630.955994 T:1961263104 DEBUG: OnKey: 169 (0xa9, obc86) pressed, action is Left 18:39:19 631.063354 T:1803547552 DEBUG: PushCecKeypress - received key a9 duration 121 (rep:0 size:0) 18:39:19 631.063416 T:1803547552 DEBUG: PushCecKeypress - ignored key a9 18:39:19 631.326904 T:1803547552 DEBUG: PushCecKeypress - received key a6 duration 0 (rep:0 size:0) 18:39:19 631.327026 T:1803547552 DEBUG: PushCecKeypress - added key a6 18:39:19 631.350098 T:1961263104 DEBUG: OnKey: 166 (0xa6, obc89) pressed, action is Up 18:39:19 631.449097 T:1803547552 DEBUG: PushCecKeypress - received key a6 duration 123 (rep:0 size:0) 18:39:19 631.449280 T:1803547552 DEBUG: PushCecKeypress - ignored key a6 18:39:21 632.813171 T:1803547552 DEBUG: PushCecKeypress - received key a6 duration 0 (rep:0 size:0) 18:39:21 632.813416 T:1803547552 DEBUG: PushCecKeypress - added key a6 18:39:21 632.850098 T:1961263104 DEBUG: OnKey: 166 (0xa6, obc89) pressed, action is Up 18:39:21 632.934814 T:1803547552 DEBUG: PushCecKeypress - received key a6 duration 121 (rep:0 size:0) 18:39:21 632.934998 T:1803547552 DEBUG: PushCecKeypress - ignored key a6 18:39:23 635.273132 T:1803547552 DEBUG: PushCecKeypress - received key a8 duration 0 (rep:0 size:0) 18:39:23 635.273315 T:1803547552 DEBUG: PushCecKeypress - added key a8 18:39:23 635.282410 T:1961263104 DEBUG: OnKey: 168 (0xa8, obc87) pressed, action is Right 18:39:23 635.422729 T:1803547552 DEBUG: PushCecKeypress - received key a8 duration 150 (rep:0 size:0) 18:39:23 635.422913 T:1803547552 DEBUG: PushCecKeypress - ignored key a8 18:39:24 635.919128 T:1803547552 DEBUG: PushCecKeypress - received key a6 duration 0 (rep:0 size:0) 18:39:24 635.919250 T:1803547552 DEBUG: PushCecKeypress - added key a6 18:39:24 635.922668 T:1961263104 DEBUG: OnKey: 166 (0xa6, obc89) pressed, action is Up 18:39:24 636.068726 T:1803547552 DEBUG: PushCecKeypress - received key a6 duration 149 (rep:0 size:0) 18:39:24 636.068909 T:1803547552 DEBUG: PushCecKeypress - ignored key a6 18:39:57 668.841797 T:1649402784 DEBUG: CPVRTimers - Update - updating timers 18:39:57 668.842529 T:1649402784 DEBUG: CFileCache::Open - opening using cache 18:39:57 668.843140 T:1649402784 DEBUG: CurlFile::Open(0x43e3ee8) http://zattoo.com/zapi/playlist 18:39:57 668.844055 T:1649402784 INFO: easy_aquire - Created session to http://zattoo.com 18:39:57 668.972656 T:1649402784 ERROR: CCurlFile::FillBuffer - Failed: HTTP returned error 403 18:39:57 668.972839 T:1649402784 ERROR: CCurlFile::Open failed with code 403 for http://zattoo.com/zapi/playlist|acceptencoding=gzip 18:39:57 668.973083 T:1649402784 ERROR: Open - failed to open source 18:39:57 668.973267 T:1649402784 DEBUG: AddOnLog: Zattoo PVR Client: Open URL failed. Try to re-init session. 18:39:57 668.973938 T:1649402784 DEBUG: CFileCache::Open - opening using cache 18:39:57 668.974609 T:1649402784 DEBUG: CurlFile::Open(0x43e3ee8) http://zattoo.com/zapi/v2/session 18:39:57 669.013550 T:1526723488 DEBUG: Thread FileCache start, auto delete: false 18:39:57 669.014038 T:1526723488 INFO: CFileCache::Process - Source read didn't return any data! Hit eof(?) 18:39:57 669.064209 T:1526723488 DEBUG: Thread FileCache 1526723488 terminating 18:39:57 669.065063 T:1649402784 DEBUG: AddOnLog: Zattoo PVR Client: Need to login. 18:39:57 669.065247 T:1649402784 DEBUG: AddOnLog: Zattoo PVR Client: Send hello. 18:39:57 669.066162 T:1649402784 DEBUG: CFileCache::Open - opening using cache 18:39:57 669.067017 T:1649402784 DEBUG: CurlFile::Open(0x43e3ee8) http://zattoo.com/zapi/session/hello 18:39:57 669.083984 T:1649402784 ERROR: CCurlFile::FillBuffer - Failed: HTTP returned error 403 18:39:57 669.084229 T:1649402784 ERROR: CCurlFile::Open failed with code 403 for http://zattoo.com/zapi/session/hello|acceptencoding=gzip&postdata=dXVpZD04ODhiNGY1NC1jMTI3LTExZTUtOTkxMi1iYTBiZTA0ODNjMTgmbGFuZz1lbiZmb3JtYXQ9anNvbiZjbGllbnRfYXBwX3Rva2VuPWVlOGZkMmYxYmNjYjNhYTM2ZmJjMjIyYmIyYTczZDhm 18:39:57 669.084412 T:1649402784 ERROR: Open - failed to open source 18:39:57 669.084534 T:1649402784 ERROR: AddOnLog: Zattoo PVR Client: Open URL failed during init. 18:39:57 669.084656 T:1649402784 ERROR: AddOnLog: Zattoo PVR Client: Hello failed. 18:39:57 669.084717 T:1649402784 ERROR: AddOnLog: Zattoo PVR Client: Re-init of session. Failed. 18:39:57 669.084778 T:1649402784 DEBUG: PVRTimers - UpdateEntries - deleted timer 67531836 on client 15870792 18:39:57 669.085022 T:1649402784 DEBUG: PVRTimers - UpdateEntries - deleted timer 67531779 on client 15870792 18:39:57 669.085144 T:1649402784 DEBUG: PVRTimers - UpdateEntries - deleted timer 67531837 on client 15870792 18:39:57 669.106079 T:1961263104 DEBUG: ------ Window Init (DialogNotification.xml) ------ 18:40:05 676.833618 T:1961263104 DEBUG: ------ Window Deinit (DialogNotification.xml) ------ 18:40:11 682.999573 T:1803547552 DEBUG: PushCecKeypress - received key d8 duration 0 (rep:0 size:0) 18:40:11 682.999939 T:1803547552 DEBUG: PushCecKeypress - added key d8 18:40:11 683.006104 T:1961263104 DEBUG: OnKey: menu (0xd8) pressed, action is PreviousMenu 18:40:11 683.029236 T:1961263104 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 18:40:11 683.119446 T:1803547552 DEBUG: PushCecKeypress - received key d8 duration 122 (rep:0 size:0) 18:40:11 683.119629 T:1803547552 DEBUG: PushCecKeypress - ignored key d8 18:40:11 683.310791 T:1961263104 DEBUG: ------ Window Deinit (SettingsCategory.xml) ------ 18:40:11 683.322815 T:1961263104 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 18:40:11 683.322998 T:1961263104 DEBUG: ------ Window Init (Settings.xml) ------ 18:40:14 686.497559 T:1803547552 DEBUG: PushCecKeypress - received key a9 duration 0 (rep:0 size:0) 18:40:14 686.497681 T:1803547552 DEBUG: PushCecKeypress - added key a9 18:40:15 686.512878 T:1961263104 DEBUG: OnKey: 169 (0xa9, obc86) pressed, action is Left 18:40:15 686.619446 T:1803547552 DEBUG: PushCecKeypress - received key a9 duration 122 (rep:0 size:0) 18:40:15 686.619629 T:1803547552 DEBUG: PushCecKeypress - ignored key a9 18:40:15 686.928772 T:1803547552 DEBUG: PushCecKeypress - received key b duration 0 (rep:0 size:0) 18:40:15 686.928955 T:1803547552 DEBUG: PushCecKeypress - added key b 18:40:15 686.951294 T:1961263104 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 18:40:15 686.951599 T:1961263104 DEBUG: Activating window ID: 10030 18:40:15 687.050781 T:1803547552 DEBUG: PushCecKeypress - received key b duration 122 (rep:0 size:0) 18:40:15 687.051147 T:1803547552 DEBUG: PushCecKeypress - ignored key b 18:40:15 687.263245 T:1961263104 DEBUG: ------ Window Deinit (Settings.xml) ------ 18:40:15 687.272583 T:1961263104 DEBUG: ------ Window Init (SettingsCategory.xml) ------ 18:40:17 688.526794 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 18:40:17 688.527039 T:1803547552 DEBUG: PushCecKeypress - added key a7 18:40:17 688.529297 T:1961263104 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 18:40:17 688.826843 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 18:40:17 688.827026 T:1803547552 DEBUG: PushCecKeypress - added key a7 18:40:17 688.865723 T:1961263104 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 18:40:17 688.917786 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 391 (rep:0 size:0) 18:40:17 688.917969 T:1803547552 DEBUG: PushCecKeypress - ignored key a7 18:40:17 689.389587 T:1803547552 DEBUG: PushCecKeypress - received key a6 duration 0 (rep:0 size:0) 18:40:17 689.389709 T:1803547552 DEBUG: PushCecKeypress - added key a6 18:40:17 689.391418 T:1961263104 DEBUG: OnKey: 166 (0xa6, obc89) pressed, action is Up 18:40:17 689.510986 T:1803547552 DEBUG: PushCecKeypress - received key a6 duration 121 (rep:0 size:0) 18:40:17 689.511169 T:1803547552 DEBUG: PushCecKeypress - ignored key a6 18:40:18 689.677673 T:1803547552 DEBUG: PushCecKeypress - received key a6 duration 0 (rep:0 size:0) 18:40:18 689.677795 T:1803547552 DEBUG: PushCecKeypress - added key a6 18:40:18 689.694397 T:1961263104 DEBUG: OnKey: 166 (0xa6, obc89) pressed, action is Up 18:40:18 689.799072 T:1803547552 DEBUG: PushCecKeypress - received key a6 duration 122 (rep:0 size:0) 18:40:18 689.799255 T:1803547552 DEBUG: PushCecKeypress - ignored key a6 18:40:18 690.223022 T:1803547552 DEBUG: PushCecKeypress - received key a8 duration 0 (rep:0 size:0) 18:40:18 690.223206 T:1803547552 DEBUG: PushCecKeypress - added key a8 18:40:18 690.256104 T:1961263104 DEBUG: OnKey: 168 (0xa8, obc87) pressed, action is Right 18:40:18 690.344727 T:1803547552 DEBUG: PushCecKeypress - received key a8 duration 122 (rep:0 size:0) 18:40:18 690.344910 T:1803547552 DEBUG: PushCecKeypress - ignored key a8 18:40:19 691.261108 T:1803547552 DEBUG: PushCecKeypress - received key d3 duration 0 (rep:0 size:0) 18:40:19 691.261292 T:1803547552 DEBUG: PushCecKeypress - added key d3 18:40:19 691.272766 T:1961263104 DEBUG: OnKey: rightshift (0xd3) pressed, action is PageDown 18:40:19 691.382202 T:1803547552 DEBUG: PushCecKeypress - received key d3 duration 122 (rep:0 size:0) 18:40:19 691.382385 T:1803547552 DEBUG: PushCecKeypress - ignored key d3 18:40:20 691.955200 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 18:40:20 691.955322 T:1803547552 DEBUG: PushCecKeypress - added key a7 18:40:20 691.955933 T:1961263104 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 18:40:20 692.255310 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 18:40:20 692.255493 T:1803547552 DEBUG: PushCecKeypress - added key a7 18:40:20 692.255981 T:1961263104 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 18:40:21 692.555725 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 18:40:21 692.555969 T:1803547552 DEBUG: PushCecKeypress - added key a7 18:40:21 692.572754 T:1961263104 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 18:40:21 692.855591 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 18:40:21 692.855774 T:1803547552 DEBUG: PushCecKeypress - added key a7 18:40:21 692.856567 T:1961263104 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 18:40:21 693.155518 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 18:40:21 693.155640 T:1803547552 DEBUG: PushCecKeypress - added key a7 18:40:21 693.155945 T:1961263104 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 18:40:21 693.455383 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 18:40:21 693.455505 T:1803547552 DEBUG: PushCecKeypress - added key a7 18:40:21 693.455994 T:1961263104 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 18:40:22 693.755737 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 18:40:22 693.756042 T:1803547552 DEBUG: PushCecKeypress - added key a7 18:40:22 693.756653 T:1961263104 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 18:40:22 694.055420 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 18:40:22 694.055481 T:1803547552 DEBUG: PushCecKeypress - added key a7 18:40:22 694.055969 T:1961263104 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 18:40:22 694.355347 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 18:40:22 694.355469 T:1803547552 DEBUG: PushCecKeypress - added key a7 18:40:22 694.355957 T:1961263104 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 18:40:22 694.424255 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 2469 (rep:0 size:0) 18:40:22 694.424316 T:1803547552 DEBUG: PushCecKeypress - ignored key a7 18:40:24 695.517395 T:1803547552 DEBUG: PushCecKeypress - received key d8 duration 0 (rep:0 size:0) 18:40:24 695.517517 T:1803547552 DEBUG: PushCecKeypress - added key d8 18:40:24 695.522644 T:1961263104 DEBUG: OnKey: menu (0xd8) pressed, action is PreviousMenu 18:40:24 695.535400 T:1961263104 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 18:40:24 695.666931 T:1803547552 DEBUG: PushCecKeypress - received key d8 duration 149 (rep:0 size:0) 18:40:24 695.667053 T:1803547552 DEBUG: PushCecKeypress - ignored key d8 18:40:24 695.845886 T:1961263104 DEBUG: ------ Window Deinit (SettingsCategory.xml) ------ 18:40:24 695.856384 T:1961263104 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 18:40:24 695.856506 T:1961263104 DEBUG: ------ Window Init (Settings.xml) ------ 18:40:25 696.706726 T:1803547552 DEBUG: PushCecKeypress - received key d8 duration 0 (rep:0 size:0) 18:40:25 696.706848 T:1803547552 DEBUG: PushCecKeypress - added key d8 18:40:25 696.730408 T:1961263104 DEBUG: OnKey: menu (0xd8) pressed, action is PreviousMenu 18:40:25 696.730530 T:1961263104 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 18:40:25 696.828491 T:1803547552 DEBUG: PushCecKeypress - received key d8 duration 122 (rep:0 size:0) 18:40:25 696.828674 T:1803547552 DEBUG: PushCecKeypress - ignored key d8 18:40:25 697.065186 T:1961263104 DEBUG: ------ Window Deinit (Settings.xml) ------ 18:40:25 697.072571 T:1961263104 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 18:40:25 697.072693 T:1961263104 DEBUG: ------ Window Init (Home.xml) ------ 18:40:25 697.104675 T:1961263104 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x4078c20 18:40:25 697.105713 T:1961263104 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(201536), nBufferAlignmen(16) 18:40:25 697.109863 T:1961263104 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.resize input port 60 output port 61 m_handle 0x42ef2f0 18:40:25 697.111572 T:1961263104 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x43363a0 18:40:25 697.112488 T:1961263104 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 18:40:25 697.227722 T:1961263104 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x4078c20 18:40:25 697.229126 T:1961263104 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.resize handle 0x42ef2f0 18:40:25 697.230896 T:1961263104 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x43363a0 18:40:25 697.231201 T:1961263104 DEBUG: DecodeJpegToTexture: decoded special://skin/extras/home-images/movie.jpg 927x540 18:40:27 698.589722 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 18:40:27 698.589905 T:1803547552 DEBUG: PushCecKeypress - added key a7 18:40:27 698.594604 T:1961263104 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 18:40:27 698.889771 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 18:40:27 698.889954 T:1803547552 DEBUG: PushCecKeypress - added key a7 18:40:27 698.904785 T:1961263104 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 18:40:27 699.189636 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 18:40:27 699.189697 T:1803547552 DEBUG: PushCecKeypress - added key a7 18:40:27 699.206055 T:1961263104 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 18:40:27 699.372620 T:1961263104 INFO: CheckIdle - Closing session to http://zattoo.com (easy=0x53aaaa8, multi=0x3f763b0) 18:40:27 699.489685 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 18:40:27 699.489807 T:1803547552 DEBUG: PushCecKeypress - added key a7 18:40:27 699.490112 T:1961263104 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 18:40:28 699.789856 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 18:40:28 699.789978 T:1803547552 DEBUG: PushCecKeypress - added key a7 18:40:28 699.805969 T:1961263104 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 18:40:28 699.858826 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 1269 (rep:0 size:0) 18:40:28 699.859009 T:1803547552 DEBUG: PushCecKeypress - ignored key a7 18:40:29 700.927795 T:1803547552 DEBUG: PushCecKeypress - received key a8 duration 0 (rep:0 size:0) 18:40:29 700.927917 T:1803547552 DEBUG: PushCecKeypress - added key a8 18:40:29 700.950378 T:1961263104 DEBUG: OnKey: 168 (0xa8, obc87) pressed, action is Right 18:40:29 701.050354 T:1803547552 DEBUG: PushCecKeypress - received key a8 duration 123 (rep:0 size:0) 18:40:29 701.050537 T:1803547552 DEBUG: PushCecKeypress - ignored key a8 18:40:30 702.115967 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 18:40:30 702.116089 T:1803547552 DEBUG: PushCecKeypress - added key a7 18:40:30 702.122620 T:1961263104 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 18:40:30 702.237305 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 122 (rep:0 size:0) 18:40:30 702.237488 T:1803547552 DEBUG: PushCecKeypress - ignored key a7 18:40:31 703.072083 T:1803547552 DEBUG: PushCecKeypress - received key b duration 0 (rep:0 size:0) 18:40:31 703.072266 T:1803547552 DEBUG: PushCecKeypress - added key b 18:40:31 703.089600 T:1961263104 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 18:40:31 703.111816 T:1961263104 DEBUG: Loading settings for pvr://channels/tv/All channels/pvr.zattoo_4245367.pvr 18:40:31 703.124084 T:1961263104 DEBUG: Radio UECP (RDS) Processor - new CDVDRadioRDSData 18:40:31 703.124451 T:1961263104 NOTICE: VideoPlayer: Opening: pvr://channels/tv/All channels/pvr.zattoo_4245367.pvr 18:40:31 703.124512 T:1961263104 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 18:40:31 703.124695 T:1961263104 DEBUG: CMMALRenderer::CMMALRenderer 18:40:31 703.124939 T:1961263104 DEBUG: CMMALRenderer::UnInitMMAL 18:40:31 703.125000 T:1526723488 DEBUG: Thread MMALProcess start, auto delete: false 18:40:31 703.125122 T:1961263104 DEBUG: CMMALRenderer::PreInit 18:40:31 703.125183 T:1526723488 DEBUG: CMMALRenderer::Run - starting 18:40:31 703.125305 T:1535112096 DEBUG: Thread VideoPlayer start, auto delete: false 18:40:31 703.125610 T:1535112096 NOTICE: Creating InputStream 18:40:31 703.126892 T:1535112096 DEBUG: PVRManager - OpenLiveStream - opening live stream on channel 'SRF 1 HD' 18:40:31 703.127014 T:1535112096 DEBUG: opening live stream on url 'pvr://stream/tv/zattoo.ts' 18:40:31 703.194702 T:1803547552 DEBUG: PushCecKeypress - received key b duration 123 (rep:0 size:0) 18:40:31 703.194824 T:1803547552 DEBUG: PushCecKeypress - ignored key b 18:40:31 703.233215 T:1535112096 DEBUG: CDVDInputStreamPVRManager - Open - playback has started on filename pvr://channels/tv/All channels/pvr.zattoo_4245367.pvr 18:40:31 703.234192 T:1535112096 DEBUG: CFileCache::Open - opening using cache 18:40:31 703.234863 T:1535112096 DEBUG: CurlFile::Open(0x73b01c00) http://zattoo.com/zapi/watch 18:40:31 703.235413 T:1535112096 INFO: easy_aquire - Created session to http://zattoo.com 18:40:31 703.363098 T:1535112096 ERROR: CCurlFile::FillBuffer - Failed: HTTP returned error 403 18:40:31 703.363342 T:1535112096 ERROR: CCurlFile::Open failed with code 403 for http://zattoo.com/zapi/watch|acceptencoding=gzip&postdata=Y2lkPXNmLTEmc3RyZWFtX3R5cGU9aGxzJmZvcm1hdD1qc29u 18:40:31 703.363464 T:1535112096 ERROR: Open - failed to open source 18:40:31 703.363586 T:1535112096 DEBUG: AddOnLog: Zattoo PVR Client: Open URL failed. Try to re-init session. 18:40:31 703.364136 T:1535112096 DEBUG: CFileCache::Open - opening using cache 18:40:31 703.364685 T:1535112096 DEBUG: CurlFile::Open(0x73b33280) http://zattoo.com/zapi/v2/session 18:40:31 703.392212 T:1586484128 DEBUG: Thread FileCache start, auto delete: false 18:40:31 703.392639 T:1586484128 INFO: CFileCache::Process - Source read didn't return any data! Hit eof(?) 18:40:31 703.442627 T:1586484128 DEBUG: Thread FileCache 1586484128 terminating 18:40:31 703.443237 T:1535112096 DEBUG: AddOnLog: Zattoo PVR Client: Need to login. 18:40:31 703.443298 T:1535112096 DEBUG: AddOnLog: Zattoo PVR Client: Send hello. 18:40:31 703.444031 T:1535112096 DEBUG: CFileCache::Open - opening using cache 18:40:31 703.444763 T:1535112096 DEBUG: CurlFile::Open(0x73b32f40) http://zattoo.com/zapi/session/hello 18:40:31 703.459106 T:1535112096 ERROR: CCurlFile::FillBuffer - Failed: HTTP returned error 403 18:40:31 703.459290 T:1535112096 ERROR: CCurlFile::Open failed with code 403 for http://zattoo.com/zapi/session/hello|acceptencoding=gzip&postdata=dXVpZD04ODhiNGY1NC1jMTI3LTExZTUtOTkxMi1iYTBiZTA0ODNjMTgmbGFuZz1lbiZmb3JtYXQ9anNvbiZjbGllbnRfYXBwX3Rva2VuPWVlOGZkMmYxYmNjYjNhYTM2ZmJjMjIyYmIyYTczZDhm 18:40:31 703.459473 T:1535112096 ERROR: Open - failed to open source 18:40:31 703.459595 T:1535112096 ERROR: AddOnLog: Zattoo PVR Client: Open URL failed during init. 18:40:31 703.459656 T:1535112096 ERROR: AddOnLog: Zattoo PVR Client: Hello failed. 18:40:31 703.459717 T:1535112096 ERROR: AddOnLog: Zattoo PVR Client: Re-init of session. Failed. 18:40:31 703.460144 T:1535112096 ERROR: CDVDInputStreamPVRManager::Open - error opening [] 18:40:31 703.460205 T:1535112096 ERROR: CVideoPlayer::OpenInputStream - error opening [pvr://channels/tv/All channels/pvr.zattoo_4245367.pvr] 18:40:31 703.460327 T:1535112096 NOTICE: CVideoPlayer::OnExit() 18:40:31 703.509949 T:1586484128 DEBUG: Thread JobWorker start, auto delete: true 18:40:31 703.510132 T:1535112096 DEBUG: CDVDInputStreamPVRManager::Close - stream closed 18:40:31 703.510376 T:1535112096 DEBUG: OnPlayBackStopped: play state was 1, starting 1 18:40:31 703.510559 T:1535112096 DEBUG: Thread VideoPlayer 1535112096 terminating 18:40:31 703.510681 T:1961263104 DEBUG: OnPlayBackStopped: play state was 3, starting 0 18:40:31 703.510864 T:1961263104 ERROR: PlayMedia could not play media: pvr://channels/tv/All channels/pvr.zattoo_4245367.pvr 18:40:31 703.510925 T:1961255840 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc 18:40:31 703.511108 T:1961255840 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop 18:40:32 703.512451 T:1961263104 DEBUG: CDirectoryProvider[pvr://channels/tv/*?view=lastplayed]: refreshing.. 18:40:32 703.515442 T:1586484128 DEBUG: CPVRDirectory::GetDirectory(pvr://channels/tv/*?view=lastplayed) 18:40:32 703.525391 T:1961263104 NOTICE: CVideoPlayer::CloseFile() 18:40:32 703.525574 T:1961263104 NOTICE: VideoPlayer: waiting for threads to exit 18:40:32 703.525696 T:1961263104 NOTICE: VideoPlayer: finished waiting 18:40:32 703.525818 T:1961263104 DEBUG: DeleteRenderer - deleting renderer 18:40:32 703.525879 T:1961263104 DEBUG: CMMALRenderer::~CMMALRenderer 18:40:32 703.526001 T:1961263104 DEBUG: CMMALRenderer::UnInitMMAL 18:40:32 703.526062 T:1526723488 DEBUG: CMMALRenderer::Run - stopping 18:40:32 703.526184 T:1526723488 DEBUG: Thread MMALProcess 1526723488 terminating 18:40:32 703.526245 T:1961263104 NOTICE: CVideoPlayer::CloseFile() 18:40:32 703.526367 T:1961263104 NOTICE: VideoPlayer: waiting for threads to exit 18:40:32 703.526428 T:1961263104 NOTICE: VideoPlayer: finished waiting 18:40:32 703.531616 T:1961263104 DEBUG: Radio UECP (RDS) Processor - delete ~CDVDRadioRDSData 18:40:33 705.110596 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 18:40:33 705.110779 T:1803547552 DEBUG: PushCecKeypress - added key a7 18:40:33 705.122864 T:1961263104 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 18:40:33 705.232117 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 122 (rep:0 size:0) 18:40:33 705.232300 T:1803547552 DEBUG: PushCecKeypress - ignored key a7 18:40:34 706.025269 T:1803547552 DEBUG: PushCecKeypress - received key b duration 0 (rep:0 size:0) 18:40:34 706.025391 T:1803547552 DEBUG: PushCecKeypress - added key b 18:40:34 706.065186 T:1961263104 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 18:40:34 706.090210 T:1526723488 DEBUG: Thread GUIDialogCache start, auto delete: true 18:40:34 706.090515 T:1961263104 INFO: easy_aquire - Created session to http://zh2-4-hls-pvr.zahs.tv 18:40:34 706.124146 T:1961263104 DEBUG: CCurlFile::GetMimeType - http://zh2-4-hls-pvr.zahs.tv/HD_tsi1/1476009900/1476017100.m3u8?z32=NVQXQ4TBORST2MBGOVZWK4S7NFSD2MRRG43TGMBQG4THK5LJMQ6TQOBYMI2GMNJUFVRTCMRXFUYTCZJVFU4TSMJSFVRGCMDCMUYDIOBTMMYTQJTJNZUXI2LBNRZGC5DFHUYCM43JM46TGNTDMRRTOOLFMU2GKZDGGAZTQNBXGRQWKNBZMM2DONBVGQ2TQNJGNVUW44TBORST2NRQGATGG2DBNZXGK3B5INEF6SDJKFPXI43JGETGG43JMQ6TCNBXIM4DONSDHE2DGMRWIM4TGLJVGAYUMRBTGI4DSNZUIJATQRJU -> application/vnd.apple.mpegurl 18:40:34 706.130737 T:1526723488 DEBUG: Thread GUIDialogCache 1526723488 terminating (autodelete) 18:40:34 706.146545 T:1803547552 DEBUG: PushCecKeypress - received key b duration 121 (rep:0 size:0) 18:40:34 706.146667 T:1803547552 DEBUG: PushCecKeypress - ignored key b 18:40:34 706.147217 T:1961263104 DEBUG: Loading settings for http://zh2-4-hls-pvr.zahs.tv/HD_tsi1/1476009900/1476017100.m3u8?z32=NVQXQ4TBORST2MBGOVZWK4S7NFSD2MRRG43TGMBQG4THK5LJMQ6TQOBYMI2GMNJUFVRTCMRXFUYTCZJVFU4TSMJSFVRGCMDCMUYDIOBTMMYTQJTJNZUXI2LBNRZGC5DFHUYCM43JM46TGNTDMRRTOOLFMU2GKZDGGAZTQNBXGRQWKNBZMM2DONBVGQ2TQNJGNVUW44TBORST2NRQGATGG2DBNZXGK3B5INEF6SDJKFPXI43JGETGG43JMQ6TCNBXIM4DONSDHE2DGMRWIM4TGLJVGAYUMRBTGI4DSNZUIJATQRJU 18:40:34 706.171448 T:1961263104 DEBUG: CPlayerCoreFactory::GetPlayers(http://zh2-4-hls-pvr.zahs.tv/HD_tsi1/1476009900/1476017100.m3u8?z32=NVQXQ4TBORST2MBGOVZWK4S7NFSD2MRRG43TGMBQG4THK5LJMQ6TQOBYMI2GMNJUFVRTCMRXFUYTCZJVFU4TSMJSFVRGCMDCMUYDIOBTMMYTQJTJNZUXI2LBNRZGC5DFHUYCM43JM46TGNTDMRRTOOLFMU2GKZDGGAZTQNBXGRQWKNBZMM2DONBVGQ2TQNJGNVUW44TBORST2NRQGATGG2DBNZXGK3B5INEF6SDJKFPXI43JGETGG43JMQ6TCNBXIM4DONSDHE2DGMRWIM4TGLJVGAYUMRBTGI4DSNZUIJATQRJU) 18:40:34 706.171631 T:1961263104 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules 18:40:34 706.171814 T:1961263104 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules 18:40:34 706.171875 T:1961263104 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mms/udp 18:40:34 706.172119 T:1961263104 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 18:40:34 706.172363 T:1961263104 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp 18:40:34 706.172607 T:1961263104 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp 18:40:34 706.172791 T:1961263104 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams 18:40:34 706.173096 T:1961263104 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: streams 18:40:34 706.173218 T:1961263104 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: aacp/sdp 18:40:34 706.173462 T:1961263104 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mp2 18:40:34 706.173645 T:1961263104 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd 18:40:34 706.173767 T:1961263104 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage 18:40:34 706.173950 T:1961263104 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 18:40:34 706.174133 T:1961263104 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv 18:40:34 706.174316 T:1961263104 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio 18:40:34 706.174561 T:1961263104 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players 18:40:34 706.174805 T:1961263104 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (VideoPlayer) 18:40:34 706.174866 T:1961263104 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0 18:40:34 706.174927 T:1961263104 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1 18:40:34 706.175171 T:1961263104 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players 18:40:34 706.182495 T:1961263104 DEBUG: Radio UECP (RDS) Processor - new CDVDRadioRDSData 18:40:34 706.183105 T:1961263104 NOTICE: VideoPlayer: Opening: http://zh2-4-hls-pvr.zahs.tv/HD_tsi1/1476009900/1476017100.m3u8?z32=NVQXQ4TBORST2MBGOVZWK4S7NFSD2MRRG43TGMBQG4THK5LJMQ6TQOBYMI2GMNJUFVRTCMRXFUYTCZJVFU4TSMJSFVRGCMDCMUYDIOBTMMYTQJTJNZUXI2LBNRZGC5DFHUYCM43JM46TGNTDMRRTOOLFMU2GKZDGGAZTQNBXGRQWKNBZMM2DONBVGQ2TQNJGNVUW44TBORST2NRQGATGG2DBNZXGK3B5INEF6SDJKFPXI43JGETGG43JMQ6TCNBXIM4DONSDHE2DGMRWIM4TGLJVGAYUMRBTGI4DSNZUIJATQRJU 18:40:34 706.183289 T:1961263104 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 18:40:34 706.194702 T:1961263104 DEBUG: CCurlFile::GetMimeType - http://zh2-4-hls-pvr.zahs.tv/HD_tsi1/1476009900/1476017100.m3u8?z32=NVQXQ4TBORST2MBGOVZWK4S7NFSD2MRRG43TGMBQG4THK5LJMQ6TQOBYMI2GMNJUFVRTCMRXFUYTCZJVFU4TSMJSFVRGCMDCMUYDIOBTMMYTQJTJNZUXI2LBNRZGC5DFHUYCM43JM46TGNTDMRRTOOLFMU2GKZDGGAZTQNBXGRQWKNBZMM2DONBVGQ2TQNJGNVUW44TBORST2NRQGATGG2DBNZXGK3B5INEF6SDJKFPXI43JGETGG43JMQ6TCNBXIM4DONSDHE2DGMRWIM4TGLJVGAYUMRBTGI4DSNZUIJATQRJU -> application/vnd.apple.mpegurl 18:40:34 706.194885 T:1961263104 DEBUG: CMMALRenderer::CMMALRenderer 18:40:34 706.195068 T:1961263104 DEBUG: CMMALRenderer::UnInitMMAL 18:40:34 706.195129 T:1526723488 DEBUG: Thread MMALProcess start, auto delete: false 18:40:34 706.195251 T:1961263104 DEBUG: CMMALRenderer::PreInit 18:40:34 706.195312 T:1526723488 DEBUG: CMMALRenderer::Run - starting 18:40:34 706.195435 T:1535112096 DEBUG: Thread VideoPlayer start, auto delete: false 18:40:34 706.195740 T:1535112096 NOTICE: Creating InputStream 18:40:34 706.198547 T:1535112096 DEBUG: CurlFile::Open(0x5b7fe838) http://zh2-4-hls-pvr.zahs.tv/HD_tsi1/1476009900/1476017100.m3u8?z32=NVQXQ4TBORST2MBGOVZWK4S7NFSD2MRRG43TGMBQG4THK5LJMQ6TQOBYMI2GMNJUFVRTCMRXFUYTCZJVFU4TSMJSFVRGCMDCMUYDIOBTMMYTQJTJNZUXI2LBNRZGC5DFHUYCM43JM46TGNTDMRRTOOLFMU2GKZDGGAZTQNBXGRQWKNBZMM2DONBVGQ2TQNJGNVUW44TBORST2NRQGATGG2DBNZXGK3B5INEF6SDJKFPXI43JGETGG43JMQ6TCNBXIM4DONSDHE2DGMRWIM4TGLJVGAYUMRBTGI4DSNZUIJATQRJU 18:40:34 706.316589 T:1535112096 DEBUG: CurlFile::Open(0x5b7fd858) http://zh2-4-hls-pvr.zahs.tv/HD_tsi1/1476009900/1476017100.m3u8?z32=NVQXQ4TBORST2MBGOVZWK4S7NFSD2MRRG43TGMBQG4THK5LJMQ6TQOBYMI2GMNJUFVRTCMRXFUYTCZJVFU4TSMJSFVRGCMDCMUYDIOBTMMYTQJTJNZUXI2LBNRZGC5DFHUYCM43JM46TGNTDMRRTOOLFMU2GKZDGGAZTQNBXGRQWKNBZMM2DONBVGQ2TQNJGNVUW44TBORST2NRQGATGG2DBNZXGK3B5INEF6SDJKFPXI43JGETGG43JMQ6TCNBXIM4DONSDHE2DGMRWIM4TGLJVGAYUMRBTGI4DSNZUIJATQRJU 18:40:34 706.326355 T:1535112096 INFO: CDVDInputStreamFFmpeg: Auto-selecting http://zh2-4-hls-pvr.zahs.tv/HD_tsi1/1476009900/1476017100/5000.m3u8?csid=147C876C94326C93-501FD328974BA8E4&maxrate=5000&user_id=21773007&sig=cf8689b5ee54d3b905ffd4eaa6e8dc71 based on configured bandwidth. 18:40:34 706.326599 T:1535112096 NOTICE: Creating Demuxer 18:40:35 706.545105 T:1535112096 INFO: ffmpeg[5B7FF3A0]: [hls,applehttp] No longer receiving playlist 0 18:40:35 706.546082 T:1535112096 DEBUG: Open - avformat_find_stream_info starting 18:40:35 706.546326 T:1535112096 INFO: ffmpeg[5B7FF3A0]: [hls,applehttp] Now receiving playlist 0, segment 0 18:40:35 706.610413 T:1535112096 DEBUG: Open - av_find_stream_info finished 18:40:35 706.610657 T:1535112096 INFO: ffmpeg[5B7FF3A0]: Input #0, hls,applehttp, http://zh2-4-hls-pvr.zahs.tv/HD_tsi1/1476009900/1476017100/5000.m3u8?csid=147C876C94326C93-501FD328974BA8E4&maxrate=5000&user_id=21773007&sig=cf8689b5ee54d3b905ffd4eaa6e8dc7': 18:40:35 706.610779 T:1535112096 INFO: ffmpeg[5B7FF3A0]: Duration: 02:00:00.00, start: 27900.000000, bitrate: 0 kb/s 18:40:35 706.610779 T:1535112096 INFO: ffmpeg[5B7FF3A0]: Program 0 18:40:35 706.610840 T:1535112096 INFO: ffmpeg[5B7FF3A0]: Metadata: 18:40:35 706.610901 T:1535112096 INFO: ffmpeg[5B7FF3A0]: variant_bitrate : 0 18:40:35 706.611145 T:1535112096 INFO: ffmpeg[5B7FF3A0]: Stream #0:0: Video: h264 (Main) ([27][0][0][0] / 0x001B), yuv420p, 1280x720 [SAR 1:1 DAR 16:9], 50 fps, 50 tbr, 90k tbn, 100 tbc 18:40:35 706.611267 T:1535112096 INFO: ffmpeg[5B7FF3A0]: Stream #0:1: Audio: aac (LC) ([15][0][0][0] / 0x000F), 48000 Hz, stereo, fltp, 121 kb/s 18:40:35 706.611328 T:1535112096 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 0 18:40:35 706.611389 T:1535112096 DEBUG: CDVDDemuxFFmpeg::AddStream ID: 1 18:40:35 706.611938 T:1535112096 NOTICE: Opening stream: 0 source: 256 18:40:35 706.612122 T:1535112096 NOTICE: Creating video codec with codec id: 28 18:40:35 706.612183 T:1535112096 DEBUG: FactoryCodec - Video: mmal-xxxx - Opening 18:40:35 706.616150 T:1535112096 DEBUG: CMMALPool::CMMALPool Created pool 0x65eee660 of size 26 x 128 for port vc.ril.video_decode:out:0(OPQV) 18:40:35 706.620422 T:1535112096 DEBUG: FactoryCodec - Video: mmal-h264 - Opened 18:40:35 706.620483 T:1535112096 DEBUG: CVideoPlayerVideo::OpenStream - open stream with codec id: 28 18:40:35 706.620544 T:1535112096 NOTICE: Creating video thread 18:40:35 706.620667 T:1535112096 NOTICE: Opening stream: 1 source: 256 18:40:35 706.620728 T:1545597856 DEBUG: Thread VideoPlayerVideo start, auto delete: false 18:40:35 706.620728 T:1535112096 NOTICE: Finding audio codec for: 86018 18:40:35 706.620789 T:1545597856 NOTICE: running thread: video_thread 18:40:35 706.620850 T:1535112096 DEBUG: FactoryCodec - Audio: passthrough - Opening 18:40:35 706.620850 T:1535112096 DEBUG: FactoryCodec - Audio: passthrough - Failed 18:40:35 706.620911 T:1535112096 DEBUG: FactoryCodec - Audio: FFmpeg - Opening 18:40:35 706.622314 T:1535112096 DEBUG: FactoryCodec - Audio: FFmpeg - Opened 18:40:35 706.622375 T:1535112096 NOTICE: Creating audio thread 18:40:35 706.622559 T:1612706720 DEBUG: Thread VideoPlayerAudio start, auto delete: false 18:40:35 706.622620 T:1612706720 NOTICE: running thread: CVideoPlayerAudio::Process() 18:40:35 706.622986 T:1535112096 DEBUG: OnPlayBackStarted: play state was 1, starting 1 18:40:35 706.623047 T:1961263104 DEBUG: PlayFile: OpenFile succeed, play state 2 18:40:35 706.623108 T:1961263104 DEBUG: OnPlayBackStarted: play state was 2, starting 0 18:40:35 706.627747 T:1535112096 DEBUG: CVideoPlayer::SetCaching - caching state 2 18:40:35 706.627930 T:1535112096 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 18:40:35 706.628113 T:1535112096 DEBUG: ProcessPacket - audio:0 video:0 18:40:35 706.628174 T:1545597856 INFO: CVideoPlayerVideo - Stillframe left, switching to normal playback 18:40:35 706.628235 T:1535112096 DEBUG: ProcessPacket - audio:0 video:0 18:40:35 706.628357 T:1535112096 DEBUG: Previous line repeats 1 times. 18:40:35 706.628357 T:1535112096 DEBUG: ProcessPacket - audio:1 video:0 18:40:35 706.628540 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.628601 T:1535112096 DEBUG: ProcessPacket - audio:1 video:1 18:40:35 706.628723 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.628723 T:1535112096 DEBUG: ProcessPacket - audio:2 video:1 18:40:35 706.628906 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.628967 T:1535112096 DEBUG: ProcessPacket - audio:2 video:2 18:40:35 706.630005 T:1535112096 DEBUG: Previous line repeats 4 times. 18:40:35 706.630127 T:1535112096 DEBUG: ProcessPacket - audio:3 video:2 18:40:35 706.630432 T:1535112096 DEBUG: Previous line repeats 4 times. 18:40:35 706.630493 T:1535112096 DEBUG: ProcessPacket - audio:3 video:3 18:40:35 706.630615 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.630615 T:1535112096 DEBUG: ProcessPacket - audio:4 video:3 18:40:35 706.630798 T:1535112096 DEBUG: Previous line repeats 4 times. 18:40:35 706.630798 T:1535112096 DEBUG: ProcessPacket - audio:4 video:4 18:40:35 706.630920 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.630981 T:1535112096 DEBUG: ProcessPacket - audio:5 video:4 18:40:35 706.631042 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.631104 T:1535112096 DEBUG: ProcessPacket - audio:6 video:4 18:40:35 706.631165 T:1535112096 DEBUG: Previous line repeats 1 times. 18:40:35 706.631226 T:1535112096 DEBUG: ProcessPacket - audio:6 video:5 18:40:35 706.631470 T:1535112096 DEBUG: Previous line repeats 5 times. 18:40:35 706.631531 T:1535112096 DEBUG: ProcessPacket - audio:7 video:5 18:40:35 706.631592 T:1535112096 DEBUG: Previous line repeats 1 times. 18:40:35 706.631653 T:1535112096 DEBUG: ProcessPacket - audio:7 video:6 18:40:35 706.631897 T:1535112096 DEBUG: Previous line repeats 6 times. 18:40:35 706.631958 T:1535112096 DEBUG: ProcessPacket - audio:8 video:6 18:40:35 706.632019 T:1535112096 DEBUG: ProcessPacket - audio:8 video:7 18:40:35 706.632141 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.632202 T:1535112096 DEBUG: ProcessPacket - audio:8 video:8 18:40:35 706.632324 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.632385 T:1535112096 DEBUG: ProcessPacket - audio:9 video:8 18:40:35 706.632690 T:1535112096 DEBUG: Previous line repeats 7 times. 18:40:35 706.632690 T:1535112096 DEBUG: ProcessPacket - audio:10 video:8 18:40:35 706.632751 T:1612706720 DEBUG: CDVDAudio::Pause - pausing audio stream 18:40:35 706.632874 T:1535112096 DEBUG: ProcessPacket - audio:10 video:8 18:40:35 706.632996 T:1535112096 DEBUG: ProcessPacket - audio:10 video:9 18:40:35 706.633179 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.633179 T:1535112096 DEBUG: ProcessPacket - audio:10 video:10 18:40:35 706.633240 T:1612706720 NOTICE: Creating audio stream (codec id: 86018, channels: 2, sample rate: 48000, no pass-through) 18:40:35 706.633362 T:1535112096 DEBUG: ProcessPacket - audio:10 video:10 18:40:35 706.633484 T:1612706720 DEBUG: CVideoPlayerAudio:: synctype set to 0: clock feedback 18:40:35 706.633728 T:1535112096 DEBUG: ProcessPacket - audio:10 video:9 18:40:35 706.634033 T:1535112096 DEBUG: ProcessPacket - audio:11 video:9 18:40:35 706.634644 T:1535112096 DEBUG: Previous line repeats 5 times. 18:40:35 706.634705 T:1535112096 DEBUG: ProcessPacket - audio:11 video:10 18:40:35 706.634766 T:1535112096 DEBUG: ProcessPacket - audio:11 video:9 18:40:35 706.634888 T:1535112096 DEBUG: Previous line repeats 1 times. 18:40:35 706.634949 T:1535112096 DEBUG: ProcessPacket - audio:12 video:9 18:40:35 706.635010 T:1535112096 DEBUG: Previous line repeats 1 times. 18:40:35 706.635071 T:1535112096 DEBUG: ProcessPacket - audio:12 video:10 18:40:35 706.635254 T:1535112096 DEBUG: Previous line repeats 4 times. 18:40:35 706.635254 T:1535112096 DEBUG: ProcessPacket - audio:13 video:10 18:40:35 706.635437 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.635498 T:1535112096 DEBUG: ProcessPacket - audio:13 video:11 18:40:35 706.635620 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.635681 T:1535112096 DEBUG: ProcessPacket - audio:14 video:11 18:40:35 706.635803 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.635803 T:1535112096 DEBUG: ProcessPacket - audio:14 video:12 18:40:35 706.636047 T:1535112096 DEBUG: Previous line repeats 5 times. 18:40:35 706.636108 T:1535112096 DEBUG: ProcessPacket - audio:15 video:12 18:40:35 706.636230 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.636230 T:1535112096 DEBUG: ProcessPacket - audio:15 video:13 18:40:35 706.636353 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.636414 T:1535112096 DEBUG: ProcessPacket - audio:15 video:14 18:40:35 706.636536 T:1535112096 DEBUG: Previous line repeats 1 times. 18:40:35 706.636536 T:1535112096 DEBUG: ProcessPacket - audio:16 video:14 18:40:35 706.636841 T:1535112096 DEBUG: Previous line repeats 6 times. 18:40:35 706.636841 T:1535112096 DEBUG: ProcessPacket - audio:17 video:14 18:40:35 706.637024 T:1930425248 DEBUG: Previous line repeats 3 times. 18:40:35 706.637024 T:1930425248 INFO: CActiveAESink::OpenSink - initialize sink 18:40:35 706.637085 T:1535112096 DEBUG: ProcessPacket - audio:17 video:15 18:40:35 706.637207 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.637268 T:1535112096 DEBUG: ProcessPacket - audio:17 video:16 18:40:35 706.637329 T:1535112096 DEBUG: ProcessPacket - audio:18 video:16 18:40:35 706.637634 T:1535112096 DEBUG: Previous line repeats 7 times. 18:40:35 706.637634 T:1535112096 DEBUG: ProcessPacket - audio:18 video:17 18:40:35 706.637756 T:1535112096 DEBUG: ProcessPacket - audio:19 video:17 18:40:35 706.637939 T:1535112096 DEBUG: Previous line repeats 5 times. 18:40:35 706.638000 T:1535112096 DEBUG: ProcessPacket - audio:19 video:18 18:40:35 706.638062 T:1535112096 DEBUG: Previous line repeats 1 times. 18:40:35 706.638123 T:1535112096 DEBUG: ProcessPacket - audio:20 video:18 18:40:35 706.638245 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.638367 T:1535112096 DEBUG: ProcessPacket - audio:21 video:18 18:40:35 706.638489 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.638489 T:1535112096 DEBUG: ProcessPacket - audio:21 video:19 18:40:35 706.638672 T:1586484128 DEBUG: Previous line repeats 3 times. 18:40:35 706.638733 T:1586484128 DEBUG: CGUIInfoManager::SetCurrentMovie(http://zh2-4-hls-pvr.zahs.tv/HD_tsi1/1476009900/1476017100.m3u8?z32=NVQXQ4TBORST2MBGOVZWK4S7NFSD2MRRG43TGMBQG4THK5LJMQ6TQOBYMI2GMNJUFVRTCMRXFUYTCZJVFU4TSMJSFVRGCMDCMUYDIOBTMMYTQJTJNZUXI2LBNRZGC5DFHUYCM43JM46TGNTDMRRTOOLFMU2GKZDGGAZTQNBXGRQWKNBZMM2DONBVGQ2TQNJGNVUW44TBORST2NRQGATGG2DBNZXGK3B5INEF6SDJKFPXI43JGETGG43JMQ6TCNBXIM4DONSDHE2DGMRWIM4TGLJVGAYUMRBTGI4DSNZUIJATQRJU) 18:40:35 706.638733 T:1535112096 DEBUG: ProcessPacket - audio:21 video:19 18:40:35 706.638855 T:1535112096 DEBUG: ProcessPacket - audio:22 video:19 18:40:35 706.638977 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.638977 T:1535112096 DEBUG: ProcessPacket - audio:22 video:20 18:40:35 706.639221 T:1535112096 DEBUG: Previous line repeats 4 times. 18:40:35 706.639221 T:1535112096 DEBUG: ProcessPacket - audio:23 video:20 18:40:35 706.639343 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.639465 T:1535112096 DEBUG: ProcessPacket - audio:23 video:21 18:40:35 706.639709 T:1535112096 DEBUG: Previous line repeats 5 times. 18:40:35 706.639771 T:1535112096 DEBUG: ProcessPacket - audio:24 video:21 18:40:35 706.639893 T:1535112096 DEBUG: Previous line repeats 1 times. 18:40:35 706.639954 T:1535112096 DEBUG: ProcessPacket - audio:24 video:22 18:40:35 706.640137 T:1535112096 DEBUG: Previous line repeats 4 times. 18:40:35 706.640137 T:1535112096 DEBUG: ProcessPacket - audio:25 video:22 18:40:35 706.640320 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.640320 T:1535112096 DEBUG: ProcessPacket - audio:25 video:23 18:40:35 706.640503 T:1535112096 DEBUG: Previous line repeats 4 times. 18:40:35 706.640564 T:1535112096 DEBUG: ProcessPacket - audio:26 video:23 18:40:35 706.640686 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.640747 T:1535112096 DEBUG: ProcessPacket - audio:26 video:24 18:40:35 706.640930 T:1535112096 DEBUG: Previous line repeats 4 times. 18:40:35 706.640930 T:1535112096 DEBUG: ProcessPacket - audio:27 video:24 18:40:35 706.641113 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.641113 T:1535112096 DEBUG: ProcessPacket - audio:27 video:25 18:40:35 706.641357 T:1535112096 DEBUG: Previous line repeats 5 times. 18:40:35 706.641357 T:1535112096 DEBUG: ProcessPacket - audio:28 video:25 18:40:35 706.641479 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.641541 T:1535112096 DEBUG: ProcessPacket - audio:28 video:26 18:40:35 706.641724 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.641724 T:1535112096 DEBUG: ProcessPacket - audio:29 video:26 18:40:35 706.641846 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.641907 T:1535112096 DEBUG: ProcessPacket - audio:29 video:27 18:40:35 706.642090 T:1535112096 DEBUG: Previous line repeats 4 times. 18:40:35 706.642151 T:1535112096 DEBUG: ProcessPacket - audio:30 video:27 18:40:35 706.642273 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.642334 T:1535112096 DEBUG: ProcessPacket - audio:30 video:28 18:40:35 706.642456 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.642456 T:1535112096 DEBUG: ProcessPacket - audio:30 video:29 18:40:35 706.642578 T:1535112096 DEBUG: Previous line repeats 1 times. 18:40:35 706.642639 T:1535112096 DEBUG: ProcessPacket - audio:31 video:29 18:40:35 706.642883 T:1535112096 DEBUG: Previous line repeats 7 times. 18:40:35 706.642944 T:1535112096 DEBUG: ProcessPacket - audio:32 video:29 18:40:35 706.643066 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.643127 T:1535112096 DEBUG: ProcessPacket - audio:32 video:30 18:40:35 706.643250 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.643311 T:1535112096 DEBUG: ProcessPacket - audio:32 video:31 18:40:35 706.643372 T:1535112096 DEBUG: ProcessPacket - audio:33 video:31 18:40:35 706.643677 T:1535112096 DEBUG: Previous line repeats 7 times. 18:40:35 706.643738 T:1535112096 DEBUG: ProcessPacket - audio:34 video:31 18:40:35 706.643921 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.643921 T:1535112096 DEBUG: ProcessPacket - audio:34 video:32 18:40:35 706.644043 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.644104 T:1535112096 DEBUG: ProcessPacket - audio:34 video:33 18:40:35 706.644165 T:1535112096 DEBUG: Previous line repeats 1 times. 18:40:35 706.644226 T:1535112096 DEBUG: ProcessPacket - audio:35 video:33 18:40:35 706.644470 T:1535112096 DEBUG: Previous line repeats 6 times. 18:40:35 706.644531 T:1535112096 DEBUG: ProcessPacket - audio:35 video:34 18:40:35 706.644592 T:1535112096 DEBUG: ProcessPacket - audio:36 video:34 18:40:35 706.644714 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.644775 T:1535112096 DEBUG: ProcessPacket - audio:37 video:34 18:40:35 706.644897 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.644897 T:1535112096 DEBUG: ProcessPacket - audio:37 video:35 18:40:35 706.645142 T:1535112096 DEBUG: Previous line repeats 4 times. 18:40:35 706.645142 T:1535112096 DEBUG: ProcessPacket - audio:38 video:35 18:40:35 706.645325 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.645325 T:1535112096 DEBUG: ProcessPacket - audio:38 video:36 18:40:35 706.645508 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.645508 T:1535112096 DEBUG: ProcessPacket - audio:39 video:36 18:40:35 706.645691 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.645691 T:1535112096 DEBUG: ProcessPacket - audio:39 video:37 18:40:35 706.645935 T:1535112096 DEBUG: Previous line repeats 5 times. 18:40:35 706.645935 T:1535112096 DEBUG: ProcessPacket - audio:40 video:37 18:40:35 706.646118 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.646118 T:1535112096 DEBUG: ProcessPacket - audio:40 video:38 18:40:35 706.646423 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.646484 T:1535112096 DEBUG: ProcessPacket - audio:41 video:38 18:40:35 706.646667 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.646729 T:1535112096 DEBUG: ProcessPacket - audio:41 video:39 18:40:35 706.646973 T:1535112096 DEBUG: Previous line repeats 4 times. 18:40:35 706.647034 T:1535112096 DEBUG: ProcessPacket - audio:42 video:39 18:40:35 706.647156 T:1961255840 DEBUG: Previous line repeats 3 times. 18:40:35 706.647217 T:1961255840 DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc 18:40:35 706.647217 T:1535112096 DEBUG: ProcessPacket - audio:42 video:40 18:40:35 706.647339 T:1961255840 DEBUG: Previous line repeats 1 times. 18:40:35 706.647339 T:1961255840 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay 18:40:35 706.647400 T:1535112096 DEBUG: ProcessPacket - audio:42 video:40 18:40:35 706.647522 T:1535112096 DEBUG: Previous line repeats 1 times. 18:40:35 706.647522 T:1535112096 DEBUG: ProcessPacket - audio:43 video:40 18:40:35 706.647705 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.647705 T:1535112096 DEBUG: ProcessPacket - audio:43 video:41 18:40:35 706.647949 T:1535112096 DEBUG: Previous line repeats 5 times. 18:40:35 706.648010 T:1535112096 DEBUG: ProcessPacket - audio:44 video:41 18:40:35 706.648132 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.648132 T:1535112096 DEBUG: ProcessPacket - audio:44 video:42 18:40:35 706.648315 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.648315 T:1535112096 DEBUG: ProcessPacket - audio:45 video:42 18:40:35 706.648499 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.648499 T:1535112096 DEBUG: ProcessPacket - audio:45 video:43 18:40:35 706.648743 T:1535112096 DEBUG: Previous line repeats 4 times. 18:40:35 706.648804 T:1535112096 DEBUG: ProcessPacket - audio:46 video:43 18:40:35 706.648987 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.648987 T:1535112096 DEBUG: ProcessPacket - audio:46 video:44 18:40:35 706.649170 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.649170 T:1535112096 DEBUG: ProcessPacket - audio:46 video:45 18:40:35 706.649292 T:1535112096 DEBUG: Previous line repeats 1 times. 18:40:35 706.649353 T:1535112096 DEBUG: ProcessPacket - audio:47 video:45 18:40:35 706.649597 T:1535112096 DEBUG: Previous line repeats 5 times. 18:40:35 706.649597 T:1535112096 DEBUG: ProcessPacket - audio:47 video:46 18:40:35 706.649719 T:1535112096 DEBUG: Previous line repeats 1 times. 18:40:35 706.649780 T:1535112096 DEBUG: ProcessPacket - audio:48 video:46 18:40:35 706.650085 T:1535112096 DEBUG: Previous line repeats 5 times. 18:40:35 706.650146 T:1535112096 DEBUG: ProcessPacket - audio:48 video:47 18:40:35 706.650269 T:1535112096 DEBUG: ProcessPacket - audio:49 video:47 18:40:35 706.650574 T:1535112096 DEBUG: Previous line repeats 6 times. 18:40:35 706.650635 T:1535112096 DEBUG: ProcessPacket - audio:49 video:48 18:40:35 706.650696 T:1535112096 DEBUG: ProcessPacket - audio:50 video:48 18:40:35 706.654907 T:1586484128 DEBUG: Previous line repeats 4 times. 18:40:35 706.655029 T:1586484128 DEBUG: GetMovieId (http://zh2-4-hls-pvr.zahs.tv/HD_tsi1/1476009900/1476017100.m3u8?z32=NVQXQ4TBORST2MBGOVZWK4S7NFSD2MRRG43TGMBQG4THK5LJMQ6TQOBYMI2GMNJUFVRTCMRXFUYTCZJVFU4TSMJSFVRGCMDCMUYDIOBTMMYTQJTJNZUXI2LBNRZGC5DFHUYCM43JM46TGNTDMRRTOOLFMU2GKZDGGAZTQNBXGRQWKNBZMM2DONBVGQ2TQNJGNVUW44TBORST2NRQGATGG2DBNZXGK3B5INEF6SDJKFPXI43JGETGG43JMQ6TCNBXIM4DONSDHE2DGMRWIM4TGLJVGAYUMRBTGI4DSNZUIJATQRJU), query = select idMovie from movie where idFile=4 18:40:35 706.655640 T:1586484128 DEBUG: GetEpisodeId (http://zh2-4-hls-pvr.zahs.tv/HD_tsi1/1476009900/1476017100.m3u8?z32=NVQXQ4TBORST2MBGOVZWK4S7NFSD2MRRG43TGMBQG4THK5LJMQ6TQOBYMI2GMNJUFVRTCMRXFUYTCZJVFU4TSMJSFVRGCMDCMUYDIOBTMMYTQJTJNZUXI2LBNRZGC5DFHUYCM43JM46TGNTDMRRTOOLFMU2GKZDGGAZTQNBXGRQWKNBZMM2DONBVGQ2TQNJGNVUW44TBORST2NRQGATGG2DBNZXGK3B5INEF6SDJKFPXI43JGETGG43JMQ6TCNBXIM4DONSDHE2DGMRWIM4TGLJVGAYUMRBTGI4DSNZUIJATQRJU), query = select idEpisode from episode where idFile=4 18:40:35 706.656311 T:1586484128 DEBUG: GetMusicVideoId (http://zh2-4-hls-pvr.zahs.tv/HD_tsi1/1476009900/1476017100.m3u8?z32=NVQXQ4TBORST2MBGOVZWK4S7NFSD2MRRG43TGMBQG4THK5LJMQ6TQOBYMI2GMNJUFVRTCMRXFUYTCZJVFU4TSMJSFVRGCMDCMUYDIOBTMMYTQJTJNZUXI2LBNRZGC5DFHUYCM43JM46TGNTDMRRTOOLFMU2GKZDGGAZTQNBXGRQWKNBZMM2DONBVGQ2TQNJGNVUW44TBORST2NRQGATGG2DBNZXGK3B5INEF6SDJKFPXI43JGETGG43JMQ6TCNBXIM4DONSDHE2DGMRWIM4TGLJVGAYUMRBTGI4DSNZUIJATQRJU), query = select idMVideo from musicvideo where idFile=4 18:40:35 706.687317 T:1930425248 DEBUG: CAESinkPi:Drain delay:50ms now:0ms 18:40:35 706.687439 T:1930425248 DEBUG: CAESinkPi:Deinitialize 18:40:35 706.687744 T:1930425248 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000000 18:40:35 706.692444 T:1930425248 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.audio_render handle 0x727c5a60 18:40:35 706.692932 T:1930425248 DEBUG: CActiveAESink::OpenSink - trying to open device PI:HDMI 18:40:35 706.693054 T:1930425248 DEBUG: CAESinkPi:Initialize Format:24 Channels:2 Samplerate:48000 framesize:8 bufsize:9600 bytes/s=384000.00 dest=PI:HDMI 18:40:35 706.693420 T:1930425248 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000008 18:40:35 706.694397 T:1930425248 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_render input port 100 output port 100 m_handle 0x727c90c8 18:40:35 706.696167 T:1930425248 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.audio_render) - port(100), nBufferCountMin(1), nBufferCountActual(2), nBufferSize(9600), nBufferAlignmen(16) 18:40:35 706.696716 T:1930425248 DEBUG: CActiveAESink::OpenSink - SinkPi Initialized: 18:40:35 706.696838 T:1930425248 DEBUG: Output Device : HDMI 18:40:35 706.696838 T:1930425248 DEBUG: Sample Rate : 48000 18:40:35 706.696960 T:1930425248 DEBUG: Sample Format : AE_FMT_FLOATP 18:40:35 706.696960 T:1930425248 DEBUG: Channel Count : 2 18:40:35 706.697021 T:1930425248 DEBUG: Channel Layout: FL,FR 18:40:35 706.697021 T:1930425248 DEBUG: Frames : 1200 18:40:35 706.697083 T:1930425248 DEBUG: Frame Size : 8 18:40:35 706.700012 T:1939870624 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 18:40:35 706.706055 T:1545597856 DEBUG: Previous line repeats 1 times. 18:40:35 706.706177 T:1545597856 DEBUG: CRenderManager::Configure - change configuration. 1280x720. display: 1280x720. framerate: 50.00. format: MMAL 18:40:35 706.706604 T:1961263104 DEBUG: DeleteRenderer - deleting renderer 18:40:35 706.706665 T:1961263104 DEBUG: CMMALRenderer::~CMMALRenderer 18:40:35 706.706726 T:1961263104 DEBUG: CMMALRenderer::UnInitMMAL 18:40:35 706.706787 T:1526723488 DEBUG: CMMALRenderer::Run - stopping 18:40:35 706.706848 T:1526723488 DEBUG: Thread MMALProcess 1526723488 terminating 18:40:35 706.707031 T:1961263104 DEBUG: CMMALRenderer::CMMALRenderer 18:40:35 706.707153 T:1961263104 DEBUG: CMMALRenderer::UnInitMMAL 18:40:35 706.707214 T:1526723488 DEBUG: Thread MMALProcess start, auto delete: false 18:40:35 706.707275 T:1961263104 DEBUG: CMMALRenderer::PreInit 18:40:35 706.707275 T:1526723488 DEBUG: CMMALRenderer::Run - starting 18:40:35 706.707336 T:1961263104 DEBUG: CMMALRenderer::Configure - 1280x720->1280x720@50.00 flags:12 format:18 ext:0 orient:0 18:40:35 706.707397 T:1961263104 DEBUG: CRenderManager::Configure - 4 18:40:35 706.708923 T:1526723488 DEBUG: CMMALRenderer::CheckConfigurationVout Changing Vout dimensions from 160x64 (160x64) to 1280x720 (1280x720) OPQV 18:40:35 706.714050 T:1526723488 DEBUG: CMMALRenderer::SetVideoRect 0,0,1280,720 -> 0,0,0,0 (o:0 v:0 d:0 i:0) 18:40:35 706.714172 T:1595929504 DEBUG: Thread MMALRenderer start, auto delete: false 18:40:35 706.714233 T:1595929504 DEBUG: CMMALRenderer::Process - starting 18:40:35 706.714355 T:1526723488 DEBUG: CMMALRenderer::SetVideoRect 0,0,1280,720 -> 0,0,0,0 t:100000 18:40:35 706.721008 T:1535112096 DEBUG: ProcessPacket - audio:48 video:47 18:40:35 706.721130 T:1535112096 DEBUG: CVideoPlayer::CheckContinuity - resync backward :2, prev:3959999.999999, curr:0.000000, diff:-3959999.999999 18:40:35 706.721252 T:1535112096 DEBUG: CVideoPlayer::HandleMessages - player started 1 18:40:35 706.721375 T:1535112096 DEBUG: CVideoPlayer::HandleMessages - player started 2 18:40:35 706.721375 T:1535112096 DEBUG: CVideoPlayer::SetCaching - caching state 3 18:40:35 706.721436 T:1535112096 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 18:40:35 706.721497 T:1535112096 DEBUG: CVideoPlayer::SetCaching - caching state 0 18:40:35 706.721497 T:1535112096 DEBUG: CDVDClock::SetSpeedAdjust - adjusted:0.000000 18:40:35 706.721558 T:1535112096 DEBUG: VideoPlayer::Sync - Audio - pts: 202666.000000, cache: 235537.222635, totalcache: 449999.988079 18:40:35 706.721619 T:1535112096 DEBUG: VideoPlayer::Sync - Video - pts: 20000.000000, cache: 50000.000000, totalcache: 100000.000000 18:40:35 706.721680 T:1545597856 DEBUG: CVideoPlayerVideo - CDVDMsg::GENERAL_RESYNC(-80000.000000) 18:40:35 706.721802 T:1612706720 DEBUG: CVideoPlayerAudio - CDVDMsg::GENERAL_RESYNC(-80000.000000) 18:40:35 706.721863 T:1535112096 DEBUG: ProcessPacket - audio:48 video:47 18:40:35 706.721924 T:1535112096 DEBUG: CVideoPlayer::CheckContinuity - resync backward :1, prev:3978666.666666, curr:10666.666665, diff:-3968000.000001 18:40:35 706.721985 T:1612706720 DEBUG: CDVDAudio::Resume - resume audio stream 18:40:35 706.721985 T:1535112096 DEBUG: CVideoPlayer::CheckContinuity - update correction: -3989333.333334 18:40:35 706.722046 T:1939870624 DEBUG: ActiveAE - start sync of audio stream 18:40:35 706.722107 T:1535112096 DEBUG: ProcessPacket - audio:48 video:47 18:40:35 706.722595 T:1961263104 DEBUG: Previous line repeats 4 times. 18:40:35 706.722656 T:1961263104 DEBUG: CMMALRenderer::RenderUpdate - vsync -1 (+26911) 18:40:35 706.722717 T:1535112096 DEBUG: ProcessPacket - audio:48 video:48 18:40:35 706.723083 T:1961263104 DEBUG: Previous line repeats 2 times. 18:40:35 706.723145 T:1961263104 DEBUG: Activating window ID: 12005 18:40:35 706.723206 T:1535112096 DEBUG: ProcessPacket - audio:48 video:48 18:40:35 706.723633 T:1961263104 DEBUG: Previous line repeats 2 times. 18:40:35 706.723694 T:1961263104 DEBUG: ------ Window Deinit (Home.xml) ------ 18:40:35 706.723755 T:1535112096 DEBUG: ProcessPacket - audio:48 video:48 18:40:35 706.724060 T:1535112096 DEBUG: Previous line repeats 1 times. 18:40:35 706.724121 T:1535112096 DEBUG: ProcessPacket - audio:48 video:49 18:40:35 706.724243 T:1535112096 DEBUG: ProcessPacket - audio:47 video:49 18:40:35 706.724609 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.724670 T:1535112096 DEBUG: ProcessPacket - audio:48 video:49 18:40:35 706.724976 T:1961263104 DEBUG: Previous line repeats 3 times. 18:40:35 706.724976 T:1961263104 DEBUG: ------ Window Init (VideoFullScreen.xml) ------ 18:40:35 706.725037 T:1535112096 DEBUG: ProcessPacket - audio:48 video:50 18:40:35 706.725403 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.725464 T:1535112096 DEBUG: ProcessPacket - audio:49 video:50 18:40:35 706.725830 T:1961263104 DEBUG: CMMALRenderer::SetVideoRect 0,0,1280,720 -> 0,0,1920,1080 (o:0 v:0 d:0 i:0) 18:40:35 706.725891 T:1535112096 DEBUG: ProcessPacket - audio:49 video:50 18:40:35 706.726135 T:1535112096 DEBUG: Previous line repeats 1 times. 18:40:35 706.726196 T:1535112096 DEBUG: ProcessPacket - audio:50 video:50 18:40:35 706.726318 T:1535112096 DEBUG: ProcessPacket - audio:50 video:51 18:40:35 706.726746 T:1961263104 DEBUG: Previous line repeats 5 times. 18:40:35 706.726807 T:1961263104 DEBUG: CMMALRenderer::SetVideoRect 0,0,1280,720 -> 0,0,1920,1080 t:100000 18:40:35 706.726868 T:1535112096 DEBUG: ProcessPacket - audio:50 video:51 18:40:35 706.727295 T:1535112096 DEBUG: ProcessPacket - audio:51 video:51 18:40:35 706.727539 T:1535112096 DEBUG: ProcessPacket - audio:51 video:52 18:40:35 706.728455 T:1535112096 DEBUG: Previous line repeats 6 times. 18:40:35 706.728455 T:1535112096 DEBUG: ProcessPacket - audio:52 video:52 18:40:35 706.728638 T:1535112096 DEBUG: ProcessPacket - audio:52 video:53 18:40:35 706.729309 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.729309 T:1535112096 DEBUG: ProcessPacket - audio:52 video:54 18:40:35 706.729858 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.729919 T:1535112096 DEBUG: ProcessPacket - audio:53 video:54 18:40:35 706.730530 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.730591 T:1535112096 DEBUG: ProcessPacket - audio:53 video:55 18:40:35 706.730957 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.730957 T:1535112096 DEBUG: ProcessPacket - audio:54 video:55 18:40:35 706.731689 T:1535112096 DEBUG: Previous line repeats 4 times. 18:40:35 706.731750 T:1535112096 DEBUG: ProcessPacket - audio:54 video:56 18:40:35 706.732056 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.732117 T:1535112096 DEBUG: ProcessPacket - audio:55 video:56 18:40:35 706.732849 T:1535112096 DEBUG: Previous line repeats 4 times. 18:40:35 706.732910 T:1535112096 DEBUG: ProcessPacket - audio:55 video:57 18:40:35 706.733215 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.733215 T:1535112096 DEBUG: ProcessPacket - audio:56 video:57 18:40:35 706.734192 T:1535112096 DEBUG: Previous line repeats 4 times. 18:40:35 706.734253 T:1535112096 DEBUG: ProcessPacket - audio:56 video:58 18:40:35 706.734741 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.734741 T:1535112096 DEBUG: ProcessPacket - audio:57 video:58 18:40:35 706.735352 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.735413 T:1535112096 DEBUG: ProcessPacket - audio:57 video:59 18:40:35 706.735779 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.735779 T:1535112096 DEBUG: ProcessPacket - audio:58 video:59 18:40:35 706.736511 T:1535112096 DEBUG: Previous line repeats 4 times. 18:40:35 706.736572 T:1535112096 DEBUG: ProcessPacket - audio:58 video:60 18:40:35 706.736938 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.737000 T:1535112096 DEBUG: ProcessPacket - audio:59 video:60 18:40:35 706.737671 T:1535112096 DEBUG: Previous line repeats 4 times. 18:40:35 706.737671 T:1535112096 DEBUG: ProcessPacket - audio:59 video:61 18:40:35 706.738220 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.738281 T:1535112096 DEBUG: ProcessPacket - audio:60 video:61 18:40:35 706.738831 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.738892 T:1535112096 DEBUG: ProcessPacket - audio:60 video:62 18:40:35 706.739685 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.739746 T:1535112096 DEBUG: ProcessPacket - audio:61 video:62 18:40:35 706.740540 T:1535112096 DEBUG: Previous line repeats 4 times. 18:40:35 706.740601 T:1535112096 DEBUG: ProcessPacket - audio:61 video:63 18:40:35 706.741150 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.741211 T:1535112096 DEBUG: ProcessPacket - audio:62 video:63 18:40:35 706.741882 T:1535112096 DEBUG: Previous line repeats 4 times. 18:40:35 706.741882 T:1535112096 DEBUG: ProcessPacket - audio:62 video:64 18:40:35 706.742310 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.742371 T:1535112096 DEBUG: ProcessPacket - audio:63 video:64 18:40:35 706.743042 T:1535112096 DEBUG: Previous line repeats 4 times. 18:40:35 706.743042 T:1535112096 DEBUG: ProcessPacket - audio:63 video:65 18:40:35 706.743652 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.743652 T:1535112096 DEBUG: ProcessPacket - audio:64 video:65 18:40:35 706.744019 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.744080 T:1535112096 DEBUG: ProcessPacket - audio:65 video:65 18:40:35 706.744263 T:1535112096 DEBUG: ProcessPacket - audio:65 video:66 18:40:35 706.745117 T:1535112096 DEBUG: Previous line repeats 6 times. 18:40:35 706.745178 T:1535112096 DEBUG: ProcessPacket - audio:66 video:66 18:40:35 706.745361 T:1535112096 DEBUG: ProcessPacket - audio:66 video:67 18:40:35 706.746277 T:1535112096 DEBUG: Previous line repeats 6 times. 18:40:35 706.746277 T:1535112096 DEBUG: ProcessPacket - audio:67 video:67 18:40:35 706.746765 T:1535112096 DEBUG: ProcessPacket - audio:67 video:68 18:40:35 706.747742 T:1535112096 DEBUG: Previous line repeats 6 times. 18:40:35 706.747803 T:1535112096 DEBUG: ProcessPacket - audio:68 video:68 18:40:35 706.747925 T:1535112096 DEBUG: ProcessPacket - audio:68 video:69 18:40:35 706.748535 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.748596 T:1535112096 DEBUG: ProcessPacket - audio:68 video:70 18:40:35 706.748901 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.748962 T:1535112096 DEBUG: ProcessPacket - audio:69 video:70 18:40:35 706.749695 T:1535112096 DEBUG: Previous line repeats 4 times. 18:40:35 706.749695 T:1535112096 DEBUG: ProcessPacket - audio:69 video:71 18:40:35 706.750061 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.750061 T:1535112096 DEBUG: ProcessPacket - audio:70 video:71 18:40:35 706.750854 T:1535112096 DEBUG: Previous line repeats 4 times. 18:40:35 706.750916 T:1535112096 DEBUG: ProcessPacket - audio:70 video:72 18:40:35 706.751648 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.751709 T:1535112096 DEBUG: ProcessPacket - audio:71 video:72 18:40:35 706.752380 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.752380 T:1535112096 DEBUG: ProcessPacket - audio:71 video:73 18:40:35 706.752869 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.752930 T:1535112096 DEBUG: ProcessPacket - audio:72 video:73 18:40:35 706.753479 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.753540 T:1535112096 DEBUG: ProcessPacket - audio:72 video:74 18:40:35 706.754028 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.754089 T:1535112096 DEBUG: ProcessPacket - audio:73 video:74 18:40:35 706.754639 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.754700 T:1535112096 DEBUG: ProcessPacket - audio:73 video:75 18:40:35 706.755188 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.755188 T:1535112096 DEBUG: ProcessPacket - audio:74 video:75 18:40:35 706.756042 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.756165 T:1535112096 DEBUG: ProcessPacket - audio:74 video:76 18:40:35 706.756714 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.756714 T:1535112096 DEBUG: ProcessPacket - audio:75 video:76 18:40:35 706.757385 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.757385 T:1535112096 DEBUG: ProcessPacket - audio:75 video:77 18:40:35 706.758057 T:1535112096 DEBUG: Previous line repeats 4 times. 18:40:35 706.758118 T:1535112096 DEBUG: ProcessPacket - audio:76 video:77 18:40:35 706.758606 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.758606 T:1535112096 DEBUG: ProcessPacket - audio:76 video:78 18:40:35 706.759155 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.759216 T:1535112096 DEBUG: ProcessPacket - audio:77 video:78 18:40:35 706.759766 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.759827 T:1535112096 DEBUG: ProcessPacket - audio:77 video:79 18:40:35 706.760376 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.760437 T:1535112096 DEBUG: ProcessPacket - audio:78 video:79 18:40:35 706.760986 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.760986 T:1535112096 DEBUG: ProcessPacket - audio:78 video:80 18:40:35 706.761536 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.761536 T:1535112096 DEBUG: ProcessPacket - audio:79 video:80 18:40:35 706.762085 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.762146 T:1535112096 DEBUG: ProcessPacket - audio:79 video:81 18:40:35 706.763123 T:1535112096 DEBUG: Previous line repeats 4 times. 18:40:35 706.763184 T:1535112096 DEBUG: ProcessPacket - audio:80 video:81 18:40:35 706.763611 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.763611 T:1535112096 DEBUG: ProcessPacket - audio:80 video:82 18:40:35 706.764160 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.764221 T:1535112096 DEBUG: ProcessPacket - audio:81 video:82 18:40:35 706.764709 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.764771 T:1535112096 DEBUG: ProcessPacket - audio:81 video:83 18:40:35 706.765320 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.765320 T:1535112096 DEBUG: ProcessPacket - audio:82 video:83 18:40:35 706.765869 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.765869 T:1535112096 DEBUG: ProcessPacket - audio:82 video:84 18:40:35 706.766418 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.766479 T:1535112096 DEBUG: ProcessPacket - audio:83 video:84 18:40:35 706.766968 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.767029 T:1535112096 DEBUG: ProcessPacket - audio:83 video:85 18:40:35 706.767639 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.767639 T:1535112096 DEBUG: ProcessPacket - audio:83 video:86 18:40:35 706.767761 T:1535112096 DEBUG: ProcessPacket - audio:84 video:86 18:40:35 706.768127 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.768188 T:1535112096 DEBUG: ProcessPacket - audio:85 video:86 18:40:35 706.768921 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.768982 T:1535112096 DEBUG: ProcessPacket - audio:85 video:87 18:40:35 706.769409 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.769470 T:1535112096 DEBUG: ProcessPacket - audio:86 video:87 18:40:35 706.770020 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.770081 T:1535112096 DEBUG: ProcessPacket - audio:86 video:88 18:40:35 706.770569 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.770630 T:1535112096 DEBUG: ProcessPacket - audio:87 video:88 18:40:35 706.771179 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.771240 T:1535112096 DEBUG: ProcessPacket - audio:87 video:89 18:40:35 706.771667 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.771729 T:1535112096 DEBUG: ProcessPacket - audio:88 video:89 18:40:35 706.772278 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.772339 T:1535112096 DEBUG: ProcessPacket - audio:88 video:90 18:40:35 706.772827 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.772888 T:1535112096 DEBUG: ProcessPacket - audio:89 video:90 18:40:35 706.773499 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.773499 T:1535112096 DEBUG: ProcessPacket - audio:89 video:91 18:40:35 706.773987 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.774048 T:1535112096 DEBUG: ProcessPacket - audio:90 video:91 18:40:35 706.774597 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.774658 T:1535112096 DEBUG: ProcessPacket - audio:90 video:92 18:40:35 706.775146 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.775146 T:1535112096 DEBUG: ProcessPacket - audio:91 video:92 18:40:35 706.775879 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.775879 T:1535112096 DEBUG: ProcessPacket - audio:91 video:93 18:40:35 706.777222 T:1535112096 DEBUG: Previous line repeats 7 times. 18:40:35 706.777283 T:1535112096 DEBUG: ProcessPacket - audio:91 video:94 18:40:35 706.777771 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.777771 T:1535112096 DEBUG: ProcessPacket - audio:92 video:94 18:40:35 706.778137 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.778198 T:1535112096 DEBUG: ProcessPacket - audio:93 video:94 18:40:35 706.778503 T:1535112096 DEBUG: Previous line repeats 1 times. 18:40:35 706.778564 T:1535112096 DEBUG: ProcessPacket - audio:93 video:95 18:40:35 706.779358 T:1535112096 DEBUG: Previous line repeats 5 times. 18:40:35 706.779358 T:1535112096 DEBUG: ProcessPacket - audio:94 video:95 18:40:35 706.779724 T:1535112096 DEBUG: Previous line repeats 1 times. 18:40:35 706.779724 T:1535112096 DEBUG: ProcessPacket - audio:94 video:96 18:40:35 706.826782 T:1939870624 DEBUG: Previous line repeats 6 times. 18:40:35 706.826904 T:1939870624 DEBUG: ActiveAE::SyncStream - average error of 44.873501, start adjusting 18:40:35 706.826965 T:1939870624 DEBUG: ActiveAE::SyncStream - average error 19.873501 below threshold of 30.000000 18:40:35 706.833557 T:1535112096 DEBUG: ProcessPacket - audio:94 video:96 18:40:35 706.835022 T:1535112096 DEBUG: Previous line repeats 4 times. 18:40:35 706.835083 T:1535112096 DEBUG: ProcessPacket - audio:95 video:96 18:40:35 706.835449 T:1535112096 DEBUG: Previous line repeats 1 times. 18:40:35 706.835449 T:1535112096 DEBUG: ProcessPacket - audio:95 video:97 18:40:35 706.836243 T:1535112096 DEBUG: Previous line repeats 5 times. 18:40:35 706.836304 T:1535112096 DEBUG: ProcessPacket - audio:96 video:97 18:40:35 706.836609 T:1535112096 DEBUG: Previous line repeats 1 times. 18:40:35 706.836670 T:1535112096 DEBUG: ProcessPacket - audio:96 video:98 18:40:35 706.837402 T:1535112096 DEBUG: Previous line repeats 5 times. 18:40:35 706.837463 T:1535112096 DEBUG: ProcessPacket - audio:97 video:98 18:40:35 706.837769 T:1535112096 DEBUG: Previous line repeats 1 times. 18:40:35 706.837830 T:1535112096 DEBUG: ProcessPacket - audio:97 video:99 18:40:35 706.838501 T:1535112096 DEBUG: Previous line repeats 4 times. 18:40:35 706.838501 T:1535112096 DEBUG: ProcessPacket - audio:98 video:99 18:40:35 706.909729 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 706.909851 T:1535112096 DEBUG: ProcessPacket - audio:97 video:99 18:40:35 706.980957 T:1535112096 DEBUG: ProcessPacket - audio:96 video:98 18:40:35 706.981445 T:1535112096 DEBUG: ProcessPacket - audio:96 video:99 18:40:35 706.982788 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:35 706.982849 T:1535112096 DEBUG: ProcessPacket - audio:97 video:99 18:40:35 707.075989 T:1535112096 DEBUG: Previous line repeats 8 times. 18:40:35 707.076172 T:1535112096 DEBUG: ProcessPacket - audio:98 video:99 18:40:35 707.148071 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 707.148254 T:1535112096 DEBUG: ProcessPacket - audio:97 video:99 18:40:35 707.160034 T:1535112096 DEBUG: Previous line repeats 5 times. 18:40:35 707.160156 T:1535112096 DEBUG: ProcessPacket - audio:98 video:99 18:40:35 707.201233 T:1535112096 DEBUG: Previous line repeats 1 times. 18:40:35 707.201538 T:1535112096 DEBUG: ProcessPacket - audio:97 video:99 18:40:35 707.233521 T:1535112096 DEBUG: Previous line repeats 5 times. 18:40:35 707.233643 T:1535112096 DEBUG: ProcessPacket - audio:98 video:99 18:40:35 707.274780 T:1535112096 DEBUG: Previous line repeats 1 times. 18:40:35 707.274963 T:1535112096 DEBUG: ProcessPacket - audio:97 video:99 18:40:35 707.346619 T:1535112096 DEBUG: Previous line repeats 1 times. 18:40:35 707.346863 T:1535112096 DEBUG: ProcessPacket - audio:96 video:99 18:40:35 707.347412 T:1535112096 DEBUG: Previous line repeats 1 times. 18:40:35 707.347473 T:1535112096 DEBUG: ProcessPacket - audio:97 video:99 18:40:35 707.348083 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:35 707.348145 T:1535112096 DEBUG: ProcessPacket - audio:98 video:99 18:40:35 707.358704 T:1535112096 DEBUG: ProcessPacket - audio:97 video:99 18:40:35 707.401245 T:1535112096 DEBUG: Previous line repeats 5 times. 18:40:35 707.401428 T:1535112096 DEBUG: ProcessPacket - audio:98 video:99 18:40:35 707.432556 T:1535112096 DEBUG: Previous line repeats 1 times. 18:40:35 707.432678 T:1535112096 DEBUG: ProcessPacket - audio:97 video:99 18:40:35 707.474487 T:1535112096 DEBUG: Previous line repeats 4 times. 18:40:35 707.474670 T:1535112096 DEBUG: ProcessPacket - audio:98 video:99 18:40:36 707.546204 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:36 707.546387 T:1535112096 DEBUG: ProcessPacket - audio:97 video:99 18:40:36 707.558228 T:1535112096 DEBUG: Previous line repeats 5 times. 18:40:36 707.558350 T:1535112096 DEBUG: ProcessPacket - audio:98 video:99 18:40:36 707.630432 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:36 707.630615 T:1535112096 DEBUG: ProcessPacket - audio:97 video:99 18:40:36 707.672302 T:1535112096 DEBUG: Previous line repeats 4 times. 18:40:36 707.672424 T:1535112096 DEBUG: ProcessPacket - audio:98 video:99 18:40:36 707.744263 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:36 707.744385 T:1535112096 DEBUG: ProcessPacket - audio:97 video:99 18:40:36 707.765381 T:1535112096 DEBUG: Previous line repeats 1 times. 18:40:36 707.765503 T:1535112096 DEBUG: ProcessPacket - audio:96 video:99 18:40:36 707.765747 T:1535112096 DEBUG: ProcessPacket - audio:97 video:99 18:40:36 707.766357 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:36 707.766418 T:1535112096 DEBUG: ProcessPacket - audio:98 video:99 18:40:36 707.797791 T:1535112096 DEBUG: Previous line repeats 1 times. 18:40:36 707.797974 T:1535112096 DEBUG: ProcessPacket - audio:97 video:99 18:40:36 707.829041 T:1535112096 DEBUG: Previous line repeats 1 times. 18:40:36 707.829163 T:1535112096 DEBUG: ProcessPacket - audio:96 video:99 18:40:36 707.829407 T:1535112096 DEBUG: ProcessPacket - audio:97 video:99 18:40:36 707.830017 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:36 707.830078 T:1535112096 DEBUG: ProcessPacket - audio:98 video:99 18:40:36 707.871216 T:1535112096 DEBUG: Previous line repeats 1 times. 18:40:36 707.871338 T:1535112096 DEBUG: ProcessPacket - audio:97 video:99 18:40:36 707.876831 T:1612706720 DEBUG: Previous line repeats 1 times. 18:40:36 707.877014 T:1612706720 DEBUG: CDVDClock::ErrorAdjust - CVideoPlayerAudio::OutputPacket - error:10656.127285, adjusted:10656.127285 18:40:36 707.932739 T:1535112096 DEBUG: ProcessPacket - audio:97 video:99 18:40:36 707.934143 T:1535112096 DEBUG: Previous line repeats 4 times. 18:40:36 707.934204 T:1535112096 DEBUG: ProcessPacket - audio:98 video:99 18:40:36 707.975647 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:36 707.975830 T:1535112096 DEBUG: ProcessPacket - audio:97 video:99 18:40:36 707.977051 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:36 707.977173 T:1535112096 DEBUG: ProcessPacket - audio:98 video:99 18:40:36 708.038757 T:1535112096 DEBUG: Previous line repeats 1 times. 18:40:36 708.038879 T:1535112096 DEBUG: ProcessPacket - audio:97 video:99 18:40:36 708.070007 T:1535112096 DEBUG: Previous line repeats 4 times. 18:40:36 708.070068 T:1535112096 DEBUG: ProcessPacket - audio:98 video:99 18:40:36 708.151794 T:1535112096 DEBUG: Previous line repeats 4 times. 18:40:36 708.151917 T:1535112096 DEBUG: ProcessPacket - audio:97 video:99 18:40:36 708.152466 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:36 708.152466 T:1535112096 DEBUG: ProcessPacket - audio:98 video:99 18:40:36 708.203308 T:1535112096 DEBUG: Previous line repeats 1 times. 18:40:36 708.203430 T:1535112096 DEBUG: ProcessPacket - audio:97 video:99 18:40:36 708.275146 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:36 708.275330 T:1535112096 DEBUG: ProcessPacket - audio:96 video:99 18:40:36 708.275513 T:1535112096 DEBUG: ProcessPacket - audio:97 video:99 18:40:36 708.276062 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:36 708.276123 T:1535112096 DEBUG: ProcessPacket - audio:98 video:99 18:40:36 708.276428 T:1535112096 DEBUG: ProcessPacket - audio:97 video:99 18:40:36 708.348267 T:1535112096 DEBUG: Previous line repeats 5 times. 18:40:36 708.348328 T:1535112096 DEBUG: ProcessPacket - audio:98 video:99 18:40:36 708.399353 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:36 708.399414 T:1535112096 DEBUG: ProcessPacket - audio:97 video:99 18:40:36 708.440247 T:1535112096 DEBUG: Previous line repeats 1 times. 18:40:36 708.440369 T:1535112096 DEBUG: ProcessPacket - audio:96 video:99 18:40:36 708.440552 T:1535112096 DEBUG: ProcessPacket - audio:97 video:99 18:40:36 708.440979 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:36 708.441040 T:1535112096 DEBUG: ProcessPacket - audio:98 video:99 18:40:36 708.471680 T:1535112096 DEBUG: Previous line repeats 1 times. 18:40:36 708.471741 T:1535112096 DEBUG: ProcessPacket - audio:97 video:99 18:40:36 708.502808 T:1535112096 DEBUG: Previous line repeats 4 times. 18:40:36 708.503113 T:1535112096 DEBUG: ProcessPacket - audio:98 video:99 18:40:37 708.592590 T:1535112096 DEBUG: ProcessPacket - audio:97 video:99 18:40:37 708.603516 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:37 708.603577 T:1535112096 DEBUG: ProcessPacket - audio:96 video:99 18:40:37 708.603882 T:1535112096 DEBUG: Previous line repeats 1 times. 18:40:37 708.603943 T:1535112096 DEBUG: ProcessPacket - audio:97 video:99 18:40:37 708.604309 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:37 708.604309 T:1535112096 DEBUG: ProcessPacket - audio:98 video:99 18:40:37 708.645020 T:1535112096 DEBUG: ProcessPacket - audio:97 video:99 18:40:37 708.676270 T:1535112096 DEBUG: Previous line repeats 4 times. 18:40:37 708.676514 T:1535112096 DEBUG: ProcessPacket - audio:98 video:99 18:40:37 708.748108 T:1535112096 DEBUG: Previous line repeats 4 times. 18:40:37 708.748169 T:1535112096 DEBUG: ProcessPacket - audio:97 video:99 18:40:37 708.748718 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:37 708.748718 T:1535112096 DEBUG: ProcessPacket - audio:98 video:99 18:40:37 708.840576 T:1535112096 DEBUG: Previous line repeats 4 times. 18:40:37 708.840759 T:1535112096 DEBUG: ProcessPacket - audio:97 video:99 18:40:37 708.841736 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:37 708.841797 T:1535112096 DEBUG: ProcessPacket - audio:98 video:99 18:40:37 708.903503 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:37 708.903625 T:1535112096 DEBUG: ProcessPacket - audio:97 video:99 18:40:37 708.954529 T:1535112096 DEBUG: Previous line repeats 1 times. 18:40:37 708.954651 T:1535112096 DEBUG: ProcessPacket - audio:96 video:99 18:40:37 708.954773 T:1535112096 DEBUG: ProcessPacket - audio:97 video:99 18:40:37 708.955200 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:37 708.955200 T:1535112096 DEBUG: ProcessPacket - audio:98 video:99 18:40:37 709.006042 T:1535112096 DEBUG: Previous line repeats 1 times. 18:40:37 709.006104 T:1535112096 DEBUG: ProcessPacket - audio:97 video:99 18:40:37 709.037109 T:1535112096 DEBUG: Previous line repeats 1 times. 18:40:37 709.037231 T:1535112096 DEBUG: ProcessPacket - audio:96 video:99 18:40:37 709.037354 T:1535112096 DEBUG: ProcessPacket - audio:97 video:99 18:40:37 709.037781 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:37 709.037781 T:1535112096 DEBUG: ProcessPacket - audio:98 video:99 18:40:37 709.068481 T:1535112096 DEBUG: Previous line repeats 1 times. 18:40:37 709.068604 T:1535112096 DEBUG: ProcessPacket - audio:97 video:99 18:40:37 709.099548 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:37 709.099609 T:1535112096 DEBUG: ProcessPacket - audio:98 video:99 18:40:37 709.150818 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:37 709.150879 T:1535112096 DEBUG: ProcessPacket - audio:97 video:99 18:40:37 709.201782 T:1535112096 DEBUG: Previous line repeats 1 times. 18:40:37 709.201904 T:1535112096 DEBUG: ProcessPacket - audio:96 video:99 18:40:37 709.202209 T:1535112096 DEBUG: Previous line repeats 1 times. 18:40:37 709.202271 T:1535112096 DEBUG: ProcessPacket - audio:97 video:99 18:40:37 709.202637 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:37 709.202698 T:1535112096 DEBUG: ProcessPacket - audio:98 video:99 18:40:37 709.243347 T:1535112096 DEBUG: ProcessPacket - audio:97 video:99 18:40:37 709.274902 T:1535112096 DEBUG: Previous line repeats 4 times. 18:40:37 709.275024 T:1535112096 DEBUG: ProcessPacket - audio:98 video:99 18:40:37 709.305847 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:37 709.305969 T:1535112096 DEBUG: ProcessPacket - audio:97 video:99 18:40:37 709.330505 T:1545597856 DEBUG: Previous line repeats 1 times. 18:40:37 709.330627 T:1545597856 DEBUG: CPullupCorrection: detected pattern of length 1: 19999.99, frameduration: 20000.000000 18:40:37 709.346863 T:1535112096 DEBUG: ProcessPacket - audio:97 video:99 18:40:37 709.347351 T:1535112096 DEBUG: Previous line repeats 2 times. 18:40:37 709.347412 T:1535112096 DEBUG: ProcessPacket - audio:98 video:99 18:40:37 709.439026 T:1535112096 DEBUG: Previous line repeats 4 times. 18:40:37 709.439148 T:1535112096 DEBUG: ProcessPacket - audio:97 video:99 18:40:37 709.439697 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:37 709.439758 T:1535112096 DEBUG: ProcessPacket - audio:98 video:99 18:40:38 709.521912 T:1535112096 DEBUG: Previous line repeats 3 times. 18:40:38 709.522095 T:1535112096 DEBUG: ProcessPacket - audio:97 video:99 18:40:38 709.524963 T:1803547552 DEBUG: Previous line repeats 1 times. 18:40:38 709.525146 T:1803547552 DEBUG: PushCecKeypress - received key e0 duration 1000 (rep:0 size:0) 18:40:38 709.525208 T:1803547552 DEBUG: PushCecKeypress - added key e0 18:40:38 709.539673 T:1961263104 DEBUG: OnKey: guide (0xe0) pressed, action is Stop 18:40:38 709.539917 T:1961263104 NOTICE: CVideoPlayer::CloseFile() 18:40:38 709.539978 T:1961263104 NOTICE: VideoPlayer: waiting for threads to exit 18:40:38 709.542725 T:1535112096 NOTICE: CVideoPlayer::OnExit() 18:40:38 709.542786 T:1535112096 NOTICE: Closing stream player 1 18:40:38 709.542847 T:1535112096 NOTICE: Waiting for audio thread to exit 18:40:38 709.551392 T:1612706720 NOTICE: thread end: CVideoPlayerAudio::OnExit() 18:40:38 709.551514 T:1612706720 DEBUG: Thread VideoPlayerAudio 1612706720 terminating 18:40:38 709.551575 T:1535112096 NOTICE: Closing audio device 18:40:38 709.575806 T:1535112096 DEBUG: CDVDAudio::Flush - flush audio stream 18:40:38 709.575928 T:1939870624 DEBUG: CActiveAE::DiscardStream - audio stream deleted 18:40:38 709.576172 T:1939870624 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 18:40:38 709.576721 T:1930425248 DEBUG: Previous line repeats 2 times. 18:40:38 709.576782 T:1930425248 INFO: CActiveAESink::OpenSink - initialize sink 18:40:38 709.579041 T:1535112096 NOTICE: Deleting audio codec 18:40:38 709.579346 T:1535112096 NOTICE: Closing stream player 2 18:40:38 709.579468 T:1535112096 NOTICE: waiting for video thread to exit 18:40:38 709.615356 T:1545597856 NOTICE: thread end: video_thread 18:40:38 709.615479 T:1545597856 DEBUG: Thread VideoPlayerVideo 1545597856 terminating 18:40:38 709.618286 T:1535112096 NOTICE: deleting video codec 18:40:38 709.625732 T:1535112096 DEBUG: CVideoPlayerVideo::CloseStream - drop:1 skip:0 18:40:38 709.626099 T:1930425248 DEBUG: CAESinkPi:Drain delay:49ms now:0ms 18:40:38 709.626221 T:1930425248 DEBUG: CAESinkPi:Deinitialize 18:40:38 709.626587 T:1930425248 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000000 18:40:38 709.630249 T:1535112096 DEBUG: OnPlayBackStopped: play state was 2, starting 0 18:40:38 709.634766 T:1535112096 DEBUG: Thread VideoPlayer 1535112096 terminating 18:40:38 709.635315 T:1961263104 NOTICE: VideoPlayer: finished waiting 18:40:38 709.635559 T:1961263104 DEBUG: DeleteRenderer - deleting renderer 18:40:38 709.635620 T:1961263104 DEBUG: CMMALRenderer::~CMMALRenderer 18:40:38 709.635803 T:1930425248 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.audio_render handle 0x727c90c8 18:40:38 709.635864 T:1961263104 DEBUG: CMMALRenderer::UnInitMMAL 18:40:38 709.636230 T:1930425248 DEBUG: CActiveAESink::OpenSink - trying to open device PI:HDMI 18:40:38 709.636414 T:1930425248 DEBUG: CAESinkPi:Initialize Format:15 Channels:2 Samplerate:44100 framesize:8 bufsize:8816 bytes/s=352800.00 dest=PI:HDMI 18:40:38 709.636780 T:1930425248 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000008 18:40:38 709.638794 T:1930425248 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_render input port 100 output port 100 m_handle 0x727d8d80 18:40:38 709.639221 T:1595929504 DEBUG: CMMALRenderer::Process - stopping 18:40:38 709.639282 T:1595929504 DEBUG: Thread MMALRenderer 1595929504 terminating 18:40:38 709.641174 T:1930425248 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.audio_render) - port(100), nBufferCountMin(1), nBufferCountActual(2), nBufferSize(8816), nBufferAlignmen(16) 18:40:38 709.641846 T:1930425248 DEBUG: CActiveAESink::OpenSink - SinkPi Initialized: 18:40:38 709.641907 T:1930425248 DEBUG: Output Device : HDMI 18:40:38 709.641968 T:1930425248 DEBUG: Sample Rate : 44100 18:40:38 709.642029 T:1930425248 DEBUG: Sample Format : AE_FMT_FLOAT 18:40:38 709.642090 T:1930425248 DEBUG: Channel Count : 2 18:40:38 709.642151 T:1930425248 DEBUG: Channel Layout: FL,FR 18:40:38 709.642212 T:1930425248 DEBUG: Frames : 1102 18:40:38 709.642273 T:1930425248 DEBUG: Frame Size : 8 18:40:38 709.646179 T:1939870624 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted 18:40:38 709.649170 T:1961255840 DEBUG: Previous line repeats 1 times. 18:40:38 709.649292 T:1961255840 DEBUG: GetMovieId (http://zh2-4-hls-pvr.zahs.tv/HD_tsi1/1476009900/1476017100.m3u8?z32=NVQXQ4TBORST2MBGOVZWK4S7NFSD2MRRG43TGMBQG4THK5LJMQ6TQOBYMI2GMNJUFVRTCMRXFUYTCZJVFU4TSMJSFVRGCMDCMUYDIOBTMMYTQJTJNZUXI2LBNRZGC5DFHUYCM43JM46TGNTDMRRTOOLFMU2GKZDGGAZTQNBXGRQWKNBZMM2DONBVGQ2TQNJGNVUW44TBORST2NRQGATGG2DBNZXGK3B5INEF6SDJKFPXI43JGETGG43JMQ6TCNBXIM4DONSDHE2DGMRWIM4TGLJVGAYUMRBTGI4DSNZUIJATQRJU), query = select idMovie from movie where idFile=4 18:40:38 709.650757 T:1961255840 DEBUG: GetEpisodeId (http://zh2-4-hls-pvr.zahs.tv/HD_tsi1/1476009900/1476017100.m3u8?z32=NVQXQ4TBORST2MBGOVZWK4S7NFSD2MRRG43TGMBQG4THK5LJMQ6TQOBYMI2GMNJUFVRTCMRXFUYTCZJVFU4TSMJSFVRGCMDCMUYDIOBTMMYTQJTJNZUXI2LBNRZGC5DFHUYCM43JM46TGNTDMRRTOOLFMU2GKZDGGAZTQNBXGRQWKNBZMM2DONBVGQ2TQNJGNVUW44TBORST2NRQGATGG2DBNZXGK3B5INEF6SDJKFPXI43JGETGG43JMQ6TCNBXIM4DONSDHE2DGMRWIM4TGLJVGAYUMRBTGI4DSNZUIJATQRJU), query = select idEpisode from episode where idFile=4 18:40:38 709.651978 T:1961255840 DEBUG: GetMusicVideoId (http://zh2-4-hls-pvr.zahs.tv/HD_tsi1/1476009900/1476017100.m3u8?z32=NVQXQ4TBORST2MBGOVZWK4S7NFSD2MRRG43TGMBQG4THK5LJMQ6TQOBYMI2GMNJUFVRTCMRXFUYTCZJVFU4TSMJSFVRGCMDCMUYDIOBTMMYTQJTJNZUXI2LBNRZGC5DFHUYCM43JM46TGNTDMRRTOOLFMU2GKZDGGAZTQNBXGRQWKNBZMM2DONBVGQ2TQNJGNVUW44TBORST2NRQGATGG2DBNZXGK3B5INEF6SDJKFPXI43JGETGG43JMQ6TCNBXIM4DONSDHE2DGMRWIM4TGLJVGAYUMRBTGI4DSNZUIJATQRJU), query = select idMVideo from musicvideo where idFile=4 18:40:38 709.657288 T:1961255840 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc 18:40:38 709.657532 T:1961255840 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop 18:40:38 709.658264 T:1961263104 DEBUG: CMMALPool::~CMMALPool Destroying pool 0x65eee660 for port vc.ril.video_decode:out:0(OPQV) 18:40:38 709.662048 T:1526723488 DEBUG: CMMALRenderer::Run - stopping 18:40:38 709.662109 T:1526723488 DEBUG: Thread MMALProcess 1526723488 terminating 18:40:38 709.662231 T:1961263104 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate 18:40:38 709.662354 T:1961263104 DEBUG: ------ Window Deinit (VideoFullScreen.xml) ------ 18:40:38 709.688232 T:1961263104 DEBUG: CGUIWindowManager::PreviousWindow: Activate new 18:40:38 709.688416 T:1961263104 DEBUG: ------ Window Init (Home.xml) ------ 18:40:38 709.688904 T:1961263104 DEBUG: CDirectoryProvider[videodb://inprogresstvshows]: refreshing.. 18:40:38 709.689331 T:1961263104 DEBUG: CDirectoryProvider[special://skin/playlists/mostplayed_albums.xsp]: refreshing.. 18:40:38 709.689514 T:1526723488 DEBUG: Thread JobWorker start, auto delete: true 18:40:38 709.689636 T:1961263104 DEBUG: CDirectoryProvider[addons://sources/video/]: refreshing.. 18:40:38 709.689758 T:1961263104 DEBUG: CDirectoryProvider[addons://sources/audio/]: refreshing.. 18:40:38 709.689880 T:1604318112 DEBUG: Thread JobWorker start, auto delete: true 18:40:38 709.690002 T:1961263104 DEBUG: CDirectoryProvider[addons://sources/executable/]: refreshing.. 18:40:38 709.690125 T:1961263104 DEBUG: CDirectoryProvider[addons://sources/image/]: refreshing.. 18:40:38 709.690552 T:1961263104 DEBUG: CDirectoryProvider[pvr://channels/tv/*?view=lastplayed]: refreshing.. 18:40:38 709.690918 T:1961263104 DEBUG: CDirectoryProvider[pvr://channels/radio/*?view=lastplayed]: refreshing.. 18:40:38 709.715149 T:1526723488 DEBUG: GetAlbumsByWhere query: SELECT albumview.* FROM albumview WHERE (albumview.strReleaseType = 'album') AND (((CAST(albumview.iTimesPlayed as DECIMAL(5,1)) > 0))) 18:40:38 709.717407 T:1526723488 DEBUG: GetAlbumsByWhere - query took 2 ms 18:40:38 709.719238 T:1586484128 DEBUG: RunQuery took 5 ms for 0 items query: SELECT * FROM tvshow_view WHERE watchedCount != 0 AND totalCount != watchedCount ORDER BY c00 18:40:38 709.723083 T:1586484128 DEBUG: CPVRDirectory::GetDirectory(pvr://channels/tv/*?view=lastplayed) 18:40:38 709.736694 T:1604318112 DEBUG: CPVRDirectory::GetDirectory(pvr://channels/radio/*?view=lastplayed) 18:40:38 709.742737 T:1961263104 NOTICE: CVideoPlayer::CloseFile() 18:40:38 709.742920 T:1961263104 NOTICE: VideoPlayer: waiting for threads to exit 18:40:38 709.742981 T:1961263104 NOTICE: VideoPlayer: finished waiting 18:40:38 709.743103 T:1961263104 NOTICE: CVideoPlayer::CloseFile() 18:40:38 709.743225 T:1961263104 NOTICE: VideoPlayer: waiting for threads to exit 18:40:38 709.743286 T:1961263104 NOTICE: VideoPlayer: finished waiting 18:40:38 709.749146 T:1961263104 DEBUG: Radio UECP (RDS) Processor - delete ~CDVDRadioRDSData 18:40:38 709.751038 T:1586484128 DEBUG: DoWork - Saving file state for video item http://zh2-4-hls-pvr.zahs.tv/HD_tsi1/1476009900/1476017100.m3u8?z32=NVQXQ4TBORST2MBGOVZWK4S7NFSD2MRRG43TGMBQG4THK5LJMQ6TQOBYMI2GMNJUFVRTCMRXFUYTCZJVFU4TSMJSFVRGCMDCMUYDIOBTMMYTQJTJNZUXI2LBNRZGC5DFHUYCM43JM46TGNTDMRRTOOLFMU2GKZDGGAZTQNBXGRQWKNBZMM2DONBVGQ2TQNJGNVUW44TBORST2NRQGATGG2DBNZXGK3B5INEF6SDJKFPXI43JGETGG43JMQ6TCNBXIM4DONSDHE2DGMRWIM4TGLJVGAYUMRBTGI4DSNZUIJATQRJU 18:40:39 710.759949 T:1803547552 DEBUG: PushCecKeypress - received key a6 duration 0 (rep:0 size:0) 18:40:39 710.760132 T:1803547552 DEBUG: PushCecKeypress - added key a6 18:40:39 710.762512 T:1961263104 DEBUG: OnKey: 166 (0xa6, obc89) pressed, action is Up 18:40:39 710.909607 T:1803547552 DEBUG: PushCecKeypress - received key a6 duration 149 (rep:0 size:0) 18:40:39 710.909729 T:1803547552 DEBUG: PushCecKeypress - ignored key a6 18:40:39 711.164185 T:1803547552 DEBUG: PushCecKeypress - received key a8 duration 0 (rep:0 size:0) 18:40:39 711.164368 T:1803547552 DEBUG: PushCecKeypress - added key a8 18:40:39 711.172791 T:1961263104 DEBUG: OnKey: 168 (0xa8, obc87) pressed, action is Right 18:40:39 711.313599 T:1803547552 DEBUG: PushCecKeypress - received key a8 duration 150 (rep:0 size:0) 18:40:39 711.313782 T:1803547552 DEBUG: PushCecKeypress - ignored key a8 18:40:40 711.785156 T:1803547552 DEBUG: PushCecKeypress - received key b duration 0 (rep:0 size:0) 18:40:40 711.785339 T:1803547552 DEBUG: PushCecKeypress - added key b 18:40:40 711.790222 T:1961263104 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 18:40:40 711.802246 T:1961263104 DEBUG: Loading settings for pvr://channels/tv/All channels/pvr.zattoo_1669258550.pvr 18:40:40 711.809448 T:1961263104 DEBUG: Radio UECP (RDS) Processor - new CDVDRadioRDSData 18:40:40 711.809753 T:1961263104 NOTICE: VideoPlayer: Opening: pvr://channels/tv/All channels/pvr.zattoo_1669258550.pvr 18:40:40 711.809875 T:1961263104 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 18:40:40 711.809998 T:1961263104 DEBUG: CMMALRenderer::CMMALRenderer 18:40:40 711.810181 T:1961263104 DEBUG: CMMALRenderer::UnInitMMAL 18:40:40 711.810242 T:1961263104 DEBUG: CMMALRenderer::PreInit 18:40:40 711.810303 T:1553986464 DEBUG: Thread MMALProcess start, auto delete: false 18:40:40 711.810364 T:1553986464 DEBUG: CMMALRenderer::Run - starting 18:40:40 711.810364 T:1595929504 DEBUG: Thread VideoPlayer start, auto delete: false 18:40:40 711.810608 T:1595929504 NOTICE: Creating InputStream 18:40:40 711.811340 T:1595929504 DEBUG: PVRManager - OpenLiveStream - opening live stream on channel 'BBC One HD' 18:40:40 711.811401 T:1595929504 DEBUG: opening live stream on url 'pvr://stream/tv/zattoo.ts' 18:40:40 711.884216 T:1595929504 DEBUG: CDVDInputStreamPVRManager - Open - playback has started on filename pvr://channels/tv/All channels/pvr.zattoo_1669258550.pvr 18:40:40 711.884827 T:1595929504 DEBUG: CFileCache::Open - opening using cache 18:40:40 711.885132 T:1595929504 DEBUG: CurlFile::Open(0x745162a8) http://zattoo.com/zapi/watch 18:40:40 711.906006 T:1595929504 ERROR: CCurlFile::FillBuffer - Failed: HTTP returned error 403 18:40:40 711.906067 T:1595929504 ERROR: CCurlFile::Open failed with code 403 for http://zattoo.com/zapi/watch|acceptencoding=gzip&postdata=Y2lkPWJiYy1vbmUmc3RyZWFtX3R5cGU9aGxzJmZvcm1hdD1qc29u 18:40:40 711.906128 T:1595929504 ERROR: Open - failed to open source 18:40:40 711.906250 T:1595929504 DEBUG: AddOnLog: Zattoo PVR Client: Open URL failed. Try to re-init session. 18:40:40 711.906433 T:1803547552 DEBUG: PushCecKeypress - received key b duration 121 (rep:0 size:0) 18:40:40 711.906494 T:1803547552 DEBUG: PushCecKeypress - ignored key b 18:40:40 711.906494 T:1595929504 DEBUG: CFileCache::Open - opening using cache 18:40:40 711.906799 T:1595929504 DEBUG: CurlFile::Open(0x745162e8) http://zattoo.com/zapi/v2/session 18:40:40 711.936646 T:1535112096 DEBUG: Thread FileCache start, auto delete: false 18:40:40 711.936951 T:1535112096 INFO: CFileCache::Process - Source read didn't return any data! Hit eof(?) 18:40:40 711.987000 T:1535112096 DEBUG: Thread FileCache 1535112096 terminating 18:40:40 711.987549 T:1595929504 DEBUG: AddOnLog: Zattoo PVR Client: Need to login. 18:40:40 711.987610 T:1595929504 DEBUG: AddOnLog: Zattoo PVR Client: Send hello. 18:40:40 711.988403 T:1595929504 DEBUG: CFileCache::Open - opening using cache 18:40:40 711.989197 T:1595929504 DEBUG: CurlFile::Open(0x7450f2d8) http://zattoo.com/zapi/session/hello 18:40:40 712.006165 T:1595929504 ERROR: CCurlFile::FillBuffer - Failed: HTTP returned error 403 18:40:40 712.006287 T:1595929504 ERROR: CCurlFile::Open failed with code 403 for http://zattoo.com/zapi/session/hello|acceptencoding=gzip&postdata=dXVpZD04ODhiNGY1NC1jMTI3LTExZTUtOTkxMi1iYTBiZTA0ODNjMTgmbGFuZz1lbiZmb3JtYXQ9anNvbiZjbGllbnRfYXBwX3Rva2VuPWVlOGZkMmYxYmNjYjNhYTM2ZmJjMjIyYmIyYTczZDhm 18:40:40 712.006470 T:1595929504 ERROR: Open - failed to open source 18:40:40 712.006592 T:1595929504 ERROR: AddOnLog: Zattoo PVR Client: Open URL failed during init. 18:40:40 712.006714 T:1595929504 ERROR: AddOnLog: Zattoo PVR Client: Hello failed. 18:40:40 712.006775 T:1595929504 ERROR: AddOnLog: Zattoo PVR Client: Re-init of session. Failed. 18:40:40 712.007141 T:1595929504 ERROR: CDVDInputStreamPVRManager::Open - error opening [] 18:40:40 712.007263 T:1595929504 ERROR: CVideoPlayer::OpenInputStream - error opening [pvr://channels/tv/All channels/pvr.zattoo_1669258550.pvr] 18:40:40 712.007324 T:1595929504 NOTICE: CVideoPlayer::OnExit() 18:40:40 712.046936 T:1595929504 DEBUG: CDVDInputStreamPVRManager::Close - stream closed 18:40:40 712.047119 T:1595929504 DEBUG: OnPlayBackStopped: play state was 1, starting 1 18:40:40 712.047180 T:1595929504 DEBUG: Thread VideoPlayer 1595929504 terminating 18:40:40 712.047241 T:1961263104 DEBUG: OnPlayBackStopped: play state was 3, starting 0 18:40:40 712.047485 T:1961255840 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc 18:40:40 712.047729 T:1961255840 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop 18:40:40 712.047913 T:1961263104 ERROR: PlayMedia could not play media: pvr://channels/tv/All channels/pvr.zattoo_1669258550.pvr 18:40:40 712.049561 T:1961263104 DEBUG: CDirectoryProvider[pvr://channels/tv/*?view=lastplayed]: refreshing.. 18:40:40 712.051453 T:1604318112 DEBUG: CPVRDirectory::GetDirectory(pvr://channels/tv/*?view=lastplayed) 18:40:40 712.062927 T:1961263104 NOTICE: CVideoPlayer::CloseFile() 18:40:40 712.063110 T:1961263104 NOTICE: VideoPlayer: waiting for threads to exit 18:40:40 712.063293 T:1961263104 NOTICE: VideoPlayer: finished waiting 18:40:40 712.063416 T:1961263104 DEBUG: DeleteRenderer - deleting renderer 18:40:40 712.063477 T:1961263104 DEBUG: CMMALRenderer::~CMMALRenderer 18:40:40 712.063538 T:1961263104 DEBUG: CMMALRenderer::UnInitMMAL 18:40:40 712.063782 T:1553986464 DEBUG: CMMALRenderer::Run - stopping 18:40:40 712.063904 T:1553986464 DEBUG: Thread MMALProcess 1553986464 terminating 18:40:40 712.063965 T:1961263104 NOTICE: CVideoPlayer::CloseFile() 18:40:40 712.064087 T:1961263104 NOTICE: VideoPlayer: waiting for threads to exit 18:40:40 712.064209 T:1961263104 NOTICE: VideoPlayer: finished waiting 18:40:40 712.069275 T:1961263104 DEBUG: Radio UECP (RDS) Processor - delete ~CDVDRadioRDSData 18:40:41 713.187744 T:1803547552 DEBUG: PushCecKeypress - received key 32 duration 0 (rep:0 size:0) 18:40:41 713.187805 T:1803547552 DEBUG: PushCecKeypress - added key 32 18:40:41 713.201660 T:1961263104 DEBUG: OnKey: two (0x32) pressed, action is ActivateWindow(TVGuide) 18:40:41 713.201904 T:1961263104 DEBUG: Activating window ID: 10702 18:40:41 713.309265 T:1803547552 DEBUG: PushCecKeypress - received key 32 duration 122 (rep:0 size:0) 18:40:41 713.309387 T:1803547552 DEBUG: PushCecKeypress - ignored key 32 18:40:42 713.514648 T:1961263104 DEBUG: ------ Window Deinit (Home.xml) ------ 18:40:42 713.522522 T:1961263104 DEBUG: ------ Window Init (MyPVRGuide.xml) ------ 18:40:42 713.524963 T:1553986464 DEBUG: Thread epg-grid-refresh-timeline-items start, auto delete: false 18:40:43 715.042297 T:1803547552 DEBUG: PushCecKeypress - received key d2 duration 0 (rep:0 size:0) 18:40:43 715.042419 T:1803547552 DEBUG: PushCecKeypress - added key d2 18:40:43 715.064453 T:1961263104 DEBUG: OnKey: leftshift (0xd2) pressed, action is PageUp 18:40:43 715.164368 T:1803547552 DEBUG: PushCecKeypress - received key d2 duration 122 (rep:0 size:0) 18:40:43 715.164490 T:1803547552 DEBUG: PushCecKeypress - ignored key d2 18:40:44 716.099854 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 18:40:44 716.099976 T:1803547552 DEBUG: PushCecKeypress - added key a7 18:40:44 716.125000 T:1961263104 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 18:40:44 716.221008 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 121 (rep:0 size:0) 18:40:44 716.221130 T:1803547552 DEBUG: PushCecKeypress - ignored key a7 18:40:45 716.761230 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 18:40:45 716.761353 T:1803547552 DEBUG: PushCecKeypress - added key a7 18:40:45 716.801880 T:1961263104 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 18:40:45 717.061829 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 0 (rep:0 size:0) 18:40:45 717.062012 T:1803547552 DEBUG: PushCecKeypress - added key a7 18:40:45 717.072693 T:1961263104 DEBUG: OnKey: 167 (0xa7, obc88) pressed, action is Down 18:40:45 717.197510 T:1803547552 DEBUG: PushCecKeypress - received key a7 duration 436 (rep:0 size:0) 18:40:45 717.197693 T:1803547552 DEBUG: PushCecKeypress - ignored key a7 18:40:46 717.631653 T:1803547552 DEBUG: PushCecKeypress - received key b duration 0 (rep:0 size:0) 18:40:46 717.631714 T:1803547552 DEBUG: PushCecKeypress - added key b 18:40:46 717.654419 T:1961263104 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 18:40:46 717.654541 T:1961263104 DEBUG: ------ Window Init (DialogPVRInfo.xml) ------ 18:40:46 717.654602 T:1961263104 INFO: Loading skin file: DialogPVRInfo.xml, load type: LOAD_EVERY_TIME 18:40:46 717.654785 T:1961263104 DEBUG: Using already stored xml root node for /usr/share/kodi/addons/skin.estuary/1080i/DialogPVRInfo.xml 18:40:46 717.673401 T:1586484128 INFO: easy_aquire - Created session to http://images.zattic.com 18:40:46 717.696777 T:1586484128 DEBUG: CurlFile::Open(0x69639a60) http://images.zattic.com/system/images/b44c/7213/1fb4/cc83/f5ca/format_480x360.jpg 18:40:46 717.753906 T:1803547552 DEBUG: PushCecKeypress - received key b duration 122 (rep:0 size:0) 18:40:46 717.754089 T:1803547552 DEBUG: PushCecKeypress - ignored key b 18:40:46 717.842285 T:1586484128 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x6963ab08 18:40:46 717.843079 T:1586484128 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 18:40:46 717.846497 T:1586484128 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_encode input port 340 output port 341 m_handle 0x6963bc60 18:40:46 717.847351 T:1586484128 DEBUG: COMXCoreComponent::AllocOutputBuffers component(OMX.broadcom.image_encode) - port(341), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(176640) nBufferAlignmen(16) 18:40:46 717.903259 T:1586484128 DEBUG: COMXReEnc::ReEncode : http://images.zattic.com/system/images/b44c/7213/1fb4/cc83/f5ca/format_480x360.jpg 480x360 -> 480x360 18:40:46 717.904846 T:1586484128 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x6963ab08 18:40:46 717.925842 T:1586484128 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_encode handle 0x6963bc60 18:40:46 717.933716 T:1586484128 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x6fd16080 18:40:46 717.934509 T:1586484128 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 18:40:46 717.937256 T:1586484128 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x696399b8 18:40:46 717.937866 T:1586484128 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 18:40:46 717.947388 T:1586484128 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x6fd16080 18:40:46 717.948303 T:1586484128 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x696399b8 18:40:46 717.948425 T:1586484128 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/c/cbde53d2.jpg 480x360 18:40:46 717.948547 T:1586484128 DEBUG: Fast Caching image 'http://images.zattic.com/system/images/b44c/7213/1fb4/cc83/f5ca/format_480x360.jpg' to 'c/cbde53d2.jpg': 0x4542b00 18:40:47 718.886841 T:1803547552 DEBUG: PushCecKeypress - received key b duration 0 (rep:0 size:0) 18:40:47 718.886963 T:1803547552 DEBUG: PushCecKeypress - added key b 18:40:47 718.901428 T:1961263104 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 18:40:47 718.928772 T:1961263104 DEBUG: Loading settings for pvr://channels/tv/All channels/pvr.zattoo_442127252.pvr 18:40:47 718.930359 T:1961263104 DEBUG: CPlayerCoreFactory::GetPlayers(pvr://channels/tv/All channels/pvr.zattoo_442127252.pvr) 18:40:47 718.930420 T:1961263104 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules 18:40:47 718.930481 T:1961263104 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules 18:40:47 718.930542 T:1961263104 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mms/udp 18:40:47 718.930664 T:1961263104 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 18:40:47 718.930725 T:1961263104 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp 18:40:47 718.930786 T:1961263104 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp 18:40:47 718.930847 T:1961263104 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams 18:40:47 718.930908 T:1961263104 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd 18:40:47 718.930969 T:1961263104 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage 18:40:47 718.931030 T:1961263104 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 18:40:47 718.931091 T:1961263104 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv 18:40:47 718.931152 T:1961263104 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio 18:40:47 718.931274 T:1961263104 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players 18:40:47 718.931335 T:1961263104 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (VideoPlayer) 18:40:47 718.931396 T:1961263104 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0 18:40:47 718.931396 T:1961263104 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1 18:40:47 718.931458 T:1961263104 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players 18:40:47 718.936157 T:1961263104 DEBUG: Radio UECP (RDS) Processor - new CDVDRadioRDSData 18:40:47 718.936401 T:1961263104 NOTICE: VideoPlayer: Opening: pvr://channels/tv/All channels/pvr.zattoo_442127252.pvr 18:40:47 718.936523 T:1961263104 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 18:40:47 718.936646 T:1961263104 DEBUG: CMMALRenderer::CMMALRenderer 18:40:47 718.936768 T:1961263104 DEBUG: CMMALRenderer::UnInitMMAL 18:40:47 718.936829 T:1961263104 DEBUG: CMMALRenderer::PreInit 18:40:47 718.936890 T:1595929504 DEBUG: Thread MMALProcess start, auto delete: false 18:40:47 718.937012 T:1535112096 DEBUG: Thread VideoPlayer start, auto delete: false 18:40:47 718.937073 T:1595929504 DEBUG: CMMALRenderer::Run - starting 18:40:47 718.937195 T:1535112096 NOTICE: Creating InputStream 18:40:47 718.937866 T:1535112096 DEBUG: PVRManager - OpenLiveStream - opening live stream on channel 'ARTE HD' 18:40:47 718.937988 T:1535112096 DEBUG: opening live stream on url 'pvr://stream/tv/zattoo.ts' 18:40:47 719.008179 T:1803547552 DEBUG: PushCecKeypress - received key b duration 122 (rep:0 size:0) 18:40:47 719.008240 T:1803547552 DEBUG: PushCecKeypress - ignored key b 18:40:47 719.136780 T:1535112096 DEBUG: CDVDInputStreamPVRManager - Open - playback has started on filename pvr://channels/tv/All channels/pvr.zattoo_442127252.pvr 18:40:47 719.137878 T:1535112096 DEBUG: CFileCache::Open - opening using cache 18:40:47 719.138550 T:1535112096 DEBUG: CurlFile::Open(0x6f501300) http://zattoo.com/zapi/watch 18:40:47 719.163452 T:1535112096 ERROR: CCurlFile::FillBuffer - Failed: HTTP returned error 403 18:40:47 719.163574 T:1535112096 ERROR: CCurlFile::Open failed with code 403 for http://zattoo.com/zapi/watch|acceptencoding=gzip&postdata=Y2lkPURFX2FydGUmc3RyZWFtX3R5cGU9aGxzJmZvcm1hdD1qc29u 18:40:47 719.163757 T:1535112096 ERROR: Open - failed to open source 18:40:47 719.163879 T:1535112096 DEBUG: AddOnLog: Zattoo PVR Client: Open URL failed. Try to re-init session. 18:40:47 719.164429 T:1535112096 DEBUG: CFileCache::Open - opening using cache 18:40:47 719.164917 T:1535112096 DEBUG: CurlFile::Open(0x6f503ef8) http://zattoo.com/zapi/v2/session 18:40:47 719.191406 T:1612706720 DEBUG: Thread FileCache start, auto delete: false 18:40:47 719.191772 T:1612706720 INFO: CFileCache::Process - Source read didn't return any data! Hit eof(?) 18:40:47 719.241821 T:1612706720 DEBUG: Thread FileCache 1612706720 terminating 18:40:47 719.242371 T:1535112096 DEBUG: AddOnLog: Zattoo PVR Client: Need to login. 18:40:47 719.242493 T:1535112096 DEBUG: AddOnLog: Zattoo PVR Client: Send hello. 18:40:47 719.243286 T:1535112096 DEBUG: CFileCache::Open - opening using cache 18:40:47 719.244019 T:1535112096 DEBUG: CurlFile::Open(0x6f5013d8) http://zattoo.com/zapi/session/hello 18:40:47 719.259216 T:1535112096 ERROR: CCurlFile::FillBuffer - Failed: HTTP returned error 403 18:40:47 719.259338 T:1535112096 ERROR: CCurlFile::Open failed with code 403 for http://zattoo.com/zapi/session/hello|acceptencoding=gzip&postdata=dXVpZD04ODhiNGY1NC1jMTI3LTExZTUtOTkxMi1iYTBiZTA0ODNjMTgmbGFuZz1lbiZmb3JtYXQ9anNvbiZjbGllbnRfYXBwX3Rva2VuPWVlOGZkMmYxYmNjYjNhYTM2ZmJjMjIyYmIyYTczZDhm 18:40:47 719.259521 T:1535112096 ERROR: Open - failed to open source 18:40:47 719.259644 T:1535112096 ERROR: AddOnLog: Zattoo PVR Client: Open URL failed during init. 18:40:47 719.259705 T:1535112096 ERROR: AddOnLog: Zattoo PVR Client: Hello failed. 18:40:47 719.259827 T:1535112096 ERROR: AddOnLog: Zattoo PVR Client: Re-init of session. Failed. 18:40:47 719.260193 T:1535112096 ERROR: CDVDInputStreamPVRManager::Open - error opening [] 18:40:47 719.260315 T:1535112096 ERROR: CVideoPlayer::OpenInputStream - error opening [pvr://channels/tv/All channels/pvr.zattoo_442127252.pvr] 18:40:47 719.260376 T:1535112096 NOTICE: CVideoPlayer::OnExit() 18:40:47 719.298340 T:1535112096 DEBUG: CDVDInputStreamPVRManager::Close - stream closed 18:40:47 719.298523 T:1535112096 DEBUG: OnPlayBackStopped: play state was 1, starting 1 18:40:47 719.298584 T:1535112096 DEBUG: Thread VideoPlayer 1535112096 terminating 18:40:47 719.298645 T:1961263104 DEBUG: OnPlayBackStopped: play state was 3, starting 0 18:40:47 719.298889 T:1961255840 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc 18:40:47 719.299072 T:1961255840 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop 18:40:47 719.334290 T:1961263104 NOTICE: CVideoPlayer::CloseFile() 18:40:47 719.334473 T:1961263104 NOTICE: VideoPlayer: waiting for threads to exit 18:40:47 719.334534 T:1961263104 NOTICE: VideoPlayer: finished waiting 18:40:47 719.334717 T:1961263104 DEBUG: DeleteRenderer - deleting renderer 18:40:47 719.334778 T:1961263104 DEBUG: CMMALRenderer::~CMMALRenderer 18:40:47 719.334839 T:1961263104 DEBUG: CMMALRenderer::UnInitMMAL 18:40:47 719.334961 T:1595929504 DEBUG: CMMALRenderer::Run - stopping 18:40:47 719.335083 T:1595929504 DEBUG: Thread MMALProcess 1595929504 terminating 18:40:47 719.335144 T:1961263104 NOTICE: CVideoPlayer::CloseFile() 18:40:47 719.335205 T:1961263104 NOTICE: VideoPlayer: waiting for threads to exit 18:40:47 719.335266 T:1961263104 NOTICE: VideoPlayer: finished waiting 18:40:47 719.339966 T:1961263104 DEBUG: Radio UECP (RDS) Processor - delete ~CDVDRadioRDSData 18:40:47 719.387573 T:1961263104 DEBUG: ------ Window Deinit (DialogPVRInfo.xml) ------ 18:41:04 736.351685 T:1961263104 INFO: CheckIdle - Closing session to http://zh2-4-hls-pvr.zahs.tv (easy=0x51a4470, multi=0x6f75f770) 18:41:11 742.830933 T:1803547552 DEBUG: PushCecKeypress - received key a8 duration 0 (rep:0 size:0) 18:41:11 742.831116 T:1803547552 DEBUG: PushCecKeypress - added key a8 18:41:11 742.842651 T:1961263104 DEBUG: OnKey: 168 (0xa8, obc87) pressed, action is Right 18:41:11 742.952759 T:1803547552 DEBUG: PushCecKeypress - received key a8 duration 122 (rep:0 size:0) 18:41:11 742.952881 T:1803547552 DEBUG: PushCecKeypress - ignored key a8 18:41:11 743.277954 T:1803547552 DEBUG: PushCecKeypress - received key b duration 0 (rep:0 size:0) 18:41:11 743.278015 T:1803547552 DEBUG: PushCecKeypress - added key b 18:41:11 743.304382 T:1961263104 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 18:41:11 743.304504 T:1961263104 DEBUG: ------ Window Init (DialogPVRInfo.xml) ------ 18:41:11 743.304565 T:1961263104 INFO: Loading skin file: DialogPVRInfo.xml, load type: LOAD_EVERY_TIME 18:41:11 743.304749 T:1961263104 DEBUG: Using already stored xml root node for /usr/share/kodi/addons/skin.estuary/1080i/DialogPVRInfo.xml 18:41:11 743.332886 T:1604318112 DEBUG: CurlFile::Open(0x6f502bd0) http://images.zattic.com/system/images/2aca/f5bc/6c6e/cc55/6529/format_480x360.jpg 18:41:11 743.355164 T:1604318112 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x65ea37c8 18:41:11 743.355896 T:1604318112 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 18:41:11 743.358948 T:1604318112 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_encode input port 340 output port 341 m_handle 0x6f500ba8 18:41:11 743.359863 T:1604318112 DEBUG: COMXCoreComponent::AllocOutputBuffers component(OMX.broadcom.image_encode) - port(341), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(176640) nBufferAlignmen(16) 18:41:11 743.400208 T:1803547552 DEBUG: PushCecKeypress - received key b duration 123 (rep:0 size:0) 18:41:11 743.400330 T:1803547552 DEBUG: PushCecKeypress - ignored key b 18:41:11 743.438416 T:1604318112 DEBUG: COMXReEnc::ReEncode : http://images.zattic.com/system/images/2aca/f5bc/6c6e/cc55/6529/format_480x360.jpg 480x360 -> 480x360 18:41:11 743.439880 T:1604318112 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x65ea37c8 18:41:11 743.462097 T:1604318112 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_encode handle 0x6f500ba8 18:41:11 743.488037 T:1604318112 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x73c8bca0 18:41:11 743.488770 T:1604318112 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(81920), nBufferAlignmen(16) 18:41:11 743.490906 T:1604318112 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x64f14820 18:41:11 743.491516 T:1604318112 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 18:41:11 743.498169 T:1604318112 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x73c8bca0 18:41:11 743.499084 T:1604318112 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x64f14820 18:41:11 743.499207 T:1604318112 DEBUG: DecodeJpegToTexture: decoded special://masterprofile/Thumbnails/7/7c4c6a54.jpg 480x360 18:41:11 743.499390 T:1604318112 DEBUG: Fast Caching image 'http://images.zattic.com/system/images/2aca/f5bc/6c6e/cc55/6529/format_480x360.jpg' to '7/7c4c6a54.jpg': 0x45e7e88 18:41:13 745.175781 T:1803547552 DEBUG: PushCecKeypress - received key b duration 0 (rep:0 size:0) 18:41:13 745.175903 T:1803547552 DEBUG: PushCecKeypress - added key b 18:41:13 745.189331 T:1961263104 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 18:41:13 745.214905 T:1961263104 DEBUG: Loading settings for pvr://channels/tv/All channels/pvr.zattoo_442127252.pvr 18:41:13 745.216431 T:1961263104 DEBUG: CPlayerCoreFactory::GetPlayers(pvr://channels/tv/All channels/pvr.zattoo_442127252.pvr) 18:41:13 745.216614 T:1961263104 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules 18:41:13 745.216675 T:1961263104 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules 18:41:13 745.216675 T:1961263104 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mms/udp 18:41:13 745.216797 T:1961263104 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout 18:41:13 745.216858 T:1961263104 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtmp 18:41:13 745.216919 T:1961263104 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp 18:41:13 745.216980 T:1961263104 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams 18:41:13 745.217102 T:1961263104 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd 18:41:13 745.217102 T:1961263104 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage 18:41:13 745.217224 T:1961263104 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf 18:41:13 745.217285 T:1961263104 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv 18:41:13 745.217346 T:1961263104 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: radio 18:41:13 745.217407 T:1961263104 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players 18:41:13 745.217529 T:1961263104 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (VideoPlayer) 18:41:13 745.217529 T:1961263104 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0 18:41:13 745.217590 T:1961263104 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1 18:41:13 745.217651 T:1961263104 DEBUG: CPlayerCoreFactory::GetPlayers: added 1 players 18:41:13 745.222595 T:1961263104 DEBUG: Radio UECP (RDS) Processor - new CDVDRadioRDSData 18:41:13 745.222839 T:1961263104 NOTICE: VideoPlayer: Opening: pvr://channels/tv/All channels/pvr.zattoo_442127252.pvr 18:41:13 745.222900 T:1961263104 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 18:41:13 745.223022 T:1961263104 DEBUG: CMMALRenderer::CMMALRenderer 18:41:13 745.223206 T:1961263104 DEBUG: CMMALRenderer::UnInitMMAL 18:41:13 745.223267 T:1961263104 DEBUG: CMMALRenderer::PreInit 18:41:13 745.223328 T:1595929504 DEBUG: Thread MMALProcess start, auto delete: false 18:41:13 745.223389 T:1595929504 DEBUG: CMMALRenderer::Run - starting 18:41:13 745.223389 T:1535112096 DEBUG: Thread VideoPlayer start, auto delete: false 18:41:13 745.223572 T:1535112096 NOTICE: Creating InputStream 18:41:13 745.224304 T:1535112096 DEBUG: PVRManager - OpenLiveStream - opening live stream on channel 'ARTE HD' 18:41:13 745.224365 T:1535112096 DEBUG: opening live stream on url 'pvr://stream/tv/zattoo.ts' 18:41:13 745.296997 T:1803547552 DEBUG: PushCecKeypress - received key b duration 122 (rep:0 size:0) 18:41:13 745.297058 T:1803547552 DEBUG: PushCecKeypress - ignored key b 18:41:13 745.418518 T:1535112096 DEBUG: CDVDInputStreamPVRManager - Open - playback has started on filename pvr://channels/tv/All channels/pvr.zattoo_442127252.pvr 18:41:13 745.419128 T:1535112096 DEBUG: CFileCache::Open - opening using cache 18:41:13 745.419495 T:1535112096 DEBUG: CurlFile::Open(0x4d351a0) http://zattoo.com/zapi/watch 18:41:13 745.440491 T:1535112096 ERROR: CCurlFile::FillBuffer - Failed: HTTP returned error 403 18:41:13 745.440552 T:1535112096 ERROR: CCurlFile::Open failed with code 403 for http://zattoo.com/zapi/watch|acceptencoding=gzip&postdata=Y2lkPURFX2FydGUmc3RyZWFtX3R5cGU9aGxzJmZvcm1hdD1qc29u 18:41:13 745.440674 T:1535112096 ERROR: Open - failed to open source 18:41:13 745.440735 T:1535112096 DEBUG: AddOnLog: Zattoo PVR Client: Open URL failed. Try to re-init session. 18:41:13 745.441040 T:1535112096 DEBUG: CFileCache::Open - opening using cache 18:41:13 745.441284 T:1535112096 DEBUG: CurlFile::Open(0x4916f50) http://zattoo.com/zapi/v2/session 18:41:13 745.464783 T:1612706720 DEBUG: Thread FileCache start, auto delete: false 18:41:13 745.465210 T:1612706720 INFO: CFileCache::Process - Source read didn't return any data! Hit eof(?) 18:41:14 745.515259 T:1612706720 DEBUG: Thread FileCache 1612706720 terminating 18:41:14 745.515808 T:1535112096 DEBUG: AddOnLog: Zattoo PVR Client: Need to login. 18:41:14 745.515930 T:1535112096 DEBUG: AddOnLog: Zattoo PVR Client: Send hello. 18:41:14 745.516724 T:1535112096 DEBUG: CFileCache::Open - opening using cache 18:41:14 745.517395 T:1535112096 DEBUG: CurlFile::Open(0x4371750) http://zattoo.com/zapi/session/hello 18:41:14 745.534424 T:1535112096 ERROR: CCurlFile::FillBuffer - Failed: HTTP returned error 403 18:41:14 745.534607 T:1535112096 ERROR: CCurlFile::Open failed with code 403 for http://zattoo.com/zapi/session/hello|acceptencoding=gzip&postdata=dXVpZD04ODhiNGY1NC1jMTI3LTExZTUtOTkxMi1iYTBiZTA0ODNjMTgmbGFuZz1lbiZmb3JtYXQ9anNvbiZjbGllbnRfYXBwX3Rva2VuPWVlOGZkMmYxYmNjYjNhYTM2ZmJjMjIyYmIyYTczZDhm 18:41:14 745.534790 T:1535112096 ERROR: Open - failed to open source 18:41:14 745.534912 T:1535112096 ERROR: AddOnLog: Zattoo PVR Client: Open URL failed during init. 18:41:14 745.534973 T:1535112096 ERROR: AddOnLog: Zattoo PVR Client: Hello failed. 18:41:14 745.535095 T:1535112096 ERROR: AddOnLog: Zattoo PVR Client: Re-init of session. Failed. 18:41:14 745.535461 T:1535112096 ERROR: CDVDInputStreamPVRManager::Open - error opening [] 18:41:14 745.535522 T:1535112096 ERROR: CVideoPlayer::OpenInputStream - error opening [pvr://channels/tv/All channels/pvr.zattoo_442127252.pvr] 18:41:14 745.535583 T:1535112096 NOTICE: CVideoPlayer::OnExit() 18:41:14 745.607910 T:1535112096 DEBUG: CDVDInputStreamPVRManager::Close - stream closed 18:41:14 745.608093 T:1535112096 DEBUG: OnPlayBackStopped: play state was 1, starting 1 18:41:14 745.608154 T:1535112096 DEBUG: Thread VideoPlayer 1535112096 terminating 18:41:14 745.608337 T:1961263104 DEBUG: OnPlayBackStopped: play state was 3, starting 0 18:41:14 745.608521 T:1961255840 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc 18:41:14 745.608704 T:1961255840 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop 18:41:14 745.643982 T:1961263104 NOTICE: CVideoPlayer::CloseFile() 18:41:14 745.644165 T:1961263104 NOTICE: VideoPlayer: waiting for threads to exit 18:41:14 745.644226 T:1961263104 NOTICE: VideoPlayer: finished waiting 18:41:14 745.644348 T:1961263104 DEBUG: DeleteRenderer - deleting renderer 18:41:14 745.644409 T:1961263104 DEBUG: CMMALRenderer::~CMMALRenderer 18:41:14 745.644470 T:1961263104 DEBUG: CMMALRenderer::UnInitMMAL 18:41:14 745.644592 T:1595929504 DEBUG: CMMALRenderer::Run - stopping 18:41:14 745.644775 T:1595929504 DEBUG: Thread MMALProcess 1595929504 terminating 18:41:14 745.644836 T:1961263104 NOTICE: CVideoPlayer::CloseFile() 18:41:14 745.644897 T:1961263104 NOTICE: VideoPlayer: waiting for threads to exit 18:41:14 745.644958 T:1961263104 NOTICE: VideoPlayer: finished waiting 18:41:14 745.649719 T:1961263104 DEBUG: Radio UECP (RDS) Processor - delete ~CDVDRadioRDSData 18:41:14 745.697327 T:1961263104 DEBUG: ------ Window Deinit (DialogPVRInfo.xml) ------ 18:41:15 746.847046 T:1803547552 DEBUG: PushCecKeypress - received key d8 duration 0 (rep:0 size:0) 18:41:15 746.847168 T:1803547552 DEBUG: PushCecKeypress - added key d8 18:41:15 746.875244 T:1961263104 DEBUG: OnKey: menu (0xd8) pressed, action is Back 18:41:15 746.875366 T:1961263104 DEBUG: Activating window ID: 10000 18:41:15 746.969055 T:1803547552 DEBUG: PushCecKeypress - received key d8 duration 122 (rep:0 size:0) 18:41:15 746.969238 T:1803547552 DEBUG: PushCecKeypress - ignored key d8 18:41:15 747.208618 T:1961263104 DEBUG: ------ Window Deinit (MyPVRGuide.xml) ------ 18:41:15 747.208801 T:1553986464 DEBUG: Thread epg-grid-refresh-timeline-items 1553986464 terminating 18:41:15 747.217651 T:1961263104 DEBUG: ------ Window Init (Home.xml) ------ 18:41:15 747.218140 T:1961263104 DEBUG: CDirectoryProvider[videodb://inprogresstvshows]: refreshing.. 18:41:15 747.218384 T:1961263104 DEBUG: CDirectoryProvider[special://skin/playlists/mostplayed_albums.xsp]: refreshing.. 18:41:15 747.218506 T:1961263104 DEBUG: CDirectoryProvider[addons://sources/video/]: refreshing.. 18:41:15 747.218628 T:1961263104 DEBUG: CDirectoryProvider[addons://sources/audio/]: refreshing.. 18:41:15 747.218689 T:1961263104 DEBUG: CDirectoryProvider[addons://sources/executable/]: refreshing.. 18:41:15 747.218750 T:1961263104 DEBUG: CDirectoryProvider[addons://sources/image/]: refreshing.. 18:41:15 747.218994 T:1961263104 DEBUG: CDirectoryProvider[pvr://channels/tv/*?view=lastplayed]: refreshing.. 18:41:15 747.219238 T:1961263104 DEBUG: CDirectoryProvider[pvr://channels/radio/*?view=lastplayed]: refreshing.. 18:41:15 747.233459 T:1604318112 DEBUG: GetAlbumsByWhere query: SELECT albumview.* FROM albumview WHERE (albumview.strReleaseType = 'album') AND (((CAST(albumview.iTimesPlayed as DECIMAL(5,1)) > 0))) 18:41:15 747.234863 T:1604318112 DEBUG: GetAlbumsByWhere - query took 1 ms 18:41:15 747.235229 T:1586484128 DEBUG: RunQuery took 3 ms for 0 items query: SELECT * FROM tvshow_view WHERE watchedCount != 0 AND totalCount != watchedCount ORDER BY c00 18:41:15 747.237915 T:1586484128 DEBUG: CPVRDirectory::GetDirectory(pvr://channels/tv/*?view=lastplayed) 18:41:15 747.245483 T:1526723488 DEBUG: CPVRDirectory::GetDirectory(pvr://channels/radio/*?view=lastplayed) 18:41:15 747.251587 T:1604318112 DEBUG: Caching image 'special://home/addons/pvr.zattoo/resources/media/channel_logo/DE_arte.png' to 'e/e78261bb.png': 18:41:15 747.251770 T:1604318112 DEBUG: cached image 'special://masterprofile/Thumbnails/e/e78261bb.png' size 256x256 18:41:42 773.850281 T:1961263104 INFO: CheckIdle - Closing session to http://images.zattic.com (easy=0x6f4764d8, multi=0x69639bd8) 18:41:44 775.876221 T:1961263104 INFO: CheckIdle - Closing session to http://zattoo.com (easy=0x73b02b40, multi=0x73b00e40) 18:41:45 777.246033 T:1526723488 DEBUG: Thread JobWorker 1526723488 terminating (autodelete) 18:41:45 777.247864 T:1586484128 DEBUG: Thread JobWorker 1586484128 terminating (autodelete) 18:41:45 777.360535 T:1604318112 DEBUG: Thread JobWorker 1604318112 terminating (autodelete) 18:42:15 807.176880 T:1930425248 DEBUG: CAESinkPi:Drain delay:49ms now:0ms 18:42:25 817.177124 T:1930425248 DEBUG: CAESinkPi:Deinitialize 18:42:25 817.177612 T:1930425248 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000000 18:42:25 817.190735 T:1930425248 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.audio_render handle 0x727d8d80 18:44:15 927.086182 T:1961255840 DEBUG: CAnnouncementManager - Announcement: OnScreensaverActivated from xbmc 18:44:15 927.086548 T:1961255840 DEBUG: GOT ANNOUNCEMENT, type: 4, from xbmc, message OnScreensaverActivated 18:44:15 927.093323 T:1961263104 DEBUG: ------ Window Init () ------ 18:44:17 928.622620 T:1803547552 DEBUG: PushCecKeypress - received key a8 duration 0 (rep:0 size:0) 18:44:17 928.622742 T:1803547552 DEBUG: PushCecKeypress - added key a8 18:44:17 928.630615 T:1961255840 DEBUG: CAnnouncementManager - Announcement: OnScreensaverDeactivated from xbmc 18:44:17 928.630798 T:1961255840 DEBUG: GOT ANNOUNCEMENT, type: 4, from xbmc, message OnScreensaverDeactivated 18:44:17 928.630981 T:1961263104 DEBUG: OnKey: 168 (0xa8, obc87) pressed, screen saver/dpms woken up 18:44:17 928.964966 T:1803547552 DEBUG: PushCecKeypress - received key a8 duration 342 (rep:0 size:0) 18:44:17 928.965149 T:1803547552 DEBUG: PushCecKeypress - ignored key a8 18:44:18 929.666321 T:1961263104 DEBUG: ------ Window Deinit () ------ 18:44:18 929.697021 T:1803547552 DEBUG: PushCecKeypress - received key a8 duration 0 (rep:0 size:0) 18:44:18 929.697205 T:1803547552 DEBUG: PushCecKeypress - added key a8 18:44:18 929.706055 T:1961263104 DEBUG: OnKey: 168 (0xa8, obc87) pressed, action is Right 18:44:18 929.706360 T:1930425248 INFO: CActiveAESink::OpenSink - initialize sink 18:44:18 929.706543 T:1930425248 DEBUG: CActiveAESink::OpenSink - trying to open device PI:HDMI 18:44:18 929.706726 T:1930425248 DEBUG: CAESinkPi:Initialize Format:15 Channels:2 Samplerate:44100 framesize:8 bufsize:8816 bytes/s=352800.00 dest=PI:HDMI 18:44:18 929.707153 T:1930425248 DEBUG: CAESinkPi:SetAudioProps hdmi_stream_channels 0 hdmi_channel_map 00000008 18:44:18 929.709656 T:1930425248 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_render input port 100 output port 100 m_handle 0x727d1fb0 18:44:18 929.711792 T:1930425248 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.audio_render) - port(100), nBufferCountMin(1), nBufferCountActual(2), nBufferSize(8816), nBufferAlignmen(16) 18:44:18 929.712402 T:1930425248 DEBUG: CActiveAESink::OpenSink - SinkPi Initialized: 18:44:18 929.712524 T:1930425248 DEBUG: Output Device : HDMI 18:44:18 929.712585 T:1930425248 DEBUG: Sample Rate : 44100 18:44:18 929.712646 T:1930425248 DEBUG: Sample Format : AE_FMT_FLOAT 18:44:18 929.712708 T:1930425248 DEBUG: Channel Count : 2 18:44:18 929.712769 T:1930425248 DEBUG: Channel Layout: FL,FR 18:44:18 929.712830 T:1930425248 DEBUG: Frames : 1102 18:44:18 929.712891 T:1930425248 DEBUG: Frame Size : 8 18:44:18 929.818176 T:1803547552 DEBUG: PushCecKeypress - received key a8 duration 122 (rep:0 size:0) 18:44:18 929.818359 T:1803547552 DEBUG: PushCecKeypress - ignored key a8 18:44:18 930.362000 T:1803547552 DEBUG: PushCecKeypress - received key b duration 0 (rep:0 size:0) 18:44:18 930.362122 T:1803547552 DEBUG: PushCecKeypress - added key b 18:44:18 930.404663 T:1961263104 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 18:44:18 930.415283 T:1961263104 DEBUG: Loading settings for pvr://channels/tv/All channels/pvr.zattoo_4245367.pvr 18:44:18 930.421509 T:1961263104 DEBUG: Radio UECP (RDS) Processor - new CDVDRadioRDSData 18:44:18 930.421692 T:1961263104 NOTICE: VideoPlayer: Opening: pvr://channels/tv/All channels/pvr.zattoo_4245367.pvr 18:44:18 930.421753 T:1961263104 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 18:44:18 930.421875 T:1961263104 DEBUG: CMMALRenderer::CMMALRenderer 18:44:18 930.421997 T:1961263104 DEBUG: CMMALRenderer::UnInitMMAL 18:44:18 930.422058 T:1961263104 DEBUG: CMMALRenderer::PreInit 18:44:18 930.422119 T:1604318112 DEBUG: Thread MMALProcess start, auto delete: false 18:44:18 930.422180 T:1604318112 DEBUG: CMMALRenderer::Run - starting 18:44:18 930.422241 T:1586484128 DEBUG: Thread VideoPlayer start, auto delete: false 18:44:18 930.422424 T:1586484128 NOTICE: Creating InputStream 18:44:18 930.423096 T:1586484128 DEBUG: PVRManager - OpenLiveStream - opening live stream on channel 'SRF 1 HD' 18:44:18 930.423218 T:1586484128 DEBUG: opening live stream on url 'pvr://stream/tv/zattoo.ts' 18:44:18 930.483704 T:1803547552 DEBUG: PushCecKeypress - received key b duration 121 (rep:0 size:0) 18:44:18 930.483826 T:1803547552 DEBUG: PushCecKeypress - ignored key b 18:44:18 930.488220 T:1586484128 DEBUG: CDVDInputStreamPVRManager - Open - playback has started on filename pvr://channels/tv/All channels/pvr.zattoo_4245367.pvr 18:44:18 930.489258 T:1586484128 DEBUG: CFileCache::Open - opening using cache 18:44:18 930.489929 T:1586484128 DEBUG: CurlFile::Open(0x7279e170) http://zattoo.com/zapi/watch 18:44:18 930.490540 T:1586484128 INFO: easy_aquire - Created session to http://zattoo.com 18:44:19 930.618774 T:1586484128 ERROR: CCurlFile::FillBuffer - Failed: HTTP returned error 403 18:44:19 930.619019 T:1586484128 ERROR: CCurlFile::Open failed with code 403 for http://zattoo.com/zapi/watch|acceptencoding=gzip&postdata=Y2lkPXNmLTEmc3RyZWFtX3R5cGU9aGxzJmZvcm1hdD1qc29u 18:44:19 930.619141 T:1586484128 ERROR: Open - failed to open source 18:44:19 930.619324 T:1586484128 DEBUG: AddOnLog: Zattoo PVR Client: Open URL failed. Try to re-init session. 18:44:19 930.619934 T:1586484128 DEBUG: CFileCache::Open - opening using cache 18:44:19 930.620483 T:1586484128 DEBUG: CurlFile::Open(0x727c8e78) http://zattoo.com/zapi/v2/session 18:44:19 930.646484 T:1526723488 DEBUG: Thread FileCache start, auto delete: false 18:44:19 930.646851 T:1526723488 INFO: CFileCache::Process - Source read didn't return any data! Hit eof(?) 18:44:19 930.696899 T:1526723488 DEBUG: Thread FileCache 1526723488 terminating 18:44:19 930.697449 T:1586484128 DEBUG: AddOnLog: Zattoo PVR Client: Need to login. 18:44:19 930.697510 T:1586484128 DEBUG: AddOnLog: Zattoo PVR Client: Send hello. 18:44:19 930.698303 T:1586484128 DEBUG: CFileCache::Open - opening using cache 18:44:19 930.698975 T:1586484128 DEBUG: CurlFile::Open(0x727c8fb0) http://zattoo.com/zapi/session/hello 18:44:19 930.712830 T:1586484128 ERROR: CCurlFile::FillBuffer - Failed: HTTP returned error 403 18:44:19 930.712952 T:1586484128 ERROR: CCurlFile::Open failed with code 403 for http://zattoo.com/zapi/session/hello|acceptencoding=gzip&postdata=dXVpZD04ODhiNGY1NC1jMTI3LTExZTUtOTkxMi1iYTBiZTA0ODNjMTgmbGFuZz1lbiZmb3JtYXQ9anNvbiZjbGllbnRfYXBwX3Rva2VuPWVlOGZkMmYxYmNjYjNhYTM2ZmJjMjIyYmIyYTczZDhm 18:44:19 930.713135 T:1586484128 ERROR: Open - failed to open source 18:44:19 930.713257 T:1586484128 ERROR: AddOnLog: Zattoo PVR Client: Open URL failed during init. 18:44:19 930.713379 T:1586484128 ERROR: AddOnLog: Zattoo PVR Client: Hello failed. 18:44:19 930.713440 T:1586484128 ERROR: AddOnLog: Zattoo PVR Client: Re-init of session. Failed. 18:44:19 930.713806 T:1586484128 ERROR: CDVDInputStreamPVRManager::Open - error opening [] 18:44:19 930.713928 T:1586484128 ERROR: CVideoPlayer::OpenInputStream - error opening [pvr://channels/tv/All channels/pvr.zattoo_4245367.pvr] 18:44:19 930.713989 T:1586484128 NOTICE: CVideoPlayer::OnExit() 18:44:19 930.781372 T:1586484128 DEBUG: CDVDInputStreamPVRManager::Close - stream closed 18:44:19 930.781494 T:1526723488 DEBUG: Thread JobWorker start, auto delete: true 18:44:19 930.781616 T:1586484128 DEBUG: OnPlayBackStopped: play state was 1, starting 1 18:44:19 930.781677 T:1586484128 DEBUG: Thread VideoPlayer 1586484128 terminating 18:44:19 930.781860 T:1961263104 DEBUG: OnPlayBackStopped: play state was 3, starting 0 18:44:19 930.782166 T:1961255840 DEBUG: CAnnouncementManager - Announcement: OnStop from xbmc 18:44:19 930.782288 T:1961255840 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnStop 18:44:19 930.782471 T:1961263104 ERROR: PlayMedia could not play media: pvr://channels/tv/All channels/pvr.zattoo_4245367.pvr 18:44:19 930.784119 T:1961263104 DEBUG: CDirectoryProvider[pvr://channels/tv/*?view=lastplayed]: refreshing.. 18:44:19 930.785889 T:1526723488 DEBUG: CPVRDirectory::GetDirectory(pvr://channels/tv/*?view=lastplayed) 18:44:19 930.805237 T:1961263104 NOTICE: CVideoPlayer::CloseFile() 18:44:19 930.805359 T:1961263104 NOTICE: VideoPlayer: waiting for threads to exit 18:44:19 930.805481 T:1961263104 NOTICE: VideoPlayer: finished waiting 18:44:19 930.805542 T:1961263104 DEBUG: DeleteRenderer - deleting renderer 18:44:19 930.805603 T:1961263104 DEBUG: CMMALRenderer::~CMMALRenderer 18:44:19 930.805664 T:1961263104 DEBUG: CMMALRenderer::UnInitMMAL 18:44:19 930.805847 T:1604318112 DEBUG: CMMALRenderer::Run - stopping 18:44:19 930.805969 T:1604318112 DEBUG: Thread MMALProcess 1604318112 terminating 18:44:19 930.806030 T:1961263104 NOTICE: CVideoPlayer::CloseFile() 18:44:19 930.806091 T:1961263104 NOTICE: VideoPlayer: waiting for threads to exit 18:44:19 930.806152 T:1961263104 NOTICE: VideoPlayer: finished waiting 18:44:19 930.811096 T:1961263104 DEBUG: Radio UECP (RDS) Processor - delete ~CDVDRadioRDSData 18:44:24 935.525818 T:1803547552 DEBUG: PushCecKeypress - received key a6 duration 0 (rep:0 size:0) 18:44:24 935.526001 T:1803547552 DEBUG: PushCecKeypress - added key a6 18:44:24 935.568604 T:1961263104 DEBUG: OnKey: 166 (0xa6, obc89) pressed, action is Up 18:44:24 935.675293 T:1803547552 DEBUG: PushCecKeypress - received key a6 duration 150 (rep:0 size:0) 18:44:24 935.675476 T:1803547552 DEBUG: PushCecKeypress - ignored key a6 18:44:24 936.332947 T:1803547552 DEBUG: PushCecKeypress - received key a9 duration 0 (rep:0 size:0) 18:44:24 936.333008 T:1803547552 DEBUG: PushCecKeypress - added key a9 18:44:24 936.347717 T:1961263104 DEBUG: OnKey: 169 (0xa9, obc86) pressed, action is Left 18:44:24 936.482849 T:1803547552 DEBUG: PushCecKeypress - received key a9 duration 150 (rep:0 size:0) 18:44:24 936.483032 T:1803547552 DEBUG: PushCecKeypress - ignored key a9 18:44:25 937.372314 T:1803547552 DEBUG: PushCecKeypress - received key a6 duration 0 (rep:0 size:0) 18:44:25 937.372437 T:1803547552 DEBUG: PushCecKeypress - added key a6 18:44:25 937.379272 T:1961263104 DEBUG: OnKey: 166 (0xa6, obc89) pressed, action is Up 18:44:26 937.672424 T:1803547552 DEBUG: PushCecKeypress - received key a6 duration 0 (rep:0 size:0) 18:44:26 937.672546 T:1803547552 DEBUG: PushCecKeypress - added key a6 18:44:26 937.690308 T:1961263104 DEBUG: OnKey: 166 (0xa6, obc89) pressed, action is Up 18:44:26 937.972168 T:1803547552 DEBUG: PushCecKeypress - received key a6 duration 0 (rep:0 size:0) 18:44:26 937.972290 T:1803547552 DEBUG: PushCecKeypress - added key a6 18:44:26 937.972595 T:1961263104 DEBUG: OnKey: 166 (0xa6, obc89) pressed, action is Up 18:44:26 938.272400 T:1803547552 DEBUG: PushCecKeypress - received key a6 duration 0 (rep:0 size:0) 18:44:26 938.272583 T:1803547552 DEBUG: PushCecKeypress - added key a6 18:44:26 938.272827 T:1961263104 DEBUG: OnKey: 166 (0xa6, obc89) pressed, action is Up 18:44:26 938.303650 T:1961263104 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.image_decode input port 320 output port 321 m_handle 0x4a96fc8 18:44:26 938.304688 T:1961263104 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.image_decode) - port(320), nBufferCountMin(2), nBufferCountActual(2), nBufferSize(201536), nBufferAlignmen(16) 18:44:26 938.308716 T:1961263104 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.resize input port 60 output port 61 m_handle 0x4524360 18:44:26 938.310425 T:1961263104 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.egl_render input port 220 output port 221 m_handle 0x4875a38 18:44:26 938.311340 T:1961263104 DEBUG: COMXCoreComponent::UseEGLImage component(OMX.broadcom.egl_render) - port(221), nBufferCountMin(1), nBufferCountActual(1), nBufferSize(15360) nBufferAlignmen(16) 18:44:26 938.425720 T:1961263104 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.image_decode handle 0x4a96fc8 18:44:26 938.426819 T:1961263104 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.resize handle 0x4524360 18:44:26 938.428101 T:1961263104 DEBUG: COMXCoreComponent::Deinitialize : OMX.broadcom.egl_render handle 0x4875a38 18:44:26 938.428345 T:1961263104 DEBUG: DecodeJpegToTexture: decoded special://skin/extras/home-images/movie.jpg 927x540 18:44:27 938.572571 T:1803547552 DEBUG: PushCecKeypress - received key a6 duration 0 (rep:0 size:0) 18:44:27 938.572754 T:1803547552 DEBUG: PushCecKeypress - added key a6 18:44:27 938.589478 T:1961263104 DEBUG: OnKey: 166 (0xa6, obc89) pressed, action is Up 18:44:27 938.708374 T:1803547552 DEBUG: PushCecKeypress - received key a6 duration 1336 (rep:0 size:0) 18:44:27 938.708557 T:1803547552 DEBUG: PushCecKeypress - ignored key a6 18:44:28 940.355713 T:1803547552 DEBUG: PushCecKeypress - received key a9 duration 0 (rep:0 size:0) 18:44:28 940.355835 T:1803547552 DEBUG: PushCecKeypress - added key a9 18:44:28 940.359985 T:1961263104 DEBUG: OnKey: 169 (0xa9, obc86) pressed, action is Left 18:44:28 940.477234 T:1803547552 DEBUG: PushCecKeypress - received key a9 duration 122 (rep:0 size:0) 18:44:28 940.477356 T:1803547552 DEBUG: PushCecKeypress - ignored key a9 18:44:29 940.710388 T:1803547552 DEBUG: PushCecKeypress - received key b duration 0 (rep:0 size:0) 18:44:29 940.710510 T:1803547552 DEBUG: PushCecKeypress - added key b 18:44:29 940.728210 T:1961263104 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 18:44:29 940.729736 T:1961263104 DEBUG: Activating window ID: 10111 18:44:29 940.729858 T:1961263104 DEBUG: ------ Window Init (DialogButtonMenu.xml) ------ 18:44:29 940.729980 T:1961263104 INFO: Loading skin file: DialogButtonMenu.xml, load type: KEEP_IN_MEMORY 18:44:29 940.832581 T:1803547552 DEBUG: PushCecKeypress - received key b duration 122 (rep:0 size:0) 18:44:29 940.832825 T:1803547552 DEBUG: PushCecKeypress - ignored key b 18:44:31 943.062988 T:1803547552 DEBUG: PushCecKeypress - received key b duration 0 (rep:0 size:0) 18:44:31 943.063232 T:1803547552 DEBUG: PushCecKeypress - added key b 18:44:31 943.089966 T:1961263104 DEBUG: OnKey: 11 (0x0b, obc244) pressed, action is Select 18:44:31 943.136230 T:1961263104 INFO: Selected Logind/UPower as PowerSyscall 18:44:31 943.137756 T:1961263104 ERROR: DBus: Error org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.UPower was not provided by any .service files 18:44:31 943.137878 T:1961263104 INFO: LogindUPowerSyscall - UPower not found, battery information will not be available 18:44:31 943.147827 T:1961263104 DEBUG: LogindUPowerSyscall - inhibit lock taken, fd 64 18:44:31 943.174805 T:1961263104 DEBUG: LogindUPowerSyscall - delay lock released 18:44:31 943.175049 T:1961263104 DEBUG: ------ Window Init (DialogBusy.xml) ------ 18:44:31 943.184998 T:1803547552 DEBUG: PushCecKeypress - received key b duration 122 (rep:0 size:0) 18:44:31 943.185181 T:1803547552 DEBUG: PushCecKeypress - ignored key b 18:44:31 943.337097 T:1930425248 INFO: Received SIGTERM... 18:44:31 943.337646 T:1930425248 NOTICE: Storing total System Uptime 18:44:31 943.337769 T:1961255840 DEBUG: CAnnouncementManager - Announcement: OnQuit from xbmc 18:44:31 943.337952 T:1961255840 DEBUG: GOT ANNOUNCEMENT, type: 8, from xbmc, message OnQuit 18:44:31 943.338135 T:1930425248 NOTICE: Saving settings 18:44:31 943.357056 T:1930425248 NOTICE: Saving skin settings 18:44:31 943.362244 T:1930425248 NOTICE: stop all 18:44:31 943.362610 T:1526723488 DEBUG: Thread JobWorker 1526723488 terminating (autodelete) 18:44:31 943.362793 T:1930425248 NOTICE: stop player 18:44:31 943.362793 T:1930425248 INFO: stopping PVRManager 18:44:31 943.362976 T:1778381728 DEBUG: Thread EPGUpdater 1778381728 terminating 18:44:31 943.363892 T:1930425248 NOTICE: PVRManager - stopping 18:44:31 943.389526 T:1961263104 NOTICE: destroy 18:44:31 943.389648 T:1961263104 NOTICE: unload skin 18:44:31 943.389709 T:1961263104 INFO: Unloading old skin ... 18:44:31 943.392212 T:1961263104 DEBUG: ------ Window Deinit () ------ 18:44:31 943.392273 T:1961263104 DEBUG: ------ Window Deinit (Home.xml) ------ 18:44:31 943.426514 T:1961263104 DEBUG: ------ Window Deinit (DialogButtonMenu.xml) ------ 18:44:31 943.429871 T:1961263104 DEBUG: ------ Window Deinit (DialogBusy.xml) ------ 18:44:31 943.437622 T:1795158944 DEBUG: Process - sending standby commands 18:44:31 943.437927 T:1666180000 DEBUG: Thread CECAdapterUpdate 1666180000 terminating 18:44:31 943.510132 T:1961263104 WARNING: Cleanup: Having to cleanup texture pointer_arrow.png 18:44:31 943.510315 T:1961263104 WARNING: Cleanup: Having to cleanup texture pointer_click.png 18:44:31 943.510559 T:1961263104 WARNING: Cleanup: Having to cleanup texture windows/pvr/epg_progress.png 18:44:32 943.556030 T:1682957216 INFO: ## LibreELEC Addon ## xdbus Monitor stopped. ## 18:44:32 943.566956 T:1761604512 ERROR: ## LibreELEC Addon ## bluetooth::monitor::remove_agent ## ERROR: (AttributeError("'NoneType' object has no attribute 'remove_from_connection'",)) 18:44:32 943.567383 T:1761604512 ERROR: Traceback (most recent call last): File "/home/neil/projects/LibreELEC.tv/build.LibreELEC-RPi2.arm-8.0-devel/LibreELEC-settings-6c2cd56/.install_pkg/usr/share/kodi/addons/service.libreelec.settings/resources/lib/modules/bluetooth.py", line 729, in remove_agent AttributeError: 'NoneType' object has no attribute 'remove_from_connection' 18:44:32 943.567810 T:1761604512 DEBUG: ## LibreELEC Addon ## STOP SERVICE DONE ! 18:44:32 943.568176 T:1674568608 INFO: ## LibreELEC Addon ## _service_::run ## MESSAGE:'exit' 18:44:32 943.568665 T:1761604512 INFO: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): script successfully run 18:44:32 943.568726 T:1761604512 INFO: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): waiting on thread 1691345824 18:44:32 943.574707 T:1691345824 INFO: ## LibreELEC Addon ## system::updateThread ## Stopped 18:44:32 943.669739 T:1961263104 DEBUG: CPythonInvoker(0, /usr/share/kodi/addons/service.libreelec.settings/service.py): script termination took 113ms 18:44:32 943.686462 T:1761604512 INFO: Python script interrupted by user 18:44:32 943.686584 T:1761604512 DEBUG: Thread LanguageInvoker 1761604512 terminating 18:44:32 943.686829 T:1961263104 DEBUG: GUI Shader - Destroying Shader : 0x31502c8 18:44:32 943.755920 T:1961263104 DEBUG: uninit_cursor 18:44:32 943.756531 T:1961263104 NOTICE: unload sections 18:44:32 943.767517 T:1961263104 NOTICE: special://profile/ is mapped to: special://masterprofile/ 18:44:32 943.767700 T:1961263104 DEBUG: object 0 --> 0 instances 18:44:32 943.767761 T:1961263104 DEBUG: object 1 --> 0 instances 18:44:32 943.767761 T:1961263104 DEBUG: object 2 --> 0 instances 18:44:32 943.767822 T:1961263104 DEBUG: object 3 --> 0 instances 18:44:32 943.767822 T:1961263104 DEBUG: object 4 --> 0 instances 18:44:32 943.767883 T:1961263104 DEBUG: object 5 --> 0 instances 18:44:32 943.767944 T:1961263104 DEBUG: object 6 --> 0 instances 18:44:32 943.767944 T:1961263104 DEBUG: object 7 --> 0 instances 18:44:32 943.768005 T:1961263104 DEBUG: object 8 --> 0 instances 18:44:32 943.768005 T:1961263104 DEBUG: object 9 --> 0 instances 18:44:32 943.768372 T:1961263104 NOTICE: PVRManager - stopping 18:44:32 943.791016 T:1641014176 DEBUG: Thread PVRGUIInfo 1641014176 terminating 18:44:32 944.109192 T:1649402784 DEBUG: Thread PVRManager 1649402784 terminating