-
Bug
-
Resolution: Done
-
Major
-
1.0
-
None
This is an example of the visible output after sending 1 message to the router
Tue Aug 23 18:59:43 2016 AGENT (debug) Add entity: LogEntity(enable=trace,debug+, identity=log/DEFAULT, module=DEFAULT, name=log/DEFAULT, output=stderr, source=False, timestamp=True, type=org.apache.qpid.dispatch.log) Tue Aug 23 18:59:43 2016 AGENT (debug) Add entity: LogEntity(enable=default, identity=log/ROUTER_LS, module=ROUTER_LS, name=log/ROUTER_LS, type=org.apache.qpid.dispatch.log) Tue Aug 23 18:59:43 2016 AGENT (debug) Add entity: LogEntity(enable=default, identity=log/ROUTER_MA, module=ROUTER_MA, name=log/ROUTER_MA, type=org.apache.qpid.dispatch.log) Tue Aug 23 18:59:43 2016 AGENT (debug) Add entity: LogEntity(enable=default, identity=log/DISPATCH, module=DISPATCH, name=log/DISPATCH, type=org.apache.qpid.dispatch.log) Tue Aug 23 18:59:43 2016 AGENT (debug) Add entity: LogEntity(enable=default, identity=log/ROUTER_HELLO, module=ROUTER_HELLO, name=log/ROUTER_HELLO, type=org.apache.qpid.dispatch.log) Tue Aug 23 18:59:43 2016 AGENT (debug) Add entity: LogEntity(enable=default, identity=log/SERVER, module=SERVER, name=log/SERVER, type=org.apache.qpid.dispatch.log) Tue Aug 23 18:59:43 2016 AGENT (debug) Add entity: LogEntity(enable=default, identity=log/POLICY, module=POLICY, name=log/POLICY, type=org.apache.qpid.dispatch.log) Tue Aug 23 18:59:43 2016 AGENT (debug) Add entity: LogEntity(enable=default, identity=log/CONTAINER, module=CONTAINER, name=log/CONTAINER, type=org.apache.qpid.dispatch.log) Tue Aug 23 18:59:43 2016 AGENT (debug) Add entity: LogEntity(enable=default, identity=log/AGENT, module=AGENT, name=log/AGENT, type=org.apache.qpid.dispatch.log) Tue Aug 23 18:59:43 2016 AGENT (debug) Add entity: LogEntity(enable=default, identity=log/ERROR, module=ERROR, name=log/ERROR, type=org.apache.qpid.dispatch.log) Tue Aug 23 18:59:43 2016 AGENT (debug) Add entity: LogEntity(enable=default, identity=log/ROUTER_CORE, module=ROUTER_CORE, name=log/ROUTER_CORE, type=org.apache.qpid.dispatch.log) Tue Aug 23 18:59:43 2016 AGENT (debug) Add entity: LogEntity(enable=default, identity=log/ROUTER, module=ROUTER, name=log/ROUTER, type=org.apache.qpid.dispatch.log) Tue Aug 23 18:59:43 2016 AGENT (debug) Add entity: LogEntity(enable=default, identity=log/MESSAGE, module=MESSAGE, name=log/MESSAGE, type=org.apache.qpid.dispatch.log) Tue Aug 23 18:59:43 2016 AGENT (debug) Add entity: LogEntity(enable=default, identity=log/CONFIG, module=CONFIG, name=log/CONFIG, type=org.apache.qpid.dispatch.log) Tue Aug 23 18:59:43 2016 AGENT (debug) Add entity: ContainerEntity(containerName=00000000-0000-0000-0000-000000000000, identity=container/00000000-0000-0000-0000-000000000000, name=container/00000000-0000-0000-0000-000000000000, type=org.apache.qpid.dispatch.container, workerThreads=4) Tue Aug 23 18:59:43 2016 AGENT (debug) Add entity: RouterEntity(area=0, helloInterval=1, helloMaxAge=3, id=Router.A, mobileAddrMaxAge=60, mode=standalone, raInterval=30, raIntervalFlux=4, remoteLsMaxAge=60, saslConfigName=qdrouterd, type=org.apache.qpid.dispatch.router, workerThreads=4) Tue Aug 23 18:59:43 2016 SERVER (info) Container Name: Router.A Tue Aug 23 18:59:43 2016 CONTAINER (trace) Container Initialized Tue Aug 23 18:59:43 2016 CONTAINER (trace) Node Type Registered - router Tue Aug 23 18:59:43 2016 CONTAINER (trace) Node of type 'router' installed as default node Tue Aug 23 18:59:43 2016 ROUTER (info) Router started in Standalone mode Tue Aug 23 18:59:43 2016 POLICY (trace) Policy Initialized Tue Aug 23 18:59:43 2016 ROUTER_CORE (info) Router Core thread running. 0/Router.A Tue Aug 23 18:59:43 2016 ROUTER_CORE (trace) Core action 'subscribe' Tue Aug 23 18:59:43 2016 ROUTER_CORE (info) In-process subscription M/$management Tue Aug 23 18:59:43 2016 AGENT (debug) Add entity: AllocatorEntity(batchesRebalancedToGlobal=0, batchesRebalancedToThreads=0, globalFreeListMax=0, heldByThreads=32, localFreeListMax=32, totalAllocFromHeap=32, totalFreeToHeap=0, transferBatchSize=16, type=org.apache.qpid.dispatch.allocator, typeName=qd_log_entry_t, typeSize=2076) Tue Aug 23 18:59:43 2016 AGENT (debug) Add entity: AllocatorEntity(batchesRebalancedToGlobal=0, batchesRebalancedToThreads=0, globalFreeListMax=0, heldByThreads=64, localFreeListMax=128, totalAllocFromHeap=64, totalFreeToHeap=0, transferBatchSize=64, type=org.apache.qpid.dispatch.allocator, typeName=qd_field_iterator_t, typeSize=68) Tue Aug 23 18:59:43 2016 AGENT (debug) Add entity: AllocatorEntity(batchesRebalancedToGlobal=0, batchesRebalancedToThreads=0, globalFreeListMax=0, heldByThreads=64, localFreeListMax=128, totalAllocFromHeap=64, totalFreeToHeap=0, transferBatchSize=64, type=org.apache.qpid.dispatch.allocator, typeName=qd_hash_item_t, typeSize=16) Tue Aug 23 18:59:43 2016 AGENT (debug) Add entity: AllocatorEntity(batchesRebalancedToGlobal=0, batchesRebalancedToThreads=0, globalFreeListMax=0, heldByThreads=64, localFreeListMax=128, totalAllocFromHeap=64, totalFreeToHeap=0, transferBatchSize=64, type=org.apache.qpid.dispatch.allocator, typeName=qd_node_t, typeSize=32) Tue Aug 23 18:59:43 2016 AGENT (debug) Add entity: AllocatorEntity(batchesRebalancedToGlobal=0, batchesRebalancedToThreads=0, globalFreeListMax=0, heldByThreads=128, localFreeListMax=128, totalAllocFromHeap=128, totalFreeToHeap=0, transferBatchSize=64, type=org.apache.qpid.dispatch.allocator, typeName=qd_timer_t, typeSize=32) Tue Aug 23 18:59:43 2016 AGENT (debug) Add entity: AllocatorEntity(batchesRebalancedToGlobal=0, batchesRebalancedToThreads=0, globalFreeListMax=0, heldByThreads=64, localFreeListMax=128, totalAllocFromHeap=64, totalFreeToHeap=0, transferBatchSize=64, type=org.apache.qpid.dispatch.allocator, typeName=qdr_action_t, typeSize=104) Tue Aug 23 18:59:43 2016 AGENT (debug) Add entity: AllocatorEntity(batchesRebalancedToGlobal=0, batchesRebalancedToThreads=0, globalFreeListMax=0, heldByThreads=64, localFreeListMax=128, totalAllocFromHeap=64, totalFreeToHeap=0, transferBatchSize=64, type=org.apache.qpid.dispatch.allocator, typeName=qdr_field_t, typeSize=20) Tue Aug 23 18:59:43 2016 AGENT (debug) Add entity: AllocatorEntity(batchesRebalancedToGlobal=0, batchesRebalancedToThreads=0, globalFreeListMax=0, heldByThreads=16, localFreeListMax=32, totalAllocFromHeap=16, totalFreeToHeap=0, transferBatchSize=16, type=org.apache.qpid.dispatch.allocator, typeName=qd_buffer_t, typeSize=524) Tue Aug 23 18:59:43 2016 AGENT (info) Activating management agent on $_management_internal Tue Aug 23 18:59:43 2016 ROUTER_CORE (trace) Core action 'subscribe' Tue Aug 23 18:59:43 2016 ROUTER_CORE (info) In-process subscription L/$management Tue Aug 23 18:59:43 2016 ROUTER_CORE (trace) Core action 'subscribe' Tue Aug 23 18:59:43 2016 ROUTER_CORE (info) In-process subscription L/$_management_internal Tue Aug 23 18:59:43 2016 DISPLAYNAME (info) Activating DisplayNameService on $displayname Tue Aug 23 18:59:43 2016 ROUTER_CORE (trace) Core action 'subscribe' Tue Aug 23 18:59:43 2016 ROUTER_CORE (info) In-process subscription L/$displayname Tue Aug 23 18:59:43 2016 CONN_MGR (info) Configured Listener: 0.0.0.0:amqp proto=any role=normal Tue Aug 23 18:59:43 2016 SERVER (trace) Listening on 0.0.0.0:amqp Tue Aug 23 18:59:43 2016 AGENT (debug) Add entity: ListenerEntity(addr=127.0.0.1, authenticatePeer=False, cost=1, host=0.0.0.0, identity=listener/0.0.0.0:amqp, idleTimeoutSeconds=16, maxFrameSize=16384, port=amqp, requireEncryption=False, requireSsl=False, role=normal, stripAnnotations=both, type=org.apache.qpid.dispatch.listener) Tue Aug 23 18:59:43 2016 CONN_MGR (info) Configured Connector: 10.34.37.159:amqp proto=any role=route-container Tue Aug 23 18:59:43 2016 AGENT (debug) Add entity: ConnectorEntity(addr=127.0.0.1, allowRedirect=True, cost=1, host=10.34.37.159, identity=connector/10.34.37.159:amqp:broker, idleTimeoutSeconds=16, maxFrameSize=65536, name=broker, port=amqp, role=route-container, stripAnnotations=both, type=org.apache.qpid.dispatch.connector, verifyHostName=True) Tue Aug 23 18:59:43 2016 ROUTER_CORE (trace) Core action 'manage_create' Tue Aug 23 18:59:43 2016 AGENT (debug) Add entity: AddressEntity(distribution=closest, identity=address/0, name=address/0, prefix=closest, type=org.apache.qpid.dispatch.router.config.address, waypoint=False) Tue Aug 23 18:59:43 2016 ROUTER_CORE (trace) Core action 'manage_create' Tue Aug 23 18:59:43 2016 AGENT (debug) Add entity: AddressEntity(distribution=multicast, identity=address/1, name=address/1, prefix=multicast, type=org.apache.qpid.dispatch.router.config.address, waypoint=False) Tue Aug 23 18:59:43 2016 ROUTER_CORE (trace) Core action 'manage_create' Tue Aug 23 18:59:43 2016 AGENT (debug) Add entity: AddressEntity(distribution=closest, identity=address/2, name=address/2, prefix=unicast, type=org.apache.qpid.dispatch.router.config.address, waypoint=False) Tue Aug 23 18:59:43 2016 ROUTER_CORE (trace) Core action 'manage_create' Tue Aug 23 18:59:43 2016 AGENT (debug) Add entity: AddressEntity(distribution=closest, identity=address/3, name=address/3, prefix=exclusive, type=org.apache.qpid.dispatch.router.config.address, waypoint=False) Tue Aug 23 18:59:43 2016 ROUTER_CORE (trace) Core action 'manage_create' Tue Aug 23 18:59:43 2016 AGENT (debug) Add entity: AddressEntity(distribution=multicast, identity=address/4, name=address/4, prefix=broadcast, type=org.apache.qpid.dispatch.router.config.address, waypoint=False) Tue Aug 23 18:59:43 2016 ROUTER_CORE (trace) Core action 'manage_create' Tue Aug 23 18:59:43 2016 AGENT (debug) Add entity: LinkRouteEntity(connection=broker, dir=in, distribution=linkBalanced, identity=linkRoute/0, name=linkRoute/0, prefix=jms, type=org.apache.qpid.dispatch.router.config.linkRoute) Tue Aug 23 18:59:43 2016 ROUTER_CORE (trace) Core action 'manage_create' Tue Aug 23 18:59:43 2016 AGENT (debug) Add entity: LinkRouteEntity(connection=broker, dir=out, distribution=linkBalanced, identity=linkRoute/1, name=linkRoute/1, prefix=jms, type=org.apache.qpid.dispatch.router.config.linkRoute) Tue Aug 23 18:59:43 2016 POLICY (info) Policy configured maximumConnections: 0, policyFolder: '', access rules enabled: 'false' Tue Aug 23 18:59:43 2016 AGENT (debug) Add entity: Entity(defaultApplication=, defaultApplicationEnabled=False, enableAccessRules=False, maximumConnections=0, policyFolder=, type=org.apache.qpid.dispatch.policy) Tue Aug 23 18:59:43 2016 AGENT (debug) Add entity: ConsoleEntity(identity=console/0, name=console/0, type=org.apache.qpid.dispatch.console, wsport=5673) Tue Aug 23 18:59:43 2016 POLICY (info) Policy fallback defaultApplication is disabled Tue Aug 23 18:59:43 2016 SERVER (trace) Connecting to 10.34.37.159:amqp Tue Aug 23 18:59:43 2016 SERVER (info) Operational, 4 Threads Running Tue Aug 23 18:59:43 2016 SERVER (trace) [1]:(null) Tue Aug 23 18:59:43 2016 SERVER (trace) [1]:(null) Tue Aug 23 18:59:43 2016 SERVER (trace) [1]:(null) Tue Aug 23 18:59:43 2016 SERVER (trace) [1]:(null) Tue Aug 23 18:59:43 2016 SERVER (trace) [1]:(null) Tue Aug 23 18:59:43 2016 SERVER (trace) [1]:(null) Tue Aug 23 18:59:43 2016 SERVER (trace) [1]:(null) Tue Aug 23 18:59:43 2016 SERVER (trace) [1]:(null) Tue Aug 23 18:59:43 2016 SERVER (trace) [1]:(null) Tue Aug 23 18:59:43 2016 SERVER (trace) [1]:(null) Tue Aug 23 18:59:43 2016 SERVER (trace) [1]:(null) Tue Aug 23 18:59:43 2016 ROUTER_CORE (trace) Core action 'connection_opened' Tue Aug 23 18:59:43 2016 ROUTER_CORE (info) Link Route Activated '6' on connection broker Tue Aug 23 18:59:43 2016 ROUTER_CORE (info) Link Route Activated '7' on connection broker Tue Aug 23 18:59:51 2016 SERVER (trace) [1]:(null) Tue Aug 23 18:59:54 2016 SERVER (debug) Accepting incoming connection from dhcp-37-176.lab.eng.brq.redhat.com:35374 to 0.0.0.0:amqp Tue Aug 23 18:59:54 2016 SERVER (trace) [2]:(null) Tue Aug 23 18:59:54 2016 SERVER (trace) [2]:(null) Tue Aug 23 18:59:54 2016 SERVER (trace) [2]:(null) Tue Aug 23 18:59:54 2016 SERVER (trace) [2]:(null) Tue Aug 23 18:59:54 2016 SERVER (trace) [2]:(null) Tue Aug 23 18:59:54 2016 SERVER (trace) [2]:(null) Tue Aug 23 18:59:54 2016 SERVER (trace) [2]:(null) Tue Aug 23 18:59:54 2016 SERVER (trace) [2]:(null) Tue Aug 23 18:59:54 2016 SERVER (trace) [2]:(null) Tue Aug 23 18:59:54 2016 SERVER (trace) [2]:(null) Tue Aug 23 18:59:54 2016 SERVER (trace) [2]:(null) Tue Aug 23 18:59:54 2016 SERVER (trace) [2]:(null) Tue Aug 23 18:59:54 2016 SERVER (trace) [2]:(null) Tue Aug 23 18:59:54 2016 SERVER (trace) [2]:(null) Tue Aug 23 18:59:54 2016 SERVER (trace) [2]:(null) Tue Aug 23 18:59:54 2016 SERVER (trace) [2]:(null) Tue Aug 23 18:59:54 2016 SERVER (trace) [2]:(null) Tue Aug 23 18:59:54 2016 SERVER (trace) [2]:(null) Tue Aug 23 18:59:54 2016 SERVER (trace) [2]:(null) Tue Aug 23 18:59:54 2016 ROUTER_CORE (trace) Core action 'connection_opened' Tue Aug 23 18:59:54 2016 ROUTER_CORE (trace) Core action 'link_first_attach' Tue Aug 23 18:59:54 2016 SERVER (trace) [1]:(null) Tue Aug 23 18:59:54 2016 SERVER (trace) [1]:(null) Tue Aug 23 18:59:54 2016 SERVER (trace) [1]:(null) Tue Aug 23 18:59:54 2016 SERVER (trace) [1]:(null) Tue Aug 23 18:59:54 2016 SERVER (trace) [1]:(null) Tue Aug 23 18:59:54 2016 SERVER (trace) [1]:(null) Tue Aug 23 18:59:54 2016 SERVER (trace) [1]:(null) Tue Aug 23 18:59:54 2016 ROUTER_CORE (trace) Core action 'link_second_attach' Tue Aug 23 18:59:54 2016 ROUTER_CORE (trace) Core action 'link_flow' Tue Aug 23 18:59:54 2016 SERVER (trace) [2]:(null) Tue Aug 23 18:59:54 2016 SERVER (trace) [2]:(null) Tue Aug 23 18:59:54 2016 SERVER (trace) [2]:(null) Tue Aug 23 18:59:54 2016 SERVER (trace) [2]:(null) Tue Aug 23 18:59:54 2016 SERVER (trace) [2]:(null) Tue Aug 23 18:59:54 2016 MESSAGE (trace) Received Message{ body='\d1\00\00\00\10\00\00\00\02\a1\08seque'} on link bb9619c5-9f02-48b6-a22e-8ce19251cbf3-jms.queue.test.address.1.1 Tue Aug 23 18:59:54 2016 ROUTER_CORE (trace) Core action 'link_deliver' Tue Aug 23 18:59:54 2016 MESSAGE (trace) Sending Message{ body='\d1\00\00\00\10\00\00\00\02\a1\08seque'} on link bb9619c5-9f02-48b6-a22e-8ce19251cbf3-jms.queue.test.address.1.1 Tue Aug 23 18:59:54 2016 SERVER (trace) [1]:(null) Tue Aug 23 18:59:54 2016 SERVER (trace) [1]:(null) Tue Aug 23 18:59:54 2016 ROUTER_CORE (trace) Core action 'link_flow' Tue Aug 23 18:59:54 2016 SERVER (trace) [1]:(null) Tue Aug 23 18:59:54 2016 ROUTER_CORE (trace) Core action 'update_delivery' Tue Aug 23 18:59:54 2016 SERVER (trace) [2]:(null) Tue Aug 23 18:59:54 2016 SERVER (trace) [2]:(null) Tue Aug 23 18:59:54 2016 SERVER (trace) [2]:(null) Tue Aug 23 18:59:54 2016 SERVER (trace) [2]:(null) Tue Aug 23 18:59:54 2016 SERVER (trace) [2]:(null) Tue Aug 23 18:59:54 2016 SERVER (trace) [2]:(null) Tue Aug 23 18:59:54 2016 SERVER (trace) [2]:(null) Tue Aug 23 18:59:54 2016 ROUTER_CORE (trace) Core action 'link_detach' Tue Aug 23 18:59:54 2016 ROUTER_CORE (trace) Core action 'connection_closed' Tue Aug 23 18:59:54 2016 SERVER (trace) [1]:(null) Tue Aug 23 18:59:54 2016 SERVER (trace) [1]:(null) Tue Aug 23 18:59:54 2016 SERVER (trace) [1]:(null) Tue Aug 23 18:59:54 2016 SERVER (trace) [1]:(null) Tue Aug 23 18:59:54 2016 SERVER (trace) [1]:(null) Tue Aug 23 18:59:54 2016 ROUTER_CORE (trace) Core action 'link_detach' Tue Aug 23 18:59:54 2016 SERVER (trace) [1]:(null) Tue Aug 23 18:59:59 2016 SERVER (trace) [1]:(null) Tue Aug 23 19:00:03 2016 SERVER (trace) [1]:(null) Tue Aug 23 19:00:07 2016 SERVER (trace) [1]:(null)
Expected Output
Tue Aug 23 17:01:05 2016 AGENT (debug) Add entity: LogEntity(enable=trace,debug+, identity=log/DEFAULT, module=DEFAULT, name=log/DEFAULT, output=stderr, source=False, timestamp=True, type=org.apache.qpid.dispatch.log) Tue Aug 23 17:01:05 2016 AGENT (debug) Add entity: LogEntity(enable=default, identity=log/ROUTER_LS, module=ROUTER_LS, name=log/ROUTER_LS, type=org.apache.qpid.dispatch.log) Tue Aug 23 17:01:05 2016 AGENT (debug) Add entity: LogEntity(enable=default, identity=log/ROUTER_MA, module=ROUTER_MA, name=log/ROUTER_MA, type=org.apache.qpid.dispatch.log) Tue Aug 23 17:01:05 2016 AGENT (debug) Add entity: LogEntity(enable=default, identity=log/DISPATCH, module=DISPATCH, name=log/DISPATCH, type=org.apache.qpid.dispatch.log) Tue Aug 23 17:01:05 2016 AGENT (debug) Add entity: LogEntity(enable=default, identity=log/ROUTER_HELLO, module=ROUTER_HELLO, name=log/ROUTER_HELLO, type=org.apache.qpid.dispatch.log) Tue Aug 23 17:01:05 2016 AGENT (debug) Add entity: LogEntity(enable=default, identity=log/SERVER, module=SERVER, name=log/SERVER, type=org.apache.qpid.dispatch.log) Tue Aug 23 17:01:05 2016 AGENT (debug) Add entity: LogEntity(enable=default, identity=log/POLICY, module=POLICY, name=log/POLICY, type=org.apache.qpid.dispatch.log) Tue Aug 23 17:01:05 2016 AGENT (debug) Add entity: LogEntity(enable=default, identity=log/CONTAINER, module=CONTAINER, name=log/CONTAINER, type=org.apache.qpid.dispatch.log) Tue Aug 23 17:01:05 2016 AGENT (debug) Add entity: LogEntity(enable=default, identity=log/AGENT, module=AGENT, name=log/AGENT, type=org.apache.qpid.dispatch.log) Tue Aug 23 17:01:05 2016 AGENT (debug) Add entity: LogEntity(enable=default, identity=log/ERROR, module=ERROR, name=log/ERROR, type=org.apache.qpid.dispatch.log) Tue Aug 23 17:01:05 2016 AGENT (debug) Add entity: LogEntity(enable=default, identity=log/ROUTER_CORE, module=ROUTER_CORE, name=log/ROUTER_CORE, type=org.apache.qpid.dispatch.log) Tue Aug 23 17:01:05 2016 AGENT (debug) Add entity: LogEntity(enable=default, identity=log/ROUTER, module=ROUTER, name=log/ROUTER, type=org.apache.qpid.dispatch.log) Tue Aug 23 17:01:05 2016 AGENT (debug) Add entity: LogEntity(enable=default, identity=log/MESSAGE, module=MESSAGE, name=log/MESSAGE, type=org.apache.qpid.dispatch.log) Tue Aug 23 17:01:05 2016 AGENT (debug) Add entity: LogEntity(enable=default, identity=log/CONFIG, module=CONFIG, name=log/CONFIG, type=org.apache.qpid.dispatch.log) Tue Aug 23 17:01:05 2016 AGENT (debug) Add entity: ContainerEntity(containerName=00000000-0000-0000-0000-000000000000, identity=container/00000000-0000-0000-0000-000000000000, name=container/00000000-0000-0000-0000-000000000000, type=org.apache.qpid.dispatch.container, workerThreads=4) Tue Aug 23 17:01:05 2016 AGENT (debug) Add entity: RouterEntity(area=0, helloInterval=1, helloMaxAge=3, id=Router.A, mobileAddrMaxAge=60, mode=standalone, raInterval=30, raIntervalFlux=4, remoteLsMaxAge=60, saslConfigName=qdrouterd, type=org.apache.qpid.dispatch.router, workerThreads=4) Tue Aug 23 17:01:05 2016 SERVER (info) Container Name: Router.A Tue Aug 23 17:01:05 2016 CONTAINER (trace) Container Initialized Tue Aug 23 17:01:05 2016 CONTAINER (trace) Node Type Registered - router Tue Aug 23 17:01:05 2016 CONTAINER (trace) Node of type 'router' installed as default node Tue Aug 23 17:01:05 2016 ROUTER (info) Router started in Standalone mode Tue Aug 23 17:01:05 2016 POLICY (trace) Policy Initialized Tue Aug 23 17:01:05 2016 ROUTER_CORE (info) Router Core thread running. 0/Router.A Tue Aug 23 17:01:05 2016 ROUTER_CORE (trace) Core action 'subscribe' Tue Aug 23 17:01:05 2016 ROUTER_CORE (info) In-process subscription M/$management Tue Aug 23 17:01:05 2016 AGENT (debug) Add entity: AllocatorEntity(batchesRebalancedToGlobal=0, batchesRebalancedToThreads=0, globalFreeListMax=0, heldByThreads=32, localFreeListMax=32, totalAllocFromHeap=32, totalFreeToHeap=0, transferBatchSize=16, type=org.apache.qpid.dispatch.allocator, typeName=qd_log_entry_t, typeSize=2104) Tue Aug 23 17:01:05 2016 AGENT (debug) Add entity: AllocatorEntity(batchesRebalancedToGlobal=0, batchesRebalancedToThreads=0, globalFreeListMax=0, heldByThreads=64, localFreeListMax=128, totalAllocFromHeap=64, totalFreeToHeap=0, transferBatchSize=64, type=org.apache.qpid.dispatch.allocator, typeName=qd_field_iterator_t, typeSize=128) Tue Aug 23 17:01:05 2016 AGENT (debug) Add entity: AllocatorEntity(batchesRebalancedToGlobal=0, batchesRebalancedToThreads=0, globalFreeListMax=0, heldByThreads=64, localFreeListMax=128, totalAllocFromHeap=64, totalFreeToHeap=0, transferBatchSize=64, type=org.apache.qpid.dispatch.allocator, typeName=qd_hash_item_t, typeSize=32) Tue Aug 23 17:01:05 2016 AGENT (debug) Add entity: AllocatorEntity(batchesRebalancedToGlobal=0, batchesRebalancedToThreads=0, globalFreeListMax=0, heldByThreads=64, localFreeListMax=128, totalAllocFromHeap=64, totalFreeToHeap=0, transferBatchSize=64, type=org.apache.qpid.dispatch.allocator, typeName=qd_node_t, typeSize=56) Tue Aug 23 17:01:05 2016 AGENT (debug) Add entity: AllocatorEntity(batchesRebalancedToGlobal=0, batchesRebalancedToThreads=0, globalFreeListMax=0, heldByThreads=128, localFreeListMax=128, totalAllocFromHeap=128, totalFreeToHeap=0, transferBatchSize=64, type=org.apache.qpid.dispatch.allocator, typeName=qd_timer_t, typeSize=56) Tue Aug 23 17:01:05 2016 AGENT (debug) Add entity: AllocatorEntity(batchesRebalancedToGlobal=0, batchesRebalancedToThreads=0, globalFreeListMax=0, heldByThreads=64, localFreeListMax=128, totalAllocFromHeap=64, totalFreeToHeap=0, transferBatchSize=64, type=org.apache.qpid.dispatch.allocator, typeName=qdr_action_t, typeSize=160) Tue Aug 23 17:01:05 2016 AGENT (debug) Add entity: AllocatorEntity(batchesRebalancedToGlobal=0, batchesRebalancedToThreads=0, globalFreeListMax=0, heldByThreads=64, localFreeListMax=128, totalAllocFromHeap=64, totalFreeToHeap=0, transferBatchSize=64, type=org.apache.qpid.dispatch.allocator, typeName=qdr_field_t, typeSize=40) Tue Aug 23 17:01:05 2016 AGENT (debug) Add entity: AllocatorEntity(batchesRebalancedToGlobal=0, batchesRebalancedToThreads=0, globalFreeListMax=0, heldByThreads=16, localFreeListMax=32, totalAllocFromHeap=16, totalFreeToHeap=0, transferBatchSize=16, type=org.apache.qpid.dispatch.allocator, typeName=qd_buffer_t, typeSize=536) Tue Aug 23 17:01:05 2016 AGENT (info) Activating management agent on $_management_internal Tue Aug 23 17:01:05 2016 ROUTER_CORE (trace) Core action 'subscribe' Tue Aug 23 17:01:05 2016 ROUTER_CORE (info) In-process subscription L/$management Tue Aug 23 17:01:05 2016 ROUTER_CORE (trace) Core action 'subscribe' Tue Aug 23 17:01:05 2016 ROUTER_CORE (info) In-process subscription L/$_management_internal Tue Aug 23 17:01:05 2016 DISPLAYNAME (info) Activating DisplayNameService on $displayname Tue Aug 23 17:01:05 2016 ROUTER_CORE (trace) Core action 'subscribe' Tue Aug 23 17:01:05 2016 ROUTER_CORE (info) In-process subscription L/$displayname Tue Aug 23 17:01:05 2016 CONN_MGR (info) Configured Listener: 0.0.0.0:amqp proto=any role=normal Tue Aug 23 17:01:05 2016 SERVER (trace) Listening on 0.0.0.0:amqp Tue Aug 23 17:01:05 2016 AGENT (debug) Add entity: ListenerEntity(addr=127.0.0.1, authenticatePeer=False, cost=1, host=0.0.0.0, identity=listener/0.0.0.0:amqp, idleTimeoutSeconds=16, maxFrameSize=16384, port=amqp, requireEncryption=False, requireSsl=False, role=normal, stripAnnotations=both, type=org.apache.qpid.dispatch.listener) Tue Aug 23 17:01:05 2016 CONN_MGR (info) Configured Connector: 10.34.37.159:amqp proto=any role=route-container Tue Aug 23 17:01:05 2016 AGENT (debug) Add entity: ConnectorEntity(addr=127.0.0.1, allowRedirect=True, cost=1, host=10.34.37.159, identity=connector/10.34.37.159:amqp:broker, idleTimeoutSeconds=16, maxFrameSize=65536, name=broker, port=amqp, role=route-container, stripAnnotations=both, type=org.apache.qpid.dispatch.connector, verifyHostName=True) Tue Aug 23 17:01:05 2016 ROUTER_CORE (trace) Core action 'manage_create' Tue Aug 23 17:01:05 2016 AGENT (debug) Add entity: AddressEntity(distribution=closest, identity=address/0, name=address/0, prefix=closest, type=org.apache.qpid.dispatch.router.config.address, waypoint=False) Tue Aug 23 17:01:05 2016 ROUTER_CORE (trace) Core action 'manage_create' Tue Aug 23 17:01:05 2016 AGENT (debug) Add entity: AddressEntity(distribution=multicast, identity=address/1, name=address/1, prefix=multicast, type=org.apache.qpid.dispatch.router.config.address, waypoint=False) Tue Aug 23 17:01:05 2016 ROUTER_CORE (trace) Core action 'manage_create' Tue Aug 23 17:01:05 2016 AGENT (debug) Add entity: AddressEntity(distribution=closest, identity=address/2, name=address/2, prefix=unicast, type=org.apache.qpid.dispatch.router.config.address, waypoint=False) Tue Aug 23 17:01:05 2016 ROUTER_CORE (trace) Core action 'manage_create' Tue Aug 23 17:01:05 2016 AGENT (debug) Add entity: AddressEntity(distribution=closest, identity=address/3, name=address/3, prefix=exclusive, type=org.apache.qpid.dispatch.router.config.address, waypoint=False) Tue Aug 23 17:01:05 2016 ROUTER_CORE (trace) Core action 'manage_create' Tue Aug 23 17:01:05 2016 AGENT (debug) Add entity: AddressEntity(distribution=multicast, identity=address/4, name=address/4, prefix=broadcast, type=org.apache.qpid.dispatch.router.config.address, waypoint=False) Tue Aug 23 17:01:05 2016 ROUTER_CORE (trace) Core action 'manage_create' Tue Aug 23 17:01:05 2016 AGENT (debug) Add entity: LinkRouteEntity(connection=broker, dir=in, distribution=linkBalanced, identity=linkRoute/0, name=linkRoute/0, prefix=jms, type=org.apache.qpid.dispatch.router.config.linkRoute) Tue Aug 23 17:01:05 2016 ROUTER_CORE (trace) Core action 'manage_create' Tue Aug 23 17:01:05 2016 AGENT (debug) Add entity: LinkRouteEntity(connection=broker, dir=out, distribution=linkBalanced, identity=linkRoute/1, name=linkRoute/1, prefix=jms, type=org.apache.qpid.dispatch.router.config.linkRoute) Tue Aug 23 17:01:05 2016 POLICY (info) Policy configured maximumConnections: 0, policyFolder: '', access rules enabled: 'false' Tue Aug 23 17:01:05 2016 AGENT (debug) Add entity: Entity(defaultApplication=, defaultApplicationEnabled=False, enableAccessRules=False, maximumConnections=0, policyFolder=, type=org.apache.qpid.dispatch.policy) Tue Aug 23 17:01:05 2016 AGENT (debug) Add entity: ConsoleEntity(identity=console/0, name=console/0, type=org.apache.qpid.dispatch.console, wsport=5673) Tue Aug 23 17:01:05 2016 POLICY (info) Policy fallback defaultApplication is disabled Tue Aug 23 17:01:05 2016 SERVER (info) Operational, 4 Threads Running Tue Aug 23 17:01:05 2016 SERVER (trace) Connecting to 10.34.37.159:amqp Tue Aug 23 17:01:05 2016 SERVER (trace) [1]: -> SASL Tue Aug 23 17:01:05 2016 SERVER (trace) [1]: <- SASL Tue Aug 23 17:01:05 2016 SERVER (trace) [1]:0 <- @sasl-mechanisms(64) [sasl-server-mechanisms=@PN_SYMBOL[:PLAIN, :ANONYMOUS]] Tue Aug 23 17:01:05 2016 SERVER (trace) [1]:0 -> @sasl-init(65) [mechanism=:ANONYMOUS, initial-response=b"anonymous@dhcp-126-46.lab.eng.brq.redhat.com"] Tue Aug 23 17:01:05 2016 SERVER (trace) [1]:RAW: "\x00\x00\x00M\x02\x01\x00\x00\x00SA\xd0\x00\x00\x00=\x00\x00\x00\x02\xa3\x09ANONYMOUS\xa0,anonymous@dhcp-126-46.lab.eng.brq.redhat.com" Tue Aug 23 17:01:05 2016 SERVER (trace) [1]:0 <- @sasl-outcome(68) [code=0] Tue Aug 23 17:01:05 2016 SERVER (trace) [1]: <- AMQP Tue Aug 23 17:01:05 2016 SERVER (trace) [1]: -> AMQP Tue Aug 23 17:01:05 2016 SERVER (trace) [1]:0 -> @open(16) [container-id="Router.A", hostname="10.34.37.159", max-frame-size=65536, channel-max=32767, idle-time-out=8000, offered-capabilities=:"ANONYMOUS-RELAY", properties={:product="qpid-dispatch-router", :version="0.6.0"}] Tue Aug 23 17:01:05 2016 SERVER (trace) [1]:RAW: "\x00\x00\x00\x85\x02\x00\x00\x00\x00S\x10\xd0\x00\x00\x00u\x00\x00\x00\x0a\xa1\x08Router.A\xa1\x0c10.34.37.159p\x00\x01\x00\x00`\x7f\xffp\x00\x00\x1f@@@\xa3\x0fANONYMOUS-RELAY@\xd1\x00\x00\x003\x00\x00\x00\x04\xa3\x07product\xa1\x14qpid-dispatch-router\xa3\x07version\xa1\x050.6.0" Tue Aug 23 17:01:05 2016 SERVER (trace) [1]:0 <- @open(16) [container-id="", hostname="", max-frame-size=4294967295, channel-max=65535, idle-time-out=30000] Tue Aug 23 17:01:05 2016 ROUTER_CORE (trace) Core action 'connection_opened' Tue Aug 23 17:01:05 2016 ROUTER_CORE (info) Link Route Activated '6' on connection broker Tue Aug 23 17:01:05 2016 ROUTER_CORE (info) Link Route Activated '7' on connection broker Tue Aug 23 17:01:07 2016 SERVER (debug) Accepting incoming connection from dhcp-37-176.lab.eng.brq.redhat.com:58606 to 0.0.0.0:amqp Tue Aug 23 17:01:07 2016 SERVER (trace) [2]:AMQP SASL layer detected Tue Aug 23 17:01:07 2016 SERVER (trace) [2]: <- SASL Tue Aug 23 17:01:07 2016 SERVER (trace) [2]: -> SASL Tue Aug 23 17:01:07 2016 SERVER (trace) [2]:0 -> @sasl-mechanisms(64) [sasl-server-mechanisms=@PN_SYMBOL[:ANONYMOUS]] Tue Aug 23 17:01:07 2016 SERVER (trace) [2]:RAW: "\x00\x00\x00+\x02\x01\x00\x00\x00S@\xd0\x00\x00\x00\x1b\x00\x00\x00\x01\xf0\x00\x00\x00\x12\x00\x00\x00\x01\xb3\x00\x00\x00\x09ANONYMOUS" Tue Aug 23 17:01:07 2016 SERVER (trace) [2]:0 <- @sasl-init(65) [mechanism=:ANONYMOUS, initial-response=b"anonymous@dhcp-37-176-6.7x.lab.eng.brq.redhat.com"] Tue Aug 23 17:01:07 2016 SERVER (trace) [2]:Authenticated user: anonymous with mechanism ANONYMOUS Tue Aug 23 17:01:07 2016 SERVER (trace) [2]:0 -> @sasl-outcome(68) [code=0] Tue Aug 23 17:01:07 2016 SERVER (trace) [2]:RAW: "\x00\x00\x00\x16\x02\x01\x00\x00\x00SD\xd0\x00\x00\x00\x06\x00\x00\x00\x01P\x00" Tue Aug 23 17:01:07 2016 SERVER (trace) [2]:AMQP 1.0 layer detected Tue Aug 23 17:01:07 2016 SERVER (trace) [2]: <- AMQP Tue Aug 23 17:01:07 2016 SERVER (trace) [2]:0 <- @open(16) [container-id="6ed292b6-c4bb-4a13-9ecc-1be82ade3925", hostname="10.34.126.46", channel-max=32767] Tue Aug 23 17:01:07 2016 SERVER (trace) [2]:0 <- @begin(17) [next-outgoing-id=0, incoming-window=2147483647, outgoing-window=2147483647] Tue Aug 23 17:01:07 2016 SERVER (trace) [2]:0 <- @attach(18) [name="6ed292b6-c4bb-4a13-9ecc-1be82ade3925-jms.queue.test.address.1.1", handle=0, role=false, snd-settle-mode=2, rcv-settle-mode=0, source=@source(40) [durable=0, timeout=0, dynamic=false], target=@target(41) [address="jms.queue.test.address.1.1", durable=0, timeout=0, dynamic=false], initial-delivery-count=0] Tue Aug 23 17:01:07 2016 SERVER (trace) [2]: -> AMQP Tue Aug 23 17:01:07 2016 ROUTER_CORE (trace) Core action 'connection_opened' Tue Aug 23 17:01:07 2016 SERVER (trace) [2]:0 -> @open(16) [container-id="Router.A", max-frame-size=16384, channel-max=32767, idle-time-out=8000, offered-capabilities=:"ANONYMOUS-RELAY", properties={:product="qpid-dispatch-router", :version="0.6.0"}] Tue Aug 23 17:01:07 2016 SERVER (trace) [2]:RAW: "\x00\x00\x00x\x02\x00\x00\x00\x00S\x10\xd0\x00\x00\x00h\x00\x00\x00\x0a\xa1\x08Router.A@p\x00\x00@\x00`\x7f\xffp\x00\x00\x1f@@@\xa3\x0fANONYMOUS-RELAY@\xd1\x00\x00\x003\x00\x00\x00\x04\xa3\x07product\xa1\x14qpid-dispatch-router\xa3\x07version\xa1\x050.6.0" Tue Aug 23 17:01:07 2016 SERVER (trace) [2]:0 -> @begin(17) [remote-channel=0, next-outgoing-id=0, incoming-window=61, outgoing-window=2147483647] Tue Aug 23 17:01:07 2016 SERVER (trace) [2]:RAW: "\x00\x00\x00 \x02\x00\x00\x00\x00S\x11\xd0\x00\x00\x00\x10\x00\x00\x00\x04`\x00\x00R\x00R=p\x7f\xff\xff\xff" Tue Aug 23 17:01:07 2016 ROUTER_CORE (trace) Core action 'link_first_attach' Tue Aug 23 17:01:07 2016 SERVER (trace) [1]:0 -> @begin(17) [next-outgoing-id=0, incoming-window=15, outgoing-window=2147483647] Tue Aug 23 17:01:07 2016 SERVER (trace) [1]:RAW: "\x00\x00\x00\x1e\x02\x00\x00\x00\x00S\x11\xd0\x00\x00\x00\x0e\x00\x00\x00\x04@R\x00R\x0fp\x7f\xff\xff\xff" Tue Aug 23 17:01:07 2016 SERVER (trace) [1]:0 -> @attach(18) [name="6ed292b6-c4bb-4a13-9ecc-1be82ade3925-jms.queue.test.address.1.1", handle=0, role=false, snd-settle-mode=2, rcv-settle-mode=0, source=@source(40) [durable=0, timeout=0, dynamic=false], target=@target(41) [address="jms.queue.test.address.1.1", durable=0, timeout=0, dynamic=false], initial-delivery-count=0] Tue Aug 23 17:01:07 2016 SERVER (trace) [1]:RAW: "\x00\x00\x00\xa9\x02\x00\x00\x00\x00S\x12\xd0\x00\x00\x00\x99\x00\x00\x00\x0a\xa1?6ed292b6-c4bb-4a13-9ecc-1be82ade3925-jms.queue.test.address.1.1R\x00BP\x02P\x00\x00S(\xd0\x00\x00\x00\x11\x00\x00\x00\x0b@R\x00@R\x00B@@@@@@\x00S)\xd0\x00\x00\x00(\x00\x00\x00\x07\xa1\x1ajms.queue.test.address.1.1R\x00@R\x00B@@@@R\x00" Tue Aug 23 17:01:07 2016 SERVER (trace) [1]:0 <- @begin(17) [remote-channel=0, next-outgoing-id=1, incoming-window=2147483647, outgoing-window=2147483647, handle-max=65535] Tue Aug 23 17:01:07 2016 SERVER (trace) [1]:0 <- @attach(18) [name="6ed292b6-c4bb-4a13-9ecc-1be82ade3925-jms.queue.test.address.1.1", handle=0, role=true, snd-settle-mode=2, rcv-settle-mode=0, source=@source(40) [], target=@target(41) [address="jms.queue.test.address.1.1"]] Tue Aug 23 17:01:07 2016 SERVER (trace) [1]:0 <- @flow(19) [next-incoming-id=0, incoming-window=2147483647, next-outgoing-id=1, outgoing-window=2147483647, handle=0, delivery-count=0, link-credit=200] Tue Aug 23 17:01:07 2016 ROUTER_CORE (trace) Core action 'link_second_attach' Tue Aug 23 17:01:07 2016 ROUTER_CORE (trace) Core action 'link_flow' Tue Aug 23 17:01:07 2016 SERVER (trace) [2]:0 -> @attach(18) [name="6ed292b6-c4bb-4a13-9ecc-1be82ade3925-jms.queue.test.address.1.1", handle=0, role=true, snd-settle-mode=2, rcv-settle-mode=0, source=@source(40) [durable=0, timeout=0, dynamic=false], target=@target(41) [address="jms.queue.test.address.1.1", durable=0, timeout=0, dynamic=false], initial-delivery-count=0] Tue Aug 23 17:01:07 2016 SERVER (trace) [2]:RAW: "\x00\x00\x00\xa9\x02\x00\x00\x00\x00S\x12\xd0\x00\x00\x00\x99\x00\x00\x00\x0a\xa1?6ed292b6-c4bb-4a13-9ecc-1be82ade3925-jms.queue.test.address.1.1R\x00AP\x02P\x00\x00S(\xd0\x00\x00\x00\x11\x00\x00\x00\x0b@R\x00@R\x00B@@@@@@\x00S)\xd0\x00\x00\x00(\x00\x00\x00\x07\xa1\x1ajms.queue.test.address.1.1R\x00@R\x00B@@@@R\x00" Tue Aug 23 17:01:07 2016 SERVER (trace) [2]:0 -> @flow(19) [next-incoming-id=0, incoming-window=61, next-outgoing-id=0, outgoing-window=2147483647, handle=0, delivery-count=0, link-credit=200, drain=false] Tue Aug 23 17:01:07 2016 SERVER (trace) [2]:RAW: "\x00\x00\x00'\x02\x00\x00\x00\x00S\x13\xd0\x00\x00\x00\x17\x00\x00\x00\x09R\x00R=R\x00p\x7f\xff\xff\xffR\x00R\x00R\xc8@B" Tue Aug 23 17:01:07 2016 SERVER (trace) [2]:0 <- @transfer(20) [handle=0, delivery-id=0, delivery-tag=b"1", message-format=0, settled=false, more=false] (132) "\x00Sp\xd0\x00\x00\x00\x0b\x00\x00\x00\x05BP\x04@BR\x00\x00Sr\xd1\x00\x00\x00&\x00\x00\x00\x02\xa1\x10x-opt-qd.ingress\xa1\x0eingress_router\x00Ss\xd0\x00\x00\x00#\x00\x00\x00\x0dS\x01@@@@@@@\x83\x00\x00\x00\x00\x00\x00\x00\x00\x83\x00\x00\x00\x00\x00\x00\x00\x00@R\x00@\x00Sw\xd1\x00\x00\x00\x10\x00\x00\x00\x02\xa1\x08sequenceT\x01" Tue Aug 23 17:01:07 2016 MESSAGE (trace) Received Message{ body='\d1\00\00\00\10\00\00\00\02\a1\08seque'} on link 6ed292b6-c4bb-4a13-9ecc-1be82ade3925-jms.queue.test.address.1.1 Tue Aug 23 17:01:07 2016 ROUTER_CORE (trace) Core action 'link_deliver' Tue Aug 23 17:01:07 2016 MESSAGE (trace) Sending Message{ body='\d1\00\00\00\10\00\00\00\02\a1\08seque'} on link 6ed292b6-c4bb-4a13-9ecc-1be82ade3925-jms.queue.test.address.1.1 Tue Aug 23 17:01:07 2016 SERVER (trace) [1]:0 -> @transfer(20) [handle=0, delivery-id=0, delivery-tag=b"1", message-format=0, settled=false, more=false] (132) "\x00Sp\xd0\x00\x00\x00\x0b\x00\x00\x00\x05BP\x04@BR\x00\x00Sr\xd1\x00\x00\x00&\x00\x00\x00\x02\xa1\x10x-opt-qd.ingress\xa1\x0eingress_router\x00Ss\xd0\x00\x00\x00#\x00\x00\x00\x0dS\x01@@@@@@@\x83\x00\x00\x00\x00\x00\x00\x00\x00\x83\x00\x00\x00\x00\x00\x00\x00\x00@R\x00@\x00Sw\xd1\x00\x00\x00\x10\x00\x00\x00\x02\xa1\x08sequenceT\x01" Tue Aug 23 17:01:07 2016 SERVER (trace) [1]:RAW: "\x00\x00\x00\xa5\x02\x00\x00\x00\x00S\x14\xd0\x00\x00\x00\x11\x00\x00\x00\x08R\x00R\x00\xa0\x011R\x00BB@@\x00Sp\xd0\x00\x00\x00\x0b\x00\x00\x00\x05BP\x04@BR\x00\x00Sr\xd1\x00\x00\x00&\x00\x00\x00\x02\xa1\x10x-opt-qd.ingress\xa1\x0eingress_router\x00Ss\xd0\x00\x00\x00#\x00\x00\x00\x0dS\x01@@@@@@@\x83\x00\x00\x00\x00\x00\x00\x00\x00\x83\x00\x00\x00\x00\x00\x00\x00\x00@R\x00@\x00Sw\xd1\x00\x00\x00\x10\x00\x00\x00\x02\xa1\x08sequenceT\x01" Tue Aug 23 17:01:07 2016 ROUTER_CORE (trace) Core action 'link_flow' Tue Aug 23 17:01:07 2016 SERVER (trace) [1]:0 <- @disposition(21) [role=true, first=0, last=0, settled=true, state=@accepted(36) []] Tue Aug 23 17:01:07 2016 ROUTER_CORE (trace) Core action 'update_delivery' Tue Aug 23 17:01:07 2016 SERVER (trace) [2]:0 -> @disposition(21) [role=true, first=0, last=0, settled=true, state=@accepted(36) []] Tue Aug 23 17:01:07 2016 SERVER (trace) [2]:RAW: "\x00\x00\x00&\x02\x00\x00\x00\x00S\x15\xd0\x00\x00\x00\x16\x00\x00\x00\x05AR\x00R\x00A\x00S$\xd0\x00\x00\x00\x04\x00\x00\x00\x00" Tue Aug 23 17:01:07 2016 SERVER (trace) [2]:0 <- @close(24) [] Tue Aug 23 17:01:07 2016 SERVER (trace) [2]: <- EOS Tue Aug 23 17:01:07 2016 SERVER (trace) [2]:0 -> @close(24) [] Tue Aug 23 17:01:07 2016 SERVER (trace) [2]:RAW: "\x00\x00\x00\x15\x02\x00\x00\x00\x00S\x18\xd0\x00\x00\x00\x05\x00\x00\x00\x01@" Tue Aug 23 17:01:07 2016 SERVER (trace) [2]: -> EOS Tue Aug 23 17:01:07 2016 ROUTER_CORE (trace) Core action 'link_detach' Tue Aug 23 17:01:07 2016 ROUTER_CORE (trace) Core action 'connection_closed' Tue Aug 23 17:01:07 2016 SERVER (trace) [1]:0 -> @detach(22) [handle=0, closed=true] Tue Aug 23 17:01:07 2016 SERVER (trace) [1]:RAW: "\x00\x00\x00\x18\x02\x00\x00\x00\x00S\x16\xd0\x00\x00\x00\x08\x00\x00\x00\x03R\x00A@" Tue Aug 23 17:01:07 2016 SERVER (trace) [1]:0 <- @detach(22) [handle=0, closed=true] Tue Aug 23 17:01:07 2016 SERVER (trace) [1]:0 -> @end(23) [] Tue Aug 23 17:01:07 2016 SERVER (trace) [1]:RAW: "\x00\x00\x00\x15\x02\x00\x00\x00\x00S\x17\xd0\x00\x00\x00\x05\x00\x00\x00\x01@" Tue Aug 23 17:01:07 2016 ROUTER_CORE (trace) Core action 'link_detach' Tue Aug 23 17:01:07 2016 SERVER (trace) [1]:0 <- @end(23) [] Tue Aug 23 17:01:13 2016 SERVER (trace) [1]:0 <- (EMPTY FRAME)