[INFO] fetching crate fast-rpc 0.3.0... [INFO] testing fast-rpc-0.3.0 against master#99e3aef02079e9c10583638520cd0c134dc3a01d for pr-85530 [INFO] extracting crate fast-rpc 0.3.0 into /workspace/builds/worker-5/source [INFO] validating manifest of crates.io crate fast-rpc 0.3.0 on toolchain 99e3aef02079e9c10583638520cd0c134dc3a01d [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+99e3aef02079e9c10583638520cd0c134dc3a01d" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", 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-5/source/Cargo.toml [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+99e3aef02079e9c10583638520cd0c134dc3a01d" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+99e3aef02079e9c10583638520cd0c134dc3a01d" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/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" "ghcr.io/rust-lang/crates-build-env/linux@sha256:20528e8c29e4536546f0102ce88568b16ea7538393a33fcca951030f7af10457" "/opt/rustwide/cargo-home/bin/cargo" "+99e3aef02079e9c10583638520cd0c134dc3a01d" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 36be43add08efd591637e364fc1e74abc8578c8c599347a4e2c8372300b7f600 [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" "36be43add08efd591637e364fc1e74abc8578c8c599347a4e2c8372300b7f600", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "36be43add08efd591637e364fc1e74abc8578c8c599347a4e2c8372300b7f600", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "36be43add08efd591637e364fc1e74abc8578c8c599347a4e2c8372300b7f600", kill_on_drop: false }` [INFO] [stdout] 36be43add08efd591637e364fc1e74abc8578c8c599347a4e2c8372300b7f600 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/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" "ghcr.io/rust-lang/crates-build-env/linux@sha256:20528e8c29e4536546f0102ce88568b16ea7538393a33fcca951030f7af10457" "/opt/rustwide/cargo-home/bin/cargo" "+99e3aef02079e9c10583638520cd0c134dc3a01d" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 4a0c12d35f68aabaaf13bf36c8c74df3e260b7a28948556c3dafb7316ab2213e [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" "4a0c12d35f68aabaaf13bf36c8c74df3e260b7a28948556c3dafb7316ab2213e", kill_on_drop: false }` [INFO] [stderr] Compiling autocfg v1.0.1 [INFO] [stderr] Compiling libc v0.2.95 [INFO] [stderr] Compiling cfg-if v0.1.10 [INFO] [stderr] Compiling log v0.4.14 [INFO] [stderr] Compiling cfg-if v1.0.0 [INFO] [stderr] Compiling lazy_static v1.4.0 [INFO] [stderr] Compiling maybe-uninit v2.0.0 [INFO] [stderr] Compiling futures v0.1.31 [INFO] [stderr] Compiling semver-parser v0.7.0 [INFO] [stderr] Compiling scopeguard v1.1.0 [INFO] [stderr] Compiling autocfg v0.1.7 [INFO] [stderr] Compiling rand_core v0.4.2 [INFO] [stderr] Compiling slab v0.4.3 [INFO] [stderr] Compiling byteorder v1.4.3 [INFO] [stderr] Compiling fnv v1.0.7 [INFO] [stderr] Compiling memchr v2.4.0 [INFO] [stderr] Compiling proc-macro2 v1.0.27 [INFO] [stderr] Compiling unicode-xid v0.2.2 [INFO] [stderr] Compiling serde v1.0.126 [INFO] [stderr] Compiling slog v2.7.0 [INFO] [stderr] Compiling syn v1.0.72 [INFO] [stderr] Compiling regex-syntax v0.6.25 [INFO] [stderr] Compiling ryu v1.0.5 [INFO] [stderr] Compiling crc16 v0.4.0 [INFO] [stderr] Compiling serde_json v1.0.64 [INFO] [stderr] Compiling serde_derive v1.0.126 [INFO] [stderr] Compiling arc-swap v1.3.0 [INFO] [stderr] Compiling itoa v0.4.7 [INFO] [stderr] Compiling crossbeam v0.2.12 [INFO] [stderr] Compiling lock_api v0.3.4 [INFO] [stderr] Compiling semver v0.9.0 [INFO] [stderr] Compiling rand_core v0.3.1 [INFO] [stderr] Compiling rand_jitter v0.1.4 [INFO] [stderr] Compiling rand_xorshift v0.1.1 [INFO] [stderr] Compiling rand_hc v0.1.0 [INFO] [stderr] Compiling rand_isaac v0.1.1 [INFO] [stderr] Compiling rustc_version 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 crossbeam-utils v0.7.2 [INFO] [stderr] Compiling num-traits v0.2.14 [INFO] [stderr] Compiling num-integer v0.1.44 [INFO] [stderr] Compiling memoffset v0.5.6 [INFO] [stderr] Compiling crossbeam-epoch v0.8.2 [INFO] [stderr] Compiling num-bigint v0.2.6 [INFO] [stderr] Compiling num-complex v0.2.4 [INFO] [stderr] Compiling num-iter v0.1.42 [INFO] [stderr] Compiling num-rational v0.2.4 [INFO] [stderr] Compiling parking_lot_core v0.6.2 [INFO] [stderr] Compiling parking_lot v0.9.0 [INFO] [stderr] Compiling log v0.3.9 [INFO] [stderr] Compiling smallvec v0.6.14 [INFO] [stderr] Compiling slog-scope v4.4.0 [INFO] [stderr] Compiling aho-corasick v0.7.18 [INFO] [stderr] Compiling slog-stdlog v3.0.5 [INFO] [stderr] Compiling iovec v0.1.4 [INFO] [stderr] Compiling net2 v0.2.37 [INFO] [stderr] Compiling num_cpus v1.13.0 [INFO] [stderr] Compiling rand_os v0.1.3 [INFO] [stderr] Compiling time v0.1.43 [INFO] [stderr] Compiling quote v1.0.9 [INFO] [stderr] Compiling tokio-sync v0.1.8 [INFO] [stderr] Compiling bytes v0.4.12 [INFO] [stderr] Compiling mio v0.6.23 [INFO] [stderr] Compiling tokio-io v0.1.13 [INFO] [stderr] Compiling tokio-executor v0.1.10 [INFO] [stderr] Compiling crossbeam-queue v0.2.3 [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 tokio-reactor v0.1.12 [INFO] [stderr] Compiling mio-uds v0.6.8 [INFO] [stderr] Compiling tokio-threadpool v0.1.18 [INFO] [stderr] Compiling tokio-udp v0.1.6 [INFO] [stderr] Compiling tokio-uds v0.2.7 [INFO] [stderr] Compiling tokio-tcp v0.1.4 [INFO] [stderr] Compiling regex v1.5.4 [INFO] [stderr] Compiling tokio-fs v0.1.7 [INFO] [stderr] Compiling tokio v0.1.22 [INFO] [stderr] Compiling chrono v0.4.19 [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 18.95s [INFO] running `Command { std: "docker" "inspect" "4a0c12d35f68aabaaf13bf36c8c74df3e260b7a28948556c3dafb7316ab2213e", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "4a0c12d35f68aabaaf13bf36c8c74df3e260b7a28948556c3dafb7316ab2213e", kill_on_drop: false }` [INFO] [stdout] 4a0c12d35f68aabaaf13bf36c8c74df3e260b7a28948556c3dafb7316ab2213e [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/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" "ghcr.io/rust-lang/crates-build-env/linux@sha256:20528e8c29e4536546f0102ce88568b16ea7538393a33fcca951030f7af10457" "/opt/rustwide/cargo-home/bin/cargo" "+99e3aef02079e9c10583638520cd0c134dc3a01d" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 7339bc97b024e749becb294fb69761b27cc0389f27561f191c7832b3a07659e9 [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" "7339bc97b024e749becb294fb69761b27cc0389f27561f191c7832b3a07659e9", kill_on_drop: false }` [INFO] [stderr] Compiling bitflags v1.2.1 [INFO] [stderr] Compiling unicode-width v0.1.8 [INFO] [stderr] Compiling once_cell v1.7.2 [INFO] [stderr] Compiling strsim v0.8.0 [INFO] [stderr] Compiling ansi_term v0.11.0 [INFO] [stderr] Compiling vec_map v0.8.2 [INFO] [stderr] Compiling dirs-sys-next v0.1.2 [INFO] [stderr] Compiling atty v0.2.14 [INFO] [stderr] Compiling textwrap v0.11.0 [INFO] [stderr] Compiling dirs-next v2.0.0 [INFO] [stderr] Compiling thread_local v1.1.3 [INFO] [stderr] Compiling term v0.7.0 [INFO] [stderr] Compiling clap v2.33.3 [INFO] [stderr] Compiling slog-term v2.8.0 [INFO] [stderr] Compiling fast-rpc v0.3.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 12.52s [INFO] running `Command { std: "docker" "inspect" "7339bc97b024e749becb294fb69761b27cc0389f27561f191c7832b3a07659e9", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "7339bc97b024e749becb294fb69761b27cc0389f27561f191c7832b3a07659e9", kill_on_drop: false }` [INFO] [stdout] 7339bc97b024e749becb294fb69761b27cc0389f27561f191c7832b3a07659e9 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/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" "ghcr.io/rust-lang/crates-build-env/linux@sha256:20528e8c29e4536546f0102ce88568b16ea7538393a33fcca951030f7af10457" "/opt/rustwide/cargo-home/bin/cargo" "+99e3aef02079e9c10583638520cd0c134dc3a01d" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 13c814e82da3ee9a9bb0b18fd95aa26e3731a6f53ad8dba337db1d60a2dcf4d2 [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" "13c814e82da3ee9a9bb0b18fd95aa26e3731a6f53ad8dba337db1d60a2dcf4d2", kill_on_drop: false }` [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.07s [INFO] [stderr] Running unittests (/opt/rustwide/target/debug/deps/fast_rpc-138bb4d9f999343c) [INFO] [stdout] [INFO] [stdout] running 3 tests [INFO] [stdout] test protocol::test::prop_fast_message_roundtrip ... ok [INFO] [stdout] test protocol::test::prop_fast_message_bundling ... ok [INFO] [stderr] Running tests/client_server_test.rs (/opt/rustwide/target/debug/deps/client_server_test-66f0ddaca67020ea) [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; finished in 1.18s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 1 test [INFO] [stdout] Jun 05 10:21:56.499 INFO listening for fast requests, address: 127.0.0.1:56652, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.557 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.557 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.557 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.557 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.563 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.563 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.563 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.563 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.571 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.571 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.571 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.571 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.579 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.580 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.580 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.580 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.582 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.582 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.582 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.582 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.585 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.585 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.585 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.585 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.589 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.589 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.589 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.589 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.596 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.596 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.596 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.596 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.602 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.602 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.602 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.602 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.610 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.610 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.610 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.611 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.615 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.615 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.615 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.615 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.624 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.625 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.625 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.625 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.632 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.633 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.633 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.633 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.643 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.643 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.643 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.643 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.651 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.651 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.651 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.651 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.658 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.658 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.658 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.658 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.666 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.666 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.666 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.666 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.674 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.674 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.674 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.674 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.685 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.685 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.686 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.686 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.705 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.705 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.705 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.705 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.718 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.718 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.718 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.718 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.729 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.729 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.730 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.730 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.741 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.741 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.741 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.741 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.753 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.753 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.753 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.753 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.769 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.769 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.769 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.769 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.780 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.781 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.781 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.781 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.793 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.793 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.793 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.793 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.806 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.806 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.806 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.806 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.820 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.820 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.820 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.820 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.843 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.843 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.843 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.843 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.863 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.863 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.863 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.863 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.885 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.885 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.886 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.886 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.903 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.903 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.903 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.903 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.923 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.923 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.923 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.923 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.939 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.939 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.939 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.939 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.955 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.955 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.955 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.955 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.980 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.980 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.980 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:56.980 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.009 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.009 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.009 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.009 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.036 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.036 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.036 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.036 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.054 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.054 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.054 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.054 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.082 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.082 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.082 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.082 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.105 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.105 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.105 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.105 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.127 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.127 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.127 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.127 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.147 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.147 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.147 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.147 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.167 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.167 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.167 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.167 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.188 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.189 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.189 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.189 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.218 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.218 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.218 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.218 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.243 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.243 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.243 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.243 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.266 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.266 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.267 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.267 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.289 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.289 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.289 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.289 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.314 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.314 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.314 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.314 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.344 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.344 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.344 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.344 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.369 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.369 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.369 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.369 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.399 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.399 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.399 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.399 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.423 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.423 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.423 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.423 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.448 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.449 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.449 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.449 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.473 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.473 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.473 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.473 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.504 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.504 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.505 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.505 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.531 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.531 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.531 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.531 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.557 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.557 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.557 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.557 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.583 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.583 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.583 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.583 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.605 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.605 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.605 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.605 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.626 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.626 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.626 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.626 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.648 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.648 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.648 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.648 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.673 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.673 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.674 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.674 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.697 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.697 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.697 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.698 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.725 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.725 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.725 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.725 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.753 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.753 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.753 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.753 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.782 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.782 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.782 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.782 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.813 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.813 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.813 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.813 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.843 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.843 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.843 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.843 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.875 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.875 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.875 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.875 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.906 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.906 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.906 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.906 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.938 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.938 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.938 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.938 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.966 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.966 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.966 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.966 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.998 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.998 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.998 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:57.998 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.032 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.032 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.032 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.033 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.068 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.068 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.068 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.068 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.095 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.096 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.096 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.096 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.120 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.121 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.121 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.121 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.149 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.149 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.149 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.149 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.177 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.177 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.177 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.177 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.208 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.208 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.208 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.208 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.240 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.240 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.240 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.240 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.275 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.275 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.275 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.275 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.307 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.307 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.307 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.307 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.342 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.342 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.342 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.342 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.379 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.379 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.380 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.380 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.416 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.416 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.416 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.416 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.451 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.451 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.451 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.451 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.490 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.490 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.490 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.490 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.530 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.530 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.530 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.530 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.570 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.570 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.570 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.570 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.607 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.607 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.608 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.608 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.646 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.646 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.646 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.646 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.685 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.685 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.686 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.686 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.726 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.726 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.726 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.726 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.769 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.769 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.769 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.769 DEBG generated response, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.806 DEBG processing fast message, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.807 DEBG responding to 1 messages, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.807 DEBG handling echo function request, build-id: 0.1.0 [INFO] [stdout] Jun 05 10:21:58.807 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; finished in 2.33s [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; finished in 0.00s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "13c814e82da3ee9a9bb0b18fd95aa26e3731a6f53ad8dba337db1d60a2dcf4d2", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "13c814e82da3ee9a9bb0b18fd95aa26e3731a6f53ad8dba337db1d60a2dcf4d2", kill_on_drop: false }` [INFO] [stdout] 13c814e82da3ee9a9bb0b18fd95aa26e3731a6f53ad8dba337db1d60a2dcf4d2