FAQ: [#6252] Device offlined - not ready after error recovery in testing isp1362+sl811 on bf537-stamp(2010)

Document created by Aaronwu Employee on Sep 11, 2013
Version 1Show Document
  • View in full screen mode

[#6252] Device offlined - not ready after error recovery in testing isp1362+sl811 on bf537-stamp

Submitted By: angelia wu

Open Date

2010-09-13 03:04:07     Close Date

2010-10-18 04:16:01

Priority:

Medium     Assignee:

Bob Liu

Status:

Closed     Fixed In Release:

N/A

Found In Release:

2010R1     Release:

Blackfin Linux:2010R1

Category:

N/A     Board:

STAMP

Processor:

BF537     Silicon Revision:

Is this bug repeatable?:

Yes     Resolution:

Fixed

Uboot version or rev.:

    Toolchain version or rev.:

svn-4681

App binary format:

N/A     

Summary: Device offlined - not ready after error recovery in testing isp1362+sl811 on bf537-stamp

Details:

 

In testing isp1362+sl811 on bf537-stamp, when i do "time bonnie++ -u root -d /mnt" the error will show and then can't detect "sdb".

when i reboot the system, and still can't detect "sdb" but when i power it and restart , it can detect "sda" and "sdb".

usb 2-1: device not accepting address 2, error -110

usb 2-1: reset full speed USB device using sl811-hcd and address 2

usb 2-1: device not accepting address 2, error -110

usb 2-1: USB disconnect, address 2

sd 1:0:0:0: Device offlined - not ready after error recovery

sd 1:0:0:0: [sdb] Unhandled error code

sd 1:0:0:0: [sdb] Result: hostbyte=0x05 driverbyte=0x00

sd 1:0:0:0: [sdb] CDB: cdb[0]=0x2a: 2a 00 00 11 49 ca 00 00 f0 00

end_request: I/O error, dev sdb, sector 1133002

sd 1:0:0:0: rejecting I/O to offline device

 

 

the log as follow.

 

 

BusyBox v1.16.2 (2010-09-10 12:41:30 CST) hush - the humble shell

 

root:/> PHY: 0:01 - Link is Up - 100/Full

 

root:/> ls /dev

console             ram0                ram7                stdout

cpu_dma_latency     ram1                ram8                tty

fd                  ram10               ram9                ttyBF0

full                ram11               random              urandom

kmsg                ram12               rtc0                usbdev1.1

log                 ram13               sda                 usbdev1.2

mdev.seq            ram14               sda1                usbdev2.1

mem                 ram15               sda2                usbdev2.2

network_latency     ram2                sdb                 watchdog

network_throughput  ram3                sdb1                zero

null                ram4                sdb2

ptmx                ram5                stderr

pts                 ram6                stdin

 

 

root:/> mke2fs /dev/sdb2

mke2fs 1.41.12 (17-May-2010)

ext2fs_check_if_mount: Can't check if filesystem is mounted due to missing mtab file while determining whether /dev/sdb2 is mounted.

Filesystem label=

OS type: Linux

Block size=1024 (log=0)

Fragment size=1024 (log=0)

Stride=0 blocks, Stripe width=0 blocks

124440 inodes, 495876 blocks

24793 blocks (5.00%) reserved for the super user

First data block=1

Maximum filesystem blocks=67633152

61 block groups

8192 blocks per group, 8192 fragments per group

2040 inodes per group

Superblock backups stored on blocks:

        8193, 24577, 40961, 57345, 73729, 204801, 221185, 401409

 

Writing inode tables: done                           

Writing superblocks and filesystem accounting information: done

 

This filesystem will be automatically checked every 33 mounts or

180 days, whichever comes first.  Use tune2fs -c or -i to override.

root:/> mount -t ext2 /dev/sdb2 /mnt

root:/> time bonnie++ -u root -d /mnt

Using uid:0, gid:0.

Writing a byte at a time...done

Writing intelligently...usb 2-1: reset full speed USB device using sl811-hcd and address 2

usb 2-1: device descriptor read/64, error -110

usb 2-1: device descriptor read/64, error -110

usb 2-1: reset full speed USB device using sl811-hcd and address 2

usb 2-1: device descriptor read/64, error -110

usb 2-1: device descriptor read/64, error -110

usb 2-1: reset full speed USB device using sl811-hcd and address 2

usb 2-1: device not accepting address 2, error -110

usb 2-1: reset full speed USB device using sl811-hcd and address 2

usb 2-1: device not accepting address 2, error -110

usb 2-1: USB disconnect, address 2

sd 1:0:0:0: Device offlined - not ready after error recovery

sd 1:0:0:0: [sdb] Unhandled error code

sd 1:0:0:0: [sdb] Result: hostbyte=0x05 driverbyte=0x00

sd 1:0:0:0: [sdb] CDB: cdb[0]=0x2a: 2a 00 00 11 49 ca 00 00 f0 00

end_request: I/O error, dev sdb, sector 1133002

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: rejecting I/O to offline device

sd 1:0:0:0: [sdb] Unhandled error code

sd 1:0:0:0: [sdb] Result: hostbyte=0x01 driverbyte=0x00

sd 1:0:0:0: [sdb] CDB: cdb[0]=0x2a: 2a 00 00 11 4a ba 00 00 20 00

end_request: I/O error, dev sdb, sector 1133242

sd 1:0:0:0: rejecting I/O to offline device

EXT2-fs: sdb2 previous I/O error to superblock detected

EXT2-fs: sdb2 previous I/O error to superblock detected

EXT2-fs (sdb2): error: ext2_get_inode: unable to read inode block - inode=12, block=263

EXT2-fs (sdb2): error: ext2_free_branches: Read failure, inode=12, block=69686

------------[ cut here ]------------

Badness at fs/buffer.c:1159

 

ADSP-BF537-0.2 500(MHz CCLK) 125(MHz SCLK) (mpu off)

Linux version 2.6.34.6-ADI-2010R1-pre-svn9118 (test@uclinux41) (gcc version 4.3.5 (ADI-trunk/svn-4681) ) #233 Mon Sep 13 10:45:32 CST 2010

 

SEQUENCER STATUS:               Not tainted

SEQSTAT: 00002021  IPEND: 8008  IMASK: ffff  SYSCFG: 0006

  EXCAUSE   : 0x21

  physical IVG3 asserted : <0xffa007d8> { _trap + 0x0 }

  physical IVG15 asserted : <0xffa010bc> { _evt_system_call + 0x0 }

  logical irq   6 mapped  : <0xffa003ec> { _bfin_coretmr_interrupt + 0x0 }

  logical irq  10 mapped  : <0x000f0dcc> { _bfin_rtc_interrupt + 0x0 }

  logical irq  18 mapped  : <0x000b8f0c> { _bfin_serial_dma_rx_int + 0x0 }

  logical irq  19 mapped  : <0x000b8c64> { _bfin_serial_dma_tx_int + 0x0 }

  logical irq  24 mapped  : <0x000d5828> { _bfin_mac_interrupt + 0x0 }

  logical irq  53 mapped  : <0x000da014> { _usb_hcd_irq + 0x0 }

  logical irq  54 mapped  : <0x000da014> { _usb_hcd_irq + 0x0 }

RETE: <0x00000000> /* Maybe null pointer? */

RETN: <0x009f3b40> /* kernel dynamic memory */

RETX: <0x00000480> /* Maybe fixed code section */

RETS: <0x0007be74> { _ext2_free_blocks + 0x1fc }

PC  : <0x00061258> { _mark_buffer_dirty + 0xa0 }

DCPLB_FAULT_ADDR: <0x001c9d20> /* kernel dynamic memory */

ICPLB_FAULT_ADDR: <0x00061258> { _mark_buffer_dirty + 0xa0 }

PROCESSOR STATE:

R0 : 00000000    R1 : 029b5414    R2 : 00000000    R3 : 00000004

R4 : 00000001    R5 : 00011035    R6 : 00000001    R7 : 00000001

P0 : 00000003    P1 : 029b5414    P2 : 001c9d20    P3 : 029bb900

P4 : 029cc400    P5 : 01d96310    FP : 00001034    SP : 009f3a64

LB0: ffa0179c    LT0: ffa0179a    LC0: 00000000

LB1: 000a1772    LT1: 000a173c    LC1: 00000000

B0 : 00000000    L0 : 00000000    M0 : 00000000    I0 : 00004000

B1 : 00000000    L1 : 00000000    M1 : 00000000    I1 : 00000001

B2 : 00000000    L2 : 00000000    M2 : 00000000    I2 : 00000000

B3 : 00000000    L3 : 00000000    M3 : 00000000    I3 : 00000000

A0.w: 000214c8   A0.x: 00000000   A1.w: 000004c8   A1.x: 00000000

USP : 00a48920  ASTAT: 02003025

 

Hardware Trace:

   0 Target : <0x00003ef8> { _trap_c + 0x0 }

     Source : <0xffa0076c> { _exception_to_level5 + 0xa4 } CALL pcrel

   1 Target : <0xffa006c8> { _exception_to_level5 + 0x0 }

     Source : <0xffa0057c> { _bfin_return_from_exception + 0x20 } RTX

   2 Target : <0xffa0055c> { _bfin_return_from_exception + 0x0 }

     Source : <0xffa00620> { _ex_trap_c + 0x74 } JUMP.S

   3 Target : <0xffa005ac> { _ex_trap_c + 0x0 }

     Source : <0xffa00840> { _trap + 0x68 } JUMP (P4)

   4 Target : <0xffa007f6> { _trap + 0x1e }

     Source : <0xffa007f2> { _trap + 0x1a } IF CC JUMP pcrel

   5 Target : <0xffa007d8> { _trap + 0x0 }

      FAULT : <0x00061258> { _mark_buffer_dirty + 0xa0 } BUG

     Source : <0x00061256> { _mark_buffer_dirty + 0x9e } IF !CC JUMP pcrel (BP)

   6 Target : <0x0006124a> { _mark_buffer_dirty + 0x92 }

     Source : <0x000611be> { _mark_buffer_dirty + 0x6 } IF CC JUMP pcrel

   7 Target : <0x000611b8> { _mark_buffer_dirty + 0x0 }

     Source : <0x0007be70> { _ext2_free_blocks + 0x1f8 } CALL pcrel

   8 Target : <0x0007be62> { _ext2_free_blocks + 0x1ea }

     Source : <0x0007be30> { _ext2_free_blocks + 0x1b8 } IF !CC JUMP pcrel

   9 Target : <0x0007be26> { _ext2_free_blocks + 0x1ae }

     Source : <0x0005c756> { ___mark_inode_dirty + 0xda } RTS

  10 Target : <0x0005c750> { ___mark_inode_dirty + 0xd4 }

     Source : <0x0005c6a8> { ___mark_inode_dirty + 0x2c } IF CC JUMP pcrel

  11 Target : <0x0005c69e> { ___mark_inode_dirty + 0x22 }

     Source : <0x0005c690> { ___mark_inode_dirty + 0x14 } IF CC JUMP pcrel (BP)

  12 Target : <0x0005c67c> { ___mark_inode_dirty + 0x0 }

     Source : <0x00061194> { ___set_page_dirty + 0x40 } JUMP.L

  13 Target : <0x0006117e> { ___set_page_dirty + 0x2a }

     Source : <0x000a178a> { _radix_tree_tag_set + 0x96 } RTS

  14 Target : <0x000a1786> { _radix_tree_tag_set + 0x92 }

     Source : <0x000a1780> { _radix_tree_tag_set + 0x8c } IF !CC JUMP pcrel

  15 Target : <0x000a173e> { _radix_tree_tag_set + 0x4a }

     Source : <0x000a173a> { _radix_tree_tag_set + 0x46 } JUMP.S

EXT2-fs: sdb2 previous I/O error to superblock detected

EXT2-fs (sdb2): error: ext2_get_inode: unable to read inode block - inode=12, block=263

Can'E write block.XT2-fs: sdb2 previous I/O error to superblock detected: Input/output error

Can't write block 11208.

 

EXT2-fs (sdb2): error: ext2_fsync: detected IO error when writing metadata buffers

EXT2-fs (sdb2): previous I/O error to superblock detected

 

Can't sync file.

mdev: page allocation failure. order:7, mode:0xd0

Hardware Trace:

   0 Target : <0x0014b79c> { _dump_stack + 0x0 }

     Source : <0x0003a3e0> { ___alloc_pages_nodemask + 0x3a4 } CALL pcrel

   1 Target : <0x0003a3e0> { ___alloc_pages_nodemask + 0x3a4 }

     Source : <0x0014b8a0> { _printk + 0x14 } RTS

   2 Target : <0x0014b89c> { _printk + 0x10 }

     Source : <0x00011f46> { _vprintk + 0x16a } RTS

   3 Target : <0x00011f3a> { _vprintk + 0x15e }

     Source : <0xffa00d3e> { __common_int_entry + 0xda } RTI

   4 Target : <0xffa00cdc> { __common_int_entry + 0x78 }

     Source : <0xffa00b18> { _return_from_int + 0x58 } RTS

   5 Target : <0xffa00b18> { _return_from_int + 0x58 }

     Source : <0xffa00aee> { _return_from_int + 0x2e } IF !CC JUMP pcrel

   6 Target : <0xffa00ac0> { _return_from_int + 0x0 }

     Source : <0xffa00cd8> { __common_int_entry + 0x74 } JUMP.L

   7 Target : <0xffa00cd6> { __common_int_entry + 0x72 }

     Source : <0xffa0038e> { _asm_do_IRQ + 0x6a } RTS

   8 Target : <0xffa00386> { _asm_do_IRQ + 0x62 }

     Source : <0x00015592> { __local_bh_enable + 0x3a } RTS

   9 Target : <0x00015558> { __local_bh_enable + 0x0 }

     Source : <0x00015bd8> { ___do_softirq + 0xa4 } JUMP.L

  10 Target : <0x00015bd0> { ___do_softirq + 0x9c }

     Source : <0x00015bc4> { ___do_softirq + 0x90 } IF CC JUMP pcrel

  11 Target : <0x00015bb6> { ___do_softirq + 0x82 }

     Source : <0x00034158> { _rcu_bh_qs + 0x14 } RTS

  12 Target : <0x00034144> { _rcu_bh_qs + 0x0 }

     Source : <0x00015bb2> { ___do_softirq + 0x7e } JUMP.L

  13 Target : <0x00015baa> { ___do_softirq + 0x76 }

     Source : <0x000349fc> { _rcu_process_callbacks + 0x30 } RTS

  14 Target : <0x000349f8> { _rcu_process_callbacks + 0x2c }

     Source : <0x00034894> { _rcu_do_batch + 0x130 } RTS

  15 Target : <0x0003488c> { _rcu_do_batch + 0x128 }

     Source : <0x00034776> { _rcu_do_batch + 0x12 } IF CC JUMP pcrel

Stack info:

EXT2-fs: sdb2 previous I/O error to superblock detected

EXT2-fs (sdb2): error: ext2_get_inode: unable to read inode block - inode=12, block=263

EXT2-fs: sdb2 previous I/O error to superblock detected

EXT2-fs (sdb2): error: read_block_bitmap: Cannot read block bitmap - block_group = 0, block_bitmap = 260

EXT2-fs: sdb2 previous I/O error to superblock detected

EXT2-fs (sdb2): error: ext2_free_branches: Read failure, inode=12, block=543

EXT2-fs: sdb2 previous I/O error to superblock detected

EXT2-fs (sdb2): error: ext2_free_branches: Read failure, inode=12, block=800

EXT2-fs: sdb2 previous I/O error to superblock detected

EXT2-fs (sdb2): error: read_inode_bitmap: Cannot read inode bitmap - block_group = 0, inode_bitmap = 261

SP: [0x01c9bc6c] <0x01c9bc6c> /* kernel dynamic memory */

FP: (0x01c9be5c)

Memory from 0x01c9bc60 to 01c9c000

01c9bc60: 000000d0  01c9bc6c  00000010 [00000000] 0003a3e4  01e28ca0  00000000  000000d0

01c9bc80: 01e28e80  00000007  000000d0  00000001  00000040  001e11c8  00000000  01c9a008

01c9bca0: 00000010  00000050  00000040  01c9a000  01c9a000  01c9bce0  000200d0  001e1bf8

01c9bcc0: 00000080  0000007c  01e28ca0  0000007c  00000040  00000000  001e11c8  00000000

01c9bce0: 00000000  00000000  001e11c8  029cf560  0004278c  0006b000  029c8908  029c8908

01c9bd00: 00000007  00000077  00000000  0006b000  00000000  00000007  01c9bd5c  00000000

01c9bd20: 01c9a008  029cf560  029cf560  00042b00  001d7058  029c8908  00000000  00000007

01c9bd40: 00000077  00000000  0006b000  0000a4a8  0004b0aa  0006b000  00000004  00000002

01c9bd60: 00000000  01c9bd6c  01bdc52c  00000004  00003f69  0006fc1e  001d7058  00854a00

01c9bd80: 00013190  01c9a000  00060530  0004d3a0  0000a4a8  0003a0ea  00854afc  001e1bf4

01c9bda0: 00000007  00000002  00000000  00000000  00000000  00000000  00854a00  00000000

01c9bdc0: 000019c0  00000001  00000000  00000000  00000000  00000000  0000292a  00000004

01c9bde0: 00000000  00000000  0006a9dc  0006b000  0004d3a0  00000000  00000000  00000000

01c9be00: 01c9be5c  00070356  001d7058  00854a00  001d6ca4  fffffff8  fffffffe  00000000

01c9be20: 01c9bef0  01000000  01c9be38  00000000  01c9be58  01c9be54  00000000  00000000

01c9be40: 00000000  00000000  00000000  00000000  00000000  00000000  00003f69 (01c9bef0)

01c9be60:<0004a884> 001d7058  00854a00  001d6ca4  fffffff8  fffffffe  00000000  00000000

01c9be80: 001f5000  01c9bef0  01e4e000  00854a02  01c9bfcc  0004b552  001f5000  02049d34

01c9bea0: 00000000  00000000  00854a00  01c9a000  00000001  01010101  01010101  00854a00

01c9bec0: 00000000  ffa00868  00000000  029891e0  01c9a000  00000000  00000000  00000000

01c9bee0: 01010101  01c9bf04  0000e730  01c9bef0 (00000000) 00000000  00000000  00000000

01c9bf00: 00000000  00000000  00000000  00000000  00000000  00000000  00000000  00000000

01c9bf20: 00000000  00000000  00000000  00000000  00000000  00000000  00000000  00000000

01c9bf40: 00000000  00000000  00000000  00000000  00000000  00000000  00000000  00000000

01c9bf60: 00000000  00000000  00000000  00000000  00000000  00000000  00000000  00000000

01c9bf80: 00000000  00000000  00000000  00000000  00000000  00000000  00000000  00000000

01c9bfa0: 00000000  00000000  00000000  00000000  00000000  00000000  00000000  00000000

01c9bfc0: 00000000  00000000  00000000  00000000  0001ddea  00000000  00000000  00000000

01c9bfe0:<000014ae> 00000000  00000000  00000000  00000000  00000000  ffffffff  00000006

Return addresses in stack:

   frame  1 : <0x0004a884> { _search_binary_handler + 0x74 }

    address : <0x000014ae> { _kernel_thread_helper + 0x6 }

Mem-Info:

DMA per-cpu:

CPU    0: hi:    0, btch:   1 usd:   0

active_anon:0 inactive_anon:0 isolated_anon:0

active_file:280 inactive_file:4 isolated_file:0

unevictable:1824 dirty:2 writeback:0 unstable:0

free:9285 slab_reclaimable:268 slab_unreclaimable:214

mapped:0 shmem:0 pagetables:0 bounce:0

DMA free:37140kB min:4096kB low:5120kB high:6144kB active_anon:0kB inactive_anon:0kB active_file:1120kB inactive_file:16kB unevictable:7296kB isolated(anono

lowmem_reserve[]: 0 0 0

DMA: 85*4kB 78*8kB 73*16kB 72*32kB 61*64kB 59*128kB 29*256kB 17*512kB 5*1024kB 0*2048kB 0*4096kB 0*8192kB 0*16384kB 0*32768kB = 37140kB

2112 total pagecache pages

14336 pages RAM

626 pages reserved

1975 pages shared

2415 pages non-shared

Allocation of length 438272 from process 282 (mdev) failed

DMA per-cpu:

CPU    0: hi:    0, btch:   1 usd:   0

active_anon:0 inactive_anon:0 isolated_anon:0

active_file:280 inactive_file:4 isolated_file:0

unevictable:1824 dirty:2 writeback:0 unstable:0

free:9285 slab_reclaimable:268 slab_unreclaimable:214

mapped:0 shmem:0 pagetables:0 bounce:0

DMA free:37140kB min:4096kB low:5120kB high:6144kB active_anon:0kB inactive_anon:0kB active_file:1120kB inactive_file:16kB unevictable:7296kB isolated(anono

lowmem_reserve[]: 0 0 0

DMA: 85*4kB 78*8kB 73*16kB 72*32kB 61*64kB 59*128kB 29*256kB 17*512kB 5*1024kB 0*2048kB 0*4096kB 0*8192kB 0*16384kB 0*32768kB = 37140kB

2112 total pagecache pages

Unable to allocate RAM for process text/data, errno 12

Command exited with non-zero status 1

real    5m 28.28s

user    0m 4.28s

sys     0m 47.62s

root:/> ls /dev

console             pts                 ram5                stdout

cpu_dma_latency     ram0                ram6                tty

fd                  ram1                ram7                ttyBF0

full                ram10               ram8                urandom

kmsg                ram11               ram9                usbdev1.1

log                 ram12               random              usbdev1.2

mdev.seq            ram13               rtc0                usbdev2.1

mem                 ram14               sda                 watchdog

network_latency     ram15               sda1                zero

network_throughput  ram2                sda2

null                ram3                stderr

ptmx                ram4                stdin

 

root:/> reboot

Restarting system.

 

CPU:   ADSP bf537-0.2 (Detected Rev: 0.2) (bypass boot)

Board: ADI BF537 stamp board

       Support: http://blackfin.uclinux.org/

Clock: VCO: 500 MHz, Core: 500 MHz, System: 125 MHz

RAM:   64 MiB

Flash: 4 MiB

In:    serial

Out:   serial

Err:   serial

KGDB:  [on serial] ready

Net:   bfin_mac

Hit any key to stop autoboot:  0

Using bfin_mac device

TFTP from server 10.100.4.174; our IP address is 10.100.4.50

Filename 'uImage'.

Load address: 0x1000000

Loading: #################################################################

         #################################################################

         #################################################################

         #################################################################

         #################################################################

         #####################

done

Bytes transferred = 5077889 (4d7b81 hex)

## Booting kernel from Legacy Image at 01000000 ...

   Image Name:   bf537-2.6.34.6-ADI-2010R1-pre-sv

   Created:      2010-09-13   2:45:38 UTC

   Image Type:   Blackfin Linux Kernel Image (gzip compressed)

   Data Size:    5077825 Bytes = 4.8 MiB

   Load Address: 00001000

   Entry Point:  001ef684

   Verifying Checksum ... OK

   Uncompressing Kernel Image ... OK

Starting Kernel at = 001ef684

Linux version 2.6.34.6-ADI-2010R1-pre-svn9118 (test@uclinux41) (gcc version 4.3.5 (ADI-trunk/svn-4681) ) #233 Mon Sep 13 10:45:32 CST 2010

register early platform devices

bootconsole [early_shadow0] enabled

bootconsole [early_BFuart0] enabled

early printk enabled on early_BFuart0

Limiting kernel memory to 56MB due to anomaly 05000263

Board Memory: 64MB

Kernel Managed Memory: 64MB

Memory map:

  fixedcode = 0x00000400-0x00000490

  text      = 0x00001000-0x0014b920

  rodata    = 0x0014b920-0x001bd074

  bss       = 0x001be000-0x001cec04

  data      = 0x001cec04-0x001e4000

    stack   = 0x001e2000-0x001e4000

  init      = 0x001e4000-0x00963000

  available = 0x00963000-0x03800000

  DMA Zone  = 0x03f00000-0x04000000

Hardware Trace Active and Enabled

Boot Mode: 0

Reset caused by Software reset

Blackfin support (C) 2004-2010 Analog Devices, Inc.

Compiled for ADSP-BF537 Rev 0.2

Blackfin Linux support by http://blackfin.uclinux.org/

Processor Speed: 500 MHz core clock and 125 MHz System Clock

NOMPU: setting up cplb tables

Instruction Cache Enabled for CPU0

  External memory: cacheable in instruction cache

Data Cache Enabled for CPU0

  External memory: cacheable (write-back) in data cache

Built 1 zonelists in Zone order, mobility grouping off.  Total pages: 14224

Kernel command line: root=/dev/mtdblock0 rw clkin_hz=25000000 earlyprintk=serial,uart0,57600 console=ttyBF0,57600 ip=10.100.4.50:10.100.4.174:10.99.29.1:25f

PID hash table entries: 256 (order: -2, 1024 bytes)

Dentry cache hash table entries: 8192 (order: 3, 32768 bytes)

Inode-cache hash table entries: 4096 (order: 2, 16384 bytes)

Memory available: 47164k/65536k RAM, (7676k init code, 1322k kernel code, 610k data, 1024k dma, 7740k reserved)

Hierarchical RCU implementation.

NR_IRQS:138

Configuring Blackfin Priority Driven Interrupts

console [ttyBF0] enabled, bootconsole disabled

console [ttyBF0] enabled, bootconsole disabled

Calibrating delay loop... 995.32 BogoMIPS (lpj=1990656)

Security Framework initialized

Mount-cache hash table entries: 512

Blackfin Scratchpad data SRAM: 4 KB

Blackfin L1 Data A SRAM: 16 KB (16 KB free)

Blackfin L1 Data B SRAM: 16 KB (16 KB free)

Blackfin L1 Instruction SRAM: 48 KB (35 KB free)

NET: Registered protocol family 16

Blackfin DMA Controller

stamp_init(): registering device resources

bio: create slab <bio-0> at 0

SCSI subsystem initialized

bfin-spi bfin-spi.0: Blackfin on-chip SPI Controller Driver, Version 1.0, regs_base@ffc00500, dma channel@7

usbcore: registered new interface driver usbfs

usbcore: registered new interface driver hub

usbcore: registered new device driver usb

Switching to clocksource bfin_cs_cycles

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

UDP hash table entries: 256 (order: 0, 4096 bytes)

UDP-Lite hash table entries: 256 (order: 0, 4096 bytes)

NET: Registered protocol family 1

msgmni has been set to 92

io scheduler noop registered

io scheduler cfq registered (default)

bfin-uart: Blackfin serial driver

bfin-uart.0: ttyBF0 at MMIO 0xffc00400 (irq = 18) is a BFIN-UART

brd: module loaded

bfin_mii_bus: probed

bfin_mii_bus: Can't get IRQ 65535 (PHY)

bfin_mac: attached PHY driver [SMSC LAN83C185] (mii_bus:phy_addr=0:01, irq=-1, mdc_clk=2500000Hz(mdc_div=24)@sclk=125MHz)

bfin_mac bfin_mac.0: Blackfin on-chip Ethernet MAC driver, Version 1.1

driver isp1362-hcd, 2005-04-04

isp1362-hcd isp1362-hcd.0: ISP1362 Host Controller

isp1362-hcd isp1362-hcd.0: new USB bus registered, assigned bus number 1

isp1362_hc_reset:

isp1362-hcd isp1362-hcd.0: irq 53, io mem 0x20360000

isp1362_hc_start:

isp1362-hcd isp1362-hcd.0: ISP1362 Memory usage:

isp1362-hcd isp1362-hcd.0:   ISTL:    2 *  256:      512 @ $0000:$0100

isp1362-hcd isp1362-hcd.0:   INTL:   16 * ( 64+8):  1152 @ $0200

isp1362-hcd isp1362-hcd.0:   ATL :   32 * ( 64+8):  2304 @ $0680

isp1362-hcd isp1362-hcd.0:   USED/FREE:   3968       128

hub 1-0:1.0: USB hub found

hub 1-0:1.0: 2 ports detected

ISP1362 Host Controller, irq 53

sl811: driver sl811-hcd, 19 May 2005

sl811-hcd sl811-hcd.0: SL811HS v1.5

sl811-hcd sl811-hcd.0: new USB bus registered, assigned bus number 2

sl811-hcd sl811-hcd.0: irq 54, io mem 0x20340000

hub 2-0:1.0: USB hub found

hub 2-0:1.0: 1 port detected

Initializing USB Mass Storage driver...

usbcore: registered new interface driver usb-storage

USB Mass Storage support registered.

rtc-bfin rtc-bfin: rtc core: registered rtc-bfin as rtc0

bfin-wdt: initialized: timeout=20 sec (nowayout=0)

usbcore: registered new interface driver usbhid

usbhid: USB HID core driver

TCP cubic registered

NET: Registered protocol family 17

rtc-bfin rtc-bfin: setting system clock to 1970-01-04 19:45:38 UTC (330338)

usb 1-2: new full speed USB device using isp1362-hcd and address 2

scsi0 : usb-storage 1-2:1.0

usb 2-1: new full speed USB device using sl811-hcd and address 2

scsi 0:0:0:0: Direct-Access     SanDisk  U3 Cruzer Micro  4.05 PQ: 0 ANSI: 2

scsi 0:0:0:1: CD-ROM            SanDisk  U3 Cruzer Micro  4.05 PQ: 0 ANSI: 2

sd 0:0:0:0: [sda] 3999373 512-byte logical blocks: (2.04 GB/1.90 GiB)

sd 0:0:0:0: [sda] Write Protect is off

sd 0:0:0:0: [sda] Assuming drive cache: write through

sd 0:0:0:0: [sda] Assuming drive cache: write through

sda: sda1 sda2

sd 0:0:0:0: [sda] Assuming drive cache: write through

sd 0:0:0:0: [sda] Attached SCSI removable disk

IP-Config: Gateway not on directly connected network.

dma_alloc_init: dma_page @ 0x029b1000 - 256 pages at 0x03f00000

Freeing unused kernel memory: 7676k freed

                           _____________________________________

        a8888b.           / Welcome to the uClinux distribution \

       d888888b.         /       _     _                         \

       8P"YP"Y88        /       | |   |_|            __  __ (TM)  |

       8|o||o|88  _____/        | |    _ ____  _   _ \ \/ /       |

       8'    .88       \        | |   | |  _ \| | | | \  /        |

       8`._.' Y8.       \       | |__ | | | | | |_| | /  \        |

      d/      `8b.       \      \____||_|_| |_|\____|/_/\_\       |

     dP   .    Y8b.       \   For embedded processors including   |

    d8:'  "  `::88b        \    the Analog Devices Blackfin      /

   d8"         'Y88b        \___________________________________/

  :8P    '      :888

   8a.   :     _a88P         For further information, check out:

._/"Yaa_:   .| 88P|            - http://blackfin.uclinux.org/

\    YP"    `| 8P  `.          - http://docs.blackfin.uclinux.org/

/     \.___.d|    .'           - http://www.uclinux.org/

`--..__)8888P`._.'  jgs/a:f    - http://www.analog.com/blackfin

 

Have a lot of fun...

 

 

BusyBox v1.16.2 (2010-09-10 12:41:30 CST) hush - the humble shell

 

root:/> PHY: 0:01 - Link is Up - 100/Full

 

root:/> ls /dev

console             pts                 ram5                stdout

cpu_dma_latency     ram0                ram6                tty

fd                  ram1                ram7                ttyBF0

full                ram10               ram8                urandom

kmsg                ram11               ram9                usbdev1.1

log                 ram12               random              usbdev1.2

mdev.seq            ram13               rtc0                usbdev2.1

mem                 ram14               sda                 watchdog

network_latency     ram15               sda1                zero

network_throughput  ram2                sda2

null                ram3                stderr

ptmx                ram4                stdin

root:/> usb 2-1: device descriptor read/64, error -110

usb 2-1: device descriptor read/64, error -110

usb 2-1: new full speed USB device using sl811-hcd and address 3

usb 2-1: device descriptor read/64, error -110

usb 2-1: device descriptor read/64, error -110

usb 2-1: new full speed USB device using sl811-hcd and address 4

usb 2-1: device not accepting address 4, error -110

usb 2-1: new full speed USB device using sl811-hcd and address 5

usb 2-1: device not accepting address 5, error -110

hub 2-0:1.0: unable to enumerate USB device on port 1

 

 

Follow-ups

 

--- Bob Liu                                                  2010-09-16 02:44:31

 

isp1362-hcd and sl811-hcd tests must use different kernel configs, so they

can't be tested at the same time.

 

for sl811-hcd test, you must config the kernel as the doc said

https://docs.blackfin.uclinux.org/doku.php?id=hw:cards:usb_ez-extender&s[]=isp1362

 

like this:

 

Configure asynchronous memory for SL811HS

 

Blackfin Processor Options --->

      --- Asynchronous Memory Configuration

          EBIU_AMBCTL Control  --->

                  (0xCCC0) Bank 3

 

 

In case you selected BANK2 for dummy accesses:

 

Blackfin Processor Options --->

      --- Asynchronous Memory Configuration

          EBIU_AMBCTL Control  --->

                  (0x22A4) Bank 2

 

I can't repeat this problem with separated kernel config and test.

 

--- angelia wu                                               2010-10-18 04:16:01

yes,it is indeed the problem.

now it is ok. I closed the bug 6252.

 

 

 

    Files

    Changes

    Commits

    Dependencies

    Duplicates

    Associations

    Tags

 

File Name     File Type     File Size     Posted By

user.537isp1362.config    application/x-config    49061    angelia wu

kernel.537isp1362.config    application/x-config    43121    angelia wu

Outcomes