2017-05-06 11:56:16,450 [INFO] [doorpi.main] ___ ___ _ / \___ ___ _ __ / _ (_) VoIP Door-Intercomstation with Raspberry Pi / /\ / _ \ / _ \| '__/ /_)/ | version: 2.5.1 / /_// (_) | (_) | | / ___/| | license: CC BY-NC 4.0 /___,' \___/ \___/|_| \/ |_| URL: Authors: Thomas Meissner Supporter: Phillip Munz Hermann Dötsch Dennis Häußler Hubert Nusser Michael Hauer Andreas Schwarz Max Rößler missing someone? -> sorry -> mail me 2017-05-06 11:56:16,451 [DEBUG] [doorpi.main] loaded with arguments: ['/usr/local/bin/doorpi_cli', '--trace'] 2017-05-06 11:56:16,452 [DEBUG] [doorpi.doorpi] run 2017-05-06 11:56:16,452 [DEBUG] [doorpi.doorpi] prepare 2017-05-06 11:56:16,453 [DEBUG] [doorpi.doorpi] given arguments argv: Namespace(configfile=None, debug=False, test=False, trace=True) 2017-05-06 11:56:16,456 [INFO] [doorpi.conf.config_object] use configfile: /usr/local/etc/DoorPi/conf/doorpi.ini 2017-05-06 11:56:16,478 [DEBUG] [doorpi.conf.config_object] __init__ 2017-05-06 11:56:16,479 [TRACE] [doorpi.conf.config_object] get_from_config 2017-05-06 11:56:16,487 [TRACE] [doorpi.conf.config_object] get_string for key base_path in section DoorPi (default: /usr/local/etc/DoorPi) returns /usr/local/etc/DoorPi 2017-05-06 11:56:16,488 [TRACE] [doorpi.conf.config_object] get_string for key eventlog in section DoorPi (default: !BASEPATH!/conf/eventlog.db) returns !BASEPATH!/conf/eventlog.db 2017-05-06 11:56:16,489 [DEBUG] [doorpi.conf.config_object] parse string "!BASEPATH!/conf/eventlog.db" to "/usr/local/etc/DoorPi/conf/eventlog.db" 2017-05-06 11:56:16,492 [TRACE] [doorpi.action.handler] register Event BeforeStartup from doorpi.doorpi 2017-05-06 11:56:16,493 [DEBUG] [doorpi.action.handler] event_source doorpi.doorpi was added 2017-05-06 11:56:16,493 [TRACE] [doorpi.action.handler] added event_name BeforeStartup and registered source doorpi.doorpi 2017-05-06 11:56:16,493 [TRACE] [doorpi.action.handler] register Event OnStartup from doorpi.doorpi 2017-05-06 11:56:16,494 [TRACE] [doorpi.action.handler] added event_name OnStartup and registered source doorpi.doorpi 2017-05-06 11:56:16,494 [TRACE] [doorpi.action.handler] register Event AfterStartup from doorpi.doorpi 2017-05-06 11:56:16,494 [TRACE] [doorpi.action.handler] added event_name AfterStartup and registered source doorpi.doorpi 2017-05-06 11:56:16,495 [TRACE] [doorpi.action.handler] register Event BeforeShutdown from doorpi.doorpi 2017-05-06 11:56:16,495 [TRACE] [doorpi.action.handler] added event_name BeforeShutdown and registered source doorpi.doorpi 2017-05-06 11:56:16,496 [TRACE] [doorpi.action.handler] register Event OnShutdown from doorpi.doorpi 2017-05-06 11:56:16,496 [TRACE] [doorpi.action.handler] added event_name OnShutdown and registered source doorpi.doorpi 2017-05-06 11:56:16,496 [TRACE] [doorpi.action.handler] register Event AfterShutdown from doorpi.doorpi 2017-05-06 11:56:16,497 [TRACE] [doorpi.action.handler] added event_name AfterShutdown and registered source doorpi.doorpi 2017-05-06 11:56:16,498 [DEBUG] [doorpi.action.SingleActions.time_tick] doorpi.action.SingleActions.time_tick loaded 2017-05-06 11:56:16,499 [DEBUG] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was added 2017-05-06 11:56:16,502 [TRACE] [doorpi.action.handler] action TimeTickDestroyAction with args () and kwargs {} was added to new evententry OnShutdown 2017-05-06 11:56:16,502 [TRACE] [doorpi.action.handler] action TimeTickAction with args ('!last_tick!',) and kwargs {} was added to new evententry OnTimeTick 2017-05-06 11:56:16,503 [TRACE] [doorpi.conf.config_object] get_string for key ip in section DoorPiWeb (default: ) returns 2017-05-06 11:56:16,503 [TRACE] [doorpi.conf.config_object] get_integer for key port in section DoorPiWeb (default: 80) returns 80 2017-05-06 11:56:16,506 [INFO] [doorpi.status.webserver] Initiating WebService at ip and port 80 2017-05-06 11:56:16,507 [TRACE] [doorpi.action.handler] register Event OnWebServerStart from doorpi.status.webserver 2017-05-06 11:56:16,508 [DEBUG] [doorpi.action.handler] event_source doorpi.status.webserver was added 2017-05-06 11:56:16,508 [TRACE] [doorpi.action.handler] added event_name OnWebServerStart and registered source doorpi.status.webserver 2017-05-06 11:56:16,508 [TRACE] [doorpi.action.handler] register Event OnWebServerStop from doorpi.status.webserver 2017-05-06 11:56:16,509 [TRACE] [doorpi.action.handler] added event_name OnWebServerStop and registered source doorpi.status.webserver 2017-05-06 11:56:16,509 [TRACE] [doorpi.conf.config_object] get_string for key www in section DoorPiWeb (default: !BASEPATH!/../DoorPiWeb) returns !BASEPATH!/../DoorPiWeb 2017-05-06 11:56:16,510 [DEBUG] [doorpi.conf.config_object] parse string "!BASEPATH!/../DoorPiWeb" to "/usr/local/etc/DoorPi/../DoorPiWeb" 2017-05-06 11:56:16,511 [TRACE] [doorpi.conf.config_object] get_string for key indexfile in section DoorPiWeb (default: index.html) returns index.html 2017-05-06 11:56:16,512 [DEBUG] [doorpi.conf.config_object] parse string "index.html" to "index.html" 2017-05-06 11:56:16,512 [TRACE] [doorpi.conf.config_object] get_string for key loginfile in section DoorPiWeb (default: login.html) returns login.html 2017-05-06 11:56:16,514 [DEBUG] [doorpi.conf.config_object] parse string "login.html" to "login.html" 2017-05-06 11:56:16,514 [TRACE] [doorpi.conf.config_object] get_string for key public in section DoorPiWeb (default: AREA_public) returns AREA_public 2017-05-06 11:56:16,515 [DEBUG] [doorpi.conf.config_object] parse string "AREA_public" to "AREA_public" 2017-05-06 11:56:16,515 [TRACE] [doorpi.conf.config_object] get_string for key online_fallback in section DoorPiWeb (default: http://motom001.github.io/DoorPiWeb) returns http://motom001.github.io/DoorPiWeb 2017-05-06 11:56:16,517 [DEBUG] [doorpi.conf.config_object] parse string "http://motom001.github.io/DoorPiWeb" to "http://motom001.github.io/DoorPiWeb" 2017-05-06 11:56:16,517 [TRACE] [doorpi.conf.config_object] get_keys for section WritePermission returns ['administrator'] 2017-05-06 11:56:16,517 [TRACE] [doorpi.conf.config_object] get_keys for section ReadPermission returns ['guests'] 2017-05-06 11:56:16,518 [TRACE] [doorpi.conf.config_object] get_keys for section Group returns ['administrator', 'guests'] 2017-05-06 11:56:16,518 [TRACE] [doorpi.conf.config_object] get_keys for section User returns ['visitor', 'door'] 2017-05-06 11:56:16,518 [TRACE] [doorpi.conf.config_object] get_list for key administrator in section Group (default: []) returns ['door'] 2017-05-06 11:56:16,519 [TRACE] [doorpi.conf.config_object] get_list for key guests in section Group (default: []) returns ['visitor'] 2017-05-06 11:56:16,519 [TRACE] [doorpi.conf.config_object] get_sections returns ['Group', 'ReadPermission', 'DTMF', 'EVENT_OnStartup', 'DoorPiWeb', 'AREA_public', 'vkboard_InputPins', 'WritePermission', 'vkboard_OutputPins', 'User', 'rfidreader_InputPins', 'rfidreader_keyboard', 'EVENT_OnFoundKnownTag', 'vkboard_keyboard', 'AREA_installer', 'rfidreader_OutputPins', 'AREA_status', 'onboardpins_OutputPins', 'onboardpins_keyboard', 'EVENT_OnKeyPressed_onboardpins.11', 'keyboards', 'AdminNumbers', 'SIP-Phone', 'EVENT_OnSipPhoneCallTimeoutNoResponse', 'onboardpins_InputPins', 'DoorPi'] 2017-05-06 11:56:16,520 [TRACE] [doorpi.conf.config_object] get_list for key administrator in section WritePermission (default: []) returns ['installer'] 2017-05-06 11:56:16,520 [TRACE] [doorpi.conf.config_object] get_list for key guests in section ReadPermission (default: []) returns ['status'] 2017-05-06 11:56:16,521 [TRACE] [doorpi.action.handler] action WebServerStartupAction with args () and kwargs {} was added to new evententry OnWebServerStart 2017-05-06 11:56:16,521 [TRACE] [doorpi.action.handler] action WebServerShutdownAction with args () and kwargs {} was added to event OnShutdown 2017-05-06 11:56:16,522 [TRACE] [doorpi.action.handler] fire Event OnWebServerStart from doorpi.status.webserver asyncron 2017-05-06 11:56:16,523 [TRACE] [doorpi.action.handler] register Event OnWebServerRequest from doorpi.status.webserver_lib.request_handler 2017-05-06 11:56:16,524 [DEBUG] [doorpi.action.handler] event_source doorpi.status.webserver_lib.request_handler was added 2017-05-06 11:56:16,524 [TRACE] [doorpi.action.handler] added event_name OnWebServerRequest and registered source doorpi.status.webserver_lib.request_handler 2017-05-06 11:56:16,525 [DEBUG] [doorpi.action.handler] [WVYQM7] fire for event OnWebServerStart this actions [] 2017-05-06 11:56:16,525 [TRACE] [doorpi.action.handler] register Event OnWebServerRequestGet from doorpi.status.webserver_lib.request_handler 2017-05-06 11:56:16,526 [TRACE] [doorpi.action.handler] [WVYQM7] try to fire action WebServerStartupAction with args () and kwargs {} 2017-05-06 11:56:16,526 [TRACE] [doorpi.action.handler] added event_name OnWebServerRequestGet and registered source doorpi.status.webserver_lib.request_handler 2017-05-06 11:56:16,527 [TRACE] [doorpi.action.base] run WebServerStartupAction with args () and kwargs {} 2017-05-06 11:56:16,527 [TRACE] [doorpi.action.handler] register Event OnWebServerRequestPost from doorpi.status.webserver_lib.request_handler 2017-05-06 11:56:16,528 [TRACE] [doorpi.action.handler] added event_name OnWebServerRequestPost and registered source doorpi.status.webserver_lib.request_handler 2017-05-06 11:56:16,528 [TRACE] [doorpi.action.handler] register Event OnWebServerVirtualResource from doorpi.status.webserver_lib.request_handler 2017-05-06 11:56:16,529 [TRACE] [doorpi.action.handler] added event_name OnWebServerVirtualResource and registered source doorpi.status.webserver_lib.request_handler 2017-05-06 11:56:16,529 [TRACE] [doorpi.action.handler] register Event OnWebServerRealResource from doorpi.status.webserver_lib.request_handler 2017-05-06 11:56:16,530 [TRACE] [doorpi.action.handler] added event_name OnWebServerRealResource and registered source doorpi.status.webserver_lib.request_handler 2017-05-06 11:56:16,530 [TRACE] [doorpi.action.handler] register Event OnFireEvent from doorpi.status.webserver_lib.request_handler 2017-05-06 11:56:16,530 [TRACE] [doorpi.action.handler] added event_name OnFireEvent and registered source doorpi.status.webserver_lib.request_handler 2017-05-06 11:56:16,531 [TRACE] [doorpi.action.handler] register Event OnConfigKeySet from doorpi.status.webserver_lib.request_handler 2017-05-06 11:56:16,531 [TRACE] [doorpi.action.handler] added event_name OnConfigKeySet and registered source doorpi.status.webserver_lib.request_handler 2017-05-06 11:56:16,531 [TRACE] [doorpi.action.handler] register Event OnConfigKeyDelete from doorpi.status.webserver_lib.request_handler 2017-05-06 11:56:16,532 [TRACE] [doorpi.action.handler] added event_name OnConfigKeyDelete and registered source doorpi.status.webserver_lib.request_handler 2017-05-06 11:56:16,532 [TRACE] [doorpi.conf.config_object] get_keys for section keyboards returns ['rfidreader', 'vkboard', 'onboardpins'] 2017-05-06 11:56:16,533 [INFO] [doorpi.keyboard.KeyboardInterface] using multi-keyboard mode (keyboards: rfidreader, vkboard, onboardpins) 2017-05-06 11:56:16,533 [INFO] [doorpi.keyboard.KeyboardInterface] trying to add keyboard 'rfidreader' to handler 2017-05-06 11:56:16,534 [TRACE] [doorpi.conf.config_object] get_string for key rfidreader in section keyboards (default: dummy) returns rdm6300 2017-05-06 11:56:16,534 [TRACE] [doorpi.conf.config_object] get_keys for section rfidreader_InputPins returns ['4895755', '4916638', '4915036', '5057884', '4983309'] 2017-05-06 11:56:16,534 [TRACE] [doorpi.conf.config_object] get_keys for section rfidreader_OutputPins returns [] 2017-05-06 11:56:16,535 [TRACE] [doorpi.conf.config_object] get_integer for key bouncetime in section rfidreader_keyboard (default: 2000) returns 2000.0 2017-05-06 11:56:16,535 [TRACE] [doorpi.conf.config_object] get_integer for key polarity in section rfidreader_keyboard (default: 0) returns 0 2017-05-06 11:56:16,536 [TRACE] [doorpi.conf.config_object] get_boolean for key pressed_on_keydown in section rfidreader_keyboard (default: True) returns True 2017-05-06 11:56:16,537 [DEBUG] [doorpi.keyboard.from_rdm6300] doorpi.keyboard.from_rdm6300 loaded 2017-05-06 11:56:16,555 [DEBUG] [doorpi.keyboard.from_rdm6300] __init__ (input_pins = ['4895755', '4916638', '4915036', '5057884', '4983309']) 2017-05-06 11:56:16,555 [TRACE] [doorpi.action.handler] register Event OnFoundTag from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,556 [DEBUG] [doorpi.action.handler] event_source doorpi.keyboard.from_rdm6300 was added 2017-05-06 11:56:16,556 [TRACE] [doorpi.action.handler] added event_name OnFoundTag and registered source doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,557 [TRACE] [doorpi.action.handler] register Event OnFoundUnknownTag from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,557 [TRACE] [doorpi.action.handler] added event_name OnFoundUnknownTag and registered source doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,557 [TRACE] [doorpi.action.handler] register Event OnFoundKnownTag from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,558 [TRACE] [doorpi.action.handler] added event_name OnFoundKnownTag and registered source doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,558 [TRACE] [doorpi.conf.config_object] get_string for key port in section rfidreader_keyboard (default: /dev/ttyAMA0) returns /dev/ttyAMA0 2017-05-06 11:56:16,559 [TRACE] [doorpi.conf.config_object] get_integer for key baudrate in section rfidreader_keyboard (default: 9600) returns 9600 2017-05-06 11:56:16,559 [TRACE] [doorpi.conf.config_object] get_integer for key dismisstime in section rfidreader_keyboard (default: 5) returns 5 2017-05-06 11:56:16,559 [TRACE] [doorpi.action.handler] register Event OnKeyPressed from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,560 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed and registered source doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,560 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_4895755 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,561 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_4895755 and registered source doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,561 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_rfidreader.4895755 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,561 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_rfidreader.4895755 and registered source doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,562 [TRACE] [doorpi.action.handler] register Event OnKeyUp from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,562 [TRACE] [doorpi.action.handler] added event_name OnKeyUp and registered source doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,563 [TRACE] [doorpi.action.handler] register Event OnKeyUp_4895755 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,563 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_4895755 and registered source doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,563 [TRACE] [doorpi.action.handler] register Event OnKeyUp_rfidreader.4895755 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,564 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_rfidreader.4895755 and registered source doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,564 [TRACE] [doorpi.action.handler] register Event OnKeyDown from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,564 [TRACE] [doorpi.action.handler] added event_name OnKeyDown and registered source doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,565 [TRACE] [doorpi.action.handler] register Event OnKeyDown_4895755 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,565 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_4895755 and registered source doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,566 [TRACE] [doorpi.action.handler] register Event OnKeyDown_rfidreader.4895755 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,566 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_rfidreader.4895755 and registered source doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,566 [TRACE] [doorpi.action.handler] register Event OnKeyPressed from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,567 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyPressed from source doorpi.keyboard.from_rdm6300 is already known 2017-05-06 11:56:16,567 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_4916638 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,567 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_4916638 and registered source doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,568 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_rfidreader.4916638 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,568 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_rfidreader.4916638 and registered source doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,568 [TRACE] [doorpi.action.handler] register Event OnKeyUp from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,569 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyUp from source doorpi.keyboard.from_rdm6300 is already known 2017-05-06 11:56:16,569 [TRACE] [doorpi.action.handler] register Event OnKeyUp_4916638 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,569 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_4916638 and registered source doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,570 [TRACE] [doorpi.action.handler] register Event OnKeyUp_rfidreader.4916638 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,570 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_rfidreader.4916638 and registered source doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,571 [TRACE] [doorpi.action.handler] register Event OnKeyDown from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,571 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyDown from source doorpi.keyboard.from_rdm6300 is already known 2017-05-06 11:56:16,571 [TRACE] [doorpi.action.handler] register Event OnKeyDown_4916638 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,572 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_4916638 and registered source doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,573 [TRACE] [doorpi.action.handler] register Event OnKeyDown_rfidreader.4916638 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,573 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_rfidreader.4916638 and registered source doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,574 [TRACE] [doorpi.action.handler] register Event OnKeyPressed from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,574 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyPressed from source doorpi.keyboard.from_rdm6300 is already known 2017-05-06 11:56:16,575 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_4915036 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,576 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_4915036 and registered source doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,576 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_rfidreader.4915036 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,577 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_rfidreader.4915036 and registered source doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,577 [TRACE] [doorpi.action.handler] register Event OnKeyUp from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,578 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyUp from source doorpi.keyboard.from_rdm6300 is already known 2017-05-06 11:56:16,578 [TRACE] [doorpi.action.handler] register Event OnKeyUp_4915036 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,579 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_4915036 and registered source doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,580 [TRACE] [doorpi.action.handler] register Event OnKeyUp_rfidreader.4915036 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,580 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_rfidreader.4915036 and registered source doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,581 [TRACE] [doorpi.action.handler] register Event OnKeyDown from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,581 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyDown from source doorpi.keyboard.from_rdm6300 is already known 2017-05-06 11:56:16,582 [TRACE] [doorpi.action.handler] register Event OnKeyDown_4915036 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,583 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_4915036 and registered source doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,583 [TRACE] [doorpi.action.handler] register Event OnKeyDown_rfidreader.4915036 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,584 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_rfidreader.4915036 and registered source doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,584 [TRACE] [doorpi.action.handler] register Event OnKeyPressed from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,585 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyPressed from source doorpi.keyboard.from_rdm6300 is already known 2017-05-06 11:56:16,585 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_5057884 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,586 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_5057884 and registered source doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,586 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_rfidreader.5057884 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,587 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_rfidreader.5057884 and registered source doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,588 [TRACE] [doorpi.action.handler] register Event OnKeyUp from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,588 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyUp from source doorpi.keyboard.from_rdm6300 is already known 2017-05-06 11:56:16,589 [TRACE] [doorpi.action.handler] register Event OnKeyUp_5057884 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,589 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_5057884 and registered source doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,590 [TRACE] [doorpi.action.handler] register Event OnKeyUp_rfidreader.5057884 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,590 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_rfidreader.5057884 and registered source doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,591 [TRACE] [doorpi.action.handler] register Event OnKeyDown from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,591 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyDown from source doorpi.keyboard.from_rdm6300 is already known 2017-05-06 11:56:16,592 [TRACE] [doorpi.action.handler] register Event OnKeyDown_5057884 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,593 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_5057884 and registered source doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,593 [TRACE] [doorpi.action.handler] register Event OnKeyDown_rfidreader.5057884 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,594 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_rfidreader.5057884 and registered source doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,594 [TRACE] [doorpi.action.handler] register Event OnKeyPressed from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,595 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyPressed from source doorpi.keyboard.from_rdm6300 is already known 2017-05-06 11:56:16,595 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_4983309 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,596 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_4983309 and registered source doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,596 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_rfidreader.4983309 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,597 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_rfidreader.4983309 and registered source doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,598 [TRACE] [doorpi.action.handler] register Event OnKeyUp from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,598 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyUp from source doorpi.keyboard.from_rdm6300 is already known 2017-05-06 11:56:16,599 [TRACE] [doorpi.action.handler] register Event OnKeyUp_4983309 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,599 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_4983309 and registered source doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,600 [TRACE] [doorpi.action.handler] register Event OnKeyUp_rfidreader.4983309 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,600 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_rfidreader.4983309 and registered source doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,601 [TRACE] [doorpi.action.handler] register Event OnKeyDown from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,601 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyDown from source doorpi.keyboard.from_rdm6300 is already known 2017-05-06 11:56:16,602 [TRACE] [doorpi.action.handler] register Event OnKeyDown_4983309 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,603 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_4983309 and registered source doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,603 [TRACE] [doorpi.action.handler] register Event OnKeyDown_rfidreader.4983309 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,604 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_rfidreader.4983309 and registered source doorpi.keyboard.from_rdm6300 2017-05-06 11:56:16,605 [DEBUG] [doorpi.keyboard.from_rdm6300] readUART() started 2017-05-06 11:56:16,606 [TRACE] [doorpi.action.handler] action KeyboardDestroyAction with args () and kwargs {} was added to event OnShutdown 2017-05-06 11:56:16,609 [TRACE] [doorpi.conf.config_object] get_keys for section rfidreader_OutputPins returns [] 2017-05-06 11:56:16,610 [INFO] [doorpi.keyboard.KeyboardInterface] trying to add keyboard 'vkboard' to handler 2017-05-06 11:56:16,611 [TRACE] [doorpi.conf.config_object] get_string for key vkboard in section keyboards (default: dummy) returns filesystem 2017-05-06 11:56:16,613 [TRACE] [doorpi.conf.config_object] get_keys for section vkboard_InputPins returns ['dooropen', 'internal', 'doorlock', 'external'] 2017-05-06 11:56:16,614 [TRACE] [doorpi.conf.config_object] get_keys for section vkboard_OutputPins returns [] 2017-05-06 11:56:16,615 [TRACE] [doorpi.conf.config_object] get_integer for key bouncetime in section vkboard_keyboard (default: 2000) returns 2000.0 2017-05-06 11:56:16,616 [TRACE] [doorpi.conf.config_object] get_integer for key polarity in section vkboard_keyboard (default: 0) returns 0 2017-05-06 11:56:16,616 [TRACE] [doorpi.conf.config_object] get_boolean for key pressed_on_keydown in section vkboard_keyboard (default: True) returns True 2017-05-06 11:56:16,618 [DEBUG] [doorpi.keyboard.from_filesystem] doorpi.keyboard.from_filesystem loaded 2017-05-06 11:56:16,701 [DEBUG] [doorpi.keyboard.from_filesystem] FileSystem.__init__(input_pins = ['dooropen', 'internal', 'doorlock', 'external'], output_pins = [], polarity = 0) 2017-05-06 11:56:16,703 [TRACE] [doorpi.conf.config_object] get_boolean for key reset_input in section vkboard_keyboard (default: True) returns True 2017-05-06 11:56:16,703 [TRACE] [doorpi.conf.config_object] get_string for key base_path_input in section vkboard_keyboard (default: ) returns /usr/local/etc/DoorPi/tools/ 2017-05-06 11:56:16,705 [DEBUG] [doorpi.conf.config_object] parse string "/usr/local/etc/DoorPi/tools/" to "/usr/local/etc/DoorPi/tools/" 2017-05-06 11:56:16,705 [TRACE] [doorpi.conf.config_object] get_string for key base_path_output in section vkboard_keyboard (default: ) returns /usr/local/etc/DoorPi/tools/ 2017-05-06 11:56:16,706 [DEBUG] [doorpi.conf.config_object] parse string "/usr/local/etc/DoorPi/tools/" to "/usr/local/etc/DoorPi/tools/" 2017-05-06 11:56:16,708 [TRACE] [doorpi.action.handler] register Event OnKeyPressed from doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,708 [DEBUG] [doorpi.action.handler] event_source doorpi.keyboard.from_filesystem was added 2017-05-06 11:56:16,708 [TRACE] [doorpi.action.handler] added event_source doorpi.keyboard.from_filesystem to existing event OnKeyPressed 2017-05-06 11:56:16,709 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_dooropen from doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,709 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_dooropen and registered source doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,710 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_vkboard.dooropen from doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,710 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_vkboard.dooropen and registered source doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,710 [TRACE] [doorpi.action.handler] register Event OnKeyUp from doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,711 [TRACE] [doorpi.action.handler] added event_source doorpi.keyboard.from_filesystem to existing event OnKeyUp 2017-05-06 11:56:16,711 [TRACE] [doorpi.action.handler] register Event OnKeyUp_dooropen from doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,711 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_dooropen and registered source doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,712 [TRACE] [doorpi.action.handler] register Event OnKeyUp_vkboard.dooropen from doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,712 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_vkboard.dooropen and registered source doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,713 [TRACE] [doorpi.action.handler] register Event OnKeyDown from doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,713 [TRACE] [doorpi.action.handler] added event_source doorpi.keyboard.from_filesystem to existing event OnKeyDown 2017-05-06 11:56:16,713 [TRACE] [doorpi.action.handler] register Event OnKeyDown_dooropen from doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,714 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_dooropen and registered source doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,714 [TRACE] [doorpi.action.handler] register Event OnKeyDown_vkboard.dooropen from doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,714 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_vkboard.dooropen and registered source doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,715 [TRACE] [doorpi.action.handler] register Event OnKeyPressed from doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,716 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyPressed from source doorpi.keyboard.from_filesystem is already known 2017-05-06 11:56:16,716 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_internal from doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,716 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_internal and registered source doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,717 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_vkboard.internal from doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,717 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_vkboard.internal and registered source doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,717 [TRACE] [doorpi.action.handler] register Event OnKeyUp from doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,718 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyUp from source doorpi.keyboard.from_filesystem is already known 2017-05-06 11:56:16,718 [TRACE] [doorpi.action.handler] register Event OnKeyUp_internal from doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,718 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_internal and registered source doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,719 [TRACE] [doorpi.action.handler] register Event OnKeyUp_vkboard.internal from doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,719 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_vkboard.internal and registered source doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,720 [TRACE] [doorpi.action.handler] register Event OnKeyDown from doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,720 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyDown from source doorpi.keyboard.from_filesystem is already known 2017-05-06 11:56:16,720 [TRACE] [doorpi.action.handler] register Event OnKeyDown_internal from doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,721 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_internal and registered source doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,721 [TRACE] [doorpi.action.handler] register Event OnKeyDown_vkboard.internal from doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,721 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_vkboard.internal and registered source doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,722 [TRACE] [doorpi.action.handler] register Event OnKeyPressed from doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,723 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyPressed from source doorpi.keyboard.from_filesystem is already known 2017-05-06 11:56:16,723 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_doorlock from doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,723 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_doorlock and registered source doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,724 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_vkboard.doorlock from doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,724 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_vkboard.doorlock and registered source doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,724 [TRACE] [doorpi.action.handler] register Event OnKeyUp from doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,725 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyUp from source doorpi.keyboard.from_filesystem is already known 2017-05-06 11:56:16,725 [TRACE] [doorpi.action.handler] register Event OnKeyUp_doorlock from doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,725 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_doorlock and registered source doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,726 [TRACE] [doorpi.action.handler] register Event OnKeyUp_vkboard.doorlock from doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,726 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_vkboard.doorlock and registered source doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,726 [TRACE] [doorpi.action.handler] register Event OnKeyDown from doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,727 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyDown from source doorpi.keyboard.from_filesystem is already known 2017-05-06 11:56:16,727 [TRACE] [doorpi.action.handler] register Event OnKeyDown_doorlock from doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,728 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_doorlock and registered source doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,728 [TRACE] [doorpi.action.handler] register Event OnKeyDown_vkboard.doorlock from doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,728 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_vkboard.doorlock and registered source doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,729 [TRACE] [doorpi.action.handler] register Event OnKeyPressed from doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,729 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyPressed from source doorpi.keyboard.from_filesystem is already known 2017-05-06 11:56:16,730 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_external from doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,730 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_external and registered source doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,730 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_vkboard.external from doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,731 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_vkboard.external and registered source doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,731 [TRACE] [doorpi.action.handler] register Event OnKeyUp from doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,732 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyUp from source doorpi.keyboard.from_filesystem is already known 2017-05-06 11:56:16,732 [TRACE] [doorpi.action.handler] register Event OnKeyUp_external from doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,733 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_external and registered source doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,733 [TRACE] [doorpi.action.handler] register Event OnKeyUp_vkboard.external from doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,733 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_vkboard.external and registered source doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,734 [TRACE] [doorpi.action.handler] register Event OnKeyDown from doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,734 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyDown from source doorpi.keyboard.from_filesystem is already known 2017-05-06 11:56:16,734 [TRACE] [doorpi.action.handler] register Event OnKeyDown_external from doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,735 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_external and registered source doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,735 [TRACE] [doorpi.action.handler] register Event OnKeyDown_vkboard.external from doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,735 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_vkboard.external and registered source doorpi.keyboard.from_filesystem 2017-05-06 11:56:16,740 [TRACE] [doorpi.action.handler] action KeyboardDestroyAction with args () and kwargs {} was added to event OnShutdown 2017-05-06 11:56:16,741 [TRACE] [doorpi.conf.config_object] get_keys for section vkboard_OutputPins returns [] 2017-05-06 11:56:16,741 [INFO] [doorpi.keyboard.KeyboardInterface] trying to add keyboard 'onboardpins' to handler 2017-05-06 11:56:16,742 [TRACE] [doorpi.conf.config_object] get_string for key onboardpins in section keyboards (default: dummy) returns gpio 2017-05-06 11:56:16,742 [TRACE] [doorpi.conf.config_object] get_keys for section onboardpins_InputPins returns ['11'] 2017-05-06 11:56:16,743 [TRACE] [doorpi.conf.config_object] get_keys for section onboardpins_OutputPins returns ['18', '16'] 2017-05-06 11:56:16,743 [TRACE] [doorpi.conf.config_object] get_integer for key bouncetime in section onboardpins_keyboard (default: 2000) returns 400.0 2017-05-06 11:56:16,744 [TRACE] [doorpi.conf.config_object] get_integer for key polarity in section onboardpins_keyboard (default: 0) returns 1 2017-05-06 11:56:16,744 [TRACE] [doorpi.conf.config_object] get_boolean for key pressed_on_keydown in section onboardpins_keyboard (default: True) returns True 2017-05-06 11:56:16,745 [DEBUG] [doorpi.keyboard.from_gpio] doorpi.keyboard.from_gpio loaded 2017-05-06 11:56:16,749 [DEBUG] [doorpi.keyboard.from_gpio] __init__(input_pins = ['11'], output_pins = ['18', '16'], bouncetime = 400.0, polarity = 1) 2017-05-06 11:56:16,750 [TRACE] [doorpi.conf.config_object] get_string for key mode in section onboardpins_keyboard (default: BOARD) returns BOARD 2017-05-06 11:56:16,750 [TRACE] [doorpi.conf.config_object] get_string for key pull_up_down in section onboardpins_keyboard (default: PUD_OFF) returns PUD_UP 2017-05-06 11:56:16,752 [TRACE] [doorpi.action.handler] register Event OnKeyPressed from doorpi.keyboard.from_gpio 2017-05-06 11:56:16,753 [DEBUG] [doorpi.action.handler] event_source doorpi.keyboard.from_gpio was added 2017-05-06 11:56:16,753 [TRACE] [doorpi.action.handler] added event_source doorpi.keyboard.from_gpio to existing event OnKeyPressed 2017-05-06 11:56:16,754 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_11 from doorpi.keyboard.from_gpio 2017-05-06 11:56:16,754 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_11 and registered source doorpi.keyboard.from_gpio 2017-05-06 11:56:16,755 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_onboardpins.11 from doorpi.keyboard.from_gpio 2017-05-06 11:56:16,756 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_onboardpins.11 and registered source doorpi.keyboard.from_gpio 2017-05-06 11:56:16,756 [TRACE] [doorpi.action.handler] register Event OnKeyUp from doorpi.keyboard.from_gpio 2017-05-06 11:56:16,757 [TRACE] [doorpi.action.handler] added event_source doorpi.keyboard.from_gpio to existing event OnKeyUp 2017-05-06 11:56:16,757 [TRACE] [doorpi.action.handler] register Event OnKeyUp_11 from doorpi.keyboard.from_gpio 2017-05-06 11:56:16,758 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_11 and registered source doorpi.keyboard.from_gpio 2017-05-06 11:56:16,759 [TRACE] [doorpi.action.handler] register Event OnKeyUp_onboardpins.11 from doorpi.keyboard.from_gpio 2017-05-06 11:56:16,759 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_onboardpins.11 and registered source doorpi.keyboard.from_gpio 2017-05-06 11:56:16,760 [TRACE] [doorpi.action.handler] register Event OnKeyDown from doorpi.keyboard.from_gpio 2017-05-06 11:56:16,760 [TRACE] [doorpi.action.handler] added event_source doorpi.keyboard.from_gpio to existing event OnKeyDown 2017-05-06 11:56:16,761 [TRACE] [doorpi.action.handler] register Event OnKeyDown_11 from doorpi.keyboard.from_gpio 2017-05-06 11:56:16,761 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_11 and registered source doorpi.keyboard.from_gpio 2017-05-06 11:56:16,762 [TRACE] [doorpi.action.handler] register Event OnKeyDown_onboardpins.11 from doorpi.keyboard.from_gpio 2017-05-06 11:56:16,763 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_onboardpins.11 and registered source doorpi.keyboard.from_gpio 2017-05-06 11:56:16,766 [TRACE] [doorpi.action.handler] action KeyboardDestroyAction with args () and kwargs {} was added to event OnShutdown 2017-05-06 11:56:16,767 [TRACE] [doorpi.conf.config_object] get_keys for section onboardpins_OutputPins returns ['18', '16'] 2017-05-06 11:56:16,767 [TRACE] [doorpi.conf.config_object] get_string for key 18 in section onboardpins_OutputPins (default: ) returns Tueroeffner 2017-05-06 11:56:16,768 [TRACE] [doorpi.conf.config_object] get_string for key 16 in section onboardpins_OutputPins (default: ) returns Tuerschliesser 2017-05-06 11:56:16,770 [DEBUG] [doorpi.status.status_lib.environment] doorpi.status.status_lib.environment loaded 2017-05-06 11:56:16,772 [DEBUG] [doorpi.status.requirements_lib.req_config] doorpi.status.requirements_lib.req_config loaded 2017-05-06 11:56:16,774 [DEBUG] [doorpi.status.requirements_lib.req_sipphone] doorpi.status.requirements_lib.req_sipphone loaded 2017-05-06 11:56:16,776 [DEBUG] [doorpi.sipphone.AbstractBaseClass] doorpi.sipphone.AbstractBaseClass loaded 2017-05-06 11:56:16,823 [DEBUG] [doorpi.status.requirements_lib.req_event_handler] doorpi.status.requirements_lib.req_event_handler loaded 2017-05-06 11:56:16,825 [DEBUG] [doorpi.status.requirements_lib.req_webserver] doorpi.status.requirements_lib.req_webserver loaded 2017-05-06 11:56:16,828 [DEBUG] [doorpi.status.requirements_lib.req_keyboard] doorpi.status.requirements_lib.req_keyboard loaded 2017-05-06 11:56:16,848 [DEBUG] [doorpi.status.requirements_lib.req_system] doorpi.status.requirements_lib.req_system loaded 2017-05-06 11:56:16,854 [INFO] [doorpi.sipphone.SipphoneInterface] found installed sipphone "linphone" and use this as default 2017-05-06 11:56:16,855 [TRACE] [doorpi.conf.config_object] get_string for key sipphonetyp in section SIP-Phone (default: linphone) returns linphone 2017-05-06 11:56:16,857 [DEBUG] [doorpi.sipphone.from_linphone] doorpi.sipphone.from_linphone loaded 2017-05-06 11:56:16,860 [DEBUG] [doorpi.sipphone.linphone_lib.CallBacks] doorpi.sipphone.linphone_lib.CallBacks loaded 2017-05-06 11:56:16,862 [DEBUG] [doorpi.sipphone.linphone_lib.Player] doorpi.sipphone.linphone_lib.Player loaded 2017-05-06 11:56:16,864 [DEBUG] [doorpi.sipphone.linphone_lib.Recorder] doorpi.sipphone.linphone_lib.Recorder loaded 2017-05-06 11:56:16,865 [DEBUG] [doorpi.sipphone.from_linphone] __init__ 2017-05-06 11:56:16,866 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to event OnShutdown 2017-05-06 11:56:16,866 [TRACE] [doorpi.action.handler] register Event OnSipPhoneCreate from doorpi.sipphone.from_linphone 2017-05-06 11:56:16,866 [DEBUG] [doorpi.action.handler] event_source doorpi.sipphone.from_linphone was added 2017-05-06 11:56:16,867 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneCreate and registered source doorpi.sipphone.from_linphone 2017-05-06 11:56:16,867 [TRACE] [doorpi.action.handler] register Event OnSipPhoneStart from doorpi.sipphone.from_linphone 2017-05-06 11:56:16,867 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneStart and registered source doorpi.sipphone.from_linphone 2017-05-06 11:56:16,868 [TRACE] [doorpi.action.handler] register Event OnSipPhoneDestroy from doorpi.sipphone.from_linphone 2017-05-06 11:56:16,868 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneDestroy and registered source doorpi.sipphone.from_linphone 2017-05-06 11:56:16,869 [TRACE] [doorpi.action.handler] register Event OnSipPhoneRecorderCreate from doorpi.sipphone.from_linphone 2017-05-06 11:56:16,869 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneRecorderCreate and registered source doorpi.sipphone.from_linphone 2017-05-06 11:56:16,869 [TRACE] [doorpi.action.handler] register Event OnSipPhoneRecorderDestroy from doorpi.sipphone.from_linphone 2017-05-06 11:56:16,870 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneRecorderDestroy and registered source doorpi.sipphone.from_linphone 2017-05-06 11:56:16,870 [TRACE] [doorpi.action.handler] register Event BeforeSipPhoneMakeCall from doorpi.sipphone.from_linphone 2017-05-06 11:56:16,870 [TRACE] [doorpi.action.handler] added event_name BeforeSipPhoneMakeCall and registered source doorpi.sipphone.from_linphone 2017-05-06 11:56:16,871 [TRACE] [doorpi.action.handler] register Event OnSipPhoneMakeCall from doorpi.sipphone.from_linphone 2017-05-06 11:56:16,871 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneMakeCall and registered source doorpi.sipphone.from_linphone 2017-05-06 11:56:16,871 [TRACE] [doorpi.action.handler] register Event OnSipPhoneMakeCallFailed from doorpi.sipphone.from_linphone 2017-05-06 11:56:16,872 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneMakeCallFailed and registered source doorpi.sipphone.from_linphone 2017-05-06 11:56:16,872 [TRACE] [doorpi.action.handler] register Event AfterSipPhoneMakeCall from doorpi.sipphone.from_linphone 2017-05-06 11:56:16,873 [TRACE] [doorpi.action.handler] added event_name AfterSipPhoneMakeCall and registered source doorpi.sipphone.from_linphone 2017-05-06 11:56:16,873 [TRACE] [doorpi.action.handler] register Event OnSipPhoneCallTimeoutNoResponse from doorpi.sipphone.from_linphone 2017-05-06 11:56:16,873 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneCallTimeoutNoResponse and registered source doorpi.sipphone.from_linphone 2017-05-06 11:56:16,874 [TRACE] [doorpi.action.handler] register Event OnSipPhoneCallTimeoutMaxCalltime from doorpi.sipphone.from_linphone 2017-05-06 11:56:16,874 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneCallTimeoutMaxCalltime and registered source doorpi.sipphone.from_linphone 2017-05-06 11:56:16,875 [TRACE] [doorpi.action.handler] register Event OnPlayerCreated from doorpi.sipphone.from_linphone 2017-05-06 11:56:16,875 [TRACE] [doorpi.action.handler] added event_name OnPlayerCreated and registered source doorpi.sipphone.from_linphone 2017-05-06 11:56:16,875 [DEBUG] [doorpi.sipphone.linphone_lib.CallBacks] __init__ 2017-05-06 11:56:16,876 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to new evententry OnSipPhoneDestroy 2017-05-06 11:56:16,876 [TRACE] [doorpi.action.handler] register Event OnCallMediaStateChange from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,877 [DEBUG] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was added 2017-05-06 11:56:16,877 [TRACE] [doorpi.action.handler] added event_name OnCallMediaStateChange and registered source doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,877 [TRACE] [doorpi.action.handler] register Event OnMediaRequired from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,878 [TRACE] [doorpi.action.handler] added event_name OnMediaRequired and registered source doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,878 [TRACE] [doorpi.action.handler] register Event OnMediaNotRequired from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,878 [TRACE] [doorpi.action.handler] added event_name OnMediaNotRequired and registered source doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,879 [TRACE] [doorpi.action.handler] register Event OnCallStateChange from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,879 [TRACE] [doorpi.action.handler] added event_name OnCallStateChange and registered source doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,879 [TRACE] [doorpi.action.handler] register Event OnCallStateConnect from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,880 [TRACE] [doorpi.action.handler] added event_name OnCallStateConnect and registered source doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,880 [TRACE] [doorpi.action.handler] register Event AfterCallStateConnect from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,880 [TRACE] [doorpi.action.handler] added event_name AfterCallStateConnect and registered source doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,881 [TRACE] [doorpi.action.handler] register Event OnCallStateDisconnect from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,881 [TRACE] [doorpi.action.handler] added event_name OnCallStateDisconnect and registered source doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,882 [TRACE] [doorpi.action.handler] register Event AfterCallStateDisconnect from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,882 [TRACE] [doorpi.action.handler] added event_name AfterCallStateDisconnect and registered source doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,882 [TRACE] [doorpi.action.handler] register Event OnCallStateDismissed from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,883 [TRACE] [doorpi.action.handler] added event_name OnCallStateDismissed and registered source doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,883 [TRACE] [doorpi.action.handler] register Event OnCallStateReject from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,883 [TRACE] [doorpi.action.handler] added event_name OnCallStateReject and registered source doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,884 [TRACE] [doorpi.action.handler] register Event OnCallStart from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,884 [TRACE] [doorpi.action.handler] added event_name OnCallStart and registered source doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,885 [TRACE] [doorpi.action.handler] register Event OnDTMF from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,885 [TRACE] [doorpi.action.handler] added event_name OnDTMF and registered source doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,885 [TRACE] [doorpi.conf.config_object] get_keys for section DTMF returns ['"18"', '"16"'] 2017-05-06 11:56:16,886 [TRACE] [doorpi.action.handler] register Event OnDTMF_"18" from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,886 [TRACE] [doorpi.action.handler] added event_name OnDTMF_"18" and registered source doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,886 [TRACE] [doorpi.action.handler] register Event OnDTMF_"16" from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,887 [TRACE] [doorpi.action.handler] added event_name OnDTMF_"16" and registered source doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,887 [TRACE] [doorpi.action.handler] register Event OnCallStart from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,887 [TRACE] [doorpi.action.handler] nothing to do - event OnCallStart from source doorpi.sipphone.linphone_lib.CallBacks is already known 2017-05-06 11:56:16,888 [TRACE] [doorpi.action.handler] register Event BeforeCallIncoming from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,888 [TRACE] [doorpi.action.handler] added event_name BeforeCallIncoming and registered source doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,888 [TRACE] [doorpi.action.handler] register Event OnCallReconnect from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,889 [TRACE] [doorpi.action.handler] added event_name OnCallReconnect and registered source doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,889 [TRACE] [doorpi.action.handler] register Event AfterCallReconnect from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,890 [TRACE] [doorpi.action.handler] added event_name AfterCallReconnect and registered source doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,890 [TRACE] [doorpi.action.handler] register Event OnCallBusy from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,890 [TRACE] [doorpi.action.handler] added event_name OnCallBusy and registered source doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,891 [TRACE] [doorpi.action.handler] register Event AfterCallBusy from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,891 [TRACE] [doorpi.action.handler] added event_name AfterCallBusy and registered source doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,891 [TRACE] [doorpi.action.handler] register Event OnCallIncoming from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,892 [TRACE] [doorpi.action.handler] added event_name OnCallIncoming and registered source doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,892 [TRACE] [doorpi.action.handler] register Event AfterCallIncoming from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,893 [TRACE] [doorpi.action.handler] added event_name AfterCallIncoming and registered source doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,893 [TRACE] [doorpi.action.handler] register Event OnCallReject from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,894 [TRACE] [doorpi.action.handler] added event_name OnCallReject and registered source doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,894 [TRACE] [doorpi.action.handler] register Event AfterCallReject from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,894 [TRACE] [doorpi.action.handler] added event_name AfterCallReject and registered source doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,895 [TRACE] [doorpi.action.handler] fire Event OnCallStart from doorpi.sipphone.linphone_lib.CallBacks asyncron 2017-05-06 11:56:16,896 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_new() 2017-05-06 11:56:16,897 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_new -> 0x7e6a40 2017-05-06 11:56:16,898 [DEBUG] [doorpi.action.handler] no actions for event OnCallStart - skip fire_event OnCallStart from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:16,898 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_init() 2017-05-06 11:56:16,899 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_init -> 0x7e6a40 2017-05-06 11:56:16,899 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_class_method_new(0x83c1e0, "(null)", "(null)") 2017-05-06 11:56:16,900 [INFO] [doorpi.sipphone.from_linphone] Mediastreamer2 factory 2.12.0 (git: 3.9.0) initialized. 2017-05-06 11:56:16,900 [INFO] [doorpi.sipphone.from_linphone] CPU count set to 4 2017-05-06 11:56:16,901 [INFO] [doorpi.sipphone.from_linphone] ms_factory_init() done: platform_tags=linux,arm,embedded 2017-05-06 11:56:16,901 [INFO] [doorpi.sipphone.from_linphone] srtp init 2017-05-06 11:56:16,934 [INFO] [doorpi.sipphone.from_linphone] Registering all soundcard handlers 2017-05-06 11:56:17,010 [INFO] [doorpi.sipphone.from_linphone] Card 'ALSA: default device' added 2017-05-06 11:56:17,027 [INFO] [doorpi.sipphone.from_linphone] Card 'ALSA: USB PnP Sound Device' added 2017-05-06 11:56:17,029 [INFO] [doorpi.sipphone.from_linphone] also error in pcm_hw.c:1293 - open '/dev/snd/pcmC1D0c' failed (-2) 2017-05-06 11:56:17,032 [INFO] [doorpi.sipphone.from_linphone] Card 'ALSA: bcm2835 ALSA' added 2017-05-06 11:56:17,033 [INFO] [doorpi.sipphone.from_linphone] Registering all webcam handlers 2017-05-06 11:56:17,034 [INFO] [doorpi.sipphone.from_linphone] Webcam StaticImage: Static picture added 2017-05-06 11:56:17,034 [INFO] [doorpi.sipphone.from_linphone] ms_factory_init_voip() done 2017-05-06 11:56:17,035 [INFO] [doorpi.sipphone.from_linphone] Loading ms plugins from [./lib/mediastreamer/plugins] 2017-05-06 11:56:17,035 [INFO] [doorpi.sipphone.from_linphone] Cannot open directory ./lib/mediastreamer/plugins: No such file or directory 2017-05-06 11:56:17,036 [INFO] [doorpi.sipphone.from_linphone] Initializing LinphoneCore 3.9.0 2017-05-06 11:56:17,036 [INFO] [doorpi.sipphone.from_linphone] Vtable [0x72125540] registered on core [0x7210a288] 2017-05-06 11:56:17,037 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_callback_global_state_changed(0x72125540, 1, "Starting up") 2017-05-06 11:56:17,037 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_callback_global_state_changed 2017-05-06 11:56:17,038 [INFO] [doorpi.sipphone.from_linphone] Linphone core [0x72125540] notifying [global_state_changed] 2017-05-06 11:56:17,038 [INFO] [doorpi.sipphone.from_linphone] oRTP-0.25.0 initialized. 2017-05-06 11:56:17,038 [INFO] [doorpi.sipphone.from_linphone] Skiping ms_base_init, because [2] ref 2017-05-06 11:56:17,039 [INFO] [doorpi.sipphone.from_linphone] Skiping ms_voip_init, because [2] ref 2017-05-06 11:56:17,039 [INFO] [doorpi.sipphone.from_linphone] Skiping ms_plugins_init, because [2] ref 2017-05-06 11:56:17,040 [INFO] [doorpi.sipphone.from_linphone] Codec opus/48000 fmtp=[useinbandfec=1] number=-1, enabled=1) added to default capabilities. 2017-05-06 11:56:17,040 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for SILK 2017-05-06 11:56:17,040 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for SILK 2017-05-06 11:56:17,041 [INFO] [doorpi.sipphone.from_linphone] Codec speex/16000 fmtp=[vbr=on] number=-1, enabled=1) added to default capabilities. 2017-05-06 11:56:17,041 [INFO] [doorpi.sipphone.from_linphone] Codec speex/8000 fmtp=[vbr=on] number=-1, enabled=1) added to default capabilities. 2017-05-06 11:56:17,042 [INFO] [doorpi.sipphone.from_linphone] Codec PCMU/8000 fmtp=[] number=0, enabled=1) added to default capabilities. 2017-05-06 11:56:17,042 [INFO] [doorpi.sipphone.from_linphone] Codec PCMA/8000 fmtp=[] number=8, enabled=1) added to default capabilities. 2017-05-06 11:56:17,043 [INFO] [doorpi.sipphone.from_linphone] Codec t140/1000 fmtp=[] number=96, enabled=1) added to default capabilities. 2017-05-06 11:56:17,043 [INFO] [doorpi.sipphone.from_linphone] Codec red/1000 fmtp=[] number=97, enabled=1) added to default capabilities. 2017-05-06 11:56:17,044 [INFO] [doorpi.sipphone.from_linphone] Codec GSM/8000 fmtp=[] number=3, enabled=0) added to default capabilities. 2017-05-06 11:56:17,044 [INFO] [doorpi.sipphone.from_linphone] Codec G722/8000 fmtp=[] number=9, enabled=0) added to default capabilities. 2017-05-06 11:56:17,045 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for iLBC 2017-05-06 11:56:17,045 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for iLBC 2017-05-06 11:56:17,045 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for AMR 2017-05-06 11:56:17,046 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for AMR 2017-05-06 11:56:17,046 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for AMR-WB 2017-05-06 11:56:17,047 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for AMR-WB 2017-05-06 11:56:17,047 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for G729 2017-05-06 11:56:17,047 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for G729 2017-05-06 11:56:17,048 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for mpeg4-generic 2017-05-06 11:56:17,048 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for mpeg4-generic 2017-05-06 11:56:17,049 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for mpeg4-generic 2017-05-06 11:56:17,049 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for mpeg4-generic 2017-05-06 11:56:17,049 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for mpeg4-generic 2017-05-06 11:56:17,050 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for mpeg4-generic 2017-05-06 11:56:17,050 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for mpeg4-generic 2017-05-06 11:56:17,050 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for mpeg4-generic 2017-05-06 11:56:17,051 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for mpeg4-generic 2017-05-06 11:56:17,051 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for mpeg4-generic 2017-05-06 11:56:17,052 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for iSAC 2017-05-06 11:56:17,052 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for iSAC 2017-05-06 11:56:17,053 [INFO] [doorpi.sipphone.from_linphone] Codec speex/32000 fmtp=[vbr=on] number=-1, enabled=0) added to default capabilities. 2017-05-06 11:56:17,053 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for SILK 2017-05-06 11:56:17,053 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for SILK 2017-05-06 11:56:17,054 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for SILK 2017-05-06 11:56:17,054 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for SILK 2017-05-06 11:56:17,055 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for SILK 2017-05-06 11:56:17,055 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for SILK 2017-05-06 11:56:17,055 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for G726-16 2017-05-06 11:56:17,056 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for G726-16 2017-05-06 11:56:17,056 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for G726-24 2017-05-06 11:56:17,057 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for G726-24 2017-05-06 11:56:17,057 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for G726-32 2017-05-06 11:56:17,057 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for G726-32 2017-05-06 11:56:17,058 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for G726-40 2017-05-06 11:56:17,058 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for G726-40 2017-05-06 11:56:17,059 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for AAL2-G726-16 2017-05-06 11:56:17,059 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for AAL2-G726-16 2017-05-06 11:56:17,059 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for AAL2-G726-24 2017-05-06 11:56:17,060 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for AAL2-G726-24 2017-05-06 11:56:17,060 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for AAL2-G726-32 2017-05-06 11:56:17,061 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for AAL2-G726-32 2017-05-06 11:56:17,061 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for AAL2-G726-40 2017-05-06 11:56:17,062 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for AAL2-G726-40 2017-05-06 11:56:17,062 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for CODEC2 2017-05-06 11:56:17,063 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for CODEC2 2017-05-06 11:56:17,063 [INFO] [doorpi.sipphone.from_linphone] Codec VP8/90000 fmtp=[] number=-1, enabled=1) added to default capabilities. 2017-05-06 11:56:17,063 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for H264 2017-05-06 11:56:17,064 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for H264 2017-05-06 11:56:17,064 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for MP4V-ES 2017-05-06 11:56:17,064 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for H263-1998 2017-05-06 11:56:17,065 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for H263 2017-05-06 11:56:17,065 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for 1016 2017-05-06 11:56:17,066 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for 1016 2017-05-06 11:56:17,066 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for G723 2017-05-06 11:56:17,066 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for G723 2017-05-06 11:56:17,067 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for LPC 2017-05-06 11:56:17,067 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for LPC 2017-05-06 11:56:17,067 [INFO] [doorpi.sipphone.from_linphone] Codec L16/44100 fmtp=[] number=10, enabled=0) added to default capabilities. 2017-05-06 11:56:17,068 [INFO] [doorpi.sipphone.from_linphone] Codec L16/44100 fmtp=[] number=11, enabled=0) added to default capabilities. 2017-05-06 11:56:17,068 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for CN 2017-05-06 11:56:17,069 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for CN 2017-05-06 11:56:17,069 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for G729 2017-05-06 11:56:17,069 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for G729 2017-05-06 11:56:17,070 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for H261 2017-05-06 11:56:17,070 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for H261 2017-05-06 11:56:17,070 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for MPV 2017-05-06 11:56:17,071 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for MPV 2017-05-06 11:56:17,071 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for H263 2017-05-06 11:56:17,072 [INFO] [doorpi.sipphone.from_linphone] Sal nat helper [enabled] 2017-05-06 11:56:17,072 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2017-05-06 11:56:17,073 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2017-05-06 11:56:17,073 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2017-05-06 11:56:17,074 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_callback_configuring_status(0x72125540, 2, "(null)") 2017-05-06 11:56:17,074 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_callback_configuring_status 2017-05-06 11:56:17,074 [INFO] [doorpi.sipphone.from_linphone] Linphone core [0x72125540] notifying [configuring_status] 2017-05-06 11:56:17,075 [INFO] [doorpi.sipphone.from_linphone] Cannot open directory ./lib/liblinphone/plugins: No such file or directory 2017-05-06 11:56:17,075 [WARNING] [doorpi.sipphone.from_linphone] ./share/sounds/linphone/rings/oldphone.wav does not exist 2017-05-06 11:56:17,076 [INFO] [doorpi.sipphone.from_linphone] linphone_core_set_playback_gain_db(): no active call. 2017-05-06 11:56:17,076 [INFO] [doorpi.sipphone.from_linphone] linphone_core_set_mic_gain_db(): no active call. 2017-05-06 11:56:17,076 [INFO] [doorpi.sipphone.from_linphone] MTU is supposed to be 1300, rtp payload max size will be 1240 2017-05-06 11:56:17,077 [INFO] [doorpi.sipphone.from_linphone] Sal nat helper [enabled] 2017-05-06 11:56:17,077 [INFO] [doorpi.sipphone.from_linphone] Sal use rport [enabled] 2017-05-06 11:56:17,078 [INFO] [doorpi.sipphone.from_linphone] Supported codec opus/48000 fmtp=useinbandfec=1 automatically added to codec list. 2017-05-06 11:56:17,078 [INFO] [doorpi.sipphone.from_linphone] Supported codec speex/16000 fmtp=vbr=on automatically added to codec list. 2017-05-06 11:56:17,078 [INFO] [doorpi.sipphone.from_linphone] Supported codec speex/8000 fmtp=vbr=on automatically added to codec list. 2017-05-06 11:56:17,079 [INFO] [doorpi.sipphone.from_linphone] Supported codec PCMU/8000 fmtp= automatically added to codec list. 2017-05-06 11:56:17,079 [INFO] [doorpi.sipphone.from_linphone] Supported codec PCMA/8000 fmtp= automatically added to codec list. 2017-05-06 11:56:17,080 [INFO] [doorpi.sipphone.from_linphone] Supported codec GSM/8000 fmtp= automatically added to codec list. 2017-05-06 11:56:17,080 [INFO] [doorpi.sipphone.from_linphone] Supported codec G722/8000 fmtp= automatically added to codec list. 2017-05-06 11:56:17,080 [INFO] [doorpi.sipphone.from_linphone] Supported codec speex/32000 fmtp=vbr=on automatically added to codec list. 2017-05-06 11:56:17,081 [INFO] [doorpi.sipphone.from_linphone] Supported codec L16/44100 fmtp= automatically added to codec list. 2017-05-06 11:56:17,081 [INFO] [doorpi.sipphone.from_linphone] Supported codec L16/44100 fmtp= automatically added to codec list. 2017-05-06 11:56:17,081 [INFO] [doorpi.sipphone.from_linphone] Supported codec VP8/90000 fmtp= automatically added to codec list. 2017-05-06 11:56:17,082 [INFO] [doorpi.sipphone.from_linphone] Supported codec t140/1000 fmtp= automatically added to codec list. 2017-05-06 11:56:17,082 [INFO] [doorpi.sipphone.from_linphone] Supported codec red/1000 fmtp= automatically added to codec list. 2017-05-06 11:56:17,083 [INFO] [doorpi.sipphone.from_linphone] Sal use rport [enabled] 2017-05-06 11:56:17,083 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2017-05-06 11:56:17,084 [INFO] [doorpi.sipphone.from_linphone] sal_unlisten_ports done 2017-05-06 11:56:17,084 [INFO] [doorpi.sipphone.from_linphone] Creating listening point [0x7211d030] on [sip:0.0.0.0:5060;transport=UDP] 2017-05-06 11:56:17,085 [INFO] [doorpi.sipphone.from_linphone] Creating listening point [0x7211d240] on [sip:0.0.0.0:5060;transport=TCP] 2017-05-06 11:56:17,086 [INFO] [doorpi.sipphone.from_linphone] Creating listening point [0x7211d418] on [sip:0.0.0.0:-1;transport=TLS] 2017-05-06 11:56:17,086 [INFO] [doorpi.sipphone.from_linphone] Random TCP port is 56480 2017-05-06 11:56:17,087 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2017-05-06 11:56:17,087 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2017-05-06 11:56:17,091 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_callback_global_state_changed(0x72125540, 2, "Ready") 2017-05-06 11:56:17,091 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_callback_global_state_changed 2017-05-06 11:56:17,092 [INFO] [doorpi.sipphone.from_linphone] Linphone core [0x72125540] notifying [global_state_changed] 2017-05-06 11:56:17,092 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_class_method_new -> 0x7e6a40 2017-05-06 11:56:17,093 [TRACE] [doorpi.conf.config_object] get_string for key identity in section SIP-Phone (default: DoorPi) returns DoorPi 2017-05-06 11:56:17,093 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_primary_contact(0x7e6a40 [0x72125540], "DoorPi ") 2017-05-06 11:56:17,094 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_primary_contact -> 0 2017-05-06 11:56:17,095 [TRACE] [doorpi.action.handler] fire Event OnSipPhoneCreate from doorpi.sipphone.from_linphone asyncron 2017-05-06 11:56:17,096 [TRACE] [doorpi.conf.config_object] get_integer for key ua.max_calls in section SIP-Phone (default: 2) returns 2 2017-05-06 11:56:17,097 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_max_calls(0x7e6a40 [0x72125540], 2) 2017-05-06 11:56:17,097 [DEBUG] [doorpi.action.handler] no actions for event OnSipPhoneCreate - skip fire_event OnSipPhoneCreate from doorpi.sipphone.from_linphone 2017-05-06 11:56:17,098 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_max_calls -> 0 2017-05-06 11:56:17,099 [TRACE] [doorpi.conf.config_object] get_boolean for key echo_cancellation_enabled in section SIP-Phone (default: False) returns True 2017-05-06 11:56:17,099 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_enable_echo_cancellation(0x7e6a40 [0x72125540], 0x256958 [1]) 2017-05-06 11:56:17,100 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_enable_echo_cancellation -> 0 2017-05-06 11:56:17,100 [TRACE] [doorpi.conf.config_object] get_integer for key local_port in section SIP-Phone (default: 5060) returns 5060 2017-05-06 11:56:17,100 [TRACE] [doorpi.conf.config_object] get_integer for key local_port in section SIP-Phone (default: 5060) returns 5060 2017-05-06 11:56:17,101 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_SipTransports_new() 2017-05-06 11:56:17,101 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_SipTransports_new -> 0x7e6a58 2017-05-06 11:56:17,102 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_sip_transports(0x7e6a40 [0x72125540], 0x7e6a58 [0x7e6a60]) 2017-05-06 11:56:17,102 [INFO] [doorpi.sipphone.from_linphone] Listening point [0x7211d030] on [sip:0.0.0.0:5060;transport=UDP] destroyed 2017-05-06 11:56:17,103 [INFO] [doorpi.sipphone.from_linphone] Listening point [0x7211d240] on [sip:0.0.0.0:5060;transport=TCP] destroyed 2017-05-06 11:56:17,103 [INFO] [doorpi.sipphone.from_linphone] Listening point [0x7211d418] on [sip:0.0.0.0:56480;transport=TLS] destroyed 2017-05-06 11:56:17,104 [INFO] [doorpi.sipphone.from_linphone] sal_unlisten_ports done 2017-05-06 11:56:17,104 [INFO] [doorpi.sipphone.from_linphone] Creating listening point [0x835210] on [sip:0.0.0.0:5060;transport=UDP] 2017-05-06 11:56:17,105 [INFO] [doorpi.sipphone.from_linphone] Creating listening point [0x748460] on [sip:0.0.0.0:5060;transport=TCP] 2017-05-06 11:56:17,106 [INFO] [doorpi.sipphone.from_linphone] Creating listening point [0x797258] on [sip:0.0.0.0:-1;transport=TLS] 2017-05-06 11:56:17,106 [INFO] [doorpi.sipphone.from_linphone] Random TCP port is 33126 2017-05-06 11:56:17,107 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2017-05-06 11:56:17,107 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2017-05-06 11:56:17,107 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_sip_transports -> 0 2017-05-06 11:56:17,108 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_SipTransports_dealloc(0x7e6a58) 2017-05-06 11:56:17,108 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_SipTransports_dealloc 2017-05-06 11:56:17,109 [TRACE] [doorpi.conf.config_object] get_boolean for key video_display_enabled in section SIP-Phone (default: False) returns False 2017-05-06 11:56:17,109 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_enable_video_display(0x7e6a40 [0x72125540], 0x25694c [0]) 2017-05-06 11:56:17,110 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_enable_video_display -> 0 2017-05-06 11:56:17,110 [TRACE] [doorpi.conf.config_object] get_string for key stun_server in section SIP-Phone (default: ) returns 192.168.178.1 2017-05-06 11:56:17,110 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_stun_server(0x7e6a40 [0x72125540], "192.168.178.1") 2017-05-06 11:56:17,111 [INFO] [doorpi.sipphone.from_linphone] Stun server resolution successful. 2017-05-06 11:56:17,112 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_stun_server -> 0 2017-05-06 11:56:17,112 [DEBUG] [doorpi.conf.config_object] create new key FirewallPolicy in section SIP-Phone with value 'PolicyNoFirewall' 2017-05-06 11:56:17,113 [TRACE] [doorpi.conf.config_object] get_string for key FirewallPolicy in section SIP-Phone (default: PolicyNoFirewall) returns PolicyNoFirewall 2017-05-06 11:56:17,113 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_firewall_policy(0x7e6a40 [0x72125540], 0) 2017-05-06 11:56:17,113 [INFO] [doorpi.sipphone.from_linphone] Sal nat helper [enabled] 2017-05-06 11:56:17,114 [INFO] [doorpi.sipphone.from_linphone] Sal use rport [enabled] 2017-05-06 11:56:17,116 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_firewall_policy -> 0 2017-05-06 11:56:17,116 [TRACE] [doorpi.conf.config_object] get_integer for key max_call_time in section SIP-Phone (default: 120) returns 120 2017-05-06 11:56:17,117 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_in_call_timeout(0x7e6a40 [0x72125540], 120) 2017-05-06 11:56:17,117 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_in_call_timeout -> 0 2017-05-06 11:56:17,117 [TRACE] [doorpi.conf.config_object] get_integer for key call_timeout in section SIP-Phone (default: 15) returns 30 2017-05-06 11:56:17,118 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_inc_timeout(0x7e6a40 [0x72125540], 30) 2017-05-06 11:56:17,118 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_inc_timeout -> 0 2017-05-06 11:56:17,119 [TRACE] [doorpi.conf.config_object] get_string for key dialtone in section SIP-Phone (default: !BASEPATH!/media/ShortDialTone.wav) returns !BASEPATH!/doorpi/media/DOORBL.wav 2017-05-06 11:56:17,120 [DEBUG] [doorpi.conf.config_object] parse string "!BASEPATH!/doorpi/media/DOORBL.wav" to "/usr/local/etc/DoorPi/doorpi/media/DOORBL.wav" 2017-05-06 11:56:17,121 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to event OnSipPhoneDestroy 2017-05-06 11:56:17,122 [TRACE] [doorpi.conf.config_object] get_boolean for key dialtone_renew_every_start in section SIP-Phone (default: False) returns False 2017-05-06 11:56:17,123 [TRACE] [doorpi.action.handler] register Event OnPlayerStarted from doorpi.sipphone.linphone_lib.Player 2017-05-06 11:56:17,123 [DEBUG] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.Player was added 2017-05-06 11:56:17,124 [TRACE] [doorpi.action.handler] added event_name OnPlayerStarted and registered source doorpi.sipphone.linphone_lib.Player 2017-05-06 11:56:17,124 [TRACE] [doorpi.action.handler] register Event OnPlayerStopped from doorpi.sipphone.linphone_lib.Player 2017-05-06 11:56:17,124 [TRACE] [doorpi.action.handler] added event_name OnPlayerStopped and registered source doorpi.sipphone.linphone_lib.Player 2017-05-06 11:56:17,125 [TRACE] [doorpi.action.handler] register Event OnPlayerCreated from doorpi.sipphone.linphone_lib.Player 2017-05-06 11:56:17,125 [TRACE] [doorpi.action.handler] added event_source doorpi.sipphone.linphone_lib.Player to existing event OnPlayerCreated 2017-05-06 11:56:17,125 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to new evententry OnSipPhoneMakeCall 2017-05-06 11:56:17,126 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to new evententry OnCallStateConnect 2017-05-06 11:56:17,126 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to new evententry OnCallStateDisconnect 2017-05-06 11:56:17,127 [TRACE] [doorpi.action.handler] fire Event OnPlayerCreated from doorpi.sipphone.linphone_lib.Player asyncron 2017-05-06 11:56:17,128 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_ringback(0x7e6a40 [0x72125540], "/usr/local/etc/DoorPi/doorpi/media/DOORBL.wav") 2017-05-06 11:56:17,129 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_ringback -> 0 2017-05-06 11:56:17,129 [DEBUG] [doorpi.action.handler] no actions for event OnPlayerCreated - skip fire_event OnPlayerCreated from doorpi.sipphone.linphone_lib.Player 2017-05-06 11:56:17,129 [TRACE] [doorpi.conf.config_object] get_string for key records in section SIP-Phone (default: !BASEPATH!/records/%Y-%m-%d_%H-%M-%S.wav) returns !BASEPATH!/records/%Y-%m-%d_%H-%M-%S.wav 2017-05-06 11:56:17,130 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to event OnSipPhoneDestroy 2017-05-06 11:56:17,131 [TRACE] [doorpi.action.handler] register Event OnRecorderStarted from doorpi.sipphone.linphone_lib.Recorder 2017-05-06 11:56:17,131 [DEBUG] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.Recorder was added 2017-05-06 11:56:17,131 [TRACE] [doorpi.action.handler] added event_name OnRecorderStarted and registered source doorpi.sipphone.linphone_lib.Recorder 2017-05-06 11:56:17,132 [TRACE] [doorpi.action.handler] register Event OnRecorderStopped from doorpi.sipphone.linphone_lib.Recorder 2017-05-06 11:56:17,132 [TRACE] [doorpi.action.handler] added event_name OnRecorderStopped and registered source doorpi.sipphone.linphone_lib.Recorder 2017-05-06 11:56:17,133 [TRACE] [doorpi.action.handler] register Event OnRecorderCreated from doorpi.sipphone.linphone_lib.Recorder 2017-05-06 11:56:17,133 [TRACE] [doorpi.action.handler] added event_name OnRecorderCreated and registered source doorpi.sipphone.linphone_lib.Recorder 2017-05-06 11:56:17,133 [TRACE] [doorpi.conf.config_object] get_boolean for key record_while_dialing in section SIP-Phone (default: False) returns True 2017-05-06 11:56:17,134 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to event OnSipPhoneMakeCall 2017-05-06 11:56:17,134 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to event OnCallStateDisconnect 2017-05-06 11:56:17,135 [TRACE] [doorpi.action.handler] fire Event OnRecorderCreated from doorpi.sipphone.linphone_lib.Recorder asyncron 2017-05-06 11:56:17,136 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_sound_devices(0x7e6a40 [0x72125540]) 2017-05-06 11:56:17,136 [DEBUG] [doorpi.action.handler] no actions for event OnRecorderCreated - skip fire_event OnRecorderCreated from doorpi.sipphone.linphone_lib.Recorder 2017-05-06 11:56:17,137 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_sound_devices -> 0x83d800 2017-05-06 11:56:17,138 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_capture_device(0x7e6a40 [0x72125540]) 2017-05-06 11:56:17,138 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_capture_device -> 0x83acb0 2017-05-06 11:56:17,139 [TRACE] [doorpi.conf.config_object] get_string for key capture_device in section SIP-Phone (default: ALSA: default device) returns ALSA: USB PnP Sound Device 2017-05-06 11:56:17,139 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_capture_device(0x7e6a40 [0x72125540], "ALSA: USB PnP Sound Device") 2017-05-06 11:56:17,139 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_capture_device -> 0 2017-05-06 11:56:17,140 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_playback_device(0x7e6a40 [0x72125540]) 2017-05-06 11:56:17,140 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_playback_device -> 0x83ac80 2017-05-06 11:56:17,141 [TRACE] [doorpi.conf.config_object] get_string for key playback_device in section SIP-Phone (default: ALSA: default device) returns ALSA: USB PnP Sound Device 2017-05-06 11:56:17,141 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_playback_device(0x7e6a40 [0x72125540], "ALSA: USB PnP Sound Device") 2017-05-06 11:56:17,141 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_playback_device -> 0 2017-05-06 11:56:17,142 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_sound_devices(0x7e6a40 [0x72125540]) 2017-05-06 11:56:17,142 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_sound_devices -> 0x83d800 2017-05-06 11:56:17,143 [INFO] [doorpi.sipphone.from_linphone] found 3 possible sounddevices: 2017-05-06 11:56:17,143 [DEBUG] [doorpi.sipphone.from_linphone] |rec|play| name 2017-05-06 11:56:17,143 [DEBUG] [doorpi.sipphone.from_linphone] ------------------------------------ 2017-05-06 11:56:17,144 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_sound_devices(0x7e6a40 [0x72125540]) 2017-05-06 11:56:17,144 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_sound_devices -> 0x83d800 2017-05-06 11:56:17,144 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_sound_device_can_capture(0x7e6a40 [0x72125540], "ALSA: default device") 2017-05-06 11:56:17,145 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_sound_device_can_capture -> 0x256958 2017-05-06 11:56:17,145 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_sound_device_can_playback(0x7e6a40 [0x72125540], "ALSA: default device") 2017-05-06 11:56:17,146 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_sound_device_can_playback -> 0x256958 2017-05-06 11:56:17,146 [DEBUG] [doorpi.sipphone.from_linphone] | X | X | ALSA: default device 2017-05-06 11:56:17,146 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_sound_device_can_capture(0x7e6a40 [0x72125540], "ALSA: USB PnP Sound Device") 2017-05-06 11:56:17,147 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_sound_device_can_capture -> 0x256958 2017-05-06 11:56:17,147 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_sound_device_can_playback(0x7e6a40 [0x72125540], "ALSA: USB PnP Sound Device") 2017-05-06 11:56:17,147 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_sound_device_can_playback -> 0x256958 2017-05-06 11:56:17,148 [DEBUG] [doorpi.sipphone.from_linphone] | X | X | ALSA: USB PnP Sound Device 2017-05-06 11:56:17,148 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_sound_device_can_capture(0x7e6a40 [0x72125540], "ALSA: bcm2835 ALSA") 2017-05-06 11:56:17,149 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_sound_device_can_capture -> 0x25694c 2017-05-06 11:56:17,149 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_sound_device_can_playback(0x7e6a40 [0x72125540], "ALSA: bcm2835 ALSA") 2017-05-06 11:56:17,149 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_sound_device_can_playback -> 0x256958 2017-05-06 11:56:17,150 [DEBUG] [doorpi.sipphone.from_linphone] | O | X | ALSA: bcm2835 ALSA 2017-05-06 11:56:17,150 [DEBUG] [doorpi.sipphone.from_linphone] ------------------------------------ 2017-05-06 11:56:17,150 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_capture_device(0x7e6a40 [0x72125540]) 2017-05-06 11:56:17,151 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_capture_device -> 0x83ad40 2017-05-06 11:56:17,151 [DEBUG] [doorpi.sipphone.from_linphone] using capture_device: ALSA: USB PnP Sound Device 2017-05-06 11:56:17,152 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_playback_device(0x7e6a40 [0x72125540]) 2017-05-06 11:56:17,152 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_playback_device -> 0x83ad70 2017-05-06 11:56:17,152 [DEBUG] [doorpi.sipphone.from_linphone] using playback_device: ALSA: USB PnP Sound Device 2017-05-06 11:56:17,153 [TRACE] [doorpi.conf.config_object] get_list for key audio_codecs in section SIP-Phone (default: PCMA,PCMU) returns ['PCMA', 'PCMU'] 2017-05-06 11:56:17,153 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_audio_codecs(0x7e6a40 [0x72125540]) 2017-05-06 11:56:17,154 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0x72125250) 2017-05-06 11:56:17,154 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2017-05-06 11:56:17,154 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0x76d4a4e0 2017-05-06 11:56:17,155 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2017-05-06 11:56:17,155 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0x76d4a4e0 2017-05-06 11:56:17,155 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0x76d4a4e0 2017-05-06 11:56:17,156 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0x721252c0) 2017-05-06 11:56:17,156 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2017-05-06 11:56:17,157 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0x76d4a510 2017-05-06 11:56:17,157 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2017-05-06 11:56:17,157 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0x76d4a510 2017-05-06 11:56:17,158 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0x76d4a510 2017-05-06 11:56:17,158 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0x72125328) 2017-05-06 11:56:17,158 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2017-05-06 11:56:17,159 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0x76d4a520 2017-05-06 11:56:17,159 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2017-05-06 11:56:17,160 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0x76d4a520 2017-05-06 11:56:17,160 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0x76d4a520 2017-05-06 11:56:17,160 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0x72125390) 2017-05-06 11:56:17,161 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2017-05-06 11:56:17,161 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0x76d4a530 2017-05-06 11:56:17,162 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2017-05-06 11:56:17,162 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0x76d4a530 2017-05-06 11:56:17,163 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0x76d4a530 2017-05-06 11:56:17,163 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0x721253e8) 2017-05-06 11:56:17,163 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2017-05-06 11:56:17,164 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0x76d4a540 2017-05-06 11:56:17,164 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2017-05-06 11:56:17,164 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0x76d4a540 2017-05-06 11:56:17,165 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0x76d4a540 2017-05-06 11:56:17,165 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0x72125440) 2017-05-06 11:56:17,166 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2017-05-06 11:56:17,166 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0x76d4a550 2017-05-06 11:56:17,166 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2017-05-06 11:56:17,167 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0x76d4a550 2017-05-06 11:56:17,167 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0x76d4a550 2017-05-06 11:56:17,167 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0x72124d00) 2017-05-06 11:56:17,168 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2017-05-06 11:56:17,168 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0x76d4a560 2017-05-06 11:56:17,168 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2017-05-06 11:56:17,169 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0x76d4a560 2017-05-06 11:56:17,169 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0x76d4a560 2017-05-06 11:56:17,170 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0x72124d58) 2017-05-06 11:56:17,170 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2017-05-06 11:56:17,170 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0x76d4a570 2017-05-06 11:56:17,171 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2017-05-06 11:56:17,171 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0x76d4a570 2017-05-06 11:56:17,171 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0x76d4a570 2017-05-06 11:56:17,172 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0x72124dc0) 2017-05-06 11:56:17,172 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2017-05-06 11:56:17,173 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0x76d4a580 2017-05-06 11:56:17,173 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2017-05-06 11:56:17,173 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0x76d4a580 2017-05-06 11:56:17,174 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0x76d4a580 2017-05-06 11:56:17,174 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0x72124e18) 2017-05-06 11:56:17,175 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2017-05-06 11:56:17,175 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0x76d4a590 2017-05-06 11:56:17,175 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2017-05-06 11:56:17,176 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0x76d4a590 2017-05-06 11:56:17,176 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0x76d4a590 2017-05-06 11:56:17,176 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_audio_codecs -> 0x83d698 2017-05-06 11:56:17,177 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d4a4e0 [0x72125250]) 2017-05-06 11:56:17,177 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x806f60 2017-05-06 11:56:17,177 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d4a4e0 [0x72125250]) 2017-05-06 11:56:17,178 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x83e140 2017-05-06 11:56:17,178 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec opus 2017-05-06 11:56:17,179 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x7e6a40 [0x72125540], 0x76d4a4e0 [0x72125250], 0x25694c [0]) 2017-05-06 11:56:17,179 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x51f0bc 2017-05-06 11:56:17,180 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d4a510 [0x721252c0]) 2017-05-06 11:56:17,180 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x83e0a0 2017-05-06 11:56:17,180 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d4a510 [0x721252c0]) 2017-05-06 11:56:17,181 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x83e140 2017-05-06 11:56:17,181 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec speex 2017-05-06 11:56:17,182 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x7e6a40 [0x72125540], 0x76d4a510 [0x721252c0], 0x25694c [0]) 2017-05-06 11:56:17,182 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x51f0bc 2017-05-06 11:56:17,182 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d4a520 [0x72125328]) 2017-05-06 11:56:17,183 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x83e0a0 2017-05-06 11:56:17,183 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d4a520 [0x72125328]) 2017-05-06 11:56:17,184 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x83e140 2017-05-06 11:56:17,184 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec speex 2017-05-06 11:56:17,184 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x7e6a40 [0x72125540], 0x76d4a520 [0x72125328], 0x25694c [0]) 2017-05-06 11:56:17,185 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x51f0bc 2017-05-06 11:56:17,185 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d4a530 [0x72125390]) 2017-05-06 11:56:17,186 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x83e0a0 2017-05-06 11:56:17,186 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d4a530 [0x72125390]) 2017-05-06 11:56:17,186 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x83e140 2017-05-06 11:56:17,187 [DEBUG] [doorpi.sipphone.from_linphone] enable audio codec PCMU 2017-05-06 11:56:17,187 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x7e6a40 [0x72125540], 0x76d4a530 [0x72125390], 0x256958 [1]) 2017-05-06 11:56:17,188 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x51f0bc 2017-05-06 11:56:17,188 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d4a540 [0x721253e8]) 2017-05-06 11:56:17,188 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x83e0a0 2017-05-06 11:56:17,189 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d4a540 [0x721253e8]) 2017-05-06 11:56:17,189 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x83e140 2017-05-06 11:56:17,190 [DEBUG] [doorpi.sipphone.from_linphone] enable audio codec PCMA 2017-05-06 11:56:17,190 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x7e6a40 [0x72125540], 0x76d4a540 [0x721253e8], 0x256958 [1]) 2017-05-06 11:56:17,190 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x51f0bc 2017-05-06 11:56:17,191 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d4a550 [0x72125440]) 2017-05-06 11:56:17,191 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x7e6a58 2017-05-06 11:56:17,192 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d4a550 [0x72125440]) 2017-05-06 11:56:17,192 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x7e6a58 2017-05-06 11:56:17,192 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec GSM 2017-05-06 11:56:17,193 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x7e6a40 [0x72125540], 0x76d4a550 [0x72125440], 0x25694c [0]) 2017-05-06 11:56:17,193 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x51f0bc 2017-05-06 11:56:17,194 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d4a560 [0x72124d00]) 2017-05-06 11:56:17,194 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x83e0a0 2017-05-06 11:56:17,194 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d4a560 [0x72124d00]) 2017-05-06 11:56:17,195 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x83e140 2017-05-06 11:56:17,195 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec G722 2017-05-06 11:56:17,196 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x7e6a40 [0x72125540], 0x76d4a560 [0x72124d00], 0x25694c [0]) 2017-05-06 11:56:17,196 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x51f0bc 2017-05-06 11:56:17,197 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d4a570 [0x72124d58]) 2017-05-06 11:56:17,197 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x83e0a0 2017-05-06 11:56:17,197 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d4a570 [0x72124d58]) 2017-05-06 11:56:17,198 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x83e140 2017-05-06 11:56:17,198 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec speex 2017-05-06 11:56:17,198 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x7e6a40 [0x72125540], 0x76d4a570 [0x72124d58], 0x25694c [0]) 2017-05-06 11:56:17,199 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x51f0bc 2017-05-06 11:56:17,199 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d4a580 [0x72124dc0]) 2017-05-06 11:56:17,200 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x7e6a58 2017-05-06 11:56:17,200 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d4a580 [0x72124dc0]) 2017-05-06 11:56:17,200 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x7e6a58 2017-05-06 11:56:17,201 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec L16 2017-05-06 11:56:17,201 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x7e6a40 [0x72125540], 0x76d4a580 [0x72124dc0], 0x25694c [0]) 2017-05-06 11:56:17,202 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x51f0bc 2017-05-06 11:56:17,202 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d4a590 [0x72124e18]) 2017-05-06 11:56:17,202 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x7e6a58 2017-05-06 11:56:17,203 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d4a590 [0x72124e18]) 2017-05-06 11:56:17,203 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x7e6a58 2017-05-06 11:56:17,204 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec L16 2017-05-06 11:56:17,204 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x7e6a40 [0x72125540], 0x76d4a590 [0x72124e18], 0x25694c [0]) 2017-05-06 11:56:17,204 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x51f0bc 2017-05-06 11:56:17,205 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_video_devices(0x7e6a40 [0x72125540]) 2017-05-06 11:56:17,205 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_video_devices -> 0x83d850 2017-05-06 11:56:17,206 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_video_devices(0x7e6a40 [0x72125540]) 2017-05-06 11:56:17,206 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_video_devices -> 0x83d850 2017-05-06 11:56:17,206 [INFO] [doorpi.sipphone.from_linphone] found 1 possible videodevices: 2017-05-06 11:56:17,207 [DEBUG] [doorpi.sipphone.from_linphone] | name 2017-05-06 11:56:17,207 [DEBUG] [doorpi.sipphone.from_linphone] ------------------------------------ 2017-05-06 11:56:17,207 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_video_devices(0x7e6a40 [0x72125540]) 2017-05-06 11:56:17,208 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_video_devices -> 0x83d850 2017-05-06 11:56:17,208 [DEBUG] [doorpi.sipphone.from_linphone] | StaticImage: Static picture 2017-05-06 11:56:17,208 [DEBUG] [doorpi.sipphone.from_linphone] ------------------------------------ 2017-05-06 11:56:17,209 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_video_devices(0x7e6a40 [0x72125540]) 2017-05-06 11:56:17,209 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_video_devices -> 0x83d850 2017-05-06 11:56:17,210 [TRACE] [doorpi.conf.config_object] get_string for key video_device in section SIP-Phone (default: StaticImage: Static picture) returns StaticImage: Static picture 2017-05-06 11:56:17,210 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_video_devices(0x7e6a40 [0x72125540]) 2017-05-06 11:56:17,210 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_video_devices -> 0x83d850 2017-05-06 11:56:17,211 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_enable_video_capture(0x7e6a40 [0x72125540], 0x256958 [1]) 2017-05-06 11:56:17,211 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_enable_video_capture -> 0 2017-05-06 11:56:17,212 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_video_device(0x7e6a40 [0x72125540], "StaticImage: Static picture") 2017-05-06 11:56:17,212 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_video_device -> 0 2017-05-06 11:56:17,213 [TRACE] [doorpi.conf.config_object] get_string for key video_size in section SIP-Phone (default: vga) returns vga 2017-05-06 11:56:17,213 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_preferred_video_size_by_name(0x7e6a40 [0x72125540], "vga") 2017-05-06 11:56:17,213 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_preferred_video_size_by_name -> 0 2017-05-06 11:56:17,214 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_video_device(0x7e6a40 [0x72125540]) 2017-05-06 11:56:17,214 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_video_device -> 0x83ae60 2017-05-06 11:56:17,215 [DEBUG] [doorpi.sipphone.from_linphone] using video_device: StaticImage: Static picture 2017-05-06 11:56:17,215 [TRACE] [doorpi.conf.config_object] get_list for key video_codecs in section SIP-Phone (default: VP8) returns ['VP8'] 2017-05-06 11:56:17,215 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_video_codecs(0x7e6a40 [0x72125540]) 2017-05-06 11:56:17,216 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0x7211cda0) 2017-05-06 11:56:17,216 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2017-05-06 11:56:17,216 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0x76d4a5a0 2017-05-06 11:56:17,217 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2017-05-06 11:56:17,217 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0x76d4a5a0 2017-05-06 11:56:17,218 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0x76d4a5a0 2017-05-06 11:56:17,218 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_video_codecs -> 0x83d828 2017-05-06 11:56:17,218 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d4a5a0 [0x7211cda0]) 2017-05-06 11:56:17,219 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x7e6a58 2017-05-06 11:56:17,219 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_video_capture_enabled(0x7e6a40 [0x72125540]) 2017-05-06 11:56:17,219 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_video_capture_enabled -> 0x256958 2017-05-06 11:56:17,220 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d4a5a0 [0x7211cda0]) 2017-05-06 11:56:17,220 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x7e6a58 2017-05-06 11:56:17,221 [DEBUG] [doorpi.sipphone.from_linphone] enable video codec VP8 2017-05-06 11:56:17,221 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x7e6a40 [0x72125540], 0x76d4a5a0 [0x7211cda0], 0x256958 [1]) 2017-05-06 11:56:17,222 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x51f0bc 2017-05-06 11:56:17,222 [TRACE] [doorpi.conf.config_object] get_string for key sipserver_server in section SIP-Phone (default: ) returns 192.168.178.1 2017-05-06 11:56:17,222 [TRACE] [doorpi.conf.config_object] get_string for key sipserver_username in section SIP-Phone (default: ) returns 623 2017-05-06 11:56:17,223 [TRACE] [doorpi.conf.config_object] get_string for key sipserver_password in section SIP-Phone (default: 623) returns ******* 2017-05-06 11:56:17,223 [TRACE] [doorpi.conf.config_object] get_string for key sipserver_realm in section SIP-Phone (default: 192.168.178.1) returns fritz.box 2017-05-06 11:56:17,223 [INFO] [doorpi.sipphone.from_linphone] using DoorPi with SIP-Server 2017-05-06 11:56:17,224 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_create_proxy_config(0x7e6a40 [0x72125540]) 2017-05-06 11:56:17,224 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_ProxyConfig_from_native_ptr(0x721247f8) 2017-05-06 11:56:17,225 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_ProxyConfig_new() 2017-05-06 11:56:17,225 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_ProxyConfig_new -> 0x76d4a5b0 2017-05-06 11:56:17,225 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_ProxyConfig_init() 2017-05-06 11:56:17,226 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_ProxyConfig_init -> 0x76d4a5b0 2017-05-06 11:56:17,226 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_ProxyConfig_from_native_ptr -> 0x76d4a5b0 2017-05-06 11:56:17,227 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_create_proxy_config -> 0x76d4a5b0 2017-05-06 11:56:17,227 [TRACE] [doorpi.conf.config_object] get_string for key identity in section SIP-Phone (default: DoorPi) returns DoorPi 2017-05-06 11:56:17,227 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Address_class_method_new("DoorPi ") 2017-05-06 11:56:17,228 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Address_from_native_ptr(0x72121170) 2017-05-06 11:56:17,229 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Address_new() 2017-05-06 11:56:17,229 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Address_new -> 0x76d4a5c0 2017-05-06 11:56:17,230 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Address_init() 2017-05-06 11:56:17,230 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Address_init -> 0x76d4a5c0 2017-05-06 11:56:17,231 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Address_from_native_ptr -> 0x76d4a5c0 2017-05-06 11:56:17,231 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Address_class_method_new -> 0x76d4a5c0 2017-05-06 11:56:17,231 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_ProxyConfig_set_identity_address(0x76d4a5b0 [0x721247f8], 0x76d4a5c0 [0x72121170]) 2017-05-06 11:56:17,232 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_ProxyConfig_set_identity_address -> 0 2017-05-06 11:56:17,232 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_ProxyConfig_set_server_addr(0x76d4a5b0 [0x721247f8], "sip:192.168.178.1") 2017-05-06 11:56:17,233 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_ProxyConfig_set_server_addr -> 0 2017-05-06 11:56:17,234 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_ProxyConfig_enable_register(0x76d4a5b0 [0x721247f8], 0x256958 [1]) 2017-05-06 11:56:17,234 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_ProxyConfig_enable_register -> 0 2017-05-06 11:56:17,235 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_add_proxy_config(0x7e6a40 [0x72125540], 0x76d4a5b0 [0x721247f8]) 2017-05-06 11:56:17,236 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_add_proxy_config -> 0x51f0bc 2017-05-06 11:56:17,236 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_default_proxy_config(0x7e6a40 [0x72125540], 0x76d4a5b0 [0x721247f8]) 2017-05-06 11:56:17,237 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_default_proxy_config -> 0 2017-05-06 11:56:17,237 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_create_auth_info(0x7e6a40 [0x72125540], "623", "(null)", "doorpi5678", "(null)", "(null)", "fritz.box") 2017-05-06 11:56:17,237 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_AuthInfo_from_native_ptr(0x7214c1f8) 2017-05-06 11:56:17,238 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_AuthInfo_new() 2017-05-06 11:56:17,238 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_AuthInfo_new -> 0x76d4a5d0 2017-05-06 11:56:17,239 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_AuthInfo_init() 2017-05-06 11:56:17,239 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_AuthInfo_init -> 0x76d4a5d0 2017-05-06 11:56:17,239 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_AuthInfo_from_native_ptr -> 0x76d4a5d0 2017-05-06 11:56:17,240 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_create_auth_info -> 0x76d4a5d0 2017-05-06 11:56:17,240 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_add_auth_info(0x7e6a40 [0x72125540], 0x76d4a5d0 [0x7214c1f8]) 2017-05-06 11:56:17,240 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_add_auth_info -> None 2017-05-06 11:56:17,241 [DEBUG] [doorpi.sipphone.from_linphone] start successfully 2017-05-06 11:56:17,241 [TRACE] [doorpi.conf.config_object] get_sections returns ['EVENT_OnStartup', 'EVENT_OnFoundKnownTag', 'EVENT_OnKeyPressed_onboardpins.11', 'EVENT_OnSipPhoneCallTimeoutNoResponse'] 2017-05-06 11:56:17,242 [INFO] [doorpi.doorpi] found EVENT_ section 'EVENT_OnStartup' in configfile 2017-05-06 11:56:17,242 [TRACE] [doorpi.conf.config_object] get_keys for section EVENT_OnStartup returns ['10', '30', '20'] 2017-05-06 11:56:17,242 [INFO] [doorpi.doorpi] registering action '10' for event 'OnStartup' 2017-05-06 11:56:17,243 [TRACE] [doorpi.conf.config_object] get_string for key 10 in section EVENT_OnStartup (default: ) returns sleep:1 2017-05-06 11:56:17,244 [DEBUG] [doorpi.action.SingleActions.sleep] doorpi.action.SingleActions.sleep loaded 2017-05-06 11:56:17,244 [TRACE] [doorpi.action.handler] action SleepAction with args (1.0,) and kwargs {} was added to new evententry OnStartup 2017-05-06 11:56:17,245 [INFO] [doorpi.doorpi] registering action '20' for event 'OnStartup' 2017-05-06 11:56:17,245 [TRACE] [doorpi.conf.config_object] get_string for key 20 in section EVENT_OnStartup (default: ) returns os_execute:/usr/local/etc/DoorPi/scripts/Startmeldung.sh 2017-05-06 11:56:17,246 [DEBUG] [doorpi.action.SingleActions.os_execute] doorpi.action.SingleActions.os_execute loaded 2017-05-06 11:56:17,259 [TRACE] [doorpi.action.handler] action OsExecuteAction with args () and kwargs {'command': '/usr/local/etc/DoorPi/scripts/Startmeldung.sh'} was added to event OnStartup 2017-05-06 11:56:17,259 [INFO] [doorpi.doorpi] registering action '30' for event 'OnStartup' 2017-05-06 11:56:17,260 [TRACE] [doorpi.conf.config_object] get_string for key 30 in section EVENT_OnStartup (default: ) returns os_execute:/usr/local/etc/DoorPi/scripts/Klingelbild.sh 2017-05-06 11:56:17,262 [TRACE] [doorpi.action.handler] action OsExecuteAction with args () and kwargs {'command': '/usr/local/etc/DoorPi/scripts/Klingelbild.sh'} was added to event OnStartup 2017-05-06 11:56:17,262 [INFO] [doorpi.doorpi] found EVENT_ section 'EVENT_OnFoundKnownTag' in configfile 2017-05-06 11:56:17,263 [TRACE] [doorpi.conf.config_object] get_keys for section EVENT_OnFoundKnownTag returns ['10', '20'] 2017-05-06 11:56:17,263 [INFO] [doorpi.doorpi] registering action '10' for event 'OnFoundKnownTag' 2017-05-06 11:56:17,263 [TRACE] [doorpi.conf.config_object] get_string for key 10 in section EVENT_OnFoundKnownTag (default: ) returns sleep:1 2017-05-06 11:56:17,264 [TRACE] [doorpi.action.handler] action SleepAction with args (1.0,) and kwargs {} was added to new evententry OnFoundKnownTag 2017-05-06 11:56:17,264 [INFO] [doorpi.doorpi] registering action '20' for event 'OnFoundKnownTag' 2017-05-06 11:56:17,265 [TRACE] [doorpi.conf.config_object] get_string for key 20 in section EVENT_OnFoundKnownTag (default: ) returns os_execute:aplay /usr/local/etc/DoorPi/media/Connect.wav 2017-05-06 11:56:17,266 [TRACE] [doorpi.action.handler] action OsExecuteAction with args () and kwargs {'command': 'aplay /usr/local/etc/DoorPi/media/Connect.wav'} was added to event OnFoundKnownTag 2017-05-06 11:56:17,267 [INFO] [doorpi.doorpi] found EVENT_ section 'EVENT_OnKeyPressed_onboardpins.11' in configfile 2017-05-06 11:56:17,267 [TRACE] [doorpi.conf.config_object] get_keys for section EVENT_OnKeyPressed_onboardpins.11 returns ['10'] 2017-05-06 11:56:17,267 [INFO] [doorpi.doorpi] registering action '10' for event 'OnKeyPressed_onboardpins.11' 2017-05-06 11:56:17,268 [TRACE] [doorpi.conf.config_object] get_string for key 10 in section EVENT_OnKeyPressed_onboardpins.11 (default: ) returns os_execute:/usr/local/etc/DoorPi/scripts/Klingelbild.sh 2017-05-06 11:56:17,269 [TRACE] [doorpi.action.handler] action OsExecuteAction with args () and kwargs {'command': '/usr/local/etc/DoorPi/scripts/Klingelbild.sh'} was added to new evententry OnKeyPressed_onboardpins.11 2017-05-06 11:56:17,270 [INFO] [doorpi.doorpi] found EVENT_ section 'EVENT_OnSipPhoneCallTimeoutNoResponse' in configfile 2017-05-06 11:56:17,270 [TRACE] [doorpi.conf.config_object] get_keys for section EVENT_OnSipPhoneCallTimeoutNoResponse returns ['10'] 2017-05-06 11:56:17,270 [INFO] [doorpi.doorpi] registering action '10' for event 'OnSipPhoneCallTimeoutNoResponse' 2017-05-06 11:56:17,271 [TRACE] [doorpi.conf.config_object] get_string for key 10 in section EVENT_OnSipPhoneCallTimeoutNoResponse (default: ) returns os_execute:/usr/local/etc/DoorPi/scripts/calltimeout.sh 2017-05-06 11:56:17,272 [TRACE] [doorpi.action.handler] action OsExecuteAction with args () and kwargs {'command': '/usr/local/etc/DoorPi/scripts/calltimeout.sh'} was added to new evententry OnSipPhoneCallTimeoutNoResponse 2017-05-06 11:56:17,273 [TRACE] [doorpi.conf.config_object] get_string for key 4895755 in section rfidreader_InputPins (default: ) returns out:Tueroeffner,1,0,1.5 2017-05-06 11:56:17,274 [DEBUG] [doorpi.action.SingleActions.out] doorpi.action.SingleActions.out loaded 2017-05-06 11:56:17,275 [DEBUG] [doorpi.action.SingleActions.out_triggered] doorpi.action.SingleActions.out_triggered loaded 2017-05-06 11:56:17,275 [TRACE] [doorpi.action.handler] action OutTriggeredAction with args () and kwargs {'stop_pin': 'NoStopPinSet', 'end_value': '0', 'timeout': 1.5, 'pin': 'Tueroeffner', 'start_value': '1'} was added to new evententry OnKeyPressed_rfidreader.4895755 2017-05-06 11:56:17,276 [TRACE] [doorpi.conf.config_object] get_string for key 4916638 in section rfidreader_InputPins (default: ) returns out:Tueroeffner,1,0,1.5 2017-05-06 11:56:17,277 [TRACE] [doorpi.action.handler] action OutTriggeredAction with args () and kwargs {'stop_pin': 'NoStopPinSet', 'end_value': '0', 'timeout': 1.5, 'pin': 'Tueroeffner', 'start_value': '1'} was added to new evententry OnKeyPressed_rfidreader.4916638 2017-05-06 11:56:17,277 [TRACE] [doorpi.conf.config_object] get_string for key 4915036 in section rfidreader_InputPins (default: ) returns out:Tueroeffner,1,0,1.5 2017-05-06 11:56:17,278 [TRACE] [doorpi.action.handler] action OutTriggeredAction with args () and kwargs {'stop_pin': 'NoStopPinSet', 'end_value': '0', 'timeout': 1.5, 'pin': 'Tueroeffner', 'start_value': '1'} was added to new evententry OnKeyPressed_rfidreader.4915036 2017-05-06 11:56:17,278 [TRACE] [doorpi.conf.config_object] get_string for key 5057884 in section rfidreader_InputPins (default: ) returns out:Tueroeffner,1,0,1.5 2017-05-06 11:56:17,279 [TRACE] [doorpi.action.handler] action OutTriggeredAction with args () and kwargs {'stop_pin': 'NoStopPinSet', 'end_value': '0', 'timeout': 1.5, 'pin': 'Tueroeffner', 'start_value': '1'} was added to new evententry OnKeyPressed_rfidreader.5057884 2017-05-06 11:56:17,279 [TRACE] [doorpi.conf.config_object] get_string for key 4983309 in section rfidreader_InputPins (default: ) returns out:Tueroeffner,1,0,1.5 2017-05-06 11:56:17,279 [TRACE] [doorpi.action.handler] action OutTriggeredAction with args () and kwargs {'stop_pin': 'NoStopPinSet', 'end_value': '0', 'timeout': 1.5, 'pin': 'Tueroeffner', 'start_value': '1'} was added to new evententry OnKeyPressed_rfidreader.4983309 2017-05-06 11:56:17,280 [TRACE] [doorpi.conf.config_object] get_string for key dooropen in section vkboard_InputPins (default: ) returns hangup:0 2017-05-06 11:56:17,281 [DEBUG] [doorpi.action.SingleActions.hangup] doorpi.action.SingleActions.hangup loaded 2017-05-06 11:56:17,281 [TRACE] [doorpi.action.handler] action HangupAction with args ('0',) and kwargs {} was added to new evententry OnKeyPressed_vkboard.dooropen 2017-05-06 11:56:17,282 [TRACE] [doorpi.conf.config_object] get_string for key internal in section vkboard_InputPins (default: ) returns os_execute:echo 0 > /usr/local/etc/DoorPi/tools/status.txt 2017-05-06 11:56:17,283 [TRACE] [doorpi.action.handler] action OsExecuteAction with args () and kwargs {'command': 'echo 0 > /usr/local/etc/DoorPi/tools/status.txt'} was added to new evententry OnKeyPressed_vkboard.internal 2017-05-06 11:56:17,284 [TRACE] [doorpi.conf.config_object] get_string for key doorlock in section vkboard_InputPins (default: ) returns out:Tuerschliesser,1,0,2 2017-05-06 11:56:17,285 [TRACE] [doorpi.action.handler] action OutTriggeredAction with args () and kwargs {'stop_pin': 'NoStopPinSet', 'end_value': '0', 'timeout': 2.0, 'pin': 'Tuerschliesser', 'start_value': '1'} was added to new evententry OnKeyPressed_vkboard.doorlock 2017-05-06 11:56:17,285 [TRACE] [doorpi.conf.config_object] get_string for key external in section vkboard_InputPins (default: ) returns os_execute:echo 1 > /usr/local/etc/DoorPi/tools/status.txt 2017-05-06 11:56:17,286 [TRACE] [doorpi.action.handler] action OsExecuteAction with args () and kwargs {'command': 'echo 1 > /usr/local/etc/DoorPi/tools/status.txt'} was added to new evententry OnKeyPressed_vkboard.external 2017-05-06 11:56:17,287 [TRACE] [doorpi.conf.config_object] get_string for key 11 in section onboardpins_InputPins (default: ) returns call:**722 2017-05-06 11:56:17,288 [DEBUG] [doorpi.action.SingleActions.call] doorpi.action.SingleActions.call loaded 2017-05-06 11:56:17,288 [TRACE] [doorpi.action.handler] action CallAction with args () and kwargs {'number': '**722'} was added to event OnKeyPressed_onboardpins.11 2017-05-06 11:56:17,289 [TRACE] [doorpi.conf.config_object] get_keys for section DTMF returns ['"18"', '"16"'] 2017-05-06 11:56:17,289 [TRACE] [doorpi.conf.config_object] get_string for key "16" in section DTMF (default: ) returns out:Tuerschliesser,1,0,2 2017-05-06 11:56:17,290 [TRACE] [doorpi.action.handler] action OutTriggeredAction with args () and kwargs {'stop_pin': 'NoStopPinSet', 'end_value': '0', 'timeout': 2.0, 'pin': 'Tuerschliesser', 'start_value': '1'} was added to new evententry OnDTMF_"16" 2017-05-06 11:56:17,290 [TRACE] [doorpi.conf.config_object] get_string for key "18" in section DTMF (default: ) returns out:Tueroeffner,1,0,1.5 2017-05-06 11:56:17,291 [TRACE] [doorpi.action.handler] action OutTriggeredAction with args () and kwargs {'stop_pin': 'NoStopPinSet', 'end_value': '0', 'timeout': 1.5, 'pin': 'Tueroeffner', 'start_value': '1'} was added to new evententry OnDTMF_"18" 2017-05-06 11:56:17,291 [TRACE] [doorpi.conf.config_object] get_string for key is_alive_led in section DoorPi (default: ) returns 2017-05-06 11:56:17,292 [TRACE] [doorpi.action.handler] fire Event BeforeStartup from doorpi.doorpi asyncron 2017-05-06 11:56:17,293 [DEBUG] [doorpi.action.handler] [PHV39P] fire for event OnStartup this actions [, , ] 2017-05-06 11:56:17,294 [DEBUG] [doorpi.action.handler] no actions for event BeforeStartup - skip fire_event BeforeStartup from doorpi.doorpi 2017-05-06 11:56:17,294 [TRACE] [doorpi.action.handler] [PHV39P] try to fire action SleepAction with args (1.0,) and kwargs {} 2017-05-06 11:56:17,295 [TRACE] [doorpi.action.base] run SleepAction with args (1.0,) and kwargs {} 2017-05-06 11:56:18,298 [TRACE] [doorpi.action.handler] [PHV39P] try to fire action OsExecuteAction with args () and kwargs {'command': '/usr/local/etc/DoorPi/scripts/Startmeldung.sh'} 2017-05-06 11:56:18,302 [TRACE] [doorpi.action.base] run OsExecuteAction with args () and kwargs {'command': '/usr/local/etc/DoorPi/scripts/Startmeldung.sh'} 2017-05-06 11:56:18,643 [TRACE] [doorpi.action.handler] [PHV39P] try to fire action OsExecuteAction with args () and kwargs {'command': '/usr/local/etc/DoorPi/scripts/Klingelbild.sh'} 2017-05-06 11:56:18,644 [TRACE] [doorpi.action.base] run OsExecuteAction with args () and kwargs {'command': '/usr/local/etc/DoorPi/scripts/Klingelbild.sh'} --2017-05-06 11:56:18-- http://192.168.178.42/tmpfs/snap.jpg Verbindungsaufbau zu 192.168.178.42:80... verbunden. HTTP-Anforderung gesendet, warte auf Antwort... 200 OK Länge: 269103 (263K) [image/jpeg] In »»/home/pi/Haustuerklingel.jpg«« speichern. 0K .......... .......... .......... .......... .......... 19% 930K 0s 50K .......... .......... .......... .......... .......... 38% 2,79M 0s 100K .......... .......... .......... .......... .......... 57% 3,71M 0s 150K .......... .......... .......... .......... .......... 76% 1,75M 0s 200K .......... .......... .......... .......... .......... 95% 2,46M 0s 250K .......... .. 100% 6,32M=0,1s 2017-05-06 11:56:18 (1,91 MB/s) - »»/home/pi/Haustuerklingel.jpg«« gespeichert [269103/269103] 2017-05-06 11:56:21,675 [TRACE] [doorpi.action.handler] [PHV39P] finished fire_event for event_name OnStartup 2017-05-06 11:56:21,676 [TRACE] [doorpi.action.handler] fire Event AfterStartup from doorpi.doorpi asyncron 2017-05-06 11:56:21,678 [INFO] [doorpi.doorpi] DoorPi started successfully 2017-05-06 11:56:21,678 [INFO] [doorpi.doorpi] BasePath is /usr/local/etc/DoorPi 2017-05-06 11:56:21,679 [INFO] [doorpi.doorpi] Weburl is http://raspberrypi/ 2017-05-06 11:56:21,680 [INFO] [doorpi.sipphone.from_linphone] New local ip address is 192.168.178.31 2017-05-06 11:56:21,681 [INFO] [doorpi.sipphone.from_linphone] Network state is now [UP] 2017-05-06 11:56:21,682 [INFO] [doorpi.sipphone.from_linphone] Stun server resolution successful. 2017-05-06 11:56:21,684 [INFO] [doorpi.sipphone.from_linphone] LinphoneProxyConfig [0x721247f8] about to register (LinphoneCore version: 3.9.0) 2017-05-06 11:56:21,695 [DEBUG] [doorpi.action.handler] no actions for event AfterStartup - skip fire_event AfterStartup from doorpi.doorpi 2017-05-06 11:56:21,696 [INFO] [doorpi.sipphone.from_linphone] belle_sip_client_transaction_send_request(): waiting channel to be ready 2017-05-06 11:56:21,697 [INFO] [doorpi.sipphone.from_linphone] channel [0x721266c0]: starting resolution of 192.168.178.1 2017-05-06 11:56:21,697 [INFO] [doorpi.sipphone.from_linphone] channel 0x721266c0: state RES_IN_PROGRESS 2017-05-06 11:56:21,698 [INFO] [doorpi.sipphone.from_linphone] transaction [0x721202c0] channel state changed to [RES_IN_PROGRESS] 2017-05-06 11:56:21,699 [INFO] [doorpi.sipphone.from_linphone] channel 0x721266c0: state RES_DONE 2017-05-06 11:56:21,700 [INFO] [doorpi.sipphone.from_linphone] transaction [0x721202c0] channel state changed to [RES_DONE] 2017-05-06 11:56:21,700 [INFO] [doorpi.sipphone.from_linphone] channel 0x721266c0: state CONNECTING 2017-05-06 11:56:21,701 [INFO] [doorpi.sipphone.from_linphone] transaction [0x721202c0] channel state changed to [CONNECTING] 2017-05-06 11:56:21,701 [INFO] [doorpi.sipphone.from_linphone] Trying to connect to [UDP://192.168.178.1:5060] 2017-05-06 11:56:21,702 [INFO] [doorpi.sipphone.from_linphone] belle_sip_get_src_addr_for(): af_inet6=0 2017-05-06 11:56:21,703 [INFO] [doorpi.sipphone.from_linphone] Channel has local address 192.168.178.31:5060 2017-05-06 11:56:21,703 [INFO] [doorpi.sipphone.from_linphone] channel 0x721266c0: state READY 2017-05-06 11:56:21,704 [INFO] [doorpi.sipphone.from_linphone] transaction [0x721202c0] channel state changed to [READY] 2017-05-06 11:56:21,705 [INFO] [doorpi.sipphone.from_linphone] Changing [client] [REGISTER] transaction [0x721202c0], from state [INIT] to [TRYING] 2017-05-06 11:56:21,706 [INFO] [doorpi.sipphone.from_linphone] channel [0x721266c0]: message sent to [UDP://192.168.178.1:5060], size: [514] bytes REGISTER sip:192.168.178.1 SIP/2.0 Via: SIP/2.0/UDP 192.168.178.31:5060;branch=z9hG4bK.hrg4Cj64u;rport From: "DoorPi" ;tag=0TzWhu8UA To: "DoorPi" CSeq: 20 REGISTER Call-ID: LHxnfRcAvZ Max-Forwards: 70 Supported: outbound Accept: application/sdp Accept: text/plain Accept: application/vnd.gsma.rcs-ft-http+xml Contact: ;+sip.instance="" Expires: 3600 User-Agent: (belle-sip/1.4.2) 2017-05-06 11:56:21,707 [INFO] [doorpi.sipphone.from_linphone] Neither Expires header nor corresponding Contact header found, checking from original request 2017-05-06 11:56:21,707 [INFO] [doorpi.sipphone.from_linphone] Refresher [0x7214c8a0] takes ownership of transaction [0x721202c0] 2017-05-06 11:56:21,708 [INFO] [doorpi.sipphone.from_linphone] Proxy config [0x721247f8] for identity ["DoorPi" ] moving from state [LinphoneRegistrationNone] to [LinphoneRegistrationProgress] 2017-05-06 11:56:21,709 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_callback_registration_state_changed(0x72125540, 0x721247f8, 1, "Registration in progress") 2017-05-06 11:56:21,709 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_callback_registration_state_changed 2017-05-06 11:56:21,710 [INFO] [doorpi.sipphone.from_linphone] Linphone core [0x72125540] notifying [registration_state_changed] 2017-05-06 11:56:21,761 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_callback_network_reachable(0x72125540, 0x1) 2017-05-06 11:56:21,762 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_callback_network_reachable 2017-05-06 11:56:21,763 [INFO] [doorpi.sipphone.from_linphone] Linphone core [0x72125540] notifying [network_reachable] 2017-05-06 11:56:21,763 [INFO] [doorpi.sipphone.from_linphone] channel [0x721266c0]: received [366] new bytes from [UDP://192.168.178.1:5060]: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 192.168.178.31:5060;branch=z9hG4bK.hrg4Cj64u;rport=5060 From: "DoorPi" ;tag=0TzWhu8UA To: "DoorPi" ;tag=1852DAB09EC64B75 Call-ID: LHxnfRcAvZ CSeq: 20 REGISTER WWW-Authenticate: Digest realm="fritz.box", nonce="94943DA62DF11815" User-Agent: FRITZ!OS Content-Length: 0 2017-05-06 11:56:21,775 [INFO] [doorpi.sipphone.from_linphone] channel [0x721266c0] [366] bytes parsed 2017-05-06 11:56:21,776 [INFO] [doorpi.sipphone.from_linphone] channel [0x721266c0]: discovered public ip and port are [192.168.178.31:5060] 2017-05-06 11:56:21,776 [INFO] [doorpi.sipphone.from_linphone] Found transaction matching response. 2017-05-06 11:56:21,777 [INFO] [doorpi.sipphone.from_linphone] Changing [client] [REGISTER] transaction [0x721202c0], from state [TRYING] to [COMPLETED] 2017-05-06 11:56:21,778 [INFO] [doorpi.sipphone.from_linphone] linphone_core_find_auth_info(): returning auth info username=623, realm= 2017-05-06 11:56:21,779 [INFO] [doorpi.sipphone.from_linphone] Auth info found for [623] realm [fritz.box] 2017-05-06 11:56:21,780 [INFO] [doorpi.sipphone.from_linphone] Changing [client] [REGISTER] transaction [0x7211fd90], from state [INIT] to [TRYING] 2017-05-06 11:56:21,781 [INFO] [doorpi.sipphone.from_linphone] channel [0x721266c0]: message sent to [UDP://192.168.178.1:5060], size: [669] bytes REGISTER sip:192.168.178.1 SIP/2.0 Via: SIP/2.0/UDP 192.168.178.31:5060;branch=z9hG4bK.lq9SE3XML;rport From: "DoorPi" ;tag=0TzWhu8UA To: "DoorPi" CSeq: 21 REGISTER Call-ID: LHxnfRcAvZ Max-Forwards: 70 Supported: outbound Accept: application/sdp Accept: text/plain Accept: application/vnd.gsma.rcs-ft-http+xml Contact: ;+sip.instance="" Expires: 3600 User-Agent: (belle-sip/1.4.2) Authorization: Digest realm="fritz.box", nonce="94943DA62DF11815", username="623", uri="sip:192.168.178.1", response="cb7eba43325fcc2ac2acc2cca4ff3646" 2017-05-06 11:56:21,833 [INFO] [doorpi.sipphone.from_linphone] channel [0x721266c0]: received [366] new bytes from [UDP://192.168.178.1:5060]: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 192.168.178.31:5060;branch=z9hG4bK.lq9SE3XML;rport=5060 From: "DoorPi" ;tag=0TzWhu8UA To: "DoorPi" ;tag=BC188D522B468391 Call-ID: LHxnfRcAvZ CSeq: 21 REGISTER WWW-Authenticate: Digest realm="fritz.box", nonce="ACCB1A34911E05E8" User-Agent: FRITZ!OS Content-Length: 0 2017-05-06 11:56:21,844 [INFO] [doorpi.sipphone.from_linphone] channel [0x721266c0] [366] bytes parsed 2017-05-06 11:56:21,845 [INFO] [doorpi.sipphone.from_linphone] Found transaction matching response. 2017-05-06 11:56:21,846 [INFO] [doorpi.sipphone.from_linphone] Changing [client] [REGISTER] transaction [0x7211fd90], from state [TRYING] to [COMPLETED] 2017-05-06 11:56:21,846 [WARNING] [doorpi.sipphone.from_linphone] Authentication is failing constantly, will retry later 2017-05-06 11:56:21,847 [INFO] [doorpi.sipphone.from_linphone] Refresher: scheduling next timer in 60000 ms 2017-05-06 11:56:21,848 [INFO] [doorpi.sipphone.from_linphone] Register refresher [401] reason [Unauthorized] for proxy [sip:192.168.178.1] 2017-05-06 11:56:21,848 [INFO] [doorpi.sipphone.from_linphone] Proxy config [0x721247f8] for identity ["DoorPi" ] moving from state [LinphoneRegistrationProgress] to [LinphoneRegistrationFailed] 2017-05-06 11:56:21,849 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_callback_registration_state_changed(0x72125540, 0x721247f8, 4, "Unauthorized") 2017-05-06 11:56:21,849 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_callback_registration_state_changed 2017-05-06 11:56:21,850 [INFO] [doorpi.sipphone.from_linphone] Linphone core [0x72125540] notifying [registration_state_changed] 2017-05-06 11:56:21,851 [INFO] [doorpi.sipphone.from_linphone] linphone_core_find_auth_info(): returning auth info username=623, realm=fritz.box 2017-05-06 11:56:21,851 [INFO] [doorpi.sipphone.from_linphone] fritz.box/623/192.168.178.1 authentication fails. 2017-05-06 11:56:21,852 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_callback_auth_info_requested(0x72125540, "fritz.box", "623", "192.168.178.1") 2017-05-06 11:56:21,852 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_callback_auth_info_requested 2017-05-06 11:56:21,853 [INFO] [doorpi.sipphone.from_linphone] Linphone core [0x72125540] notifying [auth_info_requested] 2017-05-06 11:56:26,809 [INFO] [doorpi.sipphone.from_linphone] Changing [client] [REGISTER] transaction [0x721202c0], from state [COMPLETED] to [TERMINATED] 2017-05-06 11:56:26,810 [INFO] [doorpi.sipphone.from_linphone] Client internal REGISTER transaction [0x721202c0] terminated 2017-05-06 11:56:26,861 [INFO] [doorpi.sipphone.from_linphone] Changing [client] [REGISTER] transaction [0x7211fd90], from state [COMPLETED] to [TERMINATED] 2017-05-06 11:56:26,862 [INFO] [doorpi.sipphone.from_linphone] Client internal REGISTER transaction [0x7211fd90] terminated 2017-05-06 11:56:46,717 [INFO] [doorpi.main] KeyboardInterrupt -> DoorPi will shutdown 2017-05-06 11:56:46,718 [DEBUG] [doorpi.doorpi] destroy doorpi 2017-05-06 11:56:46,719 [DEBUG] [doorpi.doorpi] Threads before starting shutdown: [<_MainThread(MainThread, started 1996161024)>, , , , , ] 2017-05-06 11:56:46,720 [TRACE] [doorpi.action.handler] fire Event BeforeShutdown from doorpi.doorpi asyncron 2017-05-06 11:56:46,722 [DEBUG] [doorpi.action.handler] no actions for event BeforeShutdown - skip fire_event BeforeShutdown from doorpi.doorpi 2017-05-06 11:56:46,724 [DEBUG] [doorpi.action.handler] [OKQ6PO] fire for event OnShutdown this actions [, , , , , ] 2017-05-06 11:56:46,725 [TRACE] [doorpi.action.handler] [OKQ6PO] try to fire action TimeTickDestroyAction with args () and kwargs {} 2017-05-06 11:56:46,726 [TRACE] [doorpi.action.base] run TimeTickDestroyAction with args () and kwargs {} 2017-05-06 11:56:46,726 [TRACE] [doorpi.action.handler] unregister Eventsource doorpi.action.SingleActions.time_tick and force_unregister is True 2017-05-06 11:56:46,727 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute59 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,727 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute59 - remove event too 2017-05-06 11:56:46,728 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute59 2017-05-06 11:56:46,728 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute58 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,729 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute58 - remove event too 2017-05-06 11:56:46,729 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute58 2017-05-06 11:56:46,730 [TRACE] [doorpi.action.handler] unregister Event OnTimeWeekEvenNumber from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,730 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeWeekEvenNumber - remove event too 2017-05-06 11:56:46,731 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeWeekEvenNumber 2017-05-06 11:56:46,732 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute51 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,732 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute51 - remove event too 2017-05-06 11:56:46,733 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute51 2017-05-06 11:56:46,733 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute50 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,734 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute50 - remove event too 2017-05-06 11:56:46,734 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute50 2017-05-06 11:56:46,735 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute53 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,735 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute53 - remove event too 2017-05-06 11:56:46,736 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute53 2017-05-06 11:56:46,736 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute52 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,737 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute52 - remove event too 2017-05-06 11:56:46,737 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute52 2017-05-06 11:56:46,738 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute55 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,738 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute55 - remove event too 2017-05-06 11:56:46,739 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute55 2017-05-06 11:56:46,739 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute54 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,740 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute54 - remove event too 2017-05-06 11:56:46,740 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute54 2017-05-06 11:56:46,741 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute57 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,741 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute57 - remove event too 2017-05-06 11:56:46,742 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute57 2017-05-06 11:56:46,742 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute56 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,743 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute56 - remove event too 2017-05-06 11:56:46,743 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute56 2017-05-06 11:56:46,744 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinuteEvenNumber from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,745 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinuteEvenNumber - remove event too 2017-05-06 11:56:46,745 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinuteEvenNumber 2017-05-06 11:56:46,746 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,746 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour - remove event too 2017-05-06 11:56:46,747 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour 2017-05-06 11:56:46,747 [TRACE] [doorpi.action.handler] unregister Event OnTimeMonth from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,748 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMonth - remove event too 2017-05-06 11:56:46,748 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMonth 2017-05-06 11:56:46,749 [TRACE] [doorpi.action.handler] unregister Event OnTimeYearUnevenNumber from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,749 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeYearUnevenNumber - remove event too 2017-05-06 11:56:46,750 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeYearUnevenNumber 2017-05-06 11:56:46,751 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour19 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,751 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour19 - remove event too 2017-05-06 11:56:46,752 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour19 2017-05-06 11:56:46,753 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour18 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,753 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour18 - remove event too 2017-05-06 11:56:46,754 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour18 2017-05-06 11:56:46,754 [TRACE] [doorpi.action.handler] unregister Event OnTimeYearEvenNumber from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,755 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeYearEvenNumber - remove event too 2017-05-06 11:56:46,755 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeYearEvenNumber 2017-05-06 11:56:46,756 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour11 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,756 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour11 - remove event too 2017-05-06 11:56:46,757 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour11 2017-05-06 11:56:46,758 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour13 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,758 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour13 - remove event too 2017-05-06 11:56:46,759 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour13 2017-05-06 11:56:46,759 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour12 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,760 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour12 - remove event too 2017-05-06 11:56:46,760 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour12 2017-05-06 11:56:46,761 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour15 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,761 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour15 - remove event too 2017-05-06 11:56:46,762 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour15 2017-05-06 11:56:46,762 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour14 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,763 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour14 - remove event too 2017-05-06 11:56:46,763 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour14 2017-05-06 11:56:46,764 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour17 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,764 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour17 - remove event too 2017-05-06 11:56:46,765 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour17 2017-05-06 11:56:46,766 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour16 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,766 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour16 - remove event too 2017-05-06 11:56:46,767 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour16 2017-05-06 11:56:46,767 [TRACE] [doorpi.action.handler] unregister Event OnTimeSecondUnevenNumber from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,768 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeSecondUnevenNumber - remove event too 2017-05-06 11:56:46,768 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeSecondUnevenNumber 2017-05-06 11:56:46,769 [TRACE] [doorpi.action.handler] unregister Event OnTimeDay from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,769 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeDay - remove event too 2017-05-06 11:56:46,770 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeDay 2017-05-06 11:56:46,771 [TRACE] [doorpi.action.handler] unregister Event OnTimeMonthEvenNumber from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,771 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMonthEvenNumber - remove event too 2017-05-06 11:56:46,772 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMonthEvenNumber 2017-05-06 11:56:46,772 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour9 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,773 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour9 - remove event too 2017-05-06 11:56:46,773 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour9 2017-05-06 11:56:46,774 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour8 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,775 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour8 - remove event too 2017-05-06 11:56:46,775 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour8 2017-05-06 11:56:46,776 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour10 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,776 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour10 - remove event too 2017-05-06 11:56:46,777 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour10 2017-05-06 11:56:46,777 [TRACE] [doorpi.action.handler] unregister Event OnTimeSecond from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,778 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeSecond - remove event too 2017-05-06 11:56:46,778 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeSecond 2017-05-06 11:56:46,779 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour4 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,779 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour4 - remove event too 2017-05-06 11:56:46,780 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour4 2017-05-06 11:56:46,780 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour7 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,781 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour7 - remove event too 2017-05-06 11:56:46,781 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour7 2017-05-06 11:56:46,782 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour6 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,783 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour6 - remove event too 2017-05-06 11:56:46,783 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour6 2017-05-06 11:56:46,784 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour1 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,784 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour1 - remove event too 2017-05-06 11:56:46,785 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour1 2017-05-06 11:56:46,785 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour0 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,786 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour0 - remove event too 2017-05-06 11:56:46,786 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour0 2017-05-06 11:56:46,787 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour3 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,787 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour3 - remove event too 2017-05-06 11:56:46,788 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour3 2017-05-06 11:56:46,788 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour2 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,789 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour2 - remove event too 2017-05-06 11:56:46,789 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour2 2017-05-06 11:56:46,790 [TRACE] [doorpi.action.handler] unregister Event OnTimeMonthUnevenNumber from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,790 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMonthUnevenNumber - remove event too 2017-05-06 11:56:46,791 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMonthUnevenNumber 2017-05-06 11:56:46,791 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute5 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,792 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute5 - remove event too 2017-05-06 11:56:46,792 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute5 2017-05-06 11:56:46,793 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute4 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,794 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute4 - remove event too 2017-05-06 11:56:46,794 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute4 2017-05-06 11:56:46,795 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute7 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,795 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute7 - remove event too 2017-05-06 11:56:46,796 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute7 2017-05-06 11:56:46,796 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute6 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,797 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute6 - remove event too 2017-05-06 11:56:46,797 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute6 2017-05-06 11:56:46,798 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute1 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,798 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute1 - remove event too 2017-05-06 11:56:46,799 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute1 2017-05-06 11:56:46,799 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute0 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,800 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute0 - remove event too 2017-05-06 11:56:46,800 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute0 2017-05-06 11:56:46,801 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute3 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,801 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute3 - remove event too 2017-05-06 11:56:46,802 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute3 2017-05-06 11:56:46,802 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute2 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,803 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute2 - remove event too 2017-05-06 11:56:46,803 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute2 2017-05-06 11:56:46,804 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute9 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,804 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute9 - remove event too 2017-05-06 11:56:46,805 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute9 2017-05-06 11:56:46,806 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute8 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,806 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute8 - remove event too 2017-05-06 11:56:46,807 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute8 2017-05-06 11:56:46,807 [TRACE] [doorpi.action.handler] unregister Event OnTimeWeek from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,808 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeWeek - remove event too 2017-05-06 11:56:46,808 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeWeek 2017-05-06 11:56:46,809 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute15 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,809 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute15 - remove event too 2017-05-06 11:56:46,810 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute15 2017-05-06 11:56:46,810 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute14 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,811 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute14 - remove event too 2017-05-06 11:56:46,811 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute14 2017-05-06 11:56:46,812 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute17 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,812 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute17 - remove event too 2017-05-06 11:56:46,813 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute17 2017-05-06 11:56:46,813 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute16 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,814 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute16 - remove event too 2017-05-06 11:56:46,815 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute16 2017-05-06 11:56:46,815 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute11 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,816 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute11 - remove event too 2017-05-06 11:56:46,816 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute11 2017-05-06 11:56:46,817 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute10 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,817 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute10 - remove event too 2017-05-06 11:56:46,818 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute10 2017-05-06 11:56:46,818 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute13 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,819 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute13 - remove event too 2017-05-06 11:56:46,819 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute13 2017-05-06 11:56:46,820 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute12 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,820 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute12 - remove event too 2017-05-06 11:56:46,821 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute12 2017-05-06 11:56:46,821 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute19 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,822 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute19 - remove event too 2017-05-06 11:56:46,822 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute19 2017-05-06 11:56:46,823 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute18 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,823 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute18 - remove event too 2017-05-06 11:56:46,824 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute18 2017-05-06 11:56:46,825 [TRACE] [doorpi.action.handler] unregister Event OnTimeWeekUnevenNumber from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,825 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeWeekUnevenNumber - remove event too 2017-05-06 11:56:46,826 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeWeekUnevenNumber 2017-05-06 11:56:46,826 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinuteEvery5 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,827 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinuteEvery5 - remove event too 2017-05-06 11:56:46,827 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinuteEvery5 2017-05-06 11:56:46,828 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour20 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,828 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour20 - remove event too 2017-05-06 11:56:46,829 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour20 2017-05-06 11:56:46,829 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour21 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,830 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour21 - remove event too 2017-05-06 11:56:46,830 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour21 2017-05-06 11:56:46,831 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour22 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,831 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour22 - remove event too 2017-05-06 11:56:46,832 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour22 2017-05-06 11:56:46,832 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour5 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,833 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour5 - remove event too 2017-05-06 11:56:46,833 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour5 2017-05-06 11:56:46,834 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute20 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,834 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute20 - remove event too 2017-05-06 11:56:46,835 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute20 2017-05-06 11:56:46,836 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute21 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,836 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute21 - remove event too 2017-05-06 11:56:46,837 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute21 2017-05-06 11:56:46,837 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute22 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,838 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute22 - remove event too 2017-05-06 11:56:46,838 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute22 2017-05-06 11:56:46,839 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute23 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,839 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute23 - remove event too 2017-05-06 11:56:46,840 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute23 2017-05-06 11:56:46,840 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute24 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,841 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute24 - remove event too 2017-05-06 11:56:46,841 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute24 2017-05-06 11:56:46,842 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute25 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,842 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute25 - remove event too 2017-05-06 11:56:46,843 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute25 2017-05-06 11:56:46,843 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute26 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,844 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute26 - remove event too 2017-05-06 11:56:46,844 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute26 2017-05-06 11:56:46,845 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute27 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,845 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute27 - remove event too 2017-05-06 11:56:46,846 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute27 2017-05-06 11:56:46,846 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute28 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,847 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute28 - remove event too 2017-05-06 11:56:46,847 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute28 2017-05-06 11:56:46,848 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute29 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,848 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute29 - remove event too 2017-05-06 11:56:46,849 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute29 2017-05-06 11:56:46,849 [TRACE] [doorpi.action.handler] unregister Event OnTimeDayEvenNumber from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,850 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeDayEvenNumber - remove event too 2017-05-06 11:56:46,851 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeDayEvenNumber 2017-05-06 11:56:46,851 [TRACE] [doorpi.action.handler] unregister Event OnTimeDayUnevenNumber from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,852 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeDayUnevenNumber - remove event too 2017-05-06 11:56:46,852 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeDayUnevenNumber 2017-05-06 11:56:46,853 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute39 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,853 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute39 - remove event too 2017-05-06 11:56:46,854 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute39 2017-05-06 11:56:46,854 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute38 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,855 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute38 - remove event too 2017-05-06 11:56:46,855 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute38 2017-05-06 11:56:46,856 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute37 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,856 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute37 - remove event too 2017-05-06 11:56:46,857 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute37 2017-05-06 11:56:46,857 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute36 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,858 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute36 - remove event too 2017-05-06 11:56:46,858 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute36 2017-05-06 11:56:46,859 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute35 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,859 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute35 - remove event too 2017-05-06 11:56:46,860 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute35 2017-05-06 11:56:46,860 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute34 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,861 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute34 - remove event too 2017-05-06 11:56:46,861 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute34 2017-05-06 11:56:46,862 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute33 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,862 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute33 - remove event too 2017-05-06 11:56:46,863 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute33 2017-05-06 11:56:46,864 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute32 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,864 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute32 - remove event too 2017-05-06 11:56:46,865 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute32 2017-05-06 11:56:46,865 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute31 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,866 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute31 - remove event too 2017-05-06 11:56:46,866 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute31 2017-05-06 11:56:46,867 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute30 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,867 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute30 - remove event too 2017-05-06 11:56:46,868 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute30 2017-05-06 11:56:46,868 [TRACE] [doorpi.action.handler] unregister Event OnTimeHourUnevenNumber from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,869 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHourUnevenNumber - remove event too 2017-05-06 11:56:46,869 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHourUnevenNumber 2017-05-06 11:56:46,870 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,870 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute - remove event too 2017-05-06 11:56:46,871 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute 2017-05-06 11:56:46,872 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute48 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,872 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute48 - remove event too 2017-05-06 11:56:46,873 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute48 2017-05-06 11:56:46,873 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute49 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,874 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute49 - remove event too 2017-05-06 11:56:46,874 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute49 2017-05-06 11:56:46,875 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute42 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,875 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute42 - remove event too 2017-05-06 11:56:46,875 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute42 2017-05-06 11:56:46,876 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute43 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,876 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute43 - remove event too 2017-05-06 11:56:46,876 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute43 2017-05-06 11:56:46,877 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute40 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,877 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute40 - remove event too 2017-05-06 11:56:46,877 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute40 2017-05-06 11:56:46,878 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute41 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,878 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute41 - remove event too 2017-05-06 11:56:46,878 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute41 2017-05-06 11:56:46,879 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute46 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,879 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute46 - remove event too 2017-05-06 11:56:46,879 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute46 2017-05-06 11:56:46,880 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute47 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,880 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute47 - remove event too 2017-05-06 11:56:46,881 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute47 2017-05-06 11:56:46,881 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute44 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,881 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute44 - remove event too 2017-05-06 11:56:46,882 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute44 2017-05-06 11:56:46,882 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute45 from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,882 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute45 - remove event too 2017-05-06 11:56:46,883 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute45 2017-05-06 11:56:46,883 [TRACE] [doorpi.action.handler] unregister Event OnTimeHourEvenNumber from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,883 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHourEvenNumber - remove event too 2017-05-06 11:56:46,884 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHourEvenNumber 2017-05-06 11:56:46,884 [TRACE] [doorpi.action.handler] unregister Event OnTimeSecondEvenNumber from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,884 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeSecondEvenNumber - remove event too 2017-05-06 11:56:46,885 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeSecondEvenNumber 2017-05-06 11:56:46,885 [TRACE] [doorpi.action.handler] unregister Event OnTimeYear from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,885 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeYear - remove event too 2017-05-06 11:56:46,886 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeYear 2017-05-06 11:56:46,886 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinuteUnevenNumber from doorpi.action.SingleActions.time_tick 2017-05-06 11:56:46,886 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinuteUnevenNumber - remove event too 2017-05-06 11:56:46,887 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinuteUnevenNumber 2017-05-06 11:56:46,887 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed 2017-05-06 11:56:46,888 [TRACE] [doorpi.action.handler] [OKQ6PO] try to fire action WebServerShutdownAction with args () and kwargs {} 2017-05-06 11:56:46,889 [TRACE] [doorpi.action.base] run WebServerShutdownAction with args () and kwargs {} 2017-05-06 11:56:46,889 [TRACE] [doorpi.action.handler] fire Event OnWebServerStop from doorpi.status.webserver asyncron 2017-05-06 11:56:46,890 [TRACE] [doorpi.action.handler] unregister Eventsource doorpi.status.webserver_lib.request_handler and force_unregister is True 2017-05-06 11:56:46,891 [TRACE] [doorpi.action.handler] unregister Event OnWebServerVirtualResource from doorpi.status.webserver_lib.request_handler 2017-05-06 11:56:46,891 [DEBUG] [doorpi.action.handler] no actions for event OnWebServerStop - skip fire_event OnWebServerStop from doorpi.status.webserver 2017-05-06 11:56:46,892 [DEBUG] [doorpi.action.handler] no more sources for event OnWebServerVirtualResource - remove event too 2017-05-06 11:56:46,893 [TRACE] [doorpi.action.handler] event_source doorpi.status.webserver_lib.request_handler was removed for event OnWebServerVirtualResource 2017-05-06 11:56:46,893 [TRACE] [doorpi.action.handler] unregister Event OnWebServerRealResource from doorpi.status.webserver_lib.request_handler 2017-05-06 11:56:46,894 [DEBUG] [doorpi.action.handler] no more sources for event OnWebServerRealResource - remove event too 2017-05-06 11:56:46,894 [TRACE] [doorpi.action.handler] event_source doorpi.status.webserver_lib.request_handler was removed for event OnWebServerRealResource 2017-05-06 11:56:46,894 [TRACE] [doorpi.action.handler] unregister Event OnConfigKeySet from doorpi.status.webserver_lib.request_handler 2017-05-06 11:56:46,895 [DEBUG] [doorpi.action.handler] no more sources for event OnConfigKeySet - remove event too 2017-05-06 11:56:46,895 [TRACE] [doorpi.action.handler] event_source doorpi.status.webserver_lib.request_handler was removed for event OnConfigKeySet 2017-05-06 11:56:46,895 [TRACE] [doorpi.action.handler] unregister Event OnWebServerRequestGet from doorpi.status.webserver_lib.request_handler 2017-05-06 11:56:46,896 [DEBUG] [doorpi.action.handler] no more sources for event OnWebServerRequestGet - remove event too 2017-05-06 11:56:46,896 [TRACE] [doorpi.action.handler] event_source doorpi.status.webserver_lib.request_handler was removed for event OnWebServerRequestGet 2017-05-06 11:56:46,896 [TRACE] [doorpi.action.handler] unregister Event OnWebServerRequestPost from doorpi.status.webserver_lib.request_handler 2017-05-06 11:56:46,897 [DEBUG] [doorpi.action.handler] no more sources for event OnWebServerRequestPost - remove event too 2017-05-06 11:56:46,897 [TRACE] [doorpi.action.handler] event_source doorpi.status.webserver_lib.request_handler was removed for event OnWebServerRequestPost 2017-05-06 11:56:46,897 [TRACE] [doorpi.action.handler] unregister Event OnConfigKeyDelete from doorpi.status.webserver_lib.request_handler 2017-05-06 11:56:46,898 [DEBUG] [doorpi.action.handler] no more sources for event OnConfigKeyDelete - remove event too 2017-05-06 11:56:46,898 [TRACE] [doorpi.action.handler] event_source doorpi.status.webserver_lib.request_handler was removed for event OnConfigKeyDelete 2017-05-06 11:56:46,899 [TRACE] [doorpi.action.handler] unregister Event OnWebServerRequest from doorpi.status.webserver_lib.request_handler 2017-05-06 11:56:46,899 [DEBUG] [doorpi.action.handler] no more sources for event OnWebServerRequest - remove event too 2017-05-06 11:56:46,899 [TRACE] [doorpi.action.handler] event_source doorpi.status.webserver_lib.request_handler was removed for event OnWebServerRequest 2017-05-06 11:56:46,900 [TRACE] [doorpi.action.handler] unregister Event OnFireEvent from doorpi.status.webserver_lib.request_handler 2017-05-06 11:56:46,900 [DEBUG] [doorpi.action.handler] no more sources for event OnFireEvent - remove event too 2017-05-06 11:56:46,900 [TRACE] [doorpi.action.handler] event_source doorpi.status.webserver_lib.request_handler was removed for event OnFireEvent 2017-05-06 11:56:46,901 [TRACE] [doorpi.action.handler] event_source doorpi.status.webserver_lib.request_handler was removed 2017-05-06 11:56:46,910 [TRACE] [doorpi.action.handler] unregister Eventsource doorpi.status.webserver and force_unregister is True 2017-05-06 11:56:46,912 [TRACE] [doorpi.action.handler] [WVYQM7] finished fire_event for event_name OnWebServerStart 2017-05-06 11:56:46,912 [TRACE] [doorpi.action.handler] unregister Event OnWebServerStop from doorpi.status.webserver 2017-05-06 11:56:46,913 [DEBUG] [doorpi.action.handler] no more sources for event OnWebServerStop - remove event too 2017-05-06 11:56:46,914 [TRACE] [doorpi.action.handler] event_source doorpi.status.webserver was removed for event OnWebServerStop 2017-05-06 11:56:46,914 [TRACE] [doorpi.action.handler] unregister Event OnWebServerStart from doorpi.status.webserver 2017-05-06 11:56:46,915 [DEBUG] [doorpi.action.handler] no more sources for event OnWebServerStart - remove event too 2017-05-06 11:56:46,915 [TRACE] [doorpi.action.handler] event_source doorpi.status.webserver was removed for event OnWebServerStart 2017-05-06 11:56:46,916 [TRACE] [doorpi.action.handler] event_source doorpi.status.webserver was removed 2017-05-06 11:56:46,916 [TRACE] [doorpi.action.handler] [OKQ6PO] try to fire action KeyboardDestroyAction with args () and kwargs {} 2017-05-06 11:56:46,917 [TRACE] [doorpi.action.base] run KeyboardDestroyAction with args () and kwargs {} 2017-05-06 11:56:46,917 [DEBUG] [doorpi.keyboard.from_rdm6300] destroy 2017-05-06 11:56:46,918 [TRACE] [doorpi.action.handler] unregister Eventsource doorpi.keyboard.from_rdm6300 and force_unregister is True 2017-05-06 11:56:46,918 [TRACE] [doorpi.action.handler] unregister Event OnKeyUp_rfidreader.5057884 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:46,918 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyUp_rfidreader.5057884 - remove event too 2017-05-06 11:56:46,919 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_rdm6300 was removed for event OnKeyUp_rfidreader.5057884 2017-05-06 11:56:46,919 [TRACE] [doorpi.action.handler] unregister Event OnKeyPressed_rfidreader.4983309 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:46,919 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyPressed_rfidreader.4983309 - remove event too 2017-05-06 11:56:46,920 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_rdm6300 was removed for event OnKeyPressed_rfidreader.4983309 2017-05-06 11:56:46,920 [TRACE] [doorpi.action.handler] unregister Event OnKeyDown_rfidreader.4983309 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:46,921 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyDown_rfidreader.4983309 - remove event too 2017-05-06 11:56:46,921 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_rdm6300 was removed for event OnKeyDown_rfidreader.4983309 2017-05-06 11:56:46,921 [TRACE] [doorpi.action.handler] unregister Event OnKeyUp_4895755 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:46,922 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyUp_4895755 - remove event too 2017-05-06 11:56:46,922 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_rdm6300 was removed for event OnKeyUp_4895755 2017-05-06 11:56:46,922 [TRACE] [doorpi.action.handler] unregister Event OnKeyPressed from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:46,923 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_rdm6300 was removed for event OnKeyPressed 2017-05-06 11:56:46,923 [TRACE] [doorpi.action.handler] unregister Event OnFoundUnknownTag from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:46,923 [DEBUG] [doorpi.action.handler] no more sources for event OnFoundUnknownTag - remove event too 2017-05-06 11:56:46,924 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_rdm6300 was removed for event OnFoundUnknownTag 2017-05-06 11:56:46,924 [TRACE] [doorpi.action.handler] unregister Event OnKeyUp from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:46,924 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_rdm6300 was removed for event OnKeyUp 2017-05-06 11:56:46,925 [TRACE] [doorpi.action.handler] unregister Event OnFoundKnownTag from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:46,925 [DEBUG] [doorpi.action.handler] no more sources for event OnFoundKnownTag - remove event too 2017-05-06 11:56:46,926 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_rdm6300 was removed for event OnFoundKnownTag 2017-05-06 11:56:46,926 [TRACE] [doorpi.action.handler] unregister Event OnKeyPressed_4915036 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:46,926 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyPressed_4915036 - remove event too 2017-05-06 11:56:46,927 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_rdm6300 was removed for event OnKeyPressed_4915036 2017-05-06 11:56:46,927 [TRACE] [doorpi.action.handler] unregister Event OnFoundTag from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:46,927 [DEBUG] [doorpi.action.handler] no more sources for event OnFoundTag - remove event too 2017-05-06 11:56:46,928 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_rdm6300 was removed for event OnFoundTag 2017-05-06 11:56:46,928 [TRACE] [doorpi.action.handler] unregister Event OnKeyDown_4916638 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:46,928 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyDown_4916638 - remove event too 2017-05-06 11:56:46,929 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_rdm6300 was removed for event OnKeyDown_4916638 2017-05-06 11:56:46,929 [TRACE] [doorpi.action.handler] unregister Event OnKeyDown_4895755 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:46,929 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyDown_4895755 - remove event too 2017-05-06 11:56:46,930 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_rdm6300 was removed for event OnKeyDown_4895755 2017-05-06 11:56:46,930 [TRACE] [doorpi.action.handler] unregister Event OnKeyPressed_4895755 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:46,930 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyPressed_4895755 - remove event too 2017-05-06 11:56:46,931 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_rdm6300 was removed for event OnKeyPressed_4895755 2017-05-06 11:56:46,931 [TRACE] [doorpi.action.handler] unregister Event OnKeyUp_rfidreader.4895755 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:46,931 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyUp_rfidreader.4895755 - remove event too 2017-05-06 11:56:46,932 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_rdm6300 was removed for event OnKeyUp_rfidreader.4895755 2017-05-06 11:56:46,932 [TRACE] [doorpi.action.handler] unregister Event OnKeyDown_4915036 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:46,933 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyDown_4915036 - remove event too 2017-05-06 11:56:46,933 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_rdm6300 was removed for event OnKeyDown_4915036 2017-05-06 11:56:46,933 [TRACE] [doorpi.action.handler] unregister Event OnKeyPressed_4916638 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:46,934 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyPressed_4916638 - remove event too 2017-05-06 11:56:46,934 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_rdm6300 was removed for event OnKeyPressed_4916638 2017-05-06 11:56:46,934 [TRACE] [doorpi.action.handler] unregister Event OnKeyUp_4915036 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:46,935 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyUp_4915036 - remove event too 2017-05-06 11:56:46,935 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_rdm6300 was removed for event OnKeyUp_4915036 2017-05-06 11:56:46,935 [TRACE] [doorpi.action.handler] unregister Event OnKeyDown_5057884 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:46,936 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyDown_5057884 - remove event too 2017-05-06 11:56:46,936 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_rdm6300 was removed for event OnKeyDown_5057884 2017-05-06 11:56:46,936 [TRACE] [doorpi.action.handler] unregister Event OnKeyDown from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:46,937 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_rdm6300 was removed for event OnKeyDown 2017-05-06 11:56:46,937 [TRACE] [doorpi.action.handler] unregister Event OnKeyUp_4983309 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:46,937 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyUp_4983309 - remove event too 2017-05-06 11:56:46,938 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_rdm6300 was removed for event OnKeyUp_4983309 2017-05-06 11:56:46,938 [TRACE] [doorpi.action.handler] unregister Event OnKeyUp_rfidreader.4983309 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:46,938 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyUp_rfidreader.4983309 - remove event too 2017-05-06 11:56:46,939 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_rdm6300 was removed for event OnKeyUp_rfidreader.4983309 2017-05-06 11:56:46,939 [TRACE] [doorpi.action.handler] unregister Event OnKeyUp_4916638 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:46,940 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyUp_4916638 - remove event too 2017-05-06 11:56:46,940 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_rdm6300 was removed for event OnKeyUp_4916638 2017-05-06 11:56:46,940 [TRACE] [doorpi.action.handler] unregister Event OnKeyUp_5057884 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:46,941 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyUp_5057884 - remove event too 2017-05-06 11:56:46,941 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_rdm6300 was removed for event OnKeyUp_5057884 2017-05-06 11:56:46,941 [TRACE] [doorpi.action.handler] unregister Event OnKeyDown_rfidreader.5057884 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:46,942 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyDown_rfidreader.5057884 - remove event too 2017-05-06 11:56:46,942 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_rdm6300 was removed for event OnKeyDown_rfidreader.5057884 2017-05-06 11:56:46,942 [TRACE] [doorpi.action.handler] unregister Event OnKeyPressed_rfidreader.4895755 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:46,943 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyPressed_rfidreader.4895755 - remove event too 2017-05-06 11:56:46,943 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_rdm6300 was removed for event OnKeyPressed_rfidreader.4895755 2017-05-06 11:56:46,943 [TRACE] [doorpi.action.handler] unregister Event OnKeyPressed_rfidreader.4915036 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:46,944 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyPressed_rfidreader.4915036 - remove event too 2017-05-06 11:56:46,944 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_rdm6300 was removed for event OnKeyPressed_rfidreader.4915036 2017-05-06 11:56:46,944 [TRACE] [doorpi.action.handler] unregister Event OnKeyDown_rfidreader.4916638 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:46,945 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyDown_rfidreader.4916638 - remove event too 2017-05-06 11:56:46,945 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_rdm6300 was removed for event OnKeyDown_rfidreader.4916638 2017-05-06 11:56:46,945 [TRACE] [doorpi.action.handler] unregister Event OnKeyUp_rfidreader.4915036 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:46,946 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyUp_rfidreader.4915036 - remove event too 2017-05-06 11:56:46,946 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_rdm6300 was removed for event OnKeyUp_rfidreader.4915036 2017-05-06 11:56:46,947 [TRACE] [doorpi.action.handler] unregister Event OnKeyDown_rfidreader.4915036 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:46,947 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyDown_rfidreader.4915036 - remove event too 2017-05-06 11:56:46,947 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_rdm6300 was removed for event OnKeyDown_rfidreader.4915036 2017-05-06 11:56:46,948 [TRACE] [doorpi.action.handler] unregister Event OnKeyPressed_5057884 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:46,948 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyPressed_5057884 - remove event too 2017-05-06 11:56:46,948 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_rdm6300 was removed for event OnKeyPressed_5057884 2017-05-06 11:56:46,949 [TRACE] [doorpi.action.handler] unregister Event OnKeyDown_rfidreader.4895755 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:46,949 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyDown_rfidreader.4895755 - remove event too 2017-05-06 11:56:46,949 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_rdm6300 was removed for event OnKeyDown_rfidreader.4895755 2017-05-06 11:56:46,950 [TRACE] [doorpi.action.handler] unregister Event OnKeyUp_rfidreader.4916638 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:46,950 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyUp_rfidreader.4916638 - remove event too 2017-05-06 11:56:46,950 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_rdm6300 was removed for event OnKeyUp_rfidreader.4916638 2017-05-06 11:56:46,951 [TRACE] [doorpi.action.handler] unregister Event OnKeyPressed_rfidreader.5057884 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:46,951 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyPressed_rfidreader.5057884 - remove event too 2017-05-06 11:56:46,951 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_rdm6300 was removed for event OnKeyPressed_rfidreader.5057884 2017-05-06 11:56:46,952 [TRACE] [doorpi.action.handler] unregister Event OnKeyPressed_4983309 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:46,952 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyPressed_4983309 - remove event too 2017-05-06 11:56:46,952 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_rdm6300 was removed for event OnKeyPressed_4983309 2017-05-06 11:56:46,953 [TRACE] [doorpi.action.handler] unregister Event OnKeyDown_4983309 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:46,953 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyDown_4983309 - remove event too 2017-05-06 11:56:46,954 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_rdm6300 was removed for event OnKeyDown_4983309 2017-05-06 11:56:46,954 [TRACE] [doorpi.action.handler] unregister Event OnKeyPressed_rfidreader.4916638 from doorpi.keyboard.from_rdm6300 2017-05-06 11:56:46,954 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyPressed_rfidreader.4916638 - remove event too 2017-05-06 11:56:46,955 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_rdm6300 was removed for event OnKeyPressed_rfidreader.4916638 2017-05-06 11:56:46,955 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_rdm6300 was removed 2017-05-06 11:56:46,956 [TRACE] [doorpi.action.handler] [OKQ6PO] try to fire action KeyboardDestroyAction with args () and kwargs {} 2017-05-06 11:56:46,956 [TRACE] [doorpi.action.base] run KeyboardDestroyAction with args () and kwargs {} 2017-05-06 11:56:46,956 [DEBUG] [doorpi.keyboard.from_filesystem] destroy 2017-05-06 11:56:47,651 [DEBUG] [doorpi.keyboard.from_rdm6300] readUART thread ended 2017-05-06 11:56:47,751 [TRACE] [doorpi.action.handler] unregister Eventsource doorpi.keyboard.from_filesystem and force_unregister is True 2017-05-06 11:56:47,752 [TRACE] [doorpi.action.handler] unregister Event OnKeyDown_doorlock from doorpi.keyboard.from_filesystem 2017-05-06 11:56:47,752 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyDown_doorlock - remove event too 2017-05-06 11:56:47,753 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_filesystem was removed for event OnKeyDown_doorlock 2017-05-06 11:56:47,753 [TRACE] [doorpi.action.handler] unregister Event OnKeyUp_vkboard.internal from doorpi.keyboard.from_filesystem 2017-05-06 11:56:47,754 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyUp_vkboard.internal - remove event too 2017-05-06 11:56:47,754 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_filesystem was removed for event OnKeyUp_vkboard.internal 2017-05-06 11:56:47,754 [TRACE] [doorpi.action.handler] unregister Event OnKeyUp_internal from doorpi.keyboard.from_filesystem 2017-05-06 11:56:47,755 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyUp_internal - remove event too 2017-05-06 11:56:47,755 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_filesystem was removed for event OnKeyUp_internal 2017-05-06 11:56:47,755 [TRACE] [doorpi.action.handler] unregister Event OnKeyPressed_vkboard.dooropen from doorpi.keyboard.from_filesystem 2017-05-06 11:56:47,756 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyPressed_vkboard.dooropen - remove event too 2017-05-06 11:56:47,756 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_filesystem was removed for event OnKeyPressed_vkboard.dooropen 2017-05-06 11:56:47,756 [TRACE] [doorpi.action.handler] unregister Event OnKeyPressed from doorpi.keyboard.from_filesystem 2017-05-06 11:56:47,757 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_filesystem was removed for event OnKeyPressed 2017-05-06 11:56:47,757 [TRACE] [doorpi.action.handler] unregister Event OnKeyDown_internal from doorpi.keyboard.from_filesystem 2017-05-06 11:56:47,758 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyDown_internal - remove event too 2017-05-06 11:56:47,758 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_filesystem was removed for event OnKeyDown_internal 2017-05-06 11:56:47,758 [TRACE] [doorpi.action.handler] unregister Event OnKeyUp from doorpi.keyboard.from_filesystem 2017-05-06 11:56:47,759 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_filesystem was removed for event OnKeyUp 2017-05-06 11:56:47,759 [TRACE] [doorpi.action.handler] unregister Event OnKeyUp_doorlock from doorpi.keyboard.from_filesystem 2017-05-06 11:56:47,759 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyUp_doorlock - remove event too 2017-05-06 11:56:47,760 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_filesystem was removed for event OnKeyUp_doorlock 2017-05-06 11:56:47,760 [TRACE] [doorpi.action.handler] unregister Event OnKeyPressed_doorlock from doorpi.keyboard.from_filesystem 2017-05-06 11:56:47,760 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyPressed_doorlock - remove event too 2017-05-06 11:56:47,761 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_filesystem was removed for event OnKeyPressed_doorlock 2017-05-06 11:56:47,761 [TRACE] [doorpi.action.handler] unregister Event OnKeyDown_vkboard.dooropen from doorpi.keyboard.from_filesystem 2017-05-06 11:56:47,761 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyDown_vkboard.dooropen - remove event too 2017-05-06 11:56:47,762 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_filesystem was removed for event OnKeyDown_vkboard.dooropen 2017-05-06 11:56:47,762 [TRACE] [doorpi.action.handler] unregister Event OnKeyPressed_vkboard.external from doorpi.keyboard.from_filesystem 2017-05-06 11:56:47,763 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyPressed_vkboard.external - remove event too 2017-05-06 11:56:47,763 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_filesystem was removed for event OnKeyPressed_vkboard.external 2017-05-06 11:56:47,763 [TRACE] [doorpi.action.handler] unregister Event OnKeyPressed_dooropen from doorpi.keyboard.from_filesystem 2017-05-06 11:56:47,764 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyPressed_dooropen - remove event too 2017-05-06 11:56:47,764 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_filesystem was removed for event OnKeyPressed_dooropen 2017-05-06 11:56:47,764 [TRACE] [doorpi.action.handler] unregister Event OnKeyDown_vkboard.internal from doorpi.keyboard.from_filesystem 2017-05-06 11:56:47,765 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyDown_vkboard.internal - remove event too 2017-05-06 11:56:47,765 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_filesystem was removed for event OnKeyDown_vkboard.internal 2017-05-06 11:56:47,766 [TRACE] [doorpi.action.handler] unregister Event OnKeyUp_dooropen from doorpi.keyboard.from_filesystem 2017-05-06 11:56:47,766 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyUp_dooropen - remove event too 2017-05-06 11:56:47,766 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_filesystem was removed for event OnKeyUp_dooropen 2017-05-06 11:56:47,767 [TRACE] [doorpi.action.handler] unregister Event OnKeyPressed_external from doorpi.keyboard.from_filesystem 2017-05-06 11:56:47,767 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyPressed_external - remove event too 2017-05-06 11:56:47,767 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_filesystem was removed for event OnKeyPressed_external 2017-05-06 11:56:47,768 [TRACE] [doorpi.action.handler] unregister Event OnKeyPressed_internal from doorpi.keyboard.from_filesystem 2017-05-06 11:56:47,768 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyPressed_internal - remove event too 2017-05-06 11:56:47,768 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_filesystem was removed for event OnKeyPressed_internal 2017-05-06 11:56:47,769 [TRACE] [doorpi.action.handler] unregister Event OnKeyPressed_vkboard.internal from doorpi.keyboard.from_filesystem 2017-05-06 11:56:47,769 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyPressed_vkboard.internal - remove event too 2017-05-06 11:56:47,769 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_filesystem was removed for event OnKeyPressed_vkboard.internal 2017-05-06 11:56:47,770 [TRACE] [doorpi.action.handler] unregister Event OnKeyDown from doorpi.keyboard.from_filesystem 2017-05-06 11:56:47,770 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_filesystem was removed for event OnKeyDown 2017-05-06 11:56:47,770 [TRACE] [doorpi.action.handler] unregister Event OnKeyPressed_vkboard.doorlock from doorpi.keyboard.from_filesystem 2017-05-06 11:56:47,771 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyPressed_vkboard.doorlock - remove event too 2017-05-06 11:56:47,771 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_filesystem was removed for event OnKeyPressed_vkboard.doorlock 2017-05-06 11:56:47,772 [TRACE] [doorpi.action.handler] unregister Event OnKeyDown_vkboard.doorlock from doorpi.keyboard.from_filesystem 2017-05-06 11:56:47,772 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyDown_vkboard.doorlock - remove event too 2017-05-06 11:56:47,772 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_filesystem was removed for event OnKeyDown_vkboard.doorlock 2017-05-06 11:56:47,773 [TRACE] [doorpi.action.handler] unregister Event OnKeyDown_vkboard.external from doorpi.keyboard.from_filesystem 2017-05-06 11:56:47,773 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyDown_vkboard.external - remove event too 2017-05-06 11:56:47,773 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_filesystem was removed for event OnKeyDown_vkboard.external 2017-05-06 11:56:47,774 [TRACE] [doorpi.action.handler] unregister Event OnKeyUp_vkboard.doorlock from doorpi.keyboard.from_filesystem 2017-05-06 11:56:47,774 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyUp_vkboard.doorlock - remove event too 2017-05-06 11:56:47,774 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_filesystem was removed for event OnKeyUp_vkboard.doorlock 2017-05-06 11:56:47,775 [TRACE] [doorpi.action.handler] unregister Event OnKeyDown_external from doorpi.keyboard.from_filesystem 2017-05-06 11:56:47,775 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyDown_external - remove event too 2017-05-06 11:56:47,776 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_filesystem was removed for event OnKeyDown_external 2017-05-06 11:56:47,776 [TRACE] [doorpi.action.handler] unregister Event OnKeyUp_external from doorpi.keyboard.from_filesystem 2017-05-06 11:56:47,776 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyUp_external - remove event too 2017-05-06 11:56:47,777 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_filesystem was removed for event OnKeyUp_external 2017-05-06 11:56:47,777 [TRACE] [doorpi.action.handler] unregister Event OnKeyUp_vkboard.external from doorpi.keyboard.from_filesystem 2017-05-06 11:56:47,777 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyUp_vkboard.external - remove event too 2017-05-06 11:56:47,778 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_filesystem was removed for event OnKeyUp_vkboard.external 2017-05-06 11:56:47,778 [TRACE] [doorpi.action.handler] unregister Event OnKeyDown_dooropen from doorpi.keyboard.from_filesystem 2017-05-06 11:56:47,778 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyDown_dooropen - remove event too 2017-05-06 11:56:47,779 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_filesystem was removed for event OnKeyDown_dooropen 2017-05-06 11:56:47,779 [TRACE] [doorpi.action.handler] unregister Event OnKeyUp_vkboard.dooropen from doorpi.keyboard.from_filesystem 2017-05-06 11:56:47,779 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyUp_vkboard.dooropen - remove event too 2017-05-06 11:56:47,780 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_filesystem was removed for event OnKeyUp_vkboard.dooropen 2017-05-06 11:56:47,780 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_filesystem was removed 2017-05-06 11:56:47,781 [TRACE] [doorpi.action.handler] [OKQ6PO] try to fire action KeyboardDestroyAction with args () and kwargs {} 2017-05-06 11:56:47,781 [TRACE] [doorpi.action.base] run KeyboardDestroyAction with args () and kwargs {} 2017-05-06 11:56:47,782 [DEBUG] [doorpi.keyboard.from_gpio] destroy 2017-05-06 11:56:47,786 [TRACE] [doorpi.action.handler] unregister Eventsource doorpi.keyboard.from_gpio and force_unregister is True 2017-05-06 11:56:47,786 [TRACE] [doorpi.action.handler] unregister Event OnKeyDown_11 from doorpi.keyboard.from_gpio 2017-05-06 11:56:47,787 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyDown_11 - remove event too 2017-05-06 11:56:47,788 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_gpio was removed for event OnKeyDown_11 2017-05-06 11:56:47,788 [TRACE] [doorpi.action.handler] unregister Event OnKeyDown_onboardpins.11 from doorpi.keyboard.from_gpio 2017-05-06 11:56:47,789 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyDown_onboardpins.11 - remove event too 2017-05-06 11:56:47,789 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_gpio was removed for event OnKeyDown_onboardpins.11 2017-05-06 11:56:47,790 [TRACE] [doorpi.action.handler] unregister Event OnKeyPressed from doorpi.keyboard.from_gpio 2017-05-06 11:56:47,790 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyPressed - remove event too 2017-05-06 11:56:47,791 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_gpio was removed for event OnKeyPressed 2017-05-06 11:56:47,792 [TRACE] [doorpi.action.handler] unregister Event OnKeyUp from doorpi.keyboard.from_gpio 2017-05-06 11:56:47,792 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyUp - remove event too 2017-05-06 11:56:47,793 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_gpio was removed for event OnKeyUp 2017-05-06 11:56:47,794 [TRACE] [doorpi.action.handler] unregister Event OnKeyPressed_onboardpins.11 from doorpi.keyboard.from_gpio 2017-05-06 11:56:47,794 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyPressed_onboardpins.11 - remove event too 2017-05-06 11:56:47,795 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_gpio was removed for event OnKeyPressed_onboardpins.11 2017-05-06 11:56:47,796 [TRACE] [doorpi.action.handler] unregister Event OnKeyDown from doorpi.keyboard.from_gpio 2017-05-06 11:56:47,796 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyDown - remove event too 2017-05-06 11:56:47,797 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_gpio was removed for event OnKeyDown 2017-05-06 11:56:47,797 [TRACE] [doorpi.action.handler] unregister Event OnKeyUp_onboardpins.11 from doorpi.keyboard.from_gpio 2017-05-06 11:56:47,798 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyUp_onboardpins.11 - remove event too 2017-05-06 11:56:47,798 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_gpio was removed for event OnKeyUp_onboardpins.11 2017-05-06 11:56:47,799 [TRACE] [doorpi.action.handler] unregister Event OnKeyUp_11 from doorpi.keyboard.from_gpio 2017-05-06 11:56:47,800 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyUp_11 - remove event too 2017-05-06 11:56:47,800 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_gpio was removed for event OnKeyUp_11 2017-05-06 11:56:47,801 [TRACE] [doorpi.action.handler] unregister Event OnKeyPressed_11 from doorpi.keyboard.from_gpio 2017-05-06 11:56:47,801 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyPressed_11 - remove event too 2017-05-06 11:56:47,802 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_gpio was removed for event OnKeyPressed_11 2017-05-06 11:56:47,803 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_gpio was removed 2017-05-06 11:56:47,804 [TRACE] [doorpi.action.handler] [OKQ6PO] try to fire action > with args () and kwargs {} 2017-05-06 11:56:47,804 [TRACE] [doorpi.action.base] run SingleAction with args () and kwargs {} 2017-05-06 11:56:47,805 [DEBUG] [doorpi.sipphone.from_linphone] destroy 2017-05-06 11:56:47,806 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_terminate_all_calls(0x7e6a40 [0x72125540]) 2017-05-06 11:56:47,806 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_terminate_all_calls -> 0x51f0bc 2017-05-06 11:56:47,808 [DEBUG] [doorpi.action.handler] [B65GJ8] fire for event OnSipPhoneDestroy this actions [, , ] 2017-05-06 11:56:47,808 [TRACE] [doorpi.action.handler] [B65GJ8] try to fire action > with args () and kwargs {} 2017-05-06 11:56:47,809 [TRACE] [doorpi.action.base] run SingleAction with args () and kwargs {} 2017-05-06 11:56:47,810 [DEBUG] [doorpi.sipphone.linphone_lib.CallBacks] destroy 2017-05-06 11:56:47,810 [TRACE] [doorpi.action.handler] unregister Eventsource doorpi.sipphone.linphone_lib.CallBacks and force_unregister is True 2017-05-06 11:56:47,811 [TRACE] [doorpi.action.handler] unregister Event OnCallReject from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:47,812 [DEBUG] [doorpi.action.handler] no more sources for event OnCallReject - remove event too 2017-05-06 11:56:47,812 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event OnCallReject 2017-05-06 11:56:47,813 [TRACE] [doorpi.action.handler] unregister Event OnMediaNotRequired from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:47,814 [DEBUG] [doorpi.action.handler] no more sources for event OnMediaNotRequired - remove event too 2017-05-06 11:56:47,814 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event OnMediaNotRequired 2017-05-06 11:56:47,815 [TRACE] [doorpi.action.handler] unregister Event OnDTMF from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:47,815 [DEBUG] [doorpi.action.handler] no more sources for event OnDTMF - remove event too 2017-05-06 11:56:47,816 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event OnDTMF 2017-05-06 11:56:47,816 [TRACE] [doorpi.action.handler] unregister Event OnMediaRequired from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:47,817 [DEBUG] [doorpi.action.handler] no more sources for event OnMediaRequired - remove event too 2017-05-06 11:56:47,817 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event OnMediaRequired 2017-05-06 11:56:47,818 [TRACE] [doorpi.action.handler] unregister Event OnCallMediaStateChange from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:47,819 [DEBUG] [doorpi.action.handler] no more sources for event OnCallMediaStateChange - remove event too 2017-05-06 11:56:47,819 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event OnCallMediaStateChange 2017-05-06 11:56:47,820 [TRACE] [doorpi.action.handler] unregister Event AfterCallStateConnect from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:47,820 [DEBUG] [doorpi.action.handler] no more sources for event AfterCallStateConnect - remove event too 2017-05-06 11:56:47,821 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event AfterCallStateConnect 2017-05-06 11:56:47,822 [TRACE] [doorpi.action.handler] unregister Event OnDTMF_"18" from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:47,822 [DEBUG] [doorpi.action.handler] no more sources for event OnDTMF_"18" - remove event too 2017-05-06 11:56:47,823 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event OnDTMF_"18" 2017-05-06 11:56:47,824 [TRACE] [doorpi.action.handler] unregister Event OnCallBusy from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:47,824 [DEBUG] [doorpi.action.handler] no more sources for event OnCallBusy - remove event too 2017-05-06 11:56:47,825 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event OnCallBusy 2017-05-06 11:56:47,825 [TRACE] [doorpi.action.handler] unregister Event OnDTMF_"16" from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:47,826 [DEBUG] [doorpi.action.handler] no more sources for event OnDTMF_"16" - remove event too 2017-05-06 11:56:47,827 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event OnDTMF_"16" 2017-05-06 11:56:47,827 [TRACE] [doorpi.action.handler] unregister Event AfterCallBusy from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:47,828 [DEBUG] [doorpi.action.handler] no more sources for event AfterCallBusy - remove event too 2017-05-06 11:56:47,828 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event AfterCallBusy 2017-05-06 11:56:47,829 [TRACE] [doorpi.action.handler] unregister Event AfterCallStateDisconnect from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:47,829 [DEBUG] [doorpi.action.handler] no more sources for event AfterCallStateDisconnect - remove event too 2017-05-06 11:56:47,830 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event AfterCallStateDisconnect 2017-05-06 11:56:47,830 [TRACE] [doorpi.action.handler] unregister Event OnCallStateReject from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:47,831 [DEBUG] [doorpi.action.handler] no more sources for event OnCallStateReject - remove event too 2017-05-06 11:56:47,832 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event OnCallStateReject 2017-05-06 11:56:47,833 [TRACE] [doorpi.action.handler] unregister Event OnCallStateChange from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:47,833 [DEBUG] [doorpi.action.handler] no more sources for event OnCallStateChange - remove event too 2017-05-06 11:56:47,834 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event OnCallStateChange 2017-05-06 11:56:47,834 [TRACE] [doorpi.action.handler] unregister Event OnCallStateDismissed from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:47,835 [DEBUG] [doorpi.action.handler] no more sources for event OnCallStateDismissed - remove event too 2017-05-06 11:56:47,836 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event OnCallStateDismissed 2017-05-06 11:56:47,836 [TRACE] [doorpi.action.handler] unregister Event OnCallStateDisconnect from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:47,837 [DEBUG] [doorpi.action.handler] no more sources for event OnCallStateDisconnect - remove event too 2017-05-06 11:56:47,837 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event OnCallStateDisconnect 2017-05-06 11:56:47,838 [TRACE] [doorpi.action.handler] unregister Event AfterCallReject from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:47,838 [DEBUG] [doorpi.action.handler] no more sources for event AfterCallReject - remove event too 2017-05-06 11:56:47,839 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event AfterCallReject 2017-05-06 11:56:47,839 [TRACE] [doorpi.action.handler] unregister Event OnCallStart from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:47,840 [DEBUG] [doorpi.action.handler] no more sources for event OnCallStart - remove event too 2017-05-06 11:56:47,841 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event OnCallStart 2017-05-06 11:56:47,841 [TRACE] [doorpi.action.handler] unregister Event OnCallStateConnect from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:47,842 [DEBUG] [doorpi.action.handler] no more sources for event OnCallStateConnect - remove event too 2017-05-06 11:56:47,843 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event OnCallStateConnect 2017-05-06 11:56:47,843 [TRACE] [doorpi.action.handler] unregister Event BeforeCallIncoming from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:47,844 [DEBUG] [doorpi.action.handler] no more sources for event BeforeCallIncoming - remove event too 2017-05-06 11:56:47,844 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event BeforeCallIncoming 2017-05-06 11:56:47,845 [TRACE] [doorpi.action.handler] unregister Event AfterCallReconnect from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:47,845 [DEBUG] [doorpi.action.handler] no more sources for event AfterCallReconnect - remove event too 2017-05-06 11:56:47,846 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event AfterCallReconnect 2017-05-06 11:56:47,846 [TRACE] [doorpi.action.handler] unregister Event OnCallIncoming from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:47,847 [DEBUG] [doorpi.action.handler] no more sources for event OnCallIncoming - remove event too 2017-05-06 11:56:47,847 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event OnCallIncoming 2017-05-06 11:56:47,848 [TRACE] [doorpi.action.handler] unregister Event AfterCallIncoming from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:47,849 [DEBUG] [doorpi.action.handler] no more sources for event AfterCallIncoming - remove event too 2017-05-06 11:56:47,849 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event AfterCallIncoming 2017-05-06 11:56:47,849 [TRACE] [doorpi.action.handler] unregister Event OnCallReconnect from doorpi.sipphone.linphone_lib.CallBacks 2017-05-06 11:56:47,850 [DEBUG] [doorpi.action.handler] no more sources for event OnCallReconnect - remove event too 2017-05-06 11:56:47,850 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event OnCallReconnect 2017-05-06 11:56:47,850 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed 2017-05-06 11:56:47,851 [TRACE] [doorpi.action.handler] [B65GJ8] try to fire action > with args () and kwargs {} 2017-05-06 11:56:47,852 [TRACE] [doorpi.action.base] run SingleAction with args () and kwargs {} 2017-05-06 11:56:47,853 [TRACE] [doorpi.action.handler] fire Event OnPlayerStopped from doorpi.sipphone.linphone_lib.Player asyncron 2017-05-06 11:56:47,854 [TRACE] [doorpi.action.handler] unregister Eventsource doorpi.sipphone.linphone_lib.Player and force_unregister is True 2017-05-06 11:56:47,854 [TRACE] [doorpi.action.handler] unregister Event OnPlayerCreated from doorpi.sipphone.linphone_lib.Player 2017-05-06 11:56:47,855 [DEBUG] [doorpi.action.handler] no actions for event OnPlayerStopped - skip fire_event OnPlayerStopped from doorpi.sipphone.linphone_lib.Player 2017-05-06 11:56:47,855 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.Player was removed for event OnPlayerCreated 2017-05-06 11:56:47,856 [TRACE] [doorpi.action.handler] unregister Event OnPlayerStarted from doorpi.sipphone.linphone_lib.Player 2017-05-06 11:56:47,856 [DEBUG] [doorpi.action.handler] no more sources for event OnPlayerStarted - remove event too 2017-05-06 11:56:47,857 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.Player was removed for event OnPlayerStarted 2017-05-06 11:56:47,857 [TRACE] [doorpi.action.handler] unregister Event OnPlayerStopped from doorpi.sipphone.linphone_lib.Player 2017-05-06 11:56:47,858 [DEBUG] [doorpi.action.handler] no more sources for event OnPlayerStopped - remove event too 2017-05-06 11:56:47,858 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.Player was removed for event OnPlayerStopped 2017-05-06 11:56:47,858 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.Player was removed 2017-05-06 11:56:47,859 [TRACE] [doorpi.action.handler] [B65GJ8] try to fire action > with args () and kwargs {} 2017-05-06 11:56:47,859 [TRACE] [doorpi.action.base] run SingleAction with args () and kwargs {} 2017-05-06 11:56:47,860 [TRACE] [doorpi.action.handler] unregister Eventsource doorpi.sipphone.linphone_lib.Recorder and force_unregister is True 2017-05-06 11:56:47,861 [TRACE] [doorpi.action.handler] unregister Event OnRecorderCreated from doorpi.sipphone.linphone_lib.Recorder 2017-05-06 11:56:47,861 [DEBUG] [doorpi.action.handler] no more sources for event OnRecorderCreated - remove event too 2017-05-06 11:56:47,861 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.Recorder was removed for event OnRecorderCreated 2017-05-06 11:56:47,862 [TRACE] [doorpi.action.handler] unregister Event OnRecorderStarted from doorpi.sipphone.linphone_lib.Recorder 2017-05-06 11:56:47,862 [DEBUG] [doorpi.action.handler] no more sources for event OnRecorderStarted - remove event too 2017-05-06 11:56:47,863 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.Recorder was removed for event OnRecorderStarted 2017-05-06 11:56:47,863 [TRACE] [doorpi.action.handler] unregister Event OnRecorderStopped from doorpi.sipphone.linphone_lib.Recorder 2017-05-06 11:56:47,863 [DEBUG] [doorpi.action.handler] no more sources for event OnRecorderStopped - remove event too 2017-05-06 11:56:47,864 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.Recorder was removed for event OnRecorderStopped 2017-05-06 11:56:47,864 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.Recorder was removed 2017-05-06 11:56:47,865 [TRACE] [doorpi.action.handler] [B65GJ8] finished fire_event for event_name OnSipPhoneDestroy 2017-05-06 11:56:47,865 [TRACE] [doorpi.action.handler] unregister Eventsource doorpi.sipphone.from_linphone and force_unregister is True 2017-05-06 11:56:47,866 [TRACE] [doorpi.action.handler] unregister Event OnSipPhoneMakeCall from doorpi.sipphone.from_linphone 2017-05-06 11:56:47,866 [DEBUG] [doorpi.action.handler] no more sources for event OnSipPhoneMakeCall - remove event too 2017-05-06 11:56:47,866 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.from_linphone was removed for event OnSipPhoneMakeCall 2017-05-06 11:56:47,867 [TRACE] [doorpi.action.handler] unregister Event OnPlayerCreated from doorpi.sipphone.from_linphone 2017-05-06 11:56:47,867 [DEBUG] [doorpi.action.handler] no more sources for event OnPlayerCreated - remove event too 2017-05-06 11:56:47,867 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.from_linphone was removed for event OnPlayerCreated 2017-05-06 11:56:47,868 [TRACE] [doorpi.action.handler] unregister Event BeforeSipPhoneMakeCall from doorpi.sipphone.from_linphone 2017-05-06 11:56:47,868 [DEBUG] [doorpi.action.handler] no more sources for event BeforeSipPhoneMakeCall - remove event too 2017-05-06 11:56:47,869 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.from_linphone was removed for event BeforeSipPhoneMakeCall 2017-05-06 11:56:47,869 [TRACE] [doorpi.action.handler] unregister Event OnSipPhoneRecorderDestroy from doorpi.sipphone.from_linphone 2017-05-06 11:56:47,869 [DEBUG] [doorpi.action.handler] no more sources for event OnSipPhoneRecorderDestroy - remove event too 2017-05-06 11:56:47,870 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.from_linphone was removed for event OnSipPhoneRecorderDestroy 2017-05-06 11:56:47,870 [TRACE] [doorpi.action.handler] unregister Event OnSipPhoneStart from doorpi.sipphone.from_linphone 2017-05-06 11:56:47,870 [DEBUG] [doorpi.action.handler] no more sources for event OnSipPhoneStart - remove event too 2017-05-06 11:56:47,871 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.from_linphone was removed for event OnSipPhoneStart 2017-05-06 11:56:47,871 [TRACE] [doorpi.action.handler] unregister Event OnSipPhoneDestroy from doorpi.sipphone.from_linphone 2017-05-06 11:56:47,871 [DEBUG] [doorpi.action.handler] no more sources for event OnSipPhoneDestroy - remove event too 2017-05-06 11:56:47,872 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.from_linphone was removed for event OnSipPhoneDestroy 2017-05-06 11:56:47,872 [TRACE] [doorpi.action.handler] unregister Event OnSipPhoneCallTimeoutMaxCalltime from doorpi.sipphone.from_linphone 2017-05-06 11:56:47,873 [DEBUG] [doorpi.action.handler] no more sources for event OnSipPhoneCallTimeoutMaxCalltime - remove event too 2017-05-06 11:56:47,873 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.from_linphone was removed for event OnSipPhoneCallTimeoutMaxCalltime 2017-05-06 11:56:47,873 [TRACE] [doorpi.action.handler] unregister Event OnSipPhoneCallTimeoutNoResponse from doorpi.sipphone.from_linphone 2017-05-06 11:56:47,874 [DEBUG] [doorpi.action.handler] no more sources for event OnSipPhoneCallTimeoutNoResponse - remove event too 2017-05-06 11:56:47,874 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.from_linphone was removed for event OnSipPhoneCallTimeoutNoResponse 2017-05-06 11:56:47,874 [TRACE] [doorpi.action.handler] unregister Event AfterSipPhoneMakeCall from doorpi.sipphone.from_linphone 2017-05-06 11:56:47,875 [DEBUG] [doorpi.action.handler] no more sources for event AfterSipPhoneMakeCall - remove event too 2017-05-06 11:56:47,875 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.from_linphone was removed for event AfterSipPhoneMakeCall 2017-05-06 11:56:47,875 [TRACE] [doorpi.action.handler] unregister Event OnSipPhoneMakeCallFailed from doorpi.sipphone.from_linphone 2017-05-06 11:56:47,876 [DEBUG] [doorpi.action.handler] no more sources for event OnSipPhoneMakeCallFailed - remove event too 2017-05-06 11:56:47,876 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.from_linphone was removed for event OnSipPhoneMakeCallFailed 2017-05-06 11:56:47,876 [TRACE] [doorpi.action.handler] unregister Event OnSipPhoneCreate from doorpi.sipphone.from_linphone 2017-05-06 11:56:47,877 [DEBUG] [doorpi.action.handler] no more sources for event OnSipPhoneCreate - remove event too 2017-05-06 11:56:47,877 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.from_linphone was removed for event OnSipPhoneCreate 2017-05-06 11:56:47,878 [TRACE] [doorpi.action.handler] unregister Event OnSipPhoneRecorderCreate from doorpi.sipphone.from_linphone 2017-05-06 11:56:47,878 [DEBUG] [doorpi.action.handler] no more sources for event OnSipPhoneRecorderCreate - remove event too 2017-05-06 11:56:47,878 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.from_linphone was removed for event OnSipPhoneRecorderCreate 2017-05-06 11:56:47,879 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.from_linphone was removed 2017-05-06 11:56:47,879 [TRACE] [doorpi.action.handler] [OKQ6PO] finished fire_event for event_name OnShutdown 2017-05-06 11:56:47,880 [TRACE] [doorpi.action.handler] fire Event AfterShutdown from doorpi.doorpi asyncron 2017-05-06 11:56:47,881 [DEBUG] [doorpi.action.handler] no actions for event AfterShutdown - skip fire_event AfterShutdown from doorpi.doorpi 2017-05-06 11:56:48,382 [INFO] [doorpi.doorpi] ======== DoorPi successfully shutdown ========