Print

Please login or register.
1 Hour 1 Day 1 Week 1 Month Forever
Login with username, password and session length

[kitz]

Rather than take another thread off-topic. - link  Thought I best open a new thread and continue the conversation in the relevant section.

I first noticed that MDWS was always showing 98% upload.
Its not a major issue, just thought I'd try to find out what is happening.

Every hour at about the same time, practically like clockwork I get a tiny gap on MDWS even if the PC is idle.

Ive tried looking into this and it would appear that HG612modem stats isnt uploading to MDWS.

I was expecting it to occur at 18:34, so I sat here with Task Man open and all that happened is CPU went from 1% to 4% at time of stat collection.

These are the affected logs:

ONGOING_ERROR.LOG

Code: [Select]

24/04/2016 18:33:00.236 - [ IN HG612_stats.EXE ] - Start of 1 minute sampling - delayed by user setting of 0 seconds
24/04/2016 18:33:00.236 - Modem in use = HG622
24/04/2016 18:33:02.346 - End of HG612_stats.exe program, closing ERROR.LOG


24/04/2016 18:33:02.476 - In [Upload.exe] - Start of upload process
24/04/2016 18:33:02.716 - Now exiting [Upload.exe]


24/04/2016 18:34:00.286 - [ IN HG612_stats.EXE ] - Start of 1 minute sampling - delayed by user setting of 0 seconds
24/04/2016 18:34:00.635 - *** Now in exit_2_instances as there are 2 instances of HG612_stats.exe running. Status = 1.
24/04/2016 18:34:00.649 - About to close(sockfd)
24/04/2016 18:34:00.663 - About to freeadddrinfo(res)
24/04/2016 18:34:00.679 - *** In exit_2_instances - Closing ERROR.LOG. Status = 1.


24/04/2016 18:34:00.425 - [ IN HG612_stats.EXE ] - Start of 1 minute sampling - delayed by user setting of 0 seconds
24/04/2016 18:34:00.767 - *** Now in exit_2_instances as there are 2 instances of HG612_stats.exe running. Status = 1.
24/04/2016 18:34:00.781 - About to close(sockfd)
24/04/2016 18:34:00.796 - About to freeadddrinfo(res)
24/04/2016 18:34:00.810 - *** In exit_2_instances - Closing ERROR.LOG. Status = 1.


24/04/2016 18:35:00.256 - [ IN HG612_stats.EXE ] - Start of 1 minute sampling - delayed by user setting of 0 seconds
24/04/2016 18:35:00.256 - Modem in use = HG622
24/04/2016 18:35:02.386 - End of HG612_stats.exe program, closing ERROR.LOG


24/04/2016 18:35:02.505 - In [Upload.exe] - Start of upload process
24/04/2016 18:35:02.738 - Now exiting [Upload.exe]


24/04/2016 18:36:00.249 - [ IN HG612_stats.EXE ] - Start of 1 minute sampling - delayed by user setting of 0 seconds
24/04/2016 18:36:00.249 - Modem in use = HG622
24/04/2016 18:36:02.371 - End of HG612_stats.exe program, closing ERROR.LOG
EXIT-2-INSTANCES.LOG

Code: [Select]

4/04/2016 12:35:00.58 - ONGOING-ISRUNNING-123500-124.TXT - ** Exiting as there are 2 instances of [HG612_stats.exe] running. Status = 1,
24/04/2016 12:35:00.60 - ONGOING-ISRUNNING-123500-124.TXT - ** ONGOING-ISRUNNING-123500-124.TXT DELETED - Status = 1,
 
24/04/2016 12:35:00.70 - ONGOING-ISRUNNING-123500-277.TXT - ** Exiting as there are 2 instances of [HG612_stats.exe] running. Status = 1,
24/04/2016 12:35:00.71 - ONGOING-ISRUNNING-123500-277.TXT - ** ONGOING-ISRUNNING-123500-277.TXT DELETED - Status = 1,
 
24/04/2016 13:35:00.57 - ONGOING-ISRUNNING-133500-095.TXT - ** Exiting as there are 2 instances of [HG612_stats.exe] running. Status = 1,
24/04/2016 13:35:00.58 - ONGOING-ISRUNNING-133500-095.TXT - ** ONGOING-ISRUNNING-133500-095.TXT DELETED - Status = 1,
 
24/04/2016 13:35:00.71 - ONGOING-ISRUNNING-133500-283.TXT - ** Exiting as there are 2 instances of [HG612_stats.exe] running. Status = 1,
24/04/2016 13:35:00.73 - ONGOING-ISRUNNING-133500-283.TXT - ** ONGOING-ISRUNNING-133500-283.TXT DELETED - Status = 1,
 
24/04/2016 14:35:00.56 - ONGOING-ISRUNNING-143500-097.TXT - ** Exiting as there are 2 instances of [HG612_stats.exe] running. Status = 1,
24/04/2016 14:35:00.58 - ONGOING-ISRUNNING-143500-097.TXT - ** ONGOING-ISRUNNING-143500-097.TXT DELETED - Status = 1,
 
24/04/2016 14:35:00.71 - ONGOING-ISRUNNING-143500-279.TXT - ** Exiting as there are 2 instances of [HG612_stats.exe] running. Status = 1,
24/04/2016 14:35:00.72 - ONGOING-ISRUNNING-143500-279.TXT - ** ONGOING-ISRUNNING-143500-279.TXT DELETED - Status = 1,
 
24/04/2016 15:35:00.59 - ONGOING-ISRUNNING-153500-132.TXT - ** Exiting as there are 2 instances of [HG612_stats.exe] running. Status = 1,
24/04/2016 15:35:00.60 - ONGOING-ISRUNNING-153500-132.TXT - ** ONGOING-ISRUNNING-153500-132.TXT DELETED - Status = 1,
 
24/04/2016 15:35:00.69 - ONGOING-ISRUNNING-153500-281.TXT - ** Exiting as there are 2 instances of [HG612_stats.exe] running. Status = 1,
24/04/2016 15:35:00.70 - ONGOING-ISRUNNING-153500-281.TXT - ** ONGOING-ISRUNNING-153500-281.TXT DELETED - Status = 1,
 
24/04/2016 16:35:00.59 - ONGOING-ISRUNNING-163500-105.TXT - ** Exiting as there are 2 instances of [HG612_stats.exe] running. Status = 1,
24/04/2016 16:35:00.61 - ONGOING-ISRUNNING-163500-105.TXT - ** ONGOING-ISRUNNING-163500-105.TXT DELETED - Status = 1,
 
24/04/2016 16:35:00.73 - ONGOING-ISRUNNING-163500-286.TXT - ** Exiting as there are 2 instances of [HG612_stats.exe] running. Status = 1,
24/04/2016 16:35:00.74 - ONGOING-ISRUNNING-163500-286.TXT - ** ONGOING-ISRUNNING-163500-286.TXT DELETED - Status = 1,
 
24/04/2016 18:34:00.57 - ONGOING-ISRUNNING-183400-102.TXT - ** Exiting as there are 2 instances of [HG612_stats.exe] running. Status = 1,
24/04/2016 18:34:00.59 - ONGOING-ISRUNNING-183400-102.TXT - ** ONGOING-ISRUNNING-183400-102.TXT DELETED - Status = 1,
 
24/04/2016 18:34:00.71 - ONGOING-ISRUNNING-183400-287.TXT - ** Exiting as there are 2 instances of [HG612_stats.exe] running. Status = 1,
24/04/2016 18:34:00.73 - ONGOING-ISRUNNING-183400-287.TXT - ** ONGOING-ISRUNNING-183400-287.TXT DELETED - Status = 1,
Login_events.TXT

Code: [Select]

***********************************************************************************
24/04/2016 18:33:00.18 -   Start of [HG612_stats.exe]
24/04/2016 18:33:00.19 -   Immediately after "chdir(C:\Users\kitz\Desktop\Connection\HG612_Modem_Stats\Scripts)"
24/04/2016 18:33:00.21 -   Immediately before ini_parse()
24/04/2016 18:33:00.22 -   **** ini file opened for reading O.K. ****
24/04/2016 18:33:02.39 -   Normal End of [HG612_stats.exe]
**********************************************************************************


***********************************************************************************
24/04/2016 18:34:00.18 -   Start of [HG612_stats.exe]
24/04/2016 18:34:00.20 -   Immediately after "chdir(C:\Users\kitz\Desktop\Connection\HG612_Modem_Stats\Scripts)"
24/04/2016 18:34:00.22 -   Immediately before ini_parse()
24/04/2016 18:34:00.23 -   **** ini file opened for reading O.K. ****


***********************************************************************************
24/04/2016 18:34:00.37 -   Start of [HG612_stats.exe]
24/04/2016 18:34:00.38 -   Immediately after "chdir(C:\Users\kitz\Desktop\Connection\HG612_Modem_Stats\Scripts)"
24/04/2016 18:34:00.40 -   Immediately before ini_parse()
24/04/2016 18:34:00.41 -   **** ini file opened for reading O.K. ****
24/04/2016 18:34:00.67 - ONGOING-ISRUNNING-183400-102.TXT - *** In exit_2_instances - Closing ERROR.LOG. Status = 1,
24/04/2016 18:34:00.80 - ONGOING-ISRUNNING-183400-287.TXT - *** In exit_2_instances - Closing ERROR.LOG. Status = 1,


***********************************************************************************
24/04/2016 18:35:00.20 -   Start of [HG612_stats.exe]
24/04/2016 18:35:00.21 -   Immediately after "chdir(C:\Users\kitz\Desktop\Connection\HG612_Modem_Stats\Scripts)"
24/04/2016 18:35:00.23 -   Immediately before ini_parse()
24/04/2016 18:35:00.24 -   **** ini file opened for reading O.K. ****
24/04/2016 18:35:02.41 -   Normal End of [HG612_stats.exe]
**********************************************************************************
ONGOING_ERROR.LOG

Code: [Select]

24/04/2016 18:33:00.236 - [ IN HG612_stats.EXE ] - Start of 1 minute sampling - delayed by user setting of 0 seconds
24/04/2016 18:33:00.236 - Modem in use = HG622
24/04/2016 18:33:02.346 - End of HG612_stats.exe program, closing ERROR.LOG


24/04/2016 18:33:02.476 - In [Upload.exe] - Start of upload process
24/04/2016 18:33:02.716 - Now exiting [Upload.exe]


24/04/2016 18:34:00.286 - [ IN HG612_stats.EXE ] - Start of 1 minute sampling - delayed by user setting of 0 seconds
24/04/2016 18:34:00.635 - *** Now in exit_2_instances as there are 2 instances of HG612_stats.exe running. Status = 1.
24/04/2016 18:34:00.649 - About to close(sockfd)
24/04/2016 18:34:00.663 - About to freeadddrinfo(res)
24/04/2016 18:34:00.679 - *** In exit_2_instances - Closing ERROR.LOG. Status = 1.


24/04/2016 18:34:00.425 - [ IN HG612_stats.EXE ] - Start of 1 minute sampling - delayed by user setting of 0 seconds
24/04/2016 18:34:00.767 - *** Now in exit_2_instances as there are 2 instances of HG612_stats.exe running. Status = 1.
24/04/2016 18:34:00.781 - About to close(sockfd)
24/04/2016 18:34:00.796 - About to freeadddrinfo(res)
24/04/2016 18:34:00.810 - *** In exit_2_instances - Closing ERROR.LOG. Status = 1.


24/04/2016 18:35:00.256 - [ IN HG612_stats.EXE ] - Start of 1 minute sampling - delayed by user setting of 0 seconds
24/04/2016 18:35:00.256 - Modem in use = HG622
24/04/2016 18:35:02.386 - End of HG612_stats.exe program, closing ERROR.LOG


24/04/2016 18:35:02.505 - In [Upload.exe] - Start of upload process
24/04/2016 18:35:02.738 - Now exiting [Upload.exe]
ONGOING_ERROR.LOG_file_ERROR.TXT

Code: [Select]


24/04/2016 18:33:00.12 - ONGOING-ISRUNNING-183300-102.TXT - Start of [HG612_stats.exe] - **** Version 5.1.0.0 16/05/2015 ****
24/04/2016 18:33:02.37 - ONGOING-ISRUNNING-183300-102.TXT - Normal End of [HG612_stats.exe]
24/04/2016 18:33:02.47 - ONGOING-ISRUNNING-183300-102.TXT - Start of [Upload.exe] - **** Version 5.1.0.0 16/05/2015 ****
24/04/2016 18:33:02.71 - ONGOING-ISRUNNING-183300-102.TXT - Now exiting [Upload.exe]. Status = 1,
 
24/04/2016 18:33:02.74 - ONGOING-ISRUNNING-183300-102.TXT - End of [HG612_stats.exe] AFTER WebStats stuff
 
 

24/04/2016 18:34:00.13 - ONGOING-ISRUNNING-183400-102.TXT - Start of [HG612_stats.exe] - **** Version 5.1.0.0 16/05/2015 ****

24/04/2016 18:34:00.31 - ONGOING-ISRUNNING-183400-287.TXT - Start of [HG612_stats.exe] - **** Version 5.1.0.0 16/05/2015 ****
24/04/2016 18:34:00.56 - ONGOING-ISRUNNING-183400-102.TXT - ** About to exit as there are 2 instances of HG612_stats.exe running. Status = 1,
24/04/2016 18:34:00.63 - ONGOING-ISRUNNING-183400-102.TXT - *** Now in exit_2_instances as there are 2 instances of HG612_stats.exe running. Status = 1,
24/04/2016 18:34:00.64 - ONGOING-ISRUNNING-183400-102.TXT - About to close(sockfd). Status = 1,
24/04/2016 18:34:00.65 - ONGOING-ISRUNNING-183400-102.TXT - About to freeadddrinfo(res). Status = 1,
24/04/2016 18:34:00.69 - ONGOING-ISRUNNING-183400-102.TXT - ERROR.LOG successfully closed. Status = 0,
24/04/2016 18:34:00.70 - ONGOING-ISRUNNING-183400-287.TXT - ** About to exit as there are 2 instances of HG612_stats.exe running. Status = 1,
24/04/2016 18:34:00.70 - ONGOING-ISRUNNING-183400-102.TXT - *** End of [HG612_stats.exe] - 2 OR MORE INSTANCES WERE RUNNING. Status = 0,
24/04/2016 18:34:00.76 - ONGOING-ISRUNNING-183400-287.TXT - *** Now in exit_2_instances as there are 2 instances of HG612_stats.exe running. Status = 1,
24/04/2016 18:34:00.77 - ONGOING-ISRUNNING-183400-287.TXT - About to close(sockfd). Status = 1,
24/04/2016 18:34:00.79 - ONGOING-ISRUNNING-183400-287.TXT - About to freeadddrinfo(res). Status = 1,
24/04/2016 18:34:00.82 - ONGOING-ISRUNNING-183400-287.TXT - ERROR.LOG successfully closed. Status = 0,
24/04/2016 18:34:00.83 - ONGOING-ISRUNNING-183400-287.TXT - *** End of [HG612_stats.exe] - 2 OR MORE INSTANCES WERE RUNNING. Status = 0,

24/04/2016 18:35:00.14 - ONGOING-ISRUNNING-183500-113.TXT - Start of [HG612_stats.exe] - **** Version 5.1.0.0 16/05/2015 ****
24/04/2016 18:35:02.40 - ONGOING-ISRUNNING-183500-113.TXT - Normal End of [HG612_stats.exe]
24/04/2016 18:35:02.50 - ONGOING-ISRUNNING-183500-113.TXT - Start of [Upload.exe] - **** Version 5.1.0.0 16/05/2015 ****
24/04/2016 18:35:02.73 - ONGOING-ISRUNNING-183500-113.TXT - Now exiting [Upload.exe]. Status = 1,
 
24/04/2016 18:35:02.77 - ONGOING-ISRUNNING-183500-113.TXT - End of [HG612_stats.exe] AFTER WebStats stuff
 
Obviously something is causing a duplicate HG612_stats.exe every hour.    Any ideas where to look next please?

[Chrysalis]

is your clock synced regularly by ntp?

[kitz]

Didnt expect this (see below) when I went to check via the clock (Win7Pro)

Ive now allowed it, but anyhow Ive gone in the long way via Task Scheduler and it is set 01:00 every Sunday of every week.
Last run time 24/04/2016 01:00:00

[kitz]

grr I think its this

https://support.microsoft.com/en-us/kb/2461249

BE has mentioned it before.

[Chrysalis]

Didnt expect this (see below) when I went to check via the clock (Win7Pro)

Ive now allowed it, but anyhow Ive gone in the long way via Task Scheduler and it is set 01:00 every Sunday of every week.
Last run time 24/04/2016 01:00:00

that box is cryptoprevent hardening access to some cpl applets.

[Bald_Eagle1]

grr I think its this

https://support.microsoft.com/en-us/kb/2461249

BE has mentioned it before.

Looking at your logs, it does indeed seem to be that known Microsoft issue.

Sometimes, just starting/stopping the logging or deleting the task & creating a new one might help on a temporary basis.
It is probably only a temporary fix as the timing seems to creep by a minute every so often, so the chances are that two instances would attempt to run again at some time. 

Usually, only one instance would be exited & the other one would continue to run, but as they sometimes start so close together, each instance probably detects that the other one is running & each one decides to exit rather than cause the program to hang indefinitely.

The Microsoft fix definitely seemed to fix the problem for me when I was using Windows 7.

[Chrysalis]

yeah install the hotfix, reboot and then wait to see if its resolved.

by the way I think windows built in time sync is crap, the software I use is free and called nettime.

grab from here. http://www.timesynctool.com/

[tbailey2]

@Chrysalis
Likewise - except I set it every 15 mins    Windows default is every 10 days from memory although you use the Registry to set it to any period down to 15 mins.

At least two the 6 machines around here lose or gain up to around 1 sec/hour or so and it doesn't take long for a clock to get a long way out. Nettime is good and if you use uk pool servers in the mix it's even better.  Attached is my setup.

NB: This PC sleeps overnight hence the network error.

[Chrysalis]

yeah  I shortened the default also, I think mine is once an hour.

perhaps its a good idea to have the url for the hotfix and nettime in the software posts.  As I know you are trying to stop people having out of sync clocks when uploading.

[kitz]

yeah install the hotfix, reboot and then wait to see if its resolved.

There isnt a hotfix any more.  The link is dead. 
https://support.microsoft.com/en-us/hotfix/kbhotfix?kbnum=2461249&kbln=en-us

Sorry, the page you requested is not available.
The page you were looking for is currently not available.

iirc, you had to jump through some sort of hoops with M$ to get the hotfix even when it was available and it wasnt offered as a quick plug and play fix anyhow.   BE will know more as he has talked about it in the past.

@BE

Thanks.

I've deleted the task and re-created a new one to see if that helps.   

[Chrysalis]

try here, but I am curious if it has been superceded as its not on my hdd and I have all win7 hotfixes.

http://thehotfixshare.net/board/index.php?s=26283296738deb89a6c5a72fee5902b0&autocom=downloads&showfile=14560

[ejs]

When I went to download the hotfix, on the first attempt, I got an EULA to agree to, then the page not available message.

When I then repeated trying to download it, I got presented with a list to tick which version of Windows I wanted the hotfix for, and boxes to put my email address in for Microsoft to email me a link to the hotfix. I did not try submitting my email address to see if it actually emails me as promised.

[Chrysalis]

yes they email hotfixes out now.

https://www.dropbox.com/s/x5br7j4d9nnp8cc/Windows6.1-KB2461249-x64.msu?dl=0

[kitz]

Because Ive been so busy not had chance to do anything about this.
I tried deleting the task (twice) but that doesn't seem to have worked.
No idea why it should start out of the blue, when its been fine for a while. 

The page which gave me a 404 the other day is weird.  Sometimes it returns a 404 and yet now its just shown me a page for which Ive requested the hotfix.

@chrys - it that the one for Win7?   I wasnt sure as there was a couple of different versions.


----
Mines arrived:  File name is 442972_intl_x64_zip.exe.   Unzipped file contains Windows6.1-KB2461249-x64.msu  so it is the same as the link Chrys gave.

[Chrysalis]

6.1 is win7 yeah.  If its not it wont let you install anyway :p