Dec 13 07:17:14.816 INFO testing pitkley/dfw against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 13 07:17:14.816 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-7/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 13 07:17:15.190 INFO [stdout] a75b23393a0eb168182cf3387cd8ea52affa11a397e5c6254df23db83b0b7a6a
Dec 13 07:17:15.193 INFO running `"docker" "start" "-a" "a75b23393a0eb168182cf3387cd8ea52affa11a397e5c6254df23db83b0b7a6a"`
Dec 13 07:17:16.443 INFO [stderr] usermod: no changes
Dec 13 07:17:16.839 INFO [stderr]    Compiling proc-macro2 v0.4.16
Dec 13 07:17:16.839 INFO [stderr]    Compiling slog v2.4.1
Dec 13 07:17:16.895 INFO [stderr]    Compiling derive_builder v0.7.0
Dec 13 07:17:16.896 INFO [stderr]    Compiling miniz-sys v0.1.10
Dec 13 07:17:16.896 INFO [stderr]    Compiling unicode-bidi v0.2.6
Dec 13 07:17:16.897 INFO [stderr]    Compiling jed v0.1.2
Dec 13 07:17:16.902 INFO [stderr]    Compiling crossbeam-epoch v0.5.2
Dec 13 07:17:16.907 INFO [stderr]    Compiling memchr v2.0.2
Dec 13 07:17:19.681 INFO [stderr]    Compiling rand v0.5.5
Dec 13 07:17:19.682 INFO [stderr]    Compiling filetime v0.1.15
Dec 13 07:17:19.719 INFO [stderr]    Compiling unix_socket v0.5.0
Dec 13 07:17:21.188 INFO [stderr]    Compiling isatty v0.1.8
Dec 13 07:17:24.884 INFO [stderr]    Compiling signal-hook v0.1.6
Dec 13 07:17:25.009 INFO [stderr]    Compiling openssl-sys v0.9.35
Dec 13 07:17:25.044 INFO [stderr]    Compiling openssl v0.9.24
Dec 13 07:17:25.067 INFO [stderr]    Compiling backtrace-sys v0.1.24
Dec 13 07:17:25.091 INFO [stderr]    Compiling toml v0.4.10
Dec 13 07:17:25.091 INFO [stderr]    Compiling aho-corasick v0.6.8
Dec 13 07:17:25.804 INFO [stderr]    Compiling tar v0.3.4
Dec 13 07:17:27.009 INFO [stderr]    Compiling chrono v0.4.6
Dec 13 07:17:28.658 INFO [stderr]    Compiling hyper v0.10.13
Dec 13 07:17:31.532 INFO [stderr]    Compiling nix v0.7.0
Dec 13 07:17:31.619 INFO [stderr]    Compiling uuid v0.2.3
Dec 13 07:17:41.799 INFO [stderr]    Compiling backtrace v0.3.9
Dec 13 07:17:41.936 INFO [stderr]    Compiling regex v1.1.0
Dec 13 07:17:51.937 INFO [stderr]    Compiling regex v0.2.11
Dec 13 07:17:56.023 INFO [stderr]    Compiling url v0.5.10
Dec 13 07:17:56.263 INFO [stderr]    Compiling slog-scope v4.0.1
Dec 13 07:17:56.264 INFO [stderr]    Compiling slog-async v2.3.0
Dec 13 07:17:56.611 INFO [stderr]    Compiling parking_lot_core v0.3.0
Dec 13 07:18:27.135 INFO [stderr]    Compiling flate2 v0.2.20
Dec 13 07:18:27.392 INFO [stderr]    Compiling slog-term v2.4.0
Dec 13 07:18:27.787 INFO [stderr]    Compiling quote v0.6.8
Dec 13 07:18:29.744 INFO [stderr]    Compiling slog-stdlog v3.0.2
Dec 13 07:18:29.951 INFO [stderr]    Compiling parking_lot v0.6.4
Dec 13 07:18:30.003 INFO [stderr]    Compiling hyperlocal v0.3.0
Dec 13 07:18:30.091 INFO [stderr]    Compiling iptables v0.2.2
Dec 13 07:18:30.663 INFO [stderr]    Compiling slog-kvfilter v0.7.0
Dec 13 07:18:33.779 INFO [stderr]    Compiling hyper-openssl v0.2.7
Dec 13 07:18:33.827 INFO [stderr]    Compiling syn v0.15.22
Dec 13 07:18:35.571 INFO [stderr]    Compiling crossbeam-channel v0.2.4
Dec 13 07:18:37.924 INFO [stderr]    Compiling shiplift v0.3.2
Dec 13 07:18:57.824 INFO [stderr]    Compiling darling_core v0.8.0
Dec 13 07:18:57.826 INFO [stderr]    Compiling trackable_derive v0.1.1
Dec 13 07:18:57.826 INFO [stderr]    Compiling synstructure v0.10.1
Dec 13 07:18:57.827 INFO [stderr]    Compiling serde_derive v1.0.81
Dec 13 07:19:01.827 INFO [stderr]    Compiling trackable v0.2.20
Dec 13 07:19:06.363 INFO [stderr]    Compiling failure_derive v0.1.3
Dec 13 07:19:10.223 INFO [stderr]    Compiling failure v0.1.3
Dec 13 07:19:10.959 INFO [stderr]    Compiling darling_macro v0.8.0
Dec 13 07:19:15.939 INFO [stderr]    Compiling darling v0.8.0
Dec 13 07:19:16.463 INFO [stderr]    Compiling derive_builder_core v0.4.0
Dec 13 07:19:16.842 INFO [stderr]    Compiling sloggers v0.3.1
Dec 13 07:19:21.785 INFO [stderr]    Compiling dfw v0.5.1-alpha.0 (/source)
Dec 13 07:19:43.814 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2m 27s
Dec 13 07:19:43.835 INFO [stderr] su: No module specific data is present
Dec 13 07:19:44.703 INFO running `"docker" "inspect" "a75b23393a0eb168182cf3387cd8ea52affa11a397e5c6254df23db83b0b7a6a"`
Dec 13 07:19:44.929 INFO running `"docker" "rm" "-f" "a75b23393a0eb168182cf3387cd8ea52affa11a397e5c6254df23db83b0b7a6a"`
Dec 13 07:19:45.154 INFO [stdout] a75b23393a0eb168182cf3387cd8ea52affa11a397e5c6254df23db83b0b7a6a
Dec 13 07:19:45.161 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-7/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 13 07:19:45.682 INFO [stdout] b7c56c50a6d0dd60701a87a5a1b217d441d43d6028cd7403e87b9a2cc7b81f17
Dec 13 07:19:45.684 INFO running `"docker" "start" "-a" "b7c56c50a6d0dd60701a87a5a1b217d441d43d6028cd7403e87b9a2cc7b81f17"`
Dec 13 07:19:46.522 INFO [stderr] usermod: no changes
Dec 13 07:19:46.853 INFO [stderr]    Compiling serde_json v1.0.26
Dec 13 07:19:51.032 INFO [stderr]    Compiling eval v0.4.3
Dec 13 07:19:54.043 INFO [stderr]    Compiling dfw v0.5.1-alpha.0 (/source)
Dec 13 07:19:58.059 INFO [stderr] warning: function is never used: `load_loglines`
Dec 13 07:19:58.059 INFO [stderr]    --> tests/logs/mod.rs:174:1
Dec 13 07:19:58.059 INFO [stderr]     |
Dec 13 07:19:58.059 INFO [stderr] 174 | pub fn load_loglines(log_path: &str) -> Vec<LogLine> {
Dec 13 07:19:58.059 INFO [stderr]     | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 13 07:19:58.059 INFO [stderr]     |
Dec 13 07:19:58.059 INFO [stderr]     = note: #[warn(dead_code)] on by default
Dec 13 07:19:58.059 INFO [stderr] 
Dec 13 07:20:20.627 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 34.05s
Dec 13 07:20:20.651 INFO [stderr] su: No module specific data is present
Dec 13 07:20:21.717 INFO running `"docker" "inspect" "b7c56c50a6d0dd60701a87a5a1b217d441d43d6028cd7403e87b9a2cc7b81f17"`
Dec 13 07:20:22.045 INFO running `"docker" "rm" "-f" "b7c56c50a6d0dd60701a87a5a1b217d441d43d6028cd7403e87b9a2cc7b81f17"`
Dec 13 07:20:22.462 INFO [stdout] b7c56c50a6d0dd60701a87a5a1b217d441d43d6028cd7403e87b9a2cc7b81f17
Dec 13 07:20:22.471 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-7/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 13 07:20:23.108 INFO [stdout] 09059cd3ba8d61f60a08d90a793b1bdc390040164e0919e60c184571febec0e5
Dec 13 07:20:23.111 INFO running `"docker" "start" "-a" "09059cd3ba8d61f60a08d90a793b1bdc390040164e0919e60c184571febec0e5"`
Dec 13 07:20:24.767 INFO [stderr] usermod: no changes
Dec 13 07:20:25.131 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.32s
Dec 13 07:20:25.139 INFO [stderr]      Running /target/debug/deps/dfw-06f9df199a291d15
Dec 13 07:20:25.143 INFO [stdout] 
Dec 13 07:20:25.143 INFO [stdout] running 4 tests
Dec 13 07:20:25.143 INFO [stdout] test iptables::tests_iptablesrestore::restore_set_policy ... ok
Dec 13 07:20:25.143 INFO [stdout] test iptables::tests_iptablesrestore::restore_append ... ok
Dec 13 07:20:25.144 INFO [stdout] test iptables::tests_iptablesrestore::double_append_replace ... ok
Dec 13 07:20:25.144 INFO [stdout] test iptables::tests_iptablesrestore::double_append ... ok
Dec 13 07:20:25.144 INFO [stdout] 
Dec 13 07:20:25.144 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 07:20:25.144 INFO [stdout] 
Dec 13 07:20:25.147 INFO [stdout] 
Dec 13 07:20:25.148 INFO [stderr]      Running /target/debug/deps/dfw-50f201e4855c603e
Dec 13 07:20:25.148 INFO [stdout] running 0 tests
Dec 13 07:20:25.148 INFO [stdout] 
Dec 13 07:20:25.148 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 07:20:25.148 INFO [stdout] 
Dec 13 07:20:25.159 INFO [stdout] 
Dec 13 07:20:25.159 INFO [stderr]      Running /target/debug/deps/dfw-13bbd71d12ed8997
Dec 13 07:20:25.159 INFO [stdout] running 0 tests
Dec 13 07:20:25.159 INFO [stderr]      Running /target/debug/deps/iptables_dummy-ed6d6bd328e20340
Dec 13 07:20:25.159 INFO [stdout] 
Dec 13 07:20:25.159 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 07:20:25.159 INFO [stdout] 
Dec 13 07:20:25.163 INFO [stdout] 
Dec 13 07:20:25.163 INFO [stdout] running 21 tests
Dec 13 07:20:25.163 INFO [stdout] test dummy_delete_all ... ok
Dec 13 07:20:25.163 INFO [stdout] test dummy_delete ... ok
Dec 13 07:20:25.163 INFO [stdout] test dummy_chain_exists ... ok
Dec 13 07:20:25.163 INFO [stdout] test dummy_append_unique ... ok
Dec 13 07:20:25.163 INFO [stdout] test dummy_exists ... ok
Dec 13 07:20:25.163 INFO [stdout] test dummy_append_replace ... ok
Dec 13 07:20:25.163 INFO [stdout] test dummy_flush_chain ... ok
Dec 13 07:20:25.163 INFO [stdout] test dummy_flush_table ... ok
Dec 13 07:20:25.163 INFO [stdout] test dummy_append ... ok
Dec 13 07:20:25.163 INFO [stdout] test dummy_get_policy ... ok
Dec 13 07:20:25.163 INFO [stdout] test dummy_insert ... ok
Dec 13 07:20:25.163 INFO [stdout] test dummy_insert_unique ... ok
Dec 13 07:20:25.163 INFO [stdout] test dummy_list ... ok
Dec 13 07:20:25.163 INFO [stdout] test dummy_list_chains ... ok
Dec 13 07:20:25.163 INFO [stdout] test dummy_list_table ... ok
Dec 13 07:20:25.163 INFO [stdout] test dummy_delete_chain ... ok
Dec 13 07:20:25.171 INFO [stdout] test dummy_execute ... ok
Dec 13 07:20:25.171 INFO [stdout] test dummy_new_chain ... ok
Dec 13 07:20:25.171 INFO [stdout] test dummy_rename_chain ... ok
Dec 13 07:20:25.171 INFO [stdout] test dummy_replace ... ok
Dec 13 07:20:25.171 INFO [stdout] test dummy_set_policy ... ok
Dec 13 07:20:25.171 INFO [stdout] 
Dec 13 07:20:25.171 INFO [stdout] test result: ok. 21 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 07:20:25.171 INFO [stdout] 
Dec 13 07:20:25.175 INFO [stdout] 
Dec 13 07:20:25.175 INFO [stderr]      Running /target/debug/deps/iptables_logger-009a9cd7b0152746
Dec 13 07:20:25.175 INFO [stdout] running 1 test
Dec 13 07:20:25.183 INFO [stdout] test log_all ... ok
Dec 13 07:20:25.183 INFO [stdout] 
Dec 13 07:20:25.183 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 07:20:25.183 INFO [stdout] 
Dec 13 07:20:25.187 INFO [stderr]      Running /target/debug/deps/logline-27f1679a85a7795a
Dec 13 07:20:25.191 INFO [stdout] 
Dec 13 07:20:25.191 INFO [stdout] running 15 tests
Dec 13 07:20:25.243 INFO [stdout] test logline_from_string_without_command ... ok
Dec 13 07:20:25.243 INFO [stdout] test regex_ne_self ... ok
Dec 13 07:20:25.255 INFO [stdout] test regex_ne_regex ... ok
Dec 13 07:20:25.255 INFO [stdout] test string_eq_self ... ok
Dec 13 07:20:25.255 INFO [stdout] test string_eq_string ... ok
Dec 13 07:20:25.307 INFO [stdout] test logline_from_string ... ok
Dec 13 07:20:25.311 INFO [stdout] test logline_from_wrong_string ... ok
Dec 13 07:20:25.311 INFO [stdout] test logline_from_string_with_eval ... ok
Dec 13 07:20:25.331 INFO [stdout] test string_ne_string ... ok
Dec 13 07:20:25.351 INFO [stdout] test string_eq_regex ... ok
Dec 13 07:20:25.359 INFO [stdout] test string_ne_regex ... ok
Dec 13 07:20:25.359 INFO [stdout] test string_eq_regex_eval ... ok
Dec 13 07:20:25.379 INFO [stdout] test string_ne_regex_eval ... ok
Dec 13 07:20:25.379 INFO [stdout] test logline_from_string_with_expansions ... ok
Dec 13 07:20:25.379 INFO [stdout] test logline_from_string_with_wrong_expansion ... ok
Dec 13 07:20:25.379 INFO [stdout] 
Dec 13 07:20:25.379 INFO [stdout] test result: ok. 15 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 07:20:25.379 INFO [stdout] 
Dec 13 07:20:25.380 INFO [stderr]      Running /target/debug/deps/types-2b3204b674ca8deb
Dec 13 07:20:25.387 INFO [stdout] 
Dec 13 07:20:25.387 INFO [stdout] running 13 tests
Dec 13 07:20:25.387 INFO [stdout] test parse_expose_port_seq_string ... ok
Dec 13 07:20:25.387 INFO [stdout] test parse_expose_port_seq_int ... ok
Dec 13 07:20:25.399 INFO [stdout] test parse_expose_port_single_int ... ok
Dec 13 07:20:25.399 INFO [stdout] test parse_expose_port_single_string ... ok
Dec 13 07:20:25.399 INFO [stdout] test parse_expose_port_seq_struct ... ok
Dec 13 07:20:25.399 INFO [stdout] test parse_expose_port_single_struct ... ok
Dec 13 07:20:25.399 INFO [stdout] test parse_conf_path ... ok
Dec 13 07:20:25.402 INFO [stdout] test parse_external_network_interfaces_single ... ok
Dec 13 07:20:25.409 INFO [stdout] test parse_external_network_interfaces_seq ... ok
Dec 13 07:20:25.411 INFO [stdout] test parse_conf_file ... ok
Dec 13 07:20:25.607 INFO [stdout] test parse_expose_port_string_invalid_format ... ok
Dec 13 07:20:25.607 INFO [stdout] test parse_expose_port_string_invalid_int ... ok
Dec 13 07:20:25.607 INFO [stdout] test parse_expose_port_string_invalid_int2 ... ok
Dec 13 07:20:25.607 INFO [stdout] 
Dec 13 07:20:25.607 INFO [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 07:20:25.607 INFO [stdout] 
Dec 13 07:20:25.612 INFO [stderr]    Doc-tests dfw
Dec 13 07:20:28.864 INFO [stdout] 
Dec 13 07:20:28.864 INFO [stdout] running 2 tests
Dec 13 07:20:38.768 INFO [stdout] test src/types.rs - types::ExposePort::from_str (line 408) ... ok
Dec 13 07:20:39.491 INFO [stdout] test src/types.rs - types::ExposePort::from_str (line 400) ... ok
Dec 13 07:20:39.491 INFO [stdout] 
Dec 13 07:20:39.491 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 07:20:39.491 INFO [stdout] 
Dec 13 07:20:39.515 INFO [stderr] su: No module specific data is present
Dec 13 07:20:40.418 INFO running `"docker" "inspect" "09059cd3ba8d61f60a08d90a793b1bdc390040164e0919e60c184571febec0e5"`
Dec 13 07:20:40.815 INFO running `"docker" "rm" "-f" "09059cd3ba8d61f60a08d90a793b1bdc390040164e0919e60c184571febec0e5"`
Dec 13 07:20:41.131 INFO [stdout] 09059cd3ba8d61f60a08d90a793b1bdc390040164e0919e60c184571febec0e5