Dec 07 18:53:47.734 INFO testing dfw-0.5.0 against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 07 18:53:47.734 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-0/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/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 07 18:53:48.280 INFO [stdout] 92abacf0f1e59678c6b63c6ee3f974950563a5d487cd04aff6353d936cd282d5
Dec 07 18:53:48.282 INFO running `"docker" "start" "-a" "92abacf0f1e59678c6b63c6ee3f974950563a5d487cd04aff6353d936cd282d5"`
Dec 07 18:53:49.516 INFO [stderr] usermod: no changes
Dec 07 18:53:49.874 INFO [stderr]    Compiling jed v0.1.2
Dec 07 18:53:49.877 INFO [stderr]    Compiling tar v0.3.4
Dec 07 18:53:49.877 INFO [stderr]    Compiling slog-stdlog v3.0.2
Dec 07 18:53:49.879 INFO [stderr]    Compiling trackable_derive v0.1.1
Dec 07 18:53:49.879 INFO [stderr]    Compiling hyperlocal v0.3.0
Dec 07 18:53:49.881 INFO [stderr]    Compiling hyper-openssl v0.2.7
Dec 07 18:53:49.882 INFO [stderr]    Compiling slog-kvfilter v0.6.1
Dec 07 18:53:49.882 INFO [stderr]    Compiling iptables v0.2.2
Dec 07 18:53:50.681 INFO [stderr]    Compiling crossbeam-channel v0.2.6
Dec 07 18:53:55.593 INFO [stderr]    Compiling trackable v0.2.20
Dec 07 18:53:56.691 INFO [stderr]    Compiling sloggers v0.2.9
Dec 07 18:53:57.092 INFO [stderr]    Compiling shiplift v0.3.2
Dec 07 18:54:09.384 INFO [stderr]    Compiling dfw v0.5.0 (/source)
Dec 07 18:54:35.164 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 45.60s
Dec 07 18:54:35.196 INFO [stderr] su: No module specific data is present
Dec 07 18:54:35.991 INFO running `"docker" "inspect" "92abacf0f1e59678c6b63c6ee3f974950563a5d487cd04aff6353d936cd282d5"`
Dec 07 18:54:36.344 INFO running `"docker" "rm" "-f" "92abacf0f1e59678c6b63c6ee3f974950563a5d487cd04aff6353d936cd282d5"`
Dec 07 18:54:36.600 INFO [stdout] 92abacf0f1e59678c6b63c6ee3f974950563a5d487cd04aff6353d936cd282d5
Dec 07 18:54:36.602 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-0/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/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 07 18:54:37.022 INFO [stdout] 15c454e72c43a4e34ccebc24cfc2e09197dc84c05efe8eab38763b6e84223d5b
Dec 07 18:54:37.024 INFO running `"docker" "start" "-a" "15c454e72c43a4e34ccebc24cfc2e09197dc84c05efe8eab38763b6e84223d5b"`
Dec 07 18:54:38.364 INFO [stderr] usermod: no changes
Dec 07 18:54:38.680 INFO [stderr]    Compiling eval v0.4.3
Dec 07 18:54:41.348 INFO [stderr]    Compiling dfw v0.5.0 (/source)
Dec 07 18:54:48.408 INFO [stderr] warning: function is never used: `load_loglines`
Dec 07 18:54:48.408 INFO [stderr]    --> tests/logs/mod.rs:174:1
Dec 07 18:54:48.408 INFO [stderr]     |
Dec 07 18:54:48.408 INFO [stderr] 174 | pub fn load_loglines(log_path: &str) -> Vec<LogLine> {
Dec 07 18:54:48.408 INFO [stderr]     | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 07 18:54:48.408 INFO [stderr]     |
Dec 07 18:54:48.408 INFO [stderr]     = note: #[warn(dead_code)] on by default
Dec 07 18:54:48.408 INFO [stderr] 
Dec 07 18:55:04.306 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 25.92s
Dec 07 18:55:04.336 INFO [stderr] su: No module specific data is present
Dec 07 18:55:04.782 INFO running `"docker" "inspect" "15c454e72c43a4e34ccebc24cfc2e09197dc84c05efe8eab38763b6e84223d5b"`
Dec 07 18:55:04.958 INFO running `"docker" "rm" "-f" "15c454e72c43a4e34ccebc24cfc2e09197dc84c05efe8eab38763b6e84223d5b"`
Dec 07 18:55:05.205 INFO [stdout] 15c454e72c43a4e34ccebc24cfc2e09197dc84c05efe8eab38763b6e84223d5b
Dec 07 18:55:05.207 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-0/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/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 07 18:55:05.780 INFO [stdout] cc5233a3570551e725e7147906e4c87dacd935c0b5d556e895f95202f1699c4b
Dec 07 18:55:05.782 INFO running `"docker" "start" "-a" "cc5233a3570551e725e7147906e4c87dacd935c0b5d556e895f95202f1699c4b"`
Dec 07 18:55:07.044 INFO [stderr] usermod: no changes
Dec 07 18:55:07.328 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.25s
Dec 07 18:55:07.348 INFO [stderr]      Running /target/debug/deps/dfw-b02c0763e2f96039
Dec 07 18:55:07.352 INFO [stdout] 
Dec 07 18:55:07.352 INFO [stdout] running 4 tests
Dec 07 18:55:07.360 INFO [stdout] test iptables::tests_iptablesrestore::double_append ... ok
Dec 07 18:55:07.360 INFO [stdout] test iptables::tests_iptablesrestore::double_append_replace ... ok
Dec 07 18:55:07.360 INFO [stdout] test iptables::tests_iptablesrestore::restore_append ... ok
Dec 07 18:55:07.360 INFO [stdout] test iptables::tests_iptablesrestore::restore_set_policy ... ok
Dec 07 18:55:07.360 INFO [stdout] 
Dec 07 18:55:07.360 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 18:55:07.360 INFO [stdout] 
Dec 07 18:55:07.368 INFO [stderr]      Running /target/debug/deps/dfw-6db3f96645327848
Dec 07 18:55:07.368 INFO [stderr]      Running /target/debug/deps/dfw-013c285fe240c353
Dec 07 18:55:07.368 INFO [stdout] 
Dec 07 18:55:07.368 INFO [stdout] running 0 tests
Dec 07 18:55:07.368 INFO [stdout] 
Dec 07 18:55:07.368 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 18:55:07.368 INFO [stdout] 
Dec 07 18:55:07.368 INFO [stdout] 
Dec 07 18:55:07.368 INFO [stdout] running 0 tests
Dec 07 18:55:07.368 INFO [stdout] 
Dec 07 18:55:07.368 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 18:55:07.368 INFO [stdout] 
Dec 07 18:55:07.376 INFO [stderr]      Running /target/debug/deps/iptables_dummy-69c8fce1dda06bb4
Dec 07 18:55:07.384 INFO [stdout] 
Dec 07 18:55:07.384 INFO [stdout] running 21 tests
Dec 07 18:55:07.384 INFO [stdout] test dummy_append ... ok
Dec 07 18:55:07.384 INFO [stdout] test dummy_chain_exists ... ok
Dec 07 18:55:07.384 INFO [stdout] test dummy_delete ... ok
Dec 07 18:55:07.384 INFO [stdout] test dummy_delete_chain ... ok
Dec 07 18:55:07.384 INFO [stdout] test dummy_delete_all ... ok
Dec 07 18:55:07.384 INFO [stdout] test dummy_flush_chain ... ok
Dec 07 18:55:07.384 INFO [stdout] test dummy_execute ... ok
Dec 07 18:55:07.384 INFO [stdout] test dummy_get_policy ... ok
Dec 07 18:55:07.384 INFO [stdout] test dummy_insert ... ok
Dec 07 18:55:07.384 INFO [stdout] test dummy_insert_unique ... ok
Dec 07 18:55:07.384 INFO [stdout] test dummy_list ... ok
Dec 07 18:55:07.384 INFO [stdout] test dummy_list_chains ... ok
Dec 07 18:55:07.384 INFO [stdout] test dummy_list_table ... ok
Dec 07 18:55:07.384 INFO [stdout] test dummy_new_chain ... ok
Dec 07 18:55:07.384 INFO [stdout] test dummy_rename_chain ... ok
Dec 07 18:55:07.384 INFO [stdout] test dummy_append_unique ... ok
Dec 07 18:55:07.384 INFO [stdout] test dummy_append_replace ... ok
Dec 07 18:55:07.384 INFO [stdout] test dummy_exists ... ok
Dec 07 18:55:07.384 INFO [stdout] test dummy_replace ... ok
Dec 07 18:55:07.384 INFO [stdout] test dummy_set_policy ... ok
Dec 07 18:55:07.404 INFO [stdout] test dummy_flush_table ... ok
Dec 07 18:55:07.404 INFO [stdout] 
Dec 07 18:55:07.404 INFO [stdout] test result: ok. 21 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 18:55:07.404 INFO [stdout] 
Dec 07 18:55:07.404 INFO [stdout] 
Dec 07 18:55:07.404 INFO [stdout] running 1 test
Dec 07 18:55:07.404 INFO [stdout] test log_all ... ok
Dec 07 18:55:07.404 INFO [stdout] 
Dec 07 18:55:07.404 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 18:55:07.404 INFO [stdout] 
Dec 07 18:55:07.404 INFO [stdout] 
Dec 07 18:55:07.404 INFO [stdout] running 15 tests
Dec 07 18:55:07.404 INFO [stderr]      Running /target/debug/deps/iptables_logger-e85dab2983e6f2c8
Dec 07 18:55:07.404 INFO [stderr]      Running /target/debug/deps/logline-d889c7b07a1c9588
Dec 07 18:55:07.412 INFO [stdout] test regex_ne_regex ... ok
Dec 07 18:55:07.412 INFO [stdout] test regex_ne_self ... ok
Dec 07 18:55:07.448 INFO [stdout] test logline_from_string_without_command ... ok
Dec 07 18:55:07.456 INFO [stdout] test string_eq_self ... ok
Dec 07 18:55:07.464 INFO [stdout] test string_eq_string ... ok
Dec 07 18:55:07.484 INFO [stdout] test string_eq_regex_eval ... ok
Dec 07 18:55:07.516 INFO [stdout] test string_eq_regex ... ok
Dec 07 18:55:07.516 INFO [stdout] test logline_from_string ... ok
Dec 07 18:55:07.516 INFO [stdout] test logline_from_string_with_eval ... ok
Dec 07 18:55:07.517 INFO [stdout] test logline_from_wrong_string ... ok
Dec 07 18:55:07.525 INFO [stdout] test string_ne_regex_eval ... ok
Dec 07 18:55:07.525 INFO [stdout] test string_ne_string ... ok
Dec 07 18:55:07.544 INFO [stdout] test string_ne_regex ... ok
Dec 07 18:55:07.549 INFO [stdout] test logline_from_string_with_expansions ... ok
Dec 07 18:55:07.554 INFO [stdout] test logline_from_string_with_wrong_expansion ... ok
Dec 07 18:55:07.554 INFO [stdout] 
Dec 07 18:55:07.554 INFO [stdout] test result: ok. 15 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 18:55:07.554 INFO [stdout] 
Dec 07 18:55:07.555 INFO [stderr]      Running /target/debug/deps/types-056973b44bba343a
Dec 07 18:55:07.559 INFO [stdout] 
Dec 07 18:55:07.559 INFO [stdout] running 13 tests
Dec 07 18:55:07.583 INFO [stdout] test parse_expose_port_single_struct ... ok
Dec 07 18:55:07.583 INFO [stdout] test parse_expose_port_seq_int ... ok
Dec 07 18:55:07.584 INFO [stdout] test parse_expose_port_single_string ... ok
Dec 07 18:55:07.584 INFO [stdout] test parse_expose_port_single_int ... ok
Dec 07 18:55:07.586 INFO [stdout] test parse_conf_path ... ok
Dec 07 18:55:07.586 INFO [stdout] test parse_expose_port_seq_string ... ok
Dec 07 18:55:07.587 INFO [stdout] test parse_expose_port_seq_struct ... ok
Dec 07 18:55:07.588 INFO [stdout] test parse_conf_file ... ok
Dec 07 18:55:07.600 INFO [stdout] test parse_external_network_interfaces_seq ... ok
Dec 07 18:55:07.600 INFO [stdout] test parse_external_network_interfaces_single ... ok
Dec 07 18:55:07.764 INFO [stdout] test parse_expose_port_string_invalid_int ... ok
Dec 07 18:55:07.764 INFO [stdout] test parse_expose_port_string_invalid_int2 ... ok
Dec 07 18:55:07.764 INFO [stdout] test parse_expose_port_string_invalid_format ... ok
Dec 07 18:55:07.764 INFO [stdout] 
Dec 07 18:55:07.764 INFO [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 18:55:07.764 INFO [stdout] 
Dec 07 18:55:07.770 INFO [stderr]    Doc-tests dfw
Dec 07 18:55:13.695 INFO [stdout] 
Dec 07 18:55:13.695 INFO [stdout] running 2 tests
Dec 07 18:55:29.080 INFO [stdout] test src/types.rs - types::ExposePort::from_str (line 408) ... ok
Dec 07 18:55:29.161 INFO [stdout] test src/types.rs - types::ExposePort::from_str (line 400) ... ok
Dec 07 18:55:29.161 INFO [stdout] 
Dec 07 18:55:29.161 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 18:55:29.161 INFO [stdout] 
Dec 07 18:55:29.192 INFO [stderr] su: No module specific data is present
Dec 07 18:55:29.736 INFO running `"docker" "inspect" "cc5233a3570551e725e7147906e4c87dacd935c0b5d556e895f95202f1699c4b"`
Dec 07 18:55:30.051 INFO running `"docker" "rm" "-f" "cc5233a3570551e725e7147906e4c87dacd935c0b5d556e895f95202f1699c4b"`
Dec 07 18:55:30.366 INFO [stdout] cc5233a3570551e725e7147906e4c87dacd935c0b5d556e895f95202f1699c4b