Nov 18 15:42:03.800 INFO testing ds1307-0.2.0 against master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c for pr-55982
Nov 18 15:42:03.800 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-2/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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 18 15:42:03.947 INFO [stdout] 16c910cbecef13aa5ebb2aa3a47c22d5d6cfd59cd7cda399566f2754d351ea56
Nov 18 15:42:03.949 INFO running `"docker" "start" "-a" "16c910cbecef13aa5ebb2aa3a47c22d5d6cfd59cd7cda399566f2754d351ea56"`
Nov 18 15:42:04.610 INFO [stderr] usermod: no changes
Nov 18 15:42:04.761 INFO [stderr]    Compiling ds1307 v0.2.0 (/source)
Nov 18 15:42:05.595 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.96s
Nov 18 15:42:05.597 INFO [stderr] su: No module specific data is present
Nov 18 15:42:06.081 INFO running `"docker" "inspect" "16c910cbecef13aa5ebb2aa3a47c22d5d6cfd59cd7cda399566f2754d351ea56"`
Nov 18 15:42:06.313 INFO running `"docker" "rm" "-f" "16c910cbecef13aa5ebb2aa3a47c22d5d6cfd59cd7cda399566f2754d351ea56"`
Nov 18 15:42:06.662 INFO [stdout] 16c910cbecef13aa5ebb2aa3a47c22d5d6cfd59cd7cda399566f2754d351ea56
Nov 18 15:42:06.673 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-2/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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 18 15:42:07.201 INFO [stdout] 9a0515239a2ee6952206939d1f82cdf703de989624cc5a8e131f38e4c11769ee
Nov 18 15:42:07.211 INFO running `"docker" "start" "-a" "9a0515239a2ee6952206939d1f82cdf703de989624cc5a8e131f38e4c11769ee"`
Nov 18 15:42:08.511 INFO [stderr] usermod: no changes
Nov 18 15:42:08.727 INFO [stderr]    Compiling ds1307 v0.2.0 (/source)
Nov 18 15:42:19.011 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 10.48s
Nov 18 15:42:19.024 INFO [stderr] su: No module specific data is present
Nov 18 15:42:19.401 INFO running `"docker" "inspect" "9a0515239a2ee6952206939d1f82cdf703de989624cc5a8e131f38e4c11769ee"`
Nov 18 15:42:19.576 INFO running `"docker" "rm" "-f" "9a0515239a2ee6952206939d1f82cdf703de989624cc5a8e131f38e4c11769ee"`
Nov 18 15:42:19.662 INFO [stdout] 9a0515239a2ee6952206939d1f82cdf703de989624cc5a8e131f38e4c11769ee
Nov 18 15:42:19.665 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-2/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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 18 15:42:19.910 INFO [stdout] db47f8716e32abfbfbc13ce7d1eb84ea5deb0a92cea749e3ca7eeb87f918bccc
Nov 18 15:42:19.912 INFO running `"docker" "start" "-a" "db47f8716e32abfbfbc13ce7d1eb84ea5deb0a92cea749e3ca7eeb87f918bccc"`
Nov 18 15:42:20.711 INFO [stderr] usermod: no changes
Nov 18 15:42:20.881 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.14s
Nov 18 15:42:20.897 INFO [stderr]      Running /target/debug/deps/ds1307-c290af95a9c372a5
Nov 18 15:42:20.905 INFO [stdout] 
Nov 18 15:42:20.905 INFO [stdout] running 2 tests
Nov 18 15:42:20.905 INFO [stdout] test datetime::tests::can_convert_packed_bcd_to_decimal ... ok
Nov 18 15:42:20.907 INFO [stdout] test datetime::tests::can_convert_decimal_to_packed_bcd ... ok
Nov 18 15:42:20.907 INFO [stdout] 
Nov 18 15:42:20.907 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 15:42:20.907 INFO [stdout] 
Nov 18 15:42:20.908 INFO [stderr]      Running /target/debug/deps/datetime-b714c756ff280206
Nov 18 15:42:20.912 INFO [stdout] 
Nov 18 15:42:20.913 INFO [stdout] running 10 tests
Nov 18 15:42:20.943 INFO [stdout] test can_set_datetime ... ok
Nov 18 15:42:20.943 INFO [stdout] test can_read_datetime ... ok
Nov 18 15:42:20.943 INFO [stdout] test when_set_datetime_ch_bit_is_unchanged ... ok
Nov 18 15:42:20.943 INFO [stdout] test wrong_day_returns_error ... ok
Nov 18 15:42:20.943 INFO [stdout] test wrong_second_returns_error ... ok
Nov 18 15:42:20.943 INFO [stdout] test wrong_month_returns_error ... ok
Nov 18 15:42:20.943 INFO [stdout] test wrong_minute_returns_error ... ok
Nov 18 15:42:20.943 INFO [stdout] test wrong_hour_returns_error ... ok
Nov 18 15:42:20.943 INFO [stdout] test wrong_weekday_returns_error ... ok
Nov 18 15:42:20.943 INFO [stdout] test wrong_year_returns_error ... ok
Nov 18 15:42:20.943 INFO [stdout] 
Nov 18 15:42:20.943 INFO [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 15:42:20.943 INFO [stdout] 
Nov 18 15:42:20.947 INFO [stderr]      Running /target/debug/deps/day_of_month-bca2597bafb5d174
Nov 18 15:42:20.951 INFO [stdout] 
Nov 18 15:42:20.952 INFO [stdout] running 4 tests
Nov 18 15:42:20.952 INFO [stdout] test too_big_day_of_month_returns_error ... ok
Nov 18 15:42:20.952 INFO [stdout] test can_write_day_of_month ... ok
Nov 18 15:42:20.953 INFO [stdout] test can_read_day_of_month ... ok
Nov 18 15:42:20.963 INFO [stdout] test too_small_day_of_month_returns_error ... ok
Nov 18 15:42:20.964 INFO [stdout] 
Nov 18 15:42:20.964 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 15:42:20.964 INFO [stdout] 
Nov 18 15:42:20.965 INFO [stderr]      Running /target/debug/deps/day_of_week-969c95a767bbc60a
Nov 18 15:42:20.971 INFO [stdout] 
Nov 18 15:42:20.971 INFO [stdout] running 4 tests
Nov 18 15:42:20.971 INFO [stdout] test too_small_weekday_returns_error ... ok
Nov 18 15:42:20.971 INFO [stdout] test can_write_weekday ... ok
Nov 18 15:42:20.971 INFO [stdout] test can_read_weekday ... ok
Nov 18 15:42:20.979 INFO [stdout] test too_big_weekday_returns_error ... ok
Nov 18 15:42:20.979 INFO [stderr]      Running /target/debug/deps/hours-d969c5762a019c5e
Nov 18 15:42:20.979 INFO [stdout] 
Nov 18 15:42:20.979 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 15:42:20.979 INFO [stdout] 
Nov 18 15:42:20.985 INFO [stdout] 
Nov 18 15:42:20.985 INFO [stderr]      Running /target/debug/deps/minutes-58e4ded4c51c02ff
Nov 18 15:42:20.985 INFO [stdout] running 11 tests
Nov 18 15:42:20.985 INFO [stdout] test can_read_12h_pm_hours ... ok
Nov 18 15:42:20.985 INFO [stdout] test can_read_12h_am_hours ... ok
Nov 18 15:42:20.985 INFO [stdout] test can_read_24h_hours ... ok
Nov 18 15:42:20.985 INFO [stdout] test can_write_12h_pm_hours ... ok
Nov 18 15:42:20.985 INFO [stdout] test can_write_12h_am_hours ... ok
Nov 18 15:42:20.985 INFO [stdout] test can_write_24h_hours ... ok
Nov 18 15:42:20.985 INFO [stdout] test too_big_12h_am_hours_returns_error ... ok
Nov 18 15:42:20.985 INFO [stdout] test too_big_12h_pm_hours_returns_error ... ok
Nov 18 15:42:20.985 INFO [stdout] test too_small_12h_am_hours_returns_error ... ok
Nov 18 15:42:20.985 INFO [stdout] test wrong_24h_hours_returns_error ... ok
Nov 18 15:42:20.985 INFO [stdout] test too_small_12h_pm_hours_returns_error ... ok
Nov 18 15:42:20.985 INFO [stdout] 
Nov 18 15:42:20.985 INFO [stdout] test result: ok. 11 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 15:42:20.985 INFO [stdout] 
Nov 18 15:42:20.986 INFO [stdout] 
Nov 18 15:42:20.986 INFO [stdout] running 3 tests
Nov 18 15:42:20.995 INFO [stdout] test can_write_minutes ... ok
Nov 18 15:42:20.995 INFO [stdout] test can_read_minutes ... ok
Nov 18 15:42:21.007 INFO [stdout] test wrong_minutes_returns_error ... ok
Nov 18 15:42:21.007 INFO [stderr]      Running /target/debug/deps/month-50fd2974a1f511a2
Nov 18 15:42:21.007 INFO [stdout] 
Nov 18 15:42:21.007 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 15:42:21.007 INFO [stdout] 
Nov 18 15:42:21.019 INFO [stdout] 
Nov 18 15:42:21.019 INFO [stdout] running 4 tests
Nov 18 15:42:21.019 INFO [stdout] test too_small_month_returns_error ... ok
Nov 18 15:42:21.019 INFO [stdout] test can_read_month ... ok
Nov 18 15:42:21.019 INFO [stdout] test can_write_month ... ok
Nov 18 15:42:21.019 INFO [stdout] test too_big_month_returns_error ... ok
Nov 18 15:42:21.019 INFO [stdout] 
Nov 18 15:42:21.019 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 15:42:21.019 INFO [stdout] 
Nov 18 15:42:21.019 INFO [stderr]      Running /target/debug/deps/run_halt-fd780893a6a490cc
Nov 18 15:42:21.027 INFO [stdout] 
Nov 18 15:42:21.027 INFO [stdout] running 8 tests
Nov 18 15:42:21.035 INFO [stdout] test can_halt ... ok
Nov 18 15:42:21.035 INFO [stdout] test can_read_is_running_running ... ok
Nov 18 15:42:21.035 INFO [stdout] test can_set_running ... ok
Nov 18 15:42:21.035 INFO [stdout] test can_read_is_running_halted ... ok
Nov 18 15:42:21.035 INFO [stdout] test halt_keeps_seconds ... ok
Nov 18 15:42:21.043 INFO [stdout] test halt_when_already_halted_does_nothing ... ok
Nov 18 15:42:21.043 INFO [stdout] test run_keeps_seconds ... ok
Nov 18 15:42:21.043 INFO [stdout] test set_running_when_already_running_does_nothing ... ok
Nov 18 15:42:21.043 INFO [stdout] 
Nov 18 15:42:21.043 INFO [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 15:42:21.043 INFO [stdout] 
Nov 18 15:42:21.050 INFO [stdout] 
Nov 18 15:42:21.051 INFO [stderr]      Running /target/debug/deps/seconds-6cb6182c852385b8
Nov 18 15:42:21.051 INFO [stdout] running 5 tests
Nov 18 15:42:21.051 INFO [stdout] test ch_bit_is_kept_when_writing_seconds ... ok
Nov 18 15:42:21.051 INFO [stdout] test can_write_seconds ... ok
Nov 18 15:42:21.051 INFO [stdout] test ch_bit_is_ignored ... ok
Nov 18 15:42:21.061 INFO [stdout] test wrong_seconds_returns_error ... ok
Nov 18 15:42:21.061 INFO [stderr]      Running /target/debug/deps/sqwout_enable_disable-f4020ef571b07e42
Nov 18 15:42:21.061 INFO [stdout] test can_read_seconds ... ok
Nov 18 15:42:21.061 INFO [stdout] 
Nov 18 15:42:21.061 INFO [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 15:42:21.061 INFO [stdout] 
Nov 18 15:42:21.062 INFO [stdout] 
Nov 18 15:42:21.062 INFO [stdout] running 8 tests
Nov 18 15:42:21.062 INFO [stdout] test can_disable ... ok
Nov 18 15:42:21.062 INFO [stdout] test can_enable ... ok
Nov 18 15:42:21.062 INFO [stdout] test when_already_disabled_then_disable_does_nothing ... ok
Nov 18 15:42:21.063 INFO [stdout] test enable_keeps_status_of_other_flags ... ok
Nov 18 15:42:21.067 INFO [stdout] test can_read_is_enabled ... ok
Nov 18 15:42:21.067 INFO [stderr]      Running /target/debug/deps/sqwout_output_level-6bd83754d09cc55c
Nov 18 15:42:21.067 INFO [stdout] test disable_keeps_status_of_other_flags ... ok
Nov 18 15:42:21.067 INFO [stdout] test when_already_enabled_then_enable_does_nothing ... ok
Nov 18 15:42:21.067 INFO [stdout] test can_read_is_not_enabled ... ok
Nov 18 15:42:21.067 INFO [stdout] 
Nov 18 15:42:21.067 INFO [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 15:42:21.067 INFO [stdout] 
Nov 18 15:42:21.071 INFO [stdout] 
Nov 18 15:42:21.077 INFO [stdout] running 9 tests
Nov 18 15:42:21.077 INFO [stdout] test can_read_output_level_low ... ok
Nov 18 15:42:21.077 INFO [stdout] test can_read_output_level_high ... ok
Nov 18 15:42:21.077 INFO [stdout] test can_write_output_level_parameter_high ... ok
Nov 18 15:42:21.077 INFO [stdout] test can_write_high_output_level ... ok
Nov 18 15:42:21.077 INFO [stdout] test can_write_output_level_parameter_low ... ok
Nov 18 15:42:21.077 INFO [stdout] test when_already_high_then_set_level_low_does_nothing ... ok
Nov 18 15:42:21.077 INFO [stdout] test when_already_low_then_set_level_low_does_nothing ... ok
Nov 18 15:42:21.077 INFO [stdout] test can_write_low_output_level ... ok
Nov 18 15:42:21.080 INFO [stdout] test write_output_level_keeps_status_of_other_flags ... ok
Nov 18 15:42:21.080 INFO [stderr]      Running /target/debug/deps/sqwout_rate-8432f13d3e80249b
Nov 18 15:42:21.080 INFO [stdout] 
Nov 18 15:42:21.080 INFO [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 15:42:21.080 INFO [stdout] 
Nov 18 15:42:21.084 INFO [stdout] 
Nov 18 15:42:21.084 INFO [stdout] running 5 tests
Nov 18 15:42:21.099 INFO [stdout] test can_set_output_rate_00 ... ok
Nov 18 15:42:21.099 INFO [stdout] test can_set_output_rate_to_11 ... ok
Nov 18 15:42:21.099 INFO [stdout] test can_read_output_rate ... ok
Nov 18 15:42:21.100 INFO [stdout] test set_output_rate_to_same_rate_does_nothing ... ok
Nov 18 15:42:21.100 INFO [stdout] test set_output_rate_keeps_status_of_other_flags ... ok
Nov 18 15:42:21.100 INFO [stdout] 
Nov 18 15:42:21.100 INFO [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 15:42:21.100 INFO [stdout] 
Nov 18 15:42:21.104 INFO [stderr]      Running /target/debug/deps/user_ram-9a0791392d94e106
Nov 18 15:42:21.106 INFO [stdout] 
Nov 18 15:42:21.106 INFO [stdout] running 12 tests
Nov 18 15:42:21.106 INFO [stdout] test empty_data_read_does_nothing ... ok
Nov 18 15:42:21.106 INFO [stdout] test empty_data_write_does_nothing ... ok
Nov 18 15:42:21.106 INFO [stdout] test too_big_address_offset_read_returns_error ... ok
Nov 18 15:42:21.106 INFO [stdout] test too_big_address_offset_write_returns_error ... ok
Nov 18 15:42:21.106 INFO [stdout] test too_much_data_read_returns_error ... ok
Nov 18 15:42:21.107 INFO [stdout] test too_long_array_write_returns_error ... ok
Nov 18 15:42:21.110 INFO [stdout] test too_long_array_read_returns_error ... ok
Nov 18 15:42:21.110 INFO [stdout] test can_write_last_ram_address ... ok
Nov 18 15:42:21.110 INFO [stdout] test can_read_last_ram_address ... ok
Nov 18 15:42:21.110 INFO [stdout] test can_read_whole_ram ... ok
Nov 18 15:42:21.110 INFO [stdout] test can_write_whole_ram ... ok
Nov 18 15:42:21.110 INFO [stdout] test too_much_data_write_returns_error ... ok
Nov 18 15:42:21.110 INFO [stdout] 
Nov 18 15:42:21.110 INFO [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 15:42:21.110 INFO [stdout] 
Nov 18 15:42:21.110 INFO [stderr]      Running /target/debug/deps/year-347e0d695c89b748
Nov 18 15:42:21.113 INFO [stdout] 
Nov 18 15:42:21.113 INFO [stdout] running 4 tests
Nov 18 15:42:21.114 INFO [stdout] test can_write_year ... ok
Nov 18 15:42:21.114 INFO [stdout] test too_big_year_returns_error ... ok
Nov 18 15:42:21.115 INFO [stdout] test can_read_year ... ok
Nov 18 15:42:21.115 INFO [stdout] test too_small_year_returns_error ... ok
Nov 18 15:42:21.115 INFO [stdout] 
Nov 18 15:42:21.115 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 15:42:21.115 INFO [stdout] 
Nov 18 15:42:21.116 INFO [stderr]    Doc-tests ds1307
Nov 18 15:42:21.973 INFO [stdout] 
Nov 18 15:42:21.974 INFO [stdout] running 6 tests
Nov 18 15:42:29.795 INFO [stdout] test src/lib.rs -  (line 46) ... ok
Nov 18 15:42:30.111 INFO [stdout] test src/lib.rs -  (line 135) ... ok
Nov 18 15:42:30.155 INFO [stdout] test src/lib.rs -  (line 61) ... ok
Nov 18 15:42:30.367 INFO [stdout] test src/lib.rs -  (line 30) ... ok
Nov 18 15:42:30.434 INFO [stdout] test src/lib.rs -  (line 113) ... ok
Nov 18 15:42:30.489 INFO [stdout] test src/lib.rs -  (line 84) ... ok
Nov 18 15:42:30.489 INFO [stdout] 
Nov 18 15:42:30.489 INFO [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 15:42:30.489 INFO [stdout] 
Nov 18 15:42:30.504 INFO [stderr] su: No module specific data is present
Nov 18 15:42:31.089 INFO running `"docker" "inspect" "db47f8716e32abfbfbc13ce7d1eb84ea5deb0a92cea749e3ca7eeb87f918bccc"`
Nov 18 15:42:31.179 INFO running `"docker" "rm" "-f" "db47f8716e32abfbfbc13ce7d1eb84ea5deb0a92cea749e3ca7eeb87f918bccc"`
Nov 18 15:42:31.334 INFO [stdout] db47f8716e32abfbfbc13ce7d1eb84ea5deb0a92cea749e3ca7eeb87f918bccc