I did a large number of mkdir -p's directly on a branch, so that mkdir
created up to three levels of directories on the branch (I.e. mkdir -p
/vault/disk1/foo/bar/baz when /vault/disk1/foo did not exist).
dmesg gave me all this output, then the box froze (I rebooted).
Kernel version: 2.6.20.3 GNU/Linux
AUFS version: 20080121
Default local.mk, except for
CONFIG_AUFS_HINOTIFY = y
CONFIG_AUFS_EXPORT = y
/proc/mounts says:
none /storage aufs
rw,xino=/vault/disk2/.aufs.xino,udba=inotify,br:/vault/disk1=rw:/vault/disk2=rw:/vault/disk5=rw:/vault/disk4=rw:/vault/disk3=rw:/vault/disk6=rw
0 0
But it's incorrect, as it has been remounted using:
mount -lo remount,del:/vault/disk1,prepend:/vault/disk1=rw /storage
(It's done automatically, since it has more free space)
dmesg output attached in log.txt. :)
I haven't had any other problems though. :-)
Kindest regards, Jørgen P. Tjernø.
[878571.742915] Slab corruption: start=c69b34b4, len=32
[878571.745786] Redzone: 0x5a2cf071/0x5a2cf071.
[878571.748791] Last user: [<f913d333>](au_kzrealloc+0xe3/0x150 [aufs])
[878571.751886] 000: 6b 6b 6b 6b 6b 6b 6b 6b 00 04 00 00 00 e0 5d d9
[878571.755137] Prev obj: start=c69b3488, len=32
[878571.758159] Redzone: 0x170fc2a5/0x170fc2a5.
[878571.761050] Last user: [<c0162644>](cache_alloc_refill+0x564/0x660)
[878571.764115] 000: 30 34 9b c6 30 df 8d c1 00 00 00 00 00 a0 e4 c2
[878571.767371] 010: 01 00 00 00 ff ff ff ff 00 00 5a 5a fe ff ff ff
[878571.770611] Next obj: start=c69b34e0, len=32
[878571.773635] Redzone: 0x170fc2a5/0x170fc2a5.
[878571.776645] Last user: [<f913d2e9>](au_kzrealloc+0x99/0x150 [aufs])
[878571.779599] 000: 00 04 00 00 00 40 1d cd 00 00 00 00 00 00 00 00
[878571.782847] 010: 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a a5
[878571.786302] Slab corruption: start=c69b34b4, len=32
[878571.789307] Redzone: 0x5a2cf071/0x5a2cf071.
[878571.792313] Last user: [<f913d333>](au_kzrealloc+0xe3/0x150 [aufs])
[878571.795251] 010: 00 04 00 00 00 c0 b5 f2 6b 6b 6b 6b 6b 6b 6b a5
[878571.798500] Prev obj: start=c69b3488, len=32
[878571.801519] Redzone: 0x170fc2a5/0x170fc2a5.
[878571.804535] Last user: [<c0162644>](cache_alloc_refill+0x564/0x660)
[878571.807609] 000: 30 34 9b c6 30 df 8d c1 00 00 00 00 00 a0 e4 c2
[878571.810773] 010: 01 00 00 00 ff ff ff ff 00 00 5a 5a fe ff ff ff
[878571.813993] Next obj: start=c69b34e0, len=32
[878571.817007] Redzone: 0x170fc2a5/0x170fc2a5.
[878571.820018] Last user: [<f913d2e9>](au_kzrealloc+0x99/0x150 [aufs])
[878571.823104] 000: 00 04 00 00 00 40 1d cd 00 00 00 00 00 00 00 00
[878571.826404] 010: 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a a5
[878571.829685] slab error in verify_redzone_free(): cache `size-32': double
free detected
[878571.835666] [<c010408a>] show_trace_log_lvl+0x1a/0x30
[878571.835671] [<c01047a2>] show_trace+0x12/0x20
[878571.835674] [<c0104856>] dump_stack+0x16/0x20
[878571.835677] [<c01611f6>] __slab_error+0x26/0x30
[878571.835680] [<c016188c>] cache_free_debugcheck+0x19c/0x1d0
[878571.835684] [<c0161a15>] kfree+0x55/0xb0
[878571.835686] [<f913d333>] au_kzrealloc+0xe3/0x150 [aufs]
[878571.835704] [<f91234e1>] au_dpages_append+0x71/0x100 [aufs]
[878571.835718] [<f912398f>] au_dcsub_pages+0xdf/0x1c0 [aufs]
[878571.835732] [<f913f0c8>] hin_digen_tree+0x48/0x230 [aufs]
[878571.835748] [<f913f800>] hin_job+0x550/0x690 [aufs]
[878571.835764] [<f9140750>] postproc+0x200/0x660 [aufs]
[878571.835780] [<f9122fb9>] wkq_func+0x19/0xf0 [aufs]
[878571.835794] [<c0130474>] run_workqueue+0x94/0x140
[878571.835797] [<c0130c38>] worker_thread+0x138/0x160
[878571.835800] [<c0133937>] kthread+0xb7/0xe0
[878571.835804] [<c0103ca3>] kernel_thread_helper+0x7/0x14
[878571.835807] =======================
[878571.835809] c69b34b0: redzone 1:0x5a2cf071, redzone 2:0x5a2cf071.
[878571.839023] slab error in verify_redzone_free(): cache `size-32': memory
outside object was overwritten
[878571.844881] [<c010408a>] show_trace_log_lvl+0x1a/0x30
[878571.844884] [<c01047a2>] show_trace+0x12/0x20
[878571.844887] [<c0104856>] dump_stack+0x16/0x20
[878571.844890] [<c01611f6>] __slab_error+0x26/0x30
[878571.844893] [<c0161813>] cache_free_debugcheck+0x123/0x1d0
[878571.844896] [<c0161a15>] kfree+0x55/0xb0
[878571.844899] [<f913d333>] au_kzrealloc+0xe3/0x150 [aufs]
[878571.844916] [<f91234e1>] au_dpages_append+0x71/0x100 [aufs]
[878571.844930] [<f912398f>] au_dcsub_pages+0xdf/0x1c0 [aufs]
[878571.844944] [<f913f0c8>] hin_digen_tree+0x48/0x230 [aufs]
[878571.844960] [<f913f800>] hin_job+0x550/0x690 [aufs]
[878571.844976] [<f9140750>] postproc+0x200/0x660 [aufs]
[878571.844992] [<f9122fb9>] wkq_func+0x19/0xf0 [aufs]
[878571.845006] [<c0130474>] run_workqueue+0x94/0x140
[878571.845008] [<c0130c38>] worker_thread+0x138/0x160
[878571.845011] [<c0133937>] kthread+0xb7/0xe0
[878571.845014] [<c0103ca3>] kernel_thread_helper+0x7/0x14
[878571.845017] =======================
[878571.845019] c69b34b0: redzone 1:0x5a2cf071, redzone 2:0x400.
[878571.848204] slab error in verify_redzone_free(): cache `size-32': double
free detected
[878571.854189] [<c010408a>] show_trace_log_lvl+0x1a/0x30
[878571.854192] [<c01047a2>] show_trace+0x12/0x20
[878571.854195] [<c0104856>] dump_stack+0x16/0x20
[878571.854198] [<c01611f6>] __slab_error+0x26/0x30
[878571.854200] [<c016188c>] cache_free_debugcheck+0x19c/0x1d0
[878571.854204] [<c0161a15>] kfree+0x55/0xb0
[878571.854206] [<f913d333>] au_kzrealloc+0xe3/0x150 [aufs]
[878571.854223] [<f91234e1>] au_dpages_append+0x71/0x100 [aufs]
[878571.854237] [<f912398f>] au_dcsub_pages+0xdf/0x1c0 [aufs]
[878571.854252] [<f913f0c8>] hin_digen_tree+0x48/0x230 [aufs]
[878571.854268] [<f913f800>] hin_job+0x550/0x690 [aufs]
[878571.854283] [<f9140750>] postproc+0x200/0x660 [aufs]
[878571.854299] [<f9122fb9>] wkq_func+0x19/0xf0 [aufs]
[878571.854313] [<c0130474>] run_workqueue+0x94/0x140
[878571.854316] [<c0130c38>] worker_thread+0x138/0x160
[878571.854319] [<c0133937>] kthread+0xb7/0xe0
[878571.854322] [<c0103ca3>] kernel_thread_helper+0x7/0x14
[878571.854324] =======================
[878571.854327] c69b34b0: redzone 1:0x5a2cf071, redzone 2:0x5a2cf071.
[878571.857426] BUG: unable to handle kernel paging request at virtual address
6b6b6b6b
[878571.863268] printing eip:
[878571.866246] f913f181
[878571.866247] *pde = 00000000
[878571.869241] Oops: 0000 [#1]
[878571.872219] SMP
[878571.875204] Modules linked in: bnep rfcomm l2cap aufs sata_via skge
sata_promise
[878571.881153] CPU: 0
[878571.881154] EIP: 0060:[<f913f181>] Not tainted VLI
[878571.881155] EFLAGS: 00010246 (2.6.20.3 #9)
[878571.890191] EIP is at hin_digen_tree+0x101/0x230 [aufs]
[878571.893211] eax: 00000000 ebx: 00000001 ecx: 6b6b6b6b edx: 6b6b6b6b
[878571.896126] esi: 00000000 edi: 6b6b6b6b ebp: c1913e28 esp: c1913de0
[878571.899195] ds: 007b es: 007b ss: 0068
[878571.902206] Process events/0 (pid: 5, ti=c1912000 task=c18fb560
task.ti=c1912000)
[878571.905321] Stack: 00000000 c1913dfc c03b11b9 c0129aa9 00000000 c0707b00
00000082 c1913e30
[878571.911334] 00000001 eb987b80 00000000 00000000 6b6b6b6b 00000007
c69b34b4 00000001
[878571.917417] eb987be2 f4c2895a c1913e88 f913f800 c1913e48 c0143d21
0000000e c0648700
[878571.923539] Call Trace:
[878571.929258] [<c010408a>] show_trace_log_lvl+0x1a/0x30
[878571.932303] [<c0104151>] show_stack_log_lvl+0xb1/0xe0
[878571.935352] [<c0104341>] show_registers+0x1c1/0x2b0
[878571.938397] [<c010454c>] die+0x11c/0x270
[878571.941422] [<c0114def>] do_page_fault+0x2af/0x580
[878571.944389] [<c04e1b94>] error_code+0x7c/0x84
[878571.947353] [<f913f800>] hin_job+0x550/0x690 [aufs]
[878571.950410] [<f9140750>] postproc+0x200/0x660 [aufs]
[878571.953471] [<f9122fb9>] wkq_func+0x19/0xf0 [aufs]
[878571.956519] [<c0130474>] run_workqueue+0x94/0x140
[878571.959555] [<c0130c38>] worker_thread+0x138/0x160
[878571.962442] [<c0133937>] kthread+0xb7/0xe0
[878571.965470] [<c0103ca3>] kernel_thread_helper+0x7/0x14
[878571.968514] =======================
[878571.971514] Code: 90 0f c1 10 8b 45 d8 85 c0 74 0f 8b 43 0c 85 c0 74 08 e8
63 fe ff ff 8d 76 00 83 c6 01 39 f7 74 5d a1 b4 7b 15 f9 8b 4d e8 85 c0 <8b> 1c
b1 0f 84 78 ff ff ff 8b 43 24 65 8b 15 08 00 00 00 89 44
[878571.981332] EIP: [<f913f181>] hin_digen_tree+0x101/0x230 [aufs] SS:ESP
0068:c1913de0
[878571.992219] <3>Slab corruption: start=c69b34b4, len=32
[878572.024040] Redzone: 0x170fc2a5/0x170fc2a5.
[878572.027069] Last user: [<c03578f7>](bit_cursor+0x1c7/0x5a0)
[878572.030002] 000: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ff ff
[878572.033384] 010: 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a a5
[878572.036769] Prev obj: start=c69b3488, len=32
[878572.039796] Redzone: 0x170fc2a5/0x170fc2a5.
[878572.042819] Last user: [<c0162644>](cache_alloc_refill+0x564/0x660)
[878572.045767] 000: 30 34 9b c6 30 df 8d c1 00 00 00 00 00 a0 e4 c2
[878572.049153] 010: 01 00 00 00 ff ff ff ff 00 00 5a 5a fe ff ff ff
[878572.052534] Next obj: start=c69b34e0, len=32
[878572.055560] Redzone: 0x400/0x170fc2a5.
[878572.058575] Last user: [<f913d2e9>](au_kzrealloc+0x99/0x150 [aufs])
[878572.061599] 000: 00 b0 40 ea ab 01 00 00 00 d0 69 f6 00 00 00 00
[878572.064973] 010: 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a a5
[878572.068354] slab error in cache_alloc_debugcheck_after(): cache `size-32':
double free, or memory outside object was overwritten
[878572.074450] [<c010408a>] show_trace_log_lvl+0x1a/0x30
[878572.077532] [<c01047a2>] show_trace+0x12/0x20
[878572.080584] [<c0104856>] dump_stack+0x16/0x20
[878572.083637] [<c01611f6>] __slab_error+0x26/0x30
[878572.086684] [<c0161686>] cache_alloc_debugcheck_after+0xc6/0x130
[878572.089767] [<c01629e1>] kmem_cache_alloc+0x61/0x90
[878572.092825] [<c0162644>] cache_alloc_refill+0x564/0x660
[878572.095741] [<c0162a02>] kmem_cache_alloc+0x82/0x90
[878572.098800] [<c01e86a9>] jbd_slab_alloc+0x19/0x20
[878572.101861] [<c01e4ac6>] journal_get_undo_access+0xb6/0x170
[878572.104938] [<c01e03ef>] __ext3_journal_get_undo_access+0x1f/0x50
[878572.108022] [<c01d1703>] ext3_try_to_allocate_with_rsv+0x33/0x510
[878572.111087] [<c01d1dbf>] ext3_new_blocks+0x1df/0x560
[878572.114034] [<c01d5040>] ext3_get_blocks_handle+0x430/0x9d0
[878572.117116] [<c01d58b8>] ext3_get_block+0x78/0xf0
[878572.120178] [<c01867cf>] __block_prepare_write+0x27f/0x440
[878572.123249] [<c01869b8>] block_prepare_write+0x28/0x40
[878572.126307] [<c01d6d8d>] ext3_prepare_write+0x8d/0x2f0
[878572.129221] [<c014898a>] generic_file_buffered_write+0x28a/0x670
[878572.132303] [<c014902c>] __generic_file_aio_write_nolock+0x2bc/0x590
[878572.135393] [<c0149353>] generic_file_aio_write+0x53/0xc0
[878572.138457] [<c01d2e5d>] ext3_file_write+0x2d/0xc0
[878572.141517] [<c0165761>] do_sync_readv_writev+0xb1/0xf0
[878572.144561] [<c0165eda>] do_readv_writev+0xba/0x1a0
[878572.147515] [<c0165fff>] vfs_writev+0x3f/0x60
[878572.150559] [<c016654d>] sys_writev+0x3d/0xa0
[878572.153608] [<c0103084>] sysenter_past_esp+0x5d/0x81
[878572.156669] =======================
[878572.159686] c69b34b0: redzone 1:0x170fc2a5, redzone 2:0x170fc2a5
[878572.162611] Slab corruption: start=c69b34b4, len=32
[878572.165648] Redzone: 0x170fc2a5/0x170fc2a5.
[878572.168675] Last user: [<c0162644>](cache_alloc_refill+0x564/0x660)
[878572.171778] 000: 9c a1 7d f3 9c 63 df f7 00 00 00 00 00 00 55 ee
[878572.175158] 010: 01 00 00 00 ff ff ff ff 00 00 5a 5a fe ff ff ff
[878572.178459] Prev obj: start=c69b3488, len=32
[878572.181427] Redzone: 0x170fc2a5/0x170fc2a5.
[878572.184450] Last user: [<c0162644>](cache_alloc_refill+0x564/0x660)
[878572.187554] 000: 30 34 9b c6 30 df 8d c1 00 00 00 00 00 a0 e4 c2
[878572.190939] 010: 01 00 00 00 ff ff ff ff 00 00 5a 5a fe ff ff ff
[878572.194319] Next obj: start=c69b34e0, len=32
[878572.197194] Redzone: 0x400/0x170fc2a5.
[878572.200215] Last user: [<f913d2e9>](au_kzrealloc+0x99/0x150 [aufs])
[878572.203326] 000: 00 b0 40 ea ab 01 00 00 00 d0 69 f6 00 00 00 00
[878572.206703] 010: 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a a5
[878572.210084] slab error in cache_alloc_debugcheck_after(): cache `size-32':
double free, or memory outside object was overwritten
[878572.216031] [<c010408a>] show_trace_log_lvl+0x1a/0x30
[878572.219093] [<c01047a2>] show_trace+0x12/0x20
[878572.222137] [<c0104856>] dump_stack+0x16/0x20
[878572.225191] [<c01611f6>] __slab_error+0x26/0x30
[878572.228210] [<c0161686>] cache_alloc_debugcheck_after+0xc6/0x130
[878572.231196] [<c01629e1>] kmem_cache_alloc+0x61/0x90
[878572.234250] [<c0162644>] cache_alloc_refill+0x564/0x660
[878572.237317] [<c0162a02>] kmem_cache_alloc+0x82/0x90
[878572.240380] [<c01e86a9>] jbd_slab_alloc+0x19/0x20
[878572.243435] [<c01e4ac6>] journal_get_undo_access+0xb6/0x170
[878572.246352] [<c01e03ef>] __ext3_journal_get_undo_access+0x1f/0x50
[878572.249439] [<c01d1703>] ext3_try_to_allocate_with_rsv+0x33/0x510
[878572.252523] [<c01d1e60>] ext3_new_blocks+0x280/0x560
[878572.255589] [<c01d5040>] ext3_get_blocks_handle+0x430/0x9d0
[878572.258662] [<c01d58b8>] ext3_get_block+0x78/0xf0
[878572.261680] [<c01867cf>] __block_prepare_write+0x27f/0x440
[878572.264659] [<c01869b8>] block_prepare_write+0x28/0x40
[878572.267724] [<c01d6d8d>] ext3_prepare_write+0x8d/0x2f0
[878572.270793] [<c014898a>] generic_file_buffered_write+0x28a/0x670
[878572.273869] [<c014902c>] __generic_file_aio_write_nolock+0x2bc/0x590
[878572.276966] [<c0149353>] generic_file_aio_write+0x53/0xc0
[878572.279884] [<c01d2e5d>] ext3_file_write+0x2d/0xc0
[878572.282944] [<c0165761>] do_sync_readv_writev+0xb1/0xf0
[878572.286010] [<c0165eda>] do_readv_writev+0xba/0x1a0
[878572.289073] [<c0165fff>] vfs_writev+0x3f/0x60
[878572.292121] [<c016654d>] sys_writev+0x3d/0xa0
[878572.295133] [<c0103084>] sysenter_past_esp+0x5d/0x81
[878572.298104] =======================
[878572.301115] c69b34b0: redzone 1:0x170fc2a5, redzone 2:0x170fc2a5
[878572.313801] Slab corruption: start=c69b34b4, len=32
[878572.316904] Redzone: 0x170fc2a5/0x170fc2a5.
[878572.320142] Last user: [<c0162644>](cache_alloc_refill+0x564/0x660)
[878572.323249] 000: b4 34 9b c6 9c 63 df f7 00 00 00 00 00 40 c6 ce
[878572.326626] 010: 01 00 00 00 ff ff ff ff 00 00 5a 5a fe ff ff ff
[878572.329857] Prev obj: start=c69b3488, len=32
[878572.332883] Redzone: 0x170fc2a5/0x170fc2a5.
[878572.335905] Last user: [<c0162644>](cache_alloc_refill+0x564/0x660)
[878572.339003] 000: 30 34 9b c6 30 df 8d c1 00 00 00 00 00 a0 e4 c2
[878572.342379] 010: 01 00 00 00 ff ff ff ff 00 00 5a 5a fe ff ff ff
[878572.345675] Next obj: start=c69b34e0, len=32
[878572.348652] Redzone: 0x400/0x170fc2a5.
[878572.351668] Last user: [<f913d2e9>](au_kzrealloc+0x99/0x150 [aufs])
[878572.354783] 000: 00 b0 40 ea ab 01 00 00 00 d0 69 f6 00 00 00 00
[878572.358158] 010: 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a a5
[878572.361544] slab error in cache_alloc_debugcheck_after(): cache `size-32':
double free, or memory outside object was overwritten
[878572.367511] [<c010408a>] show_trace_log_lvl+0x1a/0x30
[878572.370576] [<c01047a2>] show_trace+0x12/0x20
[878572.373630] [<c0104856>] dump_stack+0x16/0x20
[878572.376679] [<c01611f6>] __slab_error+0x26/0x30
[878572.379594] [<c0161686>] cache_alloc_debugcheck_after+0xc6/0x130
[878572.382680] [<c01629e1>] kmem_cache_alloc+0x61/0x90
[878572.385738] [<c0162644>] cache_alloc_refill+0x564/0x660
[878572.388808] [<c0162a02>] kmem_cache_alloc+0x82/0x90
[878572.391870] [<c016dfb5>] getname+0x25/0xd0
[878572.394913] [<c016fc5b>] __user_walk_fd+0x1b/0x60
[878572.397821] [<c0164b54>] sys_faccessat+0x94/0x150
[878572.400876] [<c0164c30>] sys_access+0x20/0x30
[878572.403931] [<c0103084>] sysenter_past_esp+0x5d/0x81
[878572.406992] =======================
[878572.409999] c69b34b0: redzone 1:0x170fc2a5, redzone 2:0x170fc2a5
-------------------------------------------------------------------------
This SF.net email is sponsored by the 2008 JavaOne(SM) Conference
Don't miss this year's exciting event. There's still time to save $100.
Use priority code J8TL2D2.
http://ad.doubleclick.net/clk;198757673;13503038;p?http://java.sun.com/javaone