[Date Prev][Date Next] [Thread Prev][Thread Next] [Date Index] [Thread Index]

Re: ARM kernel snapshots - 2.6.27-rc3



Hi,

Martin Michlmayr schrieb:
> They are completely untested.  Try only if you have a serial
> console.
> 
> You can find the kernel packages at
> http://people.debian.org/~tbm/armel/kernel/r12055/

It worked fine on my lenny slug, except for one strangeness: After the
very first reboot, it was unresponsive over the network. I thought it
had had trouble booting, so I attached rs232 and hit the power button.
Now I know that was a mistake, because then I could see it cleanly shut
down through the serial console and boot up again. That time, it started
to echo reply in the expected moment. The syslog gave me no hints -- the
network interface was up, according to that.

Trying to investigate that strangeness, I rebooted it several times, and
also cold booted it a few times, being able to reproduce this only one
more time, again at rebooting. This time again I found no clues in
syslog. I found that the echo reply eventually did work, but at an
unusually long delay:

(klappi is my notebook, and it has etch with iputils-ping.)

kevin@klappi:~$ ping 192.168.190.77
PING 192.168.190.77 (192.168.190.77) 56(84) bytes of data.
From 192.168.190.2 icmp_seq=20 Destination Host Unreachable
From 192.168.190.2 icmp_seq=21 Destination Host Unreachable
From 192.168.190.2 icmp_seq=22 Destination Host Unreachable
From 192.168.190.2 icmp_seq=24 Destination Host Unreachable
From 192.168.190.2 icmp_seq=25 Destination Host Unreachable
From 192.168.190.2 icmp_seq=26 Destination Host Unreachable
From 192.168.190.2 icmp_seq=27 Destination Host Unreachable
From 192.168.190.2 icmp_seq=28 Destination Host Unreachable
From 192.168.190.2 icmp_seq=29 Destination Host Unreachable
64 bytes from 192.168.190.77: icmp_seq=1 ttl=64 time=29912 ms
64 bytes from 192.168.190.77: icmp_seq=2 ttl=64 time=28905 ms
64 bytes from 192.168.190.77: icmp_seq=3 ttl=64 time=27903 ms
64 bytes from 192.168.190.77: icmp_seq=4 ttl=64 time=26896 ms
64 bytes from 192.168.190.77: icmp_seq=5 ttl=64 time=25897 ms
64 bytes from 192.168.190.77: icmp_seq=6 ttl=64 time=24899 ms
64 bytes from 192.168.190.77: icmp_seq=7 ttl=64 time=23900 ms
64 bytes from 192.168.190.77: icmp_seq=8 ttl=64 time=22901 ms
64 bytes from 192.168.190.77: icmp_seq=9 ttl=64 time=21902 ms
64 bytes from 192.168.190.77: icmp_seq=10 ttl=64 time=20903 ms
64 bytes from 192.168.190.77: icmp_seq=11 ttl=64 time=19904 ms
64 bytes from 192.168.190.77: icmp_seq=12 ttl=64 time=18905 ms
64 bytes from 192.168.190.77: icmp_seq=13 ttl=64 time=17906 ms
64 bytes from 192.168.190.77: icmp_seq=14 ttl=64 time=16908 ms
64 bytes from 192.168.190.77: icmp_seq=15 ttl=64 time=15909 ms
64 bytes from 192.168.190.77: icmp_seq=16 ttl=64 time=14912 ms
64 bytes from 192.168.190.77: icmp_seq=17 ttl=64 time=13914 ms
64 bytes from 192.168.190.77: icmp_seq=18 ttl=64 time=12916 ms
64 bytes from 192.168.190.77: icmp_seq=30 ttl=64 time=909 ms
64 bytes from 192.168.190.77: icmp_seq=31 ttl=64 time=2.33 ms


--- 192.168.190.77 ping statistics ---
49 packets transmitted, 20 received, +9 errors, 59% packet loss, time
48060ms
rtt min/avg/max/mdev = 2.339/19310.674/29912.959/7982.047 ms, pipe 30

This whole behavior hadn't happened to me before, so I tend to blame the
new rc3 kernel. I cannot really tell if rc2 is also affected, because I
tested it only quickly. On the other hand, this might have to to with
the notebook's network connection, which is wireless. But wireless
problems should /drop/ ping packets, not delay them for half a minute.

Somehow this left me with some question marks. If you have any good
ideas, I'll do some more debugging later tonight or tomorrow.

cheers
-- 
Kevin Price
http://www.kevin-price.de/
+Ethernet eth0: MAC address 00:14:bf:65:db:3d
IP: 192.168.0.1/255.255.255.0, Gateway: 192.168.0.1
Default server: 0.0.0.0, DNS server IP: 0.0.0.0

RedBoot(tm) bootstrap and debug environment [ROMRAM]
Red Hat certified release, version 1.92 - built 15:16:07, Feb  3 2004

Platform: IXDP425 Development Platform (XScale) 
Copyright (C) 2000, 2001, 2002, Red Hat, Inc.

RAM: 0x00000000-0x02000000, 0x000723a0-0x01ff3000 available
FLASH: 0x50000000 - 0x50800000, 64 blocks of 0x00020000 bytes each.
== Executing boot script in 2.000 seconds - enter ^C to abort
RedBoot> boot;exec 0x01d00000
have eRcOmM 

copy kernel code from flash to RAM
copy ramdisk file from flash to RAM
run kernel 

Using base address 0x01d00000 and length 0x0000a664


APEX Boot Loader 1.4.15.2 -- Copyright (c) 2004,2005,2006,2007 Marc Singer

APEX comes with ABSOLUTELY NO WARRANTY.  It is free software and you
are welcome to redistribute it under certain circumstances.
For details, refer to the file COPYING in the program source.

  apex => mem:0x00200000+0xa654   (42580 bytes)
  env  => nor:0x7c000+15k         (empty)

Use the command 'help help' to get started.


# copy -s $kernelsrc $bootaddr
# copy -s fis://kernel 0x00008000

|
/
-
\
|
/
-
\
|
1441760 bytes transferred

# copy -s $ramdisksrc $ramdiskaddr
# copy -s fis://ramdisk 0x01000000

/
-
\
|
/
-
\
|
/
-
\
|
/
-
\
|
/
-
\
|
/
-
\
|
/
-
\
|
/
-
\
|
/
6291440 bytes transferred

# wait 10 Type ^C key to cancel autoboot.
Type ^C key to cancel autoboot. 

-
\
|
/
-
\
|
/
# boot
ATAG_HEADER
ATAG_MEM: start 0x00000000  size 0x02000000
ATAG_CMDLINE: (55 bytes) 'console=ttyS0,115200 rtc-x1205.probe=0,0x6f noirqdebug'
ATAG_INITRD2: start 0x01000000  size 0x005ffff0
ATAG_END
Booting kernel at 0x00008000...
Uncompressing Linux.............................................................................................. done, booting the kernel.
[    0.000000] Initializing cgroup subsys cpu
[    0.000000] Linux version 2.6.27-rc3-ixp4xx (Debian 2.6.27~rc3-1~experimental.1) (maks@debian.org) (gcc version 4.1.3 20080420 (prerelease) (Debian 4.1.2-22)) #1 Wed Aug 13 08:43:03 UTC 2008
[    0.000000] CPU: XScale-IXP42x Family [690541f1] revision 1 (ARMv5TE), cr=0000397f
[    0.000000] Machine: Linksys NSLU2
[    0.000000] Memory policy: ECC disabled, Data cache writeback
[    0.000000] CPU0: D VIVT undefined 5 cache
[    0.000000] CPU0: I cache: 32768 bytes, associativity 32, 32 byte lines, 32 sets
[    0.000000] CPU0: D cache: 32768 bytes, associativity 32, 32 byte lines, 32 sets
[    0.000000] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 8128
[    0.000000] Kernel command line: console=ttyS0,115200 rtc-x1205.probe=0,0x6f noirqdebug
[    0.000000] Unknown boot option `rtc-x1205.probe=0,0x6f': ignoring
[    0.000000] IRQ lockup detection disabled
[    0.000000] PID hash table entries: 128 (order: 7, 512 bytes)
[42949372.960000] Console: colour dummy device 80x30
[42949372.960000] Dentry cache hash table entries: 4096 (order: 2, 16384 bytes)
[42949372.960000] Inode-cache hash table entries: 2048 (order: 1, 8192 bytes)
[42949372.960000] Memory: 32MB = 32MB total
[42949372.960000] Memory: 23244KB available (2648K code, 287K data, 116K init)
[42949372.960000] Calibrating delay loop... 266.24 BogoMIPS (lpj=1331200)
[42949373.200000] Security Framework initialized
[42949373.200000] SELinux:  Disabled at boot.
[42949373.200000] Mount-cache hash table entries: 512
[42949373.200000] Initializing cgroup subsys ns
[42949373.200000] Initializing cgroup subsys cpuacct
[42949373.200000] Initializing cgroup subsys devices
[42949373.200000] CPU: Testing write buffer coherency: ok
[42949373.200000] net_namespace: 832 bytes
[42949373.200000] NET: Registered protocol family 16
[42949373.210000] IXP4xx: Using 16MiB expansion bus window size
[42949373.210000] NSLU2: Using MAC address 00:14:bf:65:db:3d for port 0
[42949373.210000] PCI: IXP4xx is host
[42949373.210000] PCI: IXP4xx Using direct access for memory space
[42949373.210000] pci 0000:00:01.0: PME# supported from D0 D1 D2 D3hot
[42949373.210000] pci 0000:00:01.0: PME# disabled
[42949373.210000] pci 0000:00:01.1: PME# supported from D0 D1 D2 D3hot
[42949373.210000] pci 0000:00:01.1: PME# disabled
[42949373.210000] pci 0000:00:01.2: PME# supported from D0 D1 D2 D3hot
[42949373.210000] pci 0000:00:01.2: PME# disabled
[42949373.210000] PCI: bus0: Fast back to back transfers disabled
[42949373.210000] pci 0000:00:01.0: dmabounce: registered device
[42949373.220000] pci 0000:00:01.1: dmabounce: registered device
[42949373.220000] pci 0000:00:01.2: dmabounce: registered device
[42949373.250000] NET: Registered protocol family 2
[42949373.340000] IP route cache hash table entries: 1024 (order: 0, 4096 bytes)
[42949373.340000] TCP established hash table entries: 1024 (order: 1, 8192 bytes)
[42949373.340000] TCP bind hash table entries: 1024 (order: 0, 4096 bytes)
[42949373.340000] TCP: Hash tables configured (established 1024 bind 1024)
[42949373.340000] TCP reno registered
[42949373.370000] NET: Registered protocol family 1
[42949373.370000] checking if image is initramfs... it is
[42949377.140000] Freeing initrd memory: 6143K
[42949377.140000] NetWinder Floating Point Emulator V0.97 (double precision)
[42949377.150000] audit: initializing netlink socket (disabled)
[42949377.150000] type=2000 audit(4.190:1): initialized
[42949377.150000] VFS: Disk quotas dquot_6.5.1
[42949377.150000] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[42949377.150000] JFFS2 version 2.2. (NAND) (SUMMARY)  © 2001-2006 Red Hat, Inc.
[42949377.150000] msgmni has been set to 57
[42949377.150000] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 253)
[42949377.150000] io scheduler noop registered
[42949377.150000] io scheduler anticipatory registered
[42949377.150000] io scheduler deadline registered
[42949377.150000] io scheduler cfq registered (default)
[42949377.200000] Serial: 8250/16550 driver2 ports, IRQ sharing disabled
[42949377.200000] serial8250.0: ttyS0 at MMIO 0xc8000000 (irq = 15) is a XScale
[42949377.200000] console [ttyS0] enabled
[42949377.580000] serial8250.0: ttyS1 at MMIO 0xc8001000 (irq = 13) is a XScale
[42949377.620000] brd: module loaded
[42949377.620000] IXP4XX-Flash.0: Found 1 x16 devices at 0x0 in 16-bit bank
[42949377.630000]  Intel/Sharp Extended Query Table at 0x0031
[42949377.640000] Using buffer write method
[42949377.640000] cfi_cmdset_0001: Erase suspend on write enabled
[42949377.650000] Searching for RedBoot partition table in IXP4XX-Flash.0 at offset 0x7e0000
[42949377.750000] 6 RedBoot partitions found on MTD device IXP4XX-Flash.0
[42949377.750000] Creating 6 MTD partitions on "IXP4XX-Flash.0":
[42949377.760000] 0x00000000-0x00040000 : "RedBoot"
[42949377.770000] 0x00040000-0x00060000 : "SysConf"
[42949377.780000] 0x00060000-0x00080000 : "Loader"
[42949377.780000] 0x00080000-0x001e0000 : "Kernel"
[42949377.790000] 0x001e0000-0x007e0000 : "Ramdisk"
[42949377.800000] 0x007e0000-0x00800000 : "FIS directory"
[42949377.810000] mice: PS/2 mouse device common for all mice
[42949377.820000] i2c /dev entries driver
[42949377.830000] rtc-x1205 0-006f: chip found, driver version 1.0.8
[42949377.840000] rtc-x1205 0-006f: rtc core: registered rtc-x1205 as rtc0
[42949377.850000] i2c-gpio i2c-gpio.0: using pins 7 (SDA) and 6 (SCL)
[42949377.860000] IXP4xx Watchdog Timer: heartbeat 60 sec
[42949377.870000] Registered led device: nslu2:green:ready
[42949377.880000] Registered led device: nslu2:red:status
[42949377.880000] Registered led device: nslu2:green:disk-1
[42949377.890000] Registered led device: nslu2:green:disk-2
[42949377.900000] NET: Registered protocol family 26
[42949377.910000] TCP cubic registered
[42949377.910000] NET: Registered protocol family 17
[42949377.910000] XScale DSP coprocessor detected.
[42949377.920000] registered taskstats version 1
[42949377.930000] rtc-x1205 0-006f: setting system clock to 2008-08-13 16:40:39 UTC (1218645639)
[42949377.940000] Freeing init memory: 116K
Loading, please wait...
Begin: Loading essential drivers ...
[42949378.730000] SCSI subsystem initialized
[42949378.960000] usbcore: registered new interface driver usbfs
[42949378.970000] usbcore: registered new interface driver hub
[42949378.980000] usbcore: registered new device driver usb
[42949379.050000] Initializing USB Mass Storage driver...
[42949379.050000] usbcore: registered new interface driver usb-storage
[42949379.060000] USB Mass Storage support registered.
[42949379.300000] PCI: enabling device 0000:00:01.2 (0140 -> 0142)
[42949379.310000] ehci_hcd 0000:00:01.2: EHCI Host Controller
[42949379.310000] ehci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1
[42949379.350000] ehci_hcd 0000:00:01.2: irq 26, io mem 0x48002000
[42949379.370000] ehci_hcd 0000:00:01.2: USB 2.0 started, EHCI 1.00, driver 10 Dec 2004
[42949379.370000] usb usb1: configuration #1 chosen from 1 choice
[42949379.380000] hub 1-0:1.0: USB hub found
[42949379.390000] hub 1-0:1.0: 5 ports detected
[42949379.610000] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002
[42949379.620000] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[42949379.620000] usb usb1: Product: EHCI Host Controller
[42949379.630000] usb usb1: Manufacturer: Linux 2.6.27-rc3-ixp4xx ehci_hcd
[42949379.640000] usb usb1: SerialNumber: 0000:00:01.2
Done.
Begin: Running /scripts/init-premount ...
[42949379.760000] usb 1-1: new high speed USB device using ehci_hcd and address 2
[42949379.920000] usb 1-1: configuration #1 chosen from 1 choice
[42949379.950000] scsi0 : SCSI emulation for USB Mass Storage devices
[42949379.990000] usb 1-1: New USB device found, idVendor=04fc, idProduct=0c15
[42949379.990000] usb 1-1: New USB device strings: Mfr=2, Product=3, SerialNumber=1
[42949380.000000] usb 1-1: Product: USB to Serial-ATA bridge
[42949380.010000] usb 1-1: Manufacturer: Sunplus Technology Inc.
[42949380.010000] usb 1-1: SerialNumber: HDT722525D      VDK41BT4D4HTAK
[42949380.140000] usb 1-2: new high speed USB device using ehci_hcd and address 3
[42949380.290000] usb 1-2: configuration #1 chosen from 1 choice
[42949380.300000] scsi1 : SCSI emulation for USB Mass Storage devices
[42949380.310000] usb 1-2: New USB device found, idVendor=1516, idProduct=1603
[42949380.320000] usb 1-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[42949380.330000] usb 1-2: Product: USB_DISK
[42949380.330000] usb 1-2: Manufacturer: USB_DISK
[42949380.340000] usb 1-2: SerialNumber: 0010000000000000000007C1
Done.
Begin: Mounting root file system ...
Begin: Running /scripts/local-top ...
Done.
Begin: Waiting for root file system ...
[42949384.960000] scsi 0:0:0:0: Direct-Access     HDT72252 5DLA380               PQ: 0 ANSI: 2
[42949385.110000] Driver 'sd' needs updating - please use bus_type methods
[42949385.150000] sd 0:0:0:0: [sda] 488397168 512-byte hardware sectors (250059 MB)
[42949385.160000] sd 0:0:0:0: [sda] Write Protect is off
[42949385.160000] sd 0:0:0:0: [sda] Assuming drive cache: write through
[42949385.190000] sd 0:0:0:0: [sda] 488397168 512-byte hardware sectors (250059 MB)
[42949385.200000] sd 0:0:0:0: [sda] Write Protect is off
[42949385.210000] sd 0:0:0:0: [sda] Assuming drive cache: write through
[42949385.220000]  sda: sda1 sda2 sda3
[42949385.240000] sd 0:0:0:0: [sda] Attached SCSI disk
[42949385.340000] scsi 1:0:0:0: Direct-Access     USB_DISK USB_DISK         1.00 PQ: 0 ANSI: 2
[42949385.360000] sd 1:0:0:0: [sdb] 2008064 512-byte hardware sectors (1028 MB)
[42949385.370000] sd 1:0:0:0: [sdb] Write Protect is off
[42949385.380000] sd 1:0:0:0: [sdb] Assuming drive cache: write through
[42949385.420000] sd 1:0:0:0: [sdb] 2008064 512-byte hardware sectors (1028 MB)
[42949385.430000] sd 1:0:0:0: [sdb] Write Protect is off
[42949385.430000] sd 1:0:0:0: [sdb] Assuming drive cache: write through
[42949385.440000]  sdb: sdb4
[42949385.560000] sd 1:0:0:0: [sdb] Attached SCSI removable disk
Done.
Begin: Running /scripts/local-premount ...
Done.
[42949386.870000] kjournald starting.  Commit interval 5 seconds
[42949386.880000] EXT3-fs: mounted filesystem with ordered data mode.
Begin: Running /scripts/local-bottom ...
Done.
Done.
Begin: Running /scripts/init-bottom ...
Done.

INIT: version 2.86 booting

Starting the hotplug events dispatcher: udevd.
Synthesizing the initial hotplug events...done.
Waiting for /dev to be fully populated...[42949399.460000] PCI: enabling device 0000:00:01.0 (0140 -> 0142)
[42949399.470000] ohci_hcd 0000:00:01.0: OHCI Host Controller
[42949399.480000] ohci_hcd 0000:00:01.0: new USB bus registered, assigned bus number 2
[42949399.480000] ohci_hcd 0000:00:01.0: irq 28, io mem 0x48000000
[42949399.720000] usb usb2: configuration #1 chosen from 1 choice
[42949399.720000] hub 2-0:1.0: USB hub found
[42949399.730000] hub 2-0:1.0: 3 ports detected
[42949399.760000] IXP4xx Queue Manager initialized.
[42949399.850000] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001
[42949399.850000] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[42949399.860000] usb usb2: Product: OHCI Host Controller
[42949399.870000] usb usb2: Manufacturer: Linux 2.6.27-rc3-ixp4xx ohci_hcd
[42949399.870000] usb usb2: SerialNumber: 0000:00:01.0
[42949399.880000] PCI: enabling device 0000:00:01.1 (0140 -> 0142)
[42949399.890000] ohci_hcd 0000:00:01.1: OHCI Host Controller
[42949399.890000] ohci_hcd 0000:00:01.1: new USB bus registered, assigned bus number 3
[42949399.900000] ohci_hcd 0000:00:01.1: irq 27, io mem 0x48001000
[42949399.980000] eth0: MII PHY 1 on NPE-B
[42949400.080000] usb usb3: configuration #1 chosen from 1 choice
[42949400.090000] hub 3-0:1.0: USB hub found
[42949400.090000] hub 3-0:1.0: 2 ports detected
[42949400.110000] input: ixp4xx beeper as /class/input/input0
[42949400.240000] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001
[42949400.240000] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[42949400.250000] usb usb3: Product: OHCI Host Controller
[42949400.260000] usb usb3: Manufacturer: Linux 2.6.27-rc3-ixp4xx ohci_hcd
[42949400.260000] usb usb3: SerialNumber: 0000:00:01.1
done.
Setting the system clock.
Activating swap...[42949404.650000] Adding 1003496k swap on /dev/sdb4.  Priority:-1 extents:1 across:1003496k
done.
Checking root file system...fsck 1.41.0 (10-Jul-2008)
/: clean, 43113/515072 files, 279599/1028160 blocks
done.
[42949405.270000] EXT3 FS on sda1, internal journal
Setting the system clock.
Cleaning up ifupdown....
Loading kernel modules...done.
Checking file systems...fsck 1.41.0 (10-Jul-2008)
done.
Setting kernel variables (/etc/sysctl.conf)...Unknown HZ value! (94) Assume 100.
done.
[42949409.140000] fuse init (API version 7.9)
Mounting local filesystems...[42949409.570000] kjournald starting.  Commit interval 5 seconds
[42949409.570000] EXT3-fs warning: maximal mount count reached, running e2fsck is recommended
[42949409.580000] EXT3 FS on sda3, internal journal
[42949409.590000] EXT3-fs: mounted filesystem with ordered data mode.
done.
Activating swapfile swap...done.
Setting up networking....
Configuring network interfaces...[42949411.970000] firmware: requesting NPE-B
[42949412.150000] NPE-B: firmware functionality 0x2, revision 0x2:1
[42949412.150000] eth0: link down
done.
[42949415.160000] eth0: link up, 100Mbps, full-duplex, lpa 0xC5E1

INIT: Entering runlevel: 2

Starting system log daemon....
Starting kernel log daemon....
Starting OpenBSD Secure Shell server: sshd.
Starting SixXS Automatic IPv6 Connectivity Client Utility (aiccu)...No IPv6 Stack found! Please check your kernel and module configuration
 failed!
Loading ip6tables ruleset: load "active".
Loading iptables ruleset: load "active"[42949425.290000] ip_tables: (C) 2000-2006 Netfilter Core Team
[42949426.570000] nf_conntrack version 0.5.0 (1024 buckets, 4096 max)
[42949426.570000] CONFIG_NF_CT_ACCT is deprecated and will be removed soon. Plase use
[42949426.580000] nf_conntrack.acct=1 kernel paramater, acct=1 nf_conntrack module option or
[42949426.590000] sysctl net.netfilter.nf_conntrack_acct=1 to enable it.
.
Not starting internet superserver: no services enabled.
Starting Samba daemons: nmbd smbd.
Setting sysfs variables....
Starting NTP server: ntpd.
Starting periodic command scheduler: crond.
[42949431.660000] warning: `ntpd' uses 32-bit capabilities (legacy support in use)

Debian GNU/Linux lenny/sid LKG65DB3D ttyS0

LKG65DB3D login: 

Attachment: signature.asc
Description: OpenPGP digital signature


Reply to: