Dec 05 12:37:54.401 INFO testing nnarain/silica against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 05 12:37:54.401 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-7/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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:37:54.995 INFO [stdout] ac6b4d8b5fa2414bf311c9faf028ea31d83ca58bbc582566c88d967584bdf04b
Dec 05 12:37:54.997 INFO running `"docker" "start" "-a" "ac6b4d8b5fa2414bf311c9faf028ea31d83ca58bbc582566c88d967584bdf04b"`
Dec 05 12:37:56.671 INFO [stderr] usermod: no changes
Dec 05 12:37:56.832 INFO [stderr]    Compiling libc v0.2.29
Dec 05 12:37:58.098 INFO [stderr]    Compiling memchr v1.0.1
Dec 05 12:37:58.765 INFO [stderr]    Compiling aho-corasick v0.6.3
Dec 05 12:37:58.767 INFO [stderr]    Compiling nom v3.2.0
Dec 05 12:38:00.484 INFO [stderr]    Compiling regex v0.2.2
Dec 05 12:38:10.548 INFO [stderr]    Compiling docopt v0.8.1
Dec 05 12:38:17.232 INFO [stderr]    Compiling silica v0.1.0 (/source)
Dec 05 12:38:23.824 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 27.12s
Dec 05 12:38:23.841 INFO [stderr] su: No module specific data is present
Dec 05 12:38:24.494 INFO running `"docker" "inspect" "ac6b4d8b5fa2414bf311c9faf028ea31d83ca58bbc582566c88d967584bdf04b"`
Dec 05 12:38:24.758 INFO running `"docker" "rm" "-f" "ac6b4d8b5fa2414bf311c9faf028ea31d83ca58bbc582566c88d967584bdf04b"`
Dec 05 12:38:25.072 INFO [stdout] ac6b4d8b5fa2414bf311c9faf028ea31d83ca58bbc582566c88d967584bdf04b
Dec 05 12:38:25.075 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-7/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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:38:25.472 INFO [stdout] a70bc9b30e7d626fa7e5d1128bbbae93c328c20501d499ef4e2537a0f3848e81
Dec 05 12:38:25.476 INFO running `"docker" "start" "-a" "a70bc9b30e7d626fa7e5d1128bbbae93c328c20501d499ef4e2537a0f3848e81"`
Dec 05 12:38:26.512 INFO [stderr] usermod: no changes
Dec 05 12:38:26.656 INFO [stderr]    Compiling silica v0.1.0 (/source)
Dec 05 12:38:33.155 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 6.61s
Dec 05 12:38:33.163 INFO [stderr] su: No module specific data is present
Dec 05 12:38:33.846 INFO running `"docker" "inspect" "a70bc9b30e7d626fa7e5d1128bbbae93c328c20501d499ef4e2537a0f3848e81"`
Dec 05 12:38:34.090 INFO running `"docker" "rm" "-f" "a70bc9b30e7d626fa7e5d1128bbbae93c328c20501d499ef4e2537a0f3848e81"`
Dec 05 12:38:34.424 INFO [stdout] a70bc9b30e7d626fa7e5d1128bbbae93c328c20501d499ef4e2537a0f3848e81
Dec 05 12:38:34.431 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-7/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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:38:34.960 INFO [stdout] 0690c4017724475ecbf7cf331dc3380dc1f2ca544129b0fe4e696da70bf371ed
Dec 05 12:38:34.966 INFO running `"docker" "start" "-a" "0690c4017724475ecbf7cf331dc3380dc1f2ca544129b0fe4e696da70bf371ed"`
Dec 05 12:38:36.596 INFO [stderr] usermod: no changes
Dec 05 12:38:36.730 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.09s
Dec 05 12:38:36.730 INFO [stderr]      Running /target/debug/deps/silica-1f9d8e0250114af7
Dec 05 12:38:36.731 INFO [stdout] 
Dec 05 12:38:36.731 INFO [stdout] running 103 tests
Dec 05 12:38:36.731 INFO [stdout] test assembler::codegenerator::tests::test_drw ... ok
Dec 05 12:38:36.737 INFO [stdout] test assembler::codegenerator::tests::test_jp_instruction ... ok
Dec 05 12:38:36.737 INFO [stdout] test assembler::codegenerator::tests::test_db_directive ... ok
Dec 05 12:38:36.737 INFO [stdout] test assembler::codegenerator::tests::test_ld1 ... ok
Dec 05 12:38:36.737 INFO [stdout] test assembler::codegenerator::tests::test_add3 ... ok
Dec 05 12:38:36.737 INFO [stdout] test assembler::codegenerator::tests::test_and ... ok
Dec 05 12:38:36.737 INFO [stdout] test assembler::codegenerator::tests::test_add2 ... ok
Dec 05 12:38:36.737 INFO [stdout] test assembler::codegenerator::tests::test_ld4 ... ok
Dec 05 12:38:36.737 INFO [stdout] test assembler::codegenerator::tests::test_ld3 ... ok
Dec 05 12:38:36.737 INFO [stdout] test assembler::codegenerator::tests::test_ld11 ... ok
Dec 05 12:38:36.742 INFO [stdout] test assembler::codegenerator::tests::test_ld10 ... ok
Dec 05 12:38:36.742 INFO [stdout] test assembler::codegenerator::tests::test_ld7 ... ok
Dec 05 12:38:36.742 INFO [stdout] test assembler::codegenerator::tests::test_ld2 ... ok
Dec 05 12:38:36.742 INFO [stdout] test assembler::codegenerator::tests::test_ld5 ... ok
Dec 05 12:38:36.742 INFO [stdout] test assembler::codegenerator::tests::test_ld6 ... ok
Dec 05 12:38:36.743 INFO [stdout] test assembler::codegenerator::tests::test_add1 ... ok
Dec 05 12:38:36.743 INFO [stdout] test assembler::codegenerator::tests::test_ld8 ... ok
Dec 05 12:38:36.743 INFO [stdout] test assembler::codegenerator::tests::test_or ... ok
Dec 05 12:38:36.743 INFO [stdout] test assembler::codegenerator::tests::test_sh1 ... ok
Dec 05 12:38:36.743 INFO [stdout] test assembler::codegenerator::tests::test_shr ... ok
Dec 05 12:38:36.743 INFO [stdout] test assembler::codegenerator::tests::test_sknp ... ok
Dec 05 12:38:36.743 INFO [stdout] test assembler::codegenerator::tests::test_rnd ... ok
Dec 05 12:38:36.743 INFO [stdout] test assembler::codegenerator::tests::test_ld_i_addr ... ok
Dec 05 12:38:36.743 INFO [stdout] test assembler::codegenerator::tests::test_ld9 ... ok
Dec 05 12:38:36.746 INFO [stdout] test assembler::codegenerator::tests::test_sub ... ok
Dec 05 12:38:36.746 INFO [stdout] test assembler::lexer::tests::test_lex_comma ... ok
Dec 05 12:38:36.746 INFO [stdout] test assembler::lexer::tests::test_lex_comments ... ok
Dec 05 12:38:36.746 INFO [stdout] test assembler::lexer::tests::test_lex_decimal_literal ... ok
Dec 05 12:38:36.746 INFO [stdout] test assembler::lexer::tests::test_lex_directives ... ok
Dec 05 12:38:36.746 INFO [stdout] test assembler::lexer::tests::test_lex_hex_literal ... ok
Dec 05 12:38:36.746 INFO [stdout] test assembler::lexer::tests::test_lex_instruction1 ... ok
Dec 05 12:38:36.746 INFO [stdout] test assembler::lexer::tests::test_lex_instruction2 ... ok
Dec 05 12:38:36.746 INFO [stdout] test assembler::lexer::tests::test_lex_instruction3 ... ok
Dec 05 12:38:36.746 INFO [stdout] test assembler::lexer::tests::test_lex_instruction4 ... ok
Dec 05 12:38:36.746 INFO [stdout] test assembler::lexer::tests::test_lex_instruction5 ... ok
Dec 05 12:38:36.746 INFO [stdout] test assembler::lexer::tests::test_lex_instruction6 ... ok
Dec 05 12:38:36.746 INFO [stdout] test assembler::lexer::tests::test_lex_label ... ok
Dec 05 12:38:36.746 INFO [stdout] test assembler::lexer::tests::test_lex_line1_crlf ... ok
Dec 05 12:38:36.746 INFO [stdout] test assembler::lexer::tests::test_lex_line1_lf ... ok
Dec 05 12:38:36.746 INFO [stdout] test assembler::lexer::tests::test_lex_line3 ... ok
Dec 05 12:38:36.746 INFO [stdout] test assembler::lexer::tests::test_lex_line4 ... ok
Dec 05 12:38:36.746 INFO [stdout] test assembler::lexer::tests::test_lex_line5 ... ok
Dec 05 12:38:36.746 INFO [stdout] test assembler::lexer::tests::test_lex_line6 ... ok
Dec 05 12:38:36.746 INFO [stdout] test assembler::lexer::tests::test_lex_line7 ... ok
Dec 05 12:38:36.746 INFO [stdout] test assembler::lexer::tests::test_lex_line_ending_crlf ... ok
Dec 05 12:38:36.746 INFO [stdout] test assembler::lexer::tests::test_lex_line_ending_lf ... ok
Dec 05 12:38:36.746 INFO [stdout] test assembler::lexer::tests::test_lex_line_termination1 ... ok
Dec 05 12:38:36.746 INFO [stdout] test assembler::lexer::tests::test_lex_line_termination2 ... ok
Dec 05 12:38:36.746 INFO [stdout] test assembler::lexer::tests::test_lex_line_termination3 ... ok
Dec 05 12:38:36.746 INFO [stdout] test assembler::lexer::tests::test_lex_lines1 ... ok
Dec 05 12:38:36.746 INFO [stdout] test assembler::lexer::tests::test_lex_lines2 ... ok
Dec 05 12:38:36.746 INFO [stdout] test assembler::lexer::tests::test_lex_lines3 ... ok
Dec 05 12:38:36.746 INFO [stdout] test assembler::lexer::tests::test_lex_lines4 ... ok
Dec 05 12:38:36.746 INFO [stdout] test assembler::lexer::tests::test_lex_lines5 ... ok
Dec 05 12:38:36.746 INFO [stdout] test assembler::lexer::tests::test_lex_mnem ... ok
Dec 05 12:38:36.746 INFO [stdout] test assembler::lexer::tests::test_lex_numeric_literal_parse_decimal ... ok
Dec 05 12:38:36.752 INFO [stdout] test assembler::lexer::tests::test_lex_numeric_literal_parse_hex ... ok
Dec 05 12:38:36.752 INFO [stdout] test assembler::lexer::tests::test_lex_registers ... ok
Dec 05 12:38:36.752 INFO [stdout] test assembler::parser::tests::test_parse1 ... ok
Dec 05 12:38:36.752 INFO [stdout] test assembler::parser::tests::test_parse2 ... ok
Dec 05 12:38:36.752 INFO [stdout] test assembler::parser::tests::test_parse_directive1 ... ok
Dec 05 12:38:36.752 INFO [stdout] test assembler::parser::tests::test_parse_directive2 ... ok
Dec 05 12:38:36.752 INFO [stdout] test assembler::parser::tests::test_parse_instruction1 ... ok
Dec 05 12:38:36.752 INFO [stdout] test assembler::parser::tests::test_parse_instruction2 ... ok
Dec 05 12:38:36.752 INFO [stdout] test assembler::parser::tests::test_parse_instruction3 ... ok
Dec 05 12:38:36.752 INFO [stdout] test assembler::parser::tests::test_parse_instruction4 ... ok
Dec 05 12:38:36.752 INFO [stdout] test assembler::parser::tests::test_parse_instruction5 ... ok
Dec 05 12:38:36.752 INFO [stdout] test assembler::parser::tests::test_parse_label ... ok
Dec 05 12:38:36.752 INFO [stdout] test assembler::semantics::tests::test_check_add1 ... ok
Dec 05 12:38:36.752 INFO [stdout] test assembler::semantics::tests::test_check_add2 ... ok
Dec 05 12:38:36.752 INFO [stdout] test assembler::semantics::tests::test_check_and ... ok
Dec 05 12:38:36.752 INFO [stdout] test assembler::semantics::tests::test_check_directive ... ok
Dec 05 12:38:36.753 INFO [stdout] test assembler::codegenerator::tests::test_subn ... ok
Dec 05 12:38:36.753 INFO [stdout] test assembler::lexer::tests::test_label_operand ... ok
Dec 05 12:38:36.753 INFO [stdout] test assembler::lexer::tests::test_lex_column_sep_parse_all ... ok
Dec 05 12:38:36.753 INFO [stdout] test assembler::lexer::tests::test_lex_column_sep_parse_until ... ok
Dec 05 12:38:36.753 INFO [stdout] test assembler::codegenerator::tests::test_skp ... ok
Dec 05 12:38:36.756 INFO [stdout] test assembler::lexer::tests::test_lex_blank_line ... ok
Dec 05 12:38:36.756 INFO [stdout] test assembler::codegenerator::tests::test_xor ... ok
Dec 05 12:38:36.760 INFO [stdout] test assembler::semantics::tests::test_check_drw ... ok
Dec 05 12:38:36.760 INFO [stdout] test assembler::semantics::tests::test_check_instruction1 ... ok
Dec 05 12:38:36.760 INFO [stdout] test assembler::semantics::tests::test_check_jr ... ok
Dec 05 12:38:36.764 INFO [stdout] test assembler::semantics::tests::test_check_jp1 ... ok
Dec 05 12:38:36.764 INFO [stdout] test assembler::semantics::tests::test_check_ld1 ... ok
Dec 05 12:38:36.764 INFO [stdout] test assembler::semantics::tests::test_check_label ... ok
Dec 05 12:38:36.764 INFO [stdout] test assembler::semantics::tests::test_check_ld2 ... ok
Dec 05 12:38:36.764 INFO [stdout] test assembler::semantics::tests::test_check_or ... ok
Dec 05 12:38:36.764 INFO [stdout] test assembler::semantics::tests::test_check_rnd ... ok
Dec 05 12:38:36.764 INFO [stdout] test assembler::semantics::tests::test_check_se1 ... ok
Dec 05 12:38:36.772 INFO [stdout] test assembler::semantics::tests::test_check_se2 ... ok
Dec 05 12:38:36.780 INFO [stdout] test assembler::semantics::tests::test_check_shl ... ok
Dec 05 12:38:36.780 INFO [stdout] test assembler::semantics::tests::test_check_skp ... ok
Dec 05 12:38:36.780 INFO [stdout] test assembler::semantics::tests::test_check_shr ... ok
Dec 05 12:38:36.780 INFO [stdout] test assembler::semantics::tests::test_check_sknp ... ok
Dec 05 12:38:36.780 INFO [stdout] test assembler::semantics::tests::test_check_sne1 ... ok
Dec 05 12:38:36.780 INFO [stdout] test assembler::semantics::tests::test_check_sne2 ... ok
Dec 05 12:38:36.780 INFO [stdout] test assembler::semantics::tests::test_check_xor ... ok
Dec 05 12:38:36.788 INFO [stdout] test assembler::semantics::tests::test_check_sub ... ok
Dec 05 12:38:36.788 INFO [stdout] test assembler::semantics::tests::test_check_subn ... ok
Dec 05 12:38:36.849 INFO [stdout] test assembler::semantics::tests::test_check_jp2 ... ok
Dec 05 12:38:36.849 INFO [stdout] test assembler::semantics::tests::test_check_directive_invalid_operand ... ok
Dec 05 12:38:36.849 INFO [stdout] test assembler::semantics::tests::test_check_directive_only ... ok
Dec 05 12:38:36.855 INFO [stdout] test assembler::semantics::tests::test_check_instruction2 ... ok
Dec 05 12:38:36.855 INFO [stdout] 
Dec 05 12:38:36.855 INFO [stdout] test result: ok. 103 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 12:38:36.855 INFO [stdout] 
Dec 05 12:38:36.860 INFO [stderr]      Running /target/debug/deps/silica-096639bc41dc3be8
Dec 05 12:38:36.866 INFO [stdout] 
Dec 05 12:38:36.866 INFO [stdout] running 0 tests
Dec 05 12:38:36.866 INFO [stdout] 
Dec 05 12:38:36.866 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 12:38:36.866 INFO [stdout] 
Dec 05 12:38:36.867 INFO [stderr]      Running /target/debug/deps/assembler_tests-22885ac37e9510be
Dec 05 12:38:36.872 INFO [stdout] 
Dec 05 12:38:36.873 INFO [stdout] running 0 tests
Dec 05 12:38:36.873 INFO [stdout] 
Dec 05 12:38:36.873 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 12:38:36.873 INFO [stdout] 
Dec 05 12:38:36.879 INFO [stderr]    Doc-tests silica
Dec 05 12:38:37.808 INFO [stdout] 
Dec 05 12:38:37.808 INFO [stdout] running 0 tests
Dec 05 12:38:37.808 INFO [stdout] 
Dec 05 12:38:37.808 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 12:38:37.808 INFO [stdout] 
Dec 05 12:38:37.815 INFO [stderr] su: No module specific data is present
Dec 05 12:38:38.864 INFO running `"docker" "inspect" "0690c4017724475ecbf7cf331dc3380dc1f2ca544129b0fe4e696da70bf371ed"`
Dec 05 12:38:39.174 INFO running `"docker" "rm" "-f" "0690c4017724475ecbf7cf331dc3380dc1f2ca544129b0fe4e696da70bf371ed"`
Dec 05 12:38:39.568 INFO [stdout] 0690c4017724475ecbf7cf331dc3380dc1f2ca544129b0fe4e696da70bf371ed