Credential Failure Connecting Linphone to FreePBX

Hi - hoping someone can help me with this one, I’ve started work on a project to turn a Raspberry Pi into an intercom system for my flat. The current system works through our telephone line so I thought it might be efficient to setup a VoIP line for this purpose rather than run the intercom through a paid land line, that we never use for other purposes.

As you can probably tell I’m pretty new to all of this so have been using the “voip-for-dummies” guide on the littlebytesofpi website (i’m a new user so can’t post links) to setup the VoIP server etc, however the guide is a little outdated now and so the steps don’t appear to be as easy to follow as I presume they once were.

I’ve gone through the steps to install Asterisk (v13.20.0) and FreePBX (v14.0.2.10) onto my Pi, which all seems to have worked as expected. I’ve also run the suggested updates and have setup a couple of extensions when accessing the server via a browser: raspbx.local

I now want to test connectivity to the server but I’m having no luck getting my SIP softphone (i’m using the Linphone app on my Android mobile) to register with the server.

The guide I used suggests that I need to enter a username, password & domain combination but every time I do so I am met with a “Registration failed” error message.

I have tried many, many different combinations but have yet to hit the correct combination in order to register successfully.

Here are some of the variables I am working with:

  1. The guide suggests I simply select “SIP” as the extension protocol however, FreePBX appears to offer two types of SIP: Chan_SIP and PJSIP - I understand PJSIP is a newer version of the protocol however I’m not sure which I should be selecting in the case of this setup (or if it matters at all).

  2. Username - when I setup a new extension via the raspbx portal I am asked to provide a " User Extension " as well as a " Display Name " - which of these (if either) is the username? To simplify things for my test I simply named both entries as " 11111 ".

  3. Password - there seem to be a few options of which password could be used here. It could be the password I set to log onto the server or it could be what is listed in the extension setup as " Secret " or " Password For New User " - again, I made sure all three were identical for my test to reduce the amount of combinations I needed to check to connect but with no success.

  4. Domain - there seem to be even more options I could go for in this section, here’s some of the ones I’ve tested so far:

  • raspbx.local (adding spaces because I am not allowed to post links)
  • root @ raspbx.local
  • the inet ip addess under the “wlan0” section I see when I run ifconfig on my Pi
  • the net ip addess under the “lo” section I see when I run ifconfig on my Pi (localhost IP)
  • the ip address I see when I log onto the server via a web browser, listed as: **FreePBX {ip address} ‘VoIP Server’
  • 11111 @ raspbx.local
  • 11111@{all of the other IP addresses mentioned above}

Unfortunately nothing is working so I’m clearly doing something very wrong here. Can anyone advise what I should be trying in order to successfully connect the softphone to the server?

Let me know if any further detail is required.

Many thanks,

Ed

Please try these settings in Linphone:

  1. Username: match what you entered for User Extension in FreePBX (presumably 1111).
  2. Password: match what you set for Secret in FreePBX. For initial testing, use a short string, for example zzxg2718 so you can be sure it’s correct.
  3. Domain: match the IPv4 address you see for wlan0, for example 192.168.1.234

This is for a pjsip extension. If you created a chan_sip extension, also add:
4. Proxy: your wlan0 address followed by :5160, for example 192.168.1.234:5160

If you still have trouble, post what if anything appears in the Asterisk log when you attempt to register.

Hi Stewart,

Thanks very much for this. I tried both of the ways you have described above (using pjsip and chan_sip) but unfortunately neither worked.

I have pasted the log for the attempted pjsip connection below - not sure why I can’t just upload a text file here but the forum only allows the upload of picture files, therefore apologies in advance for the particularly long post!

I’m guessing this is a big part of the issue:

ERROR[4651] res_pjsip_endpoint_identifier_ip.c: Identify ‘11111-identify’ is not configured to match anything.

Though I have definitely created an extension named ‘11111’ as you can see in the attached image

Any further advise would be much appreciated!

Thanks

Ed

Full Log:

[2019-03-10 10:53:37] VERBOSE[4215] loader.c: Reloading module ‘chan_iax2.so’ (Inter Asterisk eXchange (Ver 2))

[2019-03-10 10:53:37] NOTICE[4215] iax2/provision.c: No IAX provisioning configuration found, IAX provisioning disabled.

[2019-03-10 10:53:37] VERBOSE[4215] loader.c: Reloading module ‘chan_motif.so’ (Motif Jingle Channel Driver)

[2019-03-10 10:53:37] VERBOSE[4215] loader.c: Reloading module ‘chan_sip.so’ (Session Initiation Protocol (SIP))

[2019-03-10 10:53:37] VERBOSE[1187] chan_sip.c: Reloading SIP

[2019-03-10 10:53:37] VERBOSE[4215] loader.c: Reloading module ‘res_pjsip_outbound_registration.so’ (PJSIP Outbound Registration Su$

[2019-03-10 10:53:37] ERROR[4215] res_pjsip_config_wizard.c: Unable to load config file ‘pjsip_wizard.conf’

[2019-03-10 10:53:37] VERBOSE[4215] loader.c: Reloading module ‘res_pjsip_notify.so’ (CLI/AMI PJSIP NOTIFY Support)

[2019-03-10 10:53:37] VERBOSE[4215] loader.c: Reloading module ‘res_adsi.so’ (ADSI Resource)

[2019-03-10 10:53:37] VERBOSE[4215] loader.c: Reloading module ‘app_confbridge.so’ (Conference Bridge Application)

[2019-03-10 10:53:37] NOTICE[4215] confbridge/conf_config_parser.c: Adding default_menu menu to app_confbridge

[2019-03-10 10:53:37] VERBOSE[4215] loader.c: Reloading module ‘cel_manager.so’ (Asterisk Manager Interface CEL Backend)

[2019-03-10 10:53:37] VERBOSE[1187] netsock2.c: Using SIP TOS bits 96

[2019-03-10 10:53:37] VERBOSE[4215] loader.c: Reloading module ‘cel_odbc.so’ (ODBC CEL backend)

[2019-03-10 10:53:37] VERBOSE[1187] netsock2.c: Using SIP CoS mark 4

[2019-03-10 10:53:37] VERBOSE[4215] cel_odbc.c: Found CEL table cel@asteriskcdrdb.

[2019-03-10 10:53:37] VERBOSE[4215] loader.c: Reloading module ‘codec_speex.so’ (Speex Coder/Decoder)

[2019-03-10 10:53:37] VERBOSE[4215] loader.c: Reloading module ‘app_voicemail.so’ (Comedian Mail (Voicemail System))

[2019-03-10 10:53:37] WARNING[4215] app_voicemail.c: maxsilence should be less than minsecs or you may get empty messages

[2019-03-10 10:53:37] VERBOSE[4215] loader.c: Reloading module ‘app_playback.so’ (Sound File Playback Application)

[2019-03-10 10:53:37] VERBOSE[4215] loader.c: Reloading module ‘app_queue.so’ (True Call Queueing)

[2019-03-10 10:53:37] NOTICE[4215] app_queue.c: No queuerules.conf file found, queues will not follow penalty rules

[2019-03-10 10:53:37] VERBOSE[4215] asterisk.c: Remote UNIX connection disconnected

[2019-03-10 10:57:33] VERBOSE[1111] asterisk.c: Remote UNIX connection

[2019-03-10 10:57:33] VERBOSE[4577] asterisk.c: Remote UNIX connection disconnected

[2019-03-10 10:57:33] VERBOSE[1111] asterisk.c: Remote UNIX connection

[2019-03-10 10:57:33] VERBOSE[4587] asterisk.c: Remote UNIX connection disconnected

[2019-03-10 10:57:33] VERBOSE[1111] asterisk.c: Remote UNIX connection

[2019-03-10 10:57:33] VERBOSE[4590] asterisk.c: Remote UNIX connection disconnected

[2019-03-10 10:57:33] VERBOSE[1111] asterisk.c: Remote UNIX connection

[2019-03-10 10:57:33] VERBOSE[4593] asterisk.c: Remote UNIX connection disconnected

[2019-03-10 10:57:33] VERBOSE[1111] asterisk.c: Remote UNIX connection

[2019-03-10 10:57:33] VERBOSE[4593] asterisk.c: Remote UNIX connection disconnected

[2019-03-10 10:57:37] VERBOSE[1111] asterisk.c: Remote UNIX connection

[2019-03-10 10:57:37] ERROR[4645] config_options.c: Unable to load config file ‘acl.conf’

[2019-03-10 10:57:37] WARNING[4645] named_acl.c: Could not reload ACL config

[2019-03-10 10:57:37] NOTICE[4645] cdr.c: CDR simple logging enabled.

[2019-03-10 10:57:37] VERBOSE[4645] cel.c: CEL logging enabled.

[2019-03-10 10:57:37] VERBOSE[4645] tcptls.c: TLS/SSL ECDH initialized (secp256r1), faster PFS cipher-suites enabled

[2019-03-10 10:57:37] VERBOSE[4645] tcptls.c: TLS/SSL certificate ok

[2019-03-10 10:57:37] Asterisk 13.20.0 built by root @ raspbx on a armv6l running Linux on 2018-04-03 18:02:05 UTC

[2019-03-10 10:57:37] VERBOSE[4645] indications.c: Setting default indication country to ‘us’

[2019-03-10 10:57:37] VERBOSE[4645] logger.c: Asterisk Queue Logger restarted

[2019-03-10 10:57:38] VERBOSE[4645] loader.c: Reloading module ‘res_odbc.so’ (ODBC resource)

[2019-03-10 10:57:38] NOTICE[4645] res_odbc.c: Registered ODBC class ‘asteriskcdrdb’ dsn->[MySQL-asteriskcdrdb]

[2019-03-10 10:57:38] VERBOSE[4645] loader.c: Reloading module ‘res_config_odbc.so’ (Realtime ODBC configuration)

[2019-03-10 10:57:38] VERBOSE[4645] loader.c: Reloading module ‘cdr_adaptive_odbc.so’ (Adaptive ODBC CDR backend)

[2019-03-10 10:57:38] VERBOSE[4645] cdr_adaptive_odbc.c: Found adaptive CDR table cdr@asteriskcdrdb.

[2019-03-10 10:57:38] VERBOSE[4645] cdr_adaptive_odbc.c: Found alias start for column calldate in cdr@asteriskcdrdb

[2019-03-10 10:57:38] VERBOSE[4645] loader.c: Reloading module ‘pbx_config.so’ (Text Extension Configuration)

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘MIXMON_BEEP’ to ‘’

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘QUEDEVSTATE’ to ‘TRUE’

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘DYNAMIC_FEATURES’ to ‘apprecord’

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘INTERCOMCODE’ to ‘*80’

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘ASTETCDIR’ to ‘/etc/asterisk’

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘ASTMODDIR’ to ‘/usr/lib/asterisk/modules’

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘ASTVARLIBDIR’ to ‘/var/lib/asterisk’

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘ASTAGIDIR’ to ‘/var/lib/asterisk/agi-bin’

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘ASTSPOOLDIR’ to ‘/var/spool/asterisk’

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘ASTRUNDIR’ to ‘/var/run/asterisk’

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘ASTLOGDIR’ to ‘/var/log/asterisk’

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘CWINUSEBUSY’ to ‘1’

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘ASTLOGDIR’ to ‘/var/log/asterisk’

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘CWINUSEBUSY’ to ‘1’

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘AMPMGRUSER’ to ‘admin’

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘AMPMGRPASS’ to ‘e1c8851973fb516d14efe4c5a4863e04’

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘ASTMANAGERHOST’ to ‘localhost’

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘AMPDBENGINE’ to ‘mysql’

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘AMPDBHOST’ to ‘localhost’

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘AMPDBNAME’ to ‘asterisk’

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘AMPDBUSER’ to ‘freepbxuser’

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘AMPDBPASS’ to ‘1028ef4d5e163c9c803313e981626685’

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘AMPBIN’ to ‘/var/lib/asterisk/bin’

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘VMX_CONTEXT’ to ‘from-internal’

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘VMX_PRI’ to ‘1’

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘VMX_TIMEDEST_CONTEXT’ to ‘’

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘VMX_TIMEDEST_EXT’ to ‘dovm’

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘VMX_TIMEDEST_PRI’ to ‘1’

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘VMX_LOOPDEST_CONTEXT’ to ‘’

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘VMX_LOOPDEST_EXT’ to ‘dovm’

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘VMX_LOOPDEST_PRI’ to ‘1’

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘MIXMON_DIR’ to ‘’

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘MIXMON_POST’ to ‘’

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘DIAL_OPTIONS’ to ‘Ttr’

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘TRUNK_OPTIONS’ to ‘T’

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘TRUNK_RING_TIMER’ to ‘300’

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘MIXMON_FORMAT’ to ‘wav’

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘REC_POLICY’ to ‘caller’

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘RINGTIMER_DEFAULT’ to ‘15’

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘TRANSFER_CONTEXT’ to ‘from-internal-xfer’

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘ASTVERSION’ to ‘13.20.0’

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘ASTCHANDAHDI’ to ‘1’

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘NULL’ to ‘""’

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘ASTCHANDAHDI’ to ‘1’

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘NULL’ to ‘""’

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘ALLOW_SIP_ANON’ to ‘no’

[2019-03-10 10:57:38] VERBOSE[4645] pbx_variables.c: Setting global variable ‘SIPLANG’ to ‘en’

[2019-03-10 10:57:38] WARNING[4645] pbx_config.c: The use of ‘_.’ for an extension is strongly discouraged and can have unexpected $

[2019-03-10 10:57:38] WARNING[4645] pbx_config.c: The use of ‘_.’ for an extension is strongly discouraged and can have unexpected $

[2019-03-10 10:57:38] WARNING[4645] pbx_config.c: The use of ‘_.’ for an extension is strongly discouraged and can have unexpected $

[2019-03-10 10:57:38] WARNING[4645] pbx_config.c: The use of ‘_.’ for an extension is strongly discouraged and can have unexpected $

[2019-03-10 10:57:38] WARNING[4645] pbx_config.c: The use of ‘_.’ for an extension is strongly discouraged and can have unexpected $

[2019-03-10 10:57:38] WARNING[4645] pbx_config.c: The use of ‘_.’ for an extension is strongly discouraged and can have unexpected $

[2019-03-10 10:57:38] WARNING[4645] pbx_config.c: The use of ‘_.’ for an extension is strongly discouraged and can have unexpected $

[2019-03-10 10:57:38] WARNING[4645] pbx_config.c: The use of ‘_.’ for an extension is strongly discouraged and can have unexpected $

[2019-03-10 10:57:38] WARNING[4645] pbx_config.c: The use of ‘_.’ for an extension is strongly discouraged and can have unexpected $

[2019-03-10 10:57:38] WARNING[4645] pbx_config.c: The use of ‘_.’ for an extension is strongly discouraged and can have unexpected $

[2019-03-10 10:57:38] WARNING[4645] pbx_config.c: The use of ‘_.’ for an extension is strongly discouraged and can have unexpected $

[2019-03-10 10:57:38] WARNING[4645] pbx_config.c: The use of ‘_.’ for an extension is strongly discouraged and can have unexpected $

[2019-03-10 10:57:38] WARNING[4645] pbx_config.c: The use of ‘_.’ for an extension is strongly discouraged and can have unexpected $

[2019-03-10 10:57:38] WARNING[4645] pbx_config.c: The use of ‘_.’ for an extension is strongly discouraged and can have unexpected $

[2019-03-10 10:57:38] WARNING[4645] pbx_config.c: The use of ‘_.’ for an extension is strongly discouraged and can have unexpected $

[2019-03-10 10:57:38] WARNING[4645] pbx_config.c: The use of ‘_.’ for an extension is strongly discouraged and can have unexpected $

[2019-03-10 10:57:38] WARNING[4645] pbx_config.c: The use of ‘_.’ for an extension is strongly discouraged and can have unexpected $

[2019-03-10 10:57:38] WARNING[4645] pbx_config.c: The use of ‘_.’ for an extension is strongly discouraged and can have unexpected $

[2019-03-10 10:57:38] VERBOSE[4645] pbx.c: Time to scan old dialplan and merge leftovers back into the new: 0.002165 sec

[2019-03-10 10:57:38] VERBOSE[4645] pbx.c: Time to restore hints and swap in new dialplan: 0.000028 sec

[2019-03-10 10:57:38] VERBOSE[4645] pbx.c: Time to delete the old dialplan: 0.002571 sec

[2019-03-10 10:57:38] VERBOSE[4645] pbx.c: Total time merge_contexts_delete: 0.004764 sec

[2019-03-10 10:57:38] VERBOSE[4645] pbx.c: pbx_config successfully loaded 89 contexts (enable debug for details).

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘from-did-direct’ tries to include nonexistent context ‘ext-findmefollow’

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘from-internal-xfer’ tries to include nonexistent context ‘from-internal-custom’

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘from-internal-noxfer’ tries to include nonexistent context 'from-internal-noxfe$

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘from-pstn’ tries to include nonexistent context ‘from-pstn-custom’

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘from-internal-noxfer’ tries to include nonexistent context 'from-internal-noxfe$

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘from-pstn’ tries to include nonexistent context ‘from-pstn-custom’

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘from-internal-noxfer-additional’ tries to include nonexistent context 'from-int$

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘from-internal-additional’ tries to include nonexistent context 'from-internal-a$

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘macro-parked-call’ tries to include nonexistent context 'macro-parked-call-cust$

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘func-apply-sipheaders’ tries to include nonexistent context 'func-apply-siphead$

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘func-set-sipheader’ tries to include nonexistent context 'func-set-sipheader-cu$

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘macro-dial-one’ tries to include nonexistent context ‘macro-dial-one-custom’

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘macro-hangupcall’ tries to include nonexistent context ‘macro-hangupcall-custom’

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘macro-blkvm-check’ tries to include nonexistent context 'macro-blkvm-check-cust$

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘macro-blkvm-clr’ tries to include nonexistent context ‘macro-blkvm-clr-custom’

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘macro-blkvm-set’ tries to include nonexistent context ‘macro-blkvm-set-custom’

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘macro-blkvm-setifempty’ tries to include nonexistent context 'macro-blkvm-setif$

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘originate-skipvm’ tries to include nonexistent context ‘originate-skipvm-custom’

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘macro-simple-dial’ tries to include nonexistent context 'macro-simple-dial-cust$

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘macro-exten-vm’ tries to include nonexistent context ‘macro-exten-vm-custom’

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘macro-vm’ tries to include nonexistent context ‘macro-vm-custom’

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘macro-block-cf’ tries to include nonexistent context ‘macro-block-cf-custom’

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘macro-setmusic’ tries to include nonexistent context ‘macro-setmusic-custom’

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘macro-dial-confirm’ tries to include nonexistent context 'macro-dial-confirm-cu$

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘from-dahdi’ tries to include nonexistent context ‘from-dahdi-custom’

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘from-zaptel’ tries to include nonexistent context ‘from-zaptel-custom’

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘macro-outbound-callerid’ tries to include nonexistent context 'macro-outbound-c$

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘macro-user-callerid’ tries to include nonexistent context 'macro-user-callerid-$

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘macro-privacy-mgr’ tries to include nonexistent context 'macro-privacy-mgr-cust$

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘sub-pincheck’ tries to include nonexistent context ‘sub-pincheck-custom’

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘macro-auto-blkvm’ tries to include nonexistent context ‘macro-auto-blkvm-custom’

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘macro-auto-confirm’ tries to include nonexistent context 'macro-auto-confirm-cu$

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘macro-confirm’ tries to include nonexistent context ‘macro-confirm-custom’

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘sub-presencestate-display’ tries to include nonexistent context 'sub-presencest$

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘bad-number’ tries to include nonexistent context ‘bad-number-custom’

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘sub-presencestate-display’ tries to include nonexistent context 'sub-presencest$

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘bad-number’ tries to include nonexistent context ‘bad-number-custom’

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘app-blackhole’ tries to include nonexistent context ‘app-blackhole-custom’

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘outbound-allroutes’ tries to include nonexistent context 'outbound-allroutes-cu$

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘macro-prepend-cid’ tries to include nonexistent context 'macro-prepend-cid-cust$

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘from-did-direct-ivr’ tries to include nonexistent context 'from-did-direct-ivr-$

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘ext-local’ tries to include nonexistent context ‘ext-local-custom’

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘ext-did-catchall’ tries to include nonexistent context ‘ext-did-catchall-custom’

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘ext-did’ tries to include nonexistent context ‘ext-did-custom’

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘ext-test’ tries to include nonexistent context ‘ext-test-custom’

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘app-chanspy’ tries to include nonexistent context ‘app-chanspy-custom’

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘app-pickup’ tries to include nonexistent context ‘app-pickup-custom’

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘findmefollow-ringallv2’ tries to include nonexistent context 'findmefollow-ring$

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘ext-local-confirm’ tries to include nonexistent context 'ext-local-confirm-cust$

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘macro-dial’ tries to include nonexistent context ‘macro-dial-custom’

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘app-vmmain’ tries to include nonexistent context ‘app-vmmain-custom’

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘app-dialvm’ tries to include nonexistent context ‘app-dialvm-custom’

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘vm-callme’ tries to include nonexistent context ‘vm-callme-custom’

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘ext-group’ tries to include nonexistent context ‘ext-group-custom’

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘macro-systemrecording’ tries to include nonexistent context 'macro-systemrecord$

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘systemrecording-gui’ tries to include nonexistent context 'systemrecording-gui-$

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘sub-hr24format’ tries to include nonexistent context ‘sub-hr24format-custom’

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘app-speakingclock’ tries to include nonexistent context 'app-speakingclock-cust$

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘sub-hr12format’ tries to include nonexistent context ‘sub-hr12format-custom’

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘app-speakextennum’ tries to include nonexistent context 'app-speakextennum-cust$

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘app-echo-test-echo’ tries to include nonexistent context 'app-echo-test-echo-cu$

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘app-echo-test’ tries to include nonexistent context ‘app-echo-test-custom’

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘app-calltrace-perform’ tries to include nonexistent context 'app-calltrace-perf$

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘app-calltrace’ tries to include nonexistent context ‘app-calltrace-custom’

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘ext-featurecodes’ tries to include nonexistent context ‘ext-featurecodes-custom’

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘macro-one-touch-record’ tries to include nonexistent context 'macro-one-touch-r$

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘ext-featurecodes’ tries to include nonexistent context ‘ext-featurecodes-custom’

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘macro-one-touch-record’ tries to include nonexistent context 'macro-one-touch-r$

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘sub-record-hh-check’ tries to include nonexistent context 'sub-record-hh-check-$

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘sub-record-check’ tries to include nonexistent context ‘sub-record-check-custom’

[2019-03-10 10:57:38] WARNING[4645] pbx.c: Context ‘sub-record-cancel’ tries to include nonexistent context 'sub-record-cancel-cust$

[2019-03-10 10:57:38] VERBOSE[4645] loader.c: Reloading module ‘res_pjproject.so’ (PJPROJECT Log and Utility Support)

[2019-03-10 10:57:38] ERROR[4645] res_sorcery_config.c: Unable to load config file ‘pjproject.conf’

[2019-03-10 10:57:38] VERBOSE[4645] loader.c: Reloading module ‘res_pjsip.so’ (Basic SIP resource)

[2019-03-10 10:57:38] ERROR[4651] res_pjsip_config_wizard.c: Unable to load config file ‘pjsip_wizard.conf’

[2019-03-10 10:57:38] ERROR[4651] res_pjsip_config_wizard.c: Unable to load config file ‘pjsip_wizard.conf’

[2019-03-10 10:57:38] ERROR[4651] res_pjsip_config_wizard.c: Unable to load config file ‘pjsip_wizard.conf’

[2019-03-10 10:57:38] ERROR[4651] res_pjsip_endpoint_identifier_ip.c: Identify ‘11111-identify’ is not configured to match anything.

[2019-03-10 10:57:38] ERROR[4651] res_sorcery_config.c: Could not create an object of type ‘identify’ with id ‘11111-identify’ from$

[2019-03-10 10:57:38] ERROR[4651] res_pjsip_config_wizard.c: Unable to load config file ‘pjsip_wizard.conf’

[2019-03-10 10:57:38] NOTICE[4651] sorcery.c: Type ‘system’ is not reloadable, maintaining previous values

[2019-03-10 10:57:38] ERROR[4651] res_pjsip_config_wizard.c: Unable to load config file ‘pjsip_wizard.conf’

[2019-03-10 10:57:38] VERBOSE[4645] loader.c: Reloading module ‘res_pjsip_outbound_publish.so’ (PJSIP Outbound Publish Support)

[2019-03-10 10:57:38] VERBOSE[4645] loader.c: Reloading module ‘res_xmpp.so’ (Asterisk XMPP Interface)

[2019-03-10 10:57:38] VERBOSE[4645] loader.c: Reloading module ‘res_crypto.so’ (Cryptographic Digital Signatures)

[2019-03-10 10:57:38] VERBOSE[4645] loader.c: Reloading module ‘res_ari.so’ (Asterisk RESTful Interface)

[2019-03-10 10:57:38] ERROR[4645] ari/config.c: No configured users for ARI

[2019-03-10 10:57:38] VERBOSE[4645] loader.c: Reloading module ‘res_fax.so’ (Generic FAX Applications)

[2019-03-10 10:57:38] NOTICE[4645] res_fax.c: Configuration file ‘res_fax.conf’ not found, not changing options.

[2019-03-10 10:57:38] VERBOSE[4645] loader.c: Reloading module ‘res_config_curl.so’ (Realtime Curl configuration)

[2019-03-10 10:57:38] VERBOSE[4645] loader.c: Reloading module ‘res_config_mysql.so’ (MySQL RealTime Configuration Driver)

[2019-03-10 10:57:38] VERBOSE[4645] res_config_mysql.c: MySQL RealTime reloaded.

[2019-03-10 10:57:38] VERBOSE[4645] loader.c: Reloading module ‘res_pjsip_authenticator_digest.so’ (PJSIP authentication resource)

[2019-03-10 10:57:38] VERBOSE[4645] loader.c: Reloading module ‘res_pjsip_endpoint_identifier_ip.so’ (PJSIP IP endpoint identifier)

[2019-03-10 10:57:38] ERROR[4645] res_pjsip_config_wizard.c: Unable to load config file ‘pjsip_wizard.conf’

[2019-03-10 10:57:38] VERBOSE[4645] loader.c: Reloading module ‘res_musiconhold.so’ (Music On Hold Resource)

[2019-03-10 10:57:38] VERBOSE[4645] loader.c: Reloading module ‘res_rtp_asterisk.so’ (Asterisk RTP Stack)

[2019-03-10 10:57:38] VERBOSE[4645] loader.c: Reloading module ‘res_musiconhold.so’ (Music On Hold Resource)

[2019-03-10 10:57:38] VERBOSE[4645] loader.c: Reloading module ‘res_rtp_asterisk.so’ (Asterisk RTP Stack)

[2019-03-10 10:57:38] VERBOSE[4645] res_rtp_asterisk.c: RTP Allocating from port range 10000 -> 20000

[2019-03-10 10:57:38] VERBOSE[4645] loader.c: Reloading module ‘res_pjsip_publish_asterisk.so’ (PJSIP Asterisk Event PUBLISH Suppor$

[2019-03-10 10:57:38] VERBOSE[4645] loader.c: Reloading module ‘res_pjsip_mwi.so’ (PJSIP MWI resource)

[2019-03-10 10:57:38] VERBOSE[4645] loader.c: Reloading module ‘chan_iax2.so’ (Inter Asterisk eXchange (Ver 2))

[2019-03-10 10:57:38] NOTICE[4645] iax2/provision.c: No IAX provisioning configuration found, IAX provisioning disabled.

[2019-03-10 10:57:38] VERBOSE[4645] loader.c: Reloading module ‘chan_motif.so’ (Motif Jingle Channel Driver)

[2019-03-10 10:57:38] VERBOSE[4645] loader.c: Reloading module ‘chan_sip.so’ (Session Initiation Protocol (SIP))

[2019-03-10 10:57:38] VERBOSE[1187] chan_sip.c: Reloading SIP

[2019-03-10 10:57:38] VERBOSE[4645] loader.c: Reloading module ‘res_pjsip_outbound_registration.so’ (PJSIP Outbound Registration Su$

[2019-03-10 10:57:38] ERROR[4645] res_pjsip_config_wizard.c: Unable to load config file ‘pjsip_wizard.conf’

[2019-03-10 10:57:38] VERBOSE[4645] loader.c: Reloading module ‘res_pjsip_notify.so’ (CLI/AMI PJSIP NOTIFY Support)

[2019-03-10 10:57:38] VERBOSE[4645] loader.c: Reloading module ‘res_adsi.so’ (ADSI Resource)

[2019-03-10 10:57:38] VERBOSE[4645] loader.c: Reloading module ‘app_confbridge.so’ (Conference Bridge Application)

[2019-03-10 10:57:38] VERBOSE[1187] netsock2.c: Using SIP TOS bits 96

[2019-03-10 10:57:38] VERBOSE[1187] netsock2.c: Using SIP CoS mark 4

[2019-03-10 10:57:38] NOTICE[4645] confbridge/conf_config_parser.c: Adding default_menu menu to app_confbridge

[2019-03-10 10:57:38] VERBOSE[4645] loader.c: Reloading module ‘cel_manager.so’ (Asterisk Manager Interface CEL Backend)

[2019-03-10 10:57:38] VERBOSE[4645] loader.c: Reloading module ‘cel_odbc.so’ (ODBC CEL backend)

[2019-03-10 10:57:38] VERBOSE[4645] cel_odbc.c: Found CEL table cel@asteriskcdrdb.

[2019-03-10 10:57:38] VERBOSE[4645] loader.c: Reloading module ‘codec_speex.so’ (Speex Coder/Decoder)

[2019-03-10 10:57:38] VERBOSE[4645] loader.c: Reloading module ‘app_voicemail.so’ (Comedian Mail (Voicemail System))

[2019-03-10 10:57:38] WARNING[4645] app_voicemail.c: maxsilence should be less than minsecs or you may get empty messages

[2019-03-10 10:57:38] VERBOSE[4645] loader.c: Reloading module ‘app_playback.so’ (Sound File Playback Application)

[2019-03-10 10:57:38] VERBOSE[4645] loader.c: Reloading module ‘app_queue.so’ (True Call Queueing)

[2019-03-10 10:57:38] NOTICE[4645] app_queue.c: No queuerules.conf file found, queues will not follow penalty rules

[2019-03-10 10:57:38] VERBOSE[4645] asterisk.c: Remote UNIX connection disconnected

[2019-03-10 11:32:02] VERBOSE[1111] asterisk.c: Remote UNIX connection

[2019-03-10 11:32:02] VERBOSE[5571] asterisk.c: Remote UNIX connection disconnected

[2019-03-10 11:32:02] VERBOSE[1111] asterisk.c: Remote UNIX connection

[2019-03-10 11:32:02] VERBOSE[5571] asterisk.c: Remote UNIX connection disconnected

[2019-03-10 11:32:02] VERBOSE[1111] asterisk.c: Remote UNIX connection

[2019-03-10 11:32:02] VERBOSE[5574] asterisk.c: Remote UNIX connection disconnected

[2019-03-10 11:32:02] VERBOSE[1111] asterisk.c: Remote UNIX connection

[2019-03-10 11:32:02] VERBOSE[5577] asterisk.c: Remote UNIX connection disconnected

I’m puzzled because you are getting these errors loading the config, rather than when registration is actually attempted.

Confirm that in Advanced Settings, SIP Channel Driver is set to both, and in Asterisk SIP Settings, the pjsip settings are at defaults.

If that doesn’t uncover anything, I suggest that you shut down Linphone, delete extension 11111, apply config, reboot server and see whether you still get the error. If so, something is obviously corrupted and it may be easiest to restore from a backup if you have one, or reinstall.

Assuming that the 11111 errors are gone, create a new extension, e.g. 11113, leaving everything at defaults except the extension number and secret. Confirm that the log doesn’t show any errors for 11113.

Then, set up Linphone as extension 11113 and report results. If you post a log, first do
pjsip set logger on
at the Asterisk command prompt, so the log will show SIP traffic in addition to Asterisk actions.

Thanks for this,

I’ve tried everything you mentioned above and am still having the same issues :cry:

Do you think it’s worth me downloading a new raspbx-04-04-2018.zip file? I re-flashed the SD card with the image but wonder if the zip file could be corrupt somehow? (It all seemed to load okay however)

Not sure what to do now, I’ve added my latest log file below incase you have any more insights?

btw I wasn’t sure how to get to the Asterisk prompt - from my raspberry pi I just log into the FreePBX prompt via root@raspbx - maybe i’m misunderstanding something.

Thanks for all your help so far - here’s the log:

[2019-03-12 21:29:54] VERBOSE[945] asterisk.c: Remote UNIX connection
[2019-03-12 21:29:54] VERBOSE[9710] asterisk.c: Remote UNIX connection disconnected
[2019-03-12 21:29:55] VERBOSE[945] asterisk.c: Remote UNIX connection
[2019-03-12 21:29:55] VERBOSE[9719] asterisk.c: Remote UNIX connection disconnected
[2019-03-12 21:29:55] VERBOSE[945] asterisk.c: Remote UNIX connection
[2019-03-12 21:29:55] VERBOSE[9722] asterisk.c: Remote UNIX connection disconnected
[2019-03-12 21:29:55] VERBOSE[945] asterisk.c: Remote UNIX connection
[2019-03-12 21:29:55] VERBOSE[9725] asterisk.c: Remote UNIX connection disconnected
[2019-03-12 21:30:00] VERBOSE[945] asterisk.c: Remote UNIX connection
[2019-03-12 21:30:00] ERROR[9778] config_options.c: Unable to load config file ‘acl.conf’
[2019-03-12 21:30:00] WARNING[9778] named_acl.c: Could not reload ACL config
[2019-03-12 21:30:00] NOTICE[9778] cdr.c: CDR simple logging enabled.
[2019-03-12 21:30:00] VERBOSE[9778] cel.c: CEL logging enabled.
[2019-03-12 21:30:00] VERBOSE[9778] tcptls.c: TLS/SSL ECDH initialized (secp256r1), faster PFS cipher-suites enabled
[2019-03-12 21:30:00] VERBOSE[9778] tcptls.c: TLS/SSL certificate ok
[2019-03-12 21:30:00] Asterisk 13.20.0 built by root @ raspbx on a armv6l running Linux on 2018-04-03 18:02:05 UTC
[2019-03-12 21:30:00] VERBOSE[9778] indications.c: Setting default indication country to ‘us’
[2019-03-12 21:30:00] VERBOSE[9778] logger.c: Asterisk Queue Logger restarted
[2019-03-12 21:30:00] VERBOSE[9778] loader.c: Reloading module ‘res_odbc.so’ (ODBC resource)
[2019-03-12 21:30:00] NOTICE[9778] res_odbc.c: Registered ODBC class ‘asteriskcdrdb’ dsn->[MySQL-asteriskcdrdb]
[2019-03-12 21:30:00] VERBOSE[9778] loader.c: Reloading module ‘res_config_odbc.so’ (Realtime ODBC configuration)
[2019-03-12 21:30:00] VERBOSE[9778] loader.c: Reloading module ‘cdr_adaptive_odbc.so’ (Adaptive ODBC CDR backend)
[2019-03-12 21:30:00] VERBOSE[9778] cdr_adaptive_odbc.c: Found adaptive CDR table cdr@asteriskcdrdb.
[2019-03-12 21:30:00] VERBOSE[9778] cdr_adaptive_odbc.c: Found alias start for column calldate in cdr@asteriskcdrdb
[2019-03-12 21:30:00] VERBOSE[9778] loader.c: Reloading module ‘pbx_config.so’ (Text Extension Configuration)
[2019-03-12 21:30:00] VERBOSE[9778] pbx_variables.c: Setting global variable ‘MIXMON_BEEP’ to ‘’
[2019-03-12 21:30:00] VERBOSE[9778] pbx_variables.c: Setting global variable ‘QUEDEVSTATE’ to ‘TRUE’
[2019-03-12 21:30:00] VERBOSE[9778] pbx_variables.c: Setting global variable ‘DYNAMIC_FEATURES’ to ‘apprecord’
[2019-03-12 21:30:00] VERBOSE[9778] pbx_variables.c: Setting global variable ‘INTERCOMCODE’ to ‘*80’
[2019-03-12 21:30:00] VERBOSE[9778] pbx_variables.c: Setting global variable ‘ASTETCDIR’ to ‘/etc/asterisk’
[2019-03-12 21:30:00] VERBOSE[9778] pbx_variables.c: Setting global variable ‘ASTMODDIR’ to ‘/usr/lib/asterisk/modules’
[2019-03-12 21:30:00] VERBOSE[9778] pbx_variables.c: Setting global variable ‘ASTVARLIBDIR’ to ‘/var/lib/asterisk’
[2019-03-12 21:30:00] VERBOSE[9778] pbx_variables.c: Setting global variable ‘ASTAGIDIR’ to ‘/var/lib/asterisk/agi-bin’
[2019-03-12 21:30:00] VERBOSE[9778] pbx_variables.c: Setting global variable ‘ASTSPOOLDIR’ to ‘/var/spool/asterisk’
[2019-03-12 21:30:00] VERBOSE[9778] pbx_variables.c: Setting global variable ‘ASTRUNDIR’ to ‘/var/run/asterisk’
[2019-03-12 21:30:00] VERBOSE[9778] pbx_variables.c: Setting global variable ‘ASTLOGDIR’ to ‘/var/log/asterisk’
[2019-03-12 21:30:00] VERBOSE[9778] pbx_variables.c: Setting global variable ‘CWINUSEBUSY’ to ‘1’
[2019-03-12 21:30:00] VERBOSE[9778] pbx_variables.c: Setting global variable ‘AMPMGRUSER’ to ‘admin’
[2019-03-12 21:30:00] VERBOSE[9778] pbx_variables.c: Setting global variable ‘AMPMGRPASS’ to ‘e1c8851973fb516d14efe4c5a4863e04’
[2019-03-12 21:30:00] VERBOSE[9778] pbx_variables.c: Setting global variable ‘ASTMANAGERHOST’ to ‘localhost’
[2019-03-12 21:30:00] VERBOSE[9778] pbx_variables.c: Setting global variable ‘AMPDBENGINE’ to ‘mysql’
[2019-03-12 21:30:00] VERBOSE[9778] pbx_variables.c: Setting global variable ‘AMPDBHOST’ to ‘localhost’
[2019-03-12 21:30:00] VERBOSE[9778] pbx_variables.c: Setting global variable ‘AMPDBNAME’ to ‘asterisk’
[2019-03-12 21:30:00] VERBOSE[9778] pbx_variables.c: Setting global variable ‘AMPDBUSER’ to ‘freepbxuser’
[2019-03-12 21:30:00] VERBOSE[9778] pbx_variables.c: Setting global variable ‘AMPDBPASS’ to ‘1028ef4d5e163c9c803313e981626685’
[2019-03-12 21:30:00] VERBOSE[9778] pbx_variables.c: Setting global variable ‘AMPBIN’ to ‘/var/lib/asterisk/bin’
[2019-03-12 21:30:00] VERBOSE[9778] pbx_variables.c: Setting global variable ‘VMX_CONTEXT’ to ‘from-internal’
[2019-03-12 21:30:00] VERBOSE[9778] pbx_variables.c: Setting global variable ‘VMX_PRI’ to ‘1’
[2019-03-12 21:30:00] VERBOSE[9778] pbx_variables.c: Setting global variable ‘VMX_TIMEDEST_CONTEXT’ to ‘’
[2019-03-12 21:30:00] VERBOSE[9778] pbx_variables.c: Setting global variable ‘VMX_TIMEDEST_EXT’ to ‘dovm’
[2019-03-12 21:30:00] VERBOSE[9778] pbx_variables.c: Setting global variable ‘VMX_TIMEDEST_PRI’ to ‘1’
[2019-03-12 21:30:00] VERBOSE[9778] pbx_variables.c: Setting global variable ‘VMX_LOOPDEST_CONTEXT’ to ‘’
[2019-03-12 21:30:00] VERBOSE[9778] pbx_variables.c: Setting global variable ‘VMX_LOOPDEST_EXT’ to ‘dovm’
[2019-03-12 21:30:00] VERBOSE[9778] pbx_variables.c: Setting global variable ‘VMX_LOOPDEST_PRI’ to ‘1’
[2019-03-12 21:30:00] VERBOSE[9778] pbx_variables.c: Setting global variable ‘MIXMON_DIR’ to ‘’
[2019-03-12 21:30:00] VERBOSE[9778] pbx_variables.c: Setting global variable ‘MIXMON_POST’ to ‘’
[2019-03-12 21:30:00] VERBOSE[9778] pbx_variables.c: Setting global variable ‘DIAL_OPTIONS’ to ‘Ttr’
[2019-03-12 21:30:00] VERBOSE[9778] pbx_variables.c: Setting global variable ‘TRUNK_OPTIONS’ to ‘T’
[2019-03-12 21:30:00] VERBOSE[9778] pbx_variables.c: Setting global variable ‘TRUNK_RING_TIMER’ to ‘300’
[2019-03-12 21:30:00] VERBOSE[9778] pbx_variables.c: Setting global variable ‘MIXMON_FORMAT’ to ‘wav’
[2019-03-12 21:30:00] VERBOSE[9778] pbx_variables.c: Setting global variable ‘REC_POLICY’ to ‘caller’
[2019-03-12 21:30:00] VERBOSE[9778] pbx_variables.c: Setting global variable ‘RINGTIMER_DEFAULT’ to ‘15’
[2019-03-12 21:30:00] VERBOSE[9778] pbx_variables.c: Setting global variable ‘TRANSFER_CONTEXT’ to ‘from-internal-xfer’
[2019-03-12 21:30:00] VERBOSE[9778] pbx_variables.c: Setting global variable ‘ASTVERSION’ to ‘13.20.0’
[2019-03-12 21:30:00] VERBOSE[9778] pbx_variables.c: Setting global variable ‘ASTCHANDAHDI’ to ‘1’
[2019-03-12 21:30:00] VERBOSE[9778] pbx_variables.c: Setting global variable ‘NULL’ to ‘""’
[2019-03-12 21:30:00] VERBOSE[9778] pbx_variables.c: Setting global variable ‘ALLOW_SIP_ANON’ to ‘no’
[2019-03-12 21:30:00] VERBOSE[9778] pbx_variables.c: Setting global variable ‘SIPLANG’ to ‘en’
[2019-03-12 21:30:00] WARNING[9778] pbx_config.c: The use of ‘_.’ for an extension is strongly discouraged and can have unexpected behavior. Please use ‘X.’ instead at line 190 of /etc/asterisk/extensions_additional.conf
[2019-03-12 21:30:00] WARNING[9778] pbx_config.c: The use of '
.’ for an extension is strongly discouraged and can have unexpected behavior. Please use ‘X.’ instead at line 191 of /etc/asterisk/extensions_additional.conf
[2019-03-12 21:30:00] WARNING[9778] pbx_config.c: The use of '
.’ for an extension is strongly discouraged and can have unexpected behavior. Please use ‘X.’ instead at line 799 of /etc/asterisk/extensions_additional.conf
[2019-03-12 21:30:00] WARNING[9778] pbx_config.c: The use of '
.’ for an extension is strongly discouraged and can have unexpected behavior. Please use ‘X.’ instead at line 800 of /etc/asterisk/extensions_additional.conf
[2019-03-12 21:30:00] WARNING[9778] pbx_config.c: The use of '
.’ for an extension is strongly discouraged and can have unexpected behavior. Please use ‘X.’ instead at line 801 of /etc/asterisk/extensions_additional.conf
[2019-03-12 21:30:00] WARNING[9778] pbx_config.c: The use of '
.’ for an extension is strongly discouraged and can have unexpected behavior. Please use ‘X.’ instead at line 127 of extensions.conf
[2019-03-12 21:30:00] WARNING[9778] pbx_config.c: The use of '
.’ for an extension is strongly discouraged and can have unexpected behavior. Please use ‘X.’ instead at line 128 of extensions.conf
[2019-03-12 21:30:00] WARNING[9778] pbx_config.c: The use of '
.’ for an extension is strongly discouraged and can have unexpected behavior. Please use ‘X.’ instead at line 129 of extensions.conf
[2019-03-12 21:30:00] WARNING[9778] pbx_config.c: The use of '
.’ for an extension is strongly discouraged and can have unexpected behavior. Please use ‘X.’ instead at line 130 of extensions.conf
[2019-03-12 21:30:00] WARNING[9778] pbx_config.c: The use of '
.’ for an extension is strongly discouraged and can have unexpected behavior. Please use ‘X.’ instead at line 131 of extensions.conf
[2019-03-12 21:30:00] WARNING[9778] pbx_config.c: The use of '
.’ for an extension is strongly discouraged and can have unexpected behavior. Please use ‘X.’ instead at line 132 of extensions.conf
[2019-03-12 21:30:00] WARNING[9778] pbx_config.c: The use of '
.’ for an extension is strongly discouraged and can have unexpected behavior. Please use ‘X.’ instead at line 133 of extensions.conf
[2019-03-12 21:30:00] WARNING[9778] pbx_config.c: The use of '
.’ for an extension is strongly discouraged and can have unexpected behavior. Please use ‘X.’ instead at line 172 of extensions.conf
[2019-03-12 21:30:00] WARNING[9778] pbx_config.c: The use of '
.’ for an extension is strongly discouraged and can have unexpected behavior. Please use ‘X.’ instead at line 173 of extensions.conf
[2019-03-12 21:30:00] WARNING[9778] pbx_config.c: The use of '
.’ for an extension is strongly discouraged and can have unexpected behavior. Please use ‘X.’ instead at line 174 of extensions.conf
[2019-03-12 21:30:00] WARNING[9778] pbx_config.c: The use of '
.’ for an extension is strongly discouraged and can have unexpected behavior. Please use ‘X.’ instead at line 186 of extensions.conf
[2019-03-12 21:30:00] WARNING[9778] pbx_config.c: The use of '
.’ for an extension is strongly discouraged and can have unexpected behavior. Please use ‘X.’ instead at line 187 of extensions.conf
[2019-03-12 21:30:00] WARNING[9778] pbx_config.c: The use of '
.’ for an extension is strongly discouraged and can have unexpected behavior. Please use ‘_X.’ instead at line 188 of extensions.conf
[2019-03-12 21:30:00] VERBOSE[9778] pbx.c: Time to scan old dialplan and merge leftovers back into the new: 0.002116 sec
[2019-03-12 21:30:00] VERBOSE[9778] pbx.c: Time to restore hints and swap in new dialplan: 0.000026 sec
[2019-03-12 21:30:00] VERBOSE[9778] pbx.c: Time to delete the old dialplan: 0.002854 sec
[2019-03-12 21:30:00] VERBOSE[9778] pbx.c: Total time merge_contexts_delete: 0.004996 sec
[2019-03-12 21:30:00] VERBOSE[9778] pbx.c: pbx_config successfully loaded 89 contexts (enable debug for details).
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘from-did-direct’ tries to include nonexistent context ‘ext-findmefollow’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘from-internal-xfer’ tries to include nonexistent context ‘from-internal-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘from-internal-noxfer’ tries to include nonexistent context ‘from-internal-noxfer-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘from-pstn’ tries to include nonexistent context ‘from-pstn-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘from-internal-noxfer-additional’ tries to include nonexistent context ‘from-internal-noxfer-additional-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘from-internal-additional’ tries to include nonexistent context ‘from-internal-additional-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘macro-parked-call’ tries to include nonexistent context ‘macro-parked-call-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘func-apply-sipheaders’ tries to include nonexistent context ‘func-apply-sipheaders-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘func-set-sipheader’ tries to include nonexistent context ‘func-set-sipheader-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘macro-dial-one’ tries to include nonexistent context ‘macro-dial-one-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘macro-hangupcall’ tries to include nonexistent context ‘macro-hangupcall-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘macro-blkvm-check’ tries to include nonexistent context ‘macro-blkvm-check-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘macro-blkvm-clr’ tries to include nonexistent context ‘macro-blkvm-clr-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘macro-blkvm-set’ tries to include nonexistent context ‘macro-blkvm-set-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘macro-blkvm-setifempty’ tries to include nonexistent context ‘macro-blkvm-setifempty-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘originate-skipvm’ tries to include nonexistent context ‘originate-skipvm-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘macro-simple-dial’ tries to include nonexistent context ‘macro-simple-dial-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘macro-exten-vm’ tries to include nonexistent context ‘macro-exten-vm-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘macro-vm’ tries to include nonexistent context ‘macro-vm-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘macro-block-cf’ tries to include nonexistent context ‘macro-block-cf-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘macro-setmusic’ tries to include nonexistent context ‘macro-setmusic-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘macro-dial-confirm’ tries to include nonexistent context ‘macro-dial-confirm-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘from-dahdi’ tries to include nonexistent context ‘from-dahdi-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘from-zaptel’ tries to include nonexistent context ‘from-zaptel-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘macro-outbound-callerid’ tries to include nonexistent context ‘macro-outbound-callerid-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘macro-user-callerid’ tries to include nonexistent context ‘macro-user-callerid-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘macro-privacy-mgr’ tries to include nonexistent context ‘macro-privacy-mgr-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘sub-pincheck’ tries to include nonexistent context ‘sub-pincheck-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘macro-auto-blkvm’ tries to include nonexistent context ‘macro-auto-blkvm-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘macro-auto-confirm’ tries to include nonexistent context ‘macro-auto-confirm-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘macro-confirm’ tries to include nonexistent context ‘macro-confirm-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘sub-presencestate-display’ tries to include nonexistent context ‘sub-presencestate-display-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘bad-number’ tries to include nonexistent context ‘bad-number-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘app-blackhole’ tries to include nonexistent context ‘app-blackhole-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘outbound-allroutes’ tries to include nonexistent context ‘outbound-allroutes-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘macro-prepend-cid’ tries to include nonexistent context ‘macro-prepend-cid-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘from-did-direct-ivr’ tries to include nonexistent context ‘from-did-direct-ivr-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘ext-local’ tries to include nonexistent context ‘ext-local-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘ext-did-catchall’ tries to include nonexistent context ‘ext-did-catchall-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘ext-did’ tries to include nonexistent context ‘ext-did-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘ext-test’ tries to include nonexistent context ‘ext-test-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘app-chanspy’ tries to include nonexistent context ‘app-chanspy-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘app-pickup’ tries to include nonexistent context ‘app-pickup-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘findmefollow-ringallv2’ tries to include nonexistent context ‘findmefollow-ringallv2-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘ext-local-confirm’ tries to include nonexistent context ‘ext-local-confirm-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘macro-dial’ tries to include nonexistent context ‘macro-dial-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘app-vmmain’ tries to include nonexistent context ‘app-vmmain-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘app-dialvm’ tries to include nonexistent context ‘app-dialvm-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘vm-callme’ tries to include nonexistent context ‘vm-callme-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘ext-group’ tries to include nonexistent context ‘ext-group-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘macro-systemrecording’ tries to include nonexistent context ‘macro-systemrecording-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘systemrecording-gui’ tries to include nonexistent context ‘systemrecording-gui-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘sub-hr24format’ tries to include nonexistent context ‘sub-hr24format-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘app-speakingclock’ tries to include nonexistent context ‘app-speakingclock-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘sub-hr12format’ tries to include nonexistent context ‘sub-hr12format-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘app-speakextennum’ tries to include nonexistent context ‘app-speakextennum-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘app-echo-test-echo’ tries to include nonexistent context ‘app-echo-test-echo-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘app-echo-test’ tries to include nonexistent context ‘app-echo-test-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘app-calltrace-perform’ tries to include nonexistent context ‘app-calltrace-perform-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘app-calltrace’ tries to include nonexistent context ‘app-calltrace-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘ext-featurecodes’ tries to include nonexistent context ‘ext-featurecodes-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘macro-one-touch-record’ tries to include nonexistent context ‘macro-one-touch-record-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘sub-record-hh-check’ tries to include nonexistent context ‘sub-record-hh-check-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘sub-record-check’ tries to include nonexistent context ‘sub-record-check-custom’
[2019-03-12 21:30:00] WARNING[9778] pbx.c: Context ‘sub-record-cancel’ tries to include nonexistent context ‘sub-record-cancel-custom’
[2019-03-12 21:30:00] VERBOSE[9778] loader.c: Reloading module ‘res_pjproject.so’ (PJPROJECT Log and Utility Support)
[2019-03-12 21:30:00] ERROR[9778] res_sorcery_config.c: Unable to load config file ‘pjproject.conf’
[2019-03-12 21:30:00] VERBOSE[9778] loader.c: Reloading module ‘res_pjsip.so’ (Basic SIP resource)
[2019-03-12 21:30:00] ERROR[9784] res_pjsip_config_wizard.c: Unable to load config file ‘pjsip_wizard.conf’
[2019-03-12 21:30:01] ERROR[9784] res_pjsip_config_wizard.c: Unable to load config file ‘pjsip_wizard.conf’
[2019-03-12 21:30:01] ERROR[9784] res_pjsip_config_wizard.c: Unable to load config file ‘pjsip_wizard.conf’
[2019-03-12 21:30:01] ERROR[9784] res_pjsip_endpoint_identifier_ip.c: Identify ‘11111-identify’ is not configured to match anything.
[2019-03-12 21:30:01] ERROR[9784] res_sorcery_config.c: Could not create an object of type ‘identify’ with id ‘11111-identify’ from configuration file ‘pjsip.conf’
[2019-03-12 21:30:01] ERROR[9784] res_pjsip_endpoint_identifier_ip.c: Identify ‘99999-identify’ is not configured to match anything.
[2019-03-12 21:30:01] ERROR[9784] res_sorcery_config.c: Could not create an object of type ‘identify’ with id ‘99999-identify’ from configuration file ‘pjsip.conf’
[2019-03-12 21:30:01] ERROR[9784] res_pjsip_config_wizard.c: Unable to load config file ‘pjsip_wizard.conf’
[2019-03-12 21:30:01] NOTICE[9784] sorcery.c: Type ‘system’ is not reloadable, maintaining previous values
[2019-03-12 21:30:01] ERROR[9784] res_pjsip_config_wizard.c: Unable to load config file ‘pjsip_wizard.conf’
[2019-03-12 21:30:01] VERBOSE[9778] loader.c: Reloading module ‘res_pjsip_outbound_publish.so’ (PJSIP Outbound Publish Support)
[2019-03-12 21:30:01] VERBOSE[9778] loader.c: Reloading module ‘res_xmpp.so’ (Asterisk XMPP Interface)
[2019-03-12 21:30:01] VERBOSE[9778] loader.c: Reloading module ‘res_crypto.so’ (Cryptographic Digital Signatures)
[2019-03-12 21:30:01] VERBOSE[9778] loader.c: Reloading module ‘res_ari.so’ (Asterisk RESTful Interface)
[2019-03-12 21:30:01] ERROR[9778] ari/config.c: No configured users for ARI
[2019-03-12 21:30:01] VERBOSE[9778] loader.c: Reloading module ‘res_fax.so’ (Generic FAX Applications)
[2019-03-12 21:30:01] NOTICE[9778] res_fax.c: Configuration file ‘res_fax.conf’ not found, not changing options.
[2019-03-12 21:30:01] VERBOSE[9778] loader.c: Reloading module ‘res_config_curl.so’ (Realtime Curl configuration)
[2019-03-12 21:30:01] VERBOSE[9778] loader.c: Reloading module ‘res_config_mysql.so’ (MySQL RealTime Configuration Driver)
[2019-03-12 21:30:01] VERBOSE[9778] res_config_mysql.c: MySQL RealTime reloaded.
[2019-03-12 21:30:01] VERBOSE[9778] loader.c: Reloading module ‘res_pjsip_authenticator_digest.so’ (PJSIP authentication resource)
[2019-03-12 21:30:01] VERBOSE[9778] loader.c: Reloading module ‘res_pjsip_endpoint_identifier_ip.so’ (PJSIP IP endpoint identifier)
[2019-03-12 21:30:01] ERROR[9778] res_pjsip_config_wizard.c: Unable to load config file ‘pjsip_wizard.conf’
[2019-03-12 21:30:01] VERBOSE[9778] loader.c: Reloading module ‘res_musiconhold.so’ (Music On Hold Resource)
[2019-03-12 21:30:01] VERBOSE[9778] loader.c: Reloading module ‘res_rtp_asterisk.so’ (Asterisk RTP Stack)
[2019-03-12 21:30:01] VERBOSE[9778] res_rtp_asterisk.c: RTP Allocating from port range 10000 -> 20000
[2019-03-12 21:30:01] VERBOSE[9778] loader.c: Reloading module ‘res_pjsip_mwi.so’ (PJSIP MWI resource)
[2019-03-12 21:30:01] VERBOSE[9778] loader.c: Reloading module ‘chan_iax2.so’ (Inter Asterisk eXchange (Ver 2))
[2019-03-12 21:30:01] NOTICE[9778] iax2/provision.c: No IAX provisioning configuration found, IAX provisioning disabled.
[2019-03-12 21:30:01] VERBOSE[9778] loader.c: Reloading module ‘chan_motif.so’ (Motif Jingle Channel Driver)
[2019-03-12 21:30:01] VERBOSE[9778] loader.c: Reloading module ‘chan_sip.so’ (Session Initiation Protocol (SIP))
[2019-03-12 21:30:01] VERBOSE[1022] chan_sip.c: Reloading SIP
[2019-03-12 21:30:01] VERBOSE[1022] netsock2.c: Using SIP TOS bits 96
[2019-03-12 21:30:01] VERBOSE[1022] netsock2.c: Using SIP CoS mark 4
[2019-03-12 21:30:01] VERBOSE[9778] loader.c: Reloading module ‘res_pjsip_outbound_registration.so’ (PJSIP Outbound Registration Support)
[2019-03-12 21:30:01] ERROR[9778] res_pjsip_config_wizard.c: Unable to load config file ‘pjsip_wizard.conf’
[2019-03-12 21:30:01] VERBOSE[9778] loader.c: Reloading module ‘res_pjsip_notify.so’ (CLI/AMI PJSIP NOTIFY Support)
[2019-03-12 21:30:01] VERBOSE[9778] loader.c: Reloading module ‘res_adsi.so’ (ADSI Resource)
[2019-03-12 21:30:01] VERBOSE[9778] loader.c: Reloading module ‘app_confbridge.so’ (Conference Bridge Application)
[2019-03-12 21:30:01] NOTICE[9778] confbridge/conf_config_parser.c: Adding default_menu menu to app_confbridge
[2019-03-12 21:30:01] VERBOSE[9778] loader.c: Reloading module ‘cel_manager.so’ (Asterisk Manager Interface CEL Backend)
[2019-03-12 21:30:01] VERBOSE[9778] loader.c: Reloading module ‘cel_odbc.so’ (ODBC CEL backend)
[2019-03-12 21:30:01] VERBOSE[9778] cel_odbc.c: Found CEL table cel@asteriskcdrdb.
[2019-03-12 21:30:01] VERBOSE[9778] loader.c: Reloading module ‘codec_speex.so’ (Speex Coder/Decoder)
[2019-03-12 21:30:01] VERBOSE[9778] loader.c: Reloading module ‘app_voicemail.so’ (Comedian Mail (Voicemail System))
[2019-03-12 21:30:01] WARNING[9778] app_voicemail.c: maxsilence should be less than minsecs or you may get empty messages
[2019-03-12 21:30:01] VERBOSE[9778] loader.c: Reloading module ‘app_playback.so’ (Sound File Playback Application)
[2019-03-12 21:30:01] VERBOSE[9778] loader.c: Reloading module ‘app_queue.so’ (True Call Queueing)
[2019-03-12 21:30:01] NOTICE[9778] app_queue.c: No queuerules.conf file found, queues will not follow penalty rules
[2019-03-12 21:30:01] VERBOSE[9778] asterisk.c: Remote UNIX connection disconnected

Sorry, I misdiagnosed your issue completely. Apparently, in at least some configurations (including my own test system), it’s normal and does not affect registration or calling:

So now, we need to see what gets logged (if anything) when your Linphone attempts to register.
Do
pjsip set logger on
from the Asterisk console, before starting Linphone.

If nothing gets logged, try running tcpdump on the PBX and see whether any SIP packets from Linphone are reaching it.

Great, thank you and no need to apologise - I very much appreciate the help!

I’ll take a look at this a little later today when I get home from work.

Just to confirm before this however, can you confirm how I reach the Asterisk console? I assume I am logging onto the FreePBX part when I sign-into the Pi (i.e signing into root@raspbx) - I tried running the pjsip command there and it wasn’t recognised so assume I need to logon to the Asterisk console elsewhere?

Thanks very much,

Ed

From the root shell prompt, type
asterisk -r
to connect to the Asterisk console.

Perfect - thanks. I’ll let you know how I get on.

Hi - so I turned on the logger from the Asterisk console as suggested and now seeing very little in terms of logging:

[2019-03-13 19:41:04] VERBOSE[1105] asterisk.c: Remote UNIX connection
[2019-03-13 19:43:04] VERBOSE[1398] asterisk.c: Remote UNIX connection disconnected

I then tried to running tcpdump but it doesn’t seem to be recognised -

I get:
-bash: tcpdump: command not found from raspbx
No such command ‘tcpdump’ (type ‘core show help tcpdump’ for other possible commands) from Asterisk

I tried running:

tcpdump
sudo tcpdump
tcpdump -s0 -w/tmp/capture.pcap -C50 udp and port 5060

But none worked in either FreePBX or Asterisk. Any ideas? I’m sure i’m missing something obvious but can’t think what.

Thanks,

Ed

Obviously you are missing the binary tcpdump, in Debian you could fix that with

sudo apt-get -y install tcpdump

Thanks @dicko - i’ve got tcpdump onto my Pi now if needed.

@Stewart1 - Turns out that the logfile captured quite a bit of information when I attempted to register with logger switched on - It obviously just took a while to show up in the logfile so I missed it when I looked on the 13th.

I have an issue however as I’m not permitted to attach the logs to these posts and they are far bigger than the maximum number of lines allowed per post in this forum (max is 32k lines, the file is ~295k lines). Do you think it’s worth grepping the file for certain information before pasting it here? Or maybe I could upload to the cloud via dropbox or similar?

Thanks very much

Ed

Select a section of log showing from a few seconds before through a few seconds after a registration attempt.

Go to
https://pastebin.freepbx.org
and paste your log there. You will get a link similar to:
https://pastebin.freepbx.org/view/fa3c7524
Try to post the link here. If the forum doesn’t allow you to post links because you’re too new, edit the link by removing https:// and replacing the . before org with %2E
Insert the result into your post on a line by itself:
pastebin.freepbx%2Eorg/view/fa3c7524
This can be easily opened by the reader, e.g. triple-click to select it, right-click and choose “Go to …”

Awesome - thanks @Stewart1 - here you go:

https://pastebin.freepbx.org/view/55b10cc9

Unfortunately, the log shows only initialization after reload. If the time period includes a registration attempt after 2019-03-13 20:06:52, then Asterisk received nothing.

Try again. After a reload completes, at the Asterisk console, type
pjsip set logger on
or if using chan_sip,
sip set debug on
Leave the console window open and start Linphone. If stuff appears, post it (via pastebin.freepbx.org).

If there is nothing, see whether the registration attempts show up in tcpdump. If so, this is likely a FreePBX firewall or fail2ban issue; try disabling them.

If nothing appears in tcpdump, either, then (assuming that Linphone is on the same LAN as the PBX), Linphone is either misconfigured or malfunctioning. Post screenshots of settings, or try with another SIP app or softphone.

To add to what Stewart1 said this looks to me like a straightforward connectivity issue. Try a ping direct from the machine you’re running linphone on to the raspbx. For the ping, use the exact spelling / format for the hostname that you used in the settings on linphone. Let us know what you get back from that.

Tell us a little about your network. Are the pbx and the linphone machine on the same ip4 network? Are you by chance trying to connect to the pbx from outside your network?

Thanks @dgrigg and @Stewart1 -

I’m not at home at the moment so won’t be able to test your suggestions until a little later this week but thought I’d respond on @dgrigg questions in advance.

This is all being done on a straightforward home ip4 network with all devices connected via WiFi (including the Raspberry Pi which has a USB WiFi adapter). Linphone is being run on an Android mobile phone, with the FreePBX/Asterisk server being run on the aforementioned Pi. I have been connecting to the Pi without issue via ssh using my MacBook so would be surprised if I found myself unable to ping the device from my mobile but will certainly give it a go.

I also think @Stewart1’s suggestion of using a different SIP app is a good call - I’ll try using my wife’s iPad as well incase it’s an issue with my phone.

I’ll report back a little later in the week once I’ve run all of the suggested checks in any case.

Thanks!

Ed

EDIT: I couldn’t add a new post however wanted to provide an update here to anyone who might be reading this - turns out I was having two issues 1) I was trying to connect via SIP TLS whereas Asterix was automatically setup to use SIP UDP 2) Linphone was being a pain as far as I could tell, I switched to the free version of Zoiper and it worked right away.

Thanks again to @Stewart1 and dgrigg for the assistance.

This topic was automatically closed 7 days after the last reply. New replies are no longer allowed.