app.log.2026-04-20

Latest changes applied: fixed table name (2026-04-28)
2026-04-27 21:42:54,946 - [24715] - src.utils.log - INFO - 📤 Inserting batch 1/1 (0 to 6) into ServiceCore.WorkOrderServices - __SPLIT__
2026-04-27 21:42:55,721 - [24715] - src.utils.log - INFO - ✅ All 6 rows inserted successfully into ServiceCore.WorkOrderServices in 1 batches - __SPLIT__
2026-04-27 21:42:56,397 - [24715] - src.utils.log - INFO - Checking if all rows exist in parent table or not - __SPLIT__
2026-04-27 21:42:57,321 - [24715] - src.utils.log - INFO - 📥 Inserting into ServiceAuto.WorkOrderAppliedDiscount: 1 rows in batches of 25000 (Thread: AnyIO worker thread) - __SPLIT__
2026-04-27 21:42:58,024 - [24715] - src.utils.log - INFO - 📤 Inserting batch 1/1 (0 to 1) into ServiceAuto.WorkOrderAppliedDiscount - __SPLIT__
2026-04-27 21:42:58,769 - [24715] - src.utils.log - INFO - ✅ All 1 rows inserted successfully into ServiceAuto.WorkOrderAppliedDiscount in 1 batches - __SPLIT__
2026-04-27 21:42:59,420 - [24715] - src.utils.log - INFO - 📥 Empty dataframe of ServiceCore.WorkOrderSalesPersonCommission: - __SPLIT__
2026-04-27 21:43:00,068 - [24715] - src.utils.log - INFO - 📥 Empty dataframe of ServiceAuto.WorkOrderCommissionAdjustment: - __SPLIT__
2026-04-27 21:43:00,716 - [24715] - src.utils.log - INFO - Checking if all rows exist in parent table or not - __SPLIT__
2026-04-27 21:43:01,364 - [24715] - src.utils.log - INFO - 📥 Inserting into ServiceCore.WorkOrderCrew: 5 rows in batches of 25000 (Thread: AnyIO worker thread) - __SPLIT__
2026-04-27 21:43:02,063 - [24715] - src.utils.log - INFO - 📤 Inserting batch 1/1 (0 to 5) into ServiceCore.WorkOrderCrew - __SPLIT__
2026-04-27 21:43:02,812 - [24715] - src.utils.log - INFO - ✅ All 5 rows inserted successfully into ServiceCore.WorkOrderCrew in 1 batches - __SPLIT__
2026-04-27 21:43:03,460 - [24715] - src.utils.log - INFO - 📥 Empty dataframe of ServiceCore.WorkorderSourceMapping: - __SPLIT__
2026-04-27 21:43:04,114 - [24715] - src.utils.log - INFO - 📥 Empty dataframe of CRM.LeadNote: - __SPLIT__
2026-04-27 21:43:04,762 - [24715] - src.utils.log - INFO - Checking if all rows exist in parent table or not - __SPLIT__
2026-04-27 21:43:05,413 - [24715] - src.utils.log - INFO - 📥 Inserting into ServiceCore.WorkOrderAutoGenerationPublishServices: 6 rows in batches of 25000 (Thread: AnyIO worker thread) - __SPLIT__
2026-04-27 21:43:06,111 - [24715] - src.utils.log - INFO - 📤 Inserting batch 1/1 (0 to 6) into ServiceCore.WorkOrderAutoGenerationPublishServices - __SPLIT__
2026-04-27 21:43:06,863 - [24715] - src.utils.log - INFO - ✅ All 6 rows inserted successfully into ServiceCore.WorkOrderAutoGenerationPublishServices in 1 batches - __SPLIT__
2026-04-27 21:43:07,510 - [24715] - 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 (66556, 29692)... (Thread: AnyIO worker thread) - __SPLIT__
2026-04-27 21:43:08,184 - [24715] - src.utils.log - INFO - ✅ Fetched 2 rows - __SPLIT__
2026-04-27 21:43:08,837 - [24715] - src.utils.log - INFO - Size of Transaction: 5 - __SPLIT__
2026-04-27 21:43:09,497 - [24715] - src.utils.log - INFO - 📥 Inserting into Billing.Transaction (skip triggers): 5 rows in batches of 25000 (Thread: AnyIO worker thread) - __SPLIT__
2026-04-27 21:43:10,210 - [24715] - src.utils.log - INFO - 📤 Inserting batch 1/1 (0 to 5) into Billing.Transaction (triggers skipped) - __SPLIT__
2026-04-27 21:43:11,280 - [24715] - src.utils.log - INFO - ✅ All 5 rows inserted successfully into Billing.Transaction in 1 batches (triggers skipped) - __SPLIT__
2026-04-27 21:43:11,959 - [24715] - src.utils.log - INFO - 🔄 Triggers re-enabled for session - __SPLIT__
2026-04-27 21:43:12,635 - [24715] - src.utils.log - INFO - 🔍 Fetching data: SELECT TransactionId, ModifiedBy, TransactionDate as InvoiceDate from Billing.[Transaction] t WHERE t.ModifiedBy in (12345678910, 12345678911, 12345678912, 12345678913, 12345678914)  and t.CompanyId = 133 AND 
        t.TransactionType ='Invoice' AND t.CreatedDate = '2026-04-27 17:43:08.833';... (Thread: AnyIO worker thread) - __SPLIT__
2026-04-27 21:43:13,920 - [24715] - src.utils.log - INFO - ✅ Fetched 5 rows - __SPLIT__
2026-04-27 21:43:14,600 - [24715] - src.utils.log - INFO - 🔍 Fetching data: SELECT * from ServiceCore.ServiceSetupSubWorkOrder ssswo WHERE 
     ssswo.ServiceSetupId  in (29692, 66556);... (Thread: AnyIO worker thread) - __SPLIT__
2026-04-27 21:43:15,293 - [24715] - src.utils.log - INFO - ✅ Fetched 0 rows - __SPLIT__
2026-04-27 21:43:15,971 - [24715] - src.utils.log - INFO - 📝 Executing: 
                    UPDATE Billing.[Transaction]
                    SET ModifiedBy = NULL
                    WHERE ModifiedBy IN (12345678910,12345678911,12345678912,12345678913,12345678914)
                    AND CreatedDate = '2026-04-27 17:43:08.833';
                ... (Thread: ThreadPoolExecutor-20_0) - __SPLIT__
2026-04-27 21:43:17,054 - [24715] - src.utils.log - INFO - ✅ Command executed successfully - __SPLIT__
2026-04-27 21:43:17,730 - [24715] - src.utils.log - INFO - Checking if all rows exist in parent table or not - __SPLIT__
2026-04-27 21:43:18,405 - [24715] - src.utils.log - INFO - 📥 Inserting into Billing.Invoice: 5 rows in batches of 25000 (Thread: AnyIO worker thread) - __SPLIT__
2026-04-27 21:43:19,122 - [24715] - src.utils.log - INFO - 📤 Inserting batch 1/1 (0 to 5) into Billing.Invoice - __SPLIT__
2026-04-27 21:43:19,905 - [24715] - src.utils.log - INFO - ✅ All 5 rows inserted successfully into Billing.Invoice in 1 batches - __SPLIT__
2026-04-27 21:43:20,576 - [24715] - src.utils.log - INFO - 🔍 Fetching data: SELECT InvoiceId, WorkOrderNo FROM Billing.Invoice i WHERE i.WorkOrderNo in ('494315', '494316', '494314', '494313', '494312')... (Thread: AnyIO worker thread) - __SPLIT__
2026-04-27 21:43:21,556 - [24715] - src.utils.log - INFO - ✅ Fetched 5 rows - __SPLIT__
2026-04-27 21:43:22,233 - [24715] - 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 (66556, 29692) and sss.IsDeleted =0;... (Thread: AnyIO worker thread) - __SPLIT__
2026-04-27 21:43:22,936 - [24715] - src.utils.log - INFO - ✅ Fetched 3 rows - __SPLIT__
2026-04-27 21:43:23,611 - [24715] - 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 (66556, 29692) and sss.IsDeleted =0;... (Thread: AnyIO worker thread) - __SPLIT__
2026-04-27 21:43:24,310 - [24715] - src.utils.log - INFO - ✅ Fetched 1 rows - __SPLIT__
2026-04-27 21:43:24,978 - [24715] - 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 (66556, 29692)  and sss.IsDeleted =0;  ... (Thread: AnyIO worker thread) - __SPLIT__
2026-04-27 21:43:25,688 - [24715] - src.utils.log - INFO - ✅ Fetched 0 rows - __SPLIT__
2026-04-27 21:43:26,642 - [24715] - 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 (66556, 29692)  and sss.IsDeleted =0;  ... (Thread: AnyIO worker thread) - __SPLIT__
2026-04-27 21:43:27,325 - [24715] - src.utils.log - INFO - ✅ Fetched 0 rows - __SPLIT__
2026-04-27 21:43:27,994 - [24715] - src.utils.log - INFO - 🔍 Fetching data: SELECT * from ServiceCore.ServiceSetupSubWorkOrder ssswo WHERE 
     ssswo.ServiceSetupId  in (66556, 29692);... (Thread: AnyIO worker thread) - __SPLIT__
2026-04-27 21:43:28,676 - [24715] - src.utils.log - INFO - ✅ Fetched 0 rows - __SPLIT__
2026-04-27 21:43:29,337 - [24715] - src.utils.log - INFO - 🔍 Fetching data: SELECT IsInitialSetupDiscount as IsInitial, DiscountSetupId, 
        AppliedDiscountAmt as AppliedDiscountAmount,IsActive ,ServiceSetupId  from 
        ServiceCore.ServiceSetupAppliedDiscount ssad WHERE ssad.ServiceSetupId in (66556, 29692);... (Thread: AnyIO worker thread) - __SPLIT__
2026-04-27 21:43:30,026 - [24715] - src.utils.log - INFO - ✅ Fetched 1 rows - __SPLIT__
2026-04-27 21:43:30,697 - [24715] - 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 (66556, 29692);... (Thread: AnyIO worker thread) - __SPLIT__
2026-04-27 21:43:31,383 - [24715] - src.utils.log - INFO - ✅ Fetched 1 rows - __SPLIT__
2026-04-27 21:43:32,053 - [24715] - src.utils.log - INFO - Sequential Insertion in invoice tables begin - __SPLIT__
2026-04-27 21:43:32,715 - [24715] - src.utils.log - INFO - Checking if all rows exist in parent table or not - __SPLIT__
2026-04-27 21:43:33,372 - [24715] - src.utils.log - INFO - 📥 Inserting into Billing.AccountDiscountSetup: 1 rows in batches of 25000 (Thread: AnyIO worker thread) - __SPLIT__
2026-04-27 21:43:34,075 - [24715] - src.utils.log - INFO - 📤 Inserting batch 1/1 (0 to 1) into Billing.AccountDiscountSetup - __SPLIT__
2026-04-27 21:43:34,825 - [24715] - src.utils.log - INFO - ✅ All 1 rows inserted successfully into Billing.AccountDiscountSetup in 1 batches - __SPLIT__
2026-04-27 21:43:35,488 - [24715] - src.utils.log - INFO - Checking if all rows exist in parent table or not - __SPLIT__
2026-04-27 21:43:36,147 - [24715] - src.utils.log - INFO - 📥 Inserting into Billing.InvoiceCharges: 6 rows in batches of 25000 (Thread: AnyIO worker thread) - __SPLIT__
2026-04-27 21:43:36,859 - [24715] - src.utils.log - INFO - 📤 Inserting batch 1/1 (0 to 6) into Billing.InvoiceCharges - __SPLIT__
2026-04-27 21:43:37,617 - [24715] - src.utils.log - INFO - ✅ All 6 rows inserted successfully into Billing.InvoiceCharges in 1 batches - __SPLIT__
2026-04-27 21:43:38,270 - [24715] - src.utils.log - INFO - Checking if all rows exist in parent table or not - __SPLIT__
2026-04-27 21:43:38,937 - [24715] - src.utils.log - INFO - 📥 Inserting into Billing.DiscountApplied: 1 rows in batches of 25000 (Thread: AnyIO worker thread) - __SPLIT__
2026-04-27 21:43:39,646 - [24715] - src.utils.log - INFO - 📤 Inserting batch 1/1 (0 to 1) into Billing.DiscountApplied - __SPLIT__
2026-04-27 21:43:40,715 - [24715] - src.utils.log - INFO - ✅ All 1 rows inserted successfully into Billing.DiscountApplied in 1 batches - __SPLIT__
2026-04-27 21:43:41,395 - [24715] - src.utils.log - INFO - Invoice Publish Done - __SPLIT__
2026-04-27 21:43:42,104 - [24715] - src.utils.log - INFO - Updating Next GenerationDate - __SPLIT__
2026-04-27 21:43:42,785 - [24715] - src.utils.log - INFO - 🔍 Fetching data: 
            SELECT ServiceSetupId, MAX(NextWorkOrderGenerationDate) AS MaxNextWorkOrderGeneration
            FROM ServiceCore.WorkOrderSkipMonthAutoGeneration
            WHERE GenerateWorkOrderHistoryId = 24715
            GROUP BY ServiceSetupId;
        ... (Thread: AnyIO worker thread) - __SPLIT__
2026-04-27 21:43:43,492 - [24715] - src.utils.log - INFO - ✅ Fetched 0 rows - __SPLIT__
2026-04-27 21:43:44,177 - [24715] - src.utils.log - INFO - 🔄 Updating next gen date sequentially: inside update_next_workorder_generation - __SPLIT__
2026-04-27 21:43:44,872 - [24715] - src.utils.log - INFO - 🛠 Creating temp table #tbl_95b66727ba - __SPLIT__
2026-04-27 21:43:45,579 - [24715] - src.utils.log - INFO - 📌 Bulk inserting 2 rows into #tbl_95b66727ba - __SPLIT__
2026-04-27 21:43:46,304 - [24715] - src.utils.log - INFO - 🔁 Running MERGE update to apply changes - __SPLIT__
2026-04-27 21:43:47,001 - [24715] - src.utils.log - INFO - ✔ SQL reported affected rows: 2 - __SPLIT__
2026-04-27 21:43:47,701 - [24715] - src.utils.log - INFO - 🔍 Verified successfully updated 2 rows via #tbl_95b66727ba - __SPLIT__
2026-04-27 21:43:48,381 - [24715] - src.utils.log - INFO - 🎉 Successfully updated NextGenerationDate using temp table #tbl_95b66727ba - __SPLIT__
2026-04-27 21:43:49,052 - [24715] - src.utils.log - INFO - 🗑️ Deleting records: 
                DELETE FROM ServiceCore.WorkOrderSkipMonthAutoGeneration
                WHERE GenerateWorkOrderHistoryId = 24715
               (Thread: AnyIO worker thread) - __SPLIT__
2026-04-27 21:43:49,758 - [24715] - src.utils.log - INFO - ✅ Records deleted successfully - __SPLIT__
2026-04-27 21:43:50,440 - [24715] - src.utils.log - INFO - Sequential deletion from temp tables begin - __SPLIT__
2026-04-27 21:43:51,119 - [24715] - src.utils.log - INFO - 🗑️ Deleting records: DELETE FROM ServiceCore.WorkOrderAutoGenerationServices WHERE WorkOrderAutoGenerationId in (658688, 658689, 658690, 658691, 658692)   (Thread: AnyIO worker thread) - __SPLIT__
2026-04-27 21:43:51,826 - [24715] - src.utils.log - INFO - ✅ Records deleted successfully - __SPLIT__
2026-04-27 21:43:52,498 - [24715] - src.utils.log - INFO - 🗑️ Deleting records: DELETE FROM ServiceCore.WorkOrderAutoGenerationCrews WHERE WorkOrderAutoGenerationId in (658688, 658689, 658690, 658691, 658692)   (Thread: AnyIO worker thread) - __SPLIT__
2026-04-27 21:43:53,201 - [24715] - src.utils.log - INFO - ✅ Records deleted successfully - __SPLIT__
2026-04-27 21:43:53,883 - [24715] - src.utils.log - INFO - 🗑️ Deleting records: DELETE FROM ServiceCore.WorkOrderAutoGenerationSalesPersonCommission WHERE WorkOrderAutoGenerationId in (658688, 658689, 658690, 658691, 658692)   (Thread: AnyIO worker thread) - __SPLIT__
2026-04-27 21:43:54,858 - [24715] - src.utils.log - INFO - ✅ Records deleted successfully - __SPLIT__
2026-04-27 21:43:55,520 - [24715] - src.utils.log - INFO - 🗑️ Deleting records: DELETE FROM ServiceCore.WorkOrderAutoGenerationAppliedDiscount WHERE WorkOrderAutoGenerationId in (658688, 658689, 658690, 658691, 658692)   (Thread: AnyIO worker thread) - __SPLIT__
2026-04-27 21:43:56,258 - [24715] - src.utils.log - INFO - ✅ Records deleted successfully - __SPLIT__
2026-04-27 21:43:56,918 - [24715] - src.utils.log - INFO - 🗑️ Deleting records: DELETE FROM ServiceCore.SetupAutoGenerationSourceMapping WHERE WorkOrderAutoGenerationId in (658688, 658689, 658690, 658691, 658692)   (Thread: AnyIO worker thread) - __SPLIT__
2026-04-27 21:43:57,618 - [24715] - src.utils.log - INFO - ✅ Records deleted successfully - __SPLIT__
2026-04-27 21:43:58,281 - [24715] - src.utils.log - INFO - 🗑️ Deleting records: DELETE FROM ServiceCore.SubWorkOrderAutoGeneration WHERE WorkOrderAutoGenerationId in (658688, 658689, 658690, 658691, 658692)   (Thread: AnyIO worker thread) - __SPLIT__
2026-04-27 21:43:58,978 - [24715] - src.utils.log - INFO - ✅ Records deleted successfully - __SPLIT__
2026-04-27 21:43:59,636 - [24715] - src.utils.log - INFO - 🗑️ Deleting records: DELETE FROM ServiceCore.WorkOrderAutoGenerationCommissionAdjustment WHERE WorkOrderAutoGenerationId in (658688, 658689, 658690, 658691, 658692)   (Thread: AnyIO worker thread) - __SPLIT__
2026-04-27 21:44:00,325 - [24715] - src.utils.log - INFO - ✅ Records deleted successfully - __SPLIT__
2026-04-27 21:44:00,992 - [24715] - src.utils.log - INFO - 🗑️ Deleting records: DELETE FROM ServiceCore.WorkOrderAutoGeneration WHERE WorkOrderAutoGenerationId in (658688, 658689, 658690, 658691, 658692)   (Thread: AnyIO worker thread) - __SPLIT__
2026-04-27 21:44:01,720 - [24715] - src.utils.log - INFO - ✅ Records deleted successfully - __SPLIT__
2026-04-27 21:44:02,377 - [24715] - src.utils.log - INFO - Work order published ids: (658688, 658689, 658690, 658691, 658692) - __SPLIT__
2026-04-27 21:44:03,042 - [24715] - src.utils.log - INFO - Time took to perform operation in publishing [24715]: 121.0 - __SPLIT__
2026-04-27 21:44:03,699 - [24715] - src.utils.log - INFO - Publish Completed for GenerateWorkOrderHistoryId: [24715] - __SPLIT__
2026-04-27 21:44:04,357 - [24715] - src.utils.log - INFO - 📝 Executing: UPDATE ServiceCore.GenerateWorkOrderHistory SET PublishStatus = 'Completed', 
                        PublishStatusDateTime = '2026-04-27 17:44:02.377' WHERE CompanyId = 133 AND 
                        GenerateWorkOrderHistoryId = 24715;... (Thread: AnyIO worker thread) - __SPLIT__
2026-04-27 21:44:05,039 - [24715] - src.utils.log - INFO - ✅ Command executed successfully - __SPLIT__