Guest User!

You are not Sophos Staff.

Thread Info
  • State Not Answered
  • Replies 20 replies
  • Subscribers 0 subscribers
  • Views 5414 views
  • Users 0 members are here
Options
Suggested

[8.171][BUG][UNREPRODUCIBLE] scheduled firmware update not working

RaveNet
I twice today scheduled the 8.171 update to install only to have nothing happen.  first time was for 17:30 and I had set this before noon
the second time, after I noticed the first schedule didn't run was around 6pm and I set it for 18:45 and again, nothing even shows in the up2date log

"Version 8.171 (Medium urgency, requires reboot)
Installation is scheduled for 2011-06-22 at 18:45:00"

----

2011:06:22-18:35:01 vpn audld[441]: Starting Up2Date Package Downloader
2011:06:22-18:35:02 vpn audld[441]: patch up2date possible
2011:06:22-18:35:02 vpn audld[441]: id="3701" severity="info" sys="system" sub="up2date" name="Authentication successful"
2011:06:22-18:35:04 vpn audld[441]: id="3707" severity="info" sys="system" sub="up2date" name="Successfully synchronized fileset" status="success" action="download" package="sys"
2011:06:22-18:54:01 vpn audld[1934]: Starting Up2Date Package Downloader
2011:06:22-18:54:01 vpn audld[1934]: patch up2date possible
2011:06:22-18:54:07 vpn audld[1934]: id="3701" severity="info" sys="system" sub="up2date" name="Authentication successful"
  • 0
    OK I went is as loginuser

    cd /var/log/

    when I do "grep "up2data->scheduled_update" confd-debug.log " the cursor disappears for a second then returns me to the command line.



    OK, tried as root. I can't SSH in as root. I've reset the root password 3 times.
  • 0
    You can only login as root if you allow it through WebAdmin and are using an SSH key.  Login as Loginuser, then do an su instead..

    If the search phrase provided by kbr doesn't come up with anything try shortening it to  just scheduled_update.:

    grep "scheduled_update" confd-debug.log
    grep "scheduled_update" mdw-debug.log
    __________________
    ACE v8/SCA v9.3

    ...still have a v5 install disk in a box somewhere.

    http://xkcd.com
    http://www.tedgoff.com/mb
    http://www.projectcartoon.com/cartoon/1
  • 0
    Okay, I thought I was doing something wrong but that is not the case. Using root is not required. There are no entries in either of the specified log files with "up2data->scheduled_update" or even just "scheduled_update".



    I did a search with 
    grep payfya confd-debug.log
     (payfya being the device name) and other searches with things like the devices internal IP address and I get thousands of lines flying up the screen. There are no entries with scheduled_update.

    With grep update confd-debug.log this is the output (I give these lines because the scheduled update was set to run at 3:15am)
    2011:07:01-03:10:41 payfya confd[534]: D Storage::update:84() => id="3108" severity="debug" sys="System" sub="confd" name="reloading storage" user="system" srcip="127.0.0.1" facility="system" client="dns-resolver.plx" version="7138" storage="/cfg"

    2011:07:01-03:10:42 payfya confd[534]: D Storage::update:84() => id="3108" severity="debug" sys="System" sub="confd" name="reloading storage" user="system" srcip="127.0.0.1" facility="system" client="dns-resolver.plx" version="7139" storage="/cfg"

    2011:07:01-03:10:42 payfya confd[536]: D Storage::update:84() => id="3108" severity="debug" sys="System" sub="confd" name="reloading storage" user="system" srcip="127.0.0.1" facility="system" client="mdw.plx" version="7140" storage="/cfg"

    2011:07:01-03:16:47 payfya confd[998]: D Storage::update:84() => id="3108" severity="debug" sys="System" sub="confd" name="reloading storage" user="system" srcip="127.0.0.1" facility="system" client="dns-resolver.plx" version="7142" storage="/cfg"

    2011:07:01-03:16:48 payfya confd[998]: D Storage::update:84() => id="3108" severity="debug" sys="System" sub="confd" name="reloading storage" user="system" srcip="127.0.0.1" facility="system" client="dns-resolver.plx" version="7143" storage="/cfg"

    2011:07:01-03:16:48 payfya confd[999]: D Storage::update:84() => id="3108" severity="debug" sys="System" sub="confd" name="reloading storage" user="system" srcip="127.0.0.1" facility="system" client="mdw.plx" version="7143" storage="/cfg"

    2011:07:01-03:23:53 payfya confd[1359]: D Storage::update:84() => id="3108" severity="debug" sys="System" sub="confd" name="reloading storage" user="system" srcip="127.0.0.1" facility="system" client="dns-resolver.plx" version="7146" storage="/cfg"

    2011:07:01-03:23:54 payfya confd[1359]: D Storage::update:84() => id="3108" severity="debug" sys="System" sub="confd" name="reloading storage" user="system" srcip="127.0.0.1" facility="system" client="dns-resolver.plx" version="7147" storage="/cfg"

    2011:07:01-03:23:54 payfya confd[1384]: D Storage::update:84() => id="3108" severity="debug" sys="System" sub="confd" name="reloading storage" user="system" srcip="127.0.0.1" facility="system" client="smtpd [master]" call="thaw" version="7147" storage="/cfg"

    2011:07:01-03:23:54 payfya confd[1360]: D Storage::update:84() => id="3108" severity="debug" sys="System" sub="confd" name="reloading storage" user="system" srcip="127.0.0.1" facility="system" client="mdw.plx" version="7148" storage="/cfg"

    2011:07:01-03:29:59 payfya confd[1711]: D Storage::update:84() => id="3108" severity="debug" sys="System" sub="confd" name="reloading storage" user="system" srcip="127.0.0.1" facility="system" client="dns-resolver.plx" version="7151" storage="/cfg"

    No output given for grep update mdw-debug.log

    The output I got with the simplified search string doesn't look very relevant.
  • 0
    Probably need to wait for a couple of days until kbr returns then, since we don't know what other data may be relevant.
    __________________
    ACE v8/SCA v9.3

    ...still have a v5 install disk in a box somewhere.

    http://xkcd.com
    http://www.tedgoff.com/mb
    http://www.projectcartoon.com/cartoon/1
  • 0
    As the logs get rotated on a daily basis, did you try this with the correct log files?
  • 0 in reply to kbr
    As the logs get rotated on a daily basis, did you try this with the correct log files?

    The update was scheduled to install July 1 at 3:15am and I checked the log on July 1 at ~5:30pm (local time) so I assume I was searching the correct log files with the instructions I was given.

    edit:
    I have yet to install the 8.172 update. Please give me a precise sequence of events you would like me to follow and I will do so. I just can't do the update until at least 5 hours after this post. I'm working from home today and can't afford to loose my connectivity until my shift is over.
  • 0
    Just schedule the up2date and look at the debug logs. The only thing we need to make sure is that you are looking at the logs on the same day [;)]
  • 0
    Well, it worked today. At about 3:21pm I scheduled the update to run at 3:30pm and it did it. The only differences between now and previous attempts are than I scheduled it to run in the very near future (less than 10 minutes) and the time of day. Usually I would have it run in the dead of night, like 3am. Perhaps some of the devices daily tasks preempted the update on previous attempts?

    I'm certain I was looking at the correct log files before. Oh well.
  • 0 in reply to Soong
    Well, it worked today.


    Then let's wait for the next release and try it again. This time, i'd suggest you schedule a run for later on the same day (eg. 22:23).

    I'm certain I was looking at the correct log files before. Oh well.


    If you want to go and re-check: you can find the archived logs under [FONT="Courier New"]/var/log/confd-debug/2011/06[/FONT] and [FONT="Courier New"]/var/log/confd-debug/2011/07[/FONT] ...

    Cheers,
    Kai
  • 0


    Fingers crossed.


    Well, that's two in a row that have worked.
Unfiltered HTML