Hi forum
Our FreePBX has been working nicely, until today.
Suspect I’ve changed something thats broken it, but cannot figure out exactly what.
Shall be a PITA if I need to rebuild this from bare metal.
Will be very grateful for any tips or clues to solution from following log snippet.
The last log line looks like FreePBX is trying to use an external phone number 0408xxxx as an extension number. Strange.
The Cisco phone displays “Declined” for every single outgoing call.
Clearly this is a dealbreaker.
So many thanks
[2013-03-18 18:42:51] VERBOSE[11609] pbx.c: -- Executing [0408xxxxxx@from-internal:1] Macro("SIP/156-0000000d", "user-callerid,LIMIT") in new stack
[2013-03-18 18:42:51] VERBOSE[11609] pbx.c: -- Executing [s@macro-user-callerid:1] Set("SIP/156-0000000d", "AMPUSER=156") in new stack
[2013-03-18 18:42:51] VERBOSE[11609] pbx.c: -- Executing [s@macro-user-callerid:2] GotoIf("SIP/156-0000000d", "0?report") in new stack
[2013-03-18 18:42:51] VERBOSE[11609] pbx.c: -- Executing [s@macro-user-callerid:3] ExecIf("SIP/156-0000000d", "1?Set(REALCALLERIDNUM=156)") in new stack
[2013-03-18 18:42:51] VERBOSE[11609] pbx.c: -- Executing [s@macro-user-callerid:4] Set("SIP/156-0000000d", "AMPUSER=156") in new stack
[2013-03-18 18:42:51] VERBOSE[11609] pbx.c: -- Executing [s@macro-user-callerid:5] Set("SIP/156-0000000d", "AMPUSERCIDNAME=xxxxx") in new stack
[2013-03-18 18:42:51] VERBOSE[11609] pbx.c: -- Executing [s@macro-user-callerid:6] GotoIf("SIP/156-0000000d", "0?report") in new stack
[2013-03-18 18:42:51] VERBOSE[11609] pbx.c: -- Executing [s@macro-user-callerid:7] Set("SIP/156-0000000d", "AMPUSERCID=156") in new stack
[2013-03-18 18:42:51] VERBOSE[11609] pbx.c: -- Executing [s@macro-user-callerid:8] Set("SIP/156-0000000d", "CALLERID(all)="xxxxx" <156>") in new stack
[2013-03-18 18:42:51] VERBOSE[11609] pbx.c: -- Executing [s@macro-user-callerid:9] GotoIf("SIP/156-0000000d", "0?limit") in new stack
[2013-03-18 18:42:51] VERBOSE[11609] pbx.c: -- Executing [s@macro-user-callerid:10] ExecIf("SIP/156-0000000d", "1?Set(GROUP(concurrency_limit)=156)") in new stack
[2013-03-18 18:42:51] VERBOSE[11609] pbx.c: -- Executing [s@macro-user-callerid:11] ExecIf("SIP/156-0000000d", "0?Set(CHANNEL(language)=)") in new stack
[2013-03-18 18:42:51] VERBOSE[11609] pbx.c: -- Executing [s@macro-user-callerid:12] GosubIf("SIP/156-0000000d", "7?sub-ccss,s,1(from-internal,0408xxxxxx)") in new stack
[2013-03-18 18:42:51] VERBOSE[11609] pbx.c: -- Executing [s@sub-ccss:1] ExecIf("SIP/156-0000000d", "0?Return()") in new stack
[2013-03-18 18:42:51] VERBOSE[11609] pbx.c: -- Executing [s@sub-ccss:2] Set("SIP/156-0000000d", "CCSS_SETUP=TRUE") in new stack
[2013-03-18 18:42:51] VERBOSE[11609] pbx.c: -- Executing [s@sub-ccss:3] GosubIf("SIP/156-0000000d", "0?monitor_config,1(from-internal,0408xxxxxx):monitor_default,1(from-internal,0408xxxxxx)") in new stack
[2013-03-18 18:42:51] VERBOSE[11609] pbx.c: -- Executing [monitor_default@sub-ccss:1] GotoIf("SIP/156-0000000d", "0?is_exten") in new stack
[2013-03-18 18:42:51] VERBOSE[11609] pbx.c: -- Executing [monitor_default@sub-ccss:2] StackPop("SIP/156-0000000d", "") in new stack
[2013-03-18 18:42:51] VERBOSE[11609] pbx.c: -- Executing [monitor_default@sub-ccss:3] Return("SIP/156-0000000d", "FALSE") in new stack
[2013-03-18 18:42:51] VERBOSE[11609] pbx.c: -- Executing [s@macro-user-callerid:13] GotoIf("SIP/156-0000000d", "1?continue") in new stack
[2013-03-18 18:42:51] VERBOSE[11609] pbx.c: -- Goto (macro-user-callerid,s,26)
[2013-03-18 18:42:51] VERBOSE[11609] pbx.c: -- Executing [s@macro-user-callerid:26] Set("SIP/156-0000000d", "CALLERID(number)=156") in new stack
[2013-03-18 18:42:51] VERBOSE[11609] pbx.c: -- Executing [s@macro-user-callerid:27] Set("SIP/156-0000000d", "CALLERID(name)=xxxxx") in new stack
[2013-03-18 18:42:51] VERBOSE[11609] pbx.c: -- Executing [s@macro-user-callerid:28] Set("SIP/156-0000000d", "CHANNEL(language)=au") in new stack
[2013-03-18 18:42:51] VERBOSE[11609] pbx.c: -- Executing [0408xxxxxx@from-internal:2] Set("SIP/156-0000000d", "ROUTEUSER=156") in new stack
[2013-03-18 18:42:51] VERBOSE[11609] pbx.c: -- Executing [0408xxxxxx@from-internal:3] GotoIf("SIP/156-0000000d", "1?outbound-1,0408xxxxxx,2:outbound-allroutes,0408xxxxxx,2") in new stack
[2013-03-18 18:42:51] VERBOSE[11609] pbx.c: -- Goto (outbound-1,0408xxxxxx,2)
[2013-03-18 18:42:51] WARNING[11609] pbx.c: Channel 'SIP/156-0000000d' sent into invalid extension '0408xxxxxx' in context 'outbound-1', but no invalid handler
In case anyone else trips over this, the answer is …
Don’t enable the Extension Routing Module before you receive your free licence. (Installed but disabled might be OK.)
It seems that no licence might be cause of failure in ALL outgoing calls.
Perhaps someone from Schmooze could confirm ?
Thanks to Tony Lewis for answering my support ticket, and the folks at Schmooze for this important module. Seems to suit our needs nicely.
