test.log in ruby_skynet-0.2.0 vs test.log in ruby_skynet-0.3.0
- old
+ new
@@ -1,204 +1,88 @@
-2012-10-18 14:57:39.374723 T [99228:70233348070100] RubySkynet::Doozer::Client -- Socket Connection parameters -- {:read_timeout=>5, :connect_timeout=>3, :connect_retry_interval=>0.1, :connect_retry_count=>3, :server=>"127.0.0.1:8046", :buffered=>false, :on_connect=>#<Proc:0x007fc0f3983008@/Users/rmorrison/Sandbox/ruby_skynet/lib/ruby_skynet/doozer/client.rb:31>}
-2012-10-18 14:59:21.128915 T [99228:70233348070100] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- < "6/services/TutorialService/1/Development/127.0.0.1/9000
-2012-10-18 14:59:21.129134 D [99228:70233348070100] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 64 bytes
-2012-10-18 14:59:21.129848 T [99228:70233348070100] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x01\x17"
-2012-10-18 14:59:21.129865 D [99228:70233348070100] (0.7ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes
-2012-10-18 14:59:21.130508 T [99228:70233348070100] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x18\xEA\xA4\x012\x8E\x02{\"Config\":{\"UUID\":\"3978b371-15e9-40f8-9b7b-59ae88d8c7ec\",\"Name\":\"TutorialService\",\"Version\":\"1\",\"Region\":\"Development\",\"ServiceAddr\":{\"IPAddress\":\"127.0.0.1\",\"Port\":9000,\"MaxPort\":9999},\"AdminAddr\":{\"IPAddress\":\"127.0.0.1\",\"Port\":9001,\"MaxPort\":9999}},\"Registered\":true}"
-2012-10-18 14:59:21.130529 D [99228:70233348070100] (0.5ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 279 bytes
-2012-10-18 16:24:40.508201 T [1115:70296296184540] RubySkynet::Doozer::Client -- Socket Connection parameters -- {:server=>"localhost:8046", :read_timeout=>5, :connect_timeout=>3, :connect_retry_interval=>0.1, :connect_retry_count=>3, :buffered=>false, :on_connect=>#<Proc:0x007fde439e1e10@/Users/rmorrison/Sandbox/ruby_skynet/lib/ruby_skynet/doozer/client.rb:31>}
-2012-10-18 16:24:40.508201 T [1115:70296296184540] RubySkynet::Doozer::Client -- Socket Connection parameters -- {:server=>"localhost:8046", :read_timeout=>5, :connect_timeout=>3, :connect_retry_interval=>0.1, :connect_retry_count=>3, :buffered=>false, :on_connect=>#<Proc:0x007fde439e1e10@/Users/rmorrison/Sandbox/ruby_skynet/lib/ruby_skynet/doozer/client.rb:31>} -- {:server=>"localhost:8046", :read_timeout=>5, :connect_timeout=>3, :connect_retry_interval=>0.1, :connect_retry_count=>3, :buffered=>false, :on_connect=>#<Proc:0x007fde439e1e10@/Users/rmorrison/Sandbox/ruby_skynet/lib/ruby_skynet/doozer/client.rb:31>}
-2012-10-18 16:24:40.518191 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sending -- "/8
-2012-10-18 16:24:40.518191 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sending -- "/8 -- "/8
-2012-10-18 16:24:40.518485 D [1115:70296296184540] (0.3ms) ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sent 13 bytes
-2012-10-18 16:24:40.518485 D [1115:70296296184540] (0.3ms) ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sent 13 bytes
-2012-10-18 16:24:40.518564 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\x00\x00\x00\a"
-2012-10-18 16:24:40.518564 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\x00\x00\x00\a" -- "\x00\x00\x00\a"
-2012-10-18 16:24:40.518574 D [1115:70296296184540] (0.1ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 4 bytes
-2012-10-18 16:24:40.518574 D [1115:70296296184540] (0.1ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 4 bytes
-2012-10-18 16:24:40.518790 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\b\x00*\x03ctl"
-2012-10-18 16:24:40.518790 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\b\x00*\x03ctl" -- "\b\x00*\x03ctl"
-2012-10-18 16:24:40.518808 D [1115:70296296184540] (0.1ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 7 bytes
-2012-10-18 16:24:40.518808 D [1115:70296296184540] (0.1ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 7 bytes
-2012-10-18 16:24:40.519116 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sending -- "/8
-2012-10-18 16:24:40.519116 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sending -- "/8 -- "/8
-2012-10-18 16:24:40.519160 D [1115:70296296184540] (0.0ms) ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sent 13 bytes
-2012-10-18 16:24:40.519160 D [1115:70296296184540] (0.0ms) ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sent 13 bytes
-2012-10-18 16:24:40.519384 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\x00\x00\x00\f"
-2012-10-18 16:24:40.519384 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\x00\x00\x00\f" -- "\x00\x00\x00\f"
-2012-10-18 16:24:40.519397 D [1115:70296296184540] (0.2ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 4 bytes
-2012-10-18 16:24:40.519397 D [1115:70296296184540] (0.2ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 4 bytes
-2012-10-18 16:24:40.519464 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\b\x00*\bservices"
-2012-10-18 16:24:40.519464 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\b\x00*\bservices" -- "\b\x00*\bservices"
-2012-10-18 16:24:40.519474 D [1115:70296296184540] (0.0ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 12 bytes
-2012-10-18 16:24:40.519474 D [1115:70296296184540] (0.0ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 12 bytes
-2012-10-18 16:24:40.519682 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sending -- "/8
-2012-10-18 16:24:40.519682 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sending -- "/8 -- "/8
-2012-10-18 16:24:40.519727 D [1115:70296296184540] (0.0ms) ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sent 13 bytes
-2012-10-18 16:24:40.519727 D [1115:70296296184540] (0.0ms) ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sent 13 bytes
-2012-10-18 16:24:40.519989 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\x00\x00\x00\x0E"
-2012-10-18 16:24:40.519989 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\x00\x00\x00\x0E" -- "\x00\x00\x00\x0E"
-2012-10-18 16:24:40.520002 D [1115:70296296184540] (0.2ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 4 bytes
-2012-10-18 16:24:40.520002 D [1115:70296296184540] (0.2ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 4 bytes
-2012-10-18 16:24:40.520064 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\b\x00*\nstatistics"
-2012-10-18 16:24:40.520064 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\b\x00*\nstatistics" -- "\b\x00*\nstatistics"
-2012-10-18 16:24:40.520074 D [1115:70296296184540] (0.0ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 14 bytes
-2012-10-18 16:24:40.520074 D [1115:70296296184540] (0.0ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 14 bytes
-2012-10-18 16:24:40.520287 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sending -- "/8
-2012-10-18 16:24:40.520287 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sending -- "/8 -- "/8
-2012-10-18 16:24:40.520331 D [1115:70296296184540] (0.0ms) ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sent 13 bytes
-2012-10-18 16:24:40.520331 D [1115:70296296184540] (0.0ms) ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sent 13 bytes
-2012-10-18 16:24:40.520523 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\x00\x00\x00\x05"
-2012-10-18 16:24:40.520523 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\x00\x00\x00\x05" -- "\x00\x00\x00\x05"
-2012-10-18 16:24:40.520538 D [1115:70296296184540] (0.2ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 4 bytes
-2012-10-18 16:24:40.520538 D [1115:70296296184540] (0.2ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 4 bytes
-2012-10-18 16:24:40.520825 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\b\x00\xA0\x06\b"
-2012-10-18 16:24:40.520825 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\b\x00\xA0\x06\b" -- "\b\x00\xA0\x06\b"
-2012-10-18 16:24:40.520836 D [1115:70296296184540] (0.2ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 5 bytes
-2012-10-18 16:24:40.520836 D [1115:70296296184540] (0.2ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 5 bytes
-2012-10-18 16:24:40.521872 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sending -- " /test/fooH
-2012-10-18 16:24:40.521872 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sending -- " /test/fooH -- " /test/fooH
-2012-10-18 16:24:40.521922 D [1115:70296296184540] (0.0ms) ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sent 30 bytes
-2012-10-18 16:24:40.521922 D [1115:70296296184540] (0.0ms) ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sent 30 bytes
-2012-10-18 16:24:40.528688 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\x00\x00\x00\x02"
-2012-10-18 16:24:40.528688 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\x00\x00\x00\x02" -- "\x00\x00\x00\x02"
-2012-10-18 16:24:40.528710 D [1115:70296296184540] (6.8ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 4 bytes
-2012-10-18 16:24:40.528710 D [1115:70296296184540] (6.8ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 4 bytes
-2012-10-18 16:24:40.528795 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\b\x00"
-2012-10-18 16:24:40.528795 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\b\x00" -- "\b\x00"
-2012-10-18 16:24:40.528805 D [1115:70296296184540] (0.0ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 2 bytes
-2012-10-18 16:24:40.528805 D [1115:70296296184540] (0.0ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 2 bytes
-2012-10-18 16:24:40.529057 T [1115:70296296184540] RubySkynet::Doozer::Client -- Socket Connection parameters -- {:server=>"localhost:8046", :read_timeout=>5, :connect_timeout=>3, :connect_retry_interval=>0.1, :connect_retry_count=>3, :buffered=>false, :on_connect=>#<Proc:0x007fde439753f0@/Users/rmorrison/Sandbox/ruby_skynet/lib/ruby_skynet/doozer/client.rb:31>}
-2012-10-18 16:24:40.529057 T [1115:70296296184540] RubySkynet::Doozer::Client -- Socket Connection parameters -- {:server=>"localhost:8046", :read_timeout=>5, :connect_timeout=>3, :connect_retry_interval=>0.1, :connect_retry_count=>3, :buffered=>false, :on_connect=>#<Proc:0x007fde439753f0@/Users/rmorrison/Sandbox/ruby_skynet/lib/ruby_skynet/doozer/client.rb:31>} -- {:server=>"localhost:8046", :read_timeout=>5, :connect_timeout=>3, :connect_retry_interval=>0.1, :connect_retry_count=>3, :buffered=>false, :on_connect=>#<Proc:0x007fde439753f0@/Users/rmorrison/Sandbox/ruby_skynet/lib/ruby_skynet/doozer/client.rb:31>}
-2012-10-18 16:24:40.530528 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sending --
-2012-10-18 16:24:40.530528 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sending -- --
-2012-10-18 16:24:40.530581 D [1115:70296296184540] (0.0ms) ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sent 8 bytes
-2012-10-18 16:24:40.530581 D [1115:70296296184540] (0.0ms) ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sent 8 bytes
-2012-10-18 16:24:40.531285 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\x00\x00\x00\x06"
-2012-10-18 16:24:40.531285 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\x00\x00\x00\x06" -- "\x00\x00\x00\x06"
-2012-10-18 16:24:40.531299 D [1115:70296296184540] (0.7ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 4 bytes
-2012-10-18 16:24:40.531299 D [1115:70296296184540] (0.7ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 4 bytes
-2012-10-18 16:24:40.531367 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\b\x00\x18\xEA\xCF\x03"
-2012-10-18 16:24:40.531367 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\b\x00\x18\xEA\xCF\x03" -- "\b\x00\x18\xEA\xCF\x03"
-2012-10-18 16:24:40.531377 D [1115:70296296184540] (0.0ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 6 bytes
-2012-10-18 16:24:40.531377 D [1115:70296296184540] (0.0ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 6 bytes
-2012-10-18 16:24:40.532559 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sending -- " /test/fooH
-2012-10-18 16:24:40.532559 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sending -- " /test/fooH -- " /test/fooH
-2012-10-18 16:24:40.532934 D [1115:70296296184540] (0.4ms) ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sent 30 bytes
-2012-10-18 16:24:40.532934 D [1115:70296296184540] (0.4ms) ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sent 30 bytes
-2012-10-18 16:24:40.534366 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\x00\x00\x00\x02"
-2012-10-18 16:24:40.534366 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\x00\x00\x00\x02" -- "\x00\x00\x00\x02"
-2012-10-18 16:24:40.534384 D [1115:70296296184540] (1.4ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 4 bytes
-2012-10-18 16:24:40.534384 D [1115:70296296184540] (1.4ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 4 bytes
-2012-10-18 16:24:40.535776 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\b\x00"
-2012-10-18 16:24:40.535776 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\b\x00" -- "\b\x00"
-2012-10-18 16:24:40.535862 D [1115:70296296184540] (1.4ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 2 bytes
-2012-10-18 16:24:40.535862 D [1115:70296296184540] (1.4ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 2 bytes
-2012-10-18 16:24:40.536102 T [1115:70296296184540] RubySkynet::Doozer::Client -- Socket Connection parameters -- {:server=>"localhost:8046", :read_timeout=>5, :connect_timeout=>3, :connect_retry_interval=>0.1, :connect_retry_count=>3, :buffered=>false, :on_connect=>#<Proc:0x007fde4394b0c8@/Users/rmorrison/Sandbox/ruby_skynet/lib/ruby_skynet/doozer/client.rb:31>}
-2012-10-18 16:24:40.536102 T [1115:70296296184540] RubySkynet::Doozer::Client -- Socket Connection parameters -- {:server=>"localhost:8046", :read_timeout=>5, :connect_timeout=>3, :connect_retry_interval=>0.1, :connect_retry_count=>3, :buffered=>false, :on_connect=>#<Proc:0x007fde4394b0c8@/Users/rmorrison/Sandbox/ruby_skynet/lib/ruby_skynet/doozer/client.rb:31>} -- {:server=>"localhost:8046", :read_timeout=>5, :connect_timeout=>3, :connect_retry_interval=>0.1, :connect_retry_count=>3, :buffered=>false, :on_connect=>#<Proc:0x007fde4394b0c8@/Users/rmorrison/Sandbox/ruby_skynet/lib/ruby_skynet/doozer/client.rb:31>}
-2012-10-18 16:24:40.537457 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sending -- " " /test/foo*value2H
-2012-10-18 16:24:40.537457 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sending -- " " /test/foo*value2H -- " " /test/foo*value2H
-2012-10-18 16:24:40.537939 D [1115:70296296184540] (0.2ms) ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sent 38 bytes
-2012-10-18 16:24:40.537939 D [1115:70296296184540] (0.2ms) ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sent 38 bytes
-2012-10-18 16:24:40.545279 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\x00\x00\x00\x06"
-2012-10-18 16:24:40.545279 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\x00\x00\x00\x06" -- "\x00\x00\x00\x06"
-2012-10-18 16:24:40.545375 D [1115:70296296184540] (7.3ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 4 bytes
-2012-10-18 16:24:40.545375 D [1115:70296296184540] (7.3ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 4 bytes
-2012-10-18 16:24:40.545836 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\b\x00\x18\xEC\xCF\x03"
-2012-10-18 16:24:40.545836 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\b\x00\x18\xEC\xCF\x03" -- "\b\x00\x18\xEC\xCF\x03"
-2012-10-18 16:24:40.545877 D [1115:70296296184540] (0.4ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 6 bytes
-2012-10-18 16:24:40.545877 D [1115:70296296184540] (0.4ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 6 bytes
-2012-10-18 16:24:40.546175 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sending -- " /test/foo
-2012-10-18 16:24:40.546175 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sending -- " /test/foo -- " /test/foo
-2012-10-18 16:24:40.546686 D [1115:70296296184540] (0.5ms) ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sent 19 bytes
-2012-10-18 16:24:40.546686 D [1115:70296296184540] (0.5ms) ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sent 19 bytes
-2012-10-18 16:24:40.546985 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\x00\x00\x00\x0E"
-2012-10-18 16:24:40.546985 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\x00\x00\x00\x0E" -- "\x00\x00\x00\x0E"
-2012-10-18 16:24:40.547017 D [1115:70296296184540] (0.2ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 4 bytes
-2012-10-18 16:24:40.547017 D [1115:70296296184540] (0.2ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 4 bytes
-2012-10-18 16:24:40.547334 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\b\x00\x18\xEC\xCF\x032\x06value2"
-2012-10-18 16:24:40.547334 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\b\x00\x18\xEC\xCF\x032\x06value2" -- "\b\x00\x18\xEC\xCF\x032\x06value2"
-2012-10-18 16:24:40.547371 D [1115:70296296184540] (0.3ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 14 bytes
-2012-10-18 16:24:40.547371 D [1115:70296296184540] (0.3ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 14 bytes
-2012-10-18 16:24:40.554881 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sending -- " /test/fooH
-2012-10-18 16:24:40.554881 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sending -- " /test/fooH -- " /test/fooH
-2012-10-18 16:24:40.555156 D [1115:70296296184540] (0.2ms) ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sent 30 bytes
-2012-10-18 16:24:40.555156 D [1115:70296296184540] (0.2ms) ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sent 30 bytes
-2012-10-18 16:24:40.558177 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\x00\x00\x00\x02"
-2012-10-18 16:24:40.558177 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\x00\x00\x00\x02" -- "\x00\x00\x00\x02"
-2012-10-18 16:24:40.558239 D [1115:70296296184540] (3.0ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 4 bytes
-2012-10-18 16:24:40.558239 D [1115:70296296184540] (3.0ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 4 bytes
-2012-10-18 16:24:40.558632 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\b\x00"
-2012-10-18 16:24:40.558632 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\b\x00" -- "\b\x00"
-2012-10-18 16:24:40.558673 D [1115:70296296184540] (0.4ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 2 bytes
-2012-10-18 16:24:40.558673 D [1115:70296296184540] (0.4ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 2 bytes
-2012-10-18 16:24:40.559236 T [1115:70296296184540] RubySkynet::Doozer::Client -- Socket Connection parameters -- {:server=>"localhost:8046", :read_timeout=>5, :connect_timeout=>3, :connect_retry_interval=>0.1, :connect_retry_count=>3, :buffered=>false, :on_connect=>#<Proc:0x007fde4384c118@/Users/rmorrison/Sandbox/ruby_skynet/lib/ruby_skynet/doozer/client.rb:31>}
-2012-10-18 16:24:40.559236 T [1115:70296296184540] RubySkynet::Doozer::Client -- Socket Connection parameters -- {:server=>"localhost:8046", :read_timeout=>5, :connect_timeout=>3, :connect_retry_interval=>0.1, :connect_retry_count=>3, :buffered=>false, :on_connect=>#<Proc:0x007fde4384c118@/Users/rmorrison/Sandbox/ruby_skynet/lib/ruby_skynet/doozer/client.rb:31>} -- {:server=>"localhost:8046", :read_timeout=>5, :connect_timeout=>3, :connect_retry_interval=>0.1, :connect_retry_count=>3, :buffered=>false, :on_connect=>#<Proc:0x007fde4384c118@/Users/rmorrison/Sandbox/ruby_skynet/lib/ruby_skynet/doozer/client.rb:31>}
-2012-10-18 16:24:40.561011 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sending -- ! " /test/foo*valueH
-2012-10-18 16:24:40.561011 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sending -- ! " /test/foo*valueH -- ! " /test/foo*valueH
-2012-10-18 16:24:40.561282 D [1115:70296296184540] (0.2ms) ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sent 37 bytes
-2012-10-18 16:24:40.561282 D [1115:70296296184540] (0.2ms) ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sent 37 bytes
-2012-10-18 16:24:40.564758 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\x00\x00\x00\x06"
-2012-10-18 16:24:40.564758 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\x00\x00\x00\x06" -- "\x00\x00\x00\x06"
-2012-10-18 16:24:40.564792 D [1115:70296296184540] (3.4ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 4 bytes
-2012-10-18 16:24:40.564792 D [1115:70296296184540] (3.4ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 4 bytes
-2012-10-18 16:24:40.565674 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\b\x00\x18\xEE\xCF\x03"
-2012-10-18 16:24:40.565674 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\b\x00\x18\xEE\xCF\x03" -- "\b\x00\x18\xEE\xCF\x03"
-2012-10-18 16:24:40.565742 D [1115:70296296184540] (0.9ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 6 bytes
-2012-10-18 16:24:40.565742 D [1115:70296296184540] (0.9ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 6 bytes
-2012-10-18 16:24:40.566022 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sending -- " /test/foo
-2012-10-18 16:24:40.566022 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sending -- " /test/foo -- " /test/foo
-2012-10-18 16:24:40.566562 D [1115:70296296184540] (0.5ms) ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sent 19 bytes
-2012-10-18 16:24:40.566562 D [1115:70296296184540] (0.5ms) ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sent 19 bytes
-2012-10-18 16:24:40.566814 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\x00\x00\x00\r"
-2012-10-18 16:24:40.566814 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\x00\x00\x00\r" -- "\x00\x00\x00\r"
-2012-10-18 16:24:40.566861 D [1115:70296296184540] (0.2ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 4 bytes
-2012-10-18 16:24:40.566861 D [1115:70296296184540] (0.2ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 4 bytes
-2012-10-18 16:24:40.567187 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\b\x00\x18\xEE\xCF\x032\x05value"
-2012-10-18 16:24:40.567187 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\b\x00\x18\xEE\xCF\x032\x05value" -- "\b\x00\x18\xEE\xCF\x032\x05value"
-2012-10-18 16:24:40.567228 D [1115:70296296184540] (0.3ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 13 bytes
-2012-10-18 16:24:40.567228 D [1115:70296296184540] (0.3ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 13 bytes
-2012-10-18 16:24:40.571242 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sending -- " /test/fooH
-2012-10-18 16:24:40.571242 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sending -- " /test/fooH -- " /test/fooH
-2012-10-18 16:24:40.571681 D [1115:70296296184540] (0.4ms) ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sent 30 bytes
-2012-10-18 16:24:40.571681 D [1115:70296296184540] (0.4ms) ResilientSocket::TCPClient ["localhost:8046"] -- #write ==> sent 30 bytes
-2012-10-18 16:24:40.573028 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\x00\x00\x00\x02"
-2012-10-18 16:24:40.573028 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\x00\x00\x00\x02" -- "\x00\x00\x00\x02"
-2012-10-18 16:24:40.573064 D [1115:70296296184540] (1.3ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 4 bytes
-2012-10-18 16:24:40.573064 D [1115:70296296184540] (1.3ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 4 bytes
-2012-10-18 16:24:40.574638 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\b\x00"
-2012-10-18 16:24:40.574638 T [1115:70296296184540] ResilientSocket::TCPClient ["localhost:8046"] -- #read <== received -- "\b\x00" -- "\b\x00"
-2012-10-18 16:24:40.574722 D [1115:70296296184540] (1.6ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 2 bytes
-2012-10-18 16:24:40.574722 D [1115:70296296184540] (1.6ms) ResilientSocket::TCPClient ["localhost:8046"] -- #read <== read 2 bytes
-2012-10-18 16:24:40.575333 T [1115:70296296184540] RubySkynet::Doozer::Client -- Socket Connection parameters -- {:server=>"localhost:9999", :connect_retry_interval=>0.1, :connect_retry_count=>5, :read_timeout=>5, :connect_timeout=>3, :buffered=>false, :on_connect=>#<Proc:0x007fde43939328@/Users/rmorrison/Sandbox/ruby_skynet/lib/ruby_skynet/doozer/client.rb:31>}
-2012-10-18 16:24:40.575333 T [1115:70296296184540] RubySkynet::Doozer::Client -- Socket Connection parameters -- {:server=>"localhost:9999", :connect_retry_interval=>0.1, :connect_retry_count=>5, :read_timeout=>5, :connect_timeout=>3, :buffered=>false, :on_connect=>#<Proc:0x007fde43939328@/Users/rmorrison/Sandbox/ruby_skynet/lib/ruby_skynet/doozer/client.rb:31>} -- {:server=>"localhost:9999", :connect_retry_interval=>0.1, :connect_retry_count=>5, :read_timeout=>5, :connect_timeout=>3, :buffered=>false, :on_connect=>#<Proc:0x007fde43939328@/Users/rmorrison/Sandbox/ruby_skynet/lib/ruby_skynet/doozer/client.rb:31>}
-2012-10-18 16:24:40.576018 W [1115:70296296184540] ResilientSocket::TCPClient ["localhost:9999"] -- Connection failure: Errno::ECONNREFUSED: Connection refused - connect(2). Retry: 1
-2012-10-18 16:24:40.576018 W [1115:70296296184540] ResilientSocket::TCPClient ["localhost:9999"] -- Connection failure: Errno::ECONNREFUSED: Connection refused - connect(2). Retry: 1
-2012-10-18 16:24:40.676888 W [1115:70296296184540] ResilientSocket::TCPClient ["localhost:9999"] -- Connection failure: Errno::ECONNREFUSED: Connection refused - connect(2). Retry: 2
-2012-10-18 16:24:40.676888 W [1115:70296296184540] ResilientSocket::TCPClient ["localhost:9999"] -- Connection failure: Errno::ECONNREFUSED: Connection refused - connect(2). Retry: 2
-2012-10-18 16:24:40.777969 W [1115:70296296184540] ResilientSocket::TCPClient ["localhost:9999"] -- Connection failure: Errno::ECONNREFUSED: Connection refused - connect(2). Retry: 3
-2012-10-18 16:24:40.777969 W [1115:70296296184540] ResilientSocket::TCPClient ["localhost:9999"] -- Connection failure: Errno::ECONNREFUSED: Connection refused - connect(2). Retry: 3
-2012-10-18 16:24:40.879182 W [1115:70296296184540] ResilientSocket::TCPClient ["localhost:9999"] -- Connection failure: Errno::ECONNREFUSED: Connection refused - connect(2). Retry: 4
-2012-10-18 16:24:40.879182 W [1115:70296296184540] ResilientSocket::TCPClient ["localhost:9999"] -- Connection failure: Errno::ECONNREFUSED: Connection refused - connect(2). Retry: 4
-2012-10-18 16:24:40.980738 W [1115:70296296184540] ResilientSocket::TCPClient ["localhost:9999"] -- Connection failure: Errno::ECONNREFUSED: Connection refused - connect(2). Retry: 5
-2012-10-18 16:24:40.980738 W [1115:70296296184540] ResilientSocket::TCPClient ["localhost:9999"] -- Connection failure: Errno::ECONNREFUSED: Connection refused - connect(2). Retry: 5
-2012-10-18 16:24:41.082294 E [1115:70296296184540] ResilientSocket::TCPClient ["localhost:9999"] -- Connection failure: Errno::ECONNREFUSED: Connection refused - connect(2). Giving up after 5 retries
-2012-10-18 16:24:41.082294 E [1115:70296296184540] ResilientSocket::TCPClient ["localhost:9999"] -- Connection failure: Errno::ECONNREFUSED: Connection refused - connect(2). Giving up after 5 retries
-2012-10-18 16:24:41.082419 I [1115:70296296184540] (507.0ms) ResilientSocket::TCPClient ["localhost:9999"] -- Connecting to server localhost:9999 -- ResilientSocket::ConnectionFailure: After 5 connection attempts to host 'localhost:9999': Errno::ECONNREFUSED: Connection refused - connect(2)
-/Users/rmorrison/.rvm/gems/ruby-1.9.3-p194@ruby_skynet/gems/resilient_socket-0.3.0/lib/resilient_socket/tcp_client.rb:570:in `rescue in block in connect_to_server'
-/Users/rmorrison/.rvm/gems/ruby-1.9.3-p194@ruby_skynet/gems/resilient_socket-0.3.0/lib/resilient_socket/tcp_client.rb:548:in `block in connect_to_server'
+2012-12-04 15:14:22.115990 D [35331:70215367611540] RubySkynet::Server: localhost:2100 -- Waiting for a client to connect
+2012-12-04 15:14:22.125851 D [35331:70215367088860] RubySkynet::Registry -- Doozer Connection Pool: Created connection #1 #<Thread:0x007fb89406b5b8>(70215367088860) for Doozer Connection Pool
+2012-12-04 15:14:22.164719 T [35331:70215367088860] RubySkynet::Doozer::Client -- Socket Connection parameters -- {:servers=>["127.0.0.1:8046"], :read_timeout=>5, :connect_timeout=>3, :connect_retry_interval=>1, :connect_retry_count=>300, :buffered=>false, :on_connect=>#<Proc:0x007fb8940c6530@/Users/rmorrison/Sandbox/ruby_skynet/lib/ruby_skynet/doozer/client.rb:31>}
+2012-12-04 15:14:22.168071 D [35331:70215367088860] RubySkynet::Registry -- Doozer Connection Pool: Renewed connection old=70215367088860 new=#<RubySkynet::Doozer::Client:0x007fb89410ece0>(70215367423600)
+2012-12-04 15:14:22.168121 D [35331:70215367088860] RubySkynet::Registry -- Doozer Connection Pool: Checkout connection #<RubySkynet::Doozer::Client:0x007fb89410ece0>(70215367423600) self=connections=70215367423600 checked_out=70215367423600 with_map=
+2012-12-04 15:14:22.182589 T [35331:70215367088860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- " "2/services/RubySkynet.Service/1/Test/localhost/2100*{"Config":{"UUID":"localhost:2100-35331-RubySkynet::Service-70215371353000","Name":"RubySkynet.Service","Version":"1","Region":"Test","ServiceAddr":{"IPAddress":"localhost","Port":2100,"MaxPort":3099}},"Registered":true}H
+2012-12-04 15:14:22.183484 D [35331:70215367088860] (0.8ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 294 bytes
+2012-12-04 15:14:22.185393 T [35331:70215367088860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\x05"
+2012-12-04 15:14:22.185482 D [35331:70215367088860] (1.9ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes
+2012-12-04 15:14:22.192141 T [35331:70215367088860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x18\x97\x03"
+2012-12-04 15:14:22.192267 D [35331:70215367088860] (6.5ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 5 bytes
+2012-12-04 15:14:22.192491 D [35331:70215367088860] RubySkynet::Registry -- Doozer Connection Pool: Checkin connection #<RubySkynet::Doozer::Client:0x007fb89410ece0>(70215367423600) self=connections=70215367423600 checked_out= with_map=
+2012-12-04 15:14:22.197572 D [35331:70215367088860] [50be599e6b69338a03000001] RubySkynet::Registry -- Doozer Connection Pool: Checkout connection #<RubySkynet::Doozer::Client:0x007fb89410ece0>(70215367423600) self=connections=70215367423600 checked_out=70215367423600 with_map=
+2012-12-04 15:14:22.197847 T [35331:70215367088860] [50be599e6b69338a03000001] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --
+2012-12-04 15:14:22.198156 D [35331:70215367088860] [50be599e6b69338a03000001] (0.3ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 8 bytes
+2012-12-04 15:14:22.198347 T [35331:70215367088860] [50be599e6b69338a03000001] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\x05"
+2012-12-04 15:14:22.198362 D [35331:70215367088860] [50be599e6b69338a03000001] (0.2ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes
+2012-12-04 15:14:22.198617 T [35331:70215367088860] [50be599e6b69338a03000001] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x18\x97\x03"
+2012-12-04 15:14:22.198635 D [35331:70215367088860] [50be599e6b69338a03000001] (0.2ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 5 bytes
+2012-12-04 15:14:22.198932 T [35331:70215367088860] [50be599e6b69338a03000001] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*8 H
+2012-12-04 15:14:22.198978 D [35331:70215367088860] [50be599e6b69338a03000001] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 34 bytes
+2012-12-04 15:14:22.199362 T [35331:70215367088860] [50be599e6b69338a03000001] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x01\x1A"
+2012-12-04 15:14:22.199377 D [35331:70215367088860] [50be599e6b69338a03000001] (0.4ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes
+2012-12-04 15:14:22.199570 T [35331:70215367088860] [50be599e6b69338a03000001] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\x97\x03*2/services/RubySkynet.Service/1/Test/localhost/21002\xDC\x01{\"Config\":{\"UUID\":\"localhost:2100-35331-RubySkynet::Service-70215371353000\",\"Name\":\"RubySkynet.Service\",\"Version\":\"1\",\"Region\":\"Test\",\"ServiceAddr\":{\"IPAddress\":\"localhost\",\"Port\":2100,\"MaxPort\":3099}},\"Registered\":true}"
+2012-12-04 15:14:22.199582 D [35331:70215367088860] [50be599e6b69338a03000001] (0.2ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 282 bytes
+2012-12-04 15:14:22.199874 T [35331:70215367088860] [50be599e6b69338a03000001] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*8H
+2012-12-04 15:14:22.199920 D [35331:70215367088860] [50be599e6b69338a03000001] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 34 bytes
+2012-12-04 15:14:22.200307 T [35331:70215367088860] [50be599e6b69338a03000001] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\x05"
+2012-12-04 15:14:22.200319 D [35331:70215367088860] [50be599e6b69338a03000001] (0.4ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes
+2012-12-04 15:14:22.200382 T [35331:70215367088860] [50be599e6b69338a03000001] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\xA0\x06\b"
+2012-12-04 15:14:22.200392 D [35331:70215367088860] [50be599e6b69338a03000001] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 5 bytes
+2012-12-04 15:14:22.200569 D [35331:70215367088860] [50be599e6b69338a03000001] RubySkynet::Registry -- #start_monitoring Add Service: RubySkynet.Service/1/Test => localhost:2100
+2012-12-04 15:14:22.200607 D [35331:70215367088860] [50be599e6b69338a03000001] RubySkynet::Registry -- Doozer Connection Pool: Checkin connection #<RubySkynet::Doozer::Client:0x007fb89410ece0>(70215367423600) self=connections=70215367423600 checked_out= with_map=
+2012-12-04 15:14:22.201536 I [35331:70215369422240] RubySkynet::Registry -- Start monitoring /services/*/*/*/*/*
+2012-12-04 15:14:22.201584 T [35331:70215369422240] RubySkynet::Doozer::Client -- Socket Connection parameters -- {:servers=>["127.0.0.1:8046"], :read_timeout=>5, :connect_timeout=>3, :connect_retry_interval=>1, :connect_retry_count=>300, :buffered=>false, :on_connect=>#<Proc:0x007fb8944e7510@/Users/rmorrison/Sandbox/ruby_skynet/lib/ruby_skynet/doozer/client.rb:31>}
+2012-12-04 15:14:22.202447 T [35331:70215369422240] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H
+2012-12-04 15:14:22.202599 D [35331:70215369422240] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 32 bytes
+2012-12-04 15:14:22.203006 D [35331:70215367088860] [50be599e6b69338a03000001] RubySkynet::Connection: localhost:2100 -- Waiting for Service Handshake
+2012-12-04 15:14:22.203779 D [35331:70215367611540] RubySkynet::Server: localhost:2100 -- Waiting for a client to connect
+2012-12-04 15:14:22.203883 D [35331:70215367611540] RubySkynet::Server: localhost:2100 -- Client connected, waiting for data from client
+2012-12-04 15:14:22.204267 E [35331:70215367611540] Celluloid -- RubySkynet::Server crashed!
+NoMethodError: undefined method `read_bson_document' for #<RubySkynet::Server:0x007fb89416c0e8>
+/Users/rmorrison/.rvm/gems/ruby-1.9.3-p194@ruby_skynet/gems/celluloid-0.12.3/lib/celluloid.rb:272:in `method_missing'
+/Users/rmorrison/Sandbox/ruby_skynet/lib/ruby_skynet/server.rb:105:in `handle_connection'
+/Users/rmorrison/.rvm/gems/ruby-1.9.3-p194@ruby_skynet/gems/celluloid-0.12.3/lib/celluloid/calls.rb:99:in `dispatch'
+/Users/rmorrison/.rvm/gems/ruby-1.9.3-p194@ruby_skynet/gems/celluloid-0.12.3/lib/celluloid/actor.rb:323:in `block in handle_message'
+/Users/rmorrison/.rvm/gems/ruby-1.9.3-p194@ruby_skynet/gems/celluloid-0.12.3/lib/celluloid/tasks/task_fiber.rb:22:in `block in initialize'
+2012-12-04 15:14:22.204325 I [35331:70215367611540] RubySkynet::Server: localhost:2100 -- Skynet Server Stopped
+2012-12-04 15:14:22.205644 T [35331:70215367088860] [50be599e6b69338a03000001] ResilientSocket::TCPClient ["localhost:2100"] -- #read <== received -- "9\x00\x00\x00"
+2012-12-04 15:14:22.205678 D [35331:70215367088860] [50be599e6b69338a03000001] (0.1ms) ResilientSocket::TCPClient ["localhost:2100"] -- #read <== read 4 bytes
+2012-12-04 15:14:22.205759 T [35331:70215367088860] [50be599e6b69338a03000001] ResilientSocket::TCPClient ["localhost:2100"] -- #read <== received -- "\bregistered\x00\x01\x02clientid\x00\x19\x00\x00\x0050be599e6b69338a03000002\x00\x00"
+2012-12-04 15:14:22.205770 D [35331:70215367088860] [50be599e6b69338a03000001] (0.0ms) ResilientSocket::TCPClient ["localhost:2100"] -- #read <== read 53 bytes
+2012-12-04 15:14:22.205842 T [35331:70215367088860] [50be599e6b69338a03000001] RubySkynet::Connection: localhost:2100 -- Service Handshake -- {"registered"=>true, "clientid"=>"50be599e6b69338a03000002"}
+2012-12-04 15:14:22.205860 D [35331:70215367088860] [50be599e6b69338a03000001] RubySkynet::Connection: localhost:2100 -- Sending Client Handshake
+2012-12-04 15:14:22.205869 T [35331:70215367088860] [50be599e6b69338a03000001] RubySkynet::Connection: localhost:2100 -- Client Handshake -- {"clientid"=>"50be599e6b69338a03000002"}
+2012-12-04 15:14:22.205895 T [35331:70215367088860] [50be599e6b69338a03000001] ResilientSocket::TCPClient ["localhost:2100"] -- #write ==> sending -- , clientid 50be599e6b69338a03000002
+2012-12-04 15:14:22.206648 D [35331:70215367088860] [50be599e6b69338a03000001] (0.7ms) ResilientSocket::TCPClient ["localhost:2100"] -- #write ==> sent 44 bytes
+2012-12-04 15:14:22.206742 D [35331:70215367088860] [50be599e6b69338a03000001] RubySkynet::Connection: localhost:2100 -- Sending Header
+2012-12-04 15:14:22.206760 T [35331:70215367088860] [50be599e6b69338a03000001] RubySkynet::Connection: localhost:2100 -- Header -- {"servicemethod"=>"RubySkynet.Service.Forward", "seq"=>0}
+2012-12-04 15:14:22.206786 T [35331:70215367088860] [50be599e6b69338a03000001] ResilientSocket::TCPClient ["localhost:2100"] -- #write ==> sending -- <