Dec 02 17:58:16.445 INFO testing sandbox-ipc-0.4.0 against 1.30.1 for beta-1.31-5
Dec 02 17:58:16.445 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-2/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/beta-1.31-5/1.30.1:/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 +1.30.1 build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 02 17:58:16.755 INFO [stdout] d6f0b418520705106873e16fc8b56251394801dffe2d9839148a396259e2fe81
Dec 02 17:58:16.763 INFO running `"docker" "start" "-a" "d6f0b418520705106873e16fc8b56251394801dffe2d9839148a396259e2fe81"`
Dec 02 17:58:17.656 INFO [stderr] usermod: no changes
Dec 02 17:58:17.825 INFO [stderr]    Compiling serde v1.0.80
Dec 02 17:58:30.899 INFO [stderr]    Compiling uuid v0.5.1
Dec 02 17:58:30.899 INFO [stderr]    Compiling bincode v0.9.2
Dec 02 17:58:33.725 INFO [stderr]    Compiling sandbox-ipc v0.4.0 (/source)
Dec 02 17:58:39.080 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 21.39s
Dec 02 17:58:39.091 INFO [stderr] su: No module specific data is present
Dec 02 17:58:39.852 INFO running `"docker" "inspect" "d6f0b418520705106873e16fc8b56251394801dffe2d9839148a396259e2fe81"`
Dec 02 17:58:40.244 INFO running `"docker" "rm" "-f" "d6f0b418520705106873e16fc8b56251394801dffe2d9839148a396259e2fe81"`
Dec 02 17:58:40.595 INFO [stdout] d6f0b418520705106873e16fc8b56251394801dffe2d9839148a396259e2fe81
Dec 02 17:58:40.597 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-2/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/beta-1.31-5/1.30.1:/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 +1.30.1 test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 02 17:58:41.004 INFO [stdout] e6d468d9b40ae85e3fb10de8134a7725a874a29daf68b2fe73e93e43f5190221
Dec 02 17:58:41.007 INFO running `"docker" "start" "-a" "e6d468d9b40ae85e3fb10de8134a7725a874a29daf68b2fe73e93e43f5190221"`
Dec 02 17:58:43.615 INFO [stderr] usermod: no changes
Dec 02 17:58:43.786 INFO [stderr]    Compiling serde_json v1.0.33
Dec 02 17:58:48.259 INFO [stderr]    Compiling sandbox-ipc v0.4.0 (/source)
Dec 02 17:58:57.367 INFO [stderr] warning: use of deprecated item 'tokio_all::runtime::Runtime::reactor': there is now a reactor per worker thread
Dec 02 17:58:57.367 INFO [stderr]    --> src/io.rs:170:81
Dec 02 17:58:57.367 INFO [stderr]     |
Dec 02 17:58:57.367 INFO [stderr] 170 |         let (a, b) = MessageChannel::<SendableFile, SendableFile>::pair(runtime.reactor(), 8192).unwrap();
Dec 02 17:58:57.367 INFO [stderr]     |                                                                                 ^^^^^^^
Dec 02 17:58:57.367 INFO [stderr]     |
Dec 02 17:58:57.367 INFO [stderr]     = note: #[warn(deprecated)] on by default
Dec 02 17:58:57.367 INFO [stderr] 
Dec 02 17:58:57.519 INFO [stderr] warning: use of deprecated item 'tokio_all::runtime::Runtime::reactor': there is now a reactor per worker thread
Dec 02 17:58:57.519 INFO [stderr]    --> src/shm/mod.rs:122:51
Dec 02 17:58:57.519 INFO [stderr]     |
Dec 02 17:58:57.519 INFO [stderr] 122 |         let (a, b) = MessageChannel::pair(runtime.reactor(), 8192).unwrap();
Dec 02 17:58:57.519 INFO [stderr]     |                                                   ^^^^^^^
Dec 02 17:58:57.519 INFO [stderr] 
Dec 02 17:58:58.481 INFO [stderr] warning: use of deprecated item 'tokio::runtime::Runtime::reactor': there is now a reactor per worker thread
Dec 02 17:58:58.481 INFO [stderr]   --> tests/named_channel.rs:22:84
Dec 02 17:58:58.482 INFO [stderr]    |
Dec 02 17:58:58.482 INFO [stderr] 22 |         let channel = NamedMessageChannel::connect(&channel_name, None, tokio_loop.reactor(), 8192).unwrap();
Dec 02 17:58:58.482 INFO [stderr]    |                                                                                    ^^^^^^^
Dec 02 17:58:58.482 INFO [stderr]    |
Dec 02 17:58:58.483 INFO [stderr]    = note: #[warn(deprecated)] on by default
Dec 02 17:58:58.483 INFO [stderr] 
Dec 02 17:58:58.484 INFO [stderr] warning: use of deprecated item 'tokio::runtime::Runtime::reactor': there is now a reactor per worker thread
Dec 02 17:58:58.484 INFO [stderr]   --> tests/named_channel.rs:27:66
Dec 02 17:58:58.485 INFO [stderr]    |
Dec 02 17:58:58.485 INFO [stderr] 27 |         let channel_server = NamedMessageChannel::new(tokio_loop.reactor(), 8192).unwrap();
Dec 02 17:58:58.485 INFO [stderr]    |                                                                  ^^^^^^^
Dec 02 17:58:58.485 INFO [stderr] 
Dec 02 17:59:00.079 INFO [stderr] warning: use of deprecated item 'tokio::runtime::Runtime::reactor': there is now a reactor per worker thread
Dec 02 17:59:00.079 INFO [stderr]   --> tests/child_channel.rs:22:66
Dec 02 17:59:00.080 INFO [stderr]    |
Dec 02 17:59:00.080 INFO [stderr] 22 |         let channel = channel_serialized.into_channel(tokio_loop.reactor()).unwrap();
Dec 02 17:59:00.080 INFO [stderr]    |                                                                  ^^^^^^^
Dec 02 17:59:00.103 INFO [stderr]    |
Dec 02 17:59:00.103 INFO [stderr]    = note: #[warn(deprecated)] on by default
Dec 02 17:59:00.103 INFO [stderr] 
Dec 02 17:59:00.104 INFO [stderr] warning: use of deprecated item 'tokio::runtime::Runtime::reactor': there is now a reactor per worker thread
Dec 02 17:59:00.104 INFO [stderr]   --> tests/child_channel.rs:29:104
Dec 02 17:59:00.104 INFO [stderr]    |
Dec 02 17:59:00.105 INFO [stderr] 29 |         let (a, mut child) = MessageChannel::establish_with_child(&mut child_command, 8192, tokio_loop.reactor(), |command, child_channel| {
Dec 02 17:59:00.105 INFO [stderr]    |                                                                                                        ^^^^^^^
Dec 02 17:59:00.131 INFO [stderr] 
Dec 02 17:59:08.116 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 24.47s
Dec 02 17:59:08.141 INFO [stderr] su: No module specific data is present
Dec 02 17:59:09.350 INFO running `"docker" "inspect" "e6d468d9b40ae85e3fb10de8134a7725a874a29daf68b2fe73e93e43f5190221"`
Dec 02 17:59:09.573 INFO running `"docker" "rm" "-f" "e6d468d9b40ae85e3fb10de8134a7725a874a29daf68b2fe73e93e43f5190221"`
Dec 02 17:59:09.865 INFO [stdout] e6d468d9b40ae85e3fb10de8134a7725a874a29daf68b2fe73e93e43f5190221
Dec 02 17:59:09.869 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-2/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/beta-1.31-5/1.30.1:/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 +1.30.1 test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 02 17:59:10.262 INFO [stdout] fd2928509d6a138df7ab0d8bd94ec9b3cba33238fbf46787c59afc68d1c50a40
Dec 02 17:59:10.271 INFO running `"docker" "start" "-a" "fd2928509d6a138df7ab0d8bd94ec9b3cba33238fbf46787c59afc68d1c50a40"`
Dec 02 17:59:11.227 INFO [stderr] usermod: no changes
Dec 02 17:59:11.395 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.14s
Dec 02 17:59:11.413 INFO [stderr]      Running /target/debug/deps/sandbox_ipc-09c7d077a97ddbcb
Dec 02 17:59:11.417 INFO [stdout] 
Dec 02 17:59:11.417 INFO [stdout] running 16 tests
Dec 02 17:59:11.427 INFO [stdout] test channel::tests::pre_raw_message_channel_is_send ... ok
Dec 02 17:59:11.428 INFO [stdout] test channel::tests::process_handle_is_send ... ok
Dec 02 17:59:11.430 INFO [stdout] test shm::queue::tests::full_queue_emptied_try_pop ... ok
Dec 02 17:59:11.430 INFO [stdout] test shm::queue::tests::empty_queue_try_pop ... ok
Dec 02 17:59:11.432 INFO [stdout] test shm::tests::big_shm ... ok
Dec 02 17:59:11.434 INFO [stdout] test sync::tests::mutex_is_send ... ok
Dec 02 17:59:11.438 INFO [stdout] test shm::tests::shared_mem_is_send ... ok
Dec 02 17:59:11.451 INFO [stdout] test shm::queue::tests::full_queue_try_push ... ok
Dec 02 17:59:11.451 INFO [stdout] test shm::tests::shared_mem_map_is_send ... ok
Dec 02 17:59:11.511 INFO [stdout] test sync::tests::uncontested_mutex_lock ... ok
Dec 02 17:59:11.511 INFO [stdout] test tests::raw_message_channel_pair ... ok
Dec 02 17:59:11.511 INFO [stdout] test tests::named_message_channel_pair ... ok
Dec 02 17:59:11.535 INFO [stdout] test shm::queue::tests::contested_fill_and_empty ... ok
Dec 02 17:59:11.535 INFO [stdout] test io::tests::send_file_same_process ... ok
Dec 02 17:59:11.549 INFO [stdout] test shm::tests::send_mem_same_process ... ok
Dec 02 17:59:11.614 INFO [stdout] test sync::tests::single_process_contested_mutex_lock ... ok
Dec 02 17:59:11.614 INFO [stderr]      Running /target/debug/deps/child_channel-19557dfcc9fd90fa
Dec 02 17:59:11.614 INFO [stdout] 
Dec 02 17:59:11.614 INFO [stdout] test result: ok. 16 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 02 17:59:11.614 INFO [stdout] 
Dec 02 17:59:11.631 INFO [stdout] parent sent hello
Dec 02 17:59:11.639 INFO [stdout] child received hello
Dec 02 17:59:11.639 INFO [stdout] child sent ehlo
Dec 02 17:59:11.639 INFO [stdout] parent received ehlo
Dec 02 17:59:11.663 INFO [stdout] parent sent file handle
Dec 02 17:59:11.682 INFO [stdout] child received file handle
Dec 02 17:59:11.687 INFO [stdout] child sent file contents
Dec 02 17:59:11.687 INFO [stdout] child sent file handle
Dec 02 17:59:11.687 INFO [stdout] parent received file contents
Dec 02 17:59:11.695 INFO [stdout] parent received file handle
Dec 02 17:59:11.709 INFO [stdout] child received file contents
Dec 02 17:59:11.710 INFO [stdout] parent sent file contents
Dec 02 17:59:11.710 INFO [stdout] parent sent socket
Dec 02 17:59:11.723 INFO [stdout] parent sent mutex
Dec 02 17:59:11.723 INFO [stdout] child received mutex
Dec 02 17:59:11.820 INFO [stdout] child send shared memory write ack
Dec 02 17:59:11.823 INFO [stdout] received shared memory write ack
Dec 02 17:59:11.825 INFO [stderr]      Running /target/debug/deps/named_channel-8239e678de1da37e
Dec 02 17:59:11.847 INFO [stdout] parent sent hello
Dec 02 17:59:11.851 INFO [stdout] child received hello
Dec 02 17:59:11.859 INFO [stdout] child sent ehlo
Dec 02 17:59:11.859 INFO [stdout] parent received ehlo
Dec 02 17:59:11.859 INFO [stdout] parent sent file handle
Dec 02 17:59:11.868 INFO [stdout] child received file handle
Dec 02 17:59:11.868 INFO [stdout] child sent file contents
Dec 02 17:59:11.880 INFO [stdout] parent received file contents
Dec 02 17:59:11.895 INFO [stdout] child sent file handle
Dec 02 17:59:11.895 INFO [stdout] parent received file handle
Dec 02 17:59:11.895 INFO [stdout] parent sent file contents
Dec 02 17:59:11.896 INFO [stdout] parent sent socket
Dec 02 17:59:11.897 INFO [stdout] parent sent mutex
Dec 02 17:59:11.915 INFO [stdout] child received file contents
Dec 02 17:59:11.915 INFO [stdout] child received mutex
Dec 02 17:59:12.003 INFO [stdout] child send shared memory write ack
Dec 02 17:59:12.003 INFO [stdout] received shared memory write ack
Dec 02 17:59:12.015 INFO [stderr]    Doc-tests sandbox-ipc
Dec 02 17:59:17.382 INFO [stdout] 
Dec 02 17:59:17.382 INFO [stdout] running 1 test
Dec 02 17:59:26.623 INFO [stdout] test src/lib.rs -  (line 7) ... ok
Dec 02 17:59:26.623 INFO [stdout] 
Dec 02 17:59:26.623 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 02 17:59:26.623 INFO [stdout] 
Dec 02 17:59:26.643 INFO [stderr] su: No module specific data is present
Dec 02 17:59:27.793 INFO running `"docker" "inspect" "fd2928509d6a138df7ab0d8bd94ec9b3cba33238fbf46787c59afc68d1c50a40"`
Dec 02 17:59:28.069 INFO running `"docker" "rm" "-f" "fd2928509d6a138df7ab0d8bd94ec9b3cba33238fbf46787c59afc68d1c50a40"`
Dec 02 17:59:28.339 INFO [stdout] fd2928509d6a138df7ab0d8bd94ec9b3cba33238fbf46787c59afc68d1c50a40
