SVE Client Logs

From SVE Wiki
Jump to navigation Jump to search

SVE Client Logs

The Settlement Verifier for Enterprises keeps extensive logs. The path to the logs is X:\Program Installs\SV-E\Logs.

Log Example (Successful Run)

Timestamp Level Log Entry Information
2019-07-13 01:45:00.3289 Info AutoUpdate is enabled. We are checking for updates at this time
2019-07-13 01:45:00.3445 Info =====================================================================
2019-07-13 01:45:00.3445 Info =NEW RUN NEW RUN NEW RUN NEW RUN NEW RUN NEW RUN NEW RUN=
2019-07-13 01:45:00.3445 Info =====================================================================
2019-07-13 01:45:00.3445 Info AutoUpdate: No update available at this time
2019-07-13 01:45:00.3445 Info Load Event: AutoStart is set to true
2019-07-13 01:45:01.3585 Info Timer Tick: The timer is ticking
2019-07-13 01:45:02.3725 Info Timer Tick: The timer is ticking
2019-07-13 01:45:03.3885 Info Timer Tick: The timer is ticking
2019-07-13 01:45:04.4025 Info Timer Tick: The timer is ticking
2019-07-13 01:45:05.4165 Info Timer Tick: The timer is ticking
2019-07-13 01:45:06.4305 Info Timer Tick: The timer is ticking
2019-07-13 01:45:07.4445 Info Timer Tick: The timer is ticking
2019-07-13 01:45:08.4585 Info Timer Tick: The timer is ticking
2019-07-13 01:45:09.4735 Info Timer Tick: The timer is ticking
2019-07-13 01:45:10.4875 Info Timer Tick: The timer is ticking
2019-07-13 01:45:11.5015 Info Timer Tick: The timer is ticking
2019-07-13 01:45:12.5165 Info Timer Tick: The timer is ticking
2019-07-13 01:45:13.5305 Info Timer Tick: The timer is ticking
2019-07-13 01:45:14.5445 Info Timer Tick: The timer is ticking
2019-07-13 01:45:15.5595 Info Timer Tick: The timer is ticking
2019-07-13 01:45:16.5735 Info Timer Tick: The timer is ticking
2019-07-13 01:45:17.5875 Info Timer Tick: The timer is ticking
2019-07-13 01:45:18.6015 Info Timer Tick: The timer is ticking
2019-07-13 01:45:19.6155 Info Timer Tick: The timer is ticking
2019-07-13 01:45:20.6295 Info Timer Tick: The timer is ticking
2019-07-13 01:45:21.6445 Info Timer Tick: The timer is ticking
2019-07-13 01:45:22.6585 Info Timer Tick: The timer is ticking
2019-07-13 01:45:23.6725 Info Timer Tick: The timer is ticking
2019-07-13 01:45:24.6875 Info Timer Tick: The timer is ticking
2019-07-13 01:45:25.7015 Info Timer Tick: The timer is ticking
2019-07-13 01:45:26.7155 Info Timer Tick: The timer is ticking
2019-07-13 01:45:27.7295 Info Timer Tick: The timer is ticking
2019-07-13 01:45:28.7435 Info Timer Tick: The timer is ticking
2019-07-13 01:45:29.7575 Info Timer Tick: The timer is ticking
2019-07-13 01:45:30.7725 Info Timer Tick: The timer is ticking
2019-07-13 01:45:30.7725 Info Timer Tick: The timer stopped ticking
2019-07-13 01:45:30.7881 Info === Starting to check the grind files ===
2019-07-13 01:45:30.8037 Info GNDFILES: Getting ready to inspect grinded files
2019-07-13 01:45:30.8037 Info DSR GND Calc: Sub entered
2019-07-13 01:45:30.8193 Info DSR GND Calc: Created database connection
2019-07-13 01:45:30.8349 Info DSR GND Calc: System.Data.OleDb.OleDbConnection
2019-07-13 01:45:30.8661 Info DSR GND Calc: Calculating AMEX
2019-07-13 01:45:30.8817 Error DSR GND Calc: Conversion from type 'DBNull' to type 'Decimal' is not valid.
2019-07-13 01:45:30.8817 Info DSR GND Calc: Calculating VISA
2019-07-13 01:45:30.8973 Info DSR GND Calc: Calculating MASTERCARD
2019-07-13 01:45:30.8973 Info DSR GND Calc: Calculating DISCOVER
2019-07-13 01:45:30.9441 Info DSR GND Calc: Starting to calculate the totals
2019-07-13 01:45:30.9441 Info DSR GND Calc: Calculating grand totals
2019-07-13 01:45:30.9441 Info DSR GND Calc: Returning totals to other subs
2019-07-13 01:45:30.9441 Info DSR GND Calc: Sub entered
2019-07-13 01:45:30.9441 Info DSR GND Calc: Created database connection
2019-07-13 01:45:30.9441 Info DSR GND Calc: System.Data.OleDb.OleDbConnection
2019-07-13 01:45:30.9441 Info DSR GND Calc: Calculating AMEX
2019-07-13 01:45:30.9597 Error DSR GND Calc: Conversion from type 'DBNull' to type 'Decimal' is not valid.
2019-07-13 01:45:30.9597 Info DSR GND Calc: Calculating VISA
2019-07-13 01:45:30.9753 Info DSR GND Calc: Calculating MASTERCARD
2019-07-13 01:45:30.9753 Info DSR GND Calc: Calculating DISCOVER
2019-07-13 01:45:31.0377 Info DSR GND Calc: Starting to calculate the totals
2019-07-13 01:45:31.0377 Info DSR GND Calc: Calculating grand totals
2019-07-13 01:45:31.0377 Info DSR GND Calc: Returning totals to other subs
2019-07-13 01:45:31.0377 Info GNDFILES: Subroutine complete
2019-07-13 01:45:31.0377 Info === Starting to check the settlement certificate ===
2019-07-13 01:45:31.0377 Info Previous date: 20190712
2019-07-13 01:45:31.0377 Info Todays Date: 20190713
2019-07-13 01:45:31.0377 Info Checking for settlment certificate
2019-07-13 01:45:31.0377 Info CheckForSettlementCert: Sub entered
2019-07-13 01:45:31.0377 Info CheckForSettlementCert: Checking for certificate
2019-07-13 01:45:31.0377 Info CheckForSettlementCert: Looking for C:\BOOTDRV\EDC\VISANET\20190713.STL
2019-07-13 01:45:31.0377 Info CheckForSettlementCert: We've got it
2019-07-13 01:45:31.0377 Info CheckForSettlementCert: Returning boolean DoWeHaveIt
2019-07-13 01:45:31.0377 Info Settlement Cert: Settlement certificate exists
2019-07-13 01:45:31.0377 Info STLPARSE: Beginning to parse the settlement certificate
2019-07-13 01:45:31.0377 Info STLPARSE-VISANET: Regex is starting
2019-07-13 01:45:31.0377 Info STLPARSE: Looping through settlement certificate
2019-07-13 01:45:31.0533 Info STLPARSE: Looping through settlement certificate complete
2019-07-13 01:45:31.0533 Info STLPARSE: We closed the settlement certificate
2019-07-13 01:45:31.0533 Info STLPARSE: Settlement parsed successfully
2019-07-13 01:45:31.0533 Info STLPARSE: EdcAmount - 6953.38
2019-07-13 01:45:31.0533 Info STLPARSE: EdcCount - 447
2019-07-13 01:45:31.0533 Info STLPARSE: Completed sub-routine
2019-07-13 01:45:31.0533 Info EDCvsDSR: Starting to compare values
2019-07-13 01:45:31.0533 Info EDCvsDSR: Checking variances
2019-07-13 01:45:31.0533 Info DSR GND Calc: Sub entered
2019-07-13 01:45:31.0533 Info DSR GND Calc: Created database connection
2019-07-13 01:45:31.0533 Info DSR GND Calc: System.Data.OleDb.OleDbConnection
2019-07-13 01:45:31.0689 Info DSR GND Calc: Calculating AMEX
2019-07-13 01:45:31.0845 Error DSR GND Calc: Conversion from type 'DBNull' to type 'Decimal' is not valid.
2019-07-13 01:45:31.0845 Info DSR GND Calc: Calculating VISA
2019-07-13 01:45:31.0845 Info DSR GND Calc: Calculating MASTERCARD
2019-07-13 01:45:31.1001 Info DSR GND Calc: Calculating DISCOVER
2019-07-13 01:45:31.1469 Info DSR GND Calc: Starting to calculate the totals
2019-07-13 01:45:31.1469 Info DSR GND Calc: Calculating grand totals
2019-07-13 01:45:31.1469 Info DSR GND Calc: Returning totals to other subs
2019-07-13 01:45:31.1469 Info DSRvsEDC: Sub entered
2019-07-13 01:45:31.1469 Info DSRvsEDC: difference calculated as 0.00
2019-07-13 01:45:31.1469 Info EDCvsDSR: Variance calculated as 0.00
2019-07-13 01:45:31.1469 Info EDCvsDSR: Variance sub-routine complete
2019-07-13 01:45:31.1469 Info SV-E to Web Services: Client process started
2019-07-13 01:45:31.1469 Info Getting ready to build the web client
2019-07-13 01:45:31.1625 Info Production web service invocation
2019-07-13 01:45:31.7085 Info SOAP Settlement recorded successfully on PROD
2019-07-13 01:45:32.1141 Error SVEPI0 Record insertion failure: Response is not well-formed XML.
2019-07-13 01:45:32.1297 Info Successfully sent SOAP request
2019-07-13 02:45:20.3791 Info Timer Tick: The AutoClose Timer is closing the application since it has been open for 60 minutes

Log Example (First Run)

Timestamp Level Log Entry Information
2019-07-12 18:32:16.9194 Info =====================================================================
2019-07-12 18:32:16.9284 Info =NEW RUN NEW RUN NEW RUN NEW RUN NEW RUN NEW RUN NEW RUN=
2019-07-12 18:32:16.9284 Info =====================================================================
2019-07-12 18:32:16.9284 Info AutoUpdate: No update available at this time
2019-07-12 18:32:16.9284 Info Load: Unable to find company ID - forcing options
2019-07-12 18:32:17.0104 Info Options: Loading the options now
2019-07-12 18:32:17.0104 Info License Key: Build one
2019-07-12 18:35:23.4225 Info Saving Keys: Trying to write to registry with new values
2019-07-12 18:35:23.7235 Info Starting registration with production endpoint
2019-07-12 18:35:23.9745 Info SOAP Client built
2019-07-12 18:35:46.4391 Info Registration successful
2019-07-12 19:09:41.0486 Info User is testing production web service
2019-07-12 19:09:41.2391 Info Production test succeeded
2019-07-12 19:09:57.3322 Info User is testing legacy web service
2019-07-12 19:09:57.5232 Info Legacy test succeeded
2019-07-12 19:13:19.8222 Info OptionsMnu: Opened options panel
2019-07-12 19:13:19.8222 Info Options: Loading the options now
2019-07-12 19:13:19.8222 Info License Key: Build one
2019-07-12 19:13:31.6304 Info RunNow: User ran scan manually via menu
2019-07-12 19:13:31.6934 Info === Starting to check the grind files ===
2019-07-12 19:13:31.6934 Info GNDFILES: Getting ready to inspect grinded files
2019-07-12 19:13:31.7084 Info DSR GND Calc: Sub entered
2019-07-12 19:13:31.7364 Info DSR GND Calc: Created database connection
2019-07-12 19:13:31.7374 Info DSR GND Calc: System.Data.OleDb.OleDbConnection
2019-07-12 19:13:32.0144 Error GNDFILES: '\20190711' is not a valid path. Make sure that the path name is spelled correctly and that you are connected to the server on which the file resides.
2019-07-12 19:13:32.0194 Info InsertMissingTndrDbf: Entered sub
2019-07-12 19:13:32.0194 Info InsertMissingTndrDbf: Creating SOAP client
2019-07-12 19:13:33.8684 Error InsertMissingTndrDbf: An error occurred
2019-07-12 19:13:33.8684 Error InsertMissingTndrDbf: Client found response content type of 'text/html; charset=UTF-8', but expected 'text/xml'. The request failed with an empty response.
2019-07-12 19:13:34.0744 Info Legacy enpoint insertion successful
2019-07-12 19:13:34.0744 Info GNDFILES: Subroutine complete
2019-07-12 19:13:34.0744 Info === Starting to check the settlement certificate ===
2019-07-12 19:13:34.0744 Info Previous date: 20190711
2019-07-12 19:13:34.0744 Info Todays Date: 20190712
2019-07-12 19:13:34.0744 Info Checking for settlment certificate
2019-07-12 19:13:34.0804 Info CheckForSettlementCert: Sub entered
2019-07-12 19:13:34.0804 Info CheckForSettlementCert: Checking for certificate
2019-07-12 19:13:34.0804 Info CheckForSettlementCert: Looking for \20190712.STL
2019-07-12 19:13:34.0804 Error CheckForSettlementCert: We don't have it
2019-07-12 19:13:34.0804 Info CheckForSettlementCert: Returning boolean DoWeHaveIt
2019-07-12 19:13:34.0804 Info CheckForSettlementCert: Sub entered
2019-07-12 19:13:34.0804 Info CheckForSettlementCert: Checking for certificate
2019-07-12 19:13:34.0804 Info CheckForSettlementCert: Looking for \20190712.STL
2019-07-12 19:13:34.0804 Error CheckForSettlementCert: We don't have it
2019-07-12 19:13:34.0804 Info CheckForSettlementCert: Returning boolean DoWeHaveIt
2019-07-12 19:13:34.0804 Error Settlement Cert: Settlment certificate failed -- settlement may not have run
2019-07-12 19:13:34.0804 Error Settlement Cert: Failure was noticed. Inserting zero record
2019-07-12 19:13:34.0804 Info InsertMissingStlCertificate: Entered sub
2019-07-12 19:13:34.0804 Info InsertMissingStlCertificate: Creating table adapter
2019-07-12 19:13:34.0964 Info DSRvsEDC: Sub entered
2019-07-12 19:13:34.0964 Info DSRvsEDC: difference calculated as 0
2019-07-12 19:13:34.2184 Info DSRvsEDC: Sub entered
2019-07-12 19:13:34.2184 Info DSRvsEDC: difference calculated as 0
2019-07-12 19:13:34.2284 Info InsertMissingStlCertificate: Zero record was inserted
2019-07-12 19:14:04.0446 Info === Settlement Cert: Ending settlement certificate verification ===
2019-07-12 19:14:04.0446 Info STLPARSE: Beginning to parse the settlement certificate