Dec 04 23:45:13.319 INFO testing zummenix/mprovision against try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468 for pr-56514
Dec 04 23:45:13.319 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-2/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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 04 23:45:13.688 INFO [stdout] 5f3722c61eeeb8320e9d07054096f2f3c8b0780c1d905e0b50584bbb528808b0
Dec 04 23:45:13.696 INFO running `"docker" "start" "-a" "5f3722c61eeeb8320e9d07054096f2f3c8b0780c1d905e0b50584bbb528808b0"`
Dec 04 23:45:15.480 INFO [stderr] usermod: no changes
Dec 04 23:45:15.644 INFO [stderr]    Compiling proc-macro2 v0.4.24
Dec 04 23:45:15.644 INFO [stderr]    Compiling num-integer v0.1.39
Dec 04 23:45:15.644 INFO [stderr]    Compiling serde v1.0.80
Dec 04 23:45:15.652 INFO [stderr]    Compiling plist v0.3.0
Dec 04 23:45:15.652 INFO [stderr]    Compiling byteorder v1.2.7
Dec 04 23:45:15.652 INFO [stderr]    Compiling safemem v0.3.0
Dec 04 23:45:15.652 INFO [stderr]    Compiling quick-error v1.2.2
Dec 04 23:45:15.652 INFO [stderr]    Compiling futures v0.1.25
Dec 04 23:45:17.012 INFO [stderr]    Compiling memmem v0.1.1
Dec 04 23:45:19.060 INFO [stderr]    Compiling num_cpus v1.8.0
Dec 04 23:45:19.486 INFO [stderr]    Compiling time v0.1.40
Dec 04 23:45:19.994 INFO [stderr]    Compiling heck v0.3.0
Dec 04 23:45:20.021 INFO [stderr]    Compiling xml-rs v0.7.0
Dec 04 23:45:20.542 INFO [stderr]    Compiling humantime v1.1.1
Dec 04 23:45:24.366 INFO [stderr]    Compiling base64 v0.9.3
Dec 04 23:45:36.032 INFO [stderr]    Compiling chrono v0.4.6
Dec 04 23:45:36.728 INFO [stderr]    Compiling quote v0.6.10
Dec 04 23:45:39.018 INFO [stderr]    Compiling syn v0.15.21
Dec 04 23:45:41.238 INFO [stderr]    Compiling futures-cpupool v0.1.8
Dec 04 23:46:03.386 INFO [stderr]    Compiling structopt-derive v0.2.13
Dec 04 23:46:09.788 INFO [stderr]    Compiling structopt v0.2.13
Dec 04 23:46:10.093 INFO [stderr]    Compiling mprovision v4.0.0 (/source)
Dec 04 23:46:13.208 INFO [stderr] warning: unused `#[macro_use]` import
Dec 04 23:46:13.209 INFO [stderr]  --> src/bin/main.rs:6:1
Dec 04 23:46:13.209 INFO [stderr]   |
Dec 04 23:46:13.210 INFO [stderr] 6 | #[macro_use]
Dec 04 23:46:13.210 INFO [stderr]   | ^^^^^^^^^^^^
Dec 04 23:46:13.210 INFO [stderr]   |
Dec 04 23:46:13.211 INFO [stderr]   = note: #[warn(unused_imports)] on by default
Dec 04 23:46:13.211 INFO [stderr] 
Dec 04 23:46:16.962 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1m 01s
Dec 04 23:46:16.971 INFO [stderr] su: No module specific data is present
Dec 04 23:46:19.841 INFO running `"docker" "inspect" "5f3722c61eeeb8320e9d07054096f2f3c8b0780c1d905e0b50584bbb528808b0"`
Dec 04 23:46:20.178 INFO running `"docker" "rm" "-f" "5f3722c61eeeb8320e9d07054096f2f3c8b0780c1d905e0b50584bbb528808b0"`
Dec 04 23:46:20.512 INFO [stdout] 5f3722c61eeeb8320e9d07054096f2f3c8b0780c1d905e0b50584bbb528808b0
Dec 04 23:46:20.520 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-2/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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 04 23:46:20.956 INFO [stdout] 8c9c55ee864105c294441004ab095ead4ab052b20392653e87db416dabc25344
Dec 04 23:46:20.962 INFO running `"docker" "start" "-a" "8c9c55ee864105c294441004ab095ead4ab052b20392653e87db416dabc25344"`
Dec 04 23:46:22.896 INFO [stderr] usermod: no changes
Dec 04 23:46:23.108 INFO [stderr]    Compiling remove_dir_all v0.5.1
Dec 04 23:46:23.116 INFO [stderr]    Compiling rand v0.4.3
Dec 04 23:46:23.140 INFO [stderr]    Compiling expectest v0.11.0
Dec 04 23:46:26.506 INFO [stderr]    Compiling tempdir v0.3.7
Dec 04 23:46:27.081 INFO [stderr]    Compiling mprovision v4.0.0 (/source)
Dec 04 23:46:27.536 INFO [stderr] warning: unused `#[macro_use]` import
Dec 04 23:46:27.537 INFO [stderr]  --> src/bin/main.rs:6:1
Dec 04 23:46:27.537 INFO [stderr]   |
Dec 04 23:46:27.537 INFO [stderr] 6 | #[macro_use]
Dec 04 23:46:27.537 INFO [stderr]   | ^^^^^^^^^^^^
Dec 04 23:46:27.537 INFO [stderr]   |
Dec 04 23:46:27.537 INFO [stderr]   = note: #[warn(unused_imports)] on by default
Dec 04 23:46:27.537 INFO [stderr] 
Dec 04 23:46:32.081 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 9.15s
Dec 04 23:46:32.093 INFO [stderr] su: No module specific data is present
Dec 04 23:46:33.732 INFO running `"docker" "inspect" "8c9c55ee864105c294441004ab095ead4ab052b20392653e87db416dabc25344"`
Dec 04 23:46:34.062 INFO running `"docker" "rm" "-f" "8c9c55ee864105c294441004ab095ead4ab052b20392653e87db416dabc25344"`
Dec 04 23:46:34.400 INFO [stdout] 8c9c55ee864105c294441004ab095ead4ab052b20392653e87db416dabc25344
Dec 04 23:46:34.408 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-2/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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 04 23:46:34.932 INFO [stdout] 29a49c23f9accf631a0db9a1818e394428cf5ddf833697a725110f0f3f61ec06
Dec 04 23:46:34.936 INFO running `"docker" "start" "-a" "29a49c23f9accf631a0db9a1818e394428cf5ddf833697a725110f0f3f61ec06"`
Dec 04 23:46:36.928 INFO [stderr] usermod: no changes
Dec 04 23:46:37.141 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.18s
Dec 04 23:46:37.160 INFO [stderr]      Running /target/debug/deps/mprovision-a03b8c7f75fd7528
Dec 04 23:46:37.160 INFO [stdout] 
Dec 04 23:46:37.160 INFO [stdout] running 6 tests
Dec 04 23:46:37.192 INFO [stdout] test profile::tests::contains ... ok
Dec 04 23:46:37.192 INFO [stdout] test plist_extractor::tests::test_find_plist ... ok
Dec 04 23:46:37.192 INFO [stdout] test profile::tests::correct_bundle_id ... ok
Dec 04 23:46:37.192 INFO [stdout] test profile::tests::wildcard_bundle_id ... ok
Dec 04 23:46:37.192 INFO [stdout] test profile::tests::incorrect_bundle_id ... ok
Dec 04 23:46:37.192 INFO [stdout] test tests::filter_mobileprovision_files ... ok
Dec 04 23:46:37.192 INFO [stdout] 
Dec 04 23:46:37.192 INFO [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 04 23:46:37.192 INFO [stdout] 
Dec 04 23:46:37.192 INFO [stdout] 
Dec 04 23:46:37.192 INFO [stdout] running 5 tests
Dec 04 23:46:37.192 INFO [stderr]      Running /target/debug/deps/mprovision-975dd454e482390e
Dec 04 23:46:37.200 INFO [stdout] test cli::tests::remove_id_command ... ok
Dec 04 23:46:37.200 INFO [stdout] test cli::tests::list_command ... ok
Dec 04 23:46:37.216 INFO [stdout] test cli::tests::clean_command ... ok
Dec 04 23:46:37.216 INFO [stdout] test cli::tests::show_uuid_command ... ok
Dec 04 23:46:37.216 INFO [stdout] test cli::tests::show_file_command ... ok
Dec 04 23:46:37.216 INFO [stdout] 
Dec 04 23:46:37.216 INFO [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 04 23:46:37.216 INFO [stdout] 
Dec 04 23:46:37.216 INFO [stderr]    Doc-tests mprovision
Dec 04 23:46:37.440 INFO [stdout] 
Dec 04 23:46:37.440 INFO [stdout] running 0 tests
Dec 04 23:46:37.440 INFO [stdout] 
Dec 04 23:46:37.440 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 04 23:46:37.440 INFO [stdout] 
Dec 04 23:46:37.455 INFO [stderr] su: No module specific data is present
Dec 04 23:46:38.776 INFO running `"docker" "inspect" "29a49c23f9accf631a0db9a1818e394428cf5ddf833697a725110f0f3f61ec06"`
Dec 04 23:46:39.158 INFO running `"docker" "rm" "-f" "29a49c23f9accf631a0db9a1818e394428cf5ddf833697a725110f0f3f61ec06"`
Dec 04 23:46:39.496 INFO [stdout] 29a49c23f9accf631a0db9a1818e394428cf5ddf833697a725110f0f3f61ec06