Closed GoogleCodeExporter closed 9 years ago
--------- beginning of /dev/log/main
W/XPrivacy(15866): Get client 10137/SERIAL(null;null) identification=restricted
4819 ms
D/ActivityThread(15866): handleBindApplication:com.csipsimple
D/ActivityThread(15866): setTargetHeapUtilization:0.75
D/ActivityThread(15866): setTargetHeapMinFree:2097152
I/dalvikvm(15866): DexOpt: illegal method access (call
Landroid/content/res/TypedArray;.<init> (Landroid/content/res/Resources;[I[II)V
from Landroid/content/res/XResources$XTypedArray;)
I/dalvikvm(15866): Could not find method android.content.res.TypedArray.<init>,
referenced from method android.content.res.XResources$XTypedArray.<init>
W/dalvikvm(15866): VFY: unable to resolve direct method 82:
Landroid/content/res/TypedArray;.<init> (Landroid/content/res/Resources;[I[II)V
D/dalvikvm(15866): VFY: replacing opcode 0x70 at 0x0002
D/ActivityThread(15884): handleBindApplication:com.csipsimple:sipStack
D/ActivityThread(15884): setTargetHeapUtilization:0.75
D/ActivityThread(15884): setTargetHeapMinFree:2097152
E/SIP SRV (15884): RESET SETTINGS !!!!
D/libEGL (15866): loaded /system/lib/egl/libEGL_mali.so
D/libEGL (15866): loaded /system/lib/egl/libGLESv1_CM_mali.so
D/libEGL (15866): loaded /system/lib/egl/libGLESv2_mali.so
E/ (15866): Device driver API match
E/ (15866): Device driver API version: 23
E/ (15866): User space API version: 23
E/ (15866): mali: REVISION=Linux-r3p2-01rel3 BUILD_DATE=Fri Mar 21
13:52:50 KST 2014
D/OpenGLRenderer(15866): Enabling debug mode 0
I/Choreographer(15866): Skipped 42 frames! The application may be doing too
much work on its main thread.
I/Timeline(15866): Timeline: Activity_idle id: android.os.BinderProxy@4212c320
time:22983312
I/Timeline(15866): Timeline: Activity_idle id: android.os.BinderProxy@4212c320
time:22983313
W/XPrivacy/XRuntime(15866): Get client 10137/exec(getprop init.svc.racoon;null)
shell=!restricted 2829 ms
W/XPrivacy/XRuntime(15866): exec 2831 ms
W/XPrivacy/XNetworkInfo(15884): Get client
10137/NetworkInfo.isConnected(null;null) internet=!restricted 3044 ms
W/XPrivacy/XNetworkInfo(15884): isConnected 3047 ms
I/dalvikvm(15884): DexOpt: illegal method access (call
Landroid/content/res/TypedArray;.<init> (Landroid/content/res/Resources;[I[II)V
from Landroid/content/res/XResources$XTypedArray;)
I/dalvikvm(15884): Could not find method android.content.res.TypedArray.<init>,
referenced from method android.content.res.XResources$XTypedArray.<init>
W/dalvikvm(15884): VFY: unable to resolve direct method 82:
Landroid/content/res/TypedArray;.<init> (Landroid/content/res/Resources;[I[II)V
D/dalvikvm(15884): VFY: replacing opcode 0x70 at 0x0002
I/Timeline(15866): Timeline: Activity_launch_request id:com.csipsimple
time:22995041
I/Timeline(15866): Timeline: Activity_idle id: android.os.BinderProxy@41e57b60
time:22995784
I/Timeline(15866): Timeline: Activity_idle id: android.os.BinderProxy@41f0bca8
time:22995788
I/Timeline(15866): Timeline: Activity_launch_request id:com.csipsimple
time:23000378
I/Timeline(15866): Timeline: Activity_idle id: android.os.BinderProxy@41e6f5f0
time:23001102
I/Timeline(15866): Timeline: Activity_launch_request id:com.csipsimple
time:23004496
I/Timeline(15866): Timeline: Activity_idle id: android.os.BinderProxy@41f913b8
time:23005256
I/Timeline(15866): Timeline: Activity_idle id: android.os.BinderProxy@41e57b60
time:23005257
W/IInputConnectionWrapper(15866): beginBatchEdit on inactive InputConnection
W/IInputConnectionWrapper(15866): endBatchEdit on inactive InputConnection
W/IInputConnectionWrapper(15866): beginBatchEdit on inactive InputConnection
W/IInputConnectionWrapper(15866): endBatchEdit on inactive InputConnection
W/IInputConnectionWrapper(15866): beginBatchEdit on inactive InputConnection
W/IInputConnectionWrapper(15866): endBatchEdit on inactive InputConnection
W/IInputConnectionWrapper(15866): beginBatchEdit on inactive InputConnection
W/IInputConnectionWrapper(15866): endBatchEdit on inactive InputConnection
W/IInputConnectionWrapper(15866): beginBatchEdit on inactive InputConnection
W/IInputConnectionWrapper(15866): endBatchEdit on inactive InputConnection
W/IInputConnectionWrapper(15866): getExtractedText on inactive InputConnection
W/IInputConnectionWrapper(15866): getTextBeforeCursor on inactive
InputConnection
W/IInputConnectionWrapper(15866): getTextAfterCursor on inactive InputConnection
W/IInputConnectionWrapper(15866): getSelectedText on inactive InputConnection
W/IInputConnectionWrapper(15866): getExtractedText on inactive InputConnection
W/IInputConnectionWrapper(15866): beginBatchEdit on inactive InputConnection
W/IInputConnectionWrapper(15866): endBatchEdit on inactive InputConnection
W/IInputConnectionWrapper(15866): getExtractedText on inactive InputConnection
W/IInputConnectionWrapper(15866): getTextBeforeCursor on inactive
InputConnection
W/IInputConnectionWrapper(15866): getTextAfterCursor on inactive InputConnection
W/IInputConnectionWrapper(15866): getSelectedText on inactive InputConnection
W/IInputConnectionWrapper(15866): beginBatchEdit on inactive InputConnection
W/IInputConnectionWrapper(15866): endBatchEdit on inactive InputConnection
W/IInputConnectionWrapper(15866): beginBatchEdit on inactive InputConnection
W/IInputConnectionWrapper(15866): endBatchEdit on inactive InputConnection
W/IInputConnectionWrapper(15866): beginBatchEdit on inactive InputConnection
W/IInputConnectionWrapper(15866): endBatchEdit on inactive InputConnection
W/IInputConnectionWrapper(15866): beginBatchEdit on inactive InputConnection
W/IInputConnectionWrapper(15866): endBatchEdit on inactive InputConnection
W/IInputConnectionWrapper(15866): beginBatchEdit on inactive InputConnection
W/IInputConnectionWrapper(15866): endBatchEdit on inactive InputConnection
W/IInputConnectionWrapper(15866): beginBatchEdit on inactive InputConnection
W/IInputConnectionWrapper(15866): endBatchEdit on inactive InputConnection
W/IInputConnectionWrapper(15866): beginBatchEdit on inactive InputConnection
W/IInputConnectionWrapper(15866): endBatchEdit on inactive InputConnection
W/IInputConnectionWrapper(15866): beginBatchEdit on inactive InputConnection
W/IInputConnectionWrapper(15866): endBatchEdit on inactive InputConnection
W/IInputConnectionWrapper(15866): beginBatchEdit on inactive InputConnection
W/IInputConnectionWrapper(15866): endBatchEdit on inactive InputConnection
I/Timeline(15866): Timeline: Activity_idle id: android.os.BinderProxy@41e57b60
time:23035617
E/ (15866): Device driver API match
E/ (15866): Device driver API version: 23
E/ (15866): User space API version: 23
E/ (15866): mali: REVISION=Linux-r3p2-01rel3 BUILD_DATE=Fri Mar 21
13:52:50 KST 2014
I/Timeline(15866): Timeline: Activity_idle id: android.os.BinderProxy@41e57b60
time:23083249
D/ (15866): Checked 1 et 1
I/Timeline(15866): Timeline: Activity_launch_request id:com.csipsimple
time:23097410
I/Timeline(15866): Timeline: Activity_idle id: android.os.BinderProxy@41e249d8
time:23098142
W/IInputConnectionWrapper(15866): beginBatchEdit on inactive InputConnection
W/IInputConnectionWrapper(15866): endBatchEdit on inactive InputConnection
W/IInputConnectionWrapper(15866): getExtractedText on inactive InputConnection
W/IInputConnectionWrapper(15866): getTextBeforeCursor on inactive
InputConnection
W/IInputConnectionWrapper(15866): getTextAfterCursor on inactive InputConnection
W/IInputConnectionWrapper(15866): getSelectedText on inactive InputConnection
W/IInputConnectionWrapper(15866): getExtractedText on inactive InputConnection
W/IInputConnectionWrapper(15866): beginBatchEdit on inactive InputConnection
W/IInputConnectionWrapper(15866): endBatchEdit on inactive InputConnection
W/IInputConnectionWrapper(15866): beginBatchEdit on inactive InputConnection
W/IInputConnectionWrapper(15866): endBatchEdit on inactive InputConnection
W/IInputConnectionWrapper(15866): beginBatchEdit on inactive InputConnection
W/IInputConnectionWrapper(15866): endBatchEdit on inactive InputConnection
W/IInputConnectionWrapper(15866): beginBatchEdit on inactive InputConnection
W/IInputConnectionWrapper(15866): endBatchEdit on inactive InputConnection
W/IInputConnectionWrapper(15866): beginBatchEdit on inactive InputConnection
W/IInputConnectionWrapper(15866): endBatchEdit on inactive InputConnection
I/Timeline(15866): Timeline: Activity_idle id: android.os.BinderProxy@41e57b60
time:23116953
I/Timeline(15866): Timeline: Activity_idle id: android.os.BinderProxy@41e57b60
time:23156360
W/InputEventReceiver(15866): Attempted to finish an input event but the input
event receiver has already been disposed.
I/Timeline(15866): Timeline: Activity_idle id: android.os.BinderProxy@41f0bca8
time:23164936
I/Timeline(15866): Timeline: Activity_launch_request id:com.csipsimple
time:23166738
I/Timeline(15866): Timeline: Activity_idle id: android.os.BinderProxy@42282fa0
time:23167194
D/ (15866): Checked 1 et 1
I/Timeline(15866): Timeline: Activity_launch_request id:com.csipsimple
time:23168642
I/Timeline(15866): Timeline: Activity_idle id: android.os.BinderProxy@4211fe78
time:23169305
I/Timeline(15866): Timeline: Activity_idle id: android.os.BinderProxy@4211fe78
time:23220001
I/Timeline(15866): Timeline: Activity_idle id: android.os.BinderProxy@42282fa0
time:23232225
W/InputEventReceiver(15866): Attempted to finish an input event but the input
event receiver has already been disposed.
I/Timeline(15866): Timeline: Activity_idle id: android.os.BinderProxy@41f0bca8
time:23235669
E/ (15866): Device driver API match
E/ (15866): Device driver API version: 23
E/ (15866): User space API version: 23
E/ (15866): mali: REVISION=Linux-r3p2-01rel3 BUILD_DATE=Fri Mar 21
13:52:50 KST 2014
I/Timeline(15866): Timeline: Activity_idle id: android.os.BinderProxy@41f0bca8
time:23310023
W/InputEventReceiver(15866): Attempted to finish an input event but the input
event receiver has already been disposed.
I/Timeline(15866): Timeline: Activity_launch_request id:com.csipsimple
time:23314647
I/Timeline(15866): Timeline: Activity_idle id: android.os.BinderProxy@4242c1b8
time:23315170
W/InputEventReceiver(15866): Attempted to finish an input event but the input
event receiver has already been disposed.
I/Timeline(15866): Timeline: Activity_idle id: android.os.BinderProxy@41f0bca8
time:23319176
I/Choreographer(15866): Skipped 34 frames! The application may be doing too
much work on its main thread.
I/Timeline(15866): Timeline: Activity_idle id: android.os.BinderProxy@4247c240
time:23323160
I/Timeline(15866): Timeline: Activity_idle id: android.os.BinderProxy@421a7088
time:23325701
I/Timeline(15866): Timeline: Activity_idle id: android.os.BinderProxy@4247c240
time:23329841
D/dalvikvm(15884): Trying to load lib
/data/app-lib/com.csipsimple-1/libstlport_shared.so 0x41f0f1f0
D/dalvikvm(15884): Added shared lib
/data/app-lib/com.csipsimple-1/libstlport_shared.so 0x41f0f1f0
D/dalvikvm(15884): No JNI_OnLoad found in
/data/app-lib/com.csipsimple-1/libstlport_shared.so 0x41f0f1f0, skipping init
D/dalvikvm(15884): Trying to load lib
/data/app-lib/com.csipsimple-1/libpjsipjni.so 0x41f0f1f0
D/dalvikvm(15884): Added shared lib
/data/app-lib/com.csipsimple-1/libpjsipjni.so 0x41f0f1f0
I/Timeline(15866): Timeline: Activity_idle id: android.os.BinderProxy@41f0bca8
time:23331434
I/Timeline(15866): Timeline: Activity_launch_request id:com.csipsimple
time:23332494
I/Timeline(15866): Timeline: Activity_idle id: android.os.BinderProxy@41f3c348
time:23332921
D/ (15866): Accounts status.onChange( false)
E/libpjsip(15884): 14:55:29.371 pjsua_acc.c ..Unable to create/send
REGISTER: Object is busy (PJSIP_EBUSY) [status=171001]
D/ (15866): Accounts status.onChange( false)
D/ (15866): Accounts status.onChange( false)
D/ (15866): Accounts status.onChange( false)
E/libpjsip(15884): 14:55:36.546 pjsua_acc.c !..Unable to create/send
REGISTER: Object is busy (PJSIP_EBUSY) [status=171001]
D/ (15866): Accounts status.onChange( false)
D/ (15866): Accounts status.onChange( false)
D/ (15866): Accounts status.onChange( false)
I/Timeline(15866): Timeline: Activity_idle id: android.os.BinderProxy@41f0bca8
time:23357019
W/AudioTrack(15884): AUDIO_OUTPUT_FLAG_FAST denied by client due to mismatching
sample rate (16000 vs 44100)
W/AudioRecord(15884): AUDIO_INPUT_FLAG_FAST denied by client
W/dalvikvm(15884): method
Lcom/actionbarsherlock/internal/widget/IcsLinearLayout;.drawDividersHorizontal
incorrectly overrides package-private method with same name in
Landroid/widget/LinearLayout;
W/dalvikvm(15884): method
Lcom/actionbarsherlock/internal/widget/IcsLinearLayout;.drawDividersVertical
incorrectly overrides package-private method with same name in
Landroid/widget/LinearLayout;
W/dalvikvm(15884): method
Lcom/actionbarsherlock/internal/widget/IcsLinearLayout;.drawHorizontalDivider
incorrectly overrides package-private method with same name in
Landroid/widget/LinearLayout;
W/dalvikvm(15884): method
Lcom/actionbarsherlock/internal/widget/IcsLinearLayout;.drawVerticalDivider
incorrectly overrides package-private method with same name in
Landroid/widget/LinearLayout;
W/XPrivacy/XSensorManager(15884): Get client 10137/acceleration(null;null)
sensors=!restricted 1819 ms
W/XPrivacy/XSensorManager(15884): getDefaultSensor 1825 ms
D/libEGL (15884): loaded /system/lib/egl/libEGL_mali.so
D/libEGL (15884): loaded /system/lib/egl/libGLESv1_CM_mali.so
D/libEGL (15884): loaded /system/lib/egl/libGLESv2_mali.so
E/ (15884): Device driver API match
E/ (15884): Device driver API version: 23
E/ (15884): User space API version: 23
E/ (15884): mali: REVISION=Linux-r3p2-01rel3 BUILD_DATE=Fri Mar 21
13:52:50 KST 2014
D/OpenGLRenderer(15884): Enabling debug mode 0
I/Timeline(15884): Timeline: Activity_idle id: android.os.BinderProxy@41ea15d8
time:23371682
W/AudioTrack(15884): AUDIO_OUTPUT_FLAG_FAST denied by client due to mismatching
sample rate (16000 vs 44100)
W/AudioRecord(15884): AUDIO_INPUT_FLAG_FAST denied by client
D/dalvikvm(15866): null clazz in OP_INSTANCE_OF, single-stepping
I/Timeline(15866): Timeline: Activity_idle id: android.os.BinderProxy@41f0bca8
time:23404105
I/Timeline(15866): Timeline: Activity_idle id: android.os.BinderProxy@41f0bca8
time:23438157
I/Timeline(15866): Timeline: Activity_launch_request id:com.csipsimple
time:23440072
I/Timeline(15866): Timeline: Activity_idle id: android.os.BinderProxy@41f913b8
time:23440994
I/Timeline(15866): Timeline: Activity_idle id: android.os.BinderProxy@41f913b8
time:23472196
I/Timeline(15866): Timeline: Activity_idle id: android.os.BinderProxy@41f0bca8
time:23475953
W/IInputConnectionWrapper(15866): showStatusIcon on inactive InputConnection
I/Timeline(15866): Timeline: Activity_idle id: android.os.BinderProxy@42506e00
time:23533851
I/Timeline(15866): Timeline: Activity_launch_request id:com.csipsimple
time:23534225
I/Timeline(15866): Timeline: Activity_idle id: android.os.BinderProxy@42131c78
time:23534813
D/ (15866): Accounts status.onChange( false)
I/dalvikvm(15866): Jit: resizing JitTable from 4096 to 8192
D/ (15866): Accounts status.onChange( false)
I/Timeline(15866): Timeline: Activity_idle id: android.os.BinderProxy@42506e00
time:23546540
W/AudioTrack(15884): AUDIO_OUTPUT_FLAG_FAST denied by client due to mismatching
sample rate (16000 vs 44100)
W/AudioRecord(15884): AUDIO_INPUT_FLAG_FAST denied by client
I/Timeline(15884): Timeline: Activity_idle id: android.os.BinderProxy@41e0fe98
time:23551995
I/Timeline(15866): Timeline: Activity_idle id: android.os.BinderProxy@42506e00
time:23586931
I/Timeline(15866): Timeline: Activity_idle id: android.os.BinderProxy@42506e00
time:23623983
I/Timeline(15866): Timeline: Activity_idle id: android.os.BinderProxy@41f18870
time:23627346
I/Timeline(15866): Timeline: Activity_launch_request id:com.csipsimple
time:23628841
W/Resources(15866): Converting to string: TypedValue{t=0x10/d=0x0 a=-1}
W/Resources(15866): Converting to string: TypedValue{t=0x10/d=0x0 a=-1}
W/Resources(15866): Converting to string: TypedValue{t=0x10/d=0x0 a=-1}
W/Resources(15866): Converting to string: TypedValue{t=0x10/d=0x0 a=-1}
W/Resources(15866): Converting to string: TypedValue{t=0x10/d=0xfa0 a=-1}
W/Resources(15866): Converting to string: TypedValue{t=0x10/d=0xfa0 a=-1}
W/Resources(15866): Converting to string: TypedValue{t=0x10/d=0x0 a=-1}
W/Resources(15866): Converting to string: TypedValue{t=0x10/d=0x1a a=-1}
W/Resources(15866): Converting to string: TypedValue{t=0x10/d=0x1a a=-1}
W/Resources(15866): Converting to string: TypedValue{t=0x10/d=0x0 a=-1}
I/Timeline(15866): Timeline: Activity_idle id: android.os.BinderProxy@4236fb50
time:23629660
I/Timeline(15866): Timeline: Activity_idle id: android.os.BinderProxy@41f18870
time:23636748
I/Timeline(15866): Timeline: Activity_idle id: android.os.BinderProxy@42506e00
time:23638137
I/Timeline(15866): Timeline: Activity_launch_request id:com.csipsimple
time:23639189
I/Timeline(15866): Timeline: Activity_idle id: android.os.BinderProxy@41eaf938
time:23639630
D/ (15866): Accounts status.onChange( false)
D/ (15866): Accounts status.onChange( false)
D/ (15866): Accounts status.onChange( false)
D/ (15866): Accounts status.onChange( false)
I/Timeline(15866): Timeline: Activity_idle id: android.os.BinderProxy@42506e00
time:23650546
W/AudioTrack(15884): AUDIO_OUTPUT_FLAG_FAST denied by client due to mismatching
sample rate (16000 vs 44100)
W/AudioRecord(15884): AUDIO_INPUT_FLAG_FAST denied by client
I/Timeline(15884): Timeline: Activity_idle id: android.os.BinderProxy@41e28e50
time:23657095
W/AudioTrack(15884): AUDIO_OUTPUT_FLAG_FAST denied by client due to mismatching
sample rate (16000 vs 44100)
W/AudioRecord(15884): AUDIO_INPUT_FLAG_FAST denied by client
E/ (15866): Device driver API match
E/ (15866): Device driver API version: 23
E/ (15866): User space API version: 23
E/ (15866): mali: REVISION=Linux-r3p2-01rel3 BUILD_DATE=Fri Mar 21
13:52:50 KST 2014
I/Timeline(15866): Timeline: Activity_idle id: android.os.BinderProxy@42506e00
time:23697250
D/AccountChooserButton(15866): Accounts status.onChange( false)
D/PjService(15884): Starting sip stack
I/PjService(15884): Created 0
D/PjService(15884): create ua receiver
D/SIP UA Receiver(15884): Create async worker !!!
D/BT8 (15884): Register BT media receiver
D/BT8 (15884): >>> BT SCO state changed !!!
D/BT8 (15884): BT SCO state changed : 0 target is false
D/PjService(15884): Attach is done to callback
D/PjService(15884): Use OpenSL-ES implementation
D/libpjsip(15884): 15:01:35.054 sip_endpoint.c !.Module "mod-pjsua-log"
registered
D/libpjsip(15884): 15:01:35.054 sip_endpoint.c .Module "mod-tsx-layer"
registered
D/libpjsip(15884): 15:01:35.054 sip_endpoint.c .Module "mod-stateful-util"
registered
D/libpjsip(15884): 15:01:35.054 sip_endpoint.c .Module "mod-ua" registered
D/libpjsip(15884): 15:01:35.055 sip_endpoint.c .Module "mod-100rel" registered
D/libpjsip(15884): 15:01:35.055 sip_endpoint.c .Module "mod-pjsua" registered
D/libpjsip(15884): 15:01:35.055 sip_endpoint.c .Module "mod-invite" registered
D/libpjsip(15884): 15:01:35.062 pjlib ..select() I/O Queue created
(0x5f4ff9cc)
D/libpjsip(15884): 15:01:35.063 webrtc_codec.c ..List of supported codec.
D/libpjsip(15884): 15:01:35.063 webrtc_codec.c ..0 ISAC 103 16000 480 32000
D/libpjsip(15884): 15:01:35.063 webrtc_codec.c ..5 ILBC 102 8000 240 13300
D/libpjsip(15884): 15:01:35.063 silk.c ..SILK codec version 1.0.9
initialized
D/libpjsip(15884): 15:01:35.064 sip_endpoint.c ..Module
"mod-opus-sdp-rewriter" registered
D/libpjsip(15884): 15:01:35.073 pjsua_vid.c ..Initializing video subsystem..
D/libpjsip(15884): 15:01:35.073 sip_endpoint.c .Module "mod-evsub" registered
D/libpjsip(15884): 15:01:35.073 sip_endpoint.c .Module "mod-presence"
registered
D/libpjsip(15884): 15:01:35.073 sip_endpoint.c .Module "mod-mwi" registered
D/libpjsip(15884): 15:01:35.073 sip_endpoint.c .Module "mod-refer" registered
D/libpjsip(15884): 15:01:35.073 sip_endpoint.c .Module "mod-pjsua-pres"
registered
D/libpjsip(15884): 15:01:35.073 sip_endpoint.c .Module "mod-pjsua-im"
registered
D/libpjsip(15884): 15:01:35.073 sip_endpoint.c .Module "mod-pjsua-options"
registered
D/libpjsip(15884): 15:01:35.073 pjsua_core.c .1 SIP worker threads created
I/libpjsip(15884): 15:01:35.073 pjsua_core.c .pjsua version 2.2.1-svn for
initialized
D/libpjsip(15884): 15:01:35.073 pjsua_core.c .PJSUA state changed: CREATED
--> INIT
D/libpjsip(15884): 15:01:35.073 opensl_dev.c OpenSL sound library initialized
D/libpjsip(15884): 15:01:35.073 pjsua_jni_addo Loaded audio dev
D/libpjsip(15884): 15:01:35.201 pjsua_core.c SIP UDP socket reachable at
88.30.149.166:44783
D/libpjsip(15884): 15:01:35.201 udp0x5eed2288 SIP UDP transport started,
published address is 88.30.149.166:44783
D/libpjsip(15884): 15:01:35.202 pjsua_acc.c Adding account:
id=<sip:88.30.149.166:44783>
D/libpjsip(15884): 15:01:35.202 pjsua_acc.c .Account
<sip:88.30.149.166:44783> added with id 0
D/libpjsip(15884): 15:01:35.332 tcplis:42082 SIP TCP listener ready for
incoming connections at 88.30.149.166:42082
D/libpjsip(15884): 15:01:35.332 pjsua_acc.c Adding account:
id=<sip:88.30.149.166:42082;transport=TCP>
D/libpjsip(15884): 15:01:35.332 pjsua_acc.c .Account
<sip:88.30.149.166:42082;transport=TCP> added with id 1
D/libpjsip(15884): 15:01:35.504 tlslis:34761 SIP TLS listener is ready for
incoming connections at 88.30.149.166:34761
D/libpjsip(15884): 15:01:35.504 pjsua_acc.c Adding account:
id=<sip:88.30.149.166:34761;transport=TLS>
D/libpjsip(15884): 15:01:35.504 pjsua_acc.c .Account
<sip:88.30.149.166:34761;transport=TLS> added with id 2
D/libpjsip(15884): 15:01:35.509 sip_endpoint.c Module "mod-earlylock"
registered
D/libpjsip(15884): 15:01:35.510 sip_endpoint.c Module "mod-reg-tracker"
registered
D/RegHandlerModule(15884): Reg handler module added with status 0
D/libpjsip(15884): 15:01:35.510 pjsua_core.c PJSUA state changed: INIT -->
STARTING
D/libpjsip(15884): 15:01:35.513 sip_endpoint.c .Module "mod-unsolicited-mwi"
registered
D/libpjsip(15884): 15:01:35.513 pjsua_core.c .PJSUA state changed: STARTING
--> RUNNING
D/PreferencesWrapper(15866): Invalid codec_speex_16000_fpp format : expect a int
D/PreferencesWrapper(15866): Invalid codec_speex_8000_fpp format : expect a int
D/PreferencesWrapper(15866): Invalid codec_speex_32000_fpp format : expect a int
D/PreferencesWrapper(15866): Invalid codec_gsm_8000_fpp format : expect a int
D/PreferencesWrapper(15866): Invalid codec_pcmu_8000_fpp format : expect a int
D/PreferencesWrapper(15866): Invalid codec_pcma_8000_fpp format : expect a int
D/PreferencesWrapper(15866): Invalid codec_g722_16000_fpp format : expect a int
D/PreferencesWrapper(15866): Invalid codec_amr_8000_fpp format : expect a int
D/PreferencesWrapper(15866): Invalid codec_amr-wb_16000_fpp format : expect a
int
D/PreferencesWrapper(15866): Invalid codec_isac_16000_fpp format : expect a int
D/PreferencesWrapper(15866): Invalid codec_ilbc_8000_fpp format : expect a int
D/PreferencesWrapper(15866): Invalid codec_codec2_8000_fpp format : expect a int
D/PreferencesWrapper(15866): Invalid codec_silk_8000_fpp format : expect a int
D/PreferencesWrapper(15866): Invalid codec_silk_12000_fpp format : expect a int
D/PreferencesWrapper(15866): Invalid codec_silk_16000_fpp format : expect a int
D/PreferencesWrapper(15866): Invalid codec_silk_24000_fpp format : expect a int
D/PreferencesWrapper(15866): Invalid codec_opus_16000_fpp format : expect a int
D/PreferencesWrapper(15866): Invalid codec_g726-40_8000_fpp format : expect a
int
D/PreferencesWrapper(15866): Invalid codec_g726-32_8000_fpp format : expect a
int
D/PreferencesWrapper(15866): Invalid codec_g726-24_8000_fpp format : expect a
int
D/PreferencesWrapper(15866): Invalid codec_g726-16_8000_fpp format : expect a
int
D/PreferencesWrapper(15866): Invalid codec_mpeg4-generic_48000_fpp format :
expect a int
D/PreferencesWrapper(15866): Invalid codec_g7221_16000_fpp format : expect a int
D/PreferencesWrapper(15866): Invalid codec_g7221_16000_fpp format : expect a int
D/PreferencesWrapper(15866): Invalid codec_g7221_32000_fpp format : expect a int
D/PreferencesWrapper(15866): Invalid codec_g7221_32000_fpp format : expect a int
D/PreferencesWrapper(15866): Invalid codec_g7221_32000_fpp format : expect a int
D/PjService(15884): Audio codecs : GSM/8000/1 (230) - PCMU/8000/1 (60) -
PCMA/8000/1 (50) - SILK/8000/1 (239) -
Original comment by a...@orencio.org
on 2 Feb 2015 at 2:41
D/PjService(15884): Video codecs :
D/DynamicReceiver(15884): Start monitoring of route file ? 0
D/SIP SRV (15884): Listen for phone state
D/SIP SRV (15884): Add all accounts
D/SIP SRV (15884): We are adding all accounts right now....
D/PjSipAccount(15884): Create proxy 1
D/PjSipAccount(15884): Add proxy sips:ostel.co:5061
D/libpjsip(15884): 15:01:35.901 pjsua_acc.c Adding account:
id=<sip:ostel_user@ostel.co>
D/libpjsip(15884): 15:01:35.901 pjsua_acc.c .Account
<sip:ostel_user@ostel.co> added with id 3
D/libpjsip(15884): 15:01:35.902 pjsua_acc.c Acc 3: setting registration..
D/libpjsip(15884): 15:01:36.009 tlsc0x5f35242c .TLS client transport created
D/libpjsip(15884): 15:01:36.010 tlsc0x5f35242c .TLS transport
88.30.149.166:37381 is connecting to 66.151.32.200:5061...
D/libpjsip(15884): 15:01:36.013 pjsua_acc.c .Contact for acc 3 updated for
SIP outbound:
<sip:ostel_user@88.30.149.166:37381;transport=TLS;ob>;reg-id=1;+sip.instance="<u
rn:uuid:69de3dfa-d575-44bf-9680-d748f6d0d4f6>"
D/libpjsip(15884): 15:01:36.225 pjsua_core.c ..TX 656 bytes Request msg
REGISTER/cseq=45644 (tdta0x5f3928a0) to TLS 66.151.32.200:5061:
D/libpjsip(15884): REGISTER sip:ostel.co SIP/2.0
D/libpjsip(15884): v: SIP/2.0/TLS
88.30.149.166:37381;rport;branch=z9hG4bKPjyKph-0NrBRDG8xL2XFs6RqVbqDAREPpu;alias
D/libpjsip(15884): Route: <sips:ostel.co:5061;transport=tls;lr>
D/libpjsip(15884): Max-Forwards: 70
D/libpjsip(15884): f:
<sip:ostel_user@ostel.co>;tag=dpjB0RnSlA8cHCciP-PTZRoB-pbGo-5q
D/libpjsip(15884): t: <sip:ostel_user@ostel.co>
D/libpjsip(15884): i: SANhpnJZeZbUom14YG.x32WFbTRriAGh
D/libpjsip(15884): CSeq: 45644 REGISTER
D/libpjsip(15884): User-Agent: CSipSimple_m0-19/r2457
D/libpjsip(15884): k: outbound, path
D/libpjsip(15884): m:
<sip:ostel_user@88.30.149.166:37381;transport=TLS;ob>;reg-id=1;+sip.instance="<u
rn:uuid:69de3dfa-d575-44bf-9680-d748f6d0d4f6>"
D/libpjsip(15884): Expires: 1800
D/libpjsip(15884): Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO,
SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS
D/libpjsip(15884): l: 0
D/libpjsip(15884):
D/libpjsip(15884): --end msg--
D/libpjsip(15884): 15:01:36.227 pjsua_acc.c .Acc 3: Registration sent
D/DBProvider(15884): Added status_text= status_code=-1 display_name=OSTN
expires=0 account_id=1 added_status=0 priority=100 active=true wizard=OSTN
reg_uri=sip:ostel.co pjsua_id=3
D/SIP SRV (15884): Accounts status.onChange( false)
D/SIP SRV (15884): Update registration state
D/libpjsip(15884): 15:01:36.233 pjsua_acc.c Acc 3: setting online status to
1..
D/AccountChooserButton(15866): Accounts status.onChange( false)
D/PjService(15884): Found pjsua 3 searching 3
D/PjService(15884): Update profile from service for 3 aka in db 1
D/DBProvider(15884): Updated status_text=In Progress status_code=100
display_name=OSTN expires=0 account_id=1 added_status=0 priority=100
active=true wizard=OSTN reg_uri=sip:ostel.co pjsua_id=3
D/SIP SRV (15884): Accounts status.onChange( false)
D/SIP SRV (15884): Update registration state
D/PjService(15884): Profile state UP : status_text=In Progress status_code=100
expires=0
D/DynamicReceiver(15884): Internal receive android.net.conn.CONNECTIVITY_CHANGE
D/AccountChooserButton(15866): Accounts status.onChange( false)
D/Prefs (15884): We are valid for MOBILE
D/Prefs (15884): We are valid for MOBILE
D/DynamicReceiver(15884): onConnectivityChanged(): null -> mobile
E/libpjsip(15884): 15:01:38.072 tlsc0x5f35242c !TLS connect() error: Unknown
error 495020 [code=495020]
W/libpjsip(15884): 15:01:38.072 tsx0x5f1bb9cc Failed to send Request msg
REGISTER/cseq=45644 (tdta0x5f3928a0)! err=495020 (Unknown error 495020)
W/libpjsip(15884): 15:01:38.072 pjsua_acc.c ..SIP registration failed,
status=503 (Unknown error 495020)
D/libpjsip(15884): 15:01:38.072 pjsua_acc.c ..Scheduling re-registration
retry for acc 3 in 2 seconds..
D/SIP UA Receiver(15884): < LOCK CPU
D/SIP UA Receiver(15884): > UNLOCK CPU 0
D/PjService(15884): Found pjsua 3 searching 3
D/PjService(15884): Update profile from service for 3 aka in db 1
D/DBProvider(15884): Updated status_text=Service Unavailable status_code=503
display_name=OSTN expires=-1 account_id=1 added_status=0 priority=100
active=true wizard=OSTN reg_uri=sip:ostel.co pjsua_id=3
D/SIP SRV (15884): Accounts status.onChange( false)
D/SIP SRV (15884): Update registration state
D/PjService(15884): Profile state UP : status_text=Service Unavailable
status_code=503 expires=-1
D/AccountChooserButton(15866): Accounts status.onChange( false)
D/libpjsip(15884): 15:01:38.142 pjsua_acc.c Disconnected notification for
transport tlsc0x5f35242c
D/libpjsip(15884): 15:01:38.147 pjsua_acc.c .Scheduling re-registration
retry for acc 3 in 1 seconds..
D/libpjsip(15884): 15:01:38.206 tlsc0x5f35242c !TLS transport destroyed with
reason 495020: Unknown error 495020
D/libpjsip(15884): 15:01:39.689 pjsua_acc.c Acc 3: setting registration..
D/libpjsip(15884): 15:01:39.885 tlsc0x5f35242c .TLS client transport created
D/libpjsip(15884): 15:01:39.886 tlsc0x5f35242c .TLS transport
88.30.149.166:46401 is connecting to 66.151.32.200:5061...
D/libpjsip(15884): 15:01:39.889 pjsua_acc.c .Contact for acc 3 updated for
SIP outbound:
<sip:ostel_user@88.30.149.166:46401;transport=TLS;ob>;reg-id=1;+sip.instance="<u
rn:uuid:69de3dfa-d575-44bf-9680-d748f6d0d4f6>"
D/PjService(15884): Found pjsua 3 searching 3
D/RegHandlerReceiver(15884): We restore
<sip:ostel_user@95.130.15.251:58781;transport=TLS;ob>
D/libpjsip(15884): 15:01:40.110 mobile_reg_han ..Hook a RX request
D/libpjsip(15884): 15:01:40.110 pjsua_core.c ..TX 724 bytes Request msg
REGISTER/cseq=62583 (tdta0x5f343398) to TLS 66.151.32.200:5061:
D/libpjsip(15884): REGISTER sip:ostel.co SIP/2.0
D/libpjsip(15884): v: SIP/2.0/TLS
88.30.149.166:46401;rport;branch=z9hG4bKPjoSkTNcpKAAB-PE3OcmOfLbLTd4.bb-Th;alias
D/libpjsip(15884): Route: <sips:ostel.co:5061;transport=tls;lr>
D/libpjsip(15884): Max-Forwards: 70
D/libpjsip(15884): f:
<sip:ostel_user@ostel.co>;tag=y1oVpb5jr9MaCDwqaWTQw3VDNLYRpHWy
D/libpjsip(15884): t: <sip:ostel_user@ostel.co>
D/libpjsip(15884): i: Aa-mRTcxySdpMdsZPzqbOR5DIGYaCZfm
D/libpjsip(15884): CSeq: 62583 REGISTER
D/libpjsip(15884): User-Agent: CSipSimple_m0-19/r2457
D/libpjsip(15884): k: outbound, path
D/libpjsip(15884): m:
<sip:ostel_user@88.30.149.166:46401;transport=TLS;ob>;reg-id=1;+sip.instance="<u
rn:uuid:69de3dfa-d575-44bf-9680-d748f6d0d4f6>"
D/libpjsip(15884): Expires: 1800
D/libpjsip(15884): Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO,
SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS
D/libpjsip(15884): m:
<sip:ostel_user@95.130.15.251:58781;transport=TLS;ob>;expires=0
D/libpjsip(15884): l: 0
D/libpjsip(15884):
D/libpjsip(15884): --end msg--
D/libpjsip(15884): 15:01:40.113 pjsua_acc.c .Acc 3: Registration sent
D/libpjsip(15884): 15:01:41.615 tlsc0x5f35242c !TLS transport
88.30.149.166:46401 is connected to 66.151.32.200:5061
D/libpjsip(15884): 15:01:42.412 pjsua_core.c .RX 497 bytes Response msg
401/REGISTER/cseq=62583 (rdata0x5f3525f8) from TLS 66.151.32.200:5061:
D/libpjsip(15884): SIP/2.0 401 Unauthorized
D/libpjsip(15884): v: SIP/2.0/TLS
88.30.149.166:46401;rport=33564;branch=z9hG4bKPjoSkTNcpKAAB-PE3OcmOfLbLTd4.bb-Th
;alias;received=95.130.15.251
D/libpjsip(15884): f:
<sip:ostel_user@ostel.co>;tag=y1oVpb5jr9MaCDwqaWTQw3VDNLYRpHWy
D/libpjsip(15884): t:
<sip:ostel_user@ostel.co>;tag=e01f0de2cdfebbeefc5ff0c8eabbb8b3.80bd
D/libpjsip(15884): i: Aa-mRTcxySdpMdsZPzqbOR5DIGYaCZfm
D/libpjsip(15884): CSeq: 62583 REGISTER
D/libpjsip(15884): WWW-Authenticate: Digest realm="ostel.co",
nonce="VM+EcVTPg0UAJIHKK8C32aKliX6GOYXr"
D/libpjsip(15884): Server: kamailio (4.1.3 (x86_64/linux))
D/libpjsip(15884): Content-Length: 0
D/libpjsip(15884):
D/libpjsip(15884): --end msg--
D/libpjsip(15884): 15:01:42.413 mobile_reg_han .mod_reg_tracker_on_rx_response
D/libpjsip(15884): 15:01:42.413 mobile_reg_han .mod_reg_tracker_on_rx_response
done
D/PjService(15884): Found pjsua 3 searching 3
D/RegHandlerReceiver(15884): We restore
<sip:ostel_user@95.130.15.251:58781;transport=TLS;ob>
D/libpjsip(15884): 15:01:42.434 mobile_reg_han ....The register already has
old contact in it, ignore
D/libpjsip(15884): 15:01:42.434 pjsua_core.c ....TX 894 bytes Request msg
REGISTER/cseq=62584 (tdta0x5f343398) to TLS 66.151.32.200:5061:
D/libpjsip(15884): REGISTER sip:ostel.co SIP/2.0
D/libpjsip(15884): v: SIP/2.0/TLS
88.30.149.166:46401;rport;branch=z9hG4bKPjDVzbA83LX6LEEAAZamoFDdUZ-CBRnJQ0;alias
D/libpjsip(15884): Route: <sips:ostel.co:5061;transport=tls;lr>
D/libpjsip(15884): Max-Forwards: 70
D/libpjsip(15884): f:
<sip:ostel_user@ostel.co>;tag=y1oVpb5jr9MaCDwqaWTQw3VDNLYRpHWy
D/libpjsip(15884): t: <sip:ostel_user@ostel.co>
D/libpjsip(15884): i: Aa-mRTcxySdpMdsZPzqbOR5DIGYaCZfm
D/libpjsip(15884): CSeq: 62584 REGISTER
D/libpjsip(15884): User-Agent: CSipSimple_m0-19/r2457
D/libpjsip(15884): k: outbound, path
D/libpjsip(15884): m:
<sip:ostel_user@88.30.149.166:46401;transport=TLS;ob>;reg-id=1;+sip.instance="<u
rn:uuid:69de3dfa-d575-44bf-9680-d748f6d0d4f6>"
D/libpjsip(15884): Expires: 1800
D/libpjsip(15884): Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO,
SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS
D/libpjsip(15884): m:
<sip:ostel_user@95.130.15.251:58781;transport=TLS;ob>;expires=0
D/libpjsip(15884): Authorization: Digest username="ostel_user",
realm="ostel.co", nonce="VM+EcVTPg0UAJIHKK8C32aKliX6GOYXr", uri="sip:ostel.co",
response="1fd67a1722943a896fe52ba59f1ebc74"
D/libpjsip(15884): l: 0
D/libpjsip(15884):
D/libpjsip(15884): --end msg--
D/libpjsip(15884): 15:01:43.243 pjsua_core.c .RX 741 bytes Response msg
200/REGISTER/cseq=62584 (rdata0x5f3525f8) from TLS 66.151.32.200:5061:
D/libpjsip(15884): SIP/2.0 200 OK
D/libpjsip(15884): v: SIP/2.0/TLS
88.30.149.166:46401;rport=33564;branch=z9hG4bKPjDVzbA83LX6LEEAAZamoFDdUZ-CBRnJQ0
;alias;received=95.130.15.251
D/libpjsip(15884): f:
<sip:ostel_user@ostel.co>;tag=y1oVpb5jr9MaCDwqaWTQw3VDNLYRpHWy
D/libpjsip(15884): t:
<sip:ostel_user@ostel.co>;tag=e01f0de2cdfebbeefc5ff0c8eabbb8b3.a8fc
D/libpjsip(15884): i: Aa-mRTcxySdpMdsZPzqbOR5DIGYaCZfm
D/libpjsip(15884): CSeq: 62584 REGISTER
D/libpjsip(15884): Contact:
<sip:ostel_user@88.30.149.166:47657;transport=TLS;ob>;expires=740;+sip.instance=
"<urn:uuid:5c56f713-77c8-463e-9d11-1ac42458e291>";reg-id=1,
<sip:ostel_user@88.30.149.166:46401;transport=TLS;ob>;expires=1800;received="sip
:95.130.15.251:33564;transport=TLS";+sip.instance="<urn:uuid:69de3dfa-d575-44bf-
9680-d748f6d0d4f6>";reg-id=1
D/libpjsip(15884): Server: kamailio (4.1.3 (x86_64/linux))
D/libpjsip(15884): Content-Length: 0
D/libpjsip(15884):
D/libpjsip(15884): --end msg--
D/libpjsip(15884): 15:01:43.243 mobile_reg_han .mod_reg_tracker_on_rx_response
D/libpjsip(15884): 15:01:43.243 mobile_reg_han .mod_reg_tracker_on_rx_response
2
D/libpjsip(15884): 15:01:43.243 mobile_reg_han .Hook a REGISTER RX response !!!
D/libpjsip(15884): 15:01:43.244 mobile_reg_han . Hook should save contact :
<sip:ostel_user@88.30.149.166:46401;transport=TLS;ob> > 1800
D/PjService(15884): Found pjsua 3 searching 3
D/libpjsip(15884): 15:01:43.266 mobile_reg_han .mod_reg_tracker_on_rx_response
done
D/libpjsip(15884): 15:01:43.295 pjsua_acc.c ....SIP outbound status for acc
3 is not active
I/libpjsip(15884): 15:01:43.300 pjsua_acc.c ....IP address change detected
for account 3 (88.30.149.166:46401 --> 95.130.15.251:33564). Updating
registration (using method 2)
D/libpjsip(15884): 15:01:43.301 pjsua_acc.c ....Acc 3: setting
registration..
D/PjService(15884): Found pjsua 3 searching 3
D/RegHandlerReceiver(15884): We restore
<sip:ostel_user@88.30.149.166:46401;transport=TLS;ob>
D/libpjsip(15884): 15:01:43.596 mobile_reg_han ......The register already has
old contact in it, ignore
D/libpjsip(15884): 15:01:43.596 pjsua_core.c ......TX 894 bytes Request msg
REGISTER/cseq=62585 (tdta0x5f1ebaf8) to TLS 66.151.32.200:5061:
D/libpjsip(15884): REGISTER sip:ostel.co SIP/2.0
D/libpjsip(15884): v: SIP/2.0/TLS
88.30.149.166:46401;rport;branch=z9hG4bKPj1hv.2jtQi.Du6p2cAlUUC9Xw9TSugDqL;alias
D/libpjsip(15884): Route: <sips:ostel.co:5061;transport=tls;lr>
D/libpjsip(15884): Max-Forwards: 70
D/libpjsip(15884): f:
<sip:ostel_user@ostel.co>;tag=XKJG.HWeyYdiR4IckVF6DWk2B4gb0cmM
D/libpjsip(15884): t: <sip:ostel_user@ostel.co>
D/libpjsip(15884): i: Aa-mRTcxySdpMdsZPzqbOR5DIGYaCZfm
D/libpjsip(15884): CSeq: 62585 REGISTER
D/libpjsip(15884): Authorization: Digest username="ostel_user",
realm="ostel.co", nonce="VM+EcVTPg0UAJIHKK8C32aKliX6GOYXr", uri="sip:ostel.co",
response="1fd67a1722943a896fe52ba59f1ebc74"
D/libpjsip(15884): User-Agent: CSipSimple_m0-19/r2457
D/libpjsip(15884): k: outbound, path
D/libpjsip(15884): m: <sip:ostel_user@95.130.15.251:33564;transport=TLS;ob>
D/libpjsip(15884): m:
<sip:ostel_user@88.30.149.166:46401;transport=TLS;ob>;expires=0;reg-id=1;+sip.in
stance="<urn:uuid:69de3dfa-d575-44bf-9680-d748f6d0d4f6>"
D/libpjsip(15884): Expires: 1800
D/libpjsip(15884): Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO,
SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS
D/libpjsip(15884): l: 0
D/libpjsip(15884):
D/libpjsip(15884): --end msg--
D/libpjsip(15884): 15:01:43.600 pjsua_acc.c .....Acc 3: Registration sent
D/libpjsip(15884): 15:01:44.611 pjsua_core.c .RX 668 bytes Response msg
200/REGISTER/cseq=62585 (rdata0x5f3525f8) from TLS 66.151.32.200:5061:
D/libpjsip(15884): SIP/2.0 200 OK
D/libpjsip(15884): v: SIP/2.0/TLS
88.30.149.166:46401;rport=33564;branch=z9hG4bKPj1hv.2jtQi.Du6p2cAlUUC9Xw9TSugDqL
;alias;received=95.130.15.251
D/libpjsip(15884): f:
<sip:ostel_user@ostel.co>;tag=XKJG.HWeyYdiR4IckVF6DWk2B4gb0cmM
D/libpjsip(15884): t:
<sip:ostel_user@ostel.co>;tag=e01f0de2cdfebbeefc5ff0c8eabbb8b3.4f07
D/libpjsip(15884): i: Aa-mRTcxySdpMdsZPzqbOR5DIGYaCZfm
D/libpjsip(15884): CSeq: 62585 REGISTER
D/libpjsip(15884): Contact:
<sip:ostel_user@88.30.149.166:47657;transport=TLS;ob>;expires=739;+sip.instance=
"<urn:uuid:5c56f713-77c8-463e-9d11-1ac42458e291>";reg-id=1,
<sip:ostel_user@95.130.15.251:33564;transport=TLS;ob>;expires=1800;received="sip
:95.130.15.251:33564;transport=TLS"
D/libpjsip(15884): Server: kamailio (4.1.3 (x86_64/linux))
D/libpjsip(15884): Content-Length: 0
D/libpjsip(15884):
D/libpjsip(15884): --end msg--
D/libpjsip(15884): 15:01:44.611 mobile_reg_han .mod_reg_tracker_on_rx_response
D/libpjsip(15884): 15:01:44.611 mobile_reg_han .mod_reg_tracker_on_rx_response
2
D/libpjsip(15884): 15:01:44.611 mobile_reg_han .Hook a REGISTER RX response !!!
D/libpjsip(15884): 15:01:44.611 mobile_reg_han . Hook should save contact :
<sip:ostel_user@95.130.15.251:33564;transport=TLS;ob> > 1800
D/PjService(15884): Found pjsua 3 searching 3
D/libpjsip(15884): 15:01:44.638 mobile_reg_han .mod_reg_tracker_on_rx_response
done
D/libpjsip(15884): 15:01:44.770 pjsua_acc.c ....SIP outbound status for acc
3 is not active
I/libpjsip(15884): 15:01:44.770 pjsua_acc.c ....<sip:ostel_user@ostel.co>:
registration success, status=200 (OK), will re-register in 1800 seconds
D/libpjsip(15884): 15:01:44.770 pjsua_pres.c ....Starting MWI subscription..
D/libpjsip(15884): 15:01:45.005 pjsua_core.c .......TX 624 bytes Request msg
SUBSCRIBE/cseq=31245 (tdta0x5f343398) to TLS 66.151.32.200:5061:
D/libpjsip(15884): SUBSCRIBE sip:ostel_user@ostel.co SIP/2.0
D/libpjsip(15884): v: SIP/2.0/TLS
88.30.149.166:46401;rport;branch=z9hG4bKPjYs1pKiOJ2O4aSFJiZcp1BVaB.PnwRwIS;alias
D/libpjsip(15884): Max-Forwards: 70
D/libpjsip(15884): f:
<sip:ostel_user@ostel.co>;tag=ZeA.ModrzMapanJdyao46CHvLcGq7tPK
D/libpjsip(15884): t: <sip:ostel_user@ostel.co>
D/libpjsip(15884): m: <sip:ostel_user@95.130.15.251:33564;transport=TLS;ob>
D/libpjsip(15884): i: NqDXlsKHmp3uvHWJm5UpcWFQuGtXhd8F
D/libpjsip(15884): CSeq: 31245 SUBSCRIBE
D/libpjsip(15884): Route: <sips:ostel.co:5061;transport=tls;lr>
D/libpjsip(15884): Event: message-summary
D/libpjsip(15884): Expires: 3600
D/libpjsip(15884): k: replaces, 100rel, timer, norefersub
D/libpjsip(15884): Accept: application/simple-message-summary
D/libpjsip(15884): u: presence, message-summary, refer
D/libpjsip(15884): User-Agent: CSipSimple_m0-19/r2457
D/libpjsip(15884): l: 0
D/libpjsip(15884):
D/libpjsip(15884): --end msg--
D/libpjsip(15884): 15:01:45.010 evsub0x5f0df49 .........Subscription state
changed NULL --> SENT
D/libpjsip(15884): 15:01:45.010 pjsua_pres.c ..........MWI subscription for
<sip:ostel_user@ostel.co> is SENT
D/SIP UA Receiver(15884): < LOCK CPU
D/SIP UA Receiver(15884): > UNLOCK CPU 0
D/PjService(15884): Found pjsua 3 searching 3
D/PjService(15884): Update profile from service for 3 aka in db 1
D/DBProvider(15884): Updated status_text=OK status_code=200 display_name=OSTN
expires=1794 account_id=1 added_status=0 priority=100 active=true wizard=OSTN
reg_uri=sip:ostel.co pjsua_id=3
D/SIP SRV (15884): Accounts status.onChange( false)
D/SIP SRV (15884): Update registration state
D/AccountChooserButton(15866): Accounts status.onChange( false)
D/PjService(15884): Profile state UP : status_text=OK status_code=200
expires=1794
D/libpjsip(15884): 15:01:46.072 pjsua_core.c .RX 517 bytes Response msg
407/SUBSCRIBE/cseq=31245 (rdata0x5f3525f8) from TLS 66.151.32.200:5061:
D/libpjsip(15884): SIP/2.0 407 Proxy Authentication Required
D/libpjsip(15884): v: SIP/2.0/TLS
88.30.149.166:46401;rport=33564;branch=z9hG4bKPjYs1pKiOJ2O4aSFJiZcp1BVaB.PnwRwIS
;alias;received=95.130.15.251
D/libpjsip(15884): f:
<sip:ostel_user@ostel.co>;tag=ZeA.ModrzMapanJdyao46CHvLcGq7tPK
D/libpjsip(15884): t:
<sip:ostel_user@ostel.co>;tag=e01f0de2cdfebbeefc5ff0c8eabbb8b3.75dd
D/libpjsip(15884): i: NqDXlsKHmp3uvHWJm5UpcWFQuGtXhd8F
D/libpjsip(15884): CSeq: 31245 SUBSCRIBE
D/libpjsip(15884): Proxy-Authenticate: Digest realm="ostel.co",
nonce="VM+EdVTPg0mKUeTsb+DN+rYyD2EG8NQ1"
D/libpjsip(15884): Server: kamailio (4.1.3 (x86_64/linux))
D/libpjsip(15884): Content-Length: 0
D/libpjsip(15884):
D/libpjsip(15884): --end msg--
D/libpjsip(15884): 15:01:46.072 mobile_reg_han .mod_reg_tracker_on_rx_response
D/libpjsip(15884): 15:01:46.072 mobile_reg_han .mod_reg_tracker_on_rx_response
done
D/libpjsip(15884): 15:01:46.078 pjsua_core.c ......TX 811 bytes Request msg
SUBSCRIBE/cseq=31246 (tdta0x5f343398) to TLS 66.151.32.200:5061:
D/libpjsip(15884): SUBSCRIBE sip:ostel_user@ostel.co SIP/2.0
D/libpjsip(15884): v: SIP/2.0/TLS
88.30.149.166:46401;rport;branch=z9hG4bKPjn.1dL4K.44BuwxNLpj1BywBcpB8xwp6p;alias
D/libpjsip(15884): Max-Forwards: 70
D/libpjsip(15884): f:
<sip:ostel_user@ostel.co>;tag=ZeA.ModrzMapanJdyao46CHvLcGq7tPK
D/libpjsip(15884): t: <sip:ostel_user@ostel.co>
D/libpjsip(15884): m: <sip:ostel_user@95.130.15.251:33564;transport=TLS;ob>
D/libpjsip(15884): i: NqDXlsKHmp3uvHWJm5UpcWFQuGtXhd8F
D/libpjsip(15884): CSeq: 31246 SUBSCRIBE
D/libpjsip(15884): Route: <sips:ostel.co:5061;transport=tls;lr>
D/libpjsip(15884): Event: message-summary
D/libpjsip(15884): Expires: 3600
D/libpjsip(15884): k: replaces, 100rel, timer, norefersub
D/libpjsip(15884): Accept: application/simple-message-summary
D/libpjsip(15884): u: presence, message-summary, refer
D/libpjsip(15884): User-Agent: CSipSimple_m0-19/r2457
D/libpjsip(15884): Proxy-Authorization: Digest username="ostel_user",
realm="ostel.co", nonce="VM+EdVTPg0mKUeTsb+DN+rYyD2EG8NQ1",
uri="sip:ostel_user@ostel.co", response="a005eae6d3765d3bae9d9f4f5928af9d"
D/libpjsip(15884): l: 0
D/libpjsip(15884):
D/libpjsip(15884): --end msg--
D/libpjsip(15884): 15:01:46.898 pjsua_core.c .RX 421 bytes Response msg
404/SUBSCRIBE/cseq=31246 (rdata0x5f3525f8) from TLS 66.151.32.200:5061:
D/libpjsip(15884): SIP/2.0 404 No voicemail service
D/libpjsip(15884): v: SIP/2.0/TLS
88.30.149.166:46401;rport=33564;branch=z9hG4bKPjn.1dL4K.44BuwxNLpj1BywBcpB8xwp6p
;alias;received=95.130.15.251
D/libpjsip(15884): f:
<sip:ostel_user@ostel.co>;tag=ZeA.ModrzMapanJdyao46CHvLcGq7tPK
D/libpjsip(15884): t:
<sip:ostel_user@ostel.co>;tag=e01f0de2cdfebbeefc5ff0c8eabbb8b3.8e8e
D/libpjsip(15884): i: NqDXlsKHmp3uvHWJm5UpcWFQuGtXhd8F
D/libpjsip(15884): CSeq: 31246 SUBSCRIBE
D/libpjsip(15884): Server: kamailio (4.1.3 (x86_64/linux))
D/libpjsip(15884): Content-Length: 0
D/libpjsip(15884):
D/libpjsip(15884): --end msg--
D/libpjsip(15884): 15:01:46.898 mobile_reg_han .mod_reg_tracker_on_rx_response
D/libpjsip(15884): 15:01:46.898 mobile_reg_han .mod_reg_tracker_on_rx_response
done
D/libpjsip(15884): 15:01:46.905 evsub0x5f0df49 ....Subscription state changed
SENT --> TERMINATED
D/libpjsip(15884): 15:01:46.905 pjsua_pres.c .....MWI subscription for
<sip:ostel_user@ostel.co> is TERMINATED
D/libpjsip(15884): 15:01:46.929 evsub0x5f0df49 !...Subscription destroyed
D/Prefs (15884): We are valid for MOBILE
D/Prefs (15884): We are valid for MOBILE
D/SIP SRV (15884): Direct sip start
D/Prefs (15884): We are valid for MOBILE
D/Prefs (15884): We are valid for MOBILE
D/SIP SRV (15884): Start was asked and we should actually start now
D/SIP SRV (15884): Ask pjservice to start itself
D/PjService(15884): will call <sip:9196@ostel.co>
D/libpjsip(15884): 15:01:49.322 pjsua_call.c !Making call with acc #3 to
<sip:9196@ostel.co>
D/libpjsip(15884): 15:01:49.322 pjsua_aud.c .Set sound device: capture=-1,
playback=-2
D/libpjsip(15884): 15:01:49.322 pjsua_aud.c ..Opening sound device
PCM@16000/1/20ms
D/libpjsip(15884): 15:01:49.322 opensl_dev.c ...Creating OpenSL stream
W/AudioTrack(15884): AUDIO_OUTPUT_FLAG_FAST denied by client due to mismatching
sample rate (16000 vs 44100)
D/libpjsip(15884): 15:01:49.325 opensl_dev.c ...Recording stream type 4, SDK
: 19
W/AudioRecord(15884): AUDIO_INPUT_FLAG_FAST denied by client
D/libpjsip(15884): 15:01:49.351 echo_webrtc_ae ...Create webRTC AEC with clock
rate 16000
D/libpjsip(15884): 15:01:49.351 ec0x5ef93318 ...WEBRTC AEC created,
clock_rate=16000, channel=1, samples per frame=320, tail length=200 ms,
latency=100 ms
D/libpjsip(15884): 15:01:49.351 opensl_dev.c ...Starting OpenSL stream..
D/MediaManager(15884): Target mode... : 3
D/MediaManager(15884): Target mode... : 3
D/MediaManager(15884): Set mode audio in call to 3
D/AudioFocus 8(15884): Focus again false
D/MediaManager(15884): Initial volume level : 0.8
D/libpjsip(15884): 15:01:49.675 opensl_dev.c ...OpenSL stream started
D/libpjsip(15884): 15:01:49.676 pjsua_media.c .Call 0: initializing media..
D/libpjsip(15884): 15:01:49.834 ec0x5ef93318 !Buffer size adjusted from 1920
to 1441 (eff_cnt=1440)
D/libpjsip(15884): 15:01:49.884 pjsua_media.c !..RTP socket reachable at
88.30.149.166:4000
D/libpjsip(15884): 15:01:49.884 pjsua_media.c ..RTCP socket reachable at
88.30.149.166:4001
D/libpjsip(15884): 15:01:49.884 pjsua_media.c ..Media index 0 selected for
audio call 0
D/libpjsip(15884): 15:01:49.884 pjsua_jni_addo ..Dispatch transport creation
on ZRTP one
D/libpjsip(15884): 15:01:49.884 zrtp_android.c ..ZRTP transport created
D/libpjsip(15884): 15:01:49.885 transport_zrtp .attribute added:
a=zrtp-hash:1.10
46bd5349c9d5e379df63f78076e002ed4170d970bd479f7d7fbf250bec36f065
D/libpjsip(15884): 15:01:49.996 pjsua_core.c ....TX 914 bytes Request msg
INVITE/cseq=21664 (tdta0x5f36bfa8) to TLS 66.151.32.200:5061:
D/libpjsip(15884): INVITE sip:9196@ostel.co SIP/2.0
D/libpjsip(15884): v: SIP/2.0/TLS
88.30.149.166:46401;rport;branch=z9hG4bKPj6QiW14fu6AqImja.L5dR0ZBu54BTDLSs;alias
D/libpjsip(15884): Max-Forwards: 70
D/libpjsip(15884): f:
<sip:ostel_user@ostel.co>;tag=gm2RoQxtgGwBkN1YinO7hnGp-N8K-dM1
D/libpjsip(15884): t: <sip:9196@ostel.co>
D/libpjsip(15884): m: <sip:ostel_user@95.130.15.251:33564;transport=TLS;ob>
D/libpjsip(15884): i: 4607SgEyt0bZNTGzwQGjbUpGbvMMVJ18
D/libpjsip(15884): CSeq: 21664 INVITE
D/libpjsip(15884): Route: <sips:ostel.co:5061;transport=tls;lr>
D/libpjsip(15884): k: replaces, 100rel, timer, norefersub
D/libpjsip(15884): x: 1800
D/libpjsip(15884): Min-SE: 90
D/libpjsip(15884): User-Agent: CSipSimple_m0-19/r2457
D/libpjsip(15884): c: application/sdp
D/libpjsip(15884): l: 384
D/libpjsip(15884):
D/libpjsip(15884): v=0
D/libpjsip(15884): o=- 3631874509 3631874509 IN IP4 88.30.149.166
D/libpjsip(15884): s=pjmedia
D/libpjsip(15884): c=IN IP4 88.30.149.166
D/libpjsip(15884): t=0 0
D/libpjsip(15884): m=audio 4000 RTP/AVP 96 3 0 8 101
D/libpjsip(15884): c=IN IP4 88.30.149.166
D/libpjsip(15884): a=rtcp:4001 IN IP4 88.30.149.166
D/libpjsip(15884): a=sendrecv
D/libpjsip(15884): a=rtpmap:96 SILK/8000
D/libpjsip(15884): a=fmtp:96 useinbandfec=0
D/libpjsip(15884): a=rtpmap:101 telephone-event/8000
D/libpjsip(15884): a=fmtp:101 0-16
D/libpjsip(15884): a=zrtp-hash:1.10
46bd5349c9d5e379df63f78076e002ed4170d970bd479f7d7fbf250bec36f065
D/libpjsip(15884): --end msg--
I/libpjsip(15884): 15:01:50.000 pjsua_jni_addo .......Call 0 state changed to
CALLING
D/SIP UA Receiver(15884): < LOCK CPU
D/SIP UA Receiver(15884): Call state <<
D/SIP UA Receiver(15884): Updating call infos from the stack
D/PjSipCalls(15884): Update call 0
D/PjService(15884): Found pjsua 3 searching 3
D/PjSipCalls(15884): Last status code is 0
D/SIP UA Receiver(15884): Call state >>
D/SIP UA Receiver(15884): < LOCK CPU
D/SIP UA Receiver(15884): > UNLOCK CPU 0
D/SIP UA Receiver(15884): < LOCK CPU
D/SIP UA Receiver(15884): Call TSX state <<
D/SIP UA Receiver(15884): Updating call infos from the stack
D/PjSipCalls(15884): Update call 0
D/PjService(15884): Found pjsua 3 searching 3
D/PjSipCalls(15884): Last status code is 0
D/SIP UA Receiver(15884): Call TSX state >>
D/SIP UA Receiver(15884): > UNLOCK CPU 1
D/PjService(15884): DTMF - Store for 0 - null
D/SIP UA Receiver(15884): Anounce call activity
D/SIP_HOME(15866): On Pause SIPHOME
D/SIP UA Receiver(15884): > UNLOCK CPU 0
D/InCallActivity(15884): Create in call
D/libpjsip(15884): 15:01:50.209 ec0x5ef93318 !Underflow, buf_cnt=161, will
generate 1 frame
D/InCallControls(15884): >> Speaker null
D/CallProximityManager(15884): Use 4.2 detection way for proximity sensor
detection. Result is true
D/CallProximityManager(15884): We can use native screen locker !!
D/AccelerometerListener(15884): enable(true)
Original comment by a...@orencio.org
on 2 Feb 2015 at 2:42
D/InCallControls(15884): Mode is : 1
D/InCallControls(15884): >> Speaker null
D/InCallActivity(15884): Start in call
D/InCallActivity(15884): We have a call 0 / 1/0
D/InCallControls(15884): Mode is : 1
D/InCallControls(15884): >> Speaker null
D/InCallActivity(15884): Active call is 0
D/InCallActivity(15884): Update ui from call 0 state Llamando...
D/InCallActivity(15884): Acquire wake up lock
D/InCallActivity(15884): we leave the update ui function
D/CallProximityManager(15884): Horizontal : false and activate for calls true
D/InCallActivity(15884): We have a call 0 / 1/0
D/InCallControls(15884): Mode is : 1
D/InCallControls(15884): >> Speaker null
D/InCallActivity(15884): Active call is 0
D/InCallActivity(15884): Update ui from call 0 state Llamando...
D/InCallActivity(15884): Acquire wake up lock
D/InCallActivity(15884): we leave the update ui function
D/CallProximityManager(15884): Horizontal : false and activate for calls true
D/InCallControls(15884): >> Speaker null
D/CallProximityManager(15884): Horizontal : false and activate for calls true
D/libpjsip(15884): 15:01:50.911 ec0x5ef93318 !Buffer size adjusted from 1761
to 1282 (eff_cnt=1440)
I/Timeline(15884): Timeline: Activity_idle id: android.os.BinderProxy@41edc298
time:23723386
D/InCallInfoGrid(15884): Populate 1 children
D/InCallCard(15884): Set call state : 1
W/InCallActivity(15884): No camera preview available to be shown
D/AccelerometerListener(15884): orientation: horizontal
D/CallProximityManager(15884): Horizontal : true and activate for calls true
D/InCallCard(15884): Current ratio is 0.68311197
D/libpjsip(15884): 15:01:53.060 pjsua_core.c !.RX 508 bytes Response msg
407/INVITE/cseq=21664 (rdata0x5f3525f8) from TLS 66.151.32.200:5061:
D/libpjsip(15884): SIP/2.0 407 Proxy Authentication Required
D/libpjsip(15884): v: SIP/2.0/TLS
88.30.149.166:46401;rport=33564;branch=z9hG4bKPj6QiW14fu6AqImja.L5dR0ZBu54BTDLSs
;alias;received=95.130.15.251
D/libpjsip(15884): f:
<sip:ostel_user@ostel.co>;tag=gm2RoQxtgGwBkN1YinO7hnGp-N8K-dM1
D/libpjsip(15884): t:
<sip:9196@ostel.co>;tag=e01f0de2cdfebbeefc5ff0c8eabbb8b3.918a
D/libpjsip(15884): i: 4607SgEyt0bZNTGzwQGjbUpGbvMMVJ18
D/libpjsip(15884): CSeq: 21664 INVITE
D/libpjsip(15884): Proxy-Authenticate: Digest realm="ostel.co",
nonce="VM+Ee1TPg08gka0a94jlXiJ1hVCWg4h9"
D/libpjsip(15884): Server: kamailio (4.1.3 (x86_64/linux))
D/libpjsip(15884): Content-Length: 0
D/libpjsip(15884):
D/libpjsip(15884): --end msg--
D/libpjsip(15884): 15:01:53.060 mobile_reg_han .mod_reg_tracker_on_rx_response
D/libpjsip(15884): 15:01:53.060 mobile_reg_han .mod_reg_tracker_on_rx_response
done
D/libpjsip(15884): 15:01:53.065 pjsua_core.c ..TX 388 bytes Request msg
ACK/cseq=21664 (tdta0x5f43e008) to TLS 66.151.32.200:5061:
D/libpjsip(15884): ACK sip:9196@ostel.co SIP/2.0
D/libpjsip(15884): v: SIP/2.0/TLS
88.30.149.166:46401;rport;branch=z9hG4bKPj6QiW14fu6AqImja.L5dR0ZBu54BTDLSs;alias
D/libpjsip(15884): Max-Forwards: 70
D/libpjsip(15884): f:
<sip:ostel_user@ostel.co>;tag=gm2RoQxtgGwBkN1YinO7hnGp-N8K-dM1
D/libpjsip(15884): t:
<sip:9196@ostel.co>;tag=e01f0de2cdfebbeefc5ff0c8eabbb8b3.918a
D/libpjsip(15884): i: 4607SgEyt0bZNTGzwQGjbUpGbvMMVJ18
D/libpjsip(15884): CSeq: 21664 ACK
D/libpjsip(15884): Route: <sips:ostel.co:5061;transport=tls;lr>
D/libpjsip(15884): l: 0
D/libpjsip(15884):
D/libpjsip(15884): --end msg--
D/libpjsip(15884): 15:01:53.068 pjsua_core.c .......TX 1095 bytes Request
msg INVITE/cseq=21665 (tdta0x5f36bfa8) to TLS 66.151.32.200:5061:
D/libpjsip(15884): INVITE sip:9196@ostel.co SIP/2.0
D/libpjsip(15884): v: SIP/2.0/TLS
88.30.149.166:46401;rport;branch=z9hG4bKPj5q0AgdzNdiHkckGmUpcZ3FI5TU-qf0nx;alias
D/libpjsip(15884): Max-Forwards: 70
D/libpjsip(15884): f:
<sip:ostel_user@ostel.co>;tag=gm2RoQxtgGwBkN1YinO7hnGp-N8K-dM1
D/libpjsip(15884): t: <sip:9196@ostel.co>
D/libpjsip(15884): m: <sip:ostel_user@95.130.15.251:33564;transport=TLS;ob>
D/libpjsip(15884): i: 4607SgEyt0bZNTGzwQGjbUpGbvMMVJ18
D/libpjsip(15884): CSeq: 21665 INVITE
D/libpjsip(15884): Route: <sips:ostel.co:5061;transport=tls;lr>
D/libpjsip(15884): k: replaces, 100rel, timer, norefersub
D/libpjsip(15884): x: 1800
D/libpjsip(15884): Min-SE: 90
D/libpjsip(15884): User-Agent: CSipSimple_m0-19/r2457
D/libpjsip(15884): Proxy-Authorization: Digest username="ostel_user",
realm="ostel.co", nonce="VM+Ee1TPg08gka0a94jlXiJ1hVCWg4h9",
uri="sip:9196@ostel.co", response="aee9a6d768db8e2776e3b616b946f228"
D/libpjsip(15884): c: application/sdp
D/libpjsip(15884): l: 384
D/libpjsip(15884):
D/libpjsip(15884): v=0
D/libpjsip(15884): o=- 3631874509 3631874509 IN IP4 88.30.149.166
D/libpjsip(15884): s=pjmedia
D/libpjsip(15884): c=IN IP4 88.30.149.166
D/libpjsip(15884): t=0 0
D/libpjsip(15884): m=audio 4000 RTP/AVP 96 3 0 8 101
D/libpjsip(15884): c=IN IP4 88.30.149.166
D/libpjsip(15884): a=rtcp:4001 IN IP4 88.30.149.166
D/libpjsip(15884): a=sendrecv
D/libpjsip(15884): a=rtpmap:96 SILK/8000
D/libpjsip(15884): a=fmtp:96 useinbandfec=0
D/libpjsip(15884): a=rtpmap:101 telephone-event/8000
D/libpjsip(15884): a=fmtp:101 0-16
D/libpjsip(15884): a=zrtp-hash:1.10
46bd5349c9d5e379df63f78076e002ed4170d970bd479f7d7fbf250bec36f065
D/libpjsip(15884): --end msg--
D/SIP UA Receiver(15884): < LOCK CPU
D/SIP UA Receiver(15884): Call TSX state <<
D/SIP UA Receiver(15884): Updating call infos from the stack
D/PjSipCalls(15884): Update call 0
D/PjService(15884): Found pjsua 3 searching 3
D/PjSipCalls(15884): Last status code is 0
D/SIP UA Receiver(15884): Call TSX state >>
D/SIP UA Receiver(15884): > UNLOCK CPU 0
D/SIP UA Receiver(15884): < LOCK CPU
D/SIP UA Receiver(15884): Call TSX state <<
D/SIP UA Receiver(15884): Updating call infos from the stack
D/PjSipCalls(15884): Update call 0
D/PjService(15884): Found pjsua 3 searching 3
D/PjSipCalls(15884): Last status code is 407
D/SIP UA Receiver(15884): Call TSX state >>
D/SIP UA Receiver(15884): > UNLOCK CPU 0
D/libpjsip(15884): 15:01:54.018 pjsua_core.c .RX 388 bytes Response msg
100/INVITE/cseq=21665 (rdata0x5f3525f8) from TLS 66.151.32.200:5061:
D/libpjsip(15884): SIP/2.0 100 trying -- your call is important to us
D/libpjsip(15884): v: SIP/2.0/TLS
88.30.149.166:46401;rport=33564;branch=z9hG4bKPj5q0AgdzNdiHkckGmUpcZ3FI5TU-qf0nx
;alias;received=95.130.15.251
D/libpjsip(15884): f:
<sip:ostel_user@ostel.co>;tag=gm2RoQxtgGwBkN1YinO7hnGp-N8K-dM1
D/libpjsip(15884): t: <sip:9196@ostel.co>
D/libpjsip(15884): i: 4607SgEyt0bZNTGzwQGjbUpGbvMMVJ18
D/libpjsip(15884): CSeq: 21665 INVITE
D/libpjsip(15884): Server: kamailio (4.1.3 (x86_64/linux))
D/libpjsip(15884): Content-Length: 0
D/libpjsip(15884):
D/libpjsip(15884): --end msg--
D/libpjsip(15884): 15:01:54.018 mobile_reg_han .mod_reg_tracker_on_rx_response
D/libpjsip(15884): 15:01:54.018 mobile_reg_han .mod_reg_tracker_on_rx_response
done
D/SIP UA Receiver(15884): < LOCK CPU
D/SIP UA Receiver(15884): Call TSX state <<
D/SIP UA Receiver(15884): Updating call infos from the stack
D/PjSipCalls(15884): Update call 0
D/PjService(15884): Found pjsua 3 searching 3
D/PjSipCalls(15884): Last status code is 100
D/SIP UA Receiver(15884): Call TSX state >>
D/SIP UA Receiver(15884): > UNLOCK CPU 0
D/libpjsip(15884): 15:01:54.504 sound_port.c !EC suspended because of
inactivity
D/libpjsip(15884): 15:02:27.970 pjsua_core.c !.RX 407 bytes Response msg
408/INVITE/cseq=21665 (rdata0x5f3525f8) from TLS 66.151.32.200:5061:
D/libpjsip(15884): SIP/2.0 408 Request Timeout
D/libpjsip(15884): v: SIP/2.0/TLS
88.30.149.166:46401;rport=33564;branch=z9hG4bKPj5q0AgdzNdiHkckGmUpcZ3FI5TU-qf0nx
;alias;received=95.130.15.251
D/libpjsip(15884): f:
<sip:ostel_user@ostel.co>;tag=gm2RoQxtgGwBkN1YinO7hnGp-N8K-dM1
D/libpjsip(15884): t:
<sip:9196@ostel.co>;tag=1948a7b22eacdc1559fde4faedc490e1-ce19
D/libpjsip(15884): i: 4607SgEyt0bZNTGzwQGjbUpGbvMMVJ18
D/libpjsip(15884): CSeq: 21665 INVITE
D/libpjsip(15884): Server: kamailio (4.1.3 (x86_64/linux))
D/libpjsip(15884): Content-Length: 0
D/libpjsip(15884):
D/libpjsip(15884): --end msg--
D/libpjsip(15884): 15:02:27.971 mobile_reg_han .mod_reg_tracker_on_rx_response
D/libpjsip(15884): 15:02:27.971 mobile_reg_han .mod_reg_tracker_on_rx_response
done
D/libpjsip(15884): 15:02:27.971 pjsua_core.c ..TX 388 bytes Request msg
ACK/cseq=21665 (tdta0x5f43e008) to TLS 66.151.32.200:5061:
D/libpjsip(15884): ACK sip:9196@ostel.co SIP/2.0
D/libpjsip(15884): v: SIP/2.0/TLS
88.30.149.166:46401;rport;branch=z9hG4bKPj5q0AgdzNdiHkckGmUpcZ3FI5TU-qf0nx;alias
D/libpjsip(15884): Max-Forwards: 70
D/libpjsip(15884): f:
<sip:ostel_user@ostel.co>;tag=gm2RoQxtgGwBkN1YinO7hnGp-N8K-dM1
D/libpjsip(15884): t:
<sip:9196@ostel.co>;tag=1948a7b22eacdc1559fde4faedc490e1-ce19
D/libpjsip(15884): i: 4607SgEyt0bZNTGzwQGjbUpGbvMMVJ18
D/libpjsip(15884): CSeq: 21665 ACK
D/libpjsip(15884): Route: <sips:ostel.co:5061;transport=tls;lr>
D/libpjsip(15884): l: 0
D/libpjsip(15884):
D/libpjsip(15884): --end msg--
D/SIP UA Receiver(15884): < LOCK CPU
D/SIP UA Receiver(15884): Call TSX state <<
D/SIP UA Receiver(15884): Updating call infos from the stack
D/PjSipCalls(15884): Update call 0
D/PjService(15884): Found pjsua 3 searching 3
D/PjSipCalls(15884): Last status code is 408
D/SIP UA Receiver(15884): Call TSX state >>
D/SIP UA Receiver(15884): > UNLOCK CPU 0
I/libpjsip(15884): 15:02:27.979 pjsua_jni_addo .....Call 0 is DISCONNECTED
[reason=408 (Request Timeout)]
D/SIP UA Receiver(15884): < LOCK CPU
D/SIP UA Receiver(15884): Call state <<
D/SIP UA Receiver(15884): Updating call infos from the stack
D/PjSipCalls(15884): Update call 0
D/PjService(15884): Found pjsua 3 searching 3
D/PjSipCalls(15884): Last status code is 408
D/SIP UA Receiver(15884): Call state >>
D/SIP UA Receiver(15884): > UNLOCK CPU 0
D/libpjsip(15884): 15:02:28.003 pjsua_media.c .....Call 0: deinitializing
media..
D/SIP UA Receiver(15884): < LOCK CPU
D/libpjsip(15884): 15:02:28.003 transport_zrtp ......Media stop - encrypted
packets: 0, decrypted packets: 0
D/libpjsip(15884): 15:02:28.004 transport_zrtp ......Destroy - encrypted
packets: 0, decrypted packets: 0
D/Prefs (15884): We are valid for MOBILE
D/Prefs (15884): We are valid for MOBILE
D/SIP UA Receiver(15884): > UNLOCK CPU 0
D/InCallActivity(15884): We have a call 0 / 6/0
D/InCallInfoGrid(15884): Populate 1 children
D/InCallCard(15884): Set call state : 6
W/InCallActivity(15884): No camera preview available to be shown
D/InCallInfoGrid(15884): Populate 0 children
D/InCallActivity(15884): Active call is 0
D/InCallActivity(15884): Update ui from call 0 state Colgado
D/InCallActivity(15884): Active call session is disconnected or null wait for
quit...
W/InCallActivity(15884): No camera preview available to be shown
D/InCallActivity(15884): Releasing wake up lock
D/InCallActivity(15884): Start quit timer
D/InCallInfoGrid(15884): Populate 1 children
D/InCallCard(15884): Set call state : 6
D/InCallCard(15884): Nothing changed, ignore this update
W/InCallActivity(15884): No camera preview available to be shown
D/InCallCard(15884): Current ratio is 0.5930807
D/libpjsip(15884): 15:02:29.018 pjsua_aud.c !Closing sound device after idle
for 1 second(s)
D/libpjsip(15884): 15:02:29.018 pjsua_aud.c .Closing OpenSL ES Audio sound
playback device and OpenSL ES Audio sound capture device
D/libpjsip(15884): 15:02:29.018 opensl_dev.c .Stopping stream
D/libpjsip(15884): 15:02:29.059 opensl_dev.c .OpenSL stream stopped
D/MediaManager(15884): Unset Audio In call
D/MediaManager(15884): Unset bt
D/BT8 (15884): Ask for false vs false
D/MediaManager(15884): Target mode... : 3
D/libpjsip(15884): 15:02:29.204 opensl_dev.c .OpenSL stream destroyed
D/InCallActivity(15884): Run quit timer
D/SIP_HOME(15866): On Resume SIPHOME
D/SIP_HOME(15866): WE CAN NOW start SIP service
E/ (15866): Device driver API match
E/ (15866): Device driver API version: 23
E/ (15866): User space API version: 23
E/ (15866): mali: REVISION=Linux-r3p2-01rel3 BUILD_DATE=Fri Mar 21
13:52:50 KST 2014
D/Prefs (15884): We are valid for MOBILE
D/Prefs (15884): We are valid for MOBILE
D/SIP SRV (15884): Direct sip start
D/Prefs (15884): We are valid for MOBILE
I/Timeline(15866): Timeline: Activity_idle id: android.os.BinderProxy@42506e00
time:23764176
D/Prefs (15884): We are valid for MOBILE
D/SIP SRV (15884): Start was asked and we should actually start now
D/SIP SRV (15884): Ask pjservice to start itself
D/AccelerometerListener(15884): enable(false)
I/Help (15866): Item clicked : 2 2
D/PreferencesWrapper(15866): Create directory /storage/emulated/0/CSipSimple
408 (1 of 5)
Original comment by a...@orencio.org
on 2 Feb 2015 at 2:42
(this is the log, excuse me but Google says: "Issue attachment storage quota
exceeded.").
Original comment by a...@orencio.org
on 2 Feb 2015 at 2:43
I have the same problem! Wont let me make calls. Says 408 request timeout! How
do I fix it!!!!
Original comment by ryanl...@gmail.com
on 5 Feb 2015 at 9:52
You need to disable SRTP completely and enable ZRTP (Settings -> Network ->
Secure Transport).
Original comment by pej...@gmail.com
on 6 May 2015 at 4:37
Original comment by r3gis...@gmail.com
on 22 Jun 2015 at 11:31
Original issue reported on code.google.com by
a...@orencio.org
on 2 Feb 2015 at 2:38