[Nov 23 11:55:36] Asterisk GIT-13-13.15.0-rc1-700-g3d48cf2M built by rmudgett @ mudtower on a x86_64 running Linux on 2017-11-11 15:37:37 UTC
[Nov 23 11:55:36] NOTICE[4786] cdr.c: CDR simple logging enabled.
[Nov 23 11:55:36] NOTICE[4786] loader.c: 374 modules will be loaded.
[Nov 23 11:55:36] ERROR[4786] config_options.c: Unable to load config file 'statsd.conf'
[Nov 23 11:55:36] WARNING[4786] res_odbc.c: Unable to load config file res_odbc.conf
[Nov 23 11:55:37] ERROR[4786] res_pjsip_config_wizard.c: Unable to load config file 'pjsip_wizard.conf'
[Nov 23 11:55:37] ERROR[4786] res_pjsip_config_wizard.c: Unable to load config file 'pjsip_wizard.conf'
[Nov 23 11:55:37] ERROR[4786] res_pjsip_config_wizard.c: Unable to load config file 'pjsip_wizard.conf'
[Nov 23 11:55:37] WARNING[4786] res_stun_monitor.c: Unable to load config res_stun_monitor.conf
[Nov 23 11:55:37] NOTICE[4786] res_smdi.c: Unable to load config smdi.conf: SMDI disabled
[Nov 23 11:55:37] NOTICE[4786] res_smdi.c: No SMDI interfaces are available to listen on, not starting SMDI listener.
[Nov 23 11:55:37] ERROR[4786] res_phoneprov.c: Unable to load config phoneprov.conf
[Nov 23 11:55:37] ERROR[4786] res_phoneprov.c: Unable to load provisioning profiles.
[Nov 23 11:55:37] ERROR[4786] config_options.c: Unable to load config file 'xmpp.conf'
[Nov 23 11:55:37] ERROR[4786] config_options.c: Unable to load config file 'hep.conf'
[Nov 23 11:55:37] ERROR[4786] res_calendar.c: Unable to load config calendar.conf
[Nov 23 11:55:37] WARNING[4786] res_pktccops.c: Unable to load config file res_pktccops.conf
[Nov 23 11:55:37] ERROR[4786] res_config_sqlite.c: Unable to load res_config_sqlite.conf
[Nov 23 11:55:37] ERROR[4786] res_config_ldap.c: Cannot load configuration file: res_ldap.conf
[Nov 23 11:55:37] ERROR[4786] res_config_ldap.c: Cannot load LDAP RealTime driver.
[Nov 23 11:55:37] WARNING[4786] res_config_pgsql.c: Unable to load config res_pgsql.conf
[Nov 23 11:55:37] ERROR[4786] res_config_sqlite3.c: Missing config file 'res_config_sqlite3.conf'
[Nov 23 11:55:37] ERROR[4786] res_pjsip_config_wizard.c: Unable to load config file 'pjsip_wizard.conf'
[Nov 23 11:55:37] ERROR[4786] chan_iax2.c: Unable to load config iax.conf
[Nov 23 11:55:37] VERBOSE[4786] chan_sip.c: SIP channel loading...
[Nov 23 11:55:37] NOTICE[4786] chan_sip.c: Unable to load config sip.conf
[Nov 23 11:55:37] ERROR[4786] message.c: No 'sip' message technology found.
[Nov 23 11:55:37] WARNING[4786] channel.c: Already have a handler for type 'MulticastRTP'
[Nov 23 11:55:37] ERROR[4786] chan_rtp.c: Unable to register channel class 'MulticastRTP'
[Nov 23 11:55:37] ERROR[4786] config_options.c: Unable to load config file 'motif.conf'
[Nov 23 11:55:37] ERROR[4786] chan_motif.c: Unable to read config file motif.conf. Module loaded but not running.
[Nov 23 11:55:38] ERROR[4786] res_pjsip_config_wizard.c: Unable to load config file 'pjsip_wizard.conf'
[Nov 23 11:55:38] ERROR[4786] res_pjsip_config_wizard.c: Unable to load config file 'pjsip_wizard.conf'
[Nov 23 11:55:38] WARNING[4786] res_phoneprov.c: Provider 'res_pjsip_phoneprov_provider' cannot be registered: res_phoneprov not loaded.
[Nov 23 11:55:38] ERROR[4786] res_pjsip_phoneprov_provider.c: Unable to register pjsip phoneprov provider.
[Nov 23 11:55:38] ERROR[4786] config_options.c: Unable to load config file 'agents.conf'
[Nov 23 11:55:38] ERROR[4786] app_agent_pool.c: Unable to load config. Not loading module.
[Nov 23 11:55:38] NOTICE[4786] confbridge/conf_config_parser.c: Adding default_menu menu to app_confbridge
[Nov 23 11:55:38] WARNING[4786] res_calendar.c: Calendar support disabled, not loading ical calendar module
[Nov 23 11:55:38] WARNING[4786] res_calendar.c: Calendar support disabled, not loading caldav calendar module
[Nov 23 11:55:38] WARNING[4786] res_calendar.c: Calendar support disabled, not loading exchange calendar module
[Nov 23 11:55:38] WARNING[4786] res_calendar.c: Calendar support disabled, not loading ews calendar module
[Nov 23 11:55:38] WARNING[4786] cel_odbc.c: Unable to load cel_odbc.conf.  No ODBC CEL records!
[Nov 23 11:55:38] WARNING[4786] cdr_manager.c: Failed to load configuration file. Module not activated.
[Nov 23 11:55:38] ERROR[4786] cel_custom.c: Unable to load cel_custom.conf. Not logging CEL to custom CSVs.
[Nov 23 11:55:38] ERROR[4786] cdr_syslog.c: Unable to load cdr_syslog.conf. Not logging custom CSV CDRs to syslog.
[Nov 23 11:55:38] WARNING[4786] cdr_adaptive_odbc.c: Unable to load cdr_adaptive_odbc.conf.  No adaptive ODBC CDRs.
[Nov 23 11:55:38] WARNING[4786] app_voicemail.c: maxsilence should be less than minsecs or you may get empty messages
[Nov 23 11:55:38] NOTICE[4786] app_voicemail.c: Failed reading voicemail password from /var/spool/asterisk/voicemail/default/2567768710/secret.conf, using secret from config file
[Nov 23 11:55:38] ERROR[4786] config_options.c: Unable to load config file 'app_skel.conf'
[Nov 23 11:55:38] NOTICE[4786] func_odbc.c: Unable to load config for func_odbc: func_odbc.conf
[Nov 23 11:55:38] WARNING[4786] app_minivm.c: Failed to load configuration file. Module activated with default settings.
[Nov 23 11:55:38] WARNING[4786] res_snmp.c: Could not load res_snmp.conf
[Nov 23 11:55:38] WARNING[4786] app_followme.c: No follow me config file (followme.conf), so no follow me
[Nov 23 11:55:38] WARNING[4786] res_hep_pjsip.c: res_hep is not loaded or running; declining module load
[Nov 23 11:55:38] ERROR[4786] app_amd.c: Configuration file amd.conf missing.
[Nov 23 11:55:38] WARNING[4786] res_hep_rtcp.c: res_hep is not loaded or running; declining module load
[Nov 23 11:55:38] WARNING[4786] app_festival.c: No such configuration file festival.conf
[Nov 23 11:55:38] NOTICE[4786] app_queue.c: No queuerules.conf file found, queues will not follow penalty rules
[Nov 23 11:55:38] NOTICE[4786] app_queue.c: No call queueing config file (queues.conf), so no call queues
[Nov 23 11:55:38] VERBOSE[4786] asterisk.c: Asterisk Ready.
[Nov 23 11:55:48] VERBOSE[4846] dial.c: Called 10@tst_endpoint
[Nov 23 11:55:48] VERBOSE[4847][C-00000000] pbx.c: Executing [10@tst_endpoint:1] NoOp("Local/10@tst_endpoint-00000000;2", "") in new stack
[Nov 23 11:55:48] VERBOSE[4847][C-00000000] pbx.c: Executing [10@tst_endpoint:2] NoOp("Local/10@tst_endpoint-00000000;2", "endpoint 1001 followme: 'template_value'") in new stack
[Nov 23 11:55:48] VERBOSE[4847][C-00000000] pbx.c: Executing [10@tst_endpoint:3] NoOp("Local/10@tst_endpoint-00000000;2", "endpoint 1002 followme: 'template_value'") in new stack
[Nov 23 11:55:48] VERBOSE[4847][C-00000000] pbx.c: Executing [10@tst_endpoint:4] NoOp("Local/10@tst_endpoint-00000000;2", "endpoint 1003 followme: 'section_value'") in new stack
[Nov 23 11:55:48] VERBOSE[4847][C-00000000] pbx.c: Executing [10@tst_endpoint:5] NoOp("Local/10@tst_endpoint-00000000;2", "endpoint 1001 @fred: 'fred_template'") in new stack
[Nov 23 11:55:48] VERBOSE[4847][C-00000000] pbx.c: Executing [10@tst_endpoint:6] NoOp("Local/10@tst_endpoint-00000000;2", "endpoint 1002 @fred: 'fred_override'") in new stack
[Nov 23 11:55:48] VERBOSE[4847][C-00000000] pbx.c: Executing [10@tst_endpoint:7] NoOp("Local/10@tst_endpoint-00000000;2", "endpoint 1003 @fred: 'fred_section'") in new stack
[Nov 23 11:55:48] VERBOSE[4847][C-00000000] pbx.c: Executing [10@tst_endpoint:8] Hangup("Local/10@tst_endpoint-00000000;2", "") in new stack
[Nov 23 11:55:48] VERBOSE[4847][C-00000000] pbx.c: Spawn extension (tst_endpoint, 10, 8) exited non-zero on 'Local/10@tst_endpoint-00000000;2'
[Nov 23 11:55:56] VERBOSE[4848] dial.c: Called 11@tst_endpoint
[Nov 23 11:55:56] VERBOSE[4849][C-00000001] pbx.c: Executing [11@tst_endpoint:1] NoOp("Local/11@tst_endpoint-00000001;2", "") in new stack
[Nov 23 11:55:56] VERBOSE[4849][C-00000001] pbx.c: Executing [11@tst_endpoint:2] Dial("Local/11@tst_endpoint-00000001;2", "PJSIP/1001,2,b(predial)") in new stack
[Nov 23 11:55:56] VERBOSE[4849][C-00000001] app_stack.c: PJSIP/1001-00000000 Internal Gosub(tst_endpoint,11,predial) start
[Nov 23 11:55:56] VERBOSE[4849][C-00000001] pbx.c: Executing [11@tst_endpoint:4] NoOp("PJSIP/1001-00000000", "This is the value of followme:'template_value'") in new stack
[Nov 23 11:55:56] VERBOSE[4849][C-00000001] pbx.c: Executing [11@tst_endpoint:5] Return("PJSIP/1001-00000000", "") in new stack
[Nov 23 11:55:56] VERBOSE[4849][C-00000001] app_stack.c: Spawn extension (tst_endpoint, 11, 1) exited non-zero on 'PJSIP/1001-00000000'
[Nov 23 11:55:56] VERBOSE[4849][C-00000001] app_stack.c: PJSIP/1001-00000000 Internal Gosub(tst_endpoint,11,predial) complete GOSUB_RETVAL=
[Nov 23 11:55:56] VERBOSE[4849][C-00000001] app_dial.c: Called PJSIP/1001
[Nov 23 11:55:56] VERBOSE[4849][C-00000001] app_dial.c: Everyone is busy/congested at this time (1:0/0/1)
[Nov 23 11:55:56] VERBOSE[4849][C-00000001] pbx.c: Executing [11@tst_endpoint:3] Hangup("Local/11@tst_endpoint-00000001;2", "") in new stack
[Nov 23 11:55:56] VERBOSE[4849][C-00000001] pbx.c: Spawn extension (tst_endpoint, 11, 3) exited non-zero on 'Local/11@tst_endpoint-00000001;2'
[Nov 23 11:56:01] VERBOSE[4851] dial.c: Called 12@tst_endpoint
[Nov 23 11:56:01] VERBOSE[4852][C-00000002] pbx.c: Executing [12@tst_endpoint:1] NoOp("Local/12@tst_endpoint-00000002;2", "") in new stack
[Nov 23 11:56:01] VERBOSE[4852][C-00000002] pbx.c: Executing [12@tst_endpoint:2] Dial("Local/12@tst_endpoint-00000002;2", "PJSIP/1002,2,b(predial)") in new stack
[Nov 23 11:56:01] VERBOSE[4852][C-00000002] app_stack.c: PJSIP/1002-00000001 Internal Gosub(tst_endpoint,12,predial) start
[Nov 23 11:56:01] VERBOSE[4852][C-00000002] pbx.c: Executing [12@tst_endpoint:4] NoOp("PJSIP/1002-00000001", "This is the value of followme:'override_value'") in new stack
[Nov 23 11:56:01] VERBOSE[4852][C-00000002] pbx.c: Executing [12@tst_endpoint:5] Return("PJSIP/1002-00000001", "") in new stack
[Nov 23 11:56:01] VERBOSE[4852][C-00000002] app_stack.c: Spawn extension (tst_endpoint, 12, 1) exited non-zero on 'PJSIP/1002-00000001'
[Nov 23 11:56:01] VERBOSE[4852][C-00000002] app_stack.c: PJSIP/1002-00000001 Internal Gosub(tst_endpoint,12,predial) complete GOSUB_RETVAL=
[Nov 23 11:56:01] VERBOSE[4852][C-00000002] app_dial.c: Called PJSIP/1002
[Nov 23 11:56:01] VERBOSE[4852][C-00000002] app_dial.c: Everyone is busy/congested at this time (1:0/0/1)
[Nov 23 11:56:01] VERBOSE[4852][C-00000002] pbx.c: Executing [12@tst_endpoint:3] Hangup("Local/12@tst_endpoint-00000002;2", "") in new stack
[Nov 23 11:56:01] VERBOSE[4852][C-00000002] pbx.c: Spawn extension (tst_endpoint, 12, 3) exited non-zero on 'Local/12@tst_endpoint-00000002;2'
[Nov 23 11:56:08] VERBOSE[4853] dial.c: Called 13@tst_endpoint
[Nov 23 11:56:08] VERBOSE[4854][C-00000003] pbx.c: Executing [13@tst_endpoint:1] NoOp("Local/13@tst_endpoint-00000003;2", "") in new stack
[Nov 23 11:56:08] VERBOSE[4854][C-00000003] pbx.c: Executing [13@tst_endpoint:2] Dial("Local/13@tst_endpoint-00000003;2", "PJSIP/1003,2,b(predial)") in new stack
[Nov 23 11:56:08] VERBOSE[4854][C-00000003] app_stack.c: PJSIP/1003-00000002 Internal Gosub(tst_endpoint,13,predial) start
[Nov 23 11:56:08] VERBOSE[4854][C-00000003] pbx.c: Executing [13@tst_endpoint:4] NoOp("PJSIP/1003-00000002", "This is the value of followme:'section_value'") in new stack
[Nov 23 11:56:08] VERBOSE[4854][C-00000003] pbx.c: Executing [13@tst_endpoint:5] Return("PJSIP/1003-00000002", "") in new stack
[Nov 23 11:56:08] VERBOSE[4854][C-00000003] app_stack.c: Spawn extension (tst_endpoint, 13, 1) exited non-zero on 'PJSIP/1003-00000002'
[Nov 23 11:56:08] VERBOSE[4854][C-00000003] app_stack.c: PJSIP/1003-00000002 Internal Gosub(tst_endpoint,13,predial) complete GOSUB_RETVAL=
[Nov 23 11:56:08] VERBOSE[4854][C-00000003] app_dial.c: Called PJSIP/1003
[Nov 23 11:56:08] VERBOSE[4854][C-00000003] app_dial.c: Everyone is busy/congested at this time (1:0/0/1)
[Nov 23 11:56:08] VERBOSE[4854][C-00000003] pbx.c: Executing [13@tst_endpoint:3] Hangup("Local/13@tst_endpoint-00000003;2", "") in new stack
[Nov 23 11:56:08] VERBOSE[4854][C-00000003] pbx.c: Spawn extension (tst_endpoint, 13, 3) exited non-zero on 'Local/13@tst_endpoint-00000003;2'
[Nov 23 11:56:13] VERBOSE[4786] asterisk.c: Beginning asterisk shutdown....
[Nov 23 11:56:13] VERBOSE[4786] asterisk.c: Asterisk cleanly ending (0).
[Nov 23 11:56:13] VERBOSE[4786] asterisk.c: Executing last minute cleanups
[Nov 23 11:56:13] VERBOSE[4786] res_musiconhold.c: Destroying musiconhold processes
[Nov 23 11:56:13] VERBOSE[4786] manager.c: Manager unregistered action DBGet
[Nov 23 11:56:13] VERBOSE[4786] manager.c: Manager unregistered action DBPut
[Nov 23 11:56:13] VERBOSE[4786] manager.c: Manager unregistered action DBDel
[Nov 23 11:56:13] VERBOSE[4786] manager.c: Manager unregistered action DBDelTree