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