2021-03-03 19:11:07,213 [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 2021-03-03 19:11:07,214 [DEBUG] [doorpi.main] loaded with arguments: ['/usr/local/bin/doorpi_cli', '--trace'] 2021-03-03 19:11:07,215 [DEBUG] [doorpi.doorpi] run 2021-03-03 19:11:07,215 [DEBUG] [doorpi.doorpi] prepare 2021-03-03 19:11:07,215 [DEBUG] [doorpi.doorpi] given arguments argv: Namespace(configfile=None, debug=False, test=False, trace=True) 2021-03-03 19:11:07,217 [INFO] [doorpi.conf.config_object] use configfile: /usr/local/etc/DoorPi/conf/doorpi.ini 2021-03-03 19:11:07,224 [DEBUG] [doorpi.conf.config_object] __init__ 2021-03-03 19:11:07,225 [TRACE] [doorpi.conf.config_object] get_from_config 2021-03-03 19:11:07,229 [TRACE] [doorpi.conf.config_object] get_string for key base_path in section DoorPi (default: /usr/local/etc/DoorPi) returns /usr/local/etc/DoorPi 2021-03-03 19:11:07,229 [TRACE] [doorpi.conf.config_object] get_string for key eventlog in section DoorPi (default: !BASEPATH!/conf/eventlog.db) returns !BASEPATH!/conf/eventlog.db 2021-03-03 19:11:07,230 [DEBUG] [doorpi.conf.config_object] parse string "!BASEPATH!/conf/eventlog.db" to "/usr/local/etc/DoorPi/conf/eventlog.db" 2021-03-03 19:11:07,232 [TRACE] [doorpi.action.handler] register Event BeforeStartup from doorpi.doorpi 2021-03-03 19:11:07,233 [DEBUG] [doorpi.action.handler] event_source doorpi.doorpi was added 2021-03-03 19:11:07,233 [TRACE] [doorpi.action.handler] added event_name BeforeStartup and registered source doorpi.doorpi 2021-03-03 19:11:07,233 [TRACE] [doorpi.action.handler] register Event OnStartup from doorpi.doorpi 2021-03-03 19:11:07,234 [TRACE] [doorpi.action.handler] added event_name OnStartup and registered source doorpi.doorpi 2021-03-03 19:11:07,234 [TRACE] [doorpi.action.handler] register Event AfterStartup from doorpi.doorpi 2021-03-03 19:11:07,234 [TRACE] [doorpi.action.handler] added event_name AfterStartup and registered source doorpi.doorpi 2021-03-03 19:11:07,234 [TRACE] [doorpi.action.handler] register Event BeforeShutdown from doorpi.doorpi 2021-03-03 19:11:07,234 [TRACE] [doorpi.action.handler] added event_name BeforeShutdown and registered source doorpi.doorpi 2021-03-03 19:11:07,235 [TRACE] [doorpi.action.handler] register Event OnShutdown from doorpi.doorpi 2021-03-03 19:11:07,235 [TRACE] [doorpi.action.handler] added event_name OnShutdown and registered source doorpi.doorpi 2021-03-03 19:11:07,235 [TRACE] [doorpi.action.handler] register Event AfterShutdown from doorpi.doorpi 2021-03-03 19:11:07,235 [TRACE] [doorpi.action.handler] added event_name AfterShutdown and registered source doorpi.doorpi 2021-03-03 19:11:07,236 [DEBUG] [doorpi.action.SingleActions.time_tick] doorpi.action.SingleActions.time_tick loaded 2021-03-03 19:11:07,237 [DEBUG] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was added 2021-03-03 19:11:07,238 [TRACE] [doorpi.action.handler] action TimeTickDestroyAction with args () and kwargs {} was added to new evententry OnShutdown 2021-03-03 19:11:07,238 [TRACE] [doorpi.action.handler] action TimeTickAction with args ('!last_tick!',) and kwargs {} was added to new evententry OnTimeTick 2021-03-03 19:11:07,239 [TRACE] [doorpi.conf.config_object] get_string for key ip in section DoorPiWeb (default: ) returns 2021-03-03 19:11:07,239 [TRACE] [doorpi.conf.config_object] get_integer for key port in section DoorPiWeb (default: 80) returns 8081 2021-03-03 19:11:07,241 [INFO] [doorpi.status.webserver] Initiating WebService at ip and port 8081 2021-03-03 19:11:07,241 [TRACE] [doorpi.action.handler] register Event OnWebServerStart from doorpi.status.webserver 2021-03-03 19:11:07,242 [DEBUG] [doorpi.action.handler] event_source doorpi.status.webserver was added 2021-03-03 19:11:07,242 [TRACE] [doorpi.action.handler] added event_name OnWebServerStart and registered source doorpi.status.webserver 2021-03-03 19:11:07,242 [TRACE] [doorpi.action.handler] register Event OnWebServerStop from doorpi.status.webserver 2021-03-03 19:11:07,242 [TRACE] [doorpi.action.handler] added event_name OnWebServerStop and registered source doorpi.status.webserver 2021-03-03 19:11:07,243 [TRACE] [doorpi.conf.config_object] get_string for key www in section DoorPiWeb (default: !BASEPATH!/../DoorPiWeb) returns !BASEPATH!/../DoorPiWeb 2021-03-03 19:11:07,243 [DEBUG] [doorpi.conf.config_object] parse string "!BASEPATH!/../DoorPiWeb" to "/usr/local/etc/DoorPi/../DoorPiWeb" 2021-03-03 19:11:07,244 [TRACE] [doorpi.conf.config_object] get_string for key indexfile in section DoorPiWeb (default: index.html) returns index.html 2021-03-03 19:11:07,244 [DEBUG] [doorpi.conf.config_object] parse string "index.html" to "index.html" 2021-03-03 19:11:07,244 [TRACE] [doorpi.conf.config_object] get_string for key loginfile in section DoorPiWeb (default: login.html) returns login.html 2021-03-03 19:11:07,245 [DEBUG] [doorpi.conf.config_object] parse string "login.html" to "login.html" 2021-03-03 19:11:07,245 [TRACE] [doorpi.conf.config_object] get_string for key public in section DoorPiWeb (default: AREA_public) returns AREA_public 2021-03-03 19:11:07,246 [DEBUG] [doorpi.conf.config_object] parse string "AREA_public" to "AREA_public" 2021-03-03 19:11:07,246 [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 2021-03-03 19:11:07,246 [DEBUG] [doorpi.conf.config_object] parse string "http://motom001.github.io/DoorPiWeb" to "http://motom001.github.io/DoorPiWeb" 2021-03-03 19:11:07,247 [TRACE] [doorpi.conf.config_object] get_keys for section WritePermission returns ['administrators'] 2021-03-03 19:11:07,247 [TRACE] [doorpi.conf.config_object] get_keys for section ReadPermission returns ['administrators'] 2021-03-03 19:11:07,247 [TRACE] [doorpi.conf.config_object] get_keys for section Group returns ['administrators'] 2021-03-03 19:11:07,247 [WARNING] [root] section User not found in configfile 2021-03-03 19:11:07,248 [TRACE] [doorpi.conf.config_object] get_keys for section User returns [] 2021-03-03 19:11:07,248 [TRACE] [doorpi.conf.config_object] get_list for key administrators in section Group (default: []) returns ['admin'] 2021-03-03 19:11:07,248 [TRACE] [doorpi.conf.config_object] get_sections returns ['Group', 'nextion_keyboard', 'ReadPermission', 'DTMF', 'EVENT_OnStartup', 'DoorPiWeb', 'EVENT_OnKeyPressed_nextion.54542121', 'WritePermission', 'rfidreader_InputPins', 'rfidreader_keyboard', 'EVENT_OnKeyPressed_rfidreader.0010327614', 'nextion_InputPins', 'onboardpins_OutputPins', 'nextion_OutputPins', 'EVENT_OnKeyPressed_rfidreader.0004594429', 'EVENT_OnSipPhoneMakeCall', 'keyboards', 'AdminNumbers', 'SIP-Phone', 'EVENT_OnKeyPressed_onboardpins.3', 'EVENT_OnKeyPressed_onboardpins.1', 'EVENT_OnKeyPressed_onboardpins.0', 'EVENT_OnKeyPressed_rfidreader.0010371593', 'onboardpins_InputPins', 'DoorPi'] 2021-03-03 19:11:07,248 [TRACE] [doorpi.conf.config_object] get_list for key administrators in section WritePermission (default: []) returns ['public'] 2021-03-03 19:11:07,249 [TRACE] [doorpi.conf.config_object] get_list for key administrators in section ReadPermission (default: []) returns ['public'] 2021-03-03 19:11:07,249 [ERROR] [doorpi.status.webserver] user admin is assigned to group administrators but doesn't exist as user 2021-03-03 19:11:07,249 [ERROR] [doorpi.status.webserver] module public doesn't exist but is assigned to group administrators in WritePermission 2021-03-03 19:11:07,249 [ERROR] [doorpi.status.webserver] module public doesn't exist but is assigned to group administrators in ReadPermission 2021-03-03 19:11:07,250 [TRACE] [doorpi.action.handler] action WebServerStartupAction with args () and kwargs {} was added to new evententry OnWebServerStart 2021-03-03 19:11:07,250 [TRACE] [doorpi.action.handler] action WebServerShutdownAction with args () and kwargs {} was added to event OnShutdown 2021-03-03 19:11:07,250 [TRACE] [doorpi.action.handler] fire Event OnWebServerStart from doorpi.status.webserver asyncron 2021-03-03 19:11:07,251 [TRACE] [doorpi.action.handler] register Event OnWebServerRequest from doorpi.status.webserver_lib.request_handler 2021-03-03 19:11:07,252 [DEBUG] [doorpi.action.handler] event_source doorpi.status.webserver_lib.request_handler was added 2021-03-03 19:11:07,252 [DEBUG] [doorpi.action.handler] [0F35GU] fire for event OnWebServerStart this actions [] 2021-03-03 19:11:07,252 [TRACE] [doorpi.action.handler] added event_name OnWebServerRequest and registered source doorpi.status.webserver_lib.request_handler 2021-03-03 19:11:07,253 [TRACE] [doorpi.action.handler] [0F35GU] try to fire action WebServerStartupAction with args () and kwargs {} 2021-03-03 19:11:07,253 [TRACE] [doorpi.action.handler] register Event OnWebServerRequestGet from doorpi.status.webserver_lib.request_handler 2021-03-03 19:11:07,253 [TRACE] [doorpi.action.base] run WebServerStartupAction with args () and kwargs {} 2021-03-03 19:11:07,253 [TRACE] [doorpi.action.handler] added event_name OnWebServerRequestGet and registered source doorpi.status.webserver_lib.request_handler 2021-03-03 19:11:07,254 [TRACE] [doorpi.action.handler] register Event OnWebServerRequestPost from doorpi.status.webserver_lib.request_handler 2021-03-03 19:11:07,254 [TRACE] [doorpi.action.handler] added event_name OnWebServerRequestPost and registered source doorpi.status.webserver_lib.request_handler 2021-03-03 19:11:07,254 [TRACE] [doorpi.action.handler] register Event OnWebServerVirtualResource from doorpi.status.webserver_lib.request_handler 2021-03-03 19:11:07,254 [TRACE] [doorpi.action.handler] added event_name OnWebServerVirtualResource and registered source doorpi.status.webserver_lib.request_handler 2021-03-03 19:11:07,255 [TRACE] [doorpi.action.handler] register Event OnWebServerRealResource from doorpi.status.webserver_lib.request_handler 2021-03-03 19:11:07,255 [TRACE] [doorpi.action.handler] added event_name OnWebServerRealResource and registered source doorpi.status.webserver_lib.request_handler 2021-03-03 19:11:07,255 [TRACE] [doorpi.action.handler] register Event OnFireEvent from doorpi.status.webserver_lib.request_handler 2021-03-03 19:11:07,255 [TRACE] [doorpi.action.handler] added event_name OnFireEvent and registered source doorpi.status.webserver_lib.request_handler 2021-03-03 19:11:07,256 [TRACE] [doorpi.action.handler] register Event OnConfigKeySet from doorpi.status.webserver_lib.request_handler 2021-03-03 19:11:07,256 [TRACE] [doorpi.action.handler] added event_name OnConfigKeySet and registered source doorpi.status.webserver_lib.request_handler 2021-03-03 19:11:07,256 [TRACE] [doorpi.action.handler] register Event OnConfigKeyDelete from doorpi.status.webserver_lib.request_handler 2021-03-03 19:11:07,256 [TRACE] [doorpi.action.handler] added event_name OnConfigKeyDelete and registered source doorpi.status.webserver_lib.request_handler 2021-03-03 19:11:07,256 [TRACE] [doorpi.conf.config_object] get_keys for section keyboards returns ['rfidreader', 'nextion', 'onboardpins'] 2021-03-03 19:11:07,257 [INFO] [doorpi.keyboard.KeyboardInterface] using multi-keyboard mode (keyboards: rfidreader, nextion, onboardpins) 2021-03-03 19:11:07,257 [INFO] [doorpi.keyboard.KeyboardInterface] trying to add keyboard 'rfidreader' to handler 2021-03-03 19:11:07,257 [TRACE] [doorpi.conf.config_object] get_string for key rfidreader in section keyboards (default: dummy) returns hxgreader 2021-03-03 19:11:07,257 [TRACE] [doorpi.conf.config_object] get_keys for section rfidreader_InputPins returns ['0010371593', '0010327614', '0004594429'] 2021-03-03 19:11:07,258 [WARNING] [root] section rfidreader_OutputPins not found in configfile 2021-03-03 19:11:07,258 [TRACE] [doorpi.conf.config_object] get_keys for section rfidreader_OutputPins returns [] 2021-03-03 19:11:07,258 [TRACE] [doorpi.conf.config_object] get_integer for key bouncetime in section rfidreader_keyboard (default: 2000) returns 5000.0 2021-03-03 19:11:07,258 [TRACE] [doorpi.conf.config_object] get_integer for key polarity in section rfidreader_keyboard (default: 0) returns 0 2021-03-03 19:11:07,259 [TRACE] [doorpi.conf.config_object] get_boolean for key pressed_on_keydown in section rfidreader_keyboard (default: True) returns True 2021-03-03 19:11:07,319 [DEBUG] [doorpi.keyboard.from_hxgreader] doorpi.keyboard.from_hxgreader loaded 2021-03-03 19:11:07,319 [DEBUG] [doorpi.keyboard.from_hxgreader] __init__ (input_pins = ['0010371593', '0010327614', '0004594429']) 2021-03-03 19:11:07,320 [TRACE] [doorpi.action.handler] register Event OnFoundTag from doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,320 [DEBUG] [doorpi.action.handler] event_source doorpi.keyboard.from_hxgreader was added 2021-03-03 19:11:07,320 [TRACE] [doorpi.action.handler] added event_name OnFoundTag and registered source doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,320 [TRACE] [doorpi.action.handler] register Event OnFoundUnknownTag from doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,321 [TRACE] [doorpi.action.handler] added event_name OnFoundUnknownTag and registered source doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,321 [TRACE] [doorpi.action.handler] register Event OnFoundKnownTag from doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,321 [TRACE] [doorpi.action.handler] added event_name OnFoundKnownTag and registered source doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,322 [TRACE] [doorpi.keyboard.from_hxgreader] 1 input devices found 2021-03-03 19:11:07,323 [TRACE] [doorpi.keyboard.from_hxgreader] HXGCoLtd Keyboard 2021-03-03 19:11:07,323 [TRACE] [doorpi.conf.config_object] get_string for key device in section rfidreader_keyboard (default: HXGCoLtd Keyboard) returns HXGCoLtd Keyboard 2021-03-03 19:11:07,323 [TRACE] [doorpi.action.handler] register Event OnKeyPressed from doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,324 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed and registered source doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,324 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_0010371593 from doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,324 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_0010371593 and registered source doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,324 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_rfidreader.0010371593 from doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,324 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_rfidreader.0010371593 and registered source doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,325 [TRACE] [doorpi.action.handler] register Event OnKeyUp from doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,325 [TRACE] [doorpi.action.handler] added event_name OnKeyUp and registered source doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,325 [TRACE] [doorpi.action.handler] register Event OnKeyUp_0010371593 from doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,325 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_0010371593 and registered source doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,325 [TRACE] [doorpi.action.handler] register Event OnKeyUp_rfidreader.0010371593 from doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,326 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_rfidreader.0010371593 and registered source doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,326 [TRACE] [doorpi.action.handler] register Event OnKeyDown from doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,326 [TRACE] [doorpi.action.handler] added event_name OnKeyDown and registered source doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,326 [TRACE] [doorpi.action.handler] register Event OnKeyDown_0010371593 from doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,326 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_0010371593 and registered source doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,327 [TRACE] [doorpi.action.handler] register Event OnKeyDown_rfidreader.0010371593 from doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,327 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_rfidreader.0010371593 and registered source doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,327 [TRACE] [doorpi.action.handler] register Event OnKeyPressed from doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,327 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyPressed from source doorpi.keyboard.from_hxgreader is already known 2021-03-03 19:11:07,328 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_0010327614 from doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,328 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_0010327614 and registered source doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,328 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_rfidreader.0010327614 from doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,328 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_rfidreader.0010327614 and registered source doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,328 [TRACE] [doorpi.action.handler] register Event OnKeyUp from doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,329 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyUp from source doorpi.keyboard.from_hxgreader is already known 2021-03-03 19:11:07,329 [TRACE] [doorpi.action.handler] register Event OnKeyUp_0010327614 from doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,329 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_0010327614 and registered source doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,329 [TRACE] [doorpi.action.handler] register Event OnKeyUp_rfidreader.0010327614 from doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,329 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_rfidreader.0010327614 and registered source doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,330 [TRACE] [doorpi.action.handler] register Event OnKeyDown from doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,330 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyDown from source doorpi.keyboard.from_hxgreader is already known 2021-03-03 19:11:07,330 [TRACE] [doorpi.action.handler] register Event OnKeyDown_0010327614 from doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,330 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_0010327614 and registered source doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,330 [TRACE] [doorpi.action.handler] register Event OnKeyDown_rfidreader.0010327614 from doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,331 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_rfidreader.0010327614 and registered source doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,331 [TRACE] [doorpi.action.handler] register Event OnKeyPressed from doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,331 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyPressed from source doorpi.keyboard.from_hxgreader is already known 2021-03-03 19:11:07,331 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_0004594429 from doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,331 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_0004594429 and registered source doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,332 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_rfidreader.0004594429 from doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,332 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_rfidreader.0004594429 and registered source doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,332 [TRACE] [doorpi.action.handler] register Event OnKeyUp from doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,332 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyUp from source doorpi.keyboard.from_hxgreader is already known 2021-03-03 19:11:07,333 [TRACE] [doorpi.action.handler] register Event OnKeyUp_0004594429 from doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,333 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_0004594429 and registered source doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,333 [TRACE] [doorpi.action.handler] register Event OnKeyUp_rfidreader.0004594429 from doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,333 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_rfidreader.0004594429 and registered source doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,333 [TRACE] [doorpi.action.handler] register Event OnKeyDown from doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,334 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyDown from source doorpi.keyboard.from_hxgreader is already known 2021-03-03 19:11:07,334 [TRACE] [doorpi.action.handler] register Event OnKeyDown_0004594429 from doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,334 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_0004594429 and registered source doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,334 [TRACE] [doorpi.action.handler] register Event OnKeyDown_rfidreader.0004594429 from doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,334 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_rfidreader.0004594429 and registered source doorpi.keyboard.from_hxgreader 2021-03-03 19:11:07,335 [TRACE] [doorpi.action.handler] action KeyboardDestroyAction with args () and kwargs {} was added to event OnShutdown 2021-03-03 19:11:07,336 [WARNING] [root] section rfidreader_OutputPins not found in configfile 2021-03-03 19:11:07,336 [TRACE] [doorpi.conf.config_object] get_keys for section rfidreader_OutputPins returns [] 2021-03-03 19:11:07,336 [INFO] [doorpi.keyboard.KeyboardInterface] trying to add keyboard 'nextion' to handler 2021-03-03 19:11:07,336 [TRACE] [doorpi.conf.config_object] get_string for key nextion in section keyboards (default: dummy) returns nextion 2021-03-03 19:11:07,337 [TRACE] [doorpi.conf.config_object] get_keys for section nextion_InputPins returns ['22085', '54542121', '54542120'] 2021-03-03 19:11:07,337 [TRACE] [doorpi.conf.config_object] get_keys for section nextion_OutputPins returns ['sleep', 'show_pad3', 'show_pad2', 'wakeup', 'show_pad0', 'show_pad1', 'show_pad4', 'show_pad5'] 2021-03-03 19:11:07,337 [TRACE] [doorpi.conf.config_object] get_integer for key bouncetime in section nextion_keyboard (default: 2000) returns 2000.0 2021-03-03 19:11:07,337 [TRACE] [doorpi.conf.config_object] get_integer for key polarity in section nextion_keyboard (default: 0) returns 0 2021-03-03 19:11:07,338 [TRACE] [doorpi.conf.config_object] get_boolean for key pressed_on_keydown in section nextion_keyboard (default: True) returns True 2021-03-03 19:11:07,338 [DEBUG] [doorpi.keyboard.from_nextion] doorpi.keyboard.from_nextion loaded 2021-03-03 19:11:07,346 [DEBUG] [doorpi.keyboard.from_nextion] FileSystem.__init__(input_pins = ['22085', '54542121', '54542120'], output_pins = ['sleep', 'show_pad3', 'show_pad2', 'wakeup', 'show_pad0', 'show_pad1', 'show_pad4', 'show_pad5']) 2021-03-03 19:11:07,347 [TRACE] [doorpi.action.handler] register Event OnKeyPressed from doorpi.keyboard.from_nextion 2021-03-03 19:11:07,347 [DEBUG] [doorpi.action.handler] event_source doorpi.keyboard.from_nextion was added 2021-03-03 19:11:07,347 [TRACE] [doorpi.action.handler] added event_source doorpi.keyboard.from_nextion to existing event OnKeyPressed 2021-03-03 19:11:07,347 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_22085 from doorpi.keyboard.from_nextion 2021-03-03 19:11:07,348 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_22085 and registered source doorpi.keyboard.from_nextion 2021-03-03 19:11:07,348 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_nextion.22085 from doorpi.keyboard.from_nextion 2021-03-03 19:11:07,348 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_nextion.22085 and registered source doorpi.keyboard.from_nextion 2021-03-03 19:11:07,348 [TRACE] [doorpi.action.handler] register Event OnKeyUp from doorpi.keyboard.from_nextion 2021-03-03 19:11:07,348 [TRACE] [doorpi.action.handler] added event_source doorpi.keyboard.from_nextion to existing event OnKeyUp 2021-03-03 19:11:07,349 [TRACE] [doorpi.action.handler] register Event OnKeyUp_22085 from doorpi.keyboard.from_nextion 2021-03-03 19:11:07,349 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_22085 and registered source doorpi.keyboard.from_nextion 2021-03-03 19:11:07,349 [TRACE] [doorpi.action.handler] register Event OnKeyUp_nextion.22085 from doorpi.keyboard.from_nextion 2021-03-03 19:11:07,349 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_nextion.22085 and registered source doorpi.keyboard.from_nextion 2021-03-03 19:11:07,349 [TRACE] [doorpi.action.handler] register Event OnKeyDown from doorpi.keyboard.from_nextion 2021-03-03 19:11:07,350 [TRACE] [doorpi.action.handler] added event_source doorpi.keyboard.from_nextion to existing event OnKeyDown 2021-03-03 19:11:07,350 [TRACE] [doorpi.action.handler] register Event OnKeyDown_22085 from doorpi.keyboard.from_nextion 2021-03-03 19:11:07,350 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_22085 and registered source doorpi.keyboard.from_nextion 2021-03-03 19:11:07,350 [TRACE] [doorpi.action.handler] register Event OnKeyDown_nextion.22085 from doorpi.keyboard.from_nextion 2021-03-03 19:11:07,350 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_nextion.22085 and registered source doorpi.keyboard.from_nextion 2021-03-03 19:11:07,351 [TRACE] [doorpi.action.handler] register Event OnKeyPressed from doorpi.keyboard.from_nextion 2021-03-03 19:11:07,351 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyPressed from source doorpi.keyboard.from_nextion is already known 2021-03-03 19:11:07,351 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_54542121 from doorpi.keyboard.from_nextion 2021-03-03 19:11:07,351 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_54542121 and registered source doorpi.keyboard.from_nextion 2021-03-03 19:11:07,351 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_nextion.54542121 from doorpi.keyboard.from_nextion 2021-03-03 19:11:07,352 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_nextion.54542121 and registered source doorpi.keyboard.from_nextion 2021-03-03 19:11:07,352 [TRACE] [doorpi.action.handler] register Event OnKeyUp from doorpi.keyboard.from_nextion 2021-03-03 19:11:07,352 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyUp from source doorpi.keyboard.from_nextion is already known 2021-03-03 19:11:07,352 [TRACE] [doorpi.action.handler] register Event OnKeyUp_54542121 from doorpi.keyboard.from_nextion 2021-03-03 19:11:07,352 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_54542121 and registered source doorpi.keyboard.from_nextion 2021-03-03 19:11:07,353 [TRACE] [doorpi.action.handler] register Event OnKeyUp_nextion.54542121 from doorpi.keyboard.from_nextion 2021-03-03 19:11:07,353 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_nextion.54542121 and registered source doorpi.keyboard.from_nextion 2021-03-03 19:11:07,353 [TRACE] [doorpi.action.handler] register Event OnKeyDown from doorpi.keyboard.from_nextion 2021-03-03 19:11:07,353 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyDown from source doorpi.keyboard.from_nextion is already known 2021-03-03 19:11:07,353 [TRACE] [doorpi.action.handler] register Event OnKeyDown_54542121 from doorpi.keyboard.from_nextion 2021-03-03 19:11:07,354 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_54542121 and registered source doorpi.keyboard.from_nextion 2021-03-03 19:11:07,354 [TRACE] [doorpi.action.handler] register Event OnKeyDown_nextion.54542121 from doorpi.keyboard.from_nextion 2021-03-03 19:11:07,354 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_nextion.54542121 and registered source doorpi.keyboard.from_nextion 2021-03-03 19:11:07,354 [TRACE] [doorpi.action.handler] register Event OnKeyPressed from doorpi.keyboard.from_nextion 2021-03-03 19:11:07,355 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyPressed from source doorpi.keyboard.from_nextion is already known 2021-03-03 19:11:07,355 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_54542120 from doorpi.keyboard.from_nextion 2021-03-03 19:11:07,355 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_54542120 and registered source doorpi.keyboard.from_nextion 2021-03-03 19:11:07,355 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_nextion.54542120 from doorpi.keyboard.from_nextion 2021-03-03 19:11:07,355 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_nextion.54542120 and registered source doorpi.keyboard.from_nextion 2021-03-03 19:11:07,356 [TRACE] [doorpi.action.handler] register Event OnKeyUp from doorpi.keyboard.from_nextion 2021-03-03 19:11:07,356 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyUp from source doorpi.keyboard.from_nextion is already known 2021-03-03 19:11:07,356 [TRACE] [doorpi.action.handler] register Event OnKeyUp_54542120 from doorpi.keyboard.from_nextion 2021-03-03 19:11:07,356 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_54542120 and registered source doorpi.keyboard.from_nextion 2021-03-03 19:11:07,356 [TRACE] [doorpi.action.handler] register Event OnKeyUp_nextion.54542120 from doorpi.keyboard.from_nextion 2021-03-03 19:11:07,357 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_nextion.54542120 and registered source doorpi.keyboard.from_nextion 2021-03-03 19:11:07,357 [TRACE] [doorpi.action.handler] register Event OnKeyDown from doorpi.keyboard.from_nextion 2021-03-03 19:11:07,357 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyDown from source doorpi.keyboard.from_nextion is already known 2021-03-03 19:11:07,357 [TRACE] [doorpi.action.handler] register Event OnKeyDown_54542120 from doorpi.keyboard.from_nextion 2021-03-03 19:11:07,357 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_54542120 and registered source doorpi.keyboard.from_nextion 2021-03-03 19:11:07,358 [TRACE] [doorpi.action.handler] register Event OnKeyDown_nextion.54542120 from doorpi.keyboard.from_nextion 2021-03-03 19:11:07,358 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_nextion.54542120 and registered source doorpi.keyboard.from_nextion 2021-03-03 19:11:07,358 [DEBUG] [doorpi.conf.config_object] create new key port in section nextion_keyboard with value '/dev/ttyUSB0' 2021-03-03 19:11:07,358 [TRACE] [doorpi.conf.config_object] get_string for key port in section nextion_keyboard (default: /dev/ttyUSB0) returns /dev/ttyUSB0 2021-03-03 19:11:07,359 [TRACE] [doorpi.conf.config_object] get_integer for key baudrate in section nextion_keyboard (default: 9600) returns 9600 2021-03-03 19:11:07,359 [DEBUG] [doorpi.conf.config_object] create new key input_stop_flag in section nextion_keyboard with value ' ' 2021-03-03 19:11:07,359 [TRACE] [doorpi.conf.config_object] get_string for key input_stop_flag in section nextion_keyboard (default: ) returns 2021-03-03 19:11:07,359 [TRACE] [doorpi.conf.config_object] get_integer for key input_max_size in section nextion_keyboard (default: 255) returns 255 2021-03-03 19:11:07,444 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to event OnShutdown 2021-03-03 19:11:07,444 [TRACE] [doorpi.conf.config_object] get_keys for section nextion_OutputPins returns ['sleep', 'show_pad3', 'show_pad2', 'wakeup', 'show_pad0', 'show_pad1', 'show_pad4', 'show_pad5'] 2021-03-03 19:11:07,445 [TRACE] [doorpi.conf.config_object] get_string for key sleep in section nextion_OutputPins (default: ) returns sleep=1 2021-03-03 19:11:07,445 [TRACE] [doorpi.conf.config_object] get_string for key show_pad3 in section nextion_OutputPins (default: ) returns page 3 2021-03-03 19:11:07,445 [TRACE] [doorpi.conf.config_object] get_string for key show_pad2 in section nextion_OutputPins (default: ) returns page 2 2021-03-03 19:11:07,445 [TRACE] [doorpi.conf.config_object] get_string for key wakeup in section nextion_OutputPins (default: ) returns sleep=0 2021-03-03 19:11:07,446 [TRACE] [doorpi.conf.config_object] get_string for key show_pad0 in section nextion_OutputPins (default: ) returns page 0 2021-03-03 19:11:07,446 [TRACE] [doorpi.conf.config_object] get_string for key show_pad1 in section nextion_OutputPins (default: ) returns page 1 2021-03-03 19:11:07,446 [TRACE] [doorpi.conf.config_object] get_string for key show_pad4 in section nextion_OutputPins (default: ) returns page 4 2021-03-03 19:11:07,446 [TRACE] [doorpi.conf.config_object] get_string for key show_pad5 in section nextion_OutputPins (default: ) returns page 5 2021-03-03 19:11:07,447 [INFO] [doorpi.keyboard.KeyboardInterface] trying to add keyboard 'onboardpins' to handler 2021-03-03 19:11:07,447 [TRACE] [doorpi.conf.config_object] get_string for key onboardpins in section keyboards (default: dummy) returns piface 2021-03-03 19:11:07,447 [TRACE] [doorpi.conf.config_object] get_keys for section onboardpins_InputPins returns ['1', '0', '3', '2', '5', '4', '7', '6'] 2021-03-03 19:11:07,447 [TRACE] [doorpi.conf.config_object] get_keys for section onboardpins_OutputPins returns ['0'] 2021-03-03 19:11:07,448 [TRACE] [doorpi.conf.config_object] get_integer for key bouncetime in section onboardpins_keyboard (default: 2000) returns 2000.0 2021-03-03 19:11:07,448 [TRACE] [doorpi.conf.config_object] get_integer for key polarity in section onboardpins_keyboard (default: 0) returns 0 2021-03-03 19:11:07,448 [TRACE] [doorpi.conf.config_object] get_boolean for key pressed_on_keydown in section onboardpins_keyboard (default: True) returns True 2021-03-03 19:11:07,449 [DEBUG] [doorpi.keyboard.from_piface] doorpi.keyboard.from_piface loaded 2021-03-03 19:11:07,466 [DEBUG] [doorpi.keyboard.from_piface] __init__(input_pins = ['1', '0', '3', '2', '5', '4', '7', '6'], output_pins = ['0'], polarity = 0) 2021-03-03 19:11:07,518 [TRACE] [doorpi.action.handler] register Event OnKeyPressed from doorpi.keyboard.from_piface 2021-03-03 19:11:07,519 [DEBUG] [doorpi.action.handler] event_source doorpi.keyboard.from_piface was added 2021-03-03 19:11:07,519 [TRACE] [doorpi.action.handler] added event_source doorpi.keyboard.from_piface to existing event OnKeyPressed 2021-03-03 19:11:07,519 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_1 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,519 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_1 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,519 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_onboardpins.1 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,520 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_onboardpins.1 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,520 [TRACE] [doorpi.action.handler] register Event OnKeyUp from doorpi.keyboard.from_piface 2021-03-03 19:11:07,520 [TRACE] [doorpi.action.handler] added event_source doorpi.keyboard.from_piface to existing event OnKeyUp 2021-03-03 19:11:07,520 [TRACE] [doorpi.action.handler] register Event OnKeyUp_1 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,520 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_1 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,521 [TRACE] [doorpi.action.handler] register Event OnKeyUp_onboardpins.1 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,521 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_onboardpins.1 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,521 [TRACE] [doorpi.action.handler] register Event OnKeyDown from doorpi.keyboard.from_piface 2021-03-03 19:11:07,522 [TRACE] [doorpi.action.handler] added event_source doorpi.keyboard.from_piface to existing event OnKeyDown 2021-03-03 19:11:07,522 [TRACE] [doorpi.action.handler] register Event OnKeyDown_1 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,522 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_1 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,522 [TRACE] [doorpi.action.handler] register Event OnKeyDown_onboardpins.1 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,523 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_onboardpins.1 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,523 [TRACE] [doorpi.action.handler] register Event OnKeyPressed from doorpi.keyboard.from_piface 2021-03-03 19:11:07,523 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyPressed from source doorpi.keyboard.from_piface is already known 2021-03-03 19:11:07,523 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_0 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,523 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_0 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,524 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_onboardpins.0 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,524 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_onboardpins.0 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,524 [TRACE] [doorpi.action.handler] register Event OnKeyUp from doorpi.keyboard.from_piface 2021-03-03 19:11:07,524 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyUp from source doorpi.keyboard.from_piface is already known 2021-03-03 19:11:07,524 [TRACE] [doorpi.action.handler] register Event OnKeyUp_0 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,525 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_0 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,525 [TRACE] [doorpi.action.handler] register Event OnKeyUp_onboardpins.0 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,525 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_onboardpins.0 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,525 [TRACE] [doorpi.action.handler] register Event OnKeyDown from doorpi.keyboard.from_piface 2021-03-03 19:11:07,525 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyDown from source doorpi.keyboard.from_piface is already known 2021-03-03 19:11:07,526 [TRACE] [doorpi.action.handler] register Event OnKeyDown_0 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,526 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_0 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,526 [TRACE] [doorpi.action.handler] register Event OnKeyDown_onboardpins.0 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,526 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_onboardpins.0 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,527 [TRACE] [doorpi.action.handler] register Event OnKeyPressed from doorpi.keyboard.from_piface 2021-03-03 19:11:07,527 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyPressed from source doorpi.keyboard.from_piface is already known 2021-03-03 19:11:07,527 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_3 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,527 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_3 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,527 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_onboardpins.3 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,528 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_onboardpins.3 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,528 [TRACE] [doorpi.action.handler] register Event OnKeyUp from doorpi.keyboard.from_piface 2021-03-03 19:11:07,528 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyUp from source doorpi.keyboard.from_piface is already known 2021-03-03 19:11:07,528 [TRACE] [doorpi.action.handler] register Event OnKeyUp_3 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,528 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_3 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,529 [TRACE] [doorpi.action.handler] register Event OnKeyUp_onboardpins.3 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,529 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_onboardpins.3 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,529 [TRACE] [doorpi.action.handler] register Event OnKeyDown from doorpi.keyboard.from_piface 2021-03-03 19:11:07,529 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyDown from source doorpi.keyboard.from_piface is already known 2021-03-03 19:11:07,529 [TRACE] [doorpi.action.handler] register Event OnKeyDown_3 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,530 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_3 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,530 [TRACE] [doorpi.action.handler] register Event OnKeyDown_onboardpins.3 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,530 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_onboardpins.3 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,530 [TRACE] [doorpi.action.handler] register Event OnKeyPressed from doorpi.keyboard.from_piface 2021-03-03 19:11:07,531 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyPressed from source doorpi.keyboard.from_piface is already known 2021-03-03 19:11:07,531 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_2 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,531 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_2 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,531 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_onboardpins.2 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,531 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_onboardpins.2 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,532 [TRACE] [doorpi.action.handler] register Event OnKeyUp from doorpi.keyboard.from_piface 2021-03-03 19:11:07,532 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyUp from source doorpi.keyboard.from_piface is already known 2021-03-03 19:11:07,532 [TRACE] [doorpi.action.handler] register Event OnKeyUp_2 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,532 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_2 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,532 [TRACE] [doorpi.action.handler] register Event OnKeyUp_onboardpins.2 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,533 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_onboardpins.2 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,533 [TRACE] [doorpi.action.handler] register Event OnKeyDown from doorpi.keyboard.from_piface 2021-03-03 19:11:07,533 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyDown from source doorpi.keyboard.from_piface is already known 2021-03-03 19:11:07,533 [TRACE] [doorpi.action.handler] register Event OnKeyDown_2 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,533 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_2 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,534 [TRACE] [doorpi.action.handler] register Event OnKeyDown_onboardpins.2 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,534 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_onboardpins.2 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,534 [TRACE] [doorpi.action.handler] register Event OnKeyPressed from doorpi.keyboard.from_piface 2021-03-03 19:11:07,534 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyPressed from source doorpi.keyboard.from_piface is already known 2021-03-03 19:11:07,535 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_5 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,535 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_5 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,535 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_onboardpins.5 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,535 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_onboardpins.5 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,535 [TRACE] [doorpi.action.handler] register Event OnKeyUp from doorpi.keyboard.from_piface 2021-03-03 19:11:07,536 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyUp from source doorpi.keyboard.from_piface is already known 2021-03-03 19:11:07,536 [TRACE] [doorpi.action.handler] register Event OnKeyUp_5 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,536 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_5 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,536 [TRACE] [doorpi.action.handler] register Event OnKeyUp_onboardpins.5 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,536 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_onboardpins.5 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,537 [TRACE] [doorpi.action.handler] register Event OnKeyDown from doorpi.keyboard.from_piface 2021-03-03 19:11:07,537 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyDown from source doorpi.keyboard.from_piface is already known 2021-03-03 19:11:07,537 [TRACE] [doorpi.action.handler] register Event OnKeyDown_5 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,537 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_5 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,537 [TRACE] [doorpi.action.handler] register Event OnKeyDown_onboardpins.5 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,538 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_onboardpins.5 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,538 [TRACE] [doorpi.action.handler] register Event OnKeyPressed from doorpi.keyboard.from_piface 2021-03-03 19:11:07,538 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyPressed from source doorpi.keyboard.from_piface is already known 2021-03-03 19:11:07,538 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_4 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,538 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_4 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,539 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_onboardpins.4 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,539 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_onboardpins.4 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,539 [TRACE] [doorpi.action.handler] register Event OnKeyUp from doorpi.keyboard.from_piface 2021-03-03 19:11:07,539 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyUp from source doorpi.keyboard.from_piface is already known 2021-03-03 19:11:07,540 [TRACE] [doorpi.action.handler] register Event OnKeyUp_4 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,540 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_4 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,540 [TRACE] [doorpi.action.handler] register Event OnKeyUp_onboardpins.4 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,540 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_onboardpins.4 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,540 [TRACE] [doorpi.action.handler] register Event OnKeyDown from doorpi.keyboard.from_piface 2021-03-03 19:11:07,541 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyDown from source doorpi.keyboard.from_piface is already known 2021-03-03 19:11:07,541 [TRACE] [doorpi.action.handler] register Event OnKeyDown_4 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,541 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_4 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,541 [TRACE] [doorpi.action.handler] register Event OnKeyDown_onboardpins.4 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,542 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_onboardpins.4 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,542 [TRACE] [doorpi.action.handler] register Event OnKeyPressed from doorpi.keyboard.from_piface 2021-03-03 19:11:07,542 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyPressed from source doorpi.keyboard.from_piface is already known 2021-03-03 19:11:07,542 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_7 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,543 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_7 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,543 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_onboardpins.7 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,543 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_onboardpins.7 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,543 [TRACE] [doorpi.action.handler] register Event OnKeyUp from doorpi.keyboard.from_piface 2021-03-03 19:11:07,543 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyUp from source doorpi.keyboard.from_piface is already known 2021-03-03 19:11:07,544 [TRACE] [doorpi.action.handler] register Event OnKeyUp_7 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,544 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_7 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,544 [TRACE] [doorpi.action.handler] register Event OnKeyUp_onboardpins.7 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,544 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_onboardpins.7 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,544 [TRACE] [doorpi.action.handler] register Event OnKeyDown from doorpi.keyboard.from_piface 2021-03-03 19:11:07,545 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyDown from source doorpi.keyboard.from_piface is already known 2021-03-03 19:11:07,545 [TRACE] [doorpi.action.handler] register Event OnKeyDown_7 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,545 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_7 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,545 [TRACE] [doorpi.action.handler] register Event OnKeyDown_onboardpins.7 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,545 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_onboardpins.7 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,546 [TRACE] [doorpi.action.handler] register Event OnKeyPressed from doorpi.keyboard.from_piface 2021-03-03 19:11:07,546 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyPressed from source doorpi.keyboard.from_piface is already known 2021-03-03 19:11:07,546 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_6 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,546 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_6 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,547 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_onboardpins.6 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,547 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_onboardpins.6 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,547 [TRACE] [doorpi.action.handler] register Event OnKeyUp from doorpi.keyboard.from_piface 2021-03-03 19:11:07,547 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyUp from source doorpi.keyboard.from_piface is already known 2021-03-03 19:11:07,547 [TRACE] [doorpi.action.handler] register Event OnKeyUp_6 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,548 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_6 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,548 [TRACE] [doorpi.action.handler] register Event OnKeyUp_onboardpins.6 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,548 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_onboardpins.6 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,548 [TRACE] [doorpi.action.handler] register Event OnKeyDown from doorpi.keyboard.from_piface 2021-03-03 19:11:07,548 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyDown from source doorpi.keyboard.from_piface is already known 2021-03-03 19:11:07,549 [TRACE] [doorpi.action.handler] register Event OnKeyDown_6 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,549 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_6 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,549 [TRACE] [doorpi.action.handler] register Event OnKeyDown_onboardpins.6 from doorpi.keyboard.from_piface 2021-03-03 19:11:07,549 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_onboardpins.6 and registered source doorpi.keyboard.from_piface 2021-03-03 19:11:07,557 [TRACE] [doorpi.action.handler] action KeyboardDestroyAction with args () and kwargs {} was added to event OnShutdown 2021-03-03 19:11:07,558 [TRACE] [doorpi.conf.config_object] get_keys for section onboardpins_OutputPins returns ['0'] 2021-03-03 19:11:07,559 [TRACE] [doorpi.conf.config_object] get_string for key 0 in section onboardpins_OutputPins (default: ) returns Tueroeffner 2021-03-03 19:11:07,560 [DEBUG] [doorpi.status.status_lib.environment] doorpi.status.status_lib.environment loaded 2021-03-03 19:11:07,562 [DEBUG] [doorpi.status.requirements_lib.req_config] doorpi.status.requirements_lib.req_config loaded 2021-03-03 19:11:07,564 [DEBUG] [doorpi.status.requirements_lib.req_sipphone] doorpi.status.requirements_lib.req_sipphone loaded 2021-03-03 19:11:07,565 [DEBUG] [doorpi.sipphone.AbstractBaseClass] doorpi.sipphone.AbstractBaseClass loaded 2021-03-03 19:11:07,596 [DEBUG] [doorpi.status.requirements_lib.req_event_handler] doorpi.status.requirements_lib.req_event_handler loaded 2021-03-03 19:11:07,598 [DEBUG] [doorpi.status.requirements_lib.req_webserver] doorpi.status.requirements_lib.req_webserver loaded 2021-03-03 19:11:07,599 [DEBUG] [doorpi.status.requirements_lib.req_keyboard] doorpi.status.requirements_lib.req_keyboard loaded 2021-03-03 19:11:07,603 [DEBUG] [doorpi.status.requirements_lib.req_system] doorpi.status.requirements_lib.req_system loaded 2021-03-03 19:11:07,607 [INFO] [doorpi.sipphone.SipphoneInterface] found installed sipphone "linphone" and use this as default 2021-03-03 19:11:07,607 [TRACE] [doorpi.conf.config_object] get_string for key sipphonetyp in section SIP-Phone (default: linphone) returns linphone 2021-03-03 19:11:07,608 [DEBUG] [doorpi.sipphone.from_linphone] doorpi.sipphone.from_linphone loaded 2021-03-03 19:11:07,611 [DEBUG] [doorpi.sipphone.linphone_lib.CallBacks] doorpi.sipphone.linphone_lib.CallBacks loaded 2021-03-03 19:11:07,612 [DEBUG] [doorpi.sipphone.linphone_lib.Player] doorpi.sipphone.linphone_lib.Player loaded 2021-03-03 19:11:07,614 [DEBUG] [doorpi.sipphone.linphone_lib.Recorder] doorpi.sipphone.linphone_lib.Recorder loaded 2021-03-03 19:11:07,615 [DEBUG] [doorpi.sipphone.from_linphone] __init__ 2021-03-03 19:11:07,615 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to event OnShutdown 2021-03-03 19:11:07,615 [TRACE] [doorpi.action.handler] register Event OnSipPhoneCreate from doorpi.sipphone.from_linphone 2021-03-03 19:11:07,615 [DEBUG] [doorpi.action.handler] event_source doorpi.sipphone.from_linphone was added 2021-03-03 19:11:07,616 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneCreate and registered source doorpi.sipphone.from_linphone 2021-03-03 19:11:07,616 [TRACE] [doorpi.action.handler] register Event OnSipPhoneStart from doorpi.sipphone.from_linphone 2021-03-03 19:11:07,616 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneStart and registered source doorpi.sipphone.from_linphone 2021-03-03 19:11:07,616 [TRACE] [doorpi.action.handler] register Event OnSipPhoneDestroy from doorpi.sipphone.from_linphone 2021-03-03 19:11:07,617 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneDestroy and registered source doorpi.sipphone.from_linphone 2021-03-03 19:11:07,617 [TRACE] [doorpi.action.handler] register Event OnSipPhoneRecorderCreate from doorpi.sipphone.from_linphone 2021-03-03 19:11:07,617 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneRecorderCreate and registered source doorpi.sipphone.from_linphone 2021-03-03 19:11:07,617 [TRACE] [doorpi.action.handler] register Event OnSipPhoneRecorderDestroy from doorpi.sipphone.from_linphone 2021-03-03 19:11:07,617 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneRecorderDestroy and registered source doorpi.sipphone.from_linphone 2021-03-03 19:11:07,618 [TRACE] [doorpi.action.handler] register Event BeforeSipPhoneMakeCall from doorpi.sipphone.from_linphone 2021-03-03 19:11:07,618 [TRACE] [doorpi.action.handler] added event_name BeforeSipPhoneMakeCall and registered source doorpi.sipphone.from_linphone 2021-03-03 19:11:07,618 [TRACE] [doorpi.action.handler] register Event OnSipPhoneMakeCall from doorpi.sipphone.from_linphone 2021-03-03 19:11:07,618 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneMakeCall and registered source doorpi.sipphone.from_linphone 2021-03-03 19:11:07,618 [TRACE] [doorpi.action.handler] register Event OnSipPhoneMakeCallFailed from doorpi.sipphone.from_linphone 2021-03-03 19:11:07,619 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneMakeCallFailed and registered source doorpi.sipphone.from_linphone 2021-03-03 19:11:07,619 [TRACE] [doorpi.action.handler] register Event AfterSipPhoneMakeCall from doorpi.sipphone.from_linphone 2021-03-03 19:11:07,619 [TRACE] [doorpi.action.handler] added event_name AfterSipPhoneMakeCall and registered source doorpi.sipphone.from_linphone 2021-03-03 19:11:07,619 [TRACE] [doorpi.action.handler] register Event OnSipPhoneCallTimeoutNoResponse from doorpi.sipphone.from_linphone 2021-03-03 19:11:07,619 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneCallTimeoutNoResponse and registered source doorpi.sipphone.from_linphone 2021-03-03 19:11:07,620 [TRACE] [doorpi.action.handler] register Event OnSipPhoneCallTimeoutMaxCalltime from doorpi.sipphone.from_linphone 2021-03-03 19:11:07,620 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneCallTimeoutMaxCalltime and registered source doorpi.sipphone.from_linphone 2021-03-03 19:11:07,620 [TRACE] [doorpi.action.handler] register Event OnPlayerCreated from doorpi.sipphone.from_linphone 2021-03-03 19:11:07,620 [TRACE] [doorpi.action.handler] added event_name OnPlayerCreated and registered source doorpi.sipphone.from_linphone 2021-03-03 19:11:07,621 [DEBUG] [doorpi.sipphone.linphone_lib.CallBacks] __init__ 2021-03-03 19:11:07,621 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to new evententry OnSipPhoneDestroy 2021-03-03 19:11:07,621 [TRACE] [doorpi.action.handler] register Event OnCallMediaStateChange from doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,621 [DEBUG] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was added 2021-03-03 19:11:07,622 [TRACE] [doorpi.action.handler] added event_name OnCallMediaStateChange and registered source doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,622 [TRACE] [doorpi.action.handler] register Event OnMediaRequired from doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,622 [TRACE] [doorpi.action.handler] added event_name OnMediaRequired and registered source doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,622 [TRACE] [doorpi.action.handler] register Event OnMediaNotRequired from doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,623 [TRACE] [doorpi.action.handler] added event_name OnMediaNotRequired and registered source doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,623 [TRACE] [doorpi.action.handler] register Event OnCallStateChange from doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,623 [TRACE] [doorpi.action.handler] added event_name OnCallStateChange and registered source doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,623 [TRACE] [doorpi.action.handler] register Event OnCallStateConnect from doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,623 [TRACE] [doorpi.action.handler] added event_name OnCallStateConnect and registered source doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,624 [TRACE] [doorpi.action.handler] register Event AfterCallStateConnect from doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,624 [TRACE] [doorpi.action.handler] added event_name AfterCallStateConnect and registered source doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,624 [TRACE] [doorpi.action.handler] register Event OnCallStateDisconnect from doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,624 [TRACE] [doorpi.action.handler] added event_name OnCallStateDisconnect and registered source doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,624 [TRACE] [doorpi.action.handler] register Event AfterCallStateDisconnect from doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,625 [TRACE] [doorpi.action.handler] added event_name AfterCallStateDisconnect and registered source doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,625 [TRACE] [doorpi.action.handler] register Event OnCallStateDismissed from doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,625 [TRACE] [doorpi.action.handler] added event_name OnCallStateDismissed and registered source doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,625 [TRACE] [doorpi.action.handler] register Event OnCallStateReject from doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,625 [TRACE] [doorpi.action.handler] added event_name OnCallStateReject and registered source doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,626 [TRACE] [doorpi.action.handler] register Event OnCallStart from doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,626 [TRACE] [doorpi.action.handler] added event_name OnCallStart and registered source doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,626 [TRACE] [doorpi.action.handler] register Event OnDTMF from doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,626 [TRACE] [doorpi.action.handler] added event_name OnDTMF and registered source doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,627 [TRACE] [doorpi.conf.config_object] get_keys for section DTMF returns ['"0"', '"1"', '"2"'] 2021-03-03 19:11:07,627 [TRACE] [doorpi.action.handler] register Event OnDTMF_"0" from doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,627 [TRACE] [doorpi.action.handler] added event_name OnDTMF_"0" and registered source doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,627 [TRACE] [doorpi.action.handler] register Event OnDTMF_"1" from doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,627 [TRACE] [doorpi.action.handler] added event_name OnDTMF_"1" and registered source doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,628 [TRACE] [doorpi.action.handler] register Event OnDTMF_"2" from doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,628 [TRACE] [doorpi.action.handler] added event_name OnDTMF_"2" and registered source doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,628 [TRACE] [doorpi.action.handler] register Event OnCallStart from doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,628 [TRACE] [doorpi.action.handler] nothing to do - event OnCallStart from source doorpi.sipphone.linphone_lib.CallBacks is already known 2021-03-03 19:11:07,628 [TRACE] [doorpi.action.handler] register Event BeforeCallIncoming from doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,629 [TRACE] [doorpi.action.handler] added event_name BeforeCallIncoming and registered source doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,629 [TRACE] [doorpi.action.handler] register Event OnCallReconnect from doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,629 [TRACE] [doorpi.action.handler] added event_name OnCallReconnect and registered source doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,629 [TRACE] [doorpi.action.handler] register Event AfterCallReconnect from doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,629 [TRACE] [doorpi.action.handler] added event_name AfterCallReconnect and registered source doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,630 [TRACE] [doorpi.action.handler] register Event OnCallBusy from doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,630 [TRACE] [doorpi.action.handler] added event_name OnCallBusy and registered source doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,630 [TRACE] [doorpi.action.handler] register Event AfterCallBusy from doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,630 [TRACE] [doorpi.action.handler] added event_name AfterCallBusy and registered source doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,631 [TRACE] [doorpi.action.handler] register Event OnCallIncoming from doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,631 [TRACE] [doorpi.action.handler] added event_name OnCallIncoming and registered source doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,631 [TRACE] [doorpi.action.handler] register Event AfterCallIncoming from doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,632 [TRACE] [doorpi.action.handler] added event_name AfterCallIncoming and registered source doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,632 [TRACE] [doorpi.action.handler] register Event OnCallReject from doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,632 [TRACE] [doorpi.action.handler] added event_name OnCallReject and registered source doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,632 [TRACE] [doorpi.action.handler] register Event AfterCallReject from doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,632 [TRACE] [doorpi.action.handler] added event_name AfterCallReject and registered source doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,633 [TRACE] [doorpi.action.handler] fire Event OnCallStart from doorpi.sipphone.linphone_lib.CallBacks asyncron 2021-03-03 19:11:07,634 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_new() 2021-03-03 19:11:07,634 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_new -> 0x72e794d0 2021-03-03 19:11:07,635 [DEBUG] [doorpi.action.handler] no actions for event OnCallStart - skip fire_event OnCallStart from doorpi.sipphone.linphone_lib.CallBacks 2021-03-03 19:11:07,635 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_init() 2021-03-03 19:11:07,635 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_init -> 0x72e794d0 2021-03-03 19:11:07,636 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_class_method_new(0x72e81e40, "(null)", "(null)") 2021-03-03 19:11:07,636 [INFO] [doorpi.sipphone.from_linphone] Mediastreamer2 factory 2.12.0 (git: 3.9.0) initialized. 2021-03-03 19:11:07,636 [INFO] [doorpi.sipphone.from_linphone] CPU count set to 4 2021-03-03 19:11:07,636 [INFO] [doorpi.sipphone.from_linphone] ms_factory_init() done: platform_tags=linux,arm,embedded 2021-03-03 19:11:07,637 [INFO] [doorpi.sipphone.from_linphone] srtp init 2021-03-03 19:11:07,644 [INFO] [doorpi.sipphone.from_linphone] Registering all soundcard handlers 2021-03-03 19:11:07,686 [INFO] [doorpi.sipphone.from_linphone] Card 'ALSA: default device' added 2021-03-03 19:11:07,690 [INFO] [doorpi.sipphone.from_linphone] also error in confmisc.c:767 - cannot find card '1' 2021-03-03 19:11:07,690 [INFO] [doorpi.sipphone.from_linphone] also error in conf.c:4568 - function snd_func_card_driver returned error: No such file or directory 2021-03-03 19:11:07,691 [INFO] [doorpi.sipphone.from_linphone] also error in confmisc.c:392 - error evaluating strings 2021-03-03 19:11:07,691 [INFO] [doorpi.sipphone.from_linphone] also error in conf.c:4568 - function snd_func_concat returned error: No such file or directory 2021-03-03 19:11:07,691 [INFO] [doorpi.sipphone.from_linphone] also error in confmisc.c:1246 - error evaluating name 2021-03-03 19:11:07,692 [INFO] [doorpi.sipphone.from_linphone] also error in conf.c:4568 - function snd_func_refer returned error: No such file or directory 2021-03-03 19:11:07,692 [INFO] [doorpi.sipphone.from_linphone] also error in conf.c:5047 - Evaluate error: No such file or directory 2021-03-03 19:11:07,692 [INFO] [doorpi.sipphone.from_linphone] also error in pcm.c:2565 - Unknown PCM sysdefault 2021-03-03 19:11:07,693 [INFO] [doorpi.sipphone.from_linphone] also error in confmisc.c:767 - cannot find card '1' 2021-03-03 19:11:07,693 [INFO] [doorpi.sipphone.from_linphone] also error in conf.c:4568 - function snd_func_card_driver returned error: No such file or directory 2021-03-03 19:11:07,693 [INFO] [doorpi.sipphone.from_linphone] also error in confmisc.c:392 - error evaluating strings 2021-03-03 19:11:07,693 [INFO] [doorpi.sipphone.from_linphone] also error in conf.c:4568 - function snd_func_concat returned error: No such file or directory 2021-03-03 19:11:07,694 [INFO] [doorpi.sipphone.from_linphone] also error in confmisc.c:1246 - error evaluating name 2021-03-03 19:11:07,694 [INFO] [doorpi.sipphone.from_linphone] also error in conf.c:4568 - function snd_func_refer returned error: No such file or directory 2021-03-03 19:11:07,694 [INFO] [doorpi.sipphone.from_linphone] also error in conf.c:5047 - Evaluate error: No such file or directory 2021-03-03 19:11:07,694 [INFO] [doorpi.sipphone.from_linphone] also error in pcm.c:2565 - Unknown PCM sysdefault 2021-03-03 19:11:07,694 [INFO] [doorpi.sipphone.from_linphone] Registering all webcam handlers 2021-03-03 19:11:07,695 [INFO] [doorpi.sipphone.from_linphone] Webcam V4L2: /dev/video0 added 2021-03-03 19:11:07,695 [INFO] [doorpi.sipphone.from_linphone] Webcam StaticImage: Static picture added 2021-03-03 19:11:07,696 [INFO] [doorpi.sipphone.from_linphone] ms_factory_init_voip() done 2021-03-03 19:11:07,696 [INFO] [doorpi.sipphone.from_linphone] Loading ms plugins from [./lib/mediastreamer/plugins] 2021-03-03 19:11:07,696 [INFO] [doorpi.sipphone.from_linphone] Cannot open directory ./lib/mediastreamer/plugins: No such file or directory 2021-03-03 19:11:07,696 [INFO] [doorpi.sipphone.from_linphone] Initializing LinphoneCore 3.9.0 2021-03-03 19:11:07,697 [INFO] [doorpi.sipphone.from_linphone] Vtable [0xb0f0e0] registered on core [0x983f20] 2021-03-03 19:11:07,697 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_callback_global_state_changed(0xb0f0e0, 1, "Starting up") 2021-03-03 19:11:07,697 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_callback_global_state_changed 2021-03-03 19:11:07,697 [INFO] [doorpi.sipphone.from_linphone] Linphone core [0xb0f0e0] notifying [global_state_changed] 2021-03-03 19:11:07,698 [INFO] [doorpi.sipphone.from_linphone] oRTP-0.25.0 initialized. 2021-03-03 19:11:07,698 [INFO] [doorpi.sipphone.from_linphone] Skiping ms_base_init, because [2] ref 2021-03-03 19:11:07,698 [INFO] [doorpi.sipphone.from_linphone] Skiping ms_voip_init, because [2] ref 2021-03-03 19:11:07,698 [INFO] [doorpi.sipphone.from_linphone] Skiping ms_plugins_init, because [2] ref 2021-03-03 19:11:07,699 [INFO] [doorpi.sipphone.from_linphone] Codec opus/48000 fmtp=[useinbandfec=1] number=-1, enabled=1) added to default capabilities. 2021-03-03 19:11:07,699 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for SILK 2021-03-03 19:11:07,699 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for SILK 2021-03-03 19:11:07,699 [INFO] [doorpi.sipphone.from_linphone] Codec speex/16000 fmtp=[vbr=on] number=-1, enabled=1) added to default capabilities. 2021-03-03 19:11:07,699 [INFO] [doorpi.sipphone.from_linphone] Codec speex/8000 fmtp=[vbr=on] number=-1, enabled=1) added to default capabilities. 2021-03-03 19:11:07,700 [INFO] [doorpi.sipphone.from_linphone] Codec PCMU/8000 fmtp=[] number=0, enabled=1) added to default capabilities. 2021-03-03 19:11:07,700 [INFO] [doorpi.sipphone.from_linphone] Codec PCMA/8000 fmtp=[] number=8, enabled=1) added to default capabilities. 2021-03-03 19:11:07,700 [INFO] [doorpi.sipphone.from_linphone] Codec t140/1000 fmtp=[] number=96, enabled=1) added to default capabilities. 2021-03-03 19:11:07,700 [INFO] [doorpi.sipphone.from_linphone] Codec red/1000 fmtp=[] number=97, enabled=1) added to default capabilities. 2021-03-03 19:11:07,701 [INFO] [doorpi.sipphone.from_linphone] Codec GSM/8000 fmtp=[] number=3, enabled=0) added to default capabilities. 2021-03-03 19:11:07,701 [INFO] [doorpi.sipphone.from_linphone] Codec G722/8000 fmtp=[] number=9, enabled=0) added to default capabilities. 2021-03-03 19:11:07,701 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for iLBC 2021-03-03 19:11:07,701 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for iLBC 2021-03-03 19:11:07,702 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for AMR 2021-03-03 19:11:07,702 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for AMR 2021-03-03 19:11:07,702 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for AMR-WB 2021-03-03 19:11:07,702 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for AMR-WB 2021-03-03 19:11:07,703 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for G729 2021-03-03 19:11:07,703 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for G729 2021-03-03 19:11:07,703 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for mpeg4-generic 2021-03-03 19:11:07,703 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for mpeg4-generic 2021-03-03 19:11:07,703 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for mpeg4-generic 2021-03-03 19:11:07,704 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for mpeg4-generic 2021-03-03 19:11:07,704 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for mpeg4-generic 2021-03-03 19:11:07,704 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for mpeg4-generic 2021-03-03 19:11:07,704 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for mpeg4-generic 2021-03-03 19:11:07,705 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for mpeg4-generic 2021-03-03 19:11:07,705 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for mpeg4-generic 2021-03-03 19:11:07,705 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for mpeg4-generic 2021-03-03 19:11:07,705 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for iSAC 2021-03-03 19:11:07,706 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for iSAC 2021-03-03 19:11:07,706 [INFO] [doorpi.sipphone.from_linphone] Codec speex/32000 fmtp=[vbr=on] number=-1, enabled=0) added to default capabilities. 2021-03-03 19:11:07,706 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for SILK 2021-03-03 19:11:07,706 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for SILK 2021-03-03 19:11:07,706 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for SILK 2021-03-03 19:11:07,707 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for SILK 2021-03-03 19:11:07,707 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for SILK 2021-03-03 19:11:07,707 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for SILK 2021-03-03 19:11:07,707 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for G726-16 2021-03-03 19:11:07,708 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for G726-16 2021-03-03 19:11:07,708 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for G726-24 2021-03-03 19:11:07,708 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for G726-24 2021-03-03 19:11:07,708 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for G726-32 2021-03-03 19:11:07,709 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for G726-32 2021-03-03 19:11:07,709 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for G726-40 2021-03-03 19:11:07,709 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for G726-40 2021-03-03 19:11:07,709 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for AAL2-G726-16 2021-03-03 19:11:07,709 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for AAL2-G726-16 2021-03-03 19:11:07,710 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for AAL2-G726-24 2021-03-03 19:11:07,710 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for AAL2-G726-24 2021-03-03 19:11:07,710 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for AAL2-G726-32 2021-03-03 19:11:07,710 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for AAL2-G726-32 2021-03-03 19:11:07,711 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for AAL2-G726-40 2021-03-03 19:11:07,711 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for AAL2-G726-40 2021-03-03 19:11:07,711 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for CODEC2 2021-03-03 19:11:07,711 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for CODEC2 2021-03-03 19:11:07,712 [INFO] [doorpi.sipphone.from_linphone] Codec VP8/90000 fmtp=[] number=-1, enabled=1) added to default capabilities. 2021-03-03 19:11:07,712 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for H264 2021-03-03 19:11:07,712 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for H264 2021-03-03 19:11:07,712 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for MP4V-ES 2021-03-03 19:11:07,713 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for H263-1998 2021-03-03 19:11:07,713 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for H263 2021-03-03 19:11:07,713 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for 1016 2021-03-03 19:11:07,713 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for 1016 2021-03-03 19:11:07,713 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for G723 2021-03-03 19:11:07,714 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for G723 2021-03-03 19:11:07,714 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for LPC 2021-03-03 19:11:07,714 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for LPC 2021-03-03 19:11:07,714 [INFO] [doorpi.sipphone.from_linphone] Codec L16/44100 fmtp=[] number=10, enabled=0) added to default capabilities. 2021-03-03 19:11:07,715 [INFO] [doorpi.sipphone.from_linphone] Codec L16/44100 fmtp=[] number=11, enabled=0) added to default capabilities. 2021-03-03 19:11:07,715 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for CN 2021-03-03 19:11:07,715 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for CN 2021-03-03 19:11:07,715 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for G729 2021-03-03 19:11:07,715 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for G729 2021-03-03 19:11:07,716 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for H261 2021-03-03 19:11:07,716 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for H261 2021-03-03 19:11:07,716 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for MPV 2021-03-03 19:11:07,716 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for MPV 2021-03-03 19:11:07,717 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for H263 2021-03-03 19:11:07,717 [INFO] [doorpi.sipphone.from_linphone] Sal nat helper [enabled] 2021-03-03 19:11:07,717 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2021-03-03 19:11:07,717 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2021-03-03 19:11:07,718 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2021-03-03 19:11:07,718 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_callback_configuring_status(0xb0f0e0, 2, "(null)") 2021-03-03 19:11:07,718 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_callback_configuring_status 2021-03-03 19:11:07,718 [INFO] [doorpi.sipphone.from_linphone] Linphone core [0xb0f0e0] notifying [configuring_status] 2021-03-03 19:11:07,719 [INFO] [doorpi.sipphone.from_linphone] Cannot open directory ./lib/liblinphone/plugins: No such file or directory 2021-03-03 19:11:07,719 [WARNING] [doorpi.sipphone.from_linphone] ./share/sounds/linphone/rings/oldphone.wav does not exist 2021-03-03 19:11:07,719 [INFO] [doorpi.sipphone.from_linphone] linphone_core_set_playback_gain_db(): no active call. 2021-03-03 19:11:07,719 [INFO] [doorpi.sipphone.from_linphone] linphone_core_set_mic_gain_db(): no active call. 2021-03-03 19:11:07,720 [INFO] [doorpi.sipphone.from_linphone] MTU is supposed to be 1300, rtp payload max size will be 1240 2021-03-03 19:11:07,720 [INFO] [doorpi.sipphone.from_linphone] Sal nat helper [enabled] 2021-03-03 19:11:07,720 [INFO] [doorpi.sipphone.from_linphone] Sal use rport [enabled] 2021-03-03 19:11:07,720 [INFO] [doorpi.sipphone.from_linphone] Supported codec opus/48000 fmtp=useinbandfec=1 automatically added to codec list. 2021-03-03 19:11:07,721 [INFO] [doorpi.sipphone.from_linphone] Supported codec speex/16000 fmtp=vbr=on automatically added to codec list. 2021-03-03 19:11:07,721 [INFO] [doorpi.sipphone.from_linphone] Supported codec speex/8000 fmtp=vbr=on automatically added to codec list. 2021-03-03 19:11:07,721 [INFO] [doorpi.sipphone.from_linphone] Supported codec PCMU/8000 fmtp= automatically added to codec list. 2021-03-03 19:11:07,721 [INFO] [doorpi.sipphone.from_linphone] Supported codec PCMA/8000 fmtp= automatically added to codec list. 2021-03-03 19:11:07,722 [INFO] [doorpi.sipphone.from_linphone] Supported codec GSM/8000 fmtp= automatically added to codec list. 2021-03-03 19:11:07,722 [INFO] [doorpi.sipphone.from_linphone] Supported codec G722/8000 fmtp= automatically added to codec list. 2021-03-03 19:11:07,722 [INFO] [doorpi.sipphone.from_linphone] Supported codec speex/32000 fmtp=vbr=on automatically added to codec list. 2021-03-03 19:11:07,722 [INFO] [doorpi.sipphone.from_linphone] Supported codec L16/44100 fmtp= automatically added to codec list. 2021-03-03 19:11:07,722 [INFO] [doorpi.sipphone.from_linphone] Supported codec L16/44100 fmtp= automatically added to codec list. 2021-03-03 19:11:07,723 [INFO] [doorpi.sipphone.from_linphone] Supported codec VP8/90000 fmtp= automatically added to codec list. 2021-03-03 19:11:07,723 [INFO] [doorpi.sipphone.from_linphone] Supported codec t140/1000 fmtp= automatically added to codec list. 2021-03-03 19:11:07,723 [INFO] [doorpi.sipphone.from_linphone] Supported codec red/1000 fmtp= automatically added to codec list. 2021-03-03 19:11:07,723 [INFO] [doorpi.sipphone.from_linphone] Sal use rport [enabled] 2021-03-03 19:11:07,724 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2021-03-03 19:11:07,724 [INFO] [doorpi.sipphone.from_linphone] sal_unlisten_ports done 2021-03-03 19:11:07,724 [INFO] [doorpi.sipphone.from_linphone] Creating listening point [0xb0e988] on [sip:0.0.0.0:5060;transport=UDP] 2021-03-03 19:11:07,725 [INFO] [doorpi.sipphone.from_linphone] Creating listening point [0xb0e3f8] on [sip:0.0.0.0:5060;transport=TCP] 2021-03-03 19:11:07,725 [INFO] [doorpi.sipphone.from_linphone] Creating listening point [0xaa97f0] on [sip:0.0.0.0:-1;transport=TLS] 2021-03-03 19:11:07,725 [INFO] [doorpi.sipphone.from_linphone] Random TCP port is 36151 2021-03-03 19:11:07,726 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2021-03-03 19:11:07,726 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2021-03-03 19:11:07,728 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_callback_global_state_changed(0xb0f0e0, 2, "Ready") 2021-03-03 19:11:07,729 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_callback_global_state_changed 2021-03-03 19:11:07,729 [INFO] [doorpi.sipphone.from_linphone] Linphone core [0xb0f0e0] notifying [global_state_changed] 2021-03-03 19:11:07,729 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_class_method_new -> 0x72e794d0 2021-03-03 19:11:07,730 [TRACE] [doorpi.conf.config_object] get_string for key identity in section SIP-Phone (default: DoorPi) returns DoorPi 2021-03-03 19:11:07,730 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_primary_contact(0x72e794d0 [0xb0f0e0], "DoorPi ") 2021-03-03 19:11:07,732 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_primary_contact -> 0 2021-03-03 19:11:07,732 [TRACE] [doorpi.action.handler] fire Event OnSipPhoneCreate from doorpi.sipphone.from_linphone asyncron 2021-03-03 19:11:07,733 [TRACE] [doorpi.conf.config_object] get_integer for key ua.max_calls in section SIP-Phone (default: 2) returns 2 2021-03-03 19:11:07,734 [DEBUG] [doorpi.action.handler] no actions for event OnSipPhoneCreate - skip fire_event OnSipPhoneCreate from doorpi.sipphone.from_linphone 2021-03-03 19:11:07,734 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_max_calls(0x72e794d0 [0xb0f0e0], 2) 2021-03-03 19:11:07,734 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_max_calls -> 0 2021-03-03 19:11:07,735 [TRACE] [doorpi.conf.config_object] get_boolean for key echo_cancellation_enabled in section SIP-Phone (default: False) returns False 2021-03-03 19:11:07,735 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_enable_echo_cancellation(0x72e794d0 [0xb0f0e0], 0x2a311c [0]) 2021-03-03 19:11:07,735 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_enable_echo_cancellation -> 0 2021-03-03 19:11:07,736 [TRACE] [doorpi.conf.config_object] get_integer for key local_port in section SIP-Phone (default: 5060) returns 5060 2021-03-03 19:11:07,736 [TRACE] [doorpi.conf.config_object] get_integer for key local_port in section SIP-Phone (default: 5060) returns 5060 2021-03-03 19:11:07,736 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_SipTransports_new() 2021-03-03 19:11:07,736 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_SipTransports_new -> 0x72e794e8 2021-03-03 19:11:07,736 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_sip_transports(0x72e794d0 [0xb0f0e0], 0x72e794e8 [0x72e794f0]) 2021-03-03 19:11:07,737 [INFO] [doorpi.sipphone.from_linphone] Listening point [0xb0e988] on [sip:0.0.0.0:5060;transport=UDP] destroyed 2021-03-03 19:11:07,737 [INFO] [doorpi.sipphone.from_linphone] Listening point [0xb0e3f8] on [sip:0.0.0.0:5060;transport=TCP] destroyed 2021-03-03 19:11:07,737 [INFO] [doorpi.sipphone.from_linphone] Listening point [0xaa97f0] on [sip:0.0.0.0:36151;transport=TLS] destroyed 2021-03-03 19:11:07,738 [INFO] [doorpi.sipphone.from_linphone] sal_unlisten_ports done 2021-03-03 19:11:07,738 [INFO] [doorpi.sipphone.from_linphone] Creating listening point [0xb0e988] on [sip:0.0.0.0:5060;transport=UDP] 2021-03-03 19:11:07,738 [INFO] [doorpi.sipphone.from_linphone] Creating listening point [0xaec248] on [sip:0.0.0.0:5060;transport=TCP] 2021-03-03 19:11:07,739 [INFO] [doorpi.sipphone.from_linphone] Creating listening point [0xaec1f0] on [sip:0.0.0.0:-1;transport=TLS] 2021-03-03 19:11:07,739 [INFO] [doorpi.sipphone.from_linphone] Random TCP port is 38053 2021-03-03 19:11:07,739 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2021-03-03 19:11:07,739 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2021-03-03 19:11:07,740 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_sip_transports -> 0 2021-03-03 19:11:07,740 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_SipTransports_dealloc(0x72e794e8) 2021-03-03 19:11:07,740 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_SipTransports_dealloc 2021-03-03 19:11:07,740 [TRACE] [doorpi.conf.config_object] get_boolean for key video_display_enabled in section SIP-Phone (default: False) returns False 2021-03-03 19:11:07,741 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_enable_video_display(0x72e794d0 [0xb0f0e0], 0x2a311c [0]) 2021-03-03 19:11:07,741 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_enable_video_display -> 0 2021-03-03 19:11:07,741 [TRACE] [doorpi.conf.config_object] get_string for key stun_server in section SIP-Phone (default: ) returns 2021-03-03 19:11:07,741 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_stun_server(0x72e794d0 [0xb0f0e0], "") 2021-03-03 19:11:07,742 [INFO] [doorpi.sipphone.from_linphone] Resolver is using DNS server(s): 2021-03-03 19:11:07,742 [INFO] [doorpi.sipphone.from_linphone] 192.168.2.1 2021-03-03 19:11:07,743 [INFO] [doorpi.sipphone.from_linphone] fd00::e228:6dff:fee1:c9ec 2021-03-03 19:11:07,743 [INFO] [doorpi.sipphone.from_linphone] resolver_process_data dns_res_check() in progress 2021-03-03 19:11:07,744 [INFO] [doorpi.sipphone.from_linphone] DNS resolution awaiting response, queued to main loop 2021-03-03 19:11:07,744 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_stun_server -> 0 2021-03-03 19:11:07,744 [DEBUG] [doorpi.conf.config_object] create new key FirewallPolicy in section SIP-Phone with value 'PolicyNoFirewall' 2021-03-03 19:11:07,745 [TRACE] [doorpi.conf.config_object] get_string for key FirewallPolicy in section SIP-Phone (default: PolicyNoFirewall) returns PolicyNoFirewall 2021-03-03 19:11:07,745 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_firewall_policy(0x72e794d0 [0xb0f0e0], 0) 2021-03-03 19:11:07,745 [INFO] [doorpi.sipphone.from_linphone] Sal nat helper [enabled] 2021-03-03 19:11:07,745 [INFO] [doorpi.sipphone.from_linphone] Sal use rport [enabled] 2021-03-03 19:11:07,746 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_firewall_policy -> 0 2021-03-03 19:11:07,747 [TRACE] [doorpi.conf.config_object] get_integer for key max_call_time in section SIP-Phone (default: 120) returns 120 2021-03-03 19:11:07,747 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_in_call_timeout(0x72e794d0 [0xb0f0e0], 120) 2021-03-03 19:11:07,747 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_in_call_timeout -> 0 2021-03-03 19:11:07,747 [TRACE] [doorpi.conf.config_object] get_integer for key call_timeout in section SIP-Phone (default: 15) returns 15 2021-03-03 19:11:07,748 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_inc_timeout(0x72e794d0 [0xb0f0e0], 15) 2021-03-03 19:11:07,748 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_inc_timeout -> 0 2021-03-03 19:11:07,748 [TRACE] [doorpi.conf.config_object] get_string for key dialtone in section SIP-Phone (default: !BASEPATH!/media/ShortDialTone.wav) returns !BASEPATH!/media/ShortDialTone.wav 2021-03-03 19:11:07,749 [DEBUG] [doorpi.conf.config_object] parse string "!BASEPATH!/media/ShortDialTone.wav" to "/usr/local/etc/DoorPi/media/ShortDialTone.wav" 2021-03-03 19:11:07,750 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to event OnSipPhoneDestroy 2021-03-03 19:11:07,751 [TRACE] [doorpi.conf.config_object] get_boolean for key dialtone_renew_every_start in section SIP-Phone (default: False) returns False 2021-03-03 19:11:07,751 [TRACE] [doorpi.action.handler] register Event OnPlayerStarted from doorpi.sipphone.linphone_lib.Player 2021-03-03 19:11:07,752 [DEBUG] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.Player was added 2021-03-03 19:11:07,752 [TRACE] [doorpi.action.handler] added event_name OnPlayerStarted and registered source doorpi.sipphone.linphone_lib.Player 2021-03-03 19:11:07,752 [TRACE] [doorpi.action.handler] register Event OnPlayerStopped from doorpi.sipphone.linphone_lib.Player 2021-03-03 19:11:07,752 [TRACE] [doorpi.action.handler] added event_name OnPlayerStopped and registered source doorpi.sipphone.linphone_lib.Player 2021-03-03 19:11:07,752 [TRACE] [doorpi.action.handler] register Event OnPlayerCreated from doorpi.sipphone.linphone_lib.Player 2021-03-03 19:11:07,753 [TRACE] [doorpi.action.handler] added event_source doorpi.sipphone.linphone_lib.Player to existing event OnPlayerCreated 2021-03-03 19:11:07,753 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to new evententry OnSipPhoneMakeCall 2021-03-03 19:11:07,753 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to new evententry OnCallStateConnect 2021-03-03 19:11:07,753 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to new evententry OnCallStateDisconnect 2021-03-03 19:11:07,754 [TRACE] [doorpi.action.handler] fire Event OnPlayerCreated from doorpi.sipphone.linphone_lib.Player asyncron 2021-03-03 19:11:07,755 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_ringback(0x72e794d0 [0xb0f0e0], "/usr/local/etc/DoorPi/media/ShortDialTone.wav") 2021-03-03 19:11:07,755 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_ringback -> 0 2021-03-03 19:11:07,755 [DEBUG] [doorpi.action.handler] no actions for event OnPlayerCreated - skip fire_event OnPlayerCreated from doorpi.sipphone.linphone_lib.Player 2021-03-03 19:11:07,755 [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 2021-03-03 19:11:07,756 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to event OnSipPhoneDestroy 2021-03-03 19:11:07,756 [TRACE] [doorpi.action.handler] register Event OnRecorderStarted from doorpi.sipphone.linphone_lib.Recorder 2021-03-03 19:11:07,756 [DEBUG] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.Recorder was added 2021-03-03 19:11:07,757 [TRACE] [doorpi.action.handler] added event_name OnRecorderStarted and registered source doorpi.sipphone.linphone_lib.Recorder 2021-03-03 19:11:07,757 [TRACE] [doorpi.action.handler] register Event OnRecorderStopped from doorpi.sipphone.linphone_lib.Recorder 2021-03-03 19:11:07,757 [TRACE] [doorpi.action.handler] added event_name OnRecorderStopped and registered source doorpi.sipphone.linphone_lib.Recorder 2021-03-03 19:11:07,757 [TRACE] [doorpi.action.handler] register Event OnRecorderCreated from doorpi.sipphone.linphone_lib.Recorder 2021-03-03 19:11:07,757 [TRACE] [doorpi.action.handler] added event_name OnRecorderCreated and registered source doorpi.sipphone.linphone_lib.Recorder 2021-03-03 19:11:07,758 [TRACE] [doorpi.conf.config_object] get_boolean for key record_while_dialing in section SIP-Phone (default: False) returns False 2021-03-03 19:11:07,758 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to event OnCallStateConnect 2021-03-03 19:11:07,758 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to event OnCallStateDisconnect 2021-03-03 19:11:07,759 [TRACE] [doorpi.action.handler] fire Event OnRecorderCreated from doorpi.sipphone.linphone_lib.Recorder asyncron 2021-03-03 19:11:07,759 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_sound_devices(0x72e794d0 [0xb0f0e0]) 2021-03-03 19:11:07,760 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_sound_devices -> 0x72e8c490 2021-03-03 19:11:07,760 [DEBUG] [doorpi.action.handler] no actions for event OnRecorderCreated - skip fire_event OnRecorderCreated from doorpi.sipphone.linphone_lib.Recorder 2021-03-03 19:11:07,760 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_capture_device(0x72e794d0 [0xb0f0e0]) 2021-03-03 19:11:07,761 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_capture_device -> 0x72e8a380 2021-03-03 19:11:07,761 [TRACE] [doorpi.conf.config_object] get_string for key capture_device in section SIP-Phone (default: ALSA: default device) returns ALSA: default device 2021-03-03 19:11:07,761 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_capture_device(0x72e794d0 [0xb0f0e0], "ALSA: default device") 2021-03-03 19:11:07,762 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_capture_device -> 0 2021-03-03 19:11:07,762 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_playback_device(0x72e794d0 [0xb0f0e0]) 2021-03-03 19:11:07,762 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_playback_device -> 0x72e8a350 2021-03-03 19:11:07,762 [TRACE] [doorpi.conf.config_object] get_string for key playback_device in section SIP-Phone (default: ALSA: default device) returns ALSA: default device 2021-03-03 19:11:07,763 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_playback_device(0x72e794d0 [0xb0f0e0], "ALSA: default device") 2021-03-03 19:11:07,763 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_playback_device -> 0 2021-03-03 19:11:07,763 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_sound_devices(0x72e794d0 [0xb0f0e0]) 2021-03-03 19:11:07,763 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_sound_devices -> 0x72e8c350 2021-03-03 19:11:07,763 [INFO] [doorpi.sipphone.from_linphone] found 1 possible sounddevices: 2021-03-03 19:11:07,764 [DEBUG] [doorpi.sipphone.from_linphone] |rec|play| name 2021-03-03 19:11:07,764 [DEBUG] [doorpi.sipphone.from_linphone] ------------------------------------ 2021-03-03 19:11:07,764 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_sound_devices(0x72e794d0 [0xb0f0e0]) 2021-03-03 19:11:07,764 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_sound_devices -> 0x72e8c350 2021-03-03 19:11:07,765 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_sound_device_can_capture(0x72e794d0 [0xb0f0e0], "ALSA: default device") 2021-03-03 19:11:07,765 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_sound_device_can_capture -> 0x2a3128 2021-03-03 19:11:07,765 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_sound_device_can_playback(0x72e794d0 [0xb0f0e0], "ALSA: default device") 2021-03-03 19:11:07,765 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_sound_device_can_playback -> 0x2a3128 2021-03-03 19:11:07,766 [DEBUG] [doorpi.sipphone.from_linphone] | X | X | ALSA: default device 2021-03-03 19:11:07,766 [DEBUG] [doorpi.sipphone.from_linphone] ------------------------------------ 2021-03-03 19:11:07,766 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_capture_device(0x72e794d0 [0xb0f0e0]) 2021-03-03 19:11:07,766 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_capture_device -> 0x72e8a350 2021-03-03 19:11:07,766 [DEBUG] [doorpi.sipphone.from_linphone] using capture_device: ALSA: default device 2021-03-03 19:11:07,767 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_playback_device(0x72e794d0 [0xb0f0e0]) 2021-03-03 19:11:07,767 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_playback_device -> 0x72e8a3e0 2021-03-03 19:11:07,767 [DEBUG] [doorpi.sipphone.from_linphone] using playback_device: ALSA: default device 2021-03-03 19:11:07,767 [TRACE] [doorpi.conf.config_object] get_list for key audio_codecs in section SIP-Phone (default: PCMA,PCMU) returns ['PCMA', 'PCMU'] 2021-03-03 19:11:07,768 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_audio_codecs(0x72e794d0 [0xb0f0e0]) 2021-03-03 19:11:07,768 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0xa993e0) 2021-03-03 19:11:07,768 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2021-03-03 19:11:07,768 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0x76d67bd0 2021-03-03 19:11:07,768 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2021-03-03 19:11:07,769 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0x76d67bd0 2021-03-03 19:11:07,769 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0x76d67bd0 2021-03-03 19:11:07,769 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0xa99450) 2021-03-03 19:11:07,769 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2021-03-03 19:11:07,770 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0x76d67bc0 2021-03-03 19:11:07,770 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2021-03-03 19:11:07,770 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0x76d67bc0 2021-03-03 19:11:07,770 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0x76d67bc0 2021-03-03 19:11:07,771 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0xa994b8) 2021-03-03 19:11:07,771 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2021-03-03 19:11:07,771 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0x76d67be0 2021-03-03 19:11:07,771 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2021-03-03 19:11:07,771 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0x76d67be0 2021-03-03 19:11:07,772 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0x76d67be0 2021-03-03 19:11:07,772 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0xa99520) 2021-03-03 19:11:07,772 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2021-03-03 19:11:07,772 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0x76d67bf0 2021-03-03 19:11:07,773 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2021-03-03 19:11:07,773 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0x76d67bf0 2021-03-03 19:11:07,773 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0x76d67bf0 2021-03-03 19:11:07,773 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0xa99578) 2021-03-03 19:11:07,774 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2021-03-03 19:11:07,774 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0x76d67c00 2021-03-03 19:11:07,774 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2021-03-03 19:11:07,774 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0x76d67c00 2021-03-03 19:11:07,774 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0x76d67c00 2021-03-03 19:11:07,775 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0xa995d0) 2021-03-03 19:11:07,775 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2021-03-03 19:11:07,775 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0x76d67c10 2021-03-03 19:11:07,775 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2021-03-03 19:11:07,776 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0x76d67c10 2021-03-03 19:11:07,776 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0x76d67c10 2021-03-03 19:11:07,776 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0xa99628) 2021-03-03 19:11:07,776 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2021-03-03 19:11:07,776 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0x76d67c20 2021-03-03 19:11:07,777 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2021-03-03 19:11:07,777 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0x76d67c20 2021-03-03 19:11:07,777 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0x76d67c20 2021-03-03 19:11:07,777 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0xa99680) 2021-03-03 19:11:07,778 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2021-03-03 19:11:07,778 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0x76d67c30 2021-03-03 19:11:07,778 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2021-03-03 19:11:07,778 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0x76d67c30 2021-03-03 19:11:07,778 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0x76d67c30 2021-03-03 19:11:07,779 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0xa996e8) 2021-03-03 19:11:07,779 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2021-03-03 19:11:07,779 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0x76d67c40 2021-03-03 19:11:07,779 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2021-03-03 19:11:07,780 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0x76d67c40 2021-03-03 19:11:07,780 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0x76d67c40 2021-03-03 19:11:07,780 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0xa99740) 2021-03-03 19:11:07,780 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2021-03-03 19:11:07,781 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0x76d67c50 2021-03-03 19:11:07,781 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2021-03-03 19:11:07,781 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0x76d67c50 2021-03-03 19:11:07,781 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0x76d67c50 2021-03-03 19:11:07,782 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_audio_codecs -> 0x72e8c508 2021-03-03 19:11:07,782 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d67bd0 [0xa993e0]) 2021-03-03 19:11:07,782 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x72e87420 2021-03-03 19:11:07,782 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d67bd0 [0xa993e0]) 2021-03-03 19:11:07,782 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x72e87420 2021-03-03 19:11:07,783 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec opus 2021-03-03 19:11:07,783 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x72e794d0 [0xb0f0e0], 0x76d67bd0 [0xa993e0], 0x2a311c [0]) 2021-03-03 19:11:07,783 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x90576c 2021-03-03 19:11:07,784 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d67bc0 [0xa99450]) 2021-03-03 19:11:07,784 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x72e87760 2021-03-03 19:11:07,784 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d67bc0 [0xa99450]) 2021-03-03 19:11:07,784 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x72e87760 2021-03-03 19:11:07,784 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec speex 2021-03-03 19:11:07,785 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x72e794d0 [0xb0f0e0], 0x76d67bc0 [0xa99450], 0x2a311c [0]) 2021-03-03 19:11:07,785 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x90576c 2021-03-03 19:11:07,785 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d67be0 [0xa994b8]) 2021-03-03 19:11:07,785 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x72e87420 2021-03-03 19:11:07,786 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d67be0 [0xa994b8]) 2021-03-03 19:11:07,786 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x72e87420 2021-03-03 19:11:07,786 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec speex 2021-03-03 19:11:07,786 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x72e794d0 [0xb0f0e0], 0x76d67be0 [0xa994b8], 0x2a311c [0]) 2021-03-03 19:11:07,787 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x90576c 2021-03-03 19:11:07,787 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d67bf0 [0xa99520]) 2021-03-03 19:11:07,787 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x72e87760 2021-03-03 19:11:07,787 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d67bf0 [0xa99520]) 2021-03-03 19:11:07,788 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x72e87760 2021-03-03 19:11:07,788 [DEBUG] [doorpi.sipphone.from_linphone] enable audio codec PCMU 2021-03-03 19:11:07,788 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x72e794d0 [0xb0f0e0], 0x76d67bf0 [0xa99520], 0x2a3128 [1]) 2021-03-03 19:11:07,788 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x90576c 2021-03-03 19:11:07,789 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d67c00 [0xa99578]) 2021-03-03 19:11:07,789 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x72e87420 2021-03-03 19:11:07,789 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d67c00 [0xa99578]) 2021-03-03 19:11:07,789 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x72e87420 2021-03-03 19:11:07,790 [DEBUG] [doorpi.sipphone.from_linphone] enable audio codec PCMA 2021-03-03 19:11:07,790 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x72e794d0 [0xb0f0e0], 0x76d67c00 [0xa99578], 0x2a3128 [1]) 2021-03-03 19:11:07,790 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x90576c 2021-03-03 19:11:07,790 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d67c10 [0xa995d0]) 2021-03-03 19:11:07,791 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x72e794e8 2021-03-03 19:11:07,791 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d67c10 [0xa995d0]) 2021-03-03 19:11:07,791 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x72e794e8 2021-03-03 19:11:07,791 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec GSM 2021-03-03 19:11:07,792 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x72e794d0 [0xb0f0e0], 0x76d67c10 [0xa995d0], 0x2a311c [0]) 2021-03-03 19:11:07,792 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x90576c 2021-03-03 19:11:07,792 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d67c20 [0xa99628]) 2021-03-03 19:11:07,792 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x72e87420 2021-03-03 19:11:07,793 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d67c20 [0xa99628]) 2021-03-03 19:11:07,793 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x72e87420 2021-03-03 19:11:07,793 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec G722 2021-03-03 19:11:07,793 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x72e794d0 [0xb0f0e0], 0x76d67c20 [0xa99628], 0x2a311c [0]) 2021-03-03 19:11:07,794 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x90576c 2021-03-03 19:11:07,794 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d67c30 [0xa99680]) 2021-03-03 19:11:07,794 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x72e87760 2021-03-03 19:11:07,794 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d67c30 [0xa99680]) 2021-03-03 19:11:07,795 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x72e87760 2021-03-03 19:11:07,795 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec speex 2021-03-03 19:11:07,795 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x72e794d0 [0xb0f0e0], 0x76d67c30 [0xa99680], 0x2a311c [0]) 2021-03-03 19:11:07,795 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x90576c 2021-03-03 19:11:07,796 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d67c40 [0xa996e8]) 2021-03-03 19:11:07,796 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x72e794e8 2021-03-03 19:11:07,796 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d67c40 [0xa996e8]) 2021-03-03 19:11:07,796 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x72e794e8 2021-03-03 19:11:07,796 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec L16 2021-03-03 19:11:07,797 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x72e794d0 [0xb0f0e0], 0x76d67c40 [0xa996e8], 0x2a311c [0]) 2021-03-03 19:11:07,797 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x90576c 2021-03-03 19:11:07,797 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d67c50 [0xa99740]) 2021-03-03 19:11:07,797 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x72e794e8 2021-03-03 19:11:07,798 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d67c50 [0xa99740]) 2021-03-03 19:11:07,798 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x72e794e8 2021-03-03 19:11:07,798 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec L16 2021-03-03 19:11:07,798 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x72e794d0 [0xb0f0e0], 0x76d67c50 [0xa99740], 0x2a311c [0]) 2021-03-03 19:11:07,799 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x90576c 2021-03-03 19:11:07,799 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_video_devices(0x72e794d0 [0xb0f0e0]) 2021-03-03 19:11:07,799 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_video_devices -> 0x72e8c490 2021-03-03 19:11:07,799 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_video_devices(0x72e794d0 [0xb0f0e0]) 2021-03-03 19:11:07,800 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_video_devices -> 0x72e8c490 2021-03-03 19:11:07,800 [INFO] [doorpi.sipphone.from_linphone] found 2 possible videodevices: 2021-03-03 19:11:07,800 [DEBUG] [doorpi.sipphone.from_linphone] | name 2021-03-03 19:11:07,800 [DEBUG] [doorpi.sipphone.from_linphone] ------------------------------------ 2021-03-03 19:11:07,800 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_video_devices(0x72e794d0 [0xb0f0e0]) 2021-03-03 19:11:07,801 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_video_devices -> 0x72e8c490 2021-03-03 19:11:07,801 [DEBUG] [doorpi.sipphone.from_linphone] | V4L2: /dev/video0 2021-03-03 19:11:07,801 [DEBUG] [doorpi.sipphone.from_linphone] | StaticImage: Static picture 2021-03-03 19:11:07,801 [DEBUG] [doorpi.sipphone.from_linphone] ------------------------------------ 2021-03-03 19:11:07,802 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_video_devices(0x72e794d0 [0xb0f0e0]) 2021-03-03 19:11:07,802 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_video_devices -> 0x72e8c490 2021-03-03 19:11:07,802 [TRACE] [doorpi.conf.config_object] get_string for key video_device in section SIP-Phone (default: V4L2: /dev/video0) returns V4L2: /dev/video0 2021-03-03 19:11:07,802 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_video_devices(0x72e794d0 [0xb0f0e0]) 2021-03-03 19:11:07,803 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_video_devices -> 0x72e8c490 2021-03-03 19:11:07,803 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_enable_video_capture(0x72e794d0 [0xb0f0e0], 0x2a3128 [1]) 2021-03-03 19:11:07,803 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_enable_video_capture -> 0 2021-03-03 19:11:07,803 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_video_device(0x72e794d0 [0xb0f0e0], "V4L2: /dev/video0") 2021-03-03 19:11:07,804 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_video_device -> 0 2021-03-03 19:11:07,804 [TRACE] [doorpi.conf.config_object] get_string for key video_size in section SIP-Phone (default: vga) returns vga 2021-03-03 19:11:07,804 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_preferred_video_size_by_name(0x72e794d0 [0xb0f0e0], "vga") 2021-03-03 19:11:07,804 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_preferred_video_size_by_name -> 0 2021-03-03 19:11:07,805 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_video_device(0x72e794d0 [0xb0f0e0]) 2021-03-03 19:11:07,805 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_video_device -> 0x72e8c5c0 2021-03-03 19:11:07,805 [DEBUG] [doorpi.sipphone.from_linphone] using video_device: V4L2: /dev/video0 2021-03-03 19:11:07,805 [TRACE] [doorpi.conf.config_object] get_list for key video_codecs in section SIP-Phone (default: VP8) returns ['VP8'] 2021-03-03 19:11:07,805 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_video_codecs(0x72e794d0 [0xb0f0e0]) 2021-03-03 19:11:07,806 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0xb154a8) 2021-03-03 19:11:07,806 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2021-03-03 19:11:07,806 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0x76d67c60 2021-03-03 19:11:07,806 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2021-03-03 19:11:07,807 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0x76d67c60 2021-03-03 19:11:07,807 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0x76d67c60 2021-03-03 19:11:07,807 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_video_codecs -> 0x72e8c4b8 2021-03-03 19:11:07,807 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d67c60 [0xb154a8]) 2021-03-03 19:11:07,807 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x72e794e8 2021-03-03 19:11:07,808 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_video_capture_enabled(0x72e794d0 [0xb0f0e0]) 2021-03-03 19:11:07,808 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_video_capture_enabled -> 0x2a3128 2021-03-03 19:11:07,808 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d67c60 [0xb154a8]) 2021-03-03 19:11:07,808 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x72e794e8 2021-03-03 19:11:07,809 [DEBUG] [doorpi.sipphone.from_linphone] enable video codec VP8 2021-03-03 19:11:07,809 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x72e794d0 [0xb0f0e0], 0x76d67c60 [0xb154a8], 0x2a3128 [1]) 2021-03-03 19:11:07,809 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x90576c 2021-03-03 19:11:07,810 [TRACE] [doorpi.conf.config_object] get_string for key sipserver_server in section SIP-Phone (default: ) returns 192.168.2.1 2021-03-03 19:11:07,810 [TRACE] [doorpi.conf.config_object] get_string for key sipserver_username in section SIP-Phone (default: ) returns klingeltest 2021-03-03 19:11:07,810 [TRACE] [doorpi.conf.config_object] get_string for key sipserver_password in section SIP-Phone (default: klingeltest) returns ******* 2021-03-03 19:11:07,810 [TRACE] [doorpi.conf.config_object] get_string for key sipserver_realm in section SIP-Phone (default: 192.168.2.1) returns 192.168.2.1 2021-03-03 19:11:07,811 [INFO] [doorpi.sipphone.from_linphone] using DoorPi with SIP-Server 2021-03-03 19:11:07,811 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_create_proxy_config(0x72e794d0 [0xb0f0e0]) 2021-03-03 19:11:07,811 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_ProxyConfig_from_native_ptr(0xa254c0) 2021-03-03 19:11:07,811 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_ProxyConfig_new() 2021-03-03 19:11:07,812 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_ProxyConfig_new -> 0x76d67c70 2021-03-03 19:11:07,812 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_ProxyConfig_init() 2021-03-03 19:11:07,812 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_ProxyConfig_init -> 0x76d67c70 2021-03-03 19:11:07,812 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_ProxyConfig_from_native_ptr -> 0x76d67c70 2021-03-03 19:11:07,812 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_create_proxy_config -> 0x76d67c70 2021-03-03 19:11:07,813 [TRACE] [doorpi.conf.config_object] get_string for key identity in section SIP-Phone (default: DoorPi) returns DoorPi 2021-03-03 19:11:07,813 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Address_class_method_new("DoorPi ") 2021-03-03 19:11:07,814 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Address_from_native_ptr(0xb0e3f8) 2021-03-03 19:11:07,814 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Address_new() 2021-03-03 19:11:07,814 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Address_new -> 0x76d67c80 2021-03-03 19:11:07,814 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Address_init() 2021-03-03 19:11:07,815 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Address_init -> 0x76d67c80 2021-03-03 19:11:07,815 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Address_from_native_ptr -> 0x76d67c80 2021-03-03 19:11:07,815 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Address_class_method_new -> 0x76d67c80 2021-03-03 19:11:07,815 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_ProxyConfig_set_identity_address(0x76d67c70 [0xa254c0], 0x76d67c80 [0xb0e3f8]) 2021-03-03 19:11:07,816 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_ProxyConfig_set_identity_address -> 0 2021-03-03 19:11:07,816 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_ProxyConfig_set_server_addr(0x76d67c70 [0xa254c0], "sip:192.168.2.1") 2021-03-03 19:11:07,817 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_ProxyConfig_set_server_addr -> 0 2021-03-03 19:11:07,817 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_ProxyConfig_enable_register(0x76d67c70 [0xa254c0], 0x2a3128 [1]) 2021-03-03 19:11:07,817 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_ProxyConfig_enable_register -> 0 2021-03-03 19:11:07,817 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_add_proxy_config(0x72e794d0 [0xb0f0e0], 0x76d67c70 [0xa254c0]) 2021-03-03 19:11:07,818 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_add_proxy_config -> 0x90576c 2021-03-03 19:11:07,818 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_default_proxy_config(0x72e794d0 [0xb0f0e0], 0x76d67c70 [0xa254c0]) 2021-03-03 19:11:07,819 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_default_proxy_config -> 0 2021-03-03 19:11:07,819 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_create_auth_info(0x72e794d0 [0xb0f0e0], "klingeltest", "(null)", "jannis2014", "(null)", "(null)", "192.168.2.1") 2021-03-03 19:11:07,819 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_AuthInfo_from_native_ptr(0xb0f0a8) 2021-03-03 19:11:07,819 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_AuthInfo_new() 2021-03-03 19:11:07,819 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_AuthInfo_new -> 0x76d67c90 2021-03-03 19:11:07,820 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_AuthInfo_init() 2021-03-03 19:11:07,820 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_AuthInfo_init -> 0x76d67c90 2021-03-03 19:11:07,820 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_AuthInfo_from_native_ptr -> 0x76d67c90 2021-03-03 19:11:07,820 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_create_auth_info -> 0x76d67c90 2021-03-03 19:11:07,821 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_add_auth_info(0x72e794d0 [0xb0f0e0], 0x76d67c90 [0xb0f0a8]) 2021-03-03 19:11:07,821 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_add_auth_info -> None 2021-03-03 19:11:07,821 [DEBUG] [doorpi.sipphone.from_linphone] start successfully 2021-03-03 19:11:07,821 [TRACE] [doorpi.conf.config_object] get_sections returns ['EVENT_OnStartup', 'EVENT_OnKeyPressed_nextion.54542121', 'EVENT_OnKeyPressed_rfidreader.0010327614', 'EVENT_OnKeyPressed_rfidreader.0004594429', 'EVENT_OnSipPhoneMakeCall', 'EVENT_OnKeyPressed_onboardpins.3', 'EVENT_OnKeyPressed_onboardpins.1', 'EVENT_OnKeyPressed_onboardpins.0', 'EVENT_OnKeyPressed_rfidreader.0010371593'] 2021-03-03 19:11:07,822 [INFO] [doorpi.doorpi] found EVENT_ section 'EVENT_OnStartup' in configfile 2021-03-03 19:11:07,822 [TRACE] [doorpi.conf.config_object] get_keys for section EVENT_OnStartup returns ['10', '20'] 2021-03-03 19:11:07,822 [INFO] [doorpi.doorpi] registering action '10' for event 'OnStartup' 2021-03-03 19:11:07,822 [TRACE] [doorpi.conf.config_object] get_string for key 10 in section EVENT_OnStartup (default: ) returns sleep:1 2021-03-03 19:11:07,823 [DEBUG] [doorpi.action.SingleActions.sleep] doorpi.action.SingleActions.sleep loaded 2021-03-03 19:11:07,823 [TRACE] [doorpi.action.handler] action SleepAction with args (1.0,) and kwargs {} was added to new evententry OnStartup 2021-03-03 19:11:07,824 [INFO] [doorpi.doorpi] registering action '20' for event 'OnStartup' 2021-03-03 19:11:07,824 [TRACE] [doorpi.conf.config_object] get_string for key 20 in section EVENT_OnStartup (default: ) returns os_execute:/usr/local/etc/DoorPi/scripts/Startmeldung.sh 2021-03-03 19:11:07,824 [DEBUG] [doorpi.action.SingleActions.os_execute] doorpi.action.SingleActions.os_execute loaded 2021-03-03 19:11:07,826 [TRACE] [doorpi.action.handler] action OsExecuteAction with args () and kwargs {'command': '/usr/local/etc/DoorPi/scripts/Startmeldung.sh'} was added to event OnStartup 2021-03-03 19:11:07,826 [INFO] [doorpi.doorpi] found EVENT_ section 'EVENT_OnKeyPressed_nextion.54542121' in configfile 2021-03-03 19:11:07,826 [TRACE] [doorpi.conf.config_object] get_keys for section EVENT_OnKeyPressed_nextion.54542121 returns ['10'] 2021-03-03 19:11:07,826 [INFO] [doorpi.doorpi] registering action '10' for event 'OnKeyPressed_nextion.54542121' 2021-03-03 19:11:07,827 [TRACE] [doorpi.conf.config_object] get_string for key 10 in section EVENT_OnKeyPressed_nextion.54542121 (default: ) returns os_execute:/usr/local/etc/DoorPi/scripts/Klingelbild.sh 2021-03-03 19:11:07,828 [TRACE] [doorpi.action.handler] action OsExecuteAction with args () and kwargs {'command': '/usr/local/etc/DoorPi/scripts/Klingelbild.sh'} was added to new evententry OnKeyPressed_nextion.54542121 2021-03-03 19:11:07,828 [INFO] [doorpi.doorpi] found EVENT_ section 'EVENT_OnKeyPressed_rfidreader.0010327614' in configfile 2021-03-03 19:11:07,828 [TRACE] [doorpi.conf.config_object] get_keys for section EVENT_OnKeyPressed_rfidreader.0010327614 returns ['10'] 2021-03-03 19:11:07,828 [INFO] [doorpi.doorpi] registering action '10' for event 'OnKeyPressed_rfidreader.0010327614' 2021-03-03 19:11:07,829 [TRACE] [doorpi.conf.config_object] get_string for key 10 in section EVENT_OnKeyPressed_rfidreader.0010327614 (default: ) returns os_execute:aplay !BASEPATH!/media/Hallo_Danny.wav 2021-03-03 19:11:07,830 [TRACE] [doorpi.action.handler] action OsExecuteAction with args () and kwargs {'command': 'aplay /usr/local/etc/DoorPi/media/Hallo_Danny.wav'} was added to new evententry OnKeyPressed_rfidreader.0010327614 2021-03-03 19:11:07,830 [INFO] [doorpi.doorpi] found EVENT_ section 'EVENT_OnKeyPressed_rfidreader.0004594429' in configfile 2021-03-03 19:11:07,830 [TRACE] [doorpi.conf.config_object] get_keys for section EVENT_OnKeyPressed_rfidreader.0004594429 returns ['10'] 2021-03-03 19:11:07,830 [INFO] [doorpi.doorpi] registering action '10' for event 'OnKeyPressed_rfidreader.0004594429' 2021-03-03 19:11:07,830 [TRACE] [doorpi.conf.config_object] get_string for key 10 in section EVENT_OnKeyPressed_rfidreader.0004594429 (default: ) returns os_execute:aplay !BASEPATH!/media/hallo_cori.wav 2021-03-03 19:11:07,832 [TRACE] [doorpi.action.handler] action OsExecuteAction with args () and kwargs {'command': 'aplay /usr/local/etc/DoorPi/media/hallo_cori.wav'} was added to new evententry OnKeyPressed_rfidreader.0004594429 2021-03-03 19:11:07,832 [INFO] [doorpi.doorpi] found EVENT_ section 'EVENT_OnSipPhoneMakeCall' in configfile 2021-03-03 19:11:07,832 [TRACE] [doorpi.conf.config_object] get_keys for section EVENT_OnSipPhoneMakeCall returns ['10'] 2021-03-03 19:11:07,832 [INFO] [doorpi.doorpi] registering action '10' for event 'OnSipPhoneMakeCall' 2021-03-03 19:11:07,833 [TRACE] [doorpi.conf.config_object] get_string for key 10 in section EVENT_OnSipPhoneMakeCall (default: ) returns out:page 5,1 2021-03-03 19:11:07,833 [DEBUG] [doorpi.action.SingleActions.out] doorpi.action.SingleActions.out loaded 2021-03-03 19:11:07,834 [DEBUG] [doorpi.action.SingleActions.out_triggered] doorpi.action.SingleActions.out_triggered loaded 2021-03-03 19:11:07,834 [TRACE] [doorpi.action.handler] action OutAction with args () and kwargs {'log_output': True, 'value': '1', 'pin': 'page 5'} was added to event OnSipPhoneMakeCall 2021-03-03 19:11:07,834 [INFO] [doorpi.doorpi] found EVENT_ section 'EVENT_OnKeyPressed_onboardpins.3' in configfile 2021-03-03 19:11:07,835 [TRACE] [doorpi.conf.config_object] get_keys for section EVENT_OnKeyPressed_onboardpins.3 returns ['10'] 2021-03-03 19:11:07,835 [INFO] [doorpi.doorpi] registering action '10' for event 'OnKeyPressed_onboardpins.3' 2021-03-03 19:11:07,835 [TRACE] [doorpi.conf.config_object] get_string for key 10 in section EVENT_OnKeyPressed_onboardpins.3 (default: ) returns out:sleep=0,1 2021-03-03 19:11:07,835 [TRACE] [doorpi.action.handler] action OutAction with args () and kwargs {'log_output': True, 'value': '1', 'pin': 'sleep=0'} was added to new evententry OnKeyPressed_onboardpins.3 2021-03-03 19:11:07,836 [INFO] [doorpi.doorpi] found EVENT_ section 'EVENT_OnKeyPressed_onboardpins.1' in configfile 2021-03-03 19:11:07,836 [TRACE] [doorpi.conf.config_object] get_keys for section EVENT_OnKeyPressed_onboardpins.1 returns ['10', '30', '20'] 2021-03-03 19:11:07,836 [INFO] [doorpi.doorpi] registering action '10' for event 'OnKeyPressed_onboardpins.1' 2021-03-03 19:11:07,836 [TRACE] [doorpi.conf.config_object] get_string for key 10 in section EVENT_OnKeyPressed_onboardpins.1 (default: ) returns out:page 4,1 2021-03-03 19:11:07,837 [TRACE] [doorpi.action.handler] action OutAction with args () and kwargs {'log_output': True, 'value': '1', 'pin': 'page 4'} was added to new evententry OnKeyPressed_onboardpins.1 2021-03-03 19:11:07,837 [INFO] [doorpi.doorpi] registering action '20' for event 'OnKeyPressed_onboardpins.1' 2021-03-03 19:11:07,837 [TRACE] [doorpi.conf.config_object] get_string for key 20 in section EVENT_OnKeyPressed_onboardpins.1 (default: ) returns os_execute:aplay !BASEPATH!/media/Alarmanlage.wav 2021-03-03 19:11:07,838 [TRACE] [doorpi.action.handler] action OsExecuteAction with args () and kwargs {'command': 'aplay /usr/local/etc/DoorPi/media/Alarmanlage.wav'} was added to event OnKeyPressed_onboardpins.1 2021-03-03 19:11:07,838 [INFO] [doorpi.doorpi] registering action '30' for event 'OnKeyPressed_onboardpins.1' 2021-03-03 19:11:07,839 [TRACE] [doorpi.conf.config_object] get_string for key 30 in section EVENT_OnKeyPressed_onboardpins.1 (default: ) returns os_execute:/usr/local/etc/DoorPi/scripts/Sabotagekontakt.sh 2021-03-03 19:11:07,840 [TRACE] [doorpi.action.handler] action OsExecuteAction with args () and kwargs {'command': '/usr/local/etc/DoorPi/scripts/Sabotagekontakt.sh'} was added to event OnKeyPressed_onboardpins.1 2021-03-03 19:11:07,840 [INFO] [doorpi.doorpi] found EVENT_ section 'EVENT_OnKeyPressed_onboardpins.0' in configfile 2021-03-03 19:11:07,840 [TRACE] [doorpi.conf.config_object] get_keys for section EVENT_OnKeyPressed_onboardpins.0 returns ['10'] 2021-03-03 19:11:07,840 [INFO] [doorpi.doorpi] registering action '10' for event 'OnKeyPressed_onboardpins.0' 2021-03-03 19:11:07,840 [TRACE] [doorpi.conf.config_object] get_string for key 10 in section EVENT_OnKeyPressed_onboardpins.0 (default: ) returns os_execute:/usr/local/etc/DoorPi/scripts/Klingelbild.sh 2021-03-03 19:11:07,842 [TRACE] [doorpi.action.handler] action OsExecuteAction with args () and kwargs {'command': '/usr/local/etc/DoorPi/scripts/Klingelbild.sh'} was added to new evententry OnKeyPressed_onboardpins.0 2021-03-03 19:11:07,842 [INFO] [doorpi.doorpi] found EVENT_ section 'EVENT_OnKeyPressed_rfidreader.0010371593' in configfile 2021-03-03 19:11:07,842 [TRACE] [doorpi.conf.config_object] get_keys for section EVENT_OnKeyPressed_rfidreader.0010371593 returns ['10', '20'] 2021-03-03 19:11:07,842 [INFO] [doorpi.doorpi] registering action '10' for event 'OnKeyPressed_rfidreader.0010371593' 2021-03-03 19:11:07,842 [TRACE] [doorpi.conf.config_object] get_string for key 10 in section EVENT_OnKeyPressed_rfidreader.0010371593 (default: ) returns os_execute:aplay !BASEPATH!/media/Pika.wav 2021-03-03 19:11:07,843 [TRACE] [doorpi.action.handler] action OsExecuteAction with args () and kwargs {'command': 'aplay /usr/local/etc/DoorPi/media/Pika.wav'} was added to new evententry OnKeyPressed_rfidreader.0010371593 2021-03-03 19:11:07,844 [INFO] [doorpi.doorpi] registering action '20' for event 'OnKeyPressed_rfidreader.0010371593' 2021-03-03 19:11:07,844 [TRACE] [doorpi.conf.config_object] get_string for key 20 in section EVENT_OnKeyPressed_rfidreader.0010371593 (default: ) returns out:page 3,1 2021-03-03 19:11:07,844 [TRACE] [doorpi.action.handler] action OutAction with args () and kwargs {'log_output': True, 'value': '1', 'pin': 'page 3'} was added to event OnKeyPressed_rfidreader.0010371593 2021-03-03 19:11:07,845 [TRACE] [doorpi.conf.config_object] get_string for key 0010371593 in section rfidreader_InputPins (default: ) returns out:Tueroeffner,1,0,3 2021-03-03 19:11:07,845 [TRACE] [doorpi.action.handler] action OutTriggeredAction with args () and kwargs {'stop_pin': 'NoStopPinSet', 'end_value': '0', 'timeout': 3.0, 'pin': 'Tueroeffner', 'start_value': '1'} was added to event OnKeyPressed_rfidreader.0010371593 2021-03-03 19:11:07,845 [TRACE] [doorpi.conf.config_object] get_string for key 0010327614 in section rfidreader_InputPins (default: ) returns out:Tueroeffner,1,0,3 2021-03-03 19:11:07,846 [TRACE] [doorpi.action.handler] action OutTriggeredAction with args () and kwargs {'stop_pin': 'NoStopPinSet', 'end_value': '0', 'timeout': 3.0, 'pin': 'Tueroeffner', 'start_value': '1'} was added to event OnKeyPressed_rfidreader.0010327614 2021-03-03 19:11:07,846 [TRACE] [doorpi.conf.config_object] get_string for key 0004594429 in section rfidreader_InputPins (default: ) returns out:Tueroeffner,1,0,3 2021-03-03 19:11:07,846 [TRACE] [doorpi.action.handler] action OutTriggeredAction with args () and kwargs {'stop_pin': 'NoStopPinSet', 'end_value': '0', 'timeout': 3.0, 'pin': 'Tueroeffner', 'start_value': '1'} was added to event OnKeyPressed_rfidreader.0004594429 2021-03-03 19:11:07,846 [TRACE] [doorpi.conf.config_object] get_string for key 22085 in section nextion_InputPins (default: ) returns out:Tueroeffner,1,0,3 2021-03-03 19:11:07,847 [TRACE] [doorpi.action.handler] action OutTriggeredAction with args () and kwargs {'stop_pin': 'NoStopPinSet', 'end_value': '0', 'timeout': 3.0, 'pin': 'Tueroeffner', 'start_value': '1'} was added to new evententry OnKeyPressed_nextion.22085 2021-03-03 19:11:07,847 [TRACE] [doorpi.conf.config_object] get_string for key 54542121 in section nextion_InputPins (default: ) returns call:**612 2021-03-03 19:11:07,848 [DEBUG] [doorpi.action.SingleActions.call] doorpi.action.SingleActions.call loaded 2021-03-03 19:11:07,848 [TRACE] [doorpi.action.handler] action CallAction with args () and kwargs {'number': '**612'} was added to event OnKeyPressed_nextion.54542121 2021-03-03 19:11:07,848 [TRACE] [doorpi.conf.config_object] get_string for key 54542120 in section nextion_InputPins (default: ) returns call:**600 2021-03-03 19:11:07,848 [TRACE] [doorpi.action.handler] action CallAction with args () and kwargs {'number': '**600'} was added to new evententry OnKeyPressed_nextion.54542120 2021-03-03 19:11:07,849 [TRACE] [doorpi.conf.config_object] get_string for key 1 in section onboardpins_InputPins (default: ) returns sleep:0 2021-03-03 19:11:07,849 [TRACE] [doorpi.action.handler] action SleepAction with args (0.0,) and kwargs {} was added to event OnKeyPressed_onboardpins.1 2021-03-03 19:11:07,849 [TRACE] [doorpi.conf.config_object] get_string for key 0 in section onboardpins_InputPins (default: ) returns call:**612 2021-03-03 19:11:07,850 [TRACE] [doorpi.action.handler] action CallAction with args () and kwargs {'number': '**612'} was added to event OnKeyPressed_onboardpins.0 2021-03-03 19:11:07,850 [TRACE] [doorpi.conf.config_object] get_string for key 3 in section onboardpins_InputPins (default: ) returns sleep:0 2021-03-03 19:11:07,850 [TRACE] [doorpi.action.handler] action SleepAction with args (0.0,) and kwargs {} was added to event OnKeyPressed_onboardpins.3 2021-03-03 19:11:07,850 [TRACE] [doorpi.conf.config_object] get_string for key 2 in section onboardpins_InputPins (default: ) returns sleep:0 2021-03-03 19:11:07,851 [TRACE] [doorpi.action.handler] action SleepAction with args (0.0,) and kwargs {} was added to new evententry OnKeyPressed_onboardpins.2 2021-03-03 19:11:07,851 [TRACE] [doorpi.conf.config_object] get_string for key 5 in section onboardpins_InputPins (default: ) returns sleep:0 2021-03-03 19:11:07,851 [TRACE] [doorpi.action.handler] action SleepAction with args (0.0,) and kwargs {} was added to new evententry OnKeyPressed_onboardpins.5 2021-03-03 19:11:07,851 [TRACE] [doorpi.conf.config_object] get_string for key 4 in section onboardpins_InputPins (default: ) returns sleep:0 2021-03-03 19:11:07,852 [TRACE] [doorpi.action.handler] action SleepAction with args (0.0,) and kwargs {} was added to new evententry OnKeyPressed_onboardpins.4 2021-03-03 19:11:07,852 [TRACE] [doorpi.conf.config_object] get_string for key 7 in section onboardpins_InputPins (default: ) returns sleep:0 2021-03-03 19:11:07,852 [TRACE] [doorpi.action.handler] action SleepAction with args (0.0,) and kwargs {} was added to new evententry OnKeyPressed_onboardpins.7 2021-03-03 19:11:07,852 [TRACE] [doorpi.conf.config_object] get_string for key 6 in section onboardpins_InputPins (default: ) returns sleep:0 2021-03-03 19:11:07,853 [TRACE] [doorpi.action.handler] action SleepAction with args (0.0,) and kwargs {} was added to new evententry OnKeyPressed_onboardpins.6 2021-03-03 19:11:07,853 [TRACE] [doorpi.conf.config_object] get_keys for section DTMF returns ['"0"', '"1"', '"2"'] 2021-03-03 19:11:07,853 [TRACE] [doorpi.conf.config_object] get_string for key "0" in section DTMF (default: ) returns out:Tueroeffner,1,0,3 2021-03-03 19:11:07,854 [TRACE] [doorpi.action.handler] action OutTriggeredAction with args () and kwargs {'stop_pin': 'NoStopPinSet', 'end_value': '0', 'timeout': 3.0, 'pin': 'Tueroeffner', 'start_value': '1'} was added to new evententry OnDTMF_"0" 2021-03-03 19:11:07,854 [TRACE] [doorpi.conf.config_object] get_string for key "1" in section DTMF (default: ) returns out:page 0,1 2021-03-03 19:11:07,854 [TRACE] [doorpi.action.handler] action OutAction with args () and kwargs {'log_output': True, 'value': '1', 'pin': 'page 0'} was added to new evententry OnDTMF_"1" 2021-03-03 19:11:07,854 [TRACE] [doorpi.conf.config_object] get_string for key "2" in section DTMF (default: ) returns out:page 2,1 2021-03-03 19:11:07,855 [TRACE] [doorpi.action.handler] action OutAction with args () and kwargs {'log_output': True, 'value': '1', 'pin': 'page 2'} was added to new evententry OnDTMF_"2" 2021-03-03 19:11:07,855 [TRACE] [doorpi.conf.config_object] get_string for key is_alive_led in section DoorPi (default: ) returns 2021-03-03 19:11:07,855 [TRACE] [doorpi.action.handler] fire Event BeforeStartup from doorpi.doorpi asyncron 2021-03-03 19:11:07,856 [DEBUG] [doorpi.action.handler] [H105GA] fire for event OnStartup this actions [, ] 2021-03-03 19:11:07,857 [DEBUG] [doorpi.action.handler] no actions for event BeforeStartup - skip fire_event BeforeStartup from doorpi.doorpi 2021-03-03 19:11:07,857 [TRACE] [doorpi.action.handler] [H105GA] try to fire action SleepAction with args (1.0,) and kwargs {} 2021-03-03 19:11:07,857 [TRACE] [doorpi.action.base] run SleepAction with args (1.0,) and kwargs {} 2021-03-03 19:11:08,860 [TRACE] [doorpi.action.handler] [H105GA] try to fire action OsExecuteAction with args () and kwargs {'command': '/usr/local/etc/DoorPi/scripts/Startmeldung.sh'} 2021-03-03 19:11:08,860 [TRACE] [doorpi.action.base] run OsExecuteAction with args () and kwargs {'command': '/usr/local/etc/DoorPi/scripts/Startmeldung.sh'} 2021-03-03 19:11:09,071 [TRACE] [doorpi.action.handler] [H105GA] finished fire_event for event_name OnStartup 2021-03-03 19:11:09,071 [TRACE] [doorpi.action.handler] fire Event AfterStartup from doorpi.doorpi asyncron 2021-03-03 19:11:09,072 [INFO] [doorpi.doorpi] DoorPi started successfully 2021-03-03 19:11:09,073 [INFO] [doorpi.doorpi] BasePath is /usr/local/etc/DoorPi 2021-03-03 19:11:09,073 [DEBUG] [doorpi.action.handler] no actions for event AfterStartup - skip fire_event AfterStartup from doorpi.doorpi 2021-03-03 19:11:09,073 [INFO] [doorpi.doorpi] Weburl is http://raspberrypi:8081/ 2021-03-03 19:11:09,074 [INFO] [doorpi.sipphone.from_linphone] resolved to 192.168.2.1 2021-03-03 19:11:09,075 [INFO] [doorpi.sipphone.from_linphone] Stun server resolution successful. 2021-03-03 19:11:09,075 [INFO] [doorpi.sipphone.from_linphone] New local ip address is 192.168.2.137 2021-03-03 19:11:09,076 [INFO] [doorpi.sipphone.from_linphone] Network state is now [UP] 2021-03-03 19:11:09,076 [INFO] [doorpi.sipphone.from_linphone] Resolver is using DNS server(s): 2021-03-03 19:11:09,076 [INFO] [doorpi.sipphone.from_linphone] 192.168.2.1 2021-03-03 19:11:09,077 [INFO] [doorpi.sipphone.from_linphone] fd00::e228:6dff:fee1:c9ec 2021-03-03 19:11:09,077 [INFO] [doorpi.sipphone.from_linphone] resolver_process_data dns_res_check() in progress 2021-03-03 19:11:09,078 [INFO] [doorpi.sipphone.from_linphone] DNS resolution awaiting response, queued to main loop 2021-03-03 19:11:09,078 [INFO] [doorpi.sipphone.from_linphone] LinphoneProxyConfig [0xa254c0] about to register (LinphoneCore version: 3.9.0) 2021-03-03 19:11:09,083 [INFO] [doorpi.sipphone.from_linphone] belle_sip_client_transaction_send_request(): waiting channel to be ready 2021-03-03 19:11:09,083 [INFO] [doorpi.sipphone.from_linphone] channel [0xb29ab8]: starting resolution of 192.168.2.1 2021-03-03 19:11:09,084 [INFO] [doorpi.sipphone.from_linphone] channel 0xb29ab8: state RES_IN_PROGRESS 2021-03-03 19:11:09,084 [INFO] [doorpi.sipphone.from_linphone] transaction [0x98d968] channel state changed to [RES_IN_PROGRESS] 2021-03-03 19:11:09,084 [INFO] [doorpi.sipphone.from_linphone] channel 0xb29ab8: state RES_DONE 2021-03-03 19:11:09,084 [INFO] [doorpi.sipphone.from_linphone] transaction [0x98d968] channel state changed to [RES_DONE] 2021-03-03 19:11:09,085 [INFO] [doorpi.sipphone.from_linphone] channel 0xb29ab8: state CONNECTING 2021-03-03 19:11:09,085 [INFO] [doorpi.sipphone.from_linphone] transaction [0x98d968] channel state changed to [CONNECTING] 2021-03-03 19:11:09,085 [INFO] [doorpi.sipphone.from_linphone] Trying to connect to [UDP://192.168.2.1:5060] 2021-03-03 19:11:09,085 [INFO] [doorpi.sipphone.from_linphone] belle_sip_get_src_addr_for(): af_inet6=0 2021-03-03 19:11:09,086 [INFO] [doorpi.sipphone.from_linphone] Channel has local address 192.168.2.137:5060 2021-03-03 19:11:09,086 [INFO] [doorpi.sipphone.from_linphone] channel 0xb29ab8: state READY 2021-03-03 19:11:09,086 [INFO] [doorpi.sipphone.from_linphone] transaction [0x98d968] channel state changed to [READY] 2021-03-03 19:11:09,086 [INFO] [doorpi.sipphone.from_linphone] Changing [client] [REGISTER] transaction [0x98d968], from state [INIT] to [TRYING] 2021-03-03 19:11:09,087 [INFO] [doorpi.sipphone.from_linphone] channel [0xb29ab8]: message sent to [UDP://192.168.2.1:5060], size: [530] bytes REGISTER sip:192.168.2.1 SIP/2.0 Via: SIP/2.0/UDP 192.168.2.137:5060;branch=z9hG4bK.Z-dkSBsSr;rport From: "DoorPi" ;tag=kMZ5U~~18 To: "DoorPi" CSeq: 20 REGISTER Call-ID: i1OfVZa7cv Max-Forwards: 70 Supported: outbound Accept: application/sdp Accept: text/plain Accept: application/vnd.gsma.rcs-ft-http+xml Contact: ;+sip.instance="" Expires: 3600 User-Agent: (belle-sip/1.4.2) 2021-03-03 19:11:09,087 [INFO] [doorpi.sipphone.from_linphone] Neither Expires header nor corresponding Contact header found, checking from original request 2021-03-03 19:11:09,088 [INFO] [doorpi.sipphone.from_linphone] Refresher [0xafb4c8] takes ownership of transaction [0x98d968] 2021-03-03 19:11:09,088 [INFO] [doorpi.sipphone.from_linphone] Proxy config [0xa254c0] for identity ["DoorPi" ] moving from state [LinphoneRegistrationNone] to [LinphoneRegistrationProgress] 2021-03-03 19:11:09,088 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_callback_registration_state_changed(0xb0f0e0, 0xa254c0, 1, "Registration in progress") 2021-03-03 19:11:09,088 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_callback_registration_state_changed 2021-03-03 19:11:09,089 [INFO] [doorpi.sipphone.from_linphone] Linphone core [0xb0f0e0] notifying [registration_state_changed] 2021-03-03 19:11:09,139 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_callback_network_reachable(0xb0f0e0, 0x1) 2021-03-03 19:11:09,140 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_callback_network_reachable 2021-03-03 19:11:09,140 [INFO] [doorpi.sipphone.from_linphone] Linphone core [0xb0f0e0] notifying [network_reachable] 2021-03-03 19:11:09,140 [INFO] [doorpi.sipphone.from_linphone] channel [0xb29ab8]: received [377] new bytes from [UDP://192.168.2.1:5060]: SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 192.168.2.137:5060;branch=z9hG4bK.Z-dkSBsSr;rport=5060 From: "DoorPi" ;tag=kMZ5U~~18 To: "DoorPi" ;tag=596649A3B4E4977C Call-ID: i1OfVZa7cv CSeq: 20 REGISTER WWW-Authenticate: Digest realm="fritz.box", nonce="722732B511F460BC" User-Agent: FRITZ!OS Content-Length: 0 2021-03-03 19:11:09,145 [INFO] [doorpi.sipphone.from_linphone] channel [0xb29ab8] [377] bytes parsed 2021-03-03 19:11:09,146 [INFO] [doorpi.sipphone.from_linphone] channel [0xb29ab8]: discovered public ip and port are [192.168.2.137:5060] 2021-03-03 19:11:09,146 [INFO] [doorpi.sipphone.from_linphone] Found transaction matching response. 2021-03-03 19:11:09,146 [INFO] [doorpi.sipphone.from_linphone] Changing [client] [REGISTER] transaction [0x98d968], from state [TRYING] to [COMPLETED] 2021-03-03 19:11:09,147 [INFO] [doorpi.sipphone.from_linphone] linphone_core_find_auth_info(): returning auth info username=klingeltest, realm= 2021-03-03 19:11:09,147 [INFO] [doorpi.sipphone.from_linphone] Auth info found for [klingeltest] realm [fritz.box] 2021-03-03 19:11:09,147 [INFO] [doorpi.sipphone.from_linphone] Changing [client] [REGISTER] transaction [0x90b740], from state [INIT] to [TRYING] 2021-03-03 19:11:09,148 [INFO] [doorpi.sipphone.from_linphone] channel [0xb29ab8]: message sent to [UDP://192.168.2.1:5060], size: [691] bytes REGISTER sip:192.168.2.1 SIP/2.0 Via: SIP/2.0/UDP 192.168.2.137:5060;branch=z9hG4bK.98vIehEFQ;rport From: "DoorPi" ;tag=kMZ5U~~18 To: "DoorPi" CSeq: 21 REGISTER Call-ID: i1OfVZa7cv Max-Forwards: 70 Supported: outbound Accept: application/sdp Accept: text/plain Accept: application/vnd.gsma.rcs-ft-http+xml Contact: ;+sip.instance="" Expires: 3600 User-Agent: (belle-sip/1.4.2) Authorization: Digest realm="fritz.box", nonce="722732B511F460BC", username="klingeltest", uri="sip:192.168.2.1", response="90838bda1171399de8b08e1f1598cbf5" 2021-03-03 19:11:09,148 [INFO] [doorpi.sipphone.from_linphone] resolved to 192.168.2.1 2021-03-03 19:11:09,149 [INFO] [doorpi.sipphone.from_linphone] Stun server resolution successful. 2021-03-03 19:11:09,199 [INFO] [doorpi.sipphone.from_linphone] channel [0xb29ab8]: received [688] new bytes from [UDP://192.168.2.1:5060]: SIP/2.0 200 OK Via: SIP/2.0/UDP 192.168.2.137:5060;branch=z9hG4bK.98vIehEFQ;rport=5060 From: "DoorPi" ;tag=kMZ5U~~18 To: "DoorPi" ;tag=B411A5E879A11650 Call-ID: i1OfVZa7cv CSeq: 21 REGISTER Contact: ;+sip.instance="";expires=300 User-Agent: AVM FRITZ!Box 7490 113.07.21 (Sep 3 2020) Supported: 100rel,replaces,timer Allow-Events: telephone-event,refer,reg Allow: INVITE,ACK,OPTIONS,CANCEL,BYE,UPDATE,PRACK,INFO,SUBSCRIBE,NOTIFY,REFER,MESSAGE,PUBLISH Accept: application/sdp, multipart/mixed Accept-Encoding: identity Content-Length: 0 2021-03-03 19:11:09,207 [INFO] [doorpi.sipphone.from_linphone] channel [0xb29ab8] [688] bytes parsed 2021-03-03 19:11:09,207 [INFO] [doorpi.sipphone.from_linphone] Found transaction matching response. 2021-03-03 19:11:09,208 [INFO] [doorpi.sipphone.from_linphone] Changing [client] [REGISTER] transaction [0x90b740], from state [TRYING] to [COMPLETED] 2021-03-03 19:11:09,208 [INFO] [doorpi.sipphone.from_linphone] Refresher [0xafb4c8]: has no contact for request [0xafe400]. 2021-03-03 19:11:09,208 [INFO] [doorpi.sipphone.from_linphone] Refresher: scheduling next timer in 270000 ms 2021-03-03 19:11:09,208 [INFO] [doorpi.sipphone.from_linphone] Register refresher [200] reason [OK] for proxy [sip:192.168.2.1] 2021-03-03 19:11:09,209 [INFO] [doorpi.sipphone.from_linphone] Proxy config [0xa254c0] for identity ["DoorPi" ] moving from state [LinphoneRegistrationProgress] to [LinphoneRegistrationOk] 2021-03-03 19:11:09,209 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_callback_registration_state_changed(0xb0f0e0, 0xa254c0, 2, "Registration successful") 2021-03-03 19:11:09,209 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_callback_registration_state_changed 2021-03-03 19:11:09,209 [INFO] [doorpi.sipphone.from_linphone] Linphone core [0xb0f0e0] notifying [registration_state_changed] 2021-03-03 19:11:14,165 [INFO] [doorpi.sipphone.from_linphone] Changing [client] [REGISTER] transaction [0x98d968], from state [COMPLETED] to [TERMINATED] 2021-03-03 19:11:14,166 [INFO] [doorpi.sipphone.from_linphone] Client internal REGISTER transaction [0x98d968] terminated 2021-03-03 19:11:14,217 [INFO] [doorpi.sipphone.from_linphone] Changing [client] [REGISTER] transaction [0x90b740], from state [COMPLETED] to [TERMINATED] 2021-03-03 19:11:14,218 [INFO] [doorpi.sipphone.from_linphone] Client internal REGISTER transaction [0x90b740] terminated