| View previous topic :: View next topic |
| Author |
Message |
slackline
Veteran
Joined: 01 Apr 2005
Posts: 1475
Location: /uk/sheffield
|
 Posted: Mon Mar 31, 2008 7:25 pm Post subject: |
 |
|
| orvtech wrote: | | haven anyone manage to get metalog working on the NSLU2, i get the daemon started but it does not log anything, no errors, nothing ... syslog-ng was uninstalled during last week emerge -uDvN world since it was not suported any more (that version). |
Metalog seems to be working properly here, at least now (see paste below)
Could anyone suggest what might be the cause of the problem with this....
On rebooting it only gets to user space boot and hangs with a flashing amber light. I have to pull the power then and reboot to slugOS-4.8. The log-file (metalog saving everything, see below) shows that the module for the network device is being bought up fine (lines 136, 143 and 144), but then for some reason the init script doesn't start (lines 146 and 147) as a consequence no sshd (line 147) is started and udhcpcd doesn't get an IP address as it complains about the interface not being ready (see line 150).
| /var/log/everything/current/ from failed NSLU2 boot from gentoo on external USB drive: |
1. Mar 31 18:40:52 [kernel] Linux version 2.6.21.7 (slug@otto) (gcc version 4.1.2) #1 PREEMPT Mon Dec 24 23:12:24 UTC 2007
2. Mar 31 18:40:53 [kernel] CPU: XScale-IXP42x Family [690541f2] revision 2 (ARMv5TE), cr=000039ff
3. Mar 31 18:40:53 [kernel] Machine: Linksys NSLU2
4. Mar 31 18:40:53 [kernel] Memory policy: ECC disabled, Data cache writeback
5. Mar 31 18:40:53 [kernel] On node 0 totalpages: 8192
6. Mar 31 18:40:53 [kernel] DMA zone: 64 pages used for memmap
7. Mar 31 18:40:53 [kernel] DMA zone: 0 pages reserved
8. Mar 31 18:40:53 [kernel] DMA zone: 8128 pages, LIFO batch:0
9. Mar 31 18:40:53 [kernel] Normal zone: 0 pages used for memmap
10. Mar 31 18:40:53 [kernel] CPU0: D VIVT undefined 5 cache
11. Mar 31 18:40:53 [kernel] CPU0: I cache: 32768 bytes, associativity 32, 32 byte lines, 32 sets
12. Mar 31 18:40:53 [kernel] CPU0: D cache: 32768 bytes, associativity 32, 32 byte lines, 32 sets
13. Mar 31 18:40:53 [kernel] Built 1 zonelists. Total pages: 8128
14. Mar 31 18:40:53 [kernel] Kernel command line: rtc-x1205.probe=0,0x6f console=ttyS0,115200n8 root=/dev/mtdblock4 rootfstype=jffs2 rw init=/linuxrc noirqdebug
15. Mar 31 18:40:53 [kernel] IRQ lockup detection disabled
16. Mar 31 18:40:53 [kernel] PID hash table entries: 128 (order: 7, 512 bytes)
17. Mar 31 18:40:53 [kernel] Dentry cache hash table entries: 4096 (order: 2, 16384 bytes)
18. Mar 31 18:40:53 [kernel] Inode-cache hash table entries: 2048 (order: 1, 8192 bytes)
19. Mar 31 18:40:53 [kernel] Memory: 32MB = 32MB total
20. Mar 31 18:40:53 [kernel] Memory: 30292KB available (1912K code, 153K data, 84K init)
21. Mar 31 18:40:53 [kernel] Calibrating delay loop... 266.24 BogoMIPS (lpj=1331200)
22. Mar 31 18:40:53 [kernel] Mount-cache hash table entries: 512
23. Mar 31 18:40:53 [kernel] CPU: Testing write buffer coherency: ok
24. Mar 31 18:40:53 [kernel] NET: Registered protocol family 16
25. Mar 31 18:40:53 [kernel] IXP4xx: Using 16MiB expansion bus window size
26. Mar 31 18:40:53 [kernel] PCI: IXP4xx is host
27. Mar 31 18:40:53 [kernel] PCI: IXP4xx Using direct access for memory space
28. Mar 31 18:40:53 [kernel] PCI: bus0: Fast back to back transfers disabled
29. Mar 31 18:40:53 [kernel] dmabounce: registered device 0000:00:01.0 on pci bus
30. Mar 31 18:40:53 [kernel] dmabounce: registered device 0000:00:01.1 on pci bus
31. Mar 31 18:40:53 [kernel] dmabounce: registered device 0000:00:01.2 on pci bus
32. Mar 31 18:40:53 [kernel] SCSI subsystem initialized
33. Mar 31 18:40:53 [kernel] usbcore: registered new interface driver usbfs
34. Mar 31 18:40:53 [kernel] usbcore: registered new interface driver hub
35. Mar 31 18:40:53 [kernel] usbcore: registered new device driver usb
36. Mar 31 18:40:53 [kernel] Time: OSTS clocksource has been installed.
37. Mar 31 18:40:53 [kernel] NET: Registered protocol family 2
38. Mar 31 18:40:53 [kernel] IP route cache hash table entries: 1024 (order: 0, 4096 bytes)
39. Mar 31 18:40:53 [kernel] TCP established hash table entries: 1024 (order: 1, 8192 bytes)
40. Mar 31 18:40:53 [kernel] TCP bind hash table entries: 1024 (order: 0, 4096 bytes)
41. Mar 31 18:40:53 [kernel] TCP: Hash tables configured (established 1024 bind 1024)
42. Mar 31 18:40:53 [kernel] TCP reno registered
43. Mar 31 18:40:53 [kernel] NetWinder Floating Point Emulator V0.97 (double precision)
44. Mar 31 18:40:53 [kernel] JFFS2 version 2.2. (NAND) (C) 2001-2006 Red Hat, Inc.
45. Mar 31 18:40:53 [kernel] io scheduler noop registered
46. Mar 31 18:40:53 [kernel] io scheduler deadline registered (default)
47. Mar 31 18:40:53 [kernel] Serial: 8250/16550 driver $Revision: 1.90 $ 2 ports, IRQ sharing disabled
48. Mar 31 18:40:53 [kernel] serial8250.0: ttyS0 at MMIO 0xc8000000 (irq = 15) is a XScale
49. Mar 31 18:40:53 [kernel] serial8250.0: ttyS1 at MMIO 0xc8001000 (irq = 13) is a XScale
50. Mar 31 18:40:53 [kernel] RAMDISK driver initialized: 4 RAM disks of 10240K size 1024 blocksize
51. Mar 31 18:40:53 [kernel] IXP4XX NPE driver Version 0.3.0 initialized
52. Mar 31 18:40:53 [kernel] NFTL driver: nftlcore.c $Revision: 1.98 $, nftlmount.c $Revision: 1.41 $
53. Mar 31 18:40:53 [kernel] IXP4XX-Flash.0: Found 1 x16 devices at 0x0 in 16-bit bank
54. Mar 31 18:40:53 [kernel] IXP4XX-Flash.0: Found an alias at 0x800000 for the chip at 0x0
55. Mar 31 18:40:53 [kernel] Intel/Sharp Extended Query Table at 0x0031
56. Mar 31 18:40:53 [kernel] Using buffer write method
57. Mar 31 18:40:53 [kernel] cfi_cmdset_0001: Erase suspend on write enabled
58. Mar 31 18:40:53 [kernel] erase region 0: offset=0x0,size=0x20000,blocks=64
59. Mar 31 18:40:53 [kernel] Searching for RedBoot partition table in IXP4XX-Flash.0 at offset 0x7e0000
60. Mar 31 18:40:53 [kernel] 6 RedBoot partitions found on MTD device IXP4XX-Flash.0
61. Mar 31 18:40:53 [kernel] Creating 6 MTD partitions on "IXP4XX-Flash.0":
62. Mar 31 18:40:53 [kernel] 0x00000000-0x00040000 : "RedBoot"
63. Mar 31 18:40:53 [kernel] nslu2 mac: 00:1d:7e:aa:c6:d5
64. Mar 31 18:40:53 [kernel] 0x00040000-0x00060000 : "SysConf"
65. Mar 31 18:40:53 [kernel] 0x00060000-0x00080000 : "Loader"
66. Mar 31 18:40:53 [kernel] 0x00080000-0x00180000 : "Kernel"
67. Mar 31 18:40:53 [kernel] 0x00180000-0x007e0000 : "Flashdisk"
68. Mar 31 18:40:53 [kernel] 0x007e0000-0x00800000 : "FIS directory"
69. Mar 31 18:40:53 [kernel] npe: searching for firmware...
70. Mar 31 18:40:53 [kernel] npe: found at 0x1c010, IXP425/NPE-B func: 00, rev: 2.1, size: 11964, id: 01000201
71. Mar 31 18:40:53 [kernel] Image loaded to NPE-B Func:0, Rel: 2:1, Status: 82c00000
72. Mar 31 18:40:53 [kernel] Initializing USB Mass Storage driver...
73. Mar 31 18:40:53 [kernel] usbcore: registered new interface driver usb-storage
74. Mar 31 18:40:53 [kernel] USB Mass Storage support registered.
75. Mar 31 18:40:53 [kernel] input: ixp4xx beeper as /class/input/input0
76. Mar 31 18:40:53 [kernel] i2c /dev entries driver
77. Mar 31 18:40:53 [kernel] x1205 0-006f: chip found, driver version 1.0.7
78. Mar 31 18:40:53 [kernel] x1205 0-006f: rtc core: registered x1205 as rtc0
79. Mar 31 18:40:53 [kernel] Registered led device: ready
80. Mar 31 18:40:53 [kernel] Registered led device: status
81. Mar 31 18:40:53 [kernel] Registered led device: disk-1
82. Mar 31 18:40:53 [kernel] TCP cubic registered
83. Mar 31 18:40:53 [kernel] NET: Registered protocol family 1
84. Mar 31 18:40:53 [kernel] NET: Registered protocol family 17
85. Mar 31 18:40:53 [kernel] XScale DSP coprocessor detected.
86. Mar 31 18:40:53 [kernel] x1205 0-006f: setting the system clock to 2008-03-31 18:40:11 (1206988811)
87. Mar 31 18:40:53 [kernel] VFS: Mounted root (jffs2 filesystem).
88. Mar 31 18:40:53 [kernel] Freeing init memory: 84K
89. Mar 31 18:40:53 [kernel] PCI: enabling device 0000:00:01.2 (0140 -> 0142)
90. Mar 31 18:40:53 [kernel] ehci_hcd 0000:00:01.2: EHCI Host Controller
91. Mar 31 18:40:53 [kernel] ehci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1
92. Mar 31 18:40:53 [kernel] ehci_hcd 0000:00:01.2: irq 26, io mem 0x48002000
93. Mar 31 18:40:53 [kernel] ehci_hcd 0000:00:01.2: USB 2.0 started, EHCI 1.00, driver 10 Dec 2004
94. Mar 31 18:40:53 [kernel] usb usb1: configuration #1 chosen from 1 choice
95. Mar 31 18:40:53 [kernel] hub 1-0:1.0: USB hub found
96. Mar 31 18:40:53 [kernel] hub 1-0:1.0: 5 ports detected
97. Mar 31 18:40:53 [kernel] ohci_hcd: 2006 August 04 USB 1.1 'Open' Host Controller (OHCI) Driver
98. Mar 31 18:40:53 [kernel] PCI: enabling device 0000:00:01.0 (0140 -> 0142)
99. Mar 31 18:40:53 [kernel] ohci_hcd 0000:00:01.0: OHCI Host Controller
100. Mar 31 18:40:53 [kernel] ohci_hcd 0000:00:01.0: new USB bus registered, assigned bus number 2
101. Mar 31 18:40:53 [kernel] ohci_hcd 0000:00:01.0: irq 28, io mem 0x48000000
102. Mar 31 18:40:53 [kernel] usb usb2: configuration #1 chosen from 1 choice
103. Mar 31 18:40:53 [kernel] hub 2-0:1.0: USB hub found
104. Mar 31 18:40:53 [kernel] hub 2-0:1.0: 3 ports detected
105. Mar 31 18:40:53 [kernel] PCI: enabling device 0000:00:01.1 (0140 -> 0142)
106. Mar 31 18:40:53 [kernel] ohci_hcd 0000:00:01.1: OHCI Host Controller
107. Mar 31 18:40:53 [kernel] usb 1-1: new high speed USB device using ehci_hcd and address 2
108. Mar 31 18:40:53 [kernel] ohci_hcd 0000:00:01.1: new USB bus registered, assigned bus number 3
109. Mar 31 18:40:53 [kernel] ohci_hcd 0000:00:01.1: irq 27, io mem 0x48001000
110. Mar 31 18:40:53 [kernel] usb usb3: configuration #1 chosen from 1 choice
111. Mar 31 18:40:53 [kernel] hub 3-0:1.0: USB hub found
112. Mar 31 18:40:53 [kernel] hub 3-0:1.0: 2 ports detected
113. Mar 31 18:40:53 [kernel] usb 1-1: configuration #1 chosen from 1 choice
114. Mar 31 18:40:53 [kernel] scsi0 : SCSI emulation for USB Mass Storage devices
115. Mar 31 18:40:53 [kernel] usb-storage: device found at 2
116. Mar 31 18:40:53 [kernel] usb-storage: waiting for device to settle before scanning
117. Mar 31 18:40:53 [kernel] scsi 0:0:0:0: Direct-Access WDC WD2500JB-00GVC0 08.0 PQ: 0 ANSI: 2
118. Mar 31 18:40:53 [kernel] SCSI device sda: 488397168 512-byte hdwr sectors (250059 MB)
119. Mar 31 18:40:53 [kernel] sda: Write Protect is off
120. Mar 31 18:40:53 [kernel] sda: Mode Sense: 53 00 00 08
121. Mar 31 18:40:53 [kernel] sda: assuming drive cache: write through
122. Mar 31 18:40:53 [kernel] SCSI device sda: 488397168 512-byte hdwr sectors (250059 MB)
123. Mar 31 18:40:53 [kernel] sda: Write Protect is off
124. Mar 31 18:40:53 [kernel] sda: Mode Sense: 53 00 00 08
125. Mar 31 18:40:53 [kernel] sda: assuming drive cache: write through
126. Mar 31 18:40:53 [kernel] sda: sda1 sda2 sda3 sda4 < sda5 sda6 sda7 >
127. Mar 31 18:40:53 [kernel] sd 0:0:0:0: Attached scsi disk sda
128. Mar 31 18:40:53 [kernel] usb-storage: device scan complete
129. Mar 31 18:40:53 [kernel] kjournald starting. Commit interval 5 seconds
130. Mar 31 18:40:53 [kernel] EXT3 FS on sda3, internal journal
131. Mar 31 18:40:53 [kernel] ext3_orphan_cleanup: deleting unreferenced inode 487776
132. Mar 31 18:40:53 [kernel] EXT3-fs: sda3: 1 orphan inode deleted
133. Mar 31 18:40:53 [kernel] EXT3-fs: recovery complete.
134. Mar 31 18:40:53 [kernel] EXT3-fs: mounted filesystem with ordered data mode.
135. Mar 31 18:40:53 [kernel] IXP4XX Q Manager 0.2.1 initialized.
136. Mar 31 18:40:53 [kernel] ixp4xx_mac driver 0.3.1: eth0 on NPE-B with PHY[1] initialized
137. Mar 31 18:40:53 [kernel] EXT3 FS on sda3, internal journal
138. Mar 31 18:40:53 [kernel] Adding 498004k swap on /dev/sda2. Priority:-1 extents:1 across:498004k
139. Mar 31 18:40:55 [rc-scripts] Error loading key mappings
140. Mar 31 18:40:57 [rc-scripts] Failed to set user font
141. Mar 31 18:41:06 [init] Entering runlevel: 3
142. Mar 31 18:41:19 [rc-scripts] Failed to set user font
143. Mar 31 18:41:26 [kernel] eth0: link up, 100Mbps, full-duplex, lpa 0x45E1
144. Mar 31 18:41:26 [kernel] Link of eth0 is full-duplex
145. Mar 31 18:41:27 [rc-scripts] No loaded modules provide "udhcp" (udhcp_start)
146. Mar 31 18:41:29 [rc-scripts] ERROR: cannot start netmount as net.eth0 could not start
147. Mar 31 18:41:31 [rc-scripts] ERROR: cannot start sshd as net.eth0 could not start
148. Mar 31 18:41:33 [udhcpd] udhcpd (v0.9.9-pre) started
149. Mar 31 18:41:33 [udhcpd] max_leases value (254) not sane, setting to 234 instead
150. Mar 31 18:41:33 [udhcpd] SIOCGIFADDR failed, is the interface up and configured?: Cannot assign requested address
151. Mar 31 18:41:34 [cron] (CRON) STARTUP (V5.0)
152. Mar 31 18:41:36 [rc-scripts] Failed to start local
153. Mar 31 18:41:37 [init] no more processes left in this runlevel
|
Is there any special configuration required for /etc/udhcpd.conf ? Mine's currently the default.
Feel soo close now!
Cheers,
slack
_________________
"Science is what we understand well enough to explain to a computer. Art is everything else we do." - Donald Knuth |
|
| Back to top |
|
 |
slackline
Veteran
Joined: 01 Apr 2005
Posts: 1475
Location: /uk/sheffield
|
| Posted: Wed Apr 02, 2008 9:59 am Post subject: |
|
|
Okay, I'm pretty sure udhcpc isn't configured properly.
I played around with /etc/conf.d/net a bit and now have the following reported by metalog...
| Code: |
Apr 2 07:11:31 [rc-scripts] Error loading key mappings
Apr 2 07:11:33 [rc-scripts] Failed to set user font
Apr 2 07:11:43 [init] Entering runlevel: 3
Apr 2 07:11:57 [rc-scripts] Failed to set user font
Apr 2 07:12:06 [kernel] eth0: link up, 100Mbps, full-duplex, lpa 0x45E1
Apr 2 07:12:06 [kernel] Link of eth0 is full-duplex
Apr 2 07:12:07 [rc-scripts] Configuration not set for eth0 - assuming DHCP
Apr 2 07:12:07 [udhcpc] udhcpc (v0.9.9-pre) started
Apr 2 07:12:07 [udhcpc] Sending discover...
- Last output repeated 2 times -
Apr 2 07:12:15 [udhcpc] No lease, failing.
Apr 2 07:12:18 [rc-scripts] ERROR: cannot start netmount as net.eth0 could not start
Apr 2 07:12:19 [rc-scripts] ERROR: cannot start sshd as net.eth0 could not start
Apr 2 07:12:21 [udhcpd] udhcpd (v0.9.9-pre) started
Apr 2 07:12:21 [udhcpd] SIOCGIFADDR failed, is the interface up and configured?: Cannot assign requested address
Apr 2 07:12:23 [cron] (CRON) STARTUP (V5.0)
Apr 2 07:12:25 [rc-scripts] Failed to start local
Apr 2 07:12:25 [init] no more processes left in this runlevel
Apr 2 07:20:01 [cron] (root) CMD (test -x /usr/sbin/run-crons && /usr/sbin/run-crons )
|
I don't think I have my /etc/conf.d/net set up correctly because of the error at 07:12:07, and the fact that udhcpc fails to get a lease and SIOCCGIFADDR fails.
| /etc/conf.d/net: |
preup() {
/sbin/ifconfig eth0 hw ether "$(/bin/grep '^hw_addr=' /initrd/etc/default/sysconf | /usr/bin/cut -d '-'-f 2)"
return 0
}
modules_eth0=( "udhcpc" )
|
The preup() stuff is to sort out the MAC address as per the the wiki, whilst the modules_eth0 line is as per the Discussion page on the wiki.
I've had a read of HowTo : Get DHCP Working but it seems geared towards the SlugOS install.
From what I can gather the NSLU2 doesn't like having the IP address set to 0.0.0.0. Under the chrooted Gentoo install this occurs in the following scripts...
| grep '0\.0' /usr/share/udhcpc/default.*: |
$ grep '0\.0' *
default.bound: while /sbin/route del default gw 0.0.0.0 dev $interface
default.deconfig:/sbin/ifconfig $interface 0.0.0.0
default.renew: while /sbin/route del default gw 0.0.0.0 dev $interface
|
So, I could change this to the IP address the NSLU2 is statically assigned by my router. However, I don't think I need to change all of them, as I think I need to configure udhcpc to call certain scripts in /etc/conf.d/net but I'm not sure which ones and in which order.
Any advice would be most appreciated. (Example configs even better  )
Cheers,
slack
_________________
"Science is what we understand well enough to explain to a computer. Art is everything else we do." - Donald Knuth |
|
| Back to top |
|
|
slackline
Veteran
Joined: 01 Apr 2005
Posts: 1475
Location: /uk/sheffield
|
| Posted: Wed Apr 02, 2008 5:39 pm Post subject: |
|
|
Joy of joys 
I've finally got it working
The "trick" was to not bother with the preup() stuff mentioned in the Wiki.
Found the answer in this thread and a better description on the NSLU2 wiki (basically SlugOS etc. now handle the MAC address better/correctly).
I'm sooo happy now, all up and running and 750Gb network storage
Just need to setup up NFS and a few other things and I'll be like five Mancunians in a filing cabinet............SORTED!!!!
_________________
"Science is what we understand well enough to explain to a computer. Art is everything else we do." - Donald Knuth |
|
| Back to top |
|
|
|
|
You cannot post new topics in this forum
You cannot reply to topics in this forum
You cannot edit your posts in this forum
You cannot delete your posts in this forum
You cannot vote in polls in this forum
|
|
Gentoo on Alternative Architectures
