function readOnly(count){ }
Starting November 20, the site will be set to read-only. On December 4, 2023,
forum discussions will move to the Trailblazer Community.
+ Start a Discussion
bkradminbkradmin 

NPSP Trouble: Payments not being automatically created

Normally, after an Opportunity is created, a Payment is automatically created with it. We rely heavily on this function. For some reason, this stopped working spontaneously. No settings were changed to my knowledge. Can anyone suggest where we can look? 

mbhardwajmbhardwaj
You must be using something custom to create the Payments. Can you check any triggers are there on Opportunity.

Also turn on the debugs and see if you can find any errors recorded there.
bkradminbkradmin

Still can't figure it out. I did turn on logs, and I also turned on logs for a sandbox I have where it is still working. Here are both logs, for comparison. 

 

SANDBOX - STILL WORKING:

24.0 APEX_CODE,DEBUG;APEX_PROFILING,INFO;CALLOUT,INFO;DB,INFO;SYSTEM,DEBUG;VALIDATION,INFO;VISUALFORCE,INFO;WORKFLOW,INFO
15:33:59.040 (40318000)|ENTERING_MANAGED_PKG|npe03
15:33:59.221 (221616000)|ENTERING_MANAGED_PKG|npe01
15:33:59.318 (318892000)|ENTERING_MANAGED_PKG|npo02
15:33:59.332 (332534000)|ENTERING_MANAGED_PKG|npe01
15:33:59.338 (338375000)|DML_BEGIN|[164]|Op:Insert|Type:npe01__OppPayment__c|Rows:1
15:33:59.399 (399891000)|ENTERING_MANAGED_PKG|npe03
15:33:59.425 (425101000)|ENTERING_MANAGED_PKG|npo02
15:33:59.425 (425491000)|ENTERING_MANAGED_PKG|npe01
15:33:59.430 (430362000)|SOQL_EXECUTE_BEGIN|[107]|Aggregations:1|select id, CloseDate, Amount, isClosed, isWon, payments_made__c, (SELECT id, Paid__c, Payment_Amount__c, Payment_Date__c, scheduled_date__c from Opportunity.OppPayment__r) from Opportunity WHERE id in :newOpps
15:33:59.439 (439603000)|SOQL_EXECUTE_END|[107]|Rows:1
15:33:59.440 (440630000)|ENTERING_MANAGED_PKG|npe03
15:33:59.445 (445592000)|SOQL_EXECUTE_BEGIN|[91]|Aggregations:0|select count() from Recurring_Donation__c where (Open_Ended_Status__c = :tmpVar1 and id = :tmpVar2)
15:33:59.450 (450289000)|SOQL_EXECUTE_END|[91]|Rows:0
15:33:59.450 (450700000)|DML_END|[164]
15:33:59.454 (454931000)|ENTERING_MANAGED_PKG|npe01
15:33:59.458 (458709000)|ENTERING_MANAGED_PKG|npe03
15:33:59.462 (462052000)|ENTERING_MANAGED_PKG|npo02
15:33:59.467 (467375000)|CODE_UNIT_STARTED|[EXTERNAL]|Workflow:Opportunity
15:33:59.488 (488727000)|WF_RULE_EVAL_BEGIN|Assignment
15:33:59.488 (488762000)|WF_RULE_EVAL_BEGIN|Response
15:33:59.488 (488778000)|WF_RULE_EVAL_BEGIN|Workflow
15:33:59.488 (488817000)|WF_CRITERIA_BEGIN|[Donation: asdfa 006M0000005ec7I]|Mark as received|01QE0000000U02m|ON_CREATE_OR_TRIGGERING_UPDATE
15:33:59.488 (488862000)|WF_RULE_FILTER|[Donation : Remaining Balance less or equal 0]
15:33:59.489 (489490000)|WF_RULE_EVAL_VALUE|0.00
15:33:59.489 (489502000)|WF_CRITERIA_END|true
15:33:59.489 (489936000)|WF_CRITERIA_BEGIN|[Donation: asdfa 006M0000005ec7I]|Opp Name|01QE0000000U02n|ON_ALL_CHANGES
15:33:59.489 (489969000)|WF_RULE_FILTER|[Donation : Donation Name not equal to null]
15:33:59.489 (489983000)|WF_RULE_EVAL_VALUE|asdfa
15:33:59.489 (489990000)|WF_CRITERIA_END|true
15:33:59.490 (490014000)|WF_SPOOL_ACTION_BEGIN|Workflow
15:33:59.493 (493930000)|WF_FIELD_UPDATE|[Donation: asdfa 006M0000005ec7I]|Field:Donation: Donation Name|Value:Smith Household- 2013-07-04 19:33:59Z- $1000|Id=04YE0000000U9K0|CurrentRule:Opp Name (Id=01QE0000000U02n)
15:33:59.493 (493966000)|WF_ACTION| Field Update: 2;
15:33:59.493 (493984000)|WF_RULE_EVAL_BEGIN|Escalation
15:33:59.493 (493994000)|WF_RULE_EVAL_END
15:33:59.496 (496098000)|ENTERING_MANAGED_PKG|npe03
15:33:59.517 (517783000)|ENTERING_MANAGED_PKG|npo02
15:33:59.520 (520202000)|ENTERING_MANAGED_PKG|npe01
15:33:59.523 (523522000)|SOQL_EXECUTE_BEGIN|[107]|Aggregations:1|select id, CloseDate, Amount, isClosed, isWon, payments_made__c, (SELECT id, Paid__c, Payment_Amount__c, Payment_Date__c, scheduled_date__c from Opportunity.OppPayment__r) from Opportunity WHERE id in :newOpps
15:33:59.531 (531989000)|SOQL_EXECUTE_END|[107]|Rows:1
15:33:59.534 (534987000)|ENTERING_MANAGED_PKG|npe03
15:33:59.537 (537569000)|SOQL_EXECUTE_BEGIN|[91]|Aggregations:0|select count() from Recurring_Donation__c where (Open_Ended_Status__c = :tmpVar1 and id = :tmpVar2)
15:33:59.539 (539524000)|SOQL_EXECUTE_END|[91]|Rows:0
15:33:59.541 (541767000)|WF_ACTIONS_END| Field Update: 2;
15:33:59.541 (541780000)|CODE_UNIT_FINISHED|Workflow:Opportunity
15:33:59.562 (562984000)|ENTERING_MANAGED_PKG|CRMfusionAPR
15:33:59.638 (638471000)|ENTERING_MANAGED_PKG|awduplicate2
15:33:59.727 (727574000)|SOQL_EXECUTE_BEGIN|[9]|Aggregations:0|Select Id, awduplicate2__AWDisableDuplicateCheck__c FROM User WHERE Id ='005E0000001xgl7IAA'
15:33:59.730 (730748000)|SOQL_EXECUTE_END|[9]|Rows:1
15:33:59.789 (789284000)|ENTERING_MANAGED_PKG|awduplicate2
15:33:59.791 (791737000)|SOQL_EXECUTE_BEGIN|[9]|Aggregations:0|Select Id, awduplicate2__AWDisableDuplicateCheck__c FROM User WHERE Id ='005E0000001xgl7IAA'
15:33:59.795 (795785000)|SOQL_EXECUTE_END|[9]|Rows:1
15:33:59.798 (798355000)|CODE_UNIT_STARTED|[EXTERNAL]|Workflow:Account
15:33:59.805 (805854000)|WF_RULE_EVAL_BEGIN|Assignment
15:33:59.805 (805877000)|WF_RULE_EVAL_BEGIN|Response
15:33:59.805 (805887000)|WF_RULE_EVAL_BEGIN|Workflow
15:33:59.805 (805921000)|WF_CRITERIA_BEGIN|[Account: Smith Household 001M000000QzlFL]|Recategorize Account Type|01QE0000000U65k|ON_ALL_CHANGES
15:33:59.805 (805954000)|WF_RULE_FILTER|[Account : Account Record Type equals Household, Standard Organization]
15:33:59.805 (805976000)|WF_RULE_EVAL_VALUE|012E0000000MoY8
15:33:59.805 (805982000)|WF_CRITERIA_END|false
15:33:59.805 (805996000)|WF_CRITERIA_BEGIN|[Account: Smith Household 001M000000QzlFL]|Rename Ontario to ON|01QE0000000U8nt|ON_CREATE_OR_TRIGGERING_UPDATE
15:33:59.806 (806110000)|WF_RULE_FILTER|[Account : Billing State/Province equals Ontario] OR
 [Account : Billing State/Province equals ONTARIO] OR
 [Account : Billing State/Province equals On]
15:33:59.806 (806134000)|WF_RULE_EVAL_VALUE|
15:33:59.806 (806139000)|WF_RULE_EVAL_VALUE|
15:33:59.806 (806143000)|WF_RULE_EVAL_VALUE|
15:33:59.806 (806148000)|WF_CRITERIA_END|false
15:33:59.806 (806166000)|WF_CRITERIA_BEGIN|[Account: Smith Household 001M000000QzlFL]|Last 6 fields annual|01QE0000000U02V|ON_ALL_CHANGES
15:33:59.806 (806190000)|WF_RULE_FILTER|[Account : Expenses Monthly greater than 0]
15:33:59.807 (807311000)|WF_RULE_EVAL_VALUE|0
15:33:59.807 (807320000)|WF_CRITERIA_END|false
15:33:59.807 (807340000)|WF_CRITERIA_BEGIN|[Account: Smith Household 001M000000QzlFL]|Monthly to Yearly|01QE0000000U02W|ON_ALL_CHANGES
15:33:59.807 (807723000)|WF_FORMULA|Formula:Expenses_Monthly__c>0|Values:Expenses_Monthly__c=0
15:33:59.807 (807732000)|WF_CRITERIA_END|false
15:33:59.807 (807751000)|WF_CRITERIA_BEGIN|[Account: Smith Household 001M000000QzlFL]|Rename Household Accounts with Household|01QE0000000U82Y|ON_CREATE_ONLY
15:33:59.807 (807759000)|WF_RULE_NOT_EVALUATED
15:33:59.807 (807769000)|WF_CRITERIA_BEGIN|[Account: Smith Household 001M000000QzlFL]|Categorize Charitable Orgs|01QE0000000U6Rg|ON_CREATE_OR_TRIGGERING_UPDATE
15:33:59.807 (807808000)|WF_RULE_FILTER|[Account : BN # not equal to null] 
AND [Account : Account Record Type equals Foundation/Trust]
15:33:59.807 (807817000)|WF_RULE_EVAL_VALUE|
15:33:59.807 (807821000)|WF_CRITERIA_END|false
15:33:59.807 (807833000)|WF_CRITERIA_BEGIN|[Account: Smith Household 001M000000QzlFL]|Random Income|01QE0000000U02X|ON_ALL_CHANGES
15:33:59.807 (807851000)|WF_RULE_FILTER|[Account : Income Annually greater than 0]
15:33:59.808 (808778000)|WF_RULE_EVAL_VALUE|0
15:33:59.808 (808788000)|WF_CRITERIA_END|false
15:33:59.808 (808806000)|WF_SPOOL_ACTION_BEGIN|Workflow
15:33:59.808 (808815000)|WF_ACTION| None
15:33:59.808 (808823000)|WF_RULE_EVAL_BEGIN|Escalation
15:33:59.808 (808828000)|WF_RULE_EVAL_END
15:33:59.808 (808893000)|WF_ACTIONS_END| None
15:33:59.808 (808900000)|CODE_UNIT_FINISHED|Workflow:Account

 PRODUCTION: NOT WORKING:

 

24.0 APEX_CODE,DEBUG;APEX_PROFILING,INFO;CALLOUT,INFO;DB,INFO;SYSTEM,DEBUG;VALIDATION,INFO;VISUALFORCE,INFO;WORKFLOW,INFO
15:31:32.060 (60130000)|ENTERING_MANAGED_PKG|npe03
15:31:32.098 (98134000)|ENTERING_MANAGED_PKG|npe01
15:31:32.187 (187430000)|ENTERING_MANAGED_PKG|npo02
15:31:32.319 (319733000)|ENTERING_MANAGED_PKG|npe01
15:31:32.351 (351541000)|DML_BEGIN|[164]|Op:Insert|Type:npe01__OppPayment__c|Rows:1
15:31:32.382 (382736000)|DML_END|[164]
15:31:32.389 (389676000)|ENTERING_MANAGED_PKG|npe01
15:31:32.392 (392844000)|ENTERING_MANAGED_PKG|npe03
15:31:32.398 (398366000)|ENTERING_MANAGED_PKG|npo02
15:31:32.420 (420433000)|CODE_UNIT_STARTED|[EXTERNAL]|Workflow:Opportunity
15:31:32.440 (440823000)|WF_RULE_EVAL_BEGIN|Assignment
15:31:32.440 (440846000)|WF_RULE_EVAL_BEGIN|Response
15:31:32.440 (440855000)|WF_RULE_EVAL_BEGIN|Workflow
15:31:32.440 (440880000)|WF_CRITERIA_BEGIN|[Donation: aslkdfj 006E000000CRU8H]|Mark as received|01QE0000000U02m|ON_CREATE_OR_TRIGGERING_UPDATE
15:31:32.445 (445557000)|WF_RULE_FILTER|[Donation : Remaining Balance less or equal 0]
15:31:32.446 (446107000)|WF_RULE_EVAL_VALUE|1000
15:31:32.446 (446118000)|WF_CRITERIA_END|false
15:31:32.446 (446137000)|WF_CRITERIA_BEGIN|[Donation: aslkdfj 006E000000CRU8H]|Opp Name|01QE0000000U02n|ON_ALL_CHANGES
15:31:32.446 (446164000)|WF_RULE_FILTER|[Donation : Donation Name not equal to null]
15:31:32.446 (446174000)|WF_RULE_EVAL_VALUE|aslkdfj
15:31:32.446 (446179000)|WF_CRITERIA_END|true
15:31:32.447 (447087000)|WF_SPOOL_ACTION_BEGIN|Workflow
15:31:32.448 (448019000)|WF_FIELD_UPDATE|[Donation: aslkdfj 006E000000CRU8H]|Field:Donation: Donation Name|Value:Feintuch Household- 2013-07-04 19:31:33Z- $1000|Id=04YE0000000U9K0|CurrentRule:Opp Name (Id=01QE0000000U02n)
15:31:32.448 (448053000)|WF_ACTION| Field Update: 1;
15:31:32.448 (448064000)|WF_RULE_EVAL_BEGIN|Escalation
15:31:32.448 (448069000)|WF_RULE_EVAL_END
15:31:32.449 (449889000)|ENTERING_MANAGED_PKG|npe03
15:31:32.479 (479892000)|ENTERING_MANAGED_PKG|npo02
15:31:32.481 (481782000)|ENTERING_MANAGED_PKG|npe01
15:31:32.485 (485844000)|SOQL_EXECUTE_BEGIN|[107]|Aggregations:1|select id, CloseDate, Amount, isClosed, isWon, payments_made__c, (SELECT id, Paid__c, Payment_Amount__c, Payment_Date__c, scheduled_date__c from Opportunity.OppPayment__r) from Opportunity WHERE id in :newOpps
15:31:32.492 (492543000)|SOQL_EXECUTE_END|[107]|Rows:1
15:31:32.494 (494787000)|ENTERING_MANAGED_PKG|npe03
15:31:32.510 (510729000)|SOQL_EXECUTE_BEGIN|[91]|Aggregations:0|select count() from Recurring_Donation__c where (Open_Ended_Status__c = :tmpVar1 and id = :tmpVar2)
15:31:32.516 (516579000)|SOQL_EXECUTE_END|[91]|Rows:0
15:31:32.519 (519321000)|WF_ACTIONS_END| Field Update: 1;
15:31:32.519 (519330000)|CODE_UNIT_FINISHED|Workflow:Opportunity
15:31:32.538 (538714000)|ENTERING_MANAGED_PKG|CRMfusionAPR
15:31:32.575 (575082000)|ENTERING_MANAGED_PKG|awduplicate2
15:31:32.636 (636501000)|SOQL_EXECUTE_BEGIN|[9]|Aggregations:0|Select Id, awduplicate2__AWDisableDuplicateCheck__c FROM User WHERE Id ='005E0000001xgl7IAA'
15:31:32.640 (640876000)|SOQL_EXECUTE_END|[9]|Rows:1
15:31:32.697 (697656000)|ENTERING_MANAGED_PKG|awduplicate2
15:31:32.699 (699701000)|SOQL_EXECUTE_BEGIN|[9]|Aggregations:0|Select Id, awduplicate2__AWDisableDuplicateCheck__c FROM User WHERE Id ='005E0000001xgl7IAA'
15:31:32.703 (703321000)|SOQL_EXECUTE_END|[9]|Rows:1
15:31:32.705 (705542000)|CODE_UNIT_STARTED|[EXTERNAL]|Workflow:Account
15:31:32.713 (713822000)|WF_RULE_EVAL_BEGIN|Assignment
15:31:32.713 (713847000)|WF_RULE_EVAL_BEGIN|Response
15:31:32.713 (713860000)|WF_RULE_EVAL_BEGIN|Workflow
15:31:32.713 (713897000)|WF_CRITERIA_BEGIN|[Account: Feintuch Household 001E000000c2POd]|Recategorize Account Type|01QE0000000U65k|ON_ALL_CHANGES
15:31:32.716 (716190000)|WF_RULE_FILTER|[Account : Account Record Type equals Household, Standard Organization]
15:31:32.716 (716225000)|WF_RULE_EVAL_VALUE|012E0000000MoY8
15:31:32.716 (716234000)|WF_CRITERIA_END|false
15:31:32.716 (716256000)|WF_CRITERIA_BEGIN|[Account: Feintuch Household 001E000000c2POd]|Rename Ontario to ON|01QE0000000U8nt|ON_CREATE_OR_TRIGGERING_UPDATE
15:31:32.716 (716329000)|WF_RULE_NOT_EVALUATED
15:31:32.716 (716355000)|WF_CRITERIA_BEGIN|[Account: Feintuch Household 001E000000c2POd]|Last 6 fields annual|01QE0000000U02V|ON_ALL_CHANGES
15:31:32.716 (716478000)|WF_RULE_FILTER|[Account : Expenses Monthly greater than 0]
15:31:32.717 (717644000)|WF_RULE_EVAL_VALUE|0
15:31:32.717 (717652000)|WF_CRITERIA_END|false
15:31:32.717 (717673000)|WF_CRITERIA_BEGIN|[Account: Feintuch Household 001E000000c2POd]|Monthly to Yearly|01QE0000000U02W|ON_ALL_CHANGES
15:31:32.718 (718138000)|WF_FORMULA|Formula:Expenses_Monthly__c>0|Values:Expenses_Monthly__c=0
15:31:32.718 (718148000)|WF_CRITERIA_END|false
15:31:32.718 (718167000)|WF_CRITERIA_BEGIN|[Account: Feintuch Household 001E000000c2POd]|Rename Household Accounts with Household|01QE0000000U82Y|ON_CREATE_ONLY
15:31:32.718 (718174000)|WF_RULE_NOT_EVALUATED
15:31:32.718 (718185000)|WF_CRITERIA_BEGIN|[Account: Feintuch Household 001E000000c2POd]|Categorize Charitable Orgs|01QE0000000U6Rg|ON_CREATE_OR_TRIGGERING_UPDATE
15:31:32.718 (718239000)|WF_RULE_FILTER|[Account : BN # not equal to null] 
AND [Account : Account Record Type equals Foundation/Trust]
15:31:32.718 (718249000)|WF_RULE_EVAL_VALUE|
15:31:32.718 (718252000)|WF_CRITERIA_END|false
15:31:32.718 (718266000)|WF_CRITERIA_BEGIN|[Account: Feintuch Household 001E000000c2POd]|Random Income|01QE0000000U02X|ON_ALL_CHANGES
15:31:32.718 (718351000)|WF_RULE_FILTER|[Account : Income Annually greater than 0]
15:31:32.719 (719079000)|WF_RULE_EVAL_VALUE|0
15:31:32.719 (719088000)|WF_CRITERIA_END|false
15:31:32.719 (719103000)|WF_SPOOL_ACTION_BEGIN|Workflow
15:31:32.719 (719111000)|WF_ACTION| None
15:31:32.719 (719118000)|WF_RULE_EVAL_BEGIN|Escalation
15:31:32.719 (719122000)|WF_RULE_EVAL_END
15:31:32.719 (719199000)|WF_ACTIONS_END| None
15:31:32.719 (719207000)|CODE_UNIT_FINISHED|Workflow:Account

 

mbhardwajmbhardwaj
The log looks fine. You can see the payment record is being inserted and there is no issue with that:

15:31:32.319 (319733000)|ENTERING_MANAGED_PKG|npe01
15:31:32.351 (351541000)|DML_BEGIN|[164]|Op:Insert|Type:npe01__OppPayment__c|Rows:1
15:31:32.382 (382736000)|DML_END|[164]

Do you have necessary access to view the record?

Also, was this working earlier and stopped working now?
Himanshu Singh 192Himanshu Singh 192

Hi You have check the npsp setting for payments:

You can follow this Link (https://help.salesforce.com/s/articleView?id=sfdo.NPSP_Configure_Opportunity_Payments.htm&type=5)
Thank You