Hallo Kollegen,
Ich mache Testcalls mit Fritz PCI v2 und capi4linux bzw. pppd 2.4.1
Dabei beobachte ich gelegentlich, daß Testcalls ohne plausiblen Grund
fehlschlagen, obwohl die ppp negotiation sauber durchzulaufen scheint. Beim
genaueren Hinsehen sind mir merkwürdige delays von 50s beim setup der
zugewiesenen IP Adresse aufgefallen. Normalerweise dauert dieser Schritt nur
1s. Diese Verzögerung führt dann offenbar dazu, daß ein timer abläuft und
disconnect erfolgt. Kennt jemand das Phänomen oder kann sonst einen Tip
geben?
Grüße
Andreas
..
Apr 21 17:06:44 paris pppd[25542]: capiplugin: phase authenticate (was
establish).
Apr 21 17:06:44 paris pppd[25542]: rcvd [CHAP Challenge id=0x1
<8x388ef951469c986bxxxxaf5111639c>, name = ""]
Apr 21 17:06:44 paris pppd[25542]: sent [CHAP Response id=0x1
<8x9770a7fa1a03ca3axxxxe6d439b002>, name = "test@testkunde"]
Apr 21 17:06:44 paris pppd[25542]: rcvd [LCP EchoRep id=0x0
magic=0x407eb2c5]
Apr 21 17:06:45 paris pppd[25542]: rcvd [CHAP Success id=0x1 ""]
Apr 21 17:06:45 paris pppd[25542]: capiplugin: phase network (was
authenticate).
Apr 21 17:06:45 paris pppd[25542]: sent [IPCP ConfReq id=0x1 ]
Apr 21 17:06:45 paris pppd[25542]: rcvd [IPCP ConfReq id=0x1 ]
Apr 21 17:06:45 paris pppd[25542]: sent [IPCP ConfAck id=0x1 ]
Apr 21 17:06:45 paris pppd[25542]: rcvd [IPCP ConfRej id=0x1 ]
Apr 21 17:06:45 paris pppd[25542]: sent [IPCP ConfReq id=0x2 ]
Apr 21 17:06:45 paris pppd[25542]: rcvd [IPCP ConfNak id=0x2 ]
Apr 21 17:06:45 paris pppd[25542]: sent [IPCP ConfReq id=0x3 ]
Apr 21 17:06:45 paris pppd[25542]: rcvd [IPCP ConfAck id=0x3 ]
# ----------------- hier offenbar 50s delay !!!!
Apr 21 17:07:35 paris pppd[25542]: local IP address 172.xxx.yyy.129
Apr 21 17:07:35 paris pppd[25542]: remote IP address 192.168.xxx.144
Apr 21 17:07:35 paris pppd[25542]: primary DNS address 212.xxx.yyy.34
Apr 21 17:07:35 paris pppd[25542]: secondary DNS address 212.xxx.yyy.42
Apr 21 17:07:35 paris pppd[25542]: capiplugin: phase running (was network).
Apr 21 17:07:35 paris pppd[25542]: Script /etc/ppp/ip-up started (pid 25880)
Apr 21 17:07:35 paris pppd[25542]: ncci_change_state:0x10101 4 -> 7 event=10
Apr 21 17:07:35 paris pppd[25542]: ncci_change_state:0x10101 7 -> 0 event=13
Apr 21 17:07:35 paris pppd[25542]: plci_change_state:0x101 3 -> 7 event=8
Apr 21 17:07:35 paris pppd[25542]: DISCONNECT_IND reason 0x3490 (Normal call
clearing) for plci 0x101
Apr 21 17:07:35 paris pppd[25542]: plci_change_state:0x101 7 -> 8 event=9
Apr 21 17:07:35 paris pppd[25542]: plci_change_state:0x101 8 -> 0 event=11
Apr 21 17:07:35 paris pppd[25542]: capiplugin: disconnect(remote): "" ->
"08000xxxxxx" outgoing (pcli=0x101/ncci=0x10101) 0x3490 (0x3301) - Normal
call clearing
Apr 21 17:07:35 paris pppd[25542]: sent [LCP EchoReq id=0x1
magic=0x855f121b]
Apr 21 17:07:35 paris pppd[25542]: rcvd [LCP EchoReq id=0x1 magic=0x407eb2c5
d4 4a 40 22]
Apr 21 17:07:35 paris pppd[25542]: sent [LCP EchoRep id=0x1 magic=0x855f121b
d4 4a 40 22]
Apr 21 17:07:35 paris pppd[25542]: rcvd [LCP EchoReq id=0x2 magic=0x407eb2c5
d4 4a 40 22]
Apr 21 17:07:35 paris pppd[25542]: sent [LCP EchoRep id=0x2 magic=0x855f121b
d4 4a 40 22]
Apr 21 17:07:35 paris pppd[25542]: rcvd [LCP EchoReq id=0x3 magic=0x407eb2c5
d4 4a 40 22]
Apr 21 17:07:35 paris pppd[25542]: sent [LCP EchoRep id=0x3 magic=0x855f121b
d4 4a 40 22]
Apr 21 17:07:35 paris pppd[25542]: Modem hangup
Apr 21 17:07:35 paris pppd[25542]: cbcp_lowerdown
Apr 21 17:07:35 paris pppd[25542]: capiplugin: phase network (was running).
Apr 21 17:07:35 paris pppd[25542]: capiplugin: phase terminate (was
network).
Apr 21 17:07:35 paris pppd[25542]: capiplugin: phase dead (was terminate).
Apr 21 17:07:35 paris pppd[25542]: controller 1: listen_change_state 0 -> 1