Project

General

Profile

Defect #26016 » fast.log

Renê Barbosa, 2017-05-22 18:05

 
1
Started POST "/redmine/login" for 10.20.101.199 at 2017-05-22 13:04:42 -0300
2
Processing by AccountController#login as HTML
3
  Parameters: {"utf8"=>"✓", "authenticity_token"=>"dDTyLLZn7L7fFCMh3X/3JQfT37X/eluSj6hzu0CQllzfOu61CeV2Ib1PrzM9k6BpYBI6d6m8qVXk3K6YXrgUHg==", "back_url"=>"http://10.20.100.183/redmine/", "username"=>"rene.barbosa", "password"=>"[FILTERED]", "login"=>"Entrar »"}
4
   (0.1ms)  SELECT MAX(`settings`.`updated_on`) FROM `settings`
5
  AnonymousUser Load (0.1ms)  SELECT  `users`.* FROM `users` WHERE `users`.`type` IN ('AnonymousUser')  ORDER BY `users`.`id` ASC LIMIT 1
6
  Current user: anonymous
7
  User Load (0.6ms)  SELECT `users`.* FROM `users` WHERE `users`.`type` IN ('User', 'AnonymousUser') AND `users`.`login` = 'rene.barbosa'
8
  AuthSource Load (0.2ms)  SELECT  `auth_sources`.* FROM `auth_sources` WHERE `auth_sources`.`id` = 2 LIMIT 1
9
DN found for rene.barbosa: uid=rene.barbosa,ou=people,dc=infomed,dc=inf,dc=br
10
Authentication successful for 'rene.barbosa'
11
  SQL (0.9ms)  UPDATE `users` SET `users`.`last_login_on` = '2017-05-22 13:04:42' WHERE `users`.`type` IN ('User', 'AnonymousUser') AND `users`.`id` = 148
12
Successful authentication for 'rene.barbosa' from 10.20.101.199 at 2017-05-22 16:04:42 UTC
13
   (0.1ms)  BEGIN
14
  Token Exists (0.2ms)  SELECT  1 AS one FROM `tokens` WHERE `tokens`.`value` = BINARY '' LIMIT 1
15
  User Load (0.3ms)  SELECT  `users`.* FROM `users` WHERE `users`.`type` IN ('User', 'AnonymousUser') AND `users`.`id` = 148 LIMIT 1
16
   (0.3ms)  SELECT `tokens`.`id` FROM `tokens` WHERE `tokens`.`user_id` = 148 AND `tokens`.`action` = 'session'  ORDER BY `tokens`.`updated_on` DESC LIMIT 18446744073709551615 OFFSET 9
17
  SQL (0.2ms)  INSERT INTO `tokens` (`user_id`, `action`, `created_on`, `updated_on`, `value`) VALUES (148, 'session', '2017-05-22 13:04:42', '2017-05-22 13:04:42', 'cef6ff581b6b7ea14fb73e64bdda94db6332b2b1')
18
   (0.4ms)  COMMIT
19
Redirected to http://10.20.100.183/redmine/
20
Completed 302 Found in 59ms (ActiveRecord: 4.1ms)
21
Started GET "/redmine/" for 10.20.101.199 at 2017-05-22 13:04:42 -0300
22
Processing by WelcomeController#index as HTML
23
  SQL (0.5ms)  UPDATE `tokens` SET `tokens`.`updated_on` = '2017-05-22 13:04:42' WHERE `tokens`.`user_id` = 148 AND `tokens`.`value` = 'cef6ff581b6b7ea14fb73e64bdda94db6332b2b1' AND `tokens`.`action` = 'session'
24
   (0.1ms)  SELECT MAX(`settings`.`updated_on`) FROM `settings`
25
  User Load (0.4ms)  SELECT  `users`.* FROM `users` WHERE `users`.`type` IN ('User', 'AnonymousUser') AND `users`.`status` = 1 AND `users`.`id` = 148 LIMIT 1
26
  Current user: rene.barbosa (id=148)
27
  News Load (0.3ms)  SELECT  `news`.* FROM `news` INNER JOIN `projects` ON `projects`.`id` = `news`.`project_id` WHERE (projects.status <> 9 AND projects.id IN (SELECT em.project_id FROM enabled_modules em WHERE em.name='news'))  ORDER BY news.created_on DESC LIMIT 5
28
  Token Load (0.2ms)  SELECT  `tokens`.* FROM `tokens` WHERE `tokens`.`user_id` = 148 AND (action='feeds') LIMIT 1
29
  Rendered welcome/index.html.erb within layouts/base (2.6ms)
30
  UserPreference Load (0.4ms)  SELECT  `user_preferences`.* FROM `user_preferences` WHERE `user_preferences`.`user_id` = 148 LIMIT 1
31
  Project Load (0.8ms)  SELECT `projects`.`id`, `projects`.`name`, `projects`.`identifier`, `projects`.`lft`, `projects`.`rgt` FROM `projects` INNER JOIN `members` ON `projects`.`id` = `members`.`project_id` WHERE `members`.`user_id` = 148 AND (projects.status<>9) AND `projects`.`status` = 1
32
Completed 200 OK in 56ms (Views: 48.1ms | ActiveRecord: 2.7ms)
33
Started GET "/redmine/projects" for 10.20.101.199 at 2017-05-22 13:04:45 -0300
34
Processing by ProjectsController#index as HTML
35
  SQL (0.7ms)  UPDATE `tokens` SET `tokens`.`updated_on` = '2017-05-22 13:04:45' WHERE `tokens`.`user_id` = 148 AND `tokens`.`value` = 'cef6ff581b6b7ea14fb73e64bdda94db6332b2b1' AND `tokens`.`action` = 'session'
36
   (0.2ms)  SELECT MAX(`settings`.`updated_on`) FROM `settings`
37
  User Load (0.2ms)  SELECT  `users`.* FROM `users` WHERE `users`.`type` IN ('User', 'AnonymousUser') AND `users`.`status` = 1 AND `users`.`id` = 148 LIMIT 1
38
  Current user: rene.barbosa (id=148)
39
  Project Load (1.3ms)  SELECT `projects`.* FROM `projects` WHERE (projects.status <> 9) AND `projects`.`status` = 1  ORDER BY `projects`.`lft` ASC
40
  Token Load (0.3ms)  SELECT  `tokens`.* FROM `tokens` WHERE `tokens`.`user_id` = 148 AND (action='feeds') LIMIT 1
41
  Project Load (1.2ms)  SELECT `projects`.* FROM `projects` INNER JOIN `members` ON `projects`.`id` = `members`.`project_id` WHERE `members`.`user_id` = 148 AND (projects.status<>9)
42
  Rendered projects/index.html.erb within layouts/base (299.0ms)
43
  UserPreference Load (0.1ms)  SELECT  `user_preferences`.* FROM `user_preferences` WHERE `user_preferences`.`user_id` = 148 LIMIT 1
44
  Project Load (0.1ms)  SELECT `projects`.`id`, `projects`.`name`, `projects`.`identifier`, `projects`.`lft`, `projects`.`rgt` FROM `projects` INNER JOIN `members` ON `projects`.`id` = `members`.`project_id` WHERE `members`.`user_id` = 148 AND (projects.status<>9) AND `projects`.`status` = 1
45
Completed 200 OK in 366ms (Views: 347.5ms | ActiveRecord: 4.0ms)
46
Started POST "/redmine/logout" for 10.20.101.199 at 2017-05-22 13:04:49 -0300
47
Processing by AccountController#logout as HTML
48
  Parameters: {"authenticity_token"=>"XDx33hNMJ4y3ehv8mxPim8tDE2F93Ga+X/wmRfBJjjK/8Iea2goDJAB/+6HpMeWMwvccjexgE/EhMrrnSOn8bw=="}
49
  SQL (0.7ms)  UPDATE `tokens` SET `tokens`.`updated_on` = '2017-05-22 13:04:49' WHERE `tokens`.`user_id` = 148 AND `tokens`.`value` = 'cef6ff581b6b7ea14fb73e64bdda94db6332b2b1' AND `tokens`.`action` = 'session'
50
   (0.1ms)  SELECT MAX(`settings`.`updated_on`) FROM `settings`
51
  User Load (0.1ms)  SELECT  `users`.* FROM `users` WHERE `users`.`type` IN ('User', 'AnonymousUser') AND `users`.`status` = 1 AND `users`.`id` = 148 LIMIT 1
52
  Current user: rene.barbosa (id=148)
53
  SQL (0.2ms)  DELETE FROM `tokens` WHERE (user_id = 148 AND action = 'autologin')
54
  SQL (0.5ms)  DELETE FROM `tokens` WHERE (user_id = 148 AND action = 'session' AND value = 'cef6ff581b6b7ea14fb73e64bdda94db6332b2b1')
55
  AnonymousUser Load (0.3ms)  SELECT  `users`.* FROM `users` WHERE `users`.`type` IN ('AnonymousUser')  ORDER BY `users`.`id` ASC LIMIT 1
56
Redirected to http://10.20.100.183/redmine/
57
Completed 302 Found in 9ms (ActiveRecord: 1.9ms)
58
Started GET "/redmine/" for 10.20.101.199 at 2017-05-22 13:04:49 -0300
59
Processing by WelcomeController#index as HTML
60
   (0.2ms)  SELECT MAX(`settings`.`updated_on`) FROM `settings`
61
  AnonymousUser Load (0.1ms)  SELECT  `users`.* FROM `users` WHERE `users`.`type` IN ('AnonymousUser')  ORDER BY `users`.`id` ASC LIMIT 1
62
  Current user: anonymous
63
Redirected to http://10.20.100.183/redmine/login?back_url=http%3A%2F%2F10.20.100.183%2Fredmine%2F
64
Filter chain halted as :check_if_login_required rendered or redirected
65
Completed 302 Found in 3ms (ActiveRecord: 0.3ms)
66
Started GET "/redmine/login?back_url=http%3A%2F%2F10.20.100.183%2Fredmine%2F" for 10.20.101.199 at 2017-05-22 13:04:49 -0300
67
Processing by AccountController#login as HTML
68
  Parameters: {"back_url"=>"http://10.20.100.183/redmine/"}
69
   (0.1ms)  SELECT MAX(`settings`.`updated_on`) FROM `settings`
70
  AnonymousUser Load (0.1ms)  SELECT  `users`.* FROM `users` WHERE `users`.`type` IN ('AnonymousUser')  ORDER BY `users`.`id` ASC LIMIT 1
71
  Current user: anonymous
72
  Rendered account/login.html.erb within layouts/base (1.1ms)
73
Completed 200 OK in 8ms (Views: 5.7ms | ActiveRecord: 0.2ms)
74

    
(1-1/2)