ubifs became broken on contigous power-fails

Alexander Pazdnikov pazdnikov at prosoft.ural.ru
Thu May 20 09:18:42 EDT 2010


After reboot by poweroff I've got the following:

first mount ubi2:dbfs RO then remount RW

[   11.069330] UBIFS: recovery needed                                                                     
[   13.485344] UBIFS: recovery deferred                                                                   
[   14.781242] UBIFS: mounted UBI device 2, volume 0, name "dbfs"                                         
[   14.787101] UBIFS: mounted read-only                                                                   
[   14.791008] UBIFS: file system size:   189149184 bytes (184716 KiB, 180 MiB, 1466 LEBs)                
[   14.799797] UBIFS: journal size:       9418752 bytes (9198 KiB, 8 MiB, 73 LEBs)                        
[   14.806633] UBIFS: media format:       w4/r0 (latest is w4/r0)                                         
[   14.813468] UBIFS: default compressor: lzo                                                             
[   14.817375] UBIFS: reserved for root:  4952683 bytes (4836 KiB)                                        
[   14.823234] UBIFS DBG (pid 468): mount_ubifs: compiled on:         May 12 2010 at 18:34:36             
[   14.823234] UBIFS DBG (pid 468): mount_ubifs: min. I/O unit size:  2048 bytes                          
[   14.823234] UBIFS DBG (pid 468): mount_ubifs: LEB size:            129024 bytes (126 KiB)              
[   14.824211] UBIFS DBG (pid 468): mount_ubifs: data journal heads:  1                                   
[   14.824211] UBIFS DBG (pid 468): mount_ubifs: UUID:                DC1BB581-CE01-431C-9308-BBA9D0885E3D
[   14.824211] UBIFS DBG (pid 468): mount_ubifs: big_lpt              0                                   
[   14.824211] UBIFS DBG (pid 468): mount_ubifs: log LEBs:            5 (3 - 7)                           
[   14.824211] UBIFS DBG (pid 468): mount_ubifs: LPT area LEBs:       2 (8 - 9)                           
[   14.824211] UBIFS DBG (pid 468): mount_ubifs: orphan area LEBs:    2 (10 - 11)                         
[   14.824211] UBIFS DBG (pid 468): mount_ubifs: main area LEBs:      1466 (12 - 1477)                    
[   14.824211] UBIFS DBG (pid 468): mount_ubifs: index LEBs:          1                                   
[   14.824211] UBIFS DBG (pid 468): mount_ubifs: total index bytes:   46848 (45 KiB, 0 MiB)               
[   14.824211] UBIFS DBG (pid 468): mount_ubifs: key hash type:       0                                   
[   14.824211] UBIFS DBG (pid 468): mount_ubifs: tree fanout:         8                                   
[   14.824211] UBIFS DBG (pid 468): mount_ubifs: reserved GC LEB:     14                                  
[   14.824211] UBIFS DBG (pid 468): mount_ubifs: first main LEB:      12                                  
[   14.825187] UBIFS DBG (pid 468): mount_ubifs: max. znode size      240                                 
[   14.825187] UBIFS DBG (pid 468): mount_ubifs: max. index node size 192                                 
[   14.825187] UBIFS DBG (pid 468): mount_ubifs: node sizes:          data 48, inode 160, dentry 56       
[   14.825187] UBIFS DBG (pid 468): mount_ubifs: node sizes:          trun 56, sb 4096, master 512        
[   14.825187] UBIFS DBG (pid 468): mount_ubifs: node sizes:          ref 64, cmt. start 32, orph 32      
[   14.825187] UBIFS DBG (pid 468): mount_ubifs: max. node sizes:     data 4144, inode 4256 dentry 312    
[   14.825187] UBIFS DBG (pid 468): mount_ubifs: dead watermark:      2048                                
[   14.825187] UBIFS DBG (pid 468): mount_ubifs: dark watermark:      6144                                
[   14.825187] UBIFS DBG (pid 468): mount_ubifs: LEB overhead:        560                                 
[   14.825187] UBIFS DBG (pid 468): mount_ubifs: max. dark space:     9007104 (8796 KiB, 8 MiB)
[   14.825187] UBIFS DBG (pid 468): mount_ubifs: maximum bud bytes:   8773632 (8568 KiB, 8 MiB)
[   14.825187] UBIFS DBG (pid 468): mount_ubifs: BG commit bud bytes: 7128576 (6961 KiB, 6 MiB)
[   14.825187] UBIFS DBG (pid 468): mount_ubifs: current bud bytes    2572288 (2512 KiB, 2 MiB)
[   14.826164] UBIFS DBG (pid 468): mount_ubifs: max. seq. number:    6955
[   14.826164] UBIFS DBG (pid 468): mount_ubifs: commit number:       5
[   14.890617] UBIFS: completing deferred recovery
[   14.901359] UBIFS DBG (pid 472): ubifs_bg_thread: background thread "ubifs_bgt2_0" started, PID 472
[   21.676746] UBIFS: deferred recovery completed
[   21.681629] UBIFS error (pid 471): dbg_check_space_info: free space changed from 171535545 to 171830940
[   21.691395] UBIFS: saved lprops statistics dump
[   21.696277] (pid 471) Lprops statistics: empty_lebs 1350, idx_lebs  1
[   21.696277]  taken_empty_lebs 0, total_free 174458880, total_dirty 9203536
[   21.696277]  total_used 5442288, total_dark 8777552, total_dead 22792
[   21.696277] UBIFS: current lprops statistics dump
[   21.701160] (pid 471) Lprops statistics: empty_lebs 1360, idx_lebs  1
[   21.701160]  taken_empty_lebs 1, total_free 175742976, total_dirty 7914704
[   21.701160]  total_used 5442288, total_dark 8777552, total_dead 22792
[   21.701160] UBIFS assert failed in dbg_dump_budg at 617 (pid 471)
[   21.707996] [<c0026820>] (unwind_backtrace+0x0/0xe4) from [<c0158c50>] (dbg_dump_budg+0x250/0x334)
[   21.716785] [<c0158c50>] (dbg_dump_budg+0x250/0x334) from [<c0158df4>] (dbg_check_space_info+0xc0/0x114)
[   21.726551] [<c0158df4>] (dbg_check_space_info+0xc0/0x114) from [<c0128d3c>] (ubifs_remount_fs+0x528/0x8bc)
[   21.737293] [<c0128d3c>] (ubifs_remount_fs+0x528/0x8bc) from [<c008f7ec>] (do_remount_sb+0x8c/0x100)
[   21.746082] [<c008f7ec>] (do_remount_sb+0x8c/0x100) from [<c00a80f0>] (do_mount+0x4c0/0x7cc)
[   21.754871] [<c00a80f0>] (do_mount+0x4c0/0x7cc) from [<c00a8494>] (sys_mount+0x98/0xc8)
[   21.763660] [<c00a8494>] (sys_mount+0x98/0xc8) from [<c0021f40>] (ret_fast_syscall+0x0/0x28)
[   21.772449] (pid 471) Budgeting info: budg_data_growth 0, budg_dd_growth 0, budg_idx_growth 0
[   21.772449]  data budget sum 0, total budget sum 0, freeable_cnt 57
[   21.772449]  min_idx_lebs 3, old_idx_sz 49216, calc_idx_sz 49216, idx_gc_cnt 0
[   21.772449]  dirty_pg_cnt 0, dirty_zn_cnt 0, clean_zn_cnt 280
[   21.772449]  dark_wm 6144, dead_wm 2048, max_idx_node_sz 192
[   21.772449]  gc_lnum 109, ihead_lnum 12
[   21.772449]  jhead 0 (GC)     LEB -1
[   21.772449]  jhead 1 (base)   LEB -1
[   21.772449]  jhead 2 (data)   LEB -1
[   21.772449]  commit state 0
[   21.772449] Budgeting predictions:
[   21.772449]  available: 174003384, outstanding 0, free 171830940
[   21.773426] [<c0026820>] (unwind_backtrace+0x0/0xe4) from [<c0158e0c>] (dbg_check_space_info+0xd8/0x114)
[   21.783191] [<c0158e0c>] (dbg_check_space_info+0xd8/0x114) from [<c0128d3c>] (ubifs_remount_fs+0x528/0x8bc)
[   21.792957] [<c0128d3c>] (ubifs_remount_fs+0x528/0x8bc) from [<c008f7ec>] (do_remount_sb+0x8c/0x100)
[   21.802723] [<c008f7ec>] (do_remount_sb+0x8c/0x100) from [<c00a80f0>] (do_mount+0x4c0/0x7cc)
[   21.811512] [<c00a80f0>] (do_mount+0x4c0/0x7cc) from [<c00a8494>] (sys_mount+0x98/0xc8)
[   21.819324] [<c00a8494>] (sys_mount+0x98/0xc8) from [<c0021f40>] (ret_fast_syscall+0x0/0x28)

 
--
Best regards,
Sasha
-------------- next part --------------
[   11.069330] UBIFS: recovery needed                                                                     
[   13.485344] UBIFS: recovery deferred                                                                   
[   14.781242] UBIFS: mounted UBI device 2, volume 0, name "dbfs"                                         
[   14.787101] UBIFS: mounted read-only                                                                   
[   14.791008] UBIFS: file system size:   189149184 bytes (184716 KiB, 180 MiB, 1466 LEBs)                
[   14.799797] UBIFS: journal size:       9418752 bytes (9198 KiB, 8 MiB, 73 LEBs)                        
[   14.806633] UBIFS: media format:       w4/r0 (latest is w4/r0)                                         
[   14.813468] UBIFS: default compressor: lzo                                                             
[   14.817375] UBIFS: reserved for root:  4952683 bytes (4836 KiB)                                        
[   14.823234] UBIFS DBG (pid 468): mount_ubifs: compiled on:         May 12 2010 at 18:34:36             
[   14.823234] UBIFS DBG (pid 468): mount_ubifs: min. I/O unit size:  2048 bytes                          
[   14.823234] UBIFS DBG (pid 468): mount_ubifs: LEB size:            129024 bytes (126 KiB)              
[   14.824211] UBIFS DBG (pid 468): mount_ubifs: data journal heads:  1                                   
[   14.824211] UBIFS DBG (pid 468): mount_ubifs: UUID:                DC1BB581-CE01-431C-9308-BBA9D0885E3D
[   14.824211] UBIFS DBG (pid 468): mount_ubifs: big_lpt              0                                   
[   14.824211] UBIFS DBG (pid 468): mount_ubifs: log LEBs:            5 (3 - 7)                           
[   14.824211] UBIFS DBG (pid 468): mount_ubifs: LPT area LEBs:       2 (8 - 9)                           
[   14.824211] UBIFS DBG (pid 468): mount_ubifs: orphan area LEBs:    2 (10 - 11)                         
[   14.824211] UBIFS DBG (pid 468): mount_ubifs: main area LEBs:      1466 (12 - 1477)                    
[   14.824211] UBIFS DBG (pid 468): mount_ubifs: index LEBs:          1                                   
[   14.824211] UBIFS DBG (pid 468): mount_ubifs: total index bytes:   46848 (45 KiB, 0 MiB)               
[   14.824211] UBIFS DBG (pid 468): mount_ubifs: key hash type:       0                                   
[   14.824211] UBIFS DBG (pid 468): mount_ubifs: tree fanout:         8                                   
[   14.824211] UBIFS DBG (pid 468): mount_ubifs: reserved GC LEB:     14                                  
[   14.824211] UBIFS DBG (pid 468): mount_ubifs: first main LEB:      12                                  
[   14.825187] UBIFS DBG (pid 468): mount_ubifs: max. znode size      240                                 
[   14.825187] UBIFS DBG (pid 468): mount_ubifs: max. index node size 192                                 
[   14.825187] UBIFS DBG (pid 468): mount_ubifs: node sizes:          data 48, inode 160, dentry 56       
[   14.825187] UBIFS DBG (pid 468): mount_ubifs: node sizes:          trun 56, sb 4096, master 512        
[   14.825187] UBIFS DBG (pid 468): mount_ubifs: node sizes:          ref 64, cmt. start 32, orph 32      
[   14.825187] UBIFS DBG (pid 468): mount_ubifs: max. node sizes:     data 4144, inode 4256 dentry 312    
[   14.825187] UBIFS DBG (pid 468): mount_ubifs: dead watermark:      2048                                
[   14.825187] UBIFS DBG (pid 468): mount_ubifs: dark watermark:      6144                                
[   14.825187] UBIFS DBG (pid 468): mount_ubifs: LEB overhead:        560                                 
[   14.825187] UBIFS DBG (pid 468): mount_ubifs: max. dark space:     9007104 (8796 KiB, 8 MiB)
[   14.825187] UBIFS DBG (pid 468): mount_ubifs: maximum bud bytes:   8773632 (8568 KiB, 8 MiB)
[   14.825187] UBIFS DBG (pid 468): mount_ubifs: BG commit bud bytes: 7128576 (6961 KiB, 6 MiB)
[   14.825187] UBIFS DBG (pid 468): mount_ubifs: current bud bytes    2572288 (2512 KiB, 2 MiB)
[   14.826164] UBIFS DBG (pid 468): mount_ubifs: max. seq. number:    6955
[   14.826164] UBIFS DBG (pid 468): mount_ubifs: commit number:       5
[   14.890617] UBIFS: completing deferred recovery
[   14.901359] UBIFS DBG (pid 472): ubifs_bg_thread: background thread "ubifs_bgt2_0" started, PID 472
[   21.676746] UBIFS: deferred recovery completed
[   21.681629] UBIFS error (pid 471): dbg_check_space_info: free space changed from 171535545 to 171830940
[   21.691395] UBIFS: saved lprops statistics dump
[   21.696277] (pid 471) Lprops statistics: empty_lebs 1350, idx_lebs  1
[   21.696277]  taken_empty_lebs 0, total_free 174458880, total_dirty 9203536
[   21.696277]  total_used 5442288, total_dark 8777552, total_dead 22792
[   21.696277] UBIFS: current lprops statistics dump
[   21.701160] (pid 471) Lprops statistics: empty_lebs 1360, idx_lebs  1
[   21.701160]  taken_empty_lebs 1, total_free 175742976, total_dirty 7914704
[   21.701160]  total_used 5442288, total_dark 8777552, total_dead 22792
[   21.701160] UBIFS assert failed in dbg_dump_budg at 617 (pid 471)
[   21.707996] [<c0026820>] (unwind_backtrace+0x0/0xe4) from [<c0158c50>] (dbg_dump_budg+0x250/0x334)
[   21.716785] [<c0158c50>] (dbg_dump_budg+0x250/0x334) from [<c0158df4>] (dbg_check_space_info+0xc0/0x114)
[   21.726551] [<c0158df4>] (dbg_check_space_info+0xc0/0x114) from [<c0128d3c>] (ubifs_remount_fs+0x528/0x8bc)
[   21.737293] [<c0128d3c>] (ubifs_remount_fs+0x528/0x8bc) from [<c008f7ec>] (do_remount_sb+0x8c/0x100)
[   21.746082] [<c008f7ec>] (do_remount_sb+0x8c/0x100) from [<c00a80f0>] (do_mount+0x4c0/0x7cc)
[   21.754871] [<c00a80f0>] (do_mount+0x4c0/0x7cc) from [<c00a8494>] (sys_mount+0x98/0xc8)
[   21.763660] [<c00a8494>] (sys_mount+0x98/0xc8) from [<c0021f40>] (ret_fast_syscall+0x0/0x28)
[   21.772449] (pid 471) Budgeting info: budg_data_growth 0, budg_dd_growth 0, budg_idx_growth 0
[   21.772449]  data budget sum 0, total budget sum 0, freeable_cnt 57
[   21.772449]  min_idx_lebs 3, old_idx_sz 49216, calc_idx_sz 49216, idx_gc_cnt 0
[   21.772449]  dirty_pg_cnt 0, dirty_zn_cnt 0, clean_zn_cnt 280
[   21.772449]  dark_wm 6144, dead_wm 2048, max_idx_node_sz 192
[   21.772449]  gc_lnum 109, ihead_lnum 12
[   21.772449]  jhead 0 (GC)     LEB -1
[   21.772449]  jhead 1 (base)   LEB -1
[   21.772449]  jhead 2 (data)   LEB -1
[   21.772449]  commit state 0
[   21.772449] Budgeting predictions:
[   21.772449]  available: 174003384, outstanding 0, free 171830940
[   21.773426] [<c0026820>] (unwind_backtrace+0x0/0xe4) from [<c0158e0c>] (dbg_check_space_info+0xd8/0x114)
[   21.783191] [<c0158e0c>] (dbg_check_space_info+0xd8/0x114) from [<c0128d3c>] (ubifs_remount_fs+0x528/0x8bc)
[   21.792957] [<c0128d3c>] (ubifs_remount_fs+0x528/0x8bc) from [<c008f7ec>] (do_remount_sb+0x8c/0x100)
[   21.802723] [<c008f7ec>] (do_remount_sb+0x8c/0x100) from [<c00a80f0>] (do_mount+0x4c0/0x7cc)
[   21.811512] [<c00a80f0>] (do_mount+0x4c0/0x7cc) from [<c00a8494>] (sys_mount+0x98/0xc8)
[   21.819324] [<c00a8494>] (sys_mount+0x98/0xc8) from [<c0021f40>] (ret_fast_syscall+0x0/0x28)


More information about the linux-mtd mailing list