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:inold_open’
/usr/local/lib/ruby/1.8/net/protocol.rb:206:in old_open' /usr/local/lib/ruby/1.8/net/smtp.rb:392:indo_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:inperform_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:indeliver!’
/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:inafter_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:inupdate’
/usr/local/lib/ruby/1.8/observer.rb:185:in notify_observers' /usr/local/lib/ruby/1.8/observer.rb:184:ineach’
/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:innotify’
/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:increate_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:increate_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:insave_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:insave_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:intransaction’
/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:intransaction’
/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:inrollback_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:increate_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:inperform_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:inperform_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:inmeasure’
/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:inperform_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:incache’
/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:inpassenger_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:insend’
/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:inprocess_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:inprocess’
/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:indispatch_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:insynchronize’
/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:indispatch_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:inprocess_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:instart_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:insafe_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:insend
/usr/local/passenger/lib/phusion_passenger/abstract_server.rb:
352:in main_loop' /usr/local/passenger/lib/phusion_passenger/abstract_server.rb: 196:instart_synchronously’
/usr/local/passenger/lib/phusion_passenger/abstract_server.rb:
163:in start' /usr/local/passenger/lib/phusion_passenger/railz/ application_spawner.rb:213:instart’
/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:inlookup_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:insynchronize’
/usr/local/passenger/lib/phusion_passenger/
abstract_server_collection.rb:79:in synchronize' /usr/local/passenger/lib/phusion_passenger/spawn_manager.rb:255:inspawn_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:inhandle_spawn_application’
/usr/local/passenger/lib/phusion_passenger/abstract_server.rb:
352:in __send__' /usr/local/passenger/lib/phusion_passenger/abstract_server.rb: 352:inmain_loop’
/usr/local/passenger/lib/phusion_passenger/abstract_server.rb:
196:in `start_synchronously’
/usr/local/passenger/bin/passenger-spawn-server:61

On Feb 16, 10:39 am, DanC [email protected] wrote:

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