Dec 05 12:37:50.226 INFO testing nnarain/silica against try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468 for pr-56514
Dec 05 12:37:50.226 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-1/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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:50.714 INFO [stdout] 312e4fbadc1a2fb603bdbbb2c308a551ac75ee5a3f03236cc304f36858fb947b
Dec 05 12:37:50.722 INFO running `"docker" "start" "-a" "312e4fbadc1a2fb603bdbbb2c308a551ac75ee5a3f03236cc304f36858fb947b"`
Dec 05 12:37:52.775 INFO [stderr] usermod: no changes
Dec 05 12:37:52.932 INFO [stderr]    Compiling nom v3.2.0
Dec 05 12:37:52.932 INFO [stderr]    Compiling docopt v0.8.1
Dec 05 12:38:02.241 INFO [stderr]    Compiling silica v0.1.0 (/source)
Dec 05 12:38:08.960 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 16.16s
Dec 05 12:38:08.976 INFO [stderr] su: No module specific data is present
Dec 05 12:38:09.737 INFO running `"docker" "inspect" "312e4fbadc1a2fb603bdbbb2c308a551ac75ee5a3f03236cc304f36858fb947b"`
Dec 05 12:38:10.000 INFO running `"docker" "rm" "-f" "312e4fbadc1a2fb603bdbbb2c308a551ac75ee5a3f03236cc304f36858fb947b"`
Dec 05 12:38:10.302 INFO [stdout] 312e4fbadc1a2fb603bdbbb2c308a551ac75ee5a3f03236cc304f36858fb947b
Dec 05 12:38:10.306 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-1/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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:10.815 INFO [stdout] 70a3dd30cd85d685cba74e3845baaa6602e261362ca70f47b4821b9f42f94c40
Dec 05 12:38:10.818 INFO running `"docker" "start" "-a" "70a3dd30cd85d685cba74e3845baaa6602e261362ca70f47b4821b9f42f94c40"`
Dec 05 12:38:12.307 INFO [stderr] usermod: no changes
Dec 05 12:38:12.413 INFO [stderr]    Compiling silica v0.1.0 (/source)
Dec 05 12:38:20.138 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 7.80s
Dec 05 12:38:20.143 INFO [stderr] su: No module specific data is present
Dec 05 12:38:21.781 INFO running `"docker" "inspect" "70a3dd30cd85d685cba74e3845baaa6602e261362ca70f47b4821b9f42f94c40"`
Dec 05 12:38:22.078 INFO running `"docker" "rm" "-f" "70a3dd30cd85d685cba74e3845baaa6602e261362ca70f47b4821b9f42f94c40"`
Dec 05 12:38:22.352 INFO [stdout] 70a3dd30cd85d685cba74e3845baaa6602e261362ca70f47b4821b9f42f94c40
Dec 05 12:38:22.356 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-1/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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:22.724 INFO [stdout] d592cc6648f72f0af1a435b798157d650efef2beb2df39958d16e079a9e565b7
Dec 05 12:38:22.732 INFO running `"docker" "start" "-a" "d592cc6648f72f0af1a435b798157d650efef2beb2df39958d16e079a9e565b7"`
Dec 05 12:38:23.689 INFO [stderr] usermod: no changes
Dec 05 12:38:23.756 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.04s
Dec 05 12:38:23.769 INFO [stderr]      Running /target/debug/deps/silica-325c38a37ea2af33
Dec 05 12:38:23.772 INFO [stdout] 
Dec 05 12:38:23.772 INFO [stdout] running 103 tests
Dec 05 12:38:23.797 INFO [stdout] test assembler::codegenerator::tests::test_add2 ... ok
Dec 05 12:38:23.798 INFO [stdout] test assembler::codegenerator::tests::test_add3 ... ok
Dec 05 12:38:23.798 INFO [stdout] test assembler::codegenerator::tests::test_and ... ok
Dec 05 12:38:23.798 INFO [stdout] test assembler::codegenerator::tests::test_add1 ... ok
Dec 05 12:38:23.798 INFO [stdout] test assembler::codegenerator::tests::test_db_directive ... ok
Dec 05 12:38:23.800 INFO [stdout] test assembler::codegenerator::tests::test_ld3 ... ok
Dec 05 12:38:23.800 INFO [stdout] test assembler::codegenerator::tests::test_ld1 ... ok
Dec 05 12:38:23.800 INFO [stdout] test assembler::codegenerator::tests::test_ld11 ... ok
Dec 05 12:38:23.800 INFO [stdout] test assembler::codegenerator::tests::test_jp_instruction ... ok
Dec 05 12:38:23.804 INFO [stdout] test assembler::codegenerator::tests::test_ld4 ... ok
Dec 05 12:38:23.804 INFO [stdout] test assembler::codegenerator::tests::test_ld2 ... ok
Dec 05 12:38:23.804 INFO [stdout] test assembler::codegenerator::tests::test_ld10 ... ok
Dec 05 12:38:23.804 INFO [stdout] test assembler::codegenerator::tests::test_ld9 ... ok
Dec 05 12:38:23.804 INFO [stdout] test assembler::codegenerator::tests::test_ld_i_addr ... ok
Dec 05 12:38:23.804 INFO [stdout] test assembler::codegenerator::tests::test_ld8 ... ok
Dec 05 12:38:23.804 INFO [stdout] test assembler::codegenerator::tests::test_ld7 ... ok
Dec 05 12:38:23.804 INFO [stdout] test assembler::codegenerator::tests::test_or ... ok
Dec 05 12:38:23.804 INFO [stdout] test assembler::codegenerator::tests::test_ld6 ... ok
Dec 05 12:38:23.804 INFO [stdout] test assembler::codegenerator::tests::test_drw ... ok
Dec 05 12:38:23.804 INFO [stdout] test assembler::codegenerator::tests::test_rnd ... ok
Dec 05 12:38:23.804 INFO [stdout] test assembler::codegenerator::tests::test_ld5 ... ok
Dec 05 12:38:23.804 INFO [stdout] test assembler::codegenerator::tests::test_subn ... ok
Dec 05 12:38:23.804 INFO [stdout] test assembler::codegenerator::tests::test_skp ... ok
Dec 05 12:38:23.804 INFO [stdout] test assembler::codegenerator::tests::test_sub ... ok
Dec 05 12:38:23.804 INFO [stdout] test assembler::codegenerator::tests::test_xor ... ok
Dec 05 12:38:23.804 INFO [stdout] test assembler::lexer::tests::test_label_operand ... ok
Dec 05 12:38:23.804 INFO [stdout] test assembler::lexer::tests::test_lex_blank_line ... ok
Dec 05 12:38:23.804 INFO [stdout] test assembler::lexer::tests::test_lex_column_sep_parse_all ... ok
Dec 05 12:38:23.805 INFO [stdout] test assembler::lexer::tests::test_lex_column_sep_parse_until ... ok
Dec 05 12:38:23.806 INFO [stdout] test assembler::lexer::tests::test_lex_decimal_literal ... ok
Dec 05 12:38:23.806 INFO [stdout] test assembler::lexer::tests::test_lex_directives ... ok
Dec 05 12:38:23.806 INFO [stdout] test assembler::lexer::tests::test_lex_comments ... ok
Dec 05 12:38:23.808 INFO [stdout] test assembler::lexer::tests::test_lex_comma ... ok
Dec 05 12:38:23.816 INFO [stdout] test assembler::lexer::tests::test_lex_hex_literal ... ok
Dec 05 12:38:23.820 INFO [stdout] test assembler::codegenerator::tests::test_sh1 ... ok
Dec 05 12:38:23.831 INFO [stdout] test assembler::codegenerator::tests::test_shr ... ok
Dec 05 12:38:23.833 INFO [stdout] test assembler::codegenerator::tests::test_sknp ... ok
Dec 05 12:38:23.833 INFO [stdout] test assembler::lexer::tests::test_lex_instruction1 ... ok
Dec 05 12:38:23.833 INFO [stdout] test assembler::lexer::tests::test_lex_line1_lf ... ok
Dec 05 12:38:23.836 INFO [stdout] test assembler::lexer::tests::test_lex_line3 ... ok
Dec 05 12:38:23.836 INFO [stdout] test assembler::lexer::tests::test_lex_line4 ... ok
Dec 05 12:38:23.836 INFO [stdout] test assembler::lexer::tests::test_lex_label ... ok
Dec 05 12:38:23.840 INFO [stdout] test assembler::lexer::tests::test_lex_instruction2 ... ok
Dec 05 12:38:23.840 INFO [stdout] test assembler::lexer::tests::test_lex_instruction5 ... ok
Dec 05 12:38:23.840 INFO [stdout] test assembler::lexer::tests::test_lex_instruction3 ... ok
Dec 05 12:38:23.840 INFO [stdout] test assembler::lexer::tests::test_lex_instruction4 ... ok
Dec 05 12:38:23.840 INFO [stdout] test assembler::lexer::tests::test_lex_instruction6 ... ok
Dec 05 12:38:23.840 INFO [stdout] test assembler::lexer::tests::test_lex_line1_crlf ... ok
Dec 05 12:38:23.840 INFO [stdout] test assembler::lexer::tests::test_lex_line5 ... ok
Dec 05 12:38:23.840 INFO [stdout] test assembler::lexer::tests::test_lex_line_ending_lf ... ok
Dec 05 12:38:23.840 INFO [stdout] test assembler::lexer::tests::test_lex_line_termination1 ... ok
Dec 05 12:38:23.840 INFO [stdout] test assembler::lexer::tests::test_lex_line_termination2 ... ok
Dec 05 12:38:23.840 INFO [stdout] test assembler::lexer::tests::test_lex_line_termination3 ... ok
Dec 05 12:38:23.840 INFO [stdout] test assembler::lexer::tests::test_lex_lines1 ... ok
Dec 05 12:38:23.841 INFO [stdout] test assembler::lexer::tests::test_lex_line_ending_crlf ... ok
Dec 05 12:38:23.841 INFO [stdout] test assembler::lexer::tests::test_lex_line7 ... ok
Dec 05 12:38:23.841 INFO [stdout] test assembler::lexer::tests::test_lex_lines2 ... ok
Dec 05 12:38:23.841 INFO [stdout] test assembler::lexer::tests::test_lex_lines3 ... ok
Dec 05 12:38:23.841 INFO [stdout] test assembler::lexer::tests::test_lex_lines4 ... ok
Dec 05 12:38:23.841 INFO [stdout] test assembler::lexer::tests::test_lex_lines5 ... ok
Dec 05 12:38:23.841 INFO [stdout] test assembler::lexer::tests::test_lex_mnem ... ok
Dec 05 12:38:23.841 INFO [stdout] test assembler::lexer::tests::test_lex_numeric_literal_parse_decimal ... ok
Dec 05 12:38:23.841 INFO [stdout] test assembler::lexer::tests::test_lex_numeric_literal_parse_hex ... ok
Dec 05 12:38:23.841 INFO [stdout] test assembler::lexer::tests::test_lex_registers ... ok
Dec 05 12:38:23.841 INFO [stdout] test assembler::parser::tests::test_parse1 ... ok
Dec 05 12:38:23.841 INFO [stdout] test assembler::parser::tests::test_parse2 ... ok
Dec 05 12:38:23.841 INFO [stdout] test assembler::parser::tests::test_parse_directive1 ... ok
Dec 05 12:38:23.841 INFO [stdout] test assembler::parser::tests::test_parse_directive2 ... ok
Dec 05 12:38:23.841 INFO [stdout] test assembler::parser::tests::test_parse_instruction1 ... ok
Dec 05 12:38:23.841 INFO [stdout] test assembler::parser::tests::test_parse_instruction2 ... ok
Dec 05 12:38:23.841 INFO [stdout] test assembler::parser::tests::test_parse_instruction3 ... ok
Dec 05 12:38:23.841 INFO [stdout] test assembler::parser::tests::test_parse_instruction4 ... ok
Dec 05 12:38:23.841 INFO [stdout] test assembler::parser::tests::test_parse_instruction5 ... ok
Dec 05 12:38:23.841 INFO [stdout] test assembler::parser::tests::test_parse_label ... ok
Dec 05 12:38:23.841 INFO [stdout] test assembler::semantics::tests::test_check_add1 ... ok
Dec 05 12:38:23.841 INFO [stdout] test assembler::semantics::tests::test_check_add2 ... ok
Dec 05 12:38:23.841 INFO [stdout] test assembler::semantics::tests::test_check_and ... ok
Dec 05 12:38:23.841 INFO [stdout] test assembler::semantics::tests::test_check_directive ... ok
Dec 05 12:38:23.847 INFO [stdout] test assembler::lexer::tests::test_lex_line6 ... ok
Dec 05 12:38:23.848 INFO [stdout] test assembler::semantics::tests::test_check_drw ... ok
Dec 05 12:38:23.848 INFO [stdout] test assembler::semantics::tests::test_check_instruction1 ... ok
Dec 05 12:38:23.848 INFO [stdout] test assembler::semantics::tests::test_check_jp1 ... ok
Dec 05 12:38:23.848 INFO [stdout] test assembler::semantics::tests::test_check_jr ... ok
Dec 05 12:38:23.848 INFO [stdout] test assembler::semantics::tests::test_check_ld1 ... ok
Dec 05 12:38:23.848 INFO [stdout] test assembler::semantics::tests::test_check_label ... ok
Dec 05 12:38:23.848 INFO [stdout] test assembler::semantics::tests::test_check_ld2 ... ok
Dec 05 12:38:23.848 INFO [stdout] test assembler::semantics::tests::test_check_or ... ok
Dec 05 12:38:23.848 INFO [stdout] test assembler::semantics::tests::test_check_rnd ... ok
Dec 05 12:38:23.849 INFO [stdout] test assembler::semantics::tests::test_check_se1 ... ok
Dec 05 12:38:23.849 INFO [stdout] test assembler::semantics::tests::test_check_se2 ... ok
Dec 05 12:38:23.849 INFO [stdout] test assembler::semantics::tests::test_check_shl ... ok
Dec 05 12:38:23.849 INFO [stdout] test assembler::semantics::tests::test_check_shr ... ok
Dec 05 12:38:23.849 INFO [stdout] test assembler::semantics::tests::test_check_sknp ... ok
Dec 05 12:38:23.849 INFO [stdout] test assembler::semantics::tests::test_check_skp ... ok
Dec 05 12:38:23.849 INFO [stdout] test assembler::semantics::tests::test_check_sne1 ... ok
Dec 05 12:38:23.849 INFO [stdout] test assembler::semantics::tests::test_check_sne2 ... ok
Dec 05 12:38:23.849 INFO [stdout] test assembler::semantics::tests::test_check_sub ... ok
Dec 05 12:38:23.849 INFO [stdout] test assembler::semantics::tests::test_check_subn ... ok
Dec 05 12:38:23.849 INFO [stdout] test assembler::semantics::tests::test_check_xor ... ok
Dec 05 12:38:23.972 INFO [stdout] test assembler::semantics::tests::test_check_directive_invalid_operand ... ok
Dec 05 12:38:23.980 INFO [stdout] test assembler::semantics::tests::test_check_directive_only ... ok
Dec 05 12:38:23.980 INFO [stderr]      Running /target/debug/deps/silica-afc1e01c2e8c8b8d
Dec 05 12:38:23.980 INFO [stdout] test assembler::semantics::tests::test_check_instruction2 ... ok
Dec 05 12:38:23.980 INFO [stdout] test assembler::semantics::tests::test_check_jp2 ... ok
Dec 05 12:38:23.980 INFO [stdout] 
Dec 05 12:38:23.980 INFO [stdout] test result: ok. 103 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 12:38:23.980 INFO [stdout] 
Dec 05 12:38:23.986 INFO [stdout] 
Dec 05 12:38:23.986 INFO [stderr]      Running /target/debug/deps/assembler_tests-e240b01b1060128a
Dec 05 12:38:23.986 INFO [stdout] running 0 tests
Dec 05 12:38:23.986 INFO [stdout] 
Dec 05 12:38:23.986 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 12:38:23.986 INFO [stdout] 
Dec 05 12:38:23.999 INFO [stdout] 
Dec 05 12:38:23.999 INFO [stderr]    Doc-tests silica
Dec 05 12:38:23.999 INFO [stdout] running 0 tests
Dec 05 12:38:23.999 INFO [stdout] 
Dec 05 12:38:23.999 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 12:38:23.999 INFO [stdout] 
Dec 05 12:38:24.861 INFO [stdout] 
Dec 05 12:38:24.861 INFO [stdout] running 0 tests
Dec 05 12:38:24.861 INFO [stdout] 
Dec 05 12:38:24.861 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 12:38:24.861 INFO [stdout] 
Dec 05 12:38:24.867 INFO [stderr] su: No module specific data is present
Dec 05 12:38:25.423 INFO running `"docker" "inspect" "d592cc6648f72f0af1a435b798157d650efef2beb2df39958d16e079a9e565b7"`
Dec 05 12:38:25.582 INFO running `"docker" "rm" "-f" "d592cc6648f72f0af1a435b798157d650efef2beb2df39958d16e079a9e565b7"`
Dec 05 12:38:25.892 INFO [stdout] d592cc6648f72f0af1a435b798157d650efef2beb2df39958d16e079a9e565b7