Є модем без видимих ознак виробника 1с9e:6061, підключаюсь через консоль програмою wvdial, яка, начебто, правильно визначає пристрій як модем та, начебто, підключається (що видно з лога демона pppd), навіть отримує якісь адреси, але одразу "вішає трубку". В чому причина такої поведінки? Система Ubuntu 10.10, також встановлений Network Manager.
wvdial.conf
[Dialer Defaults]
Init1 = ATZ
Init2 = ATQ0 V1 E1 S0=0 &C1 &D2 +FCLASS=0
Modem Type = Analog Modem
Phone = *99#
ISDN = 0
Username = 1
Password = 1
New PPPD = yes
Modem = /dev/ttyUSB0
Baud = 9600
Init3 = AT+CGDCONT=1,"IP","3g.utel.ua"
Stupid Mode = 1
Auto Reconnect = on
Лог wvdial
sudo wvdial
--> WvDial: Internet dialer version 1.60
--> Cannot get information for serial port.
--> Initializing modem.
--> Sending: ATZ
ATZ
OK
--> Sending: ATQ0 V1 E1 S0=0 &C1 &D2 +FCLASS=0
ATQ0 V1 E1 S0=0 &C1 &D2 +FCLASS=0
OK
--> Sending: AT+CGDCONT=1,"IP","3g.utel.ua"
AT+CGDCONT=1,"IP","3g.utel.ua"
OK
--> Modem initialized.
--> Sending: ATDT*99#
--> Waiting for carrier.
ATDT*99#
CONNECT
--> Carrier detected. Starting PPP immediately.
--> Starting pppd at Tue Oct 4 15:39:13 2011
--> Pid of pppd: 21966
--> pppd: �[7f]
--> Using interface ppp0
--> pppd: �[7f]
--> pppd: �[7f]
--> pppd: �[7f]
--> pppd: �[7f]
--> pppd: �[7f]
--> pppd: �[7f]
--> pppd: �[7f]
--> pppd: �[7f]
--> Authentication (CHAP) started
--> pppd: �[7f]
--> pppd: �[7f]
--> pppd: �[7f]
--> Authentication (CHAP) successful
--> pppd: �[7f]
--> pppd: �[7f]
--> pppd: �[7f]
--> pppd: �[7f]
--> pppd: �[7f]
--> pppd: �[7f]
--> pppd: �[7f]
--> pppd: �[7f]
--> pppd: �[7f]
--> pppd: �[7f]
--> pppd: �[7f]
--> Disconnecting at Tue Oct 4 15:39:15 2011
--> The PPP daemon has died: A modem hung up the phone (exit code = 16)
--> man pppd explains pppd error codes in more detail.
--> Try again and look into /var/log/messages and the wvdial and pppd man pages for more information.
--> Auto Reconnect will be attempted in 5 seconds
Лог pppd
Oct 4 15:37:41 mig-30 kernel: [2966775.544365] usb 7-1: USB disconnect, address 13
Oct 4 15:37:41 mig-30 kernel: [2966775.546412] option: option_instat_callback: error -108
Oct 4 15:37:41 mig-30 kernel: [2966775.546533] option1 ttyUSB0: GSM modem (1-port) converter now disconnected from ttyUSB0
Oct 4 15:37:41 mig-30 kernel: [2966775.546554] option 7-1:1.0: device disconnected
Oct 4 15:37:41 mig-30 kernel: [2966775.546648] option1 ttyUSB1: GSM modem (1-port) converter now disconnected from ttyUSB1
Oct 4 15:37:41 mig-30 kernel: [2966775.546665] option 7-1:1.1: device disconnected
Oct 4 15:37:41 mig-30 kernel: [2966775.546732] option1 ttyUSB2: GSM modem (1-port) converter now disconnected from ttyUSB2
Oct 4 15:37:41 mig-30 kernel: [2966775.546746] option 7-1:1.2: device disconnected
Oct 4 15:37:50 mig-30 kernel: [2966784.362512] usb 7-1: new full speed USB device using uhci_hcd and address 14
Oct 4 15:37:50 mig-30 kernel: [2966784.535728] scsi32 : usb-storage 7-1:1.0
Oct 4 15:37:51 mig-30 usb_modeswitch: switching 1c9e:1001 (USB Modem: USB MMC Storage)
Oct 4 15:37:51 mig-30 kernel: [2966785.299551] usb 7-1: USB disconnect, address 14
Oct 4 15:37:52 mig-30 kernel: [2966786.623762] usb 7-1: new full speed USB device using uhci_hcd and address 15
Oct 4 15:37:52 mig-30 kernel: [2966786.812690] option 7-1:1.0: GSM modem (1-port) converter detected
Oct 4 15:37:52 mig-30 kernel: [2966786.812772] usb 7-1: GSM modem (1-port) converter now attached to ttyUSB0
Oct 4 15:37:52 mig-30 kernel: [2966786.814682] option 7-1:1.1: GSM modem (1-port) converter detected
Oct 4 15:37:52 mig-30 kernel: [2966786.814771] usb 7-1: GSM modem (1-port) converter now attached to ttyUSB1
Oct 4 15:37:52 mig-30 kernel: [2966786.816695] option 7-1:1.2: GSM modem (1-port) converter detected
Oct 4 15:37:52 mig-30 kernel: [2966786.816785] usb 7-1: GSM modem (1-port) converter now attached to ttyUSB2
Oct 4 15:37:52 mig-30 modem-manager: (ttyUSB1) opening serial device...
Oct 4 15:37:52 mig-30 modem-manager: (ttyUSB1): probe requested by plugin 'Longcheer'
Oct 4 15:37:52 mig-30 modem-manager: (ttyUSB2) opening serial device...
Oct 4 15:37:52 mig-30 modem-manager: (ttyUSB2): probe requested by plugin 'Longcheer'
Oct 4 15:37:52 mig-30 modem-manager: (ttyUSB0) opening serial device...
Oct 4 15:37:52 mig-30 modem-manager: (ttyUSB0): probe requested by plugin 'Longcheer'
Oct 4 15:37:53 mig-30 usb_modeswitch: switched to 1c9e:6061 (USB Modem: USB Modem)
Oct 4 15:37:55 mig-30 modem-manager: (ttyUSB2) closing serial device...
Oct 4 15:37:55 mig-30 modem-manager: (ttyUSB0) closing serial device...
Oct 4 15:37:55 mig-30 modem-manager: (Longcheer): GSM modem /sys/devices/pci0000:00/0000:00:1d.1/usb7/7-1 claimed port ttyUSB2
Oct 4 15:37:55 mig-30 modem-manager: Added modem /sys/devices/pci0000:00/0000:00:1d.1/usb7/7-1
Oct 4 15:37:55 mig-30 modem-manager: (tty/ttyUSB0): outstanding support task prevents export of /sys/devices/pci0000:00/0000:00:1d.1/usb7/7-1
Oct 4 15:37:55 mig-30 modem-manager: (tty/ttyUSB0): outstanding support task prevents export of /sys/devices/pci0000:00/0000:00:1d.1/usb7/7-1
Oct 4 15:37:55 mig-30 modem-manager: (ttyUSB0) opening serial device...
Oct 4 15:37:55 mig-30 modem-manager: (Longcheer): GSM modem /sys/devices/pci0000:00/0000:00:1d.1/usb7/7-1 claimed port ttyUSB0
Oct 4 15:37:55 mig-30 modem-manager: (tty/ttyUSB1): outstanding support task prevents export of /sys/devices/pci0000:00/0000:00:1d.1/usb7/7-1
Oct 4 15:37:55 mig-30 modem-manager: (tty/ttyUSB1): outstanding support task prevents export of /sys/devices/pci0000:00/0000:00:1d.1/usb7/7-1
Oct 4 15:37:55 mig-30 modem-manager: (ttyUSB0) closing serial device...
Oct 4 15:38:01 mig-30 CRON[21920]: (root) CMD ( sh /var/lib/wine/default/db.sh)
Oct 4 15:38:01 mig-30 CRON[21919]: (root) CMD (/usr/bin/modem)
Oct 4 15:38:04 mig-30 modem-manager: (ttyUSB1) closing serial device...
Oct 4 15:38:05 mig-30 modem-manager: (ttyUSB1) opening serial device...
Oct 4 15:38:08 mig-30 modem-manager: (ttyUSB1) closing serial device...
Oct 4 15:38:08 mig-30 modem-manager: (Longcheer): GSM modem /sys/devices/pci0000:00/0000:00:1d.1/usb7/7-1 claimed port ttyUSB1
Oct 4 15:38:08 mig-30 modem-manager: Exported modem /sys/devices/pci0000:00/0000:00:1d.1/usb7/7-1 as /org/freedesktop/ModemManager/Modems/22
Oct 4 15:38:08 mig-30 modem-manager: (/org/freedesktop/ModemManager/Modems/22): data port is ttyUSB0
Oct 4 15:38:08 mig-30 NetworkManager[1123]: <warn> (ttyUSB0): failed to look up interface index
Oct 4 15:38:08 mig-30 NetworkManager[1123]: <info> (ttyUSB0): new GSM device (driver: 'option1' ifindex: -1)
Oct 4 15:38:08 mig-30 NetworkManager[1123]: <info> (ttyUSB0): exported as /org/freedesktop/NetworkManager/Devices/25
Oct 4 15:38:08 mig-30 NetworkManager[1123]: <info> (ttyUSB0): now managed
Oct 4 15:38:08 mig-30 NetworkManager[1123]: <info> (ttyUSB0): device state change: 1 -> 2 (reason 2)
Oct 4 15:38:08 mig-30 NetworkManager[1123]: <info> (ttyUSB0): deactivating device (reason: 2).
Oct 4 15:38:08 mig-30 NetworkManager[1123]: <info> (ttyUSB0): device state change: 2 -> 3 (reason 0)
Oct 4 15:39:01 mig-30 CRON[21943]: (root) CMD (/usr/bin/modem)
Oct 4 15:39:01 mig-30 CRON[21944]: (root) CMD ( sh /var/lib/wine/default/db.sh)
Oct 4 15:39:01 mig-30 CRON[21952]: (root) CMD ( [ -x /usr/lib/php5/maxlifetime ] && [ -d /var/lib/php5 ] && find /var/lib/php5/ -depth -mindepth 1 -maxdepth 1 -type f -cmin +$(/usr/lib/php5/maxlifetime) -delete)
Oct 4 15:39:13 mig-30 pppd[21966]: pppd 2.4.5 started by root, uid 0
Oct 4 15:39:13 mig-30 pppd[21966]: using channel 150
Oct 4 15:39:13 mig-30 pppd[21966]: Using interface ppp0
Oct 4 15:39:13 mig-30 modem-manager: (net/ppp0): could not get port's parent device
Oct 4 15:39:13 mig-30 NetworkManager[1123]: SCPlugin-Ifupdown: devices added (path: /sys/devices/virtual/net/ppp0, iface: ppp0)
Oct 4 15:39:13 mig-30 NetworkManager[1123]: SCPlugin-Ifupdown: device added (path: /sys/devices/virtual/net/ppp0, iface: ppp0): no ifupdown configuration found.
Oct 4 15:39:13 mig-30 pppd[21966]: Connect: ppp0 <--> /dev/ttyUSB0
Oct 4 15:39:13 mig-30 pppd[21966]: sent [LCP ConfReq id=0x1 <asyncmap 0x0> <magic 0xcbc69235> <pcomp> <accomp>]
Oct 4 15:39:13 mig-30 pppd[21966]: rcvd [LCP ConfReq id=0x0 <asyncmap 0x0> <auth chap MD5> <magic 0xcc8fde> <pcomp> <accomp>]
Oct 4 15:39:13 mig-30 pppd[21966]: sent [LCP ConfAck id=0x0 <asyncmap 0x0> <auth chap MD5> <magic 0xcc8fde> <pcomp> <accomp>]
Oct 4 15:39:13 mig-30 pppd[21966]: rcvd [LCP ConfAck id=0x1 <asyncmap 0x0> <magic 0xcbc69235> <pcomp> <accomp>]
Oct 4 15:39:13 mig-30 pppd[21966]: sent [LCP EchoReq id=0x0 magic=0xcbc69235]
Oct 4 15:39:13 mig-30 pppd[21966]: rcvd [LCP DiscReq id=0x1 magic=0xcc8fde]
Oct 4 15:39:13 mig-30 pppd[21966]: rcvd [CHAP Challenge id=0x1 <ae8906ff5081390660ae58a97a7720fd>, name = "UMTS_CHAP_SRVR"]
Oct 4 15:39:13 mig-30 pppd[21966]: sent [CHAP Response id=0x1 <2298374f4adbb2c2b48950491a12b703>, name = "1"]
Oct 4 15:39:13 mig-30 pppd[21966]: rcvd [LCP EchoRep id=0x0 magic=0xcc8fde cb c6 92 35]
Oct 4 15:39:13 mig-30 pppd[21966]: rcvd [CHAP Success id=0x1 ""]
Oct 4 15:39:13 mig-30 pppd[21966]: CHAP authentication succeeded
Oct 4 15:39:13 mig-30 pppd[21966]: CHAP authentication succeeded
Oct 4 15:39:13 mig-30 pppd[21966]: sent [CCP ConfReq id=0x1 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Oct 4 15:39:13 mig-30 pppd[21966]: sent [IPCP ConfReq id=0x1 <compress VJ 0f 01> <addr 0.0.0.0> <ms-dns1 0.0.0.0> <ms-dns2 0.0.0.0>]
Oct 4 15:39:13 mig-30 pppd[21966]: rcvd [LCP ProtRej id=0x2 80 fd 01 01 00 0f 1a 04 78 00 18 04 78 00 15 03 2f]
Oct 4 15:39:13 mig-30 pppd[21966]: Protocol-Reject for 'Compression Control Protocol' (0x80fd) received
Oct 4 15:39:14 mig-30 pppd[21966]: rcvd [IPCP ConfNak id=0x1 <ms-dns1 10.11.12.13> <ms-dns2 10.11.12.14> <ms-wins 10.11.12.13> <ms-wins 10.11.12.14>]
Oct 4 15:39:14 mig-30 pppd[21966]: sent [IPCP ConfReq id=0x2 <compress VJ 0f 01> <addr 0.0.0.0> <ms-dns1 10.11.12.13> <ms-dns2 10.11.12.14>]
Oct 4 15:39:14 mig-30 pppd[21966]: Modem hangup
Oct 4 15:39:14 mig-30 pppd[21966]: Connection terminated.
Oct 4 15:39:14 mig-30 avahi-daemon[1121]: Withdrawing workstation service for ppp0.
Oct 4 15:39:14 mig-30 NetworkManager[1123]: SCPlugin-Ifupdown: devices removed (path: /sys/devices/virtual/net/ppp0, iface: ppp0)
Oct 4 15:39:14 mig-30 pppd[21966]: Exit.