use couchrest session store in core, updated dummy path

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)