[INFO] updating cached repository https://github.com/joyent/rust-fast [INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "-c" "remote.origin.fetch=refs/heads/*:refs/heads/*" "fetch" "origin" "--force" "--prune", kill_on_drop: false }` [INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }` [INFO] [stdout] 1ddf01bba94c010d5627bf0eb0ff260b8085a460 [INFO] testing joyent/rust-fast against try#03a1ea71b075ab964b5278bc6e74cd6c52c36ee0 for pr-74409 [INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fjoyent%2Frust-fast" "/workspace/builds/worker-3/source", kill_on_drop: false }` [INFO] [stderr] Cloning into '/workspace/builds/worker-3/source'... [INFO] [stderr] done. [INFO] validating manifest of git repo https://github.com/joyent/rust-fast on toolchain 03a1ea71b075ab964b5278bc6e74cd6c52c36ee0 [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+03a1ea71b075ab964b5278bc6e74cd6c52c36ee0" "read-manifest" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] started tweaking git repo https://github.com/joyent/rust-fast [INFO] finished tweaking git repo https://github.com/joyent/rust-fast [INFO] tweaked toml for git repo https://github.com/joyent/rust-fast written to /workspace/builds/worker-3/source/Cargo.toml [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+03a1ea71b075ab964b5278bc6e74cd6c52c36ee0" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }` [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+03a1ea71b075ab964b5278bc6e74cd6c52c36ee0" "fetch" "--locked" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/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:38e1b949b06cde1964af550a6e548bd9b2b2ea170003ae122f8fc0886596cc07" "/opt/rustwide/cargo-home/bin/cargo" "+03a1ea71b075ab964b5278bc6e74cd6c52c36ee0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 53f7434454cb336fb7e3570a89a564830f48a77e9b81199a2d9c94d4f97c481c [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" "53f7434454cb336fb7e3570a89a564830f48a77e9b81199a2d9c94d4f97c481c", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "53f7434454cb336fb7e3570a89a564830f48a77e9b81199a2d9c94d4f97c481c", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "53f7434454cb336fb7e3570a89a564830f48a77e9b81199a2d9c94d4f97c481c", kill_on_drop: false }` [INFO] [stdout] 53f7434454cb336fb7e3570a89a564830f48a77e9b81199a2d9c94d4f97c481c [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/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@sha256:38e1b949b06cde1964af550a6e548bd9b2b2ea170003ae122f8fc0886596cc07" "/opt/rustwide/cargo-home/bin/cargo" "+03a1ea71b075ab964b5278bc6e74cd6c52c36ee0" "build" "--frozen" "--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] 7a65f3862b76675a01079ae2df3b3ed7691c492b7622afde177b71428b6ac5fb [INFO] running `Command { std: "docker" "start" "-a" "7a65f3862b76675a01079ae2df3b3ed7691c492b7622afde177b71428b6ac5fb", kill_on_drop: false }` [INFO] [stderr] Compiling autocfg v1.0.0 [INFO] [stderr] Compiling cfg-if v0.1.10 [INFO] [stderr] Compiling libc v0.2.73 [INFO] [stderr] Compiling lazy_static v1.4.0 [INFO] [stderr] Compiling log v0.4.11 [INFO] [stderr] Compiling maybe-uninit v2.0.0 [INFO] [stderr] Compiling semver-parser v0.7.0 [INFO] [stderr] Compiling futures v0.1.29 [INFO] [stderr] Compiling byteorder v1.3.4 [INFO] [stderr] Compiling scopeguard v1.1.0 [INFO] [stderr] Compiling slab v0.4.2 [INFO] [stderr] Compiling rand_core v0.4.2 [INFO] [stderr] Compiling autocfg v0.1.7 [INFO] [stderr] Compiling fnv v1.0.7 [INFO] [stderr] Compiling proc-macro2 v1.0.19 [INFO] [stderr] Compiling memchr v2.3.3 [INFO] [stderr] Compiling unicode-xid v0.2.1 [INFO] [stderr] Compiling slog v2.5.2 [INFO] [stderr] Compiling serde v1.0.114 [INFO] [stderr] Compiling syn v1.0.35 [INFO] [stderr] Compiling regex-syntax v0.6.18 [INFO] [stderr] Compiling ryu v1.0.5 [INFO] [stderr] Compiling crc16 v0.4.0 [INFO] [stderr] Compiling serde_json v1.0.57 [INFO] [stderr] Compiling serde_derive v1.0.114 [INFO] [stderr] Compiling arc-swap v0.4.7 [INFO] [stderr] Compiling crossbeam v0.2.12 [INFO] [stderr] Compiling itoa v0.4.6 [INFO] [stderr] Compiling lock_api v0.3.4 [INFO] [stderr] Compiling thread_local v1.0.1 [INFO] [stderr] Compiling rand_core v0.3.1 [INFO] [stderr] Compiling rand_jitter v0.1.4 [INFO] [stderr] Compiling semver v0.9.0 [INFO] [stderr] Compiling rand_hc v0.1.0 [INFO] [stderr] Compiling rand_isaac v0.1.1 [INFO] [stderr] Compiling rand_xorshift v0.1.1 [INFO] [stderr] Compiling crossbeam-utils v0.7.2 [INFO] [stderr] Compiling num-traits v0.2.12 [INFO] [stderr] Compiling memoffset v0.5.5 [INFO] [stderr] Compiling num-integer v0.1.43 [INFO] [stderr] Compiling crossbeam-epoch v0.8.2 [INFO] [stderr] Compiling num-bigint v0.2.6 [INFO] [stderr] Compiling num-rational v0.2.4 [INFO] [stderr] Compiling num-iter v0.1.41 [INFO] [stderr] Compiling num-complex v0.2.4 [INFO] [stderr] Compiling rand_chacha v0.1.1 [INFO] [stderr] Compiling rand_pcg v0.1.2 [INFO] [stderr] Compiling rand v0.6.5 [INFO] [stderr] Compiling rustc_version v0.2.3 [INFO] [stderr] Compiling log v0.3.9 [INFO] [stderr] Compiling aho-corasick v0.7.13 [INFO] [stderr] Compiling smallvec v0.6.13 [INFO] [stderr] Compiling iovec v0.1.4 [INFO] [stderr] Compiling num_cpus v1.13.0 [INFO] [stderr] Compiling net2 v0.2.34 [INFO] [stderr] Compiling rand_os v0.1.3 [INFO] [stderr] Compiling time v0.1.43 [INFO] [stderr] Compiling slog-scope v4.3.0 [INFO] [stderr] Compiling bytes v0.4.12 [INFO] [stderr] Compiling quote v1.0.7 [INFO] [stderr] Compiling parking_lot_core v0.6.2 [INFO] [stderr] Compiling parking_lot v0.9.0 [INFO] [stderr] Compiling mio v0.6.22 [INFO] [stderr] Compiling slog-stdlog v3.0.5 [INFO] [stderr] Compiling tokio-sync v0.1.8 [INFO] [stderr] Compiling tokio-executor v0.1.10 [INFO] [stderr] Compiling crossbeam-queue v0.2.3 [INFO] [stderr] Compiling tokio-io v0.1.13 [INFO] [stderr] Compiling tokio-current-thread v0.1.7 [INFO] [stderr] Compiling tokio-timer v0.2.13 [INFO] [stderr] Compiling crossbeam-deque v0.7.3 [INFO] [stderr] Compiling tokio-codec v0.1.2 [INFO] [stderr] Compiling mio-uds v0.6.8 [INFO] [stderr] Compiling tokio-threadpool v0.1.18 [INFO] [stderr] Compiling tokio-reactor v0.1.12 [INFO] [stderr] Compiling regex v1.3.9 [INFO] [stderr] Compiling tokio-tcp v0.1.4 [INFO] [stderr] Compiling tokio-uds v0.2.7 [INFO] [stderr] Compiling tokio-udp v0.1.6 [INFO] [stderr] Compiling tokio-fs v0.1.7 [INFO] [stderr] Compiling tokio v0.1.22 [INFO] [stderr] Compiling env_logger v0.6.2 [INFO] [stderr] Compiling quickcheck v0.8.5 [INFO] [stderr] Compiling num v0.2.1 [INFO] [stderr] Compiling num-derive v0.3.0 [INFO] [stderr] Compiling chrono v0.4.13 [INFO] [stderr] Compiling fast-rpc v0.3.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 1m 41s [INFO] running `Command { std: "docker" "inspect" "7a65f3862b76675a01079ae2df3b3ed7691c492b7622afde177b71428b6ac5fb", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "7a65f3862b76675a01079ae2df3b3ed7691c492b7622afde177b71428b6ac5fb", kill_on_drop: false }` [INFO] [stdout] 7a65f3862b76675a01079ae2df3b3ed7691c492b7622afde177b71428b6ac5fb [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/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@sha256:38e1b949b06cde1964af550a6e548bd9b2b2ea170003ae122f8fc0886596cc07" "/opt/rustwide/cargo-home/bin/cargo" "+03a1ea71b075ab964b5278bc6e74cd6c52c36ee0" "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] e839d59e1db399cc75b494571326b0124662b6b7969364053867c3455d146f55 [INFO] running `Command { std: "docker" "start" "-a" "e839d59e1db399cc75b494571326b0124662b6b7969364053867c3455d146f55", kill_on_drop: false }` [INFO] [stderr] Compiling bitflags v1.2.1 [INFO] [stderr] Compiling unicode-width v0.1.8 [INFO] [stderr] Compiling ansi_term v0.11.0 [INFO] [stderr] Compiling vec_map v0.8.2 [INFO] [stderr] Compiling strsim v0.8.0 [INFO] [stderr] Compiling dirs-sys v0.3.5 [INFO] [stderr] Compiling atty v0.2.14 [INFO] [stderr] Compiling textwrap v0.11.0 [INFO] [stderr] Compiling dirs v2.0.2 [INFO] [stderr] Compiling clap v2.33.1 [INFO] [stderr] Compiling term v0.6.1 [INFO] [stderr] Compiling slog-term v2.6.0 [INFO] [stderr] Compiling fast-rpc v0.3.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 26.56s [INFO] running `Command { std: "docker" "inspect" "e839d59e1db399cc75b494571326b0124662b6b7969364053867c3455d146f55", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "e839d59e1db399cc75b494571326b0124662b6b7969364053867c3455d146f55", kill_on_drop: false }` [INFO] [stdout] e839d59e1db399cc75b494571326b0124662b6b7969364053867c3455d146f55 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/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@sha256:38e1b949b06cde1964af550a6e548bd9b2b2ea170003ae122f8fc0886596cc07" "/opt/rustwide/cargo-home/bin/cargo" "+03a1ea71b075ab964b5278bc6e74cd6c52c36ee0" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] de624d868df4b914ad6b8ba05feec876150611598a272411f6f06d477054b899 [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" "de624d868df4b914ad6b8ba05feec876150611598a272411f6f06d477054b899", kill_on_drop: false }` [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.24s [INFO] [stderr] Running /opt/rustwide/target/debug/deps/fast_rpc-75841f3004c907d0 [INFO] [stdout] [INFO] [stdout] running 3 tests [INFO] [stdout] test protocol::test::prop_fast_message_roundtrip ... ok [INFO] [stdout] test protocol::test::prop_fast_message_bundling ... ok [INFO] [stdout] test protocol::test::prop_fast_message_decoding ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out [INFO] [stdout] [INFO] [stderr] Running /opt/rustwide/target/debug/deps/client_server_test-91d957d4face0188 [INFO] [stdout] [INFO] [stdout] running 1 test [INFO] [stdout] Jul 26 20:00:14.819 INFO listening for fast requests, address: 127.0.0.1:56652, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.828 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.828 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.828 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.828 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.835 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.836 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.836 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.836 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.838 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.838 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.839 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.839 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.841 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.841 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.841 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.841 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.844 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.844 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.844 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.844 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.848 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.848 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.849 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.849 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.853 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.853 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.853 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.853 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.858 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.858 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.858 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.858 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.863 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.864 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.864 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.864 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.872 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.873 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.873 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.873 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.885 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.885 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.885 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.885 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.901 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.901 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.901 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.901 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.913 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.913 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.913 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.913 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.920 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.921 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.921 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.921 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.929 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.929 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.930 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.930 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.938 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.939 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.939 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.939 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.947 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.948 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.948 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.948 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.957 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.957 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.958 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.958 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.967 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.967 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.967 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.967 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.981 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.981 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.981 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.982 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.992 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.992 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.992 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:14.993 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.004 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.004 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.004 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.004 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.022 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.022 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.022 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.027 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.039 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.039 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.039 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.039 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.055 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.056 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.056 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.056 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.068 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.069 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.069 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.069 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.081 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.081 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.082 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.082 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.094 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.094 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.094 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.094 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.108 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.108 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.109 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.109 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.123 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.123 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.124 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.124 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.138 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.139 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.140 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.140 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.155 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.155 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.156 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.156 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.172 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.172 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.173 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.173 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.189 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.190 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.190 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.190 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.206 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.206 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.206 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.206 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.223 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.223 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.223 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.223 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.241 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.241 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.241 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.241 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.258 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.258 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.259 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.259 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.277 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.277 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.278 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.278 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.298 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.298 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.298 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.299 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.321 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.321 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.321 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.321 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.348 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.349 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.349 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.349 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.369 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.369 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.369 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.369 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.392 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.393 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.393 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.393 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.417 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.417 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.417 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.417 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.437 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.437 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.437 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.437 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.458 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.458 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.458 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.458 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.479 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.479 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.479 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.480 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.502 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.502 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.503 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.503 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.526 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.526 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.527 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.527 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.551 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.551 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.551 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.551 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.573 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.573 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.573 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.573 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.597 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.597 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.597 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.597 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.626 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.626 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.626 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.626 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.651 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.651 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.651 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.651 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.676 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.676 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.677 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.677 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.702 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.702 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.702 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.702 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.728 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.729 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.729 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.729 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.755 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.755 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.755 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.755 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.782 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.782 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.782 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.782 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.815 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.815 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.815 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.815 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.844 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.845 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.845 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.845 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.874 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.875 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.875 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.875 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.905 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.905 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.905 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.905 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.934 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.934 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.934 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.934 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.964 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.964 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.964 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.964 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.994 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.995 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.995 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:15.995 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.026 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.026 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.026 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.026 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.058 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.058 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.058 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.058 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.090 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.090 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.090 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.090 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.122 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.122 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.122 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.123 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.160 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.160 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.160 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.160 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.213 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.219 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.219 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.219 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.252 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.252 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.252 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.252 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.288 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.288 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.288 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.288 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.322 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.322 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.322 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.322 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.356 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.356 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.356 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.356 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.391 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.391 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.391 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.391 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.425 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.425 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.425 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.425 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.460 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.460 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.460 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.461 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.496 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.496 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.496 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.496 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.532 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.532 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.532 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.532 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.570 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.570 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.570 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.570 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.611 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.611 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.611 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.615 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.654 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.655 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.655 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.655 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.693 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.693 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.693 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.693 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.740 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.740 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.740 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.740 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.780 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.786 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.787 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.787 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.830 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.830 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.830 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.830 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.873 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.873 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.873 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.873 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.939 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.939 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.939 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.939 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.983 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.983 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.983 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:16.983 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:17.037 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:17.037 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:17.037 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:17.037 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:17.092 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:17.092 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:17.092 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:17.092 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:17.134 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:17.135 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:17.135 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:17.135 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:17.177 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:17.177 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:17.177 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:17.178 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:17.221 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:17.221 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:17.221 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:17.221 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:17.265 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:17.265 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:17.265 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:17.265 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:17.317 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:17.318 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:17.318 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jul 26 20:00:17.318 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" "de624d868df4b914ad6b8ba05feec876150611598a272411f6f06d477054b899", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "de624d868df4b914ad6b8ba05feec876150611598a272411f6f06d477054b899", kill_on_drop: false }` [INFO] [stdout] de624d868df4b914ad6b8ba05feec876150611598a272411f6f06d477054b899