[INFO] fetching crate fast-rpc 0.3.0... [INFO] testing fast-rpc-0.3.0 against try#eafdee2dfae8c2233b74f98b123308be7ccefcc6 for pr-79296 [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 eafdee2dfae8c2233b74f98b123308be7ccefcc6 [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+eafdee2dfae8c2233b74f98b123308be7ccefcc6" "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" "+eafdee2dfae8c2233b74f98b123308be7ccefcc6" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }` [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+eafdee2dfae8c2233b74f98b123308be7ccefcc6" "fetch" "--locked" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] 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:6eabd152ff4036248d66efda456a36cb33d24b7291b33f25f75140726c88da35" "/opt/rustwide/cargo-home/bin/cargo" "+eafdee2dfae8c2233b74f98b123308be7ccefcc6" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 2853d0d543e0240dd935906582850edd3087ba60269dcc5b6a7507ecb0ec2ec9 [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" "2853d0d543e0240dd935906582850edd3087ba60269dcc5b6a7507ecb0ec2ec9", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "2853d0d543e0240dd935906582850edd3087ba60269dcc5b6a7507ecb0ec2ec9", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "2853d0d543e0240dd935906582850edd3087ba60269dcc5b6a7507ecb0ec2ec9", kill_on_drop: false }` [INFO] [stdout] 2853d0d543e0240dd935906582850edd3087ba60269dcc5b6a7507ecb0ec2ec9 [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=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "rustops/crates-build-env@sha256:6eabd152ff4036248d66efda456a36cb33d24b7291b33f25f75140726c88da35" "/opt/rustwide/cargo-home/bin/cargo" "+eafdee2dfae8c2233b74f98b123308be7ccefcc6" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 156c510b7c484443c1bc423d98fdb9e8e79b4bd5dfcc7ba9d67b050a1bd98a4c [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" "156c510b7c484443c1bc423d98fdb9e8e79b4bd5dfcc7ba9d67b050a1bd98a4c", kill_on_drop: false }` [INFO] [stderr] Compiling log v0.4.11 [INFO] [stderr] Compiling futures v0.1.30 [INFO] [stderr] Compiling autocfg v0.1.7 [INFO] [stderr] Compiling rand_core v0.4.2 [INFO] [stderr] Compiling fnv v1.0.7 [INFO] [stderr] Compiling memchr v2.3.4 [INFO] [stderr] Compiling slog v2.5.2 [INFO] [stderr] Compiling syn v1.0.52 [INFO] [stderr] Compiling ryu v1.0.5 [INFO] [stderr] Compiling regex-syntax v0.6.21 [INFO] [stderr] Compiling serde_json v1.0.59 [INFO] [stderr] Compiling crc16 v0.4.0 [INFO] [stderr] Compiling serde_derive v1.0.117 [INFO] [stderr] Compiling itoa v0.4.6 [INFO] [stderr] Compiling crossbeam v0.2.12 [INFO] [stderr] Compiling num-traits v0.2.14 [INFO] [stderr] Compiling num-integer v0.1.44 [INFO] [stderr] Compiling num-bigint v0.2.6 [INFO] [stderr] Compiling num-rational v0.2.4 [INFO] [stderr] Compiling num-complex v0.2.4 [INFO] [stderr] Compiling num-iter v0.1.42 [INFO] [stderr] Compiling thread_local v1.0.1 [INFO] [stderr] Compiling lock_api v0.3.4 [INFO] [stderr] Compiling rand_core v0.3.1 [INFO] [stderr] Compiling rand_jitter v0.1.4 [INFO] [stderr] Compiling rand_hc v0.1.0 [INFO] [stderr] Compiling rand_xorshift v0.1.1 [INFO] [stderr] Compiling rand_isaac v0.1.1 [INFO] [stderr] Compiling iovec v0.1.4 [INFO] [stderr] Compiling net2 v0.2.36 [INFO] [stderr] Compiling rand_os v0.1.3 [INFO] [stderr] Compiling time v0.1.44 [INFO] [stderr] Compiling crossbeam-queue v0.2.3 [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 log v0.3.9 [INFO] [stderr] Compiling bytes v0.4.12 [INFO] [stderr] Compiling parking_lot_core v0.6.2 [INFO] [stderr] Compiling mio v0.6.22 [INFO] [stderr] Compiling aho-corasick v0.7.15 [INFO] [stderr] Compiling parking_lot v0.9.0 [INFO] [stderr] Compiling tokio-executor v0.1.10 [INFO] [stderr] Compiling tokio-sync v0.1.8 [INFO] [stderr] Compiling slog-scope v4.3.0 [INFO] [stderr] Compiling tokio-threadpool v0.1.18 [INFO] [stderr] Compiling tokio-current-thread v0.1.7 [INFO] [stderr] Compiling tokio-timer v0.2.13 [INFO] [stderr] Compiling tokio-io v0.1.13 [INFO] [stderr] Compiling slog-stdlog v3.0.5 [INFO] [stderr] Compiling mio-uds v0.6.8 [INFO] [stderr] Compiling tokio-reactor v0.1.12 [INFO] [stderr] Compiling tokio-codec v0.1.2 [INFO] [stderr] Compiling tokio-fs v0.1.7 [INFO] [stderr] Compiling chrono v0.4.19 [INFO] [stderr] Compiling tokio-udp v0.1.6 [INFO] [stderr] Compiling tokio-tcp v0.1.4 [INFO] [stderr] Compiling tokio-uds v0.2.7 [INFO] [stderr] Compiling regex v1.4.2 [INFO] [stderr] Compiling tokio v0.1.22 [INFO] [stderr] Compiling env_logger v0.6.2 [INFO] [stderr] Compiling num v0.2.1 [INFO] [stderr] Compiling quickcheck v0.8.5 [INFO] [stderr] Compiling num-derive v0.3.3 [INFO] [stderr] Compiling fast-rpc v0.3.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 1m 24s [INFO] running `Command { std: "docker" "inspect" "156c510b7c484443c1bc423d98fdb9e8e79b4bd5dfcc7ba9d67b050a1bd98a4c", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "156c510b7c484443c1bc423d98fdb9e8e79b4bd5dfcc7ba9d67b050a1bd98a4c", kill_on_drop: false }` [INFO] [stdout] 156c510b7c484443c1bc423d98fdb9e8e79b4bd5dfcc7ba9d67b050a1bd98a4c [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=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "rustops/crates-build-env@sha256:6eabd152ff4036248d66efda456a36cb33d24b7291b33f25f75140726c88da35" "/opt/rustwide/cargo-home/bin/cargo" "+eafdee2dfae8c2233b74f98b123308be7ccefcc6" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 04275c98207ae4d3c70ca6f45c9c4795cb8373835cb0bf9e730379056eecb09c [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" "04275c98207ae4d3c70ca6f45c9c4795cb8373835cb0bf9e730379056eecb09c", kill_on_drop: false }` [INFO] [stderr] Compiling vec_map v0.8.2 [INFO] [stderr] Compiling strsim v0.8.0 [INFO] [stderr] Compiling ansi_term v0.11.0 [INFO] [stderr] Compiling textwrap v0.11.0 [INFO] [stderr] Compiling dirs-sys v0.3.5 [INFO] [stderr] Compiling dirs v2.0.2 [INFO] [stderr] Compiling clap v2.33.3 [INFO] [stderr] Compiling term v0.6.1 [INFO] [stderr] Compiling slog-term v2.6.0 [INFO] [stderr] Compiling fast-rpc v0.3.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 28.67s [INFO] running `Command { std: "docker" "inspect" "04275c98207ae4d3c70ca6f45c9c4795cb8373835cb0bf9e730379056eecb09c", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "04275c98207ae4d3c70ca6f45c9c4795cb8373835cb0bf9e730379056eecb09c", kill_on_drop: false }` [INFO] [stdout] 04275c98207ae4d3c70ca6f45c9c4795cb8373835cb0bf9e730379056eecb09c [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=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "rustops/crates-build-env@sha256:6eabd152ff4036248d66efda456a36cb33d24b7291b33f25f75140726c88da35" "/opt/rustwide/cargo-home/bin/cargo" "+eafdee2dfae8c2233b74f98b123308be7ccefcc6" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 029c7c1f55d9ecb4f877ce605c771b651f6935dd7f20a971afa316f3eb927453 [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" "029c7c1f55d9ecb4f877ce605c771b651f6935dd7f20a971afa316f3eb927453", kill_on_drop: false }` [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.15s [INFO] [stdout] [INFO] [stderr] Running /opt/rustwide/target/debug/deps/fast_rpc-c6690561bcbe27b2 [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-9108df3f5010e4d0 [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] Nov 28 06:58:36.926 INFO listening for fast requests, address: 127.0.0.1:56652, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:36.934 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:36.934 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:36.934 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:36.934 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:36.939 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:36.939 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:36.939 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:36.939 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:36.947 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:36.947 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:36.947 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:36.947 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:36.949 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:36.950 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:36.950 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:36.950 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:36.958 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:36.958 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:36.958 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:36.958 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:36.961 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:36.961 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:36.961 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:36.962 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:36.967 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:36.968 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:36.968 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:36.968 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:36.984 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:36.984 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:36.984 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:36.984 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:36.992 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:36.992 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:36.992 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:36.992 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.005 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.005 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.005 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.005 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.023 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.023 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.023 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.023 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.029 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.029 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.029 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.029 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.047 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.047 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.047 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.047 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.054 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.054 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.054 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.054 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.065 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.065 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.065 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.065 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.087 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.087 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.087 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.087 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.095 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.095 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.095 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.095 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.116 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.116 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.116 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.116 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.125 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.125 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.125 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.125 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.152 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.152 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.152 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.152 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.162 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.162 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.162 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.162 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.172 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.172 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.172 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.172 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.185 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.185 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.185 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.185 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.196 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.196 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.196 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.196 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.207 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.207 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.207 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.207 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.223 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.223 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.223 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.223 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.235 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.235 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.235 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.235 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.249 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.249 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.249 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.249 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.262 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.262 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.262 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.262 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.281 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.281 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.281 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.281 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.295 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.295 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.295 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.295 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.309 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.309 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.309 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.309 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.328 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.328 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.328 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.328 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.345 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.346 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.346 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.346 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.366 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.366 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.366 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.366 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.382 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.382 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.382 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.382 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.407 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.407 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.407 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.407 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.425 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.426 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.426 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.426 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.446 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.446 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.446 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.446 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.466 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.466 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.467 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.467 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.485 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.485 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.485 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.485 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.512 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.512 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.512 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.512 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.538 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.538 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.538 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.538 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.558 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.558 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.558 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.558 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.582 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.582 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.582 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.582 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.607 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.607 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.607 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.607 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.639 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.639 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.639 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.639 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.686 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.686 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.686 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.686 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.728 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.729 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.729 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.729 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.759 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.759 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.759 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.759 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.787 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.787 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.787 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.788 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.810 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.811 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.811 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.811 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.835 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.836 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.836 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.836 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.860 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.860 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.860 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.860 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.884 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.884 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.884 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.884 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.909 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.909 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.910 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.910 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.935 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.935 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.935 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.936 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.961 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.961 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.961 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.961 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.987 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.987 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.987 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:37.987 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.022 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.023 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.023 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.023 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.053 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.053 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.053 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.054 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.098 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.098 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.098 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.098 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.142 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.142 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.142 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.142 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.178 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.178 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.178 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.178 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.215 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.215 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.215 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.215 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.244 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.244 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.244 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.244 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.274 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.275 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.275 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.275 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.305 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.306 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.306 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.306 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.337 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.337 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.337 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.337 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.367 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.367 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.367 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.367 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.398 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.399 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.399 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.399 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.453 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.453 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.453 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.453 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.489 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.489 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.489 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.489 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.522 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.522 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.522 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.522 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.569 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.569 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.569 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.569 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.610 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.613 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.613 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.613 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.658 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.661 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.661 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.661 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.707 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.707 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.707 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.707 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.745 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.745 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.745 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.745 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.801 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.801 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.801 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.807 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.846 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.846 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.846 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.846 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.892 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.897 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.897 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.897 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.954 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.954 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.954 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.954 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:38.999 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.000 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.000 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.000 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.042 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.042 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.043 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.043 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.104 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.104 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.104 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.104 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.160 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.160 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.160 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.160 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.231 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.231 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.231 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.231 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.286 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.286 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.286 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.286 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.346 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.346 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.346 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.346 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.418 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.418 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.418 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.418 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.485 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.485 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.485 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.485 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.540 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.540 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.540 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.540 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.625 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.625 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.625 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.625 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.676 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.676 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.676 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.676 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.745 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.745 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.745 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.745 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.804 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.804 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.804 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.804 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.851 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.851 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.851 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.851 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.910 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.910 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.910 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.910 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Nov 28 06:58:39.939 DEBG transmitted response to client, build-id: 0.1.0 [INFO] [stderr] Doc-tests fast-rpc [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] [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" "029c7c1f55d9ecb4f877ce605c771b651f6935dd7f20a971afa316f3eb927453", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "029c7c1f55d9ecb4f877ce605c771b651f6935dd7f20a971afa316f3eb927453", kill_on_drop: false }` [INFO] [stdout] 029c7c1f55d9ecb4f877ce605c771b651f6935dd7f20a971afa316f3eb927453