Dec 15 01:02:26.726 INFO testing probes-0.2.1 against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 15 01:02:26.726 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-7/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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 15 01:02:26.907 INFO [stdout] c086b27ae80c50e064c58d82737bf4ad2126a4ead3ef6309a8fef28a6fe16e46
Dec 15 01:02:26.909 INFO running `"docker" "start" "-a" "c086b27ae80c50e064c58d82737bf4ad2126a4ead3ef6309a8fef28a6fe16e46"`
Dec 15 01:02:27.506 INFO [stderr] usermod: no changes
Dec 15 01:02:27.543 INFO [stderr]    Compiling probes v0.2.1 (/source)
Dec 15 01:02:29.494 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.97s
Dec 15 01:02:29.496 INFO [stderr] su: No module specific data is present
Dec 15 01:02:29.735 INFO running `"docker" "inspect" "c086b27ae80c50e064c58d82737bf4ad2126a4ead3ef6309a8fef28a6fe16e46"`
Dec 15 01:02:29.812 INFO running `"docker" "rm" "-f" "c086b27ae80c50e064c58d82737bf4ad2126a4ead3ef6309a8fef28a6fe16e46"`
Dec 15 01:02:29.897 INFO [stdout] c086b27ae80c50e064c58d82737bf4ad2126a4ead3ef6309a8fef28a6fe16e46
Dec 15 01:02:29.899 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-7/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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 15 01:02:30.058 INFO [stdout] e7d90f1d29c47283eab7c3848691c616d81f43dabbeffb82b7093c3cbfcabb8a
Dec 15 01:02:30.060 INFO running `"docker" "start" "-a" "e7d90f1d29c47283eab7c3848691c616d81f43dabbeffb82b7093c3cbfcabb8a"`
Dec 15 01:02:30.478 INFO [stderr] usermod: no changes
Dec 15 01:02:30.518 INFO [stderr]    Compiling probes v0.2.1 (/source)
Dec 15 01:02:33.257 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.76s
Dec 15 01:02:33.260 INFO [stderr] su: No module specific data is present
Dec 15 01:02:33.839 INFO running `"docker" "inspect" "e7d90f1d29c47283eab7c3848691c616d81f43dabbeffb82b7093c3cbfcabb8a"`
Dec 15 01:02:34.067 INFO running `"docker" "rm" "-f" "e7d90f1d29c47283eab7c3848691c616d81f43dabbeffb82b7093c3cbfcabb8a"`
Dec 15 01:02:34.359 INFO [stdout] e7d90f1d29c47283eab7c3848691c616d81f43dabbeffb82b7093c3cbfcabb8a
Dec 15 01:02:34.362 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-7/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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 15 01:02:34.842 INFO [stdout] e0f97835677bb8efab275b9ab7ade31f7f637dcdcc8cd605f1dc20b04d7ec206
Dec 15 01:02:34.851 INFO running `"docker" "start" "-a" "e0f97835677bb8efab275b9ab7ade31f7f637dcdcc8cd605f1dc20b04d7ec206"`
Dec 15 01:02:35.715 INFO [stderr] usermod: no changes
Dec 15 01:02:35.769 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.02s
Dec 15 01:02:35.769 INFO [stderr]      Running /target/debug/deps/probes-7f9f7e258a8e0c78
Dec 15 01:02:35.772 INFO [stdout] 
Dec 15 01:02:35.772 INFO [stdout] running 67 tests
Dec 15 01:02:35.772 INFO [stdout] test cpu::test::test_calculate_per_minute_values_lower ... ok
Dec 15 01:02:35.772 INFO [stdout] test cpu::test::test_calculate_per_minute_partial_minute ... ok
Dec 15 01:02:35.772 INFO [stdout] test cpu::test::test_calculate_per_minute_full_minute ... ok
Dec 15 01:02:35.773 INFO [stdout] test cpu::test::test_read_and_parse_proc_stat_incomplete ... ok
Dec 15 01:02:35.773 INFO [stdout] test cpu::test::test_in_percentages ... ok
Dec 15 01:02:35.773 INFO [stdout] test cpu::test::test_in_percentages_fractions ... ok
Dec 15 01:02:35.773 INFO [stdout] test cpu::test::test_in_percentages_integration ... ok
Dec 15 01:02:35.773 INFO [stdout] test cpu::test::test_read_cpu_measurement ... ok
Dec 15 01:02:35.783 INFO [stdout] test cpu::test::test_wrong_path ... ok
Dec 15 01:02:35.783 INFO [stdout] test cpu::test::test_calculate_per_minute_wrong_times ... ok
Dec 15 01:02:35.787 INFO [stdout] test disk_stats::tests::test_calculate_per_minute_full_minute ... ok
Dec 15 01:02:35.787 INFO [stdout] test disk_stats::tests::test_calculate_per_minute_wrong_times ... ok
Dec 15 01:02:35.787 INFO [stdout] test cpu::test::test_read_cpu_measurement_from_partial ... ok
Dec 15 01:02:35.787 INFO [stdout] test disk_stats::tests::test_calculate_per_minute_different_disks ... ok
Dec 15 01:02:35.787 INFO [stdout] test cpu::test::test_read_and_parse_proc_stat_garbage ... ok
Dec 15 01:02:35.787 INFO [stdout] test disk_stats::tests::test_calculate_per_minute_values_lower ... ok
Dec 15 01:02:35.787 INFO [stdout] test disk_stats::tests::test_calculate_per_minute_partial_minute ... ok
Dec 15 01:02:35.791 INFO [stdout] test disk_usage::tests::test_parse_df_output ... ok
Dec 15 01:02:35.791 INFO [stdout] test disk_usage::tests::test_parse_df_output_garbage ... ok
Dec 15 01:02:35.791 INFO [stdout] test disk_usage::tests::test_parse_df_output_incomplete ... ok
Dec 15 01:02:35.791 INFO [stdout] test disk_usage::tests::test_read_disks ... ok
Dec 15 01:02:35.791 INFO [stdout] test load::tests::test_read_and_parse_load_average ... ok
Dec 15 01:02:35.791 INFO [stdout] test load::tests::test_read_and_parse_load_average_garbage ... ok
Dec 15 01:02:35.791 INFO [stdout] test disk_stats::tests::test_read_and_parse_proc_diskstats_garbage ... ok
Dec 15 01:02:35.791 INFO [stdout] test load::tests::test_read_and_parse_load_average_incomplete ... ok
Dec 15 01:02:35.791 INFO [stdout] test load::tests::test_read_and_parse_load_average_wrong_path ... ok
Dec 15 01:02:35.791 INFO [stdout] test disk_stats::tests::test_read_disk_stats ... ok
Dec 15 01:02:35.791 INFO [stdout] test memory::tests::test_read_and_parse_memory_wrong_path ... ok
Dec 15 01:02:35.792 INFO [stdout] test disk_stats::tests::test_read_and_parse_proc_diskstats ... ok
Dec 15 01:02:35.792 INFO [stdout] test load::tests::test_read_load_average ... ok
Dec 15 01:02:35.792 INFO [stdout] test memory::tests::test_read_and_parse_proc_memory ... ok
Dec 15 01:02:35.792 INFO [stdout] test memory::tests::test_read_and_parse_sys_memory ... ok
Dec 15 01:02:35.792 INFO [stdout] test memory::tests::test_read_and_parse_sys_memory_garbage ... ok
Dec 15 01:02:35.799 INFO [stdout] test memory::tests::test_read_and_parse_memory_incomplete ... ok
Dec 15 01:02:35.799 INFO [stdout] test memory::tests::test_read_and_parse_memory_garbage ... ok
Dec 15 01:02:35.805 INFO [stdout] test memory::tests::test_read_and_parse_sys_memory_wrong_path ... ok
Dec 15 01:02:35.805 INFO [stdout] test memory::tests::test_read_and_parse_sys_memory_no_swap ... ok
Dec 15 01:02:35.805 INFO [stdout] test memory::tests::test_read_and_parse_sys_memory_missing_files ... ok
Dec 15 01:02:35.805 INFO [stdout] test memory::tests::test_read_and_parse_sys_memory_incomplete ... ok
Dec 15 01:02:35.805 INFO [stdout] test memory::tests::test_read_memory ... ok
Dec 15 01:02:35.805 INFO [stdout] test memory::tests::test_read_from_container ... ok
Dec 15 01:02:35.805 INFO [stdout] test disk_stats::tests::test_read_and_parse_proc_diskstats_incomplete ... ok
Dec 15 01:02:35.807 INFO [stdout] test network::tests::test_calculate_per_minute_partial_minute ... ok
Dec 15 01:02:35.810 INFO [stdout] test network::tests::test_calculate_per_minute_values_lower ... ok
Dec 15 01:02:35.810 INFO [stdout] test network::tests::test_calculate_per_minute_wrong_times ... ok
Dec 15 01:02:35.810 INFO [stdout] test network::tests::test_calculate_per_minute_full_minute ... ok
Dec 15 01:02:35.810 INFO [stdout] test network::tests::test_get_positions ... ok
Dec 15 01:02:35.810 INFO [stdout] test network::tests::test_get_positions_fields_missing ... ok
Dec 15 01:02:35.810 INFO [stdout] test network::tests::test_get_positions_bytes_field_missing ... ok
Dec 15 01:02:35.810 INFO [stdout] test network::tests::test_read_and_parse_network ... ok
Dec 15 01:02:35.810 INFO [stdout] test network::tests::test_calculate_per_minute_different_interfaces ... ok
Dec 15 01:02:35.810 INFO [stdout] test network::tests::test_read_and_parse_network_garbage ... ok
Dec 15 01:02:35.810 INFO [stdout] test process_memory::tests::test_current_rss_of ... ok
Dec 15 01:02:35.810 INFO [stdout] test process_memory::tests::test_current_rss_of_invalid_pid ... ok
Dec 15 01:02:35.812 INFO [stdout] test process_memory::tests::test_read_and_get_current_rss_incomplete ... ok
Dec 15 01:02:35.812 INFO [stdout] test process_memory::tests::test_read_and_get_current_rss ... ok
Dec 15 01:02:35.812 INFO [stdout] test process_memory::tests::test_read_and_get_current_rss_wrong_path ... ok
Dec 15 01:02:35.812 INFO [stdout] test network::tests::test_read_and_parse_network_wrong_path ... ok
Dec 15 01:02:35.812 INFO [stdout] test network::tests::test_read_and_parse_network_incomplete ... ok
Dec 15 01:02:35.812 INFO [stdout] test process_memory::tests::test_read_and_get_current_rss_garbage ... ok
Dec 15 01:02:35.812 INFO [stdout] test process_memory::tests::test_max_rss ... ok
Dec 15 01:02:35.812 INFO [stdout] test network::tests::test_read_network ... ok
Dec 15 01:02:35.812 INFO [stdout] test process_memory::tests::test_current_rss ... ok
Dec 15 01:02:35.812 INFO [stdout] test tests::test_calculate_time_difference ... ok
Dec 15 01:02:35.812 INFO [stdout] test tests::test_time_adjusted_first_higher_than_lower ... ok
Dec 15 01:02:35.812 INFO [stdout] test tests::test_parse_u64 ... ok
Dec 15 01:02:35.812 INFO [stdout] test tests::test_time_adjusted ... ok
Dec 15 01:02:35.812 INFO [stdout] 
Dec 15 01:02:35.812 INFO [stdout] test result: ok. 67 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 01:02:35.812 INFO [stdout] 
Dec 15 01:02:35.812 INFO [stderr]    Doc-tests probes
Dec 15 01:02:36.798 INFO [stdout] 
Dec 15 01:02:36.798 INFO [stdout] running 0 tests
Dec 15 01:02:36.798 INFO [stdout] 
Dec 15 01:02:36.798 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 01:02:36.798 INFO [stdout] 
Dec 15 01:02:36.806 INFO [stderr] su: No module specific data is present
Dec 15 01:02:37.415 INFO running `"docker" "inspect" "e0f97835677bb8efab275b9ab7ade31f7f637dcdcc8cd605f1dc20b04d7ec206"`
Dec 15 01:02:37.703 INFO running `"docker" "rm" "-f" "e0f97835677bb8efab275b9ab7ade31f7f637dcdcc8cd605f1dc20b04d7ec206"`
Dec 15 01:02:37.943 INFO [stdout] e0f97835677bb8efab275b9ab7ade31f7f637dcdcc8cd605f1dc20b04d7ec206