﻿2013-12-16 21:29:02,421 (d60) :  INFO (core:336) - Starting framework core - Version: 2.3.12, Build: bd749cb (Mon Nov 18 18:57:02 UTC 2013)
2013-12-16 21:29:02,421 (d60) :  DEBUG (core:348) - Using the elevated policy
2013-12-16 21:29:02,421 (d60) :  DEBUG (core:437) - Starting runtime component.
2013-12-16 21:29:02,421 (d60) :  DEBUG (core:437) - Starting caching component.
2013-12-16 21:29:02,421 (d60) :  DEBUG (core:437) - Starting data component.
2013-12-16 21:29:02,437 (d60) :  DEBUG (core:437) - Starting networking component.
2013-12-16 21:29:02,437 (d60) :  DEBUG (networking:318) - Loaded HTTP cookies
2013-12-16 21:29:02,437 (d60) :  DEBUG (networking:504) - Setting the default network timeout to 20.0
2013-12-16 21:29:02,437 (d60) :  DEBUG (core:437) - Starting localization component.
2013-12-16 21:29:02,437 (d60) :  INFO (localization:408) - Setting the default locale to en-us
2013-12-16 21:29:02,437 (d60) :  WARNING (data:186) - Error decoding with simplejson, using demjson instead (this will cause a performance hit) - Expecting property name: line 2 column 5 (char 6)
2013-12-16 21:29:02,467 (d60) :  DEBUG (localization:426) - Loaded en strings
2013-12-16 21:29:02,467 (d60) :  DEBUG (core:437) - Starting messaging component.
2013-12-16 21:29:02,467 (d60) :  DEBUG (core:437) - Starting debugging component.
2013-12-16 21:29:02,467 (d60) :  DEBUG (core:437) - Starting services component.
2013-12-16 21:29:02,467 (d60) :  DEBUG (core:437) - Starting myplex component.
2013-12-16 21:29:02,467 (d60) :  DEBUG (core:437) - Starting notifications component.
2013-12-16 21:29:02,483 (47c) :  DEBUG (networking:172) - Requesting 'http://127.0.0.1:32400/system/messaging/clear_events/info.mimediacenter.pelisalacarta'
2013-12-16 21:29:02,687 (d60) :  DEBUG (accessor:68) - Creating a new model access point for provider info.mimediacenter.pelisalacarta in namespace 'metadata'
2013-12-16 21:29:02,687 (d60) :  DEBUG (networking:172) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/resourceHashes'
2013-12-16 21:29:03,000 (498) :  DEBUG (services:265) - Plug-in is not daemonized - loading services from system
2013-12-16 21:29:03,000 (d60) :  DEBUG (runtime:1107) - Created a thread named 'load_all_services'
2013-12-16 21:29:03,000 (498) :  DEBUG (networking:172) - Requesting 'http://127.0.0.1:32400/:/plugins/com.plexapp.system/messaging/function/X0J1bmRsZVNlcnZpY2U6QWxsU2VydmljZXM_/Y2VyZWFsMQoxCmxpc3QKMApyMAo_/Y2VyZWFsMQoxCmRpY3QKMApyMAo_'
2013-12-16 21:29:03,000 (d60) :  DEBUG (runtime:1107) - Created a thread named 'get_server_info'
2013-12-16 21:29:03,000 (6ac) :  DEBUG (networking:172) - Requesting 'http://127.0.0.1:32400'
2013-12-16 21:29:03,000 (d60) :  DEBUG (core:149) - Finished starting framework core
2013-12-16 21:29:03,015 (d60) :  DEBUG (core:547) - Loading plug-in code
2013-12-16 21:29:03,125 (d60) :  DEBUG (core:553) - Finished loading plug-in code
2013-12-16 21:29:03,203 (d60) :  DEBUG (runtime:640) - Adding a prefix handler for 'Pelisalacarta' ('/video/pelisalacarta')
2013-12-16 21:29:03,217 (d60) :  DEBUG (runtime:640) - Adding a prefix handler for 'pelisalacarta' ('/video/pelisalacarta')
2013-12-16 21:29:03,217 (d60) :  INFO (core:598) - Started plug-in
2013-12-16 21:29:03,217 (d60) :  DEBUG (socketinterface:144) - Starting socket server
2013-12-16 21:29:03,265 (6ac) :  DEBUG (core:525) - Machine identifier is fbdfe1f6d35fe660ba5cd4a16d6cb38d41c8e66f
2013-12-16 21:29:03,280 (6ac) :  DEBUG (core:526) - Server version is 0.9.8.14.263-139ddbc
2013-12-16 21:29:03,296 (d60) :  DEBUG (runtime:1107) - Created a thread named 'start'
2013-12-16 21:29:03,312 (d60) :  INFO (socketinterface:168) - Socket server started on port 4642
2013-12-16 21:29:03,312 (d60) :  INFO (pipeinterface:25) - Entering run loop
2013-12-16 21:29:03,312 (d60) :  DEBUG (runtime:717) - Handling request GET /:/prefixes
2013-12-16 21:29:03,312 (d60) :  DEBUG (runtime:814) - Found route matching /:/prefixes
2013-12-16 21:29:03,608 (498) :  DEBUG (services:362) - Loaded services
2013-12-16 21:29:03,608 (b28) :  DEBUG (services:438) - No shared code to load
2013-12-16 21:29:03,625 (d60) :  DEBUG (runtime:914) - Response: [200] MediaContainer, 773 bytes
2013-12-16 21:29:03,703 (eb8) :  DEBUG (runtime:717) - Handling request GET /video/pelisalacarta/channels_list
2013-12-16 21:29:03,703 (eb8) :  DEBUG (runtime:814) - Found route matching /video/pelisalacarta/channels_list
2013-12-16 21:29:03,717 (eb8) :  WARNING (data:186) - Error decoding with simplejson, using demjson instead (this will cause a performance hit) - Expecting object: line 48 column 1 (char 4159)
2013-12-16 21:29:03,733 (eb8) :  DEBUG (preferences:256) - Loaded preferences from DefaultPrefs.json
2013-12-16 21:29:03,733 (eb8) :  DEBUG (preferences:178) - Loaded the user preferences for info.mimediacenter.pelisalacarta
2013-12-16 21:29:03,750 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x01886370>
2013-12-16 21:29:03,750 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0181F6D0>
2013-12-16 21:29:03,750 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,750 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0181F2F0>
2013-12-16 21:29:03,750 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,750 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0181F430>
2013-12-16 21:29:03,750 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,750 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0181F250>
2013-12-16 21:29:03,750 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,750 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0181F690>
2013-12-16 21:29:03,750 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,750 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0181F370>
2013-12-16 21:29:03,750 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,750 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0181F330>
2013-12-16 21:29:03,750 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,750 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0181F3B0>
2013-12-16 21:29:03,750 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,750 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0181F2B0>
2013-12-16 21:29:03,765 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,765 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0181F150>
2013-12-16 21:29:03,765 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,765 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0181F210>
2013-12-16 21:29:03,765 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,765 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0181F1B0>
2013-12-16 21:29:03,765 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,765 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0181F130>
2013-12-16 21:29:03,765 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,765 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187F930>
2013-12-16 21:29:03,765 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,765 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187F950>
2013-12-16 21:29:03,765 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,765 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187F710>
2013-12-16 21:29:03,765 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,765 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187F750>
2013-12-16 21:29:03,765 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,765 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187F290>
2013-12-16 21:29:03,765 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,780 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187F2D0>
2013-12-16 21:29:03,780 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,780 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187F2B0>
2013-12-16 21:29:03,780 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187FB70>
2013-12-16 21:29:03,780 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,780 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187FBB0>
2013-12-16 21:29:03,780 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,780 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187FB90>
2013-12-16 21:29:03,780 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,780 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187FF90>
2013-12-16 21:29:03,780 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,780 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187FFF0>
2013-12-16 21:29:03,780 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,780 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187FFD0>
2013-12-16 21:29:03,780 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,780 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187FFB0>
2013-12-16 21:29:03,780 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,780 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187FF10>
2013-12-16 21:29:03,780 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,796 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187FF70>
2013-12-16 21:29:03,796 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,796 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187FF50>
2013-12-16 21:29:03,796 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,796 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187FEB0>
2013-12-16 21:29:03,796 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,796 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187FEF0>
2013-12-16 21:29:03,796 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,796 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187FE30>
2013-12-16 21:29:03,796 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,796 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187FE90>
2013-12-16 21:29:03,796 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,796 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187FE70>
2013-12-16 21:29:03,796 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,796 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187FDD0>
2013-12-16 21:29:03,796 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,796 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187FE10>
2013-12-16 21:29:03,796 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,796 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187FD90>
2013-12-16 21:29:03,796 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,812 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187FD10>
2013-12-16 21:29:03,812 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,812 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187FD70>
2013-12-16 21:29:03,812 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,812 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187FD50>
2013-12-16 21:29:03,812 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,812 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187FCB0>
2013-12-16 21:29:03,812 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,812 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187FCF0>
2013-12-16 21:29:03,812 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187FCD0>
2013-12-16 21:29:03,812 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187FBD0>
2013-12-16 21:29:03,812 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,812 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187FC90>
2013-12-16 21:29:03,812 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,812 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187FC70>
2013-12-16 21:29:03,812 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,812 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187FC50>
2013-12-16 21:29:03,812 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,812 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187FC30>
2013-12-16 21:29:03,812 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,828 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187FC10>
2013-12-16 21:29:03,828 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,828 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187FBF0>
2013-12-16 21:29:03,828 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,828 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187FB30>
2013-12-16 21:29:03,828 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,828 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187FB50>
2013-12-16 21:29:03,828 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,828 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187FAD0>
2013-12-16 21:29:03,828 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,828 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187FB10>
2013-12-16 21:29:03,828 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,828 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187FA70>
2013-12-16 21:29:03,828 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,828 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187FAB0>
2013-12-16 21:29:03,828 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,828 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187F9F0>
2013-12-16 21:29:03,828 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,828 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187FA50>
2013-12-16 21:29:03,842 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,842 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187FA30>
2013-12-16 21:29:03,842 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,842 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187F970>
2013-12-16 21:29:03,842 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,842 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187F9D0>
2013-12-16 21:29:03,842 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187F9B0>
2013-12-16 21:29:03,842 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187F850>
2013-12-16 21:29:03,842 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,842 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187F890>
2013-12-16 21:29:03,842 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,842 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187F7F0>
2013-12-16 21:29:03,842 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,842 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187F830>
2013-12-16 21:29:03,842 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,842 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187F7B0>
2013-12-16 21:29:03,842 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,842 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187F7D0>
2013-12-16 21:29:03,858 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,858 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187F770>
2013-12-16 21:29:03,858 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187F790>
2013-12-16 21:29:03,858 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,858 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187F670>
2013-12-16 21:29:03,858 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,858 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187F6F0>
2013-12-16 21:29:03,858 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,858 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187F6D0>
2013-12-16 21:29:03,858 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,858 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187F6B0>
2013-12-16 21:29:03,858 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,858 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187F5F0>
2013-12-16 21:29:03,858 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,858 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187F650>
2013-12-16 21:29:03,858 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,858 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187F630>
2013-12-16 21:29:03,858 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,858 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187F570>
2013-12-16 21:29:03,858 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187F5D0>
2013-12-16 21:29:03,858 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,858 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187F5B0>
2013-12-16 21:29:03,858 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,858 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187F510>
2013-12-16 21:29:03,858 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,858 (eb8) :  INFO (logkit:16) - item=<core.item.Item object at 0x0187F550>
2013-12-16 21:29:03,875 (eb8) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:03,875 (eb8) :  DEBUG (runtime:106) - Sending packed state data (113 bytes)
2013-12-16 21:29:03,875 (eb8) :  DEBUG (runtime:914) - Response: [200] MediaContainer, 20321 bytes
2013-12-16 21:29:12,250 (904) :  DEBUG (runtime:717) - Handling request GET /video/pelisalacarta/:/function/canal?function_args=Y2VyZWFsMQoxCmRpY3QKMgpzOAptYWlubGlzdHM2CmFjdGlvbnMyNApwZWxpY3VsYXN5b25raXNfZ2VuZXJpY29zMTIKY2hhbm5lbF9uYW1lcjAK
2013-12-16 21:29:12,250 (904) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2013-12-16 21:29:12,296 (904) :  DEBUG (runtime:814) - Found route matching /video/pelisalacarta/:/function/canal
2013-12-16 21:29:12,312 (904) :  DEBUG (runtime:143) - Calling function 'canal'
2013-12-16 21:29:12,312 (904) :  INFO (logkit:16) - Entrando en canal para ejectuar peliculasyonkis_generico.mainlist
2013-12-16 21:29:12,312 (904) :  INFO (logkit:16) - caller_item_serialized=None
2013-12-16 21:29:12,312 (904) :  INFO (logkit:16) - caller_item=<core.item.Item object at 0x016F4F90>
2013-12-16 21:29:12,312 (904) :  INFO (logkit:16) - Importando...
2013-12-16 21:29:12,421 (904) :  INFO (logkit:16) - [scrapertools.py] init
2013-12-16 21:29:12,421 (904) :  INFO (logkit:16) - [scrapertools.py] CACHE_PATH=
2013-12-16 21:29:12,453 (904) :  INFO (logkit:16) - Importado
2013-12-16 21:29:12,453 (904) :  INFO (logkit:16) - Antes de hasattr
2013-12-16 21:29:12,453 (904) :  INFO (logkit:16) - El módulo peliculasyonkis_generico tiene una funcion mainlist
2013-12-16 21:29:12,453 (904) :  INFO (logkit:16) - [peliculasyonkis_generico.py] mainlist
2013-12-16 21:29:12,453 (904) :  INFO (logkit:16) - Tengo un itemlist con 5 elementos
2013-12-16 21:29:12,453 (904) :  INFO (logkit:16) - item=title=[Utimas Peliculas], url=[http://www.peliculasyonkis.com/ultimas-peliculas], thumbnail=[], action=[lastepisodes], show=[], category=[]
2013-12-16 21:29:12,453 (904) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:12,453 (904) :  INFO (logkit:16) - item=title=[Listado alfabetico], url=[http://www.peliculasyonkis.com/lista-de-peliculas], thumbnail=[], action=[listalfabetico], show=[], category=[]
2013-12-16 21:29:12,453 (904) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:12,453 (904) :  INFO (logkit:16) - item=title=[Listado por Categorias], url=[http://www.peliculasyonkis.com/], thumbnail=[], action=[listcategorias], show=[], category=[]
2013-12-16 21:29:12,453 (904) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:12,453 (904) :  INFO (logkit:16) - item=title=[Peliculas mas vistas], url=[http://www.peliculasyonkis.com/peliculas-mas-vistas], thumbnail=[], action=[mostviewed], show=[], category=[]
2013-12-16 21:29:12,453 (904) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:12,467 (904) :  INFO (logkit:16) - item=title=[Buscar...], url=[http://www.peliculasyonkis.com/buscar/pelicula], thumbnail=[], action=[search], show=[], category=[]
2013-12-16 21:29:12,467 (904) :  WARNING (runtime:1055) - Generating a callback path for a function with no route: <function canal at 0x0173E0B0>
2013-12-16 21:29:12,467 (904) :  DEBUG (runtime:106) - Sending packed state data (113 bytes)
2013-12-16 21:29:12,467 (904) :  DEBUG (runtime:914) - Response: [200] MediaContainer, 2872 bytes
2013-12-16 21:29:15,280 (aa8) :  DEBUG (runtime:717) - Handling request GET /video/pelisalacarta/:/function/canal?function_args=Y2VyZWFsMQoxCmRpY3QKMwpzMTIKbGFzdGVwaXNvZGVzczYKYWN0aW9uczI0CnBlbGljdWxhc3lvbmtpc19nZW5lcmljb3MxMgpjaGFubmVsX25hbWV1MTY1ClV0aW1hcyBQZWxpY3VsYXN8Pnw8fGh0dHA6Ly93d3cucGVsaWN1bGFzeW9ua2lzLmNvbS91bHRpbWFzLXBlbGljdWxhc3w%2AfDx8cGVsaWN1bGFzeW9ua2lzX2dlbmVyaWNvfD58PHxsYXN0ZXBpc29kZXN8Pnw8fGRpcmVjdG98Pnw8fHw%2AfDx8fD58PHx8Pnw8fGxpc3R8Pnw8fFRydWV8Pnw8fHMyMgpjYWxsZXJfaXRlbV9zZXJpYWxpemVkcjAK
2013-12-16 21:29:15,280 (aa8) :  DEBUG (runtime:49) - Received packed state data (80 bytes)
2013-12-16 21:29:15,280 (aa8) :  DEBUG (runtime:814) - Found route matching /video/pelisalacarta/:/function/canal
2013-12-16 21:29:15,280 (aa8) :  DEBUG (runtime:143) - Calling function 'canal'
2013-12-16 21:29:15,280 (aa8) :  INFO (logkit:16) - Entrando en canal para ejectuar peliculasyonkis_generico.lastepisodes
2013-12-16 21:29:15,280 (aa8) :  INFO (logkit:16) - caller_item_serialized=Utimas Peliculas|>|<|http://www.peliculasyonkis.com/ultimas-peliculas|>|<|peliculasyonkis_generico|>|<|lastepisodes|>|<|directo|>|<||>|<||>|<||>|<|list|>|<|True|>|<|
2013-12-16 21:29:15,280 (aa8) :  INFO (logkit:16) - caller_item=<core.item.Item object at 0x017473D0>
2013-12-16 21:29:15,280 (aa8) :  INFO (logkit:16) - Importando...
2013-12-16 21:29:15,280 (aa8) :  INFO (logkit:16) - Importado
2013-12-16 21:29:15,280 (aa8) :  INFO (logkit:16) - Antes de hasattr
2013-12-16 21:29:15,280 (aa8) :  INFO (logkit:16) - El módulo peliculasyonkis_generico tiene una funcion lastepisodes
2013-12-16 21:29:15,280 (aa8) :  INFO (logkit:16) - [peliculasyonkis_generico.py] lastepisodes
2013-12-16 21:29:15,280 (aa8) :  INFO (logkit:16) - [scrapertools.py] cachePage url=http://www.peliculasyonkis.com/ultimas-peliculas
2013-12-16 21:29:15,280 (aa8) :  INFO (logkit:16) - [scrapertools.py] MODO_CACHE=2 (no cachear)
2013-12-16 21:29:15,296 (aa8) :  INFO (logkit:16) - [scrapertools.py] downloadpage
2013-12-16 21:29:15,296 (aa8) :  INFO (logkit:16) - [scrapertools.py] url=http://www.peliculasyonkis.com/ultimas-peliculas
2013-12-16 21:29:15,296 (aa8) :  INFO (logkit:16) - [scrapertools.py] post=None
2013-12-16 21:29:15,296 (aa8) :  INFO (logkit:16) - Tengo un itemlist con 0 elementos
2013-12-16 21:29:15,296 (aa8) :  DEBUG (runtime:106) - Sending packed state data (113 bytes)
2013-12-16 21:29:15,296 (aa8) :  DEBUG (runtime:914) - Response: [200] MediaContainer, 396 bytes
