Dec 05 11:15:13.370 INFO testing pitkley/dfw against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 05 11:15:13.370 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-6/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 05 11:15:13.806 INFO [stdout] 06c8ef7ac936c67785e2b46209f37fc8493107bf2cf1d00f4b086da20dd63dd3
Dec 05 11:15:13.808 INFO running `"docker" "start" "-a" "06c8ef7ac936c67785e2b46209f37fc8493107bf2cf1d00f4b086da20dd63dd3"`
Dec 05 11:15:14.940 INFO [stderr] usermod: no changes
Dec 05 11:15:15.330 INFO [stderr]    Compiling proc-macro2 v0.4.16
Dec 05 11:15:15.330 INFO [stderr]    Compiling cc v1.0.23
Dec 05 11:15:15.342 INFO [stderr]    Compiling ident_case v1.0.0
Dec 05 11:15:15.347 INFO [stderr]    Compiling derive_builder v0.7.0
Dec 05 11:15:15.349 INFO [stderr]    Compiling unicode-bidi v0.2.6
Dec 05 11:15:15.349 INFO [stderr]    Compiling term v0.5.1
Dec 05 11:15:15.350 INFO [stderr]    Compiling jed v0.1.2
Dec 05 11:15:15.351 INFO [stderr]    Compiling log v0.3.9
Dec 05 11:15:16.692 INFO [stderr]    Compiling crossbeam-epoch v0.5.2
Dec 05 11:15:17.260 INFO [stderr]    Compiling memchr v2.0.2
Dec 05 11:15:18.855 INFO [stderr]    Compiling rand v0.5.5
Dec 05 11:15:18.961 INFO [stderr]    Compiling filetime v0.1.15
Dec 05 11:15:28.271 INFO [stderr]    Compiling isatty v0.1.8
Dec 05 11:15:28.546 INFO [stderr]    Compiling unix_socket v0.5.0
Dec 05 11:15:28.728 INFO [stderr]    Compiling mime v0.2.6
Dec 05 11:15:29.714 INFO [stderr]    Compiling aho-corasick v0.6.8
Dec 05 11:15:29.888 INFO [stderr]    Compiling tar v0.3.4
Dec 05 11:15:29.960 INFO [stderr]    Compiling chrono v0.4.6
Dec 05 11:15:30.265 INFO [stderr]    Compiling slog-stdlog v3.0.2
Dec 05 11:15:30.375 INFO [stderr]    Compiling nix v0.7.0
Dec 05 11:15:34.841 INFO [stderr]    Compiling uuid v0.2.3
Dec 05 11:15:34.920 INFO [stderr]    Compiling openssl-sys v0.9.35
Dec 05 11:15:34.998 INFO [stderr]    Compiling miniz-sys v0.1.10
Dec 05 11:15:42.275 INFO [stderr]    Compiling backtrace-sys v0.1.24
Dec 05 11:15:42.318 INFO [stderr]    Compiling regex v1.0.6
Dec 05 11:15:42.320 INFO [stderr]    Compiling regex v0.2.11
Dec 05 11:15:42.421 INFO [stderr]    Compiling hyper v0.10.13
Dec 05 11:15:48.568 INFO [stderr]    Compiling url v0.5.10
Dec 05 11:15:49.854 INFO [stderr]    Compiling parking_lot_core v0.3.0
Dec 05 11:15:50.444 INFO [stderr]    Compiling slog-term v2.4.0
Dec 05 11:15:56.896 INFO [stderr]    Compiling quote v0.6.8
Dec 05 11:16:19.590 INFO [stderr]    Compiling openssl v0.9.24
Dec 05 11:16:20.738 INFO [stderr]    Compiling parking_lot v0.6.4
Dec 05 11:16:21.085 INFO [stderr]    Compiling syn v0.15.22
Dec 05 11:16:21.094 INFO [stderr]    Compiling iptables v0.2.2
Dec 05 11:16:21.168 INFO [stderr]    Compiling flate2 v0.2.20
Dec 05 11:16:21.210 INFO [stderr]    Compiling hyperlocal v0.3.0
Dec 05 11:16:22.066 INFO [stderr]    Compiling slog-kvfilter v0.7.0
Dec 05 11:16:22.066 INFO [stderr]    Compiling backtrace v0.3.9
Dec 05 11:16:25.680 INFO [stderr]    Compiling crossbeam-channel v0.2.4
Dec 05 11:16:31.664 INFO [stderr]    Compiling hyper-openssl v0.2.7
Dec 05 11:16:33.128 INFO [stderr]    Compiling shiplift v0.3.2
Dec 05 11:16:46.628 INFO [stderr]    Compiling darling_core v0.8.0
Dec 05 11:16:46.628 INFO [stderr]    Compiling trackable_derive v0.1.1
Dec 05 11:16:46.628 INFO [stderr]    Compiling synstructure v0.10.1
Dec 05 11:16:46.628 INFO [stderr]    Compiling serde_derive v1.0.80
Dec 05 11:16:50.789 INFO [stderr]    Compiling trackable v0.2.20
Dec 05 11:16:52.083 INFO [stderr]    Compiling failure_derive v0.1.3
Dec 05 11:16:55.348 INFO [stderr]    Compiling failure v0.1.3
Dec 05 11:16:56.275 INFO [stderr]    Compiling darling_macro v0.8.0
Dec 05 11:16:59.004 INFO [stderr]    Compiling darling v0.8.0
Dec 05 11:16:59.697 INFO [stderr]    Compiling derive_builder_core v0.4.0
Dec 05 11:17:03.765 INFO [stderr]    Compiling sloggers v0.3.1
Dec 05 11:17:11.148 INFO [stderr]    Compiling dfw v0.5.1-alpha.0 (/source)
Dec 05 11:17:32.704 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2m 17s
Dec 05 11:17:32.732 INFO [stderr] su: No module specific data is present
Dec 05 11:17:33.519 INFO running `"docker" "inspect" "06c8ef7ac936c67785e2b46209f37fc8493107bf2cf1d00f4b086da20dd63dd3"`
Dec 05 11:17:33.807 INFO running `"docker" "rm" "-f" "06c8ef7ac936c67785e2b46209f37fc8493107bf2cf1d00f4b086da20dd63dd3"`
Dec 05 11:17:34.068 INFO [stdout] 06c8ef7ac936c67785e2b46209f37fc8493107bf2cf1d00f4b086da20dd63dd3
Dec 05 11:17:34.070 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-6/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 05 11:17:34.514 INFO [stdout] 8bb1dac0c56a2834de4be401528f5f679ef2280fac254f816938e870d33d02c5
Dec 05 11:17:34.516 INFO running `"docker" "start" "-a" "8bb1dac0c56a2834de4be401528f5f679ef2280fac254f816938e870d33d02c5"`
Dec 05 11:17:35.767 INFO [stderr] usermod: no changes
Dec 05 11:17:36.054 INFO [stderr]    Compiling serde_json v1.0.26
Dec 05 11:17:39.950 INFO [stderr]    Compiling eval v0.4.3
Dec 05 11:17:43.242 INFO [stderr]    Compiling dfw v0.5.1-alpha.0 (/source)
Dec 05 11:17:47.660 INFO [stderr] warning: function is never used: `load_loglines`
Dec 05 11:17:47.660 INFO [stderr]    --> tests/logs/mod.rs:174:1
Dec 05 11:17:47.660 INFO [stderr]     |
Dec 05 11:17:47.660 INFO [stderr] 174 | pub fn load_loglines(log_path: &str) -> Vec<LogLine> {
Dec 05 11:17:47.660 INFO [stderr]     | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 05 11:17:47.660 INFO [stderr]     |
Dec 05 11:17:47.660 INFO [stderr]     = note: #[warn(dead_code)] on by default
Dec 05 11:17:47.660 INFO [stderr] 
Dec 05 11:18:05.433 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 29.64s
Dec 05 11:18:05.456 INFO [stderr] su: No module specific data is present
Dec 05 11:18:06.034 INFO running `"docker" "inspect" "8bb1dac0c56a2834de4be401528f5f679ef2280fac254f816938e870d33d02c5"`
Dec 05 11:18:06.282 INFO running `"docker" "rm" "-f" "8bb1dac0c56a2834de4be401528f5f679ef2280fac254f816938e870d33d02c5"`
Dec 05 11:18:06.600 INFO [stdout] 8bb1dac0c56a2834de4be401528f5f679ef2280fac254f816938e870d33d02c5
Dec 05 11:18:06.606 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-6/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 05 11:18:07.074 INFO [stdout] 42a5d29ead6a4d1fe05ca74b8a210651760949ba6eed50df4f8f81d7975bc375
Dec 05 11:18:07.078 INFO running `"docker" "start" "-a" "42a5d29ead6a4d1fe05ca74b8a210651760949ba6eed50df4f8f81d7975bc375"`
Dec 05 11:18:08.372 INFO [stderr] usermod: no changes
Dec 05 11:18:08.852 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.42s
Dec 05 11:18:08.856 INFO [stderr]      Running /target/debug/deps/dfw-f63633beca8a82a9
Dec 05 11:18:08.880 INFO [stdout] 
Dec 05 11:18:08.880 INFO [stdout] running 4 tests
Dec 05 11:18:08.880 INFO [stdout] test iptables::tests_iptablesrestore::double_append ... ok
Dec 05 11:18:08.880 INFO [stdout] test iptables::tests_iptablesrestore::double_append_replace ... ok
Dec 05 11:18:08.880 INFO [stdout] test iptables::tests_iptablesrestore::restore_set_policy ... ok
Dec 05 11:18:08.880 INFO [stdout] test iptables::tests_iptablesrestore::restore_append ... ok
Dec 05 11:18:08.880 INFO [stdout] 
Dec 05 11:18:08.880 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 11:18:08.880 INFO [stdout] 
Dec 05 11:18:08.884 INFO [stderr]      Running /target/debug/deps/dfw-83b08d35702d3812
Dec 05 11:18:08.900 INFO [stderr]      Running /target/debug/deps/dfw-339344aa6867b5f3
Dec 05 11:18:08.900 INFO [stdout] 
Dec 05 11:18:08.900 INFO [stdout] running 0 tests
Dec 05 11:18:08.900 INFO [stdout] 
Dec 05 11:18:08.900 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 11:18:08.900 INFO [stdout] 
Dec 05 11:18:08.904 INFO [stdout] 
Dec 05 11:18:08.904 INFO [stderr]      Running /target/debug/deps/iptables_dummy-8bff62697727ad4c
Dec 05 11:18:08.904 INFO [stdout] running 0 tests
Dec 05 11:18:08.904 INFO [stdout] 
Dec 05 11:18:08.904 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 11:18:08.904 INFO [stdout] 
Dec 05 11:18:08.904 INFO [stdout] 
Dec 05 11:18:08.904 INFO [stdout] running 21 tests
Dec 05 11:18:08.908 INFO [stdout] test dummy_append_unique ... ok
Dec 05 11:18:08.908 INFO [stdout] test dummy_append_replace ... ok
Dec 05 11:18:08.908 INFO [stdout] test dummy_delete ... ok
Dec 05 11:18:08.908 INFO [stdout] test dummy_flush_table ... ok
Dec 05 11:18:08.908 INFO [stdout] test dummy_get_policy ... ok
Dec 05 11:18:08.908 INFO [stdout] test dummy_insert ... ok
Dec 05 11:18:08.908 INFO [stdout] test dummy_insert_unique ... ok
Dec 05 11:18:08.908 INFO [stdout] test dummy_list ... ok
Dec 05 11:18:08.908 INFO [stdout] test dummy_list_chains ... ok
Dec 05 11:18:08.908 INFO [stdout] test dummy_list_table ... ok
Dec 05 11:18:08.908 INFO [stdout] test dummy_new_chain ... ok
Dec 05 11:18:08.908 INFO [stdout] test dummy_rename_chain ... ok
Dec 05 11:18:08.908 INFO [stdout] test dummy_replace ... ok
Dec 05 11:18:08.908 INFO [stdout] test dummy_set_policy ... ok
Dec 05 11:18:08.908 INFO [stdout] test dummy_exists ... ok
Dec 05 11:18:08.908 INFO [stdout] test dummy_flush_chain ... ok
Dec 05 11:18:08.908 INFO [stdout] test dummy_delete_all ... ok
Dec 05 11:18:08.908 INFO [stdout] test dummy_execute ... ok
Dec 05 11:18:08.908 INFO [stdout] test dummy_delete_chain ... ok
Dec 05 11:18:08.912 INFO [stdout] test dummy_chain_exists ... ok
Dec 05 11:18:08.912 INFO [stderr]      Running /target/debug/deps/iptables_logger-b26be87bf01b3746
Dec 05 11:18:08.912 INFO [stdout] test dummy_append ... ok
Dec 05 11:18:08.912 INFO [stdout] 
Dec 05 11:18:08.912 INFO [stdout] test result: ok. 21 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 11:18:08.912 INFO [stdout] 
Dec 05 11:18:08.916 INFO [stdout] 
Dec 05 11:18:08.916 INFO [stderr]      Running /target/debug/deps/logline-a1f5623f3ae361e0
Dec 05 11:18:08.916 INFO [stdout] running 1 test
Dec 05 11:18:08.916 INFO [stdout] test log_all ... ok
Dec 05 11:18:08.916 INFO [stdout] 
Dec 05 11:18:08.916 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 11:18:08.916 INFO [stdout] 
Dec 05 11:18:08.932 INFO [stdout] 
Dec 05 11:18:08.932 INFO [stdout] running 15 tests
Dec 05 11:18:08.932 INFO [stdout] test logline_from_string_without_command ... ok
Dec 05 11:18:08.948 INFO [stdout] test regex_ne_regex ... ok
Dec 05 11:18:08.948 INFO [stdout] test regex_ne_self ... ok
Dec 05 11:18:08.964 INFO [stdout] test string_eq_self ... ok
Dec 05 11:18:09.004 INFO [stdout] test logline_from_string ... ok
Dec 05 11:18:09.004 INFO [stdout] test string_eq_string ... ok
Dec 05 11:18:09.004 INFO [stdout] test logline_from_wrong_string ... ok
Dec 05 11:18:09.016 INFO [stdout] test string_ne_string ... ok
Dec 05 11:18:09.016 INFO [stdout] test logline_from_string_with_eval ... ok
Dec 05 11:18:09.024 INFO [stdout] test logline_from_string_with_wrong_expansion ... ok
Dec 05 11:18:09.036 INFO [stdout] test string_ne_regex_eval ... ok
Dec 05 11:18:09.044 INFO [stdout] test logline_from_string_with_expansions ... ok
Dec 05 11:18:09.048 INFO [stdout] test string_eq_regex ... ok
Dec 05 11:18:09.053 INFO [stdout] test string_eq_regex_eval ... ok
Dec 05 11:18:09.053 INFO [stdout] test string_ne_regex ... ok
Dec 05 11:18:09.053 INFO [stdout] 
Dec 05 11:18:09.053 INFO [stdout] test result: ok. 15 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 11:18:09.053 INFO [stdout] 
Dec 05 11:18:09.058 INFO [stderr]      Running /target/debug/deps/types-11ad871fa1311e29
Dec 05 11:18:09.060 INFO [stdout] 
Dec 05 11:18:09.060 INFO [stdout] running 13 tests
Dec 05 11:18:09.060 INFO [stdout] test parse_expose_port_single_struct ... ok
Dec 05 11:18:09.060 INFO [stdout] test parse_expose_port_single_string ... ok
Dec 05 11:18:09.060 INFO [stdout] test parse_expose_port_single_int ... ok
Dec 05 11:18:09.076 INFO [stdout] test parse_expose_port_seq_int ... ok
Dec 05 11:18:09.076 INFO [stdout] test parse_expose_port_seq_string ... ok
Dec 05 11:18:09.081 INFO [stdout] test parse_conf_file ... ok
Dec 05 11:18:09.081 INFO [stdout] test parse_conf_path ... ok
Dec 05 11:18:09.082 INFO [stdout] test parse_expose_port_seq_struct ... ok
Dec 05 11:18:09.092 INFO [stdout] test parse_external_network_interfaces_seq ... ok
Dec 05 11:18:09.092 INFO [stdout] test parse_external_network_interfaces_single ... ok
Dec 05 11:18:09.241 INFO [stdout] test parse_expose_port_string_invalid_int ... ok
Dec 05 11:18:09.241 INFO [stdout] test parse_expose_port_string_invalid_int2 ... ok
Dec 05 11:18:09.241 INFO [stdout] test parse_expose_port_string_invalid_format ... ok
Dec 05 11:18:09.241 INFO [stdout] 
Dec 05 11:18:09.241 INFO [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 11:18:09.241 INFO [stdout] 
Dec 05 11:18:09.241 INFO [stderr]    Doc-tests dfw
Dec 05 11:18:12.340 INFO [stdout] 
Dec 05 11:18:12.340 INFO [stdout] running 2 tests
Dec 05 11:18:20.416 INFO [stdout] test src/types.rs - types::ExposePort::from_str (line 400) ... ok
Dec 05 11:18:20.592 INFO [stdout] test src/types.rs - types::ExposePort::from_str (line 408) ... ok
Dec 05 11:18:20.592 INFO [stdout] 
Dec 05 11:18:20.592 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 11:18:20.592 INFO [stdout] 
Dec 05 11:18:20.620 INFO [stderr] su: No module specific data is present
Dec 05 11:18:21.318 INFO running `"docker" "inspect" "42a5d29ead6a4d1fe05ca74b8a210651760949ba6eed50df4f8f81d7975bc375"`
Dec 05 11:18:21.574 INFO running `"docker" "rm" "-f" "42a5d29ead6a4d1fe05ca74b8a210651760949ba6eed50df4f8f81d7975bc375"`
Dec 05 11:18:21.948 INFO [stdout] 42a5d29ead6a4d1fe05ca74b8a210651760949ba6eed50df4f8f81d7975bc375