Nov 18 16:14:17.969 INFO testing dfw-0.5.0 against try#2e026d6e5d7621634147ad4c8074f1d964dbb1be for pr-55982
Nov 18 16:14:17.969 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-7/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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 16:14:18.222 INFO [stdout] 5b45600ac8d98eea4c86f6717d216943df3f9cfdd1b21563caa0fed8d65c27f9
Nov 18 16:14:18.229 INFO running `"docker" "start" "-a" "5b45600ac8d98eea4c86f6717d216943df3f9cfdd1b21563caa0fed8d65c27f9"`
Nov 18 16:14:19.335 INFO [stderr] usermod: no changes
Nov 18 16:14:19.691 INFO [stderr]    Compiling tar v0.3.4
Nov 18 16:14:19.707 INFO [stderr]    Compiling trackable_derive v0.1.1
Nov 18 16:14:19.707 INFO [stderr]    Compiling hyperlocal v0.3.0
Nov 18 16:14:19.708 INFO [stderr]    Compiling slog-kvfilter v0.6.1
Nov 18 16:14:19.708 INFO [stderr]    Compiling iptables v0.2.2
Nov 18 16:14:23.555 INFO [stderr]    Compiling shiplift v0.3.2
Nov 18 16:14:27.436 INFO [stderr]    Compiling trackable v0.2.20
Nov 18 16:14:28.306 INFO [stderr]    Compiling sloggers v0.2.9
Nov 18 16:14:34.874 INFO [stderr]    Compiling dfw v0.5.0 (/source)
Nov 18 16:15:02.657 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 43.29s
Nov 18 16:15:02.676 INFO [stderr] su: No module specific data is present
Nov 18 16:15:03.453 INFO running `"docker" "inspect" "5b45600ac8d98eea4c86f6717d216943df3f9cfdd1b21563caa0fed8d65c27f9"`
Nov 18 16:15:03.657 INFO running `"docker" "rm" "-f" "5b45600ac8d98eea4c86f6717d216943df3f9cfdd1b21563caa0fed8d65c27f9"`
Nov 18 16:15:03.917 INFO [stdout] 5b45600ac8d98eea4c86f6717d216943df3f9cfdd1b21563caa0fed8d65c27f9
Nov 18 16:15:03.929 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-7/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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 16:15:04.217 INFO [stdout] 05ca5b96df82e1134f3a5286fcdc8c34e01c7c2791f7472d5f23d3f5458f41d9
Nov 18 16:15:04.218 INFO running `"docker" "start" "-a" "05ca5b96df82e1134f3a5286fcdc8c34e01c7c2791f7472d5f23d3f5458f41d9"`
Nov 18 16:15:04.718 INFO [stderr] usermod: no changes
Nov 18 16:15:04.959 INFO [stderr]    Compiling eval v0.4.3
Nov 18 16:15:07.495 INFO [stderr]    Compiling dfw v0.5.0 (/source)
Nov 18 16:15:13.438 INFO [stderr] warning: function is never used: `load_loglines`
Nov 18 16:15:13.438 INFO [stderr]    --> tests/logs/mod.rs:174:1
Nov 18 16:15:13.438 INFO [stderr]     |
Nov 18 16:15:13.438 INFO [stderr] 174 | pub fn load_loglines(log_path: &str) -> Vec<LogLine> {
Nov 18 16:15:13.438 INFO [stderr]     | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 18 16:15:13.438 INFO [stderr]     |
Nov 18 16:15:13.438 INFO [stderr]     = note: #[warn(dead_code)] on by default
Nov 18 16:15:13.438 INFO [stderr] 
Nov 18 16:15:35.655 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 30.92s
Nov 18 16:15:35.688 INFO [stderr] su: No module specific data is present
Nov 18 16:15:36.397 INFO running `"docker" "inspect" "05ca5b96df82e1134f3a5286fcdc8c34e01c7c2791f7472d5f23d3f5458f41d9"`
Nov 18 16:15:36.644 INFO running `"docker" "rm" "-f" "05ca5b96df82e1134f3a5286fcdc8c34e01c7c2791f7472d5f23d3f5458f41d9"`
Nov 18 16:15:36.943 INFO [stdout] 05ca5b96df82e1134f3a5286fcdc8c34e01c7c2791f7472d5f23d3f5458f41d9
Nov 18 16:15:36.948 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-7/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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 16:15:37.381 INFO [stdout] 9727ce3919e8f7c1676a6aef7e15357f2aa6be89c1791c610c431f58ae3f9921
Nov 18 16:15:37.383 INFO running `"docker" "start" "-a" "9727ce3919e8f7c1676a6aef7e15357f2aa6be89c1791c610c431f58ae3f9921"`
Nov 18 16:15:38.874 INFO [stderr] usermod: no changes
Nov 18 16:15:39.175 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.27s
Nov 18 16:15:39.193 INFO [stderr]      Running /target/debug/deps/dfw-b269898aec7ce9b8
Nov 18 16:15:39.203 INFO [stdout] 
Nov 18 16:15:39.203 INFO [stdout] running 4 tests
Nov 18 16:15:39.203 INFO [stdout] test iptables::tests_iptablesrestore::double_append ... ok
Nov 18 16:15:39.203 INFO [stdout] test iptables::tests_iptablesrestore::restore_append ... ok
Nov 18 16:15:39.211 INFO [stdout] test iptables::tests_iptablesrestore::double_append_replace ... ok
Nov 18 16:15:39.211 INFO [stdout] test iptables::tests_iptablesrestore::restore_set_policy ... ok
Nov 18 16:15:39.211 INFO [stdout] 
Nov 18 16:15:39.211 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 16:15:39.211 INFO [stdout] 
Nov 18 16:15:39.219 INFO [stderr]      Running /target/debug/deps/dfw-7f07cc0866670684
Nov 18 16:15:39.227 INFO [stderr]      Running /target/debug/deps/dfw-4852b71395719e44
Nov 18 16:15:39.227 INFO [stdout] 
Nov 18 16:15:39.227 INFO [stderr]      Running /target/debug/deps/iptables_dummy-180115bd0a795c2b
Nov 18 16:15:39.227 INFO [stdout] running 0 tests
Nov 18 16:15:39.227 INFO [stdout] 
Nov 18 16:15:39.227 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 16:15:39.227 INFO [stdout] 
Nov 18 16:15:39.227 INFO [stdout] 
Nov 18 16:15:39.227 INFO [stdout] running 0 tests
Nov 18 16:15:39.227 INFO [stdout] 
Nov 18 16:15:39.227 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 16:15:39.227 INFO [stdout] 
Nov 18 16:15:39.227 INFO [stdout] 
Nov 18 16:15:39.227 INFO [stdout] running 21 tests
Nov 18 16:15:39.227 INFO [stdout] test dummy_append_replace ... ok
Nov 18 16:15:39.227 INFO [stdout] test dummy_chain_exists ... ok
Nov 18 16:15:39.234 INFO [stdout] test dummy_append_unique ... ok
Nov 18 16:15:39.234 INFO [stdout] test dummy_append ... ok
Nov 18 16:15:39.234 INFO [stdout] test dummy_delete ... ok
Nov 18 16:15:39.234 INFO [stdout] test dummy_get_policy ... ok
Nov 18 16:15:39.234 INFO [stdout] test dummy_flush_table ... ok
Nov 18 16:15:39.234 INFO [stdout] test dummy_exists ... ok
Nov 18 16:15:39.234 INFO [stdout] test dummy_execute ... ok
Nov 18 16:15:39.234 INFO [stdout] test dummy_flush_chain ... ok
Nov 18 16:15:39.234 INFO [stdout] test dummy_delete_all ... ok
Nov 18 16:15:39.234 INFO [stdout] test dummy_new_chain ... ok
Nov 18 16:15:39.234 INFO [stdout] test dummy_rename_chain ... ok
Nov 18 16:15:39.234 INFO [stdout] test dummy_replace ... ok
Nov 18 16:15:39.234 INFO [stdout] test dummy_set_policy ... ok
Nov 18 16:15:39.237 INFO [stdout] test dummy_insert ... ok
Nov 18 16:15:39.237 INFO [stdout] test dummy_insert_unique ... ok
Nov 18 16:15:39.237 INFO [stdout] test dummy_list ... ok
Nov 18 16:15:39.237 INFO [stdout] test dummy_list_table ... ok
Nov 18 16:15:39.237 INFO [stdout] test dummy_delete_chain ... ok
Nov 18 16:15:39.237 INFO [stdout] test dummy_list_chains ... ok
Nov 18 16:15:39.237 INFO [stdout] 
Nov 18 16:15:39.237 INFO [stdout] test result: ok. 21 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 16:15:39.237 INFO [stdout] 
Nov 18 16:15:39.243 INFO [stderr]      Running /target/debug/deps/iptables_logger-5ebe92d81a83cb58
Nov 18 16:15:39.255 INFO [stdout] 
Nov 18 16:15:39.255 INFO [stdout] running 1 test
Nov 18 16:15:39.263 INFO [stdout] test log_all ... ok
Nov 18 16:15:39.263 INFO [stderr]      Running /target/debug/deps/logline-a6336ecf1cf8225a
Nov 18 16:15:39.263 INFO [stdout] 
Nov 18 16:15:39.263 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 16:15:39.263 INFO [stdout] 
Nov 18 16:15:39.275 INFO [stdout] 
Nov 18 16:15:39.275 INFO [stdout] running 15 tests
Nov 18 16:15:39.296 INFO [stdout] test logline_from_string_without_command ... ok
Nov 18 16:15:39.300 INFO [stdout] test regex_ne_self ... ok
Nov 18 16:15:39.303 INFO [stdout] test regex_ne_regex ... ok
Nov 18 16:15:39.303 INFO [stdout] test string_eq_self ... ok
Nov 18 16:15:39.315 INFO [stdout] test string_eq_string ... ok
Nov 18 16:15:39.359 INFO [stdout] test logline_from_wrong_string ... ok
Nov 18 16:15:39.367 INFO [stdout] test string_ne_regex ... ok
Nov 18 16:15:39.367 INFO [stdout] test string_ne_string ... ok
Nov 18 16:15:39.375 INFO [stdout] test string_eq_regex ... ok
Nov 18 16:15:39.407 INFO [stdout] test logline_from_string ... ok
Nov 18 16:15:39.435 INFO [stdout] test logline_from_string_with_eval ... ok
Nov 18 16:15:39.435 INFO [stderr]      Running /target/debug/deps/types-8335c784e7e43755
Nov 18 16:15:39.435 INFO [stdout] test logline_from_string_with_wrong_expansion ... ok
Nov 18 16:15:39.435 INFO [stdout] test logline_from_string_with_expansions ... ok
Nov 18 16:15:39.435 INFO [stdout] test string_ne_regex_eval ... ok
Nov 18 16:15:39.435 INFO [stdout] test string_eq_regex_eval ... ok
Nov 18 16:15:39.435 INFO [stdout] 
Nov 18 16:15:39.435 INFO [stdout] test result: ok. 15 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 16:15:39.435 INFO [stdout] 
Nov 18 16:15:39.435 INFO [stdout] 
Nov 18 16:15:39.435 INFO [stdout] running 13 tests
Nov 18 16:15:39.438 INFO [stdout] test parse_expose_port_seq_string ... ok
Nov 18 16:15:39.438 INFO [stdout] test parse_expose_port_single_struct ... ok
Nov 18 16:15:39.438 INFO [stdout] test parse_expose_port_single_string ... ok
Nov 18 16:15:39.438 INFO [stdout] test parse_expose_port_seq_int ... ok
Nov 18 16:15:39.446 INFO [stdout] test parse_conf_file ... ok
Nov 18 16:15:39.451 INFO [stdout] test parse_external_network_interfaces_seq ... ok
Nov 18 16:15:39.455 INFO [stdout] test parse_external_network_interfaces_single ... ok
Nov 18 16:15:39.455 INFO [stdout] test parse_conf_path ... ok
Nov 18 16:15:39.455 INFO [stdout] test parse_expose_port_single_int ... ok
Nov 18 16:15:39.455 INFO [stdout] test parse_expose_port_seq_struct ... ok
Nov 18 16:15:39.607 INFO [stdout] test parse_expose_port_string_invalid_int2 ... ok
Nov 18 16:15:39.607 INFO [stdout] test parse_expose_port_string_invalid_int ... ok
Nov 18 16:15:39.607 INFO [stdout] test parse_expose_port_string_invalid_format ... ok
Nov 18 16:15:39.607 INFO [stdout] 
Nov 18 16:15:39.607 INFO [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 16:15:39.607 INFO [stdout] 
Nov 18 16:15:39.609 INFO [stderr]    Doc-tests dfw
Nov 18 16:15:47.437 INFO [stdout] 
Nov 18 16:15:47.438 INFO [stdout] running 2 tests
Nov 18 16:16:00.923 INFO [stdout] test src/types.rs - types::ExposePort::from_str (line 408) ... ok
Nov 18 16:16:00.951 INFO [stdout] test src/types.rs - types::ExposePort::from_str (line 400) ... ok
Nov 18 16:16:00.951 INFO [stdout] 
Nov 18 16:16:00.952 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 16:16:00.952 INFO [stdout] 
Nov 18 16:16:00.980 INFO [stderr] su: No module specific data is present
Nov 18 16:16:01.515 INFO running `"docker" "inspect" "9727ce3919e8f7c1676a6aef7e15357f2aa6be89c1791c610c431f58ae3f9921"`
Nov 18 16:16:01.758 INFO running `"docker" "rm" "-f" "9727ce3919e8f7c1676a6aef7e15357f2aa6be89c1791c610c431f58ae3f9921"`
Nov 18 16:16:01.963 INFO [stdout] 9727ce3919e8f7c1676a6aef7e15357f2aa6be89c1791c610c431f58ae3f9921