2018-10-09 18:59:05,730 [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 2018-10-09 18:59:05,732 [DEBUG] [doorpi.main] loaded with arguments: ['/usr/local/bin/doorpi_cli', '--trace'] 2018-10-09 18:59:05,735 [DEBUG] [doorpi.doorpi] run 2018-10-09 18:59:05,736 [DEBUG] [doorpi.doorpi] prepare 2018-10-09 18:59:05,738 [DEBUG] [doorpi.doorpi] given arguments argv: Namespace(configfile=None, debug=False, test=False, trace=True) 2018-10-09 18:59:05,748 [INFO] [doorpi.conf.config_object] use configfile: /usr/local/etc/DoorPi/conf/doorpi.ini 2018-10-09 18:59:05,766 [DEBUG] [doorpi.conf.config_object] __init__ 2018-10-09 18:59:05,768 [TRACE] [doorpi.conf.config_object] get_from_config 2018-10-09 18:59:05,780 [TRACE] [doorpi.conf.config_object] get_string for key base_path in section DoorPi (default: /usr/local/etc/DoorPi) returns /usr/local/etc/DoorPi 2018-10-09 18:59:05,782 [TRACE] [doorpi.conf.config_object] get_string for key eventlog in section DoorPi (default: !BASEPATH!/conf/eventlog.db) returns !BASEPATH!/conf/eventlog.db 2018-10-09 18:59:05,785 [DEBUG] [doorpi.conf.config_object] parse string "!BASEPATH!/conf/eventlog.db" to "/usr/local/etc/DoorPi/conf/eventlog.db" 2018-10-09 18:59:05,792 [TRACE] [doorpi.action.handler] register Event BeforeStartup from doorpi.doorpi 2018-10-09 18:59:05,794 [DEBUG] [doorpi.action.handler] event_source doorpi.doorpi was added 2018-10-09 18:59:05,796 [TRACE] [doorpi.action.handler] added event_name BeforeStartup and registered source doorpi.doorpi 2018-10-09 18:59:05,797 [TRACE] [doorpi.action.handler] register Event OnStartup from doorpi.doorpi 2018-10-09 18:59:05,798 [TRACE] [doorpi.action.handler] added event_name OnStartup and registered source doorpi.doorpi 2018-10-09 18:59:05,800 [TRACE] [doorpi.action.handler] register Event AfterStartup from doorpi.doorpi 2018-10-09 18:59:05,801 [TRACE] [doorpi.action.handler] added event_name AfterStartup and registered source doorpi.doorpi 2018-10-09 18:59:05,803 [TRACE] [doorpi.action.handler] register Event BeforeShutdown from doorpi.doorpi 2018-10-09 18:59:05,804 [TRACE] [doorpi.action.handler] added event_name BeforeShutdown and registered source doorpi.doorpi 2018-10-09 18:59:05,806 [TRACE] [doorpi.action.handler] register Event OnShutdown from doorpi.doorpi 2018-10-09 18:59:05,807 [TRACE] [doorpi.action.handler] added event_name OnShutdown and registered source doorpi.doorpi 2018-10-09 18:59:05,809 [TRACE] [doorpi.action.handler] register Event AfterShutdown from doorpi.doorpi 2018-10-09 18:59:05,810 [TRACE] [doorpi.action.handler] added event_name AfterShutdown and registered source doorpi.doorpi 2018-10-09 18:59:05,814 [DEBUG] [doorpi.action.SingleActions.time_tick] doorpi.action.SingleActions.time_tick loaded 2018-10-09 18:59:05,817 [DEBUG] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was added 2018-10-09 18:59:05,828 [TRACE] [doorpi.action.handler] action TimeTickDestroyAction with args () and kwargs {} was added to new evententry OnShutdown 2018-10-09 18:59:05,830 [TRACE] [doorpi.action.handler] action TimeTickAction with args ('!last_tick!',) and kwargs {} was added to new evententry OnTimeTick 2018-10-09 18:59:05,832 [TRACE] [doorpi.conf.config_object] get_string for key ip in section DoorPiWeb (default: ) returns 192.168.6.54 2018-10-09 18:59:05,833 [TRACE] [doorpi.conf.config_object] get_integer for key port in section DoorPiWeb (default: 80) returns 80 2018-10-09 18:59:05,967 [INFO] [doorpi.status.webserver] Initiating WebService at ip 192.168.6.54 and port 80 2018-10-09 18:59:05,969 [TRACE] [doorpi.action.handler] register Event OnWebServerStart from doorpi.status.webserver 2018-10-09 18:59:05,970 [DEBUG] [doorpi.action.handler] event_source doorpi.status.webserver was added 2018-10-09 18:59:05,972 [TRACE] [doorpi.action.handler] added event_name OnWebServerStart and registered source doorpi.status.webserver 2018-10-09 18:59:05,973 [TRACE] [doorpi.action.handler] register Event OnWebServerStop from doorpi.status.webserver 2018-10-09 18:59:05,975 [TRACE] [doorpi.action.handler] added event_name OnWebServerStop and registered source doorpi.status.webserver 2018-10-09 18:59:05,976 [TRACE] [doorpi.conf.config_object] get_string for key www in section DoorPiWeb (default: !BASEPATH!/../DoorPiWeb) returns !BASEPATH!/../DoorPiWeb 2018-10-09 18:59:05,980 [DEBUG] [doorpi.conf.config_object] parse string "!BASEPATH!/../DoorPiWeb" to "/usr/local/etc/DoorPi/../DoorPiWeb" 2018-10-09 18:59:05,982 [TRACE] [doorpi.conf.config_object] get_string for key indexfile in section DoorPiWeb (default: index.html) returns index.html 2018-10-09 18:59:05,985 [DEBUG] [doorpi.conf.config_object] parse string "index.html" to "index.html" 2018-10-09 18:59:05,987 [TRACE] [doorpi.conf.config_object] get_string for key loginfile in section DoorPiWeb (default: login.html) returns login.html 2018-10-09 18:59:05,990 [DEBUG] [doorpi.conf.config_object] parse string "login.html" to "login.html" 2018-10-09 18:59:05,992 [TRACE] [doorpi.conf.config_object] get_string for key public in section DoorPiWeb (default: AREA_public) returns AREA_public 2018-10-09 18:59:05,996 [DEBUG] [doorpi.conf.config_object] parse string "AREA_public" to "AREA_public" 2018-10-09 18:59:05,997 [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 2018-10-09 18:59:06,001 [DEBUG] [doorpi.conf.config_object] parse string "http://motom001.github.io/DoorPiWeb" to "http://motom001.github.io/DoorPiWeb" 2018-10-09 18:59:06,003 [WARNING] [root] section WritePermission not found in configfile 2018-10-09 18:59:06,004 [TRACE] [doorpi.conf.config_object] get_keys for section WritePermission returns [] 2018-10-09 18:59:06,006 [WARNING] [root] section ReadPermission not found in configfile 2018-10-09 18:59:06,007 [TRACE] [doorpi.conf.config_object] get_keys for section ReadPermission returns [] 2018-10-09 18:59:06,009 [WARNING] [root] section Group not found in configfile 2018-10-09 18:59:06,011 [TRACE] [doorpi.conf.config_object] get_keys for section Group returns [] 2018-10-09 18:59:06,012 [WARNING] [root] section User not found in configfile 2018-10-09 18:59:06,014 [TRACE] [doorpi.conf.config_object] get_keys for section User returns [] 2018-10-09 18:59:06,015 [TRACE] [doorpi.conf.config_object] get_sections returns ['onboardpins_OutputPins', 'onboardpins_keyboard', 'keyboards', 'SIP-Phone', 'EVENT_OnStartup', 'DoorPiWeb', 'onboardpins_InputPins', 'DoorPi'] 2018-10-09 18:59:06,018 [ERROR] [doorpi.status.webserver] no ReadPermission found 2018-10-09 18:59:06,019 [ERROR] [doorpi.status.webserver] no groups in configfile! 2018-10-09 18:59:06,021 [ERROR] [doorpi.status.webserver] no WritePermission found 2018-10-09 18:59:06,022 [TRACE] [doorpi.action.handler] action WebServerStartupAction with args () and kwargs {} was added to new evententry OnWebServerStart 2018-10-09 18:59:06,024 [TRACE] [doorpi.action.handler] action WebServerShutdownAction with args () and kwargs {} was added to event OnShutdown 2018-10-09 18:59:06,026 [TRACE] [doorpi.action.handler] fire Event OnWebServerStart from doorpi.status.webserver asyncron 2018-10-09 18:59:06,029 [TRACE] [doorpi.action.handler] register Event OnWebServerRequest from doorpi.status.webserver_lib.request_handler 2018-10-09 18:59:06,031 [DEBUG] [doorpi.action.handler] event_source doorpi.status.webserver_lib.request_handler was added 2018-10-09 18:59:06,033 [TRACE] [doorpi.action.handler] added event_name OnWebServerRequest and registered source doorpi.status.webserver_lib.request_handler 2018-10-09 18:59:06,034 [TRACE] [doorpi.action.handler] register Event OnWebServerRequestGet from doorpi.status.webserver_lib.request_handler 2018-10-09 18:59:06,036 [TRACE] [doorpi.action.handler] added event_name OnWebServerRequestGet and registered source doorpi.status.webserver_lib.request_handler 2018-10-09 18:59:06,037 [TRACE] [doorpi.action.handler] register Event OnWebServerRequestPost from doorpi.status.webserver_lib.request_handler 2018-10-09 18:59:06,039 [TRACE] [doorpi.action.handler] added event_name OnWebServerRequestPost and registered source doorpi.status.webserver_lib.request_handler 2018-10-09 18:59:06,043 [DEBUG] [doorpi.action.handler] [G83Q3J] fire for event OnWebServerStart this actions [] 2018-10-09 18:59:06,045 [TRACE] [doorpi.action.handler] [G83Q3J] try to fire action WebServerStartupAction with args () and kwargs {} 2018-10-09 18:59:06,047 [TRACE] [doorpi.action.base] run WebServerStartupAction with args () and kwargs {} 2018-10-09 18:59:06,040 [TRACE] [doorpi.action.handler] register Event OnWebServerVirtualResource from doorpi.status.webserver_lib.request_handler 2018-10-09 18:59:06,050 [TRACE] [doorpi.action.handler] added event_name OnWebServerVirtualResource and registered source doorpi.status.webserver_lib.request_handler 2018-10-09 18:59:06,052 [TRACE] [doorpi.action.handler] register Event OnWebServerRealResource from doorpi.status.webserver_lib.request_handler 2018-10-09 18:59:06,053 [TRACE] [doorpi.action.handler] added event_name OnWebServerRealResource and registered source doorpi.status.webserver_lib.request_handler 2018-10-09 18:59:06,055 [TRACE] [doorpi.action.handler] register Event OnFireEvent from doorpi.status.webserver_lib.request_handler 2018-10-09 18:59:06,056 [TRACE] [doorpi.action.handler] added event_name OnFireEvent and registered source doorpi.status.webserver_lib.request_handler 2018-10-09 18:59:06,058 [TRACE] [doorpi.action.handler] register Event OnConfigKeySet from doorpi.status.webserver_lib.request_handler 2018-10-09 18:59:06,059 [TRACE] [doorpi.action.handler] added event_name OnConfigKeySet and registered source doorpi.status.webserver_lib.request_handler 2018-10-09 18:59:06,061 [TRACE] [doorpi.action.handler] register Event OnConfigKeyDelete from doorpi.status.webserver_lib.request_handler 2018-10-09 18:59:06,063 [TRACE] [doorpi.action.handler] added event_name OnConfigKeyDelete and registered source doorpi.status.webserver_lib.request_handler 2018-10-09 18:59:06,065 [TRACE] [doorpi.conf.config_object] get_keys for section keyboards returns ['onboardpins'] 2018-10-09 18:59:06,068 [INFO] [doorpi.keyboard.KeyboardInterface] using multi-keyboard mode (keyboards: onboardpins) 2018-10-09 18:59:06,070 [INFO] [doorpi.keyboard.KeyboardInterface] trying to add keyboard 'onboardpins' to handler 2018-10-09 18:59:06,072 [TRACE] [doorpi.conf.config_object] get_string for key onboardpins in section keyboards (default: dummy) returns gpio 2018-10-09 18:59:06,074 [TRACE] [doorpi.conf.config_object] get_keys for section onboardpins_InputPins returns ['40'] 2018-10-09 18:59:06,075 [TRACE] [doorpi.conf.config_object] get_keys for section onboardpins_OutputPins returns ['38'] 2018-10-09 18:59:06,077 [TRACE] [doorpi.conf.config_object] get_integer for key bouncetime in section onboardpins_keyboard (default: 2000) returns 100.0 2018-10-09 18:59:06,079 [TRACE] [doorpi.conf.config_object] get_integer for key polarity in section onboardpins_keyboard (default: 0) returns 0 2018-10-09 18:59:06,081 [TRACE] [doorpi.conf.config_object] get_boolean for key pressed_on_keydown in section onboardpins_keyboard (default: True) returns True 2018-10-09 18:59:06,084 [DEBUG] [doorpi.keyboard.from_gpio] doorpi.keyboard.from_gpio loaded 2018-10-09 18:59:06,091 [DEBUG] [doorpi.keyboard.from_gpio] __init__(input_pins = ['40'], output_pins = ['38'], bouncetime = 100.0, polarity = 0) 2018-10-09 18:59:06,093 [DEBUG] [doorpi.conf.config_object] create new key mode in section onboardpins_keyboard with value 'BOARD' 2018-10-09 18:59:06,094 [TRACE] [doorpi.conf.config_object] get_string for key mode in section onboardpins_keyboard (default: BOARD) returns BOARD 2018-10-09 18:59:06,096 [DEBUG] [doorpi.conf.config_object] create new key pull_up_down in section onboardpins_keyboard with value 'PUD_OFF' 2018-10-09 18:59:06,097 [TRACE] [doorpi.conf.config_object] get_string for key pull_up_down in section onboardpins_keyboard (default: PUD_OFF) returns PUD_OFF 2018-10-09 18:59:06,110 [TRACE] [doorpi.action.handler] register Event OnKeyPressed from doorpi.keyboard.from_gpio 2018-10-09 18:59:06,112 [DEBUG] [doorpi.action.handler] event_source doorpi.keyboard.from_gpio was added 2018-10-09 18:59:06,113 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed and registered source doorpi.keyboard.from_gpio 2018-10-09 18:59:06,115 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_40 from doorpi.keyboard.from_gpio 2018-10-09 18:59:06,116 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_40 and registered source doorpi.keyboard.from_gpio 2018-10-09 18:59:06,118 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_onboardpins.40 from doorpi.keyboard.from_gpio 2018-10-09 18:59:06,119 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_onboardpins.40 and registered source doorpi.keyboard.from_gpio 2018-10-09 18:59:06,128 [TRACE] [doorpi.action.handler] register Event OnKeyUp from doorpi.keyboard.from_gpio 2018-10-09 18:59:06,130 [TRACE] [doorpi.action.handler] added event_name OnKeyUp and registered source doorpi.keyboard.from_gpio 2018-10-09 18:59:06,131 [TRACE] [doorpi.action.handler] register Event OnKeyUp_40 from doorpi.keyboard.from_gpio 2018-10-09 18:59:06,133 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_40 and registered source doorpi.keyboard.from_gpio 2018-10-09 18:59:06,134 [TRACE] [doorpi.action.handler] register Event OnKeyUp_onboardpins.40 from doorpi.keyboard.from_gpio 2018-10-09 18:59:06,136 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_onboardpins.40 and registered source doorpi.keyboard.from_gpio 2018-10-09 18:59:06,137 [TRACE] [doorpi.action.handler] register Event OnKeyDown from doorpi.keyboard.from_gpio 2018-10-09 18:59:06,139 [TRACE] [doorpi.action.handler] added event_name OnKeyDown and registered source doorpi.keyboard.from_gpio 2018-10-09 18:59:06,140 [TRACE] [doorpi.action.handler] register Event OnKeyDown_40 from doorpi.keyboard.from_gpio 2018-10-09 18:59:06,158 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_40 and registered source doorpi.keyboard.from_gpio 2018-10-09 18:59:06,160 [TRACE] [doorpi.action.handler] register Event OnKeyDown_onboardpins.40 from doorpi.keyboard.from_gpio 2018-10-09 18:59:06,161 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_onboardpins.40 and registered source doorpi.keyboard.from_gpio 2018-10-09 18:59:06,166 [TRACE] [doorpi.action.handler] action KeyboardDestroyAction with args () and kwargs {} was added to event OnShutdown 2018-10-09 18:59:06,168 [TRACE] [doorpi.conf.config_object] get_keys for section onboardpins_OutputPins returns ['38'] 2018-10-09 18:59:06,169 [TRACE] [doorpi.conf.config_object] get_string for key 38 in section onboardpins_OutputPins (default: ) returns Blink_LED 2018-10-09 18:59:06,183 [DEBUG] [doorpi.status.status_lib.environment] doorpi.status.status_lib.environment loaded 2018-10-09 18:59:06,187 [DEBUG] [doorpi.status.requirements_lib.req_config] doorpi.status.requirements_lib.req_config loaded 2018-10-09 18:59:06,201 [DEBUG] [doorpi.status.requirements_lib.req_sipphone] doorpi.status.requirements_lib.req_sipphone loaded 2018-10-09 18:59:06,205 [DEBUG] [doorpi.sipphone.AbstractBaseClass] doorpi.sipphone.AbstractBaseClass loaded 2018-10-09 18:59:06,317 [DEBUG] [doorpi.status.requirements_lib.req_event_handler] doorpi.status.requirements_lib.req_event_handler loaded 2018-10-09 18:59:06,322 [DEBUG] [doorpi.status.requirements_lib.req_webserver] doorpi.status.requirements_lib.req_webserver loaded 2018-10-09 18:59:06,328 [DEBUG] [doorpi.status.requirements_lib.req_keyboard] doorpi.status.requirements_lib.req_keyboard loaded 2018-10-09 18:59:06,454 [DEBUG] [doorpi.status.requirements_lib.req_system] doorpi.status.requirements_lib.req_system loaded 2018-10-09 18:59:06,472 [INFO] [doorpi.sipphone.SipphoneInterface] found installed sipphone "linphone" and use this as default 2018-10-09 18:59:06,473 [TRACE] [doorpi.conf.config_object] get_string for key sipphonetyp in section SIP-Phone (default: linphone) returns linphone 2018-10-09 18:59:06,477 [DEBUG] [doorpi.sipphone.from_linphone] doorpi.sipphone.from_linphone loaded 2018-10-09 18:59:06,483 [DEBUG] [doorpi.sipphone.linphone_lib.CallBacks] doorpi.sipphone.linphone_lib.CallBacks loaded 2018-10-09 18:59:06,487 [DEBUG] [doorpi.sipphone.linphone_lib.Player] doorpi.sipphone.linphone_lib.Player loaded 2018-10-09 18:59:06,492 [DEBUG] [doorpi.sipphone.linphone_lib.Recorder] doorpi.sipphone.linphone_lib.Recorder loaded 2018-10-09 18:59:06,496 [DEBUG] [doorpi.sipphone.from_linphone] __init__ 2018-10-09 18:59:06,498 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to event OnShutdown 2018-10-09 18:59:06,499 [TRACE] [doorpi.action.handler] register Event OnSipPhoneCreate from doorpi.sipphone.from_linphone 2018-10-09 18:59:06,501 [DEBUG] [doorpi.action.handler] event_source doorpi.sipphone.from_linphone was added 2018-10-09 18:59:06,502 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneCreate and registered source doorpi.sipphone.from_linphone 2018-10-09 18:59:06,504 [TRACE] [doorpi.action.handler] register Event OnSipPhoneStart from doorpi.sipphone.from_linphone 2018-10-09 18:59:06,505 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneStart and registered source doorpi.sipphone.from_linphone 2018-10-09 18:59:06,507 [TRACE] [doorpi.action.handler] register Event OnSipPhoneDestroy from doorpi.sipphone.from_linphone 2018-10-09 18:59:06,508 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneDestroy and registered source doorpi.sipphone.from_linphone 2018-10-09 18:59:06,510 [TRACE] [doorpi.action.handler] register Event OnSipPhoneRecorderCreate from doorpi.sipphone.from_linphone 2018-10-09 18:59:06,511 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneRecorderCreate and registered source doorpi.sipphone.from_linphone 2018-10-09 18:59:06,513 [TRACE] [doorpi.action.handler] register Event OnSipPhoneRecorderDestroy from doorpi.sipphone.from_linphone 2018-10-09 18:59:06,514 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneRecorderDestroy and registered source doorpi.sipphone.from_linphone 2018-10-09 18:59:06,516 [TRACE] [doorpi.action.handler] register Event BeforeSipPhoneMakeCall from doorpi.sipphone.from_linphone 2018-10-09 18:59:06,517 [TRACE] [doorpi.action.handler] added event_name BeforeSipPhoneMakeCall and registered source doorpi.sipphone.from_linphone 2018-10-09 18:59:06,519 [TRACE] [doorpi.action.handler] register Event OnSipPhoneMakeCall from doorpi.sipphone.from_linphone 2018-10-09 18:59:06,520 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneMakeCall and registered source doorpi.sipphone.from_linphone 2018-10-09 18:59:06,522 [TRACE] [doorpi.action.handler] register Event OnSipPhoneMakeCallFailed from doorpi.sipphone.from_linphone 2018-10-09 18:59:06,523 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneMakeCallFailed and registered source doorpi.sipphone.from_linphone 2018-10-09 18:59:06,525 [TRACE] [doorpi.action.handler] register Event AfterSipPhoneMakeCall from doorpi.sipphone.from_linphone 2018-10-09 18:59:06,526 [TRACE] [doorpi.action.handler] added event_name AfterSipPhoneMakeCall and registered source doorpi.sipphone.from_linphone 2018-10-09 18:59:06,528 [TRACE] [doorpi.action.handler] register Event OnSipPhoneCallTimeoutNoResponse from doorpi.sipphone.from_linphone 2018-10-09 18:59:06,529 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneCallTimeoutNoResponse and registered source doorpi.sipphone.from_linphone 2018-10-09 18:59:06,531 [TRACE] [doorpi.action.handler] register Event OnSipPhoneCallTimeoutMaxCalltime from doorpi.sipphone.from_linphone 2018-10-09 18:59:06,532 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneCallTimeoutMaxCalltime and registered source doorpi.sipphone.from_linphone 2018-10-09 18:59:06,534 [TRACE] [doorpi.action.handler] register Event OnPlayerCreated from doorpi.sipphone.from_linphone 2018-10-09 18:59:06,535 [TRACE] [doorpi.action.handler] added event_name OnPlayerCreated and registered source doorpi.sipphone.from_linphone 2018-10-09 18:59:06,537 [DEBUG] [doorpi.sipphone.linphone_lib.CallBacks] __init__ 2018-10-09 18:59:06,539 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to new evententry OnSipPhoneDestroy 2018-10-09 18:59:06,540 [TRACE] [doorpi.action.handler] register Event OnCallMediaStateChange from doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:06,542 [DEBUG] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was added 2018-10-09 18:59:06,544 [TRACE] [doorpi.action.handler] added event_name OnCallMediaStateChange and registered source doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:06,545 [TRACE] [doorpi.action.handler] register Event OnMediaRequired from doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:06,547 [TRACE] [doorpi.action.handler] added event_name OnMediaRequired and registered source doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:06,548 [TRACE] [doorpi.action.handler] register Event OnMediaNotRequired from doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:06,550 [TRACE] [doorpi.action.handler] added event_name OnMediaNotRequired and registered source doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:06,551 [TRACE] [doorpi.action.handler] register Event OnCallStateChange from doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:06,553 [TRACE] [doorpi.action.handler] added event_name OnCallStateChange and registered source doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:06,554 [TRACE] [doorpi.action.handler] register Event OnCallStateConnect from doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:06,556 [TRACE] [doorpi.action.handler] added event_name OnCallStateConnect and registered source doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:06,557 [TRACE] [doorpi.action.handler] register Event AfterCallStateConnect from doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:06,559 [TRACE] [doorpi.action.handler] added event_name AfterCallStateConnect and registered source doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:06,560 [TRACE] [doorpi.action.handler] register Event OnCallStateDisconnect from doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:06,562 [TRACE] [doorpi.action.handler] added event_name OnCallStateDisconnect and registered source doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:06,563 [TRACE] [doorpi.action.handler] register Event AfterCallStateDisconnect from doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:06,565 [TRACE] [doorpi.action.handler] added event_name AfterCallStateDisconnect and registered source doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:06,566 [TRACE] [doorpi.action.handler] register Event OnCallStateDismissed from doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:06,568 [TRACE] [doorpi.action.handler] added event_name OnCallStateDismissed and registered source doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:06,569 [TRACE] [doorpi.action.handler] register Event OnCallStateReject from doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:06,571 [TRACE] [doorpi.action.handler] added event_name OnCallStateReject and registered source doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:06,572 [TRACE] [doorpi.action.handler] register Event OnCallStart from doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:06,574 [TRACE] [doorpi.action.handler] added event_name OnCallStart and registered source doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:06,575 [TRACE] [doorpi.action.handler] register Event OnDTMF from doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:06,577 [TRACE] [doorpi.action.handler] added event_name OnDTMF and registered source doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:06,579 [WARNING] [root] section DTMF not found in configfile 2018-10-09 18:59:06,580 [TRACE] [doorpi.conf.config_object] get_keys for section DTMF returns [] 2018-10-09 18:59:06,582 [TRACE] [doorpi.action.handler] register Event OnCallStart from doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:06,583 [TRACE] [doorpi.action.handler] nothing to do - event OnCallStart from source doorpi.sipphone.linphone_lib.CallBacks is already known 2018-10-09 18:59:06,585 [TRACE] [doorpi.action.handler] register Event BeforeCallIncoming from doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:06,586 [TRACE] [doorpi.action.handler] added event_name BeforeCallIncoming and registered source doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:06,588 [TRACE] [doorpi.action.handler] register Event OnCallReconnect from doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:06,589 [TRACE] [doorpi.action.handler] added event_name OnCallReconnect and registered source doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:06,591 [TRACE] [doorpi.action.handler] register Event AfterCallReconnect from doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:06,592 [TRACE] [doorpi.action.handler] added event_name AfterCallReconnect and registered source doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:06,594 [TRACE] [doorpi.action.handler] register Event OnCallBusy from doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:06,595 [TRACE] [doorpi.action.handler] added event_name OnCallBusy and registered source doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:06,597 [TRACE] [doorpi.action.handler] register Event AfterCallBusy from doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:06,598 [TRACE] [doorpi.action.handler] added event_name AfterCallBusy and registered source doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:06,600 [TRACE] [doorpi.action.handler] register Event OnCallIncoming from doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:06,601 [TRACE] [doorpi.action.handler] added event_name OnCallIncoming and registered source doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:06,603 [TRACE] [doorpi.action.handler] register Event AfterCallIncoming from doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:06,604 [TRACE] [doorpi.action.handler] added event_name AfterCallIncoming and registered source doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:06,606 [TRACE] [doorpi.action.handler] register Event OnCallReject from doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:06,607 [TRACE] [doorpi.action.handler] added event_name OnCallReject and registered source doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:06,609 [TRACE] [doorpi.action.handler] register Event AfterCallReject from doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:06,610 [TRACE] [doorpi.action.handler] added event_name AfterCallReject and registered source doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:06,612 [TRACE] [doorpi.action.handler] fire Event OnCallStart from doorpi.sipphone.linphone_lib.CallBacks asyncron 2018-10-09 18:59:06,616 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_new() 2018-10-09 18:59:06,618 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_new -> 0xb4583f08 2018-10-09 18:59:06,619 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_init() 2018-10-09 18:59:06,623 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_init -> 0xb4583f08 2018-10-09 18:59:06,625 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_class_method_new(0xb44f00c0, "(null)", "(null)") 2018-10-09 18:59:06,626 [INFO] [doorpi.sipphone.from_linphone] Mediastreamer2 factory 2.11.0 (git: 380f221) initialized. 2018-10-09 18:59:06,628 [INFO] [doorpi.sipphone.from_linphone] CPU count set to 1 2018-10-09 18:59:06,622 [DEBUG] [doorpi.action.handler] no actions for event OnCallStart - skip fire_event OnCallStart from doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:06,630 [INFO] [doorpi.sipphone.from_linphone] ms_factory_init() done 2018-10-09 18:59:06,633 [INFO] [doorpi.sipphone.from_linphone] srtp init 2018-10-09 18:59:06,648 [INFO] [doorpi.sipphone.from_linphone] Registering all soundcard handlers 2018-10-09 18:59:06,706 [INFO] [doorpi.sipphone.from_linphone] Card 'ALSA: default device' added ALSA lib conf.c:4974:(snd_config_expand) Unknown parameters 0 ALSA lib control.c:1373:(snd_ctl_open_noupdate) Invalid CTL default:0 2018-10-09 18:59:06,708 [WARNING] [doorpi.sipphone.from_linphone] Could not attach mixer to card: Invalid argument 2018-10-09 18:59:06,715 [INFO] [doorpi.sipphone.from_linphone] Card 'ALSA: bcm2835 ALSA' added ALSA lib conf.c:4974:(snd_config_expand) Unknown parameters 1 ALSA lib control.c:1373:(snd_ctl_open_noupdate) Invalid CTL default:1 2018-10-09 18:59:06,717 [WARNING] [doorpi.sipphone.from_linphone] Could not attach mixer to card: Invalid argument 2018-10-09 18:59:06,742 [INFO] [doorpi.sipphone.from_linphone] Card 'ALSA: USB Audio Device' added 2018-10-09 18:59:06,744 [INFO] [doorpi.sipphone.from_linphone] Registering all webcam handlers 2018-10-09 18:59:06,746 [INFO] [doorpi.sipphone.from_linphone] Webcam V4L2: /dev/video0 added 2018-10-09 18:59:06,748 [INFO] [doorpi.sipphone.from_linphone] Webcam StaticImage: Static picture added 2018-10-09 18:59:06,750 [INFO] [doorpi.sipphone.from_linphone] ms_factory_init_voip() done 2018-10-09 18:59:06,752 [INFO] [doorpi.sipphone.from_linphone] Loading ms plugins from [./lib/mediastreamer/plugins] 2018-10-09 18:59:06,754 [INFO] [doorpi.sipphone.from_linphone] Cannot open directory ./lib/mediastreamer/plugins: No such file or directory 2018-10-09 18:59:06,756 [INFO] [doorpi.sipphone.from_linphone] Initializing LinphoneCore 3.8.0 2018-10-09 18:59:06,757 [INFO] [doorpi.sipphone.from_linphone] Vtable [0x1e39520] registered on core [0x1f4ede8] 2018-10-09 18:59:06,759 [INFO] [doorpi.sipphone.from_linphone] Linphone core [0x1e39520] notifying [global_state_changed] 2018-10-09 18:59:06,761 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_callback_global_state_changed(0x1e39520, 1, "Starting up") 2018-10-09 18:59:06,762 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_callback_global_state_changed 2018-10-09 18:59:06,764 [INFO] [doorpi.sipphone.from_linphone] oRTP-0.24.0 initialized. 2018-10-09 18:59:06,766 [INFO] [doorpi.sipphone.from_linphone] Skiping ms_base_init, because [2] ref 2018-10-09 18:59:06,767 [INFO] [doorpi.sipphone.from_linphone] Skiping ms_voip_init, because [2] ref 2018-10-09 18:59:06,769 [INFO] [doorpi.sipphone.from_linphone] Skiping ms_plugins_init, because [2] ref 2018-10-09 18:59:06,771 [INFO] [doorpi.sipphone.from_linphone] Codec opus/48000 fmtp=[useinbandfec=1; stereo=0; sprop-stereo=0] number=-1, enabled=0) added to default capabilities. 2018-10-09 18:59:06,772 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for SILK 2018-10-09 18:59:06,774 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for SILK 2018-10-09 18:59:06,776 [INFO] [doorpi.sipphone.from_linphone] Codec speex/16000 fmtp=[vbr=on] number=-1, enabled=1) added to default capabilities. 2018-10-09 18:59:06,778 [INFO] [doorpi.sipphone.from_linphone] Codec speex/8000 fmtp=[vbr=on] number=-1, enabled=1) added to default capabilities. 2018-10-09 18:59:06,779 [INFO] [doorpi.sipphone.from_linphone] Codec PCMU/8000 fmtp=[] number=0, enabled=1) added to default capabilities. 2018-10-09 18:59:06,781 [INFO] [doorpi.sipphone.from_linphone] Codec PCMA/8000 fmtp=[] number=8, enabled=1) added to default capabilities. 2018-10-09 18:59:06,783 [INFO] [doorpi.sipphone.from_linphone] Codec GSM/8000 fmtp=[] number=3, enabled=0) added to default capabilities. 2018-10-09 18:59:06,785 [INFO] [doorpi.sipphone.from_linphone] Codec G722/8000 fmtp=[] number=9, enabled=0) added to default capabilities. 2018-10-09 18:59:06,786 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for iLBC 2018-10-09 18:59:06,788 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for iLBC 2018-10-09 18:59:06,790 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for AMR 2018-10-09 18:59:06,791 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for AMR 2018-10-09 18:59:06,793 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for AMR-WB 2018-10-09 18:59:06,795 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for AMR-WB 2018-10-09 18:59:06,796 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for G729 2018-10-09 18:59:06,798 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for G729 2018-10-09 18:59:06,800 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for mpeg4-generic 2018-10-09 18:59:06,802 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for mpeg4-generic 2018-10-09 18:59:06,803 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for mpeg4-generic 2018-10-09 18:59:06,805 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for mpeg4-generic 2018-10-09 18:59:06,806 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for mpeg4-generic 2018-10-09 18:59:06,808 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for mpeg4-generic 2018-10-09 18:59:06,810 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for mpeg4-generic 2018-10-09 18:59:06,812 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for mpeg4-generic 2018-10-09 18:59:06,813 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for mpeg4-generic 2018-10-09 18:59:06,815 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for mpeg4-generic 2018-10-09 18:59:06,816 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for iSAC 2018-10-09 18:59:06,818 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for iSAC 2018-10-09 18:59:06,820 [INFO] [doorpi.sipphone.from_linphone] Codec speex/32000 fmtp=[vbr=on] number=-1, enabled=0) added to default capabilities. 2018-10-09 18:59:06,822 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for SILK 2018-10-09 18:59:06,823 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for SILK 2018-10-09 18:59:06,825 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for SILK 2018-10-09 18:59:06,826 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for SILK 2018-10-09 18:59:06,828 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for SILK 2018-10-09 18:59:06,830 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for SILK 2018-10-09 18:59:06,832 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for G726-16 2018-10-09 18:59:06,833 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for G726-16 2018-10-09 18:59:06,835 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for G726-24 2018-10-09 18:59:06,837 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for G726-24 2018-10-09 18:59:06,838 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for G726-32 2018-10-09 18:59:06,840 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for G726-32 2018-10-09 18:59:06,842 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for G726-40 2018-10-09 18:59:06,844 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for G726-40 2018-10-09 18:59:06,845 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for AAL2-G726-16 2018-10-09 18:59:06,847 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for AAL2-G726-16 2018-10-09 18:59:06,849 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for AAL2-G726-24 2018-10-09 18:59:06,851 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for AAL2-G726-24 2018-10-09 18:59:06,852 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for AAL2-G726-32 2018-10-09 18:59:06,854 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for AAL2-G726-32 2018-10-09 18:59:06,856 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for AAL2-G726-40 2018-10-09 18:59:06,857 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for AAL2-G726-40 2018-10-09 18:59:06,859 [INFO] [doorpi.sipphone.from_linphone] Codec VP8/90000 fmtp=[] number=-1, enabled=1) added to default capabilities. 2018-10-09 18:59:06,861 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for H264 2018-10-09 18:59:06,863 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for MP4V-ES 2018-10-09 18:59:06,867 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for H263-1998 2018-10-09 18:59:06,869 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for H263 2018-10-09 18:59:06,871 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for 1016 2018-10-09 18:59:06,873 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for 1016 2018-10-09 18:59:06,874 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for G723 2018-10-09 18:59:06,876 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for G723 2018-10-09 18:59:06,877 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for LPC 2018-10-09 18:59:06,879 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for LPC 2018-10-09 18:59:06,881 [INFO] [doorpi.sipphone.from_linphone] Codec L16/44100 fmtp=[] number=10, enabled=0) added to default capabilities. 2018-10-09 18:59:06,883 [INFO] [doorpi.sipphone.from_linphone] Codec L16/44100 fmtp=[] number=11, enabled=0) added to default capabilities. 2018-10-09 18:59:06,884 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for CN 2018-10-09 18:59:06,886 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for CN 2018-10-09 18:59:06,888 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for G729 2018-10-09 18:59:06,889 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for G729 2018-10-09 18:59:06,891 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for H261 2018-10-09 18:59:06,893 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for H261 2018-10-09 18:59:06,894 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for MPV 2018-10-09 18:59:06,896 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for MPV 2018-10-09 18:59:06,898 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for H263 2018-10-09 18:59:06,900 [INFO] [doorpi.sipphone.from_linphone] Sal nat helper [enabled] 2018-10-09 18:59:06,901 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2018-10-09 18:59:06,903 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2018-10-09 18:59:06,905 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2018-10-09 18:59:06,906 [INFO] [doorpi.sipphone.from_linphone] Linphone core [0x1e39520] notifying [configuring_status] 2018-10-09 18:59:06,908 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_callback_configuring_status(0x1e39520, 2, "(null)") 2018-10-09 18:59:06,910 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_callback_configuring_status 2018-10-09 18:59:06,912 [INFO] [doorpi.sipphone.from_linphone] Cannot open directory ./lib/liblinphone/plugins: No such file or directory 2018-10-09 18:59:06,913 [WARNING] [doorpi.sipphone.from_linphone] ./share/sounds/linphone/rings/oldphone.wav does not exist 2018-10-09 18:59:06,915 [INFO] [doorpi.sipphone.from_linphone] linphone_core_set_playback_gain_db(): no active call. 2018-10-09 18:59:06,917 [INFO] [doorpi.sipphone.from_linphone] linphone_core_set_mic_gain_db(): no active call. 2018-10-09 18:59:06,918 [INFO] [doorpi.sipphone.from_linphone] MTU is supposed to be 1300, rtp payload max size will be 1240 2018-10-09 18:59:06,920 [INFO] [doorpi.sipphone.from_linphone] Sal nat helper [enabled] 2018-10-09 18:59:06,922 [INFO] [doorpi.sipphone.from_linphone] Sal use rport [enabled] 2018-10-09 18:59:06,923 [INFO] [doorpi.sipphone.from_linphone] Supported codec opus/48000 fmtp=useinbandfec=1; stereo=0; sprop-stereo=0 automatically added to codec list. 2018-10-09 18:59:06,925 [INFO] [doorpi.sipphone.from_linphone] Supported codec speex/16000 fmtp=vbr=on automatically added to codec list. 2018-10-09 18:59:06,927 [INFO] [doorpi.sipphone.from_linphone] Supported codec speex/8000 fmtp=vbr=on automatically added to codec list. 2018-10-09 18:59:06,928 [INFO] [doorpi.sipphone.from_linphone] Supported codec PCMU/8000 fmtp= automatically added to codec list. 2018-10-09 18:59:06,930 [INFO] [doorpi.sipphone.from_linphone] Supported codec PCMA/8000 fmtp= automatically added to codec list. 2018-10-09 18:59:06,932 [INFO] [doorpi.sipphone.from_linphone] Supported codec GSM/8000 fmtp= automatically added to codec list. 2018-10-09 18:59:06,933 [INFO] [doorpi.sipphone.from_linphone] Supported codec G722/8000 fmtp= automatically added to codec list. 2018-10-09 18:59:06,935 [INFO] [doorpi.sipphone.from_linphone] Supported codec speex/32000 fmtp=vbr=on automatically added to codec list. 2018-10-09 18:59:06,937 [INFO] [doorpi.sipphone.from_linphone] Supported codec L16/44100 fmtp= automatically added to codec list. 2018-10-09 18:59:06,938 [INFO] [doorpi.sipphone.from_linphone] Supported codec L16/44100 fmtp= automatically added to codec list. 2018-10-09 18:59:06,940 [INFO] [doorpi.sipphone.from_linphone] Supported codec VP8/90000 fmtp= automatically added to codec list. 2018-10-09 18:59:06,942 [INFO] [doorpi.sipphone.from_linphone] Sal use rport [enabled] 2018-10-09 18:59:06,944 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2018-10-09 18:59:06,945 [INFO] [doorpi.sipphone.from_linphone] sal_unlisten_ports done 2018-10-09 18:59:06,947 [INFO] [doorpi.sipphone.from_linphone] Creating listening point [0x1f65490] on [sip:0.0.0.0:5060;transport=UDP] 2018-10-09 18:59:06,949 [INFO] [doorpi.sipphone.from_linphone] Creating listening point [0x1f65610] on [sip:0.0.0.0:5060;transport=TCP] 2018-10-09 18:59:06,951 [INFO] [doorpi.sipphone.from_linphone] Creating listening point [0x1f65850] on [sip:0.0.0.0:-1;transport=TLS] 2018-10-09 18:59:06,953 [INFO] [doorpi.sipphone.from_linphone] Random TCP port is 44411 2018-10-09 18:59:06,955 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2018-10-09 18:59:06,957 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2018-10-09 18:59:06,962 [INFO] [doorpi.sipphone.from_linphone] Linphone core [0x1e39520] notifying [display_status] 2018-10-09 18:59:06,963 [INFO] [doorpi.sipphone.from_linphone] Linphone core [0x1e39520] notifying [global_state_changed] 2018-10-09 18:59:06,965 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_callback_global_state_changed(0x1e39520, 2, "Ready") 2018-10-09 18:59:06,967 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_callback_global_state_changed 2018-10-09 18:59:06,968 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_class_method_new -> 0xb4583f08 2018-10-09 18:59:06,970 [TRACE] [doorpi.conf.config_object] get_string for key identity in section SIP-Phone (default: DoorPi) returns DoorPi 2018-10-09 18:59:06,972 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_primary_contact(0xb4583f08 [0x1e39520], "DoorPi ") 2018-10-09 18:59:06,974 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_primary_contact -> 0 2018-10-09 18:59:06,976 [TRACE] [doorpi.action.handler] fire Event OnSipPhoneCreate from doorpi.sipphone.from_linphone asyncron 2018-10-09 18:59:06,979 [TRACE] [doorpi.conf.config_object] get_integer for key ua.max_calls in section SIP-Phone (default: 2) returns 2 2018-10-09 18:59:06,981 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_max_calls(0xb4583f08 [0x1e39520], 2) 2018-10-09 18:59:06,983 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_max_calls -> 0 2018-10-09 18:59:06,985 [TRACE] [doorpi.conf.config_object] get_boolean for key echo_cancellation_enabled in section SIP-Phone (default: False) returns False 2018-10-09 18:59:06,986 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_enable_echo_cancellation(0xb4583f08 [0x1e39520], 0x2d7690 [0]) 2018-10-09 18:59:06,988 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_enable_echo_cancellation -> 0 2018-10-09 18:59:06,990 [TRACE] [doorpi.conf.config_object] get_integer for key local_port in section SIP-Phone (default: 5060) returns 5060 2018-10-09 18:59:06,992 [DEBUG] [doorpi.action.handler] no actions for event OnSipPhoneCreate - skip fire_event OnSipPhoneCreate from doorpi.sipphone.from_linphone 2018-10-09 18:59:06,995 [TRACE] [doorpi.conf.config_object] get_integer for key local_port in section SIP-Phone (default: 5060) returns 5060 2018-10-09 18:59:06,997 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_SipTransports_new() 2018-10-09 18:59:06,999 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_SipTransports_new -> 0xb4583f20 2018-10-09 18:59:07,000 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_sip_transports(0xb4583f08 [0x1e39520], 0xb4583f20 [0xb4583f28]) 2018-10-09 18:59:07,002 [INFO] [doorpi.sipphone.from_linphone] Listening point [0x1f65490] on [sip:0.0.0.0:5060;transport=UDP] destroyed 2018-10-09 18:59:07,004 [INFO] [doorpi.sipphone.from_linphone] Listening point [0x1f65610] on [sip:0.0.0.0:5060;transport=TCP] destroyed 2018-10-09 18:59:07,006 [INFO] [doorpi.sipphone.from_linphone] Listening point [0x1f65850] on [sip:0.0.0.0:44411;transport=TLS] destroyed 2018-10-09 18:59:07,008 [INFO] [doorpi.sipphone.from_linphone] sal_unlisten_ports done 2018-10-09 18:59:07,009 [INFO] [doorpi.sipphone.from_linphone] Creating listening point [0x1f6dfd0] on [sip:0.0.0.0:5060;transport=UDP] 2018-10-09 18:59:07,012 [INFO] [doorpi.sipphone.from_linphone] Creating listening point [0x1f6de40] on [sip:0.0.0.0:5060;transport=TCP] 2018-10-09 18:59:07,014 [INFO] [doorpi.sipphone.from_linphone] Creating listening point [0x1f6cbb0] on [sip:0.0.0.0:-1;transport=TLS] 2018-10-09 18:59:07,015 [INFO] [doorpi.sipphone.from_linphone] Random TCP port is 41915 2018-10-09 18:59:07,017 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2018-10-09 18:59:07,019 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2018-10-09 18:59:07,021 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_sip_transports -> 0 2018-10-09 18:59:07,022 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_SipTransports_dealloc(0xb4583f20) 2018-10-09 18:59:07,024 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_SipTransports_dealloc 2018-10-09 18:59:07,026 [TRACE] [doorpi.conf.config_object] get_boolean for key video_display_enabled in section SIP-Phone (default: False) returns False 2018-10-09 18:59:07,027 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_enable_video_display(0xb4583f08 [0x1e39520], 0x2d7690 [0]) 2018-10-09 18:59:07,029 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_enable_video_display -> 0 2018-10-09 18:59:07,031 [DEBUG] [doorpi.conf.config_object] create new key stun_server in section SIP-Phone with value '' 2018-10-09 18:59:07,032 [TRACE] [doorpi.conf.config_object] get_string for key stun_server in section SIP-Phone (default: ) returns 2018-10-09 18:59:07,034 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_stun_server(0xb4583f08 [0x1e39520], "") 2018-10-09 18:59:07,036 [INFO] [doorpi.sipphone.from_linphone] Resolver is using DNS server(s): 2018-10-09 18:59:07,038 [INFO] [doorpi.sipphone.from_linphone] 192.168.6.254 2018-10-09 18:59:07,041 [INFO] [doorpi.sipphone.from_linphone] resolver_process_data dns_res_check() in progress 2018-10-09 18:59:07,043 [INFO] [doorpi.sipphone.from_linphone] DNS resolution awaiting response, queued to main loop 2018-10-09 18:59:07,045 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_stun_server -> 0 2018-10-09 18:59:07,047 [DEBUG] [doorpi.conf.config_object] create new key FirewallPolicy in section SIP-Phone with value 'PolicyNoFirewall' 2018-10-09 18:59:07,048 [TRACE] [doorpi.conf.config_object] get_string for key FirewallPolicy in section SIP-Phone (default: PolicyNoFirewall) returns PolicyNoFirewall 2018-10-09 18:59:07,051 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_firewall_policy(0xb4583f08 [0x1e39520], 0) 2018-10-09 18:59:07,052 [INFO] [doorpi.sipphone.from_linphone] Sal nat helper [enabled] 2018-10-09 18:59:07,054 [INFO] [doorpi.sipphone.from_linphone] Sal use rport [enabled] 2018-10-09 18:59:07,057 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_firewall_policy -> 0 2018-10-09 18:59:07,059 [TRACE] [doorpi.conf.config_object] get_integer for key max_call_time in section SIP-Phone (default: 120) returns 120 2018-10-09 18:59:07,062 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_in_call_timeout(0xb4583f08 [0x1e39520], 120) 2018-10-09 18:59:07,063 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_in_call_timeout -> 0 2018-10-09 18:59:07,065 [TRACE] [doorpi.conf.config_object] get_integer for key call_timeout in section SIP-Phone (default: 15) returns 15 2018-10-09 18:59:07,069 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_inc_timeout(0xb4583f08 [0x1e39520], 15) 2018-10-09 18:59:07,071 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_inc_timeout -> 0 2018-10-09 18:59:07,073 [TRACE] [doorpi.conf.config_object] get_string for key dialtone in section SIP-Phone (default: !BASEPATH!/media/ShortDialTone.wav) returns !BASEPATH!/media/ShortDialTone.wav 2018-10-09 18:59:07,078 [DEBUG] [doorpi.conf.config_object] parse string "!BASEPATH!/media/ShortDialTone.wav" to "/usr/local/etc/DoorPi/media/ShortDialTone.wav" 2018-10-09 18:59:07,079 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to event OnSipPhoneDestroy 2018-10-09 18:59:07,085 [TRACE] [doorpi.conf.config_object] get_boolean for key dialtone_renew_every_start in section SIP-Phone (default: False) returns False 2018-10-09 18:59:07,086 [TRACE] [doorpi.action.handler] register Event OnPlayerStarted from doorpi.sipphone.linphone_lib.Player 2018-10-09 18:59:07,088 [DEBUG] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.Player was added 2018-10-09 18:59:07,090 [TRACE] [doorpi.action.handler] added event_name OnPlayerStarted and registered source doorpi.sipphone.linphone_lib.Player 2018-10-09 18:59:07,091 [TRACE] [doorpi.action.handler] register Event OnPlayerStopped from doorpi.sipphone.linphone_lib.Player 2018-10-09 18:59:07,093 [TRACE] [doorpi.action.handler] added event_name OnPlayerStopped and registered source doorpi.sipphone.linphone_lib.Player 2018-10-09 18:59:07,094 [TRACE] [doorpi.action.handler] register Event OnPlayerCreated from doorpi.sipphone.linphone_lib.Player 2018-10-09 18:59:07,096 [TRACE] [doorpi.action.handler] added event_source doorpi.sipphone.linphone_lib.Player to existing event OnPlayerCreated 2018-10-09 18:59:07,098 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to new evententry OnSipPhoneMakeCall 2018-10-09 18:59:07,099 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to new evententry OnCallStateConnect 2018-10-09 18:59:07,101 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to new evententry OnCallStateDisconnect 2018-10-09 18:59:07,103 [TRACE] [doorpi.action.handler] fire Event OnPlayerCreated from doorpi.sipphone.linphone_lib.Player asyncron 2018-10-09 18:59:07,106 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_ringback(0xb4583f08 [0x1e39520], "/usr/local/etc/DoorPi/media/ShortDialTone.wav") 2018-10-09 18:59:07,108 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_ringback -> 0 2018-10-09 18:59:07,110 [DEBUG] [doorpi.conf.config_object] create new key records in section SIP-Phone with value '!BASEPATH!/records/%Y-%m-%d_%H-%M-%S.wav' 2018-10-09 18:59:07,113 [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 2018-10-09 18:59:07,115 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to event OnSipPhoneDestroy 2018-10-09 18:59:07,117 [TRACE] [doorpi.action.handler] register Event OnRecorderStarted from doorpi.sipphone.linphone_lib.Recorder 2018-10-09 18:59:07,118 [DEBUG] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.Recorder was added 2018-10-09 18:59:07,112 [DEBUG] [doorpi.action.handler] no actions for event OnPlayerCreated - skip fire_event OnPlayerCreated from doorpi.sipphone.linphone_lib.Player 2018-10-09 18:59:07,120 [TRACE] [doorpi.action.handler] added event_name OnRecorderStarted and registered source doorpi.sipphone.linphone_lib.Recorder 2018-10-09 18:59:07,123 [TRACE] [doorpi.action.handler] register Event OnRecorderStopped from doorpi.sipphone.linphone_lib.Recorder 2018-10-09 18:59:07,125 [TRACE] [doorpi.action.handler] added event_name OnRecorderStopped and registered source doorpi.sipphone.linphone_lib.Recorder 2018-10-09 18:59:07,126 [TRACE] [doorpi.action.handler] register Event OnRecorderCreated from doorpi.sipphone.linphone_lib.Recorder 2018-10-09 18:59:07,128 [TRACE] [doorpi.action.handler] added event_name OnRecorderCreated and registered source doorpi.sipphone.linphone_lib.Recorder 2018-10-09 18:59:07,130 [TRACE] [doorpi.conf.config_object] get_boolean for key record_while_dialing in section SIP-Phone (default: False) returns False 2018-10-09 18:59:07,131 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to event OnCallStateConnect 2018-10-09 18:59:07,133 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to event OnCallStateDisconnect 2018-10-09 18:59:07,135 [TRACE] [doorpi.action.handler] fire Event OnRecorderCreated from doorpi.sipphone.linphone_lib.Recorder asyncron 2018-10-09 18:59:07,138 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_sound_devices(0xb4583f08 [0x1e39520]) 2018-10-09 18:59:07,140 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_sound_devices -> 0xb44ef8f0 2018-10-09 18:59:07,142 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_capture_device(0xb4583f08 [0x1e39520]) 2018-10-09 18:59:07,143 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_capture_device -> 0xb44ec6b0 2018-10-09 18:59:07,145 [TRACE] [doorpi.conf.config_object] get_string for key capture_device in section SIP-Phone (default: ALSA: default device) returns ALSA: USB Audio Device 2018-10-09 18:59:07,147 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_capture_device(0xb4583f08 [0x1e39520], "ALSA: USB Audio Device") 2018-10-09 18:59:07,148 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_capture_device -> 0 2018-10-09 18:59:07,152 [DEBUG] [doorpi.action.handler] no actions for event OnRecorderCreated - skip fire_event OnRecorderCreated from doorpi.sipphone.linphone_lib.Recorder 2018-10-09 18:59:07,150 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_playback_device(0xb4583f08 [0x1e39520]) 2018-10-09 18:59:07,155 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_playback_device -> 0xb44ec7d0 2018-10-09 18:59:07,157 [TRACE] [doorpi.conf.config_object] get_string for key playback_device in section SIP-Phone (default: ALSA: default device) returns ALSA: USB Audio Device 2018-10-09 18:59:07,158 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_playback_device(0xb4583f08 [0x1e39520], "ALSA: USB Audio Device") 2018-10-09 18:59:07,160 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_playback_device -> 0 2018-10-09 18:59:07,162 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_sound_devices(0xb4583f08 [0x1e39520]) 2018-10-09 18:59:07,164 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_sound_devices -> 0xb44efa58 2018-10-09 18:59:07,165 [INFO] [doorpi.sipphone.from_linphone] found 3 possible sounddevices: 2018-10-09 18:59:07,167 [DEBUG] [doorpi.sipphone.from_linphone] |rec|play| name 2018-10-09 18:59:07,169 [DEBUG] [doorpi.sipphone.from_linphone] ------------------------------------ 2018-10-09 18:59:07,171 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_sound_devices(0xb4583f08 [0x1e39520]) 2018-10-09 18:59:07,172 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_sound_devices -> 0xb44efa58 2018-10-09 18:59:07,174 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_sound_device_can_capture(0xb4583f08 [0x1e39520], "ALSA: default device") 2018-10-09 18:59:07,176 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_sound_device_can_capture -> 0x2d769c 2018-10-09 18:59:07,177 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_sound_device_can_playback(0xb4583f08 [0x1e39520], "ALSA: default device") 2018-10-09 18:59:07,179 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_sound_device_can_playback -> 0x2d769c 2018-10-09 18:59:07,180 [DEBUG] [doorpi.sipphone.from_linphone] | X | X | ALSA: default device 2018-10-09 18:59:07,182 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_sound_device_can_capture(0xb4583f08 [0x1e39520], "ALSA: bcm2835 ALSA") 2018-10-09 18:59:07,184 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_sound_device_can_capture -> 0x2d7690 2018-10-09 18:59:07,186 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_sound_device_can_playback(0xb4583f08 [0x1e39520], "ALSA: bcm2835 ALSA") 2018-10-09 18:59:07,187 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_sound_device_can_playback -> 0x2d769c 2018-10-09 18:59:07,189 [DEBUG] [doorpi.sipphone.from_linphone] | O | X | ALSA: bcm2835 ALSA 2018-10-09 18:59:07,190 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_sound_device_can_capture(0xb4583f08 [0x1e39520], "ALSA: USB Audio Device") 2018-10-09 18:59:07,192 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_sound_device_can_capture -> 0x2d769c 2018-10-09 18:59:07,194 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_sound_device_can_playback(0xb4583f08 [0x1e39520], "ALSA: USB Audio Device") 2018-10-09 18:59:07,195 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_sound_device_can_playback -> 0x2d769c 2018-10-09 18:59:07,197 [DEBUG] [doorpi.sipphone.from_linphone] | X | X | ALSA: USB Audio Device 2018-10-09 18:59:07,198 [DEBUG] [doorpi.sipphone.from_linphone] ------------------------------------ 2018-10-09 18:59:07,200 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_capture_device(0xb4583f08 [0x1e39520]) 2018-10-09 18:59:07,202 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_capture_device -> 0xb44ec8f0 2018-10-09 18:59:07,203 [DEBUG] [doorpi.sipphone.from_linphone] using capture_device: ALSA: USB Audio Device 2018-10-09 18:59:07,205 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_playback_device(0xb4583f08 [0x1e39520]) 2018-10-09 18:59:07,207 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_playback_device -> 0xb44ec920 2018-10-09 18:59:07,208 [DEBUG] [doorpi.sipphone.from_linphone] using playback_device: ALSA: USB Audio Device 2018-10-09 18:59:07,210 [TRACE] [doorpi.conf.config_object] get_list for key audio_codecs in section SIP-Phone (default: PCMA,PCMU) returns ['PCMA', 'PCMU'] 2018-10-09 18:59:07,212 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_audio_codecs(0xb4583f08 [0x1e39520]) 2018-10-09 18:59:07,214 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0x1f650e0) 2018-10-09 18:59:07,215 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2018-10-09 18:59:07,217 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0xb6d08410 2018-10-09 18:59:07,218 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2018-10-09 18:59:07,220 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0xb6d08410 2018-10-09 18:59:07,222 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0xb6d08410 2018-10-09 18:59:07,223 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0x1f65168) 2018-10-09 18:59:07,225 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2018-10-09 18:59:07,227 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0xb6d08420 2018-10-09 18:59:07,228 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2018-10-09 18:59:07,230 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0xb6d08420 2018-10-09 18:59:07,232 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0xb6d08420 2018-10-09 18:59:07,233 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0x1f651d0) 2018-10-09 18:59:07,235 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2018-10-09 18:59:07,237 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0xb6d08430 2018-10-09 18:59:07,238 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2018-10-09 18:59:07,240 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0xb6d08430 2018-10-09 18:59:07,242 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0xb6d08430 2018-10-09 18:59:07,244 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0x1f65238) 2018-10-09 18:59:07,245 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2018-10-09 18:59:07,247 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0xb6d08440 2018-10-09 18:59:07,249 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2018-10-09 18:59:07,251 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0xb6d08440 2018-10-09 18:59:07,252 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0xb6d08440 2018-10-09 18:59:07,254 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0x1f4f2f0) 2018-10-09 18:59:07,256 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2018-10-09 18:59:07,257 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0xb6d08450 2018-10-09 18:59:07,259 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2018-10-09 18:59:07,261 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0xb6d08450 2018-10-09 18:59:07,263 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0xb6d08450 2018-10-09 18:59:07,267 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0x1f4f348) 2018-10-09 18:59:07,268 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2018-10-09 18:59:07,270 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0xb6d08460 2018-10-09 18:59:07,272 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2018-10-09 18:59:07,273 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0xb6d08460 2018-10-09 18:59:07,275 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0xb6d08460 2018-10-09 18:59:07,277 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0x1f4f3a0) 2018-10-09 18:59:07,278 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2018-10-09 18:59:07,280 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0xb6d08470 2018-10-09 18:59:07,282 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2018-10-09 18:59:07,283 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0xb6d08470 2018-10-09 18:59:07,285 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0xb6d08470 2018-10-09 18:59:07,287 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0x1f4f3f8) 2018-10-09 18:59:07,288 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2018-10-09 18:59:07,290 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0xb6d08480 2018-10-09 18:59:07,292 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2018-10-09 18:59:07,293 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0xb6d08480 2018-10-09 18:59:07,295 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0xb6d08480 2018-10-09 18:59:07,297 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0x1f4f460) 2018-10-09 18:59:07,298 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2018-10-09 18:59:07,300 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0xb6d08490 2018-10-09 18:59:07,302 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2018-10-09 18:59:07,303 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0xb6d08490 2018-10-09 18:59:07,305 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0xb6d08490 2018-10-09 18:59:07,307 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0x1f4f4b8) 2018-10-09 18:59:07,308 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2018-10-09 18:59:07,310 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0xb6d084a0 2018-10-09 18:59:07,312 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2018-10-09 18:59:07,313 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0xb6d084a0 2018-10-09 18:59:07,315 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0xb6d084a0 2018-10-09 18:59:07,317 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_audio_codecs -> 0xb44efb48 2018-10-09 18:59:07,318 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0xb6d08410 [0x1f650e0]) 2018-10-09 18:59:07,320 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0xb45bfca0 2018-10-09 18:59:07,322 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0xb6d08410 [0x1f650e0]) 2018-10-09 18:59:07,323 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0xb45bfca0 2018-10-09 18:59:07,325 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec opus 2018-10-09 18:59:07,326 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0xb4583f08 [0x1e39520], 0xb6d08410 [0x1f650e0], 0x2d7690 [0]) 2018-10-09 18:59:07,328 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x1dc38cc 2018-10-09 18:59:07,330 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0xb6d08420 [0x1f65168]) 2018-10-09 18:59:07,332 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0xb45bff20 2018-10-09 18:59:07,333 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0xb6d08420 [0x1f65168]) 2018-10-09 18:59:07,335 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0xb45bff20 2018-10-09 18:59:07,337 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec speex 2018-10-09 18:59:07,338 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0xb4583f08 [0x1e39520], 0xb6d08420 [0x1f65168], 0x2d7690 [0]) 2018-10-09 18:59:07,340 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x1dc38cc 2018-10-09 18:59:07,342 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0xb6d08430 [0x1f651d0]) 2018-10-09 18:59:07,344 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0xb45bfca0 2018-10-09 18:59:07,345 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0xb6d08430 [0x1f651d0]) 2018-10-09 18:59:07,347 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0xb45bfca0 2018-10-09 18:59:07,349 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec speex 2018-10-09 18:59:07,351 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0xb4583f08 [0x1e39520], 0xb6d08430 [0x1f651d0], 0x2d7690 [0]) 2018-10-09 18:59:07,352 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x1dc38cc 2018-10-09 18:59:07,354 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0xb6d08440 [0x1f65238]) 2018-10-09 18:59:07,356 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0xb45bff20 2018-10-09 18:59:07,357 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0xb6d08440 [0x1f65238]) 2018-10-09 18:59:07,359 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0xb45bff20 2018-10-09 18:59:07,361 [DEBUG] [doorpi.sipphone.from_linphone] enable audio codec PCMU 2018-10-09 18:59:07,362 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0xb4583f08 [0x1e39520], 0xb6d08440 [0x1f65238], 0x2d769c [1]) 2018-10-09 18:59:07,364 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x1dc38cc 2018-10-09 18:59:07,366 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0xb6d08450 [0x1f4f2f0]) 2018-10-09 18:59:07,368 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0xb45bfca0 2018-10-09 18:59:07,369 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0xb6d08450 [0x1f4f2f0]) 2018-10-09 18:59:07,371 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0xb45bfca0 2018-10-09 18:59:07,372 [DEBUG] [doorpi.sipphone.from_linphone] enable audio codec PCMA 2018-10-09 18:59:07,374 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0xb4583f08 [0x1e39520], 0xb6d08450 [0x1f4f2f0], 0x2d769c [1]) 2018-10-09 18:59:07,376 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x1dc38cc 2018-10-09 18:59:07,378 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0xb6d08460 [0x1f4f348]) 2018-10-09 18:59:07,379 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0xb4583f20 2018-10-09 18:59:07,381 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0xb6d08460 [0x1f4f348]) 2018-10-09 18:59:07,383 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0xb4583f20 2018-10-09 18:59:07,385 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec GSM 2018-10-09 18:59:07,386 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0xb4583f08 [0x1e39520], 0xb6d08460 [0x1f4f348], 0x2d7690 [0]) 2018-10-09 18:59:07,388 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x1dc38cc 2018-10-09 18:59:07,390 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0xb6d08470 [0x1f4f3a0]) 2018-10-09 18:59:07,392 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0xb45bfca0 2018-10-09 18:59:07,393 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0xb6d08470 [0x1f4f3a0]) 2018-10-09 18:59:07,395 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0xb45bfca0 2018-10-09 18:59:07,397 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec G722 2018-10-09 18:59:07,398 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0xb4583f08 [0x1e39520], 0xb6d08470 [0x1f4f3a0], 0x2d7690 [0]) 2018-10-09 18:59:07,400 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x1dc38cc 2018-10-09 18:59:07,402 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0xb6d08480 [0x1f4f3f8]) 2018-10-09 18:59:07,404 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0xb45bff20 2018-10-09 18:59:07,405 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0xb6d08480 [0x1f4f3f8]) 2018-10-09 18:59:07,407 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0xb45bff20 2018-10-09 18:59:07,408 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec speex 2018-10-09 18:59:07,410 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0xb4583f08 [0x1e39520], 0xb6d08480 [0x1f4f3f8], 0x2d7690 [0]) 2018-10-09 18:59:07,412 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x1dc38cc 2018-10-09 18:59:07,414 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0xb6d08490 [0x1f4f460]) 2018-10-09 18:59:07,416 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0xb4583f20 2018-10-09 18:59:07,417 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0xb6d08490 [0x1f4f460]) 2018-10-09 18:59:07,419 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0xb4583f20 2018-10-09 18:59:07,420 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec L16 2018-10-09 18:59:07,422 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0xb4583f08 [0x1e39520], 0xb6d08490 [0x1f4f460], 0x2d7690 [0]) 2018-10-09 18:59:07,424 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x1dc38cc 2018-10-09 18:59:07,426 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0xb6d084a0 [0x1f4f4b8]) 2018-10-09 18:59:07,427 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0xb4583f20 2018-10-09 18:59:07,429 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0xb6d084a0 [0x1f4f4b8]) 2018-10-09 18:59:07,431 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0xb4583f20 2018-10-09 18:59:07,432 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec L16 2018-10-09 18:59:07,434 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0xb4583f08 [0x1e39520], 0xb6d084a0 [0x1f4f4b8], 0x2d7690 [0]) 2018-10-09 18:59:07,436 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x1dc38cc 2018-10-09 18:59:07,438 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_video_devices(0xb4583f08 [0x1e39520]) 2018-10-09 18:59:07,440 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_video_devices -> 0xb44efbc0 2018-10-09 18:59:07,442 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_video_devices(0xb4583f08 [0x1e39520]) 2018-10-09 18:59:07,443 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_video_devices -> 0xb44efbc0 2018-10-09 18:59:07,445 [INFO] [doorpi.sipphone.from_linphone] found 2 possible videodevices: 2018-10-09 18:59:07,446 [DEBUG] [doorpi.sipphone.from_linphone] | name 2018-10-09 18:59:07,448 [DEBUG] [doorpi.sipphone.from_linphone] ------------------------------------ 2018-10-09 18:59:07,450 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_video_devices(0xb4583f08 [0x1e39520]) 2018-10-09 18:59:07,452 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_video_devices -> 0xb44efbc0 2018-10-09 18:59:07,453 [DEBUG] [doorpi.sipphone.from_linphone] | V4L2: /dev/video0 2018-10-09 18:59:07,455 [DEBUG] [doorpi.sipphone.from_linphone] | StaticImage: Static picture 2018-10-09 18:59:07,456 [DEBUG] [doorpi.sipphone.from_linphone] ------------------------------------ 2018-10-09 18:59:07,458 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_video_devices(0xb4583f08 [0x1e39520]) 2018-10-09 18:59:07,460 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_video_devices -> 0xb44efbc0 2018-10-09 18:59:07,462 [TRACE] [doorpi.conf.config_object] get_string for key video_device in section SIP-Phone (default: V4L2: /dev/video0) returns StaticImage; Static picture 2018-10-09 18:59:07,464 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_video_devices(0xb4583f08 [0x1e39520]) 2018-10-09 18:59:07,467 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_video_devices -> 0xb44efbc0 2018-10-09 18:59:07,469 [WARNING] [doorpi.sipphone.from_linphone] camera "StaticImage; Static picture" from config does not exist in possible video devices. 2018-10-09 18:59:07,471 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_video_devices(0xb4583f08 [0x1e39520]) 2018-10-09 18:59:07,473 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_video_devices -> 0xb44efbc0 2018-10-09 18:59:07,474 [DEBUG] [doorpi.sipphone.from_linphone] switching to first possible video device "V4L2: /dev/video0" 2018-10-09 18:59:07,476 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_video_devices(0xb4583f08 [0x1e39520]) 2018-10-09 18:59:07,477 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_video_devices -> 0xb44efbc0 2018-10-09 18:59:07,479 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_enable_video_capture(0xb4583f08 [0x1e39520], 0x2d769c [1]) 2018-10-09 18:59:07,481 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_enable_video_capture -> 0 2018-10-09 18:59:07,483 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_video_device(0xb4583f08 [0x1e39520], "V4L2: /dev/video0") 2018-10-09 18:59:07,484 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_video_device -> 0 2018-10-09 18:59:07,486 [TRACE] [doorpi.conf.config_object] get_string for key video_size in section SIP-Phone (default: vga) returns vga 2018-10-09 18:59:07,487 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_preferred_video_size_by_name(0xb4583f08 [0x1e39520], "vga") 2018-10-09 18:59:07,489 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_preferred_video_size_by_name -> 0 2018-10-09 18:59:07,491 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_video_device(0xb4583f08 [0x1e39520]) 2018-10-09 18:59:07,493 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_video_device -> 0xb44efcf0 2018-10-09 18:59:07,494 [DEBUG] [doorpi.sipphone.from_linphone] using video_device: V4L2: /dev/video0 2018-10-09 18:59:07,496 [TRACE] [doorpi.conf.config_object] get_list for key video_codecs in section SIP-Phone (default: VP8) returns ['VP8'] 2018-10-09 18:59:07,498 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_video_codecs(0xb4583f08 [0x1e39520]) 2018-10-09 18:59:07,499 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0x1f65060) 2018-10-09 18:59:07,501 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2018-10-09 18:59:07,503 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0xb6d084b0 2018-10-09 18:59:07,504 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2018-10-09 18:59:07,506 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0xb6d084b0 2018-10-09 18:59:07,508 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0xb6d084b0 2018-10-09 18:59:07,509 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_video_codecs -> 0xb44ef8f0 2018-10-09 18:59:07,511 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0xb6d084b0 [0x1f65060]) 2018-10-09 18:59:07,513 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0xb4583f20 2018-10-09 18:59:07,514 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_video_capture_enabled(0xb4583f08 [0x1e39520]) 2018-10-09 18:59:07,516 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_video_capture_enabled -> 0x2d769c 2018-10-09 18:59:07,518 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0xb6d084b0 [0x1f65060]) 2018-10-09 18:59:07,519 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0xb4583f20 2018-10-09 18:59:07,521 [DEBUG] [doorpi.sipphone.from_linphone] enable video codec VP8 2018-10-09 18:59:07,523 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0xb4583f08 [0x1e39520], 0xb6d084b0 [0x1f65060], 0x2d769c [1]) 2018-10-09 18:59:07,524 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x1dc38cc 2018-10-09 18:59:07,526 [WARNING] [doorpi.conf.config_object] could not delete section SIP-Phone, because it's not empty. 2018-10-09 18:59:07,528 [WARNING] [doorpi.conf.config_object] found SIP-Phone - sipserver_server in BACKWARD_COMPATIBILITY_KEYS with SIP-Phone - server 2018-10-09 18:59:07,529 [TRACE] [doorpi.conf.config_object] get_string for key sipserver_server in section SIP-Phone (default: ) returns 192.168.178.254 2018-10-09 18:59:07,531 [WARNING] [doorpi.conf.config_object] could not delete section SIP-Phone, because it's not empty. 2018-10-09 18:59:07,532 [WARNING] [doorpi.conf.config_object] found SIP-Phone - sipserver_username in BACKWARD_COMPATIBILITY_KEYS with SIP-Phone - username 2018-10-09 18:59:07,534 [TRACE] [doorpi.conf.config_object] get_string for key sipserver_username in section SIP-Phone (default: ) returns 620 2018-10-09 18:59:07,536 [WARNING] [doorpi.conf.config_object] could not delete section SIP-Phone, because it's not empty. 2018-10-09 18:59:07,537 [WARNING] [doorpi.conf.config_object] found SIP-Phone - sipserver_password in BACKWARD_COMPATIBILITY_KEYS with SIP-Phone - password 2018-10-09 18:59:07,539 [TRACE] [doorpi.conf.config_object] get_string for key sipserver_password in section SIP-Phone (default: 620) returns ******* 2018-10-09 18:59:07,540 [WARNING] [doorpi.conf.config_object] could not delete section SIP-Phone, because it's not empty. 2018-10-09 18:59:07,542 [WARNING] [doorpi.conf.config_object] found SIP-Phone - sipserver_realm in BACKWARD_COMPATIBILITY_KEYS with SIP-Phone - realm 2018-10-09 18:59:07,543 [TRACE] [doorpi.conf.config_object] get_string for key sipserver_realm in section SIP-Phone (default: 192.168.178.254) returns 192.168.6.254 2018-10-09 18:59:07,545 [INFO] [doorpi.sipphone.from_linphone] using DoorPi with SIP-Server 2018-10-09 18:59:07,546 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_create_proxy_config(0xb4583f08 [0x1e39520]) 2018-10-09 18:59:07,548 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_ProxyConfig_from_native_ptr(0x1f942e0) 2018-10-09 18:59:07,550 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_ProxyConfig_new() 2018-10-09 18:59:07,552 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_ProxyConfig_new -> 0xb6d084c0 2018-10-09 18:59:07,553 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_ProxyConfig_init() 2018-10-09 18:59:07,555 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_ProxyConfig_init -> 0xb6d084c0 2018-10-09 18:59:07,556 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_ProxyConfig_from_native_ptr -> 0xb6d084c0 2018-10-09 18:59:07,558 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_create_proxy_config -> 0xb6d084c0 2018-10-09 18:59:07,560 [TRACE] [doorpi.conf.config_object] get_string for key identity in section SIP-Phone (default: DoorPi) returns DoorPi 2018-10-09 18:59:07,561 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Address_class_method_new("DoorPi ") 2018-10-09 18:59:07,564 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Address_from_native_ptr(0x1f6b508) 2018-10-09 18:59:07,566 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Address_new() 2018-10-09 18:59:07,568 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Address_new -> 0xb6d084d0 2018-10-09 18:59:07,569 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Address_init() 2018-10-09 18:59:07,571 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Address_init -> 0xb6d084d0 2018-10-09 18:59:07,572 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Address_from_native_ptr -> 0xb6d084d0 2018-10-09 18:59:07,574 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Address_class_method_new -> 0xb6d084d0 2018-10-09 18:59:07,576 [ERROR] [doorpi.main] Exception NameError: 'linphone.ProxyConfig' object has no attribute 'identity_address' Traceback (most recent call last): File "/usr/local/lib/python2.7/dist-packages/doorpi/main.py", line 152, in main_as_application try: doorpi.DoorPi(parsed_arguments).run() File "/usr/local/lib/python2.7/dist-packages/doorpi/doorpi.py", line 232, in run if not self.__prepared: self.prepare(self.__parsed_arguments) File "/usr/local/lib/python2.7/dist-packages/doorpi/doorpi.py", line 149, in prepare self.sipphone.start() File "/usr/local/lib/python2.7/dist-packages/doorpi/sipphone/from_linphone.py", line 270, in start conf.get(SIPPHONE_SECTION, "identity", 'DoorPi'), username, server) AttributeError: 'linphone.ProxyConfig' object has no attribute 'identity_address' 2018-10-09 18:59:07,583 [DEBUG] [doorpi.doorpi] destroy doorpi 2018-10-09 18:59:07,584 [DEBUG] [doorpi.doorpi] Threads before starting shutdown: [<_MainThread(MainThread, started -1225302016)>, ] 2018-10-09 18:59:07,586 [TRACE] [doorpi.action.handler] fire Event BeforeShutdown from doorpi.doorpi asyncron 2018-10-09 18:59:07,591 [DEBUG] [doorpi.action.handler] [YHXZW3] fire for event OnShutdown this actions [, , , ] 2018-10-09 18:59:07,593 [TRACE] [doorpi.action.handler] [YHXZW3] try to fire action TimeTickDestroyAction with args () and kwargs {} 2018-10-09 18:59:07,594 [TRACE] [doorpi.action.base] run TimeTickDestroyAction with args () and kwargs {} 2018-10-09 18:59:07,596 [TRACE] [doorpi.action.handler] unregister Eventsource doorpi.action.SingleActions.time_tick and force_unregister is True 2018-10-09 18:59:07,597 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute59 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,599 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute59 - remove event too 2018-10-09 18:59:07,602 [DEBUG] [doorpi.action.handler] no actions for event BeforeShutdown - skip fire_event BeforeShutdown from doorpi.doorpi 2018-10-09 18:59:07,603 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute59 2018-10-09 18:59:07,606 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute58 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,607 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute58 - remove event too 2018-10-09 18:59:07,609 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute58 2018-10-09 18:59:07,610 [TRACE] [doorpi.action.handler] unregister Event OnTimeWeekEvenNumber from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,612 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeWeekEvenNumber - remove event too 2018-10-09 18:59:07,614 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeWeekEvenNumber 2018-10-09 18:59:07,615 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute51 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,616 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute51 - remove event too 2018-10-09 18:59:07,618 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute51 2018-10-09 18:59:07,619 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute50 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,621 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute50 - remove event too 2018-10-09 18:59:07,623 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute50 2018-10-09 18:59:07,624 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute53 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,626 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute53 - remove event too 2018-10-09 18:59:07,627 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute53 2018-10-09 18:59:07,629 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute52 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,630 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute52 - remove event too 2018-10-09 18:59:07,632 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute52 2018-10-09 18:59:07,633 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute55 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,635 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute55 - remove event too 2018-10-09 18:59:07,636 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute55 2018-10-09 18:59:07,638 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute54 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,640 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute54 - remove event too 2018-10-09 18:59:07,641 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute54 2018-10-09 18:59:07,643 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute57 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,644 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute57 - remove event too 2018-10-09 18:59:07,646 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute57 2018-10-09 18:59:07,648 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute56 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,649 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute56 - remove event too 2018-10-09 18:59:07,651 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute56 2018-10-09 18:59:07,652 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinuteEvenNumber from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,654 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinuteEvenNumber - remove event too 2018-10-09 18:59:07,656 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinuteEvenNumber 2018-10-09 18:59:07,657 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,659 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour - remove event too 2018-10-09 18:59:07,660 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour 2018-10-09 18:59:07,662 [TRACE] [doorpi.action.handler] unregister Event OnTimeMonth from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,666 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMonth - remove event too 2018-10-09 18:59:07,668 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMonth 2018-10-09 18:59:07,669 [TRACE] [doorpi.action.handler] unregister Event OnTimeYearUnevenNumber from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,671 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeYearUnevenNumber - remove event too 2018-10-09 18:59:07,672 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeYearUnevenNumber 2018-10-09 18:59:07,674 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour19 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,675 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour19 - remove event too 2018-10-09 18:59:07,677 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour19 2018-10-09 18:59:07,678 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour18 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,680 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour18 - remove event too 2018-10-09 18:59:07,681 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour18 2018-10-09 18:59:07,683 [TRACE] [doorpi.action.handler] unregister Event OnTimeYearEvenNumber from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,684 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeYearEvenNumber - remove event too 2018-10-09 18:59:07,686 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeYearEvenNumber 2018-10-09 18:59:07,687 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour11 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,689 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour11 - remove event too 2018-10-09 18:59:07,691 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour11 2018-10-09 18:59:07,692 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour13 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,694 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour13 - remove event too 2018-10-09 18:59:07,695 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour13 2018-10-09 18:59:07,697 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour12 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,698 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour12 - remove event too 2018-10-09 18:59:07,700 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour12 2018-10-09 18:59:07,701 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour15 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,703 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour15 - remove event too 2018-10-09 18:59:07,704 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour15 2018-10-09 18:59:07,706 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour14 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,707 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour14 - remove event too 2018-10-09 18:59:07,709 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour14 2018-10-09 18:59:07,710 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour17 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,712 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour17 - remove event too 2018-10-09 18:59:07,714 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour17 2018-10-09 18:59:07,715 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour16 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,716 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour16 - remove event too 2018-10-09 18:59:07,718 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour16 2018-10-09 18:59:07,720 [TRACE] [doorpi.action.handler] unregister Event OnTimeSecondUnevenNumber from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,721 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeSecondUnevenNumber - remove event too 2018-10-09 18:59:07,723 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeSecondUnevenNumber 2018-10-09 18:59:07,724 [TRACE] [doorpi.action.handler] unregister Event OnTimeDay from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,726 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeDay - remove event too 2018-10-09 18:59:07,728 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeDay 2018-10-09 18:59:07,729 [TRACE] [doorpi.action.handler] unregister Event OnTimeMonthEvenNumber from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,731 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMonthEvenNumber - remove event too 2018-10-09 18:59:07,732 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMonthEvenNumber 2018-10-09 18:59:07,734 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour9 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,735 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour9 - remove event too 2018-10-09 18:59:07,737 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour9 2018-10-09 18:59:07,738 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour8 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,740 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour8 - remove event too 2018-10-09 18:59:07,742 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour8 2018-10-09 18:59:07,743 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour10 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,744 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour10 - remove event too 2018-10-09 18:59:07,746 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour10 2018-10-09 18:59:07,748 [TRACE] [doorpi.action.handler] unregister Event OnTimeSecond from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,749 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeSecond - remove event too 2018-10-09 18:59:07,751 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeSecond 2018-10-09 18:59:07,752 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour4 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,754 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour4 - remove event too 2018-10-09 18:59:07,755 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour4 2018-10-09 18:59:07,757 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour7 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,758 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour7 - remove event too 2018-10-09 18:59:07,760 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour7 2018-10-09 18:59:07,761 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour6 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,763 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour6 - remove event too 2018-10-09 18:59:07,765 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour6 2018-10-09 18:59:07,766 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour1 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,767 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour1 - remove event too 2018-10-09 18:59:07,769 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour1 2018-10-09 18:59:07,771 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour0 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,772 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour0 - remove event too 2018-10-09 18:59:07,774 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour0 2018-10-09 18:59:07,775 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour3 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,777 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour3 - remove event too 2018-10-09 18:59:07,778 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour3 2018-10-09 18:59:07,780 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour2 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,781 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour2 - remove event too 2018-10-09 18:59:07,783 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour2 2018-10-09 18:59:07,784 [TRACE] [doorpi.action.handler] unregister Event OnTimeMonthUnevenNumber from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,786 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMonthUnevenNumber - remove event too 2018-10-09 18:59:07,787 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMonthUnevenNumber 2018-10-09 18:59:07,789 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute5 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,790 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute5 - remove event too 2018-10-09 18:59:07,792 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute5 2018-10-09 18:59:07,794 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute4 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,795 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute4 - remove event too 2018-10-09 18:59:07,797 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute4 2018-10-09 18:59:07,798 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute7 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,800 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute7 - remove event too 2018-10-09 18:59:07,801 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute7 2018-10-09 18:59:07,803 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute6 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,804 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute6 - remove event too 2018-10-09 18:59:07,806 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute6 2018-10-09 18:59:07,807 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute1 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,809 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute1 - remove event too 2018-10-09 18:59:07,811 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute1 2018-10-09 18:59:07,812 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute0 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,814 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute0 - remove event too 2018-10-09 18:59:07,815 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute0 2018-10-09 18:59:07,817 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute3 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,818 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute3 - remove event too 2018-10-09 18:59:07,820 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute3 2018-10-09 18:59:07,821 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute2 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,823 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute2 - remove event too 2018-10-09 18:59:07,824 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute2 2018-10-09 18:59:07,826 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute9 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,827 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute9 - remove event too 2018-10-09 18:59:07,829 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute9 2018-10-09 18:59:07,830 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute8 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,832 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute8 - remove event too 2018-10-09 18:59:07,833 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute8 2018-10-09 18:59:07,835 [TRACE] [doorpi.action.handler] unregister Event OnTimeWeek from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,836 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeWeek - remove event too 2018-10-09 18:59:07,838 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeWeek 2018-10-09 18:59:07,840 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute15 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,841 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute15 - remove event too 2018-10-09 18:59:07,843 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute15 2018-10-09 18:59:07,845 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute14 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,846 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute14 - remove event too 2018-10-09 18:59:07,848 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute14 2018-10-09 18:59:07,849 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute17 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,851 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute17 - remove event too 2018-10-09 18:59:07,853 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute17 2018-10-09 18:59:07,854 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute16 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,856 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute16 - remove event too 2018-10-09 18:59:07,857 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute16 2018-10-09 18:59:07,859 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute11 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,861 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute11 - remove event too 2018-10-09 18:59:07,863 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute11 2018-10-09 18:59:07,866 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute10 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,868 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute10 - remove event too 2018-10-09 18:59:07,869 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute10 2018-10-09 18:59:07,871 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute13 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,872 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute13 - remove event too 2018-10-09 18:59:07,874 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute13 2018-10-09 18:59:07,875 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute12 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,877 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute12 - remove event too 2018-10-09 18:59:07,878 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute12 2018-10-09 18:59:07,880 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute19 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,881 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute19 - remove event too 2018-10-09 18:59:07,883 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute19 2018-10-09 18:59:07,884 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute18 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,886 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute18 - remove event too 2018-10-09 18:59:07,888 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute18 2018-10-09 18:59:07,889 [TRACE] [doorpi.action.handler] unregister Event OnTimeWeekUnevenNumber from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,891 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeWeekUnevenNumber - remove event too 2018-10-09 18:59:07,892 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeWeekUnevenNumber 2018-10-09 18:59:07,894 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinuteEvery5 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,895 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinuteEvery5 - remove event too 2018-10-09 18:59:07,897 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinuteEvery5 2018-10-09 18:59:07,898 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour20 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,900 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour20 - remove event too 2018-10-09 18:59:07,901 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour20 2018-10-09 18:59:07,903 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour21 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,904 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour21 - remove event too 2018-10-09 18:59:07,906 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour21 2018-10-09 18:59:07,907 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour22 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,909 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour22 - remove event too 2018-10-09 18:59:07,910 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour22 2018-10-09 18:59:07,912 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour5 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,913 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour5 - remove event too 2018-10-09 18:59:07,915 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour5 2018-10-09 18:59:07,917 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute20 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,918 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute20 - remove event too 2018-10-09 18:59:07,920 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute20 2018-10-09 18:59:07,921 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute21 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,923 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute21 - remove event too 2018-10-09 18:59:07,924 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute21 2018-10-09 18:59:07,926 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute22 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,927 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute22 - remove event too 2018-10-09 18:59:07,929 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute22 2018-10-09 18:59:07,930 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute23 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,932 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute23 - remove event too 2018-10-09 18:59:07,933 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute23 2018-10-09 18:59:07,935 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute24 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,936 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute24 - remove event too 2018-10-09 18:59:07,938 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute24 2018-10-09 18:59:07,939 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute25 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,941 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute25 - remove event too 2018-10-09 18:59:07,943 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute25 2018-10-09 18:59:07,944 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute26 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,946 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute26 - remove event too 2018-10-09 18:59:07,947 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute26 2018-10-09 18:59:07,949 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute27 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,950 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute27 - remove event too 2018-10-09 18:59:07,952 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute27 2018-10-09 18:59:07,953 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute28 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,955 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute28 - remove event too 2018-10-09 18:59:07,956 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute28 2018-10-09 18:59:07,958 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute29 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,959 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute29 - remove event too 2018-10-09 18:59:07,961 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute29 2018-10-09 18:59:07,962 [TRACE] [doorpi.action.handler] unregister Event OnTimeDayEvenNumber from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,964 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeDayEvenNumber - remove event too 2018-10-09 18:59:07,965 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeDayEvenNumber 2018-10-09 18:59:07,967 [TRACE] [doorpi.action.handler] unregister Event OnTimeDayUnevenNumber from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,968 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeDayUnevenNumber - remove event too 2018-10-09 18:59:07,970 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeDayUnevenNumber 2018-10-09 18:59:07,972 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute39 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,973 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute39 - remove event too 2018-10-09 18:59:07,975 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute39 2018-10-09 18:59:07,976 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute38 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,977 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute38 - remove event too 2018-10-09 18:59:07,979 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute38 2018-10-09 18:59:07,981 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute37 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,982 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute37 - remove event too 2018-10-09 18:59:07,984 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute37 2018-10-09 18:59:07,985 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute36 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,987 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute36 - remove event too 2018-10-09 18:59:07,988 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute36 2018-10-09 18:59:07,990 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute35 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,991 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute35 - remove event too 2018-10-09 18:59:07,993 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute35 2018-10-09 18:59:07,995 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute34 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:07,996 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute34 - remove event too 2018-10-09 18:59:07,998 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute34 2018-10-09 18:59:07,999 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute33 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:08,001 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute33 - remove event too 2018-10-09 18:59:08,002 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute33 2018-10-09 18:59:08,004 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute32 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:08,005 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute32 - remove event too 2018-10-09 18:59:08,007 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute32 2018-10-09 18:59:08,008 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute31 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:08,010 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute31 - remove event too 2018-10-09 18:59:08,011 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute31 2018-10-09 18:59:08,013 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute30 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:08,015 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute30 - remove event too 2018-10-09 18:59:08,016 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute30 2018-10-09 18:59:08,018 [TRACE] [doorpi.action.handler] unregister Event OnTimeHourUnevenNumber from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:08,019 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHourUnevenNumber - remove event too 2018-10-09 18:59:08,021 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHourUnevenNumber 2018-10-09 18:59:08,022 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:08,024 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute - remove event too 2018-10-09 18:59:08,025 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute 2018-10-09 18:59:08,027 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute48 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:08,028 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute48 - remove event too 2018-10-09 18:59:08,030 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute48 2018-10-09 18:59:08,031 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute49 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:08,033 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute49 - remove event too 2018-10-09 18:59:08,034 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute49 2018-10-09 18:59:08,036 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute42 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:08,037 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute42 - remove event too 2018-10-09 18:59:08,039 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute42 2018-10-09 18:59:08,041 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute43 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:08,042 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute43 - remove event too 2018-10-09 18:59:08,044 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute43 2018-10-09 18:59:08,045 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute40 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:08,047 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute40 - remove event too 2018-10-09 18:59:08,049 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute40 2018-10-09 18:59:08,051 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute41 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:08,052 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute41 - remove event too 2018-10-09 18:59:08,054 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute41 2018-10-09 18:59:08,055 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute46 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:08,057 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute46 - remove event too 2018-10-09 18:59:08,058 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute46 2018-10-09 18:59:08,060 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute47 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:08,062 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute47 - remove event too 2018-10-09 18:59:08,064 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute47 2018-10-09 18:59:08,065 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute44 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:08,069 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute44 - remove event too 2018-10-09 18:59:08,071 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute44 2018-10-09 18:59:08,073 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute45 from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:08,074 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute45 - remove event too 2018-10-09 18:59:08,076 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute45 2018-10-09 18:59:08,077 [TRACE] [doorpi.action.handler] unregister Event OnTimeHourEvenNumber from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:08,079 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHourEvenNumber - remove event too 2018-10-09 18:59:08,081 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHourEvenNumber 2018-10-09 18:59:08,082 [TRACE] [doorpi.action.handler] unregister Event OnTimeSecondEvenNumber from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:08,084 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeSecondEvenNumber - remove event too 2018-10-09 18:59:08,085 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeSecondEvenNumber 2018-10-09 18:59:08,087 [TRACE] [doorpi.action.handler] unregister Event OnTimeYear from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:08,088 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeYear - remove event too 2018-10-09 18:59:08,090 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeYear 2018-10-09 18:59:08,091 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinuteUnevenNumber from doorpi.action.SingleActions.time_tick 2018-10-09 18:59:08,093 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinuteUnevenNumber - remove event too 2018-10-09 18:59:08,094 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinuteUnevenNumber 2018-10-09 18:59:08,096 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed 2018-10-09 18:59:08,099 [TRACE] [doorpi.action.handler] [YHXZW3] try to fire action WebServerShutdownAction with args () and kwargs {} 2018-10-09 18:59:08,100 [TRACE] [doorpi.action.base] run WebServerShutdownAction with args () and kwargs {} 2018-10-09 18:59:08,102 [TRACE] [doorpi.action.handler] fire Event OnWebServerStop from doorpi.status.webserver asyncron 2018-10-09 18:59:08,105 [TRACE] [doorpi.action.handler] unregister Eventsource doorpi.status.webserver_lib.request_handler and force_unregister is True 2018-10-09 18:59:08,107 [TRACE] [doorpi.action.handler] unregister Event OnWebServerVirtualResource from doorpi.status.webserver_lib.request_handler 2018-10-09 18:59:08,108 [DEBUG] [doorpi.action.handler] no more sources for event OnWebServerVirtualResource - remove event too 2018-10-09 18:59:08,112 [DEBUG] [doorpi.action.handler] no actions for event OnWebServerStop - skip fire_event OnWebServerStop from doorpi.status.webserver 2018-10-09 18:59:08,110 [TRACE] [doorpi.action.handler] event_source doorpi.status.webserver_lib.request_handler was removed for event OnWebServerVirtualResource 2018-10-09 18:59:08,115 [TRACE] [doorpi.action.handler] unregister Event OnWebServerRealResource from doorpi.status.webserver_lib.request_handler 2018-10-09 18:59:08,117 [DEBUG] [doorpi.action.handler] no more sources for event OnWebServerRealResource - remove event too 2018-10-09 18:59:08,118 [TRACE] [doorpi.action.handler] event_source doorpi.status.webserver_lib.request_handler was removed for event OnWebServerRealResource 2018-10-09 18:59:08,120 [TRACE] [doorpi.action.handler] unregister Event OnConfigKeySet from doorpi.status.webserver_lib.request_handler 2018-10-09 18:59:08,121 [DEBUG] [doorpi.action.handler] no more sources for event OnConfigKeySet - remove event too 2018-10-09 18:59:08,123 [TRACE] [doorpi.action.handler] event_source doorpi.status.webserver_lib.request_handler was removed for event OnConfigKeySet 2018-10-09 18:59:08,124 [TRACE] [doorpi.action.handler] unregister Event OnWebServerRequestGet from doorpi.status.webserver_lib.request_handler 2018-10-09 18:59:08,126 [DEBUG] [doorpi.action.handler] no more sources for event OnWebServerRequestGet - remove event too 2018-10-09 18:59:08,128 [TRACE] [doorpi.action.handler] event_source doorpi.status.webserver_lib.request_handler was removed for event OnWebServerRequestGet 2018-10-09 18:59:08,129 [TRACE] [doorpi.action.handler] unregister Event OnWebServerRequestPost from doorpi.status.webserver_lib.request_handler 2018-10-09 18:59:08,131 [DEBUG] [doorpi.action.handler] no more sources for event OnWebServerRequestPost - remove event too 2018-10-09 18:59:08,132 [TRACE] [doorpi.action.handler] event_source doorpi.status.webserver_lib.request_handler was removed for event OnWebServerRequestPost 2018-10-09 18:59:08,134 [TRACE] [doorpi.action.handler] unregister Event OnConfigKeyDelete from doorpi.status.webserver_lib.request_handler 2018-10-09 18:59:08,135 [DEBUG] [doorpi.action.handler] no more sources for event OnConfigKeyDelete - remove event too 2018-10-09 18:59:08,137 [TRACE] [doorpi.action.handler] event_source doorpi.status.webserver_lib.request_handler was removed for event OnConfigKeyDelete 2018-10-09 18:59:08,138 [TRACE] [doorpi.action.handler] unregister Event OnWebServerRequest from doorpi.status.webserver_lib.request_handler 2018-10-09 18:59:08,140 [DEBUG] [doorpi.action.handler] no more sources for event OnWebServerRequest - remove event too 2018-10-09 18:59:08,141 [TRACE] [doorpi.action.handler] event_source doorpi.status.webserver_lib.request_handler was removed for event OnWebServerRequest 2018-10-09 18:59:08,143 [TRACE] [doorpi.action.handler] unregister Event OnFireEvent from doorpi.status.webserver_lib.request_handler 2018-10-09 18:59:08,145 [DEBUG] [doorpi.action.handler] no more sources for event OnFireEvent - remove event too 2018-10-09 18:59:08,146 [TRACE] [doorpi.action.handler] event_source doorpi.status.webserver_lib.request_handler was removed for event OnFireEvent 2018-10-09 18:59:08,148 [TRACE] [doorpi.action.handler] event_source doorpi.status.webserver_lib.request_handler was removed 2018-10-09 18:59:08,186 [TRACE] [doorpi.action.handler] unregister Eventsource doorpi.status.webserver and force_unregister is True 2018-10-09 18:59:08,188 [TRACE] [doorpi.action.handler] unregister Event OnWebServerStop from doorpi.status.webserver 2018-10-09 18:59:08,189 [DEBUG] [doorpi.action.handler] no more sources for event OnWebServerStop - remove event too 2018-10-09 18:59:08,195 [TRACE] [doorpi.action.handler] [G83Q3J] finished fire_event for event_name OnWebServerStart 2018-10-09 18:59:08,196 [TRACE] [doorpi.action.handler] event_source doorpi.status.webserver was removed for event OnWebServerStop 2018-10-09 18:59:08,200 [TRACE] [doorpi.action.handler] unregister Event OnWebServerStart from doorpi.status.webserver 2018-10-09 18:59:08,201 [DEBUG] [doorpi.action.handler] no more sources for event OnWebServerStart - remove event too 2018-10-09 18:59:08,203 [TRACE] [doorpi.action.handler] event_source doorpi.status.webserver was removed for event OnWebServerStart 2018-10-09 18:59:08,205 [TRACE] [doorpi.action.handler] event_source doorpi.status.webserver was removed 2018-10-09 18:59:08,207 [TRACE] [doorpi.action.handler] [YHXZW3] try to fire action KeyboardDestroyAction with args () and kwargs {} 2018-10-09 18:59:08,209 [TRACE] [doorpi.action.base] run KeyboardDestroyAction with args () and kwargs {} 2018-10-09 18:59:08,210 [DEBUG] [doorpi.keyboard.from_gpio] destroy 2018-10-09 18:59:08,221 [TRACE] [doorpi.action.handler] unregister Eventsource doorpi.keyboard.from_gpio and force_unregister is True 2018-10-09 18:59:08,222 [TRACE] [doorpi.action.handler] unregister Event OnKeyPressed from doorpi.keyboard.from_gpio 2018-10-09 18:59:08,224 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyPressed - remove event too 2018-10-09 18:59:08,226 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_gpio was removed for event OnKeyPressed 2018-10-09 18:59:08,227 [TRACE] [doorpi.action.handler] unregister Event OnKeyUp from doorpi.keyboard.from_gpio 2018-10-09 18:59:08,228 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyUp - remove event too 2018-10-09 18:59:08,230 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_gpio was removed for event OnKeyUp 2018-10-09 18:59:08,251 [TRACE] [doorpi.action.handler] unregister Event OnKeyDown_40 from doorpi.keyboard.from_gpio 2018-10-09 18:59:08,253 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyDown_40 - remove event too 2018-10-09 18:59:08,255 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_gpio was removed for event OnKeyDown_40 2018-10-09 18:59:08,256 [TRACE] [doorpi.action.handler] unregister Event OnKeyPressed_40 from doorpi.keyboard.from_gpio 2018-10-09 18:59:08,258 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyPressed_40 - remove event too 2018-10-09 18:59:08,259 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_gpio was removed for event OnKeyPressed_40 2018-10-09 18:59:08,261 [TRACE] [doorpi.action.handler] unregister Event OnKeyUp_40 from doorpi.keyboard.from_gpio 2018-10-09 18:59:08,263 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyUp_40 - remove event too 2018-10-09 18:59:08,271 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_gpio was removed for event OnKeyUp_40 2018-10-09 18:59:08,273 [TRACE] [doorpi.action.handler] unregister Event OnKeyUp_onboardpins.40 from doorpi.keyboard.from_gpio 2018-10-09 18:59:08,274 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyUp_onboardpins.40 - remove event too 2018-10-09 18:59:08,276 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_gpio was removed for event OnKeyUp_onboardpins.40 2018-10-09 18:59:08,277 [TRACE] [doorpi.action.handler] unregister Event OnKeyDown_onboardpins.40 from doorpi.keyboard.from_gpio 2018-10-09 18:59:08,279 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyDown_onboardpins.40 - remove event too 2018-10-09 18:59:08,291 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_gpio was removed for event OnKeyDown_onboardpins.40 2018-10-09 18:59:08,292 [TRACE] [doorpi.action.handler] unregister Event OnKeyDown from doorpi.keyboard.from_gpio 2018-10-09 18:59:08,294 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyDown - remove event too 2018-10-09 18:59:08,295 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_gpio was removed for event OnKeyDown 2018-10-09 18:59:08,297 [TRACE] [doorpi.action.handler] unregister Event OnKeyPressed_onboardpins.40 from doorpi.keyboard.from_gpio 2018-10-09 18:59:08,299 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyPressed_onboardpins.40 - remove event too 2018-10-09 18:59:08,300 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_gpio was removed for event OnKeyPressed_onboardpins.40 2018-10-09 18:59:08,312 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_gpio was removed 2018-10-09 18:59:08,314 [TRACE] [doorpi.action.handler] [YHXZW3] try to fire action > with args () and kwargs {} 2018-10-09 18:59:08,316 [TRACE] [doorpi.action.base] run SingleAction with args () and kwargs {} 2018-10-09 18:59:08,317 [DEBUG] [doorpi.sipphone.from_linphone] destroy 2018-10-09 18:59:08,319 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_terminate_all_calls(0xb4583f08 [0x1e39520]) 2018-10-09 18:59:08,330 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_terminate_all_calls -> 0x1dc38cc 2018-10-09 18:59:08,333 [DEBUG] [doorpi.action.handler] [4ZGX18] fire for event OnSipPhoneDestroy this actions [, , ] 2018-10-09 18:59:08,335 [TRACE] [doorpi.action.handler] [4ZGX18] try to fire action > with args () and kwargs {} 2018-10-09 18:59:08,336 [TRACE] [doorpi.action.base] run SingleAction with args () and kwargs {} 2018-10-09 18:59:08,338 [DEBUG] [doorpi.sipphone.linphone_lib.CallBacks] destroy 2018-10-09 18:59:08,339 [TRACE] [doorpi.action.handler] unregister Eventsource doorpi.sipphone.linphone_lib.CallBacks and force_unregister is True 2018-10-09 18:59:08,341 [TRACE] [doorpi.action.handler] unregister Event OnCallReject from doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:08,342 [DEBUG] [doorpi.action.handler] no more sources for event OnCallReject - remove event too 2018-10-09 18:59:08,344 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event OnCallReject 2018-10-09 18:59:08,345 [TRACE] [doorpi.action.handler] unregister Event OnMediaNotRequired from doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:08,347 [DEBUG] [doorpi.action.handler] no more sources for event OnMediaNotRequired - remove event too 2018-10-09 18:59:08,348 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event OnMediaNotRequired 2018-10-09 18:59:08,350 [TRACE] [doorpi.action.handler] unregister Event OnDTMF from doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:08,352 [DEBUG] [doorpi.action.handler] no more sources for event OnDTMF - remove event too 2018-10-09 18:59:08,353 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event OnDTMF 2018-10-09 18:59:08,355 [TRACE] [doorpi.action.handler] unregister Event OnMediaRequired from doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:08,356 [DEBUG] [doorpi.action.handler] no more sources for event OnMediaRequired - remove event too 2018-10-09 18:59:08,358 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event OnMediaRequired 2018-10-09 18:59:08,359 [TRACE] [doorpi.action.handler] unregister Event OnCallMediaStateChange from doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:08,361 [DEBUG] [doorpi.action.handler] no more sources for event OnCallMediaStateChange - remove event too 2018-10-09 18:59:08,362 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event OnCallMediaStateChange 2018-10-09 18:59:08,364 [TRACE] [doorpi.action.handler] unregister Event AfterCallStateConnect from doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:08,365 [DEBUG] [doorpi.action.handler] no more sources for event AfterCallStateConnect - remove event too 2018-10-09 18:59:08,367 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event AfterCallStateConnect 2018-10-09 18:59:08,369 [TRACE] [doorpi.action.handler] unregister Event OnCallBusy from doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:08,370 [DEBUG] [doorpi.action.handler] no more sources for event OnCallBusy - remove event too 2018-10-09 18:59:08,372 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event OnCallBusy 2018-10-09 18:59:08,373 [TRACE] [doorpi.action.handler] unregister Event AfterCallBusy from doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:08,375 [DEBUG] [doorpi.action.handler] no more sources for event AfterCallBusy - remove event too 2018-10-09 18:59:08,376 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event AfterCallBusy 2018-10-09 18:59:08,378 [TRACE] [doorpi.action.handler] unregister Event AfterCallStateDisconnect from doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:08,379 [DEBUG] [doorpi.action.handler] no more sources for event AfterCallStateDisconnect - remove event too 2018-10-09 18:59:08,381 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event AfterCallStateDisconnect 2018-10-09 18:59:08,382 [TRACE] [doorpi.action.handler] unregister Event OnCallStateReject from doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:08,384 [DEBUG] [doorpi.action.handler] no more sources for event OnCallStateReject - remove event too 2018-10-09 18:59:08,386 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event OnCallStateReject 2018-10-09 18:59:08,387 [TRACE] [doorpi.action.handler] unregister Event BeforeCallIncoming from doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:08,388 [DEBUG] [doorpi.action.handler] no more sources for event BeforeCallIncoming - remove event too 2018-10-09 18:59:08,390 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event BeforeCallIncoming 2018-10-09 18:59:08,392 [TRACE] [doorpi.action.handler] unregister Event OnCallStateChange from doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:08,393 [DEBUG] [doorpi.action.handler] no more sources for event OnCallStateChange - remove event too 2018-10-09 18:59:08,395 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event OnCallStateChange 2018-10-09 18:59:08,396 [TRACE] [doorpi.action.handler] unregister Event OnCallStateDismissed from doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:08,398 [DEBUG] [doorpi.action.handler] no more sources for event OnCallStateDismissed - remove event too 2018-10-09 18:59:08,399 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event OnCallStateDismissed 2018-10-09 18:59:08,401 [TRACE] [doorpi.action.handler] unregister Event OnCallStateDisconnect from doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:08,403 [DEBUG] [doorpi.action.handler] no more sources for event OnCallStateDisconnect - remove event too 2018-10-09 18:59:08,404 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event OnCallStateDisconnect 2018-10-09 18:59:08,406 [TRACE] [doorpi.action.handler] unregister Event AfterCallReject from doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:08,407 [DEBUG] [doorpi.action.handler] no more sources for event AfterCallReject - remove event too 2018-10-09 18:59:08,409 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event AfterCallReject 2018-10-09 18:59:08,410 [TRACE] [doorpi.action.handler] unregister Event OnCallStart from doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:08,412 [DEBUG] [doorpi.action.handler] no more sources for event OnCallStart - remove event too 2018-10-09 18:59:08,413 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event OnCallStart 2018-10-09 18:59:08,415 [TRACE] [doorpi.action.handler] unregister Event AfterCallReconnect from doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:08,416 [DEBUG] [doorpi.action.handler] no more sources for event AfterCallReconnect - remove event too 2018-10-09 18:59:08,418 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event AfterCallReconnect 2018-10-09 18:59:08,419 [TRACE] [doorpi.action.handler] unregister Event OnCallStateConnect from doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:08,421 [DEBUG] [doorpi.action.handler] no more sources for event OnCallStateConnect - remove event too 2018-10-09 18:59:08,423 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event OnCallStateConnect 2018-10-09 18:59:08,424 [TRACE] [doorpi.action.handler] unregister Event OnCallIncoming from doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:08,426 [DEBUG] [doorpi.action.handler] no more sources for event OnCallIncoming - remove event too 2018-10-09 18:59:08,427 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event OnCallIncoming 2018-10-09 18:59:08,429 [TRACE] [doorpi.action.handler] unregister Event AfterCallIncoming from doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:08,431 [DEBUG] [doorpi.action.handler] no more sources for event AfterCallIncoming - remove event too 2018-10-09 18:59:08,432 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event AfterCallIncoming 2018-10-09 18:59:08,434 [TRACE] [doorpi.action.handler] unregister Event OnCallReconnect from doorpi.sipphone.linphone_lib.CallBacks 2018-10-09 18:59:08,435 [DEBUG] [doorpi.action.handler] no more sources for event OnCallReconnect - remove event too 2018-10-09 18:59:08,437 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event OnCallReconnect 2018-10-09 18:59:08,438 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed 2018-10-09 18:59:08,441 [TRACE] [doorpi.action.handler] [4ZGX18] try to fire action > with args () and kwargs {} 2018-10-09 18:59:08,443 [TRACE] [doorpi.action.base] run SingleAction with args () and kwargs {} 2018-10-09 18:59:08,444 [TRACE] [doorpi.action.handler] fire Event OnPlayerStopped from doorpi.sipphone.linphone_lib.Player asyncron 2018-10-09 18:59:08,448 [TRACE] [doorpi.action.handler] unregister Eventsource doorpi.sipphone.linphone_lib.Player and force_unregister is True 2018-10-09 18:59:08,449 [TRACE] [doorpi.action.handler] unregister Event OnPlayerCreated from doorpi.sipphone.linphone_lib.Player 2018-10-09 18:59:08,451 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.Player was removed for event OnPlayerCreated 2018-10-09 18:59:08,453 [TRACE] [doorpi.action.handler] unregister Event OnPlayerStarted from doorpi.sipphone.linphone_lib.Player 2018-10-09 18:59:08,454 [DEBUG] [doorpi.action.handler] no more sources for event OnPlayerStarted - remove event too 2018-10-09 18:59:08,456 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.Player was removed for event OnPlayerStarted 2018-10-09 18:59:08,457 [TRACE] [doorpi.action.handler] unregister Event OnPlayerStopped from doorpi.sipphone.linphone_lib.Player 2018-10-09 18:59:08,459 [DEBUG] [doorpi.action.handler] no more sources for event OnPlayerStopped - remove event too 2018-10-09 18:59:08,462 [WARNING] [doorpi.action.handler] event OnPlayerStopped unknown - skip fire_event OnPlayerStopped from doorpi.sipphone.linphone_lib.Player 2018-10-09 18:59:08,467 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.Player was removed for event OnPlayerStopped 2018-10-09 18:59:08,468 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.Player was removed 2018-10-09 18:59:08,471 [TRACE] [doorpi.action.handler] [4ZGX18] try to fire action > with args () and kwargs {} 2018-10-09 18:59:08,473 [TRACE] [doorpi.action.base] run SingleAction with args () and kwargs {} 2018-10-09 18:59:08,475 [TRACE] [doorpi.action.handler] unregister Eventsource doorpi.sipphone.linphone_lib.Recorder and force_unregister is True 2018-10-09 18:59:08,476 [TRACE] [doorpi.action.handler] unregister Event OnRecorderCreated from doorpi.sipphone.linphone_lib.Recorder 2018-10-09 18:59:08,478 [DEBUG] [doorpi.action.handler] no more sources for event OnRecorderCreated - remove event too 2018-10-09 18:59:08,479 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.Recorder was removed for event OnRecorderCreated 2018-10-09 18:59:08,481 [TRACE] [doorpi.action.handler] unregister Event OnRecorderStarted from doorpi.sipphone.linphone_lib.Recorder 2018-10-09 18:59:08,482 [DEBUG] [doorpi.action.handler] no more sources for event OnRecorderStarted - remove event too 2018-10-09 18:59:08,484 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.Recorder was removed for event OnRecorderStarted 2018-10-09 18:59:08,486 [TRACE] [doorpi.action.handler] unregister Event OnRecorderStopped from doorpi.sipphone.linphone_lib.Recorder 2018-10-09 18:59:08,487 [DEBUG] [doorpi.action.handler] no more sources for event OnRecorderStopped - remove event too 2018-10-09 18:59:08,489 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.Recorder was removed for event OnRecorderStopped 2018-10-09 18:59:08,490 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.Recorder was removed 2018-10-09 18:59:08,493 [TRACE] [doorpi.action.handler] [4ZGX18] finished fire_event for event_name OnSipPhoneDestroy 2018-10-09 18:59:08,494 [TRACE] [doorpi.action.handler] unregister Eventsource doorpi.sipphone.from_linphone and force_unregister is True 2018-10-09 18:59:08,496 [TRACE] [doorpi.action.handler] unregister Event OnSipPhoneRecorderCreate from doorpi.sipphone.from_linphone 2018-10-09 18:59:08,498 [DEBUG] [doorpi.action.handler] no more sources for event OnSipPhoneRecorderCreate - remove event too 2018-10-09 18:59:08,499 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.from_linphone was removed for event OnSipPhoneRecorderCreate 2018-10-09 18:59:08,501 [TRACE] [doorpi.action.handler] unregister Event OnSipPhoneMakeCall from doorpi.sipphone.from_linphone 2018-10-09 18:59:08,502 [DEBUG] [doorpi.action.handler] no more sources for event OnSipPhoneMakeCall - remove event too 2018-10-09 18:59:08,504 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.from_linphone was removed for event OnSipPhoneMakeCall 2018-10-09 18:59:08,505 [TRACE] [doorpi.action.handler] unregister Event OnPlayerCreated from doorpi.sipphone.from_linphone 2018-10-09 18:59:08,507 [DEBUG] [doorpi.action.handler] no more sources for event OnPlayerCreated - remove event too 2018-10-09 18:59:08,508 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.from_linphone was removed for event OnPlayerCreated 2018-10-09 18:59:08,510 [TRACE] [doorpi.action.handler] unregister Event BeforeSipPhoneMakeCall from doorpi.sipphone.from_linphone 2018-10-09 18:59:08,511 [DEBUG] [doorpi.action.handler] no more sources for event BeforeSipPhoneMakeCall - remove event too 2018-10-09 18:59:08,513 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.from_linphone was removed for event BeforeSipPhoneMakeCall 2018-10-09 18:59:08,514 [TRACE] [doorpi.action.handler] unregister Event OnSipPhoneRecorderDestroy from doorpi.sipphone.from_linphone 2018-10-09 18:59:08,516 [DEBUG] [doorpi.action.handler] no more sources for event OnSipPhoneRecorderDestroy - remove event too 2018-10-09 18:59:08,517 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.from_linphone was removed for event OnSipPhoneRecorderDestroy 2018-10-09 18:59:08,519 [TRACE] [doorpi.action.handler] unregister Event OnSipPhoneStart from doorpi.sipphone.from_linphone 2018-10-09 18:59:08,521 [DEBUG] [doorpi.action.handler] no more sources for event OnSipPhoneStart - remove event too 2018-10-09 18:59:08,522 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.from_linphone was removed for event OnSipPhoneStart 2018-10-09 18:59:08,524 [TRACE] [doorpi.action.handler] unregister Event OnSipPhoneDestroy from doorpi.sipphone.from_linphone 2018-10-09 18:59:08,525 [DEBUG] [doorpi.action.handler] no more sources for event OnSipPhoneDestroy - remove event too 2018-10-09 18:59:08,527 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.from_linphone was removed for event OnSipPhoneDestroy 2018-10-09 18:59:08,528 [TRACE] [doorpi.action.handler] unregister Event OnSipPhoneCallTimeoutMaxCalltime from doorpi.sipphone.from_linphone 2018-10-09 18:59:08,530 [DEBUG] [doorpi.action.handler] no more sources for event OnSipPhoneCallTimeoutMaxCalltime - remove event too 2018-10-09 18:59:08,531 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.from_linphone was removed for event OnSipPhoneCallTimeoutMaxCalltime 2018-10-09 18:59:08,533 [TRACE] [doorpi.action.handler] unregister Event OnSipPhoneCallTimeoutNoResponse from doorpi.sipphone.from_linphone 2018-10-09 18:59:08,534 [DEBUG] [doorpi.action.handler] no more sources for event OnSipPhoneCallTimeoutNoResponse - remove event too 2018-10-09 18:59:08,536 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.from_linphone was removed for event OnSipPhoneCallTimeoutNoResponse 2018-10-09 18:59:08,537 [TRACE] [doorpi.action.handler] unregister Event AfterSipPhoneMakeCall from doorpi.sipphone.from_linphone 2018-10-09 18:59:08,539 [DEBUG] [doorpi.action.handler] no more sources for event AfterSipPhoneMakeCall - remove event too 2018-10-09 18:59:08,541 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.from_linphone was removed for event AfterSipPhoneMakeCall 2018-10-09 18:59:08,542 [TRACE] [doorpi.action.handler] unregister Event OnSipPhoneMakeCallFailed from doorpi.sipphone.from_linphone 2018-10-09 18:59:08,544 [DEBUG] [doorpi.action.handler] no more sources for event OnSipPhoneMakeCallFailed - remove event too 2018-10-09 18:59:08,545 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.from_linphone was removed for event OnSipPhoneMakeCallFailed 2018-10-09 18:59:08,547 [TRACE] [doorpi.action.handler] unregister Event OnSipPhoneCreate from doorpi.sipphone.from_linphone 2018-10-09 18:59:08,548 [DEBUG] [doorpi.action.handler] no more sources for event OnSipPhoneCreate - remove event too 2018-10-09 18:59:08,550 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.from_linphone was removed for event OnSipPhoneCreate 2018-10-09 18:59:08,551 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.from_linphone was removed 2018-10-09 18:59:08,554 [TRACE] [doorpi.action.handler] [YHXZW3] finished fire_event for event_name OnShutdown 2018-10-09 18:59:08,555 [TRACE] [doorpi.action.handler] fire Event AfterShutdown from doorpi.doorpi asyncron 2018-10-09 18:59:08,560 [DEBUG] [doorpi.action.handler] no actions for event AfterShutdown - skip fire_event AfterShutdown from doorpi.doorpi 2018-10-09 18:59:09,060 [INFO] [doorpi.doorpi] ======== DoorPi successfully shutdown ========