How interpret the verbose message?

oscaroxy · January 25, 2015, 6:34pm

I install asterisk on CentOS 6.5, It run and work fine.
I configure sip.conf add:

[200]
type=friend
username=200
secret=200ab
qualify=yes
nat=no
host=dynamic
canreinvite=no
context=oscar

[201]
type=friend
username=201
secret=201ab
qualify=yes
nat=no
host=dynamic
canreinvite=no
context=oscar

and in extensions.conf add:
[oscar]
exten => 200,1,Dial(SIP/200)
exten => 201,1,Dial(SIP/201)

when I call with sip application then asterisk ring, but when I open the call then asterisk close itself

localhostCLI>
[Jan 25 19:16:08] NOTICE[3305]: chan_sip.c:27554 handle_request_subscribe: Received SIP subscribe for peer without mailbox: 201
== Using SIP RTP CoS mark 5
– Executing [200@oscar:1] Dial(“SIP/201-00000000”, “SIP/200”) in new stack
== Using SIP RTP CoS mark 5
– Called SIP/200
– SIP/200-00000001 is ringing
localhostCLI>
Disconnected from Asterisk server
Asterisk cleanly ending (0).
Executing last minute cleanups

why? Where can I to see for understand?
thanks

david55 · January 25, 2015, 7:47pm

There is nothing that is necessarily wrong in that output. More information is needed.

oscaroxy · January 25, 2015, 7:58pm

and now?

Connected to Asterisk 13.1.0 currently running on localhost (pid = 2074)
– Registered SIP ‘200’ at 192.168.0.2:26310
[Jan 25 20:55:35] NOTICE[2118]: chan_sip.c:23798 handle_response_peerpoke: Peer ‘200’ is now Reachable. (1ms / 2000ms)
[Jan 25 20:55:35] NOTICE[2118]: chan_sip.c:27554 handle_request_subscribe: Received SIP subscribe for peer without mailbox: 200
– Registered SIP ‘201’ at 192.168.0.4:5060
[Jan 25 20:55:42] NOTICE[2118]: chan_sip.c:23798 handle_response_peerpoke: Peer ‘201’ is now Reachable. (6ms / 2000ms)
[Jan 25 20:55:42] NOTICE[2118]: chan_sip.c:27554 handle_request_subscribe: Received SIP subscribe for peer without mailbox: 201
== Using SIP RTP CoS mark 5
– Executing [200@oscar:1] Dial(“SIP/201-00000000”, “SIP/200”) in new stack
== Using SIP RTP CoS mark 5
– Called SIP/200
– SIP/200-00000001 is ringing
– SIP/200-00000001 answered SIP/201-00000000
– Channel SIP/201-00000000 joined ‘simple_bridge’ basic-bridge <29e8645e-30be-426c-b98e-09389fc78af8>
localhost*CLI>
Disconnected from Asterisk server
Asterisk cleanly ending (0).
Executing last minute cleanups

david55 · January 25, 2015, 8:23pm

Nothing wrong there, either. The only odd thing is that a stop now command seems to have been issued, but there is no evidence that one hasn’t.

oscaroxy · January 26, 2015, 1:48pm

I start from begin, I followed the instruction from (installed only last release):

blogs.digium.com/2012/11/05/how- … -centos-6/

I installed asterisk on centos 6.5 into virtualbox with 3 net (NAT, only host, bridge) and anything work fine, service dahdi start, service asterisk start… asterisk -rvvv work…

I done for the configuration “make samples” and “make config”.
Any thing seems ok, a sip phone calls other sip phone, it rings, but when I reply on one phone this is asterisk>CLI:

(notice: *** glibc detected *** /usr/sbin/asterisk: free(): invalid pointer:)

[code][root@localhost asterisk-13.1.0]# asterisk -rvvv
Asterisk 13.1.0, Copyright © 1999 - 2014, Digium, Inc. and others.
Created by Mark Spencer markster@digium.com
Asterisk comes with ABSOLUTELY NO WARRANTY; type ‘core show warranty’ for details.
This is free software, with components licensed under the GNU General Public
License version 2 and other licenses; you are welcome to redistribute it under
certain conditions. Type ‘core show license’ for details.

Connected to Asterisk 13.1.0 currently running on localhost (pid = 9944)
– Registered SIP ‘200’ at 192.168.56.1:37296
– Registered SIP ‘201’ at 192.168.1.98:5060
== Using SIP RTP CoS mark 5
– Executing [200@oscar:1] Dial(“SIP/201-00000000”, “SIP/200,30,Ttm”) in new stack
== Using SIP RTP CoS mark 5
– Called SIP/200
– Started music on hold, class ‘default’, on channel ‘SIP/201-00000000’
– SIP/200-00000001 is ringing
– SIP/200-00000001 answered SIP/201-00000000
– Stopped music on hold on SIP/201-00000000
– Channel SIP/201-00000000 joined ‘simple_bridge’ basic-bridge
– Channel SIP/200-00000001 joined ‘simple_bridge’ basic-bridge
localhost*CLI> *** glibc detected *** /usr/sbin/asterisk: free(): invalid pointer: 0x00007f2894003e98 ***
======= Backtrace: =========
/lib64/libc.so.6[0x33f0c76166]
/usr/lib64/libjansson.so.4[0x3ddf005efc]
/usr/lib64/libjansson.so.4(json_dumps+0x85)[0x3ddf002825]
/usr/sbin/asterisk(ast_json_dump_string_format+0x3a)[0x51210a]
/usr/lib64/asterisk/modules/res_hep_rtcp.so(+0xf67)[0x7f28785d7f67]
/usr/sbin/asterisk[0x593a8a]
/usr/sbin/asterisk[0x593ee0]
/usr/sbin/asterisk(ast_taskprocessor_execute+0x13e)[0x5a75de]
/usr/sbin/asterisk[0x5a7f38]
/usr/sbin/asterisk[0x5ba1bb]
/lib64/libpthread.so.0[0x33f10079d1]
/lib64/libc.so.6(clone+0x6d)[0x33f0ce8b7d]
======= Memory map: ========
00400000-00650000 r-xp 00000000 fd:00 60568 /usr/sbin/asterisk
0084f000-00862000 rw-p 0024f000 fd:00 60568 /usr/sbin/asterisk
00862000-00888000 rw-p 00000000 00:00 0
00a61000-00a74000 rw-p 00261000 fd:00 60568 /usr/sbin/asterisk
01a14000-02e4e000 rw-p 00000000 00:00 0 [heap]
33f0400000-33f0420000 r-xp 00000000 fd:00 50019 /lib64/ld-2.12.so
33f061f000-33f0620000 r–p 0001f000 fd:00 50019 /lib64/ld-2.12.so
33f0620000-33f0621000 rw-p 00020000 fd:00 50019 /lib64/ld-2.12.so
33f0621000-33f0622000 rw-p 00000000 00:00 0
33f0800000-33f0815000 r-xp 00000000 fd:00 50065 /lib64/libz.so.1.2.3
33f0815000-33f0a14000 —p 00015000 fd:00 50065 /lib64/libz.so.1.2.3
33f0a14000-33f0a15000 r–p 00014000 fd:00 50065 /lib64/libz.so.1.2.3
33f0a15000-33f0a16000 rw-p 00015000 fd:00 50065 /lib64/libz.so.1.2.3
33f0c00000-33f0d8b000 r-xp 00000000 fd:00 50020 /lib64/libc-2.12.so
33f0d8b000-33f0f8a000 —p 0018b000 fd:00 50020 /lib64/libc-2.12.so
33f0f8a000-33f0f8e000 r–p 0018a000 fd:00 50020 /lib64/libc-2.12.so
33f0f8e000-33f0f8f000 rw-p 0018e000 fd:00 50020 /lib64/libc-2.12.so
33f0f8f000-33f0f94000 rw-p 00000000 00:00 0
33f1000000-33f1017000 r-xp 00000000 fd:00 50023 /lib64/libpthread-2.12.so
33f1017000-33f1217000 —p 00017000 fd:00 50023 /lib64/libpthread-2.12.so
33f1217000-33f1218000 r–p 00017000 fd:00 50023 /lib64/libpthread-2.12.so
33f1218000-33f1219000 rw-p 00018000 fd:00 50023 /lib64/libpthread-2.12.so
33f1219000-33f121d000 rw-p 00000000 00:00 0
33f1400000-33f1402000 r-xp 00000000 fd:00 50027 /lib64/libdl-2.12.so
33f1402000-33f1602000 —p 00002000 fd:00 50027 /lib64/libdl-2.12.so
33f1602000-33f1603000 r–p 00002000 fd:00 50027 /lib64/libdl-2.12.so
33f1603000-33f1604000 rw-p 00003000 fd:00 50027 /lib64/libdl-2.12.so
33f1800000-33f1807000 r-xp 00000000 fd:00 50024 /lib64/librt-2.12.so
33f1807000-33f1a06000 —p 00007000 fd:00 50024 /lib64/librt-2.12.so
33f1a06000-33f1a07000 r–p 00006000 fd:00 50024 /lib64/librt-2.12.so
33f1a07000-33f1a08000 rw-p 00007000 fd:00 50024 /lib64/librt-2.12.so
33f1c00000-33f1c83000 r-xp 00000000 fd:00 50066 /lib64/libm-2.12.so
33f1c83000-33f1e82000 —p 00083000 fd:00 50066 /lib64/libm-2.12.so
33f1e82000-33f1e83000 r–p 00082000 fd:00 50066 /lib64/libm-2.12.so
33f1e83000-33f1e84000 rw-p 00083000 fd:00 50066 /lib64/libm-2.12.so
33f2000000-33f20e8000 r-xp 00000000 fd:00 6315 /usr/lib64/libstdc++.so.6.0.13
33f20e8000-33f22e8000 —p 000e8000 fd:00 6315 /usr/lib64/libstdc++.so.6.0.13
33f22e8000-33f22ef000 r–p 000e8000 fd:00 6315 /usr/lib64/libstdc++.so.6.0.13
33f22ef000-33f22f1000 rw-p 000ef000 fd:00 6315 /usr/lib64/libstdc++.so.6.0.13
33f22f1000-33f2306000 rw-p 00000000 00:00 0
33f2400000-33f241d000 r-xp 00000000 fd:00 7977 /lib64/libtinfo.so.5.7
33f241d000-33f261d000 —p 0001d000 fd:00 7977 /lib64/libtinfo.so.5.7
33f261d000-33f2621000 rw-p 0001d000 fd:00 7977 /lib64/libtinfo.so.5.7
33f2800000-33f2816000 r-xp 00000000 fd:00 3868 /lib64/libgcc_s-4.4.7-20120601.so.1
33f2816000-33f2a15000 —p 00016000 fd:00 3868 /lib64/libgcc_s-4.4.7-20120601.so.1
33f2a15000-33f2a16000 rw-p 00015000 fd:00 3868 /lib64/libgcc_s-4.4.7-20120601.so.1
33f2c00000-33f2c03000 r-xp 00000000 fd:00 50104 /lib64/libcom_err.so.2.1
33f2c03000-33f2e02000 —p 00003000 fd:00 50104 /lib64/libcom_err.so.2.1
33f2e02000-33f2e03000 r–p 00002000 fd:00 50104 /lib64/libcom_err.so.2.1
33f2e03000-33f2e04000 rw-p 00003000 fd:00 50104 /lib64/libcom_err.so.2.1
33f3000000-33f3071000 r-xp 00000000 fd:00 50060 /lib64/libfreebl3.so
33f3071000-33f3270000 —p 00071000 fd:00 50060 /lib64/libfreebl3.so
33f3270000-33f3272000 r–p 00070000 fd:00 50060 /lib64/libfreebl3.so
33f3272000-33f3273000 rw-p 00072000 fd:00 50060 /lib64/libfreebl3.so
33f3273000-33f3277000 rw-p 00000000 00:00 0
33f3400000-33f3407000 r-xp 00000000 fd:00 50061 /lib64/libcrypt-2.12.so
33f3407000-33f3607000 —p 00007000 fd:00 50061 /lib64/libcrypt-2.12.so
33f3607000-33f3608000 r–p 00007000 fd:00 50061 /lib64/libcrypt-2.12.so
33f3608000-33f3609000 rw-p 00008000 fd:00 50061 /lib64/libcrypt-2.12.so
33f3609000-33f3637000 rw-p 00000000 00:00 0
33f3800000-33f3803000 r-xp 00000000 fd:00 7168 /lib64/libgpg-error.so.0.5.0
33f3803000-33f3a02000 —p 00003000 fd:00 7168 /lib64/libgpg-error.so.0.5.0
33f3a02000-33f3a03000 r–p 00002000 fd:00 7168 /lib64/libgpg-error.so.0.5.0
33f3a03000-33f3a04000 rw-p 00003000 fd:00 7168 /lib64/libgpg-error.so.0.5.0
33f3c00000-33f3c22000 r-xp 00000000 fd:00 12770 /lib64/libncurses.so.5.7
Disconnected from Asterisk server
Asterisk cleanly ending (0).
Executing last minute cleanups
[root@localhost asterisk-13.1.0]#[/code]

sip.conf:

[code][200]
type=friend
secret=200
qualify=yes
nat=no
host=dynamic
canreinvite=no
context=oscar
mailbox=200@miprimerbuzon

[201]
type=friend
secret=201
qualify=yes
nat=no
host=dynamic
canreinvite=no
context=oscar
mailbox=201@myfirstvoicemail[/code]

[code][oscar]
exten => 200,1,Dial(SIP/200,30,Ttm)
exten => 200,2,Hangup
exten => 200,102,Voicemail(200)
exten => 200,103,Hangup

exten => 201,1,Dial(SIP/201,30,Ttm)
exten => 201,2,Hangup
exten => 201,102,Voicemail(201)
exten => 201,103,Hangup

exten => 30000,1,VoicemailMain[/code]

the service asterisk is in execute with another pid, so it restart.
Why? What do I mistake? Though I set the base configuration and installation…
thanks thanks thanks

oscaroxy · January 26, 2015, 2:06pm

I added memory to virtualbox from 512Mb to 4Gb the result is:

[code][root@localhost webuser]# asterisk -rvvv
Asterisk 13.1.0, Copyright © 1999 - 2014, Digium, Inc. and others.
Created by Mark Spencer markster@digium.com
Asterisk comes with ABSOLUTELY NO WARRANTY; type ‘core show warranty’ for details.
This is free software, with components licensed under the GNU General Public
License version 2 and other licenses; you are welcome to redistribute it under
certain conditions. Type ‘core show license’ for details.

Connected to Asterisk 13.1.0 currently running on localhost (pid = 9265)
– Registered SIP ‘200’ at 192.168.56.1:7708
[Jan 26 15:03:06] NOTICE[9346]: chan_sip.c:23798 handle_response_peerpoke: Peer ‘200’ is now Reachable. (1ms / 2000ms)
– Registered SIP ‘201’ at 192.168.1.98:5060
[Jan 26 15:03:12] NOTICE[9346]: chan_sip.c:23798 handle_response_peerpoke: Peer ‘201’ is now Reachable. (7ms / 2000ms)
== Using SIP RTP CoS mark 5
– Executing [200@oscar:1] Dial(“SIP/201-00000000”, “SIP/200,30,Ttm”) in new stack
== Using SIP RTP CoS mark 5
– Called SIP/200
– Started music on hold, class ‘default’, on channel ‘SIP/201-00000000’
– SIP/200-00000001 is ringing
– SIP/200-00000001 answered SIP/201-00000000
– Stopped music on hold on SIP/201-00000000
– Channel SIP/201-00000000 joined ‘simple_bridge’ basic-bridge <32f7bde5-08ec-4386-aaa7-075a28d11535>
– Channel SIP/200-00000001 joined ‘simple_bridge’ basic-bridge <32f7bde5-08ec-4386-aaa7-075a28d11535>
localhost*CLI>
Disconnected from Asterisk server
Asterisk cleanly ending (0).
Executing last minute cleanups[/code]

Where Can I see for the logs?
thanks

david55 · January 26, 2015, 3:10pm

/var/log/asterisk

oscaroxy · January 26, 2015, 3:32pm

into /var/log/asterisk/message I read:

[Jan 26 16:27:17] NOTICE[10065] chan_sip.c: Peer '201' is now Reachable. (9ms / 2000ms) [Jan 26 16:28:24] NOTICE[10065] chan_sip.c: Peer '200' is now Reachable. (1ms / 2000ms) [Jan 26 16:30:24] Asterisk 13.1.0 built by root @ localhost.localdomain on a x86_64 running Linux on 2015-01-26 08:06:41 UTC [Jan 26 16:30:25] NOTICE[10140] cdr.c: CDR simple logging enabled. [Jan 26 16:30:25] NOTICE[10140] loader.c: 254 modules will be loaded. [Jan 26 16:30:25] NOTICE[10140] res_odbc.c: res_odbc loaded. [Jan 26 16:30:25] WARNING[10140] res_phoneprov.c: Unable to find a valid server address or name. [Jan 26 16:30:25] ERROR[10140] ari/config.c: No configured users for ARI [Jan 26 16:30:25] NOTICE[10140] pbx_lua.c: Lua PBX Switch loaded. [Jan 26 16:30:25] WARNING[10140] loader.c: Error loading module 'res_ari_mailboxes.so': /usr/lib64/asterisk/modules/res_ari_mailboxes.so: undefined symbol: stasis_app_mailbox_update [Jan 26 16:30:25] WARNING[10140] loader.c: Module 'res_ari_mailboxes.so' could not be loaded. [Jan 26 16:30:25] NOTICE[10140] res_config_ldap.c: No directory user found, anonymous binding as default. [Jan 26 16:30:25] ERROR[10140] res_config_ldap.c: No directory URL or host found. [Jan 26 16:30:25] ERROR[10140] res_config_ldap.c: Cannot load LDAP RealTime driver. [Jan 26 16:30:25] ERROR[10140] res_config_pgsql.c: PostgreSQL RealTime: Failed to connect database asterisk on 127.0.0.1: [Jan 26 16:30:25] WARNING[10140] res_config_pgsql.c: PostgreSQL RealTime: Couldn't establish connection. Check debug. [Jan 26 16:30:25] NOTICE[10140] chan_skinny.c: Configuring skinny from skinny.conf [Jan 26 16:30:25] WARNING[10140] chan_dahdi.c: Ignoring any changes to 'userbase' (on reload) at line 23. [Jan 26 16:30:25] WARNING[10140] chan_dahdi.c: Ignoring any changes to 'vmsecret' (on reload) at line 31. [Jan 26 16:30:25] WARNING[10140] chan_dahdi.c: Ignoring any changes to 'hassip' (on reload) at line 35. [Jan 26 16:30:25] WARNING[10140] chan_dahdi.c: Ignoring any changes to 'hasiax' (on reload) at line 39. [Jan 26 16:30:25] WARNING[10140] chan_dahdi.c: Ignoring any changes to 'hasmanager' (on reload) at line 47. [Jan 26 16:30:25] NOTICE[10184] chan_sip.c: Peer '201' is now Reachable. (8ms / 2000ms) [Jan 26 16:30:25] NOTICE[10184] chan_sip.c: Peer '200' is now Reachable. (1ms / 2000ms) [Jan 26 16:30:25] NOTICE[10140] confbridge/conf_config_parser.c: Adding default_menu menu to app_confbridge [Jan 26 16:30:25] NOTICE[10140] cdr_pgsql.c: cdr_pgsql configuration contains no global section, skipping module load. [Jan 26 16:30:25] NOTICE[10140] cel_custom.c: No mappings found in cel_custom.conf. Not logging CEL to custom CSVs. [Jan 26 16:30:25] WARNING[10140] cel_pgsql.c: CEL pgsql config file missing global section.

I don’t understand …
thanks

oscaroxy · January 30, 2015, 7:51am

nothing… I start with ubuntu in virtualbox, follow same steps than centos and then all it’s ok, asterisk work fine.
bye