Dec 15 17:07:31.782 INFO testing dfw-0.5.0 against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 15 17:07:31.782 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/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 15 17:07:32.242 INFO [stdout] 73c8e6c47447ace717249168763e47fb1a2c21e984381e79e38f3611e2f6474d
Dec 15 17:07:32.251 INFO running `"docker" "start" "-a" "73c8e6c47447ace717249168763e47fb1a2c21e984381e79e38f3611e2f6474d"`
Dec 15 17:07:33.134 INFO [stderr] usermod: no changes
Dec 15 17:07:33.476 INFO [stderr]    Compiling tar v0.3.4
Dec 15 17:07:33.478 INFO [stderr]    Compiling trackable_derive v0.1.1
Dec 15 17:07:33.478 INFO [stderr]    Compiling hyperlocal v0.3.0
Dec 15 17:07:33.479 INFO [stderr]    Compiling slog-kvfilter v0.6.1
Dec 15 17:07:33.479 INFO [stderr]    Compiling iptables v0.2.2
Dec 15 17:07:33.479 INFO [stderr]    Compiling crossbeam-channel v0.2.6
Dec 15 17:07:39.689 INFO [stderr]    Compiling trackable v0.2.20
Dec 15 17:07:41.194 INFO [stderr]    Compiling shiplift v0.3.2
Dec 15 17:07:41.283 INFO [stderr]    Compiling sloggers v0.2.9
Dec 15 17:07:54.003 INFO [stderr]    Compiling dfw v0.5.0 (/source)
Dec 15 17:08:26.101 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 52.95s
Dec 15 17:08:26.119 INFO [stderr] su: No module specific data is present
Dec 15 17:08:26.392 INFO running `"docker" "inspect" "73c8e6c47447ace717249168763e47fb1a2c21e984381e79e38f3611e2f6474d"`
Dec 15 17:08:26.478 INFO running `"docker" "rm" "-f" "73c8e6c47447ace717249168763e47fb1a2c21e984381e79e38f3611e2f6474d"`
Dec 15 17:08:26.597 INFO [stdout] 73c8e6c47447ace717249168763e47fb1a2c21e984381e79e38f3611e2f6474d
Dec 15 17:08:26.599 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/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 15 17:08:26.763 INFO [stdout] 116de73876e46a42b994d54d884dde506df76392e993077c4a7561e0fcfe94cb
Dec 15 17:08:26.769 INFO running `"docker" "start" "-a" "116de73876e46a42b994d54d884dde506df76392e993077c4a7561e0fcfe94cb"`
Dec 15 17:08:27.208 INFO [stderr] usermod: no changes
Dec 15 17:08:27.436 INFO [stderr]    Compiling eval v0.4.3
Dec 15 17:08:29.923 INFO [stderr]    Compiling dfw v0.5.0 (/source)
Dec 15 17:08:34.795 INFO [stderr] warning: function is never used: `load_loglines`
Dec 15 17:08:34.795 INFO [stderr]    --> tests/logs/mod.rs:174:1
Dec 15 17:08:34.795 INFO [stderr]     |
Dec 15 17:08:34.795 INFO [stderr] 174 | pub fn load_loglines(log_path: &str) -> Vec<LogLine> {
Dec 15 17:08:34.795 INFO [stderr]     | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 15 17:08:34.795 INFO [stderr]     |
Dec 15 17:08:34.795 INFO [stderr]     = note: #[warn(dead_code)] on by default
Dec 15 17:08:34.795 INFO [stderr] 
Dec 15 17:08:59.447 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 32.22s
Dec 15 17:08:59.475 INFO [stderr] su: No module specific data is present
Dec 15 17:09:00.517 INFO running `"docker" "inspect" "116de73876e46a42b994d54d884dde506df76392e993077c4a7561e0fcfe94cb"`
Dec 15 17:09:00.805 INFO running `"docker" "rm" "-f" "116de73876e46a42b994d54d884dde506df76392e993077c4a7561e0fcfe94cb"`
Dec 15 17:09:01.045 INFO [stdout] 116de73876e46a42b994d54d884dde506df76392e993077c4a7561e0fcfe94cb
Dec 15 17:09:01.048 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/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 15 17:09:01.471 INFO [stdout] 7a06fc8babaa2d28fe0c7b5a60c1b7c4cba3d4f2f8afaee1a3d0e8f768287ee7
Dec 15 17:09:01.476 INFO running `"docker" "start" "-a" "7a06fc8babaa2d28fe0c7b5a60c1b7c4cba3d4f2f8afaee1a3d0e8f768287ee7"`
Dec 15 17:09:02.400 INFO [stderr] usermod: no changes
Dec 15 17:09:02.721 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.30s
Dec 15 17:09:02.748 INFO [stderr]      Running /target/debug/deps/dfw-beed7b498e8f0cee
Dec 15 17:09:02.766 INFO [stdout] 
Dec 15 17:09:02.766 INFO [stdout] running 4 tests
Dec 15 17:09:02.766 INFO [stdout] test iptables::tests_iptablesrestore::double_append ... ok
Dec 15 17:09:02.772 INFO [stdout] test iptables::tests_iptablesrestore::restore_set_policy ... ok
Dec 15 17:09:02.772 INFO [stdout] test iptables::tests_iptablesrestore::double_append_replace ... ok
Dec 15 17:09:02.772 INFO [stdout] test iptables::tests_iptablesrestore::restore_append ... ok
Dec 15 17:09:02.772 INFO [stdout] 
Dec 15 17:09:02.772 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 17:09:02.772 INFO [stdout] 
Dec 15 17:09:02.777 INFO [stdout] 
Dec 15 17:09:02.777 INFO [stderr]      Running /target/debug/deps/dfw-de540eed418f07c0
Dec 15 17:09:02.777 INFO [stdout] running 0 tests
Dec 15 17:09:02.777 INFO [stdout] 
Dec 15 17:09:02.777 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 17:09:02.777 INFO [stdout] 
Dec 15 17:09:02.783 INFO [stderr]      Running /target/debug/deps/dfw-db5cab760ad15516
Dec 15 17:09:02.787 INFO [stderr]      Running /target/debug/deps/iptables_dummy-c6358eac7ab03a5b
Dec 15 17:09:02.787 INFO [stdout] 
Dec 15 17:09:02.787 INFO [stdout] running 0 tests
Dec 15 17:09:02.787 INFO [stdout] 
Dec 15 17:09:02.787 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 17:09:02.787 INFO [stdout] 
Dec 15 17:09:02.795 INFO [stdout] 
Dec 15 17:09:02.795 INFO [stdout] running 21 tests
Dec 15 17:09:02.803 INFO [stdout] test dummy_append_unique ... ok
Dec 15 17:09:02.803 INFO [stdout] test dummy_append ... ok
Dec 15 17:09:02.803 INFO [stdout] test dummy_chain_exists ... ok
Dec 15 17:09:02.803 INFO [stdout] test dummy_append_replace ... ok
Dec 15 17:09:02.803 INFO [stdout] test dummy_exists ... ok
Dec 15 17:09:02.803 INFO [stdout] test dummy_execute ... ok
Dec 15 17:09:02.803 INFO [stdout] test dummy_get_policy ... ok
Dec 15 17:09:02.803 INFO [stdout] test dummy_insert ... ok
Dec 15 17:09:02.803 INFO [stdout] test dummy_flush_table ... ok
Dec 15 17:09:02.803 INFO [stdout] test dummy_insert_unique ... ok
Dec 15 17:09:02.803 INFO [stdout] test dummy_flush_chain ... ok
Dec 15 17:09:02.803 INFO [stdout] test dummy_list ... ok
Dec 15 17:09:02.803 INFO [stdout] test dummy_list_chains ... ok
Dec 15 17:09:02.803 INFO [stdout] test dummy_list_table ... ok
Dec 15 17:09:02.803 INFO [stdout] test dummy_new_chain ... ok
Dec 15 17:09:02.803 INFO [stdout] test dummy_rename_chain ... ok
Dec 15 17:09:02.803 INFO [stdout] test dummy_set_policy ... ok
Dec 15 17:09:02.803 INFO [stdout] test dummy_replace ... ok
Dec 15 17:09:02.804 INFO [stdout] test dummy_delete ... ok
Dec 15 17:09:02.804 INFO [stdout] test dummy_delete_all ... ok
Dec 15 17:09:02.804 INFO [stdout] test dummy_delete_chain ... ok
Dec 15 17:09:02.804 INFO [stdout] 
Dec 15 17:09:02.804 INFO [stdout] test result: ok. 21 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 17:09:02.804 INFO [stdout] 
Dec 15 17:09:02.804 INFO [stderr]      Running /target/debug/deps/iptables_logger-7d1bdf11d26f858f
Dec 15 17:09:02.809 INFO [stdout] 
Dec 15 17:09:02.809 INFO [stdout] running 1 test
Dec 15 17:09:02.831 INFO [stdout] test log_all ... ok
Dec 15 17:09:02.831 INFO [stderr]      Running /target/debug/deps/logline-945b89f86440f615
Dec 15 17:09:02.831 INFO [stdout] 
Dec 15 17:09:02.831 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 17:09:02.831 INFO [stdout] 
Dec 15 17:09:02.847 INFO [stdout] 
Dec 15 17:09:02.847 INFO [stdout] running 15 tests
Dec 15 17:09:02.847 INFO [stdout] test logline_from_string_without_command ... ok
Dec 15 17:09:02.847 INFO [stdout] test regex_ne_regex ... ok
Dec 15 17:09:02.847 INFO [stdout] test regex_ne_self ... ok
Dec 15 17:09:02.855 INFO [stdout] test string_eq_self ... ok
Dec 15 17:09:02.863 INFO [stdout] test string_eq_string ... ok
Dec 15 17:09:02.887 INFO [stdout] test string_eq_regex_eval ... ok
Dec 15 17:09:02.891 INFO [stdout] test logline_from_string ... ok
Dec 15 17:09:02.896 INFO [stdout] test string_ne_string ... ok
Dec 15 17:09:02.911 INFO [stdout] test string_eq_regex ... ok
Dec 15 17:09:02.943 INFO [stdout] test logline_from_string_with_wrong_expansion ... ok
Dec 15 17:09:02.943 INFO [stdout] test logline_from_string_with_eval ... ok
Dec 15 17:09:02.951 INFO [stdout] test logline_from_wrong_string ... ok
Dec 15 17:09:02.955 INFO [stdout] test logline_from_string_with_expansions ... ok
Dec 15 17:09:02.966 INFO [stdout] test string_ne_regex_eval ... ok
Dec 15 17:09:02.966 INFO [stdout] test string_ne_regex ... ok
Dec 15 17:09:02.966 INFO [stdout] 
Dec 15 17:09:02.966 INFO [stdout] test result: ok. 15 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 17:09:02.966 INFO [stdout] 
Dec 15 17:09:02.971 INFO [stderr]      Running /target/debug/deps/types-b59b5ca55c9e102e
Dec 15 17:09:02.975 INFO [stdout] 
Dec 15 17:09:02.975 INFO [stdout] running 13 tests
Dec 15 17:09:03.007 INFO [stdout] test parse_conf_file ... ok
Dec 15 17:09:03.012 INFO [stdout] test parse_expose_port_seq_int ... ok
Dec 15 17:09:03.012 INFO [stdout] test parse_expose_port_seq_string ... ok
Dec 15 17:09:03.012 INFO [stdout] test parse_expose_port_single_int ... ok
Dec 15 17:09:03.012 INFO [stdout] test parse_conf_path ... ok
Dec 15 17:09:03.012 INFO [stdout] test parse_expose_port_seq_struct ... ok
Dec 15 17:09:03.012 INFO [stdout] test parse_expose_port_single_string ... ok
Dec 15 17:09:03.012 INFO [stdout] test parse_expose_port_single_struct ... ok
Dec 15 17:09:03.012 INFO [stdout] test parse_external_network_interfaces_single ... ok
Dec 15 17:09:03.012 INFO [stdout] test parse_external_network_interfaces_seq ... ok
Dec 15 17:09:03.140 INFO [stdout] test parse_expose_port_string_invalid_format ... ok
Dec 15 17:09:03.140 INFO [stdout] test parse_expose_port_string_invalid_int2 ... ok
Dec 15 17:09:03.140 INFO [stdout] test parse_expose_port_string_invalid_int ... ok
Dec 15 17:09:03.140 INFO [stdout] 
Dec 15 17:09:03.140 INFO [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 17:09:03.140 INFO [stdout] 
Dec 15 17:09:03.145 INFO [stderr]    Doc-tests dfw
Dec 15 17:09:13.321 INFO [stdout] 
Dec 15 17:09:13.321 INFO [stdout] running 2 tests
Dec 15 17:09:34.218 INFO [stdout] test src/types.rs - types::ExposePort::from_str (line 400) ... ok
Dec 15 17:09:35.235 INFO [stdout] test src/types.rs - types::ExposePort::from_str (line 408) ... ok
Dec 15 17:09:35.235 INFO [stdout] 
Dec 15 17:09:35.235 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 17:09:35.235 INFO [stdout] 
Dec 15 17:09:35.252 INFO [stderr] su: No module specific data is present
Dec 15 17:09:36.214 INFO running `"docker" "inspect" "7a06fc8babaa2d28fe0c7b5a60c1b7c4cba3d4f2f8afaee1a3d0e8f768287ee7"`
Dec 15 17:09:36.463 INFO running `"docker" "rm" "-f" "7a06fc8babaa2d28fe0c7b5a60c1b7c4cba3d4f2f8afaee1a3d0e8f768287ee7"`
Dec 15 17:09:36.783 INFO [stdout] 7a06fc8babaa2d28fe0c7b5a60c1b7c4cba3d4f2f8afaee1a3d0e8f768287ee7