[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 beta-2020-10-09 for beta-1.48-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fksato9700%2Faozora-pubserver" "/workspace/builds/worker-7/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-7/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/ksato9700/aozora-pubserver on toolchain beta-2020-10-09
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2020-10-09" "read-manifest" "--manifest-path" "Cargo.toml", 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-7/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" "+beta-2020-10-09" "fetch" "--locked" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded bson v0.14.0
[INFO] [stderr]   Downloaded proc-macro-error-attr v0.4.9
[INFO] [stderr]   Downloaded proc-macro-error v0.4.9
[INFO] [stderr]   Downloaded os_info v1.3.3
[INFO] [stderr]   Downloaded rustversion v1.0.2
[INFO] [stderr]   Downloaded trust-dns-proto v0.8.0
[INFO] [stderr]   Downloaded err-derive v0.2.2
[INFO] [stderr]   Downloaded mongodb v0.9.0
[INFO] [stderr]   Downloaded trust-dns-resolver v0.12.0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "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:d92eaeed33fa75130ca1ee6c8a01d1ffb62bac859dfdfb3450e3e5d1c0146529" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2020-10-09" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] a4792d3697446b943c2b843561dbddb11ee1645fefb52df58eebabd971898566
[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" "a4792d3697446b943c2b843561dbddb11ee1645fefb52df58eebabd971898566", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "a4792d3697446b943c2b843561dbddb11ee1645fefb52df58eebabd971898566", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a4792d3697446b943c2b843561dbddb11ee1645fefb52df58eebabd971898566", kill_on_drop: false }`
[INFO] [stdout] a4792d3697446b943c2b843561dbddb11ee1645fefb52df58eebabd971898566
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "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" "rustops/crates-build-env@sha256:d92eaeed33fa75130ca1ee6c8a01d1ffb62bac859dfdfb3450e3e5d1c0146529" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2020-10-09" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 945aba5a42beab1ea1c055f6df18a991c2858b6f4960d2f6bb4ae7bfd75657d5
[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" "945aba5a42beab1ea1c055f6df18a991c2858b6f4960d2f6bb4ae7bfd75657d5", kill_on_drop: false }`
[INFO] [stderr]    Compiling memchr v2.3.2
[INFO] [stderr]    Compiling os_info v1.3.3
[INFO] [stderr]    Compiling md5 v0.6.1
[INFO] [stderr]    Compiling tokio-executor v0.1.10
[INFO] [stderr]    Compiling crossbeam-queue v0.2.1
[INFO] [stderr]    Compiling ring v0.16.11
[INFO] [stderr]    Compiling backtrace v0.3.44
[INFO] [stderr]    Compiling parking_lot_core v0.6.2
[INFO] [stderr]    Compiling md-5 v0.8.0
[INFO] [stderr]    Compiling tokio-io v0.1.13
[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 enum-as-inner v0.2.1
[INFO] [stderr]    Compiling serde_with_macros v1.1.0
[INFO] [stderr]    Compiling pbkdf2 v0.3.0
[INFO] [stderr]    Compiling typed-builder v0.3.0
[INFO] [stderr]    Compiling derivative v1.0.3
[INFO] [stderr]    Compiling futures-macro v0.3.4
[INFO] [stderr]    Compiling actix-threadpool v0.3.1
[INFO] [stderr]    Compiling tokio-timer v0.2.13
[INFO] [stderr]    Compiling tokio-current-thread v0.1.7
[INFO] [stderr]    Compiling parking_lot v0.9.0
[INFO] [stderr]    Compiling failure v0.1.6
[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 tokio-threadpool v0.1.18
[INFO] [stderr]    Compiling tokio-codec v0.1.2
[INFO] [stderr]    Compiling tokio-reactor v0.1.12
[INFO] [stderr]    Compiling webpki v0.21.2
[INFO] [stderr]    Compiling sct v0.6.0
[INFO] [stderr]    Compiling tokio v0.2.11
[INFO] [stderr]    Compiling aho-corasick v0.7.8
[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 webpki-roots v0.18.0
[INFO] [stderr]    Compiling rustls v0.16.0
[INFO] [stderr]    Compiling bson v0.14.0
[INFO] [stderr]    Compiling futures-util v0.3.4
[INFO] [stderr]    Compiling serde_with v1.4.0
[INFO] [stderr]    Compiling proc-macro-error v0.4.9
[INFO] [stderr]    Compiling proc-macro-error-attr v0.4.9
[INFO] [stderr]    Compiling err-derive v0.2.2
[INFO] [stderr]    Compiling regex v1.3.4
[INFO] [stderr]    Compiling trust-dns-proto v0.8.0
[INFO] [stderr]    Compiling tokio v0.1.22
[INFO] [stderr]    Compiling actix-router v0.2.4
[INFO] [stderr]    Compiling env_logger v0.7.1
[INFO] [stderr]    Compiling pin-project v0.4.8
[INFO] [stderr]    Compiling tokio-util v0.2.0
[INFO] [stderr]    Compiling actix-codec v0.2.0
[INFO] [stderr]    Compiling trust-dns-resolver v0.12.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 mongodb v0.9.0
[INFO] [stderr]    Compiling actix-server v1.0.1
[INFO] [stderr]    Compiling actix-tls v1.0.0
[INFO] [stderr]    Compiling actix-testing v1.0.0
[INFO] [stderr]    Compiling trust-dns-resolver v0.18.0-alpha.2
[INFO] [stderr]    Compiling actix-connect v1.0.2
[INFO] [stderr]    Compiling actix-http v1.0.1
[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 2m 32s
[INFO] running `Command { std: "docker" "inspect" "945aba5a42beab1ea1c055f6df18a991c2858b6f4960d2f6bb4ae7bfd75657d5", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "945aba5a42beab1ea1c055f6df18a991c2858b6f4960d2f6bb4ae7bfd75657d5", kill_on_drop: false }`
[INFO] [stdout] 945aba5a42beab1ea1c055f6df18a991c2858b6f4960d2f6bb4ae7bfd75657d5
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "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" "rustops/crates-build-env@sha256:d92eaeed33fa75130ca1ee6c8a01d1ffb62bac859dfdfb3450e3e5d1c0146529" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2020-10-09" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] e0763eb44ab87bbeb83d1cab7d191c2e90d87feb5c15ade3144f79e106337064
[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" "e0763eb44ab87bbeb83d1cab7d191c2e90d87feb5c15ade3144f79e106337064", kill_on_drop: false }`
[INFO] [stderr]    Compiling aozora-pubserver v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 15.39s
[INFO] running `Command { std: "docker" "inspect" "e0763eb44ab87bbeb83d1cab7d191c2e90d87feb5c15ade3144f79e106337064", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e0763eb44ab87bbeb83d1cab7d191c2e90d87feb5c15ade3144f79e106337064", kill_on_drop: false }`
[INFO] [stdout] e0763eb44ab87bbeb83d1cab7d191c2e90d87feb5c15ade3144f79e106337064
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "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" "rustops/crates-build-env@sha256:d92eaeed33fa75130ca1ee6c8a01d1ffb62bac859dfdfb3450e3e5d1c0146529" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2020-10-09" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 6e894e7c1ef88a824d1ef07ca56f863997126372f77f5c027dd529fe407ecef4
[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" "6e894e7c1ef88a824d1ef07ca56f863997126372f77f5c027dd529fe407ecef4", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.27s
[INFO] [stderr]      Running /opt/rustwide/target/debug/deps/aozora_pubserver-d89c9f7518a18fc6
[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/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/mem/mod.rs:658:9
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5649eee65420 - std::backtrace_rs::backtrace::libunwind::trace::h7cf3ca97bd83fbab
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/../../backtrace/src/backtrace/libunwind.rs:96
[INFO] [stdout]    1:     0x5649eee65420 - std::backtrace_rs::backtrace::trace_unsynchronized::h5a69c674b2d9ea5c
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/../../backtrace/src/backtrace/mod.rs:66
[INFO] [stdout]    2:     0x5649eee65420 - std::sys_common::backtrace::_print_fmt::hdf72478dfcb50678
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:79
[INFO] [stdout]    3:     0x5649eee65420 - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::h1e0bdbb35e83deca
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:58
[INFO] [stdout]    4:     0x5649eee89a0c - core::fmt::write::he67f9b17bcb7ee73
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/fmt/mod.rs:1080
[INFO] [stdout]    5:     0x5649ee477206 - std::io::Write::write_fmt::h68b2e5fe4c78e61a
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/io/mod.rs:1516
[INFO] [stdout]    6:     0x5649eee5b45d - std::io::impls::<impl std::io::Write for alloc::boxed::Box<W>>::write_fmt::he9ebec865e28165c
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/io/impls.rs:179
[INFO] [stdout]    7:     0x5649eee6796d - std::sys_common::backtrace::_print::haa20918e28a126c5
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:61
[INFO] [stdout]    8:     0x5649eee6796d - std::sys_common::backtrace::print::h49e772a4873d9076
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:48
[INFO] [stdout]    9:     0x5649eee6796d - std::panicking::default_hook::{{closure}}::hb218b305d15e3f11
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:208
[INFO] [stdout]   10:     0x5649eee675c2 - std::panicking::default_hook::h63997b7b949e1ce0
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:224
[INFO] [stdout]   11:     0x5649eee68051 - std::panicking::rust_panic_with_hook::hb54f09ccadf64bd3
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:577
[INFO] [stdout]   12:     0x5649eee67bf9 - std::panicking::begin_panic_handler::{{closure}}::h8b43445b254eeb30
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:484
[INFO] [stdout]   13:     0x5649eee658ac - std::sys_common::backtrace::__rust_end_short_backtrace::hacd691450edfeae0
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:153
[INFO] [stdout]   14:     0x5649eee67bb9 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:483
[INFO] [stdout]   15:     0x5649eee88031 - core::panicking::panic_fmt::h5b17d4a0e853d0f5
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/panicking.rs:85
[INFO] [stdout]   16:     0x5649eee87f7d - core::panicking::panic::hc6be4d7009fb30ae
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/panicking.rs:50
[INFO] [stdout]   17:     0x5649ee9da393 - core::mem::uninitialized::hb6214b4a1a35785c
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/mem/mod.rs:658
[INFO] [stdout]   18:     0x5649ee9da393 - linked_hash_map::LinkedHashMap<K,V,S>::ensure_guard_node::h3601d22be79f70fe
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/linked-hash-map-0.5.2/src/lib.rs:174
[INFO] [stdout]   19:     0x5649ee9da667 - linked_hash_map::LinkedHashMap<K,V,S>::insert::hdaf8d57e6da894ff
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/linked-hash-map-0.5.2/src/lib.rs:304
[INFO] [stdout]   20:     0x5649ee9ea245 - bson::ordered::OrderedDocument::insert_bson::h9be31f79f6fa5da2
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/bson-0.14.0/src/ordered.rs:475
[INFO] [stdout]   21:     0x5649ee564539 - <mongodb::cmap::establish::handshake::BASE_HANDSHAKE_DOCUMENT as core::ops::deref::Deref>::deref::__static_ref_initialize::hf160ab2ec4bd840c
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/mongodb-0.9.0/src/cmap/establish/handshake.rs:16
[INFO] [stdout]   22:     0x5649ee564539 - core::ops::function::FnOnce::call_once::h7d9c20067036f13f
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   23:     0x5649ee4d17c2 - lazy_static::lazy::Lazy<T>::get::{{closure}}::hc0abf896cea05a4a
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/lazy_static-1.4.0/src/inline_lazy.rs:31
[INFO] [stdout]   24:     0x5649ee5624af - std::sync::once::Once::call_once::{{closure}}::h81647eab59c4ab33
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sync/once.rs:261
[INFO] [stdout]   25:     0x5649eee64bb2 - std::sync::once::Once::call_inner::h33bd609ddf05a465
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sync/once.rs:419
[INFO] [stdout]   26:     0x5649ee561c01 - std::sync::once::Once::call_once::h1a915237790dbd57
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sync/once.rs:261
[INFO] [stdout]   27:     0x5649ee50bcf9 - lazy_static::lazy::Lazy<T>::get::h24d1af372f4fd73f
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/lazy_static-1.4.0/src/inline_lazy.rs:30
[INFO] [stdout]   28:     0x5649ee50bcf9 - <mongodb::cmap::establish::handshake::BASE_HANDSHAKE_DOCUMENT as core::ops::deref::Deref>::deref::__stability::h14f5e0f790d911bb
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/lazy_static-1.4.0/src/lib.rs:142
[INFO] [stdout]   29:     0x5649ee50bcf9 - <mongodb::cmap::establish::handshake::BASE_HANDSHAKE_DOCUMENT as core::ops::deref::Deref>::deref::hd55c5828bc5cd107
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/lazy_static-1.4.0/src/lib.rs:144
[INFO] [stdout]   30:     0x5649ee50b019 - mongodb::cmap::establish::handshake::Handshaker::new::h1c6f00d7f0224046
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/mongodb-0.9.0/src/cmap/establish/handshake.rs:61
[INFO] [stdout]   31:     0x5649ee58eb49 - mongodb::cmap::establish::ConnectionEstablisher::new::h2ee69abb2b10e4db
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/mongodb-0.9.0/src/cmap/establish/mod.rs:18
[INFO] [stdout]   32:     0x5649ee4c68f6 - mongodb::cmap::ConnectionPool::new::h3f6ba4f468ad903f
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/mongodb-0.9.0/src/cmap/mod.rs:134
[INFO] [stdout]   33:     0x5649ee5b30c4 - mongodb::sdam::state::server::Server::new::hde79bba2f096b02c
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/mongodb-0.9.0/src/sdam/state/server.rs:38
[INFO] [stdout]   34:     0x5649ee59ad97 - mongodb::sdam::state::Topology::add_new_server::h69229161978519af
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/mongodb-0.9.0/src/sdam/state/mod.rs:131
[INFO] [stdout]   35:     0x5649ee59a72f - mongodb::sdam::state::Topology::new::h71b0c33305e57e78
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/mongodb-0.9.0/src/sdam/state/mod.rs:87
[INFO] [stdout]   36:     0x5649ee58c430 - mongodb::client::Client::with_options::h2fe0fd59bc52f4c2
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/mongodb-0.9.0/src/client/mod.rs:93
[INFO] [stdout]   37:     0x5649ee58c22e - mongodb::client::Client::with_uri_str::h15eab508073e7022
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/mongodb-0.9.0/src/client/mod.rs:85
[INFO] [stdout]   38:     0x5649ee423332 - aozora_pubserver::db_mongo::DbClient::new::h69c226be76083491
[INFO] [stdout]                                at /opt/rustwide/workdir/src/db_mongo.rs:24
[INFO] [stdout]   39:     0x5649ee3de2b2 - aozora_pubserver::book::get_book_by_id::{{closure}}::hc50e39962c9d49ac
[INFO] [stdout]                                at /opt/rustwide/workdir/src/book.rs:93
[INFO] [stdout]   40:     0x5649ee43ebb2 - <core::future::from_generator::GenFuture<T> as core::future::future::Future>::poll::h1d185a2d7d1edd2e
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/future/mod.rs:80
[INFO] [stdout]   41:     0x5649ee438587 - <actix_web::handler::HandlerServiceResponse<T,R> as core::future::future::Future>::poll::h8aed83f6413341ec
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/actix-web-2.0.0/src/handler.rs:138
[INFO] [stdout]   42:     0x5649ee43e4ec - <actix_web::handler::ExtractResponse<T,S> as core::future::future::Future>::poll::h8caa428fc8ac9783
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/actix-web-2.0.0/src/handler.rs:247
[INFO] [stdout]   43:     0x5649ee43ea23 - <actix_web::handler::ExtractResponse<T,S> as core::future::future::Future>::poll::h8caa428fc8ac9783
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/actix-web-2.0.0/src/handler.rs:258
[INFO] [stdout]   44:     0x5649ee429a3b - <futures_util::future::future::map::Map<Fut,F> as core::future::future::Future>::poll::h44b8a883e8128b20
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/futures-util-0.3.4/src/future/future/map.rs:40
[INFO] [stdout]   45:     0x5649eea0bba2 - <core::pin::Pin<P> as core::future::future::Future>::poll::h43e56eaf95a3e63f
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/future/future.rs:119
[INFO] [stdout]   46:     0x5649eea0bba2 - <core::pin::Pin<P> as core::future::future::Future>::poll::h43e56eaf95a3e63f
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/future/future.rs:119
[INFO] [stdout]   47:     0x5649eea2eb1f - <futures_util::future::either::Either<A,B> as core::future::future::Future>::poll::hfcadff494dc338e5
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/futures-util-0.3.4/src/future/either.rs:63
[INFO] [stdout]   48:     0x5649eea0bba2 - <core::pin::Pin<P> as core::future::future::Future>::poll::h43e56eaf95a3e63f
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/future/future.rs:119
[INFO] [stdout]   49:     0x5649ee45e590 - actix_web::test::call_service::{{closure}}::h4ea8ce13c6829203
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/actix-web-2.0.0/src/test.rs:123
[INFO] [stdout]   50:     0x5649ee43ef12 - <core::future::from_generator::GenFuture<T> as core::future::future::Future>::poll::hd92e4b0d1ed6bf4d
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/future/mod.rs:80
[INFO] [stdout]   51:     0x5649ee45f5ce - aozora_pubserver::book::tests::test_single_book_ok::{{closure}}::ha9fadd2d214a18ec
[INFO] [stdout]                                at /opt/rustwide/workdir/src/book.rs:134
[INFO] [stdout]   52:     0x5649ee43eca9 - <core::future::from_generator::GenFuture<T> as core::future::future::Future>::poll::h2605f0e7eeed74b7
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/future/mod.rs:80
[INFO] [stdout]   53:     0x5649ee42d483 - <tokio::task::local::LocalFuture<F> as core::future::future::Future>::poll::{{closure}}::h10b7832e45ca9b07
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-0.2.11/src/task/local.rs:403
[INFO] [stdout]   54:     0x5649ee42c572 - tokio::task::local::Scheduler::with::{{closure}}::h7d97e16c2a087e3e
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-0.2.11/src/task/local.rs:478
[INFO] [stdout]   55:     0x5649ee459cb4 - std::thread::local::LocalKey<T>::try_with::h3372daee48ea6633
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/thread/local.rs:272
[INFO] [stdout]   56:     0x5649ee459b56 - std::thread::local::LocalKey<T>::with::h4cdc005537c0a676
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/thread/local.rs:248
[INFO] [stdout]   57:     0x5649ee42c4a1 - tokio::task::local::Scheduler::with::h5474327d68c11524
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-0.2.11/src/task/local.rs:474
[INFO] [stdout]   58:     0x5649ee42d41f - <tokio::task::local::LocalFuture<F> as core::future::future::Future>::poll::h0ee011c1b07445ec
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-0.2.11/src/task/local.rs:402
[INFO] [stdout]   59:     0x5649ee42c2fe - tokio::task::local::LocalSet::run_until::{{closure}}::hdb7d492844964e09
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-0.2.11/src/task/local.rs:358
[INFO] [stdout]   60:     0x5649ee43ee59 - <core::future::from_generator::GenFuture<T> as core::future::future::Future>::poll::h63be67833205f2e8
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/future/mod.rs:80
[INFO] [stdout]   61:     0x5649ee436a8c - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::hd59b54e1189dea76
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-0.2.11/src/runtime/basic_scheduler.rs:138
[INFO] [stdout]   62:     0x5649ee43b6b9 - tokio::runtime::Runtime::block_on::{{closure}}::h5fc9c7b9a45a8e84
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-0.2.11/src/runtime/mod.rs:411
[INFO] [stdout]   63:     0x5649ee45ca3f - tokio::runtime::context::enter::hb9de56c25a74429e
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-0.2.11/src/runtime/context.rs:72
[INFO] [stdout]   64:     0x5649ee42c81a - tokio::runtime::handle::Handle::enter::ha8efb43eb43b3051
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-0.2.11/src/runtime/handle.rs:34
[INFO] [stdout]   65:     0x5649ee43b62d - tokio::runtime::Runtime::block_on::h288f3f8ab33a2f68
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-0.2.11/src/runtime/mod.rs:408
[INFO] [stdout]   66:     0x5649ee42c084 - tokio::task::local::LocalSet::block_on::h5197cdde09e6c629
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-0.2.11/src/task/local.rs:321
[INFO] [stdout]   67:     0x5649ee45e30f - actix_rt::runtime::Runtime::block_on::h3cca8c5fa19c69a5
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/actix-rt-1.0.0/src/runtime.rs:89
[INFO] [stdout]   68:     0x5649ee42d5ac - actix_rt::builder::SystemRunner::block_on::he47d91962ea131ad
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/actix-rt-1.0.0/src/builder.rs:187
[INFO] [stdout]   69:     0x5649ee45f132 - aozora_pubserver::book::tests::test_single_book_ok::hd2203aa6cf49b2b8
[INFO] [stdout]                                at /opt/rustwide/workdir/src/book.rs:127
[INFO] [stdout]   70:     0x5649ee45f0ba - aozora_pubserver::book::tests::test_single_book_ok::{{closure}}::h5efa13a43fcdddf0
[INFO] [stdout]                                at /opt/rustwide/workdir/src/book.rs:127
[INFO] [stdout]   71:     0x5649ee43170e - core::ops::function::FnOnce::call_once::hfbf69a7f17768346
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   72:     0x5649ee49dff3 - core::ops::function::FnOnce::call_once::hcd3fa2f0696c1015
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   73:     0x5649ee49dff3 - test::__rust_begin_short_backtrace::h113f97c5e5ab7d4a
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/test/src/lib.rs:516
[INFO] [stdout]   74:     0x5649ee49c4f8 - <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once::h01fd09163cae2442
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]   75:     0x5649ee49c4f8 - <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h0da6b685ae74a04a
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:308
[INFO] [stdout]   76:     0x5649ee49c4f8 - std::panicking::try::do_call::h564a32f132f2c264
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:381
[INFO] [stdout]   77:     0x5649ee49c4f8 - std::panicking::try::h477cfd4b06a2e64a
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:345
[INFO] [stdout]   78:     0x5649ee49c4f8 - std::panic::catch_unwind::hdb5abc6d008c399d
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:382
[INFO] [stdout]   79:     0x5649ee49c4f8 - test::run_test_in_process::he8ff7dec91b275be
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/test/src/lib.rs:543
[INFO] [stdout]   80:     0x5649ee49c4f8 - test::run_test::run_test_inner::{{closure}}::hfd9f49e4a4ff9162
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/test/src/lib.rs:449
[INFO] [stdout]   81:     0x5649ee476586 - std::sys_common::backtrace::__rust_begin_short_backtrace::hee6d60d5bb466aff
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys_common/backtrace.rs:137
[INFO] [stdout]   82:     0x5649ee47b6f5 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::h988cecdf9ebbaf00
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/thread/mod.rs:464
[INFO] [stdout]   83:     0x5649ee47b6f5 - <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h330cf727ec126982
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:308
[INFO] [stdout]   84:     0x5649ee47b6f5 - std::panicking::try::do_call::h6cd25078f4a5ea13
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:381
[INFO] [stdout]   85:     0x5649ee47b6f5 - std::panicking::try::h84b1d49961301705
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panicking.rs:345
[INFO] [stdout]   86:     0x5649ee47b6f5 - std::panic::catch_unwind::h6145324593b3654b
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/panic.rs:382
[INFO] [stdout]   87:     0x5649ee47b6f5 - std::thread::Builder::spawn_unchecked::{{closure}}::ha41e72e8024f9192
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/thread/mod.rs:463
[INFO] [stdout]   88:     0x5649ee47b6f5 - core::ops::function::FnOnce::call_once{{vtable.shim}}::hfb5034cf1f1be223
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/core/src/ops/function.rs:227
[INFO] [stdout]   89:     0x5649eee6f0ba - <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once::hd4d30e37db281e8f
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]   90:     0x5649eee6f0ba - <alloc::boxed::Box<F> as core::ops::function::FnOnce<A>>::call_once::h019185a215ba16e4
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/alloc/src/boxed.rs:1042
[INFO] [stdout]   91:     0x5649eee6f0ba - std::sys::unix::thread::Thread::new::thread_start::h33c6d7cf25f9291f
[INFO] [stdout]                                at /rustc/212e76c31d461462544b5d516d3bdc99fc8f016e/library/std/src/sys/unix/thread.rs:87
[INFO] [stdout]   92:     0x7f0c48c6e609 - start_thread
[INFO] [stdout]   93:     0x7f0c48ef9103 - 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
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass '--bin aozora-pubserver'
[INFO] running `Command { std: "docker" "inspect" "6e894e7c1ef88a824d1ef07ca56f863997126372f77f5c027dd529fe407ecef4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "6e894e7c1ef88a824d1ef07ca56f863997126372f77f5c027dd529fe407ecef4", kill_on_drop: false }`
[INFO] [stdout] 6e894e7c1ef88a824d1ef07ca56f863997126372f77f5c027dd529fe407ecef4
