[8.296][BUG][OPEN] Question: Up2date Problems

I just noticed while trying to update that I have some problems with up2date and couldn't update automatically. Is anybody else having problems with updates. I have authentication errors in my logs that probably started around 8.295

2011:12:15-15:14:50 gatekeeper audld[8209]: Starting Up2Date Package Downloader
2011:12:15-15:14:50 gatekeeper audld[8209]: patch up2date possible
2011:12:15-15:14:52 gatekeeper audld[8209]: Could not connect to Authentication Server 184.72.238.199:443 (code=500).
2011:12:15-15:14:52 gatekeeper audld[8209]: Could not connect to Authentication Server 184.72.238.199:443 (code=500).
2011:12:15-15:14:52 gatekeeper audld[8209]: >=========================================================================
2011:12:15-15:14:52 gatekeeper audld[8209]: All 2 Authentication Servers failed
2011:12:15-15:14:52 gatekeeper audld[8209]: '184.72.238.199:443'                   Code: '500'
2011:12:15-15:14:52 gatekeeper audld[8209]: 
2011:12:15-15:14:52 gatekeeper audld[8209]:  1. Modules::Trad_Get_Filelist::contact:1524() audld.pl
2011:12:15-15:14:52 gatekeeper audld[8209]:  2. main::authenticate:574() audld.pl
2011:12:15-15:14:52 gatekeeper audld[8209]:  3. main::run:378() audld.pl
2011:12:15-15:14:52 gatekeeper audld[8209]:  4. main::top-level:27() audld.pl
2011:12:15-15:14:52 gatekeeper audld[8209]: Up2Date prefetch failed
2011:12:15-15:14:52 gatekeeper audld[8209]: |=========================================================================
2011:12:15-15:14:52 gatekeeper audld[8209]: id="3703" severity="error" sys="system" sub="up2date" name="Authentication failed, no valid answer from Authentication Servers"
2011:12:15-15:14:52 gatekeeper audld[8209]: 
2011:12:15-15:14:52 gatekeeper audld[8209]:  1. main::alf:841() audld.pl
2011:12:15-15:14:52 gatekeeper audld[8209]:  2. main::authenticate:578() audld.pl
2011:12:15-15:14:52 gatekeeper audld[8209]:  3. main::run:378() audld.pl
2011:12:15-15:14:52 gatekeeper audld[8209]:  4. main::top-level:27() audld.p


Regards
Bill
  • Astaro Beta Report
    --------------------------------
    Version: 8.296
    Type: BUG
    State: ASSIGNED/OPEN
    Reporter: Billybob+
    Contributor: 
    MantisID: 19835
    Target version: 
    Fixed in version: 
    --------------------------------

  • I hadn't received any updates in about 5 days so I forced an update using a different server and it worked fine. This thread can be now closed as answered.

    audld.plx --trigger --server 79.125.21.244


    Regards
    Bill
  • Question remains why your ASG didn't fallback to any of the other (available) U2D servers automatically?
  • You are correct Mario and that is what had me worried. The manual update worked but now it seems that I am back to being stuck again with no update in 900+ minutes. My system keeps querying the same amazon server over and over.
    2011:12:16-07:58:01 gatekeeper audld[20144]: Starting Up2Date Package Downloader
    2011:12:16-07:58:01 gatekeeper audld[20144]: patch up2date possible
    2011:12:16-07:58:03 gatekeeper audld[20144]: Could not connect to Authentication Server 184.72.238.199:443 (code=500).
    2011:12:16-07:58:03 gatekeeper audld[20144]: Could not connect to Authentication Server 184.72.238.199:443 (code=500).
    2011:12:16-07:58:03 gatekeeper audld[20144]: >=========================================================================
    2011:12:16-07:58:03 gatekeeper audld[20144]: All 2 Authentication Servers failed
    2011:12:16-07:58:03 gatekeeper audld[20144]: '184.72.238.199:443'                   Code: '500'
    2011:12:16-07:58:03 gatekeeper audld[20144]: 
    2011:12:16-07:58:03 gatekeeper audld[20144]:  1. Modules::Trad_Get_Filelist::contact:1524() audld.pl
    2011:12:16-07:58:03 gatekeeper audld[20144]:  2. main::authenticate:574() audld.pl
    2011:12:16-07:58:03 gatekeeper audld[20144]:  3. main::run:378() audld.pl
    2011:12:16-07:58:03 gatekeeper audld[20144]:  4. main::top-level:27() audld.pl
    2011:12:16-07:58:03 gatekeeper audld[20144]: |=========================================================================
    2011:12:16-07:58:03 gatekeeper audld[20144]: id="3703" severity="error" sys="system" sub="up2date" name="Authentication failed, no valid answer from Authentication Servers"
    2011:12:16-07:58:03 gatekeeper audld[20144]: 
    2011:12:16-07:58:03 gatekeeper audld[20144]:  1. main::alf:841() audld.pl
    2011:12:16-07:58:03 gatekeeper audld[20144]:  2. main::authenticate:578() audld.pl
    2011:12:16-07:58:03 gatekeeper audld[20144]:  3. main::run:378() audld.pl
    2011:12:16-07:58:03 gatekeeper audld[20144]:  4. main::top-level:27() audld.pl

    Regards
    Bill
  • My servers list
    gatekeeper:/var/log # cat /etc/up2date/servers.sorted
    $VAR1 = [
              {
                'name' => 'v8up2date2',
                'Port' => '443',
                'Ip' => '184.72.238.199',
                'Host' => 'v8up2date2.astaro.com',
                'Fallback_Ip' => '184.72.238.199'
              }
            ];

    I guess I can manually enter the working server to make it work unless this file is update dynamically[:S]

    Regards
    Bill
  • Hi,
    every 4 hours your ASG should check which servers are reachable and perform the best, and in that process this file is overwritten. The process doing that is called "netselector.plx", and it is called by cron - you should be able to see that call in /etc/crontab.
    Just try to run this command line manually, this should shed some light on the issue. Thank you!
    Cheers,
     andreas
  • Here is the output
    gatekeeper:/var/log # /usr/local/bin/netselector.plx --infile /etc/up2date/authservers.ini --outfile /etc/up2date/servers.sorted

    ##################
    2011-12-16 10:05:06.096 WARNING netselector[25867]: main::get_official_ip:344()
    | Could not connect to Authentication Server 184.72.238.199 (code=500).
    gatekeeper:/var/log # 

    The sorted list is still the same.
    Regards
    Bill

    Edit: Here is the authservers.ini file just in case
    gatekeeper:/var/log # cat /etc/up2date/authservers.ini
    [v8up2date1]
    Host = v8up2date1.astaro.com
    Ip   = 79.125.21.244
    Port = 443

    [v8up2date2]
    Host = v8up2date2.astaro.com
    Ip   = 184.72.238.199
    Port = 443

    [v8up2date3]
    Host = v8up2date3.astaro.com
    Ip   = 175.41.132.12
    Port = 443
  • Same server after repeated tries[:$]
    gatekeeper:/var/log # /usr/local/bin/netselector.plx --infile /etc/up2date/authservers.ini
    Sorted server list will be written to STDOUT (use --outfile  for file output)

    ##################
    2011-12-16 10:45:16.400 WARNING netselector[27633]: main::get_official_ip:344()
    | Could not connect to Authentication Server 184.72.238.199 (code=500).
    $VAR1 = [
              {
                'name' => 'v8up2date2',
                'Port' => '443',
                'Ip' => '184.72.238.199',
                'Host' => 'v8up2date2.astaro.com',
                'Fallback_Ip' => '184.72.238.199'
              }
            ];
    gatekeeper:/var/log # 
  • Apparently, this can be an issue for some on 8.203: https://community.sophos.com/products/unified-threat-management/astaroorg/f/52/t/28255

    Cheers - Bob
     
    Sophos UTM Community Moderator
    Sophos Certified Architect - UTM
    Sophos Certified Engineer - XG
    Gold Solution Partner since 2005
    MediaSoft, Inc. USA
  • No errors in my logs.  the server list has v8up2date3 first for me.