Dec 15 17:07:36.297 INFO testing dfw-0.5.0 against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 15 17:07:36.297 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-0/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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:36.852 INFO [stdout] 3f0e37826b07393d196b4525fdf4ea159594ad8d28cb493974d40d155cb74350
Dec 15 17:07:36.854 INFO running `"docker" "start" "-a" "3f0e37826b07393d196b4525fdf4ea159594ad8d28cb493974d40d155cb74350"`
Dec 15 17:07:38.423 INFO [stderr] usermod: no changes
Dec 15 17:07:38.921 INFO [stderr]    Compiling tar v0.3.4
Dec 15 17:07:38.921 INFO [stderr]    Compiling trackable_derive v0.1.1
Dec 15 17:07:38.921 INFO [stderr]    Compiling hyperlocal v0.3.0
Dec 15 17:07:38.921 INFO [stderr]    Compiling iptables v0.2.2
Dec 15 17:07:43.384 INFO [stderr]    Compiling trackable v0.2.20
Dec 15 17:07:43.982 INFO [stderr]    Compiling shiplift v0.3.2
Dec 15 17:07:44.702 INFO [stderr]    Compiling sloggers v0.2.9
Dec 15 17:08:00.366 INFO [stderr]    Compiling dfw v0.5.0 (/source)
Dec 15 17:08:31.695 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 53.23s
Dec 15 17:08:31.723 INFO [stderr] su: No module specific data is present
Dec 15 17:08:32.663 INFO running `"docker" "inspect" "3f0e37826b07393d196b4525fdf4ea159594ad8d28cb493974d40d155cb74350"`
Dec 15 17:08:32.972 INFO running `"docker" "rm" "-f" "3f0e37826b07393d196b4525fdf4ea159594ad8d28cb493974d40d155cb74350"`
Dec 15 17:08:33.355 INFO [stdout] 3f0e37826b07393d196b4525fdf4ea159594ad8d28cb493974d40d155cb74350
Dec 15 17:08:33.357 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-0/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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:33.812 INFO [stdout] eee34e807fabefeba6eeca93c8d74ef8c0b5ac453edd6ba30ac4ce8477874ba2
Dec 15 17:08:33.815 INFO running `"docker" "start" "-a" "eee34e807fabefeba6eeca93c8d74ef8c0b5ac453edd6ba30ac4ce8477874ba2"`
Dec 15 17:08:35.553 INFO [stderr] usermod: no changes
Dec 15 17:08:35.851 INFO [stderr]    Compiling eval v0.4.3
Dec 15 17:08:38.903 INFO [stderr]    Compiling dfw v0.5.0 (/source)
Dec 15 17:08:46.311 INFO [stderr] warning: function is never used: `load_loglines`
Dec 15 17:08:46.311 INFO [stderr]    --> tests/logs/mod.rs:174:1
Dec 15 17:08:46.311 INFO [stderr]     |
Dec 15 17:08:46.311 INFO [stderr] 174 | pub fn load_loglines(log_path: &str) -> Vec<LogLine> {
Dec 15 17:08:46.311 INFO [stderr]     | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 15 17:08:46.311 INFO [stderr]     |
Dec 15 17:08:46.311 INFO [stderr]     = note: #[warn(dead_code)] on by default
Dec 15 17:08:46.311 INFO [stderr] 
Dec 15 17:09:08.119 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 32.55s
Dec 15 17:09:08.151 INFO [stderr] su: No module specific data is present
Dec 15 17:09:09.187 INFO running `"docker" "inspect" "eee34e807fabefeba6eeca93c8d74ef8c0b5ac453edd6ba30ac4ce8477874ba2"`
Dec 15 17:09:09.481 INFO running `"docker" "rm" "-f" "eee34e807fabefeba6eeca93c8d74ef8c0b5ac453edd6ba30ac4ce8477874ba2"`
Dec 15 17:09:09.842 INFO [stdout] eee34e807fabefeba6eeca93c8d74ef8c0b5ac453edd6ba30ac4ce8477874ba2
Dec 15 17:09:09.846 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-0/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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:10.298 INFO [stdout] f9a13785e582d7a287823422770da96f1a718a750204e08d0d09e0bc16cdae9a
Dec 15 17:09:10.301 INFO running `"docker" "start" "-a" "f9a13785e582d7a287823422770da96f1a718a750204e08d0d09e0bc16cdae9a"`
Dec 15 17:09:11.492 INFO [stderr] usermod: no changes
Dec 15 17:09:11.789 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.27s
Dec 15 17:09:11.811 INFO [stderr]      Running /target/debug/deps/dfw-c54789bc3a2eac04
Dec 15 17:09:11.815 INFO [stdout] 
Dec 15 17:09:11.815 INFO [stdout] running 4 tests
Dec 15 17:09:11.815 INFO [stdout] test iptables::tests_iptablesrestore::restore_append ... ok
Dec 15 17:09:11.816 INFO [stdout] test iptables::tests_iptablesrestore::double_append ... ok
Dec 15 17:09:11.816 INFO [stdout] test iptables::tests_iptablesrestore::double_append_replace ... ok
Dec 15 17:09:11.816 INFO [stdout] test iptables::tests_iptablesrestore::restore_set_policy ... ok
Dec 15 17:09:11.816 INFO [stdout] 
Dec 15 17:09:11.816 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 17:09:11.816 INFO [stdout] 
Dec 15 17:09:11.823 INFO [stderr]      Running /target/debug/deps/dfw-38ccb66ab1ac1415
Dec 15 17:09:11.829 INFO [stderr]      Running /target/debug/deps/dfw-34e5373949e4cde1
Dec 15 17:09:11.829 INFO [stdout] 
Dec 15 17:09:11.829 INFO [stdout] running 0 tests
Dec 15 17:09:11.829 INFO [stdout] 
Dec 15 17:09:11.829 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 17:09:11.829 INFO [stdout] 
Dec 15 17:09:11.829 INFO [stdout] 
Dec 15 17:09:11.829 INFO [stdout] running 0 tests
Dec 15 17:09:11.829 INFO [stdout] 
Dec 15 17:09:11.829 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 17:09:11.829 INFO [stdout] 
Dec 15 17:09:11.832 INFO [stderr]      Running /target/debug/deps/iptables_dummy-8720aeee753d90cf
Dec 15 17:09:11.835 INFO [stdout] 
Dec 15 17:09:11.835 INFO [stdout] running 21 tests
Dec 15 17:09:11.835 INFO [stdout] test dummy_delete_all ... ok
Dec 15 17:09:11.835 INFO [stdout] test dummy_append ... ok
Dec 15 17:09:11.835 INFO [stdout] test dummy_delete ... ok
Dec 15 17:09:11.835 INFO [stdout] test dummy_chain_exists ... ok
Dec 15 17:09:11.835 INFO [stdout] test dummy_append_unique ... ok
Dec 15 17:09:11.835 INFO [stdout] test dummy_append_replace ... ok
Dec 15 17:09:11.835 INFO [stdout] test dummy_delete_chain ... ok
Dec 15 17:09:11.835 INFO [stdout] test dummy_execute ... ok
Dec 15 17:09:11.835 INFO [stdout] test dummy_flush_table ... ok
Dec 15 17:09:11.839 INFO [stdout] test dummy_list ... ok
Dec 15 17:09:11.839 INFO [stdout] test dummy_insert_unique ... ok
Dec 15 17:09:11.839 INFO [stdout] test dummy_flush_chain ... ok
Dec 15 17:09:11.839 INFO [stdout] test dummy_list_table ... ok
Dec 15 17:09:11.839 INFO [stdout] test dummy_list_chains ... ok
Dec 15 17:09:11.839 INFO [stdout] test dummy_exists ... ok
Dec 15 17:09:11.839 INFO [stdout] test dummy_new_chain ... ok
Dec 15 17:09:11.839 INFO [stdout] test dummy_get_policy ... ok
Dec 15 17:09:11.847 INFO [stdout] test dummy_rename_chain ... ok
Dec 15 17:09:11.847 INFO [stdout] test dummy_insert ... ok
Dec 15 17:09:11.852 INFO [stdout] test dummy_replace ... ok
Dec 15 17:09:11.852 INFO [stdout] test dummy_set_policy ... ok
Dec 15 17:09:11.852 INFO [stdout] 
Dec 15 17:09:11.852 INFO [stdout] test result: ok. 21 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 17:09:11.852 INFO [stdout] 
Dec 15 17:09:11.859 INFO [stdout] 
Dec 15 17:09:11.859 INFO [stderr]      Running /target/debug/deps/iptables_logger-7245c2ab8280a6f8
Dec 15 17:09:11.859 INFO [stdout] running 1 test
Dec 15 17:09:11.871 INFO [stdout] test log_all ... ok
Dec 15 17:09:11.871 INFO [stderr]      Running /target/debug/deps/logline-16b5c66534699913
Dec 15 17:09:11.871 INFO [stdout] 
Dec 15 17:09:11.871 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 17:09:11.871 INFO [stdout] 
Dec 15 17:09:11.871 INFO [stdout] 
Dec 15 17:09:11.871 INFO [stdout] running 15 tests
Dec 15 17:09:11.877 INFO [stdout] test regex_ne_self ... ok
Dec 15 17:09:11.883 INFO [stdout] test regex_ne_regex ... ok
Dec 15 17:09:11.883 INFO [stdout] test logline_from_string_without_command ... ok
Dec 15 17:09:11.891 INFO [stdout] test string_eq_self ... ok
Dec 15 17:09:11.907 INFO [stdout] test string_eq_string ... ok
Dec 15 17:09:11.963 INFO [stdout] test string_eq_regex_eval ... ok
Dec 15 17:09:11.963 INFO [stdout] test string_eq_regex ... ok
Dec 15 17:09:11.968 INFO [stdout] test string_ne_string ... ok
Dec 15 17:09:11.975 INFO [stdout] test logline_from_string_with_eval ... ok
Dec 15 17:09:11.983 INFO [stdout] test logline_from_string ... ok
Dec 15 17:09:11.983 INFO [stdout] test string_ne_regex ... ok
Dec 15 17:09:11.987 INFO [stdout] test logline_from_wrong_string ... ok
Dec 15 17:09:11.998 INFO [stdout] test string_ne_regex_eval ... ok
Dec 15 17:09:12.015 INFO [stdout] test logline_from_string_with_wrong_expansion ... ok
Dec 15 17:09:12.031 INFO [stdout] test logline_from_string_with_expansions ... ok
Dec 15 17:09:12.031 INFO [stderr]      Running /target/debug/deps/types-03f8a46d2e2ba1d9
Dec 15 17:09:12.031 INFO [stdout] 
Dec 15 17:09:12.031 INFO [stdout] test result: ok. 15 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 17:09:12.031 INFO [stdout] 
Dec 15 17:09:12.035 INFO [stdout] 
Dec 15 17:09:12.035 INFO [stdout] running 13 tests
Dec 15 17:09:12.039 INFO [stdout] test parse_conf_file ... ok
Dec 15 17:09:12.039 INFO [stdout] test parse_expose_port_seq_int ... ok
Dec 15 17:09:12.039 INFO [stdout] test parse_conf_path ... ok
Dec 15 17:09:12.054 INFO [stdout] test parse_expose_port_single_struct ... ok
Dec 15 17:09:12.054 INFO [stdout] test parse_expose_port_single_string ... ok
Dec 15 17:09:12.054 INFO [stdout] test parse_expose_port_single_int ... ok
Dec 15 17:09:12.054 INFO [stdout] test parse_expose_port_seq_struct ... ok
Dec 15 17:09:12.054 INFO [stdout] test parse_expose_port_seq_string ... ok
Dec 15 17:09:12.060 INFO [stdout] test parse_external_network_interfaces_seq ... ok
Dec 15 17:09:12.060 INFO [stdout] test parse_external_network_interfaces_single ... ok
Dec 15 17:09:12.176 INFO [stdout] test parse_expose_port_string_invalid_int ... ok
Dec 15 17:09:12.177 INFO [stdout] test parse_expose_port_string_invalid_int2 ... ok
Dec 15 17:09:12.181 INFO [stdout] test parse_expose_port_string_invalid_format ... ok
Dec 15 17:09:12.181 INFO [stdout] 
Dec 15 17:09:12.181 INFO [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 17:09:12.181 INFO [stdout] 
Dec 15 17:09:12.181 INFO [stderr]    Doc-tests dfw
Dec 15 17:09:22.719 INFO [stdout] 
Dec 15 17:09:22.719 INFO [stdout] running 2 tests
Dec 15 17:09:41.428 INFO [stdout] test src/types.rs - types::ExposePort::from_str (line 408) ... ok
Dec 15 17:09:41.845 INFO [stdout] test src/types.rs - types::ExposePort::from_str (line 400) ... ok
Dec 15 17:09:41.845 INFO [stdout] 
Dec 15 17:09:41.845 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 17:09:41.845 INFO [stdout] 
Dec 15 17:09:41.872 INFO [stderr] su: No module specific data is present
Dec 15 17:09:42.288 INFO running `"docker" "inspect" "f9a13785e582d7a287823422770da96f1a718a750204e08d0d09e0bc16cdae9a"`
Dec 15 17:09:42.436 INFO running `"docker" "rm" "-f" "f9a13785e582d7a287823422770da96f1a718a750204e08d0d09e0bc16cdae9a"`
Dec 15 17:09:42.595 INFO [stdout] f9a13785e582d7a287823422770da96f1a718a750204e08d0d09e0bc16cdae9a