[INFO] fetching crate psutil 1.4.0...
[INFO] extracting crate psutil 1.4.0 into work/ex/pr-61629/sources/master#c8865d8e195813ade6b84434ac9f8850e7112d1a/reg/psutil/1.4.0
[INFO] extracting crate psutil 1.4.0 into work/ex/pr-61629/sources/try#e212b7d492c96d3837691ba29d32d5f468933fb8/reg/psutil/1.4.0
[INFO] validating manifest of psutil-1.4.0 on toolchain master#c8865d8e195813ade6b84434ac9f8850e7112d1a
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+c8865d8e195813ade6b84434ac9f8850e7112d1a-alt" "read-manifest" "--manifest-path" "Cargo.toml"`
[INFO] validating manifest of psutil-1.4.0 on toolchain try#e212b7d492c96d3837691ba29d32d5f468933fb8
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+e212b7d492c96d3837691ba29d32d5f468933fb8-alt" "read-manifest" "--manifest-path" "Cargo.toml"`
[INFO] started frobbing psutil-1.4.0
[INFO] finished frobbing psutil-1.4.0
[INFO] frobbed toml for psutil-1.4.0 written to work/ex/pr-61629/sources/master#c8865d8e195813ade6b84434ac9f8850e7112d1a/reg/psutil/1.4.0/Cargo.toml
[INFO] started frobbing psutil-1.4.0
[INFO] finished frobbing psutil-1.4.0
[INFO] frobbed toml for psutil-1.4.0 written to work/ex/pr-61629/sources/try#e212b7d492c96d3837691ba29d32d5f468933fb8/reg/psutil/1.4.0/Cargo.toml
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+c8865d8e195813ade6b84434ac9f8850e7112d1a-alt" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update"`
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+e212b7d492c96d3837691ba29d32d5f468933fb8-alt" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update"`
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+c8865d8e195813ade6b84434ac9f8850e7112d1a-alt" "fetch" "--locked" "--manifest-path" "Cargo.toml"`
[INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+e212b7d492c96d3837691ba29d32d5f468933fb8-alt" "fetch" "--locked" "--manifest-path" "Cargo.toml"`
[INFO] testing psutil-1.4.0 against master#c8865d8e195813ade6b84434ac9f8850e7112d1a for pr-61629
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-61629/worker-4/master#c8865d8e195813ade6b84434ac9f8850e7112d1a:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/pr-61629/sources/master#c8865d8e195813ade6b84434ac9f8850e7112d1a/reg/psutil/1.4.0:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+c8865d8e195813ade6b84434ac9f8850e7112d1a-alt" "build" "--frozen"`
[INFO] [stdout] fc6ea3c4b36fd64ff4e35cce824d097ac4c875001e5b8bad3f3135f0a1302578
[INFO] running `"docker" "start" "-a" "fc6ea3c4b36fd64ff4e35cce824d097ac4c875001e5b8bad3f3135f0a1302578"`
[INFO] [stderr]    Compiling psutil v1.4.0 (/opt/crater/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.81s
[INFO] running `"docker" "inspect" "fc6ea3c4b36fd64ff4e35cce824d097ac4c875001e5b8bad3f3135f0a1302578"`
[INFO] running `"docker" "rm" "-f" "fc6ea3c4b36fd64ff4e35cce824d097ac4c875001e5b8bad3f3135f0a1302578"`
[INFO] [stdout] fc6ea3c4b36fd64ff4e35cce824d097ac4c875001e5b8bad3f3135f0a1302578
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-61629/worker-4/master#c8865d8e195813ade6b84434ac9f8850e7112d1a:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/pr-61629/sources/master#c8865d8e195813ade6b84434ac9f8850e7112d1a/reg/psutil/1.4.0:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+c8865d8e195813ade6b84434ac9f8850e7112d1a-alt" "test" "--frozen" "--no-run"`
[INFO] [stdout] 8e0dc36f90367f62c39207bd29cc94f2d122863dce9ae089e7d032be42539a1e
[INFO] running `"docker" "start" "-a" "8e0dc36f90367f62c39207bd29cc94f2d122863dce9ae089e7d032be42539a1e"`
[INFO] [stderr]    Compiling psutil v1.4.0 (/opt/crater/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.72s
[INFO] running `"docker" "inspect" "8e0dc36f90367f62c39207bd29cc94f2d122863dce9ae089e7d032be42539a1e"`
[INFO] running `"docker" "rm" "-f" "8e0dc36f90367f62c39207bd29cc94f2d122863dce9ae089e7d032be42539a1e"`
[INFO] [stdout] 8e0dc36f90367f62c39207bd29cc94f2d122863dce9ae089e7d032be42539a1e
[INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-61629/worker-4/master#c8865d8e195813ade6b84434ac9f8850e7112d1a:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/pr-61629/sources/master#c8865d8e195813ade6b84434ac9f8850e7112d1a/reg/psutil/1.4.0:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+c8865d8e195813ade6b84434ac9f8850e7112d1a-alt" "test" "--frozen"`
[INFO] [stdout] 7395833d3648ceccbc8fc68de8696a1b98d48bc99931b29b82eff35a812cde49
[INFO] running `"docker" "start" "-a" "7395833d3648ceccbc8fc68de8696a1b98d48bc99931b29b82eff35a812cde49"`
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.02s
[INFO] [stderr]      Running /opt/crater/target/debug/deps/psutil-717401fe34953d07
[INFO] [stdout] 
[INFO] [stdout] running 19 tests
[INFO] [stdout] test process::unit_tests::starttime_in_seconds_and_ticks ... ok
[INFO] [stdout] test disk::unit_test::line_disk_stats_test ... ok
[INFO] [stdout] test disk::unit_test::fstype_test ... ok
[INFO] [stdout] test disk::unit_test::get_partitions_test ... ok
[INFO] [stdout] test network::unit_test::total_net_io_counters_test ... ok
[INFO] [stdout] test process::unit_tests::environ ... ok
[INFO] [stdout] test process::unit_tests::stat_52_fields ... ok
[INFO] [stdout] test system::unit_tests::cpu_time_percent_test ... ok
[INFO] [stdout] test system::unit_tests::info_cpu_line_test ... ok
[INFO] [stdout] test system::unit_tests::loadavg_parses ... ok
[INFO] [stdout] test system::unit_tests::cpu_line_to_cpu_times_test ... ok
[INFO] [stdout] test system::unit_tests::make_map_spaces ... ok
[INFO] [stdout] test system::unit_tests::make_map_error ... ok
[INFO] [stdout] test system::unit_tests::make_map_tabs ... ok
[INFO] [stdout] test system::unit_tests::make_map_with_ext ... ok
[INFO] [stdout] test system::unit_tests::multipler_kb ... ok
[INFO] [stdout] test system::unit_tests::uptime_parses ... ok
[INFO] [stdout] test system::unit_tests::multiplier_none ... ok
[INFO] [stdout] test system::unit_tests::multiplier_last ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 19 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stderr]      Running /opt/crater/target/debug/deps/lib-dc518a659ebc2c33
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test getpid ... ok
[INFO] [stdout] test getppid ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]      Running /opt/crater/target/debug/deps/pidfile-5dd82f11ac7b3f58
[INFO] [stdout] running 2 tests
[INFO] [stdout] test read_write_pidfile ... ok
[INFO] [stdout] test read_invalid_pidfile ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]      Running /opt/crater/target/debug/deps/process-a65cd4110757811e
[INFO] [stdout] running 9 tests
[INFO] [stdout] test process_inequality ... ok
[INFO] [stdout] test process_exe ... ok
[INFO] [stdout] test process_cwd ... ok
[INFO] [stdout] test process_cpu ... ok
[INFO] [stdout] test all ... ok
[INFO] [stdout] test process_cmdline ... ok
[INFO] [stdout] test process_memory ... ok
[INFO] [stdout] test process_equality ... ok
[INFO] [stdout] test process_alive ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]      Running /opt/crater/target/debug/deps/system-215565ba4de61a9e
[INFO] [stdout] running 4 tests
[INFO] [stdout] test uptime ... ok
[INFO] [stdout] test loadaverage ... ok
[INFO] [stderr]    Doc-tests psutil
[INFO] [stdout] test swap_memory ... ok
[INFO] [stdout] test virtual_memory ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test src/process.rs - process::all (line 594) ... ignored
[INFO] [stdout] test src/process.rs - process::Process (line 201) ... ok
[INFO] [stdout] test src/system.rs - system::CpuPercentCollector (line 280) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] running `"docker" "inspect" "7395833d3648ceccbc8fc68de8696a1b98d48bc99931b29b82eff35a812cde49"`
[INFO] running `"docker" "rm" "-f" "7395833d3648ceccbc8fc68de8696a1b98d48bc99931b29b82eff35a812cde49"`
[INFO] [stdout] 7395833d3648ceccbc8fc68de8696a1b98d48bc99931b29b82eff35a812cde49