Добрый день! Хочу задать вопрос по АВТОМАТИЧЕСКОМУ подключенинию к сети через скайлинковский модем AnyDATA ADU-310A.
Сразу скажу, что вручную соединение устанавливается без проблем и "на ура", а вот если поставить галочку "Автоматически подключаться", то начинаются траблы. Ни после перезагрузки, ни после перетыкания модема подключения не происходит.
В логах видны попытки:
Jun 1 10:15:46 it-lenovo kernel: [ 1618.120227] usb 2-2: new full speed USB device using uhci_hcd and address 7
Jun 1 10:15:46 it-lenovo kernel: [ 1618.282246] usb 2-2: configuration #1 chosen from 1 choice
Jun 1 10:15:46 it-lenovo kernel: [ 1618.292397] option 2-2:1.0: GSM modem (1-port) converter detected
Jun 1 10:15:46 it-lenovo kernel: [ 1618.292825] usb 2-2: GSM modem (1-port) converter now attached to ttyUSB0
Jun 1 10:15:46 it-lenovo kernel: [ 1618.296015] option 2-2:1.1: GSM modem (1-port) converter detected
Jun 1 10:15:46 it-lenovo kernel: [ 1618.296876] usb 2-2: GSM modem (1-port) converter now attached to ttyUSB1
Jun 1 10:15:47 it-lenovo modem-manager: (ttyUSB1) opening serial device...
Jun 1 10:15:47 it-lenovo modem-manager: (ttyUSB1): probe requested by plugin 'AnyData'
Jun 1 10:15:47 it-lenovo modem-manager: (ttyUSB0) opening serial device...
Jun 1 10:15:47 it-lenovo modem-manager: (ttyUSB0): probe requested by plugin 'AnyData'
Jun 1 10:15:48 it-lenovo modem-manager: (ttyUSB0) closing serial device...
Jun 1 10:15:48 it-lenovo modem-manager: (AnyData): CDMA modem /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-2 claimed port ttyUSB0
Jun 1 10:15:48 it-lenovo modem-manager: Added modem /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-2
Jun 1 10:15:48 it-lenovo modem-manager: Exported modem /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-2 as /org/freedesktop/ModemManager/Modems/5
Jun 1 10:15:48 it-lenovo NetworkManager: <info> (ttyUSB0): new CDMA device (driver: 'option1')
Jun 1 10:15:48 it-lenovo NetworkManager: <info> (ttyUSB0): exported as /org/freedesktop/NetworkManager/Devices/7
Jun 1 10:15:48 it-lenovo NetworkManager: <info> (ttyUSB0): now managed
Jun 1 10:15:48 it-lenovo NetworkManager: <info> (ttyUSB0): device state change: 1 -> 2 (reason 2)
Jun 1 10:15:48 it-lenovo NetworkManager: <info> (ttyUSB0): deactivating device (reason: 2).
Jun 1 10:15:48 it-lenovo NetworkManager: <info> (ttyUSB0): device state change: 2 -> 3 (reason 0)
Jun 1 10:15:48 it-lenovo NetworkManager: <info> Activation (ttyUSB0) starting connection 'Skylink'
Jun 1 10:15:48 it-lenovo NetworkManager: <info> (ttyUSB0): device state change: 3 -> 4 (reason 0)
Jun 1 10:15:48 it-lenovo NetworkManager: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) scheduled...
Jun 1 10:15:48 it-lenovo NetworkManager: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) started...
Jun 1 10:15:48 it-lenovo NetworkManager: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) complete.
Jun 1 10:15:48 it-lenovo modem-manager: (ttyUSB0) opening serial device...
Jun 1 10:15:48 it-lenovo modem-manager: Modem /org/freedesktop/ModemManager/Modems/5: state changed (disabled -> enabling)
Jun 1 10:15:49 it-lenovo modem-manager: Got failure code 100: Unknown error
Jun 1 10:15:49 it-lenovo modem-manager: Your CDMA modem does not support +CMEE command
Jun 1 10:15:49 it-lenovo modem-manager: Modem /org/freedesktop/ModemManager/Modems/5: state changed (enabling -> enabled)
Jun 1 10:15:59 it-lenovo modem-manager: (ttyUSB1) closing serial device...
Jun 1 10:16:49 it-lenovo NetworkManager: <WARN> stage1_prepare_done(): CDMA modem connection failed: (32) No service
Jun 1 10:16:49 it-lenovo NetworkManager: <info> (ttyUSB0): device state change: 4 -> 9 (reason 0)
Jun 1 10:16:49 it-lenovo NetworkManager: <info> Marking connection 'Skylink' invalid.
Jun 1 10:16:49 it-lenovo NetworkManager: <info> Activation (ttyUSB0) failed.
Jun 1 10:16:49 it-lenovo NetworkManager: <info> (ttyUSB0): device state change: 9 -> 3 (reason 0)
Jun 1 10:16:49 it-lenovo NetworkManager: <info> (ttyUSB0): deactivating device (reason: 0).
А так выглядит лог, когда подключение происходит вручную (кликом мышки):
Jun 1 10:43:36 it-lenovo wpa_supplicant[870]: WPS-AP-AVAILABLE
Jun 1 10:43:37 it-lenovo kernel: [ 3288.552203] usb 2-1: new full speed USB device using uhci_hcd and address 10
Jun 1 10:43:37 it-lenovo kernel: [ 3288.710276] usb 2-1: configuration #1 chosen from 1 choice
Jun 1 10:43:37 it-lenovo kernel: [ 3288.720391] option 2-1:1.0: GSM modem (1-port) converter detected
Jun 1 10:43:37 it-lenovo kernel: [ 3288.720828] usb 2-1: GSM modem (1-port) converter now attached to ttyUSB0
Jun 1 10:43:37 it-lenovo kernel: [ 3288.723502] option 2-1:1.1: GSM modem (1-port) converter detected
Jun 1 10:43:37 it-lenovo kernel: [ 3288.724008] usb 2-1: GSM modem (1-port) converter now attached to ttyUSB1
Jun 1 10:43:37 it-lenovo modem-manager: (ttyUSB1) opening serial device...
Jun 1 10:43:37 it-lenovo modem-manager: (ttyUSB1): probe requested by plugin 'AnyData'
Jun 1 10:43:37 it-lenovo modem-manager: (ttyUSB0) opening serial device...
Jun 1 10:43:37 it-lenovo modem-manager: (ttyUSB0): probe requested by plugin 'AnyData'
Jun 1 10:43:39 it-lenovo modem-manager: (ttyUSB0) closing serial device...
Jun 1 10:43:39 it-lenovo modem-manager: (AnyData): CDMA modem /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1 claimed port ttyUSB0
Jun 1 10:43:39 it-lenovo modem-manager: Added modem /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1
Jun 1 10:43:39 it-lenovo modem-manager: Exported modem /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-1 as /org/freedesktop/ModemManager/Modems/8
Jun 1 10:43:39 it-lenovo NetworkManager: <info> (ttyUSB0): new CDMA device (driver: 'option1')
Jun 1 10:43:39 it-lenovo NetworkManager: <info> (ttyUSB0): exported as /org/freedesktop/NetworkManager/Devices/10
Jun 1 10:43:39 it-lenovo NetworkManager: <info> (ttyUSB0): now managed
Jun 1 10:43:39 it-lenovo NetworkManager: <info> (ttyUSB0): device state change: 1 -> 2 (reason 2)
Jun 1 10:43:39 it-lenovo NetworkManager: <info> (ttyUSB0): deactivating device (reason: 2).
Jun 1 10:43:39 it-lenovo NetworkManager: <info> (ttyUSB0): device state change: 2 -> 3 (reason 0)
Jun 1 10:43:50 it-lenovo modem-manager: (ttyUSB1) closing serial device...
Jun 1 10:45:36 it-lenovo wpa_supplicant[870]: WPS-AP-AVAILABLE
Jun 1 10:45:36 it-lenovo avahi-daemon[2315]: Invalid query packet.
Jun 1 10:45:43 it-lenovo avahi-daemon[2315]: last message repeated 2 times
Jun 1 10:46:32 it-lenovo NetworkManager: <info> Activation (ttyUSB0) starting connection 'Skylink'
Jun 1 10:46:32 it-lenovo NetworkManager: <info> (ttyUSB0): device state change: 3 -> 4 (reason 0)
Jun 1 10:46:32 it-lenovo NetworkManager: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) scheduled...
Jun 1 10:46:32 it-lenovo NetworkManager: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) started...
Jun 1 10:46:32 it-lenovo NetworkManager: <info> Activation (ttyUSB0) Stage 1 of 5 (Device Prepare) complete.
Jun 1 10:46:32 it-lenovo modem-manager: (ttyUSB0) opening serial device...
Jun 1 10:46:32 it-lenovo modem-manager: Modem /org/freedesktop/ModemManager/Modems/8: state changed (disabled -> enabling)
Jun 1 10:46:33 it-lenovo modem-manager: Got failure code 100: Unknown error
Jun 1 10:46:33 it-lenovo modem-manager: Your CDMA modem does not support +CMEE command
Jun 1 10:46:33 it-lenovo modem-manager: Modem /org/freedesktop/ModemManager/Modems/8: state changed (enabling -> enabled)
Jun 1 10:46:33 it-lenovo modem-manager: Modem /org/freedesktop/ModemManager/Modems/8: state changed (enabled -> registered)
Jun 1 10:46:33 it-lenovo modem-manager: Modem /org/freedesktop/ModemManager/Modems/8: state changed (registered -> connecting)
Jun 1 10:46:33 it-lenovo modem-manager: Modem /org/freedesktop/ModemManager/Modems/8: state changed (connecting -> connected)
Jun 1 10:46:33 it-lenovo NetworkManager: <info> Activation (ttyUSB0) Stage 2 of 5 (Device Configure) scheduled...
Jun 1 10:46:33 it-lenovo NetworkManager: <info> Activation (ttyUSB0) Stage 2 of 5 (Device Configure) starting...
Jun 1 10:46:33 it-lenovo NetworkManager: <info> (ttyUSB0): device state change: 4 -> 5 (reason 0)
Jun 1 10:46:33 it-lenovo NetworkManager: <info> Activation (ttyUSB0) Stage 2 of 5 (Device Configure) successful.
Jun 1 10:46:33 it-lenovo NetworkManager: <info> Activation (ttyUSB0) Stage 3 of 5 (IP Configure Start) scheduled.
Jun 1 10:46:33 it-lenovo NetworkManager: <info> Activation (ttyUSB0) Stage 2 of 5 (Device Configure) complete.
Jun 1 10:46:33 it-lenovo NetworkManager: <info> Activation (ttyUSB0) Stage 3 of 5 (IP Configure Start) started...
Jun 1 10:46:33 it-lenovo NetworkManager: <info> (ttyUSB0): device state change: 5 -> 7 (reason 0)
Jun 1 10:46:33 it-lenovo NetworkManager: <info> Starting pppd connection
Jun 1 10:46:33 it-lenovo NetworkManager: <debug> [1275374793.811299] nm_ppp_manager_start(): Command line: /usr/sbin/pppd nodetach lock nodefaultroute user mobile ttyUSB0 noipdefault noauth usepeerdns lcp-echo-failure 0 lcp-echo-interval 0 ipparam /org/freedesktop/NetworkManager/PPP/3 plugin /usr/lib/pppd/2.4.4/nm-pppd-plugin.so
Jun 1 10:46:33 it-lenovo NetworkManager: <debug> [1275374793.815575] nm_ppp_manager_start(): ppp started with pid 2859
Jun 1 10:46:33 it-lenovo NetworkManager: <info> Activation (ttyUSB0) Stage 4 of 5 (IP6 Configure Get) scheduled...
Jun 1 10:46:33 it-lenovo NetworkManager: <info> Activation (ttyUSB0) Stage 3 of 5 (IP Configure Start) complete.
Jun 1 10:46:33 it-lenovo NetworkManager: <info> Activation (ttyUSB0) Stage 4 of 5 (IP6 Configure Get) started...
Jun 1 10:46:33 it-lenovo NetworkManager: <info> Activation (ttyUSB0) Stage 4 of 5 (IP6 Configure Get) complete.
Jun 1 10:46:33 it-lenovo pppd[2859]: Plugin /usr/lib/pppd/2.4.4/nm-pppd-plugin.so loaded.
Jun 1 10:46:33 it-lenovo pppd[2859]: pppd 2.4.5 started by root, uid 0
Jun 1 10:46:33 it-lenovo NetworkManager: SCPlugin-Ifupdown: devices added (path: /sys/devices/virtual/net/ppp0, iface: ppp0)
Jun 1 10:46:33 it-lenovo NetworkManager: SCPlugin-Ifupdown: device added (path: /sys/devices/virtual/net/ppp0, iface: ppp0): no ifupdown configuration found.
Jun 1 10:46:33 it-lenovo pppd[2859]: Using interface ppp0
Jun 1 10:46:33 it-lenovo pppd[2859]: Connect: ppp0 <--> /dev/ttyUSB0
Jun 1 10:46:36 it-lenovo wpa_supplicant[870]: WPS-AP-AVAILABLE
Jun 1 10:46:37 it-lenovo pppd[2859]: CHAP authentication succeeded
Jun 1 10:46:37 it-lenovo pppd[2859]: CHAP authentication succeeded
Jun 1 10:46:37 it-lenovo pppd[2859]: Cannot determine ethernet address for proxy ARP
Jun 1 10:46:37 it-lenovo pppd[2859]: local IP address 89.253.xxx.xxx
Jun 1 10:46:37 it-lenovo pppd[2859]: remote IP address 89.253.xx.xx
Jun 1 10:46:37 it-lenovo pppd[2859]: primary DNS address 212.129.xx.xx
Jun 1 10:46:37 it-lenovo pppd[2859]: secondary DNS address 212.129.xx.x
Jun 1 10:46:37 it-lenovo NetworkManager: <info> PPP manager(IP Config Get) reply received.
Jun 1 10:46:37 it-lenovo NetworkManager: <info> Activation (ttyUSB0) Stage 4 of 5 (IP4 Configure Get) scheduled...
Jun 1 10:46:37 it-lenovo NetworkManager: <info> Activation (ttyUSB0) Stage 4 of 5 (IP4 Configure Get) started...
Jun 1 10:46:37 it-lenovo NetworkManager: <info> Activation (ttyUSB0) Stage 5 of 5 (IP Configure Commit) scheduled...
Jun 1 10:46:37 it-lenovo NetworkManager: <info> Activation (ttyUSB0) Stage 4 of 5 (IP4 Configure Get) complete.
Jun 1 10:46:37 it-lenovo NetworkManager: <info> Activation (ttyUSB0) Stage 5 of 5 (IP Configure Commit) started...
Jun 1 10:46:37 it-lenovo pppd[2859]: CCP terminated by peer
Jun 1 10:46:37 it-lenovo pppd[2859]: Compression disabled by peer.
Jun 1 10:46:38 it-lenovo NetworkManager: <info> Policy set 'Auto eth0' (eth0) as default for routing and DNS.
Jun 1 10:46:38 it-lenovo NetworkManager: <info> (ttyUSB0): device state change: 7 -> 8 (reason 0)
Jun 1 10:46:38 it-lenovo NetworkManager: <info> Activation (ttyUSB0) successful, device activated.
Jun 1 10:46:38 it-lenovo NetworkManager: <info> Activation (ttyUSB0) Stage 5 of 5 (IP Configure Commit) complete.
в общем не понятно куда копать...
Тема: Автоматическое подключение. Skylink. NetworkMenager (Прочитано 1355 раз)
