Tek-Tips is the largest IT community on the Internet today!

Members share and learn making Tek-Tips Forums the best source of peer-reviewed technical information on the Internet!

  • Congratulations wOOdy-Soft on being selected by the Tek-Tips community for having the most helpful posts in the forums last week. Way to Go!

remote softphone on 500v2 R9.0

Status
Not open for further replies.

bdelmar

Technical User
Apr 20, 2004
577
US
Customer can use softphone internally no problem.

When they are remote, creates a vpn connection on their laptop. NATing on the router directs traffic to the IP of the IPO. cant ping it no problem. But its not registering.

Im seeing SIP REG: Remote worker. couldn't find user for extn 9091 in the trace. 9091 is the temp extn it creates. the user has a Power user license, remote worker and softphone is enable. Remote SIP Ext is enabled, Softphone HTTP Provisioning is enabled.


********** Warning: Logging to Screen Started **********
16:11:58 1749788292mS HTTP: 10.1.1.66(54477) HTTPSession (Total = 2)
16:11:58 1749788313mS HTTP: 10.1.1.66(54477) HTTPSession: Operational
16:11:58 1749788323mS HTTP: Rx Src: 10.1.1.66(54477)
POST /SipSoftPhone HTTP/1.1
Host: 10.1.1.87
Accept: */*
User-Agent: IP Office Softphone 6.1 3.2.3.49 build 68975
Content-Length: 179
Content-Type: application/x-
16:11:58 1749788324mS HTTP: 10.1.1.66(54477) HTTPServerSessionIO: stCreationCallback
16:11:58 1749788324mS HTTP: 10.1.1.66(54477) HTTPSipSoftPhoneSessionIO: stCreationCallback
16:11:58 1749788324mS HTTP: 10.1.1.66(54477) HTTPSipSoftPhoneSessionIO, total 1
16:11:58 1749788324mS HTTP: 10.1.1.66(54477) SetSipState Sip_CleanupAndSchedule -> Sip_ParseMessage
16:11:58 1749788343mS HTTP: 10.1.1.66(54477) SetSipState Sip_ParseMessage -> Sip_CreateExtension
16:11:58 1749788346mS Sip: Check NVConfig for update: sip_cfgupdate=0
16:11:58 1749788346mS Sip: SIP Extn 9091 change registration state to unregistered
16:11:58 1749788346mS Sip: Set broadcast address for <9091>
16:11:58 1749788346mS PRN: Created standalone sip extension f44a12a8 extn number 9091
16:11:58 1749788346mS CMExtnEvt: LoginShortCode: user=Test extn=<none> password_entered=correct forcelogin=0 remote=1
16:11:58 1749788346mS PRN: SetLoginUser: (this="NoUser", b_from_remote=0 ) User 9069 trying to log on to extn 9091, on top of user NoUser at UTC time 1559941918
16:11:58 1749788346mS CMExtnEvt: SetLoginUser: diag=a
16:11:58 1749788347mS CMExtnEvt: LoginUserList: user=Test(current extn=<none>) goes to extn=9091(current user=NoUser)
16:11:58 1749788347mS CMExtnEvt: Test: ProcessShortCode feature=DoNotDisturbOff id=
16:11:58 1749788348mS HTTP: No IM/Presence info sent for User Test
16:11:58 1749788350mS HTTP: 10.1.1.66(54477) SetSipState Sip_CreateExtension -> Sip_Delete
16:11:58 1749788352mS PRN: Config Write Wake Up
16:11:58 1749788352mS HTTP: 10.1.1.66(54477) HTTPServerSessionIO: SetState GracefulClose
16:11:58 1749788352mS HTTP: 10.1.1.66(54477) SetSipState Sip_Delete -> Sip_CleanupAndSchedule
16:11:58 1749788354mS HTTP: Tx Dest: 10.1.1.66(54477)
HTTP/1.1 200 OK
Connection: close
Date: Fri, 07 Jun 2019 21:11:58 GMT
Cache-Control: private
Server: IPOffice/
Content-Type: application/x- Content-Length: 2881

16:11:58 1749788379mS HTTP: 10.1.1.66(54477) HTTPServerSessionIO: Percent(50)
16:11:58 1749788411mS HTTP: 10.1.1.66(54477) HTTPServerSessionIO: Percent(100)
16:11:58 1749788429mS HTTP: 10.1.1.66(54477) HTTPSession: EndOfData
16:11:58 1749788431mS HTTP: 10.1.1.66(54477) HTTPServerSessionIO: SetState Delete
16:11:58 1749788431mS HTTP: 10.1.1.66(54477) ~HTTPSipSoftPhoneSessionIO, total 0
16:11:58 1749788431mS HTTP: 10.1.1.66(54477) ~HTTPSession: Duration: 139ms (Total = 1)
16:11:58 1749788761mS RES: Fri 7/6/2019 16:11:58 FreeMem=45768320 43734688(5) CachedMem=2033632 CMMsg=6(8) Buff=5200 1341 999 7364 5 Links=6165 BTree=12333 CPU=12.53% CPUStats=6/14/2039/8214/10928/0/0 MCR=0 MCW=0
16:11:58 1749788761mS RES2: IP 500 V2 9.0.5.0 build 972 Tasks=57 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=71 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=2 SSA=1 TCP=18(TLS=1) TAPI=0 ASC=1 SYS=MNTD OPT=UMNT SDSPD=2034
16:11:58 1749788761mS RES4: XML MemObjs=61 PoolMem=2097152(1) FreeMem=2081872(1)
16:11:58 1749788853mS PRN: Updates IO list size 1 updated list size 1
16:11:58 1749788853mS PRN: Sending Updates out to f4517868 started
16:11:58 1749788854mS PRN: Sending Updates out to f4517868 finished
16:11:58 1749788854mS PRN: Config Write Completed
16:12:01 1749791401mS SIP Rx: UDP 10.1.1.66:37644 -> 10.1.1.87:5060
0000 52 45 47 49 53 54 45 52 20 73 69 70 3a 31 30 2e REGISTER sip:10.
0010 31 2e 31 2e 38 37 20 53 49 50 2f 32 2e 30 0d 0a 1.1.87 SIP/2.0..
0020 56 69 61 3a 20 53 49 50 2f 32 2e 30 2f 55 44 50 Via: SIP/2.0/UDP
0030 20 31 37 32 2e 32 37 2e 32 35 32 2e 36 37 3a 33 172.27.252.67:3
0040 37 36 34 34 3b 62 72 61 6e 63 68 3d 7a 39 68 47 7644;branch=z9hG
0050 34 62 4b 2d 64 38 37 35 34 7a 2d 33 37 39 64 31 4bK-d8754z-379d1
0060 31 66 37 64 38 62 31 36 34 38 33 2d 31 2d 2d 2d 1f7d8b16483-1---
0070 64 38 37 35 34 7a 2d 3b 72 70 6f 72 74 0d 0a 4d d8754z-;rport..M
0080 61 78 2d 46 6f 72 77 61 72 64 73 3a 20 37 30 0d ax-Forwards: 70.
0090 0a 43 6f 6e 74 61 63 74 3a 20 3c 73 69 70 3a 39 .Contact: <sip:9
00a0 30 39 31 40 31 37 32 2e 32 37 2e 32 35 32 2e 36 091@172.27.252.6
00b0 37 3a 33 37 36 34 34 3b 72 69 6e 73 74 61 6e 63 7:37644;rinstanc
00c0 65 3d 66 62 63 30 61 36 39 30 35 30 63 38 38 34 e=fbc0a69050c884
00d0 64 62 3b 74 72 61 6e 73 70 6f 72 74 3d 75 64 70 db;transport=udp
00e0 3e 0d 0a 54 6f 3a 20 22 54 65 73 74 22 3c 73 69 >..To: "Test"<si
00f0 70 3a 39 30 39 31 40 31 30 2e 31 2e 31 2e 38 37 p:9091@10.1.1.87
0100 3e 0d 0a 46 72 6f 6d 3a 20 22 54 65 73 74 22 3c >..From: "Test"<
0110 73 69 70 3a 39 30 39 31 40 31 30 2e 31 2e 31 2e sip:9091@10.1.1.
0120 38 37 3e 3b 74 61 67 3d 31 64 38 63 39 61 61 37 87>;tag=1d8c9aa7
0130 0d 0a 43 61 6c 6c 2d 49 44 3a 20 4e 47 46 69 4e ..Call-ID: NGFiN
0140 7a 52 6d 4e 7a 55 31 5a 44 59 7a 59 7a 5a 69 4f zRmNzU1ZDYzYzZiO
0150 57 45 30 4d 44 4a 6b 5a 6a 59 77 5a 6a 46 6b 4d WE0MDJkZjYwZjFkM
0160 7a 45 78 59 54 63 0d 0a 43 53 65 71 3a 20 31 20 zExYTc..CSeq: 1
0170 52 45 47 49 53 54 45 52 0d 0a 45 78 70 69 72 65 REGISTER..Expire
0180 73 3a 20 33 36 30 30 0d 0a 41 6c 6c 6f 77 3a 20 s: 3600..Allow:
0190 49 4e 56 49 54 45 2c 20 41 43 4b 2c 20 43 41 4e INVITE, ACK, CAN
01a0 43 45 4c 2c 20 4f 50 54 49 4f 4e 53 2c 20 42 59 CEL, OPTIONS, BY
01b0 45 2c 20 52 45 46 45 52 2c 20 4e 4f 54 49 46 59 E, REFER, NOTIFY
01c0 2c 20 4d 45 53 53 41 47 45 2c 20 53 55 42 53 43 , MESSAGE, SUBSC
01d0 52 49 42 45 2c 20 49 4e 46 4f 0d 0a 55 73 65 72 RIBE, INFO..User
01e0 2d 41 67 65 6e 74 3a 20 49 50 20 4f 66 66 69 63 -Agent: IP Offic
01f0 65 20 53 6f 66 74 70 68 6f 6e 65 20 36 2e 31 20 e Softphone 6.1
0200 33 2e 32 2e 33 2e 34 39 20 62 75 69 6c 64 20 36 3.2.3.49 build 6
0210 38 39 37 35 0d 0a 43 6f 6e 74 65 6e 74 2d 4c 65 8975..Content-Le
0220 6e 67 74 68 3a 20 30 0d 0a 0d 0a ngth: 0....
16:12:01 1749791404mS SIP Reg/Opt Rx: phone
REGISTER sip:10.1.1.87 SIP/2.0
Via: SIP/2.0/UDP 172.27.252.67:37644;branch=z9hG4bK-d8754z-379d11f7d8b16483-1---d8754z-;rport
Max-Forwards: 70
Contact: <sip:9091@172.27.252.67:37644;rinstance=fbc0a69050c884db;transport=udp>
To: "Test"<sip:9091@10.1.1.87>
From: "Test"<sip:9091@10.1.1.87>;tag=1d8c9aa7
Call-ID: NGFiNzRmNzU1ZDYzYzZiOWE0MDJkZjYwZjFkMzExYTc
CSeq: 1 REGISTER
Expires: 3600
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE, SUBSCRIBE, INFO
User-Agent: IP Office Softphone 6.1 3.2.3.49 build 68975
Content-Length: 0

16:12:01 1749791404mS Sip: SIPPhoneReceiver 247 (f46353e8) udp created, srcaddress 10.1.1.66, list size 3
16:12:01 1749791404mS Sip: SIPDialog f44a2550 created, dialogs 1
16:12:01 1749791405mS Sip: SIP REG: Remote worker. couldn't find user for extn 9091
16:12:01 1749791405mS Sip: (f44a2550) SendSIPResponse: REGISTER code 404 SENT TO 10.1.1.66 37644
16:12:01 1749791406mS SIP Reg/Opt Tx: phone
SIP/2.0 404 Not Found
Via: SIP/2.0/UDP 172.27.252.67:37644;branch=z9hG4bK-d8754z-379d11f7d8b16483-1---d8754z-;rport
From: "Test" <sip:9091@10.1.1.87>;tag=1d8c9aa7
Call-ID: NGFiNzRmNzU1ZDYzYzZiOWE0MDJkZjYwZjFkMzExYTc
CSeq: 1 REGISTER
User-Agent: IP Office 9.0.5.0 build 972
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,REFER,NOTIFY,INFO,SUBSCRIBE,REGISTER,PUBLISH
Supported: timer
Server: IP Office 9.0.5.0 build 972
Reason: Q.850;cause=1;text="Unallocated (unassigned) number"
To: "Test" <sip:9091@10.1.1.87>;tag=6ecd504ce1e30cf2
Content-Length: 0

16:12:01 1749791406mS SIP Tx: UDP 10.1.1.87:5060 -> 10.1.1.66:37644
0000 53 49 50 2f 32 2e 30 20 34 30 34 20 4e 6f 74 20 SIP/2.0 404 Not
0010 46 6f 75 6e 64 0d 0a 56 69 61 3a 20 53 49 50 2f Found..Via: SIP/
0020 32 2e 30 2f 55 44 50 20 31 37 32 2e 32 37 2e 32 2.0/UDP 172.27.2
0030 35 32 2e 36 37 3a 33 37 36 34 34 3b 62 72 61 6e 52.67:37644;bran
0040 63 68 3d 7a 39 68 47 34 62 4b 2d 64 38 37 35 34 ch=z9hG4bK-d8754
0050 7a 2d 33 37 39 64 31 31 66 37 64 38 62 31 36 34 z-379d11f7d8b164
0060 38 33 2d 31 2d 2d 2d 64 38 37 35 34 7a 2d 3b 72 83-1---d8754z-;r
0070 70 6f 72 74 0d 0a 46 72 6f 6d 3a 20 22 54 65 73 port..From: "Tes
0080 74 22 20 3c 73 69 70 3a 39 30 39 31 40 31 30 2e t" <sip:9091@10.
0090 31 2e 31 2e 38 37 3e 3b 74 61 67 3d 31 64 38 63 1.1.87>;tag=1d8c
00a0 39 61 61 37 0d 0a 43 61 6c 6c 2d 49 44 3a 20 4e 9aa7..Call-ID: N
00b0 47 46 69 4e 7a 52 6d 4e 7a 55 31 5a 44 59 7a 59 GFiNzRmNzU1ZDYzY
00c0 7a 5a 69 4f 57 45 30 4d 44 4a 6b 5a 6a 59 77 5a zZiOWE0MDJkZjYwZ
00d0 6a 46 6b 4d 7a 45 78 59 54 63 0d 0a 43 53 65 71 jFkMzExYTc..CSeq
00e0 3a 20 31 20 52 45 47 49 53 54 45 52 0d 0a 55 73 : 1 REGISTER..Us
00f0 65 72 2d 41 67 65 6e 74 3a 20 49 50 20 4f 66 66 er-Agent: IP Off
0100 69 63 65 20 39 2e 30 2e 35 2e 30 20 62 75 69 6c ice 9.0.5.0 buil
0110 64 20 39 37 32 0d 0a 41 6c 6c 6f 77 3a 20 49 4e d 972..Allow: IN
0120 56 49 54 45 2c 41 43 4b 2c 43 41 4e 43 45 4c 2c VITE,ACK,CANCEL,
0130 4f 50 54 49 4f 4e 53 2c 42 59 45 2c 52 45 46 45 OPTIONS,BYE,REFE
0140 52 2c 4e 4f 54 49 46 59 2c 49 4e 46 4f 2c 53 55 R,NOTIFY,INFO,SU
0150 42 53 43 52 49 42 45 2c 52 45 47 49 53 54 45 52 BSCRIBE,REGISTER
0160 2c 50 55 42 4c 49 53 48 0d 0a 53 75 70 70 6f 72 ,PUBLISH..Suppor
0170 74 65 64 3a 20 74 69 6d 65 72 0d 0a 53 65 72 76 ted: timer..Serv
0180 65 72 3a 20 49 50 20 4f 66 66 69 63 65 20 39 2e er: IP Office 9.
0190 30 2e 35 2e 30 20 62 75 69 6c 64 20 39 37 32 0d 0.5.0 build 972.
01a0 0a 52 65 61 73 6f 6e 3a 20 51 2e 38 35 30 3b 63 .Reason: Q.850;c
01b0 61 75 73 65 3d 31 3b 74 65 78 74 3d 22 55 6e 61 ause=1;text="Una
01c0 6c 6c 6f 63 61 74 65 64 20 28 75 6e 61 73 73 69 llocated (unassi
01d0 67 6e 65 64 29 20 6e 75 6d 62 65 72 22 0d 0a 54 gned) number"..T
01e0 6f 3a 20 22 54 65 73 74 22 20 3c 73 69 70 3a 39 o: "Test" <sip:9
01f0 30 39 31 40 31 30 2e 31 2e 31 2e 38 37 3e 3b 74 091@10.1.1.87>;t
0200 61 67 3d 36 65 63 64 35 30 34 63 65 31 65 33 30 ag=6ecd504ce1e30
0210 63 66 32 0d 0a 43 6f 6e 74 65 6e 74 2d 4c 65 6e cf2..Content-Len
0220 67 74 68 3a 20 30 0d 0a 0d 0a gth: 0....
16:12:01 1749791406mS Sip: SIPDialog f44a2550 deleted, dialogs 0
16:12:01 1749791407mS Sip: SIPPhoneReceiver 247 (f46353e8) destroyed, list size 2
16:12:01 1749791966mS PRN: Optimizing BTree Lists Completed...Started:1749790306

********** Warning: Logging to Screen Stopped **********
 
16:11:58 1749788346mS PRN: Created standalone sip extension f44a12a8 extn number 9091
16:11:58 1749788346mS CMExtnEvt: LoginShortCode: user=Test extn=<none> password_entered=correct forcelogin=0 remote=1

Seems that IPO cannot find the extension of the user.

Need some help with IP Office? CLI based cale blocking: SCN fallback over PSTN:
 
The users extn is created, is 9069. You can see in the next line it recognizes it and tries.

16:11:58 1749788346mS PRN: SetLoginUser: (this="NoUser", b_from_remote=0 ) User 9069 trying to log on to extn 9091, on top of user NoUser at UTC time 1559941918
16:11:58 1749788346mS CMExtnEvt: SetLoginUser: diag=a
 
Status
Not open for further replies.

Part and Inventory Search

Sponsor

Back
Top