[INFO] cloning repository https://github.com/ksato9700/aozora-pubserver
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/ksato9700/aozora-pubserver" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fksato9700%2Faozora-pubserver", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fksato9700%2Faozora-pubserver'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 67bb5e27ab9ade025567b338588c42ccea5f7087
[INFO] testing ksato9700/aozora-pubserver against 1.54.0 for beta-1.55-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fksato9700%2Faozora-pubserver" "/workspace/builds/worker-1/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-1/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/ksato9700/aozora-pubserver on toolchain 1.54.0
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.54.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/ksato9700/aozora-pubserver
[INFO] finished tweaking git repo https://github.com/ksato9700/aozora-pubserver
[INFO] tweaked toml for git repo https://github.com/ksato9700/aozora-pubserver written to /workspace/builds/worker-1/source/Cargo.toml
[INFO] crate git repo https://github.com/ksato9700/aozora-pubserver already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.54.0" "fetch" "--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-1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+1.54.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 42cfa2bf151bb23263ebb22c20622b4a20c26ba06c7269a6c257f357bf7032b2
[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" "42cfa2bf151bb23263ebb22c20622b4a20c26ba06c7269a6c257f357bf7032b2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "42cfa2bf151bb23263ebb22c20622b4a20c26ba06c7269a6c257f357bf7032b2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "42cfa2bf151bb23263ebb22c20622b4a20c26ba06c7269a6c257f357bf7032b2", kill_on_drop: false }`
[INFO] [stdout] 42cfa2bf151bb23263ebb22c20622b4a20c26ba06c7269a6c257f357bf7032b2
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+1.54.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] a1eedf3b6420f812b84c2b312b921538cce4d4d69e703043af8e1ae9711ead20
[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" "a1eedf3b6420f812b84c2b312b921538cce4d4d69e703043af8e1ae9711ead20", kill_on_drop: false }`
[INFO] [stderr]    Compiling syn v0.15.44
[INFO] [stderr]    Compiling untrusted v0.7.0
[INFO] [stderr]    Compiling os_info v1.3.3
[INFO] [stderr]    Compiling ring v0.16.11
[INFO] [stderr]    Compiling stringprep v0.1.2
[INFO] [stderr]    Compiling rand v0.5.6
[INFO] [stderr]    Compiling tokio-executor v0.1.10
[INFO] [stderr]    Compiling bytes v0.4.12
[INFO] [stderr]    Compiling pin-project-internal v0.4.8
[INFO] [stderr]    Compiling rustversion v1.0.2
[INFO] [stderr]    Compiling async-trait v0.1.24
[INFO] [stderr]    Compiling syn-mid v0.5.0
[INFO] [stderr]    Compiling crypto-mac v0.7.0
[INFO] [stderr]    Compiling serde_with_macros v1.1.0
[INFO] [stderr]    Compiling futures-macro v0.3.4
[INFO] [stderr]    Compiling actix-threadpool v0.3.1
[INFO] [stderr]    Compiling sha2 v0.8.1
[INFO] [stderr]    Compiling md-5 v0.8.0
[INFO] [stderr]    Compiling serde_json v1.0.48
[INFO] [stderr]    Compiling chrono v0.4.10
[INFO] [stderr]    Compiling serde_urlencoded v0.6.1
[INFO] [stderr]    Compiling actix-router v0.2.4
[INFO] [stderr]    Compiling failure v0.1.6
[INFO] [stderr]    Compiling hmac v0.7.1
[INFO] [stderr]    Compiling tokio-timer v0.2.13
[INFO] [stderr]    Compiling tokio-current-thread v0.1.7
[INFO] [stderr]    Compiling tokio-io v0.1.13
[INFO] [stderr]    Compiling tokio-threadpool v0.1.18
[INFO] [stderr]    Compiling pbkdf2 v0.3.0
[INFO] [stderr]    Compiling tokio-reactor v0.1.12
[INFO] [stderr]    Compiling tokio-codec v0.1.2
[INFO] [stderr]    Compiling bson v0.14.0
[INFO] [stderr]    Compiling tokio-fs v0.1.7
[INFO] [stderr]    Compiling tokio-tcp v0.1.4
[INFO] [stderr]    Compiling tokio-udp v0.1.6
[INFO] [stderr]    Compiling tokio-uds v0.2.6
[INFO] [stderr]    Compiling proc-macro-error v0.4.9
[INFO] [stderr]    Compiling err-derive v0.2.2
[INFO] [stderr]    Compiling proc-macro-error-attr v0.4.9
[INFO] [stderr]    Compiling serde_with v1.4.0
[INFO] [stderr]    Compiling futures-util v0.3.4
[INFO] [stderr]    Compiling tokio v0.1.22
[INFO] [stderr]    Compiling pin-project v0.4.8
[INFO] [stderr]    Compiling webpki v0.21.2
[INFO] [stderr]    Compiling sct v0.6.0
[INFO] [stderr]    Compiling rustls v0.16.0
[INFO] [stderr]    Compiling webpki-roots v0.18.0
[INFO] [stderr]    Compiling futures-executor v0.3.4
[INFO] [stderr]    Compiling actix-service v1.0.5
[INFO] [stderr]    Compiling h2 v0.2.1
[INFO] [stderr]    Compiling futures v0.3.4
[INFO] [stderr]    Compiling actix-rt v1.0.0
[INFO] [stderr]    Compiling trust-dns-proto v0.18.0-alpha.2
[INFO] [stderr]    Compiling actix-utils v1.0.6
[INFO] [stderr]    Compiling actix-server v1.0.1
[INFO] [stderr]    Compiling actix-tls v1.0.0
[INFO] [stderr]    Compiling enum-as-inner v0.2.1
[INFO] [stderr]    Compiling typed-builder v0.3.0
[INFO] [stderr]    Compiling derivative v1.0.3
[INFO] [stderr]    Compiling trust-dns-resolver v0.18.0-alpha.2
[INFO] [stderr]    Compiling actix-testing v1.0.0
[INFO] [stderr]    Compiling actix-connect v1.0.2
[INFO] [stderr]    Compiling trust-dns-proto v0.8.0
[INFO] [stderr]    Compiling actix-http v1.0.1
[INFO] [stderr]    Compiling trust-dns-resolver v0.12.0
[INFO] [stderr]    Compiling mongodb v0.9.0
[INFO] [stderr]    Compiling awc v1.0.1
[INFO] [stderr]    Compiling actix-web v2.0.0
[INFO] [stderr]    Compiling aozora-pubserver v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1m 28s
[INFO] running `Command { std: "docker" "inspect" "a1eedf3b6420f812b84c2b312b921538cce4d4d69e703043af8e1ae9711ead20", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a1eedf3b6420f812b84c2b312b921538cce4d4d69e703043af8e1ae9711ead20", kill_on_drop: false }`
[INFO] [stdout] a1eedf3b6420f812b84c2b312b921538cce4d4d69e703043af8e1ae9711ead20
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+1.54.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 0bd4283e4602e04aa69c7ff25b7a0feb68aaeee5eab0f482aa39de9053dc5e9c
[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" "0bd4283e4602e04aa69c7ff25b7a0feb68aaeee5eab0f482aa39de9053dc5e9c", kill_on_drop: false }`
[INFO] [stderr]    Compiling aozora-pubserver v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 10.95s
[INFO] running `Command { std: "docker" "inspect" "0bd4283e4602e04aa69c7ff25b7a0feb68aaeee5eab0f482aa39de9053dc5e9c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "0bd4283e4602e04aa69c7ff25b7a0feb68aaeee5eab0f482aa39de9053dc5e9c", kill_on_drop: false }`
[INFO] [stdout] 0bd4283e4602e04aa69c7ff25b7a0feb68aaeee5eab0f482aa39de9053dc5e9c
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+1.54.0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] ab26dd614096693166cf2a9a54d60b76a8bd0bff791de634a3714af8adadc164
[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" "ab26dd614096693166cf2a9a54d60b76a8bd0bff791de634a3714af8adadc164", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.25s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/aozora_pubserver-5379d5d5170117c9)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test book::tests::test_single_book_ok ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- book::tests::test_single_book_ok stdout ----
[INFO] [stdout] thread 'book::tests::test_single_book_ok' panicked at 'attempted to leave type `linked_hash_map::Node<std::string::String, bson::Bson>` uninitialized, which is invalid', /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/mem/mod.rs:660:9
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5573de522a50 - std::backtrace_rs::backtrace::libunwind::trace::h34055254b57d8e79
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/../../backtrace/src/backtrace/libunwind.rs:90:5
[INFO] [stdout]    1:     0x5573de522a50 - std::backtrace_rs::backtrace::trace_unsynchronized::h8f1e3fbd9afff6ec
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x5573de522a50 - std::sys_common::backtrace::_print_fmt::h3a99a796b770c360
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/sys_common/backtrace.rs:67:5
[INFO] [stdout]    3:     0x5573de522a50 - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::h32d1f94a80615d18
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/sys_common/backtrace.rs:46:22
[INFO] [stdout]    4:     0x5573de546efc - core::fmt::write::h306731c068f7162c
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/fmt/mod.rs:1110:17
[INFO] [stdout]    5:     0x5573de51b9f5 - std::io::Write::write_fmt::h87f19b0a2cd190bc
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/io/mod.rs:1588:15
[INFO] [stdout]    6:     0x5573de524c5b - std::sys_common::backtrace::_print::h5abaa2601a852287
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/sys_common/backtrace.rs:49:5
[INFO] [stdout]    7:     0x5573de524c5b - std::sys_common::backtrace::print::h8d81445442bb638f
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/sys_common/backtrace.rs:36:9
[INFO] [stdout]    8:     0x5573de524c5b - std::panicking::default_hook::{{closure}}::hcfe804496a9fa747
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panicking.rs:208:50
[INFO] [stdout]    9:     0x5573de52476c - std::panicking::default_hook::hbea8e3ccf2ba8901
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panicking.rs:222:9
[INFO] [stdout]   10:     0x5573de525324 - std::panicking::rust_panic_with_hook::h7ee9e1a2d0f8975a
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panicking.rs:622:17
[INFO] [stdout]   11:     0x5573de524dd7 - std::panicking::begin_panic_handler::{{closure}}::h8ab3b4491718b2c7
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panicking.rs:517:13
[INFO] [stdout]   12:     0x5573de522f4c - std::sys_common::backtrace::__rust_end_short_backtrace::hd489062ffa586a9f
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/sys_common/backtrace.rs:141:18
[INFO] [stdout]   13:     0x5573de524d69 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panicking.rs:515:5
[INFO] [stdout]   14:     0x5573ddb7edf1 - core::panicking::panic_fmt::hca6330e3e14086b4
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/panicking.rs:92:14
[INFO] [stdout]   15:     0x5573ddb7ed3d - core::panicking::panic::h1a48d878ff3dcd40
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/panicking.rs:50:5
[INFO] [stdout]   16:     0x5573de0fccba - core::mem::uninitialized::h48137efebcb57d8b
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/mem/mod.rs:660:9
[INFO] [stdout]   17:     0x5573de0fccba - linked_hash_map::LinkedHashMap<K,V,S>::ensure_guard_node::h3521a947fe9cf3c8
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/linked-hash-map-0.5.2/src/lib.rs:174:52
[INFO] [stdout]   18:     0x5573de0fcf7c - linked_hash_map::LinkedHashMap<K,V,S>::insert::h9d18fe71b5acb58b
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/linked-hash-map-0.5.2/src/lib.rs:304:9
[INFO] [stdout]   19:     0x5573de0f8a6e - bson::ordered::OrderedDocument::insert_bson::h3714a0634bdb50e7
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/bson-0.14.0/src/ordered.rs:475:9
[INFO] [stdout]   20:     0x5573ddd01577 - <mongodb::cmap::establish::handshake::BASE_HANDSHAKE_DOCUMENT as core::ops::deref::Deref>::deref::__static_ref_initialize::he83557b89f5e5727
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/mongodb-0.9.0/src/cmap/establish/handshake.rs:16:23
[INFO] [stdout]   21:     0x5573ddd01577 - core::ops::function::FnOnce::call_once::he94f5c5bc237d4a9
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   22:     0x5573ddc73cb2 - lazy_static::lazy::Lazy<T>::get::{{closure}}::hdaa189ae08329d99
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/lazy_static-1.4.0/src/inline_lazy.rs:31:29
[INFO] [stdout]   23:     0x5573ddcfb88e - std::sync::once::Once::call_once::{{closure}}::h5453a8d95ac8949a
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/sync/once.rs:261:41
[INFO] [stdout]   24:     0x5573ddb7deec - std::sync::once::Once::call_inner::h4030b088a5783b2d
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/sync/once.rs:418:21
[INFO] [stdout]   25:     0x5573ddcfb126 - std::sync::once::Once::call_once::h254980c94a7187fe
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/sync/once.rs:261:9
[INFO] [stdout]   26:     0x5573ddd16d66 - lazy_static::lazy::Lazy<T>::get::hfbb42a88746979af
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/lazy_static-1.4.0/src/inline_lazy.rs:30:9
[INFO] [stdout]   27:     0x5573ddd16d66 - <mongodb::cmap::establish::handshake::BASE_HANDSHAKE_DOCUMENT as core::ops::deref::Deref>::deref::__stability::h97c5e0a4d7d9c4b6
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/lazy_static-1.4.0/src/lib.rs:142:21
[INFO] [stdout]   28:     0x5573ddd16d66 - <mongodb::cmap::establish::handshake::BASE_HANDSHAKE_DOCUMENT as core::ops::deref::Deref>::deref::h503450dcac504e50
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/lazy_static-1.4.0/src/lib.rs:144:17
[INFO] [stdout]   29:     0x5573ddd15303 - mongodb::cmap::establish::handshake::Handshaker::new::h3fb57bda54f43135
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/mongodb-0.9.0/src/cmap/establish/handshake.rs:61:28
[INFO] [stdout]   30:     0x5573ddca1bc2 - mongodb::cmap::establish::ConnectionEstablisher::new::h6719d0c63b5762c6
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/mongodb-0.9.0/src/cmap/establish/mod.rs:18:26
[INFO] [stdout]   31:     0x5573ddc7d268 - mongodb::cmap::ConnectionPool::new::h166802922c7f8e6d
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/mongodb-0.9.0/src/cmap/mod.rs:134:27
[INFO] [stdout]   32:     0x5573ddcd34f3 - mongodb::sdam::state::server::Server::new::h8bf6f30d433ff049
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/mongodb-0.9.0/src/sdam/state/server.rs:38:19
[INFO] [stdout]   33:     0x5573ddcd4693 - mongodb::sdam::state::Topology::add_new_server::hbfe48b198fece8ac
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/mongodb-0.9.0/src/sdam/state/mod.rs:131:31
[INFO] [stdout]   34:     0x5573ddcd40f8 - mongodb::sdam::state::Topology::new::h686f9c683390169a
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/mongodb-0.9.0/src/sdam/state/mod.rs:87:17
[INFO] [stdout]   35:     0x5573ddcca77a - mongodb::client::Client::with_options::h3a9a49adc4144ab3
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/mongodb-0.9.0/src/client/mod.rs:93:23
[INFO] [stdout]   36:     0x5573ddcca593 - mongodb::client::Client::with_uri_str::h2f5dc2a543394035
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/mongodb-0.9.0/src/client/mod.rs:85:9
[INFO] [stdout]   37:     0x5573ddbea16d - aozora_pubserver::db_mongo::DbClient::new::h962bc94252d62319
[INFO] [stdout]                                at /opt/rustwide/workdir/src/db_mongo.rs:24:21
[INFO] [stdout]   38:     0x5573ddb813ee - aozora_pubserver::book::get_book_by_id::{{closure}}::h2c71371165564e3b
[INFO] [stdout]                                at /opt/rustwide/workdir/src/book.rs:93:12
[INFO] [stdout]   39:     0x5573ddbf72c9 - <core::future::from_generator::GenFuture<T> as core::future::future::Future>::poll::h5516d558d5463a87
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/future/mod.rs:80:19
[INFO] [stdout]   40:     0x5573ddc0202a - <actix_web::handler::HandlerServiceResponse<T,R> as core::future::future::Future>::poll::h69cf2fc4a22ea554
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/actix-web-2.0.0/src/handler.rs:138:15
[INFO] [stdout]   41:     0x5573ddc06323 - <actix_web::handler::ExtractResponse<T,S> as core::future::future::Future>::poll::hdac79f96296f400f
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/actix-web-2.0.0/src/handler.rs:247:20
[INFO] [stdout]   42:     0x5573ddc06904 - <actix_web::handler::ExtractResponse<T,S> as core::future::future::Future>::poll::hdac79f96296f400f
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/actix-web-2.0.0/src/handler.rs:258:17
[INFO] [stdout]   43:     0x5573ddbf7aca - <futures_util::future::future::map::Map<Fut,F> as core::future::future::Future>::poll::h5aceee755db6e348
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/futures-util-0.3.4/src/future/future/map.rs:40:9
[INFO] [stdout]   44:     0x5573de13bd19 - <core::pin::Pin<P> as core::future::future::Future>::poll::ha4c89cfe1ebf3ea5
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/future/future.rs:119:9
[INFO] [stdout]   45:     0x5573de13bd19 - <core::pin::Pin<P> as core::future::future::Future>::poll::ha4c89cfe1ebf3ea5
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/future/future.rs:119:9
[INFO] [stdout]   46:     0x5573de122863 - <futures_util::future::either::Either<A,B> as core::future::future::Future>::poll::h53c87510c2ddd12b
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/futures-util-0.3.4/src/future/either.rs:63:37
[INFO] [stdout]   47:     0x5573de13bd19 - <core::pin::Pin<P> as core::future::future::Future>::poll::ha4c89cfe1ebf3ea5
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/future/future.rs:119:9
[INFO] [stdout]   48:     0x5573ddbfbb20 - actix_web::test::call_service::{{closure}}::heef12dde4abc8976
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/actix-web-2.0.0/src/test.rs:123:5
[INFO] [stdout]   49:     0x5573ddbf71b7 - <core::future::from_generator::GenFuture<T> as core::future::future::Future>::poll::h165d6e71dc49c6f8
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/future/mod.rs:80:19
[INFO] [stdout]   50:     0x5573ddbdd636 - aozora_pubserver::book::tests::test_single_book_ok::{{closure}}::hdccd3eb78595a345
[INFO] [stdout]                                at /opt/rustwide/workdir/src/book.rs:134:15
[INFO] [stdout]   51:     0x5573ddbf754b - <core::future::from_generator::GenFuture<T> as core::future::future::Future>::poll::he76cfd2eb41aa2b3
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/future/mod.rs:80:19
[INFO] [stdout]   52:     0x5573ddc05dc0 - <tokio::task::local::LocalFuture<F> as core::future::future::Future>::poll::{{closure}}::he6490fb87b80d542
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-0.2.11/src/task/local.rs:403:42
[INFO] [stdout]   53:     0x5573ddc05167 - tokio::task::local::Scheduler::with::{{closure}}::h2e45b6243f1567ed
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-0.2.11/src/task/local.rs:478:13
[INFO] [stdout]   54:     0x5573ddbc9094 - std::thread::local::LocalKey<T>::try_with::hf15251db33205db3
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/thread/local.rs:400:16
[INFO] [stdout]   55:     0x5573ddbc8be6 - std::thread::local::LocalKey<T>::with::hc48fb77cb755fcf4
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/thread/local.rs:376:9
[INFO] [stdout]   56:     0x5573ddc0507e - tokio::task::local::Scheduler::with::hfbc07b1f6216a168
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-0.2.11/src/task/local.rs:474:9
[INFO] [stdout]   57:     0x5573ddc05d63 - <tokio::task::local::LocalFuture<F> as core::future::future::Future>::poll::h4f26f1a89cc6c575
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-0.2.11/src/task/local.rs:402:9
[INFO] [stdout]   58:     0x5573ddc04f86 - tokio::task::local::LocalSet::run_until::{{closure}}::hbb7598776f8bb0b3
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-0.2.11/src/task/local.rs:358:9
[INFO] [stdout]   59:     0x5573ddbf74bb - <core::future::from_generator::GenFuture<T> as core::future::future::Future>::poll::hd6972c0382395d34
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/future/mod.rs:80:19
[INFO] [stdout]   60:     0x5573ddbe7c71 - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::h081ebf4d1babf120
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-0.2.11/src/runtime/basic_scheduler.rs:138:31
[INFO] [stdout]   61:     0x5573ddbfa4fa - tokio::runtime::Runtime::block_on::{{closure}}::hd56f3c797e2e5255
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-0.2.11/src/runtime/mod.rs:411:34
[INFO] [stdout]   62:     0x5573ddbdbdf2 - tokio::runtime::context::enter::h6823211053f0faa1
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-0.2.11/src/runtime/context.rs:72:5
[INFO] [stdout]   63:     0x5573ddbfa3a8 - tokio::runtime::handle::Handle::enter::hde1dbb8e6af8acdb
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-0.2.11/src/runtime/handle.rs:34:9
[INFO] [stdout]   64:     0x5573ddbfa43a - tokio::runtime::Runtime::block_on::h7a86adc802216846
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-0.2.11/src/runtime/mod.rs:408:9
[INFO] [stdout]   65:     0x5573ddc04cf6 - tokio::task::local::LocalSet::block_on::h3f57c95acae3d9ff
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-0.2.11/src/task/local.rs:321:9
[INFO] [stdout]   66:     0x5573ddbe9aa3 - actix_rt::runtime::Runtime::block_on::h757b1ebeffb202d8
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/actix-rt-1.0.0/src/runtime.rs:89:19
[INFO] [stdout]   67:     0x5573ddbeffc0 - actix_rt::builder::SystemRunner::block_on::he95cdb1def2efc73
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/actix-rt-1.0.0/src/builder.rs:187:19
[INFO] [stdout]   68:     0x5573ddbdd04e - aozora_pubserver::book::tests::test_single_book_ok::h5329c437f971a711
[INFO] [stdout]                                at /opt/rustwide/workdir/src/book.rs:127:3
[INFO] [stdout]   69:     0x5573ddbdcfea - aozora_pubserver::book::tests::test_single_book_ok::{{closure}}::h0a9920a72f80b093
[INFO] [stdout]                                at /opt/rustwide/workdir/src/book.rs:127:3
[INFO] [stdout]   70:     0x5573ddbe309e - core::ops::function::FnOnce::call_once::h09f9f87d5646ea0f
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   71:     0x5573ddc36a93 - core::ops::function::FnOnce::call_once::h152e7e439ff59e19
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   72:     0x5573ddc36a93 - test::__rust_begin_short_backtrace::h0908f3b1fdbb72ab
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/test/src/lib.rs:577:5
[INFO] [stdout]   73:     0x5573ddc35550 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hf6d2a51e5587546c
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/alloc/src/boxed.rs:1575:9
[INFO] [stdout]   74:     0x5573ddc35550 - <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h8af660f3a89ef593
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panic.rs:347:9
[INFO] [stdout]   75:     0x5573ddc35550 - std::panicking::try::do_call::hd36aef60f84b6d36
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panicking.rs:401:40
[INFO] [stdout]   76:     0x5573ddc35550 - std::panicking::try::h9932b4480e69817c
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panicking.rs:365:19
[INFO] [stdout]   77:     0x5573ddc35550 - std::panic::catch_unwind::h6aa177099cfff5f8
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panic.rs:434:14
[INFO] [stdout]   78:     0x5573ddc35550 - test::run_test_in_process::h5884d6f2d99e20c3
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/test/src/lib.rs:600:18
[INFO] [stdout]   79:     0x5573ddc35550 - test::run_test::run_test_inner::{{closure}}::h6fdc58c6d5f5b6e3
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/test/src/lib.rs:492:39
[INFO] [stdout]   80:     0x5573ddc0ec02 - test::run_test::run_test_inner::{{closure}}::h408365d67a78ade8
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/test/src/lib.rs:519:37
[INFO] [stdout]   81:     0x5573ddc0ec02 - std::sys_common::backtrace::__rust_begin_short_backtrace::hb560b77c4f701523
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/sys_common/backtrace.rs:125:18
[INFO] [stdout]   82:     0x5573ddc127b8 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::hf2e7831dad93c597
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/thread/mod.rs:481:17
[INFO] [stdout]   83:     0x5573ddc127b8 - <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hd2e08783d8be4d02
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panic.rs:347:9
[INFO] [stdout]   84:     0x5573ddc127b8 - std::panicking::try::do_call::h062597b7acfd6b82
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panicking.rs:401:40
[INFO] [stdout]   85:     0x5573ddc127b8 - std::panicking::try::h0d7b79db04c14552
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panicking.rs:365:19
[INFO] [stdout]   86:     0x5573ddc127b8 - std::panic::catch_unwind::hb01a0b5e7c8cd43b
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panic.rs:434:14
[INFO] [stdout]   87:     0x5573ddc127b8 - std::thread::Builder::spawn_unchecked::{{closure}}::h5bde48cc887e0d1e
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/thread/mod.rs:480:30
[INFO] [stdout]   88:     0x5573ddc127b8 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h745ea30807a29e55
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   89:     0x5573de52a9f7 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h7ece6cfefaff1005
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/alloc/src/boxed.rs:1575:9
[INFO] [stdout]   90:     0x5573de52a9f7 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hb8b48e55c21f193e
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/alloc/src/boxed.rs:1575:9
[INFO] [stdout]   91:     0x5573de52a9f7 - std::sys::unix::thread::Thread::new::thread_start::h8c7c4450dba62914
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/sys/unix/thread.rs:71:17
[INFO] [stdout]   92:     0x7fdb0cdb6609 - start_thread
[INFO] [stdout]   93:     0x7fdb0cb88293 - clone
[INFO] [stdout]   94:                0x0 - <unknown>
[INFO] [stdout] Panic in Arbiter thread.
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     book::tests::test_single_book_ok
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 0 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.09s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass '--bin aozora-pubserver'
[INFO] running `Command { std: "docker" "inspect" "ab26dd614096693166cf2a9a54d60b76a8bd0bff791de634a3714af8adadc164", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ab26dd614096693166cf2a9a54d60b76a8bd0bff791de634a3714af8adadc164", kill_on_drop: false }`
[INFO] [stdout] ab26dd614096693166cf2a9a54d60b76a8bd0bff791de634a3714af8adadc164
