[INFO] updating cached repository https://github.com/joyent/rust-fast
[INFO] running `"git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "-c" "remote.origin.fetch=refs/heads/*:refs/heads/*" "fetch" "origin" "--force" "--prune"`
[INFO] [stderr] From https://github.com/joyent/rust-fast
[INFO] [stderr]    6aca860..1c79380  rust-1.40  -> rust-1.40
[INFO] running `"git" "rev-parse" "HEAD"`
[INFO] [stdout] aa65a63adb90ba9b663e5570453747460900a7a4
[INFO] testing joyent/rust-fast against master#28742a1146f10a4f09369baad027a464acb7a766 for pr-71274
[INFO] running `"git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fjoyent%2Frust-fast" "/workspace/builds/worker-7/source"`
[INFO] [stderr] Cloning into '/workspace/builds/worker-7/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/joyent/rust-fast on toolchain 28742a1146f10a4f09369baad027a464acb7a766
[INFO] running `"/workspace/cargo-home/bin/cargo" "+28742a1146f10a4f09369baad027a464acb7a766" "read-manifest" "--manifest-path" "Cargo.toml"`
[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-7/source/Cargo.toml
[INFO] running `"/workspace/cargo-home/bin/cargo" "+28742a1146f10a4f09369baad027a464acb7a766" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update"`
[INFO] running `"/workspace/cargo-home/bin/cargo" "+28742a1146f10a4f09369baad027a464acb7a766" "fetch" "--locked" "--manifest-path" "Cargo.toml"`
[INFO] running `"docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7/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=forbid" "-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" "/opt/rustwide/cargo-home/bin/cargo" "+28742a1146f10a4f09369baad027a464acb7a766" "build" "--frozen"`
[INFO] [stdout] 78b49bcc2ecede815f28475ed577abdba1cc0a796951aa0ddb0bb54b84a783cd
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] running `"docker" "start" "-a" "78b49bcc2ecede815f28475ed577abdba1cc0a796951aa0ddb0bb54b84a783cd"`
[INFO] [stderr]    Compiling autocfg v1.0.0
[INFO] [stderr]    Compiling cfg-if v0.1.10
[INFO] [stderr]    Compiling libc v0.2.69
[INFO] [stderr]    Compiling lazy_static v1.4.0
[INFO] [stderr]    Compiling maybe-uninit v2.0.0
[INFO] [stderr]    Compiling byteorder v1.3.4
[INFO] [stderr]    Compiling scopeguard v1.1.0
[INFO] [stderr]    Compiling proc-macro2 v1.0.10
[INFO] [stderr]    Compiling serde v1.0.106
[INFO] [stderr]    Compiling syn v1.0.18
[INFO] [stderr]    Compiling regex-syntax v0.6.17
[INFO] [stderr]    Compiling ryu v1.0.4
[INFO] [stderr]    Compiling arc-swap v0.4.6
[INFO] [stderr]    Compiling crc16 v0.4.0
[INFO] [stderr]    Compiling tokio-sync v0.1.8
[INFO] [stderr]    Compiling log v0.4.8
[INFO] [stderr]    Compiling thread_local v1.0.1
[INFO] [stderr]    Compiling lock_api v0.3.4
[INFO] [stderr]    Compiling log v0.3.9
[INFO] [stderr]    Compiling slog-scope v4.3.0
[INFO] [stderr]    Compiling slog-stdlog v3.0.5
[INFO] [stderr]    Compiling smallvec v0.6.13
[INFO] [stderr]    Compiling crossbeam-utils v0.7.2
[INFO] [stderr]    Compiling num-traits v0.2.11
[INFO] [stderr]    Compiling num-integer v0.1.42
[INFO] [stderr]    Compiling memoffset v0.5.4
[INFO] [stderr]    Compiling crossbeam-epoch v0.8.2
[INFO] [stderr]    Compiling num-bigint v0.2.6
[INFO] [stderr]    Compiling num-iter v0.1.40
[INFO] [stderr]    Compiling num-complex v0.2.4
[INFO] [stderr]    Compiling num-rational v0.2.4
[INFO] [stderr]    Compiling quote v1.0.3
[INFO] [stderr]    Compiling iovec v0.1.4
[INFO] [stderr]    Compiling net2 v0.2.33
[INFO] [stderr]    Compiling num_cpus v1.13.0
[INFO] [stderr]    Compiling parking_lot_core v0.6.2
[INFO] [stderr]    Compiling rand_os v0.1.3
[INFO] [stderr]    Compiling time v0.1.43
[INFO] [stderr]    Compiling tokio-executor v0.1.10
[INFO] [stderr]    Compiling crossbeam-queue v0.2.1
[INFO] [stderr]    Compiling bytes v0.4.12
[INFO] [stderr]    Compiling rand v0.6.5
[INFO] [stderr]    Compiling tokio-timer v0.2.13
[INFO] [stderr]    Compiling tokio-current-thread v0.1.7
[INFO] [stderr]    Compiling parking_lot v0.9.0
[INFO] [stderr]    Compiling mio v0.6.21
[INFO] [stderr]    Compiling crossbeam-deque v0.7.3
[INFO] [stderr]    Compiling tokio-io v0.1.13
[INFO] [stderr]    Compiling tokio-threadpool v0.1.18
[INFO] [stderr]    Compiling tokio-codec v0.1.2
[INFO] [stderr]    Compiling tokio-reactor v0.1.12
[INFO] [stderr]    Compiling mio-uds v0.6.7
[INFO] [stderr]    Compiling tokio-udp v0.1.6
[INFO] [stderr]    Compiling tokio-uds v0.2.6
[INFO] [stderr]    Compiling tokio-tcp v0.1.4
[INFO] [stderr]    Compiling regex v1.3.7
[INFO] [stderr]    Compiling tokio-fs v0.1.7
[INFO] [stderr]    Compiling tokio v0.1.22
[INFO] [stderr]    Compiling num v0.2.1
[INFO] [stderr]    Compiling env_logger v0.6.2
[INFO] [stderr]    Compiling quickcheck v0.8.5
[INFO] [stderr]    Compiling serde_derive v1.0.106
[INFO] [stderr]    Compiling num-derive v0.3.0
[INFO] [stderr]    Compiling chrono v0.4.11
[INFO] [stderr]    Compiling serde_json v1.0.51
[INFO] [stderr]    Compiling fast-rpc v0.3.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1m 45s
[INFO] running `"docker" "inspect" "78b49bcc2ecede815f28475ed577abdba1cc0a796951aa0ddb0bb54b84a783cd"`
[INFO] running `"docker" "rm" "-f" "78b49bcc2ecede815f28475ed577abdba1cc0a796951aa0ddb0bb54b84a783cd"`
[INFO] [stdout] 78b49bcc2ecede815f28475ed577abdba1cc0a796951aa0ddb0bb54b84a783cd
[INFO] running `"docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7/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=forbid" "-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" "/opt/rustwide/cargo-home/bin/cargo" "+28742a1146f10a4f09369baad027a464acb7a766" "test" "--frozen" "--no-run"`
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] [stdout] a5209b5a761962260d9ad08dd83c46fd2c58e928817cfd75540e84dad8248851
[INFO] running `"docker" "start" "-a" "a5209b5a761962260d9ad08dd83c46fd2c58e928817cfd75540e84dad8248851"`
[INFO] [stderr]    Compiling bitflags v1.2.1
[INFO] [stderr]    Compiling dirs-sys v0.3.4
[INFO] [stderr]    Compiling atty v0.2.14
[INFO] [stderr]    Compiling dirs v2.0.2
[INFO] [stderr]    Compiling term v0.6.1
[INFO] [stderr]    Compiling clap v2.33.0
[INFO] [stderr]    Compiling slog-term v2.5.0
[INFO] [stderr]    Compiling fast-rpc v0.3.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 34.29s
[INFO] running `"docker" "inspect" "a5209b5a761962260d9ad08dd83c46fd2c58e928817cfd75540e84dad8248851"`
[INFO] running `"docker" "rm" "-f" "a5209b5a761962260d9ad08dd83c46fd2c58e928817cfd75540e84dad8248851"`
[INFO] [stdout] a5209b5a761962260d9ad08dd83c46fd2c58e928817cfd75540e84dad8248851
[INFO] running `"docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7/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=forbid" "-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" "/opt/rustwide/cargo-home/bin/cargo" "+28742a1146f10a4f09369baad027a464acb7a766" "test" "--frozen"`
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] [stdout] 1f2dd2aff65e46e1a46bebc60f4f1a35981acb6c7c032513bd293344c306b81b
[INFO] running `"docker" "start" "-a" "1f2dd2aff65e46e1a46bebc60f4f1a35981acb6c7c032513bd293344c306b81b"`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.49s
[INFO] [stderr]      Running /opt/rustwide/target/debug/deps/fast_rpc-815aa1f11cc35d18
[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] [stderr]      Running /opt/rustwide/target/debug/deps/client_server_test-b95c5a81be79cab7
[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] Apr 25 21:45:50.410 INFO listening for fast requests, address: 127.0.0.1:56652, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.434 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.435 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.435 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.435 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.442 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.443 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.443 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.443 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.444 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.444 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.444 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.444 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.471 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.471 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.471 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.471 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.474 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.474 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.474 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.474 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.483 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.483 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.483 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.483 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.503 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.503 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.503 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.503 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.508 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.508 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.508 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.508 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.520 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.520 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.520 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.520 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.525 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.525 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.525 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.525 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.540 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.540 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.540 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.540 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.547 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.550 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.550 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.550 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.559 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.560 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.560 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.560 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.567 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.570 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.570 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.570 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.584 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.584 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.584 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.585 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.596 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.596 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.596 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.596 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.608 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.608 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.609 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.609 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.617 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.617 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.617 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.617 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.629 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.629 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.629 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.629 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.639 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.639 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.639 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.639 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.654 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.654 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.654 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.654 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.670 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.670 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.670 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.670 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.682 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.682 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.682 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.682 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.694 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.694 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.694 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.694 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.714 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.714 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.715 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.715 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.732 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.732 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.732 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.732 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.754 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.754 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.754 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.754 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.768 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.769 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.769 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.769 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.787 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.787 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.788 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.788 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.821 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.834 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.834 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.834 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.859 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.859 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.859 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.859 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.879 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.879 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.879 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.879 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.907 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.907 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.907 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.907 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.928 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.934 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.934 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.934 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.959 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.959 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.959 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.959 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.991 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.991 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.991 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:50.991 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.019 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.020 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.020 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.020 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.039 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.046 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.046 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.047 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.066 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.067 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.067 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.067 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.090 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.090 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.090 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.090 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.114 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.114 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.114 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.114 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.138 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.139 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.139 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.139 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.172 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.172 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.172 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.172 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.197 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.197 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.197 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.197 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.227 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.227 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.227 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.227 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.254 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.254 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.254 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.255 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.278 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.278 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.278 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.278 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.301 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.301 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.302 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.302 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.325 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.325 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.325 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.325 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.353 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.353 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.353 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.353 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.377 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.377 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.378 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.378 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.402 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.402 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.403 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.403 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.437 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.437 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.437 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.437 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.464 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.464 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.464 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.464 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.491 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.491 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.491 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.491 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.519 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.519 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.519 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.519 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.555 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.555 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.555 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.555 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.592 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.592 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.592 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.592 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.638 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.638 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.638 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.638 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.670 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.670 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.670 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.670 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.704 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.704 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.704 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.704 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.734 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.735 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.735 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.735 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.765 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.766 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.766 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.766 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.798 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.803 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.803 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.803 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.834 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.834 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.834 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.842 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.873 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.878 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.878 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.878 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.910 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.910 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.910 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.911 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.948 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.948 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.948 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.948 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.981 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.981 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.981 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:51.982 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.016 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.016 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.017 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.017 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.091 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.092 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.092 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.092 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.132 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.132 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.132 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.132 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.167 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.168 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.168 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.168 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.204 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.204 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.204 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.204 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.240 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.240 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.240 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.240 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.277 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.277 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.277 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.277 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.317 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.317 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.317 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.317 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.358 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.358 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.358 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.359 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.398 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.398 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.398 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.398 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.441 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.441 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.441 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.441 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.480 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.480 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.480 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.480 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.534 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.538 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.538 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.540 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.585 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.586 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.586 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.587 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.633 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.634 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.635 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.636 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.676 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.676 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.676 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.676 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.724 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.725 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.726 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.727 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.776 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.777 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.778 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.778 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.820 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.826 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.826 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.828 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.880 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.880 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.880 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.881 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.943 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.947 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.947 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.947 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.989 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.989 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.994 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:52.994 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:53.036 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:53.042 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:53.042 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:53.042 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:53.098 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:53.098 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:53.098 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:53.098 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:53.168 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:53.168 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:53.168 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:53.168 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:53.217 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:53.217 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:53.217 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:53.217 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:53.266 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:53.266 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:53.266 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:53.267 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:53.313 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:53.313 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:53.313 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:53.314 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:53.371 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:53.378 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:53.378 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:53.378 DEBG generated response, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:53.424 DEBG processing fast message, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:53.424 DEBG responding to 1 messages, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:53.424 DEBG handling echo function request, build-id: 0.1.0
[INFO] [stdout] Apr 25 21:45:53.425 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 `"docker" "inspect" "1f2dd2aff65e46e1a46bebc60f4f1a35981acb6c7c032513bd293344c306b81b"`
[INFO] running `"docker" "rm" "-f" "1f2dd2aff65e46e1a46bebc60f4f1a35981acb6c7c032513bd293344c306b81b"`
[INFO] [stdout] 1f2dd2aff65e46e1a46bebc60f4f1a35981acb6c7c032513bd293344c306b81b