hicknhack-software / redmine_time_tracker

A time tracker plugin for Redmine
Other
106 stars 32 forks source link

Redmine 2.5.2 vs rtt #183

Closed Peneheals closed 9 years ago

Peneheals commented 9 years ago

(I hope this is the right place to open this thread.) I spent my whole day investigating a problem: two days ago I migrated my Chiliproject (3.3.0) to Redmine 2.5.2, as the well known Google doc say. Everything went fine, my Redmine with the old databse works well. I tried install rtt plugin, followed all of the instructions, the plugin seems to work. Just seems. There is the "Start timer" link, but when I click on it, an error message appears: "undefined method `round=' for #"

The error log shows: NoMethodError (undefined method `round=' for #TimeTracker:0x000000064cf698):

And when I click on the left top menu item, TimeTracker (http://mysite.com/tt_menu_switcher/index) I got an internal error...

My system:

Environment: Redmine version 2.5.2.stable Ruby version 1.9.3-p547 (2014-05-14) [x86_64-linux] Rails version 3.2.19 Environment production Database adapter Mysql2 SCM: Git 1.9.1
Redmine plugins: redmine_time_tracker 0.9.13 Server version: Apache/2.4.7 (Ubuntu) Server built: Apr 3 2014 12:20:28 passenger-4.0.46

Thank you for your response!

jume-dev commented 9 years ago

Hi there, i develop on a redmine 2.5.1, so if there weren't any major things in 2.5.2, i assume it should work. Hmm, from the error message itself, i would say you didn't migrate the database properly, but thats just a guess. Could you provide a stacktrace for the two errors please?

Peneheals commented 9 years ago

I give it a try installing a brand new 2.5.1, and take a deep look on the database structure :)

TimeTracking left-top menu click (500 server error):

ActionController::RoutingError (No route matches [POST] "/time_trackers/render_menu"): actionpack (3.2.19) lib/action_dispatch/middleware/debug_exceptions.rb:21:in call' actionpack (3.2.19) lib/action_dispatch/middleware/show_exceptions.rb:56:incall' railties (3.2.19) lib/rails/rack/logger.rb:32:in call_app' railties (3.2.19) lib/rails/rack/logger.rb:16:inblock in call' activesupport (3.2.19) lib/active_support/tagged_logging.rb:22:in tagged' railties (3.2.19) lib/rails/rack/logger.rb:16:incall' actionpack (3.2.19) lib/action_dispatch/middleware/request_id.rb:22:in call' rack (1.4.5) lib/rack/methodoverride.rb:21:incall' rack (1.4.5) lib/rack/runtime.rb:17:in call' activesupport (3.2.19) lib/active_support/cache/strategy/local_cache.rb:72:incall' rack (1.4.5) lib/rack/lock.rb:15:in call' actionpack (3.2.19) lib/action_dispatch/middleware/static.rb:63:incall' rack-cache (1.2) lib/rack/cache/context.rb:136:in forward' rack-cache (1.2) lib/rack/cache/context.rb:143:inpass' rack-cache (1.2) lib/rack/cache/context.rb:155:in invalidate' rack-cache (1.2) lib/rack/cache/context.rb:71:incall!' rack-cache (1.2) lib/rack/cache/context.rb:51:in call' railties (3.2.19) lib/rails/engine.rb:484:incall' railties (3.2.19) lib/rails/application.rb:231:in call' railties (3.2.19) lib/rails/railtie/configurable.rb:30:inmethod_missing' passenger (4.0.46) lib/phusion_passenger/rack/thread_handler_extension.rb:74:in process_request' passenger (4.0.46) lib/phusion_passenger/request_handler/thread_handler.rb:141:inaccept_and_process_next_request' passenger (4.0.46) lib/phusion_passenger/request_handler/thread_handler.rb:109:in main_loop' passenger (4.0.46) lib/phusion_passenger/request_handler.rb:448:inblock (3 levels) in start_threads'

Started POST "/time_trackers/render_menu?issue_id=4888&project_id=101" for IP.IP.IP.IP at 2014-07-18 10:57:05 +0200

ActionController::RoutingError (No route matches [POST] "/time_trackers/render_menu"): actionpack (3.2.19) lib/action_dispatch/middleware/debug_exceptions.rb:21:in call' actionpack (3.2.19) lib/action_dispatch/middleware/show_exceptions.rb:56:incall' railties (3.2.19) lib/rails/rack/logger.rb:32:in call_app' railties (3.2.19) lib/rails/rack/logger.rb:16:inblock in call' activesupport (3.2.19) lib/active_support/tagged_logging.rb:22:in tagged' railties (3.2.19) lib/rails/rack/logger.rb:16:incall' actionpack (3.2.19) lib/action_dispatch/middleware/request_id.rb:22:in call' rack (1.4.5) lib/rack/methodoverride.rb:21:incall' rack (1.4.5) lib/rack/runtime.rb:17:in call' activesupport (3.2.19) lib/active_support/cache/strategy/local_cache.rb:72:incall' rack (1.4.5) lib/rack/lock.rb:15:in call' actionpack (3.2.19) lib/action_dispatch/middleware/static.rb:63:incall' rack-cache (1.2) lib/rack/cache/context.rb:136:in forward' rack-cache (1.2) lib/rack/cache/context.rb:143:inpass' rack-cache (1.2) lib/rack/cache/context.rb:155:in invalidate' rack-cache (1.2) lib/rack/cache/context.rb:71:incall!' rack-cache (1.2) lib/rack/cache/context.rb:51:in call' railties (3.2.19) lib/rails/engine.rb:484:incall' railties (3.2.19) lib/rails/application.rb:231:in call' railties (3.2.19) lib/rails/railtie/configurable.rb:30:inmethod_missing' passenger (4.0.46) lib/phusion_passenger/rack/thread_handler_extension.rb:74:in process_request' passenger (4.0.46) lib/phusion_passenger/request_handler/thread_handler.rb:141:inaccept_and_process_next_request' passenger (4.0.46) lib/phusion_passenger/request_handler/thread_handler.rb:109:in main_loop' passenger (4.0.46) lib/phusion_passenger/request_handler.rb:448:inblock (3 levels) in start_threads'

Started GET "/" for IP.IP.IP.IP at 2014-07-18 10:57:48 +0200 Processing by WelcomeController#index as HTML Current user: Pene (id=33) Rendered welcome/index.html.erb within layouts/base (15.6ms) Rendered plugins/redmine_time_tracker/app/views/time_trackers/_assets.html.erb (2.4ms) Completed 200 OK in 86.5ms (Views: 58.1ms | ActiveRecord: 2.0ms) Started GET "/tt_menu_switcher/index" for IP.IP.IP.IP at 2014-07-18 10:57:52 +0200 Processing by TtMenuSwitcherController#index as HTML Current user: Pene (id=33) Redirected to http://domain.com/tt_overview Completed 302 Found in 5.7ms (ActiveRecord: 0.3ms) Started GET "/tt_overview" for IP.IP.IP.IP at 2014-07-18 10:57:52 +0200 Processing by TtOverviewController#index as HTML Current user: Pene (id=33) Completed 500 Internal Server Error in 6.1ms

NoMethodError (undefined method round=' for #<TimeTracker:0x007faa9cb620d0>): activemodel (3.2.19) lib/active_model/attribute_methods.rb:407:inmethod_missing' activerecord (3.2.19) lib/active_record/attribute_methods.rb:149:in method_missing' plugins/redmine_time_tracker/app/models/time_tracker.rb:113:ininitialize' plugins/redmine_time_tracker/app/helpers/time_trackers_helper.rb:86:in new' plugins/redmine_time_tracker/app/helpers/time_trackers_helper.rb:86:inget_current_time_tracker' plugins/redmine_time_tracker/app/controllers/tt_overview_controller.rb:17:in index' actionpack (3.2.19) lib/action_controller/metal/implicit_render.rb:4:insend_action' actionpack (3.2.19) lib/abstract_controller/base.rb:167:in process_action' actionpack (3.2.19) lib/action_controller/metal/rendering.rb:10:inprocess_action' actionpack (3.2.19) lib/abstract_controller/callbacks.rb:18:in block in process_action' activesupport (3.2.19) lib/active_support/callbacks.rb:491:in_run138800004036842914process_action716895181906911843callbacks' activesupport (3.2.19) lib/active_support/callbacks.rb:405:in __run_callback' activesupport (3.2.19) lib/active_support/callbacks.rb:385:in_run_process_action_callbacks' activesupport (3.2.19) lib/active_support/callbacks.rb:81:in run_callbacks' actionpack (3.2.19) lib/abstract_controller/callbacks.rb:17:inprocess_action' actionpack (3.2.19) lib/action_controller/metal/rescue.rb:29:in process_action' actionpack (3.2.19) lib/action_controller/metal/instrumentation.rb:30:inblock in process_action' activesupport (3.2.19) lib/active_support/notifications.rb:123:in block in instrument' activesupport (3.2.19) lib/active_support/notifications/instrumenter.rb:20:ininstrument' activesupport (3.2.19) lib/active_support/notifications.rb:123:in instrument' actionpack (3.2.19) lib/action_controller/metal/instrumentation.rb:29:inprocess_action' actionpack (3.2.19) lib/action_controller/metal/params_wrapper.rb:207:in process_action' activerecord (3.2.19) lib/active_record/railties/controller_runtime.rb:18:inprocess_action' actionpack (3.2.19) lib/abstract_controller/base.rb:121:in process' actionpack (3.2.19) lib/abstract_controller/rendering.rb:45:inprocess' actionpack (3.2.19) lib/action_controller/metal.rb:203:in dispatch' actionpack (3.2.19) lib/action_controller/metal/rack_delegation.rb:14:indispatch' actionpack (3.2.19) lib/action_controller/metal.rb:246:in block in action' actionpack (3.2.19) lib/action_dispatch/routing/route_set.rb:73:incall' actionpack (3.2.19) lib/action_dispatch/routing/route_set.rb:73:in dispatch' actionpack (3.2.19) lib/action_dispatch/routing/route_set.rb:36:incall' journey (1.0.4) lib/journey/router.rb:68:in block in call' journey (1.0.4) lib/journey/router.rb:56:ineach' journey (1.0.4) lib/journey/router.rb:56:in call' actionpack (3.2.19) lib/action_dispatch/routing/route_set.rb:608:incall' rack-openid (1.4.2) lib/rack/openid.rb:98:in call' actionpack (3.2.19) lib/action_dispatch/middleware/best_standards_support.rb:17:incall' rack (1.4.5) lib/rack/etag.rb:23:in call' rack (1.4.5) lib/rack/conditionalget.rb:25:incall' actionpack (3.2.19) lib/action_dispatch/middleware/head.rb:14:in call' actionpack (3.2.19) lib/action_dispatch/middleware/params_parser.rb:21:incall' actionpack (3.2.19) lib/action_dispatch/middleware/flash.rb:242:in call' rack (1.4.5) lib/rack/session/abstract/id.rb:210:incontext' rack (1.4.5) lib/rack/session/abstract/id.rb:205:in call' actionpack (3.2.19) lib/action_dispatch/middleware/cookies.rb:341:incall' activerecord (3.2.19) lib/active_record/query_cache.rb:64:in call' activerecord (3.2.19) lib/active_record/connection_adapters/abstract/connection_pool.rb:479:incall' actionpack (3.2.19) lib/action_dispatch/middleware/callbacks.rb:28:in block in call' activesupport (3.2.19) lib/active_support/callbacks.rb:405:in_run1419960682094382030call2239802008632999848callbacks' activesupport (3.2.19) lib/active_support/callbacks.rb:405:in __run_callback' activesupport (3.2.19) lib/active_support/callbacks.rb:385:in_run_call_callbacks' activesupport (3.2.19) lib/active_support/callbacks.rb:81:in run_callbacks' actionpack (3.2.19) lib/action_dispatch/middleware/callbacks.rb:27:incall' actionpack (3.2.19) lib/action_dispatch/middleware/remote_ip.rb:31:in call' actionpack (3.2.19) lib/action_dispatch/middleware/debug_exceptions.rb:16:incall' actionpack (3.2.19) lib/action_dispatch/middleware/show_exceptions.rb:56:in call' railties (3.2.19) lib/rails/rack/logger.rb:32:incall_app' railties (3.2.19) lib/rails/rack/logger.rb:16:in block in call' activesupport (3.2.19) lib/active_support/tagged_logging.rb:22:intagged' railties (3.2.19) lib/rails/rack/logger.rb:16:in call' actionpack (3.2.19) lib/action_dispatch/middleware/request_id.rb:22:incall' rack (1.4.5) lib/rack/methodoverride.rb:21:in call' rack (1.4.5) lib/rack/runtime.rb:17:incall' activesupport (3.2.19) lib/active_support/cache/strategy/local_cache.rb:72:in call' rack (1.4.5) lib/rack/lock.rb:15:incall' actionpack (3.2.19) lib/action_dispatch/middleware/static.rb:63:in call' rack-cache (1.2) lib/rack/cache/context.rb:136:inforward' rack-cache (1.2) lib/rack/cache/context.rb:245:in fetch' rack-cache (1.2) lib/rack/cache/context.rb:185:inlookup' rack-cache (1.2) lib/rack/cache/context.rb:66:in call!' rack-cache (1.2) lib/rack/cache/context.rb:51:incall' railties (3.2.19) lib/rails/engine.rb:484:in call' railties (3.2.19) lib/rails/application.rb:231:incall' railties (3.2.19) lib/rails/railtie/configurable.rb:30:in method_missing' passenger (4.0.46) lib/phusion_passenger/rack/thread_handler_extension.rb:74:inprocess_request' passenger (4.0.46) lib/phusion_passenger/request_handler/thread_handler.rb:141:in accept_and_process_next_request' passenger (4.0.46) lib/phusion_passenger/request_handler/thread_handler.rb:109:inmain_loop' passenger (4.0.46) lib/phusion_passenger/request_handler.rb:448:in `block (3 levels) in start_threads'


Start Timer click (rounding error):

Started GET "/time_trackers/start?time_tracker%5Bissue_id%5D=4220" for IP.IP.IP.IP at 2014-07-18 11:04:27 +0200 Processing by TimeTrackersController#start as HTML Parameters: {"time_tracker"=>{"issue_id"=>"4220"}} Current user: Pene (id=33) Redirected to http://domain.com/issues/4220 Completed 302 Found in 4.9ms (ActiveRecord: 0.4ms) Started GET "/issues/4220" for IP.IP.IP.IP at 2014-07-18 11:04:27 +0200 Processing by IssuesController#show as HTML Parameters: {"id"=>"4220"} Current user: Pene (id=33) Rendered issues/_action_menu.html.erb (3.9ms) Rendered plugins/redmine_time_tracker/app/views/time_trackers/_issue_action_menu.html.erb (1.7ms) Rendered issue_relations/_form.html.erb (2.1ms) Rendered issues/_relations.html.erb (3.6ms) Rendered issues/_history.html.erb (23.2ms) Rendered issues/_action_menu.html.erb (4.5ms) Rendered issues/_form_custom_fields.html.erb (0.1ms) Rendered issues/_attributes.html.erb (18.9ms) Rendered issues/_form.html.erb (52.1ms) Rendered attachments/_form.html.erb (2.2ms) Rendered issues/_edit.html.erb (66.9ms) Rendered issues/_sidebar.html.erb (5.1ms) Rendered watchers/_watchers.html.erb (6.3ms) Rendered issues/show.html.erb within layouts/base (259.9ms) Rendered plugins/redmine_time_tracker/app/views/time_trackers/_assets.html.erb (1.7ms) Completed 200 OK in 370.7ms (Views: 293.5ms | ActiveRecord: 8.1ms)

jume-dev commented 9 years ago

Congratulations :) You just found a bug in our readme file. There is one line missing, which tells you to execute:

redmine:plugins:migrate RAILS_ENV=production

Please do this and see if it works.

Peneheals commented 9 years ago

Thank you very much, now it works! After executing "rake redmine:plugins:migrate RAILS_ENV=production", I got the below error message.

Migrating redmine_time_tracker (Redmine Time Tracker plugin)... == CreateTimeTrackers: migrating ============================================= -- create_table(:time_trackers) rake aborted! An error has occurred, all later migrations canceled:

Mysql2::Error: Table 'time_trackers' already exists: CREATE TABLE time_trackers (id int(11) DEFAULT NULL auto_increment PRIMARY KEY, user_id int(11), issue_id int(11), started_on datetime) ENGINE=InnoDB/home/thisisme/.rvm/gems/ruby-1.9.3-p547/gems/activerecord-3.2.19/lib/active_record/connection_adapters/abstract_mysql_adapter.rb:245:in `query' ...

Because there wasn't any data in this table, I just deleted, and tried to run that command again. It succeeded, compiled the coffee script files and the table as well. I had to restart Apache2 too. So thank you very much, I'm closing this issue.