Help get this topic noticed by sharing it on Twitter, Facebook, or email.

Operations ended abruptly

My process runs every 15 minutes to sync up data with SF. Every couple of days, I got the following errors when attempting upsert operations: "[SQLSTATE 01000] (Message 0) Cannot initialize the data source object of OLE DB provider "DBAmp.DBAmp" for linked server "SALESFORCE". [SQLSTATE 42000] (Error 7303) OLE DB provider "DBAmp.DBAmp" for linked server "SALESFORCE" returned message "Error 5103 : FAHttp::Send::WinHttpReceiveResponse Server Error". [SQLSTATE 01000] (Error 7412). The step failed." I could not replicate it at all. I am on DBAmp version 2.14.8. Any advice is greatly appreciated. TIA.
1 person has
this question
+1
Reply
  • That version of DBAMp does not give a very descriptive error message. In order to diagnose, can you upgrade your DBAmp install using the instructions found at http://www.forceamp.com/upgrade.htm

    Once you have upgraded, the error message for the issue will become more detailed and we will be able to diagnose the issue properly. Please post the detailed error message here once you have it.
  • (some HTML allowed)
    How does this make you feel?
    Add Image
    I'm

    e.g. kidding, amused, unsure, silly indifferent, undecided, unconcerned happy, confident, thankful, excited sad, anxious, confused, frustrated

  • I upgraded to the latest version as suggested. I pasted the error messages below. Any suggestion on possible reason(s) are greatly appreciated.

    Executed as user: SU-PRD\PRODDB_Agt.svc. ...] (Message 0) 14:30:05: Run the DBAmp.exe program.
    [SQLSTATE 01000] (Message 0) 14:30:05: DBAmp Bulk Operations. V2.16.1 (c) Copyright 2006-2013 forceAmp.com LLC
    [SQLSTATE 01000] (Message 0) 14:30:05: Deleting Id's using course__c_Load (PRODDB / salesforce backups) .
    [SQLSTATE 01000] (Message 0) 14:30:05: DBAmp is using the SQL Native Client.
    [SQLSTATE 01000] (Message 0) 14:30:06: SOAP Headers:
    [SQLSTATE 01000] (Message 0) 14:30:06: 0 rows read from SQL Table.
    [SQLSTATE 01000] (Message 0) 14:30:06: 0 rows successfully processed.
    [SQLSTATE 01000] (Message 0) --- Ending SF_BulkOps. Operation successful.
    [SQLSTATE 01000] (Message 0) --- Starting SF_BulkOps for course__c_Load
    [SQLSTATE 01000] (Message 0) 14:30:06: Run the DBAmp.exe program.
    [SQLSTATE 01000] (Message 0) 14:30:06: DBAmp Bulk Operations. V2.16.1 (c) Copyright 2006-2013 forceAmp.com LLC
    [SQLSTATE 01000] (Message 0) 14:30:06: Upserting Salesforce using course__c_Load (PRODDB / salesforce backups) .
    [SQLSTATE 01000] (Message 0) 14:30:06: DBAmp is using the SQL Native Client.
    [SQLSTATE 01000] (Message 0) 14:30:07: SOAP Headers:
    [SQLSTATE 01000] (Message 0) 14:30:07: 0 rows read from SQL Table.
    [SQLSTATE 01000] (Message 0) 14:30:07: 0 rows successfully processed.
    [SQLSTATE 01000] (Message 0) --- Ending SF_BulkOps. Operation successful.
    [SQLSTATE 01000] (Message 0) --- Starting SF_BulkOps for section__c_Load
    [SQLSTATE 01000] (Message 0) 14:30:14: Run the DBAmp.exe program.
    [SQLSTATE 01000] (Message 0) 14:30:14: DBAmp Bulk Operations. V2.16.1 (c) Copyright 2006-2013 forceAmp.com LLC
    [SQLSTATE 01000] (Message 0) 14:30:14: Deleting Id's using section__c_Load (PRODDB / salesforce backups) .
    [SQLSTATE 01000] (Message 0) 14:30:14: DBAmp is using the SQL Native Client.
    [SQLSTATE 01000] (Message 0) 14:30:19: SOAP Headers:
    [SQLSTATE 01000] (Message 0) 14:30:19: 0 rows read from SQL Table.
    [SQLSTATE 01000] (Message 0) 14:30:19: 0 rows successfully processed.
    [SQLSTATE 01000] (Message 0) --- Ending SF_BulkOps. Operation successful.
    [SQLSTATE 01000] (Message 0) --- Starting SF_BulkOps for section__c_Load
    [SQLSTATE 01000] (Message 0) 14:30:37: Run the DBAmp.exe program.
    [SQLSTATE 01000] (Message 0) 14:30:37: DBAmp Bulk Operations. V2.16.1 (c) Copyright 2006-2013 forceAmp.com LLC
    [SQLSTATE 01000] (Message 0) 14:30:37: Upserting Salesforce using section__c_Load (PRODDB / salesforce backups) .
    [SQLSTATE 01000] (Message 0) 14:30:37: DBAmp is using the SQL Native Client.
    [SQLSTATE 01000] (Message 0) 14:30:38: SOAP Headers:
    [SQLSTATE 01000] (Message 0) 14:30:42: 68 rows read from SQL Table.
    [SQLSTATE 01000] (Message 0) 14:30:42: 68 rows successfully processed.
    [SQLSTATE 01000] (Message 0) --- Ending SF_BulkOps. Operation successful.
    [SQLSTATE 01000] (Message 0) --- Starting SF_BulkOps for section__c_Load
    [SQLSTATE 01000] (Message 0) 14:30:44: Run the DBAmp.exe program.
    [SQLSTATE 01000] (Message 0) 14:30:44: DBAmp Bulk Operations. V2.16.1 (c) Copyright 2006-2013 forceAmp.com LLC
    [SQLSTATE 01000] (Message 0) 14:30:44: Deleting Id's using section__c_Load (PRODDB / salesforce backups) .
    [SQLSTATE 01000] (Message 0) 14:30:44: DBAmp is using the SQL Native Client.
    [SQLSTATE 01000] (Message 0) 14:30:45: SOAP Headers:
    [SQLSTATE 01000] (Message 0) 14:30:45: 0 rows read from SQL Table.
    [SQLSTATE 01000] (Message 0) 14:30:45: 0 rows successfully processed.
    [SQLSTATE 01000] (Message 0) --- Ending SF_BulkOps. Operation successful.
    [SQLSTATE 01000] (Message 0) --- Starting SF_BulkOps for section__c_Load
    [SQLSTATE 01000] (Message 0) 14:30:58: Run the DBAmp.exe program.
    [SQLSTATE 01000] (Message 0) 14:30:58: DBAmp Bulk Operations. V2.16.1 (c) Copyright 2006-2013 forceAmp.com LLC
    [SQLSTATE 01000] (Message 0) 14:30:58: Upserting Salesforce using section__c_Load (PRODDB / salesforce backups) .
    [SQLSTATE 01000] (Message 0) 14:30:58: DBAmp is using the SQL Native Client.
    [SQLSTATE 01000] (Message... The step failed.
  • (some HTML allowed)
    How does this make you feel?
    Add Image
    I'm

    e.g. kidding, amused, unsure, silly indifferent, undecided, unconcerned happy, confident, thankful, excited sad, anxious, confused, frustrated

  • The message output is truncated in the job history and therefore we cannot see the actual error message.

    Modify the job step using the Advanced Tab and capture the job output to either a file or table. Then rerun the job (if you are able to without duplicating records) and forward me the complete message output.
  • (some HTML allowed)
    How does this make you feel?
    Add Image
    I'm

    e.g. kidding, amused, unsure, silly indifferent, undecided, unconcerned happy, confident, thankful, excited sad, anxious, confused, frustrated

  • Here is, hopefully, the complete message output:

    --- Starting SF_BulkOps for section_section_attribute__c_Load [SQLSTATE 01000]
    15:03:08: Run the DBAmp.exe program. [SQLSTATE 01000]
    15:03:08: DBAmp Bulk Operations. V2.16.1 (c) Copyright 2006-2013 forceAmp.com LLC [SQLSTATE 01000]
    15:03:08: Deleting Id's using section_section_attribute__c_Load (GSB-LEV / salesforce backups) . [SQLSTATE 01000]
    15:03:09: DBAmp is using the SQL Native Client. [SQLSTATE 01000]
    15:03:09: SOAP Headers: [SQLSTATE 01000]
    15:03:09: 0 rows read from SQL Table. [SQLSTATE 01000]
    15:03:09: 0 rows successfully processed. [SQLSTATE 01000]
    --- Ending SF_BulkOps. Operation successful. [SQLSTATE 01000]
    --- Starting SF_BulkOps for section_section_attribute__c_Load [SQLSTATE 01000]
    15:03:11: Run the DBAmp.exe program. [SQLSTATE 01000]
    15:03:11: DBAmp Bulk Operations. V2.16.1 (c) Copyright 2006-2013 forceAmp.com LLC [SQLSTATE 01000]
    15:03:11: Upserting Salesforce using section_section_attribute__c_Load (GSB-LEV / salesforce backups) . [SQLSTATE 01000]
    15:03:11: DBAmp is using the SQL Native Client. [SQLSTATE 01000]
    15:03:11: SOAP Headers: [SQLSTATE 01000]
    15:03:11: 0 rows read from SQL Table. [SQLSTATE 01000]
    15:03:11: 0 rows successfully processed. [SQLSTATE 01000]
    --- Ending SF_BulkOps. Operation successful. [SQLSTATE 01000]
    Job 'Sync - Force - Course' : Step 2, 's_forcesync_all_course' : Began Executing 2013-03-07 15:15:00

    Msg 7350, Sev 16, State 2, Line 2 : Cannot get the column information from OLE DB provider "DBAmp.DBAmp" for linked server "SALESFORCE". [SQLSTATE 42000]
    Msg 7412, Sev 16, State 1, Line 2 : OLE DB provider "DBAmp.DBAmp" for linked server "SALESFORCE" returned message "Error 5103 : FAHttp::Send::WinHttpSendRequest Win32Error:: The operation timed out ". [SQLSTATE 01000]
  • (some HTML allowed)
    How does this make you feel?
    Add Image
    I'm

    e.g. kidding, amused, unsure, silly indifferent, undecided, unconcerned happy, confident, thankful, excited sad, anxious, confused, frustrated

  • It looks like salesforce is taking a long time to return the metadata for one of the tables and DBAmp is timing out waiting for a response.

    Run the DBAmp Configuration Program on the server, menu choice Registry Options and set the Receive Timeout value to 2400.

    Then let's see if the issue still occurs.
  • (some HTML allowed)
    How does this make you feel?
    Add Image
    I'm

    e.g. kidding, amused, unsure, silly indifferent, undecided, unconcerned happy, confident, thankful, excited sad, anxious, confused, frustrated

  • The entire operations usually take less than 2 minutes. But will try to see if the behavior goes away.
  • (some HTML allowed)
    How does this make you feel?
    Add Image
    I'm

    e.g. kidding, amused, unsure, silly indifferent, undecided, unconcerned happy, confident, thankful, excited sad, anxious, confused, frustrated

  • What is the total running time of the job when it fails with this error message?
  • (some HTML allowed)
    How does this make you feel?
    Add Image
    I'm

    e.g. sad, anxious, confused, frustrated kidding, amused, unsure, silly indifferent, undecided, unconcerned happy, confident, thankful, excited

  • Total running time of the job usually is less than 2 minutes. It was at 41 sec when it failed.
  • (some HTML allowed)
    How does this make you feel?
    Add Image
    I'm

    e.g. sad, anxious, confused, frustrated kidding, amused, unsure, silly indifferent, undecided, unconcerned happy, confident, thankful, excited

  • I'd like to schedule a web meeting to review this. The messages you sent do not line up with the job time.

    Please send me an email with some date / times that would work for you next week.
  • (some HTML allowed)
    How does this make you feel?
    Add Image
    I'm

    e.g. kidding, amused, unsure, silly indifferent, undecided, unconcerned happy, confident, thankful, excited sad, anxious, confused, frustrated

  • Was there any resolution to this issue? I have a similar issue where this just all of a sudden started to happen
  • (some HTML allowed)
    How does this make you feel?
    Add Image
    I'm

    e.g. kidding, amused, unsure, silly indifferent, undecided, unconcerned happy, confident, thankful, excited sad, anxious, confused, frustrated