Internal calls won't work, asterisk cli disconnects

ladiko · February 23, 2017, 6:05pm

it always worked but recently it started that internal calls won’t work anymore. When i watch it on the CLI, i always get’s kicked out of it like that:

	-- Executing [[email protected]:1] GotoIf("PJSIP/73-00000000", "0?ext-local,75,1:followme-check,75,1") in new stack
	-- Goto (followme-check,75,1)
	-- Executing [[email protected]:1] Gosub("PJSIP/73-00000000", "followme-sub,75,1()") in new stack
	-- Executing [[email protected]:1] Macro("PJSIP/73-00000000", "user-callerid,") in new stack
	-- Executing [[email protected]:1] Set("PJSIP/73-00000000", "TOUCH_MONITOR=1487865943.0") in new stack
	-- Executing [[email protected]:2] Set("PJSIP/73-00000000", "AMPUSER=73") in new stack
	-- Executing [[email protected]:3] GotoIf("PJSIP/73-00000000", "0?report") in new stack
	-- Executing [[email protected]:4] ExecIf("PJSIP/73-00000000", "1?Set(REALCALLERIDNUM=73)") in new stack
	-- Executing [[email protected]:5] Set("PJSIP/73-00000000", "AMPUSER=73") in new stack
	-- Executing [[email protected]:6] GotoIf("PJSIP/73-00000000", "0?limit") in new stack
	-- Executing [[email protected]:7] Set("PJSIP/73-00000000", "AMPUSERCIDNAME=Einkauf") in new stack
	-- Executing [[email protected]:8] GotoIf("PJSIP/73-00000000", "0?report") in new stack
	-- Executing [[email protected]:9] Set("PJSIP/73-00000000", "AMPUSERCID=73") in new stack
	-- Executing [[email protected]:10] Set("PJSIP/73-00000000", "__DIAL_OPTIONS=Ttr") in new stack
	-- Executing [[email protected]:11] Set("PJSIP/73-00000000", "CALLERID(all)="Einkauf" <73>") in new stack
	-- Executing [[email protected]:12] GotoIf("PJSIP/73-00000000", "0?limit") in new stack
	-- Executing [[email protected]:13] ExecIf("PJSIP/73-00000000", "0?Set(GROUP(concurrency_limit)=73)") in new stack
	-- Executing [[email protected]:14] ExecIf("PJSIP/73-00000000", "0?Set(CHANNEL(language)=)") in new stack
	-- Executing [[email protected]:15] GotoIf("PJSIP/73-00000000", "0?continue") in new stack
	-- Executing [[email protected]:16] ExecIf("PJSIP/73-00000000", "1?Set(__CALLEE_ACCOUNCODE=)") in new stack
	-- Executing [[email protected]:17] Set("PJSIP/73-00000000", "__TTL=64") in new stack
	-- Executing [[email protected]:18] GotoIf("PJSIP/73-00000000", "1?continue") in new stack
	-- Goto (macro-user-callerid,s,29)
	-- Executing [[email protected]:29] Set("PJSIP/73-00000000", "CALLERID(number)=73") in new stack
	-- Executing [[email protected]:30] Set("PJSIP/73-00000000", "CALLERID(name)=Einkauf") in new stack
	-- Executing [[email protected]:31] GotoIf("PJSIP/73-00000000", "0?cnum") in new stack
	-- Executing [[email protected]:32] Set("PJSIP/73-00000000", "CDR(cnam)=Einkauf") in new stack
	-- Executing [[email protected]:33] Set("PJSIP/73-00000000", "CDR(cnum)=73") in new stack
	-- Executing [[email protected]:34] Set("PJSIP/73-00000000", "CHANNEL(language)=de") in new stack
	-- Executing [[email protected]:2] Set("PJSIP/73-00000000", "DIAL_OPTIONS=TtrI") in new stack
	-- Executing [[email protected]:3] Set("PJSIP/73-00000000", "CONNECTEDLINE(num,i)=75") in new stack
	-- Executing [[email protected]:4] Gosub("PJSIP/73-00000000", "sub-presencestate-display,s,1(75)") in new stack
	-- Executing [[email protected]:1] Goto("PJSIP/73-00000000", "state-not_set,1") in new stack
	-- Goto (sub-presencestate-display,state-not_set,1)
	-- Executing [[email protected]:1] Set("PJSIP/73-00000000", "PRESENCESTATE_DISPLAY=") in new stack
	-- Executing [[email protected]:2] Return("PJSIP/73-00000000", "") in new stack
	-- Executing [[email protected]:5] Set("PJSIP/73-00000000", "CONNECTEDLINE(name)=Service") in new stack
asterisk*CLI>
Disconnected from Asterisk server
Asterisk cleanly ending (0).
Executing last minute cleanups

So i disabled followme and then i get this:

   -- Executing [[email protected]:1] GotoIf("PJSIP/73-00000000", "1?ext-local,75,1:followme-check,75,1") in new stack
	-- Goto (ext-local,75,1)
	-- Executing [[email protected]:1] Set("PJSIP/73-00000000", "__RINGTIMER=20") in new stack
	-- Executing [[email protected]:2] Macro("PJSIP/73-00000000", "exten-vm,75,75,1,1,1") in new stack
	-- Executing [[email protected]:1] Macro("PJSIP/73-00000000", "user-callerid,") in new stack
	-- Executing [[email protected]:1] Set("PJSIP/73-00000000", "TOUCH_MONITOR=1487872546.0") in new stack
	-- Executing [[email protected]:2] Set("PJSIP/73-00000000", "AMPUSER=73") in new stack
	-- Executing [[email protected]:3] GotoIf("PJSIP/73-00000000", "0?report") in new stack
	-- Executing [[email protected]:4] ExecIf("PJSIP/73-00000000", "1?Set(REALCALLERIDNUM=73)") in new stack
	-- Executing [[email protected]:5] Set("PJSIP/73-00000000", "AMPUSER=73") in new stack
	-- Executing [[email protected]:6] GotoIf("PJSIP/73-00000000", "0?limit") in new stack
	-- Executing [[email protected]:7] Set("PJSIP/73-00000000", "AMPUSERCIDNAME=Einkauf") in new stack
	-- Executing [[email protected]:8] GotoIf("PJSIP/73-00000000", "0?report") in new stack
	-- Executing [[email protected]:9] Set("PJSIP/73-00000000", "AMPUSERCID=73") in new stack
	-- Executing [[email protected]:10] Set("PJSIP/73-00000000", "__DIAL_OPTIONS=Ttr") in new stack
	-- Executing [[email protected]:11] Set("PJSIP/73-00000000", "CALLERID(all)="Einkauf" <73>") in new stack
	-- Executing [[email protected]:12] GotoIf("PJSIP/73-00000000", "0?limit") in new stack
	-- Executing [[email protected]:13] ExecIf("PJSIP/73-00000000", "0?Set(GROUP(concurrency_limit)=73)") in new stack
	-- Executing [[email protected]:14] ExecIf("PJSIP/73-00000000", "0?Set(CHANNEL(language)=)") in new stack
	-- Executing [[email protected]:15] GotoIf("PJSIP/73-00000000", "0?continue") in new stack
	-- Executing [[email protected]:16] ExecIf("PJSIP/73-00000000", "1?Set(__CALLEE_ACCOUNCODE=)") in new stack
	-- Executing [[email protected]:17] Set("PJSIP/73-00000000", "__TTL=64") in new stack
	-- Executing [[email protected]:18] GotoIf("PJSIP/73-00000000", "1?continue") in new stack
	-- Goto (macro-user-callerid,s,29)
	-- Executing [[email protected]:29] Set("PJSIP/73-00000000", "CALLERID(number)=73") in new stack
	-- Executing [[email protected]:30] Set("PJSIP/73-00000000", "CALLERID(name)=Einkauf") in new stack
	-- Executing [[email protected]:31] GotoIf("PJSIP/73-00000000", "0?cnum") in new stack
	-- Executing [[email protected]:32] Set("PJSIP/73-00000000", "CDR(cnam)=Einkauf") in new stack
	-- Executing [[email protected]:33] Set("PJSIP/73-00000000", "CDR(cnum)=73") in new stack
	-- Executing [[email protected]:34] Set("PJSIP/73-00000000", "CHANNEL(language)=de") in new stack
	-- Executing [[email protected]:2] Set("PJSIP/73-00000000", "RingGroupMethod=none") in new stack
	-- Executing [[email protected]:3] Set("PJSIP/73-00000000", "__EXTTOCALL=75") in new stack
	-- Executing [[email protected]:4] Set("PJSIP/73-00000000", "__PICKUPMARK=75") in new stack
	-- Executing [[email protected]:5] Set("PJSIP/73-00000000", "RT=20") in new stack
	-- Executing [[email protected]:6] Gosub("PJSIP/73-00000000", "sub-record-check,s,1(exten,75,dontcare)") in new stack
	-- Executing [[email protected]:1] GotoIf("PJSIP/73-00000000", "0?initialized") in new stack
	-- Executing [[email protected]:2] Set("PJSIP/73-00000000", "__REC_STATUS=INITIALIZED") in new stack
	-- Executing [[email protected]:3] Set("PJSIP/73-00000000", "NOW=1487872546") in new stack
	-- Executing [[email protected]:4] Set("PJSIP/73-00000000", "__DAY=23") in new stack
	-- Executing [[email protected]:5] Set("PJSIP/73-00000000", "__MONTH=02") in new stack
	-- Executing [[email protected]:6] Set("PJSIP/73-00000000", "__YEAR=2017") in new stack
	-- Executing [[email protected]:7] Set("PJSIP/73-00000000", "__TIMESTR=20170223-185546") in new stack
	-- Executing [[email protected]:8] Set("PJSIP/73-00000000", "__FROMEXTEN=73") in new stack
	-- Executing [[email protected]:9] Set("PJSIP/73-00000000", "__MON_FMT=wav") in new stack
	-- Executing [[email protected]:10] NoOp("PJSIP/73-00000000", "Recordings initialized") in new stack
	-- Executing [[email protected]:11] ExecIf("PJSIP/73-00000000", "0?Set(ARG3=dontcare)") in new stack
	-- Executing [[email protected]:12] Set("PJSIP/73-00000000", "REC_POLICY_MODE_SAVE=") in new stack
	-- Executing [[email protected]:13] ExecIf("PJSIP/73-00000000", "0?Set(REC_STATUS=NO)") in new stack
	-- Executing [[email protected]:14] GotoIf("PJSIP/73-00000000", "5?checkaction") in new stack
	-- Goto (sub-record-check,s,17)
	-- Executing [[email protected]:17] GotoIf("PJSIP/73-00000000", "1?sub-record-check,exten,1") in new stack
	-- Goto (sub-record-check,exten,1)
	-- Executing [[email protected]:1] NoOp("PJSIP/73-00000000", "Exten Recording Check between 73 and 75") in new stack
	-- Executing [[email protected]:2] Set("PJSIP/73-00000000", "CALLTYPE=internal") in new stack
	-- Executing [[email protected]:3] ExecIf("PJSIP/73-00000000", "0?Set(CALLTYPE=)") in new stack
	-- Executing [[email protected]:4] Set("PJSIP/73-00000000", "CALLEE=dontcare") in new stack
	-- Executing [[email protected]:5] ExecIf("PJSIP/73-00000000", "0?Set(CALLEE=dontcare)") in new stack
	-- Executing [[email protected]ub-record-check:6] GotoIf("PJSIP/73-00000000", "0?callee") in new stack
	-- Executing [[email protected]:7] GotoIf("PJSIP/73-00000000", "1?caller") in new stack
	-- Goto (sub-record-check,exten,13)
	-- Executing [[email protected]:13] Set("PJSIP/73-00000000", "RECMODE=dontcare") in new stack
	-- Executing [[email protected]:14] ExecIf("PJSIP/73-00000000", "0?Set(RECMODE=dontcare)") in new stack
	-- Executing [[email protected]:15] ExecIf("PJSIP/73-00000000", "1?Set(RECMODE=dontcare)") in new stack
	-- Executing [[email protected]:16] Gosub("PJSIP/73-00000000", "recordcheck,1(dontcare,internal,75)") in new stack
	-- Executing [[email protected]:1] NoOp("PJSIP/73-00000000", "Starting recording check against dontcare") in new stack
	-- Executing [[email protected]:2] Goto("PJSIP/73-00000000", "dontcare") in new stack
	-- Goto (sub-record-check,recordcheck,3)
	-- Executing [[email protected]:3] Return("PJSIP/73-00000000", "") in new stack
	-- Executing [[email protected]:17] Return("PJSIP/73-00000000", "") in new stack
	-- Executing [[email protected]:7] GotoIf("PJSIP/73-00000000", "1?macrodial") in new stack
	-- Goto (macro-exten-vm,s,13)
	-- Executing [[email protected]:13] GosubIf("PJSIP/73-00000000", "0?clrheader,1()") in new stack
	-- Executing [[email protected]:14] Macro("PJSIP/73-00000000", "dial-one,20,Ttr,75") in new stack
	-- Executing [[email protected]:1] Set("PJSIP/73-00000000", "DEXTEN=75") in new stack
	-- Executing [[email protected]:2] ExecIf("PJSIP/73-00000000", "0?Set(EXTTOCALL=75)") in new stack
	-- Executing [[email protected]:3] Set("PJSIP/73-00000000", "DIALSTATUS_CW=") in new stack
	-- Executing [[email protected]:4] GosubIf("PJSIP/73-00000000", "0?screen,1()") in new stack
	-- Executing [[email protected]:5] GosubIf("PJSIP/73-00000000", "0?cf,1()") in new stack
	-- Executing [[email protected]:6] GotoIf("PJSIP/73-00000000", "1?skip1") in new stack
	-- Goto (macro-dial-one,s,9)
	-- Executing [[email protected]:9] GotoIf("PJSIP/73-00000000", "0?nodial") in new stack
	-- Executing [[email protected]:10] GotoIf("PJSIP/73-00000000", "0?continue") in new stack
	-- Executing [[email protected]:11] Set("PJSIP/73-00000000", "EXTHASCW=ENABLED") in new stack
	-- Executing [[email protected]:12] GotoIf("PJSIP/73-00000000", "0?next1:cwinusebusy") in new stack
	-- Goto (macro-dial-one,s,24)
	-- Executing [[email protected]:24] GotoIf("PJSIP/73-00000000", "0?next3:continue") in new stack
	-- Goto (macro-dial-one,s,26)
	-- Executing [[email protected]:26] GotoIf("PJSIP/73-00000000", "0?nodial") in new stack
	-- Executing [[email protected]:27] GosubIf("PJSIP/73-00000000", "1?dstring,1():dlocal,1()") in new stack
	-- Executing [[email protected]:1] Set("PJSIP/73-00000000", "DSTRING=") in new stack
	-- Executing [[email protected]:2] Set("PJSIP/73-00000000", "DEVICES=75") in new stack
	-- Executing [[email protected]:3] ExecIf("PJSIP/73-00000000", "0?Return()") in new stack
	-- Executing [[email protected]:4] ExecIf("PJSIP/73-00000000", "0?Set(DEVICES=5)") in new stack
	-- Executing [[email protected]:5] Set("PJSIP/73-00000000", "LOOPCNT=1") in new stack
	-- Executing [[email protected]:6] Set("PJSIP/73-00000000", "ITER=1") in new stack
	-- Executing [[email protected]:7] Set("PJSIP/73-00000000", "THISDIAL=PJSIP/75") in new stack
	-- Executing [[email protected]:8] GosubIf("PJSIP/73-00000000", "1?zap2dahdi,1()") in new stack
	-- Executing [[email protected]:1] ExecIf("PJSIP/73-00000000", "0?Return()") in new stack
	-- Executing [[email protected]:2] Set("PJSIP/73-00000000", "NEWDIAL=") in new stack
	-- Executing [[email protected]:3] Set("PJSIP/73-00000000", "LOOPCNT2=1") in new stack
	-- Executing [[email protected]:4] Set("PJSIP/73-00000000", "ITER2=1") in new stack
	-- Executing [[email protected]:5] Set("PJSIP/73-00000000", "THISPART2=PJSIP/75") in new stack
	-- Executing [[email protected]:6] ExecIf("PJSIP/73-00000000", "0?Set(THISPART2=DAHDIIP/75)") in new stack
	-- Executing [zap2dah[email protected]:7] Set("PJSIP/73-00000000", "NEWDIAL=PJSIP/75&") in new stack
	-- Executing [[email protected]:8] Set("PJSIP/73-00000000", "ITER2=2") in new stack
	-- Executing [[email protected]:9] GotoIf("PJSIP/73-00000000", "0?begin2") in new stack
	-- Executing [[email protected]:10] Set("PJSIP/73-00000000", "THISDIAL=PJSIP/75") in new stack
	-- Executing [[email protected]:11] Return("PJSIP/73-00000000", "") in new stack
	-- Executing [[email protected]:9] GotoIf("PJSIP/73-00000000", "0?docheck") in new stack
	-- Executing [[email protected]:10] NoOp("PJSIP/73-00000000", "Debug: Found PJSIP Destination PJSIP/75") in new stack
	-- Executing [[email protected]:11] GotoIf("PJSIP/73-00000000", "0?doset") in new stack
	-- Executing [[email protected]:12] NoOp("PJSIP/73-00000000", "Debug: Updating PJSIP Destination with PJSIP_DIAL_CONTACTS") in new stack
	-- Executing [[email protected]:13] Set("PJSIP/73-00000000", "THISDIAL=PJSIP/75/sip:[email protected]:5060;uniq=1B8F9773F42DC19FF3DAB339F0524") in new stack
	-- Executing [[email protected]:14] GotoIf("PJSIP/73-00000000", "0?skipset") in new stack
	-- Executing [[email protected]:15] Set("PJSIP/73-00000000", "DSTRING=PJSIP/75/sip:[email protected]:5060;uniq=1B8F9773F42DC19FF3DAB339F0524&") in new stack
	-- Executing [[email protected]:16] Set("PJSIP/73-00000000", "ITER=2") in new stack
	-- Executing [[email protected]:17] GotoIf("PJSIP/73-00000000", "0?begin") in new stack
	-- Executing [[email protected]:18] ExecIf("PJSIP/73-00000000", "0?Return()") in new stack
	-- Executing [[email protected]:19] Set("PJSIP/73-00000000", "DSTRING=PJSIP/75/sip:[email protected]:5060;uniq=1B8F9773F42DC19FF3DAB339F0524") in new stack
	-- Executing [[email protected]:20] Return("PJSIP/73-00000000", "") in new stack
	-- Executing [[email protected]:28] GotoIf("PJSIP/73-00000000", "0?nodial") in new stack
	-- Executing [[email protected]:29] GotoIf("PJSIP/73-00000000", "0?skiptrace") in new stack
	-- Executing [[email protected]:30] GosubIf("PJSIP/73-00000000", "1?ctset,1():ctclear,1()") in new stack
	-- Executing [[email protected]:1] Set("PJSIP/73-00000000", "DB(CALLTRACE/75)=73") in new stack
	-- Executing [[email protected]:2] Return("PJSIP/73-00000000", "") in new stack
	-- Executing [[email protected]:31] Set("PJSIP/73-00000000", "D_OPTIONS=Ttr") in new stack
	-- Executing [[email protected]:32] NoOp("PJSIP/73-00000000", "Blind Transfer: , Attended Transfer: , User: 73, Alert Info: ") in new stack
	-- Executing [[email protected]:33] ExecIf("PJSIP/73-00000000", "1?Set(ALERT_INFO=)") in new stack
	-- Executing [[email protected]:34] ExecIf("PJSIP/73-00000000", "0?Set(ALERT_INFO=)") in new stack
	-- Executing [[email protected]:35] ExecIf("PJSIP/73-00000000", "0?Set(ALERT_INFO=)") in new stack
	-- Executing [[email protected]:36] ExecIf("PJSIP/73-00000000", "0?Set(ALERT_INFO=;volume=)") in new stack
	-- Executing [[email protected]:37] ExecIf("PJSIP/73-00000000", "0?Set(ALERT_INFO=;volume=)") in new stack
	-- Executing [[email protected]:38] GosubIf("PJSIP/73-00000000", "0?func-set-sipheader,s,1(Alert-Info,)") in new stack
	-- Executing [[email protected]:39] ExecIf("PJSIP/73-00000000", "0?Set(CHANNEL(musicclass)=)") in new stack
	-- Executing [[email protected]:40] GosubIf("PJSIP/73-00000000", "0?qwait,1()") in new stack
	-- Executing [[email protected]:41] Set("PJSIP/73-00000000", "__CWIGNORE=") in new stack
	-- Executing [[email protected]:42] Set("PJSIP/73-00000000", "__KEEPCID=TRUE") in new stack
	-- Executing [[email protected]:43] GotoIf("PJSIP/73-00000000", "0?usegoto,1") in new stack
	-- Executing [[email protected]:44] GotoIf("PJSIP/73-00000000", "0?godial") in new stack
	-- Executing [[email protected]:45] Gosub("PJSIP/73-00000000", "sub-presencestate-display,s,1(75)") in new stack
	-- Executing [[email protected]:1] Goto("PJSIP/73-00000000", "state-not_set,1") in new stack
	-- Goto (sub-presencestate-display,state-not_set,1)
	-- Executing [[email protected]:1] Set("PJSIP/73-00000000", "PRESENCESTATE_DISPLAY=") in new stack
	-- Executing [[email protected]:2] Return("PJSIP/73-00000000", "") in new stack
asterisk*CLI>
Disconnected from Asterisk server
Asterisk cleanly ending (0).
Executing last minute cleanups

Does anybody know what it means and why asterisk disconnects me from the CLI?

It seems to be related to [email protected] but i have no idea what it means.

lgaetz · February 23, 2017, 6:13pm

Asterisk is crashing for some reason. What version are you running?

Marbled · February 23, 2017, 6:14pm

I guess because of this?

Looks like your Asterisk stops… This is why you are apparently kicked out of the CLI…

Could you please give more information as to what you are running (FreePBX version, etc…) and on what (FreePBX distro?)?

Could it be possible that you updated your Asterisk packages a few days ago when a somewhat unstable release was released?

Good luck and have a nice day!

Nick

edit: Lorne, you are too fast for me…

ladiko · February 23, 2017, 6:16pm

I use Ubuntu 14.04.5 LTS (GNU/Linux 4.4.0-64-generic x86_64), asterisk 14.3.0 and FreePBX 13.0.190.20 with all updates. I tried to revert back to 14.2.1 but the same happened.

ladiko · February 23, 2017, 7:13pm

First i thought it was related to https://bugs.launchpad.net/ubuntu/+source/asterisk/+bug/1458323

I fiddled around with asterisk 14.2.1, 13.2 and pjsip 2.5.5 and finally reinstalled asterisk 14.3.0 and pjsip 2.6 from source and now all seems to work. Before even a reboot didn’t solve the issue. Seems like recompiling did it. Thanks for the hint towards the crashing asterisk!

ladiko · February 25, 2017, 1:53pm

seems like i get random segmentation faults when i use asterisk 14.3.0 with pjsip 2.6.0. I went back to pjsip 2.5.5 to see if that will help for now.

Marbled · February 27, 2017, 1:34am

Hi!

Are you compiling from source? From reading your posts I have a feeling that you might…

Might it be possible that you might have modules from a previous installation conflicting with the ones you are trying to install?

Something like the following problem:

I experienced last month?

Have you run tests (the first thing that would come to mind is a memory test) to make sure your hardware is not defective?

Good luck and have a nice day!

Nick

ladiko · February 27, 2017, 12:44pm

Yes i compile asterisk and pjsip from source. After re-installing pjsip 2.5.5, the machine ran fine during the weekend, so i am pretty sure it’s an issue with pjsip 2.6.0. Later i will test if there is a specific module of pjsip which causes the fail. Thanks for pointing to the other thread.

ladiko · June 7, 2017, 1:22pm

I updated asterisk to 14.5.0 and still have the same issue with pjsip 2.6 while 2.5.5 runs stable. When i execute asterisk -cvvv, it closes with the error message:

asterisk: ../src/pj/os_core_unix.c:692: pj_thread_this: Assertion `!"Calling pjlib from unknown/external thread. You must " "register external threads with pj_thread_register() " "before calling any pjlib functions."' failed.
Aborted