New User cannot login after migration of TimeTrex

[bandicoot58]

Hi,

I have a very weird issue with TimeTrex,

1. We migrated from an older TimeTrex on Windows Server 2003 to version 5.3.2 (Windows Server 2008 R2).
2. When we try to login using the existing users, everything went well.

Problem comes when we created a new user, with or without admin credentials, the user cannot login. When the user enter the username and password, immediately the "Login" button is greyed out. Often time the browser needs to be closed and reopened because the "Login" button is no longer functioning.

We tried deleting the user, changing ID, changing group membership and permission but nothing works.

Wondering what could the issue be, and how to look into it, the logs does not seem to tell or paint any picture.

Any help is greatly appreciated.

Thanks.

[shaunw]

Please attach a copy of the TimeTrex log, and a copy of your Apache error log as well.

[bandicoot58]

Just to be sure, can you tell me where are those logs located?

Thanks.

[shanec]

In Windows the log files are located in c:\timetrex\log

[bandicoot58]

There is nothing on the TimeTrex\log directory, only a file name timetrex_cron_last_executed
Here is the content:
13-Jun-13 10:55 AM PDT

Here is the content for apache error log:
[Sun Apr 14 10:13:24 2013] [notice] Apache/2.2.8 (Win32) PHP/5.2.6 configured -- resuming normal operations
[Sun Apr 14 10:13:24 2013] [notice] Server built: Feb 4 2008 08:23:06
[Sun Apr 14 10:13:24 2013] [notice] Parent: Created child process 6372
[Sun Apr 14 10:13:24 2013] [notice] Child 6372: Child process is running
[Sun Apr 14 10:13:24 2013] [notice] Child 6372: Acquired the start mutex.
[Sun Apr 14 10:13:24 2013] [notice] Child 6372: Starting 64 worker threads.
[Sun Apr 14 10:13:24 2013] [notice] Child 6372: Starting thread to listen on port 8085.
[Sun Apr 14 10:13:56 2013] [notice] Parent: Received shutdown signal -- Shutting down the server.
[Sun Apr 14 10:13:56 2013] [notice] Child 6372: Exit event signaled. Child process is ending.
[Sun Apr 14 10:13:57 2013] [notice] Child 6372: Released the start mutex
[Sun Apr 14 10:13:58 2013] [notice] Child 6372: All worker threads have exited.
[Sun Apr 14 10:13:58 2013] [notice] Child 6372: Child process is exiting
[Sun Apr 14 10:13:58 2013] [notice] Parent: Child process exited successfully.
[Sun Apr 14 10:14:02 2013] [notice] Apache/2.2.8 (Win32) PHP/5.2.6 configured -- resuming normal operations
[Sun Apr 14 10:14:02 2013] [notice] Server built: Feb 4 2008 08:23:06
[Sun Apr 14 10:14:02 2013] [notice] Parent: Created child process 5988
[Sun Apr 14 10:14:02 2013] [notice] Child 5988: Child process is running
[Sun Apr 14 10:14:02 2013] [notice] Child 5988: Acquired the start mutex.
[Sun Apr 14 10:14:02 2013] [notice] Child 5988: Starting 64 worker threads.
[Sun Apr 14 10:14:02 2013] [notice] Child 5988: Starting thread to listen on port 8085.
[Wed May 01 17:08:52 2013] [error] [client 192.168.1.213] Invalid method in request \x16\x03\x01
[Mon May 20 19:07:36 2013] [warn] pid file D:/TimeTrex/apache2/logs/httpd.pid overwritten -- Unclean shutdown of previous Apache run?
[Mon May 20 19:07:37 2013] [notice] Apache/2.2.8 (Win32) PHP/5.2.6 configured -- resuming normal operations
[Mon May 20 19:07:37 2013] [notice] Server built: Feb 4 2008 08:23:06
[Mon May 20 19:07:37 2013] [notice] Parent: Created child process 3888
[Mon May 20 19:07:37 2013] [notice] Child 3888: Child process is running
[Mon May 20 19:07:37 2013] [notice] Child 3888: Acquired the start mutex.
[Mon May 20 19:07:37 2013] [notice] Child 3888: Starting 64 worker threads.
[Mon May 20 19:07:37 2013] [notice] Child 3888: Starting thread to listen on port 8085.
[Wed May 22 17:28:49 2013] [warn] pid file D:/TimeTrex/apache2/logs/httpd.pid overwritten -- Unclean shutdown of previous Apache run?
[Wed May 22 17:28:51 2013] [notice] Apache/2.2.8 (Win32) PHP/5.2.6 configured -- resuming normal operations
[Wed May 22 17:28:51 2013] [notice] Server built: Feb 4 2008 08:23:06
[Wed May 22 17:28:51 2013] [notice] Parent: Created child process 3988
[Wed May 22 17:28:51 2013] [notice] Child 3988: Child process is running
[Wed May 22 17:28:51 2013] [notice] Child 3988: Acquired the start mutex.
[Wed May 22 17:28:51 2013] [notice] Child 3988: Starting 64 worker threads.
[Wed May 22 17:28:51 2013] [notice] Child 3988: Starting thread to listen on port 8085.
[Wed May 29 22:06:54 2013] [warn] pid file D:/TimeTrex/apache2/logs/httpd.pid overwritten -- Unclean shutdown of previous Apache run?
[Wed May 29 22:06:56 2013] [notice] Apache/2.2.8 (Win32) PHP/5.2.6 configured -- resuming normal operations
[Wed May 29 22:06:56 2013] [notice] Server built: Feb 4 2008 08:23:06
[Wed May 29 22:06:56 2013] [notice] Parent: Created child process 3708
[Wed May 29 22:06:56 2013] [notice] Child 3708: Child process is running
[Wed May 29 22:06:56 2013] [notice] Child 3708: Acquired the start mutex.
[Wed May 29 22:06:56 2013] [notice] Child 3708: Starting 64 worker threads.
[Wed May 29 22:06:56 2013] [notice] Child 3708: Starting thread to listen on port 8085.


Here is a portion of the access.log from Apache:
192.168.1.208 - - [13/Jun/2013:08:35:07 -0700] "GET / HTTP/1.1" 200 97
192.168.1.208 - - [13/Jun/2013:08:35:08 -0700] "GET /favicon.ico HTTP/1.1" 200 19518
192.168.1.208 - - [13/Jun/2013:08:35:09 -0700] "GET /interface/flex/ HTTP/1.1" 200 1397
192.168.1.208 - - [13/Jun/2013:08:35:09 -0700] "GET /interface/flex/AC_OETags.js HTTP/1.1" 200 8349
192.168.1.208 - - [13/Jun/2013:08:35:13 -0700] "GET /interface/flex/ui.swf?v=5.3.2-1364667817 HTTP/1.1" 200 2049555
192.168.1.208 - - [13/Jun/2013:08:35:15 -0700] "POST /api/amf/api.php HTTP/1.1" 200 890
192.168.1.208 - - [13/Jun/2013:08:35:16 -0700] "GET /interface/flex/view/login/images/seo.png HTTP/1.1" 200 10991
192.168.1.208 - - [13/Jun/2013:08:35:16 -0700] "GET /interface/send_file.php?api=1&object_type=primary_company_logo HTTP/1.1" 200 14457
192.168.1.208 - - [13/Jun/2013:08:35:16 -0700] "POST /api/amf/api.php HTTP/1.1" 200 282
192.168.1.208 - - [13/Jun/2013:08:35:16 -0700] "GET /interface/locale/en_US/LC_MESSAGES/messages.mo HTTP/1.1" 200 147185
192.168.1.208 - - [13/Jun/2013:08:35:20 -0700] "POST /api/amf/api.php HTTP/1.1" 200 309
192.168.1.208 - - [13/Jun/2013:08:35:20 -0700] "POST /api/amf/api.php?SessionID=68335533a48dd420615b07eddb06f755 HTTP/1.1" 200 3870
192.168.1.208 - - [13/Jun/2013:08:35:21 -0700] "POST /api/amf/api.php?SessionID=68335533a48dd420615b07eddb06f755 HTTP/1.1" 200 2440
192.168.1.208 - - [13/Jun/2013:08:35:21 -0700] "POST /api/amf/api.php?SessionID=68335533a48dd420615b07eddb06f755 HTTP/1.1" 200 926
192.168.1.208 - - [13/Jun/2013:08:35:21 -0700] "POST /api/amf/api.php?SessionID=68335533a48dd420615b07eddb06f755 HTTP/1.1" 200 636
192.168.1.208 - - [13/Jun/2013:08:35:21 -0700] "POST /api/amf/api.php?SessionID=68335533a48dd420615b07eddb06f755 HTTP/1.1" 200 965
192.168.1.208 - - [13/Jun/2013:08:35:22 -0700] "GET /interface/send_file.php?api=1&object_type=company_logo HTTP/1.1" 200 8159
192.168.1.208 - - [13/Jun/2013:08:35:22 -0700] "POST /api/amf/api.php?SessionID=68335533a48dd420615b07eddb06f755 HTTP/1.1" 200 277
192.168.1.208 - - [13/Jun/2013:08:35:23 -0700] "GET /interface/flex/view/attendance/timesheet/TimeSheetView.swf?version=5.3.2-1364667817 HTTP/1.1" 200 119192
192.168.1.208 - - [13/Jun/2013:08:35:23 -0700] "POST /api/amf/api.php?SessionID=68335533a48dd420615b07eddb06f755 HTTP/1.1" 200 1090
192.168.1.208 - - [13/Jun/2013:08:35:24 -0700] "POST /api/amf/api.php?SessionID=68335533a48dd420615b07eddb06f755 HTTP/1.1" 200 277
192.168.1.208 - - [13/Jun/2013:08:35:24 -0700] "GET /interface/send_file.php?api=1&object_type=smcopyright HTTP/1.1" 200 5721
192.168.1.208 - - [13/Jun/2013:08:35:24 -0700] "POST /api/amf/api.php?SessionID=68335533a48dd420615b07eddb06f755 HTTP/1.1" 200 743
192.168.1.208 - - [13/Jun/2013:08:35:24 -0700] "POST /api/amf/api.php?SessionID=68335533a48dd420615b07eddb06f755 HTTP/1.1" 200 869
192.168.1.208 - - [13/Jun/2013:08:35:24 -0700] "POST /api/amf/api.php?SessionID=68335533a48dd420615b07eddb06f755 HTTP/1.1" 200 22070
192.168.1.208 - - [13/Jun/2013:08:35:27 -0700] "GET /interface/flex/view/attendance/inout/PunchesView.swf?version=5.3.2-1364667817 HTTP/1.1" 200 51140
192.168.1.208 - - [13/Jun/2013:08:35:27 -0700] "GET /interface/send_file.php?api=1&object_type=smcopyright HTTP/1.1" 304 -
192.168.1.208 - - [13/Jun/2013:08:35:27 -0700] "POST /api/amf/api.php?SessionID=68335533a48dd420615b07eddb06f755 HTTP/1.1" 200 618
192.168.1.208 - - [13/Jun/2013:08:35:27 -0700] "POST /api/amf/api.php?v=1&SessionID=68335533a48dd420615b07eddb06f755&StationID=371f255d6ead6a9099e0e7dba021473c HTTP/1.1" 200 651
192.168.1.208 - - [13/Jun/2013:08:35:28 -0700] "POST /api/amf/api.php?v=1&SessionID=68335533a48dd420615b07eddb06f755&StationID=371f255d6ead6a9099e0e7dba021473c HTTP/1.1" 200 276
192.168.1.208 - - [13/Jun/2013:08:35:30 -0700] "POST /api/amf/api.php?v=1&SessionID=68335533a48dd420615b07eddb06f755&StationID=371f255d6ead6a9099e0e7dba021473c HTTP/1.1" 200 276
192.168.1.208 - - [13/Jun/2013:08:35:31 -0700] "GET /interface/send_file.php?api=1&object_type=smcopyright HTTP/1.1" 304 -
192.168.1.208 - - [13/Jun/2013:08:35:31 -0700] "POST /api/amf/api.php?v=1&SessionID=68335533a48dd420615b07eddb06f755&StationID=371f255d6ead6a9099e0e7dba021473c HTTP/1.1" 200 741
192.168.1.208 - - [13/Jun/2013:08:35:32 -0700] "POST /api/amf/api.php?v=1&SessionID=68335533a48dd420615b07eddb06f755&StationID=371f255d6ead6a9099e0e7dba021473c HTTP/1.1" 200 25063

[shaunw]

See this post for instructions on enabling logging in the timetrex.ini.php file:
http://forums.timetrex.com/viewtopic.php?f=6&t=89

Once logging is enabled you can replicate the error then attach the log file from c:\timetrex\log\

[bandicoot58]

I did enable the log by modifying this:

5. In your TimeTrex.ini.php file, set the following under the [debug] section:
enable = TRUE
enable_display = TRUE
buffer_output = TRUE
enable_log = TRUE
verbosity = 11

After I reproduce the logon failure, there is no new file under my timetrex/log directory.

Do I need to do something? I did restart the batch file, but that doesn't seemed to do produce the log.

[bandicoot58]

After changing, this is what I get on the main page, even before logging into TimeTrex

(postgres7): select session_id,user_id,ip_address,created_date,updated_date from authentication WHERE session_id = ? AND ip_address = ? AND updated_date >= ? [ (session_id=>null) (ip_address=>'127.0.0.1') (updated_date=>'1371233561') ]
--------------------------------------------------------------------------------

Fatal error: Call to a member function getId() on a non-object in D:\TimeTrex\timetrex\interface\index.php on line 68

[bandicoot58]

Never mind, I figured it out...

The user is "tcrow"

Please assist.

Thanks,

[shaunw]

Nothing stands out as an issue in the log, are you able to login to the legacy interface with that user? The URL to do that is often: /interface/Login.php