sh logg Syslog logging: enabled (0 messages dropped, 10 messages rate-limited, 8 flushes, 0 overruns, xml disabled, filtering disabled) No Active Message Discriminator. No Inactive Message Discriminator. Console logging: level debugging, 12905 messages logged, xml disabled, filtering disabled Monitor logging: level debugging, 5757 messages logged, xml disabled, filtering disabled Buffer logging: level debugging, 22282 messages logged, xml disabled, filtering disabled Exception Logging: size (4096 bytes) Count and timestamp logging messages: disabled Persistent logging: disabled Trap logging: level informational, 1402 message lines logged Log Buffer (300000 bytes): Mar 21 23:06:50.732: Received message from phone 5, sock 3, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:06:50.732: Sending message 0x4BA21A70 to phone 5, sock 3, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:06:51.628: Received message from phone 31, sock 5, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:06:51.628: Sending message 0x4BA21F08 to phone 31, sock 5, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:06:51.756: Received message from phone 10, sock 22, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:06:51.756: Sending message 0x4BA21A70 to phone 10, sock 22, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:06:51.968: Received message from phone 9, sock 4, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:06:51.968: Sending message 0x4BA21F08 to phone 9, sock 4, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:06:53.276: Received message from phone 18, sock 11, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:06:53.276: Sending message 0x4BA21F08 to phone 18, sock 11, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:06:54.072: Received message from phone 28, sock 32, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:06:54.072: Sending message 0x4BA21F08 to phone 28, sock 32, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:06:54.736: Received message from phone 11, sock 2, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:06:54.736: Sending message 0x4BA21F08 to phone 11, sock 2, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:06:54.764: Received message from phone 30, sock 34, SkinnyMessageID = StationSoftKeyEventMessageID Mar 21 23:06:54.764: ephone-30[29/34][SEP001D09CCADEE]:SoftKeyEventMessage event 1 line 0 callref 0 Mar 21 23:06:54.764: ephone-30[29/34]:Block FAC when Sk pressed. Mar 21 23:06:54.768: ephone-30[29/34][SEP001D09CCADEE]:SK REDIAL line 0 ref 0 Mar 21 23:06:54.768: ephone-30[29/34][SEP001D09CCADEE]:Normal ReDial press 107 line 0 Mar 21 23:06:54.768: SkinnyGetCallState for DN 54 chan 1 IDLE Mar 21 23:06:54.768: called DN -1 chan 1, calling DN -1 chan 1 phone -1 s2s:0 Mar 21 23:06:54.768: ephone-30[29/34]:OFFHOOK Mar 21 23:06:54.768: ephone-30[29/34][SEP001D09CCADEE]:---SkinnySyncPhoneDnOverlays has activeLine 1 current DN 54 Mar 21 23:06:54.768: ephone-30[29/34][SEP001D09CCADEE]: Mar 21 23:06:54.768: bulk_speeddial_init_ephone: 29 Mar 21 23:06:54.768: ephone-30[29/34]:FAC dialing has been blocked by softkey perss. Don't update its state. Mar 21 23:06:54.768: SkinnyGetCallState for DN 54 chan 1 IDLE Mar 21 23:06:54.768: called DN -1 chan 1, calling DN -1 chan 1 phone -1 s2s:0 Mar 21 23:06:54.768: SkinnyGetCallState for DN 54 chan 1 IDLE Mar 21 23:06:54.768: called DN -1 chan 1, calling DN -1 chan 1 phone -1 s2s:0 Mar 21 23:06:54.768: ephone-30[29/34][SEP001D09CCADEE]:SEIZE on activeLine 1 activeChan 1 Mar 21 23:06:54.768: ephone-30[29/34][SEP001D09CCADEE]:Seize select line 1 chan 1 Mar 21 23:06:54.768: ephone-30[29/34]:UpdateCallState DN 54 chan 1 state 2 calleddn -1 chan 1 Mar 21 23:06:54.768: ephone-30[29/34]:Binding ephone-30 to DN 54 chan 1 s2s:0 Mar 21 23:06:54.768: Assign Call Ref 2312 to DN 54 chan 1 Mar 21 23:06:54.768: Skinny Call State change for DN 54 chan 1 SIEZE from IDLE Mar 21 23:06:54.768: ephone-(30) DN 54 chan 1 calledDn -1 chan 1 callingDn -1 chan 1 :: port=0 Mar 21 23:06:54.768: SkinnyUpdateCstate DN 54 chan 1 cstate 1 Mar 21 23:06:54.768: SkinnyGetCallState for DN 54 chan 1 SIEZE Mar 21 23:06:54.768: called DN -1 chan 1, calling DN -1 chan 1 phone 30 s2s:0 Mar 21 23:06:54.768: ephone-30[29/34][SEP001D09CCADEE]:SkinnyUpdateCstate first phone for DN 54 chan 1 ref 2312 Mar 21 23:06:54.768: ephone-30[29/34]:SkinnyUpdateCState activeLine 1 chan 1 DN 54 ref 2312 Mar 21 23:06:54.768: ephone-30[34]:SetCallState line 1 DN 54(-1) chan 1 ref 2312 TsOffHook Mar 21 23:06:54.768: ephone-30[29/34]:SkinnyTrackActiveCall add line 1 ref 2312 state 1 (slot 0) Mar 21 23:06:54.768: ephone-30[29/34][SEP001D09CCADEE]:ClearCallPrompt line 1 ref 2312 Mar 21 23:06:54.768: ephone-30[29/34]:SelectPhoneSoftKeys set 4 mask FFFF for line 1 ref 2312 Mar 21 23:06:54.768: SkinnyGetCallState for DN 54 chan 1 SIEZE Mar 21 23:06:54.768: called DN -1 chan 1, calling DN -1 chan 1 phone 30 s2s:0 Mar 21 23:06:54.768: ephone-30[34]:SetLineLamp 1 to ON Mar 21 23:06:54.768: SkinnyGetCallState for DN 54 chan 1 SIEZE Mar 21 23:06:54.768: called DN -1 chan 1, calling DN -1 chan 1 phone 30 s2s:0 Mar 21 23:06:54.768: ephone-30[29/34][SEP001D09CCADEE]:Overlap_enabled: FALSE for dn: 54 Mar 21 23:06:54.768: ephone-30[29/34]:SpeakerPhoneOffHook Mar 21 23:06:54.768: ephone-30[29/34][SEP001D09CCADEE]:Normal ReDial press 107 pending Mar 21 23:06:54.768: ephone-30[29/34][SEP001D09CCADEE]:phone: 29 Mar 21 23:06:54.772: Sending message 0x4BA2A758 to phone 30, sock 34, SkinnyMessageID = StationCallStateMessageID Mar 21 23:06:54.772: Sending message 0x4BA0E4F8 to phone 30, sock 34, SkinnyMessageID = StationClearPromptStatusMessageID Mar 21 23:06:54.772: Sending message 0x4BA0FE20 to phone 30, sock 34, SkinnyMessageID = StationSelectSoftKeysMessageID Mar 21 23:06:54.772: Sending message 0x4BA0F2E0 to phone 30, sock 34, SkinnyMessageID = StationSetLampMessageID Mar 21 23:06:54.772: Sending message 0x4BA21F08 to phone 30, sock 34, SkinnyMessageID = StationSetSpeakerModeMessageID Mar 21 23:06:54.776: //-1/544C95E8AFB0/CCAPI/cc_api_display_ie_subfields: cc_api_call_setup_ind_common: cisco-username= ----- ccCallInfo IE subfields ----- cisco-ani=888 cisco-anitype=0 cisco-aniplan=0 cisco-anipi=0 cisco-anisi=0 dest= cisco-desttype=0 cisco-destplan=0 cisco-rdie=FFFFFFFF cisco-rdn= cisco-rdntype=0 cisco-rdnplan=0 cisco-rdnpi=0 cisco-rdnsi=0 cisco-redirectreason=0 fwd_final_type =0 final_redirectNumber = hunt_group_timeout =0 Mar 21 23:06:54.776: //-1/544C95E8AFB0/CCAPI/cc_api_call_setup_ind_common: Interface=0x4BA4EAC4, Call Info( Calling Number=888,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed), Called Number=(TON=Unknown, NPI=Unknown), Calling Translated=FALSE, Subscriber Type Str=RegularLine, FinalDestinationFlag=FALSE, Incoming Dial-peer=20077, Progress Indication=ORIGINATING SIDE IS NON ISDN(3), Calling IE Present=TRUE, Source Trkgrp Route Label=, Target Trkgrp Route Label=, CLID Transparent=FALSE), Call Id=-1 Mar 21 23:06:54.776: //-1/544C95E8AFB0/CCAPI/ccCheckClipClir: In: Calling Number=888(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed) Mar 21 23:06:54.776: //-1/544C95E8AFB0/CCAPI/ccCheckClipClir: Out: Calling Number=888(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed) Mar 21 23:06:54.776: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa: Mar 21 23:06:54.776: :cc_get_feature_vsa malloc success Mar 21 23:06:54.776: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa: Mar 21 23:06:54.776: cc_get_feature_vsa count is 1 Mar 21 23:06:54.776: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa: Mar 21 23:06:54.776: :FEATURE_VSA attributes are: feature_name:0,feature_time:1204841304,feature_id:8135 Mar 21 23:06:54.776: //4241/544C95E8AFB0/CCAPI/cc_api_call_setup_ind_common: Set Up Event Sent; Call Info(Calling Number=888(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed), Called Number=(TON=Unknown, NPI=Unknown)) Mar 21 23:06:54.776: //4241/544C95E8AFB0/CCAPI/cc_process_call_setup_ind: Event=0x497CABC8 Mar 21 23:06:54.780: //4241/544C95E8AFB0/CCAPI/ccCallSetContext: Context=0x47D0F838 Mar 21 23:06:54.780: //4241/544C95E8AFB0/CCAPI/cc_process_call_setup_ind: >>>>CCAPI handed cid 4241 with tag 20077 to app "_ManagedAppProcess_Default" Mar 21 23:06:54.780: //4241/544C95E8AFB0/CCAPI/ccCallSetupAck: Call Id=4241 Mar 21 23:06:54.780: //4241/544C95E8AFB0/CCAPI/cc_api_set_transfer_info: Transfer Number=, Transfer Reason=0x0 Mar 21 23:06:54.780: //4241/544C95E8AFB0/CCAPI/ccGenerateToneInfo: Stop Tone On Digit=TRUE, Tone=Dial Tone, Tone Direction=Network, Params=0x0, Call Id=4241 Mar 21 23:06:54.780: //4241/544C95E8AFB0/CCAPI/ccSetDigitTimeouts: Initial Digit Timeout=-1000(ms), Inter Digit Timeout=-1000(ms) Mar 21 23:06:54.780: //4241/544C95E8AFB0/CCAPI/ccSetDigitTimeouts: Call Entry(Inter Digit Timeout=10000(ms), Initial Digit Timeout=10000(ms)) Mar 21 23:06:54.780: //4241/544C95E8AFB0/CCAPI/ccCallReportDigits: (callID=0x1091, digit_event=0x1, enable=TRUE, consume=FALSE) Mar 21 23:06:54.780: //4241/544C95E8AFB0/CCAPI/ccCallReportDigits: Enabled=TRUE, Call Id=4241 Mar 21 23:06:54.780: //4241/544C95E8AFB0/CCAPI/cc_api_call_report_digits_done: (vdbPtr=0x4BA4EAC4, callID=0x1091, disp=0, digit_event=0x1, enable=TRUE, consume=FALSE) Mar 21 23:06:54.780: //4241/544C95E8AFB0/CCAPI/cc_api_call_report_digits_done: Enabled=TRUE, Disposition=0x0, Interface=0x4BA4EAC4, Call Id=4241 Mar 21 23:06:54.780: //4241/544C95E8AFB0/CCAPI/cc_api_call_report_digits_done: Call Entry(Initial Digit Timeout=15000(ms), Inter Digit Timeout=5000(ms)) Mar 21 23:06:54.780: SetDnCodec DN 54 chan 1 codec 4:G711Ulaw64k vad 0 size 160 Mar 21 23:06:54.780: DN 54 chan 1 Voice_Mode Mar 21 23:06:54.780: SkinnyGetCallState for DN 54 chan 1 SIEZE Mar 21 23:06:54.780: called DN -1 chan 1, calling DN -1 chan 1 phone 30 s2s:0 Mar 21 23:06:54.780: SkinnyTransfereeHairpinRinging: dn 54 chan 1 tonetype 33 Mar 21 23:06:54.780: dn_tone_control DN=54 chan 1 tonetype=33:DtInsideDialTone onoff=1 pid=296 Mar 21 23:06:54.784: SkinnyGetCallState for DN 54 chan 1 SIEZE Mar 21 23:06:54.784: called DN -1 chan 1, calling DN -1 chan 1 phone 30 s2s:0 Mar 21 23:06:54.784: SkinnyGetCallState for DN 54 chan 1 SIEZE Mar 21 23:06:54.784: called DN -1 chan 1, calling DN -1 chan 1 phone 30 s2s:0 Mar 21 23:06:54.784: ephone-30[29/34]:PhoneTone intercepted for pending redial Mar 21 23:06:54.784: ephone-30[29/34][SEP001D09CCADEE]:Normal ReDial press 107 line 1 Mar 21 23:06:54.784: Received message from phone 30, sock 34, SkinnyMessageID = StationMediaPathEventMessageID Mar 21 23:06:54.788: ephone-30[29/34][SEP001D09CCADEE]:MediaPathEventMessage Speaker ON Mar 21 23:06:54.788: ephone-30[29/34]:MediaPathEventMessage Mar 21 23:06:54.984: ephone-30[29/34][SEP001D09CCADEE]:KeypadButtonMessage 1 Mar 21 23:06:54.984: ephone-30[29/34]: Mar 21 23:06:54.984: bulk_sd_search_lists:Entry: digit:1, prefix= # state=1, index= 0 Mar 21 23:06:54.984: ephone-30[29/34]: Mar 21 23:06:54.984: bulk_sd_search_lists:Exit : digit:1, prefix= # state=7, index= 1, retval = 1 Mar 21 23:06:54.984: ephone-30[29/34][SEP001D09CCADEE]: Mar 21 23:06:54.984: bulk_speeddial_check_new_digit: button= 1 state FAIL_MATCH Mar 21 23:06:54.984: SkinnyGetCallState for DN 54 chan 1 SIEZE Mar 21 23:06:54.984: called DN -1 chan 1, calling DN -1 chan 1 phone 30 s2s:0 Mar 21 23:06:54.984: SkinnyGetCallState for DN 54 chan 1 SIEZE Mar 21 23:06:54.984: called DN -1 chan 1, calling DN -1 chan 1 phone 30 s2s:0 Mar 21 23:06:54.984: ephone-30[29/34][SEP001D09CCADEE]:Store ReDial digit: 1 Mar 21 23:06:54.984: ephone-30[29/34]:SkinnyTryCall to 1 instance 1 start at 0 secondary 0 Mar 21 23:06:54.984: //4241/544C95E8AFB0/CCAPI/cc_api_call_digit_begin: Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1, Source Call Id=4241, Digit=1, DigitBeginFlags=0x0, Rtp Timestamp=0x18E70, Rtp Expiration=0x0 Mar 21 23:06:54.984: dn_tone_control DN=54 chan 1 tonetype=0:DtSilence onoff=0 pid=296 Mar 21 23:06:54.984: SkinnyGetCallState for DN 54 chan 1 SIEZE Mar 21 23:06:54.984: called DN -1 chan 1, calling DN -1 chan 1 phone 30 s2s:0 Mar 21 23:06:54.984: SkinnyGetCallState for DN 54 chan 1 SIEZE Mar 21 23:06:54.984: called DN -1 chan 1, calling DN -1 chan 1 phone 30 s2s:0 Mar 21 23:06:54.988: ephone-30[29/34][SEP001D09CCADEE]:is_auto_local 0 for DN 54 Mar 21 23:06:54.988: ephone-30[29/34]:Tone Off ignored - already sent Mar 21 23:06:54.988: //4241/544C95E8AFB0/CCAPI/cc_api_call_digit_end: Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1, Source Call Id=4241, Digit=1, Duration=100, Xrule Calling Tag=0, Xrule Called Tag=0, Digit Tone Mode=DTMF Mar 21 23:06:54.988: //4241/544C95E8AFB0/CCAPI/cc_api_call_digit_end: Call Entry(Handoff Depth=0) Mar 21 23:06:54.988: Received message from phone 30, sock 34, SkinnyMessageID = StationMediaPathEventMessageID Mar 21 23:06:54.988: ephone-30[29/34][SEP001D09CCADEE]:MediaPathEventMessage Speaker ON Mar 21 23:06:54.988: ephone-30[29/34]:MediaPathEventMessage Mar 21 23:06:54.988: Received message from phone 30, sock 34, SkinnyMessageID = StationMediaPathEventMessageID Mar 21 23:06:54.988: ephone-30[29/34][SEP001D09CCADEE]:MediaPathEventMessage Handset OFF Mar 21 23:06:54.988: ephone-30[29/34]:MediaPathEventMessage Mar 21 23:06:55.184: ephone-30[29/34][SEP001D09CCADEE]:KeypadButtonMessage 0 Mar 21 23:06:55.184: ephone-30[29/34]: Mar 21 23:06:55.184: bulk_sd_search_lists:Entry: digit:0, prefix= # state=7, index= 1 Mar 21 23:06:55.184: ephone-30[29/34][SEP001D09CCADEE]: Mar 21 23:06:55.184: bulk_sd_search_lists: button= 0 state NOT_IN_SD Mar 21 23:06:55.184: SkinnyGetCallState for DN 54 chan 1 SIEZE Mar 21 23:06:55.184: called DN -1 chan 1, calling DN -1 chan 1 phone 30 s2s:0 Mar 21 23:06:55.184: SkinnyGetCallState for DN 54 chan 1 SIEZE Mar 21 23:06:55.184: called DN -1 chan 1, calling DN -1 chan 1 phone 30 s2s:0 Mar 21 23:06:55.184: ephone-30[29/34][SEP001D09CCADEE]:Store ReDial digit: 10 Mar 21 23:06:55.184: ephone-30[29/34]:SkinnyTryCall to 10 instance 1 start at 0 secondary 0 Mar 21 23:06:55.184: //4241/544C95E8AFB0/CCAPI/cc_api_call_digit_begin: Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1, Source Call Id=4241, Digit=0, DigitBeginFlags=0x0, Rtp Timestamp=0x20B70, Rtp Expiration=0x0 Mar 21 23:06:55.184: //4241/544C95E8AFB0/CCAPI/cc_api_call_digit_end: Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1, Source Call Id=4241, Digit=0, Duration=100, Xrule Calling Tag=0, Xrule Called Tag=0, Digit Tone Mode=DTMF Mar 21 23:06:55.184: //4241/544C95E8AFB0/CCAPI/cc_api_call_digit_end: Call Entry(Handoff Depth=0) Mar 21 23:06:55.384: ephone-30[29/34][SEP001D09CCADEE]:KeypadButtonMessage 7 Mar 21 23:06:55.384: ephone-30[29/34]: Mar 21 23:06:55.384: bulk_sd_search_lists:Entry: digit:7, prefix= # state=7, index= 1 Mar 21 23:06:55.384: ephone-30[29/34][SEP001D09CCADEE]: Mar 21 23:06:55.384: bulk_sd_search_lists: button= 7 state NOT_IN_SD Mar 21 23:06:55.384: SkinnyGetCallState for DN 54 chan 1 SIEZE Mar 21 23:06:55.384: called DN -1 chan 1, calling DN -1 chan 1 phone 30 s2s:0 Mar 21 23:06:55.384: SkinnyGetCallState for DN 54 chan 1 SIEZE Mar 21 23:06:55.384: called DN -1 chan 1, calling DN -1 chan 1 phone 30 s2s:0 Mar 21 23:06:55.384: ephone-30[29/34][SEP001D09CCADEE]:Store ReDial digit: 107 Mar 21 23:06:55.384: ephone-30[29/34]:SkinnyTryCall to 107 instance 1 start at 0 secondary 0 SkinnyTryCall to 107 instance 1 match DN 51 Mar 21 23:06:55.384: SkinnyGetCallState for DN 51 chan 1 IDLE Mar 21 23:06:55.384: called DN -1 chan 1, calling DN -1 chan 1 phone -1 s2s:0 Mar 21 23:06:55.384: ephone-30[29/34]:Skinny-to-Skinny call DN 54 chan 1 to DN 51 chan 1 instance 1 Mar 21 23:06:55.384: ephone-30[29/34]:UpdateCallState DN 54 chan 1 state 1 calleddn 51 chan 1 Mar 21 23:06:55.384: ephone-30[29/34]:Binding ephone-30 to DN 54 chan 1 s2s:0 Mar 21 23:06:55.384: Binding calledDn 51 chan 1 to DN 54 chan 1 Mar 21 23:06:55.384: ephone-30[29/34]:Block FAC when call at ALERTING Mar 21 23:06:55.384: Skinny Call State change for DN 54 chan 1 ALERTING from SIEZE Mar 21 23:06:55.384: ephone-(30) DN 54 chan 1 calledDn 51 chan 1 callingDn -1 chan 1 :: port=0 Mar 21 23:06:55.384: SkinnyUpdateCstate DN 54 chan 1 cstate 3 Mar 21 23:06:55.384: SkinnyGetCallState for DN 54 chan 1 ALERTING Mar 21 23:06:55.384: called DN 51 chan 1, calling DN -1 chan 1 phone 30 s2s:0 Mar 21 23:06:55.384: ephone-30[29/34][SEP001D09CCADEE]:SkinnyUpdateCstate first phone for DN 54 chan 1 ref 2312 Mar 21 23:06:55.384: ephone-30[29/34]:SkinnyUpdateCState activeLine 1 chan 1 DN 54 ref 2312 Mar 21 23:06:55.384: ephone-30[29/34][SEP001D09CCADEE]:Send TsProceed for TsRingOut DN 54 line 1 chan 1 Mar 21 23:06:55.384: ephone-30[29/34]:DialedNumber: 107 DN 54 line 1 ref 2312 Mar 21 23:06:55.384: ephone-30[34]:SetCallState line 1 DN 54(-1) chan 1 ref 2312 TsProceed Mar 21 23:06:55.384: ephone-30[29/34]:SkinnyTrackActiveCall for line 1 ref 2312 state 12 (slot 0) Mar 21 23:06:55.384: ephone-30[34]:SetCallState line 1 DN 54(-1) chan 1 ref 2312 TsRingOut Mar 21 23:06:55.384: ephone-30[29/34]:SkinnyTrackActiveCall for line 1 ref 2312 state 3 (slot 0) Mar 21 23:06:55.384: ephone-30[29/34]:CallPrompt line 1 ref 2312:tag 122 (Ring Out) Mar 21 23:06:55.384: ephone-30[29/34]:SelectPhoneSoftKeys set 8 mask FFFF for line 1 ref 2312 Mar 21 23:06:55.384: SkinnyGetCallState for DN 54 chan 1 ALERTING Mar 21 23:06:55.384: called DN 51 chan 1, calling DN -1 chan 1 phone 30 s2s:0 Mar 21 23:06:55.384: ephone-30[34]:SetLineLamp 1 to ON Mar 21 23:06:55.388: SkinnySetCallInfoName calling dn 54 chan 1 dn 54 chan 1,calling [888] called [107] calling name Wilder called name Ext 107 Mar 21 23:06:55.388: SetCallInfo DN 54 chan 1 is not skinny-to-skinny Mar 21 23:06:55.388: ephone-30[29/34][SEP001D09CCADEE]:SkinnySetOrigCallInfo Set origCalled 107 origCalledName Ext 107 Mar 21 23:06:55.388: SkinnyGetCallState for DN 54 chan 1 ALERTING Mar 21 23:06:55.388: called DN 51 chan 1, calling DN -1 chan 1 phone 30 s2s:0 Mar 21 23:06:55.388: ephone-30[29/34][SEP001D09CCADEE]:SkinnyDisplayCallInfo outgoing call line 1 ref 2312 Mar 21 23:06:55.388: ephone-30[29/34][SEP001D09CCADEE]:SkinnyDisplayCallInfo callingNumber=888 Mar 21 23:06:55.388: ephone-30[29/34][SEP001D09CCADEE]:SkinnyDisplayCallInfo calledNumber=107 Mar 21 23:06:55.388: ephone-30[34]::callingNumber 888 Mar 21 23:06:55.388: ephone-30[34]::callingParty 888 Mar 21 23:06:55.388: ephone-30[29/34]:Call Info DN 54 line 1 ref 2312 call state 1 called 107 calling 888 origcalled 107 Mar 21 23:06:55.388: ephone-30[29/34][SEP001D09CCADEE]: Mar 21 23:06:55.388: bulk_speeddial_update_callinfo: 29 Mar 21 23:06:55.388: ephone-30[29/34]:Call Info DN 54 line 1 ref 2312 called 107 calling 888 alternateCalling 888 origcalled 107 calltype 2 Mar 21 23:06:55.388: ephone-30[29/34][SEP001D09CCADEE]:Call Info for chan 1 Mar 21 23:06:55.388: ephone-30[29/34][SEP001D09CCADEE]:Original Called Name Ext 107 Mar 21 23:06:55.388: ephone-30[29/34][SEP001D09CCADEE]:SkinnyDisplayCallInfo callingName=Wilder Mar 21 23:06:55.388: ephone-30[29/34][SEP001D09CCADEE]:SkinnyDisplayCallInfo calledName=Ext 107 Mar 21 23:06:55.388: peer_vdb is NULL for DN 54, chan 1 at SkinnyIsPeerNonSCCP Mar 21 23:06:55.388: //4241/544C95E8AFB0/CCAPI/cc_api_call_digit_begin: Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1, Source Call Id=4241, Digit=7, DigitBeginFlags=0x0, Rtp Timestamp=0x28870, Rtp Expiration=0x0 Mar 21 23:06:55.388: //4241/544C95E8AFB0/CCAPI/cc_api_call_digit_end: Destination Interface=0x0, Destination Mask=0x3, Destination Call Id=-1, Source Call Id=4241, Digit=7, Duration=100, Xrule Calling Tag=0, Xrule Called Tag=0, Digit Tone Mode=DTMF Mar 21 23:06:55.388: //4241/544C95E8AFB0/CCAPI/cc_api_call_digit_end: Call Entry(Handoff Depth=0) Mar 21 23:06:55.392: Sending message 0x4BA2B158 to phone 30, sock 34, SkinnyMessageID = StationDialedNumberMessageID Mar 21 23:06:55.392: Sending message 0x4BA2E418 to phone 30, sock 34, SkinnyMessageID = StationCallStateMessageID Mar 21 23:06:55.392: Sending message 0x4BA2C618 to phone 30, sock 34, SkinnyMessageID = StationCallStateMessageID Mar 21 23:06:55.392: Sending message 0x4BAEA284 to phone 30, sock 34, SkinnyMessageID = StationDisplayPromptStatusV2MessageID Mar 21 23:06:55.392: Sending message 0x4BA0FDD0 to phone 30, sock 34, SkinnyMessageID = StationSelectSoftKeysMessageID Mar 21 23:06:55.392: Sending message 0x4BA10B18 to phone 30, sock 34, SkinnyMessageID = StationSetLampMessageID Mar 21 23:06:55.392: Sending message 0x4BDC58EC to phone 30, sock 34, SkinnyMessageID = StationCallInfoV2MessageID Mar 21 23:06:55.392: //4241/544C95E8AFB0/CCAPI/ccCallReportDigits: (callID=0x1091, digit_event=0x0, enable=FALSE, consume=FALSE) Mar 21 23:06:55.396: //4241/544C95E8AFB0/CCAPI/ccCallReportDigits: Enabled=TRUE, Call Id=4241 Mar 21 23:06:55.396: //4241/544C95E8AFB0/CCAPI/cc_api_call_report_digits_done: (vdbPtr=0x4BA4EAC4, callID=0x1091, disp=0, digit_event=0x0, enable=FALSE, consume=FALSE) Mar 21 23:06:55.396: //4241/544C95E8AFB0/CCAPI/cc_api_call_report_digits_done: Enabled=TRUE, Disposition=0x0, Interface=0x4BA4EAC4, Call Id=4241 Mar 21 23:06:55.396: //4241/544C95E8AFB0/CCAPI/cc_api_call_report_digits_done: Call Entry(Initial Digit Timeout=15000(ms), Inter Digit Timeout=5000(ms)) Mar 21 23:06:55.400: //4241/544C95E8AFB0/CCAPI/ccCallProceeding: Progress Indication=NULL(0) Mar 21 23:06:55.404: //-1/xxxxxxxxxxxx/CCAPI/ccUpdateRedirectingNumber: type=6 redirecting_number=107 Mar 21 23:06:55.404: //-1/xxxxxxxxxxxx/CCAPI/ccUpdateRedirectNumber: type=6 Original Called Number=107, Called Number=107, Calling Number=888, Calling DN=432 Calling Id=4241, Redirect Number=9602XXXX403, Redirect Reason=15 Mar 21 23:06:55.404: ephone_update_redirect_number: orig=107 cfn=9602XXXX403 cgn=888 cgdn+chan=432 fwd_final_type=0 final_redirectNumber= hunt_group_timeout=0 call_forward_reason=15 Mar 21 23:06:55.404: ephone_update_redirect_number: after ephone_update_redirect_number_for_hunt_group orig=107 cfn=9602XXXX403 cgn=888 cgdn+chan=432 fwd_final_type=0 final_redirectNumber= hunt_group_timeout=0 call_forward_reason=15 Mar 21 23:06:55.404: ephone_update_redirect_number: cgdn=54 cgchan=1 local=1 Mar 21 23:06:55.404: SkinnyUpdateRedirectNumber DN 54 chan 1 to 9602XXXX403 reason 15 Mar 21 23:06:55.404: //-1/xxxxxxxxxxxx/CCAPI/ccUpdateRedirectingNumber: type=6 redirecting_number=107 Mar 21 23:06:55.404: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa: Mar 21 23:06:55.404: :cc_get_feature_vsa malloc success Mar 21 23:06:55.404: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa: Mar 21 23:06:55.404: cc_get_feature_vsa count is 2 Mar 21 23:06:55.404: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa: Mar 21 23:06:55.404: :FEATURE_VSA attributes are: feature_name:0,feature_time:1204844440,feature_id:8136 Mar 21 23:06:55.404: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa: Mar 21 23:06:55.404: feature_vsa is 47D06B50,featname is 0 Mar 21 23:06:55.404: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa: Mar 21 23:06:55.404: :cc_get_feature_vsa malloc success Mar 21 23:06:55.404: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa: Mar 21 23:06:55.404: cc_get_feature_vsa count is 3 Mar 21 23:06:55.404: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa: Mar 21 23:06:55.404: :FEATURE_VSA attributes are: feature_name:0,feature_time:1204842424,feature_id:8137 Mar 21 23:06:55.404: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa: Mar 21 23:06:55.404: : Generating new featurevsa,inserting it Mar 21 23:06:55.404: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa: Mar 21 23:06:55.404: feature call forward featname is 1 Mar 21 23:06:55.404: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa: Mar 21 23:06:55.404: :cc_free_feature_vsa freeing 47D07790 Mar 21 23:06:55.404: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa: Mar 21 23:06:55.404: vsacount in free is 2 Mar 21 23:06:55.404: ephone_no_fwd_check, voice_peer_tag = 20052, inCallID =4241, hunt tag = 0 Mar 21 23:06:55.404: //4241/544C95E8AFB0/CCAPI/ccCallForwardTo: Call Forward Number=9602XXXX403, Call Forward Cause Reason=15, Call Id=4241 Mar 21 23:06:55.404: SkinnyRedirectedTo DN 54 chan 1 to 9602XXXX403 reason 15 Mar 21 23:06:55.404: ephone-30[29/34][SEP001D09CCADEE]:Redirected DN 54 chan 1 active on line 1 Mar 21 23:06:55.404: ephone-30[29/34][SEP001D09CCADEE]:Request Update Display info on calling DN 54 Mar 21 23:06:55.404: ephone-30[29/34]:SkinnyTryCall to 9602XXXX403 instance 1 start at 0 secondary 0 Mar 21 23:06:55.404: SkinnyRedirectedTo DN 54 chan 1, no update needed Mar 21 23:06:55.408: SkinnyUpdateDnState by EFXS_PROCEEDING for DN 54 chan 1 to state ALERTING Mar 21 23:06:55.408: ephone-30[29/34]:UpdateCallState DN 54 chan 1 state 1 calleddn -1 chan 1 Mar 21 23:06:55.408: ephone-30[29/34]:Binding ephone-30 to DN 54 chan 1 s2s:0 Mar 21 23:06:55.408: ephone-30[29/34]:Block FAC when call at ALERTING Mar 21 23:06:55.408: Skinny Call State change for DN 54 chan 1 ALERTING from ALERTING Mar 21 23:06:55.408: ephone-(30) DN 54 chan 1 calledDn -1 chan 1 callingDn -1 chan 1 :: port=0 Mar 21 23:06:55.408: SkinnyGetCallState for DN 54 chan 1 ALERTING Mar 21 23:06:55.408: called DN -1 chan 1, calling DN -1 chan 1 phone 30 s2s:0 Mar 21 23:06:55.408: ephone-30[34]:SetLineLamp 1 to ON Mar 21 23:06:55.408: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa: Mar 21 23:06:55.408: :cc_get_feature_vsa malloc success Mar 21 23:06:55.408: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa: Mar 21 23:06:55.408: cc_get_feature_vsa count is 3 Mar 21 23:06:55.408: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa: Mar 21 23:06:55.408: :FEATURE_VSA attributes are: feature_name:0,feature_time:1204844440,feature_id:8138 Mar 21 23:06:55.408: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa: Mar 21 23:06:55.408: feature call forward featname is 1 Mar 21 23:06:55.408: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa: Mar 21 23:06:55.408: :cc_free_feature_vsa freeing 47D07790 Mar 21 23:06:55.408: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa: Mar 21 23:06:55.408: vsacount in free is 2 Mar 21 23:06:55.412: //4241/544C95E8AFB0/CCAPI/ccCallForwardTo: Call Forward Number=9602XXXX403, Call Forward Cause Reason=15, Call Id=4241 Mar 21 23:06:55.412: SkinnyRedirectedTo DN 54 chan 1 to 9602XXXX403 reason 15 Mar 21 23:06:55.412: ephone-30[29/34][SEP001D09CCADEE]:Redirected DN 54 chan 1 active on line 1 Mar 21 23:06:55.412: ephone-30[29/34][SEP001D09CCADEE]:Request Update Display info on calling DN 54 Mar 21 23:06:55.412: ephone-30[29/34]:SkinnyTryCall to 9602XXXX403 instance 1 start at 0 secondary 0 Mar 21 23:06:55.412: SkinnyRedirectedTo DN 54 chan 1, no update needed Mar 21 23:06:55.412: //4241/544C95E8AFB0/CCAPI/ccCallSetupRequest: Destination=, Calling IE Present=TRUE, Mode=0, Outgoing Dial-peer=8, Params=0x47D1FCF0, Progress Indication=ORIGINATING SIDE IS NON ISDN(3) Mar 21 23:06:55.412: //4241/544C95E8AFB0/CCAPI/ccCheckClipClir: In: Calling Number=888(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed) Mar 21 23:06:55.412: //4241/544C95E8AFB0/CCAPI/ccCheckClipClir: Out: Calling Number=888(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed) Mar 21 23:06:55.412: //4241/544C95E8AFB0/CCAPI/ccCallSetupRequest: Destination Pattern=9T, Called Number=9602XXXX403, Digit Strip=TRUE Mar 21 23:06:55.412: //4241/544C95E8AFB0/CCAPI/ccCallSetupRequest: Calling Number=888(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed), Called Number=9602XXXX403(TON=Unknown, NPI=Unknown), Redirect Number=107, Display Info=Wilder Account Number=, Final Destination Flag=FALSE, Guid=54AE3E9C-B084-11E3-AFB4-DDF01636CC13, Outgoing Dial-peer=8 Mar 21 23:06:55.412: //4241/544C95E8AFB0/CCAPI/cc_api_display_ie_subfields: ccCallSetupRequest: cisco-username= ----- ccCallInfo IE subfields ----- cisco-ani=888 cisco-anitype=0 cisco-aniplan=0 cisco-anipi=0 cisco-anisi=0 dest=9602XXXX403 cisco-desttype=0 cisco-destplan=0 cisco-rdie=73 cisco-rdn=107 cisco-rdntype=0 cisco-rdnplan=0 cisco-rdnpi=0 cisco-rdnsi=0 cisco-redirectreason=15 fwd_final_type =0 final_redirectNumber = hunt_group_timeout =0 Mar 21 23:06:55.416: ephone-30[29/34][SEP001D09CCADEE]:SkinnyGetMultiMediaCapabilities: dn: 54, chan: 1 Mar 21 23:06:55.416: //4241/544C95E8AFB0/CCAPI/ccIFCallSetupRequestPrivate: Interface=0x4A04C394, Interface Type=6, Destination=, Mode=0x0, Call Params(Calling Number=888,(Calling Name=Wilder)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed), Called Number=9602XXXX403(TON=Unknown, NPI=Unknown), Calling Translated=FALSE, Subscriber Type Str=RegularLine, FinalDestinationFlag=FALSE, Outgoing Dial-peer=8, Call Count On=FALSE, Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=) Mar 21 23:06:55.416: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa: Mar 21 23:06:55.416: :cc_get_feature_vsa malloc success Mar 21 23:06:55.416: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa: Mar 21 23:06:55.416: cc_get_feature_vsa count is 3 Mar 21 23:06:55.416: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa: Mar 21 23:06:55.416: :FEATURE_VSA attributes are: feature_name:0,feature_time:1204844440,feature_id:8139 Mar 21 23:06:55.416: //4242/544C95E8AFB0/CCAPI/ccIFCallSetupRequestPrivate: SPI Call Setup Request Is Success; Interface Type=6, FlowMode=1 Mar 21 23:06:55.416: //4242/544C95E8AFB0/CCAPI/ccCallSetContext: Context=0x47D1FCA0 Mar 21 23:06:55.416: //4241/544C95E8AFB0/CCAPI/ccSaveDialpeerTag: Outgoing Dial-peer=8 Mar 21 23:06:55.416: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa: Mar 21 23:06:55.416: feature call forward featname is 1 Mar 21 23:06:55.416: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa: Mar 21 23:06:55.416: feature_vsa is 47D07790,featname is 0 Mar 21 23:06:55.416: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa: Mar 21 23:06:55.416: :cc_get_feature_vsa malloc success Mar 21 23:06:55.416: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa: Mar 21 23:06:55.416: cc_get_feature_vsa count is 4 Mar 21 23:06:55.416: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa: Mar 21 23:06:55.416: :FEATURE_VSA attributes are: feature_name:0,feature_time:1204841080,feature_id:8140 Mar 21 23:06:55.416: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa: Mar 21 23:06:55.416: : Generating new featurevsa,inserting it Mar 21 23:06:55.416: //-1/xxxxxxxxxxxx/CCAPI/cc_update_feature_vsa: Mar 21 23:06:55.416: feature call forward featname is 1 Mar 21 23:06:55.416: Sending message 0x4BA10B18 to phone 30, sock 34, SkinnyMessageID = StationSetLampMessageID Mar 21 23:06:55.420: ISDN Se0/3/0:23 Q931: Applying typeplan for sw-type 0xD is 0x0 0x0, Calling num 888 Mar 21 23:06:55.420: ISDN Se0/3/0:23 Q931: Sending SETUP callref = 0x01FF callID = 0x8180 switch = primary-ni interface = User Mar 21 23:06:55.420: ISDN Se0/3/0:23 Q931: TX -> SETUP pd = 8 callref = 0x01FF Bearer Capability i = 0x8090A2 Standard = CCITT Transfer Capability = Speech Transfer Mode = Circuit Transfer Rate = 64 kbit/s Channel ID i = 0xA9838A Exclusive, Channel 10 Progress Ind i = 0x8183 - Origination address is non-ISDN Calling Party Number i = 0x0080, '888' Plan:Unknown, Type:Unknown Called Party Number i = 0xA1, '602XXXX403' Plan:ISDN, Type:National Redirecting Number i = 0x00008F, '107' Plan:Unknown, Type:Unknown Mar 21 23:06:55.452: ISDN Se0/3/0:23 Q931: RX <- CALL_PROC pd = 8 callref = 0x81FF Channel ID i = 0xA9838A Exclusive, Channel 10 Mar 21 23:06:55.456: //4242/544C95E8AFB0/CCAPI/cc_api_call_proceeding: Interface=0x4A04C394, Progress Indication=NULL(0) Mar 21 23:06:55.552: ISDN Se0/3/0:23 Q931: RX <- PROGRESS pd = 8 callref = 0x81FF Progress Ind i = 0x8288 - In-band info or appropriate now available Mar 21 23:06:55.552: //4242/544C95E8AFB0/CCAPI/cc_api_call_cut_progress: Interface=0x4A04C394, Progress Indication=INBAND(8), Signal Indication=INTERCEPT(2), Cause Value=0 Mar 21 23:06:55.556: //4242/544C95E8AFB0/CCAPI/cc_api_call_cut_progress: Call Entry(Responsed=TRUE) Mar 21 23:06:55.556: //4241/544C95E8AFB0/CCAPI/ccCallCutProgress: Progress Indication=INBAND(8), Signal Indication=INTERCEPT(2), Cause Value=0 Voice Call Send Alert=FALSE, Call Entry(Alert Sent=FALSE) Mar 21 23:06:55.556: //4241/544C95E8AFB0/CCAPI/ccCallCutProgress: Call Entry(Responsed=TRUE) Mar 21 23:06:55.556: //4241/544C95E8AFB0/CCAPI/ccGenerateToneInfo: Stop Tone On Digit=FALSE, Tone=Null, Tone Direction=Network, Params=0x0, Call Id=4241 Mar 21 23:06:55.556: //4241/544C95E8AFB0/CCAPI/ccConferenceCreate: (confID=0x4BBE34E0, callID1=0x1091, gcid=544C95E8-B08411E3-AFB0DDF0-1636CC13, tag=0x0) Mar 21 23:06:55.556: //4242/544C95E8AFB0/CCAPI/ccConferenceCreate: (confID=0x4BBE34E0, callID2=0x1092, gcid=544C95E8-B08411E3-AFB0DDF0-1636CC13, tag=0x0) Mar 21 23:06:55.556: //4241/544C95E8AFB0/CCAPI/ccConferenceCreate: Conference Id=0x4BBE34E0, Call Id1=4241, Call Id2=4242, Tag=0x0 Mar 21 23:06:55.556: DN: 54, CHAN: 1, voice_hcmask: 0x1880000F Mar 21 23:06:55.556: dn_support_srtp DN 54 chan 1 with dn_index 54 found phone 29 Mar 21 23:06:55.556: dn_support_srtp DN 54 chan 1 can not find phone support srtp Mar 21 23:06:55.556: //4241/544C95E8AFB0/CCAPI/cc_api_bridge_done: Conference Id=0x510, Source Interface=0x4BA4EAC4, Source Call Id=4241, Destination Call Id=4242, Disposition=0x0, Tag=0xFFFFFFFF Mar 21 23:06:55.556: DN: 54, CHAN: 1, voice_hcmask: 0x1880000F Mar 21 23:06:55.556: dn_support_srtp DN 54 chan 1 with dn_index 54 found phone 29 Mar 21 23:06:55.556: dn_support_srtp DN 54 chan 1 can not find phone support srtp Mar 21 23:06:55.556: //4242/544C95E8AFB0/CCAPI/cc_api_bridge_done: Conference Id=0x510, Source Interface=0x4A04C394, Source Call Id=4242, Destination Call Id=4241, Disposition=0x0, Tag=0xFFFFFFFF Mar 21 23:06:55.556: //4241/544C95E8AFB0/CCAPI/cc_generic_bridge_done: Conference Id=0x510, Source Interface=0x4A04C394, Source Call Id=4242, Destination Call Id=4241, Disposition=0x0, Tag=0xFFFFFFFF Mar 21 23:06:55.556: //4241/544C95E8AFB0/CCAPI/ccConferenceCreate: Call Entry(Conference Id=0x510, Destination Call Id=4242) Mar 21 23:06:55.556: //4242/544C95E8AFB0/CCAPI/ccConferenceCreate: Call Entry(Conference Id=0x510, Destination Call Id=4241) Mar 21 23:06:55.556: //4241/544C95E8AFB0/CCAPI/cc_api_caps_ind: Destination Interface=0x4A04C394, Destination Call Id=4242, Source Call Id=4241, Caps(Codec=0x1, Fax Rate=0x2, Vad=0x1, Modem=0x2, Codec Bytes=160, Signal Type=2) Mar 21 23:06:55.560: //4241/544C95E8AFB0/CCAPI/cc_api_caps_ind: Caps(Playout Mode=1, Playout Initial=60(ms), Playout Min=40(ms), Playout Max=1000(ms), Fax Nom=300(ms)) Mar 21 23:06:55.560: //4242/544C95E8AFB0/CCAPI/cc_api_caps_ind: Destination Interface=0x4BA4EAC4, Destination Call Id=4241, Source Call Id=4242, Caps(Codec=0x1, Fax Rate=0x1, Vad=0x1, Modem=0x2, Codec Bytes=160, Signal Type=2) Mar 21 23:06:55.560: //4242/544C95E8AFB0/CCAPI/cc_api_caps_ind: Caps(Playout Mode=1, Playout Initial=60(ms), Playout Min=40(ms), Playout Max=1000(ms), Fax Nom=300(ms)) Mar 21 23:06:55.560: //4242/544C95E8AFB0/CCAPI/cc_api_caps_ack: Destination Interface=0x4BA4EAC4, Destination Call Id=4241, Source Call Id=4242, Caps(Codec=g711ulaw(0x1), Fax Rate=FAX_RATE_VOICE(0x2), Vad=OFF(0x1), Modem=ON(0x2), Codec Bytes=160, Signal Type=2, Seq Num Start=7545) Mar 21 23:06:55.560: //4241/544C95E8AFB0/CCAPI/cc_api_caps_ack: Destination Interface=0x4A04C394, Destination Call Id=4242, Source Call Id=4241, Caps(Codec=g711ulaw(0x1), Fax Rate=FAX_RATE_NONE(0x1), Vad=OFF(0x1), Modem=ON(0x2), Codec Bytes=160, Signal Type=2, Seq Num Start=7813) Mar 21 23:06:55.560: //4241/544C95E8AFB0/CCAPI/ccCallFeature: Feature Type=25, Call Id=4241 Mar 21 23:06:55.560: SkinnyGetCallState for DN 54 chan 1 ALERTING Mar 21 23:06:55.560: called DN -1 chan 1, calling DN -1 chan 1 phone 30 s2s:0 Mar 21 23:06:55.564: dn_callerid_update DN 54 number= 602XXXX403 name= in state ALERTING Mar 21 23:06:55.564: dn_callerid_update (outgoing) DN 54 info updated to Mar 21 23:06:55.564: calling= 888 called= 602XXXX403 origCalled= 107 Mar 21 23:06:55.564: callingName= Wilder, calledName= , origCalledName= Ext 107, redirectedTo = 9602XXXX403 Mar 21 23:06:55.564: ephone-30[29/34][SEP001D09CCADEE]:refreshDisplayLine for line 1 DN 54 chan 1 Mar 21 23:06:55.564: DN 54 chan 1 End Voice_Mode Mar 21 23:06:55.564: SetDnCodec DN 54 chan 1 codec 4:G711Ulaw64k vad 0 size 160 Mar 21 23:06:55.564: DN 54 chan 1 Voice_Mode Mar 21 23:06:55.564: SkinnyGetCallState for DN 54 chan 1 ALERTING Mar 21 23:06:55.564: called DN -1 chan 1, calling DN -1 chan 1 phone 30 s2s:0 Mar 21 23:06:55.564: dn_tone_control DN=54 chan 1 tonetype=0:DtSilence onoff=0 pid=296 Mar 21 23:06:55.564: SkinnyGetCallState for DN 54 chan 1 ALERTING Mar 21 23:06:55.564: called DN -1 chan 1, calling DN -1 chan 1 phone 30 s2s:0 Mar 21 23:06:55.564: SkinnyGetCallState for DN 54 chan 1 ALERTING Mar 21 23:06:55.564: called DN -1 chan 1, calling DN -1 chan 1 phone 30 s2s:0 Mar 21 23:06:55.564: ephone-30[29/34][SEP001D09CCADEE]:is_auto_local 0 for DN 54 Mar 21 23:06:55.564: ephone-30[29/34]:Tone Off ignored - already sent Mar 21 23:06:55.564: //4241/544C95E8AFB0/CCAPI/cc_api_voice_mode_event: Call Id=4241 Mar 21 23:06:55.564: //4241/544C95E8AFB0/CCAPI/cc_api_voice_mode_event: Call Entry(Context=0x47D0F838) Mar 21 23:06:55.568: //4242/544C95E8AFB0/CCAPI/cc_api_voice_mode_event: Call Id=4242 Mar 21 23:06:55.568: //4242/544C95E8AFB0/CCAPI/cc_api_voice_mode_event: Call Entry(Context=0x47D1FCA0) Mar 21 23:06:55.568: SkinnyGetCallState for DN 54 chan 1 ALERTING Mar 21 23:06:55.568: called DN -1 chan 1, calling DN -1 chan 1 phone 30 s2s:0 Mar 21 23:06:55.568: SkinnyUpdateDnState by EFXS_OPEN_VOICE_PATH for DN 54 chan 1 to state CALL_START Mar 21 23:06:55.568: ephone-30[29/34]:UpdateCallState DN 54 chan 1 state 12 calleddn -1 chan 1 Mar 21 23:06:55.568: ephone-30[29/34]:Binding ephone-30 to DN 54 chan 1 s2s:0 Mar 21 23:06:55.568: ephone-30[29/34]:Send StopTone for parche/seaview phones before OpenReceive Mar 21 23:06:55.568: SkinnyGetCallState for DN 54 chan 1 ALERTING Mar 21 23:06:55.568: called DN -1 chan 1, calling DN -1 chan 1 phone 30 s2s:0 Mar 21 23:06:55.568: ephone-30[29/34][SEP001D09CCADEE]:is_auto_local 0 for DN 54 Mar 21 23:06:55.568: ephone-30[29/34]:Tone Off ignored - already sent Mar 21 23:06:55.568: peer_vdb->physical_interface_type is 13 for DN 54 chan 1 at SkinnyIsPeerNonSCCP Mar 21 23:06:55.568: ephone-30[34]:OpenReceive DN 54 chan 1, addrType = 0: Mar 21 23:06:55.568: ephone-30[34]:OpenReceive DN 54 chan 1 codec 4:G711Ulaw64k duration 20 ms bytes 160 Mar 21 23:06:55.568: ephone-30[29/34]:SkinnyOpenReceiveV17: OpenReceive sent: normal confID=108 ref=2312 dn=54 ch=1 Mar 21 23:06:55.568: ephone-30[29/34][SEP001D09CCADEE]:checkToOpenMultiMedia: dn=54, chan=1 Mar 21 23:06:55.568: ephone-30[29/34][SEP001D09CCADEE]:skinnyDP[54].s2s = 0 Mar 21 23:06:55.568: ephone-30[29/34]:s2s is not set for video. Mar 21 23:06:55.568: Skinny Call State change for DN 54 chan 1 ALERTING from ALERTING Mar 21 23:06:55.568: ephone-(30) DN 54 chan 1 calledDn -1 chan 1 callingDn -1 chan 1 :: port=0 Mar 21 23:06:55.568: SkinnyGetCallState for DN 54 chan 1 ALERTING Mar 21 23:06:55.568: called DN -1 chan 1, calling DN -1 chan 1 phone 30 s2s:0 Mar 21 23:06:55.568: ephone-30[34]:SetLineLamp 1 to ON Mar 21 23:06:55.568: //4241/544C95E8AFB0/CCAPI/cc_process_notify_bridge_done: Conference Id=0x510, Call Id1=4241, Call Id2=4242 Mar 21 23:06:55.572: Sending message 0x4BA2E398 to phone 30, sock 34, SkinnyMessageID = StationConnectionStatisticsReqID Mar 21 23:06:55.572: Sending message 0x4BA2D018 to phone 30, sock 34, SkinnyMessageID = StationConnectionStatisticsReqID Mar 21 23:06:55.572: Sending message 0x4B92DF28 to phone 30, sock 34, SkinnyMessageID = StationOpenReceiveChannelID Mar 21 23:06:55.572: Sending message 0x4BA0E688 to phone 30, sock 34, SkinnyMessageID = StationSetLampMessageID Mar 21 23:06:55.972: Received message from phone 30, sock 34, SkinnyMessageID = StationOpenReceiveChannelAckID Mar 21 23:06:55.972: ephone-30[29/34]:Outgoing calling DN 54 chan 1 FarPhone -1 called DN -1 chan 1 Mar 21 23:06:55.972: ephone-30[34]:OpenReceiveChannelAck:IP 192.168.0.235, port=24580, dn_index=54, dn=54, chan=1 Mar 21 23:06:55.972: SkinnyGetCallState for DN 54 chan 1 ALERTING Mar 21 23:06:55.972: called DN -1 chan 1, calling DN -1 chan 1 phone 30 s2s:0 Mar 21 23:06:55.972: ephone-30[29/34][SEP001D09CCADEE]:s2s=0 DN:54 chan 1 Mar 21 23:06:55.972: ephone-30[29/34]:No local phone match for start media Mar 21 23:06:55.972: ephone-30[29/34]:NO LOCAL MATCH START MEDIA Mar 21 23:06:55.972: ephone-30[29/34][SEP001D09CCADEE]:STATE MEDIA NEAR PAGING media_dn 54, media_dn_chan 1 Mar 21 23:06:55.972: ephone-30[29/34]:fStationOpenReceiveChannelAckMessageV17: .SkinnyStartMedia media_dn 54 for dn 54 chan 1 Mar 21 23:06:55.972: ephone-30[29/34]:StartMedia media_dn=54 media_ch=1 activeLine=1 whisperLine=0 Mar 21 23:06:55.972: SkinnyGetCallState for DN 54 chan 1 ALERTING Mar 21 23:06:55.972: called DN -1 chan 1, calling DN -1 chan 1 phone 30 s2s:0 Mar 21 23:06:55.972: ephone-30[29/34][SEP001D09CCADEE]:SkinnyGetToneRef toneRef 0x0 callRef 0x908 Mar 21 23:06:55.972: ephone-30[29/34]:SkinnyStartMediaV17: StopTone sent: normal line=1 ref=2312 tone=0x0 Mar 21 23:06:55.972: ephone-30[34]:StartMedia 192.168.0.8 port=2000 Mar 21 23:06:55.972: DN 54 chan 1 codec 4:G711Ulaw64k duration 20 ms bytes 160 Mar 21 23:06:55.972: ephone-30[29/34]:SkinnyStartMediaV17: StartMedia sent: normal confID=108 ref=2312 Mar 21 23:06:55.976: Sending message 0x4BA0E688 to phone 30, sock 34, SkinnyMessageID = StationStopToneMessageID Mar 21 23:06:55.976: Sending message 0x4B92DF28 to phone 30, sock 34, SkinnyMessageID = StationStartMediaTransmissionID Mar 21 23:06:55.976: ephone-30[29/34][SEP001D09CCADEE]:Refresh Display for line 1 chan 1 Mar 21 23:06:55.976: SkinnyGetCallState for DN 54 chan 1 ALERTING Mar 21 23:06:55.976: called DN -1 chan 1, calling DN -1 chan 1 phone 30 s2s:0 Mar 21 23:06:55.976: ephone-30[29/34][SEP001D09CCADEE]:SkinnyDisplayCallInfo outgoing call line 1 ref 2312 Mar 21 23:06:55.980: ephone-30[29/34][SEP001D09CCADEE]:SkinnyDisplayCallInfo callingNumber=888 Mar 21 23:06:55.980: ephone-30[29/34][SEP001D09CCADEE]:SkinnyDisplayCallInfo calledNumber=9602XXXX403 Mar 21 23:06:55.980: ephone-30[34]::callingNumber 888 Mar 21 23:06:55.980: ephone-30[34]::callingParty 888 Mar 21 23:06:55.980: ephone-30[29/34]:Call Info DN 54 line 1 ref 2312 call state 1 called 602XXXX403 calling 888 origcalled 107 Mar 21 23:06:55.980: ephone-30[29/34]:SkinnyTryCall to 9602XXXX403 instance 1 start at 0 secondary 0 Mar 21 23:06:55.980: ephone-30[29/34][SEP001D09CCADEE]: Mar 21 23:06:55.980: bulk_speeddial_update_callinfo: 29 Mar 21 23:06:55.980: ephone-30[29/34]:Call Info DN 54 line 1 ref 2312 called 9602XXXX403 calling 888 alternateCalling 888 origcalled 107 calltype 2 Mar 21 23:06:55.980: ephone-30[29/34][SEP001D09CCADEE]:Call Info for chan 1 Mar 21 23:06:55.980: ephone-30[29/34][SEP001D09CCADEE]:Original Called Name Ext 107 Mar 21 23:06:55.980: ephone-30[29/34][SEP001D09CCADEE]:SkinnyDisplayCallInfo callingName=Wilder Mar 21 23:06:55.980: ephone-30[29/34]:SkinnyDisplayCallInfo No-calledName Mar 21 23:06:55.980: peer_vdb->physical_interface_type is 13 for DN 54 chan 1 at SkinnyIsPeerNonSCCP Mar 21 23:06:55.980: Sending message 0x4B86765C to phone 30, sock 34, SkinnyMessageID = StationCallInfoV2MessageID Mar 21 23:06:56.728: Received message from phone 30, sock 34, SkinnyMessageID = StationStartMediaTransmissionAckMessageID Mar 21 23:06:56.728: ephone-30[29/34]:StartMediaTransmissionAckMessage Mar 21 23:06:56.728: ephone-30[29/34][SEP001D09CCADEE]:StartMediaTransmissionAck callref 2312 OK Mar 21 23:06:57.316: Received message from phone 7, sock 27, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:06:57.320: Sending message 0x4BA21F08 to phone 7, sock 27, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:06:57.320: Received message from phone 15, sock 23, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:06:57.320: Received message from phone 22, sock 7, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:06:57.320: Sending message 0x4BA21F08 to phone 15, sock 23, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:06:57.320: Sending message 0x4BA21D80 to phone 22, sock 7, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:06:58.252: Received message from phone 36, sock 14, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:06:58.256: Sending message 0x4BA21D80 to phone 36, sock 14, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:06:58.260: Received message from phone 30, sock 34, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:06:58.260: Received message from phone 24, sock 15, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:06:58.260: Received message from phone 33, sock 21, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:06:58.260: Sending message 0x4BA21D80 to phone 30, sock 34, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:06:58.264: Sending message 0x4BA21F08 to phone 24, sock 15, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:06:58.264: Sending message 0x4BA22448 to phone 33, sock 21, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:07:00.308: Received message from phone 3, sock 19, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:07:00.308: Sending message 0x4BA22448 to phone 3, sock 19, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:07:00.396: Sending message 0x4BA2D018 to phone 30, sock 34, SkinnyMessageID = StationConnectionStatisticsReqID Mar 21 23:07:00.400: Received message from phone 30, sock 34, SkinnyMessageID = StationConnectionStatisticsResID Mar 21 23:07:02.088: Received message from phone 34, sock 25, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:07:02.088: Sending message 0x4BA22448 to phone 34, sock 25, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:07:03.704: Received message from phone 2, sock 29, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:07:03.704: Sending message 0x4BA22448 to phone 2, sock 29, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:07:04.924: Received message from phone 37, sock 18, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:07:04.924: Sending message 0x4BA22608 to phone 37, sock 18, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:07:05.396: Sending message 0x4BA29F98 to phone 30, sock 34, SkinnyMessageID = StationConnectionStatisticsReqID Mar 21 23:07:05.400: Received message from phone 30, sock 34, SkinnyMessageID = StationConnectionStatisticsResID Mar 21 23:07:05.992: ISDN Se0/3/0:23 Q931: RX <- DISCONNECT pd = 8 callref = 0x81FF Cause i = 0x8292 - No user responding Mar 21 23:07:05.996: ISDN Se0/3/0:23 Q931: TX -> RELEASE pd = 8 callref = 0x01FF Mar 21 23:07:05.996: //4242/544C95E8AFB0/CCAPI/cc_api_call_disconnected: Cause Value=18, Interface=0x4A04C394, Call Id=4242 Mar 21 23:07:05.996: //4242/544C95E8AFB0/CCAPI/cc_api_call_disconnected: Call Entry(Responsed=TRUE, Cause Value=18, Retry Count=0) Mar 21 23:07:05.996: //4241/544C95E8AFB0/CCAPI/ccCallReleaseResources: release reserved xcoding resource. Mar 21 23:07:05.996: //4242/544C95E8AFB0/CCAPI/ccCallSetAAA_Accounting: Accounting=0, Call Id=4242 Mar 21 23:07:05.996: //4241/544C95E8AFB0/CCAPI/ccConferenceDestroy: Conference Id=0x510, Tag=0x0 Mar 21 23:07:05.996: //4241/544C95E8AFB0/CCAPI/cc_api_bridge_drop_done: Conference Id=0x510, Source Interface=0x4BA4EAC4, Source Call Id=4241, Destination Call Id=4242, Disposition=0x0, Tag=0x0 Mar 21 23:07:05.996: //4242/544C95E8AFB0/CCAPI/cc_api_bridge_drop_done: Conference Id=0x510, Source Interface=0x4A04C394, Source Call Id=4242, Destination Call Id=4241, Disposition=0x0, Tag=0x0 Mar 21 23:07:05.996: //4241/544C95E8AFB0/CCAPI/cc_generic_bridge_done: Conference Id=0x510, Source Interface=0x4A04C394, Source Call Id=4242, Destination Call Id=4241, Disposition=0x0, Tag=0x0 Mar 21 23:07:06.000: //4242/544C95E8AFB0/CCAPI/ccCallDisconnect: Cause Value=18, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=18) Mar 21 23:07:06.000: //4242/544C95E8AFB0/CCAPI/ccCallDisconnect: Cause Value=18, Call Entry(Responsed=TRUE, Cause Value=18) Mar 21 23:07:06.000: //4242/544C95E8AFB0/CCAPI/cc_api_get_transfer_info: Transfer Number Is Null Mar 21 23:07:06.000: //4241/544C95E8AFB0/CCAPI/ccGenerateToneInfo: Stop Tone On Digit=FALSE, Tone=Ring Back, Tone Direction=Network, Params=0x0, Call Id=4241 Mar 21 23:07:06.000: SkinnyTransfereeHairpinRinging: dn 54 chan 1 tonetype 36 Mar 21 23:07:06.000: dn_tone_control DN=54 chan 1 tonetype=36:DtAlertingTone onoff=1 pid=296 Mar 21 23:07:06.000: SkinnyGetCallState for DN 54 chan 1 ALERTING Mar 21 23:07:06.000: called DN -1 chan 1, calling DN -1 chan 1 phone 30 s2s:0 Mar 21 23:07:06.000: ephone-30[29/34][SEP001D09CCADEE]:Tone ON during active media DN 54 chan 1 Mar 21 23:07:06.000: ephone-30[29/34][SEP001D09CCADEE]:Alerting Tone for DN 54 chan 1 when media is active Mar 21 23:07:06.000: SkinnyGetCallState for DN 54 chan 1 ALERTING Mar 21 23:07:06.000: called DN -1 chan 1, calling DN -1 chan 1 phone 30 s2s:0 Mar 21 23:07:06.000: ephone_get_callid_from_dn_chan: dn[54] chan[1] callID[4241] Mar 21 23:07:06.000: ephone-30[29/34][SEP001D09CCADEE]:is_auto_local 0 for DN 54 Mar 21 23:07:06.000: ephone-30[29/34]:DtAlertingTone - mediaRestoreAlerting set during ALERTING Mar 21 23:07:06.000: ephone-30[29/34]:SkinnyStopMedia: normal line=1 dn=54 ch=1 Mar 21 23:07:06.004: ephone-30[29/34]:SkinnyStopMedia: CloseReceive sent: normal confID=108 ref=2312 Mar 21 23:07:06.004: ephone-30[29/34][SEP001D09CCADEE]:SkinnyStopMedia: Multimedia not active Mar 21 23:07:06.004: ephone-30[29/34]:SkinnyStopMedia: StopMedia sent: normal confID=108 ref=2312 Mar 21 23:07:06.004: ephone-30[29/34][SEP001D09CCADEE]:SkinnySetToneRef callRef 0x908 tone 0x24 Mar 21 23:07:06.004: ephone-30[29/34]:SkinnyPhoneTone: StartTone sent: normal line=1 ref=2312 tone=0x24 Mar 21 23:07:06.004: Skinny StartTone 36 sent on ephone socket [34] DtAlertingTone Mar 21 23:07:06.004: Sending message 0x4BA2E398 to phone 30, sock 34, SkinnyMessageID = StationConnectionStatisticsReqID Mar 21 23:07:06.004: Sending message 0x4BA0EEF8 to phone 30, sock 34, SkinnyMessageID = StationCloseReceiveChannelID Mar 21 23:07:06.004: Sending message 0x4BA10410 to phone 30, sock 34, SkinnyMessageID = StationStopMediaTransmissionID Mar 21 23:07:06.004: Sending message 0x4BA2CC98 to phone 30, sock 34, SkinnyMessageID = StationConnectionStatisticsReqID Mar 21 23:07:06.004: Sending message 0x4BA0E688 to phone 30, sock 34, SkinnyMessageID = StationStartToneMessageID Mar 21 23:07:06.008: Received message from phone 30, sock 34, SkinnyMessageID = StationConnectionStatisticsResID Mar 21 23:07:06.008: ephone-30[29/34][SEP001D09CCADEE]:Update Stats Total for DN 54 chan 1 Mar 21 23:07:06.148: ISDN Se0/3/0:23 Q931: RX <- RELEASE_COMP pd = 8 callref = 0x81FF Mar 21 23:07:06.152: //4242/544C95E8AFB0/CCAPI/cc_api_call_disconnect_done: Disposition=0, Interface=0x4A04C394, Tag=0x0, Call Id=4242, Call Entry(Disconnect Cause=18, Voice Class Cause Code=0, Retry Count=0) Mar 21 23:07:06.152: //4242/544C95E8AFB0/CCAPI/cc_api_call_disconnect_done: Call Disconnect Event Sent Mar 21 23:07:06.152: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa: Mar 21 23:07:06.152: :cc_free_feature_vsa freeing 47D06A70 Mar 21 23:07:06.152: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa: Mar 21 23:07:06.152: vsacount in free is 3 Mar 21 23:07:06.152: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa: Mar 21 23:07:06.152: vsacount in free is 2 Mar 21 23:07:06.156: //4241/544C95E8AFB0/CCAPI/ccCallDisconnect: Cause Value=18, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0) Mar 21 23:07:06.156: //4241/544C95E8AFB0/CCAPI/ccCallDisconnect: Cause Value=18, Call Entry(Responsed=TRUE, Cause Value=18) Mar 21 23:07:06.156: //4241/544C95E8AFB0/CCAPI/cc_api_get_transfer_info: Transfer Number Is Null Mar 21 23:07:06.156: dn_tone_control DN=54 chan 1 tonetype=0:DtSilence onoff=0 pid=296 Mar 21 23:07:06.156: SkinnyGetCallState for DN 54 chan 1 ALERTING Mar 21 23:07:06.156: called DN -1 chan 1, calling DN -1 chan 1 phone 30 s2s:0 Mar 21 23:07:06.156: SkinnyGetCallState for DN 54 chan 1 ALERTING Mar 21 23:07:06.156: called DN -1 chan 1, calling DN -1 chan 1 phone 30 s2s:0 Mar 21 23:07:06.156: ephone-30[29/34][SEP001D09CCADEE]:is_auto_local 0 for DN 54 Mar 21 23:07:06.156: ephone-30[29/34][SEP001D09CCADEE]:SkinnyGetToneRef toneRef 0x908 callRef 0x908 Mar 21 23:07:06.156: ephone-30[29/34]:SkinnyPhoneTone: StopTone sent: normal line=1 ref=2312 tone=0x0 Mar 21 23:07:06.156: ephone-30[29/34]:Tone Off - mediaRestore Mar 21 23:07:06.156: ephone-30[29/34]:Tone Off - mediaRestoreAlerting force CALL_START Mar 21 23:07:06.156: ephone-30[29/34]:UpdateCallState DN 54 chan 1 state 12 calleddn -1 chan 1 Mar 21 23:07:06.160: ephone-30[29/34]:Binding ephone-30 to DN 54 chan 1 s2s:0 Mar 21 23:07:06.160: ephone-30[29/34]:Send StopTone for parche/seaview phones before OpenReceive Mar 21 23:07:06.160: SkinnyGetCallState for DN 54 chan 1 ALERTING Mar 21 23:07:06.160: called DN -1 chan 1, calling DN -1 chan 1 phone 30 s2s:0 Mar 21 23:07:06.160: ephone-30[29/34][SEP001D09CCADEE]:is_auto_local 0 for DN 54 Mar 21 23:07:06.160: ephone-30[29/34]:Tone Off ignored - already sent Mar 21 23:07:06.160: peer_vdb->physical_interface_type is 13 for DN 54 chan 1 at SkinnyIsPeerNonSCCP Mar 21 23:07:06.160: ephone-30[34]:OpenReceive DN 54 chan 1, addrType = 0: Mar 21 23:07:06.160: ephone-30[34]:OpenReceive DN 54 chan 1 codec 4:G711Ulaw64k duration 20 ms bytes 160 Mar 21 23:07:06.160: ephone-30[29/34]:SkinnyOpenReceiveV17: OpenReceive sent: normal confID=108 ref=2312 dn=54 ch=1 Mar 21 23:07:06.160: ephone-30[29/34][SEP001D09CCADEE]:checkToOpenMultiMedia: dn=54, chan=1 Mar 21 23:07:06.160: ephone-30[29/34][SEP001D09CCADEE]:skinnyDP[54].s2s = 0 Mar 21 23:07:06.160: ephone-30[29/34]:s2s is not set for video. Mar 21 23:07:06.160: Skinny Call State change for DN 54 chan 1 ALERTING from ALERTING Mar 21 23:07:06.160: ephone-(30) DN 54 chan 1 calledDn -1 chan 1 callingDn -1 chan 1 192.168.0.235 port=24580 Mar 21 23:07:06.160: SkinnyGetCallState for DN 54 chan 1 ALERTING Mar 21 23:07:06.160: called DN -1 chan 1, calling DN -1 chan 1 phone 30 s2s:0 Mar 21 23:07:06.160: ephone-30[34]:SetLineLamp 1 to ON Mar 21 23:07:06.160: ephone-30[29/34]:Tone Off ignored - already sent Mar 21 23:07:06.160: SkinnyTransfereeHairpinRinging: dn 54 chan 1 tonetype 37 Mar 21 23:07:06.160: dn_tone_control DN=54 chan 1 tonetype=37:DtReorderTone onoff=1 pid=296 Mar 21 23:07:06.160: ephone-30[29/34][SEP001D09CCADEE]:DN 54 disc reason 18 state ALERTING Mar 21 23:07:06.160: SkinnyGetCallState for DN 54 chan 1 ALERTING Mar 21 23:07:06.160: called DN -1 chan 1, calling DN -1 chan 1 phone 30 s2s:0 Mar 21 23:07:06.160: SkinnyGetCallState for DN 54 chan 1 ALERTING Mar 21 23:07:06.160: called DN -1 chan 1, calling DN -1 chan 1 phone 30 s2s:0 Mar 21 23:07:06.160: ephone-30[29/34]:PhoneTone ReOrder tone calls StopMedia Mar 21 23:07:06.160: ephone-30[29/34]:SkinnyStopMedia: normal line=1 dn=54 ch=1 Mar 21 23:07:06.160: ephone-30[29/34]:SkinnyStopMedia: CloseReceive sent: normal confID=108 ref=2312 Mar 21 23:07:06.160: ephone-30[29/34][SEP001D09CCADEE]:SkinnyStopMedia: Multimedia not active Mar 21 23:07:06.160: ephone-30[29/34]:SkinnyStopMedia: StopMedia sent: normal confID=0 ref=0 Mar 21 23:07:06.160: ephone-30[29/34][SEP001D09CCADEE]:is_auto_local 0 for DN 54 Mar 21 23:07:06.160: ephone-30[29/34][SEP001D09CCADEE]:SkinnySetToneRef callRef 0x908 tone 0x25 Mar 21 23:07:06.160: ephone-30[29/34]:SkinnyPhoneTone: StartTone sent: normal line=1 ref=2312 tone=0x25 Mar 21 23:07:06.160: Skinny StartTone 37 sent on ephone socket [34] DtReorderTone Mar 21 23:07:06.160: ephone-30[29/34]:CallPrompt line 1 ref 2312:tag 122 (Ring Out) Mar 21 23:07:06.160: ephone-30[29/34]:SelectPhoneSoftKeys set 8 mask FFFE for line 1 ref 2312 Mar 21 23:07:06.160: ephone-30[29/34]:CallPrompt line 1 ref 2312:tag 125 (Busy) Mar 21 23:07:06.164: Sending message 0x4BA0F4C0 to phone 30, sock 34, SkinnyMessageID = StationStopToneMessageID Mar 21 23:07:06.164: Sending message 0x4BA2B458 to phone 30, sock 34, SkinnyMessageID = StationConnectionStatisticsReqID Mar 21 23:07:06.164: Sending message 0x4BA2BE98 to phone 30, sock 34, SkinnyMessageID = StationConnectionStatisticsReqID Mar 21 23:07:06.164: Sending message 0x47CEBCB4 to phone 30, sock 34, SkinnyMessageID = StationOpenReceiveChannelID Mar 21 23:07:06.164: Sending message 0x4BA11068 to phone 30, sock 34, SkinnyMessageID = StationSetLampMessageID Mar 21 23:07:06.164: Sending message 0x4BA29F98 to phone 30, sock 34, SkinnyMessageID = StationConnectionStatisticsReqID Mar 21 23:07:06.164: Sending message 0x4BA10B18 to phone 30, sock 34, SkinnyMessageID = StationCloseReceiveChannelID Mar 21 23:07:06.164: Sending message 0x4BA0F880 to phone 30, sock 34, SkinnyMessageID = StationStopMediaTransmissionID Mar 21 23:07:06.164: Sending message 0x4BA2A0D8 to phone 30, sock 34, SkinnyMessageID = StationConnectionStatisticsReqID Mar 21 23:07:06.164: Sending message 0x4BA0ED68 to phone 30, sock 34, SkinnyMessageID = StationStartToneMessageID Mar 21 23:07:06.168: Sending message 0x4BAEA284 to phone 30, sock 34, SkinnyMessageID = StationDisplayPromptStatusV2MessageID Mar 21 23:07:06.168: Sending message 0x4BA104D8 to phone 30, sock 34, SkinnyMessageID = StationSelectSoftKeysMessageID Mar 21 23:07:06.168: Sending message 0x4BAEA318 to phone 30, sock 34, SkinnyMessageID = StationDisplayPromptStatusV2MessageID Mar 21 23:07:06.168: Received message from phone 30, sock 34, SkinnyMessageID = StationConnectionStatisticsResID Mar 21 23:07:06.168: ephone-30[29/34][SEP001D09CCADEE]:Update Stats Total for DN 54 chan 1 Mar 21 23:07:06.368: Received message from phone 30, sock 34, SkinnyMessageID = StationOpenReceiveChannelAckID Mar 21 23:07:06.368: ephone-30[29/34]:OpenReceiveChannelAck with mediaActive==FALSE Mar 21 23:07:06.368: ephone-30[29/34][SEP001D09CCADEE]:Media already stopped line 1 DN 54 chan 1 Mar 21 23:07:06.368: Received message from phone 30, sock 34, SkinnyMessageID = StationConnectionStatisticsResID Mar 21 23:07:07.296: Received message from phone 13, sock 30, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:07:07.296: Sending message 0x4BA22250 to phone 13, sock 30, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:07:07.788: Received message from phone 27, sock 33, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:07:07.792: Sending message 0x4BA22250 to phone 27, sock 33, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:07:08.328: Received message from phone 26, sock 26, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:07:08.328: Sending message 0x4BA22250 to phone 26, sock 26, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:07:09.040: Received message from phone 8, sock 31, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:07:09.040: Sending message 0x4BA22250 to phone 8, sock 31, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:07:09.452: Received message from phone 23, sock 1, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:07:09.452: Sending message 0x4BA22250 to phone 23, sock 1, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:07:10.168: Received message from phone 14, sock 9, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:07:10.168: Sending message 0x4BA22250 to phone 14, sock 9, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:07:10.396: ephone-1[0/24][SEP000F342FACDA]:SkinnyCheckPendingCallBackPhone scan 1 lines Mar 21 23:07:10.396: ephone-2[1/29][SEP000F24BA3608]:SkinnyCheckPendingCallBackPhone scan 1 lines Mar 21 23:07:10.396: ephone-3[2/19][SEP00170E9FD25C]:SkinnyCheckPendingCallBackPhone scan 2 lines Mar 21 23:07:10.396: ephone-4[3/20][SEP00170E9FD31C]:SkinnyCheckPendingCallBackPhone scan 2 lines Mar 21 23:07:10.396: ephone-5[4/3][SEP001795348D7B]:SkinnyCheckPendingCallBackPhone scan 2 lines Mar 21 23:07:10.396: ephone-6[5/10][SEP000F24AAA09A]:SkinnyCheckPendingCallBackPhone scan 1 lines Mar 21 23:07:10.396: ephone-7[6/27][SEP000F24BA2C77]:SkinnyCheckPendingCallBackPhone scan 1 lines Mar 21 23:07:10.396: ephone-8[7/31][SEP000F24BA2B73]:SkinnyCheckPendingCallBackPhone scan 1 lines Mar 21 23:07:10.396: ephone-9[8/4][SEP0024142F9A56]:SkinnyCheckPendingCallBackPhone scan 2 lines Mar 21 23:07:10.400: ephone-10[9/22][SEP000F24BA306E]:SkinnyCheckPendingCallBackPhone scan 1 lines Mar 21 23:07:10.400: ephone-11[10/2][SEP00170E9FD160]:SkinnyCheckPendingCallBackPhone scan 2 lines Mar 21 23:07:10.400: ephone-12[11/13][SEP001795B678EE]:SkinnyCheckPendingCallBackPhone scan 2 lines Mar 21 23:07:10.400: ephone-13[12/30][SEP000F24AAA1CA]:SkinnyCheckPendingCallBackPhone scan 1 lines Mar 21 23:07:10.400: ephone-14[13/9][SEP000F24F2A6AA]:SkinnyCheckPendingCallBackPhone scan 1 lines Mar 21 23:07:10.400: ephone-15[14/23][SEP000F245D8FA5]:SkinnyCheckPendingCallBackPhone scan 1 lines Mar 21 23:07:10.400: ephone-16[15/17][SEP000F24AAA19A]:SkinnyCheckPendingCallBackPhone scan 1 lines Mar 21 23:07:10.400: ephone-17[16/16][SEP000F24AAA214]:SkinnyCheckPendingCallBackPhone scan 1 lines Mar 21 23:07:10.400: ephone-18[17/11][SEP0016C87D699C]:SkinnyCheckPendingCallBackPhone scan 2 lines Mar 21 23:07:10.400: ephone-19[18/8][SEP000F248A8031]:SkinnyCheckPendingCallBackPhone scan 1 lines Mar 21 23:07:10.400: ephone-21[20/28][SEP000F34117645]:SkinnyCheckPendingCallBackPhone scan 1 lines Mar 21 23:07:10.400: ephone-22[21/7][SEP000F248A8146]:SkinnyCheckPendingCallBackPhone scan 1 lines Mar 21 23:07:10.400: ephone-23[22/1][SEP001B5452DAD7]:SkinnyCheckPendingCallBackPhone scan 8 lines Mar 21 23:07:10.400: ephone-24[23/15][SEP00175A6DCC2B]:SkinnyCheckPendingCallBackPhone scan 1 lines Mar 21 23:07:10.400: ephone-26[25/26][SEP0014A923B88B]:SkinnyCheckPendingCallBackPhone scan 1 lines Mar 21 23:07:10.400: ephone-27[26/33][SEP0014A97143F1]:SkinnyCheckPendingCallBackPhone scan 6 lines Mar 21 23:07:10.400: ephone-28[27/32][SEP0014A923BCEB]:SkinnyCheckPendingCallBackPhone scan 1 lines Mar 21 23:07:10.400: ephone-29[28/12][SEP000F24F2A3E0]:SkinnyCheckPendingCallBackPhone scan 1 lines Mar 21 23:07:10.400: ephone-31[30/5][SEP0014A9DEE72E]:SkinnyCheckPendingCallBackPhone scan 6 lines Mar 21 23:07:10.400: ephone-33[32/21][SEP00175A6DCC62]:SkinnyCheckPendingCallBackPhone scan 1 lines Mar 21 23:07:10.400: ephone-34[33/25][SEP00175AB1B2DC]:SkinnyCheckPendingCallBackPhone scan 1 lines Mar 21 23:07:10.400: ephone-35[34/6][SEP00175AB1B3D1]:SkinnyCheckPendingCallBackPhone scan 1 lines Mar 21 23:07:10.400: ephone-36[35/14][SEP00175A4A9767]:SkinnyCheckPendingCallBackPhone scan 1 lines Mar 21 23:07:10.400: ephone-37[36/18][SEP001759C48D5F]:SkinnyCheckPendingCallBackPhone scan 1 lines Mar 21 23:07:10.404: Sending message 0x4BA22250 to phone 1, sock 24, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.404: Sending message 0x4BA22608 to phone 1, sock 24, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.404: Sending message 0x4BA228C4 to phone 1, sock 24, SkinnyMessageID = StationClearNotifyMessageID Mar 21 23:07:10.404: Sending message 0x4BA4EF3C to phone 1, sock 24, SkinnyMessageID = StationDisplayPromptStatusMessageID Mar 21 23:07:10.404: Sending message 0x4BA22448 to phone 2, sock 29, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.404: Sending message 0x4BA21F08 to phone 2, sock 29, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.404: Sending message 0x4BA21D80 to phone 2, sock 29, SkinnyMessageID = StationClearNotifyMessageID Mar 21 23:07:10.404: Sending message 0x4BA4FE5C to phone 2, sock 29, SkinnyMessageID = StationDisplayPromptStatusMessageID Mar 21 23:07:10.404: Sending message 0x4BA22624 to phone 3, sock 19, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.404: Sending message 0x4BA21ED0 to phone 3, sock 19, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.404: Sending message 0x4BA21D10 to phone 3, sock 19, SkinnyMessageID = StationClearNotifyMessageID Mar 21 23:07:10.404: Sending message 0x4BAEA318 to phone 3, sock 19, SkinnyMessageID = StationDisplayPromptStatusV2MessageID Mar 21 23:07:10.408: Sending message 0x4BA2203C to phone 4, sock 20, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.408: Sending message 0x4BA21E44 to phone 4, sock 20, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.408: Sending message 0x4BA22020 to phone 4, sock 20, SkinnyMessageID = StationClearNotifyMessageID Mar 21 23:07:10.408: Sending message 0x4BAEA284 to phone 4, sock 20, SkinnyMessageID = StationDisplayPromptStatusV2MessageID Mar 21 23:07:10.408: Sending message 0x4BA21C68 to phone 5, sock 3, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.408: Sending message 0x4BA2249C to phone 5, sock 3, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.408: Sending message 0x4BA21CA0 to phone 5, sock 3, SkinnyMessageID = StationClearNotifyMessageID Mar 21 23:07:10.408: Sending message 0x4BAE9A6C to phone 5, sock 3, SkinnyMessageID = StationDisplayPromptStatusV2MessageID Mar 21 23:07:10.408: Sending message 0x4BA221A8 to phone 6, sock 10, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.408: Sending message 0x4BA21BF8 to phone 6, sock 10, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.408: Sending message 0x4BA2218C to phone 6, sock 10, SkinnyMessageID = StationClearNotifyMessageID Mar 21 23:07:10.408: Sending message 0x4BA4F56C to phone 6, sock 10, SkinnyMessageID = StationDisplayPromptStatusMessageID Mar 21 23:07:10.408: Sending message 0x4BA2273C to phone 7, sock 27, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.408: Sending message 0x4BA21C14 to phone 7, sock 27, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.408: Sending message 0x4BA224B8 to phone 7, sock 27, SkinnyMessageID = StationClearNotifyMessageID Mar 21 23:07:10.408: Sending message 0x4BA4F674 to phone 7, sock 27, SkinnyMessageID = StationDisplayPromptStatusMessageID Mar 21 23:07:10.408: Sending message 0x4BA22544 to phone 8, sock 31, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.408: Sending message 0x4BA22678 to phone 8, sock 31, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.412: Sending message 0x4BA22100 to phone 8, sock 31, SkinnyMessageID = StationClearNotifyMessageID Mar 21 23:07:10.412: Sending message 0x4BA4FAEC to phone 8, sock 31, SkinnyMessageID = StationDisplayPromptStatusMessageID Mar 21 23:07:10.412: Sending message 0x4BA21B88 to phone 9, sock 4, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.412: Sending message 0x4BA22138 to phone 9, sock 4, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.412: Sending message 0x4BA22950 to phone 9, sock 4, SkinnyMessageID = StationClearNotifyMessageID Mar 21 23:07:10.412: Sending message 0x4BAEAEA8 to phone 9, sock 4, SkinnyMessageID = StationDisplayPromptStatusV2MessageID Mar 21 23:07:10.412: Sending message 0x4BA222DC to phone 10, sock 22, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.412: Sending message 0x4BA221E0 to phone 10, sock 22, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.412: Sending message 0x4BA21C30 to phone 10, sock 22, SkinnyMessageID = StationClearNotifyMessageID Mar 21 23:07:10.412: Sending message 0x4BA5048C to phone 10, sock 22, SkinnyMessageID = StationDisplayPromptStatusMessageID Mar 21 23:07:10.412: Sending message 0x4BA22790 to phone 11, sock 2, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.412: Sending message 0x4BA228FC to phone 11, sock 2, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.412: Sending message 0x4BA21FB0 to phone 11, sock 2, SkinnyMessageID = StationClearNotifyMessageID Mar 21 23:07:10.412: Sending message 0x4BAE9098 to phone 11, sock 2, SkinnyMessageID = StationDisplayPromptStatusV2MessageID Mar 21 23:07:10.412: Sending message 0x4BA21A1C to phone 12, sock 13, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.412: Sending message 0x4BA227E4 to phone 12, sock 13, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.412: Sending message 0x4BA21DF0 to phone 12, sock 13, SkinnyMessageID = StationClearNotifyMessageID Mar 21 23:07:10.416: Sending message 0x4BAEB3DC to phone 12, sock 13, SkinnyMessageID = StationDisplayPromptStatusV2MessageID Mar 21 23:07:10.416: Sending message 0x4BA22170 to phone 13, sock 30, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.416: Sending message 0x4BA22090 to phone 13, sock 30, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.416: Sending message 0x4BA22640 to phone 13, sock 30, SkinnyMessageID = StationClearNotifyMessageID Mar 21 23:07:10.416: Sending message 0x4BA5032C to phone 13, sock 30, SkinnyMessageID = StationDisplayPromptStatusMessageID Mar 21 23:07:10.416: Sending message 0x4BA21F78 to phone 14, sock 9, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.416: Sending message 0x4BA21C4C to phone 14, sock 9, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.416: Sending message 0x4BA2281C to phone 14, sock 9, SkinnyMessageID = StationClearNotifyMessageID Mar 21 23:07:10.416: Sending message 0x4BA4F6CC to phone 14, sock 9, SkinnyMessageID = StationDisplayPromptStatusMessageID Mar 21 23:07:10.416: Sending message 0x4BA223A0 to phone 15, sock 23, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.416: Sending message 0x4BA220C8 to phone 15, sock 23, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.416: Sending message 0x4BA21DB8 to phone 15, sock 23, SkinnyMessageID = StationClearNotifyMessageID Mar 21 23:07:10.416: Sending message 0x4BA5074C to phone 15, sock 23, SkinnyMessageID = StationDisplayPromptStatusMessageID Mar 21 23:07:10.416: Sending message 0x4BA22720 to phone 16, sock 17, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.416: Sending message 0x4BA219E4 to phone 16, sock 17, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.416: Sending message 0x4BA21D64 to phone 16, sock 17, SkinnyMessageID = StationClearNotifyMessageID Mar 21 23:07:10.420: Sending message 0x4BA5053C to phone 16, sock 17, SkinnyMessageID = StationDisplayPromptStatusMessageID Mar 21 23:07:10.420: Sending message 0x4BA21B6C to phone 17, sock 16, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.420: Sending message 0x4BA21E7C to phone 17, sock 16, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.420: Sending message 0x4BA21FCC to phone 17, sock 16, SkinnyMessageID = StationClearNotifyMessageID Mar 21 23:07:10.420: Sending message 0x4BA4F0F4 to phone 17, sock 16, SkinnyMessageID = StationDisplayPromptStatusMessageID Mar 21 23:07:10.420: Sending message 0x4BA21F40 to phone 18, sock 11, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.420: Sending message 0x4BA223F4 to phone 18, sock 11, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.420: Sending message 0x4BA22218 to phone 18, sock 11, SkinnyMessageID = StationClearNotifyMessageID Mar 21 23:07:10.420: Sending message 0x4BAEAB30 to phone 18, sock 11, SkinnyMessageID = StationDisplayPromptStatusV2MessageID Mar 21 23:07:10.420: Sending message 0x4BA226CC to phone 19, sock 8, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.420: Sending message 0x4BA21CD8 to phone 19, sock 8, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.420: Sending message 0x4BA222C0 to phone 19, sock 8, SkinnyMessageID = StationClearNotifyMessageID Mar 21 23:07:10.420: Sending message 0x4BA4FCFC to phone 19, sock 8, SkinnyMessageID = StationDisplayPromptStatusMessageID Mar 21 23:07:10.420: Sending message 0x4BA2265C to phone 21, sock 28, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.420: Sending message 0x4BA228A8 to phone 21, sock 28, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.420: Sending message 0x4BA223D8 to phone 21, sock 28, SkinnyMessageID = StationClearNotifyMessageID Mar 21 23:07:10.424: Sending message 0x4BA4F4BC to phone 21, sock 28, SkinnyMessageID = StationDisplayPromptStatusMessageID Mar 21 23:07:10.424: Sending message 0x4BA224F0 to phone 22, sock 7, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.424: Sending message 0x4BA226B0 to phone 22, sock 7, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.424: Sending message 0x4BA21B18 to phone 22, sock 7, SkinnyMessageID = StationClearNotifyMessageID Mar 21 23:07:10.424: Sending message 0x4BA4EA6C to phone 22, sock 7, SkinnyMessageID = StationDisplayPromptStatusMessageID Mar 21 23:07:10.424: Sending message 0x4BA22288 to phone 23, sock 1, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.424: Sending message 0x4BA226E8 to phone 23, sock 1, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.424: Sending message 0x4BA21EB4 to phone 23, sock 1, SkinnyMessageID = StationClearNotifyMessageID Mar 21 23:07:10.424: Sending message 0x4BAE9410 to phone 23, sock 1, SkinnyMessageID = StationDisplayPromptStatusV2MessageID Mar 21 23:07:10.424: Sending message 0x4BA22694 to phone 24, sock 15, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.424: Sending message 0x4BA21B50 to phone 24, sock 15, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.424: Sending message 0x4BA21E28 to phone 24, sock 15, SkinnyMessageID = StationClearNotifyMessageID Mar 21 23:07:10.424: Sending message 0x4BA4EBCC to phone 24, sock 15, SkinnyMessageID = StationDisplayPromptStatusMessageID Mar 21 23:07:10.424: Sending message 0x4BA21D2C to phone 26, sock 26, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.424: Sending message 0x4BA21C84 to phone 26, sock 26, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.424: Sending message 0x4BA228E0 to phone 26, sock 26, SkinnyMessageID = StationClearNotifyMessageID Mar 21 23:07:10.424: Sending message 0x4BA4EC7C to phone 26, sock 26, SkinnyMessageID = StationDisplayPromptStatusMessageID Mar 21 23:07:10.424: Sending message 0x4BA22704 to phone 27, sock 33, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.428: Sending message 0x4BA220AC to phone 27, sock 33, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.428: Sending message 0x4BA22528 to phone 27, sock 33, SkinnyMessageID = StationClearNotifyMessageID Mar 21 23:07:10.428: Sending message 0x4BA4F40C to phone 27, sock 33, SkinnyMessageID = StationDisplayPromptStatusMessageID Mar 21 23:07:10.428: Sending message 0x4BA21BDC to phone 28, sock 32, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.428: Sending message 0x4BA21B34 to phone 28, sock 32, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.428: Sending message 0x4BA223BC to phone 28, sock 32, SkinnyMessageID = StationClearNotifyMessageID Mar 21 23:07:10.428: Sending message 0x4BA4FB9C to phone 28, sock 32, SkinnyMessageID = StationDisplayPromptStatusMessageID Mar 21 23:07:10.428: Sending message 0x4BA221FC to phone 29, sock 12, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.428: Sending message 0x4BA2211C to phone 29, sock 12, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.428: Sending message 0x4BA21AE0 to phone 29, sock 12, SkinnyMessageID = StationClearNotifyMessageID Mar 21 23:07:10.428: Sending message 0x4BA4FCA4 to phone 29, sock 12, SkinnyMessageID = StationDisplayPromptStatusMessageID Mar 21 23:07:10.428: Sending message 0x4BA21BC0 to phone 30, sock 34, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.428: Sending message 0x4BA22154 to phone 30, sock 34, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.428: Sending message 0x4BA21AFC to phone 30, sock 34, SkinnyMessageID = StationClearNotifyMessageID Mar 21 23:07:10.428: Sending message 0x4BAEB504 to phone 30, sock 34, SkinnyMessageID = StationDisplayPromptStatusV2MessageID Mar 21 23:07:10.428: Sending message 0x4BA22480 to phone 31, sock 5, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.428: Sending message 0x4BA225D0 to phone 31, sock 5, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.432: Sending message 0x4BA221C4 to phone 31, sock 5, SkinnyMessageID = StationClearNotifyMessageID Mar 21 23:07:10.432: Sending message 0x4BA4F304 to phone 31, sock 5, SkinnyMessageID = StationDisplayPromptStatusMessageID Mar 21 23:07:10.432: Sending message 0x4BA22234 to phone 33, sock 21, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.432: Sending message 0x4BA2296C to phone 33, sock 21, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.432: Sending message 0x4BA21AC4 to phone 33, sock 21, SkinnyMessageID = StationClearNotifyMessageID Mar 21 23:07:10.432: Sending message 0x4BA4F77C to phone 33, sock 21, SkinnyMessageID = StationDisplayPromptStatusMessageID Mar 21 23:07:10.432: Sending message 0x4BA22854 to phone 34, sock 25, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.432: Sending message 0x4BA22774 to phone 34, sock 25, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.432: Sending message 0x4BA2257C to phone 34, sock 25, SkinnyMessageID = StationClearNotifyMessageID Mar 21 23:07:10.432: Sending message 0x4BA4FF0C to phone 34, sock 25, SkinnyMessageID = StationDisplayPromptStatusMessageID Mar 21 23:07:10.432: Sending message 0x4BA2242C to phone 35, sock 6, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.432: Sending message 0x4BA21E98 to phone 35, sock 6, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.432: Sending message 0x4BA21A54 to phone 35, sock 6, SkinnyMessageID = StationClearNotifyMessageID Mar 21 23:07:10.432: Sending message 0x4BA50384 to phone 35, sock 6, SkinnyMessageID = StationDisplayPromptStatusMessageID Mar 21 23:07:10.432: Sending message 0x4BA2226C to phone 36, sock 14, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.432: Sending message 0x4BA22074 to phone 36, sock 14, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.432: Sending message 0x4BA21E60 to phone 36, sock 14, SkinnyMessageID = StationClearNotifyMessageID Mar 21 23:07:10.436: Sending message 0x4BA4FBF4 to phone 36, sock 14, SkinnyMessageID = StationDisplayPromptStatusMessageID Mar 21 23:07:10.436: Sending message 0x4BA2234C to phone 37, sock 18, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.436: Sending message 0x4BA22560 to phone 37, sock 18, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:10.436: Sending message 0x4BA22384 to phone 37, sock 18, SkinnyMessageID = StationClearNotifyMessageID Mar 21 23:07:10.436: Sending message 0x4BA4F724 to phone 37, sock 18, SkinnyMessageID = StationDisplayPromptStatusMessageID Mar 21 23:07:13.700: Received message from phone 19, sock 8, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:07:13.700: Sending message 0x4BA22384 to phone 19, sock 8, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:07:13.764: Received message from phone 21, sock 28, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:07:13.764: Sending message 0x4BA22384 to phone 21, sock 28, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:07:13.980: Received message from phone 12, sock 13, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:07:13.980: Sending message 0x4BA22384 to phone 12, sock 13, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:07:14.196: Received message from phone 35, sock 6, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:07:14.196: Sending message 0x4BA22384 to phone 35, sock 6, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:07:14.568: Received message from phone 4, sock 20, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:07:14.568: Sending message 0x4BA22384 to phone 4, sock 20, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:07:15.848: Received message from phone 29, sock 12, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:07:15.848: Sending message 0x4BA22384 to phone 29, sock 12, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:07:17.584: Received message from phone 16, sock 17, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:07:17.584: Sending message 0x4BA22384 to phone 16, sock 17, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:07:17.760: Received message from phone 17, sock 16, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:07:17.760: Sending message 0x4BA22384 to phone 17, sock 16, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:07:17.908: Received message from phone 1, sock 24, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:07:17.908: Sending message 0x4BA22384 to phone 1, sock 24, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:07:18.140: Received message from phone 30, sock 34, SkinnyMessageID = StationMediaPathEventMessageID Mar 21 23:07:18.140: ephone-30[29/34][SEP001D09CCADEE]:MediaPathEventMessage Speaker OFF Mar 21 23:07:18.140: ephone-30[29/34]:MediaPathEventMessage Mar 21 23:07:18.340: Received message from phone 30, sock 34, SkinnyMessageID = StationOnHookMessageID Mar 21 23:07:18.340: ephone-30[29/34][SEP001D09CCADEE]:ONHOOK (from phone msgID=7) Mar 21 23:07:18.340: ephone-30[29/34]:fStationOnHookMessage: phone normal line=1 ch=1 Mar 21 23:07:18.340: ephone-30[29/34][SEP001D09CCADEE]:ClearCallPrompt line 1 ref 2312 Mar 21 23:07:18.340: ephone-30[29/34][SEP001D09CCADEE]: Mar 21 23:07:18.340: bulk_speeddial_init_ephone: 29 Mar 21 23:07:18.340: ephone-30[29/34]:Line 1 chan 1 refresh (DN 54 state=1) Mar 21 23:07:18.340: ephone-30[29/34][SEP001D09CCADEE]:Check for transfer commit line 1 chan 1 Mar 21 23:07:18.340: ephone-30[29/34][SEP001D09CCADEE]:Clean-up transferor_dn -1 consult_dn -1 Mar 21 23:07:18.340: ephone-30[29/34][SEP001D09CCADEE]:Set FAC enabled (0) and dial mode (4) Mar 21 23:07:18.340: SkinnyGetCallState for DN 54 chan 1 ALERTING Mar 21 23:07:18.340: called DN -1 chan 1, calling DN -1 chan 1 phone 30 s2s:0 Mar 21 23:07:18.340: ephone-30[29/34][SEP001D09CCADEE]:Onhook clean up for DN 54 chan 1 in state 1 Mar 21 23:07:18.340: ephone-30[34]:call clean up this DN 54 chan 1 was calling other DN -1 chan 1 Mar 21 23:07:18.340: this ephone-30 other ephone-(-1) other DN state UNKNOWN Mar 21 23:07:18.340: ephone-30[29/34][SEP001D09CCADEE]:Media already stopped line 1 DN 54 chan 1 Mar 21 23:07:18.340: ephone-30[29/34]:UpdateCallState DN 54 chan 1 state 0 calleddn -1 chan 1 Mar 21 23:07:18.340: ephone-30[29/34]:Binding ephone-30 to DN 54 chan 1 s2s:0 Mar 21 23:07:18.340: ephone-30[29/34][SEP001D09CCADEE]:Set FAC enabled (0) and dial mode (4) Mar 21 23:07:18.340: DN 54 chan 1 End Voice_Mode Mar 21 23:07:18.340: SkinnySetDnInvokeId DN 54 chan 1 id 0 set=0 Mar 21 23:07:18.340: SkinnyStopDnRecallTimer: dn 54 chan 1 Mar 21 23:07:18.340: SkinnyGetCallState for DN 54 chan 1 IDLE Mar 21 23:07:18.340: called DN -1 chan 1, calling DN -1 chan 1 phone -1 s2s:0 Mar 21 23:07:18.340: SkinnySetCallInfoName calling dn -1 chan 1 dn 54 chan 1,calling [] called [] Mar 21 23:07:18.340: SetCallInfo DN 54 chan 1 is not skinny-to-skinny Mar 21 23:07:18.340: Skinny Call State change for DN 54 chan 1 IDLE from ALERTING Mar 21 23:07:18.340: ephone-(30) DN 54 chan 1 calledDn -1 chan 1 callingDn -1 chan 1 :: port=0 Mar 21 23:07:18.340: SkinnyUpdateCstate DN 54 chan 1 cstate 2 Mar 21 23:07:18.340: SkinnyGetCallState for DN 54 chan 1 IDLE Mar 21 23:07:18.340: called DN -1 chan 1, calling DN -1 chan 1 phone -1 s2s:0 Mar 21 23:07:18.340: ephone-30[29/34][SEP001D09CCADEE]:SkinnyUpdateCstate first phone for DN 54 chan 1 ref 2312 Mar 21 23:07:18.344: ephone-30[29/34][SEP001D09CCADEE]:UpdateCState found DN 54 on line 1 Mar 21 23:07:18.344: ephone-30[29/34]:SkinnyUpdateCState process cstate 2 for inactive DN 54 chan 1 line 1 (activeLine=0 whisperLine=0) Mar 21 23:07:18.344: ephone-30[29/34]:SkinnyUpdateCstate inactive (overlay) line 1 for DN 54 ref 2312 combo=0 Mar 21 23:07:18.344: DN 54 chan 1 ephone-30 state set to 2 Mar 21 23:07:18.344: SkinnyGetCallState for DN 54 chan 1 IDLE Mar 21 23:07:18.344: called DN -1 chan 1, calling DN -1 chan 1 phone -1 s2s:0 Mar 21 23:07:18.344: ephone-30[34]:SetCallState line 1 DN 54(54) chan 1 ref 2312 TsOnHook Mar 21 23:07:18.344: ephone-30[29/34]:SkinnyTrackActiveCall for line 1 ref 2312 state 2 (slot 0) Mar 21 23:07:18.344: ephone-30[29/34]:SelectPhoneSoftKeys set 0 mask FFBF for line 1 ref 2312 Mar 21 23:07:18.344: SkinnyGetCallState for DN 54 chan 1 IDLE Mar 21 23:07:18.344: called DN -1 chan 1, calling DN -1 chan 1 phone -1 s2s:0 Mar 21 23:07:18.344: SkinnyGetCallState for DN 54 chan 1 IDLE Mar 21 23:07:18.344: called DN -1 chan 1, calling DN -1 chan 1 phone -1 s2s:0 Mar 21 23:07:18.344: ephone-30[29/34]:Clean Up Speakerphone state Mar 21 23:07:18.344: ephone-30[29/34]:SpeakerPhoneOnHook Mar 21 23:07:18.344: ephone-30[29/34]:Speaker is not on, SpeakerPhoneOnHook suppressed Mar 21 23:07:18.344: ephone-30[29/34][SEP001D09CCADEE]:SkinnyGetToneRef toneRef 0x908 callRef 0x908 Mar 21 23:07:18.344: ephone-30[29/34]:SkinnyPhoneToneDirect: StopTone sent: normal line=1 ref=2312 tone=0x0 Mar 21 23:07:18.344: Skinny StopTone sent on ephone socket [34] Mar 21 23:07:18.344: SkinnyGetCallState for DN 54 chan 1 IDLE Mar 21 23:07:18.344: called DN -1 chan 1, calling DN -1 chan 1 phone -1 s2s:0 Mar 21 23:07:18.344: ephone-30[29/34]:SelectPhoneSoftKeys set 0 mask FFBF for line 0 ref 0 Mar 21 23:07:18.344: SkinnyGetCallState for DN 54 chan 1 IDLE Mar 21 23:07:18.344: called DN -1 chan 1, calling DN -1 chan 1 phone -1 s2s:0 Mar 21 23:07:18.344: ephone-30[34]:SetLineLamp 1 to OFF Mar 21 23:07:18.344: UnBinding ephone-30 from DN 54 chan 1 Mar 21 23:07:18.344: ephone-30[29/34][SEP001D09CCADEE]:SkinnyArmPhoneCallbacks scan 8 lines Mar 21 23:07:18.344: ephone-30[29/34][SEP001D09CCADEE]:SkinnyArmPhoneCallbacks for 1 targets Mar 21 23:07:18.344: ephone-30[29/34][SEP001D09CCADEE]:SkinnyCheckPendingCallBackPhone scan 8 lines Mar 21 23:07:18.344: ephone-30[29/34]:---SkinnySyncPhoneDnOverlays is onhook Mar 21 23:07:18.344: SkinnyGetCallState for DN 54 chan 1 IDLE Mar 21 23:07:18.344: called DN -1 chan 1, calling DN -1 chan 1 phone -1 s2s:0 Mar 21 23:07:18.344: ephone-30[29/34]:SpeakerPhoneOnHook Mar 21 23:07:18.344: ephone-30[29/34]:Speaker is not on, SpeakerPhoneOnHook suppressed Mar 21 23:07:18.344: ephone-30[29/34]:SelectPhoneSoftKeys set 0 mask FFBF for line 1 ref 2312 Mar 21 23:07:18.344: ephone-30[29/34][SEP001D09CCADEE]:SkinnyArmPhoneCallbacks scan 8 lines Mar 21 23:07:18.344: ephone-30[29/34][SEP001D09CCADEE]:SkinnyArmPhoneCallbacks for 1 targets Mar 21 23:07:18.344: ephone-30[29/34][SEP001D09CCADEE]:SkinnyCheckPendingCallBackPhone scan 8 lines Mar 21 23:07:18.344: Sending message 0x4BA104D8 to phone 30, sock 34, SkinnyMessageID = StationClearPromptStatusMessageID Mar 21 23:07:18.348: Sending message 0x4BAEB504 to phone 30, sock 34, SkinnyMessageID = StationDisplayPromptStatusV2MessageID Mar 21 23:07:18.348: Sending message 0x4BA2A0D8 to phone 30, sock 34, SkinnyMessageID = StationCallStateMessageID Mar 21 23:07:18.348: Sending message 0x4BA0ED68 to phone 30, sock 34, SkinnyMessageID = StationSelectSoftKeysMessageID Mar 21 23:07:18.348: Sending message 0x4BA0F880 to phone 30, sock 34, SkinnyMessageID = StationStopToneMessageID Mar 21 23:07:18.348: Sending message 0x4BA10B18 to phone 30, sock 34, SkinnyMessageID = StationSelectSoftKeysMessageID Mar 21 23:07:18.348: Sending message 0x4BA11068 to phone 30, sock 34, SkinnyMessageID = StationSetLampMessageID Mar 21 23:07:18.348: Sending message 0x4BA22384 to phone 30, sock 34, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:18.348: Sending message 0x4BA22560 to phone 30, sock 34, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:18.348: Sending message 0x4BA2234C to phone 30, sock 34, SkinnyMessageID = StationClearNotifyMessageID Mar 21 23:07:18.348: Sending message 0x4BAE9410 to phone 30, sock 34, SkinnyMessageID = StationDisplayPromptStatusV2MessageID Mar 21 23:07:18.348: Sending message 0x4BA0F4C0 to phone 30, sock 34, SkinnyMessageID = StationSelectSoftKeysMessageID Mar 21 23:07:18.348: Sending message 0x4BA21E60 to phone 30, sock 34, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:18.348: Sending message 0x4BA22074 to phone 30, sock 34, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:18.348: Sending message 0x4BA2226C to phone 30, sock 34, SkinnyMessageID = StationClearNotifyMessageID Mar 21 23:07:18.348: Sending message 0x4BAEAB30 to phone 30, sock 34, SkinnyMessageID = StationDisplayPromptStatusV2MessageID Mar 21 23:07:19.028: SkinnyGetCallState for DN 54 chan 1 IDLE Mar 21 23:07:19.028: called DN -1 chan 1, calling DN -1 chan 1 phone -1 s2s:0 Mar 21 23:07:19.028: ephone-30[29/34]:SkinnyConfirmOnHookAck: dn 54 chan 1 dn_index 54 phone=29, pickupOnHook=0 Mar 21 23:07:19.028: ephone-30[29/34][SEP001D09CCADEE]:SkinnyCheckPendingCallBackPhone scan 8 lines Mar 21 23:07:19.032: dn_tone_control DN=54 chan 1 tonetype=0:DtSilence onoff=0 pid=296 Mar 21 23:07:19.032: SkinnyGetCallState for DN 54 chan 1 IDLE Mar 21 23:07:19.032: called DN -1 chan 1, calling DN -1 chan 1 phone -1 s2s:0 Mar 21 23:07:19.032: ephone-30[29/34]:Check toneOn state for last_phone Mar 21 23:07:19.032: SkinnyGetCallState for DN 54 chan 1 IDLE Mar 21 23:07:19.032: called DN -1 chan 1, calling DN -1 chan 1 phone -1 s2s:0 Mar 21 23:07:19.032: //4241/544C95E8AFB0/CCAPI/cc_api_call_disconnect_done: Disposition=0, Interface=0x4BA4EAC4, Tag=0x0, Call Id=4241, Call Entry(Disconnect Cause=18, Voice Class Cause Code=0, Retry Count=0) Mar 21 23:07:19.032: //4241/544C95E8AFB0/CCAPI/cc_api_call_disconnect_done: Call Disconnect Event Sent Mar 21 23:07:19.032: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa: Mar 21 23:07:19.032: :cc_free_feature_vsa freeing 47D06FB0 Mar 21 23:07:19.032: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa: Mar 21 23:07:19.032: vsacount in free is 1 Mar 21 23:07:19.032: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa: Mar 21 23:07:19.032: vsacount in free is 0 Mar 21 23:07:19.036: Sending message 0x4BA2226C to phone 30, sock 34, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:19.036: Sending message 0x4BA22074 to phone 30, sock 34, SkinnyMessageID = StationClearPriNotifyMessageID Mar 21 23:07:19.036: Sending message 0x4BA21E60 to phone 30, sock 34, SkinnyMessageID = StationClearNotifyMessageID Mar 21 23:07:19.036: Sending message 0x4BAEAB30 to phone 30, sock 34, SkinnyMessageID = StationDisplayPromptStatusV2MessageID Mar 21 23:07:19.040: Received message from phone 6, sock 10, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:07:19.040: Sending message 0x4BA21E60 to phone 6, sock 10, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:07:20.728: Received message from phone 5, sock 3, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:07:20.728: Sending message 0x4BA21E60 to phone 5, sock 3, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:07:21.636: Received message from phone 31, sock 5, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:07:21.636: Sending message 0x4BA21E60 to phone 31, sock 5, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:07:21.776: Received message from phone 10, sock 22, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:07:21.776: Sending message 0x4BA21E60 to phone 10, sock 22, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:07:22.180: Received message from phone 9, sock 4, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:07:22.180: Sending message 0x4BA21E60 to phone 9, sock 4, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:07:23.508: Received message from phone 18, sock 11, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:07:23.508: Sending message 0x4BA21E60 to phone 18, sock 11, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:07:24.088: Received message from phone 28, sock 32, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:07:24.088: Sending message 0x4BA21E60 to phone 28, sock 32, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:07:25.856: Received message from phone 11, sock 2, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:07:25.856: Sending message 0x4BA21A70 to phone 11, sock 2, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:07:26.968: Received message from phone 7, sock 27, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:07:26.968: Sending message 0x4BA21A70 to phone 7, sock 27, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:07:27.180: Received message from phone 15, sock 23, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:07:27.180: Sending message 0x4BA21A70 to phone 15, sock 23, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:07:27.284: Received message from phone 22, sock 7, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:07:27.284: Sending message 0x4BA21A70 to phone 22, sock 7, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:07:27.508: Received message from phone 36, sock 14, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:07:27.508: Sending message 0x4BA21A70 to phone 36, sock 14, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:07:27.948: Received message from phone 24, sock 15, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:07:27.948: Sending message 0x4BA21A70 to phone 24, sock 15, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:07:28.112: Received message from phone 33, sock 21, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:07:28.112: Sending message 0x4BA21A70 to phone 33, sock 21, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:07:28.268: Received message from phone 30, sock 34, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:07:28.268: Sending message 0x4BA21A70 to phone 30, sock 34, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:07:31.440: Received message from phone 3, sock 19, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:07:31.440: Sending message 0x4BA21A70 to phone 3, sock 19, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:07:32.104: Received message from phone 34, sock 25, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:07:32.104: Sending message 0x4BA21A70 to phone 34, sock 25, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:07:33.724: Received message from phone 2, sock 29, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:07:33.724: Sending message 0x4BA21A70 to phone 2, sock 29, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:07:34.932: Received message from phone 37, sock 18, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:07:34.932: Sending message 0x4BA21A70 to phone 37, sock 18, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:07:37.324: Received message from phone 13, sock 30, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:07:37.324: Sending message 0x4BA21A70 to phone 13, sock 30, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:07:37.732: Received message from phone 27, sock 33, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:07:37.732: Sending message 0x4BA21A70 to phone 27, sock 33, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:07:38.356: Received message from phone 26, sock 26, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:07:38.356: Sending message 0x4BA21A70 to phone 26, sock 26, SkinnyMessageID = StationKeepAliveAckMessageID Mar 21 23:07:38.924: Received message from phone 8, sock 31, SkinnyMessageID = StationKeepAliveMessageID Mar 21 23:07:38.924: Sending message 0x4BA21A70 to phone 8, sock 31, SkinnyMessageID = StationKeepAliveAckMessageID chrs-phx-cme# chrs-phx-cme# chrs-phx-cme# chrs-phx-cme# chrs-phx-cme# chrs-phx-cme# chrs-phx-cme# chrs-phx-cme# chrs-phx-cme# chrs-phx-cme# chrs-phx-cme#u all All possible debugging has been turned off chrs-phx-cme# chrs-phx-cme# chrs-phx-cme#