We had it done by email and phone, I'm not getting either.
I changed a few things in here for privacy
Changed actual company name to "companyname"
My user is now "jsmith" and I changed the phone # to companyphone
03/05 12:01:46.565 DbgOut (00,5) 2336,2548: DllMain(hinstDLL=0x10000000, fdwReason=DLL_PROCESS_DETACH)
03/05 12:01:46.627 vmprov5s (06,8) ba4, b90: SOCKSTask::Main(VMServer [SOCKSTask] port 50791): Received request " VMMESSAGE_POLL Session=00000000, Seq=0" from 192.168.54.2:4098
03/05 12:01:46.629 vmprov5s (06,8) ba4, 5b0: [TCPServerThread[0]]: Processing server[192.168.54.2],m_User->Identifier()[192.168.54.2],PBXCount=[1], request " VMMESSAGE_POLL Session=00000000, Seq=0"
03/05 12:01:46.629 vmprov5s (26,6) ba4, 5b0: PBX <192.168.54.2> - Backup active = FALSE, backing up PBX <0.0.0.0>
03/05 12:01:46.629 vmprov5s (26,6) ba4, 5b0: POLL from 192.168.54.2:4098 contained the following sync info: bBackupActive=0, ulBackupIp=0.0.0.0, uCentralIP=0.0.0.0, tsPeerVMDNS=, tsPeerIPOName=company-Den, buf->data[35]=0, buf[31-34]=0.0.0.0
03/05 12:01:46.629 vmprov5s (06,8) ba4, 5b0: SOCKSTask::SendBuffer(VMServer [SOCKSTask] port 50791): Sending request " VMMESSAGE_DISTINFO Session=00000000, Seq=0" to server "192.168.54.2"
03/05 12:01:46.629 vmprov5s (06,8) ba4, 5b0: SOCKSTask::SendBuffer(VMServer [SOCKSTask] port 50791): Sending request " VMMESSAGE_SERVERUP Version=8.1.90.0" to server "192.168.54.2"
03/05 12:01:46.630 vmprov5s (06,8) ba4, 5b0: [TCPServerThread[0]]: Server[192.168.54.2], request " VMMESSAGE_POLL Session=00000000, Seq=0" - took 0.000ms
03/05 12:01:48.455 vmprov5s (14,9) ba4, f00: Check pending unsent emails
03/05 12:01:48.455 vmprov5s (26,6) ba4, f00: > VMailBox::ForwardPendingEmails()
03/05 12:01:48.455 vmprov5s (13,6) ba4, f00: Message being retried for mailbox jsmith is MSG00001
03/05 12:01:48.455 vmprov5s (1f,8) ba4, f00: > VMailBox::UpdateFileState(Mailbox: jsmith, Msg: MSG00001, State: Forward, IsPrivate: 0, IsPriority: 0, Notify: 1, MessageType: 1)
03/05 12:01:48.455 vmprov5s (1f,8) ba4, f00: < VMailBox::UpdateFileState()
03/05 12:01:48.455 vmprov5s (1d,8) ba4, f00: > tblMailbox::LocateMessage(Mailbox ID:{10a09752-740b-47df-ad87-ec7202e85c91}, Message Number:1)
03/05 12:01:48.456 vmprov5s (1d,8) ba4, f00: > tblMessage::GetRecord(Mailbox: {10a09752-740b-47df-ad87-ec7202e85c91}, ID:{0f6ceec5-e782-43fe-8941-b4464710763d})
03/05 12:01:48.458 vmprov5s (1d,8) ba4, f00: < tblMessage::GetRecord()
03/05 12:01:48.458 vmprov5s (1d,8) ba4, f00: < tblMailbox::LocateMessage()
03/05 12:01:48.458 vmprov5s (14,9) ba4, f00: EMailerRequest::Send: Queued email request for jsmith@companyname.com, subject is Voicemail Message (company name > jsmith) From:companynumber, use EMAPI=true
03/05 12:01:48.458 vmprov5s (13,6) ba4, f00: Message being retried for mailbox jsmith is MSG00002
03/05 12:01:48.458 vmprov5s (1f,8) ba4, f00: > VMailBox::UpdateFileState(Mailbox: jsmith, Msg: MSG00002, State: Forward, IsPrivate: 0, IsPriority: 0, Notify: 1, MessageType: 1)
03/05 12:01:48.458 vmprov5s (1f,8) ba4, f00: < VMailBox::UpdateFileState()
03/05 12:01:48.458 vmprov5s (1d,8) ba4, f00: > tblMailbox::LocateMessage(Mailbox ID:{10a09752-740b-47df-ad87-ec7202e85c91}, Message Number:2)
03/05 12:01:48.459 vmprov5s (1d,8) ba4, f00: > tblMessage::GetRecord(Mailbox: {10a09752-740b-47df-ad87-ec7202e85c91}, ID:{dead31c6-61ca-4537-b2ed-93fbfb7a030e})
03/05 12:01:48.461 vmprov5s (1d,8) ba4, f00: < tblMessage::GetRecord()
03/05 12:01:48.461 vmprov5s (1d,8) ba4, f00: < tblMailbox::LocateMessage()
03/05 12:01:48.461 vmprov5s (14,9) ba4, f00: EMailerRequest::Send: Queued email request for jsmith@companyname.com, subject is Voicemail Message (company name > ericw) From:companynumber, use EMAPI=true
03/05 12:01:48.461 vmprov5s (13,6) ba4, f00: Message being retried for mailbox jsmith is MSG00003
03/05 12:01:48.461 vmprov5s (1f,8) ba4, f00: > VMailBox::UpdateFileState(Mailbox: jsmith, Msg: MSG00003, State: Forward, IsPrivate: 0, IsPriority: 0, Notify: 1, MessageType: 1)
03/05 12:01:48.461 vmprov5s (1f,8) ba4, f00: < VMailBox::UpdateFileState()
03/05 12:01:48.461 vmprov5s (1d,8) ba4, f00: > tblMailbox::LocateMessage(Mailbox ID:{10a09752-740b-47df-ad87-ec7202e85c91}, Message Number:3)
03/05 12:01:48.462 vmprov5s (1d,8) ba4, f00: > tblMessage::GetRecord(Mailbox: {10a09752-740b-47df-ad87-ec7202e85c91}, ID:{6b214cc3-1132-4725-89d9-22ac5be6c0cd})
03/05 12:01:48.464 vmprov5s (1d,8) ba4, f00: < tblMessage::GetRecord()
03/05 12:01:48.464 vmprov5s (1d,8) ba4, f00: < tblMailbox::LocateMessage()
03/05 12:01:48.465 vmprov5s (14,9) ba4, f00: EMailerRequest::Send: Queued email request for jsmith@companyname.com, subject is Voicemail Message (company name > 51818) From:companynumber, use EMAPI=true
03/05 12:01:48.465 vmprov5s (13,6) ba4, f00: Message being retried for mailbox jsmith is MSG00004
03/05 12:01:48.465 vmprov5s (1f,8) ba4, f00: > VMailBox::UpdateFileState(Mailbox: jsmith, Msg: MSG00004, State: Forward, IsPrivate: 0, IsPriority: 0, Notify: 1, MessageType: 1)
03/05 12:01:48.465 vmprov5s (1f,8) ba4, f00: < VMailBox::UpdateFileState()
03/05 12:01:48.465 vmprov5s (1d,8) ba4, f00: > tblMailbox::LocateMessage(Mailbox ID:{10a09752-740b-47df-ad87-ec7202e85c91}, Message Number:4)
03/05 12:01:48.466 vmprov5s (1d,8) ba4, f00: > tblMessage::GetRecord(Mailbox: {10a09752-740b-47df-ad87-ec7202e85c91}, ID:{b83b48eb-b8f5-4d53-9807-2f959bda5cde})
03/05 12:01:48.467 vmprov5s (1d,8) ba4, f00: < tblMessage::GetRecord()
03/05 12:01:48.468 vmprov5s (1d,8) ba4, f00: < tblMailbox::LocateMessage()
03/05 12:01:48.468 vmprov5s (14,9) ba4, f00: EMailerRequest::Send: Queued email request for jsmith@companyname.com, subject is Voicemail Message (INTEGRA TELECOM > jsmith) From:3036435103, use EMAPI=true
03/05 12:01:48.479 vmprov5s (13,6) ba4, f00: Message being retried for mailbox jsmith is MSG00005
03/05 12:01:48.479 vmprov5s (1f,8) ba4, f00: > VMailBox::UpdateFileState(Mailbox: jsmith, Msg: MSG00005, State: Forward, IsPrivate: 0, IsPriority: 0, Notify: 1, MessageType: 1)
03/05 12:01:48.479 vmprov5s (1f,8) ba4, f00: < VMailBox::UpdateFileState()
03/05 12:01:48.479 vmprov5s (1d,8) ba4, f00: > tblMailbox::LocateMessage(Mailbox ID:{10a09752-740b-47df-ad87-ec7202e85c91}, Message Number:5)
03/05 12:01:48.480 vmprov5s (1d,8) ba4, f00: > tblMessage::GetRecord(Mailbox: {10a09752-740b-47df-ad87-ec7202e85c91}, ID:{e403cc68-93c6-446b-a02a-6fae5978ea82})
03/05 12:01:48.481 vmprov5s (1d,8) ba4, f00: < tblMessage::GetRecord()
03/05 12:01:48.481 vmprov5s (1d,8) ba4, f00: < tblMailbox::LocateMessage()
03/05 12:01:48.482 vmprov5s (14,9) ba4, f00: EMailerRequest::Send: Queued email request for jsmith@companyname.com, subject is Voicemail Message (company name > jsmith) From:companynumber, use EMAPI=true
03/05 12:01:48.482 vmprov5s (13,6) ba4, f00: Message being retried for mailbox jsmith is MSG00006
03/05 12:01:48.482 vmprov5s (1f,8) ba4, f00: > VMailBox::UpdateFileState(Mailbox: jsmith, Msg: MSG00006, State: Forward, IsPrivate: 0, IsPriority: 0, Notify: 1, MessageType: 1)
03/05 12:01:48.482 vmprov5s (1f,8) ba4, f00: < VMailBox::UpdateFileState()
03/05 12:01:48.482 vmprov5s (1d,8) ba4, f00: > tblMailbox::LocateMessage(Mailbox ID:{10a09752-740b-47df-ad87-ec7202e85c91}, Message Number:6)
03/05 12:01:48.483 vmprov5s (1d,8) ba4, f00: > tblMessage::GetRecord(Mailbox: {10a09752-740b-47df-ad87-ec7202e85c91}, ID:{e516c501-6023-4b62-b7de-0378eba86e98})
03/05 12:01:48.485 vmprov5s (1d,8) ba4, f00: < tblMessage::GetRecord()
03/05 12:01:48.485 vmprov5s (1d,8) ba4, f00: < tblMailbox::LocateMessage()
03/05 12:01:48.485 vmprov5s (14,9) ba4, f00: EMailerRequest::Send: Queued email request for jsmith@companyname.com, subject is Voicemail Message (company name > jsmith) From:companynumber, use EMAPI=true
03/05 12:01:48.496 vmprov5s (13,6) ba4, f00: Message being retried for mailbox jsmith is MSG00007
03/05 12:01:48.496 vmprov5s (1f,8) ba4, f00: > VMailBox::UpdateFileState(Mailbox: jsmith, Msg: MSG00007, State: Forward, IsPrivate: 0, IsPriority: 0, Notify: 1, MessageType: 1)
03/05 12:01:48.496 vmprov5s (1f,8) ba4, f00: < VMailBox::UpdateFileState()
03/05 12:01:48.496 vmprov5s (1d,8) ba4, f00: > tblMailbox::LocateMessage(Mailbox ID:{10a09752-740b-47df-ad87-ec7202e85c91}, Message Number:7)
03/05 12:01:48.497 vmprov5s (1d,8) ba4, f00: > tblMessage::GetRecord(Mailbox: {10a09752-740b-47df-ad87-ec7202e85c91}, ID:{e4f3061a-33dc-42fb-a7c9-871046742d33})
03/05 12:01:48.498 vmprov5s (1d,8) ba4, f00: < tblMessage::GetRecord()
03/05 12:01:48.498 vmprov5s (1d,8) ba4, f00: < tblMailbox::LocateMessage()
03/05 12:01:48.499 vmprov5s (14,9) ba4, f00: EMailerRequest::Send: Queued email request for jsmith@companyname.com, subject is Voicemail Message (company name > jsmith) From:companynumber, use EMAPI=true
03/05 12:01:48.499 vmprov5s (13,6) ba4, f00: Message being retried for mailbox jsmith is MSG00008
03/05 12:01:48.499 vmprov5s (1f,8) ba4, f00: > VMailBox::UpdateFileState(Mailbox: jsmith, Msg: MSG00008, State: Forward, IsPrivate: 0, IsPriority: 0, Notify: 1, MessageType: 1)
03/05 12:01:48.499 vmprov5s (1f,8) ba4, f00: < VMailBox::UpdateFileState()
03/05 12:01:48.499 vmprov5s (1d,8) ba4, f00: > tblMailbox::LocateMessage(Mailbox ID:{10a09752-740b-47df-ad87-ec7202e85c91}, Message Number:8)
03/05 12:01:48.500 vmprov5s (1d,8) ba4, f00: > tblMessage::GetRecord(Mailbox: {10a09752-740b-47df-ad87-ec7202e85c91}, ID:{fbe29c98-809e-4144-9b1c-86e01a197287})
03/05 12:01:48.501 vmprov5s (1d,8) ba4, f00: < tblMessage::GetRecord()
03/05 12:01:48.501 vmprov5s (1d,8) ba4, f00: < tblMailbox::LocateMessage()
03/05 12:01:48.502 vmprov5s (14,9) ba4, f00: EMailerRequest::Send: Queued email request for jsmith@companyname.com, subject is Voicemail Message (company name > jsmith) From:companynumber, use EMAPI=true
03/05 12:01:48.513 vmprov5s (13,6) ba4, f00: Message being retried for mailbox jsmith is MSG00009
03/05 12:01:48.513 vmprov5s (1f,8) ba4, f00: > VMailBox::UpdateFileState(Mailbox: jsmith, Msg: MSG00009, State: Forward, IsPrivate: 0, IsPriority: 0, Notify: 1, MessageType: 1)
03/05 12:01:48.513 vmprov5s (1f,8) ba4, f00: < VMailBox::UpdateFileState()
03/05 12:01:48.513 vmprov5s (1d,8) ba4, f00: > tblMailbox::LocateMessage(Mailbox ID:{10a09752-740b-47df-ad87-ec7202e85c91}, Message Number:9)
03/05 12:01:48.514 vmprov5s (1d,8) ba4, f00: > tblMessage::GetRecord(Mailbox: {10a09752-740b-47df-ad87-ec7202e85c91}, ID:{6764fb4d-e41d-434b-9365-f34b37d6c8ea})
03/05 12:01:48.515 vmprov5s (1d,8) ba4, f00: < tblMessage::GetRecord()
03/05 12:01:48.515 vmprov5s (1d,8) ba4, f00: < tblMailbox::LocateMessage()
03/05 12:01:48.516 vmprov5s (14,9) ba4, f00: EMailerRequest::Send: Queued email request for jsmith@companyname.com, subject is Voicemail Message (company name > jsmith) From:companynumber, use EMAPI=true
03/05 12:01:48.527 vmprov5s (13,6) ba4, f00: Message being retried for mailbox jsmith is MSG00010
03/05 12:01:48.527 vmprov5s (1f,8) ba4, f00: > VMailBox::UpdateFileState(Mailbox: jsmith, Msg: MSG00010, State: Forward, IsPrivate: 0, IsPriority: 0, Notify: 1, MessageType: 1)
03/05 12:01:48.527 vmprov5s (1f,8) ba4, f00: < VMailBox::UpdateFileState()
03/05 12:01:48.527 vmprov5s (1d,8) ba4, f00: > tblMailbox::LocateMessage(Mailbox ID:{10a09752-740b-47df-ad87-ec7202e85c91}, Message Number:10)
03/05 12:01:48.528 vmprov5s (1d,8) ba4, f00: > tblMessage::GetRecord(Mailbox: {10a09752-740b-47df-ad87-ec7202e85c91}, ID:{60857eec-7a43-441f-abe4-41f6a16f6f68})
03/05 12:01:48.529 vmprov5s (1d,8) ba4, f00: < tblMessage::GetRecord()
03/05 12:01:48.529 vmprov5s (1d,8) ba4, f00: < tblMailbox::LocateMessage()
03/05 12:01:48.530 vmprov5s (14,9) ba4, f00: EMailerRequest::Send: Queued email request for jsmith@companyname.com, subject is Voicemail Message (company name > jsmith) From:companynumber, use EMAPI=true
03/05 12:01:48.530 vmprov5s (13,6) ba4, f00: Message being retried for mailbox jsmith is MSG00011
03/05 12:01:48.530 vmprov5s (1f,8) ba4, f00: > VMailBox::UpdateFileState(Mailbox: jsmith, Msg: MSG00011, State: Forward, IsPrivate: 0, IsPriority: 0, Notify: 1, MessageType: 1)
03/05 12:01:48.530 vmprov5s (1f,8) ba4, f00: < VMailBox::UpdateFileState()
03/05 12:01:48.530 vmprov5s (1d,8) ba4, f00: > tblMailbox::LocateMessage(Mailbox ID:{10a09752-740b-47df-ad87-ec7202e85c91}, Message Number:11)
03/05 12:01:48.531 vmprov5s (1d,8) ba4, f00: > tblMessage::GetRecord(Mailbox: {10a09752-740b-47df-ad87-ec7202e85c91}, ID:{269d9b38-6b61-44e5-8840-0140b0e6efc4})
03/05 12:01:48.533 vmprov5s (1d,8) ba4, f00: < tblMessage::GetRecord()
03/05 12:01:48.533 vmprov5s (1d,8) ba4, f00: < tblMailbox::LocateMessage()
03/05 12:01:48.533 vmprov5s (14,9) ba4, f00: EMailerRequest::Send: Queued email request for jsmith@companyname.com, subject is Voicemail Message (company name > jsmith) From:companynumber, use EMAPI=true
03/05 12:01:48.543 vmprov5s (13,6) ba4, f00: Message being retried for mailbox jsmith is MSG00012
03/05 12:01:48.543 vmprov5s (1f,8) ba4, f00: > VMailBox::UpdateFileState(Mailbox: jsmith, Msg: MSG00012, State: Forward, IsPrivate: 0, IsPriority: 0, Notify: 1, MessageType: 1)
03/05 12:01:48.543 vmprov5s (1f,8) ba4, f00: < VMailBox::UpdateFileState()
03/05 12:01:48.543 vmprov5s (1d,8) ba4, f00: > tblMailbox::LocateMessage(Mailbox ID:{10a09752-740b-47df-ad87-ec7202e85c91}, Message Number:12)
03/05 12:01:48.544 vmprov5s (1d,8) ba4, f00: > tblMessage::GetRecord(Mailbox: {10a09752-740b-47df-ad87-ec7202e85c91}, ID:{06550e83-2440-4bbe-978a-f61792281e66})
03/05 12:01:48.545 vmprov5s (1d,8) ba4, f00: < tblMessage::GetRecord()
03/05 12:01:48.545 vmprov5s (1d,8) ba4, f00: < tblMailbox::LocateMessage()
03/05 12:01:48.546 vmprov5s (14,9) ba4, f00: EMailerRequest::Send: Queued email request for jsmith@companyname.com, subject is Voicemail Message (company name > jsmith) From:companynumber, use EMAPI=true
03/05 12:01:48.557 vmprov5s (26,6) ba4, f00: < VMailBox::ForwardPendingEmails()
03/05 12:01:48.807 vmprov5s (14,9) ba4, f00: > EMailer::SendRequestUsingEMAPI(011DA860 [51818\MSG00001])
03/05 12:01:48.807 vmprov5s (19,8) ba4, f00: > CMAPIImpl::SendUMEmail(00000000)
03/05 12:01:48.807 vmprov5s (66,8) ba4, f00: > CMAPIImpl::SendUMEmail()
03/05 12:01:48.807 vmprov5s (66,8) ba4, f00: > CMAPIImpl::SendUMEmail(pIMsgStore: 00000000, m_TargetAlias: "jsmith@companyname.com", szSubject: "Voicemail Message (company name > jsmith) From:companynumber", szBody: "IP Office Voicemail redirected message", szFile: "C:\Program Files (x86)\Avaya\IP Office\Voicemail Pro\VM\Accounts\jsmith\d64cc5fca39d45f8b3ef800fa9ce1064.WAV", szFilename: "MSG00001.WAV", lSecs: 6, szNumber: companynumber, szName: "company name", szOrder: ;MSG00001.WAV, offset: 72, ulMsgReceived: 3545051497)
03/05 12:01:48.807 vmprov5s (66,5) ba4, f00: CMAPIImpl::SendUMEmail[5714]: At entry, counter=[0]
03/05 12:01:48.807 vmprov5s (66,2) ba4, f00: CMAPIImpl::SendUMEmail[5946]: Error pIMsgStore is NULL.
03/05 12:01:48.807 vmprov5s (66,5) ba4, f00: CMAPIImpl::SendUMEmail[5949]: At Exit, counter=[0]
03/05 12:01:48.807 vmprov5s (66,8) ba4, f00: < CMAPIImpl::SendUMEmail()
03/05 12:01:48.807 vmprov5s (66,8) ba4, f00: < CMAPIImpl::SendUMEmail()
03/05 12:01:48.807 vmprov5s (19,2) ba4, f00: Error (hr=0x80004003) from SendUMEmail
03/05 12:01:48.807 vmprov5s (19,8) ba4, f00: < CMAPIImpl::SendUMEmail()
03/05 12:01:48.807 vmprov5s (14,2) ba4, f00: Error 0x80004003 sending email to jsmith@companyname.com
03/05 12:01:48.807 vmprov5s (14,9) ba4, f00: < EMailer::SendRequestUsingEMAPI()
03/05 12:01:48.808 vmprov5s (14,2) ba4, f00: emailer - SendRequest failed for 51818\MSG00001, error Invalid pointer (80004003)
03/05 12:01:49.058 vmprov5s (14,9) ba4, f00: > EMailer::SendRequestUsingEMAPI(02A7E130 [51818\MSG00002])
03/05 12:01:49.058 vmprov5s (19,8) ba4, f00: > CMAPIImpl::SendUMEmail(00000000)
03/05 12:01:49.058 vmprov5s (66,8) ba4, f00: > CMAPIImpl::SendUMEmail()
03/05 12:01:49.058 vmprov5s (66,8) ba4, f00: > CMAPIImpl::SendUMEmail(pIMsgStore: 00000000, m_TargetAlias: "jsmith@companyname.com", szSubject: "Voicemail Message (company name > ericw) From:companynumber", szBody: "IP Office Voicemail redirected message", szFile: "C:\Program Files (x86)\Avaya\IP Office\Voicemail Pro\VM\Accounts\jsmith\3fc8dd320bd74e2ebbc87541f18c7d87.WAV", szFilename: "MSG00002.WAV", lSecs: 4, szNumber: companynumber, szName: "company name", szOrder: ;MSG00002.WAV, offset: 72, ulMsgReceived: 3545053299)
03/05 12:01:49.058 vmprov5s (66,5) ba4, f00: CMAPIImpl::SendUMEmail[5714]: At entry, counter=[0]
03/05 12:01:49.058 vmprov5s (66,2) ba4, f00: CMAPIImpl::SendUMEmail[5946]: Error pIMsgStore is NULL.
03/05 12:01:49.058 vmprov5s (66,5) ba4, f00: CMAPIImpl::SendUMEmail[5949]: At Exit, counter=[0]
03/05 12:01:49.058 vmprov5s (66,8) ba4, f00: < CMAPIImpl::SendUMEmail()
03/05 12:01:49.058 vmprov5s (66,8) ba4, f00: < CMAPIImpl::SendUMEmail()
03/05 12:01:49.058 vmprov5s (19,2) ba4, f00: Error (hr=0x80004003) from SendUMEmail
03/05 12:01:49.058 vmprov5s (19,8) ba4, f00: < CMAPIImpl::SendUMEmail()
03/05 12:01:49.058 vmprov5s (14,2) ba4, f00: Error 0x80004003 sending email to jsmith@companyname.com
03/05 12:01:49.058 vmprov5s (14,9) ba4, f00: < EMailer::SendRequestUsingEMAPI()
03/05 12:01:49.058 vmprov5s (14,2) ba4, f00: emailer - SendRequest failed for 51818\MSG00002, error Invalid pointer (80004003)
03/05 12:01:49.308 vmprov5s (14,9) ba4, f00: > EMailer::SendRequestUsingEMAPI(011DA200 [51818\MSG00003])
03/05 12:01:49.308 vmprov5s (19,8) ba4, f00: > CMAPIImpl::SendUMEmail(00000000)
03/05 12:01:49.308 vmprov5s (66,8) ba4, f00: > CMAPIImpl::SendUMEmail()
03/05 12:01:49.308 vmprov5s (66,8) ba4, f00: > CMAPIImpl::SendUMEmail(pIMsgStore: 00000000, m_TargetAlias: "jsmith@companyname.com", szSubject: "Voicemail Message (company name > 51818) From:companynumber", szBody: "IP Office Voicemail redirected message", szFile: "C:\Program Files (x86)\Avaya\IP Office\Voicemail Pro\VM\Accounts\jsmith\0567d7f0edd44039ad766dee1cd2df62.WAV", szFilename: "MSG00003.WAV", lSecs: 5, szNumber: companynumber, szName: "company name", szOrder: ;MSG00003.WAV, offset: 72, ulMsgReceived: 3545054299)
03/05 12:01:49.308 vmprov5s (66,5) ba4, f00: CMAPIImpl::SendUMEmail[5714]: At entry, counter=[0]
03/05 12:01:49.308 vmprov5s (66,2) ba4, f00: CMAPIImpl::SendUMEmail[5946]: Error pIMsgStore is NULL.
03/05 12:01:49.308 vmprov5s (66,5) ba4, f00: CMAPIImpl::SendUMEmail[5949]: At Exit, counter=[0]
03/05 12:01:49.308 vmprov5s (66,8) ba4, f00: < CMAPIImpl::SendUMEmail()
03/05 12:01:49.308 vmprov5s (66,8) ba4, f00: < CMAPIImpl::SendUMEmail()
03/05 12:01:49.308 vmprov5s (19,2) ba4, f00: Error (hr=0x80004003) from SendUMEmail
03/05 12:01:49.308 vmprov5s (19,8) ba4, f00: < CMAPIImpl::SendUMEmail()
03/05 12:01:49.308 vmprov5s (14,2) ba4, f00: Error 0x80004003 sending email to jsmith@companyname.com
03/05 12:01:49.308 vmprov5s (14,9) ba4, f00: < EMailer::SendRequestUsingEMAPI()
03/05 12:01:49.308 vmprov5s (14,2) ba4, f00: emailer - SendRequest failed for 51818\MSG00003, error Invalid pointer (80004003)
03/05 12:01:49.558 vmprov5s (14,9) ba4, f00: > EMailer::SendRequestUsingEMAPI(011DA3B8 [51818\MSG00004])
03/05 12:01:49.558 vmprov5s (19,8) ba4, f00: > CMAPIImpl::SendUMEmail(00000000)
03/05 12:01:49.558 vmprov5s (66,8) ba4, f00: > CMAPIImpl::SendUMEmail()
03/05 12:01:49.558 vmprov5s (66,8) ba4, f00: > CMAPIImpl::SendUMEmail(pIMsgStore: 00000000, m_TargetAlias: "jsmith@companyname.com", szSubject: "Voicemail Message (INTEGRA TELECOM > jsmith) From:3036435103", szBody: "IP Office Voicemail redirected message", szFile: "C:\Program Files (x86)\Avaya\IP Office\Voicemail Pro\VM\Accounts\jsmith\d084958513fc44de9b319ae769931cf6.WAV", szFilename: "MSG00004.WAV", lSecs: 55, szNumber: 3036435103, szName: "INTEGRA TELECOM", szOrder: ;MSG00004.WAV, offset: 72, ulMsgReceived: 3545054963)
03/05 12:01:49.558 vmprov5s (66,5) ba4, f00: CMAPIImpl::SendUMEmail[5714]: At entry, counter=[0]
03/05 12:01:49.558 vmprov5s (66,2) ba4, f00: CMAPIImpl::SendUMEmail[5946]: Error pIMsgStore is NULL.
03/05 12:01:49.558 vmprov5s (66,5) ba4, f00: CMAPIImpl::SendUMEmail[5949]: At Exit, counter=[0]
03/05 12:01:49.558 vmprov5s (66,8) ba4, f00: < CMAPIImpl::SendUMEmail()
03/05 12:01:49.558 vmprov5s (66,8) ba4, f00: < CMAPIImpl::SendUMEmail()
03/05 12:01:49.558 vmprov5s (19,2) ba4, f00: Error (hr=0x80004003) from SendUMEmail
03/05 12:01:49.558 vmprov5s (19,8) ba4, f00: < CMAPIImpl::SendUMEmail()
03/05 12:01:49.558 vmprov5s (14,2) ba4, f00: Error 0x80004003 sending email to jsmith@companyname.com
03/05 12:01:49.558 vmprov5s (14,9) ba4, f00: < EMailer::SendRequestUsingEMAPI()
03/05 12:01:49.558 vmprov5s (14,2) ba4, f00: emailer - SendRequest failed for 51818\MSG00004, error Invalid pointer (80004003)
03/05 12:01:49.808 vmprov5s (14,9) ba4, f00: > EMailer::SendRequestUsingEMAPI(02A7A698 [51818\MSG00005])
03/05 12:01:49.808 vmprov5s (19,8) ba4, f00: > CMAPIImpl::SendUMEmail(00000000)
03/05 12:01:49.808 vmprov5s (66,8) ba4, f00: > CMAPIImpl::SendUMEmail()
03/05 12:01:49.808 vmprov5s (66,8) ba4, f00: > CMAPIImpl::SendUMEmail(pIMsgStore: 00000000, m_TargetAlias: "jsmith@companyname.com", szSubject: "Voicemail Message (company name > jsmith) From:companynumber", szBody: "IP Office Voicemail redirected message", szFile: "C:\Program Files (x86)\Avaya\IP Office\Voicemail Pro\VM\Accounts\jsmith\2b5ec947898e4f3895ee76502daa14dc.WAV", szFilename: "MSG00005.WAV", lSecs: 7, szNumber: companynumber, szName: "company name", szOrder: ;MSG00005.WAV, offset: 72, ulMsgReceived: 3545055719)
03/05 12:01:49.808 vmprov5s (66,5) ba4, f00: CMAPIImpl::SendUMEmail[5714]: At entry, counter=[0]
03/05 12:01:49.808 vmprov5s (66,2) ba4, f00: CMAPIImpl::SendUMEmail[5946]: Error pIMsgStore is NULL.
03/05 12:01:49.808 vmprov5s (66,5) ba4, f00: CMAPIImpl::SendUMEmail[5949]: At Exit, counter=[0]
03/05 12:01:49.808 vmprov5s (66,8) ba4, f00: < CMAPIImpl::SendUMEmail()
03/05 12:01:49.809 vmprov5s (66,8) ba4, f00: < CMAPIImpl::SendUMEmail()
03/05 12:01:49.809 vmprov5s (19,2) ba4, f00: Error (hr=0x80004003) from SendUMEmail
03/05 12:01:49.809 vmprov5s (19,8) ba4, f00: < CMAPIImpl::SendUMEmail()
03/05 12:01:49.809 vmprov5s (14,2) ba4, f00: Error 0x80004003 sending email to jsmith@companyname.com
03/05 12:01:49.809 vmprov5s (14,9) ba4, f00: < EMailer::SendRequestUsingEMAPI()
03/05 12:01:49.809 vmprov5s (14,2) ba4, f00: emailer - SendRequest failed for 51818\MSG00005, error Invalid pointer (80004003)
03/05 12:01:50.059 vmprov5s (14,9) ba4, f00: > EMailer::SendRequestUsingEMAPI(02A7A850 [51818\MSG00006])
03/05 12:01:50.059 vmprov5s (19,8) ba4, f00: > CMAPIImpl::SendUMEmail(00000000)
03/05 12:01:50.059 vmprov5s (66,8) ba4, f00: > CMAPIImpl::SendUMEmail()
03/05 12:01:50.059 vmprov5s (66,8) ba4, f00: > CMAPIImpl::SendUMEmail(pIMsgStore: 00000000, m_TargetAlias: "jsmith@companyname.com", szSubject: "Voicemail Message (company name > jsmith) From:companynumber", szBody: "IP Office Voicemail redirected message", szFile: "C:\Program Files (x86)\Avaya\IP Office\Voicemail Pro\VM\Accounts\jsmith\5296de2988f2497d9fb92ee9bd7ef4d3.WAV", szFilename: "MSG00006.WAV", lSecs: 8, szNumber: companynumber, szName: "company name", szOrder: ;MSG00006.WAV, offset: 72, ulMsgReceived: 3545055771)
03/05 12:01:50.059 vmprov5s (66,5) ba4, f00: CMAPIImpl::SendUMEmail[5714]: At entry, counter=[0]
03/05 12:01:50.059 vmprov5s (66,2) ba4, f00: CMAPIImpl::SendUMEmail[5946]: Error pIMsgStore is NULL.
03/05 12:01:50.059 vmprov5s (66,5) ba4, f00: CMAPIImpl::SendUMEmail[5949]: At Exit, counter=[0]
03/05 12:01:50.059 vmprov5s (66,8) ba4, f00: < CMAPIImpl::SendUMEmail()
03/05 12:01:50.059 vmprov5s (66,8) ba4, f00: < CMAPIImpl::SendUMEmail()
03/05 12:01:50.059 vmprov5s (19,2) ba4, f00: Error (hr=0x80004003) from SendUMEmail
03/05 12:01:50.059 vmprov5s (19,8) ba4, f00: < CMAPIImpl::SendUMEmail()
03/05 12:01:50.059 vmprov5s (14,2) ba4, f00: Error 0x80004003 sending email to jsmith@companyname.com
03/05 12:01:50.059 vmprov5s (14,9) ba4, f00: < EMailer::SendRequestUsingEMAPI()
03/05 12:01:50.059 vmprov5s (14,2) ba4, f00: emailer - SendRequest failed for 51818\MSG00006, error Invalid pointer (80004003)
03/05 12:01:50.240 vmprov5s (19,1) ba4, a78: VMIsMAPIAvailable returning [1]
03/05 12:01:50.240 vmprov5s (19,5) ba4, a78: CMAPIImpl::CheckMAPIConnection() - return is 0,m_iMAPIStatus = [-1]
03/05 12:01:50.240 DbgOut (01,5) 2980,1716: DllMain(hinstDLL=0x10000000, fdwReason=DLL_THREAD_ATTACH)
03/05 12:01:50.240 vmprov5s (29,9) ba4, a78: Created thread CMAPIImpl::EventThreadRoutine (02A758A8) (TID: 6b4 (1716))
03/05 12:01:50.241 DbgOut (01,5) 2980,2376: DllMain(hinstDLL=0x10000000, fdwReason=DLL_THREAD_ATTACH)
03/05 12:01:50.241 vmprov5s (29,9) ba4, a78: Created thread CMAPIImpl::EventThreadRoutine (02A75488) (TID: 948 (2376))
03/05 12:01:50.253 vmprov5s (29,9) ba4, 6b4: Processing thread CMAPIImpl::EventThreadRoutine (02A758A8) (TID: 0x6b4 (1716))
03/05 12:01:50.253 vmprov5s (19,8) ba4, 6b4: > CMAPIImpl::EventThreadRoutine(02AA4428)
03/05 12:01:50.253 vmprov5s (19,8) ba4, 6b4: > CMAPIImpl::MAPIConnect(SES-EX AvayaVoicemail@companyname.com Outlook false)
03/05 12:01:50.253 vmprov5s (66,8) ba4, 6b4: > CMAPIImpl::Connect(Exchange Server: <SES-EX>, Default Mailbox: <AvayaVoicemail@companyname.com>, Profile: <Outlook>)
03/05 12:01:50.253 vmprov5s (66,8) ba4, 6b4: > CMAPIImpl:

isconnect()
03/05 12:01:50.253 vmprov5s (66,8) ba4, 6b4: < CMAPIImpl:

isconnect()
03/05 12:01:50.253 vmprov5s (66,5) ba4, 6b4: Configuring for service.
03/05 12:01:50.253 vmprov5s (66,5) ba4, 6b4: Attempting to logon to MAPI using profile Outlook.
03/05 12:01:50.254 vmprov5s (29,9) ba4, 948: Processing thread CMAPIImpl::EventThreadRoutine (02A75488) (TID: 0x948 (2376))
03/05 12:01:50.254 vmprov5s (19,8) ba4, 948: > CMAPIImpl::EventThreadRoutine(02AA4490)
03/05 12:01:50.254 vmprov5s (19,8) ba4, 948: > CMAPIImpl::MAPIConnect(SES-EX AvayaVoicemail@companyname.com Outlook true)
03/05 12:01:50.254 vmprov5s (66,8) ba4, 948: > CMAPIImpl::Connect(Exchange Server: <SES-EX>, Default Mailbox: <AvayaVoicemail@companyname.com>, Profile: <Outlook>)
03/05 12:01:50.254 vmprov5s (66,8) ba4, 948: > CMAPIImpl:

isconnect()
03/05 12:01:50.254 vmprov5s (66,8) ba4, 948: < CMAPIImpl:

isconnect()
03/05 12:01:50.254 vmprov5s (66,5) ba4, 948: Configuring for service.
03/05 12:01:50.254 vmprov5s (66,5) ba4, 948: Attempting to logon to MAPI using profile Outlook.
03/05 12:01:50.275 DbgOut (01,5) 2980,2904: DllMain(hinstDLL=0x10000000, fdwReason=DLL_THREAD_ATTACH)
03/05 12:01:50.291 DbgOut (01,5) 2980,1184: DllMain(hinstDLL=0x10000000, fdwReason=DLL_THREAD_ATTACH)
03/05 12:01:50.291 DbgOut (01,5) 2980,3460: DllMain(hinstDLL=0x10000000, fdwReason=DLL_THREAD_ATTACH)
03/05 12:01:50.344 vmprov5s (14,9) ba4, f00: > EMailer::SendRequestUsingEMAPI(02A7AA08 [51818\MSG00007])
03/05 12:01:50.344 vmprov5s (19,8) ba4, f00: > CMAPIImpl::SendUMEmail(00000000)
03/05 12:01:50.344 vmprov5s (66,8) ba4, f00: > CMAPIImpl::SendUMEmail()
03/05 12:01:50.344 vmprov5s (66,8) ba4, f00: > CMAPIImpl::SendUMEmail(pIMsgStore: 00000000, m_TargetAlias: "jsmith@companyname.com", szSubject: "Voicemail Message (company name > jsmith) From:companynumber", szBody: "IP Office Voicemail redirected message", szFile: "C:\Program Files (x86)\Avaya\IP Office\Voicemail Pro\VM\Accounts\jsmith\6e7699316c1e452e8a244d431af39bbb.WAV", szFilename: "MSG00007.WAV", lSecs: 3, szNumber: companynumber, szName: "company name", szOrder: ;MSG00007.WAV, offset: 72, ulMsgReceived: 3545055972)
03/05 12:01:50.344 vmprov5s (66,5) ba4, f00: CMAPIImpl::SendUMEmail[5714]: At entry, counter=[0]
03/05 12:01:50.344 vmprov5s (66,2) ba4, f00: CMAPIImpl::SendUMEmail[5946]: Error pIMsgStore is NULL.
03/05 12:01:50.344 vmprov5s (66,5) ba4, f00: CMAPIImpl::SendUMEmail[5949]: At Exit, counter=[0]
03/05 12:01:50.344 vmprov5s (66,8) ba4, f00: < CMAPIImpl::SendUMEmail()
03/05 12:01:50.344 vmprov5s (66,8) ba4, f00: < CMAPIImpl::SendUMEmail()
03/05 12:01:50.344 vmprov5s (19,2) ba4, f00: Error (hr=0x80004003) from SendUMEmail
03/05 12:01:50.344 vmprov5s (19,8) ba4, f00: < CMAPIImpl::SendUMEmail()
03/05 12:01:50.344 vmprov5s (14,2) ba4, f00: Error 0x80004003 sending email to jsmith@companyname.com
03/05 12:01:50.344 vmprov5s (14,9) ba4, f00: < EMailer::SendRequestUsingEMAPI()
03/05 12:01:50.344 vmprov5s (14,2) ba4, f00: emailer - SendRequest failed for 51818\MSG00007, error Invalid pointer (80004003)
03/05 12:01:50.594 vmprov5s (14,9) ba4, f00: > EMailer::SendRequestUsingEMAPI(02A7ABC0 [51818\MSG00008])
03/05 12:01:50.594 vmprov5s (19,8) ba4, f00: > CMAPIImpl::SendUMEmail(00000000)
03/05 12:01:50.594 vmprov5s (66,8) ba4, f00: > CMAPIImpl::SendUMEmail()
03/05 12:01:50.594 vmprov5s (66,8) ba4, f00: > CMAPIImpl::SendUMEmail(pIMsgStore: 00000000, m_TargetAlias: "jsmith@companyname.com", szSubject: "Voicemail Message (company name > jsmith) From:companynumber", szBody: "IP Office Voicemail redirected message", szFile: "C:\Program Files (x86)\Avaya\IP Office\Voicemail Pro\VM\Accounts\jsmith\fabbd6910be74d3c97c3a83e88e4926a.WAV", szFilename: "MSG00008.WAV", lSecs: 6, szNumber: companynumber, szName: "company name", szOrder: ;MSG00008.WAV, offset: 72, ulMsgReceived: 3545056025)
03/05 12:01:50.594 vmprov5s (66,5) ba4, f00: CMAPIImpl::SendUMEmail[5714]: At entry, counter=[0]
03/05 12:01:50.594 vmprov5s (66,2) ba4, f00: CMAPIImpl::SendUMEmail[5946]: Error pIMsgStore is NULL.
03/05 12:01:50.594 vmprov5s (66,5) ba4, f00: CMAPIImpl::SendUMEmail[5949]: At Exit, counter=[0]
03/05 12:01:50.594 vmprov5s (66,8) ba4, f00: < CMAPIImpl::SendUMEmail()
03/05 12:01:50.594 vmprov5s (66,8) ba4, f00: < CMAPIImpl::SendUMEmail()
03/05 12:01:50.594 vmprov5s (19,2) ba4, f00: Error (hr=0x80004003) from SendUMEmail
03/05 12:01:50.594 vmprov5s (19,8) ba4, f00: < CMAPIImpl::SendUMEmail()
03/05 12:01:50.594 vmprov5s (14,2) ba4, f00: Error 0x80004003 sending email to jsmith@companyname.com
03/05 12:01:50.594 vmprov5s (14,9) ba4, f00: < EMailer::SendRequestUsingEMAPI()
03/05 12:01:50.594 vmprov5s (14,2) ba4, f00: emailer - SendRequest failed for 51818\MSG00008, error Invalid pointer (80004003)
03/05 12:01:50.844 vmprov5s (14,9) ba4, f00: > EMailer::SendRequestUsingEMAPI(02A98448 [51818\MSG00009])
03/05 12:01:50.844 vmprov5s (19,8) ba4, f00: > CMAPIImpl::SendUMEmail(00000000)
03/05 12:01:50.844 vmprov5s (66,8) ba4, f00: > CMAPIImpl::SendUMEmail()
03/05 12:01:50.844 vmprov5s (66,8) ba4, f00: > CMAPIImpl::SendUMEmail(pIMsgStore: 00000000, m_TargetAlias: "jsmith@companyname.com", szSubject: "Voicemail Message (company name > jsmith) From:companynumber", szBody: "IP Office Voicemail redirected message", szFile: "C:\Program Files (x86)\Avaya\IP Office\Voicemail Pro\VM\Accounts\jsmith\ada550ab6d7a44738c11d36da7eea032.WAV", szFilename: "MSG00009.WAV", lSecs: 5, szNumber: companynumber, szName: "company name", szOrder: ;MSG00009.WAV, offset: 72, ulMsgReceived: 3545056052)
03/05 12:01:50.844 vmprov5s (66,5) ba4, f00: CMAPIImpl::SendUMEmail[5714]: At entry, counter=[0]
03/05 12:01:50.844 vmprov5s (66,2) ba4, f00: CMAPIImpl::SendUMEmail[5946]: Error pIMsgStore is NULL.
03/05 12:01:50.844 vmprov5s (66,5) ba4, f00: CMAPIImpl::SendUMEmail[5949]: At Exit, counter=[0]
03/05 12:01:50.844 vmprov5s (66,8) ba4, f00: < CMAPIImpl::SendUMEmail()
03/05 12:01:50.844 vmprov5s (66,8) ba4, f00: < CMAPIImpl::SendUMEmail()
03/05 12:01:50.844 vmprov5s (19,2) ba4, f00: Error (hr=0x80004003) from SendUMEmail
03/05 12:01:50.844 vmprov5s (19,8) ba4, f00: < CMAPIImpl::SendUMEmail()
03/05 12:01:50.844 vmprov5s (14,2) ba4, f00: Error 0x80004003 sending email to jsmith@companyname.com
03/05 12:01:50.844 vmprov5s (14,9) ba4, f00: < EMailer::SendRequestUsingEMAPI()
03/05 12:01:50.844 vmprov5s (14,2) ba4, f00: emailer - SendRequest failed for 51818\MSG00009, error Invalid pointer (80004003)
03/05 12:01:51.094 vmprov5s (14,9) ba4, f00: > EMailer::SendRequestUsingEMAPI(02A98600 [51818\MSG00010])
03/05 12:01:51.094 vmprov5s (19,8) ba4, f00: > CMAPIImpl::SendUMEmail(00000000)
03/05 12:01:51.094 vmprov5s (66,8) ba4, f00: > CMAPIImpl::SendUMEmail()
03/05 12:01:51.094 vmprov5s (66,8) ba4, f00: > CMAPIImpl::SendUMEmail(pIMsgStore: 00000000, m_TargetAlias: "jsmith@companyname.com", szSubject: "Voicemail Message (company name > jsmith) From:companynumber", szBody: "IP Office Voicemail redirected message", szFile: "C:\Program Files (x86)\Avaya\IP Office\Voicemail Pro\VM\Accounts\jsmith\a08c19515c4648a7b8db3f7ed5c345b3.WAV", szFilename: "MSG00010.WAV", lSecs: 6, szNumber: companynumber, szName: "company name", szOrder: ;MSG00010.WAV, offset: 72, ulMsgReceived: 3545056145)
03/05 12:01:51.094 vmprov5s (66,5) ba4, f00: CMAPIImpl::SendUMEmail[5714]: At entry, counter=[0]
03/05 12:01:51.094 vmprov5s (66,2) ba4, f00: CMAPIImpl::SendUMEmail[5946]: Error pIMsgStore is NULL.
03/05 12:01:51.094 vmprov5s (66,5) ba4, f00: CMAPIImpl::SendUMEmail[5949]: At Exit, counter=[0]
03/05 12:01:51.094 vmprov5s (66,8) ba4, f00: < CMAPIImpl::SendUMEmail()
03/05 12:01:51.094 vmprov5s (66,8) ba4, f00: < CMAPIImpl::SendUMEmail()
03/05 12:01:51.094 vmprov5s (19,2) ba4, f00: Error (hr=0x80004003) from SendUMEmail
03/05 12:01:51.094 vmprov5s (19,8) ba4, f00: < CMAPIImpl::SendUMEmail()
03/05 12:01:51.094 vmprov5s (14,2) ba4, f00: Error 0x80004003 sending email to jsmith@companyname.com
03/05 12:01:51.094 vmprov5s (14,9) ba4, f00: < EMailer::SendRequestUsingEMAPI()
03/05 12:01:51.094 vmprov5s (14,2) ba4, f00: emailer - SendRequest failed for 51818\MSG00010, error Invalid pointer (80004003)
03/05 12:01:51.345 vmprov5s (14,9) ba4, f00: > EMailer::SendRequestUsingEMAPI(02A987B8 [51818\MSG00011])
03/05 12:01:51.345 vmprov5s (19,8) ba4, f00: > CMAPIImpl::SendUMEmail(00000000)
03/05 12:01:51.345 vmprov5s (66,8) ba4, f00: > CMAPIImpl::SendUMEmail()
03/05 12:01:51.345 vmprov5s (66,8) ba4, f00: > CMAPIImpl::SendUMEmail(pIMsgStore: 00000000, m_TargetAlias: "jsmith@companyname.com", szSubject: "Voicemail Message (company name > jsmith) From:companynumber", szBody: "IP Office Voicemail redirected message", szFile: "C:\Program Files (x86)\Avaya\IP Office\Voicemail Pro\VM\Accounts\jsmith\54684ef69a1346b08f936f4ba2e55174.WAV", szFilename: "MSG00011.WAV", lSecs: 5, szNumber: companynumber, szName: "company name", szOrder: ;MSG00011.WAV, offset: 72, ulMsgReceived: 3545056434)
03/05 12:01:51.345 vmprov5s (66,5) ba4, f00: CMAPIImpl::SendUMEmail[5714]: At entry, counter=[0]
03/05 12:01:51.345 vmprov5s (66,2) ba4, f00: CMAPIImpl::SendUMEmail[5946]: Error pIMsgStore is NULL.
03/05 12:01:51.345 vmprov5s (66,5) ba4, f00: CMAPIImpl::SendUMEmail[5949]: At Exit, counter=[0]
03/05 12:01:51.345 vmprov5s (66,8) ba4, f00: < CMAPIImpl::SendUMEmail()
03/05 12:01:51.345 vmprov5s (66,8) ba4, f00: < CMAPIImpl::SendUMEmail()
03/05 12:01:51.345 vmprov5s (19,2) ba4, f00: Error (hr=0x80004003) from SendUMEmail
03/05 12:01:51.345 vmprov5s (19,8) ba4, f00: < CMAPIImpl::SendUMEmail()
03/05 12:01:51.345 vmprov5s (14,2) ba4, f00: Error 0x80004003 sending email to jsmith@companyname.com
03/05 12:01:51.345 vmprov5s (14,9) ba4, f00: < EMailer::SendRequestUsingEMAPI()
03/05 12:01:51.345 vmprov5s (14,2) ba4, f00: emailer - SendRequest failed for 51818\MSG00011, error Invalid pointer (80004003)
03/05 12:01:51.595 vmprov5s (14,9) ba4, f00: > EMailer::SendRequestUsingEMAPI(02A98970 [51818\MSG00012])
03/05 12:01:51.595 vmprov5s (19,8) ba4, f00: > CMAPIImpl::SendUMEmail(00000000)
03/05 12:01:51.595 vmprov5s (66,8) ba4, f00: > CMAPIImpl::SendUMEmail()
03/05 12:01:51.595 vmprov5s (66,8) ba4, f00: > CMAPIImpl::SendUMEmail(pIMsgStore: 00000000, m_TargetAlias: "jsmith@companyname.com", szSubject: "Voicemail Message (company name > jsmith) From:companynumber", szBody: "IP Office Voicemail redirected message", szFile: "C:\Program Files (x86)\Avaya\IP Office\Voicemail Pro\VM\Accounts\jsmith\b8fe2782419f4ee797484c21010dd333.WAV", szFilename: "MSG00012.WAV", lSecs: 6, szNumber: companynumber, szName: "company name", szOrder: ;MSG00012.WAV, offset: 72, ulMsgReceived: 3545056620)
03/05 12:01:51.595 vmprov5s (66,5) ba4, f00: CMAPIImpl::SendUMEmail[5714]: At entry, counter=[0]
03/05 12:01:51.595 vmprov5s (66,2) ba4, f00: CMAPIImpl::SendUMEmail[5946]: Error pIMsgStore is NULL.
03/05 12:01:51.595 vmprov5s (66,5) ba4, f00: CMAPIImpl::SendUMEmail[5949]: At Exit, counter=[0]
03/05 12:01:51.595 vmprov5s (66,8) ba4, f00: < CMAPIImpl::SendUMEmail()
03/05 12:01:51.595 vmprov5s (66,8) ba4, f00: < CMAPIImpl::SendUMEmail()
03/05 12:01:51.595 vmprov5s (19,2) ba4, f00: Error (hr=0x80004003) from SendUMEmail
03/05 12:01:51.595 vmprov5s (19,8) ba4, f00: < CMAPIImpl::SendUMEmail()
03/05 12:01:51.595 vmprov5s (14,2) ba4, f00: Error 0x80004003 sending email to jsmith@companyname.com
03/05 12:01:51.595 vmprov5s (14,9) ba4, f00: < EMailer::SendRequestUsingEMAPI()
03/05 12:01:51.595 vmprov5s (14,2) ba4, f00: emailer - SendRequest failed for 51818\MSG00012, error Invalid pointer (80004003)
03/05 12:01:51.656 vmprov5s (66,2) ba4, 6b4: CMAPIImpl::Connect[2820]: Error 0x8004011d [MAPI_E_FAILONEPROVIDER] from OpenMsgStore (Microsoft Exchange is not available. Either there are network problems or the Exchange server is down for maintenance. : Microsoft Exchange Information Store[1318]) trying to open message store for default session.
03/05 12:01:51.656 vmprov5s (66,8) ba4, 6b4: < CMAPIImpl::Connect()
03/05 12:01:51.656 vmprov5s (19,2) ba4, 6b4: Error (hr=0x8004011d [MAPI_E_FAILONEPROVIDER]) from MAPIConnect
03/05 12:01:51.656 vmprov5s (19,8) ba4, 6b4: > CMAPIImpl:

isconnect()
03/05 12:01:51.656 vmprov5s (66,8) ba4, 6b4: > CMAPIImpl:

isconnect()
03/05 12:01:51.657 vmprov5s (66,8) ba4, 6b4: < CMAPIImpl:

isconnect()
03/05 12:01:51.657 vmprov5s (66,8) ba4, 6b4: > CMAPIImpl:

isconnect()
03/05 12:01:51.657 vmprov5s (66,8) ba4, 6b4: < CMAPIImpl:

isconnect()
03/05 12:01:51.657 vmprov5s (19,8) ba4, 6b4: < CMAPIImpl:

isconnect()
03/05 12:01:51.657 vmprov5s (19,8) ba4, 6b4: < CMAPIImpl::MAPIConnect()
03/05 12:01:51.657 vmprov5s (19,8) ba4, 6b4: < CMAPIImpl::EventThreadRoutine()
03/05 12:01:51.657 vmprov5s (29,9) ba4, 6b4: Thread CMAPIImpl::EventThreadRoutine (02A758A8) (TID: 0x6b4 (1716)) completed
03/05 12:01:51.657 vmprov5s (29,9) ba4, 6b4: Terminating thread CMAPIImpl::EventThreadRoutine (02A758A8) (TID: 6b4 (1716))
03/05 12:01:51.657 vmprov5s (29,9) ba4, 6b4: Thread CMAPIImpl::EventThreadRoutine (02A758A8) (TID: 6b4 (1716)) terminated
03/05 12:01:51.657 DbgOut (01,5) 2980,1716: DllMain(hinstDLL=0x10000000, fdwReason=DLL_THREAD_DETACH)
03/05 12:01:51.659 DbgOut (01,5) 2980,2196: DllMain(hinstDLL=0x10000000, fdwReason=DLL_THREAD_ATTACH)
03/05 12:01:51.660 vmprov5s (25,2) ba4, 948: Exception has occurred in CMAPIImpl::MAPIConnect (.\MAPIImpl.cpp[1963])
03/05 12:01:51.660 vmprov5s (09,2) ba4, 948: Exception has occurred in CMAPIImpl::MAPIConnect (.\MAPIImpl.cpp[1963])
03/05 12:01:51.661 vmprov5s (19,8) ba4, 948: > CMAPIImpl:

isconnect()
03/05 12:01:51.661 vmprov5s (66,8) ba4, 948: > CMAPIImpl:

isconnect()
03/05 12:01:51.661 vmprov5s (66,8) ba4, 948: < CMAPIImpl:

isconnect()
03/05 12:01:51.661 vmprov5s (66,8) ba4, 948: > CMAPIImpl:

isconnect()
03/05 12:01:51.661 vmprov5s (66,8) ba4, 948: < CMAPIImpl:

isconnect()
03/05 12:01:51.661 vmprov5s (19,8) ba4, 948: < CMAPIImpl:

isconnect()
03/05 12:01:51.661 vmprov5s (19,8) ba4, 948: < CMAPIImpl::MAPIConnect()
03/05 12:01:51.661 vmprov5s (19,8) ba4, 948: < CMAPIImpl::EventThreadRoutine()
03/05 12:01:51.661 vmprov5s (29,9) ba4, 948: Thread CMAPIImpl::EventThreadRoutine (02A75488) (TID: 0x948 (2376)) completed
03/05 12:01:51.661 vmprov5s (29,9) ba4, 948: Terminating thread CMAPIImpl::EventThreadRoutine (02A75488) (TID: 948 (2376))
03/05 12:01:51.661 vmprov5s (29,9) ba4, 948: Thread CMAPIImpl::EventThreadRoutine (02A75488) (TID: 948 (2376)) terminated
03/05 12:01:51.661 DbgOut (01,5) 2980,2376: DllMain(hinstDLL=0x10000000, fdwReason=DLL_THREAD_DETACH)
03/05 12:01:51.662 DbgOut (01,5) 2980,2196: DllMain(hinstDLL=0x10000000, fdwReason=DLL_THREAD_DETACH)
03/05 12:01:53.469 DbgOut (01,5) 2980,4088: DllMain(hinstDLL=0x10000000, fdwReason=DLL_THREAD_DETACH)
03/05 12:01:54.854 DbgOut (01,5) 2980,2436: DllMain(hinstDLL=0x10000000, fdwReason=DLL_THREAD_DETACH)
03/05 12:01:56.291 DbgOut (01,5) 2980,1184: DllMain(hinstDLL=0x10000000, fdwReason=DLL_THREAD_DETACH)
03/05 12:01:56.609 vmprov5s (06,8) ba4, b90: SOCKSTask::Main(VMServer [SOCKSTask] port 50791): Received request " VMMESSAGE_POLL Session=00000000, Seq=0" from 192.168.54.2:4098
03/05 12:01:56.610 vmprov5s (06,8) ba4, 5b0: [TCPServerThread[0]]: Processing server[192.168.54.2],m_User->Identifier()[192.168.54.2],PBXCount=[1], request " VMMESSAGE_POLL Session=00000000, Seq=0"
03/05 12:01:56.610 vmprov5s (26,6) ba4, 5b0: PBX <192.168.54.2> - Backup active = FALSE, backing up PBX <0.0.0.0>
03/05 12:01:56.610 vmprov5s (26,6) ba4, 5b0: POLL from 192.168.54.2:4098 contained the following sync info: bBackupActive=0, ulBackupIp=0.0.0.0, uCentralIP=0.0.0.0, tsPeerVMDNS=, tsPeerIPOName=company-Den, buf->data[35]=0, buf[31-34]=0.0.0.0
03/05 12:01:56.610 vmprov5s (06,8) ba4, 5b0: SOCKSTask::SendBuffer(VMServer [SOCKSTask] port 50791): Sending request " VMMESSAGE_DISTINFO Session=00000000, Seq=0" to server "192.168.54.2"
03/05 12:01:56.610 vmprov5s (06,8) ba4, 5b0: SOCKSTask::SendBuffer(VMServer [SOCKSTask] port 50791): Sending request " VMMESSAGE_SERVERUP Version=8.1.90.0" to server "192.168.54.2"
03/05 12:01:56.610 vmprov5s (06,8) ba4, 5b0: [TCPServerThread[0]]: Server[192.168.54.2], request " VMMESSAGE_POLL Session=00000000, Seq=0" - took 0.000ms
03/05 12:01:57.652 DbgOut (01,5) 2980,3460: DllMain(hinstDLL=0x10000000, fdwReason=DLL_THREAD_DETACH)
03/05 12:01:57.655 DbgOut (01,5) 2980,2572: DllMain(hinstDLL=0x10000000, fdwReason=DLL_THREAD_DETACH)
03/05 12:02:06.609 vmprov5s (06,8) ba4, b90: SOCKSTask::Main(VMServer [SOCKSTask] port 50791): Received request " VMMESSAGE_POLL Session=00000000, Seq=0" from 192.168.54.2:4098
03/05 12:02:06.609 vmprov5s (06,8) ba4, 5b0: [TCPServerThread[0]]: Processing server[192.168.54.2],m_User->Identifier()[192.168.54.2],PBXCount=[1], request " VMMESSAGE_POLL Session=00000000, Seq=0"
03/05 12:02:06.609 vmprov5s (26,6) ba4, 5b0: PBX <192.168.54.2> - Backup active = FALSE, backing up PBX <0.0.0.0>
03/05 12:02:06.609 vmprov5s (26,6) ba4, 5b0: POLL from 192.168.54.2:4098 contained the following sync info: bBackupActive=0, ulBackupIp=0.0.0.0, uCentralIP=0.0.0.0, tsPeerVMDNS=, tsPeerIPOName=company-Den, buf->data[35]=0, buf[31-34]=0.0.0.0
03/05 12:02:06.609 vmprov5s (06,8) ba4, 5b0: SOCKSTask::SendBuffer(VMServer [SOCKSTask] port 50791): Sending request " VMMESSAGE_DISTINFO Session=00000000, Seq=0" to server "192.168.54.2"
03/05 12:02:06.610 vmprov5s (06,8) ba4, 5b0: SOCKSTask::SendBuffer(VMServer [SOCKSTask] port 50791): Sending request " VMMESSAGE_SERVERUP Version=8.1.90.0" to server "192.168.54.2"
03/05 12:02:06.610 vmprov5s (06,8) ba4, 5b0: [TCPServerThread[0]]: Server[192.168.54.2], request " VMMESSAGE_POLL Session=00000000, Seq=0" - took 0.000ms
03/05 12:02:16.609 vmprov5s (06,8) ba4, b90: SOCKSTask::Main(VMServer [SOCKSTask] port 50791): Received request " VMMESSAGE_POLL Session=00000000, Seq=0" from 192.168.54.2:4098
03/05 12:02:16.609 vmprov5s (06,8) ba4, 5b0: [TCPServerThread[0]]: Processing server[192.168.54.2],m_User->Identifier()[192.168.54.2],PBXCount=[1], request " VMMESSAGE_POLL Session=00000000, Seq=0"
03/05 12:02:16.609 vmprov5s (26,6) ba4, 5b0: PBX <192.168.54.2> - Backup active = FALSE, backing up PBX <0.0.0.0>
03/05 12:02:16.609 vmprov5s (26,6) ba4, 5b0: POLL from 192.168.54.2:4098 contained the following sync info: bBackupActive=0, ulBackupIp=0.0.0.0, uCentralIP=0.0.0.0, tsPeerVMDNS=, tsPeerIPOName=company-Den, buf->data[35]=0, buf[31-34]=0.0.0.0
03/05 12:02:16.609 vmprov5s (06,8) ba4, 5b0: SOCKSTask::SendBuffer(VMServer [SOCKSTask] port 50791): Sending request " VMMESSAGE_DISTINFO Session=00000000, Seq=0" to server "192.168.54.2"
03/05 12:02:16.609 vmprov5s (06,8) ba4, 5b0: SOCKSTask::SendBuffer(VMServer [SOCKSTask] port 50791): Sending request " VMMESSAGE_SERVERUP Version=8.1.90.0" to server "192.168.54.2"
03/05 12:02:16.609 vmprov5s (06,8) ba4, 5b0: [TCPServerThread[0]]: Server[192.168.54.2], request " VMMESSAGE_POLL Session=00000000, Seq=0" - took 0.000ms
03/05 12:02:26.608 vmprov5s (06,8) ba4, b90: SOCKSTask::Main(VMServer [SOCKSTask] port 50791): Received request " VMMESSAGE_POLL Session=00000000, Seq=0" from 192.168.54.2:4098
03/05 12:02:26.608 vmprov5s (06,8) ba4, 5b0: [TCPServerThread[0]]: Processing server[192.168.54.2],m_User->Identifier()[192.168.54.2],PBXCount=[1], request " VMMESSAGE_POLL Session=00000000, Seq=0"
03/05 12:02:26.608 vmprov5s (26,6) ba4, 5b0: PBX <192.168.54.2> - Backup active = FALSE, backing up PBX <0.0.0.0>
03/05 12:02:26.608 vmprov5s (26,6) ba4, 5b0: POLL from 192.168.54.2:4098 contained the following sync info: bBackupActive=0, ulBackupIp=0.0.0.0, uCentralIP=0.0.0.0, tsPeerVMDNS=, tsPeerIPOName=company-Den, buf->data[35]=0, buf[31-34]=0.0.0.0
03/05 12:02:26.609 vmprov5s (06,8) ba4, 5b0: SOCKSTask::SendBuffer(VMServer [SOCKSTask] port 50791): Sending request " VMMESSAGE_DISTINFO Session=00000000, Seq=0" to server "192.168.54.2"
03/05 12:02:26.609 vmprov5s (06,8) ba4, 5b0: SOCKSTask::SendBuffer(VMServer [SOCKSTask] port 50791): Sending request " VMMESSAGE_SERVERUP Version=8.1.90.0" to server "192.168.54.2"
03/05 12:02:26.609 vmprov5s (06,8) ba4, 5b0: [TCPServerThread[0]]: Server[192.168.54.2], request " VMMESSAGE_POLL Session=00000000, Seq=0" - took 0.016ms
03/05 12:02:36.608 vmprov5s (06,8) ba4, b90: SOCKSTask::Main(VMServer [SOCKSTask] port 50791): Received request " VMMESSAGE_POLL Session=00000000, Seq=0" from 192.168.54.2:4098
03/05 12:02:36.608 vmprov5s (06,8) ba4, 5b0: [TCPServerThread[0]]: Processing server[192.168.54.2],m_User->Identifier()[192.168.54.2],PBXCount=[1], request " VMMESSAGE_POLL Session=00000000, Seq=0"
03/05 12:02:36.608 vmprov5s (26,6) ba4, 5b0: PBX <192.168.54.2> - Backup active = FALSE, backing up PBX <0.0.0.0>
03/05 12:02:36.608 vmprov5s (26,6) ba4, 5b0: POLL from 192.168.54.2:4098 contained the following sync info: bBackupActive=0, ulBackupIp=0.0.0.0, uCentralIP=0.0.0.0, tsPeerVMDNS=, tsPeerIPOName=company-Den, buf->data[35]=0, buf[31-34]=0.0.0.0
03/05 12:02:36.608 vmprov5s (06,8) ba4, 5b0: SOCKSTask::SendBuffer(VMServer [SOCKSTask] port 50791): Sending request " VMMESSAGE_DISTINFO Session=00000000, Seq=0" to server "192.168.54.2"
03/05 12:02:36.608 vmprov5s (06,8) ba4, 5b0: SOCKSTask::SendBuffer(VMServer [SOCKSTask] port 50791): Sending request " VMMESSAGE_SERVERUP Version=8.1.90.0" to server "192.168.54.2"
03/05 12:02:36.608 vmprov5s (06,8) ba4, 5b0: [TCPServerThread[0]]: Server[192.168.54.2], request " VMMESSAGE_POLL Session=00000000, Seq=0" - took 0.000ms
03/05 12:02:42.002 vmprov5s (09,5) ba4, a78: IP Office Voicemail Pro [Hardware mode 03] - Version 8.1 (9016) [CPU Usage 0.0] [CPU Min:0.0, Avg:0.5, Max:159.9] has been running for 0 days, 1 hours and 35 minutes and received 19 calls (0 missed voice packets) (19 completed, 12 calls/hour) (Call duration(secs) - Min:0, Max:72, Avg:21).
03/05 12:02:42.002 vmprov5s (09,5) ba4, a78: System Configuration:-
Voicemail Pro mode, locale: enu, IPO hardware mode: 03 [USA]
03/05 12:02:42.002 vmprov5s (09,5) ba4, a78: EVML:-
03/05 12:02:42.002 vmprov5s (09,5) ba4, a78: Maximum recording capacity: Unlimited, Maximum Recording Time: 120 seconds
03/05 12:02:42.002 vmprov5s (09,5) ba4, a78: Maximum Sessions: 4, Minimum PIN length: 0 digits
03/05 12:02:42.002 vmprov5s (09,5) ba4, a78: SMTP:-
Host address 192.168.1.7, port 25, Login method "none", email from "DEN-IPOFFICE@companyname.com", login user ""
03/05 12:02:42.002 vmprov5s (09,5) ba4, a78: Voicemail Sessions (Connections 0 - 0) (Links:11877 from 12000) (CMMsg:2 left from 2) (VM:0 NODES:0 SN:0 SBL:0 FILES:0)
03/05 12:02:46.608 vmprov5s (06,8) ba4, b90: SOCKSTask::Main(VMServer [SOCKSTask] port 50791): Received request " VMMESSAGE_POLL Session=00000000, Seq=0" from 192.168.54.2:4098
03/05 12:02:46.608 vmprov5s (06,8) ba4, 5b0: [TCPServerThread[0]]: Processing server[192.168.54.2],m_User->Identifier()[192.168.54.2],PBXCount=[1], request " VMMESSAGE_POLL Session=00000000, Seq=0"
03/05 12:02:46.608 vmprov5s (26,6) ba4, 5b0: PBX <192.168.54.2> - Backup active = FALSE, backing up PBX <0.0.0.0>
03/05 12:02:46.608 vmprov5s (26,6) ba4, 5b0: POLL from 192.168.54.2:4098 contained the following sync info: bBackupActive=0, ulBackupIp=0.0.0.0, uCentralIP=0.0.0.0, tsPeerVMDNS=, tsPeerIPOName=company-Den, buf->data[35]=0, buf[31-34]=0.0.0.0
03/05 12:02:46.608 vmprov5s (06,8) ba4, 5b0: SOCKSTask::SendBuffer(VMServer [SOCKSTask] port 50791): Sending request " VMMESSAGE_DISTINFO Session=00000000, Seq=0" to server "192.168.54.2"
03/05 12:02:46.608 vmprov5s (06,8) ba4, 5b0: SOCKSTask::SendBuffer(VMServer [SOCKSTask] port 50791): Sending request " VMMESSAGE_SERVERUP Version=8.1.90.0" to server "192.168.54.2"
03/05 12:02:46.608 vmprov5s (06,8) ba4, 5b0: [TCPServerThread[0]]: Server[192.168.54.2], request " VMMESSAGE_POLL Session=00000000, Seq=0" - took 0.000ms
03/05 12:02:54.002 vmprov5s (19,1) ba4, a78: VMIsMAPIAvailable returning [1]
03/05 12:02:54.002 vmprov5s (19,5) ba4, a78: CMAPIImpl::CheckMAPIConnection() - return is 0,m_iMAPIStatus = [-1]
03/05 12:02:54.002 DbgOut (01,5) 2980, 768: DllMain(hinstDLL=0x10000000, fdwReason=DLL_THREAD_ATTACH)
03/05 12:02:54.002 vmprov5s (29,9) ba4, a78: Created thread CMAPIImpl::EventThreadRoutine (02A75488) (TID: 300 (768))
03/05 12:02:54.002 DbgOut (01,5) 2980,3576: DllMain(hinstDLL=0x10000000, fdwReason=DLL_THREAD_ATTACH)
03/05 12:02:54.002 vmprov5s (29,9) ba4, a78: Created thread CMAPIImpl::EventThreadRoutine (02A758A8) (TID: df8 (3576))
03/05 12:02:54.014 vmprov5s (29,9) ba4, df8: Processing thread CMAPIImpl::EventThreadRoutine (02A758A8) (TID: 0xdf8 (3576))
03/05 12:02:54.014 vmprov5s (19,8) ba4, df8: > CMAPIImpl::EventThreadRoutine(02AA4490)
03/05 12:02:54.014 vmprov5s (19,8) ba4, df8: > CMAPIImpl::MAPIConnect(SES-EX AvayaVoicemail@companyname.com Outlook true)
03/05 12:02:54.014 vmprov5s (66,8) ba4, df8: > CMAPIImpl::Connect(Exchange Server: <SES-EX>, Default Mailbox: <AvayaVoicemail@companyname.com>, Profile: <Outlook>)
03/05 12:02:54.014 vmprov5s (66,8) ba4, df8: > CMAPIImpl:

isconnect()
03/05 12:02:54.014 vmprov5s (66,8) ba4, df8: < CMAPIImpl:

isconnect()
03/05 12:02:54.014 vmprov5s (66,5) ba4, df8: Configuring for service.
03/05 12:02:54.014 vmprov5s (66,5) ba4, df8: Attempting to logon to MAPI using profile Outlook.
03/05 12:02:54.014 vmprov5s (29,9) ba4, 300: Processing thread CMAPIImpl::EventThreadRoutine (02A75488) (TID: 0x300 (768))
03/05 12:02:54.014 vmprov5s (19,8) ba4, 300: > CMAPIImpl::EventThreadRoutine(02AA43C0)
03/05 12:02:54.014 vmprov5s (19,8) ba4, 300: > CMAPIImpl::MAPIConnect(SES-EX AvayaVoicemail@companyname.com Outlook false)
03/05 12:02:54.014 vmprov5s (66,8) ba4, 300: > CMAPIImpl::Connect(Exchange Server: <SES-EX>, Default Mailbox: <AvayaVoicemail@companyname.com>, Profile: <Outlook>)
03/05 12:02:54.014 vmprov5s (66,8) ba4, 300: > CMAPIImpl:

isconnect()
03/05 12:02:54.014 vmprov5s (66,8) ba4, 300: < CMAPIImpl:

isconnect()
03/05 12:02:54.014 vmprov5s (66,5) ba4, 300: Configuring for service.
03/05 12:02:54.014 vmprov5s (66,5) ba4, 300: Attempting to logon to MAPI using profile Outlook.
03/05 12:02:54.024 DbgOut (01,5) 2980,2400: DllMain(hinstDLL=0x10000000, fdwReason=DLL_THREAD_ATTACH)
03/05 12:02:54.030 DbgOut (01,5) 2980,1428: DllMain(hinstDLL=0x10000000, fdwReason=DLL_THREAD_ATTACH)
03/05 12:02:54.031 DbgOut (01,5) 2980,1680: DllMain(hinstDLL=0x10000000, fdwReason=DLL_THREAD_ATTACH)
03/05 12:02:54.268 DbgOut (01,5) 2980,1968: DllMain(hinstDLL=0x10000000, fdwReason=DLL_THREAD_ATTACH)
03/05 12:02:55.555 vmprov5s (66,2) ba4, df8: CMAPIImpl::Connect[2820]: Error 0x8004011d [MAPI_E_FAILONEPROVIDER] from OpenMsgStore (Microsoft Exchange is not available. Either there are network problems or the Exchange server is down for maintenance. : Microsoft Exchange Information Store[1318]) trying to open message store for default session.
03/05 12:02:55.555 vmprov5s (66,8) ba4, df8: < CMAPIImpl::Connect()
03/05 12:02:55.555 vmprov5s (19,2) ba4, df8: Error (hr=0x8004011d [MAPI_E_FAILONEPROVIDER]) from MAPIConnect
03/05 12:02:55.555 vmprov5s (19,8) ba4, df8: > CMAPIImpl:

isconnect()
03/05 12:02:55.555 vmprov5s (66,8) ba4, df8: > CMAPIImpl:

isconnect()
03/05 12:02:55.555 vmprov5s (66,8) ba4, df8: < CMAPIImpl:

isconnect()
03/05 12:02:55.555 vmprov5s (66,8) ba4, df8: > CMAPIImpl:

isconnect()
03/05 12:02:55.555 vmprov5s (66,8) ba4, df8: < CMAPIImpl:

isconnect()
03/05 12:02:55.555 vmprov5s (19,8) ba4, df8: < CMAPIImpl:

isconnect()
03/05 12:02:55.555 vmprov5s (19,8) ba4, df8: < CMAPIImpl::MAPIConnect()
03/05 12:02:55.555 vmprov5s (19,8) ba4, df8: < CMAPIImpl::EventThreadRoutine()
03/05 12:02:55.555 vmprov5s (29,9) ba4, df8: Thread CMAPIImpl::EventThreadRoutine (02A758A8) (TID: 0xdf8 (3576)) completed
03/05 12:02:55.555 vmprov5s (29,9) ba4, df8: Terminating thread CMAPIImpl::EventThreadRoutine (02A758A8) (TID: df8 (3576))
03/05 12:02:55.555 vmprov5s (29,9) ba4, df8: Thread CMAPIImpl::EventThreadRoutine (02A758A8) (TID: df8 (3576)) terminated
03/05 12:02:55.555 DbgOut (01,5) 2980,3576: DllMain(hinstDLL=0x10000000, fdwReason=DLL_THREAD_DETACH)
03/05 12:02:55.556 DbgOut (01,5) 2980,4012: DllMain(hinstDLL=0x10000000, fdwReason=DLL_THREAD_ATTACH)
03/05 12:02:55.557 vmprov5s (25,2) ba4, 300: Exception has occurred in CMAPIImpl::MAPIConnect (.\MAPIImpl.cpp[1963])
03/05 12:02:55.557 vmprov5s (09,2) ba4, 300: Exception has occurred in CMAPIImpl::MAPIConnect (.\MAPIImpl.cpp[1963])
03/05 12:02:55.557 vmprov5s (19,8) ba4, 300: > CMAPIImpl:

isconnect()
03/05 12:02:55.557 vmprov5s (66,8) ba4, 300: > CMAPIImpl:

isconnect()
03/05 12:02:55.557 vmprov5s (66,8) ba4, 300: < CMAPIImpl:

isconnect()
03/05 12:02:55.557 vmprov5s (66,8) ba4, 300: > CMAPIImpl:

isconnect()
03/05 12:02:55.557 vmprov5s (66,8) ba4, 300: < CMAPIImpl:

isconnect()
03/05 12:02:55.557 vmprov5s (19,8) ba4, 300: < CMAPIImpl:

isconnect()
03/05 12:02:55.557 vmprov5s (19,8) ba4, 300: < CMAPIImpl::MAPIConnect()
03/05 12:02:55.557 vmprov5s (19,8) ba4, 300: < CMAPIImpl::EventThreadRoutine()
03/05 12:02:55.557 vmprov5s (29,9) ba4, 300: Thread CMAPIImpl::EventThreadRoutine (02A75488) (TID: 0x300 (768)) completed
03/05 12:02:55.557 vmprov5s (29,9) ba4, 300: Terminating thread CMAPIImpl::EventThreadRoutine (02A75488) (TID: 300 (768))
03/05 12:02:55.557 vmprov5s (29,9) ba4, 300: Thread CMAPIImpl::EventThreadRoutine (02A75488) (TID: 300 (768)) terminated
03/05 12:02:55.557 DbgOut (01,5) 2980, 768: DllMain(hinstDLL=0x10000000, fdwReason=DLL_THREAD_DETACH)
03/05 12:02:55.558 DbgOut (01,5) 2980,1788: DllMain(hinstDLL=0x10000000, fdwReason=DLL_THREAD_ATTACH)
03/05 12:02:55.558 DbgOut (01,5) 2980,4012: DllMain(hinstDLL=0x10000000, fdwReason=DLL_THREAD_DETACH)
03/05 12:02:56.607 vmprov5s (06,8) ba4, b90: SOCKSTask::Main(VMServer [SOCKSTask] port 50791): Received request " VMMESSAGE_POLL Session=00000000, Seq=0" from 192.168.54.2:4098
03/05 12:02:56.607 vmprov5s (06,8) ba4, 5b0: [TCPServerThread[0]]: Processing server[192.168.54.2],m_User->Identifier()[192.168.54.2],PBXCount=[1], request " VMMESSAGE_POLL Session=00000000, Seq=0"
03/05 12:02:56.607 vmprov5s (26,6) ba4, 5b0: PBX <192.168.54.2> - Backup active = FALSE, backing up PBX <0.0.0.0>
03/05 12:02:56.607 vmprov5s (26,6) ba4, 5b0: POLL from 192.168.54.2:4098 contained the following sync info: bBackupActive=0, ulBackupIp=0.0.0.0, uCentralIP=0.0.0.0, tsPeerVMDNS=, tsPeerIPOName=company-Den, buf->data[35]=0, buf[31-34]=0.0.0.0
03/05 12:02:56.607 vmprov5s (06,8) ba4, 5b0: SOCKSTask::SendBuffer(VMServer [SOCKSTask] port 50791): Sending request " VMMESSAGE_DISTINFO Session=00000000, Seq=0" to server "192.168.54.2"
03/05 12:02:56.607 vmprov5s (06,8) ba4, 5b0: SOCKSTask::SendBuffer(VMServer [SOCKSTask] port 50791): Sending request " VMMESSAGE_SERVERUP Version=8.1.90.0" to server "192.168.54.2"
03/05 12:02:56.607 vmprov5s (06,8) ba4, 5b0: [TCPServerThread[0]]: Server[192.168.54.2], request " VMMESSAGE_POLL Session=00000000, Seq=0" - took 0.000ms
03/05 12:02:57.248 vmprov5s (06,8) ba4, f60: SOCKSTask::Main(TFTPTask [SOCKSTask] port 0): Received request " UNKNOWN[00] Data is 029483E8, length is 516" from 192.168.54.2:4185
03/05 12:02:57.248 vmprov5s (11,9) ba4, 69c: > TFTPDevIOTask:

rocessReceiveBuffer(029CB1F0: PBX=029C60D0[company-Den (MASTER:192.168.54.2 - SLAVE:0.0.0.0 [INACTIVE]) [8.1 (63)]] (valid), current_pbx=011C8030)
03/05 12:02:57.248 vmprov5s (11,8) ba4, 69c: > TFTPTask:

rocessReceiveBuffer(029CB1F0, buf=02672278, IP:192.168.54.2, port=4185, state=TFTP_IDLE, current_pbx=029A8A78)
03/05 12:02:57.248 vmprov5s (11,6) ba4, 69c: TFTP_IDLE - seq=141
03/05 12:02:57.248 vmprov5s (11,9) ba4, 69c: > TFTPDevIOTask::InitializeUpdates(029CB1F0: PBX=029C60D0[company-Den (MASTER:192.168.54.2 - SLAVE:0.0.0.0 [INACTIVE]) [8.1 (63)]] (valid), current_pbx=029A8A78)
03/05 12:02:57.248 vmprov5s (11,9) ba4, 69c: < TFTPDevIOTask::InitializeUpdates()
03/05 12:02:57.248 vmprov5s (11,6) ba4, 69c: TFTP_UPDATING - seq=141, newseq=142
03/05 12:02:57.248 vmprov5s (11,9) ba4, 69c: > TFTPDevIOTask::RxData(029CB1F0: PBX=029C60D0[company-Den (MASTER:192.168.54.2 - SLAVE:0.0.0.0 [INACTIVE]) [8.1 (63)]] (valid), current_pbx=029A8A78, dp=026836CC (len=512), stream(029CB334 len=0))
03/05 12:02:57.248 vmprov5s (11,8) ba4, 69c: > TFTPTask::RxData(029CB1F0 - IP:192.168.54.2 [state=TFTP_UPDATING,len=512], current_pbx=029A8A78)
03/05 12:02:57.248 vmprov5s (11,8) ba4, 69c: < TFTPTask::RxData()
03/05 12:02:57.248 vmprov5s (11,9) ba4, 69c: < TFTPDevIOTask::RxData()
03/05 12:02:57.248 vmprov5s (06,8) ba4, 69c: SOCKSTask::SendBuffer(TFTPTask [SOCKSTask] port 0): Sending request " UNKNOWN[00] Data is 026836C8, length is 4" to server "192.168.54.2"
03/05 12:02:57.248 vmprov5s (11,8) ba4, 69c: < TFTPTask:

rocessReceiveBuffer()
03/05 12:02:57.248 vmprov5s (11,9) ba4, 69c: < TFTPDevIOTask:

rocessReceiveBuffer()
03/05 12:02:57.249 vmprov5s (06,8) ba4, f60: SOCKSTask::Main(TFTPTask [SOCKSTask] port 0): Received request " UNKNOWN[00] Data is 029483E8, length is 54" from 192.168.54.2:4185
03/05 12:02:57.249 vmprov5s (11,9) ba4, 69c: > TFTPDevIOTask:

rocessReceiveBuffer(029CB1F0: PBX=029C60D0[company-Den (MASTER:192.168.54.2 - SLAVE:0.0.0.0 [INACTIVE]) [8.1 (63)]] (valid), current_pbx=011C8030)
03/05 12:02:57.249 vmprov5s (11,8) ba4, 69c: > TFTPTask:

rocessReceiveBuffer(029CB1F0, buf=02672278, IP:192.168.54.2, port=4185, state=TFTP_UPDATING, current_pbx=029A8A78)
03/05 12:02:57.249 vmprov5s (11,6) ba4, 69c: TFTP_UPDATING - seq=142, newseq=143
03/05 12:02:57.249 vmprov5s (11,9) ba4, 69c: > TFTPDevIOTask::RxData(029CB1F0: PBX=029C60D0[company-Den (MASTER:192.168.54.2 - SLAVE:0.0.0.0 [INACTIVE]) [8.1 (63)]] (valid), current_pbx=029A8A78, dp=0268389A (len=50), stream(029CB334 len=512))
03/05 12:02:57.249 vmprov5s (11,8) ba4, 69c: > TFTPTask::RxData(029CB1F0 - IP:192.168.54.2 [state=TFTP_UPDATING,len=50], current_pbx=029A8A78)
03/05 12:02:57.249 vmprov5s (11,9) ba4, 69c: > TFTPDevIOTask::UpdatesComplete(029CB1F0: PBX=029C60D0[company-Den (MASTER:192.168.54.2 - SLAVE:0.0.0.0 [INACTIVE]) [8.1 (63)]] (valid), current_pbx=029A8A78)
03/05 12:02:57.249 vmprov5s (09,6) ba4, 69c: Using config version (8.1.63=81063) for <company-Den (MASTER:192.168.54.2 - SLAVE:0.0.0.0 [INACTIVE]) [8.1 (63)]>
03/05 12:02:57.249 vmprov5s (11,9) ba4, 69c: > IVRConfig::Load(029CB328, merge=TRUE, current_pbx=029A8A78)
03/05 12:02:57.249 vmprov5s (11,9) ba4, 69c: > VMProConfigMerger::StartConfigMerge(029B6160, current_pbx=029A8A78)
03/05 12:02:57.249 vmprov5s (11,9) ba4, 69c: < VMProConfigMerger::StartConfigMerge()
03/05 12:02:57.249 vmprov5s (11,9) ba4, 69c: > IVRConfig::GetRecord(029CB328, current_pbx=029A8A78)
03/05 12:02:57.249 vmprov5s (11,9) ba4, 69c: < IVRConfig::GetRecord()
03/05 12:02:57.249 vmprov5s (11,9) ba4, 69c: > VMProConfigMerger::MergeObject(029B6160 [obj=02A012E8])
03/05 12:02:57.249 vmprov5s (11,9) ba4, 69c: > VMProConfigMerger::MergeUser(029B6160 [Name=pdaily], current_pbx=029A8A78)
03/05 12:02:57.249 vmprov5s (11,9) ba4, 69c: > UpdateUser(pdaily->pdaily, current_pbx=029A8A78)
03/05 12:02:57.249 vmprov5s (11,9) ba4, 69c: < UpdateUser()
03/05 12:02:57.249 vmprov5s (11,9) ba4, 69c: > UserUpdated(pdaily, current_pbx=029A8A78)
03/05 12:02:57.249 vmprov5s (11,9) ba4, 69c: < UserUpdated()
03/05 12:02:57.249 vmprov5s (11,9) ba4, 69c: < VMProConfigMerger::MergeUser()
03/05 12:02:57.249 vmprov5s (11,9) ba4, 69c: < VMProConfigMerger::MergeObject()
03/05 12:02:57.249 vmprov5s (11,9) ba4, 69c: > IVRConfig::GetRecord(029CB328, current_pbx=029A8A78)
03/05 12:02:57.249 vmprov5s (11,9) ba4, 69c: < IVRConfig::GetRecord()
03/05 12:02:57.249 vmprov5s (11,9) ba4, 69c: > VMProConfigMerger::EndConfigMerge(029B6160, current_pbx=029A8A78)
03/05 12:02:57.249 vmprov5s (11,9) ba4, 69c: < VMProConfigMerger::EndConfigMerge()
03/05 12:02:57.249 vmprov5s (11,9) ba4, 69c: < IVRConfig::Load()
03/05 12:02:57.249 vmprov5s (11,9) ba4, 69c: < TFTPDevIOTask::UpdatesComplete()
03/05 12:02:57.249 vmprov5s (11,8) ba4, 69c: < TFTPTask::RxData()
03/05 12:02:57.249 vmprov5s (11,9) ba4, 69c: < TFTPDevIOTask::RxData()
03/05 12:02:57.249 vmprov5s (06,8) ba4, 69c: SOCKSTask::SendBuffer(TFTPTask [SOCKSTask] port 0): Sending request " UNKNOWN[00] Data is 02683896, length is 4" to server "192.168.54.2"
03/05 12:02:57.249 vmprov5s (11,8) ba4, 69c: < TFTPTask:

rocessReceiveBuffer()
03/05 12:02:57.249 vmprov5s (11,9) ba4, 69c: < TFTPDevIOTask:

rocessReceiveBuffer()
03/05 12:02:57.250 vmprov5s (06,8) ba4, cec: > VMailBox::ResynchMailbox(Name: pdaily)
03/05 12:02:57.250 vmprov5s (06,8) ba4, cec: VMailBox::ResynchMailbox(pdaily) - Updating Mailbox record
03/05 12:02:57.250 vmprov5s (06,8) ba4, cec: > VMailBox::SynchMailboxRecord(Name: pdaily)
03/05 12:02:57.250 vmprov5s (06,8) ba4, cec: < VMailBox::SynchMailboxRecord()
03/05 12:02:57.250 vmprov5s (06,8) ba4, cec: VMailBox::ResynchMailbox(pdaily) - Configuring breakout numbers
03/05 12:02:57.250 vmprov5s (06,8) ba4, cec: > VMailBox::SynchBreakoutNumbers(Name: pdaily)
03/05 12:02:57.250 vmprov5s (1d,8) ba4, cec: > tblMailbox::RemoveBreakoutNumbers(ID:{7424fec2-d755-4591-8ac2-32ec54a2325b})
03/05 12:02:57.250 vmprov5s (1d,8) ba4, cec: < tblMailbox::RemoveBreakoutNumbers()
03/05 12:02:57.250 vmprov5s (1d,8) ba4, cec: > tblMailbox::LocateBreakoutNumber(Mailbox ID:{7424fec2-d755-4591-8ac2-32ec54a2325b}, Number:51801, DtmfKey:0)
03/05 12:02:57.250 vmprov5s (1d,5) ba4, cec: Information: No data found executing SQLFetch (line 1306, file ".\tblMailbox.cpp")
03/05 12:02:57.250 vmprov5s (1d,8) ba4, cec: < tblMailbox::LocateBreakoutNumber()
03/05 12:02:57.250 vmprov5s (1d,8) ba4, cec: > tblBreakoutNumbers::SaveRecord(Mailbox: {7424fec2-d755-4591-8ac2-32ec54a2325b}, ID:{00000000-0000-0000-0000-000000000000})
03/05 12:02:57.251 vmprov5s (1d,8) ba4, cec: < tblBreakoutNumbers::SaveRecord()
03/05 12:02:57.251 vmprov5s (06,8) ba4, cec: < VMailBox::SynchBreakoutNumbers()
03/05 12:02:57.251 vmprov5s (06,8) ba4, cec: < VMailBox::ResynchMailbox()
03/05 12:03:00.031 DbgOut (01,5) 2980,1428: DllMain(hinstDLL=0x10000000, fdwReason=DLL_THREAD_DETACH)
03/05 12:03:01.553 DbgOut (01,5) 2980,1680: DllMain(hinstDLL=0x10000000, fdwReason=DLL_THREAD_DETACH)
03/05 12:03:01.555 DbgOut (01,5) 2980,2904: DllMain(hinstDLL=0x10000000, fdwReason=DLL_THREAD_DETACH)
03/05 12:03:06.607 vmprov5s (06,8) ba4, b90: SOCKSTask::Main(VMServer [SOCKSTask] port 50791): Received request " VMMESSAGE_POLL Session=00000000, Seq=0" from 192.168.54.2:4098
03/05 12:03:06.607 vmprov5s (06,8) ba4, 5b0: [TCPServerThread[0]]: Processing server[192.168.54.2],m_User->Identifier()[192.168.54.2],PBXCount=[1