Nov 18 03:16:06.335 INFO testing probes-0.2.1 against master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c for pr-55982
Nov 18 03:16:06.335 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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"`
Nov 18 03:16:06.835 INFO [stdout] 32df9ab85d07fdb5695904d87e846bc785bcd459048b14a0f1269b960f2c69fe
Nov 18 03:16:06.839 INFO running `"docker" "start" "-a" "32df9ab85d07fdb5695904d87e846bc785bcd459048b14a0f1269b960f2c69fe"`
Nov 18 03:16:07.988 INFO [stderr] usermod: no changes
Nov 18 03:16:08.072 INFO [stderr]    Compiling probes v0.2.1 (/source)
Nov 18 03:16:09.859 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.85s
Nov 18 03:16:09.863 INFO [stderr] su: No module specific data is present
Nov 18 03:16:10.217 INFO running `"docker" "inspect" "32df9ab85d07fdb5695904d87e846bc785bcd459048b14a0f1269b960f2c69fe"`
Nov 18 03:16:10.319 INFO running `"docker" "rm" "-f" "32df9ab85d07fdb5695904d87e846bc785bcd459048b14a0f1269b960f2c69fe"`
Nov 18 03:16:10.459 INFO [stdout] 32df9ab85d07fdb5695904d87e846bc785bcd459048b14a0f1269b960f2c69fe
Nov 18 03:16:10.460 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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"`
Nov 18 03:16:10.751 INFO [stdout] e7074a501c60d1840ce064324cc10148ce856fb03f11bfcf56ebbf0dd5ddc837
Nov 18 03:16:10.755 INFO running `"docker" "start" "-a" "e7074a501c60d1840ce064324cc10148ce856fb03f11bfcf56ebbf0dd5ddc837"`
Nov 18 03:16:11.651 INFO [stderr] usermod: no changes
Nov 18 03:16:11.697 INFO [stderr]    Compiling probes v0.2.1 (/source)
Nov 18 03:16:14.845 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.17s
Nov 18 03:16:14.848 INFO [stderr] su: No module specific data is present
Nov 18 03:16:15.149 INFO running `"docker" "inspect" "e7074a501c60d1840ce064324cc10148ce856fb03f11bfcf56ebbf0dd5ddc837"`
Nov 18 03:16:15.401 INFO running `"docker" "rm" "-f" "e7074a501c60d1840ce064324cc10148ce856fb03f11bfcf56ebbf0dd5ddc837"`
Nov 18 03:16:15.603 INFO [stdout] e7074a501c60d1840ce064324cc10148ce856fb03f11bfcf56ebbf0dd5ddc837
Nov 18 03:16:15.607 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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"`
Nov 18 03:16:16.151 INFO [stdout] b3bc6a45c998879e6d4e0daf21032d3a781927ad53e593b2f872d9ece4ae0daf
Nov 18 03:16:16.159 INFO running `"docker" "start" "-a" "b3bc6a45c998879e6d4e0daf21032d3a781927ad53e593b2f872d9ece4ae0daf"`
Nov 18 03:16:17.116 INFO [stderr] usermod: no changes
Nov 18 03:16:17.190 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.05s
Nov 18 03:16:17.193 INFO [stderr]      Running /target/debug/deps/probes-359e4b916ac4c6a6
Nov 18 03:16:17.197 INFO [stdout] 
Nov 18 03:16:17.197 INFO [stdout] running 67 tests
Nov 18 03:16:17.203 INFO [stdout] test cpu::test::test_read_and_parse_proc_stat_garbage ... ok
Nov 18 03:16:17.204 INFO [stdout] test cpu::test::test_in_percentages_integration ... ok
Nov 18 03:16:17.204 INFO [stdout] test cpu::test::test_in_percentages_fractions ... ok
Nov 18 03:16:17.204 INFO [stdout] test cpu::test::test_in_percentages ... ok
Nov 18 03:16:17.205 INFO [stdout] test cpu::test::test_read_and_parse_proc_stat_incomplete ... ok
Nov 18 03:16:17.205 INFO [stdout] test cpu::test::test_read_cpu_measurement ... ok
Nov 18 03:16:17.205 INFO [stdout] test cpu::test::test_calculate_per_minute_values_lower ... ok
Nov 18 03:16:17.206 INFO [stdout] test cpu::test::test_read_cpu_measurement_from_partial ... ok
Nov 18 03:16:17.206 INFO [stdout] test cpu::test::test_wrong_path ... ok
Nov 18 03:16:17.206 INFO [stdout] test cpu::test::test_calculate_per_minute_partial_minute ... ok
Nov 18 03:16:17.207 INFO [stdout] test disk_stats::tests::test_calculate_per_minute_different_disks ... ok
Nov 18 03:16:17.207 INFO [stdout] test disk_stats::tests::test_calculate_per_minute_full_minute ... ok
Nov 18 03:16:17.207 INFO [stdout] test disk_stats::tests::test_calculate_per_minute_values_lower ... ok
Nov 18 03:16:17.208 INFO [stdout] test disk_stats::tests::test_calculate_per_minute_partial_minute ... ok
Nov 18 03:16:17.208 INFO [stdout] test disk_stats::tests::test_read_disk_stats ... ok
Nov 18 03:16:17.208 INFO [stdout] test disk_stats::tests::test_read_and_parse_proc_diskstats_incomplete ... ok
Nov 18 03:16:17.209 INFO [stdout] test disk_stats::tests::test_calculate_per_minute_wrong_times ... ok
Nov 18 03:16:17.209 INFO [stdout] test disk_usage::tests::test_parse_df_output_incomplete ... ok
Nov 18 03:16:17.209 INFO [stdout] test cpu::test::test_calculate_per_minute_full_minute ... ok
Nov 18 03:16:17.210 INFO [stdout] test load::tests::test_read_and_parse_load_average_garbage ... ok
Nov 18 03:16:17.210 INFO [stdout] test load::tests::test_read_and_parse_load_average_incomplete ... ok
Nov 18 03:16:17.210 INFO [stdout] test disk_usage::tests::test_parse_df_output ... ok
Nov 18 03:16:17.211 INFO [stdout] test disk_usage::tests::test_parse_df_output_garbage ... ok
Nov 18 03:16:17.211 INFO [stdout] test load::tests::test_read_load_average ... ok
Nov 18 03:16:17.211 INFO [stdout] test load::tests::test_read_and_parse_load_average ... ok
Nov 18 03:16:17.212 INFO [stdout] test load::tests::test_read_and_parse_load_average_wrong_path ... ok
Nov 18 03:16:17.212 INFO [stdout] test memory::tests::test_read_and_parse_memory_garbage ... ok
Nov 18 03:16:17.212 INFO [stdout] test disk_stats::tests::test_read_and_parse_proc_diskstats_garbage ... ok
Nov 18 03:16:17.213 INFO [stdout] test disk_stats::tests::test_read_and_parse_proc_diskstats ... ok
Nov 18 03:16:17.213 INFO [stdout] test cpu::test::test_calculate_per_minute_wrong_times ... ok
Nov 18 03:16:17.215 INFO [stdout] test memory::tests::test_read_and_parse_memory_incomplete ... ok
Nov 18 03:16:17.215 INFO [stdout] test disk_usage::tests::test_read_disks ... ok
Nov 18 03:16:17.216 INFO [stdout] test memory::tests::test_read_and_parse_proc_memory ... ok
Nov 18 03:16:17.216 INFO [stdout] test memory::tests::test_read_and_parse_sys_memory_garbage ... ok
Nov 18 03:16:17.216 INFO [stdout] test memory::tests::test_read_and_parse_sys_memory ... ok
Nov 18 03:16:17.217 INFO [stdout] test memory::tests::test_read_and_parse_sys_memory_missing_files ... ok
Nov 18 03:16:17.217 INFO [stdout] test memory::tests::test_read_and_parse_memory_wrong_path ... ok
Nov 18 03:16:17.217 INFO [stdout] test memory::tests::test_read_and_parse_sys_memory_incomplete ... ok
Nov 18 03:16:17.217 INFO [stdout] test memory::tests::test_read_and_parse_sys_memory_wrong_path ... ok
Nov 18 03:16:17.218 INFO [stdout] test memory::tests::test_read_memory ... ok
Nov 18 03:16:17.218 INFO [stdout] test network::tests::test_calculate_per_minute_different_interfaces ... ok
Nov 18 03:16:17.218 INFO [stdout] test network::tests::test_calculate_per_minute_partial_minute ... ok
Nov 18 03:16:17.218 INFO [stdout] test network::tests::test_calculate_per_minute_full_minute ... ok
Nov 18 03:16:17.219 INFO [stdout] test network::tests::test_get_positions ... ok
Nov 18 03:16:17.219 INFO [stdout] test network::tests::test_get_positions_bytes_field_missing ... ok
Nov 18 03:16:17.219 INFO [stdout] test network::tests::test_get_positions_fields_missing ... ok
Nov 18 03:16:17.220 INFO [stdout] test network::tests::test_read_and_parse_network ... ok
Nov 18 03:16:17.220 INFO [stdout] test network::tests::test_calculate_per_minute_wrong_times ... ok
Nov 18 03:16:17.220 INFO [stdout] test memory::tests::test_read_from_container ... ok
Nov 18 03:16:17.221 INFO [stdout] test network::tests::test_calculate_per_minute_values_lower ... ok
Nov 18 03:16:17.221 INFO [stdout] test network::tests::test_read_and_parse_network_garbage ... ok
Nov 18 03:16:17.221 INFO [stdout] test process_memory::tests::test_current_rss_of_invalid_pid ... ok
Nov 18 03:16:17.221 INFO [stdout] test process_memory::tests::test_max_rss ... ok
Nov 18 03:16:17.222 INFO [stdout] test process_memory::tests::test_read_and_get_current_rss ... ok
Nov 18 03:16:17.222 INFO [stdout] test process_memory::tests::test_read_and_get_current_rss_garbage ... ok
Nov 18 03:16:17.222 INFO [stdout] test process_memory::tests::test_read_and_get_current_rss_incomplete ... ok
Nov 18 03:16:17.223 INFO [stdout] test process_memory::tests::test_read_and_get_current_rss_wrong_path ... ok
Nov 18 03:16:17.223 INFO [stdout] test tests::test_calculate_time_difference ... ok
Nov 18 03:16:17.223 INFO [stdout] test tests::test_parse_u64 ... ok
Nov 18 03:16:17.223 INFO [stdout] test tests::test_time_adjusted ... ok
Nov 18 03:16:17.224 INFO [stdout] test tests::test_time_adjusted_first_higher_than_lower ... ok
Nov 18 03:16:17.227 INFO [stdout] test memory::tests::test_read_and_parse_sys_memory_no_swap ... ok
Nov 18 03:16:17.227 INFO [stderr]    Doc-tests probes
Nov 18 03:16:17.227 INFO [stdout] test network::tests::test_read_and_parse_network_wrong_path ... ok
Nov 18 03:16:17.227 INFO [stdout] test network::tests::test_read_and_parse_network_incomplete ... ok
Nov 18 03:16:17.227 INFO [stdout] test process_memory::tests::test_current_rss ... ok
Nov 18 03:16:17.227 INFO [stdout] test process_memory::tests::test_current_rss_of ... ok
Nov 18 03:16:17.227 INFO [stdout] test network::tests::test_read_network ... ok
Nov 18 03:16:17.227 INFO [stdout] 
Nov 18 03:16:17.227 INFO [stdout] test result: ok. 67 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 03:16:17.227 INFO [stdout] 
Nov 18 03:16:18.064 INFO [stdout] 
Nov 18 03:16:18.064 INFO [stdout] running 0 tests
Nov 18 03:16:18.064 INFO [stdout] 
Nov 18 03:16:18.064 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 03:16:18.064 INFO [stdout] 
Nov 18 03:16:18.071 INFO [stderr] su: No module specific data is present
Nov 18 03:16:18.471 INFO running `"docker" "inspect" "b3bc6a45c998879e6d4e0daf21032d3a781927ad53e593b2f872d9ece4ae0daf"`
Nov 18 03:16:18.589 INFO running `"docker" "rm" "-f" "b3bc6a45c998879e6d4e0daf21032d3a781927ad53e593b2f872d9ece4ae0daf"`
Nov 18 03:16:18.686 INFO [stdout] b3bc6a45c998879e6d4e0daf21032d3a781927ad53e593b2f872d9ece4ae0daf