Hey! When i start roms, the roms wont start? I enabled debug mode to get some log files, and when I start a rom the logfile reads the following, I copied the last part so please don't blame me for the long log.. I don't know exactly where it is going wrong.
Code:
15:34:56 T:140638234343168 WARNING: CPythonInvoker(60, /home/xbmc/.kodi/addons/script.games.rom.collection.browser/default.py): the python script "/home/xbmc/.kodi/addons/script.games.rom.collection.browser/default.py" has left several classes in memory that we couldn't clean up. The classes include: N9XBMCAddon4xbmc8PlayListE
15:34:56 T:140638234343168 NOTICE: Thread JobWorker start, auto delete: true
15:35:07 T:140641014204352 NOTICE: Log level changed to "LOG_LEVEL_DEBUG_FREEMEM"
15:35:07 T:140641014204352 NOTICE: Enabled debug logging due to GUI setting. Level 2.
15:35:07 T:140641014204352 DEBUG: ------ Window Init () ------
15:35:07 T:140641014204352 DEBUG: OnKey: 167 (0xa7) pressed, action is Down
15:35:08 T:140637353330432 DEBUG: webserver: request received for /jsonrpc
15:35:09 T:140641014204352 DEBUG: OnKey: 11 (0x0b) pressed, action is Select
15:35:09 T:140637605111552 DEBUG: webserver: request received for /jsonrpc
15:35:10 T:140641014204352 DEBUG: OnKey: 11 (0x0b) pressed, action is Select
15:35:10 T:140641014204352 DEBUG: OnKey: 166 (0xa6) pressed, action is Up
15:35:11 T:140637353330432 DEBUG: webserver: request received for /jsonrpc
15:35:29 T:140638234343168 DEBUG: Previous line repeats 11 times.
15:35:29 T:140638234343168 DEBUG: Thread JobWorker 140638234343168 terminating (autodelete)
15:35:30 T:140638234343168 DEBUG: webserver: request received for /jsonrpc
15:35:31 T:140641014204352 DEBUG: OnKey: menu (0xd8) pressed, action is PreviousMenu
15:35:31 T:140641014204352 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
15:35:31 T:140641014204352 DEBUG: ------ Window Deinit (SettingsCategory.xml) ------
15:35:31 T:140641014204352 DEBUG: CGUIWindowManager::PreviousWindow: Activate new
15:35:31 T:140641014204352 DEBUG: ------ Window Init (Settings.xml) ------
15:35:31 T:140637605111552 NOTICE: Thread JobWorker start, auto delete: true
15:35:31 T:140641014204352 DEBUG: OnKey: menu (0xd8) pressed, action is PreviousMenu
15:35:31 T:140641014204352 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
15:35:32 T:140641014204352 DEBUG: ------ Window Deinit (Settings.xml) ------
15:35:32 T:140641014204352 DEBUG: CGUIWindowManager::PreviousWindow: Activate new
15:35:32 T:140641014204352 DEBUG: ------ Window Init (Home.xml) ------
15:35:32 T:140637605111552 DEBUG: CRecentlyAddedJob::UpdateMusic() - Running RecentlyAdded home screen update
15:35:32 T:140637353330432 DEBUG: webserver: request received for /jsonrpc
15:35:32 T:140641014204352 DEBUG: OnKey: menu (0xd8) pressed, action is Back
15:35:32 T:140641014204352 DEBUG: CGUIWindowManager::PreviousWindow: Deactivate
15:35:32 T:140637605111552 DEBUG: GetRecentlyAddedAlbumSongs() query: SELECT songview.* FROM (SELECT idAlbum FROM albumview ORDER BY idAlbum DESC LIMIT 10) AS recentalbums JOIN songview ON songview.idAlbum=recentalbums.idAlbum
15:35:32 T:140637605111552 DEBUG: GetRecentlyAddedAlbums query: select * from albumview where strAlbum != '' order by idAlbum desc limit 10
15:35:32 T:140637605111552 DEBUG: CRecentlyAddedJob::UpdateVideos() - Running RecentlyAdded home screen update
15:35:32 T:140637605111552 DEBUG: RunQuery took 25 ms for 10 items query: select * from movieview ORDER BY dateAdded desc, idMovie desc LIMIT 10
15:35:32 T:140637605111552 DEBUG: RunQuery took 6 ms for 10 items query: select * from episodeview ORDER BY dateAdded desc, idEpisode desc LIMIT 10
15:35:32 T:140637605111552 DEBUG: RunQuery took 2 ms for 0 items query: select * from musicvideoview ORDER BY dateAdded desc, idMVideo desc LIMIT 10
15:35:32 T:140637605111552 DEBUG: CRecentlyAddedJob::UpdateTotal() - Running RecentlyAdded home screen update
15:35:33 T:140638234343168 DEBUG: webserver: request received for /jsonrpc
15:35:35 T:140641014204352 DEBUG: Previous line repeats 1 times.
15:35:35 T:140641014204352 DEBUG: OnKey: 169 (0xa9) pressed, action is Left
15:35:36 T:140638234343168 DEBUG: Previous line repeats 2 times.
15:35:36 T:140638234343168 DEBUG: webserver: request received for /jsonrpc
15:35:38 T:140641014204352 DEBUG: Previous line repeats 1 times.
15:35:38 T:140641014204352 DEBUG: OnKey: 168 (0xa8) pressed, action is Right
15:35:38 T:140641014204352 DEBUG: OnKey: 169 (0xa9) pressed, action is Left
15:35:39 T:140641014204352 DEBUG: Previous line repeats 1 times.
15:35:39 T:140641014204352 DEBUG: OnKey: 168 (0xa8) pressed, action is Right
15:35:39 T:140638234343168 DEBUG: Previous line repeats 1 times.
15:35:39 T:140638234343168 DEBUG: webserver: request received for /jsonrpc
15:35:39 T:140641014204352 DEBUG: OnKey: 168 (0xa8) pressed, action is Right
15:35:40 T:140641014204352 DEBUG: Previous line repeats 1 times.
15:35:40 T:140641014204352 DEBUG: OnKey: 169 (0xa9) pressed, action is Left
15:35:41 T:140641014204352 DEBUG: OnKey: 11 (0x0b) pressed, action is Select
15:35:41 T:140641014204352 DEBUG: Activating window ID: 10001
15:35:41 T:140637353330432 DEBUG: webserver: request received for /jsonrpc
15:35:41 T:140641014204352 DEBUG: ------ Window Deinit (Home.xml) ------
15:35:41 T:140641014204352 DEBUG: ------ Window Init (MyPrograms.xml) ------
15:35:41 T:140641014204352 DEBUG: CGUIMediaWindow::GetDirectory (addons://sources/executable/)
15:35:41 T:140641014204352 DEBUG: ParentPath = [addons://sources/executable/]
15:35:41 T:140638234343168 NOTICE: Thread BackgroundLoader start, auto delete: false
15:35:41 T:140638234343168 DEBUG: Thread BackgroundLoader 140638234343168 terminating
15:35:42 T:140641014204352 DEBUG: OnKey: 167 (0xa7) pressed, action is Down
15:35:42 T:140638234343168 DEBUG: Previous line repeats 2 times.
15:35:42 T:140638234343168 NOTICE: Thread JobWorker start, auto delete: true
15:35:42 T:140638234343168 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/ImageLib-x86_64-linux.so)
15:35:42 T:140638234343168 DEBUG: Loading: /usr/lib/kodi/system/ImageLib-x86_64-linux.so
15:35:42 T:140637454042880 DEBUG: webserver: request received for /jsonrpc
15:35:43 T:140641014204352 DEBUG: OnKey: 167 (0xa7) pressed, action is Down
15:35:43 T:140641014204352 DEBUG: OnKey: 11 (0x0b) pressed, action is Select
15:35:43 T:140637353330432 NOTICE: Thread LanguageInvoker start, auto delete: false
15:35:43 T:140637353330432 INFO: initializing python engine.
15:35:43 T:140637353330432 DEBUG: CPythonInvoker(61, /home/xbmc/.kodi/addons/script.games.rom.collection.browser/default.py): start processing
15:35:43 T:140637353330432 NOTICE: -->Python Interpreter Initialized<--
15:35:43 T:140637353330432 DEBUG: CPythonInvoker(61, /home/xbmc/.kodi/addons/script.games.rom.collection.browser/default.py): the source file to load is "/home/xbmc/.kodi/addons/script.games.rom.collection.browser/default.py"
15:35:43 T:140637353330432 DEBUG: CPythonInvoker(61, /home/xbmc/.kodi/addons/script.games.rom.collection.browser/default.py): setting the Python path to /home/xbmc/.kodi/addons/script.games.rom.collection.browser:/usr/lib/python2.7:/usr/lib/python2.7/plat-x86_64-linux-gnu:/usr/lib/python2.7/lib-tk:/usr/lib/python2.7/lib-old:/usr/lib/python2.7/lib-dynload:/usr/local/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages:/usr/lib/python2.7/dist-packages/PILcompat:/usr/lib/python2.7/dist-packages/gtk-2.0
15:35:43 T:140637353330432 DEBUG: CPythonInvoker(61, /home/xbmc/.kodi/addons/script.games.rom.collection.browser/default.py): entering source directory /home/xbmc/.kodi/addons/script.games.rom.collection.browser
15:35:43 T:140637353330432 DEBUG: CPythonInvoker(61, /home/xbmc/.kodi/addons/script.games.rom.collection.browser/default.py): instantiating addon using automatically obtained id of "script.games.rom.collection.browser" dependent on version 2.1.0 of the xbmc.python api
15:35:43 T:140637353330432 NOTICE: RCB started
15:35:43 T:140637353330432 NOTICE: RCB: sys.argv = ['']
15:35:43 T:140637353330432 NOTICE: RCB: param =
15:35:43 T:140637353330432 NOTICE: RCB: setting launchRCB = True
15:35:43 T:140637353330432 NOTICE: RCB: launchRCB = True
15:35:43 T:140637353330432 NOTICE: RCB_INFO: Loading sqlite3 as DB engine
15:35:43 T:140637353330432 NOTICE: RCB: init log level
15:35:43 T:140637353330432 NOTICE: RCB: current log level: 2
15:35:43 T:140637353330432 NOTICE: RCB_INFO: Loading sqlite3 as DB engine
15:35:44 T:140637353330432 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/Dutch, fallback to strings.xml
15:35:44 T:140637353330432 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/English, fallback to strings.xml
15:35:44 T:140637353330432 NOTICE: RCB_INFO: Path to configuration file: /home/xbmc/.kodi/userdata/addon_data/script.games.rom.collection.browser/config.xml
15:35:44 T:140637353330432 NOTICE: RCB_INFO: XBMC version: Assuming we are on Eden
15:35:44 T:140637353330432 NOTICE: RCB_INFO: Init Rom Collection Browser: /home/xbmc/.kodi/addons/script.games.rom.collection.browser
15:35:44 T:140637353330432 NOTICE: RCB_INFO: RCB version: 2.0.17
15:35:44 T:140637353330432 NOTICE: RCB_INFO: RCB service addon: <xbmcaddon.Addon object at 0x7fe91056e058>
15:35:44 T:140637353330432 NOTICE: RCB_INFO: checkUpdateInProgress
15:35:44 T:140637353330432 NOTICE: RCB_INFO: scrapeOnStartupAction =
15:35:44 T:140637353330432 NOTICE: RCB_INFO: initializeConfig
15:35:44 T:140637353330432 NOTICE: RCB_INFO: Config() set path to None
15:35:44 T:140637353330432 NOTICE: RCB_INFO: Path to configuration file: /home/xbmc/.kodi/userdata/addon_data/script.games.rom.collection.browser/config.xml
15:35:44 T:140637353330432 NOTICE: RCB_INFO: checkRomCollectionsAvailable
15:35:44 T:140637353330432 NOTICE: RCB_INFO: initXml
15:35:44 T:140637353330432 NOTICE: RCB_INFO: Path to configuration file: /home/xbmc/.kodi/userdata/addon_data/script.games.rom.collection.browser/config.xml
15:35:44 T:140637353330432 NOTICE: RCB_INFO: Number of Rom Collections in config.xml: 1
15:35:44 T:140637353330432 NOTICE: RCB_INFO: Reading config version from config.xml: 2.0.8
15:35:44 T:140637353330432 NOTICE: RCB_INFO: Config file is up to date
15:35:44 T:140637353330432 NOTICE: RCB_INFO: readXml
15:35:44 T:140637353330432 NOTICE: RCB_INFO: initXml
15:35:44 T:140637353330432 NOTICE: RCB_INFO: Begin readRomCollections
15:35:44 T:140637353330432 NOTICE: RCB_INFO: current Rom Collection: SNES
15:35:44 T:140637353330432 NOTICE: RCB_INFO: Rom path: /home/xbmc/EMU/ROMS/SNES/roms/*.zip
15:35:44 T:140637353330432 NOTICE: RCB_INFO: Rom path: /home/xbmc/EMU/ROMS/SNES/roms/*.smc
15:35:44 T:140637353330432 NOTICE: RCB_INFO: Media path: /home/xbmc/EMU/ROMS/SNES/roms/boxfront/%GAME%.*
15:35:44 T:140637353330432 NOTICE: RCB_INFO: Media path: /home/xbmc/EMU/ROMS/SNES/roms/boxback/%GAME%.*
15:35:44 T:140637353330432 NOTICE: RCB_INFO: Media path: /home/xbmc/EMU/ROMS/SNES/roms/cartridge/%GAME%.*
15:35:44 T:140637353330432 NOTICE: RCB_INFO: Media path: /home/xbmc/EMU/ROMS/SNES/roms/screenshot/%GAME%.*
15:35:44 T:140637353330432 NOTICE: RCB_INFO: Media path: /home/xbmc/EMU/ROMS/SNES/roms/fanart/%GAME%.*
15:35:44 T:140637353330432 NOTICE: RCB_INFO: Scraper site: thegamesdb.net
15:35:44 T:140637353330432 NOTICE: RCB_INFO: Scraper Site: thegamesdb.net
15:35:44 T:140637353330432 NOTICE: RCB_INFO: Scraper descFilePerGame: True
15:35:44 T:140637353330432 NOTICE: RCB_INFO: Scraper site: archive.vg
15:35:44 T:140637353330432 NOTICE: RCB_INFO: Scraper Site: archive.vg
15:35:44 T:140637353330432 NOTICE: RCB_INFO: Scraper descFilePerGame: True
15:35:44 T:140637353330432 NOTICE: RCB_INFO: Scraper site: mobygames.com
15:35:44 T:140637353330432 NOTICE: RCB_INFO: Scraper Site: mobygames.com
15:35:44 T:140637353330432 NOTICE: RCB_INFO: Scraper descFilePerGame: True
15:35:44 T:140637353330432 NOTICE: RCB_INFO: Image Placing name: gameinfobig
15:35:44 T:140637353330432 NOTICE: RCB_INFO: Image Placing name: gameinfosmall
15:35:44 T:140637353330432 NOTICE: RCB_INFO: emulatorCmd: /home/xbmc/EMU/snes9x-1.53/snes9x-gtk
15:35:44 T:140637353330432 NOTICE: RCB_INFO: emulatorParams: "%ROM%"
15:35:44 T:140637353330432 NOTICE: RCB_INFO: useBuiltinEmulator: False
15:35:44 T:140637353330432 NOTICE: RCB_INFO: ignoreOnScan: False
15:35:44 T:140637353330432 NOTICE: RCB_INFO: allowUpdate: True
15:35:44 T:140637353330432 NOTICE: RCB_INFO: useEmuSolo: False
15:35:44 T:140637353330432 NOTICE: RCB_INFO: usePopen: False
15:35:44 T:140637353330432 NOTICE: RCB_INFO: autoplayVideoMain: True
15:35:44 T:140637353330432 NOTICE: RCB_INFO: autoplayVideoInfo: True
15:35:44 T:140637353330432 NOTICE: RCB_INFO: useFoldernameAsGamename: False
15:35:44 T:140637353330432 NOTICE: RCB_INFO: maxFolderDepth: 99
15:35:44 T:140637353330432 NOTICE: RCB_INFO: doNotExtractZipFiles: False
15:35:44 T:140637353330432 NOTICE: RCB_INFO: diskPrefix: _Disk
15:35:44 T:140637353330432 NOTICE: RCB_INFO: Scraper Site: local nfo
15:35:44 T:140637353330432 NOTICE: RCB_INFO: Scraper descFilePerGame: True
15:35:44 T:140637353330432 NOTICE: RCB_INFO: Scraper Site: thegamesdb.net
15:35:44 T:140637353330432 NOTICE: RCB_INFO: Scraper descFilePerGame: True
15:35:44 T:140637353330432 NOTICE: RCB_INFO: Scraper Site: giantbomb.com
15:35:44 T:140637353330432 NOTICE: RCB_INFO: Scraper descFilePerGame: True
15:35:44 T:140637353330432 NOTICE: RCB_INFO: Scraper Site: mobygames.com
15:35:44 T:140637353330432 NOTICE: RCB_INFO: Scraper descFilePerGame: True
15:35:44 T:140637353330432 NOTICE: RCB_INFO: Scraper Site: archive.vg
15:35:44 T:140637353330432 NOTICE: RCB_INFO: Scraper descFilePerGame: True
15:35:44 T:140637353330432 NOTICE: RCB_INFO: Scraper Site: maws.mameworld.info
15:35:44 T:140637353330432 NOTICE: RCB_INFO: Scraper descFilePerGame: True
15:35:44 T:140637353330432 NOTICE: /home/xbmc/.kodi/userdata/addon_data/script.games.rom.collection.browser/MyGames.db
15:35:44 T:140637353330432 NOTICE: RCB_INFO: Begin cacheItems
15:35:44 T:140637353330432 NOTICE: RCB_INFO: End cacheItems
15:35:44 T:140638476261120 DEBUG: webserver: request received for /jsonrpc
15:35:44 T:140641014204352 DEBUG: Activating window ID: 13000
15:35:44 T:140641014204352 DEBUG: ------ Window Deinit (MyPrograms.xml) ------
15:35:44 T:140641014204352 DEBUG: ------ Window Init (/home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/skins/Default/720p/script-Rom_Collection_Browser-main.xml) ------
15:35:44 T:140641014204352 INFO: Loading skin file: /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/skins/Default/720p/script-Rom_Collection_Browser-main.xml, load type: LOAD_ON_GUI_INIT
15:35:44 T:140641014204352 WARNING: Trying to add unsupported control type 1
15:35:44 T:140641014204352 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/Dutch, fallback to strings.xml
15:35:44 T:140641014204352 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/English, fallback to strings.xml
15:35:44 T:140641014204352 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/Dutch, fallback to strings.xml
15:35:44 T:140641014204352 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/English, fallback to strings.xml
15:35:44 T:140641014204352 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/Dutch, fallback to strings.xml
15:35:44 T:140641014204352 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/English, fallback to strings.xml
15:35:44 T:140641014204352 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/Dutch, fallback to strings.xml
15:35:44 T:140641014204352 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/English, fallback to strings.xml
15:35:44 T:140641014204352 WARNING: Trying to add unsupported control type 1
15:35:44 T:140641014204352 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/Dutch, fallback to strings.xml
15:35:44 T:140641014204352 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/English, fallback to strings.xml
15:35:44 T:140641014204352 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/Dutch, fallback to strings.xml
15:35:44 T:140641014204352 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/English, fallback to strings.xml
15:35:44 T:140641014204352 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/Dutch, fallback to strings.xml
15:35:44 T:140641014204352 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/English, fallback to strings.xml
15:35:44 T:140641014204352 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/Dutch, fallback to strings.xml
15:35:44 T:140641014204352 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/English, fallback to strings.xml
15:35:44 T:140641014204352 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/Dutch, fallback to strings.xml
15:35:44 T:140641014204352 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/English, fallback to strings.xml
15:35:44 T:140641014204352 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/Dutch, fallback to strings.xml
15:35:44 T:140641014204352 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/English, fallback to strings.xml
15:35:44 T:140641014204352 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/Dutch, fallback to strings.xml
15:35:44 T:140641014204352 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/English, fallback to strings.xml
15:35:44 T:140641014204352 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/Dutch, fallback to strings.xml
15:35:44 T:140641014204352 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/English, fallback to strings.xml
15:35:44 T:140641014204352 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/Dutch, fallback to strings.xml
15:35:44 T:140641014204352 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/English, fallback to strings.xml
15:35:44 T:140641014204352 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/Dutch, fallback to strings.xml
15:35:44 T:140641014204352 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/English, fallback to strings.xml
15:35:44 T:140641014204352 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/Dutch, fallback to strings.xml
15:35:44 T:140641014204352 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/English, fallback to strings.xml
15:35:44 T:140641014204352 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/Dutch, fallback to strings.xml
15:35:44 T:140641014204352 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/English, fallback to strings.xml
15:35:44 T:140641014204352 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/Dutch, fallback to strings.xml
15:35:44 T:140641014204352 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/English, fallback to strings.xml
15:35:44 T:140641014204352 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/Dutch, fallback to strings.xml
15:35:44 T:140641014204352 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/English, fallback to strings.xml
15:35:44 T:140641014204352 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/Dutch, fallback to strings.xml
15:35:44 T:140641014204352 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/English, fallback to strings.xml
15:35:45 T:140641014204352 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/Dutch, fallback to strings.xml
15:35:45 T:140641014204352 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/English, fallback to strings.xml
15:35:45 T:140641014204352 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/Dutch, fallback to strings.xml
15:35:45 T:140641014204352 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/English, fallback to strings.xml
15:35:45 T:140641014204352 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/Dutch, fallback to strings.xml
15:35:45 T:140641014204352 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/English, fallback to strings.xml
15:35:45 T:140641014204352 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/Dutch, fallback to strings.xml
15:35:45 T:140641014204352 DEBUG: LocalizeStrings: no strings.po file exist at /home/xbmc/.kodi/addons/script.games.rom.collection.browser/resources/language/English, fallback to strings.xml
15:35:45 T:140641014204352 DEBUG: CGUIMediaWindow::GetDirectory ()
15:35:45 T:140641014204352 DEBUG: ParentPath = []
15:35:45 T:140641014204352 ERROR: Control 500 in window 13000 has been asked to focus, but it can't
15:35:45 T:140637353330432 NOTICE: RCB_INFO: Begin onInit
15:35:45 T:140637353330432 NOTICE: RCB_INFO: Begin loadViewState
15:35:45 T:140637353330432 NOTICE: RCB_INFO: Begin showConsoles
15:35:45 T:140637353330432 NOTICE: RCB_INFO: begin showFilterControl: 500
15:35:45 T:140637353330432 NOTICE: RCB_INFO: End showConsoles
15:35:45 T:140637353330432 NOTICE: RCB_INFO: Begin showGenre
15:35:45 T:140637353330432 NOTICE: RCB_INFO: Selected Console: 0
15:35:45 T:140637353330432 NOTICE: RCB_INFO: begin showFilterControl: 600
15:35:45 T:140637353330432 NOTICE: RCB_INFO: End showGenre
15:35:45 T:140637353330432 NOTICE: RCB_INFO: Begin showYear
15:35:45 T:140637353330432 NOTICE: RCB_INFO: Selected Console: 0
15:35:45 T:140637353330432 NOTICE: RCB_INFO: begin showFilterControl: 700
15:35:45 T:140637353330432 NOTICE: RCB_INFO: End showYear
15:35:45 T:140637353330432 NOTICE: RCB_INFO: Begin showPublisher
15:35:45 T:140637353330432 NOTICE: RCB_INFO: Selected Console: 0
15:35:45 T:140637353330432 NOTICE: RCB_INFO: begin showFilterControl: 800
15:35:45 T:140637353330432 NOTICE: RCB_INFO: End showPublisher
15:35:45 T:140637353330432 NOTICE: RCB_INFO: Begin showCharacterFilter
15:35:45 T:140637353330432 NOTICE: RCB_INFO: End showCharacterFilter
15:35:45 T:140637353330432 NOTICE: RCB_INFO: Begin showGames
15:35:45 T:140637353330432 NOTICE: RCB_INFO: helper.buildLikeStatement
15:35:45 T:140637353330432 NOTICE: showGames: load games from db in 9 ms
15:35:45 T:140637454042880 DEBUG: webserver: request received for /jsonrpc
15:35:46 T:140637353330432 NOTICE: RCB_INFO: showGames: load 38 games to list in 283 ms
15:35:46 T:140637353330432 NOTICE: RCB_INFO: End showGames
15:35:46 T:140637353330432 NOTICE: RCB_INFO: Begin showGameInfo
15:35:46 T:140637353330432 NOTICE: RCB_INFO: End showGameInfo
15:35:46 T:140637353330432 NOTICE: RCB_INFO: End loadViewState
15:35:46 T:140637353330432 NOTICE: RCB_INFO: End onInit
15:35:47 T:140638476261120 DEBUG: webserver: request received for /jsonrpc
15:35:47 T:140641014204352 DEBUG: OnKey: 11 (0x0b) pressed, action is Select
15:35:47 T:140637353330432 NOTICE: RCB_INFO: Begin launchEmu
15:35:47 T:140637353330432 NOTICE: RCB_INFO: launching game with id: 18
15:35:47 T:140637353330432 NOTICE: RCB_INFO: Begin launcher.launchEmu
15:35:47 T:140637353330432 NOTICE: RCB_INFO: Begin saveViewState
15:35:47 T:140637353330432 NOTICE: RCB_INFO: Begin saveViewMode
15:35:47 T:140637353330432 NOTICE: RCB_INFO: End saveViewMode
15:35:47 T:140637353330432 NOTICE: RCB_INFO: Begin helper.saveViewState
15:35:47 T:140637353330432 NOTICE: RCB_INFO: End helper.saveViewState
15:35:47 T:140637353330432 NOTICE: RCB_INFO: End saveViewState
15:35:47 T:140637353330432 NOTICE: RCB_INFO: files for current game: [(u'/home/xbmc/EMU/ROMS/SNES/roms/Pocky & Rocky.smc',)]
15:35:47 T:140637353330432 NOTICE: RCB_INFO: launcher.buildCmd
15:35:47 T:140637353330432 NOTICE: RCB_INFO: emuCommandLine: /home/xbmc/EMU/snes9x-1.53/snes9x-gtk
15:35:47 T:140637353330432 NOTICE: RCB_INFO: preCmdLine:
15:35:47 T:140637353330432 NOTICE: RCB_INFO: postCmdLine:
15:35:47 T:140637353330432 NOTICE: RCB_INFO: Getting Multiple Disc Parameter
15:35:47 T:140637353330432 NOTICE: RCB_INFO: emuParams: "%ROM%"
15:35:47 T:140637353330432 NOTICE: RCB_INFO: rom: /home/xbmc/EMU/ROMS/SNES/roms/Pocky & Rocky.smc
15:35:47 T:140637353330432 NOTICE: RCB_INFO: No precmd created.
15:35:47 T:140637353330432 NOTICE: RCB_INFO: No postcmd created.
15:35:47 T:140637353330432 NOTICE: RCB_INFO: cmd: "/home/xbmc/EMU/snes9x-1.53/snes9x-gtk" "/home/xbmc/EMU/ROMS/SNES/roms/Pocky & Rocky.smc"
15:35:47 T:140637353330432 NOTICE: RCB_INFO: precmd:
15:35:47 T:140637353330432 NOTICE: RCB_INFO: postcmd:
15:35:47 T:140637353330432 NOTICE: RCB_INFO: launchEmu on non-xbox
15:35:47 T:140637353330432 NOTICE: RCB_INFO: screenMode: 1920x1080@ 50.00 - Full Screen
15:35:47 T:140637353330432 NOTICE: RCB_INFO: Toggle to Windowed mode
15:35:47 T:140637353330432 NOTICE: RCB_INFO: launch emu
15:35:47 T:140641014204352 DEBUG: OnLostDevice - notify display change event
15:35:47 T:140641014204352 DEBUG: Flush - flushing renderer
15:35:48 T:140637353330432 NOTICE: RCB_INFO: onAction: 7
15:35:48 T:140641014204352 DEBUG: Window Manager Name: Openbox
15:35:48 T:140641014204352 DEBUG: CWinSystemX11::RefreshGlxContext: refreshing context
15:35:48 T:140640451196672 DEBUG: CActiveAE - display reset event
15:35:48 T:140640508954368 INFO: CActiveAESink::OpenSink - initialize sink
15:35:48 T:140640508954368 DEBUG: CActiveAESink::OpenSink - trying to open device ALSA:hdmi:CARD=NVidia,DEV=0
15:35:48 T:140640508954368 INFO: CAESinkALSA::Initialize - Attempting to open device "hdmi:CARD=NVidia,DEV=0"
15:35:48 T:140641014204352 INFO: GL: Maximum texture width: 8192
15:35:48 T:140641014204352 DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec
15:35:48 T:140640508954368 INFO: CAESinkALSA::Initialize - Opened device "hdmi:CARD=NVidia,DEV=0,AES0=0x04,AES1=0x82,AES2=0x00,AES3=0x00"
15:35:48 T:140640508954368 INFO: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats
15:35:48 T:140640508954368 INFO: CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE
15:35:48 T:140640508954368 DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 2048, bufferSize 8192
15:35:48 T:140640508954368 DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 2048, bufferSize 8192
15:35:48 T:140640508954368 DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 186 ms
15:35:48 T:140640508954368 DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2
15:35:48 T:140640508954368 DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: FL,FR
15:35:48 T:140640508954368 DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: FL,FR (ALSA: FL FR)
15:35:48 T:140640508954368 DEBUG: CActiveAESink::OpenSink - ALSA Initialized:
15:35:48 T:140640508954368 DEBUG: Output Device : HDA NVidia
15:35:48 T:140640508954368 DEBUG: Sample Rate : 44100
15:35:48 T:140640508954368 DEBUG: Sample Format : AE_FMT_S32NE
15:35:48 T:140640508954368 DEBUG: Channel Count : 2
15:35:48 T:140640508954368 DEBUG: Channel Layout: FL,FR
15:35:48 T:140640508954368 DEBUG: Frames : 2048
15:35:48 T:140640508954368 DEBUG: Frame Samples : 4096
15:35:48 T:140640508954368 DEBUG: Frame Size : 8
15:35:48 T:140640451196672 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
15:35:48 T:140641014204352 INFO: GL: Maximum texture width: 8192
15:35:48 T:140641014204352 DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec
15:35:48 T:140641014204352 INFO: GL: Maximum texture width: 8192
15:35:48 T:140641014204352 DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec
15:35:49 T:140637454042880 DEBUG: webserver: request received for /jsonrpc
15:35:49 T:140637353330432 NOTICE: RCB_INFO: launch emu done
15:35:50 T:140640451196672 ERROR: PulseAudio: Failed to connect context
15:35:50 T:140640451196672 NOTICE: PulseAudio might not be running. Context was not created.
15:35:50 T:140640451196672 INFO: CAESinkALSA - Unable to open device "pulse" for playback
15:35:50 T:140640451196672 DEBUG: CAESinkALSA - Unable to obtain ELD information for device "hdmi:CARD=NVidia,DEV=0" (not supported by device, or kernel older than 3.2)
15:35:50 T:140640451196672 NOTICE: Found 1 Lists of Devices
15:35:50 T:140640451196672 NOTICE: Enumerated ALSA devices:
15:35:50 T:140640451196672 NOTICE: Device 1
15:35:50 T:140640451196672 NOTICE: m_deviceName : default
15:35:50 T:140640451196672 NOTICE: m_displayName : Default (HDA NVidia HDMI 0)
15:35:50 T:140640451196672 NOTICE: m_displayNameExtra:
15:35:50 T:140640451196672 NOTICE: m_deviceType : AE_DEVTYPE_PCM
15:35:50 T:140640451196672 NOTICE: m_channels : FL,FR,FC,LFE,BL,BR,SL,SR
15:35:50 T:140640451196672 NOTICE: m_sampleRates : 32000,44100,48000,88200,96000,176400,192000
15:35:50 T:140640451196672 NOTICE: m_dataFormats : AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE
15:35:50 T:140640451196672 NOTICE: Device 2
15:35:50 T:140640451196672 NOTICE: m_deviceName : @:CARD=NVidia,DEV=0
15:35:50 T:140640451196672 NOTICE: m_displayName : HDA NVidia
15:35:50 T:140640451196672 NOTICE: m_displayNameExtra: ALC889A Analog
15:35:50 T:140640451196672 NOTICE: m_deviceType : AE_DEVTYPE_PCM
15:35:50 T:140640451196672 NOTICE: m_channels : FL,FR,BL,BR,FC,LFE
15:35:50 T:140640451196672 NOTICE: m_sampleRates : 48000
15:35:50 T:140640451196672 NOTICE: m_dataFormats : AE_FMT_S32NE
15:35:50 T:140640451196672 NOTICE: Device 3
15:35:50 T:140640451196672 NOTICE: m_deviceName : iec958:CARD=NVidia,DEV=0
15:35:50 T:140640451196672 NOTICE: m_displayName : HDA NVidia
15:35:50 T:140640451196672 NOTICE: m_displayNameExtra: ALC889A Digital S/PDIF
15:35:50 T:140640451196672 NOTICE: m_deviceType : AE_DEVTYPE_IEC958
15:35:50 T:140640451196672 NOTICE: m_channels : FL,FR
15:35:50 T:140640451196672 NOTICE: m_sampleRates : 44100,48000,88200,96000,192000
15:35:50 T:140640451196672 NOTICE: m_dataFormats : AE_FMT_AC3,AE_FMT_DTS,AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE
15:35:50 T:140640451196672 NOTICE: Device 4
15:35:50 T:140640451196672 NOTICE: m_deviceName : hdmi:CARD=NVidia,DEV=0
15:35:50 T:140640451196672 NOTICE: m_displayName : HDA NVidia
15:35:50 T:140640451196672 NOTICE: m_displayNameExtra: HDMI
15:35:50 T:140640451196672 NOTICE: m_deviceType : AE_DEVTYPE_HDMI
15:35:50 T:140640451196672 NOTICE: m_channels : FL,FR,FC,LFE,BL,BR,SL,SR
15:35:50 T:140640451196672 NOTICE: m_sampleRates : 32000,44100,48000,88200,96000,176400,192000
15:35:50 T:140640451196672 NOTICE: m_dataFormats : AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE,AE_FMT_LPCM,AE_FMT_DTSHD,AE_FMT_TRUEHD,AE_FMT_EAC3,AE_FMT_DTS,AE_FMT_AC3,AE_FMT_AAC
15:35:50 T:140640508954368 INFO: CActiveAESink::OpenSink - initialize sink
15:35:50 T:140640508954368 DEBUG: CActiveAESink::OpenSink - trying to open device ALSA:hdmi:CARD=NVidia,DEV=0
15:35:50 T:140640508954368 INFO: CAESinkALSA::Initialize - Attempting to open device "hdmi:CARD=NVidia,DEV=0"
15:35:50 T:140640508954368 INFO: CAESinkALSA::Initialize - Opened device "hdmi:CARD=NVidia,DEV=0,AES0=0x04,AES1=0x82,AES2=0x00,AES3=0x00"
15:35:50 T:140640508954368 INFO: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats
15:35:50 T:140640508954368 INFO: CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE
15:35:50 T:140640508954368 DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 2048, bufferSize 8192
15:35:50 T:140640508954368 DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 2048, bufferSize 8192
15:35:50 T:140640508954368 DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 186 ms
15:35:50 T:140640508954368 DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2
15:35:50 T:140640508954368 DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: FL,FR
15:35:50 T:140640508954368 DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: FL,FR (ALSA: FL FR)
15:35:50 T:140640508954368 DEBUG: CActiveAESink::OpenSink - ALSA Initialized:
15:35:50 T:140640508954368 DEBUG: Output Device : HDA NVidia
15:35:50 T:140640508954368 DEBUG: Sample Rate : 44100
15:35:50 T:140640508954368 DEBUG: Sample Format : AE_FMT_S32NE
15:35:50 T:140640508954368 DEBUG: Channel Count : 2
15:35:50 T:140640508954368 DEBUG: Channel Layout: FL,FR
15:35:50 T:140640508954368 DEBUG: Frames : 2048
15:35:50 T:140640508954368 DEBUG: Frame Samples : 4096
15:35:50 T:140640508954368 DEBUG: Frame Size : 8
15:35:50 T:140640451196672 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
15:35:50 T:140637353330432 NOTICE: RCB_INFO: Toggle to Full Screen mode
15:35:50 T:140637353330432 NOTICE: RCB_INFO: End launcher.launchEmu
15:35:50 T:140637353330432 NOTICE: RCB_INFO: End launchEmu
15:35:50 T:140641014204352 DEBUG: OnLostDevice - notify display change event
15:35:50 T:140641014204352 DEBUG: Flush - flushing renderer
15:35:50 T:140641014204352 DEBUG: Window Manager Name: Openbox
15:35:50 T:140641014204352 DEBUG: CWinSystemX11::RefreshGlxContext: refreshing context
15:35:50 T:140640451196672 DEBUG: CActiveAE - display reset event
15:35:50 T:140640508954368 INFO: CActiveAESink::OpenSink - initialize sink
15:35:50 T:140640508954368 DEBUG: CActiveAESink::OpenSink - trying to open device ALSA:hdmi:CARD=NVidia,DEV=0
15:35:50 T:140640508954368 INFO: CAESinkALSA::Initialize - Attempting to open device "hdmi:CARD=NVidia,DEV=0"
15:35:50 T:140641014204352 INFO: GL: Maximum texture width: 8192
15:35:50 T:140641014204352 DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec
15:35:50 T:140640508954368 INFO: CAESinkALSA::Initialize - Opened device "hdmi:CARD=NVidia,DEV=0,AES0=0x04,AES1=0x82,AES2=0x00,AES3=0x00"
15:35:50 T:140640508954368 INFO: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats
15:35:50 T:140640508954368 INFO: CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE
15:35:50 T:140640508954368 DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 2048, bufferSize 8192
15:35:50 T:140640508954368 DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 2048, bufferSize 8192
15:35:50 T:140640508954368 DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 186 ms
15:35:50 T:140640508954368 DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2
15:35:50 T:140640508954368 DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: FL,FR
15:35:50 T:140640508954368 DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: FL,FR (ALSA: FL FR)
15:35:50 T:140640508954368 DEBUG: CActiveAESink::OpenSink - ALSA Initialized:
15:35:50 T:140640508954368 DEBUG: Output Device : HDA NVidia
15:35:50 T:140640508954368 DEBUG: Sample Rate : 44100
15:35:50 T:140640508954368 DEBUG: Sample Format : AE_FMT_S32NE
15:35:50 T:140640508954368 DEBUG: Channel Count : 2
15:35:50 T:140640508954368 DEBUG: Channel Layout: FL,FR
15:35:50 T:140640508954368 DEBUG: Frames : 2048
15:35:50 T:140640508954368 DEBUG: Frame Samples : 4096
15:35:50 T:140640508954368 DEBUG: Frame Size : 8
15:35:50 T:140638476261120 DEBUG: webserver: request received for /jsonrpc
15:35:50 T:140640451196672 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
15:35:52 T:140637454042880 DEBUG: webserver: request received for /jsonrpc
15:35:53 T:140641014204352 DEBUG: Previous line repeats 1 times.
15:35:53 T:140641014204352 DEBUG: OnKey: 166 (0xa6) pressed, action is Up
15:35:53 T:140637353330432 NOTICE: RCB_INFO: onAction: 3
15:35:53 T:140637353330432 NOTICE: RCB_INFO: Begin showGameInfo
15:35:53 T:140637353330432 NOTICE: RCB_INFO: End showGameInfo
15:35:55 T:140638467868416 DEBUG: webserver: request received for /jsonrpc
15:35:56 T:140641014204352 DEBUG: OnKey: 11 (0x0b) pressed, action is Select
15:35:56 T:140637353330432 NOTICE: RCB_INFO: Begin launchEmu
15:35:56 T:140637353330432 NOTICE: RCB_INFO: launching game with id: 16
15:35:56 T:140637353330432 NOTICE: RCB_INFO: Begin launcher.launchEmu
15:35:56 T:140637353330432 NOTICE: RCB_INFO: Begin saveViewState
15:35:56 T:140637353330432 NOTICE: RCB_INFO: Begin saveViewMode
15:35:56 T:140637353330432 NOTICE: RCB_INFO: End saveViewMode
15:35:56 T:140637353330432 NOTICE: RCB_INFO: Begin helper.saveViewState
15:35:56 T:140637353330432 NOTICE: RCB_INFO: End helper.saveViewState
15:35:56 T:140637353330432 NOTICE: RCB_INFO: End saveViewState
15:35:56 T:140637353330432 NOTICE: RCB_INFO: files for current game: [(u'/home/xbmc/EMU/ROMS/SNES/roms/Pilotwings.smc',)]
15:35:56 T:140637353330432 NOTICE: RCB_INFO: launcher.buildCmd
15:35:56 T:140637353330432 NOTICE: RCB_INFO: emuCommandLine: /home/xbmc/EMU/snes9x-1.53/snes9x-gtk
15:35:56 T:140637353330432 NOTICE: RCB_INFO: preCmdLine:
15:35:56 T:140637353330432 NOTICE: RCB_INFO: postCmdLine:
15:35:56 T:140637353330432 NOTICE: RCB_INFO: Getting Multiple Disc Parameter
15:35:56 T:140637353330432 NOTICE: RCB_INFO: emuParams: "%ROM%"
15:35:56 T:140637353330432 NOTICE: RCB_INFO: rom: /home/xbmc/EMU/ROMS/SNES/roms/Pilotwings.smc
15:35:56 T:140637353330432 NOTICE: RCB_INFO: No precmd created.
15:35:56 T:140637353330432 NOTICE: RCB_INFO: No postcmd created.
15:35:56 T:140637353330432 NOTICE: RCB_INFO: cmd: "/home/xbmc/EMU/snes9x-1.53/snes9x-gtk" "/home/xbmc/EMU/ROMS/SNES/roms/Pilotwings.smc"
15:35:56 T:140637353330432 NOTICE: RCB_INFO: precmd:
15:35:56 T:140637353330432 NOTICE: RCB_INFO: postcmd:
15:35:56 T:140637353330432 NOTICE: RCB_INFO: launchEmu on non-xbox
15:35:56 T:140637353330432 NOTICE: RCB_INFO: screenMode: 1920x1080@ 50.00 - Full Screen
15:35:56 T:140637353330432 NOTICE: RCB_INFO: Toggle to Windowed mode
15:35:56 T:140637353330432 NOTICE: RCB_INFO: launch emu
15:35:56 T:140641014204352 DEBUG: OnLostDevice - notify display change event
15:35:56 T:140641014204352 DEBUG: Flush - flushing renderer
15:35:56 T:140637353330432 NOTICE: RCB_INFO: onAction: 7
15:35:56 T:140637454042880 DEBUG: webserver: request received for /jsonrpc
15:35:56 T:140641014204352 DEBUG: Window Manager Name: Openbox
15:35:56 T:140641014204352 DEBUG: CWinSystemX11::RefreshGlxContext: refreshing context
15:35:56 T:140640451196672 DEBUG: CActiveAE - display reset event
15:35:56 T:140640508954368 INFO: CActiveAESink::OpenSink - initialize sink
15:35:56 T:140640508954368 DEBUG: CActiveAESink::OpenSink - trying to open device ALSA:hdmi:CARD=NVidia,DEV=0
15:35:56 T:140640508954368 INFO: CAESinkALSA::Initialize - Attempting to open device "hdmi:CARD=NVidia,DEV=0"
15:35:56 T:140641014204352 INFO: GL: Maximum texture width: 8192
15:35:56 T:140641014204352 DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec
15:35:56 T:140640508954368 INFO: CAESinkALSA::Initialize - Opened device "hdmi:CARD=NVidia,DEV=0,AES0=0x04,AES1=0x82,AES2=0x00,AES3=0x00"
15:35:56 T:140640508954368 INFO: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats
15:35:56 T:140640508954368 INFO: CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE
15:35:56 T:140640508954368 DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 2048, bufferSize 8192
15:35:56 T:140640508954368 DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 2048, bufferSize 8192
15:35:56 T:140640508954368 DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 186 ms
15:35:56 T:140640508954368 DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2
15:35:56 T:140640508954368 DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: FL,FR
15:35:56 T:140640508954368 DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: FL,FR (ALSA: FL FR)
15:35:56 T:140640508954368 DEBUG: CActiveAESink::OpenSink - ALSA Initialized:
15:35:56 T:140640508954368 DEBUG: Output Device : HDA NVidia
15:35:56 T:140640508954368 DEBUG: Sample Rate : 44100
15:35:56 T:140640508954368 DEBUG: Sample Format : AE_FMT_S32NE
15:35:56 T:140640508954368 DEBUG: Channel Count : 2
15:35:56 T:140640508954368 DEBUG: Channel Layout: FL,FR
15:35:56 T:140640508954368 DEBUG: Frames : 2048
15:35:56 T:140640508954368 DEBUG: Frame Samples : 4096
15:35:56 T:140640508954368 DEBUG: Frame Size : 8
15:35:56 T:140640451196672 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
15:35:56 T:140641014204352 INFO: GL: Maximum texture width: 8192
15:35:56 T:140641014204352 DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec
15:35:56 T:140641014204352 INFO: GL: Maximum texture width: 8192
15:35:56 T:140641014204352 DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec
15:35:57 T:140641014204352 DEBUG: GetActionCode: Trying Hardy keycode for 0xf200
15:35:57 T:140641014204352 DEBUG: Previous line repeats 1 times.
15:35:57 T:140641014204352 DEBUG: OnKey: 0 (0xf200) pressed, action is
15:35:57 T:140637353330432 NOTICE: RCB_INFO: launch emu done
15:35:57 T:140641014204352 DEBUG: GetActionCode: Trying Hardy keycode for 0xf200
15:35:57 T:140641014204352 DEBUG: Previous line repeats 1 times.
15:35:57 T:140641014204352 DEBUG: OnKey: 0 (0xf200) pressed, action is
15:35:57 T:140638476261120 DEBUG: webserver: request received for /jsonrpc
15:35:57 T:140641014204352 DEBUG: GetActionCode: Trying Hardy keycode for 0xf200
15:35:57 T:140641014204352 DEBUG: Previous line repeats 1 times.
15:35:57 T:140641014204352 DEBUG: OnKey: 0 (0xf200) pressed, action is
15:35:57 T:140641014204352 DEBUG: GetActionCode: Trying Hardy keycode for 0xf200
15:35:57 T:140641014204352 DEBUG: Previous line repeats 1 times.
15:35:57 T:140641014204352 DEBUG: OnKey: 0 (0xf200) pressed, action is
15:35:57 T:140641014204352 DEBUG: GetActionCode: Trying Hardy keycode for 0xf200
15:35:57 T:140641014204352 DEBUG: Previous line repeats 1 times.
15:35:57 T:140641014204352 DEBUG: OnKey: 0 (0xf200) pressed, action is
15:35:57 T:140641014204352 DEBUG: GetActionCode: Trying Hardy keycode for 0xf200
15:35:57 T:140641014204352 DEBUG: Previous line repeats 1 times.
15:35:57 T:140641014204352 DEBUG: OnKey: 0 (0xf200) pressed, action is
15:35:57 T:140637353330432 NOTICE: RCB_INFO: onAction: 0
15:35:57 T:140637353330432 NOTICE: RCB_INFO: actionId == 0. Input ignored
15:35:57 T:140637353330432 NOTICE: RCB_INFO: onAction: 0
15:35:57 T:140637353330432 NOTICE: RCB_INFO: actionId == 0. Input ignored
15:35:57 T:140637353330432 NOTICE: RCB_INFO: onAction: 0
15:35:57 T:140637353330432 NOTICE: RCB_INFO: actionId == 0. Input ignored
15:35:57 T:140637353330432 NOTICE: RCB_INFO: onAction: 0
15:35:57 T:140637353330432 NOTICE: RCB_INFO: actionId == 0. Input ignored
15:35:57 T:140637353330432 NOTICE: RCB_INFO: onAction: 0
15:35:57 T:140637353330432 NOTICE: RCB_INFO: actionId == 0. Input ignored
15:35:57 T:140637353330432 NOTICE: RCB_INFO: onAction: 0
15:35:57 T:140637353330432 NOTICE: RCB_INFO: actionId == 0. Input ignored
15:35:57 T:140641014204352 DEBUG: GetActionCode: Trying Hardy keycode for 0xf200
15:35:57 T:140641014204352 DEBUG: Previous line repeats 1 times.
15:35:57 T:140641014204352 DEBUG: OnKey: 0 (0xf200) pressed, action is
15:35:57 T:140641014204352 DEBUG: GetActionCode: Trying Hardy keycode for 0xf200
15:35:57 T:140641014204352 DEBUG: Previous line repeats 1 times.
15:35:57 T:140641014204352 DEBUG: OnKey: 0 (0xf200) pressed, action is
15:35:57 T:140641014204352 DEBUG: GetActionCode: Trying Hardy keycode for 0xf200
15:35:57 T:140641014204352 DEBUG: Previous line repeats 1 times.
15:35:57 T:140641014204352 DEBUG: OnKey: 0 (0xf200) pressed, action is
15:35:57 T:140641014204352 DEBUG: GetActionCode: Trying Hardy keycode for 0xf200
15:35:57 T:140641014204352 DEBUG: Previous line repeats 1 times.
15:35:57 T:140641014204352 DEBUG: OnKey: 0 (0xf200) pressed, action is
15:35:57 T:140641014204352 DEBUG: GetActionCode: Trying Hardy keycode for 0xf200
15:35:57 T:140641014204352 DEBUG: Previous line repeats 1 times.
15:35:57 T:140641014204352 DEBUG: OnKey: 0 (0xf200) pressed, action is
15:35:58 T:140640451196672 ERROR: PulseAudio: Failed to connect context
15:35:58 T:140640451196672 NOTICE: PulseAudio might not be running. Context was not created.
15:35:58 T:140640451196672 INFO: CAESinkALSA - Unable to open device "pulse" for playback
15:35:58 T:140640451196672 DEBUG: CAESinkALSA - Unable to obtain ELD information for device "hdmi:CARD=NVidia,DEV=0" (not supported by device, or kernel older than 3.2)
15:35:58 T:140640451196672 NOTICE: Found 1 Lists of Devices
15:35:58 T:140640451196672 NOTICE: Enumerated ALSA devices:
15:35:58 T:140640451196672 NOTICE: Device 1
15:35:58 T:140640451196672 NOTICE: m_deviceName : default
15:35:58 T:140640451196672 NOTICE: m_displayName : Default (HDA NVidia HDMI 0)
15:35:58 T:140640451196672 NOTICE: m_displayNameExtra:
15:35:58 T:140640451196672 NOTICE: m_deviceType : AE_DEVTYPE_PCM
15:35:58 T:140640451196672 NOTICE: m_channels : FL,FR,FC,LFE,BL,BR,SL,SR
15:35:58 T:140640451196672 NOTICE: m_sampleRates : 32000,44100,48000,88200,96000,176400,192000
15:35:58 T:140640451196672 NOTICE: m_dataFormats : AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE
15:35:58 T:140640451196672 NOTICE: Device 2
15:35:58 T:140640451196672 NOTICE: m_deviceName : @:CARD=NVidia,DEV=0
15:35:58 T:140640451196672 NOTICE: m_displayName : HDA NVidia
15:35:58 T:140640451196672 NOTICE: m_displayNameExtra: ALC889A Analog
15:35:58 T:140640451196672 NOTICE: m_deviceType : AE_DEVTYPE_PCM
15:35:58 T:140640451196672 NOTICE: m_channels : FL,FR,BL,BR,FC,LFE
15:35:58 T:140640451196672 NOTICE: m_sampleRates : 48000
15:35:58 T:140640451196672 NOTICE: m_dataFormats : AE_FMT_S32NE
15:35:58 T:140640451196672 NOTICE: Device 3
15:35:58 T:140640451196672 NOTICE: m_deviceName : iec958:CARD=NVidia,DEV=0
15:35:58 T:140640451196672 NOTICE: m_displayName : HDA NVidia
15:35:58 T:140640451196672 NOTICE: m_displayNameExtra: ALC889A Digital S/PDIF
15:35:58 T:140640451196672 NOTICE: m_deviceType : AE_DEVTYPE_IEC958
15:35:58 T:140640451196672 NOTICE: m_channels : FL,FR
15:35:58 T:140640451196672 NOTICE: m_sampleRates : 44100,48000,88200,96000,192000
15:35:58 T:140640451196672 NOTICE: m_dataFormats : AE_FMT_AC3,AE_FMT_DTS,AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE
15:35:58 T:140640451196672 NOTICE: Device 4
15:35:58 T:140640451196672 NOTICE: m_deviceName : hdmi:CARD=NVidia,DEV=0
15:35:58 T:140640451196672 NOTICE: m_displayName : HDA NVidia
15:35:58 T:140640451196672 NOTICE: m_displayNameExtra: HDMI
15:35:58 T:140640451196672 NOTICE: m_deviceType : AE_DEVTYPE_HDMI
15:35:58 T:140640451196672 NOTICE: m_channels : FL,FR,FC,LFE,BL,BR,SL,SR
15:35:58 T:140640451196672 NOTICE: m_sampleRates : 32000,44100,48000,88200,96000,176400,192000
15:35:58 T:140640451196672 NOTICE: m_dataFormats : AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S16LE,AE_FMT_LPCM,AE_FMT_DTSHD,AE_FMT_TRUEHD,AE_FMT_EAC3,AE_FMT_DTS,AE_FMT_AC3,AE_FMT_AAC
15:35:58 T:140640508954368 INFO: CActiveAESink::OpenSink - initialize sink
15:35:58 T:140640508954368 DEBUG: CActiveAESink::OpenSink - trying to open device ALSA:hdmi:CARD=NVidia,DEV=0
15:35:58 T:140640508954368 INFO: CAESinkALSA::Initialize - Attempting to open device "hdmi:CARD=NVidia,DEV=0"
15:35:58 T:140640508954368 INFO: CAESinkALSA::Initialize - Opened device "hdmi:CARD=NVidia,DEV=0,AES0=0x04,AES1=0x82,AES2=0x00,AES3=0x00"
15:35:58 T:140640508954368 INFO: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats
15:35:58 T:140640508954368 INFO: CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE
15:35:58 T:140640508954368 DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 2048, bufferSize 8192
15:35:58 T:140640508954368 DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 2048, bufferSize 8192
15:35:58 T:140640508954368 DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 186 ms
15:35:58 T:140640508954368 DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2
15:35:58 T:140640508954368 DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: FL,FR
15:35:58 T:140640508954368 DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: FL,FR (ALSA: FL FR)
15:35:58 T:140640508954368 DEBUG: CActiveAESink::OpenSink - ALSA Initialized:
15:35:58 T:140640508954368 DEBUG: Output Device : HDA NVidia
15:35:58 T:140640508954368 DEBUG: Sample Rate : 44100
15:35:58 T:140640508954368 DEBUG: Sample Format : AE_FMT_S32NE
15:35:58 T:140640508954368 DEBUG: Channel Count : 2
15:35:58 T:140640508954368 DEBUG: Channel Layout: FL,FR
15:35:58 T:140640508954368 DEBUG: Frames : 2048
15:35:58 T:140640508954368 DEBUG: Frame Samples : 4096
15:35:58 T:140640508954368 DEBUG: Frame Size : 8
15:35:58 T:140640451196672 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
15:35:58 T:140637353330432 NOTICE: RCB_INFO: Toggle to Full Screen mode
15:35:58 T:140637353330432 NOTICE: RCB_INFO: End launcher.launchEmu
15:35:58 T:140637353330432 NOTICE: RCB_INFO: End launchEmu
15:35:58 T:140637353330432 NOTICE: RCB_INFO: onAction: 0
15:35:58 T:140637353330432 NOTICE: RCB_INFO: actionId == 0. Input ignored
15:35:58 T:140637353330432 NOTICE: RCB_INFO: onAction: 0
15:35:58 T:140637353330432 NOTICE: RCB_INFO: actionId == 0. Input ignored
15:35:58 T:140637353330432 NOTICE: RCB_INFO: onAction: 0
15:35:58 T:140637353330432 NOTICE: RCB_INFO: actionId == 0. Input ignored
15:35:58 T:140637353330432 NOTICE: RCB_INFO: onAction: 0
15:35:58 T:140637353330432 NOTICE: RCB_INFO: actionId == 0. Input ignored
15:35:58 T:140637353330432 NOTICE: RCB_INFO: onAction: 0
15:35:58 T:140637353330432 NOTICE: RCB_INFO: actionId == 0. Input ignored
15:35:58 T:140641014204352 DEBUG: OnLostDevice - notify display change event
15:35:58 T:140641014204352 DEBUG: Flush - flushing renderer
15:35:58 T:140641014204352 DEBUG: Window Manager Name: Openbox
15:35:58 T:140641014204352 DEBUG: CWinSystemX11::RefreshGlxContext: refreshing context
15:35:59 T:140640451196672 DEBUG: CActiveAE - display reset event
15:35:59 T:140640508954368 INFO: CActiveAESink::OpenSink - initialize sink
15:35:59 T:140640508954368 DEBUG: CActiveAESink::OpenSink - trying to open device ALSA:hdmi:CARD=NVidia,DEV=0
15:35:59 T:140640508954368 INFO: CAESinkALSA::Initialize - Attempting to open device "hdmi:CARD=NVidia,DEV=0"
15:35:59 T:140641014204352 INFO: GL: Maximum texture width: 8192
15:35:59 T:140641014204352 DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec
15:35:59 T:140640508954368 INFO: CAESinkALSA::Initialize - Opened device "hdmi:CARD=NVidia,DEV=0,AES0=0x04,AES1=0x82,AES2=0x00,AES3=0x00"
15:35:59 T:140640508954368 INFO: CAESinkALSA::InitializeHW - Your hardware does not support AE_FMT_FLOAT, trying other formats
15:35:59 T:140640508954368 INFO: CAESinkALSA::InitializeHW - Using data format AE_FMT_S32NE
15:35:59 T:140640508954368 DEBUG: CAESinkALSA::InitializeHW - Request: periodSize 2048, bufferSize 8192
15:35:59 T:140640508954368 DEBUG: CAESinkALSA::InitializeHW - Got: periodSize 2048, bufferSize 8192
15:35:59 T:140640508954368 DEBUG: CAESinkALSA::InitializeHW - Setting timeout to 186 ms
15:35:59 T:140640508954368 DEBUG: CAESinkALSA::GetChannelLayout - Input Channel Count: 2 Output Channel Count: 2
15:35:59 T:140640508954368 DEBUG: CAESinkALSA::GetChannelLayout - Requested Layout: FL,FR
15:35:59 T:140640508954368 DEBUG: CAESinkALSA::GetChannelLayout - Got Layout: FL,FR (ALSA: FL FR)
15:35:59 T:140640508954368 DEBUG: CActiveAESink::OpenSink - ALSA Initialized:
15:35:59 T:140640508954368 DEBUG: Output Device : HDA NVidia
15:35:59 T:140640508954368 DEBUG: Sample Rate : 44100
15:35:59 T:140640508954368 DEBUG: Sample Format : AE_FMT_S32NE
15:35:59 T:140640508954368 DEBUG: Channel Count : 2
15:35:59 T:140640508954368 DEBUG: Channel Layout: FL,FR
15:35:59 T:140640508954368 DEBUG: Frames : 2048
15:35:59 T:140640508954368 DEBUG: Frame Samples : 4096
15:35:59 T:140640508954368 DEBUG: Frame Size : 8
15:35:59 T:140638467868416 DEBUG: webserver: request received for /jsonrpc
15:35:59 T:140640451196672 DEBUG: CActiveAE::ClearDiscardedBuffers - buffer pool deleted
15:36:00 T:140638476261120 DEBUG: webserver: request received for /jsonrpc
15:36:13 T:140637605111552 DEBUG: Previous line repeats 8 times.
15:36:13 T:140637605111552 DEBUG: Thread JobWorker 140637605111552 terminating (autodelete)
15:36:13 T:140638234343168 DEBUG: Thread JobWorker 140638234343168 terminating (autodelete)
15:36:14 T:140638234343168 DEBUG: webserver: request received for /jsonrpc