Dec 13 15:56:22.421 INFO testing jasonwhite/ubercopy against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 13 15:56:22.421 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-5/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 15:56:22.887 INFO [stdout] 31ffe9ee6487c24dac2ca48196010946741195ea9f966e5f8d8704cc6ec371af
Dec 13 15:56:22.891 INFO running `"docker" "start" "-a" "31ffe9ee6487c24dac2ca48196010946741195ea9f966e5f8d8704cc6ec371af"`
Dec 13 15:56:24.017 INFO [stderr] usermod: no changes
Dec 13 15:56:24.228 INFO [stderr]    Compiling winapi v0.3.5
Dec 13 15:56:24.231 INFO [stderr]    Compiling scoped-pool v1.0.0
Dec 13 15:56:24.231 INFO [stderr]    Compiling nix v0.11.0
Dec 13 15:56:24.231 INFO [stderr]    Compiling atty v0.2.10
Dec 13 15:56:24.231 INFO [stderr]    Compiling miniz-sys v0.1.10
Dec 13 15:56:24.263 INFO [stderr]    Compiling serde_json v1.0.19
Dec 13 15:56:24.263 INFO [stderr]    Compiling serde_yaml v0.7.4
Dec 13 15:56:24.263 INFO [stderr]    Compiling ordered-float v0.5.0
Dec 13 15:56:25.921 INFO [stderr]    Compiling flate2 v0.2.20
Dec 13 15:56:26.407 INFO [stderr]    Compiling chrono v0.3.0
Dec 13 15:56:30.089 INFO [stderr]    Compiling clap v2.32.0
Dec 13 15:56:30.152 INFO [stderr]    Compiling serde-value v0.5.2
Dec 13 15:56:36.931 INFO [stderr]    Compiling shared_child v0.3.3
Dec 13 15:56:37.860 INFO [stderr]    Compiling log4rs v0.7.0
Dec 13 15:56:44.696 INFO [stderr]    Compiling os_pipe v0.7.0
Dec 13 15:56:52.211 INFO [stderr]    Compiling duct v0.11.1
Dec 13 15:57:00.972 INFO [stderr]    Compiling ubercopy v1.0.2 (/source)
Dec 13 15:57:07.599 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 43.55s
Dec 13 15:57:07.609 INFO [stderr] su: No module specific data is present
Dec 13 15:57:07.872 INFO running `"docker" "inspect" "31ffe9ee6487c24dac2ca48196010946741195ea9f966e5f8d8704cc6ec371af"`
Dec 13 15:57:08.021 INFO running `"docker" "rm" "-f" "31ffe9ee6487c24dac2ca48196010946741195ea9f966e5f8d8704cc6ec371af"`
Dec 13 15:57:08.207 INFO [stdout] 31ffe9ee6487c24dac2ca48196010946741195ea9f966e5f8d8704cc6ec371af
Dec 13 15:57:08.209 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-5/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 15:57:08.530 INFO [stdout] 2bba33a1c826aa561ab4d3833a92cdd489c7004461580afdb97045e7ff8d17c1
Dec 13 15:57:08.533 INFO running `"docker" "start" "-a" "2bba33a1c826aa561ab4d3833a92cdd489c7004461580afdb97045e7ff8d17c1"`
Dec 13 15:57:08.950 INFO [stderr] usermod: no changes
Dec 13 15:57:09.082 INFO [stderr]    Compiling ubercopy v1.0.2 (/source)
Dec 13 15:57:14.189 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 5.20s
Dec 13 15:57:14.199 INFO [stderr] su: No module specific data is present
Dec 13 15:57:15.272 INFO running `"docker" "inspect" "2bba33a1c826aa561ab4d3833a92cdd489c7004461580afdb97045e7ff8d17c1"`
Dec 13 15:57:15.476 INFO running `"docker" "rm" "-f" "2bba33a1c826aa561ab4d3833a92cdd489c7004461580afdb97045e7ff8d17c1"`
Dec 13 15:57:15.629 INFO [stdout] 2bba33a1c826aa561ab4d3833a92cdd489c7004461580afdb97045e7ff8d17c1
Dec 13 15:57:15.643 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-5/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 15:57:15.972 INFO [stdout] 198d4dc83a9a137990bea0656c01f20d70a1af3ad01c36a203b43059a896bad4
Dec 13 15:57:15.973 INFO running `"docker" "start" "-a" "198d4dc83a9a137990bea0656c01f20d70a1af3ad01c36a203b43059a896bad4"`
Dec 13 15:57:16.396 INFO [stderr] usermod: no changes
Dec 13 15:57:16.479 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.07s
Dec 13 15:57:16.482 INFO [stderr]      Running /target/debug/deps/ubercopy-8808c20b77f9b5db
Dec 13 15:57:16.486 INFO [stdout] 
Dec 13 15:57:16.486 INFO [stdout] running 12 tests
Dec 13 15:57:16.487 INFO [stdout] test iter::tests::adjacent_base_case ... ok
Dec 13 15:57:16.487 INFO [stdout] test iter::tests::adjacent_case_1 ... ok
Dec 13 15:57:16.487 INFO [stdout] test iter::tests::adjacent_case_2 ... ok
Dec 13 15:57:16.487 INFO [stdout] test iter::tests::changes_base_case ... ok
Dec 13 15:57:16.487 INFO [stdout] test iter::tests::changes_both_sides ... ok
Dec 13 15:57:16.487 INFO [stdout] test iter::tests::changes_left_only ... ok
Dec 13 15:57:16.487 INFO [stdout] test iter::tests::change ... ok
Dec 13 15:57:16.487 INFO [stdout] test util::tests::test_parent_dir ... ok
Dec 13 15:57:16.487 INFO [stdout] test util::tests::test_sandbox ... ok
Dec 13 15:57:16.487 INFO [stdout] test iter::tests::unique_case_1 ... ok
Dec 13 15:57:16.487 INFO [stdout] test util::tests::test_norm ... ok
Dec 13 15:57:16.488 INFO [stdout] test iter::tests::changes_right_only ... ok
Dec 13 15:57:16.488 INFO [stdout] 
Dec 13 15:57:16.488 INFO [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 15:57:16.488 INFO [stdout] 
Dec 13 15:57:16.490 INFO [stderr] su: No module specific data is present
Dec 13 15:57:16.750 INFO running `"docker" "inspect" "198d4dc83a9a137990bea0656c01f20d70a1af3ad01c36a203b43059a896bad4"`
Dec 13 15:57:16.829 INFO running `"docker" "rm" "-f" "198d4dc83a9a137990bea0656c01f20d70a1af3ad01c36a203b43059a896bad4"`
Dec 13 15:57:16.906 INFO [stdout] 198d4dc83a9a137990bea0656c01f20d70a1af3ad01c36a203b43059a896bad4