Cisco Phone 8831


(Andreas) #1

Hello,

i try to get an cisco phone 8831 working on a “test freepbx”.
Here are some informations:
Asterisk Version: 16.15.1
static ip 10.0.30.17
8831 current firmware: sip8831.9-3-3-5
static ip 10.0.30.35

I created a chan_pjsip extension
To make things easier while i am still testing the extension number and the secret is the same.

In the (commercial) endpoint manager i created a template and linked it to the extension. Because there is no 8831 i have chosen the 9971 as available phone.
I altered the automatically built xml file to this:

SEPAC44F21156C2.cnf.xml
<device>
	<fullConfig>true</fullConfig>
	<deviceProtocol>SIP</deviceProtocol>
	<ipAddressMode>0</ipAddressMode>
<devicePool>
	<dateTimeSetting>
		<dateTemplate>D.M.Y</dateTemplate>
		<timeZone>Central Europe Standard/Daylight Time</timeZone>
		<ntps>
				<name>ntp.pool.org</name>
				<ntpMode>directedbroadcast</ntpMode>
			</ntp>
			<name>ntp.pool.org</name> 
		</ntps>
	</dateTimeSetting>
	<callManagerGroup>
		<members>
			<member priority="0">
				<callManager>
					<ports>
						<sipPort>5060</sipPort>
					</ports>
					<processNodeName>10.0.30.17</processNodeName>
				</callManager>
			</member>
		</members>
	</callManagerGroup>
</devicePool>
<sipProfile>
	<sipProxies>
		<registerWithProxy>true</registerWithProxy>
	</sipProxies>
	<sipCallFeatures>
		<cnfJoinEnabled>true</cnfJoinEnabled>
		<localCfwdEnable>true</localCfwdEnable>
		<callForwardURI>service-uri-cfwdall</callForwardURI>
		<callPickupURI>service-uri-pickup</callPickupURI>
		<callPickupGroupURI>service-uri-gpickup</callPickupGroupURI>
		<meetMeServiceURI>service-uri-meetme</meetMeServiceURI>
		<callHoldRingback>2</callHoldRingback>
		<semiAttendedTransfer>true</semiAttendedTransfer>
		<anonymousCallBlock>2</anonymousCallBlock>
		<callerIdBlocking>2</callerIdBlocking>
		<dndControl>2</dndControl>
		<dndCallAlert>1</dndCallAlert>
		<remoteCcEnable>true</remoteCcEnable>
	</sipCallFeatures>
	<sipStack>
		<timerRegisterExpires>3600</timerRegisterExpires>
		<timerRegisterDelta>5</timerRegisterDelta>
		<timerInviteExpires>180</timerInviteExpires>
		<timerKeepAliveExpires>3600</timerKeepAliveExpires>
		<timerSubscribeExpires>3600</timerSubscribeExpires>
		<timerSubscribeDelta>5</timerSubscribeDelta>
		<timerT1>500</timerT1>
		<timerT2>4000</timerT2>
		<remotePartyID>true</remotePartyID>
	</sipStack>
	<sipLines>
		<line button="1" lineIndex="1">
			<featureID>9</featureID>
			<featureLabel>CP8831_Test</featureLabel>
			<speedDialNumber></speedDialNumber>
			<proxy>USECALLMANAGER</proxy>
			<port>5060</port>
			<voipControlPort>5060</voipControlPort>
			<name>301</name>
			<displayName>CP8831_Test</displayName>
			<autoAnswer>
				<autoAnswerEnabled>0</autoAnswerEnabled>
			</autoAnswer>
			<callWaiting>1</callWaiting>
			<authName>301</authName>
			<authPassword>301</authPassword>
			<sharedLine>false</sharedLine>
			<messagesNumber></messagesNumber>
			<messageWaitingLampPolicy>3</messageWaitingLampPolicy>
			<ringSettingActive>5</ringSettingActive>
			<forwardCallInfoDisplay>
				<callerName>true</callerName>
				<callerNumber>false</callerNumber>
				<redirectedNumber>false</redirectedNumber>
				<dialedNumber>true</dialedNumber>
			</forwardCallInfoDisplay>
			<maxNumCalls>6</maxNumCalls>
			<busyTrigger>2</busyTrigger>
		</line>
	</sipLines>
	<enableVad>true</enableVad>
	<preferredCodec>g711alaw</preferredCodec>
	<softKeyFile>softkeyDefault_kpml.xml</softKeyFile>
	<dialTemplate></dialTemplate>
	<kpml>0</kpml>
	<phoneLabel>CP8831_Test</phoneLabel>
	<stutterMsgWaiting>0</stutterMsgWaiting>
	<disableLocalSpeedDialConfig>true</disableLocalSpeedDialConfig>
	<dscpForAudio>184</dscpForAudio>
	<dscpVideo>136</dscpVideo>
	<startMediaPort>16384</startMediaPort>
	<stopMediaPort>32766</stopMediaPort>
</sipProfile>
<commonProfile>
	<phonePassword></phonePassword>
	<callLogBlfEnabled>2</callLogBlfEnabled>
</commonProfile>
<loadInformation>sip8831.10-3-1SR3-5-EU</loadInformation>
<vendorConfig>
</vendorConfig>
<commonConfig>
	<videoCapability>0</videoCapability>
	<ciscoCamera>0</ciscoCamera>
</commonConfig>
<sshAccess>0</sshAccess>
<sshUserId>301</sshUserId>
<sshPassword>301</sshPassword>
<versionStamp>1332742429550542</versionStamp>
<userLocale>
	<name>SIP_German_Germany</name>
	<langCode>de_DE</langCode>
</userLocale>
<networkLocale>SIP_Germany</networkLocale>
<networkLocaleInfo>
	<name>Germany</name>
</networkLocaleInfo>
<authenticationURL></authenticationURL>
<directoryURL></directoryURL>
<servicesURL></servicesURL>
<transportLayerProtocol>1</transportLayerProtocol>
</device>

The phone “kind of” connects to the freepbx. I can call my catch all number and speak in both ways.

But of course i have some problems. In Asterisk info the extension is shown as “unknown” status.
More important i cannot call it. This is a log when i try:

call attempt

Filter
Highlight (None)
Auto-Scroll
2[2021-02-17 13:47:04] VERBOSE[2349] pbx_variables.c: Setting global variable ‘SIPDOMAIN’ to ‘10.0.120.17’
3[2021-02-17 13:47:04] VERBOSE[2349] netsock2.c: Using SIP RTP Audio TOS bits 184
4[2021-02-17 13:47:04] VERBOSE[2349] netsock2.c: Using SIP RTP Audio TOS bits 184 in TCLASS field.
5[2021-02-17 13:47:04] VERBOSE[2349] netsock2.c: Using SIP RTP Audio CoS mark 5
6[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [301@from-internal:1] GotoIf(“PJSIP/333-00000003”, “1?ext-local,301,1:followme-check,301,1”) in new stack
7[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx_builtins.c: Goto (ext-local,301,1)
8[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [301@ext-local:1] Set(“PJSIP/333-00000003”, “__RINGTIMER=15”) in new stack
9[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [301@ext-local:2] ExecIf(“PJSIP/333-00000003”, “0?Set(__CWIGNORE=)”) in new stack
10[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [301@ext-local:3] Macro(“PJSIP/333-00000003”, “exten-vm,novm,301,0,0,0”) in new stack
11[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-exten-vm:1] Macro(“PJSIP/333-00000003”, “user-callerid,”) in new stack
12[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-user-callerid:1] Set(“PJSIP/333-00000003”, “TOUCH_MONITOR=1613566024.4”) in new stack
13[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-user-callerid:2] Set(“PJSIP/333-00000003”, “AMPUSER=333”) in new stack
14[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-user-callerid:3] Set(“PJSIP/333-00000003”, “HOTDESCKCHAN=333-00000003”) in new stack
15[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-user-callerid:4] Set(“PJSIP/333-00000003”, “HOTDESKEXTEN=333”) in new stack
16[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-user-callerid:5] Set(“PJSIP/333-00000003”, “HOTDESKCALL=0”) in new stack
17[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-user-callerid:6] ExecIf(“PJSIP/333-00000003”, “0?Set(HOTDESKCALL=1)”) in new stack
18[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-user-callerid:7] ExecIf(“PJSIP/333-00000003”, “0?Set(CALLERID(name)=)”) in new stack
19[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-user-callerid:8] GotoIf(“PJSIP/333-00000003”, “0?report”) in new stack
20[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-user-callerid:9] ExecIf(“PJSIP/333-00000003”, “1?Set(REALCALLERIDNUM=333)”) in new stack
21[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-user-callerid:10] Set(“PJSIP/333-00000003”, “AMPUSER=333”) in new stack
22[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-user-callerid:11] GotoIf(“PJSIP/333-00000003”, “0?limit”) in new stack
23[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-user-callerid:12] Set(“PJSIP/333-00000003”, “AMPUSERCIDNAME=77333 abi Softphone”) in new stack
24[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-user-callerid:13] ExecIf(“PJSIP/333-00000003”, “0?Set(__CIDMASQUERADING=TRUE)”) in new stack
25[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-user-callerid:14] GotoIf(“PJSIP/333-00000003”, “0?report”) in new stack
26[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-user-callerid:15] Set(“PJSIP/333-00000003”, “AMPUSERCID=333”) in new stack
27[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-user-callerid:16] Set(“PJSIP/333-00000003”, “__DIAL_OPTIONS=HhTtr”) in new stack
28[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-user-callerid:17] Set(“PJSIP/333-00000003”, “CALLERID(all)=“77333 abi Softphone” <333>”) in new stack
29[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-user-callerid:18] ExecIf(“PJSIP/333-00000003”, “0?Set(CUSDIAL=301)”) in new stack
30[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-user-callerid:19] ExecIf(“PJSIP/333-00000003”, “0?Set(CALLERID(all)=“77333 abi Softphone” <333>)”) in new stack
31[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-user-callerid:20] GotoIf(“PJSIP/333-00000003”, “0?limit”) in new stack
32[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-user-callerid:21] ExecIf(“PJSIP/333-00000003”, “0?Set(GROUP(concurrency_limit)=333)”) in new stack
33[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-user-callerid:22] ExecIf(“PJSIP/333-00000003”, “0?Set(CHANNEL(language)=)”) in new stack
34[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-user-callerid:23] NoOp(“PJSIP/333-00000003”, “Macro Depth is 2”) in new stack
35[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-user-callerid:24] GotoIf(“PJSIP/333-00000003”, “1?report2:macroerror”) in new stack
36[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx_builtins.c: Goto (macro-user-callerid,s,25)
37[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-user-callerid:25] GotoIf(“PJSIP/333-00000003”, “0?continue”) in new stack
38[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-user-callerid:26] ExecIf(“PJSIP/333-00000003”, “1?Set(__CALLEE_ACCOUNCODE=)”) in new stack
39[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-user-callerid:27] Set(“PJSIP/333-00000003”, “__TTL=64”) in new stack
40[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-user-callerid:28] GotoIf(“PJSIP/333-00000003”, “1?continue”) in new stack
41[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx_builtins.c: Goto (macro-user-callerid,s,44)
42[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-user-callerid:44] Set(“PJSIP/333-00000003”, “CALLERID(number)=333”) in new stack
43[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-user-callerid:45] Set(“PJSIP/333-00000003”, “CALLERID(name)=77333 abi Softphone”) in new stack
44[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-user-callerid:46] GotoIf(“PJSIP/333-00000003”, “0?cnum”) in new stack
45[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-user-callerid:47] Set(“PJSIP/333-00000003”, “CDR(cnam)=77333 abi Softphone”) in new stack
46[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-user-callerid:48] Set(“PJSIP/333-00000003”, “CDR(cnum)=333”) in new stack
47[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-user-callerid:49] Set(“PJSIP/333-00000003”, “CHANNEL(language)=de_DE”) in new stack
48[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-exten-vm:2] Set(“PJSIP/333-00000003”, “RingGroupMethod=none”) in new stack
49[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-exten-vm:3] Set(“PJSIP/333-00000003”, “__EXTTOCALL=301”) in new stack
50[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-exten-vm:4] Set(“PJSIP/333-00000003”, “__PICKUPMARK=301”) in new stack
51[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-exten-vm:5] Set(“PJSIP/333-00000003”, “RT=”) in new stack
52[2021-02-17 13:47:04] WARNING[11147][C-00000009] chan_sip.c: This function can only be used on SIP channels.
53[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-exten-vm:6] ExecIf(“PJSIP/333-00000003”, “0?Macro(vm,novm,DIRECTDIAL,)”) in new stack
54[2021-02-17 13:47:04] WARNING[11147][C-00000009] chan_sip.c: This function can only be used on SIP channels.
55[2021-02-17 13:47:04] WARNING[11147][C-00000009] chan_sip.c: This function can only be used on SIP channels.
56[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-exten-vm:7] ExecIf(“PJSIP/333-00000003”, “0?MacroExit()”) in new stack
57[2021-02-17 13:47:04] WARNING[11147][C-00000009] chan_sip.c: This function can only be used on SIP channels.
58[2021-02-17 13:47:04] WARNING[11147][C-00000009] chan_sip.c: This function can only be used on SIP channels.
59[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-exten-vm:8] ExecIf(“PJSIP/333-00000003”, “0?Gosub(ext-intercom,*80301,1())”) in new stack
60[2021-02-17 13:47:04] WARNING[11147][C-00000009] chan_sip.c: This function can only be used on SIP channels.
61[2021-02-17 13:47:04] WARNING[11147][C-00000009] chan_sip.c: This function can only be used on SIP channels.
62[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-exten-vm:9] ExecIf(“PJSIP/333-00000003”, “0?MacroExit()”) in new stack
63[2021-02-17 13:47:04] WARNING[11147][C-00000009] chan_sip.c: This function can only be used on SIP channels.
64[2021-02-17 13:47:04] WARNING[11147][C-00000009] chan_sip.c: This function can only be used on SIP channels.
65[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-exten-vm:10] ExecIf(“PJSIP/333-00000003”, “0?ChanSpy(PJSIP/301,q)”) in new stack
66[2021-02-17 13:47:04] WARNING[11147][C-00000009] chan_sip.c: This function can only be used on SIP channels.
67[2021-02-17 13:47:04] WARNING[11147][C-00000009] chan_sip.c: This function can only be used on SIP channels.
68[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-exten-vm:11] ExecIf(“PJSIP/333-00000003”, “0?MacroExit()”) in new stack
69[2021-02-17 13:47:04] WARNING[11147][C-00000009] chan_sip.c: This function can only be used on SIP channels.
70[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-exten-vm:12] ExecIf(“PJSIP/333-00000003”, “0?Macro(vm,novm,DIRECTDIAL,)”) in new stack
71[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-exten-vm:13] ExecIf(“PJSIP/333-00000003”, “0?MacroExit()”) in new stack
72[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-exten-vm:14] ExecIf(“PJSIP/333-00000003”, “0?Gosub(ext-intercom,*80301,1())”) in new stack
73[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-exten-vm:15] ExecIf(“PJSIP/333-00000003”, “0?MacroExit()”) in new stack
74[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-exten-vm:16] ExecIf(“PJSIP/333-00000003”, “0?ChanSpy(PJSIP/301,q)”) in new stack
75[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-exten-vm:17] ExecIf(“PJSIP/333-00000003”, “0?MacroExit()”) in new stack
76[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-exten-vm:18] Gosub(“PJSIP/333-00000003”, “sub-record-check,s,1(exten,301,dontcare)”) in new stack
77[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@sub-record-check:1] GotoIf(“PJSIP/333-00000003”, “0?initialized”) in new stack
78[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@sub-record-check:2] Set(“PJSIP/333-00000003”, “__REC_STATUS=INITIALIZED”) in new stack
79[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@sub-record-check:3] Set(“PJSIP/333-00000003”, “NOW=1613566024”) in new stack
80[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@sub-record-check:4] Set(“PJSIP/333-00000003”, “__DAY=17”) in new stack
81[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@sub-record-check:5] Set(“PJSIP/333-00000003”, “__MONTH=02”) in new stack
82[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@sub-record-check:6] Set(“PJSIP/333-00000003”, “__YEAR=2021”) in new stack
83[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@sub-record-check:7] Set(“PJSIP/333-00000003”, “__TIMESTR=20210217-134704”) in new stack
84[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@sub-record-check:8] Set(“PJSIP/333-00000003”, “__FROMEXTEN=333”) in new stack
85[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@sub-record-check:9] Set(“PJSIP/333-00000003”, “__MON_FMT=wav”) in new stack
86[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@sub-record-check:10] NoOp(“PJSIP/333-00000003”, “Recordings initialized”) in new stack
87[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@sub-record-check:11] ExecIf(“PJSIP/333-00000003”, “0?Set(ARG3=dontcare)”) in new stack
88[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@sub-record-check:12] Set(“PJSIP/333-00000003”, “REC_POLICY_MODE_SAVE=”) in new stack
89[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@sub-record-check:13] ExecIf(“PJSIP/333-00000003”, “0?Set(REC_STATUS=NO)”) in new stack
90[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@sub-record-check:14] GotoIf(“PJSIP/333-00000003”, “5?checkaction”) in new stack
91[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx_builtins.c: Goto (sub-record-check,s,17)
92[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@sub-record-check:17] GotoIf(“PJSIP/333-00000003”, “1?sub-record-check,exten,1”) in new stack
93[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx_builtins.c: Goto (sub-record-check,exten,1)
94[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [exten@sub-record-check:1] NoOp(“PJSIP/333-00000003”, “Exten Recording Check between 333 and 301”) in new stack
95[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [exten@sub-record-check:2] Set(“PJSIP/333-00000003”, “CALLTYPE=internal”) in new stack
96[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [exten@sub-record-check:3] ExecIf(“PJSIP/333-00000003”, “0?Set(CALLTYPE=)”) in new stack
97[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [exten@sub-record-check:4] Set(“PJSIP/333-00000003”, “CALLEE=dontcare”) in new stack
98[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [exten@sub-record-check:5] ExecIf(“PJSIP/333-00000003”, “0?Set(CALLEE=dontcare)”) in new stack
99[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [exten@sub-record-check:6] GotoIf(“PJSIP/333-00000003”, “0?callee”) in new stack
100[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [exten@sub-record-check:7] GotoIf(“PJSIP/333-00000003”, “1?caller”) in new stack
101[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx_builtins.c: Goto (sub-record-check,exten,13)
102[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [exten@sub-record-check:13] Set(“PJSIP/333-00000003”, “RECMODE=dontcare”) in new stack
103[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [exten@sub-record-check:14] ExecIf(“PJSIP/333-00000003”, “0?Set(RECMODE=dontcare)”) in new stack
104[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [exten@sub-record-check:15] ExecIf(“PJSIP/333-00000003”, “1?Set(RECMODE=dontcare)”) in new stack
105[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [exten@sub-record-check:16] Gosub(“PJSIP/333-00000003”, “recordcheck,1(dontcare,internal,301)”) in new stack
106[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp(“PJSIP/333-00000003”, “Starting recording check against dontcare”) in new stack
107[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [recordcheck@sub-record-check:2] Goto(“PJSIP/333-00000003”, “dontcare”) in new stack
108[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
109[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [recordcheck@sub-record-check:3] Return(“PJSIP/333-00000003”, “”) in new stack
110[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [exten@sub-record-check:17] Return(“PJSIP/333-00000003”, “”) in new stack
111[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-exten-vm:19] GotoIf(“PJSIP/333-00000003”, “1?macrodial”) in new stack
112[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx_builtins.c: Goto (macro-exten-vm,s,25)
113[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-exten-vm:25] GosubIf(“PJSIP/333-00000003”, “0?clrheader,1()”) in new stack
114[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-exten-vm:26] Macro(“PJSIP/333-00000003”, “dial-one,HhTtr,301”) in new stack
115[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-dial-one:1] Set(“PJSIP/333-00000003”, “DEXTEN=301”) in new stack
116[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-dial-one:2] Set(“PJSIP/333-00000003”, “__CRM_SOURCE=333”) in new stack
117[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-dial-one:3] ExecIf(“PJSIP/333-00000003”, “0?Set(__EXTTOCALL=301)”) in new stack
118[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-dial-one:4] Set(“PJSIP/333-00000003”, “DIALSTATUS_CW=”) in new stack
119[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-dial-one:5] GosubIf(“PJSIP/333-00000003”, “0?screen,1()”) in new stack
120[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-dial-one:6] GosubIf(“PJSIP/333-00000003”, “0?cf,1()”) in new stack
121[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-dial-one:7] GotoIf(“PJSIP/333-00000003”, “1?skip1”) in new stack
122[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx_builtins.c: Goto (macro-dial-one,s,10)
123[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-dial-one:10] GotoIf(“PJSIP/333-00000003”, “0?nodial”) in new stack
124[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-dial-one:11] GotoIf(“PJSIP/333-00000003”, “0?continue”) in new stack
125[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-dial-one:12] Set(“PJSIP/333-00000003”, “EXTHASCW=ENABLED”) in new stack
126[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-dial-one:13] GotoIf(“PJSIP/333-00000003”, “0?next1:cwinusebusy”) in new stack
127[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx_builtins.c: Goto (macro-dial-one,s,25)
128[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-dial-one:25] GotoIf(“PJSIP/333-00000003”, “0?next3:continue”) in new stack
129[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx_builtins.c: Goto (macro-dial-one,s,27)
130[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-dial-one:27] GotoIf(“PJSIP/333-00000003”, “0?nodial”) in new stack
131[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-dial-one:28] GosubIf(“PJSIP/333-00000003”, “1?dstring,1():dlocal,1()”) in new stack
132[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [dstring@macro-dial-one:1] Set(“PJSIP/333-00000003”, “DSTRING=”) in new stack
133[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [dstring@macro-dial-one:2] Set(“PJSIP/333-00000003”, “DEVICES=301”) in new stack
134[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [dstring@macro-dial-one:3] ExecIf(“PJSIP/333-00000003”, “0?Return()”) in new stack
135[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [dstring@macro-dial-one:4] ExecIf(“PJSIP/333-00000003”, “0?Set(DEVICES=01)”) in new stack
136[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [dstring@macro-dial-one:5] Set(“PJSIP/333-00000003”, “LOOPCNT=1”) in new stack
137[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [dstring@macro-dial-one:6] Set(“PJSIP/333-00000003”, “ITER=1”) in new stack
138[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [dstring@macro-dial-one:7] Set(“PJSIP/333-00000003”, “THISDIAL=PJSIP/301”) in new stack
139[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [dstring@macro-dial-one:8] GotoIf(“PJSIP/333-00000003”, “0?docheck”) in new stack
140[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [dstring@macro-dial-one:9] NoOp(“PJSIP/333-00000003”, “Debug: Found PJSIP Destination PJSIP/301”) in new stack
141[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [dstring@macro-dial-one:10] GotoIf(“PJSIP/333-00000003”, “0?doset”) in new stack
142[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [dstring@macro-dial-one:11] NoOp(“PJSIP/333-00000003”, “Debug: Updating PJSIP Destination with PJSIP_DIAL_CONTACTS”) in new stack
143[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [dstring@macro-dial-one:12] Set(“PJSIP/333-00000003”, “THISDIAL=”) in new stack
144[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [dstring@macro-dial-one:13] ExecIf(“PJSIP/333-00000003”, “1?Set(DIALSTATUS=CHANUNAVAIL)”) in new stack
145[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [dstring@macro-dial-one:14] GotoIf(“PJSIP/333-00000003”, “1?skipset”) in new stack
146[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx_builtins.c: Goto (macro-dial-one,dstring,16)
147[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [dstring@macro-dial-one:16] Set(“PJSIP/333-00000003”, “ITER=2”) in new stack
148[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [dstring@macro-dial-one:17] GotoIf(“PJSIP/333-00000003”, “0?begin”) in new stack
149[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [dstring@macro-dial-one:18] ExecIf(“PJSIP/333-00000003”, “1?Return()”) in new stack
150[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-dial-one:29] GotoIf(“PJSIP/333-00000003”, “1?nodial”) in new stack
151[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx_builtins.c: Goto (macro-dial-one,s,61)
152[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-dial-one:61] NoOp(“PJSIP/333-00000003”, “”) in new stack
153[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-dial-one:62] ExecIf(“PJSIP/333-00000003”, “0?Set(DIALSTATUS=NOANSWER)”) in new stack
154[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-dial-one:63] NoOp(“PJSIP/333-00000003”, “Returned from dial-one with nothing to call and DIALSTATUS: CHANUNAVAIL”) in new stack
155[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-dial-one:64] MacroExit(“PJSIP/333-00000003”, “”) in new stack
156[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-exten-vm:27] Set(“PJSIP/333-00000003”, “SV_DIALSTATUS=CHANUNAVAIL”) in new stack
157[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-exten-vm:28] GosubIf(“PJSIP/333-00000003”, “0?docfu,1()”) in new stack
158[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-exten-vm:29] GosubIf(“PJSIP/333-00000003”, “0?docfb,1()”) in new stack
159[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-exten-vm:30] Set(“PJSIP/333-00000003”, “DIALSTATUS=CHANUNAVAIL”) in new stack
160[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-exten-vm:31] ExecIf(“PJSIP/333-00000003”, “0?MacroExit()”) in new stack
161[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-exten-vm:32] GotoIf(“PJSIP/333-00000003”, “1?s-CHANUNAVAIL,1”) in new stack
162[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx_builtins.c: Goto (macro-exten-vm,s-CHANUNAVAIL,1)
163[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s-CHANUNAVAIL@macro-exten-vm:1] GotoIf(“PJSIP/333-00000003”, “0?exit,1”) in new stack
164[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s-CHANUNAVAIL@macro-exten-vm:2] PlayTones(“PJSIP/333-00000003”, “congestion”) in new stack
165[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s-CHANUNAVAIL@macro-exten-vm:3] Congestion(“PJSIP/333-00000003”, “10”) in new stack
166[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] app_macro.c: Spawn extension (macro-exten-vm, s-CHANUNAVAIL, 3) exited non-zero on ‘PJSIP/333-00000003’ in macro ‘exten-vm’
167[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Spawn extension (ext-local, 301, 3) exited non-zero on ‘PJSIP/333-00000003’
168[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [h@ext-local:1] Macro(“PJSIP/333-00000003”, “hangupcall,”) in new stack
169[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-hangupcall:1] GotoIf(“PJSIP/333-00000003”, “1?theend”) in new stack
170[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx_builtins.c: Goto (macro-hangupcall,s,3)
171[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-hangupcall:3] ExecIf(“PJSIP/333-00000003”, “0?Set(CDR(recordingfile)=)”) in new stack
172[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-hangupcall:4] NoOp(“PJSIP/333-00000003”, " montior file= ") in new stack
173[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-hangupcall:5] GotoIf(“PJSIP/333-00000003”, “1?skipagi”) in new stack
174[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx_builtins.c: Goto (macro-hangupcall,s,7)
175[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Executing [s@macro-hangupcall:7] Hangup(“PJSIP/333-00000003”, “”) in new stack
176[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] app_macro.c: Spawn extension (macro-hangupcall, s, 7) exited non-zero on ‘PJSIP/333-00000003’ in macro ‘hangupcall’
177[2021-02-17 13:47:04] VERBOSE[11147][C-00000009] pbx.c: Spawn extension (ext-local, h, 1) exited non-zero on ‘PJSIP/333-00000003’

The other main problem is that when i call from 8831 only the first typed in digit is transfered.
I remember that i had to use “no digit collect kpml” on the cisco server to circumvent that but i cannot find a similar option in freepbx.

A third (minor for me) problem is that it seems the phone never tries to get the firmware load i configured.


(Andreas) #2

I then enabled “sip set debug ip 10.0.30.35” and rebooted the phone. This is the log:

8831 boot log
179[2021-02-17 14:02:43] VERBOSE[2020] chan_sip.c:

180&lt;--- SIP read from UDP:10.0.30.35:50962 ---&gt;

181REFER sip:10.0.30.17 SIP/2.0

182Via: SIP/2.0/UDP 10.0.30.35:5060;branch=z9hG4bK165d8710

183From: &lt;sip:ac44f21156c2@10.0.30.35&gt;;tag=ac44f21156c20002572c1703-7ae56cb5

184To: &lt;sip:10.0.30.17&gt;

185Call-ID: ac44f211-56c20002-4d7bb9b2-4987b5b3@10.0.30.35

186Date: Sat, 01 Jan 2000 00:00:52 GMT

187CSeq: 1000 REFER

188User-Agent: Cisco-CP8831G/9.3.2

189Expires: 10

190Max-Forwards: 70

191Contact: &lt;sip:ac44f21156c2@10.0.30.35:5060&gt;

192Require: norefersub

193Referred-By: &lt;sip:ac44f21156c2@10.0.30.35&gt;

194Refer-To: cid:6ae2a787@10.0.30.35

195Content-Id: &lt;6ae2a787@10.0.30.35&gt;

196Allow: ACK,BYE,CANCEL,INVITE,NOTIFY,OPTIONS,REFER,REGISTER,UPDATE,SUBSCRIBE

197Content-Length: 1299

198Content-Type: application/x-cisco-alarm+xml

199Content-Disposition: session;handling=required

200

201&lt;?xml version="1.0" encoding="UTF-8"?&gt;

202&lt;x-cisco-alarm&gt;

203&lt;Alarm Name="LastOutOfServiceInformation"&gt;

204&lt;ParameterList&gt;

205&lt;String name="DeviceName"&gt;SEPAC44F21156C2&lt;/String&gt;

206&lt;String name="DeviceIPv4Address"&gt;10.0.30.35/24&lt;/String&gt;

207&lt;String name="IPv4DefaultGateway"&gt;10.0.30.17&lt;/String&gt;

208&lt;String name="DeviceIPv6Address"&gt;&lt;/String&gt;

209&lt;String name="IPv6DefaultGateway"&gt;&lt;/String&gt;

210&lt;String name="ModelNumber"&gt;CP-8831&lt;/String&gt;

211&lt;String name="NeighborIPv4Address"&gt;0.0.0.0&lt;/String&gt;

212&lt;String name="NeighborIPv6Address"&gt;&lt;/String&gt;

213&lt;String name="NeighborDeviceID"&gt;&lt;/String&gt;

214&lt;String name="NeighborPortID"&gt;&lt;/String&gt;

215&lt;Enum name="DHCPv4Status"&gt;1&lt;/Enum&gt;

216&lt;Enum name="DHCPv6Status"&gt;0&lt;/Enum&gt;

217&lt;Enum name="TFTPCfgStatus"&gt;1&lt;/Enum&gt;

218&lt;Enum name="DNSStatusUnifiedCM1"&gt;4&lt;/Enum&gt;

219&lt;Enum name="DNSStatusUnifiedCM2"&gt;0&lt;/Enum&gt;

220&lt;Enum name="DNSStatusUnifiedCM3"&gt;0&lt;/Enum&gt;

221&lt;String name="VoiceVLAN"&gt;4095&lt;/String&gt;

222&lt;String name="UnifiedCMIPAddress"&gt;10.0.30.17&lt;/String&gt;

223&lt;String name="LocalPort"&gt;0&lt;/String&gt;

224&lt;String name="TimeStamp"&gt;946686542813946684861907&lt;/String&gt;

225&lt;Enum name="ReasonForOutOfService"&gt;14&lt;/Enum&gt;

226&lt;String name="LastProtocolEventSent"&gt;Sent:REGISTER sip:10.0.30.17 SIP/2.0 Cseq:101 REGISTER CallId:ac44f211-56c20002-33f5da99-0b94958b@10.0.30.35&lt;/String&gt;

227&lt;String name="LastProtocolEventReceived"&gt;&lt;/String&gt;

228&lt;/ParameterList&gt;

229&lt;/Alarm&gt;

230&lt;/x-cisco-alarm&gt;

231&lt;-------------&gt;

232[2021-02-17 14:02:43] VERBOSE[2020] chan_sip.c: --- (19 headers 30 lines) ---

233[2021-02-17 14:02:43] VERBOSE[2020] chan_sip.c: Sending to 10.0.30.35:5060 (no NAT)

234[2021-02-17 14:02:43] VERBOSE[2020] chan_sip.c: Call ac44f211-56c20002-4d7bb9b2-4987b5b3@10.0.30.35 got a SIP call transfer from caller: (REFER)!

235[2021-02-17 14:02:43] VERBOSE[2020] chan_sip.c:

236&lt;--- Transmitting (no NAT) to 10.0.30.35:5060 ---&gt;

237SIP/2.0 603 Declined (No dialog)

238Via: SIP/2.0/UDP 10.0.30.35:5060;branch=z9hG4bK165d8710;received=10.0.30.35

239From: &lt;sip:ac44f21156c2@10.0.30.35&gt;;tag=ac44f21156c20002572c1703-7ae56cb5

240To: &lt;sip:10.0.30.17&gt;;tag=as7ab7b5b6

241Call-ID: ac44f211-56c20002-4d7bb9b2-4987b5b3@10.0.30.35

242CSeq: 1000 REFER

243Server: FPBX-15.0.17.17(16.15.1)

244Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE

245Supported: replaces, timer

246Content-Length: 0

247

248

249&lt;------------&gt;

250[2021-02-17 14:02:43] VERBOSE[2020] chan_sip.c: Really destroying SIP dialog 'ac44f211-56c20002-4d7bb9b2-4987b5b3@10.0.30.35' Method: REFER

[![FreePBX®](https://pnasterisk.pnd.local/admin/images/freepbx_small.png?load_version=15.0.17.17) ](http://www.freepbx.org)

[FreePBX](http://www.freepbx.org) is a registered trademark of
[ Sangoma Technologies Inc.](http://www.freepbx.org/copyright.html)
FreePBX 15.0.17.17 is licensed under the [ GPL](http://www.gnu.org/copyleft/gpl.html)
[Copyright© 2007-2021](http://www.freepbx.org/copyright.html)

[![www.sangoma.com](https://pnasterisk.pnd.local/admin/images/sangoma-horizontal_thumb.png) ](http://www.sangoma.com)

Can you help me or give me some advices what to do next?


#3

With default settings on FreePBX, pjsip listens on port 5060 “Port to Listen On” and chan_sip on port 5160 “Bind Port”. Please confirm that you have not changed these.

The phone config does not mention port 5160, so I don’t understand why ‘sip set debug’ shows anything from the phone. The corresponding command for pjsip is ‘pjsip set logger on’. You can have both active at the same time, though a phone would normally communicate with only one driver.

The call from 333 to 301 apparently failed because 301 was not registered as a pjsip extension.

I don’t understand the REFER request on boot. After that, do you see registration requests?

In Reports -> Asterisk Info, what shows for extension 301?


(Andreas) #4

I changed the pjsip TCP Port to 5061.
In the extension tab i get this message " This device uses PJSIP technology listening on Port 5060 (UDP), Port 5061 (TCP - this is a NON STANDARD port)"
But tcp should not be an issue becaue it should communicate over udp or shoudn’t it?

In asterisk info is this “PJSIP 301 OFFLINE 0” but i can place calls via the 8831 (even if it can only reach the catch all rule)

If i turn “sip set debug off” and “pjsip set logger on” then i do not receive any registration logs about this extension. (but i kind of get flooded by my jitsi-softphones)

Although i am still able to place a call
EDIT: Ah i think i can place a call because i allowed “anonymous inbound calls”


(Andreas) #5

Small step further. The 8831 does not recognize when i change the config.xml.
I had to do a factory reset on the phone, now it produces some logs:

log
82380[2021-02-18 12:39:38] VERBOSE[1958] res_pjsip_logger.c: <--- Transmitting SIP request (413 bytes) to UDP:10.0.30.35:50651 --->
82381OPTIONS sip:301@10.0.30.35:50651 SIP/2.0
82382Via: SIP/2.0/UDP 10.0.30.17:5060;rport;branch=z9hG4bKPjf9fbafe4-cde0-4f16-b009-50f289d6c35a
82383From: <sip:301@10.0.1.17>;tag=74cad7c0-4252-4038-80de-329cca907217
82384To: <sip:301@10.0.30.35>
82385Contact: <sip:301@10.0.30.17:5060>
82386Call-ID: e91e6dfb-fafd-4b90-9363-664ce34d30b2
82387CSeq: 65195 OPTIONS
82388Max-Forwards: 70
82389User-Agent: FPBX-15.0.17.17(16.15.1)
82390Content-Length: 0

And sometimes

log2

104923[2021-02-18 15:24:50] ERROR[1958] pjproject: sip_transport.c Error processing 1254 bytes packet from UDP 10.0.30.35:40076 : PJSIP syntax error exception when parsing 'Request Line' header on line 1 col 1:

And whenever i change something in the .xml (even the label) i have to do another factory reset. How tidious.
Is this because i have a major mistake in my XML? This is the current version i use and that worked with c2911.

SEPAC44F21156C2.cnf.xml
<device>
<fullConfig>true</fullConfig>
<deviceProtocol>SIP</deviceProtocol>
<devicePool>
<dateTimeSetting>
<dateTemplate>M/D/Y</dateTemplate>
<timeZone>Central Europe Standard/Daylight Time</timeZone>
<ntps>
<ntp priority="0">
<name></name>
<ntpMode>directedbroadcast</ntpMode>
</ntp>
</ntps>
</dateTimeSetting>
<callManagerGroup>
<members>
<member priority="0">
<callManager>
<ports>
<sipPort>5060</sipPort>
</ports>
<processNodeName>10.0.30.17</processNodeName>
</callManager>
</member>
</members>
</callManagerGroup>
</devicePool>
<sipProfile>
<sipProxies>
<registerWithProxy>true</registerWithProxy>
</sipProxies>
<sipCallFeatures>
<cnfJoinEnabled>true</cnfJoinEnabled>
<localCfwdEnable>true</localCfwdEnable>
<callForwardURI>service-uri-cfwdall</callForwardURI>
<callPickupURI>service-uri-pickup</callPickupURI>
<callPickupGroupURI>service-uri-gpickup</callPickupGroupURI>
<meetMeServiceURI>service-uri-meetme</meetMeServiceURI>
<callHoldRingback>2</callHoldRingback>
<semiAttendedTransfer>true</semiAttendedTransfer>
<anonymousCallBlock>2</anonymousCallBlock>
<callerIdBlocking>2</callerIdBlocking>
<dndControl>2</dndControl>
<dndCallAlert>1</dndCallAlert>
<remoteCcEnable>true</remoteCcEnable>
</sipCallFeatures>
<sipStack>
<timerRegisterExpires>3600</timerRegisterExpires>
<timerRegisterDelta>5</timerRegisterDelta>
<timerInviteExpires>180</timerInviteExpires>
<timerKeepAliveExpires>3600</timerKeepAliveExpires>
<timerSubscribeExpires>3600</timerSubscribeExpires>
<timerSubscribeDelta>5</timerSubscribeDelta>
<timerT1>500</timerT1>
<timerT2>4000</timerT2>
<remotePartyID>true</remotePartyID>
</sipStack>
<sipLines>
<line button="1" lineIndex="1">
<featureID>9</featureID>
<featureLabel>CP8831_Test3</featureLabel>
<contact>301</contact>
<speedDialNumber></speedDialNumber>
<proxy>USECALLMANAGER</proxy>
<port>5060</port>
<voipControlPort>5060</voipControlPort>
<name>301</name>
<displayName>CP8831_Test3</displayName>
<autoAnswer>
<autoAnswerEnabled>2</autoAnswerEnabled>
</autoAnswer>
<callWaiting>1</callWaiting>
<authName>301</authName>
<authPassword>301</authPassword>
<sharedLine>false</sharedLine>
<messagesNumber></messagesNumber>
<messageWaitingLampPolicy>3</messageWaitingLampPolicy>
<ringSettingActive>5</ringSettingActive>
<forwardCallInfoDisplay>
<callerName>true</callerName>
<callerNumber>true</callerNumber>
<redirectedNumber>true</redirectedNumber>
<dialedNumber>true</dialedNumber>
</forwardCallInfoDisplay>
<maxNumCalls>6</maxNumCalls>
<busyTrigger>1</busyTrigger>
</line>
</sipLines>
<enableVad>true</enableVad>
<preferredCodec>g711alaw</preferredCodec>
<softKeyFile>softkeyDefault_kpml.xml</softKeyFile>
<dialTemplate></dialTemplate>
<kpml>1</kpml>
<phoneLabel>CP8831_Test3</phoneLabel>
<stutterMsgWaiting>2</stutterMsgWaiting>
<disableLocalSpeedDialConfig>true</disableLocalSpeedDialConfig>
<dscpForAudio>184</dscpForAudio>
<dscpVideo>136</dscpVideo>
<startMediaPort>16384</startMediaPort>
<stopMediaPort>32766</stopMediaPort>
</sipProfile>
<commonProfile>
<phonePassword>301</phonePassword>
<callLogBlfEnabled>2</callLogBlfEnabled>
</commonProfile>
<loadInformation>sip8831.10-3-1SR3-5-EU</loadInformation>
<vendorConfig>
</vendorConfig>
<commonConfig>
<videoCapability>0</videoCapability>
<ciscoCamera>0</ciscoCamera>
</commonConfig>
<sshUserId>301</sshUserId>
<sshPassword>301</sshPassword>
<versionStamp>1332742429550542</versionStamp>
<userLocale>
<name>SIP_German_Germany</name>
<langCode>de_DE</langCode>
</userLocale>
<networkLocale>SIP_Germany</networkLocale>
<networkLocaleInfo>
<name>German_Germany</name>
</networkLocaleInfo>
<authenticationURL></authenticationURL>
<directoryURL></directoryURL>
<servicesURL></servicesURL>
<dscpForSCCPPhoneServices>0</dscpForSCCPPhoneServices>
<dscpForCm2Dvce>96</dscpForCm2Dvce>
<transportLayerProtocol>2</transportLayerProtocol>

Strange enough in the log file is this line:

82383From: <sip:301@10.0.1.17>;tag=74cad7c0-4252-4038-80de-329cca907217

10.0.1.17 is a second interface on freepbx to communicate with our “non-hardware phones” network.