|
1
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Processing event EVENT_READ PptpCtrlListenEvent()
|
|
2
|
Apr 29 17:45:47 voip mpd[92581]: PPTP: Incoming control connection from 174.114.135.28 57389 to 49.12.126.101 1723
|
|
3
|
Apr 29 17:45:47 voip mpd[92581]: pptp0: ctrl state FREE --> IDLE
|
|
4
|
Apr 29 17:45:47 voip mpd[92581]: pptp0: attached to connection with 174.114.135.28 57389
|
|
5
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Registering event EVENT_READ PptpCtrlReadCtrl() at pptp_ctrl.c:937
|
|
6
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Registering event EVENT_READ PptpCtrlReadCtrl() done at pptp_ctrl.c:937
|
|
7
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Starting timer "PptpIdle" PptpCtrlIdleTimeout() for 60000 ms at pptp_ctrl.c:1692
|
|
8
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() at timer.c:50
|
|
9
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() done at timer.c:50
|
|
10
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Processing event EVENT_READ PptpCtrlListenEvent() done
|
|
11
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Processing event EVENT_READ PptpCtrlReadCtrl()
|
|
12
|
Apr 29 17:45:47 voip mpd[92581]: pptp0: read 12 bytes ctrl data
|
|
13
|
Apr 29 17:45:47 voip mpd[92581]: 00 9c 00 01 1a 2b 3c 4d 00 01 00 00 .....+<M....
|
|
14
|
Apr 29 17:45:47 voip mpd[92581]: pptp0: got hdr
|
|
15
|
Apr 29 17:45:47 voip mpd[92581]: len=0x9c msgType=1 magic=0x1a2b3c4d type=1
|
|
16
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Processing event EVENT_READ PptpCtrlReadCtrl() done
|
|
17
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Processing event EVENT_READ PptpCtrlReadCtrl()
|
|
18
|
Apr 29 17:45:47 voip mpd[92581]: pptp0: read 144 bytes ctrl data
|
|
19
|
Apr 29 17:45:47 voip mpd[92581]: 01 00 00 00 00 00 00 01 00 00 00 01 00 00 00 00 ................
|
|
20
|
Apr 29 17:45:47 voip mpd[92581]: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
|
|
21
|
Apr 29 17:45:47 voip syslogd: last message repeated 3 times
|
|
22
|
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.......
|
|
23
|
Apr 29 17:45:47 voip mpd[92581]: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
|
|
24
|
Apr 29 17:45:47 voip syslogd: last message repeated 2 times
|
|
25
|
Apr 29 17:45:47 voip mpd[92581]: pptp0: recv StartCtrlConnRequest
|
|
26
|
Apr 29 17:45:47 voip mpd[92581]: vers=0x100 frameCap=1 bearCap=1 maxChan=0 firm=0 host=""
|
|
27
|
Apr 29 17:45:47 voip mpd[92581]: vend="Microsoft"
|
|
28
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Stopping timer "PptpIdle" PptpCtrlIdleTimeout() at pptp_ctrl.c:1689
|
|
29
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() at timer.c:83
|
|
30
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() done at timer.c:83
|
|
31
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Starting timer "PptpIdle" PptpCtrlIdleTimeout() for 60000 ms at pptp_ctrl.c:1692
|
|
32
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() at timer.c:50
|
|
33
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() done at timer.c:50
|
|
34
|
Apr 29 17:45:47 voip mpd[92581]: pptp0: ctrl state IDLE --> ESTABLISHED
|
|
35
|
Apr 29 17:45:47 voip mpd[92581]: pptp0: send StartCtrlConnReply msg
|
|
36
|
Apr 29 17:45:47 voip mpd[92581]: len=0x9c msgType=1 magic=0x1a2b3c4d type=2
|
|
37
|
Apr 29 17:45:47 voip mpd[92581]: vers=0x100 result=1 err=0 frameCap=3 bearCap=3 maxChan=0
|
|
38
|
Apr 29 17:45:47 voip mpd[92581]: firm=0x101 host="voip.xxxxx.ua" vend="FreeBSD MPD"
|
|
39
|
Apr 29 17:45:47 voip mpd[92581]: pptp0: wrote 156 bytes ctrl data
|
|
40
|
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........
|
|
41
|
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
|
|
42
|
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......
|
|
43
|
Apr 29 17:45:47 voip mpd[92581]: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
|
|
44
|
Apr 29 17:45:47 voip syslogd: last message repeated 1 times
|
|
45
|
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
|
|
46
|
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.........
|
|
47
|
Apr 29 17:45:47 voip mpd[92581]: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
|
|
48
|
Apr 29 17:45:47 voip syslogd: last message repeated 1 times
|
|
49
|
Apr 29 17:45:47 voip mpd[92581]: 00 00 00 00 00 00 00 00 00 00 00 00 ............
|
|
50
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Processing event EVENT_READ PptpCtrlReadCtrl() done
|
|
51
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Processing event EVENT_READ PptpCtrlReadCtrl()
|
|
52
|
Apr 29 17:45:47 voip mpd[92581]: pptp0: read 12 bytes ctrl data
|
|
53
|
Apr 29 17:45:47 voip mpd[92581]: 00 a8 00 01 1a 2b 3c 4d 00 07 00 00 .....+<M....
|
|
54
|
Apr 29 17:45:47 voip mpd[92581]: pptp0: got hdr
|
|
55
|
Apr 29 17:45:47 voip mpd[92581]: len=0xa8 msgType=1 magic=0x1a2b3c4d type=7
|
|
56
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Processing event EVENT_READ PptpCtrlReadCtrl() done
|
|
57
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Processing event EVENT_READ PptpCtrlReadCtrl()
|
|
58
|
Apr 29 17:45:47 voip mpd[92581]: pptp0: read 156 bytes ctrl data
|
|
59
|
Apr 29 17:45:47 voip mpd[92581]: e0 2d 00 02 00 00 01 2c 05 f5 e1 00 00 00 00 03 .-.....,........
|
|
60
|
Apr 29 17:45:47 voip mpd[92581]: 00 00 00 03 00 40 00 00 00 00 00 00 00 00 00 00 .....@..........
|
|
61
|
Apr 29 17:45:47 voip mpd[92581]: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
|
|
62
|
Apr 29 17:45:47 voip syslogd: last message repeated 6 times
|
|
63
|
Apr 29 17:45:47 voip mpd[92581]: 00 00 00 00 00 00 00 00 00 00 00 00 ............
|
|
64
|
Apr 29 17:45:47 voip mpd[92581]: pptp0: recv OutCallRequest
|
|
65
|
Apr 29 17:45:47 voip mpd[92581]: cid=0xe02d serno=2 minBPS=0x12c maxBPS=0x5f5e100 bearType=3
|
|
66
|
Apr 29 17:45:47 voip mpd[92581]: frameType=3 recvWin=64 ppd=0 numLen=0 phone="" subaddr=""
|
|
67
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Stopping timer "PptpIdle" PptpCtrlIdleTimeout() at pptp_ctrl.c:1689
|
|
68
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() at timer.c:83
|
|
69
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() done at timer.c:83
|
|
70
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Starting timer "PptpIdle" PptpCtrlIdleTimeout() for 60000 ms at pptp_ctrl.c:1692
|
|
71
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() at timer.c:50
|
|
72
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() done at timer.c:50
|
|
73
|
Apr 29 17:45:47 voip mpd[92581]: pptp0-0: chan state FREE --> WAIT_ANSWER
|
|
74
|
Apr 29 17:45:47 voip mpd[92581]: [L-1] Accepting PPTP connection
|
|
75
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Message 1 to LinkMsg() sent
|
|
76
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Processing event EVENT_READ PptpCtrlReadCtrl() done
|
|
77
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Processing event EVENT_READ MsgEvent()
|
|
78
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Message 1 to LinkMsg() received
|
|
79
|
Apr 29 17:45:47 voip mpd[92581]: [L-1] Link: OPEN event
|
|
80
|
Apr 29 17:45:47 voip mpd[92581]: [L-1] LCP: Open event
|
|
81
|
Apr 29 17:45:47 voip mpd[92581]: [L-1] LCP: state change Initial --> Starting
|
|
82
|
Apr 29 17:45:47 voip mpd[92581]: [L-1] LCP: LayerStart
|
|
83
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Message 1 to PhysMsg() sent
|
|
84
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Message 1 to LinkMsg() processed
|
|
85
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Message 1 to PhysMsg() received
|
|
86
|
Apr 29 17:45:47 voip mpd[92581]: [L-1] device: OPEN event
|
|
87
|
Apr 29 17:45:47 voip mpd[92581]: [L-1] PPTP: attaching to peer's outgoing call
|
|
88
|
Apr 29 17:45:47 voip mpd[92581]: pptp0-0: chan state WAIT_ANSWER --> ESTABLISHED
|
|
89
|
Apr 29 17:45:47 voip mpd[92581]: pptp0: send OutCallReply msg
|
|
90
|
Apr 29 17:45:47 voip mpd[92581]: len=32 msgType=1 magic=0x1a2b3c4d type=8
|
|
91
|
Apr 29 17:45:47 voip mpd[92581]: cid=0x61e0 peerCid=0xe02d result=1 err=0 cause=0 speed=0xfa00
|
|
92
|
Apr 29 17:45:47 voip mpd[92581]: recvWin=16 ppd=1 channel=0
|
|
93
|
Apr 29 17:45:47 voip mpd[92581]: pptp0: wrote 32 bytes ctrl data
|
|
94
|
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..-
|
|
95
|
Apr 29 17:45:47 voip mpd[92581]: 01 00 00 00 00 00 fa 00 00 10 00 01 00 00 00 00 ................
|
|
96
|
Apr 29 17:45:47 voip mpd[92581]: [L-1] device: UP event
|
|
97
|
Apr 29 17:45:47 voip mpd[92581]: [L-1] Link: UP event
|
|
98
|
Apr 29 17:45:47 voip mpd[92581]: [L-1] Link: origination is remote
|
|
99
|
Apr 29 17:45:47 voip mpd[92581]: [L-1] LCP: Up event
|
|
100
|
Apr 29 17:45:47 voip mpd[92581]: [L-1] LCP: state change Starting --> Req-Sent
|
|
101
|
Apr 29 17:45:47 voip mpd[92581]: [L-1] LCP: phase shift DEAD --> ESTABLISH
|
|
102
|
Apr 29 17:45:47 voip mpd[92581]: [L-1] LCP: SendConfigReq #1
|
|
103
|
Apr 29 17:45:47 voip mpd[92581]: [L-1] ACFCOMP
|
|
104
|
Apr 29 17:45:47 voip mpd[92581]: [L-1] PROTOCOMP
|
|
105
|
Apr 29 17:45:47 voip mpd[92581]: [L-1] MRU 1500
|
|
106
|
Apr 29 17:45:47 voip mpd[92581]: [L-1] MAGICNUM 0xc4ed072f
|
|
107
|
Apr 29 17:45:47 voip mpd[92581]: [L-1] AUTHPROTO CHAP MSOFTv2
|
|
108
|
Apr 29 17:45:47 voip mpd[92581]: [L-1] MP MRRU 2048
|
|
109
|
Apr 29 17:45:47 voip mpd[92581]: [L-1] MP SHORTSEQ
|
|
110
|
Apr 29 17:45:47 voip mpd[92581]: [L-1] ENDPOINTDISC [802.1] a8 a1 59 0f 25 39
|
|
111
|
Apr 29 17:45:47 voip mpd[92581]: [L-1] xmit frame to link proto=0xc021
|
|
112
|
Apr 29 17:45:47 voip mpd[92581]: ff 03 c0 21 01 01 00 26 08 02 07 02 01 04 05 dc ...!...&........
|
|
113
|
Apr 29 17:45:47 voip mpd[92581]: 05 06 c4 ed 07 2f 03 05 c2 23 81 11 04 08 00 12 ...../...#......
|
|
114
|
Apr 29 17:45:47 voip mpd[92581]: 02 13 09 03 a8 a1 59 0f 25 39 ......Y.%9
|
|
115
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Starting timer "LCP" FsmTimeout() for 2000 ms at fsm.c:426
|
|
116
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() at timer.c:50
|
|
117
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() done at timer.c:50
|
|
118
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Message 1 to PhysMsg() processed
|
|
119
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Processing event EVENT_READ MsgEvent() done
|
|
120
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Processing event EVENT_READ MsgEvent()
|
|
121
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Processing event EVENT_READ MsgEvent() done
|
|
122
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Processing event EVENT_READ PptpCtrlReadCtrl()
|
|
123
|
Apr 29 17:45:47 voip mpd[92581]: pptp0: read 12 bytes ctrl data
|
|
124
|
Apr 29 17:45:47 voip mpd[92581]: 00 18 00 01 1a 2b 3c 4d 00 0f 00 00 .....+<M....
|
|
125
|
Apr 29 17:45:47 voip mpd[92581]: pptp0: got hdr
|
|
126
|
Apr 29 17:45:47 voip mpd[92581]: len=24 msgType=1 magic=0x1a2b3c4d type=15
|
|
127
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Processing event EVENT_READ PptpCtrlReadCtrl() done
|
|
128
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Processing event EVENT_READ PptpCtrlReadCtrl()
|
|
129
|
Apr 29 17:45:47 voip mpd[92581]: pptp0: read 12 bytes ctrl data
|
|
130
|
Apr 29 17:45:47 voip mpd[92581]: 61 e0 00 00 ff ff ff ff ff ff ff ff a...........
|
|
131
|
Apr 29 17:45:47 voip mpd[92581]: pptp0: recv SetLinkInfo
|
|
132
|
Apr 29 17:45:47 voip mpd[92581]: cid=0x61e0 sendAccm=0xffffffff recvAccm=0xffffffff
|
|
133
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Stopping timer "PptpIdle" PptpCtrlIdleTimeout() at pptp_ctrl.c:1689
|
|
134
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() at timer.c:83
|
|
135
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() done at timer.c:83
|
|
136
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Starting timer "PptpIdle" PptpCtrlIdleTimeout() for 60000 ms at pptp_ctrl.c:1692
|
|
137
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() at timer.c:50
|
|
138
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() done at timer.c:50
|
|
139
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Processing event EVENT_READ PptpCtrlReadCtrl() done
|
|
140
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Processing event EVENT_READ LinkNgDataEvent()
|
|
141
|
Apr 29 17:45:47 voip mpd[92581]: [L-1] rec'd 25 bytes frame from link proto=0xc021
|
|
142
|
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.
|
|
143
|
Apr 29 17:45:47 voip mpd[92581]: 06 63 07 02 08 02 0d 03 06 .c.......
|
|
144
|
Apr 29 17:45:47 voip mpd[92581]: [L-1] LCP: rec'd Configure Request #0 (Req-Sent)
|
|
145
|
Apr 29 17:45:47 voip mpd[92581]: [L-1] MRU 1400
|
|
146
|
Apr 29 17:45:47 voip mpd[92581]: [L-1] MAGICNUM 0x6d030663
|
|
147
|
Apr 29 17:45:47 voip mpd[92581]: [L-1] PROTOCOMP
|
|
148
|
Apr 29 17:45:47 voip mpd[92581]: [L-1] ACFCOMP
|
|
149
|
Apr 29 17:45:47 voip mpd[92581]: [L-1] CALLBACK 6
|
|
150
|
Apr 29 17:45:47 voip mpd[92581]: [L-1] LCP: SendConfigRej #0
|
|
151
|
Apr 29 17:45:47 voip mpd[92581]: [L-1] CALLBACK 6
|
|
152
|
Apr 29 17:45:47 voip mpd[92581]: [L-1] xmit frame to link proto=0xc021
|
|
153
|
Apr 29 17:45:47 voip mpd[92581]: ff 03 c0 21 04 00 00 07 0d 03 06 ...!.......
|
|
154
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Processing event EVENT_READ LinkNgDataEvent() done
|
|
155
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Processing event EVENT_READ LinkNgDataEvent()
|
|
156
|
Apr 29 17:45:47 voip mpd[92581]: [L-1] rec'd 22 bytes frame from link proto=0xc021
|
|
157
|
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.
|
|
158
|
Apr 29 17:45:47 voip mpd[92581]: 06 63 07 02 08 02 .c....
|
|
159
|
Apr 29 17:45:47 voip mpd[92581]: [L-1] LCP: rec'd Configure Request #1 (Req-Sent)
|
|
160
|
Apr 29 17:45:47 voip mpd[92581]: [L-1] MRU 1400
|
|
161
|
Apr 29 17:45:47 voip mpd[92581]: [L-1] MAGICNUM 0x6d030663
|
|
162
|
Apr 29 17:45:47 voip mpd[92581]: [L-1] PROTOCOMP
|
|
163
|
Apr 29 17:45:47 voip mpd[92581]: [L-1] ACFCOMP
|
|
164
|
Apr 29 17:45:47 voip mpd[92581]: [L-1] LCP: SendConfigAck #1
|
|
165
|
Apr 29 17:45:47 voip mpd[92581]: [L-1] MRU 1400
|
|
166
|
Apr 29 17:45:47 voip mpd[92581]: [L-1] MAGICNUM 0x6d030663
|
|
167
|
Apr 29 17:45:47 voip mpd[92581]: [L-1] PROTOCOMP
|
|
168
|
Apr 29 17:45:47 voip mpd[92581]: [L-1] ACFCOMP
|
|
169
|
Apr 29 17:45:47 voip mpd[92581]: [L-1] xmit frame to link proto=0xc021
|
|
170
|
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.
|
|
171
|
Apr 29 17:45:47 voip mpd[92581]: 06 63 07 02 08 02 .c....
|
|
172
|
Apr 29 17:45:47 voip mpd[92581]: [L-1] LCP: state change Req-Sent --> Ack-Sent
|
|
173
|
Apr 29 17:45:47 voip mpd[92581]: EVENT: Processing event EVENT_READ LinkNgDataEvent() done
|
|
174
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Processing event EVENT_TIMEOUT TimerExpires()
|
|
175
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Processing timer "LCP" FsmTimeout()
|
|
176
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] LCP: SendConfigReq #2
|
|
177
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] ACFCOMP
|
|
178
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] PROTOCOMP
|
|
179
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] MRU 1500
|
|
180
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] MAGICNUM 0xc4ed072f
|
|
181
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] AUTHPROTO CHAP MSOFTv2
|
|
182
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] MP MRRU 2048
|
|
183
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] MP SHORTSEQ
|
|
184
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] ENDPOINTDISC [802.1] a8 a1 59 0f 25 39
|
|
185
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] xmit frame to link proto=0xc021
|
|
186
|
Apr 29 17:45:49 voip mpd[92581]: ff 03 c0 21 01 02 00 26 08 02 07 02 01 04 05 dc ...!...&........
|
|
187
|
Apr 29 17:45:49 voip mpd[92581]: 05 06 c4 ed 07 2f 03 05 c2 23 81 11 04 08 00 12 ...../...#......
|
|
188
|
Apr 29 17:45:49 voip mpd[92581]: 02 13 09 03 a8 a1 59 0f 25 39 ......Y.%9
|
|
189
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Starting timer "LCP" FsmTimeout() for 2000 ms at fsm.c:426
|
|
190
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() at timer.c:50
|
|
191
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() done at timer.c:50
|
|
192
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Processing timer "LCP" FsmTimeout() done
|
|
193
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Processing event EVENT_TIMEOUT TimerExpires() done
|
|
194
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Processing event EVENT_READ LinkNgDataEvent()
|
|
195
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] rec'd 23 bytes frame from link proto=0xc021
|
|
196
|
Apr 29 17:45:49 voip mpd[92581]: ff 03 c0 21 04 02 00 13 11 04 08 00 12 02 13 09 ...!............
|
|
197
|
Apr 29 17:45:49 voip mpd[92581]: 03 a8 a1 59 0f 25 39 ...Y.%9
|
|
198
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] LCP: rec'd Configure Reject #2 (Ack-Sent)
|
|
199
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] MP MRRU 2048
|
|
200
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] MP SHORTSEQ
|
|
201
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] ENDPOINTDISC [802.1] a8 a1 59 0f 25 39
|
|
202
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Stopping timer "LCP" FsmTimeout() at fsm.c:531
|
|
203
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() at timer.c:83
|
|
204
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() done at timer.c:83
|
|
205
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] LCP: SendConfigReq #3
|
|
206
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] ACFCOMP
|
|
207
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] PROTOCOMP
|
|
208
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] MRU 1500
|
|
209
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] MAGICNUM 0xc4ed072f
|
|
210
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] AUTHPROTO CHAP MSOFTv2
|
|
211
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] xmit frame to link proto=0xc021
|
|
212
|
Apr 29 17:45:49 voip mpd[92581]: ff 03 c0 21 01 03 00 17 08 02 07 02 01 04 05 dc ...!............
|
|
213
|
Apr 29 17:45:49 voip mpd[92581]: 05 06 c4 ed 07 2f 03 05 c2 23 81 ...../...#.
|
|
214
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Starting timer "LCP" FsmTimeout() for 2000 ms at fsm.c:426
|
|
215
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() at timer.c:50
|
|
216
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() done at timer.c:50
|
|
217
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Processing event EVENT_READ LinkNgDataEvent() done
|
|
218
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Processing event EVENT_READ PptpCtrlReadCtrl()
|
|
219
|
Apr 29 17:45:49 voip mpd[92581]: pptp0: read 12 bytes ctrl data
|
|
220
|
Apr 29 17:45:49 voip mpd[92581]: 00 18 00 01 1a 2b 3c 4d 00 0f 00 00 .....+<M....
|
|
221
|
Apr 29 17:45:49 voip mpd[92581]: pptp0: got hdr
|
|
222
|
Apr 29 17:45:49 voip mpd[92581]: len=24 msgType=1 magic=0x1a2b3c4d type=15
|
|
223
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Processing event EVENT_READ PptpCtrlReadCtrl() done
|
|
224
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Processing event EVENT_READ PptpCtrlReadCtrl()
|
|
225
|
Apr 29 17:45:49 voip mpd[92581]: pptp0: read 12 bytes ctrl data
|
|
226
|
Apr 29 17:45:49 voip mpd[92581]: 61 e0 00 00 ff ff ff ff ff ff ff ff a...........
|
|
227
|
Apr 29 17:45:49 voip mpd[92581]: pptp0: recv SetLinkInfo
|
|
228
|
Apr 29 17:45:49 voip mpd[92581]: cid=0x61e0 sendAccm=0xffffffff recvAccm=0xffffffff
|
|
229
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Stopping timer "PptpIdle" PptpCtrlIdleTimeout() at pptp_ctrl.c:1689
|
|
230
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() at timer.c:83
|
|
231
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() done at timer.c:83
|
|
232
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Starting timer "PptpIdle" PptpCtrlIdleTimeout() for 60000 ms at pptp_ctrl.c:1692
|
|
233
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() at timer.c:50
|
|
234
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() done at timer.c:50
|
|
235
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Processing event EVENT_READ PptpCtrlReadCtrl() done
|
|
236
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Processing event EVENT_READ LinkNgDataEvent()
|
|
237
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] rec'd 27 bytes frame from link proto=0xc021
|
|
238
|
Apr 29 17:45:49 voip mpd[92581]: ff 03 c0 21 02 03 00 17 08 02 07 02 01 04 05 dc ...!............
|
|
239
|
Apr 29 17:45:49 voip mpd[92581]: 05 06 c4 ed 07 2f 03 05 c2 23 81 ...../...#.
|
|
240
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] LCP: rec'd Configure Ack #3 (Ack-Sent)
|
|
241
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] ACFCOMP
|
|
242
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] PROTOCOMP
|
|
243
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] MRU 1500
|
|
244
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] MAGICNUM 0xc4ed072f
|
|
245
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] AUTHPROTO CHAP MSOFTv2
|
|
246
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] LCP: state change Ack-Sent --> Opened
|
|
247
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] LCP: phase shift ESTABLISH --> AUTHENTICATE
|
|
248
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] LCP: auth: peer wants nothing, I want CHAP
|
|
249
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Starting timer "AuthTimer" AuthTimeout() for 40000 ms at auth.c:411
|
|
250
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() at timer.c:50
|
|
251
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() done at timer.c:50
|
|
252
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Starting timer "ChalTimer" ChapChalTimeout() for 2000 ms at chap.c:75
|
|
253
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() at timer.c:50
|
|
254
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() done at timer.c:50
|
|
255
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] CHAP: sending CHALLENGE #1 len: 21
|
|
256
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] xmit frame to link proto=0xc223
|
|
257
|
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..
|
|
258
|
Apr 29 17:45:49 voip mpd[92581]: f0 af 2c 47 87 ab 11 4a 66 ..,G...Jf
|
|
259
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Stopping timer "LCP" FsmTimeout() at fsm.c:190
|
|
260
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() at timer.c:83
|
|
261
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() done at timer.c:83
|
|
262
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Starting recurring timer "FsmKeepAlive" FsmEchoTimeout() for 10000 ms at fsm.c:200
|
|
263
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() at timer.c:69
|
|
264
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() done at timer.c:69
|
|
265
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] LCP: LayerUp
|
|
266
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] rec'd 20 bytes frame from link proto=0xc021
|
|
267
|
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
|
|
268
|
Apr 29 17:45:49 voip mpd[92581]: 35 2e 32 30 5.20
|
|
269
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] LCP: rec'd Ident #2 (Opened)
|
|
270
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] MESG: MSRASV5.20
|
|
271
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] rec'd 33 bytes frame from link proto=0xc021
|
|
272
|
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-
|
|
273
|
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
|
|
274
|
Apr 29 17:45:49 voip mpd[92581]: 52 R
|
|
275
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] LCP: rec'd Ident #3 (Opened)
|
|
276
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] MESG: MSRAS-0-DESKTOP-6OEFJRR
|
|
277
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] rec'd 26 bytes frame from link proto=0xc021
|
|
278
|
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
|
|
279
|
Apr 29 17:45:49 voip mpd[92581]: 01 00 39 db 3b 21 40 45 d9 01 ..9.;!@E..
|
|
280
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] LCP: rec'd Ident #4 (Opened)
|
|
281
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] MESG: M-^H?^R!@E^A
|
|
282
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Processing event EVENT_READ LinkNgDataEvent() done
|
|
283
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Processing event EVENT_READ LinkNgDataEvent()
|
|
284
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] rec'd 63 bytes frame from link proto=0xc223
|
|
285
|
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
|
|
286
|
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.........
|
|
287
|
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....
|
|
288
|
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
|
|
289
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] CHAP: rec'd RESPONSE #1 len: 61
|
|
290
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Stopping timer "ChalTimer" ChapChalTimeout() at chap.c:402
|
|
291
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() at timer.c:83
|
|
292
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() done at timer.c:83
|
|
293
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] Name: "admin"
|
|
294
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Processing event EVENT_READ LinkNgDataEvent() done
|
|
295
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] AUTH: Thread started
|
|
296
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] AUTH: Trying EXTERNAL
|
|
297
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] Ext-auth: Invoking auth program: '/usr/local/bin/smartswitch/mpd_auth 'admin''
|
|
298
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] Ext-auth: attr:'USER_LM_HASH', value:'8584430FCE17D7E67C3113XXXXXXXXXX'
|
|
299
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] Ext-auth: attr:'USER_NT_HASH', value:'79928B56B15AC6BDFE4327XXXXXXXXXX'
|
|
300
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] Ext-auth: attr:'RESULT', value:'UNDEF'
|
|
301
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] AUTH: EXTERNAL returned: undefined
|
|
302
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] AUTH: Thread finished normally
|
|
303
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] CHAP: Auth return status: undefined
|
|
304
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] CHAP: Response is valid
|
|
305
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] CHAP: Reply message: S=9A9F6A5D3A094AEA74F11B0A76117738A3641A10
|
|
306
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] CHAP: sending SUCCESS #1 len: 46
|
|
307
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] xmit frame to link proto=0xc223
|
|
308
|
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
|
|
309
|
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
|
|
310
|
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
|
|
311
|
Apr 29 17:45:49 voip mpd[92581]: 31 30 10
|
|
312
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Stopping timer "AuthTimer" AuthTimeout() at auth.c:718
|
|
313
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() at timer.c:83
|
|
314
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() done at timer.c:83
|
|
315
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] LCP: authorization successful
|
|
316
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] LCP: phase shift AUTHENTICATE --> NETWORK
|
|
317
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] Link: Matched action 'bundle "B" ""'
|
|
318
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] Creating new bundle using template "B".
|
|
319
|
Apr 29 17:45:49 voip mpd[92581]: [B-1] Bundle: Interface ng0 created
|
|
320
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] Link: Join bundle "B-1"
|
|
321
|
Apr 29 17:45:49 voip mpd[92581]: [B-1] IFACE: setting ng0 MTU to 1400 bytes
|
|
322
|
Apr 29 17:45:49 voip mpd[92581]: [B-1] Bundle: Status update: up 1 link, total bandwidth 64000 bps
|
|
323
|
Apr 29 17:45:49 voip mpd[92581]: [B-1] IPCP: Open event
|
|
324
|
Apr 29 17:45:49 voip mpd[92581]: [B-1] IPCP: state change Initial --> Starting
|
|
325
|
Apr 29 17:45:49 voip mpd[92581]: [B-1] IPCP: LayerStart
|
|
326
|
Apr 29 17:45:49 voip mpd[92581]: [B-1] CCP: Open event
|
|
327
|
Apr 29 17:45:49 voip mpd[92581]: [B-1] CCP: state change Initial --> Starting
|
|
328
|
Apr 29 17:45:49 voip mpd[92581]: [B-1] CCP: LayerStart
|
|
329
|
Apr 29 17:45:49 voip mpd[92581]: [B-1] IPCP: Up event
|
|
330
|
Apr 29 17:45:49 voip mpd[92581]: [B-1] IPCP: Got IP 172.16.1.2 from pool "pool1" for peer
|
|
331
|
Apr 29 17:45:49 voip mpd[92581]: [B-1] IPCP: state change Starting --> Req-Sent
|
|
332
|
Apr 29 17:45:49 voip mpd[92581]: [B-1] IPCP: SendConfigReq #1
|
|
333
|
Apr 29 17:45:49 voip mpd[92581]: [B-1] IPADDR 172.16.1.1
|
|
334
|
Apr 29 17:45:49 voip mpd[92581]: [B-1] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
|
|
335
|
Apr 29 17:45:49 voip mpd[92581]: [B-1] xmit bypass frame link=-1 proto=0x8021
|
|
336
|
Apr 29 17:45:49 voip mpd[92581]: ff ff 80 21 01 01 00 10 03 06 ac 10 01 01 02 06 ...!............
|
|
337
|
Apr 29 17:45:49 voip mpd[92581]: 00 2d 0f 00 .-..
|
|
338
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Starting timer "IPCP" FsmTimeout() for 2000 ms at fsm.c:426
|
|
339
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() at timer.c:50
|
|
340
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() done at timer.c:50
|
|
341
|
Apr 29 17:45:49 voip mpd[92581]: [B-1] CCP: Up event
|
|
342
|
Apr 29 17:45:49 voip mpd[92581]: [B-1] CCP: state change Starting --> Req-Sent
|
|
343
|
Apr 29 17:45:49 voip mpd[92581]: [B-1] CCP: SendConfigReq #1
|
|
344
|
Apr 29 17:45:49 voip mpd[92581]: [B-1] MPPC
|
|
345
|
Apr 29 17:45:49 voip mpd[92581]: [B-1] 0x01000060:MPPE(40, 128 bits), stateless
|
|
346
|
Apr 29 17:45:49 voip mpd[92581]: [B-1] xmit bypass frame link=-1 proto=0x80fd
|
|
347
|
Apr 29 17:45:49 voip mpd[92581]: ff ff 80 fd 01 01 00 0a 12 06 01 00 00 60 .............`
|
|
348
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Starting timer "CCP" FsmTimeout() for 2000 ms at fsm.c:426
|
|
349
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() at timer.c:50
|
|
350
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() done at timer.c:50
|
|
351
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Processing event EVENT_READ LinkNgDataEvent()
|
|
352
|
Apr 29 17:45:49 voip mpd[92581]: [B-1] rec'd 14 bytes bypass frame link=0 proto=0x8057
|
|
353
|
Apr 29 17:45:49 voip mpd[92581]: 01 05 00 0e 01 0a 84 e8 4b 54 6f b6 2a 91 ........KTo.*.
|
|
354
|
Apr 29 17:45:49 voip mpd[92581]: [L-1] rec'd unexpected protocol IPV6CP, rejecting
|
|
355
|
Apr 29 17:45:49 voip mpd[92581]: [B-1] xmit bypass frame link=0 proto=0xc021
|
|
356
|
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......
|
|
357
|
Apr 29 17:45:49 voip mpd[92581]: 84 e8 4b 54 6f b6 2a 91 ..KTo.*.
|
|
358
|
Apr 29 17:45:49 voip mpd[92581]: EVENT: Processing event EVENT_READ LinkNgDataEvent() done
|
|
359
|
Apr 29 17:45:50 voip mpd[92581]: EVENT: Processing event EVENT_READ LinkNgDataEvent()
|
|
360
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] rec'd 10 bytes bypass frame link=0 proto=0x80fd
|
|
361
|
Apr 29 17:45:50 voip mpd[92581]: 01 06 00 0a 12 06 01 00 00 00 ..........
|
|
362
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] CCP: rec'd Configure Request #6 (Req-Sent)
|
|
363
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] MPPC
|
|
364
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] 0x01000000:stateless
|
|
365
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] CCP: SendConfigNak #6
|
|
366
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] MPPC
|
|
367
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] 0x01000060:MPPE(40, 128 bits), stateless
|
|
368
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] xmit bypass frame link=-1 proto=0x80fd
|
|
369
|
Apr 29 17:45:50 voip mpd[92581]: ff ff 80 fd 03 06 00 0a 12 06 01 00 00 60 .............`
|
|
370
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] rec'd 34 bytes bypass frame link=0 proto=0x8021
|
|
371
|
Apr 29 17:45:50 voip mpd[92581]: 01 07 00 22 03 06 00 00 00 00 81 06 00 00 00 00 ..."............
|
|
372
|
Apr 29 17:45:50 voip mpd[92581]: 82 06 00 00 00 00 83 06 00 00 00 00 84 06 00 00 ................
|
|
373
|
Apr 29 17:45:50 voip mpd[92581]: 00 00 ..
|
|
374
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] IPCP: rec'd Configure Request #7 (Req-Sent)
|
|
375
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] IPADDR 0.0.0.0
|
|
376
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] NAKing with 172.16.1.2
|
|
377
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] PRIDNS 0.0.0.0
|
|
378
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] NAKing with 172.16.1.1
|
|
379
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] PRINBNS 0.0.0.0
|
|
380
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] NAKing with 172.16.1.1
|
|
381
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] SECDNS 0.0.0.0
|
|
382
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] SECNBNS 0.0.0.0
|
|
383
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] IPCP: SendConfigRej #7
|
|
384
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] SECDNS 0.0.0.0
|
|
385
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] SECNBNS 0.0.0.0
|
|
386
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] xmit bypass frame link=-1 proto=0x8021
|
|
387
|
Apr 29 17:45:50 voip mpd[92581]: ff ff 80 21 04 07 00 10 83 06 00 00 00 00 84 06 ...!............
|
|
388
|
Apr 29 17:45:50 voip mpd[92581]: 00 00 00 00 ....
|
|
389
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] rec'd 10 bytes bypass frame link=0 proto=0x8021
|
|
390
|
Apr 29 17:45:50 voip mpd[92581]: 04 01 00 0a 02 06 00 2d 0f 00 .......-..
|
|
391
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] IPCP: rec'd Configure Reject #1 (Req-Sent)
|
|
392
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] COMPPROTO VJCOMP, 16 comp. channels, no comp-cid
|
|
393
|
Apr 29 17:45:50 voip mpd[92581]: EVENT: Stopping timer "IPCP" FsmTimeout() at fsm.c:531
|
|
394
|
Apr 29 17:45:50 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() at timer.c:83
|
|
395
|
Apr 29 17:45:50 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() done at timer.c:83
|
|
396
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] IPCP: SendConfigReq #2
|
|
397
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] IPADDR 172.16.1.1
|
|
398
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] xmit bypass frame link=-1 proto=0x8021
|
|
399
|
Apr 29 17:45:50 voip mpd[92581]: ff ff 80 21 01 02 00 0a 03 06 ac 10 01 01 ...!..........
|
|
400
|
Apr 29 17:45:50 voip mpd[92581]: EVENT: Starting timer "IPCP" FsmTimeout() for 2000 ms at fsm.c:426
|
|
401
|
Apr 29 17:45:50 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() at timer.c:50
|
|
402
|
Apr 29 17:45:50 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() done at timer.c:50
|
|
403
|
Apr 29 17:45:50 voip mpd[92581]: EVENT: Processing event EVENT_READ LinkNgDataEvent() done
|
|
404
|
Apr 29 17:45:50 voip mpd[92581]: EVENT: Processing event EVENT_READ LinkNgDataEvent()
|
|
405
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] rec'd 10 bytes bypass frame link=0 proto=0x80fd
|
|
406
|
Apr 29 17:45:50 voip mpd[92581]: 03 01 00 0a 12 06 01 00 00 40 .........@
|
|
407
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] CCP: rec'd Configure Nak #1 (Req-Sent)
|
|
408
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] MPPC
|
|
409
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] 0x01000040:MPPE(128 bits), stateless
|
|
410
|
Apr 29 17:45:50 voip mpd[92581]: EVENT: Stopping timer "CCP" FsmTimeout() at fsm.c:531
|
|
411
|
Apr 29 17:45:50 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() at timer.c:83
|
|
412
|
Apr 29 17:45:50 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() done at timer.c:83
|
|
413
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] CCP: SendConfigReq #2
|
|
414
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] MPPC
|
|
415
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] 0x01000040:MPPE(128 bits), stateless
|
|
416
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] xmit bypass frame link=-1 proto=0x80fd
|
|
417
|
Apr 29 17:45:50 voip mpd[92581]: ff ff 80 fd 01 02 00 0a 12 06 01 00 00 40 .............@
|
|
418
|
Apr 29 17:45:50 voip mpd[92581]: EVENT: Starting timer "CCP" FsmTimeout() for 2000 ms at fsm.c:426
|
|
419
|
Apr 29 17:45:50 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() at timer.c:50
|
|
420
|
Apr 29 17:45:50 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() done at timer.c:50
|
|
421
|
Apr 29 17:45:50 voip mpd[92581]: EVENT: Processing event EVENT_READ LinkNgDataEvent() done
|
|
422
|
Apr 29 17:45:50 voip mpd[92581]: EVENT: Processing event EVENT_READ LinkNgDataEvent()
|
|
423
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] rec'd 10 bytes bypass frame link=0 proto=0x80fd
|
|
424
|
Apr 29 17:45:50 voip mpd[92581]: 01 08 00 0a 12 06 01 00 00 40 .........@
|
|
425
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] CCP: rec'd Configure Request #8 (Req-Sent)
|
|
426
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] MPPC
|
|
427
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] 0x01000040:MPPE(128 bits), stateless
|
|
428
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] CCP: SendConfigAck #8
|
|
429
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] MPPC
|
|
430
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] 0x01000040:MPPE(128 bits), stateless
|
|
431
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] xmit bypass frame link=-1 proto=0x80fd
|
|
432
|
Apr 29 17:45:50 voip mpd[92581]: ff ff 80 fd 02 08 00 0a 12 06 01 00 00 40 .............@
|
|
433
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] CCP: state change Req-Sent --> Ack-Sent
|
|
434
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] rec'd 22 bytes bypass frame link=0 proto=0x8021
|
|
435
|
Apr 29 17:45:50 voip mpd[92581]: 01 09 00 16 03 06 00 00 00 00 81 06 00 00 00 00 ................
|
|
436
|
Apr 29 17:45:50 voip mpd[92581]: 82 06 00 00 00 00 ......
|
|
437
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] IPCP: rec'd Configure Request #9 (Req-Sent)
|
|
438
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] IPADDR 0.0.0.0
|
|
439
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] NAKing with 172.16.1.2
|
|
440
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] PRIDNS 0.0.0.0
|
|
441
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] NAKing with 172.16.1.1
|
|
442
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] PRINBNS 0.0.0.0
|
|
443
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] NAKing with 172.16.1.1
|
|
444
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] IPCP: SendConfigNak #9
|
|
445
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] IPADDR 172.16.1.2
|
|
446
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] PRIDNS 172.16.1.1
|
|
447
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] PRINBNS 172.16.1.1
|
|
448
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] xmit bypass frame link=-1 proto=0x8021
|
|
449
|
Apr 29 17:45:50 voip mpd[92581]: ff ff 80 21 03 09 00 16 03 06 ac 10 01 02 81 06 ...!............
|
|
450
|
Apr 29 17:45:50 voip mpd[92581]: ac 10 01 01 82 06 ac 10 01 01 ..........
|
|
451
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] rec'd 10 bytes bypass frame link=0 proto=0x8021
|
|
452
|
Apr 29 17:45:50 voip mpd[92581]: 02 02 00 0a 03 06 ac 10 01 01 ..........
|
|
453
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] IPCP: rec'd Configure Ack #2 (Req-Sent)
|
|
454
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] IPADDR 172.16.1.1
|
|
455
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] IPCP: state change Req-Sent --> Ack-Rcvd
|
|
456
|
Apr 29 17:45:50 voip mpd[92581]: EVENT: Stopping timer "IPCP" FsmTimeout() at fsm.c:531
|
|
457
|
Apr 29 17:45:50 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() at timer.c:83
|
|
458
|
Apr 29 17:45:50 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() done at timer.c:83
|
|
459
|
Apr 29 17:45:50 voip mpd[92581]: EVENT: Starting timer "IPCP" FsmTimeout() for 2000 ms at fsm.c:683
|
|
460
|
Apr 29 17:45:50 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() at timer.c:50
|
|
461
|
Apr 29 17:45:50 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() done at timer.c:50
|
|
462
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] rec'd 10 bytes bypass frame link=0 proto=0x80fd
|
|
463
|
Apr 29 17:45:50 voip mpd[92581]: 02 02 00 0a 12 06 01 00 00 40 .........@
|
|
464
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] CCP: rec'd Configure Ack #2 (Ack-Sent)
|
|
465
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] MPPC
|
|
466
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] 0x01000040:MPPE(128 bits), stateless
|
|
467
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] CCP: state change Ack-Sent --> Opened
|
|
468
|
Apr 29 17:45:50 voip mpd[92581]: EVENT: Stopping timer "CCP" FsmTimeout() at fsm.c:190
|
|
469
|
Apr 29 17:45:50 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() at timer.c:83
|
|
470
|
Apr 29 17:45:50 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() done at timer.c:83
|
|
471
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] CCP: LayerUp
|
|
472
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] CCP: Compress using: mppc (MPPE(128 bits), stateless)
|
|
473
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] CCP: Decompress using: mppc (MPPE(128 bits), stateless)
|
|
474
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] IFACE: setting ng0 MTU to 1396 bytes
|
|
475
|
Apr 29 17:45:50 voip mpd[92581]: EVENT: Processing event EVENT_READ LinkNgDataEvent() done
|
|
476
|
Apr 29 17:45:50 voip mpd[92581]: EVENT: Processing event EVENT_READ LinkNgDataEvent()
|
|
477
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] rec'd 22 bytes bypass frame link=0 proto=0x8021
|
|
478
|
Apr 29 17:45:50 voip mpd[92581]: 01 0a 00 16 03 06 ac 10 01 02 81 06 ac 10 01 01 ................
|
|
479
|
Apr 29 17:45:50 voip mpd[92581]: 82 06 ac 10 01 01 ......
|
|
480
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] IPCP: rec'd Configure Request #10 (Ack-Rcvd)
|
|
481
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] IPADDR 172.16.1.2
|
|
482
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] 172.16.1.2 is OK
|
|
483
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] PRIDNS 172.16.1.1
|
|
484
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] PRINBNS 172.16.1.1
|
|
485
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] IPCP: SendConfigAck #10
|
|
486
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] IPADDR 172.16.1.2
|
|
487
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] PRIDNS 172.16.1.1
|
|
488
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] PRINBNS 172.16.1.1
|
|
489
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] xmit bypass frame link=-1 proto=0x8021
|
|
490
|
Apr 29 17:45:50 voip mpd[92581]: ff ff 80 21 02 0a 00 16 03 06 ac 10 01 02 81 06 ...!............
|
|
491
|
Apr 29 17:45:50 voip mpd[92581]: ac 10 01 01 82 06 ac 10 01 01 ..........
|
|
492
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] IPCP: state change Ack-Rcvd --> Opened
|
|
493
|
Apr 29 17:45:50 voip mpd[92581]: EVENT: Stopping timer "IPCP" FsmTimeout() at fsm.c:190
|
|
494
|
Apr 29 17:45:50 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() at timer.c:83
|
|
495
|
Apr 29 17:45:50 voip mpd[92581]: EVENT: Unregistering event EVENT_TIMEOUT TimerExpires() done at timer.c:83
|
|
496
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] IPCP: LayerUp
|
|
497
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] 172.16.1.1 -> 172.16.1.2
|
|
498
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] IFACE: Connecting tcpmssfix
|
|
499
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] IFACE: Configuring ng_tcpmss mpd92581-B-1-mss: 1356
|
|
500
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] IFACE: Add address 172.16.1.1/32->172.16.1.2 to ng0
|
|
501
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] IFACE: Up event
|
|
502
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] IFACE: idle-timeout: 1800 seconds
|
|
503
|
Apr 29 17:45:50 voip mpd[92581]: EVENT: Starting timer "IfaceIdle" IfaceIdleTimeout() for 450000 ms at iface.c:503
|
|
504
|
Apr 29 17:45:50 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() at timer.c:50
|
|
505
|
Apr 29 17:45:50 voip mpd[92581]: EVENT: Registering event EVENT_TIMEOUT TimerExpires() done at timer.c:50
|
|
506
|
Apr 29 17:45:50 voip mpd[92581]: [B-1] IFACE: Change interface ng0 flags: -0 +1
|
|
507
|
Apr 29 17:45:50 voip mpd[92581]: EVENT: Processing event EVENT_READ LinkNgDataEvent() done
|
|
508
|
Apr 29 17:45:59 voip mpd[92581]: EVENT: Processing event EVENT_TIMEOUT TimerExpires()
|
|
509
|
Apr 29 17:45:59 voip mpd[92581]: EVENT: Processing timer "FsmKeepAlive" FsmEchoTimeout()
|
|
510
|
Apr 29 17:45:59 voip mpd[92581]: EVENT: Processing timer "FsmKeepAlive" FsmEchoTimeout() done
|
|
511
|
Apr 29 17:45:59 voip mpd[92581]: EVENT: Processing event EVENT_TIMEOUT TimerExpires() done
|
