[INFO] cloning repository https://github.com/joyent/rust-fast
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/joyent/rust-fast" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fjoyent%2Frust-fast", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fjoyent%2Frust-fast'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 1ddf01bba94c010d5627bf0eb0ff260b8085a460
[INFO] testing joyent/rust-fast against try#eafdee2dfae8c2233b74f98b123308be7ccefcc6 for pr-79296
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fjoyent%2Frust-fast" "/workspace/builds/worker-2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-2/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/joyent/rust-fast on toolchain eafdee2dfae8c2233b74f98b123308be7ccefcc6
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+eafdee2dfae8c2233b74f98b123308be7ccefcc6" "read-manifest" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/joyent/rust-fast
[INFO] finished tweaking git repo https://github.com/joyent/rust-fast
[INFO] tweaked toml for git repo https://github.com/joyent/rust-fast written to /workspace/builds/worker-2/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+eafdee2dfae8c2233b74f98b123308be7ccefcc6" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }`
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+eafdee2dfae8c2233b74f98b123308be7ccefcc6" "fetch" "--locked" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded tokio-uds v0.2.7
[INFO] [stderr]   Downloaded crc16 v0.4.0
[INFO] [stderr]   Downloaded crossbeam v0.2.12
[INFO] [stderr]   Downloaded slog-stdlog v3.0.5
[INFO] [stderr]   Downloaded slog v2.7.0
[INFO] [stderr]   Downloaded slog-term v2.6.0
[INFO] [stderr]   Downloaded slog-scope v4.3.0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "rustops/crates-build-env@sha256:6eabd152ff4036248d66efda456a36cb33d24b7291b33f25f75140726c88da35" "/opt/rustwide/cargo-home/bin/cargo" "+eafdee2dfae8c2233b74f98b123308be7ccefcc6" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 90b4416d5c4576bfaa3a6e86d1205f7bcccbd6b5418202cb12dc31add621df52
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] running `Command { std: "docker" "start" "-a" "90b4416d5c4576bfaa3a6e86d1205f7bcccbd6b5418202cb12dc31add621df52", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "90b4416d5c4576bfaa3a6e86d1205f7bcccbd6b5418202cb12dc31add621df52", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "90b4416d5c4576bfaa3a6e86d1205f7bcccbd6b5418202cb12dc31add621df52", kill_on_drop: false }`
[INFO] [stdout] 90b4416d5c4576bfaa3a6e86d1205f7bcccbd6b5418202cb12dc31add621df52
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "rustops/crates-build-env@sha256:6eabd152ff4036248d66efda456a36cb33d24b7291b33f25f75140726c88da35" "/opt/rustwide/cargo-home/bin/cargo" "+eafdee2dfae8c2233b74f98b123308be7ccefcc6" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 51984e38b12a97597376524b08c83605739539f7c9537760142b268ff6262534
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] running `Command { std: "docker" "start" "-a" "51984e38b12a97597376524b08c83605739539f7c9537760142b268ff6262534", kill_on_drop: false }`
[INFO] [stderr]    Compiling maybe-uninit v2.0.0
[INFO] [stderr]    Compiling scopeguard v1.1.0
[INFO] [stderr]    Compiling autocfg v0.1.7
[INFO] [stderr]    Compiling slab v0.4.2
[INFO] [stderr]    Compiling memchr v2.3.4
[INFO] [stderr]    Compiling slog v2.7.0
[INFO] [stderr]    Compiling syn v1.0.53
[INFO] [stderr]    Compiling serde v1.0.117
[INFO] [stderr]    Compiling regex-syntax v0.6.21
[INFO] [stderr]    Compiling crc16 v0.4.0
[INFO] [stderr]    Compiling itoa v0.4.6
[INFO] [stderr]    Compiling crossbeam v0.2.12
[INFO] [stderr]    Compiling crossbeam-utils v0.7.2
[INFO] [stderr]    Compiling num-traits v0.2.14
[INFO] [stderr]    Compiling memoffset v0.5.6
[INFO] [stderr]    Compiling num-integer v0.1.44
[INFO] [stderr]    Compiling crossbeam-epoch v0.8.2
[INFO] [stderr]    Compiling num-bigint v0.2.6
[INFO] [stderr]    Compiling num-rational v0.2.4
[INFO] [stderr]    Compiling num-complex v0.2.4
[INFO] [stderr]    Compiling num-iter v0.1.42
[INFO] [stderr]    Compiling lock_api v0.3.4
[INFO] [stderr]    Compiling log v0.4.11
[INFO] [stderr]    Compiling iovec v0.1.4
[INFO] [stderr]    Compiling net2 v0.2.36
[INFO] [stderr]    Compiling num_cpus v1.13.0
[INFO] [stderr]    Compiling rand_os v0.1.3
[INFO] [stderr]    Compiling time v0.1.44
[INFO] [stderr]    Compiling parking_lot_core v0.6.2
[INFO] [stderr]    Compiling parking_lot v0.9.0
[INFO] [stderr]    Compiling bytes v0.4.12
[INFO] [stderr]    Compiling rand_chacha v0.1.1
[INFO] [stderr]    Compiling rand_pcg v0.1.2
[INFO] [stderr]    Compiling rand v0.6.5
[INFO] [stderr]    Compiling smallvec v0.6.13
[INFO] [stderr]    Compiling log v0.3.9
[INFO] [stderr]    Compiling mio v0.6.22
[INFO] [stderr]    Compiling aho-corasick v0.7.15
[INFO] [stderr]    Compiling tokio-executor v0.1.10
[INFO] [stderr]    Compiling crossbeam-queue v0.2.3
[INFO] [stderr]    Compiling tokio-io v0.1.13
[INFO] [stderr]    Compiling slog-scope v4.3.0
[INFO] [stderr]    Compiling tokio-timer v0.2.13
[INFO] [stderr]    Compiling tokio-current-thread v0.1.7
[INFO] [stderr]    Compiling crossbeam-deque v0.7.3
[INFO] [stderr]    Compiling slog-stdlog v3.0.5
[INFO] [stderr]    Compiling tokio-threadpool v0.1.18
[INFO] [stderr]    Compiling tokio-codec v0.1.2
[INFO] [stderr]    Compiling mio-uds v0.6.8
[INFO] [stderr]    Compiling tokio-reactor v0.1.12
[INFO] [stderr]    Compiling tokio-tcp v0.1.4
[INFO] [stderr]    Compiling tokio-uds v0.2.7
[INFO] [stderr]    Compiling tokio-udp v0.1.6
[INFO] [stderr]    Compiling tokio-fs v0.1.7
[INFO] [stderr]    Compiling tokio v0.1.22
[INFO] [stderr]    Compiling regex v1.4.2
[INFO] [stderr]    Compiling num v0.2.1
[INFO] [stderr]    Compiling num-derive v0.3.3
[INFO] [stderr]    Compiling serde_derive v1.0.117
[INFO] [stderr]    Compiling env_logger v0.6.2
[INFO] [stderr]    Compiling quickcheck v0.8.5
[INFO] [stderr]    Compiling chrono v0.4.19
[INFO] [stderr]    Compiling serde_json v1.0.59
[INFO] [stderr]    Compiling fast-rpc v0.3.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1m 27s
[INFO] running `Command { std: "docker" "inspect" "51984e38b12a97597376524b08c83605739539f7c9537760142b268ff6262534", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "51984e38b12a97597376524b08c83605739539f7c9537760142b268ff6262534", kill_on_drop: false }`
[INFO] [stdout] 51984e38b12a97597376524b08c83605739539f7c9537760142b268ff6262534
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "rustops/crates-build-env@sha256:6eabd152ff4036248d66efda456a36cb33d24b7291b33f25f75140726c88da35" "/opt/rustwide/cargo-home/bin/cargo" "+eafdee2dfae8c2233b74f98b123308be7ccefcc6" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] [stdout] b6e055ac2abd7614fa61a829cf49b2dffb9f229968083f20edd2a8ae755becf3
[INFO] running `Command { std: "docker" "start" "-a" "b6e055ac2abd7614fa61a829cf49b2dffb9f229968083f20edd2a8ae755becf3", kill_on_drop: false }`
[INFO] [stderr]    Compiling textwrap v0.11.0
[INFO] [stderr]    Compiling dirs-sys v0.3.5
[INFO] [stderr]    Compiling atty v0.2.14
[INFO] [stderr]    Compiling dirs v2.0.2
[INFO] [stderr]    Compiling clap v2.33.3
[INFO] [stderr]    Compiling term v0.6.1
[INFO] [stderr]    Compiling slog-term v2.6.0
[INFO] [stderr]    Compiling fast-rpc v0.3.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 26.25s
[INFO] running `Command { std: "docker" "inspect" "b6e055ac2abd7614fa61a829cf49b2dffb9f229968083f20edd2a8ae755becf3", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "b6e055ac2abd7614fa61a829cf49b2dffb9f229968083f20edd2a8ae755becf3", kill_on_drop: false }`
[INFO] [stdout] b6e055ac2abd7614fa61a829cf49b2dffb9f229968083f20edd2a8ae755becf3
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "rustops/crates-build-env@sha256:6eabd152ff4036248d66efda456a36cb33d24b7291b33f25f75140726c88da35" "/opt/rustwide/cargo-home/bin/cargo" "+eafdee2dfae8c2233b74f98b123308be7ccefcc6" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 117f41a63e16e78cfa26d9852e041b195b2083544e174afd756c69a98a836179
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] running `Command { std: "docker" "start" "-a" "117f41a63e16e78cfa26d9852e041b195b2083544e174afd756c69a98a836179", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.14s
[INFO] [stderr]      Running /opt/rustwide/target/debug/deps/fast_rpc-5655750864f91142
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test protocol::test::prop_fast_message_roundtrip ... ok
[INFO] [stdout] test protocol::test::prop_fast_message_bundling ... ok
[INFO] [stdout] test protocol::test::prop_fast_message_decoding ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stderr]      Running /opt/rustwide/target/debug/deps/client_server_test-9bbf23018e9438e5
[INFO] [stdout] Nov 30 23:12:56.992 INFO listening for fast requests, address: 127.0.0.1:56652, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.000 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.000 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.000 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.000 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.003 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.004 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.004 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.004 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.012 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.012 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.012 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.012 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.020 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.020 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.020 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.020 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.028 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.028 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.028 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.028 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.032 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.032 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.032 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.032 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.040 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.040 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.040 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.040 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.048 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.049 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.049 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.049 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.056 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.056 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.056 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.057 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.068 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.069 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.069 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.069 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.080 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.080 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.080 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.080 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.089 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.089 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.089 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.089 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.097 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.097 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.097 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.097 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.105 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.105 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.105 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.105 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.115 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.116 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.116 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.116 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.123 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.123 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.123 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.123 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.133 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.134 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.134 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.134 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.142 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.142 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.142 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.142 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.151 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.151 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.151 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.151 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.162 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.162 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.162 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.162 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.172 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.172 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.172 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.172 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.182 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.182 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.182 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.182 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.193 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.193 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.193 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.193 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.204 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.204 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.204 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.205 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.216 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.216 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.216 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.216 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.228 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.229 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.229 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.229 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.241 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.241 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.241 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.241 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.254 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.254 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.254 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.254 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.267 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.267 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.268 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.268 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.281 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.281 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.281 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.281 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.296 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.296 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.296 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.296 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.310 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.310 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.310 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.311 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.330 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.330 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.330 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.331 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.347 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.347 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.347 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.348 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.363 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.363 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.363 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.363 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.379 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.379 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.380 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.380 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.397 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.397 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.397 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.397 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.414 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.414 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.414 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.414 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.431 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.431 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.431 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.431 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.449 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.449 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.449 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.449 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.476 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.477 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.477 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.477 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.501 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.501 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.501 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.501 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.524 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.525 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.525 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.525 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.548 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.549 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.549 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.549 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.573 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.573 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.573 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.573 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.597 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.597 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.597 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.597 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.618 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.618 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.618 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.618 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.643 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.644 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.644 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.644 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.666 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.666 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.666 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.666 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.688 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.688 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.688 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.688 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.714 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.714 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.714 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.714 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.737 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.737 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.737 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.737 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.761 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.761 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.761 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.761 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.793 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.793 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.793 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.793 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.822 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.822 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.823 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.823 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.855 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.855 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.855 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.855 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.883 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.884 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.885 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.885 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.914 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.914 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.914 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.914 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.942 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.942 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.942 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.942 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.969 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.969 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.969 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.969 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.996 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.996 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.996 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:57.996 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.024 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.024 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.024 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.024 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.059 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.059 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.059 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.059 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.088 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.091 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.091 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.091 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.120 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.120 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.120 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.120 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.149 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.149 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.149 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.149 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.179 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.179 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.179 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.179 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.208 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.209 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.209 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.209 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.247 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.247 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.248 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.248 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.281 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.282 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.282 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.282 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.313 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.313 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.313 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.313 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.352 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.352 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.352 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.353 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.388 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.388 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.388 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.388 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.424 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.424 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.424 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.424 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.460 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.460 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.461 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.461 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.497 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.498 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.498 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.498 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.532 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.532 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.532 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.533 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.566 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.566 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.566 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.566 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.605 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.605 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.605 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.605 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.649 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.649 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.649 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.650 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.687 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.688 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.688 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.688 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.726 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.726 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.726 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.726 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.766 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.766 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.767 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.767 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.810 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.810 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.810 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.810 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.859 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.859 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.859 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.859 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.907 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.907 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.907 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.907 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.980 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.980 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.980 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:58.980 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.034 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.034 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.034 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.034 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.077 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.077 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.077 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.077 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.118 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.118 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.118 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.118 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.158 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.159 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.159 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.159 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.215 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.216 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.216 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.216 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.263 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.263 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.263 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.263 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.304 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.304 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.304 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.304 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.349 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.349 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.349 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.349 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.397 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.397 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.397 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.397 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.455 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.455 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.455 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.456 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.499 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.499 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.503 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.503 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.548 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.548 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.548 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Nov 30 23:12:59.548 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] test client_server_comms ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests fast-rpc
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "117f41a63e16e78cfa26d9852e041b195b2083544e174afd756c69a98a836179", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "117f41a63e16e78cfa26d9852e041b195b2083544e174afd756c69a98a836179", kill_on_drop: false }`
[INFO] [stdout] 117f41a63e16e78cfa26d9852e041b195b2083544e174afd756c69a98a836179