Bug #33713 Crash mysql
Submitted: 6 Jan 2008 14:02 Modified: 31 Jan 2008 19:43
Reporter: morariu marius Email Updates:
Status: Not a Bug Impact on me:
None 
Category:MySQL Server: General Severity:S2 (Serious)
Version:5.0.37 OS:Linux (Crash)
Assigned to: CPU Architecture:Any
Tags: I use slackware 12

[6 Jan 2008 14:02] morariu marius 
Description:
I use slackware 12 with mysql version 5.0.37 and it seems mysql crashes...
071207 14:09:12  mysqld started
InnoDB: The first specified data file ./ibdata1 did not exist:
InnoDB: a new database to be created!
071207 14:09:12  InnoDB: Setting file ./ibdata1 size to 10 MB
InnoDB: Database physically writes the file full: wait...
071207 14:09:12  InnoDB: Log file ./ib_logfile0 did not exist: new to be created
InnoDB: Setting log file ./ib_logfile0 size to 5 MB
InnoDB: Database physically writes the file full: wait...
071207 14:09:13  InnoDB: Log file ./ib_logfile1 did not exist: new to be created
InnoDB: Setting log file ./ib_logfile1 size to 5 MB
InnoDB: Database physically writes the file full: wait...
InnoDB: Doublewrite buffer not found: creating new
InnoDB: Doublewrite buffer created
InnoDB: Creating foreign key constraint system tables
InnoDB: Foreign key constraint system tables created
071207 14:09:13  InnoDB: Started; log sequence number 0 0
071207 14:09:13 [Note] /usr/libexec/mysqld: ready for connections.
Version: '5.0.37'  socket: '/var/run/mysql/mysql.sock'  port: 0  Source distribution
071207 14:27:33 [Note] /usr/libexec/mysqld: Normal shutdown

071207 14:27:33  InnoDB: Starting shutdown...
071207 14:27:35  InnoDB: Shutdown completed; log sequence number 0 43655
071207 14:27:35 [Note] /usr/libexec/mysqld: Shutdown complete

071207 14:27:35  mysqld ended

071207 14:29:17  mysqld started
071207 14:29:18  InnoDB: Started; log sequence number 0 43655
071207 14:29:18 [Note] /usr/libexec/mysqld: ready for connections.
Version: '5.0.37'  socket: '/var/run/mysql/mysql.sock'  port: 0  Source distribution
071218 14:25:51  mysqld started
071218 14:25:52  InnoDB: Started; log sequence number 0 43655
071218 14:25:52 [Note] /usr/libexec/mysqld: ready for connections.
Version: '5.0.37'  socket: '/var/run/mysql/mysql.sock'  port: 0  Source distribution

Number of processes running now: 0
071227 15:25:08  mysqld restarted
071227 15:25:08  InnoDB: Started; log sequence number 0 43655
071227 15:25:08 [Note] /usr/libexec/mysqld: ready for connections.
Version: '5.0.37'  socket: '/var/run/mysql/mysql.sock'  port: 0  Source distribution

Number of processes running now: 0
080102 19:44:09  mysqld restarted
080102 19:44:10  InnoDB: Started; log sequence number 0 43655
080102 19:44:10 [Note] /usr/libexec/mysqld: ready for connections.
Version: '5.0.37'  socket: '/var/run/mysql/mysql.sock'  port: 0  Source distribution

Number of processes running now: 0
080102 19:44:17  mysqld restarted
080102 19:44:17  InnoDB: Started; log sequence number 0 43655
080102 19:44:17 [Note] /usr/libexec/mysqld: ready for connections.
Version: '5.0.37'  socket: '/var/run/mysql/mysql.sock'  port: 0  Source distribution

Number of processes running now: 0
080102 19:44:23  mysqld restarted
080102 19:44:23  InnoDB: Started; log sequence number 0 43655
080102 19:44:23 [Note] /usr/libexec/mysqld: ready for connections.
Version: '5.0.37'  socket: '/var/run/mysql/mysql.sock'  port: 0  Source distribution

Number of processes running now: 0
080102 19:44:26  mysqld restarted
080102 19:44:26  InnoDB: Started; log sequence number 0 43655
080102 19:44:26 [Note] /usr/libexec/mysqld: ready for connections.
Version: '5.0.37'  socket: '/var/run/mysql/mysql.sock'  port: 0  Source distribution

Number of processes running now: 0
080105 17:26:42  mysqld restarted
080105 17:26:43  InnoDB: Started; log sequence number 0 43655
080105 17:26:43 [Note] /usr/libexec/mysqld: ready for connections.
Version: '5.0.37'  socket: '/var/run/mysql/mysql.sock'  port: 0  Source distribution

How to repeat:
What can i do?
[7 Jan 2008 12:15] Susanne Ebrecht 
MySQL version 5.0.37 is quiet old. Please try newer version (5.0.51) and let us know, if the error still occurs.
[8 Jan 2008 6:41] MySQL Verification Team 
did kernel's oom killer kill the mysqld ?
[8 Jan 2008 21:04] morariu marius 
yes kernel killed mysql and restarted but i dont know why...What can i do?
[8 Jan 2008 21:08] morariu marius 
work kernel: CPU    0: Hot: hi:  186, btch:  31 usd: 174   Cold: hi:   62, btch:  15 usd:   1
Jan  2 19:44:05 rahova-network kernel: CPU    1: Hot: hi:  186, btch:  31 usd:  11   Cold: hi:   62, btch:  15 usd:  14
Jan  2 19:44:05 rahova-network kernel: CPU    2: Hot: hi:  186, btch:  31 usd: 158   Cold: hi:   62, btch:  15 usd:  11
Jan  2 19:44:05 rahova-network kernel: CPU    3: Hot: hi:  186, btch:  31 usd:  35   Cold: hi:   62, btch:  15 usd:   8
Jan  2 19:44:05 rahova-network kernel: Active:65358 inactive:3219 dirty:29 writeback:165 unstable:0
Jan  2 19:44:05 rahova-network kernel:  free:618686 slab:214807 mapped:3985 pagetables:224 bounce:0
Jan  2 19:44:05 rahova-network kernel: DMA free:3540kB min:68kB low:84kB high:100kB active:0kB inactive:0kB present:16256kB pages_scanned:0 all_unreclaimable? yes
Jan  2 19:44:05 rahova-network kernel: lowmem_reserve[]: 0 873 4048
Jan  2 19:44:05 rahova-network kernel: Normal free:3668kB min:3744kB low:4680kB high:5616kB active:208kB inactive:612kB present:894080kB pages_scanned:1640 all_unreclaimable? yes
Jan  2 19:44:05 rahova-network kernel: lowmem_reserve[]: 0 0 25400
Jan  2 19:44:05 rahova-network kernel: HighMem free:2467536kB min:512kB low:3916kB high:7324kB active:261224kB inactive:12264kB present:3251200kB pages_scanned:0 all_unreclaimable? no
Jan  2 19:44:05 rahova-network kernel: lowmem_reserve[]: 0 0 0
Jan  2 19:44:05 rahova-network kernel: DMA: 1*4kB 0*8kB 1*16kB 0*32kB 1*64kB 1*128kB 1*256kB 0*512kB 1*1024kB 1*2048kB 0*4096kB = 3540kB
Jan  2 19:44:05 rahova-network kernel: Normal: 1*4kB 29*8kB 0*16kB 1*32kB 1*64kB 1*128kB 1*256kB 0*512kB 1*1024kB 1*2048kB 0*4096kB = 3788kB
Jan  2 19:44:05 rahova-network kernel: HighMem: 1370*4kB 372*8kB 89*16kB 58*32kB 586*64kB 897*128kB 264*256kB 227*512kB 136*1024kB 57*2048kB 455*4096kB = 2467544kB
Jan  2 19:44:05 rahova-network kernel: Swap cache: add 0, delete 0, find 0/0, race 0+0
Jan  2 19:44:05 rahova-network kernel: Free swap  = 1004020kB
Jan  2 19:44:05 rahova-network kernel: Total swap = 1004020kB
Jan  2 19:44:05 rahova-network kernel: Out of memory: kill process 29634 (mysqld) score 26068 or a child
Jan  2 19:44:05 rahova-network kernel: Killed process 29634 (mysqld)
Jan  2 19:44:14 rahova-network kernel: verlihub invoked oom-killer: gfp_mask=0xd0, order=0, oomkilladj=0
Jan  2 19:44:14 rahova-network kernel:  [<c014a818>] out_of_memory+0x178/0x1b0
Jan  2 19:44:14 rahova-network kernel:  [<c014c0ac>] __alloc_pages+0x29c/0x2f0
Jan  2 19:44:14 rahova-network kernel:  [<c0129ba0>] lock_timer_base+0x20/0x50
Jan  2 19:44:14 rahova-network kernel:  [<c0162aae>] cache_alloc_refill+0x2de/0x540
Jan  2 19:44:14 rahova-network kernel:  [<c0133d3d>] finish_wait+0x2d/0x70
Jan  2 19:44:14 rahova-network kernel:  [<c0162d7c>] __kmalloc+0x6c/0x80
Jan  2 19:44:14 rahova-network kernel:  [<c068fc83>] __alloc_skb+0x53/0x110
Jan  2 19:44:14 rahova-network kernel:  [<c06bee42>] tcp_sendmsg+0x362/0xb20
Jan  2 19:44:14 rahova-network kernel:  [<c06ca6fc>] __tcp_push_pending_frames+0x15c/0x8a0
Jan  2 19:44:14 rahova-network kernel:  [<c06db507>] inet_sendmsg+0x37/0x70
Jan  2 19:44:14 rahova-network kernel:  [<c0689bb7>] sock_sendmsg+0x107/0x120
Jan  2 19:44:14 rahova-network kernel:  [<c0695abe>] net_tx_action+0xce/0x100
Jan  2 19:44:14 rahova-network kernel:  [<c0133c60>] autoremove_wake_function+0x0/0x50
Jan  2 19:44:14 rahova-network kernel:  [<c0125a52>] irq_exit+0x52/0x80
Jan  2 19:44:14 rahova-network kernel:  [<c0105440>] do_IRQ+0x40/0x80
Jan  2 19:44:14 rahova-network kernel:  [<c014bd45>] get_page_from_freelist+0x265/0x330
Jan  2 19:44:14 rahova-network kernel:  [<c0689f7f>] sys_sendto+0x12f/0x180
Jan  2 19:44:14 rahova-network kernel:  [<c06b3af2>] ip_local_deliver+0x122/0x2c0
Jan  2 19:44:14 rahova-network kernel:  [<c06947f3>] dev_hard_start_xmit+0x1e3/0x2c0
Jan  2 19:44:14 rahova-network kernel:  [<c014be67>] __alloc_pages+0x57/0x2f0
Jan  2 19:44:14 rahova-network kernel:  [<c06a5dd7>] __qdisc_run+0x77/0x1c0
Jan  2 19:44:14 rahova-network kernel:  [<c068f474>] __kfree_skb+0x54/0x130
Jan  2 19:44:14 rahova-network kernel:  [<c0695abe>] net_tx_action+0xce/0x100
Jan  2 19:44:14 rahova-network kernel:  [<c0125792>] __do_softirq+0x82/0xf0
Jan  2 19:44:14 rahova-network kernel:  [<c068a003>] sys_send+0x33/0x40
Jan  2 19:44:14 rahova-network kernel:  [<c068afb2>] sys_socketcall+0x142/0x280
Jan  2 19:44:14 rahova-network kernel:  [<c0102ae8>] syscall_call+0x7/0xb
Jan  2 19:44:14 rahova-network kernel:  [<c0710000>] __mutex_lock_slowpath+0x40/0x90
Jan  2 19:44:14 rahova-network kernel:  =======================
Jan  2 19:44:14 rahova-network kernel: DMA per-cpu:
Jan  2 19:44:14 rahova-network kernel: CPU    0: Hot: hi:    0, btch:   1 usd:   0   Cold: hi:    0, btch:   1 usd:   0
Jan  2 19:44:14 rahova-network kernel: CPU    1: Hot: hi:    0, btch:   1 usd:   0   Cold: hi:    0, btch:   1 usd:   0
Jan  2 19:44:14 rahova-network kernel: CPU    2: Hot: hi:    0, btch:   1 usd:   0   Cold: hi:    0, btch:   1 usd:   0
Jan  2 19:44:14 rahova-network kernel: CPU    3: Hot: hi:    0, btch:   1 usd:   0   Cold: hi:    0, btch:   1 usd:   0
Jan  2 19:44:14 rahova-network kernel: Normal per-cpu:
Jan  2 19:44:14 rahova-network kernel: CPU    0: Hot: hi:  186, btch:  31 usd:  30   Cold: hi:   62, btch:  15 usd:  49
Jan  2 19:44:14 rahova-network kernel: CPU    1: Hot: hi:  186, btch:  31 usd: 117   Cold: hi:   62, btch:  15 usd:  16
Jan  2 19:44:14 rahova-network kernel: CPU    2: Hot: hi:  186, btch:  31 usd: 163   Cold: hi:   62, btch:  15 usd:  50
Jan  2 19:44:14 rahova-network kernel: CPU    3: Hot: hi:  186, btch:  31 usd: 132   Cold: hi:   62, btch:  15 usd:  57
Jan  2 19:44:14 rahova-network kernel: HighMem per-cpu:
Jan  2 19:44:14 rahova-network kernel: CPU    0: Hot: hi:  186, btch:  31 usd:  19   Cold: hi:   62, btch:  15 usd:   3
[12 Jan 2008 15:22] MySQL Verification Team 
most likely a configuration problem.  you could downsize some my.cnf parameters, so that mysqld doesn't attempt to allocate so much memory.
[12 Jan 2008 18:49] morariu marius 
how can i downsize some my.cnf
parameters, so that mysqld doesn't attempt to allocate so much memory? You can help me?
[31 Jan 2008 19:43] Valeriy Kravchuk 
We're sorry, but the bug system is not the appropriate forum for asking help on using MySQL products. Your problem is, likely, not the result of a bug.

Support on using our products is available both free in our forums at http://forums.mysql.com/ and for a reasonable fee direct from our skilled support engineers at http://www.mysql.com/support/

Thank you for your interest in MySQL.