POP3 and Outlook 2002

Devinder Thiara · Jul 15, 2003

Curious if anyone else has had a problem with outlook 2002
not downloading messages off a POP3 server hosted on a
UNIX box. We recive the messages, but Outlook fails to
delete the "read" messages from the server. And yes I
checked the settings in Outlook 2002 to indicate not to
save messages on the server. Weird.

Jeff Stephenson [MSFT] · Jul 15, 2003

I haven't heard of this before. Could you turn on diagnostic logging (see
http://support.microsoft.com/default.aspx?scid=kb;en-us;Q300479) and post
the OPMLog.log file after a session in which messages aren't deleted?

Devinder · Jul 15, 2003

Here is the log:

2003.07.15 15:42:56 <<<< Logging Started (level is
LTF_TRACE) >>>>
2003.07.15 15:42:56 Successfully initialized the resource
manager
2003.07.15 15:42:56 ResourceObject [THIS: 00184c10]:
Created
2003.07.15 15:42:56 ResourceObject [THIS: 00184c10]:
Synchronize called (flags = 00000031)
2003.07.15 15:42:56 ResourceObject [THIS: 00184c10]:
Synch operation started (flags = 00000031)
2003.07.15 15:42:56 ResourceObject [THIS: 00184c10]:
StartImport(flags = 00000000, max msg = ffffffff): full
items
2003.07.15 15:42:56 ResourceObject [THIS: 00184c10]:
Trying to read remote URL off the resource
2003.07.15 15:42:56 Looking up handler for POP
2003.07.15 15:42:56 Creating proto handler {848F8363-04C9-
11D3-B8AF-00105A19CDC6}
2003.07.15 15:42:56 Initializing proto handler {848F8363-
04C9-11D3-B8AF-00105A19CDC6}
2003.07.15 15:42:56 ResourceObject [THIS: 00184c10]:
StartImport: Retrieving Blob
2003.07.15 15:42:56 ResourceObject [THIS: 00184c10]:
StartImport: pCallback->StartImport
2003.07.15 15:42:56
Callback::ExecuteThread2003.07.15 15:42:56
Callback::LogText[THIS: 00173ca8] (flags = LTF_TRACE, hr =
00000000, code = 00000000,
2003.07.15 15:42:56 "CPOPManifestTask:
Begin execution")
[THIS: 00173ca8] (00001000) returns 00000000
2003.07.15 15:42:56 Callback::ExecuteThread[THIS:
00173ca8] (00001000) returns 00000000
2003.07.15 15:42:56 Callback::LogText[THIS:
00173ca8] (flags = LTF_TRACE, hr = 00000000, code =
00000000,
2003.07.15 15:42:56 "POP3: Finding host")
2003.07.15 15:42:56 ResourceObject [THIS: 00184c10]:
DeleteNukedItems - Nothing to nuke
2003.07.15 15:42:56 ResourceObject [THIS: 00184c10]:
UploadItems: 0 messages to send
2003.07.15 15:42:57 Callback::LogText[THIS:
00173ca8] (flags = LTF_TRACE, hr = 00000000, code =
00000000,
2003.07.15 15:42:57 "POP3: Connecting to
host")
2003.07.15 15:42:57 Callback::LogText[THIS:
00173ca8] (flags = LTF_TRACE, hr = 00000000, code =
00000000,
2003.07.15 15:42:57 "POP3: Connected to
host")
2003.07.15 15:42:57 Callback::LogText[THIS:
00173ca8] (flags = LTF_TRACE, hr = 00000000, code =
00000000,
2003.07.15 15:42:57 "POP3: <rx> +OK
<[email protected]>, MercuryP/NLM v1.48 ready.")
2003.07.15 15:42:57 Callback::LogText[THIS:
00173ca8] (flags = LTF_TRACE, hr = 00000000, code =
00000000,
2003.07.15 15:42:57 "POP3: Authorizing
to server")
2003.07.15 15:42:57 Callback::LogText[THIS:
00173ca8] (flags = LTF_TRACE, hr = 00000000, code =
00000000,
2003.07.15 15:42:57 "POP3: [tx] USER
dthiara.nd")
2003.07.15 15:42:57 Callback::LogText[THIS:
00173ca8] (flags = LTF_TRACE, hr = 00000000, code =
00000000,
2003.07.15 15:42:57 "POP3: <rx> +OK
dthiara.nd.")
2003.07.15 15:42:57 Callback::LogText[THIS:
00173ca8] (flags = LTF_TRACE, hr = 00000000, code =
00000000,
2003.07.15 15:42:57 "POP3: [tx] PASS
*****")
2003.07.15 15:42:58 Callback::LogText[THIS:
00173ca8] (flags = LTF_TRACE, hr = 00000000, code =
00000000,
2003.07.15 15:42:58 "POP3: <rx> +OK 0
messages (1837195 bytes)")
2003.07.15 15:42:58 Callback::LogText[THIS:
00173ca8] (flags = LTF_TRACE, hr = 00000000, code =
00000000,
2003.07.15 15:42:58 "POP3: Authorized to
host")
2003.07.15 15:42:58 Callback::LogText[THIS:
00173ca8] (flags = LTF_TRACE, hr = 00000000, code =
00000000,
2003.07.15 15:42:58 "POP3: Connected to
host")
2003.07.15 15:42:58 Callback::ReportStatus[THIS:
00173ca8] (ulAsynchPhase = RSF_CONNECTED) Progress = 1/3
2003.07.15 15:42:58 Callback::ReportStatus[THIS:
00173ca8] (ulAsynchPhase = RSF_CONNECTED) Progress = 2/4
2003.07.15 15:42:58 Callback::LogText[THIS:
00173ca8] (flags = LTF_TRACE, hr = 00000000, code =
00000000,
2003.07.15 15:42:58 "POP3: [tx] STAT")
2003.07.15 15:42:58 Callback::LogText[THIS:
00173ca8] (flags = LTF_TRACE, hr = 00000000, code =
00000000,
2003.07.15 15:42:58 "POP3: <rx> +OK 0
1837195")
2003.07.15 15:42:58 Callback::ReportStatus[THIS:
00173ca8] (ulAsynchPhase = RSF_INPROGRESS) Progress = 3/5
2003.07.15 15:42:58 Callback::LogText[THIS:
00173ca8] (flags = LTF_TRACE, hr = 00000000, code =
00000000,
2003.07.15 15:42:58 "POP3: [tx] UIDL")
2003.07.15 15:42:58 Callback::LogText[THIS:
00173ca8] (flags = LTF_TRACE, hr = 00000000, code =
00000000,
2003.07.15 15:42:58 "POP3: <rx> -ERR No
messages.")
2003.07.15 15:42:58 Callback::LogText[THIS:
00173ca8] (flags = LTF_TRACE, hr = 00000000, code =
00000000,
2003.07.15 15:42:58 "Server does not
support UIDL. Falling back on TOP.")
2003.07.15 15:42:58 Callback::ReportStatus[THIS:
00173ca8] (ulAsynchPhase = RSF_CONNECTED) Progress = 4/7
2003.07.15 15:42:58 Callback::ReportStatus[THIS:
00173ca8] (ulAsynchPhase = RSF_CONNECTED) Progress = 5/8
2003.07.15 15:42:58 Callback::LogText[THIS:
00173ca8] (flags = LTF_TRACE, hr = 00000000, code =
00000000,
2003.07.15 15:42:58 "POP3: [tx] STAT")
2003.07.15 15:42:58 Callback::LogText[THIS:
00173ca8] (flags = LTF_TRACE, hr = 00000000, code =
00000000,
2003.07.15 15:42:58 "POP3: <rx> +OK 0
1837195")
2003.07.15 15:42:58 Callback::ReportStatus[THIS:
00173ca8] (ulAsynchPhase = RSF_INPROGRESS) Progress = 6/9
2003.07.15 15:42:58 Callback::ReportStatus[THIS:
00173ca8] (ulAsynchPhase = RSF_INPROGRESS) Progress = 7/9
2003.07.15 15:42:58 Callback::LogText[THIS:
00173ca8] (flags = LTF_TRACE, hr = 00000000, code =
00000000,
2003.07.15 15:42:58 "CPOPManifestTask:
Comparing server and local blobs")
2003.07.15 15:42:58 ManifestCallback::ImportDelete
[THIS: 00173ca8] (-b2003071519322607F24$2eCNM2EEF7987)
returns 0x8004010f
2003.07.15 15:42:58 ManifestCallback::ImportDelete
[THIS: 00173ca8] (-b200307151932270DC60$2eCNM2EEF7413)
returns 0x8004010f
2003.07.15 15:42:58 Callback::ReportStatus[THIS:
00173ca8] (ulAsynchPhase = RSF_INPROGRESS) Progress = 8/9
2003.07.15 15:42:58 Callback::LogText[THIS:
00173ca8] (flags = LTF_TRACE, hr = 00000000, code =
00000000,
2003.07.15 15:42:58 "CPOPManifestTask:
Checking for messages to delete")
2003.07.15 15:42:58 Callback::LogText[THIS:
00173ca8] (flags = LTF_TRACE, hr = 00000000, code =
00000000,
2003.07.15 15:42:58 "CPOPManifestTask:
End execution")
2003.07.15 15:42:58 Callback::ReportStatus[THIS:
00173ca8] (ulAsynchPhase = RSF_COMPLETED, hrStatus =
0x00000000)
2003.07.15 15:42:58 ResourceObject [THIS: 00184c10]:
StartImport(flags = 00000004, max msg = ffffffff): full
items
2003.07.15 15:42:58 ResourceObject [THIS: 00184c10]:
StartImport: Retrieving Blob
2003.07.15 15:42:58 ResourceObject [THIS: 00184c10]:
StartImport: pCallback->StartImport
2003.07.15 15:42:58 Callback::LogText[THIS:
0018fba0] (flags = LTF_TRACE, hr = 00000000, code =
00000000,
2003.07.15 15:42:58 "CPOPManifestTask:
Begin execution")
2003.07.15 15:42:58 Callback::ExecuteThread[THIS:
0018fba0] (00001000) returns 00000000
2003.07.15 15:42:58 ManifestCallback::SetBlob[THIS:
0018fba0] returns 0x00000000
2003.07.15 15:42:58 Callback::LogText[THIS:
0018fba0] (flags = LTF_TRACE, hr = 00000000, code =
00000000,
2003.07.15 15:42:58 "CPOPManifestTask:
End execution")
2003.07.15 15:42:58 Callback::ReportStatus[THIS:
0018fba0] (ulAsynchPhase = RSF_COMPLETED, hrStatus =
0x00000000)
2003.07.15 15:42:58 ResourceObject [THIS: 00184c10]:
Synch operation completed
2003.07.15 15:42:58 ResourceObject [THIS: 00184c10]:
Synchronize called (flags = 00000031)
2003.07.15 15:42:58 ResourceObject [THIS: 00184c10]:
Synch operation started (flags = 00000031)
2003.07.15 15:42:58 ResourceObject [THIS: 00184c10]:
StartImport(flags = 00000000, max msg = ffffffff): full
items
2003.07.15 15:42:58 ResourceObject [THIS: 00184c10]:
StartImport: Retrieving Blob
2003.07.15 15:42:58 ResourceObject [THIS: 00184c10]:
StartImport: pCallback->StartImport
2003.07.15 15:42:58 Callback::LogText[THIS:
0016c8e0] (flags = LTF_TRACE, hr = 00000000, code =
00000000,
2003.07.15 15:42:58 "CPOPManifestTask:
Begin execution")
2003.07.15 15:42:58 Callback::ExecuteThread[THIS:
0016c8e0] (00001000) returns 00000000
2003.07.15 15:42:58 Callback::ExecuteThread[THIS:
0016c8e0] (00001000) returns 00000000
2003.07.15 15:42:58 Callback::LogText[THIS:
0016c8e0] (flags = LTF_TRACE, hr = 00000000, code =
00000000,
2003.07.15 15:42:58 "POP3: Finding host")
2003.07.15 15:42:58 Callback::LogText[THIS:
0016c8e0] (flags = LTF_TRACE, hr = 00000000, code =
00000000,
2003.07.15 15:42:58 "POP3: Connected to
host")
2003.07.15 15:42:58 Callback::LogText[THIS:
0016c8e0] (flags = LTF_TRACE, hr = 00000000, code =
00000000,
2003.07.15 15:42:58 "POP3: <rx> +OK
<[email protected]>, MercuryP/NLM v1.48 ready.")
2003.07.15 15:42:58 Callback::LogText[THIS:
0016c8e0] (flags = LTF_TRACE, hr = 00000000, code =
00000000,
2003.07.15 15:42:58 "POP3: Authorizing
to server")
2003.07.15 15:42:58 Callback::LogText[THIS:
0016c8e0] (flags = LTF_TRACE, hr = 00000000, code =
00000000,
2003.07.15 15:42:58 "POP3: [tx] USER
dthiara.nd")
2003.07.15 15:42:58 Callback::LogText[THIS:
0016c8e0] (flags = LTF_TRACE, hr = 00000000, code =
00000000,
2003.07.15 15:42:58 "POP3: <rx> +OK
dthiara.nd.")
2003.07.15 15:42:58 Callback::LogText[THIS:
0016c8e0] (flags = LTF_TRACE, hr = 00000000, code =
00000000,
2003.07.15 15:42:58 "POP3: [tx] PASS
*****")
2003.07.15 15:42:58 ResourceObject [THIS: 00184c10]:
DeleteNukedItems - Nothing to nuke
2003.07.15 15:42:58 ResourceObject [THIS: 00184c10]:
UploadItems: 0 messages to send
2003.07.15 15:42:58 Callback::LogText[THIS:
0016c8e0] (flags = LTF_TRACE, hr = 00000000, code =
00000000,
2003.07.15 15:42:58 "POP3: <rx> +OK 0
messages (1837195 bytes)")
2003.07.15 15:42:58 Callback::LogText[THIS:
0016c8e0] (flags = LTF_TRACE, hr = 00000000, code =
00000000,
2003.07.15 15:42:58 "POP3: Authorized to
host")
2003.07.15 15:42:58 Callback::LogText[THIS:
0016c8e0] (flags = LTF_TRACE, hr = 00000000, code =
00000000,
2003.07.15 15:42:58 "POP3: Connected to
host")
2003.07.15 15:42:58 Callback::ReportStatus[THIS:
0016c8e0] (ulAsynchPhase = RSF_CONNECTED) Progress = 1/3
2003.07.15 15:42:58 Callback::ReportStatus[THIS:
0016c8e0] (ulAsynchPhase = RSF_CONNECTED) Progress = 2/4
2003.07.15 15:42:58 Callback::LogText[THIS:
0016c8e0] (flags = LTF_TRACE, hr = 00000000, code =
00000000,
2003.07.15 15:42:58 "POP3: [tx] STAT")
2003.07.15 15:42:58 Callback::LogText[THIS:
0016c8e0] (flags = LTF_TRACE, hr = 00000000, code =
00000000,
2003.07.15 15:42:58 "POP3: <rx> +OK 0
1837195")
2003.07.15 15:42:58 Callback::ReportStatus[THIS:
0016c8e0] (ulAsynchPhase = RSF_INPROGRESS) Progress = 3/5
2003.07.15 15:42:58 Callback::LogText[THIS:
0016c8e0] (flags = LTF_TRACE, hr = 00000000, code =
00000000,
2003.07.15 15:42:58 "Server does not
support UIDL. Falling back on TOP.")
2003.07.15 15:42:58 Callback::ReportStatus[THIS:
0016c8e0] (ulAsynchPhase = RSF_CONNECTED) Progress = 4/7
2003.07.15 15:42:58 Callback::ReportStatus[THIS:
0016c8e0] (ulAsynchPhase = RSF_CONNECTED) Progress = 5/8
2003.07.15 15:42:58 Callback::LogText[THIS:
0016c8e0] (flags = LTF_TRACE, hr = 00000000, code =
00000000,
2003.07.15 15:42:58 "POP3: [tx] STAT")
2003.07.15 15:42:58 Callback::LogText[THIS:
0016c8e0] (flags = LTF_TRACE, hr = 00000000, code =
00000000,
2003.07.15 15:42:58 "POP3: <rx> +OK 0
1837195")
2003.07.15 15:42:58 Callback::ReportStatus[THIS:
0016c8e0] (ulAsynchPhase = RSF_INPROGRESS) Progress = 6/9
2003.07.15 15:42:58 Callback::ReportStatus[THIS:
0016c8e0] (ulAsynchPhase = RSF_INPROGRESS) Progress = 7/9
2003.07.15 15:42:58 Callback::LogText[THIS:
0016c8e0] (flags = LTF_TRACE, hr = 00000000, code =
00000000,
2003.07.15 15:42:58 "CPOPManifestTask:
Comparing server and local blobs")
2003.07.15 15:42:58 Callback::ReportStatus[THIS:
0016c8e0] (ulAsynchPhase = RSF_INPROGRESS) Progress = 8/9
2003.07.15 15:42:58 Callback::LogText[THIS:
0016c8e0] (flags = LTF_TRACE, hr = 00000000, code =
00000000,
2003.07.15 15:42:58 "CPOPManifestTask:
Checking for messages to delete")
2003.07.15 15:42:58 Callback::LogText[THIS:
0016c8e0] (flags = LTF_TRACE, hr = 00000000, code =
00000000,
2003.07.15 15:42:58 "CPOPManifestTask:
End execution")
2003.07.15 15:42:58 Callback::ReportStatus[THIS:
0016c8e0] (ulAsynchPhase = RSF_COMPLETED, hrStatus =
0x00000000)
2003.07.15 15:42:58 ResourceObject [THIS: 00184c10]:
Synch operation completed

POP3 and Outlook 2002

Devinder Thiara

Jeff Stephenson [MSFT]

Devinder