[INFO] updating cached repository matklad/s
[INFO] running `"git" "fetch" "--all"`
[INFO] [stdout] Fetching origin
[INFO] [stderr] From git://github.com/matklad/s
[INFO] [stderr]  * branch            HEAD       -> FETCH_HEAD
[INFO] running `"git" "clone" "work/cache/sources/gh/matklad/s" "work/ex/beta-1.38-1/sources/1.37.0/gh/matklad/s"`
[INFO] [stderr] Cloning into 'work/ex/beta-1.38-1/sources/1.37.0/gh/matklad/s'...
[INFO] [stderr] done.
[INFO] running `"git" "clone" "work/cache/sources/gh/matklad/s" "work/ex/beta-1.38-1/sources/beta-2019-08-13/gh/matklad/s"`
[INFO] [stderr] Cloning into 'work/ex/beta-1.38-1/sources/beta-2019-08-13/gh/matklad/s'...
[INFO] [stderr] done.
[INFO] running `"git" "rev-parse" "HEAD"`
[INFO] [stdout] 7be36a4cf85c5dbb1046a41ef01c8d441c60f98f
[INFO] sha for GitHub repo matklad/s: 7be36a4cf85c5dbb1046a41ef01c8d441c60f98f
[INFO] validating manifest of matklad/s on toolchain 1.37.0
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+1.37.0" "read-manifest" "--manifest-path" "Cargo.toml"`
[INFO] validating manifest of matklad/s on toolchain beta-2019-08-13
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+beta-2019-08-13" "read-manifest" "--manifest-path" "Cargo.toml"`
[INFO] started frobbing matklad/s
[INFO] finished frobbing matklad/s
[INFO] frobbed toml for matklad/s written to work/ex/beta-1.38-1/sources/1.37.0/gh/matklad/s/Cargo.toml
[INFO] started frobbing matklad/s
[INFO] finished frobbing matklad/s
[INFO] frobbed toml for matklad/s written to work/ex/beta-1.38-1/sources/beta-2019-08-13/gh/matklad/s/Cargo.toml
[INFO] crate matklad/s already has a lockfile, it will not be regenerated
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+1.37.0" "fetch" "--locked" "--manifest-path" "Cargo.toml"`
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+beta-2019-08-13" "fetch" "--locked" "--manifest-path" "Cargo.toml"`
[INFO] testing matklad/s against 1.37.0 for beta-1.38-1
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.38-1/worker-0/1.37.0:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/beta-1.38-1/sources/1.37.0/gh/matklad/s:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+1.37.0" "build" "--frozen"`
[INFO] [stdout] 0fe870fe3a02c68f3384a6a95e3d755401769c562095911a7bd6abfe32cf531d
[INFO] running `"docker" "start" "-a" "0fe870fe3a02c68f3384a6a95e3d755401769c562095911a7bd6abfe32cf531d"`
[INFO] [stderr]    Compiling s v0.1.0 (/opt/crater/workdir)
[INFO] [stderr] warning: trait objects without an explicit `dyn` are deprecated
[INFO] [stderr]   --> src/eval.rs:14:16
[INFO] [stderr]    |
[INFO] [stderr] 14 |     Closure(Rc<Fn(&Env, &[Sexpr]) -> Result<Value, Error>>)
[INFO] [stderr]    |                ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: use `dyn`: `dyn Fn(&Env, &[Sexpr]) -> Result<Value, Error>`
[INFO] [stderr]    |
[INFO] [stderr]    = note: #[warn(bare_trait_objects)] on by default
[INFO] [stderr] 
[INFO] [stderr] warning: trait objects without an explicit `dyn` are deprecated
[INFO] [stderr]   --> src/eval.rs:27:19
[INFO] [stderr]    |
[INFO] [stderr] 27 | pub type Env = Rc<Fn(&str) -> Option<Value>>;
[INFO] [stderr]    |                   ^^^^^^^^^^^^^^^^^^^^^^^^^ help: use `dyn`: `dyn Fn(&str) -> Option<Value>`
[INFO] [stderr] 
[INFO] [stderr] warning: use of deprecated item 'core::str::<impl str>::trim_left': superseded by `trim_start`
[INFO] [stderr]   --> src/sexpr.rs:57:15
[INFO] [stderr]    |
[INFO] [stderr] 57 |     let s = s.trim_left();
[INFO] [stderr]    |               ^^^^^^^^^ help: replace the use of the deprecated item: `trim_start`
[INFO] [stderr]    |
[INFO] [stderr]    = note: #[warn(deprecated)] on by default
[INFO] [stderr] 
[INFO] [stderr] warning: use of deprecated item 'core::str::<impl str>::trim_left': superseded by `trim_start`
[INFO] [stderr]   --> src/sexpr.rs:68:19
[INFO] [stderr]    |
[INFO] [stderr] 68 |             s = s.trim_left();
[INFO] [stderr]    |                   ^^^^^^^^^ help: replace the use of the deprecated item: `trim_start`
[INFO] [stderr] 
[INFO] [stderr] warning: variant is never constructed: `Number`
[INFO] [stderr]   --> src/eval.rs:11:5
[INFO] [stderr]    |
[INFO] [stderr] 11 |     Number(i64),
[INFO] [stderr]    |     ^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: #[warn(dead_code)] on by default
[INFO] [stderr] 
[INFO] [stderr] warning: variant is never constructed: `Atom`
[INFO] [stderr]   --> src/eval.rs:12:5
[INFO] [stderr]    |
[INFO] [stderr] 12 |     Atom(String),
[INFO] [stderr]    |     ^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: variant is never constructed: `List`
[INFO] [stderr]   --> src/eval.rs:13:5
[INFO] [stderr]    |
[INFO] [stderr] 13 |     List(Vec<Value>),
[INFO] [stderr]    |     ^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: variant is never constructed: `Closure`
[INFO] [stderr]   --> src/eval.rs:14:5
[INFO] [stderr]    |
[INFO] [stderr] 14 |     Closure(Rc<Fn(&Env, &[Sexpr]) -> Result<Value, Error>>)
[INFO] [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: method is never used: `closure`
[INFO] [stderr]   --> src/eval.rs:31:5
[INFO] [stderr]    |
[INFO] [stderr] 31 |     pub fn closure<F: Fn(&Env, &[Sexpr]) -> Result<Value, Error> + 'static>(f: F) -> Value {
[INFO] [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: method is never used: `number`
[INFO] [stderr]   --> src/eval.rs:35:5
[INFO] [stderr]    |
[INFO] [stderr] 35 |     pub fn number(i: i64) -> Value {
[INFO] [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: method is never used: `from_bool`
[INFO] [stderr]   --> src/eval.rs:39:5
[INFO] [stderr]    |
[INFO] [stderr] 39 |     pub fn from_bool(b: bool) -> Value {
[INFO] [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: method is never used: `from_sexpr`
[INFO] [stderr]   --> src/eval.rs:43:5
[INFO] [stderr]    |
[INFO] [stderr] 43 |     pub fn from_sexpr(sexpr: &Sexpr) -> Value {
[INFO] [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: method is never used: `eval`
[INFO] [stderr]   --> src/eval.rs:79:5
[INFO] [stderr]    |
[INFO] [stderr] 79 |     pub fn eval(&self) -> Result<Value, Error> {
[INFO] [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: function is never used: `builtin`
[INFO] [stderr]   --> src/eval.rs:86:1
[INFO] [stderr]    |
[INFO] [stderr] 86 | fn builtin() -> Env {
[INFO] [stderr]    | ^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: function is never used: `mk_env`
[INFO] [stderr]    --> src/eval.rs:401:1
[INFO] [stderr]     |
[INFO] [stderr] 401 | fn mk_env<F: Fn(&str) -> Option<Value> + 'static>(f: F) -> Env {
[INFO] [stderr]     | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: function is never used: `eval_number`
[INFO] [stderr]    --> src/eval.rs:406:1
[INFO] [stderr]     |
[INFO] [stderr] 406 | fn eval_number(env: &Env, expr: &Sexpr) -> Result<i64, Error> {
[INFO] [stderr]     | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: function is never used: `eval`
[INFO] [stderr]    --> src/eval.rs:414:1
[INFO] [stderr]     |
[INFO] [stderr] 414 | fn eval(env: &Env, expr: &Sexpr) -> Result<Value, Error> {
[INFO] [stderr]     | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.91s
[INFO] running `"docker" "inspect" "0fe870fe3a02c68f3384a6a95e3d755401769c562095911a7bd6abfe32cf531d"`
[INFO] running `"docker" "rm" "-f" "0fe870fe3a02c68f3384a6a95e3d755401769c562095911a7bd6abfe32cf531d"`
[INFO] [stdout] 0fe870fe3a02c68f3384a6a95e3d755401769c562095911a7bd6abfe32cf531d
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.38-1/worker-0/1.37.0:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/beta-1.38-1/sources/1.37.0/gh/matklad/s:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+1.37.0" "test" "--frozen" "--no-run"`
[INFO] [stdout] 540571710e8921849a8d319dc05006fb6d6942545245bb83ec6b3dfba364d7a3
[INFO] running `"docker" "start" "-a" "540571710e8921849a8d319dc05006fb6d6942545245bb83ec6b3dfba364d7a3"`
[INFO] [stderr]    Compiling s v0.1.0 (/opt/crater/workdir)
[INFO] [stderr] warning: trait objects without an explicit `dyn` are deprecated
[INFO] [stderr]   --> src/eval.rs:14:16
[INFO] [stderr]    |
[INFO] [stderr] 14 |     Closure(Rc<Fn(&Env, &[Sexpr]) -> Result<Value, Error>>)
[INFO] [stderr]    |                ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: use `dyn`: `dyn Fn(&Env, &[Sexpr]) -> Result<Value, Error>`
[INFO] [stderr]    |
[INFO] [stderr]    = note: #[warn(bare_trait_objects)] on by default
[INFO] [stderr] 
[INFO] [stderr] warning: trait objects without an explicit `dyn` are deprecated
[INFO] [stderr]   --> src/eval.rs:27:19
[INFO] [stderr]    |
[INFO] [stderr] 27 | pub type Env = Rc<Fn(&str) -> Option<Value>>;
[INFO] [stderr]    |                   ^^^^^^^^^^^^^^^^^^^^^^^^^ help: use `dyn`: `dyn Fn(&str) -> Option<Value>`
[INFO] [stderr] 
[INFO] [stderr] warning: use of deprecated item 'core::str::<impl str>::trim_left': superseded by `trim_start`
[INFO] [stderr]   --> src/sexpr.rs:57:15
[INFO] [stderr]    |
[INFO] [stderr] 57 |     let s = s.trim_left();
[INFO] [stderr]    |               ^^^^^^^^^ help: replace the use of the deprecated item: `trim_start`
[INFO] [stderr]    |
[INFO] [stderr]    = note: #[warn(deprecated)] on by default
[INFO] [stderr] 
[INFO] [stderr] warning: use of deprecated item 'core::str::<impl str>::trim_left': superseded by `trim_start`
[INFO] [stderr]   --> src/sexpr.rs:68:19
[INFO] [stderr]    |
[INFO] [stderr] 68 |             s = s.trim_left();
[INFO] [stderr]    |                   ^^^^^^^^^ help: replace the use of the deprecated item: `trim_start`
[INFO] [stderr] 
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.99s
[INFO] running `"docker" "inspect" "540571710e8921849a8d319dc05006fb6d6942545245bb83ec6b3dfba364d7a3"`
[INFO] running `"docker" "rm" "-f" "540571710e8921849a8d319dc05006fb6d6942545245bb83ec6b3dfba364d7a3"`
[INFO] [stdout] 540571710e8921849a8d319dc05006fb6d6942545245bb83ec6b3dfba364d7a3
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.38-1/worker-0/1.37.0:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/beta-1.38-1/sources/1.37.0/gh/matklad/s:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+1.37.0" "test" "--frozen"`
[INFO] [stdout] 3097bad56d5e9eb777669b112fd069f33f97f97692e6e50e0a857f7333e19601
[INFO] running `"docker" "start" "-a" "3097bad56d5e9eb777669b112fd069f33f97f97692e6e50e0a857f7333e19601"`
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.03s
[INFO] [stderr]      Running /opt/crater/target/debug/deps/s-dfbe854921f89974
[INFO] [stdout] 
[INFO] [stdout] running 34 tests
[INFO] [stdout] test eval::meta_eval_tests::cond ... ok
[INFO] [stdout] test eval::meta_eval_tests::cadavr ... ok
[INFO] [stdout] test eval::meta_eval_tests::cons ... ok
[INFO] [stdout] test eval::meta_eval_tests::caaddr ... ok
[INFO] [stdout] test eval::meta_eval_tests::binops ... test eval::meta_eval_tests::binops has been running for over 60 seconds
[INFO] [stdout] test eval::meta_eval_tests::fix2_comb ... test eval::meta_eval_tests::fix2_comb has been running for over 60 seconds
[INFO] [stdout] test eval::meta_eval_tests::basic_arigh ... test eval::meta_eval_tests::basic_arigh has been running for over 60 seconds
[INFO] [stdout] test eval::meta_eval_tests::combinator_fact ... test eval::meta_eval_tests::combinator_fact has been running for over 60 seconds
[INFO] [stdout] test eval::meta_eval_tests::if_ ... ok
[INFO] [stdout] test eval::meta_eval_tests::integers ... ok
[INFO] [stdout] test eval::meta_eval_tests::fix_comb ... test eval::meta_eval_tests::fix_comb has been running for over 60 seconds
[INFO] [stdout] test eval::meta_eval_tests::binops ... ok
[INFO] [stdout] test eval::meta_eval_tests::basic_arigh ... ok
[INFO] [stdout] test eval::meta_eval_tests::fix_fact ... test eval::meta_eval_tests::fix_fact has been running for over 60 seconds
[INFO] [stdout] test eval::meta_eval_tests::let_ ... ok
[INFO] [stdout] test eval::meta_eval_tests::list ... test eval::meta_eval_tests::list has been running for over 60 seconds
[INFO] [stdout] test eval::meta_eval_tests::multiarg_fun ... ok
[INFO] [stdout] test eval::meta_eval_tests::not ... test eval::meta_eval_tests::not has been running for over 60 seconds
[INFO] [stdout] test eval::meta_eval_tests::list ... ok
[INFO] [stdout] test eval::meta_eval_tests::polymorphic_equality ... test eval::meta_eval_tests::polymorphic_equality has been running for over 60 seconds
[INFO] [stdout] test eval::meta_eval_tests::not ... ok
[INFO] [stdout] test eval::meta_eval_tests::quoting ... test eval::meta_eval_tests::quoting has been running for over 60 seconds
[INFO] [stdout] test eval::meta_eval_tests::rec_comb ... test eval::meta_eval_tests::rec_comb has been running for over 60 seconds
[INFO] [stdout] test eval::meta_eval_tests::polymorphic_equality ... ok
[INFO] [stdout] test eval::meta_eval_tests::rec_fact ... test eval::meta_eval_tests::rec_fact has been running for over 60 seconds
[INFO] [stdout] test eval::meta_eval_tests::quoting ... ok
[INFO] [stdout] test eval::meta_eval_tests::recursive_arith ... ok
[INFO] [stdout] test eval::meta_eval_tests::self_evaluating_empty_list ... ok
[INFO] [stdout] test eval::meta_eval_tests::smoke ... ok
[INFO] [stdout] test eval::meta_eval_tests::simple_functions ... test eval::meta_eval_tests::simple_functions has been running for over 60 seconds
[INFO] [stdout] test eval::meta_eval_tests::simple_functions ... ok
[INFO] [stdout] test eval::meta_eval_tests::twice ... test eval::meta_eval_tests::twice has been running for over 60 seconds
[INFO] [stdout] test eval::meta_eval_tests::zeroarg_fun ... ok
[INFO] [stdout] test eval::special_test::fake_fn ... ok
[INFO] [stdout] test eval::special_test::invalid ... ok
[INFO] [stdout] test eval::special_test::var ... ok
[INFO] [stdout] test eval::special_test::var_arif ... ok
[INFO] [stdout] test sexpr::tests::comments ... ok
[INFO] [stdout] test sexpr::tests::parenthesis ... ok
[INFO] [stdout] test sexpr::tests::quote ... ok
[INFO] [stdout] test sexpr::tests::test_atoms ... ok
[INFO] [stdout] test eval::meta_eval_tests::twice ... ok
[INFO] [stdout] test eval::meta_eval_tests::combinator_fact ... ok
[INFO] [stdout] test eval::meta_eval_tests::fix_fact ... ok
[INFO] [stdout] test eval::meta_eval_tests::rec_fact ... ok
[ERROR] error running command: command timed out after 900 seconds
[INFO] running `"docker" "inspect" "3097bad56d5e9eb777669b112fd069f33f97f97692e6e50e0a857f7333e19601"`
[INFO] running `"docker" "rm" "-f" "3097bad56d5e9eb777669b112fd069f33f97f97692e6e50e0a857f7333e19601"`
[INFO] [stdout] 3097bad56d5e9eb777669b112fd069f33f97f97692e6e50e0a857f7333e19601