Naohiro Aota
nao.a****@gmail*****
2008年 11月 27日 (木) 16:48:13 JST
TOMOYO
Fork青田です。
2ch のほうであれこれしてましたがあらためてこちらに。
新しくプロセスを起動しようとすると以下のような
Nov 26 07:11:58 [kernel] BUG: unable to handle kernel paging request at ffffffffffffffff
Nov 26 07:11:58 [kernel] IP: [<ffffffff80390839>] ccs_free+0x19/0x80
Nov 26 07:11:58 [kernel] PGD 203067 PUD 204067 PMD 0
Nov 26 07:11:58 [kernel] CPU 0
Nov 26 07:11:58 [kernel] Modules linked in: msr sr_mod vhba ipt_LOG ipt_REJECT ipt_recent iptable_filter nvidiafb fb_ddc i2c_algo_bit vgastate nvidia(P) sg thermal button evdev
Nov 26 07:11:58 [kernel] Pid: 28505, comm: init Tainted: P D W 2.6.27-ccs-r2 #2
Nov 26 07:11:58 [kernel] RIP: 0010:[<ffffffff80390839>] [<ffffffff80390839>] ccs_free+0x19/0x80
Nov 26 07:11:58 [kernel] RSP: 0018:ffff880054b3bc28 EFLAGS: 00010206
Nov 26 07:11:58 [kernel] RAX: ffff88009e93df68 RBX: ffffffffffffffff RCX: 0000000000000000
Nov 26 07:11:58 [kernel] RDX: 0000000000000020 RSI: ffffffffffffffff RDI: ffff880054b68000
Nov 26 07:11:58 [kernel] RBP: 00000000735bf579 R08: 00000000fffffffe R09: 000000000000000b
Nov 26 07:11:58 [kernel] R10: ffff880054b4ffa1 R11: 0000000054b4f000 R12: ffff88009e93df68
Nov 26 07:11:58 [kernel] R13: 000000006778a8de R14: ffff88009e802410 R15: 0000000000000000
Nov 26 07:11:58 [kernel] FS: 00007f2d090776f0(0000) GS:ffffffff80789e80(0000) knlGS:00000000f74836d0
Nov 26 07:11:58 [kernel] CS: 0010 DS: 0000 ES: 0000 CR0: 000000008005003b
Nov 26 07:11:58 [kernel] CR2: ffffffffffffffff CR3: 0000000055763000 CR4: 00000000000006e0
Nov 26 07:11:58 [kernel] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
Nov 26 07:11:58 [kernel] DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 0000000000000400
Nov 26 07:11:58 [kernel] Process init (pid: 28505, threadinfo ffff880054b3a000, task ffff880061aa05d0)
Nov 26 07:11:58 [kernel] Stack: 0000000000000000 ffffffff8038b28a 0000000000000246 0000000000000000
Nov 26 07:11:58 [kernel] ffffffff80787c88 ffff880054b68000 0000000000000000 ffff880054b3be58
Nov 26 07:11:58 [kernel] ffff88009e938162 ffff880058372000 ffff880054b4f000 ffff880054b4e000
Nov 26 07:11:58 [kernel] Call Trace:
Nov 26 07:11:58 [kernel] [<ffffffff8038b28a>] ? find_next_domain+0x4ca/0x910
Nov 26 07:11:58 [kernel] [<ffffffff8038bfd8>] ? search_binary_handler_with_transition+0xf8/0x6f0
Nov 26 07:11:58 [kernel] [<ffffffff802803bd>] ? follow_page+0x1cd/0x200
- Last output repeated twice -
Nov 26 07:11:58 [kernel] [<ffffffff80281ad4>] ? get_user_pages+0x104/0x430
Nov 26 07:11:58 [kernel] [<ffffffff8029e1a7>] ? copy_strings+0x1c7/0x1f0
Nov 26 07:11:58 [kernel] [<ffffffff8029f706>] ? do_execve+0x296/0x2d0
Nov 26 07:11:58 [kernel] [<ffffffff8020a6f9>] ? sys_execve+0x49/0x80
Nov 26 07:11:58 [kernel] [<ffffffff8020c61a>] ? stub_execve+0x6a/0xc0
Nov 26 07:11:58 [kernel] RIP [<ffffffff80390839>] ccs_free+0x19/0x80
Nov 26 07:11:58 [kernel] RSP <ffff880054b3bc28>
Nov 26 07:11:58 [kernel] ---[ end trace c7c7ca885d41477c ]---
sshd が (多分) audit log を書こうとすると以下のような
Nov 26 07:13:32 [kernel] BUG: unable to handle kernel paging request at ffffffffffffffff
Nov 26 07:13:32 [kernel] IP: [<ffffffff80390839>] ccs_free+0x19/0x80
Nov 26 07:13:32 [kernel] PGD 203067 PUD 204067 PMD 0
Nov 26 07:13:32 [kernel] CPU 0
Nov 26 07:13:32 [kernel] Modules linked in: msr sr_mod vhba ipt_LOG ipt_REJECT ipt_recent iptable_filter nvidiafb fb_ddc i2c_algo_bit vgastate nvidia(P) sg thermal button evdev
Nov 26 07:13:32 [kernel] Pid: 28520, comm: sshd Tainted: P D W 2.6.27-ccs-r2 #2
Nov 26 07:13:32 [kernel] RIP: 0010:[<ffffffff80390839>] [<ffffffff80390839>] ccs_free+0x19/0x80
Nov 26 07:13:32 [kernel] RSP: 0018:ffff880087e5b978 EFLAGS: 00010206
Nov 26 07:13:32 [kernel] RAX: 00000000000007e8 RBX: ffffffffffffffff RCX: 0000000000000000
Nov 26 07:13:32 [kernel] RDX: ffff880087e5be58 RSI: ffffffffffffffff RDI: ffff880054b3a000
Nov 26 07:13:32 [kernel] RBP: ffff880054bee000 R08: 00000000fffffffe R09: 0000000000000017
Nov 26 07:13:32 [kernel] R10: ffff880054bee892 R11: 0000000054bee000 R12: 0000000000000000
Nov 26 07:13:32 [kernel] R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000
Nov 26 07:13:32 [kernel] FS: 00007f1d77f7a6f0(0000) GS:ffffffff80789e80(0000) knlGS:00000000f74836d0
Nov 26 07:13:32 [kernel] CS: 0010 DS: 0000 ES: 0000 CR0: 000000008005003b
Nov 26 07:13:32 [kernel] CR2: ffffffffffffffff CR3: 0000000054a99000 CR4: 00000000000006e0
Nov 26 07:13:32 [kernel] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
Nov 26 07:13:32 [kernel] DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 0000000000000400
Nov 26 07:13:32 [kernel] Process sshd (pid: 28520, threadinfo ffff880087e5a000, task ffff880061aa1740)
Nov 26 07:13:32 [kernel] Stack: 0000000000000000 ffffffff80399f00 ffff880000006f68 0000000000000000
Nov 26 07:13:32 [kernel] ffff880000000000 87e5baf400000000 ffff880000000000 ffff880000000000
Nov 26 07:13:32 [kernel] ffff880000000000 0000000000000000 0000000000000000 ffff880000000000
Nov 26 07:13:32 [kernel] Call Trace:
Nov 26 07:13:32 [kernel] [<ffffffff80399f00>] ? ccs_init_audit_log+0x200/0x5e0
Nov 26 07:13:32 [kernel] [<ffffffff8039a3a6>] ? ccs_write_audit_log+0xc6/0x2c0
Nov 26 07:13:32 [kernel] [<ffffffff8038e4f0>] ? ccs_path_matches_pattern+0x160/0x200
Nov 26 07:13:32 [kernel] [<ffffffff803953e4>] ? check_single_path_acl2+0x94/0x100
Nov 26 07:13:32 [kernel] [<ffffffff80396777>] ? check_file_perm2+0xd7/0x2c0
Nov 26 07:13:32 [kernel] [<ffffffff8038b0e4>] ? find_next_domain+0x324/0x910
Nov 26 07:13:32 [kernel] [<ffffffff8038bfd8>] ? search_binary_handler_with_transition+0xf8/0x6f0
Nov 26 07:13:32 [kernel] [<ffffffff802803bd>] ? follow_page+0x1cd/0x200
Nov 26 07:13:32 [kernel] [<ffffffff803bddfa>] ? strnlen_user+0x2a/0x80
Nov 26 07:13:32 [kernel] [<ffffffff8029f706>] ? do_execve+0x296/0x2d0
Nov 26 07:13:32 [kernel] [<ffffffff8020a6f9>] ? sys_execve+0x49/0x80
Nov 26 07:13:32 [kernel] [<ffffffff8020c61a>] ? stub_execve+0x6a/0xc0
Nov 26 07:13:32 [kernel] RIP [<ffffffff80390839>] ccs_free+0x19/0x80
Nov 26 07:13:32 [kernel] RSP <ffff880087e5b978>
Nov 26 07:13:32 [kernel] ---[ end trace c7c7ca885d41477c ]---
cron が動こうとするとこのような
Nov 26 07:20:01 [kernel] BUG: unable to handle kernel paging request at ffffffffffffffff
Nov 26 07:20:01 [kernel] IP: [<ffffffff80390839>] ccs_free+0x19/0x80
Nov 26 07:20:01 [kernel] PGD 203067 PUD 204067 PMD 0
Nov 26 07:20:01 [kernel] CPU 0
Nov 26 07:20:01 [kernel] Modules linked in: msr sr_mod vhba ipt_LOG ipt_REJECT ipt_recent iptable_filter nvidiafb fb_ddc i2c_algo_bit vgastate nvidia(P) sg thermal button evdev
Nov 26 07:20:01 [kernel] Pid: 28555, comm: cron Tainted: P D W 2.6.27-ccs-r2 #2
Nov 26 07:20:01 [kernel] RIP: 0010:[<ffffffff80390839>] [<ffffffff80390839>] ccs_free+0x19/0x80
Nov 26 07:20:01 [kernel] RSP: 0018:ffff8800544b1d08 EFLAGS: 00010206
Nov 26 07:20:01 [kernel] RAX: 0000000000000000 RBX: ffffffffffffffff RCX: 0000000000000000
Nov 26 07:20:01 [kernel] RDX: ffffffff8075b870 RSI: ffffffffffffffff RDI: ffff880054524000
Nov 26 07:20:01 [kernel] RBP: 0000000000000004 R08: ffffffff8075b858 R09: ffff8800557634e0
Nov 26 07:20:01 [kernel] R10: ffff8800557add8c R11: 00000000557adce4 R12: ffff88007b956780
Nov 26 07:20:01 [kernel] R13: 0000000000000000 R14: 0000000000000004 R15: ffff880054524000
Nov 26 07:20:01 [kernel] FS: 00007f6eafdc76f0(0000) GS:ffffffff80789e80(0000) knlGS:00000000f74836d0
Nov 26 07:20:01 [kernel] CS: 0010 DS: 0000 ES: 0000 CR0: 000000008005003b
Nov 26 07:20:01 [kernel] CR2: ffffffffffffffff CR3: 00000000544de000 CR4: 00000000000006e0
Nov 26 07:20:01 [kernel] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
Nov 26 07:20:01 [kernel] DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 0000000000000400
Nov 26 07:20:01 [kernel] Process cron (pid: 28555, threadinfo ffff8800544b0000, task ffff880061aa05d0)
Nov 26 07:20:01 [kernel] Stack: 0000000000000000 ffffffff80396f00 0000000000000000 ffff88007b956780
Nov 26 07:20:01 [kernel] ffff88009ef86c00 0000000000000000 0000000000000000 0000000000000000
Nov 26 07:20:01 [kernel] 0000000000000000 0000000000000000 0000000000000000 0000000000000000
Nov 26 07:20:01 [kernel] Call Trace:
Nov 26 07:20:01 [kernel] [<ffffffff80396f00>] ? ccs_check_open_permission+0x170/0x230
Nov 26 07:20:01 [kernel] [<ffffffff802a3207>] ? may_open+0x137/0x200
Nov 26 07:20:01 [kernel] [<ffffffff802a5fb8>] ? do_filp_open+0x138/0x970
Nov 26 07:20:01 [kernel] [<ffffffff803bddfa>] ? strnlen_user+0x2a/0x80
Nov 26 07:20:01 [kernel] [<ffffffff8029cf04>] ? cp_new_stat+0xe4/0x100
Nov 26 07:20:01 [kernel] [<ffffffff802b158a>] ? alloc_fd+0x3a/0x110
Nov 26 07:20:01 [kernel] [<ffffffff802979db>] ? do_sys_open+0x5b/0x100
Nov 26 07:20:01 [kernel] [<ffffffff8020c1fb>] ? system_call_fastpath+0x16/0x1b
Nov 26 07:20:01 [kernel] RIP [<ffffffff80390839>] ccs_free+0x19/0x80
Nov 26 07:20:01 [kernel] RSP <ffff8800544b1d08>
Nov 26 07:20:01 [kernel] ---[ end trace c7c7ca885d41477c ]---
ログをそれぞれ出してなにも動かなくなるというような状態になってしまいまし
た。
直前にやっていたあやしそうなことといって思いあたるのは xorg.conf で
Disable "dri" として glxinfo を動かしたことぐらいでしょうか。 glxinfo|lv
としていたのに結果が出てきてなかったので、 glxinfo の時点でこの現象になっ
ていたかと思われます。(log を見てみましたが、すでに流れてしまって確かでは
ないです。)
結局、この後再起動して同様に X を起動して glxinfo を動かしてみても問題な
く動いていて再現はできていません。 どうにもはっきりしていなくて、もうし
わけないのですが一応報告しておきます。
;; はっきりしていないといえば、 updatedb 中に suspend させると TOMOYO ま
;; わりでひっかかかって suspend できなかった記憶があるのですが、これまた
;; うまく再現できていません。 カーネルまわりの再現は難しいですね…。
--
青田