AHN creates stream on freeswitch mod_rayo, but AHN won't pick up call

classic Classic list List threaded Threaded
14 messages Options
Reply | Threaded
Open this post in threaded view
|

AHN creates stream on freeswitch mod_rayo, but AHN won't pick up call

Dave Dolan
I am not 100% sure if this is a freeswitch or adhearsion issue, but I think it is adhearsion because it appears as though it's just not responding as a rayo client should.  

on the freeswitch side (which I think is ok)

ENTITIES
        TYPE='CLIENT',SUBTYPE='',ID='4dda87bb-c053-4d72-b7fa-3ad816d008e1@localhost/console',JID='4dda87bb-c053-4d72-b7fa-3ad816d008e1@localhost/console',DOMAIN='localhost',REFS=1,STATUS='OFFLINE'
        TYPE='SERVER',SUBTYPE='',ID='localhost',JID='localhost',DOMAIN='localhost',REFS=1

ACTIVE STREAMS
        TYPE='c2s_in',ID='23738217-69a1-409c-a1b9-3a7b8fc728f5',JID='',REMOTE_ADDRESS='127.0.0.1',REMOTE_PORT=39208,STATE='SECURE'   

The Active stream is my adhearsion app

on the ahn side:

[2014-07-07 16:57:32.493] INFO  Adhearsion::Initializer: Setting RAILS_ENV to "development"
[2014-07-07 16:57:32.881] INFO  Adhearsion::Console: Launching Adhearsion Console
AHN> [2014-07-07 16:57:33.006] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
AHN>
AHN> [2014-07-07 16:58:10.301] DEBUG Adhearsion::Initializer: Received SIGALRM. Toggling trace logging.
[2014-07-07 16:58:10.307] WARN  Adhearsion::Logging: Turning TRACE logging ON.
[2014-07-07 16:58:33.249] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 1 of Infinity
[2014-07-07 16:58:38.251] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 16:58:38.609] TRACE Punchblock::Connection::XMPP: USING JID: usera@localhost/phone1.mydomain.com-16876
[2014-07-07 16:58:38.612] TRACE Punchblock::Connection::XMPP: SENDING: (/home/metacodemin/apps/aucp_phone/shared/bundle/jruby/1.9/gems/blather-1.0.0/lib/blather/stream/client.rb:12:in `start') <stream:stream to='localhost' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' version='1.0' xml:lang='en'>
[2014-07-07 16:58:38.620] TRACE Punchblock::Connection::XMPP: RECEIVING (stream) <stream:stream from="localhost" id="11d2a60c-9a67-478d-b14e-8965f6a40665" lang="en" version="1.0" xmlns:db="jabber:server:dialback" xmlns:stream="http://etherx.jabber.org/streams"/>
[2014-07-07 16:58:38.628] TRACE Punchblock::Connection::XMPP: RECEIVING (features) <stream:features xmlns:stream="http://etherx.jabber.org/streams"><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>PLAIN</mechanism></mechanisms></stream:features>

I get basically an infinite number of retries to connect, even though it looks like it's got a connection on the freeswitch side.

config.punchblock.platform = :xmpp # Use FreeSWITCH
config.punchblock.username = "usera@localhost"
config.punchblock.password =  "1"


Am I missing something?  Is there a way to get more detailed errors? 


--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.
Reply | Threaded
Open this post in threaded view
|

Re: AHN creates stream on freeswitch mod_rayo, but AHN won't pick up call

ik_5
You have lost the connection to freeswitch at:

[2014-07-07 16:58:33.249] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 1 of Infinity

what versuin if freeswitch, and what is the rayo binded to ?


On Mon, Jul 7, 2014 at 8:02 PM, Dave Dolan <[hidden email]> wrote:
I am not 100% sure if this is a freeswitch or adhearsion issue, but I think it is adhearsion because it appears as though it's just not responding as a rayo client should.  

on the freeswitch side (which I think is ok)

ENTITIES
        TYPE='CLIENT',SUBTYPE='',ID='4dda87bb-c053-4d72-b7fa-3ad816d008e1@localhost/console',JID='4dda87bb-c053-4d72-b7fa-3ad816d008e1@localhost/console',DOMAIN='localhost',REFS=1,STATUS='OFFLINE'
        TYPE='SERVER',SUBTYPE='',ID='localhost',JID='localhost',DOMAIN='localhost',REFS=1

ACTIVE STREAMS
        TYPE='c2s_in',ID='23738217-69a1-409c-a1b9-3a7b8fc728f5',JID='',REMOTE_ADDRESS='127.0.0.1',REMOTE_PORT=39208,STATE='SECURE'   

The Active stream is my adhearsion app

on the ahn side:

[2014-07-07 16:57:32.493] INFO  Adhearsion::Initializer: Setting RAILS_ENV to "development"
[2014-07-07 16:57:32.881] INFO  Adhearsion::Console: Launching Adhearsion Console
AHN> [2014-07-07 16:57:33.006] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
AHN>
AHN> [2014-07-07 16:58:10.301] DEBUG Adhearsion::Initializer: Received SIGALRM. Toggling trace logging.
[2014-07-07 16:58:10.307] WARN  Adhearsion::Logging: Turning TRACE logging ON.
[2014-07-07 16:58:33.249] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 1 of Infinity
[2014-07-07 16:58:38.251] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 16:58:38.609] TRACE Punchblock::Connection::XMPP: USING JID: usera@localhost/phone1.mydomain.com-16876
[2014-07-07 16:58:38.612] TRACE Punchblock::Connection::XMPP: SENDING: (/home/metacodemin/apps/aucp_phone/shared/bundle/jruby/1.9/gems/blather-1.0.0/lib/blather/stream/client.rb:12:in `start') <stream:stream to='localhost' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' version='1.0' xml:lang='en'>
[2014-07-07 16:58:38.620] TRACE Punchblock::Connection::XMPP: RECEIVING (stream) <stream:stream from="localhost" id="11d2a60c-9a67-478d-b14e-8965f6a40665" lang="en" version="1.0" xmlns:db="jabber:server:dialback" xmlns:stream="http://etherx.jabber.org/streams"/>
[2014-07-07 16:58:38.628] TRACE Punchblock::Connection::XMPP: RECEIVING (features) <stream:features xmlns:stream="http://etherx.jabber.org/streams"><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>PLAIN</mechanism></mechanisms></stream:features>

I get basically an infinite number of retries to connect, even though it looks like it's got a connection on the freeswitch side.

config.punchblock.platform = :xmpp # Use FreeSWITCH
config.punchblock.username = "usera@localhost"
config.punchblock.password =  "1"


Am I missing something?  Is there a way to get more detailed errors? 


--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.

--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.
Reply | Threaded
Open this post in threaded view
|

Re: AHN creates stream on freeswitch mod_rayo, but AHN won't pick up call

Ben Langfeld-2
You've provided Adhearsion logs right up until the part before something useful is said about why the connection fails.

As for the FreeSWITCH console showing an active connection, all its really showing is that a socket is open, and not that authentication completed. Most likely, authentication is failing, but to be sure you need to provide us with a complete log instead of cutting it short.


On 7 July 2014 15:10, ik <[hidden email]> wrote:
You have lost the connection to freeswitch at:


[2014-07-07 16:58:33.249] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 1 of Infinity

what versuin if freeswitch, and what is the rayo binded to ?


On Mon, Jul 7, 2014 at 8:02 PM, Dave Dolan <[hidden email]> wrote:
I am not 100% sure if this is a freeswitch or adhearsion issue, but I think it is adhearsion because it appears as though it's just not responding as a rayo client should.  

on the freeswitch side (which I think is ok)

ENTITIES
        TYPE='CLIENT',SUBTYPE='',ID='4dda87bb-c053-4d72-b7fa-3ad816d008e1@localhost/console',JID='4dda87bb-c053-4d72-b7fa-3ad816d008e1@localhost/console',DOMAIN='localhost',REFS=1,STATUS='OFFLINE'
        TYPE='SERVER',SUBTYPE='',ID='localhost',JID='localhost',DOMAIN='localhost',REFS=1

ACTIVE STREAMS
        TYPE='c2s_in',ID='23738217-69a1-409c-a1b9-3a7b8fc728f5',JID='',REMOTE_ADDRESS='127.0.0.1',REMOTE_PORT=39208,STATE='SECURE'   

The Active stream is my adhearsion app

on the ahn side:

[2014-07-07 16:57:32.493] INFO  Adhearsion::Initializer: Setting RAILS_ENV to "development"
[2014-07-07 16:57:32.881] INFO  Adhearsion::Console: Launching Adhearsion Console
AHN> [2014-07-07 16:57:33.006] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
AHN>
AHN> [2014-07-07 16:58:10.301] DEBUG Adhearsion::Initializer: Received SIGALRM. Toggling trace logging.
[2014-07-07 16:58:10.307] WARN  Adhearsion::Logging: Turning TRACE logging ON.
[2014-07-07 16:58:33.249] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 1 of Infinity
[2014-07-07 16:58:38.251] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 16:58:38.609] TRACE Punchblock::Connection::XMPP: USING JID: usera@localhost/phone1.mydomain.com-16876
[2014-07-07 16:58:38.612] TRACE Punchblock::Connection::XMPP: SENDING: (/home/metacodemin/apps/aucp_phone/shared/bundle/jruby/1.9/gems/blather-1.0.0/lib/blather/stream/client.rb:12:in `start') <stream:stream to='localhost' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' version='1.0' xml:lang='en'>
[2014-07-07 16:58:38.620] TRACE Punchblock::Connection::XMPP: RECEIVING (stream) <stream:stream from="localhost" id="11d2a60c-9a67-478d-b14e-8965f6a40665" lang="en" version="1.0" xmlns:db="jabber:server:dialback" xmlns:stream="http://etherx.jabber.org/streams"/>
[2014-07-07 16:58:38.628] TRACE Punchblock::Connection::XMPP: RECEIVING (features) <stream:features xmlns:stream="http://etherx.jabber.org/streams"><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>PLAIN</mechanism></mechanisms></stream:features>

I get basically an infinite number of retries to connect, even though it looks like it's got a connection on the freeswitch side.

config.punchblock.platform = :xmpp # Use FreeSWITCH
config.punchblock.username = "usera@localhost"
config.punchblock.password =  "1"


Am I missing something?  Is there a way to get more detailed errors? 


--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.

--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.

--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.
Reply | Threaded
Open this post in threaded view
|

Re: AHN creates stream on freeswitch mod_rayo, but AHN won't pick up call

Dave Dolan
For ik: FreeSWITCH Version 1.5.13b+git~20140628T181125Z~c3798dbb02~64bit

It doesn't say anything else in the ahn logs. that's what I get and it starts connecting again, repeating the exact same thing except incrementing the number for the retry.  I cleared the logs, started up ahn, and pasted it to you.  I'll do it again:

[2014-07-07 18:57:38.782] INFO  Adhearsion::Initializer: Setting RAILS_ENV to "development"
[2014-07-07 18:57:39.209] INFO  Adhearsion::Console: Launching Adhearsion Console
[2014-07-07 18:57:39.328] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 18:57:50.120] DEBUG Adhearsion::Initializer: Received SIGALRM. Toggling trace logging.
[2014-07-07 18:57:50.129] WARN  Adhearsion::Logging: Turning TRACE logging ON.
[2014-07-07 18:58:39.412] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 1 of Infinity
[2014-07-07 18:58:44.416] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 18:58:44.420] TRACE Punchblock::Connection::XMPP: USING JID: usera@localhost/phone1.my-server.com-18058
[2014-07-07 18:58:44.424] TRACE Punchblock::Connection::XMPP: SENDING: (/home/metacodemin/apps/aucp_phone/shared/bundle/jruby/1.9/gems/blather-1.0.0/lib/blather/stream/client.rb:12:in `start') <stream:stream to='localhost' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' version='1.0' xml:lang='en'>
[2014-07-07 18:58:44.434] TRACE Punchblock::Connection::XMPP: RECEIVING (stream) <stream:stream from="localhost" id="67a7703d-bb9e-4b3a-97a8-451e9e680eec" lang="en" version="1.0" xmlns:db="jabber:server:dialback" xmlns:stream="http://etherx.jabber.org/streams"/>
[2014-07-07 18:58:44.439] TRACE Punchblock::Connection::XMPP: RECEIVING (features) <stream:features xmlns:stream="http://etherx.jabber.org/streams"><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>PLAIN</mechanism></mechanisms></stream:features>
[2014-07-07 18:59:44.474] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 2 of Infinity
[2014-07-07 18:59:49.477] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 18:59:49.480] TRACE Punchblock::Connection::XMPP: USING JID: usera@localhost/phone1.my-server.com-18058
[2014-07-07 18:59:49.485] TRACE Punchblock::Connection::XMPP: SENDING: (/home/metacodemin/apps/aucp_phone/shared/bundle/jruby/1.9/gems/blather-1.0.0/lib/blather/stream/client.rb:12:in `start') <stream:stream to='localhost' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' version='1.0' xml:lang='en'>
[2014-07-07 18:59:49.497] TRACE Punchblock::Connection::XMPP: RECEIVING (stream) <stream:stream from="localhost" id="662ab4c3-fc84-43be-9422-6b172039f7fb" lang="en" version="1.0" xmlns:db="jabber:server:dialback" xmlns:stream="http://etherx.jabber.org/streams"/>
[2014-07-07 18:59:49.504] TRACE Punchblock::Connection::XMPP: RECEIVING (features) <stream:features xmlns:stream="http://etherx.jabber.org/streams"><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>PLAIN</mechanism></mechanisms></stream:features>

I notice after the second retry, when I look in the freeswitch "rayo status" I see the first stream is still there and another one appeared:

ENTITIES
        TYPE='CLIENT',SUBTYPE='',ID='cdd02294-7c25-463e-9b21-a40f8e0ad375@localhost/console',JID='cdd02294-7c25-463e-9b21-a40f8e0ad375@localhost/console',DOMAIN='localhost',REFS=1,STATUS='OFFLINE'
        TYPE='SERVER',SUBTYPE='',ID='localhost',JID='localhost',DOMAIN='localhost',REFS=1

ACTIVE STREAMS
        TYPE='c2s_in',ID='6999fdfe-01ce-4a3c-bdbb-9829369b5881',JID='',REMOTE_ADDRESS='127.0.0.1',REMOTE_PORT=41437,STATE='SECURE'
        TYPE='c2s_in',ID='67a7703d-bb9e-4b3a-97a8-451e9e680eec',JID='',REMOTE_ADDRESS='127.0.0.1',REMOTE_PORT=41438,STATE='SECURE'

freeswitch@internal>




On Mon, Jul 7, 2014 at 2:14 PM, Ben Langfeld <[hidden email]> wrote:
You've provided Adhearsion logs right up until the part before something useful is said about why the connection fails.

As for the FreeSWITCH console showing an active connection, all its really showing is that a socket is open, and not that authentication completed. Most likely, authentication is failing, but to be sure you need to provide us with a complete log instead of cutting it short.


On 7 July 2014 15:10, ik <[hidden email]> wrote:
You have lost the connection to freeswitch at:


[2014-07-07 16:58:33.249] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 1 of Infinity

what versuin if freeswitch, and what is the rayo binded to ?


On Mon, Jul 7, 2014 at 8:02 PM, Dave Dolan <[hidden email]> wrote:
I am not 100% sure if this is a freeswitch or adhearsion issue, but I think it is adhearsion because it appears as though it's just not responding as a rayo client should.  

on the freeswitch side (which I think is ok)

ENTITIES
        TYPE='CLIENT',SUBTYPE='',ID='4dda87bb-c053-4d72-b7fa-3ad816d008e1@localhost/console',JID='4dda87bb-c053-4d72-b7fa-3ad816d008e1@localhost/console',DOMAIN='localhost',REFS=1,STATUS='OFFLINE'
        TYPE='SERVER',SUBTYPE='',ID='localhost',JID='localhost',DOMAIN='localhost',REFS=1

ACTIVE STREAMS
        TYPE='c2s_in',ID='23738217-69a1-409c-a1b9-3a7b8fc728f5',JID='',REMOTE_ADDRESS='127.0.0.1',REMOTE_PORT=39208,STATE='SECURE'   

The Active stream is my adhearsion app

on the ahn side:

[2014-07-07 16:57:32.493] INFO  Adhearsion::Initializer: Setting RAILS_ENV to "development"
[2014-07-07 16:57:32.881] INFO  Adhearsion::Console: Launching Adhearsion Console
AHN> [2014-07-07 16:57:33.006] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
AHN>
AHN> [2014-07-07 16:58:10.301] DEBUG Adhearsion::Initializer: Received SIGALRM. Toggling trace logging.
[2014-07-07 16:58:10.307] WARN  Adhearsion::Logging: Turning TRACE logging ON.
[2014-07-07 16:58:33.249] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 1 of Infinity
[2014-07-07 16:58:38.251] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 16:58:38.609] TRACE Punchblock::Connection::XMPP: USING JID: usera@localhost/phone1.mydomain.com-16876
[2014-07-07 16:58:38.612] TRACE Punchblock::Connection::XMPP: SENDING: (/home/metacodemin/apps/aucp_phone/shared/bundle/jruby/1.9/gems/blather-1.0.0/lib/blather/stream/client.rb:12:in `start') <stream:stream to='localhost' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' version='1.0' xml:lang='en'>
[2014-07-07 16:58:38.620] TRACE Punchblock::Connection::XMPP: RECEIVING (stream) <stream:stream from="localhost" id="11d2a60c-9a67-478d-b14e-8965f6a40665" lang="en" version="1.0" xmlns:db="jabber:server:dialback" xmlns:stream="http://etherx.jabber.org/streams"/>
[2014-07-07 16:58:38.628] TRACE Punchblock::Connection::XMPP: RECEIVING (features) <stream:features xmlns:stream="http://etherx.jabber.org/streams"><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>PLAIN</mechanism></mechanisms></stream:features>

I get basically an infinite number of retries to connect, even though it looks like it's got a connection on the freeswitch side.

config.punchblock.platform = :xmpp # Use FreeSWITCH
config.punchblock.username = "usera@localhost"
config.punchblock.password =  "1"


Am I missing something?  Is there a way to get more detailed errors? 


--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.

--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.

--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.



--
---------------------------------------------------------------
Dave Dolan
http://davedolan.com/blog

--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.
Reply | Threaded
Open this post in threaded view
|

Re: AHN creates stream on freeswitch mod_rayo, but AHN won't pick up call

Dave Dolan
First of all, thanks for reading this and helping me out.

Just an update: I have the same results on FreeSwitch 1.2 stable tarball installation. So the bleeding edge apparently isn't what caused this issue with Adhearsion.  I'm curious because of the previous comment that there was something that you expected to see in the ahn logs immediately after the disconnect. It was in trace mode, and I pasted everything (it was a complete log file, just very short.)  What should I be looking for, and is there another setting I can do to crank up the logging some more than Trace?


On Mon, Jul 7, 2014 at 3:02 PM, Dave Dolan <[hidden email]> wrote:
For ik: FreeSWITCH Version 1.5.13b+git~20140628T181125Z~c3798dbb02~64bit

It doesn't say anything else in the ahn logs. that's what I get and it starts connecting again, repeating the exact same thing except incrementing the number for the retry.  I cleared the logs, started up ahn, and pasted it to you.  I'll do it again:

[2014-07-07 18:57:38.782] INFO  Adhearsion::Initializer: Setting RAILS_ENV to "development"
[2014-07-07 18:57:39.209] INFO  Adhearsion::Console: Launching Adhearsion Console
[2014-07-07 18:57:39.328] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 18:57:50.120] DEBUG Adhearsion::Initializer: Received SIGALRM. Toggling trace logging.
[2014-07-07 18:57:50.129] WARN  Adhearsion::Logging: Turning TRACE logging ON.
[2014-07-07 18:58:39.412] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 1 of Infinity
[2014-07-07 18:58:44.416] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 18:58:44.420] TRACE Punchblock::Connection::XMPP: USING JID: usera@localhost/phone1.my-server.com-18058
[2014-07-07 18:58:44.424] TRACE Punchblock::Connection::XMPP: SENDING: (/home/metacodemin/apps/aucp_phone/shared/bundle/jruby/1.9/gems/blather-1.0.0/lib/blather/stream/client.rb:12:in `start') <stream:stream to='localhost' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' version='1.0' xml:lang='en'>
[2014-07-07 18:58:44.434] TRACE Punchblock::Connection::XMPP: RECEIVING (stream) <stream:stream from="localhost" id="67a7703d-bb9e-4b3a-97a8-451e9e680eec" lang="en" version="1.0" xmlns:db="jabber:server:dialback" xmlns:stream="http://etherx.jabber.org/streams"/>
[2014-07-07 18:58:44.439] TRACE Punchblock::Connection::XMPP: RECEIVING (features) <stream:features xmlns:stream="http://etherx.jabber.org/streams"><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>PLAIN</mechanism></mechanisms></stream:features>
[2014-07-07 18:59:44.474] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 2 of Infinity
[2014-07-07 18:59:49.477] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 18:59:49.480] TRACE Punchblock::Connection::XMPP: USING JID: usera@localhost/phone1.my-server.com-18058
[2014-07-07 18:59:49.485] TRACE Punchblock::Connection::XMPP: SENDING: (/home/metacodemin/apps/aucp_phone/shared/bundle/jruby/1.9/gems/blather-1.0.0/lib/blather/stream/client.rb:12:in `start') <stream:stream to='localhost' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' version='1.0' xml:lang='en'>
[2014-07-07 18:59:49.497] TRACE Punchblock::Connection::XMPP: RECEIVING (stream) <stream:stream from="localhost" id="662ab4c3-fc84-43be-9422-6b172039f7fb" lang="en" version="1.0" xmlns:db="jabber:server:dialback" xmlns:stream="http://etherx.jabber.org/streams"/>
[2014-07-07 18:59:49.504] TRACE Punchblock::Connection::XMPP: RECEIVING (features) <stream:features xmlns:stream="http://etherx.jabber.org/streams"><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>PLAIN</mechanism></mechanisms></stream:features>

I notice after the second retry, when I look in the freeswitch "rayo status" I see the first stream is still there and another one appeared:

ENTITIES
        TYPE='CLIENT',SUBTYPE='',ID='cdd02294-7c25-463e-9b21-a40f8e0ad375@localhost/console',JID='cdd02294-7c25-463e-9b21-a40f8e0ad375@localhost/console',DOMAIN='localhost',REFS=1,STATUS='OFFLINE'
        TYPE='SERVER',SUBTYPE='',ID='localhost',JID='localhost',DOMAIN='localhost',REFS=1

ACTIVE STREAMS
        TYPE='c2s_in',ID='6999fdfe-01ce-4a3c-bdbb-9829369b5881',JID='',REMOTE_ADDRESS='127.0.0.1',REMOTE_PORT=41437,STATE='SECURE'
        TYPE='c2s_in',ID='67a7703d-bb9e-4b3a-97a8-451e9e680eec',JID='',REMOTE_ADDRESS='127.0.0.1',REMOTE_PORT=41438,STATE='SECURE'

freeswitch@internal>




On Mon, Jul 7, 2014 at 2:14 PM, Ben Langfeld <[hidden email]> wrote:
You've provided Adhearsion logs right up until the part before something useful is said about why the connection fails.

As for the FreeSWITCH console showing an active connection, all its really showing is that a socket is open, and not that authentication completed. Most likely, authentication is failing, but to be sure you need to provide us with a complete log instead of cutting it short.


On 7 July 2014 15:10, ik <[hidden email]> wrote:
You have lost the connection to freeswitch at:


[2014-07-07 16:58:33.249] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 1 of Infinity

what versuin if freeswitch, and what is the rayo binded to ?


On Mon, Jul 7, 2014 at 8:02 PM, Dave Dolan <[hidden email]> wrote:
I am not 100% sure if this is a freeswitch or adhearsion issue, but I think it is adhearsion because it appears as though it's just not responding as a rayo client should.  

on the freeswitch side (which I think is ok)

ENTITIES
        TYPE='CLIENT',SUBTYPE='',ID='4dda87bb-c053-4d72-b7fa-3ad816d008e1@localhost/console',JID='4dda87bb-c053-4d72-b7fa-3ad816d008e1@localhost/console',DOMAIN='localhost',REFS=1,STATUS='OFFLINE'
        TYPE='SERVER',SUBTYPE='',ID='localhost',JID='localhost',DOMAIN='localhost',REFS=1

ACTIVE STREAMS
        TYPE='c2s_in',ID='23738217-69a1-409c-a1b9-3a7b8fc728f5',JID='',REMOTE_ADDRESS='127.0.0.1',REMOTE_PORT=39208,STATE='SECURE'   

The Active stream is my adhearsion app

on the ahn side:

[2014-07-07 16:57:32.493] INFO  Adhearsion::Initializer: Setting RAILS_ENV to "development"
[2014-07-07 16:57:32.881] INFO  Adhearsion::Console: Launching Adhearsion Console
AHN> [2014-07-07 16:57:33.006] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
AHN>
AHN> [2014-07-07 16:58:10.301] DEBUG Adhearsion::Initializer: Received SIGALRM. Toggling trace logging.
[2014-07-07 16:58:10.307] WARN  Adhearsion::Logging: Turning TRACE logging ON.
[2014-07-07 16:58:33.249] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 1 of Infinity
[2014-07-07 16:58:38.251] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 16:58:38.609] TRACE Punchblock::Connection::XMPP: USING JID: usera@localhost/phone1.mydomain.com-16876
[2014-07-07 16:58:38.612] TRACE Punchblock::Connection::XMPP: SENDING: (/home/metacodemin/apps/aucp_phone/shared/bundle/jruby/1.9/gems/blather-1.0.0/lib/blather/stream/client.rb:12:in `start') <stream:stream to='localhost' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' version='1.0' xml:lang='en'>
[2014-07-07 16:58:38.620] TRACE Punchblock::Connection::XMPP: RECEIVING (stream) <stream:stream from="localhost" id="11d2a60c-9a67-478d-b14e-8965f6a40665" lang="en" version="1.0" xmlns:db="jabber:server:dialback" xmlns:stream="http://etherx.jabber.org/streams"/>
[2014-07-07 16:58:38.628] TRACE Punchblock::Connection::XMPP: RECEIVING (features) <stream:features xmlns:stream="http://etherx.jabber.org/streams"><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>PLAIN</mechanism></mechanisms></stream:features>

I get basically an infinite number of retries to connect, even though it looks like it's got a connection on the freeswitch side.

config.punchblock.platform = :xmpp # Use FreeSWITCH
config.punchblock.username = "usera@localhost"
config.punchblock.password =  "1"


Am I missing something?  Is there a way to get more detailed errors? 


--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.

--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.

--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.



--
---------------------------------------------------------------
Dave Dolan
http://davedolan.com/blog



--
---------------------------------------------------------------
Dave Dolan
http://davedolan.com/blog

--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.
Reply | Threaded
Open this post in threaded view
|

Re: AHN creates stream on freeswitch mod_rayo, but AHN won't pick up call

Ben Klang-2
If Adhearsion isn’t printing any additional logs, then I guess the socket is being closed.

Some things to check:

1) The XMPP username (including the Rayo domain) match between FreeSWITCH and Adhearsion.  For FreeSWITCH look for the config file autoload_configs/rayo.conf.xml and vars.conf.xml.  With XMPP you don’t strictly need to configure the host IP in Adhearsion if your XMPP domain is valid/resolvable.

2) The FreeSWITCH logs. Please gist those (https://gist.github.com) so we can review what FreeSWITCH is reporting

/BAK/
-- 
Ben Klang
Principal/Technology Strategist, Mojo Lingo
+1.404.475.4841

Mojo Lingo -- Voice applications that work like magic
Twitter: @MojoLingo

Il giorno Jul 8, 2014, alle ore 12:03 AM, Dave Dolan <[hidden email]> ha scritto:

First of all, thanks for reading this and helping me out.

Just an update: I have the same results on FreeSwitch 1.2 stable tarball installation. So the bleeding edge apparently isn't what caused this issue with Adhearsion.  I'm curious because of the previous comment that there was something that you expected to see in the ahn logs immediately after the disconnect. It was in trace mode, and I pasted everything (it was a complete log file, just very short.)  What should I be looking for, and is there another setting I can do to crank up the logging some more than Trace?


On Mon, Jul 7, 2014 at 3:02 PM, Dave Dolan <[hidden email]> wrote:
For ik: FreeSWITCH Version 1.5.13b+git~20140628T181125Z~c3798dbb02~64bit

It doesn't say anything else in the ahn logs. that's what I get and it starts connecting again, repeating the exact same thing except incrementing the number for the retry.  I cleared the logs, started up ahn, and pasted it to you.  I'll do it again:

[2014-07-07 18:57:38.782] INFO  Adhearsion::Initializer: Setting RAILS_ENV to "development"
[2014-07-07 18:57:39.209] INFO  Adhearsion::Console: Launching Adhearsion Console
[2014-07-07 18:57:39.328] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 18:57:50.120] DEBUG Adhearsion::Initializer: Received SIGALRM. Toggling trace logging.
[2014-07-07 18:57:50.129] WARN  Adhearsion::Logging: Turning TRACE logging ON.
[2014-07-07 18:58:39.412] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 1 of Infinity
[2014-07-07 18:58:44.416] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 18:58:44.420] TRACE Punchblock::Connection::XMPP: USING JID: usera@localhost/phone1.my-server.com-18058
[2014-07-07 18:58:44.424] TRACE Punchblock::Connection::XMPP: SENDING: (/home/metacodemin/apps/aucp_phone/shared/bundle/jruby/1.9/gems/blather-1.0.0/lib/blather/stream/client.rb:12:in `start') <stream:stream to='localhost' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' version='1.0' xml:lang='en'>
[2014-07-07 18:58:44.434] TRACE Punchblock::Connection::XMPP: RECEIVING (stream) <stream:stream from="localhost" id="67a7703d-bb9e-4b3a-97a8-451e9e680eec" lang="en" version="1.0" xmlns:db="<a href="jabber:server:dialback">jabber:server:dialback" xmlns:stream="http://etherx.jabber.org/streams"/>
[2014-07-07 18:58:44.439] TRACE Punchblock::Connection::XMPP: RECEIVING (features) <stream:features xmlns:stream="http://etherx.jabber.org/streams"><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>PLAIN</mechanism></mechanisms></stream:features>
[2014-07-07 18:59:44.474] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 2 of Infinity
[2014-07-07 18:59:49.477] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 18:59:49.480] TRACE Punchblock::Connection::XMPP: USING JID: usera@localhost/phone1.my-server.com-18058
[2014-07-07 18:59:49.485] TRACE Punchblock::Connection::XMPP: SENDING: (/home/metacodemin/apps/aucp_phone/shared/bundle/jruby/1.9/gems/blather-1.0.0/lib/blather/stream/client.rb:12:in `start') <stream:stream to='localhost' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' version='1.0' xml:lang='en'>
[2014-07-07 18:59:49.497] TRACE Punchblock::Connection::XMPP: RECEIVING (stream) <stream:stream from="localhost" id="662ab4c3-fc84-43be-9422-6b172039f7fb" lang="en" version="1.0" xmlns:db="<a href="jabber:server:dialback">jabber:server:dialback" xmlns:stream="http://etherx.jabber.org/streams"/>
[2014-07-07 18:59:49.504] TRACE Punchblock::Connection::XMPP: RECEIVING (features) <stream:features xmlns:stream="http://etherx.jabber.org/streams"><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>PLAIN</mechanism></mechanisms></stream:features>

I notice after the second retry, when I look in the freeswitch "rayo status" I see the first stream is still there and another one appeared:

ENTITIES
        TYPE='CLIENT',SUBTYPE='',ID='cdd02294-7c25-463e-9b21-a40f8e0ad375@localhost/console',JID='cdd02294-7c25-463e-9b21-a40f8e0ad375@localhost/console',DOMAIN='localhost',REFS=1,STATUS='OFFLINE'
        TYPE='SERVER',SUBTYPE='',ID='localhost',JID='localhost',DOMAIN='localhost',REFS=1

ACTIVE STREAMS
        TYPE='c2s_in',ID='6999fdfe-01ce-4a3c-bdbb-9829369b5881',JID='',REMOTE_ADDRESS='127.0.0.1',REMOTE_PORT=41437,STATE='SECURE'
        TYPE='c2s_in',ID='67a7703d-bb9e-4b3a-97a8-451e9e680eec',JID='',REMOTE_ADDRESS='127.0.0.1',REMOTE_PORT=41438,STATE='SECURE'

freeswitch@internal>




On Mon, Jul 7, 2014 at 2:14 PM, Ben Langfeld <[hidden email]> wrote:
You've provided Adhearsion logs right up until the part before something useful is said about why the connection fails.

As for the FreeSWITCH console showing an active connection, all its really showing is that a socket is open, and not that authentication completed. Most likely, authentication is failing, but to be sure you need to provide us with a complete log instead of cutting it short.


On 7 July 2014 15:10, ik <[hidden email]> wrote:
You have lost the connection to freeswitch at:


[2014-07-07 16:58:33.249] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 1 of Infinity

what versuin if freeswitch, and what is the rayo binded to ?


On Mon, Jul 7, 2014 at 8:02 PM, Dave Dolan <[hidden email]> wrote:
I am not 100% sure if this is a freeswitch or adhearsion issue, but I think it is adhearsion because it appears as though it's just not responding as a rayo client should.  

on the freeswitch side (which I think is ok)

ENTITIES
        TYPE='CLIENT',SUBTYPE='',ID='4dda87bb-c053-4d72-b7fa-3ad816d008e1@localhost/console',JID='4dda87bb-c053-4d72-b7fa-3ad816d008e1@localhost/console',DOMAIN='localhost',REFS=1,STATUS='OFFLINE'
        TYPE='SERVER',SUBTYPE='',ID='localhost',JID='localhost',DOMAIN='localhost',REFS=1

ACTIVE STREAMS
        TYPE='c2s_in',ID='23738217-69a1-409c-a1b9-3a7b8fc728f5',JID='',REMOTE_ADDRESS='127.0.0.1',REMOTE_PORT=39208,STATE='SECURE'   

The Active stream is my adhearsion app

on the ahn side:

[2014-07-07 16:57:32.493] INFO  Adhearsion::Initializer: Setting RAILS_ENV to "development"
[2014-07-07 16:57:32.881] INFO  Adhearsion::Console: Launching Adhearsion Console
AHN> [2014-07-07 16:57:33.006] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
AHN>
AHN> [2014-07-07 16:58:10.301] DEBUG Adhearsion::Initializer: Received SIGALRM. Toggling trace logging.
[2014-07-07 16:58:10.307] WARN  Adhearsion::Logging: Turning TRACE logging ON.
[2014-07-07 16:58:33.249] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 1 of Infinity
[2014-07-07 16:58:38.251] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 16:58:38.609] TRACE Punchblock::Connection::XMPP: USING JID: usera@localhost/phone1.mydomain.com-16876
[2014-07-07 16:58:38.612] TRACE Punchblock::Connection::XMPP: SENDING: (/home/metacodemin/apps/aucp_phone/shared/bundle/jruby/1.9/gems/blather-1.0.0/lib/blather/stream/client.rb:12:in `start') <stream:stream to='localhost' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' version='1.0' xml:lang='en'>
[2014-07-07 16:58:38.620] TRACE Punchblock::Connection::XMPP: RECEIVING (stream) <stream:stream from="localhost" id="11d2a60c-9a67-478d-b14e-8965f6a40665" lang="en" version="1.0" xmlns:db="<a href="jabber:server:dialback">jabber:server:dialback" xmlns:stream="http://etherx.jabber.org/streams"/>
[2014-07-07 16:58:38.628] TRACE Punchblock::Connection::XMPP: RECEIVING (features) <stream:features xmlns:stream="http://etherx.jabber.org/streams"><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>PLAIN</mechanism></mechanisms></stream:features>

I get basically an infinite number of retries to connect, even though it looks like it's got a connection on the freeswitch side.

config.punchblock.platform = :xmpp # Use FreeSWITCH
config.punchblock.username = "usera@localhost"
config.punchblock.password =  "1"


Am I missing something?  Is there a way to get more detailed errors? 



--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.


--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.


--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.



--
---------------------------------------------------------------
Dave Dolan
http://davedolan.com/blog



--
---------------------------------------------------------------
Dave Dolan
http://davedolan.com/blog

--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.


signature.asc (858 bytes) Download Attachment
Reply | Threaded
Open this post in threaded view
|

Re: AHN creates stream on freeswitch mod_rayo, but AHN won't pick up call

Ben Langfeld-2
Did you get this sorted out in the end, Dave?


On 8 July 2014 11:25, Ben Klang <[hidden email]> wrote:
If Adhearsion isn’t printing any additional logs, then I guess the socket is being closed.

Some things to check:

1) The XMPP username (including the Rayo domain) match between FreeSWITCH and Adhearsion.  For FreeSWITCH look for the config file autoload_configs/rayo.conf.xml and vars.conf.xml.  With XMPP you don’t strictly need to configure the host IP in Adhearsion if your XMPP domain is valid/resolvable.

2) The FreeSWITCH logs. Please gist those (https://gist.github.com) so we can review what FreeSWITCH is reporting

/BAK/
-- 
Ben Klang
Principal/Technology Strategist, Mojo Lingo
<a href="tel:%2B1.404.475.4841" value="+14044754841" target="_blank">+1.404.475.4841

Mojo Lingo -- Voice applications that work like magic
Twitter: @MojoLingo

Il giorno Jul 8, 2014, alle ore 12:03 AM, Dave Dolan <[hidden email]> ha scritto:

First of all, thanks for reading this and helping me out.

Just an update: I have the same results on FreeSwitch 1.2 stable tarball installation. So the bleeding edge apparently isn't what caused this issue with Adhearsion.  I'm curious because of the previous comment that there was something that you expected to see in the ahn logs immediately after the disconnect. It was in trace mode, and I pasted everything (it was a complete log file, just very short.)  What should I be looking for, and is there another setting I can do to crank up the logging some more than Trace?


On Mon, Jul 7, 2014 at 3:02 PM, Dave Dolan <[hidden email]> wrote:
For ik: FreeSWITCH Version 1.5.13b+git~20140628T181125Z~c3798dbb02~64bit

It doesn't say anything else in the ahn logs. that's what I get and it starts connecting again, repeating the exact same thing except incrementing the number for the retry.  I cleared the logs, started up ahn, and pasted it to you.  I'll do it again:

[2014-07-07 18:57:38.782] INFO  Adhearsion::Initializer: Setting RAILS_ENV to "development"
[2014-07-07 18:57:39.209] INFO  Adhearsion::Console: Launching Adhearsion Console
[2014-07-07 18:57:39.328] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 18:57:50.120] DEBUG Adhearsion::Initializer: Received SIGALRM. Toggling trace logging.
[2014-07-07 18:57:50.129] WARN  Adhearsion::Logging: Turning TRACE logging ON.
[2014-07-07 18:58:39.412] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 1 of Infinity
[2014-07-07 18:58:44.416] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 18:58:44.420] TRACE Punchblock::Connection::XMPP: USING JID: usera@localhost/phone1.my-server.com-18058
[2014-07-07 18:58:44.424] TRACE Punchblock::Connection::XMPP: SENDING: (/home/metacodemin/apps/aucp_phone/shared/bundle/jruby/1.9/gems/blather-1.0.0/lib/blather/stream/client.rb:12:in `start') <stream:stream to='localhost' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' version='1.0' xml:lang='en'>
[2014-07-07 18:58:44.434] TRACE Punchblock::Connection::XMPP: RECEIVING (stream) <stream:stream from="localhost" id="67a7703d-bb9e-4b3a-97a8-451e9e680eec" lang="en" version="1.0" xmlns:db="jabber:server:dialback" xmlns:stream="http://etherx.jabber.org/streams"/>
[2014-07-07 18:58:44.439] TRACE Punchblock::Connection::XMPP: RECEIVING (features) <stream:features xmlns:stream="http://etherx.jabber.org/streams"><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>PLAIN</mechanism></mechanisms></stream:features>
[2014-07-07 18:59:44.474] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 2 of Infinity
[2014-07-07 18:59:49.477] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 18:59:49.480] TRACE Punchblock::Connection::XMPP: USING JID: usera@localhost/phone1.my-server.com-18058
[2014-07-07 18:59:49.485] TRACE Punchblock::Connection::XMPP: SENDING: (/home/metacodemin/apps/aucp_phone/shared/bundle/jruby/1.9/gems/blather-1.0.0/lib/blather/stream/client.rb:12:in `start') <stream:stream to='localhost' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' version='1.0' xml:lang='en'>
[2014-07-07 18:59:49.497] TRACE Punchblock::Connection::XMPP: RECEIVING (stream) <stream:stream from="localhost" id="662ab4c3-fc84-43be-9422-6b172039f7fb" lang="en" version="1.0" xmlns:db="jabber:server:dialback" xmlns:stream="http://etherx.jabber.org/streams"/>
[2014-07-07 18:59:49.504] TRACE Punchblock::Connection::XMPP: RECEIVING (features) <stream:features xmlns:stream="http://etherx.jabber.org/streams"><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>PLAIN</mechanism></mechanisms></stream:features>

I notice after the second retry, when I look in the freeswitch "rayo status" I see the first stream is still there and another one appeared:

ENTITIES
        TYPE='CLIENT',SUBTYPE='',ID='cdd02294-7c25-463e-9b21-a40f8e0ad375@localhost/console',JID='cdd02294-7c25-463e-9b21-a40f8e0ad375@localhost/console',DOMAIN='localhost',REFS=1,STATUS='OFFLINE'
        TYPE='SERVER',SUBTYPE='',ID='localhost',JID='localhost',DOMAIN='localhost',REFS=1

ACTIVE STREAMS
        TYPE='c2s_in',ID='6999fdfe-01ce-4a3c-bdbb-9829369b5881',JID='',REMOTE_ADDRESS='127.0.0.1',REMOTE_PORT=41437,STATE='SECURE'
        TYPE='c2s_in',ID='67a7703d-bb9e-4b3a-97a8-451e9e680eec',JID='',REMOTE_ADDRESS='127.0.0.1',REMOTE_PORT=41438,STATE='SECURE'

freeswitch@internal>




On Mon, Jul 7, 2014 at 2:14 PM, Ben Langfeld <[hidden email]> wrote:
You've provided Adhearsion logs right up until the part before something useful is said about why the connection fails.

As for the FreeSWITCH console showing an active connection, all its really showing is that a socket is open, and not that authentication completed. Most likely, authentication is failing, but to be sure you need to provide us with a complete log instead of cutting it short.


On 7 July 2014 15:10, ik <[hidden email]> wrote:
You have lost the connection to freeswitch at:


[2014-07-07 16:58:33.249] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 1 of Infinity

what versuin if freeswitch, and what is the rayo binded to ?


On Mon, Jul 7, 2014 at 8:02 PM, Dave Dolan <[hidden email]> wrote:
I am not 100% sure if this is a freeswitch or adhearsion issue, but I think it is adhearsion because it appears as though it's just not responding as a rayo client should.  

on the freeswitch side (which I think is ok)

ENTITIES
        TYPE='CLIENT',SUBTYPE='',ID='4dda87bb-c053-4d72-b7fa-3ad816d008e1@localhost/console',JID='4dda87bb-c053-4d72-b7fa-3ad816d008e1@localhost/console',DOMAIN='localhost',REFS=1,STATUS='OFFLINE'
        TYPE='SERVER',SUBTYPE='',ID='localhost',JID='localhost',DOMAIN='localhost',REFS=1

ACTIVE STREAMS
        TYPE='c2s_in',ID='23738217-69a1-409c-a1b9-3a7b8fc728f5',JID='',REMOTE_ADDRESS='127.0.0.1',REMOTE_PORT=39208,STATE='SECURE'   

The Active stream is my adhearsion app

on the ahn side:

[2014-07-07 16:57:32.493] INFO  Adhearsion::Initializer: Setting RAILS_ENV to "development"
[2014-07-07 16:57:32.881] INFO  Adhearsion::Console: Launching Adhearsion Console
AHN> [2014-07-07 16:57:33.006] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
AHN>
AHN> [2014-07-07 16:58:10.301] DEBUG Adhearsion::Initializer: Received SIGALRM. Toggling trace logging.
[2014-07-07 16:58:10.307] WARN  Adhearsion::Logging: Turning TRACE logging ON.
[2014-07-07 16:58:33.249] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 1 of Infinity
[2014-07-07 16:58:38.251] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 16:58:38.609] TRACE Punchblock::Connection::XMPP: USING JID: usera@localhost/phone1.mydomain.com-16876
[2014-07-07 16:58:38.612] TRACE Punchblock::Connection::XMPP: SENDING: (/home/metacodemin/apps/aucp_phone/shared/bundle/jruby/1.9/gems/blather-1.0.0/lib/blather/stream/client.rb:12:in `start') <stream:stream to='localhost' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' version='1.0' xml:lang='en'>
[2014-07-07 16:58:38.620] TRACE Punchblock::Connection::XMPP: RECEIVING (stream) <stream:stream from="localhost" id="11d2a60c-9a67-478d-b14e-8965f6a40665" lang="en" version="1.0" xmlns:db="jabber:server:dialback" xmlns:stream="http://etherx.jabber.org/streams"/>
[2014-07-07 16:58:38.628] TRACE Punchblock::Connection::XMPP: RECEIVING (features) <stream:features xmlns:stream="http://etherx.jabber.org/streams"><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>PLAIN</mechanism></mechanisms></stream:features>

I get basically an infinite number of retries to connect, even though it looks like it's got a connection on the freeswitch side.

config.punchblock.platform = :xmpp # Use FreeSWITCH
config.punchblock.username = "usera@localhost"
config.punchblock.password =  "1"


Am I missing something?  Is there a way to get more detailed errors? 



--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.


--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.


--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.



--
---------------------------------------------------------------
Dave Dolan
http://davedolan.com/blog



--
---------------------------------------------------------------
Dave Dolan
http://davedolan.com/blog

--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.


--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.
Reply | Threaded
Open this post in threaded view
|

Re: AHN creates stream on freeswitch mod_rayo, but AHN won't pick up call

Dave Dolan
I was going to reply today actually! As it turns out, Adhearsion was dumping the connection every time it tried to register or answer a call because the provider configuration was wrong - only slightly.  It would authenticate to the provider, but it would refuse the calls, and it wasn't registered quite right.  Freeswitch would keep the stream open though and it eventually reached the open files limit and crashed the server.  I posted a thread in the freeswitch list about how to configure net2phone for for freeswitch (the provider I'm using.)  This seems like it is actually a bug because it doesn't report why it's throwing out the connection, and it doesn't tell freeswitch to close the stream.  It took me forever to figure out what was going on.  


On Mon, Jul 14, 2014 at 9:22 AM, Ben Langfeld <[hidden email]> wrote:
Did you get this sorted out in the end, Dave?


On 8 July 2014 11:25, Ben Klang <[hidden email]> wrote:
If Adhearsion isn’t printing any additional logs, then I guess the socket is being closed.

Some things to check:

1) The XMPP username (including the Rayo domain) match between FreeSWITCH and Adhearsion.  For FreeSWITCH look for the config file autoload_configs/rayo.conf.xml and vars.conf.xml.  With XMPP you don’t strictly need to configure the host IP in Adhearsion if your XMPP domain is valid/resolvable.

2) The FreeSWITCH logs. Please gist those (https://gist.github.com) so we can review what FreeSWITCH is reporting

/BAK/
-- 
Ben Klang
Principal/Technology Strategist, Mojo Lingo
<a href="tel:%2B1.404.475.4841" value="+14044754841" target="_blank">+1.404.475.4841

Mojo Lingo -- Voice applications that work like magic
Twitter: @MojoLingo

Il giorno Jul 8, 2014, alle ore 12:03 AM, Dave Dolan <[hidden email]> ha scritto:

First of all, thanks for reading this and helping me out.

Just an update: I have the same results on FreeSwitch 1.2 stable tarball installation. So the bleeding edge apparently isn't what caused this issue with Adhearsion.  I'm curious because of the previous comment that there was something that you expected to see in the ahn logs immediately after the disconnect. It was in trace mode, and I pasted everything (it was a complete log file, just very short.)  What should I be looking for, and is there another setting I can do to crank up the logging some more than Trace?


On Mon, Jul 7, 2014 at 3:02 PM, Dave Dolan <[hidden email]> wrote:
For ik: FreeSWITCH Version 1.5.13b+git~20140628T181125Z~c3798dbb02~64bit

It doesn't say anything else in the ahn logs. that's what I get and it starts connecting again, repeating the exact same thing except incrementing the number for the retry.  I cleared the logs, started up ahn, and pasted it to you.  I'll do it again:

[2014-07-07 18:57:38.782] INFO  Adhearsion::Initializer: Setting RAILS_ENV to "development"
[2014-07-07 18:57:39.209] INFO  Adhearsion::Console: Launching Adhearsion Console
[2014-07-07 18:57:39.328] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 18:57:50.120] DEBUG Adhearsion::Initializer: Received SIGALRM. Toggling trace logging.
[2014-07-07 18:57:50.129] WARN  Adhearsion::Logging: Turning TRACE logging ON.
[2014-07-07 18:58:39.412] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 1 of Infinity
[2014-07-07 18:58:44.416] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 18:58:44.420] TRACE Punchblock::Connection::XMPP: USING JID: usera@localhost/phone1.my-server.com-18058
[2014-07-07 18:58:44.424] TRACE Punchblock::Connection::XMPP: SENDING: (/home/metacodemin/apps/aucp_phone/shared/bundle/jruby/1.9/gems/blather-1.0.0/lib/blather/stream/client.rb:12:in `start') <stream:stream to='localhost' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' version='1.0' xml:lang='en'>
[2014-07-07 18:58:44.434] TRACE Punchblock::Connection::XMPP: RECEIVING (stream) <stream:stream from="localhost" id="67a7703d-bb9e-4b3a-97a8-451e9e680eec" lang="en" version="1.0" xmlns:db="jabber:server:dialback" xmlns:stream="http://etherx.jabber.org/streams"/>
[2014-07-07 18:58:44.439] TRACE Punchblock::Connection::XMPP: RECEIVING (features) <stream:features xmlns:stream="http://etherx.jabber.org/streams"><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>PLAIN</mechanism></mechanisms></stream:features>
[2014-07-07 18:59:44.474] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 2 of Infinity
[2014-07-07 18:59:49.477] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 18:59:49.480] TRACE Punchblock::Connection::XMPP: USING JID: usera@localhost/phone1.my-server.com-18058
[2014-07-07 18:59:49.485] TRACE Punchblock::Connection::XMPP: SENDING: (/home/metacodemin/apps/aucp_phone/shared/bundle/jruby/1.9/gems/blather-1.0.0/lib/blather/stream/client.rb:12:in `start') <stream:stream to='localhost' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' version='1.0' xml:lang='en'>
[2014-07-07 18:59:49.497] TRACE Punchblock::Connection::XMPP: RECEIVING (stream) <stream:stream from="localhost" id="662ab4c3-fc84-43be-9422-6b172039f7fb" lang="en" version="1.0" xmlns:db="jabber:server:dialback" xmlns:stream="http://etherx.jabber.org/streams"/>
[2014-07-07 18:59:49.504] TRACE Punchblock::Connection::XMPP: RECEIVING (features) <stream:features xmlns:stream="http://etherx.jabber.org/streams"><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>PLAIN</mechanism></mechanisms></stream:features>

I notice after the second retry, when I look in the freeswitch "rayo status" I see the first stream is still there and another one appeared:

ENTITIES
        TYPE='CLIENT',SUBTYPE='',ID='cdd02294-7c25-463e-9b21-a40f8e0ad375@localhost/console',JID='cdd02294-7c25-463e-9b21-a40f8e0ad375@localhost/console',DOMAIN='localhost',REFS=1,STATUS='OFFLINE'
        TYPE='SERVER',SUBTYPE='',ID='localhost',JID='localhost',DOMAIN='localhost',REFS=1

ACTIVE STREAMS
        TYPE='c2s_in',ID='6999fdfe-01ce-4a3c-bdbb-9829369b5881',JID='',REMOTE_ADDRESS='127.0.0.1',REMOTE_PORT=41437,STATE='SECURE'
        TYPE='c2s_in',ID='67a7703d-bb9e-4b3a-97a8-451e9e680eec',JID='',REMOTE_ADDRESS='127.0.0.1',REMOTE_PORT=41438,STATE='SECURE'

freeswitch@internal>




On Mon, Jul 7, 2014 at 2:14 PM, Ben Langfeld <[hidden email]> wrote:
You've provided Adhearsion logs right up until the part before something useful is said about why the connection fails.

As for the FreeSWITCH console showing an active connection, all its really showing is that a socket is open, and not that authentication completed. Most likely, authentication is failing, but to be sure you need to provide us with a complete log instead of cutting it short.


On 7 July 2014 15:10, ik <[hidden email]> wrote:
You have lost the connection to freeswitch at:


[2014-07-07 16:58:33.249] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 1 of Infinity

what versuin if freeswitch, and what is the rayo binded to ?


On Mon, Jul 7, 2014 at 8:02 PM, Dave Dolan <[hidden email]> wrote:
I am not 100% sure if this is a freeswitch or adhearsion issue, but I think it is adhearsion because it appears as though it's just not responding as a rayo client should.  

on the freeswitch side (which I think is ok)

ENTITIES
        TYPE='CLIENT',SUBTYPE='',ID='4dda87bb-c053-4d72-b7fa-3ad816d008e1@localhost/console',JID='4dda87bb-c053-4d72-b7fa-3ad816d008e1@localhost/console',DOMAIN='localhost',REFS=1,STATUS='OFFLINE'
        TYPE='SERVER',SUBTYPE='',ID='localhost',JID='localhost',DOMAIN='localhost',REFS=1

ACTIVE STREAMS
        TYPE='c2s_in',ID='23738217-69a1-409c-a1b9-3a7b8fc728f5',JID='',REMOTE_ADDRESS='127.0.0.1',REMOTE_PORT=39208,STATE='SECURE'   

The Active stream is my adhearsion app

on the ahn side:

[2014-07-07 16:57:32.493] INFO  Adhearsion::Initializer: Setting RAILS_ENV to "development"
[2014-07-07 16:57:32.881] INFO  Adhearsion::Console: Launching Adhearsion Console
AHN> [2014-07-07 16:57:33.006] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
AHN>
AHN> [2014-07-07 16:58:10.301] DEBUG Adhearsion::Initializer: Received SIGALRM. Toggling trace logging.
[2014-07-07 16:58:10.307] WARN  Adhearsion::Logging: Turning TRACE logging ON.
[2014-07-07 16:58:33.249] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 1 of Infinity
[2014-07-07 16:58:38.251] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 16:58:38.609] TRACE Punchblock::Connection::XMPP: USING JID: usera@localhost/phone1.mydomain.com-16876
[2014-07-07 16:58:38.612] TRACE Punchblock::Connection::XMPP: SENDING: (/home/metacodemin/apps/aucp_phone/shared/bundle/jruby/1.9/gems/blather-1.0.0/lib/blather/stream/client.rb:12:in `start') <stream:stream to='localhost' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' version='1.0' xml:lang='en'>
[2014-07-07 16:58:38.620] TRACE Punchblock::Connection::XMPP: RECEIVING (stream) <stream:stream from="localhost" id="11d2a60c-9a67-478d-b14e-8965f6a40665" lang="en" version="1.0" xmlns:db="jabber:server:dialback" xmlns:stream="http://etherx.jabber.org/streams"/>
[2014-07-07 16:58:38.628] TRACE Punchblock::Connection::XMPP: RECEIVING (features) <stream:features xmlns:stream="http://etherx.jabber.org/streams"><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>PLAIN</mechanism></mechanisms></stream:features>

I get basically an infinite number of retries to connect, even though it looks like it's got a connection on the freeswitch side.

config.punchblock.platform = :xmpp # Use FreeSWITCH
config.punchblock.username = "usera@localhost"
config.punchblock.password =  "1"


Am I missing something?  Is there a way to get more detailed errors? 



--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.


--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.


--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.



--
---------------------------------------------------------------
Dave Dolan
http://davedolan.com/blog



--
---------------------------------------------------------------
Dave Dolan
http://davedolan.com/blog

--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.


--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.



--
---------------------------------------------------------------
Dave Dolan
http://davedolan.com/blog

--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.
Reply | Threaded
Open this post in threaded view
|

Re: AHN creates stream on freeswitch mod_rayo, but AHN won't pick up call

Dave Dolan
And thank you very much Ben for following up with me!


On Mon, Jul 14, 2014 at 9:30 AM, Dave Dolan <[hidden email]> wrote:
I was going to reply today actually! As it turns out, Adhearsion was dumping the connection every time it tried to register or answer a call because the provider configuration was wrong - only slightly.  It would authenticate to the provider, but it would refuse the calls, and it wasn't registered quite right.  Freeswitch would keep the stream open though and it eventually reached the open files limit and crashed the server.  I posted a thread in the freeswitch list about how to configure net2phone for for freeswitch (the provider I'm using.)  This seems like it is actually a bug because it doesn't report why it's throwing out the connection, and it doesn't tell freeswitch to close the stream.  It took me forever to figure out what was going on.  


On Mon, Jul 14, 2014 at 9:22 AM, Ben Langfeld <[hidden email]> wrote:
Did you get this sorted out in the end, Dave?


On 8 July 2014 11:25, Ben Klang <[hidden email]> wrote:
If Adhearsion isn’t printing any additional logs, then I guess the socket is being closed.

Some things to check:

1) The XMPP username (including the Rayo domain) match between FreeSWITCH and Adhearsion.  For FreeSWITCH look for the config file autoload_configs/rayo.conf.xml and vars.conf.xml.  With XMPP you don’t strictly need to configure the host IP in Adhearsion if your XMPP domain is valid/resolvable.

2) The FreeSWITCH logs. Please gist those (https://gist.github.com) so we can review what FreeSWITCH is reporting

/BAK/
-- 
Ben Klang
Principal/Technology Strategist, Mojo Lingo
<a href="tel:%2B1.404.475.4841" value="+14044754841" target="_blank">+1.404.475.4841

Mojo Lingo -- Voice applications that work like magic
Twitter: @MojoLingo

Il giorno Jul 8, 2014, alle ore 12:03 AM, Dave Dolan <[hidden email]> ha scritto:

First of all, thanks for reading this and helping me out.

Just an update: I have the same results on FreeSwitch 1.2 stable tarball installation. So the bleeding edge apparently isn't what caused this issue with Adhearsion.  I'm curious because of the previous comment that there was something that you expected to see in the ahn logs immediately after the disconnect. It was in trace mode, and I pasted everything (it was a complete log file, just very short.)  What should I be looking for, and is there another setting I can do to crank up the logging some more than Trace?


On Mon, Jul 7, 2014 at 3:02 PM, Dave Dolan <[hidden email]> wrote:
For ik: FreeSWITCH Version 1.5.13b+git~20140628T181125Z~c3798dbb02~64bit

It doesn't say anything else in the ahn logs. that's what I get and it starts connecting again, repeating the exact same thing except incrementing the number for the retry.  I cleared the logs, started up ahn, and pasted it to you.  I'll do it again:

[2014-07-07 18:57:38.782] INFO  Adhearsion::Initializer: Setting RAILS_ENV to "development"
[2014-07-07 18:57:39.209] INFO  Adhearsion::Console: Launching Adhearsion Console
[2014-07-07 18:57:39.328] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 18:57:50.120] DEBUG Adhearsion::Initializer: Received SIGALRM. Toggling trace logging.
[2014-07-07 18:57:50.129] WARN  Adhearsion::Logging: Turning TRACE logging ON.
[2014-07-07 18:58:39.412] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 1 of Infinity
[2014-07-07 18:58:44.416] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 18:58:44.420] TRACE Punchblock::Connection::XMPP: USING JID: usera@localhost/phone1.my-server.com-18058
[2014-07-07 18:58:44.424] TRACE Punchblock::Connection::XMPP: SENDING: (/home/metacodemin/apps/aucp_phone/shared/bundle/jruby/1.9/gems/blather-1.0.0/lib/blather/stream/client.rb:12:in `start') <stream:stream to='localhost' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' version='1.0' xml:lang='en'>
[2014-07-07 18:58:44.434] TRACE Punchblock::Connection::XMPP: RECEIVING (stream) <stream:stream from="localhost" id="67a7703d-bb9e-4b3a-97a8-451e9e680eec" lang="en" version="1.0" xmlns:db="jabber:server:dialback" xmlns:stream="http://etherx.jabber.org/streams"/>
[2014-07-07 18:58:44.439] TRACE Punchblock::Connection::XMPP: RECEIVING (features) <stream:features xmlns:stream="http://etherx.jabber.org/streams"><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>PLAIN</mechanism></mechanisms></stream:features>
[2014-07-07 18:59:44.474] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 2 of Infinity
[2014-07-07 18:59:49.477] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 18:59:49.480] TRACE Punchblock::Connection::XMPP: USING JID: usera@localhost/phone1.my-server.com-18058
[2014-07-07 18:59:49.485] TRACE Punchblock::Connection::XMPP: SENDING: (/home/metacodemin/apps/aucp_phone/shared/bundle/jruby/1.9/gems/blather-1.0.0/lib/blather/stream/client.rb:12:in `start') <stream:stream to='localhost' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' version='1.0' xml:lang='en'>
[2014-07-07 18:59:49.497] TRACE Punchblock::Connection::XMPP: RECEIVING (stream) <stream:stream from="localhost" id="662ab4c3-fc84-43be-9422-6b172039f7fb" lang="en" version="1.0" xmlns:db="jabber:server:dialback" xmlns:stream="http://etherx.jabber.org/streams"/>
[2014-07-07 18:59:49.504] TRACE Punchblock::Connection::XMPP: RECEIVING (features) <stream:features xmlns:stream="http://etherx.jabber.org/streams"><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>PLAIN</mechanism></mechanisms></stream:features>

I notice after the second retry, when I look in the freeswitch "rayo status" I see the first stream is still there and another one appeared:

ENTITIES
        TYPE='CLIENT',SUBTYPE='',ID='cdd02294-7c25-463e-9b21-a40f8e0ad375@localhost/console',JID='cdd02294-7c25-463e-9b21-a40f8e0ad375@localhost/console',DOMAIN='localhost',REFS=1,STATUS='OFFLINE'
        TYPE='SERVER',SUBTYPE='',ID='localhost',JID='localhost',DOMAIN='localhost',REFS=1

ACTIVE STREAMS
        TYPE='c2s_in',ID='6999fdfe-01ce-4a3c-bdbb-9829369b5881',JID='',REMOTE_ADDRESS='127.0.0.1',REMOTE_PORT=41437,STATE='SECURE'
        TYPE='c2s_in',ID='67a7703d-bb9e-4b3a-97a8-451e9e680eec',JID='',REMOTE_ADDRESS='127.0.0.1',REMOTE_PORT=41438,STATE='SECURE'

freeswitch@internal>




On Mon, Jul 7, 2014 at 2:14 PM, Ben Langfeld <[hidden email]> wrote:
You've provided Adhearsion logs right up until the part before something useful is said about why the connection fails.

As for the FreeSWITCH console showing an active connection, all its really showing is that a socket is open, and not that authentication completed. Most likely, authentication is failing, but to be sure you need to provide us with a complete log instead of cutting it short.


On 7 July 2014 15:10, ik <[hidden email]> wrote:
You have lost the connection to freeswitch at:


[2014-07-07 16:58:33.249] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 1 of Infinity

what versuin if freeswitch, and what is the rayo binded to ?


On Mon, Jul 7, 2014 at 8:02 PM, Dave Dolan <[hidden email]> wrote:
I am not 100% sure if this is a freeswitch or adhearsion issue, but I think it is adhearsion because it appears as though it's just not responding as a rayo client should.  

on the freeswitch side (which I think is ok)

ENTITIES
        TYPE='CLIENT',SUBTYPE='',ID='4dda87bb-c053-4d72-b7fa-3ad816d008e1@localhost/console',JID='4dda87bb-c053-4d72-b7fa-3ad816d008e1@localhost/console',DOMAIN='localhost',REFS=1,STATUS='OFFLINE'
        TYPE='SERVER',SUBTYPE='',ID='localhost',JID='localhost',DOMAIN='localhost',REFS=1

ACTIVE STREAMS
        TYPE='c2s_in',ID='23738217-69a1-409c-a1b9-3a7b8fc728f5',JID='',REMOTE_ADDRESS='127.0.0.1',REMOTE_PORT=39208,STATE='SECURE'   

The Active stream is my adhearsion app

on the ahn side:

[2014-07-07 16:57:32.493] INFO  Adhearsion::Initializer: Setting RAILS_ENV to "development"
[2014-07-07 16:57:32.881] INFO  Adhearsion::Console: Launching Adhearsion Console
AHN> [2014-07-07 16:57:33.006] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
AHN>
AHN> [2014-07-07 16:58:10.301] DEBUG Adhearsion::Initializer: Received SIGALRM. Toggling trace logging.
[2014-07-07 16:58:10.307] WARN  Adhearsion::Logging: Turning TRACE logging ON.
[2014-07-07 16:58:33.249] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 1 of Infinity
[2014-07-07 16:58:38.251] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 16:58:38.609] TRACE Punchblock::Connection::XMPP: USING JID: usera@localhost/phone1.mydomain.com-16876
[2014-07-07 16:58:38.612] TRACE Punchblock::Connection::XMPP: SENDING: (/home/metacodemin/apps/aucp_phone/shared/bundle/jruby/1.9/gems/blather-1.0.0/lib/blather/stream/client.rb:12:in `start') <stream:stream to='localhost' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' version='1.0' xml:lang='en'>
[2014-07-07 16:58:38.620] TRACE Punchblock::Connection::XMPP: RECEIVING (stream) <stream:stream from="localhost" id="11d2a60c-9a67-478d-b14e-8965f6a40665" lang="en" version="1.0" xmlns:db="jabber:server:dialback" xmlns:stream="http://etherx.jabber.org/streams"/>
[2014-07-07 16:58:38.628] TRACE Punchblock::Connection::XMPP: RECEIVING (features) <stream:features xmlns:stream="http://etherx.jabber.org/streams"><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>PLAIN</mechanism></mechanisms></stream:features>

I get basically an infinite number of retries to connect, even though it looks like it's got a connection on the freeswitch side.

config.punchblock.platform = :xmpp # Use FreeSWITCH
config.punchblock.username = "usera@localhost"
config.punchblock.password =  "1"


Am I missing something?  Is there a way to get more detailed errors? 



--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.


--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.


--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.



--
---------------------------------------------------------------
Dave Dolan
http://davedolan.com/blog



--
---------------------------------------------------------------
Dave Dolan
http://davedolan.com/blog

--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.


--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.



--
---------------------------------------------------------------
Dave Dolan
http://davedolan.com/blog



--
---------------------------------------------------------------
Dave Dolan
http://davedolan.com/blog

--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.
Reply | Threaded
Open this post in threaded view
|

Re: AHN creates stream on freeswitch mod_rayo, but AHN won't pick up call

Ben Langfeld-2
By "Provider" I assume you mean a SIP trunk. Adhearsion doesn't know anything about your SIP trunk, and you got nowhere near the stage of handling calls. I think your diagnosis is wrong, here. This is purely a mod_rayo issue.

Whatever it really was, glad you got it sorted :)


On 14 July 2014 10:32, Dave Dolan <[hidden email]> wrote:
And thank you very much Ben for following up with me!


On Mon, Jul 14, 2014 at 9:30 AM, Dave Dolan <[hidden email]> wrote:
I was going to reply today actually! As it turns out, Adhearsion was dumping the connection every time it tried to register or answer a call because the provider configuration was wrong - only slightly.  It would authenticate to the provider, but it would refuse the calls, and it wasn't registered quite right.  Freeswitch would keep the stream open though and it eventually reached the open files limit and crashed the server.  I posted a thread in the freeswitch list about how to configure net2phone for for freeswitch (the provider I'm using.)  This seems like it is actually a bug because it doesn't report why it's throwing out the connection, and it doesn't tell freeswitch to close the stream.  It took me forever to figure out what was going on.  


On Mon, Jul 14, 2014 at 9:22 AM, Ben Langfeld <[hidden email]> wrote:
Did you get this sorted out in the end, Dave?


On 8 July 2014 11:25, Ben Klang <[hidden email]> wrote:
If Adhearsion isn’t printing any additional logs, then I guess the socket is being closed.

Some things to check:

1) The XMPP username (including the Rayo domain) match between FreeSWITCH and Adhearsion.  For FreeSWITCH look for the config file autoload_configs/rayo.conf.xml and vars.conf.xml.  With XMPP you don’t strictly need to configure the host IP in Adhearsion if your XMPP domain is valid/resolvable.

2) The FreeSWITCH logs. Please gist those (https://gist.github.com) so we can review what FreeSWITCH is reporting

/BAK/
-- 
Ben Klang
Principal/Technology Strategist, Mojo Lingo
<a href="tel:%2B1.404.475.4841" value="+14044754841" target="_blank">+1.404.475.4841

Mojo Lingo -- Voice applications that work like magic
Twitter: @MojoLingo

Il giorno Jul 8, 2014, alle ore 12:03 AM, Dave Dolan <[hidden email]> ha scritto:

First of all, thanks for reading this and helping me out.

Just an update: I have the same results on FreeSwitch 1.2 stable tarball installation. So the bleeding edge apparently isn't what caused this issue with Adhearsion.  I'm curious because of the previous comment that there was something that you expected to see in the ahn logs immediately after the disconnect. It was in trace mode, and I pasted everything (it was a complete log file, just very short.)  What should I be looking for, and is there another setting I can do to crank up the logging some more than Trace?


On Mon, Jul 7, 2014 at 3:02 PM, Dave Dolan <[hidden email]> wrote:
For ik: FreeSWITCH Version 1.5.13b+git~20140628T181125Z~c3798dbb02~64bit

It doesn't say anything else in the ahn logs. that's what I get and it starts connecting again, repeating the exact same thing except incrementing the number for the retry.  I cleared the logs, started up ahn, and pasted it to you.  I'll do it again:

[2014-07-07 18:57:38.782] INFO  Adhearsion::Initializer: Setting RAILS_ENV to "development"
[2014-07-07 18:57:39.209] INFO  Adhearsion::Console: Launching Adhearsion Console
[2014-07-07 18:57:39.328] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 18:57:50.120] DEBUG Adhearsion::Initializer: Received SIGALRM. Toggling trace logging.
[2014-07-07 18:57:50.129] WARN  Adhearsion::Logging: Turning TRACE logging ON.
[2014-07-07 18:58:39.412] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 1 of Infinity
[2014-07-07 18:58:44.416] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 18:58:44.420] TRACE Punchblock::Connection::XMPP: USING JID: usera@localhost/phone1.my-server.com-18058
[2014-07-07 18:58:44.424] TRACE Punchblock::Connection::XMPP: SENDING: (/home/metacodemin/apps/aucp_phone/shared/bundle/jruby/1.9/gems/blather-1.0.0/lib/blather/stream/client.rb:12:in `start') <stream:stream to='localhost' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' version='1.0' xml:lang='en'>
[2014-07-07 18:58:44.434] TRACE Punchblock::Connection::XMPP: RECEIVING (stream) <stream:stream from="localhost" id="67a7703d-bb9e-4b3a-97a8-451e9e680eec" lang="en" version="1.0" xmlns:db="jabber:server:dialback" xmlns:stream="http://etherx.jabber.org/streams"/>
[2014-07-07 18:58:44.439] TRACE Punchblock::Connection::XMPP: RECEIVING (features) <stream:features xmlns:stream="http://etherx.jabber.org/streams"><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>PLAIN</mechanism></mechanisms></stream:features>
[2014-07-07 18:59:44.474] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 2 of Infinity
[2014-07-07 18:59:49.477] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 18:59:49.480] TRACE Punchblock::Connection::XMPP: USING JID: usera@localhost/phone1.my-server.com-18058
[2014-07-07 18:59:49.485] TRACE Punchblock::Connection::XMPP: SENDING: (/home/metacodemin/apps/aucp_phone/shared/bundle/jruby/1.9/gems/blather-1.0.0/lib/blather/stream/client.rb:12:in `start') <stream:stream to='localhost' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' version='1.0' xml:lang='en'>
[2014-07-07 18:59:49.497] TRACE Punchblock::Connection::XMPP: RECEIVING (stream) <stream:stream from="localhost" id="662ab4c3-fc84-43be-9422-6b172039f7fb" lang="en" version="1.0" xmlns:db="jabber:server:dialback" xmlns:stream="http://etherx.jabber.org/streams"/>
[2014-07-07 18:59:49.504] TRACE Punchblock::Connection::XMPP: RECEIVING (features) <stream:features xmlns:stream="http://etherx.jabber.org/streams"><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>PLAIN</mechanism></mechanisms></stream:features>

I notice after the second retry, when I look in the freeswitch "rayo status" I see the first stream is still there and another one appeared:

ENTITIES
        TYPE='CLIENT',SUBTYPE='',ID='cdd02294-7c25-463e-9b21-a40f8e0ad375@localhost/console',JID='cdd02294-7c25-463e-9b21-a40f8e0ad375@localhost/console',DOMAIN='localhost',REFS=1,STATUS='OFFLINE'
        TYPE='SERVER',SUBTYPE='',ID='localhost',JID='localhost',DOMAIN='localhost',REFS=1

ACTIVE STREAMS
        TYPE='c2s_in',ID='6999fdfe-01ce-4a3c-bdbb-9829369b5881',JID='',REMOTE_ADDRESS='127.0.0.1',REMOTE_PORT=41437,STATE='SECURE'
        TYPE='c2s_in',ID='67a7703d-bb9e-4b3a-97a8-451e9e680eec',JID='',REMOTE_ADDRESS='127.0.0.1',REMOTE_PORT=41438,STATE='SECURE'

freeswitch@internal>




On Mon, Jul 7, 2014 at 2:14 PM, Ben Langfeld <[hidden email]> wrote:
You've provided Adhearsion logs right up until the part before something useful is said about why the connection fails.

As for the FreeSWITCH console showing an active connection, all its really showing is that a socket is open, and not that authentication completed. Most likely, authentication is failing, but to be sure you need to provide us with a complete log instead of cutting it short.


On 7 July 2014 15:10, ik <[hidden email]> wrote:
You have lost the connection to freeswitch at:


[2014-07-07 16:58:33.249] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 1 of Infinity

what versuin if freeswitch, and what is the rayo binded to ?


On Mon, Jul 7, 2014 at 8:02 PM, Dave Dolan <[hidden email]> wrote:
I am not 100% sure if this is a freeswitch or adhearsion issue, but I think it is adhearsion because it appears as though it's just not responding as a rayo client should.  

on the freeswitch side (which I think is ok)

ENTITIES
        TYPE='CLIENT',SUBTYPE='',ID='4dda87bb-c053-4d72-b7fa-3ad816d008e1@localhost/console',JID='4dda87bb-c053-4d72-b7fa-3ad816d008e1@localhost/console',DOMAIN='localhost',REFS=1,STATUS='OFFLINE'
        TYPE='SERVER',SUBTYPE='',ID='localhost',JID='localhost',DOMAIN='localhost',REFS=1

ACTIVE STREAMS
        TYPE='c2s_in',ID='23738217-69a1-409c-a1b9-3a7b8fc728f5',JID='',REMOTE_ADDRESS='127.0.0.1',REMOTE_PORT=39208,STATE='SECURE'   

The Active stream is my adhearsion app

on the ahn side:

[2014-07-07 16:57:32.493] INFO  Adhearsion::Initializer: Setting RAILS_ENV to "development"
[2014-07-07 16:57:32.881] INFO  Adhearsion::Console: Launching Adhearsion Console
AHN> [2014-07-07 16:57:33.006] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
AHN>
AHN> [2014-07-07 16:58:10.301] DEBUG Adhearsion::Initializer: Received SIGALRM. Toggling trace logging.
[2014-07-07 16:58:10.307] WARN  Adhearsion::Logging: Turning TRACE logging ON.
[2014-07-07 16:58:33.249] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 1 of Infinity
[2014-07-07 16:58:38.251] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 16:58:38.609] TRACE Punchblock::Connection::XMPP: USING JID: usera@localhost/phone1.mydomain.com-16876
[2014-07-07 16:58:38.612] TRACE Punchblock::Connection::XMPP: SENDING: (/home/metacodemin/apps/aucp_phone/shared/bundle/jruby/1.9/gems/blather-1.0.0/lib/blather/stream/client.rb:12:in `start') <stream:stream to='localhost' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' version='1.0' xml:lang='en'>
[2014-07-07 16:58:38.620] TRACE Punchblock::Connection::XMPP: RECEIVING (stream) <stream:stream from="localhost" id="11d2a60c-9a67-478d-b14e-8965f6a40665" lang="en" version="1.0" xmlns:db="jabber:server:dialback" xmlns:stream="http://etherx.jabber.org/streams"/>
[2014-07-07 16:58:38.628] TRACE Punchblock::Connection::XMPP: RECEIVING (features) <stream:features xmlns:stream="http://etherx.jabber.org/streams"><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>PLAIN</mechanism></mechanisms></stream:features>

I get basically an infinite number of retries to connect, even though it looks like it's got a connection on the freeswitch side.

config.punchblock.platform = :xmpp # Use FreeSWITCH
config.punchblock.username = "usera@localhost"
config.punchblock.password =  "1"


Am I missing something?  Is there a way to get more detailed errors? 



--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.


--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.


--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.



--
---------------------------------------------------------------
Dave Dolan
http://davedolan.com/blog



--
---------------------------------------------------------------
Dave Dolan
http://davedolan.com/blog

--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.


--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.



--
---------------------------------------------------------------
Dave Dolan
http://davedolan.com/blog



--
---------------------------------------------------------------
Dave Dolan
http://davedolan.com/blog

--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.

--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.
Reply | Threaded
Open this post in threaded view
|

Re: AHN creates stream on freeswitch mod_rayo, but AHN won't pick up call

Dave Dolan
Ok, so why was the connection being lost from the Adhearsion side?  Mod_rayo still had the stream open, and created a new one every reconnect attempt. And the disconnects did happen every 30 seconds or so when the sip trunk gateway was set to reregister at 30 second intervals.  I can't tell from the logs in adhearsion who caused punchblock to lose the connection, mod_rayo, or adhearsion.  It is maybe not a bug, but very unhelpful, not to know if the server caused the lost connection, or if it was punchblock that decided to dump it.


On Mon, Jul 14, 2014 at 9:36 AM, Ben Langfeld <[hidden email]> wrote:
By "Provider" I assume you mean a SIP trunk. Adhearsion doesn't know anything about your SIP trunk, and you got nowhere near the stage of handling calls. I think your diagnosis is wrong, here. This is purely a mod_rayo issue.

Whatever it really was, glad you got it sorted :)


On 14 July 2014 10:32, Dave Dolan <[hidden email]> wrote:
And thank you very much Ben for following up with me!


On Mon, Jul 14, 2014 at 9:30 AM, Dave Dolan <[hidden email]> wrote:
I was going to reply today actually! As it turns out, Adhearsion was dumping the connection every time it tried to register or answer a call because the provider configuration was wrong - only slightly.  It would authenticate to the provider, but it would refuse the calls, and it wasn't registered quite right.  Freeswitch would keep the stream open though and it eventually reached the open files limit and crashed the server.  I posted a thread in the freeswitch list about how to configure net2phone for for freeswitch (the provider I'm using.)  This seems like it is actually a bug because it doesn't report why it's throwing out the connection, and it doesn't tell freeswitch to close the stream.  It took me forever to figure out what was going on.  


On Mon, Jul 14, 2014 at 9:22 AM, Ben Langfeld <[hidden email]> wrote:
Did you get this sorted out in the end, Dave?


On 8 July 2014 11:25, Ben Klang <[hidden email]> wrote:
If Adhearsion isn’t printing any additional logs, then I guess the socket is being closed.

Some things to check:

1) The XMPP username (including the Rayo domain) match between FreeSWITCH and Adhearsion.  For FreeSWITCH look for the config file autoload_configs/rayo.conf.xml and vars.conf.xml.  With XMPP you don’t strictly need to configure the host IP in Adhearsion if your XMPP domain is valid/resolvable.

2) The FreeSWITCH logs. Please gist those (https://gist.github.com) so we can review what FreeSWITCH is reporting

/BAK/
-- 
Ben Klang
Principal/Technology Strategist, Mojo Lingo
<a href="tel:%2B1.404.475.4841" value="+14044754841" target="_blank">+1.404.475.4841

Mojo Lingo -- Voice applications that work like magic
Twitter: @MojoLingo

Il giorno Jul 8, 2014, alle ore 12:03 AM, Dave Dolan <[hidden email]> ha scritto:

First of all, thanks for reading this and helping me out.

Just an update: I have the same results on FreeSwitch 1.2 stable tarball installation. So the bleeding edge apparently isn't what caused this issue with Adhearsion.  I'm curious because of the previous comment that there was something that you expected to see in the ahn logs immediately after the disconnect. It was in trace mode, and I pasted everything (it was a complete log file, just very short.)  What should I be looking for, and is there another setting I can do to crank up the logging some more than Trace?


On Mon, Jul 7, 2014 at 3:02 PM, Dave Dolan <[hidden email]> wrote:
For ik: FreeSWITCH Version 1.5.13b+git~20140628T181125Z~c3798dbb02~64bit

It doesn't say anything else in the ahn logs. that's what I get and it starts connecting again, repeating the exact same thing except incrementing the number for the retry.  I cleared the logs, started up ahn, and pasted it to you.  I'll do it again:

[2014-07-07 18:57:38.782] INFO  Adhearsion::Initializer: Setting RAILS_ENV to "development"
[2014-07-07 18:57:39.209] INFO  Adhearsion::Console: Launching Adhearsion Console
[2014-07-07 18:57:39.328] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 18:57:50.120] DEBUG Adhearsion::Initializer: Received SIGALRM. Toggling trace logging.
[2014-07-07 18:57:50.129] WARN  Adhearsion::Logging: Turning TRACE logging ON.
[2014-07-07 18:58:39.412] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 1 of Infinity
[2014-07-07 18:58:44.416] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 18:58:44.420] TRACE Punchblock::Connection::XMPP: USING JID: usera@localhost/phone1.my-server.com-18058
[2014-07-07 18:58:44.424] TRACE Punchblock::Connection::XMPP: SENDING: (/home/metacodemin/apps/aucp_phone/shared/bundle/jruby/1.9/gems/blather-1.0.0/lib/blather/stream/client.rb:12:in `start') <stream:stream to='localhost' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' version='1.0' xml:lang='en'>
[2014-07-07 18:58:44.434] TRACE Punchblock::Connection::XMPP: RECEIVING (stream) <stream:stream from="localhost" id="67a7703d-bb9e-4b3a-97a8-451e9e680eec" lang="en" version="1.0" xmlns:db="jabber:server:dialback" xmlns:stream="http://etherx.jabber.org/streams"/>
[2014-07-07 18:58:44.439] TRACE Punchblock::Connection::XMPP: RECEIVING (features) <stream:features xmlns:stream="http://etherx.jabber.org/streams"><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>PLAIN</mechanism></mechanisms></stream:features>
[2014-07-07 18:59:44.474] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 2 of Infinity
[2014-07-07 18:59:49.477] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 18:59:49.480] TRACE Punchblock::Connection::XMPP: USING JID: usera@localhost/phone1.my-server.com-18058
[2014-07-07 18:59:49.485] TRACE Punchblock::Connection::XMPP: SENDING: (/home/metacodemin/apps/aucp_phone/shared/bundle/jruby/1.9/gems/blather-1.0.0/lib/blather/stream/client.rb:12:in `start') <stream:stream to='localhost' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' version='1.0' xml:lang='en'>
[2014-07-07 18:59:49.497] TRACE Punchblock::Connection::XMPP: RECEIVING (stream) <stream:stream from="localhost" id="662ab4c3-fc84-43be-9422-6b172039f7fb" lang="en" version="1.0" xmlns:db="jabber:server:dialback" xmlns:stream="http://etherx.jabber.org/streams"/>
[2014-07-07 18:59:49.504] TRACE Punchblock::Connection::XMPP: RECEIVING (features) <stream:features xmlns:stream="http://etherx.jabber.org/streams"><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>PLAIN</mechanism></mechanisms></stream:features>

I notice after the second retry, when I look in the freeswitch "rayo status" I see the first stream is still there and another one appeared:

ENTITIES
        TYPE='CLIENT',SUBTYPE='',ID='cdd02294-7c25-463e-9b21-a40f8e0ad375@localhost/console',JID='cdd02294-7c25-463e-9b21-a40f8e0ad375@localhost/console',DOMAIN='localhost',REFS=1,STATUS='OFFLINE'
        TYPE='SERVER',SUBTYPE='',ID='localhost',JID='localhost',DOMAIN='localhost',REFS=1

ACTIVE STREAMS
        TYPE='c2s_in',ID='6999fdfe-01ce-4a3c-bdbb-9829369b5881',JID='',REMOTE_ADDRESS='127.0.0.1',REMOTE_PORT=41437,STATE='SECURE'
        TYPE='c2s_in',ID='67a7703d-bb9e-4b3a-97a8-451e9e680eec',JID='',REMOTE_ADDRESS='127.0.0.1',REMOTE_PORT=41438,STATE='SECURE'

freeswitch@internal>




On Mon, Jul 7, 2014 at 2:14 PM, Ben Langfeld <[hidden email]> wrote:
You've provided Adhearsion logs right up until the part before something useful is said about why the connection fails.

As for the FreeSWITCH console showing an active connection, all its really showing is that a socket is open, and not that authentication completed. Most likely, authentication is failing, but to be sure you need to provide us with a complete log instead of cutting it short.


On 7 July 2014 15:10, ik <[hidden email]> wrote:
You have lost the connection to freeswitch at:


[2014-07-07 16:58:33.249] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 1 of Infinity

what versuin if freeswitch, and what is the rayo binded to ?


On Mon, Jul 7, 2014 at 8:02 PM, Dave Dolan <[hidden email]> wrote:
I am not 100% sure if this is a freeswitch or adhearsion issue, but I think it is adhearsion because it appears as though it's just not responding as a rayo client should.  

on the freeswitch side (which I think is ok)

ENTITIES
        TYPE='CLIENT',SUBTYPE='',ID='4dda87bb-c053-4d72-b7fa-3ad816d008e1@localhost/console',JID='4dda87bb-c053-4d72-b7fa-3ad816d008e1@localhost/console',DOMAIN='localhost',REFS=1,STATUS='OFFLINE'
        TYPE='SERVER',SUBTYPE='',ID='localhost',JID='localhost',DOMAIN='localhost',REFS=1

ACTIVE STREAMS
        TYPE='c2s_in',ID='23738217-69a1-409c-a1b9-3a7b8fc728f5',JID='',REMOTE_ADDRESS='127.0.0.1',REMOTE_PORT=39208,STATE='SECURE'   

The Active stream is my adhearsion app

on the ahn side:

[2014-07-07 16:57:32.493] INFO  Adhearsion::Initializer: Setting RAILS_ENV to "development"
[2014-07-07 16:57:32.881] INFO  Adhearsion::Console: Launching Adhearsion Console
AHN> [2014-07-07 16:57:33.006] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
AHN>
AHN> [2014-07-07 16:58:10.301] DEBUG Adhearsion::Initializer: Received SIGALRM. Toggling trace logging.
[2014-07-07 16:58:10.307] WARN  Adhearsion::Logging: Turning TRACE logging ON.
[2014-07-07 16:58:33.249] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 1 of Infinity
[2014-07-07 16:58:38.251] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 16:58:38.609] TRACE Punchblock::Connection::XMPP: USING JID: usera@localhost/phone1.mydomain.com-16876
[2014-07-07 16:58:38.612] TRACE Punchblock::Connection::XMPP: SENDING: (/home/metacodemin/apps/aucp_phone/shared/bundle/jruby/1.9/gems/blather-1.0.0/lib/blather/stream/client.rb:12:in `start') <stream:stream to='localhost' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' version='1.0' xml:lang='en'>
[2014-07-07 16:58:38.620] TRACE Punchblock::Connection::XMPP: RECEIVING (stream) <stream:stream from="localhost" id="11d2a60c-9a67-478d-b14e-8965f6a40665" lang="en" version="1.0" xmlns:db="jabber:server:dialback" xmlns:stream="http://etherx.jabber.org/streams"/>
[2014-07-07 16:58:38.628] TRACE Punchblock::Connection::XMPP: RECEIVING (features) <stream:features xmlns:stream="http://etherx.jabber.org/streams"><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>PLAIN</mechanism></mechanisms></stream:features>

I get basically an infinite number of retries to connect, even though it looks like it's got a connection on the freeswitch side.

config.punchblock.platform = :xmpp # Use FreeSWITCH
config.punchblock.username = "usera@localhost"
config.punchblock.password =  "1"


Am I missing something?  Is there a way to get more detailed errors? 



--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.


--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.


--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.



--
---------------------------------------------------------------
Dave Dolan
http://davedolan.com/blog



--
---------------------------------------------------------------
Dave Dolan
http://davedolan.com/blog

--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.


--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.



--
---------------------------------------------------------------
Dave Dolan
http://davedolan.com/blog



--
---------------------------------------------------------------
Dave Dolan
http://davedolan.com/blog

--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.

--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.



--
---------------------------------------------------------------
Dave Dolan
http://davedolan.com/blog

--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.
Reply | Threaded
Open this post in threaded view
|

Re: AHN creates stream on freeswitch mod_rayo, but AHN won't pick up call

Christopher Rienzo
In reply to this post by Ben Langfeld-2
Open a ticket in jira.freeswitch.org and I can look at it.  I missed the e-mail on the freeswitch mailing list.


On Mon, Jul 14, 2014 at 9:36 AM, Ben Langfeld <[hidden email]> wrote:
By "Provider" I assume you mean a SIP trunk. Adhearsion doesn't know anything about your SIP trunk, and you got nowhere near the stage of handling calls. I think your diagnosis is wrong, here. This is purely a mod_rayo issue.

Whatever it really was, glad you got it sorted :)


On 14 July 2014 10:32, Dave Dolan <[hidden email]> wrote:
And thank you very much Ben for following up with me!


On Mon, Jul 14, 2014 at 9:30 AM, Dave Dolan <[hidden email]> wrote:
I was going to reply today actually! As it turns out, Adhearsion was dumping the connection every time it tried to register or answer a call because the provider configuration was wrong - only slightly.  It would authenticate to the provider, but it would refuse the calls, and it wasn't registered quite right.  Freeswitch would keep the stream open though and it eventually reached the open files limit and crashed the server.  I posted a thread in the freeswitch list about how to configure net2phone for for freeswitch (the provider I'm using.)  This seems like it is actually a bug because it doesn't report why it's throwing out the connection, and it doesn't tell freeswitch to close the stream.  It took me forever to figure out what was going on.  


On Mon, Jul 14, 2014 at 9:22 AM, Ben Langfeld <[hidden email]> wrote:
Did you get this sorted out in the end, Dave?


On 8 July 2014 11:25, Ben Klang <[hidden email]> wrote:
If Adhearsion isn’t printing any additional logs, then I guess the socket is being closed.

Some things to check:

1) The XMPP username (including the Rayo domain) match between FreeSWITCH and Adhearsion.  For FreeSWITCH look for the config file autoload_configs/rayo.conf.xml and vars.conf.xml.  With XMPP you don’t strictly need to configure the host IP in Adhearsion if your XMPP domain is valid/resolvable.

2) The FreeSWITCH logs. Please gist those (https://gist.github.com) so we can review what FreeSWITCH is reporting

/BAK/
-- 
Ben Klang
Principal/Technology Strategist, Mojo Lingo
<a href="tel:%2B1.404.475.4841" value="+14044754841" target="_blank">+1.404.475.4841

Mojo Lingo -- Voice applications that work like magic
Twitter: @MojoLingo

Il giorno Jul 8, 2014, alle ore 12:03 AM, Dave Dolan <[hidden email]> ha scritto:

First of all, thanks for reading this and helping me out.

Just an update: I have the same results on FreeSwitch 1.2 stable tarball installation. So the bleeding edge apparently isn't what caused this issue with Adhearsion.  I'm curious because of the previous comment that there was something that you expected to see in the ahn logs immediately after the disconnect. It was in trace mode, and I pasted everything (it was a complete log file, just very short.)  What should I be looking for, and is there another setting I can do to crank up the logging some more than Trace?


On Mon, Jul 7, 2014 at 3:02 PM, Dave Dolan <[hidden email]> wrote:
For ik: FreeSWITCH Version 1.5.13b+git~20140628T181125Z~c3798dbb02~64bit

It doesn't say anything else in the ahn logs. that's what I get and it starts connecting again, repeating the exact same thing except incrementing the number for the retry.  I cleared the logs, started up ahn, and pasted it to you.  I'll do it again:

[2014-07-07 18:57:38.782] INFO  Adhearsion::Initializer: Setting RAILS_ENV to "development"
[2014-07-07 18:57:39.209] INFO  Adhearsion::Console: Launching Adhearsion Console
[2014-07-07 18:57:39.328] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 18:57:50.120] DEBUG Adhearsion::Initializer: Received SIGALRM. Toggling trace logging.
[2014-07-07 18:57:50.129] WARN  Adhearsion::Logging: Turning TRACE logging ON.
[2014-07-07 18:58:39.412] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 1 of Infinity
[2014-07-07 18:58:44.416] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 18:58:44.420] TRACE Punchblock::Connection::XMPP: USING JID: usera@localhost/phone1.my-server.com-18058
[2014-07-07 18:58:44.424] TRACE Punchblock::Connection::XMPP: SENDING: (/home/metacodemin/apps/aucp_phone/shared/bundle/jruby/1.9/gems/blather-1.0.0/lib/blather/stream/client.rb:12:in `start') <stream:stream to='localhost' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' version='1.0' xml:lang='en'>
[2014-07-07 18:58:44.434] TRACE Punchblock::Connection::XMPP: RECEIVING (stream) <stream:stream from="localhost" id="67a7703d-bb9e-4b3a-97a8-451e9e680eec" lang="en" version="1.0" xmlns:db="jabber:server:dialback" xmlns:stream="http://etherx.jabber.org/streams"/>
[2014-07-07 18:58:44.439] TRACE Punchblock::Connection::XMPP: RECEIVING (features) <stream:features xmlns:stream="http://etherx.jabber.org/streams"><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>PLAIN</mechanism></mechanisms></stream:features>
[2014-07-07 18:59:44.474] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 2 of Infinity
[2014-07-07 18:59:49.477] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 18:59:49.480] TRACE Punchblock::Connection::XMPP: USING JID: usera@localhost/phone1.my-server.com-18058
[2014-07-07 18:59:49.485] TRACE Punchblock::Connection::XMPP: SENDING: (/home/metacodemin/apps/aucp_phone/shared/bundle/jruby/1.9/gems/blather-1.0.0/lib/blather/stream/client.rb:12:in `start') <stream:stream to='localhost' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' version='1.0' xml:lang='en'>
[2014-07-07 18:59:49.497] TRACE Punchblock::Connection::XMPP: RECEIVING (stream) <stream:stream from="localhost" id="662ab4c3-fc84-43be-9422-6b172039f7fb" lang="en" version="1.0" xmlns:db="jabber:server:dialback" xmlns:stream="http://etherx.jabber.org/streams"/>
[2014-07-07 18:59:49.504] TRACE Punchblock::Connection::XMPP: RECEIVING (features) <stream:features xmlns:stream="http://etherx.jabber.org/streams"><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>PLAIN</mechanism></mechanisms></stream:features>

I notice after the second retry, when I look in the freeswitch "rayo status" I see the first stream is still there and another one appeared:

ENTITIES
        TYPE='CLIENT',SUBTYPE='',ID='cdd02294-7c25-463e-9b21-a40f8e0ad375@localhost/console',JID='cdd02294-7c25-463e-9b21-a40f8e0ad375@localhost/console',DOMAIN='localhost',REFS=1,STATUS='OFFLINE'
        TYPE='SERVER',SUBTYPE='',ID='localhost',JID='localhost',DOMAIN='localhost',REFS=1

ACTIVE STREAMS
        TYPE='c2s_in',ID='6999fdfe-01ce-4a3c-bdbb-9829369b5881',JID='',REMOTE_ADDRESS='127.0.0.1',REMOTE_PORT=41437,STATE='SECURE'
        TYPE='c2s_in',ID='67a7703d-bb9e-4b3a-97a8-451e9e680eec',JID='',REMOTE_ADDRESS='127.0.0.1',REMOTE_PORT=41438,STATE='SECURE'

freeswitch@internal>




On Mon, Jul 7, 2014 at 2:14 PM, Ben Langfeld <[hidden email]> wrote:
You've provided Adhearsion logs right up until the part before something useful is said about why the connection fails.

As for the FreeSWITCH console showing an active connection, all its really showing is that a socket is open, and not that authentication completed. Most likely, authentication is failing, but to be sure you need to provide us with a complete log instead of cutting it short.


On 7 July 2014 15:10, ik <[hidden email]> wrote:
You have lost the connection to freeswitch at:


[2014-07-07 16:58:33.249] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 1 of Infinity

what versuin if freeswitch, and what is the rayo binded to ?


On Mon, Jul 7, 2014 at 8:02 PM, Dave Dolan <[hidden email]> wrote:
I am not 100% sure if this is a freeswitch or adhearsion issue, but I think it is adhearsion because it appears as though it's just not responding as a rayo client should.  

on the freeswitch side (which I think is ok)

ENTITIES
        TYPE='CLIENT',SUBTYPE='',ID='4dda87bb-c053-4d72-b7fa-3ad816d008e1@localhost/console',JID='4dda87bb-c053-4d72-b7fa-3ad816d008e1@localhost/console',DOMAIN='localhost',REFS=1,STATUS='OFFLINE'
        TYPE='SERVER',SUBTYPE='',ID='localhost',JID='localhost',DOMAIN='localhost',REFS=1

ACTIVE STREAMS
        TYPE='c2s_in',ID='23738217-69a1-409c-a1b9-3a7b8fc728f5',JID='',REMOTE_ADDRESS='127.0.0.1',REMOTE_PORT=39208,STATE='SECURE'   

The Active stream is my adhearsion app

on the ahn side:

[2014-07-07 16:57:32.493] INFO  Adhearsion::Initializer: Setting RAILS_ENV to "development"
[2014-07-07 16:57:32.881] INFO  Adhearsion::Console: Launching Adhearsion Console
AHN> [2014-07-07 16:57:33.006] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
AHN>
AHN> [2014-07-07 16:58:10.301] DEBUG Adhearsion::Initializer: Received SIGALRM. Toggling trace logging.
[2014-07-07 16:58:10.307] WARN  Adhearsion::Logging: Turning TRACE logging ON.
[2014-07-07 16:58:33.249] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 1 of Infinity
[2014-07-07 16:58:38.251] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 16:58:38.609] TRACE Punchblock::Connection::XMPP: USING JID: usera@localhost/phone1.mydomain.com-16876
[2014-07-07 16:58:38.612] TRACE Punchblock::Connection::XMPP: SENDING: (/home/metacodemin/apps/aucp_phone/shared/bundle/jruby/1.9/gems/blather-1.0.0/lib/blather/stream/client.rb:12:in `start') <stream:stream to='localhost' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' version='1.0' xml:lang='en'>
[2014-07-07 16:58:38.620] TRACE Punchblock::Connection::XMPP: RECEIVING (stream) <stream:stream from="localhost" id="11d2a60c-9a67-478d-b14e-8965f6a40665" lang="en" version="1.0" xmlns:db="jabber:server:dialback" xmlns:stream="http://etherx.jabber.org/streams"/>
[2014-07-07 16:58:38.628] TRACE Punchblock::Connection::XMPP: RECEIVING (features) <stream:features xmlns:stream="http://etherx.jabber.org/streams"><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>PLAIN</mechanism></mechanisms></stream:features>

I get basically an infinite number of retries to connect, even though it looks like it's got a connection on the freeswitch side.

config.punchblock.platform = :xmpp # Use FreeSWITCH
config.punchblock.username = "usera@localhost"
config.punchblock.password =  "1"


Am I missing something?  Is there a way to get more detailed errors? 



--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.


--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.


--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.



--
---------------------------------------------------------------
Dave Dolan
http://davedolan.com/blog



--
---------------------------------------------------------------
Dave Dolan
http://davedolan.com/blog

--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.


--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.



--
---------------------------------------------------------------
Dave Dolan
http://davedolan.com/blog



--
---------------------------------------------------------------
Dave Dolan
http://davedolan.com/blog

--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.

--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.

--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.
Reply | Threaded
Open this post in threaded view
|

Re: AHN creates stream on freeswitch mod_rayo, but AHN won't pick up call

Ben Langfeld-2
In reply to this post by Dave Dolan
I don't know why the connection failed, but the last post here requested further details particularly from the FreeSWITCH side; these were precisely to help determine the problem ;) I know that the log output you saw in Adhearsion was unhelpful, but I need to first fully understand the issue in order to figure out how to make Adhearsion's output more useful in this situation, since I've never encountered it myself before.


On 14 July 2014 10:42, Dave Dolan <[hidden email]> wrote:
Ok, so why was the connection being lost from the Adhearsion side?  Mod_rayo still had the stream open, and created a new one every reconnect attempt. And the disconnects did happen every 30 seconds or so when the sip trunk gateway was set to reregister at 30 second intervals.  I can't tell from the logs in adhearsion who caused punchblock to lose the connection, mod_rayo, or adhearsion.  It is maybe not a bug, but very unhelpful, not to know if the server caused the lost connection, or if it was punchblock that decided to dump it.


On Mon, Jul 14, 2014 at 9:36 AM, Ben Langfeld <[hidden email]> wrote:
By "Provider" I assume you mean a SIP trunk. Adhearsion doesn't know anything about your SIP trunk, and you got nowhere near the stage of handling calls. I think your diagnosis is wrong, here. This is purely a mod_rayo issue.

Whatever it really was, glad you got it sorted :)


On 14 July 2014 10:32, Dave Dolan <[hidden email]> wrote:
And thank you very much Ben for following up with me!


On Mon, Jul 14, 2014 at 9:30 AM, Dave Dolan <[hidden email]> wrote:
I was going to reply today actually! As it turns out, Adhearsion was dumping the connection every time it tried to register or answer a call because the provider configuration was wrong - only slightly.  It would authenticate to the provider, but it would refuse the calls, and it wasn't registered quite right.  Freeswitch would keep the stream open though and it eventually reached the open files limit and crashed the server.  I posted a thread in the freeswitch list about how to configure net2phone for for freeswitch (the provider I'm using.)  This seems like it is actually a bug because it doesn't report why it's throwing out the connection, and it doesn't tell freeswitch to close the stream.  It took me forever to figure out what was going on.  


On Mon, Jul 14, 2014 at 9:22 AM, Ben Langfeld <[hidden email]> wrote:
Did you get this sorted out in the end, Dave?


On 8 July 2014 11:25, Ben Klang <[hidden email]> wrote:
If Adhearsion isn’t printing any additional logs, then I guess the socket is being closed.

Some things to check:

1) The XMPP username (including the Rayo domain) match between FreeSWITCH and Adhearsion.  For FreeSWITCH look for the config file autoload_configs/rayo.conf.xml and vars.conf.xml.  With XMPP you don’t strictly need to configure the host IP in Adhearsion if your XMPP domain is valid/resolvable.

2) The FreeSWITCH logs. Please gist those (https://gist.github.com) so we can review what FreeSWITCH is reporting

/BAK/
-- 
Ben Klang
Principal/Technology Strategist, Mojo Lingo
<a href="tel:%2B1.404.475.4841" value="+14044754841" target="_blank">+1.404.475.4841

Mojo Lingo -- Voice applications that work like magic
Twitter: @MojoLingo

Il giorno Jul 8, 2014, alle ore 12:03 AM, Dave Dolan <[hidden email]> ha scritto:

First of all, thanks for reading this and helping me out.

Just an update: I have the same results on FreeSwitch 1.2 stable tarball installation. So the bleeding edge apparently isn't what caused this issue with Adhearsion.  I'm curious because of the previous comment that there was something that you expected to see in the ahn logs immediately after the disconnect. It was in trace mode, and I pasted everything (it was a complete log file, just very short.)  What should I be looking for, and is there another setting I can do to crank up the logging some more than Trace?


On Mon, Jul 7, 2014 at 3:02 PM, Dave Dolan <[hidden email]> wrote:
For ik: FreeSWITCH Version 1.5.13b+git~20140628T181125Z~c3798dbb02~64bit

It doesn't say anything else in the ahn logs. that's what I get and it starts connecting again, repeating the exact same thing except incrementing the number for the retry.  I cleared the logs, started up ahn, and pasted it to you.  I'll do it again:

[2014-07-07 18:57:38.782] INFO  Adhearsion::Initializer: Setting RAILS_ENV to "development"
[2014-07-07 18:57:39.209] INFO  Adhearsion::Console: Launching Adhearsion Console
[2014-07-07 18:57:39.328] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 18:57:50.120] DEBUG Adhearsion::Initializer: Received SIGALRM. Toggling trace logging.
[2014-07-07 18:57:50.129] WARN  Adhearsion::Logging: Turning TRACE logging ON.
[2014-07-07 18:58:39.412] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 1 of Infinity
[2014-07-07 18:58:44.416] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 18:58:44.420] TRACE Punchblock::Connection::XMPP: USING JID: usera@localhost/phone1.my-server.com-18058
[2014-07-07 18:58:44.424] TRACE Punchblock::Connection::XMPP: SENDING: (/home/metacodemin/apps/aucp_phone/shared/bundle/jruby/1.9/gems/blather-1.0.0/lib/blather/stream/client.rb:12:in `start') <stream:stream to='localhost' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' version='1.0' xml:lang='en'>
[2014-07-07 18:58:44.434] TRACE Punchblock::Connection::XMPP: RECEIVING (stream) <stream:stream from="localhost" id="67a7703d-bb9e-4b3a-97a8-451e9e680eec" lang="en" version="1.0" xmlns:db="jabber:server:dialback" xmlns:stream="http://etherx.jabber.org/streams"/>
[2014-07-07 18:58:44.439] TRACE Punchblock::Connection::XMPP: RECEIVING (features) <stream:features xmlns:stream="http://etherx.jabber.org/streams"><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>PLAIN</mechanism></mechanisms></stream:features>
[2014-07-07 18:59:44.474] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 2 of Infinity
[2014-07-07 18:59:49.477] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 18:59:49.480] TRACE Punchblock::Connection::XMPP: USING JID: usera@localhost/phone1.my-server.com-18058
[2014-07-07 18:59:49.485] TRACE Punchblock::Connection::XMPP: SENDING: (/home/metacodemin/apps/aucp_phone/shared/bundle/jruby/1.9/gems/blather-1.0.0/lib/blather/stream/client.rb:12:in `start') <stream:stream to='localhost' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' version='1.0' xml:lang='en'>
[2014-07-07 18:59:49.497] TRACE Punchblock::Connection::XMPP: RECEIVING (stream) <stream:stream from="localhost" id="662ab4c3-fc84-43be-9422-6b172039f7fb" lang="en" version="1.0" xmlns:db="jabber:server:dialback" xmlns:stream="http://etherx.jabber.org/streams"/>
[2014-07-07 18:59:49.504] TRACE Punchblock::Connection::XMPP: RECEIVING (features) <stream:features xmlns:stream="http://etherx.jabber.org/streams"><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>PLAIN</mechanism></mechanisms></stream:features>

I notice after the second retry, when I look in the freeswitch "rayo status" I see the first stream is still there and another one appeared:

ENTITIES
        TYPE='CLIENT',SUBTYPE='',ID='cdd02294-7c25-463e-9b21-a40f8e0ad375@localhost/console',JID='cdd02294-7c25-463e-9b21-a40f8e0ad375@localhost/console',DOMAIN='localhost',REFS=1,STATUS='OFFLINE'
        TYPE='SERVER',SUBTYPE='',ID='localhost',JID='localhost',DOMAIN='localhost',REFS=1

ACTIVE STREAMS
        TYPE='c2s_in',ID='6999fdfe-01ce-4a3c-bdbb-9829369b5881',JID='',REMOTE_ADDRESS='127.0.0.1',REMOTE_PORT=41437,STATE='SECURE'
        TYPE='c2s_in',ID='67a7703d-bb9e-4b3a-97a8-451e9e680eec',JID='',REMOTE_ADDRESS='127.0.0.1',REMOTE_PORT=41438,STATE='SECURE'

freeswitch@internal>




On Mon, Jul 7, 2014 at 2:14 PM, Ben Langfeld <[hidden email]> wrote:
You've provided Adhearsion logs right up until the part before something useful is said about why the connection fails.

As for the FreeSWITCH console showing an active connection, all its really showing is that a socket is open, and not that authentication completed. Most likely, authentication is failing, but to be sure you need to provide us with a complete log instead of cutting it short.


On 7 July 2014 15:10, ik <[hidden email]> wrote:
You have lost the connection to freeswitch at:


[2014-07-07 16:58:33.249] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 1 of Infinity

what versuin if freeswitch, and what is the rayo binded to ?


On Mon, Jul 7, 2014 at 8:02 PM, Dave Dolan <[hidden email]> wrote:
I am not 100% sure if this is a freeswitch or adhearsion issue, but I think it is adhearsion because it appears as though it's just not responding as a rayo client should.  

on the freeswitch side (which I think is ok)

ENTITIES
        TYPE='CLIENT',SUBTYPE='',ID='4dda87bb-c053-4d72-b7fa-3ad816d008e1@localhost/console',JID='4dda87bb-c053-4d72-b7fa-3ad816d008e1@localhost/console',DOMAIN='localhost',REFS=1,STATUS='OFFLINE'
        TYPE='SERVER',SUBTYPE='',ID='localhost',JID='localhost',DOMAIN='localhost',REFS=1

ACTIVE STREAMS
        TYPE='c2s_in',ID='23738217-69a1-409c-a1b9-3a7b8fc728f5',JID='',REMOTE_ADDRESS='127.0.0.1',REMOTE_PORT=39208,STATE='SECURE'   

The Active stream is my adhearsion app

on the ahn side:

[2014-07-07 16:57:32.493] INFO  Adhearsion::Initializer: Setting RAILS_ENV to "development"
[2014-07-07 16:57:32.881] INFO  Adhearsion::Console: Launching Adhearsion Console
AHN> [2014-07-07 16:57:33.006] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
AHN>
AHN> [2014-07-07 16:58:10.301] DEBUG Adhearsion::Initializer: Received SIGALRM. Toggling trace logging.
[2014-07-07 16:58:10.307] WARN  Adhearsion::Logging: Turning TRACE logging ON.
[2014-07-07 16:58:33.249] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 1 of Infinity
[2014-07-07 16:58:38.251] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 16:58:38.609] TRACE Punchblock::Connection::XMPP: USING JID: usera@localhost/phone1.mydomain.com-16876
[2014-07-07 16:58:38.612] TRACE Punchblock::Connection::XMPP: SENDING: (/home/metacodemin/apps/aucp_phone/shared/bundle/jruby/1.9/gems/blather-1.0.0/lib/blather/stream/client.rb:12:in `start') <stream:stream to='localhost' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' version='1.0' xml:lang='en'>
[2014-07-07 16:58:38.620] TRACE Punchblock::Connection::XMPP: RECEIVING (stream) <stream:stream from="localhost" id="11d2a60c-9a67-478d-b14e-8965f6a40665" lang="en" version="1.0" xmlns:db="jabber:server:dialback" xmlns:stream="http://etherx.jabber.org/streams"/>
[2014-07-07 16:58:38.628] TRACE Punchblock::Connection::XMPP: RECEIVING (features) <stream:features xmlns:stream="http://etherx.jabber.org/streams"><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>PLAIN</mechanism></mechanisms></stream:features>

I get basically an infinite number of retries to connect, even though it looks like it's got a connection on the freeswitch side.

config.punchblock.platform = :xmpp # Use FreeSWITCH
config.punchblock.username = "usera@localhost"
config.punchblock.password =  "1"


Am I missing something?  Is there a way to get more detailed errors? 



--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.


--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.


--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.



--
---------------------------------------------------------------
Dave Dolan
http://davedolan.com/blog



--
---------------------------------------------------------------
Dave Dolan
http://davedolan.com/blog

--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.


--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.



--
---------------------------------------------------------------
Dave Dolan
http://davedolan.com/blog



--
---------------------------------------------------------------
Dave Dolan
http://davedolan.com/blog

--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.

--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.



--
---------------------------------------------------------------
Dave Dolan
http://davedolan.com/blog

--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.

--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.
Reply | Threaded
Open this post in threaded view
|

Re: AHN creates stream on freeswitch mod_rayo, but AHN won't pick up call

Ben Langfeld-2
As for the 30s reconnect timer: there is absolutely no way for this to have been triggered by a SIP trunk in Adhearsion. Perhaps there is something in mod_rayo that might cause it to drop a Rayo connection for this reason, but it's *highly* unlikely. I think you're confusing coincidence with causality. More likely what you saw is Adhearsion's (by default 60s) connection timeout firing.


On 14 July 2014 11:07, Ben Langfeld <[hidden email]> wrote:
I don't know why the connection failed, but the last post here requested further details particularly from the FreeSWITCH side; these were precisely to help determine the problem ;) I know that the log output you saw in Adhearsion was unhelpful, but I need to first fully understand the issue in order to figure out how to make Adhearsion's output more useful in this situation, since I've never encountered it myself before.


On 14 July 2014 10:42, Dave Dolan <[hidden email]> wrote:
Ok, so why was the connection being lost from the Adhearsion side?  Mod_rayo still had the stream open, and created a new one every reconnect attempt. And the disconnects did happen every 30 seconds or so when the sip trunk gateway was set to reregister at 30 second intervals.  I can't tell from the logs in adhearsion who caused punchblock to lose the connection, mod_rayo, or adhearsion.  It is maybe not a bug, but very unhelpful, not to know if the server caused the lost connection, or if it was punchblock that decided to dump it.


On Mon, Jul 14, 2014 at 9:36 AM, Ben Langfeld <[hidden email]> wrote:
By "Provider" I assume you mean a SIP trunk. Adhearsion doesn't know anything about your SIP trunk, and you got nowhere near the stage of handling calls. I think your diagnosis is wrong, here. This is purely a mod_rayo issue.

Whatever it really was, glad you got it sorted :)


On 14 July 2014 10:32, Dave Dolan <[hidden email]> wrote:
And thank you very much Ben for following up with me!


On Mon, Jul 14, 2014 at 9:30 AM, Dave Dolan <[hidden email]> wrote:
I was going to reply today actually! As it turns out, Adhearsion was dumping the connection every time it tried to register or answer a call because the provider configuration was wrong - only slightly.  It would authenticate to the provider, but it would refuse the calls, and it wasn't registered quite right.  Freeswitch would keep the stream open though and it eventually reached the open files limit and crashed the server.  I posted a thread in the freeswitch list about how to configure net2phone for for freeswitch (the provider I'm using.)  This seems like it is actually a bug because it doesn't report why it's throwing out the connection, and it doesn't tell freeswitch to close the stream.  It took me forever to figure out what was going on.  


On Mon, Jul 14, 2014 at 9:22 AM, Ben Langfeld <[hidden email]> wrote:
Did you get this sorted out in the end, Dave?


On 8 July 2014 11:25, Ben Klang <[hidden email]> wrote:
If Adhearsion isn’t printing any additional logs, then I guess the socket is being closed.

Some things to check:

1) The XMPP username (including the Rayo domain) match between FreeSWITCH and Adhearsion.  For FreeSWITCH look for the config file autoload_configs/rayo.conf.xml and vars.conf.xml.  With XMPP you don’t strictly need to configure the host IP in Adhearsion if your XMPP domain is valid/resolvable.

2) The FreeSWITCH logs. Please gist those (https://gist.github.com) so we can review what FreeSWITCH is reporting

/BAK/
-- 
Ben Klang
Principal/Technology Strategist, Mojo Lingo
<a href="tel:%2B1.404.475.4841" value="+14044754841" target="_blank">+1.404.475.4841

Mojo Lingo -- Voice applications that work like magic
Twitter: @MojoLingo

Il giorno Jul 8, 2014, alle ore 12:03 AM, Dave Dolan <[hidden email]> ha scritto:

First of all, thanks for reading this and helping me out.

Just an update: I have the same results on FreeSwitch 1.2 stable tarball installation. So the bleeding edge apparently isn't what caused this issue with Adhearsion.  I'm curious because of the previous comment that there was something that you expected to see in the ahn logs immediately after the disconnect. It was in trace mode, and I pasted everything (it was a complete log file, just very short.)  What should I be looking for, and is there another setting I can do to crank up the logging some more than Trace?


On Mon, Jul 7, 2014 at 3:02 PM, Dave Dolan <[hidden email]> wrote:
For ik: FreeSWITCH Version 1.5.13b+git~20140628T181125Z~c3798dbb02~64bit

It doesn't say anything else in the ahn logs. that's what I get and it starts connecting again, repeating the exact same thing except incrementing the number for the retry.  I cleared the logs, started up ahn, and pasted it to you.  I'll do it again:

[2014-07-07 18:57:38.782] INFO  Adhearsion::Initializer: Setting RAILS_ENV to "development"
[2014-07-07 18:57:39.209] INFO  Adhearsion::Console: Launching Adhearsion Console
[2014-07-07 18:57:39.328] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 18:57:50.120] DEBUG Adhearsion::Initializer: Received SIGALRM. Toggling trace logging.
[2014-07-07 18:57:50.129] WARN  Adhearsion::Logging: Turning TRACE logging ON.
[2014-07-07 18:58:39.412] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 1 of Infinity
[2014-07-07 18:58:44.416] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 18:58:44.420] TRACE Punchblock::Connection::XMPP: USING JID: usera@localhost/phone1.my-server.com-18058
[2014-07-07 18:58:44.424] TRACE Punchblock::Connection::XMPP: SENDING: (/home/metacodemin/apps/aucp_phone/shared/bundle/jruby/1.9/gems/blather-1.0.0/lib/blather/stream/client.rb:12:in `start') <stream:stream to='localhost' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' version='1.0' xml:lang='en'>
[2014-07-07 18:58:44.434] TRACE Punchblock::Connection::XMPP: RECEIVING (stream) <stream:stream from="localhost" id="67a7703d-bb9e-4b3a-97a8-451e9e680eec" lang="en" version="1.0" xmlns:db="jabber:server:dialback" xmlns:stream="http://etherx.jabber.org/streams"/>
[2014-07-07 18:58:44.439] TRACE Punchblock::Connection::XMPP: RECEIVING (features) <stream:features xmlns:stream="http://etherx.jabber.org/streams"><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>PLAIN</mechanism></mechanisms></stream:features>
[2014-07-07 18:59:44.474] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 2 of Infinity
[2014-07-07 18:59:49.477] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 18:59:49.480] TRACE Punchblock::Connection::XMPP: USING JID: usera@localhost/phone1.my-server.com-18058
[2014-07-07 18:59:49.485] TRACE Punchblock::Connection::XMPP: SENDING: (/home/metacodemin/apps/aucp_phone/shared/bundle/jruby/1.9/gems/blather-1.0.0/lib/blather/stream/client.rb:12:in `start') <stream:stream to='localhost' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' version='1.0' xml:lang='en'>
[2014-07-07 18:59:49.497] TRACE Punchblock::Connection::XMPP: RECEIVING (stream) <stream:stream from="localhost" id="662ab4c3-fc84-43be-9422-6b172039f7fb" lang="en" version="1.0" xmlns:db="jabber:server:dialback" xmlns:stream="http://etherx.jabber.org/streams"/>
[2014-07-07 18:59:49.504] TRACE Punchblock::Connection::XMPP: RECEIVING (features) <stream:features xmlns:stream="http://etherx.jabber.org/streams"><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>PLAIN</mechanism></mechanisms></stream:features>

I notice after the second retry, when I look in the freeswitch "rayo status" I see the first stream is still there and another one appeared:

ENTITIES
        TYPE='CLIENT',SUBTYPE='',ID='cdd02294-7c25-463e-9b21-a40f8e0ad375@localhost/console',JID='cdd02294-7c25-463e-9b21-a40f8e0ad375@localhost/console',DOMAIN='localhost',REFS=1,STATUS='OFFLINE'
        TYPE='SERVER',SUBTYPE='',ID='localhost',JID='localhost',DOMAIN='localhost',REFS=1

ACTIVE STREAMS
        TYPE='c2s_in',ID='6999fdfe-01ce-4a3c-bdbb-9829369b5881',JID='',REMOTE_ADDRESS='127.0.0.1',REMOTE_PORT=41437,STATE='SECURE'
        TYPE='c2s_in',ID='67a7703d-bb9e-4b3a-97a8-451e9e680eec',JID='',REMOTE_ADDRESS='127.0.0.1',REMOTE_PORT=41438,STATE='SECURE'

freeswitch@internal>




On Mon, Jul 7, 2014 at 2:14 PM, Ben Langfeld <[hidden email]> wrote:
You've provided Adhearsion logs right up until the part before something useful is said about why the connection fails.

As for the FreeSWITCH console showing an active connection, all its really showing is that a socket is open, and not that authentication completed. Most likely, authentication is failing, but to be sure you need to provide us with a complete log instead of cutting it short.


On 7 July 2014 15:10, ik <[hidden email]> wrote:
You have lost the connection to freeswitch at:


[2014-07-07 16:58:33.249] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 1 of Infinity

what versuin if freeswitch, and what is the rayo binded to ?


On Mon, Jul 7, 2014 at 8:02 PM, Dave Dolan <[hidden email]> wrote:
I am not 100% sure if this is a freeswitch or adhearsion issue, but I think it is adhearsion because it appears as though it's just not responding as a rayo client should.  

on the freeswitch side (which I think is ok)

ENTITIES
        TYPE='CLIENT',SUBTYPE='',ID='4dda87bb-c053-4d72-b7fa-3ad816d008e1@localhost/console',JID='4dda87bb-c053-4d72-b7fa-3ad816d008e1@localhost/console',DOMAIN='localhost',REFS=1,STATUS='OFFLINE'
        TYPE='SERVER',SUBTYPE='',ID='localhost',JID='localhost',DOMAIN='localhost',REFS=1

ACTIVE STREAMS
        TYPE='c2s_in',ID='23738217-69a1-409c-a1b9-3a7b8fc728f5',JID='',REMOTE_ADDRESS='127.0.0.1',REMOTE_PORT=39208,STATE='SECURE'   

The Active stream is my adhearsion app

on the ahn side:

[2014-07-07 16:57:32.493] INFO  Adhearsion::Initializer: Setting RAILS_ENV to "development"
[2014-07-07 16:57:32.881] INFO  Adhearsion::Console: Launching Adhearsion Console
AHN> [2014-07-07 16:57:33.006] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
AHN>
AHN> [2014-07-07 16:58:10.301] DEBUG Adhearsion::Initializer: Received SIGALRM. Toggling trace logging.
[2014-07-07 16:58:10.307] WARN  Adhearsion::Logging: Turning TRACE logging ON.
[2014-07-07 16:58:33.249] ERROR Adhearsion::PunchblockPlugin::Initializer: Connection lost. Attempting reconnect 1 of Infinity
[2014-07-07 16:58:38.251] INFO  Adhearsion::PunchblockPlugin::Initializer: Starting connection to server
[2014-07-07 16:58:38.609] TRACE Punchblock::Connection::XMPP: USING JID: usera@localhost/phone1.mydomain.com-16876
[2014-07-07 16:58:38.612] TRACE Punchblock::Connection::XMPP: SENDING: (/home/metacodemin/apps/aucp_phone/shared/bundle/jruby/1.9/gems/blather-1.0.0/lib/blather/stream/client.rb:12:in `start') <stream:stream to='localhost' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' version='1.0' xml:lang='en'>
[2014-07-07 16:58:38.620] TRACE Punchblock::Connection::XMPP: RECEIVING (stream) <stream:stream from="localhost" id="11d2a60c-9a67-478d-b14e-8965f6a40665" lang="en" version="1.0" xmlns:db="jabber:server:dialback" xmlns:stream="http://etherx.jabber.org/streams"/>
[2014-07-07 16:58:38.628] TRACE Punchblock::Connection::XMPP: RECEIVING (features) <stream:features xmlns:stream="http://etherx.jabber.org/streams"><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>PLAIN</mechanism></mechanisms></stream:features>

I get basically an infinite number of retries to connect, even though it looks like it's got a connection on the freeswitch side.

config.punchblock.platform = :xmpp # Use FreeSWITCH
config.punchblock.username = "usera@localhost"
config.punchblock.password =  "1"


Am I missing something?  Is there a way to get more detailed errors? 



--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.


--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.


--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.



--
---------------------------------------------------------------
Dave Dolan
http://davedolan.com/blog



--
---------------------------------------------------------------
Dave Dolan
http://davedolan.com/blog

--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.


--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.



--
---------------------------------------------------------------
Dave Dolan
http://davedolan.com/blog



--
---------------------------------------------------------------
Dave Dolan
http://davedolan.com/blog

--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.

--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.



--
---------------------------------------------------------------
Dave Dolan
http://davedolan.com/blog

--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.


--
You received this message because you are subscribed to the Google Groups "Adhearsion" group.
To unsubscribe from this group and stop receiving emails from it, send an email to [hidden email].
For more options, visit https://groups.google.com/d/optout.