NTTコミュニケーションズ050plusの標準度合いを調査しましたlog03

attemptAutoAnswerForPush
2017-09-14T13:06:03.875Z
Sending RTP packet #2 10.221.82.222:12648 > 60.37.58.164:62088, len=52, really=52, data=809271CC36C27B4BC4DB85F345318B9D928CD7C0F23EF86B7B4CACD2C6FFCC91
JITTER: audio=0ms, net=0ms, pktloss=0%
VU
start, status=2
BRIDGE
updateFeeds
Setting call feeder
VU
start, status=2
2017-09-14T13:06:03.907Z
Sending RTP packet #3 10.221.82.222:12648 > 60.37.58.164:62088, len=52, really=52, data=809271CD36C27C3BC4DB85F3FB3DBC610E0C0142FFEA75720CF1C67EEF05BD5D
2017-09-14T13:06:03.939Z
Sending RTP packet #4 10.221.82.222:12648 > 60.37.58.164:62088, len=52, really=52, data=801271CE36C27D2BC4DB85F3B181BDEA55E12009DBFA8C30E0BB5681F0B4B5AC
2017-09-14T13:06:03.971Z
Sending RTP packet #5 10.221.82.222:12648 > 60.37.58.164:62088, len=52, really=52, data=801271CF36C27E1BC4DB85F30E526760A8B76B9ACDCCC7352079F1EB7B460F5D
2017-09-14T13:06:04.002Z
Sending RTP packet #6 10.221.82.222:12648 > 60.37.58.164:62088, len=52, really=52, data=801271D036C27F0BC4DB85F36D6BF0FB2EF6FCC30AD5437381D8BDC4B00ECA9A
2017-09-14T13:06:04.034Z
Sending RTP packet #7 10.221.82.222:12648 > 60.37.58.164:62088, len=52, really=52, data=801271D136C27FFBC4DB85F319CB013C1B2763507332AD34471F421F3E2507D9
VU
start, status=2
BRIDGE
updateFeeds
Setting call feeder
VU
start, status=2
2017-09-14T13:06:04.051Z
Sending RTP packet #8 10.221.82.222:12648 > 60.37.58.164:62088, len=52, really=52, data=801271D236C280EBC4DB85F3D676AD61C73BB88D1EE407CE8C0FAF367D70C80C
2017-09-14T13:06:04.083Z
Sending RTP packet #9 10.221.82.222:12648 > 60.37.58.164:62088, len=52, really=52, data=801271D336C281DBC4DB85F3FA578C543D8F1493BDDE5B20525648D35DC030A6
2017-09-14T13:06:04.115Z
Sending RTP packet #10 10.221.82.222:12648 > 60.37.58.164:62088, len=52, really=52, data=801271D436C282CBC4DB85F32CCC2980E49826A73A7B8C6A782847B7320D46A0
2017-09-14T13:06:04.147Z
Sending RTP packet #11 10.221.82.222:12648 > 60.37.58.164:62088, len=52, really=52, data=801271D536C283BBC4DB85F334DC837AE45F2D79F2402694521C4F4670F1FF6C
2017-09-14T13:06:04.179Z
Sending RTP packet #12 10.221.82.222:12648 > 60.37.58.164:62088, len=52, really=52, data=801271D636C284ABC4DB85F35A26BD926F33386DA0708EA9A1B650757087A5DE
2017-09-14T13:06:04.211Z
Sending RTP packet #13 10.221.82.222:12648 > 60.37.58.164:62088, len=52, really=52, data=801271D736C2859BC4DB85F3B4050066FE49B0078ECF3D15659E490372D87142
2017-09-14T13:06:04.226Z
Received RTP packet #1 60.37.58.164:62088 > 10.221.82.222:12648, len=62, data=8012007E00009D80807EF5A03EE60393D37C697A4826A8C81F187274DFCE3501
2017-09-14T13:06:04.243Z
Sending RTP packet #14 10.221.82.222:12648 > 60.37.58.164:62088, len=52, really=52, data=801271D836C2868BC4DB85F3B02F6B436A3B38F49514F3390F0A71B2FA8FDDAA
2017-09-14T13:06:04.306Z
Received RTP packet #2 60.37.58.164:62088 > 10.221.82.222:12648, len=62, data=8012007F00009EC0807EF5A03361D5ADC7F4AAC700EE861975B6F9B3E60B5ED8
2017-09-14T13:06:04.320Z (1505394364320493)
Rtp::Session::updateMediaStatus
Media status changed.
Correlation Id: SiphoneUserAgent[399182336]SiphoneSipCall[390896128]RtpSession[390285824]
Audio Incoming: Active; 18
Audio Outgoing: Active; 18
Video Incoming: Inactive; -
Video Outgoing: Inactive; -

VU
start, status=2
BRIDGE
updateFeeds
Setting call feeder
VU
start, status=2
2017-09-14T13:06:04.346Z
Received RTP packet #3 60.37.58.164:62088 > 10.221.82.222:12648, len=62, data=801200800000A000807EF5A084F6C4136328EA417D15AE05C310C6A89929D13E
2017-09-14T13:06:04.395Z (1505394364395702)
ali::network::sip::layer::transport::stream_channel::conn_can_read
Received message.
Correlation Id: SiphoneUserAgent[399182336]SipUserAgent[397486592]SipTransaction[397487796]SipTransport[403772784]SipTransportChannel[403059568]
Local Address: 10.221.82.222:54159
Remote Address: kar-f2fcp.050plus.com/60.37.58.171:5061 [kar-f2fcp.050plus.com; 60.37.58.171:5061]
Message Size: 419
ACK sip:fmc12345678@10.221.82.222:54159;transport=tls SIP/2.0
Via: SIP/2.0/TLS 60.37.58.171:5061;branch=z9hG4bK7bcaf1e8, SIP/2.0/UDP 60.37.58.132:6061;branch=z9hG4bK4faadce1
From: ;tag=76d9aa9b
To: ;tag=46E90C412A52051A33F71E1145AD99D3
Call-ID: f64a3690fe3b103fbcdb000069e3@10.124.237.107--_6ba85830
CSeq: 1 ACK
Max-Forwards: 69
Content-Length: 0



2017-09-14T13:06:04.396Z (1505394364396242)
Sip::Shared::requestHandler
The request matches an existing dialog.
Correlation Id: SiphoneUserAgent[399182336]SipUserAgent[397486592]
Status: Alive
Call Id: f64a3690fe3b103fbcdb000069e3@10.124.237.107--_6ba85830
Local Tag: 46E90C412A52051A33F71E1145AD99D3
Remote Tag: 76d9aa9b
Local SeqNo: 1
Remote SeqNo: 1
Local URI: <From uri="sip:05012345678@voip.ntt.com">
<Uri scheme="sip" user="05012345678" host="voip.ntt.com"/>
<Params tag="46E90C412A52051A33F71E1145AD99D3"/>
</From>
Remote URI: <To uri="sip:08080019999@voip.ntt.com">
<Uri scheme="sip" user="08080019999" host="voip.ntt.com"/>
<Params tag="76d9aa9b"/>
</To>
Remote Target: <Contact uri="sip:60.37.58.132:6061;transport=udp">
<Uri scheme="sip" host="60.37.58.132" port="6061">
<Params transport="udp"/>
</Uri>
</Contact>
Route Set:
<Route
uri="sip:nxs_38f7ed5d_flow=03bb4fd137b438fb@60.37.58.171:5061;transport=tcp;lr">
<Uri
scheme="sip"
user="nxs_38f7ed5d_flow=03bb4fd137b438fb"
host="60.37.58.171"
port="5061"
host-name="kar-f2fcp.050plus.com">
<Params transport="tcp" lr=""/>
</Uri>
</Route>


2017-09-14T13:06:04.396Z (1505394364396678)
Sip::Dialog::writeServerRequest
Dialog request queued.
Correlation Id: SiphoneUserAgent[399182336]SipUserAgent[397486592]
Request Id: 0
Method: ACK
Queue Size: 1
Notifying: Yes

2017-09-14T13:06:04.396Z (1505394364396869)
Sip::Dialog::readServerRequest
Dialog request dispatched.
Correlation Id: SiphoneUserAgent[399182336]SipUserAgent[397486592]
Request Id: 0
Method: ACK

2017-09-14T13:06:04.396Z (1505394364396933)
Sip::Dialog::notifyServerRequest
Correlation Id: SiphoneUserAgent[399182336]SipUserAgent[397486592]
Invariant Holds: Yes
Queue Size: 0

2017-09-14T13:06:04.397Z (1505394364397001)
Sip::Call::serverRequestHandler
Correlation Id: SiphoneUserAgent[399182336]SiphoneSipCall[390896128]SiphoneUserAgent[399182336]SipUserAgent[397486592]SipCall[391365632]
Request Id: 0
Method: ACK

2017-09-14T13:06:04.426Z
Received RTP packet #4 60.37.58.164:62088 > 10.221.82.222:12648, len=62, data=801200810000A140807EF5A04E11CB1C0D832E44E3E672E262E38CA5827B26EF
2017-09-14T13:06:04.466Z
Received RTP packet #5 60.37.58.164:62088 > 10.221.82.222:12648, len=62, data=801200820000A280807EF5A0B2A135BF166D5401625D1D42468A644080F58DCF
2017-09-14T13:06:04.507Z
Received RTP packet #6 60.37.58.164:62088 > 10.221.82.222:12648, len=62, data=801200830000A3C0807EF5A046EA3A44A8190724B5AFB4F1D5D9BCA8C4405DF8
2017-09-14T13:06:04.548Z
Received RTP packet #7 60.37.58.164:62088 > 10.221.82.222:12648, len=62, data=801200840000A500807EF5A0BA8C2872FFEF863549D5141F26CEBC7217991E50
2017-09-14T13:06:04.587Z
Received RTP packet #8 60.37.58.164:62088 > 10.221.82.222:12648, len=62, data=801200850000A640807EF5A03BC14B8FDAFC03ACB28C5F0E721031AF49CEBE17
2017-09-14T13:06:04.626Z
Received RTP packet #9 60.37.58.164:62088 > 10.221.82.222:12648, len=62, data=801200860000A780807EF5A0E780D361F12AB5A8A6C4E095849EFB54E393F2BF
2017-09-14T13:06:04.666Z
Received RTP packet #10 60.37.58.164:62088 > 10.221.82.222:12648, len=62, data=801200870000A8C0807EF5A0E3FBC8F805D40C04DC92DD4F0F6324E766C67B66
2017-09-14T13:06:04.706Z
Received RTP packet #11 60.37.58.164:62088 > 10.221.82.222:12648, len=62, data=801200880000AA00807EF5A06FE61F233C150031BA7CD08EB8C997856D8A3A83
2017-09-14T13:06:04.720Z (1505394364720668)
Rtp::Session::MediaStream::startOrUpdateNetwork
Correlation Id: SiphoneUserAgent[399182336]SiphoneSipCall[390896128]RtpSession[390285824]RtpAudioStream[390289024]
ICE Check List State: Running
All Comps Have Valid Pair: No

2017-09-14T13:06:04.720Z (1505394364720920)
Rtp::Session::MediaStream::startOrUpdateNetwork
Correlation Id: SiphoneUserAgent[399182336]SiphoneSipCall[390896128]RtpSession[390285824]RtpAudioStream[390289024]
Available Local Addresses: RTP (SDP): 10.221.82.222:12648
RTCP (SDP): 10.221.82.222:12649
RTP (ICE): (unspecified)
RTCP (ICE): (unspecified)
Available Remote Addresses: RTP (SDP): 60.37.58.164:62088
RTCP (SDP): 60.37.58.164:62089
RTP (ICE): (unspecified)
RTCP (ICE): (unspecified)
RTP (Inc): 60.37.58.164:62088
RTCP (Inc): (unspecified)
Use Incoming: Yes

2017-09-14T13:06:04.721Z (1505394364721382)
Rtp::Session::MediaStream::startOrUpdateNetwork
Correlation Id: SiphoneUserAgent[399182336]SiphoneSipCall[390896128]RtpSession[390285824]RtpAudioStream[390289024]
Selected Local Addresses: RTP: 10.221.82.222:12648; was 10.221.82.222:12648
RTCP: 10.221.82.222:12649; was 10.221.82.222:12649
Selected Remote Addresses: RTP: 60.37.58.164:62088; was 60.37.58.164:62088
RTCP: 60.37.58.164:62089; was 60.37.58.164:62089

2017-09-14T13:06:04.747Z
Received RTP packet #12 60.37.58.164:62088 > 10.221.82.222:12648, len=62, data=801200890000AB40807EF5A0568A5A108C937DDFA0AA0DFFE571A9970DDB16CE
2017-09-14T13:06:04.787Z
Received RTP packet #13 60.37.58.164:62088 > 10.221.82.222:12648, len=62, data=8012008A0000AC80807EF5A0C9B66CB4B6B358C58833FAE650CDAFA01D590C2E
2017-09-14T13:06:04.828Z
Received RTP packet #14 60.37.58.164:62088 > 10.221.82.222:12648, len=62, data=8012008B0000ADC0807EF5A094C7842C67C447BCD2C790253473AC46742EA342
JITTER: audio=5ms, net=0ms, pktloss=0%
JITTER: audio=5ms, net=2ms, pktloss=0%
2017-09-14T13:06:06.820Z
Sending RTP packet #100 10.221.82.222:12648 > 60.37.58.164:62088, len=52, really=52, data=8012722E36C2D72BC4DB85F37E3D110DE5FE543D7F87715D322D53F413BF6324
JITTER: audio=5ms, net=2ms, pktloss=0%
JB parameters: span=0, optimum=240, count=0, lostSeq=(0,0)
JITTER: audio=5ms, net=2ms, pktloss=0%
2017-09-14T13:06:08.266Z
Received RTP packet #100 60.37.58.164:62088 > 10.221.82.222:12648, len=62, data=801200E100011940807EF5A0ADC4E03B4FB515243E8C2DBDBA337030D20CB446
JITTER: audio=5ms, net=2ms, pktloss=0%
2017-09-14T13:06:09.812Z
Sending RTP packet #200 10.221.82.222:12648 > 60.37.58.164:62088, len=52, really=52, data=8012729236C334EBC4DB85F3B1C43D879B1A543B99E896594B2B3115E5FCC707
JITTER: audio=5ms, net=2ms, pktloss=0%
2017-09-14T13:06:10.183Z
Sending RTP packet #2 10.221.82.222:12649 > 60.37.58.164:62089, len=94, really=94, data=81C8000CC4DB85F3AAA3123EF14938B82BB40FE64FF954491BB35FBB18ED7130
UdpRequestProcessor
sending
2017-09-14T13:06:10.796Z
UdpClient sending 542 bytes:
REGISTERED
Version: 2.0
RequestId: q2i67Kci
Selector: B42A1DEBEBED8AF1A620209034C9BFA247E1FC9F
Checksum: 651ED5D0BF586D277912C95914FE714E31D438E6
Expires: 60
Method: tunnel
Device-Token: lpkxPV276A9R45WmkCOL91/fhAMTLNtetzwBL8XtQIE=
App-Id: cz.acrobits.softphone.own.pushkit
Authorization: Digest username="fmc12345678",realm="sipis10 a",nonce="59ba7e765184e674",uri="B42A1DEBEBED8AF1A620209034C9BFA247E1FC9F",qop=auth,cnonce="7457da2ee51ac9487632219c16ce9a24",nc=00000003,response="ab7f1b50d0d9ffa5d07de1392939d327",algorithm=MD5


JITTER: audio=5ms, net=2ms, pktloss=0%
2017-09-14T13:06:11.021Z
UdpClient::LinkBase onDataReceived
2017-09-14T13:06:11.022Z
UdpClient::LinkBase received:
REGISTERED-ACK
Content-Length: 76
Expires: 60
Method: Tunnel
RequestId: q2i67Kci
Selector: B42A1DEBEBED8AF1A620209034C9BFA247E1FC9F
Server: sipis10 a
Timestamp: 1505394370

<Body><PendingCalls/><IncomingCalls/><PendingTextMessages Count="0"/></Body>
2017-09-14T13:06:11.022Z
SIPIS onLocallyRegisteredResponse: REGISTERED-ACK
onSipisResult with result Success
JB parameters: span=0, optimum=240, count=0, lostSeq=(0,0)
JITTER: audio=5ms, net=2ms, pktloss=0%
2017-09-14T13:06:12.268Z
Received RTP packet #200 60.37.58.164:62088 > 10.221.82.222:12648, len=62, data=8012014500019640807EF5A0EEC52899CF199F775045192C61CF0EB60217100E
resetting call from Siphone::hangup
2017-09-14T13:06:12.644Z (1505394372644527)
Call::~Call
Correlation Id: SiphoneUserAgent[399182336]SiphoneSipCall[390896128]
State: Established
Rtp State: NotInTransaction
Call State: Established

2017-09-14T13:06:12.644Z (1505394372644618)
Call<Sip>::~Call
Correlation Id: SiphoneUserAgent[399182336]SiphoneSipCall[390896128]
Active Call Count: 0

2017-09-14T13:06:12.645Z (1505394372645699)
Sip::Shared::startGlobalContactDiscovery
Correlation Id: SiphoneUserAgent[399182336]SipUserAgent[397486592]
Purpose: Global Contact Discovery
Use Global Contact: No
Global Contact State: Off

2017-09-14T13:06:12.646Z (1505394372646182)
ali::network::sip::layer::transport::do_send
Correlation Id: SiphoneUserAgent[399182336]SipUserAgent[397486592]SipTransaction[397487796]SipTransport[403772784]
Host Name: kar-f2fcp.050plus.com
Host: 60.37.58.171
Port: 5061
Transport: tcp

2017-09-14T13:06:12.646Z (1505394372646287)
ali::network::sip::layer::transport::create_channel
Initiating a new channel.
Correlation Id: SiphoneUserAgent[399182336]SipUserAgent[397486592]SipTransaction[397487796]SipTransport[403772784]

2017-09-14T13:06:12.646Z (1505394372646422)
ali::network::sip::layer::transport::channel::send
Message queued.
Correlation Id: SiphoneUserAgent[399182336]SipUserAgent[397486592]SipTransaction[397487796]SipTransport[403772784]SipTransportChannel[403146288]
Destination: kar-f2fcp.050plus.com/60.37.58.171:5061 [kar-f2fcp.050plus.com/60.37.58.171:5061; 60.37.58.171:5061]
Queue Size: 1

2017-09-14T13:06:12.646Z (1505394372646525)
ali::network::sip::layer::transport::channel::try_send
Correlation Id: SiphoneUserAgent[399182336]SipUserAgent[397486592]SipTransaction[397487796]SipTransport[403772784]SipTransportChannel[403146288]
Destination: kar-f2fcp.050plus.com/60.37.58.171:5061 [kar-f2fcp.050plus.com/60.37.58.171:5061; 60.37.58.171:5061]
Entry Message Queue Size: 1

2017-09-14T13:06:12.646Z (1505394372646615)
ali::network::sip::layer::transport::stream_channel::do_send
Correlation Id: SiphoneUserAgent[399182336]SipUserAgent[397486592]SipTransaction[397487796]SipTransport[403772784]SipTransportChannel[403146288]
Destination: kar-f2fcp.050plus.com/60.37.58.171:5061 [kar-f2fcp.050plus.com/60.37.58.171:5061; 60.37.58.171:5061]
Connection state: Not Connected
Not Connected Reason: Disconnected
Error: -

2017-09-14T13:06:12.646Z (1505394372646770)
ali::network::basic_communicator2::connect
Socket Id: 7
Remote Address: kar-f2fcp.050plus.com/60.37.58.171:5061

2017-09-14T13:06:12.646Z (1505394372646830)
ali::network::basic_communicator2::connect
Connecting socket.
Socket Id: 7
Remote Address: kar-f2fcp.050plus.com/60.37.58.171:5061

2017-09-14T13:06:12.655Z (1505394372655435)
ali::network::sip::layer::transport::channel::try_send
Correlation Id: SiphoneUserAgent[399182336]SipUserAgent[397486592]SipTransaction[397487796]SipTransport[403772784]SipTransportChannel[403146288]
Destination: kar-f2fcp.050plus.com/60.37.58.171:5061 [kar-f2fcp.050plus.com/60.37.58.171:5061; 60.37.58.171:5061]
Exit Message Queue Size: 1

2017-09-14T13:06:12.655Z (1505394372655593)
ali::network::sip::transaction::start_client_transaction
Correlation Id: SiphoneUserAgent[399182336]SipUserAgent[397486592]SipTransaction[397487796]
Method: BYE
Id: 4

2017-09-14T13:06:12.655Z (1505394372655842)
Rtp::Session::resetMediaStream
Correlation Id: SiphoneUserAgent[399182336]SiphoneSipCall[390896128]RtpSession[390285824]

2017-09-14T13:06:12.655Z (1505394372655906)
Rtp::Session::resetMediaStream
Correlation Id: SiphoneUserAgent[399182336]SiphoneSipCall[390896128]RtpSession[390285824]

2017-09-14T13:06:12.655Z
RTP socket 31 shutdown
2017-09-14T13:06:12.656Z
RTP socket 31 close
RTP UdpSocket: select failed, errno=9. Terminating socket thread
2017-09-14T13:06:12.656Z
RTP socket 31 shutdown
2017-09-14T13:06:12.656Z
RTP socket 31 close
2017-09-14T13:06:12.656Z
RTP socket 31 destroyed
2017-09-14T13:06:12.656Z
RTP socket -1 destroyed
2017-09-14T13:06:12.656Z
RTP socket 34 shutdown
2017-09-14T13:06:12.656Z
RTP socket 34 close
RTP UdpSocket: select failed, errno=9. Terminating socket thread
2017-09-14T13:06:12.656Z
RTP socket 34 shutdown
2017-09-14T13:06:12.656Z
RTP socket 34 close
2017-09-14T13:06:12.656Z
RTP socket 34 destroyed
2017-09-14T13:06:12.657Z
RTP socket -1 destroyed
updateCallEventForStateTransition: Established -> Terminated
2017-09-14T13:06:12.676Z (1505394372676697)
ali::network::sip::layer::transport::stream_channel::conn_state_changed
Correlation Id: SiphoneUserAgent[399182336]SipUserAgent[397486592]SipTransaction[397487796]SipTransport[403772784]SipTransportChannel[403146288]
Connecting To: kar-f2fcp.050plus.com/60.37.58.171:5061 [kar-f2fcp.050plus.com/60.37.58.171:5061; 60.37.58.171:5061]

2017-09-14T13:06:12.677Z (1505394372677884)
ali::network::basic_communicator2::socket_state_changed
Socket Id: 7
Socket State: Connecting