12:40:19 T:2500 NOTICE: ----------------------------------------------------------------------- 12:40:19 T:2500 NOTICE: Starting XBMC (11.0 Git:20120321-14feb09), Platform: Windows 7, 32-bit Service Pack 1 build 7601. Built on Mar 21 2012 (compiler 1600) 12:40:19 T:2500 NOTICE: Intel(R) Atom(TM) CPU N270 @ 1.60GHz 12:40:19 T:2500 NOTICE: Desktop Resolution: 1920x1080 32Bit at 50Hz 12:40:19 T:2500 NOTICE: Running with restricted rights 12:40:19 T:2500 NOTICE: Aero is disabled 12:40:19 T:2500 NOTICE: special://xbmc/ is mapped to: C:\Program Files\XBMC 12:40:19 T:2500 NOTICE: special://xbmcbin/ is mapped to: C:\Program Files\XBMC 12:40:19 T:2500 NOTICE: special://masterprofile/ is mapped to: C:\Users\44q\AppData\Roaming\XBMC\userdata 12:40:19 T:2500 NOTICE: special://home/ is mapped to: C:\Users\44q\AppData\Roaming\XBMC\ 12:40:19 T:2500 NOTICE: special://temp/ is mapped to: C:\Users\44q\AppData\Roaming\XBMC\cache 12:40:19 T:2500 NOTICE: The executable running is: C:\Program Files\XBMC\XBMC.exe 12:40:19 T:2500 NOTICE: Local hostname: S20HTPC 12:40:19 T:2500 NOTICE: Log File is located: C:\Users\44q\AppData\Roaming\XBMC\xbmc.log 12:40:19 T:2500 NOTICE: ----------------------------------------------------------------------- 12:40:19 T:2500 NOTICE: Setup SDL 12:40:19 T:2500 NOTICE: Found screen: PnP-Monitor (Standard) on NVIDIA ION , adapter 0. 12:40:19 T:2500 NOTICE: Primary mode: 1920x1080 @ 50.00 - Full Screen 12:40:19 T:2500 NOTICE: Additional mode: 640x480 @ 60.00 - Full Screen 12:40:19 T:2500 NOTICE: Additional mode: 640x480 @ 59.94 - Full Screen 12:40:19 T:2500 NOTICE: Additional mode: 640x480 @ 72.00 - Full Screen 12:40:19 T:2500 NOTICE: Additional mode: 640x480 @ 75.00 - Full Screen 12:40:19 T:2500 NOTICE: Additional mode: 720x480 @ 60.00 - Full Screen 12:40:19 T:2500 NOTICE: Additional mode: 720x480 @ 59.94 - Full Screen 12:40:19 T:2500 NOTICE: Additional mode: 720x576 @ 50.00 - Full Screen 12:40:19 T:2500 NOTICE: Additional mode: 800x600 @ 56.00 - Full Screen 12:40:19 T:2500 NOTICE: Additional mode: 800x600 @ 60.00 - Full Screen 12:40:19 T:2500 NOTICE: Additional mode: 800x600 @ 72.00 - Full Screen 12:40:19 T:2500 NOTICE: Additional mode: 800x600 @ 75.00 - Full Screen 12:40:19 T:2500 NOTICE: Additional mode: 1024x768 @ 60.00 - Full Screen 12:40:19 T:2500 NOTICE: Additional mode: 1024x768 @ 70.00 - Full Screen 12:40:19 T:2500 NOTICE: Additional mode: 1024x768 @ 75.00 - Full Screen 12:40:19 T:2500 NOTICE: Additional mode: 1152x864 @ 60.00 - Full Screen 12:40:19 T:2500 NOTICE: Previous line repeats 2 times. 12:40:19 T:2500 NOTICE: Additional mode: 1176x664 @ 50.00 - Full Screen 12:40:19 T:2500 NOTICE: Previous line repeats 2 times. 12:40:19 T:2500 NOTICE: Additional mode: 1176x664 @ 60.00 - Full Screen 12:40:19 T:2500 NOTICE: Previous line repeats 2 times. 12:40:19 T:2500 NOTICE: Additional mode: 1176x664 @ 59.94 - Full Screen 12:40:19 T:2500 NOTICE: Previous line repeats 2 times. 12:40:19 T:2500 NOTICE: Additional mode: 1280x720 @ 50.00 - Full Screen 12:40:19 T:2500 NOTICE: Additional mode: 1280x720 @ 60.00 - Full Screen 12:40:19 T:2500 NOTICE: Additional mode: 1280x720 @ 59.94 - Full Screen 12:40:19 T:2500 NOTICE: Additional mode: 1280x768 @ 60.00 - Full Screen 12:40:19 T:2500 NOTICE: Previous line repeats 2 times. 12:40:19 T:2500 NOTICE: Additional mode: 1280x800 @ 60.00 - Full Screen 12:40:19 T:2500 NOTICE: Previous line repeats 2 times. 12:40:19 T:2500 NOTICE: Additional mode: 1280x960 @ 60.00 - Full Screen 12:40:19 T:2500 NOTICE: Previous line repeats 2 times. 12:40:19 T:2500 NOTICE: Additional mode: 1280x1024 @ 60.00 - Full Screen 12:40:19 T:2500 NOTICE: Additional mode: 1360x768 @ 60.00 - Full Screen 12:40:19 T:2500 NOTICE: Additional mode: 1440x900 @ 50.00 - Full Screen 12:40:19 T:2500 NOTICE: Previous line repeats 2 times. 12:40:19 T:2500 NOTICE: Additional mode: 1440x900 @ 60.00 - Full Screen 12:40:19 T:2500 NOTICE: Previous line repeats 2 times. 12:40:19 T:2500 NOTICE: Additional mode: 1440x900 @ 59.94 - Full Screen 12:40:19 T:2500 NOTICE: Previous line repeats 2 times. 12:40:19 T:2500 NOTICE: Additional mode: 1440x900 @ 24.00 - Full Screen 12:40:19 T:2500 NOTICE: Previous line repeats 2 times. 12:40:19 T:2500 NOTICE: Additional mode: 1440x900 @ 23.98 - Full Screen 12:40:19 T:2500 NOTICE: Previous line repeats 2 times. 12:40:19 T:2500 NOTICE: Additional mode: 1600x900 @ 50.00 - Full Screen 12:40:19 T:2500 NOTICE: Previous line repeats 2 times. 12:40:19 T:2500 NOTICE: Additional mode: 1600x900 @ 60.00 - Full Screen 12:40:19 T:2500 NOTICE: Previous line repeats 2 times. 12:40:19 T:2500 NOTICE: Additional mode: 1600x900 @ 59.94 - Full Screen 12:40:19 T:2500 NOTICE: Previous line repeats 2 times. 12:40:19 T:2500 NOTICE: Additional mode: 1600x900 @ 24.00 - Full Screen 12:40:19 T:2500 NOTICE: Previous line repeats 2 times. 12:40:19 T:2500 NOTICE: Additional mode: 1600x900 @ 23.98 - Full Screen 12:40:19 T:2500 NOTICE: Previous line repeats 2 times. 12:40:19 T:2500 NOTICE: Additional mode: 1600x1024 @ 50.00 - Full Screen 12:40:19 T:2500 NOTICE: Previous line repeats 2 times. 12:40:19 T:2500 NOTICE: Additional mode: 1600x1024 @ 60.00 - Full Screen 12:40:19 T:2500 NOTICE: Previous line repeats 2 times. 12:40:19 T:2500 NOTICE: Additional mode: 1600x1024 @ 59.94 - Full Screen 12:40:19 T:2500 NOTICE: Previous line repeats 2 times. 12:40:19 T:2500 NOTICE: Additional mode: 1600x1024 @ 24.00 - Full Screen 12:40:19 T:2500 NOTICE: Previous line repeats 2 times. 12:40:19 T:2500 NOTICE: Additional mode: 1600x1024 @ 23.98 - Full Screen 12:40:19 T:2500 NOTICE: Previous line repeats 2 times. 12:40:19 T:2500 NOTICE: Additional mode: 1600x1200 @ 60.00 - Full Screen 12:40:19 T:2500 NOTICE: Additional mode: 1680x1050 @ 50.00 - Full Screen 12:40:19 T:2500 NOTICE: Previous line repeats 2 times. 12:40:19 T:2500 NOTICE: Additional mode: 1680x1050 @ 60.00 - Full Screen 12:40:19 T:2500 NOTICE: Previous line repeats 2 times. 12:40:19 T:2500 NOTICE: Additional mode: 1680x1050 @ 59.94 - Full Screen 12:40:19 T:2500 NOTICE: Previous line repeats 2 times. 12:40:19 T:2500 NOTICE: Additional mode: 1680x1050 @ 24.00 - Full Screen 12:40:19 T:2500 NOTICE: Previous line repeats 2 times. 12:40:19 T:2500 NOTICE: Additional mode: 1680x1050 @ 23.98 - Full Screen 12:40:19 T:2500 NOTICE: Previous line repeats 2 times. 12:40:19 T:2500 NOTICE: Additional mode: 1768x992 @ 50.00 - Full Screen 12:40:19 T:2500 NOTICE: Previous line repeats 2 times. 12:40:19 T:2500 NOTICE: Additional mode: 1768x992 @ 60.00 - Full Screen 12:40:19 T:2500 NOTICE: Previous line repeats 2 times. 12:40:19 T:2500 NOTICE: Additional mode: 1768x992 @ 59.94 - Full Screen 12:40:19 T:2500 NOTICE: Previous line repeats 2 times. 12:40:19 T:2500 NOTICE: Additional mode: 1768x992 @ 25.00i - Full Screen 12:40:19 T:2500 NOTICE: Previous line repeats 2 times. 12:40:19 T:2500 NOTICE: Additional mode: 1768x992 @ 24.00 - Full Screen 12:40:19 T:2500 NOTICE: Previous line repeats 2 times. 12:40:19 T:2500 NOTICE: Additional mode: 1768x992 @ 23.98 - Full Screen 12:40:19 T:2500 NOTICE: Previous line repeats 2 times. 12:40:19 T:2500 NOTICE: Additional mode: 1768x992 @ 30.00i - Full Screen 12:40:19 T:2500 NOTICE: Previous line repeats 2 times. 12:40:19 T:2500 NOTICE: Additional mode: 1768x992 @ 29.97i - Full Screen 12:40:19 T:2500 NOTICE: Previous line repeats 2 times. 12:40:19 T:2500 NOTICE: Additional mode: 1920x1080 @ 50.00 - Full Screen 12:40:19 T:2500 NOTICE: Additional mode: 1920x1080 @ 60.00 - Full Screen 12:40:19 T:2500 NOTICE: Additional mode: 1920x1080 @ 59.94 - Full Screen 12:40:19 T:2500 NOTICE: Additional mode: 1920x1080 @ 25.00i - Full Screen 12:40:19 T:2500 NOTICE: Additional mode: 1920x1080 @ 24.00 - Full Screen 12:40:19 T:2500 NOTICE: Additional mode: 1920x1080 @ 23.98 - Full Screen 12:40:19 T:2500 NOTICE: Additional mode: 1920x1080 @ 30.00i - Full Screen 12:40:19 T:2500 NOTICE: Additional mode: 1920x1080 @ 29.97i - Full Screen 12:40:19 T:2500 NOTICE: Additional mode: 1400x1050 @ 60.00 - Full Screen 12:40:19 T:2500 NOTICE: load settings... 12:40:20 T:2500 NOTICE: special://profile/ is mapped to: special://masterprofile/ 12:40:20 T:2500 NOTICE: loading special://masterprofile/guisettings.xml 12:40:20 T:2500 NOTICE: Getting hardware information now... 12:40:20 T:2500 NOTICE: Checking resolution 12 12:40:20 T:2500 NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml. 12:40:20 T:2500 NOTICE: Loaded playercorefactory configuration 12:40:20 T:2500 NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml. 12:40:20 T:2500 NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping. 12:40:20 T:2500 NOTICE: No settings file to load (special://xbmc/system/advancedsettings.xml) 12:40:20 T:2500 NOTICE: No settings file to load (special://masterprofile/advancedsettings.xml) 12:40:20 T:2500 NOTICE: Default DVD Player: dvdplayer 12:40:20 T:2500 NOTICE: Default Video Player: dvdplayer 12:40:20 T:2500 NOTICE: Default Audio Player: paplayer 12:40:20 T:2500 NOTICE: Disabled debug logging due to GUI setting. Level 0. 12:40:20 T:2500 NOTICE: Log level changed to 0 12:40:20 T:2500 NOTICE: Loading media sources from special://masterprofile/sources.xml 12:40:22 T:2500 NOTICE: initializing playlistplayer 12:40:22 T:2500 NOTICE: DONE initializing playlistplayer 12:40:22 T:4748 ERROR: CRemoteControl::Connect - failed to connect 12:40:26 T:1996 NOTICE: -->Python Interpreter Initialized<-- 12:40:27 T:2500 NOTICE: initialize done 12:40:27 T:2500 NOTICE: Running the application... 12:40:27 T:2500 NOTICE: Webserver: Starting... 12:40:27 T:2500 NOTICE: WebServer: Started the webserver 12:40:27 T:2500 NOTICE: ES: Starting event server 12:40:27 T:3848 NOTICE: ES: Starting UDP Event server on 0.0.0.0:9777 12:40:27 T:2500 NOTICE: starting zeroconf publishing 12:40:27 T:3848 NOTICE: UDP: Listening on port 9777 12:40:27 T:2500 ERROR: Control 1 in window 10099 has been asked to focus, but it can't 12:40:28 T:1996 NOTICE: downloader ARGV: [''] 12:40:28 T:3416 NOTICE: -->Python Interpreter Initialized<-- 12:40:28 T:328 NOTICE: -->Python Interpreter Initialized<-- 12:40:29 T:2180 NOTICE: -->Python Interpreter Initialized<-- 12:40:33 T:328 NOTICE: Artwork Downloader: ## Service - Run at startup: False 12:40:33 T:328 NOTICE: Artwork Downloader: ## Service - Delayed startup: -- minutes 12:40:33 T:328 NOTICE: Artwork Downloader: ## Service - Run as service: False 12:40:33 T:328 NOTICE: Artwork Downloader: ## Service - Time: 00:00 12:40:33 T:2180 NOTICE: StorageServer Module loaded RUN 12:40:33 T:2180 NOTICE: StorageClient-0.9.2 Starting server 12:40:33 T:2180 NOTICE: StorageServer-0.9.2 Storage Server starting C:\Users\44q\AppData\Roaming\XBMC\userdata\Database\commoncache.db 12:40:35 T:688 NOTICE: -->Python Interpreter Initialized<-- 12:40:37 T:2500 ERROR: Python script "script.tv.show.next.aired" does not exist 12:40:37 T:2500 ERROR: Control 31 in window 10000 has been asked to focus, but it can't 12:40:39 T:2500 WARNING: Trying to add unsupported control type 3 12:40:43 T:2500 ERROR: unmatched parentheses in IsEmpty(Window(Home).Property(DontRunTVShowScripts) 12:40:53 T:2500 ERROR: Control 1 in window 10099 has been asked to focus, but it can't 12:40:59 T:2500 ERROR: Control 31 in window 10000 has been asked to focus, but it can't 12:41:00 T:2500 WARNING: Trying to add unsupported control type 3 12:41:17 T:2500 ERROR: Control 31 in window 10000 has been asked to focus, but it can't 12:41:18 T:2500 WARNING: Trying to add unsupported control type 3 12:41:22 T:2500 ERROR: Control 1 in window 10099 has been asked to focus, but it can't 12:41:34 T:1156 NOTICE: -->Python Interpreter Initialized<-- 12:41:36 T:1156 NOTICE: [script.cinema.experience] - Script Name: Cinema Experience 12:41:36 T:1156 NOTICE: [script.cinema.experience] - Script ID: script.cinema.experience 12:41:36 T:1156 NOTICE: [script.cinema.experience] - Script Version: 1.0.46 12:41:36 T:1156 NOTICE: [script.cinema.experience] - Autorefresh - Before Script: False 12:41:36 T:1156 NOTICE: [script.cinema.experience] - Starting Window ID: 10025 12:41:36 T:1156 NOTICE: [script.cinema.experience] - Log Level: 0 12:41:37 T:1156 NOTICE: [script.cinema.experience] - Video Playlist Cleared 12:41:37 T:1156 NOTICE: [script.cinema.experience] - Music Playlist Cleared 12:41:37 T:1156 NOTICE: [script.cinema.experience] - Action(Queue,25) 12:41:37 T:1156 NOTICE: [script.cinema.experience] - Library_view: oldway 12:41:37 T:1156 NOTICE: [script.cinema.experience] - auto_refresh( False, disable ) 12:41:37 T:1156 NOTICE: [script.cinema.experience] - Autorefresh Status: False 12:41:37 T:1156 NOTICE: [script.cinema.experience] - Feature - 12 Monkeys 12:41:37 T:1156 NOTICE: [script.cinema.experience] - Storing Playlist 12:41:37 T:1156 NOTICE: [script.cinema.experience] - Error - Playlist Empty 12:41:37 T:3652 WARNING: 'xbmc.output()' is depreciated and will be removed in future releases, please use 'xbmc.log()' instead 12:41:37 T:3652 NOTICE: [script.cinema.experience] - [ home_automation.py ] - activate_on( Script Start ) Triggered 12:41:38 T:1156 NOTICE: [script.cinema.experience] - [ce_playlist.py] - Rebuilding Playlist 12:41:38 T:1156 NOTICE: [] 12:41:38 T:1156 ERROR: Traceback (most recent call last): 12:41:38 T:1156 ERROR: File "C:\Users\44q\AppData\Roaming\XBMC\addons\script.cinema.experience\resources\lib\ce_playlist.py", line 262, in _get_queued_video_info 12:41:38 T:1156 ERROR: movie_title = xbmc.PlayList( xbmc.PLAYLIST_VIDEO )[ feature ].getdescription() 12:41:38 T:1156 ERROR: TypeError: array out of bound 12:41:38 T:1156 NOTICE: [script.cinema.experience] - Building Cinema Experience Playlist 12:41:38 T:1156 NOTICE: [script.cinema.experience] - Adding Audio Format Video 12:41:38 T:1156 NOTICE: [script.cinema.experience] - Adding Countdown Videos: 0 Video(s) 12:41:38 T:1156 NOTICE: [script.cinema.experience] - Adding Ratings Video 12:41:38 T:1156 NOTICE: [script.cinema.experience] - Adding Feature Presentation Intro Videos: 1 Videos 12:41:38 T:1156 NOTICE: [script.cinema.experience] - Retriving Trailers: 0 Trailers 12:41:38 T:1156 NOTICE: [script.cinema.experience] - Adding Coming Attraction Outro Video: 1 Videos 12:41:38 T:1156 NOTICE: [script.cinema.experience] - Adding Trailers: 0 Trailers 12:41:38 T:1156 NOTICE: [script.cinema.experience] - Adding Coming Attraction Intro Videos: 1 Videos 12:41:38 T:1156 NOTICE: [script.cinema.experience] - Adding Movie Theatre Intro Videos: 0 Videos 12:41:38 T:1156 NOTICE: 0 12:41:38 T:1156 NOTICE: [script.cinema.experience] - Adding Feature Presentation Outro Videos: 1 Videos 12:41:38 T:1156 NOTICE: [script.cinema.experience] - Adding Movie Theatre Outro Videos: 0 Videos 12:41:38 T:1156 NOTICE: [script.cinema.experience] - Playlist Size: 2 12:41:38 T:1156 NOTICE: [script.cinema.experience] - Trigger List Size: 3 12:41:38 T:1156 NOTICE: [script.cinema.experience] - Saving trigger List 12:41:39 T:5512 WARNING: 'xbmc.output()' is depreciated and will be removed in future releases, please use 'xbmc.log()' instead 12:41:39 T:5512 NOTICE: [script.cinema.experience] - [ home_automation.py ] - activate_on( Script Start ) Triggered 12:41:39 T:2500 NOTICE: DVDPlayer: Opening: D:\Mediacenter\My Stuff\Cinema Experience\Feature Presentation Intro\hd_thx_amazing_life.m2ts 12:41:39 T:2500 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 12:41:39 T:5544 NOTICE: Creating InputStream 12:41:39 T:5544 NOTICE: Creating Demuxer 12:41:41 T:5544 NOTICE: Opening video stream: 0 source: 256 12:41:41 T:5544 NOTICE: Creating video codec with codec id: 28 12:41:41 T:5544 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 12:41:41 T:5544 NOTICE: Creating video thread 12:41:41 T:5544 NOTICE: Opening audio stream: 1 source: 256 12:41:41 T:5544 NOTICE: Finding audio codec for: 86019 12:41:41 T:1044 NOTICE: running thread: video_thread 12:41:41 T:5544 NOTICE: Creating audio thread 12:41:41 T:3828 NOTICE: running thread: CDVDPlayerAudio::Process() 12:41:42 T:3828 NOTICE: Creating audio device with codec id: 86019, channels: 2, sample rate: 48000, pass-through 12:41:42 T:1044 NOTICE: fps: 23.976024, pwidth: 1920, pheight: 1080, dwidth: 1920, dheight: 1080 12:41:42 T:1044 NOTICE: Display resolution DESKTOP : 1920x1080 @ 50.00 - Full Screen (12) 12:41:42 T:1044 NOTICE: D3D: rendering method forced to DXVA2 processor 12:41:42 T:1044 NOTICE: DXVA: Auto deinterlacing mode workaround activated. Deinterlacing processor will be used only for interlaced frames. 12:41:43 T:1156 NOTICE: [script.cinema.experience] - Music Playlist Cleared 12:41:43 T:1156 NOTICE: [script.cinema.experience] - Loading Trigger List 12:41:44 T:1156 NOTICE: [script.cinema.experience] - Item From Trigger List: Feature Presentation Intro 12:41:44 T:1156 NOTICE: [script.cinema.experience] - Playlist Position: 1 Playlist Size: 2 12:41:44 T:1156 NOTICE: [script.cinema.experience] - autorefresh_movie: False 12:41:44 T:5508 WARNING: 'xbmc.output()' is depreciated and will be removed in future releases, please use 'xbmc.log()' instead 12:41:44 T:5508 NOTICE: [script.cinema.experience] - [ home_automation.py ] - activate_on( Feature Presentation Intro ) Triggered 12:42:27 T:1044 WARNING: CDVDMessageQueue(video)::Get - asked for new data packet, with nothing available 12:42:27 T:3828 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available 12:42:27 T:5544 NOTICE: CDVDPlayer::OnExit() 12:42:27 T:5544 NOTICE: DVDPlayer: eof, waiting for queues to empty 12:42:27 T:5544 NOTICE: DVDPlayer: closing audio stream 12:42:27 T:5544 NOTICE: Closing audio stream 12:42:27 T:5544 NOTICE: CDVDMessageQueue(audio)::WaitUntilEmpty 12:42:27 T:5544 NOTICE: Waiting for audio thread to exit 12:42:27 T:3828 NOTICE: thread end: CDVDPlayerAudio::OnExit() 12:42:27 T:5544 NOTICE: Closing audio device 12:42:28 T:5544 NOTICE: Deleting audio codec 12:42:28 T:5544 NOTICE: DVDPlayer: closing video stream 12:42:28 T:5544 NOTICE: Closing video stream 12:42:28 T:5544 NOTICE: CDVDMessageQueue(video)::WaitUntilEmpty 12:42:28 T:5544 NOTICE: waiting for video thread to exit 12:42:28 T:1044 ERROR: Got MSGQ_ABORT or MSGO_IS_ERROR return true 12:42:28 T:1044 NOTICE: thread end: video_thread 12:42:28 T:5544 NOTICE: deleting video codec 12:42:28 T:5544 NOTICE: CDVDPlayer::OnExit() deleting demuxer 12:42:28 T:5544 NOTICE: CDVDPlayer::OnExit() deleting input stream 12:42:28 T:2500 NOTICE: DVDPlayer: Opening: D:\Mediacenter\My Stuff\Cinema Experience\Feature Presentation Outro\xbmc_ce_intro.mp4 12:42:28 T:2500 NOTICE: CDVDPlayer::CloseFile() 12:42:28 T:2500 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 12:42:28 T:2500 NOTICE: DVDPlayer: waiting for threads to exit 12:42:28 T:2500 NOTICE: DVDPlayer: finished waiting 12:42:28 T:2500 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 12:42:28 T:3400 NOTICE: Creating InputStream 12:42:28 T:3400 NOTICE: Creating Demuxer 12:42:28 T:3400 NOTICE: Opening video stream: 0 source: 256 12:42:28 T:3400 NOTICE: Creating video codec with codec id: 28 12:42:28 T:3400 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 12:42:28 T:3400 NOTICE: Creating video thread 12:42:28 T:3400 NOTICE: Opening audio stream: 1 source: 256 12:42:28 T:3400 NOTICE: Finding audio codec for: 86018 12:42:28 T:4576 NOTICE: running thread: video_thread 12:42:28 T:3400 NOTICE: Creating audio thread 12:42:28 T:3268 NOTICE: running thread: CDVDPlayerAudio::Process() 12:42:28 T:3268 NOTICE: Creating audio device with codec id: 86018, channels: 2, sample rate: 44100, no pass-through 12:42:28 T:4576 NOTICE: fps: 25.000000, pwidth: 1920, pheight: 1080, dwidth: 1920, dheight: 1080 12:42:28 T:4576 NOTICE: Display resolution DESKTOP : 1920x1080 @ 50.00 - Full Screen (12) 12:42:28 T:4576 NOTICE: D3D: rendering method forced to DXVA2 processor 12:42:28 T:4576 NOTICE: DXVA: Auto deinterlacing mode workaround activated. Deinterlacing processor will be used only for interlaced frames. 12:42:29 T:1156 NOTICE: [script.cinema.experience] - Item From Trigger List: Movie 12:42:29 T:1156 NOTICE: [script.cinema.experience] - Playlist Position: 2 Playlist Size: 2 12:42:29 T:1156 NOTICE: Previous line repeats 1 times. 12:42:29 T:1156 WARNING: 'xbmc.output()' is depreciated and will be removed in future releases, please use 'xbmc.log()' instead 12:42:29 T:1156 NOTICE: [script.cinema.experience] - [ home_automation.py ] - activate_on( Movie ) Triggered 12:42:29 T:1156 WARNING: 'xbmc.output()' is depreciated and will be removed in future releases, please use 'xbmc.log()' instead 12:42:29 T:1156 NOTICE: [script.cinema.experience] - [ home_automation.py ] - Movie Triggered 12:42:29 T:1156 NOTICE: [script.cinema.experience] - Item From Trigger List: Movie 12:42:29 T:1156 NOTICE: [ script.cinema.experience ] - [ ce_playlist.py ] - Waiting Until End Of Video 12:42:29 T:4576 WARNING: CRenderManager::FlipPage - timeout waiting for flip to complete 12:42:29 T:4576 WARNING: CRenderManager::FlipPage - timeout waiting for previous frame 12:42:30 T:2500 WARNING: Previous line repeats 4 times. 12:42:30 T:2500 WARNING: DXVA::CProcessor::Render - did not find all required samples, adjusting the sample array. 12:42:30 T:2500 WARNING: DXVA::CProcessor::Render - no usable samples. 12:42:52 T:4576 WARNING: CDVDMessageQueue(video)::Get - asked for new data packet, with nothing available 12:42:52 T:3268 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available 12:42:52 T:3400 NOTICE: CDVDPlayer::OnExit() 12:42:52 T:3400 NOTICE: DVDPlayer: eof, waiting for queues to empty 12:42:52 T:3400 NOTICE: DVDPlayer: closing audio stream 12:42:52 T:3400 NOTICE: Closing audio stream 12:42:52 T:3400 NOTICE: CDVDMessageQueue(audio)::WaitUntilEmpty 12:42:52 T:3268 NOTICE: thread end: CDVDPlayerAudio::OnExit() 12:42:52 T:3400 NOTICE: Waiting for audio thread to exit 12:42:52 T:3400 NOTICE: Closing audio device 12:42:52 T:1156 NOTICE: [script.cinema.experience] - messy_exit: False 12:42:52 T:1156 NOTICE: [script.cinema.experience] - Video Playlist Cleared 12:42:52 T:1156 NOTICE: [script.cinema.experience] - Music Playlist Cleared 12:42:52 T:1156 WARNING: 'xbmc.output()' is depreciated and will be removed in future releases, please use 'xbmc.log()' instead 12:42:52 T:1156 NOTICE: [script.cinema.experience] - [ home_automation.py ] - activate_on( Script End ) Triggered 12:42:53 T:3400 NOTICE: Deleting audio codec 12:42:53 T:3400 NOTICE: DVDPlayer: closing video stream 12:42:53 T:3400 NOTICE: Closing video stream 12:42:53 T:3400 NOTICE: CDVDMessageQueue(video)::WaitUntilEmpty 12:42:53 T:3400 NOTICE: waiting for video thread to exit 12:42:53 T:4576 ERROR: Got MSGQ_ABORT or MSGO_IS_ERROR return true 12:42:53 T:4576 NOTICE: thread end: video_thread 12:42:53 T:3400 NOTICE: deleting video codec 12:42:53 T:3400 NOTICE: CDVDPlayer::OnExit() deleting demuxer 12:42:53 T:3400 NOTICE: CDVDPlayer::OnExit() deleting input stream 12:42:53 T:2500 WARNING: Trying to add unsupported control type 3 12:42:55 T:2500 NOTICE: CDVDPlayer::CloseFile() 12:42:55 T:2500 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED 12:42:55 T:2500 NOTICE: DVDPlayer: waiting for threads to exit 12:42:55 T:2500 NOTICE: DVDPlayer: finished waiting 12:43:00 T:2500 NOTICE: Storing total System Uptime 12:43:00 T:2500 NOTICE: Saving settings 12:43:00 T:2500 NOTICE: stop all 12:43:00 T:2500 NOTICE: ES: Stopping event server 12:43:00 T:2500 NOTICE: stopping zeroconf publishing 12:43:00 T:2500 NOTICE: Webserver: Stopping... 12:43:00 T:2500 NOTICE: WebServer: Stopped the webserver 12:43:00 T:2500 NOTICE: Webserver: Stopped... 12:43:00 T:3848 NOTICE: ES: UDP Event server stopped 12:43:01 T:2500 NOTICE: stop sap announcement listener 12:43:01 T:2500 NOTICE: clean cached files! 12:43:01 T:2500 NOTICE: unload skin 12:43:01 T:2180 NOTICE: StorageServer-0.9.2 Closed down 12:43:02 T:2500 NOTICE: stop python 12:43:02 T:2500 NOTICE: stopped 12:43:02 T:2500 NOTICE: destroy 12:43:02 T:2500 NOTICE: closing down remote control service 12:43:02 T:2500 NOTICE: unload sections 12:43:02 T:2500 NOTICE: destroy 12:43:02 T:2500 WARNING: Attempted to remove window 10013 from the window manager when it didn't exist 12:43:02 T:2500 WARNING: Attempted to remove window 10014 from the window manager when it didn't exist 12:43:02 T:2500 WARNING: Attempted to remove window 10015 from the window manager when it didn't exist 12:43:02 T:2500 WARNING: Attempted to remove window 10016 from the window manager when it didn't exist 12:43:02 T:2500 WARNING: Attempted to remove window 10017 from the window manager when it didn't exist 12:43:02 T:2500 WARNING: Attempted to remove window 10018 from the window manager when it didn't exist 12:43:02 T:2500 WARNING: Attempted to remove window 10019 from the window manager when it didn't exist 12:43:02 T:2500 WARNING: Attempted to remove window 10107 from the window manager when it didn't exist 12:43:02 T:2500 WARNING: Attempted to remove window 10115 from the window manager when it didn't exist 12:43:02 T:2500 WARNING: Attempted to remove window 10104 from the window manager when it didn't exist 12:43:02 T:2500 NOTICE: closing down remote control service 12:43:02 T:2500 NOTICE: unload sections 12:43:02 T:2500 NOTICE: application stopped...