Dec 06 23:55:06.933 INFO testing sandbox-ipc-0.4.0 against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514 Dec 06 23:55:06.933 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-4/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 06 23:55:07.461 INFO [stdout] 709e1c0cbf5fa45c12bb8d8affca972fe38dc93402e76aae2a9b6337e1433675 Dec 06 23:55:07.462 INFO running `"docker" "start" "-a" "709e1c0cbf5fa45c12bb8d8affca972fe38dc93402e76aae2a9b6337e1433675"` Dec 06 23:55:09.888 INFO [stderr] usermod: no changes Dec 06 23:55:10.146 INFO [stderr] Compiling bincode v0.9.2 Dec 06 23:55:10.146 INFO [stderr] Compiling uuid v0.5.1 Dec 06 23:55:12.072 INFO [stderr] Compiling sandbox-ipc v0.4.0 (/source) Dec 06 23:55:17.079 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 7.17s Dec 06 23:55:17.088 INFO [stderr] su: No module specific data is present Dec 06 23:55:17.650 INFO running `"docker" "inspect" "709e1c0cbf5fa45c12bb8d8affca972fe38dc93402e76aae2a9b6337e1433675"` Dec 06 23:55:17.986 INFO running `"docker" "rm" "-f" "709e1c0cbf5fa45c12bb8d8affca972fe38dc93402e76aae2a9b6337e1433675"` Dec 06 23:55:18.360 INFO [stdout] 709e1c0cbf5fa45c12bb8d8affca972fe38dc93402e76aae2a9b6337e1433675 Dec 06 23:55:18.364 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-4/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 06 23:55:18.774 INFO [stdout] 8785f0338ed84289f281c2f1a0a04f60b1c7021783b57117776e177e47969710 Dec 06 23:55:18.776 INFO running `"docker" "start" "-a" "8785f0338ed84289f281c2f1a0a04f60b1c7021783b57117776e177e47969710"` Dec 06 23:55:20.843 INFO [stderr] usermod: no changes Dec 06 23:55:21.124 INFO [stderr] Compiling sandbox-ipc v0.4.0 (/source) Dec 06 23:55:30.389 INFO [stderr] warning: use of deprecated item 'tokio_all::runtime::Runtime::reactor': there is now a reactor per worker thread Dec 06 23:55:30.392 INFO [stderr] --> src/io.rs:170:81 Dec 06 23:55:30.392 INFO [stderr] | Dec 06 23:55:30.392 INFO [stderr] 170 | let (a, b) = MessageChannel::::pair(runtime.reactor(), 8192).unwrap(); Dec 06 23:55:30.392 INFO [stderr] | ^^^^^^^ Dec 06 23:55:30.392 INFO [stderr] | Dec 06 23:55:30.392 INFO [stderr] = note: #[warn(deprecated)] on by default Dec 06 23:55:30.392 INFO [stderr] Dec 06 23:55:30.533 INFO [stderr] warning: use of deprecated item 'tokio_all::runtime::Runtime::reactor': there is now a reactor per worker thread Dec 06 23:55:30.533 INFO [stderr] --> src/shm/mod.rs:122:51 Dec 06 23:55:30.533 INFO [stderr] | Dec 06 23:55:30.533 INFO [stderr] 122 | let (a, b) = MessageChannel::pair(runtime.reactor(), 8192).unwrap(); Dec 06 23:55:30.533 INFO [stderr] | ^^^^^^^ Dec 06 23:55:30.533 INFO [stderr] Dec 06 23:55:31.380 INFO [stderr] warning: use of deprecated item 'tokio::runtime::Runtime::reactor': there is now a reactor per worker thread Dec 06 23:55:31.380 INFO [stderr] --> tests/named_channel.rs:22:84 Dec 06 23:55:31.380 INFO [stderr] | Dec 06 23:55:31.380 INFO [stderr] 22 | let channel = NamedMessageChannel::connect(&channel_name, None, tokio_loop.reactor(), 8192).unwrap(); Dec 06 23:55:31.380 INFO [stderr] | ^^^^^^^ Dec 06 23:55:31.380 INFO [stderr] | Dec 06 23:55:31.380 INFO [stderr] = note: #[warn(deprecated)] on by default Dec 06 23:55:31.380 INFO [stderr] Dec 06 23:55:31.380 INFO [stderr] warning: use of deprecated item 'tokio::runtime::Runtime::reactor': there is now a reactor per worker thread Dec 06 23:55:31.380 INFO [stderr] --> tests/named_channel.rs:27:66 Dec 06 23:55:31.380 INFO [stderr] | Dec 06 23:55:31.380 INFO [stderr] 27 | let channel_server = NamedMessageChannel::new(tokio_loop.reactor(), 8192).unwrap(); Dec 06 23:55:31.380 INFO [stderr] | ^^^^^^^ Dec 06 23:55:31.380 INFO [stderr] Dec 06 23:55:32.632 INFO [stderr] warning: use of deprecated item 'tokio::runtime::Runtime::reactor': there is now a reactor per worker thread Dec 06 23:55:32.632 INFO [stderr] --> tests/child_channel.rs:22:66 Dec 06 23:55:32.632 INFO [stderr] | Dec 06 23:55:32.632 INFO [stderr] 22 | let channel = channel_serialized.into_channel(tokio_loop.reactor()).unwrap(); Dec 06 23:55:32.632 INFO [stderr] | ^^^^^^^ Dec 06 23:55:32.632 INFO [stderr] | Dec 06 23:55:32.632 INFO [stderr] = note: #[warn(deprecated)] on by default Dec 06 23:55:32.632 INFO [stderr] Dec 06 23:55:32.634 INFO [stderr] warning: use of deprecated item 'tokio::runtime::Runtime::reactor': there is now a reactor per worker thread Dec 06 23:55:32.634 INFO [stderr] --> tests/child_channel.rs:29:104 Dec 06 23:55:32.634 INFO [stderr] | Dec 06 23:55:32.634 INFO [stderr] 29 | let (a, mut child) = MessageChannel::establish_with_child(&mut child_command, 8192, tokio_loop.reactor(), |command, child_channel| { Dec 06 23:55:32.634 INFO [stderr] | ^^^^^^^ Dec 06 23:55:32.634 INFO [stderr] Dec 06 23:55:41.085 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 20.20s Dec 06 23:55:41.100 INFO [stderr] su: No module specific data is present Dec 06 23:55:42.248 INFO running `"docker" "inspect" "8785f0338ed84289f281c2f1a0a04f60b1c7021783b57117776e177e47969710"` Dec 06 23:55:42.644 INFO running `"docker" "rm" "-f" "8785f0338ed84289f281c2f1a0a04f60b1c7021783b57117776e177e47969710"` Dec 06 23:55:43.015 INFO [stdout] 8785f0338ed84289f281c2f1a0a04f60b1c7021783b57117776e177e47969710 Dec 06 23:55:43.018 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-4/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 06 23:55:43.496 INFO [stdout] c218221eb8f6ebb1e6f1b78239828c26a763b61381e2eb21b6267a33ca2e0f87 Dec 06 23:55:43.502 INFO running `"docker" "start" "-a" "c218221eb8f6ebb1e6f1b78239828c26a763b61381e2eb21b6267a33ca2e0f87"` Dec 06 23:55:44.952 INFO [stderr] usermod: no changes Dec 06 23:55:45.136 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.17s Dec 06 23:55:45.154 INFO [stderr] Running /target/debug/deps/sandbox_ipc-b8ce7bf425700be9 Dec 06 23:55:45.160 INFO [stdout] Dec 06 23:55:45.160 INFO [stdout] running 16 tests Dec 06 23:55:45.160 INFO [stdout] test channel::tests::process_handle_is_send ... ok Dec 06 23:55:45.160 INFO [stdout] test channel::tests::pre_raw_message_channel_is_send ... ok Dec 06 23:55:45.160 INFO [stdout] test shm::tests::big_shm ... ok Dec 06 23:55:45.165 INFO [stdout] test shm::queue::tests::full_queue_emptied_try_pop ... ok Dec 06 23:55:45.168 INFO [stdout] test shm::queue::tests::full_queue_try_push ... ok Dec 06 23:55:45.170 INFO [stdout] test shm::tests::shared_mem_is_send ... ok Dec 06 23:55:45.170 INFO [stdout] test shm::tests::shared_mem_map_is_send ... ok Dec 06 23:55:45.170 INFO [stdout] test shm::queue::tests::empty_queue_try_pop ... ok Dec 06 23:55:45.192 INFO [stdout] test shm::queue::tests::contested_fill_and_empty ... ok Dec 06 23:55:45.199 INFO [stdout] test sync::tests::mutex_is_send ... ok Dec 06 23:55:45.199 INFO [stdout] test tests::raw_message_channel_pair ... ok Dec 06 23:55:45.199 INFO [stdout] test sync::tests::uncontested_mutex_lock ... ok Dec 06 23:55:45.212 INFO [stdout] test tests::named_message_channel_pair ... ok Dec 06 23:55:45.216 INFO [stdout] test shm::tests::send_mem_same_process ... ok Dec 06 23:55:45.240 INFO [stdout] test io::tests::send_file_same_process ... ok Dec 06 23:55:45.332 INFO [stdout] test sync::tests::single_process_contested_mutex_lock ... ok Dec 06 23:55:45.332 INFO [stderr] Running /target/debug/deps/child_channel-cdb945eaa6115422 Dec 06 23:55:45.332 INFO [stdout] Dec 06 23:55:45.332 INFO [stdout] test result: ok. 16 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 06 23:55:45.332 INFO [stdout] Dec 06 23:55:45.332 INFO [stdout] parent sent hello Dec 06 23:55:45.340 INFO [stdout] child received hello Dec 06 23:55:45.340 INFO [stdout] parent received ehlo Dec 06 23:55:45.340 INFO [stdout] child sent ehlo Dec 06 23:55:45.348 INFO [stdout] parent sent file handle Dec 06 23:55:45.348 INFO [stdout] child received file handle Dec 06 23:55:45.359 INFO [stdout] child sent file contents Dec 06 23:55:45.359 INFO [stdout] child sent file handle Dec 06 23:55:45.359 INFO [stdout] parent received file contents Dec 06 23:55:45.359 INFO [stdout] parent received file handle Dec 06 23:55:45.359 INFO [stdout] parent sent file contents Dec 06 23:55:45.359 INFO [stdout] child received file contents Dec 06 23:55:45.380 INFO [stdout] parent sent socket Dec 06 23:55:45.381 INFO [stdout] parent sent mutex Dec 06 23:55:45.388 INFO [stdout] child received mutex Dec 06 23:55:45.488 INFO [stdout] child send shared memory write ack Dec 06 23:55:45.488 INFO [stdout] received shared memory write ack Dec 06 23:55:45.496 INFO [stderr] Running /target/debug/deps/named_channel-65f209a119ff6e0b Dec 06 23:55:45.524 INFO [stdout] parent sent hello Dec 06 23:55:45.528 INFO [stdout] child received hello Dec 06 23:55:45.528 INFO [stdout] child sent ehlo Dec 06 23:55:45.528 INFO [stdout] parent received ehlo Dec 06 23:55:45.532 INFO [stdout] parent sent file handle Dec 06 23:55:45.536 INFO [stdout] child received file handle Dec 06 23:55:45.536 INFO [stdout] child sent file contents Dec 06 23:55:45.544 INFO [stdout] child sent file handle Dec 06 23:55:45.552 INFO [stdout] parent received file contents Dec 06 23:55:45.552 INFO [stdout] parent received file handle Dec 06 23:55:45.628 INFO [stdout] parent sent file contents Dec 06 23:55:45.628 INFO [stdout] child received file contents Dec 06 23:55:45.628 INFO [stdout] parent sent socket Dec 06 23:55:45.628 INFO [stdout] child received mutex Dec 06 23:55:45.628 INFO [stdout] parent sent mutex Dec 06 23:55:45.697 INFO [stdout] child send shared memory write ack Dec 06 23:55:45.710 INFO [stderr] Doc-tests sandbox-ipc Dec 06 23:55:45.710 INFO [stdout] received shared memory write ack Dec 06 23:55:50.384 INFO [stdout] Dec 06 23:55:50.384 INFO [stdout] running 1 test Dec 06 23:55:57.973 INFO [stdout] test src/lib.rs - (line 7) ... ok Dec 06 23:55:57.973 INFO [stdout] Dec 06 23:55:57.974 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 06 23:55:57.974 INFO [stdout] Dec 06 23:55:57.990 INFO [stderr] su: No module specific data is present Dec 06 23:55:58.903 INFO running `"docker" "inspect" "c218221eb8f6ebb1e6f1b78239828c26a763b61381e2eb21b6267a33ca2e0f87"` Dec 06 23:55:59.214 INFO running `"docker" "rm" "-f" "c218221eb8f6ebb1e6f1b78239828c26a763b61381e2eb21b6267a33ca2e0f87"` Dec 06 23:55:59.596 INFO [stdout] c218221eb8f6ebb1e6f1b78239828c26a763b61381e2eb21b6267a33ca2e0f87