[INFO] fetching crate in-toto 0.1.2...
[INFO] testing in-toto-0.1.2 against beta-2021-09-08 for beta-1.56-1
[INFO] extracting crate in-toto 0.1.2 into /workspace/builds/worker-85/source
[INFO] validating manifest of crates.io crate in-toto 0.1.2 on toolchain beta-2021-09-08
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2021-09-08" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate in-toto 0.1.2
[INFO] finished tweaking crates.io crate in-toto 0.1.2
[INFO] tweaked toml for crates.io crate in-toto 0.1.2 written to /workspace/builds/worker-85/source/Cargo.toml
[INFO] crate crates.io crate in-toto 0.1.2 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2021-09-08" "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-85/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-85/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:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2021-09-08" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 37dee176bdbbca222bf2e0b14c26ae47233c8131d59af5eb432c02058f3a4dd3
[INFO] running `Command { std: "docker" "start" "-a" "37dee176bdbbca222bf2e0b14c26ae47233c8131d59af5eb432c02058f3a4dd3", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "37dee176bdbbca222bf2e0b14c26ae47233c8131d59af5eb432c02058f3a4dd3", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "37dee176bdbbca222bf2e0b14c26ae47233c8131d59af5eb432c02058f3a4dd3", kill_on_drop: false }`
[INFO] [stdout] 37dee176bdbbca222bf2e0b14c26ae47233c8131d59af5eb432c02058f3a4dd3
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-85/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-85/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:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2021-09-08" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] fd9f8540fea5a39c6a13460915ca2c401c23d1410d73a329b4a1e8cc8506e2a0
[INFO] running `Command { std: "docker" "start" "-a" "fd9f8540fea5a39c6a13460915ca2c401c23d1410d73a329b4a1e8cc8506e2a0", kill_on_drop: false }`
[INFO] [stderr]    Compiling syn v1.0.76
[INFO] [stderr]    Compiling proc-macro-hack v0.5.19
[INFO] [stderr]    Compiling futures-core v0.3.17
[INFO] [stderr]    Compiling pin-project-lite v0.2.7
[INFO] [stderr]    Compiling futures-task v0.3.17
[INFO] [stderr]    Compiling proc-macro-nested v0.1.7
[INFO] [stderr]    Compiling itoa v0.4.8
[INFO] [stderr]    Compiling bytes v1.1.0
[INFO] [stderr]    Compiling futures v0.1.31
[INFO] [stderr]    Compiling matches v0.1.9
[INFO] [stderr]    Compiling httparse v1.5.1
[INFO] [stderr]    Compiling futures-io v0.3.17
[INFO] [stderr]    Compiling futures-channel v0.3.17
[INFO] [stderr]    Compiling parking_lot_core v0.8.5
[INFO] [stderr]    Compiling ppv-lite86 v0.2.10
[INFO] [stderr]    Compiling slab v0.4.4
[INFO] [stderr]    Compiling unicode-bidi v0.3.6
[INFO] [stderr]    Compiling untrusted v0.7.1
[INFO] [stderr]    Compiling smallvec v1.6.1
[INFO] [stderr]    Compiling scopeguard v1.1.0
[INFO] [stderr]    Compiling spin v0.5.2
[INFO] [stderr]    Compiling remove_dir_all v0.5.3
[INFO] [stderr]    Compiling once_cell v1.8.0
[INFO] [stderr]    Compiling same-file v1.0.6
[INFO] [stderr]    Compiling path-clean v0.1.0
[INFO] [stderr]    Compiling data-encoding v2.3.2
[INFO] [stderr]    Compiling futures-macro v0.3.17
[INFO] [stderr]    Compiling futures-util v0.3.17
[INFO] [stderr]    Compiling tokio v1.11.0
[INFO] [stderr]    Compiling tinyvec v1.3.1
[INFO] [stderr]    Compiling tracing-core v0.1.19
[INFO] [stderr]    Compiling instant v0.1.10
[INFO] [stderr]    Compiling ring v0.16.20
[INFO] [stderr]    Compiling getrandom v0.2.3
[INFO] [stderr]    Compiling time v0.1.43
[INFO] [stderr]    Compiling form_urlencoded v1.0.1
[INFO] [stderr]    Compiling walkdir v2.3.2
[INFO] [stderr]    Compiling rand_core v0.6.3
[INFO] [stderr]    Compiling lock_api v0.4.5
[INFO] [stderr]    Compiling derp v0.0.14
[INFO] [stderr]    Compiling serde_json v1.0.67
[INFO] [stderr]    Compiling http v0.2.4
[INFO] [stderr]    Compiling chrono v0.4.19
[INFO] [stderr]    Compiling tracing v0.1.26
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling unicode-normalization v0.1.19
[INFO] [stderr]    Compiling parking_lot v0.11.2
[INFO] [stderr]    Compiling rand v0.8.4
[INFO] [stderr]    Compiling idna v0.2.3
[INFO] [stderr]    Compiling tempfile v3.2.0
[INFO] [stderr]    Compiling http-body v0.4.3
[INFO] [stderr]    Compiling url v2.2.2
[INFO] [stderr]    Compiling thiserror-impl v1.0.29
[INFO] [stderr]    Compiling serde_derive v1.0.130
[INFO] [stderr]    Compiling thiserror v1.0.29
[INFO] [stderr]    Compiling futures-executor v0.3.17
[INFO] [stderr]    Compiling hyper v0.14.12
[INFO] [stderr]    Compiling in-toto v0.1.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 19.84s
[INFO] running `Command { std: "docker" "inspect" "fd9f8540fea5a39c6a13460915ca2c401c23d1410d73a329b4a1e8cc8506e2a0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "fd9f8540fea5a39c6a13460915ca2c401c23d1410d73a329b4a1e8cc8506e2a0", kill_on_drop: false }`
[INFO] [stdout] fd9f8540fea5a39c6a13460915ca2c401c23d1410d73a329b4a1e8cc8506e2a0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-85/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-85/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:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2021-09-08" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] bd0bba6e5deec9b813ad9a5168d2abeb6cff6413a5148d1951238513419d4e8f
[INFO] running `Command { std: "docker" "start" "-a" "bd0bba6e5deec9b813ad9a5168d2abeb6cff6413a5148d1951238513419d4e8f", kill_on_drop: false }`
[INFO] [stderr]    Compiling diff v0.1.12
[INFO] [stderr]    Compiling ansi_term v0.12.1
[INFO] [stderr]    Compiling maplit v1.0.2
[INFO] [stderr]    Compiling pretty_assertions v0.7.2
[INFO] [stderr]    Compiling in-toto v0.1.2 (/opt/rustwide/workdir)
[INFO] [stdout] warning: function is never used: `calculate_hash`
[INFO] [stdout]   --> src/crypto.rs:78:15
[INFO] [stdout]    |
[INFO] [stdout] 78 | pub(crate) fn calculate_hash(data: &[u8], hash_alg: HashAlgorithm) -> HashValue {
[INFO] [stdout]    |               ^^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(dead_code)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: 1 warning emitted
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 4.69s
[INFO] running `Command { std: "docker" "inspect" "bd0bba6e5deec9b813ad9a5168d2abeb6cff6413a5148d1951238513419d4e8f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "bd0bba6e5deec9b813ad9a5168d2abeb6cff6413a5148d1951238513419d4e8f", kill_on_drop: false }`
[INFO] [stdout] bd0bba6e5deec9b813ad9a5168d2abeb6cff6413a5148d1951238513419d4e8f
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-85/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-85/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:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2021-09-08" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] bd7525baedc010bbd7acc6085337055efbb47cebb269b522448083c492003523
[INFO] running `Command { std: "docker" "start" "-a" "bd7525baedc010bbd7acc6085337055efbb47cebb269b522448083c492003523", kill_on_drop: false }`
[INFO] [stderr] warning: function is never used: `calculate_hash`
[INFO] [stderr]   --> src/crypto.rs:78:15
[INFO] [stderr]    |
[INFO] [stderr] 78 | pub(crate) fn calculate_hash(data: &[u8], hash_alg: HashAlgorithm) -> HashValue {
[INFO] [stderr]    |               ^^^^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(dead_code)]` on by default
[INFO] [stderr] 
[INFO] [stderr] warning: `in-toto` (lib test) generated 1 warning
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.08s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/in_toto-27a6de4adba85391)
[INFO] [stdout] 
[INFO] [stdout] running 33 tests
[INFO] [stdout] test crypto::test::extract_pkcs1_from_rsa_2048_pkcs8 ... ok
[INFO] [stdout] test crypto::test::de_ser_rsa_public_key_with_keyid_hash_algo ... ok
[INFO] [stdout] test crypto::test::extract_pkcs1_from_rsa_4096_pkcs8 ... ok
[INFO] [stdout] test crypto::test::de_ser_ed25519_public_key_without_keyid_hash_algo ... ok
[INFO] [stdout] test crypto::test::de_ser_rsa_public_key_without_keyid_hash_algo ... ok
[INFO] [stdout] test crypto::test::de_ser_ed25519_public_key_with_keyid_hash_algo ... ok
[INFO] [stdout] test crypto::test::parse_public_ed25519_spki ... ok
[INFO] [stdout] test crypto::test::parse_public_ed25519_with_keyid_hash_algo ... ok
[INFO] [stdout] test crypto::test::parse_public_ed25519 ... ok
[INFO] [stdout] test crypto::test::new_ed25519_key ... ok
[INFO] [stdout] test crypto::test::parse_public_ed25519_without_keyid_hash_algo ... ok
[INFO] [stdout] test crypto::test::parse_public_rsa_2048_spki ... ok
[INFO] [stdout] test crypto::test::serde_key_id ... ok
[INFO] [stdout] test crypto::test::ed25519_read_keypair_and_sign ... ok
[INFO] [stdout] test crypto::test::serde_ed25519_public_key ... ok
[INFO] [stdout] test crypto::test::ed25519_read_pkcs8_and_sign ... ok
[INFO] [stdout] test crypto::test::ed25519_read_keypair_and_sign_with_keyid_hash_algorithms ... ok
[INFO] [stdout] test crypto::test::parse_public_rsa_4096_spki ... ok
[INFO] [stdout] test crypto::test::serde_signature_value ... ok
[INFO] [stdout] test crypto::test::serde_signature ... ok
[INFO] [stdout] test crypto::test::serde_rsa_public_key ... ok
[INFO] [stdout] test crypto::test::rsa_2048_read_pkcs8_and_sign ... ok
[INFO] [stdout] test crypto::test::serde_signature_without_keyid_hash_algo ... ok
[INFO] [stdout] test crypto::test::test_public_key_eq ... ok
[INFO] [stdout] test error::tests::verify_io_error_display_string ... ok
[INFO] [stdout] test crypto::test::test_public_key_hash ... ok
[INFO] [stdout] test interchange::cjson::test::write_arr ... ok
[INFO] [stdout] test interchange::cjson::test::write_obj ... ok
[INFO] [stdout] test interchange::cjson::test::write_str ... ok
[INFO] [stdout] test crypto::test::rsa_4096_read_pkcs8_and_sign ... ok
[INFO] [stdout] hellotest runlib::test::test_record_artifacts ... ok
[INFO] [stdout] test runlib::test::test_run_command ... ok
[INFO] [stdout] test crypto::test::new_rsa_key ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 33 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.38s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/runlib.rs (/opt/rustwide/target/debug/deps/runlib-88820e2f791ab2cd)
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test in_toto_run_record_modified_file ... ok
[INFO] [stdout] test in_toto_run_record_symlink_cycle ... ok
[INFO] [stdout] in_toto says hi
[INFO] [stdout] in_toto says hi
[INFO] [stderr]    Doc-tests in_toto
[INFO] [stdout] test in_toto_run_record_file ... ok
[INFO] [stdout] test in_toto_run_record_new_file ... ok
[INFO] [stdout] test in_toto_run_record_symlink_file ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 25 tests
[INFO] [stdout] test src/crypto.rs - crypto::PrivateKey::from_pkcs8 (line 409) - compile ... ok
[INFO] [stdout] test src/interchange/cjson/pretty.rs - interchange::cjson::pretty::JsonPretty::deserialize (line 39) ... FAILED
[INFO] [stdout] test src/interchange/cjson/mod.rs - interchange::cjson::Json::deserialize (line 186) ... FAILED
[INFO] [stdout] test src/interchange/cjson/mod.rs - interchange::cjson::Json::from_reader (line 268) ... 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 in_toto --test /opt/rustwide/workdir/./src/lib.rs -L dependency=/opt/rustwide/target/debug/deps -L dependency=/opt/rustwide/target/debug/deps -L native=/opt/rustwide/target/debug/build/ring-26cd1457f34a97e6/out --extern chrono=/opt/rustwide/target/debug/deps/libchrono-98b4735fefee6a68.rlib --extern data_encoding=/opt/rustwide/target/debug/deps/libdata_encoding-db8c7da9cef73501.rlib --extern derp=/opt/rustwide/target/debug/deps/libderp-297a866cef89186d.rlib --extern futures_executor=/opt/rustwide/target/debug/deps/libfutures_executor-0b13734e29c9d92f.rlib --extern futures_io=/opt/rustwide/target/debug/deps/libfutures_io-da2392d6c8abc697.rlib --extern futures_util=/opt/rustwide/target/debug/deps/libfutures_util-dde3758de538105f.rlib --extern http=/opt/rustwide/target/debug/deps/libhttp-c5f3b245a9ce0a3b.rlib --extern hyper=/opt/rustwide/target/debug/deps/libhyper-53717790ebf55d82.rlib --extern in_toto=/opt/rustwide/target/debug/deps/libin_toto-03d4f0cfa1fe046c.rlib --extern itoa=/opt/rustwide/target/debug/deps/libitoa-d0264c8ce1ce890b.rlib --extern lazy_static=/opt/rustwide/target/debug/deps/liblazy_static-86422d76b8bd90ed.rlib --extern log=/opt/rustwide/target/debug/deps/liblog-51b42ffc939a9eea.rlib --extern maplit=/opt/rustwide/target/debug/deps/libmaplit-7b5b184081e8655b.rlib --extern matches=/opt/rustwide/target/debug/deps/libmatches-bfb4602457f1458f.rlib --extern parking_lot=/opt/rustwide/target/debug/deps/libparking_lot-036ccff7442f54f4.rlib --extern path_clean=/opt/rustwide/target/debug/deps/libpath_clean-dff772de01dd0713.rlib --extern percent_encoding=/opt/rustwide/target/debug/deps/libpercent_encoding-8c83310236959ef9.rlib --extern pretty_assertions=/opt/rustwide/target/debug/deps/libpretty_assertions-4f79767f3becb4c6.rlib --extern rand=/opt/rustwide/target/debug/deps/librand-103265e50e195195.rlib --extern ring=/opt/rustwide/target/debug/deps/libring-e3ad87ec8f9172d8.rlib --extern serde=/opt/rustwide/target/debug/deps/libserde-3d87f6cff87cb4be.rlib --extern serde_derive=/opt/rustwide/target/debug/deps/libserde_derive-3c2cf0f74b59c10a.so --extern serde_json=/opt/rustwide/target/debug/deps/libserde_json-58878fc59a0b63d7.rlib --extern tempfile=/opt/rustwide/target/debug/deps/libtempfile-150c46338fbc16f2.rlib --extern thiserror=/opt/rustwide/target/debug/deps/libthiserror-e7a85c0dbbcd38ec.rlib --extern untrusted=/opt/rustwide/target/debug/deps/libuntrusted-299fbcd347deffe0.rlib --extern url=/opt/rustwide/target/debug/deps/liburl-173623fcea0d26ec.rlib --extern walkdir=/opt/rustwide/target/debug/deps/libwalkdir-d68fa3dede4483c7.rlib -C embed-bitcode=no --cfg 'feature="default"' --error-format human` (signal: 9, SIGKILL: kill)
[INFO] running `Command { std: "docker" "inspect" "bd7525baedc010bbd7acc6085337055efbb47cebb269b522448083c492003523", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "bd7525baedc010bbd7acc6085337055efbb47cebb269b522448083c492003523", kill_on_drop: false }`
[INFO] [stdout] bd7525baedc010bbd7acc6085337055efbb47cebb269b522448083c492003523