2015-01-31 17:33:59,641 [INFO] [__main__] loaded with arguments: ['/home/pi/DoorPI/doorpi/main.py', 'start', '--configfile', '/home/pi/DoorPI/conf/doorpi.cfg']
2015-01-31 17:34:00,141 [DEBUG] [doorpi] run
2015-01-31 17:34:00,145 [DEBUG] [doorpi] prepare
2015-01-31 17:34:00,148 [DEBUG] [doorpi] givven arguments argv: Namespace(configfile=<open file '/home/pi/DoorPI/conf/doorpi.cfg', mode 'r' at 0xb66e6498>)
2015-01-31 17:34:00,153 [DEBUG] [conf.config_object] load_config (<open file '/home/pi/DoorPI/conf/doorpi.cfg', mode 'r' at 0xb66e6498>)
2015-01-31 17:34:00,156 [DEBUG] [conf.config_object] use configfile: /home/pi/DoorPI/conf/doorpi.cfg
2015-01-31 17:34:00,182 [DEBUG] [conf.config_object] __init__
2015-01-31 17:34:00,185 [TRACE] [conf.config_object] get_from_config
2015-01-31 17:34:00,200 [TRACE] [conf.config_object] get for key typ in section keyboard (default: autodetect)
2015-01-31 17:34:00,203 [TRACE] [conf.config_object] get_string for key typ in section keyboard (default: autodetect)
2015-01-31 17:34:00,206 [TRACE] [conf.config_object] key 'typ' exist in section 'keyboard' with value 'gpio'
2015-01-31 17:34:00,210 [TRACE] [conf.config_object] get_int for key bouncetime in section keyboard (default: 5000)
2015-01-31 17:34:00,213 [TRACE] [conf.config_object] get_string for key bouncetime in section keyboard (default: )
2015-01-31 17:34:00,216 [TRACE] [conf.config_object] key 'bouncetime' doesn't exist in section 'keyboard'
2015-01-31 17:34:00,219 [TRACE] [conf.config_object] return default '
2015-01-31 17:34:00,222 [TRACE] [conf.config_object] get_keys for section InputPins
2015-01-31 17:34:00,225 [TRACE] [conf.config_object] get_keys for section OutputPins
2015-01-31 17:34:00,228 [TRACE] [keyboard.KeyboardInterface] load_gpio
2015-01-31 17:34:00,235 [DEBUG] [keyboard.from_gpio] keyboard.from_gpio loaded
2015-01-31 17:34:00,246 [DEBUG] [keyboard.AbstractBaseClass] keyboard.AbstractBaseClass loaded
2015-01-31 17:34:00,251 [DEBUG] [keyboard.from_gpio] GPIO.__init__(input_pins = ['11', '13'], output_pins = ['18', '12', '16'])
2015-01-31 17:34:00,255 [TRACE] [action.handler] register Event OnKeyPressed from keyboard.from_gpio
2015-01-31 17:34:00,258 [DEBUG] [action.handler] event_source keyboard.from_gpio was added
2015-01-31 17:34:00,261 [TRACE] [action.handler] added event_name OnKeyPressed an register source keyboard.from_gpio
2015-01-31 17:34:00,270 [TRACE] [action.handler] register Event OnKeyPressed_11 from keyboard.from_gpio
2015-01-31 17:34:00,283 [TRACE] [action.handler] added event_name OnKeyPressed_11 an register source keyboard.from_gpio
2015-01-31 17:34:00,288 [TRACE] [action.handler] register Event OnKeyPressed_13 from keyboard.from_gpio
2015-01-31 17:34:00,295 [TRACE] [action.handler] added event_name OnKeyPressed_13 an register source keyboard.from_gpio
2015-01-31 17:34:00,300 [DEBUG] [doorpi] Keyboard is now GPIO Keyboard
2015-01-31 17:34:00,425 [DEBUG] [sipphone.by_pjsua] sipphone.by_pjsua loaded
2015-01-31 17:34:00,474 [DEBUG] [sipphone.pjsua_lib.SipPhoneAccountCallBack] sipphone.pjsua_lib.SipPhoneAccountCallBack loaded
2015-01-31 17:34:00,480 [DEBUG] [sipphone.pjsua_lib.SipPhoneCallCallBack] sipphone.pjsua_lib.SipPhoneCallCallBack loaded
2015-01-31 17:34:00,497 [TRACE] [conf.config_object] get for key record_while_dialing in section DoorPi (default: False)
2015-01-31 17:34:00,500 [TRACE] [conf.config_object] get_string for key record_while_dialing in section DoorPi (default: False)
2015-01-31 17:34:00,517 [TRACE] [conf.config_object] key 'record_while_dialing' exist in section 'DoorPi' with value 'true'
2015-01-31 17:34:00,520 [DEBUG] [sipphone.by_pjsua] __init__
2015-01-31 17:34:00,533 [TRACE] [action.handler] register Event OnSipPhoneCreate from sipphone.by_pjsua
2015-01-31 17:34:00,537 [DEBUG] [action.handler] event_source sipphone.by_pjsua was added
2015-01-31 17:34:00,540 [TRACE] [action.handler] added event_name OnSipPhoneCreate an register source sipphone.by_pjsua
2015-01-31 17:34:00,553 [TRACE] [action.handler] register Event OnSipPhoneStart from sipphone.by_pjsua
2015-01-31 17:34:00,556 [TRACE] [action.handler] added event_name OnSipPhoneStart an register source sipphone.by_pjsua
2015-01-31 17:34:00,559 [TRACE] [action.handler] register Event OnSipPhoneDestroy from sipphone.by_pjsua
2015-01-31 17:34:00,573 [TRACE] [action.handler] added event_name OnSipPhoneDestroy an register source sipphone.by_pjsua
2015-01-31 17:34:00,576 [TRACE] [action.handler] register Event OnSipPhoneRecorderCreate from sipphone.by_pjsua
2015-01-31 17:34:00,579 [TRACE] [action.handler] added event_name OnSipPhoneRecorderCreate an register source sipphone.by_pjsua
2015-01-31 17:34:00,582 [TRACE] [action.handler] register Event OnSipPhoneRecorderDestroy from sipphone.by_pjsua
2015-01-31 17:34:00,596 [TRACE] [action.handler] added event_name OnSipPhoneRecorderDestroy an register source sipphone.by_pjsua
2015-01-31 17:34:00,599 [TRACE] [action.handler] register Event OnSipPhoneMakeCall from sipphone.by_pjsua
2015-01-31 17:34:00,602 [TRACE] [action.handler] added event_name OnSipPhoneMakeCall an register source sipphone.by_pjsua
2015-01-31 17:34:00,618 [DEBUG] [action.SingleActions.sleep] action.SingleActions.sleep loaded
2015-01-31 17:34:00,633 [TRACE] [action.handler] action SleepAction with args (0.5,) and kwargs {} was added to new evententry AfterCallStateDisconnect
2015-01-31 17:34:00,637 [TRACE] [action.handler] action <bound method Pjsua.cleanup_after_call of <sipphone.by_pjsua.Pjsua instance at 0xb5dfae90>> with args () and kwargs {} was added to event AfterCallStateDisconnect
2015-01-31 17:34:00,641 [TRACE] [action.handler] fire Event OnSipPhoneCreate from sipphone.by_pjsua asyncron
2015-01-31 17:34:00,683 [DEBUG] [action.handler] no actions for event OnSipPhoneCreate - skip fire_event OnSipPhoneCreate from sipphone.by_pjsua
2015-01-31 17:34:00,667 [DEBUG] [sipphone.by_pjsua] init Lib
2015-01-31 17:34:00,689 [DEBUG] [sipphone.by_pjsua] CreateUAConfig
2015-01-31 17:34:00,692 [DEBUG] [sipphone.by_pjsua] CreateMediaConfig
2015-01-31 17:34:00,698 [DEBUG] [sipphone.by_pjsua] CreateLogConfig
2015-01-31 17:34:01,044 [DEBUG] [sipphone.by_pjsua] init transport
2015-01-31 17:34:01,047 [DEBUG] [sipphone.by_pjsua] CreateTransportConfig
2015-01-31 17:34:01,054 [DEBUG] [sipphone.by_pjsua] Lib.start()
2015-01-31 17:34:01,058 [DEBUG] [sipphone.by_pjsua] init Acc
2015-01-31 17:34:01,061 [DEBUG] [sipphone.by_pjsua] CreateAccountConfig
2015-01-31 17:34:01,066 [TRACE] [conf.config_object] get for key server in section SIP-Phone (default: )
2015-01-31 17:34:01,070 [TRACE] [conf.config_object] get_string for key server in section SIP-Phone (default: )
2015-01-31 17:34:01,073 [TRACE] [conf.config_object] key 'server' exist in section 'SIP-Phone' with value '192.168.10.1'
2015-01-31 17:34:01,076 [TRACE] [conf.config_object] get for key username in section SIP-Phone (default: )
2015-01-31 17:34:01,079 [TRACE] [conf.config_object] get_string for key username in section SIP-Phone (default: )
2015-01-31 17:34:01,083 [TRACE] [conf.config_object] key 'username' exist in section 'SIP-Phone' with value '621'
2015-01-31 17:34:01,086 [TRACE] [conf.config_object] get for key password in section SIP-Phone (default: )
2015-01-31 17:34:01,089 [TRACE] [conf.config_object] get_string for key password in section SIP-Phone (default: )
2015-01-31 17:34:01,092 [TRACE] [conf.config_object] key 'password' exist in section 'SIP-Phone' with value '*******'
2015-01-31 17:34:01,095 [TRACE] [conf.config_object] get for key realm in section SIP-Phone (default: )
2015-01-31 17:34:01,098 [TRACE] [conf.config_object] get_string for key realm in section SIP-Phone (default: )
2015-01-31 17:34:01,101 [TRACE] [conf.config_object] key 'realm' exist in section 'SIP-Phone' with value 'fritz.box'
2015-01-31 17:34:01,104 [INFO] [sipphone.by_pjsua] try to create AccountConfig
2015-01-31 17:34:01,107 [DEBUG] [sipphone.by_pjsua] username: 621
2015-01-31 17:34:01,111 [DEBUG] [sipphone.by_pjsua] password: ******
2015-01-31 17:34:01,114 [DEBUG] [sipphone.by_pjsua] server: 192.168.10.1
2015-01-31 17:34:01,119 [DEBUG] [sipphone.by_pjsua] realm: fritz.box
2015-01-31 17:34:01,122 [DEBUG] [sipphone.pjsua_lib.SipPhoneAccountCallBack] __init__
2015-01-31 17:34:01,126 [TRACE] [action.handler] register Event BeforeCallIncoming from sipphone.pjsua_lib.SipPhoneAccountCallBack
2015-01-31 17:34:01,129 [DEBUG] [action.handler] event_source sipphone.pjsua_lib.SipPhoneAccountCallBack was added
2015-01-31 17:34:01,132 [TRACE] [action.handler] added event_name BeforeCallIncoming an register source sipphone.pjsua_lib.SipPhoneAccountCallBack
2015-01-31 17:34:01,141 [TRACE] [action.handler] register Event OnCallReconnect from sipphone.pjsua_lib.SipPhoneAccountCallBack
2015-01-31 17:34:01,145 [TRACE] [action.handler] added event_name OnCallReconnect an register source sipphone.pjsua_lib.SipPhoneAccountCallBack
2015-01-31 17:34:01,148 [TRACE] [action.handler] register Event AfterCallReconnect from sipphone.pjsua_lib.SipPhoneAccountCallBack
2015-01-31 17:34:01,151 [TRACE] [action.handler] added event_name AfterCallReconnect an register source sipphone.pjsua_lib.SipPhoneAccountCallBack
2015-01-31 17:34:01,155 [TRACE] [action.handler] register Event OnCallBusy from sipphone.pjsua_lib.SipPhoneAccountCallBack
2015-01-31 17:34:01,158 [TRACE] [action.handler] added event_name OnCallBusy an register source sipphone.pjsua_lib.SipPhoneAccountCallBack
2015-01-31 17:34:01,161 [TRACE] [action.handler] register Event AfterCallBusy from sipphone.pjsua_lib.SipPhoneAccountCallBack
2015-01-31 17:34:01,164 [TRACE] [action.handler] added event_name AfterCallBusy an register source sipphone.pjsua_lib.SipPhoneAccountCallBack
2015-01-31 17:34:01,169 [TRACE] [action.handler] register Event OnCallIncomming from sipphone.pjsua_lib.SipPhoneAccountCallBack
2015-01-31 17:34:01,172 [TRACE] [action.handler] added event_name OnCallIncomming an register source sipphone.pjsua_lib.SipPhoneAccountCallBack
2015-01-31 17:34:01,175 [TRACE] [action.handler] register Event AfterCallIncomming from sipphone.pjsua_lib.SipPhoneAccountCallBack
2015-01-31 17:34:01,178 [TRACE] [action.handler] added event_name AfterCallIncomming an register source sipphone.pjsua_lib.SipPhoneAccountCallBack
2015-01-31 17:34:01,182 [TRACE] [action.handler] register Event OnCallReject from sipphone.pjsua_lib.SipPhoneAccountCallBack
2015-01-31 17:34:01,185 [TRACE] [action.handler] added event_name OnCallReject an register source sipphone.pjsua_lib.SipPhoneAccountCallBack
2015-01-31 17:34:01,188 [TRACE] [action.handler] register Event AfterCallReject from sipphone.pjsua_lib.SipPhoneAccountCallBack
2015-01-31 17:34:01,191 [TRACE] [action.handler] added event_name AfterCallReject an register source sipphone.pjsua_lib.SipPhoneAccountCallBack
2015-01-31 17:34:01,198 [DEBUG] [sipphone.by_pjsua] Listening on: 192.168.10.176
2015-01-31 17:34:01,202 [DEBUG] [sipphone.by_pjsua] Port: 53879
2015-01-31 17:34:01,205 [TRACE] [conf.config_object] get for key dialtone in section DoorPi (default: )
2015-01-31 17:34:01,208 [TRACE] [conf.config_object] get_string for key dialtone in section DoorPi (default: )
2015-01-31 17:34:01,212 [TRACE] [conf.config_object] key 'dialtone' exist in section 'DoorPi' with value '!BASEPATH!/doorpi/media/ShortDialTone.wav'
2015-01-31 17:34:01,215 [DEBUG] [sipphone.by_pjsua] dialtone is missing or not readable - create it now