Time out problem

Hi,

An app I have had online for a while has started timeing out when I add a new user. I think it is failing on the send activation email action. The error dump is below. Am I right in thinking this is the mailer?

If so, what could I have changed to make this happen. Sorry to sound gormless, but I just can't understand why a working app would have stopped working?

Sent mail to xxxxxxx

Timeout::Error (execution expired):     /usr/local/lib/ruby/1.8/timeout.rb:60:in `new'     /usr/local/lib/ruby/1.8/net/protocol.rb:206:in `old_open'     /usr/local/lib/ruby/1.8/net/protocol.rb:206:in `old_open'     /usr/local/lib/ruby/1.8/net/smtp.rb:392:in `do_start'     /usr/local/lib/ruby/1.8/net/smtp.rb:377:in `start'     /usr/local/lib/ruby/gems/1.8/gems/actionmailer-2.2.2/lib/ action_mailer/base.rb:671:in `perform_delivery_smtp'     /usr/local/lib/ruby/gems/1.8/gems/actionmailer-2.2.2/lib/ action_mailer/base.rb:526:in `__send__'     /usr/local/lib/ruby/gems/1.8/gems/actionmailer-2.2.2/lib/ action_mailer/base.rb:526:in `deliver!'     /usr/local/lib/ruby/gems/1.8/gems/actionmailer-2.2.2/lib/ action_mailer/base.rb:392:in `method_missing'     /app/models/user_observer.rb:3:in `after_create'     /usr/local/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/ active_record/observer.rb:171:in `send'     /usr/local/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/ active_record/observer.rb:171:in `update'     /usr/local/lib/ruby/1.8/observer.rb:185:in `notify_observers'     /usr/local/lib/ruby/1.8/observer.rb:184:in `each'     /usr/local/lib/ruby/1.8/observer.rb:184:in `notify_observers'     /usr/local/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/ active_record/callbacks.rb:328:in `notify'     /usr/local/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/ active_record/callbacks.rb:321:in `callback'     /usr/local/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/ active_record/callbacks.rb:238:in `create_without_timestamps'     /usr/local/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/ active_record/timestamp.rb:29:in `create'     /usr/local/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/ active_record/base.rb:2699:in `create_or_update_without_callbacks'     /usr/local/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/ active_record/callbacks.rb:222:in `create_or_update'     /usr/local/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/ active_record/base.rb:2400:in `save_without_validation!'     /usr/local/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/ active_record/validations.rb:1019:in `save_without_dirty!'     /usr/local/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/ active_record/dirty.rb:87:in `save_without_transactions!'     /usr/local/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/ active_record/transactions.rb:150:in `save!'     /usr/local/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/ active_record/connection_adapters/abstract/database_statements.rb: 66:in `transaction'     /usr/local/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/ active_record/transactions.rb:129:in `transaction'     /usr/local/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/ active_record/transactions.rb:138:in `transaction'     /usr/local/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/ active_record/transactions.rb:150:in `save!'     /usr/local/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/ active_record/transactions.rb:158:in `rollback_active_record_state!'     /usr/local/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/ active_record/transactions.rb:150:in `save!'     /app/controllers/imports_controller.rb:60:in `create_administrator'     /usr/local/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/ action_controller/base.rb:1253:in `send'     /usr/local/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/ action_controller/base.rb:1253:in `perform_action_without_filters'     /usr/local/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/ action_controller/filters.rb:617:in `call_filters'     /usr/local/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/ action_controller/filters.rb:610:in `perform_action_without_benchmark'     /usr/local/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/ action_controller/benchmarking.rb:68:in `perform_action_without_rescue'     /usr/local/lib/ruby/1.8/benchmark.rb:293:in `measure'     /usr/local/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/ action_controller/benchmarking.rb:68:in `perform_action_without_rescue'     /usr/local/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/ action_controller/rescue.rb:136:in `perform_action_without_caching'     /usr/local/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/ action_controller/caching/sql_cache.rb:13:in `passenger_orig_perform_action'     /usr/local/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/ active_record/connection_adapters/abstract/query_cache.rb:34:in `cache'     /usr/local/lib/ruby/gems/1.8/gems/activerecord-2.2.2/lib/ active_record/query_cache.rb:8:in `cache'     /usr/local/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/ action_controller/caching/sql_cache.rb:12:in `passenger_orig_perform_action'     /usr/local/passenger/lib/phusion_passenger/railz/ request_handler.rb:65:in `perform_action'     /usr/local/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/ action_controller/base.rb:524:in `send'     /usr/local/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/ action_controller/base.rb:524:in `process_without_filters'     /usr/local/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/ action_controller/filters.rb:606:in `process_without_session_management_support'     /usr/local/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/ action_controller/session_management.rb:134:in `process'     /usr/local/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/ action_controller/base.rb:392:in `process'     /usr/local/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/ action_controller/dispatcher.rb:183:in `handle_request'     /usr/local/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/ action_controller/dispatcher.rb:110:in `dispatch_unlocked'     /usr/local/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/ action_controller/dispatcher.rb:123:in `dispatch'     /usr/local/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/ action_controller/dispatcher.rb:122:in `synchronize'     /usr/local/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/ action_controller/dispatcher.rb:122:in `dispatch'     /usr/local/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/ action_controller/dispatcher.rb:132:in `dispatch_cgi'     /usr/local/lib/ruby/gems/1.8/gems/actionpack-2.2.2/lib/ action_controller/dispatcher.rb:39:in `dispatch'     /usr/local/passenger/lib/phusion_passenger/railz/ request_handler.rb:50:in `process_request'     /usr/local/passenger/lib/phusion_passenger/ abstract_request_handler.rb:207:in `main_loop'     /usr/local/passenger/lib/phusion_passenger/railz/ application_spawner.rb:378:in `start_request_handler'     /usr/local/passenger/lib/phusion_passenger/railz/ application_spawner.rb:336:in `handle_spawn_application'     /usr/local/passenger/lib/phusion_passenger/utils.rb:183:in `safe_fork'     /usr/local/passenger/lib/phusion_passenger/railz/ application_spawner.rb:334:in `handle_spawn_application'     /usr/local/passenger/lib/phusion_passenger/abstract_server.rb: 352:in `__send__'     /usr/local/passenger/lib/phusion_passenger/abstract_server.rb: 352:in `main_loop'     /usr/local/passenger/lib/phusion_passenger/abstract_server.rb: 196:in `start_synchronously'     /usr/local/passenger/lib/phusion_passenger/abstract_server.rb: 163:in `start'     /usr/local/passenger/lib/phusion_passenger/railz/ application_spawner.rb:213:in `start'     /usr/local/passenger/lib/phusion_passenger/spawn_manager.rb:262:in `spawn_rails_application'     /usr/local/passenger/lib/phusion_passenger/ abstract_server_collection.rb:126:in `lookup_or_add'     /usr/local/passenger/lib/phusion_passenger/spawn_manager.rb:256:in `spawn_rails_application'     /usr/local/passenger/lib/phusion_passenger/ abstract_server_collection.rb:80:in `synchronize'     /usr/local/passenger/lib/phusion_passenger/ abstract_server_collection.rb:79:in `synchronize'     /usr/local/passenger/lib/phusion_passenger/spawn_manager.rb:255:in `spawn_rails_application'     /usr/local/passenger/lib/phusion_passenger/spawn_manager.rb:154:in `spawn_application'     /usr/local/passenger/lib/phusion_passenger/spawn_manager.rb:287:in `handle_spawn_application'     /usr/local/passenger/lib/phusion_passenger/abstract_server.rb: 352:in `__send__'     /usr/local/passenger/lib/phusion_passenger/abstract_server.rb: 352:in `main_loop'     /usr/local/passenger/lib/phusion_passenger/abstract_server.rb: 196:in `start_synchronously'     /usr/local/passenger/bin/passenger-spawn-server:61

Hi,

An app I have had online for a while has started timeing out when I add a new user. I think it is failing on the send activation email action. The error dump is below. Am I right in thinking this is the mailer?

If so, what could I have changed to make this happen. Sorry to sound gormless, but I just can't understand why a working app would have stopped working?

Yup, it's timing out opening a connection to your smtp server. You may have changed nothing, but something in between you and the smtp server may have changed. Is the smtp server still running on the port / host it used to be? Has something (maybe not under your control) like a firewall changed?

Fred

Fred

Hi Fred,

Yes it was a firewall issue that I could control.

I eventually got the hosting company to sort it out. I thought I was going crazy when it just stopped.

Anyway, sorted now and your message gave me the confidence to tell them it was not my fault.

Thanks,

Dan