[INFO] crate fast-rpc 0.3.0 is already in cache
[INFO] testing fast-rpc-0.3.0 against 1.45.2 for beta-1.46-1
[INFO] extracting crate fast-rpc 0.3.0 into /workspace/builds/worker-14/source
[INFO] validating manifest of crates.io crate fast-rpc 0.3.0 on toolchain 1.45.2
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.45.2" "read-manifest" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] started tweaking crates.io crate fast-rpc 0.3.0
[INFO] finished tweaking crates.io crate fast-rpc 0.3.0
[INFO] tweaked toml for crates.io crate fast-rpc 0.3.0 written to /workspace/builds/worker-14/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.45.2" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.45.2" "fetch" "--locked" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-14/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-14/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" "MAP_USER_ID=0" "-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" "--network" "none" "rustops/crates-build-env@sha256:a636fd89d022f18117e1dc8fb37a0a009933cdbbe082814857f0e2024962d47c" "/opt/rustwide/cargo-home/bin/cargo" "+1.45.2" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 9bcda20bdb41ce3c15136ff3fc64480563f20a7e731ee3f86978f9c6c512140f
[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" "9bcda20bdb41ce3c15136ff3fc64480563f20a7e731ee3f86978f9c6c512140f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "9bcda20bdb41ce3c15136ff3fc64480563f20a7e731ee3f86978f9c6c512140f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9bcda20bdb41ce3c15136ff3fc64480563f20a7e731ee3f86978f9c6c512140f", kill_on_drop: false }`
[INFO] [stdout] 9bcda20bdb41ce3c15136ff3fc64480563f20a7e731ee3f86978f9c6c512140f
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-14/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-14/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" "MAP_USER_ID=0" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--network" "none" "rustops/crates-build-env@sha256:a636fd89d022f18117e1dc8fb37a0a009933cdbbe082814857f0e2024962d47c" "/opt/rustwide/cargo-home/bin/cargo" "+1.45.2" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] e9d9d28c1af3481d081ca5589b1450e934e885b6d5db5c08e9db735ada37043d
[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" "e9d9d28c1af3481d081ca5589b1450e934e885b6d5db5c08e9db735ada37043d", kill_on_drop: false }`
[INFO] [stderr]    Compiling crc16 v0.4.0
[INFO] [stderr]    Compiling slog-scope v4.3.0
[INFO] [stderr]    Compiling mio v0.6.22
[INFO] [stderr]    Compiling chrono v0.4.13
[INFO] [stderr]    Compiling tokio-io v0.1.13
[INFO] [stderr]    Compiling num-derive v0.3.1
[INFO] [stderr]    Compiling tokio-threadpool v0.1.18
[INFO] [stderr]    Compiling slog-stdlog v3.0.5
[INFO] [stderr]    Compiling mio-uds v0.6.8
[INFO] [stderr]    Compiling tokio-reactor v0.1.12
[INFO] [stderr]    Compiling tokio-codec v0.1.2
[INFO] [stderr]    Compiling tokio-fs v0.1.7
[INFO] [stderr]    Compiling tokio-uds v0.2.7
[INFO] [stderr]    Compiling tokio-udp v0.1.6
[INFO] [stderr]    Compiling tokio-tcp v0.1.4
[INFO] [stderr]    Compiling tokio v0.1.22
[INFO] [stderr]    Compiling fast-rpc v0.3.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 12.76s
[INFO] running `Command { std: "docker" "inspect" "e9d9d28c1af3481d081ca5589b1450e934e885b6d5db5c08e9db735ada37043d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e9d9d28c1af3481d081ca5589b1450e934e885b6d5db5c08e9db735ada37043d", kill_on_drop: false }`
[INFO] [stdout] e9d9d28c1af3481d081ca5589b1450e934e885b6d5db5c08e9db735ada37043d
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-14/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-14/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" "MAP_USER_ID=0" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--network" "none" "rustops/crates-build-env@sha256:a636fd89d022f18117e1dc8fb37a0a009933cdbbe082814857f0e2024962d47c" "/opt/rustwide/cargo-home/bin/cargo" "+1.45.2" "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] 8af943ab7a6a48ab49afbd1cae213b16fff3d21af06c2d5ecdc89eba3d0e610c
[INFO] running `Command { std: "docker" "start" "-a" "8af943ab7a6a48ab49afbd1cae213b16fff3d21af06c2d5ecdc89eba3d0e610c", kill_on_drop: false }`
[INFO] [stderr]    Compiling dirs-sys v0.3.5
[INFO] [stderr]    Compiling dirs v2.0.2
[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 11.88s
[INFO] running `Command { std: "docker" "inspect" "8af943ab7a6a48ab49afbd1cae213b16fff3d21af06c2d5ecdc89eba3d0e610c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8af943ab7a6a48ab49afbd1cae213b16fff3d21af06c2d5ecdc89eba3d0e610c", kill_on_drop: false }`
[INFO] [stdout] 8af943ab7a6a48ab49afbd1cae213b16fff3d21af06c2d5ecdc89eba3d0e610c
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-14/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-14/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" "MAP_USER_ID=0" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--network" "none" "rustops/crates-build-env@sha256:a636fd89d022f18117e1dc8fb37a0a009933cdbbe082814857f0e2024962d47c" "/opt/rustwide/cargo-home/bin/cargo" "+1.45.2" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 8741b9642339fabde7428519d875c2700b22b9ba3ddeed722eaa79de3e81d119
[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" "8741b9642339fabde7428519d875c2700b22b9ba3ddeed722eaa79de3e81d119", kill_on_drop: false }`
[INFO] [stdout] 
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.37s
[INFO] [stdout] running 3 tests
[INFO] [stderr]      Running /opt/rustwide/target/debug/deps/fast_rpc-47e3cc682fa6193c
[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] [stderr]      Running /opt/rustwide/target/debug/deps/client_server_test-96c473832c1013a5
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] Aug 08 06:08:31.150 INFO listening for fast requests, address: 127.0.0.1:56652, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.171 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.171 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.171 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.171 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.177 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.177 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.177 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.177 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.189 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.189 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.189 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.189 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.192 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.192 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.192 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.192 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.194 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.194 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.194 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.195 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.211 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.211 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.211 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.211 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.215 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.215 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.215 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.215 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.219 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.219 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.219 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.219 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.228 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.229 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.229 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.229 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.239 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.239 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.239 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.239 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.244 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.245 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.245 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.245 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.254 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.254 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.254 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.254 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.264 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.264 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.264 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.264 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.275 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.275 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.275 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.275 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.287 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.287 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.287 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.287 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.297 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.297 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.297 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.297 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.305 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.305 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.305 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.305 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.323 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.323 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.323 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.323 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.341 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.341 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.341 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.341 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.356 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.356 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.356 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.356 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.366 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.366 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.366 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.366 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.388 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.388 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.388 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.388 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.406 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.406 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.406 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.407 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.421 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.421 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.421 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.421 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.440 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.440 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.440 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.440 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.452 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.452 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.452 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.452 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.465 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.465 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.465 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.465 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.478 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.478 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.478 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.478 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.499 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.499 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.499 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.499 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.513 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.513 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.513 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.513 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.528 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.528 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.528 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.528 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.543 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.543 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.543 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.543 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.565 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.565 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.565 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.565 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.581 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.581 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.581 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.581 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.605 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.605 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.605 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.605 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.625 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.625 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.625 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.625 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.646 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.646 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.646 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.646 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.664 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.665 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.665 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.665 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.688 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.688 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.688 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.688 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.708 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.708 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.708 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.708 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.732 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.732 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.732 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.732 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.760 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.760 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.760 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.761 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.783 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.783 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.784 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.784 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.808 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.808 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.808 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.808 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.832 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.832 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.832 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.832 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.858 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.858 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.858 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.859 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.880 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.880 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.880 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.880 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.919 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.919 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.919 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.919 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.957 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.957 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.957 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.958 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.983 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.983 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.983 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:31.983 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.023 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.023 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.023 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.023 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.047 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.048 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.048 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.048 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.073 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.073 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.073 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.073 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.098 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.098 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.098 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.098 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.123 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.123 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.123 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.123 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.150 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.150 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.150 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.150 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.179 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.179 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.179 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.179 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.214 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.214 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.214 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.214 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.241 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.241 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.241 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.241 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.269 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.269 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.269 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.269 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.297 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.298 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.298 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.298 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.327 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.327 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.327 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.327 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.357 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.357 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.357 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.357 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.387 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.387 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.387 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.387 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.421 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.421 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.421 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.421 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.452 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.452 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.452 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.452 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.484 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.484 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.484 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.484 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.533 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.534 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.534 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.534 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.574 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.574 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.575 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.575 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.608 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.608 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.608 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.608 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.641 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.641 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.641 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.641 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.694 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.694 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.694 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.694 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.753 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.754 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.754 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.754 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.805 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.805 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.805 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.805 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.852 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.852 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.852 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.852 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.900 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.900 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.900 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.900 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.942 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.942 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.942 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.942 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.978 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.979 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.979 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:32.979 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.019 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.019 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.019 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.019 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.056 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.056 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.056 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.056 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.102 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.102 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.102 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.102 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.143 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.145 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.145 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.145 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.192 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.192 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.192 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.192 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.231 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.231 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.231 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.231 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.280 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.280 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.280 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.280 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.328 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.328 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.328 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.328 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.389 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.389 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.389 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.389 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.437 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.437 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.437 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.437 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.490 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.490 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.490 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.490 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.531 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.531 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.531 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.531 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.576 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.576 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.576 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.576 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.630 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.630 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.630 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.630 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.678 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.678 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.678 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.678 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.737 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.737 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.737 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.737 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.802 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.802 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.802 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.802 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.860 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.860 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.860 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.860 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.950 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.950 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.950 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:33.953 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:34.016 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:34.016 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:34.016 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:34.016 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:34.068 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:34.068 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:34.068 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Aug 08 06:08:34.068 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" "8741b9642339fabde7428519d875c2700b22b9ba3ddeed722eaa79de3e81d119", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8741b9642339fabde7428519d875c2700b22b9ba3ddeed722eaa79de3e81d119", kill_on_drop: false }`
[INFO] [stdout] 8741b9642339fabde7428519d875c2700b22b9ba3ddeed722eaa79de3e81d119