Nov 16 17:59:23.984 INFO testing nnarain/silica against try#2e026d6e5d7621634147ad4c8074f1d964dbb1be for pr-55982
Nov 16 17:59:23.986 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-7/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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:59:24.440 INFO [stdout] dac1007f1375aa78d0d73542b8470dcbc833c4b03f6ec2ce12b6a9868c2aca1f
Nov 16 17:59:24.443 INFO running `"docker" "start" "-a" "dac1007f1375aa78d0d73542b8470dcbc833c4b03f6ec2ce12b6a9868c2aca1f"`
Nov 16 17:59:25.514 INFO [stderr] usermod: no changes
Nov 16 17:59:25.667 INFO [stderr]    Compiling nom v3.2.0
Nov 16 17:59:25.667 INFO [stderr]    Compiling docopt v0.8.1
Nov 16 17:59:35.095 INFO [stderr]    Compiling silica v0.1.0 (/source)
Nov 16 17:59:41.842 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 16.29s
Nov 16 17:59:41.848 INFO [stderr] su: No module specific data is present
Nov 16 17:59:42.915 INFO running `"docker" "inspect" "dac1007f1375aa78d0d73542b8470dcbc833c4b03f6ec2ce12b6a9868c2aca1f"`
Nov 16 17:59:43.241 INFO running `"docker" "rm" "-f" "dac1007f1375aa78d0d73542b8470dcbc833c4b03f6ec2ce12b6a9868c2aca1f"`
Nov 16 17:59:43.438 INFO [stdout] dac1007f1375aa78d0d73542b8470dcbc833c4b03f6ec2ce12b6a9868c2aca1f
Nov 16 17:59:43.445 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-7/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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:59:44.031 INFO [stdout] 3f5286080ab727c002cf6f1cf84ee4501a0fbc1742bfcb198b14080dc3f4ccac
Nov 16 17:59:44.039 INFO running `"docker" "start" "-a" "3f5286080ab727c002cf6f1cf84ee4501a0fbc1742bfcb198b14080dc3f4ccac"`
Nov 16 17:59:44.979 INFO [stderr] usermod: no changes
Nov 16 17:59:45.143 INFO [stderr]    Compiling silica v0.1.0 (/source)
Nov 16 17:59:51.035 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 6.02s
Nov 16 17:59:51.036 INFO [stderr] su: No module specific data is present
Nov 16 17:59:51.625 INFO running `"docker" "inspect" "3f5286080ab727c002cf6f1cf84ee4501a0fbc1742bfcb198b14080dc3f4ccac"`
Nov 16 17:59:51.885 INFO running `"docker" "rm" "-f" "3f5286080ab727c002cf6f1cf84ee4501a0fbc1742bfcb198b14080dc3f4ccac"`
Nov 16 17:59:52.146 INFO [stdout] 3f5286080ab727c002cf6f1cf84ee4501a0fbc1742bfcb198b14080dc3f4ccac
Nov 16 17:59:52.152 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-7/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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:59:52.535 INFO [stdout] 374acfba7d54a66363b7eb87a339f0aeb5ed30c0faac086061ebe652f80e22b1
Nov 16 17:59:52.543 INFO running `"docker" "start" "-a" "374acfba7d54a66363b7eb87a339f0aeb5ed30c0faac086061ebe652f80e22b1"`
Nov 16 17:59:54.067 INFO [stderr] usermod: no changes
Nov 16 17:59:54.155 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.05s
Nov 16 17:59:54.159 INFO [stderr]      Running /target/debug/deps/silica-c7ccaecb72e9ec7d
Nov 16 17:59:54.167 INFO [stdout] 
Nov 16 17:59:54.167 INFO [stdout] running 103 tests
Nov 16 17:59:54.168 INFO [stdout] test assembler::codegenerator::tests::test_add2 ... ok
Nov 16 17:59:54.168 INFO [stdout] test assembler::codegenerator::tests::test_add1 ... ok
Nov 16 17:59:54.168 INFO [stdout] test assembler::codegenerator::tests::test_ld11 ... ok
Nov 16 17:59:54.168 INFO [stdout] test assembler::codegenerator::tests::test_ld10 ... ok
Nov 16 17:59:54.168 INFO [stdout] test assembler::codegenerator::tests::test_jp_instruction ... ok
Nov 16 17:59:54.179 INFO [stdout] test assembler::codegenerator::tests::test_ld3 ... ok
Nov 16 17:59:54.183 INFO [stdout] test assembler::codegenerator::tests::test_drw ... ok
Nov 16 17:59:54.183 INFO [stdout] test assembler::codegenerator::tests::test_ld1 ... ok
Nov 16 17:59:54.197 INFO [stdout] test assembler::codegenerator::tests::test_ld2 ... ok
Nov 16 17:59:54.197 INFO [stdout] test assembler::codegenerator::tests::test_ld6 ... ok
Nov 16 17:59:54.197 INFO [stdout] test assembler::codegenerator::tests::test_add3 ... ok
Nov 16 17:59:54.198 INFO [stdout] test assembler::codegenerator::tests::test_ld5 ... ok
Nov 16 17:59:54.198 INFO [stdout] test assembler::codegenerator::tests::test_db_directive ... ok
Nov 16 17:59:54.198 INFO [stdout] test assembler::codegenerator::tests::test_and ... ok
Nov 16 17:59:54.198 INFO [stdout] test assembler::codegenerator::tests::test_ld4 ... ok
Nov 16 17:59:54.199 INFO [stdout] test assembler::codegenerator::tests::test_sh1 ... ok
Nov 16 17:59:54.199 INFO [stdout] test assembler::codegenerator::tests::test_rnd ... ok
Nov 16 17:59:54.199 INFO [stdout] test assembler::codegenerator::tests::test_sknp ... ok
Nov 16 17:59:54.199 INFO [stdout] test assembler::codegenerator::tests::test_skp ... ok
Nov 16 17:59:54.199 INFO [stdout] test assembler::codegenerator::tests::test_sub ... ok
Nov 16 17:59:54.200 INFO [stdout] test assembler::codegenerator::tests::test_subn ... ok
Nov 16 17:59:54.200 INFO [stdout] test assembler::codegenerator::tests::test_xor ... ok
Nov 16 17:59:54.200 INFO [stdout] test assembler::lexer::tests::test_label_operand ... ok
Nov 16 17:59:54.200 INFO [stdout] test assembler::lexer::tests::test_lex_blank_line ... ok
Nov 16 17:59:54.200 INFO [stdout] test assembler::lexer::tests::test_lex_column_sep_parse_all ... ok
Nov 16 17:59:54.201 INFO [stdout] test assembler::lexer::tests::test_lex_column_sep_parse_until ... ok
Nov 16 17:59:54.201 INFO [stdout] test assembler::lexer::tests::test_lex_comma ... ok
Nov 16 17:59:54.201 INFO [stdout] test assembler::lexer::tests::test_lex_comments ... ok
Nov 16 17:59:54.201 INFO [stdout] test assembler::lexer::tests::test_lex_decimal_literal ... ok
Nov 16 17:59:54.202 INFO [stdout] test assembler::lexer::tests::test_lex_hex_literal ... ok
Nov 16 17:59:54.202 INFO [stdout] test assembler::lexer::tests::test_lex_directives ... ok
Nov 16 17:59:54.202 INFO [stdout] test assembler::lexer::tests::test_lex_instruction1 ... ok
Nov 16 17:59:54.202 INFO [stdout] test assembler::lexer::tests::test_lex_instruction2 ... ok
Nov 16 17:59:54.203 INFO [stdout] test assembler::lexer::tests::test_lex_instruction3 ... ok
Nov 16 17:59:54.203 INFO [stdout] test assembler::lexer::tests::test_lex_instruction4 ... ok
Nov 16 17:59:54.203 INFO [stdout] test assembler::lexer::tests::test_lex_instruction5 ... ok
Nov 16 17:59:54.203 INFO [stdout] test assembler::lexer::tests::test_lex_instruction6 ... ok
Nov 16 17:59:54.203 INFO [stdout] test assembler::lexer::tests::test_lex_label ... ok
Nov 16 17:59:54.204 INFO [stdout] test assembler::lexer::tests::test_lex_line1_crlf ... ok
Nov 16 17:59:54.204 INFO [stdout] test assembler::lexer::tests::test_lex_line1_lf ... ok
Nov 16 17:59:54.204 INFO [stdout] test assembler::lexer::tests::test_lex_line3 ... ok
Nov 16 17:59:54.204 INFO [stdout] test assembler::lexer::tests::test_lex_line4 ... ok
Nov 16 17:59:54.205 INFO [stdout] test assembler::lexer::tests::test_lex_line5 ... ok
Nov 16 17:59:54.205 INFO [stdout] test assembler::lexer::tests::test_lex_line6 ... ok
Nov 16 17:59:54.205 INFO [stdout] test assembler::lexer::tests::test_lex_line7 ... ok
Nov 16 17:59:54.205 INFO [stdout] test assembler::lexer::tests::test_lex_line_ending_crlf ... ok
Nov 16 17:59:54.205 INFO [stdout] test assembler::lexer::tests::test_lex_line_ending_lf ... ok
Nov 16 17:59:54.206 INFO [stdout] test assembler::lexer::tests::test_lex_line_termination1 ... ok
Nov 16 17:59:54.206 INFO [stdout] test assembler::lexer::tests::test_lex_line_termination2 ... ok
Nov 16 17:59:54.206 INFO [stdout] test assembler::lexer::tests::test_lex_line_termination3 ... ok
Nov 16 17:59:54.206 INFO [stdout] test assembler::lexer::tests::test_lex_lines1 ... ok
Nov 16 17:59:54.207 INFO [stdout] test assembler::lexer::tests::test_lex_lines2 ... ok
Nov 16 17:59:54.207 INFO [stdout] test assembler::lexer::tests::test_lex_lines3 ... ok
Nov 16 17:59:54.207 INFO [stdout] test assembler::lexer::tests::test_lex_lines4 ... ok
Nov 16 17:59:54.208 INFO [stdout] test assembler::lexer::tests::test_lex_lines5 ... ok
Nov 16 17:59:54.208 INFO [stdout] test assembler::lexer::tests::test_lex_mnem ... ok
Nov 16 17:59:54.208 INFO [stdout] test assembler::lexer::tests::test_lex_numeric_literal_parse_decimal ... ok
Nov 16 17:59:54.209 INFO [stdout] test assembler::lexer::tests::test_lex_numeric_literal_parse_hex ... ok
Nov 16 17:59:54.209 INFO [stdout] test assembler::codegenerator::tests::test_shr ... ok
Nov 16 17:59:54.209 INFO [stdout] test assembler::lexer::tests::test_lex_registers ... ok
Nov 16 17:59:54.209 INFO [stdout] test assembler::codegenerator::tests::test_ld9 ... ok
Nov 16 17:59:54.210 INFO [stdout] test assembler::codegenerator::tests::test_or ... ok
Nov 16 17:59:54.210 INFO [stdout] test assembler::parser::tests::test_parse1 ... ok
Nov 16 17:59:54.210 INFO [stdout] test assembler::parser::tests::test_parse_directive1 ... ok
Nov 16 17:59:54.211 INFO [stdout] test assembler::parser::tests::test_parse_directive2 ... ok
Nov 16 17:59:54.211 INFO [stdout] test assembler::parser::tests::test_parse_instruction3 ... ok
Nov 16 17:59:54.212 INFO [stdout] test assembler::parser::tests::test_parse_instruction2 ... ok
Nov 16 17:59:54.212 INFO [stdout] test assembler::parser::tests::test_parse_instruction1 ... ok
Nov 16 17:59:54.212 INFO [stdout] test assembler::parser::tests::test_parse_instruction4 ... ok
Nov 16 17:59:54.212 INFO [stdout] test assembler::parser::tests::test_parse_instruction5 ... ok
Nov 16 17:59:54.213 INFO [stdout] test assembler::parser::tests::test_parse_label ... ok
Nov 16 17:59:54.213 INFO [stdout] test assembler::semantics::tests::test_check_add1 ... ok
Nov 16 17:59:54.213 INFO [stdout] test assembler::semantics::tests::test_check_add2 ... ok
Nov 16 17:59:54.214 INFO [stdout] test assembler::parser::tests::test_parse2 ... ok
Nov 16 17:59:54.214 INFO [stdout] test assembler::semantics::tests::test_check_and ... ok
Nov 16 17:59:54.216 INFO [stdout] test assembler::semantics::tests::test_check_directive ... ok
Nov 16 17:59:54.216 INFO [stdout] test assembler::semantics::tests::test_check_drw ... ok
Nov 16 17:59:54.217 INFO [stdout] test assembler::semantics::tests::test_check_instruction1 ... ok
Nov 16 17:59:54.217 INFO [stdout] test assembler::codegenerator::tests::test_ld8 ... ok
Nov 16 17:59:54.217 INFO [stdout] test assembler::codegenerator::tests::test_ld_i_addr ... ok
Nov 16 17:59:54.218 INFO [stdout] test assembler::codegenerator::tests::test_ld7 ... ok
Nov 16 17:59:54.227 INFO [stdout] test assembler::semantics::tests::test_check_label ... ok
Nov 16 17:59:54.227 INFO [stdout] test assembler::semantics::tests::test_check_ld1 ... ok
Nov 16 17:59:54.228 INFO [stdout] test assembler::semantics::tests::test_check_jr ... ok
Nov 16 17:59:54.228 INFO [stdout] test assembler::semantics::tests::test_check_jp1 ... ok
Nov 16 17:59:54.228 INFO [stdout] test assembler::semantics::tests::test_check_rnd ... ok
Nov 16 17:59:54.229 INFO [stdout] test assembler::semantics::tests::test_check_se1 ... ok
Nov 16 17:59:54.229 INFO [stdout] test assembler::semantics::tests::test_check_or ... ok
Nov 16 17:59:54.229 INFO [stdout] test assembler::semantics::tests::test_check_se2 ... ok
Nov 16 17:59:54.229 INFO [stdout] test assembler::semantics::tests::test_check_shl ... ok
Nov 16 17:59:54.230 INFO [stdout] test assembler::semantics::tests::test_check_shr ... ok
Nov 16 17:59:54.230 INFO [stdout] test assembler::semantics::tests::test_check_sknp ... ok
Nov 16 17:59:54.231 INFO [stdout] test assembler::semantics::tests::test_check_skp ... ok
Nov 16 17:59:54.231 INFO [stdout] test assembler::semantics::tests::test_check_sne1 ... ok
Nov 16 17:59:54.239 INFO [stdout] test assembler::semantics::tests::test_check_sne2 ... ok
Nov 16 17:59:54.239 INFO [stdout] test assembler::semantics::tests::test_check_ld2 ... ok
Nov 16 17:59:54.240 INFO [stdout] test assembler::semantics::tests::test_check_sub ... ok
Nov 16 17:59:54.240 INFO [stdout] test assembler::semantics::tests::test_check_subn ... ok
Nov 16 17:59:54.240 INFO [stdout] test assembler::semantics::tests::test_check_xor ... ok
Nov 16 17:59:54.347 INFO [stdout] test assembler::semantics::tests::test_check_directive_invalid_operand ... ok
Nov 16 17:59:54.348 INFO [stdout] test assembler::semantics::tests::test_check_jp2 ... ok
Nov 16 17:59:54.348 INFO [stdout] test assembler::semantics::tests::test_check_instruction2 ... ok
Nov 16 17:59:54.348 INFO [stdout] test assembler::semantics::tests::test_check_directive_only ... ok
Nov 16 17:59:54.349 INFO [stdout] 
Nov 16 17:59:54.349 INFO [stdout] test result: ok. 103 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 17:59:54.349 INFO [stdout] 
Nov 16 17:59:54.350 INFO [stderr]      Running /target/debug/deps/silica-5c990a71ec8b5cb8
Nov 16 17:59:54.352 INFO [stdout] 
Nov 16 17:59:54.352 INFO [stdout] running 0 tests
Nov 16 17:59:54.352 INFO [stdout] 
Nov 16 17:59:54.352 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 17:59:54.352 INFO [stdout] 
Nov 16 17:59:54.353 INFO [stderr]      Running /target/debug/deps/assembler_tests-562619d29146048f
Nov 16 17:59:54.354 INFO [stdout] 
Nov 16 17:59:54.354 INFO [stdout] running 0 tests
Nov 16 17:59:54.355 INFO [stdout] 
Nov 16 17:59:54.355 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 17:59:54.355 INFO [stdout] 
Nov 16 17:59:54.356 INFO [stderr]    Doc-tests silica
Nov 16 17:59:55.303 INFO [stdout] 
Nov 16 17:59:55.304 INFO [stdout] running 0 tests
Nov 16 17:59:55.304 INFO [stdout] 
Nov 16 17:59:55.304 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 17:59:55.304 INFO [stdout] 
Nov 16 17:59:55.306 INFO [stderr] su: No module specific data is present
Nov 16 17:59:56.080 INFO running `"docker" "inspect" "374acfba7d54a66363b7eb87a339f0aeb5ed30c0faac086061ebe652f80e22b1"`
Nov 16 17:59:56.412 INFO running `"docker" "rm" "-f" "374acfba7d54a66363b7eb87a339f0aeb5ed30c0faac086061ebe652f80e22b1"`
Nov 16 17:59:56.674 INFO [stdout] 374acfba7d54a66363b7eb87a339f0aeb5ed30c0faac086061ebe652f80e22b1