2012-10-18 15:21:53.934328 T [99879:70100183112400] 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=>#} 2012-10-18 15:21:53.946600 T [99879:70100183112400] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  2012-10-18 15:21:53.946847 D [99879:70100183112400] (0.2ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 8 bytes 2012-10-18 15:21:53.947053 T [99879:70100183112400] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\x06" 2012-10-18 15:21:53.947068 D [99879:70100183112400] (0.2ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 15:21:53.947274 T [99879:70100183112400] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x18\xA7\xAC\x03" 2012-10-18 15:21:53.947291 D [99879:70100183112400] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 6 bytes 2012-10-18 15:21:53.947677 T [99879:70100183112400] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  "/services/*/*/*/*/*8H 2012-10-18 15:21:53.947724 D [99879:70100183112400] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 35 bytes 2012-10-18 15:21:53.948296 T [99879:70100183112400] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\xFA" 2012-10-18 15:21:53.948312 D [99879:70100183112400] (0.6ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 15:21:53.948601 T [99879:70100183112400] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\xBB\xAA\x03*+/services/TestService/1/Test/127.0.0.1/20002\xC2\x01{\"Config\":{\"UUID\":\"3978b371-15e9-40f8-9b7b-59ae88d8c7ec\",\"Name\":\"TestService\",\"Version\":\"1\",\"Region\":\"Test\",\"ServiceAddr\":{\"IPAddress\":\"127.0.0.1\",\"Port\":2000,\"MaxPort\":2999},\"Registered\":true}}" 2012-10-18 15:21:53.948616 D [99879:70100183112400] (0.3ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 250 bytes 2012-10-18 15:21:53.948971 T [99879:70100183112400] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  "/services/*/*/*/*/*8H 2012-10-18 15:21:53.949016 D [99879:70100183112400] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 35 bytes 2012-10-18 15:21:53.949629 T [99879:70100183112400] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x01Q" 2012-10-18 15:21:53.949645 D [99879:70100183112400] (0.6ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 15:21:53.949920 T [99879:70100183112400] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\xEA\xA4\x01*6/services/TutorialService/1/Development/127.0.0.1/90002\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 15:21:53.949934 D [99879:70100183112400] (0.2ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 337 bytes 2012-10-18 15:21:53.950224 T [99879:70100183112400] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  "/services/*/*/*/*/*8H 2012-10-18 15:21:53.950269 D [99879:70100183112400] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 35 bytes 2012-10-18 15:21:53.950632 T [99879:70100183112400] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\x05" 2012-10-18 15:21:53.950648 D [99879:70100183112400] (0.4ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 15:21:53.950881 T [99879:70100183112400] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\xA0\x06\b" 2012-10-18 15:21:53.950909 D [99879:70100183112400] (0.2ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 5 bytes 2012-10-18 15:21:53.969020 D [99879:70100183112400] RubySkynet::Registry -- #monitor Add/Update Service: TutorialService/1/Development => 127.0.0.1:9000 2012-10-18 15:21:53.969757 I [99879:70100182966480] RubySkynet::Registry -- Start monitoring /services/*/*/*/*/* 2012-10-18 15:21:53.972347 T [99879:70100182966480] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 15:21:53.972621 D [99879:70100182966480] (0.3ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 15:22:28.550665 T [99879:70100182966480] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00B" 2012-10-18 15:22:28.550710 D [99879:70100182966480] (34577.6ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 15:22:28.554754 T [99879:70100182966480] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\b\x18\xD2\xAC\x03*6/services/TutorialService/1/Development/127.0.0.1/90002\x00" 2012-10-18 15:22:28.554781 D [99879:70100182966480] (3.9ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 66 bytes 2012-10-18 15:22:28.554973 D [99879:70100182966480] RubySkynet::Registry -- #monitor Service stopped, remove: TutorialService/1/Development => 127.0.0.1:9000 2012-10-18 15:22:28.554996 D [99879:70100182966480] RubySkynet::Registry -- Updated registry -- {} 2012-10-18 15:22:28.555246 T [99879:70100182966480] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*HӬ 2012-10-18 15:22:28.555321 D [99879:70100182966480] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 15:22:42.688952 T [99879:70100182966480] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x01R" 2012-10-18 15:22:42.689016 D [99879:70100182966480] (14133.7ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 15:22:42.689400 T [99879:70100182966480] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\xE2\xAC\x03*6/services/TutorialService/1/Development/127.0.0.1/90002\x8F\x02{\"Config\":{\"UUID\":\"01bfea77-cdb8-42c2-9d4f-2d3e41ea5779\",\"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\":false}" 2012-10-18 15:22:42.689473 D [99879:70100182966480] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 338 bytes 2012-10-18 15:22:42.689841 D [99879:70100182966480] RubySkynet::Registry -- #monitor Service deregistered, remove: TutorialService/1/Development => 127.0.0.1:9000 2012-10-18 15:22:42.689858 D [99879:70100182966480] RubySkynet::Registry -- Updated registry -- {} 2012-10-18 15:22:42.695466 T [99879:70100182966480] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 15:22:42.695660 D [99879:70100182966480] (0.2ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 15:22:42.709035 T [99879:70100182966480] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x01Q" 2012-10-18 15:22:42.709080 D [99879:70100182966480] (13.4ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 15:22:42.709823 T [99879:70100182966480] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\xE3\xAC\x03*6/services/TutorialService/1/Development/127.0.0.1/90002\x8E\x02{\"Config\":{\"UUID\":\"01bfea77-cdb8-42c2-9d4f-2d3e41ea5779\",\"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 15:22:42.709839 D [99879:70100182966480] (0.7ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 337 bytes 2012-10-18 15:22:42.710070 D [99879:70100182966480] RubySkynet::Registry -- #monitor Add/Update Service: TutorialService/1/Development => 127.0.0.1:9000 2012-10-18 15:22:42.710097 D [99879:70100182966480] RubySkynet::Registry -- Updated registry -- {"TutorialService/1/Development"=>["127.0.0.1:9000"]} 2012-10-18 15:22:42.710367 T [99879:70100182966480] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 15:22:42.710446 D [99879:70100182966480] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 15:23:19.257659 T [99879:70100182966480] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00B" 2012-10-18 15:23:19.257706 D [99879:70100182966480] (36547.2ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 15:23:19.258241 T [99879:70100182966480] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\b\x18\x8F\xAD\x03*6/services/TutorialService/1/Development/127.0.0.1/90002\x00" 2012-10-18 15:23:19.258257 D [99879:70100182966480] (0.5ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 66 bytes 2012-10-18 15:23:19.258396 D [99879:70100182966480] RubySkynet::Registry -- #monitor Service stopped, remove: TutorialService/1/Development => 127.0.0.1:9000 2012-10-18 15:23:19.258418 D [99879:70100182966480] RubySkynet::Registry -- Updated registry -- {} 2012-10-18 15:23:19.258659 T [99879:70100182966480] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 15:23:19.258731 D [99879:70100182966480] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 15:23:20.315919 T [99879:70100182966480] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x01R" 2012-10-18 15:23:20.315971 D [99879:70100182966480] (1057.2ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 15:23:20.316477 T [99879:70100182966480] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\x92\xAD\x03*6/services/TutorialService/1/Development/127.0.0.1/90002\x8F\x02{\"Config\":{\"UUID\":\"e04a59bb-4121-4c2c-92b1-66a6acf6c016\",\"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\":false}" 2012-10-18 15:23:20.316494 D [99879:70100182966480] (0.4ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 338 bytes 2012-10-18 15:23:20.316768 D [99879:70100182966480] RubySkynet::Registry -- #monitor Service deregistered, remove: TutorialService/1/Development => 127.0.0.1:9000 2012-10-18 15:23:20.316784 D [99879:70100182966480] RubySkynet::Registry -- Updated registry -- {} 2012-10-18 15:23:20.317031 T [99879:70100182966480] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 15:23:20.317077 D [99879:70100182966480] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 15:23:20.339886 T [99879:70100182966480] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x01Q" 2012-10-18 15:23:20.339930 D [99879:70100182966480] (22.8ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 15:23:20.343164 T [99879:70100182966480] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\x93\xAD\x03*6/services/TutorialService/1/Development/127.0.0.1/90002\x8E\x02{\"Config\":{\"UUID\":\"e04a59bb-4121-4c2c-92b1-66a6acf6c016\",\"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 15:23:20.343181 D [99879:70100182966480] (3.2ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 337 bytes 2012-10-18 15:23:20.343656 D [99879:70100182966480] RubySkynet::Registry -- #monitor Add/Update Service: TutorialService/1/Development => 127.0.0.1:9000 2012-10-18 15:23:20.343673 D [99879:70100182966480] RubySkynet::Registry -- Updated registry -- {"TutorialService/1/Development"=>["127.0.0.1:9000"]} 2012-10-18 15:23:20.343933 T [99879:70100182966480] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 15:23:20.344014 D [99879:70100182966480] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 15:24:02.940305 T [99879:70100183112400] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "+/services/TestService/1/Test/127.0.0.1/2000*{"Config":{"UUID":"3978b371-15e9-40f8-9b7b-59ae88d8c7ec","Name":"TestService","Version":"1","Region":"Test","ServiceAddr":{"IPAddress":"127.0.0.1","Port":2000,"MaxPort":2999},"Registered":true}}H 2012-10-18 15:24:02.940566 D [99879:70100183112400] (0.2ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 261 bytes 2012-10-18 15:24:02.944985 T [99879:70100183112400] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\xFA" 2012-10-18 15:24:02.945006 D [99879:70100183112400] (3.9ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 15:24:02.945095 T [99879:70100183112400] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\xC7\xAD\x03*+/services/TestService/1/Test/127.0.0.1/20002\xC2\x01{\"Config\":{\"UUID\":\"3978b371-15e9-40f8-9b7b-59ae88d8c7ec\",\"Name\":\"TestService\",\"Version\":\"1\",\"Region\":\"Test\",\"ServiceAddr\":{\"IPAddress\":\"127.0.0.1\",\"Port\":2000,\"MaxPort\":2999},\"Registered\":true}}" 2012-10-18 15:24:02.945106 D [99879:70100183112400] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 250 bytes 2012-10-18 15:24:02.946514 T [99879:70100182966480] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\x06" 2012-10-18 15:24:02.946529 D [99879:70100182966480] (42602.5ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 15:24:02.946594 T [99879:70100182966480] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x18\xC7\xAD\x03" 2012-10-18 15:24:02.946605 D [99879:70100182966480] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 6 bytes 2012-10-18 15:24:02.946725 D [99879:70100182966480] RubySkynet::Registry -- #monitor Service stopped, remove: // => : 2012-10-18 15:24:02.946746 D [99879:70100182966480] RubySkynet::Registry -- Updated registry -- {"TutorialService/1/Development"=>["127.0.0.1:9000"]} 2012-10-18 15:24:02.946970 T [99879:70100182966480] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*Hȭ 2012-10-18 15:24:02.947049 D [99879:70100182966480] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 15:38:28.046855 D [323:70164469209820] RubySkynet::Registry -- Doozer Connection Pool: Created connection #1 #(70164469209820) for Doozer Connection Pool 2012-10-18 15:38:28.087425 T [323:70164469209820] 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=>#} 2012-10-18 15:38:28.093667 D [323:70164469209820] RubySkynet::Registry -- Doozer Connection Pool: Renewed connection old=70164469209820 new=#(70164473491060) 2012-10-18 15:38:28.093782 D [323:70164469209820] RubySkynet::Registry -- Doozer Connection Pool: Checkout connection #(70164473491060) self=connections=70164473491060 checked_out=70164473491060 with_map= 2012-10-18 15:38:28.095685 T [323:70164469209820] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  2012-10-18 15:38:28.106607 D [323:70164469209820] (10.9ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 8 bytes 2012-10-18 15:38:28.110564 T [323:70164469209820] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\x06" 2012-10-18 15:38:28.111056 D [323:70164469209820] (4.3ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 15:38:28.111743 T [323:70164469209820] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x18\xD2\xB5\x03" 2012-10-18 15:38:28.111787 D [323:70164469209820] (0.3ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 6 bytes 2012-10-18 15:38:28.112220 T [323:70164469209820] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  "/services/*/*/*/*/*8Hҵ 2012-10-18 15:38:28.112897 D [323:70164469209820] (0.7ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 35 bytes 2012-10-18 15:38:28.113101 T [323:70164469209820] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\xFA" 2012-10-18 15:38:28.113141 D [323:70164469209820] (0.2ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 15:38:28.113385 T [323:70164469209820] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\xC7\xAD\x03*+/services/TestService/1/Test/127.0.0.1/20002\xC2\x01{\"Config\":{\"UUID\":\"3978b371-15e9-40f8-9b7b-59ae88d8c7ec\",\"Name\":\"TestService\",\"Version\":\"1\",\"Region\":\"Test\",\"ServiceAddr\":{\"IPAddress\":\"127.0.0.1\",\"Port\":2000,\"MaxPort\":2999},\"Registered\":true}}" 2012-10-18 15:38:28.113425 D [323:70164469209820] (0.3ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 250 bytes 2012-10-18 15:38:28.113734 T [323:70164469209820] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  "/services/*/*/*/*/*8Hҵ 2012-10-18 15:38:28.114380 D [323:70164469209820] (0.6ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 35 bytes 2012-10-18 15:38:28.114610 T [323:70164469209820] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x01Q" 2012-10-18 15:38:28.114649 D [323:70164469209820] (0.2ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 15:38:28.114972 T [323:70164469209820] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\x93\xAD\x03*6/services/TutorialService/1/Development/127.0.0.1/90002\x8E\x02{\"Config\":{\"UUID\":\"e04a59bb-4121-4c2c-92b1-66a6acf6c016\",\"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 15:38:28.115012 D [323:70164469209820] (0.3ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 337 bytes 2012-10-18 15:38:28.115340 T [323:70164469209820] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  "/services/*/*/*/*/*8Hҵ 2012-10-18 15:38:28.115974 D [323:70164469209820] (0.6ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 35 bytes 2012-10-18 15:38:28.116301 T [323:70164469209820] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\x05" 2012-10-18 15:38:28.116341 D [323:70164469209820] (0.3ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 15:38:28.118413 T [323:70164469209820] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\xA0\x06\b" 2012-10-18 15:38:28.118460 D [323:70164469209820] (2.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 5 bytes 2012-10-18 15:38:28.148238 D [323:70164469209820] RubySkynet::Registry -- #monitor Add/Update Service: TutorialService/1/Development => 127.0.0.1:9000 2012-10-18 15:38:28.148342 D [323:70164469209820] RubySkynet::Registry -- Doozer Connection Pool: Checkin connection #(70164473491060) self=connections=70164473491060 checked_out= with_map= 2012-10-18 15:39:55.152595 D [323:70164469209820] RubySkynet::Registry -- Doozer Connection Pool: Checkout connection #(70164473491060) self=connections=70164473491060 checked_out=70164473491060 with_map= 2012-10-18 15:39:55.153256 T [323:70164469209820] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "+/services/TestService/1/Test/127.0.0.1/2000*{"Config":{"UUID":"3978b371-15e9-40f8-9b7b-59ae88d8c7ec","Name":"TestService","Version":"1","Region":"Test","ServiceAddr":{"IPAddress":"127.0.0.1","Port":2000,"MaxPort":2999},"Registered":true}}H 2012-10-18 15:39:55.153826 D [323:70164469209820] (0.6ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 261 bytes 2012-10-18 15:39:55.155031 T [323:70164469209820] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\x06" 2012-10-18 15:39:55.155322 D [323:70164469209820] (1.4ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 15:39:55.155967 T [323:70164469209820] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x18\xBB\xB6\x03" 2012-10-18 15:39:55.156009 D [323:70164469209820] (0.3ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 6 bytes 2012-10-18 15:39:55.156127 D [323:70164469209820] RubySkynet::Registry -- Doozer Connection Pool: Checkin connection #(70164473491060) self=connections=70164473491060 checked_out= with_map= 2012-10-18 15:40:06.221610 D [323:70164469209820] RubySkynet::Registry -- Doozer Connection Pool: Checkout connection #(70164473491060) self=connections=70164473491060 checked_out=70164473491060 with_map= 2012-10-18 15:40:06.221934 T [323:70164469209820] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- <"+/services/TestService/1/Test/127.0.0.1/2000H 2012-10-18 15:40:06.222246 D [323:70164469209820] (0.3ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 64 bytes 2012-10-18 15:40:06.230778 T [323:70164469209820] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\x02" 2012-10-18 15:40:06.230858 D [323:70164469209820] (8.6ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 15:40:06.231007 T [323:70164469209820] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00" 2012-10-18 15:40:06.231019 D [323:70164469209820] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 2 bytes 2012-10-18 15:40:06.231148 D [323:70164469209820] RubySkynet::Registry -- Doozer Connection Pool: Checkin connection #(70164473491060) self=connections=70164473491060 checked_out= with_map= 2012-10-18 15:40:25.607996 D [323:70164469209820] RubySkynet::Registry -- Doozer Connection Pool: Checkout connection #(70164473491060) self=connections=70164473491060 checked_out=70164473491060 with_map= 2012-10-18 15:40:25.608517 T [323:70164469209820] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "+/services/TestService/1/Test/127.0.0.1/2000*{"Config":{"UUID":"3978b371-15e9-40f8-9b7b-59ae88d8c7ec","Name":"TestService","Version":"1","Region":"Test","ServiceAddr":{"IPAddress":"127.0.0.1","Port":2000,"MaxPort":2999},"Registered":true}}H 2012-10-18 15:40:25.608854 D [323:70164469209820] (0.3ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 261 bytes 2012-10-18 15:40:25.616726 T [323:70164469209820] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\x06" 2012-10-18 15:40:25.616799 D [323:70164469209820] (7.9ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 15:40:25.616968 T [323:70164469209820] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x18\xE2\xB6\x03" 2012-10-18 15:40:25.616979 D [323:70164469209820] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 6 bytes 2012-10-18 15:40:25.617921 D [323:70164469209820] RubySkynet::Registry -- Doozer Connection Pool: Checkin connection #(70164473491060) self=connections=70164473491060 checked_out= with_map= 2012-10-18 15:42:17.306140 D [374:70116826110680] RubySkynet::Registry -- Doozer Connection Pool: Created connection #1 #(70116826110680) for Doozer Connection Pool 2012-10-18 15:42:17.341921 T [374:70116826110680] 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=>#} 2012-10-18 15:42:17.348794 D [374:70116826110680] RubySkynet::Registry -- Doozer Connection Pool: Renewed connection old=70116826110680 new=#(70116826604020) 2012-10-18 15:42:17.348862 D [374:70116826110680] RubySkynet::Registry -- Doozer Connection Pool: Checkout connection #(70116826604020) self=connections=70116826604020 checked_out=70116826604020 with_map= 2012-10-18 15:42:17.349917 T [374:70116826110680] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  2012-10-18 15:42:17.349976 D [374:70116826110680] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 8 bytes 2012-10-18 15:42:17.350661 T [374:70116826110680] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\x06" 2012-10-18 15:42:17.350678 D [374:70116826110680] (0.5ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 15:42:17.350923 T [374:70116826110680] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x18\xF3\xB7\x03" 2012-10-18 15:42:17.350940 D [374:70116826110680] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 6 bytes 2012-10-18 15:42:17.351323 T [374:70116826110680] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  "/services/*/*/*/*/*8H 2012-10-18 15:42:17.351368 D [374:70116826110680] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 35 bytes 2012-10-18 15:42:17.351754 T [374:70116826110680] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\xFA" 2012-10-18 15:42:17.351765 D [374:70116826110680] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 15:42:17.351844 T [374:70116826110680] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\xE2\xB6\x03*+/services/TestService/1/Test/127.0.0.1/20002\xC2\x01{\"Config\":{\"UUID\":\"3978b371-15e9-40f8-9b7b-59ae88d8c7ec\",\"Name\":\"TestService\",\"Version\":\"1\",\"Region\":\"Test\",\"ServiceAddr\":{\"IPAddress\":\"127.0.0.1\",\"Port\":2000,\"MaxPort\":2999},\"Registered\":true}}" 2012-10-18 15:42:17.351854 D [374:70116826110680] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 250 bytes 2012-10-18 15:42:17.352149 T [374:70116826110680] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  "/services/*/*/*/*/*8H 2012-10-18 15:42:17.354396 D [374:70116826110680] (2.2ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 35 bytes 2012-10-18 15:42:17.354660 T [374:70116826110680] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x01Q" 2012-10-18 15:42:17.354677 D [374:70116826110680] (0.2ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 15:42:17.354753 T [374:70116826110680] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\xD4\xB7\x03*6/services/TutorialService/1/Development/127.0.0.1/90002\x8E\x02{\"Config\":{\"UUID\":\"88eeece9-d2f8-4bda-8ccf-b76242e75c5c\",\"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 15:42:17.354763 D [374:70116826110680] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 337 bytes 2012-10-18 15:42:17.355086 T [374:70116826110680] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  "/services/*/*/*/*/*8H 2012-10-18 15:42:17.355132 D [374:70116826110680] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 35 bytes 2012-10-18 15:42:17.355844 T [374:70116826110680] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\x05" 2012-10-18 15:42:17.355887 D [374:70116826110680] (0.7ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 15:42:17.356188 T [374:70116826110680] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\xA0\x06\b" 2012-10-18 15:42:17.356205 D [374:70116826110680] (0.3ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 5 bytes 2012-10-18 15:42:17.371666 D [374:70116826110680] RubySkynet::Registry -- #monitor Add/Update Service: TutorialService/1/Development => 127.0.0.1:9000 2012-10-18 15:42:17.371784 D [374:70116826110680] RubySkynet::Registry -- Doozer Connection Pool: Checkin connection #(70116826604020) self=connections=70116826604020 checked_out= with_map= 2012-10-18 15:44:08.078128 D [405:70315346713300] RubySkynet::Registry -- Doozer Connection Pool: Created connection #1 #(70315346713300) for Doozer Connection Pool 2012-10-18 15:44:08.123638 T [405:70315346713300] 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=>#} 2012-10-18 15:44:08.128067 D [405:70315346713300] RubySkynet::Registry -- Doozer Connection Pool: Renewed connection old=70315346713300 new=#(70315347220800) 2012-10-18 15:44:08.128120 D [405:70315346713300] RubySkynet::Registry -- Doozer Connection Pool: Checkout connection #(70315347220800) self=connections=70315347220800 checked_out=70315347220800 with_map= 2012-10-18 15:44:08.129960 T [405:70315346713300] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  2012-10-18 15:44:08.130319 D [405:70315346713300] (0.3ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 8 bytes 2012-10-18 15:44:08.130462 T [405:70315346713300] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\x06" 2012-10-18 15:44:08.130533 D [405:70315346713300] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 15:44:08.130724 T [405:70315346713300] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x18\xF9\xB8\x03" 2012-10-18 15:44:08.130741 D [405:70315346713300] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 6 bytes 2012-10-18 15:44:08.131101 T [405:70315346713300] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  "/services/*/*/*/*/*8H 2012-10-18 15:44:08.131147 D [405:70315346713300] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 35 bytes 2012-10-18 15:44:08.131970 T [405:70315346713300] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\xFA" 2012-10-18 15:44:08.131981 D [405:70315346713300] (0.8ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 15:44:08.132458 T [405:70315346713300] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\xE2\xB6\x03*+/services/TestService/1/Test/127.0.0.1/20002\xC2\x01{\"Config\":{\"UUID\":\"3978b371-15e9-40f8-9b7b-59ae88d8c7ec\",\"Name\":\"TestService\",\"Version\":\"1\",\"Region\":\"Test\",\"ServiceAddr\":{\"IPAddress\":\"127.0.0.1\",\"Port\":2000,\"MaxPort\":2999},\"Registered\":true}}" 2012-10-18 15:44:08.132661 D [405:70315346713300] (0.6ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 250 bytes 2012-10-18 15:44:08.133002 T [405:70315346713300] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  "/services/*/*/*/*/*8H 2012-10-18 15:44:08.133058 D [405:70315346713300] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 35 bytes 2012-10-18 15:44:08.135628 T [405:70315346713300] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x01Q" 2012-10-18 15:44:08.135649 D [405:70315346713300] (2.6ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 15:44:08.135914 T [405:70315346713300] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\x84\xB8\x03*6/services/TutorialService/1/Development/127.0.0.1/90002\x8E\x02{\"Config\":{\"UUID\":\"115c0c2d-8526-4a57-b534-4834c00a2e11\",\"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 15:44:08.135929 D [405:70315346713300] (0.2ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 337 bytes 2012-10-18 15:44:08.136514 T [405:70315346713300] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  "/services/*/*/*/*/*8H 2012-10-18 15:44:08.136596 D [405:70315346713300] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 35 bytes 2012-10-18 15:44:08.137822 T [405:70315346713300] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\x05" 2012-10-18 15:44:08.137868 D [405:70315346713300] (1.3ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 15:44:08.138188 T [405:70315346713300] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\xA0\x06\b" 2012-10-18 15:44:08.138204 D [405:70315346713300] (0.3ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 5 bytes 2012-10-18 15:44:08.155934 D [405:70315346713300] RubySkynet::Registry -- #start_monitoring Add Service: TutorialService/1/Development => 127.0.0.1:9000 2012-10-18 15:44:08.156005 D [405:70315346713300] RubySkynet::Registry -- Doozer Connection Pool: Checkin connection #(70315347220800) self=connections=70315347220800 checked_out= with_map= 2012-10-18 15:48:45.073017 D [459:70172677462740] RubySkynet::Registry -- Doozer Connection Pool: Created connection #1 #(70172677462740) for Doozer Connection Pool 2012-10-18 15:48:45.108796 T [459:70172677462740] 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=>#} 2012-10-18 15:48:45.113323 D [459:70172677462740] RubySkynet::Registry -- Doozer Connection Pool: Renewed connection old=70172677462740 new=#(70172685747360) 2012-10-18 15:48:45.113373 D [459:70172677462740] RubySkynet::Registry -- Doozer Connection Pool: Checkout connection #(70172685747360) self=connections=70172685747360 checked_out=70172685747360 with_map= 2012-10-18 15:48:45.115018 T [459:70172677462740] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  2012-10-18 15:48:45.115464 D [459:70172677462740] (0.4ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 8 bytes 2012-10-18 15:48:45.115532 T [459:70172677462740] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\x06" 2012-10-18 15:48:45.115542 D [459:70172677462740] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 15:48:45.115719 T [459:70172677462740] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x18\xC8\xBB\x03" 2012-10-18 15:48:45.115735 D [459:70172677462740] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 6 bytes 2012-10-18 15:48:45.116102 T [459:70172677462740] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  "/services/*/*/*/*/*8HȻ 2012-10-18 15:48:45.116148 D [459:70172677462740] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 35 bytes 2012-10-18 15:48:45.117165 T [459:70172677462740] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\xFA" 2012-10-18 15:48:45.117181 D [459:70172677462740] (1.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 15:48:45.117269 T [459:70172677462740] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\xE2\xB6\x03*+/services/TestService/1/Test/127.0.0.1/20002\xC2\x01{\"Config\":{\"UUID\":\"3978b371-15e9-40f8-9b7b-59ae88d8c7ec\",\"Name\":\"TestService\",\"Version\":\"1\",\"Region\":\"Test\",\"ServiceAddr\":{\"IPAddress\":\"127.0.0.1\",\"Port\":2000,\"MaxPort\":2999},\"Registered\":true}}" 2012-10-18 15:48:45.117279 D [459:70172677462740] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 250 bytes 2012-10-18 15:48:45.117598 T [459:70172677462740] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  "/services/*/*/*/*/*8HȻ 2012-10-18 15:48:45.117668 D [459:70172677462740] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 35 bytes 2012-10-18 15:48:45.121498 T [459:70172677462740] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x01Q" 2012-10-18 15:48:45.121518 D [459:70172677462740] (3.8ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 15:48:45.121609 T [459:70172677462740] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\x8A\xB9\x03*6/services/TutorialService/1/Development/127.0.0.1/90002\x8E\x02{\"Config\":{\"UUID\":\"70c03cc2-d840-492d-aaa9-bab90d75ac09\",\"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 15:48:45.121620 D [459:70172677462740] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 337 bytes 2012-10-18 15:48:45.121951 T [459:70172677462740] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  "/services/*/*/*/*/*8HȻ 2012-10-18 15:48:45.121993 D [459:70172677462740] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 35 bytes 2012-10-18 15:48:45.122832 T [459:70172677462740] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\x05" 2012-10-18 15:48:45.122850 D [459:70172677462740] (0.8ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 15:48:45.122925 T [459:70172677462740] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\xA0\x06\b" 2012-10-18 15:48:45.122935 D [459:70172677462740] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 5 bytes 2012-10-18 15:48:45.140081 D [459:70172677462740] RubySkynet::Registry -- #start_monitoring Add Service: TutorialService/1/Development => 127.0.0.1:9000 2012-10-18 15:48:45.140160 D [459:70172677462740] RubySkynet::Registry -- Doozer Connection Pool: Checkin connection #(70172685747360) self=connections=70172685747360 checked_out= with_map= 2012-10-18 15:49:52.048902 D [483:70159729646300] RubySkynet::Registry -- Doozer Connection Pool: Created connection #1 #(70159729646300) for Doozer Connection Pool 2012-10-18 15:49:52.076609 T [483:70159729646300] 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=>#} 2012-10-18 15:49:52.080579 D [483:70159729646300] RubySkynet::Registry -- Doozer Connection Pool: Renewed connection old=70159729646300 new=#(70159730074460) 2012-10-18 15:49:52.080635 D [483:70159729646300] RubySkynet::Registry -- Doozer Connection Pool: Checkout connection #(70159730074460) self=connections=70159730074460 checked_out=70159730074460 with_map= 2012-10-18 15:49:52.081732 T [483:70159729646300] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  2012-10-18 15:49:52.081788 D [483:70159729646300] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 8 bytes 2012-10-18 15:49:52.082505 T [483:70159729646300] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\x06" 2012-10-18 15:49:52.082521 D [483:70159729646300] (0.7ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 15:49:52.082685 T [483:70159729646300] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x18\x98\xBC\x03" 2012-10-18 15:49:52.082701 D [483:70159729646300] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 6 bytes 2012-10-18 15:49:52.083049 T [483:70159729646300] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  "/services/*/*/*/*/*8H 2012-10-18 15:49:52.083089 D [483:70159729646300] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 35 bytes 2012-10-18 15:49:52.083959 T [483:70159729646300] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\xFA" 2012-10-18 15:49:52.083976 D [483:70159729646300] (0.9ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 15:49:52.084059 T [483:70159729646300] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\xE2\xB6\x03*+/services/TestService/1/Test/127.0.0.1/20002\xC2\x01{\"Config\":{\"UUID\":\"3978b371-15e9-40f8-9b7b-59ae88d8c7ec\",\"Name\":\"TestService\",\"Version\":\"1\",\"Region\":\"Test\",\"ServiceAddr\":{\"IPAddress\":\"127.0.0.1\",\"Port\":2000,\"MaxPort\":2999},\"Registered\":true}}" 2012-10-18 15:49:52.084069 D [483:70159729646300] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 250 bytes 2012-10-18 15:49:52.084377 T [483:70159729646300] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  "/services/*/*/*/*/*8H 2012-10-18 15:49:52.084447 D [483:70159729646300] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 35 bytes 2012-10-18 15:49:52.085479 T [483:70159729646300] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x01Q" 2012-10-18 15:49:52.085495 D [483:70159729646300] (1.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 15:49:52.085595 T [483:70159729646300] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\x8A\xB9\x03*6/services/TutorialService/1/Development/127.0.0.1/90002\x8E\x02{\"Config\":{\"UUID\":\"70c03cc2-d840-492d-aaa9-bab90d75ac09\",\"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 15:49:52.085605 D [483:70159729646300] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 337 bytes 2012-10-18 15:49:52.085872 T [483:70159729646300] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  "/services/*/*/*/*/*8H 2012-10-18 15:49:52.085942 D [483:70159729646300] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 35 bytes 2012-10-18 15:49:52.087093 T [483:70159729646300] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\x05" 2012-10-18 15:49:52.087109 D [483:70159729646300] (1.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 15:49:52.087169 T [483:70159729646300] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\xA0\x06\b" 2012-10-18 15:49:52.087179 D [483:70159729646300] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 5 bytes 2012-10-18 15:49:52.114693 D [483:70159729646300] RubySkynet::Registry -- #start_monitoring Add Service: TutorialService/1/Development => 127.0.0.1:9000 2012-10-18 15:49:52.114756 D [483:70159729646300] RubySkynet::Registry -- Doozer Connection Pool: Checkin connection #(70159730074460) self=connections=70159730074460 checked_out= with_map= 2012-10-18 15:49:52.118239 I [483:70159729646300] RubySkynet::Registry -- Thread started # 2012-10-18 16:02:36.297403 D [600:70321441037020] RubySkynet::Registry -- Doozer Connection Pool: Created connection #1 #(70321441037020) for Doozer Connection Pool 2012-10-18 16:02:36.333190 T [600:70321441037020] 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=>#} 2012-10-18 16:02:36.337825 D [600:70321441037020] RubySkynet::Registry -- Doozer Connection Pool: Renewed connection old=70321441037020 new=#(70321441685520) 2012-10-18 16:02:36.337877 D [600:70321441037020] RubySkynet::Registry -- Doozer Connection Pool: Checkout connection #(70321441685520) self=connections=70321441685520 checked_out=70321441685520 with_map= 2012-10-18 16:02:36.339766 T [600:70321441037020] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  2012-10-18 16:02:36.339830 D [600:70321441037020] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 8 bytes 2012-10-18 16:02:36.340069 T [600:70321441037020] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\x06" 2012-10-18 16:02:36.340081 D [600:70321441037020] (0.2ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:02:36.340267 T [600:70321441037020] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x18\xAB\xC3\x03" 2012-10-18 16:02:36.340283 D [600:70321441037020] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 6 bytes 2012-10-18 16:02:36.340636 T [600:70321441037020] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  "/services/*/*/*/*/*8H 2012-10-18 16:02:36.340683 D [600:70321441037020] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 35 bytes 2012-10-18 16:02:36.342289 T [600:70321441037020] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\xFA" 2012-10-18 16:02:36.342305 D [600:70321441037020] (1.6ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:02:36.342396 T [600:70321441037020] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\xE2\xB6\x03*+/services/TestService/1/Test/127.0.0.1/20002\xC2\x01{\"Config\":{\"UUID\":\"3978b371-15e9-40f8-9b7b-59ae88d8c7ec\",\"Name\":\"TestService\",\"Version\":\"1\",\"Region\":\"Test\",\"ServiceAddr\":{\"IPAddress\":\"127.0.0.1\",\"Port\":2000,\"MaxPort\":2999},\"Registered\":true}}" 2012-10-18 16:02:36.342407 D [600:70321441037020] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 250 bytes 2012-10-18 16:02:36.342735 T [600:70321441037020] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  "/services/*/*/*/*/*8H 2012-10-18 16:02:36.342821 D [600:70321441037020] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 35 bytes 2012-10-18 16:02:36.343838 T [600:70321441037020] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x01Q" 2012-10-18 16:02:36.343852 D [600:70321441037020] (1.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:02:36.343957 T [600:70321441037020] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\x8A\xB9\x03*6/services/TutorialService/1/Development/127.0.0.1/90002\x8E\x02{\"Config\":{\"UUID\":\"70c03cc2-d840-492d-aaa9-bab90d75ac09\",\"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 16:02:36.343968 D [600:70321441037020] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 337 bytes 2012-10-18 16:02:36.344285 T [600:70321441037020] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  "/services/*/*/*/*/*8H 2012-10-18 16:02:36.344328 D [600:70321441037020] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 35 bytes 2012-10-18 16:02:36.344721 T [600:70321441037020] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\x05" 2012-10-18 16:02:36.344733 D [600:70321441037020] (0.4ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:02:36.344792 T [600:70321441037020] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\xA0\x06\b" 2012-10-18 16:02:36.344802 D [600:70321441037020] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 5 bytes 2012-10-18 16:02:36.363590 D [600:70321441037020] RubySkynet::Registry -- #start_monitoring Add Service: TutorialService/1/Development => 127.0.0.1:9000 2012-10-18 16:02:36.363663 D [600:70321441037020] RubySkynet::Registry -- Doozer Connection Pool: Checkin connection #(70321441685520) self=connections=70321441685520 checked_out= with_map= 2012-10-18 16:02:36.366899 I [600:70321441037020] RubySkynet::Registry -- Thread started # 2012-10-18 16:03:29.647785 T [600:70321441037020] 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=>#} 2012-10-18 16:04:02.360776 I [600:70321441037020] RubySkynet::Registry -- Start monitoring /services/*/*/*/*/* 2012-10-18 16:04:02.361006 T [600:70321441037020] 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=>#} 2012-10-18 16:04:02.361994 T [600:70321441037020] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:04:02.362115 D [600:70321441037020] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 16:04:47.973433 D [600:70321441037020] (45611.3ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes -- IRB::Abort: abort then interrupt! /Users/rmorrison/.rvm/rubies/ruby-1.9.3-p194/lib/ruby/1.9.1/irb.rb:88:in `irb_abort' /Users/rmorrison/.rvm/rubies/ruby-1.9.3-p194/lib/ruby/1.9.1/irb.rb:257:in `signal_handle' /Users/rmorrison/.rvm/rubies/ruby-1.9.3-p194/lib/ruby/1.9.1/irb.rb:65:in `block in start' /Users/rmorrison/.rvm/gems/ruby-1.9.3-p194@ruby_skynet/gems/resilient_socket-0.3.0/lib/resilient_socket/tcp_client.rb:397:in `call' /Users/rmorrison/.rvm/gems/ruby-1.9.3-p194@ruby_skynet/gems/resilient_socket-0.3.0/lib/resilient_socket/tcp_client.rb:397:in `read' /Users/rmorrison/.rvm/gems/ruby-1.9.3-p194@ruby_skynet/gems/resilient_socket-0.3.0/lib/resilient_socket/tcp_client.rb:397:in `block in read' /Users/rmorrison/.rvm/gems/ruby-1.9.3-p194@ruby_skynet/gems/semantic_logger-0.7.0/lib/semantic_logger/base.rb:181:in `benchmark_debug' /Users/rmorrison/.rvm/gems/ruby-1.9.3-p194@ruby_skynet/gems/resilient_socket-0.3.0/lib/resilient_socket/tcp_client.rb:373:in `read' /Users/rmorrison/Sandbox/ruby_skynet/lib/ruby_skynet/doozer/client.rb:202:in `read' /Users/rmorrison/Sandbox/ruby_skynet/lib/ruby_skynet/doozer/client.rb:181:in `block in invoke' /Users/rmorrison/.rvm/gems/ruby-1.9.3-p194@ruby_skynet/gems/resilient_socket-0.3.0/lib/resilient_socket/tcp_client.rb:465:in `retry_on_connection_failure' /Users/rmorrison/Sandbox/ruby_skynet/lib/ruby_skynet/doozer/client.rb:179:in `invoke' /Users/rmorrison/Sandbox/ruby_skynet/lib/ruby_skynet/doozer/client.rb:148:in `wait' /Users/rmorrison/Sandbox/ruby_skynet/lib/ruby_skynet/doozer/client.rb:160:in `block in watch' /Users/rmorrison/Sandbox/ruby_skynet/lib/ruby_skynet/doozer/client.rb:159:in `loop' /Users/rmorrison/Sandbox/ruby_skynet/lib/ruby_skynet/doozer/client.rb:159:in `watch' /Users/rmorrison/Sandbox/ruby_skynet/lib/ruby_skynet/registry.rb:197:in `watch' (irb):11:in `irb_binding' /Users/rmorrison/.rvm/rubies/ruby-1.9.3-p194/lib/ruby/1.9.1/irb/workspace.rb:80:in `eval' /Users/rmorrison/.rvm/rubies/ruby-1.9.3-p194/lib/ruby/1.9.1/irb/workspace.rb:80:in `evaluate' /Users/rmorrison/.rvm/rubies/ruby-1.9.3-p194/lib/ruby/1.9.1/irb/context.rb:254:in `evaluate' /Users/rmorrison/.rvm/rubies/ruby-1.9.3-p194/lib/ruby/1.9.1/irb.rb:159:in `block (2 levels) in eval_input' /Users/rmorrison/.rvm/rubies/ruby-1.9.3-p194/lib/ruby/1.9.1/irb.rb:273:in `signal_status' /Users/rmorrison/.rvm/rubies/ruby-1.9.3-p194/lib/ruby/1.9.1/irb.rb:156:in `block in eval_input' /Users/rmorrison/.rvm/rubies/ruby-1.9.3-p194/lib/ruby/1.9.1/irb/ruby-lex.rb:243:in `block (2 levels) in each_top_level_statement' /Users/rmorrison/.rvm/rubies/ruby-1.9.3-p194/lib/ruby/1.9.1/irb/ruby-lex.rb:229:in `loop' /Users/rmorrison/.rvm/rubies/ruby-1.9.3-p194/lib/ruby/1.9.1/irb/ruby-lex.rb:229:in `block in each_top_level_statement' /Users/rmorrison/.rvm/rubies/ruby-1.9.3-p194/lib/ruby/1.9.1/irb/ruby-lex.rb:228:in `catch' /Users/rmorrison/.rvm/rubies/ruby-1.9.3-p194/lib/ruby/1.9.1/irb/ruby-lex.rb:228:in `each_top_level_statement' /Users/rmorrison/.rvm/rubies/ruby-1.9.3-p194/lib/ruby/1.9.1/irb.rb:155:in `eval_input' /Users/rmorrison/.rvm/rubies/ruby-1.9.3-p194/lib/ruby/1.9.1/irb.rb:70:in `block in start' /Users/rmorrison/.rvm/rubies/ruby-1.9.3-p194/lib/ruby/1.9.1/irb.rb:69:in `catch' /Users/rmorrison/.rvm/rubies/ruby-1.9.3-p194/lib/ruby/1.9.1/irb.rb:69:in `start' /Users/rmorrison/.rvm/rubies/ruby-1.9.3-p194/bin/irb:16:in `
' 2012-10-18 16:04:47.973525 I [600:70321441037020] RubySkynet::Registry -- Stopped monitoring 2012-10-18 16:05:01.900694 D [634:70225278229200] RubySkynet::Registry -- Doozer Connection Pool: Created connection #1 #(70225278229200) for Doozer Connection Pool 2012-10-18 16:05:01.934374 T [634:70225278229200] 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=>#} 2012-10-18 16:05:01.939151 D [634:70225278229200] RubySkynet::Registry -- Doozer Connection Pool: Renewed connection old=70225278229200 new=#(70225278698580) 2012-10-18 16:05:01.939206 D [634:70225278229200] RubySkynet::Registry -- Doozer Connection Pool: Checkout connection #(70225278698580) self=connections=70225278698580 checked_out=70225278698580 with_map= 2012-10-18 16:05:01.942287 T [634:70225278229200] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  2012-10-18 16:05:01.942765 D [634:70225278229200] (0.5ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 8 bytes 2012-10-18 16:05:01.942957 T [634:70225278229200] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\x06" 2012-10-18 16:05:01.942969 D [634:70225278229200] (0.2ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:05:01.943183 T [634:70225278229200] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x18\xD9\xC4\x03" 2012-10-18 16:05:01.943200 D [634:70225278229200] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 6 bytes 2012-10-18 16:05:01.943556 T [634:70225278229200] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  "/services/*/*/*/*/*8H 2012-10-18 16:05:01.943619 D [634:70225278229200] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 35 bytes 2012-10-18 16:05:01.944469 T [634:70225278229200] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\xFA" 2012-10-18 16:05:01.944485 D [634:70225278229200] (0.8ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:05:01.944575 T [634:70225278229200] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\xE2\xB6\x03*+/services/TestService/1/Test/127.0.0.1/20002\xC2\x01{\"Config\":{\"UUID\":\"3978b371-15e9-40f8-9b7b-59ae88d8c7ec\",\"Name\":\"TestService\",\"Version\":\"1\",\"Region\":\"Test\",\"ServiceAddr\":{\"IPAddress\":\"127.0.0.1\",\"Port\":2000,\"MaxPort\":2999},\"Registered\":true}}" 2012-10-18 16:05:01.944586 D [634:70225278229200] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 250 bytes 2012-10-18 16:05:01.944901 T [634:70225278229200] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  "/services/*/*/*/*/*8H 2012-10-18 16:05:01.944960 D [634:70225278229200] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 35 bytes 2012-10-18 16:05:01.945875 T [634:70225278229200] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x01Q" 2012-10-18 16:05:01.945906 D [634:70225278229200] (0.9ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:05:01.945983 T [634:70225278229200] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\x8A\xB9\x03*6/services/TutorialService/1/Development/127.0.0.1/90002\x8E\x02{\"Config\":{\"UUID\":\"70c03cc2-d840-492d-aaa9-bab90d75ac09\",\"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 16:05:01.946018 D [634:70225278229200] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 337 bytes 2012-10-18 16:05:01.946293 T [634:70225278229200] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  "/services/*/*/*/*/*8H 2012-10-18 16:05:01.946339 D [634:70225278229200] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 35 bytes 2012-10-18 16:05:01.947568 T [634:70225278229200] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\x05" 2012-10-18 16:05:01.947587 D [634:70225278229200] (1.2ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:05:01.947721 T [634:70225278229200] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\xA0\x06\b" 2012-10-18 16:05:01.947733 D [634:70225278229200] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 5 bytes 2012-10-18 16:05:01.965077 D [634:70225278229200] RubySkynet::Registry -- #start_monitoring Add Service: TutorialService/1/Development => 127.0.0.1:9000 2012-10-18 16:05:01.965147 D [634:70225278229200] RubySkynet::Registry -- Doozer Connection Pool: Checkin connection #(70225278698580) self=connections=70225278698580 checked_out= with_map= 2012-10-18 16:05:01.969374 I [634:70225278229200] RubySkynet::Registry -- Thread started # 2012-10-18 16:05:34.484408 D [634:70225278229200] RubySkynet::Registry -- Doozer Connection Pool: Checkout connection #(70225278698580) self=connections=70225278698580 checked_out=70225278698580 with_map= 2012-10-18 16:05:34.484663 T [634:70225278229200] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  2012-10-18 16:05:34.484743 D [634:70225278229200] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 8 bytes 2012-10-18 16:05:34.485039 T [634:70225278229200] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\x06" 2012-10-18 16:05:34.485051 D [634:70225278229200] (0.3ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:05:34.485118 T [634:70225278229200] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x18\x80\xC5\x03" 2012-10-18 16:05:34.485129 D [634:70225278229200] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 6 bytes 2012-10-18 16:05:34.485442 T [634:70225278229200] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  "/services/*/*/*/*/*8H 2012-10-18 16:05:34.485519 D [634:70225278229200] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 35 bytes 2012-10-18 16:05:34.486622 T [634:70225278229200] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\xFA" 2012-10-18 16:05:34.486639 D [634:70225278229200] (1.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:05:34.486795 T [634:70225278229200] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\xE2\xB6\x03*+/services/TestService/1/Test/127.0.0.1/20002\xC2\x01{\"Config\":{\"UUID\":\"3978b371-15e9-40f8-9b7b-59ae88d8c7ec\",\"Name\":\"TestService\",\"Version\":\"1\",\"Region\":\"Test\",\"ServiceAddr\":{\"IPAddress\":\"127.0.0.1\",\"Port\":2000,\"MaxPort\":2999},\"Registered\":true}}" 2012-10-18 16:05:34.486806 D [634:70225278229200] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 250 bytes 2012-10-18 16:05:34.487090 T [634:70225278229200] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  "/services/*/*/*/*/*8H 2012-10-18 16:05:34.487136 D [634:70225278229200] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 35 bytes 2012-10-18 16:05:34.487863 T [634:70225278229200] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x01Q" 2012-10-18 16:05:34.487877 D [634:70225278229200] (0.7ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:05:34.487958 T [634:70225278229200] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\x8A\xB9\x03*6/services/TutorialService/1/Development/127.0.0.1/90002\x8E\x02{\"Config\":{\"UUID\":\"70c03cc2-d840-492d-aaa9-bab90d75ac09\",\"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 16:05:34.487968 D [634:70225278229200] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 337 bytes 2012-10-18 16:05:34.488247 T [634:70225278229200] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  "/services/*/*/*/*/*8H 2012-10-18 16:05:34.488320 D [634:70225278229200] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 35 bytes 2012-10-18 16:05:34.489937 T [634:70225278229200] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\x05" 2012-10-18 16:05:34.489956 D [634:70225278229200] (1.6ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:05:34.490027 T [634:70225278229200] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\xA0\x06\b" 2012-10-18 16:05:34.490038 D [634:70225278229200] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 5 bytes 2012-10-18 16:05:34.490230 D [634:70225278229200] RubySkynet::Registry -- #start_monitoring Add Service: TutorialService/1/Development => 127.0.0.1:9000 2012-10-18 16:05:34.490277 D [634:70225278229200] RubySkynet::Registry -- Doozer Connection Pool: Checkin connection #(70225278698580) self=connections=70225278698580 checked_out= with_map= 2012-10-18 16:05:34.490355 I [634:70225278229200] RubySkynet::Registry -- Thread started # 2012-10-18 16:06:18.508871 I [634:70225278229200] RubySkynet::Registry -- Start monitoring /services/*/*/*/*/* 2012-10-18 16:06:18.508972 T [634:70225278229200] 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=>#} 2012-10-18 16:06:18.509871 T [634:70225278229200] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:06:18.509936 D [634:70225278229200] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 16:07:12.211642 D [634:70225278229200] (53701.7ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes -- IRB::Abort: abort then interrupt! /Users/rmorrison/.rvm/rubies/ruby-1.9.3-p194/lib/ruby/1.9.1/irb.rb:88:in `irb_abort' /Users/rmorrison/.rvm/rubies/ruby-1.9.3-p194/lib/ruby/1.9.1/irb.rb:257:in `signal_handle' /Users/rmorrison/.rvm/rubies/ruby-1.9.3-p194/lib/ruby/1.9.1/irb.rb:65:in `block in start' /Users/rmorrison/.rvm/gems/ruby-1.9.3-p194@ruby_skynet/gems/resilient_socket-0.3.0/lib/resilient_socket/tcp_client.rb:397:in `call' /Users/rmorrison/.rvm/gems/ruby-1.9.3-p194@ruby_skynet/gems/resilient_socket-0.3.0/lib/resilient_socket/tcp_client.rb:397:in `read' /Users/rmorrison/.rvm/gems/ruby-1.9.3-p194@ruby_skynet/gems/resilient_socket-0.3.0/lib/resilient_socket/tcp_client.rb:397:in `block in read' /Users/rmorrison/.rvm/gems/ruby-1.9.3-p194@ruby_skynet/gems/semantic_logger-0.7.0/lib/semantic_logger/base.rb:181:in `benchmark_debug' /Users/rmorrison/.rvm/gems/ruby-1.9.3-p194@ruby_skynet/gems/resilient_socket-0.3.0/lib/resilient_socket/tcp_client.rb:373:in `read' /Users/rmorrison/Sandbox/ruby_skynet/lib/ruby_skynet/doozer/client.rb:202:in `read' /Users/rmorrison/Sandbox/ruby_skynet/lib/ruby_skynet/doozer/client.rb:181:in `block in invoke' /Users/rmorrison/.rvm/gems/ruby-1.9.3-p194@ruby_skynet/gems/resilient_socket-0.3.0/lib/resilient_socket/tcp_client.rb:465:in `retry_on_connection_failure' /Users/rmorrison/Sandbox/ruby_skynet/lib/ruby_skynet/doozer/client.rb:179:in `invoke' /Users/rmorrison/Sandbox/ruby_skynet/lib/ruby_skynet/doozer/client.rb:148:in `wait' /Users/rmorrison/Sandbox/ruby_skynet/lib/ruby_skynet/doozer/client.rb:160:in `block in watch' /Users/rmorrison/Sandbox/ruby_skynet/lib/ruby_skynet/doozer/client.rb:159:in `loop' /Users/rmorrison/Sandbox/ruby_skynet/lib/ruby_skynet/doozer/client.rb:159:in `watch' /Users/rmorrison/Sandbox/ruby_skynet/lib/ruby_skynet/registry.rb:197:in `watch' (irb):10:in `irb_binding' /Users/rmorrison/.rvm/rubies/ruby-1.9.3-p194/lib/ruby/1.9.1/irb/workspace.rb:80:in `eval' /Users/rmorrison/.rvm/rubies/ruby-1.9.3-p194/lib/ruby/1.9.1/irb/workspace.rb:80:in `evaluate' /Users/rmorrison/.rvm/rubies/ruby-1.9.3-p194/lib/ruby/1.9.1/irb/context.rb:254:in `evaluate' /Users/rmorrison/.rvm/rubies/ruby-1.9.3-p194/lib/ruby/1.9.1/irb.rb:159:in `block (2 levels) in eval_input' /Users/rmorrison/.rvm/rubies/ruby-1.9.3-p194/lib/ruby/1.9.1/irb.rb:273:in `signal_status' /Users/rmorrison/.rvm/rubies/ruby-1.9.3-p194/lib/ruby/1.9.1/irb.rb:156:in `block in eval_input' /Users/rmorrison/.rvm/rubies/ruby-1.9.3-p194/lib/ruby/1.9.1/irb/ruby-lex.rb:243:in `block (2 levels) in each_top_level_statement' /Users/rmorrison/.rvm/rubies/ruby-1.9.3-p194/lib/ruby/1.9.1/irb/ruby-lex.rb:229:in `loop' /Users/rmorrison/.rvm/rubies/ruby-1.9.3-p194/lib/ruby/1.9.1/irb/ruby-lex.rb:229:in `block in each_top_level_statement' /Users/rmorrison/.rvm/rubies/ruby-1.9.3-p194/lib/ruby/1.9.1/irb/ruby-lex.rb:228:in `catch' /Users/rmorrison/.rvm/rubies/ruby-1.9.3-p194/lib/ruby/1.9.1/irb/ruby-lex.rb:228:in `each_top_level_statement' /Users/rmorrison/.rvm/rubies/ruby-1.9.3-p194/lib/ruby/1.9.1/irb.rb:155:in `eval_input' /Users/rmorrison/.rvm/rubies/ruby-1.9.3-p194/lib/ruby/1.9.1/irb.rb:70:in `block in start' /Users/rmorrison/.rvm/rubies/ruby-1.9.3-p194/lib/ruby/1.9.1/irb.rb:69:in `catch' /Users/rmorrison/.rvm/rubies/ruby-1.9.3-p194/lib/ruby/1.9.1/irb.rb:69:in `start' /Users/rmorrison/.rvm/rubies/ruby-1.9.3-p194/bin/irb:16:in `
' 2012-10-18 16:07:12.212161 I [634:70225278229200] RubySkynet::Registry -- Stopped monitoring 2012-10-18 16:07:18.852749 D [663:70126313626320] RubySkynet::Registry -- Doozer Connection Pool: Created connection #1 #(70126313626320) for Doozer Connection Pool 2012-10-18 16:07:18.876006 T [663:70126313626320] 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=>#} 2012-10-18 16:07:18.880360 D [663:70126313626320] RubySkynet::Registry -- Doozer Connection Pool: Renewed connection old=70126313626320 new=#(70126317858300) 2012-10-18 16:07:18.880419 D [663:70126313626320] RubySkynet::Registry -- Doozer Connection Pool: Checkout connection #(70126317858300) self=connections=70126317858300 checked_out=70126317858300 with_map= 2012-10-18 16:07:18.881519 T [663:70126313626320] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  2012-10-18 16:07:18.881575 D [663:70126313626320] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 8 bytes 2012-10-18 16:07:18.882293 T [663:70126313626320] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\x06" 2012-10-18 16:07:18.882310 D [663:70126313626320] (0.7ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:07:18.882488 T [663:70126313626320] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x18\xFC\xC5\x03" 2012-10-18 16:07:18.882504 D [663:70126313626320] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 6 bytes 2012-10-18 16:07:18.882861 T [663:70126313626320] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  "/services/*/*/*/*/*8H 2012-10-18 16:07:18.882905 D [663:70126313626320] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 35 bytes 2012-10-18 16:07:18.883600 T [663:70126313626320] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\xFA" 2012-10-18 16:07:18.883616 D [663:70126313626320] (0.7ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:07:18.883706 T [663:70126313626320] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\xE2\xB6\x03*+/services/TestService/1/Test/127.0.0.1/20002\xC2\x01{\"Config\":{\"UUID\":\"3978b371-15e9-40f8-9b7b-59ae88d8c7ec\",\"Name\":\"TestService\",\"Version\":\"1\",\"Region\":\"Test\",\"ServiceAddr\":{\"IPAddress\":\"127.0.0.1\",\"Port\":2000,\"MaxPort\":2999},\"Registered\":true}}" 2012-10-18 16:07:18.883716 D [663:70126313626320] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 250 bytes 2012-10-18 16:07:18.884026 T [663:70126313626320] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  "/services/*/*/*/*/*8H 2012-10-18 16:07:18.884085 D [663:70126313626320] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 35 bytes 2012-10-18 16:07:18.884780 T [663:70126313626320] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x01Q" 2012-10-18 16:07:18.884830 D [663:70126313626320] (0.7ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:07:18.884938 T [663:70126313626320] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\x8A\xB9\x03*6/services/TutorialService/1/Development/127.0.0.1/90002\x8E\x02{\"Config\":{\"UUID\":\"70c03cc2-d840-492d-aaa9-bab90d75ac09\",\"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 16:07:18.884949 D [663:70126313626320] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 337 bytes 2012-10-18 16:07:18.885212 T [663:70126313626320] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  "/services/*/*/*/*/*8H 2012-10-18 16:07:18.885270 D [663:70126313626320] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 35 bytes 2012-10-18 16:07:18.886107 T [663:70126313626320] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\x05" 2012-10-18 16:07:18.886123 D [663:70126313626320] (0.8ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:07:18.886434 T [663:70126313626320] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\xA0\x06\b" 2012-10-18 16:07:18.886450 D [663:70126313626320] (0.3ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 5 bytes 2012-10-18 16:07:18.900562 D [663:70126313626320] RubySkynet::Registry -- #start_monitoring Add Service: TutorialService/1/Development => 127.0.0.1:9000 2012-10-18 16:07:18.900631 D [663:70126313626320] RubySkynet::Registry -- Doozer Connection Pool: Checkin connection #(70126317858300) self=connections=70126317858300 checked_out= with_map= 2012-10-18 16:07:18.903965 I [663:70126313626320] RubySkynet::Registry -- Thread started # 2012-10-18 16:07:47.578007 D [679:70106646534880] RubySkynet::Registry -- Doozer Connection Pool: Created connection #1 #(70106646534880) for Doozer Connection Pool 2012-10-18 16:07:47.611487 T [679:70106646534880] 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=>#} 2012-10-18 16:07:47.617092 D [679:70106646534880] RubySkynet::Registry -- Doozer Connection Pool: Renewed connection old=70106646534880 new=#(70106646716020) 2012-10-18 16:07:47.617153 D [679:70106646534880] RubySkynet::Registry -- Doozer Connection Pool: Checkout connection #(70106646716020) self=connections=70106646716020 checked_out=70106646716020 with_map= 2012-10-18 16:07:47.618197 T [679:70106646534880] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  2012-10-18 16:07:47.618583 D [679:70106646534880] (0.4ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 8 bytes 2012-10-18 16:07:47.618800 T [679:70106646534880] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\x06" 2012-10-18 16:07:47.618817 D [679:70106646534880] (0.2ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:07:47.619003 T [679:70106646534880] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x18\x9F\xC6\x03" 2012-10-18 16:07:47.619021 D [679:70106646534880] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 6 bytes 2012-10-18 16:07:47.619374 T [679:70106646534880] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  "/services/*/*/*/*/*8H 2012-10-18 16:07:47.619420 D [679:70106646534880] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 35 bytes 2012-10-18 16:07:47.620234 T [679:70106646534880] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\xFA" 2012-10-18 16:07:47.620251 D [679:70106646534880] (0.8ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:07:47.620565 T [679:70106646534880] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\xE2\xB6\x03*+/services/TestService/1/Test/127.0.0.1/20002\xC2\x01{\"Config\":{\"UUID\":\"3978b371-15e9-40f8-9b7b-59ae88d8c7ec\",\"Name\":\"TestService\",\"Version\":\"1\",\"Region\":\"Test\",\"ServiceAddr\":{\"IPAddress\":\"127.0.0.1\",\"Port\":2000,\"MaxPort\":2999},\"Registered\":true}}" 2012-10-18 16:07:47.620591 D [679:70106646534880] (0.3ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 250 bytes 2012-10-18 16:07:47.620967 T [679:70106646534880] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  "/services/*/*/*/*/*8H 2012-10-18 16:07:47.621013 D [679:70106646534880] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 35 bytes 2012-10-18 16:07:47.621785 T [679:70106646534880] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x01Q" 2012-10-18 16:07:47.621818 D [679:70106646534880] (0.4ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:07:47.622112 T [679:70106646534880] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\x8A\xB9\x03*6/services/TutorialService/1/Development/127.0.0.1/90002\x8E\x02{\"Config\":{\"UUID\":\"70c03cc2-d840-492d-aaa9-bab90d75ac09\",\"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 16:07:47.622143 D [679:70106646534880] (0.3ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 337 bytes 2012-10-18 16:07:47.624871 T [679:70106646534880] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  "/services/*/*/*/*/*8H 2012-10-18 16:07:47.627134 D [679:70106646534880] (2.2ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 35 bytes 2012-10-18 16:07:47.627442 T [679:70106646534880] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\x05" 2012-10-18 16:07:47.627560 D [679:70106646534880] (0.4ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:07:47.627887 T [679:70106646534880] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\xA0\x06\b" 2012-10-18 16:07:47.627904 D [679:70106646534880] (0.3ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 5 bytes 2012-10-18 16:07:47.643984 D [679:70106646534880] RubySkynet::Registry -- #start_monitoring Add Service: TutorialService/1/Development => 127.0.0.1:9000 2012-10-18 16:07:47.644074 D [679:70106646534880] RubySkynet::Registry -- Doozer Connection Pool: Checkin connection #(70106646716020) self=connections=70106646716020 checked_out= with_map= 2012-10-18 16:07:47.647524 I [679:70106646534880] RubySkynet::Registry -- Thread started # 2012-10-18 16:08:13.884223 D [693:70207632792280] RubySkynet::Registry -- Doozer Connection Pool: Created connection #1 #(70207632792280) for Doozer Connection Pool 2012-10-18 16:08:13.910237 T [693:70207632792280] 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=>#} 2012-10-18 16:08:13.916948 D [693:70207632792280] RubySkynet::Registry -- Doozer Connection Pool: Renewed connection old=70207632792280 new=#(70207637026080) 2012-10-18 16:08:13.917050 D [693:70207632792280] RubySkynet::Registry -- Doozer Connection Pool: Checkout connection #(70207637026080) self=connections=70207637026080 checked_out=70207637026080 with_map= 2012-10-18 16:08:13.918134 T [693:70207632792280] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  2012-10-18 16:08:13.918561 D [693:70207632792280] (0.4ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 8 bytes 2012-10-18 16:08:13.918831 T [693:70207632792280] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\x06" 2012-10-18 16:08:13.918863 D [693:70207632792280] (0.3ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:08:13.919272 T [693:70207632792280] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x18\xBE\xC6\x03" 2012-10-18 16:08:13.920466 D [693:70207632792280] (1.4ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 6 bytes 2012-10-18 16:08:13.920833 T [693:70207632792280] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  "/services/*/*/*/*/*8H 2012-10-18 16:08:13.921522 D [693:70207632792280] (0.7ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 35 bytes 2012-10-18 16:08:13.921707 T [693:70207632792280] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\xFA" 2012-10-18 16:08:13.921746 D [693:70207632792280] (0.2ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:08:13.922027 T [693:70207632792280] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\xE2\xB6\x03*+/services/TestService/1/Test/127.0.0.1/20002\xC2\x01{\"Config\":{\"UUID\":\"3978b371-15e9-40f8-9b7b-59ae88d8c7ec\",\"Name\":\"TestService\",\"Version\":\"1\",\"Region\":\"Test\",\"ServiceAddr\":{\"IPAddress\":\"127.0.0.1\",\"Port\":2000,\"MaxPort\":2999},\"Registered\":true}}" 2012-10-18 16:08:13.922066 D [693:70207632792280] (0.3ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 250 bytes 2012-10-18 16:08:13.922490 T [693:70207632792280] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  "/services/*/*/*/*/*8H 2012-10-18 16:08:13.923209 D [693:70207632792280] (0.7ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 35 bytes 2012-10-18 16:08:13.923391 T [693:70207632792280] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x01Q" 2012-10-18 16:08:13.923430 D [693:70207632792280] (0.2ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:08:13.923687 T [693:70207632792280] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\x8A\xB9\x03*6/services/TutorialService/1/Development/127.0.0.1/90002\x8E\x02{\"Config\":{\"UUID\":\"70c03cc2-d840-492d-aaa9-bab90d75ac09\",\"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 16:08:13.923726 D [693:70207632792280] (0.3ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 337 bytes 2012-10-18 16:08:13.924007 T [693:70207632792280] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  "/services/*/*/*/*/*8H 2012-10-18 16:08:13.924639 D [693:70207632792280] (0.6ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 35 bytes 2012-10-18 16:08:13.924842 T [693:70207632792280] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\x05" 2012-10-18 16:08:13.924881 D [693:70207632792280] (0.2ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:08:13.925138 T [693:70207632792280] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\xA0\x06\b" 2012-10-18 16:08:13.925177 D [693:70207632792280] (0.3ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 5 bytes 2012-10-18 16:08:13.945247 D [693:70207632792280] RubySkynet::Registry -- #start_monitoring Add Service: TutorialService/1/Development => 127.0.0.1:9000 2012-10-18 16:08:13.945307 D [693:70207632792280] RubySkynet::Registry -- Doozer Connection Pool: Checkin connection #(70207637026080) self=connections=70207637026080 checked_out= with_map= 2012-10-18 16:08:13.948703 I [693:70207632792280] RubySkynet::Registry -- Thread started # 2012-10-18 16:09:22.365923 D [717:70097310014160] RubySkynet::Registry -- Doozer Connection Pool: Created connection #1 #(70097310014160) for Doozer Connection Pool 2012-10-18 16:09:22.394872 T [717:70097310014160] 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=>#} 2012-10-18 16:09:22.398536 D [717:70097310014160] RubySkynet::Registry -- Doozer Connection Pool: Renewed connection old=70097310014160 new=#(70097310502640) 2012-10-18 16:09:22.398618 D [717:70097310014160] RubySkynet::Registry -- Doozer Connection Pool: Checkout connection #(70097310502640) self=connections=70097310502640 checked_out=70097310502640 with_map= 2012-10-18 16:09:22.399722 T [717:70097310014160] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  2012-10-18 16:09:22.400287 D [717:70097310014160] (0.5ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 8 bytes 2012-10-18 16:09:22.400581 T [717:70097310014160] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\x06" 2012-10-18 16:09:22.400623 D [717:70097310014160] (0.3ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:09:22.400823 T [717:70097310014160] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x18\x91\xC7\x03" 2012-10-18 16:09:22.400840 D [717:70097310014160] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 6 bytes 2012-10-18 16:09:22.401209 T [717:70097310014160] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  "/services/*/*/*/*/*8H 2012-10-18 16:09:22.401260 D [717:70097310014160] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 35 bytes 2012-10-18 16:09:22.401723 T [717:70097310014160] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\xFA" 2012-10-18 16:09:22.401843 D [717:70097310014160] (0.5ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:09:22.402652 T [717:70097310014160] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\xE2\xB6\x03*+/services/TestService/1/Test/127.0.0.1/20002\xC2\x01{\"Config\":{\"UUID\":\"3978b371-15e9-40f8-9b7b-59ae88d8c7ec\",\"Name\":\"TestService\",\"Version\":\"1\",\"Region\":\"Test\",\"ServiceAddr\":{\"IPAddress\":\"127.0.0.1\",\"Port\":2000,\"MaxPort\":2999},\"Registered\":true}}" 2012-10-18 16:09:22.402700 D [717:70097310014160] (0.8ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 250 bytes 2012-10-18 16:09:22.403076 T [717:70097310014160] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  "/services/*/*/*/*/*8H 2012-10-18 16:09:22.403123 D [717:70097310014160] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 35 bytes 2012-10-18 16:09:22.403582 T [717:70097310014160] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x01Q" 2012-10-18 16:09:22.403603 D [717:70097310014160] (0.5ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:09:22.403775 T [717:70097310014160] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\x8A\xB9\x03*6/services/TutorialService/1/Development/127.0.0.1/90002\x8E\x02{\"Config\":{\"UUID\":\"70c03cc2-d840-492d-aaa9-bab90d75ac09\",\"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 16:09:22.403786 D [717:70097310014160] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 337 bytes 2012-10-18 16:09:22.404059 T [717:70097310014160] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending --  "/services/*/*/*/*/*8H 2012-10-18 16:09:22.404104 D [717:70097310014160] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 35 bytes 2012-10-18 16:09:22.404860 T [717:70097310014160] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\x05" 2012-10-18 16:09:22.404900 D [717:70097310014160] (0.7ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:09:22.406307 T [717:70097310014160] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\xA0\x06\b" 2012-10-18 16:09:22.406403 D [717:70097310014160] (1.5ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 5 bytes 2012-10-18 16:09:22.419985 D [717:70097310014160] RubySkynet::Registry -- #start_monitoring Add Service: TutorialService/1/Development => 127.0.0.1:9000 2012-10-18 16:09:22.420065 D [717:70097310014160] RubySkynet::Registry -- Doozer Connection Pool: Checkin connection #(70097310502640) self=connections=70097310502640 checked_out= with_map= 2012-10-18 16:09:22.424770 I [717:70097310014160] RubySkynet::Registry -- Thread started # 2012-10-18 16:09:22.426186 I [717:70097310320860] RubySkynet::Registry -- Start monitoring /services/*/*/*/*/* 2012-10-18 16:09:22.426291 T [717:70097310320860] 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=>#} 2012-10-18 16:09:22.427399 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:09:22.427594 D [717:70097310320860] (0.2ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 16:10:01.257579 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00B" 2012-10-18 16:10:01.257626 D [717:70097310320860] (38830.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:10:01.288303 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\b\x18\xC0\xC7\x03*6/services/TutorialService/1/Development/127.0.0.1/90002\x00" 2012-10-18 16:10:01.288330 D [717:70097310320860] (30.6ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 66 bytes 2012-10-18 16:10:01.288757 D [717:70097310320860] RubySkynet::Registry -- #monitor Service stopped, remove: TutorialService/1/Development => 127.0.0.1:9000 2012-10-18 16:10:01.288785 D [717:70097310320860] RubySkynet::Registry -- Updated registry -- {} 2012-10-18 16:10:01.289021 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:10:01.289132 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 16:10:01.999287 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x01R" 2012-10-18 16:10:01.999332 D [717:70097310320860] (710.2ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:10:01.999451 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\xC3\xC7\x03*6/services/TutorialService/1/Development/127.0.0.1/90002\x8F\x02{\"Config\":{\"UUID\":\"472891a5-f2b8-46be-8017-5c0cdbaf3946\",\"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\":false}" 2012-10-18 16:10:01.999462 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 338 bytes 2012-10-18 16:10:01.999677 D [717:70097310320860] RubySkynet::Registry -- #monitor Service deregistered, remove: TutorialService/1/Development => 127.0.0.1:9000 2012-10-18 16:10:01.999694 D [717:70097310320860] RubySkynet::Registry -- Updated registry -- {} 2012-10-18 16:10:01.999945 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:10:02.000056 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 16:10:02.002327 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x01Q" 2012-10-18 16:10:02.002350 D [717:70097310320860] (2.3ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:10:02.002447 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\xC4\xC7\x03*6/services/TutorialService/1/Development/127.0.0.1/90002\x8E\x02{\"Config\":{\"UUID\":\"472891a5-f2b8-46be-8017-5c0cdbaf3946\",\"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 16:10:02.002458 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 337 bytes 2012-10-18 16:10:02.003179 D [717:70097310320860] RubySkynet::Registry -- #monitor Add/Update Service: TutorialService/1/Development => 127.0.0.1:9000 2012-10-18 16:10:02.003196 D [717:70097310320860] RubySkynet::Registry -- Updated registry -- {"TutorialService/1/Development"=>["127.0.0.1:9000"]} 2012-10-18 16:10:02.013514 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:10:02.013669 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 16:10:22.532125 D [717:70097310014160] RubySkynet::Registry -- Doozer Connection Pool: Checkout connection #(70097310502640) self=connections=70097310502640 checked_out=70097310502640 with_map= 2012-10-18 16:10:22.532777 T [717:70097310014160] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "+/services/TestService/1/Test/127.0.0.1/2000*{"Config":{"UUID":"3978b371-15e9-40f8-9b7b-59ae88d8c7ec","Name":"TestService","Version":"1","Region":"Test","ServiceAddr":{"IPAddress":"127.0.0.1","Port":2000,"MaxPort":2999},"Registered":true}}H 2012-10-18 16:10:22.532949 D [717:70097310014160] (0.2ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 261 bytes 2012-10-18 16:10:22.536812 T [717:70097310014160] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\x06" 2012-10-18 16:10:22.536837 D [717:70097310014160] (3.9ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:10:22.541529 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\xFA" 2012-10-18 16:10:22.541560 D [717:70097310320860] (20527.9ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:10:22.541660 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\xDD\xC7\x03*+/services/TestService/1/Test/127.0.0.1/20002\xC2\x01{\"Config\":{\"UUID\":\"3978b371-15e9-40f8-9b7b-59ae88d8c7ec\",\"Name\":\"TestService\",\"Version\":\"1\",\"Region\":\"Test\",\"ServiceAddr\":{\"IPAddress\":\"127.0.0.1\",\"Port\":2000,\"MaxPort\":2999},\"Registered\":true}}" 2012-10-18 16:10:22.541671 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 250 bytes 2012-10-18 16:10:22.541898 D [717:70097310320860] RubySkynet::Registry -- #monitor Service deregistered, remove: TestService/1/Test => 127.0.0.1:2000 2012-10-18 16:10:22.541914 D [717:70097310320860] RubySkynet::Registry -- Updated registry -- {"TutorialService/1/Development"=>["127.0.0.1:9000"]} 2012-10-18 16:10:22.542166 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:10:22.542242 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 16:10:22.542370 T [717:70097310014160] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x18\xDD\xC7\x03" 2012-10-18 16:10:22.542380 D [717:70097310014160] (5.5ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 6 bytes 2012-10-18 16:10:22.542463 D [717:70097310014160] RubySkynet::Registry -- Doozer Connection Pool: Checkin connection #(70097310502640) self=connections=70097310502640 checked_out= with_map= 2012-10-18 16:11:45.348753 D [717:70097310014160] RubySkynet::Registry -- Doozer Connection Pool: Checkout connection #(70097310502640) self=connections=70097310502640 checked_out=70097310502640 with_map= 2012-10-18 16:11:45.352536 T [717:70097310014160] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "2/services/TestService/1/Development/127.0.0.1/2000*{"Config":{"UUID":"3978b371-15e9-40f8-9b7b-59ae88d8c7ec","Name":"TestService","Version":"1","Region":"Development","ServiceAddr":{"IPAddress":"127.0.0.1","Port":2000,"MaxPort":2999},"Registered":true}}H 2012-10-18 16:11:45.352665 D [717:70097310014160] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 275 bytes 2012-10-18 16:11:45.354444 T [717:70097310014160] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\x06" 2012-10-18 16:11:45.354461 D [717:70097310014160] (1.8ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:11:45.354947 T [717:70097310014160] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x18\xC1\xC8\x03" 2012-10-18 16:11:45.354963 D [717:70097310014160] (0.5ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 6 bytes 2012-10-18 16:11:45.355059 D [717:70097310014160] RubySkynet::Registry -- Doozer Connection Pool: Checkin connection #(70097310502640) self=connections=70097310502640 checked_out= with_map= 2012-10-18 16:11:45.356326 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x01\b" 2012-10-18 16:11:45.356344 D [717:70097310320860] (82814.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:11:45.356443 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\xC1\xC8\x03*2/services/TestService/1/Development/127.0.0.1/20002\xC9\x01{\"Config\":{\"UUID\":\"3978b371-15e9-40f8-9b7b-59ae88d8c7ec\",\"Name\":\"TestService\",\"Version\":\"1\",\"Region\":\"Development\",\"ServiceAddr\":{\"IPAddress\":\"127.0.0.1\",\"Port\":2000,\"MaxPort\":2999},\"Registered\":true}}" 2012-10-18 16:11:45.356454 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 264 bytes 2012-10-18 16:11:45.356617 D [717:70097310320860] RubySkynet::Registry -- #monitor Service deregistered, remove: TestService/1/Development => 127.0.0.1:2000 2012-10-18 16:11:45.356631 D [717:70097310320860] RubySkynet::Registry -- Updated registry -- {"TutorialService/1/Development"=>["127.0.0.1:9000"]} 2012-10-18 16:11:45.356908 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:11:45.357067 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 16:11:57.148962 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00B" 2012-10-18 16:11:57.149057 D [717:70097310320860] (11792.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:11:57.149347 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\b\x18\xD1\xC8\x03*6/services/TutorialService/1/Development/127.0.0.1/90002\x00" 2012-10-18 16:11:57.149362 D [717:70097310320860] (0.2ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 66 bytes 2012-10-18 16:11:57.149590 D [717:70097310320860] RubySkynet::Registry -- #monitor Service stopped, remove: TutorialService/1/Development => 127.0.0.1:9000 2012-10-18 16:11:57.149617 D [717:70097310320860] RubySkynet::Registry -- Updated registry -- {} 2012-10-18 16:11:57.149909 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:11:57.150070 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 16:11:58.000816 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x01R" 2012-10-18 16:11:58.001038 D [717:70097310320860] (850.9ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:11:58.001302 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\xD4\xC8\x03*6/services/TutorialService/1/Development/127.0.0.1/90002\x8F\x02{\"Config\":{\"UUID\":\"aa58fa11-6ab7-4b53-aad9-3d657120f2b8\",\"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\":false}" 2012-10-18 16:11:58.001314 D [717:70097310320860] (0.2ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 338 bytes 2012-10-18 16:11:58.001572 D [717:70097310320860] RubySkynet::Registry -- #monitor Service deregistered, remove: TutorialService/1/Development => 127.0.0.1:9000 2012-10-18 16:11:58.001589 D [717:70097310320860] RubySkynet::Registry -- Updated registry -- {} 2012-10-18 16:11:58.001869 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:11:58.001943 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 16:11:58.021378 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x01Q" 2012-10-18 16:11:58.021446 D [717:70097310320860] (19.5ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:11:58.022646 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\xD5\xC8\x03*6/services/TutorialService/1/Development/127.0.0.1/90002\x8E\x02{\"Config\":{\"UUID\":\"aa58fa11-6ab7-4b53-aad9-3d657120f2b8\",\"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 16:11:58.022665 D [717:70097310320860] (1.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 337 bytes 2012-10-18 16:11:58.022888 D [717:70097310320860] RubySkynet::Registry -- #monitor Add/Update Service: TutorialService/1/Development => 127.0.0.1:9000 2012-10-18 16:11:58.022902 D [717:70097310320860] RubySkynet::Registry -- Updated registry -- {"TutorialService/1/Development"=>["127.0.0.1:9000"]} 2012-10-18 16:11:58.023307 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:11:58.023397 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 16:13:44.650683 D [717:70097310014160] RubySkynet::Registry -- Doozer Connection Pool: Checkout connection #(70097310502640) self=connections=70097310502640 checked_out=70097310502640 with_map= 2012-10-18 16:13:44.651120 T [717:70097310014160] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "2/services/TestService/1/Development/127.0.0.1/2000*{"Config":{"UUID":"3978b371-15e9-40f8-9b7b-59ae88d8c7ec","Name":"TestService","Version":"1","Region":"Development","ServiceAddr":{"IPAddress":"127.0.0.1","Port":2000,"MaxPort":2999},"Registered":true}}H 2012-10-18 16:13:44.651493 D [717:70097310014160] (0.3ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 275 bytes 2012-10-18 16:13:44.653416 T [717:70097310014160] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\x06" 2012-10-18 16:13:44.653431 D [717:70097310014160] (1.3ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:13:44.665841 T [717:70097310014160] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x18\xD5\xC9\x03" 2012-10-18 16:13:44.665874 D [717:70097310014160] (12.4ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 6 bytes 2012-10-18 16:13:44.666004 D [717:70097310014160] RubySkynet::Registry -- Doozer Connection Pool: Checkin connection #(70097310502640) self=connections=70097310502640 checked_out= with_map= 2012-10-18 16:13:44.670077 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x01\b" 2012-10-18 16:13:44.670095 D [717:70097310320860] (106646.7ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:13:44.670208 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\xD5\xC9\x03*2/services/TestService/1/Development/127.0.0.1/20002\xC9\x01{\"Config\":{\"UUID\":\"3978b371-15e9-40f8-9b7b-59ae88d8c7ec\",\"Name\":\"TestService\",\"Version\":\"1\",\"Region\":\"Development\",\"ServiceAddr\":{\"IPAddress\":\"127.0.0.1\",\"Port\":2000,\"MaxPort\":2999},\"Registered\":true}}" 2012-10-18 16:13:44.670219 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 264 bytes 2012-10-18 16:13:44.670374 D [717:70097310320860] RubySkynet::Registry -- #monitor Service deregistered, remove: TestService/1/Development => 127.0.0.1:2000 2012-10-18 16:13:44.670414 D [717:70097310320860] RubySkynet::Registry -- Updated registry -- {"TutorialService/1/Development"=>["127.0.0.1:9000"]} 2012-10-18 16:13:44.670638 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:13:44.670737 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 16:16:31.466386 D [717:70097310014160] RubySkynet::Registry -- Doozer Connection Pool: Checkout connection #(70097310502640) self=connections=70097310502640 checked_out=70097310502640 with_map= 2012-10-18 16:16:31.466756 T [717:70097310014160] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "2/services/TestService/1/Development/127.0.0.1/2000*{"Config":{"UUID":"3978b371-15e9-40f8-9b7b-59ae88d8c7ec","Name":"TestService","Version":"1","Region":"Development","ServiceAddr":{"IPAddress":"127.0.0.1","Port":2000,"MaxPort":2999}},"Registered":true}H 2012-10-18 16:16:31.466880 D [717:70097310014160] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 275 bytes 2012-10-18 16:16:31.482813 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x01\b" 2012-10-18 16:16:31.482863 D [717:70097310320860] (166812.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:16:31.483032 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\x9D\xCB\x03*2/services/TestService/1/Development/127.0.0.1/20002\xC9\x01{\"Config\":{\"UUID\":\"3978b371-15e9-40f8-9b7b-59ae88d8c7ec\",\"Name\":\"TestService\",\"Version\":\"1\",\"Region\":\"Development\",\"ServiceAddr\":{\"IPAddress\":\"127.0.0.1\",\"Port\":2000,\"MaxPort\":2999}},\"Registered\":true}" 2012-10-18 16:16:31.483043 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 264 bytes 2012-10-18 16:16:31.483236 D [717:70097310320860] RubySkynet::Registry -- #monitor Add/Update Service: TestService/1/Development => 127.0.0.1:2000 2012-10-18 16:16:31.483251 D [717:70097310320860] RubySkynet::Registry -- Updated registry -- {"TutorialService/1/Development"=>["127.0.0.1:9000"], "TestService/1/Development"=>["127.0.0.1:2000"]} 2012-10-18 16:16:31.483516 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:16:31.483640 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 16:16:31.485543 T [717:70097310014160] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\x06" 2012-10-18 16:16:31.485560 D [717:70097310014160] (18.7ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:16:31.485640 T [717:70097310014160] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x18\x9D\xCB\x03" 2012-10-18 16:16:31.485650 D [717:70097310014160] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 6 bytes 2012-10-18 16:16:31.485742 D [717:70097310014160] RubySkynet::Registry -- Doozer Connection Pool: Checkin connection #(70097310502640) self=connections=70097310502640 checked_out= with_map= 2012-10-18 16:17:24.308790 D [717:70097310014160] RubySkynet::Registry -- Doozer Connection Pool: Checkout connection #(70097310502640) self=connections=70097310502640 checked_out=70097310502640 with_map= 2012-10-18 16:17:24.309041 T [717:70097310014160] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- C"2/services/TestService/1/Development/127.0.0.1/2000H 2012-10-18 16:17:24.309165 D [717:70097310014160] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 71 bytes 2012-10-18 16:17:24.322862 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00>" 2012-10-18 16:17:24.322907 D [717:70097310320860] (52839.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:17:24.323012 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\b\x18\xDE\xCB\x03*2/services/TestService/1/Development/127.0.0.1/20002\x00" 2012-10-18 16:17:24.323023 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 62 bytes 2012-10-18 16:17:24.323181 D [717:70097310320860] RubySkynet::Registry -- #monitor Service stopped, remove: TestService/1/Development => 127.0.0.1:2000 2012-10-18 16:17:24.323202 D [717:70097310320860] RubySkynet::Registry -- Updated registry -- {"TutorialService/1/Development"=>["127.0.0.1:9000"]} 2012-10-18 16:17:24.323446 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:17:24.323556 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 16:17:24.323617 T [717:70097310014160] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\x02" 2012-10-18 16:17:24.323628 D [717:70097310014160] (14.4ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:17:24.323684 T [717:70097310014160] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00" 2012-10-18 16:17:24.323694 D [717:70097310014160] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 2 bytes 2012-10-18 16:17:24.323757 D [717:70097310014160] RubySkynet::Registry -- Doozer Connection Pool: Checkin connection #(70097310502640) self=connections=70097310502640 checked_out= with_map= 2012-10-18 16:17:46.282116 D [717:70097310014160] RubySkynet::Registry -- Doozer Connection Pool: Checkout connection #(70097310502640) self=connections=70097310502640 checked_out=70097310502640 with_map= 2012-10-18 16:17:46.282613 T [717:70097310014160] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "+/services/TestService/1/Test/127.0.0.1/2000*{"Config":{"UUID":"3978b371-15e9-40f8-9b7b-59ae88d8c7ec","Name":"TestService","Version":"1","Region":"Test","ServiceAddr":{"IPAddress":"127.0.0.1","Port":2000,"MaxPort":2999}},"Registered":true}H 2012-10-18 16:17:46.282748 D [717:70097310014160] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 261 bytes 2012-10-18 16:17:46.284649 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\xFA" 2012-10-18 16:17:46.284690 D [717:70097310320860] (21961.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:17:46.288615 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\xF9\xCB\x03*+/services/TestService/1/Test/127.0.0.1/20002\xC2\x01{\"Config\":{\"UUID\":\"3978b371-15e9-40f8-9b7b-59ae88d8c7ec\",\"Name\":\"TestService\",\"Version\":\"1\",\"Region\":\"Test\",\"ServiceAddr\":{\"IPAddress\":\"127.0.0.1\",\"Port\":2000,\"MaxPort\":2999}},\"Registered\":true}" 2012-10-18 16:17:46.288633 D [717:70097310320860] (3.8ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 250 bytes 2012-10-18 16:17:46.288812 D [717:70097310320860] RubySkynet::Registry -- #monitor Add/Update Service: TestService/1/Test => 127.0.0.1:2000 2012-10-18 16:17:46.288826 D [717:70097310320860] RubySkynet::Registry -- Updated registry -- {"TutorialService/1/Development"=>["127.0.0.1:9000"], "TestService/1/Test"=>["127.0.0.1:2000"]} 2012-10-18 16:17:46.289074 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:17:46.289171 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 16:17:46.289249 T [717:70097310014160] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\x06" 2012-10-18 16:17:46.289260 D [717:70097310014160] (6.5ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:17:46.289324 T [717:70097310014160] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x18\xF9\xCB\x03" 2012-10-18 16:17:46.289333 D [717:70097310014160] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 6 bytes 2012-10-18 16:17:46.289432 D [717:70097310014160] RubySkynet::Registry -- Doozer Connection Pool: Checkin connection #(70097310502640) self=connections=70097310502640 checked_out= with_map= 2012-10-18 16:25:43.701240 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\xFA" 2012-10-18 16:25:43.701287 D [717:70097310320860] (477412.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:25:43.701833 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\xC8\xD0\x03*+/services/TestService/1/Test/127.0.0.1/20002\xC2\x01{\"Config\":{\"UUID\":\"3978b371-15e9-40f8-9b7b-59ae88d8c7ec\",\"Name\":\"TestService\",\"Version\":\"1\",\"Region\":\"Test\",\"ServiceAddr\":{\"IPAddress\":\"127.0.0.1\",\"Port\":2000,\"MaxPort\":2999}},\"Registered\":true}" 2012-10-18 16:25:43.701848 D [717:70097310320860] (0.5ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 250 bytes 2012-10-18 16:25:43.702085 D [717:70097310320860] RubySkynet::Registry -- #monitor Add/Update Service: TestService/1/Test => 127.0.0.1:2000 2012-10-18 16:25:43.702100 D [717:70097310320860] RubySkynet::Registry -- Updated registry -- {"TutorialService/1/Development"=>["127.0.0.1:9000"], "TestService/1/Test"=>["127.0.0.1:2000"]} 2012-10-18 16:25:43.702360 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:25:43.702433 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 16:25:43.732745 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x007" 2012-10-18 16:25:43.732779 D [717:70097310320860] (30.3ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:25:43.732874 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\b\x18\xC9\xD0\x03*+/services/TestService/1/Test/127.0.0.1/20002\x00" 2012-10-18 16:25:43.732884 D [717:70097310320860] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 55 bytes 2012-10-18 16:25:43.733012 D [717:70097310320860] RubySkynet::Registry -- #monitor Service stopped, remove: TestService/1/Test => 127.0.0.1:2000 2012-10-18 16:25:43.733062 D [717:70097310320860] RubySkynet::Registry -- Updated registry -- {"TutorialService/1/Development"=>["127.0.0.1:9000"]} 2012-10-18 16:25:43.733282 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:25:43.733374 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 16:25:43.744550 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\xFA" 2012-10-18 16:25:43.744581 D [717:70097310320860] (11.2ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:25:43.747976 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\xCA\xD0\x03*+/services/TestService/1/Test/127.0.0.1/20002\xC2\x01{\"Config\":{\"UUID\":\"3978b371-15e9-40f8-9b7b-59ae88d8c7ec\",\"Name\":\"TestService\",\"Version\":\"1\",\"Region\":\"Test\",\"ServiceAddr\":{\"IPAddress\":\"127.0.0.1\",\"Port\":2000,\"MaxPort\":2999}},\"Registered\":true}" 2012-10-18 16:25:43.748003 D [717:70097310320860] (3.3ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 250 bytes 2012-10-18 16:25:43.748259 D [717:70097310320860] RubySkynet::Registry -- #monitor Add/Update Service: TestService/1/Test => 127.0.0.1:2000 2012-10-18 16:25:43.748274 D [717:70097310320860] RubySkynet::Registry -- Updated registry -- {"TutorialService/1/Development"=>["127.0.0.1:9000"], "TestService/1/Test"=>["127.0.0.1:2000"]} 2012-10-18 16:25:43.752469 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:25:43.752930 D [717:70097310320860] (0.4ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 16:25:43.755004 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x007" 2012-10-18 16:25:43.755022 D [717:70097310320860] (2.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:25:43.760128 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\b\x18\xCB\xD0\x03*+/services/TestService/1/Test/127.0.0.1/20002\x00" 2012-10-18 16:25:43.760156 D [717:70097310320860] (5.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 55 bytes 2012-10-18 16:25:43.760291 D [717:70097310320860] RubySkynet::Registry -- #monitor Service stopped, remove: TestService/1/Test => 127.0.0.1:2000 2012-10-18 16:25:43.760312 D [717:70097310320860] RubySkynet::Registry -- Updated registry -- {"TutorialService/1/Development"=>["127.0.0.1:9000"]} 2012-10-18 16:25:43.760533 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:25:43.760698 D [717:70097310320860] (0.2ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 16:26:04.949824 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\xFA" 2012-10-18 16:26:04.949856 D [717:70097310320860] (21189.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:26:04.953149 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\xEB\xD0\x03*+/services/TestService/1/Test/127.0.0.1/20002\xC2\x01{\"Config\":{\"UUID\":\"3978b371-15e9-40f8-9b7b-59ae88d8c7ec\",\"Name\":\"TestService\",\"Version\":\"1\",\"Region\":\"Test\",\"ServiceAddr\":{\"IPAddress\":\"127.0.0.1\",\"Port\":2000,\"MaxPort\":2999}},\"Registered\":true}" 2012-10-18 16:26:04.953175 D [717:70097310320860] (3.3ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 250 bytes 2012-10-18 16:26:04.953359 D [717:70097310320860] RubySkynet::Registry -- #monitor Add/Update Service: TestService/1/Test => 127.0.0.1:2000 2012-10-18 16:26:04.953374 D [717:70097310320860] RubySkynet::Registry -- Updated registry -- {"TutorialService/1/Development"=>["127.0.0.1:9000"], "TestService/1/Test"=>["127.0.0.1:2000"]} 2012-10-18 16:26:04.953949 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:26:04.954032 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 16:26:04.969554 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x007" 2012-10-18 16:26:04.969585 D [717:70097310320860] (15.5ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:26:04.972869 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\b\x18\xEC\xD0\x03*+/services/TestService/1/Test/127.0.0.1/20002\x00" 2012-10-18 16:26:04.972891 D [717:70097310320860] (3.3ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 55 bytes 2012-10-18 16:26:04.973026 D [717:70097310320860] RubySkynet::Registry -- #monitor Service stopped, remove: TestService/1/Test => 127.0.0.1:2000 2012-10-18 16:26:04.973049 D [717:70097310320860] RubySkynet::Registry -- Updated registry -- {"TutorialService/1/Development"=>["127.0.0.1:9000"]} 2012-10-18 16:26:04.973274 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:26:04.973316 D [717:70097310320860] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 16:26:04.985564 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\xFA" 2012-10-18 16:26:04.985597 D [717:70097310320860] (12.3ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:26:04.987492 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\xED\xD0\x03*+/services/TestService/1/Test/127.0.0.1/20002\xC2\x01{\"Config\":{\"UUID\":\"3978b371-15e9-40f8-9b7b-59ae88d8c7ec\",\"Name\":\"TestService\",\"Version\":\"1\",\"Region\":\"Test\",\"ServiceAddr\":{\"IPAddress\":\"127.0.0.1\",\"Port\":2000,\"MaxPort\":2999}},\"Registered\":true}" 2012-10-18 16:26:04.987514 D [717:70097310320860] (1.9ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 250 bytes 2012-10-18 16:26:04.987701 D [717:70097310320860] RubySkynet::Registry -- #monitor Add/Update Service: TestService/1/Test => 127.0.0.1:2000 2012-10-18 16:26:04.987716 D [717:70097310320860] RubySkynet::Registry -- Updated registry -- {"TutorialService/1/Development"=>["127.0.0.1:9000"], "TestService/1/Test"=>["127.0.0.1:2000"]} 2012-10-18 16:26:04.987955 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:26:04.988098 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 16:26:04.994324 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x007" 2012-10-18 16:26:04.994351 D [717:70097310320860] (6.2ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:26:04.995680 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\b\x18\xEE\xD0\x03*+/services/TestService/1/Test/127.0.0.1/20002\x00" 2012-10-18 16:26:04.995698 D [717:70097310320860] (1.3ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 55 bytes 2012-10-18 16:26:04.995901 D [717:70097310320860] RubySkynet::Registry -- #monitor Service stopped, remove: TestService/1/Test => 127.0.0.1:2000 2012-10-18 16:26:04.995923 D [717:70097310320860] RubySkynet::Registry -- Updated registry -- {"TutorialService/1/Development"=>["127.0.0.1:9000"]} 2012-10-18 16:26:04.996410 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:26:04.996486 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 16:27:12.940823 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\xFA" 2012-10-18 16:27:12.940958 D [717:70097310320860] (67944.4ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:27:12.941161 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\xC6\xD1\x03*+/services/TestService/1/Test/127.0.0.1/20002\xC2\x01{\"Config\":{\"UUID\":\"3978b371-15e9-40f8-9b7b-59ae88d8c7ec\",\"Name\":\"TestService\",\"Version\":\"1\",\"Region\":\"Test\",\"ServiceAddr\":{\"IPAddress\":\"127.0.0.1\",\"Port\":2000,\"MaxPort\":2999}},\"Registered\":true}" 2012-10-18 16:27:12.941342 D [717:70097310320860] (0.3ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 250 bytes 2012-10-18 16:27:12.941541 D [717:70097310320860] RubySkynet::Registry -- #monitor Add/Update Service: TestService/1/Test => 127.0.0.1:2000 2012-10-18 16:27:12.941556 D [717:70097310320860] RubySkynet::Registry -- Updated registry -- {"TutorialService/1/Development"=>["127.0.0.1:9000"], "TestService/1/Test"=>["127.0.0.1:2000"]} 2012-10-18 16:27:12.941777 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:27:12.941854 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 16:27:12.973318 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x007" 2012-10-18 16:27:12.973353 D [717:70097310320860] (31.5ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:27:12.988197 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\b\x18\xC7\xD1\x03*+/services/TestService/1/Test/127.0.0.1/20002\x00" 2012-10-18 16:27:12.988237 D [717:70097310320860] (14.8ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 55 bytes 2012-10-18 16:27:12.989698 D [717:70097310320860] RubySkynet::Registry -- #monitor Service stopped, remove: TestService/1/Test => 127.0.0.1:2000 2012-10-18 16:27:12.989721 D [717:70097310320860] RubySkynet::Registry -- Updated registry -- {"TutorialService/1/Development"=>["127.0.0.1:9000"]} 2012-10-18 16:27:12.989963 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:27:12.990031 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 16:27:13.006442 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\xFA" 2012-10-18 16:27:13.006475 D [717:70097310320860] (16.4ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:27:13.007457 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\xC9\xD1\x03*+/services/TestService/1/Test/127.0.0.1/20002\xC2\x01{\"Config\":{\"UUID\":\"3978b371-15e9-40f8-9b7b-59ae88d8c7ec\",\"Name\":\"TestService\",\"Version\":\"1\",\"Region\":\"Test\",\"ServiceAddr\":{\"IPAddress\":\"127.0.0.1\",\"Port\":2000,\"MaxPort\":2999}},\"Registered\":true}" 2012-10-18 16:27:13.007476 D [717:70097310320860] (0.7ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 250 bytes 2012-10-18 16:27:13.007654 D [717:70097310320860] RubySkynet::Registry -- #monitor Add/Update Service: TestService/1/Test => 127.0.0.1:2000 2012-10-18 16:27:13.007668 D [717:70097310320860] RubySkynet::Registry -- Updated registry -- {"TutorialService/1/Development"=>["127.0.0.1:9000"], "TestService/1/Test"=>["127.0.0.1:2000"]} 2012-10-18 16:27:13.007902 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:27:13.007979 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 16:27:16.535599 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x007" 2012-10-18 16:27:16.535633 D [717:70097310320860] (3527.6ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:27:16.536491 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\b\x18\xCD\xD1\x03*+/services/TestService/1/Test/127.0.0.1/20002\x00" 2012-10-18 16:27:16.536511 D [717:70097310320860] (0.8ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 55 bytes 2012-10-18 16:27:16.536652 D [717:70097310320860] RubySkynet::Registry -- #monitor Service stopped, remove: TestService/1/Test => 127.0.0.1:2000 2012-10-18 16:27:16.536677 D [717:70097310320860] RubySkynet::Registry -- Updated registry -- {"TutorialService/1/Development"=>["127.0.0.1:9000"]} 2012-10-18 16:27:16.536925 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:27:16.537012 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 16:27:45.533701 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\xFA" 2012-10-18 16:27:45.533736 D [717:70097310320860] (28996.7ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:27:45.533891 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\xF7\xD1\x03*+/services/TestService/1/Test/127.0.0.1/20002\xC2\x01{\"Config\":{\"UUID\":\"3978b371-15e9-40f8-9b7b-59ae88d8c7ec\",\"Name\":\"TestService\",\"Version\":\"1\",\"Region\":\"Test\",\"ServiceAddr\":{\"IPAddress\":\"127.0.0.1\",\"Port\":2000,\"MaxPort\":2999}},\"Registered\":true}" 2012-10-18 16:27:45.533903 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 250 bytes 2012-10-18 16:27:45.534078 D [717:70097310320860] RubySkynet::Registry -- #monitor Add/Update Service: TestService/1/Test => 127.0.0.1:2000 2012-10-18 16:27:45.534262 D [717:70097310320860] RubySkynet::Registry -- Updated registry -- {"TutorialService/1/Development"=>["127.0.0.1:9000"], "TestService/1/Test"=>["127.0.0.1:2000"]} 2012-10-18 16:27:45.534496 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:27:45.534539 D [717:70097310320860] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 16:27:45.568333 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x007" 2012-10-18 16:27:45.568367 D [717:70097310320860] (33.8ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:27:45.576221 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\b\x18\xF8\xD1\x03*+/services/TestService/1/Test/127.0.0.1/20002\x00" 2012-10-18 16:27:45.576268 D [717:70097310320860] (7.8ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 55 bytes 2012-10-18 16:27:45.576467 D [717:70097310320860] RubySkynet::Registry -- #monitor Service stopped, remove: TestService/1/Test => 127.0.0.1:2000 2012-10-18 16:27:45.576495 D [717:70097310320860] RubySkynet::Registry -- Updated registry -- {"TutorialService/1/Development"=>["127.0.0.1:9000"]} 2012-10-18 16:27:45.576795 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:27:45.576898 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 16:27:45.595822 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\xFA" 2012-10-18 16:27:45.595855 D [717:70097310320860] (18.9ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:27:45.597861 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\xF9\xD1\x03*+/services/TestService/1/Test/127.0.0.1/20002\xC2\x01{\"Config\":{\"UUID\":\"3978b371-15e9-40f8-9b7b-59ae88d8c7ec\",\"Name\":\"TestService\",\"Version\":\"1\",\"Region\":\"Test\",\"ServiceAddr\":{\"IPAddress\":\"127.0.0.1\",\"Port\":2000,\"MaxPort\":2999}},\"Registered\":true}" 2012-10-18 16:27:45.597883 D [717:70097310320860] (2.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 250 bytes 2012-10-18 16:27:45.598064 D [717:70097310320860] RubySkynet::Registry -- #monitor Add/Update Service: TestService/1/Test => 127.0.0.1:2000 2012-10-18 16:27:45.598079 D [717:70097310320860] RubySkynet::Registry -- Updated registry -- {"TutorialService/1/Development"=>["127.0.0.1:9000"], "TestService/1/Test"=>["127.0.0.1:2000"]} 2012-10-18 16:27:45.598309 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:27:45.598383 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 16:27:49.121833 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x007" 2012-10-18 16:27:49.121866 D [717:70097310320860] (3523.5ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:27:49.121959 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\b\x18\xFF\xD1\x03*+/services/TestService/1/Test/127.0.0.1/20002\x00" 2012-10-18 16:27:49.121970 D [717:70097310320860] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 55 bytes 2012-10-18 16:27:49.122123 D [717:70097310320860] RubySkynet::Registry -- #monitor Service stopped, remove: TestService/1/Test => 127.0.0.1:2000 2012-10-18 16:27:49.122145 D [717:70097310320860] RubySkynet::Registry -- Updated registry -- {"TutorialService/1/Development"=>["127.0.0.1:9000"]} 2012-10-18 16:27:49.122380 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:27:49.122487 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 16:28:17.572425 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\xFA" 2012-10-18 16:28:17.572462 D [717:70097310320860] (28449.9ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:28:17.573013 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\xA7\xD2\x03*+/services/TestService/1/Test/127.0.0.1/20002\xC2\x01{\"Config\":{\"UUID\":\"3978b371-15e9-40f8-9b7b-59ae88d8c7ec\",\"Name\":\"TestService\",\"Version\":\"1\",\"Region\":\"Test\",\"ServiceAddr\":{\"IPAddress\":\"127.0.0.1\",\"Port\":2000,\"MaxPort\":2999}},\"Registered\":true}" 2012-10-18 16:28:17.573026 D [717:70097310320860] (0.5ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 250 bytes 2012-10-18 16:28:17.573245 D [717:70097310320860] RubySkynet::Registry -- #monitor Add/Update Service: TestService/1/Test => 127.0.0.1:2000 2012-10-18 16:28:17.573260 D [717:70097310320860] RubySkynet::Registry -- Updated registry -- {"TutorialService/1/Development"=>["127.0.0.1:9000"], "TestService/1/Test"=>["127.0.0.1:2000"]} 2012-10-18 16:28:17.573515 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:28:17.573593 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 16:28:17.618674 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x007" 2012-10-18 16:28:17.618707 D [717:70097310320860] (45.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:28:17.635977 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\b\x18\xA8\xD2\x03*+/services/TestService/1/Test/127.0.0.1/20002\x00" 2012-10-18 16:28:17.636014 D [717:70097310320860] (17.3ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 55 bytes 2012-10-18 16:28:17.636192 D [717:70097310320860] RubySkynet::Registry -- #monitor Service stopped, remove: TestService/1/Test => 127.0.0.1:2000 2012-10-18 16:28:17.636214 D [717:70097310320860] RubySkynet::Registry -- Updated registry -- {"TutorialService/1/Development"=>["127.0.0.1:9000"]} 2012-10-18 16:28:17.636462 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:28:17.636580 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 16:28:17.648817 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\xFA" 2012-10-18 16:28:17.648850 D [717:70097310320860] (12.2ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:28:17.648953 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\xA9\xD2\x03*+/services/TestService/1/Test/127.0.0.1/20002\xC2\x01{\"Config\":{\"UUID\":\"3978b371-15e9-40f8-9b7b-59ae88d8c7ec\",\"Name\":\"TestService\",\"Version\":\"1\",\"Region\":\"Test\",\"ServiceAddr\":{\"IPAddress\":\"127.0.0.1\",\"Port\":2000,\"MaxPort\":2999}},\"Registered\":true}" 2012-10-18 16:28:17.648964 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 250 bytes 2012-10-18 16:28:17.649152 D [717:70097310320860] RubySkynet::Registry -- #monitor Add/Update Service: TestService/1/Test => 127.0.0.1:2000 2012-10-18 16:28:17.649166 D [717:70097310320860] RubySkynet::Registry -- Updated registry -- {"TutorialService/1/Development"=>["127.0.0.1:9000"], "TestService/1/Test"=>["127.0.0.1:2000"]} 2012-10-18 16:28:17.649421 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:28:17.649520 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 16:28:21.161323 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x007" 2012-10-18 16:28:21.161356 D [717:70097310320860] (3511.8ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:28:21.178206 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\b\x18\xAF\xD2\x03*+/services/TestService/1/Test/127.0.0.1/20002\x00" 2012-10-18 16:28:21.178240 D [717:70097310320860] (16.8ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 55 bytes 2012-10-18 16:28:21.178392 D [717:70097310320860] RubySkynet::Registry -- #monitor Service stopped, remove: TestService/1/Test => 127.0.0.1:2000 2012-10-18 16:28:21.178415 D [717:70097310320860] RubySkynet::Registry -- Updated registry -- {"TutorialService/1/Development"=>["127.0.0.1:9000"]} 2012-10-18 16:28:21.178697 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:28:21.178800 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 16:28:31.167675 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\xFA" 2012-10-18 16:28:31.167903 D [717:70097310320860] (9989.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:28:31.168034 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\xC2\xD2\x03*+/services/TestService/1/Test/127.0.0.1/20002\xC2\x01{\"Config\":{\"UUID\":\"3978b371-15e9-40f8-9b7b-59ae88d8c7ec\",\"Name\":\"TestService\",\"Version\":\"1\",\"Region\":\"Test\",\"ServiceAddr\":{\"IPAddress\":\"127.0.0.1\",\"Port\":2000,\"MaxPort\":2999}},\"Registered\":true}" 2012-10-18 16:28:31.168045 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 250 bytes 2012-10-18 16:28:31.168237 D [717:70097310320860] RubySkynet::Registry -- #monitor Add/Update Service: TestService/1/Test => 127.0.0.1:2000 2012-10-18 16:28:31.168251 D [717:70097310320860] RubySkynet::Registry -- Updated registry -- {"TutorialService/1/Development"=>["127.0.0.1:9000"], "TestService/1/Test"=>["127.0.0.1:2000"]} 2012-10-18 16:28:31.168473 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:28:31.168548 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 16:28:31.210443 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x007" 2012-10-18 16:28:31.210627 D [717:70097310320860] (42.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:28:31.218951 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\b\x18\xC3\xD2\x03*+/services/TestService/1/Test/127.0.0.1/20002\x00" 2012-10-18 16:28:31.219008 D [717:70097310320860] (8.3ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 55 bytes 2012-10-18 16:28:31.219254 D [717:70097310320860] RubySkynet::Registry -- #monitor Service stopped, remove: TestService/1/Test => 127.0.0.1:2000 2012-10-18 16:28:31.219280 D [717:70097310320860] RubySkynet::Registry -- Updated registry -- {"TutorialService/1/Development"=>["127.0.0.1:9000"]} 2012-10-18 16:28:31.219574 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:28:31.219736 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 16:28:31.233933 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\xFA" 2012-10-18 16:28:31.233962 D [717:70097310320860] (14.2ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:28:31.236181 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\xC4\xD2\x03*+/services/TestService/1/Test/127.0.0.1/20002\xC2\x01{\"Config\":{\"UUID\":\"3978b371-15e9-40f8-9b7b-59ae88d8c7ec\",\"Name\":\"TestService\",\"Version\":\"1\",\"Region\":\"Test\",\"ServiceAddr\":{\"IPAddress\":\"127.0.0.1\",\"Port\":2000,\"MaxPort\":2999}},\"Registered\":true}" 2012-10-18 16:28:31.236199 D [717:70097310320860] (2.2ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 250 bytes 2012-10-18 16:28:31.236374 D [717:70097310320860] RubySkynet::Registry -- #monitor Add/Update Service: TestService/1/Test => 127.0.0.1:2000 2012-10-18 16:28:31.236388 D [717:70097310320860] RubySkynet::Registry -- Updated registry -- {"TutorialService/1/Development"=>["127.0.0.1:9000"], "TestService/1/Test"=>["127.0.0.1:2000"]} 2012-10-18 16:28:31.236630 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:28:31.236716 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 16:28:34.761113 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x007" 2012-10-18 16:28:34.761145 D [717:70097310320860] (3524.4ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:28:34.770735 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\b\x18\xC9\xD2\x03*+/services/TestService/1/Test/127.0.0.1/20002\x00" 2012-10-18 16:28:34.770864 D [717:70097310320860] (9.6ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 55 bytes 2012-10-18 16:28:34.771096 D [717:70097310320860] RubySkynet::Registry -- #monitor Service stopped, remove: TestService/1/Test => 127.0.0.1:2000 2012-10-18 16:28:34.771121 D [717:70097310320860] RubySkynet::Registry -- Updated registry -- {"TutorialService/1/Development"=>["127.0.0.1:9000"]} 2012-10-18 16:28:34.771422 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:28:34.771575 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 16:32:10.435306 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\xFA" 2012-10-18 16:32:10.435338 D [717:70097310320860] (215663.7ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:32:10.435605 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\xD2\xD4\x03*+/services/TestService/1/Test/127.0.0.1/20002\xC2\x01{\"Config\":{\"UUID\":\"3978b371-15e9-40f8-9b7b-59ae88d8c7ec\",\"Name\":\"TestService\",\"Version\":\"1\",\"Region\":\"Test\",\"ServiceAddr\":{\"IPAddress\":\"127.0.0.1\",\"Port\":2000,\"MaxPort\":2999}},\"Registered\":true}" 2012-10-18 16:32:10.435617 D [717:70097310320860] (0.2ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 250 bytes 2012-10-18 16:32:10.436092 D [717:70097310320860] RubySkynet::Registry -- #monitor Add/Update Service: TestService/1/Test => 127.0.0.1:2000 2012-10-18 16:32:10.436107 D [717:70097310320860] RubySkynet::Registry -- Updated registry -- {"TutorialService/1/Development"=>["127.0.0.1:9000"], "TestService/1/Test"=>["127.0.0.1:2000"]} 2012-10-18 16:32:10.436341 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:32:10.436420 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 16:32:10.487093 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x007" 2012-10-18 16:32:10.487824 D [717:70097310320860] (51.4ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:32:10.495131 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\b\x18\xD3\xD4\x03*+/services/TestService/1/Test/127.0.0.1/20002\x00" 2012-10-18 16:32:10.495173 D [717:70097310320860] (7.3ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 55 bytes 2012-10-18 16:32:10.495346 D [717:70097310320860] RubySkynet::Registry -- #monitor Service stopped, remove: TestService/1/Test => 127.0.0.1:2000 2012-10-18 16:32:10.495368 D [717:70097310320860] RubySkynet::Registry -- Updated registry -- {"TutorialService/1/Development"=>["127.0.0.1:9000"]} 2012-10-18 16:32:10.495606 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:32:10.495751 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 16:32:10.513925 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\xFA" 2012-10-18 16:32:10.513958 D [717:70097310320860] (18.2ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:32:10.529674 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\xD4\xD4\x03*+/services/TestService/1/Test/127.0.0.1/20002\xC2\x01{\"Config\":{\"UUID\":\"3978b371-15e9-40f8-9b7b-59ae88d8c7ec\",\"Name\":\"TestService\",\"Version\":\"1\",\"Region\":\"Test\",\"ServiceAddr\":{\"IPAddress\":\"127.0.0.1\",\"Port\":2000,\"MaxPort\":2999}},\"Registered\":true}" 2012-10-18 16:32:10.529706 D [717:70097310320860] (15.7ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 250 bytes 2012-10-18 16:32:10.529896 D [717:70097310320860] RubySkynet::Registry -- #monitor Add/Update Service: TestService/1/Test => 127.0.0.1:2000 2012-10-18 16:32:10.529910 D [717:70097310320860] RubySkynet::Registry -- Updated registry -- {"TutorialService/1/Development"=>["127.0.0.1:9000"], "TestService/1/Test"=>["127.0.0.1:2000"]} 2012-10-18 16:32:10.530157 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:32:10.535235 D [717:70097310320860] (5.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 16:32:13.544475 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x007" 2012-10-18 16:32:13.544509 D [717:70097310320860] (3009.2ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:32:13.544597 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\b\x18\xD9\xD4\x03*+/services/TestService/1/Test/127.0.0.1/20002\x00" 2012-10-18 16:32:13.544608 D [717:70097310320860] (0.0ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 55 bytes 2012-10-18 16:32:13.552996 D [717:70097310320860] RubySkynet::Registry -- #monitor Service stopped, remove: TestService/1/Test => 127.0.0.1:2000 2012-10-18 16:32:13.553042 D [717:70097310320860] RubySkynet::Registry -- Updated registry -- {"TutorialService/1/Development"=>["127.0.0.1:9000"]} 2012-10-18 16:32:13.553379 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:32:13.553566 D [717:70097310320860] (0.2ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 16:32:44.163926 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\xFA" 2012-10-18 16:32:44.163964 D [717:70097310320860] (30610.4ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:32:44.164138 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\x85\xD5\x03*+/services/TestService/1/Test/127.0.0.1/20002\xC2\x01{\"Config\":{\"UUID\":\"3978b371-15e9-40f8-9b7b-59ae88d8c7ec\",\"Name\":\"TestService\",\"Version\":\"1\",\"Region\":\"Test\",\"ServiceAddr\":{\"IPAddress\":\"127.0.0.1\",\"Port\":2000,\"MaxPort\":2999}},\"Registered\":true}" 2012-10-18 16:32:44.164149 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 250 bytes 2012-10-18 16:32:44.164352 D [717:70097310320860] RubySkynet::Registry -- #monitor Add/Update Service: TestService/1/Test => 127.0.0.1:2000 2012-10-18 16:32:44.164367 D [717:70097310320860] RubySkynet::Registry -- Updated registry -- {"TutorialService/1/Development"=>["127.0.0.1:9000"], "TestService/1/Test"=>["127.0.0.1:2000"]} 2012-10-18 16:32:44.164618 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:32:44.164709 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 16:32:44.193103 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x007" 2012-10-18 16:32:44.193136 D [717:70097310320860] (28.4ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:32:44.194262 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\b\x18\x86\xD5\x03*+/services/TestService/1/Test/127.0.0.1/20002\x00" 2012-10-18 16:32:44.194280 D [717:70097310320860] (1.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 55 bytes 2012-10-18 16:32:44.194407 D [717:70097310320860] RubySkynet::Registry -- #monitor Service stopped, remove: TestService/1/Test => 127.0.0.1:2000 2012-10-18 16:32:44.194428 D [717:70097310320860] RubySkynet::Registry -- Updated registry -- {"TutorialService/1/Development"=>["127.0.0.1:9000"]} 2012-10-18 16:32:44.194678 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:32:44.194763 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 16:32:44.217050 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x00\xFA" 2012-10-18 16:32:44.217113 D [717:70097310320860] (22.3ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:32:44.221444 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\x04\x18\x87\xD5\x03*+/services/TestService/1/Test/127.0.0.1/20002\xC2\x01{\"Config\":{\"UUID\":\"3978b371-15e9-40f8-9b7b-59ae88d8c7ec\",\"Name\":\"TestService\",\"Version\":\"1\",\"Region\":\"Test\",\"ServiceAddr\":{\"IPAddress\":\"127.0.0.1\",\"Port\":2000,\"MaxPort\":2999}},\"Registered\":true}" 2012-10-18 16:32:44.221483 D [717:70097310320860] (4.3ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 250 bytes 2012-10-18 16:32:44.221681 D [717:70097310320860] RubySkynet::Registry -- #monitor Add/Update Service: TestService/1/Test => 127.0.0.1:2000 2012-10-18 16:32:44.221695 D [717:70097310320860] RubySkynet::Registry -- Updated registry -- {"TutorialService/1/Development"=>["127.0.0.1:9000"], "TestService/1/Test"=>["127.0.0.1:2000"]} 2012-10-18 16:32:44.221932 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:32:44.222027 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes 2012-10-18 16:32:47.241087 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\x00\x00\x007" 2012-10-18 16:32:47.241118 D [717:70097310320860] (3019.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 4 bytes 2012-10-18 16:32:47.242025 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== received -- "\b\x00\x10\b\x18\x8B\xD5\x03*+/services/TestService/1/Test/127.0.0.1/20002\x00" 2012-10-18 16:32:47.242067 D [717:70097310320860] (0.9ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #read <== read 55 bytes 2012-10-18 16:32:47.242201 D [717:70097310320860] RubySkynet::Registry -- #monitor Service stopped, remove: TestService/1/Test => 127.0.0.1:2000 2012-10-18 16:32:47.242222 D [717:70097310320860] RubySkynet::Registry -- Updated registry -- {"TutorialService/1/Development"=>["127.0.0.1:9000"]} 2012-10-18 16:32:47.242472 T [717:70097310320860] ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sending -- "/services/*/*/*/*/*H 2012-10-18 16:32:47.242548 D [717:70097310320860] (0.1ms) ResilientSocket::TCPClient ["127.0.0.1:8046"] -- #write ==> sent 33 bytes