Dec 05 12:31:22.275 INFO testing nrc/s against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 05 12:31:22.275 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-3/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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"`
Dec 05 12:31:22.552 INFO [stdout] 8ae2feb4e310b449a8f964a6c46c295f84de2611eb882fdad16ebab35748f94e
Dec 05 12:31:22.558 INFO running `"docker" "start" "-a" "8ae2feb4e310b449a8f964a6c46c295f84de2611eb882fdad16ebab35748f94e"`
Dec 05 12:31:23.222 INFO [stderr] usermod: no changes
Dec 05 12:31:23.248 INFO [stderr]    Compiling s v0.0.1 (/source)
Dec 05 12:31:23.471 INFO [stderr] warning: unused macro definition
Dec 05 12:31:23.471 INFO [stderr]   --> src/parser.rs:87:1
Dec 05 12:31:23.471 INFO [stderr]    |
Dec 05 12:31:23.471 INFO [stderr] 87 | / macro_rules! program {
Dec 05 12:31:23.471 INFO [stderr] 88 | |     ($($ns: expr),*) => (::parser::Node::Program(vec![$($ns),*]))
Dec 05 12:31:23.471 INFO [stderr] 89 | | }
Dec 05 12:31:23.471 INFO [stderr]    | |_^
Dec 05 12:31:23.471 INFO [stderr]    |
Dec 05 12:31:23.471 INFO [stderr]    = note: #[warn(unused_macros)] on by default
Dec 05 12:31:23.472 INFO [stderr] 
Dec 05 12:31:23.472 INFO [stderr] warning: unused macro definition
Dec 05 12:31:23.472 INFO [stderr]   --> src/parser.rs:93:1
Dec 05 12:31:23.472 INFO [stderr]    |
Dec 05 12:31:23.472 INFO [stderr] 93 | / macro_rules! ident {
Dec 05 12:31:23.472 INFO [stderr] 94 | |     ($s: expr) => (::parser::Node::Ident(::lexer::Str::new($s)))
Dec 05 12:31:23.472 INFO [stderr] 95 | | }
Dec 05 12:31:23.472 INFO [stderr]    | |_^
Dec 05 12:31:23.472 INFO [stderr] 
Dec 05 12:31:23.472 INFO [stderr] warning: unused macro definition
Dec 05 12:31:23.472 INFO [stderr]    --> src/parser.rs:99:1
Dec 05 12:31:23.472 INFO [stderr]     |
Dec 05 12:31:23.472 INFO [stderr] 99  | / macro_rules! lit_str {
Dec 05 12:31:23.472 INFO [stderr] 100 | |     ($s: expr) => (::parser::Node::LitStr(::lexer::Str::new($s)))
Dec 05 12:31:23.472 INFO [stderr] 101 | | }
Dec 05 12:31:23.472 INFO [stderr]     | |_^
Dec 05 12:31:23.472 INFO [stderr] 
Dec 05 12:31:23.777 INFO [stderr] warning: method is never used: `new`
Dec 05 12:31:23.777 INFO [stderr]   --> src/lexer.rs:36:5
Dec 05 12:31:23.777 INFO [stderr]    |
Dec 05 12:31:23.777 INFO [stderr] 36 |     pub fn new(s: &str) -> Str {
Dec 05 12:31:23.777 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 05 12:31:23.777 INFO [stderr]    |
Dec 05 12:31:23.777 INFO [stderr]    = note: #[warn(dead_code)] on by default
Dec 05 12:31:23.777 INFO [stderr] 
Dec 05 12:31:23.777 INFO [stderr] warning: method is never used: `is_keyword`
Dec 05 12:31:23.777 INFO [stderr]   --> src/parser.rs:30:5
Dec 05 12:31:23.777 INFO [stderr]    |
Dec 05 12:31:23.777 INFO [stderr] 30 |     pub fn is_keyword(&self) -> bool {
Dec 05 12:31:23.777 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 05 12:31:23.777 INFO [stderr] 
Dec 05 12:31:23.777 INFO [stderr] warning: struct is never constructed: `NoopFolder`
Dec 05 12:31:23.777 INFO [stderr]   --> src/expand.rs:39:1
Dec 05 12:31:23.777 INFO [stderr]    |
Dec 05 12:31:23.777 INFO [stderr] 39 | pub struct NoopFolder;
Dec 05 12:31:23.777 INFO [stderr]    | ^^^^^^^^^^^^^^^^^^^^^^
Dec 05 12:31:23.777 INFO [stderr] 
Dec 05 12:31:23.777 INFO [stderr] warning: method is never used: `with_value`
Dec 05 12:31:23.777 INFO [stderr]   --> src/interpreter.rs:29:5
Dec 05 12:31:23.777 INFO [stderr]    |
Dec 05 12:31:23.777 INFO [stderr] 29 |     fn with_value(name: &str, value: Node) -> Envr {
Dec 05 12:31:23.777 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 05 12:31:23.777 INFO [stderr] 
Dec 05 12:31:24.843 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.61s
Dec 05 12:31:24.845 INFO [stderr] su: No module specific data is present
Dec 05 12:31:25.406 INFO running `"docker" "inspect" "8ae2feb4e310b449a8f964a6c46c295f84de2611eb882fdad16ebab35748f94e"`
Dec 05 12:31:25.569 INFO running `"docker" "rm" "-f" "8ae2feb4e310b449a8f964a6c46c295f84de2611eb882fdad16ebab35748f94e"`
Dec 05 12:31:25.788 INFO [stdout] 8ae2feb4e310b449a8f964a6c46c295f84de2611eb882fdad16ebab35748f94e
Dec 05 12:31:25.790 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-3/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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"`
Dec 05 12:31:26.067 INFO [stdout] 5f361e516a865b9e0d6390ab39a6324c01e112ac359344f4f876a5638bddf64b
Dec 05 12:31:26.076 INFO running `"docker" "start" "-a" "5f361e516a865b9e0d6390ab39a6324c01e112ac359344f4f876a5638bddf64b"`
Dec 05 12:31:27.030 INFO [stderr] usermod: no changes
Dec 05 12:31:27.124 INFO [stderr]    Compiling s v0.0.1 (/source)
Dec 05 12:31:28.064 INFO [stderr] warning: method is never used: `is_keyword`
Dec 05 12:31:28.064 INFO [stderr]   --> src/parser.rs:30:5
Dec 05 12:31:28.064 INFO [stderr]    |
Dec 05 12:31:28.064 INFO [stderr] 30 |     pub fn is_keyword(&self) -> bool {
Dec 05 12:31:28.064 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 05 12:31:28.064 INFO [stderr]    |
Dec 05 12:31:28.072 INFO [stderr]    = note: #[warn(dead_code)] on by default
Dec 05 12:31:28.072 INFO [stderr] 
Dec 05 12:31:29.481 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.40s
Dec 05 12:31:29.483 INFO [stderr] su: No module specific data is present
Dec 05 12:31:29.756 INFO running `"docker" "inspect" "5f361e516a865b9e0d6390ab39a6324c01e112ac359344f4f876a5638bddf64b"`
Dec 05 12:31:29.851 INFO running `"docker" "rm" "-f" "5f361e516a865b9e0d6390ab39a6324c01e112ac359344f4f876a5638bddf64b"`
Dec 05 12:31:29.922 INFO [stdout] 5f361e516a865b9e0d6390ab39a6324c01e112ac359344f4f876a5638bddf64b
Dec 05 12:31:29.928 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-3/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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"`
Dec 05 12:31:30.089 INFO [stdout] 10528b1a634ab2628db4932675a23676592c53fe2219fb4bf6170789351072ba
Dec 05 12:31:30.092 INFO running `"docker" "start" "-a" "10528b1a634ab2628db4932675a23676592c53fe2219fb4bf6170789351072ba"`
Dec 05 12:31:30.491 INFO [stderr] usermod: no changes
Dec 05 12:31:30.512 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.00s
Dec 05 12:31:30.512 INFO [stderr]      Running /target/debug/deps/s-01acf82b70b872aa
Dec 05 12:31:30.513 INFO [stdout] 
Dec 05 12:31:30.514 INFO [stdout] running 30 tests
Dec 05 12:31:30.514 INFO [stdout] test interpreter::test::test_empty ... ok
Dec 05 12:31:30.514 INFO [stdout] test expand::test::test_noop ... ok
Dec 05 12:31:30.514 INFO [stdout] test interpreter::test::test_envr_push_pop ... ok
Dec 05 12:31:30.514 INFO [stdout] test interpreter::test::test_fn_let ... ok
Dec 05 12:31:30.514 INFO [stdout] test interpreter::test::test_fn ... ok
Dec 05 12:31:30.515 INFO [stdout] test interpreter::test::test_let ... ok
Dec 05 12:31:30.515 INFO [stdout] test interpreter::test::test_ident ... ok
Dec 05 12:31:30.515 INFO [stdout] test interpreter::test::test_plus ... ok
Dec 05 12:31:30.515 INFO [stdout] test interpreter::test::test_print ... ok
Dec 05 12:31:30.515 INFO [stdout] test interpreter::test::test_s_reduce ... ok
Dec 05 12:31:30.515 INFO [stdout] test interpreter::test::test_scoped_ident ... ok
Dec 05 12:31:30.515 INFO [stdout] test interpreter::test::test_values ... ok
Dec 05 12:31:30.515 INFO [stdout] test lexer::test::test_empty ... ok
Dec 05 12:31:30.516 INFO [stdout] test lexer::test::test_single ... ok
Dec 05 12:31:30.516 INFO [stdout] test lexer::test::test_two ... ok
Dec 05 12:31:30.516 INFO [stdout] test lexer::test::test_two_ws ... ok
Dec 05 12:31:30.516 INFO [stdout] test lexer::test::test_single_ws ... ok
Dec 05 12:31:30.516 INFO [stdout] test lexer::test::test_realistic ... ok
Dec 05 12:31:30.520 INFO [stdout] test parser::test::test_empty ... ok
Dec 05 12:31:30.552 INFO [stdout] test interpreter::test::test_fn_arg_mismatch ... ok
Dec 05 12:31:30.552 INFO [stdout] test interpreter::test::test_ident_fail ... ok
Dec 05 12:31:30.553 INFO [stdout] test parser::test::test_realistic ... ok
Dec 05 12:31:30.554 INFO [stdout] test parser::test::test_simple ... ok
Dec 05 12:31:30.554 INFO [stdout] test parser::test::test_fail_unclosed2 ... ok
Dec 05 12:31:30.554 INFO [stdout] test interpreter::test::test_let_not_rec ... ok
Dec 05 12:31:30.554 INFO [stdout] test interpreter::test::test_plus_fail ... ok
Dec 05 12:31:30.554 INFO [stdout] test parser::test::test_fail_too_closed2 ... ok
Dec 05 12:31:30.556 INFO [stdout] test parser::test::test_fail_too_closed ... ok
Dec 05 12:31:30.557 INFO [stdout] test interpreter::test::test_ident_dup_fail ... ok
Dec 05 12:31:30.558 INFO [stdout] test parser::test::test_fail_unclosed ... ok
Dec 05 12:31:30.558 INFO [stdout] 
Dec 05 12:31:30.558 INFO [stdout] test result: ok. 30 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 12:31:30.558 INFO [stdout] 
Dec 05 12:31:30.559 INFO [stderr] su: No module specific data is present
Dec 05 12:31:30.930 INFO running `"docker" "inspect" "10528b1a634ab2628db4932675a23676592c53fe2219fb4bf6170789351072ba"`
Dec 05 12:31:31.173 INFO running `"docker" "rm" "-f" "10528b1a634ab2628db4932675a23676592c53fe2219fb4bf6170789351072ba"`
Dec 05 12:31:31.355 INFO [stdout] 10528b1a634ab2628db4932675a23676592c53fe2219fb4bf6170789351072ba