[
https://issues.apache.org/jira/browse/QPID-7295?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel
]
Keith Wall updated QPID-7295:
-----------------------------
Description:
Running Hello against the Java Broker, I notice that the Java Broker sends
duplicate {{SessionCompleted}} commands containing the same range-set. The
Java Client seems to ignore the duplicate, but bandwidth is wasted all the same.
Extract from the Broker log whilst running Hello. Notice two
SessionCompleted(0,14) at the end of the log.
{noformat}
2016-06-07 18:33:29,864 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Connection) -
RECV: [conn:63046a90] ch=0 SessionCompleted(commands=[0, 2])
2016-06-07 18:33:29,864 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Session) -
ssn:"ac0415af-bd52-44ea-9d8a-3501f3636bd8" complete(0, 2)
2016-06-07 18:33:29,864 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Session) -
ssn:"ac0415af-bd52-44ea-9d8a-3501f3636bd8" commands remaining: 1
2016-06-07 18:33:29,865 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Connection) -
RECV: [conn:63046a90] ch=0 MessageAccept(transfers=[2, 2])
2016-06-07 18:33:29,865 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Session) -
identify: ch=0, commandId=13
2016-06-07 18:33:29,867 DEBUG [IO-/127.0.0.1:58682]
(o.a.q.s.s.d.DerbyMessageStore) - REMOVE called on message: 2
2016-06-07 18:33:29,867 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Session) -
ssn:"ac0415af-bd52-44ea-9d8a-3501f3636bd8" ch=0 processed([13,13]) 12 12
2016-06-07 18:33:29,867 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Session) -
ssn:"ac0415af-bd52-44ea-9d8a-3501f3636bd8" processed: {[0,
12]}
2016-06-07 18:33:29,868 DEBUG [IO-/127.0.0.1:58682]
(o.a.q.s.t.NonBlockingConnection) - Read 18 byte(s)
2016-06-07 18:33:29,868 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Connection) -
RECV: [conn:63046a90] ch=0 [S] ExecutionSync()
2016-06-07 18:33:29,868 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Session) -
identify: ch=0, commandId=14
2016-06-07 18:33:29,868 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Session) -
ssn:"ac0415af-bd52-44ea-9d8a-3501f3636bd8" synced to 14
2016-06-07 18:33:29,868 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Session) -
ssn:"ac0415af-bd52-44ea-9d8a-3501f3636bd8" ch=0 processed([14,14]) 14 13
2016-06-07 18:33:29,868 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Session) -
ssn:"ac0415af-bd52-44ea-9d8a-3501f3636bd8" processed: {[0,
13]}
2016-06-07 18:33:29,868 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Connection) -
SEND: [conn:63046a90] ch=0 SessionCompleted(commands={[0,
14]})
2016-06-07 18:33:29,868 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Connection) -
FLUSH: [conn:63046a90]
2016-06-07 18:33:29,868 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Connection) -
SEND: [conn:63046a90] ch=0 SessionCompleted(commands={[0,
14]})
2016-06-07 18:33:29,868 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Connection) -
FLUSH: [conn:63046a90]
2016-06-07 18:33:29,868 DEBUG [IO-/127.0.0.1:58682]
(o.a.q.s.t.NonBlockingConnection) - Written 52 bytes
2016-06-07 18:33:29,869 DEBUG [IO-/127.0.0.1:58682]
(o.a.q.s.t.NonBlockingConnection) - Read 0 byte(s)
2016-06-07 18:33:29,871 DEBUG [IO-/127.0.0.1:58682]
(o.a.q.s.t.NonBlockingConnection) - Read 74 byte(s)
2016-06-07 18:33:29,871 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Connection) -
RECV: [conn:63046a90] ch=0 SessionRequestTimeout(timeout=0)
2016-06-07 18:33:29,871 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Connection) -
SEND: [conn:63046a90] ch=0 SessionTimeout(timeout=0)
{noformat}
was:
Running Hello against the Java Broker, I notice that the Java Broker sends
duplicate {{SessionCompleted}} commands containing the same range-set. The
Java Client seems to ignore the duplicate, but bandwidth is wasted all the same.
Extract from the Broker log whilst running Hello. Notice two
SessionCompleted(commands={[0, 14]}).
{noformat}
2016-06-07 18:33:29,864 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Connection) -
RECV: [conn:63046a90] ch=0 SessionCompleted(commands=[0, 2])
2016-06-07 18:33:29,864 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Session) -
ssn:"ac0415af-bd52-44ea-9d8a-3501f3636bd8" complete(0, 2)
2016-06-07 18:33:29,864 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Session) -
ssn:"ac0415af-bd52-44ea-9d8a-3501f3636bd8" commands remaining: 1
2016-06-07 18:33:29,865 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Connection) -
RECV: [conn:63046a90] ch=0 MessageAccept(transfers=[2, 2])
2016-06-07 18:33:29,865 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Session) -
identify: ch=0, commandId=13
2016-06-07 18:33:29,867 DEBUG [IO-/127.0.0.1:58682]
(o.a.q.s.s.d.DerbyMessageStore) - REMOVE called on message: 2
2016-06-07 18:33:29,867 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Session) -
ssn:"ac0415af-bd52-44ea-9d8a-3501f3636bd8" ch=0 processed([13,13]) 12 12
2016-06-07 18:33:29,867 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Session) -
ssn:"ac0415af-bd52-44ea-9d8a-3501f3636bd8" processed: {[0, 12]}
2016-06-07 18:33:29,868 DEBUG [IO-/127.0.0.1:58682]
(o.a.q.s.t.NonBlockingConnection) - Read 18 byte(s)
2016-06-07 18:33:29,868 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Connection) -
RECV: [conn:63046a90] ch=0 [S] ExecutionSync()
2016-06-07 18:33:29,868 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Session) -
identify: ch=0, commandId=14
2016-06-07 18:33:29,868 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Session) -
ssn:"ac0415af-bd52-44ea-9d8a-3501f3636bd8" synced to 14
2016-06-07 18:33:29,868 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Session) -
ssn:"ac0415af-bd52-44ea-9d8a-3501f3636bd8" ch=0 processed([14,14]) 14 13
2016-06-07 18:33:29,868 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Session) -
ssn:"ac0415af-bd52-44ea-9d8a-3501f3636bd8" processed: {[0, 13]}
2016-06-07 18:33:29,868 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Connection) -
SEND: [conn:63046a90] ch=0 SessionCompleted(commands={[0, 14]})
2016-06-07 18:33:29,868 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Connection) -
FLUSH: [conn:63046a90]
2016-06-07 18:33:29,868 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Connection) -
SEND: [conn:63046a90] ch=0 SessionCompleted(commands={[0, 14]})
2016-06-07 18:33:29,868 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Connection) -
FLUSH: [conn:63046a90]
2016-06-07 18:33:29,868 DEBUG [IO-/127.0.0.1:58682]
(o.a.q.s.t.NonBlockingConnection) - Written 52 bytes
2016-06-07 18:33:29,869 DEBUG [IO-/127.0.0.1:58682]
(o.a.q.s.t.NonBlockingConnection) - Read 0 byte(s)
2016-06-07 18:33:29,871 DEBUG [IO-/127.0.0.1:58682]
(o.a.q.s.t.NonBlockingConnection) - Read 74 byte(s)
2016-06-07 18:33:29,871 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Connection) -
RECV: [conn:63046a90] ch=0 SessionRequestTimeout(timeout=0)
2016-06-07 18:33:29,871 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Connection) -
SEND: [conn:63046a90] ch=0 SessionTimeout(timeout=0)
{noformat}
> [Java Broker] [0-10] duplicate SessionCompleted commands sent to client peer
> ----------------------------------------------------------------------------
>
> Key: QPID-7295
> URL: https://issues.apache.org/jira/browse/QPID-7295
> Project: Qpid
> Issue Type: Bug
> Components: Java Broker
> Affects Versions: qpid-java-6.1
> Reporter: Keith Wall
> Priority: Minor
>
> Running Hello against the Java Broker, I notice that the Java Broker sends
> duplicate {{SessionCompleted}} commands containing the same range-set. The
> Java Client seems to ignore the duplicate, but bandwidth is wasted all the
> same.
> Extract from the Broker log whilst running Hello. Notice two
> SessionCompleted(0,14) at the end of the log.
> {noformat}
> 2016-06-07 18:33:29,864 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Connection) -
> RECV: [conn:63046a90] ch=0 SessionCompleted(commands=[0, 2])
> 2016-06-07 18:33:29,864 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Session) -
> ssn:"ac0415af-bd52-44ea-9d8a-3501f3636bd8" complete(0, 2)
> 2016-06-07 18:33:29,864 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Session) -
> ssn:"ac0415af-bd52-44ea-9d8a-3501f3636bd8" commands remaining: 1
> 2016-06-07 18:33:29,865 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Connection) -
> RECV: [conn:63046a90] ch=0 MessageAccept(transfers=[2, 2])
> 2016-06-07 18:33:29,865 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Session) -
> identify: ch=0, commandId=13
> 2016-06-07 18:33:29,867 DEBUG [IO-/127.0.0.1:58682]
> (o.a.q.s.s.d.DerbyMessageStore) - REMOVE called on message: 2
> 2016-06-07 18:33:29,867 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Session) -
> ssn:"ac0415af-bd52-44ea-9d8a-3501f3636bd8" ch=0 processed([13,13]) 12 12
> 2016-06-07 18:33:29,867 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Session) -
> ssn:"ac0415af-bd52-44ea-9d8a-3501f3636bd8" processed: {[0,
> 12]}
> 2016-06-07 18:33:29,868 DEBUG [IO-/127.0.0.1:58682]
> (o.a.q.s.t.NonBlockingConnection) - Read 18 byte(s)
> 2016-06-07 18:33:29,868 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Connection) -
> RECV: [conn:63046a90] ch=0 [S] ExecutionSync()
> 2016-06-07 18:33:29,868 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Session) -
> identify: ch=0, commandId=14
> 2016-06-07 18:33:29,868 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Session) -
> ssn:"ac0415af-bd52-44ea-9d8a-3501f3636bd8" synced to 14
> 2016-06-07 18:33:29,868 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Session) -
> ssn:"ac0415af-bd52-44ea-9d8a-3501f3636bd8" ch=0 processed([14,14]) 14 13
> 2016-06-07 18:33:29,868 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Session) -
> ssn:"ac0415af-bd52-44ea-9d8a-3501f3636bd8" processed: {[0,
> 13]}
> 2016-06-07 18:33:29,868 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Connection) -
> SEND: [conn:63046a90] ch=0 SessionCompleted(commands={[0,
> 14]})
> 2016-06-07 18:33:29,868 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Connection) -
> FLUSH: [conn:63046a90]
> 2016-06-07 18:33:29,868 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Connection) -
> SEND: [conn:63046a90] ch=0 SessionCompleted(commands={[0,
> 14]})
> 2016-06-07 18:33:29,868 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Connection) -
> FLUSH: [conn:63046a90]
> 2016-06-07 18:33:29,868 DEBUG [IO-/127.0.0.1:58682]
> (o.a.q.s.t.NonBlockingConnection) - Written 52 bytes
> 2016-06-07 18:33:29,869 DEBUG [IO-/127.0.0.1:58682]
> (o.a.q.s.t.NonBlockingConnection) - Read 0 byte(s)
> 2016-06-07 18:33:29,871 DEBUG [IO-/127.0.0.1:58682]
> (o.a.q.s.t.NonBlockingConnection) - Read 74 byte(s)
> 2016-06-07 18:33:29,871 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Connection) -
> RECV: [conn:63046a90] ch=0 SessionRequestTimeout(timeout=0)
> 2016-06-07 18:33:29,871 DEBUG [IO-/127.0.0.1:58682] (o.a.q.t.Connection) -
> SEND: [conn:63046a90] ch=0 SessionTimeout(timeout=0)
> {noformat}
--
This message was sent by Atlassian JIRA
(v6.3.4#6332)
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
