Tek-Tips is the largest IT community on the Internet today!

Members share and learn making Tek-Tips Forums the best source of peer-reviewed technical information on the Internet!

  • Congratulations Mike Lewis on being selected by the Tek-Tips community for having the most helpful posts in the forums last week. Way to Go!

Aloha Rejected Batches due to a bad transaction

Status
Not open for further replies.

MitchMann

Vendor
Jun 20, 2012
3
US
I have been having issues with a particular store getting rejected batches due to a bad transaction. The error that they are getting is "Rejected Batch: (Record Type)=Detail, (Error Type)=Error in Batch (E), (Record Sequence Number)=0070, (Data Field Number)=19".
The process in which this happens is they attempt to batch out at night, receive the rejected batch. I have to call their Credit Processor which is Visanet and they will tell me that the batch failed due to a bad transaction. They will give me the credit card information and then I void that transaction out of the current batch. Sometimes there will be more than one transaction. After getting out the bad transaction, I am then able to batch out successfully. After batching out, I will then re-enter that voided transaction into the newest batch and it will batch out fine.

They started having this issue in the first of May when they switched from DialUp to DSL. The ISP is AT&T. They also have a Sister Restaurant with the exact same setup and they have not experienced any issues at all. Once these problems started occuring, I upgraded their EDC to 7.0.9.4 which did not resolve the issue.


Here is the EDC Debout:
Jun 28, 03:05:52.967, [], [Notice],,"ALOHABOH","User 2675 has run Login"
Jun 28, 03:05:52.967, [], [Notice],,"ALOHABOH","Using BOH security timeout (600 seconds)."
Jun 28, 03:05:53.076, [], [Notice],,"ALOHABOH","Security::Timeout created for 600 seconds."
Jun 28, 03:05:56.780, [], [Notice],,"ALOHABOH","User 2675 has run Functions | Settle Batch"
Jun 28, 03:05:56.795, [], [Debug],,"GetProcessors - Reading processor info from D:\Aloha\EDC\Edc.ini."
Jun 28, 03:05:56.795, [], [Debug],,"GetProcessors - Read 1 processors."
Jun 28, 03:05:56.858, [], [Debug],,"GetProcessors - Reading processor info from D:\Aloha\EDC\Edc.ini."
Jun 28, 03:05:56.858, [], [Debug],,"GetProcessors - Read 1 processors."
Jun 28, 03:05:58.436, [], [Notice],,"ALOHABOH","Select Processor","User 2675 has selected VisaNet to settle batch"
Jun 28, 03:05:59.608, [], [Notice],,"ALOHABOH","Confirm","User 2675 has settled batch for processor VisaNet"
Jun 28, 03:05:59.608, [], [Notice],,"Settle batch: 1"
Jun 28, 03:05:59.623, [], [Debug],,"SubmitTxn() called."
Jun 28, 03:05:59.623, [], [Information],,"WARNING: Generating new date and time fields."
Jun 28, 03:05:59.623, [], [Debug],,"SubmitTxn() called. Waiting for a response..."
Jun 28, 03:05:59.623, [], [Debug],," parms offline status = "
Jun 28, 03:05:59.639, [RequestManager], [Notice],,"RequestManager::processRequestFile: FOUND: D:\Aloha\EDC\10000000.REQ, size = 178"
Jun 28, 03:05:59.639, [RequestManager], [Notice],,"RequestManager::processRequestFile: --1 about to process .req file: D:\Aloha\EDC\10000000.REQ"
Jun 28, 03:05:59.639, [RequestManager], [Debug],,"TransactionsBase::StoreTxn Added: 10000000 Next: 10000000"
Jun 28, 03:05:59.639, [RequestManager], [Notice],,"RequestManager::processTxnFile: --2 txn stored. (renamed to HLD)"
Jun 28, 03:05:59.639, [RequestManager], [Notice],,"RequestManager::processTxnFile: --3 .req file processed."
Jun 28, 03:05:59.655, [SSLManager], [Debug],,"CEngine::processNextStoredTxn() - START 10000000"
Jun 28, 03:05:59.655, [SSLManager], [Debug],,"<queue>"
Jun 28, 03:05:59.655, [SSLManager], [Debug],,"</queue>"
Jun 28, 03:05:59.655, [SSLManager], [Debug],,"CEngine::processStoredTxn() FileNumber = 10000000 - begin."
Jun 28, 03:05:59.655, [SSLManager], [Notice],,"Transactions::preProcessTxn() begin"
Jun 28, 03:05:59.655, [SSLManager], [Notice],,"CEngine::processStoredTxn() - after 'PreProcessTxn(*parms)"
Jun 28, 03:05:59.655, [SSLManager], [Notice],,"Transactions::processTxn: VISANET[1]"
Jun 28, 03:05:59.655, [SSLManager], [Notice],,"CEngine::performSettlement - begin"
Jun 28, 03:05:59.655, [SSLManager], [Debug],,"|: Visanet::Engine::performSettlementViaSSL()"
Jun 28, 03:05:59.655, [SSLManager], [Debug],,"Preparing message"
Jun 28, 03:05:59.655, [SSLManager], [Debug],,"|: Visanet::Engine::BuildBatchHeader()"
Jun 28, 03:05:59.655, [SSLManager], [Debug],,"|: Visanet::Engine::BuildBatchParameters()"
Jun 28, 03:05:59.655, [SSLManager], [Debug],,"|: Visanet::Engine::BuildBatchDetail()"
Jun 28, 03:05:59.655, [SSLManager], [Notice],,"======TxnIndex: 0"
Jun 28, 03:05:59.655, [SSLManager], [Debug],,"|: Visanet::Engine::BuildBatchDetail()"
Jun 28, 03:05:59.655, [SSLManager], [Notice],,"======TxnIndex: 1"
Jun 28, 03:05:59.655, [SSLManager], [Debug],,"|: Visanet::Engine::BuildBatchDetail()"
Jun 28, 03:05:59.655, [SSLManager], [Notice],,"======TxnIndex: 2"
Jun 28, 03:05:59.655, [SSLManager], [Debug],,"|: Visanet::Engine::BuildBatchDetail()"
Jun 28, 03:05:59.655, [SSLManager], [Notice],,"======TxnIndex: 3"
Jun 28, 03:05:59.655, [SSLManager], [Debug],,"|: Visanet::Engine::BuildBatchDetail()"
Jun 28, 03:05:59.655, [SSLManager], [Notice],,"======TxnIndex: 4"
Jun 28, 03:05:59.655, [SSLManager], [Debug],,"|: Visanet::Engine::BuildBatchDetail()"
Jun 28, 03:05:59.655, [SSLManager], [Notice],,"======TxnIndex: 5"
Jun 28, 03:05:59.670, [SSLManager], [Debug],,"|: Visanet::Engine::BuildBatchDetail()"
Jun 28, 03:05:59.670, [SSLManager], [Notice],,"======TxnIndex: 6"
Jun 28, 03:05:59.670, [SSLManager], [Debug],,"|: Visanet::Engine::BuildBatchDetail()"
Jun 28, 03:05:59.670, [SSLManager], [Notice],,"======TxnIndex: 7"
Jun 28, 03:05:59.670, [SSLManager], [Debug],,"|: Visanet::Engine::BuildBatchDetail()"
Jun 28, 03:05:59.670, [SSLManager], [Notice],,"======TxnIndex: 8"
Jun 28, 03:05:59.670, [SSLManager], [Debug],,"|: Visanet::Engine::BuildBatchDetail()"
Jun 28, 03:05:59.670, [SSLManager], [Notice],,"======TxnIndex: 9"
Jun 28, 03:05:59.670, [SSLManager], [Debug],,"|: Visanet::Engine::BuildBatchDetail()"
Jun 28, 03:05:59.670, [SSLManager], [Notice],,"======TxnIndex: 10"
Jun 28, 03:05:59.670, [SSLManager], [Debug],,"|: Visanet::Engine::BuildBatchDetail()"
Jun 28, 03:05:59.670, [SSLManager], [Notice],,"======TxnIndex: 11"
Jun 28, 03:05:59.670, [SSLManager], [Debug],,"|: Visanet::Engine::BuildBatchDetail()"
Jun 28, 03:05:59.670, [SSLManager], [Notice],,"======TxnIndex: 12"
Jun 28, 03:05:59.670, [SSLManager], [Debug],,"|: Visanet::Engine::BuildBatchDetail()"
Jun 28, 03:05:59.670, [SSLManager], [Notice],,"======TxnIndex: 13"
Jun 28, 03:05:59.686, [SSLManager], [Debug],,"|: Visanet::Engine::BuildBatchDetail()"
Jun 28, 03:05:59.686, [SSLManager], [Notice],,"======TxnIndex: 14"
Jun 28, 03:05:59.686, [SSLManager], [Debug],,"|: Visanet::Engine::BuildBatchDetail()"
Jun 28, 03:05:59.686, [SSLManager], [Notice],,"======TxnIndex: 15"
Jun 28, 03:05:59.686, [SSLManager], [Debug],,"|: Visanet::Engine::BuildBatchDetail()"
Jun 28, 03:05:59.686, [SSLManager], [Notice],,"======TxnIndex: 16"
Jun 28, 03:05:59.686, [SSLManager], [Debug],,"|: Visanet::Engine::BuildBatchDetail()"
Jun 28, 03:05:59.686, [SSLManager], [Notice],,"======TxnIndex: 17"
Jun 28, 03:05:59.686, [SSLManager], [Debug],,"|: Visanet::Engine::BuildBatchDetail()"
Jun 28, 03:05:59.686, [SSLManager], [Notice],,"======TxnIndex: 18"
Jun 28, 03:05:59.686, [SSLManager], [Debug],,"|: Visanet::Engine::BuildBatchDetail()"
Jun 28, 03:05:59.686, [SSLManager], [Notice],,"======TxnIndex: 19"
Jun 28, 03:05:59.686, [SSLManager], [Debug],,"|: Visanet::Engine::BuildBatchDetail()"
Jun 28, 03:05:59.686, [SSLManager], [Notice],,"======TxnIndex: 20"
Jun 28, 03:05:59.842, [SSLManager], [Debug],,"|: Visanet::Engine::BuildBatchDetail()"
Jun 28, 03:05:59.842, [SSLManager], [Debug],,"|: Visanet::Engine::BuildBatchTrailer()"
Jun 28, 03:05:59.842, [SSLManager], [Debug],,"|: Visanet::Engine::performSettlementViaRawSSL()"
Jun 28, 03:05:59.842, [SSLManager], [Debug],,"** VisanetSSL2Client TimedConnect connecting to ssl2.vitalps.net:5003 (timeout 200)"
Jun 28, 03:06:00.092, [SSLManager], [Debug],,"** VisanetSSL2Client::TimedConnect OK."
Jun 28, 03:06:00.092, [SSLManager], [Debug],,"Sending message"
Jun 28, 03:06:00.092, [SSLManager], [Information],,"|: VisanetSSLSocket::SendBatchHeader"
Jun 28, 03:06:00.311, [SSLManager], [Information],,"|: VisanetSSLSocket::SendBatchParameters"
Jun 28, 03:06:00.483, [SSLManager], [Information],,"|: BatchDetail[0]"
Jun 28, 03:06:00.483, [SSLManager], [Information],,"|: VisanetSSLSocket::SendBatchDetail"
Jun 28, 03:06:00.655, [SSLManager], [Information],,"|: BatchDetail[1]"
Jun 28, 03:06:00.655, [SSLManager], [Information],,"|: VisanetSSLSocket::SendBatchDetail"
Jun 28, 03:06:00.826, [SSLManager], [Information],,"|: BatchDetail[2]"
Jun 28, 03:06:00.826, [SSLManager], [Information],,"|: VisanetSSLSocket::SendBatchDetail"
Jun 28, 03:06:00.998, [SSLManager], [Information],,"|: BatchDetail[3]"
Jun 28, 03:06:00.998, [SSLManager], [Information],,"|: VisanetSSLSocket::SendBatchDetail"
Jun 28, 03:06:01.186, [SSLManager], [Information],,"|: BatchDetail[4]"
Jun 28, 03:06:01.186, [SSLManager], [Information],,"|: VisanetSSLSocket::SendBatchDetail"
Jun 28, 03:06:01.358, [SSLManager], [Information],,"|: BatchDetail[5]"
Jun 28, 03:06:01.358, [SSLManager], [Information],,"|: VisanetSSLSocket::SendBatchDetail"
Jun 28, 03:06:01.530, [SSLManager], [Information],,"|: BatchDetail[6]"
Jun 28, 03:06:01.530, [SSLManager], [Information],,"|: VisanetSSLSocket::SendBatchDetail"
Jun 28, 03:06:01.701, [SSLManager], [Information],,"|: BatchDetail[7]"
Jun 28, 03:06:01.701, [SSLManager], [Information],,"|: VisanetSSLSocket::SendBatchDetail"
Jun 28, 03:06:01.873, [SSLManager], [Information],,"|: BatchDetail[8]"
Jun 28, 03:06:01.873, [SSLManager], [Information],,"|: VisanetSSLSocket::SendBatchDetail"
Jun 28, 03:06:02.061, [SSLManager], [Information],,"|: BatchDetail[9]"
Jun 28, 03:06:02.061, [SSLManager], [Information],,"|: VisanetSSLSocket::SendBatchDetail"
Jun 28, 03:06:02.233, [SSLManager], [Information],,"|: BatchDetail[10]"
Jun 28, 03:06:02.233, [SSLManager], [Information],,"|: VisanetSSLSocket::SendBatchDetail"
Jun 28, 03:06:02.405, [SSLManager], [Information],,"|: BatchDetail[11]"
Jun 28, 03:06:02.405, [SSLManager], [Information],,"|: VisanetSSLSocket::SendBatchDetail"
Jun 28, 03:06:02.608, [SSLManager], [Information],,"|: BatchDetail[12]"
Jun 28, 03:06:02.608, [SSLManager], [Information],,"|: VisanetSSLSocket::SendBatchDetail"
Jun 28, 03:06:02.795, [SSLManager], [Information],,"|: BatchDetail[13]"
Jun 28, 03:06:02.795, [SSLManager], [Information],,"|: VisanetSSLSocket::SendBatchDetail"
Jun 28, 03:06:02.967, [SSLManager], [Information],,"|: BatchDetail[14]"
Jun 28, 03:06:02.967, [SSLManager], [Information],,"|: VisanetSSLSocket::SendBatchDetail"
Jun 28, 03:06:03.139, [SSLManager], [Information],,"|: BatchDetail[15]"
Jun 28, 03:06:03.139, [SSLManager], [Information],,"|: VisanetSSLSocket::SendBatchDetail"
Jun 28, 03:06:03.358, [SSLManager], [Information],,"|: BatchDetail[16]"
Jun 28, 03:06:03.358, [SSLManager], [Information],,"|: VisanetSSLSocket::SendBatchDetail"
Jun 28, 03:06:03.530, [SSLManager], [Information],,"|: BatchDetail[17]"
Jun 28, 03:06:03.530, [SSLManager], [Information],,"|: VisanetSSLSocket::SendBatchDetail"
Jun 28, 03:06:03.701, [SSLManager], [Information],,"|: BatchDetail[18]"
Jun 28, 03:06:03.701, [SSLManager], [Information],,"|: VisanetSSLSocket::SendBatchDetail"
Jun 28, 03:06:03.889, [SSLManager], [Information],,"|: BatchDetail[19]"
Jun 28, 03:06:03.889, [SSLManager], [Information],,"|: VisanetSSLSocket::SendBatchDetail"
Jun 28, 03:06:04.092, [SSLManager], [Information],,"|: BatchDetail[20]"
Jun 28, 03:06:12.451, [SSLManager], [Information],,"|: VisanetSSLSocket::SendBatchDetail"
Jun 28, 03:06:12.655, [SSLManager], [Information],,"|: VisanetSSLSocket::SendBatch response error: STXFound."
Jun 28, 03:06:12.655, [SSLManager], [Information],,"|: VisanetSSLSocket::ReceiveBatchResponse"
Jun 28, 03:06:17.920, [SSLManager], [Information],,"|: VisanetSSLSocket::SendBatch complete."
Jun 28, 03:06:17.920, [SSLManager], [Debug],,"Sending message"
Jun 28, 03:06:17.920, [SSLManager], [Error],,"Rejected Batch: [Record Type]=Detail, [Error Type]=Error in Batch (E), [Record Sequence Number]=0070, [Data Field Number]=19"
Jun 28, 03:06:17.920, [SSLManager], [Debug],,"Rejected Batch: [Record Type]=Detail, [Error Type]=Error in Batch (E), [Record Sequence Number]=0070, [Data Field Number]=19"
Jun 28, 03:06:17.920, [SSLManager], [Notice],,"** VisanetSSL2Client::DisposeConnection - Connection closed ssl2.vitalps.net:5003"
Jun 28, 03:06:17.920, [SSLManager], [Notice],,"CEngine::performSettlement - end"
Jun 28, 03:06:17.920, [SSLManager], [Notice],,"CEngine::processStoredTxn() - after 'ProcessTxn(*parms)"
Jun 28, 03:06:17.936, [SSLManager], [Notice],,"CEngine::processFinishedTxn() - "
Jun 28, 03:06:17.936, [SSLManager], [Debug],,"StoredTxn corresponding to FileNumber (10000000) deleted"
Jun 28, 03:06:17.936, [SSLManager], [Debug],,"Write ANS filenumber = 10000000"
Jun 28, 03:06:17.936, [SSLManager], [Debug],,"Write parms ANS filenumber = 10000000"
Jun 28, 03:06:17.936, [SSLManager], [Information],,"LastTxnNumber before increment is: 225"
Jun 28, 03:06:17.936, [SSLManager], [Information],,"LastTxnNumber after increment is: 226"
Jun 28, 03:06:17.936, [SSLManager], [Notice],,"Writing D:\Aloha\EDC\VISANET\TXN00226..."
Jun 28, 03:06:17.936, [SSLManager], [Notice],,"WriteAnswerFile(): WRITE: D:\Aloha\EDC\10000000.WRK"
Jun 28, 03:06:17.936, [], [Debug],,"m_nOfflineFileCount = 0"
Jun 28, 03:06:17.936, [], [Debug],,"# of offline txns = 0"
Jun 28, 03:06:17.936, [SSLManager], [Notice],,"WriteAnswerFile(): WROTE: D:\Aloha\EDC\10000000.WRK, size = 416"
Jun 28, 03:06:17.936, [SSLManager], [Notice],,"WriteAnswerFile(): RENAME D:\Aloha\EDC\10000000.ANS"
Jun 28, 03:06:17.951, [SSLManager], [Debug],,"CEngine::processNextStoredTxn() - END 10000000"
Jun 28, 03:06:18.623, [], [Error],,"Rejected Batch: [Record Type]=Detail, [Error Type]=Error in Batch (E), [Record Sequence Number]=0070, [Data Field Number]=19"
Jun 28, 03:06:18.623, [], [Notice],,"Deleted Back Office file (D:\Aloha\EDC\10000000.ANS) successfully"
Jun 28, 03:06:18.623, [], [Debug],,"SubmitTxn() - Response received. (0) 0 = success"
Jun 28, 03:10:25.967, [], [Debug],,"m_nOfflineFileCount = 0"
Jun 28, 03:10:25.967, [], [Debug],,"# of offline txns = 0"
Jun 28, 03:20:27.498, [], [Notice],,"ALOHABOH","User 2675 is being logged out due to inactivity."



Any ideas on what could be causing this?
 
I would check and see if all the bad transactions are coming from the same terminal. Usually from what i have seen, when you get a bad transaction it's because the software did not read the tracks cleanly and causes the batch to fail..either it sees an erraneous character of some sort.

If the cards that are failing are indeed from a specific terminal, i would try cleaning the MSR on the terminal.
 
I have not found a cause or solution for the problem you are having it occurs at some of my locations randomly. You don't have to call the processor because the system is telling you what transaction failed and then all you have to do is count down in EDC and then delete that transaction.
 
Thanks everyone for the replies. I actually found out that this is happening due to the "bad transaction" duplicating the "Transaction Sequence Number" and "Authorization Code" of a good transaction which is provided by the Merchant Processor. After finding this out, our options were to either escalate this up to Merchant Services and find out why these are duplicating or reinstall credit with a whole new account. We chose to reinstall credit with a brand new account on Friday and the client has not had a single issue since then.
 
We have been seeing this happen as well. Visanet as processor. I have escalated this issue with Visanet and all they can tell me is the transaction ID is a 10 digit number and all transactions are showing 0000000000 for the trans number except the failed transaction. They too have had me delete the trans and then force it in EDC.

MitchMan, you cant count the transactions, because a voided transaction or tip adjustment will make the count off. Unless you have a way of seeing the trans in the batch order directly to get the info?
 
Status
Not open for further replies.

Part and Inventory Search

Sponsor

Back
Top