2026-07-16 09:15:30,068 - [124740] - src.utils.log - INFO - Checking if all rows exist in parent table or not - __SPLIT__
2026-07-16 09:15:30,136 - [124740] - src.utils.log - INFO - 📥 Inserting into ServiceCore.WorkOrderAutoGenerationPublishHistory: 1 rows in batches of 25000 (Thread: AnyIO worker thread) - __SPLIT__
2026-07-16 09:15:30,501 - [124740] - src.utils.log - INFO - 📤 Inserting batch 1/1 (0 to 1) into ServiceCore.WorkOrderAutoGenerationPublishHistory - __SPLIT__
2026-07-16 09:15:31,490 - [124740] - src.utils.log - INFO - ✅ All 1 rows inserted successfully into ServiceCore.WorkOrderAutoGenerationPublishHistory in 1 batches - __SPLIT__
2026-07-16 09:15:31,552 - [124740] - src.utils.log - INFO - 🔍 Fetching data:
SELECT
WorkOrderAutoGenerationPublishHistoryId,
WorkOrderNo,
ServiceSetupId
FROM ServiceCore.WorkOrderAutoGenerationPublishHistory
WHERE ServiceSetupId = 150664
AND WorkOrderNo = '1840647'
AND GenerateWorkOrderHistoryId = 124740;
... (Thread: AnyIO worker thread) - __SPLIT__
2026-07-16 09:15:32,017 - [124740] - src.utils.log - INFO - ✅ Fetched 1 rows - __SPLIT__
2026-07-16 09:15:32,091 - [124740] - src.utils.log - INFO - Sequential Insertion in work order tables begin - __SPLIT__
2026-07-16 09:15:32,321 - [124740] - src.utils.log - INFO - Checking if all rows exist in parent table or not - __SPLIT__
2026-07-16 09:15:32,398 - [124740] - src.utils.log - INFO - 📥 Inserting into ServiceCore.WorkOrderServices: 1 rows in batches of 25000 (Thread: AnyIO worker thread) - __SPLIT__
2026-07-16 09:15:32,756 - [124740] - src.utils.log - INFO - 📤 Inserting batch 1/1 (0 to 1) into ServiceCore.WorkOrderServices - __SPLIT__
2026-07-16 09:15:33,845 - [124740] - src.utils.log - INFO - ✅ All 1 rows inserted successfully into ServiceCore.WorkOrderServices in 1 batches - __SPLIT__
2026-07-16 09:15:33,911 - [124740] - src.utils.log - INFO - 📥 Empty dataframe of ServiceAuto.WorkOrderAppliedDiscount: - __SPLIT__
2026-07-16 09:15:33,970 - [124740] - src.utils.log - INFO - 📥 Empty dataframe of ServiceCore.WorkOrderSalesPersonCommission: - __SPLIT__
2026-07-16 09:15:34,029 - [124740] - src.utils.log - INFO - 📥 Empty dataframe of ServiceAuto.WorkOrderCommissionAdjustment: - __SPLIT__
2026-07-16 09:15:34,096 - [124740] - src.utils.log - INFO - Checking if all rows exist in parent table or not - __SPLIT__
2026-07-16 09:15:34,208 - [124740] - src.utils.log - INFO - 📥 Inserting into ServiceCore.WorkOrderCrew: 1 rows in batches of 25000 (Thread: AnyIO worker thread) - __SPLIT__
2026-07-16 09:15:34,563 - [124740] - src.utils.log - INFO - 📤 Inserting batch 1/1 (0 to 1) into ServiceCore.WorkOrderCrew - __SPLIT__
2026-07-16 09:15:35,581 - [124740] - src.utils.log - INFO - ✅ All 1 rows inserted successfully into ServiceCore.WorkOrderCrew in 1 batches - __SPLIT__
2026-07-16 09:15:35,653 - [124740] - src.utils.log - INFO - 📥 Empty dataframe of ServiceCore.WorkorderSourceMapping: - __SPLIT__
2026-07-16 09:15:35,720 - [124740] - src.utils.log - INFO - 📥 Empty dataframe of CRM.LeadNote: - __SPLIT__
2026-07-16 09:15:35,788 - [124740] - src.utils.log - INFO - Checking if all rows exist in parent table or not - __SPLIT__
2026-07-16 09:15:35,857 - [124740] - src.utils.log - INFO - 📥 Inserting into ServiceCore.WorkOrderAutoGenerationPublishServices: 1 rows in batches of 25000 (Thread: AnyIO worker thread) - __SPLIT__
2026-07-16 09:15:36,218 - [124740] - src.utils.log - INFO - 📤 Inserting batch 1/1 (0 to 1) into ServiceCore.WorkOrderAutoGenerationPublishServices - __SPLIT__
2026-07-16 09:15:37,217 - [124740] - src.utils.log - INFO - ✅ All 1 rows inserted successfully into ServiceCore.WorkOrderAutoGenerationPublishServices in 1 batches - __SPLIT__
2026-07-16 09:15:37,293 - [124740] - src.utils.log - INFO - 🔍 Fetching data: SELECT ss.ServiceSetupId as SetupId, ss.FrequencyScheduleId as setup_frequency_schedule_id, ss.AccountNumber, ss.CompanyId,
ss.BillingLocationId, ss.ServiceLocationId, ss.TaxSysName, ss.TermId, ss.TaxPercent, ss.PoNumber, ss.IsTaxExempt,
ss.DisplayServiceAsSeparateLineItem, ss.GenerateInvoice, ss.IsGenerateInvoiceforInitalSetup,
ss.IsGenerateInvoiceforInitalSetupBilling, ss.IsBilling, t.NetDueIn, ptm.PaymentType, ssb.*
FROM ServiceCore.ServiceSetup ss LEFT JOIN ServiceCore.ServiceSetupBilling ssb
ON ss.ServiceSetupId = ssb.ServiceSetupId LEFT JOIN Billing.PaymentTypeMaster ptm ON
ptm.PaymentTypeMasterId = ssb.PaymentTypeMasterId left join Billing.Term t on ss.TermId = t.TermId
WHERE ss.ServiceSetupId = 150664... (Thread: AnyIO worker thread) - __SPLIT__
2026-07-16 09:15:37,626 - [124740] - src.utils.log - INFO - ✅ Fetched 1 rows - __SPLIT__
2026-07-16 09:15:37,698 - [124740] - src.utils.log - INFO - Size of Transaction: 1 - __SPLIT__
2026-07-16 09:15:37,764 - [124740] - src.utils.log - INFO - 📥 Inserting into Billing.Transaction (skip triggers): 1 rows in batches of 25000 (Thread: AnyIO worker thread) - __SPLIT__
2026-07-16 09:15:38,249 - [124740] - src.utils.log - INFO - 📤 Inserting batch 1/1 (0 to 1) into Billing.Transaction (triggers skipped) - __SPLIT__
2026-07-16 09:15:39,307 - [124740] - src.utils.log - INFO - ✅ All 1 rows inserted successfully into Billing.Transaction in 1 batches (triggers skipped) - __SPLIT__
2026-07-16 09:15:39,512 - [124740] - src.utils.log - INFO - 🔄 Triggers re-enabled for session - __SPLIT__
2026-07-16 09:15:39,581 - [124740] - src.utils.log - INFO - 🔍 Fetching data: SELECT TransactionId, ModifiedBy, TransactionDate as InvoiceDate from Billing.[Transaction] t WHERE t.ModifiedBy = 12345678910 and t.CompanyId = 133 AND
t.TransactionType ='Invoice' AND t.CreatedDate = '2026-07-16 05:15:37.694';... (Thread: AnyIO worker thread) - __SPLIT__
2026-07-16 09:15:44,924 - [124740] - src.utils.log - INFO - ✅ Fetched 1 rows - __SPLIT__
2026-07-16 09:15:45,001 - [124740] - src.utils.log - INFO - 🔍 Fetching data: SELECT * from ServiceCore.ServiceSetupSubWorkOrder ssswo WHERE
ssswo.ServiceSetupId = 150664;... (Thread: AnyIO worker thread) - __SPLIT__
2026-07-16 09:15:45,339 - [124740] - src.utils.log - INFO - ✅ Fetched 0 rows - __SPLIT__
2026-07-16 09:15:45,468 - [124740] - src.utils.log - INFO - 📝 Executing:
UPDATE Billing.[Transaction]
SET ModifiedBy = NULL
WHERE ModifiedBy = 12345678910
AND CreatedDate = '2026-07-16 05:15:37.694';
... (Thread: ThreadPoolExecutor-1_0) - __SPLIT__
2026-07-16 09:15:46,362 - [124740] - src.utils.log - INFO - ✅ Command executed successfully - __SPLIT__
2026-07-16 09:15:46,439 - [124740] - src.utils.log - INFO - Checking if all rows exist in parent table or not - __SPLIT__
2026-07-16 09:15:46,508 - [124740] - src.utils.log - INFO - 📥 Inserting into Billing.Invoice: 1 rows in batches of 25000 (Thread: AnyIO worker thread) - __SPLIT__
2026-07-16 09:15:46,864 - [124740] - src.utils.log - INFO - 📤 Inserting batch 1/1 (0 to 1) into Billing.Invoice - __SPLIT__
2026-07-16 09:15:47,914 - [124740] - src.utils.log - INFO - ✅ All 1 rows inserted successfully into Billing.Invoice in 1 batches - __SPLIT__
2026-07-16 09:15:47,983 - [124740] - src.utils.log - INFO - 🔍 Fetching data: SELECT InvoiceId, WorkOrderNo FROM Billing.Invoice i WHERE i.WorkOrderNo = '1427312'... (Thread: AnyIO worker thread) - __SPLIT__
2026-07-16 09:15:48,960 - [124740] - src.utils.log - INFO - ✅ Fetched 1 rows - __SPLIT__
2026-07-16 09:15:49,039 - [124740] - src.utils.log - INFO - 🔍 Fetching data: SELECT sss.ServiceSetupId, sss.NonStdSoldServiceId as SoldServiceNonStandardId, sss.Qty as Quantity,
sss.Price as Rate, sss.IsTaxable, sm.Name as NonStandardServiceName, sm.Description , sm.ServiceMasterId as ServiceId
FROM ServiceCore.ServiceSetupServices sss join ServiceCore.ServiceMaster sm on sm.ServiceMasterId = sss.ServiceId
where ServiceSetupId = 150664 and sss.IsDeleted =0;... (Thread: AnyIO worker thread) - __SPLIT__
2026-07-16 09:15:49,370 - [124740] - src.utils.log - INFO - ✅ Fetched 1 rows - __SPLIT__
2026-07-16 09:15:49,441 - [124740] - src.utils.log - INFO - 🔍 Fetching data: SELECT sss.ServiceSetupId, sss.NonStdSoldServiceId as SoldServiceNonStandardId, sss.Qty as Quantity,
sss.Price as Rate, sss.IsTaxable, sm.Name as NonStandardServiceName, sm.Description , sm.ServiceMasterId as ServiceId
FROM ServiceCore.ServiceSetupInitialServices sss join ServiceCore.ServiceMaster sm on sm.ServiceMasterId = sss.ServiceId
where ServiceSetupId = 150664 and sss.IsDeleted =0;... (Thread: AnyIO worker thread) - __SPLIT__
2026-07-16 09:15:49,783 - [124740] - src.utils.log - INFO - ✅ Fetched 0 rows - __SPLIT__
2026-07-16 09:15:49,854 - [124740] - src.utils.log - INFO - 🔍 Fetching data: SELECT sss.ServiceSetupId, sss.NonStdSoldServiceId as SoldServiceNonStandardId, sss.Qty as Quantity,
sss.Price as Rate, sss.IsTaxable, sm.servicename as NonStandardServiceName, sm.Description , sss.ServiceId
FROM ServiceCore.ServiceSetupServices sss join ServiceCore.SoldServiceNonStandard sm on sm.SoldServiceNonStandardId = sss.NonStdSoldServiceId
where ServiceSetupId = 150664 and sss.IsDeleted =0; ... (Thread: AnyIO worker thread) - __SPLIT__
2026-07-16 09:15:50,184 - [124740] - src.utils.log - INFO - ✅ Fetched 0 rows - __SPLIT__
2026-07-16 09:15:50,255 - [124740] - src.utils.log - INFO - 🔍 Fetching data: SELECT sss.ServiceSetupId, sss.NonStdSoldServiceId as SoldServiceNonStandardId, sss.Qty as Quantity,
sss.Price as Rate, sss.IsTaxable, sm.servicename as NonStandardServiceName, sm.Description , sss.ServiceId
FROM ServiceCore.ServiceSetupInitialServices sss join ServiceCore.SoldServiceNonStandard sm on sm.SoldServiceNonStandardId = sss.NonStdSoldServiceId
where ServiceSetupId = 150664 and sss.IsDeleted =0; ... (Thread: AnyIO worker thread) - __SPLIT__
2026-07-16 09:15:50,593 - [124740] - src.utils.log - INFO - ✅ Fetched 0 rows - __SPLIT__
2026-07-16 09:15:50,673 - [124740] - src.utils.log - INFO - 🔍 Fetching data: SELECT * from ServiceCore.ServiceSetupSubWorkOrder ssswo WHERE
ssswo.ServiceSetupId = 150664;... (Thread: AnyIO worker thread) - __SPLIT__
2026-07-16 09:15:51,005 - [124740] - src.utils.log - INFO - ✅ Fetched 0 rows - __SPLIT__
2026-07-16 09:15:51,079 - [124740] - src.utils.log - INFO - 🔍 Fetching data: SELECT IsInitialSetupDiscount as IsInitial, DiscountSetupId,
AppliedDiscountAmt as AppliedDiscountAmount,IsActive ,ServiceSetupId from
ServiceCore.ServiceSetupAppliedDiscount ssad WHERE ssad.ServiceSetupId = 150664;... (Thread: AnyIO worker thread) - __SPLIT__
2026-07-16 09:15:51,411 - [124740] - src.utils.log - INFO - ✅ Fetched 0 rows - __SPLIT__
2026-07-16 09:15:51,533 - [124740] - src.utils.log - INFO - 🔍 Fetching data: SELECT IsInitialSetupDiscount as IsInitial, DiscountSetupId,IsActive,DiscountAmount,
IsDiscountPercent,DiscountPercent,DiscountDescription , ServiceSetupId from
ServiceCore.ServiceSetupAppliedDiscount ssad WHERE ssad.ServiceSetupId = 150664;... (Thread: AnyIO worker thread) - __SPLIT__
2026-07-16 09:15:51,868 - [124740] - src.utils.log - INFO - ✅ Fetched 0 rows - __SPLIT__
2026-07-16 09:15:51,939 - [124740] - src.utils.log - INFO - Sequential Insertion in invoice tables begin - __SPLIT__
2026-07-16 09:15:52,010 - [124740] - src.utils.log - INFO - 📥 Empty dataframe of Billing.AccountDiscountSetup: - __SPLIT__
2026-07-16 09:15:52,080 - [124740] - src.utils.log - INFO - Checking if all rows exist in parent table or not - __SPLIT__
2026-07-16 09:15:52,153 - [124740] - src.utils.log - INFO - 📥 Inserting into Billing.InvoiceCharges: 1 rows in batches of 25000 (Thread: AnyIO worker thread) - __SPLIT__
2026-07-16 09:15:52,518 - [124740] - src.utils.log - INFO - 📤 Inserting batch 1/1 (0 to 1) into Billing.InvoiceCharges - __SPLIT__
2026-07-16 09:15:53,524 - [124740] - src.utils.log - INFO - ✅ All 1 rows inserted successfully into Billing.InvoiceCharges in 1 batches - __SPLIT__
2026-07-16 09:15:53,590 - [124740] - src.utils.log - INFO - 📥 Empty dataframe of Billing.DiscountApplied: - __SPLIT__
2026-07-16 09:15:53,665 - [124740] - src.utils.log - INFO - Invoice Publish Done - __SPLIT__
2026-07-16 09:15:53,732 - [124740] - src.utils.log - INFO - Updating Next GenerationDate - __SPLIT__
2026-07-16 09:15:53,805 - [124740] - src.utils.log - INFO - 🔍 Fetching data:
SELECT ServiceSetupId, MAX(NextWorkOrderGenerationDate) AS MaxNextWorkOrderGeneration
FROM ServiceCore.WorkOrderSkipMonthAutoGeneration
WHERE GenerateWorkOrderHistoryId = 124740
GROUP BY ServiceSetupId;
... (Thread: AnyIO worker thread) - __SPLIT__
2026-07-16 09:15:54,136 - [124740] - src.utils.log - INFO - ✅ Fetched 0 rows - __SPLIT__
2026-07-16 09:15:54,214 - [124740] - src.utils.log - INFO - 🔄 Updating next gen date sequentially: inside update_next_workorder_generation - __SPLIT__
2026-07-16 09:15:54,413 - [124740] - src.utils.log - INFO - 🛠 Creating temp table #tbl_4c1ca2bc1c - __SPLIT__
2026-07-16 09:15:54,755 - [124740] - src.utils.log - INFO - 📌 Bulk inserting 1 rows into #tbl_4c1ca2bc1c - __SPLIT__
2026-07-16 09:15:55,084 - [124740] - src.utils.log - INFO - 🔁 Running MERGE update to apply changes - __SPLIT__
2026-07-16 09:15:55,288 - [124740] - src.utils.log - INFO - ✔ SQL reported affected rows: 1 - __SPLIT__
2026-07-16 09:15:55,493 - [124740] - src.utils.log - INFO - 🔍 Verified successfully updated 1 rows via #tbl_4c1ca2bc1c - __SPLIT__
2026-07-16 09:15:55,565 - [124740] - src.utils.log - INFO - 🎉 Successfully updated NextGenerationDate using temp table #tbl_4c1ca2bc1c - __SPLIT__
2026-07-16 09:15:55,679 - [124740] - src.utils.log - INFO - 🗑️ Deleting records:
DELETE FROM ServiceCore.WorkOrderSkipMonthAutoGeneration
WHERE GenerateWorkOrderHistoryId = 124740
(Thread: AnyIO worker thread) - __SPLIT__
2026-07-16 09:15:56,068 - [124740] - src.utils.log - INFO - ✅ Records deleted successfully - __SPLIT__
2026-07-16 09:15:56,139 - [124740] - src.utils.log - INFO - Sequential deletion from temp tables begin - __SPLIT__
2026-07-16 09:15:56,209 - [124740] - src.utils.log - INFO - 🗑️ Deleting records: DELETE FROM ServiceCore.WorkOrderAutoGenerationServices WHERE WorkOrderAutoGenerationId = 3681578 (Thread: AnyIO worker thread) - __SPLIT__
2026-07-16 09:15:56,670 - [124740] - src.utils.log - INFO - ✅ Records deleted successfully - __SPLIT__
2026-07-16 09:15:56,745 - [124740] - src.utils.log - INFO - 🗑️ Deleting records: DELETE FROM ServiceCore.WorkOrderAutoGenerationCrews WHERE WorkOrderAutoGenerationId = 3681578 (Thread: AnyIO worker thread) - __SPLIT__
2026-07-16 09:15:57,162 - [124740] - src.utils.log - INFO - ✅ Records deleted successfully - __SPLIT__
2026-07-16 09:15:57,237 - [124740] - src.utils.log - INFO - 🗑️ Deleting records: DELETE FROM ServiceCore.WorkOrderAutoGenerationSalesPersonCommission WHERE WorkOrderAutoGenerationId = 3681578 (Thread: AnyIO worker thread) - __SPLIT__
2026-07-16 09:15:57,570 - [124740] - src.utils.log - INFO - ✅ Records deleted successfully - __SPLIT__
2026-07-16 09:15:57,643 - [124740] - src.utils.log - INFO - 🗑️ Deleting records: DELETE FROM ServiceCore.WorkOrderAutoGenerationAppliedDiscount WHERE WorkOrderAutoGenerationId = 3681578 (Thread: AnyIO worker thread) - __SPLIT__
2026-07-16 09:15:58,054 - [124740] - src.utils.log - INFO - ✅ Records deleted successfully - __SPLIT__
2026-07-16 09:15:58,123 - [124740] - src.utils.log - INFO - 🗑️ Deleting records: DELETE FROM ServiceCore.SetupAutoGenerationSourceMapping WHERE WorkOrderAutoGenerationId = 3681578 (Thread: AnyIO worker thread) - __SPLIT__
2026-07-16 09:15:58,463 - [124740] - src.utils.log - INFO - ✅ Records deleted successfully - __SPLIT__
2026-07-16 09:15:58,532 - [124740] - src.utils.log - INFO - 🗑️ Deleting records: DELETE FROM ServiceCore.SubWorkOrderAutoGeneration WHERE WorkOrderAutoGenerationId = 3681578 (Thread: AnyIO worker thread) - __SPLIT__
2026-07-16 09:15:58,864 - [124740] - src.utils.log - INFO - ✅ Records deleted successfully - __SPLIT__
2026-07-16 09:15:58,949 - [124740] - src.utils.log - INFO - 🗑️ Deleting records: DELETE FROM ServiceCore.WorkOrderAutoGenerationCommissionAdjustment WHERE WorkOrderAutoGenerationId = 3681578 (Thread: AnyIO worker thread) - __SPLIT__
2026-07-16 09:15:59,284 - [124740] - src.utils.log - INFO - ✅ Records deleted successfully - __SPLIT__
2026-07-16 09:15:59,352 - [124740] - src.utils.log - INFO - 🗑️ Deleting records: DELETE FROM ServiceCore.WorkOrderAutoGeneration WHERE WorkOrderAutoGenerationId = 3681578 (Thread: AnyIO worker thread) - __SPLIT__
2026-07-16 09:15:59,734 - [124740] - src.utils.log - INFO - ✅ Records deleted successfully - __SPLIT__
2026-07-16 09:15:59,803 - [124740] - src.utils.log - INFO - Work order published ids: (3681578,) - __SPLIT__
2026-07-16 09:15:59,912 - [124740] - src.utils.log - INFO - Time took to perform operation in publishing [124740]: 46.33 - __SPLIT__
2026-07-16 09:15:59,978 - [124740] - src.utils.log - INFO - Publish Completed for GenerateWorkOrderHistoryId: [124740] - __SPLIT__
2026-07-16 09:16:00,048 - [124740] - src.utils.log - INFO - 📝 Executing: UPDATE ServiceCore.GenerateWorkOrderHistory SET PublishStatus = 'Completed',
PublishStatusDateTime = '2026-07-16 05:15:59.803' WHERE CompanyId = 133 AND
GenerateWorkOrderHistoryId = 124740;... (Thread: AnyIO worker thread) - __SPLIT__
2026-07-16 09:16:00,387 - [124740] - src.utils.log - INFO - ✅ Command executed successfully - __SPLIT__