6/14/2012 1:17:38 PM Debug StartDBLoggerThread - enter 6/14/2012 1:17:38 PM Debug StartDBLoggerThread - exit 6/14/2012 1:17:38 PM Debug InternalWorkerThreadClass was created 6/14/2012 1:17:38 PM Debug Credential provider test ok. 6/14/2012 1:17:38 PM Debug Output folder: C:\ProgramData\VisualCron\output 6/14/2012 1:17:38 PM Info VisualCron - Server: 6.1.1 - build: 14806 - protocol: 6.0.9 6/14/2012 1:17:38 PM Info Cleaning up local database according to cleanup rules 6/14/2012 1:17:38 PM Debug CleanLocalDB - retrieve stats - start 6/14/2012 1:17:38 PM Debug CleanLocalDB - retrieve stats - end 6/14/2012 1:17:38 PM Debug CleanLocalDB - start 6/14/2012 1:17:38 PM Debug CleanLocalDB - end 6/14/2012 1:17:38 PM Debug Startup path: C:\Program Files (x86)\VisualCron 6/14/2012 1:17:38 PM Debug SettingsAPI.HDSerial(0): 3816CE84 6/14/2012 1:17:38 PM Debug SettingsAPI.HDSerial(1): 3816CE84 6/14/2012 1:17:38 PM Info Verifying license, loaded (False) 6/14/2012 1:17:38 PM Debug Before GetSetTrialTime (VerifyLicense): Trial 6/14/2012 1:17:38 PM Debug GetSetTrialTime result (VerifyLicense): 3 6/14/2012 1:17:38 PM Debug Loading license file 6/14/2012 1:17:38 PM Debug License location 1: C:\Program Files (x86)\VisualCron\settings\license.xml 6/14/2012 1:17:38 PM Debug License location 2: C:\Windows\system32\isx\licsystem.xml 6/14/2012 1:17:39 PM Info Server Id: 68bfb201-eb6e-457c-a603-cca75a206e75 6/14/2012 1:17:39 PM Debug License file was succesfully loaded 6/14/2012 1:17:39 PM Debug Saving license file 6/14/2012 1:17:39 PM Info Server Id: 68bfb201-eb6e-457c-a603-cca75a206e75 6/14/2012 1:17:39 PM Debug License file was saved successfully 6/14/2012 1:17:39 PM Debug Activation code: bdd677a6-6f9f-4a3c-9108-366062e181be 6/14/2012 1:17:39 PM Debug LoadLicenseFile result (VerifyLicense): 0 6/14/2012 1:17:39 PM Debug Successful verification of Activation code 6/14/2012 1:17:39 PM Info License status: Activated 6/14/2012 1:17:39 PM Debug Loading language 6/14/2012 1:17:39 PM Debug Loading Variables 6/14/2012 1:17:40 PM Info Loaded: 24 Variable(s) 6/14/2012 1:17:40 PM Info No Certificates loaded, file not found 6/14/2012 1:17:40 PM Debug Loading connections 6/14/2012 1:17:40 PM Info Loaded: 15 FTP connection(s) 6/14/2012 1:17:40 PM Debug Loading users 6/14/2012 1:17:40 PM Info Loaded: 7 users(s) 6/14/2012 1:17:40 PM Debug Loading Conditions 6/14/2012 1:17:40 PM Info Loaded: 2 Condition(s) 6/14/2012 1:17:40 PM Debug PGP Key Rings file did not exist. 6/14/2012 1:17:40 PM Debug Time exceptions file did not exist. 6/14/2012 1:17:40 PM Debug Loading network credentials 6/14/2012 1:17:41 PM Debug Loaded: 2 network credential(s) 6/14/2012 1:17:41 PM Debug Loading Notifications 6/14/2012 1:17:41 PM Info Loaded: 10 notifications(s) 6/14/2012 1:17:41 PM Debug Loading Network Drives 6/14/2012 1:17:41 PM Info 3 network drive(s) were loaded 6/14/2012 1:17:41 PM Debug ConnectNetworkDrives() 6/14/2012 1:17:41 PM Err Could not find Credential when mapping drive. 6/14/2012 1:17:41 PM Err Network drive T:(\\sdc1as062\xfer) could not be mounted. 6/14/2012 1:17:41 PM Info No credentials was found when mapping drive. 6/14/2012 1:17:41 PM Err Could not map drive, error (4): Access is denied 6/14/2012 1:17:41 PM Err Network drive Y:(\\nas-dq2\dq) could not be mounted. 6/14/2012 1:17:41 PM Info No credentials was found when mapping drive. 6/14/2012 1:17:42 PM Err Could not map drive, error (4): Access is denied 6/14/2012 1:17:42 PM Err Network drive Z:(\\nas-dq1\dq) could not be mounted. 6/14/2012 1:17:42 PM Debug AddNonControlledNetworkDrives() 6/14/2012 1:17:42 PM Debug Exiting NetworkDrivesAPI.Load 6/14/2012 1:17:42 PM Debug Loading jobs 6/14/2012 1:17:47 PM Info Loaded: 109 job(s) 6/14/2012 1:17:47 PM Info Deleteting all output files in: C:\ProgramData\VisualCron\output 6/14/2012 1:17:47 PM Debug Expiring old triggers 6/14/2012 1:17:47 PM Info Skipping RunMissed because the server is off 6/14/2012 1:17:47 PM Debug Recalculating all jobs 6/14/2012 1:17:47 PM Debug Next execution (6) for job 'Backup settings' is: 6/14/2012 11:00:00 PM 6/14/2012 1:17:47 PM Debug Next execution (6) for job 'Delete old log files' is: 6/14/2012 11:10:00 PM 6/14/2012 1:17:47 PM Debug Next execution (6) for job 'CRODS Load' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job 'RACV Data Load' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job 'HUON Data Load' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job 'Microsite Match' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '010 - Run Profile ADDR_DPID' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job 'CRODS Customer Monthly SCORECARDS' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job 'Peter Stroud - HOME PIF REL CODES' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job 'NZ OGM' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job 'Electronic Address Stats - Mktg' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job 'TEST EXCEL MACRO' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job 'MDM CRODS Load' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job 'MDM HUON Load' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job 'test1' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job 'MDM CRODS Load_DEV' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job 'Test Parm' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job 'CRODS Transaction Load' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job 'Harmony' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '090 - Run Profile DPID' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job 'CRODS 10-Monthly Load' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job 'Support Test' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '020 - Run Profile ADDR_GID' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '030 - Run Profile ADDRESS' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '040 - Run Profile ADDRESS_XREF' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '050 - Run Profile ASSET' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '060 - Run Profile BUS_MISC_ITEM' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '070 - Run Profile BUS_ROLE_REL' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '080 - Run Profile CONTACT' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '100 - Run Profile ELEC_ADDR' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '110 - Run Profile GEO_TRAN_LOG' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '120 - Run Profile GEOCODE' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '130 - Run Profile GEOCODE_LOAD_ERRORS' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '140 - Run Profile GroupDistEAFlags' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '150 - Run Profile GroupPartyFlags' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '160 - Run Profile GPPA' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '170 - Run Profile GRPN' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '180 - Run Profile IGAM' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '190 - Run Profile MISC_ITEM' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '200 - Run Profile NAME' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '210 - Run Profile PARTY' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '220 - Run Profile PARTY_GROUP' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '230 - Run Profile PARTY_GROUP_TXN' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '240 - Run Profile PARTY_GROUP_ROLE' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '250 - Run Profile PartyAttribs' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '260 - Run Profile PotDupPartyGroup' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '270 - Run Profile QUOTE_TRIGGER' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '280 - Run Profile Ref_Data' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '290 - Run Profile RFR_DCLN' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '300 - Run Profile SCVPAF_TRAN_NZ' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job 'DQPUBLISH' is: 6/18/2012 7:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '310 - Run Profile SCVR_BEST_ADDR_PRGID' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '320 - Run Profile SCVR_BEST_ADDR' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '330 - Run Profile SCVR_CONTROL_NZ' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '340 - Run Profile SCVR_DCLN_CUST' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '350 - Run Profile SCVR_REPORT_CONTROL' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '360 - Run Profile SRC_SYS_BUS' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '370 - Run Profile TEAM_ACCESS' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '380 - Run Profile TRANSACTION' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '390 - Run Profile TRAN_FOLLOWUP' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '400 - Run Profile WHITE_PAGES_EXTRACT' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '410 - Run Profile WHITE_PAGES_RESULTS' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job 'HUON Monthly Data Load' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job 'CRODS 20-Transaction Load' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job 'CRODS 30-Archive Files' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '010 - Export and Load Profiling Results for CRODS tables' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '020 - Get Frequency results and Load CRODS -ADDR_DPID' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '010 - Run Profile ADDPID' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '020 - Run Profile ADDRESS' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '030 - Run Profile ADDRREF' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '040 - Run Profile ADRGEO' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '050 - Run Profile BPT031C' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '060 - Run Profile BPT038' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '070 - Run Profile BPT041' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '080 - Run Profile BPT042' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '090 - Run Profile BPT052' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '100 - Run Profile BPT055' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '110 - Run Profile BPT065' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '120 - Run Profile BPT099' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '130 - Run Profile CLIENT' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '140 - Run Profile CLTACS' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '150 - Run Profile CLTDET' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '160 - Run Profile CLTDUP' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '170 - Run Profile CLTQTC' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '180 - Run Profile CLTREF' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '190 - Run Profile CLTROLE' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '200 - Run Profile CLTTH' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '210 - Run Profile DRVLIC' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '220 - Run Profile FONREF' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '230 - Run Profile LOCASS_BOTCVT' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '240 - Run Profile LOCASS_HOM' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '250 - Run Profile LOCASS_MOT' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '260 - Run Profile MMPDBOT' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '270 - Run Profile MMPDCVT' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '280 - Run Profile MMPDHOM' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '290 - Run Profile MMPDMOT' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '300 - Run Profile MPDDUP' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '310 - Run Profile MPDRFND' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '320 - Run Profile MSGHIS' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '330 - Run Profile NAME' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '340 - Run Profile OTHPARTY' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '350 - Run Profile POLICY_CTP' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '360 - Run Profile POLICY_HOM' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '370 - Run Profile POLICY_MOT' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '380 - Run Profile POLICY_NICHE' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '390 - Run Profile POLICY_NOTMOT' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '400 - Run Profile POLMSG_FULL' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '410 - Run Profile SCHITEM' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Next execution (6) for job '420 - Run Profile TOWNPROF' is: 12:00:00 AM 6/14/2012 1:17:47 PM Debug Starting main threads 6/14/2012 1:17:47 PM Debug Flushing memory 6/14/2012 1:17:47 PM Debug InternalWorkerThreadClass was started 6/14/2012 1:17:47 PM Debug Startup finished 6/14/2012 1:17:47 PM Debug Starting IPC server. 6/14/2012 1:17:47 PM Debug Server certificate read 6/14/2012 1:17:47 PM Debug VisualCron - Server starting on port: 16444 6/14/2012 1:17:47 PM Info Starting IPV6 listener 6/14/2012 1:17:53 PM Debug Before sending ClientConnection. 6/14/2012 1:17:56 PM Debug Before sending ClientConnection. 6/14/2012 1:17:56 PM Debug Using normal logon (False) 6/14/2012 1:17:56 PM Info Verifying license, loaded (True) 6/14/2012 1:17:56 PM Debug License status (VerifyLicense): Activated 6/14/2012 1:17:56 PM Info User "VisualCron Default Admin" (admin) - Logged in succesfully through IPC (346ef82c-e3c8-4525-b13f-6c2b8c3df59a) 6/14/2012 1:17:56 PM Debug Updating login status for: 346ef82c-e3c8-4525-b13f-6c2b8c3df59a 6/14/2012 1:17:56 PM Debug Before sending ClientConnection. 6/14/2012 1:17:56 PM Comm IN: SERVERSETTINGSREQ 6/14/2012 1:17:56 PM Debug Server time: 6/14/2012 1:17:56 PM 6/14/2012 1:17:56 PM Comm IN: LICENSEREQ 6/14/2012 1:17:56 PM Info ServerId: 68bfb201-eb6e-457c-a603-cca75a206e75 6/14/2012 1:18:00 PM Debug Server time: 6/14/2012 1:18:00 PM 6/14/2012 1:18:00 PM Debug File watcher started. Directory: E:\XFER\Marketing\in, filter: MICRO_DQ_extract_trigger.* 6/14/2012 1:18:00 PM Debug File watcher started. Directory: E:\XFER\iag_dsapp\DQ\DEV\Trigger, filter: CRODS_LOAD_COMPLETE.* 6/14/2012 1:18:00 PM Debug File watcher started. Directory: E:\XFER\iag_dsapp\DQ\DEV\Trigger, filter: Start_TRAN_FTP.txt 6/14/2012 1:18:00 PM Debug File watcher started. Directory: E:\XFER\iag_dsapp\DQ\DEV\Trigger, filter: HUON_Load_Complete.* 6/14/2012 1:18:00 PM Debug File watcher started. Directory: E:\XFER\iag_dsapp\DQ\DEV\Trigger, filter: DISQL03_CRODS_Dataload_Complete.* 6/14/2012 1:18:00 PM Debug File watcher started. Directory: E:\XFER\iag_dsapp\DQ\DEV\inbound\BONUS, filter: 'DQTPROD.JSDQT120.TBCUSLOG.UNLOAD*.* 6/14/2012 1:18:00 PM Debug File watcher started. Directory: E:\XFER\iag_dsapp\DQ\DEV\Trigger, filter: Start_TRAN_FTP.txt 6/14/2012 1:18:00 PM Debug Saving settings 6/14/2012 1:18:00 PM Debug Server time: 6/14/2012 1:18:00 PM 6/14/2012 1:18:00 PM Info User 'VisualCron Default Admin' - Updated Server settings 6/14/2012 1:18:05 PM Debug Before sending ClientConnection. 6/14/2012 1:18:05 PM Debug Using normal logon (False) 6/14/2012 1:18:05 PM Info Verifying license, loaded (True) 6/14/2012 1:18:05 PM Debug License status (VerifyLicense): Activated 6/14/2012 1:18:05 PM Info User "VisualCron Tray Client User" (TrayClientUser) - Logged in succesfully through IPC (f8445a6b-15eb-4033-a1cf-f01597cd32e6) 6/14/2012 1:18:05 PM Debug Updating login status for: f8445a6b-15eb-4033-a1cf-f01597cd32e6 6/14/2012 1:18:05 PM Debug Before sending ClientConnection. 6/14/2012 1:18:05 PM Comm IN: SERVERSETTINGSREQ 6/14/2012 1:18:05 PM Debug Server time: 6/14/2012 1:18:05 PM 6/14/2012 1:18:05 PM Comm IN: LICENSEREQ 6/14/2012 1:18:05 PM Info ServerId: 68bfb201-eb6e-457c-a603-cca75a206e75 6/14/2012 1:18:13 PM Debug Before sending ClientConnection. 6/14/2012 1:18:13 PM Debug Using normal logon (False) 6/14/2012 1:18:13 PM Info Verifying license, loaded (True) 6/14/2012 1:18:13 PM Debug License status (VerifyLicense): Activated 6/14/2012 1:18:13 PM Info User "VisualCron Tray Client User" (TrayClientUser) - Logged in succesfully through IPC (cec3d919-00df-4bb6-a24b-24fd3ae9e717) 6/14/2012 1:18:13 PM Debug Updating login status for: cec3d919-00df-4bb6-a24b-24fd3ae9e717 6/14/2012 1:18:13 PM Debug Before sending ClientConnection. 6/14/2012 1:18:13 PM Comm IN: SERVERSETTINGSREQ 6/14/2012 1:18:13 PM Debug Server time: 6/14/2012 1:18:13 PM 6/14/2012 1:18:13 PM Comm IN: LICENSEREQ 6/14/2012 1:18:13 PM Info ServerId: 68bfb201-eb6e-457c-a603-cca75a206e75 6/14/2012 1:19:11 PM Info Job started: 060 - Run Profile BUS_MISC_ITEM 6/14/2012 1:19:11 PM Info User 'VisualCron Default Admin' - Ran Job: 060 - Run Profile BUS_MISC_ITEM 6/14/2012 1:19:11 PM Debug Job (1) was added to processlist: 060 - Run Profile BUS_MISC_ITEM 6/14/2012 1:19:11 PM Info Skipping Condition check because the Job was run manually. 6/14/2012 1:19:11 PM Debug Next action: ActionContinue 6/14/2012 1:19:11 PM Debug Calling GetNextTaskProcess() 6/14/2012 1:19:11 PM Debug Next Task is: Set Current Date Time Check Variable 6/14/2012 1:19:11 PM Debug Next action: ActionContinue 6/14/2012 1:19:11 PM Debug Calling StartTaskProcess() with Task: Set Current Date Time Check Variable (0) 6/14/2012 1:19:11 PM Debug Task (1) was added to processlist: Set Current Date Time Check Variable 6/14/2012 1:19:11 PM Debug Entering wait loop. Set Current Date Time Check Variable (1) 6/14/2012 1:19:11 PM Info Task started: Set Current Date Time Check Variable (1) 6/14/2012 1:19:11 PM Debug Saving Variables 6/14/2012 1:19:11 PM Debug Saving Variables 6/14/2012 1:19:11 PM Info Variable 'store_date' was updated to: 201206141319 6/14/2012 1:19:11 PM Info Task completed: Set Current Date Time Check Variable (1) 6/14/2012 1:19:11 PM Debug Process status - About to RemoveTaskProcess (1) 6/14/2012 1:19:11 PM Debug Setting previous task in TaskProcessCompleted: Set Current Date Time Check Variable (635b93ac-a62e-4c57-bf28-9c73b8be1f46) in job: 060 - Run Profile BUS_MISC_ITEM 6/14/2012 1:19:11 PM Debug Process status - About to SendTaskProcess (1) 6/14/2012 1:19:11 PM Debug Process status - About to RemoveTaskProcess (1) 6/14/2012 1:19:11 PM Debug Task (1) was removed from processlist: Set Current Date Time Check Variable 6/14/2012 1:19:11 PM Debug Sleep ended because Task ended.Set Current Date Time Check Variable (1) 6/14/2012 1:19:11 PM Debug TaskWaitQueue.Dequeued.Set Current Date Time Check Variable (1) 6/14/2012 1:19:11 PM Debug Else (1)Set Current Date Time Check Variable (1) 6/14/2012 1:19:11 PM Debug End of loop - iterating again.Set Current Date Time Check Variable (1) 6/14/2012 1:19:11 PM Debug Calling GetNextTaskProcess() 6/14/2012 1:19:11 PM Debug Next Task is: Reset chk_Datetime 6/14/2012 1:19:11 PM Debug Next action: ActionContinue 6/14/2012 1:19:11 PM Debug Calling StartTaskProcess() with Task: Reset chk_Datetime (0) 6/14/2012 1:19:11 PM Debug Task (2) was added to processlist: Reset chk_Datetime 6/14/2012 1:19:11 PM Debug Entering wait loop. Reset chk_Datetime (2) 6/14/2012 1:19:11 PM Info Task started: Reset chk_Datetime (2) 6/14/2012 1:19:11 PM Debug Saving Variables 6/14/2012 1:19:11 PM Debug Saving Variables 6/14/2012 1:19:11 PM Info Variable 'chk_Datetime' was updated to: 6/14/2012 1:19:11 PM Info Task completed: Reset chk_Datetime (2) 6/14/2012 1:19:11 PM Debug Process status - About to RemoveTaskProcess (2) 6/14/2012 1:19:11 PM Debug Setting previous task in TaskProcessCompleted: Reset chk_Datetime (8d6be2d2-922f-4927-abe1-52d9c680ca8b) in job: 060 - Run Profile BUS_MISC_ITEM 6/14/2012 1:19:11 PM Debug Process status - About to SendTaskProcess (2) 6/14/2012 1:19:11 PM Debug Process status - About to RemoveTaskProcess (2) 6/14/2012 1:19:11 PM Debug Task (2) was removed from processlist: Reset chk_Datetime 6/14/2012 1:19:11 PM Debug Sleep ended because Task ended.Reset chk_Datetime (2) 6/14/2012 1:19:11 PM Debug TaskWaitQueue.Dequeued.Reset chk_Datetime (2) 6/14/2012 1:19:11 PM Debug Else (1)Reset chk_Datetime (2) 6/14/2012 1:19:11 PM Debug End of loop - iterating again.Reset chk_Datetime (2) 6/14/2012 1:19:11 PM Debug Calling GetNextTaskProcess() 6/14/2012 1:19:11 PM Debug Next Task is: Reset prof_Stop_Loop variable on each new profile job 6/14/2012 1:19:11 PM Debug Next action: ActionContinue 6/14/2012 1:19:11 PM Debug Calling StartTaskProcess() with Task: Reset prof_Stop_Loop variable on each new profile job (0) 6/14/2012 1:19:11 PM Debug Task (3) was added to processlist: Reset prof_Stop_Loop variable on each new profile job 6/14/2012 1:19:11 PM Debug Entering wait loop. Reset prof_Stop_Loop variable on each new profile job (3) 6/14/2012 1:19:11 PM Info Task started: Reset prof_Stop_Loop variable on each new profile job (3) 6/14/2012 1:19:11 PM Debug Saving Variables 6/14/2012 1:19:11 PM Debug Saving Variables 6/14/2012 1:19:11 PM Info Variable 'prof_Stop_Loop' was updated to: NO 6/14/2012 1:19:11 PM Info Task completed: Reset prof_Stop_Loop variable on each new profile job (3) 6/14/2012 1:19:11 PM Debug Process status - About to RemoveTaskProcess (3) 6/14/2012 1:19:11 PM Debug Setting previous task in TaskProcessCompleted: Reset prof_Stop_Loop variable on each new profile job (942048be-adbd-4ffd-8fb6-7143032d4b29) in job: 060 - Run Profile BUS_MISC_ITEM 6/14/2012 1:19:11 PM Debug Process status - About to SendTaskProcess (3) 6/14/2012 1:19:11 PM Debug Process status - About to RemoveTaskProcess (3) 6/14/2012 1:19:11 PM Debug Task (3) was removed from processlist: Reset prof_Stop_Loop variable on each new profile job 6/14/2012 1:19:11 PM Debug Sleep ended because Task ended.Reset prof_Stop_Loop variable on each new profile job (3) 6/14/2012 1:19:11 PM Debug TaskWaitQueue.Dequeued.Reset prof_Stop_Loop variable on each new profile job (3) 6/14/2012 1:19:11 PM Debug Else (1)Reset prof_Stop_Loop variable on each new profile job (3) 6/14/2012 1:19:11 PM Debug End of loop - iterating again.Reset prof_Stop_Loop variable on each new profile job (3) 6/14/2012 1:19:11 PM Debug Calling GetNextTaskProcess() 6/14/2012 1:19:11 PM Debug Next Task is: Run Profiling - BUS_MISC_ITEM 6/14/2012 1:19:11 PM Debug Next action: ActionContinue 6/14/2012 1:19:11 PM Debug Calling StartTaskProcess() with Task: Run Profiling - BUS_MISC_ITEM (0) 6/14/2012 1:19:11 PM Debug Task (4) was added to processlist: Run Profiling - BUS_MISC_ITEM 6/14/2012 1:19:11 PM Debug Entering wait loop. Run Profiling - BUS_MISC_ITEM (4) 6/14/2012 1:19:11 PM Info Task started: Run Profiling - BUS_MISC_ITEM (4) 6/14/2012 1:19:12 PM Debug Process status - retrieving process id (4) 6/14/2012 1:19:13 PM Debug Process status - has left WaitForExit (4) 6/14/2012 1:19:13 PM Debug Process status - OutPut captured (4) 6/14/2012 1:19:13 PM Debug Process status - trying to retrieve exit code 6/14/2012 1:19:13 PM Debug Process status - ExitCode fetched (4) 6/14/2012 1:19:13 PM Debug Process status - ProcessHandles closed (4) 6/14/2012 1:19:13 PM Debug Ending timeout timer (4) 6/14/2012 1:19:13 PM Debug Ending output readers (4) 6/14/2012 1:19:13 PM Debug Closing desktop handles (4) 6/14/2012 1:19:13 PM Debug Process status - About to raise TaskCompleted (4) 6/14/2012 1:19:13 PM Info Task completed: Run Profiling - BUS_MISC_ITEM (4) 6/14/2012 1:19:13 PM Debug Process status - About to RemoveTaskProcess (4) 6/14/2012 1:19:13 PM Debug Setting previous task in TaskProcessCompleted: Run Profiling - BUS_MISC_ITEM (399b2f4d-2ef3-4057-b9cf-e330bd6ebbdd) in job: 060 - Run Profile BUS_MISC_ITEM 6/14/2012 1:19:13 PM Debug Process status - About to SendTaskProcess (4) 6/14/2012 1:19:13 PM Debug Process status - About to RemoveTaskProcess (4) 6/14/2012 1:19:13 PM Debug Task (4) was removed from processlist: Run Profiling - BUS_MISC_ITEM 6/14/2012 1:19:13 PM Debug Sleep ended because Task ended.Run Profiling - BUS_MISC_ITEM (4) 6/14/2012 1:19:13 PM Debug TaskWaitQueue.Dequeued.Run Profiling - BUS_MISC_ITEM (4) 6/14/2012 1:19:13 PM Debug Else (1)Run Profiling - BUS_MISC_ITEM (4) 6/14/2012 1:19:13 PM Debug End of loop - iterating again.Run Profiling - BUS_MISC_ITEM (4) 6/14/2012 1:19:13 PM Debug Calling GetNextTaskProcess() 6/14/2012 1:19:13 PM Debug Next Task is: Parse the status return value from the xml file 6/14/2012 1:19:13 PM Debug Next action: ActionContinue 6/14/2012 1:19:13 PM Debug Calling StartTaskProcess() with Task: Parse the status return value from the xml file (0) 6/14/2012 1:19:13 PM Debug Task (5) was added to processlist: Parse the status return value from the xml file 6/14/2012 1:19:13 PM Debug Entering wait loop. Parse the status return value from the xml file (5) 6/14/2012 1:19:13 PM Info Task started: Parse the status return value from the xml file (5) 6/14/2012 1:19:13 PM Debug Impersonation result 1: truetruetrueERGA\dqautofalse 6/14/2012 1:19:13 PM Info Impersonation result 2: True 6/14/2012 1:19:13 PM Info Task completed: Parse the status return value from the xml file (5) 6/14/2012 1:19:13 PM Debug Process status - About to RemoveTaskProcess (5) 6/14/2012 1:19:13 PM Debug Setting previous task in TaskProcessCompleted: Parse the status return value from the xml file (6d303fa3-1ba0-4222-9b94-5a60230bebd7) in job: 060 - Run Profile BUS_MISC_ITEM 6/14/2012 1:19:13 PM Debug Process status - About to SendTaskProcess (5) 6/14/2012 1:19:13 PM Debug Process status - About to RemoveTaskProcess (5) 6/14/2012 1:19:13 PM Debug Task (5) was removed from processlist: Parse the status return value from the xml file 6/14/2012 1:19:13 PM Debug Sleep ended because Task ended.Parse the status return value from the xml file (5) 6/14/2012 1:19:13 PM Debug TaskWaitQueue.Dequeued.Parse the status return value from the xml file (5) 6/14/2012 1:19:13 PM Debug Else (1)Parse the status return value from the xml file (5) 6/14/2012 1:19:13 PM Debug End of loop - iterating again.Parse the status return value from the xml file (5) 6/14/2012 1:19:13 PM Debug Calling GetNextTaskProcess() 6/14/2012 1:19:13 PM Debug Next Task is: Send an email if the current profile step has failed for a particular table 6/14/2012 1:19:13 PM Debug Next action: ActionContinue 6/14/2012 1:19:13 PM Debug Calling StartTaskProcess() with Task: Send an email if the current profile step has failed for a particular table (0) 6/14/2012 1:19:13 PM Debug Task (6) was added to processlist: Send an email if the current profile step has failed for a particular table 6/14/2012 1:19:13 PM Debug Entering wait loop. Send an email if the current profile step has failed for a particular table (6) 6/14/2012 1:19:13 PM Info Task started: Send an email if the current profile step has failed for a particular table (6) 6/14/2012 1:19:14 PM Info Task completed: Send an email if the current profile step has failed for a particular table (6) 6/14/2012 1:19:14 PM Debug Process status - About to RemoveTaskProcess (6) 6/14/2012 1:19:14 PM Debug Setting previous task in TaskProcessCompleted: Send an email if the current profile step has failed for a particular table (7d6bc1bd-9585-4604-86ec-4078d21a9c61) in job: 060 - Run Profile BUS_MISC_ITEM 6/14/2012 1:19:14 PM Debug Process status - About to SendTaskProcess (6) 6/14/2012 1:19:14 PM Debug Process status - About to RemoveTaskProcess (6) 6/14/2012 1:19:14 PM Debug Task (6) was removed from processlist: Send an email if the current profile step has failed for a particular table 6/14/2012 1:19:14 PM Debug Sleep ended because Task ended.Send an email if the current profile step has failed for a particular table (6) 6/14/2012 1:19:14 PM Debug TaskWaitQueue.Dequeued.Send an email if the current profile step has failed for a particular table (6) 6/14/2012 1:19:14 PM Debug Else (1)Send an email if the current profile step has failed for a particular table (6) 6/14/2012 1:19:14 PM Debug End of loop - iterating again.Send an email if the current profile step has failed for a particular table (6) 6/14/2012 1:19:14 PM Debug Calling GetNextTaskProcess() 6/14/2012 1:19:14 PM Debug Job (1) was removed from processlist: 060 - Run Profile BUS_MISC_ITEM 6/14/2012 1:19:14 PM Debug Next execution (2) for job '060 - Run Profile BUS_MISC_ITEM' is: 12:00:00 AM 6/14/2012 1:19:14 PM Info Job completed: 060 - Run Profile BUS_MISC_ITEM 6/14/2012 1:19:33 PM Debug Server time: 6/14/2012 1:19:33 PM 6/14/2012 1:19:33 PM Debug File trigger event has been ended, trigger: Trigger CRODS Customer Scorecard 6/14/2012 1:19:33 PM Debug File trigger event has been ended, trigger: Microsite FTP complete 6/14/2012 1:19:33 PM Debug File trigger event has been ended, trigger: HUON Load Complete trigger 6/14/2012 1:19:33 PM Debug File trigger event has been ended, trigger: HUON Load Complete trigger 6/14/2012 1:19:33 PM Debug File trigger event has been ended, trigger: Start_TRAN_FTP.txt 6/14/2012 1:19:33 PM Debug File trigger event has been ended, trigger: 6/14/2012 1:19:33 PM Debug File trigger event has been ended, trigger: Start_TRAN_FTP.txt 6/14/2012 1:19:33 PM Debug Saving settings 6/14/2012 1:19:33 PM Debug Server time: 6/14/2012 1:19:33 PM 6/14/2012 1:19:33 PM Info User 'VisualCron Default Admin' - Updated Server settings 6/14/2012 1:19:38 PM Debug Saving Jobs 6/14/2012 1:19:42 PM Info VisualCron service is being stopped 6/14/2012 1:19:42 PM Info VisualCron Server is shutting down 6/14/2012 1:19:42 PM Info Shutting down running processes 6/14/2012 1:19:42 PM Info Shutting down event triggers 6/14/2012 1:19:42 PM Info Shutting down listener. 6/14/2012 1:19:42 PM Debug Shutting down socket 6/14/2012 1:19:42 PM Debug Shutdown of socket reached final stage 6/14/2012 1:19:42 PM Debug Stopping loops and threads for timers 6/14/2012 1:19:42 PM Info Saving Jobs (109) 6/14/2012 1:19:42 PM Debug Saving Jobs 6/14/2012 1:19:42 PM Err TimePicker exits 6/14/2012 1:19:42 PM Err TimePutter exits 6/14/2012 1:19:42 PM Info Jobs saved (4132507) 6/14/2012 1:19:42 PM Debug VisualCron Service shutdown reached last stage 6/14/2012 1:19:42 PM Debug Ending DBLogger 6/14/2012 1:19:42 PM Debug Shutting down socket 6/14/2012 1:19:42 PM Debug Shutdown of socket reached final stage