Dec 12 19:15:07.229 INFO testing zummenix/mprovision against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 12 19:15:07.229 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/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 12 19:15:07.828 INFO [stdout] 349020d54b8f2d621b6b844d95988b12c5877aa2d3b31b37872fc468da92d4d0
Dec 12 19:15:07.830 INFO running `"docker" "start" "-a" "349020d54b8f2d621b6b844d95988b12c5877aa2d3b31b37872fc468da92d4d0"`
Dec 12 19:15:10.134 INFO [stderr] usermod: no changes
Dec 12 19:15:10.335 INFO [stderr]    Compiling proc-macro2 v0.4.24
Dec 12 19:15:10.336 INFO [stderr]    Compiling serde v1.0.80
Dec 12 19:15:10.336 INFO [stderr]    Compiling num-integer v0.1.39
Dec 12 19:15:10.362 INFO [stderr]    Compiling plist v0.3.0
Dec 12 19:15:10.362 INFO [stderr]    Compiling safemem v0.3.0
Dec 12 19:15:10.363 INFO [stderr]    Compiling byteorder v1.2.7
Dec 12 19:15:10.364 INFO [stderr]    Compiling quick-error v1.2.2
Dec 12 19:15:10.366 INFO [stderr]    Compiling futures v0.1.25
Dec 12 19:15:11.543 INFO [stderr]    Compiling memmem v0.1.1
Dec 12 19:15:11.544 INFO [stderr]    Compiling heck v0.3.0
Dec 12 19:15:15.044 INFO [stderr]    Compiling num_cpus v1.8.0
Dec 12 19:15:15.075 INFO [stderr]    Compiling time v0.1.40
Dec 12 19:15:15.167 INFO [stderr]    Compiling xml-rs v0.7.0
Dec 12 19:15:15.563 INFO [stderr]    Compiling humantime v1.1.1
Dec 12 19:15:16.313 INFO [stderr]    Compiling base64 v0.9.3
Dec 12 19:15:24.767 INFO [stderr]    Compiling chrono v0.4.6
Dec 12 19:15:28.144 INFO [stderr]    Compiling quote v0.6.10
Dec 12 19:15:33.241 INFO [stderr]    Compiling syn v0.15.21
Dec 12 19:15:37.099 INFO [stderr]    Compiling futures-cpupool v0.1.8
Dec 12 19:15:57.145 INFO [stderr]    Compiling structopt-derive v0.2.13
Dec 12 19:16:03.401 INFO [stderr]    Compiling structopt v0.2.13
Dec 12 19:16:05.104 INFO [stderr]    Compiling mprovision v4.0.0 (/source)
Dec 12 19:16:08.178 INFO [stderr] warning: unused `#[macro_use]` import
Dec 12 19:16:08.178 INFO [stderr]  --> src/bin/main.rs:6:1
Dec 12 19:16:08.178 INFO [stderr]   |
Dec 12 19:16:08.178 INFO [stderr] 6 | #[macro_use]
Dec 12 19:16:08.179 INFO [stderr]   | ^^^^^^^^^^^^
Dec 12 19:16:08.179 INFO [stderr]   |
Dec 12 19:16:08.179 INFO [stderr]   = note: #[warn(unused_imports)] on by default
Dec 12 19:16:08.179 INFO [stderr] 
Dec 12 19:16:12.199 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1m 02s
Dec 12 19:16:12.204 INFO [stderr] su: No module specific data is present
Dec 12 19:16:13.659 INFO running `"docker" "inspect" "349020d54b8f2d621b6b844d95988b12c5877aa2d3b31b37872fc468da92d4d0"`
Dec 12 19:16:14.021 INFO running `"docker" "rm" "-f" "349020d54b8f2d621b6b844d95988b12c5877aa2d3b31b37872fc468da92d4d0"`
Dec 12 19:16:14.395 INFO [stdout] 349020d54b8f2d621b6b844d95988b12c5877aa2d3b31b37872fc468da92d4d0
Dec 12 19:16:14.403 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/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 12 19:16:14.876 INFO [stdout] 0a4fb1a6b505a5eb57f91acf9034841a14e9332a6522c837047e4132db3e4ea2
Dec 12 19:16:14.879 INFO running `"docker" "start" "-a" "0a4fb1a6b505a5eb57f91acf9034841a14e9332a6522c837047e4132db3e4ea2"`
Dec 12 19:16:16.875 INFO [stderr] usermod: no changes
Dec 12 19:16:17.054 INFO [stderr]    Compiling remove_dir_all v0.5.1
Dec 12 19:16:17.055 INFO [stderr]    Compiling rand v0.4.3
Dec 12 19:16:17.059 INFO [stderr]    Compiling expectest v0.11.0
Dec 12 19:16:20.357 INFO [stderr]    Compiling tempdir v0.3.7
Dec 12 19:16:21.100 INFO [stderr]    Compiling mprovision v4.0.0 (/source)
Dec 12 19:16:21.547 INFO [stderr] warning: unused `#[macro_use]` import
Dec 12 19:16:21.547 INFO [stderr]  --> src/bin/main.rs:6:1
Dec 12 19:16:21.547 INFO [stderr]   |
Dec 12 19:16:21.547 INFO [stderr] 6 | #[macro_use]
Dec 12 19:16:21.548 INFO [stderr]   | ^^^^^^^^^^^^
Dec 12 19:16:21.548 INFO [stderr]   |
Dec 12 19:16:21.548 INFO [stderr]   = note: #[warn(unused_imports)] on by default
Dec 12 19:16:21.548 INFO [stderr] 
Dec 12 19:16:26.647 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 9.73s
Dec 12 19:16:26.655 INFO [stderr] su: No module specific data is present
Dec 12 19:16:27.978 INFO running `"docker" "inspect" "0a4fb1a6b505a5eb57f91acf9034841a14e9332a6522c837047e4132db3e4ea2"`
Dec 12 19:16:28.363 INFO running `"docker" "rm" "-f" "0a4fb1a6b505a5eb57f91acf9034841a14e9332a6522c837047e4132db3e4ea2"`
Dec 12 19:16:28.743 INFO [stdout] 0a4fb1a6b505a5eb57f91acf9034841a14e9332a6522c837047e4132db3e4ea2
Dec 12 19:16:28.747 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/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 12 19:16:29.283 INFO [stdout] 3a0ec1f9928d9006816d45a2c518759f6cccd9a7b0afeb000beeb2211d1b6a7e
Dec 12 19:16:29.289 INFO running `"docker" "start" "-a" "3a0ec1f9928d9006816d45a2c518759f6cccd9a7b0afeb000beeb2211d1b6a7e"`
Dec 12 19:16:31.439 INFO [stderr] usermod: no changes
Dec 12 19:16:31.659 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.18s
Dec 12 19:16:31.663 INFO [stderr]      Running /target/debug/deps/mprovision-5d232cc029045127
Dec 12 19:16:31.665 INFO [stdout] 
Dec 12 19:16:31.665 INFO [stdout] running 6 tests
Dec 12 19:16:31.666 INFO [stdout] test profile::tests::wildcard_bundle_id ... ok
Dec 12 19:16:31.666 INFO [stdout] test profile::tests::incorrect_bundle_id ... ok
Dec 12 19:16:31.666 INFO [stdout] test profile::tests::correct_bundle_id ... ok
Dec 12 19:16:31.666 INFO [stdout] test profile::tests::contains ... ok
Dec 12 19:16:31.666 INFO [stdout] test plist_extractor::tests::test_find_plist ... ok
Dec 12 19:16:31.672 INFO [stdout] test tests::filter_mobileprovision_files ... ok
Dec 12 19:16:31.672 INFO [stdout] 
Dec 12 19:16:31.672 INFO [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 12 19:16:31.672 INFO [stdout] 
Dec 12 19:16:31.675 INFO [stderr]      Running /target/debug/deps/mprovision-f4770d8ee48618b3
Dec 12 19:16:31.677 INFO [stdout] 
Dec 12 19:16:31.677 INFO [stdout] running 5 tests
Dec 12 19:16:31.679 INFO [stdout] test cli::tests::clean_command ... ok
Dec 12 19:16:31.681 INFO [stdout] test cli::tests::remove_id_command ... ok
Dec 12 19:16:31.683 INFO [stdout] test cli::tests::show_file_command ... ok
Dec 12 19:16:31.687 INFO [stdout] test cli::tests::show_uuid_command ... ok
Dec 12 19:16:31.687 INFO [stdout] test cli::tests::list_command ... ok
Dec 12 19:16:31.687 INFO [stdout] 
Dec 12 19:16:31.687 INFO [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 12 19:16:31.687 INFO [stdout] 
Dec 12 19:16:31.691 INFO [stderr]    Doc-tests mprovision
Dec 12 19:16:31.883 INFO [stdout] 
Dec 12 19:16:31.883 INFO [stdout] running 0 tests
Dec 12 19:16:31.883 INFO [stdout] 
Dec 12 19:16:31.883 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 12 19:16:31.883 INFO [stdout] 
Dec 12 19:16:31.899 INFO [stderr] su: No module specific data is present
Dec 12 19:16:32.911 INFO running `"docker" "inspect" "3a0ec1f9928d9006816d45a2c518759f6cccd9a7b0afeb000beeb2211d1b6a7e"`
Dec 12 19:16:33.221 INFO running `"docker" "rm" "-f" "3a0ec1f9928d9006816d45a2c518759f6cccd9a7b0afeb000beeb2211d1b6a7e"`
Dec 12 19:16:33.623 INFO [stdout] 3a0ec1f9928d9006816d45a2c518759f6cccd9a7b0afeb000beeb2211d1b6a7e