Nov 16 17:52:19.856 INFO testing nrc/s against try#2e026d6e5d7621634147ad4c8074f1d964dbb1be for pr-55982
Nov 16 17:52:19.856 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +2e026d6e5d7621634147ad4c8074f1d964dbb1be-alt build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Nov 16 17:52:20.401 INFO [stdout] e9e03d35561faeec05a8dc356d549816db0079a36b875d221dc003737a8f5d71
Nov 16 17:52:20.407 INFO running `"docker" "start" "-a" "e9e03d35561faeec05a8dc356d549816db0079a36b875d221dc003737a8f5d71"`
Nov 16 17:52:21.456 INFO [stderr] usermod: no changes
Nov 16 17:52:21.498 INFO [stderr]    Compiling s v0.0.1 (/source)
Nov 16 17:52:21.739 INFO [stderr] warning: unused macro definition
Nov 16 17:52:21.739 INFO [stderr]   --> src/parser.rs:87:1
Nov 16 17:52:21.739 INFO [stderr]    |
Nov 16 17:52:21.739 INFO [stderr] 87 | / macro_rules! program {
Nov 16 17:52:21.739 INFO [stderr] 88 | |     ($($ns: expr),*) => (::parser::Node::Program(vec![$($ns),*]))
Nov 16 17:52:21.739 INFO [stderr] 89 | | }
Nov 16 17:52:21.739 INFO [stderr]    | |_^
Nov 16 17:52:21.740 INFO [stderr]    |
Nov 16 17:52:21.740 INFO [stderr]    = note: #[warn(unused_macros)] on by default
Nov 16 17:52:21.740 INFO [stderr] 
Nov 16 17:52:21.740 INFO [stderr] warning: unused macro definition
Nov 16 17:52:21.740 INFO [stderr]   --> src/parser.rs:93:1
Nov 16 17:52:21.740 INFO [stderr]    |
Nov 16 17:52:21.740 INFO [stderr] 93 | / macro_rules! ident {
Nov 16 17:52:21.740 INFO [stderr] 94 | |     ($s: expr) => (::parser::Node::Ident(::lexer::Str::new($s)))
Nov 16 17:52:21.740 INFO [stderr] 95 | | }
Nov 16 17:52:21.740 INFO [stderr]    | |_^
Nov 16 17:52:21.740 INFO [stderr] 
Nov 16 17:52:21.740 INFO [stderr] warning: unused macro definition
Nov 16 17:52:21.740 INFO [stderr]    --> src/parser.rs:99:1
Nov 16 17:52:21.740 INFO [stderr]     |
Nov 16 17:52:21.740 INFO [stderr] 99  | / macro_rules! lit_str {
Nov 16 17:52:21.740 INFO [stderr] 100 | |     ($s: expr) => (::parser::Node::LitStr(::lexer::Str::new($s)))
Nov 16 17:52:21.740 INFO [stderr] 101 | | }
Nov 16 17:52:21.740 INFO [stderr]     | |_^
Nov 16 17:52:21.740 INFO [stderr] 
Nov 16 17:52:22.036 INFO [stderr] warning: method is never used: `new`
Nov 16 17:52:22.036 INFO [stderr]   --> src/lexer.rs:36:5
Nov 16 17:52:22.036 INFO [stderr]    |
Nov 16 17:52:22.037 INFO [stderr] 36 |     pub fn new(s: &str) -> Str {
Nov 16 17:52:22.037 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 17:52:22.038 INFO [stderr]    |
Nov 16 17:52:22.038 INFO [stderr]    = note: #[warn(dead_code)] on by default
Nov 16 17:52:22.038 INFO [stderr] 
Nov 16 17:52:22.039 INFO [stderr] warning: method is never used: `is_keyword`
Nov 16 17:52:22.039 INFO [stderr]   --> src/parser.rs:30:5
Nov 16 17:52:22.040 INFO [stderr]    |
Nov 16 17:52:22.040 INFO [stderr] 30 |     pub fn is_keyword(&self) -> bool {
Nov 16 17:52:22.041 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 17:52:22.041 INFO [stderr] 
Nov 16 17:52:22.041 INFO [stderr] warning: struct is never constructed: `NoopFolder`
Nov 16 17:52:22.041 INFO [stderr]   --> src/expand.rs:39:1
Nov 16 17:52:22.043 INFO [stderr]    |
Nov 16 17:52:22.046 INFO [stderr] 39 | pub struct NoopFolder;
Nov 16 17:52:22.046 INFO [stderr]    | ^^^^^^^^^^^^^^^^^^^^^^
Nov 16 17:52:22.047 INFO [stderr] 
Nov 16 17:52:22.047 INFO [stderr] warning: method is never used: `with_value`
Nov 16 17:52:22.047 INFO [stderr]   --> src/interpreter.rs:29:5
Nov 16 17:52:22.048 INFO [stderr]    |
Nov 16 17:52:22.048 INFO [stderr] 29 |     fn with_value(name: &str, value: Node) -> Envr {
Nov 16 17:52:22.048 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 17:52:22.049 INFO [stderr] 
Nov 16 17:52:23.835 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.34s
Nov 16 17:52:23.835 INFO [stderr] su: No module specific data is present
Nov 16 17:52:24.630 INFO running `"docker" "inspect" "e9e03d35561faeec05a8dc356d549816db0079a36b875d221dc003737a8f5d71"`
Nov 16 17:52:24.913 INFO running `"docker" "rm" "-f" "e9e03d35561faeec05a8dc356d549816db0079a36b875d221dc003737a8f5d71"`
Nov 16 17:52:25.159 INFO [stdout] e9e03d35561faeec05a8dc356d549816db0079a36b875d221dc003737a8f5d71
Nov 16 17:52:25.160 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +2e026d6e5d7621634147ad4c8074f1d964dbb1be-alt test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Nov 16 17:52:25.506 INFO [stdout] f91c7351503a59d5a722521780e91f2cedb79f6a361622d66cc15b5131ad0afa
Nov 16 17:52:25.508 INFO running `"docker" "start" "-a" "f91c7351503a59d5a722521780e91f2cedb79f6a361622d66cc15b5131ad0afa"`
Nov 16 17:52:26.178 INFO [stderr] usermod: no changes
Nov 16 17:52:26.222 INFO [stderr]    Compiling s v0.0.1 (/source)
Nov 16 17:52:27.027 INFO [stderr] warning: method is never used: `is_keyword`
Nov 16 17:52:27.027 INFO [stderr]   --> src/parser.rs:30:5
Nov 16 17:52:27.027 INFO [stderr]    |
Nov 16 17:52:27.027 INFO [stderr] 30 |     pub fn is_keyword(&self) -> bool {
Nov 16 17:52:27.027 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 17:52:27.027 INFO [stderr]    |
Nov 16 17:52:27.027 INFO [stderr]    = note: #[warn(dead_code)] on by default
Nov 16 17:52:27.027 INFO [stderr] 
Nov 16 17:52:28.419 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.21s
Nov 16 17:52:28.419 INFO [stderr] su: No module specific data is present
Nov 16 17:52:28.834 INFO running `"docker" "inspect" "f91c7351503a59d5a722521780e91f2cedb79f6a361622d66cc15b5131ad0afa"`
Nov 16 17:52:29.068 INFO running `"docker" "rm" "-f" "f91c7351503a59d5a722521780e91f2cedb79f6a361622d66cc15b5131ad0afa"`
Nov 16 17:52:29.356 INFO [stdout] f91c7351503a59d5a722521780e91f2cedb79f6a361622d66cc15b5131ad0afa
Nov 16 17:52:29.362 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +2e026d6e5d7621634147ad4c8074f1d964dbb1be-alt test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Nov 16 17:52:29.737 INFO [stdout] 6a672d5507a74db5dc1e5971a307cc5467ca5db08e21545c062da7468dd3e9c6
Nov 16 17:52:29.738 INFO running `"docker" "start" "-a" "6a672d5507a74db5dc1e5971a307cc5467ca5db08e21545c062da7468dd3e9c6"`
Nov 16 17:52:30.687 INFO [stderr] usermod: no changes
Nov 16 17:52:30.730 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.02s
Nov 16 17:52:30.731 INFO [stderr]      Running /target/debug/deps/s-3a5a113f02202353
Nov 16 17:52:30.735 INFO [stdout] 
Nov 16 17:52:30.735 INFO [stdout] running 30 tests
Nov 16 17:52:30.735 INFO [stdout] test interpreter::test::test_fn_let ... ok
Nov 16 17:52:30.739 INFO [stdout] test interpreter::test::test_fn ... ok
Nov 16 17:52:30.739 INFO [stdout] test interpreter::test::test_envr_push_pop ... ok
Nov 16 17:52:30.744 INFO [stdout] test interpreter::test::test_ident ... ok
Nov 16 17:52:30.744 INFO [stdout] test expand::test::test_noop ... ok
Nov 16 17:52:30.744 INFO [stdout] test interpreter::test::test_empty ... ok
Nov 16 17:52:30.755 INFO [stdout] test interpreter::test::test_let ... ok
Nov 16 17:52:30.755 INFO [stdout] test interpreter::test::test_print ... ok
Nov 16 17:52:30.755 INFO [stdout] test interpreter::test::test_plus ... ok
Nov 16 17:52:30.755 INFO [stdout] test interpreter::test::test_values ... ok
Nov 16 17:52:30.755 INFO [stdout] test lexer::test::test_empty ... ok
Nov 16 17:52:30.755 INFO [stdout] test lexer::test::test_realistic ... ok
Nov 16 17:52:30.755 INFO [stdout] test lexer::test::test_single ... ok
Nov 16 17:52:30.755 INFO [stdout] test lexer::test::test_single_ws ... ok
Nov 16 17:52:30.755 INFO [stdout] test lexer::test::test_two ... ok
Nov 16 17:52:30.755 INFO [stdout] test lexer::test::test_two_ws ... ok
Nov 16 17:52:30.755 INFO [stdout] test parser::test::test_empty ... ok
Nov 16 17:52:30.765 INFO [stdout] test interpreter::test::test_s_reduce ... ok
Nov 16 17:52:30.765 INFO [stdout] test interpreter::test::test_scoped_ident ... ok
Nov 16 17:52:30.819 INFO [stdout] test interpreter::test::test_ident_fail ... ok
Nov 16 17:52:30.819 INFO [stdout] test interpreter::test::test_fn_arg_mismatch ... ok
Nov 16 17:52:30.819 INFO [stdout] test parser::test::test_fail_unclosed2 ... ok
Nov 16 17:52:30.820 INFO [stdout] test parser::test::test_realistic ... ok
Nov 16 17:52:30.828 INFO [stdout] test interpreter::test::test_let_not_rec ... ok
Nov 16 17:52:30.828 INFO [stdout] test parser::test::test_simple ... ok
Nov 16 17:52:30.828 INFO [stdout] test interpreter::test::test_ident_dup_fail ... ok
Nov 16 17:52:30.828 INFO [stdout] test interpreter::test::test_plus_fail ... ok
Nov 16 17:52:30.828 INFO [stdout] test parser::test::test_fail_too_closed ... ok
Nov 16 17:52:30.828 INFO [stdout] test parser::test::test_fail_too_closed2 ... ok
Nov 16 17:52:30.835 INFO [stdout] test parser::test::test_fail_unclosed ... ok
Nov 16 17:52:30.836 INFO [stdout] 
Nov 16 17:52:30.836 INFO [stdout] test result: ok. 30 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 17:52:30.836 INFO [stdout] 
Nov 16 17:52:30.836 INFO [stderr] su: No module specific data is present
Nov 16 17:52:31.425 INFO running `"docker" "inspect" "6a672d5507a74db5dc1e5971a307cc5467ca5db08e21545c062da7468dd3e9c6"`
Nov 16 17:52:31.751 INFO running `"docker" "rm" "-f" "6a672d5507a74db5dc1e5971a307cc5467ca5db08e21545c062da7468dd3e9c6"`
Nov 16 17:52:32.021 INFO [stdout] 6a672d5507a74db5dc1e5971a307cc5467ca5db08e21545c062da7468dd3e9c6