Nov 16 17:52:20.422 INFO testing nrc/s against master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c for pr-55982
Nov 16 17:52:20.424 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-7/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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.884 INFO [stdout] a105b1ba601e4baa8fe158cedf4f5f1f9c4bc43014f174fe9fc2ca011b5913e1
Nov 16 17:52:20.892 INFO running `"docker" "start" "-a" "a105b1ba601e4baa8fe158cedf4f5f1f9c4bc43014f174fe9fc2ca011b5913e1"`
Nov 16 17:52:21.790 INFO [stderr] usermod: no changes
Nov 16 17:52:21.832 INFO [stderr]    Compiling s v0.0.1 (/source)
Nov 16 17:52:22.107 INFO [stderr] warning: unused macro definition
Nov 16 17:52:22.107 INFO [stderr]   --> src/parser.rs:87:1
Nov 16 17:52:22.107 INFO [stderr]    |
Nov 16 17:52:22.107 INFO [stderr] 87 | / macro_rules! program {
Nov 16 17:52:22.107 INFO [stderr] 88 | |     ($($ns: expr),*) => (::parser::Node::Program(vec![$($ns),*]))
Nov 16 17:52:22.107 INFO [stderr] 89 | | }
Nov 16 17:52:22.107 INFO [stderr]    | |_^
Nov 16 17:52:22.107 INFO [stderr]    |
Nov 16 17:52:22.107 INFO [stderr]    = note: #[warn(unused_macros)] on by default
Nov 16 17:52:22.107 INFO [stderr] 
Nov 16 17:52:22.107 INFO [stderr] warning: unused macro definition
Nov 16 17:52:22.107 INFO [stderr]   --> src/parser.rs:93:1
Nov 16 17:52:22.107 INFO [stderr]    |
Nov 16 17:52:22.107 INFO [stderr] 93 | / macro_rules! ident {
Nov 16 17:52:22.107 INFO [stderr] 94 | |     ($s: expr) => (::parser::Node::Ident(::lexer::Str::new($s)))
Nov 16 17:52:22.107 INFO [stderr] 95 | | }
Nov 16 17:52:22.107 INFO [stderr]    | |_^
Nov 16 17:52:22.107 INFO [stderr] 
Nov 16 17:52:22.107 INFO [stderr] warning: unused macro definition
Nov 16 17:52:22.107 INFO [stderr]    --> src/parser.rs:99:1
Nov 16 17:52:22.107 INFO [stderr]     |
Nov 16 17:52:22.107 INFO [stderr] 99  | / macro_rules! lit_str {
Nov 16 17:52:22.107 INFO [stderr] 100 | |     ($s: expr) => (::parser::Node::LitStr(::lexer::Str::new($s)))
Nov 16 17:52:22.107 INFO [stderr] 101 | | }
Nov 16 17:52:22.107 INFO [stderr]     | |_^
Nov 16 17:52:22.107 INFO [stderr] 
Nov 16 17:52:22.411 INFO [stderr] warning: method is never used: `new`
Nov 16 17:52:22.412 INFO [stderr]   --> src/lexer.rs:36:5
Nov 16 17:52:22.412 INFO [stderr]    |
Nov 16 17:52:22.412 INFO [stderr] 36 |     pub fn new(s: &str) -> Str {
Nov 16 17:52:22.412 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 17:52:22.412 INFO [stderr]    |
Nov 16 17:52:22.413 INFO [stderr]    = note: #[warn(dead_code)] on by default
Nov 16 17:52:22.413 INFO [stderr] 
Nov 16 17:52:22.413 INFO [stderr] warning: method is never used: `is_keyword`
Nov 16 17:52:22.413 INFO [stderr]   --> src/parser.rs:30:5
Nov 16 17:52:22.414 INFO [stderr]    |
Nov 16 17:52:22.414 INFO [stderr] 30 |     pub fn is_keyword(&self) -> bool {
Nov 16 17:52:22.414 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 17:52:22.414 INFO [stderr] 
Nov 16 17:52:22.414 INFO [stderr] warning: struct is never constructed: `NoopFolder`
Nov 16 17:52:22.415 INFO [stderr]   --> src/expand.rs:39:1
Nov 16 17:52:22.415 INFO [stderr]    |
Nov 16 17:52:22.415 INFO [stderr] 39 | pub struct NoopFolder;
Nov 16 17:52:22.415 INFO [stderr]    | ^^^^^^^^^^^^^^^^^^^^^^
Nov 16 17:52:22.415 INFO [stderr] 
Nov 16 17:52:22.416 INFO [stderr] warning: method is never used: `with_value`
Nov 16 17:52:22.416 INFO [stderr]   --> src/interpreter.rs:29:5
Nov 16 17:52:22.416 INFO [stderr]    |
Nov 16 17:52:22.416 INFO [stderr] 29 |     fn with_value(name: &str, value: Node) -> Envr {
Nov 16 17:52:22.417 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 17:52:22.417 INFO [stderr] 
Nov 16 17:52:23.979 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.16s
Nov 16 17:52:23.987 INFO [stderr] su: No module specific data is present
Nov 16 17:52:24.631 INFO running `"docker" "inspect" "a105b1ba601e4baa8fe158cedf4f5f1f9c4bc43014f174fe9fc2ca011b5913e1"`
Nov 16 17:52:24.912 INFO running `"docker" "rm" "-f" "a105b1ba601e4baa8fe158cedf4f5f1f9c4bc43014f174fe9fc2ca011b5913e1"`
Nov 16 17:52:25.111 INFO [stdout] a105b1ba601e4baa8fe158cedf4f5f1f9c4bc43014f174fe9fc2ca011b5913e1
Nov 16 17:52:25.114 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-7/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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.475 INFO [stdout] e7251bc95eae32a114aabd3b7f28c3a2cd96c5a2585af48b0460e4f0c5843de3
Nov 16 17:52:25.487 INFO running `"docker" "start" "-a" "e7251bc95eae32a114aabd3b7f28c3a2cd96c5a2585af48b0460e4f0c5843de3"`
Nov 16 17:52:26.423 INFO [stderr] usermod: no changes
Nov 16 17:52:26.467 INFO [stderr]    Compiling s v0.0.1 (/source)
Nov 16 17:52:27.219 INFO [stderr] warning: method is never used: `is_keyword`
Nov 16 17:52:27.219 INFO [stderr]   --> src/parser.rs:30:5
Nov 16 17:52:27.220 INFO [stderr]    |
Nov 16 17:52:27.220 INFO [stderr] 30 |     pub fn is_keyword(&self) -> bool {
Nov 16 17:52:27.220 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 17:52:27.221 INFO [stderr]    |
Nov 16 17:52:27.221 INFO [stderr]    = note: #[warn(dead_code)] on by default
Nov 16 17:52:27.221 INFO [stderr] 
Nov 16 17:52:28.724 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.27s
Nov 16 17:52:28.731 INFO [stderr] su: No module specific data is present
Nov 16 17:52:29.341 INFO running `"docker" "inspect" "e7251bc95eae32a114aabd3b7f28c3a2cd96c5a2585af48b0460e4f0c5843de3"`
Nov 16 17:52:29.559 INFO running `"docker" "rm" "-f" "e7251bc95eae32a114aabd3b7f28c3a2cd96c5a2585af48b0460e4f0c5843de3"`
Nov 16 17:52:29.782 INFO [stdout] e7251bc95eae32a114aabd3b7f28c3a2cd96c5a2585af48b0460e4f0c5843de3
Nov 16 17:52:29.782 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-7/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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:30.339 INFO [stdout] d174790aaf694f26c5bc35dbdf94f6023f7f20f6e7a69c55262a68c69f0c989a
Nov 16 17:52:30.341 INFO running `"docker" "start" "-a" "d174790aaf694f26c5bc35dbdf94f6023f7f20f6e7a69c55262a68c69f0c989a"`
Nov 16 17:52:31.607 INFO [stderr] usermod: no changes
Nov 16 17:52:31.643 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.01s
Nov 16 17:52:31.655 INFO [stderr]      Running /target/debug/deps/s-91791e419eeb6f21
Nov 16 17:52:31.659 INFO [stdout] 
Nov 16 17:52:31.659 INFO [stdout] running 30 tests
Nov 16 17:52:31.667 INFO [stdout] test interpreter::test::test_empty ... ok
Nov 16 17:52:31.667 INFO [stdout] test expand::test::test_noop ... ok
Nov 16 17:52:31.667 INFO [stdout] test interpreter::test::test_envr_push_pop ... ok
Nov 16 17:52:31.679 INFO [stdout] test interpreter::test::test_let ... ok
Nov 16 17:52:31.679 INFO [stdout] test interpreter::test::test_ident ... ok
Nov 16 17:52:31.679 INFO [stdout] test interpreter::test::test_fn_let ... ok
Nov 16 17:52:31.683 INFO [stdout] test interpreter::test::test_print ... ok
Nov 16 17:52:31.683 INFO [stdout] test interpreter::test::test_fn ... ok
Nov 16 17:52:31.691 INFO [stdout] test interpreter::test::test_scoped_ident ... ok
Nov 16 17:52:31.691 INFO [stdout] test interpreter::test::test_s_reduce ... ok
Nov 16 17:52:31.691 INFO [stdout] test interpreter::test::test_plus ... ok
Nov 16 17:52:31.703 INFO [stdout] test lexer::test::test_realistic ... ok
Nov 16 17:52:31.703 INFO [stdout] test lexer::test::test_empty ... ok
Nov 16 17:52:31.703 INFO [stdout] test interpreter::test::test_values ... ok
Nov 16 17:52:31.703 INFO [stdout] test lexer::test::test_single ... ok
Nov 16 17:52:31.703 INFO [stdout] test lexer::test::test_single_ws ... ok
Nov 16 17:52:31.703 INFO [stdout] test lexer::test::test_two ... ok
Nov 16 17:52:31.710 INFO [stdout] test parser::test::test_empty ... ok
Nov 16 17:52:31.710 INFO [stdout] test lexer::test::test_two_ws ... ok
Nov 16 17:52:31.779 INFO [stdout] test interpreter::test::test_ident_fail ... ok
Nov 16 17:52:31.779 INFO [stdout] test interpreter::test::test_fn_arg_mismatch ... ok
Nov 16 17:52:31.779 INFO [stdout] test interpreter::test::test_let_not_rec ... ok
Nov 16 17:52:31.787 INFO [stdout] test interpreter::test::test_ident_dup_fail ... ok
Nov 16 17:52:31.787 INFO [stdout] test interpreter::test::test_plus_fail ... ok
Nov 16 17:52:31.787 INFO [stdout] test parser::test::test_simple ... ok
Nov 16 17:52:31.787 INFO [stdout] test parser::test::test_fail_too_closed ... ok
Nov 16 17:52:31.787 INFO [stdout] test parser::test::test_fail_too_closed2 ... ok
Nov 16 17:52:31.787 INFO [stdout] test parser::test::test_fail_unclosed ... ok
Nov 16 17:52:31.787 INFO [stdout] test parser::test::test_fail_unclosed2 ... ok
Nov 16 17:52:31.787 INFO [stdout] test parser::test::test_realistic ... ok
Nov 16 17:52:31.787 INFO [stdout] 
Nov 16 17:52:31.787 INFO [stdout] test result: ok. 30 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 17:52:31.787 INFO [stdout] 
Nov 16 17:52:31.799 INFO [stderr] su: No module specific data is present
Nov 16 17:52:32.360 INFO running `"docker" "inspect" "d174790aaf694f26c5bc35dbdf94f6023f7f20f6e7a69c55262a68c69f0c989a"`
Nov 16 17:52:32.827 INFO running `"docker" "rm" "-f" "d174790aaf694f26c5bc35dbdf94f6023f7f20f6e7a69c55262a68c69f0c989a"`
Nov 16 17:52:33.250 INFO [stdout] d174790aaf694f26c5bc35dbdf94f6023f7f20f6e7a69c55262a68c69f0c989a