[rabbitmq-discuss] RabbitMQ 3.0.0 hangs

Rui ruifavas at hotmail.com
Tue Dec 18 11:56:38 GMT 2012



Hi Tim, Simon,

Thank you for your help on this


I can now re-create the problem on demand. It only happens on versions 
3/3.0.1 and if the management plugin is on. 

The problem is caused by starting the process without using the Operating 
System shell. In our case we set the UseShellExecute to false so we can 
catch the Standard In/Out.


On Monday, 17 December 2012 14:59:04 UTC, Rui wrote:
>
> Hello Tim,
>
> We use a .Net process which runs Rabbit using “sbin\rabbitmq-server”. This 
> has been running in prod with previous versions of rabbitmq for a while 
> with no problems – have you changed the way the Management Plug-in runs?
>
>
>
>
> On Monday, 17 December 2012 13:15:59 UTC, Rui wrote:
>>
>> Erlang starts fine – Both work fine for a period of time  (I can acess 
>> rabbit and management console fine for an hour or so)
>>
>>  
>>
>> See full log below:-
>>
>>  
>>
>> =INFO REPORT==== 17-Dec-2012::10:00:44 ===
>>
>> Starting RabbitMQ 3.0.1 on Erlang R15B03
>>
>>  
>>
>> =INFO REPORT==== 17-Dec-2012::10:00:46 ===
>>
>> Limiting to approx 65436 file handles (58890 sockets)
>>
>>  
>>
>> =INFO REPORT==== 17-Dec-2012::10:00:46 ===
>>
>>     application: mnesia
>>
>>     exited: stopped
>>
>>     type: temporary
>>
>>  
>>
>> =INFO REPORT==== 17-Dec-2012::10:00:47 ===
>>
>> Memory limit set to 9826MB of 24565MB total.
>>
>>  
>>
>> =INFO REPORT==== 17-Dec-2012::10:00:47 ===
>>
>> Disk free limit set to 1000MB
>>
>>  
>>
>> =INFO REPORT==== 17-Dec-2012::10:00:47 ===
>>
>> Management plugin upgraded statistics to coarse.
>>
>>  
>>
>> =INFO REPORT==== 17-Dec-2012::10:00:47 ===
>>
>> msg_store_transient: using rabbit_msg_store_ets_index to provide index
>>
>>  
>>
>> =INFO REPORT==== 17-Dec-2012::10:00:47 ===
>>
>> msg_store_persistent: using rabbit_msg_store_ets_index to provide index
>>
>>  
>>
>> =WARNING REPORT==== 17-Dec-2012::10:00:47 ===
>>
>> msg_store_persistent: rebuilding indices from scratch
>>
>>  
>>
>> =INFO REPORT==== 17-Dec-2012::10:00:47 ===
>>
>> Adding vhost '/test'
>>
>>  
>>
>> =INFO REPORT==== 17-Dec-2012::10:00:47 ===
>>
>> Creating user 'testadmin'
>>
>>  
>>
>> =INFO REPORT==== 17-Dec-2012::10:00:47 ===
>>
>> Setting user tags for user 'testadmin' to [administrator]
>>
>>  
>>
>> =INFO REPORT==== 17-Dec-2012::10:00:47 ===
>>
>> Setting permissions for 'testadmin' in '/bcfs' to '.*', '.*', '.*'
>>
>>  
>>
>> =INFO REPORT==== 17-Dec-2012::10:00:47 ===
>>
>> started TCP Listener on [::]:5672
>>
>>  
>>
>> =INFO REPORT==== 17-Dec-2012::10:00:47 ===
>>
>> started TCP Listener on 0.0.0.0:5672
>>
>>  
>>
>> =INFO REPORT==== 17-Dec-2012::10:00:47 ===
>>
>> Management agent started.
>>
>>  
>>
>> =INFO REPORT==== 17-Dec-2012::10:00:47 ===
>>
>> Management plugin started. Port: 15672
>>
>>  
>>
>> =INFO REPORT==== 17-Dec-2012::10:00:47 ===
>>
>> Statistics database started.
>>
>>  
>>
>> =INFO REPORT==== 17-Dec-2012::10:00:47 ===
>>
>> accepting AMQP connection <0.362.0> (10.74.59.91:51986 -> 
>> 10.74.59.91:5672)
>>
>>  
>>
>> =INFO REPORT==== 17-Dec-2012::10:00:47 ===
>>
>> accepting AMQP connection <0.372.0> (10.74.59.91:51985 -> 
>> 10.74.59.91:5672)
>>
>>  
>>
>> =INFO REPORT==== 17-Dec-2012::10:00:47 ===
>>
>> accepting AMQP connection <0.387.0> (10.74.59.91:51988 -> 
>> 10.74.59.91:5672)
>>
>>  
>>
>> =INFO REPORT==== 17-Dec-2012::10:00:47 ===
>>
>> accepting AMQP connection <0.391.0> (10.74.59.91:51987 -> 
>> 10.74.59.91:5672)
>>
>>  
>>
>> =INFO REPORT==== 17-Dec-2012::10:04:01 ===
>>
>> accepting AMQP connection <0.549.0> (30.254.43.157:62861 -> 
>> 10.74.59.91:5672)
>>
>>  
>>
>> =INFO REPORT==== 17-Dec-2012::10:04:16 ===
>>
>> closing AMQP connection <0.549.0> (30.254.43.157:62861 -> 
>> 10.74.59.91:5672)
>>
>>  
>>
>> =INFO REPORT==== 17-Dec-2012::10:04:29 ===
>>
>> accepting AMQP connection <0.562.0> (30.254.43.157:62865 -> 
>> 10.74.59.91:5672)
>>
>>  
>>
>> =INFO REPORT==== 17-Dec-2012::10:04:33 ===
>>
>> accepting AMQP connection <0.575.0> (30.254.43.157:62866 -> 
>> 10.74.59.91:5672)
>>
>>  
>>
>> =INFO REPORT==== 17-Dec-2012::10:21:57 ===
>>
>> closing AMQP connection <0.575.0> (30.254.43.157:62866 -> 
>> 10.74.59.91:5672)
>>
>>  
>>
>> =INFO REPORT==== 17-Dec-2012::10:21:58 ===
>>
>> closing AMQP connection <0.562.0> (30.254.43.157:62865 -> 
>> 10.74.59.91:5672)
>>
>>  
>>
>> =INFO REPORT==== 17-Dec-2012::10:47:31 ===
>>
>> accepting AMQP connection <0.1467.0> (30.254.43.157:51530 -> 
>> 10.74.59.91:5672)
>>
>>  
>>
>> =INFO REPORT==== 17-Dec-2012::10:47:38 ===
>>
>> accepting AMQP connection <0.1480.0> (30.254.43.157:51533 -> 
>> 10.74.59.91:5672)
>>
>>  
>>
>> =INFO REPORT==== 17-Dec-2012::10:47:43 ===
>>
>> accepting AMQP connection <0.1491.0> (30.254.43.157:51535 -> 
>> 10.74.59.91:5672)
>>
>>  
>>
>> =INFO REPORT==== 17-Dec-2012::10:47:49 ===
>>
>> accepting AMQP connection <0.1502.0> (30.254.43.157:51536 -> 
>> 10.74.59.91:5672)
>>
>>  
>>
>> =INFO REPORT==== 17-Dec-2012::10:48:00 ===
>>
>> accepting AMQP connection <0.1513.0> (30.254.43.157:51539 -> 
>> 10.74.59.91:5672)
>>
>>  
>>
>> =INFO REPORT==== 17-Dec-2012::10:48:08 ===
>>
>> accepting AMQP connection <0.1524.0> (30.254.43.157:51543 -> 
>> 10.74.59.91:5672)
>>
>>  
>>
>> =INFO REPORT==== 17-Dec-2012::10:49:24 ===
>>
>> accepting AMQP connection <0.1536.0> (30.254.43.157:51565 -> 
>> 10.74.59.91:5672)
>>
>>  
>>
>> =INFO REPORT==== 17-Dec-2012::10:49:31 ===
>>
>> accepting AMQP connection <0.1547.0> (30.254.43.157:51567 -> 
>> 10.74.59.91:5672)
>>
>>  
>>
>> =INFO REPORT==== 17-Dec-2012::10:53:04 ===
>>
>> closing AMQP connection <0.1536.0> (30.254.43.157:51565 -> 
>> 10.74.59.91:5672)
>>
>>  
>>
>> =INFO REPORT==== 17-Dec-2012::10:53:06 ===
>>
>> closing AMQP connection <0.1524.0> (30.254.43.157:51543 -> 
>> 10.74.59.91:5672)
>>
>>  
>>
>> =INFO REPORT==== 17-Dec-2012::10:53:11 ===
>>
>> closing AMQP connection <0.1502.0> (30.254.43.157:51536 -> 
>> 10.74.59.91:5672)
>>
>>  
>>
>> =INFO REPORT==== 17-Dec-2012::10:53:19 ===
>>
>> closing AMQP connection <0.1513.0> (30.254.43.157:51539 -> 
>> 10.74.59.91:5672)
>>
>>  
>>
>> =INFO REPORT==== 17-Dec-2012::10:53:20 ===
>>
>> closing AMQP connection <0.1547.0> (30.254.43.157:51567 -> 
>> 10.74.59.91:5672)
>>
>>  
>>
>> =INFO REPORT==== 17-Dec-2012::10:53:22 ===
>>
>> closing AMQP connection <0.1491.0> (30.254.43.157:51535 -> 
>> 10.74.59.91:5672)
>>
>>  
>>
>> =INFO REPORT==== 17-Dec-2012::10:53:57 ===
>>
>> closing AMQP connection <0.1480.0> (30.254.43.157:51533 -> 
>> 10.74.59.91:5672)
>>
>>  
>>
>> =INFO REPORT==== 17-Dec-2012::10:54:00 ===
>>
>> closing AMQP connection <0.1467.0> (30.254.43.157:51530 -> 
>> 10.74.59.91:5672)
>>
>>  
>>
>> =ERROR REPORT==== 17-Dec-2012::11:00:00 ===
>>
>> ** Generic server <0.28.0> terminating 
>>
>> ** Last message in was {'EXIT',<0.29.0>,einval}
>>
>> ** When Server state == {state,user_sup,undefined,<0.29.0>,
>>
>>                                {<0.28.0>,user_sup}}
>>
>> ** Reason for termination == 
>>
>> ** einval
>>
>>  
>>
>> On Monday, 17 December 2012 11:35:04 UTC, Rui wrote:
>>>
>>> The upgrade was simple - We just uninstalled the previous version and 
>>> delete all the previous files (including the rabbit db) and installed the 
>>> new version.
>>>
>>>  
>>>
>>> We are running:
>>>
>>>  
>>>
>>>             RabbitMQ : 3.0.1
>>>
>>>             Erlang : 5.9.3
>>>
>>>             OS :     Windows Server 2008 64-bit
>>>
>>>  
>>>
>>>  
>>>
>>> Here’s what we get on the logs:-
>>>
>>>  
>>>
>>> Rabbit Log
>>>
>>>  
>>>
>>> =ERROR REPORT==== 17-Dec-2012::11:00:00 ===
>>>
>>> ** Generic server <0.28.0> terminating 
>>>
>>> ** Last message in was {'EXIT',<0.29.0>,einval}
>>>
>>> ** When Server state == {state,user_sup,undefined,<0.29.0>,
>>>
>>>                                {<0.28.0>,user_sup}}
>>>
>>> ** Reason for termination == 
>>>
>>> ** einval
>>>
>>>  
>>>
>>>  
>>>
>>> Rabbit SASL Log
>>>
>>>  
>>>
>>>  
>>>
>>> =SUPERVISOR REPORT==== 17-Dec-2012::11:00:00 ===
>>>
>>>      Supervisor: {<0.28.0>,user_sup}
>>>
>>>      Context:    child_terminated
>>>
>>>      Reason:     einval
>>>
>>>      Offender:   [{pid,<0.29.0>},{mod,user_sup}]
>>>
>>>  
>>>
>>>  
>>>
>>> =CRASH REPORT==== 17-Dec-2012::11:00:00 ===
>>>
>>>   crasher:
>>>
>>>     initial call: supervisor_bridge:user_sup/1
>>>
>>>     pid: <0.28.0>
>>>
>>>     registered_name: []
>>>
>>>     exception exit: einval
>>>
>>>       in function  gen_server:terminate/6 (gen_server.erl, line 747)
>>>
>>>     ancestors: [kernel_sup,<0.10.0>]
>>>
>>>     messages: []
>>>
>>>     links: [<0.11.0>]
>>>
>>>     dictionary: []
>>>
>>>     trap_exit: true
>>>
>>>     status: running
>>>
>>>     heap_size: 377
>>>
>>>     stack_size: 24
>>>
>>>     reductions: 337
>>>
>>>   neighbours:
>>>
>>>  
>>>
>>> =SUPERVISOR REPORT==== 17-Dec-2012::11:00:00 ===
>>>
>>>      Supervisor: {local,kernel_sup}
>>>
>>>      Context:    child_terminated
>>>
>>>      Reason:     einval
>>>
>>>      Offender:   [{pid,<0.28.0>},
>>>
>>>                   {name,user},
>>>
>>>                   {mfargs,{user_sup,start,[]}},
>>>
>>>                   {restart_type,temporary},
>>>
>>>                   {shutdown,2000},
>>>
>>>                   {child_type,supervisor}]
>>>
>>>  
>>>
>>>  
>>>
>>>  
>>>
>>>  
>>>
>>>
>>>
>>>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.rabbitmq.com/pipermail/rabbitmq-discuss/attachments/20121218/c287b889/attachment.htm>


More information about the rabbitmq-discuss mailing list