05/25/2006 14:43:16
[pdl :PDL :ERR /0: pntx_adt] read failed: Connection reset by peer
[pdl :PDL :DBUG/0: pntx_adt] input buffer accepted 0 bytes, now 0
05/25/2006 14:43:16
[pdl :PDL :ERR /0: pntx_adt] read returned error 73 (Connection reset by peer)
[pdl :PDL :INFO/0: pntx_adt] no PDL exception handler registered => input error
[pdl :PDL :DBUG/0: pntx_adt] IDLE and 0 bytes and an error: starting READ
[pdl :PDL :DBUG/2: pntx_adt] PDL changed states: old 0, new 1
[pdl :PDL :DBUG/0: pntx_adt] Calling Tcl procedure: hci_pd.read
[pdl :PDL :DBUG/0: pntx_adt] with args: {}
[pdl :PDL :DBUG/0: pntx_adt] Tcl procedure hci_pd.read returns 'RECEIVE'
[pdl :PDL :DBUG/0: pntx_adt] trying to match phrase: basic-msg
[pdl :PDL :INFO/0: pntx_adt] input-error in dfa 'basic-msg'
[pdl :PDL :DBUG/0: pntx_adt] multi_phrase_2: status = error
[pdl :PDL :DBUG/0: pntx_adt] Calling Tcl procedure: read.error
[pdl :PDL :DBUG/0: pntx_adt] with args: {{status error} {type input-error}}
05/25/2006 14:43:16
[pdl :PDL :ERR /0: pntx_adt] PDL signaled exception: code 1, msg device error (remote side probably shut down)
[pdl :PDL :DBUG/0: pntx_adt] pdiIgnoreInput: chop to 4294967295, bolen 0
[pdl :PDL :DBUG/0: pntx_adt] pdiIgnoreInput: after clear: 0 + 0
[pdl :PDL :DBUG/0: pntx_adt] Tcl procedure read.error returns '0'
[pdl :PDL :DBUG/2: pntx_adt] PDL changed states: old 1, new 0
[pdl :PDL :DBUG/0: pntx_adt] READ operation completed (0 bytes buffered still, 0 before)
[pdl :PDL :DBUG/2: pntx_adt] PDL changed states: old 0, new 5
[pdl :PDL :DBUG/2: pntx_adt] PDL changed states: old 5, new 6
[pdl :PDL :DBUG/1: pntx_adt] Clearing PDL listen event
[pti :even:DBUG/0: pntx_adt] Unregistering SOCKET (PDL server) event 0x20bf0d08 for tid 7
[pti :even:DBUG/0: pntx_adt] evUnregister SOCKET event 0x20BF0D08 for tid 7
[msg :Msg :DBUG/0: pntx_adt] [0.0.4773187] msgFree 0x3000603c
[pdl :clse:DBUG/1: pntx_adt] PDL did shutdown: code = 1000
[pdl :open:INFO/1: pntx_adt] Scheduling driver reopen try in 5.0 secs
[pd :pdtd:INFO/1: pntx_adt] Set driver status to PD_STATUS_OPENING
[diag:leak:DBUG/0: pntx_adt] diag timeval alloc 0x20be04d8
[diag:leak:DBUG/0: pntx_adt] diag ev alloc 0x21257d68
[diag:leak:DBUG/0: pntx_adt] diag dqe alloc 0x20be2b28
[pti :even:DBUG/0: pntx_adt] Registering TIMER (<no description>) event 0x21257d68 for tid 7
[pti :even:DBUG/0: pntx_adt] Registering TIMER event for tid 7
[diag:leak:DBUG/0: pntx_adt] diag timeval free 0x20be04d8
[pti :sche:INFO/1: pntx_adt] Thread has 0 ready events left.
[pti :sche:DBUG/2: pntx_adt] Thread 7 has been enabled
[pti :sche:INFO/1: pntx_adt] Thread has 1 ready events.
[pti :even:DBUG/0: pntx_adt] Processing ACTIVE_TIMER (<no description>) event 0x219b38a8
[pti :even:DBUG/1: pntx_adt] Calling cb 0x2009c674
[msi :msi :DBUG/1: pntx_adt] msiExportStats: export for thread: pntx_adt
[pti :even:DBUG/0: pntx_adt] Unregistering ACTIVE_TIMER (<no description>) event 0x219b38a8 for tid 7
[pti :even:DBUG/0: pntx_adt] evUnregister ACTIVE_TIMER event 0x219B38A8 for tid 7
[diag:leak:DBUG/0: pntx_adt] diag timeval alloc 0x20be04d8
[diag:leak:DBUG/0: pntx_adt] diag dqe alloc 0x20bf9c18
[pti :even:DBUG/0: pntx_adt] Registering ACTIVE_TIMER (<no description>) event 0x219b38a8 for tid 7
[pti :even:DBUG/0: pntx_adt] Registering ACTIVE_TIMER event for tid 7
[diag:leak:DBUG/0: pntx_adt] diag timeval free 0x20be04d8
[pti :sche:INFO/1: pntx_adt] Thread has 0 ready events left.
[pti :sche:INFO/2: pntx_adt] Performing apply callback for thread 7
[msi :msi :DBUG/1: pntx_adt] msiExportStats: export for thread: pntx_adt
[pti :sche:DBUG/2: pntx_adt] Thread 7 has been enabled
[pti :sche:INFO/1: pntx_adt] Thread has 1 ready events.
[pti :even:DBUG/0: pntx_adt] Processing TIMER (<no description>) event 0x21257d68
[pti :even:DBUG/1: pntx_adt] Calling cb 0x2009b750
[pdl :open:INFO/0: pntx_adt] Driver attempting reopen
[dbi :elog:DBUG/3: pntx_adt] [0.0.4773188] Looking for mid in error db
[dbi :rlog:DBUG/3: pntx_adt] [0.0.4773188] Looking for mid in recovery db
[msg :Mid :DBUG/3: pntx_adt] Assigned mid [0.0.4773188] to msg 3000603c
[msg :Msg :DBUG/0: pntx_adt] [0.0.4773188] MSG alloc 0x3000603c
[pdl :PDL :DBUG/2: pntx_adt] PDL changed states: old 6, new 7
[pdl :PDL :DBUG/0: pntx_adt] Evaling:
proc hci_pd.write { info } {
global MsgId
keylget info message MsgId
keylset continuations ok write.done
keylset continuations error write.error
keylset continuations timeout [list 15000 write.timeout]
hci_pd_send basic-msg [list [list data [list message $MsgId]]] $continuations
}
proc write.done {info} {}
proc write.error {info} {
hci_pd_report_exception 1 "write failure"
hci_pd_set_result_code 1
}
proc write.timeout {info} {
global MsgId
msgmetaset $MsgId FLAGS {{proto_timeout 1}}
hci_pd_set_result_code 1
}
proc hci_pd.read {info} {
keylset continuations basic-msg read.done
keylset continuations error read.error
keylset continuations timeout [list 15000 read.timeout]
hci_pd_receive $continuations
}
proc read.done {info} {
keylset accept text [list [keylget info data]]
keylset accept end [keylget info end]
hci_pd_accept $accept
}
proc read.error {info} {
keylget info type type
switch -exact -- $type {
input-error {
hci_pd_report_exception 1 "device error (remote side probably shut down)"
hci_pd_ignore_input -all
}
no-match {
hci_pd_ignore_input 1
hci_pd_ignore_input -until \xb
}
default {
hci_pd_report_exception 2 "unknown fail: $type"
hci_pd_ignore_input -all
}
}
}
proc read.timeout {info} {
hci_pd_ignore_input 1
hci_pd_ignore_input -until \xb
}
[pdl :PDL :DBUG/2: pntx_adt] PDL changed states: old 7, new 4
[pdl :PDL :DBUG/0: pntx_adt] Calling Tcl procedure: hci_pd.initialize
[pdl :PDL :DBUG/0: pntx_adt] with args: {}
[pdl :PDL :DBUG/0: pntx_adt] Tcl procedure hci_pd.initialize returns ''
[pdl :PDL :INFO/0: pntx_adt] connected to 172.16.101.125 on port 16000
[pdl :PDL :DBUG/0: pntx_adt] tcp-client: attempting connect to: 172.16.101.125:16000
[pdl :PDL :INFO/0: pntx_adt] tcp-client: connect error (Operation now in progress)
[pdl :PDL :DBUG/1: pntx_adt] PDL setting timeout in 0.10 seconds
[diag:leak:DBUG/0: pntx_adt] diag ev alloc 0x21257958
[diag:leak:DBUG/0: pntx_adt] diag dqe alloc 0x20be2b28
[pti :even:DBUG/0: pntx_adt] Registering TIMER (<no description>) event 0x21257958 for tid 7
[pti :even:DBUG/0: pntx_adt] Registering TIMER event for tid 7
[pti :even:DBUG/0: pntx_adt] Unregistering TIMER (<no description>) event 0x21257d68 for tid 7
[pti :even:DBUG/0: pntx_adt] evUnregister TIMER event 0x21257D68 for tid 7
[diag:leak:DBUG/0: pntx_adt] diag ev free 0x21257d68
[pti :sche:INFO/1: pntx_adt] Thread has 0 ready events left.
[pti :sche:DBUG/2: pntx_adt] Thread 7 has been enabled
[pti :sche:INFO/1: pntx_adt] Thread has 1 ready events.
[pti :even:DBUG/0: pntx_adt] Processing ACTIVE_TIMER (<no description>) event 0x219b38a8
[pti :even:DBUG/1: pntx_adt] Calling cb 0x2009c674
[msi :msi :DBUG/1: pntx_adt] msiExportStats: export for thread: pntx_adt
[pti :even:DBUG/0: pntx_adt] Unregistering ACTIVE_TIMER (<no description>) event 0x219b38a8 for tid 7
[pti :even:DBUG/0: pntx_adt] evUnregister ACTIVE_TIMER event 0x219B38A8 for tid 7
[diag:leak:DBUG/0: pntx_adt] diag timeval alloc 0x20bddea8
[diag:leak:DBUG/0: pntx_adt] diag dqe alloc 0x20bf9c18
[pti :even:DBUG/0: pntx_adt] Registering ACTIVE_TIMER (<no description>) event 0x219b38a8 for tid 7
[pti :even:DBUG/0: pntx_adt] Registering ACTIVE_TIMER event for tid 7
[diag:leak:DBUG/0: pntx_adt] diag timeval free 0x20bddea8
[pti :sche:INFO/1: pntx_adt] Thread has 0 ready events left.
[pti :sche:INFO/2: pntx_adt] Performing apply callback for thread 7
[msi :msi :DBUG/1: pntx_adt] msiExportStats: export for thread: pntx_adt
[pti :sche:DBUG/2: pntx_adt] Thread 7 has been enabled
[pti :sche:INFO/1: pntx_adt] Thread has 1 ready events.
[pti :even:DBUG/0: pntx_adt] Processing TIMER (<no description>) event 0x21257958
[pti :even:DBUG/1: pntx_adt] Calling cb 0x2009b744
[pdl :PDL :DBUG/0: pntx_adt] timeout continues: 2009b69c
[pdl :PDL :DBUG/0: pntx_adt] tcp-client: attempting connect to: 172.16.101.125:16000
[pdl :PDL :INFO/0: pntx_adt] tcp-client: connect error (Invalid argument)
[pdl :PDL :DBUG/1: pntx_adt] PDL setting timeout in 5.00 seconds
[diag:leak:DBUG/0: pntx_adt] diag ev alloc 0x21257d68
[diag:leak:DBUG/0: pntx_adt] diag dqe alloc 0x20be2b28
[pti :even:DBUG/0: pntx_adt] Registering TIMER (<no description>) event 0x21257d68 for tid 7
[pti :even:DBUG/0: pntx_adt] Registering TIMER event for tid 7
[pti :even:DBUG/0: pntx_adt] Unregistering TIMER (<no description>) event 0x21257958 for tid 7
[pti :even:DBUG/0: pntx_adt] evUnregister TIMER event 0x21257958 for tid 7
[diag:leak:DBUG/0: pntx_adt] diag ev free 0x21257958
[pti :sche:INFO/1: pntx_adt] Thread has 0 ready events left.
[pti :sche:INFO/2: pntx_adt] Performing apply callback for thread 7
[msi :msi :DBUG/1: pntx_adt] msiExportStats: export for thread: pntx_adt
[pti :sche:DBUG/2: pntx_adt] Thread 7 has been enabled
[pti :sche:INFO/1: pntx_adt] Thread has 1 ready events.
[pti :even:DBUG/0: pntx_adt] Processing TIMER (<no description>) event 0x21257d68
[pti :even:DBUG/1: pntx_adt] Calling cb 0x2009b744
[pdl :PDL :DBUG/0: pntx_adt] timeout continues: 2009b6a8
[pdl :PDL :DBUG/0: pntx_adt] tcp-client: attempting connect to: 172.16.101.125:16000
[pdl :PDL :INFO/0: pntx_adt] tcp-client: connect error (Operation now in progress)
[pdl :PDL :DBUG/1: pntx_adt] PDL setting timeout in 0.10 seconds
[diag:leak:DBUG/0: pntx_adt] diag ev alloc 0x21257958
[diag:leak:DBUG/0: pntx_adt] diag dqe alloc 0x20be2b28
[pti :even:DBUG/0: pntx_adt] Registering TIMER (<no description>) event 0x21257958 for tid 7
[pti :even:DBUG/0: pntx_adt] Registering TIMER event for tid 7
[pti :even:DBUG/0: pntx_adt] Unregistering TIMER (<no description>) event 0x21257d68 for tid 7
[pti :even:DBUG/0: pntx_adt] evUnregister TIMER event 0x21257D68 for tid 7
[diag:leak:DBUG/0: pntx_adt] diag ev free 0x21257d68
[pti :sche:INFO/1: pntx_adt] Thread has 0 ready events left.
[pti :sche:DBUG/2: pntx_adt] Thread 7 has been enabled
[pti :sche:INFO/1: pntx_adt] Thread has 1 ready events.
[pti :even:DBUG/0: pntx_adt] Processing ACTIVE_TIMER (<no description>) event 0x219b38a8
[pti :even:DBUG/1: pntx_adt] Calling cb 0x2009c674
[msi :msi :DBUG/1: pntx_adt] msiExportStats: export for thread: pntx_adt
[pti :even:DBUG/0: pntx_adt] Unregistering ACTIVE_TIMER (<no description>) event 0x219b38a8 for tid 7
[pti :even:DBUG/0: pntx_adt] evUnregister ACTIVE_TIMER event 0x219B38A8 for tid 7
[diag:leak:DBUG/0: pntx_adt] diag timeval alloc 0x20bddea8
[diag:leak:DBUG/0: pntx_adt] diag dqe alloc 0x20bf9c18
[pti :even:DBUG/0: pntx_adt] Registering ACTIVE_TIMER (<no description>) event 0x219b38a8 for tid 7
[pti :even:DBUG/0: pntx_adt] Registering ACTIVE_TIMER event for tid 7
[diag:leak:DBUG/0: pntx_adt] diag timeval free 0x20bddea8
[pti :sche:INFO/1: pntx_adt] Thread has 0 ready events left.
[pti :sche:INFO/2: pntx_adt] Performing apply callback for thread 7
[msi :msi :DBUG/1: pntx_adt] msiExportStats: export for thread: pntx_adt
[pti :sche:DBUG/2: pntx_adt] Thread 7 has been enabled
[pti :sche:INFO/1: pntx_adt] Thread has 1 ready events.
[pti :even:DBUG/0: pntx_adt] Processing TIMER (<no description>) event 0x21257958
[pti :even:DBUG/1: pntx_adt] Calling cb 0x2009b744
[pdl :PDL :DBUG/0: pntx_adt] timeout continues: 2009b69c
[pdl :PDL :DBUG/0: pntx_adt] tcp-client: attempting connect to: 172.16.101.125:16000
[pdl :PDL :DBUG/1: pntx_adt] Creating PDL listen event on fd 93
[pti :even:DBUG/0: pntx_adt] Registering SOCKET (PDL server) event 0x20bf0d08 for tid 7
[pti :even:DBUG/0: pntx_adt] Registering SOCKET event for tid 7
[pdl :PDL :DBUG/0: pntx_adt] Calling Tcl procedure: hci_pd.default.open-ok
[pdl :PDL :DBUG/0: pntx_adt] with args: {{status ok}}
[pdl :PDL :DBUG/0: pntx_adt] Tcl procedure hci_pd.default.open-ok returns ''
[pdl :PDL :DBUG/2: pntx_adt] PDL changed states: old 4, new 0
[pdl :init:DBUG/1: pntx_adt] PDL did initialize: code = 0
[pd :pdtd:INFO/1: pntx_adt] Set driver status to PD_STATUS_UP
[pti :even:DBUG/0: pntx_adt] Unregistering TIMER (<no description>) event 0x21257958 for tid 7
[pti :even:DBUG/0: pntx_adt] evUnregister TIMER event 0x21257958 for tid 7
[diag:leak:DBUG/0: pntx_adt] diag ev free 0x21257958
[pti :sche:INFO/1: pntx_adt] Thread has 0 ready events left.
[pti :sche:INFO/2: pntx_adt] Performing apply callback for thread 7
[msi :msi :DBUG/1: pntx_adt] msiExportStats: export for thread: pntx_adt
Engine idle -- 05/25/2006 14:43:36
[pti :sche:DBUG/2: pntx_adt] Thread 7 has been enabled
[pti :sche:INFO/1: pntx_adt] Thread has 1 ready events.
[pti :even:DBUG/0: pntx_adt] Processing SOCKET (PDL server) event 0x20bf0d08
[pti :even:DBUG/1: pntx_adt] Calling cb 0x2009b738
[pdl :read:DBUG/2: pntx_adt] Events: E 0, R 8, W 0
05/25/2006 14:59:32
[pdl :PDL :ERR /0: pntx_adt] read failed: Connection reset by peer
[pdl :PDL :DBUG/0: pntx_adt] input buffer accepted 0 bytes, now 0
05/25/2006 14:59:32
[pdl :PDL :ERR /0: pntx_adt] read returned error 73 (Connection reset by peer)
[pdl :PDL :INFO/0: pntx_adt] no PDL exception handler registered => input error
[pdl :PDL :DBUG/0: pntx_adt] IDLE and 0 bytes and an error: starting READ
[pdl :PDL :DBUG/2: pntx_adt] PDL changed states: old 0, new 1
[pdl :PDL :DBUG/0: pntx_adt] Calling Tcl procedure: hci_pd.read
[pdl :PDL :DBUG/0: pntx_adt] with args: {}
[pdl :PDL :DBUG/0: pntx_adt] Tcl procedure hci_pd.read returns 'RECEIVE'
[pdl :PDL :DBUG/0: pntx_adt] trying to match phrase: basic-msg
[pdl :PDL :INFO/0: pntx_adt] input-error in dfa 'basic-msg'
[pdl :PDL :DBUG/0: pntx_adt] multi_phrase_2: status = error
[pdl :PDL :DBUG/0: pntx_adt] Calling Tcl procedure: read.error
[pdl :PDL :DBUG/0: pntx_adt] with args: {{status error} {type input-error}}
05/25/2006 14:59:32
[pdl :PDL :ERR /0: pntx_adt] PDL signaled exception: code 1, msg device error (remote side probably shut down)
[pdl :PDL :DBUG/0: pntx_adt] pdiIgnoreInput: chop to 4294967295, bolen 0
[pdl :PDL :DBUG/0: pntx_adt] pdiIgnoreInput: after clear: 0 + 0
[pdl :PDL :DBUG/0: pntx_adt] Tcl procedure read.error returns '0'
[pdl :PDL :DBUG/2: pntx_adt] PDL changed states: old 1, new 0
[pdl :PDL :DBUG/0: pntx_adt] READ operation completed (0 bytes buffered still, 0 before)
[pdl :PDL :DBUG/2: pntx_adt] PDL changed states: old 0, new 5
[pdl :PDL :DBUG/2: pntx_adt] PDL changed states: old 5, new 6
[pdl :PDL :DBUG/1: pntx_adt] Clearing PDL listen event
[pti :even:DBUG/0: pntx_adt] Unregistering SOCKET (PDL server) event 0x20bf0d08 for tid 7
[pti :even:DBUG/0: pntx_adt] evUnregister SOCKET event 0x20BF0D08 for tid 7
[msg :Msg :DBUG/0: pntx_adt] [0.0.4773188] msgFree 0x3000603c
[pdl :clse:DBUG/1: pntx_adt] PDL did shutdown: code = 1000
[pdl :open:INFO/1: pntx_adt] Scheduling driver reopen try in 5.0 secs
[pd :pdtd:INFO/1: pntx_adt] Set driver status to PD_STATUS_OPENING
[diag:leak:DBUG/0: pntx_adt] diag timeval alloc 0x20be04d8
[diag:leak:DBUG/0: pntx_adt] diag ev alloc 0x21257d68
[diag:leak:DBUG/0: pntx_adt] diag dqe alloc 0x20be2b28
[pti :even:DBUG/0: pntx_adt] Registering TIMER (<no description>) event 0x21257d68 for tid 7
[pti :even:DBUG/0: pntx_adt] Registering TIMER event for tid 7
[diag:leak:DBUG/0: pntx_adt] diag timeval free 0x20be04d8
[pti :sche:INFO/1: pntx_adt] Thread has 0 ready events left.
[pti :sche:DBUG/2: pntx_adt] Thread 7 has been enabled
[pti :sche:INFO/1: pntx_adt] Thread has 1 ready events.
[pti :even:DBUG/0: pntx_adt] Processing ACTIVE_TIMER (<no description>) event 0x219b38a8
[pti :even:DBUG/1: pntx_adt] Calling cb 0x2009c674
[msi :msi :DBUG/1: pntx_adt] msiExportStats: export for thread: pntx_adt
[pti :even:DBUG/0: pntx_adt] Unregistering ACTIVE_TIMER (<no description>) event 0x219b38a8 for tid 7
[pti :even:DBUG/0: pntx_adt] evUnregister ACTIVE_TIMER event 0x219B38A8 for tid 7
[diag:leak:DBUG/0: pntx_adt] diag timeval alloc 0x20be04d8
[diag:leak:DBUG/0: pntx_adt] diag dqe alloc 0x20bf9c18
[pti :even:DBUG/0: pntx_adt] Registering ACTIVE_TIMER (<no description>) event 0x219b38a8 for tid 7
[pti :even:DBUG/0: pntx_adt] Registering ACTIVE_TIMER event for tid 7
[diag:leak:DBUG/0: pntx_adt] diag timeval free 0x20be04d8
[pti :sche:INFO/1: pntx_adt] Thread has 0 ready events left.
[pti :sche:INFO/2: pntx_adt] Performing apply callback for thread 7
[msi :msi :DBUG/1: pntx_adt] msiExportStats: export for thread: pntx_adt
[pti :sche:DBUG/2: pntx_adt] Thread 7 has been enabled
[pti :sche:INFO/1: pntx_adt] Thread has 1 ready events.
[pti :even:DBUG/0: pntx_adt] Processing TIMER (<no description>) event 0x21257d68