This is what’s happening on the phone log of the phone that i pressed the BLF key on in an attempt to do direct pickup:
[12-07 08:49:31 50:0f:36] >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
[12-07 08:49:49 50:0f:36] SIP: aid 0, cid 0, tid 4500, did 12, REQUEST: NOTIFY, Event: 43
[12-07 08:49:49 50:0f:36] SIP: aid 0, cid 0, tid 4501, did 10, REQUEST: NOTIFY, Event: 43
[12-07 08:49:50 50:0f:36] BSP: SetLineLedStatus line 4, error flag 0x2
[12-07 08:49:51 50:0f:36] Dial LINE_5
[12-07 08:49:51 50:0f:36] line Key 5 ==>
[12-07 08:49:51 50:0f:36] GUI: LCM_DSS_LINE_KEY
[12-07 08:49:51 50:0f:36] GUI:rcv line key 4
[12-07 08:49:51 50:0f:36] GUI:Send line key event:4
[12-07 08:49:51 50:0f:36] DSS_SOFT_LINE_KEY_EVENT Key 5 ==>
[12-07 08:49:51 50:0f:36] DSS_BLF
[12-07 08:49:51 50:0f:36] L2C: Aid 0 Dial Plan matching…, digits 5
[12-07 08:49:51 50:0f:36] L2C: Aid 0 Dial Plan matching…, digits 59
[12-07 08:49:51 50:0f:36] L2C: Dial Plan matched, old_digits 591, new_digits 591
[12-07 08:49:51 50:0f:36] L2DtmfPreMatchedPlanProc…
[12-07 08:49:51 50:0f:36] L2DtmfPreMatchedPlanProc, Call-Out Number Change to 591
[12-07 08:49:51 50:0f:36] CALL: State=0x60, Event=0x1070, Chn=0
[12-07 08:49:51 50:0f:36] XPhoneDtmfSpeedDialPro:5253###===>>>KeyNo=4,Chn=0,Number=591,Len=3
[12-07 08:49:51 50:0f:36] CallCtl: SendEvent2Lcm: aid 0, Line: 0, event 0x8d7
[12-07 08:49:51 50:0f:36] ReDialInfo: aid 0, line 0, Number 591
[12-07 08:49:51 50:0f:36] SIP: sdp_message_pro: Local IP is 172.18.67.81
[12-07 08:49:51 50:0f:36] SIP: SendInvite to 591, cid 50, wIP 0xac124351, port 12100, Interval 2, Codec 0, Audio 0
[12-07 08:49:51 50:0f:36] CALL: State=0x62, Event=0x201, Chn=0
[12-07 08:49:51 50:0f:36] SIP: aid 0, cid 50, tid 4502, did 0, REQUEST: INVITE, Event: 12
[12-07 08:49:51 50:0f:36] SIP: aid 0, cid 50, tid 4502, did 0, RESPONSE: 401 Unauthorized, 4xx received for Call!, Event: 12
[12-07 08:49:51 50:0f:36] SIP: find_authentication_info, aid 0, username: 583, realm: “asterisk”
[12-07 08:49:51 50:0f:36] SIP: find_auth_info, aid 0, username: 583, account match
[12-07 08:49:51 50:0f:36] SIP: aid 0, cid 50, tid 4503, did 0, REQUEST: INVITE, Event: 8
[12-07 08:49:51 50:0f:36] SIP: aid 0, cid 50, tid 4503, did 0, RESPONSE: 100 Trying, Call is being processed!, Event: 8
[12-07 08:49:51 50:0f:36] GUI: CALL_OUTGOING, Index:0
[12-07 08:49:51 50:0f:36] Ti3100:HANDFREE mode
[12-07 08:49:51 50:0f:36] BSP: OpenSpeaker SpkVolume 8 MicVolum 8
[12-07 08:49:51 50:0f:36] GUI: MSG_PAINT
[12-07 08:49:51 50:0f:36] SIP: aid 0, cid 50, tid 4503, did 0, REQUEST: INVITE, Event: 12
[12-07 08:49:51 50:0f:36] SIP: aid 0, cid 50, tid 4503, did 0, RESPONSE: 486 Busy Here, 4xx received for Call!, Event: 12
[12-07 08:49:51 50:0f:36] SIP: ActionUrlCall, can’t get call_dialog!!!
[12-07 08:49:51 50:0f:36] SIP: ActionUrlPro active_url sip:[email protected]:5060
[12-07 08:49:51 50:0f:36] SIP: Send CALL_FAILURE (486 Busy Here) to LCM
[12-07 08:49:51 50:0f:36] SIP: aid 0 recv 486, Busy Here
[12-07 08:49:51 50:0f:36] CALL: State=0x62, Event=0x306, Chn=0
[12-07 08:49:51 50:0f:36] XPhoneRelPro:20845######===>>>Line 0 LineState 0x62…
[12-07 08:49:51 50:0f:36] CALL:20858========Play Busy Tone and SET timer========
This is what i expect to happen:
[12-07 09:13:40 50:0f:36] BSP: SetLineLedStatus line 4, error flag 0x2
[12-07 09:13:40 50:0f:36] Dial LINE_5
[12-07 09:13:40 50:0f:36] line Key 5 ==>
[12-07 09:13:40 50:0f:36] GUI: LCM_DSS_LINE_KEY
[12-07 09:13:40 50:0f:36] GUI:rcv line key 4
[12-07 09:13:40 50:0f:36] GUI:Send line key event:4
[12-07 09:13:40 50:0f:36] DSS_SOFT_LINE_KEY_EVENT Key 5 ==>
[12-07 09:13:40 50:0f:36] DSS_BLF
[12-07 09:13:40 50:0f:36] L2C: Aid 0 Dial Plan matching…, digits 5
[12-07 09:13:40 50:0f:36] L2C: Aid 0 Dial Plan matching…, digits 59
[12-07 09:13:40 50:0f:36] L2C: Aid 0 Dial Plan matching…, digits 591
[12-07 09:13:40 50:0f:36] CALL: State=0x60, Event=0x1b2, Chn=0
[12-07 09:13:40 50:0f:36] CallCtl: SendEvent2Lcm: aid 0, Line: 0, event 0x8d7
[12-07 09:13:40 50:0f:36] ReDialInfo: aid 0, line 0, Number **591
[12-07 09:13:40 50:0f:36] SIP: sdp_message_pro: Local IP is 172.18.67.81
[12-07 09:13:40 50:0f:36] SIP: SendInvite to **591, cid 55, wIP 0xac124351, port 12100, Interval 2, Codec 0, Audio 0
[12-07 09:13:40 50:0f:36] CALL: State=0x62, Event=0x201, Chn=0
[12-07 09:13:40 50:0f:36] SIP: aid 0, cid 55, tid 4610, did 0, REQUEST: INVITE, Event: 12
[12-07 09:13:40 50:0f:36] SIP: aid 0, cid 55, tid 4610, did 0, RESPONSE: 401 Unauthorized, 4xx received for Call!, Event: 12
[12-07 09:13:40 50:0f:36] SIP: find_authentication_info, aid 0, username: 583, realm: “asterisk”
[12-07 09:13:40 50:0f:36] SIP: find_auth_info, aid 0, username: 583, account match
[12-07 09:13:40 50:0f:36] SIP: aid 0, cid 55, tid 4611, did 0, REQUEST: INVITE, Event: 8
[12-07 09:13:40 50:0f:36] SIP: aid 0, cid 55, tid 4611, did 0, RESPONSE: 100 Trying, Call is being processed!, Event: 8
[12-07 09:13:40 50:0f:36] GUI: CALL_OUTGOING, Index:0
[12-07 09:13:40 50:0f:36] Ti3100:HANDFREE mode
[12-07 09:13:40 50:0f:36] BSP: OpenSpeaker SpkVolume 8 MicVolum 8
[12-07 09:13:40 50:0f:36] SIP: aid 0, cid 0, tid 4612, did 11, REQUEST: NOTIFY, Event: 43
[12-07 09:13:40 50:0f:36] SIP: aid 0, cid 55, tid 4611, did 56, REQUEST: INVITE, Event: 10
[12-07 09:13:40 50:0f:36] SIP: aid 0, cid 55, tid 4611, did 56, RESPONSE: 200 OK, Remote phone has answered!, Event: 10