From users-return-3300-apmail-qpid-users-archive=qpid.apache.org@qpid.apache.org Tue Oct 05 20:21:13 2010 Return-Path: Delivered-To: apmail-qpid-users-archive@www.apache.org Received: (qmail 63698 invoked from network); 5 Oct 2010 20:21:13 -0000 Received: from unknown (HELO mail.apache.org) (140.211.11.3) by 140.211.11.9 with SMTP; 5 Oct 2010 20:21:13 -0000 Received: (qmail 84010 invoked by uid 500); 5 Oct 2010 20:21:13 -0000 Delivered-To: apmail-qpid-users-archive@qpid.apache.org Received: (qmail 83962 invoked by uid 500); 5 Oct 2010 20:21:12 -0000 Mailing-List: contact users-help@qpid.apache.org; run by ezmlm Precedence: bulk List-Help: List-Unsubscribe: List-Post: List-Id: Reply-To: users@qpid.apache.org Delivered-To: mailing list users@qpid.apache.org Received: (qmail 83954 invoked by uid 99); 5 Oct 2010 20:21:10 -0000 Received: from athena.apache.org (HELO athena.apache.org) (140.211.11.136) by apache.org (qpsmtpd/0.29) with ESMTP; Tue, 05 Oct 2010 20:21:10 +0000 X-ASF-Spam-Status: No, hits=-0.0 required=10.0 tests=SPF_PASS X-Spam-Check-By: apache.org Received-SPF: pass (athena.apache.org: domain of Luiz.Cordeiro@corp.terra.com.br designates 200.176.5.26 as permitted sender) Received: from [200.176.5.26] (HELO mail.corp.terra.com.br) (200.176.5.26) by apache.org (qpsmtpd/0.29) with ESMTP; Tue, 05 Oct 2010 20:21:05 +0000 Received: from MAIL.corp.terra ([192.168.1.2]) by poasns28b.corp.terra ([10.225.0.104]) with mapi; Tue, 5 Oct 2010 17:20:00 -0300 From: Luiz Cordeiro To: "users@qpid.apache.org" Date: Tue, 5 Oct 2010 17:19:58 -0300 Subject: RES: Client is unable to connect to server Thread-Topic: Client is unable to connect to server Thread-Index: ActkEVu43d0yzykYQHuXB7yR4h2CMgAe0N4wAACZASAADtpQ8A== Message-ID: <5843E8596C824942BBA56B74D7D9380810740999E8@MAIL.corp.terra> References: <003a01cb648c$afa55c40$0ef014c0$@centeno@terra.com.br> <598B2D1B37D8410CBB511D240A97FD98@hope> In-Reply-To: <598B2D1B37D8410CBB511D240A97FD98@hope> Accept-Language: pt-BR, en-US Content-Language: pt-BR X-MS-Has-Attach: X-MS-TNEF-Correlator: acceptlanguage: pt-BR, en-US Content-Type: text/plain; charset="iso-8859-1" Content-Transfer-Encoding: quoted-printable MIME-Version: 1.0 Hi, The daemon is already running with -t but no messages are logged. We've ma= de a strace on the clien side, and it seems to be a memory allocation probl= em: connect(9, {sa_family=3DAF_INET, sin_port=3Dhtons(5672), sin_addr=3Dinet_ad= dr("200.154.54.236")}, 16) =3D -1 EINPROGRESS (Operation now in progress) epoll_ctl(15, EPOLL_CTL_ADD, 9, {EPOLLOUT|EPOLLONESHOT, {u32=3D150707256, u= 64=3D150707256}}) =3D 0 mmap2(NULL, 10489856, PROT_READ|PROT_WRITE|PROT_EXEC, MAP_PRIVATE|MAP_ANONY= MOUS, -1, 0) =3D 0x25ce000 mprotect(0x25ce000, 4096, PROT_NONE) =3D 0 clone(Process 30233 attached child_stack=3D0x2fce1c4, flags=3DCLONE_VM|CLONE_FS|CLONE_FILES|CLONE_SIGHAN= D|CLONE_THREAD|CLONE_SYSVSEM|CLONE_SETTLS|CLONE_PARENT_SETTID|CLONE_CHILD_C= LEARTID, parent_tidptr=3D0x2fcebd8, {entry_number:6, base_addr:0x2fceb90, l= imit:1048575, seg_32bit:1, contents:0, read_exec_only:0, limit_in_pages:1, = seg_not_present:0, useable:1}, child_tidptr=3D0x2fcebd8) =3D 30233 [pid 30211] futex(0x8fb9330, FUTEX_WAIT_PRIVATE, 1, NULL [pid 30233] set_robust_list(0x2fcebe0, 0xc) =3D 0 [pid 30233] rt_sigprocmask(SIG_SETMASK, ~[RTMIN RT_1], NULL, 8) =3D 0 [pid 30233] rt_sigprocmask(SIG_SETMASK, [], ~[KILL STOP RTMIN RT_1], 8) =3D= 0 [pid 30233] epoll_wait(15, {{EPOLLOUT, {u32=3D150707256, u64=3D150707256}}}= , 1, -1) =3D 1 [pid 30233] rt_sigprocmask(SIG_SETMASK, ~[KILL STOP RTMIN RT_1], NULL, 8) = =3D 0 [pid 30233] getsockopt(9, SOL_SOCKET, SO_ERROR, [0], [4]) =3D 0 [pid 30233] epoll_ctl(15, EPOLL_CTL_DEL, 9, NULL) =3D 0 [pid 30233] fcntl64(9, F_SETFL, O_RDONLY|O_NONBLOCK) =3D 0 [pid 30233] brk(0x8ff9000) =3D 0x8ff9000 [pid 30233] brk(0x9029000) =3D 0x9029000 [pid 30233] brk(0x9059000) =3D 0x9059000 [pid 30233] brk(0x9089000) =3D 0x9089000 [pid 30233] brk(0x90b9000) =3D 0x90b9000 [pid 30233] brk(0x90e9000) =3D 0x90e9000 [pid 30233] brk(0x9119000) =3D 0x9119000 [pid 30233] brk(0x9149000) =3D 0x9149000 [pid 30233] brk(0x9179000) =3D 0x9179000 [pid 30233] brk(0x91a9000) =3D 0x91a9000 [pid 30233] brk(0x91d9000) =3D 0x91a9000 [pid 30233] mmap2(NULL, 1048576, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANON= YMOUS, -1, 0) =3D -1 ENOMEM (Cannot allocate memory) [pid 30233] mmap2(NULL, 2097152, PROT_NONE, MAP_PRIVATE|MAP_ANONYMOUS|MAP_N= ORESERVE, -1, 0) =3D -1 ENOMEM (Cannot allocate memory) [pid 30233] mmap2(NULL, 1048576, PROT_NONE, MAP_PRIVATE|MAP_ANONYMOUS|MAP_N= ORESERVE, -1, 0) =3D -1 ENOMEM (Cannot allocate memory) [pid 30233] mmap2(NULL, 1048576, PROT_NONE, MAP_PRIVATE|MAP_ANONYMOUS|MAP_N= ORESERVE, -1, 0) =3D -1 ENOMEM (Cannot allocate memory) [pid 30233] mmap2(NULL, 2097152, PROT_NONE, MAP_PRIVATE|MAP_ANONYMOUS|MAP_N= ORESERVE, -1, 0) =3D -1 ENOMEM (Cannot allocate memory) [pid 30233] mmap2(NULL, 1048576, PROT_NONE, MAP_PRIVATE|MAP_ANONYMOUS|MAP_N= ORESERVE, -1, 0) =3D -1 ENOMEM (Cannot allocate memory) [pid 30233] futex(0xb12a88, FUTEX_WAKE_PRIVATE, 2147483647) =3D 0 [pid 30233] time(NULL) =3D 1286307651 [pid 30233] write(2, "2010-oct-05 19:40:51 error FAIL : St9bad_alloc (qpid/= client/Connector.cpp:411)\n", 79) =3D 79 [pid 30233] brk(0x8fe9000) =3D 0x8fe9000 [pid 30233] epoll_ctl(15, EPOLL_CTL_MOD, 11, {EPOLLIN, {u32=3D2, u64=3D2}})= =3D 0 [pid 30233] time(NULL) =3D 1286307651 [pid 30233] write(2, "2010-oct-05 19:40:51 warning Connection closed\n", 47= ) =3D 47 [pid 30233] futex(0x8fb9330, FUTEX_CMP_REQUEUE_PRIVATE, 1, 2147483647, 0x8f= b9314, 2) =3D 1 [pid 30211] <... futex resumed> ) =3D 0 [pid 30211] futex(0x8fb9314, FUTEX_WAIT_PRIVATE, 2, NULL [pid 30233] futex(0x8fb9314, FUTEX_WAKE_PRIVATE, 1) =3D 1 [pid 30211] <... futex resumed> ) =3D 0 [pid 30211] futex(0x8fb9314, FUTEX_WAKE_PRIVATE, 1 [pid 30233] _exit(0) =3D ? Process 30233 detached Does this mean something to you guys? Atenciosamente, Luiz Ac=E1cio Centeno Cordeiro Jr Gest=E3o de Servi=E7os p/ Am=E9rica Latina +55 (51) 3284-4287 Terra Latin America & USA -----Mensagem original----- De: Steve Huston [mailto:shuston@riverace.com]=20 Enviada em: ter=E7a-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? =20 Also, can you run the broker with more logging? Maybe add -t to the command options. =20 -Steve -- Steve Huston, Riverace Corporation Total Lifecycle Support for Your Networked Applications http://www.riverace.com =20 -----Original Message----- From: Ac=E1cio Centeno [mailto:acacio.centeno@terra.com.br]=20 Sent: Tuesday, October 05, 2010 8:56 AM To: users@qpid.apache.org Subject: Client is unable to connect to server Hello, =20 I'm facing a connection problem with qpidc-0.5.752581-34.el5 when trying to connect to the C++ broker (same version). =20 My exception handler logs only "Connection closed" on this line: =20 } catch(const std::exception& error) { TrrQueueLog(ctx, "In function [%s]: [%s]", __FUNCTION__, error.what()); =20 And a tcpdump only shows the TCP connection (which the server seems to be refusing): =20 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 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 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 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. =20 No log is generated on the server. =20 I'm clueless about what the problem could be. I do can telnet the server on port 5672. Any ideias? =20 Atenciosamente, Luiz Ac=E1cio Centeno Cordeiro Jr Gest=E3o de Servi=E7os p/ Am=E9rica Latina +55 (51) 3284-4287 Terra Latin America & USA logo =20 --------------------------------------------------------------------- Apache Qpid - AMQP Messaging Implementation Project: http://qpid.apache.org Use/Interact: mailto:users-subscribe@qpid.apache.org