[Bug runtime/14467] New: on rawhide, getting "poison overwritten" kernel bug

["dsmith at redhat dot com" <sourceware-bugzilla at sourceware dot org>]

http://sourceware.org/bugzilla/show_bug.cgi?id=14467

             Bug #: 14467
           Summary: on rawhide, getting "poison overwritten" kernel bug
           Product: systemtap
           Version: unspecified
            Status: NEW
          Severity: normal
          Priority: P2
         Component: runtime
        AssignedTo: systemtap@sourceware.org
        ReportedBy: dsmith@redhat.com
    Classification: Unclassified


I'm occasionally get the following error on rawhide
(3.6.0-0.rc1.git2.1.fc18.i686.PAE), which indicates we're overwriting memory
somewhere.

This bug happens rarely - in a 42 test runs of utrace_p5.exp it only happened
once.

====
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.722313]
=============================================================================
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.723036] BUG utrace (Tainted: G
S      W   ): Poison overwritten
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.723255]
-----------------------------------------------------------------------------
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.723255] 
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.723255] INFO:
0xe29e6054-0xe29e6056. First byte 0x0 instead of 0x6b
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.723255] INFO: Allocated in
utrace_attach_task+0x167/0x270 [stap_f77a8495578afd43797271a2e02ffa8_28687]
age=202 cpu=1 pid=28687
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.723255]    
__slab_alloc.constprop.62+0x46d/0x4a3
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.723255]    
kmem_cache_alloc+0x204/0x250
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.723255]    
utrace_attach_task+0x167/0x270 [stap_f77a8495578afd43797271a2e02ffa8_28687]
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.723255]    
__stp_utrace_attach+0x56/0x1f0 [stap_f77a8495578afd43797271a2e02ffa8_28687]
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.723255]    
_stp_ctl_write_cmd+0xb79/0xf50 [stap_f77a8495578afd43797271a2e02ffa8_28687]
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.723255]    
vfs_write+0x8c/0x160
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.723255]     sys_write+0x3d/0x70
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.723255]    
sysenter_do_call+0x12/0x38
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.723255] INFO: Freed in
utrace_attach_task+0x1d1/0x270 [stap_f77a8495578afd43797271a2e02ffa8_28687]
age=207 cpu=1 pid=28687
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.723255]    
__slab_free+0x37/0x31b
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.723255]    
kmem_cache_free+0x20d/0x220
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.723255]    
utrace_attach_task+0x1d1/0x270 [stap_f77a8495578afd43797271a2e02ffa8_28687]
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.723255]    
__stp_utrace_attach+0x56/0x1f0 [stap_f77a8495578afd43797271a2e02ffa8_28687]
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.723255]    
_stp_ctl_write_cmd+0xb79/0xf50 [stap_f77a8495578afd43797271a2e02ffa8_28687]
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.723255]    
vfs_write+0x8c/0x160
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.723255]     sys_write+0x3d/0x70
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.723255]    
sysenter_do_call+0x12/0x38
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.723255] INFO: Slab 0xf5aa7cc0
objects=15 used=15 fp=0x  (null) flags=0x40000080
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.723255] INFO: Object 0xe29e6000
@offset=0 fp=0xe29e6e70
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.723255] 
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.723255] Object e29e6000: 6b 6b
6b 6b 6b 6b 6b 6b 6b 6b 6b 6b 6b 6b 6b 6b  kkkkkkkkkkkkkkkk
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.723255] Object e29e6010: 6b 6b
6b 6b 6b 6b 6b 6b 6b 6b 6b 6b 6b 6b 6b 6b  kkkkkkkkkkkkkkkk
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.723255] Object e29e6020: 6b 6b
6b 6b 6b 6b 6b 6b 6b 6b 6b 6b 6b 6b 6b 6b  kkkkkkkkkkkkkkkk
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.723255] Object e29e6030: 6b 6b
6b 6b 6b 6b 6b 6b 6b 6b 6b 6b 6b 6b 6b 6b  kkkkkkkkkkkkkkkk
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.723255] Object e29e6040: 6b 6b
6b 6b 6b 6b 6b 6b 6b 6b 6b 6b 6b 6b 6b 6b  kkkkkkkkkkkkkkkk
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.723255] Object e29e6050: 6b 6b
6b 6b 00 cf 60 f8                          kkkk..`.
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.723255] Redzone e29e6058: bb bb
bb bb                                      ....
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.740096] Padding e29e6100: 5a 5a
5a 5a 5a 5a 5a 5a                          ZZZZZZZZ
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.740096] Pid: 28692, comm:
expect Tainted: G S      W    3.6.0-0.rc1.git2.1.fc18.i686.PAE #1
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.740096] Call Trace:
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.740096]  [<c0571962>]
print_trailer+0xe2/0x130
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.740096]  [<c0571ac3>]
check_bytes_and_report+0xc3/0x100
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.740096]  [<c0572259>]
check_object+0x1b9/0x200
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.740096]  [<c0a143c8>]
alloc_debug_processing+0x57/0xfb
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.740096]  [<c0a14caa>] ?
__slab_alloc.constprop.62+0x335/0x4a3
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.740096]  [<c0a14de2>]
__slab_alloc.constprop.62+0x46d/0x4a3
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.740096]  [<f860cad7>] ?
utrace_attach_task+0x167/0x270 [stap_f77a8495578afd43797271a2e02ffa8_28687]
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.740096]  [<f860cad7>] ?
utrace_attach_task+0x167/0x270 [stap_f77a8495578afd43797271a2e02ffa8_28687]
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.740096]  [<f860b025>] ?
task_utrace_struct+0x15/0x30 [stap_f77a8495578afd43797271a2e02ffa8_28687]
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.740096]  [<c0573944>]
kmem_cache_alloc+0x204/0x250
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.740096]  [<f860b038>] ?
task_utrace_struct+0x28/0x30 [stap_f77a8495578afd43797271a2e02ffa8_28687]
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.740096]  [<f860cad7>] ?
utrace_attach_task+0x167/0x270 [stap_f77a8495578afd43797271a2e02ffa8_28687]
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.740096]  [<c0a1d312>] ?
_raw_spin_unlock+0x22/0x30
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.740096]  [<f860cad7>]
utrace_attach_task+0x167/0x270 [stap_f77a8495578afd43797271a2e02ffa8_28687]
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.740096]  [<f8610686>]
__stp_utrace_attach+0x56/0x1f0 [stap_f77a8495578afd43797271a2e02ffa8_28687]
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.740096]  [<f8610bc6>]
__stp_tf_clone_worker+0x86/0xb0 [stap_f77a8495578afd43797271a2e02ffa8_28687]
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.740096]  [<c0477e4d>]
task_work_run+0x4d/0x60
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.740096]  [<c0417331>]
do_notify_resume+0x71/0xb0
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.740096]  [<c0a1d6f2>]
work_notifysig+0x35/0x3b
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.740096] FIX utrace: Restoring
0xe29e6054-0xe29e6056=0x6b
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.740096] 
Aug 14 13:46:49 kvm-rawhide-32-1 kernel: [ 7422.740096] FIX utrace: Marking all
objects used
Aug 14 13:46:54 kvm-rawhide-32-1 kernel: [ 7427.801963] SLUB utrace:
kmem_cache_destroy called for cache that still has objects.
Aug 14 13:46:54 kvm-rawhide-32-1 kernel: [ 7427.803222] Pid: 28687, comm:
stapio Tainted: G S      W    3.6.0-0.rc1.git2.1.fc18.i686.PAE #1
Aug 14 13:46:54 kvm-rawhide-32-1 kernel: [ 7427.803229] Call Trace:
Aug 14 13:46:54 kvm-rawhide-32-1 kernel: [ 7427.803251]  [<c05750a1>]
kmem_cache_destroy+0x261/0x2f0
Aug 14 13:46:54 kvm-rawhide-32-1 kernel: [ 7427.803284]  [<f860c94b>]
utrace_exit+0x1b/0x40 [stap_f77a8495578afd43797271a2e02ffa8_28687]
Aug 14 13:46:54 kvm-rawhide-32-1 kernel: [ 7427.803299]  [<f86114ee>]
_stp_cleanup_and_exit+0x12e/0x370 [stap_f77a8495578afd43797271a2e02ffa8_28687]
Aug 14 13:46:54 kvm-rawhide-32-1 kernel: [ 7427.803312]  [<c055229e>] ?
might_fault+0x9e/0xb0
Aug 14 13:46:54 kvm-rawhide-32-1 kernel: [ 7427.803325]  [<f8611a2a>]
_stp_ctl_write_cmd+0x1ca/0xf50 [stap_f77a8495578afd43797271a2e02ffa8_28687]
Aug 14 13:46:54 kvm-rawhide-32-1 kernel: [ 7427.803339]  [<c067d047>] ?
selinux_file_permission+0xe7/0x130
Aug 14 13:46:54 kvm-rawhide-32-1 kernel: [ 7427.803348]  [<c06772b4>] ?
security_file_permission+0x24/0xb0
Aug 14 13:46:54 kvm-rawhide-32-1 kernel: [ 7427.803357]  [<c0589303>] ?
rw_verify_area+0x63/0x110
Aug 14 13:46:54 kvm-rawhide-32-1 kernel: [ 7427.803364]  [<c058b10f>] ?
fget_light+0x2f/0x490
Aug 14 13:46:54 kvm-rawhide-32-1 kernel: [ 7427.803376]  [<f8611860>] ?
_stp_build_id_check.constprop.63+0xf0/0xf0
[stap_f77a8495578afd43797271a2e02ffa8_28687]
Aug 14 13:46:54 kvm-rawhide-32-1 kernel: [ 7427.803383]  [<c058968c>]
vfs_write+0x8c/0x160
Aug 14 13:46:54 kvm-rawhide-32-1 kernel: [ 7427.803394]  [<f8611860>] ?
_stp_build_id_check.constprop.63+0xf0/0xf0
[stap_f77a8495578afd43797271a2e02ffa8_28687]
Aug 14 13:46:54 kvm-rawhide-32-1 kernel: [ 7427.803401]  [<c058996d>]
sys_write+0x3d/0x70
Aug 14 13:46:54 kvm-rawhide-32-1 kernel: [ 7427.803414]  [<c0a1d5d4>]
syscall_call+0x7/0xb
====

-- 
Configure bugmail: http://sourceware.org/bugzilla/userprefs.cgi?tab=email
------- You are receiving this mail because: -------
You are the assignee for the bug.