Hi,
I've spent most of my waking hours for the last 3 days trying to get this
to work, I've learned lots about ppp and freebsd, but I am no closer to a
solution.
modem_run runs fine ( even though, sometimes it complains URB147
Input/Output Error, up to URB150 and concludes that the ADSL line is
closed, but this usually happens when Ive been unplugging and re-plugging
the modem a lot - so I chose to ignore it - it is fixed by a reboot anyway)
Then when I run "ppp -background adsl" this appears in the log:
/var/log/ppp.log
Nov 13 09:07:06 moonchild ppp[264]: Phase: Using interface: tun0
Nov 13 09:07:06 moonchild ppp[264]: Phase: deflink: Created in closed state
Nov 13 09:07:06 moonchild ppp[264]: tun0: Command: adsl: set log All
-physical -timer -sync -debug
Nov 13 09:07:06 moonchild ppp[264]: tun0: Command: adsl: set authname
adsl01224630538@freedom2surf
Nov 13 09:07:06 moonchild ppp[264]: tun0: Command: adsl: set authkey ********
Nov 13 09:07:06 moonchild ppp[264]: tun0: Command: adsl: set device !pppoa2
-vpi 0 -vci 38 -v 1
Nov 13 09:07:06 moonchild ppp[264]: tun0: Command: adsl: accept chap
Nov 13 09:07:06 moonchild ppp[264]: tun0: Command: adsl: set speed sync
Nov 13 09:07:06 moonchild ppp[264]: tun0: Command: adsl: set timeout 0
Nov 13 09:07:06 moonchild ppp[264]: tun0: Command: adsl: enable lqr
Nov 13 09:07:06 moonchild ppp[264]: tun0: Command: adsl: set lqrperiod 5
Nov 13 09:07:06 moonchild ppp[264]: tun0: Command: adsl: set redial 15 10000
Nov 13 09:07:06 moonchild ppp[264]: tun0: Command: adsl: set dial
Nov 13 09:07:06 moonchild ppp[264]: tun0: Command: adsl: set ifaddr
10.0.0.1/0 10.0.0.2/0 255.255.255.0 0.0.0.0
Nov 13 09:07:06 moonchild ppp[264]: tun0: Command: adsl: add default HISADDR
Nov 13 09:07:06 moonchild ppp[264]: tun0: ID0: 9 = socket(17, 3, 0)
Nov 13 09:07:06 moonchild ppp[264]: tun0: ID0: -1 = write(9, data, 140)
Nov 13 09:07:06 moonchild ppp[264]: tun0: TCP/IP: rt_Set failure:
Nov 13 09:07:06 moonchild ppp[264]: tun0: TCP/IP: rt_Set: Cmd = Add
Nov 13 09:07:06 moonchild ppp[264]: tun0: TCP/IP: rt_Set: Dst = 0.0.0.0
Nov 13 09:07:06 moonchild ppp[264]: tun0: TCP/IP: rt_Set: Gateway = 10.0.0.2
Nov 13 09:07:06 moonchild ppp[264]: tun0: TCP/IP: rt_Set: Mask = 0.0.0.0
Nov 13 09:07:06 moonchild ppp[264]: tun0: Command: adsl: enable dns
Nov 13 09:07:06 moonchild ppp[265]: tun0: ID0: 0x28249480 =
fopen("/var/run/tun0.pid", "w")
Nov 13 09:07:06 moonchild ppp[265]: tun0: Phase: PPP Started (background
mode).
Nov 13 09:07:06 moonchild ppp[265]: tun0: Phase: bundle: Establish
Nov 13 09:07:06 moonchild ppp[265]: tun0: Phase: deflink: closed -> opening
Nov 13 09:07:06 moonchild ppp[265]: tun0: Phase: deflink: Connected!
Nov 13 09:07:06 moonchild ppp[265]: tun0: Phase: deflink: opening -> dial
Nov 13 09:07:06 moonchild ppp[265]: tun0: Chat: deflink: Dial attempt 1 of
10000
Nov 13 09:07:06 moonchild ppp[265]: tun0: Phase: deflink: dial -> carrier
Nov 13 09:07:06 moonchild ppp[265]: tun0: Phase: deflink: carrier -> login
Nov 13 09:07:06 moonchild ppp[265]: tun0: Phase: deflink: login -> lcp
Nov 13 09:07:06 moonchild ppp[265]: tun0: LCP: FSM: Using "deflink" as a
transport
Nov 13 09:07:06 moonchild ppp[265]: tun0: LCP: deflink: State change
Initial --> Closed
Nov 13 09:07:06 moonchild ppp[265]: tun0: LCP: deflink: State change Closed
--> Stopped
Nov 13 09:07:07 moonchild ppp[265]: tun0: LCP: deflink: LayerStart
Nov 13 09:07:07 moonchild ppp[265]: tun0: LCP: deflink: SendConfigReq(1)
state = Stopped
Nov 13 09:07:07 moonchild ppp[265]: tun0: LCP: MRU[4] 1500
Nov 13 09:07:07 moonchild ppp[265]: tun0: LCP: MAGICNUM[6] 0x7a92034c
Nov 13 09:07:07 moonchild ppp[265]: tun0: LCP: QUALPROTO[8] proto c025,
interval 5000ms
Nov 13 09:07:07 moonchild ppp[265]: tun0: LCP: deflink: State change
Stopped --> Req-Sent
Nov 13 09:07:10 moonchild ppp[265]: tun0: LCP: deflink: SendConfigReq(1)
state = Req-Sent
Nov 13 09:07:10 moonchild ppp[265]: tun0: LCP: MRU[4] 1500
Nov 13 09:07:10 moonchild ppp[265]: tun0: LCP: MAGICNUM[6] 0x7a92034c
Nov 13 09:07:10 moonchild ppp[265]: tun0: LCP: QUALPROTO[8] proto c025,
interval 5000ms
Nov 13 09:07:13 moonchild ppp[265]: tun0: LCP: deflink: SendConfigReq(1)
state = Req-Sent
Nov 13 09:07:13 moonchild ppp[265]: tun0: LCP: MRU[4] 1500
Nov 13 09:07:13 moonchild ppp[265]: tun0: LCP: MAGICNUM[6] 0x7a92034c
Nov 13 09:07:13 moonchild ppp[265]: tun0: LCP: QUALPROTO[8] proto c025,
interval 5000ms
Nov 13 09:07:16 moonchild ppp[265]: tun0: LCP: deflink: SendConfigReq(1)
state = Req-Sent
Nov 13 09:07:16 moonchild ppp[265]: tun0: LCP: MRU[4] 1500
Nov 13 09:07:16 moonchild ppp[265]: tun0: LCP: MAGICNUM[6] 0x7a92034c
Nov 13 09:07:16 moonchild ppp[265]: tun0: LCP: QUALPROTO[8] proto c025,
interval 5000ms
Nov 13 09:07:19 moonchild ppp[265]: tun0: LCP: deflink: SendConfigReq(1)
state = Req-Sent
Nov 13 09:07:19 moonchild ppp[265]: tun0: LCP: MRU[4] 1500
Nov 13 09:07:19 moonchild ppp[265]: tun0: LCP: MAGICNUM[6] 0x7a92034c
Nov 13 09:07:19 moonchild ppp[265]: tun0: LCP: QUALPROTO[8] proto c025,
interval 5000ms
Nov 13 09:07:22 moonchild ppp[265]: tun0: LCP: deflink: LayerFinish
Nov 13 09:07:22 moonchild ppp[265]: tun0: LCP: deflink: State change
Req-Sent --> Stopped
Nov 13 09:07:22 moonchild ppp[265]: tun0: LCP: deflink: State change
Stopped --> Closed
Nov 13 09:07:22 moonchild ppp[265]: tun0: LCP: deflink: State change Closed
--> Initial
Nov 13 09:07:22 moonchild ppp[265]: tun0: Phase: deflink: Disconnected!
Nov 13 09:07:22 moonchild ppp[265]: tun0: Phase: deflink: lcp -> logout
Nov 13 09:07:22 moonchild ppp[265]: tun0: Phase: deflink: logout -> hangup
Nov 13 09:07:22 moonchild ppp[265]: tun0: Phase: deflink: Disconnected!
Nov 13 09:07:22 moonchild ppp[265]: tun0: Phase: deflink: Connect time: 16
secs: 0 octets in, 130 octets out
Nov 13 09:07:22 moonchild ppp[265]: tun0: Phase: deflink: : 0 packets in, 5
packets out
Nov 13 09:07:22 moonchild ppp[265]: tun0: Phase: total 8 bytes/sec, peak
10 bytes/sec on Tue Nov 13 09:07:22 2001
Nov 13 09:07:22 moonchild ppp[265]: tun0: Phase: deflink: HUPing 267
Nov 13 09:07:22 moonchild ppp[265]: tun0: ID0: 0 = kill(267, 1)
Nov 13 09:07:22 moonchild ppp[265]: tun0: Phase: deflink: hangup -> closed
Nov 13 09:07:22 moonchild ppp[265]: tun0: ID0: 0 = socket(2, 2, 0)
Nov 13 09:07:22 moonchild ppp[265]: tun0: ID0: 0 = ioctl(0, 3223349521,
0xbfbff8a4)
Nov 13 09:07:22 moonchild ppp[265]: tun0: ID0: 0 = ioctl(0, 2149607696,
0xbfbff8a4)
Nov 13 09:07:22 moonchild ppp[265]: tun0: Phase: bundle: Dead
Nov 13 09:07:22 moonchild ppp[265]: tun0: ID0: 0 = ioctl(6, 2148037723,
0xbfbff98c)
Nov 13 09:07:22 moonchild ppp[265]: tun0: Phase: PPP Terminated (normal).
Nov 13 09:07:22 moonchild ppp[265]: tun0: ID0: 0 = socket(2, 2, 0)
Nov 13 09:07:22 moonchild ppp[265]: tun0: ID0: 0 = ioctl(0, 3223349521,
0xbfbff984)
Nov 13 09:07:22 moonchild ppp[265]: tun0: ID0: 0 = ioctl(0, 2149607696,
0xbfbff984)
Nov 13 09:07:22 moonchild ppp[265]: tun0: ID0: 0 = unlink("/var/run/tun0.pid")
Nov 13 09:07:22 moonchild ppp[264]: tun0: Phase: Parent: Child failed
(errdead)
Nov 13 09:07:22 moonchild ppp[265]: tun0: Chat: Parent notified of failure
The add route failur is because I had another default route to access the
web, it shouldn't make any difference.
The /var/log/pppoa2m.log file is:
Info >244< Starting PPPoA2m ( merged version includes new ATM/AAL5 stack )
20011007
Info >244< Log started on Tue Nov 13 09:01:38 2001
Info >244< Using vpi=0, vci=38
Info >244< I'm the parent process, I handle the endpoint 0x07
Debug >244< pty descriptors : fdin=3, fdout=4
[Tue Nov 13 09:01:38 2001] Info >244< Increasing SNDBUF from 2048 to 65536
[Tue Nov 13 09:01:38 2001] Info >244< Increasing RCVBUF from 4096 to 65536
[Tue Nov 13 09:01:38 2001] Debug >244< Got the modem !
[Tue Nov 13 09:01:48 2001] Debug >244< PPP packet read from ppp(d) (24
bytes long)
c0 21 01 01 00 16 01 04 05 dc 05 06 e8 bc 93 a7 .!..............
04 08 c0 25 00 00 01 2c ...%...,
[Tue Nov 13 09:01:48 2001] Debug >244< ATM cell queue built (53 bytes long)
00 00 02 62 56 c0 21 01 01 00 16 01 04 05 dc 05 ...bV.!.........
06 e8 bc 93 a7 04 08 c0 25 00 00 01 2c 00 00 00 ........%...,...
00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
18 f8 31 a5 f3 ..1..
Info >245< I'm the children process, I handle the endpoint 0x87
[Tue Nov 13 09:01:54 2001] Info >244< Killed by a signal 1
The ppp.conf file used for these runs is pretty much unchanged from the
sample file that came with the the pppoa port,
adsl:
set log All -physical -timer -sync -debug
set authname adsl01224630538@freedom2surf
set authkey *****
set device !"pppoa2 -vpi 0 -vci 38 -v 1"
accept chap
set speed sync
set timeout 0
enable lqr
set lqrperiod 5
set redial 15 10000
set dial ""
set ifaddr 10.0.0.1/0 10.0.0.2/0 255.255.255.0 0.0.0.0
add default HISADDR
enable dns
I've tried changed everything in this file, from timeout values, to mtu,
mru, ip address etc.etc
I had this problem on 4.3-RELEASE, and I tried upgrading to 4.4-STABLE, but
exactly the same problem ( these logs are from the 4.4)
I tried checking out the speedtouch module from cvs, but same problem.
My system is an old pentium MMX 200, and on-board USB controller with no
connectors (What ??) which I disabled in the bios, and a DLINK (du-a2) USB
adapter card.
Here is the relevant part of my dmesg:
pci0: <PCI bus> on pcib0
isab0: <Intel 82371SB PCI to ISA bridge> at device 7.0 on pci0
isa0: <ISA bus> on isab0
atapci0: <Intel PIIX3 ATA controller> port 0xf000-0xf00f at device 7.1 on pci0
ata0: at 0x1f0 irq 14 on atapci0
pci0: <S3 ViRGE DX/GX graphics accelerator> at 11.0 irq 11
ohci0: <CMD Tech 673 (USB0673) USB controller> mem 0xe4000000-0xe4000fff
irq 15 at device 13.0 on pci0
usb0: OHCI version 1.0, legacy support
usb0: <CMD Tech 673 (USB0673) USB controller> on ohci0
usb0: USB revision 1.0
uhub0: CMDTECH OHCI root hub, class 9/0, rev 1.00/1.00, addr 1
uhub0: 2 ports with 2 removable, self powered
ugen0: ALCATEL Speed Touch USB , rev 1.10/0.00, addr 2
I've got all the necessary /dev entries.
If there is any other info I can give, please reply and I'll do my best.
It seems to me that my isp never responds to my SendConfReg packets... I
don't know why.
I am connecting with the same modem/line on my linux laptop (and my windows
box), and it works fine,
Here is the linux ppp.log :
Nov 11 18:01:56 laptop pppd[1724]: Plugin /usr/lib/pppd/plugins/pppoatm.so
loaded.
Nov 11 18:01:56 laptop pppd[1724]: PPPoATM plugin_init
Nov 11 18:01:56 laptop pppd[1724]: PPPoATM setdevname_pppoatm
Nov 11 18:01:56 laptop pppd[1724]: PPPoATM setdevname_pppoatm - SUCCESS
Nov 11 18:01:56 laptop pppd[1725]: pppd 2.4.0b1 started by root, uid 0
Nov 11 18:01:56 laptop pppd[1725]: using channel 6
Nov 11 18:01:56 laptop pppd[1725]: Using interface ppp0
Nov 11 18:01:56 laptop pppd[1725]: Connect: ppp0 <--> 0.38
Nov 11 18:01:56 laptop pppd[1725]: sent [LCP ConfReq id=0x1 <magic 0xdea9336d>]
Nov 11 18:01:56 laptop pppd[1725]: rcvd [LCP ConfAck id=0x1 <magic 0xdea9336d>]
Nov 11 18:01:59 laptop pppd[1725]: sent [LCP ConfReq id=0x1 <magic 0xdea9336d>]
Nov 11 18:01:59 laptop pppd[1725]: rcvd [LCP ConfReq id=0x66 <auth chap
MD5> <magic 0xd05b44db>]
Nov 11 18:01:59 laptop pppd[1725]: sent [LCP ConfAck id=0x66 <auth chap
MD5> <magic 0xd05b44db>]
Nov 11 18:01:59 laptop pppd[1725]: rcvd [LCP ConfAck id=0x1 <magic 0xdea9336d>]
Nov 11 18:01:59 laptop pppd[1725]: sent [LCP EchoReq id=0x0 magic=0xdea9336d]
Nov 11 18:01:59 laptop pppd[1725]: rcvd [CHAP Challenge id=0x5f
<094aab205a658b725c18c6ba4058969b>, name = "RASA3NRP4.Edinburgh"]
Nov 11 18:01:59 laptop pppd[1725]: sent [CHAP Response id=0x5f
<92819a6fa1c7e86218899dffe0b3927f>, name = "adsl01224630538@freedom2surf"]
Nov 11 18:01:59 laptop pppd[1725]: rcvd [LCP EchoRep id=0x0 magic=0xd05b44db]
Nov 11 18:02:00 laptop pppd[1725]: rcvd [IPCP ConfReq id=0x1 <addr
213.123.99.89>]
Nov 11 18:02:00 laptop pppd[1725]: rcvd [CHAP Success id=0x5f ""] 00 00
Nov 11 18:02:00 laptop pppd[1725]: sent [IPCP ConfReq id=0x1 <addr 0.0.0.0>
<compress VJ 0f 01> <ms-dns1 0.0.0.0> <ms-dns3 0.0.0.0>]
Nov 11 18:02:00 laptop modprobe: modprobe: Can't locate module ppp-compress-21
Nov 11 18:02:00 laptop modprobe: modprobe: Can't locate module ppp-compress-21
Nov 11 18:02:00 laptop pppd[1725]: sent [CCP ConfReq id=0x1 <deflate 15>
<deflate(old#) 15>]
Nov 11 18:02:00 laptop pppd[1725]: rcvd [IPCP ConfRej id=0x1 <compress VJ
0f 01>]
Nov 11 18:02:00 laptop pppd[1725]: sent [IPCP ConfReq id=0x2 <addr 0.0.0.0>
<ms-dns1 0.0.0.0> <ms-dns3 0.0.0.0>]
Nov 11 18:02:00 laptop pppd[1725]: rcvd [LCP ProtRej id=0x1 80 fd 01 01 00
0c 1a 04 78 00 18 04 78 00]
Nov 11 18:02:00 laptop pppd[1725]: rcvd [IPCP ConfNak id=0x2 <addr
194.106.48.146> <ms-dns1 194.106.56.6> <ms-dns3 194.106.33.42>]
Nov 11 18:02:00 laptop pppd[1725]: sent [IPCP ConfReq id=0x3 <addr
194.106.48.146> <ms-dns1 194.106.56.6> <ms-dns3 194.106.33.42>]
Nov 11 18:02:00 laptop pppd[1725]: rcvd [IPCP ConfAck id=0x3 <addr
194.106.48.146> <ms-dns1 194.106.56.6> <ms-dns3 194.106.33.42>]
Nov 11 18:02:01 laptop pppd[1725]: sent [LCP EchoReq id=0x1 magic=0xdea9336d]
Nov 11 18:02:01 laptop pppd[1725]: rcvd [LCP EchoRep id=0x1 magic=0xd05b44db]
Nov 11 18:02:02 laptop pppd[1725]: rcvd [IPCP ConfReq id=0x2 <addr
213.123.99.89>]
Nov 11 18:02:02 laptop pppd[1725]: sent [IPCP ConfAck id=0x2 <addr
213.123.99.89>]
Nov 11 18:02:02 laptop pppd[1725]: local IP address 194.106.48.146
Nov 11 18:02:02 laptop pppd[1725]: remote IP address 213.123.99.89
Nov 11 18:02:02 laptop pppd[1725]: primary DNS address 194.106.56.6
Nov 11 18:02:02 laptop pppd[1725]: secondary DNS address 194.106.33.42
Nov 11 18:02:02 laptop pppd[1725]: Script /etc/ppp/ip-up started (pid 1736)
Nov 11 18:02:02 laptop pppd[1725]: Script /etc/ppp/ip-up finished (pid
1736), status = 0x0
.... snip echo requests here ....
Nov 11 18:01:32 laptop pppd[1661]: Terminating on signal 15.
Nov 11 18:01:32 laptop pppd[1661]: Script /etc/ppp/ip-down started (pid 1707)
Nov 11 18:01:32 laptop pppd[1661]: sent [LCP TermReq id=0x2 "User request"]
Nov 11 18:01:32 laptop pppd[1661]: Script /etc/ppp/ip-down finished (pid
1707), status = 0x0
Nov 11 18:01:32 laptop pppd[1661]: rcvd [LCP TermAck id=0x2] 00 00
Nov 11 18:01:32 laptop pppd[1661]: Connection terminated.
Nov 11 18:01:32 laptop pppd[1661]: Connect time 1.5 minutes.
Nov 11 18:01:32 laptop pppd[1661]: Sent 94 bytes, received 74 bytes.
Nov 11 18:01:32 laptop pppd[1661]: Exit.
Please, can anyone help me - I am slowly going mad if I cant get this to work.
--
Gunnar AAstrand Grimnes
[EMAIL PROTECTED]
http://www.csd.abdn.ac.uk/~ggrimnes
7 John Knox Court
Mounthooly
Aberdeen
AB24 3LF
Liste de diffusion modem ALCATEL SpeedTouch USB
Pour se désinscrire : mailto:[EMAIL PROTECTED]?subject=unsubscribe
