読者です 読者をやめる 読者になる 読者になる

BHR-4GRVのブートログ

OpenWrt導入前にBHR-4GRVにシリアル接続して、電源オン直後からのログを取った。

長いので全ログはエントリ末尾に掲載するが、下記部分が興味深いと感じた。

SPI flash size total:32 Mbytes
WZR-HP-G450H_part partition parsing not available
WZR-HP-G302NH_V2_part partition parsing not available
WHR-AG300N_part partition parsing not available
WHR-HP-G300N_part partition parsing not available
7 cmdlinepart partitions found on MTD device ar7240-nor0
Creating 7 MTD partitions on "ar7240-nor0":
0x000000000000-0x000000040000 : "uboot"
0x000000040000-0x000000050000 : "uboot_environ"
0x000000050000-0x000000060000 : "ART"
0x000000060000-0x000000160000 : "linux"
0x000000160000-0x000001fe0000 : "rootfs"
0x000001fe0000-0x000002000000 : "user_property"
0x000000060000-0x000001fe0000 : "firmware"

MTDのパーティション決定のために機種判定コードが動いているようだ。機種ごとに別ファームウェアを配っているのにわざわざ判定を行っているのはファームビルドの手間を省くためなのか、この方がテストがやりやすいのか、色々謎である。

以下がログ全体。

BUFFALO U-BOOT Ver 1.00
  == CPU:400MHz, DDR:400MHz, AHB:200MHz ==
AP111 (ar7241 - Virian) U-boot
DRAM:  64 MB
WAN port disabling: done
Top of RAM usable for U-Boot at: 84000000
Reserving 257k for U-Boot at: 83fbc000
Reserving 192k for malloc() at: 83f8c000
Reserving 44 Bytes for Board Info at: 83f8bfd4
Reserving 36 Bytes for Global Data at: 83f8bfb0
Reserving 128k for boot params() at: 83f6bfb0
Stack Pointer at: 83f6bf98
Now running in RAM - U-Boot at: 83fbc000
flash bank #0 found 16 MB flash [W25Q128BV, blk:0x10000, sectors:256]
flash bank #1 found 16 MB flash [W25Q128BV, blk:0x10000, sectors:256]
Flash: 32 MB
*** Warning *** : PCIe WLAN Module not found !!!
In:    serial
Out:   serial
Err:   serial
Memory Test (address line)
uboot use  83F6BFB0 - 84000000
Memory Test start(0x80000000) end(0x83F00000) size(67108864)
Data line test start:0x80000000 pattern 0x00000001 0x00000003 0x00000007 0x0000000F 0x00000005 0x00000015 0x00000055 0xAAAAAAAA 
Address line test start:0x80000000 len:0x3f00000 pattern 0xAAAAAAAA 0x55555555  
Fill test patnum:5 
fill Pattern 5555AAAA  Writing...             Reading...
fill Pattern AAAA5555  Writing...             Reading...
fill Pattern 0000FFFF  Writing...             Reading...
fill Pattern FFFF0000  Writing...             Reading...
fill Pattern AAAAAAAA  Writing...             Reading...
Memory Test OK
### buf_ver=[1.00] U-Boot Ver.=[1.00]
### build_date(env)=[Apr  6 2011 - 08:52:25] build_date(bin)=[Apr  6 2011 - 08:52:25]
ag7240_enet_initialize...
Reading MAC Address from ENV(0x83f8c322)
No valid address in Flash. Using fixed address
Virian MDC CFG Value ==> 4
: cfg1 0x7 cfg2 0x7114
eth0: 02:aa:bb:cc:dd:22
athrs16_reg_init: complete
eth0 up
Virian MDC CFG Value ==> 4
: cfg1 0xf cfg2 0x7214
eth1: 00:03:7f:09:0b:ad
eth1 up
eth0  02:AA:BB:CC:DD:22
, eth1  00:03:7F:09:0B:AD

eth0 link down

tftp server(receive) go, waiting:4[sec]
eth0 link down
Load address: 0x81f00000

TftpServer Timeout;
no file was loaded.
LAN port disabling: done
skip FW-CRC checking!!!
change bootargs
console=ttyS0,115200 root=31:03 rootfstype=jffs2 init=/sbin/init mtdparts=ar7240-nor0:256k(u-boot),64k(u-boot-env),1152k@384k(uImage),6592k@1536k(rootfs),64k@320k(ART),64k@8128k(properties),8192k@8192k(flash1),16384k@16384k(flash2) mem=64M
## Booting image at bf060000 ...
   Image Name:   Linux Rootfs Combined Image
   Created:      2012-12-19  18:30:33 UTC
   Image Type:   MIPS Linux Kernel Image (lzma compressed)
   Data Size:    21454784 Bytes = 20.5 MB
   Load Address: 80002000
   Entry Point:  80201320
   Uncompressing Kernel Image ... OK
No initrd
## Transferring control to Linux (at address 80201320) ...
## Giving linux memsize in bytes, 67108864

Starting kernel ...

Booting AR7240(Python)...
Linux version 2.6.31--LSDK-9.2.0.106 (snapshot@snapshot-03) (gcc version 4.3.3 (GCC) ) #1 Thu Dec 20 03:16:13 JST 2012
flash_size passed from bootloader = 32
arg 1: console=ttyS0,115200
arg 2: root=31:03
arg 3: rootfstype=jffs2
arg 4: init=/sbin/init
arg 5: mtdparts=ar7240-nor0:256k(u-boot),64k(u-boot-env),1152k@384k(uImage),6592k@1536k(rootfs),64k@320k(ART),64k@8128k(properties),8192k@8192k(flash1),16384k@16384k(flash2)
arg 6: mem=64M
use [CONFIG_CMDLINE] = console=ttyS0,115200 root=/dev/mtdblock4 rootfstype=squashfs init=/sbin/init mtdparts=ar7240-nor0:256k(uboot),64k(uboot_environ),64k(ART),1024k(linux),31232k(rootfs),128k(user_property),32256k@384k(firmware) mem=64M 
CPU revision is: 00019374 (MIPS 24Kc)
Determined physical RAM map:
 memory: 02000000 @ 00000000 (usable)
User-defined physical RAM map:
 memory: 04000000 @ 00000000 (usable)
Zone PFN ranges:
  Normal   0x00000000 -> 0x00004000
Movable zone start PFN for each node
early_node_map[1] active PFN ranges
    0: 0x00000000 -> 0x00004000
Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 16256
Kernel command line: console=ttyS0,115200 root=/dev/mtdblock4 rootfstype=squashfs init=/sbin/init mtdparts=ar7240-nor0:256k(uboot),64k(uboot_environ),64k(ART),1024k(linux),31232k(rootfs),128k(user_property),32256k@384k(firmware) mem=64M
PID hash table entries: 256 (order: 8, 1024 bytes)
Dentry cache hash table entries: 8192 (order: 3, 32768 bytes)
Inode-cache hash table entries: 4096 (order: 2, 16384 bytes)
Primary instruction cache 64kB, VIPT, 4-way, linesize 32 bytes.
Primary data cache 32kB, 4-way, VIPT, cache aliases, linesize 32 bytes
Writing ErrCtl register=00000000
Readback ErrCtl register=00000000
Memory: 61900k/65536k available (2067k kernel code, 3564k reserved, 569k data, 128k init, 0k highmem)
NR_IRQS:128
plat_time_init: plat time init done
Calibrating delay loop... 266.24 BogoMIPS (lpj=532480)
Mount-cache hash table entries: 512
NET: Registered protocol family 16
===== ar7240_platform_init: 0
***** Warning *****: PCIe WLAN H/W not found !!!
bio: create slab <bio-0> at 0
SCSI subsystem initialized
NET: Registered protocol family 2
IP route cache hash table entries: 1024 (order: 0, 4096 bytes)
TCP established hash table entries: 2048 (order: 2, 16384 bytes)
TCP bind hash table entries: 2048 (order: 1, 8192 bytes)
TCP: Hash tables configured (established 2048 bind 2048)
TCP reno registered
NET: Registered protocol family 1
AR7240 GPIOC major 0
squashfs: version 4.0 (2009/01/31) Phillip Lougher
Slow work thread pool: Starting up
Slow work thread pool: Ready
GFS2 (built Dec 20 2012 03:12:53) installed
msgmni has been set to 121
alg: No test for lzma (lzma-generic)
alg: No test for stdrng (krng)
io scheduler noop registered
io scheduler deadline registered (default)
HDLC line discipline maxframe=4096
N_HDLC line discipline registered.
Serial: 8250/16550 driver, 1 ports, IRQ sharing disabled
serial8250.0: ttyS0 at MMIO 0xb8020000 (irq = 19) is a 16550A
console [ttyS0] enabled
brd: module loaded
PPP generic driver version 2.4.2
PPP Deflate Compression module registered
PPP BSD Compression module registered
PPP MPPE compression module registered
NET: Registered protocol family 24
drivers/mtd/mtdchar.c(1053): alloc reserved-buffer addr=83940000 size=131072
check spi banks 2
0000 : EF 40 18
found W25Q128BV device on bank#0
0000 : EF 40 18
found W25Q128BV device on bank#1
SPI flash size total:32 Mbytes
WZR-HP-G450H_part partition parsing not available
WZR-HP-G302NH_V2_part partition parsing not available
WHR-AG300N_part partition parsing not available
WHR-HP-G300N_part partition parsing not available
7 cmdlinepart partitions found on MTD device ar7240-nor0
Creating 7 MTD partitions on "ar7240-nor0":
0x000000000000-0x000000040000 : "uboot"
0x000000040000-0x000000050000 : "uboot_environ"
0x000000050000-0x000000060000 : "ART"
0x000000060000-0x000000160000 : "linux"
0x000000160000-0x000001fe0000 : "rootfs"
0x000001fe0000-0x000002000000 : "user_property"
0x000000060000-0x000001fe0000 : "firmware"
u32 classifier
nf_conntrack version 0.5.0 (1024 buckets, 4096 max)
ip_tables: (C) 2000-2006 Netfilter Core Team
TCP cubic 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>
ar7240wdt_init: Registering WDT success
VFS: Mounted root (squashfs filesystem) readonly on device 31:4.
Freeing unused kernel memory: 128k freed
Warning: unable to open an initial console.
insmod: /lib/modules/2.6.31--LSDK-9.2.0.106: No such file or directory
Using /lib/modules/kernel/drivers/char/mel_initsw.ko

Please press Enter to activate this console. mel_initsw_ar7240_bhr_4grv: module license 'unspecified' taints kernel.
Disabling lock debugging due to kernel taint
mel_initsw initialized. 
watchdogd.c(33) watchdogd_main :watchdog refresh 00000000
WD:Start Watchdog Daemon
rc.c(354) VerifyParamsOfInit :x:create status sections
rc.c(896) SetUbootParam :====:pUbootProduct=BHR-4GRV
rc.c(906) SetUbootParam :====:pProductHex=00000001(str:00000001)
insmod: /lib/modules/2.6.31--LSDK-9.2.0.106: No such file or directory
Using /lib/modules/2.6.31/net/athrs_gmac.ko
ATHR_GMAC: Length per segment 1536
ATHR_GMAC: fifo cfg 3 01f00140
ATHR_GMAC: [eth%d] netdev_priv is 839fcac0
ATHR_GMAC: [eth%d] netdev_priv is 839fc6c0
ATHR_GMAC: Mac address for unit 0: 4c:e6:76:**:**:47
ATHR_GMAC: Mac address for unit 0: 4c:e6:76:**:**:47
ATHR_GMAC: Max segments per packet :   1
ATHR_GMAC: Max tx descriptor count :   40
ATHR_GMAC: Max rx descriptor count :   252
ATHR_GMAC: Mac capability flags    :   4B81
ATHR_GMAC: [eth%d] netdev_priv is 83a6d2c0
ATHR_GMAC: [eth%d] netdev_priv is 83a08ec0
ATHR_GMAC: Mac address for unit 1: 4c:e6:76:**:**:48
ATHR_GMAC: Mac address for unit 1: 4c:e6:76:**:**:48
------------[ cut here ]------------
WARNING: at fs/proc/generic.c:590 proc_register+0x18c/0x1d8()
proc_dir_entry '/proc/eth' already registered
Modules linked in: athrs_gmac(+) mel_initsw_ar7240_bhr_4grv(P)
Call Trace:
[<8020423c>] dump_stack+0x8/0x34
[<80022f9c>] warn_slowpath_common+0x70/0xb0
[<8002301c>] warn_slowpath_fmt+0x24/0x30
[<800ad7c8>] proc_register+0x18c/0x1d8
[<800ada0c>] proc_mkdir_mode+0x3c/0x64
[<c004193c>] athr_gmac_init+0x93c/0xc84 [athrs_gmac]
[<80002468>] _stext+0x68/0x1ec

---[ end trace 12a4c3bd7d5329b8 ]---
ATHR_GMAC: Max segments per packet :   1
ATHR_GMAC: Max tx descriptor count :   40
ATHR_GMAC: Max rx descriptor count :   252
ATHR_GMAC: Mac capability flags    :   4981
athr_gmac_ring_alloc Allocated 640 at 0x83a74800
athr_gmac_ring_alloc Allocated 4032 at 0x83a67000
Virian MDC CFG Value ==> 4
Setting Drop CRC Errors, Pause Frames and Length Error frames 
Modified reg init
ATHRS16: resetting...
ATHRS16: reset done.
CFG Board need PortVLAN 
Enable Broadcast forward
port vlan initialize...
AbBUFFALO athrs16_reg_init complete.
Setting PHY...
Phy setup Complete
insmod: /lib/modules/2.6.31--LSDK-9.2.0.106: No such file or directory
Using /lib/modules/2.6.31/net/athrs_gmac.ko
insmod: cannot insert `/lib/modules/2.6.31/net/athrs_gmac.ko': Invalid parameters (17): Invalid argument
MidLayerFlashNvram.c(1910) MLF_GetUbootParam :ERROR:cmderr="ubootenv get dummy_ethaddr "
insmod: /lib/modules/2.6.31--LSDK-9.2.0.106: No such file or directory
Using /lib/modules/kernel/net/ipv4/netfilter/nf_conntrack_proto_gre.ko
insmod: /lib/modules/2.6.31--LSDK-9.2.0.106: No such file or directory
Using /lib/modules/kernel/net/ipv4/netfilter/nf_nat_proto_gre.ko
rc.c(896) SetUbootParam :====:pUbootProduct=BHR-4GRV
rc.c(906) SetUbootParam :====:pProductHex=00000001(str:00000001)
insmod: /lib/modules/2.6.31--LSDK-9.2.0.106: No such file or directory
Using /lib/modules/2.6.31/net/athrs_gmac.ko
insmod: cannot insert `/lib/modules/2.6.31/net/athrs_gmac.ko': Invalid parameters (17): Invalid argument
insmod: /lib/modules/2.6.31--LSDK-9.2.0.106: No such file or directory
Using /lib/modules/2.6.31/net/athrs_gmac.ko
insmod: cannot insert `/lib/modules/2.6.31/net/athrs_gmac.ko': Invalid parameters (17): Invalid argument
MidLayerFlashNvram.c(1910) MLF_GetUbootParam :ERROR:cmderr="ubootenv get dummy_ethaddr "
insmod: /lib/modules/2.6.31--LSDK-9.2.0.106: No such file or directory
Using /lib/modules/kernel/net/ipv4/netfilter/nf_conntrack_proto_gre.ko
insmod: cannot insert `/lib/modules/kernel/net/ipv4/netfilter/nf_conntrack_proto_gre.ko': Invalid parameters (17): Invalid argument
insmod: /lib/modules/2.6.31--LSDK-9.2.0.106: No such file or directory
Using /lib/modules/kernel/net/ipv4/netfilter/nf_nat_proto_gre.ko
insmod: cannot insert `/lib/modules/kernel/net/ipv4/netfilter/nf_nat_proto_gre.ko': Invalid parameters (17): Invalid argument
MidLayerModDep.c(807) startModules :INFO:Starting module init
Algorithmics/MIPS FPU Emulator v1.5
mknod: /dev/ppp: File exists
insmod: /lib/modules/2.6.31--LSDK-9.2.0.106: No such file or directory
insmod: slhc.ko: no module by that name found
insmod: /lib/modules/2.6.31--LSDK-9.2.0.106: No such file or directory
insmod: ppp_generic.ko: no module by that name found
insmod: /lib/modules/2.6.31--LSDK-9.2.0.106: No such file or directory
insmod: ppp_mppe.ko: no module by that name found
insmod: /lib/modules/2.6.31--LSDK-9.2.0.106: No such file or directory
insmod: ppp_async.ko: no module by that name found
insmod: /lib/modules/2.6.31--LSDK-9.2.0.106: No such file or directory
insmod: ppp_synctty.ko: no module by that name found
insmod: /lib/modules/2.6.31--LSDK-9.2.0.106: No such file or directory
insmod: pppox.ko: no module by that name found
insmod: /lib/modules/2.6.31--LSDK-9.2.0.106: No such file or directory
insmod: pppoe.ko: no module by that name found
insmod: /lib/modules/2.6.31--LSDK-9.2.0.106: No such file or directory
insmod: zlib_deflate.ko: no module by that name found
insmod: /lib/modules/2.6.31--LSDK-9.2.0.106: No such file or directory
insmod: ppp_deflate.ko: no module by that name found
insmod: /lib/modules/2.6.31--LSDK-9.2.0.106: No such file or directory
Using /lib/modules/kernel/fs/nls/nls_base.ko
insmod: /lib/modules/2.6.31--LSDK-9.2.0.106: No such file or directory
Using /lib/modules/kernel/drivers/usb/core/usbcore.ko
usbcore: registered new interface driver usbfs
usbcore: registered new interface driver hub
usbcore: registered new device driver usb
insmod: /lib/modules/2.6.31--LSDK-9.2.0.106: No such file or directory
Using /lib/modules/kernel/drivers/usb/host/ehci-hcd.ko
ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
Port Status c000004 
ar7240-ehci ar7240-ehci.0: ATH EHCI
ar7240-ehci ar7240-ehci.0: new USB bus registered, assigned bus number 1
ehci_reset Intialize USB CONTROLLER in host mode: 3
ehci_reset Port Status c000000 
ar7240-ehci ar7240-ehci.0: irq 3, io mem 0x1b000000
ehci_reset Intialize USB CONTROLLER in host mode: 3
ehci_reset Port Status c000000 
ar7240-ehci ar7240-ehci.0: USB 2.0 started, EHCI 1.00
usb usb1: New USB device found, idVendor=1d6b, idProduct=0002
usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
usb usb1: Product: ATH EHCI
usb usb1: Manufacturer: Linux 2.6.31--LSDK-9.2.0.106 ehci_hcd
usb usb1: SerialNumber: platform
usb usb1: configuration #1 chosen from 1 choice
hub 1-0:1.0: USB hub found
hub 1-0:1.0: 1 port detected
insmod: /lib/modules/2.6.31--LSDK-9.2.0.106: No such file or directory
Using /lib/modules/kernel/drivers/usb/host/ohci-hcd.ko
ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
MidLayerModDep.c(819) startModules :INFO:Started  module init 1575[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_tz
MidLayerModDep.c(819) startModules :INFO:Started  module rc_tz 1[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_syslogd
MidLayerModDep.c(819) startModules :INFO:Started  module rc_syslogd 417[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_klogd
MidLayerModDep.c(819) startModules :INFO:Started  module rc_klogd 13[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_loif
insmod: /lib/modules/2.6.31--LSDK-9.2.0.106: No such file or directory
Using /lib/modules/2.6.31/net/athrs_gmac.ko
insmod: cannot insert `/lib/modules/2.6.31/net/athrs_gmac.ko': Invalid parameters (17): Invalid argument
MidLayerFlashNvram.c(1910) MLF_GetUbootParam :ERROR:cmderr="ubootenv get dummy_ethaddr "
MidLayerModDep.c(819) startModules :INFO:Started  module rc_loif 87[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_router_behavior
MidLayerModDep.c(819) startModules :INFO:Started  module rc_router_behavior 0[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module init
MidLayerModDep.c(819) startModules :INFO:Started  module init 4[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_user_passwd
MidLayerModDep.c(819) startModules :INFO:Started  module rc_user_passwd 0[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_usbmod
insmod: /lib/modules/2.6.31--LSDK-9.2.0.106: No such file or directory
Using /lib/modules/kernel/drivers/usb/storage/usb-storage.ko
insmod: /lib/modules/2.6.31--LSDK-9.2.0.106: No such file or directory
Using /lib/modules/kernel/fs/exportfs/exportfs.ko
insmod: /lib/modules/2.6.31--LSDK-9.2.0.106: No such file or directory
Using /lib/modules/kernel/fs/xfs/xfs.ko
insmod: /lib/modules/2.6.31--LSDK-9.2.0.106: No such file or directory
Using /lib/modules/kernel/fs/fat/fat.ko
insmod: /lib/modules/2.6.31--LSDK-9.2.0.106: No such file or directory
Using /lib/modules/kernel/fs/fat/vfat.ko
insmod: /lib/modules/2.6.31--LSDK-9.2.0.106: No such file or directory
Using /lib/modules/kernel/fs/nls/nls_cp932.ko
insmod: /lib/modules/2.6.31--LSDK-9.2.0.106: No such file or directory
Using /lib/modules/kernel/fs/nls/nls_utf8.ko
MidLayerModDep.cathr_gmac_do_ioctl: dev:eth1 ifr:838c1e18 cmd:0x89FF
(819) startModulathrs16_ioctl_buffalo: dev:eth1 ethUnit:0 cmd:0x89FF
es :INFO:Started+  module rc_usbm-od 1718[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_wiredlan
MidLayerModDep.c(819) startModules :INFO:Started  module rc_wiredlan 137[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module id
MidLayerModDep.c(819) startModules :INFO:Started  module id 3[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module lang
MidLayerModDep.c(819) startModules :INFO:Started  module lang 0[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_lanif

rc_lanif.c(475) StartOfrc_lanif :x:PPPoE Path throw?


unable to set ip mcast flag
unable to set ip mcast policy
MidLayerModDep.c(819) startModules :INFO:Started  module rc_lanif 145[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_udhcpd
udhcpd (v0.9.9-pre) started
max_leases value (256) not sane, setting to 16 instead
MidLayerModDep.c(819) startModules :INFO:Started  module rc_udhcpd 27[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_ap_serv
MidLayerModDep.c(819) startModules :INFO:Started  module rc_ap_serv 31[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_usb_device_server
MidLayerModDep.c(819) startModules :INFO:Started  module rc_usb_device_server 0[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_httpd
MidLayerModDep.c(819) startModules :INFO:Started  module rc_httpd 25[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_wanif
MidLayerModDep.c(819) startModules :INFO:Started  module rc_wanif 0[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_wanctl_pre
athr_gmac_do_ioctl: dev:eth1 ifr:83033e18 cmd:0x89FB
athrs16_ioctl_buffalo: dev:eth1 ethUnit:0 cmd:0x89FB
MidLayer.c(1591) ML_Signal_QueueRemove :x:SIGNAL-QUEUE NOT-FOUND (tree=NORM mod=rc_wanctl_dhcpcd)
MidLayer.c(1591) ML_Signal_QueueRemove :x:SIGNAL-QUEUE NOT-FOUND (tree=NORM mod=rc_wanctl_pppoecd_0)
MidLayer.c(1591) ML_Signal_QueueRemove :x:SIGNAL-QUEUE NOT-FOUND (tree=NORM mod=rc_wanctl_pppoecd_1)
MidLayer.c(1591) ML_Signal_QueueRemove :x:SIGNAL-QUEUE NOT-FOUND (tree=NORM mod=rc_wanctl_pppoecd_2)
MidLayer.c(1591) ML_Signal_QueueRemove :x:SIGNAL-QUEUE NOT-FOUND (tree=NORM mod=rc_wanctl_pppoecd_3)
MidLayer.c(1591) ML_Signal_QueueRemove :x:SIGNAL-QUEUE NOT-FOUND (tree=NORM mod=rc_wanctl_pppoecd_4)
MidLayer.c(1591) ML_Signal_QueueRemove :x:SIGNAL-QUEUE NOT-FOUND (tree=NORM mod=rc_wanctl_auto_detect)
MidLayerModDep.c(819) startModules :INFO:Started  module rc_wanctl_pre 3068[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_wanctl_auto_detect
MidLayerModDep.c(819) startModules :INFO:Started  module rc_wanctl_auto_detect 0[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_wanctl_auto_detect_dummy
MidLayerModDep.c(819) startModules :INFO:Started  module rc_wanctl_auto_detect_dummy 0[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_wanctl_auto_detect_dhcpcd
MidLayerModDep.c(819) startModules :INFO:Started  module rc_wanctl_auto_detect_dhcpcd 0[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_wanctl_auto_detect_pppoecd_0
MidLayerModDep.c(819) startModules :INFO:Started  module rc_wanctl_auto_detect_pppoecd_0 0[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_wanctl_auto_detect_pppoecd_1
MidLayerModDep.c(819) startModules :INFO:Started  module rc_wanctl_auto_detect_pppoecd_1 0[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_wanctl_auto_detect_pppoecd_2
MidLayerModDep.c(819) startModules :INFO:Started  module rc_wanctl_auto_detect_pppoecd_2 0[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_wanctl_auto_detect_pppoecd_3
MidLayerModDep.c(819) startModules :INFO:Started  module rc_wanctl_auto_detect_pppoecd_3 0[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_wanctl_auto_detect_pppoecd_4
MidLayerModDep.c(819) startModules :INFO:Started  module rc_wanctl_auto_detect_pppoecd_4 0[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_wanctl_auto_detect_pppoecd_check
MidLayerModDep.c(819) startModules :INFO:Started  module rc_wanctl_auto_detect_pppoecd_check 0[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_wanctl_manual
MidLayerModDep.c(819) startModules :INFO:Started  module rc_wanctl_manual 0[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_wanctl_dhcpcd
MidLayerModDep.c(819) startModules :INFO:Started  module rc_wanctl_dhcpcd 0[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_wanctl_pppoecd_0
MidLayerModDep.c(819) startModules :INFO:Started  module rc_wanctl_pppoecd_0 2[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_wanctl_pppoecd_1
rc_wanctl_pppoecd.c(490) Common_StartOfrc_wanctl_pppoecd :DEBUG:ConnectMethod is PPPoE
rc_wanctl_pppoecd.c(493) Common_StartOfrc_wanctl_pppoecd :DEBUG:Index=1 eth1 Down
rc_wanctl_pppoecd.c(496) Common_StartOfrc_wanctl_pppoecd :DEBUG:Index=1 eth1 Up
--- PPPoE ---
pppoe_srv_name=B-F pppoe_ac_name=(null) hostuniq=(null)
retries=4 pppoe_server=1 ifunit=1
--- Auth ---
user=(BZAWNYUHW@plala.or.jp)  pass=(WEE-RING-TILL)  refuse_chap=0 refuse_pap=0
--- General Opt ---
holdoff=5 idle_time_limit=0 maxconnect=0 persist=1
demand=0 maxfail=9 connect_delay=1000 continuous=1

>>persist=1 maxfail=9 unsuccess=1 need_holdoff=1 
continuous=1 demand=0 demand_at_once=0 doing_callback=0
--- PPPoE ---
pppoe_srv_name=B-F pppoe_ac_name=(null) hostuniq=(null)
retries=4 pppoe_server=1 ifunit=1
--- Auth ---
user=(BZAWNYUHW@plala.or.jp)  pass=(WEE-RING-TILL)  refuse_chap=0 refuse_pap=0
--- General Opt ---
holdoff=5 idle_time_limit=0 maxconnect=0 persist=1
demand=0 maxfail=9 connect_delay=1000 continuous=1

MidLayerModDep.c(819) startModules :INFO:Started  module rc_wanctl_pppoecd_1 16252[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_wanctl_pppoecd_2
MidLayerModDep.c(819) startModules :INFO:Started  module rc_wanctl_pppoecd_2 1[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_wanctl_pppoecd_3
MidLayerModDep.c(819) startModules :INFO:Started  module rc_wanctl_pppoecd_3 1[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_wanctl_pppoecd_4
MidLayerModDep.c(819) startModules :INFO:Started  module rc_wanctl_pppoecd_4 1[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_wanctl_pppoecd_check
MidLayerModDep.c(819) startModules :INFO:Started  module rc_wanctl_pppoecd_check 0[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_wanctl_post
route: SIOC[ADD|DEL]RT: No such process
MidLayerModDep.c(819) startModules :INFO:Started  module rc_wanctl_post 94[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_wanctl_pppoeroute
MidLayerModDep.c(819) startModules :INFO:Started  module rc_wanctl_pppoeroute 2[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_dnrd
MidLayerModDep.c(819) startModules :INFO:Started  module rc_dnrd 116[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_netwatchd
wanctl-wanstate_check.c(910) wanstate_check_main :wanctl:Start wanstate_check Daemon
wanctl-lib.c(5019) NtpFunctionControle :x:ntp-client disable
MidLayerModDep.c(819) startModules :INFO:Started  module rc_netwatchd 168[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_ipfilter
iptables: Bad rule (does a matching rule exist in that chain?)
MidLayerModDep.c(819) startModules :INFO:Started  module rc_ipfilter 516[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_ipfilter_simple
MidLayerModDep.c(819) startModules :INFO:Started  module rc_ipfilter_simple 44[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_ipfilter_user
MidLayerModDep.c(819) startModules :INFO:Started  module rc_ipfilter_user 1[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_ipfilter_pptp
MidLayerModDep.c(819) startModules :INFO:Started  module rc_ipfilter_pptp 0[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_nat
insmod: /lib/modules/2.6.31--LSDK-9.2.0.106: No such file or directory
Using /lib/modules/kernel/net/ipv4/netfilter/nf_conntrack_pptp.ko
insmod: /lib/modules/2.6.31--LSDK-9.2.0.106: No such file or directory
Using /lib/modules/kernel/net/ipv4/netfilter/nf_nat_pptp.ko
insmod: /lib/modules/2.6.31--LSDK-9.2.0.106: No such file or directory
Using /lib/modules/kernel/net/ipv4/buff_fastpath.ko

Loding buf_fastpath_module
--> FastNAT poor_spi Enable 9
rcUtil.c(5375) SetFastNat :fastn--> FastNAT Started AC105A0A/FFFFFF00 -> 0A404041/FFFFFFFF 
at-debug:write "poor_spi:9
" ==> "/proc/net/fastnat"
rcUtil.c(5390) SetFastNat :fastnat-debug:write "start:ppp1:br0
" ==> "/proc/net/fastnat"
MidLayerModDep.c(819) startModules :INFO:Started  module rc_nat 485[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_routectl
MidLayerModDep.c(819) startModules :INFO:Started  module rc_routectl 35[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_zebra
MidLayerModDep.c(819) startModules :INFO:Started  module rc_zebra 801[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_lltd
MidLayerModDep.c(819) startModules :INFO:Started  module rc_lltd 154[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_upnp
iptables v1.4.2: Couldn't find target `UPNP-PREROUTING-CHAIN'

Try `iptables -h' or 'iptables --help' for more information.
iptables: No chain/target/match by that name
iptables: No chain/target/match by that name
iptables v1.4.2: Couldn't find target `UPNP-POSTROUTING-CHAIN'

Try `iptables -h' or 'iptables --help' for more information.
iptables: No chain/target/match by that name
iptables: No chain/target/match by that name
MidLayerModDep.c(819) startModules :INFO:Started  module rc_upnp 306[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_ntpclient
MidLayerModDep.c(819) startModules :INFO:Started  module rc_ntpclient 110[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_eco
MidLayerModDep.c(819) startModules :INFO:Started  module rc_eco 78[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_wan_qos
MidLayerModDep.c(819) startModules :INFO:Started  module rc_wan_qos 0[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_pptp_client
MidLayerModDep.c(819) startModules :INFO:Started  module rc_pptp_client 69[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_pptp_client_route
MidLayerModDep.c(819) startModules :INFO:Started  module rc_pptp_client_route 245[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_pptp_server
MidLayerModDep.c(819) startModules :INFO:Started  module rc_pptp_server 0[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_pptp_server_route
MidLayerModDep.c(819) startModules :INFO:Started  module rc_pptp_server_route 93[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_nastorage
MidLayerModDep.c(819) startModules :INFO:Started  module rc_nastorage 21[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_ifilter
MidLayerModDep.c(819) startModules :INFO:Started  module rc_ifilter 38[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_auto_fwup
/dev/set_clock: cannot create
led_mask_11g_chip:0
MidLayerModDep.c(819) startModules :INFO:Started  module rc_auto_fwup 163[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_end_signal
wanctl_fwupdate.c(93) IsConnectionStatusGood :DEBUG:PPPOECD_STAT : 2
MidLayerModDep.c(819) startModules :INFO:Started  module rc_end_signal 36[msec]
MidLayerModDep.c(807) startModules :INFO:Starting module rc_timer_reboot
MidLayerModDep.c(819) startModules :INFO:Started  module rc_timer_reboot 0[msec]
main.c(280) main :x:PMLIST RESTORE START
main.c(283) main :x:PMLIST RESTORE END
>>persist=1 maxfail=9 unsuccess=2 need_holdoff=1 
continuous=1 demand=0 demand_at_once=0 doing_callback=0
--- PPPoE ---
pppoe_srv_name=B-F pppoe_ac_name=(null) hostuniq=(null)
retries=4 pppoe_server=1 ifunit=1
--- Auth ---
user=(****@plala.or.jp)  pass=(WEE-RING-TILL)  refuse_chap=0 refuse_pap=0
--- General Opt ---
holdoff=5 idle_time_limit=0 maxconnect=0 persist=1
demand=0 maxfail=9 connect_delay=1000 continuous=1

ARPING to 172.16.90.10 from 172.16.90.10 via br0
Sent 1 probes (1 broadcast(s))
Received 0 reply