2026-08-31 18:40:47,695 - [28370] - src.utils.log - INFO - 📥 Inserting into ServiceCore.WorkOrderAutoGenerationPublishHistory: 4 rows in batches of 25000 (Thread: AnyIO worker thread) - __SPLIT__
2026-08-31 18:40:48,416 - [28370] - src.utils.log - INFO - 📤 Inserting batch 1/1 (0 to 4) into ServiceCore.WorkOrderAutoGenerationPublishHistory - __SPLIT__
2026-08-31 18:40:49,197 - [28370] - src.utils.log - INFO - ✅ All 4 rows inserted successfully into ServiceCore.WorkOrderAutoGenerationPublishHistory in 1 batches - __SPLIT__
2026-08-31 18:40:49,855 - [28370] - src.utils.log - INFO - 🔍 Fetching data:
SELECT
WorkOrderAutoGenerationPublishHistoryId,
WorkOrderNo,
ServiceSetupId
FROM ServiceCore.WorkOrderAutoGenerationPublishHistory
WHERE
ServiceSetupId IN (69299, 69253, 69138, 69212) AND WorkOrderNo IN ('4233839', '2991801', '9317904', '3321932') AND GenerateWorkOrderHistoryId = 28370;... (Thread: ThreadPoolExecutor-24_0) - __SPLIT__
2026-08-31 18:40:50,642 - [28370] - src.utils.log - INFO - ✅ Fetched 4 rows - __SPLIT__
2026-08-31 18:40:51,302 - [28370] - src.utils.log - INFO - 🏁 Final merged rows: 4 - __SPLIT__
2026-08-31 18:40:51,966 - [28370] - src.utils.log - INFO - Sequential Insertion in work order tables begin - __SPLIT__
2026-08-31 18:40:52,630 - [28370] - src.utils.log - INFO - Checking if all rows exist in parent table or not - __SPLIT__
2026-08-31 18:40:53,282 - [28370] - src.utils.log - INFO - 📥 Inserting into ServiceCore.WorkOrderServices: 4 rows in batches of 25000 (Thread: AnyIO worker thread) - __SPLIT__
2026-08-31 18:40:53,978 - [28370] - src.utils.log - INFO - 📤 Inserting batch 1/1 (0 to 4) into ServiceCore.WorkOrderServices - __SPLIT__
2026-08-31 18:40:54,738 - [28370] - src.utils.log - INFO - ✅ All 4 rows inserted successfully into ServiceCore.WorkOrderServices in 1 batches - __SPLIT__
2026-08-31 18:40:55,393 - [28370] - src.utils.log - INFO - 📥 Empty dataframe of ServiceAuto.WorkOrderAppliedDiscount: - __SPLIT__
2026-08-31 18:40:56,042 - [28370] - src.utils.log - INFO - 📥 Empty dataframe of ServiceCore.WorkOrderSalesPersonCommission: - __SPLIT__
2026-08-31 18:40:56,700 - [28370] - src.utils.log - INFO - 📥 Empty dataframe of ServiceAuto.WorkOrderCommissionAdjustment: - __SPLIT__
2026-08-31 18:40:57,660 - [28370] - src.utils.log - INFO - Checking if all rows exist in parent table or not - __SPLIT__
2026-08-31 18:40:58,332 - [28370] - src.utils.log - INFO - 📥 Inserting into ServiceCore.WorkOrderCrew: 4 rows in batches of 25000 (Thread: AnyIO worker thread) - __SPLIT__
2026-08-31 18:40:59,052 - [28370] - src.utils.log - INFO - 📤 Inserting batch 1/1 (0 to 4) into ServiceCore.WorkOrderCrew - __SPLIT__
2026-08-31 18:40:59,817 - [28370] - src.utils.log - INFO - ✅ All 4 rows inserted successfully into ServiceCore.WorkOrderCrew in 1 batches - __SPLIT__
2026-08-31 18:41:00,491 - [28370] - src.utils.log - INFO - 📥 Empty dataframe of ServiceCore.WorkorderSourceMapping: - __SPLIT__
2026-08-31 18:41:01,163 - [28370] - src.utils.log - INFO - 📥 Empty dataframe of CRM.LeadNote: - __SPLIT__
2026-08-31 18:41:01,852 - [28370] - src.utils.log - INFO - Checking if all rows exist in parent table or not - __SPLIT__
2026-08-31 18:41:02,526 - [28370] - src.utils.log - INFO - 📥 Inserting into ServiceCore.WorkOrderAutoGenerationPublishServices: 4 rows in batches of 25000 (Thread: AnyIO worker thread) - __SPLIT__
2026-08-31 18:41:03,265 - [28370] - src.utils.log - INFO - 📤 Inserting batch 1/1 (0 to 4) into ServiceCore.WorkOrderAutoGenerationPublishServices - __SPLIT__
2026-08-31 18:41:04,039 - [28370] - src.utils.log - INFO - ✅ All 4 rows inserted successfully into ServiceCore.WorkOrderAutoGenerationPublishServices in 1 batches - __SPLIT__
2026-08-31 18:41:04,716 - [28370] - 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 in (69299, 69253, 69138, 69212)... (Thread: AnyIO worker thread) - __SPLIT__
2026-08-31 18:41:05,418 - [28370] - src.utils.log - INFO - ✅ Fetched 4 rows - __SPLIT__
2026-08-31 18:41:06,096 - [28370] - src.utils.log - INFO - Size of Transaction: 4 - __SPLIT__
2026-08-31 18:41:06,796 - [28370] - src.utils.log - INFO - 📥 Inserting into Billing.Transaction (skip triggers): 4 rows in batches of 25000 (Thread: AnyIO worker thread) - __SPLIT__
2026-08-31 18:41:07,528 - [28370] - src.utils.log - INFO - 📤 Inserting batch 1/1 (0 to 4) into Billing.Transaction (triggers skipped) - __SPLIT__
2026-08-31 18:41:08,320 - [28370] - src.utils.log - INFO - ✅ All 4 rows inserted successfully into Billing.Transaction in 1 batches (triggers skipped) - __SPLIT__
2026-08-31 18:41:09,007 - [28370] - src.utils.log - INFO - 🔄 Triggers re-enabled for session - __SPLIT__
2026-08-31 18:41:09,675 - [28370] - src.utils.log - INFO - 🔍 Fetching data: SELECT TransactionId, ModifiedBy, TransactionDate as InvoiceDate from Billing.[Transaction] t WHERE t.ModifiedBy in (12345678910, 12345678911, 12345678912, 12345678913) and t.CompanyId = 133 AND
t.TransactionType ='Invoice' AND t.CreatedDate = '2026-08-31 14:41:06.093';... (Thread: AnyIO worker thread) - __SPLIT__
2026-08-31 18:41:10,826 - [28370] - src.utils.log - INFO - ✅ Fetched 4 rows - __SPLIT__
2026-08-31 18:41:11,497 - [28370] - src.utils.log - INFO - 🔍 Fetching data: SELECT * from ServiceCore.ServiceSetupSubWorkOrder ssswo WHERE
ssswo.ServiceSetupId in (69138, 69212, 69253, 69299);... (Thread: AnyIO worker thread) - __SPLIT__
2026-08-31 18:41:12,474 - [28370] - src.utils.log - INFO - ✅ Fetched 0 rows - __SPLIT__
2026-08-31 18:41:13,152 - [28370] - src.utils.log - INFO - 📝 Executing:
UPDATE Billing.[Transaction]
SET ModifiedBy = NULL
WHERE ModifiedBy IN (12345678910,12345678911,12345678912,12345678913)
AND CreatedDate = '2026-08-31 14:41:06.093';
... (Thread: ThreadPoolExecutor-25_0) - __SPLIT__
2026-08-31 18:41:14,433 - [28370] - src.utils.log - INFO - ✅ Command executed successfully - __SPLIT__
2026-08-31 18:41:15,108 - [28370] - src.utils.log - INFO - Checking if all rows exist in parent table or not - __SPLIT__
2026-08-31 18:41:15,784 - [28370] - src.utils.log - INFO - 📥 Inserting into Billing.Invoice: 4 rows in batches of 25000 (Thread: AnyIO worker thread) - __SPLIT__
2026-08-31 18:41:16,519 - [28370] - src.utils.log - INFO - 📤 Inserting batch 1/1 (0 to 4) into Billing.Invoice - __SPLIT__
2026-08-31 18:41:17,304 - [28370] - src.utils.log - INFO - ✅ All 4 rows inserted successfully into Billing.Invoice in 1 batches - __SPLIT__
2026-08-31 18:41:17,972 - [28370] - src.utils.log - INFO - 🔍 Fetching data: SELECT InvoiceId, WorkOrderNo FROM Billing.Invoice i WHERE i.WorkOrderNo in ('570944', '570945', '570943', '570942')... (Thread: AnyIO worker thread) - __SPLIT__
2026-08-31 18:41:19,465 - [28370] - src.utils.log - INFO - ✅ Fetched 4 rows - __SPLIT__
2026-08-31 18:41:20,143 - [28370] - 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 in (69299, 69253, 69138, 69212) and sss.IsDeleted =0;... (Thread: AnyIO worker thread) - __SPLIT__
2026-08-31 18:41:20,861 - [28370] - src.utils.log - INFO - ✅ Fetched 4 rows - __SPLIT__
2026-08-31 18:41:21,525 - [28370] - 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 in (69299, 69253, 69138, 69212) and sss.IsDeleted =0;... (Thread: AnyIO worker thread) - __SPLIT__
2026-08-31 18:41:22,231 - [28370] - src.utils.log - INFO - ✅ Fetched 2 rows - __SPLIT__
2026-08-31 18:41:22,899 - [28370] - 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 in (69299, 69253, 69138, 69212) and sss.IsDeleted =0; ... (Thread: AnyIO worker thread) - __SPLIT__
2026-08-31 18:41:23,602 - [28370] - src.utils.log - INFO - ✅ Fetched 0 rows - __SPLIT__
2026-08-31 18:41:24,260 - [28370] - 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 in (69299, 69253, 69138, 69212) and sss.IsDeleted =0; ... (Thread: AnyIO worker thread) - __SPLIT__
2026-08-31 18:41:24,965 - [28370] - src.utils.log - INFO - ✅ Fetched 0 rows - __SPLIT__
2026-08-31 18:41:25,656 - [28370] - src.utils.log - INFO - 🔍 Fetching data: SELECT * from ServiceCore.ServiceSetupSubWorkOrder ssswo WHERE
ssswo.ServiceSetupId in (69299, 69253, 69138, 69212);... (Thread: AnyIO worker thread) - __SPLIT__
2026-08-31 18:41:26,351 - [28370] - src.utils.log - INFO - ✅ Fetched 0 rows - __SPLIT__
2026-08-31 18:41:27,030 - [28370] - src.utils.log - INFO - 🔍 Fetching data: SELECT IsInitialSetupDiscount as IsInitial, DiscountSetupId,
AppliedDiscountAmt as AppliedDiscountAmount,IsActive ,ServiceSetupId from
ServiceCore.ServiceSetupAppliedDiscount ssad WHERE ssad.ServiceSetupId in (69299, 69253, 69138, 69212);... (Thread: AnyIO worker thread) - __SPLIT__
2026-08-31 18:41:28,003 - [28370] - src.utils.log - INFO - ✅ Fetched 0 rows - __SPLIT__
2026-08-31 18:41:28,678 - [28370] - src.utils.log - INFO - 🔍 Fetching data: SELECT IsInitialSetupDiscount as IsInitial, DiscountSetupId,IsActive,DiscountAmount,
IsDiscountPercent,DiscountPercent,DiscountDescription, ServiceSetupId from
ServiceCore.ServiceSetupAppliedDiscount ssad WHERE ssad.ServiceSetupId in (69299, 69253, 69138, 69212);... (Thread: AnyIO worker thread) - __SPLIT__
2026-08-31 18:41:29,362 - [28370] - src.utils.log - INFO - ✅ Fetched 0 rows - __SPLIT__
2026-08-31 18:41:30,033 - [28370] - src.utils.log - INFO - Sequential Insertion in invoice tables begin - __SPLIT__
2026-08-31 18:41:30,726 - [28370] - src.utils.log - INFO - 📥 Empty dataframe of Billing.AccountDiscountSetup: - __SPLIT__
2026-08-31 18:41:31,398 - [28370] - src.utils.log - INFO - Checking if all rows exist in parent table or not - __SPLIT__
2026-08-31 18:41:32,067 - [28370] - src.utils.log - INFO - 📥 Inserting into Billing.InvoiceCharges: 4 rows in batches of 25000 (Thread: AnyIO worker thread) - __SPLIT__
2026-08-31 18:41:32,822 - [28370] - src.utils.log - INFO - 📤 Inserting batch 1/1 (0 to 4) into Billing.InvoiceCharges - __SPLIT__
2026-08-31 18:41:33,635 - [28370] - src.utils.log - INFO - ✅ All 4 rows inserted successfully into Billing.InvoiceCharges in 1 batches - __SPLIT__
2026-08-31 18:41:34,298 - [28370] - src.utils.log - INFO - 📥 Empty dataframe of Billing.DiscountApplied: - __SPLIT__
2026-08-31 18:41:34,988 - [28370] - src.utils.log - INFO - Invoice Publish Done - __SPLIT__
2026-08-31 18:41:35,655 - [28370] - src.utils.log - INFO - Updating Next GenerationDate - __SPLIT__
2026-08-31 18:41:36,317 - [28370] - src.utils.log - INFO - 🔍 Fetching data:
SELECT ServiceSetupId, MAX(NextWorkOrderGenerationDate) AS MaxNextWorkOrderGeneration
FROM ServiceCore.WorkOrderSkipMonthAutoGeneration
WHERE GenerateWorkOrderHistoryId = 28370
GROUP BY ServiceSetupId;
... (Thread: AnyIO worker thread) - __SPLIT__
2026-08-31 18:41:37,008 - [28370] - src.utils.log - INFO - ✅ Fetched 0 rows - __SPLIT__
2026-08-31 18:41:37,675 - [28370] - src.utils.log - INFO - 🔄 Updating next gen date sequentially: inside update_next_workorder_generation - __SPLIT__
2026-08-31 18:41:38,349 - [28370] - src.utils.log - INFO - 🛠 Creating temp table #tbl_3dc97758a0 - __SPLIT__
2026-08-31 18:41:39,049 - [28370] - src.utils.log - INFO - 📌 Bulk inserting 4 rows into #tbl_3dc97758a0 - __SPLIT__
2026-08-31 18:41:39,783 - [28370] - src.utils.log - INFO - 🔁 Running MERGE update to apply changes - __SPLIT__
2026-08-31 18:41:40,490 - [28370] - src.utils.log - INFO - ✔ SQL reported affected rows: 4 - __SPLIT__
2026-08-31 18:41:41,170 - [28370] - src.utils.log - INFO - 🔍 Verified successfully updated 4 rows via #tbl_3dc97758a0 - __SPLIT__
2026-08-31 18:41:42,131 - [28370] - src.utils.log - INFO - 🎉 Successfully updated NextGenerationDate using temp table #tbl_3dc97758a0 - __SPLIT__
2026-08-31 18:41:42,792 - [28370] - src.utils.log - INFO - 🗑️ Deleting records:
DELETE FROM ServiceCore.WorkOrderSkipMonthAutoGeneration
WHERE GenerateWorkOrderHistoryId = 28370
(Thread: AnyIO worker thread) - __SPLIT__
2026-08-31 18:41:43,471 - [28370] - src.utils.log - INFO - ✅ Records deleted successfully - __SPLIT__
2026-08-31 18:41:44,126 - [28370] - src.utils.log - INFO - Sequential deletion from temp tables begin - __SPLIT__
2026-08-31 18:41:44,778 - [28370] - src.utils.log - INFO - 🗑️ Deleting records: DELETE FROM ServiceCore.WorkOrderAutoGenerationServices WHERE WorkOrderAutoGenerationId in (724553, 724554, 724555, 724556) (Thread: AnyIO worker thread) - __SPLIT__
2026-08-31 18:41:45,459 - [28370] - src.utils.log - INFO - ✅ Records deleted successfully - __SPLIT__
2026-08-31 18:41:46,111 - [28370] - src.utils.log - INFO - 🗑️ Deleting records: DELETE FROM ServiceCore.WorkOrderAutoGenerationCrews WHERE WorkOrderAutoGenerationId in (724553, 724554, 724555, 724556) (Thread: AnyIO worker thread) - __SPLIT__
2026-08-31 18:41:46,792 - [28370] - src.utils.log - INFO - ✅ Records deleted successfully - __SPLIT__
2026-08-31 18:41:47,451 - [28370] - src.utils.log - INFO - 🗑️ Deleting records: DELETE FROM ServiceCore.WorkOrderAutoGenerationSalesPersonCommission WHERE WorkOrderAutoGenerationId in (724553, 724554, 724555, 724556) (Thread: AnyIO worker thread) - __SPLIT__
2026-08-31 18:41:48,140 - [28370] - src.utils.log - INFO - ✅ Records deleted successfully - __SPLIT__
2026-08-31 18:41:48,795 - [28370] - src.utils.log - INFO - 🗑️ Deleting records: DELETE FROM ServiceCore.WorkOrderAutoGenerationAppliedDiscount WHERE WorkOrderAutoGenerationId in (724553, 724554, 724555, 724556) (Thread: AnyIO worker thread) - __SPLIT__
2026-08-31 18:41:49,622 - [28370] - src.utils.log - INFO - ✅ Records deleted successfully - __SPLIT__
2026-08-31 18:41:50,278 - [28370] - src.utils.log - INFO - 🗑️ Deleting records: DELETE FROM ServiceCore.SetupAutoGenerationSourceMapping WHERE WorkOrderAutoGenerationId in (724553, 724554, 724555, 724556) (Thread: AnyIO worker thread) - __SPLIT__
2026-08-31 18:41:51,047 - [28370] - src.utils.log - INFO - ✅ Records deleted successfully - __SPLIT__
2026-08-31 18:41:51,707 - [28370] - src.utils.log - INFO - 🗑️ Deleting records: DELETE FROM ServiceCore.SubWorkOrderAutoGeneration WHERE WorkOrderAutoGenerationId in (724553, 724554, 724555, 724556) (Thread: AnyIO worker thread) - __SPLIT__
2026-08-31 18:41:52,403 - [28370] - src.utils.log - INFO - ✅ Records deleted successfully - __SPLIT__
2026-08-31 18:41:53,055 - [28370] - src.utils.log - INFO - 🗑️ Deleting records: DELETE FROM ServiceCore.WorkOrderAutoGenerationCommissionAdjustment WHERE WorkOrderAutoGenerationId in (724553, 724554, 724555, 724556) (Thread: AnyIO worker thread) - __SPLIT__
2026-08-31 18:41:53,758 - [28370] - src.utils.log - INFO - ✅ Records deleted successfully - __SPLIT__
2026-08-31 18:41:54,412 - [28370] - src.utils.log - INFO - 🗑️ Deleting records: DELETE FROM ServiceCore.WorkOrderAutoGeneration WHERE WorkOrderAutoGenerationId in (724553, 724554, 724555, 724556) (Thread: AnyIO worker thread) - __SPLIT__
2026-08-31 18:41:55,161 - [28370] - src.utils.log - INFO - ✅ Records deleted successfully - __SPLIT__
2026-08-31 18:41:56,118 - [28370] - src.utils.log - INFO - Work order published ids: (724553, 724554, 724555, 724556) - __SPLIT__
2026-08-31 18:41:56,785 - [28370] - src.utils.log - INFO - Time took to perform operation in publishing [28370]: 113.99 - __SPLIT__
2026-08-31 18:41:57,451 - [28370] - src.utils.log - INFO - Publish Completed for GenerateWorkOrderHistoryId: [28370] - __SPLIT__
2026-08-31 18:41:58,123 - [28370] - src.utils.log - INFO - 📝 Executing: UPDATE ServiceCore.GenerateWorkOrderHistory SET PublishStatus = 'Completed',
PublishStatusDateTime = '2026-08-31 14:41:56.118' WHERE CompanyId = 133 AND
GenerateWorkOrderHistoryId = 28370;... (Thread: AnyIO worker thread) - __SPLIT__
2026-08-31 18:41:58,833 - [28370] - src.utils.log - INFO - ✅ Command executed successfully - __SPLIT__