Dec 05 14:29:33.651 INFO testing michaelsproul/ewok against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 05 14:29:33.652 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-3/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/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 05 14:29:34.140 INFO [stdout] f69cbcf1d949d3e64c8b289a003494ce4f0301bdbdb1f04189473bea31c35090
Dec 05 14:29:34.148 INFO running `"docker" "start" "-a" "f69cbcf1d949d3e64c8b289a003494ce4f0301bdbdb1f04189473bea31c35090"`
Dec 05 14:29:34.999 INFO [stderr] usermod: no changes
Dec 05 14:29:35.131 INFO [stderr]    Compiling itertools v0.6.0
Dec 05 14:29:35.142 INFO [stderr]    Compiling env_logger v0.4.3
Dec 05 14:29:37.400 INFO [stderr]    Compiling ewok v0.1.0 (/source)
Dec 05 14:29:58.009 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 22.98s
Dec 05 14:29:58.016 INFO [stderr] su: No module specific data is present
Dec 05 14:29:58.816 INFO running `"docker" "inspect" "f69cbcf1d949d3e64c8b289a003494ce4f0301bdbdb1f04189473bea31c35090"`
Dec 05 14:29:59.198 INFO running `"docker" "rm" "-f" "f69cbcf1d949d3e64c8b289a003494ce4f0301bdbdb1f04189473bea31c35090"`
Dec 05 14:29:59.495 INFO [stdout] f69cbcf1d949d3e64c8b289a003494ce4f0301bdbdb1f04189473bea31c35090
Dec 05 14:29:59.502 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-3/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/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 05 14:29:59.846 INFO [stdout] e48d45723914a5830e9fd482116fd1fb1dc68826689bce58819bfae86d10ebda
Dec 05 14:29:59.852 INFO running `"docker" "start" "-a" "e48d45723914a5830e9fd482116fd1fb1dc68826689bce58819bfae86d10ebda"`
Dec 05 14:30:01.116 INFO [stderr] usermod: no changes
Dec 05 14:30:01.244 INFO [stderr]    Compiling ewok v0.1.0 (/source)
Dec 05 14:30:11.330 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 10.17s
Dec 05 14:30:11.337 INFO [stderr] su: No module specific data is present
Dec 05 14:30:11.872 INFO running `"docker" "inspect" "e48d45723914a5830e9fd482116fd1fb1dc68826689bce58819bfae86d10ebda"`
Dec 05 14:30:12.108 INFO running `"docker" "rm" "-f" "e48d45723914a5830e9fd482116fd1fb1dc68826689bce58819bfae86d10ebda"`
Dec 05 14:30:12.343 INFO [stdout] e48d45723914a5830e9fd482116fd1fb1dc68826689bce58819bfae86d10ebda
Dec 05 14:30:12.350 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-3/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/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 05 14:30:12.632 INFO [stdout] 38da0057f76e4383253f5cf6c36d8832f624480cf7250d299b27110c2fafb611
Dec 05 14:30:12.637 INFO running `"docker" "start" "-a" "38da0057f76e4383253f5cf6c36d8832f624480cf7250d299b27110c2fafb611"`
Dec 05 14:30:13.604 INFO [stderr] usermod: no changes
Dec 05 14:30:13.708 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.06s
Dec 05 14:30:13.708 INFO [stderr]      Running /target/debug/deps/ewok-e86eea19b9b9b0b0
Dec 05 14:30:13.740 INFO [stdout] 
Dec 05 14:30:13.740 INFO [stdout] running 6 tests
Dec 05 14:30:13.748 INFO [stdout] test name::test::sibling_ancestor ... ok
Dec 05 14:30:13.748 INFO [stderr]      Running /target/debug/deps/ewok-cb597e4d607d7919
Dec 05 14:30:13.748 INFO [stdout] test network::test::in_order_delivery_diff_step ... ok
Dec 05 14:30:13.748 INFO [stdout] test blocks::test::covering ... ok
Dec 05 14:30:13.748 INFO [stdout] test blocks::test::segment ... ok
Dec 05 14:30:13.748 INFO [stdout] test network::test::in_order_delivery_same_step ... ok
Dec 05 14:30:13.748 INFO [stdout] test params::test::test_quorum ... ok
Dec 05 14:30:13.748 INFO [stdout] 
Dec 05 14:30:13.748 INFO [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 14:30:13.748 INFO [stdout] 
Dec 05 14:30:13.764 INFO [stdout] 
Dec 05 14:30:13.764 INFO [stderr]      Running /target/debug/deps/graph-7639e67b7900edc2
Dec 05 14:30:13.764 INFO [stdout] running 0 tests
Dec 05 14:30:13.764 INFO [stderr]      Running /target/debug/deps/graph_msgs-915ad33bfc21f88b
Dec 05 14:30:13.764 INFO [stdout] 
Dec 05 14:30:13.764 INFO [stderr]      Running /target/debug/deps/manual_setup-1f26fa94ac8be4c5
Dec 05 14:30:13.764 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 14:30:13.764 INFO [stdout] 
Dec 05 14:30:13.764 INFO [stdout] 
Dec 05 14:30:13.764 INFO [stdout] running 0 tests
Dec 05 14:30:13.764 INFO [stdout] 
Dec 05 14:30:13.764 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 14:30:13.764 INFO [stdout] 
Dec 05 14:30:13.764 INFO [stdout] 
Dec 05 14:30:13.764 INFO [stdout] running 0 tests
Dec 05 14:30:13.764 INFO [stdout] 
Dec 05 14:30:13.764 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 14:30:13.764 INFO [stdout] 
Dec 05 14:30:13.772 INFO [stdout] 
Dec 05 14:30:13.772 INFO [stdout] running 11 tests
Dec 05 14:30:50.241 INFO [stdout] test one_join_one_drop ... ok
Dec 05 14:31:13.774 INFO [stdout] test growth_then_cascade ... test growth_then_cascade has been running for over 60 seconds
Dec 05 14:31:13.774 INFO [stdout] test parallel_merge_with_adds ... test parallel_merge_with_adds has been running for over 60 seconds
Dec 05 14:31:13.774 INFO [stdout] test four_sections ... test four_sections has been running for over 60 seconds
Dec 05 14:31:13.774 INFO [stdout] test growth_then_force_merge ... test growth_then_force_merge has been running for over 60 seconds
Dec 05 14:31:13.774 INFO [stdout] test parallel_cascading_merges ... test parallel_cascading_merges has been running for over 60 seconds
Dec 05 14:31:13.774 INFO [stdout] test parallel_merge ... test parallel_merge has been running for over 60 seconds
Dec 05 14:31:13.774 INFO [stdout] test cascading_merge ... test cascading_merge has been running for over 60 seconds
Dec 05 14:31:19.556 INFO [stdout] test growth_then_force_merge ... ok
Dec 05 14:31:20.396 INFO [stdout] test cascading_merge ... ok
Dec 05 14:31:21.540 INFO [stdout] test triple_drop_merge ... ok
Dec 05 14:31:29.614 INFO [stdout] test two_drop_one_join ... ok
Dec 05 14:31:52.965 INFO [stdout] test two_drop_merge ... ok
Dec 05 14:32:12.044 INFO [stdout] test parallel_merge ... ok
Dec 05 14:32:17.008 INFO [stdout] test parallel_merge_with_adds ... ok
Dec 05 14:32:22.236 INFO [stdout] test four_sections ... ok
Dec 05 14:33:04.392 INFO [stdout] test growth_then_cascade ... ok
Dec 05 14:33:38.713 INFO [stdout] test parallel_cascading_merges ... ok
Dec 05 14:33:38.714 INFO [stdout] 
Dec 05 14:33:38.714 INFO [stdout] test result: ok. 11 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 14:33:38.714 INFO [stdout] 
Dec 05 14:33:38.715 INFO [stderr]    Doc-tests ewok
Dec 05 14:33:39.648 INFO [stdout] 
Dec 05 14:33:39.648 INFO [stdout] running 0 tests
Dec 05 14:33:39.648 INFO [stdout] 
Dec 05 14:33:39.648 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 14:33:39.648 INFO [stdout] 
Dec 05 14:33:39.657 INFO [stderr] su: No module specific data is present
Dec 05 14:33:40.715 INFO running `"docker" "inspect" "38da0057f76e4383253f5cf6c36d8832f624480cf7250d299b27110c2fafb611"`
Dec 05 14:33:40.996 INFO running `"docker" "rm" "-f" "38da0057f76e4383253f5cf6c36d8832f624480cf7250d299b27110c2fafb611"`
Dec 05 14:33:41.324 INFO [stdout] 38da0057f76e4383253f5cf6c36d8832f624480cf7250d299b27110c2fafb611