qpid-users mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Luiz Cordeiro <Luiz.Corde...@corp.terra.com.br>
Subject RES: Client is unable to connect to server
Date Tue, 05 Oct 2010 20:19:58 GMT
Hi,

	The daemon is already running with -t but no messages are logged. We've made a strace on
the clien side, and it seems to be a memory allocation problem:

connect(9, {sa_family=AF_INET, sin_port=htons(5672), sin_addr=inet_addr("200.154.54.236")},
16) = -1 EINPROGRESS (Operation now in progress)
epoll_ctl(15, EPOLL_CTL_ADD, 9, {EPOLLOUT|EPOLLONESHOT, {u32=150707256, u64=150707256}}) =
0
mmap2(NULL, 10489856, PROT_READ|PROT_WRITE|PROT_EXEC, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) =
0x25ce000
mprotect(0x25ce000, 4096, PROT_NONE)    = 0
clone(Process 30233 attached
child_stack=0x2fce1c4, flags=CLONE_VM|CLONE_FS|CLONE_FILES|CLONE_SIGHAND|CLONE_THREAD|CLONE_SYSVSEM|CLONE_SETTLS|CLONE_PARENT_SETTID|CLONE_CHILD_CLEARTID,
parent_tidptr=0x2fcebd8, {entry_number:6, base_addr:0x2fceb90, limit:1048575, seg_32bit:1,
contents:0, read_exec_only:0, limit_in_pages:1, seg_not_present:0, useable:1}, child_tidptr=0x2fcebd8)
= 30233
[pid 30211] futex(0x8fb9330, FUTEX_WAIT_PRIVATE, 1, NULL <unfinished ...>
[pid 30233] set_robust_list(0x2fcebe0, 0xc) = 0
[pid 30233] rt_sigprocmask(SIG_SETMASK, ~[RTMIN RT_1], NULL, 8) = 0
[pid 30233] rt_sigprocmask(SIG_SETMASK, [], ~[KILL STOP RTMIN RT_1], 8) = 0
[pid 30233] epoll_wait(15, {{EPOLLOUT, {u32=150707256, u64=150707256}}}, 1, -1) = 1
[pid 30233] rt_sigprocmask(SIG_SETMASK, ~[KILL STOP RTMIN RT_1], NULL, 8) = 0
[pid 30233] getsockopt(9, SOL_SOCKET, SO_ERROR, [0], [4]) = 0
[pid 30233] epoll_ctl(15, EPOLL_CTL_DEL, 9, NULL) = 0
[pid 30233] fcntl64(9, F_SETFL, O_RDONLY|O_NONBLOCK) = 0
[pid 30233] brk(0x8ff9000)              = 0x8ff9000
[pid 30233] brk(0x9029000)              = 0x9029000
[pid 30233] brk(0x9059000)              = 0x9059000
[pid 30233] brk(0x9089000)              = 0x9089000
[pid 30233] brk(0x90b9000)              = 0x90b9000
[pid 30233] brk(0x90e9000)              = 0x90e9000
[pid 30233] brk(0x9119000)              = 0x9119000
[pid 30233] brk(0x9149000)              = 0x9149000
[pid 30233] brk(0x9179000)              = 0x9179000
[pid 30233] brk(0x91a9000)              = 0x91a9000
[pid 30233] brk(0x91d9000)              = 0x91a9000
[pid 30233] mmap2(NULL, 1048576, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) =
-1 ENOMEM (Cannot allocate memory)
[pid 30233] mmap2(NULL, 2097152, PROT_NONE, MAP_PRIVATE|MAP_ANONYMOUS|MAP_NORESERVE, -1, 0)
= -1 ENOMEM (Cannot allocate memory)
[pid 30233] mmap2(NULL, 1048576, PROT_NONE, MAP_PRIVATE|MAP_ANONYMOUS|MAP_NORESERVE, -1, 0)
= -1 ENOMEM (Cannot allocate memory)
[pid 30233] mmap2(NULL, 1048576, PROT_NONE, MAP_PRIVATE|MAP_ANONYMOUS|MAP_NORESERVE, -1, 0)
= -1 ENOMEM (Cannot allocate memory)
[pid 30233] mmap2(NULL, 2097152, PROT_NONE, MAP_PRIVATE|MAP_ANONYMOUS|MAP_NORESERVE, -1, 0)
= -1 ENOMEM (Cannot allocate memory)
[pid 30233] mmap2(NULL, 1048576, PROT_NONE, MAP_PRIVATE|MAP_ANONYMOUS|MAP_NORESERVE, -1, 0)
= -1 ENOMEM (Cannot allocate memory)
[pid 30233] futex(0xb12a88, FUTEX_WAKE_PRIVATE, 2147483647) = 0
[pid 30233] time(NULL)                  = 1286307651
[pid 30233] write(2, "2010-oct-05 19:40:51 error FAIL : St9bad_alloc (qpid/client/Connector.cpp:411)\n",
79) = 79
[pid 30233] brk(0x8fe9000)              = 0x8fe9000
[pid 30233] epoll_ctl(15, EPOLL_CTL_MOD, 11, {EPOLLIN, {u32=2, u64=2}}) = 0
[pid 30233] time(NULL)                  = 1286307651
[pid 30233] write(2, "2010-oct-05 19:40:51 warning Connection closed\n", 47) = 47
[pid 30233] futex(0x8fb9330, FUTEX_CMP_REQUEUE_PRIVATE, 1, 2147483647, 0x8fb9314, 2) = 1
[pid 30211] <... futex resumed> )       = 0
[pid 30211] futex(0x8fb9314, FUTEX_WAIT_PRIVATE, 2, NULL <unfinished ...>
[pid 30233] futex(0x8fb9314, FUTEX_WAKE_PRIVATE, 1) = 1
[pid 30211] <... futex resumed> )       = 0
[pid 30211] futex(0x8fb9314, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>
[pid 30233] _exit(0)                    = ?
Process 30233 detached

	Does this mean something to you guys?

Atenciosamente,
Luiz Acácio Centeno Cordeiro Jr
Gestão de Serviços p/ América Latina
+55 (51) 3284-4287
Terra Latin America & USA


-----Mensagem original-----
De: Steve Huston [mailto:shuston@riverace.com] 
Enviada em: terça-feira, 5 de outubro de 2010 10:14
Para: users@qpid.apache.org
Assunto: RE: Client is unable to connect to server

The tcpdump shows the TCP connection opening. What happens further along
in the connection?
 
Also, can you run the broker with more logging? Maybe add -t to the
command options.
 
-Steve

--
Steve Huston, Riverace Corporation
Total Lifecycle Support for Your Networked Applications
http://www.riverace.com <http://www.riverace.com/> 


-----Original Message-----
From: Acácio Centeno [mailto:acacio.centeno@terra.com.br] 
Sent: Tuesday, October 05, 2010 8:56 AM
To: users@qpid.apache.org
Subject: Client is unable to connect to server



Hello,

 

                I'm facing a connection problem with
qpidc-0.5.752581-34.el5 when trying to connect to the C++ broker (same
version).

 

                My exception handler logs only "Connection closed" on
this line:

 

        } catch(const std::exception& error) {

                TrrQueueLog(ctx, "In function [%s]: [%s]", __FUNCTION__,
error.what());

 

                And a tcpdump only shows the TCP connection (which the
server seems to be refusing):

 

21:46:01.757692 IP dsv-bridge7-02.terra.com.br.37583 >
infra-acct-poa.terra.com.br.amqp: S 368799713:368799713(0) win 5840 <mss
1460,sackOK,timestamp 1506255414 0,nop,wscale 6>

        0x0000:  4500 003c cdd7 4000 4006 6dce c89a 36f5
E..<..@.@.m...6.

        0x0010:  c89a 36ec 92cf 1628 15fb 6fe1 0000 0000
..6....(..o.....

        0x0020:  a002 16d0 0749 0000 0204 05b4 0402 080a
.....I..........

        0x0030:  59c7 a236 0000 0000 0103 0306            Y..6........

21:46:01.760474 IP infra-acct-poa.terra.com.br.amqp >
dsv-bridge7-02.terra.com.br.37583: S 3043923573:3043923573(0) ack
368799714 win 5792 <mss 1460,sackOK,timestamp 17790935
1506255414,nop,wscale 5>

        0x0000:  4500 003c 0000 4000 4006 3ba6 c89a 36ec
E..<..@.@.;...6.

        0x0010:  c89a 36f5 1628 92cf b56e 9675 15fb 6fe2
..6..(...n.u..o.

        0x0020:  a012 16a0 429e 0000 0204 05b4 0402 080a
....B...........

        0x0030:  010f 77d7 59c7 a236 0103 0305            ..w.Y..6....

21:46:01.757874 IP dsv-bridge7-02.terra.com.br.37583 >
infra-acct-poa.terra.com.br.amqp: . ack 1 win 92 <nop,nop,timestamp
1506255415 17790935>

        0x0000:  4500 0034 cdd8 4000 4006 6dd5 c89a 36f5
E..4..@.@.m...6.

        0x0010:  c89a 36ec 92cf 1628 15fb 6fe2 b56e 9676
..6....(..o..n.v

        0x0020:  8010 005c 87ab 0000 0101 080a 59c7 a237
...\........Y..7

        0x0030:  010f 77d7                                ..w.

 

                No log is generated on the server.

 

                I'm clueless about what the problem could be. I do can
telnet the server on port 5672. Any ideias?

 

Atenciosamente,

Luiz Acácio Centeno Cordeiro Jr

Gestão de Serviços p/ América Latina

+55 (51) 3284-4287

Terra Latin America & USA

logo

 


---------------------------------------------------------------------
Apache Qpid - AMQP Messaging Implementation
Project:      http://qpid.apache.org
Use/Interact: mailto:users-subscribe@qpid.apache.org


Mime
View raw message