Dec 15 16:32:43.711 INFO testing ds1307-0.2.0 against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 15 16:32:43.711 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 15 16:32:43.893 INFO [stdout] 446282e0ade7121ee23c1c9b121d66b443a0c964d01568cf0d143f18b718154c
Dec 15 16:32:43.894 INFO running `"docker" "start" "-a" "446282e0ade7121ee23c1c9b121d66b443a0c964d01568cf0d143f18b718154c"`
Dec 15 16:32:44.300 INFO [stderr] usermod: no changes
Dec 15 16:32:44.383 INFO [stderr]    Compiling ds1307 v0.2.0 (/source)
Dec 15 16:32:45.024 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.71s
Dec 15 16:32:45.031 INFO [stderr] su: No module specific data is present
Dec 15 16:32:45.361 INFO running `"docker" "inspect" "446282e0ade7121ee23c1c9b121d66b443a0c964d01568cf0d143f18b718154c"`
Dec 15 16:32:45.476 INFO running `"docker" "rm" "-f" "446282e0ade7121ee23c1c9b121d66b443a0c964d01568cf0d143f18b718154c"`
Dec 15 16:32:45.566 INFO [stdout] 446282e0ade7121ee23c1c9b121d66b443a0c964d01568cf0d143f18b718154c
Dec 15 16:32:45.568 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 15 16:32:45.774 INFO [stdout] a0ae351d753aaa49445cbf33932d51246e8c74a3003a15291d4c3eb0ec9d83c9
Dec 15 16:32:45.776 INFO running `"docker" "start" "-a" "a0ae351d753aaa49445cbf33932d51246e8c74a3003a15291d4c3eb0ec9d83c9"`
Dec 15 16:32:46.216 INFO [stderr] usermod: no changes
Dec 15 16:32:46.370 INFO [stderr]    Compiling ds1307 v0.2.0 (/source)
Dec 15 16:33:01.420 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 15.18s
Dec 15 16:33:01.437 INFO [stderr] su: No module specific data is present
Dec 15 16:33:01.739 INFO running `"docker" "inspect" "a0ae351d753aaa49445cbf33932d51246e8c74a3003a15291d4c3eb0ec9d83c9"`
Dec 15 16:33:01.828 INFO running `"docker" "rm" "-f" "a0ae351d753aaa49445cbf33932d51246e8c74a3003a15291d4c3eb0ec9d83c9"`
Dec 15 16:33:01.905 INFO [stdout] a0ae351d753aaa49445cbf33932d51246e8c74a3003a15291d4c3eb0ec9d83c9
Dec 15 16:33:01.908 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 15 16:33:02.124 INFO [stdout] 56c51cf1ac91151bafb8c578c78ce58453fbe6a74eac88e778733e2a3fb29bc1
Dec 15 16:33:02.129 INFO running `"docker" "start" "-a" "56c51cf1ac91151bafb8c578c78ce58453fbe6a74eac88e778733e2a3fb29bc1"`
Dec 15 16:33:02.549 INFO [stderr] usermod: no changes
Dec 15 16:33:02.644 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.07s
Dec 15 16:33:02.660 INFO [stderr]      Running /target/debug/deps/ds1307-40b284ade7cb3999
Dec 15 16:33:02.662 INFO [stdout] 
Dec 15 16:33:02.662 INFO [stdout] running 2 tests
Dec 15 16:33:02.662 INFO [stdout] test datetime::tests::can_convert_decimal_to_packed_bcd ... ok
Dec 15 16:33:02.671 INFO [stdout] test datetime::tests::can_convert_packed_bcd_to_decimal ... ok
Dec 15 16:33:02.671 INFO [stdout] 
Dec 15 16:33:02.671 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 16:33:02.671 INFO [stdout] 
Dec 15 16:33:02.671 INFO [stderr]      Running /target/debug/deps/datetime-247f81f219e2a683
Dec 15 16:33:02.673 INFO [stdout] 
Dec 15 16:33:02.673 INFO [stdout] running 10 tests
Dec 15 16:33:02.673 INFO [stdout] test can_read_datetime ... ok
Dec 15 16:33:02.673 INFO [stdout] test can_set_datetime ... ok
Dec 15 16:33:02.673 INFO [stdout] test when_set_datetime_ch_bit_is_unchanged ... ok
Dec 15 16:33:02.673 INFO [stdout] test wrong_day_returns_error ... ok
Dec 15 16:33:02.673 INFO [stdout] test wrong_hour_returns_error ... ok
Dec 15 16:33:02.673 INFO [stdout] test wrong_minute_returns_error ... ok
Dec 15 16:33:02.673 INFO [stdout] test wrong_month_returns_error ... ok
Dec 15 16:33:02.673 INFO [stdout] test wrong_second_returns_error ... ok
Dec 15 16:33:02.674 INFO [stdout] test wrong_weekday_returns_error ... ok
Dec 15 16:33:02.674 INFO [stdout] test wrong_year_returns_error ... ok
Dec 15 16:33:02.674 INFO [stdout] 
Dec 15 16:33:02.674 INFO [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 16:33:02.674 INFO [stdout] 
Dec 15 16:33:02.674 INFO [stderr]      Running /target/debug/deps/day_of_month-9911940fdddd3819
Dec 15 16:33:02.676 INFO [stdout] 
Dec 15 16:33:02.676 INFO [stdout] running 4 tests
Dec 15 16:33:02.677 INFO [stdout] test can_read_day_of_month ... ok
Dec 15 16:33:02.677 INFO [stdout] test too_big_day_of_month_returns_error ... ok
Dec 15 16:33:02.677 INFO [stdout] test too_small_day_of_month_returns_error ... ok
Dec 15 16:33:02.677 INFO [stdout] test can_write_day_of_month ... ok
Dec 15 16:33:02.677 INFO [stdout] 
Dec 15 16:33:02.677 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 16:33:02.677 INFO [stdout] 
Dec 15 16:33:02.677 INFO [stderr]      Running /target/debug/deps/day_of_week-fda00abbd06998e7
Dec 15 16:33:02.679 INFO [stdout] 
Dec 15 16:33:02.679 INFO [stdout] running 4 tests
Dec 15 16:33:02.679 INFO [stdout] test too_small_weekday_returns_error ... ok
Dec 15 16:33:02.679 INFO [stdout] test too_big_weekday_returns_error ... ok
Dec 15 16:33:02.680 INFO [stdout] test can_write_weekday ... ok
Dec 15 16:33:02.680 INFO [stdout] test can_read_weekday ... ok
Dec 15 16:33:02.680 INFO [stdout] 
Dec 15 16:33:02.680 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 16:33:02.680 INFO [stdout] 
Dec 15 16:33:02.680 INFO [stderr]      Running /target/debug/deps/hours-5e9732439f9d01fb
Dec 15 16:33:02.681 INFO [stdout] 
Dec 15 16:33:02.681 INFO [stdout] running 11 tests
Dec 15 16:33:02.682 INFO [stdout] test can_read_24h_hours ... ok
Dec 15 16:33:02.682 INFO [stdout] test too_big_12h_pm_hours_returns_error ... ok
Dec 15 16:33:02.682 INFO [stdout] test can_write_24h_hours ... ok
Dec 15 16:33:02.682 INFO [stdout] test can_write_12h_pm_hours ... ok
Dec 15 16:33:02.682 INFO [stdout] test too_small_12h_pm_hours_returns_error ... ok
Dec 15 16:33:02.682 INFO [stdout] test wrong_24h_hours_returns_error ... ok
Dec 15 16:33:02.682 INFO [stdout] test too_small_12h_am_hours_returns_error ... ok
Dec 15 16:33:02.683 INFO [stdout] test can_read_12h_am_hours ... ok
Dec 15 16:33:02.683 INFO [stdout] test can_read_12h_pm_hours ... ok
Dec 15 16:33:02.687 INFO [stdout] test too_big_12h_am_hours_returns_error ... ok
Dec 15 16:33:02.687 INFO [stdout] test can_write_12h_am_hours ... ok
Dec 15 16:33:02.687 INFO [stdout] 
Dec 15 16:33:02.687 INFO [stdout] test result: ok. 11 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 16:33:02.687 INFO [stdout] 
Dec 15 16:33:02.688 INFO [stderr]      Running /target/debug/deps/minutes-d45d646d320bb5a1
Dec 15 16:33:02.692 INFO [stdout] 
Dec 15 16:33:02.692 INFO [stdout] running 3 tests
Dec 15 16:33:02.692 INFO [stdout] test can_write_minutes ... ok
Dec 15 16:33:02.693 INFO [stdout] test can_read_minutes ... ok
Dec 15 16:33:02.695 INFO [stdout] test wrong_minutes_returns_error ... ok
Dec 15 16:33:02.695 INFO [stdout] 
Dec 15 16:33:02.695 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 16:33:02.695 INFO [stdout] 
Dec 15 16:33:02.695 INFO [stderr]      Running /target/debug/deps/month-137394203cd6213a
Dec 15 16:33:02.704 INFO [stdout] 
Dec 15 16:33:02.704 INFO [stdout] running 4 tests
Dec 15 16:33:02.704 INFO [stdout] test too_big_month_returns_error ... ok
Dec 15 16:33:02.704 INFO [stdout] test can_write_month ... ok
Dec 15 16:33:02.704 INFO [stdout] test too_small_month_returns_error ... ok
Dec 15 16:33:02.704 INFO [stdout] test can_read_month ... ok
Dec 15 16:33:02.704 INFO [stdout] 
Dec 15 16:33:02.704 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 16:33:02.704 INFO [stdout] 
Dec 15 16:33:02.705 INFO [stderr]      Running /target/debug/deps/run_halt-4eb268f9d66dcea3
Dec 15 16:33:02.706 INFO [stdout] 
Dec 15 16:33:02.706 INFO [stdout] running 8 tests
Dec 15 16:33:02.707 INFO [stdout] test can_read_is_running_halted ... ok
Dec 15 16:33:02.707 INFO [stdout] test can_halt ... ok
Dec 15 16:33:02.707 INFO [stdout] test halt_when_already_halted_does_nothing ... ok
Dec 15 16:33:02.707 INFO [stdout] test can_read_is_running_running ... ok
Dec 15 16:33:02.707 INFO [stdout] test can_set_running ... ok
Dec 15 16:33:02.707 INFO [stdout] test run_keeps_seconds ... ok
Dec 15 16:33:02.707 INFO [stdout] test set_running_when_already_running_does_nothing ... ok
Dec 15 16:33:02.707 INFO [stdout] test halt_keeps_seconds ... ok
Dec 15 16:33:02.707 INFO [stdout] 
Dec 15 16:33:02.707 INFO [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 16:33:02.707 INFO [stdout] 
Dec 15 16:33:02.707 INFO [stderr]      Running /target/debug/deps/seconds-a837ea167012fc01
Dec 15 16:33:02.709 INFO [stdout] 
Dec 15 16:33:02.709 INFO [stdout] running 5 tests
Dec 15 16:33:02.709 INFO [stdout] test ch_bit_is_kept_when_writing_seconds ... ok
Dec 15 16:33:02.709 INFO [stdout] test can_read_seconds ... ok
Dec 15 16:33:02.711 INFO [stdout] test ch_bit_is_ignored ... ok
Dec 15 16:33:02.711 INFO [stdout] test wrong_seconds_returns_error ... ok
Dec 15 16:33:02.711 INFO [stdout] test can_write_seconds ... ok
Dec 15 16:33:02.711 INFO [stdout] 
Dec 15 16:33:02.711 INFO [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 16:33:02.711 INFO [stdout] 
Dec 15 16:33:02.711 INFO [stderr]      Running /target/debug/deps/sqwout_enable_disable-8bab18ebdc2298d8
Dec 15 16:33:02.720 INFO [stdout] 
Dec 15 16:33:02.720 INFO [stdout] running 8 tests
Dec 15 16:33:02.720 INFO [stdout] test can_enable ... ok
Dec 15 16:33:02.720 INFO [stdout] test can_disable ... ok
Dec 15 16:33:02.720 INFO [stdout] test can_read_is_enabled ... ok
Dec 15 16:33:02.720 INFO [stdout] test can_read_is_not_enabled ... ok
Dec 15 16:33:02.720 INFO [stdout] test disable_keeps_status_of_other_flags ... ok
Dec 15 16:33:02.720 INFO [stdout] test enable_keeps_status_of_other_flags ... ok
Dec 15 16:33:02.720 INFO [stdout] test when_already_disabled_then_disable_does_nothing ... ok
Dec 15 16:33:02.720 INFO [stdout] test when_already_enabled_then_enable_does_nothing ... ok
Dec 15 16:33:02.720 INFO [stdout] 
Dec 15 16:33:02.720 INFO [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 16:33:02.720 INFO [stdout] 
Dec 15 16:33:02.721 INFO [stderr]      Running /target/debug/deps/sqwout_output_level-b2108c8870fa1c50
Dec 15 16:33:02.724 INFO [stdout] 
Dec 15 16:33:02.724 INFO [stdout] running 9 tests
Dec 15 16:33:02.725 INFO [stdout] test can_write_high_output_level ... ok
Dec 15 16:33:02.725 INFO [stdout] test can_read_output_level_high ... ok
Dec 15 16:33:02.725 INFO [stdout] test can_write_low_output_level ... ok
Dec 15 16:33:02.725 INFO [stdout] test can_read_output_level_low ... ok
Dec 15 16:33:02.725 INFO [stdout] test can_write_output_level_parameter_low ... ok
Dec 15 16:33:02.725 INFO [stdout] test can_write_output_level_parameter_high ... ok
Dec 15 16:33:02.725 INFO [stdout] test when_already_high_then_set_level_low_does_nothing ... ok
Dec 15 16:33:02.725 INFO [stdout] test when_already_low_then_set_level_low_does_nothing ... ok
Dec 15 16:33:02.729 INFO [stdout] test write_output_level_keeps_status_of_other_flags ... ok
Dec 15 16:33:02.729 INFO [stdout] 
Dec 15 16:33:02.729 INFO [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 16:33:02.729 INFO [stdout] 
Dec 15 16:33:02.730 INFO [stderr]      Running /target/debug/deps/sqwout_rate-250822f2798f9ead
Dec 15 16:33:02.735 INFO [stderr]      Running /target/debug/deps/user_ram-3f745d099dfa4336
Dec 15 16:33:02.741 INFO [stdout] 
Dec 15 16:33:02.741 INFO [stdout] running 5 tests
Dec 15 16:33:02.741 INFO [stdout] test can_read_output_rate ... ok
Dec 15 16:33:02.741 INFO [stdout] test can_set_output_rate_to_11 ... ok
Dec 15 16:33:02.741 INFO [stdout] test set_output_rate_keeps_status_of_other_flags ... ok
Dec 15 16:33:02.741 INFO [stdout] test can_set_output_rate_00 ... ok
Dec 15 16:33:02.741 INFO [stdout] test set_output_rate_to_same_rate_does_nothing ... ok
Dec 15 16:33:02.741 INFO [stdout] 
Dec 15 16:33:02.741 INFO [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 16:33:02.741 INFO [stdout] 
Dec 15 16:33:02.741 INFO [stdout] 
Dec 15 16:33:02.741 INFO [stdout] running 12 tests
Dec 15 16:33:02.741 INFO [stdout] test can_write_last_ram_address ... ok
Dec 15 16:33:02.741 INFO [stdout] test can_read_whole_ram ... ok
Dec 15 16:33:02.741 INFO [stdout] test can_write_whole_ram ... ok
Dec 15 16:33:02.741 INFO [stdout] test can_read_last_ram_address ... ok
Dec 15 16:33:02.741 INFO [stdout] test empty_data_read_does_nothing ... ok
Dec 15 16:33:02.741 INFO [stdout] test empty_data_write_does_nothing ... ok
Dec 15 16:33:02.741 INFO [stdout] test too_long_array_read_returns_error ... ok
Dec 15 16:33:02.743 INFO [stdout] test too_long_array_write_returns_error ... ok
Dec 15 16:33:02.743 INFO [stdout] test too_much_data_read_returns_error ... ok
Dec 15 16:33:02.743 INFO [stdout] test too_much_data_write_returns_error ... ok
Dec 15 16:33:02.743 INFO [stdout] test too_big_address_offset_write_returns_error ... ok
Dec 15 16:33:02.744 INFO [stdout] test too_big_address_offset_read_returns_error ... ok
Dec 15 16:33:02.745 INFO [stdout] 
Dec 15 16:33:02.745 INFO [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 16:33:02.745 INFO [stdout] 
Dec 15 16:33:02.745 INFO [stderr]      Running /target/debug/deps/year-777381a8c1d693e4
Dec 15 16:33:02.748 INFO [stdout] 
Dec 15 16:33:02.748 INFO [stdout] running 4 tests
Dec 15 16:33:02.748 INFO [stdout] test can_write_year ... ok
Dec 15 16:33:02.748 INFO [stdout] test can_read_year ... ok
Dec 15 16:33:02.751 INFO [stdout] test too_big_year_returns_error ... ok
Dec 15 16:33:02.756 INFO [stdout] test too_small_year_returns_error ... ok
Dec 15 16:33:02.756 INFO [stdout] 
Dec 15 16:33:02.756 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 16:33:02.756 INFO [stdout] 
Dec 15 16:33:02.756 INFO [stderr]    Doc-tests ds1307
Dec 15 16:33:03.739 INFO [stdout] 
Dec 15 16:33:03.739 INFO [stdout] running 6 tests
Dec 15 16:33:14.339 INFO [stdout] test src/lib.rs -  (line 113) ... ok
Dec 15 16:33:14.935 INFO [stdout] test src/lib.rs -  (line 84) ... ok
Dec 15 16:33:15.591 INFO [stdout] test src/lib.rs -  (line 46) ... ok
Dec 15 16:33:15.929 INFO [stdout] test src/lib.rs -  (line 135) ... ok
Dec 15 16:33:16.463 INFO [stdout] test src/lib.rs -  (line 61) ... ok
Dec 15 16:33:16.735 INFO [stdout] test src/lib.rs -  (line 30) ... ok
Dec 15 16:33:16.735 INFO [stdout] 
Dec 15 16:33:16.735 INFO [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 16:33:16.735 INFO [stdout] 
Dec 15 16:33:16.775 INFO [stderr] su: No module specific data is present
Dec 15 16:33:17.392 INFO running `"docker" "inspect" "56c51cf1ac91151bafb8c578c78ce58453fbe6a74eac88e778733e2a3fb29bc1"`
Dec 15 16:33:17.657 INFO running `"docker" "rm" "-f" "56c51cf1ac91151bafb8c578c78ce58453fbe6a74eac88e778733e2a3fb29bc1"`
Dec 15 16:33:18.022 INFO [stdout] 56c51cf1ac91151bafb8c578c78ce58453fbe6a74eac88e778733e2a3fb29bc1