[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