Attachment 150340 Details for Bug 232845 – Snippet from /var/log/messages when this happens

Snippet from /var/log/messages when this happens

kernel.log (text/plain), 9.89 KB, created by Bojan Smojver on 2007-03-18 20:26:22 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Bojan Smojver

Created: 2007-03-18 20:26:22 UTC

Size: 9.89 KB

patch

obsolete

>Mar 19 07:07:11 beauty racoon: INFO: @(#)ipsec-tools 0.6.5 (http://ipsec-tools.sourceforge.net) 
>Mar 19 07:07:11 beauty racoon: INFO: @(#)This product linked OpenSSL 0.9.8b 04 May 2006 (http://www.openssl.org/) 
>Mar 19 07:07:12 beauty racoon: INFO: <source-ip>[500] used as isakmp port (fd=7) 
>Mar 19 07:07:12 beauty racoon: INFO: <source-ip>[500] used for NAT-T 
>Mar 19 07:07:19 beauty racoon: INFO: IPsec-SA request for <destination-ip> queued due to no phase1 found. 
>Mar 19 07:07:19 beauty racoon: INFO: initiate new phase 1 negotiation: <source-ip>[500]<=><destination-ip>[500] 
>Mar 19 07:07:19 beauty racoon: INFO: begin Aggressive mode. 
>Mar 19 07:07:20 beauty racoon: INFO: received Vendor ID: draft-ietf-ipsra-isakmp-xauth-06.txt 
>Mar 19 07:07:20 beauty racoon: INFO: received Vendor ID: DPD 
>Mar 19 07:07:20 beauty racoon: INFO: received Vendor ID: CISCO-UNITY 
>Mar 19 07:07:20 beauty racoon: NOTIFY: couldn't find the proper pskey, try to get one by the peer's address. 
>Mar 19 07:07:20 beauty racoon: INFO: ISAKMP-SA established <source-ip>[500]-<destination-ip>[500] spi:fe7e1d2625aab7c5:aa0894fc7af5b2ea 
>Mar 19 07:07:20 beauty racoon: INFO: initiate new phase 2 negotiation: <source-ip>[500]<=><destination-ip>[500] 
>Mar 19 07:07:47 beauty kernel: BUG: sleeping function called from invalid context at mm/slab.c:3035
>Mar 19 07:07:47 beauty kernel: in_atomic():1, irqs_disabled():0
>Mar 19 07:07:47 beauty kernel:  [<c046ec5d>] __kmalloc+0x42/0x7d
>Mar 19 07:07:47 beauty kernel:  [<c044d381>] audit_log_task_context+0x41/0x9b
>Mar 19 07:07:47 beauty kernel:  [<c060cfb5>] xfrm_audit_log+0x125/0x513
>Mar 19 07:07:47 beauty kernel:  [<e099e801>] mdio_read+0x1d/0x23 [e100]
>Mar 19 07:07:47 beauty kernel:  [<c04e83e4>] __next_cpu+0x12/0x21
>Mar 19 07:07:47 beauty kernel:  [<c0420116>] find_busiest_group+0x1b4/0x4c3
>Mar 19 07:07:47 beauty kernel:  [<c06114bb>] xfrm_timer_handler+0x1fe/0x21a
>Mar 19 07:07:47 beauty kernel:  [<c06112bd>] xfrm_timer_handler+0x0/0x21a
>Mar 19 07:07:47 beauty kernel:  [<c042e64f>] run_timer_softirq+0x101/0x164
>Mar 19 07:07:47 beauty kernel:  [<c042b8e4>] __do_softirq+0x5d/0xba
>Mar 19 07:07:47 beauty kernel:  [<c04061b1>] do_softirq+0x59/0xb1
>Mar 19 07:07:47 beauty kernel:  [<c0419df6>] smp_apic_timer_interrupt+0x76/0x80
>Mar 19 07:07:47 beauty kernel:  [<c04049b0>] apic_timer_interrupt+0x28/0x30
>Mar 19 07:07:47 beauty kernel:  [<c05b6cbf>] sock_poll+0x0/0x11
>Mar 19 07:07:47 beauty kernel:  [<c05b6cc0>] sock_poll+0x1/0x11
>Mar 19 07:07:47 beauty kernel:  [<c047d097>] do_select+0x222/0x3c0
>Mar 19 07:07:47 beauty kernel:  [<c047d7a9>] __pollwait+0x0/0xac
>Mar 19 07:07:47 beauty kernel:  [<c04226ab>] default_wake_function+0x0/0xc
>Mar 19 07:07:47 beauty last message repeated 9 times
>Mar 19 07:07:47 beauty kernel:  [<c0420c7c>] enqueue_task+0x29/0x39
>Mar 19 07:07:47 beauty kernel:  [<c0420cb9>] task_running_tick+0x2d/0x237
>Mar 19 07:07:47 beauty kernel:  [<c0424274>] scheduler_tick+0x7c/0xdc
>Mar 19 07:07:47 beauty kernel:  [<c04503a9>] handle_level_irq+0x0/0xdf
>Mar 19 07:07:47 beauty kernel:  [<c0420cb9>] task_running_tick+0x2d/0x237
>Mar 19 07:07:47 beauty kernel:  [<c0420cb9>] task_running_tick+0x2d/0x237
>Mar 19 07:07:47 beauty kernel:  [<c0420c7c>] enqueue_task+0x29/0x39
>Mar 19 07:07:47 beauty kernel:  [<c0420edf>] __activate_task+0x1c/0x29
>Mar 19 07:07:47 beauty kernel:  [<c04226a1>] try_to_wake_up+0x3aa/0x3b4
>Mar 19 07:07:47 beauty kernel:  [<c0420c7c>] enqueue_task+0x29/0x39
>Mar 19 07:07:47 beauty kernel:  [<c04226a1>] try_to_wake_up+0x3aa/0x3b4
>Mar 19 07:07:47 beauty kernel:  [<c047d507>] core_sys_select+0x2d2/0x2f3
>Mar 19 07:07:47 beauty kernel:  [<c043b487>] wake_futex+0x42/0x4c
>Mar 19 07:07:47 beauty kernel:  [<c043b73a>] futex_wake+0xa6/0xb0
>Mar 19 07:07:47 beauty kernel:  [<c043c353>] do_futex+0x217/0xb6b
>Mar 19 07:07:47 beauty kernel:  [<c04c47a3>] inode_has_perm+0x5b/0x63
>Mar 19 07:07:47 beauty kernel:  [<c061fc0d>] _spin_unlock_irq+0x5/0x7
>Mar 19 07:07:47 beauty kernel:  [<c061e5c1>] __sched_text_start+0x999/0xa21
>Mar 19 07:07:47 beauty kernel:  [<c047db27>] sys_select+0xd6/0x187
>Mar 19 07:07:47 beauty kernel:  [<c0406d45>] do_syscall_trace+0xbb/0xc2
>Mar 19 07:07:47 beauty kernel:  [<c0403f64>] syscall_call+0x7/0xb
>Mar 19 07:07:47 beauty kernel:  =======================
>Mar 19 07:07:50 beauty kernel: BUG: sleeping function called from invalid context at mm/slab.c:3035
>Mar 19 07:07:50 beauty kernel: in_atomic():1, irqs_disabled():0
>Mar 19 07:07:50 beauty kernel:  [<c046ec5d>] __kmalloc+0x42/0x7d
>Mar 19 07:07:50 beauty kernel:  [<c044d381>] audit_log_task_context+0x41/0x9b
>Mar 19 07:07:50 beauty kernel:  [<c060cfb5>] xfrm_audit_log+0x125/0x513
>Mar 19 07:07:50 beauty kernel:  [<c0420a95>] __wake_up+0x32/0x43
>Mar 19 07:07:50 beauty kernel:  [<e0b98a9c>] pfkey_broadcast+0x138/0x15d [af_key]
>Mar 19 07:07:50 beauty kernel:  [<c0420a95>] __wake_up+0x32/0x43
>Mar 19 07:07:50 beauty kernel:  [<c061006d>] km_state_expired+0x3e/0x43
>Mar 19 07:07:50 beauty kernel:  [<c06114bb>] xfrm_timer_handler+0x1fe/0x21a
>Mar 19 07:07:50 beauty kernel:  [<c06112bd>] xfrm_timer_handler+0x0/0x21a
>Mar 19 07:07:50 beauty racoon: INFO: IPsec-SA expired: ESP/Tunnel <destination-ip>[0]-><source-ip>[0] spi=124820771(0x7709d23) 
>Mar 19 07:07:50 beauty racoon: ERROR: <destination-ip> give up to get IPsec-SA due to time up to wait. 
>Mar 19 07:07:50 beauty kernel:  [<c042e64f>] run_timer_softirq+0x101/0x164
>Mar 19 07:07:50 beauty kernel:  [<c04359ab>] __rcu_process_callbacks+0xf2/0x15a
>Mar 19 07:07:50 beauty kernel:  [<c042b8e4>] __do_softirq+0x5d/0xba
>Mar 19 07:07:50 beauty kernel:  [<c04061b1>] do_softirq+0x59/0xb1
>Mar 19 07:07:50 beauty kernel:  [<c0419df6>] smp_apic_timer_interrupt+0x76/0x80
>Mar 19 07:07:50 beauty kernel:  [<c04049b0>] apic_timer_interrupt+0x28/0x30
>Mar 19 07:07:50 beauty kernel:  [<c047007b>] do_xip_mapping_read+0x169/0x1a4
>Mar 19 07:07:50 beauty kernel:  [<c047d053>] do_select+0x1de/0x3c0
>Mar 19 07:07:50 beauty kernel:  [<c047d7a9>] __pollwait+0x0/0xac
>Mar 19 07:07:50 beauty kernel:  [<c04226ab>] default_wake_function+0x0/0xc
>Mar 19 07:07:50 beauty last message repeated 9 times
>Mar 19 07:07:50 beauty kernel:  [<c0420c7c>] enqueue_task+0x29/0x39
>Mar 19 07:07:50 beauty kernel:  [<c0420cb9>] task_running_tick+0x2d/0x237
>Mar 19 07:07:50 beauty kernel:  [<c0424274>] scheduler_tick+0x7c/0xdc
>Mar 19 07:07:50 beauty kernel:  [<c0420cb9>] task_running_tick+0x2d/0x237
>Mar 19 07:07:50 beauty kernel:  [<c0420cb9>] task_running_tick+0x2d/0x237
>Mar 19 07:07:50 beauty kernel:  [<c0420c7c>] enqueue_task+0x29/0x39
>Mar 19 07:07:50 beauty kernel:  [<c0420edf>] __activate_task+0x1c/0x29
>Mar 19 07:07:50 beauty kernel:  [<c04226a1>] try_to_wake_up+0x3aa/0x3b4
>Mar 19 07:07:50 beauty kernel:  [<c0420c7c>] enqueue_task+0x29/0x39
>Mar 19 07:07:50 beauty kernel:  [<c04226a1>] try_to_wake_up+0x3aa/0x3b4
>Mar 19 07:07:50 beauty kernel:  [<c04062cf>] do_IRQ+0xc6/0xdb
>Mar 19 07:07:50 beauty kernel:  [<c047d507>] core_sys_select+0x2d2/0x2f3
>Mar 19 07:07:50 beauty kernel:  [<c043b487>] wake_futex+0x42/0x4c
>Mar 19 07:07:50 beauty kernel:  [<c043b73a>] futex_wake+0xa6/0xb0
>Mar 19 07:07:50 beauty kernel:  [<c043c353>] do_futex+0x217/0xb6b
>Mar 19 07:07:50 beauty kernel:  [<c04c47a3>] inode_has_perm+0x5b/0x63
>Mar 19 07:07:50 beauty kernel:  [<c061fc0d>] _spin_unlock_irq+0x5/0x7
>Mar 19 07:07:50 beauty kernel:  [<c061e5c1>] __sched_text_start+0x999/0xa21
>Mar 19 07:07:50 beauty kernel:  [<c047db27>] sys_select+0xd6/0x187
>Mar 19 07:07:50 beauty kernel:  [<c0406d45>] do_syscall_trace+0xbb/0xc2
>Mar 19 07:07:50 beauty kernel:  [<c0403f64>] syscall_call+0x7/0xb
>Mar 19 07:07:50 beauty kernel:  =======================
>Mar 19 07:08:15 beauty named[3230]: socket.c:1156: unexpected error:
>Mar 19 07:08:15 beauty named[3230]: internal_send: 10.0.0.203#53: No such process
>Mar 19 07:08:15 beauty named[3230]: errno2result.c:109: unexpected error:
>Mar 19 07:08:15 beauty named[3230]: unable to convert errno to isc_result: 3: No such process
>Mar 19 07:08:15 beauty racoon: INFO: initiate new phase 2 negotiation: <source-ip>[500]<=><destination-ip>[500] 
>Mar 19 07:08:16 beauty racoon: WARNING: ignore RESPONDER-LIFETIME notification. 
>Mar 19 07:08:16 beauty racoon: WARNING: attribute has been modified. 
>Mar 19 07:08:16 beauty racoon: WARNING: authtype mismatched: my:hmac-sha peer:hmac-md5 
>Mar 19 07:08:17 beauty racoon: INFO: IPsec-SA established: ESP/Tunnel <destination-ip>[0]-><source-ip>[0] spi=176901038(0xa8b4bae) 
>Mar 19 07:08:17 beauty racoon: INFO: IPsec-SA established: ESP/Tunnel <source-ip>[0]-><destination-ip>[0] spi=3299693271(0xc4ad52d7) 
>Mar 19 07:08:17 beauty kernel: BUG: sleeping function called from invalid context at mm/slab.c:3035
>Mar 19 07:08:17 beauty kernel: in_atomic():1, irqs_disabled():0
>Mar 19 07:08:17 beauty kernel:  [<c046ec5d>] __kmalloc+0x42/0x7d
>Mar 19 07:08:17 beauty kernel:  [<c044d381>] audit_log_task_context+0x41/0x9b
>Mar 19 07:08:17 beauty kernel:  [<c060cfb5>] xfrm_audit_log+0x125/0x513
>Mar 19 07:08:17 beauty kernel:  [<e099e801>] mdio_read+0x1d/0x23 [e100]
>Mar 19 07:08:17 beauty kernel:  [<c04e83e4>] __next_cpu+0x12/0x21
>Mar 19 07:08:17 beauty kernel:  [<c0420116>] find_busiest_group+0x1b4/0x4c3
>Mar 19 07:08:17 beauty kernel:  [<c06114bb>] xfrm_timer_handler+0x1fe/0x21a
>Mar 19 07:08:17 beauty kernel:  [<c06112bd>] xfrm_timer_handler+0x0/0x21a
>Mar 19 07:08:17 beauty kernel:  [<c042e64f>] run_timer_softirq+0x101/0x164
>Mar 19 07:08:17 beauty kernel:  [<c042b8e4>] __do_softirq+0x5d/0xba
>Mar 19 07:08:17 beauty kernel:  [<c04061b1>] do_softirq+0x59/0xb1
>Mar 19 07:08:17 beauty kernel:  [<c0419df6>] smp_apic_timer_interrupt+0x76/0x80
>Mar 19 07:08:17 beauty kernel:  [<c04049b0>] apic_timer_interrupt+0x28/0x30
>Mar 19 07:08:17 beauty kernel:  [<c0402d7e>] default_idle+0x2c/0x3e
>Mar 19 07:08:17 beauty kernel:  [<c0417003>] apm_cpu_idle+0x19e/0x1f4
>Mar 19 07:08:17 beauty kernel:  [<c061e645>] __sched_text_start+0xa1d/0xa21
>Mar 19 07:08:17 beauty kernel:  [<c04023d0>] cpu_idle+0x9e/0xb7
>Mar 19 07:08:17 beauty kernel:  [<c074a812>] start_kernel+0x3b6/0x3be
>Mar 19 07:08:17 beauty kernel:  [<c074a25a>] unknown_bootoption+0x0/0x202
>Mar 19 07:08:17 beauty kernel:  =======================

Actions: View

Attachments on bug 232845: 150340