Bug#602568: squeeze-di-beta1 installer: partman hang
Package: installation-reports
Boot method: disk2go PURE II USB stick
Image version:
http://cdimage.debian.org/cdimage/squeeze_di_beta1/i386/iso-cd/debian-squeeze-di-beta1-i386-businesscard.iso
Date: 06 nov 2010
Machine: Asus EeePC 1015PE
Processor: Intel Atom N450
Memory: 2GB
Partitions:
Disk /dev/sda: 250.1 GB, 250059350016 bytes
255 heads, 63 sectors/track, 30401 cylinders
Units = cylinders of 16065 * 512 = 8225280 bytes
Sector size (logical/physical): 512 bytes / 512 bytes
I/O size (minimum/optimal): 512 bytes / 512 bytes
Disk identifier: 0x29133921
Device Boot Start End Blocks Id System
/dev/sda1 1 6632 53267456 7 HPFS/NTFS
/dev/sda2 30399 30402 20664 ef EFI (FAT-12/16/32)
/dev/sda3 * 6632 6697 524288+ 83 Linux
/dev/sda4 6697 30399 190385151+ 5 Extended
/dev/sda5 6697 13224 52428800+ 83 Linux
Partition table entries are not in disk order
Disk /dev/sdb: 5 MB, 5242880 bytes
256 heads, 32 sectors/track, 1 cylinders
Units = cylinders of 8192 * 512 = 4194304 bytes
Sector size (logical/physical): 512 bytes / 512 bytes
I/O size (minimum/optimal): 512 bytes / 512 bytes
Disk identifier: 0x00000000
Device Boot Start End Blocks Id System
/dev/sdb1 1 2 5088 1 FAT12
Partition 1 has different physical/logical endings:
phys=(40, 255, 32) logical=(1, 63, 32)
Disk /dev/sdc: 2142 MB, 2142240768 bytes
66 heads, 62 sectors/track, 1022 cylinders
Units = cylinders of 4092 * 512 = 2095104 bytes
Sector size (logical/physical): 512 bytes / 512 bytes
I/O size (minimum/optimal): 512 bytes / 512 bytes
Disk identifier: 0xbb0eb409
This doesn't look like a partition table
Probably you selected the wrong device.
Device Boot Start End Blocks Id System
/dev/sdc1 ? 842478 1298648 933323145+ 66 Unknown
Partition 1 has different physical/logical beginnings (non-Linux?):
phys=(1010, 16, 43) logical=(842477, 65, 13)
Partition 1 has different physical/logical endings:
phys=(906, 97, 3) logical=(249046, 43, 23)
Partition 1 does not end on cylinder boundary.
/dev/sdc2 ? 1 1 0 72 Unknown
Partition 2 has different physical/logical beginnings (non-Linux?):
phys=(101, 116, 32) logical=(0, 41, 32)
Partition 2 has different physical/logical endings:
phys=(370, 114, 47) logical=(0, 41, 31)
Partition 2 does not end on cylinder boundary.
Partition table entries are not in disk order
Output of lspci -knn (or lspci -nn):
00:00.0 Host bridge [0600]: Intel Corporation N10 Family DMI Bridge
[8086:a010]
Subsystem: ASUSTeK Computer Inc. Device [1043:83ac]
Kernel driver in use: agpgart-intel
00:02.0 VGA compatible controller [0300]: Intel Corporation N10 Family
Integrated Graphics Controller [8086:a011]
Subsystem: ASUSTeK Computer Inc. Device [1043:83ac]
00:02.1 Display controller [0380]: Intel Corporation N10 Family
Integrated Graphics Controller [8086:a012]
Subsystem: ASUSTeK Computer Inc. Device [1043:83ac]
00:1b.0 Audio device [0403]: Intel Corporation N10/ICH 7 Family High
Definition Audio Controller [8086:27d8] (rev 02)
Subsystem: ASUSTeK Computer Inc. Device [1043:841c]
00:1c.0 PCI bridge [0604]: Intel Corporation N10/ICH 7 Family PCI
Express Port 1 [8086:27d0] (rev 02)
Kernel driver in use: pcieport
00:1c.1 PCI bridge [0604]: Intel Corporation N10/ICH 7 Family PCI
Express Port 2 [8086:27d2] (rev 02)
Kernel driver in use: pcieport
00:1c.3 PCI bridge [0604]: Intel Corporation N10/ICH 7 Family PCI
Express Port 4 [8086:27d6] (rev 02)
Kernel driver in use: pcieport
00:1d.0 USB Controller [0c03]: Intel Corporation N10/ICH 7 Family USB
UHCI Controller #1 [8086:27c8] (rev 02)
Subsystem: ASUSTeK Computer Inc. Device [1043:83ad]
Kernel driver in use: uhci_hcd
00:1d.1 USB Controller [0c03]: Intel Corporation N10/ICH 7 Family USB
UHCI Controller #2 [8086:27c9] (rev 02)
Subsystem: ASUSTeK Computer Inc. Device [1043:83ad]
Kernel driver in use: uhci_hcd
00:1d.2 USB Controller [0c03]: Intel Corporation N10/ICH 7 Family USB
UHCI Controller #3 [8086:27ca] (rev 02)
Subsystem: ASUSTeK Computer Inc. Device [1043:83ad]
Kernel driver in use: uhci_hcd
00:1d.3 USB Controller [0c03]: Intel Corporation N10/ICH 7 Family USB
UHCI Controller #4 [8086:27cb] (rev 02)
Subsystem: ASUSTeK Computer Inc. Device [1043:83ad]
Kernel driver in use: uhci_hcd
00:1d.7 USB Controller [0c03]: Intel Corporation N10/ICH 7 Family USB2
EHCI Controller [8086:27cc] (rev 02)
Subsystem: ASUSTeK Computer Inc. Device [1043:83ad]
Kernel driver in use: ehci_hcd
00:1e.0 PCI bridge [0604]: Intel Corporation 82801 Mobile PCI Bridge
[8086:2448] (rev e2)
00:1f.0 ISA bridge [0601]: Intel Corporation NM10 Family LPC Controller
[8086:27bc] (rev 02)
Subsystem: ASUSTeK Computer Inc. Device [1043:83ad]
00:1f.2 SATA controller [0106]: Intel Corporation N10/ICH7 Family SATA
AHCI Controller [8086:27c1] (rev 02)
Subsystem: ASUSTeK Computer Inc. Device [1043:83ad]
Kernel driver in use: ahci
01:00.0 Ethernet controller [0200]: Atheros Communications AR8132 Fast
Ethernet [1969:1062] (rev c0)
Subsystem: ASUSTeK Computer Inc. Device [1043:838a]
Kernel driver in use: atl1c
02:00.0 Network controller [0280]: RaLink RT3090 Wireless 802.11n 1T/1R
PCIe [1814:3090]
Subsystem: Device [1a3b:1087]
Base System Installation Checklist:
[O] = OK, [E] = Error (please elaborate below), [ ] = didn't try it
Initial boot: [O]
Detect network card: [O]
Configure network: [O]
Detect CD: [O]
Load installer modules: [O]
Detect hard drives: [O]
Partition hard drives: [E]
Install base system: [ ]
Clock/timezone setup: [ ]
User/password setup: [ ]
Install tasks: [ ]
Install boot loader: [ ]
Overall install: [ ]
Comments/Problems:
The partition setup show progress until it hang at 50%. The syslog give
this:
Nov 5 22:23:31 main-menu[337]: INFO: Menu item 'partman-base' selected
Nov 5 22:23:31 anna-install: Installing partman-auto-lvm
Nov 5 22:23:31 anna[5759]: DEBUG: resolver (cdebconf-udeb): package
doesn't exist (ignored)
Nov 5 22:23:31 anna[5759]: DEBUG: resolver (di-utils): package doesn't
exist (ignored)
Nov 5 22:23:31 anna[5759]: DEBUG: resolver
(kernel-image-2.6.32-5-486-di): package doesn't exist (ignored)
Nov 5 22:23:31 anna[5759]: DEBUG: resolver
(core-modules-2.6.32-5-486-di): package doesn't exist (ignored)
Nov 5 22:23:31 anna[5759]: DEBUG: resolver (fat-modules): package
doesn't exist (ignored)
Nov 5 22:23:31 anna[5759]: DEBUG: resolver (libdebian-installer4-udeb):
package doesn't exist (ignored)
Nov 5 22:23:31 anna[5759]: DEBUG: resolver (archdetect): package
doesn't exist (ignored)
Nov 5 22:23:31 anna[5759]: DEBUG: resolver (hw-detect): package doesn't
exist (ignored)
Nov 5 22:23:31 anna[5759]: DEBUG: retrieving lvm2-udeb 2.02.66-3
Nov 5 22:23:31 anna[5759]: DEBUG: retrieving partman-auto-lvm 36
Nov 5 22:23:32 anna[5759]: DEBUG: retrieving partman-lvm 72
Nov 5 22:23:33 anna-install: Installing partman-auto-crypto
Nov 5 22:23:33 anna[5853]: DEBUG: resolver (cdebconf-udeb): package
doesn't exist (ignored)
Nov 5 22:23:33 anna[5853]: DEBUG: resolver (di-utils): package doesn't
exist (ignored)
Nov 5 22:23:33 anna[5853]: DEBUG: resolver
(kernel-image-2.6.32-5-486-di): package doesn't exist (ignored)
Nov 5 22:23:33 anna[5853]: DEBUG: resolver
(core-modules-2.6.32-5-486-di): package doesn't exist (ignored)
Nov 5 22:23:33 anna[5853]: DEBUG: resolver (fat-modules): package
doesn't exist (ignored)
Nov 5 22:23:33 anna[5853]: DEBUG: resolver (libdebian-installer4-udeb):
package doesn't exist (ignored)
Nov 5 22:23:33 anna[5853]: DEBUG: resolver (archdetect): package
doesn't exist (ignored)
Nov 5 22:23:33 anna[5853]: DEBUG: resolver (hw-detect): package doesn't
exist (ignored)
Nov 5 22:23:33 anna[5853]: DEBUG: retrieving partman-auto-crypto 14
Nov 5 22:23:34 anna[5853]: DEBUG: retrieving partman-crypto 44
Nov 5 22:23:36 kernel: [ 338.431776] btrfs: Unknown symbol zlib_deflateEnd
Nov 5 22:23:36 kernel: [ 338.433279] btrfs: Unknown symbol zlib_deflate
Nov 5 22:23:36 kernel: [ 338.434232] btrfs: Unknown symbol
zlib_deflate_workspacesize
Nov 5 22:23:36 kernel: [ 338.435804] btrfs: Unknown symbol
zlib_deflateInit2
Nov 5 22:23:36 kernel: [ 338.520457] JFS: nTxBlock = 8192, nTxLock = 65536
Nov 5 22:23:36 kernel: [ 338.567760] SGI XFS with ACLs, security
attributes, realtime, large block/inode numbers, no debug enabled
Nov 5 22:23:36 kernel: [ 338.570190] SGI XFS Quota Management subsystem
Nov 5 22:23:36 md-devices: mdadm: No arrays found in config file or
automatically
Nov 5 22:23:36 kernel: [ 339.142590] device-mapper: uevent: version 1.0.3
Nov 5 22:23:36 kernel: [ 339.143317] device-mapper: ioctl:
4.15.0-ioctl (2009-04-01) initialised: dm-devel@redhat.com
Nov 5 22:23:36 partman: No matching physical volumes found
Nov 5 22:23:36 partman:
Nov 5 22:23:36 partman: No volume groups found
Nov 5 22:23:36 partman:
Nov 5 22:23:36 partman: Reading all physical volumes. This may take
a while...
Nov 5 22:23:36 partman-lvm:
Nov 5 22:23:36 partman-lvm: No volume groups found
Nov 5 22:23:36 partman-lvm:
The nothing happed. I then killing some of the last process to go back
to the installer menu in order to save the debug journal via HTTP and
SSH (very useful expert mode trick). Then the syslog completed with this:
Nov 5 22:23:51 init: starting pid 319, tty '/dev/tty3': '-/bin/sh'
Nov 5 22:25:40 main-menu[337]: (process:5746): Terminated
Nov 5 22:25:40 main-menu[337]: (process:5746): Terminated
Nov 5 22:25:40 main-menu[337]: WARNING **: Configuring 'partman-base'
failed with error code 143
Nov 5 22:25:40 main-menu[337]: WARNING **: Menu item 'partman-base' failed.
Nov 5 22:26:06 main-menu[337]: INFO: Menu item 'save-logs' selected
Nov 5 22:32:55 main-menu[337]: INFO: Menu item 'save-logs' selected
Nov 5 22:33:38 main-menu[337]: INFO: Menu item 'save-logs' selected
The debian installed log provide a partman log:
/bin/partman: *******************************************************
/lib/partman/init.d/25md-devices:
*******************************************************
/lib/partman/init.d/30parted:
*******************************************************
parted_server: ======= Starting the server
parted_server: main_loop: iteration 1
parted_server: Opening infifo
/lib/partman/init.d/30parted: IN: OPEN =dev=sda /dev/sda
parted_server: Read command: OPEN
parted_server: command_open()
parted_server: Request to open =dev=sda
parted_server: Opening outfifo
parted_server: OUT: OK
parted_server: OUT: OK
parted_server: Note =dev=sda as unchanged
parted_server: Closing infifo and outfifo
parted_server: main_loop: iteration 2
parted_server: Opening infifo
/lib/partman/init.d/30parted: IN: OPEN =dev=sdb /dev/sdb
parted_server: Read command: OPEN
parted_server: command_open()
parted_server: Request to open =dev=sdb
parted_server: Opening outfifo
parted_server: OUT: OK
parted_server: OUT: OK
It seem to hang when processing /dev/sdb if I understand correctly.
/dev/sdb is actually a small USB disk that is integrated into the same
USB stick as the 2GB /dev/sdc USB disk. When I insert this USB stick
into a regular Lenny machine I get this:
[130550.986061] usb 2-2: new high speed USB device using ehci_hcd and
address 11
[130551.189585] usb 2-2: configuration #1 chosen from 1 choice
[130551.190036] scsi15 : SCSI emulation for USB Mass Storage devices
[130551.190307] usb-storage: device found at 11
[130551.190317] usb-storage: waiting for device to settle before scanning
[130551.190547] usb 2-2: New USB device found, idVendor=1dbe, idProduct=0102
[130551.190557] usb 2-2: New USB device strings: Mfr=1, Product=2,
SerialNumber=3
[130551.190563] usb 2-2: SerialNumber: AA2719E4
[130556.190280] usb-storage: device scan complete
[130556.191114] scsi 15:0:0:0: Direct-Access disk2go PURE II
8.20 PQ: 0 ANSI: 2
[130556.191726] scsi 15:0:0:1: Direct-Access disk2go PURE II
8.20 PQ: 0 ANSI: 2
[130556.194101] sd 15:0:0:0: [sdb] 10240 512-byte hardware sectors (5 MB)
[130556.194599] sd 15:0:0:0: [sdb] Write Protect is off
[130556.194603] sd 15:0:0:0: [sdb] Mode Sense: 03 00 00 00
[130556.194604] sd 15:0:0:0: [sdb] Assuming drive cache: write through
[130556.196098] sd 15:0:0:0: [sdb] 10240 512-byte hardware sectors (5 MB)
[130556.196602] sd 15:0:0:0: [sdb] Write Protect is off
[130556.196605] sd 15:0:0:0: [sdb] Mode Sense: 03 00 00 00
[130556.196607] sd 15:0:0:0: [sdb] Assuming drive cache: write through
[130556.196609] sdb: sdb1
[130556.490327] sd 15:0:0:0: [sdb] Attached SCSI removable disk
[130556.495952] sd 15:0:0:1: [sdc] 4184064 512-byte hardware sectors
(2142 MB)
[130556.497988] sd 15:0:0:1: [sdc] Write Protect is off
[130556.497992] sd 15:0:0:1: [sdc] Mode Sense: 03 00 00 00
[130556.497993] sd 15:0:0:1: [sdc] Assuming drive cache: write through
[130556.500437] sd 15:0:0:1: [sdc] 4184064 512-byte hardware sectors
(2142 MB)
[130556.500973] sd 15:0:0:1: [sdc] Write Protect is off
[130556.500976] sd 15:0:0:1: [sdc] Mode Sense: 03 00 00 00
[130556.500977] sd 15:0:0:1: [sdc] Assuming drive cache: write through
[130556.500980] sdc:
[130556.501789] sd 15:0:0:1: [sdc] Attached SCSI removable disk
[130556.813803] FAT: utf8 is not a recommended IO charset for FAT
filesystems, filesystem will be case sensitive!
[130556.917917] FAT: utf8 is not a recommended IO charset for FAT
filesystems, filesystem will be case sensitive!
So /dev/sdb is just an another innocent small 5MB usb storage disk. It's
strange that partman can be getting trouble with this.
How can I get more debug informations from partman to go deeper into the
analysis ?
Note: I first tried a AMD64 install that have the same exact problem
before giving this report from a i386 install. The machine is only 2
days old and run without problem Windows 7 and Meego 1.1, so no hardware
failure is expected.
Regards,
Jean-Christian de Rivaz
Reply to: