pi@raspberrypi:~ $ sudo doorpi_cli --trace 2019-06-13 13:18:13,827 [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 2019-06-13 13:18:13,828 [DEBUG] [doorpi.main] loaded with arguments: ['/usr/local/bin/doorpi_cli', '--trace'] 2019-06-13 13:18:13,829 [DEBUG] [doorpi.doorpi] run 2019-06-13 13:18:13,829 [DEBUG] [doorpi.doorpi] prepare 2019-06-13 13:18:13,830 [DEBUG] [doorpi.doorpi] given arguments argv: Namespace(configfile=None, debug=False, test=False, trace=True) 2019-06-13 13:18:13,832 [INFO] [doorpi.conf.config_object] use configfile: /usr/local/etc/DoorPi/conf/doorpi.ini 2019-06-13 13:18:13,837 [DEBUG] [doorpi.conf.config_object] __init__ 2019-06-13 13:18:13,838 [TRACE] [doorpi.conf.config_object] get_from_config 2019-06-13 13:18:13,843 [TRACE] [doorpi.conf.config_object] get_string for key base_path in section DoorPi (default: /usr/local/etc/DoorPi) returns /usr/local/etc/DoorPi 2019-06-13 13:18:13,844 [TRACE] [doorpi.conf.config_object] get_string for key eventlog in section DoorPi (default: !BASEPATH!/conf/eventlog.db) returns !BASEPATH!/conf/eventlog.db 2019-06-13 13:18:13,845 [DEBUG] [doorpi.conf.config_object] parse string "!BASEPATH!/conf/eventlog.db" to "/usr/local/etc/DoorPi/conf/eventlog.db" 2019-06-13 13:18:13,847 [TRACE] [doorpi.action.handler] register Event BeforeStartup from doorpi.doorpi 2019-06-13 13:18:13,848 [DEBUG] [doorpi.action.handler] event_source doorpi.doorpi was added 2019-06-13 13:18:13,848 [TRACE] [doorpi.action.handler] added event_name BeforeStartup and registered source doorpi.doorpi 2019-06-13 13:18:13,849 [TRACE] [doorpi.action.handler] register Event OnStartup from doorpi.doorpi 2019-06-13 13:18:13,849 [TRACE] [doorpi.action.handler] added event_name OnStartup and registered source doorpi.doorpi 2019-06-13 13:18:13,849 [TRACE] [doorpi.action.handler] register Event AfterStartup from doorpi.doorpi 2019-06-13 13:18:13,850 [TRACE] [doorpi.action.handler] added event_name AfterStartup and registered source doorpi.doorpi 2019-06-13 13:18:13,850 [TRACE] [doorpi.action.handler] register Event BeforeShutdown from doorpi.doorpi 2019-06-13 13:18:13,850 [TRACE] [doorpi.action.handler] added event_name BeforeShutdown and registered source doorpi.doorpi 2019-06-13 13:18:13,850 [TRACE] [doorpi.action.handler] register Event OnShutdown from doorpi.doorpi 2019-06-13 13:18:13,851 [TRACE] [doorpi.action.handler] added event_name OnShutdown and registered source doorpi.doorpi 2019-06-13 13:18:13,851 [TRACE] [doorpi.action.handler] register Event AfterShutdown from doorpi.doorpi 2019-06-13 13:18:13,851 [TRACE] [doorpi.action.handler] added event_name AfterShutdown and registered source doorpi.doorpi 2019-06-13 13:18:13,853 [DEBUG] [doorpi.action.SingleActions.time_tick] doorpi.action.SingleActions.time_tick loaded 2019-06-13 13:18:13,853 [DEBUG] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was added 2019-06-13 13:18:13,865 [TRACE] [doorpi.action.handler] action TimeTickDestroyAction with args () and kwargs {} was added to new evententry OnShutdown 2019-06-13 13:18:13,866 [TRACE] [doorpi.action.handler] action TimeTickAction with args ('!last_tick!',) and kwargs {} was added to new evententry OnTimeTick 2019-06-13 13:18:13,868 [TRACE] [doorpi.conf.config_object] get_string for key ip in section DoorPiWeb (default: ) returns 192.168.188.23 2019-06-13 13:18:13,869 [TRACE] [doorpi.conf.config_object] get_integer for key port in section DoorPiWeb (default: 80) returns 80 2019-06-13 13:18:13,874 [INFO] [doorpi.status.webserver] Initiating WebService at ip 192.168.188.23 and port 80 2019-06-13 13:18:13,875 [TRACE] [doorpi.action.handler] register Event OnWebServerStart from doorpi.status.webserver 2019-06-13 13:18:13,876 [DEBUG] [doorpi.action.handler] event_source doorpi.status.webserver was added 2019-06-13 13:18:13,876 [TRACE] [doorpi.action.handler] added event_name OnWebServerStart and registered source doorpi.status.webserver 2019-06-13 13:18:13,877 [TRACE] [doorpi.action.handler] register Event OnWebServerStop from doorpi.status.webserver 2019-06-13 13:18:13,877 [TRACE] [doorpi.action.handler] added event_name OnWebServerStop and registered source doorpi.status.webserver 2019-06-13 13:18:13,878 [TRACE] [doorpi.conf.config_object] get_string for key www in section DoorPiWeb (default: !BASEPATH!/../DoorPiWeb) returns !BASEPATH!/../DoorPiWeb 2019-06-13 13:18:13,879 [DEBUG] [doorpi.conf.config_object] parse string "!BASEPATH!/../DoorPiWeb" to "/usr/local/etc/DoorPi/../DoorPiWeb" 2019-06-13 13:18:13,879 [TRACE] [doorpi.conf.config_object] get_string for key indexfile in section DoorPiWeb (default: index.html) returns index.html 2019-06-13 13:18:13,880 [DEBUG] [doorpi.conf.config_object] parse string "index.html" to "index.html" 2019-06-13 13:18:13,881 [TRACE] [doorpi.conf.config_object] get_string for key loginfile in section DoorPiWeb (default: login.html) returns login.html 2019-06-13 13:18:13,882 [DEBUG] [doorpi.conf.config_object] parse string "login.html" to "login.html" 2019-06-13 13:18:13,882 [TRACE] [doorpi.conf.config_object] get_string for key public in section DoorPiWeb (default: AREA_public) returns AREA_public 2019-06-13 13:18:13,883 [DEBUG] [doorpi.conf.config_object] parse string "AREA_public" to "AREA_public" 2019-06-13 13:18:13,884 [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 2019-06-13 13:18:13,886 [DEBUG] [doorpi.conf.config_object] parse string "http://motom001.github.io/DoorPiWeb" to "http://motom001.github.io/DoorPiWeb" 2019-06-13 13:18:13,886 [TRACE] [doorpi.conf.config_object] get_keys for section WritePermission returns ['administrators'] 2019-06-13 13:18:13,887 [TRACE] [doorpi.conf.config_object] get_keys for section ReadPermission returns ['guests'] 2019-06-13 13:18:13,887 [TRACE] [doorpi.conf.config_object] get_keys for section Group returns ['administrators', 'guests'] 2019-06-13 13:18:13,887 [TRACE] [doorpi.conf.config_object] get_keys for section User returns ['visitor', 'door'] 2019-06-13 13:18:13,888 [TRACE] [doorpi.conf.config_object] get_list for key administrators in section Group (default: []) returns ['door'] 2019-06-13 13:18:13,888 [TRACE] [doorpi.conf.config_object] get_list for key guests in section Group (default: []) returns ['visitor'] 2019-06-13 13:18:13,888 [TRACE] [doorpi.conf.config_object] get_sections returns ['onboardpins_OutputPins', 'AREA_public', 'onboardpins_keyboard', 'Group', 'ReadPermission', 'AREA_dashboard', 'keyboards', 'DTMF', 'SIP-Phone', 'AREA_config', 'onboardpins_InputPins', 'EVENT_OnStartup', 'User', 'DoorPiWeb', 'DoorPi', 'WritePermission', 'AREA_status'] 2019-06-13 13:18:13,889 [TRACE] [doorpi.conf.config_object] get_list for key administrators in section WritePermission (default: []) returns ['dashboard', 'status', 'config'] 2019-06-13 13:18:13,889 [TRACE] [doorpi.conf.config_object] get_list for key guests in section ReadPermission (default: []) returns ['dashboard'] 2019-06-13 13:18:13,890 [TRACE] [doorpi.action.handler] action WebServerStartupAction with args () and kwargs {} was added to new evententry OnWebServerStart 2019-06-13 13:18:13,890 [TRACE] [doorpi.action.handler] action WebServerShutdownAction with args () and kwargs {} was added to event OnShutdown 2019-06-13 13:18:13,890 [TRACE] [doorpi.action.handler] fire Event OnWebServerStart from doorpi.status.webserver asyncron 2019-06-13 13:18:13,891 [TRACE] [doorpi.action.handler] register Event OnWebServerRequest from doorpi.status.webserver_lib.request_handler 2019-06-13 13:18:13,892 [DEBUG] [doorpi.action.handler] event_source doorpi.status.webserver_lib.request_handler was added 2019-06-13 13:18:13,892 [TRACE] [doorpi.action.handler] added event_name OnWebServerRequest and registered source doorpi.status.webserver_lib.request_handler 2019-06-13 13:18:13,892 [TRACE] [doorpi.action.handler] register Event OnWebServerRequestGet from doorpi.status.webserver_lib.request_handler 2019-06-13 13:18:13,893 [TRACE] [doorpi.action.handler] added event_name OnWebServerRequestGet and registered source doorpi.status.webserver_lib.request_handler 2019-06-13 13:18:13,893 [TRACE] [doorpi.action.handler] register Event OnWebServerRequestPost from doorpi.status.webserver_lib.request_handler 2019-06-13 13:18:13,893 [TRACE] [doorpi.action.handler] added event_name OnWebServerRequestPost and registered source doorpi.status.webserver_lib.request_handler 2019-06-13 13:18:13,893 [TRACE] [doorpi.action.handler] register Event OnWebServerVirtualResource from doorpi.status.webserver_lib.request_handler 2019-06-13 13:18:13,894 [TRACE] [doorpi.action.handler] added event_name OnWebServerVirtualResource and registered source doorpi.status.webserver_lib.request_handler 2019-06-13 13:18:13,894 [TRACE] [doorpi.action.handler] register Event OnWebServerRealResource from doorpi.status.webserver_lib.request_handler 2019-06-13 13:18:13,894 [TRACE] [doorpi.action.handler] added event_name OnWebServerRealResource and registered source doorpi.status.webserver_lib.request_handler 2019-06-13 13:18:13,894 [TRACE] [doorpi.action.handler] register Event OnFireEvent from doorpi.status.webserver_lib.request_handler 2019-06-13 13:18:13,894 [TRACE] [doorpi.action.handler] added event_name OnFireEvent and registered source doorpi.status.webserver_lib.request_handler 2019-06-13 13:18:13,895 [TRACE] [doorpi.action.handler] register Event OnConfigKeySet from doorpi.status.webserver_lib.request_handler 2019-06-13 13:18:13,895 [TRACE] [doorpi.action.handler] added event_name OnConfigKeySet and registered source doorpi.status.webserver_lib.request_handler 2019-06-13 13:18:13,895 [TRACE] [doorpi.action.handler] register Event OnConfigKeyDelete from doorpi.status.webserver_lib.request_handler 2019-06-13 13:18:13,895 [TRACE] [doorpi.action.handler] added event_name OnConfigKeyDelete and registered source doorpi.status.webserver_lib.request_handler 2019-06-13 13:18:13,895 [TRACE] [doorpi.conf.config_object] get_keys for section keyboards returns ['onboardpins'] 2019-06-13 13:18:13,896 [INFO] [doorpi.keyboard.KeyboardInterface] using multi-keyboard mode (keyboards: onboardpins) 2019-06-13 13:18:13,896 [INFO] [doorpi.keyboard.KeyboardInterface] trying to add keyboard 'onboardpins' to handler 2019-06-13 13:18:13,896 [TRACE] [doorpi.conf.config_object] get_string for key onboardpins in section keyboards (default: dummy) returns gpio 2019-06-13 13:18:13,897 [TRACE] [doorpi.conf.config_object] get_keys for section onboardpins_InputPins returns ['7'] 2019-06-13 13:18:13,897 [TRACE] [doorpi.conf.config_object] get_keys for section onboardpins_OutputPins returns ['3'] 2019-06-13 13:18:13,897 [TRACE] [doorpi.conf.config_object] get_integer for key bouncetime in section onboardpins_keyboard (default: 2000) returns 200.0 2019-06-13 13:18:13,897 [TRACE] [doorpi.conf.config_object] get_integer for key polarity in section onboardpins_keyboard (default: 0) returns 0 2019-06-13 13:18:13,898 [TRACE] [doorpi.conf.config_object] get_boolean for key pressed_on_keydown in section onboardpins_keyboard (default: True) returns True 2019-06-13 13:18:13,898 [DEBUG] [doorpi.keyboard.from_gpio] doorpi.keyboard.from_gpio loaded 2019-06-13 13:18:13,901 [DEBUG] [doorpi.keyboard.from_gpio] __init__(input_pins = ['7'], output_pins = ['3'], bouncetime = 200.0, polarity = 0) 2019-06-13 13:18:13,901 [TRACE] [doorpi.conf.config_object] get_string for key mode in section onboardpins_keyboard (default: BOARD) returns BOARD 2019-06-13 13:18:13,902 [TRACE] [doorpi.conf.config_object] get_string for key pull_up_down in section onboardpins_keyboard (default: PUD_OFF) returns PUD_OFF 2019-06-13 13:18:13,902 [TRACE] [doorpi.action.handler] register Event OnKeyPressed from doorpi.keyboard.from_gpio 2019-06-13 13:18:13,903 [DEBUG] [doorpi.action.handler] event_source doorpi.keyboard.from_gpio was added 2019-06-13 13:18:13,903 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed and registered source doorpi.keyboard.from_gpio 2019-06-13 13:18:13,903 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_7 from doorpi.keyboard.from_gpio 2019-06-13 13:18:13,904 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_7 and registered source doorpi.keyboard.from_gpio 2019-06-13 13:18:13,904 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_onboardpins.7 from doorpi.keyboard.from_gpio 2019-06-13 13:18:13,904 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_onboardpins.7 and registered source doorpi.keyboard.from_gpio 2019-06-13 13:18:13,904 [TRACE] [doorpi.action.handler] register Event OnKeyUp from doorpi.keyboard.from_gpio 2019-06-13 13:18:13,904 [TRACE] [doorpi.action.handler] added event_name OnKeyUp and registered source doorpi.keyboard.from_gpio 2019-06-13 13:18:13,905 [TRACE] [doorpi.action.handler] register Event OnKeyUp_7 from doorpi.keyboard.from_gpio 2019-06-13 13:18:13,905 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_7 and registered source doorpi.keyboard.from_gpio 2019-06-13 13:18:13,905 [TRACE] [doorpi.action.handler] register Event OnKeyUp_onboardpins.7 from doorpi.keyboard.from_gpio 2019-06-13 13:18:13,905 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_onboardpins.7 and registered source doorpi.keyboard.from_gpio 2019-06-13 13:18:13,906 [TRACE] [doorpi.action.handler] register Event OnKeyDown from doorpi.keyboard.from_gpio 2019-06-13 13:18:13,906 [TRACE] [doorpi.action.handler] added event_name OnKeyDown and registered source doorpi.keyboard.from_gpio 2019-06-13 13:18:13,906 [TRACE] [doorpi.action.handler] register Event OnKeyDown_7 from doorpi.keyboard.from_gpio 2019-06-13 13:18:13,906 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_7 and registered source doorpi.keyboard.from_gpio 2019-06-13 13:18:13,906 [TRACE] [doorpi.action.handler] register Event OnKeyDown_onboardpins.7 from doorpi.keyboard.from_gpio 2019-06-13 13:18:13,907 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_onboardpins.7 and registered source doorpi.keyboard.from_gpio 2019-06-13 13:18:13,907 [TRACE] [doorpi.action.handler] action KeyboardDestroyAction with args () and kwargs {} was added to event OnShutdown 2019-06-13 13:18:13,908 [TRACE] [doorpi.conf.config_object] get_keys for section onboardpins_OutputPins returns ['3'] 2019-06-13 13:18:13,908 [TRACE] [doorpi.conf.config_object] get_string for key 3 in section onboardpins_OutputPins (default: ) returns Tueroeffner 2019-06-13 13:18:13,909 [DEBUG] [doorpi.status.status_lib.environment] doorpi.status.status_lib.environment loaded 2019-06-13 13:18:13,910 [DEBUG] [doorpi.status.requirements_lib.req_config] doorpi.status.requirements_lib.req_config loaded 2019-06-13 13:18:13,912 [DEBUG] [doorpi.status.requirements_lib.req_sipphone] doorpi.status.requirements_lib.req_sipphone loaded 2019-06-13 13:18:13,913 [DEBUG] [doorpi.sipphone.AbstractBaseClass] doorpi.sipphone.AbstractBaseClass loaded 2019-06-13 13:18:13,958 [DEBUG] [doorpi.status.requirements_lib.req_event_handler] doorpi.status.requirements_lib.req_event_handler loaded 2019-06-13 13:18:13,960 [DEBUG] [doorpi.status.requirements_lib.req_webserver] doorpi.status.requirements_lib.req_webserver loaded 2019-06-13 13:18:13,963 [DEBUG] [doorpi.status.requirements_lib.req_keyboard] doorpi.status.requirements_lib.req_keyboard loaded 2019-06-13 13:18:14,020 [DEBUG] [doorpi.status.requirements_lib.req_system] doorpi.status.requirements_lib.req_system loaded 2019-06-13 13:18:14,026 [INFO] [doorpi.sipphone.SipphoneInterface] found installed sipphone "linphone" and use this as default 2019-06-13 13:18:14,027 [TRACE] [doorpi.conf.config_object] get_string for key sipphonetyp in section SIP-Phone (default: linphone) returns linphone 2019-06-13 13:18:14,029 [DEBUG] [doorpi.sipphone.from_linphone] doorpi.sipphone.from_linphone loaded 2019-06-13 13:18:14,031 [DEBUG] [doorpi.sipphone.linphone_lib.CallBacks] doorpi.sipphone.linphone_lib.CallBacks loaded 2019-06-13 13:18:14,033 [DEBUG] [doorpi.sipphone.linphone_lib.Player] doorpi.sipphone.linphone_lib.Player loaded 2019-06-13 13:18:14,035 [DEBUG] [doorpi.sipphone.linphone_lib.Recorder] doorpi.sipphone.linphone_lib.Recorder loaded 2019-06-13 13:18:14,037 [DEBUG] [doorpi.sipphone.from_linphone] __init__ 2019-06-13 13:18:14,038 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to event OnShutdown 2019-06-13 13:18:14,039 [TRACE] [doorpi.action.handler] register Event OnSipPhoneCreate from doorpi.sipphone.from_linphone 2019-06-13 13:18:14,039 [DEBUG] [doorpi.action.handler] event_source doorpi.sipphone.from_linphone was added 2019-06-13 13:18:14,040 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneCreate and registered source doorpi.sipphone.from_linphone 2019-06-13 13:18:14,041 [TRACE] [doorpi.action.handler] register Event OnSipPhoneStart from doorpi.sipphone.from_linphone 2019-06-13 13:18:14,041 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneStart and registered source doorpi.sipphone.from_linphone 2019-06-13 13:18:14,042 [TRACE] [doorpi.action.handler] register Event OnSipPhoneDestroy from doorpi.sipphone.from_linphone 2019-06-13 13:18:14,042 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneDestroy and registered source doorpi.sipphone.from_linphone 2019-06-13 13:18:14,042 [TRACE] [doorpi.action.handler] register Event OnSipPhoneRecorderCreate from doorpi.sipphone.from_linphone 2019-06-13 13:18:14,044 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneRecorderCreate and registered source doorpi.sipphone.from_linphone 2019-06-13 13:18:14,045 [TRACE] [doorpi.action.handler] register Event OnSipPhoneRecorderDestroy from doorpi.sipphone.from_linphone 2019-06-13 13:18:14,045 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneRecorderDestroy and registered source doorpi.sipphone.from_linphone 2019-06-13 13:18:14,046 [TRACE] [doorpi.action.handler] register Event BeforeSipPhoneMakeCall from doorpi.sipphone.from_linphone 2019-06-13 13:18:14,047 [TRACE] [doorpi.action.handler] added event_name BeforeSipPhoneMakeCall and registered source doorpi.sipphone.from_linphone 2019-06-13 13:18:14,047 [TRACE] [doorpi.action.handler] register Event OnSipPhoneMakeCall from doorpi.sipphone.from_linphone 2019-06-13 13:18:14,048 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneMakeCall and registered source doorpi.sipphone.from_linphone 2019-06-13 13:18:14,048 [TRACE] [doorpi.action.handler] register Event OnSipPhoneMakeCallFailed from doorpi.sipphone.from_linphone 2019-06-13 13:18:14,048 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneMakeCallFailed and registered source doorpi.sipphone.from_linphone 2019-06-13 13:18:14,049 [TRACE] [doorpi.action.handler] register Event AfterSipPhoneMakeCall from doorpi.sipphone.from_linphone 2019-06-13 13:18:14,049 [TRACE] [doorpi.action.handler] added event_name AfterSipPhoneMakeCall and registered source doorpi.sipphone.from_linphone 2019-06-13 13:18:14,050 [TRACE] [doorpi.action.handler] register Event OnSipPhoneCallTimeoutNoResponse from doorpi.sipphone.from_linphone 2019-06-13 13:18:14,050 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneCallTimeoutNoResponse and registered source doorpi.sipphone.from_linphone 2019-06-13 13:18:14,051 [TRACE] [doorpi.action.handler] register Event OnSipPhoneCallTimeoutMaxCalltime from doorpi.sipphone.from_linphone 2019-06-13 13:18:14,051 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneCallTimeoutMaxCalltime and registered source doorpi.sipphone.from_linphone 2019-06-13 13:18:14,051 [TRACE] [doorpi.action.handler] register Event OnPlayerCreated from doorpi.sipphone.from_linphone 2019-06-13 13:18:14,052 [TRACE] [doorpi.action.handler] added event_name OnPlayerCreated and registered source doorpi.sipphone.from_linphone 2019-06-13 13:18:14,052 [DEBUG] [doorpi.sipphone.linphone_lib.CallBacks] __init__ 2019-06-13 13:18:14,052 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to new evententry OnSipPhoneDestroy 2019-06-13 13:18:14,053 [TRACE] [doorpi.action.handler] register Event OnCallMediaStateChange from doorpi.sipphone.linphone_lib.CallBacks 2019-06-13 13:18:14,053 [DEBUG] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was added 2019-06-13 13:18:14,054 [TRACE] [doorpi.action.handler] added event_name OnCallMediaStateChange and registered source doorpi.sipphone.linphone_lib.CallBacks 2019-06-13 13:18:14,054 [TRACE] [doorpi.action.handler] register Event OnMediaRequired from doorpi.sipphone.linphone_lib.CallBacks 2019-06-13 13:18:14,055 [TRACE] [doorpi.action.handler] added event_name OnMediaRequired and registered source doorpi.sipphone.linphone_lib.CallBacks 2019-06-13 13:18:14,055 [TRACE] [doorpi.action.handler] register Event OnMediaNotRequired from doorpi.sipphone.linphone_lib.CallBacks 2019-06-13 13:18:14,055 [TRACE] [doorpi.action.handler] added event_name OnMediaNotRequired and registered source doorpi.sipphone.linphone_lib.CallBacks 2019-06-13 13:18:14,055 [TRACE] [doorpi.action.handler] register Event OnCallStateChange from doorpi.sipphone.linphone_lib.CallBacks 2019-06-13 13:18:14,056 [TRACE] [doorpi.action.handler] added event_name OnCallStateChange and registered source doorpi.sipphone.linphone_lib.CallBacks 2019-06-13 13:18:14,056 [TRACE] [doorpi.action.handler] register Event OnCallStateConnect from doorpi.sipphone.linphone_lib.CallBacks 2019-06-13 13:18:14,056 [TRACE] [doorpi.action.handler] added event_name OnCallStateConnect and registered source doorpi.sipphone.linphone_lib.CallBacks 2019-06-13 13:18:14,056 [TRACE] [doorpi.action.handler] register Event AfterCallStateConnect from doorpi.sipphone.linphone_lib.CallBacks 2019-06-13 13:18:14,056 [TRACE] [doorpi.action.handler] added event_name AfterCallStateConnect and registered source doorpi.sipphone.linphone_lib.CallBacks 2019-06-13 13:18:14,057 [TRACE] [doorpi.action.handler] register Event OnCallStateDisconnect from doorpi.sipphone.linphone_lib.CallBacks 2019-06-13 13:18:14,057 [TRACE] [doorpi.action.handler] added event_name OnCallStateDisconnect and registered source doorpi.sipphone.linphone_lib.CallBacks 2019-06-13 13:18:14,058 [TRACE] [doorpi.action.handler] register Event AfterCallStateDisconnect from doorpi.sipphone.linphone_lib.CallBacks 2019-06-13 13:18:14,059 [TRACE] [doorpi.action.handler] added event_name AfterCallStateDisconnect and registered source doorpi.sipphone.linphone_lib.CallBacks 2019-06-13 13:18:14,059 [TRACE] [doorpi.action.handler] register Event OnCallStateDismissed from doorpi.sipphone.linphone_lib.CallBacks 2019-06-13 13:18:14,060 [TRACE] [doorpi.action.handler] added event_name OnCallStateDismissed and registered source doorpi.sipphone.linphone_lib.CallBacks 2019-06-13 13:18:14,061 [TRACE] [doorpi.action.handler] register Event OnCallStateReject from doorpi.sipphone.linphone_lib.CallBacks 2019-06-13 13:18:14,062 [TRACE] [doorpi.action.handler] added event_name OnCallStateReject and registered source doorpi.sipphone.linphone_lib.CallBacks 2019-06-13 13:18:14,063 [TRACE] [doorpi.action.handler] register Event OnCallStart from doorpi.sipphone.linphone_lib.CallBacks 2019-06-13 13:18:14,064 [TRACE] [doorpi.action.handler] added event_name OnCallStart and registered source doorpi.sipphone.linphone_lib.CallBacks 2019-06-13 13:18:14,065 [TRACE] [doorpi.action.handler] register Event OnDTMF from doorpi.sipphone.linphone_lib.CallBacks 2019-06-13 13:18:14,065 [TRACE] [doorpi.action.handler] added event_name OnDTMF and registered source doorpi.sipphone.linphone_lib.CallBacks 2019-06-13 13:18:14,066 [TRACE] [doorpi.conf.config_object] get_keys for section DTMF returns ['0'] 2019-06-13 13:18:14,067 [TRACE] [doorpi.action.handler] register Event OnDTMF_0 from doorpi.sipphone.linphone_lib.CallBacks 2019-06-13 13:18:14,068 [TRACE] [doorpi.action.handler] added event_name OnDTMF_0 and registered source doorpi.sipphone.linphone_lib.CallBacks 2019-06-13 13:18:14,068 [TRACE] [doorpi.action.handler] register Event OnCallStart from doorpi.sipphone.linphone_lib.CallBacks 2019-06-13 13:18:14,069 [TRACE] [doorpi.action.handler] nothing to do - event OnCallStart from source doorpi.sipphone.linphone_lib.CallBacks is already known 2019-06-13 13:18:14,070 [TRACE] [doorpi.action.handler] register Event BeforeCallIncoming from doorpi.sipphone.linphone_lib.CallBacks 2019-06-13 13:18:14,070 [TRACE] [doorpi.action.handler] added event_name BeforeCallIncoming and registered source doorpi.sipphone.linphone_lib.CallBacks 2019-06-13 13:18:14,070 [TRACE] [doorpi.action.handler] register Event OnCallReconnect from doorpi.sipphone.linphone_lib.CallBacks 2019-06-13 13:18:14,071 [TRACE] [doorpi.action.handler] added event_name OnCallReconnect and registered source doorpi.sipphone.linphone_lib.CallBacks 2019-06-13 13:18:14,071 [TRACE] [doorpi.action.handler] register Event AfterCallReconnect from doorpi.sipphone.linphone_lib.CallBacks 2019-06-13 13:18:14,071 [TRACE] [doorpi.action.handler] added event_name AfterCallReconnect and registered source doorpi.sipphone.linphone_lib.CallBacks 2019-06-13 13:18:14,072 [TRACE] [doorpi.action.handler] register Event OnCallBusy from doorpi.sipphone.linphone_lib.CallBacks 2019-06-13 13:18:14,072 [TRACE] [doorpi.action.handler] added event_name OnCallBusy and registered source doorpi.sipphone.linphone_lib.CallBacks 2019-06-13 13:18:14,073 [TRACE] [doorpi.action.handler] register Event AfterCallBusy from doorpi.sipphone.linphone_lib.CallBacks 2019-06-13 13:18:14,073 [TRACE] [doorpi.action.handler] added event_name AfterCallBusy and registered source doorpi.sipphone.linphone_lib.CallBacks 2019-06-13 13:18:14,074 [TRACE] [doorpi.action.handler] register Event OnCallIncoming from doorpi.sipphone.linphone_lib.CallBacks 2019-06-13 13:18:14,074 [TRACE] [doorpi.action.handler] added event_name OnCallIncoming and registered source doorpi.sipphone.linphone_lib.CallBacks 2019-06-13 13:18:14,075 [TRACE] [doorpi.action.handler] register Event AfterCallIncoming from doorpi.sipphone.linphone_lib.CallBacks 2019-06-13 13:18:14,075 [TRACE] [doorpi.action.handler] added event_name AfterCallIncoming and registered source doorpi.sipphone.linphone_lib.CallBacks 2019-06-13 13:18:14,076 [TRACE] [doorpi.action.handler] register Event OnCallReject from doorpi.sipphone.linphone_lib.CallBacks 2019-06-13 13:18:14,076 [TRACE] [doorpi.action.handler] added event_name OnCallReject and registered source doorpi.sipphone.linphone_lib.CallBacks 2019-06-13 13:18:14,076 [TRACE] [doorpi.action.handler] register Event AfterCallReject from doorpi.sipphone.linphone_lib.CallBacks 2019-06-13 13:18:14,077 [TRACE] [doorpi.action.handler] added event_name AfterCallReject and registered source doorpi.sipphone.linphone_lib.CallBacks 2019-06-13 13:18:14,077 [TRACE] [doorpi.action.handler] fire Event OnCallStart from doorpi.sipphone.linphone_lib.CallBacks asyncron 2019-06-13 13:18:14,079 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_new() 2019-06-13 13:18:14,079 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_new -> 0x7455ae78 2019-06-13 13:18:14,080 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_init() 2019-06-13 13:18:14,080 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_init -> 0x7455ae78 2019-06-13 13:18:14,081 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_class_method_new(0x744c09c0, "(null)", "(null)") 2019-06-13 13:18:14,081 [INFO] [doorpi.sipphone.from_linphone] Mediastreamer2 factory 2.12.0 (git: 3.9.0) initialized. 2019-06-13 13:18:14,082 [INFO] [doorpi.sipphone.from_linphone] CPU count set to 4 2019-06-13 13:18:14,083 [INFO] [doorpi.sipphone.from_linphone] ms_factory_init() done: platform_tags=linux,arm,embedded 2019-06-13 13:18:14,083 [INFO] [doorpi.sipphone.from_linphone] srtp init 2019-06-13 13:18:14,090 [INFO] [doorpi.sipphone.from_linphone] Registering all soundcard handlers 2019-06-13 13:18:14,134 [INFO] [doorpi.sipphone.from_linphone] Card 'ALSA: default device' added 2019-06-13 13:18:14,145 [INFO] [doorpi.sipphone.from_linphone] also error in confmisc.c:767 - cannot find card '0' 2019-06-13 13:18:14,146 [INFO] [doorpi.sipphone.from_linphone] also error in conf.c:4528 - function snd_func_card_driver returned error: No such file or directory 2019-06-13 13:18:14,147 [INFO] [doorpi.sipphone.from_linphone] also error in confmisc.c:392 - error evaluating strings 2019-06-13 13:18:14,147 [INFO] [doorpi.sipphone.from_linphone] also error in conf.c:4528 - function snd_func_concat returned error: No such file or directory 2019-06-13 13:18:14,148 [INFO] [doorpi.sipphone.from_linphone] also error in confmisc.c:1246 - error evaluating name 2019-06-13 13:18:14,148 [INFO] [doorpi.sipphone.from_linphone] also error in conf.c:4528 - function snd_func_refer returned error: No such file or directory 2019-06-13 13:18:14,149 [INFO] [doorpi.sipphone.from_linphone] also error in conf.c:5007 - Evaluate error: No such file or directory 2019-06-13 13:18:14,149 [INFO] [doorpi.sipphone.from_linphone] also error in pcm.c:2495 - Unknown PCM sysdefault 2019-06-13 13:18:14,150 [INFO] [doorpi.sipphone.from_linphone] also error in confmisc.c:767 - cannot find card '0' 2019-06-13 13:18:14,151 [INFO] [doorpi.sipphone.from_linphone] also error in conf.c:4528 - function snd_func_card_driver returned error: No such file or directory 2019-06-13 13:18:14,152 [INFO] [doorpi.sipphone.from_linphone] also error in confmisc.c:392 - error evaluating strings 2019-06-13 13:18:14,152 [INFO] [doorpi.sipphone.from_linphone] also error in conf.c:4528 - function snd_func_concat returned error: No such file or directory 2019-06-13 13:18:14,153 [INFO] [doorpi.sipphone.from_linphone] also error in confmisc.c:1246 - error evaluating name 2019-06-13 13:18:14,154 [INFO] [doorpi.sipphone.from_linphone] also error in conf.c:4528 - function snd_func_refer returned error: No such file or directory 2019-06-13 13:18:14,155 [INFO] [doorpi.sipphone.from_linphone] also error in conf.c:5007 - Evaluate error: No such file or directory 2019-06-13 13:18:14,155 [INFO] [doorpi.sipphone.from_linphone] also error in pcm.c:2495 - Unknown PCM sysdefault 2019-06-13 13:18:14,156 [INFO] [doorpi.sipphone.from_linphone] Registering all webcam handlers 2019-06-13 13:18:14,157 [INFO] [doorpi.sipphone.from_linphone] Webcam V4L2: /dev/video0 added 2019-06-13 13:18:14,158 [INFO] [doorpi.sipphone.from_linphone] Webcam StaticImage: Static picture added 2019-06-13 13:18:14,159 [INFO] [doorpi.sipphone.from_linphone] ms_factory_init_voip() done 2019-06-13 13:18:14,160 [INFO] [doorpi.sipphone.from_linphone] Loading ms plugins from [./lib/mediastreamer/plugins] 2019-06-13 13:18:14,160 [INFO] [doorpi.sipphone.from_linphone] Cannot open directory ./lib/mediastreamer/plugins: No such file or directory 2019-06-13 13:18:14,161 [INFO] [doorpi.sipphone.from_linphone] Initializing LinphoneCore 3.9.0 2019-06-13 13:18:14,162 [INFO] [doorpi.sipphone.from_linphone] Vtable [0xd20e68] registered on core [0xd21138] 2019-06-13 13:18:14,162 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_callback_global_state_changed(0xd20e68, 1, "Starting up") 2019-06-13 13:18:14,163 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_callback_global_state_changed 2019-06-13 13:18:14,163 [INFO] [doorpi.sipphone.from_linphone] Linphone core [0xd20e68] notifying [global_state_changed] 2019-06-13 13:18:14,164 [INFO] [doorpi.sipphone.from_linphone] oRTP-0.25.0 initialized. 2019-06-13 13:18:14,164 [INFO] [doorpi.sipphone.from_linphone] Skiping ms_base_init, because [2] ref 2019-06-13 13:18:14,165 [INFO] [doorpi.sipphone.from_linphone] Skiping ms_voip_init, because [2] ref 2019-06-13 13:18:14,165 [INFO] [doorpi.sipphone.from_linphone] Skiping ms_plugins_init, because [2] ref 2019-06-13 13:18:14,166 [INFO] [doorpi.sipphone.from_linphone] Codec opus/48000 fmtp=[useinbandfec=1] number=-1, enabled=1) added to default capabilities. 2019-06-13 13:18:14,166 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for SILK 2019-06-13 13:18:14,167 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for SILK 2019-06-13 13:18:14,167 [INFO] [doorpi.sipphone.from_linphone] Codec speex/16000 fmtp=[vbr=on] number=-1, enabled=1) added to default capabilities. 2019-06-13 13:18:14,168 [INFO] [doorpi.sipphone.from_linphone] Codec speex/8000 fmtp=[vbr=on] number=-1, enabled=1) added to default capabilities. 2019-06-13 13:18:14,168 [INFO] [doorpi.sipphone.from_linphone] Codec PCMU/8000 fmtp=[] number=0, enabled=1) added to default capabilities. 2019-06-13 13:18:14,169 [INFO] [doorpi.sipphone.from_linphone] Codec PCMA/8000 fmtp=[] number=8, enabled=1) added to default capabilities. 2019-06-13 13:18:14,170 [INFO] [doorpi.sipphone.from_linphone] Codec t140/1000 fmtp=[] number=96, enabled=1) added to default capabilities. 2019-06-13 13:18:14,170 [INFO] [doorpi.sipphone.from_linphone] Codec red/1000 fmtp=[] number=97, enabled=1) added to default capabilities. 2019-06-13 13:18:14,171 [INFO] [doorpi.sipphone.from_linphone] Codec GSM/8000 fmtp=[] number=3, enabled=0) added to default capabilities. 2019-06-13 13:18:14,171 [INFO] [doorpi.sipphone.from_linphone] Codec G722/8000 fmtp=[] number=9, enabled=0) added to default capabilities. 2019-06-13 13:18:14,172 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for iLBC 2019-06-13 13:18:14,172 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for iLBC 2019-06-13 13:18:14,173 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for AMR 2019-06-13 13:18:14,173 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for AMR 2019-06-13 13:18:14,174 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for AMR-WB 2019-06-13 13:18:14,174 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for AMR-WB 2019-06-13 13:18:14,175 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for G729 2019-06-13 13:18:14,175 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for G729 2019-06-13 13:18:14,175 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for mpeg4-generic 2019-06-13 13:18:14,176 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for mpeg4-generic 2019-06-13 13:18:14,176 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for mpeg4-generic 2019-06-13 13:18:14,177 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for mpeg4-generic 2019-06-13 13:18:14,177 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for mpeg4-generic 2019-06-13 13:18:14,178 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for mpeg4-generic 2019-06-13 13:18:14,178 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for mpeg4-generic 2019-06-13 13:18:14,178 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for mpeg4-generic 2019-06-13 13:18:14,179 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for mpeg4-generic 2019-06-13 13:18:14,179 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for mpeg4-generic 2019-06-13 13:18:14,179 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for iSAC 2019-06-13 13:18:14,180 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for iSAC 2019-06-13 13:18:14,180 [INFO] [doorpi.sipphone.from_linphone] Codec speex/32000 fmtp=[vbr=on] number=-1, enabled=0) added to default capabilities. 2019-06-13 13:18:14,181 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for SILK 2019-06-13 13:18:14,181 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for SILK 2019-06-13 13:18:14,181 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for SILK 2019-06-13 13:18:14,182 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for SILK 2019-06-13 13:18:14,182 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for SILK 2019-06-13 13:18:14,183 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for SILK 2019-06-13 13:18:14,184 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for G726-16 2019-06-13 13:18:14,185 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for G726-16 2019-06-13 13:18:14,186 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for G726-24 2019-06-13 13:18:14,186 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for G726-24 2019-06-13 13:18:14,186 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for G726-32 2019-06-13 13:18:14,187 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for G726-32 2019-06-13 13:18:14,187 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for G726-40 2019-06-13 13:18:14,187 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for G726-40 2019-06-13 13:18:14,188 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for AAL2-G726-16 2019-06-13 13:18:14,189 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for AAL2-G726-16 2019-06-13 13:18:14,190 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for AAL2-G726-24 2019-06-13 13:18:14,190 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for AAL2-G726-24 2019-06-13 13:18:14,191 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for AAL2-G726-32 2019-06-13 13:18:14,192 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for AAL2-G726-32 2019-06-13 13:18:14,193 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for AAL2-G726-40 2019-06-13 13:18:14,195 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for AAL2-G726-40 2019-06-13 13:18:14,196 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for CODEC2 2019-06-13 13:18:14,197 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for CODEC2 2019-06-13 13:18:14,197 [INFO] [doorpi.sipphone.from_linphone] Codec VP8/90000 fmtp=[] number=-1, enabled=1) added to default capabilities. 2019-06-13 13:18:14,198 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for H264 2019-06-13 13:18:14,199 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for H264 2019-06-13 13:18:14,200 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for MP4V-ES 2019-06-13 13:18:14,202 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for H263-1998 2019-06-13 13:18:14,205 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for H263 2019-06-13 13:18:14,207 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for 1016 2019-06-13 13:18:14,208 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for 1016 2019-06-13 13:18:14,209 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for G723 2019-06-13 13:18:14,209 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for G723 2019-06-13 13:18:14,209 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for LPC 2019-06-13 13:18:14,210 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for LPC 2019-06-13 13:18:14,210 [INFO] [doorpi.sipphone.from_linphone] Codec L16/44100 fmtp=[] number=10, enabled=0) added to default capabilities. 2019-06-13 13:18:14,211 [INFO] [doorpi.sipphone.from_linphone] Codec L16/44100 fmtp=[] number=11, enabled=0) added to default capabilities. 2019-06-13 13:18:14,211 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for CN 2019-06-13 13:18:14,212 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for CN 2019-06-13 13:18:14,212 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for G729 2019-06-13 13:18:14,213 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for G729 2019-06-13 13:18:14,213 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for H261 2019-06-13 13:18:14,214 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for H261 2019-06-13 13:18:14,214 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for MPV 2019-06-13 13:18:14,215 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for MPV 2019-06-13 13:18:14,215 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for H263 2019-06-13 13:18:14,216 [INFO] [doorpi.sipphone.from_linphone] Sal nat helper [enabled] 2019-06-13 13:18:14,216 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2019-06-13 13:18:14,217 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2019-06-13 13:18:14,217 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2019-06-13 13:18:14,217 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_callback_configuring_status(0xd20e68, 2, "(null)") 2019-06-13 13:18:14,218 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_callback_configuring_status 2019-06-13 13:18:14,218 [INFO] [doorpi.sipphone.from_linphone] Linphone core [0xd20e68] notifying [configuring_status] 2019-06-13 13:18:14,219 [INFO] [doorpi.sipphone.from_linphone] Cannot open directory ./lib/liblinphone/plugins: No such file or directory 2019-06-13 13:18:14,219 [WARNING] [doorpi.sipphone.from_linphone] ./share/sounds/linphone/rings/oldphone.wav does not exist 2019-06-13 13:18:14,220 [INFO] [doorpi.sipphone.from_linphone] linphone_core_set_playback_gain_db(): no active call. 2019-06-13 13:18:14,220 [INFO] [doorpi.sipphone.from_linphone] linphone_core_set_mic_gain_db(): no active call. 2019-06-13 13:18:14,220 [INFO] [doorpi.sipphone.from_linphone] MTU is supposed to be 1300, rtp payload max size will be 1240 2019-06-13 13:18:14,221 [INFO] [doorpi.sipphone.from_linphone] Sal nat helper [enabled] 2019-06-13 13:18:14,221 [INFO] [doorpi.sipphone.from_linphone] Sal use rport [enabled] 2019-06-13 13:18:14,222 [INFO] [doorpi.sipphone.from_linphone] Supported codec opus/48000 fmtp=useinbandfec=1 automatically added to codec list. 2019-06-13 13:18:14,222 [INFO] [doorpi.sipphone.from_linphone] Supported codec speex/16000 fmtp=vbr=on automatically added to codec list. 2019-06-13 13:18:14,222 [INFO] [doorpi.sipphone.from_linphone] Supported codec speex/8000 fmtp=vbr=on automatically added to codec list. 2019-06-13 13:18:14,223 [INFO] [doorpi.sipphone.from_linphone] Supported codec PCMU/8000 fmtp= automatically added to codec list. 2019-06-13 13:18:14,223 [INFO] [doorpi.sipphone.from_linphone] Supported codec PCMA/8000 fmtp= automatically added to codec list. 2019-06-13 13:18:14,223 [INFO] [doorpi.sipphone.from_linphone] Supported codec GSM/8000 fmtp= automatically added to codec list. 2019-06-13 13:18:14,224 [INFO] [doorpi.sipphone.from_linphone] Supported codec G722/8000 fmtp= automatically added to codec list. 2019-06-13 13:18:14,224 [INFO] [doorpi.sipphone.from_linphone] Supported codec speex/32000 fmtp=vbr=on automatically added to codec list. 2019-06-13 13:18:14,225 [INFO] [doorpi.sipphone.from_linphone] Supported codec L16/44100 fmtp= automatically added to codec list. 2019-06-13 13:18:14,225 [INFO] [doorpi.sipphone.from_linphone] Supported codec L16/44100 fmtp= automatically added to codec list. 2019-06-13 13:18:14,226 [INFO] [doorpi.sipphone.from_linphone] Supported codec VP8/90000 fmtp= automatically added to codec list. 2019-06-13 13:18:14,226 [INFO] [doorpi.sipphone.from_linphone] Supported codec t140/1000 fmtp= automatically added to codec list. 2019-06-13 13:18:14,226 [INFO] [doorpi.sipphone.from_linphone] Supported codec red/1000 fmtp= automatically added to codec list. 2019-06-13 13:18:14,227 [INFO] [doorpi.sipphone.from_linphone] Sal use rport [enabled] 2019-06-13 13:18:14,227 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2019-06-13 13:18:14,228 [INFO] [doorpi.sipphone.from_linphone] sal_unlisten_ports done 2019-06-13 13:18:14,228 [INFO] [doorpi.sipphone.from_linphone] Creating listening point [0xcbd9b0] on [sip:0.0.0.0:5060;transport=UDP] 2019-06-13 13:18:14,229 [INFO] [doorpi.sipphone.from_linphone] Creating listening point [0xd1b0d8] on [sip:0.0.0.0:5060;transport=TCP] 2019-06-13 13:18:14,230 [ERROR] [doorpi.sipphone.from_linphone] TCP bind() failed for 0.0.0.0 port 5060: Address already in use 2019-06-13 13:18:14,230 [INFO] [doorpi.sipphone.from_linphone] Listening point [0xd1b0d8] on [sip:0.0.0.0:5060;transport=TCP] destroyed 2019-06-13 13:18:14,231 [WARNING] [doorpi.sipphone.from_linphone] Could not start tcp transport on port 5060, maybe this port is already used. 2019-06-13 13:18:14,231 [INFO] [doorpi.sipphone.from_linphone] Creating listening point [0xcbd938] on [sip:0.0.0.0:-1;transport=TLS] 2019-06-13 13:18:14,232 [INFO] [doorpi.sipphone.from_linphone] Random TCP port is 43957 2019-06-13 13:18:14,233 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2019-06-13 13:18:14,234 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2019-06-13 13:18:14,236 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_callback_global_state_changed(0xd20e68, 2, "Ready") 2019-06-13 13:18:14,237 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_callback_global_state_changed 2019-06-13 13:18:14,238 [INFO] [doorpi.sipphone.from_linphone] Linphone core [0xd20e68] notifying [global_state_changed] 2019-06-13 13:18:14,238 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_class_method_new -> 0x7455ae78 2019-06-13 13:18:14,239 [TRACE] [doorpi.conf.config_object] get_string for key identity in section SIP-Phone (default: DoorPi) returns Tuer 2019-06-13 13:18:14,239 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_primary_contact(0x7455ae78 [0xd20e68], "Tuer ") 2019-06-13 13:18:14,241 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_primary_contact -> 0 2019-06-13 13:18:14,241 [TRACE] [doorpi.action.handler] fire Event OnSipPhoneCreate from doorpi.sipphone.from_linphone asyncron 2019-06-13 13:18:14,245 [TRACE] [doorpi.conf.config_object] get_integer for key ua.max_calls in section SIP-Phone (default: 2) returns 2 2019-06-13 13:18:14,246 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_max_calls(0x7455ae78 [0xd20e68], 2) 2019-06-13 13:18:14,247 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_max_calls -> 0 2019-06-13 13:18:14,247 [TRACE] [doorpi.conf.config_object] get_boolean for key echo_cancellation_enabled in section SIP-Phone (default: False) returns False 2019-06-13 13:18:14,248 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_enable_echo_cancellation(0x7455ae78 [0xd20e68], 0x2d7690 [0]) 2019-06-13 13:18:14,248 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_enable_echo_cancellation -> 0 2019-06-13 13:18:14,249 [TRACE] [doorpi.conf.config_object] get_integer for key local_port in section SIP-Phone (default: 5060) returns 5060 2019-06-13 13:18:14,249 [TRACE] [doorpi.conf.config_object] get_integer for key local_port in section SIP-Phone (default: 5060) returns 5060 2019-06-13 13:18:14,250 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_SipTransports_new() 2019-06-13 13:18:14,250 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_SipTransports_new -> 0x7455ae90 2019-06-13 13:18:14,251 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_sip_transports(0x7455ae78 [0xd20e68], 0x7455ae90 [0x7455ae98]) 2019-06-13 13:18:14,251 [INFO] [doorpi.sipphone.from_linphone] Listening point [0xcbd9b0] on [sip:0.0.0.0:5060;transport=UDP] destroyed 2019-06-13 13:18:14,252 [INFO] [doorpi.sipphone.from_linphone] Listening point [0xcbd938] on [sip:0.0.0.0:43957;transport=TLS] destroyed 2019-06-13 13:18:14,253 [INFO] [doorpi.sipphone.from_linphone] sal_unlisten_ports done 2019-06-13 13:18:14,253 [INFO] [doorpi.sipphone.from_linphone] Creating listening point [0xd1d1a8] on [sip:0.0.0.0:5060;transport=UDP] 2019-06-13 13:18:14,254 [INFO] [doorpi.sipphone.from_linphone] Creating listening point [0xd1d6a8] on [sip:0.0.0.0:5060;transport=TCP] 2019-06-13 13:18:14,255 [ERROR] [doorpi.sipphone.from_linphone] TCP bind() failed for 0.0.0.0 port 5060: Address already in use 2019-06-13 13:18:14,256 [INFO] [doorpi.sipphone.from_linphone] Listening point [0xd1d6a8] on [sip:0.0.0.0:5060;transport=TCP] destroyed 2019-06-13 13:18:14,257 [WARNING] [doorpi.sipphone.from_linphone] Could not start tcp transport on port 5060, maybe this port is already used. 2019-06-13 13:18:14,258 [INFO] [doorpi.sipphone.from_linphone] Creating listening point [0xd1d208] on [sip:0.0.0.0:-1;transport=TLS] 2019-06-13 13:18:14,258 [INFO] [doorpi.sipphone.from_linphone] Random TCP port is 45229 2019-06-13 13:18:14,259 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2019-06-13 13:18:14,259 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2019-06-13 13:18:14,259 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_sip_transports -> 0 2019-06-13 13:18:14,259 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_SipTransports_dealloc(0x7455ae90) 2019-06-13 13:18:14,260 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_SipTransports_dealloc 2019-06-13 13:18:14,260 [TRACE] [doorpi.conf.config_object] get_boolean for key video_display_enabled in section SIP-Phone (default: False) returns False 2019-06-13 13:18:14,261 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_enable_video_display(0x7455ae78 [0xd20e68], 0x2d7690 [0]) 2019-06-13 13:18:14,262 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_enable_video_display -> 0 2019-06-13 13:18:14,262 [TRACE] [doorpi.conf.config_object] get_string for key stun_server in section SIP-Phone (default: ) returns 2019-06-13 13:18:14,263 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_stun_server(0x7455ae78 [0xd20e68], "") 2019-06-13 13:18:14,265 [INFO] [doorpi.sipphone.from_linphone] Resolver is using DNS server(s): 2019-06-13 13:18:14,265 [INFO] [doorpi.sipphone.from_linphone] 192.168.188.1 2019-06-13 13:18:14,267 [INFO] [doorpi.sipphone.from_linphone] resolver_process_data dns_res_check() in progress 2019-06-13 13:18:14,268 [INFO] [doorpi.sipphone.from_linphone] DNS resolution awaiting response, queued to main loop 2019-06-13 13:18:14,269 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_stun_server -> 0 2019-06-13 13:18:14,269 [DEBUG] [doorpi.conf.config_object] create new key FirewallPolicy in section SIP-Phone with value 'PolicyNoFirewall' 2019-06-13 13:18:14,270 [TRACE] [doorpi.conf.config_object] get_string for key FirewallPolicy in section SIP-Phone (default: PolicyNoFirewall) returns PolicyNoFirewall 2019-06-13 13:18:14,271 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_firewall_policy(0x7455ae78 [0xd20e68], 0) 2019-06-13 13:18:14,271 [INFO] [doorpi.sipphone.from_linphone] Sal nat helper [enabled] 2019-06-13 13:18:14,272 [INFO] [doorpi.sipphone.from_linphone] Sal use rport [enabled] 2019-06-13 13:18:14,275 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_firewall_policy -> 0 2019-06-13 13:18:14,277 [TRACE] [doorpi.conf.config_object] get_integer for key max_call_time in section SIP-Phone (default: 120) returns 90 2019-06-13 13:18:14,279 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_in_call_timeout(0x7455ae78 [0xd20e68], 90) 2019-06-13 13:18:14,280 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_in_call_timeout -> 0 2019-06-13 13:18:14,281 [TRACE] [doorpi.conf.config_object] get_integer for key call_timeout in section SIP-Phone (default: 15) returns 20 2019-06-13 13:18:14,281 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_inc_timeout(0x7455ae78 [0xd20e68], 20) 2019-06-13 13:18:14,282 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_inc_timeout -> 0 2019-06-13 13:18:14,282 [TRACE] [doorpi.conf.config_object] get_string for key dialtone in section SIP-Phone (default: !BASEPATH!/media/ShortDialTone.wav) returns !BASEPATH!/media/ShortDialTone.wav 2019-06-13 13:18:14,284 [DEBUG] [doorpi.conf.config_object] parse string "!BASEPATH!/media/ShortDialTone.wav" to "/usr/local/etc/DoorPi/media/ShortDialTone.wav" 2019-06-13 13:18:14,284 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to event OnSipPhoneDestroy 2019-06-13 13:18:14,286 [TRACE] [doorpi.conf.config_object] get_boolean for key dialtone_renew_every_start in section SIP-Phone (default: False) returns False 2019-06-13 13:18:14,286 [TRACE] [doorpi.action.handler] register Event OnPlayerStarted from doorpi.sipphone.linphone_lib.Player 2019-06-13 13:18:14,287 [DEBUG] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.Player was added 2019-06-13 13:18:14,287 [TRACE] [doorpi.action.handler] added event_name OnPlayerStarted and registered source doorpi.sipphone.linphone_lib.Player 2019-06-13 13:18:14,288 [TRACE] [doorpi.action.handler] register Event OnPlayerStopped from doorpi.sipphone.linphone_lib.Player 2019-06-13 13:18:14,288 [TRACE] [doorpi.action.handler] added event_name OnPlayerStopped and registered source doorpi.sipphone.linphone_lib.Player 2019-06-13 13:18:14,289 [TRACE] [doorpi.action.handler] register Event OnPlayerCreated from doorpi.sipphone.linphone_lib.Player 2019-06-13 13:18:14,289 [TRACE] [doorpi.action.handler] added event_source doorpi.sipphone.linphone_lib.Player to existing event OnPlayerCreated 2019-06-13 13:18:14,289 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to new evententry OnSipPhoneMakeCall 2019-06-13 13:18:14,290 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to new evententry OnCallStateConnect 2019-06-13 13:18:14,291 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to new evententry OnCallStateDisconnect 2019-06-13 13:18:14,291 [TRACE] [doorpi.action.handler] fire Event OnPlayerCreated from doorpi.sipphone.linphone_lib.Player asyncron 2019-06-13 13:18:14,293 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_ringback(0x7455ae78 [0xd20e68], "/usr/local/etc/DoorPi/media/ShortDialTone.wav") 2019-06-13 13:18:14,315 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_ringback -> 0 2019-06-13 13:18:14,316 [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 2019-06-13 13:18:14,317 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to event OnSipPhoneDestroy 2019-06-13 13:18:14,317 [TRACE] [doorpi.action.handler] register Event OnRecorderStarted from doorpi.sipphone.linphone_lib.Recorder 2019-06-13 13:18:14,318 [DEBUG] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.Recorder was added 2019-06-13 13:18:14,318 [TRACE] [doorpi.action.handler] added event_name OnRecorderStarted and registered source doorpi.sipphone.linphone_lib.Recorder 2019-06-13 13:18:14,319 [TRACE] [doorpi.action.handler] register Event OnRecorderStopped from doorpi.sipphone.linphone_lib.Recorder 2019-06-13 13:18:14,319 [TRACE] [doorpi.action.handler] added event_name OnRecorderStopped and registered source doorpi.sipphone.linphone_lib.Recorder 2019-06-13 13:18:14,319 [TRACE] [doorpi.action.handler] register Event OnRecorderCreated from doorpi.sipphone.linphone_lib.Recorder 2019-06-13 13:18:14,320 [TRACE] [doorpi.action.handler] added event_name OnRecorderCreated and registered source doorpi.sipphone.linphone_lib.Recorder 2019-06-13 13:18:14,320 [TRACE] [doorpi.conf.config_object] get_boolean for key record_while_dialing in section SIP-Phone (default: False) returns False 2019-06-13 13:18:14,321 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to event OnCallStateConnect 2019-06-13 13:18:14,322 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to event OnCallStateDisconnect 2019-06-13 13:18:14,322 [TRACE] [doorpi.action.handler] fire Event OnRecorderCreated from doorpi.sipphone.linphone_lib.Recorder asyncron 2019-06-13 13:18:14,324 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_sound_devices(0x7455ae78 [0xd20e68]) 2019-06-13 13:18:14,325 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_sound_devices -> 0x744c5cb0 2019-06-13 13:18:14,325 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_capture_device(0x7455ae78 [0xd20e68]) 2019-06-13 13:18:14,325 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_capture_device -> 0x744bec50 2019-06-13 13:18:14,326 [TRACE] [doorpi.conf.config_object] get_string for key capture_device in section SIP-Phone (default: ALSA: default device) returns ALSA: default device 2019-06-13 13:18:14,326 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_capture_device(0x7455ae78 [0xd20e68], "ALSA: default device") 2019-06-13 13:18:14,326 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_capture_device -> 0 2019-06-13 13:18:14,327 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_playback_device(0x7455ae78 [0xd20e68]) 2019-06-13 13:18:14,328 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_playback_device -> 0x744bed40 2019-06-13 13:18:14,329 [TRACE] [doorpi.conf.config_object] get_string for key playback_device in section SIP-Phone (default: ALSA: default device) returns ALSA: default device 2019-06-13 13:18:14,330 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_playback_device(0x7455ae78 [0xd20e68], "ALSA: default device") 2019-06-13 13:18:14,331 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_playback_device -> 0 2019-06-13 13:18:14,331 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_sound_devices(0x7455ae78 [0xd20e68]) 2019-06-13 13:18:14,332 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_sound_devices -> 0x744c5cb0 2019-06-13 13:18:14,333 [INFO] [doorpi.sipphone.from_linphone] found 1 possible sounddevices: 2019-06-13 13:18:14,334 [DEBUG] [doorpi.sipphone.from_linphone] |rec|play| name 2019-06-13 13:18:14,335 [DEBUG] [doorpi.sipphone.from_linphone] ------------------------------------ 2019-06-13 13:18:14,336 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_sound_devices(0x7455ae78 [0xd20e68]) 2019-06-13 13:18:14,337 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_sound_devices -> 0x744c5cb0 2019-06-13 13:18:14,337 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_sound_device_can_capture(0x7455ae78 [0xd20e68], "ALSA: default device") 2019-06-13 13:18:14,338 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_sound_device_can_capture -> 0x2d769c 2019-06-13 13:18:14,340 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_sound_device_can_playback(0x7455ae78 [0xd20e68], "ALSA: default device") 2019-06-13 13:18:14,342 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_sound_device_can_playback -> 0x2d769c 2019-06-13 13:18:14,344 [DEBUG] [doorpi.sipphone.from_linphone] | X | X | ALSA: default device 2019-06-13 13:18:14,345 [DEBUG] [doorpi.sipphone.from_linphone] ------------------------------------ 2019-06-13 13:18:14,347 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_capture_device(0x7455ae78 [0xd20e68]) 2019-06-13 13:18:14,348 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_capture_device -> 0x744beda0 2019-06-13 13:18:14,348 [DEBUG] [doorpi.sipphone.from_linphone] using capture_device: ALSA: default device 2019-06-13 13:18:14,349 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_playback_device(0x7455ae78 [0xd20e68]) 2019-06-13 13:18:14,350 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_playback_device -> 0x744bedd0 2019-06-13 13:18:14,350 [DEBUG] [doorpi.sipphone.from_linphone] using playback_device: ALSA: default device 2019-06-13 13:18:14,351 [TRACE] [doorpi.conf.config_object] get_list for key audio_codecs in section SIP-Phone (default: PCMA,PCMU) returns ['PCMA', 'PCMU'] 2019-06-13 13:18:14,351 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_audio_codecs(0x7455ae78 [0xd20e68]) 2019-06-13 13:18:14,352 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0xcbd420) 2019-06-13 13:18:14,352 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2019-06-13 13:18:14,353 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0x76ce2490 2019-06-13 13:18:14,354 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2019-06-13 13:18:14,354 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0x76ce2490 2019-06-13 13:18:14,355 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0x76ce2490 2019-06-13 13:18:14,356 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0xcbd490) 2019-06-13 13:18:14,356 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2019-06-13 13:18:14,357 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0x76ce24a0 2019-06-13 13:18:14,357 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2019-06-13 13:18:14,358 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0x76ce24a0 2019-06-13 13:18:14,359 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0x76ce24a0 2019-06-13 13:18:14,360 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0xcbd4f8) 2019-06-13 13:18:14,360 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2019-06-13 13:18:14,361 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0x76ce24b0 2019-06-13 13:18:14,361 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2019-06-13 13:18:14,362 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0x76ce24b0 2019-06-13 13:18:14,362 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0x76ce24b0 2019-06-13 13:18:14,363 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0xcbd560) 2019-06-13 13:18:14,364 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2019-06-13 13:18:14,364 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0x76ce24c0 2019-06-13 13:18:14,365 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2019-06-13 13:18:14,365 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0x76ce24c0 2019-06-13 13:18:14,366 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0x76ce24c0 2019-06-13 13:18:14,366 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0xcbd5b8) 2019-06-13 13:18:14,366 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2019-06-13 13:18:14,367 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0x76ce24d0 2019-06-13 13:18:14,367 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2019-06-13 13:18:14,368 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0x76ce24d0 2019-06-13 13:18:14,368 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0x76ce24d0 2019-06-13 13:18:14,369 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0xcbd610) 2019-06-13 13:18:14,369 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2019-06-13 13:18:14,370 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0x76ce24e0 2019-06-13 13:18:14,370 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2019-06-13 13:18:14,370 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0x76ce24e0 2019-06-13 13:18:14,371 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0x76ce24e0 2019-06-13 13:18:14,371 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0xcbd668) 2019-06-13 13:18:14,371 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2019-06-13 13:18:14,372 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0x76ce24f0 2019-06-13 13:18:14,372 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2019-06-13 13:18:14,373 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0x76ce24f0 2019-06-13 13:18:14,373 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0x76ce24f0 2019-06-13 13:18:14,373 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0xcbd6c0) 2019-06-13 13:18:14,374 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2019-06-13 13:18:14,374 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0x76ce2500 2019-06-13 13:18:14,375 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2019-06-13 13:18:14,375 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0x76ce2500 2019-06-13 13:18:14,375 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0x76ce2500 2019-06-13 13:18:14,376 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0xcbd728) 2019-06-13 13:18:14,376 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2019-06-13 13:18:14,377 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0x76ce2510 2019-06-13 13:18:14,377 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2019-06-13 13:18:14,378 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0x76ce2510 2019-06-13 13:18:14,378 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0x76ce2510 2019-06-13 13:18:14,378 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0xcbd780) 2019-06-13 13:18:14,379 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2019-06-13 13:18:14,379 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0x76ce2520 2019-06-13 13:18:14,380 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2019-06-13 13:18:14,380 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0x76ce2520 2019-06-13 13:18:14,381 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0x76ce2520 2019-06-13 13:18:14,381 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_audio_codecs -> 0x744c5d50 2019-06-13 13:18:14,382 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76ce2490 [0xcbd420]) 2019-06-13 13:18:14,382 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x744c4780 2019-06-13 13:18:14,383 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76ce2490 [0xcbd420]) 2019-06-13 13:18:14,383 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x744c4780 2019-06-13 13:18:14,384 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec opus 2019-06-13 13:18:14,384 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x7455ae78 [0xd20e68], 0x76ce2490 [0xcbd420], 0x2d7690 [0]) 2019-06-13 13:18:14,385 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0xb878cc 2019-06-13 13:18:14,385 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76ce24a0 [0xcbd490]) 2019-06-13 13:18:14,386 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x744c4800 2019-06-13 13:18:14,386 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76ce24a0 [0xcbd490]) 2019-06-13 13:18:14,387 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x744c4800 2019-06-13 13:18:14,388 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec speex 2019-06-13 13:18:14,388 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x7455ae78 [0xd20e68], 0x76ce24a0 [0xcbd490], 0x2d7690 [0]) 2019-06-13 13:18:14,389 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0xb878cc 2019-06-13 13:18:14,389 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76ce24b0 [0xcbd4f8]) 2019-06-13 13:18:14,390 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x744c4780 2019-06-13 13:18:14,391 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76ce24b0 [0xcbd4f8]) 2019-06-13 13:18:14,391 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x744c4780 2019-06-13 13:18:14,392 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec speex 2019-06-13 13:18:14,392 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x7455ae78 [0xd20e68], 0x76ce24b0 [0xcbd4f8], 0x2d7690 [0]) 2019-06-13 13:18:14,393 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0xb878cc 2019-06-13 13:18:14,394 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76ce24c0 [0xcbd560]) 2019-06-13 13:18:14,395 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x744c4800 2019-06-13 13:18:14,395 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76ce24c0 [0xcbd560]) 2019-06-13 13:18:14,396 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x744c4800 2019-06-13 13:18:14,396 [DEBUG] [doorpi.sipphone.from_linphone] enable audio codec PCMU 2019-06-13 13:18:14,397 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x7455ae78 [0xd20e68], 0x76ce24c0 [0xcbd560], 0x2d769c [1]) 2019-06-13 13:18:14,399 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0xb878cc 2019-06-13 13:18:14,399 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76ce24d0 [0xcbd5b8]) 2019-06-13 13:18:14,399 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x744c4780 2019-06-13 13:18:14,400 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76ce24d0 [0xcbd5b8]) 2019-06-13 13:18:14,400 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x744c4780 2019-06-13 13:18:14,400 [DEBUG] [doorpi.sipphone.from_linphone] enable audio codec PCMA 2019-06-13 13:18:14,401 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x7455ae78 [0xd20e68], 0x76ce24d0 [0xcbd5b8], 0x2d769c [1]) 2019-06-13 13:18:14,401 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0xb878cc 2019-06-13 13:18:14,402 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76ce24e0 [0xcbd610]) 2019-06-13 13:18:14,403 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x7455ae90 2019-06-13 13:18:14,404 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76ce24e0 [0xcbd610]) 2019-06-13 13:18:14,405 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x7455ae90 2019-06-13 13:18:14,406 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec GSM 2019-06-13 13:18:14,407 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x7455ae78 [0xd20e68], 0x76ce24e0 [0xcbd610], 0x2d7690 [0]) 2019-06-13 13:18:14,408 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0xb878cc 2019-06-13 13:18:14,409 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76ce24f0 [0xcbd668]) 2019-06-13 13:18:14,410 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x744c4780 2019-06-13 13:18:14,411 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76ce24f0 [0xcbd668]) 2019-06-13 13:18:14,412 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x744c4780 2019-06-13 13:18:14,413 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec G722 2019-06-13 13:18:14,415 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x7455ae78 [0xd20e68], 0x76ce24f0 [0xcbd668], 0x2d7690 [0]) 2019-06-13 13:18:14,417 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0xb878cc 2019-06-13 13:18:14,418 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76ce2500 [0xcbd6c0]) 2019-06-13 13:18:14,420 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x744c4800 2019-06-13 13:18:14,420 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76ce2500 [0xcbd6c0]) 2019-06-13 13:18:14,421 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x744c4800 2019-06-13 13:18:14,421 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec speex 2019-06-13 13:18:14,422 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x7455ae78 [0xd20e68], 0x76ce2500 [0xcbd6c0], 0x2d7690 [0]) 2019-06-13 13:18:14,423 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0xb878cc 2019-06-13 13:18:14,423 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76ce2510 [0xcbd728]) 2019-06-13 13:18:14,424 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x7455ae90 2019-06-13 13:18:14,424 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76ce2510 [0xcbd728]) 2019-06-13 13:18:14,425 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x7455ae90 2019-06-13 13:18:14,425 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec L16 2019-06-13 13:18:14,426 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x7455ae78 [0xd20e68], 0x76ce2510 [0xcbd728], 0x2d7690 [0]) 2019-06-13 13:18:14,427 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0xb878cc 2019-06-13 13:18:14,427 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76ce2520 [0xcbd780]) 2019-06-13 13:18:14,428 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x7455ae90 2019-06-13 13:18:14,428 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76ce2520 [0xcbd780]) 2019-06-13 13:18:14,428 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x7455ae90 2019-06-13 13:18:14,429 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec L16 2019-06-13 13:18:14,430 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x7455ae78 [0xd20e68], 0x76ce2520 [0xcbd780], 0x2d7690 [0]) 2019-06-13 13:18:14,430 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0xb878cc 2019-06-13 13:18:14,431 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_video_devices(0x7455ae78 [0xd20e68]) 2019-06-13 13:18:14,431 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_video_devices -> 0x744c5d78 2019-06-13 13:18:14,432 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_video_devices(0x7455ae78 [0xd20e68]) 2019-06-13 13:18:14,432 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_video_devices -> 0x744c5d78 2019-06-13 13:18:14,433 [INFO] [doorpi.sipphone.from_linphone] found 2 possible videodevices: 2019-06-13 13:18:14,433 [DEBUG] [doorpi.sipphone.from_linphone] | name 2019-06-13 13:18:14,434 [DEBUG] [doorpi.sipphone.from_linphone] ------------------------------------ 2019-06-13 13:18:14,434 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_video_devices(0x7455ae78 [0xd20e68]) 2019-06-13 13:18:14,435 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_video_devices -> 0x744c5d78 2019-06-13 13:18:14,435 [DEBUG] [doorpi.sipphone.from_linphone] | V4L2: /dev/video0 2019-06-13 13:18:14,435 [DEBUG] [doorpi.sipphone.from_linphone] | StaticImage: Static picture 2019-06-13 13:18:14,436 [DEBUG] [doorpi.sipphone.from_linphone] ------------------------------------ 2019-06-13 13:18:14,436 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_video_devices(0x7455ae78 [0xd20e68]) 2019-06-13 13:18:14,437 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_video_devices -> 0x744c5d78 2019-06-13 13:18:14,437 [TRACE] [doorpi.conf.config_object] get_string for key video_device in section SIP-Phone (default: V4L2: /dev/video0) returns V4L2: /dev/video0 2019-06-13 13:18:14,438 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_video_devices(0x7455ae78 [0xd20e68]) 2019-06-13 13:18:14,438 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_video_devices -> 0x744c5d78 2019-06-13 13:18:14,439 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_enable_video_capture(0x7455ae78 [0xd20e68], 0x2d769c [1]) 2019-06-13 13:18:14,439 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_enable_video_capture -> 0 2019-06-13 13:18:14,440 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_video_device(0x7455ae78 [0xd20e68], "V4L2: /dev/video0") 2019-06-13 13:18:14,440 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_video_device -> 0 2019-06-13 13:18:14,441 [TRACE] [doorpi.conf.config_object] get_string for key video_size in section SIP-Phone (default: vga) returns vga 2019-06-13 13:18:14,441 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_preferred_video_size_by_name(0x7455ae78 [0xd20e68], "vga") 2019-06-13 13:18:14,442 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_preferred_video_size_by_name -> 0 2019-06-13 13:18:14,442 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_video_device(0x7455ae78 [0xd20e68]) 2019-06-13 13:18:14,443 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_video_device -> 0x744c5e08 2019-06-13 13:18:14,443 [DEBUG] [doorpi.sipphone.from_linphone] using video_device: V4L2: /dev/video0 2019-06-13 13:18:14,444 [TRACE] [doorpi.conf.config_object] get_list for key video_codecs in section SIP-Phone (default: VP8) returns ['VP8'] 2019-06-13 13:18:14,445 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_video_codecs(0x7455ae78 [0xd20e68]) 2019-06-13 13:18:14,445 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0xcbd380) 2019-06-13 13:18:14,446 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2019-06-13 13:18:14,447 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0x76ce2530 2019-06-13 13:18:14,447 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2019-06-13 13:18:14,447 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0x76ce2530 2019-06-13 13:18:14,448 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0x76ce2530 2019-06-13 13:18:14,449 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_video_codecs -> 0x744c5e18 2019-06-13 13:18:14,450 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76ce2530 [0xcbd380]) 2019-06-13 13:18:14,450 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x7455ae90 2019-06-13 13:18:14,451 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_video_capture_enabled(0x7455ae78 [0xd20e68]) 2019-06-13 13:18:14,452 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_video_capture_enabled -> 0x2d769c 2019-06-13 13:18:14,452 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76ce2530 [0xcbd380]) 2019-06-13 13:18:14,453 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x7455ae90 2019-06-13 13:18:14,453 [DEBUG] [doorpi.sipphone.from_linphone] enable video codec VP8 2019-06-13 13:18:14,454 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x7455ae78 [0xd20e68], 0x76ce2530 [0xcbd380], 0x2d769c [1]) 2019-06-13 13:18:14,455 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0xb878cc 2019-06-13 13:18:14,455 [TRACE] [doorpi.conf.config_object] get_string for key sipserver_server in section SIP-Phone (default: ) returns 192.168.188.1 2019-06-13 13:18:14,456 [TRACE] [doorpi.conf.config_object] get_string for key sipserver_username in section SIP-Phone (default: ) returns doordoor 2019-06-13 13:18:14,456 [TRACE] [doorpi.conf.config_object] get_string for key sipserver_password in section SIP-Phone (default: doordoor) returns ******* 2019-06-13 13:18:14,457 [TRACE] [doorpi.conf.config_object] get_string for key sipserver_realm in section SIP-Phone (default: 192.168.188.1) returns 192.168.188.1 2019-06-13 13:18:14,458 [INFO] [doorpi.sipphone.from_linphone] using DoorPi with SIP-Server 2019-06-13 13:18:14,458 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_create_proxy_config(0x7455ae78 [0xd20e68]) 2019-06-13 13:18:14,459 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_ProxyConfig_from_native_ptr(0xd1b810) 2019-06-13 13:18:14,459 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_ProxyConfig_new() 2019-06-13 13:18:14,460 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_ProxyConfig_new -> 0x76ce2540 2019-06-13 13:18:14,461 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_ProxyConfig_init() 2019-06-13 13:18:14,461 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_ProxyConfig_init -> 0x76ce2540 2019-06-13 13:18:14,462 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_ProxyConfig_from_native_ptr -> 0x76ce2540 2019-06-13 13:18:14,462 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_create_proxy_config -> 0x76ce2540 2019-06-13 13:18:14,463 [TRACE] [doorpi.conf.config_object] get_string for key identity in section SIP-Phone (default: DoorPi) returns Tuer 2019-06-13 13:18:14,464 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Address_class_method_new("Tuer ") 2019-06-13 13:18:14,465 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Address_from_native_ptr(0xd35048) 2019-06-13 13:18:14,466 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Address_new() 2019-06-13 13:18:14,466 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Address_new -> 0x76ce2550 2019-06-13 13:18:14,466 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Address_init() 2019-06-13 13:18:14,467 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Address_init -> 0x76ce2550 2019-06-13 13:18:14,467 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Address_from_native_ptr -> 0x76ce2550 2019-06-13 13:18:14,467 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Address_class_method_new -> 0x76ce2550 2019-06-13 13:18:14,468 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_ProxyConfig_set_identity_address(0x76ce2540 [0xd1b810], 0x76ce2550 [0xd35048]) 2019-06-13 13:18:14,469 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_ProxyConfig_set_identity_address -> 0 2019-06-13 13:18:14,470 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_ProxyConfig_set_server_addr(0x76ce2540 [0xd1b810], "sip:192.168.188.1") 2019-06-13 13:18:14,472 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_ProxyConfig_set_server_addr -> 0 2019-06-13 13:18:14,473 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_ProxyConfig_enable_register(0x76ce2540 [0xd1b810], 0x2d769c [1]) 2019-06-13 13:18:14,474 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_ProxyConfig_enable_register -> 0 2019-06-13 13:18:14,475 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_add_proxy_config(0x7455ae78 [0xd20e68], 0x76ce2540 [0xd1b810]) 2019-06-13 13:18:14,477 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_add_proxy_config -> 0xb878cc 2019-06-13 13:18:14,478 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_default_proxy_config(0x7455ae78 [0xd20e68], 0x76ce2540 [0xd1b810]) 2019-06-13 13:18:14,479 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_default_proxy_config -> 0 2019-06-13 13:18:14,480 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_create_auth_info(0x7455ae78 [0xd20e68], "doordoor", "(null)", "pidoorpi1212", "(null)", "(null)", "192.168.188.1") 2019-06-13 13:18:14,481 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_AuthInfo_from_native_ptr(0xd34798) 2019-06-13 13:18:14,483 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_AuthInfo_new() 2019-06-13 13:18:14,485 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_AuthInfo_new -> 0x76ce2560 2019-06-13 13:18:14,486 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_AuthInfo_init() 2019-06-13 13:18:14,487 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_AuthInfo_init -> 0x76ce2560 2019-06-13 13:18:14,488 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_AuthInfo_from_native_ptr -> 0x76ce2560 2019-06-13 13:18:14,489 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_create_auth_info -> 0x76ce2560 2019-06-13 13:18:14,489 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_add_auth_info(0x7455ae78 [0xd20e68], 0x76ce2560 [0xd34798]) 2019-06-13 13:18:14,490 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_add_auth_info -> None 2019-06-13 13:18:14,491 [DEBUG] [doorpi.sipphone.from_linphone] start successfully 2019-06-13 13:18:14,491 [TRACE] [doorpi.conf.config_object] get_sections returns ['EVENT_OnStartup'] 2019-06-13 13:18:14,492 [INFO] [doorpi.doorpi] found EVENT_ section 'EVENT_OnStartup' in configfile 2019-06-13 13:18:14,493 [TRACE] [doorpi.conf.config_object] get_keys for section EVENT_OnStartup returns ['10'] 2019-06-13 13:18:14,494 [INFO] [doorpi.doorpi] registering action '10' for event 'OnStartup' 2019-06-13 13:18:14,494 [TRACE] [doorpi.conf.config_object] get_string for key 10 in section EVENT_OnStartup (default: ) returns sleep:1 2019-06-13 13:18:14,495 [DEBUG] [doorpi.action.SingleActions.sleep] doorpi.action.SingleActions.sleep loaded 2019-06-13 13:18:14,496 [TRACE] [doorpi.action.handler] action SleepAction with args (1.0,) and kwargs {} was added to new evententry OnStartup 2019-06-13 13:18:14,497 [TRACE] [doorpi.conf.config_object] get_string for key 7 in section onboardpins_InputPins (default: ) returns call:**9 2019-06-13 13:18:14,498 [DEBUG] [doorpi.action.SingleActions.call] doorpi.action.SingleActions.call loaded 2019-06-13 13:18:14,500 [TRACE] [doorpi.action.handler] action CallAction with args () and kwargs {'number': '**9'} was added to new evententry OnKeyPressed_onboardpins.7 2019-06-13 13:18:14,501 [TRACE] [doorpi.conf.config_object] get_keys for section DTMF returns ['0'] 2019-06-13 13:18:14,502 [TRACE] [doorpi.conf.config_object] get_string for key 0 in section DTMF (default: ) returns out:Tueroeffner,1,0,3 2019-06-13 13:18:14,503 [DEBUG] [doorpi.action.SingleActions.out] doorpi.action.SingleActions.out loaded 2019-06-13 13:18:14,504 [DEBUG] [doorpi.action.SingleActions.out_triggered] doorpi.action.SingleActions.out_triggered loaded 2019-06-13 13:18:14,505 [TRACE] [doorpi.action.handler] action OutTriggeredAction with args () and kwargs {'stop_pin': 'NoStopPinSet', 'end_value': '0', 'timeout': 3.0, 'pin': 'Tueroeffner', 'start_value': '1'} was added to new evententry OnDTMF_0 2019-06-13 13:18:14,506 [TRACE] [doorpi.conf.config_object] get_string for key is_alive_led in section DoorPi (default: ) returns 2019-06-13 13:18:14,507 [TRACE] [doorpi.action.handler] fire Event BeforeStartup from doorpi.doorpi asyncron Exception in thread OnWebServerStart from doorpi.status.webserver: Traceback (most recent call last): File "/usr/lib/python2.7/threading.py", line 801, in __bootstrap_inner self.run() File "/usr/lib/python2.7/threading.py", line 754, in run self.__target(*self.__args, **self.__kwargs) File "/usr/local/lib/python2.7/dist-packages/doorpi/action/handler.py", line 251, in fire_event_synchron if not silent: self.db.insert_event_log(event_fire_id, event_source, event_name, start_time, kwargs) File "/usr/local/lib/python2.7/dist-packages/doorpi/action/handler.py", line 135, in insert_event_log self.execute_sql(sql_statement) File "/usr/local/lib/python2.7/dist-packages/doorpi/action/handler.py", line 121, in execute_sql return self._db.execute(sql) OperationalError: database is locked Exception in thread OnCallStart from doorpi.sipphone.linphone_lib.CallBacks: Traceback (most recent call last): File "/usr/lib/python2.7/threading.py", line 801, in __bootstrap_inner self.run() File "/usr/lib/python2.7/threading.py", line 754, in run self.__target(*self.__args, **self.__kwargs) File "/usr/local/lib/python2.7/dist-packages/doorpi/action/handler.py", line 251, in fire_event_synchron if not silent: self.db.insert_event_log(event_fire_id, event_source, event_name, start_time, kwargs) File "/usr/local/lib/python2.7/dist-packages/doorpi/action/handler.py", line 135, in insert_event_log self.execute_sql(sql_statement) File "/usr/local/lib/python2.7/dist-packages/doorpi/action/handler.py", line 121, in execute_sql return self._db.execute(sql) OperationalError: database is locked Exception in thread OnSipPhoneCreate from doorpi.sipphone.from_linphone: Traceback (most recent call last): File "/usr/lib/python2.7/threading.py", line 801, in __bootstrap_inner self.run() File "/usr/lib/python2.7/threading.py", line 754, in run self.__target(*self.__args, **self.__kwargs) File "/usr/local/lib/python2.7/dist-packages/doorpi/action/handler.py", line 251, in fire_event_synchron if not silent: self.db.insert_event_log(event_fire_id, event_source, event_name, start_time, kwargs) File "/usr/local/lib/python2.7/dist-packages/doorpi/action/handler.py", line 135, in insert_event_log self.execute_sql(sql_statement) File "/usr/local/lib/python2.7/dist-packages/doorpi/action/handler.py", line 121, in execute_sql return self._db.execute(sql) OperationalError: database is locked Exception in thread OnRecorderCreated from doorpi.sipphone.linphone_lib.Recorder: Traceback (most recent call last): File "/usr/lib/python2.7/threading.py", line 801, in __bootstrap_inner self.run() File "/usr/lib/python2.7/threading.py", line 754, in run self.__target(*self.__args, **self.__kwargs) File "/usr/local/lib/python2.7/dist-packages/doorpi/action/handler.py", line 251, in fire_event_synchron if not silent: self.db.insert_event_log(event_fire_id, event_source, event_name, start_time, kwargs) File "/usr/local/lib/python2.7/dist-packages/doorpi/action/handler.py", line 135, in insert_event_log self.execute_sql(sql_statement) File "/usr/local/lib/python2.7/dist-packages/doorpi/action/handler.py", line 121, in execute_sql return self._db.execute(sql) OperationalError: database is locked Exception in thread OnPlayerCreated from doorpi.sipphone.linphone_lib.Player: Traceback (most recent call last): File "/usr/lib/python2.7/threading.py", line 801, in __bootstrap_inner self.run() File "/usr/lib/python2.7/threading.py", line 754, in run self.__target(*self.__args, **self.__kwargs) File "/usr/local/lib/python2.7/dist-packages/doorpi/action/handler.py", line 251, in fire_event_synchron if not silent: self.db.insert_event_log(event_fire_id, event_source, event_name, start_time, kwargs) File "/usr/local/lib/python2.7/dist-packages/doorpi/action/handler.py", line 135, in insert_event_log self.execute_sql(sql_statement) File "/usr/local/lib/python2.7/dist-packages/doorpi/action/handler.py", line 121, in execute_sql return self._db.execute(sql) OperationalError: database is locked Exception in thread BeforeStartup from doorpi.doorpi: Traceback (most recent call last): File "/usr/lib/python2.7/threading.py", line 801, in __bootstrap_inner self.run() File "/usr/lib/python2.7/threading.py", line 754, in run self.__target(*self.__args, **self.__kwargs) File "/usr/local/lib/python2.7/dist-packages/doorpi/action/handler.py", line 251, in fire_event_synchron if not silent: self.db.insert_event_log(event_fire_id, event_source, event_name, start_time, kwargs) File "/usr/local/lib/python2.7/dist-packages/doorpi/action/handler.py", line 135, in insert_event_log self.execute_sql(sql_statement) File "/usr/local/lib/python2.7/dist-packages/doorpi/action/handler.py", line 121, in execute_sql return self._db.execute(sql) OperationalError: database is locked 2019-06-13 13:18:20,936 [ERROR] [doorpi.main] Exception NameError: database is locked 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 235, in run self.event_handler.fire_event_synchron('OnStartup', __name__) File "/usr/local/lib/python2.7/dist-packages/doorpi/action/handler.py", line 251, in fire_event_synchron if not silent: self.db.insert_event_log(event_fire_id, event_source, event_name, start_time, kwargs) File "/usr/local/lib/python2.7/dist-packages/doorpi/action/handler.py", line 135, in insert_event_log self.execute_sql(sql_statement) File "/usr/local/lib/python2.7/dist-packages/doorpi/action/handler.py", line 121, in execute_sql return self._db.execute(sql) OperationalError: database is locked 2019-06-13 13:18:20,945 [DEBUG] [doorpi.doorpi] destroy doorpi 2019-06-13 13:18:20,946 [DEBUG] [doorpi.doorpi] Threads before starting shutdown: [<_MainThread(MainThread, started 1995898880)>] 2019-06-13 13:18:20,947 [TRACE] [doorpi.action.handler] fire Event BeforeShutdown from doorpi.doorpi asyncron Traceback (most recent call last): File "/usr/local/bin/doorpi_cli", line 10, in sys.exit(entry_point()) Exception in thread BeforeShutdown from doorpi.doorpi: Traceback (most recent call last): File "/usr/lib/python2.7/threading.py", line 801, in __bootstrap_inner self.run() File "/usr/lib/python2.7/threading.py", line 754, in run self.__target(*self.__args, **self.__kwargs) File "/usr/local/lib/python2.7/dist-packages/doorpi/action/handler.py", line 251, in fire_event_synchron if not silent: self.db.insert_event_log(event_fire_id, event_source, event_name, start_time, kwargs) File "/usr/local/lib/python2.7/dist-packages/doorpi/action/handler.py", line 135, in insert_event_log self.execute_sql(sql_statement) File "/usr/local/lib/python2.7/dist-packages/doorpi/action/handler.py", line 121, in execute_sql return self._db.execute(sql) OperationalError: database is locked File "/usr/local/lib/python2.7/dist-packages/doorpi/main.py", line 169, in entry_point raise SystemExit(main_as_application(sys.argv)) File "/usr/local/lib/python2.7/dist-packages/doorpi/main.py", line 155, in main_as_application finally: doorpi.DoorPi().destroy() File "/usr/local/lib/python2.7/dist-packages/doorpi/doorpi.py", line 205, in destroy self.event_handler.fire_event_synchron('OnShutdown', __name__) File "/usr/local/lib/python2.7/dist-packages/doorpi/action/handler.py", line 251, in fire_event_synchron if not silent: self.db.insert_event_log(event_fire_id, event_source, event_name, start_time, kwargs) File "/usr/local/lib/python2.7/dist-packages/doorpi/action/handler.py", line 135, in insert_event_log self.execute_sql(sql_statement) File "/usr/local/lib/python2.7/dist-packages/doorpi/action/handler.py", line 121, in execute_sql return self._db.execute(sql) sqlite3.OperationalError: database is locked pi@raspberrypi:~ $