[INFO] crate lexpr 0.2.5 is already in cache
[INFO] testing lexpr-0.2.5 against beta-2020-07-24 for beta-1.46-1
[INFO] extracting crate lexpr 0.2.5 into /workspace/builds/worker-1/source
[INFO] validating manifest of crates.io crate lexpr 0.2.5 on toolchain beta-2020-07-24
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2020-07-24" "read-manifest" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] started tweaking crates.io crate lexpr 0.2.5
[INFO] finished tweaking crates.io crate lexpr 0.2.5
[INFO] tweaked toml for crates.io crate lexpr 0.2.5 written to /workspace/builds/worker-1/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2020-07-24" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }`
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2020-07-24" "fetch" "--locked" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[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" "MAP_USER_ID=0" "-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" "--network" "none" "rustops/crates-build-env@sha256:a636fd89d022f18117e1dc8fb37a0a009933cdbbe082814857f0e2024962d47c" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2020-07-24" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] a615790c3ab75b27773bbe65a486e9f1ed12956202fdd6c4d71a63a452fa2d5c
[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" "a615790c3ab75b27773bbe65a486e9f1ed12956202fdd6c4d71a63a452fa2d5c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "a615790c3ab75b27773bbe65a486e9f1ed12956202fdd6c4d71a63a452fa2d5c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a615790c3ab75b27773bbe65a486e9f1ed12956202fdd6c4d71a63a452fa2d5c", kill_on_drop: false }`
[INFO] [stdout] a615790c3ab75b27773bbe65a486e9f1ed12956202fdd6c4d71a63a452fa2d5c
[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" "MAP_USER_ID=0" "-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" "--network" "none" "rustops/crates-build-env@sha256:a636fd89d022f18117e1dc8fb37a0a009933cdbbe082814857f0e2024962d47c" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2020-07-24" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 8b5f5d2dd337580cf410211254e4ac615d5304470e567504871f875b5ae4ec0e
[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" "8b5f5d2dd337580cf410211254e4ac615d5304470e567504871f875b5ae4ec0e", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling lexpr-macros v0.2.1
[INFO] [stderr]    Compiling lexpr v0.2.5 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 4.17s
[INFO] running `Command { std: "docker" "inspect" "8b5f5d2dd337580cf410211254e4ac615d5304470e567504871f875b5ae4ec0e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8b5f5d2dd337580cf410211254e4ac615d5304470e567504871f875b5ae4ec0e", kill_on_drop: false }`
[INFO] [stdout] 8b5f5d2dd337580cf410211254e4ac615d5304470e567504871f875b5ae4ec0e
[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" "MAP_USER_ID=0" "-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" "--network" "none" "rustops/crates-build-env@sha256:a636fd89d022f18117e1dc8fb37a0a009933cdbbe082814857f0e2024962d47c" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2020-07-24" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] ef8fe1a32aa5991e468023f1a1db287d0b888d5d7e115b40b5721a73d6bfe9c3
[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" "ef8fe1a32aa5991e468023f1a1db287d0b888d5d7e115b40b5721a73d6bfe9c3", kill_on_drop: false }`
[INFO] [stderr]    Compiling quickcheck_macros v0.9.1
[INFO] [stderr]    Compiling plotters v0.2.15
[INFO] [stderr]    Compiling bstr v0.2.13
[INFO] [stderr]    Compiling env_logger v0.7.1
[INFO] [stderr]    Compiling quickcheck v0.9.2
[INFO] [stderr]    Compiling csv v1.1.3
[INFO] [stderr]    Compiling criterion v0.3.3
[INFO] [stderr]    Compiling lexpr v0.2.5 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 36.81s
[INFO] running `Command { std: "docker" "inspect" "ef8fe1a32aa5991e468023f1a1db287d0b888d5d7e115b40b5721a73d6bfe9c3", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ef8fe1a32aa5991e468023f1a1db287d0b888d5d7e115b40b5721a73d6bfe9c3", kill_on_drop: false }`
[INFO] [stdout] ef8fe1a32aa5991e468023f1a1db287d0b888d5d7e115b40b5721a73d6bfe9c3
[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" "MAP_USER_ID=0" "-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" "--network" "none" "rustops/crates-build-env@sha256:a636fd89d022f18117e1dc8fb37a0a009933cdbbe082814857f0e2024962d47c" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2020-07-24" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 7aeac863517d73bb32e2c4f7497246cb8e0bf2193ba39f214263f20921ee080f
[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" "7aeac863517d73bb32e2c4f7497246cb8e0bf2193ba39f214263f20921ee080f", kill_on_drop: false }`
[INFO] [stdout] 
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.12s
[INFO] [stdout] running 56 tests
[INFO] [stderr]      Running /opt/rustwide/target/debug/deps/lexpr-a594dac2f08ca8e5
[INFO] [stdout] test parse::tests::test_atom_failures ... ok
[INFO] [stdout] test parse::tests::test_atoms_default ... ok
[INFO] [stdout] test parse::tests::test_bin_numbers ... ok
[INFO] [stdout] test parse::tests::test_atoms_location_info ... ok
[INFO] [stdout] test parse::tests::test_chars_elisp ... ok
[INFO] [stdout] test parse::tests::test_list_brackets ... ok
[INFO] [stdout] test parse::tests::test_broken_lists_default ... ok
[INFO] [stdout] test parse::tests::test_list_elisp ... ok
[INFO] [stdout] test parse::tests::test_hex_numbers ... ok
[INFO] [stdout] test parse::tests::test_list_location_info ... ok
[INFO] [stdout] test parse::tests::test_list_peculiar ... ok
[INFO] [stdout] test parse::tests::test_quote_shorthand ... ok
[INFO] [stdout] test parse::tests::test_lists_default ... ok
[INFO] [stdout] test parse::tests::test_parser_iterator ... ok
[INFO] [stdout] test parse::tests::test_quasiquote_shorthand ... ok
[INFO] [stdout] test parse::tests::test_strings_elisp_io ... ok
[INFO] [stdout] test parse::tests::test_comments ... ok
[INFO] [stdout] test parse::tests::test_strings_io_default ... ok
[INFO] [stdout] test parse::tests::test_list_nil_default ... ok
[INFO] [stdout] test parse::tests::test_keyword_syntaxes ... ok
[INFO] [stdout] test parse::tests::test_strings_elisp ... ok
[INFO] [stdout] test parse::tests::test_quoted_location_info ... ok
[INFO] [stdout] test parse::tests::test_byte_vectors ... ok
[INFO] [stdout] test print::tests::test_options_size ... ok
[INFO] [stdout] test parse::tests::test_symbols ... ok
[INFO] [stdout] test parse::tests::test_chars_default ... ok
[INFO] [stdout] test parse::tests::test_unquote_shorthand ... ok
[INFO] [stdout] test parse::tests::test_oct_numbers ... ok
[INFO] [stdout] test print::tests::test_keyword_syntax ... ok
[INFO] [stdout] test parse::tests::test_vector_location_info ... ok
[INFO] [stdout] test parse::tests::test_strings_default ... ok
[INFO] [stdout] test parse::tests::test_vectors_default ... ok
[INFO] [stdout] test parse::tests::test_options_size ... ok
[INFO] [stdout] test parse::tests::test_vector_peculiar ... ok
[INFO] [stdout] test parse::tests::test_vectors_elisp ... ok
[INFO] [stdout] test parse::tests::test_decimal_numbers ... ok
[INFO] [stdout] test parse::tests::test_dotted_list_location_info ... ok
[INFO] [stdout] test parse::tests::test_unquote_splicing_shorthand ... ok
[INFO] [stdout] test tests::test_list_index ... ok
[INFO] [stdout] test print::tests::test_str_escapes_default ... ok
[INFO] [stdout] test value::tests::test_strings ... ok
[INFO] [stdout] test value::tests::test_lists ... ok
[INFO] [stdout] test print::tests::test_str_escapes_elisp ... ok
[INFO] [stdout] test value::tests::test_chars ... ok
[INFO] [stdout] test value::tests::test_numbers ... ok
[INFO] [stdout] test tests::write_number ... ok
[INFO] [stdout] test tests::test_alist_index ... ok
[INFO] [stdout] test value::tests::test_dotted_lists ... ok
[INFO] [stdout] test value::tests::test_keywords ... ok
[INFO] [stdout] test tests::write_parse_number ... ok
[INFO] [stdout] test value::tests::test_symbols ... ok
[INFO] [stdout] test tests::print_parse_roundtrip_io_default ... ok
[INFO] [stdout] test value::tests::test_vectors ... ok
[INFO] [stdout] test tests::print_parse_roundtrip_custom_default ... ok
[INFO] [stderr]      Running /opt/rustwide/target/debug/deps/print_parse-c6ee35ae51e388ab
[INFO] [stdout] test tests::print_parse_roundtrip_default ... ok
[INFO] [stdout] test tests::parse_datum_span_sanity ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 56 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 12 tests
[INFO] [stdout] test test_bytes ... ok
[INFO] [stdout] test test_bytes_elisp ... ok
[INFO] [stdout] test test_keyword_default ... ok
[INFO] [stdout] test test_peculiar_symbols ... ok
[INFO] [stderr]    Doc-tests lexpr
[INFO] [stdout] test test_number ... ok
[INFO] [stdout] test test_strings_elisp ... ok
[INFO] [stdout] test test_special_symbols ... ok
[INFO] [stdout] test test_vectors_elisp ... ok
[INFO] [stdout] test test_chars_elisp ... ok
[INFO] [stdout] test test_symbol ... ok
[INFO] [stdout] test test_vectors ... ok
[INFO] [stdout] test test_improper_lists ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 76 tests
[INFO] [stdout] test src/datum.rs - datum::from_reader_custom (line 409) ... ok
[INFO] [stdout] test src/lib.rs - sexp (line 347) ... ok
[INFO] [stdout] test src/cons.rs - cons::Cons::to_ref_vec (line 168) ... ok
[INFO] [stdout] test src/datum.rs - datum::from_slice_custom (line 459) ... ok
[INFO] [stdout] test src/cons.rs - cons::Cons::as_pair (line 84) ... ok
[INFO] [stdout] test src/cons.rs - cons::Cons::into_vec (line 126) ... ok
[INFO] [stdout] test src/datum.rs - datum::from_str_custom (line 491) ... ok
[INFO] [stdout] test src/cons.rs - cons::Cons::into_pair (line 95) ... ok
[INFO] [stdout] test src/lib.rs - sexp (line 359) ... ok
[INFO] [stdout] test src/lib.rs - sexp (line 377) ... ok
[INFO] [stdout] test src/lib.rs - sexp (line 390) ... ok
[INFO] [stdout] test src/cons.rs - cons::Cons::iter (line 111) ... ok
[INFO] [stdout] test src/lib.rs - (line 66) ... ok
[INFO] [stdout] test src/datum.rs - datum::Datum::list_iter (line 58) ... ok
[INFO] [stdout] test src/cons.rs - cons::Cons::to_vec (line 147) ... ok
[INFO] [stdout] test src/cons.rs - cons::Cons::into_iter (line 206) ... ok
[INFO] [stdout] test src/number.rs - number::Number::as_u64 (line 131) ... ok
[INFO] [stdout] test src/parse/error.rs - parse::error::io::Error::from (line 128) ... ok
[INFO] [stdout] test src/lib.rs - sexp (line 402) ... ok
[INFO] [stdout] test src/parse/mod.rs - parse::from_reader_custom (line 1378) ... ok
[INFO] [stdout] test src/lib.rs - sexp (line 415) ... ok
[INFO] [stdout] test src/parse/mod.rs - parse::Parser<R>::datum_iter (line 431) ... ok
[INFO] [stdout] test src/number.rs - number::Number::from_f64 (line 171) ... ok
[INFO] [stdout] test src/parse/mod.rs - parse::Parser<R>::expect_value (line 448) ... ok
[INFO] [stdout] test src/number.rs - number::Number::is_u64 (line 53) ... ok
[INFO] [stdout] test src/number.rs - number::Number::as_f64 (line 150) ... ok
[INFO] [stdout] test src/number.rs - number::Number::as_i64 (line 103) ... ok
[INFO] [stdout] test src/parse/mod.rs - parse::from_slice_custom (line 1428) ... ok
[INFO] [stdout] test src/number.rs - number::Number::is_i64 (line 25) ... ok
[INFO] [stdout] test src/number.rs - number::Number::is_f64 (line 82) ... ok
[INFO] [stdout] test src/parse/mod.rs - parse::Parser<R>::value_iter (line 408) ... ok
[INFO] [stdout] test src/value/index.rs - value::index::Value::index (line 161) ... ok
[INFO] [stdout] test src/parse/mod.rs - parse::from_str_custom (line 1458) ... ok
[INFO] [stdout] test src/value/index.rs - value::index::Index (line 24) ... ok
[INFO] [stdout] test src/value/mod.rs - value (line 61) ... ok
[INFO] [stdout] test src/value/mod.rs - value (line 37) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::append (line 286) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::as_bytes (line 502) ... ok
[INFO] [stdout] test src/value/mod.rs - value (line 8) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::as_bool (line 684) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::Cons (line 155) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::as_name (line 459) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::as_f64 (line 649) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::as_pair (line 808) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::as_i64 (line 615) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::as_nil (line 747) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::as_char (line 709) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::as_keyword (line 440) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::as_str (line 353) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::as_slice (line 828) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::as_symbol (line 403) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::as_slice_mut (line 843) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::as_u64 (line 633) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::get (line 959) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::bytes (line 199) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::cons (line 221) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::cons (line 211) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::is_dotted_list (line 265) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::is_bytes (line 485) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::fmt (line 1023) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::is_boolean (line 667) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::is_f64 (line 593) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::get (line 978) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::is_keyword (line 422) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::is_string (line 336) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::is_i64 (line 539) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::keyword (line 175) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::list_iter (line 863) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::is_symbol (line 385) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::is_nil (line 731) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::to_vec (line 889) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::is_u64 (line 565) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::string (line 187) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::to_ref_vec (line 917) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::list (line 237) ... ok
[INFO] [stdout] test src/value/mod.rs - value::Value::vector (line 318) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 76 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "7aeac863517d73bb32e2c4f7497246cb8e0bf2193ba39f214263f20921ee080f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "7aeac863517d73bb32e2c4f7497246cb8e0bf2193ba39f214263f20921ee080f", kill_on_drop: false }`
[INFO] [stdout] 7aeac863517d73bb32e2c4f7497246cb8e0bf2193ba39f214263f20921ee080f