Nov 16 19:40:39.215 INFO testing michaelsproul/ewok against master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c for pr-55982
Nov 16 19:40:39.215 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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"`
Nov 16 19:40:39.709 INFO [stdout] 7d15a68e44a326d116b10fc866883170dd142f3c182dd677b29571ab5c493872
Nov 16 19:40:39.719 INFO running `"docker" "start" "-a" "7d15a68e44a326d116b10fc866883170dd142f3c182dd677b29571ab5c493872"`
Nov 16 19:40:40.774 INFO [stderr] usermod: no changes
Nov 16 19:40:40.941 INFO [stderr]    Compiling memchr v1.0.1
Nov 16 19:40:40.955 INFO [stderr]    Compiling thread-id v3.1.0
Nov 16 19:40:40.955 INFO [stderr]    Compiling term_size v0.3.0
Nov 16 19:40:40.955 INFO [stderr]    Compiling atty v0.2.2
Nov 16 19:40:41.695 INFO [stderr]    Compiling thread_local v0.3.3
Nov 16 19:40:41.828 INFO [stderr]    Compiling clap v2.24.2
Nov 16 19:40:42.059 INFO [stderr]    Compiling aho-corasick v0.6.3
Nov 16 19:40:43.546 INFO [stderr]    Compiling regex v0.2.2
Nov 16 19:40:57.607 INFO [stderr]    Compiling env_logger v0.4.3
Nov 16 19:41:11.631 INFO [stderr]    Compiling ewok v0.1.0 (/source)
Nov 16 19:41:28.071 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 47.26s
Nov 16 19:41:28.071 INFO [stderr] su: No module specific data is present
Nov 16 19:41:28.858 INFO running `"docker" "inspect" "7d15a68e44a326d116b10fc866883170dd142f3c182dd677b29571ab5c493872"`
Nov 16 19:41:29.153 INFO running `"docker" "rm" "-f" "7d15a68e44a326d116b10fc866883170dd142f3c182dd677b29571ab5c493872"`
Nov 16 19:41:29.428 INFO [stdout] 7d15a68e44a326d116b10fc866883170dd142f3c182dd677b29571ab5c493872
Nov 16 19:41:29.437 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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"`
Nov 16 19:41:29.832 INFO [stdout] 580f315fed95e050ee24a9b1648d383b75b63174e72abddd860c9afcc548fd81
Nov 16 19:41:29.838 INFO running `"docker" "start" "-a" "580f315fed95e050ee24a9b1648d383b75b63174e72abddd860c9afcc548fd81"`
Nov 16 19:41:30.833 INFO [stderr] usermod: no changes
Nov 16 19:41:30.999 INFO [stderr]    Compiling ewok v0.1.0 (/source)
Nov 16 19:41:42.303 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 11.44s
Nov 16 19:41:42.307 INFO [stderr] su: No module specific data is present
Nov 16 19:41:43.595 INFO running `"docker" "inspect" "580f315fed95e050ee24a9b1648d383b75b63174e72abddd860c9afcc548fd81"`
Nov 16 19:41:43.991 INFO running `"docker" "rm" "-f" "580f315fed95e050ee24a9b1648d383b75b63174e72abddd860c9afcc548fd81"`
Nov 16 19:41:44.423 INFO [stdout] 580f315fed95e050ee24a9b1648d383b75b63174e72abddd860c9afcc548fd81
Nov 16 19:41:44.433 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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"`
Nov 16 19:41:44.885 INFO [stdout] fbf03146b818f960e6369998469423fbd49df90d9ea11e43c37ac005ea5e04d9
Nov 16 19:41:44.887 INFO running `"docker" "start" "-a" "fbf03146b818f960e6369998469423fbd49df90d9ea11e43c37ac005ea5e04d9"`
Nov 16 19:41:47.198 INFO [stderr] usermod: no changes
Nov 16 19:41:47.327 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.10s
Nov 16 19:41:47.339 INFO [stderr]      Running /target/debug/deps/ewok-f37af0effa4cdf9c
Nov 16 19:41:47.367 INFO [stdout] 
Nov 16 19:41:47.367 INFO [stdout] running 6 tests
Nov 16 19:41:47.391 INFO [stderr]      Running /target/debug/deps/ewok-2ddbc07eee7b19c5
Nov 16 19:41:47.391 INFO [stderr]      Running /target/debug/deps/graph-926f931b37d1cd0d
Nov 16 19:41:47.392 INFO [stdout] test name::test::sibling_ancestor ... ok
Nov 16 19:41:47.392 INFO [stdout] test blocks::test::covering ... ok
Nov 16 19:41:47.392 INFO [stdout] test blocks::test::segment ... ok
Nov 16 19:41:47.392 INFO [stdout] test network::test::in_order_delivery_same_step ... ok
Nov 16 19:41:47.392 INFO [stdout] test params::test::test_quorum ... ok
Nov 16 19:41:47.392 INFO [stdout] test network::test::in_order_delivery_diff_step ... ok
Nov 16 19:41:47.392 INFO [stdout] 
Nov 16 19:41:47.392 INFO [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 19:41:47.392 INFO [stdout] 
Nov 16 19:41:47.392 INFO [stdout] 
Nov 16 19:41:47.392 INFO [stdout] running 0 tests
Nov 16 19:41:47.392 INFO [stdout] 
Nov 16 19:41:47.392 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 19:41:47.392 INFO [stdout] 
Nov 16 19:41:47.395 INFO [stdout] 
Nov 16 19:41:47.395 INFO [stdout] running 0 tests
Nov 16 19:41:47.395 INFO [stdout] 
Nov 16 19:41:47.395 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 19:41:47.395 INFO [stdout] 
Nov 16 19:41:47.396 INFO [stderr]      Running /target/debug/deps/graph_msgs-02c8e21700c888a1
Nov 16 19:41:47.403 INFO [stdout] 
Nov 16 19:41:47.403 INFO [stdout] running 0 tests
Nov 16 19:41:47.403 INFO [stdout] 
Nov 16 19:41:47.403 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 19:41:47.403 INFO [stdout] 
Nov 16 19:41:47.403 INFO [stderr]      Running /target/debug/deps/manual_setup-4b2e52c288809650
Nov 16 19:41:47.411 INFO [stdout] 
Nov 16 19:41:47.411 INFO [stdout] running 11 tests
Nov 16 19:42:22.355 INFO [stdout] test one_join_one_drop ... ok
Nov 16 19:42:47.415 INFO [stdout] test four_sections ... test four_sections has been running for over 60 seconds
Nov 16 19:42:47.415 INFO [stdout] test cascading_merge ... test cascading_merge has been running for over 60 seconds
Nov 16 19:42:47.415 INFO [stdout] test growth_then_force_merge ... test growth_then_force_merge has been running for over 60 seconds
Nov 16 19:42:47.415 INFO [stdout] test growth_then_cascade ... test growth_then_cascade has been running for over 60 seconds
Nov 16 19:42:47.426 INFO [stdout] test parallel_cascading_merges ... test parallel_cascading_merges has been running for over 60 seconds
Nov 16 19:42:47.439 INFO [stdout] test parallel_merge ... test parallel_merge has been running for over 60 seconds
Nov 16 19:42:47.439 INFO [stdout] test parallel_merge_with_adds ... test parallel_merge_with_adds has been running for over 60 seconds
Nov 16 19:43:00.919 INFO [stdout] test triple_drop_merge ... ok
Nov 16 19:43:02.359 INFO [stdout] test cascading_merge ... ok
Nov 16 19:43:11.711 INFO [stdout] test two_drop_one_join ... ok
Nov 16 19:43:21.895 INFO [stdout] test growth_then_force_merge ... ok
Nov 16 19:43:34.596 INFO [stdout] test two_drop_merge ... ok
Nov 16 19:43:51.979 INFO [stdout] test parallel_merge_with_adds ... ok
Nov 16 19:43:53.811 INFO [stdout] test parallel_merge ... ok
Nov 16 19:43:56.859 INFO [stdout] test four_sections ... ok
Nov 16 19:45:10.783 INFO [stdout] test growth_then_cascade ... ok
Nov 16 19:45:20.177 INFO [stderr]    Doc-tests ewok
Nov 16 19:45:20.177 INFO [stdout] test parallel_cascading_merges ... ok
Nov 16 19:45:20.177 INFO [stdout] 
Nov 16 19:45:20.177 INFO [stdout] test result: ok. 11 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 19:45:20.177 INFO [stdout] 
Nov 16 19:45:20.971 INFO [stdout] 
Nov 16 19:45:20.971 INFO [stdout] running 0 tests
Nov 16 19:45:20.971 INFO [stdout] 
Nov 16 19:45:20.971 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 19:45:20.971 INFO [stdout] 
Nov 16 19:45:20.979 INFO [stderr] su: No module specific data is present
Nov 16 19:45:21.345 INFO running `"docker" "inspect" "fbf03146b818f960e6369998469423fbd49df90d9ea11e43c37ac005ea5e04d9"`
Nov 16 19:45:21.422 INFO running `"docker" "rm" "-f" "fbf03146b818f960e6369998469423fbd49df90d9ea11e43c37ac005ea5e04d9"`
Nov 16 19:45:21.533 INFO [stdout] fbf03146b818f960e6369998469423fbd49df90d9ea11e43c37ac005ea5e04d9