pi@raspberrypi:~ $ sudo doorpi_cli --debug --configfile /usr/local/etc/DoorPi/conf/doorpi.ini 2021-03-21 08:47:02,814 [INFO] [doorpi.main] ___ ___ _ / \___ ___ _ __ / _ (_) VoIP Door-Intercomstation with Raspberry Pi / /\ / _ \ / _ \| '__/ /_)/ | version: 2.5.1 / /_// (_) | (_) | | / ___/| | license: CC BY-NC 4.0 /___,' \___/ \___/|_| \/ |_| URL: Authors: Thomas Meissner Supporter: Phillip Munz Hermann Dötsch Dennis Häußler Hubert Nusser Michael Hauer Andreas Schwarz Max Rößler missing someone? -> sorry -> mail me 2021-03-21 08:47:02,815 [DEBUG] [doorpi.main] loaded with arguments: ['/usr/local/bin/doorpi_cli', '--debug', '--configfile', '/usr/local/etc/DoorPi/conf/doorpi.ini'] 2021-03-21 08:47:02,815 [DEBUG] [doorpi.doorpi] run 2021-03-21 08:47:02,815 [DEBUG] [doorpi.doorpi] prepare 2021-03-21 08:47:02,816 [DEBUG] [doorpi.doorpi] given arguments argv: Namespace(configfile='/usr/local/etc/DoorPi/conf/doorpi.ini', debug=True, test=False, trace=False) 2021-03-21 08:47:02,817 [INFO] [doorpi.conf.config_object] use configfile: /usr/local/etc/DoorPi/conf/doorpi.ini 2021-03-21 08:47:02,819 [DEBUG] [doorpi.conf.config_object] __init__ 2021-03-21 08:47:02,820 [TRACE] [doorpi.conf.config_object] get_from_config 2021-03-21 08:47:02,821 [TRACE] [doorpi.conf.config_object] get_string for key base_path in section DoorPi (default: /usr/local/etc/DoorPi) returns /usr/local/etc/DoorPi 2021-03-21 08:47:02,821 [TRACE] [doorpi.conf.config_object] get_string for key eventlog in section DoorPi (default: !BASEPATH!/conf/eventlog.db) returns !BASEPATH!/conf/eventlog.db 2021-03-21 08:47:02,822 [DEBUG] [doorpi.conf.config_object] parse string "!BASEPATH!/conf/eventlog.db" to "/usr/local/etc/DoorPi/conf/eventlog.db" 2021-03-21 08:47:02,828 [TRACE] [doorpi.action.handler] register Event BeforeStartup from doorpi.doorpi 2021-03-21 08:47:02,828 [DEBUG] [doorpi.action.handler] event_source doorpi.doorpi was added 2021-03-21 08:47:02,828 [TRACE] [doorpi.action.handler] added event_name BeforeStartup and registered source doorpi.doorpi 2021-03-21 08:47:02,829 [TRACE] [doorpi.action.handler] register Event OnStartup from doorpi.doorpi 2021-03-21 08:47:02,829 [TRACE] [doorpi.action.handler] added event_name OnStartup and registered source doorpi.doorpi 2021-03-21 08:47:02,829 [TRACE] [doorpi.action.handler] register Event AfterStartup from doorpi.doorpi 2021-03-21 08:47:02,829 [TRACE] [doorpi.action.handler] added event_name AfterStartup and registered source doorpi.doorpi 2021-03-21 08:47:02,830 [TRACE] [doorpi.action.handler] register Event BeforeShutdown from doorpi.doorpi 2021-03-21 08:47:02,830 [TRACE] [doorpi.action.handler] added event_name BeforeShutdown and registered source doorpi.doorpi 2021-03-21 08:47:02,830 [TRACE] [doorpi.action.handler] register Event OnShutdown from doorpi.doorpi 2021-03-21 08:47:02,830 [TRACE] [doorpi.action.handler] added event_name OnShutdown and registered source doorpi.doorpi 2021-03-21 08:47:02,831 [TRACE] [doorpi.action.handler] register Event AfterShutdown from doorpi.doorpi 2021-03-21 08:47:02,831 [TRACE] [doorpi.action.handler] added event_name AfterShutdown and registered source doorpi.doorpi 2021-03-21 08:47:02,832 [DEBUG] [doorpi.action.SingleActions.time_tick] doorpi.action.SingleActions.time_tick loaded 2021-03-21 08:47:02,833 [DEBUG] [doorpi.action.handler] event_source doorpi.action.SingleActions.time_tick was added 2021-03-21 08:47:02,834 [TRACE] [doorpi.action.handler] action TimeTickDestroyAction with args () and kwargs {} was added to new evententry OnShutdown 2021-03-21 08:47:02,835 [TRACE] [doorpi.action.handler] action TimeTickAction with args ('!last_tick!',) and kwargs {} was added to new evententry OnTimeTick 2021-03-21 08:47:02,835 [TRACE] [doorpi.conf.config_object] get_string for key ip in section DoorPiWeb (default: ) returns 2021-03-21 08:47:02,835 [TRACE] [doorpi.conf.config_object] get_integer for key port in section DoorPiWeb (default: 80) returns 80 2021-03-21 08:47:02,837 [INFO] [doorpi.status.webserver] Initiating WebService at ip and port 80 2021-03-21 08:47:02,838 [TRACE] [doorpi.action.handler] register Event OnWebServerStart from doorpi.status.webserver 2021-03-21 08:47:02,838 [DEBUG] [doorpi.action.handler] event_source doorpi.status.webserver was added 2021-03-21 08:47:02,838 [TRACE] [doorpi.action.handler] added event_name OnWebServerStart and registered source doorpi.status.webserver 2021-03-21 08:47:02,839 [TRACE] [doorpi.action.handler] register Event OnWebServerStop from doorpi.status.webserver 2021-03-21 08:47:02,839 [TRACE] [doorpi.action.handler] added event_name OnWebServerStop and registered source doorpi.status.webserver 2021-03-21 08:47:02,839 [TRACE] [doorpi.conf.config_object] get_string for key www in section DoorPiWeb (default: !BASEPATH!/../DoorPiWeb) returns !BASEPATH!/../DoorPiWeb 2021-03-21 08:47:02,840 [DEBUG] [doorpi.conf.config_object] parse string "!BASEPATH!/../DoorPiWeb" to "/usr/local/etc/DoorPi/../DoorPiWeb" 2021-03-21 08:47:02,840 [TRACE] [doorpi.conf.config_object] get_string for key indexfile in section DoorPiWeb (default: index.html) returns index.html 2021-03-21 08:47:02,841 [DEBUG] [doorpi.conf.config_object] parse string "index.html" to "index.html" 2021-03-21 08:47:02,841 [TRACE] [doorpi.conf.config_object] get_string for key loginfile in section DoorPiWeb (default: login.html) returns login.html 2021-03-21 08:47:02,842 [DEBUG] [doorpi.conf.config_object] parse string "login.html" to "login.html" 2021-03-21 08:47:02,843 [TRACE] [doorpi.conf.config_object] get_string for key public in section DoorPiWeb (default: AREA_public) returns AREA_public 2021-03-21 08:47:02,843 [DEBUG] [doorpi.conf.config_object] parse string "AREA_public" to "AREA_public" 2021-03-21 08:47:02,844 [TRACE] [doorpi.conf.config_object] get_string for key online_fallback in section DoorPiWeb (default: http://motom001.github.io/DoorPiWeb) returns http://motom001.github.io/DoorPiWeb 2021-03-21 08:47:02,844 [DEBUG] [doorpi.conf.config_object] parse string "http://motom001.github.io/DoorPiWeb" to "http://motom001.github.io/DoorPiWeb" 2021-03-21 08:47:02,845 [WARNING] [root] section WritePermission not found in configfile 2021-03-21 08:47:02,845 [TRACE] [doorpi.conf.config_object] get_keys for section WritePermission returns [] 2021-03-21 08:47:02,845 [WARNING] [root] section ReadPermission not found in configfile 2021-03-21 08:47:02,846 [TRACE] [doorpi.conf.config_object] get_keys for section ReadPermission returns [] 2021-03-21 08:47:02,846 [WARNING] [root] section Group not found in configfile 2021-03-21 08:47:02,846 [TRACE] [doorpi.conf.config_object] get_keys for section Group returns [] 2021-03-21 08:47:02,846 [WARNING] [root] section User not found in configfile 2021-03-21 08:47:02,847 [TRACE] [doorpi.conf.config_object] get_keys for section User returns [] 2021-03-21 08:47:02,847 [TRACE] [doorpi.conf.config_object] get_sections returns ['DoorPiWeb', 'keyboards', 'EVENT_OnStartup', 'SIP-Phone', 'DoorPi'] 2021-03-21 08:47:02,847 [ERROR] [doorpi.status.webserver] no ReadPermission found 2021-03-21 08:47:02,848 [ERROR] [doorpi.status.webserver] no groups in configfile! 2021-03-21 08:47:02,848 [ERROR] [doorpi.status.webserver] no WritePermission found 2021-03-21 08:47:02,848 [TRACE] [doorpi.action.handler] action WebServerStartupAction with args () and kwargs {} was added to new evententry OnWebServerStart 2021-03-21 08:47:02,848 [TRACE] [doorpi.action.handler] action WebServerShutdownAction with args () and kwargs {} was added to event OnShutdown 2021-03-21 08:47:02,849 [TRACE] [doorpi.action.handler] fire Event OnWebServerStart from doorpi.status.webserver asyncron 2021-03-21 08:47:02,850 [TRACE] [doorpi.action.handler] register Event OnWebServerRequest from doorpi.status.webserver_lib.request_handler 2021-03-21 08:47:02,850 [DEBUG] [doorpi.action.handler] event_source doorpi.status.webserver_lib.request_handler was added 2021-03-21 08:47:02,851 [TRACE] [doorpi.action.handler] added event_name OnWebServerRequest and registered source doorpi.status.webserver_lib.request_handler 2021-03-21 08:47:02,851 [DEBUG] [doorpi.action.handler] [KM49OI] fire for event OnWebServerStart this actions [] 2021-03-21 08:47:02,851 [TRACE] [doorpi.action.handler] register Event OnWebServerRequestGet from doorpi.status.webserver_lib.request_handler 2021-03-21 08:47:02,852 [TRACE] [doorpi.action.handler] [KM49OI] try to fire action WebServerStartupAction with args () and kwargs {} 2021-03-21 08:47:02,852 [TRACE] [doorpi.action.handler] added event_name OnWebServerRequestGet and registered source doorpi.status.webserver_lib.request_handler 2021-03-21 08:47:02,852 [TRACE] [doorpi.action.base] run WebServerStartupAction with args () and kwargs {} 2021-03-21 08:47:02,853 [TRACE] [doorpi.action.handler] register Event OnWebServerRequestPost from doorpi.status.webserver_lib.request_handler 2021-03-21 08:47:02,853 [TRACE] [doorpi.action.handler] added event_name OnWebServerRequestPost and registered source doorpi.status.webserver_lib.request_handler 2021-03-21 08:47:02,854 [TRACE] [doorpi.action.handler] register Event OnWebServerVirtualResource from doorpi.status.webserver_lib.request_handler 2021-03-21 08:47:02,854 [TRACE] [doorpi.action.handler] added event_name OnWebServerVirtualResource and registered source doorpi.status.webserver_lib.request_handler 2021-03-21 08:47:02,854 [TRACE] [doorpi.action.handler] register Event OnWebServerRealResource from doorpi.status.webserver_lib.request_handler 2021-03-21 08:47:02,855 [TRACE] [doorpi.action.handler] added event_name OnWebServerRealResource and registered source doorpi.status.webserver_lib.request_handler 2021-03-21 08:47:02,855 [TRACE] [doorpi.action.handler] register Event OnFireEvent from doorpi.status.webserver_lib.request_handler 2021-03-21 08:47:02,855 [TRACE] [doorpi.action.handler] added event_name OnFireEvent and registered source doorpi.status.webserver_lib.request_handler 2021-03-21 08:47:02,855 [TRACE] [doorpi.action.handler] register Event OnConfigKeySet from doorpi.status.webserver_lib.request_handler 2021-03-21 08:47:02,856 [TRACE] [doorpi.action.handler] added event_name OnConfigKeySet and registered source doorpi.status.webserver_lib.request_handler 2021-03-21 08:47:02,856 [TRACE] [doorpi.action.handler] register Event OnConfigKeyDelete from doorpi.status.webserver_lib.request_handler 2021-03-21 08:47:02,856 [TRACE] [doorpi.action.handler] added event_name OnConfigKeyDelete and registered source doorpi.status.webserver_lib.request_handler 2021-03-21 08:47:02,856 [TRACE] [doorpi.conf.config_object] get_keys for section keyboards returns ['dummy'] 2021-03-21 08:47:02,857 [INFO] [doorpi.keyboard.KeyboardInterface] using multi-keyboard mode (keyboards: dummy) 2021-03-21 08:47:02,857 [INFO] [doorpi.keyboard.KeyboardInterface] trying to add keyboard 'dummy' to handler 2021-03-21 08:47:02,857 [TRACE] [doorpi.conf.config_object] get_string for key dummy in section keyboards (default: dummy) returns dummy 2021-03-21 08:47:02,858 [WARNING] [root] section dummy_InputPins not found in configfile 2021-03-21 08:47:02,858 [TRACE] [doorpi.conf.config_object] get_keys for section dummy_InputPins returns [] 2021-03-21 08:47:02,858 [WARNING] [root] section dummy_OutputPins not found in configfile 2021-03-21 08:47:02,859 [TRACE] [doorpi.conf.config_object] get_keys for section dummy_OutputPins returns [] 2021-03-21 08:47:02,859 [TRACE] [doorpi.conf.config_object] get_integer for key bouncetime in section dummy_keyboard (default: 2000) returns 2000.0 2021-03-21 08:47:02,859 [TRACE] [doorpi.conf.config_object] get_integer for key polarity in section dummy_keyboard (default: 0) returns 0 2021-03-21 08:47:02,860 [TRACE] [doorpi.conf.config_object] get_boolean for key pressed_on_keydown in section dummy_keyboard (default: True) returns True 2021-03-21 08:47:02,860 [DEBUG] [doorpi.keyboard.from_dummy] doorpi.keyboard.from_dummy loaded 2021-03-21 08:47:02,861 [DEBUG] [doorpi.keyboard.from_dummy] __init__(input_pins = [], output_pins = [], bouncetime = 2000.0, polarity = 0) 2021-03-21 08:47:02,861 [WARNING] [root] section dummy_InputPins not found in configfile 2021-03-21 08:47:02,862 [TRACE] [doorpi.conf.config_object] get_keys for section dummy_InputPins returns [] 2021-03-21 08:47:02,862 [WARNING] [root] section dummy_OutputPins not found in configfile 2021-03-21 08:47:02,862 [TRACE] [doorpi.conf.config_object] get_keys for section dummy_OutputPins returns [] 2021-03-21 08:47:02,863 [TRACE] [doorpi.action.handler] action KeyboardDestroyAction with args () and kwargs {} was added to event OnShutdown 2021-03-21 08:47:02,863 [WARNING] [root] section dummy_OutputPins not found in configfile 2021-03-21 08:47:02,863 [TRACE] [doorpi.conf.config_object] get_keys for section dummy_OutputPins returns [] 2021-03-21 08:47:02,864 [DEBUG] [doorpi.status.status_lib.environment] doorpi.status.status_lib.environment loaded 2021-03-21 08:47:02,866 [DEBUG] [doorpi.status.requirements_lib.req_config] doorpi.status.requirements_lib.req_config loaded 2021-03-21 08:47:02,867 [DEBUG] [doorpi.status.requirements_lib.req_sipphone] doorpi.status.requirements_lib.req_sipphone loaded 2021-03-21 08:47:02,868 [DEBUG] [doorpi.sipphone.AbstractBaseClass] doorpi.sipphone.AbstractBaseClass loaded 2021-03-21 08:47:02,896 [DEBUG] [doorpi.status.requirements_lib.req_event_handler] doorpi.status.requirements_lib.req_event_handler loaded 2021-03-21 08:47:02,897 [DEBUG] [doorpi.status.requirements_lib.req_webserver] doorpi.status.requirements_lib.req_webserver loaded 2021-03-21 08:47:02,899 [DEBUG] [doorpi.status.requirements_lib.req_keyboard] doorpi.status.requirements_lib.req_keyboard loaded 2021-03-21 08:47:02,941 [DEBUG] [doorpi.status.requirements_lib.req_system] doorpi.status.requirements_lib.req_system loaded 2021-03-21 08:47:02,944 [INFO] [doorpi.sipphone.SipphoneInterface] found installed sipphone "linphone" and use this as default 2021-03-21 08:47:02,945 [TRACE] [doorpi.conf.config_object] get_string for key sipphonetyp in section SIP-Phone (default: linphone) returns dummy 2021-03-21 08:47:02,946 [DEBUG] [doorpi.sipphone.from_dummy] doorpi.sipphone.from_dummy loaded 2021-03-21 08:47:02,947 [WARNING] [doorpi.sipphone.from_dummy] No sipphone in config - use dummy sipphone without functionality 2021-03-21 08:47:02,948 [DEBUG] [doorpi.sipphone.from_dummy] __init__ 2021-03-21 08:47:02,948 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to event OnShutdown 2021-03-21 08:47:02,948 [TRACE] [doorpi.action.handler] register Event OnSipPhoneCreate from doorpi.sipphone.from_dummy 2021-03-21 08:47:02,949 [DEBUG] [doorpi.action.handler] event_source doorpi.sipphone.from_dummy was added 2021-03-21 08:47:02,949 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneCreate and registered source doorpi.sipphone.from_dummy 2021-03-21 08:47:02,949 [TRACE] [doorpi.action.handler] register Event OnSipPhoneStart from doorpi.sipphone.from_dummy 2021-03-21 08:47:02,950 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneStart and registered source doorpi.sipphone.from_dummy 2021-03-21 08:47:02,950 [TRACE] [doorpi.action.handler] register Event OnSipPhoneDestroy from doorpi.sipphone.from_dummy 2021-03-21 08:47:02,950 [TRACE] [doorpi.action.handler] added event_name OnSipPhoneDestroy and registered source doorpi.sipphone.from_dummy 2021-03-21 08:47:02,951 [TRACE] [doorpi.action.handler] action > with args () and kwargs {} was added to new evententry OnSipPhoneDestroy 2021-03-21 08:47:02,951 [TRACE] [doorpi.action.handler] register Event OnRecorderStarted from doorpi.sipphone.from_dummy 2021-03-21 08:47:02,951 [TRACE] [doorpi.action.handler] added event_name OnRecorderStarted and registered source doorpi.sipphone.from_dummy 2021-03-21 08:47:02,951 [TRACE] [doorpi.action.handler] register Event OnRecorderStopped from doorpi.sipphone.from_dummy 2021-03-21 08:47:02,952 [TRACE] [doorpi.action.handler] added event_name OnRecorderStopped and registered source doorpi.sipphone.from_dummy 2021-03-21 08:47:02,952 [TRACE] [doorpi.action.handler] register Event OnRecorderCreated from doorpi.sipphone.from_dummy 2021-03-21 08:47:02,952 [TRACE] [doorpi.action.handler] added event_name OnRecorderCreated and registered source doorpi.sipphone.from_dummy 2021-03-21 08:47:02,953 [TRACE] [doorpi.action.handler] fire Event OnRecorderCreated from doorpi.sipphone.from_dummy asyncron 2021-03-21 08:47:02,954 [TRACE] [doorpi.action.handler] fire Event OnSipPhoneCreate from doorpi.sipphone.from_dummy asyncron 2021-03-21 08:47:02,955 [DEBUG] [doorpi.action.handler] no actions for event OnRecorderCreated - skip fire_event OnRecorderCreated from doorpi.sipphone.from_dummy 2021-03-21 08:47:02,956 [TRACE] [doorpi.action.handler] fire Event OnSipPhoneStart from doorpi.sipphone.from_dummy asyncron 2021-03-21 08:47:02,957 [TRACE] [doorpi.conf.config_object] get_sections returns ['EVENT_OnStartup'] 2021-03-21 08:47:02,957 [DEBUG] [doorpi.action.handler] no actions for event OnSipPhoneCreate - skip fire_event OnSipPhoneCreate from doorpi.sipphone.from_dummy 2021-03-21 08:47:02,958 [INFO] [doorpi.doorpi] found EVENT_ section 'EVENT_OnStartup' in configfile 2021-03-21 08:47:02,958 [DEBUG] [doorpi.action.handler] no actions for event OnSipPhoneStart - skip fire_event OnSipPhoneStart from doorpi.sipphone.from_dummy 2021-03-21 08:47:02,958 [TRACE] [doorpi.conf.config_object] get_keys for section EVENT_OnStartup returns ['10'] 2021-03-21 08:47:02,959 [INFO] [doorpi.doorpi] registering action '10' for event 'OnStartup' 2021-03-21 08:47:02,960 [TRACE] [doorpi.conf.config_object] get_string for key 10 in section EVENT_OnStartup (default: ) returns sleep:1 2021-03-21 08:47:02,960 [DEBUG] [doorpi.action.SingleActions.sleep] doorpi.action.SingleActions.sleep loaded 2021-03-21 08:47:02,961 [TRACE] [doorpi.action.handler] action SleepAction with args (1.0,) and kwargs {} was added to new evententry OnStartup 2021-03-21 08:47:02,961 [WARNING] [root] section dummy_InputPins not found in configfile 2021-03-21 08:47:02,962 [WARNING] [root] section DTMF not found in configfile 2021-03-21 08:47:02,962 [TRACE] [doorpi.conf.config_object] get_keys for section DTMF returns [] 2021-03-21 08:47:02,962 [TRACE] [doorpi.conf.config_object] get_string for key is_alive_led in section DoorPi (default: ) returns 2021-03-21 08:47:02,963 [TRACE] [doorpi.action.handler] fire Event BeforeStartup from doorpi.doorpi asyncron 2021-03-21 08:47:02,964 [DEBUG] [doorpi.action.handler] [CRJ2BD] fire for event OnStartup this actions [] 2021-03-21 08:47:02,964 [TRACE] [doorpi.action.handler] [CRJ2BD] try to fire action SleepAction with args (1.0,) and kwargs {} 2021-03-21 08:47:02,964 [DEBUG] [doorpi.action.handler] no actions for event BeforeStartup - skip fire_event BeforeStartup from doorpi.doorpi 2021-03-21 08:47:02,965 [TRACE] [doorpi.action.base] run SleepAction with args (1.0,) and kwargs {} 2021-03-21 08:47:03,967 [TRACE] [doorpi.action.handler] [CRJ2BD] finished fire_event for event_name OnStartup 2021-03-21 08:47:03,968 [TRACE] [doorpi.action.handler] fire Event AfterStartup from doorpi.doorpi asyncron 2021-03-21 08:47:03,970 [INFO] [doorpi.doorpi] DoorPi started successfully 2021-03-21 08:47:03,971 [INFO] [doorpi.doorpi] BasePath is /usr/local/etc/DoorPi 2021-03-21 08:47:03,971 [DEBUG] [doorpi.action.handler] no actions for event AfterStartup - skip fire_event AfterStartup from doorpi.doorpi 2021-03-21 08:47:03,972 [INFO] [doorpi.doorpi] Weburl is http://raspberrypi/