search

tmakkonen / sipcmd

sipcmd
327 stars 108 forks source link

Problem Running Command Sequence #61

Open jh6r opened 5 years ago

jh6r commented 5 years ago

I have a local PBX on my Debian linux machine. I am attempting to test calls between the extensions. The call isn't going through, and it isn't obvious to me through the console, nor the logs, as to what is causing the call to fail. Below is the command I've used:

admin@ip-172-26-2-113:~/.local/lib/sipcmd-master$ ./sipcmd -P sip -u UID -c myPassword -w 127.0.0.1 -x "c0004;ws30;vclip"

So, I am attempting to use the loopback address to place a call. Both extensions are showing as registering, and when I dial 0004 on the phone client, it successfully makes the call, and everything seems to be working fine. However, when I try to do it through sipcmd, it fails, and I'm not certain why.

Here is the console's output (without the logs):

    Starting sipcmd
    in debug mode
    Manager
    Init
    initialising SIP endpoint...
    TestChanAudio
    TestChanAudio
    Listening for SIP signalling on 0.0.0.0:5060
    SIP listener up
    registered as sip:UID@127.0.0.1
    Created LocalEndPoint
    Main
    ## Call ##
    TestPhone::Main: calling "0004" using gateway "127.0.0.1" at Wed Mar 13 14:36:35 2019

    Setting up a call to: sip:0004@127.0.0.1
    LocalEndpoint::MakeConnection
    LocalEndpointCreateConnection
    LocalConnection
    OnIncomingConnection: token=L4e2c6dc42
    Call setup to sip:0004@127.0.0.1 failed
    Problem running command sequence ("c0004;ws30;vclip"):

    TestPhone::Main: shutting down
    OnReleased: reason: EndedByNoAccept
    OnReleased: reason: EndedByTransportFail
    OnClearedCall
    ~LocalConnection
    TestPhone::Main: exiting...
    Exiting...
    ~Manager

And the following are the logs when I used the -o flag:

    Starting sipcmd
    in debug mode
    Manager
    Init
    sipcmd: Could not open trace output file "/home/admin/.local/lib/sipcmd-master/~./call.log"  0:00.038                        sipcmd         Version 1.0.1 by Command line VoIP testphone on Unix Linux (4.9.0-8-amd64-x86_64) with PTLib (v2.10.11 (svn:30295)) at 2019/3/13 11:12:36.666
    initialising SIP endpoint...
      0:00.038                       sipcmd OpalMan Attached endpoint with prefix sip
      0:00.038                       sipcmd OpalEP  Created endpoint: sip
      0:00.039                       sipcmd PTLib   Created read/write mutex 0x55d893db4438
      0:00.039                       sipcmd PWLib   File handle high water mark set: 8 PUDPSocket
      0:00.039                       sipcmd IfaceMon        Initial interface list:
    127.0.0.1 <00-00-00-00-00-00> (lo)
    172.26.2.113 <02-D4-F5-4A-EF-8C> (eth0)

      0:00.040                       sipcmd PTLIB   Opened NetLink socket
      0:00.040                       sipcmd PWLib   File handle high water mark set: 15 Thread unblock pipe
      0:00.040                       sipcmd PTLib   Created thread 0x55d893db4910
      0:00.040                       sipcmd PTLib   Thread high water mark set: 3
      0:00.040                       sipcmd PTLib   Created read/write mutex 0x55d893db46b8
      0:00.040                       sipcmd PWLib   File handle high water mark set: 17 Thread unblock pipe
      0:00.041                       sipcmd PTLib   Created thread 0x55d893db4bc0 Housekeeper
      0:00.041                       sipcmd PTLib   No permission to set priority level 4
      0:00.041                       sipcmd PTLib   Thread high water mark set: 4
      0:00.041                       sipcmd OpalMan Attached endpoint with prefix sips
      0:00.042                       sipcmd SIP     Created endpoint.
      0:00.042                       sipcmd OpalMan Added route "local:.*=sip:<da>"
      0:00.042                       sipcmd OpalMan Added route "sip:.*=local:<db>"
    TestChanAudio
    TestChanAudio
    Listening for SIP signalling on 0.0.0.0:5060
      0:00.042                       sipcmd PTLib   Created read/write mutex 0x55d893dbada0
      0:00.043                       sipcmd PWLib   File handle high water mark set: 18 PUDPSocket
      0:00.043                       sipcmd MonSock Created socket bundle for all interfaces.
      0:00.043                       sipcmd PWLib   File handle high water mark set: 19 PUDPSocket
      0:00.043                       sipcmd MonSock Could not listen on 172.26.2.113:5060 - Address already in use
      0:00.043                       sipcmd PWLib   File handle high water mark set: 20 Thread unblock pipe
      0:00.044                       sipcmd PTLib   Created thread 0x55d893db9c80 Opal Listener
      0:00.044                       sipcmd PTLib   Thread high water mark set: 5
      0:00.044                       sipcmd PTLib   No permission to set priority level 4
    SIP listener up
      0:00.044                       sipcmd SIP     Start REGISTER
              aor=UID
           remote=127.0.0.1
            local=
          contact=
            proxy=
           authID=
            realm=
           expire=0
          restore=30
         minRetry=default
         maxRetry=default
    compatibility=FullyCompliant
      0:00.045                       sipcmd SIP     Normalised REGISTER
              aor=sip:UID@127.0.0.1
           remote=sip:UID@127.0.0.1
            local=
          contact=
            proxy=
           authID=UID
            realm=
           expire=3600
          restore=30
         minRetry=default
         maxRetry=default
    compatibility=FullyCompliant
      0:00.046                       sipcmd PTLib   Created read/write mutex 0x55d893dbb580
      0:00.046      Housekeepe...3168ef4700 PTLib   Started thread 0x55d893db4bc0 (24057) Housekeeper:0x7f3168ef4700
      0:00.046                       sipcmd PWLib   File handle high water mark set: 21 PUDPSocket
      0:00.047                       sipcmd SIP     Constructed REGISTER handler for sip:UID@127.0.0.1
      0:00.047                       sipcmd SIP     Executing state change to Subscribing for REGISTER handler, target=sip:UID@127.0.0.1, id=6636871a-1044-e911-9313-02d4f54aef8c@ip-172-26-2-113
      0:00.047                       sipcmd SIP     Changing REGISTER handler from Unavailable to Subscribing, target=sip:UID@127.0.0.1, id=6636871a-1044-e911-9313-02d4f54aef8c@ip-172-26-2-113
      0:00.048                       sipcmd PTLib   Created read/write mutex 0x55d893dbd2f0
      0:00.048                       sipcmd OpalUDP Binding to interface: 0.0.0.0:5060
      0:00.048                       sipcmd SIP     Created transport udp$127.0.0.1:5060<if=udp$*:5060>
      0:00.048                       sipcmd OpalUDP Started connect to 127.0.0.1:5060
      0:00.049                       sipcmd SIP     Changing REGISTER handler from Subscribing to Unavailable, target=sip:UID@127.0.0.1, id=6636871a-1044-e911-9313-02d4f54aef8c@ip-172-26-2-113
      0:00.049                       sipcmd SIP     Retrying REGISTER after 30 seconds.
    registered as sip:UID@127.0.0.1
      0:00.049      Opal Liste...3168eb3700 PTLib   Started thread 0x55d893db9c80 (24058) Opal Listener:0x7f3168eb3700
      0:00.049      Opal Liste...3168eb3700 Listen  Started listening thread on udp$*:5060
      0:00.049      Opal Garba...3168f76700 PTLib   Started thread 0x55d893db36e0 (24055) Opal Garbage:0x7f3168f76700
      0:00.049                       sipcmd OpalMan Attached endpoint with prefix local
      0:00.049                       sipcmd OpalEP  Created endpoint: local
      0:00.050                       sipcmd LocalEP Created endpoint.
    Created LocalEndPoint
    Main
    ## Call ##
    TestPhone::Main: calling "0004" using gateway "127.0.0.1" at Wed Mar 13 11:12:36 2019
      0:00.050      Network In...3168f35700 PTLib   Started thread 0x55d893db4910 (24056) Network Interface Monitor:0x7f3168f35700
      0:00.050      Network In...3168f35700 IfaceMon        Started interface monitor thread.

    Setting up a call to: sip:0004@127.0.0.1
      0:00.050                       sipcmd OpalMan Set up call from local:* to sip:0004@127.0.0.1
      0:00.050                       sipcmd PTLib   Created read/write mutex 0x55d893dbfdc0
      0:00.050                       sipcmd Call    Created Call[C5416e2a61]
      0:00.050                       sipcmd OpalMan Set up connection to "local:*"
    LocalEndpoint::MakeConnection
    LocalEndpointCreateConnection
      0:00.050                       sipcmd PTLib   Created read/write mutex 0x55d893dc03a0
      0:00.050                       sipcmd OpalCon Created connection Call[C5416e2a61]-EP<local>[Lfe18107c2]
      0:00.051                       sipcmd LocalCon        Created connection with token "Lfe18107c2"
    LocalConnection
      0:00.051                       sipcmd Call    GetOtherPartyConnection Call[C5416e2a61]-EP<local>[Lfe18107c2]
      0:00.051                       sipcmd OpalCon SetPhase from UninitialisedPhase to SetUpPhase for Call[C5416e2a61]-EP<local>[Lfe18107c2]
    OnIncomingConnection: token=Lfe18107c2
      0:00.051                       sipcmd OpalMan OnIncoming connection Call[C5416e2a61]-EP<local>[Lfe18107c2]
      0:00.051                       sipcmd Call    GetOtherPartyConnection Call[C5416e2a61]-EP<local>[Lfe18107c2]
      0:00.051                       sipcmd Call    GetOtherPartyConnection Call[C5416e2a61]-EP<local>[Lfe18107c2]
      0:00.051                       sipcmd OpalMan Searching for route "local:admin        sip:0004@127.0.0.1"
      0:00.051                       sipcmd OpalMan Matched regex "^local:.*        .*$" ("local:.*")
      0:00.051                       sipcmd OpalMan Set up connection to "sip:0004@127.0.0.1"
      0:00.052                       sipcmd PTLib   Created read/write mutex 0x55d893dc6f30
      0:00.052                       sipcmd OpalCon Created connection Call[C5416e2a61]-EP<sip>[480d881a-1044-e911-9313-02d4f54aef8c]
      0:00.052                       sipcmd RFC2833 Handler created
      0:00.052                       sipcmd RFC2833 Handler created
      0:00.052                       sipcmd SIP     Created connection.
      0:00.053                       sipcmd LocalCon        Outgoing call routed to sip:0004@127.0.0.1 for Call[C5416e2a61]-EP<local>[Lfe18107c2]
      0:00.053                       sipcmd Call    OnSetUp Call[C5416e2a61]-EP<local>[Lfe18107c2]
      0:00.053                       sipcmd SIP     SetUpConnection: sip:0004@127.0.0.1
      0:00.053                       sipcmd SIP     Connecting to sip:0004@127.0.0.1 via sip:0004@127.0.0.1
      0:00.053                       sipcmd SIP     Setting new transport for destination "sip:0004@127.0.0.1"
      0:00.053                       sipcmd SIP     Found registrar on domain 127.0.0.1, using interface
      0:00.053                       sipcmd PTLib   Created read/write mutex 0x55d893dcb340
      0:00.054                       sipcmd OpalUDP Binding to interface: 0.0.0.0:5060
      0:00.054                       sipcmd SIP     Created transport udp$127.0.0.1:5060<if=udp$*:5060>
      0:00.054                       sipcmd OpalUDP Started connect to 127.0.0.1:5060
      0:00.060                       sipcmd Call    GetMediaFormats for Call[C5416e2a61]-EP<sip>[480d881a-1044-e911-9313-02d4f54aef8c]
        G.722.2,GSM-AMR,iLBC,GSM-06.10,G.726-40k,G.726-32k,G.726-24k,G.726-16k,G.711-uLaw-64k,G.711-ALaw-64k,H.264,H.264-1,H.264-0,MPEG4,H.263,H.263plus,H.261,G.722-64k,G.722.1-24k,G.722.1-32k,SILK-16,SpeexIETFWide-20.6k,SpeexWB,SpeexWide-20.6k,LPC-10,MS-GSM,MS-IMA-ADPCM,SILK-8,SpeexIETFNarrow-11k,SpeexIETFNarrow-15k,SpeexIETFNarrow-18.2k,SpeexIETFNarrow-24.6k,SpeexIETFNarrow-5.95k,SpeexIETFNarrow-8k,SpeexNB,SpeexWNarrow-8k,T.38,iLBC-13k3,iLBC-15k2,UserInput/RFC2833,NamedSignalEvent,RFC4175_YCbCr-4:2:0,theora,MSRP,SIP-IM,T.140,H.224/H323AnnexQ
      0:00.060                       sipcmd SIP     Local media formats set:
        G.722.2,GSM-AMR,iLBC,GSM-06.10,G.726-40k,G.726-32k,G.726-24k,G.726-16k,G.711-uLaw-64k,G.711-ALaw-64k,H.264,H.264-1,H.264-0,MPEG4,H.263,H.263plus,H.261,G.722-64k,G.722.1-24k,G.722.1-32k,SILK-16,SpeexIETFWide-20.6k,SpeexWB,SpeexWide-20.6k,LPC-10,MS-GSM,MS-IMA-ADPCM,SILK-8,SpeexIETFNarrow-11k,SpeexIETFNarrow-15k,SpeexIETFNarrow-18.2k,SpeexIETFNarrow-24.6k,SpeexIETFNarrow-5.95k,SpeexIETFNarrow-8k,SpeexNB,SpeexWNarrow-8k,T.38,iLBC-13k3,iLBC-15k2,UserInput/RFC2833,NamedSignalEvent,RFC4175_YCbCr-4:2:0,theora,MSRP,SIP-IM,T.140,H.224/H323AnnexQ
      0:00.060                       sipcmd SIP     Remote media formats set:
        G.722.2,GSM-AMR,iLBC,GSM-06.10,G.726-40k,G.726-32k,G.726-24k,G.726-16k,G.711-uLaw-64k,G.711-ALaw-64k,H.264,H.264-1,H.264-0,MPEG4,H.263,H.263plus,H.261,G.722-64k,G.722.1-24k,G.722.1-32k,SILK-16,SpeexIETFWide-20.6k,SpeexWB,SpeexWide-20.6k,LPC-10,MS-GSM,MS-IMA-ADPCM,SILK-8,SpeexIETFNarrow-11k,SpeexIETFNarrow-15k,SpeexIETFNarrow-18.2k,SpeexIETFNarrow-24.6k,SpeexIETFNarrow-5.95k,SpeexIETFNarrow-8k,SpeexNB,SpeexWNarrow-8k,T.38,iLBC-13k3,iLBC-15k2,UserInput/RFC2833,NamedSignalEvent,RFC4175_YCbCr-4:2:0,theora,MSRP,SIP-IM,T.140,H.224/H323AnnexQ
      0:00.061                       sipcmd OpalCon SetPhase from UninitialisedPhase to SetUpPhase for Call[C5416e2a61]-EP<sip>[480d881a-1044-e911-9313-02d4f54aef8c]
      0:00.061                       sipcmd SIP     Could not write to sip:0004@127.0.0.1 -
      0:00.061                       sipcmd OpalCon SetPhase from SetUpPhase to ReleasingPhase for Call[C5416e2a61]-EP<sip>[480d881a-1044-e911-9313-02d4f54aef8c]
      0:00.061                       sipcmd OpalCon Call end reason for Call[C5416e2a61]-EP<sip>[480d881a-1044-e911-9313-02d4f54aef8c] set to EndedByTransportFail
      0:00.061                       sipcmd OpalCon Releasing asynchronously Call[C5416e2a61]-EP<sip>[480d881a-1044-e911-9313-02d4f54aef8c]
      0:00.062                       sipcmd PWLib   File handle high water mark set: 22 Thread unblock pipe
      0:00.062                       sipcmd PTLib   Created thread 0x55d893dd4570 OnRelease
      0:00.062                       sipcmd PTLib   Thread high water mark set: 6
      0:00.062                       sipcmd OpalCon SetPhase from SetUpPhase to ReleasingPhase for Call[C5416e2a61]-EP<local>[Lfe18107c2]
      0:00.062                       sipcmd OpalCon Call end reason for Call[C5416e2a61]-EP<local>[Lfe18107c2] set to EndedByNoAccept
      0:00.063                       sipcmd OpalCon Releasing asynchronously Call[C5416e2a61]-EP<local>[Lfe18107c2]
      0:00.063                       sipcmd PWLib   File handle high water mark set: 24 Thread unblock pipe
      0:00.063                       sipcmd PTLib   Created thread 0x55d893dd4820 OnRelease
      0:00.063                       sipcmd PTLib   Thread high water mark set: 7
      0:00.064                       sipcmd Call    Clearing Call[C5416e2a61] reason=EndedByTransportFail
      0:00.064                       sipcmd OpalCon Already released Call[C5416e2a61]-EP<sip>[480d881a-1044-e911-9313-02d4f54aef8c]
    Call setup to sip:0004@127.0.0.1 failed
    Problem running command sequence ("c0004;ws30;vclip"):

    TestPhone::Main: shutting down
      0:00.064                       sipcmd OpalMan Clearing all calls and waiting, primary thread.
      0:00.064                       sipcmd Call    Clearing Call[C5416e2a61] reason=EndedByLocalUser
      0:00.065      OnRelease:...31497ae700 PTLib   Started thread 0x55d893dd4820 (24060) OnRelease:0x7f31497ae700
      0:00.065      OnRelease:...31497ae700 OpalCon OnReleased Call[C5416e2a61]-EP<local>[Lfe18107c2]
      0:00.065      OnRelease:...31497ae700 OpalCon Media streams closed.
      0:00.065      OnRelease:...31497ae700 OpalEP  OnReleased Call[C5416e2a61]-EP<local>[Lfe18107c2]
    OnReleased: reason: EndedByNoAccept
      0:00.065      OnRelease:...31497ae700 OpalMan OnReleased Call[C5416e2a61]-EP<local>[Lfe18107c2]
      0:00.066      OnRelease:...31497ae700 Call    OnReleased Call[C5416e2a61]-EP<local>[Lfe18107c2]
      0:00.066      OnRelease:...31497ae700 OpalCon Already released Call[C5416e2a61]-EP<sip>[480d881a-1044-e911-9313-02d4f54aef8c]
      0:00.066      OnRelease:...31497ae700 OpalCon SetPhase from ReleasingPhase to ReleasedPhase for Call[C5416e2a61]-EP<local>[Lfe18107c2]
      0:00.066      OnRelease:...31497ae700 OpalCon Connection Call[C5416e2a61]-EP<local>[Lfe18107c2] released
            Initial Time: Wed, 13 Mar 2019 11:12:36 -04:00
              SetUpPhase: 0.000
         ProceedingPhase: N/A
           AlertingPhase: N/A
          ConnectedPhase: N/A
        EstablishedPhase: N/A
         ForwardingPhase: N/A
          ReleasingPhase: 0.011
           ReleasedPhase: 0.015
         Call end reason: EndedByNoAccept

      0:00.067      OnRelease:...31497ae700 OpalCon OnRelease thread completed for Call[C5416e2a61]-EP<local>[Lfe18107c2]
      0:00.067      OnRelease:...31497ae700 PWLib   File handle high water mark set: 25 PTextFile
      0:00.067      OnRelease:...31497ae700 PTLib   Thread ended: name="OnRelease:0x7f31497ae700", real=0.002, kernel=0.000 (0%), user=0.000 (0%), both=0.000 (0%)
      0:00.067      OnRelease:...3154078700 PTLib   Started thread 0x55d893dd4570 (24059) OnRelease:0x7f3154078700
      0:00.068      OnRelease:...3154078700 SIP     OnReleased: Call[C5416e2a61]-EP<sip>[480d881a-1044-e911-9313-02d4f54aef8c]
      0:00.068      OnRelease:...3154078700 OpalCon OnReleased Call[C5416e2a61]-EP<sip>[480d881a-1044-e911-9313-02d4f54aef8c]
      0:00.068      OnRelease:...3154078700 OpalCon Media streams closed.
      0:00.068      OnRelease:...3154078700 OpalEP  OnReleased Call[C5416e2a61]-EP<sip>[480d881a-1044-e911-9313-02d4f54aef8c]
    OnReleased: reason: EndedByTransportFail
      0:00.068      OnRelease:...3154078700 OpalMan OnReleased Call[C5416e2a61]-EP<sip>[480d881a-1044-e911-9313-02d4f54aef8c]
      0:00.069      OnRelease:...3154078700 Call    OnReleased Call[C5416e2a61]-EP<sip>[480d881a-1044-e911-9313-02d4f54aef8c]
    OnClearedCall
      0:00.069      OnRelease:...3154078700 OpalCon SetPhase from ReleasingPhase to ReleasedPhase for Call[C5416e2a61]-EP<sip>[480d881a-1044-e911-9313-02d4f54aef8c]
      0:00.069      OnRelease:...3154078700 OpalCon Connection Call[C5416e2a61]-EP<sip>[480d881a-1044-e911-9313-02d4f54aef8c] released
            Initial Time: Wed, 13 Mar 2019 11:12:36 -04:00
              SetUpPhase: 0.009
         ProceedingPhase: N/A
           AlertingPhase: N/A
          ConnectedPhase: N/A
        EstablishedPhase: N/A
         ForwardingPhase: N/A
          ReleasingPhase: 0.009
           ReleasedPhase: 0.017
         Call end reason: EndedByTransportFail

      0:00.070      OnRelease:...3154078700 OpalCon OnRelease thread completed for Call[C5416e2a61]-EP<sip>[480d881a-1044-e911-9313-02d4f54aef8c]
      0:00.070      OnRelease:...3154078700 PTLib   Thread ended: name="OnRelease:0x7f3154078700", real=0.003, kernel=0.000 (0%), user=0.000 (0%), both=0.000 (0%)
      0:02.050      Opal Garba...3168f76700 SIP     Deleting connection.
      0:02.050      Opal Garba...3168f76700 SIP     Setting new transport for destination ""
      0:02.050      Opal Garba...3168f76700 Opal    Transport clean up on termination
      0:02.050      Opal Garba...3168f76700 Opal    Transport Close
      0:02.050      Opal Garba...3168f76700 Opal    Transport clean up on termination
      0:02.050      Opal Garba...3168f76700 Opal    Transport Close
      0:02.050      Opal Garba...3168f76700 Opal    Deleted transport udp$127.0.0.1:5060<if=udp$*:5060>
      0:02.050      Opal Garba...3168f76700 PTLib   Destroying read/write mutex 0x55d893dcb340
      0:02.050      Housekeepe...3168ef4700 PTLib   Destroyed thread 0x55d893dd4820 OnRelease:0x7f31497ae700(id = 0)
      0:02.050      Housekeepe...3168ef4700 PTLib   Destroyed thread 0x55d893dd4570 OnRelease:0x7f3154078700(id = 0)
      0:02.050      Opal Garba...3168f76700 OpalCon Connection Call[C5416e2a61]-EP<sip>[480d881a-1044-e911-9313-02d4f54aef8c] destroyed.
      0:02.050      Opal Garba...3168f76700 PTLib   Destroying read/write mutex 0x55d893dc6f30
    ~LocalConnection
      0:02.050      Opal Garba...3168f76700 LocalCon        Deleted connection.
      0:02.050      Opal Garba...3168f76700 OpalCon Connection Call[C5416e2a61]-EP<local>[Lfe18107c2] destroyed.
      0:02.051      Opal Garba...3168f76700 PTLib   Destroying read/write mutex 0x55d893dc03a0
      0:03.051      Opal Garba...3168f76700 Call    Destroyed Call[C5416e2a61]
      0:03.051      Opal Garba...3168f76700 PTLib   Destroying read/write mutex 0x55d893dbfdc0
      0:03.051                       sipcmd OpalMan All calls cleared.
    TestPhone::Main: exiting...
    Exiting...
    ~Manager
      0:03.051                       sipcmd OpalMan Shutting down endpoints.
      0:03.051                       sipcmd OpalMan Clearing all calls and waiting, primary thread.
      0:04.051                       sipcmd OpalMan All calls cleared.
      0:04.051                       sipcmd SIP     Shutting down.
      0:04.052                       sipcmd SIP     Changing REGISTER handler from Unavailable to Unsubscribing, target=sip:UID@127.0.0.1, id=6636871a-1044-e911-9313-02d4f54aef8c@ip-172-26-2-113
      0:04.052                       sipcmd SIP     Not retrying REGISTER due to error response 1 Transport Error
      0:04.052                       sipcmd SIP     Changing REGISTER handler from Unsubscribing to Unsubscribed, target=sip:UID@127.0.0.1, id=6636871a-1044-e911-9313-02d4f54aef8c@ip-172-26-2-113
      0:04.152                       sipcmd OpalEP  sip endpoint shutting down.
      0:04.152                       sipcmd Listen  Stopping listening thread on udp$*:5060
      0:04.153      Opal Liste...3168eb3700 Listen  UDP read error.
      0:04.153      Opal Liste...3168eb3700 PWLib   File handle low water mark set: 18 PTextFile
      0:04.153      Opal Liste...3168eb3700 PTLib   Thread ended: name="Opal Listener:0x7f3168eb3700", real=4.105, kernel=0.000 (0%), user=0.000 (0%), both=0.000 (0%)
      0:04.163                       sipcmd PTLib   Destroyed thread 0x55d893db9c80 Opal Listener:0x7f3168eb3700(id = 7f3168eb3700)
      0:04.163                       sipcmd OpalEP  local endpoint shutting down.
      0:04.163                       sipcmd PTLib   Destroying read/write mutex 0x55d893db46b8
      0:04.163                       sipcmd PTLib   Destroying read/write mutex 0x55d893db4438
      0:04.163                       sipcmd Opal    Transport clean up on termination
      0:04.163                       sipcmd Opal    Transport Close
      0:04.163                       sipcmd Opal    Transport clean up on termination
      0:04.163                       sipcmd Opal    Transport Close
      0:04.163                       sipcmd Opal    Deleted transport udp$127.0.0.1:5060<if=udp$*:5060>
      0:04.163                       sipcmd IfaceMon        Awaiting thread termination
      0:04.163      Network In...3168f35700 IfaceMon        Finished interface monitor thread.
      0:04.163      Network In...3168f35700 PTLib   Thread ended: name="Network Interface Monitor:0x7f3168f35700", real=4.116, kernel=0.000 (0%), user=0.000 (0%), both=0.000 (0%)
      0:04.163                       sipcmd PTLib   Destroyed thread 0x55d893db4910 Network Interface Monitor:0x7f3168f35700(id = 7f3168f35700)
      0:04.164                       sipcmd PTLib   Destroying read/write mutex 0x55d893dbada0
      0:04.164                       sipcmd PTLib   Destroying read/write mutex 0x55d893dbd2f0
      0:04.164                       sipcmd SIP     Destroyed REGISTER handler for sip:UID@127.0.0.1
      0:04.164                       sipcmd PTLib   Destroying read/write mutex 0x55d893dbb580
      0:04.164                       sipcmd OpalEP  sip endpoint destroyed.
      0:04.165                       sipcmd LocalEP Deleted endpoint.
      0:04.165                       sipcmd OpalEP  local endpoint destroyed.
      0:04.165      Opal Garba...3168f76700 PWLib   File handle low water mark set: 8 PTextFile
      0:04.165      Opal Garba...3168f76700 PTLib   Thread ended: name="Opal Garbage:0x7f3168f76700", real=4.118, kernel=0.000 (0%), user=0.000 (0%), both=0.000 (0%)
      0:04.165                       sipcmd PTLib   Destroyed thread 0x55d893db36e0 Opal Garbage:0x7f3168f76700(id = 7f3168f76700)
      0:04.165                       sipcmd OpalMan Deleted manager.
      0:04.166                       sipcmd PTLib   Destroying read/write mutex 0x55d893dae3e8
      0:04.166                       sipcmd OpalPlugin      Using default handler for plugin codec spandsp_ptplugin
      0:04.166                       sipcmd OpalPlugin      Using default handler for plugin codec mpeg4_ffmpeg_ptplugin
      0:04.166                       sipcmd OpalPlugin      Using default handler for plugin codec h263_ffmpeg_ptplugin
      0:04.167                       sipcmd OpalPlugin      Using default handler for plugin codec theora_ptplugin
      0:04.167                       sipcmd OpalPlugin      Using default handler for plugin codec h264_x264_ptplugin
      0:04.167                       sipcmd OpalPlugin      Using default handler for plugin codec h261_vic_ptplugin
      0:04.167                       sipcmd OpalPlugin      Using default handler for plugin codec ima_adpcm_ptplugin
      0:04.167                       sipcmd OpalPlugin      Using default handler for plugin codec g7221_ptplugin
      0:04.167                       sipcmd OpalPlugin      Using default handler for plugin codec gsm0610_ptplugin
      0:04.167                       sipcmd OpalPlugin      Using default handler for plugin codec speex_ptplugin
      0:04.168                       sipcmd OpalPlugin      Using default handler for plugin codec lpc10_ptplugin
      0:04.168                       sipcmd OpalPlugin      Using default handler for plugin codec g722_ptplugin
      0:04.168                       sipcmd OpalPlugin      Using default handler for plugin codec gsmamrcodec_ptplugin
      0:04.168                       sipcmd OpalPlugin      Using default handler for plugin codec silk_ptplugin
      0:04.168                       sipcmd OpalPlugin      Using default handler for plugin codec g726_ptplugin
      0:04.168                       sipcmd OpalPlugin      Using default handler for plugin codec iLBC_ptplugin
      0:04.168                       sipcmd OpalPlugin      Using default handler for plugin codec g7222_ptplugin
      0:04.168                       sipcmd UDLL    Closing /usr/lib/opal-3.10.10/codecs/audio/g7222_ptplugin.so
      0:04.168                       sipcmd UDLL    Closing /usr/lib/opal-3.10.10/codecs/audio/iLBC_ptplugin.so
      0:04.169                       sipcmd UDLL    Closing /usr/lib/opal-3.10.10/codecs/audio/g726_ptplugin.so
      0:04.169                       sipcmd UDLL    Closing /usr/lib/opal-3.10.10/codecs/audio/silk_ptplugin.so
      0:04.169                       sipcmd UDLL    Closing /usr/lib/opal-3.10.10/codecs/audio/gsmamrcodec_ptplugin.so
      0:04.169                       sipcmd UDLL    Closing /usr/lib/opal-3.10.10/codecs/audio/g722_ptplugin.so
      0:04.169                       sipcmd UDLL    Closing /usr/lib/opal-3.10.10/codecs/audio/lpc10_ptplugin.so
      0:04.169                       sipcmd UDLL    Closing /usr/lib/opal-3.10.10/codecs/audio/speex_ptplugin.so
      0:04.169                       sipcmd UDLL    Closing /usr/lib/opal-3.10.10/codecs/audio/gsm0610_ptplugin.so
      0:04.169                       sipcmd UDLL    Closing /usr/lib/opal-3.10.10/codecs/audio/g7221_ptplugin.so
      0:04.169                       sipcmd UDLL    Closing /usr/lib/opal-3.10.10/codecs/audio/ima_adpcm_ptplugin.so
      0:04.170                       sipcmd UDLL    Closing /usr/lib/opal-3.10.10/codecs/video/h261_vic_ptplugin.so
      0:04.170                       sipcmd UDLL    Closing /usr/lib/opal-3.10.10/codecs/video/h264_x264_ptplugin.so
      0:04.170                       sipcmd UDLL    Closing /usr/lib/opal-3.10.10/codecs/video/theora_ptplugin.so
      0:04.170                       sipcmd UDLL    Closing /usr/lib/opal-3.10.10/codecs/video/h263_ffmpeg_ptplugin.so
      0:04.170                       sipcmd UDLL    Closing /usr/lib/opal-3.10.10/codecs/video/mpeg4_ffmpeg_ptplugin.so
      0:04.170                       sipcmd UDLL    Closing /usr/lib/opal-3.10.10/fax/spandsp_ptplugin.so
      0:04.170                       sipcmd UDLL    Closing /usr/lib/ptlib-2.10.11/devices/sound/oss_pwplugin.so
      0:04.170                       sipcmd UDLL    Closing /usr/lib/ptlib-2.10.11/devices/sound/alsa_pwplugin.so
      0:04.170                       sipcmd UDLL    Closing /usr/lib/ptlib-2.10.11/devices/sound/pulse_pwplugin.so
      0:04.171                       sipcmd UDLL    Closing /usr/lib/ptlib-2.10.11/devices/videoinput/v4l2_pwplugin.so
      0:14.166      Housekeepe...3168ef4700 Housekeeping thread ended
      0:14.166      Housekeepe...3168ef4700 PWLib   File handle low water mark set: 6 PTextFile
      0:14.166      Housekeepe...3168ef4700 PTLib   Thread ended: name="Housekeeper:0x7f3168ef4700", real=14.120, kernel=0.000 (0%), user=0.000 (0%), both=0.000 (0%)
      0:14.173                       sipcmd PTLib   Destroyed thread 0x55d893db4bc0 Housekeeper:0x7f3168ef4700(id = 7f3168ef4700)

Any idea what it is the issue is here?

tommasinigiovanni commented 5 years ago

more or less the same problem. and when I sniffed the outgoing traffic, I've never seen any packets to the gateway define with -w