2020-04-07 07:47:43,272 [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 2020-04-07 07:47:43,273 [DEBUG] [doorpi.main] loaded with arguments: ['/usr/local/bin/doorpi_cli', '--debug'] 2020-04-07 07:47:43,273 [DEBUG] [doorpi.doorpi] run 2020-04-07 07:47:43,273 [DEBUG] [doorpi.doorpi] prepare 2020-04-07 07:47:43,273 [DEBUG] [doorpi.doorpi] given arguments argv: Namespace(configfile=None, debug=True, test=False, trace=False) 2020-04-07 07:47:43,274 [INFO] [doorpi.conf.config_object] use configfile: /usr/local/etc/DoorPi/conf/doorpi.ini 2020-04-07 07:47:43,277 [DEBUG] [doorpi.conf.config_object] __init__ 2020-04-07 07:47:43,277 [TRACE] [doorpi.conf.config_object] get_from_config 2020-04-07 07:47:43,279 [TRACE] [doorpi.conf.config_object] get_string for key base_path in section DoorPi (default: /usr/local/etc/DoorPi) returns /usr/local/etc/DoorPi 2020-04-07 07:47:43,279 [TRACE] [doorpi.conf.config_object] get_string for key eventlog in section DoorPi (default: !BASEPATH!/conf/eventlog.db) returns !BASEPATH!/conf/eventlog.db 2020-04-07 07:47:43,280 [DEBUG] [doorpi.conf.config_object] parse string "!BASEPATH!/conf/eventlog.db" to "/usr/local/etc/DoorPi/conf/eventlog.db" 2020-04-07 07:47:43,281 [TRACE] [doorpi.action.handler] register Event BeforeStartup from doorpi.doorpi 2020-04-07 07:47:43,281 [DEBUG] [doorpi.action.handler] event_source doorpi.doorpi was added 2020-04-07 07:47:43,281 [TRACE] [doorpi.action.handler] added event_name BeforeStartup and registered source doorpi.doorpi 2020-04-07 07:47:43,281 [TRACE] [doorpi.action.handler] register Event OnStartup from doorpi.doorpi 2020-04-07 07:47:43,281 [TRACE] [doorpi.action.handler] added event_name OnStartup and registered source doorpi.doorpi 2020-04-07 07:47:43,281 [TRACE] [doorpi.action.handler] register Event AfterStartup from doorpi.doorpi 2020-04-07 07:47:43,282 [TRACE] [doorpi.action.handler] added event_name AfterStartup and registered source doorpi.doorpi 2020-04-07 07:47:43,282 [TRACE] [doorpi.action.handler] register Event BeforeShutdown from doorpi.doorpi 2020-04-07 07:47:43,282 [TRACE] [doorpi.action.handler] added event_name BeforeShutdown and registered source doorpi.doorpi 2020-04-07 07:47:43,282 [TRACE] [doorpi.action.handler] register Event OnShutdown from doorpi.doorpi 2020-04-07 07:47:43,282 [TRACE] [doorpi.action.handler] added event_name OnShutdown and registered source doorpi.doorpi 2020-04-07 07:47:43,282 [TRACE] [doorpi.action.handler] register Event AfterShutdown from doorpi.doorpi 2020-04-07 07:47:43,282 [TRACE] [doorpi.action.handler] added event_name AfterShutdown and registered source doorpi.doorpi 2020-04-07 07:47:43,283 [DEBUG] [doorpi.action.SingleActions.time_tick] doorpi.action.SingleActions.time_tick loaded 2020-04-07 07:47:43,284 [DEBUG] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was added 2020-04-07 07:47:43,284 [TRACE] [doorpi.action.handler] action TimeTickDestroyAction with args () and kwargs {} was added to new evententry OnShutdown 2020-04-07 07:47:43,285 [TRACE] [doorpi.action.handler] action TimeTickAction with args ('!last_tick!',) and kwargs {} was added to new evententry OnTimeTick 2020-04-07 07:47:43,285 [TRACE] [doorpi.conf.config_object] get_string for key ip in section DoorPiWeb (default: ) returns 2020-04-07 07:47:43,285 [TRACE] [doorpi.conf.config_object] get_integer for key port in section DoorPiWeb (default: 80) returns 80 2020-04-07 07:47:43,286 [INFO] [doorpi.status.webserver] Initiating WebService at ip and port 80 2020-04-07 07:47:43,286 [TRACE] [doorpi.action.handler] register Event OnWebServerStart from doorpi.status.webserver 2020-04-07 07:47:43,286 [DEBUG] [doorpi.action.handler] event_source doorpi.status.webserver was added 2020-04-07 07:47:43,286 [TRACE] [doorpi.action.handler] added event_name OnWebServerStart and registered source doorpi.status.webserver 2020-04-07 07:47:43,287 [TRACE] [doorpi.action.handler] register Event OnWebServerStop from doorpi.status.webserver 2020-04-07 07:47:43,287 [TRACE] [doorpi.action.handler] added event_name OnWebServerStop and registered source doorpi.status.webserver 2020-04-07 07:47:43,287 [TRACE] [doorpi.conf.config_object] get_string for key www in section DoorPiWeb (default: !BASEPATH!/../DoorPiWeb) returns !BASEPATH!/../DoorPiWeb 2020-04-07 07:47:43,287 [DEBUG] [doorpi.conf.config_object] parse string "!BASEPATH!/../DoorPiWeb" to "/usr/local/etc/DoorPi/../DoorPiWeb" 2020-04-07 07:47:43,287 [TRACE] [doorpi.conf.config_object] get_string for key indexfile in section DoorPiWeb (default: index.html) returns index.html 2020-04-07 07:47:43,288 [DEBUG] [doorpi.conf.config_object] parse string "index.html" to "index.html" 2020-04-07 07:47:43,288 [TRACE] [doorpi.conf.config_object] get_string for key loginfile in section DoorPiWeb (default: login.html) returns login.html 2020-04-07 07:47:43,288 [DEBUG] [doorpi.conf.config_object] parse string "login.html" to "login.html" 2020-04-07 07:47:43,288 [TRACE] [doorpi.conf.config_object] get_string for key public in section DoorPiWeb (default: AREA_public) returns AREA_public 2020-04-07 07:47:43,288 [DEBUG] [doorpi.conf.config_object] parse string "AREA_public" to "AREA_public" 2020-04-07 07:47:43,288 [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 2020-04-07 07:47:43,289 [DEBUG] [doorpi.conf.config_object] parse string "http://motom001.github.io/DoorPiWeb" to "http://motom001.github.io/DoorPiWeb" 2020-04-07 07:47:43,289 [TRACE] [doorpi.conf.config_object] get_keys for section WritePermission returns ['administrators'] 2020-04-07 07:47:43,289 [TRACE] [doorpi.conf.config_object] get_keys for section ReadPermission returns ['administrators', 'guests'] 2020-04-07 07:47:43,289 [TRACE] [doorpi.conf.config_object] get_keys for section Group returns ['administrators', 'guests'] 2020-04-07 07:47:43,289 [TRACE] [doorpi.conf.config_object] get_keys for section User returns ['door'] 2020-04-07 07:47:43,289 [TRACE] [doorpi.conf.config_object] get_list for key administrators in section Group (default: []) returns ['door'] 2020-04-07 07:47:43,290 [TRACE] [doorpi.conf.config_object] get_list for key guests in section Group (default: []) returns [] 2020-04-07 07:47:43,290 [TRACE] [doorpi.conf.config_object] get_sections returns ['Group', 'ReadPermission', 'virtual_keyboard', 'DTMF', 'AREA_config', 'EVENT_OnStartup', 'DoorPiWeb', 'virtual_InputPins', 'AREA_public', 'AREA_dashboard', 'WritePermission', 'virtual_OutputPins', 'User', 'AREA_installer', 'AREA_status', 'onboardpins_OutputPins', 'keyboards', 'AdminNumbers', 'SIP-Phone', 'EVENT_OnKeyPressed_onboardpins.0', 'onboardpins_InputPins', 'DoorPi'] 2020-04-07 07:47:43,290 [TRACE] [doorpi.conf.config_object] get_list for key administrators in section WritePermission (default: []) returns ['installer', 'dashboard', 'config'] 2020-04-07 07:47:43,290 [TRACE] [doorpi.conf.config_object] get_list for key administrators in section ReadPermission (default: []) returns ['dashboard', 'status', 'config'] 2020-04-07 07:47:43,290 [TRACE] [doorpi.conf.config_object] get_list for key guests in section ReadPermission (default: []) returns ['dashboard'] 2020-04-07 07:47:43,290 [TRACE] [doorpi.action.handler] action WebServerStartupAction with args () and kwargs {} was added to new evententry OnWebServerStart 2020-04-07 07:47:43,290 [TRACE] [doorpi.action.handler] action WebServerShutdownAction with args () and kwargs {} was added to event OnShutdown 2020-04-07 07:47:43,291 [TRACE] [doorpi.action.handler] fire Event OnWebServerStart from doorpi.status.webserver asyncron 2020-04-07 07:47:43,291 [TRACE] [doorpi.action.handler] register Event OnWebServerRequest from doorpi.status.webserver_lib.request_handler 2020-04-07 07:47:43,291 [DEBUG] [doorpi.action.handler] event_source doorpi.status.webserver_lib.request_handler was added 2020-04-07 07:47:43,292 [TRACE] [doorpi.action.handler] added event_name OnWebServerRequest and registered source doorpi.status.webserver_lib.request_handler 2020-04-07 07:47:43,292 [TRACE] [doorpi.action.handler] register Event OnWebServerRequestGet from doorpi.status.webserver_lib.request_handler 2020-04-07 07:47:43,292 [TRACE] [doorpi.action.handler] added event_name OnWebServerRequestGet and registered source doorpi.status.webserver_lib.request_handler 2020-04-07 07:47:43,292 [TRACE] [doorpi.action.handler] register Event OnWebServerRequestPost from doorpi.status.webserver_lib.request_handler 2020-04-07 07:47:43,292 [TRACE] [doorpi.action.handler] added event_name OnWebServerRequestPost and registered source doorpi.status.webserver_lib.request_handler 2020-04-07 07:47:43,292 [TRACE] [doorpi.action.handler] register Event OnWebServerVirtualResource from doorpi.status.webserver_lib.request_handler 2020-04-07 07:47:43,292 [DEBUG] [doorpi.action.handler] [FZXM99] fire for event OnWebServerStart this actions [] 2020-04-07 07:47:43,292 [TRACE] [doorpi.action.handler] added event_name OnWebServerVirtualResource and registered source doorpi.status.webserver_lib.request_handler 2020-04-07 07:47:43,293 [TRACE] [doorpi.action.handler] [FZXM99] try to fire action WebServerStartupAction with args () and kwargs {} 2020-04-07 07:47:43,293 [TRACE] [doorpi.action.handler] register Event OnWebServerRealResource from doorpi.status.webserver_lib.request_handler 2020-04-07 07:47:43,293 [TRACE] [doorpi.action.base] run WebServerStartupAction with args () and kwargs {} 2020-04-07 07:47:43,293 [TRACE] [doorpi.action.handler] added event_name OnWebServerRealResource and registered source doorpi.status.webserver_lib.request_handler 2020-04-07 07:47:43,293 [TRACE] [doorpi.action.handler] register Event OnFireEvent from doorpi.status.webserver_lib.request_handler 2020-04-07 07:47:43,293 [TRACE] [doorpi.action.handler] added event_name OnFireEvent and registered source doorpi.status.webserver_lib.request_handler 2020-04-07 07:47:43,294 [TRACE] [doorpi.action.handler] register Event OnConfigKeySet from doorpi.status.webserver_lib.request_handler 2020-04-07 07:47:43,294 [TRACE] [doorpi.action.handler] added event_name OnConfigKeySet and registered source doorpi.status.webserver_lib.request_handler 2020-04-07 07:47:43,294 [TRACE] [doorpi.action.handler] register Event OnConfigKeyDelete from doorpi.status.webserver_lib.request_handler 2020-04-07 07:47:43,294 [TRACE] [doorpi.action.handler] added event_name OnConfigKeyDelete and registered source doorpi.status.webserver_lib.request_handler 2020-04-07 07:47:43,294 [TRACE] [doorpi.conf.config_object] get_keys for section keyboards returns ['virtual', 'onboardpins'] 2020-04-07 07:47:43,294 [INFO] [doorpi.keyboard.KeyboardInterface] using multi-keyboard mode (keyboards: virtual, onboardpins) 2020-04-07 07:47:43,294 [INFO] [doorpi.keyboard.KeyboardInterface] trying to add keyboard 'virtual' to handler 2020-04-07 07:47:43,294 [TRACE] [doorpi.conf.config_object] get_string for key virtual in section keyboards (default: dummy) returns filesystem 2020-04-07 07:47:43,295 [TRACE] [doorpi.conf.config_object] get_keys for section virtual_InputPins returns ['anrufen'] 2020-04-07 07:47:43,295 [TRACE] [doorpi.conf.config_object] get_keys for section virtual_OutputPins returns ['virt_output'] 2020-04-07 07:47:43,295 [TRACE] [doorpi.conf.config_object] get_integer for key bouncetime in section virtual_keyboard (default: 2000) returns 2000.0 2020-04-07 07:47:43,295 [TRACE] [doorpi.conf.config_object] get_integer for key polarity in section virtual_keyboard (default: 0) returns 0 2020-04-07 07:47:43,295 [TRACE] [doorpi.conf.config_object] get_boolean for key pressed_on_keydown in section virtual_keyboard (default: True) returns True 2020-04-07 07:47:43,296 [DEBUG] [doorpi.keyboard.from_filesystem] doorpi.keyboard.from_filesystem loaded 2020-04-07 07:47:43,327 [DEBUG] [doorpi.keyboard.from_filesystem] FileSystem.__init__(input_pins = ['anrufen'], output_pins = ['virt_output'], polarity = 0) 2020-04-07 07:47:43,327 [TRACE] [doorpi.conf.config_object] get_boolean for key reset_input in section virtual_keyboard (default: True) returns True 2020-04-07 07:47:43,327 [TRACE] [doorpi.conf.config_object] get_string for key base_path_input in section virtual_keyboard (default: ) returns !BASEPATH!/filesystem/inputs/ 2020-04-07 07:47:43,328 [DEBUG] [doorpi.conf.config_object] parse string "!BASEPATH!/filesystem/inputs/" to "/usr/local/etc/DoorPi/filesystem/inputs/" 2020-04-07 07:47:43,328 [TRACE] [doorpi.conf.config_object] get_string for key base_path_output in section virtual_keyboard (default: ) returns !BASEPATH!/filesystem/outputs/ 2020-04-07 07:47:43,328 [DEBUG] [doorpi.conf.config_object] parse string "!BASEPATH!/filesystem/outputs/" to "/usr/local/etc/DoorPi/filesystem/outputs/" 2020-04-07 07:47:43,329 [TRACE] [doorpi.action.handler] register Event OnKeyPressed from doorpi.keyboard.from_filesystem 2020-04-07 07:47:43,329 [DEBUG] [doorpi.action.handler] event_source doorpi.keyboard.from_filesystem was added 2020-04-07 07:47:43,329 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed and registered source doorpi.keyboard.from_filesystem 2020-04-07 07:47:43,329 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_anrufen from doorpi.keyboard.from_filesystem 2020-04-07 07:47:43,329 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_anrufen and registered source doorpi.keyboard.from_filesystem 2020-04-07 07:47:43,329 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_virtual.anrufen from doorpi.keyboard.from_filesystem 2020-04-07 07:47:43,329 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_virtual.anrufen and registered source doorpi.keyboard.from_filesystem 2020-04-07 07:47:43,329 [TRACE] [doorpi.action.handler] register Event OnKeyUp from doorpi.keyboard.from_filesystem 2020-04-07 07:47:43,330 [TRACE] [doorpi.action.handler] added event_name OnKeyUp and registered source doorpi.keyboard.from_filesystem 2020-04-07 07:47:43,330 [TRACE] [doorpi.action.handler] register Event OnKeyUp_anrufen from doorpi.keyboard.from_filesystem 2020-04-07 07:47:43,330 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_anrufen and registered source doorpi.keyboard.from_filesystem 2020-04-07 07:47:43,330 [TRACE] [doorpi.action.handler] register Event OnKeyUp_virtual.anrufen from doorpi.keyboard.from_filesystem 2020-04-07 07:47:43,330 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_virtual.anrufen and registered source doorpi.keyboard.from_filesystem 2020-04-07 07:47:43,330 [TRACE] [doorpi.action.handler] register Event OnKeyDown from doorpi.keyboard.from_filesystem 2020-04-07 07:47:43,330 [TRACE] [doorpi.action.handler] added event_name OnKeyDown and registered source doorpi.keyboard.from_filesystem 2020-04-07 07:47:43,330 [TRACE] [doorpi.action.handler] register Event OnKeyDown_anrufen from doorpi.keyboard.from_filesystem 2020-04-07 07:47:43,330 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_anrufen and registered source doorpi.keyboard.from_filesystem 2020-04-07 07:47:43,331 [TRACE] [doorpi.action.handler] register Event OnKeyDown_virtual.anrufen from doorpi.keyboard.from_filesystem 2020-04-07 07:47:43,331 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_virtual.anrufen and registered source doorpi.keyboard.from_filesystem 2020-04-07 07:47:43,333 [TRACE] [doorpi.action.handler] action KeyboardDestroyAction with args () and kwargs {} was added to event OnShutdown 2020-04-07 07:47:43,333 [TRACE] [doorpi.conf.config_object] get_keys for section virtual_OutputPins returns ['virt_output'] 2020-04-07 07:47:43,334 [TRACE] [doorpi.conf.config_object] get_string for key virt_output in section virtual_OutputPins (default: ) returns virtuellerOutput 2020-04-07 07:47:43,334 [INFO] [doorpi.keyboard.KeyboardInterface] trying to add keyboard 'onboardpins' to handler 2020-04-07 07:47:43,334 [TRACE] [doorpi.conf.config_object] get_string for key onboardpins in section keyboards (default: dummy) returns dummy 2020-04-07 07:47:43,334 [TRACE] [doorpi.conf.config_object] get_keys for section onboardpins_InputPins returns [] 2020-04-07 07:47:43,334 [TRACE] [doorpi.conf.config_object] get_keys for section onboardpins_OutputPins returns [] 2020-04-07 07:47:43,334 [TRACE] [doorpi.conf.config_object] get_integer for key bouncetime in section onboardpins_keyboard (default: 2000) returns 2000.0 2020-04-07 07:47:43,334 [TRACE] [doorpi.conf.config_object] get_integer for key polarity in section onboardpins_keyboard (default: 0) returns 0 2020-04-07 07:47:43,335 [TRACE] [doorpi.conf.config_object] get_boolean for key pressed_on_keydown in section onboardpins_keyboard (default: True) returns True 2020-04-07 07:47:43,335 [DEBUG] [doorpi.keyboard.from_dummy] doorpi.keyboard.from_dummy loaded 2020-04-07 07:47:43,335 [DEBUG] [doorpi.keyboard.from_dummy] __init__(input_pins = [], output_pins = [], bouncetime = 2000.0, polarity = 0) 2020-04-07 07:47:43,335 [TRACE] [doorpi.conf.config_object] get_keys for section onboardpins_InputPins returns [] 2020-04-07 07:47:43,335 [TRACE] [doorpi.conf.config_object] get_keys for section onboardpins_OutputPins returns [] 2020-04-07 07:47:43,336 [TRACE] [doorpi.action.handler] action KeyboardDestroyAction with args () and kwargs {} was added to event OnShutdown 2020-04-07 07:47:43,336 [TRACE] [doorpi.conf.config_object] get_keys for section onboardpins_OutputPins returns [] 2020-04-07 07:47:43,336 [DEBUG] [doorpi.status.status_lib.environment] doorpi.status.status_lib.environment loaded 2020-04-07 07:47:43,337 [DEBUG] [doorpi.status.requirements_lib.req_config] doorpi.status.requirements_lib.req_config loaded 2020-04-07 07:47:43,338 [DEBUG] [doorpi.status.requirements_lib.req_sipphone] doorpi.status.requirements_lib.req_sipphone loaded 2020-04-07 07:47:43,338 [DEBUG] [doorpi.sipphone.AbstractBaseClass] doorpi.sipphone.AbstractBaseClass loaded 2020-04-07 07:47:43,362 [DEBUG] [doorpi.status.requirements_lib.req_event_handler] doorpi.status.requirements_lib.req_event_handler loaded 2020-04-07 07:47:43,362 [DEBUG] [doorpi.status.requirements_lib.req_webserver] doorpi.status.requirements_lib.req_webserver loaded 2020-04-07 07:47:43,363 [DEBUG] [doorpi.status.requirements_lib.req_keyboard] doorpi.status.requirements_lib.req_keyboard loaded 2020-04-07 07:47:43,378 [DEBUG] [doorpi.status.requirements_lib.req_system] doorpi.status.requirements_lib.req_system loaded 2020-04-07 07:47:43,380 [INFO] [doorpi.sipphone.SipphoneInterface] found installed sipphone "linphone" and use this as default 2020-04-07 07:47:43,380 [TRACE] [doorpi.conf.config_object] get_string for key sipphonetyp in section SIP-Phone (default: linphone) returns linphone 2020-04-07 07:47:43,381 [DEBUG] [doorpi.sipphone.from_linphone] doorpi.sipphone.from_linphone loaded 2020-04-07 07:47:43,382 [DEBUG] [doorpi.sipphone.linphone_lib.CallBacks] doorpi.sipphone.linphone_lib.CallBacks loaded 2020-04-07 07:47:43,382 [DEBUG] [doorpi.sipphone.linphone_lib.Player] doorpi.sipphone.linphone_lib.Player loaded 2020-04-07 07:47:43,383 [DEBUG] [doorpi.sipphone.linphone_lib.Recorder] doorpi.sipphone.linphone_lib.Recorder loaded 2020-04-07 07:47:43,383 [DEBUG] [doorpi.sipphone.from_linphone] __init__ 2020-04-07 07:47:43,384 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to event OnShutdown 2020-04-07 07:47:43,384 [TRACE] [doorpi.action.handler] register Event OnSipPhoneCreate from doorpi.sipphone.from_linphone 2020-04-07 07:47:43,384 [DEBUG] [doorpi.action.handler] event_source doorpi.sipphone.from_linphone was added 2020-04-07 07:47:43,384 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneCreate and registered source doorpi.sipphone.from_linphone 2020-04-07 07:47:43,384 [TRACE] [doorpi.action.handler] register Event OnSipPhoneStart from doorpi.sipphone.from_linphone 2020-04-07 07:47:43,384 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneStart and registered source doorpi.sipphone.from_linphone 2020-04-07 07:47:43,384 [TRACE] [doorpi.action.handler] register Event OnSipPhoneDestroy from doorpi.sipphone.from_linphone 2020-04-07 07:47:43,384 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneDestroy and registered source doorpi.sipphone.from_linphone 2020-04-07 07:47:43,385 [TRACE] [doorpi.action.handler] register Event OnSipPhoneRecorderCreate from doorpi.sipphone.from_linphone 2020-04-07 07:47:43,385 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneRecorderCreate and registered source doorpi.sipphone.from_linphone 2020-04-07 07:47:43,385 [TRACE] [doorpi.action.handler] register Event OnSipPhoneRecorderDestroy from doorpi.sipphone.from_linphone 2020-04-07 07:47:43,385 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneRecorderDestroy and registered source doorpi.sipphone.from_linphone 2020-04-07 07:47:43,385 [TRACE] [doorpi.action.handler] register Event BeforeSipPhoneMakeCall from doorpi.sipphone.from_linphone 2020-04-07 07:47:43,385 [TRACE] [doorpi.action.handler] added event_name BeforeSipPhoneMakeCall and registered source doorpi.sipphone.from_linphone 2020-04-07 07:47:43,385 [TRACE] [doorpi.action.handler] register Event OnSipPhoneMakeCall from doorpi.sipphone.from_linphone 2020-04-07 07:47:43,385 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneMakeCall and registered source doorpi.sipphone.from_linphone 2020-04-07 07:47:43,385 [TRACE] [doorpi.action.handler] register Event OnSipPhoneMakeCallFailed from doorpi.sipphone.from_linphone 2020-04-07 07:47:43,386 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneMakeCallFailed and registered source doorpi.sipphone.from_linphone 2020-04-07 07:47:43,386 [TRACE] [doorpi.action.handler] register Event AfterSipPhoneMakeCall from doorpi.sipphone.from_linphone 2020-04-07 07:47:43,386 [TRACE] [doorpi.action.handler] added event_name AfterSipPhoneMakeCall and registered source doorpi.sipphone.from_linphone 2020-04-07 07:47:43,386 [TRACE] [doorpi.action.handler] register Event OnSipPhoneCallTimeoutNoResponse from doorpi.sipphone.from_linphone 2020-04-07 07:47:43,386 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneCallTimeoutNoResponse and registered source doorpi.sipphone.from_linphone 2020-04-07 07:47:43,386 [TRACE] [doorpi.action.handler] register Event OnSipPhoneCallTimeoutMaxCalltime from doorpi.sipphone.from_linphone 2020-04-07 07:47:43,386 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneCallTimeoutMaxCalltime and registered source doorpi.sipphone.from_linphone 2020-04-07 07:47:43,386 [TRACE] [doorpi.action.handler] register Event OnPlayerCreated from doorpi.sipphone.from_linphone 2020-04-07 07:47:43,386 [TRACE] [doorpi.action.handler] added event_name OnPlayerCreated and registered source doorpi.sipphone.from_linphone 2020-04-07 07:47:43,387 [DEBUG] [doorpi.sipphone.linphone_lib.CallBacks] __init__ 2020-04-07 07:47:43,387 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to new evententry OnSipPhoneDestroy 2020-04-07 07:47:43,387 [TRACE] [doorpi.action.handler] register Event OnCallMediaStateChange from doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:43,387 [DEBUG] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was added 2020-04-07 07:47:43,387 [TRACE] [doorpi.action.handler] added event_name OnCallMediaStateChange and registered source doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:43,387 [TRACE] [doorpi.action.handler] register Event OnMediaRequired from doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:43,387 [TRACE] [doorpi.action.handler] added event_name OnMediaRequired and registered source doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:43,387 [TRACE] [doorpi.action.handler] register Event OnMediaNotRequired from doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:43,388 [TRACE] [doorpi.action.handler] added event_name OnMediaNotRequired and registered source doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:43,388 [TRACE] [doorpi.action.handler] register Event OnCallStateChange from doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:43,388 [TRACE] [doorpi.action.handler] added event_name OnCallStateChange and registered source doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:43,388 [TRACE] [doorpi.action.handler] register Event OnCallStateConnect from doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:43,388 [TRACE] [doorpi.action.handler] added event_name OnCallStateConnect and registered source doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:43,388 [TRACE] [doorpi.action.handler] register Event AfterCallStateConnect from doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:43,388 [TRACE] [doorpi.action.handler] added event_name AfterCallStateConnect and registered source doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:43,388 [TRACE] [doorpi.action.handler] register Event OnCallStateDisconnect from doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:43,388 [TRACE] [doorpi.action.handler] added event_name OnCallStateDisconnect and registered source doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:43,389 [TRACE] [doorpi.action.handler] register Event AfterCallStateDisconnect from doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:43,389 [TRACE] [doorpi.action.handler] added event_name AfterCallStateDisconnect and registered source doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:43,389 [TRACE] [doorpi.action.handler] register Event OnCallStateDismissed from doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:43,389 [TRACE] [doorpi.action.handler] added event_name OnCallStateDismissed and registered source doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:43,389 [TRACE] [doorpi.action.handler] register Event OnCallStateReject from doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:43,389 [TRACE] [doorpi.action.handler] added event_name OnCallStateReject and registered source doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:43,389 [TRACE] [doorpi.action.handler] register Event OnCallStart from doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:43,389 [TRACE] [doorpi.action.handler] added event_name OnCallStart and registered source doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:43,389 [TRACE] [doorpi.action.handler] register Event OnDTMF from doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:43,389 [TRACE] [doorpi.action.handler] added event_name OnDTMF and registered source doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:43,390 [TRACE] [doorpi.conf.config_object] get_keys for section DTMF returns ['"*#"'] 2020-04-07 07:47:43,390 [TRACE] [doorpi.action.handler] register Event OnDTMF_"*#" from doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:43,390 [TRACE] [doorpi.action.handler] added event_name OnDTMF_"*#" and registered source doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:43,390 [TRACE] [doorpi.action.handler] register Event OnCallStart from doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:43,390 [TRACE] [doorpi.action.handler] nothing to do - event OnCallStart from source doorpi.sipphone.linphone_lib.CallBacks is already known 2020-04-07 07:47:43,390 [TRACE] [doorpi.action.handler] register Event BeforeCallIncoming from doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:43,390 [TRACE] [doorpi.action.handler] added event_name BeforeCallIncoming and registered source doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:43,390 [TRACE] [doorpi.action.handler] register Event OnCallReconnect from doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:43,390 [TRACE] [doorpi.action.handler] added event_name OnCallReconnect and registered source doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:43,391 [TRACE] [doorpi.action.handler] register Event AfterCallReconnect from doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:43,391 [TRACE] [doorpi.action.handler] added event_name AfterCallReconnect and registered source doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:43,391 [TRACE] [doorpi.action.handler] register Event OnCallBusy from doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:43,391 [TRACE] [doorpi.action.handler] added event_name OnCallBusy and registered source doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:43,391 [TRACE] [doorpi.action.handler] register Event AfterCallBusy from doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:43,391 [TRACE] [doorpi.action.handler] added event_name AfterCallBusy and registered source doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:43,391 [TRACE] [doorpi.action.handler] register Event OnCallIncoming from doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:43,391 [TRACE] [doorpi.action.handler] added event_name OnCallIncoming and registered source doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:43,391 [TRACE] [doorpi.action.handler] register Event AfterCallIncoming from doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:43,392 [TRACE] [doorpi.action.handler] added event_name AfterCallIncoming and registered source doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:43,392 [TRACE] [doorpi.action.handler] register Event OnCallReject from doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:43,392 [TRACE] [doorpi.action.handler] added event_name OnCallReject and registered source doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:43,392 [TRACE] [doorpi.action.handler] register Event AfterCallReject from doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:43,392 [TRACE] [doorpi.action.handler] added event_name AfterCallReject and registered source doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:43,392 [TRACE] [doorpi.action.handler] fire Event OnCallStart from doorpi.sipphone.linphone_lib.CallBacks asyncron 2020-04-07 07:47:45,274 [TRACE] [doorpi.conf.config_object] get_string for key identity in section SIP-Phone (default: DoorPi) returns Klingel 2020-04-07 07:47:45,276 [TRACE] [doorpi.action.handler] fire Event OnSipPhoneCreate from doorpi.sipphone.from_linphone asyncron 2020-04-07 07:47:45,277 [DEBUG] [doorpi.action.handler] no actions for event OnCallStart - skip fire_event OnCallStart from doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:45,278 [TRACE] [doorpi.conf.config_object] get_integer for key ua.max_calls in section SIP-Phone (default: 2) returns 2 2020-04-07 07:47:45,278 [TRACE] [doorpi.conf.config_object] get_boolean for key echo_cancellation_enabled in section SIP-Phone (default: False) returns False 2020-04-07 07:47:45,279 [TRACE] [doorpi.conf.config_object] get_integer for key local_port in section SIP-Phone (default: 5060) returns 5060 2020-04-07 07:47:45,279 [TRACE] [doorpi.conf.config_object] get_integer for key local_port in section SIP-Phone (default: 5060) returns 5060 2020-04-07 07:47:45,279 [DEBUG] [doorpi.action.handler] no actions for event OnSipPhoneCreate - skip fire_event OnSipPhoneCreate from doorpi.sipphone.from_linphone 2020-04-07 07:47:45,281 [TRACE] [doorpi.conf.config_object] get_boolean for key video_display_enabled in section SIP-Phone (default: False) returns False 2020-04-07 07:47:45,281 [TRACE] [doorpi.conf.config_object] get_string for key stun_server in section SIP-Phone (default: ) returns stun.linphone.org 2020-04-07 07:47:45,283 [DEBUG] [doorpi.conf.config_object] create new key FirewallPolicy in section SIP-Phone with value 'PolicyNoFirewall' 2020-04-07 07:47:45,283 [TRACE] [doorpi.conf.config_object] get_string for key FirewallPolicy in section SIP-Phone (default: PolicyNoFirewall) returns PolicyNoFirewall 2020-04-07 07:47:45,285 [TRACE] [doorpi.conf.config_object] get_integer for key max_call_time in section SIP-Phone (default: 120) returns 120 2020-04-07 07:47:45,285 [TRACE] [doorpi.conf.config_object] get_integer for key call_timeout in section SIP-Phone (default: 15) returns 30 2020-04-07 07:47:45,285 [TRACE] [doorpi.conf.config_object] get_string for key dialtone in section SIP-Phone (default: !BASEPATH!/media/ShortDialTone.wav) returns !BASEPATH!/media/ShortDialTone.wav 2020-04-07 07:47:45,287 [DEBUG] [doorpi.conf.config_object] parse string "!BASEPATH!/media/ShortDialTone.wav" to "/usr/local/etc/DoorPi/media/ShortDialTone.wav" 2020-04-07 07:47:45,287 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to event OnSipPhoneDestroy 2020-04-07 07:47:45,288 [TRACE] [doorpi.conf.config_object] get_boolean for key dialtone_renew_every_start in section SIP-Phone (default: False) returns False 2020-04-07 07:47:45,288 [TRACE] [doorpi.action.handler] register Event OnPlayerStarted from doorpi.sipphone.linphone_lib.Player 2020-04-07 07:47:45,289 [DEBUG] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.Player was added 2020-04-07 07:47:45,289 [TRACE] [doorpi.action.handler] added event_name OnPlayerStarted and registered source doorpi.sipphone.linphone_lib.Player 2020-04-07 07:47:45,289 [TRACE] [doorpi.action.handler] register Event OnPlayerStopped from doorpi.sipphone.linphone_lib.Player 2020-04-07 07:47:45,290 [TRACE] [doorpi.action.handler] added event_name OnPlayerStopped and registered source doorpi.sipphone.linphone_lib.Player 2020-04-07 07:47:45,290 [TRACE] [doorpi.action.handler] register Event OnPlayerCreated from doorpi.sipphone.linphone_lib.Player 2020-04-07 07:47:45,290 [TRACE] [doorpi.action.handler] added event_source doorpi.sipphone.linphone_lib.Player to existing event OnPlayerCreated 2020-04-07 07:47:45,290 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to new evententry OnSipPhoneMakeCall 2020-04-07 07:47:45,291 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to new evententry OnCallStateConnect 2020-04-07 07:47:45,291 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to new evententry OnCallStateDisconnect 2020-04-07 07:47:45,292 [TRACE] [doorpi.action.handler] fire Event OnPlayerCreated from doorpi.sipphone.linphone_lib.Player asyncron 2020-04-07 07:47:45,293 [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 2020-04-07 07:47:45,293 [DEBUG] [doorpi.action.handler] no actions for event OnPlayerCreated - skip fire_event OnPlayerCreated from doorpi.sipphone.linphone_lib.Player 2020-04-07 07:47:45,293 [DEBUG] [doorpi.sipphone.linphone_lib.Recorder] no recorder found in config at section DoorPi and key records 2020-04-07 07:47:45,295 [TRACE] [doorpi.conf.config_object] get_string for key capture_device in section SIP-Phone (default: ALSA: default device) returns ALSA: USB Audio Device 2020-04-07 07:47:45,295 [TRACE] [doorpi.conf.config_object] get_string for key playback_device in section SIP-Phone (default: ALSA: default device) returns ALSA: USB Audio Device 2020-04-07 07:47:45,296 [TRACE] [doorpi.conf.config_object] get_integer for key mic_gain_db in section SIP-Phone (default: 0) returns 0.0 2020-04-07 07:47:45,296 [INFO] [doorpi.sipphone.from_linphone] found 3 possible sounddevices: 2020-04-07 07:47:45,297 [DEBUG] [doorpi.sipphone.from_linphone] |rec|play| name 2020-04-07 07:47:45,297 [DEBUG] [doorpi.sipphone.from_linphone] ------------------------------------ 2020-04-07 07:47:45,297 [DEBUG] [doorpi.sipphone.from_linphone] | X | X | ALSA: default device 2020-04-07 07:47:45,298 [DEBUG] [doorpi.sipphone.from_linphone] | O | X | ALSA: bcm2835 ALSA 2020-04-07 07:47:45,298 [DEBUG] [doorpi.sipphone.from_linphone] | X | O | ALSA: USB Device 0x46d:0x825 2020-04-07 07:47:45,298 [DEBUG] [doorpi.sipphone.from_linphone] ------------------------------------ 2020-04-07 07:47:45,299 [DEBUG] [doorpi.sipphone.from_linphone] using capture_device: ALSA: default device 2020-04-07 07:47:45,299 [DEBUG] [doorpi.sipphone.from_linphone] using playback_device: ALSA: default device 2020-04-07 07:47:45,299 [DEBUG] [doorpi.sipphone.from_linphone] mic_gain_db: 0.0 2020-04-07 07:47:45,300 [TRACE] [doorpi.conf.config_object] get_list for key audio_codecs in section SIP-Phone (default: PCMA,PCMU) returns ['PCMA', 'PCMU'] 2020-04-07 07:47:45,301 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec opus 2020-04-07 07:47:45,302 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec speex 2020-04-07 07:47:45,302 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec speex 2020-04-07 07:47:45,303 [DEBUG] [doorpi.sipphone.from_linphone] enable audio codec PCMU 2020-04-07 07:47:45,303 [DEBUG] [doorpi.sipphone.from_linphone] enable audio codec PCMA 2020-04-07 07:47:45,304 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec GSM 2020-04-07 07:47:45,304 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec G722 2020-04-07 07:47:45,305 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec speex 2020-04-07 07:47:45,305 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec L16 2020-04-07 07:47:45,306 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec L16 2020-04-07 07:47:45,306 [INFO] [doorpi.sipphone.from_linphone] found 3 possible videodevices: 2020-04-07 07:47:45,306 [DEBUG] [doorpi.sipphone.from_linphone] | name 2020-04-07 07:47:45,307 [DEBUG] [doorpi.sipphone.from_linphone] ------------------------------------ 2020-04-07 07:47:45,307 [DEBUG] [doorpi.sipphone.from_linphone] | V4L2: /dev/video0 2020-04-07 07:47:45,307 [DEBUG] [doorpi.sipphone.from_linphone] | V4L2: /dev/video1 2020-04-07 07:47:45,308 [DEBUG] [doorpi.sipphone.from_linphone] | StaticImage: Static picture 2020-04-07 07:47:45,308 [DEBUG] [doorpi.sipphone.from_linphone] ------------------------------------ 2020-04-07 07:47:45,308 [TRACE] [doorpi.conf.config_object] get_string for key video_device in section SIP-Phone (default: V4L2: /dev/video0) returns V4L2: /dev/video0 2020-04-07 07:47:45,309 [TRACE] [doorpi.conf.config_object] get_string for key video_size in section SIP-Phone (default: vga) returns QVGA 2020-04-07 07:47:45,309 [DEBUG] [doorpi.sipphone.from_linphone] using video_device: V4L2: /dev/video0 2020-04-07 07:47:45,309 [TRACE] [doorpi.conf.config_object] get_list for key video_codecs in section SIP-Phone (default: VP8) returns ['VP8', 'V4L2', 'JPEG'] 2020-04-07 07:47:45,310 [DEBUG] [doorpi.sipphone.from_linphone] enable video codec VP8 2020-04-07 07:47:45,310 [TRACE] [doorpi.conf.config_object] get_string for key sipserver_server in section SIP-Phone (default: ) returns sip.linphone.org 2020-04-07 07:47:45,311 [TRACE] [doorpi.conf.config_object] get_string for key sipserver_username in section SIP-Phone (default: ) returns MyPiAccount 2020-04-07 07:47:45,311 [TRACE] [doorpi.conf.config_object] get_string for key sipserver_password in section SIP-Phone (default: MyPiAccount) returns ******* 2020-04-07 07:47:45,311 [DEBUG] [doorpi.conf.config_object] create new key sipserver_realm in section SIP-Phone with value 'sip.linphone.org' 2020-04-07 07:47:45,312 [TRACE] [doorpi.conf.config_object] get_string for key sipserver_realm in section SIP-Phone (default: sip.linphone.org) returns sip.linphone.org 2020-04-07 07:47:45,312 [INFO] [doorpi.sipphone.from_linphone] using DoorPi with SIP-Server 2020-04-07 07:47:45,313 [TRACE] [doorpi.conf.config_object] get_string for key identity in section SIP-Phone (default: DoorPi) returns Klingel 2020-04-07 07:47:45,317 [DEBUG] [doorpi.sipphone.from_linphone] start successfully 2020-04-07 07:47:45,318 [TRACE] [doorpi.conf.config_object] get_sections returns ['EVENT_OnStartup', 'EVENT_OnKeyPressed_onboardpins.0'] 2020-04-07 07:47:45,318 [INFO] [doorpi.doorpi] found EVENT_ section 'EVENT_OnStartup' in configfile 2020-04-07 07:47:45,318 [TRACE] [doorpi.conf.config_object] get_keys for section EVENT_OnStartup returns [] 2020-04-07 07:47:45,319 [INFO] [doorpi.doorpi] found EVENT_ section 'EVENT_OnKeyPressed_onboardpins.0' in configfile 2020-04-07 07:47:45,319 [TRACE] [doorpi.conf.config_object] get_keys for section EVENT_OnKeyPressed_onboardpins.0 returns [] 2020-04-07 07:47:45,319 [TRACE] [doorpi.conf.config_object] get_string for key anrufen in section virtual_InputPins (default: ) returns call:sip:MyHandyAccount@sip.linphone.org 2020-04-07 07:47:45,320 [DEBUG] [doorpi.action.SingleActions.call] doorpi.action.SingleActions.call loaded 2020-04-07 07:47:45,320 [TRACE] [doorpi.action.handler] action CallAction with args () and kwargs {'number': 'sip:MyHandyAccount@sip.linphone.org'} was added to new evententry OnKeyPressed_virtual.anrufen 2020-04-07 07:47:45,321 [TRACE] [doorpi.conf.config_object] get_keys for section DTMF returns ['"*#"'] 2020-04-07 07:47:45,321 [TRACE] [doorpi.conf.config_object] get_string for key "*#" in section DTMF (default: ) returns out:virtuellerOutput,1,0,3 2020-04-07 07:47:45,322 [DEBUG] [doorpi.action.SingleActions.out] doorpi.action.SingleActions.out loaded 2020-04-07 07:47:45,323 [DEBUG] [doorpi.action.SingleActions.out_triggered] doorpi.action.SingleActions.out_triggered loaded 2020-04-07 07:47:45,323 [TRACE] [doorpi.action.handler] action OutTriggeredAction with args () and kwargs {'stop_pin': 'NoStopPinSet', 'end_value': '0', 'timeout': 3.0, 'pin': 'virtuellerOutput', 'start_value': '1'} was added to new evententry OnDTMF_"*#" 2020-04-07 07:47:45,324 [TRACE] [doorpi.conf.config_object] get_string for key is_alive_led in section DoorPi (default: ) returns 2020-04-07 07:47:45,324 [TRACE] [doorpi.action.handler] fire Event BeforeStartup from doorpi.doorpi asyncron 2020-04-07 07:47:45,325 [DEBUG] [doorpi.action.handler] no actions for event BeforeStartup - skip fire_event BeforeStartup from doorpi.doorpi 2020-04-07 07:47:45,326 [DEBUG] [doorpi.action.handler] no actions for event OnStartup - skip fire_event OnStartup from doorpi.doorpi 2020-04-07 07:47:45,326 [TRACE] [doorpi.action.handler] fire Event AfterStartup from doorpi.doorpi asyncron 2020-04-07 07:47:45,327 [INFO] [doorpi.doorpi] DoorPi started successfully 2020-04-07 07:47:45,328 [INFO] [doorpi.doorpi] BasePath is /usr/local/etc/DoorPi 2020-04-07 07:47:45,328 [DEBUG] [doorpi.action.handler] no actions for event AfterStartup - skip fire_event AfterStartup from doorpi.doorpi 2020-04-07 07:47:45,328 [INFO] [doorpi.doorpi] Weburl is http://HomeserverPi/ 2020-04-07 07:47:54,381 [DEBUG] [watchdog.observers.inotify_buffer] in-event 2020-04-07 07:47:54,383 [DEBUG] [watchdog.observers.inotify_buffer] in-event 2020-04-07 07:47:54,391 [TRACE] [doorpi.action.handler] fire Event OnKeyPressed from doorpi.keyboard.from_filesystem asyncron 2020-04-07 07:47:54,391 [TRACE] [doorpi.action.handler] fire Event OnKeyPressed_anrufen from doorpi.keyboard.from_filesystem asyncron 2020-04-07 07:47:54,392 [DEBUG] [doorpi.action.handler] no actions for event OnKeyPressed - skip fire_event OnKeyPressed from doorpi.keyboard.from_filesystem 2020-04-07 07:47:54,392 [TRACE] [doorpi.action.handler] fire Event OnKeyPressed_virtual.anrufen from doorpi.keyboard.from_filesystem asyncron 2020-04-07 07:47:54,393 [DEBUG] [doorpi.action.handler] no actions for event OnKeyPressed_anrufen - skip fire_event OnKeyPressed_anrufen from doorpi.keyboard.from_filesystem 2020-04-07 07:47:54,393 [TRACE] [doorpi.action.handler] fire Event OnKeyDown from doorpi.keyboard.from_filesystem asyncron 2020-04-07 07:47:54,394 [DEBUG] [doorpi.action.handler] [E97C3G] fire for event OnKeyPressed_virtual.anrufen this actions [] 2020-04-07 07:47:54,394 [TRACE] [doorpi.action.handler] [E97C3G] try to fire action CallAction with args () and kwargs {'number': 'sip:MyHandyAccount@sip.linphone.org'} 2020-04-07 07:47:54,394 [TRACE] [doorpi.action.base] run CallAction with args () and kwargs {'number': 'sip:MyHandyAccount@sip.linphone.org'} 2020-04-07 07:47:54,395 [TRACE] [doorpi.action.handler] fire Event BeforeSipPhoneMakeCall from doorpi.sipphone.from_linphone asyncron 2020-04-07 07:47:54,395 [TRACE] [doorpi.action.handler] fire Event OnKeyDown_anrufen from doorpi.keyboard.from_filesystem asyncron 2020-04-07 07:47:54,395 [TRACE] [doorpi.action.handler] fire Event OnKeyDown_virtual.anrufen from doorpi.keyboard.from_filesystem asyncron 2020-04-07 07:47:54,396 [DEBUG] [doorpi.action.handler] no actions for event OnKeyDown_anrufen - skip fire_event OnKeyDown_anrufen from doorpi.keyboard.from_filesystem 2020-04-07 07:47:54,396 [DEBUG] [doorpi.action.handler] no actions for event OnKeyDown - skip fire_event OnKeyDown from doorpi.keyboard.from_filesystem 2020-04-07 07:47:54,397 [DEBUG] [doorpi.sipphone.from_linphone] call (sip:MyHandyAccount@sip.linphone.org) 2020-04-07 07:47:54,397 [DEBUG] [doorpi.sipphone.from_linphone] no current call -> start new call 2020-04-07 07:47:54,397 [DEBUG] [doorpi.action.handler] no actions for event BeforeSipPhoneMakeCall - skip fire_event BeforeSipPhoneMakeCall from doorpi.sipphone.from_linphone 2020-04-07 07:47:54,397 [DEBUG] [doorpi.sipphone.from_linphone] reset current call start datetime to 2020-04-07 05:47:54.397888 2020-04-07 07:47:54,402 [DEBUG] [doorpi.sipphone.linphone_lib.CallBacks] call_state_changed (2 - Starting outgoing call) 2020-04-07 07:47:54,402 [TRACE] [doorpi.action.handler] fire Event OnCallStateChange from doorpi.sipphone.linphone_lib.CallBacks asyncron 2020-04-07 07:47:54,403 [TRACE] [doorpi.action.handler] fire Event OnMediaRequired from doorpi.sipphone.linphone_lib.CallBacks asyncron 2020-04-07 07:47:54,403 [DEBUG] [doorpi.action.handler] no actions for event OnCallStateChange - skip fire_event OnCallStateChange from doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:54,404 [DEBUG] [doorpi.action.handler] no actions for event OnKeyDown_virtual.anrufen - skip fire_event OnKeyDown_virtual.anrufen from doorpi.keyboard.from_filesystem 2020-04-07 07:47:54,406 [DEBUG] [doorpi.sipphone.linphone_lib.CallBacks] call_state_changed (3 - Outgoing call in progress) 2020-04-07 07:47:54,407 [DEBUG] [doorpi.action.handler] no actions for event OnMediaRequired - skip fire_event OnMediaRequired from doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:54,407 [TRACE] [doorpi.action.handler] fire Event OnCallStateChange from doorpi.sipphone.linphone_lib.CallBacks asyncron 2020-04-07 07:47:54,408 [TRACE] [doorpi.action.handler] fire Event OnSipPhoneMakeCall from doorpi.sipphone.from_linphone asyncron 2020-04-07 07:47:54,408 [DEBUG] [doorpi.action.handler] no actions for event OnCallStateChange - skip fire_event OnCallStateChange from doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:54,408 [TRACE] [doorpi.action.handler] fire Event AfterSipPhoneMakeCall from doorpi.sipphone.from_linphone asyncron 2020-04-07 07:47:54,409 [DEBUG] [doorpi.action.handler] [CBCVOZ] fire for event OnSipPhoneMakeCall this actions [] 2020-04-07 07:47:54,409 [TRACE] [doorpi.action.handler] [CBCVOZ] try to fire action > with args () and kwargs {} 2020-04-07 07:47:54,409 [TRACE] [doorpi.action.base] run SingleAction with args () and kwargs {} 2020-04-07 07:47:54,409 [TRACE] [doorpi.action.handler] fire Event OnPlayerStarted from doorpi.sipphone.linphone_lib.Player asyncron 2020-04-07 07:47:54,410 [TRACE] [doorpi.action.handler] [CBCVOZ] finished fire_event for event_name OnSipPhoneMakeCall 2020-04-07 07:47:54,410 [TRACE] [doorpi.action.handler] [E97C3G] finished fire_event for event_name OnKeyPressed_virtual.anrufen 2020-04-07 07:47:54,411 [DEBUG] [doorpi.action.handler] no actions for event AfterSipPhoneMakeCall - skip fire_event AfterSipPhoneMakeCall from doorpi.sipphone.from_linphone 2020-04-07 07:47:54,411 [DEBUG] [doorpi.action.handler] no actions for event OnPlayerStarted - skip fire_event OnPlayerStarted from doorpi.sipphone.linphone_lib.Player 2020-04-07 07:47:55,101 [DEBUG] [doorpi.sipphone.linphone_lib.CallBacks] call_state_changed (4 - Remote ringing) 2020-04-07 07:47:55,102 [TRACE] [doorpi.action.handler] fire Event OnCallStateChange from doorpi.sipphone.linphone_lib.CallBacks asyncron 2020-04-07 07:47:55,104 [DEBUG] [doorpi.action.handler] no actions for event OnCallStateChange - skip fire_event OnCallStateChange from doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:58,521 [DEBUG] [doorpi.sipphone.linphone_lib.CallBacks] call_state_changed (6 - Connected) 2020-04-07 07:47:58,522 [TRACE] [doorpi.action.handler] fire Event OnCallStateChange from doorpi.sipphone.linphone_lib.CallBacks asyncron 2020-04-07 07:47:58,523 [TRACE] [doorpi.action.handler] fire Event OnCallStateConnect from doorpi.sipphone.linphone_lib.CallBacks asyncron 2020-04-07 07:47:59,274 [DEBUG] [doorpi.sipphone.linphone_lib.CallBacks] call_state_changed (7 - Streams running) 2020-04-07 07:47:59,275 [DEBUG] [doorpi.action.handler] no actions for event OnCallStateChange - skip fire_event OnCallStateChange from doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:59,276 [TRACE] [doorpi.action.handler] fire Event OnCallStateChange from doorpi.sipphone.linphone_lib.CallBacks asyncron 2020-04-07 07:47:59,277 [DEBUG] [doorpi.action.handler] [LGYD1Z] fire for event OnCallStateConnect this actions [] 2020-04-07 07:47:59,278 [TRACE] [doorpi.action.handler] [LGYD1Z] try to fire action > with args () and kwargs {} 2020-04-07 07:47:59,279 [TRACE] [doorpi.action.handler] fire Event AfterCallStateConnect from doorpi.sipphone.linphone_lib.CallBacks asyncron 2020-04-07 07:47:59,279 [TRACE] [doorpi.action.base] run SingleAction with args () and kwargs {} 2020-04-07 07:47:59,280 [DEBUG] [doorpi.action.handler] no actions for event OnCallStateChange - skip fire_event OnCallStateChange from doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:59,281 [TRACE] [doorpi.action.handler] fire Event OnPlayerStopped from doorpi.sipphone.linphone_lib.Player asyncron 2020-04-07 07:47:59,281 [TRACE] [doorpi.action.handler] fire Event OnCallMediaStateChange from doorpi.sipphone.linphone_lib.CallBacks asyncron 2020-04-07 07:47:59,284 [TRACE] [doorpi.action.handler] [LGYD1Z] finished fire_event for event_name OnCallStateConnect 2020-04-07 07:47:59,284 [DEBUG] [doorpi.action.handler] no actions for event OnCallMediaStateChange - skip fire_event OnCallMediaStateChange from doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:47:59,285 [DEBUG] [doorpi.action.handler] no actions for event OnPlayerStopped - skip fire_event OnPlayerStopped from doorpi.sipphone.linphone_lib.Player 2020-04-07 07:47:59,285 [DEBUG] [doorpi.action.handler] no actions for event AfterCallStateConnect - skip fire_event AfterCallStateConnect from doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:48:07,075 [DEBUG] [doorpi.sipphone.linphone_lib.CallBacks] call_state_changed (13 - Call ended) 2020-04-07 07:48:07,075 [TRACE] [doorpi.action.handler] fire Event OnCallStateChange from doorpi.sipphone.linphone_lib.CallBacks asyncron 2020-04-07 07:48:07,076 [TRACE] [doorpi.action.handler] fire Event OnCallStateDisconnect from doorpi.sipphone.linphone_lib.CallBacks asyncron 2020-04-07 07:48:07,077 [TRACE] [doorpi.action.handler] fire Event OnMediaNotRequired from doorpi.sipphone.linphone_lib.CallBacks asyncron 2020-04-07 07:48:07,077 [DEBUG] [doorpi.action.handler] no actions for event OnCallStateChange - skip fire_event OnCallStateChange from doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:48:07,079 [DEBUG] [doorpi.action.handler] [HCDSFQ] fire for event OnCallStateDisconnect this actions [] 2020-04-07 07:48:07,079 [TRACE] [doorpi.action.handler] [HCDSFQ] try to fire action > with args () and kwargs {} 2020-04-07 07:48:07,080 [DEBUG] [doorpi.action.handler] no actions for event OnMediaNotRequired - skip fire_event OnMediaNotRequired from doorpi.sipphone.linphone_lib.CallBacks 2020-04-07 07:48:07,080 [TRACE] [doorpi.action.base] run SingleAction with args () and kwargs {} 2020-04-07 07:48:07,080 [TRACE] [doorpi.action.handler] fire Event OnPlayerStopped from doorpi.sipphone.linphone_lib.Player asyncron 2020-04-07 07:48:07,081 [DEBUG] [doorpi.action.handler] no actions for event OnPlayerStopped - skip fire_event OnPlayerStopped from doorpi.sipphone.linphone_lib.Player 2020-04-07 07:48:07,082 [TRACE] [doorpi.action.handler] [HCDSFQ] finished fire_event for event_name OnCallStateDisconnect 2020-04-07 07:48:07,179 [DEBUG] [doorpi.sipphone.linphone_lib.CallBacks] call_state_changed (18 - Call released) 2020-04-07 07:48:07,180 [TRACE] [doorpi.action.handler] fire Event OnCallStateChange from doorpi.sipphone.linphone_lib.CallBacks asyncron 2020-04-07 07:48:07,182 [DEBUG] [doorpi.action.handler] no actions for event OnCallStateChange - skip fire_event OnCallStateChange from doorpi.sipphone.linphone_lib.CallBacks