Nov 18 15:42:03.462 INFO testing ds1307-0.2.0 against try#2e026d6e5d7621634147ad4c8074f1d964dbb1be for pr-55982
Nov 18 15:42:03.462 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 18 15:42:03.679 INFO [stdout] 1d26fb2c9926e3bcc9e153772a67bf3b074692b8203455c10134527bd4fe4010
Nov 18 15:42:03.684 INFO running `"docker" "start" "-a" "1d26fb2c9926e3bcc9e153772a67bf3b074692b8203455c10134527bd4fe4010"`
Nov 18 15:42:04.052 INFO [stderr] usermod: no changes
Nov 18 15:42:04.134 INFO [stderr]    Compiling ds1307 v0.2.0 (/source)
Nov 18 15:42:04.819 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.74s
Nov 18 15:42:04.825 INFO [stderr] su: No module specific data is present
Nov 18 15:42:05.751 INFO running `"docker" "inspect" "1d26fb2c9926e3bcc9e153772a67bf3b074692b8203455c10134527bd4fe4010"`
Nov 18 15:42:06.007 INFO running `"docker" "rm" "-f" "1d26fb2c9926e3bcc9e153772a67bf3b074692b8203455c10134527bd4fe4010"`
Nov 18 15:42:06.311 INFO [stdout] 1d26fb2c9926e3bcc9e153772a67bf3b074692b8203455c10134527bd4fe4010
Nov 18 15:42:06.313 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 18 15:42:06.800 INFO [stdout] 48a7c22a4001e4ca6b45d7a85c3811cc28fad6a3624a625f9f6ba96b13c0d00b
Nov 18 15:42:06.802 INFO running `"docker" "start" "-a" "48a7c22a4001e4ca6b45d7a85c3811cc28fad6a3624a625f9f6ba96b13c0d00b"`
Nov 18 15:42:07.921 INFO [stderr] usermod: no changes
Nov 18 15:42:08.175 INFO [stderr]    Compiling ds1307 v0.2.0 (/source)
Nov 18 15:42:19.883 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 11.93s
Nov 18 15:42:19.892 INFO [stderr] su: No module specific data is present
Nov 18 15:42:20.369 INFO running `"docker" "inspect" "48a7c22a4001e4ca6b45d7a85c3811cc28fad6a3624a625f9f6ba96b13c0d00b"`
Nov 18 15:42:20.555 INFO running `"docker" "rm" "-f" "48a7c22a4001e4ca6b45d7a85c3811cc28fad6a3624a625f9f6ba96b13c0d00b"`
Nov 18 15:42:20.804 INFO [stdout] 48a7c22a4001e4ca6b45d7a85c3811cc28fad6a3624a625f9f6ba96b13c0d00b
Nov 18 15:42:20.815 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 18 15:42:21.167 INFO [stdout] d0d921f35ef06602204db71b015b4e954854dae7485b148d078c8e70b22c3202
Nov 18 15:42:21.174 INFO running `"docker" "start" "-a" "d0d921f35ef06602204db71b015b4e954854dae7485b148d078c8e70b22c3202"`
Nov 18 15:42:22.107 INFO [stderr] usermod: no changes
Nov 18 15:42:22.267 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.13s
Nov 18 15:42:22.279 INFO [stderr]      Running /target/debug/deps/ds1307-e4bf6cd706159502
Nov 18 15:42:22.285 INFO [stdout] 
Nov 18 15:42:22.285 INFO [stdout] running 2 tests
Nov 18 15:42:22.291 INFO [stdout] test datetime::tests::can_convert_packed_bcd_to_decimal ... ok
Nov 18 15:42:22.291 INFO [stdout] test datetime::tests::can_convert_decimal_to_packed_bcd ... ok
Nov 18 15:42:22.292 INFO [stdout] 
Nov 18 15:42:22.292 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 15:42:22.292 INFO [stdout] 
Nov 18 15:42:22.293 INFO [stderr]      Running /target/debug/deps/datetime-641b19a5e645282d
Nov 18 15:42:22.293 INFO [stdout] 
Nov 18 15:42:22.293 INFO [stdout] running 10 tests
Nov 18 15:42:22.294 INFO [stdout] test can_set_datetime ... ok
Nov 18 15:42:22.294 INFO [stdout] test can_read_datetime ... ok
Nov 18 15:42:22.294 INFO [stdout] test when_set_datetime_ch_bit_is_unchanged ... ok
Nov 18 15:42:22.295 INFO [stdout] test wrong_day_returns_error ... ok
Nov 18 15:42:22.295 INFO [stdout] test wrong_year_returns_error ... ok
Nov 18 15:42:22.295 INFO [stdout] test wrong_minute_returns_error ... ok
Nov 18 15:42:22.296 INFO [stdout] test wrong_second_returns_error ... ok
Nov 18 15:42:22.296 INFO [stdout] test wrong_hour_returns_error ... ok
Nov 18 15:42:22.296 INFO [stdout] test wrong_weekday_returns_error ... ok
Nov 18 15:42:22.297 INFO [stdout] test wrong_month_returns_error ... ok
Nov 18 15:42:22.297 INFO [stdout] 
Nov 18 15:42:22.297 INFO [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 15:42:22.298 INFO [stdout] 
Nov 18 15:42:22.298 INFO [stdout] 
Nov 18 15:42:22.298 INFO [stdout] running 4 tests
Nov 18 15:42:22.299 INFO [stderr]      Running /target/debug/deps/day_of_month-50793ed55561045b
Nov 18 15:42:22.302 INFO [stdout] test can_read_day_of_month ... ok
Nov 18 15:42:22.302 INFO [stdout] test can_write_day_of_month ... ok
Nov 18 15:42:22.307 INFO [stdout] test too_big_day_of_month_returns_error ... ok
Nov 18 15:42:22.307 INFO [stdout] test too_small_day_of_month_returns_error ... ok
Nov 18 15:42:22.307 INFO [stdout] 
Nov 18 15:42:22.307 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 15:42:22.307 INFO [stdout] 
Nov 18 15:42:22.308 INFO [stderr]      Running /target/debug/deps/day_of_week-e03b9e9a1b8724f6
Nov 18 15:42:22.316 INFO [stdout] 
Nov 18 15:42:22.316 INFO [stdout] running 4 tests
Nov 18 15:42:22.316 INFO [stdout] test can_read_weekday ... ok
Nov 18 15:42:22.316 INFO [stdout] test too_big_weekday_returns_error ... ok
Nov 18 15:42:22.319 INFO [stdout] test can_write_weekday ... ok
Nov 18 15:42:22.319 INFO [stdout] test too_small_weekday_returns_error ... ok
Nov 18 15:42:22.319 INFO [stdout] 
Nov 18 15:42:22.319 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 15:42:22.319 INFO [stdout] 
Nov 18 15:42:22.323 INFO [stderr]      Running /target/debug/deps/hours-15da03157c4842fc
Nov 18 15:42:22.343 INFO [stdout] 
Nov 18 15:42:22.343 INFO [stdout] running 11 tests
Nov 18 15:42:22.343 INFO [stdout] test can_read_12h_am_hours ... ok
Nov 18 15:42:22.343 INFO [stdout] test can_write_12h_pm_hours ... ok
Nov 18 15:42:22.343 INFO [stdout] test can_write_24h_hours ... ok
Nov 18 15:42:22.343 INFO [stdout] test too_big_12h_am_hours_returns_error ... ok
Nov 18 15:42:22.343 INFO [stdout] test wrong_24h_hours_returns_error ... ok
Nov 18 15:42:22.343 INFO [stdout] test too_small_12h_pm_hours_returns_error ... ok
Nov 18 15:42:22.343 INFO [stdout] test too_small_12h_am_hours_returns_error ... ok
Nov 18 15:42:22.351 INFO [stdout] test can_read_24h_hours ... ok
Nov 18 15:42:22.351 INFO [stdout] test can_write_12h_am_hours ... ok
Nov 18 15:42:22.351 INFO [stdout] test can_read_12h_pm_hours ... ok
Nov 18 15:42:22.355 INFO [stdout] test too_big_12h_pm_hours_returns_error ... ok
Nov 18 15:42:22.355 INFO [stderr]      Running /target/debug/deps/minutes-9e3c9dca92b49f0c
Nov 18 15:42:22.355 INFO [stdout] 
Nov 18 15:42:22.355 INFO [stdout] test result: ok. 11 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 15:42:22.355 INFO [stdout] 
Nov 18 15:42:22.363 INFO [stdout] 
Nov 18 15:42:22.363 INFO [stderr]      Running /target/debug/deps/month-163df8a8aad3e82e
Nov 18 15:42:22.363 INFO [stdout] running 3 tests
Nov 18 15:42:22.363 INFO [stdout] test wrong_minutes_returns_error ... ok
Nov 18 15:42:22.363 INFO [stdout] test can_write_minutes ... ok
Nov 18 15:42:22.363 INFO [stdout] test can_read_minutes ... ok
Nov 18 15:42:22.363 INFO [stdout] 
Nov 18 15:42:22.363 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 15:42:22.363 INFO [stdout] 
Nov 18 15:42:22.363 INFO [stdout] 
Nov 18 15:42:22.363 INFO [stdout] running 4 tests
Nov 18 15:42:22.363 INFO [stdout] test can_read_month ... ok
Nov 18 15:42:22.363 INFO [stdout] test too_small_month_returns_error ... ok
Nov 18 15:42:22.379 INFO [stdout] test too_big_month_returns_error ... ok
Nov 18 15:42:22.379 INFO [stderr]      Running /target/debug/deps/run_halt-0d7f77dd8bc8bca6
Nov 18 15:42:22.379 INFO [stdout] test can_write_month ... ok
Nov 18 15:42:22.379 INFO [stdout] 
Nov 18 15:42:22.379 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 15:42:22.379 INFO [stdout] 
Nov 18 15:42:22.379 INFO [stdout] 
Nov 18 15:42:22.379 INFO [stdout] running 8 tests
Nov 18 15:42:22.379 INFO [stdout] test set_running_when_already_running_does_nothing ... ok
Nov 18 15:42:22.379 INFO [stdout] test run_keeps_seconds ... ok
Nov 18 15:42:22.379 INFO [stdout] test halt_when_already_halted_does_nothing ... ok
Nov 18 15:42:22.379 INFO [stdout] test halt_keeps_seconds ... ok
Nov 18 15:42:22.379 INFO [stdout] test can_read_is_running_halted ... ok
Nov 18 15:42:22.379 INFO [stdout] test can_halt ... ok
Nov 18 15:42:22.387 INFO [stdout] test can_read_is_running_running ... ok
Nov 18 15:42:22.387 INFO [stderr]      Running /target/debug/deps/seconds-1e4b4bf2241c1379
Nov 18 15:42:22.387 INFO [stdout] test can_set_running ... ok
Nov 18 15:42:22.387 INFO [stderr]      Running /target/debug/deps/sqwout_enable_disable-024b2c8b4a2d2105
Nov 18 15:42:22.387 INFO [stdout] 
Nov 18 15:42:22.387 INFO [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 15:42:22.387 INFO [stdout] 
Nov 18 15:42:22.387 INFO [stdout] 
Nov 18 15:42:22.387 INFO [stdout] running 5 tests
Nov 18 15:42:22.387 INFO [stdout] test wrong_seconds_returns_error ... ok
Nov 18 15:42:22.387 INFO [stdout] test ch_bit_is_kept_when_writing_seconds ... ok
Nov 18 15:42:22.387 INFO [stdout] test ch_bit_is_ignored ... ok
Nov 18 15:42:22.387 INFO [stdout] test can_write_seconds ... ok
Nov 18 15:42:22.387 INFO [stdout] test can_read_seconds ... ok
Nov 18 15:42:22.387 INFO [stdout] 
Nov 18 15:42:22.387 INFO [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 15:42:22.387 INFO [stdout] 
Nov 18 15:42:22.392 INFO [stdout] 
Nov 18 15:42:22.392 INFO [stdout] running 8 tests
Nov 18 15:42:22.393 INFO [stdout] test when_already_enabled_then_enable_does_nothing ... ok
Nov 18 15:42:22.393 INFO [stdout] test when_already_disabled_then_disable_does_nothing ... ok
Nov 18 15:42:22.393 INFO [stdout] test enable_keeps_status_of_other_flags ... ok
Nov 18 15:42:22.393 INFO [stdout] test disable_keeps_status_of_other_flags ... ok
Nov 18 15:42:22.393 INFO [stdout] test can_read_is_not_enabled ... ok
Nov 18 15:42:22.393 INFO [stdout] test can_disable ... ok
Nov 18 15:42:22.393 INFO [stdout] test can_read_is_enabled ... ok
Nov 18 15:42:22.399 INFO [stdout] test can_enable ... ok
Nov 18 15:42:22.399 INFO [stdout] 
Nov 18 15:42:22.399 INFO [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 15:42:22.399 INFO [stdout] 
Nov 18 15:42:22.403 INFO [stderr]      Running /target/debug/deps/sqwout_output_level-04b50ec4b3421aae
Nov 18 15:42:22.407 INFO [stdout] 
Nov 18 15:42:22.407 INFO [stdout] running 9 tests
Nov 18 15:42:22.407 INFO [stdout] test can_write_output_level_parameter_low ... ok
Nov 18 15:42:22.407 INFO [stdout] test can_write_output_level_parameter_high ... ok
Nov 18 15:42:22.407 INFO [stdout] test can_write_low_output_level ... ok
Nov 18 15:42:22.407 INFO [stdout] test can_write_high_output_level ... ok
Nov 18 15:42:22.407 INFO [stdout] test write_output_level_keeps_status_of_other_flags ... ok
Nov 18 15:42:22.407 INFO [stdout] test can_read_output_level_high ... ok
Nov 18 15:42:22.411 INFO [stdout] test when_already_high_then_set_level_low_does_nothing ... ok
Nov 18 15:42:22.411 INFO [stderr]      Running /target/debug/deps/sqwout_rate-842c6a2b78b64fc4
Nov 18 15:42:22.411 INFO [stdout] test when_already_low_then_set_level_low_does_nothing ... ok
Nov 18 15:42:22.411 INFO [stdout] test can_read_output_level_low ... ok
Nov 18 15:42:22.411 INFO [stdout] 
Nov 18 15:42:22.411 INFO [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 15:42:22.411 INFO [stdout] 
Nov 18 15:42:22.411 INFO [stdout] 
Nov 18 15:42:22.411 INFO [stdout] running 5 tests
Nov 18 15:42:22.412 INFO [stdout] test can_set_output_rate_to_11 ... ok
Nov 18 15:42:22.412 INFO [stdout] test can_set_output_rate_00 ... ok
Nov 18 15:42:22.412 INFO [stdout] test can_read_output_rate ... ok
Nov 18 15:42:22.415 INFO [stdout] test set_output_rate_keeps_status_of_other_flags ... ok
Nov 18 15:42:22.415 INFO [stdout] test set_output_rate_to_same_rate_does_nothing ... ok
Nov 18 15:42:22.415 INFO [stdout] 
Nov 18 15:42:22.415 INFO [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 15:42:22.415 INFO [stdout] 
Nov 18 15:42:22.419 INFO [stdout] 
Nov 18 15:42:22.419 INFO [stderr]      Running /target/debug/deps/user_ram-1d8de6c266e9cc27
Nov 18 15:42:22.419 INFO [stdout] running 12 tests
Nov 18 15:42:22.435 INFO [stdout] test can_write_last_ram_address ... ok
Nov 18 15:42:22.435 INFO [stdout] test can_read_whole_ram ... ok
Nov 18 15:42:22.435 INFO [stdout] test can_read_last_ram_address ... ok
Nov 18 15:42:22.435 INFO [stdout] test can_write_whole_ram ... ok
Nov 18 15:42:22.435 INFO [stdout] test empty_data_read_does_nothing ... ok
Nov 18 15:42:22.435 INFO [stdout] test too_much_data_write_returns_error ... ok
Nov 18 15:42:22.443 INFO [stdout] test too_long_array_read_returns_error ... ok
Nov 18 15:42:22.443 INFO [stderr]      Running /target/debug/deps/year-5734353893030a5c
Nov 18 15:42:22.443 INFO [stdout] test too_big_address_offset_write_returns_error ... ok
Nov 18 15:42:22.443 INFO [stdout] test too_long_array_write_returns_error ... ok
Nov 18 15:42:22.443 INFO [stdout] test too_much_data_read_returns_error ... ok
Nov 18 15:42:22.443 INFO [stdout] test empty_data_write_does_nothing ... ok
Nov 18 15:42:22.443 INFO [stdout] test too_big_address_offset_read_returns_error ... ok
Nov 18 15:42:22.443 INFO [stdout] 
Nov 18 15:42:22.443 INFO [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 15:42:22.443 INFO [stdout] 
Nov 18 15:42:22.448 INFO [stdout] 
Nov 18 15:42:22.448 INFO [stdout] running 4 tests
Nov 18 15:42:22.449 INFO [stdout] test can_write_year ... ok
Nov 18 15:42:22.449 INFO [stdout] test too_small_year_returns_error ... ok
Nov 18 15:42:22.449 INFO [stdout] test too_big_year_returns_error ... ok
Nov 18 15:42:22.449 INFO [stdout] test can_read_year ... ok
Nov 18 15:42:22.449 INFO [stdout] 
Nov 18 15:42:22.449 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 15:42:22.449 INFO [stdout] 
Nov 18 15:42:22.455 INFO [stderr]    Doc-tests ds1307
Nov 18 15:42:23.579 INFO [stdout] 
Nov 18 15:42:23.579 INFO [stdout] running 6 tests
Nov 18 15:42:29.475 INFO [stdout] test src/lib.rs -  (line 84) ... ok
Nov 18 15:42:29.820 INFO [stdout] test src/lib.rs -  (line 30) ... ok
Nov 18 15:42:30.079 INFO [stdout] test src/lib.rs -  (line 61) ... ok
Nov 18 15:42:30.763 INFO [stdout] test src/lib.rs -  (line 135) ... ok
Nov 18 15:42:30.960 INFO [stdout] test src/lib.rs -  (line 46) ... ok
Nov 18 15:42:30.964 INFO [stdout] test src/lib.rs -  (line 113) ... ok
Nov 18 15:42:30.964 INFO [stdout] 
Nov 18 15:42:30.964 INFO [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 15:42:30.964 INFO [stdout] 
Nov 18 15:42:30.977 INFO [stderr] su: No module specific data is present
Nov 18 15:42:31.345 INFO running `"docker" "inspect" "d0d921f35ef06602204db71b015b4e954854dae7485b148d078c8e70b22c3202"`
Nov 18 15:42:31.512 INFO running `"docker" "rm" "-f" "d0d921f35ef06602204db71b015b4e954854dae7485b148d078c8e70b22c3202"`
Nov 18 15:42:31.669 INFO [stdout] d0d921f35ef06602204db71b015b4e954854dae7485b148d078c8e70b22c3202