22:25:43 T:3040317440 NOTICE: ----------------------------------------------------------------------- 22:25:44 T:3040317440 NOTICE: Starting XBMC (12.2 Git:20131201-8eed85b), Platform: Linux (Debian GNU/Linux 7.2 (n/a), 3.10.21 armv6l). Built on Dec 9 2013 22:25:44 T:3040317440 NOTICE: special://xbmc/ is mapped to: /opt/xbmc-bcm/xbmc-bin/share/xbmc 22:25:44 T:3040317440 NOTICE: special://xbmcbin/ is mapped to: /opt/xbmc-bcm/xbmc-bin/lib/xbmc 22:25:44 T:3040317440 NOTICE: special://masterprofile/ is mapped to: /home/pi/.xbmc/userdata 22:25:44 T:3040317440 NOTICE: special://home/ is mapped to: /home/pi/.xbmc 22:25:44 T:3040317440 NOTICE: special://temp/ is mapped to: /home/pi/.xbmc/temp 22:25:44 T:3040317440 NOTICE: The executable running is: /opt/xbmc-bcm/xbmc-bin/lib/xbmc/xbmc.bin 22:25:44 T:3040317440 NOTICE: Local hostname: raspbmc 22:25:44 T:3040317440 NOTICE: Log File is located: /home/pi/.xbmc/temp/xbmc.log 22:25:44 T:3040317440 NOTICE: ----------------------------------------------------------------------- 22:25:59 T:3040317440 NOTICE: load settings... 22:25:59 T:3040317440 NOTICE: special://profile/ is mapped to: special://masterprofile/ 22:25:59 T:3040317440 NOTICE: loading special://masterprofile/guisettings.xml 22:25:59 T:3040317440 NOTICE: Getting hardware information now... 22:25:59 T:3040317440 NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml. 22:25:59 T:3040317440 NOTICE: Loaded playercorefactory configuration 22:25:59 T:3040317440 NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml. 22:25:59 T:3040317440 NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping. 22:25:59 T:3040317440 NOTICE: Loaded settings file from special://xbmc/system/advancedsettings.xml 22:25:59 T:3040317440 NOTICE: Contents of special://xbmc/system/advancedsettings.xml are... /opt/vc/bin/vcgencmd measure_temp | sed -e 's/temp=\([0-9]*\).*/\1 C/' /opt/vc/bin/vcgencmd measure_temp | sed -e 's/temp=\([0-9]*\).*/\1 C/' 20971520 540 720

22:25:59 T:3040317440 NOTICE: Getting hardware information now... 22:25:59 T:3040317440 NOTICE: No settings file to load (special://masterprofile/advancedsettings.xml) 22:25:59 T:3040317440 NOTICE: Default DVD Player: omxplayer 22:25:59 T:3040317440 NOTICE: Default Video Player: omxplayer 22:25:59 T:3040317440 NOTICE: Default Audio Player: paplayer 22:25:59 T:3040317440 NOTICE: Disabled debug logging due to GUI setting. Level 0. 22:25:59 T:3040317440 NOTICE: Log level changed to 0 22:25:59 T:3040317440 NOTICE: Loading media sources from special://masterprofile/sources.xml 22:26:00 T:3040317440 ERROR: Error: Requested setting (audiooutput.guisoundmode) was not found. It must be case-sensitive 22:26:00 T:3040317440 NOTICE: Running database version Addons15 22:26:01 T:3040317440 NOTICE: Register - new cec device registered on cec->RPI: CEC Adapter (2708:1001) 22:26:01 T:3021141056 NOTICE: Thread XBMC Peripherals start, auto delete: false 22:26:01 T:3029529664 NOTICE: Thread CEC Adapter start, auto delete: false 22:26:01 T:3011507264 NOTICE: Thread XBMC Peripherals start, auto delete: false 22:26:02 T:3040317440 NOTICE: Raspberry PI firmware version: Dec 2 2013 20:30:23 Copyright (c) 2012 Broadcom version 0334d765c5cb144589b4d7a4ac68ae8f136491e1 (clean) (release) 22:26:02 T:3040317440 NOTICE: ARM mem: 384MB GPU mem: 128MB 22:26:02 T:3040317440 NOTICE: InitWindowSystem: Using EGL Implementation: raspberrypi 22:26:02 T:2961175616 NOTICE: Thread CRBPWorker start, auto delete: false 22:26:02 T:3040317440 NOTICE: Found resolution 720 x 480 for display 0 with 720 x 480i @ 60.000000 Hz 22:26:02 T:3040317440 NOTICE: Found (720x480i@60.000000) at 16, setting to RES_DESKTOP at 16 22:26:02 T:3040317440 NOTICE: Checking resolution 16 22:26:02 T:3040317440 NOTICE: GL_VENDOR = Broadcom 22:26:02 T:3040317440 NOTICE: GL_RENDERER = VideoCore IV HW 22:26:02 T:3040317440 NOTICE: GL_VERSION = OpenGL ES 2.0 22:26:02 T:3040317440 NOTICE: GL_SHADING_LANGUAGE_VERSION = OpenGL ES GLSL ES 1.00 22:26:02 T:3040317440 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 22:26:04 T:3029529664 ERROR: CecLogMessage - failed to release the previous LA 22:26:04 T:3029529664 ERROR: CecLogMessage - could not open a connection (try 1) 22:26:04 T:3040317440 NOTICE: Running database version Addons15 22:26:04 T:3040317440 NOTICE: Running database version ViewModes4 22:26:05 T:3040317440 NOTICE: Running database version Textures13 22:26:05 T:3040317440 NOTICE: Running database version MyMusic32 22:26:05 T:3040317440 NOTICE: Running database version MyVideos75 22:26:05 T:3040317440 NOTICE: Running database version TV22 22:26:05 T:3040317440 NOTICE: Running database version Epg7 22:26:05 T:3040317440 NOTICE: start dvd mediatype detection 22:26:05 T:3040317440 NOTICE: initializing playlistplayer 22:26:05 T:3040317440 NOTICE: DONE initializing playlistplayer 22:26:05 T:2951406656 NOTICE: Thread CDetectDVDMedia start, auto delete: false 22:26:06 T:3029529664 ERROR: CecLogMessage - RegisterLogicalAddress - vc_cec_set_logical_address(E) returned invalid arg (8) 22:26:06 T:3029529664 ERROR: CecLogMessage - Open - vc_cec could not be initialised 22:26:06 T:3029529664 ERROR: CecLogMessage - RegisterLogicalAddress - vc_cec_set_logical_address(1) returned invalid arg (8) 22:26:06 T:2939532352 NOTICE: Thread CEC Adapter Update Thread start, auto delete: false 22:26:09 T:2930345024 NOTICE: Thread XBPyThread start, auto delete: false 22:26:09 T:3040317440 NOTICE: Previous line repeats 1 times. 22:26:09 T:3040317440 NOTICE: initialize done 22:26:09 T:3040317440 NOTICE: Running the application... 22:26:09 T:2913301568 NOTICE: Thread XBPyThread start, auto delete: false 22:26:09 T:3040317440 ERROR: GLES: Vertical Blank Syncing unsupported 22:26:10 T:2930345024 NOTICE: -->Python Interpreter Initialized<-- 22:26:10 T:2921956416 NOTICE: -->Python Interpreter Initialized<-- 22:26:10 T:2913301568 NOTICE: -->Python Interpreter Initialized<-- 22:26:11 T:2904020032 NOTICE: Thread Jobworker start, auto delete: true 22:26:12 T:3040317440 NOTICE: Webserver: Starting... 22:26:12 T:3040317440 NOTICE: WebServer: Started the webserver 22:26:12 T:3040317440 NOTICE: ES: Starting event server 22:26:12 T:3040317440 NOTICE: starting zeroconf publishing 22:26:12 T:2853688384 NOTICE: Thread CEventServer start, auto delete: false 22:26:12 T:2853688384 NOTICE: ES: Starting UDP Event server on 0.0.0.0:9777 22:26:12 T:2853688384 NOTICE: UDP: Listening on port 9777 22:26:12 T:2836911168 NOTICE: Thread Jobworker start, auto delete: true 22:26:12 T:2845299776 NOTICE: Thread CTCPServer start, auto delete: false 22:26:15 T:2913301568 NOTICE: StorageServer Module loaded RUN 22:26:15 T:2913301568 NOTICE: StorageClient-2.5.2 Starting server 22:26:15 T:2913301568 NOTICE: StorageServer-2.5.2 Storage Server starting /home/pi/.xbmc/temp/commoncache.db 22:26:15 T:2930345024 NOTICE: services: {'sys.service.avahi': 'true', 'sys.service.del': 'false', 'sys.service.tvh': 'true', 'sys.service.remote': 'true', 'sys.service.surveil': 'false', 'sys.service.ftp': 'true', 'sys.service.samba': 'true', 'sys.service.vnc': 'true', 'sys.service.boblight': 'false', 'sys.service.ssh': 'true', 'sys.service.cron': 'false', 'sys.service.sab': 'false'} 22:26:15 T:2930345024 NOTICE: enable service: avahi-daemon 22:26:16 T:2930345024 NOTICE: disable service: deluge 22:26:16 T:2930345024 NOTICE: enable service: tvheadend 22:26:16 T:2930345024 NOTICE: enable service: eventlircd 22:26:17 T:2930345024 NOTICE: disable service: surveil 22:26:18 T:2930345024 NOTICE: enable service: ftp 22:26:19 T:2930345024 NOTICE: enable service: samba 22:26:19 T:2930345024 NOTICE: enable service: vnc 22:26:20 T:2930345024 NOTICE: disable service: boblight 22:26:22 T:2930345024 NOTICE: enable service: ssh 22:26:22 T:2930345024 NOTICE: disable service: cron 22:26:23 T:2930345024 NOTICE: disable service: sabnzbd 22:26:26 T:2930345024 NOTICE: system settings from addon: {'sys.config.freq.arm': 850, 'sys.config.freq.gpu': 250, 'sys.config.freq.sdram': 400, 'sys.config.freq.core': 375, 'sys.config.freq.overvolt': 0, 'sys.config.decode.wvc1': '', 'sys.config.disable.overscan': '1', 'sys.config.decode.ac3': '', 'sys.config.freq.isp': 250, 'sys.config.decode.mpg2': '', 'sys.config.decode.dts': ''} 22:26:26 T:2930345024 NOTICE: system settings from /boot/config.txt: {'sys.config.freq.arm': 850, 'sys.config.freq.gpu': 250, 'sys.config.freq.sdram': 400, 'sys.config.freq.core': 375, 'sys.config.freq.overvolt': 0, 'sys.config.decode.wvc1': '', 'sys.config.disable.overscan': '1', 'sys.config.decode.ac3': '', 'sys.config.freq.isp': 250, 'sys.config.decode.mpg2': '', 'sys.config.decode.dts': ''} 23:54:50 T:2853688384 NOTICE: ES: Incoming connection from XBMC Constellation 23:54:58 T:2904020032 NOTICE: Thread XBPyThread start, auto delete: false 23:54:59 T:2904020032 NOTICE: -->Python Interpreter Initialized<-- 23:55:00 T:2904020032 NOTICE: Loading cookies from :'/home/pi/.xbmc/userdata/addon_data/plugin.video.youtube/yt-cookiejar.txt' 23:55:00 T:2904020032 NOTICE: YouTube-4.4.6 23:55:03 T:2904020032 NOTICE: CommonFunctions-2.5.1 23:55:07 T:2904020032 NOTICE: links: 'dict' 23:55:09 T:3040317440 NOTICE: COMXPlayer: Opening: http://r17---sn-4g57lnls.googlevideo.com/videoplayback?ms=au&source=youtube&mv=m&upn=uaD2k4OxIpU&id=e098a91c4cf9dec5&fexp=903802,913432,923309,919007,921091,916613,906009,909717,932295,936912,936910,923305,936913,907231,907240&key=yt5&ratebypass=yes&sparams=id,ip,ipbits,itag,ratebypass,source,upn,expire&sver=3&ipbits=0&mt=1387148058&itag=22&ip=94.218.64.160&expire=1387170986&signature=6637A71BFAF78B0302CCFE2EEACB0B35EC4BC48D.DFFF4661DA81AD90486E1D68CDE0F770C0B106B2|User-Agent=Mozilla%2F5.0+%28Windows+NT+6.2%3B+Win64%3B+x64%3B+rv%3A16.0.1%29+Gecko%2F20121011+Firefox%2F16.0.1 23:55:11 T:3040317440 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 23:55:11 T:2904020032 NOTICE: Thread COMXPlayer start, auto delete: false 23:55:11 T:2904020032 NOTICE: Creating InputStream 23:55:11 T:2904020032 NOTICE: Creating Demuxer 23:55:11 T:2836911168 NOTICE: Thread CFileCache start, auto delete: false 23:55:19 T:2904020032 NOTICE: Opening video stream: 0 source: 256 23:55:19 T:2904020032 NOTICE: Creating video thread 23:55:19 T:2930345024 NOTICE: Thread COMXPlayerVideo start, auto delete: false 23:55:19 T:2904020032 NOTICE: Opening audio stream: 1 source: 256 23:55:19 T:2904020032 NOTICE: Creating audio thread 23:55:19 T:2921956416 NOTICE: Thread COMXPlayerAudio start, auto delete: false 23:55:19 T:2904020032 NOTICE: OMXClock using audio as reference 23:55:19 T:2930345024 NOTICE: Display resolution DESKTOP : 720x480 @ 60.00i - Full Screen (16) 23:55:19 T:3040317440 NOTICE: Using GL_TEXTURE_2D 23:55:19 T:3040317440 NOTICE: GL: Using BYPASS render method 23:55:19 T:3040317440 NOTICE: GL: NPOT texture support detected 23:55:52 T:2930345024 WARNING: CRenderManager::FlipPage - timeout waiting for flip to complete 23:55:52 T:2930345024 WARNING: CRenderManager::FlipPage - timeout waiting for previous frame 23:55:52 T:2782917696 WARNING: Previous line repeats 2 times. 23:55:52 T:2782917696 NOTICE: Thread XBPyThread start, auto delete: false 23:55:52 T:2772431936 NOTICE: Thread Jobworker start, auto delete: true 23:55:53 T:2930345024 WARNING: CRenderManager::FlipPage - timeout waiting for previous frame 23:55:53 T:2764043328 NOTICE: Thread Jobworker start, auto delete: true 23:55:53 T:2930345024 WARNING: CRenderManager::FlipPage - timeout waiting for previous frame 23:55:54 T:2782917696 WARNING: Previous line repeats 1 times. 23:55:54 T:2782917696 NOTICE: -->Python Interpreter Initialized<-- 23:55:57 T:2782917696 NOTICE: Loading cookies from :'/home/pi/.xbmc/userdata/addon_data/plugin.video.youtube/yt-cookiejar.txt' 23:55:57 T:2782917696 NOTICE: YouTube-4.4.6 23:56:01 T:2782917696 NOTICE: CommonFunctions-2.5.1 23:56:10 T:2782917696 NOTICE: links: 'dict' 23:56:11 T:3040317440 NOTICE: COMXPlayer: Opening: http://r8---sn-4g57kn6r.googlevideo.com/videoplayback?fexp=900225,906373,905611,906439,914073,916611,901448,942424,909717,932295,936912,936910,923305,936913,907231,907240&ms=au&ipbits=0&ratebypass=yes&expire=1387170553&source=youtube&sparams=id,ip,ipbits,itag,ratebypass,source,upn,expire&ip=94.218.64.160&itag=22&key=yt5&id=8f9fb22a10ddeb8b&mt=1387148118&mv=m&sver=3&upn=Xf0XOKtZQiI&signature=34CE881C486FB0BE6DA9BF155D2F31BB8FA04183.0BC7078099BE68797F5A909C35B4AA34E92D1E13|User-Agent=Mozilla%2F5.0+%28Windows+NT+6.2%3B+Win64%3B+x64%3B+rv%3A16.0.1%29+Gecko%2F20121011+Firefox%2F16.0.1 23:56:11 T:3040317440 NOTICE: COMXPlayer::CloseFile 23:56:11 T:3040317440 NOTICE: COMXPlayer: waiting for threads to exit 23:56:11 T:2904020032 NOTICE: COMXPlayer::OnExit() 23:56:11 T:2904020032 NOTICE: OMXPlayer: closing audio stream 23:56:11 T:2904020032 NOTICE: Closing audio stream 23:56:11 T:2921956416 NOTICE: thread end: OMXPlayerAudio::OnExit() 23:56:11 T:2904020032 NOTICE: OMXPlayer: closing video stream 23:56:11 T:2904020032 NOTICE: Closing video stream 23:56:11 T:2930345024 NOTICE: thread end: video_thread 23:56:11 T:2904020032 NOTICE: COMXPlayer::OnExit() deleting demuxer 23:56:11 T:2904020032 NOTICE: COMXPlayer::OnExit() deleting input stream 23:56:11 T:3040317440 NOTICE: DVDPlayer: finished waiting 23:56:11 T:3040317440 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 23:56:11 T:2836911168 NOTICE: Thread COMXPlayer start, auto delete: false 23:56:11 T:2836911168 NOTICE: Creating InputStream 23:56:12 T:2836911168 NOTICE: Creating Demuxer 23:56:12 T:2904020032 NOTICE: Thread CFileCache start, auto delete: false 23:56:18 T:2836911168 NOTICE: Opening video stream: 0 source: 256 23:56:18 T:2836911168 NOTICE: Creating video thread 23:56:18 T:2930345024 NOTICE: Thread COMXPlayerVideo start, auto delete: false 23:56:18 T:2836911168 NOTICE: Opening audio stream: 1 source: 256 23:56:18 T:2836911168 NOTICE: Creating audio thread 23:56:18 T:2921956416 NOTICE: Thread COMXPlayerAudio start, auto delete: false 23:56:18 T:2930345024 WARNING: CRenderManager::Configure - timeout waiting for previous frame 23:56:18 T:2930345024 NOTICE: Display resolution DESKTOP : 720x480 @ 60.00i - Full Screen (16) 23:56:20 T:2930345024 WARNING: CRenderManager::FlipPage - timeout waiting for flip to complete 23:56:20 T:2930345024 WARNING: CRenderManager::FlipPage - timeout waiting for previous frame 23:56:20 T:3040317440 NOTICE: Using GL_TEXTURE_2D 23:56:20 T:3040317440 NOTICE: GL: Using BYPASS render method 23:56:20 T:3040317440 NOTICE: GL: NPOT texture support detected 23:57:02 T:2764043328 NOTICE: Thread XBPyThread start, auto delete: false 23:57:02 T:2772431936 NOTICE: Thread Jobworker start, auto delete: true 23:57:03 T:2764043328 NOTICE: Previous line repeats 1 times. 23:57:03 T:2764043328 NOTICE: -->Python Interpreter Initialized<-- 23:57:06 T:2764043328 NOTICE: Loading cookies from :'/home/pi/.xbmc/userdata/addon_data/plugin.video.youtube/yt-cookiejar.txt' 23:57:06 T:2764043328 NOTICE: YouTube-4.4.6 23:57:07 T:2764043328 NOTICE: CommonFunctions-2.5.1 23:57:12 T:2764043328 NOTICE: links: 'dict' 23:57:13 T:3040317440 NOTICE: COMXPlayer: Opening: http://r1---sn-4g57knke.googlevideo.com/videoplayback?ipbits=0&ratebypass=yes&ip=94.218.64.160&key=yt5&fexp=927604,916625,909717,924616,932295,936912,936910,923305,936913,907231,907240&source=youtube&ms=au&upn=1s19T7TiWHc&id=17956fbd5c6e2a4a&mv=m&mt=1387148118&sparams=id,ip,ipbits,itag,ratebypass,source,upn,expire&expire=1387168336&sver=3&itag=43&signature=C46BB9DD0CD3DF1D859499F71046E7793F8B3F53.4A7E18BB35123D9FF0A20C4DAE0DA24D1EEAF110|User-Agent=Mozilla%2F5.0+%28Windows+NT+6.2%3B+Win64%3B+x64%3B+rv%3A16.0.1%29+Gecko%2F20121011+Firefox%2F16.0.1 23:57:13 T:3040317440 NOTICE: COMXPlayer::CloseFile 23:57:13 T:3040317440 NOTICE: COMXPlayer: waiting for threads to exit 23:57:13 T:2836911168 NOTICE: COMXPlayer::OnExit() 23:57:13 T:2836911168 NOTICE: OMXPlayer: closing audio stream 23:57:13 T:2836911168 NOTICE: Closing audio stream 23:57:13 T:2921956416 NOTICE: thread end: OMXPlayerAudio::OnExit() 23:57:13 T:2836911168 NOTICE: OMXPlayer: closing video stream 23:57:13 T:2836911168 NOTICE: Closing video stream 23:57:13 T:2930345024 NOTICE: thread end: video_thread 23:57:15 T:2836911168 ERROR: COMXCoreComponent::WaitForCommand OMX.broadcom.video_decode wait timeout event.eEvent 0x00000000 event.command 0x00000001 event.nData2 130 23:57:19 T:2836911168 ERROR: Previous line repeats 1 times. 23:57:19 T:2836911168 ERROR: COMXCoreComponent::WaitForCommand OMX.broadcom.video_decode wait timeout event.eEvent 0x00000000 event.command 0x00000001 event.nData2 131 23:57:21 T:2836911168 ERROR: COMXCoreComponent::WaitForCommand OMX.broadcom.video_decode wait timeout event.eEvent 0x00000000 event.command 0x00000002 event.nData2 130 23:57:21 T:2836911168 ERROR: COMXCoreComponent::FreeInputBuffers WaitForCommand:OMX_CommandPortDisable failed on OMX.broadcom.video_decode omx_err(0x80001011) 23:57:22 T:2836911168 ERROR: COMXCoreComponent::WaitForInputDone OMX.broadcom.video_decode wait event timeout 23:57:22 T:2836911168 ERROR: COMXCoreComponent::SetStateForComponent - OMX.broadcom.video_decode failed with omx_err(0x80001000) 23:58:12 T:2853688384 ERROR: Previous line repeats 1 times. 23:58:12 T:2853688384 NOTICE: ES: Incoming connection from XBMC Constellation 23:58:45 T:2853688384 NOTICE: ES: Client XBMC Constellation from 192.168.2.102 timed out