Dec 14 20:53:36.669 INFO testing sbd-0.2.0 against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 14 20:53:36.669 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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 14 20:53:37.069 INFO [stdout] 29d3327269c015ccb204033497eb4f0c7b0420bfbe034d6e1b8d6ae2f1410f1b
Dec 14 20:53:37.072 INFO running `"docker" "start" "-a" "29d3327269c015ccb204033497eb4f0c7b0420bfbe034d6e1b8d6ae2f1410f1b"`
Dec 14 20:53:38.338 INFO [stderr] usermod: no changes
Dec 14 20:53:38.555 INFO [stderr]    Compiling sbd v0.2.0 (/source)
Dec 14 20:53:46.731 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 8.35s
Dec 14 20:53:46.739 INFO [stderr] su: No module specific data is present
Dec 14 20:53:47.523 INFO running `"docker" "inspect" "29d3327269c015ccb204033497eb4f0c7b0420bfbe034d6e1b8d6ae2f1410f1b"`
Dec 14 20:53:47.723 INFO running `"docker" "rm" "-f" "29d3327269c015ccb204033497eb4f0c7b0420bfbe034d6e1b8d6ae2f1410f1b"`
Dec 14 20:53:47.971 INFO [stdout] 29d3327269c015ccb204033497eb4f0c7b0420bfbe034d6e1b8d6ae2f1410f1b
Dec 14 20:53:47.973 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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 14 20:53:48.299 INFO [stdout] 41485126899ffb2fca2d76ae17fdbdb116c4dbb4a3be978d0e62b2f22a5f07ef
Dec 14 20:53:48.307 INFO running `"docker" "start" "-a" "41485126899ffb2fca2d76ae17fdbdb116c4dbb4a3be978d0e62b2f22a5f07ef"`
Dec 14 20:53:49.947 INFO [stderr] usermod: no changes
Dec 14 20:53:50.087 INFO [stderr]    Compiling sbd v0.2.0 (/source)
Dec 14 20:53:55.251 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 5.27s
Dec 14 20:53:55.251 INFO [stderr] su: No module specific data is present
Dec 14 20:53:56.196 INFO running `"docker" "inspect" "41485126899ffb2fca2d76ae17fdbdb116c4dbb4a3be978d0e62b2f22a5f07ef"`
Dec 14 20:53:56.493 INFO running `"docker" "rm" "-f" "41485126899ffb2fca2d76ae17fdbdb116c4dbb4a3be978d0e62b2f22a5f07ef"`
Dec 14 20:53:56.860 INFO [stdout] 41485126899ffb2fca2d76ae17fdbdb116c4dbb4a3be978d0e62b2f22a5f07ef
Dec 14 20:53:56.865 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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 14 20:53:57.339 INFO [stdout] 66c5410bb05a6be3974b538f4d5dd605dc323c8c18e4d28bfd4fdfc939f0ff43
Dec 14 20:53:57.345 INFO running `"docker" "start" "-a" "66c5410bb05a6be3974b538f4d5dd605dc323c8c18e4d28bfd4fdfc939f0ff43"`
Dec 14 20:53:58.655 INFO [stderr] usermod: no changes
Dec 14 20:53:58.771 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.12s
Dec 14 20:53:58.791 INFO [stderr]      Running /target/debug/deps/sbd-52f20aa6edab2c8b
Dec 14 20:53:58.791 INFO [stdout] 
Dec 14 20:53:58.791 INFO [stdout] running 29 tests
Dec 14 20:53:58.812 INFO [stdout] test mo::information_element::tests::payload_len ... ok
Dec 14 20:53:58.812 INFO [stdout] test mo::information_element::tests::location_information_len ... ok
Dec 14 20:53:58.812 INFO [stdout] test mo::information_element::tests::header_len ... ok
Dec 14 20:53:58.812 INFO [stdout] test mo::information_element::tests::header_time_of_session_too_old ... ok
Dec 14 20:53:58.812 INFO [stdout] test mo::information_element::tests::payload_too_long ... ok
Dec 14 20:53:58.812 INFO [stdout] test mo::message::tests::from_path ... ok
Dec 14 20:53:58.812 INFO [stdout] test mo::information_element::tests::undersized ... ok
Dec 14 20:53:58.812 INFO [stdout] test mo::message::tests::from_read ... ok
Dec 14 20:53:58.812 INFO [stdout] test mo::message::tests::no_header ... ok
Dec 14 20:53:58.812 INFO [stdout] test mo::message::tests::order ... ok
Dec 14 20:53:58.812 INFO [stdout] test mo::message::tests::no_payload ... ok
Dec 14 20:53:58.812 INFO [stdout] test mo::information_element::tests::roundtrip_payload ... ok
Dec 14 20:53:58.813 INFO [stdout] test mo::message::tests::two_headers ... ok
Dec 14 20:53:58.813 INFO [stdout] test mo::message::tests::undersized ... ok
Dec 14 20:53:58.813 INFO [stdout] test mo::message::tests::two_payloads ... ok
Dec 14 20:53:58.813 INFO [stdout] test mo::message::tests::values ... ok
Dec 14 20:53:58.813 INFO [stdout] test mo::message::tests::write ... ok
Dec 14 20:53:58.823 INFO [stdout] test storage::filesystem::tests::file_is_error ... ok
Dec 14 20:53:58.823 INFO [stdout] test mo::information_element::tests::read_from ... ok
Dec 14 20:53:58.823 INFO [stdout] test mo::information_element::tests::roundtrip_header ... ok
Dec 14 20:53:58.823 INFO [stdout] test mo::message::tests::from_path_that_is_not_an_sbd_message ... ok
Dec 14 20:53:58.823 INFO [stdout] test mo::message::tests::from_path_that_doesnt_exist ... ok
Dec 14 20:53:58.823 INFO [stdout] test mo::information_element::tests::roundtrip_location_information ... ok
Dec 14 20:53:58.823 INFO [stdout] test storage::filesystem::tests::store ... ok
Dec 14 20:53:58.827 INFO [stdout] test storage::filesystem::tests::open ... ok
Dec 14 20:53:58.827 INFO [stdout] test storage::filesystem::tests::no_directory ... ok
Dec 14 20:53:58.831 INFO [stdout] test storage::filesystem::tests::messages_from_imei ... ok
Dec 14 20:53:58.831 INFO [stdout] test storage::filesystem::tests::iter ... ok
Dec 14 20:53:58.831 INFO [stdout] test storage::memory::tests::store ... ok
Dec 14 20:53:58.831 INFO [stdout] 
Dec 14 20:53:58.831 INFO [stdout] test result: ok. 29 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 20:53:58.831 INFO [stdout] 
Dec 14 20:53:58.839 INFO [stderr]      Running /target/debug/deps/sbd-fcd5966d00b2f729
Dec 14 20:53:58.847 INFO [stderr]    Doc-tests sbd
Dec 14 20:53:58.847 INFO [stdout] 
Dec 14 20:53:58.847 INFO [stdout] running 0 tests
Dec 14 20:53:58.847 INFO [stdout] 
Dec 14 20:53:58.847 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 20:53:58.847 INFO [stdout] 
Dec 14 20:54:00.613 INFO [stdout] 
Dec 14 20:54:00.613 INFO [stdout] running 23 tests
Dec 14 20:54:13.131 INFO [stdout] test src/mo/message.rs - mo::message::Message::imei (line 143) ... ok
Dec 14 20:54:14.763 INFO [stdout] test src/directip.rs - directip::Server<A, S>::bind (line 65) ... ok
Dec 14 20:54:16.979 INFO [stdout] test src/lib.rs -  (line 33) ... ok
Dec 14 20:54:17.066 INFO [stdout] test src/lib.rs -  (line 25) ... ok
Dec 14 20:54:18.387 INFO [stdout] test src/mo/message.rs - mo::message::Message::from_path (line 25) ... ok
Dec 14 20:54:18.777 INFO [stdout] test src/directip.rs - directip::Server<A, S>::serve_forever (line 84) ... ok
Dec 14 20:54:19.396 INFO [stdout] test src/directip.rs - directip::Server<A, S>::new (line 46) ... ok
Dec 14 20:54:19.397 INFO [stdout] test src/mo/message.rs - mo::message::Message::auto_id (line 125) ... ok
Dec 14 20:54:25.887 INFO [stdout] test src/mo/message.rs - mo::message::Message::new (line 75) ... ok
Dec 14 20:54:27.440 INFO [stdout] test src/mo/message.rs - mo::message::Message::momsn (line 170) ... ok
Dec 14 20:54:31.042 INFO [stdout] test src/mo/message.rs - mo::message::Message::mtmsn (line 183) ... ok
Dec 14 20:54:33.918 INFO [stdout] test src/mo/message.rs - mo::message::Message::payload (line 209) ... ok
Dec 14 20:54:34.099 INFO [stdout] test src/mo/message.rs - mo::message::Message::read_from (line 41) ... ok
Dec 14 20:54:34.775 INFO [stdout] test src/mo/message.rs - mo::message::Message::time_of_session (line 196) ... ok
Dec 14 20:54:34.807 INFO [stdout] test src/mo/message.rs - mo::message::Message::write_to (line 222) ... ok
Dec 14 20:54:35.454 INFO [stdout] test src/mo/message.rs - mo::message::Message::session_status (line 157) ... ok
Dec 14 20:54:38.115 INFO [stdout] test src/mo/session_status.rs - mo::session_status::SessionStatus::new (line 37) ... ok
Dec 14 20:54:42.311 INFO [stdout] test src/storage/filesystem.rs - storage::filesystem::Storage::iter (line 53) ... ok
Dec 14 20:54:44.959 INFO [stdout] test src/storage/filesystem.rs - storage::filesystem::Storage::open (line 33) ... ok
Dec 14 20:54:45.427 INFO [stdout] test src/storage/mod.rs - storage::Storage::messages_from_imei (line 49) ... ok
Dec 14 20:54:45.847 INFO [stdout] test src/storage/memory.rs - storage::memory::Storage::new (line 20) ... ok
Dec 14 20:54:46.583 INFO [stdout] test src/storage/mod.rs - storage::Storage::messages (line 31) ... ok
Dec 14 20:54:46.911 INFO [stdout] test src/storage/mod.rs - storage::Storage::store (line 18) ... ok
Dec 14 20:54:46.911 INFO [stdout] 
Dec 14 20:54:46.911 INFO [stdout] test result: ok. 23 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 20:54:46.911 INFO [stdout] 
Dec 14 20:54:46.965 INFO [stderr] su: No module specific data is present
Dec 14 20:54:47.449 INFO running `"docker" "inspect" "66c5410bb05a6be3974b538f4d5dd605dc323c8c18e4d28bfd4fdfc939f0ff43"`
Dec 14 20:54:47.651 INFO running `"docker" "rm" "-f" "66c5410bb05a6be3974b538f4d5dd605dc323c8c18e4d28bfd4fdfc939f0ff43"`
Dec 14 20:54:47.939 INFO [stdout] 66c5410bb05a6be3974b538f4d5dd605dc323c8c18e4d28bfd4fdfc939f0ff43