Hi Benny, I am facing problem in call tansfer. I have set up the pjsip with two ua , one is 8003 and other is 8004. call always come on 8003. and if 8003 is busy, it does transfer two 8004. but it fails. I am sending the trace also. 15:03:51.591 sip_endpoint.c Module "mod-pjsua-log" registered 15:03:51.591 sip_endpoint.c Module "mod-tsx-layer" registered 15:03:51.591 sip_endpoint.c Module "mod-stateful-util" registered 15:03:51.591 sip_endpoint.c Module "mod-ua" registered 15:03:51.591 sip_endpoint.c Module "mod-pjsua" registered 15:03:51.607 sip_endpoint.c Module "mod-invite" registered 15:03:51.872 pasound.c PortAudio sound library initialized, status=0 15:03:51.872 pasound.c PortAudio host api count=3 15:03:51.872 pasound.c Sound device count=8 15:03:51.872 pjlib select() I/O Queue created (00F5DFBC) 15:03:51.888 conference.c Creating conference bridge with 102 ports 15:03:51.888 conference.c Sound device successfully created for port 0 15:03:51.888 sip_endpoint.c Module "mod-evsub" registered 15:03:51.888 sip_endpoint.c Module "mod-presence" registered 15:03:51.888 evsub.c Event pkg "presence" registered by mod-presence 15:03:51.888 sip_endpoint.c Module "mod-refer" registered 15:03:51.888 evsub.c Event pkg "refer" registered by mod-refer 15:03:51.888 sip_endpoint.c Module "mod-pjsua-pres" registered 15:03:51.888 sip_endpoint.c Module "mod-pjsua-im" registered 15:03:51.888 sip_endpoint.c Module "mod-pjsua-options" registered 15:03:51.888 pjsua_core.c 4 SIP worker threads created 15:03:51.888 pjsua_core.c pjsua version 0.5.10.4 for win32 initialized 15:03:51.904 pjsua_core.c SIP UDP socket reachable at 10.209.2.150:5060 15:03:51.904 udp00F84E34 SIP UDP transport started, published address is 10.209.2.150:5060 15:03:51.904 pjsua_media.c RTP socket reachable at 10.209.2.150:4000 15:03:51.904 pjsua_media.c RTCP socket reachable at 10.209.2.150:4001 15:03:51.919 pjsua_media.c RTP socket reachable at 10.209.2.150:4002 15:03:51.919 pjsua_media.c RTCP socket reachable at 10.209.2.150:4003 15:03:51.919 pjsua_media.c RTP socket reachable at 10.209.2.150:4004 15:03:51.919 pjsua_media.c RTCP socket reachable at 10.209.2.150:4005 15:03:51.935 pjsua_media.c RTP socket reachable at 10.209.2.150:4006 15:03:51.935 pjsua_media.c RTCP socket reachable at 10.209.2.150:4007 15:03:51.935 pjsua_media.c RTP socket reachable at 10.209.2.150:4008 15:03:51.935 pjsua_media.c RTCP socket reachable at 10.209.2.150:4009 15:03:51.935 pjsua_media.c RTP socket reachable at 10.209.2.150:4010 15:03:51.935 pjsua_media.c RTCP socket reachable at 10.209.2.150:4011 15:03:51.951 pjsua_media.c RTP socket reachable at 10.209.2.150:4012 15:03:51.951 pjsua_media.c RTCP socket reachable at 10.209.2.150:4013 15:03:51.951 pjsua_media.c RTP socket reachable at 10.209.2.150:4014 15:03:51.951 pjsua_media.c RTCP socket reachable at 10.209.2.150:4015 15:03:51.966 pjsua_media.c RTP socket reachable at 10.209.2.150:4016 15:03:51.966 pjsua_media.c RTCP socket reachable at 10.209.2.150:4017 15:03:51.966 pjsua_media.c RTP socket reachable at 10.209.2.150:4018 15:03:51.966 pjsua_media.c RTCP socket reachable at 10.209.2.150:4019 15:03:51.966 pjsua_media.c RTP socket reachable at 10.209.2.150:4020 15:03:51.966 pjsua_media.c RTCP socket reachable at 10.209.2.150:4021 15:03:51.982 pjsua_media.c RTP socket reachable at 10.209.2.150:4022 15:03:51.982 pjsua_media.c RTCP socket reachable at 10.209.2.150:4023 15:03:51.997 pjsua_media.c RTP socket reachable at 10.209.2.150:4024 15:03:51.997 pjsua_media.c RTCP socket reachable at 10.209.2.150:4025 15:03:51.997 pjsua_media.c RTP socket reachable at 10.209.2.150:4026 15:03:51.997 pjsua_media.c RTCP socket reachable at 10.209.2.150:4027 15:03:52.013 pjsua_media.c RTP socket reachable at 10.209.2.150:4028 15:03:52.013 pjsua_media.c RTCP socket reachable at 10.209.2.150:4029 15:03:52.013 pjsua_media.c RTP socket reachable at 10.209.2.150:4030 15:03:52.013 pjsua_media.c RTCP socket reachable at 10.209.2.150:4031 15:03:52.029 pjsua_media.c RTP socket reachable at 10.209.2.150:4032 15:03:52.029 pjsua_media.c RTCP socket reachable at 10.209.2.150:4033 15:03:52.029 pjsua_media.c RTP socket reachable at 10.209.2.150:4034 15:03:52.029 pjsua_media.c RTCP socket reachable at 10.209.2.150:4035 15:03:52.044 pjsua_media.c RTP socket reachable at 10.209.2.150:4036 15:03:52.044 pjsua_media.c RTCP socket reachable at 10.209.2.150:4037 15:03:52.044 pjsua_media.c RTP socket reachable at 10.209.2.150:4038 15:03:52.044 pjsua_media.c RTCP socket reachable at 10.209.2.150:4039 15:03:52.044 pjsua_media.c RTP socket reachable at 10.209.2.150:4040 15:03:52.044 pjsua_media.c RTCP socket reachable at 10.209.2.150:4041 15:03:52.060 pjsua_media.c RTP socket reachable at 10.209.2.150:4042 15:03:52.060 pjsua_media.c RTCP socket reachable at 10.209.2.150:4043 15:03:52.060 pjsua_media.c RTP socket reachable at 10.209.2.150:4044 15:03:52.060 pjsua_media.c RTCP socket reachable at 10.209.2.150:4045 15:03:52.076 pjsua_media.c RTP socket reachable at 10.209.2.150:4046 15:03:52.076 pjsua_media.c RTCP socket reachable at 10.209.2.150:4047 15:03:52.076 pjsua_media.c RTP socket reachable at 10.209.2.150:4048 15:03:52.076 pjsua_media.c RTCP socket reachable at 10.209.2.150:4049 15:03:52.091 pjsua_media.c RTP socket reachable at 10.209.2.150:4050 15:03:52.091 pjsua_media.c RTCP socket reachable at 10.209.2.150:4051 15:03:52.091 pjsua_media.c RTP socket reachable at 10.209.2.150:4052 15:03:52.091 pjsua_media.c RTCP socket reachable at 10.209.2.150:4053 15:03:52.091 pjsua_media.c RTP socket reachable at 10.209.2.150:4054 15:03:52.091 pjsua_media.c RTCP socket reachable at 10.209.2.150:4055 15:03:52.107 pjsua_media.c RTP socket reachable at 10.209.2.150:4056 15:03:52.107 pjsua_media.c RTCP socket reachable at 10.209.2.150:4057 15:03:52.107 pjsua_media.c RTP socket reachable at 10.209.2.150:4058 15:03:52.107 pjsua_media.c RTCP socket reachable at 10.209.2.150:4059 15:03:52.122 pjsua_media.c RTP socket reachable at 10.209.2.150:4060 15:03:52.122 pjsua_media.c RTCP socket reachable at 10.209.2.150:4061 15:03:52.122 pjsua_media.c RTP socket reachable at 10.209.2.150:4062 15:03:52.122 pjsua_media.c RTCP socket reachable at 10.209.2.150:4063 15:03:52.122 pjsua_media.c RTP socket reachable at 10.209.2.150:4064 15:03:52.122 pjsua_media.c RTCP socket reachable at 10.209.2.150:4065 15:03:52.138 pjsua_media.c RTP socket reachable at 10.209.2.150:4066 15:03:52.138 pjsua_media.c RTCP socket reachable at 10.209.2.150:4067 15:03:52.138 pjsua_media.c RTP socket reachable at 10.209.2.150:4068 15:03:52.138 pjsua_media.c RTCP socket reachable at 10.209.2.150:4069 15:03:52.154 pjsua_media.c RTP socket reachable at 10.209.2.150:4070 15:03:52.154 pjsua_media.c RTCP socket reachable at 10.209.2.150:4071 15:03:52.154 pjsua_media.c RTP socket reachable at 10.209.2.150:4072 15:03:52.154 pjsua_media.c RTCP socket reachable at 10.209.2.150:4073 15:03:52.169 pjsua_media.c RTP socket reachable at 10.209.2.150:4074 15:03:52.169 pjsua_media.c RTCP socket reachable at 10.209.2.150:4075 15:03:52.169 pjsua_media.c RTP socket reachable at 10.209.2.150:4076 15:03:52.169 pjsua_media.c RTCP socket reachable at 10.209.2.150:4077 15:03:52.169 pjsua_media.c RTP socket reachable at 10.209.2.150:4078 15:03:52.169 pjsua_media.c RTCP socket reachable at 10.209.2.150:4079 15:03:52.185 pjsua_media.c RTP socket reachable at 10.209.2.150:4080 15:03:52.185 pjsua_media.c RTCP socket reachable at 10.209.2.150:4081 15:03:52.185 pjsua_media.c RTP socket reachable at 10.209.2.150:4082 15:03:52.185 pjsua_media.c RTCP socket reachable at 10.209.2.150:4083 15:03:52.201 pjsua_media.c RTP socket reachable at 10.209.2.150:4084 15:03:52.201 pjsua_media.c RTCP socket reachable at 10.209.2.150:4085 15:03:52.201 pjsua_media.c RTP socket reachable at 10.209.2.150:4086 15:03:52.201 pjsua_media.c RTCP socket reachable at 10.209.2.150:4087 15:03:52.201 pjsua_media.c RTP socket reachable at 10.209.2.150:4088 15:03:52.201 pjsua_media.c RTCP socket reachable at 10.209.2.150:4089 15:03:52.216 pjsua_media.c RTP socket reachable at 10.209.2.150:4090 15:03:52.216 pjsua_media.c RTCP socket reachable at 10.209.2.150:4091 15:03:52.216 pjsua_media.c RTP socket reachable at 10.209.2.150:4092 15:03:52.216 pjsua_media.c RTCP socket reachable at 10.209.2.150:4093 15:03:52.232 pjsua_media.c RTP socket reachable at 10.209.2.150:4094 15:03:52.232 pjsua_media.c RTCP socket reachable at 10.209.2.150:4095 15:03:52.232 pjsua_media.c RTP socket reachable at 10.209.2.150:4096 15:03:52.232 pjsua_media.c RTCP socket reachable at 10.209.2.150:4097 15:03:52.232 pjsua_media.c RTP socket reachable at 10.209.2.150:4098 15:03:52.232 pjsua_media.c RTCP socket reachable at 10.209.2.150:4099 15:03:52.247 pjsua_media.c RTP socket reachable at 10.209.2.150:4100 15:03:52.247 pjsua_media.c RTCP socket reachable at 10.209.2.150:4101 15:03:52.247 pjsua_media.c RTP socket reachable at 10.209.2.150:4102 15:03:52.247 pjsua_media.c RTCP socket reachable at 10.209.2.150:4103 15:03:52.263 pjsua_media.c RTP socket reachable at 10.209.2.150:4104 15:03:52.263 pjsua_media.c RTCP socket reachable at 10.209.2.150:4105 15:03:52.263 pjsua_media.c RTP socket reachable at 10.209.2.150:4106 15:03:52.263 pjsua_media.c RTCP socket reachable at 10.209.2.150:4107 15:03:52.263 pjsua_media.c RTP socket reachable at 10.209.2.150:4108 15:03:52.263 pjsua_media.c RTCP socket reachable at 10.209.2.150:4109 15:03:52.279 pjsua_media.c RTP socket reachable at 10.209.2.150:4110 15:03:52.279 pjsua_media.c RTCP socket reachable at 10.209.2.150:4111 15:03:52.279 pjsua_media.c RTP socket reachable at 10.209.2.150:4112 15:03:52.279 pjsua_media.c RTCP socket reachable at 10.209.2.150:4113 15:03:52.294 pjsua_media.c RTP socket reachable at 10.209.2.150:4114 15:03:52.294 pjsua_media.c RTCP socket reachable at 10.209.2.150:4115 15:03:52.294 pjsua_media.c RTP socket reachable at 10.209.2.150:4116 15:03:52.294 pjsua_media.c RTCP socket reachable at 10.209.2.150:4117 15:03:52.310 pjsua_media.c RTP socket reachable at 10.209.2.150:4118 15:03:52.310 pjsua_media.c RTCP socket reachable at 10.209.2.150:4119 15:03:52.310 pjsua_media.c RTP socket reachable at 10.209.2.150:4120 15:03:52.310 pjsua_media.c RTCP socket reachable at 10.209.2.150:4121 15:03:52.310 pjsua_media.c RTP socket reachable at 10.209.2.150:4122 15:03:52.310 pjsua_media.c RTCP socket reachable at 10.209.2.150:4123 15:03:52.326 pjsua_media.c RTP socket reachable at 10.209.2.150:4124 15:03:52.326 pjsua_media.c RTCP socket reachable at 10.209.2.150:4125 15:03:52.326 pjsua_media.c RTP socket reachable at 10.209.2.150:4126 15:03:52.326 pjsua_media.c RTCP socket reachable at 10.209.2.150:4127 15:03:52.341 pjsua_media.c RTP socket reachable at 10.209.2.150:4128 15:03:52.341 pjsua_media.c RTCP socket reachable at 10.209.2.150:4129 15:03:52.341 pjsua_media.c RTP socket reachable at 10.209.2.150:4130 15:03:52.341 pjsua_media.c RTCP socket reachable at 10.209.2.150:4131 15:03:52.357 pjsua_media.c RTP socket reachable at 10.209.2.150:4132 15:03:52.357 pjsua_media.c RTCP socket reachable at 10.209.2.150:4133 15:03:52.357 pjsua_media.c RTP socket reachable at 10.209.2.150:4134 15:03:52.357 pjsua_media.c RTCP socket reachable at 10.209.2.150:4135 15:03:52.357 pjsua_media.c RTP socket reachable at 10.209.2.150:4136 15:03:52.357 pjsua_media.c RTCP socket reachable at 10.209.2.150:4137 15:03:52.372 pjsua_media.c RTP socket reachable at 10.209.2.150:4138 15:03:52.372 pjsua_media.c RTCP socket reachable at 10.209.2.150:4139 15:03:52.372 pjsua_media.c RTP socket reachable at 10.209.2.150:4140 15:03:52.372 pjsua_media.c RTCP socket reachable at 10.209.2.150:4141 15:03:52.388 pjsua_media.c RTP socket reachable at 10.209.2.150:4142 15:03:52.388 pjsua_media.c RTCP socket reachable at 10.209.2.150:4143 15:03:52.388 pjsua_media.c RTP socket reachable at 10.209.2.150:4144 15:03:52.388 pjsua_media.c RTCP socket reachable at 10.209.2.150:4145 15:03:52.388 pjsua_media.c RTP socket reachable at 10.209.2.150:4146 15:03:52.388 pjsua_media.c RTCP socket reachable at 10.209.2.150:4147 15:03:52.404 pjsua_media.c RTP socket reachable at 10.209.2.150:4148 15:03:52.404 pjsua_media.c RTCP socket reachable at 10.209.2.150:4149 15:03:52.419 pjsua_media.c RTP socket reachable at 10.209.2.150:4150 15:03:52.419 pjsua_media.c RTCP socket reachable at 10.209.2.150:4151 15:03:52.419 pjsua_media.c RTP socket reachable at 10.209.2.150:4152 15:03:52.419 pjsua_media.c RTCP socket reachable at 10.209.2.150:4153 15:03:52.435 pjsua_media.c RTP socket reachable at 10.209.2.150:4154 15:03:52.435 pjsua_media.c RTCP socket reachable at 10.209.2.150:4155 15:03:52.435 pjsua_media.c RTP socket reachable at 10.209.2.150:4156 15:03:52.435 pjsua_media.c RTCP socket reachable at 10.209.2.150:4157 15:03:52.451 pjsua_media.c RTP socket reachable at 10.209.2.150:4158 15:03:52.451 pjsua_media.c RTCP socket reachable at 10.209.2.150:4159 15:03:52.451 pjsua_media.c RTP socket reachable at 10.209.2.150:4160 15:03:52.451 pjsua_media.c RTCP socket reachable at 10.209.2.150:4161 15:03:52.451 pjsua_media.c RTP socket reachable at 10.209.2.150:4162 15:03:52.451 pjsua_media.c RTCP socket reachable at 10.209.2.150:4163 15:03:52.466 pjsua_media.c RTP socket reachable at 10.209.2.150:4164 15:03:52.466 pjsua_media.c RTCP socket reachable at 10.209.2.150:4165 15:03:52.466 pjsua_media.c RTP socket reachable at 10.209.2.150:4166 15:03:52.466 pjsua_media.c RTCP socket reachable at 10.209.2.150:4167 15:03:52.482 pjsua_media.c RTP socket reachable at 10.209.2.150:4168 15:03:52.482 pjsua_media.c RTCP socket reachable at 10.209.2.150:4169 15:03:52.482 pjsua_media.c RTP socket reachable at 10.209.2.150:4170 15:03:52.482 pjsua_media.c RTCP socket reachable at 10.209.2.150:4171 15:03:52.497 pjsua_media.c RTP socket reachable at 10.209.2.150:4172 15:03:52.497 pjsua_media.c RTCP socket reachable at 10.209.2.150:4173 15:03:52.497 pjsua_media.c RTP socket reachable at 10.209.2.150:4174 15:03:52.497 pjsua_media.c RTCP socket reachable at 10.209.2.150:4175 15:03:52.497 pjsua_media.c RTP socket reachable at 10.209.2.150:4176 15:03:52.497 pjsua_media.c RTCP socket reachable at 10.209.2.150:4177 15:03:52.513 pjsua_media.c RTP socket reachable at 10.209.2.150:4178 15:03:52.513 pjsua_media.c RTCP socket reachable at 10.209.2.150:4179 15:03:52.513 pjsua_media.c RTP socket reachable at 10.209.2.150:4180 15:03:52.513 pjsua_media.c RTCP socket reachable at 10.209.2.150:4181 15:03:52.529 pjsua_media.c RTP socket reachable at 10.209.2.150:4182 15:03:52.529 pjsua_media.c RTCP socket reachable at 10.209.2.150:4183 15:03:52.529 pjsua_media.c RTP socket reachable at 10.209.2.150:4184 15:03:52.529 pjsua_media.c RTCP socket reachable at 10.209.2.150:4185 15:03:52.529 pjsua_media.c RTP socket reachable at 10.209.2.150:4186 15:03:52.529 pjsua_media.c RTCP socket reachable at 10.209.2.150:4187 15:03:52.544 pjsua_media.c RTP socket reachable at 10.209.2.150:4188 15:03:52.544 pjsua_media.c RTCP socket reachable at 10.209.2.150:4189 15:03:52.544 pjsua_media.c RTP socket reachable at 10.209.2.150:4190 15:03:52.544 pjsua_media.c RTCP socket reachable at 10.209.2.150:4191 15:03:52.560 pjsua_media.c RTP socket reachable at 10.209.2.150:4192 15:03:52.560 pjsua_media.c RTCP socket reachable at 10.209.2.150:4193 15:03:52.560 pjsua_media.c RTP socket reachable at 10.209.2.150:4194 15:03:52.560 pjsua_media.c RTCP socket reachable at 10.209.2.150:4195 15:03:52.560 pjsua_media.c RTP socket reachable at 10.209.2.150:4196 15:03:52.560 pjsua_media.c RTCP socket reachable at 10.209.2.150:4197 15:03:52.576 pjsua_media.c RTP socket reachable at 10.209.2.150:4198 15:03:52.576 pjsua_media.c RTCP socket reachable at 10.209.2.150:4199 15:03:52.576 pjsua_media.c pjsua_set_snd_dev(): attempting to open devices @16000 Hz 15:03:52.654 pasound.c Opened device Primary Sound Capture Driver(Windows DirectSound)/Primary Sound Driver(Windows DirectSound) for recording and playback, sample rate=16000, ch=1, bits=16, 320 samples per frame, input latency=0 ms, output latency=120 ms 15:03:52.654 pasound.c Starting Primary Sound Capture Driver stream.. 15:03:52.654 pasound.c Done, status=0 15:03:52.669 echo_speex.c Speex Echo canceller/AEC created, clock_rate=16000, samples per frame=320, tail length=800 ms, latency=120 ms 15:03:52.701 pasound.c Player thread started 15:03:52.701 pasound.c Recorder thread started 15:03:52.701 aec01AD1CB8 AEC reset, delay=1, prefetch=6 15:03:52.701 aec01AD1CB8 AEC reset, delay=1, prefetch=6 15:03:52.732 aec01AD1CB8 AEC Info: old frame removed (seq=3, want=-3, count=2) 15:03:52.732 aec01AD1CB8 AEC Info: old frame removed (seq=4, want=-3, count=1) 15:03:52.732 aec01AD1CB8 AEC Info: empty queue for seq=-3! 15:03:52.732 aec01AD1CB8 AEC reset, delay=1, prefetch=6 15:03:52.763 aec01AD1CB8 AEC Info: old frame removed (seq=5, want=-1, count=2) 15:03:52.763 aec01AD1CB8 AEC Info: old frame removed (seq=6, want=-1, count=1) 15:03:52.763 aec01AD1CB8 AEC Info: empty queue for seq=-1! 15:03:52.763 aec01AD1CB8 AEC reset, delay=1, prefetch=6 15:03:52.779 pjsua_acc.c Account sip:8003 at 10.209.2.150 added with id 0 15:03:52.794 aec01AD1CB8 AEC Info: prefetching (first seq=7) 15:03:52.826 pjsua_acc.c Account sip:8004 at 10.209.2.150 added with id 1 15:03:52.841 aec01AD1CB8 AEC Info: prefetching (first seq=7) 15:03:52.841 aec01AD1CB8 AEC Info: prefetching (first seq=7) 15:03:52.872 aec01AD1CB8 AEC Info: prefetching (first seq=7) 15:03:52.872 aec01AD1CB8 AEC Info: prefetching (first seq=7) 15:03:52.904 aec01AD1CB8 AEC Info: prefetching (first seq=7) 15:03:57.700 sound_port.c EC suspended because of inactivity 15:04:03.028 sip_endpoint.c Processing incoming message: Request msg INVITE/cseq=1 (rdata00F72EAC) 15:04:03.028 pjsua_core.c RX 855 bytes Request msg INVITE/cseq=1 (rdata00F72EAC) from UDP 10.209.2.150:5065: INVITE sip:8003 at 10.209.2.150 SIP/2.0 Via: SIP/2.0/UDP 10.209.2.150:5065 ;branch=z9hG4bK8037bdcb6e63dc118bff00096b849c3e From: "Anonymous" <sip:anonymous@10.209.2.150:5065>;tag=17824 To: <sip:8003 at 10.209.2.150> Call-ID: 8037BDCB-6E63-DC11-8BFE-00096B849C3E at 10.209.2.150 CSeq: 1 INVITE Contact: <sip:tet at 10.209.2.150:5065> Max-Forwards: 70 User-Agent: SIPPER for 3CX Phone Privacy: user Allow: INVITE, OPTIONS, ACK, BYE, CANCEL, INFO, NOTIFY Content-Type: application/sdp Content-Length: 349 v=0 o=- 3399010443 3399010443 IN IP4 10.209.2.150 s=SIPPER for 3CX Phone c=IN IP4 10.209.2.150 t=0 0 m=audio 5067 RTP/AVP 8 0 2 3 97 110 101 a=rtpmap:8 PCMA/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:2 G726-32/8000 a=rtpmap:3 GSM/8000 a=rtpmap:97 iLBC/8000 a=rtpmap:110 speex/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 a=ptime:20 --end msg-- 15:04:03.059 tsx01ADB25C Transaction created for Request msg INVITE/cseq=1 (rdata00F72EAC) 15:04:03.059 tsx01ADB25C Incoming Request msg INVITE/cseq=1 (rdata00F72EAC) in state Null 15:04:03.059 tsx01ADB25C State changed from Null to Trying, event=RX_MSG 15:04:03.059 dlg01ADAA54 Transaction tsx01ADB25C state changed to Trying 15:04:03.059 dlg01ADAA54 UAS dialog created 15:04:03.059 dlg01ADAA54 Module mod-invite added as dialog usage, data=01ADB10C 15:04:03.059 dlg01ADAA54 Session count inc to 2 by mod-invite 15:04:03.059 inv01ADAA54 UAS invite session created for dialog dlg01ADAA54 15:04:03.059 endpoint Response msg 100/INVITE/cseq=1 (tdta01ADD09C) created 15:04:03.059 inv01ADAA54 Sending Response msg 100/INVITE/cseq=1 (tdta01ADD09C) 15:04:03.059 dlg01ADAA54 Sending Response msg 100/INVITE/cseq=1 (tdta01ADD09C) 15:04:03.059 tsx01ADB25C Sending Response msg 100/INVITE/cseq=1 (tdta01ADD09C) in state Trying 15:04:03.059 sip_resolve.c Target '10.209.2.150:5065' type=UDP resolved to '10.209.2.150:5065' type=UDP 15:04:03.059 pjsua_core.c TX 310 bytes Response msg 100/INVITE/cseq=1 (tdta01ADD09C) to UDP 10.209.2.150:5065: SIP/2.0 100 Trying Via: SIP/2.0/UDP 10.209.2.150:5065;received=10.209.2.150 ;branch=z9hG4bK8037bdcb6e63dc118bff00096b849c3e Call-ID: 8037BDCB-6E63-DC11-8BFE-00096B849C3E at 10.209.2.150 From: "Anonymous" <sip:anonymous@10.209.2.150>;tag=17824 To: <sip:8003 at 10.209.2.150> CSeq: 1 INVITE Content-Length: 0 --end msg-- 15:04:03.059 tsx01ADB25C State changed from Trying to Proceeding, event=TX_MSG 15:04:03.059 dlg01ADAA54 Transaction tsx01ADB25C state changed to Proceeding 15:04:03.122 inv01ADAA54 SDP negotiation done, status=0 15:04:03.122 strm01AE355C VAD temporarily disabled 15:04:03.122 rtp.c pjmedia_rtp_session_init: ses=01AE4590, default_pt=8, ssrc=0x18be6784 15:04:03.122 rtp.c pjmedia_rtp_session_init: ses=01AE5198, default_pt=8, ssrc=0x18be6784 15:04:03.122 stream.c Stream strm01AE355C created 15:04:03.122 strm01AE355C Encoder stream started 15:04:03.122 strm01AE355C Decoder stream started 15:04:03.122 resample.c resample created: high qualiy, large filter, in/out rate=8000/16000 15:04:03.122 resample.c resample created: high qualiy, large filter, in/out rate=16000/8000 15:04:03.122 pjsua_call.c Media updates, stream #0: PCMA (sendrecv) 15:04:03.122 inv01ADAA54 Sending Response msg 200/INVITE/cseq=1 (tdta01ADD09C) 15:04:03.122 dlg01ADAA54 Sending Response msg 200/INVITE/cseq=1 (tdta01ADD09C) 15:04:03.122 tsx01ADB25C Sending Response msg 200/INVITE/cseq=1 (tdta01ADD09C) in state Proceeding 15:04:03.122 pjsua_core.c TX 789 bytes Response msg 200/INVITE/cseq=1 (tdta01ADD09C) to UDP 10.209.2.150:5065: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.209.2.150:5065;received=10.209.2.150 ;branch=z9hG4bK8037bdcb6e63dc118bff00096b849c3e Call-ID: 8037BDCB-6E63-DC11-8BFE-00096B849C3E at 10.209.2.150 From: "Anonymous" <sip:anonymous@10.209.2.150>;tag=17824 To: <sip:8003 at 10.209.2.150>;tag=f33101722dec4d4fb946d058e42fe9df CSeq: 1 INVITE Contact: <sip:8003 at 10.209.2.150:5060;transport=UDP> Allow: INVITE, ACK, BYE, CANCEL, SUBSCRIBE, NOTIFY, PUBLISH, REFER, MESSAGE, OPTIONS Supported: replaces, norefersub Content-Type: application/sdp Content-Length: 240 v=0 o=- 3399030243 3399030244 IN IP4 10.209.2.150 s=pjmedia c=IN IP4 10.209.2.150 t=0 0 m=audio 4000 RTP/AVP 8 101 a=rtcp:4001 IN IP4 10.209.2.150 a=rtpmap:8 PCMA/8000 a=sendrecv a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 --end msg-- 15:04:03.137 tsx01ADB25C State changed from Proceeding to Completed, event=TX_MSG 15:04:03.137 dlg01ADAA54 Transaction tsx01ADB25C state changed to Completed 15:04:03.153 strm01AE355C Start talksprut.. 15:04:03.278 sip_endpoint.c Processing incoming message: Request msg ACK/cseq=1 (rdata00F72EAC) 15:04:03.278 pjsua_core.c RX 411 bytes Request msg ACK/cseq=1 (rdata00F72EAC) from UDP 10.209.2.150:5065: ACK sip:8003 at 10.209.2.150:5060;transport=UDP SIP/2.0 Via: SIP/2.0/UDP 10.209.2.150:5065 ;branch=z9hG4bK8037bdcb6e63dc118c0000096b849c3e From: "Anonymous" <sip:anonymous@10.209.2.150>;tag=17824 To: <sip:8003 at 10.209.2.150>;tag=f33101722dec4d4fb946d058e42fe9df Call-ID: 8037BDCB-6E63-DC11-8BFE-00096B849C3E at 10.209.2.150 CSeq: 1 ACK Contact: <sip:tet at 10.209.2.150:5065> Max-Forwards: 70 Content-Length: 0 --end msg-- 15:04:03.278 dlg01ADAA54 Received Request msg ACK/cseq=1 (rdata00F72EAC) 15:04:03.278 tsx01ADB25C Request to terminate transaction 15:04:03.278 tsx01ADB25C State changed from Completed to Terminated, event=USER 15:04:03.278 dlg01ADAA54 Transaction tsx01ADB25C state changed to Terminated 15:04:03.294 tsx01ADB25C Timeout timer event 15:04:03.294 tsx01ADB25C State changed from Terminated to Destroyed, event=TIMER 15:04:03.294 tdta01ADD09C Destroying txdata Response msg 200/INVITE/cseq=1 (tdta01ADD09C) 15:04:03.294 tsx01ADB25C Transaction destroyed! 15:04:03.700 strm01AE355C RTP status: badpt=0, badssrc=0, dup=0, outorder=0, probation=-1, restart=0 15:04:03.794 strm01AE355C VAD re-enabled 15:04:03.794 strm01AE355C Starting silence 15:04:04.278 strm01AE355C Start talksprut.. 15:04:04.309 strm01AE355C Starting silence 15:04:04.809 strm01AE355C Start talksprut.. 15:04:04.809 strm01AE355C Starting silence 15:04:05.294 strm01AE355C Start talksprut.. 15:04:05.325 strm01AE355C Starting silence 15:04:05.559 wav_playlist.c WAV playlist 'WAV playlist' created: samp.rate=8000, ch=1, bufsize=4KB 15:04:05.559 resample.c resample created: high qualiy, large filter, in/out rate=8000/16000 15:04:05.559 resample.c resample created: high qualiy, large filter, in/out rate=16000/8000 15:04:05.559 conference.c Port 2 (WAV playlist) transmitting to port 1 ( sip:anonymous at 10.209.2.150:5065) 15:04:05.575 conference.c Port 2 (WAV playlist) stop transmitting to port 1 (sip:anonymous at 10.209.2.150:5065) 15:04:05.606 wav_playlist.c WAV playlist 'WAV playlist' created: samp.rate=8000, ch=1, bufsize=4KB 15:04:05.606 resample.c resample created: high qualiy, large filter, in/out rate=8000/16000 15:04:05.606 resample.c resample created: high qualiy, large filter, in/out rate=16000/8000 15:04:05.606 conference.c Port 2 (WAV playlist) transmitting to port 1 ( sip:anonymous at 10.209.2.150:5065) 15:04:05.622 strm01AE355C Start talksprut.. 15:04:07.637 silencedet.c Vad cur_threshold updated 4-->5. Signal lo=5 15:04:08.278 sip_endpoint.c Processing incoming message: Request msg INVITE/cseq=1 (rdata00F72EAC) 15:04:08.278 pjsua_core.c RX 826 bytes Request msg INVITE/cseq=1 (rdata00F72EAC) from UDP 10.209.2.150:49152: INVITE sip:8003 at 10.209.2.150 SIP/2.0 Via: SIP/2.0/UDP 127.0.0.1:49152 ;branch=z9hG4bK0ad102960000002046ee4a10000033eb00000008;rport From: "unknown" <sip:127.0.0.1:49152>;tag=60d419990d6b To: <sip:8003 at 10.209.2.150> Contact: <sip:127.0.0.1:49152> Call-ID: 729331EA37104553A32759C210AF2F460x0ad10296 CSeq: 1 INVITE Max-Forwards: 70 User-Agent: SJphone/1.65.377a (SJ Labs) Content-Length: 356 Content-Type: application/sdp Supported: replaces,norefersub,timer v=0 o=- 3399010448 3399010449 IN IP4 127.0.0.1 s=SJphone c=IN IP4 127.0.0.1 t=0 0 m=audio 49156 RTP/AVP 3 97 98 8 0 101 c=IN IP4 127.0.0.1 a=rtpmap:3 GSM/8000 a=rtpmap:97 iLBC/8000 a=rtpmap:98 iLBC/8000 a=fmtp:98 mode=20 a=rtpmap:8 PCMA/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=setup:active a=sendrecv --end msg-- 15:04:08.278 tsx01AF5224 Transaction created for Request msg INVITE/cseq=1 (rdata00F72EAC) 15:04:08.278 tsx01AF5224 Incoming Request msg INVITE/cseq=1 (rdata00F72EAC) in state Null 15:04:08.278 tsx01AF5224 State changed from Null to Trying, event=RX_MSG 15:04:08.278 dlg01AF4A1C Transaction tsx01AF5224 state changed to Trying 15:04:08.278 dlg01AF4A1C UAS dialog created 15:04:08.278 dlg01AF4A1C Module mod-invite added as dialog usage, data=01AF50B0 15:04:08.278 dlg01AF4A1C Session count inc to 2 by mod-invite 15:04:08.278 inv01AF4A1C UAS invite session created for dialog dlg01AF4A1C 15:04:08.278 endpoint Response msg 100/INVITE/cseq=1 (tdta01AF706C) created 15:04:08.278 inv01AF4A1C Sending Response msg 100/INVITE/cseq=1 (tdta01AF706C) 15:04:08.278 dlg01AF4A1C Sending Response msg 100/INVITE/cseq=1 (tdta01AF706C) 15:04:08.278 tsx01AF5224 Sending Response msg 100/INVITE/cseq=1 (tdta01AF706C) in state Trying 15:04:08.278 pjsua_core.c TX 313 bytes Response msg 100/INVITE/cseq=1 (tdta01AF706C) to UDP 10.209.2.150:49152: SIP/2.0 100 Trying Via: SIP/2.0/UDP 127.0.0.1:49152;rport=49152;received=10.209.2.150 ;branch=z9hG4bK0ad102960000002046ee4a10000033eb00000008 Call-ID: 729331EA37104553A32759C210AF2F460x0ad10296 From: "unknown" <sip:127.0.0.1>;tag=60d419990d6b To: <sip:8003 at 10.209.2.150> CSeq: 1 INVITE Content-Length: 0 --end msg-- 15:04:08.278 tsx01AF5224 State changed from Trying to Proceeding, event=TX_MSG 15:04:08.278 dlg01AF4A1C Transaction tsx01AF5224 state changed to Proceeding 15:04:08.325 dlg01AF4A1C Module mod-evsub added as dialog usage, data=01AF83BC 15:04:08.325 evsub01AF8024 UAC subscription created, using dialog dlg01AF4A1C 15:04:08.325 dlg01AF4A1C Session count inc to 5 by mod-evsub 15:04:08.325 endpoint Request msg REFER/cseq=2705444 (tdta01AF8484) created. 15:04:08.325 dlg01AF4A1C Sending Request msg REFER/cseq=2705444 (tdta01AF8484) 15:04:08.325 tsx01AF948C Transaction created for Request msg REFER/cseq=2705443 (tdta01AF8484) 15:04:08.325 tsx01AF948C Sending Request msg REFER/cseq=2705443 (tdta01AF8484) in state Null 15:04:08.325 sip_resolve.c Target '127.0.0.1:49152' type=Unspecified resolved to '127.0.0.1:49152' type=UDP 15:04:08.325 pjsua_core.c TX 572 bytes Request msg REFER/cseq=2705443 (tdta01AF8484) to UDP 127.0.0.1:49152: REFER sip:127.0.0.1:49152 SIP/2.0 Via: SIP/2.0/UDP 10.209.2.150:5060 ;rport;branch=z9hG4bKPjfa8cff356bf74da59bc22074bd827f13 Max-Forwards: 70 From: <sip:8003@10.209.2.150>;tag=b739a44076794264bd7c9f6ede51e836 To: "unknown" <sip:127.0.0.1>;tag=60d419990d6b Contact: <sip:8003 at 10.209.2.150:5060;transport=UDP> Call-ID: 729331EA37104553A32759C210AF2F460x0ad10296 CSeq: 2705443 REFER Event: refer Expires: 300 Accept: message/sipfrag;version=2.0 Allow-Events: presence, refer Refer-To: 8004 at 10.209.2.150 Referred-By: <sip:8003 at 10.209.2.150> Content-Length: 0 --end msg-- 15:04:08.325 tsx01AF948C State changed from Null to Calling, event=TX_MSG 15:04:08.325 dlg01AF4A1C Transaction tsx01AF948C state changed to Calling 15:04:08.325 evsub01AF8024 Subscription state changed NULL --> SENT 15:04:08.340 wav_playlist.c File port WAV playlist EOF, stopping.. 15:04:08.825 tsx01AF948C Retransmit timer event 15:04:08.825 tsx01AF948C Retransmiting Request msg REFER/cseq=2705443 (tdta01AF8484), count=0, restart?=1 15:04:08.825 pjsua_core.c TX 572 bytes Request msg REFER/cseq=2705443 (tdta01AF8484) to UDP 127.0.0.1:49152: REFER sip:127.0.0.1:49152 SIP/2.0 Via: SIP/2.0/UDP 10.209.2.150:5060 ;rport;branch=z9hG4bKPjfa8cff356bf74da59bc22074bd827f13 Max-Forwards: 70 From: <sip:8003@10.209.2.150>;tag=b739a44076794264bd7c9f6ede51e836 To: "unknown" <sip:127.0.0.1>;tag=60d419990d6b Contact: <sip:8003 at 10.209.2.150:5060;transport=UDP> Call-ID: 729331EA37104553A32759C210AF2F460x0ad10296 CSeq: 2705443 REFER Event: refer Expires: 300 Accept: message/sipfrag;version=2.0 Allow-Events: presence, refer Refer-To: 8004 at 10.209.2.150 Referred-By: <sip:8003 at 10.209.2.150> Content-Length: 0 --end msg-- 15:04:08.934 sip_endpoint.c Processing incoming message: Response msg 500/REFER/cseq=2705443 (rdata00F72EAC) 15:04:08.934 pjsua_core.c RX 398 bytes Response msg 500/REFER/cseq=2705443 (rdata00F72EAC) from UDP 127.0.0.1:49152: SIP/2.0 500 Server Internal Error Via: SIP/2.0/UDP 10.209.2.150:5060 ;branch=z9hG4bKPjfa8cff356bf74da59bc22074bd827f13;rport=5060;received= 127.0.0.1 From: <sip:8003@10.209.2.150>;tag=b739a44076794264bd7c9f6ede51e836 To: "unknown" <sip:127.0.0.1>;tag=60d419990d6b Call-ID: 729331EA37104553A32759C210AF2F460x0ad10296 CSeq: 2705443 REFER Content-Length: 0 Server: SJphone/1.65.377a (SJ Labs) --end msg-- 15:04:08.934 tsx01AF948C Incoming Response msg 500/REFER/cseq=2705443 (rdata00F72EAC) in state Calling 15:04:08.934 tsx01AF948C State changed from Calling to Completed, event=RX_MSG 15:04:08.934 dlg01AF4A1C Received Response msg 500/REFER/cseq=2705443 (rdata00F72EAC) 15:04:08.934 dlg01AF4A1C Transaction tsx01AF948C state changed to Completed 15:04:08.934 evsub01AF8024 Subscription state changed SENT --> TERMINATED 15:04:08.934 pjsua_call.c Xfer client subscription terminated 15:04:08.934 sip_endpoint.c Processing incoming message: Response msg 500/REFER/cseq=2705443 (rdata00F72EAC) 15:04:08.934 pjsua_core.c RX 398 bytes Response msg 500/REFER/cseq=2705443 (rdata00F72EAC) from UDP 127.0.0.1:49152: SIP/2.0 500 Server Internal Error Via: SIP/2.0/UDP 10.209.2.150:5060 ;branch=z9hG4bKPjfa8cff356bf74da59bc22074bd827f13;rport=5060;received= 127.0.0.1 From: <sip:8003@10.209.2.150>;tag=b739a44076794264bd7c9f6ede51e836 To: "unknown" <sip:127.0.0.1>;tag=60d419990d6b Call-ID: 729331EA37104553A32759C210AF2F460x0ad10296 CSeq: 2705443 REFER Content-Length: 0 Server: SJphone/1.65.377a (SJ Labs) --end msg-- 15:04:08.934 tsx01AF948C Incoming Response msg 500/REFER/cseq=2705443 (rdata00F72EAC) in state Completed 15:04:08.965 strm01AE355C Starting silence 15:04:09.465 strm01AE355C Start talksprut.. 15:04:09.497 strm01AE355C Starting silence 15:04:09.981 strm01AE355C Start talksprut.. 15:04:10.012 strm01AE355C Starting silence 15:04:10.481 strm01AE355C Start talksprut.. 15:04:10.512 strm01AE355C Starting silence 15:04:10.996 strm01AE355C Start talksprut.. 15:04:10.996 strm01AE355C Starting silence 15:04:11.528 strm01AE355C Start talksprut.. 15:04:11.528 strm01AE355C Starting silence 15:04:12.012 strm01AE355C Start talksprut.. 15:04:12.043 strm01AE355C Starting silence 15:04:12.543 strm01AE355C Start talksprut.. 15:04:12.574 strm01AE355C Starting silence 15:04:12.856 silencedet.c Vad cur_threshold updated 5-->3. Signal lo=-1 15:04:13.059 strm01AE355C Start talksprut.. 15:04:13.106 strm01AE355C Starting silence 15:04:13.559 strm01AE355C Start talksprut.. 15:04:13.590 strm01AE355C Starting silence 15:04:13.934 tsx01AF948C Timeout timer event 15:04:13.934 tsx01AF948C State changed from Completed to Terminated, event=TIMER 15:04:13.934 dlg01AF4A1C Transaction tsx01AF948C state changed to Terminated 15:04:13.934 evsub01AF8024 Subscription destroyed 15:04:13.934 dlg01AF4A1C Session count dec to 2 by mod-evsub 15:04:13.934 tsx01AF948C Timeout timer event 15:04:13.934 tsx01AF948C State changed from Terminated to Destroyed, event=TIMER 15:04:13.934 tdta01AF8484 Destroying txdata Request msg REFER/cseq=2705443 (tdta01AF8484) 15:04:13.934 tsx01AF948C Transaction destroyed! 15:04:14.074 strm01AE355C Start talksprut.. 15:04:14.074 strm01AE355C Starting silence 15:04:14.606 strm01AE355C Start talksprut.. 15:04:14.606 strm01AE355C Starting silence 15:04:14.840 sip_endpoint.c Processing incoming message: Request msg CANCEL/cseq=1 (rdata00F72EAC) 15:04:14.840 pjsua_core.c RX 367 bytes Request msg CANCEL/cseq=1 (rdata00F72EAC) from UDP 10.209.2.150:49152: CANCEL sip:8003 at 10.209.2.150 SIP/2.0 Via: SIP/2.0/UDP 127.0.0.1:49152 ;branch=z9hG4bK0ad102960000002046ee4a10000033eb00000008;rport From: "unknown" <sip:127.0.0.1:49152>;tag=60d419990d6b To: <sip:8003 at 10.209.2.150> Call-ID: 729331EA37104553A32759C210AF2F460x0ad10296 CSeq: 1 CANCEL Max-Forwards: 70 User-Agent: SJphone/1.65.377a (SJ Labs) Content-Length: 0 --end msg-- 15:04:14.840 dlg01AF4A1C Received Request msg CANCEL/cseq=1 (rdata00F72EAC) 15:04:14.840 tsx01AF3A74 Transaction created for Request msg CANCEL/cseq=1 (rdata00F72EAC) 15:04:14.840 tsx01AF3A74 Incoming Request msg CANCEL/cseq=1 (rdata00F72EAC) in state Null 15:04:14.840 tsx01AF3A74 State changed from Null to Trying, event=RX_MSG 15:04:14.840 dlg01AF4A1C Transaction tsx01AF3A74 state changed to Trying 15:04:14.840 endpoint Response msg 200/CANCEL/cseq=1 (tdta01ADD09C) created 15:04:14.840 dlg01AF4A1C Sending Response msg 200/CANCEL/cseq=1 (tdta01ADD09C) 15:04:14.840 tsx01AF3A74 Sending Response msg 200/CANCEL/cseq=1 (tdta01ADD09C) in state Trying 15:04:14.840 pjsua_core.c TX 346 bytes Response msg 200/CANCEL/cseq=1 (tdta01ADD09C) to UDP 10.209.2.150:49152: SIP/2.0 200 OK Via: SIP/2.0/UDP 127.0.0.1:49152;rport=49152;received=10.209.2.150 ;branch=z9hG4bK0ad102960000002046ee4a10000033eb00000008 Call-ID: 729331EA37104553A32759C210AF2F460x0ad10296 From: "unknown" <sip:127.0.0.1>;tag=60d419990d6b To: <sip:8003 at 10.209.2.150>;tag=b739a44076794264bd7c9f6ede51e836 CSeq: 1 CANCEL Content-Length: 0 --end msg-- 15:04:14.840 tsx01AF3A74 State changed from Trying to Completed, event=TX_MSG 15:04:14.840 dlg01AF4A1C Transaction tsx01AF3A74 state changed to Completed 15:04:14.840 dlg01AF4A1C Sending Response msg 487/INVITE/cseq=1 (tdta01AF706C) 15:04:14.840 tsx01AF5224 Sending Response msg 487/INVITE/cseq=1 (tdta01AF706C) in state Proceeding 15:04:14.840 pjsua_core.c TX 362 bytes Response msg 487/INVITE/cseq=1 (tdta01AF706C) to UDP 10.209.2.150:49152: SIP/2.0 487 Request Terminated Via: SIP/2.0/UDP 127.0.0.1:49152;rport=49152;received=10.209.2.150 ;branch=z9hG4bK0ad102960000002046ee4a10000033eb00000008 Call-ID: 729331EA37104553A32759C210AF2F460x0ad10296 From: "unknown" <sip:127.0.0.1>;tag=60d419990d6b To: <sip:8003 at 10.209.2.150>;tag=b739a44076794264bd7c9f6ede51e836 CSeq: 1 INVITE Content-Length: 0 --end msg-- 15:04:14.840 tsx01AF5224 State changed from Proceeding to Completed, event=TX_MSG 15:04:14.840 dlg01AF4A1C Transaction tsx01AF5224 state changed to Completed 15:04:14.856 dlg01AF4A1C Session count dec to 5 by mod-invite 15:04:14.856 sip_endpoint.c Processing incoming message: Request msg ACK/cseq=1 (rdata00F72EAC) 15:04:14.856 pjsua_core.c RX 398 bytes Request msg ACK/cseq=1 (rdata00F72EAC) from UDP 10.209.2.150:49152: ACK sip:8003 at 10.209.2.150 SIP/2.0 Via: SIP/2.0/UDP 127.0.0.1:49152 ;branch=z9hG4bK0ad102960000002046ee4a10000033eb00000008;rport From: "unknown" <sip:127.0.0.1:49152>;tag=60d419990d6b To: <sip:8003 at 10.209.2.150>;tag=b739a44076794264bd7c9f6ede51e836 Call-ID: 729331EA37104553A32759C210AF2F460x0ad10296 CSeq: 1 ACK Max-Forwards: 70 User-Agent: SJphone/1.65.377a (SJ Labs) Content-Length: 0 --end msg-- 15:04:14.856 tsx01AF5224 Incoming Request msg ACK/cseq=1 (rdata00F72EAC) in state Completed 15:04:14.856 tsx01AF5224 State changed from Completed to Confirmed, event=RX_MSG 15:04:14.856 dlg01AF4A1C Transaction tsx01AF5224 state changed to Confirmed 15:04:15.090 strm01AE355C Start talksprut.. 15:04:15.137 strm01AE355C Starting silence 15:04:15.621 strm01AE355C Start talksprut.. 15:04:15.652 strm01AE355C Starting silence 15:04:16.137 strm01AE355C Start talksprut.. 15:04:16.137 strm01AE355C Starting silence 15:04:16.637 strm01AE355C Start talksprut.. 15:04:16.668 strm01AE355C Starting silence 15:04:16.746 silencedet.c Vad cur_threshold updated 3-->2. Signal lo=-1 15:04:17.152 strm01AE355C Start talksprut.. 15:04:17.152 strm01AE355C Starting silence 15:04:17.684 strm01AE355C Start talksprut.. 15:04:17.684 strm01AE355C Starting silence 15:04:17.793 sip_endpoint.c Processing incoming message: Request msg BYE/cseq=2 (rdata00F72EAC) 15:04:17.793 pjsua_core.c RX 407 bytes Request msg BYE/cseq=2 (rdata00F72EAC) from UDP 10.209.2.150:5065: BYE sip:8003 at 10.209.2.150:5060;transport=UDP SIP/2.0 Via: SIP/2.0/UDP 10.209.2.150:5065 ;branch=z9hG4bK807215d46e63dc118c0000096b849c3e From: "Anonymous" <sip:anonymous@10.209.2.150>;tag=17824 To: <sip:8003 at 10.209.2.150>;tag=f33101722dec4d4fb946d058e42fe9df Call-ID: 8037BDCB-6E63-DC11-8BFE-00096B849C3E at 10.209.2.150 CSeq: 2 BYE Max-Forwards: 70 User-Agent: SIPPER for 3CX Phone Content-Length: 0 --end msg-- 15:04:17.793 dlg01ADAA54 Received Request msg BYE/cseq=2 (rdata00F72EAC) 15:04:17.793 tsx01AD9AA4 Transaction created for Request msg BYE/cseq=2 (rdata00F72EAC) 15:04:17.793 tsx01AD9AA4 Incoming Request msg BYE/cseq=2 (rdata00F72EAC) in state Null 15:04:17.793 tsx01AD9AA4 State changed from Null to Trying, event=RX_MSG 15:04:17.793 dlg01ADAA54 Transaction tsx01AD9AA4 state changed to Trying 15:04:17.793 endpoint Response msg 200/BYE/cseq=2 (tdta01AF8484) created 15:04:17.793 dlg01ADAA54 Sending Response msg 200/BYE/cseq=2 (tdta01AF8484) 15:04:17.793 tsx01AD9AA4 Sending Response msg 200/BYE/cseq=2 (tdta01AF8484) in state Trying 15:04:17.793 sip_resolve.c Target '10.209.2.150:5065' type=UDP resolved to '10.209.2.150:5065' type=UDP 15:04:17.793 pjsua_core.c TX 340 bytes Response msg 200/BYE/cseq=2 (tdta01AF8484) to UDP 10.209.2.150:5065: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.209.2.150:5065;received=10.209.2.150 ;branch=z9hG4bK807215d46e63dc118c0000096b849c3e Call-ID: 8037BDCB-6E63-DC11-8BFE-00096B849C3E at 10.209.2.150 From: "Anonymous" <sip:anonymous@10.209.2.150>;tag=17824 To: <sip:8003 at 10.209.2.150>;tag=f33101722dec4d4fb946d058e42fe9df CSeq: 2 BYE Content-Length: 0 --end msg-- 15:04:17.793 tsx01AD9AA4 State changed from Trying to Completed, event=TX_MSG 15:04:17.793 dlg01ADAA54 Transaction tsx01AD9AA4 state changed to Completed 15:04:17.840 pjsua_call.c Media session for call 0 is destroyed 15:04:17.840 dlg01ADAA54 Session count dec to 3 by mod-invite 15:04:17.871 pjsua_call.c Invalid call_id 0 in pjsua_call_hangup() 15:04:19.871 tsx01AF5224 Timeout timer event 15:04:19.871 tsx01AF5224 State changed from Confirmed to Terminated, event=TIMER 15:04:19.871 dlg01AF4A1C Transaction tsx01AF5224 state changed to Terminated 15:04:19.871 tsx01AF5224 Timeout timer event 15:04:19.871 tsx01AF5224 State changed from Terminated to Destroyed, event=TIMER 15:04:19.871 tdta01AF706C Destroying txdata Response msg 487/INVITE/cseq=1 (tdta01AF706C) 15:04:19.871 tsx01AF5224 Transaction destroyed! 15:04:21.496 sip_endpoint.c Processing incoming message: Request msg INVITE/cseq=1 (rdata00F72EAC) 15:04:21.496 pjsua_core.c RX 825 bytes Request msg INVITE/cseq=1 (rdata00F72EAC) from UDP 10.209.2.150:49152: INVITE sip:8003 at 10.209.2.150 SIP/2.0 Via: SIP/2.0/UDP 127.0.0.1:49152 ;branch=z9hG4bK0ad102960000002946ee4a1d00001ff00000000f;rport From: "unknown" <sip:127.0.0.1:49152>;tag=6521999410e To: <sip:8003 at 10.209.2.150> Contact: <sip:127.0.0.1:49152> Call-ID: FF5AF7F7E8204C3D93BDFFD1751C29E10x0ad10296 CSeq: 1 INVITE Max-Forwards: 70 User-Agent: SJphone/1.65.377a (SJ Labs) Content-Length: 356 Content-Type: application/sdp Supported: replaces,norefersub,timer v=0 o=- 3399010461 3399010462 IN IP4 127.0.0.1 s=SJphone c=IN IP4 127.0.0.1 t=0 0 m=audio 49158 RTP/AVP 3 97 98 8 0 101 c=IN IP4 127.0.0.1 a=rtpmap:3 GSM/8000 a=rtpmap:97 iLBC/8000 a=rtpmap:98 iLBC/8000 a=fmtp:98 mode=20 a=rtpmap:8 PCMA/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=setup:active a=sendrecv --end msg-- 15:04:21.496 tsx01AEE06C Transaction created for Request msg INVITE/cseq=1 (rdata00F72EAC) 15:04:21.496 tsx01AEE06C Incoming Request msg INVITE/cseq=1 (rdata00F72EAC) in state Null 15:04:21.496 tsx01AEE06C State changed from Null to Trying, event=RX_MSG 15:04:21.496 dlg01AF5224 Transaction tsx01AEE06C state changed to Trying 15:04:21.496 dlg01AF5224 UAS dialog created 15:04:21.496 dlg01AF5224 Module mod-invite added as dialog usage, data=01AF58B8 15:04:21.496 dlg01AF5224 Session count inc to 2 by mod-invite 15:04:21.496 inv01AF5224 UAS invite session created for dialog dlg01AF5224 15:04:21.496 endpoint Response msg 100/INVITE/cseq=1 (tdta01AFB9EC) created 15:04:21.496 inv01AF5224 Sending Response msg 100/INVITE/cseq=1 (tdta01AFB9EC) 15:04:21.496 dlg01AF5224 Sending Response msg 100/INVITE/cseq=1 (tdta01AFB9EC) 15:04:21.496 tsx01AEE06C Sending Response msg 100/INVITE/cseq=1 (tdta01AFB9EC) in state Trying 15:04:21.496 pjsua_core.c TX 312 bytes Response msg 100/INVITE/cseq=1 (tdta01AFB9EC) to UDP 10.209.2.150:49152: SIP/2.0 100 Trying Via: SIP/2.0/UDP 127.0.0.1:49152;rport=49152;received=10.209.2.150 ;branch=z9hG4bK0ad102960000002946ee4a1d00001ff00000000f Call-ID: FF5AF7F7E8204C3D93BDFFD1751C29E10x0ad10296 From: "unknown" <sip:127.0.0.1>;tag=6521999410e To: <sip:8003 at 10.209.2.150> CSeq: 1 INVITE Content-Length: 0 --end msg-- 15:04:21.496 tsx01AEE06C State changed from Trying to Proceeding, event=TX_MSG 15:04:21.496 dlg01AF5224 Transaction tsx01AEE06C state changed to Proceeding 15:04:21.605 inv01AF5224 SDP negotiation done, status=0 15:04:21.668 strm01AFD694 VAD temporarily disabled 15:04:21.668 rtp.c pjmedia_rtp_session_init: ses=01AFDD94, default_pt=3, ssrc=0x18be6784 15:04:21.668 rtp.c pjmedia_rtp_session_init: ses=01AFE518, default_pt=3, ssrc=0x18be6784 15:04:21.668 stream.c Stream strm01AFD694 created 15:04:21.668 strm01AFD694 Encoder stream started 15:04:21.668 strm01AFD694 Decoder stream started 15:04:21.668 resample.c resample created: high qualiy, large filter, in/out rate=8000/16000 15:04:21.668 resample.c resample created: high qualiy, large filter, in/out rate=16000/8000 15:04:21.668 pjsua_call.c Media updates, stream #0: GSM (sendrecv) 15:04:21.668 inv01AF5224 Sending Response msg 200/INVITE/cseq=1 (tdta01AFB9EC) 15:04:21.668 dlg01AF5224 Sending Response msg 200/INVITE/cseq=1 (tdta01AFB9EC) 15:04:21.668 tsx01AEE06C Sending Response msg 200/INVITE/cseq=1 (tdta01AFB9EC) in state Proceeding 15:04:21.668 pjsua_core.c TX 790 bytes Response msg 200/INVITE/cseq=1 (tdta01AFB9EC) to UDP 10.209.2.150:49152: SIP/2.0 200 OK Via: SIP/2.0/UDP 127.0.0.1:49152;rport=49152;received=10.209.2.150 ;branch=z9hG4bK0ad102960000002946ee4a1d00001ff00000000f Call-ID: FF5AF7F7E8204C3D93BDFFD1751C29E10x0ad10296 From: "unknown" <sip:127.0.0.1>;tag=6521999410e To: <sip:8003 at 10.209.2.150>;tag=91eecf34e44742c3b5d5498c58f2f4e9 CSeq: 1 INVITE Contact: <sip:8003 at 10.209.2.150:5060;transport=UDP> Allow: INVITE, ACK, BYE, CANCEL, SUBSCRIBE, NOTIFY, PUBLISH, REFER, MESSAGE, OPTIONS Supported: replaces, norefersub Content-Type: application/sdp Content-Length: 239 v=0 o=- 3399030261 3399030262 IN IP4 10.209.2.150 s=pjmedia c=IN IP4 10.209.2.150 t=0 0 m=audio 4000 RTP/AVP 3 101 a=rtcp:4001 IN IP4 10.209.2.150 a=rtpmap:3 GSM/8000 a=sendrecv a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 --end msg-- 15:04:21.668 tsx01AEE06C State changed from Proceeding to Completed, event=TX_MSG 15:04:21.668 dlg01AF5224 Transaction tsx01AEE06C state changed to Completed 15:04:21.668 strm01AFD694 Start talksprut.. 15:04:22.168 tsx01AEE06C Retransmit timer event 15:04:22.168 tsx01AEE06C Retransmiting Response msg 200/INVITE/cseq=1 (tdta01AFB9EC), count=0, restart?=1 15:04:22.168 pjsua_core.c TX 790 bytes Response msg 200/INVITE/cseq=1 (tdta01AFB9EC) to UDP 10.209.2.150:49152: SIP/2.0 200 OK Via: SIP/2.0/UDP 127.0.0.1:49152;rport=49152;received=10.209.2.150 ;branch=z9hG4bK0ad102960000002946ee4a1d00001ff00000000f Call-ID: FF5AF7F7E8204C3D93BDFFD1751C29E10x0ad10296 From: "unknown" <sip:127.0.0.1>;tag=6521999410e To: <sip:8003 at 10.209.2.150>;tag=91eecf34e44742c3b5d5498c58f2f4e9 CSeq: 1 INVITE Contact: <sip:8003 at 10.209.2.150:5060;transport=UDP> Allow: INVITE, ACK, BYE, CANCEL, SUBSCRIBE, NOTIFY, PUBLISH, REFER, MESSAGE, OPTIONS Supported: replaces, norefersub Content-Type: application/sdp Content-Length: 239 v=0 o=- 3399030261 3399030262 IN IP4 10.209.2.150 s=pjmedia c=IN IP4 10.209.2.150 t=0 0 m=audio 4000 RTP/AVP 3 101 a=rtcp:4001 IN IP4 10.209.2.150 a=rtpmap:3 GSM/8000 a=sendrecv a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 --end msg-- 15:04:22.308 strm01AFD694 VAD re-enabled 15:04:22.308 strm01AFD694 Starting silence 15:04:22.324 sip_endpoint.c Processing incoming message: Request msg ACK/cseq=1 (rdata00F72EAC) 15:04:22.324 pjsua_core.c RX 448 bytes Request msg ACK/cseq=1 (rdata00F72EAC) from UDP 10.209.2.150:49152: ACK sip:8003 at 10.209.2.150:5060;transport=UDP SIP/2.0 Via: SIP/2.0/UDP 127.0.0.1:49152 ;branch=z9hG4bK0ad102960000002946ee4a1e00004a1d00000013;rport From: "unknown" <sip:127.0.0.1:49152>;tag=6521999410e To: <sip:8003 at 10.209.2.150>;tag=91eecf34e44742c3b5d5498c58f2f4e9 Contact: <sip:127.0.0.1:49152> Call-ID: FF5AF7F7E8204C3D93BDFFD1751C29E10x0ad10296 CSeq: 1 ACK Max-Forwards: 70 User-Agent: SJphone/1.65.377a (SJ Labs) Content-Length: 0 --end msg-- 15:04:22.324 dlg01AF5224 Received Request msg ACK/cseq=1 (rdata00F72EAC) 15:04:22.324 tsx01AEE06C Request to terminate transaction 15:04:22.324 tsx01AEE06C State changed from Completed to Terminated, event=USER 15:04:22.324 dlg01AF5224 Transaction tsx01AEE06C state changed to Terminated 15:04:22.340 tsx01AEE06C Timeout timer event 15:04:22.340 tsx01AEE06C State changed from Terminated to Destroyed, event=TIMER 15:04:22.340 tdta01AFB9EC Destroying txdata Response msg 200/INVITE/cseq=1 (tdta01AFB9EC) 15:04:22.340 tsx01AEE06C Transaction destroyed! 15:04:22.355 strm01AFD694 RTP status: badpt=0, badssrc=0, dup=0, outorder=0, probation=-1, restart=0 15:04:22.465 sip_endpoint.c Processing incoming message: Request msg ACK/cseq=1 (rdata00F72EAC) 15:04:22.465 pjsua_core.c RX 448 bytes Request msg ACK/cseq=1 (rdata00F72EAC) from UDP 10.209.2.150:49152: ACK sip:8003 at 10.209.2.150:5060;transport=UDP SIP/2.0 Via: SIP/2.0/UDP 127.0.0.1:49152 ;branch=z9hG4bK0ad102960000002946ee4a1e00004a1d00000013;rport From: "unknown" <sip:127.0.0.1:49152>;tag=6521999410e To: <sip:8003 at 10.209.2.150>;tag=91eecf34e44742c3b5d5498c58f2f4e9 Contact: <sip:127.0.0.1:49152> Call-ID: FF5AF7F7E8204C3D93BDFFD1751C29E10x0ad10296 CSeq: 1 ACK Max-Forwards: 70 User-Agent: SJphone/1.65.377a (SJ Labs) Content-Length: 0 --end msg-- 15:04:22.465 dlg01AF5224 Received Request msg ACK/cseq=1 (rdata00F72EAC) 15:04:22.527 udpmedia Remote RTP address switched to 10.209.2.150:49158 15:04:22.793 strm01AFD694 Start talksprut.. 15:04:22.824 strm01AFD694 Starting silence 15:04:23.324 strm01AFD694 Start talksprut.. 15:04:23.324 strm01AFD694 Starting silence 15:04:23.840 strm01AFD694 Start talksprut.. 15:04:23.840 strm01AFD694 Starting silence 15:04:24.293 silencedet.c Vad cur_threshold updated 4-->3. Signal lo=-1 15:04:24.340 strm01AFD694 Start talksprut.. 15:04:24.340 strm01AFD694 Starting silence 15:04:24.496 sip_endpoint.c Processing incoming message: Request msg INVITE/cseq=3 (rdata00F72EAC) 15:04:24.496 pjsua_core.c RX 854 bytes Request msg INVITE/cseq=3 (rdata00F72EAC) from UDP 10.209.2.150:5065: INVITE sip:8003 at 10.209.2.150 SIP/2.0 Via: SIP/2.0/UDP 10.209.2.150:5065 ;branch=z9hG4bK009041d86e63dc118c0100096b849c3e From: "Anonymous" <sip:anonymous@10.209.2.150:5065>;tag=2840 To: <sip:8003 at 10.209.2.150> Call-ID: 009041D8-6E63-DC11-8C00-00096B849C3E at 10.209.2.150 CSeq: 3 INVITE Contact: <sip:tet at 10.209.2.150:5065> Max-Forwards: 70 User-Agent: SIPPER for 3CX Phone Privacy: user Allow: INVITE, OPTIONS, ACK, BYE, CANCEL, INFO, NOTIFY Content-Type: application/sdp Content-Length: 349 v=0 o=- 3399010464 3399010464 IN IP4 10.209.2.150 s=SIPPER for 3CX Phone c=IN IP4 10.209.2.150 t=0 0 m=audio 5067 RTP/AVP 8 0 2 3 97 110 101 a=rtpmap:8 PCMA/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:2 G726-32/8000 a=rtpmap:3 GSM/8000 a=rtpmap:97 iLBC/8000 a=rtpmap:110 speex/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 a=ptime:20 --end msg-- 15:04:24.496 tsx01AE40EC Transaction created for Request msg INVITE/cseq=3 (rdata00F72EAC) 15:04:24.496 tsx01AE40EC Incoming Request msg INVITE/cseq=3 (rdata00F72EAC) in state Null 15:04:24.496 tsx01AE40EC State changed from Null to Trying, event=RX_MSG 15:04:24.496 dlg01AFBE64 Transaction tsx01AE40EC state changed to Trying 15:04:24.496 dlg01AFBE64 UAS dialog created 15:04:24.496 dlg01AFBE64 Module mod-invite added as dialog usage, data=01AFC518 15:04:24.496 dlg01AFBE64 Session count inc to 2 by mod-invite 15:04:24.496 inv01AFBE64 UAS invite session created for dialog dlg01AFBE64 15:04:24.496 endpoint Response msg 100/INVITE/cseq=3 (tdta01AE5D24) created 15:04:24.496 inv01AFBE64 Sending Response msg 100/INVITE/cseq=3 (tdta01AE5D24) 15:04:24.496 dlg01AFBE64 Sending Response msg 100/INVITE/cseq=3 (tdta01AE5D24) 15:04:24.496 tsx01AE40EC Sending Response msg 100/INVITE/cseq=3 (tdta01AE5D24) in state Trying 15:04:24.496 sip_resolve.c Target '10.209.2.150:5065' type=UDP resolved to '10.209.2.150:5065' type=UDP 15:04:24.496 pjsua_core.c TX 309 bytes Response msg 100/INVITE/cseq=3 (tdta01AE5D24) to UDP 10.209.2.150:5065: SIP/2.0 100 Trying Via: SIP/2.0/UDP 10.209.2.150:5065;received=10.209.2.150 ;branch=z9hG4bK009041d86e63dc118c0100096b849c3e Call-ID: 009041D8-6E63-DC11-8C00-00096B849C3E at 10.209.2.150 From: "Anonymous" <sip:anonymous@10.209.2.150>;tag=2840 To: <sip:8003 at 10.209.2.150> CSeq: 3 INVITE Content-Length: 0 --end msg-- 15:04:24.496 tsx01AE40EC State changed from Trying to Proceeding, event=TX_MSG 15:04:24.496 dlg01AFBE64 Transaction tsx01AE40EC state changed to Proceeding 15:04:24.543 dlg01AFBE64 Module mod-evsub added as dialog usage, data=01AE7074 15:04:24.543 evsub01AE6CDC UAC subscription created, using dialog dlg01AFBE64 15:04:24.543 dlg01AFBE64 Session count inc to 5 by mod-evsub 15:04:24.543 endpoint Request msg REFER/cseq=415131525 (tdta01AE713C) created. 15:04:24.543 dlg01AFBE64 Sending Request msg REFER/cseq=415131525 (tdta01AE713C) 15:04:24.543 tsx01AE8144 Transaction created for Request msg REFER/cseq=415131524 (tdta01AE713C) 15:04:24.543 tsx01AE8144 Sending Request msg REFER/cseq=415131524 (tdta01AE713C) in state Null 15:04:24.543 sip_resolve.c Target '10.209.2.150:5065' type=Unspecified resolved to '10.209.2.150:5065' type=UDP 15:04:24.543 pjsua_core.c TX 594 bytes Request msg REFER/cseq=415131524 (tdta01AE713C) to UDP 10.209.2.150:5065: REFER sip:tet at 10.209.2.150:5065 SIP/2.0 Via: SIP/2.0/UDP 10.209.2.150:5060 ;rport;branch=z9hG4bKPj0b20e728d0fb4151bf55001b2c075839 Max-Forwards: 70 From: <sip:8003@10.209.2.150>;tag=1e1eece89cd54cb5a8518fc631ec2bd4 To: "Anonymous" <sip:anonymous at 10.209.2.150>;tag=2840 Contact: <sip:8003 at 10.209.2.150:5060;transport=UDP> Call-ID: 009041D8-6E63-DC11-8C00-00096B849C3E at 10.209.2.150 CSeq: 415131524 REFER Event: refer Expires: 300 Accept: message/sipfrag;version=2.0 Allow-Events: presence, refer Refer-To: 8004 at 10.209.2.150 Referred-By: <sip:8003 at 10.209.2.150> Content-Length: 0 --end msg-- 15:04:24.543 tsx01AE8144 State changed from Null to Calling, event=TX_MSG 15:04:24.543 dlg01AFBE64 Transaction tsx01AE8144 state changed to Calling 15:04:24.543 evsub01AE6CDC Subscription state changed NULL --> SENT 15:04:24.605 sip_endpoint.c Processing incoming message: Response msg 200/REFER/cseq=415131524 (rdata00F72EAC) 15:04:24.605 pjsua_core.c RX 518 bytes Response msg 200/REFER/cseq=415131524 (rdata00F72EAC) from UDP 10.209.2.150:5065: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.209.2.150:5060 ;rport=5060;branch=z9hG4bKPj0b20e728d0fb4151bf55001b2c075839 From: <sip:8003@10.209.2.150>;tag=1e1eece89cd54cb5a8518fc631ec2bd4 To: "Anonymous" <sip:anonymous at 10.209.2.150>;tag=2840 Call-ID: 009041D8-6E63-DC11-8C00-00096B849C3E at 10.209.2.150 CSeq: 415131524 REFER Contact: <sip:tet at 10.209.2.150:5065> Max-Forwards: 70 Server: SIPPER for 3CX Phone Date: Mon, 17 Sep 2007 09:34:24 GMT Allow: INVITE, OPTIONS, ACK, BYE, CANCEL, INFO, NOTIFY Content-Length: 0 --end msg-- 15:04:24.605 tsx01AE8144 Incoming Response msg 200/REFER/cseq=415131524 (rdata00F72EAC) in state Calling 15:04:24.605 tsx01AE8144 State changed from Calling to Completed, event=RX_MSG 15:04:24.605 dlg01AFBE64 Received Response msg 200/REFER/cseq=415131524 (rdata00F72EAC) 15:04:24.605 dlg01AFBE64 Transaction tsx01AE8144 state changed to Completed 15:04:24.605 evsub01AE6CDC Will refresh in 295 seconds 15:04:24.605 evsub01AE6CDC Timer UAC_REFRESH scheduled in 295 seconds 15:04:24.605 evsub01AE6CDC Subscription state changed SENT --> ACCEPTED 15:04:24.746 wav_playlist.c WAV playlist 'WAV playlist' created: samp.rate=8000, ch=1, bufsize=4KB 15:04:24.746 resample.c resample created: high qualiy, large filter, in/out rate=8000/16000 15:04:24.746 resample.c resample created: high qualiy, large filter, in/out rate=16000/8000 15:04:24.746 conference.c Port 2 (WAV playlist) transmitting to port 1 (sip:127.0.0.1:49152) 15:04:24.777 conference.c Port 2 (WAV playlist) stop transmitting to port 1 (sip:127.0.0.1:49152) 15:04:24.793 wav_playlist.c WAV playlist 'WAV playlist' created: samp.rate=8000, ch=1, bufsize=4KB 15:04:24.793 resample.c resample created: high qualiy, large filter, in/out rate=8000/16000 15:04:24.793 resample.c resample created: high qualiy, large filter, in/out rate=16000/8000 15:04:24.793 conference.c Port 2 (WAV playlist) transmitting to port 1 (sip:127.0.0.1:49152) 15:04:24.824 strm01AFD694 Start talksprut.. 15:04:26.621 sip_endpoint.c Processing incoming message: Request msg CANCEL/cseq=3 (rdata00F72EAC) 15:04:26.636 pjsua_core.c RX 417 bytes Request msg CANCEL/cseq=3 (rdata00F72EAC) from UDP 10.209.2.150:5065: CANCEL sip:8003 at 10.209.2.150 SIP/2.0 Via: SIP/2.0/UDP 10.209.2.150:5065 ;branch=z9hG4bK009041d86e63dc118c0100096b849c3e From: "Anonymous" <sip:anonymous@10.209.2.150:5065>;tag=2840 To: <sip:8003 at 10.209.2.150> Call-ID: 009041D8-6E63-DC11-8C00-00096B849C3E at 10.209.2.150 CSeq: 3 CANCEL Max-Forwards: 70 User-Agent: SIPPER for 3CX Phone Allow: INVITE, OPTIONS, ACK, BYE, CANCEL, INFO, NOTIFY Content-Length: 0 --end msg-- 15:04:26.636 dlg01AFBE64 Received Request msg CANCEL/cseq=3 (rdata00F72EAC) 15:04:26.636 tsx01AF7274 Transaction created for Request msg CANCEL/cseq=3 (rdata00F72EAC) 15:04:26.636 tsx01AF7274 Incoming Request msg CANCEL/cseq=3 (rdata00F72EAC) in state Null 15:04:26.636 tsx01AF7274 State changed from Null to Trying, event=RX_MSG 15:04:26.636 dlg01AFBE64 Transaction tsx01AF7274 state changed to Trying 15:04:26.636 endpoint Response msg 200/CANCEL/cseq=3 (tdta01AEC7E4) created 15:04:26.636 dlg01AFBE64 Sending Response msg 200/CANCEL/cseq=3 (tdta01AEC7E4) 15:04:26.636 tsx01AF7274 Sending Response msg 200/CANCEL/cseq=3 (tdta01AEC7E4) in state Trying 15:04:26.636 sip_resolve.c Target '10.209.2.150:5065' type=UDP resolved to '10.209.2.150:5065' type=UDP 15:04:26.636 pjsua_core.c TX 342 bytes Response msg 200/CANCEL/cseq=3 (tdta01AEC7E4) to UDP 10.209.2.150:5065: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.209.2.150:5065;received=10.209.2.150 ;branch=z9hG4bK009041d86e63dc118c0100096b849c3e Call-ID: 009041D8-6E63-DC11-8C00-00096B849C3E at 10.209.2.150 From: "Anonymous" <sip:anonymous@10.209.2.150>;tag=2840 To: <sip:8003 at 10.209.2.150>;tag=1e1eece89cd54cb5a8518fc631ec2bd4 CSeq: 3 CANCEL Content-Length: 0 --end msg-- 15:04:26.636 tsx01AF7274 State changed from Trying to Completed, event=TX_MSG 15:04:26.636 dlg01AFBE64 Transaction tsx01AF7274 state changed to Completed 15:04:26.636 dlg01AFBE64 Sending Response msg 487/INVITE/cseq=3 (tdta01AE5D24) 15:04:26.636 tsx01AE40EC Sending Response msg 487/INVITE/cseq=3 (tdta01AE5D24) in state Proceeding 15:04:26.636 pjsua_core.c TX 358 bytes Response msg 487/INVITE/cseq=3 (tdta01AE5D24) to UDP 10.209.2.150:5065: SIP/2.0 487 Request Terminated Via: SIP/2.0/UDP 10.209.2.150:5065;received=10.209.2.150 ;branch=z9hG4bK009041d86e63dc118c0100096b849c3e Call-ID: 009041D8-6E63-DC11-8C00-00096B849C3E at 10.209.2.150 From: "Anonymous" <sip:anonymous@10.209.2.150>;tag=2840 To: <sip:8003 at 10.209.2.150>;tag=1e1eece89cd54cb5a8518fc631ec2bd4 CSeq: 3 INVITE Content-Length: 0 --end msg-- 15:04:26.668 tsx01AE40EC State changed from Proceeding to Completed, event=TX_MSG 15:04:26.668 dlg01AFBE64 Transaction tsx01AE40EC state changed to Completed 15:04:26.730 dlg01AFBE64 Session count dec to 6 by mod-invite 15:04:26.730 sip_endpoint.c Processing incoming message: Request msg ACK/cseq=3 (rdata00F72EAC) 15:04:26.730 pjsua_core.c RX 335 bytes Request msg ACK/cseq=3 (rdata00F72EAC) from UDP 10.209.2.150:5065: ACK sip:8003 at 10.209.2.150 SIP/2.0 Via: SIP/2.0/UDP 10.209.2.150:5065 ;branch=z9hG4bK009041d86e63dc118c0100096b849c3e From: "Anonymous" <sip:anonymous@10.209.2.150>;tag=2840 To: <sip:8003 at 10.209.2.150>;tag=1e1eece89cd54cb5a8518fc631ec2bd4 Call-ID: 009041D8-6E63-DC11-8C00-00096B849C3E at 10.209.2.150 CSeq: 3 ACK Content-Length: 0 --end msg-- 15:04:26.730 tsx01AE40EC Incoming Request msg ACK/cseq=3 (rdata00F72EAC) in state Completed 15:04:26.730 tsx01AE40EC State changed from Completed to Confirmed, event=RX_MSG 15:04:26.730 dlg01AFBE64 Transaction tsx01AE40EC state changed to Confirmed 15:04:26.855 silencedet.c Vad cur_threshold updated 3-->4. Signal lo=5 15:04:27.558 wav_playlist.c File port WAV playlist EOF, stopping.. 15:04:28.183 strm01AFD694 Starting silence 15:04:28.667 strm01AFD694 Start talksprut.. 15:04:28.667 strm01AFD694 Starting silence 15:04:29.167 strm01AFD694 Start talksprut.. 15:04:29.199 strm01AFD694 Starting silence 15:04:29.620 tsx01AE8144 Timeout timer event 15:04:29.620 tsx01AE8144 State changed from Completed to Terminated, event=TIMER 15:04:29.620 dlg01AFBE64 Transaction tsx01AE8144 state changed to Terminated 15:04:29.620 tsx01AE8144 Timeout timer event 15:04:29.620 tsx01AE8144 State changed from Terminated to Destroyed, event=TIMER 15:04:29.620 tdta01AE713C Destroying txdata Request msg REFER/cseq=415131524 (tdta01AE713C) 15:04:29.620 tsx01AE8144 Transaction destroyed! 15:04:29.683 strm01AFD694 Start talksprut.. 15:04:29.683 strm01AFD694 Starting silence 15:04:30.183 silencedet.c Vad cur_threshold updated 4-->3. Signal lo=-1 15:04:30.183 strm01AFD694 Start talksprut.. 15:04:30.214 strm01AFD694 Starting silence 15:04:30.699 strm01AFD694 Start talksprut.. 15:04:30.699 strm01AFD694 Starting silence 15:04:31.199 strm01AFD694 Start talksprut.. 15:04:31.230 strm01AFD694 Starting silence 15:04:31.714 strm01AFD694 Start talksprut.. 15:04:31.714 strm01AFD694 Starting silence 15:04:31.730 tsx01AE40EC Timeout timer event 15:04:31.730 tsx01AE40EC State changed from Confirmed to Terminated, event=TIMER 15:04:31.730 dlg01AFBE64 Transaction tsx01AE40EC state changed to Terminated 15:04:31.730 tsx01AE40EC Timeout timer event 15:04:31.730 tsx01AE40EC State changed from Terminated to Destroyed, event=TIMER 15:04:31.730 tdta01AE5D24 Destroying txdata Response msg 487/INVITE/cseq=3 (tdta01AE5D24) 15:04:31.730 tsx01AE40EC Transaction destroyed! 15:04:32.214 silencedet.c Vad cur_threshold updated 3-->2. Signal lo=-1 15:04:32.245 strm01AFD694 Start talksprut.. 15:04:32.245 strm01AFD694 Starting silence 15:04:32.730 strm01AFD694 Start talksprut.. 15:04:32.761 strm01AFD694 Starting silence 15:04:33.261 strm01AFD694 Start talksprut.. 15:04:33.261 strm01AFD694 Starting silence 15:04:33.777 strm01AFD694 Start talksprut.. 15:04:33.777 strm01AFD694 Starting silence 15:04:34.277 strm01AFD694 Start talksprut.. 15:04:34.308 strm01AFD694 Starting silence 15:04:34.792 strm01AFD694 Start talksprut.. 15:04:34.792 strm01AFD694 Starting silence 15:04:35.323 strm01AFD694 Start talksprut.. 15:04:35.323 strm01AFD694 Starting silence 15:04:35.808 strm01AFD694 Start talksprut.. 15:04:35.855 strm01AFD694 Starting silence 15:04:36.339 strm01AFD694 Start talksprut.. 15:04:36.339 strm01AFD694 Starting silence 15:04:36.870 strm01AFD694 Start talksprut.. 15:04:36.870 strm01AFD694 Starting silence 15:04:37.354 strm01AFD694 Start talksprut.. 15:04:37.354 strm01AFD694 Starting silence 15:04:37.792 sip_endpoint.c Processing incoming message: Request msg INVITE/cseq=4 (rdata00F72EAC) 15:04:37.792 pjsua_core.c RX 855 bytes Request msg INVITE/cseq=4 (rdata00F72EAC) from UDP 10.209.2.150:5065: INVITE sip:8004 at 10.209.2.150 SIP/2.0 Via: SIP/2.0/UDP 10.209.2.150:5065 ;branch=z9hG4bK803401e06e63dc118c0200096b849c3e From: "Anonymous" <sip:anonymous@10.209.2.150:5065>;tag=21744 To: <sip:8004 at 10.209.2.150> Call-ID: 803401E0-6E63-DC11-8C01-00096B849C3E at 10.209.2.150 CSeq: 4 INVITE Contact: <sip:tet at 10.209.2.150:5065> Max-Forwards: 70 User-Agent: SIPPER for 3CX Phone Privacy: user Allow: INVITE, OPTIONS, ACK, BYE, CANCEL, INFO, NOTIFY Content-Type: application/sdp Content-Length: 349 v=0 o=- 3399010477 3399010477 IN IP4 10.209.2.150 s=SIPPER for 3CX Phone c=IN IP4 10.209.2.150 t=0 0 m=audio 5067 RTP/AVP 8 0 2 3 97 110 101 a=rtpmap:8 PCMA/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:2 G726-32/8000 a=rtpmap:3 GSM/8000 a=rtpmap:97 iLBC/8000 a=rtpmap:110 speex/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 a=ptime:20 --end msg-- 15:04:37.792 tsx01AED7EC Transaction created for Request msg INVITE/cseq=4 (rdata00F72EAC) 15:04:37.792 tsx01AED7EC Incoming Request msg INVITE/cseq=4 (rdata00F72EAC) in state Null 15:04:37.792 tsx01AED7EC State changed from Null to Trying, event=RX_MSG 15:04:37.792 dlg01AE40EC Transaction tsx01AED7EC state changed to Trying 15:04:37.792 dlg01AE40EC UAS dialog created 15:04:37.792 dlg01AE40EC Module mod-invite added as dialog usage, data=01AE47A4 15:04:37.792 dlg01AE40EC Session count inc to 2 by mod-invite 15:04:37.792 inv01AE40EC UAS invite session created for dialog dlg01AE40EC 15:04:37.792 endpoint Response msg 100/INVITE/cseq=4 (tdta01AE856C) created 15:04:37.792 inv01AE40EC Sending Response msg 100/INVITE/cseq=4 (tdta01AE856C) 15:04:37.792 dlg01AE40EC Sending Response msg 100/INVITE/cseq=4 (tdta01AE856C) 15:04:37.792 tsx01AED7EC Sending Response msg 100/INVITE/cseq=4 (tdta01AE856C) in state Trying 15:04:37.792 sip_resolve.c Target '10.209.2.150:5065' type=UDP resolved to '10.209.2.150:5065' type=UDP 15:04:37.792 pjsua_core.c TX 310 bytes Response msg 100/INVITE/cseq=4 (tdta01AE856C) to UDP 10.209.2.150:5065: SIP/2.0 100 Trying Via: SIP/2.0/UDP 10.209.2.150:5065;received=10.209.2.150 ;branch=z9hG4bK803401e06e63dc118c0200096b849c3e Call-ID: 803401E0-6E63-DC11-8C01-00096B849C3E at 10.209.2.150 From: "Anonymous" <sip:anonymous@10.209.2.150>;tag=21744 To: <sip:8004 at 10.209.2.150> CSeq: 4 INVITE Content-Length: 0 --end msg-- 15:04:37.792 tsx01AED7EC State changed from Trying to Proceeding, event=TX_MSG 15:04:37.792 dlg01AE40EC Transaction tsx01AED7EC state changed to Proceeding 15:04:37.886 strm01AFD694 Start talksprut.. 15:04:37.886 strm01AFD694 Starting silence 15:04:37.886 inv01AE40EC SDP negotiation done, status=0 15:04:37.886 strm01B0CE0C VAD temporarily disabled 15:04:37.886 rtp.c pjmedia_rtp_session_init: ses=01B0DE40, default_pt=8, ssrc=0x2cd672ae 15:04:37.886 rtp.c pjmedia_rtp_session_init: ses=01B0EA48, default_pt=8, ssrc=0x2cd672ae 15:04:37.886 stream.c Stream strm01B0CE0C created 15:04:37.886 strm01B0CE0C Encoder stream started 15:04:37.886 strm01B0CE0C Decoder stream started 15:04:37.886 resample.c resample created: high qualiy, large filter, in/out rate=8000/16000 15:04:37.886 resample.c resample created: high qualiy, large filter, in/out rate=16000/8000 15:04:37.886 pjsua_call.c Media updates, stream #0: PCMA (sendrecv) 15:04:37.886 inv01AE40EC Sending Response msg 200/INVITE/cseq=4 (tdta01AE856C) 15:04:37.886 dlg01AE40EC Sending Response msg 200/INVITE/cseq=4 (tdta01AE856C) 15:04:37.886 tsx01AED7EC Sending Response msg 200/INVITE/cseq=4 (tdta01AE856C) in state Proceeding 15:04:37.886 pjsua_core.c TX 789 bytes Response msg 200/INVITE/cseq=4 (tdta01AE856C) to UDP 10.209.2.150:5065: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.209.2.150:5065;received=10.209.2.150 ;branch=z9hG4bK803401e06e63dc118c0200096b849c3e Call-ID: 803401E0-6E63-DC11-8C01-00096B849C3E at 10.209.2.150 From: "Anonymous" <sip:anonymous@10.209.2.150>;tag=21744 To: <sip:8004 at 10.209.2.150>;tag=2d81639ca7244924bcbd38c38f084ebb CSeq: 4 INVITE Contact: <sip:8004 at 10.209.2.150:5060;transport=UDP> Allow: INVITE, ACK, BYE, CANCEL, SUBSCRIBE, NOTIFY, PUBLISH, REFER, MESSAGE, OPTIONS Supported: replaces, norefersub Content-Type: application/sdp Content-Length: 240 v=0 o=- 3399030277 3399030278 IN IP4 10.209.2.150 s=pjmedia c=IN IP4 10.209.2.150 t=0 0 m=audio 4002 RTP/AVP 8 101 a=rtcp:4003 IN IP4 10.209.2.150 a=rtpmap:8 PCMA/8000 a=sendrecv a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 --end msg-- 15:04:37.886 tsx01AED7EC State changed from Proceeding to Completed, event=TX_MSG 15:04:37.886 dlg01AE40EC Transaction tsx01AED7EC state changed to Completed 15:04:37.917 strm01B0CE0C Start talksprut.. 15:04:38.026 sip_endpoint.c Processing incoming message: Request msg ACK/cseq=4 (rdata00F72EAC) 15:04:38.026 pjsua_core.c RX 411 bytes Request msg ACK/cseq=4 (rdata00F72EAC) from UDP 10.209.2.150:5065: ACK sip:8004 at 10.209.2.150:5060;transport=UDP SIP/2.0 Via: SIP/2.0/UDP 10.209.2.150:5065 ;branch=z9hG4bK803401e06e63dc118c0300096b849c3e From: "Anonymous" <sip:anonymous@10.209.2.150>;tag=21744 To: <sip:8004 at 10.209.2.150>;tag=2d81639ca7244924bcbd38c38f084ebb Call-ID: 803401E0-6E63-DC11-8C01-00096B849C3E at 10.209.2.150 CSeq: 4 ACK Contact: <sip:tet at 10.209.2.150:5065> Max-Forwards: 70 Content-Length: 0 --end msg-- 15:04:38.026 dlg01AE40EC Received Request msg ACK/cseq=4 (rdata00F72EAC) 15:04:38.026 tsx01AED7EC Request to terminate transaction 15:04:38.026 tsx01AED7EC State changed from Completed to Terminated, event=USER 15:04:38.026 dlg01AE40EC Transaction tsx01AED7EC state changed to Terminated 15:04:38.104 tsx01AED7EC Timeout timer event 15:04:38.104 tsx01AED7EC State changed from Terminated to Destroyed, event=TIMER 15:04:38.104 tdta01AE856C Destroying txdata Response msg 200/INVITE/cseq=4 (tdta01AE856C) 15:04:38.104 tsx01AED7EC Transaction destroyed! 15:04:38.401 strm01AFD694 Start talksprut.. 15:04:38.401 strm01AFD694 Starting silence 15:04:38.495 strm01B0CE0C RTP status: badpt=0, badssrc=0, dup=0, outorder=0, probation=-1, restart=0 15:04:38.542 strm01B0CE0C VAD re-enabled 15:04:38.542 strm01B0CE0C Starting silence 15:04:38.886 strm01AFD694 Start talksprut.. 15:04:38.933 strm01AFD694 Starting silence 15:04:39.026 strm01B0CE0C Start talksprut.. 15:04:39.073 strm01B0CE0C Starting silence 15:04:39.417 strm01AFD694 Start talksprut.. 15:04:39.417 strm01AFD694 Starting silence 15:04:39.557 strm01B0CE0C Start talksprut.. 15:04:39.557 strm01B0CE0C Starting silence 15:04:39.901 strm01AFD694 Start talksprut.. 15:04:39.948 strm01AFD694 Starting silence 15:04:40.089 strm01B0CE0C Start talksprut.. 15:04:40.089 strm01B0CE0C Starting silence 15:04:40.432 strm01AFD694 Start talksprut.. 15:04:40.432 strm01AFD694 Starting silence 15:04:40.511 wav_playlist.c WAV playlist 'WAV playlist' created: samp.rate=8000, ch=1, bufsize=4KB 15:04:40.511 resample.c resample created: high qualiy, large filter, in/out rate=8000/16000 15:04:40.511 resample.c resample created: high qualiy, large filter, in/out rate=16000/8000 15:04:40.511 conference.c Port 4 (WAV playlist) transmitting to port 3 ( sip:anonymous at 10.209.2.150:5065) 15:04:40.542 strm01B0CE0C Start talksprut.. 15:04:40.589 conference.c Port 4 (WAV playlist) stop transmitting to port 3 (sip:anonymous at 10.209.2.150:5065) 15:04:40.620 wav_playlist.c WAV playlist 'WAV playlist' created: samp.rate=8000, ch=1, bufsize=4KB 15:04:40.620 resample.c resample created: high qualiy, large filter, in/out rate=8000/16000 15:04:40.620 resample.c resample created: high qualiy, large filter, in/out rate=16000/8000 15:04:40.620 conference.c Port 4 (WAV playlist) transmitting to port 3 ( sip:anonymous at 10.209.2.150:5065) 15:04:40.964 strm01AFD694 Start talksprut.. 15:04:40.964 strm01AFD694 Starting silence 15:04:41.479 strm01AFD694 Start talksprut.. 15:04:41.479 strm01AFD694 Starting silence 15:04:41.870 wav_playlist.c File port WAV playlist EOF, stopping.. 15:04:41.979 strm01AFD694 Start talksprut.. 15:04:42.010 strm01AFD694 Starting silence 15:04:42.495 strm01AFD694 Start talksprut.. 15:04:42.495 strm01B0CE0C Starting silence 15:04:42.495 strm01AFD694 Starting silence 15:04:42.995 strm01AFD694 Start talksprut.. 15:04:42.995 strm01B0CE0C Start talksprut.. 15:04:42.995 strm01AFD694 Starting silence 15:04:42.995 strm01B0CE0C Starting silence 15:04:43.510 strm01AFD694 Start talksprut.. 15:04:43.510 strm01B0CE0C Start talksprut.. 15:04:43.510 strm01AFD694 Starting silence 15:04:43.510 strm01B0CE0C Starting silence 15:04:43.557 sip_endpoint.c Processing incoming message: Request msg BYE/cseq=4 (rdata00F72EAC) 15:04:43.557 pjsua_core.c RX 406 bytes Request msg BYE/cseq=4 (rdata00F72EAC) from UDP 10.209.2.150:5065: BYE sip:8004 at 10.209.2.150:5060;transport=UDP SIP/2.0 Via: SIP/2.0/UDP 10.209.2.150:5065 ;branch=z9hG4bK80bb94e36e63dc118c0300096b849c3e From: "Anonymous" <sip:anonymous@10.209.2.150>;tag=2840 To: <sip:8003 at 10.209.2.150>;tag=1e1eece89cd54cb5a8518fc631ec2bd4 Call-ID: 009041D8-6E63-DC11-8C00-00096B849C3E at 10.209.2.150 CSeq: 4 BYE Max-Forwards: 70 User-Agent: SIPPER for 3CX Phone Content-Length: 0 --end msg-- 15:04:43.557 dlg01AFBE64 Received Request msg BYE/cseq=4 (rdata00F72EAC) 15:04:43.557 tsx01AE619C Transaction created for Request msg BYE/cseq=4 (rdata00F72EAC) 15:04:43.557 tsx01AE619C Incoming Request msg BYE/cseq=4 (rdata00F72EAC) in state Null 15:04:43.557 tsx01AE619C State changed from Null to Trying, event=RX_MSG 15:04:43.557 dlg01AFBE64 Transaction tsx01AE619C state changed to Trying 15:04:43.557 endpoint Response msg 200/BYE/cseq=4 (tdta01B1BF04) created 15:04:43.557 dlg01AFBE64 Sending Response msg 200/BYE/cseq=4 (tdta01B1BF04) 15:04:43.557 tsx01AE619C Sending Response msg 200/BYE/cseq=4 (tdta01B1BF04) in state Trying 15:04:43.557 sip_resolve.c Target '10.209.2.150:5065' type=UDP resolved to '10.209.2.150:5065' type=UDP 15:04:43.557 pjsua_core.c TX 339 bytes Response msg 200/BYE/cseq=4 (tdta01B1BF04) to UDP 10.209.2.150:5065: SIP/2.0 200 OK Via: SIP/2.0/UDP 10.209.2.150:5065;received=10.209.2.150 ;branch=z9hG4bK80bb94e36e63dc118c0300096b849c3e Call-ID: 009041D8-6E63-DC11-8C00-00096B849C3E at 10.209.2.150 From: "Anonymous" <sip:anonymous@10.209.2.150>;tag=2840 To: <sip:8003 at 10.209.2.150>;tag=1e1eece89cd54cb5a8518fc631ec2bd4 CSeq: 4 BYE Content-Length: 0 --end msg-- 15:04:43.557 tsx01AE619C State changed from Trying to Completed, event=TX_MSG 15:04:43.557 dlg01AFBE64 Transaction tsx01AE619C state changed to Completed 15:04:44.042 strm01AFD694 Start talksprut.. 15:04:44.042 strm01B0CE0C Start talksprut.. 15:04:44.042 strm01AFD694 Starting silence 15:04:44.042 strm01B0CE0C Starting silence 15:04:44.526 strm01AFD694 Start talksprut.. 15:04:44.526 strm01B0CE0C Start talksprut.. 15:04:44.557 strm01AFD694 Starting silence 15:04:44.557 strm01B0CE0C Starting silence 15:04:44.776 conference.c Port 2 (WAV playlist) stop transmitting to port 1 (sip:127.0.0.1:49152) 15:04:44.792 wav_playlist.c WAV playlist 'WAV playlist' created: samp.rate=8000, ch=1, bufsize=4KB 15:04:44.792 resample.c resample created: high qualiy, large filter, in/out rate=8000/16000 15:04:44.792 resample.c resample created: high qualiy, large filter, in/out rate=16000/8000 15:04:44.792 conference.c Port 2 (WAV playlist) transmitting to port 1 (sip:127.0.0.1:49152) 15:04:44.807 strm01AFD694 Start talksprut.. 15:04:45.057 strm01B0CE0C Start talksprut.. 15:04:45.057 strm01B0CE0C Starting silence 15:04:45.135 sip_endpoint.c Processing incoming message: Request msg BYE/cseq=2 (rdata00F72EAC) 15:04:45.135 pjsua_core.c RX 486 bytes Request msg BYE/cseq=2 (rdata00F72EAC) from UDP 10.209.2.150:49152: BYE sip:8003 at 10.209.2.150:5060;transport=UDP SIP/2.0 Via: SIP/2.0/UDP 127.0.0.1:49152 ;branch=z9hG4bK0ad102960000002b46ee4a350000736f00000015;rport From: "unknown" <sip:127.0.0.1:49152>;tag=6521999410e To: <sip:8003 at 10.209.2.150>;tag=91eecf34e44742c3b5d5498c58f2f4e9 Contact: <sip:127.0.0.1:49152> Call-ID: FF5AF7F7E8204C3D93BDFFD1751C29E10x0ad10296 CSeq: 2 BYE Max-Forwards: 70 User-Agent: SJphone/1.65.377a (SJ Labs) Content-Length: 0 Supported: replaces,norefersub,timer --end msg-- 15:04:45.135 dlg01AF5224 Received Request msg BYE/cseq=2 (rdata00F72EAC) 15:04:45.135 tsx021200AC Transaction created for Request msg BYE/cseq=2 (rdata00F72EAC) 15:04:45.135 tsx021200AC Incoming Request msg BYE/cseq=2 (rdata00F72EAC) in state Null 15:04:45.135 tsx021200AC State changed from Null to Trying, event=RX_MSG 15:04:45.135 dlg01AF5224 Transaction tsx021200AC state changed to Trying 15:04:45.135 endpoint Response msg 200/BYE/cseq=2 (tdta021208B4) created 15:04:45.135 dlg01AF5224 Sending Response msg 200/BYE/cseq=2 (tdta021208B4) 15:04:45.135 tsx021200AC Sending Response msg 200/BYE/cseq=2 (tdta021208B4) in state Trying 15:04:45.135 pjsua_core.c TX 342 bytes Response msg 200/BYE/cseq=2 (tdta021208B4) to UDP 10.209.2.150:49152: SIP/2.0 200 OK Via: SIP/2.0/UDP 127.0.0.1:49152;rport=49152;received=10.209.2.150 ;branch=z9hG4bK0ad102960000002b46ee4a350000736f00000015 Call-ID: FF5AF7F7E8204C3D93BDFFD1751C29E10x0ad10296 From: "unknown" <sip:127.0.0.1>;tag=6521999410e To: <sip:8003 at 10.209.2.150>;tag=91eecf34e44742c3b5d5498c58f2f4e9 CSeq: 2 BYE Content-Length: 0 --end msg-- 15:04:45.135 tsx021200AC State changed from Trying to Completed, event=TX_MSG 15:04:45.135 dlg01AF5224 Transaction tsx021200AC state changed to Completed 15:04:45.307 pjsua_call.c Media session for call 0 is destroyed 15:04:45.307 dlg01AF5224 Session count dec to 3 by mod-invite 15:04:45.323 pjsua_call.c Invalid call_id 0 in pjsua_call_hangup() 15:04:45.542 strm01B0CE0C Start talksprut.. 15:04:45.573 strm01B0CE0C Starting silence 15:04:46.073 strm01B0CE0C Start talksprut.. 15:04:46.073 strm01B0CE0C Starting silence 15:04:46.557 strm01B0CE0C Start talksprut.. 15:04:46.588 strm01B0CE0C Starting silence 15:04:46.854 tsx01AF3A74 Timeout timer event 15:04:46.854 tsx01AF3A74 State changed from Completed to Terminated, event=TIMER 15:04:46.854 dlg01AF4A1C Transaction tsx01AF3A74 state changed to Terminated 15:04:46.854 dlg01AF4A1C Dialog destroyed 15:04:46.854 tsx01AF3A74 Timeout timer event 15:04:46.854 tsx01AF3A74 State changed from Terminated to Destroyed, event=TIMER 15:04:46.854 tdta01ADD09C Destroying txdata Response msg 200/CANCEL/cseq=1 (tdta01ADD09C) 15:04:46.854 tsx01AF3A74 Transaction destroyed! 15:04:47.088 strm01B0CE0C Start talksprut.. 15:04:47.088 strm01B0CE0C Starting silence 15:04:47.573 strm01B0CE0C Start talksprut.. 15:04:47.604 strm01B0CE0C Starting silence 15:04:48.104 strm01B0CE0C Start talksprut.. 15:04:48.135 strm01B0CE0C Starting silence 15:04:48.588 strm01B0CE0C Start talksprut.. 15:04:48.620 strm01B0CE0C Starting silence 15:04:49.119 strm01B0CE0C Start talksprut.. 15:04:49.119 strm01B0CE0C Starting silence 15:04:49.635 strm01B0CE0C Start talksprut.. 15:04:49.635 strm01B0CE0C Starting silence 15:04:49.807 tsx01AD9AA4 Timeout timer event 15:04:49.807 tsx01AD9AA4 State changed from Completed to Terminated, event=TIMER 15:04:49.807 dlg01ADAA54 Transaction tsx01AD9AA4 state changed to Terminated 15:04:49.807 dlg01ADAA54 Dialog destroyed 15:04:49.807 tsx01AD9AA4 Timeout timer event 15:04:49.807 tsx01AD9AA4 State changed from Terminated to Destroyed, event=TIMER 15:04:49.807 tdta01AF8484 Destroying txdata Response msg 200/BYE/cseq=2 (tdta01AF8484) 15:04:49.807 tsx01AD9AA4 Transaction destroyed! 15:04:50.135 strm01B0CE0C Start talksprut.. 15:04:50.166 strm01B0CE0C Starting silence 15:04:50.651 strm01B0CE0C Start talksprut.. 15:04:50.682 strm01B0CE0C Starting silence 15:04:51.182 strm01B0CE0C Start talksprut.. 15:04:51.182 strm01B0CE0C Starting silence -- Jagdish Jangid -------------- next part -------------- An HTML attachment was scrubbed... URL: http://lists.pjsip.org/pipermail/pjsip_lists.pjsip.org/attachments/20070917/4699b98c/attachment-0001.html