2018-12-30 21:11:33,503 [INFO] [doorpi.main] ___ ___ _ / \___ ___ _ __ / _ (_) VoIP Door-Intercomstation with Raspberry Pi / /\ / _ \ / _ \| '__/ /_)/ | version: 2.5.1 / /_// (_) | (_) | | / ___/| | license: CC BY-NC 4.0 /___,' \___/ \___/|_| \/ |_| URL: Authors: Thomas Meissner Supporter: Phillip Munz Hermann Dötsch Dennis Häußler Hubert Nusser Michael Hauer Andreas Schwarz Max Rößler missing someone? -> sorry -> mail me 2018-12-30 21:11:33,504 [DEBUG] [doorpi.main] loaded with arguments: ['/usr/local/bin/doorpi_cli', '--trace'] 2018-12-30 21:11:33,505 [DEBUG] [doorpi.doorpi] run 2018-12-30 21:11:33,506 [DEBUG] [doorpi.doorpi] prepare 2018-12-30 21:11:33,506 [DEBUG] [doorpi.doorpi] given arguments argv: Namespace(configfile=None, debug=False, test=False, trace=True) 2018-12-30 21:11:33,511 [INFO] [doorpi.conf.config_object] use configfile: /usr/local/etc/DoorPi/conf/doorpi.ini 2018-12-30 21:11:33,521 [DEBUG] [doorpi.conf.config_object] __init__ 2018-12-30 21:11:33,522 [TRACE] [doorpi.conf.config_object] get_from_config 2018-12-30 21:11:33,529 [TRACE] [doorpi.conf.config_object] get_string for key base_path in section DoorPi (default: /usr/local/etc/DoorPi) returns /usr/local/etc/DoorPi 2018-12-30 21:11:33,530 [TRACE] [doorpi.conf.config_object] get_string for key eventlog in section DoorPi (default: !BASEPATH!/conf/eventlog.db) returns !BASEPATH!/conf/eventlog.db 2018-12-30 21:11:33,531 [DEBUG] [doorpi.conf.config_object] parse string "!BASEPATH!/conf/eventlog.db" to "/usr/local/etc/DoorPi/conf/eventlog.db" 2018-12-30 21:11:33,536 [TRACE] [doorpi.action.handler] register Event BeforeStartup from doorpi.doorpi 2018-12-30 21:11:33,537 [DEBUG] [doorpi.action.handler] event_source doorpi.doorpi was added 2018-12-30 21:11:33,537 [TRACE] [doorpi.action.handler] added event_name BeforeStartup and registered source doorpi.doorpi 2018-12-30 21:11:33,538 [TRACE] [doorpi.action.handler] register Event OnStartup from doorpi.doorpi 2018-12-30 21:11:33,539 [TRACE] [doorpi.action.handler] added event_name OnStartup and registered source doorpi.doorpi 2018-12-30 21:11:33,539 [TRACE] [doorpi.action.handler] register Event AfterStartup from doorpi.doorpi 2018-12-30 21:11:33,540 [TRACE] [doorpi.action.handler] added event_name AfterStartup and registered source doorpi.doorpi 2018-12-30 21:11:33,540 [TRACE] [doorpi.action.handler] register Event BeforeShutdown from doorpi.doorpi 2018-12-30 21:11:33,541 [TRACE] [doorpi.action.handler] added event_name BeforeShutdown and registered source doorpi.doorpi 2018-12-30 21:11:33,541 [TRACE] [doorpi.action.handler] register Event OnShutdown from doorpi.doorpi 2018-12-30 21:11:33,542 [TRACE] [doorpi.action.handler] added event_name OnShutdown and registered source doorpi.doorpi 2018-12-30 21:11:33,542 [TRACE] [doorpi.action.handler] register Event AfterShutdown from doorpi.doorpi 2018-12-30 21:11:33,542 [TRACE] [doorpi.action.handler] added event_name AfterShutdown and registered source doorpi.doorpi 2018-12-30 21:11:33,544 [DEBUG] [doorpi.action.SingleActions.time_tick] doorpi.action.SingleActions.time_tick loaded 2018-12-30 21:11:33,546 [DEBUG] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was added 2018-12-30 21:11:33,549 [TRACE] [doorpi.action.handler] action TimeTickDestroyAction with args () and kwargs {} was added to new evententry OnShutdown 2018-12-30 21:11:33,550 [TRACE] [doorpi.action.handler] action TimeTickAction with args ('!last_tick!',) and kwargs {} was added to new evententry OnTimeTick 2018-12-30 21:11:33,551 [TRACE] [doorpi.conf.config_object] get_string for key ip in section DoorPiWeb (default: ) returns 2018-12-30 21:11:33,551 [TRACE] [doorpi.conf.config_object] get_integer for key port in section DoorPiWeb (default: 80) returns 80 2018-12-30 21:11:33,553 [WARNING] [doorpi.status.webserver] failed to initiating WebService at ip and port 80 ([Errno 98] Address already in use) 2018-12-30 21:11:33,554 [WARNING] [doorpi.status.webserver] failed to initiating WebService at ip and port 80 ([Errno 98] Address already in use) 2018-12-30 21:11:33,557 [INFO] [doorpi.status.webserver] Initiating WebService at ip and port 8080 2018-12-30 21:11:33,558 [TRACE] [doorpi.action.handler] register Event OnWebServerStart from doorpi.status.webserver 2018-12-30 21:11:33,558 [DEBUG] [doorpi.action.handler] event_source doorpi.status.webserver was added 2018-12-30 21:11:33,559 [TRACE] [doorpi.action.handler] added event_name OnWebServerStart and registered source doorpi.status.webserver 2018-12-30 21:11:33,559 [TRACE] [doorpi.action.handler] register Event OnWebServerStop from doorpi.status.webserver 2018-12-30 21:11:33,560 [TRACE] [doorpi.action.handler] added event_name OnWebServerStop and registered source doorpi.status.webserver 2018-12-30 21:11:33,560 [TRACE] [doorpi.conf.config_object] get_string for key www in section DoorPiWeb (default: !BASEPATH!/../DoorPiWeb) returns !BASEPATH!/../DoorPiWeb 2018-12-30 21:11:33,562 [DEBUG] [doorpi.conf.config_object] parse string "!BASEPATH!/../DoorPiWeb" to "/usr/local/etc/DoorPi/../DoorPiWeb" 2018-12-30 21:11:33,563 [TRACE] [doorpi.conf.config_object] get_string for key indexfile in section DoorPiWeb (default: index.html) returns index.html 2018-12-30 21:11:33,564 [DEBUG] [doorpi.conf.config_object] parse string "index.html" to "index.html" 2018-12-30 21:11:33,565 [TRACE] [doorpi.conf.config_object] get_string for key loginfile in section DoorPiWeb (default: login.html) returns login.html 2018-12-30 21:11:33,566 [DEBUG] [doorpi.conf.config_object] parse string "login.html" to "login.html" 2018-12-30 21:11:33,567 [TRACE] [doorpi.conf.config_object] get_string for key public in section DoorPiWeb (default: AREA_public) returns AREA_public 2018-12-30 21:11:33,568 [DEBUG] [doorpi.conf.config_object] parse string "AREA_public" to "AREA_public" 2018-12-30 21:11:33,568 [TRACE] [doorpi.conf.config_object] get_string for key online_fallback in section DoorPiWeb (default: http://motom001.github.io/DoorPiWeb) returns http://motom001.github.io/DoorPiWeb 2018-12-30 21:11:33,570 [DEBUG] [doorpi.conf.config_object] parse string "http://motom001.github.io/DoorPiWeb" to "http://motom001.github.io/DoorPiWeb" 2018-12-30 21:11:33,571 [TRACE] [doorpi.conf.config_object] get_keys for section WritePermission returns ['administrators'] 2018-12-30 21:11:33,571 [TRACE] [doorpi.conf.config_object] get_keys for section ReadPermission returns ['administrators'] 2018-12-30 21:11:33,572 [TRACE] [doorpi.conf.config_object] get_keys for section Group returns ['administrators'] 2018-12-30 21:11:33,572 [TRACE] [doorpi.conf.config_object] get_keys for section User returns ['door'] 2018-12-30 21:11:33,573 [TRACE] [doorpi.conf.config_object] get_list for key administrators in section Group (default: []) returns ['door'] 2018-12-30 21:11:33,573 [TRACE] [doorpi.conf.config_object] get_sections returns ['onboardpins_OutputPins', 'onboardpins_keyboard', 'Group', 'ReadPermission', 'AdminNumbers', 'keyboards', 'DTMF', 'SIP-Phone', 'WritePermission', 'AREA_installer', 'EVENT_OnStartup', 'User', 'DoorPiWeb', 'onboardpins_InputPins', 'DoorPi'] 2018-12-30 21:11:33,574 [TRACE] [doorpi.conf.config_object] get_list for key administrators in section WritePermission (default: []) returns ['installer'] 2018-12-30 21:11:33,575 [TRACE] [doorpi.conf.config_object] get_list for key administrators in section ReadPermission (default: []) returns ['installer'] 2018-12-30 21:11:33,575 [TRACE] [doorpi.action.handler] action WebServerStartupAction with args () and kwargs {} was added to new evententry OnWebServerStart 2018-12-30 21:11:33,576 [TRACE] [doorpi.action.handler] action WebServerShutdownAction with args () and kwargs {} was added to event OnShutdown 2018-12-30 21:11:33,577 [TRACE] [doorpi.action.handler] fire Event OnWebServerStart from doorpi.status.webserver asyncron 2018-12-30 21:11:33,579 [TRACE] [doorpi.action.handler] register Event OnWebServerRequest from doorpi.status.webserver_lib.request_handler 2018-12-30 21:11:33,580 [DEBUG] [doorpi.action.handler] event_source doorpi.status.webserver_lib.request_handler was added 2018-12-30 21:11:33,580 [TRACE] [doorpi.action.handler] added event_name OnWebServerRequest and registered source doorpi.status.webserver_lib.request_handler 2018-12-30 21:11:33,581 [TRACE] [doorpi.action.handler] register Event OnWebServerRequestGet from doorpi.status.webserver_lib.request_handler 2018-12-30 21:11:33,581 [DEBUG] [doorpi.action.handler] [JU7TQS] fire for event OnWebServerStart this actions [] 2018-12-30 21:11:33,582 [TRACE] [doorpi.action.handler] added event_name OnWebServerRequestGet and registered source doorpi.status.webserver_lib.request_handler 2018-12-30 21:11:33,583 [TRACE] [doorpi.action.handler] [JU7TQS] try to fire action WebServerStartupAction with args () and kwargs {} 2018-12-30 21:11:33,583 [TRACE] [doorpi.action.handler] register Event OnWebServerRequestPost from doorpi.status.webserver_lib.request_handler 2018-12-30 21:11:33,584 [TRACE] [doorpi.action.base] run WebServerStartupAction with args () and kwargs {} 2018-12-30 21:11:33,584 [TRACE] [doorpi.action.handler] added event_name OnWebServerRequestPost and registered source doorpi.status.webserver_lib.request_handler 2018-12-30 21:11:33,585 [TRACE] [doorpi.action.handler] register Event OnWebServerVirtualResource from doorpi.status.webserver_lib.request_handler 2018-12-30 21:11:33,586 [TRACE] [doorpi.action.handler] added event_name OnWebServerVirtualResource and registered source doorpi.status.webserver_lib.request_handler 2018-12-30 21:11:33,586 [TRACE] [doorpi.action.handler] register Event OnWebServerRealResource from doorpi.status.webserver_lib.request_handler 2018-12-30 21:11:33,587 [TRACE] [doorpi.action.handler] added event_name OnWebServerRealResource and registered source doorpi.status.webserver_lib.request_handler 2018-12-30 21:11:33,587 [TRACE] [doorpi.action.handler] register Event OnFireEvent from doorpi.status.webserver_lib.request_handler 2018-12-30 21:11:33,587 [TRACE] [doorpi.action.handler] added event_name OnFireEvent and registered source doorpi.status.webserver_lib.request_handler 2018-12-30 21:11:33,588 [TRACE] [doorpi.action.handler] register Event OnConfigKeySet from doorpi.status.webserver_lib.request_handler 2018-12-30 21:11:33,589 [TRACE] [doorpi.action.handler] added event_name OnConfigKeySet and registered source doorpi.status.webserver_lib.request_handler 2018-12-30 21:11:33,589 [TRACE] [doorpi.action.handler] register Event OnConfigKeyDelete from doorpi.status.webserver_lib.request_handler 2018-12-30 21:11:33,590 [TRACE] [doorpi.action.handler] added event_name OnConfigKeyDelete and registered source doorpi.status.webserver_lib.request_handler 2018-12-30 21:11:33,591 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to new evententry OnTimeSecondEvenNumber 2018-12-30 21:11:33,591 [TRACE] [doorpi.conf.config_object] get_keys for section keyboards returns ['onboardpins'] 2018-12-30 21:11:33,592 [INFO] [doorpi.keyboard.KeyboardInterface] using multi-keyboard mode (keyboards: onboardpins) 2018-12-30 21:11:33,592 [INFO] [doorpi.keyboard.KeyboardInterface] trying to add keyboard 'onboardpins' to handler 2018-12-30 21:11:33,593 [TRACE] [doorpi.conf.config_object] get_string for key onboardpins in section keyboards (default: dummy) returns piface 2018-12-30 21:11:33,594 [TRACE] [doorpi.conf.config_object] get_keys for section onboardpins_InputPins returns ['1', '2'] 2018-12-30 21:11:33,594 [TRACE] [doorpi.conf.config_object] get_keys for section onboardpins_OutputPins returns [] 2018-12-30 21:11:33,595 [TRACE] [doorpi.conf.config_object] get_integer for key bouncetime in section onboardpins_keyboard (default: 2000) returns 200.0 2018-12-30 21:11:33,595 [TRACE] [doorpi.conf.config_object] get_integer for key polarity in section onboardpins_keyboard (default: 0) returns 0 2018-12-30 21:11:33,596 [TRACE] [doorpi.conf.config_object] get_boolean for key pressed_on_keydown in section onboardpins_keyboard (default: True) returns False 2018-12-30 21:11:33,597 [DEBUG] [doorpi.keyboard.from_piface] doorpi.keyboard.from_piface loaded 2018-12-30 21:11:33,649 [DEBUG] [doorpi.keyboard.from_piface] __init__(input_pins = ['1', '2'], output_pins = [], polarity = 0) 2018-12-30 21:11:33,775 [TRACE] [doorpi.action.handler] register Event OnKeyPressed from doorpi.keyboard.from_piface 2018-12-30 21:11:33,776 [DEBUG] [doorpi.action.handler] event_source doorpi.keyboard.from_piface was added 2018-12-30 21:11:33,777 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed and registered source doorpi.keyboard.from_piface 2018-12-30 21:11:33,777 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_1 from doorpi.keyboard.from_piface 2018-12-30 21:11:33,778 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_1 and registered source doorpi.keyboard.from_piface 2018-12-30 21:11:33,778 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_onboardpins.1 from doorpi.keyboard.from_piface 2018-12-30 21:11:33,779 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_onboardpins.1 and registered source doorpi.keyboard.from_piface 2018-12-30 21:11:33,779 [TRACE] [doorpi.action.handler] register Event OnKeyUp from doorpi.keyboard.from_piface 2018-12-30 21:11:33,780 [TRACE] [doorpi.action.handler] added event_name OnKeyUp and registered source doorpi.keyboard.from_piface 2018-12-30 21:11:33,780 [TRACE] [doorpi.action.handler] register Event OnKeyUp_1 from doorpi.keyboard.from_piface 2018-12-30 21:11:33,781 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_1 and registered source doorpi.keyboard.from_piface 2018-12-30 21:11:33,781 [TRACE] [doorpi.action.handler] register Event OnKeyUp_onboardpins.1 from doorpi.keyboard.from_piface 2018-12-30 21:11:33,782 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_onboardpins.1 and registered source doorpi.keyboard.from_piface 2018-12-30 21:11:33,782 [TRACE] [doorpi.action.handler] register Event OnKeyDown from doorpi.keyboard.from_piface 2018-12-30 21:11:33,783 [TRACE] [doorpi.action.handler] added event_name OnKeyDown and registered source doorpi.keyboard.from_piface 2018-12-30 21:11:33,783 [TRACE] [doorpi.action.handler] register Event OnKeyDown_1 from doorpi.keyboard.from_piface 2018-12-30 21:11:33,783 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_1 and registered source doorpi.keyboard.from_piface 2018-12-30 21:11:33,784 [TRACE] [doorpi.action.handler] register Event OnKeyDown_onboardpins.1 from doorpi.keyboard.from_piface 2018-12-30 21:11:33,784 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_onboardpins.1 and registered source doorpi.keyboard.from_piface 2018-12-30 21:11:33,785 [TRACE] [doorpi.action.handler] register Event OnKeyPressed from doorpi.keyboard.from_piface 2018-12-30 21:11:33,785 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyPressed from source doorpi.keyboard.from_piface is already known 2018-12-30 21:11:33,786 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_2 from doorpi.keyboard.from_piface 2018-12-30 21:11:33,786 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_2 and registered source doorpi.keyboard.from_piface 2018-12-30 21:11:33,787 [TRACE] [doorpi.action.handler] register Event OnKeyPressed_onboardpins.2 from doorpi.keyboard.from_piface 2018-12-30 21:11:33,787 [TRACE] [doorpi.action.handler] added event_name OnKeyPressed_onboardpins.2 and registered source doorpi.keyboard.from_piface 2018-12-30 21:11:33,787 [TRACE] [doorpi.action.handler] register Event OnKeyUp from doorpi.keyboard.from_piface 2018-12-30 21:11:33,788 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyUp from source doorpi.keyboard.from_piface is already known 2018-12-30 21:11:33,788 [TRACE] [doorpi.action.handler] register Event OnKeyUp_2 from doorpi.keyboard.from_piface 2018-12-30 21:11:33,789 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_2 and registered source doorpi.keyboard.from_piface 2018-12-30 21:11:33,789 [TRACE] [doorpi.action.handler] register Event OnKeyUp_onboardpins.2 from doorpi.keyboard.from_piface 2018-12-30 21:11:33,790 [TRACE] [doorpi.action.handler] added event_name OnKeyUp_onboardpins.2 and registered source doorpi.keyboard.from_piface 2018-12-30 21:11:33,790 [TRACE] [doorpi.action.handler] register Event OnKeyDown from doorpi.keyboard.from_piface 2018-12-30 21:11:33,791 [TRACE] [doorpi.action.handler] nothing to do - event OnKeyDown from source doorpi.keyboard.from_piface is already known 2018-12-30 21:11:33,791 [TRACE] [doorpi.action.handler] register Event OnKeyDown_2 from doorpi.keyboard.from_piface 2018-12-30 21:11:33,792 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_2 and registered source doorpi.keyboard.from_piface 2018-12-30 21:11:33,792 [TRACE] [doorpi.action.handler] register Event OnKeyDown_onboardpins.2 from doorpi.keyboard.from_piface 2018-12-30 21:11:33,793 [TRACE] [doorpi.action.handler] added event_name OnKeyDown_onboardpins.2 and registered source doorpi.keyboard.from_piface 2018-12-30 21:11:33,800 [TRACE] [doorpi.action.handler] action KeyboardDestroyAction with args () and kwargs {} was added to event OnShutdown 2018-12-30 21:11:33,802 [TRACE] [doorpi.conf.config_object] get_keys for section onboardpins_OutputPins returns [] 2018-12-30 21:11:33,806 [DEBUG] [doorpi.status.status_lib.environment] doorpi.status.status_lib.environment loaded 2018-12-30 21:11:33,809 [DEBUG] [doorpi.status.requirements_lib.req_config] doorpi.status.requirements_lib.req_config loaded 2018-12-30 21:11:33,813 [DEBUG] [doorpi.status.requirements_lib.req_sipphone] doorpi.status.requirements_lib.req_sipphone loaded 2018-12-30 21:11:33,816 [DEBUG] [doorpi.sipphone.AbstractBaseClass] doorpi.sipphone.AbstractBaseClass loaded 2018-12-30 21:11:33,868 [DEBUG] [doorpi.status.requirements_lib.req_event_handler] doorpi.status.requirements_lib.req_event_handler loaded 2018-12-30 21:11:33,872 [DEBUG] [doorpi.status.requirements_lib.req_webserver] doorpi.status.requirements_lib.req_webserver loaded 2018-12-30 21:11:33,877 [DEBUG] [doorpi.status.requirements_lib.req_keyboard] doorpi.status.requirements_lib.req_keyboard loaded 2018-12-30 21:11:33,898 [DEBUG] [doorpi.status.requirements_lib.req_system] doorpi.status.requirements_lib.req_system loaded 2018-12-30 21:11:33,906 [INFO] [doorpi.sipphone.SipphoneInterface] found installed sipphone "linphone" and use this as default 2018-12-30 21:11:33,907 [TRACE] [doorpi.conf.config_object] get_string for key sipphonetyp in section SIP-Phone (default: linphone) returns linphone 2018-12-30 21:11:33,909 [DEBUG] [doorpi.sipphone.from_linphone] doorpi.sipphone.from_linphone loaded 2018-12-30 21:11:33,912 [DEBUG] [doorpi.sipphone.linphone_lib.CallBacks] doorpi.sipphone.linphone_lib.CallBacks loaded 2018-12-30 21:11:33,914 [DEBUG] [doorpi.sipphone.linphone_lib.Player] doorpi.sipphone.linphone_lib.Player loaded 2018-12-30 21:11:33,917 [DEBUG] [doorpi.sipphone.linphone_lib.Recorder] doorpi.sipphone.linphone_lib.Recorder loaded 2018-12-30 21:11:33,918 [DEBUG] [doorpi.sipphone.from_linphone] __init__ 2018-12-30 21:11:33,920 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to event OnShutdown 2018-12-30 21:11:33,921 [TRACE] [doorpi.action.handler] register Event OnSipPhoneCreate from doorpi.sipphone.from_linphone 2018-12-30 21:11:33,921 [DEBUG] [doorpi.action.handler] event_source doorpi.sipphone.from_linphone was added 2018-12-30 21:11:33,922 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneCreate and registered source doorpi.sipphone.from_linphone 2018-12-30 21:11:33,923 [TRACE] [doorpi.action.handler] register Event OnSipPhoneStart from doorpi.sipphone.from_linphone 2018-12-30 21:11:33,923 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneStart and registered source doorpi.sipphone.from_linphone 2018-12-30 21:11:33,924 [TRACE] [doorpi.action.handler] register Event OnSipPhoneDestroy from doorpi.sipphone.from_linphone 2018-12-30 21:11:33,924 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneDestroy and registered source doorpi.sipphone.from_linphone 2018-12-30 21:11:33,925 [TRACE] [doorpi.action.handler] register Event OnSipPhoneRecorderCreate from doorpi.sipphone.from_linphone 2018-12-30 21:11:33,925 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneRecorderCreate and registered source doorpi.sipphone.from_linphone 2018-12-30 21:11:33,926 [TRACE] [doorpi.action.handler] register Event OnSipPhoneRecorderDestroy from doorpi.sipphone.from_linphone 2018-12-30 21:11:33,926 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneRecorderDestroy and registered source doorpi.sipphone.from_linphone 2018-12-30 21:11:33,927 [TRACE] [doorpi.action.handler] register Event BeforeSipPhoneMakeCall from doorpi.sipphone.from_linphone 2018-12-30 21:11:33,927 [TRACE] [doorpi.action.handler] added event_name BeforeSipPhoneMakeCall and registered source doorpi.sipphone.from_linphone 2018-12-30 21:11:33,928 [TRACE] [doorpi.action.handler] register Event OnSipPhoneMakeCall from doorpi.sipphone.from_linphone 2018-12-30 21:11:33,928 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneMakeCall and registered source doorpi.sipphone.from_linphone 2018-12-30 21:11:33,928 [TRACE] [doorpi.action.handler] register Event OnSipPhoneMakeCallFailed from doorpi.sipphone.from_linphone 2018-12-30 21:11:33,929 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneMakeCallFailed and registered source doorpi.sipphone.from_linphone 2018-12-30 21:11:33,930 [TRACE] [doorpi.action.handler] register Event AfterSipPhoneMakeCall from doorpi.sipphone.from_linphone 2018-12-30 21:11:33,930 [TRACE] [doorpi.action.handler] added event_name AfterSipPhoneMakeCall and registered source doorpi.sipphone.from_linphone 2018-12-30 21:11:33,931 [TRACE] [doorpi.action.handler] register Event OnSipPhoneCallTimeoutNoResponse from doorpi.sipphone.from_linphone 2018-12-30 21:11:33,931 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneCallTimeoutNoResponse and registered source doorpi.sipphone.from_linphone 2018-12-30 21:11:33,932 [TRACE] [doorpi.action.handler] register Event OnSipPhoneCallTimeoutMaxCalltime from doorpi.sipphone.from_linphone 2018-12-30 21:11:33,932 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneCallTimeoutMaxCalltime and registered source doorpi.sipphone.from_linphone 2018-12-30 21:11:33,933 [TRACE] [doorpi.action.handler] register Event OnPlayerCreated from doorpi.sipphone.from_linphone 2018-12-30 21:11:33,933 [TRACE] [doorpi.action.handler] added event_name OnPlayerCreated and registered source doorpi.sipphone.from_linphone 2018-12-30 21:11:33,934 [DEBUG] [doorpi.sipphone.linphone_lib.CallBacks] __init__ 2018-12-30 21:11:33,934 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to new evententry OnSipPhoneDestroy 2018-12-30 21:11:33,935 [TRACE] [doorpi.action.handler] register Event OnCallMediaStateChange from doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:33,935 [DEBUG] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was added 2018-12-30 21:11:33,936 [TRACE] [doorpi.action.handler] added event_name OnCallMediaStateChange and registered source doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:33,937 [TRACE] [doorpi.action.handler] register Event OnMediaRequired from doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:33,937 [TRACE] [doorpi.action.handler] added event_name OnMediaRequired and registered source doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:33,938 [TRACE] [doorpi.action.handler] register Event OnMediaNotRequired from doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:33,938 [TRACE] [doorpi.action.handler] added event_name OnMediaNotRequired and registered source doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:33,939 [TRACE] [doorpi.action.handler] register Event OnCallStateChange from doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:33,939 [TRACE] [doorpi.action.handler] added event_name OnCallStateChange and registered source doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:33,940 [TRACE] [doorpi.action.handler] register Event OnCallStateConnect from doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:33,940 [TRACE] [doorpi.action.handler] added event_name OnCallStateConnect and registered source doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:33,941 [TRACE] [doorpi.action.handler] register Event AfterCallStateConnect from doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:33,941 [TRACE] [doorpi.action.handler] added event_name AfterCallStateConnect and registered source doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:33,942 [TRACE] [doorpi.action.handler] register Event OnCallStateDisconnect from doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:33,942 [TRACE] [doorpi.action.handler] added event_name OnCallStateDisconnect and registered source doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:33,943 [TRACE] [doorpi.action.handler] register Event AfterCallStateDisconnect from doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:33,943 [TRACE] [doorpi.action.handler] added event_name AfterCallStateDisconnect and registered source doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:33,943 [TRACE] [doorpi.action.handler] register Event OnCallStateDismissed from doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:33,944 [TRACE] [doorpi.action.handler] added event_name OnCallStateDismissed and registered source doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:33,945 [TRACE] [doorpi.action.handler] register Event OnCallStateReject from doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:33,945 [TRACE] [doorpi.action.handler] added event_name OnCallStateReject and registered source doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:33,945 [TRACE] [doorpi.action.handler] register Event OnCallStart from doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:33,946 [TRACE] [doorpi.action.handler] added event_name OnCallStart and registered source doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:33,946 [TRACE] [doorpi.action.handler] register Event OnDTMF from doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:33,947 [TRACE] [doorpi.action.handler] added event_name OnDTMF and registered source doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:33,947 [TRACE] [doorpi.conf.config_object] get_keys for section DTMF returns [] 2018-12-30 21:11:33,948 [TRACE] [doorpi.action.handler] register Event OnCallStart from doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:33,948 [TRACE] [doorpi.action.handler] nothing to do - event OnCallStart from source doorpi.sipphone.linphone_lib.CallBacks is already known 2018-12-30 21:11:33,949 [TRACE] [doorpi.action.handler] register Event BeforeCallIncoming from doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:33,949 [TRACE] [doorpi.action.handler] added event_name BeforeCallIncoming and registered source doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:33,950 [TRACE] [doorpi.action.handler] register Event OnCallReconnect from doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:33,950 [TRACE] [doorpi.action.handler] added event_name OnCallReconnect and registered source doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:33,951 [TRACE] [doorpi.action.handler] register Event AfterCallReconnect from doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:33,951 [TRACE] [doorpi.action.handler] added event_name AfterCallReconnect and registered source doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:33,952 [TRACE] [doorpi.action.handler] register Event OnCallBusy from doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:33,952 [TRACE] [doorpi.action.handler] added event_name OnCallBusy and registered source doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:33,952 [TRACE] [doorpi.action.handler] register Event AfterCallBusy from doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:33,953 [TRACE] [doorpi.action.handler] added event_name AfterCallBusy and registered source doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:33,954 [TRACE] [doorpi.action.handler] register Event OnCallIncoming from doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:33,954 [TRACE] [doorpi.action.handler] added event_name OnCallIncoming and registered source doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:33,955 [TRACE] [doorpi.action.handler] register Event AfterCallIncoming from doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:33,955 [TRACE] [doorpi.action.handler] added event_name AfterCallIncoming and registered source doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:33,955 [TRACE] [doorpi.action.handler] register Event OnCallReject from doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:33,956 [TRACE] [doorpi.action.handler] added event_name OnCallReject and registered source doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:33,956 [TRACE] [doorpi.action.handler] register Event AfterCallReject from doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:33,957 [TRACE] [doorpi.action.handler] added event_name AfterCallReject and registered source doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:33,957 [TRACE] [doorpi.action.handler] fire Event OnCallStart from doorpi.sipphone.linphone_lib.CallBacks asyncron 2018-12-30 21:11:33,960 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_new() 2018-12-30 21:11:33,962 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_new -> 0x75a372a8 2018-12-30 21:11:33,963 [DEBUG] [doorpi.action.handler] no actions for event OnCallStart - skip fire_event OnCallStart from doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:33,964 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_init() 2018-12-30 21:11:33,966 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_init -> 0x75a372a8 2018-12-30 21:11:33,967 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_class_method_new(0x744966f0, "(null)", "(null)") 2018-12-30 21:11:33,968 [INFO] [doorpi.sipphone.from_linphone] Mediastreamer2 factory 2.11.0 (git: 380f221) initialized. 2018-12-30 21:11:33,969 [INFO] [doorpi.sipphone.from_linphone] CPU count set to 4 2018-12-30 21:11:33,970 [INFO] [doorpi.sipphone.from_linphone] ms_factory_init() done 2018-12-30 21:11:33,971 [INFO] [doorpi.sipphone.from_linphone] srtp init 2018-12-30 21:11:33,985 [INFO] [doorpi.sipphone.from_linphone] Registering all soundcard handlers 2018-12-30 21:11:34,016 [INFO] [doorpi.sipphone.from_linphone] Card 'ALSA: default device' added ALSA lib conf.c:4974:(snd_config_expand) Unknown parameters 0 ALSA lib control.c:1373:(snd_ctl_open_noupdate) Invalid CTL default:0 2018-12-30 21:11:34,017 [WARNING] [doorpi.sipphone.from_linphone] Could not attach mixer to card: Invalid argument 2018-12-30 21:11:34,022 [INFO] [doorpi.sipphone.from_linphone] Card 'ALSA: bcm2835 ALSA' added ALSA lib conf.c:4974:(snd_config_expand) Unknown parameters 1 ALSA lib control.c:1373:(snd_ctl_open_noupdate) Invalid CTL default:1 2018-12-30 21:11:34,023 [WARNING] [doorpi.sipphone.from_linphone] Could not attach mixer to card: Invalid argument 2018-12-30 21:11:34,027 [INFO] [doorpi.sipphone.from_linphone] Card 'ALSA: Dummy' added ALSA lib conf.c:4974:(snd_config_expand) Unknown parameters 2 ALSA lib control.c:1373:(snd_ctl_open_noupdate) Invalid CTL default:2 2018-12-30 21:11:34,029 [WARNING] [doorpi.sipphone.from_linphone] Could not attach mixer to card: Invalid argument 2018-12-30 21:11:34,050 [INFO] [doorpi.sipphone.from_linphone] Card 'ALSA: USB Audio Device' added 2018-12-30 21:11:34,052 [INFO] [doorpi.sipphone.from_linphone] Registering all webcam handlers 2018-12-30 21:11:34,054 [INFO] [doorpi.sipphone.from_linphone] Webcam V4L2: /dev/video0 added 2018-12-30 21:11:34,056 [INFO] [doorpi.sipphone.from_linphone] Webcam StaticImage: Static picture added 2018-12-30 21:11:34,057 [INFO] [doorpi.sipphone.from_linphone] ms_factory_init_voip() done 2018-12-30 21:11:34,058 [INFO] [doorpi.sipphone.from_linphone] Loading ms plugins from [./lib/mediastreamer/plugins] 2018-12-30 21:11:34,059 [INFO] [doorpi.sipphone.from_linphone] Cannot open directory ./lib/mediastreamer/plugins: No such file or directory 2018-12-30 21:11:34,061 [INFO] [doorpi.sipphone.from_linphone] Initializing LinphoneCore 3.8.0 2018-12-30 21:11:34,062 [INFO] [doorpi.sipphone.from_linphone] Vtable [0x2369090] registered on core [0x23779d0] 2018-12-30 21:11:34,063 [INFO] [doorpi.sipphone.from_linphone] Linphone core [0x2369090] notifying [global_state_changed] 2018-12-30 21:11:34,064 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_callback_global_state_changed(0x2369090, 1, "Starting up") 2018-12-30 21:11:34,065 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_callback_global_state_changed 2018-12-30 21:11:34,065 [INFO] [doorpi.sipphone.from_linphone] oRTP-0.24.0 initialized. 2018-12-30 21:11:34,067 [INFO] [doorpi.sipphone.from_linphone] Skiping ms_base_init, because [2] ref 2018-12-30 21:11:34,067 [INFO] [doorpi.sipphone.from_linphone] Skiping ms_voip_init, because [2] ref 2018-12-30 21:11:34,068 [INFO] [doorpi.sipphone.from_linphone] Skiping ms_plugins_init, because [2] ref 2018-12-30 21:11:34,070 [INFO] [doorpi.sipphone.from_linphone] Codec opus/48000 fmtp=[useinbandfec=1; stereo=0; sprop-stereo=0] number=-1, enabled=1) added to default capabilities. 2018-12-30 21:11:34,071 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for SILK 2018-12-30 21:11:34,072 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for SILK 2018-12-30 21:11:34,073 [INFO] [doorpi.sipphone.from_linphone] Codec speex/16000 fmtp=[vbr=on] number=-1, enabled=1) added to default capabilities. 2018-12-30 21:11:34,074 [INFO] [doorpi.sipphone.from_linphone] Codec speex/8000 fmtp=[vbr=on] number=-1, enabled=1) added to default capabilities. 2018-12-30 21:11:34,074 [INFO] [doorpi.sipphone.from_linphone] Codec PCMU/8000 fmtp=[] number=0, enabled=1) added to default capabilities. 2018-12-30 21:11:34,075 [INFO] [doorpi.sipphone.from_linphone] Codec PCMA/8000 fmtp=[] number=8, enabled=1) added to default capabilities. 2018-12-30 21:11:34,077 [INFO] [doorpi.sipphone.from_linphone] Codec GSM/8000 fmtp=[] number=3, enabled=0) added to default capabilities. 2018-12-30 21:11:34,077 [INFO] [doorpi.sipphone.from_linphone] Codec G722/8000 fmtp=[] number=9, enabled=0) added to default capabilities. 2018-12-30 21:11:34,078 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for iLBC 2018-12-30 21:11:34,079 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for iLBC 2018-12-30 21:11:34,080 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for AMR 2018-12-30 21:11:34,081 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for AMR 2018-12-30 21:11:34,082 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for AMR-WB 2018-12-30 21:11:34,083 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for AMR-WB 2018-12-30 21:11:34,084 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for G729 2018-12-30 21:11:34,085 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for G729 2018-12-30 21:11:34,086 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for mpeg4-generic 2018-12-30 21:11:34,087 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for mpeg4-generic 2018-12-30 21:11:34,088 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for mpeg4-generic 2018-12-30 21:11:34,089 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for mpeg4-generic 2018-12-30 21:11:34,090 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for mpeg4-generic 2018-12-30 21:11:34,091 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for mpeg4-generic 2018-12-30 21:11:34,091 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for mpeg4-generic 2018-12-30 21:11:34,092 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for mpeg4-generic 2018-12-30 21:11:34,093 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for mpeg4-generic 2018-12-30 21:11:34,094 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for mpeg4-generic 2018-12-30 21:11:34,094 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for iSAC 2018-12-30 21:11:34,095 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for iSAC 2018-12-30 21:11:34,096 [INFO] [doorpi.sipphone.from_linphone] Codec speex/32000 fmtp=[vbr=on] number=-1, enabled=0) added to default capabilities. 2018-12-30 21:11:34,097 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for SILK 2018-12-30 21:11:34,098 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for SILK 2018-12-30 21:11:34,098 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for SILK 2018-12-30 21:11:34,099 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for SILK 2018-12-30 21:11:34,100 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for SILK 2018-12-30 21:11:34,101 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for SILK 2018-12-30 21:11:34,102 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for G726-16 2018-12-30 21:11:34,103 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for G726-16 2018-12-30 21:11:34,104 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for G726-24 2018-12-30 21:11:34,105 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for G726-24 2018-12-30 21:11:34,105 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for G726-32 2018-12-30 21:11:34,106 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for G726-32 2018-12-30 21:11:34,107 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for G726-40 2018-12-30 21:11:34,108 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for G726-40 2018-12-30 21:11:34,109 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for AAL2-G726-16 2018-12-30 21:11:34,110 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for AAL2-G726-16 2018-12-30 21:11:34,111 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for AAL2-G726-24 2018-12-30 21:11:34,112 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for AAL2-G726-24 2018-12-30 21:11:34,113 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for AAL2-G726-32 2018-12-30 21:11:34,114 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for AAL2-G726-32 2018-12-30 21:11:34,115 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for AAL2-G726-40 2018-12-30 21:11:34,115 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for AAL2-G726-40 2018-12-30 21:11:34,116 [INFO] [doorpi.sipphone.from_linphone] Codec VP8/90000 fmtp=[] number=-1, enabled=1) added to default capabilities. 2018-12-30 21:11:34,116 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for H264 2018-12-30 21:11:34,117 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for MP4V-ES 2018-12-30 21:11:34,118 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for H263-1998 2018-12-30 21:11:34,119 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for H263 2018-12-30 21:11:34,120 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for 1016 2018-12-30 21:11:34,120 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for 1016 2018-12-30 21:11:34,121 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for G723 2018-12-30 21:11:34,121 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for G723 2018-12-30 21:11:34,122 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for LPC 2018-12-30 21:11:34,123 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for LPC 2018-12-30 21:11:34,123 [INFO] [doorpi.sipphone.from_linphone] Codec L16/44100 fmtp=[] number=10, enabled=0) added to default capabilities. 2018-12-30 21:11:34,124 [INFO] [doorpi.sipphone.from_linphone] Codec L16/44100 fmtp=[] number=11, enabled=0) added to default capabilities. 2018-12-30 21:11:34,124 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for CN 2018-12-30 21:11:34,125 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for CN 2018-12-30 21:11:34,126 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for G729 2018-12-30 21:11:34,126 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for G729 2018-12-30 21:11:34,127 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for H261 2018-12-30 21:11:34,128 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for H261 2018-12-30 21:11:34,128 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for MPV 2018-12-30 21:11:34,129 [INFO] [doorpi.sipphone.from_linphone] Could not find decoder for MPV 2018-12-30 21:11:34,129 [INFO] [doorpi.sipphone.from_linphone] Could not find encoder for H263 2018-12-30 21:11:34,130 [INFO] [doorpi.sipphone.from_linphone] Sal nat helper [enabled] 2018-12-30 21:11:34,131 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2018-12-30 21:11:34,132 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2018-12-30 21:11:34,132 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2018-12-30 21:11:34,133 [INFO] [doorpi.sipphone.from_linphone] Linphone core [0x2369090] notifying [configuring_status] 2018-12-30 21:11:34,134 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_callback_configuring_status(0x2369090, 2, "(null)") 2018-12-30 21:11:34,134 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_callback_configuring_status 2018-12-30 21:11:34,135 [INFO] [doorpi.sipphone.from_linphone] Cannot open directory ./lib/liblinphone/plugins: No such file or directory 2018-12-30 21:11:34,136 [WARNING] [doorpi.sipphone.from_linphone] ./share/sounds/linphone/rings/oldphone.wav does not exist 2018-12-30 21:11:34,136 [INFO] [doorpi.sipphone.from_linphone] linphone_core_set_playback_gain_db(): no active call. 2018-12-30 21:11:34,137 [INFO] [doorpi.sipphone.from_linphone] linphone_core_set_mic_gain_db(): no active call. 2018-12-30 21:11:34,138 [INFO] [doorpi.sipphone.from_linphone] MTU is supposed to be 1300, rtp payload max size will be 1240 2018-12-30 21:11:34,138 [INFO] [doorpi.sipphone.from_linphone] Sal nat helper [enabled] 2018-12-30 21:11:34,139 [INFO] [doorpi.sipphone.from_linphone] Sal use rport [enabled] 2018-12-30 21:11:34,140 [INFO] [doorpi.sipphone.from_linphone] Supported codec opus/48000 fmtp=useinbandfec=1; stereo=0; sprop-stereo=0 automatically added to codec list. 2018-12-30 21:11:34,141 [INFO] [doorpi.sipphone.from_linphone] Supported codec speex/16000 fmtp=vbr=on automatically added to codec list. 2018-12-30 21:11:34,141 [INFO] [doorpi.sipphone.from_linphone] Supported codec speex/8000 fmtp=vbr=on automatically added to codec list. 2018-12-30 21:11:34,142 [INFO] [doorpi.sipphone.from_linphone] Supported codec PCMU/8000 fmtp= automatically added to codec list. 2018-12-30 21:11:34,142 [INFO] [doorpi.sipphone.from_linphone] Supported codec PCMA/8000 fmtp= automatically added to codec list. 2018-12-30 21:11:34,143 [INFO] [doorpi.sipphone.from_linphone] Supported codec GSM/8000 fmtp= automatically added to codec list. 2018-12-30 21:11:34,144 [INFO] [doorpi.sipphone.from_linphone] Supported codec G722/8000 fmtp= automatically added to codec list. 2018-12-30 21:11:34,144 [INFO] [doorpi.sipphone.from_linphone] Supported codec speex/32000 fmtp=vbr=on automatically added to codec list. 2018-12-30 21:11:34,145 [INFO] [doorpi.sipphone.from_linphone] Supported codec L16/44100 fmtp= automatically added to codec list. 2018-12-30 21:11:34,145 [INFO] [doorpi.sipphone.from_linphone] Supported codec L16/44100 fmtp= automatically added to codec list. 2018-12-30 21:11:34,146 [INFO] [doorpi.sipphone.from_linphone] Supported codec VP8/90000 fmtp= automatically added to codec list. 2018-12-30 21:11:34,147 [INFO] [doorpi.sipphone.from_linphone] Sal use rport [enabled] 2018-12-30 21:11:34,148 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2018-12-30 21:11:34,149 [INFO] [doorpi.sipphone.from_linphone] sal_unlisten_ports done 2018-12-30 21:11:34,150 [INFO] [doorpi.sipphone.from_linphone] Creating listening point [0x2377fd8] on [sip:0.0.0.0:5060;transport=UDP] 2018-12-30 21:11:34,150 [ERROR] [doorpi.sipphone.from_linphone] udp bind() failed for 0.0.0.0 port 5060: Address already in use 2018-12-30 21:11:34,151 [INFO] [doorpi.sipphone.from_linphone] Listening point [0x2377fd8] on [sip:0.0.0.0:5060;transport=UDP] destroyed 2018-12-30 21:11:34,152 [WARNING] [doorpi.sipphone.from_linphone] Could not start udp transport on port 5060, maybe this port is already used. 2018-12-30 21:11:34,153 [INFO] [doorpi.sipphone.from_linphone] Linphone core [0x2369090] notifying [display_warning] 2018-12-30 21:11:34,154 [INFO] [doorpi.sipphone.from_linphone] Creating listening point [0x2377fd8] on [sip:0.0.0.0:5060;transport=TCP] 2018-12-30 21:11:34,155 [INFO] [doorpi.sipphone.from_linphone] Creating listening point [0x238e0f0] on [sip:0.0.0.0:-1;transport=TLS] 2018-12-30 21:11:34,156 [INFO] [doorpi.sipphone.from_linphone] Random TCP port is 33175 2018-12-30 21:11:34,157 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2018-12-30 21:11:34,158 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2018-12-30 21:11:34,163 [INFO] [doorpi.sipphone.from_linphone] Linphone core [0x2369090] notifying [display_status] 2018-12-30 21:11:34,164 [INFO] [doorpi.sipphone.from_linphone] Linphone core [0x2369090] notifying [global_state_changed] 2018-12-30 21:11:34,165 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_callback_global_state_changed(0x2369090, 2, "Ready") 2018-12-30 21:11:34,166 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_callback_global_state_changed 2018-12-30 21:11:34,167 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_class_method_new -> 0x75a372a8 2018-12-30 21:11:34,169 [TRACE] [doorpi.conf.config_object] get_string for key identity in section SIP-Phone (default: DoorPi) returns DoorPi 2018-12-30 21:11:34,170 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_primary_contact(0x75a372a8 [0x2369090], "DoorPi ") 2018-12-30 21:11:34,172 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_primary_contact -> 0 2018-12-30 21:11:34,173 [TRACE] [doorpi.action.handler] fire Event OnSipPhoneCreate from doorpi.sipphone.from_linphone asyncron 2018-12-30 21:11:34,175 [TRACE] [doorpi.conf.config_object] get_integer for key ua.max_calls in section SIP-Phone (default: 2) returns 2 2018-12-30 21:11:34,176 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_max_calls(0x75a372a8 [0x2369090], 2) 2018-12-30 21:11:34,177 [DEBUG] [doorpi.action.handler] no actions for event OnSipPhoneCreate - skip fire_event OnSipPhoneCreate from doorpi.sipphone.from_linphone 2018-12-30 21:11:34,177 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_max_calls -> 0 2018-12-30 21:11:34,179 [TRACE] [doorpi.conf.config_object] get_boolean for key echo_cancellation_enabled in section SIP-Phone (default: False) returns False 2018-12-30 21:11:34,180 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_enable_echo_cancellation(0x75a372a8 [0x2369090], 0x2d7690 [0]) 2018-12-30 21:11:34,180 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_enable_echo_cancellation -> 0 2018-12-30 21:11:34,181 [TRACE] [doorpi.conf.config_object] get_integer for key local_port in section SIP-Phone (default: 5060) returns 5061 2018-12-30 21:11:34,182 [TRACE] [doorpi.conf.config_object] get_integer for key local_port in section SIP-Phone (default: 5060) returns 5061 2018-12-30 21:11:34,182 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_SipTransports_new() 2018-12-30 21:11:34,183 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_SipTransports_new -> 0x75a372c0 2018-12-30 21:11:34,184 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_sip_transports(0x75a372a8 [0x2369090], 0x75a372c0 [0x75a372c8]) 2018-12-30 21:11:34,184 [INFO] [doorpi.sipphone.from_linphone] Listening point [0x2377fd8] on [sip:0.0.0.0:5060;transport=TCP] destroyed 2018-12-30 21:11:34,185 [INFO] [doorpi.sipphone.from_linphone] Listening point [0x238e0f0] on [sip:0.0.0.0:33175;transport=TLS] destroyed 2018-12-30 21:11:34,186 [INFO] [doorpi.sipphone.from_linphone] sal_unlisten_ports done 2018-12-30 21:11:34,187 [INFO] [doorpi.sipphone.from_linphone] Creating listening point [0x2396f28] on [sip:0.0.0.0:5061;transport=UDP] 2018-12-30 21:11:34,188 [INFO] [doorpi.sipphone.from_linphone] Creating listening point [0x2396ca8] on [sip:0.0.0.0:5061;transport=TCP] 2018-12-30 21:11:34,189 [INFO] [doorpi.sipphone.from_linphone] Creating listening point [0x2396a98] on [sip:0.0.0.0:-1;transport=TLS] 2018-12-30 21:11:34,190 [INFO] [doorpi.sipphone.from_linphone] Random TCP port is 36833 2018-12-30 21:11:34,191 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2018-12-30 21:11:34,191 [INFO] [doorpi.sipphone.from_linphone] Root ca path set to /etc/ssl/certs 2018-12-30 21:11:34,192 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_sip_transports -> 0 2018-12-30 21:11:34,193 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_SipTransports_dealloc(0x75a372c0) 2018-12-30 21:11:34,193 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_SipTransports_dealloc 2018-12-30 21:11:34,194 [TRACE] [doorpi.conf.config_object] get_boolean for key video_display_enabled in section SIP-Phone (default: False) returns False 2018-12-30 21:11:34,195 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_enable_video_display(0x75a372a8 [0x2369090], 0x2d7690 [0]) 2018-12-30 21:11:34,195 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_enable_video_display -> 0 2018-12-30 21:11:34,196 [TRACE] [doorpi.conf.config_object] get_string for key stun_server in section SIP-Phone (default: ) returns 2018-12-30 21:11:34,196 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_stun_server(0x75a372a8 [0x2369090], "") 2018-12-30 21:11:34,198 [INFO] [doorpi.sipphone.from_linphone] Resolver is using DNS server(s): 2018-12-30 21:11:34,199 [INFO] [doorpi.sipphone.from_linphone] 127.0.0.1 2018-12-30 21:11:34,200 [ERROR] [doorpi.sipphone.from_linphone] resolver_process_data dns_res_check() error: Unknown error 1994089328 (1994089328) 2018-12-30 21:11:34,201 [WARNING] [doorpi.sipphone.from_linphone] Stun server resolution failed. 2018-12-30 21:11:34,202 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_stun_server -> 0 2018-12-30 21:11:34,203 [DEBUG] [doorpi.conf.config_object] create new key FirewallPolicy in section SIP-Phone with value 'PolicyNoFirewall' 2018-12-30 21:11:34,204 [TRACE] [doorpi.conf.config_object] get_string for key FirewallPolicy in section SIP-Phone (default: PolicyNoFirewall) returns PolicyNoFirewall 2018-12-30 21:11:34,205 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_firewall_policy(0x75a372a8 [0x2369090], 0) 2018-12-30 21:11:34,205 [INFO] [doorpi.sipphone.from_linphone] Sal nat helper [enabled] 2018-12-30 21:11:34,206 [INFO] [doorpi.sipphone.from_linphone] Sal use rport [enabled] 2018-12-30 21:11:34,208 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_firewall_policy -> 0 2018-12-30 21:11:34,209 [TRACE] [doorpi.conf.config_object] get_integer for key max_call_time in section SIP-Phone (default: 120) returns 120 2018-12-30 21:11:34,210 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_in_call_timeout(0x75a372a8 [0x2369090], 120) 2018-12-30 21:11:34,210 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_in_call_timeout -> 0 2018-12-30 21:11:34,211 [TRACE] [doorpi.conf.config_object] get_integer for key call_timeout in section SIP-Phone (default: 15) returns 15 2018-12-30 21:11:34,212 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_inc_timeout(0x75a372a8 [0x2369090], 15) 2018-12-30 21:11:34,212 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_inc_timeout -> 0 2018-12-30 21:11:34,213 [TRACE] [doorpi.conf.config_object] get_string for key dialtone in section SIP-Phone (default: !BASEPATH!/media/ShortDialTone.wav) returns !BASEPATH!/media/ShortDialTone.wav 2018-12-30 21:11:34,216 [DEBUG] [doorpi.conf.config_object] parse string "!BASEPATH!/media/ShortDialTone.wav" to "/usr/local/etc/DoorPi/media/ShortDialTone.wav" 2018-12-30 21:11:34,217 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to event OnSipPhoneDestroy 2018-12-30 21:11:34,220 [TRACE] [doorpi.conf.config_object] get_boolean for key dialtone_renew_every_start in section SIP-Phone (default: False) returns False 2018-12-30 21:11:34,221 [TRACE] [doorpi.action.handler] register Event OnPlayerStarted from doorpi.sipphone.linphone_lib.Player 2018-12-30 21:11:34,222 [DEBUG] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.Player was added 2018-12-30 21:11:34,222 [TRACE] [doorpi.action.handler] added event_name OnPlayerStarted and registered source doorpi.sipphone.linphone_lib.Player 2018-12-30 21:11:34,223 [TRACE] [doorpi.action.handler] register Event OnPlayerStopped from doorpi.sipphone.linphone_lib.Player 2018-12-30 21:11:34,223 [TRACE] [doorpi.action.handler] added event_name OnPlayerStopped and registered source doorpi.sipphone.linphone_lib.Player 2018-12-30 21:11:34,224 [TRACE] [doorpi.action.handler] register Event OnPlayerCreated from doorpi.sipphone.linphone_lib.Player 2018-12-30 21:11:34,225 [TRACE] [doorpi.action.handler] added event_source doorpi.sipphone.linphone_lib.Player to existing event OnPlayerCreated 2018-12-30 21:11:34,225 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to new evententry OnSipPhoneMakeCall 2018-12-30 21:11:34,227 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to new evententry OnCallStateConnect 2018-12-30 21:11:34,230 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to new evententry OnCallStateDisconnect 2018-12-30 21:11:34,232 [TRACE] [doorpi.action.handler] fire Event OnPlayerCreated from doorpi.sipphone.linphone_lib.Player asyncron 2018-12-30 21:11:34,235 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_ringback(0x75a372a8 [0x2369090], "/usr/local/etc/DoorPi/media/ShortDialTone.wav") 2018-12-30 21:11:34,236 [DEBUG] [doorpi.action.handler] no actions for event OnPlayerCreated - skip fire_event OnPlayerCreated from doorpi.sipphone.linphone_lib.Player 2018-12-30 21:11:34,237 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_ringback -> 0 2018-12-30 21:11:34,239 [TRACE] [doorpi.conf.config_object] get_string for key records in section SIP-Phone (default: !BASEPATH!/records/%Y-%m-%d_%H-%M-%S.wav) returns !BASEPATH!/records/%Y-%m-%d_%H-%M-%S.wav 2018-12-30 21:11:34,240 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to event OnSipPhoneDestroy 2018-12-30 21:11:34,241 [TRACE] [doorpi.action.handler] register Event OnRecorderStarted from doorpi.sipphone.linphone_lib.Recorder 2018-12-30 21:11:34,242 [DEBUG] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.Recorder was added 2018-12-30 21:11:34,243 [TRACE] [doorpi.action.handler] added event_name OnRecorderStarted and registered source doorpi.sipphone.linphone_lib.Recorder 2018-12-30 21:11:34,243 [TRACE] [doorpi.action.handler] register Event OnRecorderStopped from doorpi.sipphone.linphone_lib.Recorder 2018-12-30 21:11:34,244 [TRACE] [doorpi.action.handler] added event_name OnRecorderStopped and registered source doorpi.sipphone.linphone_lib.Recorder 2018-12-30 21:11:34,245 [TRACE] [doorpi.action.handler] register Event OnRecorderCreated from doorpi.sipphone.linphone_lib.Recorder 2018-12-30 21:11:34,246 [TRACE] [doorpi.action.handler] added event_name OnRecorderCreated and registered source doorpi.sipphone.linphone_lib.Recorder 2018-12-30 21:11:34,246 [TRACE] [doorpi.conf.config_object] get_boolean for key record_while_dialing in section SIP-Phone (default: False) returns False 2018-12-30 21:11:34,247 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to event OnCallStateConnect 2018-12-30 21:11:34,248 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to event OnCallStateDisconnect 2018-12-30 21:11:34,248 [TRACE] [doorpi.action.handler] fire Event OnRecorderCreated from doorpi.sipphone.linphone_lib.Recorder asyncron 2018-12-30 21:11:34,250 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_sound_devices(0x75a372a8 [0x2369090]) 2018-12-30 21:11:34,251 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_sound_devices -> 0x744975d0 2018-12-30 21:11:34,252 [DEBUG] [doorpi.action.handler] no actions for event OnRecorderCreated - skip fire_event OnRecorderCreated from doorpi.sipphone.linphone_lib.Recorder 2018-12-30 21:11:34,252 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_capture_device(0x75a372a8 [0x2369090]) 2018-12-30 21:11:34,253 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_capture_device -> 0x74494ea0 2018-12-30 21:11:34,254 [TRACE] [doorpi.conf.config_object] get_string for key capture_device in section SIP-Phone (default: ALSA: Dummy) returns ALSA: USB Audio Device 2018-12-30 21:11:34,254 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_capture_device(0x75a372a8 [0x2369090], "ALSA: USB Audio Device") 2018-12-30 21:11:34,255 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_capture_device -> 0 2018-12-30 21:11:34,255 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_playback_device(0x75a372a8 [0x2369090]) 2018-12-30 21:11:34,256 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_playback_device -> 0x744994d0 2018-12-30 21:11:34,256 [TRACE] [doorpi.conf.config_object] get_string for key playback_device in section SIP-Phone (default: ALSA: default device) returns ALSA: USB Audio Device 2018-12-30 21:11:34,257 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_playback_device(0x75a372a8 [0x2369090], "ALSA: USB Audio Device") 2018-12-30 21:11:34,258 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_playback_device -> 0 2018-12-30 21:11:34,258 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_sound_devices(0x75a372a8 [0x2369090]) 2018-12-30 21:11:34,259 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_sound_devices -> 0x74497490 2018-12-30 21:11:34,259 [INFO] [doorpi.sipphone.from_linphone] found 4 possible sounddevices: 2018-12-30 21:11:34,260 [DEBUG] [doorpi.sipphone.from_linphone] |rec|play| name 2018-12-30 21:11:34,261 [DEBUG] [doorpi.sipphone.from_linphone] ------------------------------------ 2018-12-30 21:11:34,261 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_sound_devices(0x75a372a8 [0x2369090]) 2018-12-30 21:11:34,262 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_sound_devices -> 0x74497490 2018-12-30 21:11:34,262 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_sound_device_can_capture(0x75a372a8 [0x2369090], "ALSA: default device") 2018-12-30 21:11:34,263 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_sound_device_can_capture -> 0x2d7690 2018-12-30 21:11:34,263 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_sound_device_can_playback(0x75a372a8 [0x2369090], "ALSA: default device") 2018-12-30 21:11:34,264 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_sound_device_can_playback -> 0x2d769c 2018-12-30 21:11:34,264 [DEBUG] [doorpi.sipphone.from_linphone] | O | X | ALSA: default device 2018-12-30 21:11:34,265 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_sound_device_can_capture(0x75a372a8 [0x2369090], "ALSA: bcm2835 ALSA") 2018-12-30 21:11:34,265 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_sound_device_can_capture -> 0x2d7690 2018-12-30 21:11:34,266 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_sound_device_can_playback(0x75a372a8 [0x2369090], "ALSA: bcm2835 ALSA") 2018-12-30 21:11:34,266 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_sound_device_can_playback -> 0x2d769c 2018-12-30 21:11:34,266 [DEBUG] [doorpi.sipphone.from_linphone] | O | X | ALSA: bcm2835 ALSA 2018-12-30 21:11:34,267 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_sound_device_can_capture(0x75a372a8 [0x2369090], "ALSA: Dummy") 2018-12-30 21:11:34,267 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_sound_device_can_capture -> 0x2d769c 2018-12-30 21:11:34,268 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_sound_device_can_playback(0x75a372a8 [0x2369090], "ALSA: Dummy") 2018-12-30 21:11:34,269 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_sound_device_can_playback -> 0x2d769c 2018-12-30 21:11:34,270 [DEBUG] [doorpi.sipphone.from_linphone] | X | X | ALSA: Dummy 2018-12-30 21:11:34,271 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_sound_device_can_capture(0x75a372a8 [0x2369090], "ALSA: USB Audio Device") 2018-12-30 21:11:34,271 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_sound_device_can_capture -> 0x2d769c 2018-12-30 21:11:34,272 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_sound_device_can_playback(0x75a372a8 [0x2369090], "ALSA: USB Audio Device") 2018-12-30 21:11:34,273 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_sound_device_can_playback -> 0x2d769c 2018-12-30 21:11:34,274 [DEBUG] [doorpi.sipphone.from_linphone] | X | X | ALSA: USB Audio Device 2018-12-30 21:11:34,274 [DEBUG] [doorpi.sipphone.from_linphone] ------------------------------------ 2018-12-30 21:11:34,275 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_capture_device(0x75a372a8 [0x2369090]) 2018-12-30 21:11:34,275 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_capture_device -> 0x74499650 2018-12-30 21:11:34,276 [DEBUG] [doorpi.sipphone.from_linphone] using capture_device: ALSA: USB Audio Device 2018-12-30 21:11:34,276 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_playback_device(0x75a372a8 [0x2369090]) 2018-12-30 21:11:34,277 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_playback_device -> 0x74499620 2018-12-30 21:11:34,277 [DEBUG] [doorpi.sipphone.from_linphone] using playback_device: ALSA: USB Audio Device 2018-12-30 21:11:34,278 [TRACE] [doorpi.conf.config_object] get_list for key audio_codecs in section SIP-Phone (default: PCMA,PCMU) returns ['PCMA', 'PCMU'] 2018-12-30 21:11:34,278 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_audio_codecs(0x75a372a8 [0x2369090]) 2018-12-30 21:11:34,279 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0x238e768) 2018-12-30 21:11:34,280 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2018-12-30 21:11:34,280 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0x76d43440 2018-12-30 21:11:34,281 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2018-12-30 21:11:34,281 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0x76d43440 2018-12-30 21:11:34,282 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0x76d43440 2018-12-30 21:11:34,282 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0x238e7f0) 2018-12-30 21:11:34,283 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2018-12-30 21:11:34,283 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0x76d43450 2018-12-30 21:11:34,283 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2018-12-30 21:11:34,284 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0x76d43450 2018-12-30 21:11:34,284 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0x76d43450 2018-12-30 21:11:34,285 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0x23774f8) 2018-12-30 21:11:34,285 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2018-12-30 21:11:34,286 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0x76d43460 2018-12-30 21:11:34,286 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2018-12-30 21:11:34,287 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0x76d43460 2018-12-30 21:11:34,287 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0x76d43460 2018-12-30 21:11:34,288 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0x2377560) 2018-12-30 21:11:34,288 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2018-12-30 21:11:34,289 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0x76d43470 2018-12-30 21:11:34,289 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2018-12-30 21:11:34,290 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0x76d43470 2018-12-30 21:11:34,290 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0x76d43470 2018-12-30 21:11:34,291 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0x23775b8) 2018-12-30 21:11:34,291 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2018-12-30 21:11:34,292 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0x76d43480 2018-12-30 21:11:34,292 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2018-12-30 21:11:34,292 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0x76d43480 2018-12-30 21:11:34,293 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0x76d43480 2018-12-30 21:11:34,293 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0x238e4b0) 2018-12-30 21:11:34,294 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2018-12-30 21:11:34,294 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0x76d43490 2018-12-30 21:11:34,295 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2018-12-30 21:11:34,295 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0x76d43490 2018-12-30 21:11:34,296 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0x76d43490 2018-12-30 21:11:34,296 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0x238e4f8) 2018-12-30 21:11:34,297 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2018-12-30 21:11:34,297 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0x76d434a0 2018-12-30 21:11:34,298 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2018-12-30 21:11:34,298 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0x76d434a0 2018-12-30 21:11:34,299 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0x76d434a0 2018-12-30 21:11:34,299 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0x238e550) 2018-12-30 21:11:34,300 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2018-12-30 21:11:34,300 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0x76d434b0 2018-12-30 21:11:34,301 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2018-12-30 21:11:34,301 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0x76d434b0 2018-12-30 21:11:34,302 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0x76d434b0 2018-12-30 21:11:34,302 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0x238e5b8) 2018-12-30 21:11:34,303 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2018-12-30 21:11:34,303 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0x76d434c0 2018-12-30 21:11:34,303 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2018-12-30 21:11:34,304 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0x76d434c0 2018-12-30 21:11:34,304 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0x76d434c0 2018-12-30 21:11:34,305 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0x238e610) 2018-12-30 21:11:34,305 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2018-12-30 21:11:34,306 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0x76d434d0 2018-12-30 21:11:34,306 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2018-12-30 21:11:34,307 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0x76d434d0 2018-12-30 21:11:34,307 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0x76d434d0 2018-12-30 21:11:34,308 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_audio_codecs -> 0x74497648 2018-12-30 21:11:34,308 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d43440 [0x238e768]) 2018-12-30 21:11:34,309 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x74494e20 2018-12-30 21:11:34,309 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d43440 [0x238e768]) 2018-12-30 21:11:34,310 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x74494e20 2018-12-30 21:11:34,310 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec opus 2018-12-30 21:11:34,311 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x75a372a8 [0x2369090], 0x76d43440 [0x238e768], 0x2d7690 [0]) 2018-12-30 21:11:34,312 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x21e78cc 2018-12-30 21:11:34,313 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d43450 [0x238e7f0]) 2018-12-30 21:11:34,313 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x74494e60 2018-12-30 21:11:34,314 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d43450 [0x238e7f0]) 2018-12-30 21:11:34,314 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x74494e60 2018-12-30 21:11:34,315 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec speex 2018-12-30 21:11:34,315 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x75a372a8 [0x2369090], 0x76d43450 [0x238e7f0], 0x2d7690 [0]) 2018-12-30 21:11:34,316 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x21e78cc 2018-12-30 21:11:34,317 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d43460 [0x23774f8]) 2018-12-30 21:11:34,317 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x74494e20 2018-12-30 21:11:34,318 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d43460 [0x23774f8]) 2018-12-30 21:11:34,318 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x74494e20 2018-12-30 21:11:34,318 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec speex 2018-12-30 21:11:34,319 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x75a372a8 [0x2369090], 0x76d43460 [0x23774f8], 0x2d7690 [0]) 2018-12-30 21:11:34,320 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x21e78cc 2018-12-30 21:11:34,320 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d43470 [0x2377560]) 2018-12-30 21:11:34,321 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x74494e60 2018-12-30 21:11:34,321 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d43470 [0x2377560]) 2018-12-30 21:11:34,322 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x74494e60 2018-12-30 21:11:34,322 [DEBUG] [doorpi.sipphone.from_linphone] enable audio codec PCMU 2018-12-30 21:11:34,323 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x75a372a8 [0x2369090], 0x76d43470 [0x2377560], 0x2d769c [1]) 2018-12-30 21:11:34,324 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x21e78cc 2018-12-30 21:11:34,324 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d43480 [0x23775b8]) 2018-12-30 21:11:34,324 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x74494e20 2018-12-30 21:11:34,325 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d43480 [0x23775b8]) 2018-12-30 21:11:34,325 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x74494e20 2018-12-30 21:11:34,326 [DEBUG] [doorpi.sipphone.from_linphone] enable audio codec PCMA 2018-12-30 21:11:34,326 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x75a372a8 [0x2369090], 0x76d43480 [0x23775b8], 0x2d769c [1]) 2018-12-30 21:11:34,327 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x21e78cc 2018-12-30 21:11:34,327 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d43490 [0x238e4b0]) 2018-12-30 21:11:34,328 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x75a372c0 2018-12-30 21:11:34,328 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d43490 [0x238e4b0]) 2018-12-30 21:11:34,329 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x75a372c0 2018-12-30 21:11:34,329 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec GSM 2018-12-30 21:11:34,330 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x75a372a8 [0x2369090], 0x76d43490 [0x238e4b0], 0x2d7690 [0]) 2018-12-30 21:11:34,331 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x21e78cc 2018-12-30 21:11:34,331 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d434a0 [0x238e4f8]) 2018-12-30 21:11:34,332 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x74494e20 2018-12-30 21:11:34,332 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d434a0 [0x238e4f8]) 2018-12-30 21:11:34,333 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x74494e20 2018-12-30 21:11:34,333 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec G722 2018-12-30 21:11:34,334 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x75a372a8 [0x2369090], 0x76d434a0 [0x238e4f8], 0x2d7690 [0]) 2018-12-30 21:11:34,334 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x21e78cc 2018-12-30 21:11:34,335 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d434b0 [0x238e550]) 2018-12-30 21:11:34,335 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x74494e60 2018-12-30 21:11:34,336 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d434b0 [0x238e550]) 2018-12-30 21:11:34,336 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x74494e60 2018-12-30 21:11:34,337 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec speex 2018-12-30 21:11:34,337 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x75a372a8 [0x2369090], 0x76d434b0 [0x238e550], 0x2d7690 [0]) 2018-12-30 21:11:34,338 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x21e78cc 2018-12-30 21:11:34,338 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d434c0 [0x238e5b8]) 2018-12-30 21:11:34,339 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x75a372c0 2018-12-30 21:11:34,339 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d434c0 [0x238e5b8]) 2018-12-30 21:11:34,340 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x75a372c0 2018-12-30 21:11:34,340 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec L16 2018-12-30 21:11:34,341 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x75a372a8 [0x2369090], 0x76d434c0 [0x238e5b8], 0x2d7690 [0]) 2018-12-30 21:11:34,342 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x21e78cc 2018-12-30 21:11:34,342 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d434d0 [0x238e610]) 2018-12-30 21:11:34,343 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x75a372c0 2018-12-30 21:11:34,343 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d434d0 [0x238e610]) 2018-12-30 21:11:34,343 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x75a372c0 2018-12-30 21:11:34,344 [DEBUG] [doorpi.sipphone.from_linphone] disable audio codec L16 2018-12-30 21:11:34,344 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x75a372a8 [0x2369090], 0x76d434d0 [0x238e610], 0x2d7690 [0]) 2018-12-30 21:11:34,345 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x21e78cc 2018-12-30 21:11:34,346 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_video_devices(0x75a372a8 [0x2369090]) 2018-12-30 21:11:34,346 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_video_devices -> 0x744975d0 2018-12-30 21:11:34,347 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_video_devices(0x75a372a8 [0x2369090]) 2018-12-30 21:11:34,347 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_video_devices -> 0x744975d0 2018-12-30 21:11:34,347 [INFO] [doorpi.sipphone.from_linphone] found 2 possible videodevices: 2018-12-30 21:11:34,348 [DEBUG] [doorpi.sipphone.from_linphone] | name 2018-12-30 21:11:34,348 [DEBUG] [doorpi.sipphone.from_linphone] ------------------------------------ 2018-12-30 21:11:34,349 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_video_devices(0x75a372a8 [0x2369090]) 2018-12-30 21:11:34,349 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_video_devices -> 0x744975d0 2018-12-30 21:11:34,350 [DEBUG] [doorpi.sipphone.from_linphone] | V4L2: /dev/video0 2018-12-30 21:11:34,350 [DEBUG] [doorpi.sipphone.from_linphone] | StaticImage: Static picture 2018-12-30 21:11:34,351 [DEBUG] [doorpi.sipphone.from_linphone] ------------------------------------ 2018-12-30 21:11:34,351 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_video_devices(0x75a372a8 [0x2369090]) 2018-12-30 21:11:34,352 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_video_devices -> 0x744975d0 2018-12-30 21:11:34,353 [TRACE] [doorpi.conf.config_object] get_string for key video_device in section SIP-Phone (default: V4L2: /dev/video0) returns V4L2: /dev/video0 2018-12-30 21:11:34,354 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_video_devices(0x75a372a8 [0x2369090]) 2018-12-30 21:11:34,354 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_video_devices -> 0x744975d0 2018-12-30 21:11:34,355 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_enable_video_capture(0x75a372a8 [0x2369090], 0x2d769c [1]) 2018-12-30 21:11:34,355 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_enable_video_capture -> 0 2018-12-30 21:11:34,356 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_video_device(0x75a372a8 [0x2369090], "V4L2: /dev/video0") 2018-12-30 21:11:34,356 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_video_device -> 0 2018-12-30 21:11:34,357 [TRACE] [doorpi.conf.config_object] get_string for key video_size in section SIP-Phone (default: vga) returns vga 2018-12-30 21:11:34,357 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_set_preferred_video_size_by_name(0x75a372a8 [0x2369090], "vga") 2018-12-30 21:11:34,358 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_set_preferred_video_size_by_name -> 0 2018-12-30 21:11:34,358 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_video_device(0x75a372a8 [0x2369090]) 2018-12-30 21:11:34,359 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_video_device -> 0x74497778 2018-12-30 21:11:34,359 [DEBUG] [doorpi.sipphone.from_linphone] using video_device: V4L2: /dev/video0 2018-12-30 21:11:34,360 [TRACE] [doorpi.conf.config_object] get_list for key video_codecs in section SIP-Phone (default: VP8) returns ['VP8'] 2018-12-30 21:11:34,360 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_get_video_codecs(0x75a372a8 [0x2369090]) 2018-12-30 21:11:34,361 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_from_native_ptr(0x238e6d8) 2018-12-30 21:11:34,361 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_new() 2018-12-30 21:11:34,362 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_new -> 0x76d434e0 2018-12-30 21:11:34,362 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_init() 2018-12-30 21:11:34,363 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_init -> 0x76d434e0 2018-12-30 21:11:34,363 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_from_native_ptr -> 0x76d434e0 2018-12-30 21:11:34,364 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_get_video_codecs -> 0x744975f8 2018-12-30 21:11:34,364 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d434e0 [0x238e6d8]) 2018-12-30 21:11:34,365 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x75a372c0 2018-12-30 21:11:34,365 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_video_capture_enabled(0x75a372a8 [0x2369090]) 2018-12-30 21:11:34,366 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_video_capture_enabled -> 0x2d769c 2018-12-30 21:11:34,366 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_PayloadType_get_mime_type(0x76d434e0 [0x238e6d8]) 2018-12-30 21:11:34,366 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_PayloadType_get_mime_type -> 0x75a372c0 2018-12-30 21:11:34,367 [DEBUG] [doorpi.sipphone.from_linphone] enable video codec VP8 2018-12-30 21:11:34,368 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_enable_payload_type(0x75a372a8 [0x2369090], 0x76d434e0 [0x238e6d8], 0x2d769c [1]) 2018-12-30 21:11:34,368 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_enable_payload_type -> 0x21e78cc 2018-12-30 21:11:34,369 [TRACE] [doorpi.conf.config_object] get_string for key sipserver_server in section SIP-Phone (default: ) returns 192.168.0.150 2018-12-30 21:11:34,369 [TRACE] [doorpi.conf.config_object] get_string for key sipserver_username in section SIP-Phone (default: ) returns 305 2018-12-30 21:11:34,370 [TRACE] [doorpi.conf.config_object] get_string for key sipserver_password in section SIP-Phone (default: 305) returns ******* 2018-12-30 21:11:34,370 [TRACE] [doorpi.conf.config_object] get_string for key sipserver_realm in section SIP-Phone (default: 192.168.0.150) returns 192.168.0.150 2018-12-30 21:11:34,371 [INFO] [doorpi.sipphone.from_linphone] using DoorPi with SIP-Server 2018-12-30 21:11:34,371 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_create_proxy_config(0x75a372a8 [0x2369090]) 2018-12-30 21:11:34,372 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_ProxyConfig_from_native_ptr(0x2394c68) 2018-12-30 21:11:34,372 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_ProxyConfig_new() 2018-12-30 21:11:34,373 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_ProxyConfig_new -> 0x76d434f0 2018-12-30 21:11:34,373 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_ProxyConfig_init() 2018-12-30 21:11:34,374 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_ProxyConfig_init -> 0x76d434f0 2018-12-30 21:11:34,374 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_ProxyConfig_from_native_ptr -> 0x76d434f0 2018-12-30 21:11:34,375 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_create_proxy_config -> 0x76d434f0 2018-12-30 21:11:34,375 [TRACE] [doorpi.conf.config_object] get_string for key identity in section SIP-Phone (default: DoorPi) returns DoorPi 2018-12-30 21:11:34,376 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Address_class_method_new("DoorPi ") 2018-12-30 21:11:34,377 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Address_from_native_ptr(0x23920e0) 2018-12-30 21:11:34,378 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Address_new() 2018-12-30 21:11:34,378 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Address_new -> 0x76d43500 2018-12-30 21:11:34,379 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Address_init() 2018-12-30 21:11:34,379 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Address_init -> 0x76d43500 2018-12-30 21:11:34,380 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Address_from_native_ptr -> 0x76d43500 2018-12-30 21:11:34,380 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Address_class_method_new -> 0x76d43500 2018-12-30 21:11:34,381 [ERROR] [doorpi.main] Exception NameError: 'linphone.ProxyConfig' object has no attribute 'identity_address' Traceback (most recent call last): File "/usr/local/lib/python2.7/dist-packages/doorpi/main.py", line 152, in main_as_application try: doorpi.DoorPi(parsed_arguments).run() File "/usr/local/lib/python2.7/dist-packages/doorpi/doorpi.py", line 232, in run if not self.__prepared: self.prepare(self.__parsed_arguments) File "/usr/local/lib/python2.7/dist-packages/doorpi/doorpi.py", line 149, in prepare self.sipphone.start() File "/usr/local/lib/python2.7/dist-packages/doorpi/sipphone/from_linphone.py", line 270, in start conf.get(SIPPHONE_SECTION, "identity", 'DoorPi'), username, server) AttributeError: 'linphone.ProxyConfig' object has no attribute 'identity_address' 2018-12-30 21:11:34,384 [DEBUG] [doorpi.doorpi] destroy doorpi 2018-12-30 21:11:34,385 [DEBUG] [doorpi.doorpi] Threads before starting shutdown: [<_MainThread(MainThread, started 1996269760)>, , ] 2018-12-30 21:11:34,386 [TRACE] [doorpi.action.handler] fire Event BeforeShutdown from doorpi.doorpi asyncron 2018-12-30 21:11:34,388 [DEBUG] [doorpi.action.handler] [YAJOSB] fire for event OnShutdown this actions [, , , ] 2018-12-30 21:11:34,389 [DEBUG] [doorpi.action.handler] no actions for event BeforeShutdown - skip fire_event BeforeShutdown from doorpi.doorpi 2018-12-30 21:11:34,389 [TRACE] [doorpi.action.handler] [YAJOSB] try to fire action TimeTickDestroyAction with args () and kwargs {} 2018-12-30 21:11:34,391 [TRACE] [doorpi.action.base] run TimeTickDestroyAction with args () and kwargs {} 2018-12-30 21:11:34,391 [TRACE] [doorpi.action.handler] unregister Eventsource doorpi.action.SingleActions.time_tick and force_unregister is True 2018-12-30 21:11:34,392 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute59 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,392 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute59 - remove event too 2018-12-30 21:11:34,393 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute59 2018-12-30 21:11:34,393 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute58 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,394 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute58 - remove event too 2018-12-30 21:11:34,395 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute58 2018-12-30 21:11:34,395 [TRACE] [doorpi.action.handler] unregister Event OnTimeWeekEvenNumber from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,396 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeWeekEvenNumber - remove event too 2018-12-30 21:11:34,397 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeWeekEvenNumber 2018-12-30 21:11:34,397 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute51 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,398 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute51 - remove event too 2018-12-30 21:11:34,398 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute51 2018-12-30 21:11:34,399 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute50 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,399 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute50 - remove event too 2018-12-30 21:11:34,400 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute50 2018-12-30 21:11:34,400 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute53 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,401 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute53 - remove event too 2018-12-30 21:11:34,401 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute53 2018-12-30 21:11:34,402 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute52 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,402 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute52 - remove event too 2018-12-30 21:11:34,403 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute52 2018-12-30 21:11:34,403 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute55 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,404 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute55 - remove event too 2018-12-30 21:11:34,404 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute55 2018-12-30 21:11:34,404 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute54 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,405 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute54 - remove event too 2018-12-30 21:11:34,405 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute54 2018-12-30 21:11:34,406 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute57 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,406 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute57 - remove event too 2018-12-30 21:11:34,407 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute57 2018-12-30 21:11:34,407 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute56 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,407 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute56 - remove event too 2018-12-30 21:11:34,408 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute56 2018-12-30 21:11:34,408 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinuteEvenNumber from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,409 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinuteEvenNumber - remove event too 2018-12-30 21:11:34,409 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinuteEvenNumber 2018-12-30 21:11:34,410 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,410 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour - remove event too 2018-12-30 21:11:34,411 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour 2018-12-30 21:11:34,411 [TRACE] [doorpi.action.handler] unregister Event OnTimeMonth from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,412 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMonth - remove event too 2018-12-30 21:11:34,412 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMonth 2018-12-30 21:11:34,413 [TRACE] [doorpi.action.handler] unregister Event OnTimeYearUnevenNumber from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,413 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeYearUnevenNumber - remove event too 2018-12-30 21:11:34,414 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeYearUnevenNumber 2018-12-30 21:11:34,414 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour19 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,415 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour19 - remove event too 2018-12-30 21:11:34,415 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour19 2018-12-30 21:11:34,415 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour18 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,416 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour18 - remove event too 2018-12-30 21:11:34,416 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour18 2018-12-30 21:11:34,417 [TRACE] [doorpi.action.handler] unregister Event OnTimeYearEvenNumber from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,417 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeYearEvenNumber - remove event too 2018-12-30 21:11:34,418 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeYearEvenNumber 2018-12-30 21:11:34,418 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour11 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,419 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour11 - remove event too 2018-12-30 21:11:34,419 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour11 2018-12-30 21:11:34,420 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour13 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,420 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour13 - remove event too 2018-12-30 21:11:34,421 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour13 2018-12-30 21:11:34,421 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour12 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,422 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour12 - remove event too 2018-12-30 21:11:34,422 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour12 2018-12-30 21:11:34,422 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour15 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,423 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour15 - remove event too 2018-12-30 21:11:34,423 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour15 2018-12-30 21:11:34,424 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour14 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,424 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour14 - remove event too 2018-12-30 21:11:34,425 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour14 2018-12-30 21:11:34,425 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour17 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,426 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour17 - remove event too 2018-12-30 21:11:34,426 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour17 2018-12-30 21:11:34,426 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour16 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,427 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour16 - remove event too 2018-12-30 21:11:34,427 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour16 2018-12-30 21:11:34,428 [TRACE] [doorpi.action.handler] unregister Event OnTimeSecondUnevenNumber from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,428 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeSecondUnevenNumber - remove event too 2018-12-30 21:11:34,429 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeSecondUnevenNumber 2018-12-30 21:11:34,429 [TRACE] [doorpi.action.handler] unregister Event OnTimeDay from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,430 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeDay - remove event too 2018-12-30 21:11:34,430 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeDay 2018-12-30 21:11:34,431 [TRACE] [doorpi.action.handler] unregister Event OnTimeMonthEvenNumber from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,431 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMonthEvenNumber - remove event too 2018-12-30 21:11:34,432 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMonthEvenNumber 2018-12-30 21:11:34,432 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour9 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,433 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour9 - remove event too 2018-12-30 21:11:34,433 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour9 2018-12-30 21:11:34,434 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour8 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,434 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour8 - remove event too 2018-12-30 21:11:34,434 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour8 2018-12-30 21:11:34,435 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour10 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,435 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour10 - remove event too 2018-12-30 21:11:34,436 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour10 2018-12-30 21:11:34,436 [TRACE] [doorpi.action.handler] unregister Event OnTimeSecond from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,437 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeSecond - remove event too 2018-12-30 21:11:34,437 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeSecond 2018-12-30 21:11:34,438 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour4 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,438 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour4 - remove event too 2018-12-30 21:11:34,439 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour4 2018-12-30 21:11:34,440 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour7 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,440 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour7 - remove event too 2018-12-30 21:11:34,441 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour7 2018-12-30 21:11:34,441 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour6 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,442 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour6 - remove event too 2018-12-30 21:11:34,442 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour6 2018-12-30 21:11:34,442 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour1 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,443 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour1 - remove event too 2018-12-30 21:11:34,443 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour1 2018-12-30 21:11:34,444 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour0 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,444 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour0 - remove event too 2018-12-30 21:11:34,445 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour0 2018-12-30 21:11:34,445 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour3 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,446 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour3 - remove event too 2018-12-30 21:11:34,446 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour3 2018-12-30 21:11:34,446 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour2 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,447 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour2 - remove event too 2018-12-30 21:11:34,447 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour2 2018-12-30 21:11:34,448 [TRACE] [doorpi.action.handler] unregister Event OnTimeMonthUnevenNumber from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,448 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMonthUnevenNumber - remove event too 2018-12-30 21:11:34,449 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMonthUnevenNumber 2018-12-30 21:11:34,449 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute5 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,450 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute5 - remove event too 2018-12-30 21:11:34,450 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute5 2018-12-30 21:11:34,451 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute4 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,451 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute4 - remove event too 2018-12-30 21:11:34,451 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute4 2018-12-30 21:11:34,452 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute7 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,452 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute7 - remove event too 2018-12-30 21:11:34,453 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute7 2018-12-30 21:11:34,453 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute6 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,454 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute6 - remove event too 2018-12-30 21:11:34,454 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute6 2018-12-30 21:11:34,455 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute1 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,455 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute1 - remove event too 2018-12-30 21:11:34,456 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute1 2018-12-30 21:11:34,456 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute0 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,456 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute0 - remove event too 2018-12-30 21:11:34,457 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute0 2018-12-30 21:11:34,457 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute3 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,458 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute3 - remove event too 2018-12-30 21:11:34,458 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute3 2018-12-30 21:11:34,459 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute2 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,459 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute2 - remove event too 2018-12-30 21:11:34,459 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute2 2018-12-30 21:11:34,460 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute9 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,460 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute9 - remove event too 2018-12-30 21:11:34,461 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute9 2018-12-30 21:11:34,461 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute8 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,462 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute8 - remove event too 2018-12-30 21:11:34,462 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute8 2018-12-30 21:11:34,463 [TRACE] [doorpi.action.handler] unregister Event OnTimeWeek from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,463 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeWeek - remove event too 2018-12-30 21:11:34,464 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeWeek 2018-12-30 21:11:34,464 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute15 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,464 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute15 - remove event too 2018-12-30 21:11:34,465 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute15 2018-12-30 21:11:34,465 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute14 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,466 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute14 - remove event too 2018-12-30 21:11:34,466 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute14 2018-12-30 21:11:34,467 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute17 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,467 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute17 - remove event too 2018-12-30 21:11:34,468 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute17 2018-12-30 21:11:34,468 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute16 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,469 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute16 - remove event too 2018-12-30 21:11:34,469 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute16 2018-12-30 21:11:34,470 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute11 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,470 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute11 - remove event too 2018-12-30 21:11:34,471 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute11 2018-12-30 21:11:34,471 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute10 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,471 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute10 - remove event too 2018-12-30 21:11:34,472 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute10 2018-12-30 21:11:34,472 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute13 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,473 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute13 - remove event too 2018-12-30 21:11:34,473 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute13 2018-12-30 21:11:34,474 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute12 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,474 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute12 - remove event too 2018-12-30 21:11:34,475 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute12 2018-12-30 21:11:34,475 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute19 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,476 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute19 - remove event too 2018-12-30 21:11:34,476 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute19 2018-12-30 21:11:34,477 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute18 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,477 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute18 - remove event too 2018-12-30 21:11:34,478 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute18 2018-12-30 21:11:34,479 [TRACE] [doorpi.action.handler] unregister Event OnTimeWeekUnevenNumber from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,479 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeWeekUnevenNumber - remove event too 2018-12-30 21:11:34,480 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeWeekUnevenNumber 2018-12-30 21:11:34,480 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinuteEvery5 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,480 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinuteEvery5 - remove event too 2018-12-30 21:11:34,481 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinuteEvery5 2018-12-30 21:11:34,481 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour20 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,482 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour20 - remove event too 2018-12-30 21:11:34,482 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour20 2018-12-30 21:11:34,483 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour21 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,483 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour21 - remove event too 2018-12-30 21:11:34,484 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour21 2018-12-30 21:11:34,484 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour22 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,485 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour22 - remove event too 2018-12-30 21:11:34,485 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour22 2018-12-30 21:11:34,485 [TRACE] [doorpi.action.handler] unregister Event OnTimeHour5 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,486 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHour5 - remove event too 2018-12-30 21:11:34,486 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHour5 2018-12-30 21:11:34,487 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute20 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,487 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute20 - remove event too 2018-12-30 21:11:34,488 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute20 2018-12-30 21:11:34,488 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute21 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,489 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute21 - remove event too 2018-12-30 21:11:34,489 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute21 2018-12-30 21:11:34,490 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute22 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,490 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute22 - remove event too 2018-12-30 21:11:34,490 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute22 2018-12-30 21:11:34,491 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute23 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,491 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute23 - remove event too 2018-12-30 21:11:34,492 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute23 2018-12-30 21:11:34,492 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute24 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,493 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute24 - remove event too 2018-12-30 21:11:34,493 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute24 2018-12-30 21:11:34,494 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute25 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,494 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute25 - remove event too 2018-12-30 21:11:34,494 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute25 2018-12-30 21:11:34,495 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute26 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,495 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute26 - remove event too 2018-12-30 21:11:34,496 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute26 2018-12-30 21:11:34,496 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute27 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,497 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute27 - remove event too 2018-12-30 21:11:34,497 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute27 2018-12-30 21:11:34,497 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute28 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,498 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute28 - remove event too 2018-12-30 21:11:34,498 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute28 2018-12-30 21:11:34,499 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute29 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,499 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute29 - remove event too 2018-12-30 21:11:34,500 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute29 2018-12-30 21:11:34,500 [TRACE] [doorpi.action.handler] unregister Event OnTimeDayEvenNumber from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,501 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeDayEvenNumber - remove event too 2018-12-30 21:11:34,501 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeDayEvenNumber 2018-12-30 21:11:34,502 [TRACE] [doorpi.action.handler] unregister Event OnTimeDayUnevenNumber from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,502 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeDayUnevenNumber - remove event too 2018-12-30 21:11:34,503 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeDayUnevenNumber 2018-12-30 21:11:34,503 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute39 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,503 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute39 - remove event too 2018-12-30 21:11:34,504 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute39 2018-12-30 21:11:34,504 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute38 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,505 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute38 - remove event too 2018-12-30 21:11:34,505 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute38 2018-12-30 21:11:34,506 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute37 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,506 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute37 - remove event too 2018-12-30 21:11:34,507 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute37 2018-12-30 21:11:34,507 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute36 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,507 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute36 - remove event too 2018-12-30 21:11:34,508 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute36 2018-12-30 21:11:34,508 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute35 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,509 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute35 - remove event too 2018-12-30 21:11:34,509 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute35 2018-12-30 21:11:34,510 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute34 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,510 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute34 - remove event too 2018-12-30 21:11:34,511 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute34 2018-12-30 21:11:34,511 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute33 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,512 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute33 - remove event too 2018-12-30 21:11:34,512 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute33 2018-12-30 21:11:34,513 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute32 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,513 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute32 - remove event too 2018-12-30 21:11:34,514 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute32 2018-12-30 21:11:34,514 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute31 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,515 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute31 - remove event too 2018-12-30 21:11:34,515 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute31 2018-12-30 21:11:34,515 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute30 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,516 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute30 - remove event too 2018-12-30 21:11:34,516 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute30 2018-12-30 21:11:34,517 [TRACE] [doorpi.action.handler] unregister Event OnTimeHourUnevenNumber from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,517 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHourUnevenNumber - remove event too 2018-12-30 21:11:34,518 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHourUnevenNumber 2018-12-30 21:11:34,518 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,519 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute - remove event too 2018-12-30 21:11:34,519 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute 2018-12-30 21:11:34,520 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute48 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,521 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute48 - remove event too 2018-12-30 21:11:34,521 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute48 2018-12-30 21:11:34,522 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute49 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,522 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute49 - remove event too 2018-12-30 21:11:34,523 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute49 2018-12-30 21:11:34,523 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute42 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,523 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute42 - remove event too 2018-12-30 21:11:34,524 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute42 2018-12-30 21:11:34,524 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute43 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,525 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute43 - remove event too 2018-12-30 21:11:34,525 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute43 2018-12-30 21:11:34,526 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute40 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,526 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute40 - remove event too 2018-12-30 21:11:34,527 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute40 2018-12-30 21:11:34,527 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute41 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,527 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute41 - remove event too 2018-12-30 21:11:34,528 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute41 2018-12-30 21:11:34,528 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute46 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,529 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute46 - remove event too 2018-12-30 21:11:34,529 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute46 2018-12-30 21:11:34,530 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute47 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,530 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute47 - remove event too 2018-12-30 21:11:34,531 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute47 2018-12-30 21:11:34,531 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute44 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,531 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute44 - remove event too 2018-12-30 21:11:34,532 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute44 2018-12-30 21:11:34,532 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinute45 from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,533 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinute45 - remove event too 2018-12-30 21:11:34,533 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinute45 2018-12-30 21:11:34,534 [TRACE] [doorpi.action.handler] unregister Event OnTimeHourEvenNumber from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,534 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeHourEvenNumber - remove event too 2018-12-30 21:11:34,535 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeHourEvenNumber 2018-12-30 21:11:34,535 [TRACE] [doorpi.action.handler] unregister Event OnTimeSecondEvenNumber from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,536 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeSecondEvenNumber - remove event too 2018-12-30 21:11:34,536 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeSecondEvenNumber 2018-12-30 21:11:34,537 [TRACE] [doorpi.action.handler] unregister Event OnTimeYear from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,537 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeYear - remove event too 2018-12-30 21:11:34,538 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeYear 2018-12-30 21:11:34,538 [TRACE] [doorpi.action.handler] unregister Event OnTimeMinuteUnevenNumber from doorpi.action.SingleActions.time_tick 2018-12-30 21:11:34,539 [DEBUG] [doorpi.action.handler] no more sources for event OnTimeMinuteUnevenNumber - remove event too 2018-12-30 21:11:34,539 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed for event OnTimeMinuteUnevenNumber 2018-12-30 21:11:34,540 [TRACE] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was removed 2018-12-30 21:11:34,541 [TRACE] [doorpi.action.handler] [YAJOSB] try to fire action WebServerShutdownAction with args () and kwargs {} 2018-12-30 21:11:34,542 [TRACE] [doorpi.action.base] run WebServerShutdownAction with args () and kwargs {} 2018-12-30 21:11:34,542 [TRACE] [doorpi.action.handler] fire Event OnWebServerStop from doorpi.status.webserver asyncron 2018-12-30 21:11:34,544 [TRACE] [doorpi.action.handler] unregister Eventsource doorpi.status.webserver_lib.request_handler and force_unregister is True 2018-12-30 21:11:34,545 [TRACE] [doorpi.action.handler] unregister Event OnWebServerVirtualResource from doorpi.status.webserver_lib.request_handler 2018-12-30 21:11:34,545 [DEBUG] [doorpi.action.handler] no actions for event OnWebServerStop - skip fire_event OnWebServerStop from doorpi.status.webserver 2018-12-30 21:11:34,546 [DEBUG] [doorpi.action.handler] no more sources for event OnWebServerVirtualResource - remove event too 2018-12-30 21:11:34,547 [TRACE] [doorpi.action.handler] event_source doorpi.status.webserver_lib.request_handler was removed for event OnWebServerVirtualResource 2018-12-30 21:11:34,547 [TRACE] [doorpi.action.handler] unregister Event OnWebServerRealResource from doorpi.status.webserver_lib.request_handler 2018-12-30 21:11:34,548 [DEBUG] [doorpi.action.handler] no more sources for event OnWebServerRealResource - remove event too 2018-12-30 21:11:34,548 [TRACE] [doorpi.action.handler] event_source doorpi.status.webserver_lib.request_handler was removed for event OnWebServerRealResource 2018-12-30 21:11:34,549 [TRACE] [doorpi.action.handler] unregister Event OnConfigKeySet from doorpi.status.webserver_lib.request_handler 2018-12-30 21:11:34,549 [DEBUG] [doorpi.action.handler] no more sources for event OnConfigKeySet - remove event too 2018-12-30 21:11:34,550 [TRACE] [doorpi.action.handler] event_source doorpi.status.webserver_lib.request_handler was removed for event OnConfigKeySet 2018-12-30 21:11:34,550 [TRACE] [doorpi.action.handler] unregister Event OnWebServerRequestGet from doorpi.status.webserver_lib.request_handler 2018-12-30 21:11:34,551 [DEBUG] [doorpi.action.handler] no more sources for event OnWebServerRequestGet - remove event too 2018-12-30 21:11:34,551 [TRACE] [doorpi.action.handler] event_source doorpi.status.webserver_lib.request_handler was removed for event OnWebServerRequestGet 2018-12-30 21:11:34,552 [TRACE] [doorpi.action.handler] unregister Event OnWebServerRequestPost from doorpi.status.webserver_lib.request_handler 2018-12-30 21:11:34,552 [DEBUG] [doorpi.action.handler] no more sources for event OnWebServerRequestPost - remove event too 2018-12-30 21:11:34,553 [TRACE] [doorpi.action.handler] event_source doorpi.status.webserver_lib.request_handler was removed for event OnWebServerRequestPost 2018-12-30 21:11:34,553 [TRACE] [doorpi.action.handler] unregister Event OnConfigKeyDelete from doorpi.status.webserver_lib.request_handler 2018-12-30 21:11:34,554 [DEBUG] [doorpi.action.handler] no more sources for event OnConfigKeyDelete - remove event too 2018-12-30 21:11:34,554 [TRACE] [doorpi.action.handler] event_source doorpi.status.webserver_lib.request_handler was removed for event OnConfigKeyDelete 2018-12-30 21:11:34,555 [TRACE] [doorpi.action.handler] unregister Event OnWebServerRequest from doorpi.status.webserver_lib.request_handler 2018-12-30 21:11:34,555 [DEBUG] [doorpi.action.handler] no more sources for event OnWebServerRequest - remove event too 2018-12-30 21:11:34,556 [TRACE] [doorpi.action.handler] event_source doorpi.status.webserver_lib.request_handler was removed for event OnWebServerRequest 2018-12-30 21:11:34,556 [TRACE] [doorpi.action.handler] unregister Event OnFireEvent from doorpi.status.webserver_lib.request_handler 2018-12-30 21:11:34,556 [DEBUG] [doorpi.action.handler] no more sources for event OnFireEvent - remove event too 2018-12-30 21:11:34,557 [TRACE] [doorpi.action.handler] event_source doorpi.status.webserver_lib.request_handler was removed for event OnFireEvent 2018-12-30 21:11:34,557 [TRACE] [doorpi.action.handler] event_source doorpi.status.webserver_lib.request_handler was removed 2018-12-30 21:11:34,569 [TRACE] [doorpi.action.handler] unregister Eventsource doorpi.status.webserver and force_unregister is True 2018-12-30 21:11:34,571 [TRACE] [doorpi.action.handler] unregister Event OnWebServerStop from doorpi.status.webserver 2018-12-30 21:11:34,572 [DEBUG] [doorpi.action.handler] no more sources for event OnWebServerStop - remove event too 2018-12-30 21:11:34,573 [TRACE] [doorpi.action.handler] [JU7TQS] finished fire_event for event_name OnWebServerStart 2018-12-30 21:11:34,573 [TRACE] [doorpi.action.handler] event_source doorpi.status.webserver was removed for event OnWebServerStop 2018-12-30 21:11:34,575 [TRACE] [doorpi.action.handler] unregister Event OnWebServerStart from doorpi.status.webserver 2018-12-30 21:11:34,576 [DEBUG] [doorpi.action.handler] no more sources for event OnWebServerStart - remove event too 2018-12-30 21:11:34,576 [TRACE] [doorpi.action.handler] event_source doorpi.status.webserver was removed for event OnWebServerStart 2018-12-30 21:11:34,577 [TRACE] [doorpi.action.handler] event_source doorpi.status.webserver was removed 2018-12-30 21:11:34,578 [TRACE] [doorpi.action.handler] [YAJOSB] try to fire action KeyboardDestroyAction with args () and kwargs {} 2018-12-30 21:11:34,578 [TRACE] [doorpi.action.base] run KeyboardDestroyAction with args () and kwargs {} 2018-12-30 21:11:34,579 [DEBUG] [doorpi.keyboard.from_piface] destroy 2018-12-30 21:11:34,590 [TRACE] [doorpi.action.handler] unregister Eventsource doorpi.keyboard.from_piface and force_unregister is True 2018-12-30 21:11:34,592 [TRACE] [doorpi.action.handler] unregister Event OnKeyPressed_2 from doorpi.keyboard.from_piface 2018-12-30 21:11:34,593 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyPressed_2 - remove event too 2018-12-30 21:11:34,594 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_piface was removed for event OnKeyPressed_2 2018-12-30 21:11:34,594 [TRACE] [doorpi.action.handler] unregister Event OnKeyPressed from doorpi.keyboard.from_piface 2018-12-30 21:11:34,595 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyPressed - remove event too 2018-12-30 21:11:34,596 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_piface was removed for event OnKeyPressed 2018-12-30 21:11:34,597 [TRACE] [doorpi.action.handler] unregister Event OnKeyUp from doorpi.keyboard.from_piface 2018-12-30 21:11:34,598 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyUp - remove event too 2018-12-30 21:11:34,598 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_piface was removed for event OnKeyUp 2018-12-30 21:11:34,599 [TRACE] [doorpi.action.handler] unregister Event OnKeyUp_2 from doorpi.keyboard.from_piface 2018-12-30 21:11:34,600 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyUp_2 - remove event too 2018-12-30 21:11:34,601 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_piface was removed for event OnKeyUp_2 2018-12-30 21:11:34,602 [TRACE] [doorpi.action.handler] unregister Event OnKeyUp_1 from doorpi.keyboard.from_piface 2018-12-30 21:11:34,603 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyUp_1 - remove event too 2018-12-30 21:11:34,604 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_piface was removed for event OnKeyUp_1 2018-12-30 21:11:34,605 [TRACE] [doorpi.action.handler] unregister Event OnKeyPressed_onboardpins.1 from doorpi.keyboard.from_piface 2018-12-30 21:11:34,606 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyPressed_onboardpins.1 - remove event too 2018-12-30 21:11:34,606 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_piface was removed for event OnKeyPressed_onboardpins.1 2018-12-30 21:11:34,607 [TRACE] [doorpi.action.handler] unregister Event OnKeyPressed_onboardpins.2 from doorpi.keyboard.from_piface 2018-12-30 21:11:34,608 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyPressed_onboardpins.2 - remove event too 2018-12-30 21:11:34,609 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_piface was removed for event OnKeyPressed_onboardpins.2 2018-12-30 21:11:34,610 [TRACE] [doorpi.action.handler] unregister Event OnKeyDown from doorpi.keyboard.from_piface 2018-12-30 21:11:34,610 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyDown - remove event too 2018-12-30 21:11:34,611 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_piface was removed for event OnKeyDown 2018-12-30 21:11:34,612 [TRACE] [doorpi.action.handler] unregister Event OnKeyUp_onboardpins.1 from doorpi.keyboard.from_piface 2018-12-30 21:11:34,613 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyUp_onboardpins.1 - remove event too 2018-12-30 21:11:34,613 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_piface was removed for event OnKeyUp_onboardpins.1 2018-12-30 21:11:34,614 [TRACE] [doorpi.action.handler] unregister Event OnKeyUp_onboardpins.2 from doorpi.keyboard.from_piface 2018-12-30 21:11:34,615 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyUp_onboardpins.2 - remove event too 2018-12-30 21:11:34,616 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_piface was removed for event OnKeyUp_onboardpins.2 2018-12-30 21:11:34,617 [TRACE] [doorpi.action.handler] unregister Event OnKeyDown_2 from doorpi.keyboard.from_piface 2018-12-30 21:11:34,617 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyDown_2 - remove event too 2018-12-30 21:11:34,618 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_piface was removed for event OnKeyDown_2 2018-12-30 21:11:34,619 [TRACE] [doorpi.action.handler] unregister Event OnKeyDown_1 from doorpi.keyboard.from_piface 2018-12-30 21:11:34,620 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyDown_1 - remove event too 2018-12-30 21:11:34,621 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_piface was removed for event OnKeyDown_1 2018-12-30 21:11:34,622 [TRACE] [doorpi.action.handler] unregister Event OnKeyPressed_1 from doorpi.keyboard.from_piface 2018-12-30 21:11:34,623 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyPressed_1 - remove event too 2018-12-30 21:11:34,624 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_piface was removed for event OnKeyPressed_1 2018-12-30 21:11:34,624 [TRACE] [doorpi.action.handler] unregister Event OnKeyDown_onboardpins.1 from doorpi.keyboard.from_piface 2018-12-30 21:11:34,625 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyDown_onboardpins.1 - remove event too 2018-12-30 21:11:34,626 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_piface was removed for event OnKeyDown_onboardpins.1 2018-12-30 21:11:34,627 [TRACE] [doorpi.action.handler] unregister Event OnKeyDown_onboardpins.2 from doorpi.keyboard.from_piface 2018-12-30 21:11:34,627 [DEBUG] [doorpi.action.handler] no more sources for event OnKeyDown_onboardpins.2 - remove event too 2018-12-30 21:11:34,628 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_piface was removed for event OnKeyDown_onboardpins.2 2018-12-30 21:11:34,629 [TRACE] [doorpi.action.handler] event_source doorpi.keyboard.from_piface was removed 2018-12-30 21:11:34,630 [TRACE] [doorpi.action.handler] [YAJOSB] try to fire action > with args () and kwargs {} 2018-12-30 21:11:34,631 [TRACE] [doorpi.action.base] run SingleAction with args () and kwargs {} 2018-12-30 21:11:34,632 [DEBUG] [doorpi.sipphone.from_linphone] destroy 2018-12-30 21:11:34,633 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] >>> pylinphone_Core_instance_method_terminate_all_calls(0x75a372a8 [0x2369090]) 2018-12-30 21:11:34,633 [DEBUG] [doorpi.sipphone.from_linphone] [PYLINPHONE] <<< pylinphone_Core_instance_method_terminate_all_calls -> 0x21e78cc 2018-12-30 21:11:34,635 [DEBUG] [doorpi.action.handler] [NARUNN] fire for event OnSipPhoneDestroy this actions [, , ] 2018-12-30 21:11:34,635 [TRACE] [doorpi.action.handler] [NARUNN] try to fire action > with args () and kwargs {} 2018-12-30 21:11:34,636 [TRACE] [doorpi.action.base] run SingleAction with args () and kwargs {} 2018-12-30 21:11:34,636 [DEBUG] [doorpi.sipphone.linphone_lib.CallBacks] destroy 2018-12-30 21:11:34,637 [TRACE] [doorpi.action.handler] unregister Eventsource doorpi.sipphone.linphone_lib.CallBacks and force_unregister is True 2018-12-30 21:11:34,637 [TRACE] [doorpi.action.handler] unregister Event OnCallReject from doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:34,638 [DEBUG] [doorpi.action.handler] no more sources for event OnCallReject - remove event too 2018-12-30 21:11:34,638 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event OnCallReject 2018-12-30 21:11:34,639 [TRACE] [doorpi.action.handler] unregister Event OnMediaNotRequired from doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:34,639 [DEBUG] [doorpi.action.handler] no more sources for event OnMediaNotRequired - remove event too 2018-12-30 21:11:34,640 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event OnMediaNotRequired 2018-12-30 21:11:34,640 [TRACE] [doorpi.action.handler] unregister Event OnDTMF from doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:34,641 [DEBUG] [doorpi.action.handler] no more sources for event OnDTMF - remove event too 2018-12-30 21:11:34,641 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event OnDTMF 2018-12-30 21:11:34,642 [TRACE] [doorpi.action.handler] unregister Event OnMediaRequired from doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:34,642 [DEBUG] [doorpi.action.handler] no more sources for event OnMediaRequired - remove event too 2018-12-30 21:11:34,643 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event OnMediaRequired 2018-12-30 21:11:34,643 [TRACE] [doorpi.action.handler] unregister Event OnCallMediaStateChange from doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:34,644 [DEBUG] [doorpi.action.handler] no more sources for event OnCallMediaStateChange - remove event too 2018-12-30 21:11:34,644 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event OnCallMediaStateChange 2018-12-30 21:11:34,645 [TRACE] [doorpi.action.handler] unregister Event AfterCallStateConnect from doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:34,645 [DEBUG] [doorpi.action.handler] no more sources for event AfterCallStateConnect - remove event too 2018-12-30 21:11:34,646 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event AfterCallStateConnect 2018-12-30 21:11:34,646 [TRACE] [doorpi.action.handler] unregister Event OnCallBusy from doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:34,646 [DEBUG] [doorpi.action.handler] no more sources for event OnCallBusy - remove event too 2018-12-30 21:11:34,647 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event OnCallBusy 2018-12-30 21:11:34,647 [TRACE] [doorpi.action.handler] unregister Event AfterCallStateDisconnect from doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:34,648 [DEBUG] [doorpi.action.handler] no more sources for event AfterCallStateDisconnect - remove event too 2018-12-30 21:11:34,649 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event AfterCallStateDisconnect 2018-12-30 21:11:34,649 [TRACE] [doorpi.action.handler] unregister Event AfterCallBusy from doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:34,650 [DEBUG] [doorpi.action.handler] no more sources for event AfterCallBusy - remove event too 2018-12-30 21:11:34,651 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event AfterCallBusy 2018-12-30 21:11:34,651 [TRACE] [doorpi.action.handler] unregister Event OnCallStateReject from doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:34,651 [DEBUG] [doorpi.action.handler] no more sources for event OnCallStateReject - remove event too 2018-12-30 21:11:34,652 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event OnCallStateReject 2018-12-30 21:11:34,652 [TRACE] [doorpi.action.handler] unregister Event BeforeCallIncoming from doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:34,653 [DEBUG] [doorpi.action.handler] no more sources for event BeforeCallIncoming - remove event too 2018-12-30 21:11:34,653 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event BeforeCallIncoming 2018-12-30 21:11:34,654 [TRACE] [doorpi.action.handler] unregister Event OnCallStateChange from doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:34,654 [DEBUG] [doorpi.action.handler] no more sources for event OnCallStateChange - remove event too 2018-12-30 21:11:34,655 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event OnCallStateChange 2018-12-30 21:11:34,655 [TRACE] [doorpi.action.handler] unregister Event OnCallStateDismissed from doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:34,656 [DEBUG] [doorpi.action.handler] no more sources for event OnCallStateDismissed - remove event too 2018-12-30 21:11:34,656 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event OnCallStateDismissed 2018-12-30 21:11:34,657 [TRACE] [doorpi.action.handler] unregister Event OnCallStateDisconnect from doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:34,657 [DEBUG] [doorpi.action.handler] no more sources for event OnCallStateDisconnect - remove event too 2018-12-30 21:11:34,658 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event OnCallStateDisconnect 2018-12-30 21:11:34,658 [TRACE] [doorpi.action.handler] unregister Event AfterCallReject from doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:34,658 [DEBUG] [doorpi.action.handler] no more sources for event AfterCallReject - remove event too 2018-12-30 21:11:34,659 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event AfterCallReject 2018-12-30 21:11:34,659 [TRACE] [doorpi.action.handler] unregister Event OnCallStart from doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:34,660 [DEBUG] [doorpi.action.handler] no more sources for event OnCallStart - remove event too 2018-12-30 21:11:34,660 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event OnCallStart 2018-12-30 21:11:34,661 [TRACE] [doorpi.action.handler] unregister Event AfterCallReconnect from doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:34,661 [DEBUG] [doorpi.action.handler] no more sources for event AfterCallReconnect - remove event too 2018-12-30 21:11:34,662 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event AfterCallReconnect 2018-12-30 21:11:34,662 [TRACE] [doorpi.action.handler] unregister Event OnCallStateConnect from doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:34,663 [DEBUG] [doorpi.action.handler] no more sources for event OnCallStateConnect - remove event too 2018-12-30 21:11:34,663 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event OnCallStateConnect 2018-12-30 21:11:34,664 [TRACE] [doorpi.action.handler] unregister Event OnCallIncoming from doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:34,664 [DEBUG] [doorpi.action.handler] no more sources for event OnCallIncoming - remove event too 2018-12-30 21:11:34,665 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event OnCallIncoming 2018-12-30 21:11:34,665 [TRACE] [doorpi.action.handler] unregister Event AfterCallIncoming from doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:34,666 [DEBUG] [doorpi.action.handler] no more sources for event AfterCallIncoming - remove event too 2018-12-30 21:11:34,666 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event AfterCallIncoming 2018-12-30 21:11:34,666 [TRACE] [doorpi.action.handler] unregister Event OnCallReconnect from doorpi.sipphone.linphone_lib.CallBacks 2018-12-30 21:11:34,667 [DEBUG] [doorpi.action.handler] no more sources for event OnCallReconnect - remove event too 2018-12-30 21:11:34,667 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed for event OnCallReconnect 2018-12-30 21:11:34,668 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.CallBacks was removed 2018-12-30 21:11:34,669 [TRACE] [doorpi.action.handler] [NARUNN] try to fire action > with args () and kwargs {} 2018-12-30 21:11:34,670 [TRACE] [doorpi.action.base] run SingleAction with args () and kwargs {} 2018-12-30 21:11:34,670 [TRACE] [doorpi.action.handler] fire Event OnPlayerStopped from doorpi.sipphone.linphone_lib.Player asyncron 2018-12-30 21:11:34,672 [TRACE] [doorpi.action.handler] unregister Eventsource doorpi.sipphone.linphone_lib.Player and force_unregister is True 2018-12-30 21:11:34,673 [TRACE] [doorpi.action.handler] unregister Event OnPlayerCreated from doorpi.sipphone.linphone_lib.Player 2018-12-30 21:11:34,673 [DEBUG] [doorpi.action.handler] no actions for event OnPlayerStopped - skip fire_event OnPlayerStopped from doorpi.sipphone.linphone_lib.Player 2018-12-30 21:11:34,674 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.Player was removed for event OnPlayerCreated 2018-12-30 21:11:34,675 [TRACE] [doorpi.action.handler] unregister Event OnPlayerStarted from doorpi.sipphone.linphone_lib.Player 2018-12-30 21:11:34,675 [DEBUG] [doorpi.action.handler] no more sources for event OnPlayerStarted - remove event too 2018-12-30 21:11:34,676 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.Player was removed for event OnPlayerStarted 2018-12-30 21:11:34,676 [TRACE] [doorpi.action.handler] unregister Event OnPlayerStopped from doorpi.sipphone.linphone_lib.Player 2018-12-30 21:11:34,677 [DEBUG] [doorpi.action.handler] no more sources for event OnPlayerStopped - remove event too 2018-12-30 21:11:34,677 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.Player was removed for event OnPlayerStopped 2018-12-30 21:11:34,678 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.Player was removed 2018-12-30 21:11:34,679 [TRACE] [doorpi.action.handler] [NARUNN] try to fire action > with args () and kwargs {} 2018-12-30 21:11:34,679 [TRACE] [doorpi.action.base] run SingleAction with args () and kwargs {} 2018-12-30 21:11:34,680 [TRACE] [doorpi.action.handler] unregister Eventsource doorpi.sipphone.linphone_lib.Recorder and force_unregister is True 2018-12-30 21:11:34,681 [TRACE] [doorpi.action.handler] unregister Event OnRecorderCreated from doorpi.sipphone.linphone_lib.Recorder 2018-12-30 21:11:34,681 [DEBUG] [doorpi.action.handler] no more sources for event OnRecorderCreated - remove event too 2018-12-30 21:11:34,682 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.Recorder was removed for event OnRecorderCreated 2018-12-30 21:11:34,682 [TRACE] [doorpi.action.handler] unregister Event OnRecorderStarted from doorpi.sipphone.linphone_lib.Recorder 2018-12-30 21:11:34,683 [DEBUG] [doorpi.action.handler] no more sources for event OnRecorderStarted - remove event too 2018-12-30 21:11:34,683 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.Recorder was removed for event OnRecorderStarted 2018-12-30 21:11:34,684 [TRACE] [doorpi.action.handler] unregister Event OnRecorderStopped from doorpi.sipphone.linphone_lib.Recorder 2018-12-30 21:11:34,684 [DEBUG] [doorpi.action.handler] no more sources for event OnRecorderStopped - remove event too 2018-12-30 21:11:34,684 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.Recorder was removed for event OnRecorderStopped 2018-12-30 21:11:34,685 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.linphone_lib.Recorder was removed 2018-12-30 21:11:34,686 [TRACE] [doorpi.action.handler] [NARUNN] finished fire_event for event_name OnSipPhoneDestroy 2018-12-30 21:11:34,687 [TRACE] [doorpi.action.handler] unregister Eventsource doorpi.sipphone.from_linphone and force_unregister is True 2018-12-30 21:11:34,688 [TRACE] [doorpi.action.handler] unregister Event OnSipPhoneRecorderCreate from doorpi.sipphone.from_linphone 2018-12-30 21:11:34,688 [DEBUG] [doorpi.action.handler] no more sources for event OnSipPhoneRecorderCreate - remove event too 2018-12-30 21:11:34,689 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.from_linphone was removed for event OnSipPhoneRecorderCreate 2018-12-30 21:11:34,689 [TRACE] [doorpi.action.handler] unregister Event OnPlayerCreated from doorpi.sipphone.from_linphone 2018-12-30 21:11:34,690 [DEBUG] [doorpi.action.handler] no more sources for event OnPlayerCreated - remove event too 2018-12-30 21:11:34,690 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.from_linphone was removed for event OnPlayerCreated 2018-12-30 21:11:34,691 [TRACE] [doorpi.action.handler] unregister Event BeforeSipPhoneMakeCall from doorpi.sipphone.from_linphone 2018-12-30 21:11:34,691 [DEBUG] [doorpi.action.handler] no more sources for event BeforeSipPhoneMakeCall - remove event too 2018-12-30 21:11:34,692 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.from_linphone was removed for event BeforeSipPhoneMakeCall 2018-12-30 21:11:34,692 [TRACE] [doorpi.action.handler] unregister Event OnSipPhoneRecorderDestroy from doorpi.sipphone.from_linphone 2018-12-30 21:11:34,693 [DEBUG] [doorpi.action.handler] no more sources for event OnSipPhoneRecorderDestroy - remove event too 2018-12-30 21:11:34,693 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.from_linphone was removed for event OnSipPhoneRecorderDestroy 2018-12-30 21:11:34,694 [TRACE] [doorpi.action.handler] unregister Event OnSipPhoneStart from doorpi.sipphone.from_linphone 2018-12-30 21:11:34,694 [DEBUG] [doorpi.action.handler] no more sources for event OnSipPhoneStart - remove event too 2018-12-30 21:11:34,694 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.from_linphone was removed for event OnSipPhoneStart 2018-12-30 21:11:34,695 [TRACE] [doorpi.action.handler] unregister Event OnSipPhoneDestroy from doorpi.sipphone.from_linphone 2018-12-30 21:11:34,695 [DEBUG] [doorpi.action.handler] no more sources for event OnSipPhoneDestroy - remove event too 2018-12-30 21:11:34,696 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.from_linphone was removed for event OnSipPhoneDestroy 2018-12-30 21:11:34,696 [TRACE] [doorpi.action.handler] unregister Event OnSipPhoneCallTimeoutMaxCalltime from doorpi.sipphone.from_linphone 2018-12-30 21:11:34,697 [DEBUG] [doorpi.action.handler] no more sources for event OnSipPhoneCallTimeoutMaxCalltime - remove event too 2018-12-30 21:11:34,697 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.from_linphone was removed for event OnSipPhoneCallTimeoutMaxCalltime 2018-12-30 21:11:34,698 [TRACE] [doorpi.action.handler] unregister Event OnSipPhoneCallTimeoutNoResponse from doorpi.sipphone.from_linphone 2018-12-30 21:11:34,698 [DEBUG] [doorpi.action.handler] no more sources for event OnSipPhoneCallTimeoutNoResponse - remove event too 2018-12-30 21:11:34,698 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.from_linphone was removed for event OnSipPhoneCallTimeoutNoResponse 2018-12-30 21:11:34,699 [TRACE] [doorpi.action.handler] unregister Event AfterSipPhoneMakeCall from doorpi.sipphone.from_linphone 2018-12-30 21:11:34,699 [DEBUG] [doorpi.action.handler] no more sources for event AfterSipPhoneMakeCall - remove event too 2018-12-30 21:11:34,700 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.from_linphone was removed for event AfterSipPhoneMakeCall 2018-12-30 21:11:34,700 [TRACE] [doorpi.action.handler] unregister Event OnSipPhoneMakeCall from doorpi.sipphone.from_linphone 2018-12-30 21:11:34,701 [DEBUG] [doorpi.action.handler] no more sources for event OnSipPhoneMakeCall - remove event too 2018-12-30 21:11:34,701 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.from_linphone was removed for event OnSipPhoneMakeCall 2018-12-30 21:11:34,702 [TRACE] [doorpi.action.handler] unregister Event OnSipPhoneMakeCallFailed from doorpi.sipphone.from_linphone 2018-12-30 21:11:34,702 [DEBUG] [doorpi.action.handler] no more sources for event OnSipPhoneMakeCallFailed - remove event too 2018-12-30 21:11:34,703 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.from_linphone was removed for event OnSipPhoneMakeCallFailed 2018-12-30 21:11:34,703 [TRACE] [doorpi.action.handler] unregister Event OnSipPhoneCreate from doorpi.sipphone.from_linphone 2018-12-30 21:11:34,704 [DEBUG] [doorpi.action.handler] no more sources for event OnSipPhoneCreate - remove event too 2018-12-30 21:11:34,704 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.from_linphone was removed for event OnSipPhoneCreate 2018-12-30 21:11:34,704 [TRACE] [doorpi.action.handler] event_source doorpi.sipphone.from_linphone was removed 2018-12-30 21:11:34,705 [TRACE] [doorpi.action.handler] [YAJOSB] finished fire_event for event_name OnShutdown 2018-12-30 21:11:34,706 [TRACE] [doorpi.action.handler] fire Event AfterShutdown from doorpi.doorpi asyncron 2018-12-30 21:11:34,708 [DEBUG] [doorpi.action.handler] no actions for event AfterShutdown - skip fire_event AfterShutdown from doorpi.doorpi 2018-12-30 21:11:35,209 [DEBUG] [doorpi.doorpi] wait 5 seconds for threads 1 and 1 event 2018-12-30 21:11:35,210 [TRACE] [doorpi.doorpi] still existing threads: [] 2018-12-30 21:11:35,210 [TRACE] [doorpi.doorpi] still existing event sources: ['doorpi.doorpi'] 2018-12-30 21:11:35,712 [DEBUG] [doorpi.doorpi] wait 4.5 seconds for threads 1 and 1 event 2018-12-30 21:11:35,713 [TRACE] [doorpi.doorpi] still existing threads: [] 2018-12-30 21:11:35,713 [TRACE] [doorpi.doorpi] still existing event sources: ['doorpi.doorpi'] 2018-12-30 21:11:36,215 [DEBUG] [doorpi.doorpi] wait 4.0 seconds for threads 1 and 1 event 2018-12-30 21:11:36,216 [TRACE] [doorpi.doorpi] still existing threads: [] 2018-12-30 21:11:36,217 [TRACE] [doorpi.doorpi] still existing event sources: ['doorpi.doorpi'] 2018-12-30 21:11:36,718 [DEBUG] [doorpi.doorpi] wait 3.5 seconds for threads 1 and 1 event 2018-12-30 21:11:36,720 [TRACE] [doorpi.doorpi] still existing threads: [] 2018-12-30 21:11:36,721 [TRACE] [doorpi.doorpi] still existing event sources: ['doorpi.doorpi'] 2018-12-30 21:11:37,223 [DEBUG] [doorpi.doorpi] wait 3.0 seconds for threads 1 and 1 event 2018-12-30 21:11:37,224 [TRACE] [doorpi.doorpi] still existing threads: [] 2018-12-30 21:11:37,224 [TRACE] [doorpi.doorpi] still existing event sources: ['doorpi.doorpi'] 2018-12-30 21:11:37,726 [DEBUG] [doorpi.doorpi] wait 2.5 seconds for threads 1 and 1 event 2018-12-30 21:11:37,728 [TRACE] [doorpi.doorpi] still existing threads: [] 2018-12-30 21:11:37,729 [TRACE] [doorpi.doorpi] still existing event sources: ['doorpi.doorpi'] 2018-12-30 21:11:38,230 [DEBUG] [doorpi.doorpi] wait 2.0 seconds for threads 1 and 1 event 2018-12-30 21:11:38,232 [TRACE] [doorpi.doorpi] still existing threads: [] 2018-12-30 21:11:38,233 [TRACE] [doorpi.doorpi] still existing event sources: ['doorpi.doorpi'] 2018-12-30 21:11:38,735 [DEBUG] [doorpi.doorpi] wait 1.5 seconds for threads 1 and 1 event 2018-12-30 21:11:38,736 [TRACE] [doorpi.doorpi] still existing threads: [] 2018-12-30 21:11:38,736 [TRACE] [doorpi.doorpi] still existing event sources: ['doorpi.doorpi'] 2018-12-30 21:11:39,238 [DEBUG] [doorpi.doorpi] wait 1.0 seconds for threads 1 and 1 event 2018-12-30 21:11:39,240 [TRACE] [doorpi.doorpi] still existing threads: [] 2018-12-30 21:11:39,241 [TRACE] [doorpi.doorpi] still existing event sources: ['doorpi.doorpi'] 2018-12-30 21:11:39,743 [DEBUG] [doorpi.doorpi] wait 0.5 seconds for threads 1 and 1 event 2018-12-30 21:11:39,744 [TRACE] [doorpi.doorpi] still existing threads: [] 2018-12-30 21:11:39,745 [TRACE] [doorpi.doorpi] still existing event sources: ['doorpi.doorpi'] 2018-12-30 21:11:40,246 [WARNING] [doorpi.doorpi] waiting for threads to time out - there are still threads: [] 2018-12-30 21:11:40,247 [INFO] [doorpi.doorpi] ======== DoorPi successfully shutdown ========