Dec 13 10:41:21.701 INFO testing michaelsproul/ewok against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 13 10:41:21.701 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-1/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/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 13 10:41:22.143 INFO [stdout] d3c720257609e18322bdb2276cf4689e1d4095b4f51fac23aa40b63d0f6272ec
Dec 13 10:41:22.148 INFO running `"docker" "start" "-a" "d3c720257609e18322bdb2276cf4689e1d4095b4f51fac23aa40b63d0f6272ec"`
Dec 13 10:41:22.683 INFO [stderr] usermod: no changes
Dec 13 10:41:22.777 INFO [stderr]    Compiling unwrap v1.1.0
Dec 13 10:41:22.787 INFO [stderr]    Compiling itertools v0.6.0
Dec 13 10:41:22.791 INFO [stderr]    Compiling env_logger v0.4.3
Dec 13 10:41:25.035 INFO [stderr]    Compiling ewok v0.1.0 (/source)
Dec 13 10:41:47.007 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 24.30s
Dec 13 10:41:47.016 INFO [stderr] su: No module specific data is present
Dec 13 10:41:47.772 INFO running `"docker" "inspect" "d3c720257609e18322bdb2276cf4689e1d4095b4f51fac23aa40b63d0f6272ec"`
Dec 13 10:41:48.335 INFO running `"docker" "rm" "-f" "d3c720257609e18322bdb2276cf4689e1d4095b4f51fac23aa40b63d0f6272ec"`
Dec 13 10:41:48.705 INFO [stdout] d3c720257609e18322bdb2276cf4689e1d4095b4f51fac23aa40b63d0f6272ec
Dec 13 10:41:48.711 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-1/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/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 13 10:41:49.175 INFO [stdout] 118e50fd2c231e62f945a8ad0ab5dfc8c37f1eaa7636de3f43e6f1c9a7412bb8
Dec 13 10:41:49.175 INFO running `"docker" "start" "-a" "118e50fd2c231e62f945a8ad0ab5dfc8c37f1eaa7636de3f43e6f1c9a7412bb8"`
Dec 13 10:41:50.747 INFO [stderr] usermod: no changes
Dec 13 10:41:50.927 INFO [stderr]    Compiling ewok v0.1.0 (/source)
Dec 13 10:42:00.909 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 10.14s
Dec 13 10:42:00.924 INFO [stderr] su: No module specific data is present
Dec 13 10:42:01.459 INFO running `"docker" "inspect" "118e50fd2c231e62f945a8ad0ab5dfc8c37f1eaa7636de3f43e6f1c9a7412bb8"`
Dec 13 10:42:01.620 INFO running `"docker" "rm" "-f" "118e50fd2c231e62f945a8ad0ab5dfc8c37f1eaa7636de3f43e6f1c9a7412bb8"`
Dec 13 10:42:01.791 INFO [stdout] 118e50fd2c231e62f945a8ad0ab5dfc8c37f1eaa7636de3f43e6f1c9a7412bb8
Dec 13 10:42:01.795 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-1/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/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 13 10:42:02.232 INFO [stdout] 928b6a92eef9c5bc3870d3837b78b0ca8255fab35f87e5c2f5ca85906aa41654
Dec 13 10:42:02.241 INFO running `"docker" "start" "-a" "928b6a92eef9c5bc3870d3837b78b0ca8255fab35f87e5c2f5ca85906aa41654"`
Dec 13 10:42:02.902 INFO [stderr] usermod: no changes
Dec 13 10:42:02.991 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.05s
Dec 13 10:42:03.003 INFO [stderr]      Running /target/debug/deps/ewok-1fe77a2f6e62b91e
Dec 13 10:42:03.019 INFO [stdout] 
Dec 13 10:42:03.019 INFO [stdout] running 6 tests
Dec 13 10:42:03.019 INFO [stdout] test blocks::test::segment ... ok
Dec 13 10:42:03.019 INFO [stdout] test blocks::test::covering ... ok
Dec 13 10:42:03.021 INFO [stdout] test params::test::test_quorum ... ok
Dec 13 10:42:03.021 INFO [stdout] test name::test::sibling_ancestor ... ok
Dec 13 10:42:03.024 INFO [stdout] test network::test::in_order_delivery_diff_step ... ok
Dec 13 10:42:03.025 INFO [stdout] test network::test::in_order_delivery_same_step ... ok
Dec 13 10:42:03.025 INFO [stderr]      Running /target/debug/deps/ewok-56e0e9ebecb88d2f
Dec 13 10:42:03.025 INFO [stdout] 
Dec 13 10:42:03.025 INFO [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 10:42:03.025 INFO [stdout] 
Dec 13 10:42:03.029 INFO [stdout] 
Dec 13 10:42:03.029 INFO [stdout] running 0 tests
Dec 13 10:42:03.029 INFO [stdout] 
Dec 13 10:42:03.029 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 10:42:03.029 INFO [stdout] 
Dec 13 10:42:03.035 INFO [stdout] 
Dec 13 10:42:03.035 INFO [stderr]      Running /target/debug/deps/graph-d6879e719e0ddd6a
Dec 13 10:42:03.035 INFO [stdout] running 0 tests
Dec 13 10:42:03.035 INFO [stderr]      Running /target/debug/deps/graph_msgs-c8c1b9057d82e408
Dec 13 10:42:03.035 INFO [stdout] 
Dec 13 10:42:03.035 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 10:42:03.035 INFO [stdout] 
Dec 13 10:42:03.039 INFO [stdout] 
Dec 13 10:42:03.039 INFO [stderr]      Running /target/debug/deps/manual_setup-315a0973ee0a2b9d
Dec 13 10:42:03.039 INFO [stdout] running 0 tests
Dec 13 10:42:03.039 INFO [stdout] 
Dec 13 10:42:03.039 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 10:42:03.039 INFO [stdout] 
Dec 13 10:42:03.039 INFO [stdout] 
Dec 13 10:42:03.039 INFO [stdout] running 11 tests
Dec 13 10:42:44.287 INFO [stdout] test one_join_one_drop ... ok
Dec 13 10:43:00.627 INFO [stdout] test cascading_merge ... ok
Dec 13 10:43:03.043 INFO [stdout] test parallel_cascading_merges ... test parallel_cascading_merges has been running for over 60 seconds
Dec 13 10:43:03.043 INFO [stdout] test growth_then_cascade ... test growth_then_cascade has been running for over 60 seconds
Dec 13 10:43:03.043 INFO [stdout] test parallel_merge_with_adds ... test parallel_merge_with_adds has been running for over 60 seconds
Dec 13 10:43:03.043 INFO [stdout] test growth_then_force_merge ... test growth_then_force_merge has been running for over 60 seconds
Dec 13 10:43:03.043 INFO [stdout] test four_sections ... test four_sections has been running for over 60 seconds
Dec 13 10:43:03.043 INFO [stdout] test parallel_merge ... test parallel_merge has been running for over 60 seconds
Dec 13 10:43:18.251 INFO [stdout] test triple_drop_merge ... ok
Dec 13 10:43:18.724 INFO [stdout] test growth_then_force_merge ... ok
Dec 13 10:43:27.379 INFO [stdout] test two_drop_one_join ... ok
Dec 13 10:43:38.057 INFO [stdout] test two_drop_merge ... ok
Dec 13 10:43:49.255 INFO [stdout] test parallel_merge ... ok
Dec 13 10:43:54.583 INFO [stdout] test four_sections ... ok
Dec 13 10:44:08.364 INFO [stdout] test parallel_merge_with_adds ... ok
Dec 13 10:45:10.208 INFO [stdout] test growth_then_cascade ... ok
Dec 13 10:45:30.634 INFO [stdout] test parallel_cascading_merges ... ok
Dec 13 10:45:30.634 INFO [stdout] 
Dec 13 10:45:30.634 INFO [stdout] test result: ok. 11 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 10:45:30.634 INFO [stdout] 
Dec 13 10:45:30.635 INFO [stderr]    Doc-tests ewok
Dec 13 10:45:31.745 INFO [stdout] 
Dec 13 10:45:31.745 INFO [stdout] running 0 tests
Dec 13 10:45:31.745 INFO [stdout] 
Dec 13 10:45:31.745 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 10:45:31.745 INFO [stdout] 
Dec 13 10:45:31.755 INFO [stderr] su: No module specific data is present
Dec 13 10:45:32.611 INFO running `"docker" "inspect" "928b6a92eef9c5bc3870d3837b78b0ca8255fab35f87e5c2f5ca85906aa41654"`
Dec 13 10:45:32.849 INFO running `"docker" "rm" "-f" "928b6a92eef9c5bc3870d3837b78b0ca8255fab35f87e5c2f5ca85906aa41654"`
Dec 13 10:45:33.099 INFO [stdout] 928b6a92eef9c5bc3870d3837b78b0ca8255fab35f87e5c2f5ca85906aa41654