Ubuntu日本語フォーラム
ログインしていません。
お知らせ
#1 2012-01-20 21:25:41
- ziko8jp
- 新しいメンバ
- 登録日: 2012-01-20
ubuntu10.4server にてフリーズ現象発生
初めて投稿させて頂きます。
WEBサーバー運用開始から10日程ですが、初めてサーバーフリーズが発生してしまいました。
特にアップデート作業等していません。
お分かりになる方、解決方法をご教授頂ければ幸いです。
環境
マシン : ASUS EeeBOX1007
メモリ増設 : Transcend JetRam ノートPC用増設メモリ PC2-6400(DDR2-800) 2GB 永久保証 JM800QSU-2G
メモリ総容量 : 3GB
OS : ubuntu10.4 server 32bit(coreパッケージのみインストール)
主要インストールパッケージ一覧
apache2.2(wordpress使用)
mysql-server_5.1.41-3
php5_5.3.2-1
vsftpd_2.2.2-3
sysstat_9.0.6-2
uname -a コマンド結果
Linux webserver-1 2.6.32-21-generic-pae #32-Ubuntu SMP Fri Apr 16 09:39:35 UTC 2010 i686 GNU/Linux
/var/log/messages を確認した所、1月20日の01:43:59からログが追記されていません。
sar -C コマンド結果
Linux 2.6.32-21-generic-pae (webserver-1) 2012年01月20日 _i686_ (2 CPU)
00時00分01秒 CPU %user %nice %system %iowait %steal %idle
00時05分01秒 all 0.36 0.00 0.27 0.00 0.00 99.37
00時15分01秒 all 4.46 0.00 1.31 1.12 0.00 93.12
00時25分01秒 all 3.70 0.00 1.05 0.36 0.00 94.89
00時35分01秒 all 2.45 0.00 0.66 0.20 0.00 96.68
00時45分01秒 all 8.29 0.00 3.59 0.67 0.00 87.45
00時55分01秒 all 5.46 0.00 2.21 0.66 0.00 91.68
01時05分02秒 all 4.46 0.00 2.91 1.47 0.00 91.16
01時15分01秒 all 0.51 0.00 0.30 0.32 0.00 98.87
01時25分01秒 all 0.77 0.00 0.45 0.29 0.00 98.48
01時35分01秒 all 0.50 0.00 0.33 0.30 0.00 98.87
Average: all 3.24 0.00 1.36 0.57 0.00 94.83
20時52分37秒 LINUX RESTART
20時55分01秒 CPU %user %nice %system %iowait %steal %idle
21時05分01秒 all 1.37 0.00 2.54 0.12 0.00 95.97
21時15分01秒 all 0.78 0.00 1.90 0.00 0.00 97.32
Average: all 1.07 0.00 2.22 0.06 0.00 96.64
dmesg | tail -n 10 コマンド結果
[ 1533.403701] type=1505 audit(1327061871.867:60): operation="profile_replace" pid=4541 name="/usr/sbin/mysqld"
[ 1563.783950] type=1505 audit(1327061902.248:61): operation="profile_replace" pid=4611 name="/usr/sbin/mysqld"
[ 1594.158358] type=1505 audit(1327061932.623:62): operation="profile_replace" pid=4681 name="/usr/sbin/mysqld"
[ 1624.513238] type=1505 audit(1327061962.980:63): operation="profile_replace" pid=4758 name="/usr/sbin/mysqld"
[ 1654.853040] type=1505 audit(1327061993.319:64): operation="profile_replace" pid=4829 name="/usr/sbin/mysqld"
[ 1685.193209] type=1505 audit(1327062023.660:65): operation="profile_replace" pid=4899 name="/usr/sbin/mysqld"
[ 1715.532830] type=1505 audit(1327062053.999:66): operation="profile_replace" pid=4969 name="/usr/sbin/mysqld"
[ 1745.872993] type=1505 audit(1327062084.340:67): operation="profile_replace" pid=5039 name="/usr/sbin/mysqld"
[ 1776.213338] type=1505 audit(1327062114.679:68): operation="profile_replace" pid=5110 name="/usr/sbin/mysqld"
[ 1806.552371] type=1505 audit(1327062145.019:69): operation="profile_replace" pid=5180 name="/usr/sbin/mysqld"
mysqlが原因なのかなと感じているのですが、分かりません。
PC自体は電源が入っていたのですが、クライアントからのSSHログインが出来なかった為、電源断～電源ONを手動で行いました。
ご教授願います。
オフライン
#2 2012-01-21 00:31:27
- hmatsue
- アドバイザ
- 登録日: 2009-03-10
Re: ubuntu10.4server にてフリーズ現象発生
正直なところ、どこまで理解できるか自信はありませんが。。
異常発生時刻と思われる時間帯のsyslogやkern.logになにか異常を示す記録が残っていないでしょうか。
あれば、その内容を教えて下さい。
オフライン
#3 2012-01-21 21:00:31
- ziko8jp
- 新しいメンバ
- 登録日: 2012-01-20
Re: ubuntu10.4server にてフリーズ現象発生
ひろーさんお返事ありがとうございます。
syslogについては障害発生まで以下の内容が繰り返し書き込まれていました。
--------ログ内容 start------------
Jan 20 01:43:27 webserver-1 init: mysql post-start process (26964) terminated with status 1
Jan 20 01:43:27 webserver-1 kernel: [722191.903192] type=1505 audit(1326991407.570:23802): operation="profile_replace" pid=27032 name="/usr/sbin/mysqld"
Jan 20 01:43:28 webserver-1 init: mysql main process (27036) terminated with status 1
Jan 20 01:43:28 webserver-1 init: mysql main process ended, respawning
Jan 20 01:43:58 webserver-1 init: mysql post-start process (27037) terminated with status 1
--------ログ内容 end------------
障害発生時ログ。これ以降手動電源断するまでログは書き込まれていません。
--------ログ内容 start------------
Jan 20 01:43:59 webserver-1 kernel: [722223.700605] apparmor_parser invoked oom-killer: gfp_mask=0x42d0, order=3, oom_adj=0
Jan 20 01:43:59 webserver-1 kernel: [722223.700616] apparmor_parser cpuset=/ mems_allowed=0
Jan 20 01:43:59 webserver-1 kernel: [722223.700624] Pid: 27102, comm: apparmor_parser Not tainted 2.6.32-21-generic-pae #32-Ubuntu
Jan 20 01:43:59 webserver-1 kernel: [722223.700629] Call Trace:
Jan 20 01:43:59 webserver-1 kernel: [722223.700645] [<c01d4d34>] oom_kill_process+0xa4/0x2b0
Jan 20 01:43:59 webserver-1 kernel: [722223.700654] [<c01d53a9>] ? select_bad_process+0xa9/0xe0
Jan 20 01:43:59 webserver-1 kernel: [722223.700661] [<c01d5431>] __out_of_memory+0x51/0xa0
Jan 20 01:43:59 webserver-1 kernel: [722223.700669] [<c01d54d8>] out_of_memory+0x58/0xb0
Jan 20 01:43:59 webserver-1 kernel: [722223.700677] [<c01d7d17>] __alloc_pages_slowpath+0x407/0x4a0
Jan 20 01:43:59 webserver-1 kernel: [722223.700685] [<c01d7eea>] __alloc_pages_nodemask+0x13a/0x170
Jan 20 01:43:59 webserver-1 kernel: [722223.700693] [<c01d7f3c>] __get_free_pages+0x1c/0x30
Jan 20 01:43:59 webserver-1 kernel: [722223.700702] [<c0207639>] __kmalloc+0xf9/0x190
Jan 20 01:43:59 webserver-1 kernel: [722223.700710] [<c032b407>] ? apparmor_capable+0x27/0x80
Jan 20 01:43:59 webserver-1 kernel: [722223.700719] [<c032571d>] kvmalloc+0x1d/0x40
Jan 20 01:43:59 webserver-1 kernel: [722223.700727] [<c0325796>] aa_simple_write_to_buffer+0x56/0x100
Jan 20 01:43:59 webserver-1 kernel: [722223.700736] [<c02fe3b4>] ? security_file_permission+0x14/0x20
Jan 20 01:43:59 webserver-1 kernel: [722223.700743] [<c03258c6>] aa_profile_replace+0x26/0x50
Jan 20 01:43:59 webserver-1 kernel: [722223.700752] [<c0211aa2>] vfs_write+0xa2/0x1a0
Jan 20 01:43:59 webserver-1 kernel: [722223.700759] [<c03258a0>] ? aa_profile_replace+0x0/0x50
Jan 20 01:43:59 webserver-1 kernel: [722223.700767] [<c02123c2>] sys_write+0x42/0x70
Jan 20 01:43:59 webserver-1 kernel: [722223.700775] [<c0109763>] sysenter_do_call+0x12/0x28
Jan 20 01:43:59 webserver-1 kernel: [722223.700780] Mem-Info:
Jan 20 01:43:59 webserver-1 kernel: [722223.700784] DMA per-cpu:
Jan 20 01:43:59 webserver-1 kernel: [722223.700789] CPU 0: hi: 0, btch: 1 usd: 0
Jan 20 01:43:59 webserver-1 kernel: [722223.700794] CPU 1: hi: 0, btch: 1 usd: 0
Jan 20 01:43:59 webserver-1 kernel: [722223.700798] Normal per-cpu:
Jan 20 01:43:59 webserver-1 kernel: [722223.700803] CPU 0: hi: 186, btch: 31 usd: 0
Jan 20 01:43:59 webserver-1 kernel: [722223.700808] CPU 1: hi: 186, btch: 31 usd: 0
Jan 20 01:43:59 webserver-1 kernel: [722223.700812] HighMem per-cpu:
Jan 20 01:43:59 webserver-1 kernel: [722223.700816] CPU 0: hi: 186, btch: 31 usd: 0
Jan 20 01:43:59 webserver-1 kernel: [722223.700821] CPU 1: hi: 186, btch: 31 usd: 0
Jan 20 01:43:59 webserver-1 kernel: [722223.700832] active_anon:73780 inactive_anon:19671 isolated_anon:0
Jan 20 01:43:59 webserver-1 kernel: [722223.700835] active_file:12158 inactive_file:7823 isolated_file:0
Jan 20 01:43:59 webserver-1 kernel: [722223.700838] unevictable:0 dirty:0 writeback:0 unstable:0
Jan 20 01:43:59 webserver-1 kernel: [722223.700840] free:439583 slab_reclaimable:1291 slab_unreclaimable:137903
Jan 20 01:43:59 webserver-1 kernel: [722223.700843] mapped:3639 shmem:112 pagetables:462 bounce:0
Jan 20 01:43:59 webserver-1 kernel: [722223.700858] DMA free:3536kB min:64kB low:80kB high:96kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:8kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:15804kB mlocked:0kB dirty:0kB writeback:0kB mapped:0kB shmem:0kB slab_reclaimable:36kB slab_unreclaimable:4584kB kernel_stack:0kB pagetables:0kB unstable:0kB bounce:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? no
Jan 20 01:43:59 webserver-1 kernel: [722223.700870] lowmem_reserve[]: 0 867 3022 3022
Jan 20 01:43:59 webserver-1 kernel: [722223.700889] Normal free:8976kB min:3732kB low:4664kB high:5596kB active_anon:0kB inactive_anon:0kB active_file:100kB inactive_file:0kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:887976kB mlocked:0kB dirty:0kB writeback:0kB mapped:4kB shmem:0kB slab_reclaimable:5128kB slab_unreclaimable:547028kB kernel_stack:808kB pagetables:0kB unstable:0kB bounce:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? no
Jan 20 01:43:59 webserver-1 kernel: [722223.700901] lowmem_reserve[]: 0 0 17245 17245
Jan 20 01:43:59 webserver-1 kernel: [722223.700920] HighMem free:1745820kB min:512kB low:2832kB high:5152kB active_anon:295120kB inactive_anon:78684kB active_file:48532kB inactive_file:31284kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:2207392kB mlocked:0kB dirty:0kB writeback:0kB mapped:14552kB shmem:448kB slab_reclaimable:0kB slab_unreclaimable:0kB kernel_stack:0kB pagetables:1848kB unstable:0kB bounce:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? no
Jan 20 01:43:59 webserver-1 kernel: [722223.700933] lowmem_reserve[]: 0 0 0 0
Jan 20 01:43:59 webserver-1 kernel: [722223.700940] DMA: 10*4kB 21*8kB 8*16kB 4*32kB 2*64kB 3*128kB 4*256kB 3*512kB 0*1024kB 0*2048kB 0*4096kB = 3536kB
Jan 20 01:43:59 webserver-1 kernel: [722223.700961] Normal: 442*4kB 413*8kB 214*16kB 1*32kB 1*64kB 1*128kB 1*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB = 8976kB
Jan 20 01:43:59 webserver-1 kernel: [722223.700981] HighMem: 1191*4kB 881*8kB 458*16kB 1512*32kB 2060*64kB 928*128kB 269*256kB 64*512kB 13*1024kB 1*2048kB 320*4096kB = 1745860kB
Jan 20 01:43:59 webserver-1 kernel: [722223.701002] 20116 total pagecache pages
Jan 20 01:43:59 webserver-1 kernel: [722223.701006] 0 pages in swap cache
Jan 20 01:43:59 webserver-1 kernel: [722223.701011] Swap cache stats: add 0, delete 0, find 0/0
Jan 20 01:43:59 webserver-1 kernel: [722223.701015] Free swap = 39119864kB
Jan 20 01:43:59 webserver-1 kernel: [722223.701018] Total swap = 39119864kB
Jan 20 01:43:59 webserver-1 kernel: [722223.721669] 784016 pages RAM
Jan 20 01:43:59 webserver-1 kernel: [722223.721675] 556194 pages HighMem
Jan 20 01:43:59 webserver-1 kernel: [722223.721679] 12272 pages reserved
Jan 20 01:43:59 webserver-1 kernel: [722223.721682] 34915 pages shared
Jan 20 01:43:59 webserver-1 kernel: [722223.721686] 314635 pages non-shared
Jan 20 01:43:59 webserver-1 kernel: [722223.721693] Out of memory: kill process 5958 (apache2) score 18812 or a child
Jan 20 01:43:59 webserver-1 kernel: [722223.722052] Killed process 5958 (apache2)
Jan 20 01:43:59 webserver-1 kernel: [722223.824228] type=1505 audit(1326991439.494:23803): operation="profile_replace" pid=27102 name="/usr/sbin/mysqld"
Jan 20 01:44:00 webserver-1 init: mysql main process (27106) terminated with status 1
Jan 20 01:44:00 webserver-1 init: mysql main process ended, respawning
--------ログ内容 end------------
kernについては障害発生まで以下の内容が繰り返し書き込まれていました。
--------ログ内容 start------------
Jan 20 01:43:27 webserver-1 kernel: [722191.903192] type=1505 audit(1326991407.570:23802): operation="profile_replace" pid=27032 name="/usr/sbin/mysqld"
--------ログ内容 end------------
障害発生時ログ。これ以降手動電源断するまでログは書き込まれていません。
--------ログ内容 start------------
Jan 20 01:43:59 webserver-1 kernel: [722223.700605] apparmor_parser invoked oom-killer: gfp_mask=0x42d0, order=3, oom_adj=0
Jan 20 01:43:59 webserver-1 kernel: [722223.700616] apparmor_parser cpuset=/ mems_allowed=0
Jan 20 01:43:59 webserver-1 kernel: [722223.700624] Pid: 27102, comm: apparmor_parser Not tainted 2.6.32-21-generic-pae #32-Ubuntu
Jan 20 01:43:59 webserver-1 kernel: [722223.700629] Call Trace:
Jan 20 01:43:59 webserver-1 kernel: [722223.700645] [<c01d4d34>] oom_kill_process+0xa4/0x2b0
Jan 20 01:43:59 webserver-1 kernel: [722223.700654] [<c01d53a9>] ? select_bad_process+0xa9/0xe0
Jan 20 01:43:59 webserver-1 kernel: [722223.700661] [<c01d5431>] __out_of_memory+0x51/0xa0
Jan 20 01:43:59 webserver-1 kernel: [722223.700669] [<c01d54d8>] out_of_memory+0x58/0xb0
Jan 20 01:43:59 webserver-1 kernel: [722223.700677] [<c01d7d17>] __alloc_pages_slowpath+0x407/0x4a0
Jan 20 01:43:59 webserver-1 kernel: [722223.700685] [<c01d7eea>] __alloc_pages_nodemask+0x13a/0x170
Jan 20 01:43:59 webserver-1 kernel: [722223.700693] [<c01d7f3c>] __get_free_pages+0x1c/0x30
Jan 20 01:43:59 webserver-1 kernel: [722223.700702] [<c0207639>] __kmalloc+0xf9/0x190
Jan 20 01:43:59 webserver-1 kernel: [722223.700710] [<c032b407>] ? apparmor_capable+0x27/0x80
Jan 20 01:43:59 webserver-1 kernel: [722223.700719] [<c032571d>] kvmalloc+0x1d/0x40
Jan 20 01:43:59 webserver-1 kernel: [722223.700727] [<c0325796>] aa_simple_write_to_buffer+0x56/0x100
Jan 20 01:43:59 webserver-1 kernel: [722223.700736] [<c02fe3b4>] ? security_file_permission+0x14/0x20
Jan 20 01:43:59 webserver-1 kernel: [722223.700743] [<c03258c6>] aa_profile_replace+0x26/0x50
Jan 20 01:43:59 webserver-1 kernel: [722223.700752] [<c0211aa2>] vfs_write+0xa2/0x1a0
Jan 20 01:43:59 webserver-1 kernel: [722223.700759] [<c03258a0>] ? aa_profile_replace+0x0/0x50
Jan 20 01:43:59 webserver-1 kernel: [722223.700767] [<c02123c2>] sys_write+0x42/0x70
Jan 20 01:43:59 webserver-1 kernel: [722223.700775] [<c0109763>] sysenter_do_call+0x12/0x28
Jan 20 01:43:59 webserver-1 kernel: [722223.700780] Mem-Info:
Jan 20 01:43:59 webserver-1 kernel: [722223.700784] DMA per-cpu:
Jan 20 01:43:59 webserver-1 kernel: [722223.700789] CPU 0: hi: 0, btch: 1 usd: 0
Jan 20 01:43:59 webserver-1 kernel: [722223.700794] CPU 1: hi: 0, btch: 1 usd: 0
Jan 20 01:43:59 webserver-1 kernel: [722223.700798] Normal per-cpu:
Jan 20 01:43:59 webserver-1 kernel: [722223.700803] CPU 0: hi: 186, btch: 31 usd: 0
Jan 20 01:43:59 webserver-1 kernel: [722223.700808] CPU 1: hi: 186, btch: 31 usd: 0
Jan 20 01:43:59 webserver-1 kernel: [722223.700812] HighMem per-cpu:
Jan 20 01:43:59 webserver-1 kernel: [722223.700816] CPU 0: hi: 186, btch: 31 usd: 0
Jan 20 01:43:59 webserver-1 kernel: [722223.700821] CPU 1: hi: 186, btch: 31 usd: 0
Jan 20 01:43:59 webserver-1 kernel: [722223.700832] active_anon:73780 inactive_anon:19671 isolated_anon:0
Jan 20 01:43:59 webserver-1 kernel: [722223.700835] active_file:12158 inactive_file:7823 isolated_file:0
Jan 20 01:43:59 webserver-1 kernel: [722223.700838] unevictable:0 dirty:0 writeback:0 unstable:0
Jan 20 01:43:59 webserver-1 kernel: [722223.700840] free:439583 slab_reclaimable:1291 slab_unreclaimable:137903
Jan 20 01:43:59 webserver-1 kernel: [722223.700843] mapped:3639 shmem:112 pagetables:462 bounce:0
Jan 20 01:43:59 webserver-1 kernel: [722223.700858] DMA free:3536kB min:64kB low:80kB high:96kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:8kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:15804kB mlocked:0kB dirty:0kB writeback:0kB mapped:0kB shmem:0kB slab_reclaimable:36kB slab_unreclaimable:4584kB kernel_stack:0kB pagetables:0kB unstable:0kB bounce:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? no
Jan 20 01:43:59 webserver-1 kernel: [722223.700870] lowmem_reserve[]: 0 867 3022 3022
Jan 20 01:43:59 webserver-1 kernel: [722223.700889] Normal free:8976kB min:3732kB low:4664kB high:5596kB active_anon:0kB inactive_anon:0kB active_file:100kB inactive_file:0kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:887976kB mlocked:0kB dirty:0kB writeback:0kB mapped:4kB shmem:0kB slab_reclaimable:5128kB slab_unreclaimable:547028kB kernel_stack:808kB pagetables:0kB unstable:0kB bounce:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? no
Jan 20 01:43:59 webserver-1 kernel: [722223.700901] lowmem_reserve[]: 0 0 17245 17245
Jan 20 01:43:59 webserver-1 kernel: [722223.700920] HighMem free:1745820kB min:512kB low:2832kB high:5152kB active_anon:295120kB inactive_anon:78684kB active_file:48532kB inactive_file:31284kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:2207392kB mlocked:0kB dirty:0kB writeback:0kB mapped:14552kB shmem:448kB slab_reclaimable:0kB slab_unreclaimable:0kB kernel_stack:0kB pagetables:1848kB unstable:0kB bounce:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? no
Jan 20 01:43:59 webserver-1 kernel: [722223.700933] lowmem_reserve[]: 0 0 0 0
Jan 20 01:43:59 webserver-1 kernel: [722223.700940] DMA: 10*4kB 21*8kB 8*16kB 4*32kB 2*64kB 3*128kB 4*256kB 3*512kB 0*1024kB 0*2048kB 0*4096kB = 3536kB
Jan 20 01:43:59 webserver-1 kernel: [722223.700961] Normal: 442*4kB 413*8kB 214*16kB 1*32kB 1*64kB 1*128kB 1*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB = 8976kB
Jan 20 01:43:59 webserver-1 kernel: [722223.700981] HighMem: 1191*4kB 881*8kB 458*16kB 1512*32kB 2060*64kB 928*128kB 269*256kB 64*512kB 13*1024kB 1*2048kB 320*4096kB = 1745860kB
Jan 20 01:43:59 webserver-1 kernel: [722223.701002] 20116 total pagecache pages
Jan 20 01:43:59 webserver-1 kernel: [722223.701006] 0 pages in swap cache
Jan 20 01:43:59 webserver-1 kernel: [722223.701011] Swap cache stats: add 0, delete 0, find 0/0
Jan 20 01:43:59 webserver-1 kernel: [722223.701015] Free swap = 39119864kB
Jan 20 01:43:59 webserver-1 kernel: [722223.701018] Total swap = 39119864kB
Jan 20 01:43:59 webserver-1 kernel: [722223.721669] 784016 pages RAM
Jan 20 01:43:59 webserver-1 kernel: [722223.721675] 556194 pages HighMem
Jan 20 01:43:59 webserver-1 kernel: [722223.721679] 12272 pages reserved
Jan 20 01:43:59 webserver-1 kernel: [722223.721682] 34915 pages shared
Jan 20 01:43:59 webserver-1 kernel: [722223.721686] 314635 pages non-shared
Jan 20 01:43:59 webserver-1 kernel: [722223.721693] Out of memory: kill process 5958 (apache2) score 18812 or a child
Jan 20 01:43:59 webserver-1 kernel: [722223.722052] Killed process 5958 (apache2)
Jan 20 01:43:59 webserver-1 kernel: [722223.824228] type=1505 audit(1326991439.494:23803): operation="profile_replace" pid=27102 name="/usr/sbin/mysqld"
--------ログ内容 end------------
よろしくお願いします。
オフライン
#4 2012-01-21 23:36:33
- hmatsue
- アドバイザ
- 登録日: 2009-03-10
Re: ubuntu10.4server にてフリーズ現象発生
ziko8jp による投稿:
Jan 20 01:43:27 webserver-1 init: mysql post-start process (26964) terminated with status 1
Jan 20 01:43:27 webserver-1 kernel: [722191.903192] type=1505 audit(1326991407.570:23802): operation="profile_replace" pid=27032 name="/usr/sbin/mysqld"
Jan 20 01:43:28 webserver-1 init: mysql main process (27036) terminated with status 1
Jan 20 01:43:28 webserver-1 init: mysql main process ended, respawning
Jan 20 01:43:58 webserver-1 init: mysql post-start process (27037) terminated with status 1
延々とこのログが出力されているようなので、何かmysqlに問題がでているのでしょうね。
これが直接oom-killer(後述)の原因となっているのかは分かりませんが、
まずは、下記の現象と同様の原因ではないか確認してみて下さい。
(検索してでてきた、それらしいものをいくつかピックアップしました)
http://serverfault.com/questions/294163/mysql-server-restarts-every-30-seconds (ただし10.10でのお話です)
https://bugs.launchpad.net/ubuntu/+source/mysql-dfsg-5.1/+bug/573318
https://bugs.launchpad.net/ubuntu/+source/mysql-dfsg-5.1/+bug/608423
ziko8jp による投稿:
Jan 20 01:43:59 webserver-1 kernel: [722223.700605] apparmor_parser invoked oom-killer: gfp_mask=0x42d0, order=3, oom_adj=0
oom-killerが発動されているようです。
古い記事しか見つかりませんでしたが、
http://itpro.nikkeibp.co.jp/article/COLUMN/20061117/254053/
あたりが参考になるかと。
apparmorから召喚されているっぽいので、
https://bugs.launchpad.net/ubuntu/+source/mysql-dfsg-5.1/+bug/573318
あたりが怪しいのかなぁ、という気もします。
ところで、MySQLは動作していますでしょうか。
ログを見た感じでは起動に失敗し続けているように見えますが。。
もし、起動していたら、
/var/log/mysql.err
/var/log/mysql.log
あたりのログを見るとなにか出ているかも知れません。
もし、何かのバグで本来oom-killerが召喚されるべきではない状態で召喚されてしまっているというようなことがあれば、oom-killer自体が召喚されないようにするのが対策となるかと思います。
http://brokendish.org/debian/926/
あたりの操作で良さそうですが、召喚されるべくして召喚されている場合は根本的な解決とはなり得ません。
あと気になるのは、proposedなレポジトリを有効にしているのか、していないのか、
パッケージは全て最新の状態にアップデートされているのか、されていないのか、
あたりですね。
基本的にはproposedは有効にせず、その範囲内で最新の状態に更新されていることが安定、安全な動作の前提条件になるかと思います。
オフライン
#5 2012-01-22 01:02:26
- ziko8jp
- 新しいメンバ
- 登録日: 2012-01-20
Re: ubuntu10.4server にてフリーズ現象発生
ひろーさん早速のお返事ありがとうございます。
ご指摘頂いた点を調査して結果をお伝えしたいと思います。
ありがとうございました。
オフライン
#6 2012-02-03 00:29:01
- ziko8jp
- 新しいメンバ
- 登録日: 2012-01-20
Re: ubuntu10.4server にてフリーズ現象発生
ひろーさん早速のお返事ありがとうございます。
返事が遅くなり申し訳ありません。
proposedが有効になっているかどうかは分かりませんが、パッケージはDVDからのインストール以降パッケージアップデートは行っておらず、パッケージの手動更新もしていません。
oom-killerが原因の可能性もあるので、とりあえず、以下の対策を打ち、安定するか監視しようと思います。
”vm.overcommit_memoryを2に設定して、メモリオーバーコミットを無効にする。（再起動後は無効）
#sudo sysctl -w vm.overcommit_ratio=99
#sudo sysctl -w vm.overcommit_memory=2
これで安定すれば、
”vm.overcommit_memoryを2に設定して、メモリオーバーコミットを無効にする。（再起動後もずっと）
#echo '#メモリオーバーコミットを無効にする。'＞＞/etc/sysctl.conf
#echo 'vm.overcommit_ratio=99'＞＞/etc/sysctl.conf
#echo 'vm.overcommit_memory=2'＞＞/etc/sysctl.conf
を行いたいと思います。
とりあえず、syslogに頻発している
init: mysql main process (XXXX) terminated with status 1
init: mysql main process ended, respawning
が継続するか監視します。
また報告します。
オフライン
2007年10月11日以降の投稿は、クリエイティブ・コモンズ-表示-継承-3.0 (Cc-by-sa-3.0)で提供されます。
著作権等の他者の権利を不当に侵害するような投稿、特定の個人や団体などへの誹謗中傷を含む投稿、個人情報を含む投稿など、違法性のある投稿は行わないでください。
Ubuntu and Canonical are registered trademarks of Canonical Ltd.