{"action":"created","issue":{"url":"https://api.github.com/repos/pannal/Subliminal.bundle/issues/18","labels_url":"https://api.github.com/repos/pannal/Subliminal.bundle/issues/18/labels{/name}","comments_url":"https://api.github.com/repos/pannal/Subliminal.bundle/issues/18/comments","events_url":"https://api.github.com/repos/pannal/Subliminal.bundle/issues/18/events","html_url":"https://github.com/pannal/Subliminal.bundle/issues/18","id":108274697,"number":18,"title":"Can't download subtitles","user":{"login":"mrlook2","id":14833143,"avatar_url":"https://avatars.githubusercontent.com/u/14833143?v=3","gravatar_id":"","url":"https://api.github.com/users/mrlook2","html_url":"https://github.com/mrlook2","followers_url":"https://api.github.com/users/mrlook2/followers","following_url":"https://api.github.com/users/mrlook2/following{/other_user}","gists_url":"https://api.github.com/users/mrlook2/gists{/gist_id}","starred_url":"https://api.github.com/users/mrlook2/starred{/owner}{/repo}","subscriptions_url":"https://api.github.com/users/mrlook2/subscriptions","organizations_url":"https://api.github.com/users/mrlook2/orgs","repos_url":"https://api.github.com/users/mrlook2/repos","events_url":"https://api.github.com/users/mrlook2/events{/privacy}","received_events_url":"https://api.github.com/users/mrlook2/received_events","type":"User","site_admin":false},"labels":[],"state":"open","locked":false,"assignee":{"login":"pannal","id":1359593,"avatar_url":"https://avatars.githubusercontent.com/u/1359593?v=3","gravatar_id":"","url":"https://api.github.com/users/pannal","html_url":"https://github.com/pannal","followers_url":"https://api.github.com/users/pannal/followers","following_url":"https://api.github.com/users/pannal/following{/other_user}","gists_url":"https://api.github.com/users/pannal/gists{/gist_id}","starred_url":"https://api.github.com/users/pannal/starred{/owner}{/repo}","subscriptions_url":"https://api.github.com/users/pannal/subscriptions","organizations_url":"https://api.github.com/users/pannal/orgs","repos_url":"https://api.github.com/users/pannal/repos","events_url":"https://api.github.com/users/pannal/events{/privacy}","received_events_url":"https://api.github.com/users/pannal/received_events","type":"User","site_admin":false},"milestone":null,"comments":20,"created_at":"2015-09-25T07:02:08Z","updated_at":"2015-10-09T13:26:01Z","closed_at":null,"body":"Not sure if I should post this here, as an issue. Bit kind of new into github and couldn't find any forum or something like that. Anyway, I attach the log, I can't see whats wrong but perhaps you can:\r\n\r\n2015-09-25 08:42:27,854 (7fac7cf97740) :  INFO (core:347) - Starting framework core - Version: 2.6.2, Build: 4ffb9d5 (Mon Aug 17 09:49:09 UTC 2015)\r\n2015-09-25 08:42:27,854 (7fac7cf97740) :  DEBUG (core:359) - Using the elevated policy\r\n2015-09-25 08:42:27,854 (7fac7cf97740) :  DEBUG (core:448) - Starting runtime component.\r\n2015-09-25 08:42:27,859 (7fac7cf97740) :  DEBUG (core:448) - Starting caching component.\r\n2015-09-25 08:42:27,859 (7fac7cf97740) :  DEBUG (core:448) - Starting data component.\r\n2015-09-25 08:42:27,859 (7fac7cf97740) :  DEBUG (core:448) - Starting networking component.\r\n2015-09-25 08:42:27,864 (7fac7cf97740) :  DEBUG (networking:282) - Loaded HTTP cookies\r\n2015-09-25 08:42:27,872 (7fac7cf97740) :  DEBUG (networking:450) - Setting the default network timeout to 20.0\r\n2015-09-25 08:42:27,873 (7fac7cf97740) :  DEBUG (core:448) - Starting localization component.\r\n2015-09-25 08:42:27,873 (7fac7cf97740) :  INFO (localization:408) - Setting the default locale to en-us\r\n2015-09-25 08:42:27,882 (7fac7cf97740) :  WARNING (data:179) - Error decoding with simplejson, using demjson instead (this will cause a performance hit) - Expecting property name enclosed in double quotes: line 45 column 1 (char 789)\r\n2015-09-25 08:42:27,896 (7fac7cf97740) :  DEBUG (localization:426) - Loaded en strings\r\n2015-09-25 08:42:27,897 (7fac7cf97740) :  DEBUG (core:448) - Starting messaging component.\r\n2015-09-25 08:42:27,897 (7fac7cf97740) :  DEBUG (core:448) - Starting debugging component.\r\n2015-09-25 08:42:27,898 (7fac657fa700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/system/messaging/clear_events/com.plexapp.agents.subliminal'\r\n2015-09-25 08:42:27,898 (7fac7cf97740) :  DEBUG (core:448) - Starting services component.\r\n2015-09-25 08:42:27,899 (7fac7cf97740) :  DEBUG (core:448) - Starting myplex component.\r\n2015-09-25 08:42:27,900 (7fac7cf97740) :  DEBUG (core:448) - Starting notifications component.\r\n2015-09-25 08:42:28,014 (7fac7cf97740) :  DEBUG (accessor:68) - Creating a new model access point for provider com.plexapp.agents.subliminal in namespace 'metadata'\r\n2015-09-25 08:42:28,019 (7fac7cf97740) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/resourceHashes'\r\n2015-09-25 08:42:28,035 (7fac657fa700) :  DEBUG (services:265) - Plug-in is not daemonized - loading services from system\r\n2015-09-25 08:42:28,035 (7fac7cf97740) :  DEBUG (runtime:1111) - Created a thread named 'load_all_services'\r\n2015-09-25 08:42:28,037 (7fac657fa700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_'\r\n2015-09-25 08:42:28,041 (7fac7cf97740) :  DEBUG (runtime:1111) - Created a thread named 'get_server_info'\r\n2015-09-25 08:42:28,041 (7fac47fff700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400'\r\n2015-09-25 08:42:28,041 (7fac7cf97740) :  DEBUG (core:150) - Finished starting framework core\r\n2015-09-25 08:42:28,043 (7fac7cf97740) :  DEBUG (core:558) - Loading plug-in code\r\n2015-09-25 08:42:28,106 (7fac7cf97740) :  DEBUG (core:564) - Finished loading plug-in code\r\n2015-09-25 08:42:28,165 (7fac47fff700) :  DEBUG (core:536) - Machine identifier is b32aacea57ab776146aba9393b9ebaf2c404b56c\r\n2015-09-25 08:42:28,166 (7fac47fff700) :  DEBUG (core:537) - Server version is 0.9.12.11.1406-8403350\r\n2015-09-25 08:42:28,328 (7fac657fa700) :  DEBUG (services:362) - Loaded services\r\n2015-09-25 08:42:28,332 (7fac64ff9700) :  DEBUG (services:438) - No shared code to load\r\n2015-09-25 08:42:28,575 (7fac7cf97740) :  DEBUG (agentkit:1094) - Creating new agent class called SubliminalSubtitlesAgentMovies\r\n2015-09-25 08:42:28,576 (7fac7cf97740) :  DEBUG (agentkit:912) - Updating agent information: [{'media_types': ['Movie'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.imdb'], 'languages': ['en'], 'persist_stored_files': True, 'version': 0, 'primary_provider': False, 'prefs': True, 'name': 'Subliminal Movie Subtitles'}]\r\n2015-09-25 08:42:28,576 (7fac7cf97740) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQo2CmRpY3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0CjIKczI5CmNvbS5wbGV4YXBwLmFnZW50cy5zdWJsaW1pbmFsczEwCmlkZW50aWZpZXJyMQpzMTAKYWdlbnRfaW5mbzEKcjIKMTAKcjMKczExCm1lZGlhX3R5cGVzbnMxMgphY2NlcHRzX2Zyb21uczE0CmZhbGxiYWNrX2FnZW50cjQKczE0CmNvbnRyaWJ1dGVzX3RvcjUKczkKbGFuZ3VhZ2VzYjFzMjAKcGVyc2lzdF9zdG9yZWRfZmlsZXNpMApzNwp2ZXJzaW9uYjBzMTYKcHJpbWFyeV9wcm92aWRlcmIxczUKcHJlZnNzMjYKU3VibGltaW5hbCBNb3ZpZSBTdWJ0aXRsZXNzNApuYW1lMQpzNQpNb3ZpZTEKczIzCmNvbS5wbGV4YXBwLmFnZW50cy5pbWRiMQpzMgplbnIwCg__'\r\n2015-09-25 08:42:28,585 (7fac7cf97740) :  DEBUG (agentkit:1094) - Creating new agent class called SubliminalSubtitlesAgentTvShows\r\n2015-09-25 08:42:28,586 (7fac7cf97740) :  DEBUG (agentkit:912) - Updating agent information: [{'media_types': ['Movie'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.imdb'], 'languages': ['en'], 'persist_stored_files': True, 'version': 0, 'primary_provider': False, 'prefs': True, 'name': 'Subliminal Movie Subtitles'}, {'media_types': ['TV_Show'], 'accepts_from': None, 'fallback_agent': None, 'contributes_to': ['com.plexapp.agents.thetvdb'], 'languages': ['en'], 'persist_stored_files': True, 'version': 0, 'primary_provider': False, 'prefs': True, 'name': 'Subliminal TV Subtitles'}]\r\n2015-09-25 08:42:28,587 (7fac7cf97740) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/messaging/function/X0FnZW50U2VydmljZTpVcGRhdGVJbmZv/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxMApkaWN0Cmxpc3QKZGljdApsaXN0Cmxpc3QKbGlzdApkaWN0Cmxpc3QKbGlzdApsaXN0CjIKczI5CmNvbS5wbGV4YXBwLmFnZW50cy5zdWJsaW1pbmFsczEwCmlkZW50aWZpZXJyMQpzMTAKYWdlbnRfaW5mbzIKcjIKcjYKMTAKcjMKczExCm1lZGlhX3R5cGVzbnMxMgphY2NlcHRzX2Zyb21uczE0CmZhbGxiYWNrX2FnZW50cjQKczE0CmNvbnRyaWJ1dGVzX3RvcjUKczkKbGFuZ3VhZ2VzYjFzMjAKcGVyc2lzdF9zdG9yZWRfZmlsZXNpMApzNwp2ZXJzaW9uYjBzMTYKcHJpbWFyeV9wcm92aWRlcmIxczUKcHJlZnNzMjYKU3VibGltaW5hbCBNb3ZpZSBTdWJ0aXRsZXNzNApuYW1lMQpzNQpNb3ZpZTEKczIzCmNvbS5wbGV4YXBwLmFnZW50cy5pbWRiMQpzMgplbjEwCnI3CnMxMQptZWRpYV90eXBlc25zMTIKYWNjZXB0c19mcm9tbnMxNApmYWxsYmFja19hZ2VudHI4CnMxNApjb250cmlidXRlc190b3I5CnM5Cmxhbmd1YWdlc2IxczIwCnBlcnNpc3Rfc3RvcmVkX2ZpbGVzaTAKczcKdmVyc2lvbmIwczE2CnByaW1hcnlfcHJvdmlkZXJiMXM1CnByZWZzczIzClN1YmxpbWluYWwgVFYgU3VidGl0bGVzczQKbmFtZTEKczcKVFZfU2hvdzEKczI2CmNvbS5wbGV4YXBwLmFnZW50cy50aGV0dmRiMQpzMgplbnIwCg__'\r\n2015-09-25 08:42:28,596 (7fac7cf97740) :  DEBUG (__init__:16) - START CALLED\r\n2015-09-25 08:42:28,596 (7fac7cf97740) :  DEBUG (logger:6) - Registering LoggerHandler for dependency: subliminal\r\n2015-09-25 08:42:28,596 (7fac7cf97740) :  DEBUG (logger:6) - Registering LoggerHandler for dependency: enzyme\r\n2015-09-25 08:42:28,597 (7fac7cf97740) :  DEBUG (logger:6) - Registering LoggerHandler for dependency: guessit\r\n2015-09-25 08:42:28,597 (7fac7cf97740) :  DEBUG (logger:6) - Registering LoggerHandler for dependency: requests\r\n2015-09-25 08:42:28,598 (7fac7cf97740) :  INFO (core:609) - Started plug-in\r\n2015-09-25 08:42:28,598 (7fac7cf97740) :  DEBUG (socketinterface:160) - Starting socket server\r\n2015-09-25 08:42:28,599 (7fac7cf97740) :  DEBUG (runtime:1111) - Created a thread named 'start'\r\n2015-09-25 08:42:28,599 (7fac7cf97740) :  INFO (socketinterface:184) - Socket server started on port 33724\r\n2015-09-25 08:42:28,599 (7fac7cf97740) :  INFO (pipeinterface:25) - Entering run loop\r\n2015-09-25 08:42:28,599 (7fac7cf97740) :  DEBUG (runtime:717) - Handling request GET /:/prefixes\r\n2015-09-25 08:42:28,601 (7fac7cf97740) :  DEBUG (runtime:814) - Found route matching /:/prefixes\r\n2015-09-25 08:42:28,601 (7fac7cf97740) :  DEBUG (runtime:918) - Response: [200] MediaContainer, 154 bytes\r\n2015-09-25 08:42:28,629 (7fac657fa700) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.subliminal/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCnN2czQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M3ClRWX1Nob3dzMTAKbWVkaWFfdHlwZTUKczMKMTYzczgKcGFyZW50SURzNDcKY29tLnBsZXhhcHAuYWdlbnRzLnRoZXR2ZGI6Ly8yNTUzMTYvMy8yP2xhbmc9c3ZzNApndWlkYjFzNQpmb3JjZXMyNgpjb20ucGxleGFwcC5hZ2VudHMudGhldHZkYnMxMwpwcmltYXJ5X2FnZW50czMKMTY1czIKaWRyMAo_\r\n2015-09-25 08:42:28,629 (7fac657fa700) :  DEBUG (runtime:49) - Received packed state data (80 bytes)\r\n2015-09-25 08:42:28,641 (7fac657fa700) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.subliminal/messaging/function/X0FnZW50S2l0OlNlYXJjaA__/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoyCmRpY3QKZGljdAo2CnMyCnN2czQKbGFuZ2IwczYKbWFudWFsYjBzNwpwcmltYXJ5aTAKczcKdmVyc2lvbnIxCnM2Cmt3YXJnc3M3ClRWX1Nob3dzMTAKbWVkaWFfdHlwZTUKczMKMTYzczgKcGFyZW50SURzNDcKY29tLnBsZXhhcHAuYWdlbnRzLnRoZXR2ZGI6Ly8yNTUzMTYvMy8yP2xhbmc9c3ZzNApndWlkYjFzNQpmb3JjZXMyNgpjb20ucGxleGFwcC5hZ2VudHMudGhldHZkYnMxMwpwcmltYXJ5X2FnZW50czMKMTY1czIKaWRyMAo_\r\n2015-09-25 08:42:28,641 (7fac657fa700) :  INFO (agentkit:936) - Searching for matches for {'id': '165', 'guid': 'com.plexapp.agents.thetvdb://255316/3/2?lang=sv', 'force': True, 'primary_agent': 'com.plexapp.agents.thetvdb', 'parentID': '163'}\r\n2015-09-25 08:42:28,642 (7fac657fa700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/165/tree'\r\n2015-09-25 08:42:28,648 (7fac657fa700) :  DEBUG (accessor:68) - Creating a new read-only model access point for provider com.plexapp.agents.thetvdb in namespace 'metadata'\r\n2015-09-25 08:42:28,652 (7fac657fa700) :  DEBUG (model:32) - Loading model with GUID com.plexapp.agents.thetvdb://255316/3/2?lang=sv\r\n2015-09-25 08:42:28,654 (7fac657fa700) :  DEBUG (model:230) - Deserializing from /home/look2/Library/Application Support/Plex Media Server/Metadata/TV Shows/3/d139bd90dac5b223a04b6b53191d8bc516d52c0.bundle/Contents/com.plexapp.agents.thetvdb/Info.xml\r\n2015-09-25 08:42:28,713 (7fac657fa700) :  DEBUG (__init__:142) - TV SEARCH CALLED\r\n2015-09-25 08:42:28,714 (7fac657fa700) :  DEBUG (runtime:106) - Sending packed state data (110 bytes)\r\n2015-09-25 08:42:28,714 (7fac657fa700) :  DEBUG (runtime:918) - Response: [200] str, 600 bytes\r\n2015-09-25 08:42:28,721 (7fac657fa700) :  DEBUG (runtime:717) - Handling request GET /:/plugins/com.plexapp.agents.subliminal/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKc3ZzNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzMwoxNjVzNApkYmlkaTAKczcKdmVyc2lvbnM0NQpjb20ucGxleGFwcC5hZ2VudHMudGhldHZkYjovLzI1NTMxNi8zP2xhbmc9c3ZzMTAKcGFyZW50R1VJRHMzCjE2M3M4CnBhcmVudElEczcKVFZfU2hvd3MxMAptZWRpYV90eXBlczQ3CmNvbS5wbGV4YXBwLmFnZW50cy50aGV0dmRiOi8vMjU1MzE2LzMvMj9sYW5nPXN2czQKZ3VpZHM0Cm51bGxzMgppZHIwCg__\r\n2015-09-25 08:42:28,722 (7fac657fa700) :  DEBUG (runtime:49) - Received packed state data (80 bytes)\r\n2015-09-25 08:42:28,723 (7fac657fa700) :  DEBUG (runtime:814) - Found route matching /:/plugins/com.plexapp.agents.subliminal/messaging/function/X0FnZW50S2l0OlVwZGF0ZU1ldGFkYXRh/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMTAKczIKc3ZzNApsYW5nYjFzNQpmb3JjZWIwczgKcGVyaW9kaWNzMwoxNjVzNApkYmlkaTAKczcKdmVyc2lvbnM0NQpjb20ucGxleGFwcC5hZ2VudHMudGhldHZkYjovLzI1NTMxNi8zP2xhbmc9c3ZzMTAKcGFyZW50R1VJRHMzCjE2M3M4CnBhcmVudElEczcKVFZfU2hvd3MxMAptZWRpYV90eXBlczQ3CmNvbS5wbGV4YXBwLmFnZW50cy50aGV0dmRiOi8vMjU1MzE2LzMvMj9sYW5nPXN2czQKZ3VpZHM0Cm51bGxzMgppZHIwCg__\r\n2015-09-25 08:42:28,723 (7fac657fa700) :  DEBUG (model:32) - Loading model with GUID com.plexapp.agents.thetvdb://255316/3/2?lang=sv\r\n2015-09-25 08:42:28,724 (7fac657fa700) :  ERROR (model:201) - Cannot read model from /home/look2/Library/Application Support/Plex Media Server/Metadata/TV Shows/3/d139bd90dac5b223a04b6b53191d8bc516d52c0.bundle/Contents/com.plexapp.agents.subliminal\r\n2015-09-25 08:42:28,724 (7fac657fa700) :  DEBUG (networking:166) - Requesting 'http://127.0.0.1:32400/library/metadata/165/tree'\r\n2015-09-25 08:42:28,730 (7fac657fa700) :  DEBUG (__init__:146) - TvUpdate. Lang sv\r\n2015-09-25 08:42:28,748 (7fac657fa700) :  WARNING (data:179) - Error decoding with simplejson, using demjson instead (this will cause a performance hit) - Expecting value: line 104 column 1 (char 4063)\r\n2015-09-25 08:42:28,757 (7fac657fa700) :  DEBUG (preferences:258) - Loaded preferences from DefaultPrefs.json\r\n2015-09-25 08:42:28,758 (7fac657fa700) :  DEBUG (preferences:178) - Loaded the user preferences for com.plexapp.agents.subliminal\r\n2015-09-25 08:42:28,758 (7fac657fa700) :  DEBUG (__init__:71) - Scanning video: /home/look2/fserv/film_tv/tv/Elementary/Elementary.S03E02.720p.HDTV.X264-DIMENSION.mkv, subtitles=False, embedded_subtitles=False\r\n2015-09-25 08:42:28,758 (7fac657fa700) :  INFO (logger:31) - subliminal.video: Scanning video 'Elementary.S03E02.720p.HDTV.X264-DIMENSION.mkv' in '/home/look2/fserv/film_tv/tv/Elementary'\r\n2015-09-25 08:42:29,087 (7fac657fa700) :  DEBUG (logger:21) - guessit.matcher: Property found: type=movie (None) (confidence=1.00)\r\n2015-09-25 08:42:29,105 (7fac657fa700) :  DEBUG (logger:21) - guessit.matcher: Property found: mimetype=video/x-matroska (None) (confidence=1.00)\r\n2015-09-25 08:42:29,105 (7fac657fa700) :  DEBUG (logger:21) - guessit.matcher: Property found: container=mkv (None) (confidence=1.00)\r\n2015-09-25 08:42:29,306 (7fac657fa700) :  DEBUG (logger:21) - guessit.matcher: Found match tree:\r\n01111 22222 33333 4444444 55 6666666666 777777777777777777777777777777777777777777 888\r\n00000 00000 00000 0000000 00 0000000000 000000000000000000000000000000000000000000 000\r\n                                        000000000000000000000001111222222222222222 000\r\n                                        00000000000000000011112    011112222222222\r\n                                                                        0111111111\r\n/home/look2/fserv/film_tv/tv/Elementary/______________________.____.____-_________.___\r\n                                        ttttttttttttttttttssss ffff vvvv rrrrrrrrr ccc\r\n/home/look2/fserv/film_tv/tv/Elementary/Elementary.S03E02.720p.HDTV.X264-DIMENSION.mkv\r\n2015-09-25 08:42:29,307 (7fac657fa700) :  DEBUG (logger:21) - guessit.guess: Updating matching property 'container' with confidence 1.00\r\n2015-09-25 08:42:29,308 (7fac657fa700) :  DEBUG (logger:21) - guessit.matchtree: Final result: {\r\n    [1.00] \"mimetype\": \"video/x-matroska\", \r\n    [1.00] \"videoCodec\": \"h264\", \r\n    [1.00] \"container\": \"mkv\", \r\n    [1.00] \"format\": \"HDTV\", \r\n    [0.60] \"title\": \"Elementary S03E02\", \r\n    [1.00] \"releaseGroup\": \"DIMENSION\", \r\n    [1.00] \"screenSize\": \"720p\", \r\n    [1.00] \"type\": \"movie\"\r\n}\r\n2015-09-25 08:42:29,310 (7fac657fa700) :  DEBUG (logger:21) - subliminal.video: Size is 878229730\r\n2015-09-25 08:42:29,421 (7fac657fa700) :  DEBUG (logger:21) - subliminal.video: Computed hashes {u'opensubtitles': u'c864259a8734d7e7', u'thesubdb': 'dc7bc77da2ba08f95ecf6f3530d20a23'}\r\n2015-09-25 08:42:29,422 (7fac657fa700) :  INFO (logger:31) - enzyme.mkv: Reading Segment element\r\n2015-09-25 08:42:29,466 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: MasterElement EBML parsed\r\n2015-09-25 08:42:29,466 (7fac657fa700) :  INFO (logger:31) - enzyme.parsers.ebml.core: MasterElement EBML ignored\r\n2015-09-25 08:42:29,466 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: MasterElement Segment parsed\r\n2015-09-25 08:42:29,467 (7fac657fa700) :  INFO (logger:31) - enzyme.parsers.ebml.core: Maximum level 0 reached for children of MasterElement Segment\r\n2015-09-25 08:42:29,467 (7fac657fa700) :  INFO (logger:31) - enzyme.mkv: Reading SeekHead element\r\n2015-09-25 08:42:29,468 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: MasterElement Seek parsed\r\n2015-09-25 08:42:29,469 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: Loading child elements for MasterElement Seek with size 12\r\n2015-09-25 08:42:29,470 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: Element SeekID parsed\r\n2015-09-25 08:42:29,470 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: Element SeekPosition parsed\r\n2015-09-25 08:42:29,470 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: MasterElement Seek parsed\r\n2015-09-25 08:42:29,470 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: Loading child elements for MasterElement Seek with size 12\r\n2015-09-25 08:42:29,471 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: Element SeekID parsed\r\n2015-09-25 08:42:29,471 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: Element SeekPosition parsed\r\n2015-09-25 08:42:29,471 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: MasterElement Seek parsed\r\n2015-09-25 08:42:29,472 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: Loading child elements for MasterElement Seek with size 14\r\n2015-09-25 08:42:29,472 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: Element SeekID parsed\r\n2015-09-25 08:42:29,472 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: Element SeekPosition parsed\r\n2015-09-25 08:42:29,472 (7fac657fa700) :  INFO (logger:31) - enzyme.mkv: Processing element Info from SeekHead at position 4151\r\n2015-09-25 08:42:29,473 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: Element TimecodeScale parsed\r\n2015-09-25 08:42:29,473 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: Element MuxingApp parsed\r\n2015-09-25 08:42:29,473 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: Element WritingApp parsed\r\n2015-09-25 08:42:29,474 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: Element Duration parsed\r\n2015-09-25 08:42:29,474 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: Element DateUTC parsed\r\n2015-09-25 08:42:29,474 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: Element SegmentUID parsed\r\n2015-09-25 08:42:29,475 (7fac657fa700) :  INFO (logger:31) - enzyme.mkv: Processing element Tracks from SeekHead at position 4316\r\n2015-09-25 08:42:29,475 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: MasterElement TrackEntry parsed\r\n2015-09-25 08:42:29,475 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: Loading child elements for MasterElement TrackEntry with size 114\r\n2015-09-25 08:42:29,475 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: Element TrackNumber parsed\r\n2015-09-25 08:42:29,476 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: Element TrackUID parsed\r\n2015-09-25 08:42:29,476 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: Element TrackType parsed\r\n2015-09-25 08:42:29,476 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: Element FlagLacing parsed\r\n2015-09-25 08:42:29,476 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: Element MinCache parsed\r\n2015-09-25 08:42:29,477 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: Element CodecID parsed\r\n2015-09-25 08:42:29,477 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: Element CodecPrivate parsed\r\n2015-09-25 08:42:29,477 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: Element DefaultDuration parsed\r\n2015-09-25 08:42:29,477 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: MasterElement Video parsed\r\n2015-09-25 08:42:29,478 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: Loading child elements for MasterElement Video with size 22\r\n2015-09-25 08:42:29,478 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: Element PixelWidth parsed\r\n2015-09-25 08:42:29,478 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: Element PixelHeight parsed\r\n2015-09-25 08:42:29,479 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: Element DisplayWidth parsed\r\n2015-09-25 08:42:29,479 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: Element DisplayHeight parsed\r\n2015-09-25 08:42:29,479 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: MasterElement TrackEntry parsed\r\n2015-09-25 08:42:29,479 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: Loading child elements for MasterElement TrackEntry with size 50\r\n2015-09-25 08:42:29,480 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: Element TrackNumber parsed\r\n2015-09-25 08:42:29,480 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: Element TrackUID parsed\r\n2015-09-25 08:42:29,480 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: Element TrackType parsed\r\n2015-09-25 08:42:29,480 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: Element CodecID parsed\r\n2015-09-25 08:42:29,481 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: Element DefaultDuration parsed\r\n2015-09-25 08:42:29,481 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: Element Language parsed\r\n2015-09-25 08:42:29,481 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: MasterElement Audio parsed\r\n2015-09-25 08:42:29,482 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: Loading child elements for MasterElement Audio with size 9\r\n2015-09-25 08:42:29,482 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: Element SamplingFrequency parsed\r\n2015-09-25 08:42:29,482 (7fac657fa700) :  DEBUG (logger:21) - enzyme.parsers.ebml.core: Element Channels parsed\r\n2015-09-25 08:42:29,483 (7fac657fa700) :  DEBUG (logger:21) - enzyme.mkv: Element Cues ignored\r\n2015-09-25 08:42:29,483 (7fac657fa700) :  DEBUG (logger:21) - subliminal.video: Found resolution 720p with enzyme\r\n2015-09-25 08:42:29,484 (7fac657fa700) :  DEBUG (logger:21) - subliminal.video: Found video_codec h264 with enzyme\r\n2015-09-25 08:42:29,484 (7fac657fa700) :  DEBUG (logger:21) - subliminal.video: Found audio_codec AC3 with enzyme\r\n2015-09-25 08:42:29,484 (7fac657fa700) :  DEBUG (logger:21) - subliminal.video: MKV has no subtitle track\r\n2015-09-25 08:42:29,484 (7fac657fa700) :  DEBUG (__init__:80) - Download best subtitles using settings: min_score: 20, hearing_impaired: False\r\n2015-09-25 08:42:29,719 (7fac657fa700) :  INFO (logger:31) - subliminal.api: Listing subtitles for <Movie [u'Elementary S03E02']>\r\n2015-09-25 08:42:29,870 (7fac657fa700) :  INFO (logger:31) - subliminal.providers: Listing subtitles with provider 'opensubtitles' and languages set([<Language [en]>, <Language [sv]>])\r\n2015-09-25 08:42:29,870 (7fac657fa700) :  DEBUG (logger:21) - subliminal.providers.opensubtitles: Searching subtitles [{u'moviebytesize': '878229730', u'sublanguageid': u'eng,swe', u'moviehash': u'c864259a8734d7e7'}]\r\n2015-09-25 08:42:30,026 (7fac657fa700) :  INFO (logger:31) - subliminal.providers: Found 6 subtitles\r\n2015-09-25 08:42:30,070 (7fac657fa700) :  INFO (logger:31) - subliminal.providers: Listing subtitles with provider 'thesubdb' and languages set([<Language [en]>, <Language [sv]>])\r\n2015-09-25 08:42:30,070 (7fac657fa700) :  DEBUG (logger:21) - subliminal.providers.thesubdb: Searching subtitles {u'action': u'search', u'hash': 'dc7bc77da2ba08f95ecf6f3530d20a23'}\r\n2015-09-25 08:42:30,115 (7fac657fa700) :  INFO (logger:31) - requests.packages.urllib3.connectionpool: Starting new HTTP connection (1): api.thesubdb.com\r\n2015-09-25 08:42:30,411 (7fac657fa700) :  DEBUG (logger:21) - requests.packages.urllib3.connectionpool: \"GET /?action=search&hash=dc7bc77da2ba08f95ecf6f3530d20a23 HTTP/1.1\" 200 None\r\n2015-09-25 08:42:30,412 (7fac657fa700) :  INFO (logger:31) - subliminal.providers: Found 1 subtitles\r\n2015-09-25 08:42:30,412 (7fac657fa700) :  INFO (logger:31) - subliminal.providers: Listing subtitles with provider 'podnapisi' and languages set([<Language [en]>, <Language [sv]>])\r\n2015-09-25 08:42:30,413 (7fac657fa700) :  DEBUG (logger:21) - subliminal.providers.podnapisi: Searching episode {u'sK': u'Elementary S03E02', u'sJ': 2, u'sXML': 1}\r\n2015-09-25 08:42:30,414 (7fac657fa700) :  INFO (logger:31) - requests.packages.urllib3.connectionpool: Starting new HTTP connection (1): simple.podnapisi.net\r\n2015-09-25 08:42:30,615 (7fac657fa700) :  DEBUG (logger:21) - requests.packages.urllib3.connectionpool: \"GET /ppodnapisi/search?sK=Elementary+S03E02&sJ=2&sXML=1 HTTP/1.1\" 302 160\r\n2015-09-25 08:42:30,616 (7fac657fa700) :  INFO (logger:31) - requests.packages.urllib3.connectionpool: Starting new HTTP connection (1): www.podnapisi.net\r\n2015-09-25 08:42:30,757 (7fac657fa700) :  DEBUG (logger:21) - requests.packages.urllib3.connectionpool: \"GET /ppodnapisi/search?sK=Elementary+S03E02&sJ=2&sXML=1 HTTP/1.1\" 200 1420\r\n2015-09-25 08:42:30,758 (7fac657fa700) :  DEBUG (logger:21) - subliminal.providers.podnapisi: No subtitle found\r\n2015-09-25 08:42:30,759 (7fac657fa700) :  DEBUG (logger:21) - subliminal.providers.podnapisi: Searching episode {u'sK': u'Elementary S03E02', u'sJ': 25, u'sXML': 1}\r\n2015-09-25 08:42:30,811 (7fac657fa700) :  DEBUG (logger:21) - requests.packages.urllib3.connectionpool: \"GET /ppodnapisi/search?sK=Elementary+S03E02&sJ=25&sXML=1 HTTP/1.1\" 302 160\r\n2015-09-25 08:42:30,884 (7fac657fa700) :  DEBUG (logger:21) - requests.packages.urllib3.connectionpool: \"GET /ppodnapisi/search?sK=Elementary+S03E02&sJ=25&sXML=1 HTTP/1.1\" 200 1420\r\n2015-09-25 08:42:30,885 (7fac657fa700) :  DEBUG (logger:21) - subliminal.providers.podnapisi: No subtitle found\r\n2015-09-25 08:42:30,885 (7fac657fa700) :  INFO (logger:31) - subliminal.providers: Found 0 subtitles\r\n2015-09-25 08:42:30,886 (7fac657fa700) :  INFO (logger:31) - subliminal.providers: Skipping provider 'addic7ed': not a valid video\r\n2015-09-25 08:42:30,886 (7fac657fa700) :  INFO (logger:31) - subliminal.providers: Skipping provider 'tvsubtitles': not a valid video\r\n2015-09-25 08:42:30,886 (7fac657fa700) :  INFO (logger:31) - subliminal.api: Found 7 subtitles total\r\n2015-09-25 08:42:30,886 (7fac657fa700) :  INFO (logger:31) - subliminal.providers.opensubtitles: 'episode' is not a valid movie_kind for <Movie [u'Elementary S03E02']>\r\n2015-09-25 08:42:30,887 (7fac657fa700) :  INFO (logger:31) - subliminal.subtitle: Computed score 0 with matches set([])\r\n2015-09-25 08:42:30,887 (7fac657fa700) :  INFO (logger:31) - subliminal.providers.opensubtitles: 'episode' is not a valid movie_kind for <Movie [u'Elementary S03E02']>\r\n2015-09-25 08:42:30,887 (7fac657fa700) :  INFO (logger:31) - subliminal.subtitle: Computed score 0 with matches set([])\r\n2015-09-25 08:42:30,887 (7fac657fa700) :  INFO (logger:31) - subliminal.providers.opensubtitles: 'episode' is not a valid movie_kind for <Movie [u'Elementary S03E02']>\r\n2015-09-25 08:42:30,888 (7fac657fa700) :  INFO (logger:31) - subliminal.subtitle: Computed score 0 with matches set([])\r\n2015-09-25 08:42:30,888 (7fac657fa700) :  INFO (logger:31) - subliminal.providers.opensubtitles: 'episode' is not a valid movie_kind for <Movie [u'Elementary S03E02']>\r\n2015-09-25 08:42:30,888 (7fac657fa700) :  INFO (logger:31) - subliminal.subtitle: Computed score 0 with matches set([])\r\n2015-09-25 08:42:30,889 (7fac657fa700) :  INFO (logger:31) - subliminal.providers.opensubtitles: 'episode' is not a valid movie_kind for <Movie [u'Elementary S03E02']>\r\n2015-09-25 08:42:30,889 (7fac657fa700) :  INFO (logger:31) - subliminal.subtitle: Computed score 0 with matches set([])\r\n2015-09-25 08:42:30,889 (7fac657fa700) :  INFO (logger:31) - subliminal.providers.opensubtitles: 'episode' is not a valid movie_kind for <Movie [u'Elementary S03E02']>\r\n2015-09-25 08:42:30,889 (7fac657fa700) :  INFO (logger:31) - subliminal.subtitle: Computed score 0 with matches set([])\r\n2015-09-25 08:42:30,890 (7fac657fa700) :  INFO (logger:31) - subliminal.subtitle: Computed score 34 with matches set([u'hash'])\r\n2015-09-25 08:42:30,890 (7fac657fa700) :  INFO (logger:31) - subliminal.api: Downloading subtitle <TheSubDBSubtitle [en]> with score 34\r\n2015-09-25 08:42:31,027 (7fac657fa700) :  DEBUG (logger:21) - requests.packages.urllib3.connectionpool: \"GET /?action=download&hash=dc7bc77da2ba08f95ecf6f3530d20a23&language=en HTTP/1.1\" 200 68250\r\n2015-09-25 08:42:31,314 (7fac657fa700) :  INFO (logger:31) - subliminal.api: No subtitle with score >= 20\r\n2015-09-25 08:42:31,595 (7fac657fa700) :  DEBUG (__init__:88) - Saving subtitles as metadata\r\n2015-09-25 08:42:31,596 (7fac657fa700) :  CRITICAL (agentkit:1057) - Exception in the update function of agent named 'Subliminal TV Subtitles', called with guid 'com.plexapp.agents.thetvdb://255316/3/2?lang=sv' (most recent call last):\r\n  File \"bundles-release/Framework.bundle-dist/Contents/Resources/Versions/2/Python/Framework/api/agentkit.py\", line 1055, in _update\r\n  File \"/home/look2/Library/Application Support/Plex Media Server/Plug-ins/Subliminal.bundle/Contents/Code/__init__.py\", line 149, in update\r\n    saveSubtitles(videos, subtitles)\r\n  File \"/home/look2/Library/Application Support/Plex Media Server/Plug-ins/Subliminal.bundle/Contents/Code/__init__.py\", line 89, in saveSubtitles\r\n    saveSubtitlesToMetadata(videos, subtitles)\r\n  File \"/home/look2/Library/Application Support/Plex Media Server/Plug-ins/Subliminal.bundle/Contents/Code/__init__.py\", line 116, in saveSubtitlesToMetadata\r\n    mediaPart.subtitles[Locale.Language.Match(subtitle.language.alpha2)][subtitle.page_link] = Proxy.Media(subtitle.content, ext=\"srt\")\r\n  File \"bundles-release/Framework.bundle-dist/Contents/Resources/Versions/2/Python/Framework/api/agentkit.py\", line 237, in __setitem__\r\n  File \"bundles-release/Framework.bundle-dist/Contents/Resources/Versions/2/Python/Framework/api/agentkit.py\", line 220, in make_tuple\r\n  File \"bundles-release/Framework.bundle-dist/Contents/Resources/Versions/2/Python/Framework/components/data.py\", line 32, in sha1\r\n  File \"bundles-release/Framework.bundle-dist/Contents/Resources/Versions/2/Python/Framework/components/data.py\", line 22, in _generateHash\r\nTypeError: must be string or buffer, not None\r\n\r\n2015-09-25 08:42:31,598 (7fac657fa700) :  DEBUG (model:225) - Serializing to /home/look2/Library/Application Support/Plex Media Server/Metadata/TV Shows/3/d139bd90dac5b223a04b6b53191d8bc516d52c0.bundle/Contents/com.plexapp.agents.subliminal/Info.xml\r\n2015-09-25 08:42:31,599 (7fac657fa700) :  DEBUG (runtime:106) - Sending packed state data (110 bytes)\r\n2015-09-25 08:42:31,599 (7fac657fa700) :  DEBUG (runtime:918) - Response: [200] str, 16 bytes\r\n\r\n"},"comment":{"url":"https://api.github.com/repos/pannal/Subliminal.bundle/issues/comments/146871180","html_url":"https://github.com/pannal/Subliminal.bundle/issues/18#issuecomment-146871180","issue_url":"https://api.github.com/repos/pannal/Subliminal.bundle/issues/18","id":146871180,"user":{"login":"mrlook2","id":14833143,"avatar_url":"https://avatars.githubusercontent.com/u/14833143?v=3","gravatar_id":"","url":"https://api.github.com/users/mrlook2","html_url":"https://github.com/mrlook2","followers_url":"https://api.github.com/users/mrlook2/followers","following_url":"https://api.github.com/users/mrlook2/following{/other_user}","gists_url":"https://api.github.com/users/mrlook2/gists{/gist_id}","starred_url":"https://api.github.com/users/mrlook2/starred{/owner}{/repo}","subscriptions_url":"https://api.github.com/users/mrlook2/subscriptions","organizations_url":"https://api.github.com/users/mrlook2/orgs","repos_url":"https://api.github.com/users/mrlook2/repos","events_url":"https://api.github.com/users/mrlook2/events{/privacy}","received_events_url":"https://api.github.com/users/mrlook2/received_events","type":"User","site_admin":false},"created_at":"2015-10-09T13:26:01Z","updated_at":"2015-10-09T13:26:01Z","body":"YEAH! it's working now... \r\nDo I need a user for open subtitles? Or can't I download subtitles from that site without a username ?"}}