Не поднимается PPP-соединение на OpenWrt

io scheduler deadline registered (default)
gpiodev: gpio device registered with major 254
gpiodev: gpio platform device registered with access mask FFFFFFFF
bcm63xx_uart.0: ttyS0 at MMIO 0xfffe0300 (irq = 10) is a bcm63xx_uart
console [ttyS0] enabled, bootconsole disabled
bcm963xx_flash: 0x00400000 at 0x1fc00000
bcm963xx: Found 1 x16 devices at 0x0 in 16-bit bank
 CFI mfr 0x000000c2
 CFI id  0x000022a7
 Amd/Fujitsu Extended Query Table at 0x0040
  Amd/Fujitsu Extended Query version 1.1.
bcm963xx: Swapping erase regions for broken CFI table.
number of CFI chips: 1
cfi_cmdset_0002: Disabling erase-suspend-program due to code brokenness.
bcm963xx_flash: Read Signature value of CFE1CFE1
bcm963xx_flash: CFE bootloader detected
bcm963xx_flash: CFE boot tag found with version 6 and board type 96348GW
bcm963xx_flash: Partition 0 is CFE offset 0 and length 10000
bcm963xx_flash: Partition 1 is kernel offset 10100 and length dff00
bcm963xx_flash: Partition 2 is rootfs offset f0000 and length 300000
bcm963xx_flash: Partition 3 is nvram offset 3f0000 and length 10000
bcm963xx_flash: Partition 4 is linux offset 10000 and length 3e0000
bcm963xx_flash: Spare partition is 2b0000 offset and length 140000
Creating 5 MTD partitions on "bcm963xx":
0x000000000000-0x000000010000 : "CFE"
0x000000010100-0x0000000f0000 : "kernel"
mtd: partition "kernel" must either start or end on erase block boundary or be smaller than an erase block -- forcing read-only
0x0000000f0000-0x0000003f0000 : "rootfs"
mtd: partition "rootfs" set to be root filesystem
mtd: partition "rootfs_data" created automatically, ofs=2B0000, len=140000
0x0000002b0000-0x0000003f0000 : "rootfs_data"
0x0000003f0000-0x000000400000 : "nvram"
0x000000010000-0x0000003f0000 : "linux"
bcm63xx_enet MII bus: probed
bcm63xx_wdt started, timer margin: 30 sec
Registered led device: adsl-fail
Registered led device: ppp
Registered led device: ppp-fail
Registered led device: power
Registered led device: stop
TCP westwood registered
NET: Registered protocol family 17
802.1Q VLAN Support v1.8 Ben Greear <greearb@candelatech.com>
All bugs added by David S. Miller <davem@redhat.com>
VFS: Mounted root (squashfs filesystem) readonly on device 31:2.
Freeing unused kernel memory: 140k freed
Please be patient, while OpenWrt loads ...
mini_fo: using base directory: /
mini_fo: using storage directory: /overlay
eth1: link forced UP - 100/full - flow control off/off
device eth1 entered promiscuous mode
br-lan: port 1(eth1) entering forwarding state
Compat-wireless backport release: compat-wireless-2011-11-08-1-g4ab9b62
Backport based on wireless-testing.git master-2011-11-15
cfg80211: Calling CRDA to update world regulatory domain
roboswitch: Probing device eth0:
roboswitch: [/home/jow/devel/openwrt/10.03.1/brcm63xx/build_dir/linux-brcm63xx/kmod-switch/switch-robo.c:130] SIOCGETCPHYRD failed!
roboswitch: [/home/jow/devel/openwrt/10.03.1/brcm63xx/build_dir/linux-brcm63xx/kmod-switch/switch-robo.c:130] SIOCGETCPHYRD failed!
No Robo switch in managed mode found, phy_id = 0xffffffff
roboswitch: Probing device eth1: found a 5325! It's a 5350.
usbcore: registered new interface driver usbfs
usbcore: registered new interface driver hub
cfg80211: World regulatory domain updated:
cfg80211:     (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp)
cfg80211:     (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
cfg80211:     (2457000 KHz - 2482000 KHz @ 20000 KHz), (300 mBi, 2000 mBm)
cfg80211:     (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm)
cfg80211:     (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
cfg80211:     (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
usbcore: registered new device driver usb
b43-phy0: Broadcom 4318 WLAN found (core revision 9)
ieee80211 phy0: Selected rate control algorithm 'minstrel_ht'
Registered led device: b43-phy0::tx
Registered led device: b43-phy0::rx
Registered led device: b43-phy0::radio
Broadcom 43xx driver loaded [ Features: PL ]
PPP generic driver version 2.4.2
ip_tables: (C) 2000-2006 Netfilter Core Team
NET: Registered protocol family 24
ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
PCI: Enabling device 0000:00:07.2 (0000 -> 0002)
ehci_hcd 0000:00:07.2: EHCI Host Controller
ehci_hcd 0000:00:07.2: new USB bus registered, assigned bus number 1
ehci_hcd 0000:00:07.2: Enabling legacy PCI PM
ehci_hcd 0000:00:07.2: irq 32, io mem 0x30002000
ehci_hcd 0000:00:07.2: USB 2.0 started, EHCI 1.00
usb usb1: configuration #1 chosen from 1 choice
hub 1-0:1.0: USB hub found
hub 1-0:1.0: 2 ports detected
nf_conntrack version 0.5.0 (209 buckets, 836 max)
CONFIG_NF_CT_ACCT is deprecated and will be removed soon. Please use
nf_conntrack.acct=1 kernel parameter, acct=1 nf_conntrack module option or
sysctl net.netfilter.nf_conntrack_acct=1 to enable it.
usb 1-2: new high speed USB device using ehci_hcd and address 2
usb 1-2: configuration #1 chosen from 1 choice
ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
bcm63xx_ohci bcm63xx_ohci.0: BCM63XX integrated OHCI controller
bcm63xx_ohci bcm63xx_ohci.0: new USB bus registered, assigned bus number 2
bcm63xx_ohci bcm63xx_ohci.0: irq 20, io mem 0xfffe1b00
usb usb2: configuration #1 chosen from 1 choice
hub 2-0:1.0: USB hub found
hub 2-0:1.0: 1 port detected
uhci_hcd: USB Universal Host Controller Interface driver
PCI: Enabling device 0000:00:07.0 (0000 -> 0001)
bcm63xx: PCI IO window assigned to PCI
uhci_hcd 0000:00:07.0: UHCI Host Controller
uhci_hcd 0000:00:07.0: new USB bus registered, assigned bus number 3
CPU 0 Unable to handle kernel paging request at virtual address 08000010, epc == 805e4340, ra == 80406918
Oops[#1]:
Cpu 0
$ 0   : 00000000 10008400 00000001 00000010
$ 4   : 00000000 00000008 08000010 0000ffff
$ 8   : 00000000 00000000 00000005 80365700
$12   : 00000003 80809a10 ffffffff 65726564
$16   : 80c362b8 00000000 80c36200 80c2b000
$20   : 000000a0 00000005 00000020 00000006
$24   : 00000010 00000000
$28   : 804b0000 804b1cd0 8028a340 80406918
Hi    : 00000000
Lo    : 00000003
epc   : 805e4340 0x805e4340
    Not tainted
ra    : 80406918 0x80406918
Status: 10008403    KERNEL EXL IE
Cause : 00800008
BadVA : 08000010
PrId  : 00029107 (Broadcom BCM6348)
Modules linked in: uhci_hcd(+) ohci_hcd nf_nat_tftp nf_conntrack_tftp nf_nat_irc nf_conntrack_irc nf_nat_ftp nf_conntrack_ftp ipt_MASQUERADE iptable_nat nf_nat xt_NOTRACK iptable_raw xt_state nf_conntrack_ipv4 nf_defrag_ipv4 nf_conntrack ehci_hcd pppoe pppox ipt_REJECT xt_TCPMSS ipt_LOG xt_comment xt_multiport xt_mac xt_limit iptable_mangle iptable_filter ip_tables xt_tcpudp x_tables ppp_async ppp_generic slhc b43 mac80211 usbcore switch_adm switch_robo switch_core nls_base crc_ccitt cfg80211 compat arc4 aes_generic deflate ecb cbc
Process insmod (pid: 584, threadinfo=804b0000, task=80db5148, tls=00000000)
Stack : 00000001 00000000 80420000 00000000 80c36200 80420000 00000000 80406918
        804b1cf8 805e4720 80864400 00000003 00014720 80813000 00000020 80192634
        00000000 00000020 80c36200 80813070 80813000 00000005 805e472c 80412cf8
        00000001 00000000 80813000 8015f808 00000000 800e59ac 805e4b60 805e4b30
        80813000 805e4b60 80291940 00000000 0040819c 00000002 7fac1628 801460f8
        ...
Call Trace:[<80420000>] 0x80420000
[<80420000>] 0x80420000
[<80406918>] 0x80406918
[<80192634>] 0x80192634
[<80412cf8>] 0x80412cf8
[<8015f808>] 0x8015f808
[<800e59ac>] 0x800e59ac
[<801460f8>] 0x801460f8
[<801630e4>] 0x801630e4
[<80163258>] 0x80163258
[<8012b39c>] 0x8012b39c
[<8016339c>] 0x8016339c
[<8012ba78>] 0x8012ba78
[<80163330>] 0x80163330
[<8016299c>] 0x8016299c
[<8012bb08>] 0x8012bb08
[<80162118>] 0x80162118
[<800951ac>] 0x800951ac
[<8016374c>] 0x8016374c
[<8009584c>] 0x8009584c
[<8008dec0>] 0x8008dec0
[<80146384>] 0x80146384
[<805e0000>] 0x805e0000
[<805e0000>] 0x805e0000
[<805e50b0>] 0x805e50b0
[<805e5000>] 0x805e5000
[<8001bc68>] 0x8001bc68
[<8004b47c>] 0x8004b47c
[<8005b63c>] 0x8005b63c
[<80088994>] 0x80088994
[<80095be8>] 0x80095be8
[<80012210>] 0x80012210


Code: 00032842  081790dc  3407ffff <94c20000> 3042ffff  00021a02  00021200  00431025  3043ffff
Disabling lock debugging due to kernel taint
usbcore: registered new interface driver cdc_acm
cdc_acm: v0.26:USB Abstract Control Model driver for USB modems and ISDN adapters
usbcore: registered new interface driver usbserial
USB Serial support registered for generic
usbcore: registered new interface driver usbserial_generic
usbserial: USB Serial Driver core
sg: Unknown symbol scsi_device_get
sg: Unknown symbol __scsi_print_sense
sg: Unknown symbol scsi_block_when_processing_errors
sg: Unknown symbol scsi_ioctl
sg: Unknown symbol scsi_device_put
sg: Unknown symbol scsi_reset_provider
sg: Unknown symbol scsi_register_interface
sg: Unknown symbol scsi_normalize_sense
USB Serial support registered for GSM modem (1-port)
usbcore: registered new interface driver option
option: v0.7.2:USB Driver for GSM modems
usb 1-2: usbfs: process 644 (usb_modeswitch) did not claim interface 0 before use
usb 1-2: USB disconnect, address 2
usb 1-2: new high speed USB device using ehci_hcd and address 3
usb 1-2: configuration #1 chosen from 1 choice
b43-phy0: Loading firmware version 508.1084 (2009-01-14 01:32:01)
b43-phy0: Loading firmware version 508.1084 (2009-01-14 01:32:01)
device wlan0 entered promiscuous mode
br-lan: port 2(wlan0) entering forwarding state
device wlan0 left promiscuous mode
br-lan: port 2(wlan0) entering disabled state
device wlan0 entered promiscuous mode
br-lan: port 2(wlan0) entering forwarding state
option 1-2:1.0: GSM modem (1-port) converter detected
usb 1-2: GSM modem (1-port) converter now attached to ttyUSB0
option 1-2:1.1: GSM modem (1-port) converter detected
usb 1-2: GSM modem (1-port) converter now attached to ttyUSB1
option 1-2:1.2: GSM modem (1-port) converter detected
usb 1-2: GSM modem (1-port) converter now attached to ttyUSB2
option 1-2:1.3: GSM modem (1-port) converter detected
usb 1-2: GSM modem (1-port) converter now attached to ttyUSB3
option 1-2:1.4: GSM modem (1-port) converter detected
usb 1-2: GSM modem (1-port) converter now attached to ttyUSB4

config 'interface' 'wan'
	option '_orig_ifname' 'eth0'
	option '_orig_bridge' 'false'
	option 'proto' '3g'
	option 'service' 'umts'
	option 'device' '/dev/ttyUSB1'
	option 'apn' 'home.beeline.ru'
	option 'username' 'beeline'
	option 'password' 'beeline'

ABORT   BUSY
ABORT   'NO CARRIER'
ABORT   ERROR
REPORT  CONNECT
TIMEOUT 10
""      "AT&F"
OK      "ATE1"
OK      'AT+CGDCONT=1,"IP","$USE_APN"'
SAY     "Calling UMTS/GPRS"
TIMEOUT 30
OK      "ATD*99***1#"
CONNECT ' '

Apr 15 21:35:05 OpenWrt user.info kernel: device wlan0 left promiscuous mode
Apr 15 21:35:05 OpenWrt user.info kernel: br-lan: port 2(wlan0) entering disabled state
Apr 15 21:35:09 OpenWrt user.info kernel: b43-phy0: Loading firmware version 508.1084 (2009-01-14 01:32:01)
Apr 15 21:35:10 OpenWrt user.info kernel: b43-phy0: Loading firmware version 508.1084 (2009-01-14 01:32:01)
Apr 15 21:35:10 OpenWrt user.info kernel: device wlan0 entered promiscuous mode
Apr 15 21:35:10 OpenWrt user.info kernel: br-lan: port 2(wlan0) entering forwarding state
Apr 15 21:35:14 OpenWrt local2.info chat[5527]: alarm
Apr 15 21:35:14 OpenWrt local2.info chat[5527]: Failed
Apr 15 21:35:14 OpenWrt daemon.err pppd[5497]: Connect script failed
Apr 15 21:35:17 OpenWrt user.info kernel: device wlan0 left promiscuous mode
Apr 15 21:35:17 OpenWrt user.info kernel: br-lan: port 2(wlan0) entering disabled state
Apr 15 21:35:17 OpenWrt user.info kernel: device wlan0 entered promiscuous mode
Apr 15 21:35:17 OpenWrt user.info kernel: br-lan: port 2(wlan0) entering forwarding state
Apr 15 21:35:18 OpenWrt daemon.info dnsmasq[1200]: exiting on receipt of SIGTERM
Apr 15 21:35:18 OpenWrt user.notice dnsmasq: DNS rebinding protection is active, will discard upstream RFC1918 responses!
Apr 15 21:35:18 OpenWrt user.notice dnsmasq: Allowing 127.0.0.0/8 responses
Apr 15 21:35:19 OpenWrt daemon.info dnsmasq[5872]: started, version 2.55 cachesize 150
Apr 15 21:35:19 OpenWrt daemon.info dnsmasq[5872]: compile time options: IPv6 GNU-getopt no-DBus no-I18N DHCP TFTP
Apr 15 21:35:19 OpenWrt daemon.info dnsmasq[5872]: using local addresses only for domain lan
Apr 15 21:35:19 OpenWrt daemon.info dnsmasq[5872]: reading /tmp/resolv.conf.auto
Apr 15 21:35:19 OpenWrt daemon.info dnsmasq[5872]: using nameserver 8.8.8.8#53
Apr 15 21:35:19 OpenWrt daemon.info dnsmasq[5872]: using local addresses only for domain lan
Apr 15 21:35:19 OpenWrt daemon.info dnsmasq[5872]: read /etc/hosts - 1 addresses
Apr 15 21:35:37 OpenWrt user.info firewall: adding lan (br-lan) to zone lan
Apr 15 21:35:46 OpenWrt local2.info chat[6204]: abort on (BUSY)
Apr 15 21:35:46 OpenWrt local2.info chat[6204]: abort on (NO CARRIER)
Apr 15 21:35:46 OpenWrt local2.info chat[6204]: abort on (ERROR)
Apr 15 21:35:46 OpenWrt local2.info chat[6204]: report (CONNECT)
Apr 15 21:35:46 OpenWrt local2.info chat[6204]: timeout set to 10 seconds
Apr 15 21:35:46 OpenWrt local2.info chat[6204]: send (AT&F^M)
Apr 15 21:35:46 OpenWrt local2.info chat[6204]: expect (OK)
Apr 15 21:35:56 OpenWrt local2.info chat[6204]: alarm
Apr 15 21:35:56 OpenWrt local2.info chat[6204]: Failed
Apr 15 21:35:56 OpenWrt daemon.err pppd[5497]: Connect script failed
Apr 15 21:36:29 OpenWrt local2.info chat[6390]: abort on (BUSY)
Apr 15 21:36:29 OpenWrt local2.info chat[6390]: abort on (NO CARRIER)
Apr 15 21:36:29 OpenWrt local2.info chat[6390]: abort on (ERROR)
Apr 15 21:36:29 OpenWrt local2.info chat[6390]: report (CONNECT)
Apr 15 21:36:29 OpenWrt local2.info chat[6390]: timeout set to 10 seconds
Apr 15 21:36:29 OpenWrt local2.info chat[6390]: send (AT&F^M)
Apr 15 21:36:29 OpenWrt local2.info chat[6390]: expect (OK)
Apr 15 21:36:39 OpenWrt local2.info chat[6390]: alarm
Apr 15 21:36:39 OpenWrt local2.info chat[6390]: Failed
Apr 15 21:36:39 OpenWrt daemon.err pppd[5497]: Connect script failed
Apr 15 21:36:40 OpenWrt authpriv.info dropbear[6438]: Child connection from 192.168.100.4:64036
Apr 15 21:36:46 OpenWrt authpriv.notice dropbear[6438]: Password auth succeeded for 'root' from 192.168.100.4:64036
Apr 15 21:37:11 OpenWrt local2.info chat[6615]: abort on (BUSY)
Apr 15 21:37:11 OpenWrt local2.info chat[6615]: abort on (NO CARRIER)
Apr 15 21:37:11 OpenWrt local2.info chat[6615]: abort on (ERROR)
Apr 15 21:37:11 OpenWrt local2.info chat[6615]: report (CONNECT)
Apr 15 21:37:11 OpenWrt local2.info chat[6615]: timeout set to 10 seconds
Apr 15 21:37:11 OpenWrt local2.info chat[6615]: send (AT&F^M)
Apr 15 21:37:11 OpenWrt local2.info chat[6615]: expect (OK)
Apr 15 21:37:21 OpenWrt local2.info chat[6615]: alarm
Apr 15 21:37:21 OpenWrt local2.info chat[6615]: Failed
Apr 15 21:37:21 OpenWrt daemon.err pppd[5497]: Connect script failed
Apr 15 21:37:53 OpenWrt local2.info chat[6801]: abort on (BUSY)
Apr 15 21:37:53 OpenWrt local2.info chat[6801]: abort on (NO CARRIER)
Apr 15 21:37:53 OpenWrt local2.info chat[6801]: abort on (ERROR)
Apr 15 21:37:53 OpenWrt local2.info chat[6801]: report (CONNECT)
Apr 15 21:37:53 OpenWrt local2.info chat[6801]: timeout set to 10 seconds
Apr 15 21:37:53 OpenWrt local2.info chat[6801]: send (AT&F^M)
Apr 15 21:37:53 OpenWrt local2.info chat[6801]: expect (OK)
Apr 15 21:38:03 OpenWrt local2.info chat[6801]: alarm
Apr 15 21:38:03 OpenWrt local2.info chat[6801]: Failed
Apr 15 21:38:03 OpenWrt daemon.err pppd[5497]: Connect script failed
Apr 15 21:38:35 OpenWrt local2.info chat[6989]: abort on (BUSY)
Apr 15 21:38:35 OpenWrt local2.info chat[6989]: abort on (NO CARRIER)
Apr 15 21:38:35 OpenWrt local2.info chat[6989]: abort on (ERROR)
Apr 15 21:38:35 OpenWrt local2.info chat[6989]: report (CONNECT)
Apr 15 21:38:35 OpenWrt local2.info chat[6989]: timeout set to 10 seconds
Apr 15 21:38:35 OpenWrt local2.info chat[6989]: send (AT&F^M)
Apr 15 21:38:35 OpenWrt local2.info chat[6989]: expect (OK)
Apr 15 21:38:45 OpenWrt local2.info chat[6989]: alarm
Apr 15 21:38:45 OpenWrt local2.info chat[6989]: Failed
Apr 15 21:38:45 OpenWrt daemon.err pppd[5497]: Connect script failed
Apr 15 21:39:17 OpenWrt local2.info chat[7199]: abort on (BUSY)
Apr 15 21:39:17 OpenWrt local2.info chat[7199]: abort on (NO CARRIER)
Apr 15 21:39:17 OpenWrt local2.info chat[7199]: abort on (ERROR)
Apr 15 21:39:17 OpenWrt local2.info chat[7199]: report (CONNECT)
Apr 15 21:39:17 OpenWrt local2.info chat[7199]: timeout set to 10 seconds
Apr 15 21:39:17 OpenWrt local2.info chat[7199]: send (AT&F^M)
Apr 15 21:39:17 OpenWrt local2.info chat[7199]: expect (OK)
Apr 15 21:39:27 OpenWrt local2.info chat[7199]: alarm
Apr 15 21:39:27 OpenWrt local2.info chat[7199]: Failed
Apr 15 21:39:27 OpenWrt daemon.err pppd[5497]: Connect script failed
Apr 15 21:39:59 OpenWrt local2.info chat[7386]: abort on (BUSY)
Apr 15 21:39:59 OpenWrt local2.info chat[7386]: abort on (NO CARRIER)
Apr 15 21:39:59 OpenWrt local2.info chat[7386]: abort on (ERROR)
Apr 15 21:39:59 OpenWrt local2.info chat[7386]: report (CONNECT)
Apr 15 21:39:59 OpenWrt local2.info chat[7386]: timeout set to 10 seconds
Apr 15 21:39:59 OpenWrt local2.info chat[7386]: send (AT&F^M)
Apr 15 21:39:59 OpenWrt local2.info chat[7386]: expect (OK)
Apr 15 21:40:09 OpenWrt local2.info chat[7386]: alarm
Apr 15 21:40:09 OpenWrt local2.info chat[7386]: Failed
Apr 15 21:40:09 OpenWrt daemon.err pppd[5497]: Connect script failed
Apr 15 21:40:41 OpenWrt local2.info chat[7684]: abort on (BUSY)
Apr 15 21:40:41 OpenWrt local2.info chat[7684]: abort on (NO CARRIER)
Apr 15 21:40:41 OpenWrt local2.info chat[7684]: abort on (ERROR)
Apr 15 21:40:41 OpenWrt local2.info chat[7684]: report (CONNECT)
Apr 15 21:40:41 OpenWrt local2.info chat[7684]: timeout set to 10 seconds
Apr 15 21:40:41 OpenWrt local2.info chat[7684]: send (AT&F^M)
Apr 15 21:40:42 OpenWrt local2.info chat[7684]: expect (OK)
Apr 15 21:40:44 OpenWrt local2.err chat[7684]: SIGTERM
Apr 15 21:40:44 OpenWrt daemon.err pppd[5497]: Connect script failed
Apr 15 21:40:46 OpenWrt daemon.info pppd[5497]: Exit.
Apr 15 21:40:50 OpenWrt daemon.notice pppd[7741]: pppd 2.4.4 started by root, uid 0
Apr 15 21:40:51 OpenWrt local2.info chat[7746]: abort on (BUSY)
Apr 15 21:40:51 OpenWrt local2.info chat[7746]: abort on (NO CARRIER)
Apr 15 21:40:51 OpenWrt local2.info chat[7746]: abort on (ERROR)
Apr 15 21:40:51 OpenWrt local2.info chat[7746]: report (CONNECT)
Apr 15 21:40:51 OpenWrt local2.info chat[7746]: timeout set to 10 seconds
Apr 15 21:40:51 OpenWrt local2.info chat[7746]: send (AT&F^M)
Apr 15 21:40:51 OpenWrt local2.info chat[7746]: expect (OK)