Q.931 signaling tool help

Overview

The tool is designed to filter activity reported by "debug isdn q931" and track individual calls. Calls are assigned numbers ("Call#") in the order they arrive, each record within the call is assigned an index ("[Idx]").

A single Q.931 message can be represented by one or more records: first record reports the message type, further records may provide additional information about various values encoded in the message. Each Q.931 message is followed by two time values: time elapsed since the previous Q.931 message related to the call ("Previous", e. g. for troubleshooting problems when it takes too long to set up a call) and time elapsed since the call was initiated ("Duration", e. g. for troubleshooting problems when a call is disconnected on idle timeout).

The calls are sorted by thier number, records within each call are sorted by their index. Below are included a sample log as reported by "debug isdn q931" (for better visibility Q.931 messages are separated with blank lines) and the output of the tool.

Sample log

Jan  9 10:45:42.694: ISDN Se1/0/0:15 SC: RX <-  SETUP pd = 8  callref = 0x35C2
Jan  9 10:45:42.694:         Bearer Capability i = 0x8890
Jan  9 10:45:42.694:         Called Party Number i = 0xA1, '674501100', Plan:ISDN, Type:National
Jan  9 10:45:42.694:         Calling Party Number i = 0x21A3, '664188096', Plan:ISDN, Type:National
Jan  9 10:45:42.694:         Channel ID i = 0xE99A8392
Jan  9 10:45:42.694:         Low Layer Compat i = 0x8890214846BB

Jan  9 10:45:42.698: ISDN Se1/0/0:15 SC: TX ->  CALL_PROC pd = 8  callref = 0xB5C2
Jan  9 10:45:42.698:         Channel ID i = 0xE19A8392

Jan  9 10:45:42.726: ISDN Se1/0/0:15 SC: TX ->  CONNECT pd = 8  callref = 0xB5C2
Jan  9 10:45:42.726:         Channel ID i = 0xE19A8392

Jan  9 10:45:42.726: ISDN Se1/0/0:15 SC: RX <-  CONNECT_ACK pd = 8  callref = 0x35C2

Jan  9 10:45:43.490: ISDN Se1/3/11:15 SC: RX <-  SETUP pd = 8  callref = 0x3AD1
Jan  9 10:45:43.490:         Bearer Capability i = 0x8890
Jan  9 10:45:43.494:         Called Party Number i = 0xA1, '674501100', Plan:ISDN, Type:National
Jan  9 10:45:43.494:         Calling Party Number i = 0x2183, '678488092', Plan:ISDN, Type:National
Jan  9 10:45:43.494:         Channel ID i = 0xE9A8838C
Jan  9 10:45:43.494:         Low Layer Compat i = 0x8890214846BB
Jan  9 10:45:43.498:         Channel ID i = 0xE1A8838C

Jan  9 10:45:43.498: ISDN Se1/3/11:15 SC: TX ->  CALL_PROC pd = 8  callref = 0xBAD1

Jan  9 10:45:43.514: ISDN Se1/3/11:15 SC: TX ->  CONNECT pd = 8  callref = 0xBAD1
Jan  9 10:45:43.514:         Channel ID i = 0xE1A8838C

Jan  9 10:45:43.534: ISDN Se1/3/11:15 SC: RX <-  CONNECT_ACK pd = 8  callref = 0x3AD1

Jan  9 10:45:44.070: ISDN Se1/3/11:15 SC: RX <-  DISCONNECT pd = 8  callref = 0x3AD1
Jan  9 10:45:44.070:         Cause i = 0x8090 - Normal call clearing

Jan  9 10:45:44.394: ISDN Se1/3/11:15 SC: RX <-  SETUP pd = 8  callref = 0x3AD2
Jan  9 10:45:44.394:         Bearer Capability i = 0x8890
Jan  9 10:45:44.394:         Called Party Number i = 0xA1, '674501100', Plan:ISDN, Type:National
Jan  9 10:45:44.394:         Calling Party Number i = 0x2183, '611160898', Plan:ISDN, Type:National
Jan  9 10:45:44.394:         Channel ID i = 0xE9AB838B
Jan  9 10:45:44.394:         Low Layer Compat i = 0x8890214846BB

Jan  9 10:45:44.398: ISDN Se1/3/11:15 SC: TX ->  CALL_PROC pd = 8  callref = 0xBAD2
Jan  9 10:45:44.398:         Channel ID i = 0xE1AB838B

Jan  9 10:45:44.426: ISDN Se1/3/11:15 SC: TX ->  CONNECT pd = 8  callref = 0xBAD2
Jan  9 10:45:44.426:         Channel ID i = 0xE1AB838B

Jan  9 10:45:44.454: ISDN Se1/3/11:15 SC: RX <-  CONNECT_ACK pd = 8  callref = 0x3AD2

Jan  9 10:45:44.858: ISDN Se1/3/11:15 SC: RX <-  DISCONNECT pd = 8  callref = 0x3AD2
Jan  9 10:45:44.858:         Cause i = 0x8A90 - Normal call clearing

Jan  9 10:45:44.862: ISDN Se1/3/11:15 SC: TX ->  RELEASE pd = 8  callref = 0xBAD2

Jan  9 10:45:44.874: ISDN Se1/3/11:15 SC: RX <-  RELEASE_COMP pd = 8  callref = 0x3AD2

Jan  9 10:45:44.906: ISDN Se1/0/0:15 SC: RX <-  DISCONNECT pd = 8  callref = 0x35C2
Jan  9 10:45:44.906:         Cause i = 0x8090 - Normal call clearing

Jan  9 10:45:44.910: ISDN Se1/0/0:15 SC: RX <-  RELEASE_COMP pd = 8  callref = 0x35C2

Jan  9 10:45:44.910: ISDN Se1/0/0:15 SC: TX ->  RELEASE pd = 8  callref = 0xB5C2

Jan  9 10:45:46.806: ISDN Se1/0/0:15 SC: RX <-  SETUP pd = 8  callref = 0x35C3
Jan  9 10:45:46.806:         Bearer Capability i = 0x8890
Jan  9 10:45:46.806:         Called Party Number i = 0xA1, '674501100', Plan:ISDN, Type:National
Jan  9 10:45:46.806:         Calling Party Number i = 0x2183, '682341930', Plan:ISDN, Type:National
Jan  9 10:45:46.806:         Channel ID i = 0xE988838B
Jan  9 10:45:46.810:         Low Layer Compat i = 0x8890214846BB

Jan  9 10:45:46.814: ISDN Se1/0/0:15 SC: TX ->  CALL_PROC pd = 8  callref = 0xB5C3
Jan  9 10:45:46.814:         Channel ID i = 0xE188838B

Jan  9 10:45:46.834: ISDN Se1/0/0:15 SC: TX ->  CONNECT pd = 8  callref = 0xB5C3
Jan  9 10:45:46.834:         Channel ID i = 0xE188838B

Jan  9 10:45:46.838: ISDN Se1/0/0:15 SC: RX <-  CONNECT_ACK pd = 8  callref = 0x35C3

Jan  9 10:45:47.090: ISDN Se1/0/0:15 SC: RX <-  DISCONNECT pd = 8  callref = 0x35C3
Jan  9 10:45:47.090:         Cause i = 0x8090 - Normal call clearing

Jan  9 10:45:47.094: ISDN Se1/0/0:15 SC: TX ->  RELEASE pd = 8  callref = 0xB5C3

Jan  9 10:45:47.094: ISDN Se1/0/0:15 SC: RX <-  RELEASE_COMP pd = 8  callref = 0x35C3

Jan  9 10:45:47.590: ISDN Se1/3/11:15 SC: RX <-  SETUP pd = 8  callref = 0x3AD3
Jan  9 10:45:47.594:         Bearer Capability i = 0x8890
Jan  9 10:45:47.594:         Called Party Number i = 0xA1, '674501100', Plan:ISDN, Type:National
Jan  9 10:45:47.594:         Calling Party Number i = 0x2183, '678946450', Plan:ISDN, Type:National
Jan  9 10:45:47.594:         Channel ID i = 0xE9A6839F
Jan  9 10:45:47.594:         Low Layer Compat i = 0x8890214840BB
Jan  9 10:45:47.598:         Channel ID i = 0xE1A6839F

Jan  9 10:45:47.598: ISDN Se1/3/11:15 SC: TX ->  CALL_PROC pd = 8  callref = 0xBAD3

Jan  9 10:45:47.614: ISDN Se1/3/11:15 SC: TX ->  CONNECT pd = 8  callref = 0xBAD3
Jan  9 10:45:47.614:         Channel ID i = 0xE1A6839F

Jan  9 10:45:47.638: ISDN Se1/3/11:15 SC: RX <-  CONNECT_ACK pd = 8  callref = 0x3AD3

Jan  9 10:45:47.858: ISDN Se1/0/0:15 SC: RX <-  SETUP pd = 8  callref = 0x35C4
Jan  9 10:45:47.858:         Bearer Capability i = 0x8890
Jan  9 10:45:47.858:         Called Party Number i = 0xA1, '674501100', Plan:ISDN, Type:National
Jan  9 10:45:47.858:         Calling Party Number i = 0x2183, '683170576', Plan:ISDN, Type:National
Jan  9 10:45:47.858:         Channel ID i = 0xE9888397
Jan  9 10:45:47.858:         Low Layer Compat i = 0x8890214846BB

Jan  9 10:45:47.862: ISDN Se1/0/0:15 SC: TX ->  CALL_PROC pd = 8  callref = 0xB5C4
Jan  9 10:45:47.862:         Channel ID i = 0xE1888397

Jan  9 10:45:47.886: ISDN Se1/0/0:15 SC: RX <-  CONNECT_ACK pd = 8  callref = 0x35C4
Jan  9 10:45:47.886:         Channel ID i = 0xE1888397

Jan  9 10:45:47.886: ISDN Se1/0/0:15 SC: TX ->  CONNECT pd = 8  callref = 0xB5C4

Jan  9 10:45:48.890: ISDN Se1/3/11:15 SC: RX <-  SETUP pd = 8  callref = 0x3AD4
Jan  9 10:45:48.890:         Bearer Capability i = 0x8890
Jan  9 10:45:48.890:         Called Party Number i = 0xA1, '674501100', Plan:ISDN, Type:National
Jan  9 10:45:48.890:         Calling Party Number i = 0x2183, '632428936', Plan:ISDN, Type:National
Jan  9 10:45:48.890:         Channel ID i = 0xE994839F
Jan  9 10:45:48.890:         Low Layer Compat i = 0x8890214846BB

Jan  9 10:45:48.898: ISDN Se1/3/11:15 SC: TX ->  CALL_PROC pd = 8  callref = 0xBAD4
Jan  9 10:45:48.898:         Channel ID i = 0xE194839F

Jan  9 10:45:49.162: ISDN Se1/3/11:15 SC: TX ->  CONNECT pd = 8  callref = 0xBAD4
Jan  9 10:45:49.162:         Channel ID i = 0xE194839F

Jan  9 10:45:49.338: ISDN Se1/3/11:15 SC: RX <-  CONNECT_ACK pd = 8  callref = 0x3AD4

Jan  9 10:45:49.906: ISDN Se1/3/11:15 SC: RX <-  SETUP pd = 8  callref = 0x3AD5
Jan  9 10:45:49.906:         Bearer Capability i = 0x8890
Jan  9 10:45:49.906:         Called Party Number i = 0xA1, '674501100', Plan:ISDN, Type:National
Jan  9 10:45:49.906:         Calling Party Number i = 0x2183, '689384379', Plan:ISDN, Type:National
Jan  9 10:45:49.906:         Channel ID i = 0xE9A7839D
Jan  9 10:45:49.906:         Low Layer Compat i = 0x8890214846BB

Jan  9 10:45:49.914: ISDN Se1/3/11:15 SC: TX ->  CALL_PROC pd = 8  callref = 0xBAD5
Jan  9 10:45:49.914:         Channel ID i = 0xE1A7839D

Jan  9 10:45:49.938: ISDN Se1/3/11:15 SC: TX ->  CONNECT pd = 8  callref = 0xBAD5
Jan  9 10:45:49.938:         Channel ID i = 0xE1A7839D

Jan  9 10:45:49.950: ISDN Se1/3/11:15 SC: RX <-  CONNECT_ACK pd = 8  callref = 0x3AD5

Jan  9 10:45:50.698: ISDN Se1/0/0:15 SC: RX <-  SETUP pd = 8  callref = 0x35C5
Jan  9 10:45:50.698:         Bearer Capability i = 0x8890
Jan  9 10:45:50.698:         Called Party Number i = 0xA1, '674501100', Plan:ISDN, Type:National
Jan  9 10:45:50.698:         Calling Party Number i = 0x2183, '630611716', Plan:ISDN, Type:National
Jan  9 10:45:50.698:         Channel ID i = 0xE99C839C
Jan  9 10:45:50.698:         Low Layer Compat i = 0x8890214846BB

Jan  9 10:45:50.706: ISDN Se1/0/0:15 SC: TX ->  CALL_PROC pd = 8  callref = 0xB5C5
Jan  9 10:45:50.706:         Channel ID i = 0xE19C839C

Jan  9 10:45:50.730: ISDN Se1/0/0:15 SC: TX ->  CONNECT pd = 8  callref = 0xB5C5
Jan  9 10:45:50.730:         Channel ID i = 0xE19C839C

Jan  9 10:45:50.734: ISDN Se1/0/0:15 SC: RX <-  CONNECT_ACK pd = 8  callref = 0x35C5

Output of the tool

Call#
[Idx]
MessageComments



# 0[ 1]Jan 9 10:45:42.694: ISDN Se1/0/0:15 SC: RX <- SETUP pd = 8 callref = 0x35C2
# 0[ 2]Jan 9 10:45:42.694: Bearer Capability i = 0x8890
# 0[ 3]Jan 9 10:45:42.694: Channel ID i = 0xE99A8392
# 0[ 4]Jan 9 10:45:42.694: Calling Party Number i = 0x21A3, '664188096', Plan:ISDN, Type:National
# 0[ 5]Jan 9 10:45:42.694: Called Party Number i = 0xA1, '674501100', Plan:ISDN, Type:National
# 0[ 6]Jan 9 10:45:42.694: Low Layer Compat i = 0x8890214846BB
# 0[ 7]Jan 9 10:45:42.698: ISDN Se1/0/0:15 SC: TX -> CALL_PROC pd = 8 callref = 0xB5C2Previous 0.004s, Duration 0.004s
# 0[ 8]Jan 9 10:45:42.698: Channel ID i = 0xE19A8392
# 0[ 9]Jan 9 10:45:42.726: ISDN Se1/0/0:15 SC: TX -> CONNECT pd = 8 callref = 0xB5C2Previous 0.028s, Duration 0.032s
# 0[ 10]Jan 9 10:45:42.726: Channel ID i = 0xE19A8392
# 0[ 11]Jan 9 10:45:42.726: ISDN Se1/0/0:15 SC: RX <- CONNECT_ACK pd = 8 callref = 0x35C2Previous 0.000s, Duration 0.032s
# 0[ 12]Jan 9 10:45:44.906: ISDN Se1/0/0:15 SC: RX <- DISCONNECT pd = 8 callref = 0x35C2Previous 2.180s, Duration 2.212s
# 0[ 13]Jan 9 10:45:44.906: Cause i = 0x8090 - Normal call clearing
# 0[ 14]Jan 9 10:45:44.910: ISDN Se1/0/0:15 SC: TX -> RELEASE pd = 8 callref = 0xB5C2Previous 0.004s, Duration 2.216s
# 0[ 15]Jan 9 10:45:44.910: ISDN Se1/0/0:15 SC: RX <- RELEASE_COMP pd = 8 callref = 0x35C2Previous 0.000s, Duration 2.216s



# 1[ 1]Jan 9 10:45:43.490: ISDN Se1/3/11:15 SC: RX <- SETUP pd = 8 callref = 0x3AD1
# 1[ 2]Jan 9 10:45:43.490: Bearer Capability i = 0x8890
# 1[ 3]Jan 9 10:45:43.494: Channel ID i = 0xE9A8838C
# 1[ 4]Jan 9 10:45:43.494: Calling Party Number i = 0x2183, '678488092', Plan:ISDN, Type:National
# 1[ 5]Jan 9 10:45:43.494: Called Party Number i = 0xA1, '674501100', Plan:ISDN, Type:National
# 1[ 6]Jan 9 10:45:43.494: Low Layer Compat i = 0x8890214846BB
# 1[ 7]Jan 9 10:45:43.498: ISDN Se1/3/11:15 SC: TX -> CALL_PROC pd = 8 callref = 0xBAD1Previous 0.008s, Duration 0.008s
# 1[ 8]Jan 9 10:45:43.498: Channel ID i = 0xE1A8838C
# 1[ 9]Jan 9 10:45:43.514: ISDN Se1/3/11:15 SC: TX -> CONNECT pd = 8 callref = 0xBAD1Previous 0.016s, Duration 0.024s
# 1[ 10]Jan 9 10:45:43.514: Channel ID i = 0xE1A8838C
# 1[ 11]Jan 9 10:45:43.534: ISDN Se1/3/11:15 SC: RX <- CONNECT_ACK pd = 8 callref = 0x3AD1Previous 0.020s, Duration 0.044s
# 1[ 12]Jan 9 10:45:44.070: ISDN Se1/3/11:15 SC: RX <- DISCONNECT pd = 8 callref = 0x3AD1Previous 0.536s, Duration 0.580s
# 1[ 13]Jan 9 10:45:44.070: Cause i = 0x8090 - Normal call clearing
# 1[ 13]Jan 9 10:45:51.918: [Warning]Still active Se1/3/11:15 0x3AD1



# 2[ 1]Jan 9 10:45:44.394: ISDN Se1/3/11:15 SC: RX <- SETUP pd = 8 callref = 0x3AD2
# 2[ 2]Jan 9 10:45:44.394: Bearer Capability i = 0x8890
# 2[ 3]Jan 9 10:45:44.394: Channel ID i = 0xE9AB838B
# 2[ 4]Jan 9 10:45:44.394: Calling Party Number i = 0x2183, '611160898', Plan:ISDN, Type:National
# 2[ 5]Jan 9 10:45:44.394: Called Party Number i = 0xA1, '674501100', Plan:ISDN, Type:National
# 2[ 6]Jan 9 10:45:44.394: Low Layer Compat i = 0x8890214846BB
# 2[ 7]Jan 9 10:45:44.398: ISDN Se1/3/11:15 SC: TX -> CALL_PROC pd = 8 callref = 0xBAD2Previous 0.004s, Duration 0.004s
# 2[ 8]Jan 9 10:45:44.398: Channel ID i = 0xE1AB838B
# 2[ 9]Jan 9 10:45:44.426: ISDN Se1/3/11:15 SC: TX -> CONNECT pd = 8 callref = 0xBAD2Previous 0.028s, Duration 0.032s
# 2[ 10]Jan 9 10:45:44.426: Channel ID i = 0xE1AB838B
# 2[ 11]Jan 9 10:45:44.454: ISDN Se1/3/11:15 SC: RX <- CONNECT_ACK pd = 8 callref = 0x3AD2Previous 0.028s, Duration 0.060s
# 2[ 12]Jan 9 10:45:44.858: ISDN Se1/3/11:15 SC: RX <- DISCONNECT pd = 8 callref = 0x3AD2Previous 0.404s, Duration 0.464s
# 2[ 13]Jan 9 10:45:44.858: Cause i = 0x8A90 - Normal call clearing
# 2[ 14]Jan 9 10:45:44.862: ISDN Se1/3/11:15 SC: TX -> RELEASE pd = 8 callref = 0xBAD2Previous 0.004s, Duration 0.468s
# 2[ 15]Jan 9 10:45:44.874: ISDN Se1/3/11:15 SC: RX <- RELEASE_COMP pd = 8 callref = 0x3AD2Previous 0.012s, Duration 0.480s



# 3[ 1]Jan 9 10:45:46.806: ISDN Se1/0/0:15 SC: RX <- SETUP pd = 8 callref = 0x35C3
# 3[ 2]Jan 9 10:45:46.806: Bearer Capability i = 0x8890
# 3[ 3]Jan 9 10:45:46.806: Channel ID i = 0xE988838B
# 3[ 4]Jan 9 10:45:46.806: Calling Party Number i = 0x2183, '682341930', Plan:ISDN, Type:National
# 3[ 5]Jan 9 10:45:46.806: Called Party Number i = 0xA1, '674501100', Plan:ISDN, Type:National
# 3[ 6]Jan 9 10:45:46.810: Low Layer Compat i = 0x8890214846BB
# 3[ 7]Jan 9 10:45:46.814: ISDN Se1/0/0:15 SC: TX -> CALL_PROC pd = 8 callref = 0xB5C3Previous 0.008s, Duration 0.008s
# 3[ 8]Jan 9 10:45:46.814: Channel ID i = 0xE188838B
# 3[ 9]Jan 9 10:45:46.834: ISDN Se1/0/0:15 SC: TX -> CONNECT pd = 8 callref = 0xB5C3Previous 0.020s, Duration 0.028s
# 3[ 10]Jan 9 10:45:46.834: Channel ID i = 0xE188838B
# 3[ 11]Jan 9 10:45:46.838: ISDN Se1/0/0:15 SC: RX <- CONNECT_ACK pd = 8 callref = 0x35C3Previous 0.004s, Duration 0.032s
# 3[ 12]Jan 9 10:45:47.090: ISDN Se1/0/0:15 SC: RX <- DISCONNECT pd = 8 callref = 0x35C3Previous 0.252s, Duration 0.284s
# 3[ 13]Jan 9 10:45:47.090: Cause i = 0x8090 - Normal call clearing
# 3[ 14]Jan 9 10:45:47.094: ISDN Se1/0/0:15 SC: TX -> RELEASE pd = 8 callref = 0xB5C3Previous 0.004s, Duration 0.288s
# 3[ 15]Jan 9 10:45:47.094: ISDN Se1/0/0:15 SC: RX <- RELEASE_COMP pd = 8 callref = 0x35C3Previous 0.000s, Duration 0.288s



# 4[ 1]Jan 9 10:45:47.590: ISDN Se1/3/11:15 SC: RX <- SETUP pd = 8 callref = 0x3AD3
# 4[ 2]Jan 9 10:45:47.594: Bearer Capability i = 0x8890
# 4[ 3]Jan 9 10:45:47.594: Channel ID i = 0xE9A6839F
# 4[ 4]Jan 9 10:45:47.594: Calling Party Number i = 0x2183, '678946450', Plan:ISDN, Type:National
# 4[ 5]Jan 9 10:45:47.594: Called Party Number i = 0xA1, '674501100', Plan:ISDN, Type:National
# 4[ 6]Jan 9 10:45:47.594: Low Layer Compat i = 0x8890214840BB
# 4[ 7]Jan 9 10:45:47.598: ISDN Se1/3/11:15 SC: TX -> CALL_PROC pd = 8 callref = 0xBAD3Previous 0.008s, Duration 0.008s
# 4[ 8]Jan 9 10:45:47.598: Channel ID i = 0xE1A6839F
# 4[ 9]Jan 9 10:45:47.614: ISDN Se1/3/11:15 SC: TX -> CONNECT pd = 8 callref = 0xBAD3Previous 0.016s, Duration 0.024s
# 4[ 10]Jan 9 10:45:47.614: Channel ID i = 0xE1A6839F
# 4[ 11]Jan 9 10:45:47.638: ISDN Se1/3/11:15 SC: RX <- CONNECT_ACK pd = 8 callref = 0x3AD3Previous 0.024s, Duration 0.048s
# 4[ 11]Jan 9 10:45:51.918: [Warning]Still active Se1/3/11:15 0x3AD3



# 5[ 1]Jan 9 10:45:47.858: ISDN Se1/0/0:15 SC: RX <- SETUP pd = 8 callref = 0x35C4
# 5[ 2]Jan 9 10:45:47.858: Bearer Capability i = 0x8890
# 5[ 3]Jan 9 10:45:47.858: Channel ID i = 0xE9888397
# 5[ 4]Jan 9 10:45:47.858: Calling Party Number i = 0x2183, '683170576', Plan:ISDN, Type:National
# 5[ 5]Jan 9 10:45:47.858: Called Party Number i = 0xA1, '674501100', Plan:ISDN, Type:National
# 5[ 6]Jan 9 10:45:47.858: Low Layer Compat i = 0x8890214846BB
# 5[ 7]Jan 9 10:45:47.862: ISDN Se1/0/0:15 SC: TX -> CALL_PROC pd = 8 callref = 0xB5C4Previous 0.004s, Duration 0.004s
# 5[ 8]Jan 9 10:45:47.862: Channel ID i = 0xE1888397
# 5[ 9]Jan 9 10:45:47.886: ISDN Se1/0/0:15 SC: TX -> CONNECT pd = 8 callref = 0xB5C4Previous 0.024s, Duration 0.028s
# 5[ 10]Jan 9 10:45:47.886: Channel ID i = 0xE1888397
# 5[ 11]Jan 9 10:45:47.886: ISDN Se1/0/0:15 SC: RX <- CONNECT_ACK pd = 8 callref = 0x35C4Previous 0.000s, Duration 0.028s
# 5[ 11]Jan 9 10:45:51.918: [Warning]Still active Se1/0/0:15 0x35C4



# 6[ 1]Jan 9 10:45:48.890: ISDN Se1/3/11:15 SC: RX <- SETUP pd = 8 callref = 0x3AD4
# 6[ 2]Jan 9 10:45:48.890: Bearer Capability i = 0x8890
# 6[ 3]Jan 9 10:45:48.890: Channel ID i = 0xE994839F
# 6[ 4]Jan 9 10:45:48.890: Calling Party Number i = 0x2183, '632428936', Plan:ISDN, Type:National
# 6[ 5]Jan 9 10:45:48.890: Called Party Number i = 0xA1, '674501100', Plan:ISDN, Type:National
# 6[ 6]Jan 9 10:45:48.890: Low Layer Compat i = 0x8890214846BB
# 6[ 7]Jan 9 10:45:48.898: ISDN Se1/3/11:15 SC: TX -> CALL_PROC pd = 8 callref = 0xBAD4Previous 0.008s, Duration 0.008s
# 6[ 8]Jan 9 10:45:48.898: Channel ID i = 0xE194839F
# 6[ 9]Jan 9 10:45:49.162: ISDN Se1/3/11:15 SC: TX -> CONNECT pd = 8 callref = 0xBAD4Previous 0.264s, Duration 0.272s
# 6[ 10]Jan 9 10:45:49.162: Channel ID i = 0xE194839F
# 6[ 11]Jan 9 10:45:49.338: ISDN Se1/3/11:15 SC: RX <- CONNECT_ACK pd = 8 callref = 0x3AD4Previous 0.176s, Duration 0.448s
# 6[ 11]Jan 9 10:45:51.918: [Warning]Still active Se1/3/11:15 0x3AD4



# 7[ 1]Jan 9 10:45:49.906: ISDN Se1/3/11:15 SC: RX <- SETUP pd = 8 callref = 0x3AD5
# 7[ 2]Jan 9 10:45:49.906: Bearer Capability i = 0x8890
# 7[ 3]Jan 9 10:45:49.906: Channel ID i = 0xE9A7839D
# 7[ 4]Jan 9 10:45:49.906: Calling Party Number i = 0x2183, '689384379', Plan:ISDN, Type:National
# 7[ 5]Jan 9 10:45:49.906: Called Party Number i = 0xA1, '674501100', Plan:ISDN, Type:National
# 7[ 6]Jan 9 10:45:49.906: Low Layer Compat i = 0x8890214846BB
# 7[ 7]Jan 9 10:45:49.914: ISDN Se1/3/11:15 SC: TX -> CALL_PROC pd = 8 callref = 0xBAD5Previous 0.008s, Duration 0.008s
# 7[ 8]Jan 9 10:45:49.914: Channel ID i = 0xE1A7839D
# 7[ 9]Jan 9 10:45:49.938: ISDN Se1/3/11:15 SC: TX -> CONNECT pd = 8 callref = 0xBAD5Previous 0.024s, Duration 0.032s
# 7[ 10]Jan 9 10:45:49.938: Channel ID i = 0xE1A7839D
# 7[ 11]Jan 9 10:45:49.950: ISDN Se1/3/11:15 SC: RX <- CONNECT_ACK pd = 8 callref = 0x3AD5Previous 0.012s, Duration 0.044s
# 7[ 11]Jan 9 10:45:51.918: [Warning]Still active Se1/3/11:15 0x3AD5



# 8[ 1]Jan 9 10:45:50.698: ISDN Se1/0/0:15 SC: RX <- SETUP pd = 8 callref = 0x35C5
# 8[ 2]Jan 9 10:45:50.698: Bearer Capability i = 0x8890
# 8[ 3]Jan 9 10:45:50.698: Channel ID i = 0xE99C839C
# 8[ 4]Jan 9 10:45:50.698: Calling Party Number i = 0x2183, '630611716', Plan:ISDN, Type:National
# 8[ 5]Jan 9 10:45:50.698: Called Party Number i = 0xA1, '674501100', Plan:ISDN, Type:National
# 8[ 6]Jan 9 10:45:50.698: Low Layer Compat i = 0x8890214846BB
# 8[ 7]Jan 9 10:45:50.706: ISDN Se1/0/0:15 SC: TX -> CALL_PROC pd = 8 callref = 0xB5C5Previous 0.008s, Duration 0.008s
# 8[ 8]Jan 9 10:45:50.706: Channel ID i = 0xE19C839C
# 8[ 9]Jan 9 10:45:50.730: ISDN Se1/0/0:15 SC: TX -> CONNECT pd = 8 callref = 0xB5C5Previous 0.024s, Duration 0.032s
# 8[ 10]Jan 9 10:45:50.730: Channel ID i = 0xE19C839C
# 8[ 11]Jan 9 10:45:50.734: ISDN Se1/0/0:15 SC: RX <- CONNECT_ACK pd = 8 callref = 0x35C5Previous 0.004s, Duration 0.036s
# 8[ 11]Jan 9 10:45:51.918: [Warning]Still active Se1/0/0:15 0x35C5