Help get this topic noticed by sharing it on Twitter, Facebook, or email.
I’m anxious

Sometimes worklog does not clock out properly and records working all night.

I'm not sure how this happens, but it did this morning. These are following steps as best I can remember.

1. Yesterday I was working on an issue until about 4:30 PM. I had clocked into and out of it a couple times during the day. I clocked out to help another developer with a different task (I think I explicitly stopped working, but I may have used the "working on nothing" button on the idle detection dialog).
2. This morning I remoted into my machine for a while and Worklog asked if I'd like to work on something. It did not have the "Continue working on..." option. Just the "Issue" and "Nothing" options.
3. After I got into the office, I continued to specify "Nothing" since I had some meetings and other stuff.
4. Finally, I double clicked on the task I was working yesterday and got to work.
5. About an hour later, I noticed that the task no longer had a green highlight. But it showed that I had 12 hrs of time against it. Since 4:30 the previous night. I can't remember what dialog (if any) was on screen.

So, I'm not sure what the deal is exactly, but I had to delete the bogus log entry. I had worked for about an hour, and I could have manually fixed up the time, but the tool should not have failed.

I'll try to more carefully watch what happens the next time.
1 person has
this problem
+1
Reply
  • Hm, thanks for the detailed recollection. I'm not sure I can think of any situation except if you clicked "same as before" and didn't notice.

    If you do come across it again, I would very much appreciate the details.

    Sorry for the inconvenience.
  • (some HTML allowed)
    How does this make you feel?
    Add Image
    I'm

    e.g. indifferent, undecided, unconcerned happy, confident, thankful, excited kidding, amused, unsure, silly sad, anxious, confused, frustrated

  • I’m anxious
    It happened again. After I got back from lunch. So, remote terminal does not have anything to do with the problem.

    I saw the standard Idle detection dialog and chose Nothing. Then I double clicked on my task and closed the window. I immediately saw a new toaster popup says "You are not working on anything". But I had just started work on a task.

    So I brought the window back and saw that the task was not highlighted, but it had an extra hour from the last time I'd read it.

    I had not been working on anything before lunch, so the worklog was basically since the time I'd clocked out. I'm still not sure of the exact sequence here. I'm going to be very careful from now on.

    Are there any logs I can turn on, or send to help track this down?
  • (some HTML allowed)
    How does this make you feel?
    Add Image
    I'm

    e.g. indifferent, undecided, unconcerned sad, anxious, confused, frustrated happy, confident, thankful, excited kidding, amused, unsure, silly

  • The only thing that would be useful would be the "Debug log" tab. Can you see if there anything in there which is helpful? You can find this tab by going to Help->Show/hide debug log.

    One other thing you might want to ensure is that you do not have worklog rounding enabled. You can check this at the bottom of the "Pending Worklogs" tab.
  • (some HTML allowed)
    How does this make you feel?
    Add Image
    I'm

    e.g. indifferent, undecided, unconcerned sad, anxious, confused, frustrated happy, confident, thankful, excited kidding, amused, unsure, silly

  • I don't have the rounding or the consolidate options checked (I'm a by the second kinda guy). I do have the logs from around the time I saw some weirdness. How should I get them to you. One sequence that looked interesting was:


    [Tue Nov 16 12:43:34 2010] :: [DEBUG] :: Systray icon clicked...
    [Tue Nov 16 12:43:34 2010] :: [DEBUG] :: Neither minimized nor hidden, hiding
    [Tue Nov 16 12:43:36 2010] :: [DEBUG] :: Systray icon clicked...
    [Tue Nov 16 12:43:36 2010] :: [DEBUG] :: Not minimized, showing..
    [Tue Nov 16 12:43:45 2010] :: [DEBUG] :: Refreshing
    [Tue Nov 16 12:43:45 2010] :: [DEBUG] :: Starting: tryConnect
    [Tue Nov 16 12:43:45 2010] :: [DEBUG] :: JIRA: http://jira/rpc/soap/jirasoapservice-v2?wsdl
    [Tue Nov 16 12:43:46 2010] :: [DEBUG] :: WLA : http://jira/rpc/soap/worklogassistant?wsdl
    [Tue Nov 16 12:43:46 2010] :: [DEBUG] :: Connection timeout: 15
    [Tue Nov 16 12:43:46 2010] :: [DEBUG] :: Error code: 12
    [Tue Nov 16 12:43:46 2010] :: [DEBUG] :: Exception: The AXIS engine could not find a target service to invoke! targetService is worklogassistant
    [Tue Nov 16 12:43:46 2010] :: [DEBUG] :: Done: tryConnect
    [Tue Nov 16 12:43:46 2010] :: [DEBUG] :: Refreshing issues.
    [Tue Nov 16 12:43:46 2010] :: [DEBUG] :: Retrieving filter for filter: 10010
    [Tue Nov 16 12:43:46 2010] :: [DEBUG] :: Exception: Nothing here.
    [Tue Nov 16 12:43:46 2010] :: [DEBUG] :: Launching operation in worker thread
    [Tue Nov 16 12:43:46 2010] :: [DEBUG] :: Setting cancel callback
    [Tue Nov 16 12:43:46 2010] :: [DEBUG] :: Starting: getFilterIssues
    [Tue Nov 16 12:43:46 2010] :: [DEBUG] :: Getting additional fields the slow way
    [Tue Nov 16 12:43:46 2010] :: [DEBUG] :: Done: getFilterIssues
    [Tue Nov 16 12:43:46 2010] :: [DEBUG] :: Setting cancel callback
  • (some HTML allowed)
    How does this make you feel?
    Add Image
    I'm

    e.g. indifferent, undecided, unconcerned sad, anxious, confused, frustrated happy, confident, thankful, excited kidding, amused, unsure, silly

  • That looks ok actually...

    As for timing by the second, you might be interested in http://support.worklogassistant.com/s...
  • (some HTML allowed)
    How does this make you feel?
    Add Image
    I'm

    e.g. indifferent, undecided, unconcerned sad, anxious, confused, frustrated happy, confident, thankful, excited kidding, amused, unsure, silly

  • I've been trying to reproduce this but I can't by following your instructions.

    When you are next presented with the dialog, if you can remember to make a note of what the "Pending Worklogs" tab says, that would be useful.

    Also, look at the entries in the "Pending Worklogs" tab. That will give you the most accurate view on what has happened.
  • (some HTML allowed)
    How does this make you feel?
    Add Image
    I'm

    e.g. indifferent, undecided, unconcerned happy, confident, thankful, excited kidding, amused, unsure, silly sad, anxious, confused, frustrated

  • Ok. Getting closer, I think.

    I was working on an issue and then was talking to a coworker for a while. When I returned to the computer, I was presented with "Continue working on X", "Another Issue" or Nothing. I clicked on nothing.

    At the same time as I was dismissing the dialog, I saw a reminder saying I was not working on anything. Before the reminder went away, I double clicked the last issue and started working again.

    However, the highlight did not stick. In fact, when I then looked at the pending worklog, the times for the last two worklogs were:

    8:17:25 - 8:53:25
    8:53:30 - 9:37:12

    And I'd definitely been away from my desk for about 30 minutes. 9:37 was the time I clicked "Nothing" followed by double clicking on the task.

    I don't know if this makes any difference, but the previous worklog to the two above was:

    8:13:03 - 8:17:25

    I had created that log by clicking on the "Continue working on X" after some idle time.

    I'm still baffled by how I get into the situation. I'll keep trying to biold it down to a consistent repro path.

    BTW, I do like this tool. Very easy to use and fits my needs nicely. I've even presented it to our company as a tool to use enterprise wide.

    Here are the logs from the time around the last work log above: (I've removed the huge sets of issues info for brevity/privacy)


    [Wed Nov 17 08:42:46 2010] :: [DEBUG] :: Is idle: 1
    [Wed Nov 17 08:49:38 2010] :: [DEBUG] :: Returned from idle
    [Wed Nov 17 08:52:46 2010] :: [DEBUG] :: 22 serialization::archive 5 0 1 2...

    [Wed Nov 17 08:52:46 2010] :: [DEBUG] :: 22 serialization::archive 5 0 1 2...

    [Wed Nov 17 08:52:47 2010] :: [DEBUG] :: Reminding to track...
    [Wed Nov 17 08:52:47 2010] :: [DEBUG] :: Reminder message: Not currently tracking time.
    Click this message to change the current task
    [Wed Nov 17 08:52:47 2010] :: [DEBUG] :: Is idle: 0
    [Wed Nov 17 08:53:30 2010] :: [DEBUG] :: 22 serialization::archive 5 0 1 2...

    [Wed Nov 17 08:53:30 2010] :: [DEBUG] :: 22 serialization::archive 5 0 1 2...

    [Wed Nov 17 08:53:30 2010] :: [DEBUG] :: Starting idle time detection service. idle-after: 300 polling-interval: 5
    [Wed Nov 17 08:53:30 2010] :: [DEBUG] :: 22 serialization::archive 5 0 1 2...

    [Wed Nov 17 08:53:30 2010] :: [DEBUG] :: 22 serialization::archive 5 0 1 2...

    [Wed Nov 17 08:53:32 2010] :: [DEBUG] :: 22 serialization::archive 5 0 1 2...

    [Wed Nov 17 08:53:32 2010] :: [DEBUG] :: 22 serialization::archive 5 0 1 2...

    [Wed Nov 17 08:56:52 2010] :: [DEBUG] :: Systray icon clicked...
    [Wed Nov 17 08:56:52 2010] :: [DEBUG] :: Not minimized, showing..
    [Wed Nov 17 08:58:40 2010] :: [DEBUG] :: Idle seconds: 5 current state: Busy
    [Wed Nov 17 09:02:46 2010] :: [DEBUG] :: 22 serialization::archive 5 0 1 2...

    [Wed Nov 17 09:02:46 2010] :: [DEBUG] :: 22 serialization::archive 5 0 1 2...

    [Wed Nov 17 09:02:47 2010] :: [DEBUG] :: Reminding to track...
    [Wed Nov 17 09:02:47 2010] :: [DEBUG] :: Reminder message: Current issue: PLTA-891 - use commandline arg to call [vitalapi]/s ...
    Elapsed / Remaining: 1h 11m / 0h 0m
    Click this message to change the current task
    [Wed Nov 17 09:02:47 2010] :: [DEBUG] :: Is idle: 0
    [Wed Nov 17 09:08:01 2010] :: [DEBUG] :: Idle seconds: 5 current state: Busy
    [Wed Nov 17 09:09:01 2010] :: [DEBUG] :: Idle seconds: 5 current state: Busy
    [Wed Nov 17 09:12:46 2010] :: [DEBUG] :: 22 serialization::archive 5 0 1 2...

    [Wed Nov 17 09:12:46 2010] :: [DEBUG] :: 22 serialization::archive 5 0 1 2...

    [Wed Nov 17 09:12:47 2010] :: [DEBUG] :: Reminding to track...
    [Wed Nov 17 09:12:47 2010] :: [DEBUG] :: Reminder message: Current issue: PLTA-891 - use commandline arg to call [vitalapi]/s ...
    Elapsed / Remaining: 1h 21m / 0h 0m
    Click this message to change the current task
    [Wed Nov 17 09:12:47 2010] :: [DEBUG] :: Is idle: 0
    [Wed Nov 17 09:17:57 2010] :: [DEBUG] :: Computer is now idle
    [Wed Nov 17 09:17:57 2010] :: [DEBUG] :: Entered idle... Disabling current task if any
    [Wed Nov 17 09:17:57 2010] :: [DEBUG] :: Set issue before idle to: PLTA-891
    [Wed Nov 17 09:17:57 2010] :: [DEBUG] :: 22 serialization::archive 5 0 1 2...

    [Wed Nov 17 09:17:57 2010] :: [DEBUG] :: 22 serialization::archive 5 0 1 2...

    [Wed Nov 17 09:17:57 2010] :: [DEBUG] :: 22 serialization::archive 5 0 1 2...

    [Wed Nov 17 09:17:57 2010] :: [DEBUG] :: 22 serialization::archive 5 0 1 2...

    [Wed Nov 17 09:22:46 2010] :: [DEBUG] :: 22 serialization::archive 5 0 1 2...

    [Wed Nov 17 09:22:46 2010] :: [DEBUG] :: 22 serialization::archive 5 0 1 2...

    [Wed Nov 17 09:22:47 2010] :: [DEBUG] :: Reminding to track...
    [Wed Nov 17 09:22:47 2010] :: [DEBUG] :: Reminder message: Not currently tracking time.
    Click this message to change the current task
    [Wed Nov 17 09:22:47 2010] :: [DEBUG] :: Is idle: 1
    [Wed Nov 17 09:29:53 2010] :: [DEBUG] :: Returned from idle
    [Wed Nov 17 09:29:53 2010] :: [DEBUG] :: Systray icon clicked...
    [Wed Nov 17 09:29:53 2010] :: [DEBUG] :: Window is minimized...
    [Wed Nov 17 09:29:53 2010] :: [DEBUG] :: Minimized to tray... Showing
    [Wed Nov 17 09:29:53 2010] :: [DEBUG] :: Shown...
    [Wed Nov 17 09:32:46 2010] :: [DEBUG] :: 22 serialization::archive 5 0 1 2...

    [Wed Nov 17 09:32:46 2010] :: [DEBUG] :: 22 serialization::archive 5 0 1 2...

    [Wed Nov 17 09:32:46 2010] :: [DEBUG] :: Reminding to track...
    [Wed Nov 17 09:32:46 2010] :: [DEBUG] :: Reminder message: Not currently tracking time.
    Click this message to change the current task
    [Wed Nov 17 09:32:46 2010] :: [DEBUG] :: Is idle: 0
    [Wed Nov 17 09:37:07 2010] :: [DEBUG] :: Starting idle time detection service. idle-after: 300 polling-interval: 5
    [Wed Nov 17 09:37:09 2010] :: [DEBUG] :: 22 serialization::archive 5 0 1 2...

    [Wed Nov 17 09:37:09 2010] :: [DEBUG] :: 22 serialization::archive 5 0 1 2...

    [Wed Nov 17 09:37:12 2010] :: [DEBUG] :: Computer is now idle
    [Wed Nov 17 09:37:12 2010] :: [DEBUG] :: Entered idle... Disabling current task if any
    [Wed Nov 17 09:37:12 2010] :: [DEBUG] :: Set issue before idle to: PLTA-891
    [Wed Nov 17 09:37:12 2010] :: [DEBUG] :: 22 serialization::archive 5 0 1 2...

    [Wed Nov 17 09:37:12 2010] :: [DEBUG] :: 22 serialization::archive 5 0 1 2...

    [Wed Nov 17 09:37:20 2010] :: [DEBUG] :: Refreshing
    [Wed Nov 17 09:37:20 2010] :: [DEBUG] :: Starting: tryConnect
    [Wed Nov 17 09:37:20 2010] :: [DEBUG] :: JIRA: http://jira/rpc/soap/jirasoapservice-v2?wsdl
    [Wed Nov 17 09:37:20 2010] :: [DEBUG] :: WLA : http://jira/rpc/soap/worklogassistant?wsdl
    [Wed Nov 17 09:37:20 2010] :: [DEBUG] :: Connection timeout: 15
    [Wed Nov 17 09:37:20 2010] :: [DEBUG] :: Error code: 12
    [Wed Nov 17 09:37:20 2010] :: [DEBUG] :: Exception: The AXIS engine could not find a target service to invoke! targetService is worklogassistant
    [Wed Nov 17 09:37:20 2010] :: [DEBUG] :: Done: tryConnect
    [Wed Nov 17 09:37:20 2010] :: [DEBUG] :: Refreshing issues.
    [Wed Nov 17 09:37:20 2010] :: [DEBUG] :: Retrieving filter for filter: 10010
    [Wed Nov 17 09:37:20 2010] :: [DEBUG] :: Exception: Nothing here.
    [Wed Nov 17 09:37:20 2010] :: [DEBUG] :: Launching operation in worker thread
    [Wed Nov 17 09:37:20 2010] :: [DEBUG] :: Setting cancel callback
    [Wed Nov 17 09:37:20 2010] :: [DEBUG] :: Starting: getFilterIssues
    [Wed Nov 17 09:37:20 2010] :: [DEBUG] :: Getting additional fields the slow way
    [Wed Nov 17 09:37:20 2010] :: [DEBUG] :: Done: getFilterIssues
    [Wed Nov 17 09:37:20 2010] :: [DEBUG] :: Setting cancel callback
    [Wed Nov 17 09:37:37 2010] :: [DEBUG] :: Returned from idle
    [Wed Nov 17 09:37:42 2010] :: [DEBUG] :: Idle seconds: 5 current state: Busy
    [Wed Nov 17 09:37:47 2010] :: [DEBUG] :: Idle seconds: 10 current state: Busy
    [Wed Nov 17 09:37:52 2010] :: [DEBUG] :: Idle seconds: 15 current state: Busy
  • (some HTML allowed)
    How does this make you feel?
    Add Image
    I'm

    e.g. indifferent, undecided, unconcerned sad, anxious, confused, frustrated happy, confident, thankful, excited kidding, amused, unsure, silly

  • I'm going to add some more logging in the beta. This is a very strange situation... Please bear with me.
  • (some HTML allowed)
    How does this make you feel?
    Add Image
    I'm

    e.g. indifferent, undecided, unconcerned happy, confident, thankful, excited kidding, amused, unsure, silly sad, anxious, confused, frustrated

  • No problem. I think I may have just intentionally reproduced it.

    WA had the "Idle detected" dialog on screen with the 3 options. It must have been up for a while since I'd been busy in other window (but that probably does not matter). I was looking at the tabs trying to take it all in when I saw the reminder popup appear (BTW I'm running this in Win 7). I immediately hit the "Nothing" option and then as soon as the dialog was gone, I double clicked on the same issue as I had been working on. I did these before the reminder even started to fade.

    The issue was active (green) for a second, but then it turned off. So did the task tray icon (turned green briefly and then turned off). When I checked the work log, it showed the whole idle time as work.

    I'm going to see if I can do that again.
  • (some HTML allowed)
    How does this make you feel?
    Add Image
    I'm

    e.g. indifferent, undecided, unconcerned sad, anxious, confused, frustrated happy, confident, thankful, excited kidding, amused, unsure, silly

  • I've just started the build for a new version with some more logging that should help us narrow down exactly what is happening if not the cause. It should be available on http://next.worklogassistant.com/down... ( build number > 1906) within the next half hour.

    Thanks for your patience and sorry for the abnormally late replies, things are a bit hectic at the moment!
  • (some HTML allowed)
    How does this make you feel?
    Add Image
    I'm

    e.g. indifferent, undecided, unconcerned sad, anxious, confused, frustrated happy, confident, thankful, excited kidding, amused, unsure, silly

  • Good news! Sortof. I was able to repo the problem again using the steps I outlined above. I think it may be related to starting a task at the same time the reminder popup is being displayed.

    Here are the logs from 1.0.1906


    [Wed Nov 17 13:38:04 2010] :: [DEBUG] :: 22 serialization::archive 5 0 1 2...

    [Wed Nov 17 13:38:14 2010] :: [DEBUG] :: Idle seconds: 5 current state: Busy

    --- This is where I started the worklog ---

    [Wed Nov 17 13:38:26 2010] :: [DEBUG] :: 22 serialization::archive 5 0 1 2...

    [Wed Nov 17 13:38:26 2010] :: [DEBUG] :: 22 serialization::archive 5 0 1 2...

    [Wed Nov 17 13:38:35 2010] :: [DEBUG] :: Systray icon clicked...
    [Wed Nov 17 13:38:35 2010] :: [DEBUG] :: Window is minimized...
    [Wed Nov 17 13:38:35 2010] :: [DEBUG] :: Minimized to tray... Showing
    [Wed Nov 17 13:38:35 2010] :: [DEBUG] :: Shown...
    [Wed Nov 17 13:48:04 2010] :: [DEBUG] :: 22 serialization::archive 5 0 1 2...

    [Wed Nov 17 13:48:04 2010] :: [DEBUG] :: 22 serialization::archive 5 0 1 2...

    [Wed Nov 17 13:48:04 2010] :: [DEBUG] :: Reminding to track...
    [Wed Nov 17 13:48:04 2010] :: [DEBUG] :: Reminder message: Current issue: PLTA-891 - use commandline arg to call [vitalapi]/s ...
    Elapsed / Remaining: 2h 56m / 0h 0m
    Click this message to change the current task
    [Wed Nov 17 13:48:04 2010] :: [DEBUG] :: Is idle: 0
    [Wed Nov 17 13:50:40 2010] :: [DEBUG] :: Idle seconds: 5 current state: Busy
    [Wed Nov 17 13:51:25 2010] :: [DEBUG] :: Idle seconds: 5 current state: Busy
    [Wed Nov 17 13:51:30 2010] :: [DEBUG] :: Idle seconds: 10 current state: Busy
    [Wed Nov 17 13:51:35 2010] :: [DEBUG] :: Idle seconds: 15 current state: Busy
    [Wed Nov 17 13:51:40 2010] :: [DEBUG] :: Idle seconds: 20 current state: Busy
    [Wed Nov 17 13:52:15 2010] :: [DEBUG] :: Idle seconds: 5 current state: Busy

    --- in the idle detected dialog, it said: idle since 1:52... ---

    [Wed Nov 17 13:52:20 2010] :: [DEBUG] :: Idle seconds: 10 current state: Busy
    [Wed Nov 17 13:52:25 2010] :: [DEBUG] :: Idle seconds: 15 current state: Busy
    [Wed Nov 17 13:52:30 2010] :: [DEBUG] :: Idle seconds: 20 current state: Busy
    [Wed Nov 17 13:52:35 2010] :: [DEBUG] :: Idle seconds: 25 current state: Busy
    [Wed Nov 17 13:52:40 2010] :: [DEBUG] :: Idle seconds: 30 current state: Busy
    [Wed Nov 17 13:52:45 2010] :: [DEBUG] :: Idle seconds: 35 current state: Busy
    [Wed Nov 17 13:52:50 2010] :: [DEBUG] :: Idle seconds: 40 current state: Busy
    [Wed Nov 17 13:52:55 2010] :: [DEBUG] :: Idle seconds: 45 current state: Busy
    [Wed Nov 17 13:53:00 2010] :: [DEBUG] :: Idle seconds: 50 current state: Busy
    [Wed Nov 17 13:53:05 2010] :: [DEBUG] :: Idle seconds: 55 current state: Busy
    [Wed Nov 17 13:53:10 2010] :: [DEBUG] :: Idle seconds: 60 current state: Busy
    [Wed Nov 17 13:53:15 2010] :: [DEBUG] :: Idle seconds: 65 current state: Busy
    [Wed Nov 17 13:53:20 2010] :: [DEBUG] :: Idle seconds: 70 current state: Busy
    [Wed Nov 17 13:53:25 2010] :: [DEBUG] :: Idle seconds: 75 current state: Busy
    [Wed Nov 17 13:53:30 2010] :: [DEBUG] :: Idle seconds: 80 current state: Busy
    [Wed Nov 17 13:53:35 2010] :: [DEBUG] :: Idle seconds: 85 current state: Busy
    [Wed Nov 17 13:53:40 2010] :: [DEBUG] :: Idle seconds: 90 current state: Busy
    [Wed Nov 17 13:53:45 2010] :: [DEBUG] :: Idle seconds: 95 current state: Busy
    [Wed Nov 17 13:53:50 2010] :: [DEBUG] :: Idle seconds: 100 current state: Busy
    [Wed Nov 17 13:53:55 2010] :: [DEBUG] :: Idle seconds: 105 current state: Busy
    [Wed Nov 17 13:54:00 2010] :: [DEBUG] :: Idle seconds: 110 current state: Busy
    [Wed Nov 17 13:54:05 2010] :: [DEBUG] :: Idle seconds: 115 current state: Busy
    [Wed Nov 17 13:54:10 2010] :: [DEBUG] :: Idle seconds: 120 current state: Busy
    [Wed Nov 17 13:54:15 2010] :: [DEBUG] :: Idle seconds: 125 current state: Busy
    [Wed Nov 17 13:54:20 2010] :: [DEBUG] :: Idle seconds: 130 current state: Busy
    [Wed Nov 17 13:54:25 2010] :: [DEBUG] :: Idle seconds: 135 current state: Busy
    [Wed Nov 17 13:54:30 2010] :: [DEBUG] :: Idle seconds: 140 current state: Busy
    [Wed Nov 17 13:54:35 2010] :: [DEBUG] :: Idle seconds: 145 current state: Busy
    [Wed Nov 17 13:54:40 2010] :: [DEBUG] :: Idle seconds: 150 current state: Busy
    [Wed Nov 17 13:54:45 2010] :: [DEBUG] :: Idle seconds: 155 current state: Busy
    [Wed Nov 17 13:54:50 2010] :: [DEBUG] :: Idle seconds: 160 current state: Busy
    [Wed Nov 17 13:54:55 2010] :: [DEBUG] :: Idle seconds: 165 current state: Busy
    [Wed Nov 17 13:55:00 2010] :: [DEBUG] :: Idle seconds: 170 current state: Busy
    [Wed Nov 17 13:55:05 2010] :: [DEBUG] :: Idle seconds: 175 current state: Busy
    [Wed Nov 17 13:55:10 2010] :: [DEBUG] :: Idle seconds: 180 current state: Busy
    [Wed Nov 17 13:55:15 2010] :: [DEBUG] :: Idle seconds: 185 current state: Busy
    [Wed Nov 17 13:55:20 2010] :: [DEBUG] :: Idle seconds: 190 current state: Busy
    [Wed Nov 17 13:55:26 2010] :: [DEBUG] :: Idle seconds: 195 current state: Busy
    [Wed Nov 17 13:55:31 2010] :: [DEBUG] :: Idle seconds: 200 current state: Busy
    [Wed Nov 17 13:55:36 2010] :: [DEBUG] :: Idle seconds: 205 current state: Busy
    [Wed Nov 17 13:55:41 2010] :: [DEBUG] :: Idle seconds: 210 current state: Busy
    [Wed Nov 17 13:55:46 2010] :: [DEBUG] :: Idle seconds: 215 current state: Busy
    [Wed Nov 17 13:55:51 2010] :: [DEBUG] :: Idle seconds: 220 current state: Busy
    [Wed Nov 17 13:55:56 2010] :: [DEBUG] :: Idle seconds: 225 current state: Busy
    [Wed Nov 17 13:56:01 2010] :: [DEBUG] :: Idle seconds: 230 current state: Busy
    [Wed Nov 17 13:56:06 2010] :: [DEBUG] :: Idle seconds: 235 current state: Busy
    [Wed Nov 17 13:57:11 2010] :: [DEBUG] :: Computer is now idle
    [Wed Nov 17 13:57:11 2010] :: [DEBUG] :: Entered idle... Disabling current task if any
    [Wed Nov 17 13:57:11 2010] :: [DEBUG] :: Set issue before idle to: PLTA-891
    [Wed Nov 17 13:57:11 2010] :: [DEBUG] :: 22 serialization::archive 5 0 1 2...

    [Wed Nov 17 13:57:11 2010] :: [DEBUG] :: 22 serialization::archive 5 0 1 2...

    [Wed Nov 17 13:57:11 2010] :: [DEBUG] :: 22 serialization::archive 5 0 1 2...

    [Wed Nov 17 13:57:11 2010] :: [DEBUG] :: 22 serialization::archive 5 0 1 2...

    [Wed Nov 17 13:58:04 2010] :: [DEBUG] :: 22 serialization::archive 5 0 1 2...

    [Wed Nov 17 13:58:04 2010] :: [DEBUG] :: 22 serialization::archive 5 0 1 2...

    [Wed Nov 17 13:58:04 2010] :: [DEBUG] :: Reminding to track...
    [Wed Nov 17 13:58:04 2010] :: [DEBUG] :: Reminder message: Not currently tracking time.
    Click this message to change the current task
    [Wed Nov 17 13:58:04 2010] :: [DEBUG] :: Is idle: 1
    [Wed Nov 17 14:00:56 2010] :: [DEBUG] :: Returned from idle
    [Wed Nov 17 14:00:56 2010] :: [DEBUG] :: Systray icon clicked...
    [Wed Nov 17 14:00:56 2010] :: [DEBUG] :: Window is minimized...
    [Wed Nov 17 14:00:56 2010] :: [DEBUG] :: Minimized to tray... Showing
    [Wed Nov 17 14:00:56 2010] :: [DEBUG] :: Shown...
    [Wed Nov 17 14:08:04 2010] :: [DEBUG] :: 22 serialization::archive 5 0 1 2...

    [Wed Nov 17 14:08:04 2010] :: [DEBUG] :: 22 serialization::archive 5 0 1 2...

    [Wed Nov 17 14:08:04 2010] :: [DEBUG] :: Reminding to track...
    [Wed Nov 17 14:08:04 2010] :: [DEBUG] :: Reminder message: Not currently tracking time.
    Click this message to change the current task
    [Wed Nov 17 14:08:04 2010] :: [DEBUG] :: Is idle: 0
    [Wed Nov 17 14:08:06 2010] :: [DEBUG] :: Starting idle time detection service. idle-after: 300 polling-interval: 5
    [Wed Nov 17 14:08:07 2010] :: [DEBUG] :: 22 serialization::archive 5 0 1 2...

    [Wed Nov 17 14:08:07 2010] :: [DEBUG] :: 22 serialization::archive 5 0 1 2...

    --- !!!! The erroneous worklog ends 2:08:11 which is where I pressed nothing and then started the task ---

    [Wed Nov 17 14:08:11 2010] :: [DEBUG] :: Computer is now idle
    [Wed Nov 17 14:08:11 2010] :: [DEBUG] :: Entered idle... Disabling current task if any
    [Wed Nov 17 14:08:11 2010] :: [DEBUG] :: Set issue before idle to: PLTA-891
    [Wed Nov 17 14:08:11 2010] :: [DEBUG] :: 22 serialization::archive 5 0 1 2...

    [Wed Nov 17 14:08:11 2010] :: [DEBUG] :: 22 serialization::archive 5 0 1 2...

    [Wed Nov 17 14:08:16 2010] :: [DEBUG] :: Idle seconds: 5 current state: Idle
    [Wed Nov 17 14:08:21 2010] :: [DEBUG] :: Returned from idle
    [Wed Nov 17 14:09:32 2010] :: [DEBUG] :: Idle seconds: 5 current state: Busy
  • (some HTML allowed)
    How does this make you feel?
    Add Image
    I'm

    e.g. indifferent, undecided, unconcerned sad, anxious, confused, frustrated happy, confident, thankful, excited kidding, amused, unsure, silly

  • I’m happy and thankful
    Well, after a few off-forum information exchanges, it looks like Sohail reproed and fixed the issue. I've been testing build 1910 and have not been able to invoke the problem.

    For an intermittent, thread/race based bug, fixing it in one day is pretty awesome! Thanks Sohail.
  • (some HTML allowed)
    How does this make you feel?
    Add Image
    I'm

    e.g. indifferent, undecided, unconcerned sad, anxious, confused, frustrated happy, confident, thankful, excited kidding, amused, unsure, silly

  • v2 detects and stops the timer when you turn the computer off or put it to sleep (currently for Windows only - but will soon get support for the other platforms). You can find it here: https://worklogassistant.com

    Update: now works for all platforms.
  • (some HTML allowed)
    How does this make you feel?
    Add Image
    I'm

    e.g. indifferent, undecided, unconcerned happy, confident, thankful, excited kidding, amused, unsure, silly sad, anxious, confused, frustrated