VPN сервер¶
- Table of contents
- VPN сервер
В дистрибутив Smartswitch интегрирован VPN сервер, полностью совместимый для подключения штатными средствами Windows.
Это может потребоваться для случаев, когда вы хотите надежно зашифровать Ваши коммуникации.
Для подключения следует использовать ваш логин и пароль пользователя, тот же, что и на веб-интерфейс.
При подключении пользователю по умолчанию выделяется динамический IP-адрес, при этом в SIP настройках вы должны будете указать, что тип аутентификации должен быть по динамическому IP адресу и паролю или по номеру звонящего.
Также есть возможность выделить статический IP адрес для VPN пользователя, в этом случае вы сможете указать тип SIP аутентификации по статическому IP адресу.
Настройка VPN подключения в Windows 10.¶
Перейдите в настройки и нажмите Network & Internet :
Добавьте новое VPN подключение:
Подключитесь:
Подключение состоялось:
Состояние VPN адаптера после успешного подключения¶
Лог успешного подключения¶
# cat /var/log/mpd.log Apr 29 17:45:47 voip mpd[92581]: EVENT: Processing event EVENT_READ PptpCtrlListenEvent() Apr 29 17:45:47 voip mpd[92581]: PPTP: Incoming control connection from 174.114.135.28 57389 to x.x.x.x 1723 Apr 29 17:45:47 voip mpd[92581]: pptp0: ctrl state FREE --> IDLE Apr 29 17:45:47 voip mpd[92581]: pptp0: attached to connection with 174.114.135.28 57389 Apr 29 17:45:47 voip mpd[92581]: EVENT: Registering event EVENT_READ PptpCtrlReadCtrl() at pptp_ctrl.c:937 Apr 29 17:45:47 voip mpd[92581]: EVENT: Registering event EVENT_READ PptpCtrlReadCtrl() done at pptp_ctrl.c:937 Apr 29 17:45:47 voip mpd[92581]: EVENT: Starting timer "PptpIdle" PptpCtrlIdleTimeout() for 60000 ms at pptp_ctrl.c:1692 Apr 29 17:45:47 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() at timer.c:50 Apr 29 17:45:47 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() done at timer.c:50 Apr 29 17:45:47 voip mpd[92581]: EVENT: Processing event EVENT_READ PptpCtrlListenEvent() done Apr 29 17:45:47 voip mpd[92581]: EVENT: Processing event EVENT_READ PptpCtrlReadCtrl() Apr 29 17:45:47 voip mpd[92581]: pptp0: read 12 bytes ctrl data Apr 29 17:45:47 voip mpd[92581]: 00 9c 00 01 1a 2b 3c 4d 00 01 00 00 .....+<M.... Apr 29 17:45:47 voip mpd[92581]: pptp0: got hdr Apr 29 17:45:47 voip mpd[92581]: len=0x9c msgType=1 magic=0x1a2b3c4d type=1 Apr 29 17:45:47 voip mpd[92581]: EVENT: Processing event EVENT_READ PptpCtrlReadCtrl() done Apr 29 17:45:47 voip mpd[92581]: EVENT: Processing event EVENT_READ PptpCtrlReadCtrl() Apr 29 17:45:47 voip mpd[92581]: pptp0: read 144 bytes ctrl data Apr 29 17:45:47 voip mpd[92581]: 01 00 00 00 00 00 00 01 00 00 00 01 00 00 00 00 ................ Apr 29 17:45:47 voip mpd[92581]: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................ Apr 29 17:45:47 voip syslogd: last message repeated 3 times Apr 29 17:45:47 voip mpd[92581]: 4d 69 63 72 6f 73 6f 66 74 00 00 00 00 00 00 00 Microsoft....... Apr 29 17:45:47 voip mpd[92581]: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................ Apr 29 17:45:47 voip syslogd: last message repeated 2 times Apr 29 17:45:47 voip mpd[92581]: pptp0: recv StartCtrlConnRequest Apr 29 17:45:47 voip mpd[92581]: vers=0x100 frameCap=1 bearCap=1 maxChan=0 firm=0 host="" Apr 29 17:45:47 voip mpd[92581]: vend="Microsoft" Apr 29 17:45:47 voip mpd[92581]: EVENT: Stopping timer "PptpIdle" PptpCtrlIdleTimeout() at pptp_ctrl.c:1689 Apr 29 17:45:47 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() at timer.c:83 Apr 29 17:45:47 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() done at timer.c:83 Apr 29 17:45:47 voip mpd[92581]: EVENT: Starting timer "PptpIdle" PptpCtrlIdleTimeout() for 60000 ms at pptp_ctrl.c:1692 Apr 29 17:45:47 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() at timer.c:50 Apr 29 17:45:47 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() done at timer.c:50 Apr 29 17:45:47 voip mpd[92581]: pptp0: ctrl state IDLE --> ESTABLISHED Apr 29 17:45:47 voip mpd[92581]: pptp0: send StartCtrlConnReply msg Apr 29 17:45:47 voip mpd[92581]: len=0x9c msgType=1 magic=0x1a2b3c4d type=2 Apr 29 17:45:47 voip mpd[92581]: vers=0x100 result=1 err=0 frameCap=3 bearCap=3 maxChan=0 Apr 29 17:45:47 voip mpd[92581]: firm=0x101 host="voip.xxxxx.ua" vend="FreeBSD MPD" Apr 29 17:45:47 voip mpd[92581]: pptp0: wrote 156 bytes ctrl data Apr 29 17:45:47 voip mpd[92581]: 00 9c 00 01 1a 2b 3c 4d 00 02 00 00 01 00 01 00 .....+<M........ Apr 29 17:45:47 voip mpd[92581]: 00 00 00 03 00 00 00 03 00 00 01 01 76 6f 69 70 ............voip Apr 29 17:45:47 voip mpd[92581]: 2e 00 00 00 00 00 00 2e 6d 65 00 00 00 00 00 00 .xxxxxx.me...... Apr 29 17:45:47 voip mpd[92581]: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................ Apr 29 17:45:47 voip syslogd: last message repeated 1 times Apr 29 17:45:47 voip mpd[92581]: 00 00 00 00 00 00 00 00 00 00 00 00 46 72 65 65 ............Free Apr 29 17:45:47 voip mpd[92581]: 42 53 44 20 4d 50 44 00 00 00 00 00 00 00 00 00 BSD.MPD......... Apr 29 17:45:47 voip mpd[92581]: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................ Apr 29 17:45:47 voip syslogd: last message repeated 1 times Apr 29 17:45:47 voip mpd[92581]: 00 00 00 00 00 00 00 00 00 00 00 00 ............ Apr 29 17:45:47 voip mpd[92581]: EVENT: Processing event EVENT_READ PptpCtrlReadCtrl() done Apr 29 17:45:47 voip mpd[92581]: EVENT: Processing event EVENT_READ PptpCtrlReadCtrl() Apr 29 17:45:47 voip mpd[92581]: pptp0: read 12 bytes ctrl data Apr 29 17:45:47 voip mpd[92581]: 00 a8 00 01 1a 2b 3c 4d 00 07 00 00 .....+<M.... Apr 29 17:45:47 voip mpd[92581]: pptp0: got hdr Apr 29 17:45:47 voip mpd[92581]: len=0xa8 msgType=1 magic=0x1a2b3c4d type=7 Apr 29 17:45:47 voip mpd[92581]: EVENT: Processing event EVENT_READ PptpCtrlReadCtrl() done Apr 29 17:45:47 voip mpd[92581]: EVENT: Processing event EVENT_READ PptpCtrlReadCtrl() Apr 29 17:45:47 voip mpd[92581]: pptp0: read 156 bytes ctrl data Apr 29 17:45:47 voip mpd[92581]: e0 2d 00 02 00 00 01 2c 05 f5 e1 00 00 00 00 03 .-.....,........ Apr 29 17:45:47 voip mpd[92581]: 00 00 00 03 00 40 00 00 00 00 00 00 00 00 00 00 .....@.......... Apr 29 17:45:47 voip mpd[92581]: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................ Apr 29 17:45:47 voip syslogd: last message repeated 6 times Apr 29 17:45:47 voip mpd[92581]: 00 00 00 00 00 00 00 00 00 00 00 00 ............ Apr 29 17:45:47 voip mpd[92581]: pptp0: recv OutCallRequest Apr 29 17:45:47 voip mpd[92581]: cid=0xe02d serno=2 minBPS=0x12c maxBPS=0x5f5e100 bearType=3 Apr 29 17:45:47 voip mpd[92581]: frameType=3 recvWin=64 ppd=0 numLen=0 phone="" subaddr="" Apr 29 17:45:47 voip mpd[92581]: EVENT: Stopping timer "PptpIdle" PptpCtrlIdleTimeout() at pptp_ctrl.c:1689 Apr 29 17:45:47 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() at timer.c:83 Apr 29 17:45:47 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() done at timer.c:83 Apr 29 17:45:47 voip mpd[92581]: EVENT: Starting timer "PptpIdle" PptpCtrlIdleTimeout() for 60000 ms at pptp_ctrl.c:1692 Apr 29 17:45:47 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() at timer.c:50 Apr 29 17:45:47 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() done at timer.c:50 Apr 29 17:45:47 voip mpd[92581]: pptp0-0: chan state FREE --> WAIT_ANSWER Apr 29 17:45:47 voip mpd[92581]: [L-1] Accepting PPTP connection Apr 29 17:45:47 voip mpd[92581]: EVENT: Message 1 to LinkMsg() sent Apr 29 17:45:47 voip mpd[92581]: EVENT: Processing event EVENT_READ PptpCtrlReadCtrl() done Apr 29 17:45:47 voip mpd[92581]: EVENT: Processing event EVENT_READ MsgEvent() Apr 29 17:45:47 voip mpd[92581]: EVENT: Message 1 to LinkMsg() received Apr 29 17:45:47 voip mpd[92581]: [L-1] Link: OPEN event Apr 29 17:45:47 voip mpd[92581]: [L-1] LCP: Open event Apr 29 17:45:47 voip mpd[92581]: [L-1] LCP: state change Initial --> Starting Apr 29 17:45:47 voip mpd[92581]: [L-1] LCP: LayerStart Apr 29 17:45:47 voip mpd[92581]: EVENT: Message 1 to PhysMsg() sent Apr 29 17:45:47 voip mpd[92581]: EVENT: Message 1 to LinkMsg() processed Apr 29 17:45:47 voip mpd[92581]: EVENT: Message 1 to PhysMsg() received Apr 29 17:45:47 voip mpd[92581]: [L-1] device: OPEN event Apr 29 17:45:47 voip mpd[92581]: [L-1] PPTP: attaching to peer's outgoing call Apr 29 17:45:47 voip mpd[92581]: pptp0-0: chan state WAIT_ANSWER --> ESTABLISHED Apr 29 17:45:47 voip mpd[92581]: pptp0: send OutCallReply msg Apr 29 17:45:47 voip mpd[92581]: len=32 msgType=1 magic=0x1a2b3c4d type=8 Apr 29 17:45:47 voip mpd[92581]: cid=0x61e0 peerCid=0xe02d result=1 err=0 cause=0 speed=0xfa00 Apr 29 17:45:47 voip mpd[92581]: recvWin=16 ppd=1 channel=0 Apr 29 17:45:47 voip mpd[92581]: pptp0: wrote 32 bytes ctrl data Apr 29 17:45:47 voip mpd[92581]: 00 20 00 01 1a 2b 3c 4d 00 08 00 00 61 e0 e0 2d .....+<M....a..- Apr 29 17:45:47 voip mpd[92581]: 01 00 00 00 00 00 fa 00 00 10 00 01 00 00 00 00 ................ Apr 29 17:45:47 voip mpd[92581]: [L-1] device: UP event Apr 29 17:45:47 voip mpd[92581]: [L-1] Link: UP event Apr 29 17:45:47 voip mpd[92581]: [L-1] Link: origination is remote Apr 29 17:45:47 voip mpd[92581]: [L-1] LCP: Up event Apr 29 17:45:47 voip mpd[92581]: [L-1] LCP: state change Starting --> Req-Sent Apr 29 17:45:47 voip mpd[92581]: [L-1] LCP: phase shift DEAD --> ESTABLISH Apr 29 17:45:47 voip mpd[92581]: [L-1] LCP: SendConfigReq #1 Apr 29 17:45:47 voip mpd[92581]: [L-1] ACFCOMP Apr 29 17:45:47 voip mpd[92581]: [L-1] PROTOCOMP Apr 29 17:45:47 voip mpd[92581]: [L-1] MRU 1500 Apr 29 17:45:47 voip mpd[92581]: [L-1] MAGICNUM 0xc4ed072f Apr 29 17:45:47 voip mpd[92581]: [L-1] AUTHPROTO CHAP MSOFTv2 Apr 29 17:45:47 voip mpd[92581]: [L-1] MP MRRU 2048 Apr 29 17:45:47 voip mpd[92581]: [L-1] MP SHORTSEQ Apr 29 17:45:47 voip mpd[92581]: [L-1] ENDPOINTDISC [802.1] a8 a1 59 0f 25 39 Apr 29 17:45:47 voip mpd[92581]: [L-1] xmit frame to link proto=0xc021 Apr 29 17:45:47 voip mpd[92581]: ff 03 c0 21 01 01 00 26 08 02 07 02 01 04 05 dc ...!...&........ Apr 29 17:45:47 voip mpd[92581]: 05 06 c4 ed 07 2f 03 05 c2 23 81 11 04 08 00 12 ...../...#...... Apr 29 17:45:47 voip mpd[92581]: 02 13 09 03 a8 a1 59 0f 25 39 ......Y.%9 Apr 29 17:45:47 voip mpd[92581]: EVENT: Starting timer "LCP" FsmTimeout() for 2000 ms at fsm.c:426 Apr 29 17:45:47 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() at timer.c:50 Apr 29 17:45:47 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() done at timer.c:50 Apr 29 17:45:47 voip mpd[92581]: EVENT: Message 1 to PhysMsg() processed Apr 29 17:45:47 voip mpd[92581]: EVENT: Processing event EVENT_READ MsgEvent() done Apr 29 17:45:47 voip mpd[92581]: EVENT: Processing event EVENT_READ MsgEvent() Apr 29 17:45:47 voip mpd[92581]: EVENT: Processing event EVENT_READ MsgEvent() done Apr 29 17:45:47 voip mpd[92581]: EVENT: Processing event EVENT_READ PptpCtrlReadCtrl() Apr 29 17:45:47 voip mpd[92581]: pptp0: read 12 bytes ctrl data Apr 29 17:45:47 voip mpd[92581]: 00 18 00 01 1a 2b 3c 4d 00 0f 00 00 .....+<M.... Apr 29 17:45:47 voip mpd[92581]: pptp0: got hdr Apr 29 17:45:47 voip mpd[92581]: len=24 msgType=1 magic=0x1a2b3c4d type=15 Apr 29 17:45:47 voip mpd[92581]: EVENT: Processing event EVENT_READ PptpCtrlReadCtrl() done Apr 29 17:45:47 voip mpd[92581]: EVENT: Processing event EVENT_READ PptpCtrlReadCtrl() Apr 29 17:45:47 voip mpd[92581]: pptp0: read 12 bytes ctrl data Apr 29 17:45:47 voip mpd[92581]: 61 e0 00 00 ff ff ff ff ff ff ff ff a........... Apr 29 17:45:47 voip mpd[92581]: pptp0: recv SetLinkInfo Apr 29 17:45:47 voip mpd[92581]: cid=0x61e0 sendAccm=0xffffffff recvAccm=0xffffffff Apr 29 17:45:47 voip mpd[92581]: EVENT: Stopping timer "PptpIdle" PptpCtrlIdleTimeout() at pptp_ctrl.c:1689 Apr 29 17:45:47 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() at timer.c:83 Apr 29 17:45:47 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() done at timer.c:83 Apr 29 17:45:47 voip mpd[92581]: EVENT: Starting timer "PptpIdle" PptpCtrlIdleTimeout() for 60000 ms at pptp_ctrl.c:1692 Apr 29 17:45:47 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() at timer.c:50 Apr 29 17:45:47 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() done at timer.c:50 Apr 29 17:45:47 voip mpd[92581]: EVENT: Processing event EVENT_READ PptpCtrlReadCtrl() done Apr 29 17:45:47 voip mpd[92581]: EVENT: Processing event EVENT_READ LinkNgDataEvent() Apr 29 17:45:47 voip mpd[92581]: [L-1] rec'd 25 bytes frame from link proto=0xc021 Apr 29 17:45:47 voip mpd[92581]: ff 03 c0 21 01 00 00 15 01 04 05 78 05 06 6d 03 ...!.......x..m. Apr 29 17:45:47 voip mpd[92581]: 06 63 07 02 08 02 0d 03 06 .c....... Apr 29 17:45:47 voip mpd[92581]: [L-1] LCP: rec'd Configure Request #0 (Req-Sent) Apr 29 17:45:47 voip mpd[92581]: [L-1] MRU 1400 Apr 29 17:45:47 voip mpd[92581]: [L-1] MAGICNUM 0x6d030663 Apr 29 17:45:47 voip mpd[92581]: [L-1] PROTOCOMP Apr 29 17:45:47 voip mpd[92581]: [L-1] ACFCOMP Apr 29 17:45:47 voip mpd[92581]: [L-1] CALLBACK 6 Apr 29 17:45:47 voip mpd[92581]: [L-1] LCP: SendConfigRej #0 Apr 29 17:45:47 voip mpd[92581]: [L-1] CALLBACK 6 Apr 29 17:45:47 voip mpd[92581]: [L-1] xmit frame to link proto=0xc021 Apr 29 17:45:47 voip mpd[92581]: ff 03 c0 21 04 00 00 07 0d 03 06 ...!....... Apr 29 17:45:47 voip mpd[92581]: EVENT: Processing event EVENT_READ LinkNgDataEvent() done Apr 29 17:45:47 voip mpd[92581]: EVENT: Processing event EVENT_READ LinkNgDataEvent() Apr 29 17:45:47 voip mpd[92581]: [L-1] rec'd 22 bytes frame from link proto=0xc021 Apr 29 17:45:47 voip mpd[92581]: ff 03 c0 21 01 01 00 12 01 04 05 78 05 06 6d 03 ...!.......x..m. Apr 29 17:45:47 voip mpd[92581]: 06 63 07 02 08 02 .c.... Apr 29 17:45:47 voip mpd[92581]: [L-1] LCP: rec'd Configure Request #1 (Req-Sent) Apr 29 17:45:47 voip mpd[92581]: [L-1] MRU 1400 Apr 29 17:45:47 voip mpd[92581]: [L-1] MAGICNUM 0x6d030663 Apr 29 17:45:47 voip mpd[92581]: [L-1] PROTOCOMP Apr 29 17:45:47 voip mpd[92581]: [L-1] ACFCOMP Apr 29 17:45:47 voip mpd[92581]: [L-1] LCP: SendConfigAck #1 Apr 29 17:45:47 voip mpd[92581]: [L-1] MRU 1400 Apr 29 17:45:47 voip mpd[92581]: [L-1] MAGICNUM 0x6d030663 Apr 29 17:45:47 voip mpd[92581]: [L-1] PROTOCOMP Apr 29 17:45:47 voip mpd[92581]: [L-1] ACFCOMP Apr 29 17:45:47 voip mpd[92581]: [L-1] xmit frame to link proto=0xc021 Apr 29 17:45:47 voip mpd[92581]: ff 03 c0 21 02 01 00 12 01 04 05 78 05 06 6d 03 ...!.......x..m. Apr 29 17:45:47 voip mpd[92581]: 06 63 07 02 08 02 .c.... Apr 29 17:45:47 voip mpd[92581]: [L-1] LCP: state change Req-Sent --> Ack-Sent Apr 29 17:45:47 voip mpd[92581]: EVENT: Processing event EVENT_READ LinkNgDataEvent() done Apr 29 17:45:49 voip mpd[92581]: EVENT: Processing event EVENT_TIMEOUT TimerExpires() Apr 29 17:45:49 voip mpd[92581]: EVENT: Processing timer "LCP" FsmTimeout() Apr 29 17:45:49 voip mpd[92581]: [L-1] LCP: SendConfigReq #2 Apr 29 17:45:49 voip mpd[92581]: [L-1] ACFCOMP Apr 29 17:45:49 voip mpd[92581]: [L-1] PROTOCOMP Apr 29 17:45:49 voip mpd[92581]: [L-1] MRU 1500 Apr 29 17:45:49 voip mpd[92581]: [L-1] MAGICNUM 0xc4ed072f Apr 29 17:45:49 voip mpd[92581]: [L-1] AUTHPROTO CHAP MSOFTv2 Apr 29 17:45:49 voip mpd[92581]: [L-1] MP MRRU 2048 Apr 29 17:45:49 voip mpd[92581]: [L-1] MP SHORTSEQ Apr 29 17:45:49 voip mpd[92581]: [L-1] ENDPOINTDISC [802.1] a8 a1 59 0f 25 39 Apr 29 17:45:49 voip mpd[92581]: [L-1] xmit frame to link proto=0xc021 Apr 29 17:45:49 voip mpd[92581]: ff 03 c0 21 01 02 00 26 08 02 07 02 01 04 05 dc ...!...&........ Apr 29 17:45:49 voip mpd[92581]: 05 06 c4 ed 07 2f 03 05 c2 23 81 11 04 08 00 12 ...../...#...... Apr 29 17:45:49 voip mpd[92581]: 02 13 09 03 a8 a1 59 0f 25 39 ......Y.%9 Apr 29 17:45:49 voip mpd[92581]: EVENT: Starting timer "LCP" FsmTimeout() for 2000 ms at fsm.c:426 Apr 29 17:45:49 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() at timer.c:50 Apr 29 17:45:49 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() done at timer.c:50 Apr 29 17:45:49 voip mpd[92581]: EVENT: Processing timer "LCP" FsmTimeout() done Apr 29 17:45:49 voip mpd[92581]: EVENT: Processing event EVENT_TIMEOUT TimerExpires() done Apr 29 17:45:49 voip mpd[92581]: EVENT: Processing event EVENT_READ LinkNgDataEvent() Apr 29 17:45:49 voip mpd[92581]: [L-1] rec'd 23 bytes frame from link proto=0xc021 Apr 29 17:45:49 voip mpd[92581]: ff 03 c0 21 04 02 00 13 11 04 08 00 12 02 13 09 ...!............ Apr 29 17:45:49 voip mpd[92581]: 03 a8 a1 59 0f 25 39 ...Y.%9 Apr 29 17:45:49 voip mpd[92581]: [L-1] LCP: rec'd Configure Reject #2 (Ack-Sent) Apr 29 17:45:49 voip mpd[92581]: [L-1] MP MRRU 2048 Apr 29 17:45:49 voip mpd[92581]: [L-1] MP SHORTSEQ Apr 29 17:45:49 voip mpd[92581]: [L-1] ENDPOINTDISC [802.1] a8 a1 59 0f 25 39 Apr 29 17:45:49 voip mpd[92581]: EVENT: Stopping timer "LCP" FsmTimeout() at fsm.c:531 Apr 29 17:45:49 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() at timer.c:83 Apr 29 17:45:49 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() done at timer.c:83 Apr 29 17:45:49 voip mpd[92581]: [L-1] LCP: SendConfigReq #3 Apr 29 17:45:49 voip mpd[92581]: [L-1] ACFCOMP Apr 29 17:45:49 voip mpd[92581]: [L-1] PROTOCOMP Apr 29 17:45:49 voip mpd[92581]: [L-1] MRU 1500 Apr 29 17:45:49 voip mpd[92581]: [L-1] MAGICNUM 0xc4ed072f Apr 29 17:45:49 voip mpd[92581]: [L-1] AUTHPROTO CHAP MSOFTv2 Apr 29 17:45:49 voip mpd[92581]: [L-1] xmit frame to link proto=0xc021 Apr 29 17:45:49 voip mpd[92581]: ff 03 c0 21 01 03 00 17 08 02 07 02 01 04 05 dc ...!............ Apr 29 17:45:49 voip mpd[92581]: 05 06 c4 ed 07 2f 03 05 c2 23 81 ...../...#. Apr 29 17:45:49 voip mpd[92581]: EVENT: Starting timer "LCP" FsmTimeout() for 2000 ms at fsm.c:426 Apr 29 17:45:49 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() at timer.c:50 Apr 29 17:45:49 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() done at timer.c:50 Apr 29 17:45:49 voip mpd[92581]: EVENT: Processing event EVENT_READ LinkNgDataEvent() done Apr 29 17:45:49 voip mpd[92581]: EVENT: Processing event EVENT_READ PptpCtrlReadCtrl() Apr 29 17:45:49 voip mpd[92581]: pptp0: read 12 bytes ctrl data Apr 29 17:45:49 voip mpd[92581]: 00 18 00 01 1a 2b 3c 4d 00 0f 00 00 .....+<M.... Apr 29 17:45:49 voip mpd[92581]: pptp0: got hdr Apr 29 17:45:49 voip mpd[92581]: len=24 msgType=1 magic=0x1a2b3c4d type=15 Apr 29 17:45:49 voip mpd[92581]: EVENT: Processing event EVENT_READ PptpCtrlReadCtrl() done Apr 29 17:45:49 voip mpd[92581]: EVENT: Processing event EVENT_READ PptpCtrlReadCtrl() Apr 29 17:45:49 voip mpd[92581]: pptp0: read 12 bytes ctrl data Apr 29 17:45:49 voip mpd[92581]: 61 e0 00 00 ff ff ff ff ff ff ff ff a........... Apr 29 17:45:49 voip mpd[92581]: pptp0: recv SetLinkInfo Apr 29 17:45:49 voip mpd[92581]: cid=0x61e0 sendAccm=0xffffffff recvAccm=0xffffffff Apr 29 17:45:49 voip mpd[92581]: EVENT: Stopping timer "PptpIdle" PptpCtrlIdleTimeout() at pptp_ctrl.c:1689 Apr 29 17:45:49 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() at timer.c:83 Apr 29 17:45:49 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() done at timer.c:83 Apr 29 17:45:49 voip mpd[92581]: EVENT: Starting timer "PptpIdle" PptpCtrlIdleTimeout() for 60000 ms at pptp_ctrl.c:1692 Apr 29 17:45:49 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() at timer.c:50 Apr 29 17:45:49 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() done at timer.c:50 Apr 29 17:45:49 voip mpd[92581]: EVENT: Processing event EVENT_READ PptpCtrlReadCtrl() done Apr 29 17:45:49 voip mpd[92581]: EVENT: Processing event EVENT_READ LinkNgDataEvent() Apr 29 17:45:49 voip mpd[92581]: [L-1] rec'd 27 bytes frame from link proto=0xc021 Apr 29 17:45:49 voip mpd[92581]: ff 03 c0 21 02 03 00 17 08 02 07 02 01 04 05 dc ...!............ Apr 29 17:45:49 voip mpd[92581]: 05 06 c4 ed 07 2f 03 05 c2 23 81 ...../...#. Apr 29 17:45:49 voip mpd[92581]: [L-1] LCP: rec'd Configure Ack #3 (Ack-Sent) Apr 29 17:45:49 voip mpd[92581]: [L-1] ACFCOMP Apr 29 17:45:49 voip mpd[92581]: [L-1] PROTOCOMP Apr 29 17:45:49 voip mpd[92581]: [L-1] MRU 1500 Apr 29 17:45:49 voip mpd[92581]: [L-1] MAGICNUM 0xc4ed072f Apr 29 17:45:49 voip mpd[92581]: [L-1] AUTHPROTO CHAP MSOFTv2 Apr 29 17:45:49 voip mpd[92581]: [L-1] LCP: state change Ack-Sent --> Opened Apr 29 17:45:49 voip mpd[92581]: [L-1] LCP: phase shift ESTABLISH --> AUTHENTICATE Apr 29 17:45:49 voip mpd[92581]: [L-1] LCP: auth: peer wants nothing, I want CHAP Apr 29 17:45:49 voip mpd[92581]: EVENT: Starting timer "AuthTimer" AuthTimeout() for 40000 ms at auth.c:411 Apr 29 17:45:49 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() at timer.c:50 Apr 29 17:45:49 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() done at timer.c:50 Apr 29 17:45:49 voip mpd[92581]: EVENT: Starting timer "ChalTimer" ChapChalTimeout() for 2000 ms at chap.c:75 Apr 29 17:45:49 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() at timer.c:50 Apr 29 17:45:49 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() done at timer.c:50 Apr 29 17:45:49 voip mpd[92581]: [L-1] CHAP: sending CHALLENGE #1 len: 21 Apr 29 17:45:49 voip mpd[92581]: [L-1] xmit frame to link proto=0xc223 Apr 29 17:45:49 voip mpd[92581]: ff 03 c2 23 01 01 00 15 10 bb 1e 68 dc 79 1e ce ...#.......h.y.. Apr 29 17:45:49 voip mpd[92581]: f0 af 2c 47 87 ab 11 4a 66 ..,G...Jf Apr 29 17:45:49 voip mpd[92581]: EVENT: Stopping timer "LCP" FsmTimeout() at fsm.c:190 Apr 29 17:45:49 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() at timer.c:83 Apr 29 17:45:49 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() done at timer.c:83 Apr 29 17:45:49 voip mpd[92581]: EVENT: Starting recurring timer "FsmKeepAlive" FsmEchoTimeout() for 10000 ms at fsm.c:200 Apr 29 17:45:49 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() at timer.c:69 Apr 29 17:45:49 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() done at timer.c:69 Apr 29 17:45:49 voip mpd[92581]: [L-1] LCP: LayerUp Apr 29 17:45:49 voip mpd[92581]: [L-1] rec'd 20 bytes frame from link proto=0xc021 Apr 29 17:45:49 voip mpd[92581]: c0 21 0c 02 00 12 6d 03 06 63 4d 53 52 41 53 56 .!....m..cMSRASV Apr 29 17:45:49 voip mpd[92581]: 35 2e 32 30 5.20 Apr 29 17:45:49 voip mpd[92581]: [L-1] LCP: rec'd Ident #2 (Opened) Apr 29 17:45:49 voip mpd[92581]: [L-1] MESG: MSRASV5.20 Apr 29 17:45:49 voip mpd[92581]: [L-1] rec'd 33 bytes frame from link proto=0xc021 Apr 29 17:45:49 voip mpd[92581]: c0 21 0c 03 00 1f 6d 03 06 63 4d 53 52 41 53 2d .!....m..cMSRAS- Apr 29 17:45:49 voip mpd[92581]: 30 2d 44 45 53 4b 54 4f 50 2d 36 4f 45 46 4a 52 0-DESKTOP-6OEFJR Apr 29 17:45:49 voip mpd[92581]: 52 R Apr 29 17:45:49 voip mpd[92581]: [L-1] LCP: rec'd Ident #3 (Opened) Apr 29 17:45:49 voip mpd[92581]: [L-1] MESG: MSRAS-0-DESKTOP-6OEFJRR Apr 29 17:45:49 voip mpd[92581]: [L-1] rec'd 26 bytes frame from link proto=0xc021 Apr 29 17:45:49 voip mpd[92581]: c0 21 0c 04 00 18 6d 03 06 63 88 f5 12 21 40 45 .!....m..c...!@E Apr 29 17:45:49 voip mpd[92581]: 01 00 39 db 3b 21 40 45 d9 01 ..9.;!@E.. Apr 29 17:45:49 voip mpd[92581]: [L-1] LCP: rec'd Ident #4 (Opened) Apr 29 17:45:49 voip mpd[92581]: [L-1] MESG: M-^H<F5>^R!@E^A Apr 29 17:45:49 voip mpd[92581]: EVENT: Processing event EVENT_READ LinkNgDataEvent() done Apr 29 17:45:49 voip mpd[92581]: EVENT: Processing event EVENT_READ LinkNgDataEvent() Apr 29 17:45:49 voip mpd[92581]: [L-1] rec'd 63 bytes frame from link proto=0xc223 Apr 29 17:45:49 voip mpd[92581]: c2 23 02 01 00 3d 31 5e b9 c7 42 84 57 a9 b6 74 .#...=1^..B.W..t Apr 29 17:45:49 voip mpd[92581]: 74 5b 21 7d 43 4f 79 00 00 00 00 00 00 00 00 90 t[!}COy......... Apr 29 17:45:49 voip mpd[92581]: c5 11 96 79 1f 0a b1 b9 70 b4 03 6e 2e 18 18 da ...y....p..n.... Apr 29 17:45:49 voip mpd[92581]: 8d 29 ba 46 e3 48 45 00 73 75 00 00 00 00 00 .).F.HE.admin Apr 29 17:45:49 voip mpd[92581]: [L-1] CHAP: rec'd RESPONSE #1 len: 61 Apr 29 17:45:49 voip mpd[92581]: EVENT: Stopping timer "ChalTimer" ChapChalTimeout() at chap.c:402 Apr 29 17:45:49 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() at timer.c:83 Apr 29 17:45:49 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() done at timer.c:83 Apr 29 17:45:49 voip mpd[92581]: [L-1] Name: "admin" Apr 29 17:45:49 voip mpd[92581]: EVENT: Processing event EVENT_READ LinkNgDataEvent() done Apr 29 17:45:49 voip mpd[92581]: [L-1] AUTH: Thread started Apr 29 17:45:49 voip mpd[92581]: [L-1] AUTH: Trying EXTERNAL Apr 29 17:45:49 voip mpd[92581]: [L-1] Ext-auth: Invoking auth program: '/usr/local/bin/smartswitch/mpd_auth 'admin'' Apr 29 17:45:49 voip mpd[92581]: [L-1] Ext-auth: attr:'USER_LM_HASH', value:'8584430FCE17D7E67C3113XXXXXXXXXX' Apr 29 17:45:49 voip mpd[92581]: [L-1] Ext-auth: attr:'USER_NT_HASH', value:'79928B56B15AC6BDFE4327XXXXXXXXXX' Apr 29 17:45:49 voip mpd[92581]: [L-1] Ext-auth: attr:'RESULT', value:'UNDEF' Apr 29 17:45:49 voip mpd[92581]: [L-1] AUTH: EXTERNAL returned: undefined Apr 29 17:45:49 voip mpd[92581]: [L-1] AUTH: Thread finished normally Apr 29 17:45:49 voip mpd[92581]: [L-1] CHAP: Auth return status: undefined Apr 29 17:45:49 voip mpd[92581]: [L-1] CHAP: Response is valid Apr 29 17:45:49 voip mpd[92581]: [L-1] CHAP: Reply message: S=9A9F6A5D3A094AEA74F11B0A76117738A3641A10 Apr 29 17:45:49 voip mpd[92581]: [L-1] CHAP: sending SUCCESS #1 len: 46 Apr 29 17:45:49 voip mpd[92581]: [L-1] xmit frame to link proto=0xc223 Apr 29 17:45:49 voip mpd[92581]: ff 03 c2 23 03 01 00 2e 53 3d 39 41 39 46 36 41 ...#....S=9A9F6A Apr 29 17:45:49 voip mpd[92581]: 35 44 33 41 30 39 34 41 45 41 37 34 46 31 31 42 5D3A094AEA74F11B Apr 29 17:45:49 voip mpd[92581]: 30 41 37 36 31 31 37 37 33 38 41 33 36 34 31 41 0A76117738A3641A Apr 29 17:45:49 voip mpd[92581]: 31 30 10 Apr 29 17:45:49 voip mpd[92581]: EVENT: Stopping timer "AuthTimer" AuthTimeout() at auth.c:718 Apr 29 17:45:49 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() at timer.c:83 Apr 29 17:45:49 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() done at timer.c:83 Apr 29 17:45:49 voip mpd[92581]: [L-1] LCP: authorization successful Apr 29 17:45:49 voip mpd[92581]: [L-1] LCP: phase shift AUTHENTICATE --> NETWORK Apr 29 17:45:49 voip mpd[92581]: [L-1] Link: Matched action 'bundle "B" ""' Apr 29 17:45:49 voip mpd[92581]: [L-1] Creating new bundle using template "B". Apr 29 17:45:49 voip mpd[92581]: [B-1] Bundle: Interface ng0 created Apr 29 17:45:49 voip mpd[92581]: [L-1] Link: Join bundle "B-1" Apr 29 17:45:49 voip mpd[92581]: [B-1] IFACE: setting ng0 MTU to 1400 bytes Apr 29 17:45:49 voip mpd[92581]: [B-1] Bundle: Status update: up 1 link, total bandwidth 64000 bps Apr 29 17:45:49 voip mpd[92581]: [B-1] IPCP: Open event Apr 29 17:45:49 voip mpd[92581]: [B-1] IPCP: state change Initial --> Starting Apr 29 17:45:49 voip mpd[92581]: [B-1] IPCP: LayerStart Apr 29 17:45:49 voip mpd[92581]: [B-1] CCP: Open event Apr 29 17:45:49 voip mpd[92581]: [B-1] CCP: state change Initial --> Starting Apr 29 17:45:49 voip mpd[92581]: [B-1] CCP: LayerStart Apr 29 17:45:49 voip mpd[92581]: [B-1] IPCP: Up event Apr 29 17:45:49 voip mpd[92581]: [B-1] IPCP: Got IP 172.16.1.2 from pool "pool1" for peer Apr 29 17:45:49 voip mpd[92581]: [B-1] IPCP: state change Starting --> Req-Sent Apr 29 17:45:49 voip mpd[92581]: [B-1] IPCP: SendConfigReq #1 Apr 29 17:45:49 voip mpd[92581]: [B-1] IPADDR 172.16.1.1 Apr 29 17:45:49 voip mpd[92581]: [B-1] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid Apr 29 17:45:49 voip mpd[92581]: [B-1] xmit bypass frame link=-1 proto=0x8021 Apr 29 17:45:49 voip mpd[92581]: ff ff 80 21 01 01 00 10 03 06 ac 10 01 01 02 06 ...!............ Apr 29 17:45:49 voip mpd[92581]: 00 2d 0f 00 .-.. Apr 29 17:45:49 voip mpd[92581]: EVENT: Starting timer "IPCP" FsmTimeout() for 2000 ms at fsm.c:426 Apr 29 17:45:49 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() at timer.c:50 Apr 29 17:45:49 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() done at timer.c:50 Apr 29 17:45:49 voip mpd[92581]: [B-1] CCP: Up event Apr 29 17:45:49 voip mpd[92581]: [B-1] CCP: state change Starting --> Req-Sent Apr 29 17:45:49 voip mpd[92581]: [B-1] CCP: SendConfigReq #1 Apr 29 17:45:49 voip mpd[92581]: [B-1] MPPC Apr 29 17:45:49 voip mpd[92581]: [B-1] 0x01000060:MPPE(40, 128 bits), stateless Apr 29 17:45:49 voip mpd[92581]: [B-1] xmit bypass frame link=-1 proto=0x80fd Apr 29 17:45:49 voip mpd[92581]: ff ff 80 fd 01 01 00 0a 12 06 01 00 00 60 .............` Apr 29 17:45:49 voip mpd[92581]: EVENT: Starting timer "CCP" FsmTimeout() for 2000 ms at fsm.c:426 Apr 29 17:45:49 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() at timer.c:50 Apr 29 17:45:49 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() done at timer.c:50 Apr 29 17:45:49 voip mpd[92581]: EVENT: Processing event EVENT_READ LinkNgDataEvent() Apr 29 17:45:49 voip mpd[92581]: [B-1] rec'd 14 bytes bypass frame link=0 proto=0x8057 Apr 29 17:45:49 voip mpd[92581]: 01 05 00 0e 01 0a 84 e8 4b 54 6f b6 2a 91 ........KTo.*. Apr 29 17:45:49 voip mpd[92581]: [L-1] rec'd unexpected protocol IPV6CP, rejecting Apr 29 17:45:49 voip mpd[92581]: [B-1] xmit bypass frame link=0 proto=0xc021 Apr 29 17:45:49 voip mpd[92581]: 00 00 c0 21 08 01 00 14 80 57 01 05 00 0e 01 0a ...!.....W...... Apr 29 17:45:49 voip mpd[92581]: 84 e8 4b 54 6f b6 2a 91 ..KTo.*. Apr 29 17:45:49 voip mpd[92581]: EVENT: Processing event EVENT_READ LinkNgDataEvent() done Apr 29 17:45:50 voip mpd[92581]: EVENT: Processing event EVENT_READ LinkNgDataEvent() Apr 29 17:45:50 voip mpd[92581]: [B-1] rec'd 10 bytes bypass frame link=0 proto=0x80fd Apr 29 17:45:50 voip mpd[92581]: 01 06 00 0a 12 06 01 00 00 00 .......... Apr 29 17:45:50 voip mpd[92581]: [B-1] CCP: rec'd Configure Request #6 (Req-Sent) Apr 29 17:45:50 voip mpd[92581]: [B-1] MPPC Apr 29 17:45:50 voip mpd[92581]: [B-1] 0x01000000:stateless Apr 29 17:45:50 voip mpd[92581]: [B-1] CCP: SendConfigNak #6 Apr 29 17:45:50 voip mpd[92581]: [B-1] MPPC Apr 29 17:45:50 voip mpd[92581]: [B-1] 0x01000060:MPPE(40, 128 bits), stateless Apr 29 17:45:50 voip mpd[92581]: [B-1] xmit bypass frame link=-1 proto=0x80fd Apr 29 17:45:50 voip mpd[92581]: ff ff 80 fd 03 06 00 0a 12 06 01 00 00 60 .............` Apr 29 17:45:50 voip mpd[92581]: [B-1] rec'd 34 bytes bypass frame link=0 proto=0x8021 Apr 29 17:45:50 voip mpd[92581]: 01 07 00 22 03 06 00 00 00 00 81 06 00 00 00 00 ..."............ Apr 29 17:45:50 voip mpd[92581]: 82 06 00 00 00 00 83 06 00 00 00 00 84 06 00 00 ................ Apr 29 17:45:50 voip mpd[92581]: 00 00 .. Apr 29 17:45:50 voip mpd[92581]: [B-1] IPCP: rec'd Configure Request #7 (Req-Sent) Apr 29 17:45:50 voip mpd[92581]: [B-1] IPADDR 0.0.0.0 Apr 29 17:45:50 voip mpd[92581]: [B-1] NAKing with 172.16.1.2 Apr 29 17:45:50 voip mpd[92581]: [B-1] PRIDNS 0.0.0.0 Apr 29 17:45:50 voip mpd[92581]: [B-1] NAKing with 172.16.1.1 Apr 29 17:45:50 voip mpd[92581]: [B-1] PRINBNS 0.0.0.0 Apr 29 17:45:50 voip mpd[92581]: [B-1] NAKing with 172.16.1.1 Apr 29 17:45:50 voip mpd[92581]: [B-1] SECDNS 0.0.0.0 Apr 29 17:45:50 voip mpd[92581]: [B-1] SECNBNS 0.0.0.0 Apr 29 17:45:50 voip mpd[92581]: [B-1] IPCP: SendConfigRej #7 Apr 29 17:45:50 voip mpd[92581]: [B-1] SECDNS 0.0.0.0 Apr 29 17:45:50 voip mpd[92581]: [B-1] SECNBNS 0.0.0.0 Apr 29 17:45:50 voip mpd[92581]: [B-1] xmit bypass frame link=-1 proto=0x8021 Apr 29 17:45:50 voip mpd[92581]: ff ff 80 21 04 07 00 10 83 06 00 00 00 00 84 06 ...!............ Apr 29 17:45:50 voip mpd[92581]: 00 00 00 00 .... Apr 29 17:45:50 voip mpd[92581]: [B-1] rec'd 10 bytes bypass frame link=0 proto=0x8021 Apr 29 17:45:50 voip mpd[92581]: 04 01 00 0a 02 06 00 2d 0f 00 .......-.. Apr 29 17:45:50 voip mpd[92581]: [B-1] IPCP: rec'd Configure Reject #1 (Req-Sent) Apr 29 17:45:50 voip mpd[92581]: [B-1] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid Apr 29 17:45:50 voip mpd[92581]: EVENT: Stopping timer "IPCP" FsmTimeout() at fsm.c:531 Apr 29 17:45:50 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() at timer.c:83 Apr 29 17:45:50 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() done at timer.c:83 Apr 29 17:45:50 voip mpd[92581]: [B-1] IPCP: SendConfigReq #2 Apr 29 17:45:50 voip mpd[92581]: [B-1] IPADDR 172.16.1.1 Apr 29 17:45:50 voip mpd[92581]: [B-1] xmit bypass frame link=-1 proto=0x8021 Apr 29 17:45:50 voip mpd[92581]: ff ff 80 21 01 02 00 0a 03 06 ac 10 01 01 ...!.......... Apr 29 17:45:50 voip mpd[92581]: EVENT: Starting timer "IPCP" FsmTimeout() for 2000 ms at fsm.c:426 Apr 29 17:45:50 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() at timer.c:50 Apr 29 17:45:50 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() done at timer.c:50 Apr 29 17:45:50 voip mpd[92581]: EVENT: Processing event EVENT_READ LinkNgDataEvent() done Apr 29 17:45:50 voip mpd[92581]: EVENT: Processing event EVENT_READ LinkNgDataEvent() Apr 29 17:45:50 voip mpd[92581]: [B-1] rec'd 10 bytes bypass frame link=0 proto=0x80fd Apr 29 17:45:50 voip mpd[92581]: 03 01 00 0a 12 06 01 00 00 40 .........@ Apr 29 17:45:50 voip mpd[92581]: [B-1] CCP: rec'd Configure Nak #1 (Req-Sent) Apr 29 17:45:50 voip mpd[92581]: [B-1] MPPC Apr 29 17:45:50 voip mpd[92581]: [B-1] 0x01000040:MPPE(128 bits), stateless Apr 29 17:45:50 voip mpd[92581]: EVENT: Stopping timer "CCP" FsmTimeout() at fsm.c:531 Apr 29 17:45:50 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() at timer.c:83 Apr 29 17:45:50 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() done at timer.c:83 Apr 29 17:45:50 voip mpd[92581]: [B-1] CCP: SendConfigReq #2 Apr 29 17:45:50 voip mpd[92581]: [B-1] MPPC Apr 29 17:45:50 voip mpd[92581]: [B-1] 0x01000040:MPPE(128 bits), stateless Apr 29 17:45:50 voip mpd[92581]: [B-1] xmit bypass frame link=-1 proto=0x80fd Apr 29 17:45:50 voip mpd[92581]: ff ff 80 fd 01 02 00 0a 12 06 01 00 00 40 .............@ Apr 29 17:45:50 voip mpd[92581]: EVENT: Starting timer "CCP" FsmTimeout() for 2000 ms at fsm.c:426 Apr 29 17:45:50 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() at timer.c:50 Apr 29 17:45:50 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() done at timer.c:50 Apr 29 17:45:50 voip mpd[92581]: EVENT: Processing event EVENT_READ LinkNgDataEvent() done Apr 29 17:45:50 voip mpd[92581]: EVENT: Processing event EVENT_READ LinkNgDataEvent() Apr 29 17:45:50 voip mpd[92581]: [B-1] rec'd 10 bytes bypass frame link=0 proto=0x80fd Apr 29 17:45:50 voip mpd[92581]: 01 08 00 0a 12 06 01 00 00 40 .........@ Apr 29 17:45:50 voip mpd[92581]: [B-1] CCP: rec'd Configure Request #8 (Req-Sent) Apr 29 17:45:50 voip mpd[92581]: [B-1] MPPC Apr 29 17:45:50 voip mpd[92581]: [B-1] 0x01000040:MPPE(128 bits), stateless Apr 29 17:45:50 voip mpd[92581]: [B-1] CCP: SendConfigAck #8 Apr 29 17:45:50 voip mpd[92581]: [B-1] MPPC Apr 29 17:45:50 voip mpd[92581]: [B-1] 0x01000040:MPPE(128 bits), stateless Apr 29 17:45:50 voip mpd[92581]: [B-1] xmit bypass frame link=-1 proto=0x80fd Apr 29 17:45:50 voip mpd[92581]: ff ff 80 fd 02 08 00 0a 12 06 01 00 00 40 .............@ Apr 29 17:45:50 voip mpd[92581]: [B-1] CCP: state change Req-Sent --> Ack-Sent Apr 29 17:45:50 voip mpd[92581]: [B-1] rec'd 22 bytes bypass frame link=0 proto=0x8021 Apr 29 17:45:50 voip mpd[92581]: 01 09 00 16 03 06 00 00 00 00 81 06 00 00 00 00 ................ Apr 29 17:45:50 voip mpd[92581]: 82 06 00 00 00 00 ...... Apr 29 17:45:50 voip mpd[92581]: [B-1] IPCP: rec'd Configure Request #9 (Req-Sent) Apr 29 17:45:50 voip mpd[92581]: [B-1] IPADDR 0.0.0.0 Apr 29 17:45:50 voip mpd[92581]: [B-1] NAKing with 172.16.1.2 Apr 29 17:45:50 voip mpd[92581]: [B-1] PRIDNS 0.0.0.0 Apr 29 17:45:50 voip mpd[92581]: [B-1] NAKing with 172.16.1.1 Apr 29 17:45:50 voip mpd[92581]: [B-1] PRINBNS 0.0.0.0 Apr 29 17:45:50 voip mpd[92581]: [B-1] NAKing with 172.16.1.1 Apr 29 17:45:50 voip mpd[92581]: [B-1] IPCP: SendConfigNak #9 Apr 29 17:45:50 voip mpd[92581]: [B-1] IPADDR 172.16.1.2 Apr 29 17:45:50 voip mpd[92581]: [B-1] PRIDNS 172.16.1.1 Apr 29 17:45:50 voip mpd[92581]: [B-1] PRINBNS 172.16.1.1 Apr 29 17:45:50 voip mpd[92581]: [B-1] xmit bypass frame link=-1 proto=0x8021 Apr 29 17:45:50 voip mpd[92581]: ff ff 80 21 03 09 00 16 03 06 ac 10 01 02 81 06 ...!............ Apr 29 17:45:50 voip mpd[92581]: ac 10 01 01 82 06 ac 10 01 01 .......... Apr 29 17:45:50 voip mpd[92581]: [B-1] rec'd 10 bytes bypass frame link=0 proto=0x8021 Apr 29 17:45:50 voip mpd[92581]: 02 02 00 0a 03 06 ac 10 01 01 .......... Apr 29 17:45:50 voip mpd[92581]: [B-1] IPCP: rec'd Configure Ack #2 (Req-Sent) Apr 29 17:45:50 voip mpd[92581]: [B-1] IPADDR 172.16.1.1 Apr 29 17:45:50 voip mpd[92581]: [B-1] IPCP: state change Req-Sent --> Ack-Rcvd Apr 29 17:45:50 voip mpd[92581]: EVENT: Stopping timer "IPCP" FsmTimeout() at fsm.c:531 Apr 29 17:45:50 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() at timer.c:83 Apr 29 17:45:50 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() done at timer.c:83 Apr 29 17:45:50 voip mpd[92581]: EVENT: Starting timer "IPCP" FsmTimeout() for 2000 ms at fsm.c:683 Apr 29 17:45:50 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() at timer.c:50 Apr 29 17:45:50 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() done at timer.c:50 Apr 29 17:45:50 voip mpd[92581]: [B-1] rec'd 10 bytes bypass frame link=0 proto=0x80fd Apr 29 17:45:50 voip mpd[92581]: 02 02 00 0a 12 06 01 00 00 40 .........@ Apr 29 17:45:50 voip mpd[92581]: [B-1] CCP: rec'd Configure Ack #2 (Ack-Sent) Apr 29 17:45:50 voip mpd[92581]: [B-1] MPPC Apr 29 17:45:50 voip mpd[92581]: [B-1] 0x01000040:MPPE(128 bits), stateless Apr 29 17:45:50 voip mpd[92581]: [B-1] CCP: state change Ack-Sent --> Opened Apr 29 17:45:50 voip mpd[92581]: EVENT: Stopping timer "CCP" FsmTimeout() at fsm.c:190 Apr 29 17:45:50 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() at timer.c:83 Apr 29 17:45:50 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() done at timer.c:83 Apr 29 17:45:50 voip mpd[92581]: [B-1] CCP: LayerUp Apr 29 17:45:50 voip mpd[92581]: [B-1] CCP: Compress using: mppc (MPPE(128 bits), stateless) Apr 29 17:45:50 voip mpd[92581]: [B-1] CCP: Decompress using: mppc (MPPE(128 bits), stateless) Apr 29 17:45:50 voip mpd[92581]: [B-1] IFACE: setting ng0 MTU to 1396 bytes Apr 29 17:45:50 voip mpd[92581]: EVENT: Processing event EVENT_READ LinkNgDataEvent() done Apr 29 17:45:50 voip mpd[92581]: EVENT: Processing event EVENT_READ LinkNgDataEvent() Apr 29 17:45:50 voip mpd[92581]: [B-1] rec'd 22 bytes bypass frame link=0 proto=0x8021 Apr 29 17:45:50 voip mpd[92581]: 01 0a 00 16 03 06 ac 10 01 02 81 06 ac 10 01 01 ................ Apr 29 17:45:50 voip mpd[92581]: 82 06 ac 10 01 01 ...... Apr 29 17:45:50 voip mpd[92581]: [B-1] IPCP: rec'd Configure Request #10 (Ack-Rcvd) Apr 29 17:45:50 voip mpd[92581]: [B-1] IPADDR 172.16.1.2 Apr 29 17:45:50 voip mpd[92581]: [B-1] 172.16.1.2 is OK Apr 29 17:45:50 voip mpd[92581]: [B-1] PRIDNS 172.16.1.1 Apr 29 17:45:50 voip mpd[92581]: [B-1] PRINBNS 172.16.1.1 Apr 29 17:45:50 voip mpd[92581]: [B-1] IPCP: SendConfigAck #10 Apr 29 17:45:50 voip mpd[92581]: [B-1] IPADDR 172.16.1.2 Apr 29 17:45:50 voip mpd[92581]: [B-1] PRIDNS 172.16.1.1 Apr 29 17:45:50 voip mpd[92581]: [B-1] PRINBNS 172.16.1.1 Apr 29 17:45:50 voip mpd[92581]: [B-1] xmit bypass frame link=-1 proto=0x8021 Apr 29 17:45:50 voip mpd[92581]: ff ff 80 21 02 0a 00 16 03 06 ac 10 01 02 81 06 ...!............ Apr 29 17:45:50 voip mpd[92581]: ac 10 01 01 82 06 ac 10 01 01 .......... Apr 29 17:45:50 voip mpd[92581]: [B-1] IPCP: state change Ack-Rcvd --> Opened Apr 29 17:45:50 voip mpd[92581]: EVENT: Stopping timer "IPCP" FsmTimeout() at fsm.c:190 Apr 29 17:45:50 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() at timer.c:83 Apr 29 17:45:50 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() done at timer.c:83 Apr 29 17:45:50 voip mpd[92581]: [B-1] IPCP: LayerUp Apr 29 17:45:50 voip mpd[92581]: [B-1] 172.16.1.1 -> 172.16.1.2 Apr 29 17:45:50 voip mpd[92581]: [B-1] IFACE: Connecting tcpmssfix Apr 29 17:45:50 voip mpd[92581]: [B-1] IFACE: Configuring ng_tcpmss mpd92581-B-1-mss: 1356 Apr 29 17:45:50 voip mpd[92581]: [B-1] IFACE: Add address 172.16.1.1/32->172.16.1.2 to ng0 Apr 29 17:45:50 voip mpd[92581]: [B-1] IFACE: Up event Apr 29 17:45:50 voip mpd[92581]: [B-1] IFACE: idle-timeout: 1800 seconds Apr 29 17:45:50 voip mpd[92581]: EVENT: Starting timer "IfaceIdle" IfaceIdleTimeout() for 450000 ms at iface.c:503 Apr 29 17:45:50 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() at timer.c:50 Apr 29 17:45:50 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() done at timer.c:50 Apr 29 17:45:50 voip mpd[92581]: [B-1] IFACE: Change interface ng0 flags: -0 +1 Apr 29 17:45:50 voip mpd[92581]: EVENT: Processing event EVENT_READ LinkNgDataEvent() done Apr 29 17:45:59 voip mpd[92581]: EVENT: Processing event EVENT_TIMEOUT TimerExpires() Apr 29 17:45:59 voip mpd[92581]: EVENT: Processing timer "FsmKeepAlive" FsmEchoTimeout() Apr 29 17:45:59 voip mpd[92581]: EVENT: Processing timer "FsmKeepAlive" FsmEchoTimeout() done Apr 29 17:45:59 voip mpd[92581]: EVENT: Processing event EVENT_TIMEOUT TimerExpires() done