Oct 12 23:09:47.714 INFO testing starrhorne/nes-rust against try#40d4795669493f1965de7c44029c69552134fe1f for rustdoc-test-static-cling-1
Oct 12 23:09:47.714 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-7/try#40d4795669493f1965de7c44029c69552134fe1f:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-7/rustdoc-test-static-cling-1/try#40d4795669493f1965de7c44029c69552134fe1f:/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 +40d4795669493f1965de7c44029c69552134fe1f-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"`
Oct 12 23:09:48.344 INFO blam! 4fde0d31c0ba7f28e4052e1d54b5cc1fc7d4e7b91df5da33963f53bc78f9ecf5
Oct 12 23:09:48.344 INFO running `"docker" "start" "-a" "4fde0d31c0ba7f28e4052e1d54b5cc1fc7d4e7b91df5da33963f53bc78f9ecf5"`
Oct 12 23:09:50.858 INFO kablam! usermod: no changes
Oct 12 23:09:50.943 INFO kablam!    Compiling either v1.1.0
Oct 12 23:09:50.943 INFO kablam!    Compiling bitfield v0.12.0
Oct 12 23:09:50.943 INFO kablam!    Compiling libretro-sys v0.1.0
Oct 12 23:09:50.943 INFO kablam!    Compiling time v0.1.39
Oct 12 23:09:50.943 INFO kablam!    Compiling rand v0.3.17
Oct 12 23:09:52.071 INFO kablam!    Compiling itertools v0.6.1
Oct 12 23:09:54.527 INFO kablam!    Compiling libretro-backend v0.2.1
Oct 12 23:09:56.408 INFO kablam!    Compiling nes v0.1.0 (/source)
Oct 12 23:09:59.129 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 8.25s
Oct 12 23:09:59.139 INFO kablam! su: No module specific data is present
Oct 12 23:09:59.935 INFO running `"docker" "rm" "-f" "4fde0d31c0ba7f28e4052e1d54b5cc1fc7d4e7b91df5da33963f53bc78f9ecf5"`
Oct 12 23:10:00.347 INFO blam! 4fde0d31c0ba7f28e4052e1d54b5cc1fc7d4e7b91df5da33963f53bc78f9ecf5
Oct 12 23:10:00.361 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-7/try#40d4795669493f1965de7c44029c69552134fe1f:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-7/rustdoc-test-static-cling-1/try#40d4795669493f1965de7c44029c69552134fe1f:/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 +40d4795669493f1965de7c44029c69552134fe1f-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"`
Oct 12 23:10:00.815 INFO blam! 7942e5cd56b0d6c611fcb00f599bec6ae2aeec8974bef2205a6aec025d127845
Oct 12 23:10:00.827 INFO running `"docker" "start" "-a" "7942e5cd56b0d6c611fcb00f599bec6ae2aeec8974bef2205a6aec025d127845"`
Oct 12 23:10:02.326 INFO kablam! usermod: no changes
Oct 12 23:10:02.451 INFO kablam!    Compiling nes v0.1.0 (/source)
Oct 12 23:10:03.963 INFO kablam! warning: unused import: `apu::Apu`
Oct 12 23:10:03.963 INFO kablam!  --> src/./cpu_test.rs:3:5
Oct 12 23:10:03.963 INFO kablam!   |
Oct 12 23:10:03.963 INFO kablam! 3 | use apu::Apu;
Oct 12 23:10:03.963 INFO kablam!   |     ^^^^^^^^
Oct 12 23:10:03.963 INFO kablam!   |
Oct 12 23:10:03.963 INFO kablam!   = note: #[warn(unused_imports)] on by default
Oct 12 23:10:03.963 INFO kablam! 
Oct 12 23:10:03.963 INFO kablam! warning: unused import: `ppu::Ppu`
Oct 12 23:10:03.963 INFO kablam!  --> src/./cpu_test.rs:6:5
Oct 12 23:10:03.963 INFO kablam!   |
Oct 12 23:10:03.963 INFO kablam! 6 | use ppu::Ppu;
Oct 12 23:10:03.963 INFO kablam!   |     ^^^^^^^^
Oct 12 23:10:03.963 INFO kablam! 
Oct 12 23:10:03.963 INFO kablam! warning: unused macro definition
Oct 12 23:10:03.963 INFO kablam!   --> src/./cpu_test.rs:44:1
Oct 12 23:10:03.963 INFO kablam!    |
Oct 12 23:10:03.963 INFO kablam! 44 | / macro_rules! build_cpu_and_run {
Oct 12 23:10:03.963 INFO kablam! 45 | |     ($instruction:expr, $mode:ident, $bytes:expr) => {
Oct 12 23:10:03.963 INFO kablam! 46 | |         {
Oct 12 23:10:03.963 INFO kablam! 47 | |             let op = opcode($instruction, $mode);
Oct 12 23:10:03.963 INFO kablam! ...  |
Oct 12 23:10:03.963 INFO kablam! 60 | |     }
Oct 12 23:10:03.963 INFO kablam! 61 | | }
Oct 12 23:10:03.963 INFO kablam!    | |_^
Oct 12 23:10:03.963 INFO kablam!    |
Oct 12 23:10:03.963 INFO kablam!    = note: #[warn(unused_macros)] on by default
Oct 12 23:10:03.963 INFO kablam! 
Oct 12 23:10:04.019 INFO kablam! warning: unused import: `super::*`
Oct 12 23:10:04.019 INFO kablam!    --> src/bus.rs:203:9
Oct 12 23:10:04.019 INFO kablam!     |
Oct 12 23:10:04.019 INFO kablam! 203 |     use super::*;
Oct 12 23:10:04.019 INFO kablam!     |         ^^^^^^^^
Oct 12 23:10:04.019 INFO kablam! 
Oct 12 23:10:17.298 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 14.94s
Oct 12 23:10:17.301 INFO kablam! su: No module specific data is present
Oct 12 23:10:18.789 INFO running `"docker" "rm" "-f" "7942e5cd56b0d6c611fcb00f599bec6ae2aeec8974bef2205a6aec025d127845"`
Oct 12 23:10:19.163 INFO blam! 7942e5cd56b0d6c611fcb00f599bec6ae2aeec8974bef2205a6aec025d127845
Oct 12 23:10:19.171 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-7/try#40d4795669493f1965de7c44029c69552134fe1f:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-7/rustdoc-test-static-cling-1/try#40d4795669493f1965de7c44029c69552134fe1f:/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 +40d4795669493f1965de7c44029c69552134fe1f-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"`
Oct 12 23:10:19.595 INFO blam! a10c7133bd56c5ebe374a1d545eeb1afee5c93d27c348dad806adaf18145b898
Oct 12 23:10:19.598 INFO running `"docker" "start" "-a" "a10c7133bd56c5ebe374a1d545eeb1afee5c93d27c348dad806adaf18145b898"`
Oct 12 23:10:21.439 INFO kablam! usermod: no changes
Oct 12 23:10:21.523 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 0.05s
Oct 12 23:10:21.531 INFO kablam!      Running /target/debug/deps/nes-8e0cdc4207551ce8
Oct 12 23:10:21.533 INFO blam! 
Oct 12 23:10:21.533 INFO blam! running 119 tests
Oct 12 23:10:21.542 INFO blam! test cartridge::cartridge_header::test::test_sizes ... ok
Oct 12 23:10:21.579 INFO blam! test cartridge::mapper1::test::test_shift ... ok
Oct 12 23:10:21.745 INFO blam! test cartridge::pager::test::test_index_first ... ok
Oct 12 23:10:21.760 INFO blam! test cartridge::pager::test::test_index_last ... ok
Oct 12 23:10:21.871 INFO blam! test cartridge::pager::test::test_index_nopage ... ok
Oct 12 23:10:21.917 INFO blam! test cartridge::pager::test::test_index_number ... ok
Oct 12 23:10:21.947 INFO blam! test cartridge::pager::test::test_index_overflow ... ok
Oct 12 23:10:21.989 INFO blam! test cartridge::pager::test::test_page_count ... ok
Oct 12 23:10:21.989 INFO blam! test cartridge::mapper1::test::test_prg_rom ... ok
Oct 12 23:10:22.015 INFO blam! test cartridge::ppu_test::test_chr_ram ... ok
Oct 12 23:10:22.015 INFO blam! test cartridge::pager::test::test_rw ... ok
Oct 12 23:10:22.051 INFO blam! test cartridge::ppu_test::test_read_chr_rom ... ok
Oct 12 23:10:22.052 INFO blam! test cartridge::ppu_test::test_prg_ram ... ok
Oct 12 23:10:22.075 INFO blam! test cpu::cpu_test::test_adc ... ok
Oct 12 23:10:22.080 INFO blam! test cpu::cpu_test::test_and ... ok
Oct 12 23:10:22.087 INFO blam! test cpu::cpu_test::test_asl ... ok
Oct 12 23:10:22.095 INFO blam! test cpu::cpu_test::test_bcc ... ok
Oct 12 23:10:22.103 INFO blam! test cpu::cpu_test::test_bcs ... ok
Oct 12 23:10:22.111 INFO blam! test cpu::cpu_test::test_beq ... ok
Oct 12 23:10:22.119 INFO blam! test cpu::cpu_test::test_bit ... ok
Oct 12 23:10:22.123 INFO blam! test cartridge::ppu_test::test_read_prg_rom ... ok
Oct 12 23:10:22.123 INFO blam! test cpu::cpu_test::test_bmi ... ok
Oct 12 23:10:22.130 INFO blam! test cpu::cpu_test::test_bpl ... ok
Oct 12 23:10:22.130 INFO blam! test cpu::cpu_test::test_bne ... ok
Oct 12 23:10:22.135 INFO blam! test cpu::cpu_test::test_brk ... ok
Oct 12 23:10:22.135 INFO blam! test cpu::cpu_test::test_bvc ... ok
Oct 12 23:10:22.135 INFO blam! test cpu::cpu_test::test_bvs ... ok
Oct 12 23:10:22.143 INFO blam! test cpu::cpu_test::test_cpx ... ok
Oct 12 23:10:22.143 INFO blam! test cpu::cpu_test::test_cmp ... ok
Oct 12 23:10:22.144 INFO blam! test cpu::cpu_test::test_cpy ... ok
Oct 12 23:10:22.144 INFO blam! test cpu::cpu_test::test_dec ... ok
Oct 12 23:10:22.145 INFO blam! test cpu::cpu_test::test_dex ... ok
Oct 12 23:10:22.176 INFO blam! test cartridge::mapper1::test::test_set_chr_0 ... ok
Oct 12 23:10:22.176 INFO blam! test cpu::cpu_test::test_dey ... ok
Oct 12 23:10:22.176 INFO blam! test cpu::cpu_test::test_eor ... ok
Oct 12 23:10:22.176 INFO blam! test cartridge::mapper1::test::test_prg_ram ... ok
Oct 12 23:10:22.176 INFO blam! test cartridge::mapper1::test::test_set_control ... ok
Oct 12 23:10:22.177 INFO blam! test cpu::cpu_test::test_inx ... ok
Oct 12 23:10:22.177 INFO blam! test cpu::cpu_test::test_iny ... ok
Oct 12 23:10:22.177 INFO blam! test cpu::cpu_test::test_jmp ... ok
Oct 12 23:10:22.178 INFO blam! test cpu::cpu_test::test_flag_ops ... ok
Oct 12 23:10:22.179 INFO blam! test cpu::cpu_test::test_lda ... ok
Oct 12 23:10:22.199 INFO blam! test cpu::cpu_test::test_jsr_ret ... ok
Oct 12 23:10:22.199 INFO blam! test cpu::cpu_test::test_inc ... ok
Oct 12 23:10:22.201 INFO blam! test cpu::cpu_test::test_ldx ... ok
Oct 12 23:10:22.214 INFO blam! test cpu::cpu_test::test_php_plp ... ok
Oct 12 23:10:22.214 INFO blam! test cpu::cpu_test::test_ldy ... ok
Oct 12 23:10:22.225 INFO blam! test cpu::cpu_test::test_ror ... ok
Oct 12 23:10:22.225 INFO blam! test cpu::cpu_test::test_lsr ... ok
Oct 12 23:10:22.235 INFO blam! test cpu::cpu_test::test_sta ... ok
Oct 12 23:10:22.237 INFO blam! test cpu::cpu_test::test_sbc ... ok
Oct 12 23:10:22.239 INFO blam! test cpu::cpu_test::test_rol ... ok
Oct 12 23:10:22.239 INFO blam! test cartridge::mapper1::test::test_set_chr_1 ... ok
Oct 12 23:10:22.247 INFO blam! test cartridge::mapper1::test::test_set_prg ... ok
Oct 12 23:10:22.248 INFO blam! test cpu::cpu_test::test_tax ... ok
Oct 12 23:10:22.256 INFO blam! test cpu::cpu_test::test_stx ... ok
Oct 12 23:10:22.256 INFO blam! test cpu::cpu_test::test_tsx ... ok
Oct 12 23:10:22.257 INFO blam! test cpu::cpu_test::test_pha_pla ... ok
Oct 12 23:10:22.258 INFO blam! test cpu::cpu_test::test_tay ... ok
Oct 12 23:10:22.258 INFO blam! test ppu::address::test::test_copy_x ... ok
Oct 12 23:10:22.258 INFO blam! test cpu::cpu_test::test_sty ... ok
Oct 12 23:10:22.259 INFO blam! test cpu::cpu_test::test_txa ... ok
Oct 12 23:10:22.259 INFO blam! test ppu::address::test::test_copy_y ... ok
Oct 12 23:10:22.259 INFO blam! test ppu::address::test::test_loopy ... ok
Oct 12 23:10:22.260 INFO blam! test ppu::address::test::test_register_address ... ok
Oct 12 23:10:22.275 INFO blam! test ppu::address::test::test_attribute_address ... ok
Oct 12 23:10:22.275 INFO blam! test ppu::address::test::test_scroll_x ... ok
Oct 12 23:10:22.275 INFO blam! test ppu::address::test::test_nametable_address ... ok
Oct 12 23:10:22.276 INFO blam! test cpu::cpu_test::test_txs ... ok
Oct 12 23:10:22.276 INFO blam! test cpu::cpu_test::test_tya ... ok
Oct 12 23:10:22.286 INFO blam! test cartridge::mapper1::test::test_chr_rom ... ok
Oct 12 23:10:22.286 INFO blam! test cpu::cpu_test::test_ora ... ok
Oct 12 23:10:22.286 INFO blam! test ppu::control::test::test_background_tile_base ... ok
Oct 12 23:10:22.287 INFO blam! test ppu::address::test::test_tile_offset ... ok
Oct 12 23:10:22.287 INFO blam! test ppu::registers::test::test_read_data_delayed ... ok
Oct 12 23:10:22.287 INFO blam! test ppu::mask::test::test_rendering_sprites ... ok
Oct 12 23:10:22.287 INFO blam! test ppu::registers::test::test_read_oam_data ... ok
Oct 12 23:10:22.287 INFO blam! test ppu::registers::test::test_read_ghost_bits ... ok
Oct 12 23:10:22.287 INFO blam! test ppu::registers::test::test_read_status ... ok
Oct 12 23:10:22.287 INFO blam! test ppu::registers::test::test_write_address ... ok
Oct 12 23:10:22.287 INFO blam! test ppu::registers::test::test_write_control ... ok
Oct 12 23:10:22.287 INFO blam! test ppu::registers::test::test_write_data ... ok
Oct 12 23:10:22.287 INFO blam! test ppu::registers::test::test_write_mask ... ok
Oct 12 23:10:22.287 INFO blam! test ppu::registers::test::test_write_oam_address ... ok
Oct 12 23:10:22.287 INFO blam! test ppu::registers::test::test_write_oam_data ... ok
Oct 12 23:10:22.287 INFO blam! test ppu::renderer::test::test_evaluate_sprites ... ok
Oct 12 23:10:22.287 INFO blam! test ppu::registers::test::test_write_scroll ... ok
Oct 12 23:10:22.287 INFO blam! test ppu::renderer::test::test_render_background_pixel ... ok
Oct 12 23:10:22.298 INFO blam! test ppu::control::test::test_increment_amount ... ok
Oct 12 23:10:22.298 INFO blam! test ppu::control::test::test_sprite_height ... ok
Oct 12 23:10:22.298 INFO blam! test ppu::renderer::test::test_reload_shift ... ok
Oct 12 23:10:22.298 INFO blam! test ppu::control::test::test_sprite_tile_base ... ok
Oct 12 23:10:22.298 INFO blam! test ppu::mask::test::test_rendering_background ... ok
Oct 12 23:10:22.298 INFO blam! test ppu::renderer::test::test_load_sprites ... ok
Oct 12 23:10:22.298 INFO blam! test ppu::address::test::test_scroll_y ... ok
Oct 12 23:10:22.298 INFO blam! test ppu::renderer::test::test_step ... ok
Oct 12 23:10:22.298 INFO blam! test ppu::sprite::test::test_color_index ... ok
Oct 12 23:10:22.298 INFO blam! test ppu::renderer::test::test_render_pixel_opaque_sprite_front ... ok
Oct 12 23:10:22.298 INFO blam! test ppu::renderer::test::test_sprite_overflow ... ok
Oct 12 23:10:22.299 INFO blam! test ppu::sprite::test::test_color_index_flip_x ... ok
Oct 12 23:10:22.299 INFO blam! test ppu::renderer::test::test_render_pixel_transparent_sprite_front ... ok
Oct 12 23:10:22.299 INFO blam! test ppu::sprite::test::test_sprite_tile_offset ... ok
Oct 12 23:10:22.299 INFO blam! test ppu::renderer::test::test_render_sprite_pixel ... ok
Oct 12 23:10:22.299 INFO blam! test ppu::renderer::test::test_render_pixel_opaque_sprite_behind ... ok
Oct 12 23:10:22.299 INFO blam! test ppu::renderer::test::test_shift ... ok
Oct 12 23:10:22.299 INFO blam! test ppu::vram::test::test_mirror_nametable_vertically ... ok
Oct 12 23:10:22.299 INFO blam! test ppu::vram::test::test_mirror_nametable_horizontally ... ok
Oct 12 23:10:22.300 INFO blam! test ppu::vram::test::test_mirror_palette ... ok
Oct 12 23:10:22.300 INFO blam! test ppu::sprite::test::test_tile_address_large_flip_y ... ok
Oct 12 23:10:22.300 INFO blam! test ppu::vram::test::test_read_byte_nametable ... ok
Oct 12 23:10:22.300 INFO blam! test ppu::vram::test::test_write_byte_nametable ... ok
Oct 12 23:10:22.301 INFO blam! test ppu::sprite::test::test_tile_address_large_no_flip ... ok
Oct 12 23:10:22.301 INFO blam! test ppu::sprite::test::test_tile_address_small_no_flip ... ok
Oct 12 23:10:22.301 INFO blam! test ppu::vram::test::test_read_byte_palette ... ok
Oct 12 23:10:22.301 INFO blam! test ppu::sprite::test::test_tile_base ... ok
Oct 12 23:10:22.301 INFO blam! test ppu::vram::test::test_buffered_read_byte ... ok
Oct 12 23:10:22.301 INFO blam! test ppu::sprite::test::test_tile_address_small_flip_y ... ok
Oct 12 23:10:22.301 INFO blam! test ppu::vram::test::test_write_byte_palette ... ok
Oct 12 23:10:22.311 INFO blam! test ppu::vram::test::test_read_byte_cartridge ... ok
Oct 12 23:10:22.311 INFO blam! 
Oct 12 23:10:22.311 INFO blam! test result: ok. 119 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 12 23:10:22.311 INFO blam! 
Oct 12 23:10:22.332 INFO kablam! su: No module specific data is present
Oct 12 23:10:23.588 INFO running `"docker" "rm" "-f" "a10c7133bd56c5ebe374a1d545eeb1afee5c93d27c348dad806adaf18145b898"`
Oct 12 23:10:23.847 INFO blam! a10c7133bd56c5ebe374a1d545eeb1afee5c93d27c348dad806adaf18145b898