pi@tuer /home/DoorPI/DoorPi $ sudo /usr/bin/python /usr/local/bin/doorpi_cli --configfile /home/DoorPi/DoorPi/conf/doorpi.cfg --trace 2016-03-18 17:36:30,248 [INFO] [doorpi.main] ___ ___ _ / \___ ___ _ __ / _ (_) VoIP Door-Intercomstation with Raspberry Pi / /\ / _ \ / _ \| '__/ /_)/ | version: 2.5.0.0 / /_// (_) | (_) | | / ___/| | 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 2016-03-18 17:36:30,251 [DEBUG] [doorpi.main] loaded with arguments: ['/usr/local/bin/doorpi_cli', '--configfile', '/home/DoorPi/DoorPi/conf/doorpi.cfg', '--trace'] 2016-03-18 17:36:30,254 [DEBUG] [doorpi.doorpi] run 2016-03-18 17:36:30,257 [DEBUG] [doorpi.doorpi] prepare 2016-03-18 17:36:30,259 [DEBUG] [doorpi.doorpi] given arguments argv: Namespace(configfile='/home/DoorPi/DoorPi/conf/doorpi.cfg', debug=False, test=False, trace=True) 2016-03-18 17:36:30,268 [INFO] [doorpi.conf.config_object] use configfile: /usr/local/etc/DoorPi/conf/doorpi.ini 2016-03-18 17:36:30,288 [DEBUG] [doorpi.conf.config_object] __init__ 2016-03-18 17:36:30,291 [TRACE] [doorpi.conf.config_object] get_from_config 2016-03-18 17:36:30,303 [TRACE] [doorpi.conf.config_object] get_string for key base_path in section DoorPi (default: /usr/local/etc/DoorPi) returns /usr/local/etc/DoorPi 2016-03-18 17:36:30,306 [TRACE] [doorpi.conf.config_object] get_string for key eventlog in section DoorPi (default: !BASEPATH!/conf/eventlog.db) returns !BASEPATH!/conf/eventlog.db 2016-03-18 17:36:30,309 [DEBUG] [doorpi.conf.config_object] parse string "!BASEPATH!/conf/eventlog.db" to "/usr/local/etc/DoorPi/conf/eventlog.db" 2016-03-18 17:36:30,319 [TRACE] [doorpi.action.handler] register Event BeforeStartup from doorpi.doorpi 2016-03-18 17:36:30,321 [DEBUG] [doorpi.action.handler] event_source doorpi.doorpi was added 2016-03-18 17:36:30,324 [TRACE] [doorpi.action.handler] added event_name BeforeStartup and registered source doorpi.doorpi 2016-03-18 17:36:30,327 [TRACE] [doorpi.action.handler] register Event OnStartup from doorpi.doorpi 2016-03-18 17:36:30,329 [TRACE] [doorpi.action.handler] added event_name OnStartup and registered source doorpi.doorpi 2016-03-18 17:36:30,332 [TRACE] [doorpi.action.handler] register Event AfterStartup from doorpi.doorpi 2016-03-18 17:36:30,334 [TRACE] [doorpi.action.handler] added event_name AfterStartup and registered source doorpi.doorpi 2016-03-18 17:36:30,337 [TRACE] [doorpi.action.handler] register Event BeforeShutdown from doorpi.doorpi 2016-03-18 17:36:30,340 [TRACE] [doorpi.action.handler] added event_name BeforeShutdown and registered source doorpi.doorpi 2016-03-18 17:36:30,342 [TRACE] [doorpi.action.handler] register Event OnShutdown from doorpi.doorpi 2016-03-18 17:36:30,345 [TRACE] [doorpi.action.handler] added event_name OnShutdown and registered source doorpi.doorpi 2016-03-18 17:36:30,348 [TRACE] [doorpi.action.handler] register Event AfterShutdown from doorpi.doorpi 2016-03-18 17:36:30,350 [TRACE] [doorpi.action.handler] added event_name AfterShutdown and registered source doorpi.doorpi 2016-03-18 17:36:30,357 [DEBUG] [doorpi.action.SingleActions.time_tick] doorpi.action.SingleActions.time_tick loaded 2016-03-18 17:36:30,361 [DEBUG] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was added 2016-03-18 17:36:30,372 [TRACE] [doorpi.action.handler] action TimeTickDestroyAction with args () and kwargs {} was added to new evententry OnShutdown 2016-03-18 17:36:30,375 [TRACE] [doorpi.action.handler] action TimeTickAction with args ('!last_tick!',) and kwargs {} was added to new evententry OnTimeTick 2016-03-18 17:36:30,378 [TRACE] [doorpi.conf.config_object] get_string for key ip in section DoorPiWeb (default: ) returns 2016-03-18 17:36:30,382 [TRACE] [doorpi.conf.config_object] get_integer for key port in section DoorPiWeb (default: 80) returns 80 2016-03-18 17:36:30,391 [INFO] [doorpi.status.webserver] Initiating WebService at ip and port 80 2016-03-18 17:36:30,394 [TRACE] [doorpi.action.handler] register Event OnWebServerStart from doorpi.status.webserver 2016-03-18 17:36:30,397 [DEBUG] [doorpi.action.handler] event_source doorpi.status.webserver was added 2016-03-18 17:36:30,400 [TRACE] [doorpi.action.handler] added event_name OnWebServerStart and registered source doorpi.status.webserver 2016-03-18 17:36:30,402 [TRACE] [doorpi.action.handler] register Event OnWebServerStop from doorpi.status.webserver 2016-03-18 17:36:30,405 [TRACE] [doorpi.action.handler] added event_name OnWebServerStop and registered source doorpi.status.webserver 2016-03-18 17:36:30,408 [TRACE] [doorpi.conf.config_object] get_string for key www in section DoorPiWeb (default: !BASEPATH!/../DoorPiWeb) returns !BASEPATH!/../DoorPiWeb 2016-03-18 17:36:30,412 [DEBUG] [doorpi.conf.config_object] parse string "!BASEPATH!/../DoorPiWeb" to "/usr/local/etc/DoorPi/../DoorPiWeb" 2016-03-18 17:36:30,415 [TRACE] [doorpi.conf.config_object] get_string for key indexfile in section DoorPiWeb (default: index.html) returns index.html 2016-03-18 17:36:30,419 [DEBUG] [doorpi.conf.config_object] parse string "index.html" to "index.html" 2016-03-18 17:36:30,421 [TRACE] [doorpi.conf.config_object] get_string for key loginfile in section DoorPiWeb (default: login.html) returns login.html 2016-03-18 17:36:30,425 [DEBUG] [doorpi.conf.config_object] parse string "login.html" to "login.html" 2016-03-18 17:36:30,428 [TRACE] [doorpi.conf.config_object] get_string for key public in section DoorPiWeb (default: AREA_public) returns AREA_public 2016-03-18 17:36:30,432 [DEBUG] [doorpi.conf.config_object] parse string "AREA_public" to "AREA_public" 2016-03-18 17:36:30,435 [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 2016-03-18 17:36:30,439 [DEBUG] [doorpi.conf.config_object] parse string "http://motom001.github.io/DoorPiWeb" to "http://motom001.github.io/DoorPiWeb" 2016-03-18 17:36:30,441 [WARNING] [root] section WritePermission not found in configfile 2016-03-18 17:36:30,444 [TRACE] [doorpi.conf.config_object] get_keys for section WritePermission returns [] 2016-03-18 17:36:30,447 [WARNING] [root] section ReadPermission not found in configfile 2016-03-18 17:36:30,449 [TRACE] [doorpi.conf.config_object] get_keys for section ReadPermission returns [] 2016-03-18 17:36:30,452 [WARNING] [root] section Group not found in configfile 2016-03-18 17:36:30,455 [TRACE] [doorpi.conf.config_object] get_keys for section Group returns [] 2016-03-18 17:36:30,457 [WARNING] [root] section User not found in configfile 2016-03-18 17:36:30,460 [TRACE] [doorpi.conf.config_object] get_keys for section User returns [] 2016-03-18 17:36:30,463 [TRACE] [doorpi.conf.config_object] get_sections returns ['DoorPiWeb', 'keyboards', 'EVENT_OnStartup', 'SIP-Phone', 'DoorPi'] 2016-03-18 17:36:30,468 [ERROR] [doorpi.status.webserver] no ReadPermission found 2016-03-18 17:36:30,470 [ERROR] [doorpi.status.webserver] no groups in configfile! 2016-03-18 17:36:30,473 [ERROR] [doorpi.status.webserver] no WritePermission found 2016-03-18 17:36:30,476 [TRACE] [doorpi.action.handler] action WebServerStartupAction with args () and kwargs {} was added to new evententry OnWebServerStart 2016-03-18 17:36:30,479 [TRACE] [doorpi.action.handler] action WebServerShutdownAction with args () and kwargs {} was added to event OnShutdown 2016-03-18 17:36:30,482 [TRACE] [doorpi.action.handler] fire Event OnWebServerStart from doorpi.status.webserver asyncron 2016-03-18 17:36:30,487 [TRACE] [doorpi.action.handler] register Event OnWebServerRequest from doorpi.status.webserver_lib.request_handler 2016-03-18 17:36:30,489 [DEBUG] [doorpi.action.handler] event_source doorpi.status.webserver_lib.request_handler was added 2016-03-18 17:36:30,496 [TRACE] [doorpi.action.handler] added event_name OnWebServerRequest and registered source doorpi.status.webserver_lib.request_handler 2016-03-18 17:36:30,499 [TRACE] [doorpi.action.handler] register Event OnWebServerRequestGet from doorpi.status.webserver_lib.request_handler 2016-03-18 17:36:30,502 [TRACE] [doorpi.action.handler] added event_name OnWebServerRequestGet and registered source doorpi.status.webserver_lib.request_handler 2016-03-18 17:36:30,495 [DEBUG] [doorpi.action.handler] [D18K8G] fire for event OnWebServerStart this actions [] 2016-03-18 17:36:30,509 [TRACE] [doorpi.action.handler] [D18K8G] try to fire action WebServerStartupAction with args () and kwargs {} 2016-03-18 17:36:30,512 [TRACE] [doorpi.action.base] run WebServerStartupAction with args () and kwargs {} 2016-03-18 17:36:30,511 [TRACE] [doorpi.action.handler] register Event OnWebServerRequestPost from doorpi.status.webserver_lib.request_handler 2016-03-18 17:36:30,517 [TRACE] [doorpi.action.handler] added event_name OnWebServerRequestPost and registered source doorpi.status.webserver_lib.request_handler 2016-03-18 17:36:30,521 [TRACE] [doorpi.action.handler] register Event OnWebServerVirtualResource from doorpi.status.webserver_lib.request_handler 2016-03-18 17:36:30,523 [TRACE] [doorpi.action.handler] added event_name OnWebServerVirtualResource and registered source doorpi.status.webserver_lib.request_handler 2016-03-18 17:36:30,526 [TRACE] [doorpi.action.handler] register Event OnWebServerRealResource from doorpi.status.webserver_lib.request_handler 2016-03-18 17:36:30,530 [TRACE] [doorpi.action.handler] added event_name OnWebServerRealResource and registered source doorpi.status.webserver_lib.request_handler 2016-03-18 17:36:30,533 [TRACE] [doorpi.action.handler] register Event OnFireEvent from doorpi.status.webserver_lib.request_handler 2016-03-18 17:36:30,536 [TRACE] [doorpi.action.handler] added event_name OnFireEvent and registered source doorpi.status.webserver_lib.request_handler 2016-03-18 17:36:30,538 [TRACE] [doorpi.action.handler] register Event OnConfigKeySet from doorpi.status.webserver_lib.request_handler 2016-03-18 17:36:30,541 [TRACE] [doorpi.action.handler] added event_name OnConfigKeySet and registered source doorpi.status.webserver_lib.request_handler 2016-03-18 17:36:30,544 [TRACE] [doorpi.action.handler] register Event OnConfigKeyDelete from doorpi.status.webserver_lib.request_handler 2016-03-18 17:36:30,546 [TRACE] [doorpi.action.handler] added event_name OnConfigKeyDelete and registered source doorpi.status.webserver_lib.request_handler 2016-03-18 17:36:30,549 [TRACE] [doorpi.conf.config_object] get_keys for section keyboards returns ['dummy'] 2016-03-18 17:36:30,552 [INFO] [doorpi.keyboard.KeyboardInterface] using multi-keyboard mode (keyboards: dummy) 2016-03-18 17:36:30,554 [INFO] [doorpi.keyboard.KeyboardInterface] trying to add keyboard 'dummy' to handler 2016-03-18 17:36:30,558 [TRACE] [doorpi.conf.config_object] get_string for key dummy in section keyboards (default: dummy) returns dummy 2016-03-18 17:36:30,561 [WARNING] [root] section dummy_InputPins not found in configfile 2016-03-18 17:36:30,563 [TRACE] [doorpi.conf.config_object] get_keys for section dummy_InputPins returns [] 2016-03-18 17:36:30,566 [WARNING] [root] section dummy_OutputPins not found in configfile 2016-03-18 17:36:30,569 [TRACE] [doorpi.conf.config_object] get_keys for section dummy_OutputPins returns [] 2016-03-18 17:36:30,572 [TRACE] [doorpi.conf.config_object] get_integer for key bouncetime in section dummy_keyboard (default: 2000) returns 2000.0 2016-03-18 17:36:30,575 [TRACE] [doorpi.conf.config_object] get_integer for key polarity in section dummy_keyboard (default: 0) returns 0 2016-03-18 17:36:30,578 [TRACE] [doorpi.conf.config_object] get_boolean for key pressed_on_keydown in section dummy_keyboard (default: True) returns True 2016-03-18 17:36:30,583 [DEBUG] [doorpi.keyboard.from_dummy] doorpi.keyboard.from_dummy loaded 2016-03-18 17:36:30,587 [DEBUG] [doorpi.keyboard.from_dummy] __init__(input_pins = [], output_pins = [], bouncetime = 2000.0, polarity = 0) 2016-03-18 17:36:30,590 [WARNING] [root] section dummy_InputPins not found in configfile 2016-03-18 17:36:30,592 [TRACE] [doorpi.conf.config_object] get_keys for section dummy_InputPins returns [] 2016-03-18 17:36:30,595 [WARNING] [root] section dummy_OutputPins not found in configfile 2016-03-18 17:36:30,598 [TRACE] [doorpi.conf.config_object] get_keys for section dummy_OutputPins returns [] 2016-03-18 17:36:30,601 [TRACE] [doorpi.action.handler] action KeyboardDestroyAction with args () and kwargs {} was added to event OnShutdown 2016-03-18 17:36:30,603 [WARNING] [root] section dummy_OutputPins not found in configfile 2016-03-18 17:36:30,606 [TRACE] [doorpi.conf.config_object] get_keys for section dummy_OutputPins returns [] 2016-03-18 17:36:30,612 [DEBUG] [doorpi.status.status_lib.environment] doorpi.status.status_lib.environment loaded 2016-03-18 17:36:30,620 [DEBUG] [doorpi.status.requirements_lib.req_config] doorpi.status.requirements_lib.req_config loaded 2016-03-18 17:36:30,625 [DEBUG] [doorpi.status.requirements_lib.req_sipphone] doorpi.status.requirements_lib.req_sipphone loaded 2016-03-18 17:36:30,630 [DEBUG] [doorpi.sipphone.AbstractBaseClass] doorpi.sipphone.AbstractBaseClass loaded 2016-03-18 17:36:30,739 [DEBUG] [doorpi.status.requirements_lib.req_event_handler] doorpi.status.requirements_lib.req_event_handler loaded 2016-03-18 17:36:30,746 [DEBUG] [doorpi.status.requirements_lib.req_webserver] doorpi.status.requirements_lib.req_webserver loaded 2016-03-18 17:36:30,754 [DEBUG] [doorpi.status.requirements_lib.req_keyboard] doorpi.status.requirements_lib.req_keyboard loaded 2016-03-18 17:36:30,911 [DEBUG] [doorpi.status.requirements_lib.req_system] doorpi.status.requirements_lib.req_system loaded 2016-03-18 17:36:30,930 [INFO] [doorpi.sipphone.SipphoneInterface] found installed sipphone "linphone" and use this as default 2016-03-18 17:36:30,932 [TRACE] [doorpi.conf.config_object] get_string for key sipphonetyp in section SIP-Phone (default: linphone) returns linphone 2016-03-18 17:36:30,939 [DEBUG] [doorpi.sipphone.from_linphone] doorpi.sipphone.from_linphone loaded 2016-03-18 17:36:30,946 [DEBUG] [doorpi.sipphone.linphone_lib.CallBacks] doorpi.sipphone.linphone_lib.CallBacks loaded 2016-03-18 17:36:30,956 [DEBUG] [doorpi.sipphone.linphone_lib.Player] doorpi.sipphone.linphone_lib.Player loaded 2016-03-18 17:36:30,963 [DEBUG] [doorpi.sipphone.linphone_lib.Recorder] doorpi.sipphone.linphone_lib.Recorder loaded 2016-03-18 17:36:30,969 [DEBUG] [doorpi.sipphone.from_linphone] __init__ 2016-03-18 17:36:30,972 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to event OnShutdown 2016-03-18 17:36:30,974 [TRACE] [doorpi.action.handler] register Event OnSipPhoneCreate from doorpi.sipphone.from_linphone 2016-03-18 17:36:30,977 [DEBUG] [doorpi.action.handler] event_source doorpi.sipphone.from_linphone was added 2016-03-18 17:36:30,980 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneCreate and registered source doorpi.sipphone.from_linphone 2016-03-18 17:36:30,983 [TRACE] [doorpi.action.handler] register Event OnSipPhoneStart from doorpi.sipphone.from_linphone 2016-03-18 17:36:30,986 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneStart and registered source doorpi.sipphone.from_linphone 2016-03-18 17:36:30,989 [TRACE] [doorpi.action.handler] register Event OnSipPhoneDestroy from doorpi.sipphone.from_linphone 2016-03-18 17:36:30,992 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneDestroy and registered source doorpi.sipphone.from_linphone 2016-03-18 17:36:30,994 [TRACE] [doorpi.action.handler] register Event OnSipPhoneRecorderCreate from doorpi.sipphone.from_linphone 2016-03-18 17:36:30,998 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneRecorderCreate and registered source doorpi.sipphone.from_linphone 2016-03-18 17:36:31,001 [TRACE] [doorpi.action.handler] register Event OnSipPhoneRecorderDestroy from doorpi.sipphone.from_linphone 2016-03-18 17:36:31,003 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneRecorderDestroy and registered source doorpi.sipphone.from_linphone 2016-03-18 17:36:31,006 [TRACE] [doorpi.action.handler] register Event BeforeSipPhoneMakeCall from doorpi.sipphone.from_linphone 2016-03-18 17:36:31,009 [TRACE] [doorpi.action.handler] added event_name BeforeSipPhoneMakeCall and registered source doorpi.sipphone.from_linphone 2016-03-18 17:36:31,012 [TRACE] [doorpi.action.handler] register Event OnSipPhoneMakeCall from doorpi.sipphone.from_linphone 2016-03-18 17:36:31,015 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneMakeCall and registered source doorpi.sipphone.from_linphone 2016-03-18 17:36:31,018 [TRACE] [doorpi.action.handler] register Event OnSipPhoneMakeCallFailed from doorpi.sipphone.from_linphone 2016-03-18 17:36:31,021 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneMakeCallFailed and registered source doorpi.sipphone.from_linphone 2016-03-18 17:36:31,023 [TRACE] [doorpi.action.handler] register Event AfterSipPhoneMakeCall from doorpi.sipphone.from_linphone 2016-03-18 17:36:31,026 [TRACE] [doorpi.action.handler] added event_name AfterSipPhoneMakeCall and registered source doorpi.sipphone.from_linphone 2016-03-18 17:36:31,029 [TRACE] [doorpi.action.handler] register Event OnSipPhoneCallTimeoutNoResponse from doorpi.sipphone.from_linphone 2016-03-18 17:36:31,031 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneCallTimeoutNoResponse and registered source doorpi.sipphone.from_linphone 2016-03-18 17:36:31,034 [TRACE] [doorpi.action.handler] register Event OnSipPhoneCallTimeoutMaxCalltime from doorpi.sipphone.from_linphone 2016-03-18 17:36:31,037 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneCallTimeoutMaxCalltime and registered source doorpi.sipphone.from_linphone 2016-03-18 17:36:31,041 [TRACE] [doorpi.action.handler] register Event OnPlayerCreated from doorpi.sipphone.from_linphone 2016-03-18 17:36:31,043 [TRACE] [doorpi.action.handler] added event_name OnPlayerCreated and registered source doorpi.sipphone.from_linphone 2016-03-18 17:36:31,046 [DEBUG] [doorpi.sipphone.linphone_lib.CallBacks] __init__ 2016-03-18 17:36:31,049 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to new evententry OnSipPhoneDestroy 2016-03-18 17:36:31,052 [TRACE] [doorpi.action.handler] register Event OnCallMediaStateChange from doorpi.sipphone.linphone_lib.CallBacks 2016-03-18 17:36:31,055 [DEBUG] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was added 2016-03-18 17:36:31,058 [TRACE] [doorpi.action.handler] added event_name OnCallMediaStateChange and registered source doorpi.sipphone.linphone_lib.CallBacks 2016-03-18 17:36:31,061 [TRACE] [doorpi.action.handler] register Event OnMediaRequired from doorpi.sipphone.linphone_lib.CallBacks 2016-03-18 17:36:31,064 [TRACE] [doorpi.action.handler] added event_name OnMediaRequired and registered source doorpi.sipphone.linphone_lib.CallBacks 2016-03-18 17:36:31,067 [TRACE] [doorpi.action.handler] register Event OnMediaNotRequired from doorpi.sipphone.linphone_lib.CallBacks 2016-03-18 17:36:31,069 [TRACE] [doorpi.action.handler] added event_name OnMediaNotRequired and registered source doorpi.sipphone.linphone_lib.CallBacks 2016-03-18 17:36:31,072 [TRACE] [doorpi.action.handler] register Event OnCallStateChange from doorpi.sipphone.linphone_lib.CallBacks 2016-03-18 17:36:31,075 [TRACE] [doorpi.action.handler] added event_name OnCallStateChange and registered source doorpi.sipphone.linphone_lib.CallBacks 2016-03-18 17:36:31,078 [TRACE] [doorpi.action.handler] register Event OnCallStateConnect from doorpi.sipphone.linphone_lib.CallBacks 2016-03-18 17:36:31,080 [TRACE] [doorpi.action.handler] added event_name OnCallStateConnect and registered source doorpi.sipphone.linphone_lib.CallBacks 2016-03-18 17:36:31,083 [TRACE] [doorpi.action.handler] register Event AfterCallStateConnect from doorpi.sipphone.linphone_lib.CallBacks 2016-03-18 17:36:31,086 [TRACE] [doorpi.action.handler] added event_name AfterCallStateConnect and registered source doorpi.sipphone.linphone_lib.CallBacks 2016-03-18 17:36:31,089 [TRACE] [doorpi.action.handler] register Event OnCallStateDisconnect from doorpi.sipphone.linphone_lib.CallBacks 2016-03-18 17:36:31,092 [TRACE] [doorpi.action.handler] added event_name OnCallStateDisconnect and registered source doorpi.sipphone.linphone_lib.CallBacks 2016-03-18 17:36:31,095 [TRACE] [doorpi.action.handler] register Event AfterCallStateDisconnect from doorpi.sipphone.linphone_lib.CallBacks 2016-03-18 17:36:31,098 [TRACE] [doorpi.action.handler] added event_name AfterCallStateDisconnect and registered source doorpi.sipphone.linphone_lib.CallBacks 2016-03-18 17:36:31,100 [TRACE] [doorpi.action.handler] register Event OnCallStateDismissed from doorpi.sipphone.linphone_lib.CallBacks 2016-03-18 17:36:31,103 [TRACE] [doorpi.action.handler] added event_name OnCallStateDismissed and registered source doorpi.sipphone.linphone_lib.CallBacks 2016-03-18 17:36:31,106 [TRACE] [doorpi.action.handler] register Event OnCallStateReject from doorpi.sipphone.linphone_lib.CallBacks 2016-03-18 17:36:31,109 [TRACE] [doorpi.action.handler] added event_name OnCallStateReject and registered source doorpi.sipphone.linphone_lib.CallBacks 2016-03-18 17:36:31,111 [TRACE] [doorpi.action.handler] register Event OnCallStart from doorpi.sipphone.linphone_lib.CallBacks 2016-03-18 17:36:31,114 [TRACE] [doorpi.action.handler] added event_name OnCallStart and registered source doorpi.sipphone.linphone_lib.CallBacks 2016-03-18 17:36:31,117 [TRACE] [doorpi.action.handler] register Event OnDTMF from doorpi.sipphone.linphone_lib.CallBacks 2016-03-18 17:36:31,120 [TRACE] [doorpi.action.handler] added event_name OnDTMF and registered source doorpi.sipphone.linphone_lib.CallBacks 2016-03-18 17:36:31,122 [WARNING] [root] section DTMF not found in configfile 2016-03-18 17:36:31,125 [TRACE] [doorpi.conf.config_object] get_keys for section DTMF returns [] 2016-03-18 17:36:31,128 [TRACE] [doorpi.action.handler] register Event OnCallStart from doorpi.sipphone.linphone_lib.CallBacks 2016-03-18 17:36:31,131 [TRACE] [doorpi.action.handler] nothing to do - event OnCallStart from source doorpi.sipphone.linphone_lib.CallBacks is already known 2016-03-18 17:36:31,133 [TRACE] [doorpi.action.handler] register Event BeforeCallIncoming from doorpi.sipphone.linphone_lib.CallBacks 2016-03-18 17:36:31,136 [TRACE] [doorpi.action.handler] added event_name BeforeCallIncoming and registered source doorpi.sipphone.linphone_lib.CallBacks 2016-03-18 17:36:31,140 [TRACE] [doorpi.action.handler] register Event OnCallReconnect from doorpi.sipphone.linphone_lib.CallBacks 2016-03-18 17:36:31,142 [TRACE] [doorpi.action.handler] added event_name OnCallReconnect and registered source doorpi.sipphone.linphone_lib.CallBacks 2016-03-18 17:36:31,145 [TRACE] [doorpi.action.handler] register Event AfterCallReconnect from doorpi.sipphone.linphone_lib.CallBacks 2016-03-18 17:36:31,149 [TRACE] [doorpi.action.handler] added event_name AfterCallReconnect and registered source doorpi.sipphone.linphone_lib.CallBacks 2016-03-18 17:36:31,152 [TRACE] [doorpi.action.handler] register Event OnCallBusy from doorpi.sipphone.linphone_lib.CallBacks 2016-03-18 17:36:31,155 [TRACE] [doorpi.action.handler] added event_name OnCallBusy and registered source doorpi.sipphone.linphone_lib.CallBacks 2016-03-18 17:36:31,158 [TRACE] [doorpi.action.handler] register Event AfterCallBusy from doorpi.sipphone.linphone_lib.CallBacks 2016-03-18 17:36:31,161 [TRACE] [doorpi.action.handler] added event_name AfterCallBusy and registered source doorpi.sipphone.linphone_lib.CallBacks 2016-03-18 17:36:31,164 [TRACE] [doorpi.action.handler] register Event OnCallIncoming from doorpi.sipphone.linphone_lib.CallBacks 2016-03-18 17:36:31,166 [TRACE] [doorpi.action.handler] added event_name OnCallIncoming and registered source doorpi.sipphone.linphone_lib.CallBacks 2016-03-18 17:36:31,169 [TRACE] [doorpi.action.handler] register Event AfterCallIncoming from doorpi.sipphone.linphone_lib.CallBacks 2016-03-18 17:36:31,172 [TRACE] [doorpi.action.handler] added event_name AfterCallIncoming and registered source doorpi.sipphone.linphone_lib.CallBacks 2016-03-18 17:36:31,174 [TRACE] [doorpi.action.handler] register Event OnCallReject from doorpi.sipphone.linphone_lib.CallBacks 2016-03-18 17:36:31,177 [TRACE] [doorpi.action.handler] added event_name OnCallReject and registered source doorpi.sipphone.linphone_lib.CallBacks 2016-03-18 17:36:31,180 [TRACE] [doorpi.action.handler] register Event AfterCallReject from doorpi.sipphone.linphone_lib.CallBacks 2016-03-18 17:36:31,183 [TRACE] [doorpi.action.handler] added event_name AfterCallReject and registered source doorpi.sipphone.linphone_lib.CallBacks 2016-03-18 17:36:31,185 [TRACE] [doorpi.action.handler] fire Event OnCallStart from doorpi.sipphone.linphone_lib.CallBacks asyncron 2016-03-18 17:36:31,191 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_new() 2016-03-18 17:36:31,194 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_new -> 0x2469920 2016-03-18 17:36:31,199 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_init() 2016-03-18 17:36:31,202 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_init -> 0x2469920 2016-03-18 17:36:31,198 [DEBUG] [doorpi.action.handler] no actions for event OnCallStart - skip fire_event OnCallStart from doorpi.sipphone.linphone_lib.CallBacks 2016-03-18 17:36:31,205 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_class_method_new(0x24ba030, "(null)", "(null)") 2016-03-18 17:36:31,211 [INFO] [doorpi.sipphone.from_linphone] Mediastreamer2 factory 2.12.1 (git: 3.9.1) initialized. 2016-03-18 17:36:31,215 [INFO] [doorpi.sipphone.from_linphone] CPU count set to 1 2016-03-18 17:36:31,218 [INFO] [doorpi.sipphone.from_linphone] ms_factory_init() done: platform_tags=linux,arm,embedded 2016-03-18 17:36:31,221 [INFO] [doorpi.sipphone.from_linphone] srtp init 2016-03-18 17:36:31,277 [INFO] [doorpi.sipphone.from_linphone] Registering all soundcard handlers 2016-03-18 17:36:31,485 [INFO] [doorpi.sipphone.from_linphone] Card 'ALSA: default device' added 2016-03-18 17:36:31,491 [INFO] [doorpi.sipphone.from_linphone] also error in pcm_hw.c:1293 - open '/dev/snd/pcmC0D0c' failed (-2) 2016-03-18 17:36:31,500 [INFO] [doorpi.sipphone.from_linphone] Card 'ALSA: bcm2835 ALSA' added 2016-03-18 17:36:31,546 [INFO] [doorpi.sipphone.from_linphone] Card 'ALSA: USB PnP Sound Device' added 2016-03-18 17:36:31,549 [INFO] [doorpi.sipphone.from_linphone] Registering all webcam handlers 2016-03-18 17:36:31,553 [INFO] [doorpi.sipphone.from_linphone] Webcam StaticImage: Static picture added 2016-03-18 17:36:31,556 [INFO] [doorpi.sipphone.from_linphone] ms_factory_init_voip() done 2016-03-18 17:36:31,559 [INFO] [doorpi.sipphone.from_linphone] Loading ms plugins from [./lib/mediastreamer/plugins] 2016-03-18 17:36:31,562 [INFO] [doorpi.sipphone.from_linphone] Cannot open directory ./lib/mediastreamer/plugins: No such file or directory 2016-03-18 17:36:31,565 [INFO] [doorpi.sipphone.from_linphone] Initializing LinphoneCore 3.9.1 2016-03-18 17:36:31,568 [INFO] [doorpi.sipphone.from_linphone] Vtable [0x250e0e8] registered on core [0x2418a50] 2016-03-18 17:36:31,571 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_callback_global_state_changed(0x250e0e8, 1, "Starting up") 2016-03-18 17:36:31,574 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_callback_global_state_changed 2016-03-18 17:36:31,577 [INFO] [doorpi.sipphone.from_linphone] Linphone core [0x250e0e8] notifying [global_state_changed] 2016-03-18 17:36:31,580 [INFO] [doorpi.sipphone.from_linphone] oRTP-0.25.0 initialized. 2016-03-18 17:36:31,583 [INFO] [doorpi.sipphone.from_linphone] Skiping ms_base_init, because [2] ref 2016-03-18 17:36:31,586 [INFO] [doorpi.sipphone.from_linphone] Skiping ms_voip_init, because [2] ref 2016-03-18 17:36:31,588 [INFO] [doorpi.sipphone.from_linphone] Skiping ms_plugins_init, because [2] ref 2016-03-18 17:36:31,591 [INFO] [doorpi.sipphone.from_linphone] Codec opus/48000 fmtp=[useinbandfec=1] number=-1, enabled=0) added to default capabilities. 2016-03-18 17:36:31,594 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for SILK 2016-03-18 17:36:31,597 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for SILK 2016-03-18 17:36:31,601 [INFO] [doorpi.sipphone.from_linphone] Codec speex/16000 fmtp=[vbr=on] number=-1, enabled=1) added to default capabilities. 2016-03-18 17:36:31,604 [INFO] [doorpi.sipphone.from_linphone] Codec speex/8000 fmtp=[vbr=on] number=-1, enabled=1) added to default capabilities. 2016-03-18 17:36:31,608 [INFO] [doorpi.sipphone.from_linphone] Codec PCMU/8000 fmtp=[] number=0, enabled=1) added to default capabilities. 2016-03-18 17:36:31,611 [INFO] [doorpi.sipphone.from_linphone] Codec PCMA/8000 fmtp=[] number=8, enabled=1) added to default capabilities. 2016-03-18 17:36:31,613 [INFO] [doorpi.sipphone.from_linphone] Codec t140/1000 fmtp=[] number=96, enabled=1) added to default capabilities. 2016-03-18 17:36:31,616 [INFO] [doorpi.sipphone.from_linphone] Codec red/1000 fmtp=[] number=97, enabled=1) added to default capabilities. 2016-03-18 17:36:31,619 [INFO] [doorpi.sipphone.from_linphone] Codec GSM/8000 fmtp=[] number=3, enabled=0) added to default capabilities. 2016-03-18 17:36:31,622 [INFO] [doorpi.sipphone.from_linphone] Codec G722/8000 fmtp=[] number=9, enabled=0) added to default capabilities. 2016-03-18 17:36:31,625 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for iLBC 2016-03-18 17:36:31,628 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for iLBC 2016-03-18 17:36:31,631 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for AMR 2016-03-18 17:36:31,634 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for AMR 2016-03-18 17:36:31,637 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for AMR-WB 2016-03-18 17:36:31,640 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for AMR-WB 2016-03-18 17:36:31,642 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for G729 2016-03-18 17:36:31,645 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for G729 2016-03-18 17:36:31,648 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for mpeg4-generic 2016-03-18 17:36:31,651 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for mpeg4-generic 2016-03-18 17:36:31,654 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for mpeg4-generic 2016-03-18 17:36:31,658 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for mpeg4-generic 2016-03-18 17:36:31,660 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for mpeg4-generic 2016-03-18 17:36:31,663 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for mpeg4-generic 2016-03-18 17:36:31,666 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for mpeg4-generic 2016-03-18 17:36:31,669 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for mpeg4-generic 2016-03-18 17:36:31,673 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for mpeg4-generic 2016-03-18 17:36:31,677 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for mpeg4-generic 2016-03-18 17:36:31,679 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for iSAC 2016-03-18 17:36:31,682 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for iSAC 2016-03-18 17:36:31,685 [INFO] [doorpi.sipphone.from_linphone] Codec speex/32000 fmtp=[vbr=on] number=-1, enabled=0) added to default capabilities. 2016-03-18 17:36:31,688 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for SILK 2016-03-18 17:36:31,692 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for SILK 2016-03-18 17:36:31,695 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for SILK 2016-03-18 17:36:31,698 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for SILK 2016-03-18 17:36:31,700 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for SILK 2016-03-18 17:36:31,703 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for SILK 2016-03-18 17:36:31,706 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for G726-16 2016-03-18 17:36:31,709 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for G726-16 2016-03-18 17:36:31,712 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for G726-24 2016-03-18 17:36:31,715 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for G726-24 2016-03-18 17:36:31,718 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for G726-32 2016-03-18 17:36:31,721 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for G726-32 2016-03-18 17:36:31,723 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for G726-40 2016-03-18 17:36:31,726 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for G726-40 2016-03-18 17:36:31,729 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for AAL2-G726-16 2016-03-18 17:36:31,732 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for AAL2-G726-16 2016-03-18 17:36:31,735 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for AAL2-G726-24 2016-03-18 17:36:31,738 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for AAL2-G726-24 2016-03-18 17:36:31,741 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for AAL2-G726-32 2016-03-18 17:36:31,744 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for AAL2-G726-32 2016-03-18 17:36:31,747 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for AAL2-G726-40 2016-03-18 17:36:31,749 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for AAL2-G726-40 2016-03-18 17:36:31,752 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for CODEC2 2016-03-18 17:36:31,755 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for CODEC2 2016-03-18 17:36:31,760 [INFO] [doorpi.sipphone.from_linphone] Codec VP8/90000 fmtp=[] number=-1, enabled=1) added to default capabilities. 2016-03-18 17:36:31,763 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for H264 2016-03-18 17:36:31,767 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for H264 2016-03-18 17:36:31,770 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for MP4V-ES 2016-03-18 17:36:31,773 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for H263-1998 2016-03-18 17:36:31,777 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for H263 2016-03-18 17:36:31,779 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for 1016 2016-03-18 17:36:31,782 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for 1016 2016-03-18 17:36:31,785 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for G723 2016-03-18 17:36:31,788 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for G723 2016-03-18 17:36:31,792 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for LPC 2016-03-18 17:36:31,795 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for LPC 2016-03-18 17:36:31,798 [INFO] [doorpi.sipphone.from_linphone] Codec L16/44100 fmtp=[] number=10, enabled=0) added to default capabilities. 2016-03-18 17:36:31,801 [INFO] [doorpi.sipphone.from_linphone] Codec L16/44100 fmtp=[] number=11, enabled=0) added to default capabilities. 2016-03-18 17:36:31,804 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for CN 2016-03-18 17:36:31,807 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for CN 2016-03-18 17:36:31,810 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for G729 2016-03-18 17:36:31,813 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for G729 2016-03-18 17:36:31,816 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for H261 2016-03-18 17:36:31,819 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for H261 2016-03-18 17:36:31,822 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for MPV 2016-03-18 17:36:31,825 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for MPV 2016-03-18 17:36:31,828 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for H263 2016-03-18 17:36:31,831 [INFO] [doorpi.sipphone.from_linphone] Sal nat helper [enabled] 2016-03-18 17:36:31,834 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2016-03-18 17:36:31,837 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2016-03-18 17:36:31,840 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2016-03-18 17:36:31,843 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_callback_configuring_status(0x250e0e8, 2, "(null)") 2016-03-18 17:36:31,846 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_callback_configuring_status 2016-03-18 17:36:31,848 [INFO] [doorpi.sipphone.from_linphone] Linphone core [0x250e0e8] notifying [configuring_status] 2016-03-18 17:36:31,851 [INFO] [doorpi.sipphone.from_linphone] Cannot open directory ./lib/liblinphone/plugins: No such file or directory 2016-03-18 17:36:31,854 [WARNING] [doorpi.sipphone.from_linphone] ./share/sounds/linphone/rings/oldphone.wav does not exist 2016-03-18 17:36:31,857 [INFO] [doorpi.sipphone.from_linphone] linphone_core_set_playback_gain_db(): no active call. 2016-03-18 17:36:31,860 [INFO] [doorpi.sipphone.from_linphone] linphone_core_set_mic_gain_db(): no active call. 2016-03-18 17:36:31,863 [INFO] [doorpi.sipphone.from_linphone] MTU is supposed to be 1300, rtp payload max size will be 1240 2016-03-18 17:36:31,866 [INFO] [doorpi.sipphone.from_linphone] Sal nat helper [enabled] 2016-03-18 17:36:31,870 [INFO] [doorpi.sipphone.from_linphone] Sal use rport [enabled] 2016-03-18 17:36:31,873 [INFO] [doorpi.sipphone.from_linphone] Supported codec opus/48000 fmtp=useinbandfec=1 automatically added to codec list. 2016-03-18 17:36:31,876 [INFO] [doorpi.sipphone.from_linphone] Supported codec speex/16000 fmtp=vbr=on automatically added to codec list. 2016-03-18 17:36:31,879 [INFO] [doorpi.sipphone.from_linphone] Supported codec speex/8000 fmtp=vbr=on automatically added to codec list. 2016-03-18 17:36:31,882 [INFO] [doorpi.sipphone.from_linphone] Supported codec PCMU/8000 fmtp= automatically added to codec list. 2016-03-18 17:36:31,884 [INFO] [doorpi.sipphone.from_linphone] Supported codec PCMA/8000 fmtp= automatically added to codec list. 2016-03-18 17:36:31,888 [INFO] [doorpi.sipphone.from_linphone] Supported codec GSM/8000 fmtp= automatically added to codec list. 2016-03-18 17:36:31,890 [INFO] [doorpi.sipphone.from_linphone] Supported codec G722/8000 fmtp= automatically added to codec list. 2016-03-18 17:36:31,893 [INFO] [doorpi.sipphone.from_linphone] Supported codec speex/32000 fmtp=vbr=on automatically added to codec list. 2016-03-18 17:36:31,896 [INFO] [doorpi.sipphone.from_linphone] Supported codec L16/44100 fmtp= automatically added to codec list. 2016-03-18 17:36:31,900 [INFO] [doorpi.sipphone.from_linphone] Supported codec L16/44100 fmtp= automatically added to codec list. 2016-03-18 17:36:31,903 [INFO] [doorpi.sipphone.from_linphone] Supported codec VP8/90000 fmtp= automatically added to codec list. 2016-03-18 17:36:31,906 [INFO] [doorpi.sipphone.from_linphone] Supported codec t140/1000 fmtp= automatically added to codec list. 2016-03-18 17:36:31,909 [INFO] [doorpi.sipphone.from_linphone] Supported codec red/1000 fmtp= automatically added to codec list. 2016-03-18 17:36:31,911 [INFO] [doorpi.sipphone.from_linphone] Sal use rport [enabled] 2016-03-18 17:36:31,914 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2016-03-18 17:36:31,917 [INFO] [doorpi.sipphone.from_linphone] sal_unlisten_ports done 2016-03-18 17:36:31,921 [INFO] [doorpi.sipphone.from_linphone] Creating listening point [0x250e8a0] on [sip:0.0.0.0:5060;transport=UDP] 2016-03-18 17:36:31,924 [INFO] [doorpi.sipphone.from_linphone] Creating listening point [0x250ea18] on [sip:0.0.0.0:5060;transport=TCP] 2016-03-18 17:36:31,928 [INFO] [doorpi.sipphone.from_linphone] Creating listening point [0x2504de0] on [sip:0.0.0.0:-1;transport=TLS] 2016-03-18 17:36:31,932 [INFO] [doorpi.sipphone.from_linphone] Random TCP port is 51967 2016-03-18 17:36:31,935 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2016-03-18 17:36:31,938 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2016-03-18 17:36:31,947 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_callback_global_state_changed(0x250e0e8, 2, "Ready") 2016-03-18 17:36:31,950 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_callback_global_state_changed 2016-03-18 17:36:31,953 [INFO] [doorpi.sipphone.from_linphone] Linphone core [0x250e0e8] notifying [global_state_changed] 2016-03-18 17:36:31,956 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_class_method_new -> 0x2469920 2016-03-18 17:36:31,959 [TRACE] [doorpi.conf.config_object] get_string for key identity in section SIP-Phone (default: DoorPi) returns DoorPi 2016-03-18 17:36:31,962 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_primary_contact(0x2469920 [0x250e0e8], "DoorPi ") 2016-03-18 17:36:31,966 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_primary_contact -> 0 2016-03-18 17:36:31,969 [TRACE] [doorpi.action.handler] fire Event OnSipPhoneCreate from doorpi.sipphone.from_linphone asyncron 2016-03-18 17:36:31,974 [TRACE] [doorpi.conf.config_object] get_integer for key ua.max_calls in section SIP-Phone (default: 2) returns 2 2016-03-18 17:36:31,977 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_max_calls(0x2469920 [0x250e0e8], 2) 2016-03-18 17:36:31,982 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_max_calls -> 0 2016-03-18 17:36:31,985 [TRACE] [doorpi.conf.config_object] get_boolean for key echo_cancellation_enabled in section SIP-Phone (default: False) returns False 2016-03-18 17:36:31,981 [DEBUG] [doorpi.action.handler] no actions for event OnSipPhoneCreate - skip fire_event OnSipPhoneCreate from doorpi.sipphone.from_linphone 2016-03-18 17:36:31,991 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_enable_echo_cancellation(0x2469920 [0x250e0e8], 0x27c694 [0]) 2016-03-18 17:36:31,994 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_enable_echo_cancellation -> 0 2016-03-18 17:36:31,997 [TRACE] [doorpi.conf.config_object] get_integer for key local_port in section SIP-Phone (default: 5060) returns 5060 2016-03-18 17:36:32,000 [TRACE] [doorpi.conf.config_object] get_integer for key local_port in section SIP-Phone (default: 5060) returns 5060 2016-03-18 17:36:32,003 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_SipTransports_new() 2016-03-18 17:36:32,006 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_SipTransports_new -> 0x2469938 2016-03-18 17:36:32,009 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_sip_transports(0x2469920 [0x250e0e8], 0x2469938 [0x2469940]) 2016-03-18 17:36:32,012 [INFO] [doorpi.sipphone.from_linphone] Listening point [0x250e8a0] on [sip:0.0.0.0:5060;transport=UDP] destroyed 2016-03-18 17:36:32,015 [INFO] [doorpi.sipphone.from_linphone] Listening point [0x250ea18] on [sip:0.0.0.0:5060;transport=TCP] destroyed 2016-03-18 17:36:32,019 [INFO] [doorpi.sipphone.from_linphone] Listening point [0x2504de0] on [sip:0.0.0.0:51967;transport=TLS] destroyed 2016-03-18 17:36:32,021 [INFO] [doorpi.sipphone.from_linphone] sal_unlisten_ports done 2016-03-18 17:36:32,025 [INFO] [doorpi.sipphone.from_linphone] Creating listening point [0x250a318] on [sip:0.0.0.0:5060;transport=UDP] 2016-03-18 17:36:32,028 [INFO] [doorpi.sipphone.from_linphone] Creating listening point [0x250c128] on [sip:0.0.0.0:5060;transport=TCP] 2016-03-18 17:36:32,032 [INFO] [doorpi.sipphone.from_linphone] Creating listening point [0x2509918] on [sip:0.0.0.0:-1;transport=TLS] 2016-03-18 17:36:32,036 [INFO] [doorpi.sipphone.from_linphone] Random TCP port is 39458 2016-03-18 17:36:32,039 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2016-03-18 17:36:32,042 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2016-03-18 17:36:32,044 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_sip_transports -> 0 2016-03-18 17:36:32,048 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_SipTransports_dealloc(0x2469938) 2016-03-18 17:36:32,050 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_SipTransports_dealloc 2016-03-18 17:36:32,053 [TRACE] [doorpi.conf.config_object] get_boolean for key video_display_enabled in section SIP-Phone (default: False) returns False 2016-03-18 17:36:32,056 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_enable_video_display(0x2469920 [0x250e0e8], 0x27c694 [0]) 2016-03-18 17:36:32,059 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_enable_video_display -> 0 2016-03-18 17:36:32,062 [TRACE] [doorpi.conf.config_object] get_string for key stun_server in section SIP-Phone (default: ) returns 2016-03-18 17:36:32,065 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_stun_server(0x2469920 [0x250e0e8], "") 2016-03-18 17:36:32,069 [INFO] [doorpi.sipphone.from_linphone] Resolver is using DNS server(s): 2016-03-18 17:36:32,072 [INFO] [doorpi.sipphone.from_linphone] 192.168.1.1 2016-03-18 17:36:32,077 [INFO] [doorpi.sipphone.from_linphone] resolver_process_data dns_res_check() in progress 2016-03-18 17:36:32,080 [INFO] [doorpi.sipphone.from_linphone] DNS resolution awaiting response, queued to main loop 2016-03-18 17:36:32,083 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_stun_server -> 0 2016-03-18 17:36:32,086 [DEBUG] [doorpi.conf.config_object] create new key FirewallPolicy in section SIP-Phone with value 'PolicyNoFirewall' 2016-03-18 17:36:32,089 [TRACE] [doorpi.conf.config_object] get_string for key FirewallPolicy in section SIP-Phone (default: PolicyNoFirewall) returns PolicyNoFirewall 2016-03-18 17:36:32,092 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_firewall_policy(0x2469920 [0x250e0e8], 0) 2016-03-18 17:36:32,095 [INFO] [doorpi.sipphone.from_linphone] Sal nat helper [enabled] 2016-03-18 17:36:32,098 [INFO] [doorpi.sipphone.from_linphone] Sal use rport [enabled] 2016-03-18 17:36:32,103 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_firewall_policy -> 0 2016-03-18 17:36:32,107 [TRACE] [doorpi.conf.config_object] get_integer for key max_call_time in section SIP-Phone (default: 120) returns 120 2016-03-18 17:36:32,110 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_in_call_timeout(0x2469920 [0x250e0e8], 120) 2016-03-18 17:36:32,113 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_in_call_timeout -> 0 2016-03-18 17:36:32,116 [TRACE] [doorpi.conf.config_object] get_integer for key call_timeout in section SIP-Phone (default: 15) returns 15 2016-03-18 17:36:32,119 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_inc_timeout(0x2469920 [0x250e0e8], 15) 2016-03-18 17:36:32,122 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_inc_timeout -> 0 2016-03-18 17:36:32,126 [TRACE] [doorpi.conf.config_object] get_string for key dialtone in section SIP-Phone (default: !BASEPATH!/media/ShortDialTone.wav) returns !BASEPATH!/media/ShortDialTone.wav 2016-03-18 17:36:32,130 [DEBUG] [doorpi.conf.config_object] parse string "!BASEPATH!/media/ShortDialTone.wav" to "/usr/local/etc/DoorPi/media/ShortDialTone.wav" 2016-03-18 17:36:32,133 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to event OnSipPhoneDestroy 2016-03-18 17:36:32,139 [TRACE] [doorpi.conf.config_object] get_boolean for key dialtone_renew_every_start in section SIP-Phone (default: False) returns False 2016-03-18 17:36:32,142 [TRACE] [doorpi.action.handler] register Event OnPlayerStarted from doorpi.sipphone.linphone_lib.Player 2016-03-18 17:36:32,144 [DEBUG] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.Player was added 2016-03-18 17:36:32,147 [TRACE] [doorpi.action.handler] added event_name OnPlayerStarted and registered source doorpi.sipphone.linphone_lib.Player 2016-03-18 17:36:32,150 [TRACE] [doorpi.action.handler] register Event OnPlayerStopped from doorpi.sipphone.linphone_lib.Player 2016-03-18 17:36:32,152 [TRACE] [doorpi.action.handler] added event_name OnPlayerStopped and registered source doorpi.sipphone.linphone_lib.Player 2016-03-18 17:36:32,155 [TRACE] [doorpi.action.handler] register Event OnPlayerCreated from doorpi.sipphone.linphone_lib.Player 2016-03-18 17:36:32,159 [TRACE] [doorpi.action.handler] added event_source doorpi.sipphone.linphone_lib.Player to existing event OnPlayerCreated 2016-03-18 17:36:32,162 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to new evententry OnSipPhoneMakeCall 2016-03-18 17:36:32,165 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to new evententry OnCallStateConnect 2016-03-18 17:36:32,168 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to new evententry OnCallStateDisconnect 2016-03-18 17:36:32,172 [TRACE] [doorpi.action.handler] fire Event OnPlayerCreated from doorpi.sipphone.linphone_lib.Player asyncron 2016-03-18 17:36:32,177 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_ringback(0x2469920 [0x250e0e8], "/usr/local/etc/DoorPi/media/ShortDialTone.wav") 2016-03-18 17:36:32,180 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_ringback -> 0 2016-03-18 17:36:32,185 [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 2016-03-18 17:36:32,188 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to event OnSipPhoneDestroy 2016-03-18 17:36:32,183 [DEBUG] [doorpi.action.handler] no actions for event OnPlayerCreated - skip fire_event OnPlayerCreated from doorpi.sipphone.linphone_lib.Player 2016-03-18 17:36:32,194 [TRACE] [doorpi.action.handler] register Event OnRecorderStarted from doorpi.sipphone.linphone_lib.Recorder 2016-03-18 17:36:32,197 [DEBUG] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.Recorder was added 2016-03-18 17:36:32,199 [TRACE] [doorpi.action.handler] added event_name OnRecorderStarted and registered source doorpi.sipphone.linphone_lib.Recorder 2016-03-18 17:36:32,202 [TRACE] [doorpi.action.handler] register Event OnRecorderStopped from doorpi.sipphone.linphone_lib.Recorder 2016-03-18 17:36:32,205 [TRACE] [doorpi.action.handler] added event_name OnRecorderStopped and registered source doorpi.sipphone.linphone_lib.Recorder 2016-03-18 17:36:32,208 [TRACE] [doorpi.action.handler] register Event OnRecorderCreated from doorpi.sipphone.linphone_lib.Recorder 2016-03-18 17:36:32,210 [TRACE] [doorpi.action.handler] added event_name OnRecorderCreated and registered source doorpi.sipphone.linphone_lib.Recorder 2016-03-18 17:36:32,213 [TRACE] [doorpi.conf.config_object] get_boolean for key record_while_dialing in section SIP-Phone (default: False) returns False 2016-03-18 17:36:32,216 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to event OnCallStateConnect 2016-03-18 17:36:32,219 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to event OnCallStateDisconnect 2016-03-18 17:36:32,222 [TRACE] [doorpi.action.handler] fire Event OnRecorderCreated from doorpi.sipphone.linphone_lib.Recorder asyncron 2016-03-18 17:36:32,227 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_sound_devices(0x2469920 [0x250e0e8]) 2016-03-18 17:36:32,230 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_sound_devices -> 0x24b6d50 2016-03-18 17:36:32,236 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_capture_device(0x2469920 [0x250e0e8]) 2016-03-18 17:36:32,238 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_capture_device -> 0x24b57d0 2016-03-18 17:36:32,234 [DEBUG] [doorpi.action.handler] no actions for event OnRecorderCreated - skip fire_event OnRecorderCreated from doorpi.sipphone.linphone_lib.Recorder 2016-03-18 17:36:32,244 [TRACE] [doorpi.conf.config_object] get_string for key capture_device in section SIP-Phone (default: ALSA: default device) returns ALSA: default device 2016-03-18 17:36:32,247 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_capture_device(0x2469920 [0x250e0e8], "ALSA: default device") 2016-03-18 17:36:32,250 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_capture_device -> 0 2016-03-18 17:36:32,253 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_playback_device(0x2469920 [0x250e0e8]) 2016-03-18 17:36:32,257 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_playback_device -> 0x24b5800 2016-03-18 17:36:32,260 [TRACE] [doorpi.conf.config_object] get_string for key playback_device in section SIP-Phone (default: ALSA: default device) returns ALSA: default device 2016-03-18 17:36:32,263 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_playback_device(0x2469920 [0x250e0e8], "ALSA: default device") 2016-03-18 17:36:32,266 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_playback_device -> 0 2016-03-18 17:36:32,269 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_sound_devices(0x2469920 [0x250e0e8]) 2016-03-18 17:36:32,273 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_sound_devices -> 0x24b6c38 2016-03-18 17:36:32,276 [INFO] [doorpi.sipphone.from_linphone] found 3 possible sounddevices: 2016-03-18 17:36:32,279 [DEBUG] [doorpi.sipphone.from_linphone] |rec|play| name 2016-03-18 17:36:32,282 [DEBUG] [doorpi.sipphone.from_linphone] ------------------------------------ 2016-03-18 17:36:32,284 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_sound_devices(0x2469920 [0x250e0e8]) 2016-03-18 17:36:32,287 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_sound_devices -> 0x24b6c38 2016-03-18 17:36:32,290 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_sound_device_can_capture(0x2469920 [0x250e0e8], "ALSA: default device") 2016-03-18 17:36:32,293 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_sound_device_can_capture -> 0x27c6a0 2016-03-18 17:36:32,297 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_sound_device_can_playback(0x2469920 [0x250e0e8], "ALSA: default device") 2016-03-18 17:36:32,300 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_sound_device_can_playback -> 0x27c6a0 2016-03-18 17:36:32,303 [DEBUG] [doorpi.sipphone.from_linphone] | X | X | ALSA: default device 2016-03-18 17:36:32,306 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_sound_device_can_capture(0x2469920 [0x250e0e8], "ALSA: bcm2835 ALSA") 2016-03-18 17:36:32,308 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_sound_device_can_capture -> 0x27c694 2016-03-18 17:36:32,311 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_sound_device_can_playback(0x2469920 [0x250e0e8], "ALSA: bcm2835 ALSA") 2016-03-18 17:36:32,314 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_sound_device_can_playback -> 0x27c6a0 2016-03-18 17:36:32,317 [DEBUG] [doorpi.sipphone.from_linphone] | O | X | ALSA: bcm2835 ALSA 2016-03-18 17:36:32,320 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_sound_device_can_capture(0x2469920 [0x250e0e8], "ALSA: USB PnP Sound Device") 2016-03-18 17:36:32,323 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_sound_device_can_capture -> 0x27c6a0 2016-03-18 17:36:32,327 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_sound_device_can_playback(0x2469920 [0x250e0e8], "ALSA: USB PnP Sound Device") 2016-03-18 17:36:32,329 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_sound_device_can_playback -> 0x27c6a0 2016-03-18 17:36:32,332 [DEBUG] [doorpi.sipphone.from_linphone] | X | X | ALSA: USB PnP Sound Device 2016-03-18 17:36:32,335 [DEBUG] [doorpi.sipphone.from_linphone] ------------------------------------ 2016-03-18 17:36:32,338 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_capture_device(0x2469920 [0x250e0e8]) 2016-03-18 17:36:32,341 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_capture_device -> 0x24b5860 2016-03-18 17:36:32,343 [DEBUG] [doorpi.sipphone.from_linphone] using capture_device: ALSA: default device 2016-03-18 17:36:32,348 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_playback_device(0x2469920 [0x250e0e8]) 2016-03-18 17:36:32,351 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_playback_device -> 0x24b5890 2016-03-18 17:36:32,353 [DEBUG] [doorpi.sipphone.from_linphone] using playback_device: ALSA: default device 2016-03-18 17:36:32,357 [TRACE] [doorpi.conf.config_object] get_list for key audio_codecs in section SIP-Phone (default: PCMA,PCMU) returns ['PCMA', 'PCMU'] 2016-03-18 17:36:32,360 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_audio_codecs(0x2469920 [0x250e0e8]) 2016-03-18 17:36:32,363 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0x250eba0) 2016-03-18 17:36:32,366 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2016-03-18 17:36:32,369 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0xb6d003d0 2016-03-18 17:36:32,371 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2016-03-18 17:36:32,375 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0xb6d003d0 2016-03-18 17:36:32,377 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0xb6d003d0 2016-03-18 17:36:32,380 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0x250ec10) 2016-03-18 17:36:32,383 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2016-03-18 17:36:32,386 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0xb6d00370 2016-03-18 17:36:32,388 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2016-03-18 17:36:32,391 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0xb6d00370 2016-03-18 17:36:32,394 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0xb6d00370 2016-03-18 17:36:32,397 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0x250d7b0) 2016-03-18 17:36:32,399 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2016-03-18 17:36:32,402 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0xb6d003f0 2016-03-18 17:36:32,405 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2016-03-18 17:36:32,407 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0xb6d003f0 2016-03-18 17:36:32,410 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0xb6d003f0 2016-03-18 17:36:32,413 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0x250d818) 2016-03-18 17:36:32,416 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2016-03-18 17:36:32,419 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0xb6d00400 2016-03-18 17:36:32,421 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2016-03-18 17:36:32,424 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0xb6d00400 2016-03-18 17:36:32,428 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0xb6d00400 2016-03-18 17:36:32,430 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0x250d870) 2016-03-18 17:36:32,433 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2016-03-18 17:36:32,436 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0xb6d00420 2016-03-18 17:36:32,439 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2016-03-18 17:36:32,441 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0xb6d00420 2016-03-18 17:36:32,444 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0xb6d00420 2016-03-18 17:36:32,447 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0x250d8c8) 2016-03-18 17:36:32,450 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2016-03-18 17:36:32,453 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0xb6d00440 2016-03-18 17:36:32,456 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2016-03-18 17:36:32,458 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0xb6d00440 2016-03-18 17:36:32,461 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0xb6d00440 2016-03-18 17:36:32,464 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0x240e070) 2016-03-18 17:36:32,467 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2016-03-18 17:36:32,471 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0xb6d00450 2016-03-18 17:36:32,473 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2016-03-18 17:36:32,477 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0xb6d00450 2016-03-18 17:36:32,480 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0xb6d00450 2016-03-18 17:36:32,482 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0x240e0c8) 2016-03-18 17:36:32,485 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2016-03-18 17:36:32,488 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0xb6d00460 2016-03-18 17:36:32,491 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2016-03-18 17:36:32,493 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0xb6d00460 2016-03-18 17:36:32,496 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0xb6d00460 2016-03-18 17:36:32,499 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0x240e130) 2016-03-18 17:36:32,502 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2016-03-18 17:36:32,504 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0xb6d00410 2016-03-18 17:36:32,508 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2016-03-18 17:36:32,511 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0xb6d00410 2016-03-18 17:36:32,514 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0xb6d00410 2016-03-18 17:36:32,517 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0x240e188) 2016-03-18 17:36:32,519 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2016-03-18 17:36:32,522 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0xb6d00470 2016-03-18 17:36:32,525 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2016-03-18 17:36:32,528 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0xb6d00470 2016-03-18 17:36:32,531 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0xb6d00470 2016-03-18 17:36:32,534 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_audio_codecs -> 0x24b6d78 2016-03-18 17:36:32,536 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0xb6d003d0 [0x250eba0]) 2016-03-18 17:36:32,539 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x2489e00 2016-03-18 17:36:32,542 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0xb6d003d0 [0x250eba0]) 2016-03-18 17:36:32,545 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x2489e00 2016-03-18 17:36:32,548 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec opus 2016-03-18 17:36:32,551 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x2469920 [0x250e0e8], 0xb6d003d0 [0x250eba0], 0x27c694 [0]) 2016-03-18 17:36:32,554 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x20ec0bc 2016-03-18 17:36:32,558 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0xb6d00370 [0x250ec10]) 2016-03-18 17:36:32,560 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x2489de0 2016-03-18 17:36:32,563 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0xb6d00370 [0x250ec10]) 2016-03-18 17:36:32,566 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x2489de0 2016-03-18 17:36:32,569 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec speex 2016-03-18 17:36:32,571 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x2469920 [0x250e0e8], 0xb6d00370 [0x250ec10], 0x27c694 [0]) 2016-03-18 17:36:32,575 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x20ec0bc 2016-03-18 17:36:32,577 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0xb6d003f0 [0x250d7b0]) 2016-03-18 17:36:32,581 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x2489e00 2016-03-18 17:36:32,584 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0xb6d003f0 [0x250d7b0]) 2016-03-18 17:36:32,586 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x2489e00 2016-03-18 17:36:32,589 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec speex 2016-03-18 17:36:32,592 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x2469920 [0x250e0e8], 0xb6d003f0 [0x250d7b0], 0x27c694 [0]) 2016-03-18 17:36:32,595 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x20ec0bc 2016-03-18 17:36:32,598 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0xb6d00400 [0x250d818]) 2016-03-18 17:36:32,601 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x2489de0 2016-03-18 17:36:32,604 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0xb6d00400 [0x250d818]) 2016-03-18 17:36:32,606 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x2489de0 2016-03-18 17:36:32,609 [DEBUG] [doorpi.sipphone.from_linphone] enable audio codec PCMU 2016-03-18 17:36:32,612 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x2469920 [0x250e0e8], 0xb6d00400 [0x250d818], 0x27c6a0 [1]) 2016-03-18 17:36:32,615 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x20ec0bc 2016-03-18 17:36:32,618 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0xb6d00420 [0x250d870]) 2016-03-18 17:36:32,621 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x2489e00 2016-03-18 17:36:32,623 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0xb6d00420 [0x250d870]) 2016-03-18 17:36:32,626 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x2489e00 2016-03-18 17:36:32,629 [DEBUG] [doorpi.sipphone.from_linphone] enable audio codec PCMA 2016-03-18 17:36:32,631 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x2469920 [0x250e0e8], 0xb6d00420 [0x250d870], 0x27c6a0 [1]) 2016-03-18 17:36:32,634 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x20ec0bc 2016-03-18 17:36:32,637 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0xb6d00440 [0x250d8c8]) 2016-03-18 17:36:32,640 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x2469938 2016-03-18 17:36:32,643 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0xb6d00440 [0x250d8c8]) 2016-03-18 17:36:32,646 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x2469938 2016-03-18 17:36:32,648 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec GSM 2016-03-18 17:36:32,652 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x2469920 [0x250e0e8], 0xb6d00440 [0x250d8c8], 0x27c694 [0]) 2016-03-18 17:36:32,655 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x20ec0bc 2016-03-18 17:36:32,658 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0xb6d00450 [0x240e070]) 2016-03-18 17:36:32,660 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x2489e00 2016-03-18 17:36:32,663 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0xb6d00450 [0x240e070]) 2016-03-18 17:36:32,666 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x2489e00 2016-03-18 17:36:32,668 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec G722 2016-03-18 17:36:32,671 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x2469920 [0x250e0e8], 0xb6d00450 [0x240e070], 0x27c694 [0]) 2016-03-18 17:36:32,674 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x20ec0bc 2016-03-18 17:36:32,677 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0xb6d00460 [0x240e0c8]) 2016-03-18 17:36:32,680 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x2489de0 2016-03-18 17:36:32,684 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0xb6d00460 [0x240e0c8]) 2016-03-18 17:36:32,686 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x2489de0 2016-03-18 17:36:32,689 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec speex 2016-03-18 17:36:32,692 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x2469920 [0x250e0e8], 0xb6d00460 [0x240e0c8], 0x27c694 [0]) 2016-03-18 17:36:32,695 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x20ec0bc 2016-03-18 17:36:32,698 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0xb6d00410 [0x240e130]) 2016-03-18 17:36:32,701 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x2469938 2016-03-18 17:36:32,703 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0xb6d00410 [0x240e130]) 2016-03-18 17:36:32,706 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x2469938 2016-03-18 17:36:32,709 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec L16 2016-03-18 17:36:32,711 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x2469920 [0x250e0e8], 0xb6d00410 [0x240e130], 0x27c694 [0]) 2016-03-18 17:36:32,714 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x20ec0bc 2016-03-18 17:36:32,717 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0xb6d00470 [0x240e188]) 2016-03-18 17:36:32,720 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x2469938 2016-03-18 17:36:32,723 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0xb6d00470 [0x240e188]) 2016-03-18 17:36:32,726 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x2469938 2016-03-18 17:36:32,728 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec L16 2016-03-18 17:36:32,732 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x2469920 [0x250e0e8], 0xb6d00470 [0x240e188], 0x27c694 [0]) 2016-03-18 17:36:32,735 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x20ec0bc 2016-03-18 17:36:32,738 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_video_devices(0x2469920 [0x250e0e8]) 2016-03-18 17:36:32,740 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_video_devices -> 0x24b6d50 2016-03-18 17:36:32,743 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_video_devices(0x2469920 [0x250e0e8]) 2016-03-18 17:36:32,746 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_video_devices -> 0x24b6d50 2016-03-18 17:36:32,749 [INFO] [doorpi.sipphone.from_linphone] found 1 possible videodevices: 2016-03-18 17:36:32,752 [DEBUG] [doorpi.sipphone.from_linphone] | name 2016-03-18 17:36:32,754 [DEBUG] [doorpi.sipphone.from_linphone] ------------------------------------ 2016-03-18 17:36:32,757 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_video_devices(0x2469920 [0x250e0e8]) 2016-03-18 17:36:32,760 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_video_devices -> 0x24b6d50 2016-03-18 17:36:32,762 [DEBUG] [doorpi.sipphone.from_linphone] | StaticImage: Static picture 2016-03-18 17:36:32,765 [DEBUG] [doorpi.sipphone.from_linphone] ------------------------------------ 2016-03-18 17:36:32,769 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_video_devices(0x2469920 [0x250e0e8]) 2016-03-18 17:36:32,772 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_video_devices -> 0x24b6d50 2016-03-18 17:36:32,775 [TRACE] [doorpi.conf.config_object] get_string for key video_device in section SIP-Phone (default: StaticImage: Static picture) returns StaticImage: Static picture 2016-03-18 17:36:32,778 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_video_devices(0x2469920 [0x250e0e8]) 2016-03-18 17:36:32,781 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_video_devices -> 0x24b6d50 2016-03-18 17:36:32,783 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_enable_video_capture(0x2469920 [0x250e0e8], 0x27c6a0 [1]) 2016-03-18 17:36:32,788 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_enable_video_capture -> 0 2016-03-18 17:36:32,790 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_video_device(0x2469920 [0x250e0e8], "StaticImage: Static picture") 2016-03-18 17:36:32,794 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_video_device -> 0 2016-03-18 17:36:32,797 [TRACE] [doorpi.conf.config_object] get_string for key video_size in section SIP-Phone (default: vga) returns vga 2016-03-18 17:36:32,799 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_preferred_video_size_by_name(0x2469920 [0x250e0e8], "vga") 2016-03-18 17:36:32,803 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_preferred_video_size_by_name -> 0 2016-03-18 17:36:32,806 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_video_device(0x2469920 [0x250e0e8]) 2016-03-18 17:36:32,808 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_video_device -> 0x24b5980 2016-03-18 17:36:32,811 [DEBUG] [doorpi.sipphone.from_linphone] using video_device: StaticImage: Static picture 2016-03-18 17:36:32,814 [TRACE] [doorpi.conf.config_object] get_list for key video_codecs in section SIP-Phone (default: VP8) returns ['VP8'] 2016-03-18 17:36:32,817 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_video_codecs(0x2469920 [0x250e0e8]) 2016-03-18 17:36:32,819 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0x250eb00) 2016-03-18 17:36:32,822 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2016-03-18 17:36:32,826 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0xb6d00430 2016-03-18 17:36:32,828 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2016-03-18 17:36:32,831 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0xb6d00430 2016-03-18 17:36:32,834 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0xb6d00430 2016-03-18 17:36:32,837 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_video_codecs -> 0x24b6e18 2016-03-18 17:36:32,839 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0xb6d00430 [0x250eb00]) 2016-03-18 17:36:32,843 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x2469938 2016-03-18 17:36:32,846 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_video_capture_enabled(0x2469920 [0x250e0e8]) 2016-03-18 17:36:32,848 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_video_capture_enabled -> 0x27c6a0 2016-03-18 17:36:32,852 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0xb6d00430 [0x250eb00]) 2016-03-18 17:36:32,854 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x2469938 2016-03-18 17:36:32,857 [DEBUG] [doorpi.sipphone.from_linphone] enable video codec VP8 2016-03-18 17:36:32,860 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x2469920 [0x250e0e8], 0xb6d00430 [0x250eb00], 0x27c6a0 [1]) 2016-03-18 17:36:32,864 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x20ec0bc 2016-03-18 17:36:32,866 [TRACE] [doorpi.conf.config_object] get_string for key sipserver_server in section SIP-Phone (default: ) returns 2016-03-18 17:36:32,869 [TRACE] [doorpi.conf.config_object] get_string for key sipserver_username in section SIP-Phone (default: ) returns 2016-03-18 17:36:32,872 [TRACE] [doorpi.conf.config_object] get_string for key sipserver_password in section SIP-Phone (default: ) returns ******* 2016-03-18 17:36:32,874 [TRACE] [doorpi.conf.config_object] get_string for key sipserver_realm in section SIP-Phone (default: ) returns 2016-03-18 17:36:32,877 [INFO] [doorpi.sipphone.from_linphone] using DoorPi without SIP-Server? Okay... 2016-03-18 17:36:32,880 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_create_proxy_config(0x2469920 [0x250e0e8]) 2016-03-18 17:36:32,883 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_ProxyConfig_from_native_ptr(0x25372e0) 2016-03-18 17:36:32,886 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_ProxyConfig_new() 2016-03-18 17:36:32,889 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_ProxyConfig_new -> 0xb6d00480 2016-03-18 17:36:32,893 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_ProxyConfig_init() 2016-03-18 17:36:32,896 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_ProxyConfig_init -> 0xb6d00480 2016-03-18 17:36:32,899 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_ProxyConfig_from_native_ptr -> 0xb6d00480 2016-03-18 17:36:32,902 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_create_proxy_config -> 0xb6d00480 2016-03-18 17:36:32,905 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_ProxyConfig_enable_register(0xb6d00480 [0x25372e0], 0x27c694 [0]) 2016-03-18 17:36:32,907 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_ProxyConfig_enable_register -> 0 2016-03-18 17:36:32,910 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_add_proxy_config(0x2469920 [0x250e0e8], 0xb6d00480 [0x25372e0]) 2016-03-18 17:36:32,913 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_add_proxy_config -> 0x20ec0c8 2016-03-18 17:36:32,916 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_default_proxy_config(0x2469920 [0x250e0e8], 0xb6d00480 [0x25372e0]) 2016-03-18 17:36:32,918 [WARNING] [doorpi.sipphone.from_linphone] Bad proxy address: it is not in the list ! 2016-03-18 17:36:32,922 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_default_proxy_config -> 0 2016-03-18 17:36:32,925 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_proxy_config_list(0x2469920 [0x250e0e8]) 2016-03-18 17:36:32,927 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_proxy_config_list -> 0x24b6dc8 2016-03-18 17:36:32,930 [DEBUG] [doorpi.sipphone.from_linphone] [] 2016-03-18 17:36:32,933 [DEBUG] [doorpi.sipphone.from_linphone] start successfully 2016-03-18 17:36:32,936 [TRACE] [doorpi.conf.config_object] get_sections returns ['EVENT_OnStartup'] 2016-03-18 17:36:32,938 [INFO] [doorpi.doorpi] found EVENT_ section 'EVENT_OnStartup' in configfile 2016-03-18 17:36:32,941 [TRACE] [doorpi.conf.config_object] get_keys for section EVENT_OnStartup returns ['10'] 2016-03-18 17:36:32,944 [INFO] [doorpi.doorpi] registering action '10' for event 'OnStartup' 2016-03-18 17:36:32,946 [TRACE] [doorpi.conf.config_object] get_string for key 10 in section EVENT_OnStartup (default: ) returns sleep:1 2016-03-18 17:36:32,951 [DEBUG] [doorpi.action.SingleActions.sleep] doorpi.action.SingleActions.sleep loaded 2016-03-18 17:36:32,955 [TRACE] [doorpi.action.handler] action SleepAction with args (1.0,) and kwargs {} was added to new evententry OnStartup 2016-03-18 17:36:32,958 [WARNING] [root] section dummy_InputPins not found in configfile 2016-03-18 17:36:32,961 [WARNING] [root] section DTMF not found in configfile 2016-03-18 17:36:32,964 [TRACE] [doorpi.conf.config_object] get_keys for section DTMF returns [] 2016-03-18 17:36:32,967 [TRACE] [doorpi.conf.config_object] get_string for key is_alive_led in section DoorPi (default: ) returns 2016-03-18 17:36:32,970 [TRACE] [doorpi.action.handler] fire Event BeforeStartup from doorpi.doorpi asyncron 2016-03-18 17:36:32,976 [DEBUG] [doorpi.action.handler] [MKAP85] fire for event OnStartup this actions [] 2016-03-18 17:36:32,981 [TRACE] [doorpi.action.handler] [MKAP85] try to fire action SleepAction with args (1.0,) and kwargs {} 2016-03-18 17:36:32,984 [TRACE] [doorpi.action.base] run SleepAction with args (1.0,) and kwargs {} 2016-03-18 17:36:32,980 [DEBUG] [doorpi.action.handler] no actions for event BeforeStartup - skip fire_event BeforeStartup from doorpi.doorpi 2016-03-18 17:36:33,992 [TRACE] [doorpi.action.handler] [MKAP85] finished fire_event for event_name OnStartup 2016-03-18 17:36:33,994 [TRACE] [doorpi.action.handler] fire Event AfterStartup from doorpi.doorpi asyncron 2016-03-18 17:36:33,999 [INFO] [doorpi.doorpi] DoorPi started successfully 2016-03-18 17:36:34,001 [INFO] [doorpi.doorpi] BasePath is /usr/local/etc/DoorPi 2016-03-18 17:36:34,007 [INFO] [doorpi.doorpi] Weburl is http://tuer/ 2016-03-18 17:36:34,011 [INFO] [doorpi.sipphone.from_linphone] resolved to 192.168.1.1 2016-03-18 17:36:34,005 [DEBUG] [doorpi.action.handler] no actions for event AfterStartup - skip fire_event AfterStartup from doorpi.doorpi 2016-03-18 17:36:34,016 [INFO] [doorpi.sipphone.from_linphone] Stun server resolution successful. 2016-03-18 17:36:34,020 [INFO] [doorpi.sipphone.from_linphone] New local ip address is 192.168.1.174 2016-03-18 17:36:34,023 [INFO] [doorpi.sipphone.from_linphone] Network state is now [UP] 2016-03-18 17:36:34,027 [INFO] [doorpi.sipphone.from_linphone] Resolver is using DNS server(s): 2016-03-18 17:36:34,030 [INFO] [doorpi.sipphone.from_linphone] 192.168.1.1 2016-03-18 17:36:34,034 [INFO] [doorpi.sipphone.from_linphone] resolver_process_data dns_res_check() in progress 2016-03-18 17:36:34,037 [INFO] [doorpi.sipphone.from_linphone] DNS resolution awaiting response, queued to main loop 2016-03-18 17:36:34,091 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_callback_network_reachable(0x250e0e8, 0x1) 2016-03-18 17:36:34,094 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_callback_network_reachable 2016-03-18 17:36:34,097 [INFO] [doorpi.sipphone.from_linphone] Linphone core [0x250e0e8] notifying [network_reachable] 2016-03-18 17:36:34,102 [INFO] [doorpi.sipphone.from_linphone] resolved to 192.168.1.1 2016-03-18 17:36:34,105 [INFO] [doorpi.sipphone.from_linphone] Stun server resolution successful.