It appears estimate server is failing. Can you please try different
estimate algorithm?

I will ask others to take a look.

thanks,
Paddy

On Mon, Jul 19, 2010 at 9:06 AM, McGraw, Robert P <rmcg...@purdue.edu> wrote:
> My amreport showed the following:
>
> mailrelay "C:/Alligate" lev 0  FAILED [disk "C:/Alligate", all estimate 
> failed]
>
> Attached is the window client log file from last night backup.
>
> 5116:4820:18/7/2010:23:10:413::CZWCJobHandler::ExecuteJob : Job Type = 3
> 5116:4820:18/7/2010:23:10:413::CZWCJobHandler::ExecuteJob : Job Type = 21
> 5116:4820:18/7/2010:23:10:413::CZWCJobHandler : Server address to be 
> validated from the list of authentic server = 128.210.3.201
> 5116:4820:18/7/2010:23:10:413::CZWCJobHandler : Server name = 
> hertz.math.purdue.edu
> 5116:4820:18/7/2010:23:10:413::CZWCJobHandler : Authentic Server name = 
> hertz.math.purdue.edu
> 5116:4820:18/7/2010:23:10:413::CZWCJobHandler::ExecuteJob : Job Type = 6
> 5116:4820:18/7/2010:23:10:413::ZWC Failure error code: 2
> 5116:4820:18/7/2010:23:10:413::ZWC Failure error code: 2
> 5116:4820:18/7/2010:23:10:413::CZWCJobHandler::ExecuteJob : Job Type = 11
> 5116:4820:18/7/2010:23:10:413::CZWCJobHandler : Entering ExecuteGetDLESizeJob
> 5116:4820:18/7/2010:23:10:413::CZWCJobHandler : Entering GetDLESize
> 5116:4820:18/7/2010:23:10:413::Catalog:GetStatementHandle: sql specific error
> 5116:4820:18/7/2010:23:10:413::Catalog: IsConnected: Reconnecting
> 5116:4820:18/7/2010:23:10:413::Catalog: IsConnected: Freeing connection 
> handles
> 5116:4820:18/7/2010:23:10:413::Catalog:ConnectToDb: Preprocessing before 
> connecting to driver
> 5116:4820:18/7/2010:23:10:413::Reading connection string from registry
> 5116:4820:18/7/2010:23:10:413::Connection string from registry is read 
> successfully
> 5116:4820:18/7/2010:23:10:413::Catalog:ConnectToDb: Connecting to driver
> 5116:4820:18/7/2010:23:10:882::Catalog:ConnectToDb: Driver Connection is 
> Successful
> 5116:4820:18/7/2010:23:10:882::Catalog: IsSchemaExists: Checking if schema 
> exists
> 5116:4820:18/7/2010:23:10:960::Catalog: IsSchemaExists: Schema exists
> 5116:4820:18/7/2010:23:10:960::Catalog: IsConnected: Reconnecting to database
> 5116:4820:18/7/2010:23:10:960::Catalog: IsConnected: Connected to database
> 5116:4820:18/7/2010:23:10:960::AddVolumeMetaData::DLE name C:/Alligate
> 5116:4820:18/7/2010:23:10:960::AddVolumeMetaData::Volume name C:\
> 5116:4820:18/7/2010:23:10:960::ZWC Failure error code: 2
> 5116:4820:18/7/2010:23:10:960::AddVolumeMetaData::Its a local drive
> 5116:4820:18/7/2010:23:10:960::CZWCJobHandler::GetDLESize : Estimate type 
> ESTIMATE_CALCSIZE
> 5116:4820:18/7/2010:23:10:976::Query:GetDiskList: No matching DiskList
> 5116:4820:18/7/2010:23:10:976::CZWCJobHandler::GetDLESize : Estimate type 
> ESTIMATE_SERVER
> 5116:4820:18/7/2010:23:10:976::Catalog:DisconnectDb: Disconnecting DB
> 5116:4820:18/7/2010:23:10:976::Catalog:DisconnectDb: Connection to DB is 
> disconnected successfully
> 5116:4820:18/7/2010:23:10:976::CZWCJobHandler : Leaving GetDLESize
> 5116:4820:18/7/2010:23:10:976::CZWCJobHandler : Leaving ExecuteGetDLESizeJob
> 5116:4820:18/7/2010:23:10:976::CServiceSessionMgr : Error in 
> ZWCGetBackupSizeForDle - NULTEXT( -1
> 5116:2652:18/7/2010:23:10:976::RemoveStaleClient : Last error code is 0
> 5116:2652:18/7/2010:23:10:991::The operation completed successfully.
>
> 5116:2652:18/7/2010:23:10:991::Communication Layer : Connection closed by 
> server.
>
> Amcheck says that my DLE name is correct. Yet when the backup rungs I get
>
>        ZWC Failure error code: 2
>
> And
>
>        Query:GetDiskList: No matching DiskList
>
>
> Any ideas what is happening?
>
> Robert
>
>
>
>> -----Original Message-----
>> From: owner-amanda-us...@amanda.org [mailto:owner-amanda-
>> us...@amanda.org] On Behalf Of McGraw, Robert P
>> Sent: Monday, July 19, 2010 10:52 AM
>> To: 'Paddy Sreenivasan'
>> Cc: 'amanda-users@amanda.org'
>> Subject: RE: zwc 3.1.1 problem
>>
>>
>> Paddy,
>>
>> By mistake I put beta. I did install the file from
>> http://www.zmanda.com/download-amanda.php which was ZWC-Community-
>> 3.1.1-31bit.zip. To be sure I downloaded the file again and ran cmp on
>> the two files and the are identical.
>>
>> Still having problems.
>>
>> Robert
>>
>>
>>
>> > -----Original Message-----
>> > From: paddy.sreeniva...@gmail.com
>> [mailto:paddy.sreeniva...@gmail.com]
>> > On Behalf Of Paddy Sreenivasan
>> > Sent: Friday, July 16, 2010 6:26 PM
>> > To: McGraw, Robert P
>> > Cc: amanda-users@amanda.org
>> > Subject: Re: zwc 3.1.1 problem
>> >
>> >
>> > Hi Robert,
>> >
>> > Can you try the 3.1.1 images which are available under 3.1.1 version
>> > in http://www.zmanda.com/download-amanda.php
>> >
>> > thanks,
>> > Paddy
>> > On Fri, Jul 16, 2010 at 2:11 PM, McGraw, Robert P
>> <rmcg...@purdue.edu>
>> > wrote:
>> > >
>> > >
>> > >> -----Original Message-----
>> > >> From: owner-amanda-us...@amanda.org [mailto:owner-amanda-
>> > >> us...@amanda.org] On Behalf Of McGraw, Robert P
>> > >> Sent: Friday, July 16, 2010 4:47 PM
>> > >> To: 'amanda-users@amanda.org'
>> > >> Subject: zwc 3.1.1 problem
>> > >>
>> > >>
>> > >>
>> > >> I am running Amanda 3.1.1 on Solaris 10 x86 and zwc is 3.1.1 beta.
>> > >>
>> > >> I installed zwc on host mailrelay without any errors.
>> > >>
>> > >> I ran amcheck on mailrelay:
>> > >>
>> > >>       [381][amandaba...@hertz]:amanda/server/daily% amcheck -c
>> daily
>> > >> mailrelay
>> > >>       Amanda Backup Client Hosts Check
>> > >>       --------------------------------
>> > >>       Client check: 1 host checked in 0.108 seconds.  0 problems
>> > found.
>> > >>       (brought to you by Amanda 3.1.1)
>> > >>
>> > >> No errors
>> > >>
>> > >> I ran
>> > >>
>> > >>       sh -x /local/amanda/amanda/sbin/amdump daily mailrelay
>> > >>
>> > >> and go the following
>> > >>
>> > >>       The next 4 new tapes already labelled are: D01018, D01019,
>> > >> D01020, D01021 FAILURE DUMP SUMMARY:
>> > >>         mailrelay "C:/Alligate" lev 0  FAILED [disk "C:/Alligate",
>> > all
>> > >> estimate failed]
>> > >>
>> > >>       NOTES:
>> > >>         planner: Adding new disk mailrelay:"C:/Alligate".
>> > >>         driver: WARNING: got empty schedule from planner
>> > >>
>> > >> Here is the planner debug file. Nothing obvious to me.
>> > >>
>> > >>
>> > >> [406][amandaba...@hertz]:amanda/server/daily% cat
>> > >> planner.20100716163132.debug
>> > >> Fri Jul 16 16:31:32 2010: planner: pid 5251 ruid 0 euid 30002
>> > version
>> > >> 3.1.1: start at Fri Jul 16 16:31:32 2010
>> > >> Fri Jul 16 16:31:32 2010: planner: pid 5251 ruid 0 euid 30002
>> > version
>> > >> 3.1.1: rename at Fri Jul 16 16:31:32 2010
>> > >> Fri Jul 16 16:31:33 2010: planner: security_getdriver(name=bsdtcp)
>> > >> returns 80bc8d8
>> > >> Fri Jul 16 16:31:33 2010: planner:
>> > security_handleinit(handle=810a988,
>> > >> driver=80bc8d8 (BSDTCP))
>> > >> Fri Jul 16 16:31:33 2010: planner:
>> > security_streaminit(stream=8126c78,
>> > >> driver=80bc8d8 (BSDTCP))
>> > >> Fri Jul 16 16:31:33 2010: planner: connect_port: Skip port 512:
>> > owned
>> > >> by exec.
>> > >> Fri Jul 16 16:31:33 2010: planner: connect_port: Skip port 513:
>> > owned
>> > >> by login.
>> > >> Fri Jul 16 16:31:33 2010: planner: connect_port: Skip port 514:
>> > owned
>> > >> by shell.
>> > >> Fri Jul 16 16:31:33 2010: planner: connect_port: Skip port 515:
>> > owned
>> > >> by printer.
>> > >> Fri Jul 16 16:31:33 2010: planner: make_socket opening socket with
>> > >> family 2
>> > >> Fri Jul 16 16:31:33 2010: planner: connect_port: Try  port 516:
>> > >> available - Success
>> > >> Fri Jul 16 16:31:33 2010: planner: connected to
>> 128.210.3.183.10080
>> > >> Fri Jul 16 16:31:33 2010: planner: our side is 0.0.0.0.516
>> > >> Fri Jul 16 16:31:33 2010: planner: try_socksize: send buffer size
>> is
>> > >> 65536
>> > >> Fri Jul 16 16:31:33 2010: planner: try_socksize: receive buffer
>> size
>> > is
>> > >> 65536
>> > >> Fri Jul 16 16:31:33 2010: planner: tcpm_send_token: data is still
>> > >> flowing
>> > >> Fri Jul 16 16:31:33 2010: planner: security_getdriver(name=bsdtcp)
>> > >> returns 80bc8d8
>> > >> Fri Jul 16 16:31:33 2010: planner:
>> > security_handleinit(handle=8126420,
>> > >> driver=80bc8d8 (BSDTCP))
>> > >> Fri Jul 16 16:31:33 2010: planner:
>> > security_streaminit(stream=812f810,
>> > >> driver=80bc8d8 (BSDTCP))
>> > >> Fri Jul 16 16:31:33 2010: planner: security_close(handle=810a988,
>> > >> driver=80bc8d8 (BSDTCP))
>> > >> Fri Jul 16 16:31:33 2010: planner: security_stream_close(8126c78)
>> > >> Fri Jul 16 16:31:33 2010: planner: security_close(handle=8126420,
>> > >> driver=80bc8d8 (BSDTCP))
>> > >> Fri Jul 16 16:31:33 2010: planner: security_stream_close(812f810)
>> > >> Fri Jul 16 16:31:33 2010: planner: pid 5251 finish time Fri Jul 16
>> > >> 16:31:33 2010
>> > >>
>> > >> Any idea what could be causing or where to look further.
>> > >>
>> > >> Thanks
>> > >>
>> > >> Robert
>> > >>
>> > >>
>> > _____________________________________________________________________
>> > >> Robert P. McGraw, Jr.
>> > >> Manager, Computer System                    EMAIL:
>> > rmcg...@purdue.edu
>> > >> Purdue University                            ROOM: MATH-807
>> > >> Department of Mathematics                   PHONE: (765) 494-6055
>> > >> 150 N. University Street
>> > >> West Lafayette, IN 47907-2067
>> > >>
>> > >>
>> > >>
>> > >
>> > > [McGraw, Robert P]
>> > > The following is the log file from the ZWC client. 1634 was the
>> logs
>> > from amcheck and 1653 was the logs from amdump. Says th
>> > >
>> > > 5116:4820:16/7/2010:16:34:343::CZWCJobHandler::ExecuteJob : Job
>> Type
>> > = 3
>> > > 5116:4820:16/7/2010:16:34:359::CZWCJobHandler::ExecuteJob : Job
>> Type
>> > = 5
>> > > 5116:4820:16/7/2010:16:34:359::CZWCJobHandler::ExecuteJob : Job
>> Type
>> > = 21
>> > > 5116:4820:16/7/2010:16:34:359::CZWCJobHandler : Server address to
>> be
>> > validated from the list of authentic server = 128.210.3.201
>> > > 5116:4820:16/7/2010:16:34:359::CZWCJobHandler : Server name =
>> > hertz.math.purdue.edu
>> > > 5116:4820:16/7/2010:16:34:359::CZWCJobHandler : Authentic Server
>> name
>> > = hertz.math.purdue.edu
>> > > 5116:4820:16/7/2010:16:34:359::CZWCJobHandler::ExecuteJob : Job
>> Type
>> > = 1
>> > > 5116:4820:16/7/2010:16:34:359::CZWCJobHandler::ExecuteJob : Job
>> Type
>> > = 3
>> > > 5116:4820:16/7/2010:16:34:359::CZWCJobHandler::ExecuteJob : Job
>> Type
>> > = 6
>> > > 5116:4820:16/7/2010:16:34:359::ZWC Failure error code: 2
>> > > 5116:4820:16/7/2010:16:34:359::ZWC Failure error code: 2
>> > > 5116:4820:16/7/2010:16:34:359::CZWCJobHandler::ExecuteJob : Job
>> Type
>> > = 7
>> > > 5116:4820:16/7/2010:16:34:359::CZWCJobHandler::ExecuteJob : Job
>> Type
>> > = 8
>> > > 5116:2652:16/7/2010:16:34:359::RemoveStaleClient : Last error code
>> is
>> > 0
>> > > 5116:2652:16/7/2010:16:34:359::The operation completed
>> successfully.
>> > > 5116:2652:16/7/2010:16:34:359::Communication Layer : Connection
>> > closed by server.
>> > >
>> > >
>> > >
>> > > 5116:4820:16/7/2010:16:53:447::CZWCJobHandler::ExecuteJob : Job
>> Type
>> > = 3
>> > > 5116:4820:16/7/2010:16:53:462::CZWCJobHandler::ExecuteJob : Job
>> Type
>> > = 21
>> > > 5116:4820:16/7/2010:16:53:462::CZWCJobHandler : Server address to
>> be
>> > validated from the list of authentic server = 128.210.3.201
>> > > 5116:4820:16/7/2010:16:53:462::CZWCJobHandler : Server name =
>> > hertz.math.purdue.edu
>> > > 5116:4820:16/7/2010:16:53:462::CZWCJobHandler : Authentic Server
>> name
>> > = hertz.math.purdue.edu
>> > > 5116:4820:16/7/2010:16:53:462::CZWCJobHandler::ExecuteJob : Job
>> Type
>> > = 6
>> > > 5116:4820:16/7/2010:16:53:462::ZWC Failure error code: 2
>> > > 5116:4820:16/7/2010:16:53:462::ZWC Failure error code: 2
>> > > 5116:4820:16/7/2010:16:53:462::CZWCJobHandler::ExecuteJob : Job
>> Type
>> > = 11
>> > > 5116:4820:16/7/2010:16:53:462::CZWCJobHandler : Entering
>> > ExecuteGetDLESizeJob
>> > > 5116:4820:16/7/2010:16:53:462::CZWCJobHandler : Entering GetDLESize
>> > > 5116:4820:16/7/2010:16:53:462::Catalog:GetStatementHandle: sql
>> > specific error
>> > > 5116:4820:16/7/2010:16:53:462::Catalog: IsConnected: Reconnecting
>> > > 5116:4820:16/7/2010:16:53:462::Catalog: IsConnected: Freeing
>> > connection handles
>> > > 5116:4820:16/7/2010:16:53:462::Catalog:ConnectToDb: Preprocessing
>> > before connecting to driver
>> > > 5116:4820:16/7/2010:16:53:462::Reading connection string from
>> > registry
>> > > 5116:4820:16/7/2010:16:53:462::Connection string from registry is
>> > read successfully
>> > > 5116:4820:16/7/2010:16:53:462::Catalog:ConnectToDb: Connecting to
>> > driver
>> > > 5116:4820:16/7/2010:16:53:462::Catalog:ConnectToDb: Driver
>> Connection
>> > is Successful
>> > > 5116:4820:16/7/2010:16:53:462::Catalog: IsSchemaExists: Checking if
>> > schema exists
>> > > 5116:4820:16/7/2010:16:53:462::Catalog: IsSchemaExists: Schema
>> exists
>> > > 5116:4820:16/7/2010:16:53:462::Catalog: IsConnected: Reconnecting
>> to
>> > database
>> > > 5116:4820:16/7/2010:16:53:462::Catalog: IsConnected: Connected to
>> > database
>> > > 5116:4820:16/7/2010:16:53:462::AddVolumeMetaData::DLE name
>> > C:/Alligate
>> > > 5116:4820:16/7/2010:16:53:462::AddVolumeMetaData::Volume name C:\
>> > > 5116:4820:16/7/2010:16:53:462::ZWC Failure error code: 2
>> > > 5116:4820:16/7/2010:16:53:462::AddVolumeMetaData::Its a local drive
>> > > 5116:4820:16/7/2010:16:53:462::CZWCJobHandler::GetDLESize :
>> Estimate
>> > type ESTIMATE_CALCSIZE
>> > > 5116:4820:16/7/2010:16:53:462::Query:GetDiskList: No matching
>> > DiskList
>> > > 5116:4820:16/7/2010:16:53:462::CZWCJobHandler::GetDLESize :
>> Estimate
>> > type ESTIMATE_SERVER
>> > > 5116:4820:16/7/2010:16:53:478::Catalog:DisconnectDb: Disconnecting
>> DB
>> > > 5116:4820:16/7/2010:16:53:478::Catalog:DisconnectDb: Connection to
>> DB
>> > is disconnected successfully
>> > > 5116:4820:16/7/2010:16:53:478::CZWCJobHandler : Leaving GetDLESize
>> > > 5116:4820:16/7/2010:16:53:478::CZWCJobHandler : Leaving
>> > ExecuteGetDLESizeJob
>> > > 5116:4820:16/7/2010:16:53:478::CServiceSessionMgr : Error in
>> > ZWCGetBackupSizeForDle - NULTEXT( -1
>> > > 5116:2652:16/7/2010:16:53:478::RemoveStaleClient : Last error code
>> is
>> > 0
>> > > 5116:2652:16/7/2010:16:53:478::The operation completed
>> successfully.
>> > > 5116:2652:16/7/2010:16:53:478::Communication Layer : Connection
>> > closed by server.
>> > >
>> > >
>> > > Robert
>> > >
>> > >
>> > >
>> >
>> >
>> >
>> > --
>> > Amanda http://amanda.zmanda.com
>> > ZRM for MySQL http://www.zmanda.com/backup-mysql.html
>>
>>
>
>
>



-- 
Amanda http://amanda.zmanda.com
ZRM for MySQL http://www.zmanda.com/backup-mysql.html

Reply via email to