[avahi] Services not registered when DHCP request occurs during avahi-daemon start-up
armand.ciejak at free.fr
armand.ciejak at free.fr
Mon Oct 5 03:09:53 PDT 2009
I'm using avahi 0.6.25 with OpenWrt (Linux kernel 2.6.30.7, busybox 1.13.4) on a PowerPC custom board with 2 Ethernet ports.
I have a problem a boot time if a configure one of the 2 Ethernet ports to get it's IP address with DHCP.
What I see is that if the DHCP client (udhcpc from busybox) gets the IP address while the avahi-daemon is starting, the services are never published by avahi.
With the exact same set-up if I configure both Ethernet ports with static IP addresses the services are published correctly.
The problem can be seen in the following logs. The first one is missing the 3 following lines:
Oct 1 08:51:11 E106926 daemon.info avahi-daemon[855]: Service "VM XMC16 [E106926]" (/etc/avahi/services/xnp-sysconfig.service) successfully established.
Oct 1 08:51:11 E106926 daemon.info avahi-daemon[855]: Service "Secure Shell on E106926" (/etc/avahi/services/ssh.service) successfully established.
Oct 1 08:51:11 E106926 daemon.info avahi-daemon[855]: Service "Web Server on E106926" (/etc/avahi/services/http.service) successfully established.
Here is a log of the boot with eth0 set-up with DHCP and eth1 using a static IP address, showing the problem:
root at E106926:~# logread
Jan 1 01:00:05 E106926 user.debug kernel: pci 0000:00:00.0: reg 18 64bit mmio: [0x000000-0x3fffffff]
Jan 1 01:00:05 E106926 user.debug kernel: pci_bus 0000:00: resource 0 io: [0x00-0xffffff]
Jan 1 01:00:05 E106926 user.debug kernel: pci_bus 0000:00: resource 1 pref mem [0x80000000-0x8fffffff]
Jan 1 01:00:05 E106926 user.debug kernel: pci_bus 0000:00: resource 2 mem: [0x90000000-0x9fffffff]
Jan 1 01:00:05 E106926 user.debug kernel: Registering ipic with sysfs...
Jan 1 01:00:05 E106926 user.warn kernel: bio: create slab <bio-0> at 0
Jan 1 01:00:05 E106926 user.notice kernel: SCSI subsystem initialized
Jan 1 01:00:05 E106926 user.info kernel: usbcore: registered new interface driver usbfs
Jan 1 01:00:05 E106926 user.info kernel: usbcore: registered new interface driver hub
Jan 1 01:00:05 E106926 user.info kernel: usbcore: registered new device driver usb
Jan 1 01:00:05 E106926 user.info kernel: NET: Registered protocol family 2
Jan 1 01:00:05 E106926 user.debug kernel: Switched to high resolution mode on CPU 0
Jan 1 01:00:05 E106926 user.info kernel: IP route cache hash table entries: 1024 (order: 0, 4096 bytes)
Jan 1 01:00:05 E106926 user.info kernel: TCP established hash table entries: 4096 (order: 3, 32768 bytes)
Jan 1 01:00:05 E106926 user.info kernel: TCP bind hash table entries: 4096 (order: 2, 16384 bytes)
Jan 1 01:00:05 E106926 user.info kernel: TCP: Hash tables configured (established 4096 bind 4096)
Jan 1 01:00:05 E106926 user.info kernel: TCP reno registered
Jan 1 01:00:05 E106926 user.info kernel: NET: Registered protocol family 1
Jan 1 01:00:05 E106926 user.debug kernel: irq: irq 9 on host /soc8349 at e0000000/pic at 700 mapped to virtual irq 16
Jan 1 01:00:05 E106926 user.debug kernel: irq: irq 10 on host /soc8349 at e0000000/pic at 700 mapped to virtual irq 17
Jan 1 01:00:05 E106926 user.info kernel: WDT driver for MPC8xxx initialized. mode:reset timeout=65535 (13 seconds)
Jan 1 01:00:05 E106926 user.info kernel: Freescale PowerQUICC MII Bus: probed
Jan 1 01:00:05 E106926 user.info kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher
Jan 1 01:00:05 E106926 user.warn kernel: Registering mini_fo version $Id$
Jan 1 01:00:05 E106926 user.info kernel: JFFS2 version 2.2. (NAND) © 2001-2006 Red Hat, Inc.
Jan 1 01:00:05 E106926 user.info kernel: msgmni has been set to 246
Jan 1 01:00:05 E106926 user.info kernel: alg: No test for lzma (lzma-generic)
Jan 1 01:00:05 E106926 user.info kernel: alg: No test for stdrng (krng)
Jan 1 01:00:05 E106926 user.info kernel: io scheduler noop registered
Jan 1 01:00:05 E106926 user.info kernel: io scheduler anticipatory registered (default)
Jan 1 01:00:05 E106926 user.info kernel: io scheduler deadline registered
Jan 1 01:00:05 E106926 user.info kernel: io scheduler cfq registered
Jan 1 01:00:05 E106926 user.info kernel: pci_hotplug: PCI Hot Plug PCI Core version: 0.5
Jan 1 01:00:05 E106926 user.info kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled
Jan 1 01:00:05 E106926 user.info kernel: serial8250.0: ttyS0 at MMIO 0xe0004500 (irq = 16) is a 16550A
Jan 1 01:00:05 E106926 user.info kernel: console handover: boot [udbg0] -> real [ttyS0]
Jan 1 01:00:05 E106926 user.info kernel: serial8250.0: ttyS1 at MMIO 0xe0004600 (irq = 17) is a 16550A
Jan 1 01:00:05 E106926 user.info kernel: brd: module loaded
Jan 1 01:00:05 E106926 user.info kernel: loop: module loaded
Jan 1 01:00:05 E106926 user.warn kernel: Driver 'sd' needs updating - please use bus_type methods
Jan 1 01:00:05 E106926 user.debug kernel: irq: irq 32 on host /soc8349 at e0000000/pic at 700 mapped to virtual irq 32
Jan 1 01:00:05 E106926 user.debug kernel: irq: irq 33 on host /soc8349 at e0000000/pic at 700 mapped to virtual irq 33
Jan 1 01:00:05 E106926 user.debug kernel: irq: irq 34 on host /soc8349 at e0000000/pic at 700 mapped to virtual irq 34
Jan 1 01:00:05 E106926 user.info kernel: eth0: Gianfar Ethernet Controller Version 1.2, 00:1e:63:00:00:27
Jan 1 01:00:05 E106926 user.info kernel: eth0: Running with NAPI enabled
Jan 1 01:00:05 E106926 user.info kernel: eth0: 256/256 RX/TX BD ring size
Jan 1 01:00:05 E106926 user.debug kernel: irq: irq 35 on host /soc8349 at e0000000/pic at 700 mapped to virtual irq 35
Jan 1 01:00:05 E106926 user.debug kernel: irq: irq 36 on host /soc8349 at e0000000/pic at 700 mapped to virtual irq 36
Jan 1 01:00:05 E106926 user.debug kernel: irq: irq 37 on host /soc8349 at e0000000/pic at 700 mapped to virtual irq 37
Jan 1 01:00:05 E106926 user.info kernel: eth1: Gianfar Ethernet Controller Version 1.2, 00:1e:63:00:00:26
Jan 1 01:00:05 E106926 user.info kernel: eth1: Running with NAPI enabled
Jan 1 01:00:05 E106926 user.info kernel: eth1: 256/256 RX/TX BD ring size
Jan 1 01:00:05 E106926 user.err kernel: Error: Driver 'Marvell 88E1118' is already registered, aborting...
Jan 1 01:00:05 E106926 user.err kernel: Marvell 88E1118: Error -17 in registering driver
Jan 1 01:00:05 E106926 user.warn kernel: UIO: Starting MPC834x GPIO driver
Jan 1 01:00:05 E106926 user.info kernel: fe000000.flash: Found 1 x16 devices at 0x0 in 16-bit bank
Jan 1 01:00:05 E106926 user.warn kernel: Amd/Fujitsu Extended Query Table at 0x0040
Jan 1 01:00:05 E106926 user.warn kernel: fe000000.flash: CFI does not contain boot bank location. Assuming top.
Jan 1 01:00:05 E106926 user.notice kernel: number of CFI chips: 1
Jan 1 01:00:05 E106926 user.notice kernel: cfi_cmdset_0002: Disabling erase-suspend-program due to code brokenness.
Jan 1 01:00:05 E106926 user.notice kernel: cmdlinepart partition parsing not available
Jan 1 01:00:05 E106926 user.notice kernel: RedBoot partition parsing not available
Jan 1 01:00:05 E106926 user.notice kernel: Creating 5 MTD partitions on "fe000000.flash":
Jan 1 01:00:05 E106926 user.notice kernel: 0x000000000000-0x000000060000 : "loader"
Jan 1 01:00:05 E106926 user.notice kernel: 0x000000060000-0x000000080000 : "loader_cfg"
Jan 1 01:00:05 E106926 user.notice kernel: 0x000000080000-0x0000000a0000 : "dtb"
Jan 1 01:00:05 E106926 user.notice kernel: 0x0000000a0000-0x0000002a0000 : "kernel"
Jan 1 01:00:05 E106926 user.notice kernel: 0x0000002a0000-0x000002000000 : "rootfs"
Jan 1 01:00:05 E106926 user.notice kernel: mtd: partition "rootfs" set to be root filesystem
Jan 1 01:00:05 E106926 user.info kernel: mtd: partition "rootfs_data" created automatically, ofs=4C0000, len=1B40000
Jan 1 01:00:05 E106926 user.notice kernel: 0x0000004c0000-0x000002000000 : "rootfs_data"
Jan 1 01:00:05 E106926 user.debug kernel: irq: irq 16 on host /soc8349 at e0000000/pic at 700 mapped to virtual irq 18
Jan 1 01:00:05 E106926 user.info kernel: e0007000.spi: MPC83xx SPI Controller driver at 0x890f8000 (irq = 18)
Jan 1 01:00:05 E106926 user.info kernel: ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
Jan 1 01:00:05 E106926 user.info kernel: fsl-ehci fsl-ehci.0: Freescale On-Chip EHCI Host Controller
Jan 1 01:00:05 E106926 user.info kernel: fsl-ehci fsl-ehci.0: new USB bus registered, assigned bus number 1
Jan 1 01:00:05 E106926 user.info kernel: fsl-ehci fsl-ehci.0: irq 38, io base 0xe0023000
Jan 1 01:00:05 E106926 user.info kernel: fsl-ehci fsl-ehci.0: USB 2.0 started, EHCI 1.00
Jan 1 01:00:05 E106926 user.info kernel: usb usb1: configuration #1 chosen from 1 choice
Jan 1 01:00:05 E106926 user.info kernel: hub 1-0:1.0: USB hub found
Jan 1 01:00:05 E106926 user.info kernel: hub 1-0:1.0: 1 port detected
Jan 1 01:00:05 E106926 user.info kernel: ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
Jan 1 01:00:05 E106926 user.info kernel: uhci_hcd: USB Universal Host Controller Interface driver
Jan 1 01:00:05 E106926 user.info kernel: Initializing USB Mass Storage driver...
Jan 1 01:00:05 E106926 user.info kernel: usbcore: registered new interface driver usb-storage
Jan 1 01:00:05 E106926 user.info kernel: USB Mass Storage support registered.
Jan 1 01:00:05 E106926 user.info kernel: i2c /dev entries driver
Jan 1 01:00:05 E106926 user.debug kernel: irq: irq 14 on host /soc8349 at e0000000/pic at 700 mapped to virtual irq 19
Jan 1 01:00:05 E106926 user.debug kernel: irq: irq 15 on host /soc8349 at e0000000/pic at 700 mapped to virtual irq 20
Jan 1 01:00:05 E106926 user.info kernel: TCP cubic registered
Jan 1 01:00:05 E106926 user.info kernel: NET: Registered protocol family 17
Jan 1 01:00:05 E106926 user.info kernel: RPC: Registered udp transport module.
Jan 1 01:00:05 E106926 user.info kernel: RPC: Registered tcp transport module.
Jan 1 01:00:05 E106926 user.warn kernel: VFS: Mounted root (squashfs filesystem) readonly on device 31:4.
Jan 1 01:00:05 E106926 user.warn kernel: Freeing unused kernel memory: 168k init
Jan 1 01:00:05 E106926 user.warn kernel: Please be patient, while OpenWrt loads ...
Jan 1 01:00:05 E106926 user.info kernel: mini_fo: using base directory: /
Jan 1 01:00:05 E106926 user.info kernel: mini_fo: using storage directory: /jffs
Jan 1 01:00:05 E106926 user.info sysinit: udhcpc (v1.13.4) started
Jan 1 01:00:05 E106926 user.info sysinit: Sending discover...
Jan 1 01:00:07 E106926 user.info sysinit: Firmware upgrate daemon starting...
Jan 1 01:00:07 E106926 user.info sysinit: SVN revision: 1810
Jan 1 01:00:07 E106926 user.info sysinit: Process is now running as a daemon
Jan 1 01:00:07 E106926 user.info sysinit: /tmp/upgrade successfully created
Jan 1 01:00:07 E106926 user.info sysinit: Working directory successfully changed to /tmp/upgrade
Jan 1 01:00:07 E106926 user.info kernel: PHY: mdio at e0024520:01 - Link is Up - 1000/Full
Jan 1 01:00:07 E106926 user.info sysinit: Stream socket (3) successfully created
Jan 1 01:00:07 E106926 user.info sysinit: Stream socket (4) successfully created
Jan 1 01:00:07 E106926 user.info sysinit: Server socket options successfully set
Jan 1 01:00:07 E106926 user.info sysinit: Bind() was successful
Jan 1 01:00:07 E106926 user.info sysinit: Listen on port 50003 was successful
Jan 1 01:00:07 E106926 user.info sysinit: Datagram socket (5) successfully created
Jan 1 01:00:07 E106926 user.info sysinit: Server socket options successfully set
Jan 1 01:00:07 E106926 user.info sysinit: Bind() was successful
Jan 1 01:00:07 E106926 user.info sysinit: BindToDevice (eth0) was successful
Jan 1 01:00:07 E106926 user.info sysinit: Datagram socket (6) successfully created
Jan 1 01:00:07 E106926 user.info sysinit: Server socket options successfully set
Jan 1 01:00:07 E106926 user.info sysinit: Bind() was successful
Jan 1 01:00:07 E106926 user.info sysinit: BindToDevice (eth1) was successful
Jan 1 01:00:07 E106926 user.info sysinit: recv() FAILED: Transport endpoint is not connected
Jan 1 01:00:07 E106926 user.info sysinit: Socket (3) successfully closed
Jan 1 01:00:07 E106926 user.info kernel: PHY: mdio at e0024520:02 - Link is Up - 1000/Full
Jan 1 01:00:08 E106926 daemon.info avahi-daemon[855]: Found user 'nobody' (UID 65534) and group 'nogroup' (GID 65534).
Jan 1 01:00:08 E106926 daemon.info avahi-daemon[855]: Successfully dropped root privileges.
Jan 1 01:00:08 E106926 daemon.info avahi-daemon[855]: avahi-daemon 0.6.25 starting up.
Jan 1 01:00:08 E106926 daemon.warn avahi-daemon[855]: WARNING: No NSS support for mDNS detected, consider installing nss-mdns!
Jan 1 01:00:08 E106926 daemon.info avahi-daemon[855]: Loading service file /etc/avahi/services/http.service.
Jan 1 01:00:08 E106926 daemon.info avahi-daemon[855]: Loading service file /etc/avahi/services/ssh.service.
Jan 1 01:00:08 E106926 daemon.info avahi-daemon[855]: Loading service file /etc/avahi/services/xnp-sysconfig.service.
Jan 1 01:00:08 E106926 daemon.info avahi-daemon[855]: Joining mDNS multicast group on interface eth1.IPv4 with address 10.10.52.195.
Jan 1 01:00:08 E106926 daemon.info avahi-daemon[855]: New relevant interface eth1.IPv4 for mDNS.
Jan 1 01:00:08 E106926 daemon.info avahi-daemon[855]: Network interface enumeration completed.
Jan 1 01:00:08 E106926 daemon.info avahi-daemon[855]: Registering new address record for 10.10.52.195 on eth1.IPv4.
Jan 1 01:00:08 E106926 daemon.info avahi-daemon[855]: Registering HINFO record with values 'PPC'/'LINUX'.
Jan 1 01:00:08 E106926 authpriv.info dropbear[865]: Running in background
Oct 1 09:35:52 E106926 daemon.notice ntpdate[882]: step time server 10.10.2.110 offset 1254382543.344729 sec
Oct 1 09:35:52 E106926 daemon.info avahi-daemon[855]: Server startup complete. Host name is E106926.local. Local service cookie is 3422980960.
Oct 1 09:35:52 E106926 user.info sysinit: Sending discover...
Oct 1 09:35:52 E106926 user.info sysinit: Sending select for 10.10.21.103...
Oct 1 09:35:52 E106926 user.info sysinit: Lease of 10.10.21.103 obtained, lease time 432000
Oct 1 09:35:52 E106926 daemon.notice ntpd[884]: ntpd 4.2.4p7 at 1.1607 Wed Sep 30 10:35:54 UTC 2009 (1)
Oct 1 09:35:52 E106926 daemon.info ntpd[892]: precision = 0.751 usec
Oct 1 09:35:52 E106926 daemon.debug ntpd[892]: ntp_io: estimated max descriptors: 1024, initial socket boundary: 16
Oct 1 09:35:52 E106926 daemon.info ntpd[892]: Listening on interface #0 wildcard, 0.0.0.0#123 Disabled
Oct 1 09:35:52 E106926 daemon.info ntpd[892]: Listening on interface #1 lo, 127.0.0.1#123 Enabled
Oct 1 09:35:52 E106926 daemon.info ntpd[892]: Listening on interface #2 eth1, 10.10.52.195#123 Enabled
Oct 1 09:35:52 E106926 daemon.info ntpd[892]: kernel time sync status 0040
Oct 1 09:35:52 E106926 user.info sysinit: udhcpc: ifconfig eth0 10.10.21.103 netmask 255.255.0.0 broadcast +
Oct 1 09:35:52 E106926 daemon.info avahi-daemon[855]: Joining mDNS multicast group on interface eth0.IPv4 with address 10.10.21.103.
Oct 1 09:35:52 E106926 daemon.info avahi-daemon[855]: New relevant interface eth0.IPv4 for mDNS.
Oct 1 09:35:52 E106926 daemon.info avahi-daemon[855]: Registering new address record for 10.10.21.103 on eth0.IPv4.
Oct 1 09:35:52 E106926 daemon.info avahi-daemon[855]: Withdrawing address record for 10.10.21.103 on eth0.
Oct 1 09:35:52 E106926 daemon.info avahi-daemon[855]: Leaving mDNS multicast group on interface eth0.IPv4 with address 10.10.21.103.
Oct 1 09:35:52 E106926 daemon.info avahi-daemon[855]: Interface eth0.IPv4 no longer relevant for mDNS.
Oct 1 09:35:52 E106926 daemon.info avahi-daemon[855]: Joining mDNS multicast group on interface eth0.IPv4 with address 10.10.21.103.
Oct 1 09:35:52 E106926 daemon.info avahi-daemon[855]: New relevant interface eth0.IPv4 for mDNS.
Oct 1 09:35:52 E106926 daemon.info avahi-daemon[855]: Registering new address record for 10.10.21.103 on eth0.IPv4.
Oct 1 09:35:52 E106926 user.info sysinit: udhcpc: setting default routers: 10.10.1.254
Oct 1 09:35:52 E106926 user.info sysinit: watchdog: WDIOC_SETTIMEOUT: Inappropriate ioctl for device
Oct 1 09:35:52 E106926 user.info sysinit: udhcpc: setting dns servers: 10.10.2.100 10.10.2.101
Oct 1 09:35:52 E106926 user.info sysinit: sysctl: error: 'net.netfilter.nf_conntrack_checksum' is an unknown key
Oct 1 09:35:52 E106926 user.info sysinit: sysctl: error: 'net.ipv4.netfilter.ip_conntrack_checksum' is an unknown key
Oct 1 09:35:52 E106926 user.info sysinit: sysctl: error: 'net.ipv4.netfilter.ip_conntrack_max' is an unknown key
Oct 1 09:35:52 E106926 user.info sysinit: sysctl: error: 'net.ipv4.netfilter.ip_conntrack_tcp_timeout_established' is an unknown key
Oct 1 09:35:52 E106926 user.info sysinit: sysctl: error: 'net.ipv4.netfilter.ip_conntrack_udp_timeout' is an unknown key
Oct 1 09:35:52 E106926 user.info sysinit: sysctl: error: 'net.ipv4.netfilter.ip_conntrack_udp_timeout_stream' is an unknown key
Oct 1 09:35:53 E106926 daemon.info ntpd[892]: Listening on interface #3 eth0, 10.10.21.103#123 Enabled
Oct 1 09:35:53 E106926 daemon.debug ntpd[892]: new interface(s) found: waking up resolver
Oct 1 09:35:59 E106926 daemon.info ntpd[892]: synchronized to 10.10.2.110, stratum 5
Oct 1 09:35:59 E106926 daemon.notice ntpd[892]: kernel time sync status change 0001
Oct 1 09:36:00 E106926 daemon.info init: starting pid 673, tty '/dev/ttyS0': '/bin/ash --login'
Oct 1 09:36:49 E106926 authpriv.info dropbear[912]: Child connection from 10.10.21.231:2279
Oct 1 09:36:51 E106926 authpriv.notice dropbear[912]: password auth succeeded for 'root' from 10.10.21.231:2279
#########################################################################################
Here is a log of the boot with eth0 set-up with DHCP and eth1 using a static IP address, showing the problem:
root at E106926:~# logread
Jan 1 01:00:05 E106926 user.debug kernel: High memory: 0k
Jan 1 01:00:05 E106926 user.info kernel: Memory: 126164k/131072k available (3272k kernel code, 4744k reserved, 160k data, 110k bss, 168k init)
Jan 1 01:00:05 E106926 user.info kernel: Kernel virtual memory layout:
Jan 1 01:00:05 E106926 user.info kernel: * 0xfffef000..0xfffff000 : fixmap
Jan 1 01:00:05 E106926 user.info kernel: * 0xff800000..0xffc00000 : highmem PTEs
Jan 1 01:00:05 E106926 user.info kernel: * 0xfe7fa000..0xff800000 : early ioremap
Jan 1 01:00:05 E106926 user.info kernel: * 0x89000000..0xfe7fa000 : vmalloc & ioremap
Jan 1 01:00:05 E106926 user.info kernel: SLUB: Genslabs=13, HWalign=32, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
Jan 1 01:00:05 E106926 user.info kernel: Calibrating delay loop... 164.86 BogoMIPS (lpj=329728)
Jan 1 01:00:05 E106926 user.warn kernel: Mount-cache hash table entries: 512
Jan 1 01:00:05 E106926 user.info kernel: net_namespace: 324 bytes
Jan 1 01:00:05 E106926 user.info kernel: NET: Registered protocol family 16
Jan 1 01:00:05 E106926 user.debug kernel: irq: irq 38 on host /soc8349 at e0000000/pic at 700 mapped to virtual irq 38
Jan 1 01:00:05 E106926 user.info kernel: PCI: Probing PCI hardware
Jan 1 01:00:05 E106926 user.debug kernel: pci 0000:00:00.0: reg 10 32bit mmio: [0x000000-0x0fffff]
Jan 1 01:00:05 E106926 user.debug kernel: pci 0000:00:00.0: reg 18 64bit mmio: [0x000000-0x3fffffff]
Jan 1 01:00:05 E106926 user.debug kernel: pci_bus 0000:00: resource 0 io: [0x00-0xffffff]
Jan 1 01:00:05 E106926 user.debug kernel: pci_bus 0000:00: resource 1 pref mem [0x80000000-0x8fffffff]
Jan 1 01:00:05 E106926 user.debug kernel: pci_bus 0000:00: resource 2 mem: [0x90000000-0x9fffffff]
Jan 1 01:00:05 E106926 user.debug kernel: Registering ipic with sysfs...
Jan 1 01:00:05 E106926 user.warn kernel: bio: create slab <bio-0> at 0
Jan 1 01:00:05 E106926 user.notice kernel: SCSI subsystem initialized
Jan 1 01:00:05 E106926 user.info kernel: usbcore: registered new interface driver usbfs
Jan 1 01:00:05 E106926 user.info kernel: usbcore: registered new interface driver hub
Jan 1 01:00:05 E106926 user.info kernel: usbcore: registered new device driver usb
Jan 1 01:00:05 E106926 user.info kernel: NET: Registered protocol family 2
Jan 1 01:00:05 E106926 user.debug kernel: Switched to high resolution mode on CPU 0
Jan 1 01:00:05 E106926 user.info kernel: IP route cache hash table entries: 1024 (order: 0, 4096 bytes)
Jan 1 01:00:05 E106926 user.info kernel: TCP established hash table entries: 4096 (order: 3, 32768 bytes)
Jan 1 01:00:05 E106926 user.info kernel: TCP bind hash table entries: 4096 (order: 2, 16384 bytes)
Jan 1 01:00:05 E106926 user.info kernel: TCP: Hash tables configured (established 4096 bind 4096)
Jan 1 01:00:05 E106926 user.info kernel: TCP reno registered
Jan 1 01:00:05 E106926 user.info kernel: NET: Registered protocol family 1
Jan 1 01:00:05 E106926 user.debug kernel: irq: irq 9 on host /soc8349 at e0000000/pic at 700 mapped to virtual irq 16
Jan 1 01:00:05 E106926 user.debug kernel: irq: irq 10 on host /soc8349 at e0000000/pic at 700 mapped to virtual irq 17
Jan 1 01:00:05 E106926 user.info kernel: WDT driver for MPC8xxx initialized. mode:reset timeout=65535 (13 seconds)
Jan 1 01:00:05 E106926 user.info kernel: Freescale PowerQUICC MII Bus: probed
Jan 1 01:00:05 E106926 user.info kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher
Jan 1 01:00:05 E106926 user.warn kernel: Registering mini_fo version $Id$
Jan 1 01:00:05 E106926 user.info kernel: JFFS2 version 2.2. (NAND) © 2001-2006 Red Hat, Inc.
Jan 1 01:00:05 E106926 user.info kernel: msgmni has been set to 246
Jan 1 01:00:05 E106926 user.info kernel: alg: No test for lzma (lzma-generic)
Jan 1 01:00:05 E106926 user.info kernel: alg: No test for stdrng (krng)
Jan 1 01:00:05 E106926 user.info kernel: io scheduler noop registered
Jan 1 01:00:05 E106926 user.info kernel: io scheduler anticipatory registered (default)
Jan 1 01:00:05 E106926 user.info kernel: io scheduler deadline registered
Jan 1 01:00:05 E106926 user.info kernel: io scheduler cfq registered
Jan 1 01:00:05 E106926 user.info kernel: pci_hotplug: PCI Hot Plug PCI Core version: 0.5
Jan 1 01:00:05 E106926 user.info kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled
Jan 1 01:00:05 E106926 user.info kernel: serial8250.0: ttyS0 at MMIO 0xe0004500 (irq = 16) is a 16550A
Jan 1 01:00:05 E106926 user.info kernel: console handover: boot [udbg0] -> real [ttyS0]
Jan 1 01:00:05 E106926 user.info kernel: serial8250.0: ttyS1 at MMIO 0xe0004600 (irq = 17) is a 16550A
Jan 1 01:00:05 E106926 user.info kernel: brd: module loaded
Jan 1 01:00:05 E106926 user.info kernel: loop: module loaded
Jan 1 01:00:05 E106926 user.warn kernel: Driver 'sd' needs updating - please use bus_type methods
Jan 1 01:00:05 E106926 user.debug kernel: irq: irq 32 on host /soc8349 at e0000000/pic at 700 mapped to virtual irq 32
Jan 1 01:00:05 E106926 user.debug kernel: irq: irq 33 on host /soc8349 at e0000000/pic at 700 mapped to virtual irq 33
Jan 1 01:00:05 E106926 user.debug kernel: irq: irq 34 on host /soc8349 at e0000000/pic at 700 mapped to virtual irq 34
Jan 1 01:00:05 E106926 user.info kernel: eth0: Gianfar Ethernet Controller Version 1.2, 00:1e:63:00:00:27
Jan 1 01:00:05 E106926 user.info kernel: eth0: Running with NAPI enabled
Jan 1 01:00:05 E106926 user.info kernel: eth0: 256/256 RX/TX BD ring size
Jan 1 01:00:05 E106926 user.debug kernel: irq: irq 35 on host /soc8349 at e0000000/pic at 700 mapped to virtual irq 35
Jan 1 01:00:05 E106926 user.debug kernel: irq: irq 36 on host /soc8349 at e0000000/pic at 700 mapped to virtual irq 36
Jan 1 01:00:05 E106926 user.debug kernel: irq: irq 37 on host /soc8349 at e0000000/pic at 700 mapped to virtual irq 37
Jan 1 01:00:05 E106926 user.info kernel: eth1: Gianfar Ethernet Controller Version 1.2, 00:1e:63:00:00:26
Jan 1 01:00:05 E106926 user.info kernel: eth1: Running with NAPI enabled
Jan 1 01:00:05 E106926 user.info kernel: eth1: 256/256 RX/TX BD ring size
Jan 1 01:00:05 E106926 user.err kernel: Error: Driver 'Marvell 88E1118' is already registered, aborting...
Jan 1 01:00:05 E106926 user.err kernel: Marvell 88E1118: Error -17 in registering driver
Jan 1 01:00:05 E106926 user.warn kernel: UIO: Starting MPC834x GPIO driver
Jan 1 01:00:05 E106926 user.info kernel: fe000000.flash: Found 1 x16 devices at 0x0 in 16-bit bank
Jan 1 01:00:05 E106926 user.warn kernel: Amd/Fujitsu Extended Query Table at 0x0040
Jan 1 01:00:05 E106926 user.warn kernel: fe000000.flash: CFI does not contain boot bank location. Assuming top.
Jan 1 01:00:05 E106926 user.notice kernel: number of CFI chips: 1
Jan 1 01:00:05 E106926 user.notice kernel: cfi_cmdset_0002: Disabling erase-suspend-program due to code brokenness.
Jan 1 01:00:05 E106926 user.notice kernel: cmdlinepart partition parsing not available
Jan 1 01:00:05 E106926 user.notice kernel: RedBoot partition parsing not available
Jan 1 01:00:05 E106926 user.notice kernel: Creating 5 MTD partitions on "fe000000.flash":
Jan 1 01:00:05 E106926 user.notice kernel: 0x000000000000-0x000000060000 : "loader"
Jan 1 01:00:05 E106926 user.notice kernel: 0x000000060000-0x000000080000 : "loader_cfg"
Jan 1 01:00:05 E106926 user.notice kernel: 0x000000080000-0x0000000a0000 : "dtb"
Jan 1 01:00:05 E106926 user.notice kernel: 0x0000000a0000-0x0000002a0000 : "kernel"
Jan 1 01:00:05 E106926 user.notice kernel: 0x0000002a0000-0x000002000000 : "rootfs"
Jan 1 01:00:05 E106926 user.notice kernel: mtd: partition "rootfs" set to be root filesystem
Jan 1 01:00:05 E106926 user.info kernel: mtd: partition "rootfs_data" created automatically, ofs=4C0000, len=1B40000
Jan 1 01:00:05 E106926 user.notice kernel: 0x0000004c0000-0x000002000000 : "rootfs_data"
Jan 1 01:00:05 E106926 user.debug kernel: irq: irq 16 on host /soc8349 at e0000000/pic at 700 mapped to virtual irq 18
Jan 1 01:00:05 E106926 user.info kernel: e0007000.spi: MPC83xx SPI Controller driver at 0x890f8000 (irq = 18)
Jan 1 01:00:05 E106926 user.info kernel: ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
Jan 1 01:00:05 E106926 user.info kernel: fsl-ehci fsl-ehci.0: Freescale On-Chip EHCI Host Controller
Jan 1 01:00:05 E106926 user.info kernel: fsl-ehci fsl-ehci.0: new USB bus registered, assigned bus number 1
Jan 1 01:00:05 E106926 user.info kernel: fsl-ehci fsl-ehci.0: irq 38, io base 0xe0023000
Jan 1 01:00:05 E106926 user.info kernel: fsl-ehci fsl-ehci.0: USB 2.0 started, EHCI 1.00
Jan 1 01:00:05 E106926 user.info kernel: usb usb1: configuration #1 chosen from 1 choice
Jan 1 01:00:05 E106926 user.info kernel: hub 1-0:1.0: USB hub found
Jan 1 01:00:05 E106926 user.info kernel: hub 1-0:1.0: 1 port detected
Jan 1 01:00:05 E106926 user.info kernel: ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
Jan 1 01:00:05 E106926 user.info kernel: uhci_hcd: USB Universal Host Controller Interface driver
Jan 1 01:00:05 E106926 user.info kernel: Initializing USB Mass Storage driver...
Jan 1 01:00:05 E106926 user.info kernel: usbcore: registered new interface driver usb-storage
Jan 1 01:00:05 E106926 user.info kernel: USB Mass Storage support registered.
Jan 1 01:00:05 E106926 user.info kernel: i2c /dev entries driver
Jan 1 01:00:05 E106926 user.debug kernel: irq: irq 14 on host /soc8349 at e0000000/pic at 700 mapped to virtual irq 19
Jan 1 01:00:05 E106926 user.debug kernel: irq: irq 15 on host /soc8349 at e0000000/pic at 700 mapped to virtual irq 20
Jan 1 01:00:05 E106926 user.info kernel: TCP cubic registered
Jan 1 01:00:05 E106926 user.info kernel: NET: Registered protocol family 17
Jan 1 01:00:05 E106926 user.info kernel: RPC: Registered udp transport module.
Jan 1 01:00:05 E106926 user.info kernel: RPC: Registered tcp transport module.
Jan 1 01:00:05 E106926 user.warn kernel: VFS: Mounted root (squashfs filesystem) readonly on device 31:4.
Jan 1 01:00:05 E106926 user.warn kernel: Freeing unused kernel memory: 168k init
Jan 1 01:00:05 E106926 user.warn kernel: Please be patient, while OpenWrt loads ...
Jan 1 01:00:05 E106926 user.info kernel: mini_fo: using base directory: /
Jan 1 01:00:05 E106926 user.info kernel: mini_fo: using storage directory: /jffs
Jan 1 01:00:05 E106926 user.info sysinit: udhcpc (v1.13.4) started
Jan 1 01:00:05 E106926 user.info sysinit: Sending discover...
Jan 1 01:00:07 E106926 user.info sysinit: Firmware upgrate daemon starting...
Jan 1 01:00:07 E106926 user.info sysinit: SVN revision: 1810
Jan 1 01:00:07 E106926 user.info sysinit: Process is now running as a daemon
Jan 1 01:00:07 E106926 user.info sysinit: /tmp/upgrade successfully created
Jan 1 01:00:07 E106926 user.info sysinit: Working directory successfully changed to /tmp/upgrade
Jan 1 01:00:07 E106926 user.info sysinit: Stream socket (3) successfully created
Jan 1 01:00:07 E106926 user.info sysinit: Stream socket (4) successfully created
Jan 1 01:00:07 E106926 user.info sysinit: Server socket options successfully set
Jan 1 01:00:07 E106926 user.info sysinit: Bind() was successful
Jan 1 01:00:07 E106926 user.info sysinit: Listen on port 50003 was successful
Jan 1 01:00:07 E106926 user.info sysinit: Datagram socket (5) successfully created
Jan 1 01:00:07 E106926 user.info sysinit: Server socket options successfully set
Jan 1 01:00:07 E106926 user.info sysinit: Bind() was successful
Jan 1 01:00:07 E106926 user.info sysinit: BindToDevice (eth0) was successful
Jan 1 01:00:07 E106926 user.info sysinit: Datagram socket (6) successfully created
Jan 1 01:00:07 E106926 user.info sysinit: Server socket options successfully set
Jan 1 01:00:07 E106926 user.info sysinit: Bind() was successful
Jan 1 01:00:07 E106926 user.info sysinit: BindToDevice (eth1) was successful
Jan 1 01:00:07 E106926 user.info sysinit: recv() FAILED: Transport endpoint is not connected
Jan 1 01:00:07 E106926 user.info sysinit: Socket (3) successfully closed
Jan 1 01:00:07 E106926 user.info kernel: PHY: mdio at e0024520:02 - Link is Up - 1000/Full
Jan 1 01:00:08 E106926 daemon.info avahi-daemon[855]: Found user 'nobody' (UID 65534) and group 'nogroup' (GID 65534).
Jan 1 01:00:08 E106926 daemon.info avahi-daemon[855]: Successfully dropped root privileges.
Jan 1 01:00:08 E106926 daemon.info avahi-daemon[855]: avahi-daemon 0.6.23 starting up.
Jan 1 01:00:08 E106926 daemon.warn avahi-daemon[855]: WARNING: No NSS support for mDNS detected, consider installing nss-mdns!
Jan 1 01:00:08 E106926 daemon.info avahi-daemon[855]: Loading service file /etc/avahi/services/http.service.
Jan 1 01:00:08 E106926 daemon.info avahi-daemon[855]: Loading service file /etc/avahi/services/ssh.service.
Jan 1 01:00:08 E106926 daemon.info avahi-daemon[855]: Loading service file /etc/avahi/services/xnp-sysconfig.service.
Jan 1 01:00:08 E106926 daemon.info avahi-daemon[855]: Joining mDNS multicast group on interface eth1.IPv4 with address 10.10.52.195.
Jan 1 01:00:08 E106926 daemon.info avahi-daemon[855]: New relevant interface eth1.IPv4 for mDNS.
Jan 1 01:00:08 E106926 daemon.info avahi-daemon[855]: Network interface enumeration completed.
Jan 1 01:00:08 E106926 daemon.info avahi-daemon[855]: Registering new address record for 10.10.52.195 on eth1.IPv4.
Jan 1 01:00:08 E106926 daemon.info avahi-daemon[855]: Registering HINFO record with values 'PPC'/'LINUX'.
Jan 1 01:00:08 E106926 authpriv.info dropbear[865]: Running in background
Oct 1 08:51:11 E106926 daemon.notice ntpdate[882]: step time server 10.10.2.110 offset 1254379862.219600 sec
Oct 1 08:51:11 E106926 daemon.info avahi-daemon[855]: Server startup complete. Host name is E106926.local. Local service cookie is 3706581384.
Oct 1 08:51:11 E106926 user.info sysinit: Sending discover...
Oct 1 08:51:11 E106926 daemon.notice ntpd[884]: ntpd 4.2.4p7 at 1.1607 Wed Sep 30 10:35:54 UTC 2009 (1)
Oct 1 08:51:11 E106926 daemon.info ntpd[886]: precision = 0.751 usec
Oct 1 08:51:11 E106926 daemon.debug ntpd[886]: ntp_io: estimated max descriptors: 1024, initial socket boundary: 16
Oct 1 08:51:11 E106926 daemon.info ntpd[886]: Listening on interface #0 wildcard, 0.0.0.0#123 Disabled
Oct 1 08:51:11 E106926 daemon.info ntpd[886]: Listening on interface #1 lo, 127.0.0.1#123 Enabled
Oct 1 08:51:11 E106926 daemon.info ntpd[886]: Listening on interface #2 eth1, 10.10.52.195#123 Enabled
Oct 1 08:51:11 E106926 daemon.info ntpd[886]: kernel time sync status 0040
Oct 1 08:51:11 E106926 user.info sysinit: watchdog: WDIOC_SETTIMEOUT: Inappropriate ioctl for device
Oct 1 08:51:11 E106926 user.info sysinit: sysctl: error: 'net.netfilter.nf_conntrack_checksum' is an unknown key
Oct 1 08:51:11 E106926 user.info sysinit: sysctl: error: 'net.ipv4.netfilter.ip_conntrack_checksum' is an unknown key
Oct 1 08:51:11 E106926 user.info sysinit: sysctl: error: 'net.ipv4.netfilter.ip_conntrack_max' is an unknown key
Oct 1 08:51:11 E106926 user.info sysinit: sysctl: error: 'net.ipv4.netfilter.ip_conntrack_tcp_timeout_established' is an unknown key
Oct 1 08:51:11 E106926 user.info sysinit: sysctl: error: 'net.ipv4.netfilter.ip_conntrack_udp_timeout' is an unknown key
Oct 1 08:51:11 E106926 user.info sysinit: sysctl: error: 'net.ipv4.netfilter.ip_conntrack_udp_timeout_stream' is an unknown key
Oct 1 08:51:11 E106926 daemon.info avahi-daemon[855]: Service "VM XMC16 [E106926]" (/etc/avahi/services/xnp-sysconfig.service) successfully established.
Oct 1 08:51:11 E106926 daemon.info avahi-daemon[855]: Service "Secure Shell on E106926" (/etc/avahi/services/ssh.service) successfully established.
Oct 1 08:51:11 E106926 daemon.info avahi-daemon[855]: Service "Web Server on E106926" (/etc/avahi/services/http.service) successfully established.
Oct 1 08:51:14 E106926 user.info sysinit: Sending discover...
Oct 1 08:51:18 E106926 daemon.info ntpd[886]: synchronized to 10.10.2.110, stratum 5
Oct 1 08:51:18 E106926 daemon.notice ntpd[886]: kernel time sync status change 0001
Oct 1 08:52:18 E106926 daemon.info init: starting pid 673, tty '/dev/ttyS0': '/bin/ash --login'
Oct 1 08:52:32 E106926 authpriv.info dropbear[898]: Child connection from 10.10.21.231:1806
Oct 1 08:52:34 E106926 authpriv.notice dropbear[898]: password auth succeeded for 'root' from 10.10.21.231:1806
root at E106926:~#
More information about the avahi
mailing list