diff options
Diffstat (limited to 'test/dummy/log')
| -rw-r--r-- | test/dummy/log/.gitkeep | 0 | ||||
| -rw-r--r-- | test/dummy/log/development.log | 2505 | ||||
| -rw-r--r-- | test/dummy/log/test.log | 1244 |
3 files changed, 3749 insertions, 0 deletions
diff --git a/test/dummy/log/.gitkeep b/test/dummy/log/.gitkeep new file mode 100644 index 0000000..e69de29 --- /dev/null +++ b/test/dummy/log/.gitkeep diff --git a/test/dummy/log/development.log b/test/dummy/log/development.log new file mode 100644 index 0000000..aaf6ba4 --- /dev/null +++ b/test/dummy/log/development.log @@ -0,0 +1,2505 @@ + + +Started GET "/sign_up" for 127.0.0.1 at Tue Sep 18 15:44:43 +0200 2012 +Processing by UsersController#new as HTML + Rendered /oldvar/src/leap/leap_web_users/app/views/users/new.html.haml within layouts/application (751.7ms) +Compiled application.css (1ms) (pid 4287) +Compiled jquery.js (7ms) (pid 4287) +Compiled jquery_ujs.js (1ms) (pid 4287) +Compiled srp/lib/MD5.js (0ms) (pid 4287) +Compiled srp/lib/SHA1.js (0ms) (pid 4287) +Compiled srp/lib/SHA256.js (0ms) (pid 4287) +Compiled srp/lib/aes.js (1ms) (pid 4287) +Compiled srp/lib/cryptoHelpers.js (0ms) (pid 4287) +Compiled srp/lib/jsbn.js (1ms) (pid 4287) +Compiled srp/lib/jsbn2.js (1ms) (pid 4287) +Compiled srp/lib/prng4.js (0ms) (pid 4287) +Compiled srp/lib/rng.js (0ms) (pid 4287) +Compiled srp/src/jqueryRest.js (0ms) (pid 4287) +Compiled srp/src/plainXHR.js (0ms) (pid 4287) +Compiled srp/src/srp.js (0ms) (pid 4287) +Compiled srp/src/srp_session.js (0ms) (pid 4287) +Compiled srp/index.js (186ms) (pid 4287) +Compiled application.js (459ms) (pid 4287) +Completed 200 OK in 1576ms (Views: 1574.7ms) + + +Started GET "/assets/application.css?body=1" for 127.0.0.1 at Tue Sep 18 15:44:45 +0200 2012 +Served asset /application.css - 200 OK (4ms) + + +Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at Tue Sep 18 15:44:45 +0200 2012 +Served asset /jquery.js - 200 OK (13ms) + + +Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at Tue Sep 18 15:44:45 +0200 2012 +Served asset /jquery_ujs.js - 200 OK (12ms) + + +Started GET "/assets/srp/lib/MD5.js?body=1" for 127.0.0.1 at Tue Sep 18 15:44:45 +0200 2012 +Served asset /srp/lib/MD5.js - 200 OK (4ms) + + +Started GET "/assets/srp/lib/SHA1.js?body=1" for 127.0.0.1 at Tue Sep 18 15:44:46 +0200 2012 +Served asset /srp/lib/SHA1.js - 200 OK (6ms) + + +Started GET "/assets/srp/lib/SHA256.js?body=1" for 127.0.0.1 at Tue Sep 18 15:44:46 +0200 2012 +Served asset /srp/lib/SHA256.js - 200 OK (4ms) + + +Started GET "/assets/srp/lib/aes.js?body=1" for 127.0.0.1 at Tue Sep 18 15:44:46 +0200 2012 +Served asset /srp/lib/aes.js - 200 OK (8ms) + + +Started GET "/assets/srp/lib/cryptoHelpers.js?body=1" for 127.0.0.1 at Tue Sep 18 15:44:46 +0200 2012 +Served asset /srp/lib/cryptoHelpers.js - 200 OK (4ms) + + +Started GET "/assets/srp/lib/jsbn.js?body=1" for 127.0.0.1 at Tue Sep 18 15:44:46 +0200 2012 +Served asset /srp/lib/jsbn.js - 200 OK (4ms) + + +Started GET "/assets/srp/lib/jsbn2.js?body=1" for 127.0.0.1 at Tue Sep 18 15:44:46 +0200 2012 +Served asset /srp/lib/jsbn2.js - 200 OK (75ms) + + +Started GET "/assets/srp/lib/prng4.js?body=1" for 127.0.0.1 at Tue Sep 18 15:44:46 +0200 2012 +Served asset /srp/lib/prng4.js - 200 OK (4ms) + + +Started GET "/assets/srp/lib/rng.js?body=1" for 127.0.0.1 at Tue Sep 18 15:44:46 +0200 2012 +Served asset /srp/lib/rng.js - 200 OK (4ms) + + +Started GET "/assets/srp/src/jqueryRest.js?body=1" for 127.0.0.1 at Tue Sep 18 15:44:46 +0200 2012 +Served asset /srp/src/jqueryRest.js - 200 OK (4ms) + + +Started GET "/assets/srp/src/plainXHR.js?body=1" for 127.0.0.1 at Tue Sep 18 15:44:46 +0200 2012 +Served asset /srp/src/plainXHR.js - 200 OK (3ms) + + +Started GET "/assets/srp/src/srp.js?body=1" for 127.0.0.1 at Tue Sep 18 15:44:46 +0200 2012 +Served asset /srp/src/srp.js - 200 OK (3ms) + + +Started GET "/assets/srp/src/srp_session.js?body=1" for 127.0.0.1 at Tue Sep 18 15:44:46 +0200 2012 +Served asset /srp/src/srp_session.js - 200 OK (4ms) + + +Started GET "/assets/srp/index.js?body=1" for 127.0.0.1 at Tue Sep 18 15:44:46 +0200 2012 +Served asset /srp/index.js - 200 OK (28ms) + + +Started GET "/assets/application.js?body=1" for 127.0.0.1 at Tue Sep 18 15:44:46 +0200 2012 +Served asset /application.js - 200 OK (33ms) + + +Started GET "/sign_up" for 127.0.0.1 at Tue Sep 18 15:44:58 +0200 2012 +Processing by UsersController#new as HTML + Rendered /oldvar/src/leap/leap_web_users/app/views/users/new.html.haml within layouts/application (12.2ms) +Completed 200 OK in 23ms (Views: 22.6ms) + + +Started GET "/assets/application.css?body=1" for 127.0.0.1 at Tue Sep 18 15:44:58 +0200 2012 +Served asset /application.css - 200 OK (0ms) + + +Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at Tue Sep 18 15:44:58 +0200 2012 +Served asset /jquery.js - 200 OK (0ms) + + +Started GET "/assets/srp/lib/SHA1.js?body=1" for 127.0.0.1 at Tue Sep 18 15:44:58 +0200 2012 +Served asset /srp/lib/SHA1.js - 200 OK (0ms) + + +Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at Tue Sep 18 15:44:58 +0200 2012 +Served asset /jquery_ujs.js - 200 OK (0ms) + + +Started GET "/assets/srp/lib/MD5.js?body=1" for 127.0.0.1 at Tue Sep 18 15:44:58 +0200 2012 +Served asset /srp/lib/MD5.js - 200 OK (0ms) + + +Started GET "/assets/srp/lib/aes.js?body=1" for 127.0.0.1 at Tue Sep 18 15:44:58 +0200 2012 +Served asset /srp/lib/aes.js - 200 OK (0ms) + + +Started GET "/assets/srp/lib/SHA256.js?body=1" for 127.0.0.1 at Tue Sep 18 15:44:58 +0200 2012 +Served asset /srp/lib/SHA256.js - 200 OK (0ms) + + +Started GET "/assets/srp/lib/cryptoHelpers.js?body=1" for 127.0.0.1 at Tue Sep 18 15:44:58 +0200 2012 +Served asset /srp/lib/cryptoHelpers.js - 200 OK (0ms) + + +Started GET "/assets/srp/lib/jsbn.js?body=1" for 127.0.0.1 at Tue Sep 18 15:44:58 +0200 2012 +Served asset /srp/lib/jsbn.js - 200 OK (0ms) + + +Started GET "/assets/srp/lib/jsbn2.js?body=1" for 127.0.0.1 at Tue Sep 18 15:44:58 +0200 2012 +Served asset /srp/lib/jsbn2.js - 200 OK (0ms) + + +Started GET "/assets/srp/lib/prng4.js?body=1" for 127.0.0.1 at Tue Sep 18 15:44:58 +0200 2012 +Served asset /srp/lib/prng4.js - 200 OK (0ms) + + +Started GET "/assets/srp/lib/rng.js?body=1" for 127.0.0.1 at Tue Sep 18 15:44:58 +0200 2012 +Served asset /srp/lib/rng.js - 200 OK (0ms) + + +Started GET "/assets/srp/src/jqueryRest.js?body=1" for 127.0.0.1 at Tue Sep 18 15:44:58 +0200 2012 +Served asset /srp/src/jqueryRest.js - 200 OK (0ms) + + +Started GET "/assets/srp/src/plainXHR.js?body=1" for 127.0.0.1 at Tue Sep 18 15:44:58 +0200 2012 +Served asset /srp/src/plainXHR.js - 200 OK (0ms) + + +Started GET "/assets/srp/src/srp.js?body=1" for 127.0.0.1 at Tue Sep 18 15:44:58 +0200 2012 +Served asset /srp/src/srp.js - 200 OK (0ms) + + +Started GET "/assets/srp/src/srp_session.js?body=1" for 127.0.0.1 at Tue Sep 18 15:44:58 +0200 2012 +Served asset /srp/src/srp_session.js - 200 OK (0ms) + + +Started GET "/assets/srp/index.js?body=1" for 127.0.0.1 at Tue Sep 18 15:44:58 +0200 2012 +Served asset /srp/index.js - 200 OK (1ms) + + +Started GET "/assets/application.js?body=1" for 127.0.0.1 at Tue Sep 18 15:44:58 +0200 2012 +Served asset /application.js - 200 OK (85ms) + + +Started GET "/sign_up" for 127.0.0.1 at Tue Sep 18 15:47:02 +0200 2012 +Processing by UsersController#new as HTML + Rendered /oldvar/src/leap/leap_web_users/app/views/users/new.html.haml within layouts/application (15.0ms) +Completed 500 Internal Server Error in 5855ms + +ActionView::Template::Error (/oldvar/src/leap/leap_web_users/test/dummy/app/assets/stylesheets/application.css has already been required): + 2: <html> + 3: <head> + 4: <title>Dummy</title> + 5: <%= stylesheet_link_tag "application", :media => "all" %> + 6: <%= javascript_include_tag "application" %> + 7: <%= csrf_meta_tags %> + 8: </head> + app/views/layouts/application.html.erb:5:in `_app_views_layouts_application_html_erb___654027934__617377338' + + + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_trace.erb (2.0ms) + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.1ms) + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/template_error.erb within rescues/layout (13.9ms) + + +Started GET "/sign_up" for 127.0.0.1 at Tue Sep 18 15:47:32 +0200 2012 +Processing by UsersController#new as HTML + Rendered /oldvar/src/leap/leap_web_users/app/views/users/new.html.haml within layouts/application (12.4ms) +Compiled application.css (1676ms) (pid 4287) +Completed 200 OK in 1951ms (Views: 1951.0ms) + + +Started GET "/assets/application.css?body=1" for 127.0.0.1 at Tue Sep 18 15:47:34 +0200 2012 +Served asset /application.css - 200 OK (24ms) + + +Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at Tue Sep 18 15:47:34 +0200 2012 +Served asset /jquery.js - 200 OK (0ms) + + +Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at Tue Sep 18 15:47:34 +0200 2012 +Served asset /jquery_ujs.js - 200 OK (0ms) + + +Started GET "/assets/srp/lib/MD5.js?body=1" for 127.0.0.1 at Tue Sep 18 15:47:34 +0200 2012 +Served asset /srp/lib/MD5.js - 200 OK (0ms) + + +Started GET "/assets/srp/lib/SHA1.js?body=1" for 127.0.0.1 at Tue Sep 18 15:47:34 +0200 2012 +Served asset /srp/lib/SHA1.js - 200 OK (0ms) + + +Started GET "/assets/srp/lib/SHA256.js?body=1" for 127.0.0.1 at Tue Sep 18 15:47:34 +0200 2012 +Served asset /srp/lib/SHA256.js - 200 OK (0ms) + + +Started GET "/assets/srp/lib/aes.js?body=1" for 127.0.0.1 at Tue Sep 18 15:47:34 +0200 2012 +Served asset /srp/lib/aes.js - 200 OK (0ms) + + +Started GET "/assets/srp/lib/cryptoHelpers.js?body=1" for 127.0.0.1 at Tue Sep 18 15:47:34 +0200 2012 +Served asset /srp/lib/cryptoHelpers.js - 200 OK (0ms) + + +Started GET "/assets/srp/lib/jsbn.js?body=1" for 127.0.0.1 at Tue Sep 18 15:47:34 +0200 2012 +Served asset /srp/lib/jsbn.js - 200 OK (0ms) + + +Started GET "/assets/srp/lib/jsbn2.js?body=1" for 127.0.0.1 at Tue Sep 18 15:47:34 +0200 2012 +Served asset /srp/lib/jsbn2.js - 200 OK (0ms) + + +Started GET "/assets/srp/lib/prng4.js?body=1" for 127.0.0.1 at Tue Sep 18 15:47:34 +0200 2012 +Served asset /srp/lib/prng4.js - 200 OK (0ms) + + +Started GET "/assets/srp/lib/rng.js?body=1" for 127.0.0.1 at Tue Sep 18 15:47:34 +0200 2012 +Served asset /srp/lib/rng.js - 200 OK (0ms) + + +Started GET "/assets/srp/src/jqueryRest.js?body=1" for 127.0.0.1 at Tue Sep 18 15:47:34 +0200 2012 +Served asset /srp/src/jqueryRest.js - 200 OK (0ms) + + +Started GET "/assets/srp/src/plainXHR.js?body=1" for 127.0.0.1 at Tue Sep 18 15:47:34 +0200 2012 +Served asset /srp/src/plainXHR.js - 200 OK (0ms) + + +Started GET "/assets/srp/src/srp.js?body=1" for 127.0.0.1 at Tue Sep 18 15:47:34 +0200 2012 +Served asset /srp/src/srp.js - 200 OK (0ms) + + +Started GET "/assets/srp/src/srp_session.js?body=1" for 127.0.0.1 at Tue Sep 18 15:47:34 +0200 2012 +Served asset /srp/src/srp_session.js - 200 OK (0ms) + + +Started GET "/assets/srp/index.js?body=1" for 127.0.0.1 at Tue Sep 18 15:47:34 +0200 2012 +Served asset /srp/index.js - 200 OK (1ms) + + +Started GET "/assets/application.js?body=1" for 127.0.0.1 at Tue Sep 18 15:47:34 +0200 2012 +Served asset /application.js - 200 OK (2ms) + + +Started GET "/sign_up" for 127.0.0.1 at Tue Sep 18 15:48:51 +0200 2012 +Processing by UsersController#new as HTML + Rendered /oldvar/src/leap/leap_web_users/app/views/users/new.html.haml within layouts/application (12.7ms) +Compiled srp/src/plainXHR.js (0ms) (pid 4287) +Compiled srp/index.js (10ms) (pid 4287) +Compiled application.js (11ms) (pid 4287) +Completed 200 OK in 170ms (Views: 169.8ms) + + +Started GET "/assets/application.css?body=1" for 127.0.0.1 at Tue Sep 18 15:48:51 +0200 2012 +Served asset /application.css - 200 OK (3ms) + + +Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at Tue Sep 18 15:48:51 +0200 2012 +Served asset /jquery.js - 200 OK (0ms) + + +Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at Tue Sep 18 15:48:51 +0200 2012 +Served asset /jquery_ujs.js - 200 OK (0ms) + + +Started GET "/assets/srp/lib/MD5.js?body=1" for 127.0.0.1 at Tue Sep 18 15:48:51 +0200 2012 +Served asset /srp/lib/MD5.js - 200 OK (0ms) + + +Started GET "/assets/srp/lib/aes.js?body=1" for 127.0.0.1 at Tue Sep 18 15:48:52 +0200 2012 +Served asset /srp/lib/aes.js - 200 OK (0ms) + + +Started GET "/assets/srp/lib/SHA1.js?body=1" for 127.0.0.1 at Tue Sep 18 15:48:52 +0200 2012 +Served asset /srp/lib/SHA1.js - 200 OK (0ms) + + +Started GET "/assets/srp/lib/SHA256.js?body=1" for 127.0.0.1 at Tue Sep 18 15:48:52 +0200 2012 +Served asset /srp/lib/SHA256.js - 200 OK (0ms) + + +Started GET "/assets/srp/lib/cryptoHelpers.js?body=1" for 127.0.0.1 at Tue Sep 18 15:48:52 +0200 2012 +Served asset /srp/lib/cryptoHelpers.js - 200 OK (0ms) + + +Started GET "/assets/srp/lib/jsbn.js?body=1" for 127.0.0.1 at Tue Sep 18 15:48:52 +0200 2012 +Served asset /srp/lib/jsbn.js - 200 OK (0ms) + + +Started GET "/assets/srp/lib/jsbn2.js?body=1" for 127.0.0.1 at Tue Sep 18 15:48:52 +0200 2012 +Served asset /srp/lib/jsbn2.js - 200 OK (0ms) + + +Started GET "/assets/srp/lib/prng4.js?body=1" for 127.0.0.1 at Tue Sep 18 15:48:52 +0200 2012 +Served asset /srp/lib/prng4.js - 200 OK (0ms) + + +Started GET "/assets/srp/lib/rng.js?body=1" for 127.0.0.1 at Tue Sep 18 15:48:52 +0200 2012 +Served asset /srp/lib/rng.js - 200 OK (0ms) + + +Started GET "/assets/srp/src/jqueryRest.js?body=1" for 127.0.0.1 at Tue Sep 18 15:48:52 +0200 2012 +Served asset /srp/src/jqueryRest.js - 200 OK (0ms) + + +Started GET "/assets/srp/src/plainXHR.js?body=1" for 127.0.0.1 at Tue Sep 18 15:48:52 +0200 2012 +Served asset /srp/src/plainXHR.js - 200 OK (4ms) + + +Started GET "/assets/srp/src/srp.js?body=1" for 127.0.0.1 at Tue Sep 18 15:48:52 +0200 2012 +Served asset /srp/src/srp.js - 200 OK (0ms) + + +Started GET "/assets/srp/src/srp_session.js?body=1" for 127.0.0.1 at Tue Sep 18 15:48:52 +0200 2012 +Served asset /srp/src/srp_session.js - 200 OK (0ms) + + +Started GET "/assets/srp/index.js?body=1" for 127.0.0.1 at Tue Sep 18 15:48:52 +0200 2012 +Served asset /srp/index.js - 200 OK (30ms) + + +Started GET "/assets/application.js?body=1" for 127.0.0.1 at Tue Sep 18 15:48:52 +0200 2012 +Served asset /application.js - 200 OK (39ms) + + +Started GET "/sign_up" for 127.0.0.1 at Tue Sep 18 15:50:33 +0200 2012 +Processing by UsersController#new as HTML + Rendered /oldvar/src/leap/leap_web_users/app/views/users/new.html.haml within layouts/application (14.0ms) +Compiled srp/index.js (11ms) (pid 4287) +Compiled application.js (80ms) (pid 4287) +Completed 200 OK in 172ms (Views: 171.5ms) + + +Started GET "/assets/application.css?body=1" for 127.0.0.1 at Tue Sep 18 15:50:33 +0200 2012 +Served asset /application.css - 200 OK (3ms) + + +Started GET "/assets/jquery.js?body=1" for 127.0.0.1 at Tue Sep 18 15:50:33 +0200 2012 +Served asset /jquery.js - 200 OK (0ms) + + +Started GET "/assets/jquery_ujs.js?body=1" for 127.0.0.1 at Tue Sep 18 15:50:33 +0200 2012 +Served asset /jquery_ujs.js - 200 OK (0ms) + + +Started GET "/assets/srp/lib/MD5.js?body=1" for 127.0.0.1 at Tue Sep 18 15:50:33 +0200 2012 +Served asset /srp/lib/MD5.js - 200 OK (0ms) + + +Started GET "/assets/srp/lib/SHA1.js?body=1" for 127.0.0.1 at Tue Sep 18 15:50:33 +0200 2012 +Served asset /srp/lib/SHA1.js - 200 OK (0ms) + + +Started GET "/assets/srp/lib/aes.js?body=1" for 127.0.0.1 at Tue Sep 18 15:50:33 +0200 2012 +Served asset /srp/lib/aes.js - 200 OK (0ms) + + +Started GET "/assets/srp/lib/SHA256.js?body=1" for 127.0.0.1 at Tue Sep 18 15:50:33 +0200 2012 +Served asset /srp/lib/SHA256.js - 200 OK (0ms) + + +Started GET "/assets/srp/lib/cryptoHelpers.js?body=1" for 127.0.0.1 at Tue Sep 18 15:50:33 +0200 2012 +Served asset /srp/lib/cryptoHelpers.js - 200 OK (0ms) + + +Started GET "/assets/srp/lib/jsbn.js?body=1" for 127.0.0.1 at Tue Sep 18 15:50:33 +0200 2012 +Served asset /srp/lib/jsbn.js - 200 OK (0ms) + + +Started GET "/assets/srp/lib/jsbn2.js?body=1" for 127.0.0.1 at Tue Sep 18 15:50:33 +0200 2012 +Served asset /srp/lib/jsbn2.js - 200 OK (0ms) + + +Started GET "/assets/srp/lib/prng4.js?body=1" for 127.0.0.1 at Tue Sep 18 15:50:33 +0200 2012 +Served asset /srp/lib/prng4.js - 200 OK (0ms) + + +Started GET "/assets/srp/lib/rng.js?body=1" for 127.0.0.1 at Tue Sep 18 15:50:33 +0200 2012 +Served asset /srp/lib/rng.js - 200 OK (0ms) + + +Started GET "/assets/srp/src/srp.js?body=1" for 127.0.0.1 at Tue Sep 18 15:50:33 +0200 2012 +Served asset /srp/src/srp.js - 200 OK (0ms) + + +Started GET "/assets/srp/src/jqueryRest.js?body=1" for 127.0.0.1 at Tue Sep 18 15:50:33 +0200 2012 +Served asset /srp/src/jqueryRest.js - 200 OK (0ms) + + +Started GET "/assets/srp/src/plainXHR.js?body=1" for 127.0.0.1 at Tue Sep 18 15:50:33 +0200 2012 +Served asset /srp/src/plainXHR.js - 200 OK (0ms) + + +Started GET "/assets/srp/src/srp_session.js?body=1" for 127.0.0.1 at Tue Sep 18 15:50:33 +0200 2012 +Served asset /srp/src/srp_session.js - 200 OK (0ms) + + +Started GET "/assets/srp/index.js?body=1" for 127.0.0.1 at Tue Sep 18 15:50:33 +0200 2012 +Served asset /srp/index.js - 200 OK (34ms) + + +Started GET "/assets/application.js?body=1" for 127.0.0.1 at Tue Sep 18 15:50:33 +0200 2012 +Served asset /application.js - 200 OK (111ms) + + +Started POST "/users.json" for 127.0.0.1 at Sun Sep 23 17:00:45 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"login"=>"O5H15R", "password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]"}} +WARNING: Can't verify CSRF token authenticity + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 201 Created in 685ms (Views: 0.3ms) + + +Started POST "/sessions" for 127.0.0.1 at Sun Sep 23 17:00:46 +0200 2012 +Processing by SessionsController#create as */* + Parameters: {"login"=>"O5H15R", "A"=>"12345"} +WARNING: Can't verify CSRF token authenticity +Completed 200 OK in 19ms (Views: 0.3ms) + + +Started POST "/sessions" for 127.0.0.1 at Sun Sep 23 17:00:46 +0200 2012 +Processing by SessionsController#create as */* + Parameters: {"login"=>"O5H15R", "A"=>"12345"} +WARNING: Can't verify CSRF token authenticity +Completed 200 OK in 11ms (Views: 0.3ms) + + +Started PUT "/sessions/O5H15R" for 127.0.0.1 at Sun Sep 23 17:00:46 +0200 2012 +Processing by SessionsController#update as */* + Parameters: {"id"=>"O5H15R", "M"=>"123"} +WARNING: Can't verify CSRF token authenticity +Completed 500 Internal Server Error in 12ms + +NoMethodError (undefined method `hex' for nil:NilClass): + /oldvar/src/leap/leap_web_users/app/controllers/sessions_controller.rb:15:in `update' + actionpack (3.2.8) lib/action_controller/metal/implicit_render.rb:4:in `send_action' + actionpack (3.2.8) lib/action_controller/metal/implicit_render.rb:4:in `send_action' + actionpack (3.2.8) lib/abstract_controller/base.rb:167:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/rendering.rb:10:in `process_action' + actionpack (3.2.8) lib/abstract_controller/callbacks.rb:18:in `process_action' + activesupport (3.2.8) lib/active_support/callbacks.rb:414:in `_run__545523884__process_action__787962131__callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `__run_callback' + activesupport (3.2.8) lib/active_support/callbacks.rb:385:in `_run_process_action_callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `run_callbacks' + actionpack (3.2.8) lib/abstract_controller/callbacks.rb:17:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/rescue.rb:29:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/instrumentation.rb:30:in `process_action' + activesupport (3.2.8) lib/active_support/notifications.rb:123:in `instrument' + activesupport (3.2.8) lib/active_support/notifications/instrumenter.rb:20:in `instrument' + activesupport (3.2.8) lib/active_support/notifications.rb:123:in `instrument' + actionpack (3.2.8) lib/action_controller/metal/instrumentation.rb:29:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/params_wrapper.rb:207:in `process_action' + actionpack (3.2.8) lib/abstract_controller/base.rb:121:in `process' + actionpack (3.2.8) lib/abstract_controller/rendering.rb:45:in `process' + actionpack (3.2.8) lib/action_controller/metal.rb:203:in `dispatch' + actionpack (3.2.8) lib/action_controller/metal/rack_delegation.rb:14:in `dispatch' + actionpack (3.2.8) lib/action_controller/metal.rb:246:in `action' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:73:in `call' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:73:in `dispatch' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:36:in `call' + journey (1.0.4) lib/journey/router.rb:68:in `call' + journey (1.0.4) lib/journey/router.rb:56:in `each' + journey (1.0.4) lib/journey/router.rb:56:in `call' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:600:in `call' + sass (3.1.20) lib/sass/./sass/plugin/rack.rb:54:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/best_standards_support.rb:17:in `call' + rack (1.4.1) lib/rack/etag.rb:23:in `call' + rack (1.4.1) lib/rack/conditionalget.rb:35:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/head.rb:14:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/params_parser.rb:21:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/flash.rb:242:in `call' + rack (1.4.1) lib/rack/session/abstract/id.rb:205:in `context' + rack (1.4.1) lib/rack/session/abstract/id.rb:200:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/cookies.rb:339:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/callbacks.rb:28:in `call' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `_run__237587485__call__4__callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `__run_callback' + activesupport (3.2.8) lib/active_support/callbacks.rb:385:in `_run_call_callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `run_callbacks' + actionpack (3.2.8) lib/action_dispatch/middleware/callbacks.rb:27:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/reloader.rb:65:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/remote_ip.rb:31:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/debug_exceptions.rb:16:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/show_exceptions.rb:56:in `call' + railties (3.2.8) lib/rails/rack/logger.rb:26:in `call_app' + railties (3.2.8) lib/rails/rack/logger.rb:16:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/request_id.rb:22:in `call' + rack (1.4.1) lib/rack/methodoverride.rb:21:in `call' + rack (1.4.1) lib/rack/runtime.rb:17:in `call' + activesupport (3.2.8) lib/active_support/cache/strategy/local_cache.rb:72:in `call' + rack (1.4.1) lib/rack/lock.rb:15:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/static.rb:62:in `call' + railties (3.2.8) lib/rails/engine.rb:479:in `call' + railties (3.2.8) lib/rails/application.rb:223:in `call' + rack (1.4.1) lib/rack/content_length.rb:14:in `call' + railties (3.2.8) lib/rails/rack/log_tailer.rb:17:in `call' + rack (1.4.1) lib/rack/handler/webrick.rb:59:in `service' + /usr/lib/ruby/1.8/webrick/httpserver.rb:104:in `service' + /usr/lib/ruby/1.8/webrick/httpserver.rb:65:in `run' + /usr/lib/ruby/1.8/webrick/server.rb:173:in `start_thread' + /usr/lib/ruby/1.8/webrick/server.rb:162:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:162:in `start_thread' + /usr/lib/ruby/1.8/webrick/server.rb:95:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:92:in `each' + /usr/lib/ruby/1.8/webrick/server.rb:92:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:23:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:82:in `start' + rack (1.4.1) lib/rack/handler/webrick.rb:13:in `run' + rack (1.4.1) lib/rack/server.rb:265:in `start' + railties (3.2.8) lib/rails/commands/server.rb:70:in `start' + railties (3.2.8) lib/rails/commands.rb:55 + railties (3.2.8) lib/rails/commands.rb:50:in `tap' + railties (3.2.8) lib/rails/commands.rb:50 + script/rails:6:in `require' + script/rails:6 + + + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.6ms) + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.2ms) + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (14.8ms) + + +Started POST "/users.json" for 127.0.0.1 at Sun Sep 23 17:20:09 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"login"=>"python_test_user_2BIJLT", "password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]"}} +WARNING: Can't verify CSRF token authenticity + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 201 Created in 98ms (Views: 0.2ms) + + +Started POST "/sessions" for 127.0.0.1 at Sun Sep 23 17:20:38 +0200 2012 +Processing by SessionsController#create as */* + Parameters: {"login"=>"python_test_user_65XJBI", "A"=>"12345"} +WARNING: Can't verify CSRF token authenticity +Completed 200 OK in 22ms (Views: 0.6ms) + + +Started POST "/users.json" for 127.0.0.1 at Sun Sep 23 17:21:35 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"login"=>"CZZJ1R", "password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]"}} +WARNING: Can't verify CSRF token authenticity + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 201 Created in 17ms (Views: 0.2ms) + + +Started POST "/sessions" for 127.0.0.1 at Sun Sep 23 17:21:35 +0200 2012 +Processing by SessionsController#create as */* + Parameters: {"login"=>"CZZJ1R", "A"=>"12345"} +WARNING: Can't verify CSRF token authenticity +Completed 200 OK in 13ms (Views: 0.3ms) + + +Started POST "/sessions" for 127.0.0.1 at Sun Sep 23 17:21:35 +0200 2012 +Processing by SessionsController#create as */* + Parameters: {"login"=>"CZZJ1R", "A"=>"12345"} +WARNING: Can't verify CSRF token authenticity +Completed 200 OK in 12ms (Views: 0.3ms) + + +Started PUT "/sessions/CZZJ1R" for 127.0.0.1 at Sun Sep 23 17:21:35 +0200 2012 +Processing by SessionsController#update as */* + Parameters: {"id"=>"CZZJ1R", "client_auth"=>"123"} +WARNING: Can't verify CSRF token authenticity +Completed 500 Internal Server Error in 70ms + +NoMethodError (undefined method `m1' for nil:NilClass): + ruby-srp (0.0.2) lib/srp/authentication.rb:49:in `authenticate' + ruby-srp (0.0.2) lib/srp/authentication.rb:45:in `authenticate!' + /oldvar/src/leap/leap_web_users/app/controllers/sessions_controller.rb:15:in `update' + actionpack (3.2.8) lib/action_controller/metal/implicit_render.rb:4:in `send_action' + actionpack (3.2.8) lib/action_controller/metal/implicit_render.rb:4:in `send_action' + actionpack (3.2.8) lib/abstract_controller/base.rb:167:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/rendering.rb:10:in `process_action' + actionpack (3.2.8) lib/abstract_controller/callbacks.rb:18:in `process_action' + activesupport (3.2.8) lib/active_support/callbacks.rb:414:in `_run__545523884__process_action__787962131__callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `__run_callback' + activesupport (3.2.8) lib/active_support/callbacks.rb:385:in `_run_process_action_callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `run_callbacks' + actionpack (3.2.8) lib/abstract_controller/callbacks.rb:17:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/rescue.rb:29:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/instrumentation.rb:30:in `process_action' + activesupport (3.2.8) lib/active_support/notifications.rb:123:in `instrument' + activesupport (3.2.8) lib/active_support/notifications/instrumenter.rb:20:in `instrument' + activesupport (3.2.8) lib/active_support/notifications.rb:123:in `instrument' + actionpack (3.2.8) lib/action_controller/metal/instrumentation.rb:29:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/params_wrapper.rb:207:in `process_action' + actionpack (3.2.8) lib/abstract_controller/base.rb:121:in `process' + actionpack (3.2.8) lib/abstract_controller/rendering.rb:45:in `process' + actionpack (3.2.8) lib/action_controller/metal.rb:203:in `dispatch' + actionpack (3.2.8) lib/action_controller/metal/rack_delegation.rb:14:in `dispatch' + actionpack (3.2.8) lib/action_controller/metal.rb:246:in `action' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:73:in `call' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:73:in `dispatch' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:36:in `call' + journey (1.0.4) lib/journey/router.rb:68:in `call' + journey (1.0.4) lib/journey/router.rb:56:in `each' + journey (1.0.4) lib/journey/router.rb:56:in `call' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:600:in `call' + sass (3.1.20) lib/sass/./sass/plugin/rack.rb:54:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/best_standards_support.rb:17:in `call' + rack (1.4.1) lib/rack/etag.rb:23:in `call' + rack (1.4.1) lib/rack/conditionalget.rb:35:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/head.rb:14:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/params_parser.rb:21:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/flash.rb:242:in `call' + rack (1.4.1) lib/rack/session/abstract/id.rb:205:in `context' + rack (1.4.1) lib/rack/session/abstract/id.rb:200:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/cookies.rb:339:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/callbacks.rb:28:in `call' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `_run__237587485__call__4__callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `__run_callback' + activesupport (3.2.8) lib/active_support/callbacks.rb:385:in `_run_call_callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `run_callbacks' + actionpack (3.2.8) lib/action_dispatch/middleware/callbacks.rb:27:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/reloader.rb:65:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/remote_ip.rb:31:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/debug_exceptions.rb:16:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/show_exceptions.rb:56:in `call' + railties (3.2.8) lib/rails/rack/logger.rb:26:in `call_app' + railties (3.2.8) lib/rails/rack/logger.rb:16:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/request_id.rb:22:in `call' + rack (1.4.1) lib/rack/methodoverride.rb:21:in `call' + rack (1.4.1) lib/rack/runtime.rb:17:in `call' + activesupport (3.2.8) lib/active_support/cache/strategy/local_cache.rb:72:in `call' + rack (1.4.1) lib/rack/lock.rb:15:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/static.rb:62:in `call' + railties (3.2.8) lib/rails/engine.rb:479:in `call' + railties (3.2.8) lib/rails/application.rb:223:in `call' + rack (1.4.1) lib/rack/content_length.rb:14:in `call' + railties (3.2.8) lib/rails/rack/log_tailer.rb:17:in `call' + rack (1.4.1) lib/rack/handler/webrick.rb:59:in `service' + /usr/lib/ruby/1.8/webrick/httpserver.rb:104:in `service' + /usr/lib/ruby/1.8/webrick/httpserver.rb:65:in `run' + /usr/lib/ruby/1.8/webrick/server.rb:173:in `start_thread' + /usr/lib/ruby/1.8/webrick/server.rb:162:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:162:in `start_thread' + /usr/lib/ruby/1.8/webrick/server.rb:95:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:92:in `each' + /usr/lib/ruby/1.8/webrick/server.rb:92:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:23:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:82:in `start' + rack (1.4.1) lib/rack/handler/webrick.rb:13:in `run' + rack (1.4.1) lib/rack/server.rb:265:in `start' + railties (3.2.8) lib/rails/commands/server.rb:70:in `start' + railties (3.2.8) lib/rails/commands.rb:55 + railties (3.2.8) lib/rails/commands.rb:50:in `tap' + railties (3.2.8) lib/rails/commands.rb:50 + script/rails:6:in `require' + script/rails:6 + + + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.6ms) + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.0ms) + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (11.5ms) + + +Started POST "/users.json" for 127.0.0.1 at Sun Sep 23 17:23:31 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_salt"=>"[FILTERED]", "login"=>"Z6TALH", "password_verifier"=>"[FILTERED]"}} +WARNING: Can't verify CSRF token authenticity + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 201 Created in 120ms (Views: 0.3ms) + + +Started POST "/sessions" for 127.0.0.1 at Sun Sep 23 17:23:31 +0200 2012 +Processing by SessionsController#create as */* + Parameters: {"login"=>"Z6TALH", "A"=>"12345"} +WARNING: Can't verify CSRF token authenticity +Completed 200 OK in 14ms (Views: 0.3ms) + + +Started POST "/sessions" for 127.0.0.1 at Sun Sep 23 17:23:31 +0200 2012 +Processing by SessionsController#create as */* + Parameters: {"login"=>"Z6TALH", "A"=>"12345"} +WARNING: Can't verify CSRF token authenticity +Completed 200 OK in 10ms (Views: 0.3ms) + + +Started PUT "/sessions/Z6TALH" for 127.0.0.1 at Sun Sep 23 17:23:31 +0200 2012 +Processing by SessionsController#update as */* + Parameters: {"id"=>"Z6TALH", "client_auth"=>"123"} +WARNING: Can't verify CSRF token authenticity + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 500 Internal Server Error in 11ms + +NoMethodError (undefined method `m1' for nil:NilClass): + ruby-srp (0.0.2) lib/srp/authentication.rb:49:in `authenticate' + ruby-srp (0.0.2) lib/srp/authentication.rb:45:in `authenticate!' + /oldvar/src/leap/leap_web_users/app/controllers/sessions_controller.rb:16:in `update' + actionpack (3.2.8) lib/action_controller/metal/implicit_render.rb:4:in `send_action' + actionpack (3.2.8) lib/action_controller/metal/implicit_render.rb:4:in `send_action' + actionpack (3.2.8) lib/abstract_controller/base.rb:167:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/rendering.rb:10:in `process_action' + actionpack (3.2.8) lib/abstract_controller/callbacks.rb:18:in `process_action' + activesupport (3.2.8) lib/active_support/callbacks.rb:414:in `_run__864269965__process_action__125080836__callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `__run_callback' + activesupport (3.2.8) lib/active_support/callbacks.rb:385:in `_run_process_action_callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `run_callbacks' + actionpack (3.2.8) lib/abstract_controller/callbacks.rb:17:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/rescue.rb:29:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/instrumentation.rb:30:in `process_action' + activesupport (3.2.8) lib/active_support/notifications.rb:123:in `instrument' + activesupport (3.2.8) lib/active_support/notifications/instrumenter.rb:20:in `instrument' + activesupport (3.2.8) lib/active_support/notifications.rb:123:in `instrument' + actionpack (3.2.8) lib/action_controller/metal/instrumentation.rb:29:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/params_wrapper.rb:207:in `process_action' + actionpack (3.2.8) lib/abstract_controller/base.rb:121:in `process' + actionpack (3.2.8) lib/abstract_controller/rendering.rb:45:in `process' + actionpack (3.2.8) lib/action_controller/metal.rb:203:in `dispatch' + actionpack (3.2.8) lib/action_controller/metal/rack_delegation.rb:14:in `dispatch' + actionpack (3.2.8) lib/action_controller/metal.rb:246:in `action' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:73:in `call' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:73:in `dispatch' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:36:in `call' + journey (1.0.4) lib/journey/router.rb:68:in `call' + journey (1.0.4) lib/journey/router.rb:56:in `each' + journey (1.0.4) lib/journey/router.rb:56:in `call' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:600:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/best_standards_support.rb:17:in `call' + rack (1.4.1) lib/rack/etag.rb:23:in `call' + rack (1.4.1) lib/rack/conditionalget.rb:35:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/head.rb:14:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/params_parser.rb:21:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/flash.rb:242:in `call' + rack (1.4.1) lib/rack/session/abstract/id.rb:205:in `context' + rack (1.4.1) lib/rack/session/abstract/id.rb:200:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/cookies.rb:339:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/callbacks.rb:28:in `call' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `_run__351353186__call__4__callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `__run_callback' + activesupport (3.2.8) lib/active_support/callbacks.rb:385:in `_run_call_callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `run_callbacks' + actionpack (3.2.8) lib/action_dispatch/middleware/callbacks.rb:27:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/reloader.rb:65:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/remote_ip.rb:31:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/debug_exceptions.rb:16:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/show_exceptions.rb:56:in `call' + railties (3.2.8) lib/rails/rack/logger.rb:26:in `call_app' + railties (3.2.8) lib/rails/rack/logger.rb:16:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/request_id.rb:22:in `call' + rack (1.4.1) lib/rack/methodoverride.rb:21:in `call' + rack (1.4.1) lib/rack/runtime.rb:17:in `call' + activesupport (3.2.8) lib/active_support/cache/strategy/local_cache.rb:72:in `call' + rack (1.4.1) lib/rack/lock.rb:15:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/static.rb:62:in `call' + railties (3.2.8) lib/rails/engine.rb:479:in `call' + railties (3.2.8) lib/rails/application.rb:223:in `call' + rack (1.4.1) lib/rack/content_length.rb:14:in `call' + railties (3.2.8) lib/rails/rack/log_tailer.rb:17:in `call' + rack (1.4.1) lib/rack/handler/webrick.rb:59:in `service' + /usr/lib/ruby/1.8/webrick/httpserver.rb:104:in `service' + /usr/lib/ruby/1.8/webrick/httpserver.rb:65:in `run' + /usr/lib/ruby/1.8/webrick/server.rb:173:in `start_thread' + /usr/lib/ruby/1.8/webrick/server.rb:162:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:162:in `start_thread' + /usr/lib/ruby/1.8/webrick/server.rb:95:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:92:in `each' + /usr/lib/ruby/1.8/webrick/server.rb:92:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:23:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:82:in `start' + rack (1.4.1) lib/rack/handler/webrick.rb:13:in `run' + rack (1.4.1) lib/rack/server.rb:265:in `start' + railties (3.2.8) lib/rails/commands/server.rb:70:in `start' + railties (3.2.8) lib/rails/commands.rb:55 + railties (3.2.8) lib/rails/commands.rb:50:in `tap' + railties (3.2.8) lib/rails/commands.rb:50 + script/rails:6:in `require' + script/rails:6 + + + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.6ms) + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.0ms) + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (11.2ms) + + +Started POST "/sessions" for 127.0.0.1 at Mon Sep 24 13:51:06 +0200 2012 +Processing by SessionsController#create as */* + Parameters: {"login"=>"python_test_user_Z9W9QZ", "A"=>"12345"} +WARNING: Can't verify CSRF token authenticity +Completed 200 OK in 210ms (Views: 0.7ms) + + +Started POST "/users.json" for 127.0.0.1 at Mon Sep 24 13:51:13 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_salt"=>"[FILTERED]", "login"=>"QR1CQE", "password_verifier"=>"[FILTERED]"}} +WARNING: Can't verify CSRF token authenticity + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 201 Created in 145ms (Views: 0.3ms) + + +Started POST "/sessions" for 127.0.0.1 at Mon Sep 24 13:51:13 +0200 2012 +Processing by SessionsController#create as */* + Parameters: {"login"=>"QR1CQE", "A"=>"12345"} +WARNING: Can't verify CSRF token authenticity +Completed 200 OK in 267ms (Views: 0.3ms) + + +Started POST "/sessions" for 127.0.0.1 at Mon Sep 24 13:51:14 +0200 2012 +Processing by SessionsController#create as */* + Parameters: {"login"=>"QR1CQE", "A"=>"12345"} +WARNING: Can't verify CSRF token authenticity +Completed 200 OK in 14ms (Views: 0.4ms) + + +Started PUT "/sessions/QR1CQE" for 127.0.0.1 at Mon Sep 24 13:51:14 +0200 2012 +Processing by SessionsController#update as */* + Parameters: {"client_auth"=>"123", "id"=>"QR1CQE"} +WARNING: Can't verify CSRF token authenticity + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 500 Internal Server Error in 8ms + +NoMethodError (undefined method `m1' for nil:NilClass): + ruby-srp (0.0.2) lib/srp/authentication.rb:49:in `authenticate' + ruby-srp (0.0.2) lib/srp/authentication.rb:45:in `authenticate!' + /oldvar/src/leap/leap_web_users/app/controllers/sessions_controller.rb:16:in `update' + actionpack (3.2.8) lib/action_controller/metal/implicit_render.rb:4:in `send_action' + actionpack (3.2.8) lib/action_controller/metal/implicit_render.rb:4:in `send_action' + actionpack (3.2.8) lib/abstract_controller/base.rb:167:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/rendering.rb:10:in `process_action' + actionpack (3.2.8) lib/abstract_controller/callbacks.rb:18:in `process_action' + activesupport (3.2.8) lib/active_support/callbacks.rb:414:in `_run__976707062__process_action__424034160__callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `__run_callback' + activesupport (3.2.8) lib/active_support/callbacks.rb:385:in `_run_process_action_callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `run_callbacks' + actionpack (3.2.8) lib/abstract_controller/callbacks.rb:17:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/rescue.rb:29:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/instrumentation.rb:30:in `process_action' + activesupport (3.2.8) lib/active_support/notifications.rb:123:in `instrument' + activesupport (3.2.8) lib/active_support/notifications/instrumenter.rb:20:in `instrument' + activesupport (3.2.8) lib/active_support/notifications.rb:123:in `instrument' + actionpack (3.2.8) lib/action_controller/metal/instrumentation.rb:29:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/params_wrapper.rb:207:in `process_action' + actionpack (3.2.8) lib/abstract_controller/base.rb:121:in `process' + actionpack (3.2.8) lib/abstract_controller/rendering.rb:45:in `process' + actionpack (3.2.8) lib/action_controller/metal.rb:203:in `dispatch' + actionpack (3.2.8) lib/action_controller/metal/rack_delegation.rb:14:in `dispatch' + actionpack (3.2.8) lib/action_controller/metal.rb:246:in `action' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:73:in `call' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:73:in `dispatch' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:36:in `call' + journey (1.0.4) lib/journey/router.rb:68:in `call' + journey (1.0.4) lib/journey/router.rb:56:in `each' + journey (1.0.4) lib/journey/router.rb:56:in `call' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:600:in `call' + sass (3.1.20) lib/sass/./sass/plugin/rack.rb:54:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/best_standards_support.rb:17:in `call' + rack (1.4.1) lib/rack/etag.rb:23:in `call' + rack (1.4.1) lib/rack/conditionalget.rb:35:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/head.rb:14:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/params_parser.rb:21:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/flash.rb:242:in `call' + rack (1.4.1) lib/rack/session/abstract/id.rb:205:in `context' + rack (1.4.1) lib/rack/session/abstract/id.rb:200:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/cookies.rb:339:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/callbacks.rb:28:in `call' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `_run__923441740__call__4__callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `__run_callback' + activesupport (3.2.8) lib/active_support/callbacks.rb:385:in `_run_call_callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `run_callbacks' + actionpack (3.2.8) lib/action_dispatch/middleware/callbacks.rb:27:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/reloader.rb:65:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/remote_ip.rb:31:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/debug_exceptions.rb:16:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/show_exceptions.rb:56:in `call' + railties (3.2.8) lib/rails/rack/logger.rb:26:in `call_app' + railties (3.2.8) lib/rails/rack/logger.rb:16:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/request_id.rb:22:in `call' + rack (1.4.1) lib/rack/methodoverride.rb:21:in `call' + rack (1.4.1) lib/rack/runtime.rb:17:in `call' + activesupport (3.2.8) lib/active_support/cache/strategy/local_cache.rb:72:in `call' + rack (1.4.1) lib/rack/lock.rb:15:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/static.rb:62:in `call' + railties (3.2.8) lib/rails/engine.rb:479:in `call' + railties (3.2.8) lib/rails/application.rb:223:in `call' + rack (1.4.1) lib/rack/content_length.rb:14:in `call' + railties (3.2.8) lib/rails/rack/log_tailer.rb:17:in `call' + rack (1.4.1) lib/rack/handler/webrick.rb:59:in `service' + /usr/lib/ruby/1.8/webrick/httpserver.rb:104:in `service' + /usr/lib/ruby/1.8/webrick/httpserver.rb:65:in `run' + /usr/lib/ruby/1.8/webrick/server.rb:173:in `start_thread' + /usr/lib/ruby/1.8/webrick/server.rb:162:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:162:in `start_thread' + /usr/lib/ruby/1.8/webrick/server.rb:95:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:92:in `each' + /usr/lib/ruby/1.8/webrick/server.rb:92:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:23:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:82:in `start' + rack (1.4.1) lib/rack/handler/webrick.rb:13:in `run' + rack (1.4.1) lib/rack/server.rb:265:in `start' + railties (3.2.8) lib/rails/commands/server.rb:70:in `start' + railties (3.2.8) lib/rails/commands.rb:55 + railties (3.2.8) lib/rails/commands.rb:50:in `tap' + railties (3.2.8) lib/rails/commands.rb:50 + script/rails:6:in `require' + script/rails:6 + + + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.7ms) + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.0ms) + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (16.6ms) + + +Started POST "/users.json" for 127.0.0.1 at Mon Sep 24 13:52:19 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_salt"=>"[FILTERED]", "login"=>"D8GF9U", "password_verifier"=>"[FILTERED]"}} +WARNING: Can't verify CSRF token authenticity +Completed 201 Created in 63888ms (Views: 0.4ms) + + +Started POST "/sessions" for 127.0.0.1 at Mon Sep 24 13:53:23 +0200 2012 +Processing by SessionsController#create as */* + Parameters: {"A"=>"12345", "login"=>"D8GF9U"} +WARNING: Can't verify CSRF token authenticity +Completed 200 OK in 29ms (Views: 0.3ms) + + +Started POST "/sessions" for 127.0.0.1 at Mon Sep 24 13:53:23 +0200 2012 +Processing by SessionsController#create as */* + Parameters: {"A"=>"12345", "login"=>"D8GF9U"} +WARNING: Can't verify CSRF token authenticity +Completed 200 OK in 13ms (Views: 0.3ms) + + +Started PUT "/sessions/D8GF9U" for 127.0.0.1 at Mon Sep 24 13:53:23 +0200 2012 +Processing by SessionsController#update as */* + Parameters: {"client_auth"=>"123", "id"=>"D8GF9U"} +WARNING: Can't verify CSRF token authenticity +Completed 500 Internal Server Error in 138423ms + +NoMethodError (undefined method `m1' for nil:NilClass): + ruby-srp (0.0.2) lib/srp/authentication.rb:49:in `authenticate' + ruby-srp (0.0.2) lib/srp/authentication.rb:45:in `authenticate!' + /oldvar/src/leap/leap_web_users/app/controllers/sessions_controller.rb:16:in `update' + actionpack (3.2.8) lib/action_controller/metal/implicit_render.rb:4:in `send_action' + actionpack (3.2.8) lib/action_controller/metal/implicit_render.rb:4:in `send_action' + actionpack (3.2.8) lib/abstract_controller/base.rb:167:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/rendering.rb:10:in `process_action' + actionpack (3.2.8) lib/abstract_controller/callbacks.rb:18:in `process_action' + activesupport (3.2.8) lib/active_support/callbacks.rb:414:in `_run__187471855__process_action__31421765__callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `__run_callback' + activesupport (3.2.8) lib/active_support/callbacks.rb:385:in `_run_process_action_callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `run_callbacks' + actionpack (3.2.8) lib/abstract_controller/callbacks.rb:17:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/rescue.rb:29:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/instrumentation.rb:30:in `process_action' + activesupport (3.2.8) lib/active_support/notifications.rb:123:in `instrument' + activesupport (3.2.8) lib/active_support/notifications/instrumenter.rb:20:in `instrument' + activesupport (3.2.8) lib/active_support/notifications.rb:123:in `instrument' + actionpack (3.2.8) lib/action_controller/metal/instrumentation.rb:29:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/params_wrapper.rb:207:in `process_action' + actionpack (3.2.8) lib/abstract_controller/base.rb:121:in `process' + actionpack (3.2.8) lib/abstract_controller/rendering.rb:45:in `process' + actionpack (3.2.8) lib/action_controller/metal.rb:203:in `dispatch' + actionpack (3.2.8) lib/action_controller/metal/rack_delegation.rb:14:in `dispatch' + actionpack (3.2.8) lib/action_controller/metal.rb:246:in `action' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:73:in `call' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:73:in `dispatch' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:36:in `call' + journey (1.0.4) lib/journey/router.rb:68:in `call' + journey (1.0.4) lib/journey/router.rb:56:in `each' + journey (1.0.4) lib/journey/router.rb:56:in `call' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:600:in `call' + sass (3.1.20) lib/sass/./sass/plugin/rack.rb:54:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/best_standards_support.rb:17:in `call' + rack (1.4.1) lib/rack/etag.rb:23:in `call' + rack (1.4.1) lib/rack/conditionalget.rb:35:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/head.rb:14:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/params_parser.rb:21:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/flash.rb:242:in `call' + rack (1.4.1) lib/rack/session/abstract/id.rb:205:in `context' + rack (1.4.1) lib/rack/session/abstract/id.rb:200:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/cookies.rb:339:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/callbacks.rb:28:in `call' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `_run__346269916__call__4__callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `__run_callback' + activesupport (3.2.8) lib/active_support/callbacks.rb:385:in `_run_call_callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `run_callbacks' + actionpack (3.2.8) lib/action_dispatch/middleware/callbacks.rb:27:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/reloader.rb:65:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/remote_ip.rb:31:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/debug_exceptions.rb:16:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/show_exceptions.rb:56:in `call' + railties (3.2.8) lib/rails/rack/logger.rb:26:in `call_app' + railties (3.2.8) lib/rails/rack/logger.rb:16:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/request_id.rb:22:in `call' + rack (1.4.1) lib/rack/methodoverride.rb:21:in `call' + rack (1.4.1) lib/rack/runtime.rb:17:in `call' + activesupport (3.2.8) lib/active_support/cache/strategy/local_cache.rb:72:in `call' + rack (1.4.1) lib/rack/lock.rb:15:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/static.rb:62:in `call' + railties (3.2.8) lib/rails/engine.rb:479:in `call' + railties (3.2.8) lib/rails/application.rb:223:in `call' + rack (1.4.1) lib/rack/content_length.rb:14:in `call' + railties (3.2.8) lib/rails/rack/log_tailer.rb:17:in `call' + rack (1.4.1) lib/rack/handler/webrick.rb:59:in `service' + /usr/lib/ruby/1.8/webrick/httpserver.rb:104:in `service' + /usr/lib/ruby/1.8/webrick/httpserver.rb:65:in `run' + /usr/lib/ruby/1.8/webrick/server.rb:173:in `start_thread' + /usr/lib/ruby/1.8/webrick/server.rb:162:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:162:in `start_thread' + /usr/lib/ruby/1.8/webrick/server.rb:95:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:92:in `each' + /usr/lib/ruby/1.8/webrick/server.rb:92:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:23:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:82:in `start' + rack (1.4.1) lib/rack/handler/webrick.rb:13:in `run' + rack (1.4.1) lib/rack/server.rb:265:in `start' + railties (3.2.8) lib/rails/commands/server.rb:70:in `start' + railties (3.2.8) lib/rails/commands.rb:55 + railties (3.2.8) lib/rails/commands.rb:50:in `tap' + railties (3.2.8) lib/rails/commands.rb:50 + script/rails:6:in `require' + script/rails:6 + + + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_trace.erb (2.0ms) + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.4ms) + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (13.5ms) + + +Started POST "/users.json" for 127.0.0.1 at Mon Sep 24 13:55:44 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_salt"=>"[FILTERED]", "login"=>"5PTK31", "password_verifier"=>"[FILTERED]"}} +WARNING: Can't verify CSRF token authenticity +Completed 201 Created in 9708ms (Views: 0.4ms) + + +Started POST "/sessions" for 127.0.0.1 at Mon Sep 24 13:55:54 +0200 2012 +Processing by SessionsController#create as */* + Parameters: {"A"=>"12345", "login"=>"5PTK31"} +WARNING: Can't verify CSRF token authenticity +Completed 200 OK in 77ms (Views: 0.3ms) + + +Started POST "/sessions" for 127.0.0.1 at Mon Sep 24 13:55:54 +0200 2012 +Processing by SessionsController#create as */* + Parameters: {"A"=>"12345", "login"=>"5PTK31"} +WARNING: Can't verify CSRF token authenticity +Completed 200 OK in 12ms (Views: 0.3ms) + + +Started PUT "/sessions/5PTK31" for 127.0.0.1 at Mon Sep 24 13:55:54 +0200 2012 +Processing by SessionsController#update as */* + Parameters: {"client_auth"=>"123", "id"=>"5PTK31"} +WARNING: Can't verify CSRF token authenticity +Completed 500 Internal Server Error in 129662ms + +NoMethodError (undefined method `m1' for nil:NilClass): + ruby-srp (0.0.2) lib/srp/authentication.rb:49:in `authenticate' + ruby-srp (0.0.2) lib/srp/authentication.rb:45:in `authenticate!' + /oldvar/src/leap/leap_web_users/app/controllers/sessions_controller.rb:16:in `update' + actionpack (3.2.8) lib/action_controller/metal/implicit_render.rb:4:in `send_action' + actionpack (3.2.8) lib/action_controller/metal/implicit_render.rb:4:in `send_action' + actionpack (3.2.8) lib/abstract_controller/base.rb:167:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/rendering.rb:10:in `process_action' + actionpack (3.2.8) lib/abstract_controller/callbacks.rb:18:in `process_action' + activesupport (3.2.8) lib/active_support/callbacks.rb:414:in `_run__187471855__process_action__31421765__callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `__run_callback' + activesupport (3.2.8) lib/active_support/callbacks.rb:385:in `_run_process_action_callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `run_callbacks' + actionpack (3.2.8) lib/abstract_controller/callbacks.rb:17:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/rescue.rb:29:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/instrumentation.rb:30:in `process_action' + activesupport (3.2.8) lib/active_support/notifications.rb:123:in `instrument' + activesupport (3.2.8) lib/active_support/notifications/instrumenter.rb:20:in `instrument' + activesupport (3.2.8) lib/active_support/notifications.rb:123:in `instrument' + actionpack (3.2.8) lib/action_controller/metal/instrumentation.rb:29:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/params_wrapper.rb:207:in `process_action' + actionpack (3.2.8) lib/abstract_controller/base.rb:121:in `process' + actionpack (3.2.8) lib/abstract_controller/rendering.rb:45:in `process' + actionpack (3.2.8) lib/action_controller/metal.rb:203:in `dispatch' + actionpack (3.2.8) lib/action_controller/metal/rack_delegation.rb:14:in `dispatch' + actionpack (3.2.8) lib/action_controller/metal.rb:246:in `action' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:73:in `call' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:73:in `dispatch' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:36:in `call' + journey (1.0.4) lib/journey/router.rb:68:in `call' + journey (1.0.4) lib/journey/router.rb:56:in `each' + journey (1.0.4) lib/journey/router.rb:56:in `call' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:600:in `call' + sass (3.1.20) lib/sass/./sass/plugin/rack.rb:54:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/best_standards_support.rb:17:in `call' + rack (1.4.1) lib/rack/etag.rb:23:in `call' + rack (1.4.1) lib/rack/conditionalget.rb:35:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/head.rb:14:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/params_parser.rb:21:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/flash.rb:242:in `call' + rack (1.4.1) lib/rack/session/abstract/id.rb:205:in `context' + rack (1.4.1) lib/rack/session/abstract/id.rb:200:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/cookies.rb:339:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/callbacks.rb:28:in `call' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `_run__346269916__call__4__callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `__run_callback' + activesupport (3.2.8) lib/active_support/callbacks.rb:385:in `_run_call_callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `run_callbacks' + actionpack (3.2.8) lib/action_dispatch/middleware/callbacks.rb:27:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/reloader.rb:65:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/remote_ip.rb:31:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/debug_exceptions.rb:16:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/show_exceptions.rb:56:in `call' + railties (3.2.8) lib/rails/rack/logger.rb:26:in `call_app' + railties (3.2.8) lib/rails/rack/logger.rb:16:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/request_id.rb:22:in `call' + rack (1.4.1) lib/rack/methodoverride.rb:21:in `call' + rack (1.4.1) lib/rack/runtime.rb:17:in `call' + activesupport (3.2.8) lib/active_support/cache/strategy/local_cache.rb:72:in `call' + rack (1.4.1) lib/rack/lock.rb:15:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/static.rb:62:in `call' + railties (3.2.8) lib/rails/engine.rb:479:in `call' + railties (3.2.8) lib/rails/application.rb:223:in `call' + rack (1.4.1) lib/rack/content_length.rb:14:in `call' + railties (3.2.8) lib/rails/rack/log_tailer.rb:17:in `call' + rack (1.4.1) lib/rack/handler/webrick.rb:59:in `service' + /usr/lib/ruby/1.8/webrick/httpserver.rb:104:in `service' + /usr/lib/ruby/1.8/webrick/httpserver.rb:65:in `run' + /usr/lib/ruby/1.8/webrick/server.rb:173:in `start_thread' + /usr/lib/ruby/1.8/webrick/server.rb:162:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:162:in `start_thread' + /usr/lib/ruby/1.8/webrick/server.rb:95:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:92:in `each' + /usr/lib/ruby/1.8/webrick/server.rb:92:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:23:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:82:in `start' + rack (1.4.1) lib/rack/handler/webrick.rb:13:in `run' + rack (1.4.1) lib/rack/server.rb:265:in `start' + railties (3.2.8) lib/rails/commands/server.rb:70:in `start' + railties (3.2.8) lib/rails/commands.rb:55 + railties (3.2.8) lib/rails/commands.rb:50:in `tap' + railties (3.2.8) lib/rails/commands.rb:50 + script/rails:6:in `require' + script/rails:6 + + + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.9ms) + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.2ms) + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (12.2ms) + + +Started POST "/users.json" for 127.0.0.1 at Mon Sep 24 14:01:37 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]", "login"=>"8RU895"}} +WARNING: Can't verify CSRF token authenticity +Completed 201 Created in 28884ms (Views: 0.4ms) + + +Started POST "/sessions" for 127.0.0.1 at Mon Sep 24 14:02:06 +0200 2012 +Processing by SessionsController#create as */* + Parameters: {"A"=>"12345", "login"=>"8RU895"} +WARNING: Can't verify CSRF token authenticity +Completed 200 OK in 18ms (Views: 0.4ms) + + +Started POST "/sessions" for 127.0.0.1 at Mon Sep 24 14:02:06 +0200 2012 +Processing by SessionsController#create as */* + Parameters: {"A"=>"12345", "login"=>"8RU895"} +WARNING: Can't verify CSRF token authenticity +Completed 200 OK in 11ms (Views: 0.3ms) + + +Started PUT "/sessions/8RU895" for 127.0.0.1 at Mon Sep 24 14:02:06 +0200 2012 +Processing by SessionsController#update as */* + Parameters: {"id"=>"8RU895", "client_auth"=>"123"} +WARNING: Can't verify CSRF token authenticity +DEPRECATION WARNING: ActiveSupport::Base64.decode64 is deprecated. Use Base64.decode64 instead. (called from send_action at /oldvar/src/leap/leap_web_users/app/controllers/sessions_controller.rb:16) +DEPRECATION WARNING: ActiveSupport::Base64.decode64 is deprecated. Use Base64.decode64 instead. (called from send_action at /oldvar/src/leap/leap_web_users/app/controllers/sessions_controller.rb:16) + + +Started POST "/users.json" for 127.0.0.1 at Mon Sep 24 14:53:35 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_salt"=>"[FILTERED]", "login"=>"JBEJ0N", "password_verifier"=>"[FILTERED]"}} +WARNING: Can't verify CSRF token authenticity +Completed 201 Created in 2459ms (Views: 0.4ms) + + +Started POST "/sessions" for 127.0.0.1 at Mon Sep 24 14:53:37 +0200 2012 +Processing by SessionsController#create as */* + Parameters: {"login"=>"JBEJ0N", "A"=>"12345"} +WARNING: Can't verify CSRF token authenticity +Completed 200 OK in 16ms (Views: 0.4ms) + + +Started POST "/sessions" for 127.0.0.1 at Mon Sep 24 14:53:37 +0200 2012 +Processing by SessionsController#create as */* + Parameters: {"login"=>"JBEJ0N", "A"=>"12345"} +WARNING: Can't verify CSRF token authenticity +Completed 200 OK in 12ms (Views: 0.3ms) + + +Started PUT "/sessions/JBEJ0N" for 127.0.0.1 at Mon Sep 24 14:53:37 +0200 2012 +Processing by SessionsController#update as */* + Parameters: {"id"=>"JBEJ0N", "client_auth"=>"123"} +WARNING: Can't verify CSRF token authenticity +DEPRECATION WARNING: ActiveSupport::Base64.decode64 is deprecated. Use Base64.decode64 instead. (called from update at /oldvar/src/leap/leap_web_users/app/controllers/sessions_controller.rb:14) +Completed 200 OK in 26117ms (Views: 0.4ms) + + +Started POST "/users.json" for 127.0.0.1 at Mon Sep 24 14:55:30 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]", "login"=>"QIN7SE"}} +WARNING: Can't verify CSRF token authenticity +Completed 201 Created in 4898ms (Views: 0.4ms) + + +Started POST "/sessions" for 127.0.0.1 at Mon Sep 24 14:55:35 +0200 2012 +Processing by SessionsController#create as */* + Parameters: {"A"=>"12345", "login"=>"QIN7SE"} +WARNING: Can't verify CSRF token authenticity +Completed 200 OK in 79ms (Views: 1.0ms) + + +Started POST "/sessions" for 127.0.0.1 at Mon Sep 24 14:55:35 +0200 2012 +Processing by SessionsController#create as */* + Parameters: {"A"=>"12345", "login"=>"QIN7SE"} +WARNING: Can't verify CSRF token authenticity +Completed 200 OK in 12ms (Views: 0.4ms) + + +Started PUT "/sessions/QIN7SE" for 127.0.0.1 at Mon Sep 24 14:55:35 +0200 2012 +Processing by SessionsController#update as */* + Parameters: {"client_auth"=>"123", "id"=>"QIN7SE"} +WARNING: Can't verify CSRF token authenticity +Completed 200 OK in 1006ms (Views: 0.5ms) + + +Started POST "/users.json" for 127.0.0.1 at Tue Sep 25 10:52:50 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_verifier"=>"[FILTERED]", "login"=>"PBX8XS", "password_salt"=>"[FILTERED]"}} +WARNING: Can't verify CSRF token authenticity +Completed 201 Created in 3184ms (Views: 0.4ms) + + +Started POST "/sessions" for 127.0.0.1 at Tue Sep 25 10:52:53 +0200 2012 +Processing by SessionsController#create as */* + Parameters: {"A"=>"12345", "login"=>"PBX8XS"} +WARNING: Can't verify CSRF token authenticity +Completed 200 OK in 17ms (Views: 0.3ms) + + +Started POST "/sessions" for 127.0.0.1 at Tue Sep 25 10:52:53 +0200 2012 +Processing by SessionsController#create as */* + Parameters: {"A"=>"12345", "login"=>"PBX8XS"} +WARNING: Can't verify CSRF token authenticity +Completed 200 OK in 12ms (Views: 0.3ms) + + +Started PUT "/sessions/PBX8XS" for 127.0.0.1 at Tue Sep 25 10:52:53 +0200 2012 +Processing by SessionsController#update as */* + Parameters: {"client_auth"=>"123", "id"=>"PBX8XS"} +WARNING: Can't verify CSRF token authenticity +Completed 500 Internal Server Error in 650602ms + +NoMethodError (undefined method `m1' for nil:NilClass): + ruby-srp (0.0.2) lib/srp/authentication.rb:49:in `authenticate' + ruby-srp (0.0.2) lib/srp/authentication.rb:45:in `authenticate!' + /oldvar/src/leap/leap_web_users/app/controllers/sessions_controller.rb:16:in `update' + actionpack (3.2.8) lib/action_controller/metal/implicit_render.rb:4:in `send_action' + actionpack (3.2.8) lib/action_controller/metal/implicit_render.rb:4:in `send_action' + actionpack (3.2.8) lib/abstract_controller/base.rb:167:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/rendering.rb:10:in `process_action' + actionpack (3.2.8) lib/abstract_controller/callbacks.rb:18:in `process_action' + activesupport (3.2.8) lib/active_support/callbacks.rb:414:in `_run__466870917__process_action__781300863__callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `__run_callback' + activesupport (3.2.8) lib/active_support/callbacks.rb:385:in `_run_process_action_callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `run_callbacks' + actionpack (3.2.8) lib/abstract_controller/callbacks.rb:17:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/rescue.rb:29:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/instrumentation.rb:30:in `process_action' + activesupport (3.2.8) lib/active_support/notifications.rb:123:in `instrument' + activesupport (3.2.8) lib/active_support/notifications/instrumenter.rb:20:in `instrument' + activesupport (3.2.8) lib/active_support/notifications.rb:123:in `instrument' + actionpack (3.2.8) lib/action_controller/metal/instrumentation.rb:29:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/params_wrapper.rb:207:in `process_action' + actionpack (3.2.8) lib/abstract_controller/base.rb:121:in `process' + actionpack (3.2.8) lib/abstract_controller/rendering.rb:45:in `process' + actionpack (3.2.8) lib/action_controller/metal.rb:203:in `dispatch' + actionpack (3.2.8) lib/action_controller/metal/rack_delegation.rb:14:in `dispatch' + actionpack (3.2.8) lib/action_controller/metal.rb:246:in `action' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:73:in `call' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:73:in `dispatch' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:36:in `call' + journey (1.0.4) lib/journey/router.rb:68:in `call' + journey (1.0.4) lib/journey/router.rb:56:in `each' + journey (1.0.4) lib/journey/router.rb:56:in `call' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:600:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/best_standards_support.rb:17:in `call' + rack (1.4.1) lib/rack/etag.rb:23:in `call' + rack (1.4.1) lib/rack/conditionalget.rb:35:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/head.rb:14:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/params_parser.rb:21:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/flash.rb:242:in `call' + rack (1.4.1) lib/rack/session/abstract/id.rb:205:in `context' + rack (1.4.1) lib/rack/session/abstract/id.rb:200:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/cookies.rb:339:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/callbacks.rb:28:in `call' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `_run__291805995__call__4__callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `__run_callback' + activesupport (3.2.8) lib/active_support/callbacks.rb:385:in `_run_call_callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `run_callbacks' + actionpack (3.2.8) lib/action_dispatch/middleware/callbacks.rb:27:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/reloader.rb:65:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/remote_ip.rb:31:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/debug_exceptions.rb:16:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/show_exceptions.rb:56:in `call' + railties (3.2.8) lib/rails/rack/logger.rb:26:in `call_app' + railties (3.2.8) lib/rails/rack/logger.rb:16:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/request_id.rb:22:in `call' + rack (1.4.1) lib/rack/methodoverride.rb:21:in `call' + rack (1.4.1) lib/rack/runtime.rb:17:in `call' + activesupport (3.2.8) lib/active_support/cache/strategy/local_cache.rb:72:in `call' + rack (1.4.1) lib/rack/lock.rb:15:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/static.rb:62:in `call' + railties (3.2.8) lib/rails/engine.rb:479:in `call' + railties (3.2.8) lib/rails/application.rb:223:in `call' + rack (1.4.1) lib/rack/content_length.rb:14:in `call' + railties (3.2.8) lib/rails/rack/log_tailer.rb:17:in `call' + rack (1.4.1) lib/rack/handler/webrick.rb:59:in `service' + /usr/lib/ruby/1.8/webrick/httpserver.rb:104:in `service' + /usr/lib/ruby/1.8/webrick/httpserver.rb:65:in `run' + /usr/lib/ruby/1.8/webrick/server.rb:173:in `start_thread' + /usr/lib/ruby/1.8/webrick/server.rb:162:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:162:in `start_thread' + /usr/lib/ruby/1.8/webrick/server.rb:95:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:92:in `each' + /usr/lib/ruby/1.8/webrick/server.rb:92:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:23:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:82:in `start' + rack (1.4.1) lib/rack/handler/webrick.rb:13:in `run' + rack (1.4.1) lib/rack/server.rb:265:in `start' + railties (3.2.8) lib/rails/commands/server.rb:70:in `start' + railties (3.2.8) lib/rails/commands.rb:55 + railties (3.2.8) lib/rails/commands.rb:50:in `tap' + railties (3.2.8) lib/rails/commands.rb:50 + script/rails:6:in `require' + script/rails:6 + + + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_trace.erb (2.0ms) + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.5ms) + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (13.2ms) + + +Started POST "/users.json" for 127.0.0.1 at Tue Sep 25 11:04:16 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_salt"=>"[FILTERED]", "login"=>"LCUH3R", "password_verifier"=>"[FILTERED]"}} +WARNING: Can't verify CSRF token authenticity +Completed 201 Created in 3223ms (Views: 0.4ms) + + +Started POST "/sessions" for 127.0.0.1 at Tue Sep 25 11:04:19 +0200 2012 +Processing by SessionsController#create as */* + Parameters: {"A"=>"12345", "login"=>"LCUH3R"} +WARNING: Can't verify CSRF token authenticity +Completed 200 OK in 16ms (Views: 0.4ms) + + +Started POST "/sessions" for 127.0.0.1 at Tue Sep 25 11:04:19 +0200 2012 +Processing by SessionsController#create as */* + Parameters: {"A"=>"12345", "login"=>"LCUH3R"} +WARNING: Can't verify CSRF token authenticity +Completed 200 OK in 14ms (Views: 0.3ms) + + +Started PUT "/sessions/LCUH3R" for 127.0.0.1 at Tue Sep 25 11:04:19 +0200 2012 +Processing by SessionsController#update as */* + Parameters: {"client_auth"=>"123", "id"=>"LCUH3R"} +WARNING: Can't verify CSRF token authenticity + + +Started POST "/users.json" for 127.0.0.1 at Tue Sep 25 11:11:52 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"login"=>"6X1B1C", "password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]"}} +WARNING: Can't verify CSRF token authenticity +Completed 201 Created in 24149ms (Views: 0.4ms) + + +Started POST "/sessions" for 127.0.0.1 at Tue Sep 25 11:19:05 +0200 2012 +Processing by SessionsController#create as */* + Parameters: {"login"=>"6X1B1C", "A"=>"12345"} +WARNING: Can't verify CSRF token authenticity +Completed 200 OK in 16ms (Views: 0.3ms) + + +Started POST "/sessions" for 127.0.0.1 at Tue Sep 25 11:31:24 +0200 2012 +Processing by SessionsController#create as */* + Parameters: {"login"=>"6X1B1C", "A"=>"12345"} +WARNING: Can't verify CSRF token authenticity +Completed 200 OK in 12ms (Views: 0.4ms) + + +Started PUT "/sessions/6X1B1C" for 127.0.0.1 at Tue Sep 25 11:33:07 +0200 2012 +Processing by SessionsController#update as */* + Parameters: {"client_auth"=>"123", "id"=>"6X1B1C"} +WARNING: Can't verify CSRF token authenticity +Completed 500 Internal Server Error in 1307ms + +NoMethodError (undefined method `m1' for nil:NilClass): + ruby-srp (0.0.2) lib/srp/authentication.rb:49:in `authenticate' + ruby-srp (0.0.2) lib/srp/authentication.rb:45:in `authenticate!' + /oldvar/src/leap/leap_web_users/app/controllers/sessions_controller.rb:16:in `update' + actionpack (3.2.8) lib/action_controller/metal/implicit_render.rb:4:in `send_action' + actionpack (3.2.8) lib/action_controller/metal/implicit_render.rb:4:in `send_action' + actionpack (3.2.8) lib/abstract_controller/base.rb:167:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/rendering.rb:10:in `process_action' + actionpack (3.2.8) lib/abstract_controller/callbacks.rb:18:in `process_action' + activesupport (3.2.8) lib/active_support/callbacks.rb:414:in `_run__193620331__process_action__203499565__callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `__run_callback' + activesupport (3.2.8) lib/active_support/callbacks.rb:385:in `_run_process_action_callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `run_callbacks' + actionpack (3.2.8) lib/abstract_controller/callbacks.rb:17:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/rescue.rb:29:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/instrumentation.rb:30:in `process_action' + activesupport (3.2.8) lib/active_support/notifications.rb:123:in `instrument' + activesupport (3.2.8) lib/active_support/notifications/instrumenter.rb:20:in `instrument' + activesupport (3.2.8) lib/active_support/notifications.rb:123:in `instrument' + actionpack (3.2.8) lib/action_controller/metal/instrumentation.rb:29:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/params_wrapper.rb:207:in `process_action' + actionpack (3.2.8) lib/abstract_controller/base.rb:121:in `process' + actionpack (3.2.8) lib/abstract_controller/rendering.rb:45:in `process' + actionpack (3.2.8) lib/action_controller/metal.rb:203:in `dispatch' + actionpack (3.2.8) lib/action_controller/metal/rack_delegation.rb:14:in `dispatch' + actionpack (3.2.8) lib/action_controller/metal.rb:246:in `action' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:73:in `call' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:73:in `dispatch' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:36:in `call' + journey (1.0.4) lib/journey/router.rb:68:in `call' + journey (1.0.4) lib/journey/router.rb:56:in `each' + journey (1.0.4) lib/journey/router.rb:56:in `call' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:600:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/best_standards_support.rb:17:in `call' + rack (1.4.1) lib/rack/etag.rb:23:in `call' + rack (1.4.1) lib/rack/conditionalget.rb:35:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/head.rb:14:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/params_parser.rb:21:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/flash.rb:242:in `call' + rack (1.4.1) lib/rack/session/abstract/id.rb:205:in `context' + rack (1.4.1) lib/rack/session/abstract/id.rb:200:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/cookies.rb:339:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/callbacks.rb:28:in `call' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `_run__138771931__call__4__callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `__run_callback' + activesupport (3.2.8) lib/active_support/callbacks.rb:385:in `_run_call_callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `run_callbacks' + actionpack (3.2.8) lib/action_dispatch/middleware/callbacks.rb:27:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/reloader.rb:65:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/remote_ip.rb:31:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/debug_exceptions.rb:16:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/show_exceptions.rb:56:in `call' + railties (3.2.8) lib/rails/rack/logger.rb:26:in `call_app' + railties (3.2.8) lib/rails/rack/logger.rb:16:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/request_id.rb:22:in `call' + rack (1.4.1) lib/rack/methodoverride.rb:21:in `call' + rack (1.4.1) lib/rack/runtime.rb:17:in `call' + activesupport (3.2.8) lib/active_support/cache/strategy/local_cache.rb:72:in `call' + rack (1.4.1) lib/rack/lock.rb:15:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/static.rb:62:in `call' + railties (3.2.8) lib/rails/engine.rb:479:in `call' + railties (3.2.8) lib/rails/application.rb:223:in `call' + rack (1.4.1) lib/rack/content_length.rb:14:in `call' + railties (3.2.8) lib/rails/rack/log_tailer.rb:17:in `call' + rack (1.4.1) lib/rack/handler/webrick.rb:59:in `service' + /usr/lib/ruby/1.8/webrick/httpserver.rb:104:in `service' + /usr/lib/ruby/1.8/webrick/httpserver.rb:65:in `run' + /usr/lib/ruby/1.8/webrick/server.rb:173:in `start_thread' + /usr/lib/ruby/1.8/webrick/server.rb:162:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:162:in `start_thread' + /usr/lib/ruby/1.8/webrick/server.rb:95:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:92:in `each' + /usr/lib/ruby/1.8/webrick/server.rb:92:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:23:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:82:in `start' + rack (1.4.1) lib/rack/handler/webrick.rb:13:in `run' + rack (1.4.1) lib/rack/server.rb:265:in `start' + railties (3.2.8) lib/rails/commands/server.rb:70:in `start' + railties (3.2.8) lib/rails/commands.rb:55 + railties (3.2.8) lib/rails/commands.rb:50:in `tap' + railties (3.2.8) lib/rails/commands.rb:50 + script/rails:6:in `require' + script/rails:6 + + + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_trace.erb (2.0ms) + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.2ms) + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (12.2ms) + + +Started POST "/users.json" for 127.0.0.1 at Tue Sep 25 11:33:17 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"login"=>"TAQJTG", "password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]"}} +WARNING: Can't verify CSRF token authenticity +Completed 201 Created in 12519ms (Views: 0.4ms) + + +Started POST "/sessions" for 127.0.0.1 at Tue Sep 25 11:33:30 +0200 2012 +Processing by SessionsController#create as */* + Parameters: {"login"=>"TAQJTG", "A"=>"12345"} +WARNING: Can't verify CSRF token authenticity +Completed 200 OK in 20ms (Views: 0.3ms) + + +Started POST "/sessions" for 127.0.0.1 at Tue Sep 25 11:33:39 +0200 2012 +Processing by SessionsController#create as */* + Parameters: {"login"=>"TAQJTG", "A"=>"12345"} +WARNING: Can't verify CSRF token authenticity +Completed 200 OK in 24ms (Views: 0.3ms) + + +Started PUT "/sessions/TAQJTG" for 127.0.0.1 at Tue Sep 25 11:34:37 +0200 2012 +Processing by SessionsController#update as */* + Parameters: {"client_auth"=>"123", "id"=>"TAQJTG"} +WARNING: Can't verify CSRF token authenticity +Completed 500 Internal Server Error in 797ms + +NoMethodError (undefined method `m1' for nil:NilClass): + ruby-srp (0.0.2) lib/srp/authentication.rb:49:in `authenticate' + ruby-srp (0.0.2) lib/srp/authentication.rb:45:in `authenticate!' + /oldvar/src/leap/leap_web_users/app/controllers/sessions_controller.rb:16:in `update' + actionpack (3.2.8) lib/action_controller/metal/implicit_render.rb:4:in `send_action' + actionpack (3.2.8) lib/action_controller/metal/implicit_render.rb:4:in `send_action' + actionpack (3.2.8) lib/abstract_controller/base.rb:167:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/rendering.rb:10:in `process_action' + actionpack (3.2.8) lib/abstract_controller/callbacks.rb:18:in `process_action' + activesupport (3.2.8) lib/active_support/callbacks.rb:414:in `_run__193620331__process_action__203499565__callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `__run_callback' + activesupport (3.2.8) lib/active_support/callbacks.rb:385:in `_run_process_action_callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `run_callbacks' + actionpack (3.2.8) lib/abstract_controller/callbacks.rb:17:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/rescue.rb:29:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/instrumentation.rb:30:in `process_action' + activesupport (3.2.8) lib/active_support/notifications.rb:123:in `instrument' + activesupport (3.2.8) lib/active_support/notifications/instrumenter.rb:20:in `instrument' + activesupport (3.2.8) lib/active_support/notifications.rb:123:in `instrument' + actionpack (3.2.8) lib/action_controller/metal/instrumentation.rb:29:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/params_wrapper.rb:207:in `process_action' + actionpack (3.2.8) lib/abstract_controller/base.rb:121:in `process' + actionpack (3.2.8) lib/abstract_controller/rendering.rb:45:in `process' + actionpack (3.2.8) lib/action_controller/metal.rb:203:in `dispatch' + actionpack (3.2.8) lib/action_controller/metal/rack_delegation.rb:14:in `dispatch' + actionpack (3.2.8) lib/action_controller/metal.rb:246:in `action' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:73:in `call' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:73:in `dispatch' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:36:in `call' + journey (1.0.4) lib/journey/router.rb:68:in `call' + journey (1.0.4) lib/journey/router.rb:56:in `each' + journey (1.0.4) lib/journey/router.rb:56:in `call' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:600:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/best_standards_support.rb:17:in `call' + rack (1.4.1) lib/rack/etag.rb:23:in `call' + rack (1.4.1) lib/rack/conditionalget.rb:35:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/head.rb:14:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/params_parser.rb:21:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/flash.rb:242:in `call' + rack (1.4.1) lib/rack/session/abstract/id.rb:205:in `context' + rack (1.4.1) lib/rack/session/abstract/id.rb:200:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/cookies.rb:339:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/callbacks.rb:28:in `call' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `_run__138771931__call__4__callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `__run_callback' + activesupport (3.2.8) lib/active_support/callbacks.rb:385:in `_run_call_callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `run_callbacks' + actionpack (3.2.8) lib/action_dispatch/middleware/callbacks.rb:27:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/reloader.rb:65:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/remote_ip.rb:31:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/debug_exceptions.rb:16:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/show_exceptions.rb:56:in `call' + railties (3.2.8) lib/rails/rack/logger.rb:26:in `call_app' + railties (3.2.8) lib/rails/rack/logger.rb:16:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/request_id.rb:22:in `call' + rack (1.4.1) lib/rack/methodoverride.rb:21:in `call' + rack (1.4.1) lib/rack/runtime.rb:17:in `call' + activesupport (3.2.8) lib/active_support/cache/strategy/local_cache.rb:72:in `call' + rack (1.4.1) lib/rack/lock.rb:15:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/static.rb:62:in `call' + railties (3.2.8) lib/rails/engine.rb:479:in `call' + railties (3.2.8) lib/rails/application.rb:223:in `call' + rack (1.4.1) lib/rack/content_length.rb:14:in `call' + railties (3.2.8) lib/rails/rack/log_tailer.rb:17:in `call' + rack (1.4.1) lib/rack/handler/webrick.rb:59:in `service' + /usr/lib/ruby/1.8/webrick/httpserver.rb:104:in `service' + /usr/lib/ruby/1.8/webrick/httpserver.rb:65:in `run' + /usr/lib/ruby/1.8/webrick/server.rb:173:in `start_thread' + /usr/lib/ruby/1.8/webrick/server.rb:162:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:162:in `start_thread' + /usr/lib/ruby/1.8/webrick/server.rb:95:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:92:in `each' + /usr/lib/ruby/1.8/webrick/server.rb:92:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:23:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:82:in `start' + rack (1.4.1) lib/rack/handler/webrick.rb:13:in `run' + rack (1.4.1) lib/rack/server.rb:265:in `start' + railties (3.2.8) lib/rails/commands/server.rb:70:in `start' + railties (3.2.8) lib/rails/commands.rb:55 + railties (3.2.8) lib/rails/commands.rb:50:in `tap' + railties (3.2.8) lib/rails/commands.rb:50 + script/rails:6:in `require' + script/rails:6 + + + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_trace.erb (2.1ms) + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.2ms) + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (12.6ms) + + +Started POST "/users.json" for 127.0.0.1 at Tue Sep 25 11:34:43 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"login"=>"YL20SR", "password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]"}} +WARNING: Can't verify CSRF token authenticity +Completed 201 Created in 3593ms (Views: 0.4ms) + + +Started POST "/sessions" for 127.0.0.1 at Tue Sep 25 11:34:51 +0200 2012 +Processing by SessionsController#create as */* + Parameters: {"login"=>"YL20SR", "A"=>"12345"} +WARNING: Can't verify CSRF token authenticity +Completed 200 OK in 23ms (Views: 0.4ms) + + +Started POST "/sessions" for 127.0.0.1 at Tue Sep 25 11:34:55 +0200 2012 +Processing by SessionsController#create as */* + Parameters: {"login"=>"YL20SR", "A"=>"12345"} +WARNING: Can't verify CSRF token authenticity +Completed 200 OK in 23ms (Views: 0.3ms) + + +Started PUT "/sessions/YL20SR" for 127.0.0.1 at Tue Sep 25 11:34:56 +0200 2012 +Processing by SessionsController#update as */* + Parameters: {"client_auth"=>"123", "id"=>"YL20SR"} +WARNING: Can't verify CSRF token authenticity +Completed 500 Internal Server Error in 1151ms + +NoMethodError (undefined method `m1' for nil:NilClass): + ruby-srp (0.0.2) lib/srp/authentication.rb:49:in `authenticate' + ruby-srp (0.0.2) lib/srp/authentication.rb:45:in `authenticate!' + /oldvar/src/leap/leap_web_users/app/controllers/sessions_controller.rb:16:in `update' + actionpack (3.2.8) lib/action_controller/metal/implicit_render.rb:4:in `send_action' + actionpack (3.2.8) lib/action_controller/metal/implicit_render.rb:4:in `send_action' + actionpack (3.2.8) lib/abstract_controller/base.rb:167:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/rendering.rb:10:in `process_action' + actionpack (3.2.8) lib/abstract_controller/callbacks.rb:18:in `process_action' + activesupport (3.2.8) lib/active_support/callbacks.rb:414:in `_run__193620331__process_action__203499565__callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `__run_callback' + activesupport (3.2.8) lib/active_support/callbacks.rb:385:in `_run_process_action_callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `run_callbacks' + actionpack (3.2.8) lib/abstract_controller/callbacks.rb:17:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/rescue.rb:29:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/instrumentation.rb:30:in `process_action' + activesupport (3.2.8) lib/active_support/notifications.rb:123:in `instrument' + activesupport (3.2.8) lib/active_support/notifications/instrumenter.rb:20:in `instrument' + activesupport (3.2.8) lib/active_support/notifications.rb:123:in `instrument' + actionpack (3.2.8) lib/action_controller/metal/instrumentation.rb:29:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/params_wrapper.rb:207:in `process_action' + actionpack (3.2.8) lib/abstract_controller/base.rb:121:in `process' + actionpack (3.2.8) lib/abstract_controller/rendering.rb:45:in `process' + actionpack (3.2.8) lib/action_controller/metal.rb:203:in `dispatch' + actionpack (3.2.8) lib/action_controller/metal/rack_delegation.rb:14:in `dispatch' + actionpack (3.2.8) lib/action_controller/metal.rb:246:in `action' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:73:in `call' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:73:in `dispatch' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:36:in `call' + journey (1.0.4) lib/journey/router.rb:68:in `call' + journey (1.0.4) lib/journey/router.rb:56:in `each' + journey (1.0.4) lib/journey/router.rb:56:in `call' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:600:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/best_standards_support.rb:17:in `call' + rack (1.4.1) lib/rack/etag.rb:23:in `call' + rack (1.4.1) lib/rack/conditionalget.rb:35:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/head.rb:14:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/params_parser.rb:21:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/flash.rb:242:in `call' + rack (1.4.1) lib/rack/session/abstract/id.rb:205:in `context' + rack (1.4.1) lib/rack/session/abstract/id.rb:200:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/cookies.rb:339:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/callbacks.rb:28:in `call' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `_run__138771931__call__4__callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `__run_callback' + activesupport (3.2.8) lib/active_support/callbacks.rb:385:in `_run_call_callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `run_callbacks' + actionpack (3.2.8) lib/action_dispatch/middleware/callbacks.rb:27:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/reloader.rb:65:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/remote_ip.rb:31:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/debug_exceptions.rb:16:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/show_exceptions.rb:56:in `call' + railties (3.2.8) lib/rails/rack/logger.rb:26:in `call_app' + railties (3.2.8) lib/rails/rack/logger.rb:16:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/request_id.rb:22:in `call' + rack (1.4.1) lib/rack/methodoverride.rb:21:in `call' + rack (1.4.1) lib/rack/runtime.rb:17:in `call' + activesupport (3.2.8) lib/active_support/cache/strategy/local_cache.rb:72:in `call' + rack (1.4.1) lib/rack/lock.rb:15:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/static.rb:62:in `call' + railties (3.2.8) lib/rails/engine.rb:479:in `call' + railties (3.2.8) lib/rails/application.rb:223:in `call' + rack (1.4.1) lib/rack/content_length.rb:14:in `call' + railties (3.2.8) lib/rails/rack/log_tailer.rb:17:in `call' + rack (1.4.1) lib/rack/handler/webrick.rb:59:in `service' + /usr/lib/ruby/1.8/webrick/httpserver.rb:104:in `service' + /usr/lib/ruby/1.8/webrick/httpserver.rb:65:in `run' + /usr/lib/ruby/1.8/webrick/server.rb:173:in `start_thread' + /usr/lib/ruby/1.8/webrick/server.rb:162:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:162:in `start_thread' + /usr/lib/ruby/1.8/webrick/server.rb:95:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:92:in `each' + /usr/lib/ruby/1.8/webrick/server.rb:92:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:23:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:82:in `start' + rack (1.4.1) lib/rack/handler/webrick.rb:13:in `run' + rack (1.4.1) lib/rack/server.rb:265:in `start' + railties (3.2.8) lib/rails/commands/server.rb:70:in `start' + railties (3.2.8) lib/rails/commands.rb:55 + railties (3.2.8) lib/rails/commands.rb:50:in `tap' + railties (3.2.8) lib/rails/commands.rb:50 + script/rails:6:in `require' + script/rails:6 + + + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_trace.erb (2.0ms) + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.1ms) + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (12.3ms) + + +Started POST "/users.json" for 127.0.0.1 at Tue Sep 25 11:43:31 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_salt"=>"[FILTERED]", "login"=>"UU6RH0", "password_verifier"=>"[FILTERED]"}} + + +Started POST "/users.json" for 127.0.0.1 at Tue Sep 25 11:48:03 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"login"=>"07MPU2", "password_salt"=>"[FILTERED]", "password_verifier"=>"[FILTERED]"}} + + +Started POST "/users.json" for 127.0.0.1 at Tue Sep 25 11:48:56 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]", "login"=>"6RPPJJ"}} + + +Started POST "/users.json" for 127.0.0.1 at Tue Sep 25 11:50:29 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_salt"=>"[FILTERED]", "login"=>"RQIHIW", "password_verifier"=>"[FILTERED]"}} +WARNING: Can't verify CSRF token authenticity +Completed 500 Internal Server Error in 119875ms + +RuntimeError (#destroy_session not implemented): + rack (1.4.1) lib/rack/session/abstract/id.rb:367:in `destroy_session' + actionpack (3.2.8) lib/action_dispatch/middleware/session/abstract_store.rb:17:in `send' + actionpack (3.2.8) lib/action_dispatch/middleware/session/abstract_store.rb:17:in `destroy' + actionpack (3.2.8) lib/action_dispatch/http/request.rb:210:in `reset_session' + actionpack (3.2.8) lib/action_controller/metal/rack_delegation.rb:23:in `reset_session' + actionpack (3.2.8) lib/action_controller/metal/request_forgery_protection.rb:85:in `handle_unverified_request' + actionpack (3.2.8) lib/action_controller/metal/request_forgery_protection.rb:78:in `verify_authenticity_token' + activesupport (3.2.8) lib/active_support/callbacks.rb:407:in `_run__711698483__process_action__294889909__callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `__run_callback' + activesupport (3.2.8) lib/active_support/callbacks.rb:385:in `_run_process_action_callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `run_callbacks' + actionpack (3.2.8) lib/abstract_controller/callbacks.rb:17:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/rescue.rb:29:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/instrumentation.rb:30:in `process_action' + activesupport (3.2.8) lib/active_support/notifications.rb:123:in `instrument' + activesupport (3.2.8) lib/active_support/notifications/instrumenter.rb:20:in `instrument' + activesupport (3.2.8) lib/active_support/notifications.rb:123:in `instrument' + actionpack (3.2.8) lib/action_controller/metal/instrumentation.rb:29:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/params_wrapper.rb:207:in `process_action' + actionpack (3.2.8) lib/abstract_controller/base.rb:121:in `process' + actionpack (3.2.8) lib/abstract_controller/rendering.rb:45:in `process' + actionpack (3.2.8) lib/action_controller/metal.rb:203:in `dispatch' + actionpack (3.2.8) lib/action_controller/metal/rack_delegation.rb:14:in `dispatch' + actionpack (3.2.8) lib/action_controller/metal.rb:246:in `action' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:73:in `call' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:73:in `dispatch' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:36:in `call' + journey (1.0.4) lib/journey/router.rb:68:in `call' + journey (1.0.4) lib/journey/router.rb:56:in `each' + journey (1.0.4) lib/journey/router.rb:56:in `call' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:600:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/best_standards_support.rb:17:in `call' + rack (1.4.1) lib/rack/etag.rb:23:in `call' + rack (1.4.1) lib/rack/conditionalget.rb:35:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/head.rb:14:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/params_parser.rb:21:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/flash.rb:242:in `call' + rack (1.4.1) lib/rack/session/abstract/id.rb:205:in `context' + rack (1.4.1) lib/rack/session/abstract/id.rb:200:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/cookies.rb:339:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/callbacks.rb:28:in `call' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `_run__888893177__call__4__callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `__run_callback' + activesupport (3.2.8) lib/active_support/callbacks.rb:385:in `_run_call_callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `run_callbacks' + actionpack (3.2.8) lib/action_dispatch/middleware/callbacks.rb:27:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/reloader.rb:65:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/remote_ip.rb:31:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/debug_exceptions.rb:16:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/show_exceptions.rb:56:in `call' + railties (3.2.8) lib/rails/rack/logger.rb:26:in `call_app' + railties (3.2.8) lib/rails/rack/logger.rb:16:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/request_id.rb:22:in `call' + rack (1.4.1) lib/rack/methodoverride.rb:21:in `call' + rack (1.4.1) lib/rack/runtime.rb:17:in `call' + activesupport (3.2.8) lib/active_support/cache/strategy/local_cache.rb:72:in `call' + rack (1.4.1) lib/rack/lock.rb:15:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/static.rb:62:in `call' + railties (3.2.8) lib/rails/engine.rb:479:in `call' + railties (3.2.8) lib/rails/application.rb:223:in `call' + rack (1.4.1) lib/rack/content_length.rb:14:in `call' + railties (3.2.8) lib/rails/rack/log_tailer.rb:17:in `call' + rack (1.4.1) lib/rack/handler/webrick.rb:59:in `service' + /usr/lib/ruby/1.8/webrick/httpserver.rb:104:in `service' + /usr/lib/ruby/1.8/webrick/httpserver.rb:65:in `run' + /usr/lib/ruby/1.8/webrick/server.rb:173:in `start_thread' + /usr/lib/ruby/1.8/webrick/server.rb:162:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:162:in `start_thread' + /usr/lib/ruby/1.8/webrick/server.rb:95:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:92:in `each' + /usr/lib/ruby/1.8/webrick/server.rb:92:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:23:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:82:in `start' + rack (1.4.1) lib/rack/handler/webrick.rb:13:in `run' + rack (1.4.1) lib/rack/server.rb:265:in `start' + railties (3.2.8) lib/rails/commands/server.rb:70:in `start' + railties (3.2.8) lib/rails/commands.rb:55 + railties (3.2.8) lib/rails/commands.rb:50:in `tap' + railties (3.2.8) lib/rails/commands.rb:50 + script/rails:6:in `require' + script/rails:6 + + + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_trace.erb (2.3ms) + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.4ms) + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (13.9ms) + + +Started POST "/users.json" for 127.0.0.1 at Tue Sep 25 12:11:11 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_salt"=>"[FILTERED]", "login"=>"IILLNQ", "password_verifier"=>"[FILTERED]"}} +WARNING: Can't verify CSRF token authenticity +Completed 500 Internal Server Error in 4980ms + +RuntimeError (#destroy_session not implemented): + rack (1.4.1) lib/rack/session/abstract/id.rb:367:in `destroy_session' + actionpack (3.2.8) lib/action_dispatch/middleware/session/abstract_store.rb:17:in `send' + actionpack (3.2.8) lib/action_dispatch/middleware/session/abstract_store.rb:17:in `destroy' + actionpack (3.2.8) lib/action_dispatch/http/request.rb:210:in `reset_session' + actionpack (3.2.8) lib/action_controller/metal/rack_delegation.rb:23:in `reset_session' + actionpack (3.2.8) lib/action_controller/metal/request_forgery_protection.rb:85:in `handle_unverified_request' + actionpack (3.2.8) lib/action_controller/metal/request_forgery_protection.rb:78:in `verify_authenticity_token' + activesupport (3.2.8) lib/active_support/callbacks.rb:407:in `_run__871243012__process_action__753637363__callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `__run_callback' + activesupport (3.2.8) lib/active_support/callbacks.rb:385:in `_run_process_action_callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `run_callbacks' + actionpack (3.2.8) lib/abstract_controller/callbacks.rb:17:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/rescue.rb:29:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/instrumentation.rb:30:in `process_action' + activesupport (3.2.8) lib/active_support/notifications.rb:123:in `instrument' + activesupport (3.2.8) lib/active_support/notifications/instrumenter.rb:20:in `instrument' + activesupport (3.2.8) lib/active_support/notifications.rb:123:in `instrument' + actionpack (3.2.8) lib/action_controller/metal/instrumentation.rb:29:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/params_wrapper.rb:207:in `process_action' + actionpack (3.2.8) lib/abstract_controller/base.rb:121:in `process' + actionpack (3.2.8) lib/abstract_controller/rendering.rb:45:in `process' + actionpack (3.2.8) lib/action_controller/metal.rb:203:in `dispatch' + actionpack (3.2.8) lib/action_controller/metal/rack_delegation.rb:14:in `dispatch' + actionpack (3.2.8) lib/action_controller/metal.rb:246:in `action' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:73:in `call' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:73:in `dispatch' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:36:in `call' + journey (1.0.4) lib/journey/router.rb:68:in `call' + journey (1.0.4) lib/journey/router.rb:56:in `each' + journey (1.0.4) lib/journey/router.rb:56:in `call' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:600:in `call' + sass (3.1.20) lib/sass/./sass/plugin/rack.rb:54:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/best_standards_support.rb:17:in `call' + rack (1.4.1) lib/rack/etag.rb:23:in `call' + rack (1.4.1) lib/rack/conditionalget.rb:35:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/head.rb:14:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/params_parser.rb:21:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/flash.rb:242:in `call' + rack (1.4.1) lib/rack/session/abstract/id.rb:205:in `context' + rack (1.4.1) lib/rack/session/abstract/id.rb:200:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/cookies.rb:339:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/callbacks.rb:28:in `call' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `_run__829662181__call__4__callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `__run_callback' + activesupport (3.2.8) lib/active_support/callbacks.rb:385:in `_run_call_callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `run_callbacks' + actionpack (3.2.8) lib/action_dispatch/middleware/callbacks.rb:27:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/reloader.rb:65:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/remote_ip.rb:31:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/debug_exceptions.rb:16:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/show_exceptions.rb:56:in `call' + railties (3.2.8) lib/rails/rack/logger.rb:26:in `call_app' + railties (3.2.8) lib/rails/rack/logger.rb:16:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/request_id.rb:22:in `call' + rack (1.4.1) lib/rack/methodoverride.rb:21:in `call' + rack (1.4.1) lib/rack/runtime.rb:17:in `call' + activesupport (3.2.8) lib/active_support/cache/strategy/local_cache.rb:72:in `call' + rack (1.4.1) lib/rack/lock.rb:15:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/static.rb:62:in `call' + railties (3.2.8) lib/rails/engine.rb:479:in `call' + railties (3.2.8) lib/rails/application.rb:223:in `call' + rack (1.4.1) lib/rack/content_length.rb:14:in `call' + railties (3.2.8) lib/rails/rack/log_tailer.rb:17:in `call' + rack (1.4.1) lib/rack/handler/webrick.rb:59:in `service' + /usr/lib/ruby/1.8/webrick/httpserver.rb:104:in `service' + /usr/lib/ruby/1.8/webrick/httpserver.rb:65:in `run' + /usr/lib/ruby/1.8/webrick/server.rb:173:in `start_thread' + /usr/lib/ruby/1.8/webrick/server.rb:162:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:162:in `start_thread' + /usr/lib/ruby/1.8/webrick/server.rb:95:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:92:in `each' + /usr/lib/ruby/1.8/webrick/server.rb:92:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:23:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:82:in `start' + rack (1.4.1) lib/rack/handler/webrick.rb:13:in `run' + rack (1.4.1) lib/rack/server.rb:265:in `start' + railties (3.2.8) lib/rails/commands/server.rb:70:in `start' + railties (3.2.8) lib/rails/commands.rb:55 + railties (3.2.8) lib/rails/commands.rb:50:in `tap' + railties (3.2.8) lib/rails/commands.rb:50 + script/rails:6:in `require' + script/rails:6 + + + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_trace.erb (2.0ms) + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.2ms) + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (12.8ms) + + +Started POST "/users.json" for 127.0.0.1 at Tue Sep 25 12:13:26 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"login"=>"4JSDWG", "password_salt"=>"[FILTERED]", "password_verifier"=>"[FILTERED]"}} +Completed 201 Created in 55ms (Views: 0.3ms) + + +Started POST "/sessions" for 127.0.0.1 at Tue Sep 25 12:13:26 +0200 2012 +Processing by SessionsController#create as */* + Parameters: {"login"=>"4JSDWG", "A"=>"12345"} +Completed 200 OK in 37872ms (Views: 0.9ms) + +ArgumentError (wrong number of arguments (4 for 3)): + rack (1.4.1) lib/rack/session/abstract/id.rb:322:in `set_session' + rack (1.4.1) lib/rack/session/abstract/id.rb:322:in `commit_session' + rack (1.4.1) lib/rack/session/abstract/id.rb:206:in `context' + rack (1.4.1) lib/rack/session/abstract/id.rb:200:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/cookies.rb:339:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/callbacks.rb:28:in `call' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `_run__893869306__call__4__callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `__run_callback' + activesupport (3.2.8) lib/active_support/callbacks.rb:385:in `_run_call_callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `run_callbacks' + actionpack (3.2.8) lib/action_dispatch/middleware/callbacks.rb:27:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/reloader.rb:65:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/remote_ip.rb:31:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/debug_exceptions.rb:16:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/show_exceptions.rb:56:in `call' + railties (3.2.8) lib/rails/rack/logger.rb:26:in `call_app' + railties (3.2.8) lib/rails/rack/logger.rb:16:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/request_id.rb:22:in `call' + rack (1.4.1) lib/rack/methodoverride.rb:21:in `call' + rack (1.4.1) lib/rack/runtime.rb:17:in `call' + activesupport (3.2.8) lib/active_support/cache/strategy/local_cache.rb:72:in `call' + rack (1.4.1) lib/rack/lock.rb:15:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/static.rb:62:in `call' + railties (3.2.8) lib/rails/engine.rb:479:in `call' + railties (3.2.8) lib/rails/application.rb:223:in `call' + rack (1.4.1) lib/rack/content_length.rb:14:in `call' + railties (3.2.8) lib/rails/rack/log_tailer.rb:17:in `call' + rack (1.4.1) lib/rack/handler/webrick.rb:59:in `service' + /usr/lib/ruby/1.8/webrick/httpserver.rb:104:in `service' + /usr/lib/ruby/1.8/webrick/httpserver.rb:65:in `run' + /usr/lib/ruby/1.8/webrick/server.rb:173:in `start_thread' + /usr/lib/ruby/1.8/webrick/server.rb:162:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:162:in `start_thread' + /usr/lib/ruby/1.8/webrick/server.rb:95:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:92:in `each' + /usr/lib/ruby/1.8/webrick/server.rb:92:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:23:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:82:in `start' + rack (1.4.1) lib/rack/handler/webrick.rb:13:in `run' + rack (1.4.1) lib/rack/server.rb:265:in `start' + railties (3.2.8) lib/rails/commands/server.rb:70:in `start' + railties (3.2.8) lib/rails/commands.rb:55 + railties (3.2.8) lib/rails/commands.rb:50:in `tap' + railties (3.2.8) lib/rails/commands.rb:50 + script/rails:6:in `require' + script/rails:6 + + + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.6ms) + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.2ms) + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (11.8ms) + + +Started POST "/sessions" for 127.0.0.1 at Tue Sep 25 12:14:04 +0200 2012 +Processing by SessionsController#create as */* + Parameters: {"login"=>"4JSDWG", "A"=>"12345"} + + +Started POST "/users.json" for 127.0.0.1 at Tue Sep 25 12:16:23 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"login"=>"4NLSBY", "password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]"}} +Completed 201 Created in 53ms (Views: 0.3ms) + + +Started POST "/sessions" for 127.0.0.1 at Tue Sep 25 12:16:23 +0200 2012 +Processing by SessionsController#create as */* + Parameters: {"login"=>"4NLSBY", "A"=>"12345"} +Completed 200 OK in 11334ms (Views: 0.9ms) + + +Started POST "/sessions" for 127.0.0.1 at Tue Sep 25 12:16:35 +0200 2012 + +RestClient::InternalServerError (500 Internal Server Error): + rest-client (1.6.7) lib/restclient/abstract_response.rb:48:in `return!' + rest-client (1.6.7) lib/restclient/request.rb:230:in `process_result' + rest-client (1.6.7) lib/restclient/request.rb:178:in `transmit' + /usr/lib/ruby/1.8/net/http.rb:543:in `start' + rest-client (1.6.7) lib/restclient/request.rb:172:in `transmit' + rest-client (1.6.7) lib/restclient/request.rb:64:in `execute' + rest-client (1.6.7) lib/restclient/request.rb:33:in `execute' + couchrest (1.1.3) lib/couchrest/rest_api.rb:94:in `execute' + couchrest (1.1.3) lib/couchrest/rest_api.rb:45:in `get' + couchrest (1.1.3) lib/couchrest/database.rb:82:in `get' + couchrest_session_store (0.0.1) lib/couchrest_session_store.rb:35:in `get_session' + rack (1.4.1) lib/rack/session/abstract/id.rb:246:in `load_session' + actionpack (3.2.8) lib/action_dispatch/middleware/session/abstract_store.rb:47:in `load_session' + actionpack (3.2.8) lib/action_dispatch/middleware/session/abstract_store.rb:55:in `stale_session_check!' + actionpack (3.2.8) lib/action_dispatch/middleware/session/abstract_store.rb:47:in `load_session' + rack (1.4.1) lib/rack/session/abstract/id.rb:130:in `send' + rack (1.4.1) lib/rack/session/abstract/id.rb:130:in `load!' + rack (1.4.1) lib/rack/session/abstract/id.rb:122:in `load_for_read!' + rack (1.4.1) lib/rack/session/abstract/id.rb:64:in `key?' + actionpack (3.2.8) lib/action_dispatch/middleware/flash.rb:258:in `call' + rack (1.4.1) lib/rack/session/abstract/id.rb:205:in `context' + rack (1.4.1) lib/rack/session/abstract/id.rb:200:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/cookies.rb:339:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/callbacks.rb:28:in `call' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `_run__83331831__call__4__callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `__run_callback' + activesupport (3.2.8) lib/active_support/callbacks.rb:385:in `_run_call_callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `run_callbacks' + actionpack (3.2.8) lib/action_dispatch/middleware/callbacks.rb:27:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/reloader.rb:65:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/remote_ip.rb:31:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/debug_exceptions.rb:16:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/show_exceptions.rb:56:in `call' + railties (3.2.8) lib/rails/rack/logger.rb:26:in `call_app' + railties (3.2.8) lib/rails/rack/logger.rb:16:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/request_id.rb:22:in `call' + rack (1.4.1) lib/rack/methodoverride.rb:21:in `call' + rack (1.4.1) lib/rack/runtime.rb:17:in `call' + activesupport (3.2.8) lib/active_support/cache/strategy/local_cache.rb:72:in `call' + rack (1.4.1) lib/rack/lock.rb:15:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/static.rb:62:in `call' + railties (3.2.8) lib/rails/engine.rb:479:in `call' + railties (3.2.8) lib/rails/application.rb:223:in `call' + rack (1.4.1) lib/rack/content_length.rb:14:in `call' + railties (3.2.8) lib/rails/rack/log_tailer.rb:17:in `call' + rack (1.4.1) lib/rack/handler/webrick.rb:59:in `service' + /usr/lib/ruby/1.8/webrick/httpserver.rb:104:in `service' + /usr/lib/ruby/1.8/webrick/httpserver.rb:65:in `run' + /usr/lib/ruby/1.8/webrick/server.rb:173:in `start_thread' + /usr/lib/ruby/1.8/webrick/server.rb:162:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:162:in `start_thread' + /usr/lib/ruby/1.8/webrick/server.rb:95:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:92:in `each' + /usr/lib/ruby/1.8/webrick/server.rb:92:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:23:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:82:in `start' + rack (1.4.1) lib/rack/handler/webrick.rb:13:in `run' + rack (1.4.1) lib/rack/server.rb:265:in `start' + railties (3.2.8) lib/rails/commands/server.rb:70:in `start' + railties (3.2.8) lib/rails/commands.rb:55 + railties (3.2.8) lib/rails/commands.rb:50:in `tap' + railties (3.2.8) lib/rails/commands.rb:50 + script/rails:6:in `require' + script/rails:6 + + + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.7ms) + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.5ms) + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (13.6ms) + + +Started PUT "/sessions/4NLSBY" for 127.0.0.1 at Tue Sep 25 12:17:56 +0200 2012 + + +Started POST "/users.json" for 127.0.0.1 at Tue Sep 25 12:22:38 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]", "login"=>"FGFSGF"}} +Completed 201 Created in 119ms (Views: 0.3ms) + + +Started POST "/sessions" for 127.0.0.1 at Tue Sep 25 12:22:38 +0200 2012 +Processing by SessionsController#create as */* + Parameters: {"A"=>"12345", "login"=>"FGFSGF"} +Completed 500 Internal Server Error in 2634ms + +NoMethodError (undefined method `marshal' for CouchRestSessionStore:Class): + couchrest_session_store (0.0.1) lib/couchrest_session_store.rb:52:in `get_session' + rack (1.4.1) lib/rack/session/abstract/id.rb:246:in `load_session' + actionpack (3.2.8) lib/action_dispatch/middleware/session/abstract_store.rb:47:in `load_session' + actionpack (3.2.8) lib/action_dispatch/middleware/session/abstract_store.rb:55:in `stale_session_check!' + actionpack (3.2.8) lib/action_dispatch/middleware/session/abstract_store.rb:47:in `load_session' + rack (1.4.1) lib/rack/session/abstract/id.rb:130:in `send' + rack (1.4.1) lib/rack/session/abstract/id.rb:130:in `load!' + rack (1.4.1) lib/rack/session/abstract/id.rb:126:in `load_for_write!' + rack (1.4.1) lib/rack/session/abstract/id.rb:71:in `[]=' + /oldvar/src/leap/leap_web_users/app/controllers/sessions_controller.rb:10:in `create' + actionpack (3.2.8) lib/action_controller/metal/implicit_render.rb:4:in `send_action' + actionpack (3.2.8) lib/action_controller/metal/implicit_render.rb:4:in `send_action' + actionpack (3.2.8) lib/abstract_controller/base.rb:167:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/rendering.rb:10:in `process_action' + actionpack (3.2.8) lib/abstract_controller/callbacks.rb:18:in `process_action' + activesupport (3.2.8) lib/active_support/callbacks.rb:403:in `_run__967875644__process_action__616544259__callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `__run_callback' + activesupport (3.2.8) lib/active_support/callbacks.rb:385:in `_run_process_action_callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `run_callbacks' + actionpack (3.2.8) lib/abstract_controller/callbacks.rb:17:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/rescue.rb:29:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/instrumentation.rb:30:in `process_action' + activesupport (3.2.8) lib/active_support/notifications.rb:123:in `instrument' + activesupport (3.2.8) lib/active_support/notifications/instrumenter.rb:20:in `instrument' + activesupport (3.2.8) lib/active_support/notifications.rb:123:in `instrument' + actionpack (3.2.8) lib/action_controller/metal/instrumentation.rb:29:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/params_wrapper.rb:207:in `process_action' + actionpack (3.2.8) lib/abstract_controller/base.rb:121:in `process' + actionpack (3.2.8) lib/abstract_controller/rendering.rb:45:in `process' + actionpack (3.2.8) lib/action_controller/metal.rb:203:in `dispatch' + actionpack (3.2.8) lib/action_controller/metal/rack_delegation.rb:14:in `dispatch' + actionpack (3.2.8) lib/action_controller/metal.rb:246:in `action' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:73:in `call' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:73:in `dispatch' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:36:in `call' + journey (1.0.4) lib/journey/router.rb:68:in `call' + journey (1.0.4) lib/journey/router.rb:56:in `each' + journey (1.0.4) lib/journey/router.rb:56:in `call' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:600:in `call' + sass (3.1.20) lib/sass/./sass/plugin/rack.rb:54:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/best_standards_support.rb:17:in `call' + rack (1.4.1) lib/rack/etag.rb:23:in `call' + rack (1.4.1) lib/rack/conditionalget.rb:35:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/head.rb:14:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/params_parser.rb:21:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/flash.rb:242:in `call' + rack (1.4.1) lib/rack/session/abstract/id.rb:205:in `context' + rack (1.4.1) lib/rack/session/abstract/id.rb:200:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/cookies.rb:339:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/callbacks.rb:28:in `call' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `_run__340473720__call__4__callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `__run_callback' + activesupport (3.2.8) lib/active_support/callbacks.rb:385:in `_run_call_callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `run_callbacks' + actionpack (3.2.8) lib/action_dispatch/middleware/callbacks.rb:27:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/reloader.rb:65:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/remote_ip.rb:31:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/debug_exceptions.rb:16:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/show_exceptions.rb:56:in `call' + railties (3.2.8) lib/rails/rack/logger.rb:26:in `call_app' + railties (3.2.8) lib/rails/rack/logger.rb:16:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/request_id.rb:22:in `call' + rack (1.4.1) lib/rack/methodoverride.rb:21:in `call' + rack (1.4.1) lib/rack/runtime.rb:17:in `call' + activesupport (3.2.8) lib/active_support/cache/strategy/local_cache.rb:72:in `call' + rack (1.4.1) lib/rack/lock.rb:15:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/static.rb:62:in `call' + railties (3.2.8) lib/rails/engine.rb:479:in `call' + railties (3.2.8) lib/rails/application.rb:223:in `call' + rack (1.4.1) lib/rack/content_length.rb:14:in `call' + railties (3.2.8) lib/rails/rack/log_tailer.rb:17:in `call' + rack (1.4.1) lib/rack/handler/webrick.rb:59:in `service' + /usr/lib/ruby/1.8/webrick/httpserver.rb:104:in `service' + /usr/lib/ruby/1.8/webrick/httpserver.rb:65:in `run' + /usr/lib/ruby/1.8/webrick/server.rb:173:in `start_thread' + /usr/lib/ruby/1.8/webrick/server.rb:162:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:162:in `start_thread' + /usr/lib/ruby/1.8/webrick/server.rb:95:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:92:in `each' + /usr/lib/ruby/1.8/webrick/server.rb:92:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:23:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:82:in `start' + rack (1.4.1) lib/rack/handler/webrick.rb:13:in `run' + rack (1.4.1) lib/rack/server.rb:265:in `start' + railties (3.2.8) lib/rails/commands/server.rb:70:in `start' + railties (3.2.8) lib/rails/commands.rb:55 + railties (3.2.8) lib/rails/commands.rb:50:in `tap' + railties (3.2.8) lib/rails/commands.rb:50 + script/rails:6:in `require' + script/rails:6 + + + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_trace.erb (2.0ms) + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.2ms) + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (12.5ms) + + +Started POST "/sessions" for 127.0.0.1 at Tue Sep 25 12:22:41 +0200 2012 +Processing by SessionsController#create as */* + Parameters: {"A"=>"12345", "login"=>"FGFSGF"} +Completed 500 Internal Server Error in 490ms + +NoMethodError (undefined method `marshal' for CouchRestSessionStore:Class): + couchrest_session_store (0.0.1) lib/couchrest_session_store.rb:52:in `get_session' + rack (1.4.1) lib/rack/session/abstract/id.rb:246:in `load_session' + actionpack (3.2.8) lib/action_dispatch/middleware/session/abstract_store.rb:47:in `load_session' + actionpack (3.2.8) lib/action_dispatch/middleware/session/abstract_store.rb:55:in `stale_session_check!' + actionpack (3.2.8) lib/action_dispatch/middleware/session/abstract_store.rb:47:in `load_session' + rack (1.4.1) lib/rack/session/abstract/id.rb:130:in `send' + rack (1.4.1) lib/rack/session/abstract/id.rb:130:in `load!' + rack (1.4.1) lib/rack/session/abstract/id.rb:126:in `load_for_write!' + rack (1.4.1) lib/rack/session/abstract/id.rb:71:in `[]=' + /oldvar/src/leap/leap_web_users/app/controllers/sessions_controller.rb:10:in `create' + actionpack (3.2.8) lib/action_controller/metal/implicit_render.rb:4:in `send_action' + actionpack (3.2.8) lib/action_controller/metal/implicit_render.rb:4:in `send_action' + actionpack (3.2.8) lib/abstract_controller/base.rb:167:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/rendering.rb:10:in `process_action' + actionpack (3.2.8) lib/abstract_controller/callbacks.rb:18:in `process_action' + activesupport (3.2.8) lib/active_support/callbacks.rb:403:in `_run__967875644__process_action__616544259__callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `__run_callback' + activesupport (3.2.8) lib/active_support/callbacks.rb:385:in `_run_process_action_callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `run_callbacks' + actionpack (3.2.8) lib/abstract_controller/callbacks.rb:17:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/rescue.rb:29:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/instrumentation.rb:30:in `process_action' + activesupport (3.2.8) lib/active_support/notifications.rb:123:in `instrument' + activesupport (3.2.8) lib/active_support/notifications/instrumenter.rb:20:in `instrument' + activesupport (3.2.8) lib/active_support/notifications.rb:123:in `instrument' + actionpack (3.2.8) lib/action_controller/metal/instrumentation.rb:29:in `process_action' + actionpack (3.2.8) lib/action_controller/metal/params_wrapper.rb:207:in `process_action' + actionpack (3.2.8) lib/abstract_controller/base.rb:121:in `process' + actionpack (3.2.8) lib/abstract_controller/rendering.rb:45:in `process' + actionpack (3.2.8) lib/action_controller/metal.rb:203:in `dispatch' + actionpack (3.2.8) lib/action_controller/metal/rack_delegation.rb:14:in `dispatch' + actionpack (3.2.8) lib/action_controller/metal.rb:246:in `action' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:73:in `call' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:73:in `dispatch' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:36:in `call' + journey (1.0.4) lib/journey/router.rb:68:in `call' + journey (1.0.4) lib/journey/router.rb:56:in `each' + journey (1.0.4) lib/journey/router.rb:56:in `call' + actionpack (3.2.8) lib/action_dispatch/routing/route_set.rb:600:in `call' + sass (3.1.20) lib/sass/./sass/plugin/rack.rb:54:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/best_standards_support.rb:17:in `call' + rack (1.4.1) lib/rack/etag.rb:23:in `call' + rack (1.4.1) lib/rack/conditionalget.rb:35:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/head.rb:14:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/params_parser.rb:21:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/flash.rb:242:in `call' + rack (1.4.1) lib/rack/session/abstract/id.rb:205:in `context' + rack (1.4.1) lib/rack/session/abstract/id.rb:200:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/cookies.rb:339:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/callbacks.rb:28:in `call' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `_run__340473720__call__4__callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `__run_callback' + activesupport (3.2.8) lib/active_support/callbacks.rb:385:in `_run_call_callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `run_callbacks' + actionpack (3.2.8) lib/action_dispatch/middleware/callbacks.rb:27:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/reloader.rb:65:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/remote_ip.rb:31:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/debug_exceptions.rb:16:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/show_exceptions.rb:56:in `call' + railties (3.2.8) lib/rails/rack/logger.rb:26:in `call_app' + railties (3.2.8) lib/rails/rack/logger.rb:16:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/request_id.rb:22:in `call' + rack (1.4.1) lib/rack/methodoverride.rb:21:in `call' + rack (1.4.1) lib/rack/runtime.rb:17:in `call' + activesupport (3.2.8) lib/active_support/cache/strategy/local_cache.rb:72:in `call' + rack (1.4.1) lib/rack/lock.rb:15:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/static.rb:62:in `call' + railties (3.2.8) lib/rails/engine.rb:479:in `call' + railties (3.2.8) lib/rails/application.rb:223:in `call' + rack (1.4.1) lib/rack/content_length.rb:14:in `call' + railties (3.2.8) lib/rails/rack/log_tailer.rb:17:in `call' + rack (1.4.1) lib/rack/handler/webrick.rb:59:in `service' + /usr/lib/ruby/1.8/webrick/httpserver.rb:104:in `service' + /usr/lib/ruby/1.8/webrick/httpserver.rb:65:in `run' + /usr/lib/ruby/1.8/webrick/server.rb:173:in `start_thread' + /usr/lib/ruby/1.8/webrick/server.rb:162:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:162:in `start_thread' + /usr/lib/ruby/1.8/webrick/server.rb:95:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:92:in `each' + /usr/lib/ruby/1.8/webrick/server.rb:92:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:23:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:82:in `start' + rack (1.4.1) lib/rack/handler/webrick.rb:13:in `run' + rack (1.4.1) lib/rack/server.rb:265:in `start' + railties (3.2.8) lib/rails/commands/server.rb:70:in `start' + railties (3.2.8) lib/rails/commands.rb:55 + railties (3.2.8) lib/rails/commands.rb:50:in `tap' + railties (3.2.8) lib/rails/commands.rb:50 + script/rails:6:in `require' + script/rails:6 + + + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.8ms) + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (1.2ms) + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (12.5ms) + + +Started PUT "/sessions/FGFSGF" for 127.0.0.1 at Tue Sep 25 12:22:42 +0200 2012 +Processing by SessionsController#update as */* + Parameters: {"id"=>"FGFSGF", "client_auth"=>"123"} + + +Started POST "/users.json" for 127.0.0.1 at Tue Sep 25 12:25:10 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_salt"=>"[FILTERED]", "password_verifier"=>"[FILTERED]", "login"=>"XILYHT"}} +Completed 201 Created in 56ms (Views: 0.3ms) + + +Started POST "/sessions" for 127.0.0.1 at Tue Sep 25 12:25:10 +0200 2012 +Processing by SessionsController#create as */* + Parameters: {"A"=>"12345", "login"=>"XILYHT"} +Completed 200 OK in 2780ms (Views: 0.8ms) + + +Started POST "/sessions" for 127.0.0.1 at Tue Sep 25 12:25:13 +0200 2012 +Processing by SessionsController#create as */* + Parameters: {"A"=>"12345", "login"=>"XILYHT"} +Completed 200 OK in 69ms (Views: 0.3ms) + + +Started PUT "/sessions/XILYHT" for 127.0.0.1 at Tue Sep 25 12:25:13 +0200 2012 +Processing by SessionsController#update as */* + Parameters: {"client_auth"=>"123", "id"=>"XILYHT"} +Completed 200 OK in 54ms (Views: 0.5ms) + + +Started GET "/sign_up" for 127.0.0.1 at Tue Oct 02 11:50:25 +0200 2012 + +RestClient::ResourceNotFound (404 Resource Not Found): + rest-client (1.6.7) lib/restclient/abstract_response.rb:48:in `return!' + rest-client (1.6.7) lib/restclient/request.rb:230:in `process_result' + rest-client (1.6.7) lib/restclient/request.rb:178:in `transmit' + /usr/lib/ruby/1.8/net/http.rb:543:in `start' + rest-client (1.6.7) lib/restclient/request.rb:172:in `transmit' + rest-client (1.6.7) lib/restclient/request.rb:64:in `execute' + rest-client (1.6.7) lib/restclient/request.rb:33:in `execute' + couchrest (1.1.3) lib/couchrest/rest_api.rb:94:in `execute' + couchrest (1.1.3) lib/couchrest/rest_api.rb:45:in `get' + couchrest (1.1.3) lib/couchrest/database.rb:82:in `get' + couchrest_session_store (0.0.1) lib/couchrest_session_store.rb:46:in `get_session' + rack (1.4.1) lib/rack/session/abstract/id.rb:246:in `load_session' + actionpack (3.2.8) lib/action_dispatch/middleware/session/abstract_store.rb:47:in `load_session' + actionpack (3.2.8) lib/action_dispatch/middleware/session/abstract_store.rb:55:in `stale_session_check!' + actionpack (3.2.8) lib/action_dispatch/middleware/session/abstract_store.rb:47:in `load_session' + rack (1.4.1) lib/rack/session/abstract/id.rb:130:in `send' + rack (1.4.1) lib/rack/session/abstract/id.rb:130:in `load!' + rack (1.4.1) lib/rack/session/abstract/id.rb:122:in `load_for_read!' + rack (1.4.1) lib/rack/session/abstract/id.rb:64:in `key?' + actionpack (3.2.8) lib/action_dispatch/middleware/flash.rb:258:in `call' + rack (1.4.1) lib/rack/session/abstract/id.rb:205:in `context' + rack (1.4.1) lib/rack/session/abstract/id.rb:200:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/cookies.rb:339:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/callbacks.rb:28:in `call' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `_run__844724840__call__4__callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:405:in `__run_callback' + activesupport (3.2.8) lib/active_support/callbacks.rb:385:in `_run_call_callbacks' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `send' + activesupport (3.2.8) lib/active_support/callbacks.rb:81:in `run_callbacks' + actionpack (3.2.8) lib/action_dispatch/middleware/callbacks.rb:27:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/reloader.rb:65:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/remote_ip.rb:31:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/debug_exceptions.rb:16:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/show_exceptions.rb:56:in `call' + railties (3.2.8) lib/rails/rack/logger.rb:26:in `call_app' + railties (3.2.8) lib/rails/rack/logger.rb:16:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/request_id.rb:22:in `call' + rack (1.4.1) lib/rack/methodoverride.rb:21:in `call' + rack (1.4.1) lib/rack/runtime.rb:17:in `call' + activesupport (3.2.8) lib/active_support/cache/strategy/local_cache.rb:72:in `call' + rack (1.4.1) lib/rack/lock.rb:15:in `call' + actionpack (3.2.8) lib/action_dispatch/middleware/static.rb:62:in `call' + railties (3.2.8) lib/rails/engine.rb:479:in `call' + railties (3.2.8) lib/rails/application.rb:223:in `call' + rack (1.4.1) lib/rack/content_length.rb:14:in `call' + railties (3.2.8) lib/rails/rack/log_tailer.rb:17:in `call' + rack (1.4.1) lib/rack/handler/webrick.rb:59:in `service' + /usr/lib/ruby/1.8/webrick/httpserver.rb:104:in `service' + /usr/lib/ruby/1.8/webrick/httpserver.rb:65:in `run' + /usr/lib/ruby/1.8/webrick/server.rb:173:in `start_thread' + /usr/lib/ruby/1.8/webrick/server.rb:162:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:162:in `start_thread' + /usr/lib/ruby/1.8/webrick/server.rb:95:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:92:in `each' + /usr/lib/ruby/1.8/webrick/server.rb:92:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:23:in `start' + /usr/lib/ruby/1.8/webrick/server.rb:82:in `start' + rack (1.4.1) lib/rack/handler/webrick.rb:13:in `run' + rack (1.4.1) lib/rack/server.rb:265:in `start' + railties (3.2.8) lib/rails/commands/server.rb:70:in `start' + railties (3.2.8) lib/rails/commands.rb:55 + railties (3.2.8) lib/rails/commands.rb:50:in `tap' + railties (3.2.8) lib/rails/commands.rb:50 + script/rails:6:in `require' + script/rails:6 + + + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_trace.erb (1.9ms) + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/_request_and_response.erb (2.3ms) + Rendered /var/lib/gems/1.8/gems/actionpack-3.2.8/lib/action_dispatch/middleware/templates/rescues/diagnostics.erb within rescues/layout (15.0ms) diff --git a/test/dummy/log/test.log b/test/dummy/log/test.log new file mode 100644 index 0000000..ccc2d30 --- /dev/null +++ b/test/dummy/log/test.log @@ -0,0 +1,1244 @@ + + +Started POST "/users.json" for 127.0.0.1 at Thu Aug 23 21:42:54 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]", "login"=>"integration_test_user"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 500 Internal Server Error in 62ms + + +Started POST "/users.json" for 127.0.0.1 at Thu Aug 23 21:42:55 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]", "login"=>"integration_test_user"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 500 Internal Server Error in 13ms + + +Started POST "/users.json" for 127.0.0.1 at Thu Aug 23 21:42:55 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]", "login"=>"integration_test_user"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 500 Internal Server Error in 15ms +Processing by SessionsController#destroy as HTML +Completed 500 Internal Server Error in 1ms +Processing by SessionsController#update as HTML + Parameters: {"client_auth"=>"a123", "id"=>"me"} +Completed 200 OK in 1ms (Views: 0.2ms) +Processing by SessionsController#new as HTML +Completed 500 Internal Server Error in 190ms +Processing by SessionsController#create as HTML + Parameters: {"A"=>"a123", "login"=>"me"} +Completed 200 OK in 1ms (Views: 0.2ms) +Processing by UsersController#create as HTML + Parameters: {"user"=>{"password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]", "login"=>"me"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 500 Internal Server Error in 1ms +Processing by UsersController#new as HTML +Completed 500 Internal Server Error in 30ms + + +Started POST "/users.json" for 127.0.0.1 at Thu Aug 23 22:56:01 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_salt"=>"[FILTERED]", "password_verifier"=>"[FILTERED]", "login"=>"integration_test_user"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 500 Internal Server Error in 1094ms + + +Started POST "/users.json" for 127.0.0.1 at Thu Aug 23 22:56:03 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_salt"=>"[FILTERED]", "password_verifier"=>"[FILTERED]", "login"=>"integration_test_user"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 500 Internal Server Error in 15ms + + +Started POST "/users.json" for 127.0.0.1 at Thu Aug 23 22:56:03 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_salt"=>"[FILTERED]", "password_verifier"=>"[FILTERED]", "login"=>"integration_test_user"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 500 Internal Server Error in 64ms +Processing by SessionsController#destroy as HTML +Completed 500 Internal Server Error in 1ms +Processing by SessionsController#update as HTML + Parameters: {"id"=>"me", "client_auth"=>"a123"} +Completed 200 OK in 1ms (Views: 0.2ms) +Processing by SessionsController#new as HTML +Completed 500 Internal Server Error in 1010ms +Processing by SessionsController#create as HTML + Parameters: {"A"=>"a123", "login"=>"me"} +Completed 200 OK in 1ms (Views: 0.2ms) +Processing by UsersController#create as HTML + Parameters: {"user"=>{"password_salt"=>"[FILTERED]", "password_verifier"=>"[FILTERED]", "login"=>"me"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 500 Internal Server Error in 1ms +Processing by UsersController#new as HTML +Completed 500 Internal Server Error in 68ms + + +Started POST "/users.json" for 127.0.0.1 at Thu Aug 23 23:49:45 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_salt"=>"[FILTERED]", "password_verifier"=>"[FILTERED]", "login"=>"integration_test_user"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 500 Internal Server Error in 42ms + + +Started POST "/users.json" for 127.0.0.1 at Thu Aug 23 23:49:45 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_salt"=>"[FILTERED]", "password_verifier"=>"[FILTERED]", "login"=>"integration_test_user"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 500 Internal Server Error in 12ms + + +Started POST "/users.json" for 127.0.0.1 at Thu Aug 23 23:49:45 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_salt"=>"[FILTERED]", "password_verifier"=>"[FILTERED]", "login"=>"integration_test_user"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 500 Internal Server Error in 13ms +Processing by SessionsController#destroy as HTML +Completed 500 Internal Server Error in 1ms +Processing by SessionsController#update as HTML + Parameters: {"client_auth"=>"a123", "id"=>"me"} +Completed 200 OK in 1ms (Views: 0.2ms) +Processing by SessionsController#new as HTML +Completed 500 Internal Server Error in 99ms +Processing by SessionsController#create as HTML + Parameters: {"A"=>"a123", "login"=>"me"} +Completed 200 OK in 1ms (Views: 0.2ms) +Processing by UsersController#create as HTML + Parameters: {"user"=>{"password_salt"=>"[FILTERED]", "password_verifier"=>"[FILTERED]", "login"=>"me"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 500 Internal Server Error in 1ms +Processing by UsersController#new as HTML +Completed 500 Internal Server Error in 29ms + + +Started POST "/users.json" for 127.0.0.1 at Thu Aug 23 23:55:38 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_verifier"=>"[FILTERED]", "login"=>"integration_test_user", "password_salt"=>"[FILTERED]"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 500 Internal Server Error in 43ms + + +Started POST "/users.json" for 127.0.0.1 at Thu Aug 23 23:55:38 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_verifier"=>"[FILTERED]", "login"=>"integration_test_user", "password_salt"=>"[FILTERED]"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 500 Internal Server Error in 15ms + + +Started POST "/users.json" for 127.0.0.1 at Thu Aug 23 23:55:38 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_verifier"=>"[FILTERED]", "login"=>"integration_test_user", "password_salt"=>"[FILTERED]"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 500 Internal Server Error in 21ms +Processing by SessionsController#destroy as HTML +Completed 500 Internal Server Error in 2ms +Processing by SessionsController#update as HTML + Parameters: {"id"=>"me", "client_auth"=>"a123"} +Completed 200 OK in 1ms (Views: 0.2ms) +Processing by SessionsController#new as HTML +Completed 500 Internal Server Error in 99ms +Processing by SessionsController#create as HTML + Parameters: {"login"=>"me", "A"=>"a123"} +Completed 200 OK in 1ms (Views: 0.2ms) +Processing by UsersController#create as HTML + Parameters: {"user"=>{"password_verifier"=>"[FILTERED]", "login"=>"me", "password_salt"=>"[FILTERED]"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 500 Internal Server Error in 1ms +Processing by UsersController#new as HTML +Completed 500 Internal Server Error in 29ms + + +Started POST "/users.json" for 127.0.0.1 at Fri Aug 24 00:03:59 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]", "login"=>"integration_test_user"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 500 Internal Server Error in 45ms + + +Started POST "/users.json" for 127.0.0.1 at Fri Aug 24 00:03:59 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]", "login"=>"integration_test_user"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 500 Internal Server Error in 15ms + + +Started POST "/users.json" for 127.0.0.1 at Fri Aug 24 00:03:59 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]", "login"=>"integration_test_user"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 500 Internal Server Error in 17ms +Processing by SessionsController#destroy as HTML +Completed 500 Internal Server Error in 1ms +Processing by SessionsController#update as HTML + Parameters: {"id"=>"me", "client_auth"=>"a123"} +Completed 200 OK in 1ms (Views: 0.2ms) +Processing by SessionsController#new as HTML +Completed 500 Internal Server Error in 98ms +Processing by SessionsController#create as HTML + Parameters: {"login"=>"me", "A"=>"a123"} +Completed 200 OK in 1ms (Views: 0.2ms) +Processing by SessionsController#create as HTML + Parameters: {"login"=>"login_that_does_not_exist"} +Completed 200 OK in 1ms (Views: 0.3ms) +Processing by UsersController#create as HTML + Parameters: {"user"=>{"password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]", "login"=>"me"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 500 Internal Server Error in 1ms +Processing by UsersController#new as HTML +Completed 500 Internal Server Error in 34ms +Processing by UsersController#create as HTML + Parameters: {"user"=>{"login"=>"me"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Redirected to http://test.host/users/new +Completed 302 Found in 2ms + + +Started POST "/users.json" for 127.0.0.1 at Fri Aug 24 00:08:20 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"login"=>"integration_test_user", "password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 201 Created in 49ms (Views: 0.3ms) + + +Started POST "/users.json" for 127.0.0.1 at Fri Aug 24 00:08:21 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"login"=>"integration_test_user", "password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 201 Created in 13ms (Views: 0.2ms) + + +Started POST "/users.json" for 127.0.0.1 at Fri Aug 24 00:08:21 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"login"=>"integration_test_user", "password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 201 Created in 13ms (Views: 0.3ms) +Processing by SessionsController#destroy as HTML +Redirected to http://test.host/ +Completed 302 Found in 1ms +Processing by SessionsController#update as HTML + Parameters: {"id"=>"me", "client_auth"=>"a123"} +Completed 200 OK in 1ms (Views: 0.2ms) +Processing by SessionsController#new as HTML +Completed 200 OK in 90ms (Views: 89.4ms) +Processing by SessionsController#create as HTML + Parameters: {"A"=>"a123", "login"=>"me"} +Completed 200 OK in 1ms (Views: 0.2ms) +Processing by SessionsController#create as HTML + Parameters: {"login"=>"login_that_does_not_exist"} +Completed 200 OK in 1ms (Views: 0.3ms) +Processing by UsersController#create as HTML + Parameters: {"user"=>{"login"=>"me", "password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Redirected to http://test.host/ +Completed 302 Found in 3ms +Processing by UsersController#new as HTML +Completed 200 OK in 19ms (Views: 18.2ms) +Processing by UsersController#create as HTML + Parameters: {"user"=>{"login"=>"me"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Redirected to http://test.host/users/new +Completed 302 Found in 2ms + + +Started POST "/users.json" for 127.0.0.1 at Fri Aug 24 09:34:21 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_verifier"=>"[FILTERED]", "login"=>"integration_test_user", "password_salt"=>"[FILTERED]"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 201 Created in 96ms (Views: 0.3ms) + + +Started POST "/users.json" for 127.0.0.1 at Fri Aug 24 09:34:21 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_verifier"=>"[FILTERED]", "login"=>"integration_test_user", "password_salt"=>"[FILTERED]"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 201 Created in 12ms (Views: 0.3ms) + + +Started POST "/users.json" for 127.0.0.1 at Fri Aug 24 09:34:21 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_verifier"=>"[FILTERED]", "login"=>"integration_test_user", "password_salt"=>"[FILTERED]"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 201 Created in 13ms (Views: 0.2ms) +Processing by SessionsController#destroy as HTML +Redirected to http://test.host/ +Completed 302 Found in 1ms +Processing by SessionsController#update as HTML + Parameters: {"id"=>"me", "client_auth"=>"a123"} +Completed 200 OK in 1ms (Views: 0.3ms) +Processing by SessionsController#new as HTML +Completed 200 OK in 212ms (Views: 211.6ms) +Processing by SessionsController#create as HTML + Parameters: {"login"=>"me", "A"=>"a123"} +Completed 200 OK in 1ms (Views: 0.2ms) +Processing by SessionsController#create as HTML + Parameters: {"login"=>"login_that_does_not_exist"} +Completed 200 OK in 1ms (Views: 0.3ms) +Processing by UsersController#create as HTML + Parameters: {"user"=>{"password_verifier"=>"[FILTERED]", "login"=>"me", "password_salt"=>"[FILTERED]"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Redirected to http://test.host/ +Completed 302 Found in 3ms +Processing by UsersController#new as HTML +Completed 200 OK in 35ms (Views: 34.5ms) +Processing by UsersController#create as HTML + Parameters: {"user"=>{"login"=>"me"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Redirected to http://test.host/users/new +Completed 302 Found in 1ms + + +Started POST "/users.json" for 127.0.0.1 at Fri Aug 24 09:35:32 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]", "login"=>"integration_test_user"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 201 Created in 50ms (Views: 0.3ms) + + +Started POST "/users.json" for 127.0.0.1 at Fri Aug 24 09:35:32 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]", "login"=>"integration_test_user"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 201 Created in 18ms (Views: 0.3ms) + + +Started POST "/users.json" for 127.0.0.1 at Fri Aug 24 09:35:32 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]", "login"=>"integration_test_user"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 201 Created in 13ms (Views: 0.3ms) +Processing by SessionsController#destroy as HTML +Redirected to http://test.host/ +Completed 302 Found in 1ms +Processing by SessionsController#update as HTML + Parameters: {"client_auth"=>"a123", "id"=>"me"} +Completed 200 OK in 1ms (Views: 0.2ms) +Processing by SessionsController#new as HTML +Completed 200 OK in 91ms (Views: 91.1ms) +Processing by SessionsController#create as HTML + Parameters: {"A"=>"a123", "login"=>"me"} +Completed 200 OK in 1ms (Views: 0.2ms) +Processing by SessionsController#create as HTML + Parameters: {"login"=>"login_that_does_not_exist"} +Completed 200 OK in 1ms (Views: 0.3ms) +Processing by SessionsController#update as HTML + Parameters: {"client_auth"=>"a123", "id"=>"me"} +Completed 200 OK in 1ms (Views: 0.3ms) +Processing by UsersController#create as HTML + Parameters: {"user"=>{"password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]", "login"=>"me"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Redirected to http://test.host/ +Completed 302 Found in 2ms +Processing by UsersController#new as HTML +Completed 200 OK in 18ms (Views: 17.6ms) +Processing by UsersController#create as HTML + Parameters: {"user"=>{"login"=>"me"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Redirected to http://test.host/users/new +Completed 302 Found in 1ms + + +Started POST "/users.json" for 127.0.0.1 at Fri Aug 24 09:47:02 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"login"=>"integration_test_user", "password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 201 Created in 52ms (Views: 0.3ms) + + +Started POST "/users.json" for 127.0.0.1 at Fri Aug 24 09:47:02 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"login"=>"integration_test_user", "password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 201 Created in 16ms (Views: 0.2ms) + + +Started POST "/users.json" for 127.0.0.1 at Fri Aug 24 09:47:02 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"login"=>"integration_test_user", "password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 201 Created in 12ms (Views: 0.2ms) +Processing by SessionsController#destroy as HTML +Redirected to http://test.host/ +Completed 302 Found in 1ms +Processing by SessionsController#update as HTML + Parameters: {"id"=>"me", "client_auth"=>"a123"} +Completed 200 OK in 1ms (Views: 0.2ms) +Processing by SessionsController#new as HTML +Completed 200 OK in 38ms (Views: 38.2ms) +Processing by SessionsController#create as HTML + Parameters: {"login"=>"me", "A"=>"a123"} +Completed 200 OK in 1ms (Views: 0.2ms) +Processing by SessionsController#create as HTML + Parameters: {"login"=>"login_that_does_not_exist"} +Completed 200 OK in 0ms (Views: 0.3ms) +Processing by SessionsController#update as HTML + Parameters: {"id"=>"me", "client_auth"=>"a123"} +Completed 200 OK in 0ms (Views: 0.3ms) +Processing by UsersController#create as HTML + Parameters: {"user"=>{"login"=>"me", "password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Redirected to http://test.host/ +Completed 302 Found in 2ms +Processing by UsersController#new as HTML +Completed 200 OK in 18ms (Views: 17.2ms) +Processing by UsersController#create as HTML + Parameters: {"user"=>{"login"=>"me"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Redirected to http://test.host/users/new +Completed 302 Found in 2ms + + +Started POST "/users.json" for 127.0.0.1 at Fri Aug 24 09:47:14 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_verifier"=>"[FILTERED]", "login"=>"integration_test_user", "password_salt"=>"[FILTERED]"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 201 Created in 50ms (Views: 0.3ms) + + +Started POST "/users.json" for 127.0.0.1 at Fri Aug 24 09:47:14 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_verifier"=>"[FILTERED]", "login"=>"integration_test_user", "password_salt"=>"[FILTERED]"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 201 Created in 14ms (Views: 0.2ms) + + +Started POST "/users.json" for 127.0.0.1 at Fri Aug 24 09:47:15 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_verifier"=>"[FILTERED]", "login"=>"integration_test_user", "password_salt"=>"[FILTERED]"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 201 Created in 13ms (Views: 0.2ms) +Processing by SessionsController#destroy as HTML +Redirected to http://test.host/ +Completed 302 Found in 1ms +Processing by SessionsController#update as HTML + Parameters: {"client_auth"=>"a123", "id"=>"me"} +Completed 200 OK in 1ms (Views: 0.2ms) +Processing by SessionsController#new as HTML +Completed 200 OK in 38ms (Views: 37.6ms) +Processing by SessionsController#create as HTML + Parameters: {"A"=>"a123", "login"=>"me"} +Completed 200 OK in 1ms (Views: 0.2ms) +Processing by SessionsController#create as HTML + Parameters: {"login"=>"login_that_does_not_exist"} +Completed 200 OK in 0ms (Views: 0.3ms) +Processing by SessionsController#update as HTML + Parameters: {"client_auth"=>"a123", "id"=>"me"} +Completed 200 OK in 0ms (Views: 0.2ms) +Processing by UsersController#create as HTML + Parameters: {"user"=>{"password_verifier"=>"[FILTERED]", "login"=>"me", "password_salt"=>"[FILTERED]"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Redirected to http://test.host/ +Completed 302 Found in 3ms +Processing by UsersController#new as HTML +Completed 200 OK in 17ms (Views: 17.0ms) +Processing by UsersController#create as HTML + Parameters: {"user"=>{"login"=>"me"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Redirected to http://test.host/users/new +Completed 302 Found in 1ms + + +Started POST "/users.json" for 127.0.0.1 at Fri Aug 24 09:53:07 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"login"=>"integration_test_user", "password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 201 Created in 56ms (Views: 0.3ms) + + +Started POST "/sessions" for 127.0.0.1 at Fri Aug 24 09:53:07 +0200 2012 +Processing by SessionsController#create as HTML + Parameters: {"login"=>"integration_test_user", "A"=>"86b7b6251081d6cc54e23706ecb92019f7eb770dbe9161e97371a155aa3ba904"} +Completed 200 OK in 8ms (Views: 0.3ms) + + +Started PUT "/sessions/integration_test_user" for 127.0.0.1 at Fri Aug 24 09:53:07 +0200 2012 +Processing by SessionsController#update as HTML + Parameters: {"id"=>"integration_test_user", "client_auth"=>"6fe632efa6c4bc707cbca53bdc327e3ac0e8dd3de06ec60cc70ae66bccffbec5"} +Completed 200 OK in 69ms (Views: 0.3ms) + + +Started POST "/users.json" for 127.0.0.1 at Fri Aug 24 09:53:07 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"login"=>"integration_test_user", "password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 201 Created in 16ms (Views: 0.3ms) + + +Started POST "/sessions" for 127.0.0.1 at Fri Aug 24 09:53:07 +0200 2012 +Processing by SessionsController#create as HTML + Parameters: {"login"=>"integration_test_user", "A"=>"54dbd0535db592074d3993038676039e05e09704f53b893311d0a069a520ee5a"} +Completed 200 OK in 8ms (Views: 0.3ms) + + +Started PUT "/sessions/integration_test_user" for 127.0.0.1 at Fri Aug 24 09:53:07 +0200 2012 +Processing by SessionsController#update as HTML + Parameters: {"id"=>"integration_test_user", "client_auth"=>"6c731717540ed41bd701ec7672d8e1d9b11c7bd7e66d866d564241aa012d3eba"} +Completed 200 OK in 9ms (Views: 0.4ms) + + +Started POST "/users.json" for 127.0.0.1 at Fri Aug 24 09:53:07 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"login"=>"integration_test_user", "password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 201 Created in 15ms (Views: 0.3ms) + + +Started POST "/sessions" for 127.0.0.1 at Fri Aug 24 09:53:07 +0200 2012 +Processing by SessionsController#create as HTML + Parameters: {"login"=>"wronglogin", "A"=>"736077507e34ed76a8510cb691647084d98fdd386d460c84228e2085eea6cf60"} +Completed 200 OK in 64ms (Views: 0.4ms) +Processing by SessionsController#destroy as HTML +Redirected to http://test.host/ +Completed 302 Found in 1ms +Processing by SessionsController#update as HTML + Parameters: {"id"=>"me", "client_auth"=>"a123"} +Completed 200 OK in 0ms (Views: 0.2ms) +Processing by SessionsController#new as HTML +Completed 200 OK in 40ms (Views: 40.0ms) +Processing by SessionsController#create as HTML + Parameters: {"login"=>"me", "A"=>"a123"} +Completed 200 OK in 1ms (Views: 0.2ms) +Processing by SessionsController#create as HTML + Parameters: {"login"=>"login_that_does_not_exist"} +Completed 200 OK in 1ms (Views: 0.3ms) +Processing by SessionsController#update as HTML + Parameters: {"id"=>"me", "client_auth"=>"a123"} +Completed 200 OK in 1ms (Views: 0.3ms) +Processing by UsersController#create as HTML + Parameters: {"user"=>{"login"=>"me", "password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Redirected to http://test.host/ +Completed 302 Found in 5ms +Processing by UsersController#new as HTML +Completed 200 OK in 24ms (Views: 23.4ms) +Processing by UsersController#create as HTML + Parameters: {"user"=>{"login"=>"me"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Redirected to http://test.host/users/new +Completed 302 Found in 1ms +Processing by SessionsController#destroy as HTML +Redirected to http://test.host/ +Completed 302 Found in 1ms +Processing by SessionsController#update as HTML + Parameters: {"client_auth"=>"a123", "id"=>"me"} +Completed 200 OK in 1ms (Views: 0.2ms) +Processing by SessionsController#new as HTML +Completed 200 OK in 100ms (Views: 100.1ms) +Processing by SessionsController#create as HTML + Parameters: {"login"=>"me", "A"=>"a123"} +Completed 200 OK in 1ms (Views: 0.2ms) +Processing by SessionsController#create as HTML + Parameters: {"login"=>"login_that_does_not_exist"} +Completed 200 OK in 0ms (Views: 0.2ms) +Processing by SessionsController#update as HTML + Parameters: {"client_auth"=>"a123", "id"=>"me"} +Completed 200 OK in 1ms (Views: 0.3ms) +Processing by UsersController#create as HTML + Parameters: {"user"=>{"password_salt"=>"[FILTERED]", "password_verifier"=>"[FILTERED]", "login"=>"me"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Redirected to http://test.host/ +Completed 302 Found in 8ms +Processing by UsersController#new as HTML +Completed 200 OK in 100ms (Views: 99.0ms) +Processing by UsersController#create as HTML + Parameters: {"user"=>{"login"=>"me"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Redirected to http://test.host/users/new +Completed 302 Found in 1ms + + +Started POST "/users.json" for 127.0.0.1 at Fri Aug 24 09:56:16 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"login"=>"integration_test_user", "password_salt"=>"[FILTERED]", "password_verifier"=>"[FILTERED]"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 201 Created in 52ms (Views: 0.3ms) + + +Started POST "/sessions" for 127.0.0.1 at Fri Aug 24 09:56:16 +0200 2012 +Processing by SessionsController#create as HTML + Parameters: {"login"=>"integration_test_user", "A"=>"18d5f90618da300e42ddfca4ae0892d70188fc1bd15806a62e9727694d048d41"} +Completed 200 OK in 7ms (Views: 0.2ms) + + +Started PUT "/sessions/integration_test_user" for 127.0.0.1 at Fri Aug 24 09:56:16 +0200 2012 +Processing by SessionsController#update as HTML + Parameters: {"id"=>"integration_test_user", "client_auth"=>"c9669e6d2e637a2dd4c88f1e14dac9411feff213a594d5375392fd9507be7554"} +Completed 200 OK in 12ms (Views: 0.3ms) + + +Started POST "/users.json" for 127.0.0.1 at Fri Aug 24 09:56:16 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"login"=>"integration_test_user", "password_salt"=>"[FILTERED]", "password_verifier"=>"[FILTERED]"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 201 Created in 11ms (Views: 0.2ms) + + +Started POST "/sessions" for 127.0.0.1 at Fri Aug 24 09:56:16 +0200 2012 +Processing by SessionsController#create as HTML + Parameters: {"login"=>"integration_test_user", "A"=>"5c888674fc202f583edb74ddd76d51d1d91f29ef13f275e0e6590f489697b984"} +Completed 200 OK in 7ms (Views: 0.2ms) + + +Started PUT "/sessions/integration_test_user" for 127.0.0.1 at Fri Aug 24 09:56:16 +0200 2012 +Processing by SessionsController#update as HTML + Parameters: {"id"=>"integration_test_user", "client_auth"=>"a69f83478fb2794670d4a01f1d8fafc3aab9552dff2e40608fc0c1465d503000"} +Completed 200 OK in 9ms (Views: 0.3ms) + + +Started POST "/users.json" for 127.0.0.1 at Fri Aug 24 09:56:16 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"login"=>"integration_test_user", "password_salt"=>"[FILTERED]", "password_verifier"=>"[FILTERED]"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 201 Created in 14ms (Views: 0.2ms) + + +Started POST "/sessions" for 127.0.0.1 at Fri Aug 24 09:56:16 +0200 2012 +Processing by SessionsController#create as HTML + Parameters: {"login"=>"wronglogin", "A"=>"1d4dd9d87394fb996cf5c9cd26ceae999ee91d6e918ae4898487d29299f97def"} +Completed 200 OK in 4ms (Views: 0.4ms) + + +Started POST "/users.json" for 127.0.0.1 at Fri Aug 24 09:58:23 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_salt"=>"[FILTERED]", "password_verifier"=>"[FILTERED]", "login"=>"integration_test_user"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 201 Created in 53ms (Views: 0.7ms) + + +Started POST "/sessions" for 127.0.0.1 at Fri Aug 24 09:58:23 +0200 2012 +Processing by SessionsController#create as HTML + Parameters: {"A"=>"f13b416ca8f8f26d00e005fadd4c94744ff866110f9d090ae23ac249a7da6079", "login"=>"integration_test_user"} +Completed 200 OK in 6ms (Views: 0.2ms) + + +Started PUT "/sessions/integration_test_user" for 127.0.0.1 at Fri Aug 24 09:58:23 +0200 2012 +Processing by SessionsController#update as HTML + Parameters: {"client_auth"=>"608400e10ba35bb964b1e2d69d141484f7ed1307a77f1f991e33bb713906b00c", "id"=>"integration_test_user"} +Completed 200 OK in 61ms (Views: 0.3ms) + + +Started POST "/users.json" for 127.0.0.1 at Fri Aug 24 09:58:23 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_salt"=>"[FILTERED]", "password_verifier"=>"[FILTERED]", "login"=>"integration_test_user"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 201 Created in 13ms (Views: 0.3ms) + + +Started POST "/sessions" for 127.0.0.1 at Fri Aug 24 09:58:23 +0200 2012 +Processing by SessionsController#create as HTML + Parameters: {"A"=>"73f9bc1a40ae806817f6cab3a355f9c575d7574402b426b89c2c66d1c39ab82a", "login"=>"integration_test_user"} +Completed 200 OK in 9ms (Views: 0.3ms) + + +Started PUT "/sessions/integration_test_user" for 127.0.0.1 at Fri Aug 24 09:58:23 +0200 2012 +Processing by SessionsController#update as HTML + Parameters: {"client_auth"=>"79473702fd2354792f4403f7116bd664b5f799cb40f328422c02a07cf0a1623e", "id"=>"integration_test_user"} +Completed 200 OK in 9ms (Views: 0.4ms) + + +Started POST "/users.json" for 127.0.0.1 at Fri Aug 24 09:58:23 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_salt"=>"[FILTERED]", "password_verifier"=>"[FILTERED]", "login"=>"integration_test_user"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 201 Created in 12ms (Views: 0.3ms) + + +Started POST "/sessions" for 127.0.0.1 at Fri Aug 24 09:58:23 +0200 2012 +Processing by SessionsController#create as HTML + Parameters: {"A"=>"a84357df5892d8cdf74d55947f7ac8edbcea92c8a19af7403ec3db027dd8ebc8", "login"=>"wronglogin"} +Completed 200 OK in 5ms (Views: 0.3ms) +Processing by SessionsController#destroy as HTML +Redirected to http://test.host/ +Completed 302 Found in 1ms +Processing by SessionsController#update as HTML + Parameters: {"client_auth"=>"a123", "id"=>"me"} +Completed 200 OK in 0ms (Views: 0.2ms) +Processing by SessionsController#new as HTML +Completed 200 OK in 94ms (Views: 93.5ms) +Processing by SessionsController#create as HTML + Parameters: {"A"=>"a123", "login"=>"me"} +Completed 200 OK in 0ms (Views: 0.2ms) +Processing by SessionsController#create as HTML + Parameters: {"login"=>"login_that_does_not_exist"} +Completed 200 OK in 1ms (Views: 0.3ms) +Processing by SessionsController#update as HTML + Parameters: {"client_auth"=>"a123", "id"=>"me"} +Completed 200 OK in 1ms (Views: 0.3ms) +Processing by UsersController#create as HTML + Parameters: {"user"=>{"password_salt"=>"[FILTERED]", "password_verifier"=>"[FILTERED]", "login"=>"me"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Redirected to http://test.host/ +Completed 302 Found in 3ms +Processing by UsersController#new as HTML +Completed 200 OK in 20ms (Views: 19.0ms) +Processing by UsersController#create as HTML + Parameters: {"user"=>{"login"=>"me"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Redirected to http://test.host/users/new +Completed 302 Found in 1ms + + +Started POST "/users.json" for 127.0.0.1 at Fri Aug 24 10:36:38 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_salt"=>"[FILTERED]", "login"=>"integration_test_user", "password_verifier"=>"[FILTERED]"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 201 Created in 49ms (Views: 0.3ms) + + +Started POST "/sessions" for 127.0.0.1 at Fri Aug 24 10:36:38 +0200 2012 +Processing by SessionsController#create as HTML + Parameters: {"login"=>"integration_test_user", "A"=>"2f856f5d037678c93fe314de8368100990c6ff2262f05b6a839e85dfa24677b"} +Completed 200 OK in 8ms (Views: 0.2ms) + + +Started PUT "/sessions/integration_test_user" for 127.0.0.1 at Fri Aug 24 10:36:38 +0200 2012 +Processing by SessionsController#update as HTML + Parameters: {"client_auth"=>"efaf709c62d216af9651ddba8025f54d22dcec60907bd74e78fc8cf48529a86e", "id"=>"integration_test_user"} +Completed 200 OK in 62ms (Views: 0.3ms) + + +Started POST "/users.json" for 127.0.0.1 at Fri Aug 24 10:36:38 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_salt"=>"[FILTERED]", "login"=>"integration_test_user", "password_verifier"=>"[FILTERED]"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 201 Created in 13ms (Views: 0.2ms) + + +Started POST "/sessions" for 127.0.0.1 at Fri Aug 24 10:36:38 +0200 2012 +Processing by SessionsController#create as HTML + Parameters: {"login"=>"integration_test_user", "A"=>"2b61fe1e9c6dcf534267f898677aaff6dacb3ba59d7f7f73d20a3653aea5d5e3"} +Completed 200 OK in 9ms (Views: 0.3ms) + + +Started PUT "/sessions/integration_test_user" for 127.0.0.1 at Fri Aug 24 10:36:38 +0200 2012 +Processing by SessionsController#update as HTML + Parameters: {"client_auth"=>"61fa2879b62eacf34216d4b9560a64dd30541fc71192984fdbd7113dbc25f00a", "id"=>"integration_test_user"} +Completed 200 OK in 9ms (Views: 0.4ms) + + +Started POST "/users.json" for 127.0.0.1 at Fri Aug 24 10:36:38 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_salt"=>"[FILTERED]", "login"=>"integration_test_user", "password_verifier"=>"[FILTERED]"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 201 Created in 15ms (Views: 0.3ms) + + +Started POST "/sessions" for 127.0.0.1 at Fri Aug 24 10:36:38 +0200 2012 +Processing by SessionsController#create as HTML + Parameters: {"login"=>"wronglogin", "A"=>"f7fe517fb7aefc41633d1e2f0b4df845321479f37ffc713407daff0d9551e14e"} +Completed 200 OK in 5ms (Views: 0.5ms) +Processing by SessionsController#destroy as HTML +Redirected to http://test.host/ +Completed 302 Found in 1ms +Processing by SessionsController#update as HTML + Parameters: {"client_auth"=>"a123", "id"=>"me"} +Completed 200 OK in 1ms (Views: 0.3ms) +Processing by SessionsController#new as HTML +Completed 200 OK in 89ms (Views: 89.2ms) +Processing by SessionsController#create as HTML + Parameters: {"login"=>"me", "A"=>"a123"} +Completed 200 OK in 0ms (Views: 0.2ms) +Processing by SessionsController#create as HTML + Parameters: {"login"=>"login_that_does_not_exist"} +Completed 200 OK in 1ms (Views: 0.3ms) +Processing by SessionsController#update as HTML + Parameters: {"client_auth"=>"a123", "id"=>"me"} +Completed 200 OK in 1ms (Views: 0.3ms) +Processing by UsersController#new as HTML +Completed 200 OK in 29ms (Views: 28.0ms) + + +Started POST "/users.json" for 127.0.0.1 at Fri Aug 24 10:37:34 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]", "login"=>"integration_test_user"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 201 Created in 49ms (Views: 0.3ms) + + +Started POST "/sessions" for 127.0.0.1 at Fri Aug 24 10:37:34 +0200 2012 +Processing by SessionsController#create as HTML + Parameters: {"A"=>"799c9b3dd2e5e8819b602709392116adda74a2bf9b9099067c9053b5ac451e8d", "login"=>"integration_test_user"} +Completed 200 OK in 6ms (Views: 0.2ms) + + +Started PUT "/sessions/integration_test_user" for 127.0.0.1 at Fri Aug 24 10:37:34 +0200 2012 +Processing by SessionsController#update as HTML + Parameters: {"client_auth"=>"95bb7fbdbe81bb4a23979b454fe411f30cbe84c38addc36c681a70fe3e9d1954", "id"=>"integration_test_user"} +Completed 200 OK in 61ms (Views: 0.3ms) + + +Started POST "/users.json" for 127.0.0.1 at Fri Aug 24 10:37:34 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]", "login"=>"integration_test_user"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 201 Created in 12ms (Views: 0.2ms) + + +Started POST "/sessions" for 127.0.0.1 at Fri Aug 24 10:37:34 +0200 2012 +Processing by SessionsController#create as HTML + Parameters: {"A"=>"dd43208fd903fa0566b28762747ba5c5c9d14d2483254078247c8066068e8843", "login"=>"integration_test_user"} +Completed 200 OK in 7ms (Views: 0.3ms) + + +Started PUT "/sessions/integration_test_user" for 127.0.0.1 at Fri Aug 24 10:37:34 +0200 2012 +Processing by SessionsController#update as HTML + Parameters: {"client_auth"=>"c22060242c28c76491026a98b812d16a94bac821d3c32443810ce1ed12ed3b9b", "id"=>"integration_test_user"} +Completed 200 OK in 8ms (Views: 0.3ms) + + +Started POST "/users.json" for 127.0.0.1 at Fri Aug 24 10:37:34 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]", "login"=>"integration_test_user"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 201 Created in 12ms (Views: 0.3ms) + + +Started POST "/sessions" for 127.0.0.1 at Fri Aug 24 10:37:34 +0200 2012 +Processing by SessionsController#create as HTML + Parameters: {"A"=>"70310508bd80485f27e7b073ca4df34b6f2385eab38982e4d9470af4044d934a", "login"=>"wronglogin"} +Completed 200 OK in 4ms (Views: 0.3ms) +Processing by SessionsController#destroy as HTML +Redirected to http://test.host/ +Completed 302 Found in 1ms +Processing by SessionsController#update as HTML + Parameters: {"client_auth"=>"a123", "id"=>"me"} +Completed 200 OK in 1ms (Views: 0.2ms) +Processing by SessionsController#new as HTML +Completed 200 OK in 90ms (Views: 89.3ms) +Processing by SessionsController#create as HTML + Parameters: {"A"=>"a123", "login"=>"me"} +Completed 200 OK in 1ms (Views: 0.2ms) +Processing by SessionsController#create as HTML + Parameters: {"login"=>"login_that_does_not_exist"} +Completed 200 OK in 1ms (Views: 0.3ms) +Processing by SessionsController#update as HTML + Parameters: {"client_auth"=>"a123", "id"=>"me"} +Completed 200 OK in 1ms (Views: 0.3ms) +Processing by UsersController#create as HTML + Parameters: {"user"=>{"password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]", "login"=>"me"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Redirected to http://test.host/ +Completed 302 Found in 3ms +Processing by UsersController#new as HTML +Completed 200 OK in 18ms (Views: 17.6ms) +Processing by UsersController#create as HTML + Parameters: {"user"=>{"login"=>"me"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Redirected to http://test.host/users/new +Completed 302 Found in 1ms + + +Started POST "/users.json" for 127.0.0.1 at Fri Aug 24 11:39:07 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]", "login"=>"integration_test_user"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 201 Created in 104ms (Views: 0.3ms) + + +Started POST "/sessions" for 127.0.0.1 at Fri Aug 24 11:39:07 +0200 2012 +Processing by SessionsController#create as HTML + Parameters: {"login"=>"integration_test_user", "A"=>"42dc9d94507a80b9bb57bc77594e4c5938487bf36c72db98765522535bf54f5f"} +Completed 200 OK in 7ms (Views: 0.3ms) + + +Started PUT "/sessions/integration_test_user" for 127.0.0.1 at Fri Aug 24 11:39:07 +0200 2012 +Processing by SessionsController#update as HTML + Parameters: {"client_auth"=>"52a9145dcde0842b075d41a82651a2de18bf4b283bca8e386e7f75410f3d6463", "id"=>"integration_test_user"} +Completed 200 OK in 11ms (Views: 0.3ms) + + +Started POST "/users.json" for 127.0.0.1 at Fri Aug 24 11:39:07 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]", "login"=>"integration_test_user"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 201 Created in 12ms (Views: 0.2ms) + + +Started POST "/sessions" for 127.0.0.1 at Fri Aug 24 11:39:07 +0200 2012 +Processing by SessionsController#create as HTML + Parameters: {"login"=>"integration_test_user", "A"=>"df80bc7b52846fdb35c3a396432efe5963dc0f766ff4fe1b825462bf69ea8bf4"} +Completed 200 OK in 9ms (Views: 0.3ms) + + +Started PUT "/sessions/integration_test_user" for 127.0.0.1 at Fri Aug 24 11:39:07 +0200 2012 +Processing by SessionsController#update as HTML + Parameters: {"client_auth"=>"5c4be413569756b55d6e3e8e8d7b76078a1fe080da39a410abb9085db2eb04fd", "id"=>"integration_test_user"} +Completed 200 OK in 8ms (Views: 0.3ms) + + +Started POST "/users.json" for 127.0.0.1 at Fri Aug 24 11:39:07 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]", "login"=>"integration_test_user"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 201 Created in 11ms (Views: 0.2ms) + + +Started POST "/sessions" for 127.0.0.1 at Fri Aug 24 11:39:07 +0200 2012 +Processing by SessionsController#create as HTML + Parameters: {"login"=>"wronglogin", "A"=>"2a73003b8c8ca88e6b051cbf344df5937530413998f13f85045ae31a5be8fb9"} +Completed 200 OK in 54ms (Views: 0.4ms) +Processing by SessionsController#destroy as HTML +Redirected to http://test.host/ +Completed 302 Found in 1ms +Processing by SessionsController#update as HTML + Parameters: {"client_auth"=>"a123", "id"=>"me"} +Completed 200 OK in 0ms (Views: 0.2ms) +Processing by SessionsController#new as HTML +Completed 200 OK in 39ms (Views: 38.4ms) +Processing by SessionsController#create as HTML + Parameters: {"login"=>"me", "A"=>"a123"} +Completed 200 OK in 0ms (Views: 0.2ms) +Processing by SessionsController#create as HTML + Parameters: {"login"=>"login_that_does_not_exist"} +Completed 200 OK in 0ms (Views: 0.3ms) +Processing by SessionsController#update as HTML + Parameters: {"client_auth"=>"a123", "id"=>"me"} +Completed 200 OK in 1ms (Views: 0.3ms) +Processing by UsersController#create as HTML + Parameters: {"user"=>{"password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]", "login"=>"me"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Redirected to http://test.host/ +Completed 302 Found in 3ms +Processing by UsersController#new as HTML +Completed 200 OK in 18ms (Views: 17.3ms) +Processing by UsersController#create as HTML + Parameters: {"user"=>{"login"=>"me"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Redirected to http://test.host/users/new +Completed 302 Found in 1ms + + +Started POST "/users.json" for 127.0.0.1 at Fri Aug 24 11:44:47 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_salt"=>"[FILTERED]", "password_verifier"=>"[FILTERED]", "login"=>"integration_test_user"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 201 Created in 101ms (Views: 0.3ms) + + +Started POST "/sessions" for 127.0.0.1 at Fri Aug 24 11:44:47 +0200 2012 +Processing by SessionsController#create as HTML + Parameters: {"login"=>"integration_test_user", "A"=>"bf69e20fa47d287c51d632336596b41526f6c0cd3e2449bd960509a29bfa2961"} +Completed 200 OK in 7ms (Views: 0.3ms) + + +Started PUT "/sessions/integration_test_user" for 127.0.0.1 at Fri Aug 24 11:44:47 +0200 2012 +Processing by SessionsController#update as HTML + Parameters: {"client_auth"=>"fed972599dd4e5b70f6bd0bd8a57be1b5e98ee096933b03c1ddd873f4a2657c1", "id"=>"integration_test_user"} +Completed 200 OK in 11ms (Views: 0.3ms) + + +Started POST "/users.json" for 127.0.0.1 at Fri Aug 24 11:44:47 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_salt"=>"[FILTERED]", "password_verifier"=>"[FILTERED]", "login"=>"integration_test_user"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 201 Created in 12ms (Views: 0.2ms) + + +Started POST "/sessions" for 127.0.0.1 at Fri Aug 24 11:44:47 +0200 2012 +Processing by SessionsController#create as HTML + Parameters: {"login"=>"integration_test_user", "A"=>"d3e93135f8ad2360e2d589afc1882b1cea00cf4755cfc9b6afee5aafb0504f30"} +Completed 200 OK in 7ms (Views: 0.3ms) + + +Started PUT "/sessions/integration_test_user" for 127.0.0.1 at Fri Aug 24 11:44:47 +0200 2012 +Processing by SessionsController#update as HTML + Parameters: {"client_auth"=>"157dbd5ac6385e60f0f5bab7150cce8ee92441e4596194ab177683be963eca7f", "id"=>"integration_test_user"} +Completed 200 OK in 8ms (Views: 0.3ms) + + +Started POST "/users.json" for 127.0.0.1 at Fri Aug 24 11:44:47 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_salt"=>"[FILTERED]", "password_verifier"=>"[FILTERED]", "login"=>"integration_test_user"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Completed 201 Created in 11ms (Views: 0.2ms) + + +Started POST "/sessions" for 127.0.0.1 at Fri Aug 24 11:44:47 +0200 2012 +Processing by SessionsController#create as HTML + Parameters: {"login"=>"wronglogin", "A"=>"c285e722bc1d826a009e3d4fb5e92fd4ade4f00ba2d7b7d4946e3e1a404928b"} +Completed 200 OK in 4ms (Views: 0.3ms) +Processing by SessionsController#destroy as HTML +Redirected to http://test.host/ +Completed 302 Found in 1ms +Processing by SessionsController#update as HTML + Parameters: {"client_auth"=>"a123", "id"=>"me"} +Completed 200 OK in 0ms (Views: 0.2ms) +Processing by SessionsController#new as HTML +Completed 200 OK in 41ms (Views: 40.3ms) +Processing by SessionsController#create as HTML + Parameters: {"login"=>"me", "A"=>"a123"} +Completed 200 OK in 0ms (Views: 0.2ms) +Processing by SessionsController#create as HTML + Parameters: {"login"=>"login_that_does_not_exist"} +Completed 200 OK in 1ms (Views: 0.3ms) +Processing by SessionsController#update as HTML + Parameters: {"client_auth"=>"a123", "id"=>"me"} +Completed 200 OK in 1ms (Views: 0.3ms) +Processing by UsersController#create as HTML + Parameters: {"user"=>{"password_salt"=>"[FILTERED]", "password_verifier"=>"[FILTERED]", "login"=>"me"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Redirected to http://test.host/ +Completed 302 Found in 3ms +Processing by UsersController#new as HTML +Completed 200 OK in 18ms (Views: 17.8ms) +Processing by UsersController#create as HTML + Parameters: {"user"=>{"login"=>"me"}} + +***** Debugger requested, but was not available (ensure ruby-debug is listed in Gemfile/installed as gem): Start server with --debugger to enable ***** + +Redirected to http://test.host/users/new +Completed 302 Found in 1ms + + +Started POST "/users.json" for 127.0.0.1 at Tue Oct 02 23:02:02 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_salt"=>"[FILTERED]", "password_verifier"=>"[FILTERED]", "login"=>"integration_test_user"}} +Completed 201 Created in 142ms (Views: 0.3ms) + + +Started POST "/sessions" for 127.0.0.1 at Tue Oct 02 23:02:03 +0200 2012 +Processing by SessionsController#create as HTML + Parameters: {"A"=>"ed4f1fbb97cddc6a89a2b7da9ef5361e53ad9aac5b2ea4ecd89c68c8faf5f40", "login"=>"integration_test_user"} +Completed 200 OK in 3966ms (Views: 0.9ms) + + +Started PUT "/sessions/integration_test_user" for 127.0.0.1 at Tue Oct 02 23:02:07 +0200 2012 +Processing by SessionsController#update as HTML + Parameters: {"id"=>"integration_test_user", "client_auth"=>"28d9daa3ba48ead895d21157f42bd7d19219c188d8a6627d720f0e2ce9b5f5bc"} +Completed 200 OK in 24ms (Views: 0.4ms) + + +Started POST "/users.json" for 127.0.0.1 at Tue Oct 02 23:02:07 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_salt"=>"[FILTERED]", "password_verifier"=>"[FILTERED]", "login"=>"integration_test_user"}} +Completed 201 Created in 11ms (Views: 0.3ms) + + +Started POST "/sessions" for 127.0.0.1 at Tue Oct 02 23:02:07 +0200 2012 +Processing by SessionsController#create as HTML + Parameters: {"A"=>"31485189d6b8c70926be5327a7c2324e9f6d0b8fe11a4218d36609586347820b", "login"=>"integration_test_user"} +Completed 200 OK in 458ms (Views: 0.4ms) + + +Started PUT "/sessions/integration_test_user" for 127.0.0.1 at Tue Oct 02 23:02:08 +0200 2012 +Processing by SessionsController#update as HTML + Parameters: {"id"=>"integration_test_user", "client_auth"=>"37f23433a5a0ac70627eff14f0aee883493d84d87f739f84cd656ffd3515ab98"} +Completed 200 OK in 10ms (Views: 0.5ms) + + +Started POST "/users.json" for 127.0.0.1 at Tue Oct 02 23:02:08 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_salt"=>"[FILTERED]", "password_verifier"=>"[FILTERED]", "login"=>"integration_test_user"}} +Completed 201 Created in 11ms (Views: 0.3ms) + + +Started POST "/sessions" for 127.0.0.1 at Tue Oct 02 23:02:08 +0200 2012 +Processing by SessionsController#create as HTML + Parameters: {"A"=>"7c69083c85178f5217f656fdf1261b92fa2660023538310c9f3d6a380b60be96", "login"=>"wronglogin"} +Completed 200 OK in 5ms (Views: 0.4ms) + + +Started POST "/users.json" for 127.0.0.1 at Mon Oct 08 11:31:35 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]", "login"=>"integration_test_user"}} +Completed 201 Created in 70ms (Views: 0.5ms) + + +Started POST "/users.json" for 127.0.0.1 at Mon Oct 08 11:31:35 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]", "login"=>"integration_test_user"}} +Completed 201 Created in 10ms (Views: 0.3ms) + + +Started POST "/users.json" for 127.0.0.1 at Mon Oct 08 11:31:35 +0200 2012 +Processing by UsersController#create as JSON + Parameters: {"user"=>{"password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]", "login"=>"integration_test_user"}} +Completed 201 Created in 12ms (Views: 0.2ms) +Processing by SessionsController#destroy as HTML +Redirected to http://test.host/ +Completed 302 Found in 1ms +Processing by SessionsController#update as HTML + Parameters: {"client_auth"=>"a123", "id"=>"me"} +Completed 500 Internal Server Error in 1ms +Processing by SessionsController#new as HTML +Completed 200 OK in 68ms (Views: 67.6ms) +Processing by SessionsController#create as HTML + Parameters: {"login"=>"me", "A"=>"a123"} +Completed 500 Internal Server Error in 1ms +Processing by SessionsController#create as HTML + Parameters: {"login"=>"login_that_does_not_exist"} +Completed 200 OK in 0ms (Views: 0.2ms) +Processing by SessionsController#update as HTML + Parameters: {"client_auth"=>"a123", "id"=>"me"} +Completed 500 Internal Server Error in 1ms +Processing by UsersController#create as HTML + Parameters: {"user"=>{"password_verifier"=>"[FILTERED]", "password_salt"=>"[FILTERED]", "login"=>"me"}} +Redirected to http://test.host/ +Completed 302 Found in 59ms +Processing by UsersController#new as HTML +Completed 200 OK in 19ms (Views: 18.2ms) +Processing by UsersController#create as HTML + Parameters: {"user"=>{"login"=>"me"}} +Redirected to http://test.host/users/new +Completed 302 Found in 2ms +Processing by CertsController#show as HTML + Rendered text template (0.0ms) +Completed 200 OK in 5ms (Views: 5.0ms) +Processing by CertsController#show as HTML + Rendered text template (0.0ms) +Completed 200 OK in 5ms (Views: 4.5ms) |