[INFO] fetching crate rusp 0.12.1...
[INFO] testing rusp-0.12.1 against try#722e1797249a965b6335aebd65d777f917e498f1 for pr-91031
[INFO] extracting crate rusp 0.12.1 into /workspace/builds/worker-114/source
[INFO] validating manifest of crates.io crate rusp 0.12.1 on toolchain 722e1797249a965b6335aebd65d777f917e498f1
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate rusp 0.12.1
[INFO] finished tweaking crates.io crate rusp 0.12.1
[INFO] tweaked toml for crates.io crate rusp 0.12.1 written to /workspace/builds/worker-114/source/Cargo.toml
[INFO] crate crates.io crate rusp 0.12.1 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded structopt-derive v0.4.14
[INFO] [stderr]   Downloaded structopt v0.3.21
[INFO] [stderr]   Downloaded quick-protobuf v0.8.0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-114/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-114/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 5fdad54e2015b848f3f88cedd7be7dba674e4fd40895648a84a5e37605ae4334
[INFO] running `Command { std: "docker" "start" "-a" "5fdad54e2015b848f3f88cedd7be7dba674e4fd40895648a84a5e37605ae4334", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "5fdad54e2015b848f3f88cedd7be7dba674e4fd40895648a84a5e37605ae4334", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5fdad54e2015b848f3f88cedd7be7dba674e4fd40895648a84a5e37605ae4334", kill_on_drop: false }`
[INFO] [stdout] 5fdad54e2015b848f3f88cedd7be7dba674e4fd40895648a84a5e37605ae4334
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-114/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-114/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] a90ddb16c5ba9d5d43564bc7a85513b5e486d72c0c48ebe9b3d6e0f62f152f0f
[INFO] running `Command { std: "docker" "start" "-a" "a90ddb16c5ba9d5d43564bc7a85513b5e486d72c0c48ebe9b3d6e0f62f152f0f", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.26
[INFO] [stderr]    Compiling syn v1.0.71
[INFO] [stderr]    Compiling libc v0.2.94
[INFO] [stderr]    Compiling serde v1.0.125
[INFO] [stderr]    Compiling unicode-width v0.1.8
[INFO] [stderr]    Compiling unicode-segmentation v1.7.1
[INFO] [stderr]    Compiling serde_json v1.0.64
[INFO] [stderr]    Compiling serde_derive v1.0.125
[INFO] [stderr]    Compiling anyhow v1.0.40
[INFO] [stderr]    Compiling itoa v0.4.7
[INFO] [stderr]    Compiling byteorder v1.4.3
[INFO] [stderr]    Compiling proc-macro-error-attr v1.0.4
[INFO] [stderr]    Compiling proc-macro-error v1.0.4
[INFO] [stderr]    Compiling textwrap v0.11.0
[INFO] [stderr]    Compiling quick-protobuf v0.8.0
[INFO] [stderr]    Compiling heck v0.3.2
[INFO] [stderr]    Compiling quote v1.0.9
[INFO] [stderr]    Compiling atty v0.2.14
[INFO] [stderr]    Compiling clap v2.33.3
[INFO] [stderr]    Compiling structopt-derive v0.4.14
[INFO] [stderr]    Compiling structopt v0.3.21
[INFO] [stderr]    Compiling rusp v0.12.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 31.17s
[INFO] running `Command { std: "docker" "inspect" "a90ddb16c5ba9d5d43564bc7a85513b5e486d72c0c48ebe9b3d6e0f62f152f0f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a90ddb16c5ba9d5d43564bc7a85513b5e486d72c0c48ebe9b3d6e0f62f152f0f", kill_on_drop: false }`
[INFO] [stdout] a90ddb16c5ba9d5d43564bc7a85513b5e486d72c0c48ebe9b3d6e0f62f152f0f
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-114/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-114/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] f7b7e75badb7b5af498bf6aba74fe3a9b659c4785653d6f4eae90bb53d0fb4f9
[INFO] running `Command { std: "docker" "start" "-a" "f7b7e75badb7b5af498bf6aba74fe3a9b659c4785653d6f4eae90bb53d0fb4f9", kill_on_drop: false }`
[INFO] [stderr]    Compiling rusp v0.12.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 16.68s
[INFO] running `Command { std: "docker" "inspect" "f7b7e75badb7b5af498bf6aba74fe3a9b659c4785653d6f4eae90bb53d0fb4f9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f7b7e75badb7b5af498bf6aba74fe3a9b659c4785653d6f4eae90bb53d0fb4f9", kill_on_drop: false }`
[INFO] [stdout] f7b7e75badb7b5af498bf6aba74fe3a9b659c4785653d6f4eae90bb53d0fb4f9
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-114/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-114/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 78614b48164db1c57d8489be54b3d62393591a06f720bf8feb5430c0e81faa47
[INFO] running `Command { std: "docker" "start" "-a" "78614b48164db1c57d8489be54b3d62393591a06f720bf8feb5430c0e81faa47", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.06s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/rusp-ab26b596b7a01178)
[INFO] [stdout] running 0 tests
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/rusp-7768e10fb1277e63)
[INFO] [stdout] 
[INFO] [stderr]      Running tests/parsing_test.rs (/opt/rustwide/target/debug/deps/parsing_test-66d01131ce0464d3)
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test tests::create_obj ... ok
[INFO] [stdout] test tests::get_obj ... ok
[INFO] [stdout] test tests::simple_notify ... ok
[INFO] [stdout] test tests::delete_obj ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_json.rs (/opt/rustwide/target/debug/deps/test_json-bbc352e47488b904)
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test tests::create_obj ... ok
[INFO] [stdout] test tests::get_obj ... ok
[INFO] [stdout] test tests::delete_obj ... ok
[INFO] [stdout] test tests::simple_notify ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests rusp
[INFO] [stdout] 
[INFO] [stdout] running 32 tests
[INFO] [stdout] test src/usp_decoder.rs - usp_decoder::decode_msg (line 79) ... FAILED
[INFO] [stdout] test src/usp_generator.rs - usp_generator::usp_get_response_from_json (line 755) ... FAILED
[INFO] [stdout] test src/usp_decoder.rs - usp_decoder::decode_record (line 17) ... FAILED
[INFO] [stderr] error: test failed, to rerun pass '--doc'
[INFO] [stderr] 
[INFO] [stderr] Caused by:
[INFO] [stderr]   process didn't exit successfully: `rustdoc --edition=2018 --crate-type lib --crate-name rusp --test /opt/rustwide/workdir/src/lib.rs -L dependency=/opt/rustwide/target/debug/deps -L dependency=/opt/rustwide/target/debug/deps --extern anyhow=/opt/rustwide/target/debug/deps/libanyhow-12bc1d15d100a19c.rlib --extern quick_protobuf=/opt/rustwide/target/debug/deps/libquick_protobuf-4116bb4583a0c765.rlib --extern rusp=/opt/rustwide/target/debug/deps/librusp-0896a3326f743fba.rlib --extern serde=/opt/rustwide/target/debug/deps/libserde-efa2178fd10b3175.rlib --extern serde_derive=/opt/rustwide/target/debug/deps/libserde_derive-5139060ac7a118e1.so --extern serde_json=/opt/rustwide/target/debug/deps/libserde_json-d2dbbb1786d7dfdb.rlib --extern structopt=/opt/rustwide/target/debug/deps/libstructopt-96e71fbdb8c53f5c.rlib -C embed-bitcode=no --error-format human` (signal: 9, SIGKILL: kill)
[INFO] running `Command { std: "docker" "inspect" "78614b48164db1c57d8489be54b3d62393591a06f720bf8feb5430c0e81faa47", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "78614b48164db1c57d8489be54b3d62393591a06f720bf8feb5430c0e81faa47", kill_on_drop: false }`
[INFO] [stdout] 78614b48164db1c57d8489be54b3d62393591a06f720bf8feb5430c0e81faa47