Problem receiving emails in an multi client system

Former Member · ‎07-19-2007

Hi all,

i've 3 clients and for all of them i've configured an sapconnect SMTP Service which corresponds to a specific profile parameter.

icm/plugin_2 PROT=SMTP

icm/plugin_1 PROT=HTTPS

icm/plugin_0 PROT=HTTP

icm/server_port_4 PROT=SMTP,PORT=25492

icm/server_port_3 PROT=SMTP,PORT=25491

icm/server_port_2 PROT=SMTP,PORT=25490

icm/server_port_1 PROT=HTTPS,PORT=44356,TIMEOUT=900

icm/server_port_0 PROT=HTTP,PORT=8056,TIMEOUT=900

is/SMTP/virt_host_2 P500.HF-GROUP.COM:25492

is/SMTP/virt_host_1 P220.HF-GROUP.COM:25491

is/SMTP/virt_host_0 P110.HF-GROUP.COM:25490

here is a logfile that shows what happend when i try to send a mail:

=₌=₌=₌=₌=₌=_{= PuTTY log 2007.07.01 11:39:44 =}=₌=₌=₌=₌=₌=

220 k1b06cus.khis.krupp.com SAP 7.00(52) ESMTP service ready

HELO

250 k1b06cus.khis.krupp.com

mail from:<dagobert@hf-group.com>

250 Ok

rcpt to:<reinhold.mueller@p500.hf-group.com>

250 Ok

data

354 Enter mail, end with "."

subject: Test

Test Zeile 1

Test Zeile 2

.

554 Transaction failed

quit

221 k1b06cus.khis.krupp.com Bye

and here is the corresponding icm log:

-

trc file: "dev_icm", trc level: 3, release: "700"

-

sysno 56

sid P56

systemid 324 (IBM RS/6000 with AIX)

relno 7000

patchlevel 0

patchno 100

intno 20050900

make: multithreaded, ASCII, 64 bit, optimized

pid 1687654

[Thr 01] Sun Jul 1 11:39:41 2007

[Thr 01] TRACE FILE TRUNCATED

[Thr 01] <<- SapSSLSetTraceFile()==SAP_O_K

[Thr 01] NiBufIAlloc: malloc ICM_EXT, to 80 bytes

[Thr 01]

NiBufSend starting

[Thr 515] SiSelPSelect: start select (timeout=10000)

[Thr 3342] Sun Jul 1 11:40:55 2007

[Thr 3342] NiSelISelectInt: 0 handles selected (0 buffered)

[Thr 3342] IcmQueueAppend: queuelen: 1

[Thr 3342] IcmCreateRequest: Appended request 42722

[Thr 3342] IcmCheckForBlockedThreads: check for blocked SSL-threads

[Thr 3342] IcmWatchDogThread: check ni handles (timeout=10000)

[Thr 3342] SiSelPSelect: start select (timeout=10000)

[Thr 1286] IcmWorkerThread: worker 2 got the semaphore

[Thr 1286] REQUEST:

Type: SCHEDULER Index = 42721

[Thr 1286] IcmGetSchedule: found slot 0

[Thr 1286] IcmAlReportData: Reporting data to CCMS Alerting Infrastructure

[Thr 1286] NiIGetServNo: servicename '8056' = port 1F.78/8056

[Thr 1286] IcmConnCheckStoredClientConn: next client timeout check in 50 sec

[Thr 1286] NiIGetServNo: servicename '8056' = port 1F.78/8056

[Thr 1286] IcmGetServicePtr: new serv_ref_count: 2

[Thr 1286] PlugInHandleAdmMessage: request received:

[Thr 1286] PlugInHandleAdmMessage: opcode: 136, len: 272, dest_type: 2, subhdlkey: 262145

[Thr 1286] HttpSubHandlerCall: Call Handler: HttpCacheHandler, task=4, header_len=0

[Thr 1286] HttpCacheHandler: 4 0 110272160 0

[Thr 1286] SCACHE: adm request received:

[Thr 1286] SCACHE: opcode: 136, len: 272, dest_type: 2, dest:

[Thr 1286] MTX_LOCK 3038 110d1e050

[Thr 1286] MTX_UNLOCK 3051 110d1e050

[Thr 1286] IctCmGetCacheInfo#18874 -> 0

[Thr 1286] IcmNetBufWrapBuf: allocated netbuf: 110465e00, blocks used: 1

[Thr 1286] IcmNetBufWrapBuf: allocated netbuf: 110465e00

[Thr 1286] IcmNetBufFree: free netbuf: 110465e00 out of 1 used

[Thr 1286] IcmConnFreeContext: context 2 released

[Thr 1286] IcmServDecrRefCount: k1b06cus.khis.krupp.com:8056 - serv_ref_count: 1

[Thr 1286] IcmGetSchedule: next schedule in 30 secs

[Thr 1286] IcmWorkerThread: Thread 2: Waiting for event

[Thr 515] Sun Jul 1 11:41:00 2007

[Thr 515] SiSelPSelect: of 1 sockets 0 selected

[Thr 515] IcmProxyWatchDog: check sockets (timeout=10000)

[Thr 515] SiSelPSelect: start select (timeout=10000)

[Thr 3342] Sun Jul 1 11:41:03 2007

[Thr 3342] SiSelPNext: sock 63 selected (pos=2; revt=r--)

[Thr 3342] NiSelIListInsert: add hdl 44 [2] to sel-list (0) of set1

[Thr 3342] NiSelISelectInt: 1 handles selected (0 buffered)

[Thr 3342] IcmWatchDogThread(id=2/39991): nihdl 44 - data received(read)

[Thr 3342] SiSelPClear: set events of sock 63 to: ---

[Thr 3342] NiSelIListRemove: remove hdl 44 [2] from sel-list (1) of set1

[Thr 3342] SiSelPRemove: removed last sock 63 (pos=2)

[Thr 3342] NiSelIRemove: removed hdl 44

[Thr 3342] IcmQueueAppend: queuelen: 1

[Thr 3342] IcmCreateRequest: Appended request 42723

[Thr 3342] IcmConnRollIn: connection (id=2/39991) rolled back to status: READ_REQUEST

[Thr 3085] IcmWorkerThread: worker 9 got the semaphore

[Thr 3085] REQUEST:

Type: READ_REQUEST Index = 42722

[Thr 3085] CONNECTION (id=2/39991):

used: 1, type: 1, role: 1, stateful: 0

NI_HDL: 44, protocol: SMTP(4)

local host: 170.56.225.77:25492 ()

remote host: 170.56.149.133:1129 ()

status: READ_REQUEST

connect time: 01.07.2007 11:40:06

MPI request: <a653> MPI response: <a654>

request_buf_size: 65464 response_buf_size: 0

request_buf_used: 0 response_buf_used: 0

request_buf_offset: 0 response_buf_offset: 0

[Thr 3342] IcmWatchDogThread: check ni handles (timeout=10000)

[Thr 3085] NiIRead: hdl 44 received data (rcd=35,pac=1,RAW_IO)

[Thr 3085] IcmReadFromConn(id=2/39991): read 35 bytes(timeout 500)

[Thr 3085] Address Offset IcmReadFromConn received

[Thr 3085] -

[Thr 3085] 700000000c214e8 000000 6d61696c 2066726f 6d3a3c64 61676f62 |mail from:<dagob|

[Thr 3085] 700000000c214f8 000016 65727440 68662d67 726f7570 2e636f6d |ert@hf-group.com|

[Thr 3085] 700000000c21508 000032 3e0d0a |>.. |

[Thr 3085] -

[Thr 3085] SMTP PlugInHandleNetData entry

[Thr 3085] SMTP PlugInHandleNetData: reply = mail from:<dagobert@hf-group.com>

[Thr 3085] SMTP SmtpActivity: state = -3, reply = 3

[Thr 3085] SMTP SmtpServerRecvMail: MAIL received, get originator

[Thr 3342] SiSelPSelect: start select (timeout=10000)

[Thr 3085] MPI<a653>5#8 GetOutbuf -1 148368 65536 (0) -> 700000000bd1388 0

[Thr 3085] SMTP SmtpServerRecvMail: send '250 Ok'

[Thr 3085] IcmNetBufWrapBuf: allocated netbuf: 110465e00, blocks used: 1

[Thr 3085] IcmNetBufWrapBuf: allocated netbuf: 110465e00

[Thr 3085] MPI<a653>5#9 DiscardOutbuf l5 0 0 198480 0 0 -> 700000000c21480 0

[Thr 3085] IcmPlCheckRetVal: Next status: READ_REQUEST(1)

[Thr 3085] IcmHandleNetRead(id=2/39991): read_len: 35, HandleNetData returned: 1

[Thr 3085] Address Offset IcmWriteToConn:

[Thr 3085] -

[Thr 3085] 11029b630 000000 32353020 4f6b0d0a |250 Ok.. |

[Thr 3085] -

[Thr 3085] IcmWriteToConn(id=2/39991): prepared to write data to partner (len = 😎

[Thr 3085] NiIWrite: hdl 44 sent data (wrt=8,pac=1,RAW_IO)

[Thr 3085] IcmWriteToConn: NiWrite (8 bytes, timeout = -1) wrote 8,rc=0

[Thr 3085] IcmWriteToConn: net_buf_len=8

[Thr 3085] IcmWriteToConn(id=2/39991): wrote data to partner (len = 😎

[Thr 3085] IcmNetBufFree: free netbuf: 110465e00 out of 1 used

[Thr 3085] IcmHandleNetRead(id=2/39991): status 1 -> 1

[Thr 3085] IcmReadFromConn(id=2/39991): request new MPI (0/0)

[Thr 3085] MPI<a653>5#10 GetOutbuf -1 198480 65536 (0) -> 700000000c214a0 0

[Thr 3085] NiIRead: hdl 44 recv would block (errno=EAGAIN)

[Thr 3085] NiIRead: raw read for hdl 44 timed out (0ms)

[Thr 3085] IcmReadFromConn: read failed with timeout: 0 -> roll out

[Thr 3085] NiWakeupExec: send wakeup signal to 64994 (sock 17)

[Thr 3085] IcmConnRollOut: connection (id=2/39991) rolled out:

[Thr 3085] CONNECTION (id=2/39991):

used: 1, type: 1, role: 1, stateful: 0

NI_HDL: 44, protocol: SMTP(4)

local host: 170.56.225.77:25492 ()

remote host: 170.56.149.133:1129 ()

status: READ_REQUEST

connect time: 01.07.2007 11:40:06

MPI request: <a653> MPI response: <a654>

request_buf_size: 65464 response_buf_size: 0

request_buf_used: 0 response_buf_used: 0

request_buf_offset: 0 response_buf_offset: 0

[Thr 3085] IcmWorkerThread: Thread 9: Waiting for event

[Thr 3342] SiSelPNext: sock 16 selected (pos=0; revt=r--)

[Thr 3342] NiSelIListInsert: add hdl 3 [0] to sel-list (0) of set1

[Thr 3342] NiSelISelectInt: 1 handles selected (0 buffered)

[Thr 3342] NiIPeek: peek successful for hdl 3 (r)

[Thr 3342] NiIWakeupReceive: hdl 3 received 1 bytes from 127.0.0.1:41437

[Thr 3342] NiIPeek: peek for hdl 3 timed out (r; 0ms)

[Thr 3342] IcmWatchDogUpdateRollQueue(id=2/39991): insert fe-nihdl 44, flags=1

[Thr 3342] SiSelPSet: sock 63 added to set pos 1

[Thr 3342] NiSelIAddMsg: added hdl 44 to set1

[Thr 3342] SiSelPSet: set events of sock 63 to: rp-

[Thr 3342] IcmWatchDogThread: check ni handles (timeout=10000)

[Thr 3342] SiSelPSelect: start select (timeout=10000)

[Thr 515] Sun Jul 1 11:41:10 2007

[Thr 515] SiSelPSelect: of 1 sockets 0 selected

[Thr 515] IcmProxyWatchDog: check sockets (timeout=10000)

[Thr 515] SiSelPSelect: start select (timeout=10000)

[Thr 3342] Sun Jul 1 11:41:13 2007

[Thr 3342] NiSelISelectInt: 0 handles selected (0 buffered)

[Thr 3342] IcmWatchDogThread: check ni handles (timeout=10000)

[Thr 3342] SiSelPSelect: start select (timeout=10000)

[Thr 515] Sun Jul 1 11:41:21 2007

[Thr 515] SiSelPSelect: of 1 sockets 0 selected

[Thr 515] IcmProxyWatchDog: check sockets (timeout=10000)

[Thr 515] SiSelPSelect: start select (timeout=10000)

[Thr 3342] Sun Jul 1 11:41:23 2007

[Thr 3342] NiSelISelectInt: 0 handles selected (0 buffered)

[Thr 3342] IcmWatchDogThread: check ni handles (timeout=10000)

[Thr 3342] SiSelPSelect: start select (timeout=10000)

[Thr 3342] Sun Jul 1 11:41:27 2007

[Thr 3342] SiSelPNext: sock 63 selected (pos=1; revt=r--)

[Thr 3342] NiSelIListInsert: add hdl 44 [1] to sel-list (0) of set1

[Thr 3342] NiSelISelectInt: 1 handles selected (0 buffered)

[Thr 3342] IcmWatchDogThread(id=2/39991): nihdl 44 - data received(read)

[Thr 3342] SiSelPClear: set events of sock 63 to: ---

[Thr 3342] NiSelIListRemove: remove hdl 44 [1] from sel-list (1) of set1

[Thr 3342] SiSelPRemove: removed last sock 63 (pos=1)

[Thr 3342] NiSelIRemove: removed hdl 44

[Thr 3342] IcmQueueAppend: queuelen: 1

[Thr 3342] IcmCreateRequest: Appended request 42724

[Thr 3342] IcmConnRollIn: connection (id=2/39991) rolled back to status: READ_REQUEST

[Thr 1543] IcmWorkerThread: worker 3 got the semaphore

[Thr 1543] REQUEST:

Type: READ_REQUEST Index = 42723

[Thr 1543] CONNECTION (id=2/39991):

used: 1, type: 1, role: 1, stateful: 0

NI_HDL: 44, protocol: SMTP(4)

local host: 170.56.225.77:25492 ()

remote host: 170.56.149.133:1129 ()

status: READ_REQUEST

connect time: 01.07.2007 11:40:06

MPI request: <a653> MPI response: <a654>

request_buf_size: 65464 response_buf_size: 0

request_buf_used: 0 response_buf_used: 0

request_buf_offset: 0 response_buf_offset: 0

[Thr 3342] IcmQueueAppend: queuelen: 0

[Thr 1543] NiIRead: hdl 44 received data (rcd=46,pac=1,RAW_IO)

[Thr 1543] IcmReadFromConn(id=2/39991): read 46 bytes(timeout 500)

[Thr 1543] Address Offset IcmReadFromConn received

[Thr 1543] -

[Thr 1543] 700000000c214e8 000000 72637074 20746f3a 3c726569 6e686f6c |rcpt to:<reinhol|

[Thr 1543] 700000000c214f8 000016 642e6d75 656c6c65 72407035 30302e68 |d.mueller@p500.h|

[Thr 1543] 700000000c21508 000032 662d6772 6f75702e 636f6d3e 0d0a |f-group.com>.. |

[Thr 1543] -

[Thr 1543] SMTP PlugInHandleNetData entry

[Thr 1543] SMTP PlugInHandleNetData: reply = rcpt to:<reinhold.mueller@p500.hf-group.com>

[Thr 1543] SMTP SmtpActivity: state = -5, reply = 4

[Thr 1543] SMTP SmtpServerRecvRcpt: RCPT received, get recipient

[Thr 1543] SMTP SmtpServerRecvRcpt: send '250 Ok'

[Thr 3342] IcmCreateRequest: Appended request 42725

[Thr 3342] IcmCheckForBlockedThreads: check for blocked SSL-threads

[Thr 3342] IcmWatchDogThread: check ni handles (timeout=10000)

[Thr 3342] SiSelPSelect: start select (timeout=10000)

[Thr 2057] IcmWorkerThread: worker 5 got the semaphore

[Thr 2057] REQUEST:

Type: SCHEDULER Index = 42724

[Thr 2057] IcmGetSchedule: found slot 0

[Thr 2057] IcmAlReportData: Reporting data to CCMS Alerting Infrastructure

[Thr 2057] NiIGetServNo: servicename '8056' = port 1F.78/8056

[Thr 2057] IcmConnCheckStoredClientConn: next client timeout check in 18 sec

[Thr 2057] NiIGetServNo: servicename '8056' = port 1F.78/8056

[Thr 2057] IcmGetServicePtr: new serv_ref_count: 2

[Thr 2057] PlugInHandleAdmMessage: request received:

[Thr 2057] PlugInHandleAdmMessage: opcode: 136, len: 272, dest_type: 2, subhdlkey: 262145

[Thr 2057] HttpSubHandlerCall: Call Handler: HttpCacheHandler, task=4, header_len=0

[Thr 2057] HttpCacheHandler: 4 0 110272160 0

[Thr 2057] SCACHE: adm request received:

[Thr 2057] SCACHE: opcode: 136, len: 272, dest_type: 2, dest:

[Thr 2057] MTX_LOCK 3038 110d1e050

[Thr 2057] MTX_UNLOCK 3051 110d1e050

[Thr 2057] IctCmGetCacheInfo#18875 -> 0

[Thr 2057] IcmNetBufWrapBuf: allocated netbuf: 110465e80, blocks used: 2

[Thr 2057] IcmNetBufWrapBuf: allocated netbuf: 110465e80

[Thr 2057] IcmNetBufFree: free netbuf: 110465e80 out of 2 used

[Thr 2057] IcmConnFreeContext: context 2 released

[Thr 2057] IcmServDecrRefCount: k1b06cus.khis.krupp.com:8056 - serv_ref_count: 1

[Thr 2057] IcmGetSchedule: next schedule in 30 secs

[Thr 2057] IcmWorkerThread: Thread 5: Waiting for event

[Thr 1543] IcmNetBufWrapBuf: allocated netbuf: 110465e00, blocks used: 1

[Thr 1543] IcmNetBufWrapBuf: allocated netbuf: 110465e00

[Thr 1543] MPI<a653>5#11 DiscardOutbuf l5 0 0 198480 0 0 -> 700000000c21480 0

[Thr 1543] IcmPlCheckRetVal: Next status: READ_REQUEST(1)

[Thr 1543] IcmHandleNetRead(id=2/39991): read_len: 46, HandleNetData returned: 1

[Thr 1543] Address Offset IcmWriteToConn:

[Thr 1543] -

[Thr 1543] 11029b630 000000 32353020 4f6b0d0a |250 Ok.. |

[Thr 1543] -

[Thr 1543] IcmWriteToConn(id=2/39991): prepared to write data to partner (len = 😎

[Thr 1543] NiIWrite: hdl 44 sent data (wrt=8,pac=1,RAW_IO)

[Thr 1543] IcmWriteToConn: NiWrite (8 bytes, timeout = -1) wrote 8,rc=0

[Thr 1543] IcmWriteToConn: net_buf_len=8

[Thr 1543] IcmWriteToConn(id=2/39991): wrote data to partner (len = 😎

[Thr 1543] IcmNetBufFree: free netbuf: 110465e00 out of 1 used

[Thr 1543] IcmHandleNetRead(id=2/39991): status 1 -> 1

[Thr 1543] IcmReadFromConn(id=2/39991): request new MPI (0/0)

[Thr 1543] MPI<a653>5#12 GetOutbuf -1 198480 65536 (0) -> 700000000c214a0 0

[Thr 1543] NiIRead: hdl 44 recv would block (errno=EAGAIN)

[Thr 1543] NiIRead: raw read for hdl 44 timed out (0ms)

[Thr 1543] IcmReadFromConn: read failed with timeout: 0 -> roll out

[Thr 1543] NiWakeupExec: send wakeup signal to 64994 (sock 17)

[Thr 1543] IcmConnRollOut: connection (id=2/39991) rolled out:

[Thr 1543] CONNECTION (id=2/39991):

used: 1, type: 1, role: 1, stateful: 0

NI_HDL: 44, protocol: SMTP(4)

local host: 170.56.225.77:25492 ()

remote host: 170.56.149.133:1129 ()

status: READ_REQUEST

connect time: 01.07.2007 11:40:06

MPI request: <a653> MPI response: <a654>

request_buf_size: 65464 response_buf_size: 0

request_buf_used: 0 response_buf_used: 0

request_buf_offset: 0 response_buf_offset: 0

[Thr 1543] IcmWorkerThread: Thread 3: Waiting for event

[Thr 3342] SiSelPNext: sock 16 selected (pos=0; revt=r--)

[Thr 3342] NiSelIListInsert: add hdl 3 [0] to sel-list (0) of set1

[Thr 3342] NiSelISelectInt: 1 handles selected (0 buffered)

[Thr 3342] NiIPeek: peek successful for hdl 3 (r)

[Thr 3342] NiIWakeupReceive: hdl 3 received 1 bytes from 127.0.0.1:41437

[Thr 3342] NiIPeek: peek for hdl 3 timed out (r; 0ms)

[Thr 3342] IcmWatchDogUpdateRollQueue(id=2/39991): insert fe-nihdl 44, flags=1

[Thr 3342] SiSelPSet: sock 63 added to set pos 1

[Thr 3342] NiSelIAddMsg: added hdl 44 to set1

[Thr 3342] SiSelPSet: set events of sock 63 to: rp-

[Thr 3342] IcmWatchDogThread: check ni handles (timeout=10000)

[Thr 3342] SiSelPSelect: start select (timeout=10000)

[Thr 3342] Sun Jul 1 11:41:30 2007

[Thr 3342] SiSelPNext: sock 63 selected (pos=1; revt=r--)

[Thr 3342] NiSelIListInsert: add hdl 44 [1] to sel-list (0) of set1

[Thr 3342] NiSelISelectInt: 1 handles selected (0 buffered)

[Thr 3342] IcmWatchDogThread(id=2/39991): nihdl 44 - data received(read)

[Thr 3342] SiSelPClear: set events of sock 63 to: ---

[Thr 3342] NiSelIListRemove: remove hdl 44 [1] from sel-list (1) of set1

[Thr 3342] SiSelPRemove: removed last sock 63 (pos=1)

[Thr 3342] NiSelIRemove: removed hdl 44

[Thr 3342] IcmQueueAppend: queuelen: 1

[Thr 3342] IcmCreateRequest: Appended request 42726

[Thr 3342] IcmConnRollIn: connection (id=2/39991) rolled back to status: READ_REQUEST

[Thr 3342] IcmWatchDogThread: check ni handles (timeout=10000)

[Thr 3342] SiSelPSelect: start select (timeout=10000)

[Thr 2571] IcmWorkerThread: worker 7 got the semaphore

[Thr 2571] REQUEST:

Type: READ_REQUEST Index = 42725

[Thr 2571] CONNECTION (id=2/39991):

used: 1, type: 1, role: 1, stateful: 0

NI_HDL: 44, protocol: SMTP(4)

local host: 170.56.225.77:25492 ()

remote host: 170.56.149.133:1129 ()

status: READ_REQUEST

connect time: 01.07.2007 11:40:06

MPI request: <a653> MPI response: <a654>

request_buf_size: 65464 response_buf_size: 0

request_buf_used: 0 response_buf_used: 0

request_buf_offset: 0 response_buf_offset: 0

[Thr 2571] NiIRead: hdl 44 received data (rcd=6,pac=1,RAW_IO)

[Thr 2571] IcmReadFromConn(id=2/39991): read 6 bytes(timeout 500)

[Thr 2571] Address Offset IcmReadFromConn received

[Thr 2571] -

[Thr 2571] 700000000c214e8 000000 64617461 0d0a |data.. |

[Thr 2571] -

[Thr 2571] SMTP PlugInHandleNetData entry

[Thr 2571] SMTP PlugInHandleNetData: reply = data

[Thr 2571] SMTP SmtpActivity: state = -6, reply = 5

[Thr 2571] SMTP SmtpServerRecvData: DATA received, wait for message

[Thr 2571] SMTP SmtpServerRecvData: send '354 Enter mail, end with "."'

[Thr 2571] IcmNetBufWrapBuf: allocated netbuf: 110465e00, blocks used: 1

[Thr 2571] IcmNetBufWrapBuf: allocated netbuf: 110465e00

[Thr 2571] MPI<a653>5#13 DiscardOutbuf l5 0 0 198480 0 0 -> 700000000c21480 0

[Thr 2571] IcmPlCheckRetVal: Next status: READ_REQUEST(1)

[Thr 2571] IcmHandleNetRead(id=2/39991): read_len: 6, HandleNetData returned: 1

[Thr 2571] Address Offset IcmWriteToConn:

[Thr 2571] -

[Thr 2571] 11029b630 000000 33353420 456e7465 72206d61 696c2c20 |354 Enter mail, |

[Thr 2571] 11029b640 000016 656e6420 77697468 20222e22 0d0a |end with ".".. |

[Thr 2571] -

[Thr 2571] IcmWriteToConn(id=2/39991): prepared to write data to partner (len = 30)

[Thr 2571] NiIWrite: hdl 44 sent data (wrt=30,pac=1,RAW_IO)

[Thr 2571] IcmWriteToConn: NiWrite (30 bytes, timeout = -1) wrote 30,rc=0

[Thr 2571] IcmWriteToConn: net_buf_len=30

[Thr 2571] IcmWriteToConn(id=2/39991): wrote data to partner (len = 30)

[Thr 2571] IcmNetBufFree: free netbuf: 110465e00 out of 1 used

[Thr 2571] IcmHandleNetRead(id=2/39991): status 1 -> 1

[Thr 2571] IcmReadFromConn(id=2/39991): request new MPI (0/0)

[Thr 2571] MPI<a653>5#14 GetOutbuf -1 198480 65536 (0) -> 700000000c214a0 0

[Thr 2571] NiIRead: hdl 44 recv would block (errno=EAGAIN)

[Thr 2571] NiIRead: raw read for hdl 44 timed out (0ms)

[Thr 2571] IcmReadFromConn: read failed with timeout: 0 -> roll out

[Thr 2571] NiWakeupExec: send wakeup signal to 64994 (sock 17)

[Thr 2571] IcmConnRollOut: connection (id=2/39991) rolled out:

[Thr 2571] CONNECTION (id=2/39991):

used: 1, type: 1, role: 1, stateful: 0

NI_HDL: 44, protocol: SMTP(4)

local host: 170.56.225.77:25492 ()

remote host: 170.56.149.133:1129 ()

status: READ_REQUEST

connect time: 01.07.2007 11:40:06

MPI request: <a653> MPI response: <a654>

request_buf_size: 65464 response_buf_size: 0

request_buf_used: 0 response_buf_used: 0

request_buf_offset: 0 response_buf_offset: 0

[Thr 2571] IcmWorkerThread: Thread 7: Waiting for event

[Thr 3342] SiSelPNext: sock 16 selected (pos=0; revt=r--)

[Thr 3342] NiSelIListInsert: add hdl 3 [0] to sel-list (0) of set1

[Thr 3342] NiSelISelectInt: 1 handles selected (0 buffered)

[Thr 3342] NiIPeek: peek successful for hdl 3 (r)

[Thr 3342] NiIWakeupReceive: hdl 3 received 1 bytes from 127.0.0.1:41437

[Thr 3342] NiIPeek: peek for hdl 3 timed out (r; 0ms)

[Thr 3342] IcmWatchDogUpdateRollQueue(id=2/39991): insert fe-nihdl 44, flags=1

[Thr 3342] SiSelPSet: sock 63 added to set pos 1

[Thr 3342] NiSelIAddMsg: added hdl 44 to set1

[Thr 3342] SiSelPSet: set events of sock 63 to: rp-

[Thr 3342] IcmWatchDogThread: check ni handles (timeout=10000)

[Thr 3342] SiSelPSelect: start select (timeout=10000)

[Thr 515] Sun Jul 1 11:41:31 2007

[Thr 515] SiSelPSelect: of 1 sockets 0 selected

[Thr 515] IcmProxyWatchDog: check sockets (timeout=10000)

[Thr 515] SiSelPSelect: start select (timeout=10000)

[Thr 3342] Sun Jul 1 11:41:39 2007

[Thr 3342] SiSelPNext: sock 63 selected (pos=1; revt=r--)

[Thr 3342] NiSelIListInsert: add hdl 44 [1] to sel-list (0) of set1

[Thr 3342] NiSelISelectInt: 1 handles selected (0 buffered)

[Thr 3342] IcmWatchDogThread(id=2/39991): nihdl 44 - data received(read)

[Thr 3342] SiSelPClear: set events of sock 63 to: ---

[Thr 3342] NiSelIListRemove: remove hdl 44 [1] from sel-list (1) of set1

[Thr 3342] SiSelPRemove: removed last sock 63 (pos=1)

[Thr 3342] NiSelIRemove: removed hdl 44

[Thr 3342] IcmQueueAppend: queuelen: 1

[Thr 3342] IcmCreateRequest: Appended request 42727

[Thr 3342] IcmConnRollIn: connection (id=2/39991) rolled back to status: READ_REQUEST

[Thr 2828] IcmWorkerThread: worker 8 got the semaphore

[Thr 2828] REQUEST:

Type: READ_REQUEST Index = 42726

[Thr 2828] CONNECTION (id=2/39991):

used: 1, type: 1, role: 1, stateful: 0

NI_HDL: 44, protocol: SMTP(4)

local host: 170.56.225.77:25492 ()

remote host: 170.56.149.133:1129 ()

status: READ_REQUEST

connect time: 01.07.2007 11:40:06

MPI request: <a653> MPI response: <a654>

request_buf_size: 65464 response_buf_size: 0

request_buf_used: 0 response_buf_used: 0

request_buf_offset: 0 response_buf_offset: 0

[Thr 3342] IcmWatchDogThread: check ni handles (timeout=10000)

[Thr 3342] SiSelPSelect: start select (timeout=10000)

[Thr 2828] NiIRead: hdl 44 received data (rcd=13,pac=1,RAW_IO)

[Thr 2828] IcmReadFromConn(id=2/39991): read 13 bytes(timeout 500)

[Thr 2828] Address Offset IcmReadFromConn received

[Thr 2828] -

[Thr 2828] 700000000c214e8 000000 7375626a 6563743a 20546573 74 |subject: Test |

[Thr 2828] -

[Thr 2828] SMTP PlugInHandleNetData entry

[Thr 2828] MPI<a653>5#15 DiscardOutbuf l5 0 0 198480 0 0 -> 700000000c21480 0

[Thr 2828] IcmPlCheckRetVal: Next status: READ_REQUEST(1)

[Thr 2828] IcmHandleNetRead(id=2/39991): read_len: 13, HandleNetData returned: 1

[Thr 2828] IcmHandleNetRead(id=2/39991): status 1 -> 1

[Thr 2828] IcmReadFromConn(id=2/39991): request new MPI (0/0)

[Thr 2828] MPI<a653>5#16 GetOutbuf -1 198480 65536 (0) -> 700000000c214a0 0

[Thr 2828] NiIRead: hdl 44 recv would block (errno=EAGAIN)

[Thr 2828] NiIPeek: peek successful for hdl 44 (r)

[Thr 2828] NiIRead: hdl 44 received data (rcd=2,pac=1,RAW_IO)

[Thr 2828] IcmReadFromConn(id=2/39991): read 2 bytes(timeout 250)

[Thr 2828] Address Offset IcmReadFromConn received

[Thr 2828] -

[Thr 2828] 700000000c214e8 000000 0d0a |.. |

[Thr 2828] -

[Thr 2828] SMTP PlugInHandleNetData entry

[Thr 2828] SMTP PlugInHandleNetData: reply = subject: Test

[Thr 2828] SMTP SmtpActivity: state = -7, reply = 0

[Thr 2828] SMTP SmtpServerRecvMessage: message data received

[Thr 2828] MPI<a653>5#17 DiscardOutbuf l5 0 0 198480 0 0 -> 700000000c21480 0

[Thr 2828] IcmPlCheckRetVal: Next status: READ_REQUEST(1)

[Thr 2828] IcmHandleNetRead(id=2/39991): read_len: 2, HandleNetData returned: 1

[Thr 2828] IcmHandleNetRead(id=2/39991): status 1 -> 1

[Thr 2828] IcmReadFromConn(id=2/39991): request new MPI (0/0)

[Thr 2828] MPI<a653>5#18 GetOutbuf -1 198480 65536 (0) -> 700000000c214a0 0

[Thr 2828] NiIRead: hdl 44 recv would block (errno=EAGAIN)

[Thr 2828] NiIPeek: peek for hdl 44 timed out (r; 125ms)

[Thr 2828] NiIRead: raw read for hdl 44 timed out (125ms)

[Thr 2828] IcmReadFromConn: read failed with timeout: 125 -> roll out

[Thr 2828] NiWakeupExec: send wakeup signal to 64994 (sock 17)

[Thr 2828] IcmConnRollOut: connection (id=2/39991) rolled out:

[Thr 2828] CONNECTION (id=2/39991):

used: 1, type: 1, role: 1, stateful: 0

NI_HDL: 44, protocol: SMTP(4)

local host: 170.56.225.77:25492 ()

remote host: 170.56.149.133:1129 ()

status: READ_REQUEST

connect time: 01.07.2007 11:40:06

MPI request: <a653> MPI response: <a654>

request_buf_size: 65464 response_buf_size: 0

request_buf_used: 0 response_buf_used: 0

request_buf_offset: 0 response_buf_offset: 0

[Thr 2828] IcmWorkerThread: Thread 8: Waiting for event

[Thr 3342] SiSelPNext: sock 16 selected (pos=0; revt=r--)

[Thr 3342] NiSelIListInsert: add hdl 3 [0] to sel-list (0) of set1

[Thr 3342] NiSelISelectInt: 1 handles selected (0 buffered)

[Thr 3342] NiIPeek: peek successful for hdl 3 (r)

[Thr 3342] NiIWakeupReceive: hdl 3 received 1 bytes from 127.0.0.1:41437

[Thr 3342] NiIPeek: peek for hdl 3 timed out (r; 0ms)

[Thr 3342] IcmWatchDogUpdateRollQueue(id=2/39991): insert fe-nihdl 44, flags=1

[Thr 3342] SiSelPSet: sock 63 added to set pos 1

[Thr 3342] NiSelIAddMsg: added hdl 44 to set1

[Thr 3342] SiSelPSet: set events of sock 63 to: rp-

[Thr 3342] IcmWatchDogThread: check ni handles (timeout=10000)

[Thr 3342] SiSelPSelect: start select (timeout=10000)

[Thr 515] Sun Jul 1 11:41:41 2007

[Thr 515] SiSelPSelect: of 1 sockets 0 selected

[Thr 515] IcmProxyWatchDog: check sockets (timeout=10000)

[Thr 515] SiSelPSelect: start select (timeout=10000)

[Thr 3342] Sun Jul 1 11:41:44 2007

[Thr 3342] SiSelPNext: sock 63 selected (pos=1; revt=r--)

[Thr 3342] NiSelIListInsert: add hdl 44 [1] to sel-list (0) of set1

[Thr 3342] NiSelISelectInt: 1 handles selected (0 buffered)

[Thr 3342] IcmWatchDogThread(id=2/39991): nihdl 44 - data received(read)

[Thr 3342] SiSelPClear: set events of sock 63 to: ---

[Thr 3342] NiSelIListRemove: remove hdl 44 [1] from sel-list (1) of set1

[Thr 3342] SiSelPRemove: removed last sock 63 (pos=1)

[Thr 3342] NiSelIRemove: removed hdl 44

[Thr 3342] IcmQueueAppend: queuelen: 1

[Thr 3342] IcmCreateRequest: Appended request 42728

[Thr 3342] IcmConnRollIn: connection (id=2/39991) rolled back to status: READ_REQUEST

[Thr 1029] IcmWorkerThread: worker 1 got the semaphore

[Thr 3342] IcmWatchDogThread: check ni handles (timeout=10000)

[Thr 3342] SiSelPSelect: start select (timeout=10000)

[Thr 1029] REQUEST:

Type: READ_REQUEST Index = 42727

[Thr 1029] CONNECTION (id=2/39991):

used: 1, type: 1, role: 1, stateful: 0

NI_HDL: 44, protocol: SMTP(4)

local host: 170.56.225.77:25492 ()

remote host: 170.56.149.133:1129 ()

status: READ_REQUEST

connect time: 01.07.2007 11:40:06

MPI request: <a653> MPI response: <a654>

request_buf_size: 65464 response_buf_size: 0

request_buf_used: 0 response_buf_used: 0

request_buf_offset: 0 response_buf_offset: 0

[Thr 1029] NiIRead: hdl 44 received data (rcd=14,pac=1,RAW_IO)

[Thr 1029] IcmReadFromConn(id=2/39991): read 14 bytes(timeout 500)

[Thr 1029] Address Offset IcmReadFromConn received

[Thr 1029] -

[Thr 1029] 700000000c214e8 000000 54657374 205a6569 6c652031 0d0a |Test Zeile 1.. |

[Thr 1029] -

[Thr 1029] SMTP PlugInHandleNetData entry

[Thr 1029] SMTP PlugInHandleNetData: reply = Test Zeile 1

[Thr 1029] SMTP SmtpActivity: state = -7, reply = 0

[Thr 1029] SMTP SmtpServerRecvMessage: message data received

[Thr 1029] MPI<a653>5#19 DiscardOutbuf l5 0 0 198480 0 0 -> 700000000c21480 0

[Thr 1029] IcmPlCheckRetVal: Next status: READ_REQUEST(1)

[Thr 1029] IcmHandleNetRead(id=2/39991): read_len: 14, HandleNetData returned: 1

[Thr 1029] IcmHandleNetRead(id=2/39991): status 1 -> 1

[Thr 1029] IcmReadFromConn(id=2/39991): request new MPI (0/0)

[Thr 1029] MPI<a653>5#20 GetOutbuf -1 198480 65536 (0) -> 700000000c214a0 0

[Thr 1029] NiIRead: hdl 44 recv would block (errno=EAGAIN)

[Thr 1029] NiIPeek: peek for hdl 44 timed out (r; 250ms)

[Thr 1029] NiIRead: raw read for hdl 44 timed out (250ms)

[Thr 1029] IcmReadFromConn: read failed with timeout: 250 -> roll out

[Thr 1029] NiWakeupExec: send wakeup signal to 64994 (sock 17)

[Thr 1029] IcmConnRollOut: connection (id=2/39991) rolled out:

[Thr 1029] CONNECTION (id=2/39991):

used: 1, type: 1, role: 1, stateful: 0

NI_HDL: 44, protocol: SMTP(4)

local host: 170.56.225.77:25492 ()

remote host: 170.56.149.133:1129 ()

status: READ_REQUEST

connect time: 01.07.2007 11:40:06

MPI request: <a653> MPI response: <a654>

request_buf_size: 65464 response_buf_size: 0

request_buf_used: 0 response_buf_used: 0

request_buf_offset: 0 response_buf_offset: 0

[Thr 1029] IcmWorkerThread: Thread 1: Waiting for event

[Thr 3342] SiSelPNext: sock 16 selected (pos=0; revt=r--)

[Thr 3342] NiSelIListInsert: add hdl 3 [0] to sel-list (0) of set1

[Thr 3342] NiSelISelectInt: 1 handles selected (0 buffered)

[Thr 3342] NiIPeek: peek successful for hdl 3 (r)

[Thr 3342] NiIWakeupReceive: hdl 3 received 1 bytes from 127.0.0.1:41437

[Thr 3342] NiIPeek: peek for hdl 3 timed out (r; 0ms)

[Thr 3342] IcmWatchDogUpdateRollQueue(id=2/39991): insert fe-nihdl 44, flags=1

[Thr 3342] SiSelPSet: sock 63 added to set pos 1

[Thr 3342] NiSelIAddMsg: added hdl 44 to set1

[Thr 3342] SiSelPSet: set events of sock 63 to: rp-

[Thr 3342] IcmWatchDogThread: check ni handles (timeout=10000)

[Thr 3342] SiSelPSelect: start select (timeout=10000)

[Thr 3342] Sun Jul 1 11:41:48 2007

[Thr 3342] SiSelPNext: sock 63 selected (pos=1; revt=r--)

[Thr 3342] NiSelIListInsert: add hdl 44 [1] to sel-list (0) of set1

[Thr 3342] NiSelISelectInt: 1 handles selected (0 buffered)

[Thr 3342] IcmWatchDogThread(id=2/39991): nihdl 44 - data received(read)

[Thr 3342] SiSelPClear: set events of sock 63 to: ---

[Thr 3342] NiSelIListRemove: remove hdl 44 [1] from sel-list (1) of set1

[Thr 3342] SiSelPRemove: removed last sock 63 (pos=1)

[Thr 3342] NiSelIRemove: removed hdl 44

[Thr 3342] IcmQueueAppend: queuelen: 1

[Thr 3342] IcmCreateRequest: Appended request 42729

[Thr 3342] IcmConnRollIn: connection (id=2/39991) rolled back to status: READ_REQUEST

[Thr 3342] IcmWatchDogThread: check ni handles (timeout=10000)

[Thr 3342] SiSelPSelect: start select (timeout=10000)

[Thr 772] IcmWorkerThread: worker 0 got the semaphore

[Thr 772] REQUEST:

Type: READ_REQUEST Index = 42728

[Thr 772] CONNECTION (id=2/39991):

used: 1, type: 1, role: 1, stateful: 0

NI_HDL: 44, protocol: SMTP(4)

local host: 170.56.225.77:25492 ()

remote host: 170.56.149.133:1129 ()

status: READ_REQUEST

connect time: 01.07.2007 11:40:06

MPI request: <a653> MPI response: <a654>

request_buf_size: 65464 response_buf_size: 0

request_buf_used: 0 response_buf_used: 0

request_buf_offset: 0 response_buf_offset: 0

[Thr 772] NiIRead: hdl 44 received data (rcd=12,pac=1,RAW_IO)

[Thr 772] IcmReadFromConn(id=2/39991): read 12 bytes(timeout 500)

[Thr 772] Address Offset IcmReadFromConn received

[Thr 772] -

[Thr 772] 700000000c214e8 000000 54657374 205a6569 6c652032 |Test Zeile 2 |

[Thr 772] -

[Thr 772] SMTP PlugInHandleNetData entry

[Thr 772] MPI<a653>5#21 DiscardOutbuf l5 0 0 198480 0 0 -> 700000000c21480 0

[Thr 772] IcmPlCheckRetVal: Next status: READ_REQUEST(1)

[Thr 772] IcmHandleNetRead(id=2/39991): read_len: 12, HandleNetData returned: 1

[Thr 772] IcmHandleNetRead(id=2/39991): status 1 -> 1

[Thr 772] IcmReadFromConn(id=2/39991): request new MPI (0/0)

[Thr 772] MPI<a653>5#22 GetOutbuf -1 198480 65536 (0) -> 700000000c214a0 0

[Thr 772] NiIRead: hdl 44 received data (rcd=2,pac=1,RAW_IO)

[Thr 772] IcmReadFromConn(id=2/39991): read 2 bytes(timeout 250)

[Thr 772] Address Offset IcmReadFromConn received

[Thr 772] -

[Thr 772] 700000000c214e8 000000 0d0a |.. |

[Thr 772] -

[Thr 772] SMTP PlugInHandleNetData entry

[Thr 772] SMTP PlugInHandleNetData: reply = Test Zeile 2

[Thr 772] SMTP SmtpActivity: state = -7, reply = 0

[Thr 772] SMTP SmtpServerRecvMessage: message data received

[Thr 772] MPI<a653>5#23 DiscardOutbuf l5 0 0 198480 0 0 -> 700000000c21480 0

[Thr 772] IcmPlCheckRetVal: Next status: READ_REQUEST(1)

[Thr 772] IcmHandleNetRead(id=2/39991): read_len: 2, HandleNetData returned: 1

[Thr 772] IcmHandleNetRead(id=2/39991): status 1 -> 1

[Thr 772] IcmReadFromConn(id=2/39991): request new MPI (0/0)

[Thr 772] MPI<a653>5#24 GetOutbuf -1 198480 65536 (0) -> 700000000c214a0 0

[Thr 772] NiIRead: hdl 44 recv would block (errno=EAGAIN)

[Thr 772] NiIPeek: peek for hdl 44 timed out (r; 125ms)

[Thr 772] NiIRead: raw read for hdl 44 timed out (125ms)

[Thr 772] IcmReadFromConn: read failed with timeout: 125 -> roll out

[Thr 772] NiWakeupExec: send wakeup signal to 64994 (sock 17)

[Thr 772] IcmConnRollOut: connection (id=2/39991) rolled out:

[Thr 772] CONNECTION (id=2/39991):

used: 1, type: 1, role: 1, stateful: 0

NI_HDL: 44, protocol: SMTP(4)

local host: 170.56.225.77:25492 ()

remote host: 170.56.149.133:1129 ()

status: READ_REQUEST

connect time: 01.07.2007 11:40:06

MPI request: <a653> MPI response: <a654>

request_buf_size: 65464 response_buf_size: 0

request_buf_used: 0 response_buf_used: 0

request_buf_offset: 0 response_buf_offset: 0

[Thr 772] IcmWorkerThread: Thread 0: Waiting for event

[Thr 3342] SiSelPNext: sock 16 selected (pos=0; revt=r--)

[Thr 3342] NiSelIListInsert: add hdl 3 [0] to sel-list (0) of set1

[Thr 3342] NiSelISelectInt: 1 handles selected (0 buffered)

[Thr 3342] NiIPeek: peek successful for hdl 3 (r)

[Thr 3342] NiIWakeupReceive: hdl 3 received 1 bytes from 127.0.0.1:41437

[Thr 3342] NiIPeek: peek for hdl 3 timed out (r; 0ms)

[Thr 3342] IcmWatchDogUpdateRollQueue(id=2/39991): insert fe-nihdl 44, flags=1

[Thr 3342] SiSelPSet: sock 63 added to set pos 1

[Thr 3342] NiSelIAddMsg: added hdl 44 to set1

[Thr 3342] SiSelPSet: set events of sock 63 to: rp-

[Thr 3342] IcmWatchDogThread: check ni handles (timeout=10000)

[Thr 3342] SiSelPSelect: start select (timeout=10000)

[Thr 515] Sun Jul 1 11:41:51 2007

[Thr 515] SiSelPSelect: of 1 sockets 0 selected

[Thr 515] IcmProxyWatchDog: check sockets (timeout=10000)

[Thr 515] SiSelPSelect: start select (timeout=10000)

[Thr 3342] SiSelPNext: sock 63 selected (pos=1; revt=r--)

[Thr 3342] NiSelIListInsert: add hdl 44 [1] to sel-list (0) of set1

[Thr 3342] NiSelISelectInt: 1 handles selected (0 buffered)

[Thr 3342] IcmWatchDogThread(id=2/39991): nihdl 44 - data received(read)

[Thr 3342] SiSelPClear: set events of sock 63 to: ---

[Thr 3342] NiSelIListRemove: remove hdl 44 [1] from sel-list (1) of set1

[Thr 3342] SiSelPRemove: removed last sock 63 (pos=1)

[Thr 3342] NiSelIRemove: removed hdl 44

[Thr 3342] IcmQueueAppend: queuelen: 1

[Thr 3342] IcmCreateRequest: Appended request 42730

[Thr 3342] IcmConnRollIn: connection (id=2/39991) rolled back to status: READ_REQUEST

[Thr 2314] IcmWorkerThread: worker 6 got the semaphore

[Thr 2314] REQUEST:

Type: READ_REQUEST Index = 42729

[Thr 2314] CONNECTION (id=2/39991):

used: 1, type: 1, role: 1, stateful: 0

NI_HDL: 44, protocol: SMTP(4)

local host: 170.56.225.77:25492 ()

remote host: 170.56.149.133:1129 ()

status: READ_REQUEST

connect time: 01.07.2007 11:40:06

MPI request: <a653> MPI response: <a654>

request_buf_size: 65464 response_buf_size: 0

request_buf_used: 0 response_buf_used: 0

request_buf_offset: 0 response_buf_offset: 0

[Thr 3342] IcmWatchDogThread: check ni handles (timeout=10000)

[Thr 3342] SiSelPSelect: start select (timeout=10000)

[Thr 2314] NiIRead: hdl 44 received data (rcd=1,pac=1,RAW_IO)

[Thr 2314] IcmReadFromConn(id=2/39991): read 1 bytes(timeout 500)

[Thr 2314] Address Offset IcmReadFromConn received

[Thr 2314] -

[Thr 2314] 700000000c214e8 000000 2e |. |

[Thr 2314] -

[Thr 2314] SMTP PlugInHandleNetData entry

[Thr 2314] MPI<a653>5#25 DiscardOutbuf l5 0 0 198480 0 0 -> 700000000c21480 0

[Thr 2314] IcmPlCheckRetVal: Next status: READ_REQUEST(1)

[Thr 2314] IcmHandleNetRead(id=2/39991): read_len: 1, HandleNetData returned: 1

[Thr 2314] IcmHandleNetRead(id=2/39991): status 1 -> 1

[Thr 2314] IcmReadFromConn(id=2/39991): request new MPI (0/0)

[Thr 2314] MPI<a653>5#26 GetOutbuf -1 198480 65536 (0) -> 700000000c214a0 0

[Thr 2314] NiIRead: hdl 44 received data (rcd=2,pac=1,RAW_IO)

[Thr 2314] IcmReadFromConn(id=2/39991): read 2 bytes(timeout 250)

[Thr 2314] Address Offset IcmReadFromConn received

[Thr 2314] -

[Thr 2314] 700000000c214e8 000000 0d0a |.. |

[Thr 2314] -

[Thr 2314] SMTP PlugInHandleNetData entry

[Thr 2314] SMTP PlugInHandleNetData: reply = .

[Thr 2314] SMTP SmtpActivity: state = -7, reply = 0

[Thr 2314] SMTP SmtpServerRecvMessage: message data received

[Thr 2314] IcmFlushBuf: Flushing 111 Bytes, buf_status: 6

[Thr 2314] flush buffer with mpi buffer id 0

[Thr 2314] MPI<a653>5#27 FlushOutbuf l0 1 0 148368 183 6 -> 700000000bd1368 0

[Thr 2314] IcmCreateDpRequest: Send request to AppServer

[Thr 2314] DpCheckContextUsage: check for plugin 4: 2000/90 against 0 used

[Thr 2314] -OUT- sender_id IC_MAN tid -1 wp_ca_blk -1 wp_id -1

[Thr 2314] -OUT- action SEND_TO_WP uid -1 appc_ca_blk -1 type DIA

[Thr 2314] -OUT- new_stat NO_CHANGE mode 0 len -1 rq_id 49085

[Thr 2314] -OUT- req_info LOGIN DP_ICM_EVENT

[Thr 2314] -OUT- mpi rq <a653> mpi resp <a654> prot 4 obj fd -1 rq_id 0

[Thr 2314] -OUT- icm_opcode: ICM_PLUGIN_REQUEST

[Thr 2314] DpRqPutIntoQueue: put request into queue (reqtype 1, prio LOW, rq_id 49085)

[Thr 2314] IcmConnRollInWP: rolled in WP -old roll reason was: 0

[Thr 2314] MPI<a653>5#28 DiscardOutbuf l5 0 0 198480 0 0 -> 700000000c21480 0

[Thr 2314] IcmPlCheckRetVal: Next status: WRITE_RESPONSE(4)

[Thr 2314] IcmHandleNetRead(id=2/39991): read_len: 2, HandleNetData returned: 4

[Thr 2314] IcmHandleNetRead(id=2/39991): status 1 -> 4

[Thr 2314] IcmReadFromPartner(id=2/39991): read with maximum timeout 500

[Thr 2314] IcmConnRollInWP: no need to roll in WP status: ROLLED IN

[Thr 2314] MPI<a654>4#4 GetInbuf 0 0 0 (0) -> 12

[Thr 2314] DpIsContextValid: context invalid: -1/65535/0

[Thr 2314] MPI<a654>4#5 ReadOOB 00000000 00000006 00000021 00 -> 0

[Thr 2314] IcmHandleOOBData: Received data on 1st MPI (seqno: 0, type=6, reason=0): 33/23359/0

[Thr 2314] IcmHandleOOBData: request will be processed in wp0

[Thr 2314] IcmConnRollInWP: no need to roll in WP status: ROLLED IN

[Thr 2314] MPI<a654>4#6: GetInbuf: check avail. buffers 0 0

[Thr 2314] MPI<a654>4#6 GetInbuf 0 0 0 (0) -> 10

[Thr 2314] DpDebuggingActive: check T33/M0

[Thr 2314] NiIHdlGetStatus: hdl 44 / sock 63 ok, no data pending

[Thr 2314] IcmReadFromPartner(id=2/39991): fe-nihdl timeout

[Thr 2314] IcmReadFromPartner: No data from server available(5)

[Thr 2314] MPI<a654>4#11 GetInbuf 0 0 0 (0) -> 12

[Thr 2314] DpDebuggingActive: check T33/M0

[Thr 2314] NiIHdlGetStatus: hdl 44 / sock 63 ok, no data pending

[Thr 2314] IcmReadFromPartner(id=2/39991): fe-nihdl timeout

[Thr 2314] MPI<a654>4#12 ReadOOB 00000001 00000001 00000021 00 -> 0

[Thr 2314] IcmHandleOOBData: Received data on 1st MPI (seqno: 1, type=1, reason=4): 33/23359/0

[Thr 2314] MPI<a653>5#32 ReadOOB 00000001 00000001 00000021 00 -> 0

[Thr 2314] IcmHandleOOBData: Received data on 2nd MPI (seqno: 1, type=1, reason=4): 33/23359/0

[Thr 2314] IcmHandleOOBData: Received context key (type=1, reason=4): 33/23359/0

[Thr 2314] MPI<a654>4#13 GetInbuf 0 148368 139 (1) -> 6

[Thr 2314] DpIsContextValid: context invalid: -1/65535/0

[Thr 2314] Address Offset IcmReadFromPartner received

[Thr 2314] -

[Thr 2314] 700000000bd13d0 000000 51004f3c 6461676f 62657274 4068662d |Q.O<dagobert@hf-|

[Thr 2314] 700000000bd13e0 000016 67726f75 702e636f 6d3e0052 3c726569 |group.com>.R<rei|

[Thr 2314] 700000000bd13f0 000032 6e686f6c 642e6d75 656c6c65 72407035 |nhold.mueller@p5|

[Thr 2314] 700000000bd1400 000048 30302e68 662d6772 6f75702e 636f6d3e |00.hf-group.com>|

[Thr 2314] 700000000bd1410 000064 005873 |.Xs |

[Thr 2314] -

[Thr 2314] SMTP PlugInHandleServData entry

[Thr 2314] SMTP PlugInHandleServData: buffer read o.k., status = 6

[Thr 2314] SMTP SmtpActivity: state = -8, reply = -1

[Thr 2314] SMTP SmtpServerAcknowledge: mail processed by app server

[Thr 2314] MPI<a654>4#14 FreeInbuf#1 0 148368 0 -> 0

[Thr 2314] SMTP SmtpServerAcknowledge: send '554 Transaction failed'

[Thr 2314] IcmNetBufWrapBuf: allocated netbuf: 110465e00, blocks used: 1

[Thr 2314] IcmNetBufWrapBuf: allocated netbuf: 110465e00

[Thr 2314] SMTP SmtpServerInit: flush buffers

[Thr 2314] IcmPlCheckRetVal: Next status: READ_REQUEST(1)

[Thr 2314] IcmHandleNetWrite(id=2/39991): HandleServData returned: 1

[Thr 2314] Address Offset IcmWriteToConn:

[Thr 2314] -

[Thr 2314] 11029b630 000000 35353420 5472616e 73616374 696f6e20 |554 Transaction |

[Thr 2314] 11029b640 000016 6661696c 65640d0a |failed.. |

[Thr 2314] -

[Thr 2314] IcmWriteToConn(id=2/39991): prepared to write data to partner (len = 24)

[Thr 2314] NiIWrite: hdl 44 sent data (wrt=24,pac=1,RAW_IO)

[Thr 2314] IcmWriteToConn: NiWrite (24 bytes, timeout = 2000) wrote 24,rc=0

[Thr 2314] IcmWriteToConn: net_buf_len=24

[Thr 2314] IcmWriteToConn(id=2/39991): wrote data to partner (len = 24)

[Thr 2314] IcmNetBufFree: free netbuf: 110465e00 out of 1 used

[Thr 2314] REQUEST:

Type: READ_REQUEST Index = 42729

[Thr 2314] CONNECTION (id=2/39991):

used: 1, type: 1, role: 1, stateful: 0

NI_HDL: 44, protocol: SMTP(4)

local host: 170.56.225.77:25492 ()

remote host: 170.56.149.133:1129 ()

status: READ_REQUEST

connect time: 01.07.2007 11:40:06

WP-status: INIT (Context: 1, Role: 1)

tid: -1, mode: 0, uid: 65535, roll-reason: ICM_ROLL_APPL_REL_CONTEXT

MPI request: <a653> MPI response: <a654>

request_buf_size: 0 response_buf_size: 0

request_buf_used: 0 response_buf_used: 0

request_buf_offset: 0 response_buf_offset: 0

[Thr 2314] IcmReadFromConn(id=2/39991): request new MPI (0/0)

[Thr 2314] MPI<a653>5#33 GetOutbuf -1 148368 65536 (0) -> 700000000bd1388 0

[Thr 2314] NiIRead: hdl 44 recv would block (errno=EAGAIN)

[Thr 2314] NiIRead: raw read for hdl 44 timed out (0ms)

[Thr 2314] IcmReadFromConn: read failed with timeout: 0 -> roll out

[Thr 2314] IcmConnRollOutWP: Context is in status INIT

[Thr 2314] NiWakeupExec: send wakeup signal to 64994 (sock 17)

[Thr 2314] IcmConnRollOut: connection (id=2/39991) rolled out:

[Thr 2314] CONNECTION (id=2/39991):

used: 1, type: 1, role: 1, stateful: 0

NI_HDL: 44, protocol: SMTP(4)

local host: 170.56.225.77:25492 ()

remote host: 170.56.149.133:1129 ()

status: READ_REQUEST

connect time: 01.07.2007 11:40:06

WP-status: INIT (Context: 1, Role: 1)

tid: -1, mode: 0, uid: 65535, roll-reason: ICM_ROLL_APPL_REL_CONTEXT

MPI request: <a653> MPI response: <a654>

request_buf_size: 65464 response_buf_size: 0

request_buf_used: 0 response_buf_used: 0

request_buf_offset: 0 response_buf_offset: 0

[Thr 2314] IcmWorkerThread: Thread 6: Waiting for event

[Thr 3342] SiSelPNext: sock 16 selected (pos=0; revt=r--)

[Thr 3342] NiSelIListInsert: add hdl 3 [0] to sel-list (0) of set1

[Thr 3342] NiSelISelectInt: 1 handles selected (0 buffered)

[Thr 3342] NiIPeek: peek successful for hdl 3 (r)

[Thr 3342] NiIWakeupReceive: hdl 3 received 1 bytes from 127.0.0.1:41437

[Thr 3342] NiIPeek: peek for hdl 3 timed out (r; 0ms)

[Thr 3342] IcmWatchDogUpdateRollQueue(id=2/39991): insert fe-nihdl 44, flags=1

[Thr 3342] SiSelPSet: sock 63 added to set pos 1

[Thr 3342] NiSelIAddMsg: added hdl 44 to set1

[Thr 3342] SiSelPSet: set events of sock 63 to: rp-

[Thr 3342] IcmWatchDogThread: check ni handles (timeout=10000)

[Thr 3342] SiSelPSelect: start select (timeout=10000)

[Thr 3342] Sun Jul 1 11:41:57 2007

[Thr 3342] SiSelPNext: sock 63 selected (pos=1; revt=r--)

[Thr 3342] NiSelIListInsert: add hdl 44 [1] to sel-list (0) of set1

[Thr 3342] NiSelISelectInt: 1 handles selected (0 buffered)

[Thr 3342] IcmWatchDogThread(id=2/39991): nihdl 44 - data received(read)

[Thr 3342] SiSelPClear: set events of sock 63 to: ---

[Thr 3342] NiSelIListRemove: remove hdl 44 [1] from sel-list (1) of set1

[Thr 3342] SiSelPRemove: removed last sock 63 (pos=1)

[Thr 3342] NiSelIRemove: removed hdl 44

[Thr 3342] IcmQueueAppend: queuelen: 1

[Thr 3342] IcmCreateRequest: Appended request 42731

[Thr 3342] IcmConnRollIn: connection (id=2/39991) rolled back to status: READ_REQUEST

[Thr 1800] IcmWorkerThread: worker 4 got the semaphore

[Thr 1800] REQUEST:

Type: READ_REQUEST Index = 42730

[Thr 1800] CONNECTION (id=2/39991):

used: 1, type: 1, role: 1, stateful: 0

NI_HDL: 44, protocol: SMTP(4)

local host: 170.56.225.77:25492 ()

remote host: 170.56.149.133:1129 ()

status: READ_REQUEST

connect time: 01.07.2007 11:40:06

WP-status: INIT (Context: 1, Role: 1)

tid: -1, mode: 0, uid: 65535, roll-reason: ICM_ROLL_APPL_REL_CONTEXT

MPI request: <a653> MPI response: <a654>

request_buf_size: 65464 response_buf_size: 0

request_buf_used: 0 response_buf_used: 0

request_buf_offset: 0 response_buf_offset: 0

[Thr 3342] IcmQueueAppend: queuelen: 0

[Thr 3342] IcmCreateRequest: Appended request 42732

[Thr 3342] IcmCheckForBlockedThreads: check for blocked SSL-threads

[Thr 3342] IcmWatchDogThread: check ni handles (timeout=10000)

[Thr 3342] SiSelPSelect: start select (timeout=10000)

[Thr 1286] IcmWorkerThread: worker 2 got the semaphore

[Thr 1286] REQUEST:

Type: SCHEDULER Index = 42731

[Thr 1286] IcmGetSchedule: found slot 0

[Thr 1286] IcmAlReportData: Reporting data to CCMS Alerting Infrastructure

[Thr 1800] NiIRead: hdl 44 received data (rcd=3,pac=1,RAW_IO)

[Thr 1800] IcmReadFromConn(id=2/39991): read 3 bytes(timeout 500)

[Thr 1800] Address Offset IcmReadFromConn received

[Thr 1800] -

[Thr 1800] 700000000bd13d0 000000 627965 |bye |

[Thr 1800] -

[Thr 1800] SMTP PlugInHandleNetData entry

[Thr 1800] MPI<a653>5#34 DiscardOutbuf l0 0 0 148368 0 0 -> 700000000bd1368 0

[Thr 1800] IcmPlCheckRetVal: Next status: READ_REQUEST(1)

[Thr 1800] IcmHandleNetRead(id=2/39991): read_len: 3, HandleNetData returned: 1

[Thr 1800] IcmHandleNetRead(id=2/39991): status 1 -> 1

[Thr 1800] IcmReadFromConn(id=2/39991): request new MPI (0/0)

[Thr 1800] MPI<a653>5#35 GetOutbuf -1 148368 65536 (0) -> 700000000bd1388 0

[Thr 1800] NiIRead: hdl 44 recv would block (errno=EAGAIN)

[Thr 1286] NiIGetServNo: servicename '8056' = port 1F.78/8056

[Thr 1286] IcmConnCheckStoredClientConn: check for client conn timeout

[Thr 1286] IcmConnCheckStoredClientConn: next client timeout check in 60 sec

[Thr 1800] NiIPeek: peek successful for hdl 44 (r)

[Thr 1800] NiIRead: hdl 44 received data (rcd=2,pac=1,RAW_IO)

[Thr 1800] IcmReadFromConn(id=2/39991): read 2 bytes(timeout 250)

[Thr 1800] Address Offset IcmReadFromConn received

[Thr 1800] -

[Thr 1800] 700000000bd13d0 000000 0d0a |.. |

[Thr 1800] -

[Thr 1800] SMTP PlugInHandleNetData entry

[Thr 1800] SMTP PlugInHandleNetData: reply = bye

[Thr 1800] SMTP SmtpActivity: state = -3, reply = 0

[Thr 1800] SMTP SmtpServerUnknown: command not recognized, send 500

[Thr 1800] SMTP SmtpServerUnknown: send '500 Command unrecognized'

[Thr 1286] NiIGetServNo: servicename '8056' = port 1F.78/8056

[Thr 1286] IcmGetServicePtr: new serv_ref_count: 2

[Thr 1286] PlugInHandleAdmMessage: request received:

[Thr 1286] PlugInHandleAdmMessage: opcode: 136, len: 272, dest_type: 2, subhdlkey: 262145

[Thr 1286] HttpSubHandlerCall: Call Handler: HttpCacheHandler, task=4, header_len=0

[Thr 1286] HttpCacheHandler: 4 0 110272160 0

[Thr 1286] SCACHE: adm request received:

[Thr 1286] SCACHE: opcode: 136, len: 272, dest_type: 2, dest:

[Thr 1286] MTX_LOCK 3038 110d1e050

[Thr 1286] MTX_UNLOCK 3051 110d1e050

[Thr 1286] IctCmGetCacheInfo#18876 -> 0

[Thr 1800] IcmNetBufWrapBuf: allocated netbuf: 110465e00, blocks used: 2

[Thr 1800] IcmNetBufWrapBuf: allocated netbuf: 110465e00

[Thr 1800] MPI<a653>5#36 DiscardOutbuf l0 0 0 148368 0 0 -> 700000000bd1368 0

[Thr 1800] IcmPlCheckRetVal: Next status: READ_REQUEST(1)

[Thr 1800] IcmHandleNetRead(id=2/39991): read_len: 2, HandleNetData returned: 1

[Thr 1800] Address Offset IcmWriteToConn:

[Thr 1800] -

[Thr 1800] 11029b630 000000 35303020 436f6d6d 616e6420 756e7265 |500 Command unre|

[Thr 1800] 11029b640 000016 636f676e 697a6564 0d0a |cognized.. |

[Thr 1800] -

[Thr 1800] IcmWriteToConn(id=2/39991): prepared to write data to partner (len = 26)

[Thr 1286] IcmNetBufWrapBuf: allocated netbuf: 110465e80, blocks used: 2

[Thr 1286] IcmNetBufWrapBuf: allocated netbuf: 110465e80

[Thr 1800] NiIWrite: hdl 44 sent data (wrt=26,pac=1,RAW_IO)

[Thr 1800] IcmWriteToConn: NiWrite (26 bytes, timeout = -1) wrote 26,rc=0

[Thr 1800] IcmWriteToConn: net_buf_len=26

[Thr 1800] IcmWriteToConn(id=2/39991): wrote data to partner (len = 26)

[Thr 1800] IcmNetBufFree: free netbuf: 110465e00 out of 2 used

[Thr 1800] IcmHandleNetRead(id=2/39991): status 1 -> 1

[Thr 1800] IcmReadFromConn(id=2/39991): request new MPI (0/0)

[Thr 1800] MPI<a653>5#37 GetOutbuf -1 148368 65536 (0) -> 700000000bd1388 0

[Thr 1800] NiIRead: hdl 44 recv would block (errno=EAGAIN)

[Thr 1800] NiIRead: raw read for hdl 44 timed out (0ms)

[Thr 1800] IcmReadFromConn: read failed with timeout: 0 -> roll out

[Thr 1800] IcmConnRollOutWP: Context is in status INIT

[Thr 1800] NiWakeupExec: send wakeup signal to 64994 (sock 17)

[Thr 1286] IcmNetBufFree: free netbuf: 110465e80 out of 1 used

[Thr 1286] IcmConnFreeContext: context 2 released

[Thr 1286] IcmServDecrRefCount: k1b06cus.khis.krupp.com:8056 - serv_ref_count: 1

[Thr 1286] IcmGetSchedule: next schedule in 30 secs

[Thr 1286] IcmWorkerThread: Thread 2: Waiting for event

[Thr 3342] SiSelPNext: sock 16 selected (pos=0; revt=r--)

[Thr 3342] NiSelIListInsert: add hdl 3 [0] to sel-list (0) of set1

[Thr 3342] NiSelISelectInt: 1 handles selected (0 buffered)

[Thr 1800] IcmConnRollOut: connection (id=2/39991) rolled out:

[Thr 1800] CONNECTION (id=2/39991):

used: 1, type: 1, role: 1, stateful: 0

NI_HDL: 44, protocol: SMTP(4)

local host: 170.56.225.77:25492 ()

remote host: 170.56.149.133:1129 ()

status: READ_REQUEST

connect time: 01.07.2007 11:40:06

WP-status: INIT (Context: 1, Role: 1)

tid: -1, mode: 0, uid: 65535, roll-reason: ICM_ROLL_APPL_REL_CONTEXT

MPI request: <a653> MPI response: <a654>

request_buf_size: 65464 response_buf_size: 0

request_buf_used: 0 response_buf_used: 0

request_buf_offset: 0 response_buf_offset: 0

[Thr 1800] IcmWorkerThread: Thread 4: Waiting for event

[Thr 3342] NiIPeek: peek successful for hdl 3 (r)

[Thr 3342] NiIWakeupReceive: hdl 3 received 1 bytes from 127.0.0.1:41437

[Thr 3342] NiIPeek: peek for hdl 3 timed out (r; 0ms)

[Thr 3342] IcmWatchDogUpdateRollQueue(id=2/39991): insert fe-nihdl 44, flags=1

[Thr 3342] SiSelPSet: sock 63 added to set pos 1

[Thr 3342] NiSelIAddMsg: added hdl 44 to set1

[Thr 3342] SiSelPSet: set events of sock 63 to: rp-

[Thr 3342] IcmWatchDogThread: check ni handles (timeout=10000)

[Thr 3342] SiSelPSelect: start select (timeout=10000)

[Thr 515] Sun Jul 1 11:42:01 2007

[Thr 515] SiSelPSelect: of 1 sockets 0 selected

[Thr 515] IcmProxyWatchDog: check sockets (timeout=10000)

[Thr 515] SiSelPSelect: start select (timeout=10000)

[Thr 3342] Sun Jul 1 11:42:05 2007

[Thr 3342] SiSelPNext: sock 63 selected (pos=1; revt=r--)

[Thr 3342] NiSelIListInsert: add hdl 44 [1] to sel-list (0) of set1

[Thr 3342] NiSelISelectInt: 1 handles selected (0 buffered)

[Thr 3342] IcmWatchDogThread(id=2/39991): nihdl 44 - data received(read)

[Thr 3342] SiSelPClear: set events of sock 63 to: ---

[Thr 3342] NiSelIListRemove: remove hdl 44 [1] from sel-list (1) of set1

[Thr 3342] SiSelPRemove: removed last sock 63 (pos=1)

[Thr 3342] NiSelIRemove: removed hdl 44

[Thr 3342] IcmQueueAppend: queuelen: 1

[Thr 3342] IcmCreateRequest: Appended request 42733

[Thr 3342] IcmConnRollIn: connection (id=2/39991) rolled back to status: READ_REQUEST

[Thr 3342] IcmWatchDogThread: check ni handles (timeout=10000)

[Thr 3342] SiSelPSelect: start select (timeout=10000)

[Thr 3085] IcmWorkerThread: worker 9 got the semaphore

[Thr 3085] REQUEST:

Type: READ_REQUEST Index = 42732

[Thr 3085] CONNECTION (id=2/39991):

used: 1, type: 1, role: 1, stateful: 0

NI_HDL: 44, protocol: SMTP(4)

local host: 170.56.225.77:25492 ()

remote host: 170.56.149.133:1129 ()

status: READ_REQUEST

connect time: 01.07.2007 11:40:06

WP-status: INIT (Context: 1, Role: 1)

tid: -1, mode: 0, uid: 65535, roll-reason: ICM_ROLL_APPL_REL_CONTEXT

MPI request: <a653> MPI response: <a654>

request_buf_size: 65464 response_buf_size: 0

request_buf_used: 0 response_buf_used: 0

request_buf_offset: 0 response_buf_offset: 0

[Thr 3085] NiIRead: hdl 44 received data (rcd=6,pac=1,RAW_IO)

[Thr 3085] IcmReadFromConn(id=2/39991): read 6 bytes(timeout 500)

[Thr 3085] Address Offset IcmReadFromConn received

[Thr 3085] -

[Thr 3085] 700000000bd13d0 000000 71756974 0d0a |quit.. |

[Thr 3085] -

[Thr 3085] SMTP PlugInHandleNetData entry

[Thr 3085] SMTP PlugInHandleNetData: reply = quit

[Thr 3085] SMTP SmtpActivity: state = -3, reply = 7

[Thr 3085] SMTP SmtpServerRecvQuit: close connection

[Thr 3085] SMTP SmtpServerRecvQuit: send '221 k1b06cus.khis.krupp.com Bye'

[Thr 3085] IcmNetBufWrapBuf: allocated netbuf: 110465e80, blocks used: 1

[Thr 3085] IcmNetBufWrapBuf: allocated netbuf: 110465e80

[Thr 3085] MPI<a653>5#38 DiscardOutbuf l0 0 0 148368 0 0 -> 700000000bd1368 0

[Thr 3085] IcmPlCheckRetVal: Plugin retval: PLUGIN_RET_CLOSE (702)

[Thr 3085] IcmHandleNetRead(id=2/39991): read_len: 6, HandleNetData returned: 702

[Thr 3085] Address Offset IcmWriteToConn:

[Thr 3085] -

[Thr 3085] 11029b630 000000 32323120 6b316230 36637573 2e6b6869 |221 k1b06cus.khi|

[Thr 3085] 11029b640 000016 732e6b72 7570702e 636f6d20 4279650d |s.krupp.com Bye.|

[Thr 3085] 11029b650 000032 0a |. |

[Thr 3085] -

[Thr 3085] IcmWriteToConn(id=2/39991): prepared to write data to partner (len = 33)

[Thr 3085] NiIWrite: hdl 44 sent data (wrt=33,pac=1,RAW_IO)

[Thr 3085] IcmWriteToConn: NiWrite (33 bytes, timeout = -1) wrote 33,rc=0

[Thr 3085] IcmWriteToConn: net_buf_len=33

[Thr 3085] IcmWriteToConn(id=2/39991): wrote data to partner (len = 33)

[Thr 3085] IcmNetBufFree: free netbuf: 110465e80 out of 1 used

[Thr 3085] SMTP PlugInStopConn: close connection

[Thr 3085] SMTP SmtpServerClose: connection closed

[Thr 3085] MPI<a653>5#39 Close( 5 ) del=0 -> 0

[Thr 3085] MPI<a653>5#41 Delete( 5 ) -> 0

[Thr 3085] MPI<a653>5#40 Close( 5 ) del=1 -> 0

[Thr 3085] MPI<a654>4#15 Close( 4 ) del=0 -> 0

[Thr 3085] MPI<a654>4#17 Delete( 4 ) -> 0

[Thr 3085] MPI<a654>4#16 Close( 4 ) del=1 -> 0

[Thr 3085] NiICloseHandle: shutdown and close hdl 44 / sock 63

[Thr 3085] IcmConnClose: Connection 2/39991 closed

[Thr 3085] IcmConnFreeContext: context 1 released

[Thr 3085] IcmServDecrRefCount: k1b06cus.khis.krupp.com:25492 - serv_ref_count: 1

[Thr 3085] IcmWorkerThread: Thread 9: Waiting for event

[Thr 515] Sun Jul 1 11:42:11 2007

[Thr 515] SiSelPSelect: of 1 sockets 0 selected

[Thr 515] IcmProxyWatchDog: check sockets (timeout=10000)

[Thr 515] SiSelPSelect: start select (timeout=10000)

[Thr 01] SiSelPNext: sock 54 selected (pos=34; revt=r--)

[Thr 01] NiBufISelProcess: hdl 34 process r-

[Thr 01] NiBufIAlloc: malloc NIBUF-IN, to 72 bytes

[Thr 01] NiIRead: hdl 34 received data (rcd=72,pac=1,MESG_IO)

[Thr 01] NiBufIIn: NIBUF len=72

[Thr 01] NiBufIIn: packet complete for hdl 34

[Thr 01] NiBufISelUpdate: new MODE -- (r-) for hdl 34 in set0

[Thr 01] SiSelPSet: set events of sock 54 to: ---

[Thr 01] NiBufISelUpdate: new STAT r-- (---) for hdl 34 in set0

[Thr 01] NiSelIListInsert: add hdl 34 [34] to buf-list (0) of set0

[Thr 01] NiSelISelectInt: 1 handles selected (1 buffered)

[Thr 01] IcmMsgProcess: Receive data from partner: WP(2), wp_no: 2

[Thr 01]

NiBufReceive starting

[Thr 01] NiBufISelUpdate: new MODE r- (--) for hdl 34 in set0

[Thr 01] SiSelPSet: set events of sock 54 to: rp-

[Thr 01] NiBufISelUpdate: new STAT ~~- (r~~) for hdl 34 in set0

[Thr 01] NiSelIListRemove: remove hdl 34 [34] from buf-list (1) of set0

[Thr 01] IcmRecMsg: received 72 bytes

[Thr 01] ============================================

[Thr 01] | COM_DATA:

[Thr 01] | Offset: 0 | Version: 7000

[Thr 01] | MsgNo: 675 | Opcode: ICM_COM_OP_ICM_MONITOR (66)

[Thr 01] ============================================

[Thr 01] IcmHandleAdmMsg: op: 66

[Thr 01] NiBufIAlloc: malloc NiBufadm, to 0 bytes

[Thr 01] NiBufDup: ref 1 for buf 11029b630

[Thr 01] IcmQueueAppend: queuelen: 1

[Thr 01] IcmCreateRequest: Appended request 42734

[Thr 01] NiBufIAlloc: malloc ICM_EXT, to 80 bytes

[Thr 01]

NiBufSend starting

[Thr 2057] IcmWorkerThread: worker 5 got the semaphore

[Thr 2057] REQUEST:

Type: ADMMSG Index = 42733

[Thr 2057] NiBufFree: ref 1 for buf 11029b630

[Thr 2057] MPI<a65a>5#5 GetInbuf -1 148368 440 (1) -> 6

[Thr 2057] IcmHandleMonitorMessage: called with opcode: 100

[Thr 2057] MPI<a659>4#4 GetOutbuf -1 198480 65536 (0) -> 700000000c214a0 0

[Thr 01] NiIWrite: hdl 34 sent data (wrt=80,pac=1,MESG_IO)

[Thr 2057] MPI<a65a>5#6 FreeInbuf#2 0 148368 0 -> 0

[Thr 01] SiSelPSelect: start select (timeout=-1)

[Thr 2057] MPI<a659>4#5 FlushOutbuf l-1 1 1 198480 1650 6 -> 700000000c21480 0

[Thr 2057] IcmWorkerThread: Thread 5: Waiting for event

[Thr 3342] Sun Jul 1 11:42:15 2007

[Thr 3342] NiSelISelectInt: 0 handles selected (0 buffered)

[Thr 3342] IcmWatchDogThread: check ni handles (timeout=10000)

[Thr 3342] SiSelPSelect: start select (timeout=10000)

[Thr 515] Sun Jul 1 11:42:21 2007

[Thr 515] SiSelPSelect: of 1 sockets 0 selected

[Thr 515] IcmProxyWatchDog: check sockets (timeout=10000)

[Thr 515] SiSelPSelect: start select (timeout=10000)

[Thr 3342] Sun Jul 1 11:42:25 2007

[Thr 3342] NiSelISelectInt: 0 handles selected (0 buffered)

[Thr 3342] IcmWatchDogThread: check ni handles (timeout=10000)

[Thr 3342] SiSelPSelect: start select (timeout=10000)

[Thr 515] Sun Jul 1 11:42:31 2007

[Thr 515] SiSelPSelect: of 1 sockets 0 selected

[Thr 515] IcmProxyWatchDog: check sockets (timeout=10000)

[Thr 515] SiSelPSelect: start select (timeout=10000)

[Thr 3342] Sun Jul 1 11:42:35 2007

[Thr 3342] NiSelISelectInt: 0 handles selected (0 buffered)

[Thr 3342] IcmQueueAppend: queuelen: 1

[Thr 3342] IcmCreateRequest: Appended request 42735

[Thr 3342] IcmCheckForBlockedThreads: check for blocked SSL-threads

[Thr 3342] IcmWatchDogThread: check ni handles (timeout=10000)

[Thr 3342] SiSelPSelect: start select (timeout=10000)

[Thr 1543] IcmWorkerThread: worker 3 got the semaphore

[Thr 1543] REQUEST:

Type: SCHEDULER Index = 42734

[Thr 1543] IcmGetSchedule: found slot 0

[Thr 1543] IcmAlReportData: Reporting data to CCMS Alerting Infrastructure

[Thr 1543] NiIGetServNo: servicename '8056' = port 1F.78/8056

[Thr 1543] IcmConnCheckStoredClientConn: next client timeout check in 22 sec

[Thr 1543] NiIGetServNo: servicename '8056' = port 1F.78/8056

[Thr 1543] IcmGetServicePtr: new serv_ref_count: 2

[Thr 1543] PlugInHandleAdmMessage: request received:

[Thr 1543] PlugInHandleAdmMessage: opcode: 136, len: 272, dest_type: 2, subhdlkey: 262145

[Thr 1543] HttpSubHandlerCall: Call Handler: HttpCacheHandler, task=4, header_len=0

[Thr 1543] HttpCacheHandler: 4 0 110272160 0

[Thr 1543] SCACHE: adm request received:

[Thr 1543] SCACHE: opcode: 136, len: 272, dest_type: 2, dest:

[Thr 1543] MTX_LOCK 3038 110d1e050

[Thr 1543] MTX_UNLOCK 3051 110d1e050

[Thr 1543] IctCmGetCacheInfo#18877 -> 0

[Thr 1543] IcmNetBufWrapBuf: allocated netbuf: 110465e80, blocks used: 1

[Thr 1543] IcmNetBufWrapBuf: allocated netbuf: 110465e80

[Thr 1543] IcmNetBufFree: free netbuf: 110465e80 out of 1 used

[Thr 1543] IcmConnFreeContext: context 1 released

[Thr 1543] IcmServDecrRefCount: k1b06cus.khis.krupp.com:8056 - serv_ref_count: 1

[Thr 1543] IcmGetSchedule: next schedule in 30 secs

[Thr 1543] IcmWorkerThread: Thread 3: Waiting for event

[Thr 515] Sun Jul 1 11:42:41 2007

[Thr 515] SiSelPSelect: of 1 sockets 0 selected

[Thr 515] IcmProxyWatchDog: check sockets (timeout=10000)

[Thr 515] SiSelPSelect: start select (timeout=10000)

[Thr 3342] Sun Jul 1 11:42:45 2007

[Thr 3342] NiSelISelectInt: 0 handles selected (0 buffered)

[Thr 3342] IcmWatchDogThread: check ni handles (timeout=10000)

[Thr 3342] SiSelPSelect: start select (timeout=10000)

[Thr 01] Sun Jul 1 11:42:46 2007

[Thr 01] SiSelPNext: sock 54 selected (pos=34; revt=r--)

[Thr 01] NiBufISelProcess: hdl 34 process r-

[Thr 01] NiBufIAlloc: malloc NIBUF-IN, to 72 bytes

[Thr 01] NiIRead: hdl 34 received data (rcd=72,pac=1,MESG_IO)

[Thr 01] NiBufIIn: NIBUF len=72

[Thr 01] NiBufIIn: packet complete for hdl 34

[Thr 01] NiBufISelUpdate: new MODE -- (r-) for hdl 34 in set0

[Thr 01] SiSelPSet: set events of sock 54 to: ---

[Thr 01] NiBufISelUpdate: new STAT r-- (---) for hdl 34 in set0

[Thr 01] NiSelIListInsert: add hdl 34 [34] to buf-list (0) of set0

[Thr 01] NiSelISelectInt: 1 handles selected (1 buffered)

[Thr 01] IcmMsgProcess: Receive data from partner: WP(2), wp_no: 2

[Thr 01]

NiBufReceive starting

[Thr 01] NiBufISelUpdate: new MODE r- (--) for hdl 34 in set0

[Thr 01] SiSelPSet: set events of sock 54 to: rp-

[Thr 01] NiBufISelUpdate: new STAT ~~- (r~~) for hdl 34 in set0

[Thr 01] NiSelIListRemove: remove hdl 34 [34] from buf-list (1) of set0

[Thr 01] IcmRecMsg: received 72 bytes

[Thr 01] ============================================

[Thr 01] | COM_DATA:

[Thr 01] | Offset: 0 | Version: 7000

[Thr 01] | MsgNo: 675 | Opcode: ICM_COM_OP_ICM_MONITOR (66)

[Thr 01] ============================================

[Thr 01] IcmHandleAdmMsg: op: 66

[Thr 01] NiBufIAlloc: malloc NiBufadm, to 0 bytes

[Thr 01] NiBufDup: ref 1 for buf 11029b630

[Thr 01] IcmQueueAppend: queuelen: 1

[Thr 01] IcmCreateRequest: Appended request 42736

[Thr 01] NiBufIAlloc: malloc ICM_EXT, to 80 bytes

[Thr 01]

NiBufSend starting

[Thr 2571] IcmWorkerThread: worker 7 got the semaphore

[Thr 2571] REQUEST:

Type: ADMMSG Index = 42735

[Thr 2571] NiBufFree: ref 1 for buf 11029b630

[Thr 2571] MPI<a65c>5#5 GetInbuf -1 198480 440 (1) -> 6

[Thr 2571] IcmHandleMonitorMessage: called with opcode: 100

[Thr 2571] MPI<a65b>4#4 GetOutbuf -1 148368 65536 (0) -> 700000000bd1388 0

[Thr 01] NiIWrite: hdl 34 sent data (wrt=80,pac=1,MESG_IO)

[Thr 2571] MPI<a65c>5#6 FreeInbuf#2 0 198480 0 -> 0

[Thr 01] SiSelPSelect: start select (timeout=-1)

[Thr 2571] MPI<a65b>4#5 FlushOutbuf l-1 1 1 148368 1650 6 -> 700000000bd1368 0

[Thr 2571] IcmWorkerThread: Thread 7: Waiting for event

[Thr 515] Sun Jul 1 11:42:51 2007

[Thr 515] SiSelPSelect: of 1 sockets 0 selected

[Thr 515] IcmProxyWatchDog: check sockets (timeout=10000)

[Thr 515] SiSelPSelect: start select (timeout=10000)

[Thr 3342] Sun Jul 1 11:42:55 2007

[Thr 3342] NiSelISelectInt: 0 handles selected (0 buffered)

[Thr 3342] IcmWatchDogThread: check ni handles (timeout=10000)

[Thr 3342] SiSelPSelect: start select (timeout=10000)

[Thr 515] Sun Jul 1 11:43:01 2007

[Thr 515] SiSelPSelect: of 1 sockets 0 selected

[Thr 515] IcmProxyWatchDog: check sockets (timeout=10000)

[Thr 515] SiSelPSelect: start select (timeout=10000)

[Thr 3342] Sun Jul 1 11:43:05 2007

[Thr 3342] NiSelISelectInt: 0 handles selected (0 buffered)

[Thr 3342] IcmQueueAppend: queuelen: 1

[Thr 3342] IcmCreateRequest: Appended request 42737

[Thr 3342] IcmCheckForBlockedThreads: check for blocked SSL-threads

[Thr 3342] IcmWatchDogThread: check ni handles (timeout=10000)

[Thr 3342] SiSelPSelect: start select (timeout=10000)

[Thr 2828] IcmWorkerThread: worker 8 got the semaphore

[Thr 2828] REQUEST:

Type: SCHEDULER Index = 42736

[Thr 2828] IcmGetSchedule: found slot 0

[Thr 2828] IcmAlReportData: Reporting data to CCMS Alerting Infrastructure

[Thr 2828] NiIGetServNo: servicename '8056' = port 1F.78/8056

[Thr 2828] IcmConnCheckStoredClientConn: check for client conn timeout

[Thr 2828] IcmConnCheckStoredClientConn: next client timeout check in 60 sec

[Thr 2828] NiIGetServNo: servicename '8056' = port 1F.78/8056

[Thr 2828] IcmGetServicePtr: new serv_ref_count: 2

[Thr 2828] PlugInHandleAdmMessage: request received:

[Thr 2828] PlugInHandleAdmMessage: opcode: 136, len: 272, dest_type: 2, subhdlkey: 262145

[Thr 2828] HttpSubHandlerCall: Call Handler: HttpCacheHandler, task=4, header_len=0

[Thr 2828] HttpCacheHandler: 4 0 110272160 0

[Thr 2828] SCACHE: adm request received:

[Thr 2828] SCACHE: opcode: 136, len: 272, dest_type: 2, dest:

[Thr 2828] MTX_LOCK 3038 110d1e050

[Thr 2828] MTX_UNLOCK 3051 110d1e050

[Thr 2828] IctCmGetCacheInfo#18878 -> 0

[Thr 2828] IcmNetBufWrapBuf: allocated netbuf: 110465e80, blocks used: 1

[Thr 2828] IcmNetBufWrapBuf: allocated netbuf: 110465e80

[Thr 2828] IcmNetBufFree: free netbuf: 110465e80 out of 1 used

[Thr 2828] IcmConnFreeContext: context 1 released

[Thr 2828] IcmServDecrRefCount: k1b06cus.khis.krupp.com:8056 - serv_ref_count: 1

[Thr 2828] IcmGetSchedule: next schedule in 30 secs

[Thr 2828] IcmWorkerThread: Thread 8: Waiting for event

I don't have any idea where the problem is.

Regards

Reinhold

Former Member · ‎12-10-2007

I am also receiving the same error .. kindly suggest

Thanks in Advance

Problem receiving emails in an multi client system

Accepted Solutions (0)

Answers (1)

Answers (1)

Re: Bought a new laptop and trying to install Crys...

Re: HTTP Receiver adapter with Dynamic value in UR...

How to create a rolling forecast in SAC? I have an...

In SAP Hana Cloud, do packages exist as database o...

Re: Mass Update a Zfield in Std Table with Split &...