[INFO] fetching crate fast-rpc 0.3.0...
[INFO] testing fast-rpc-0.3.0 against beta-2020-10-09 for beta-1.48-1
[INFO] extracting crate fast-rpc 0.3.0 into /workspace/builds/worker-6/source
[INFO] validating manifest of crates.io crate fast-rpc 0.3.0 on toolchain beta-2020-10-09
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2020-10-09" "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-6/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2020-10-09" "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" "+beta-2020-10-09" "fetch" "--locked" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6/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:d92eaeed33fa75130ca1ee6c8a01d1ffb62bac859dfdfb3450e3e5d1c0146529" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2020-10-09" "metadata" "--no-deps" "--format-version=1", 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] 5cb1b8384110d40ffbb16e85f0cb87c845f72f3450f53e64e5d7046f4bb30021
[INFO] running `Command { std: "docker" "start" "-a" "5cb1b8384110d40ffbb16e85f0cb87c845f72f3450f53e64e5d7046f4bb30021", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "5cb1b8384110d40ffbb16e85f0cb87c845f72f3450f53e64e5d7046f4bb30021", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5cb1b8384110d40ffbb16e85f0cb87c845f72f3450f53e64e5d7046f4bb30021", kill_on_drop: false }`
[INFO] [stdout] 5cb1b8384110d40ffbb16e85f0cb87c845f72f3450f53e64e5d7046f4bb30021
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6/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=warn" "-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:d92eaeed33fa75130ca1ee6c8a01d1ffb62bac859dfdfb3450e3e5d1c0146529" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2020-10-09" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 6bd00613614d0311f17068e8a2a5948ace3f19c009da2cc7a9f2e8a0e8504751
[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" "6bd00613614d0311f17068e8a2a5948ace3f19c009da2cc7a9f2e8a0e8504751", kill_on_drop: false }`
[INFO] [stderr]    Compiling crc16 v0.4.0
[INFO] [stderr]    Compiling num-integer v0.1.43
[INFO] [stderr]    Compiling num-bigint v0.2.6
[INFO] [stderr]    Compiling num-complex v0.2.4
[INFO] [stderr]    Compiling num-iter v0.1.41
[INFO] [stderr]    Compiling num-rational v0.2.4
[INFO] [stderr]    Compiling serde_json v1.0.59
[INFO] [stderr]    Compiling num-derive v0.3.2
[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 num v0.2.1
[INFO] [stderr]    Compiling fast-rpc v0.3.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 16.79s
[INFO] running `Command { std: "docker" "inspect" "6bd00613614d0311f17068e8a2a5948ace3f19c009da2cc7a9f2e8a0e8504751", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "6bd00613614d0311f17068e8a2a5948ace3f19c009da2cc7a9f2e8a0e8504751", kill_on_drop: false }`
[INFO] [stdout] 6bd00613614d0311f17068e8a2a5948ace3f19c009da2cc7a9f2e8a0e8504751
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6/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=warn" "-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:d92eaeed33fa75130ca1ee6c8a01d1ffb62bac859dfdfb3450e3e5d1c0146529" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2020-10-09" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 80c0bbc024aa65e0ad564d15593f1219c145cb9df06e456562a690d7a4d7a34b
[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" "80c0bbc024aa65e0ad564d15593f1219c145cb9df06e456562a690d7a4d7a34b", 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.30s
[INFO] running `Command { std: "docker" "inspect" "80c0bbc024aa65e0ad564d15593f1219c145cb9df06e456562a690d7a4d7a34b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "80c0bbc024aa65e0ad564d15593f1219c145cb9df06e456562a690d7a4d7a34b", kill_on_drop: false }`
[INFO] [stdout] 80c0bbc024aa65e0ad564d15593f1219c145cb9df06e456562a690d7a4d7a34b
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6/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=warn" "-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:d92eaeed33fa75130ca1ee6c8a01d1ffb62bac859dfdfb3450e3e5d1c0146529" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2020-10-09" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 4a1cbc04ed3d12707c2c8d2ff47659eb917617cfd3b54c0de2dad80d919e0350
[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" "4a1cbc04ed3d12707c2c8d2ff47659eb917617cfd3b54c0de2dad80d919e0350", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.15s
[INFO] [stderr]      Running /opt/rustwide/target/debug/deps/fast_rpc-1f96a14dba9392d4
[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] [stderr]      Running /opt/rustwide/target/debug/deps/client_server_test-0f019dce9a5675e5
[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] [stdout] Oct 16 02:20:14.820 INFO listening for fast requests, address: 127.0.0.1:56652, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.830 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.831 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.831 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.831 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.832 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.832 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.832 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.832 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.834 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.834 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.834 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.834 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.841 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.841 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.841 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.841 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.849 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.849 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.849 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.849 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.856 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.856 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.856 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.856 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.866 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.866 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.866 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.866 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.873 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.873 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.873 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.873 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.878 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.878 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.878 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.878 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.883 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.883 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.883 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.883 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.892 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.892 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.892 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.892 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.898 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.898 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.898 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.898 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.907 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.907 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.907 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.907 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.915 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.915 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.915 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.915 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.923 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.923 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.923 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.923 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.931 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.931 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.931 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.931 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.944 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.944 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.944 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.944 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.954 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.954 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.954 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.954 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.978 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.978 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.978 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.978 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.995 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.995 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.995 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:14.995 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.006 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.006 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.006 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.006 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.018 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.018 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.018 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.018 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.037 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.037 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.037 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.037 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.049 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.049 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.049 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.049 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.062 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.062 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.062 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.062 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.074 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.075 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.075 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.075 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.088 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.088 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.088 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.088 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.101 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.101 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.101 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.101 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.115 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.115 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.115 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.115 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.130 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.130 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.130 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.130 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.149 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.149 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.150 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.150 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.168 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.168 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.168 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.168 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.185 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.185 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.185 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.185 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.203 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.203 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.203 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.203 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.221 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.221 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.221 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.221 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.239 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.240 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.240 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.240 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.258 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.258 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.258 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.258 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.275 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.275 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.275 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.275 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.300 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.300 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.300 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.300 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.325 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.325 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.325 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.325 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.344 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.344 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.344 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.344 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.365 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.365 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.365 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.365 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.384 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.384 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.384 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.384 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.410 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.410 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.410 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.410 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.441 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.441 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.441 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.441 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.465 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.465 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.465 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.465 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.488 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.488 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.488 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.488 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.510 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.511 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.511 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.511 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.534 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.535 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.535 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.535 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.558 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.558 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.558 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.558 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.583 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.583 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.583 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.583 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.613 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.613 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.613 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.613 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.643 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.643 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.643 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.643 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.681 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.681 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.681 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.682 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.708 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.708 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.708 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.708 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.739 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.739 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.739 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.739 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.770 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.770 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.770 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.770 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.798 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.798 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.798 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.798 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.825 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.826 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.826 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.826 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.856 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.856 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.856 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.856 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.894 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.894 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.894 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.895 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.923 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.923 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.923 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.923 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.960 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.960 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.961 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.961 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.991 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.991 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.991 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:15.991 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.020 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.020 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.020 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.020 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.052 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.052 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.052 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.052 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.083 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.083 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.083 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.083 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.115 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.115 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.115 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.115 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.149 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.149 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.149 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.149 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.182 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.182 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.182 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.182 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.217 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.217 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.217 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.217 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.252 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.252 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.252 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.252 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.286 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.286 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.286 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.286 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.321 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.322 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.322 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.322 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.356 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.356 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.356 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.356 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.391 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.391 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.391 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.391 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.427 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.427 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.427 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.427 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.459 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.459 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.459 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.459 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.496 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.497 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.497 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.497 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.532 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.533 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.533 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.533 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.573 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.573 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.573 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.573 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.610 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.610 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.610 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.610 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.649 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.649 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.649 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.649 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.687 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.687 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.687 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.687 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.728 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.728 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.728 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.728 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.770 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.770 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.770 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.771 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.808 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.808 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.808 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.808 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.848 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.848 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.848 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.849 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.887 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.887 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.888 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.888 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.922 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.922 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.922 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.922 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.969 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.969 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.969 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:16.969 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:17.018 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:17.022 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:17.022 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:17.022 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:17.066 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:17.066 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:17.066 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:17.066 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:17.118 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:17.118 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:17.118 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:17.118 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:17.172 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:17.172 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:17.172 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:17.172 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:17.221 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:17.221 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:17.221 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:17.221 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:17.269 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:17.269 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:17.269 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:17.269 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:17.314 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:17.315 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:17.315 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:17.315 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:17.364 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:17.364 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:17.364 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Oct 16 02:20:17.364 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" "4a1cbc04ed3d12707c2c8d2ff47659eb917617cfd3b54c0de2dad80d919e0350", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "4a1cbc04ed3d12707c2c8d2ff47659eb917617cfd3b54c0de2dad80d919e0350", kill_on_drop: false }`
[INFO] [stdout] 4a1cbc04ed3d12707c2c8d2ff47659eb917617cfd3b54c0de2dad80d919e0350
