Dec 07 18:53:42.048 INFO testing dfw-0.5.0 against try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468 for pr-56514
Dec 07 18:53:42.056 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-4/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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:42.498 INFO [stdout] e119082a70dfc1f81ca1f6befbcf7f8ef967b3dc7c35616117d552ae6efdae03
Dec 07 18:53:42.500 INFO running `"docker" "start" "-a" "e119082a70dfc1f81ca1f6befbcf7f8ef967b3dc7c35616117d552ae6efdae03"`
Dec 07 18:53:43.553 INFO [stderr] usermod: no changes
Dec 07 18:53:43.941 INFO [stderr]    Compiling unix_socket v0.5.0
Dec 07 18:53:43.943 INFO [stderr]    Compiling tar v0.3.4
Dec 07 18:53:43.946 INFO [stderr]    Compiling slog-kvfilter v0.6.1
Dec 07 18:53:43.946 INFO [stderr]    Compiling iptables v0.2.2
Dec 07 18:53:43.946 INFO [stderr]    Compiling crossbeam-channel v0.2.6
Dec 07 18:53:45.446 INFO [stderr]    Compiling hyperlocal v0.3.0
Dec 07 18:53:47.712 INFO [stderr]    Compiling sloggers v0.2.9
Dec 07 18:53:49.757 INFO [stderr]    Compiling shiplift v0.3.2
Dec 07 18:54:00.918 INFO [stderr]    Compiling dfw v0.5.0 (/source)
Dec 07 18:54:29.966 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 46.39s
Dec 07 18:54:29.993 INFO [stderr] su: No module specific data is present
Dec 07 18:54:30.606 INFO running `"docker" "inspect" "e119082a70dfc1f81ca1f6befbcf7f8ef967b3dc7c35616117d552ae6efdae03"`
Dec 07 18:54:31.196 INFO running `"docker" "rm" "-f" "e119082a70dfc1f81ca1f6befbcf7f8ef967b3dc7c35616117d552ae6efdae03"`
Dec 07 18:54:31.467 INFO [stdout] e119082a70dfc1f81ca1f6befbcf7f8ef967b3dc7c35616117d552ae6efdae03
Dec 07 18:54:31.467 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-4/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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:31.848 INFO [stdout] e52fc0e763d597d5f2e695093a775392b908e608b95bbaa0e81f5997a2dc1414
Dec 07 18:54:31.854 INFO running `"docker" "start" "-a" "e52fc0e763d597d5f2e695093a775392b908e608b95bbaa0e81f5997a2dc1414"`
Dec 07 18:54:32.992 INFO [stderr] usermod: no changes
Dec 07 18:54:33.320 INFO [stderr]    Compiling eval v0.4.3
Dec 07 18:54:36.487 INFO [stderr]    Compiling dfw v0.5.0 (/source)
Dec 07 18:54:39.547 INFO [stderr] warning: function is never used: `load_loglines`
Dec 07 18:54:39.547 INFO [stderr]    --> tests/logs/mod.rs:174:1
Dec 07 18:54:39.547 INFO [stderr]     |
Dec 07 18:54:39.547 INFO [stderr] 174 | pub fn load_loglines(log_path: &str) -> Vec<LogLine> {
Dec 07 18:54:39.547 INFO [stderr]     | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 07 18:54:39.547 INFO [stderr]     |
Dec 07 18:54:39.547 INFO [stderr]     = note: #[warn(dead_code)] on by default
Dec 07 18:54:39.547 INFO [stderr] 
Dec 07 18:55:01.980 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 28.94s
Dec 07 18:55:02.002 INFO [stderr] su: No module specific data is present
Dec 07 18:55:02.368 INFO running `"docker" "inspect" "e52fc0e763d597d5f2e695093a775392b908e608b95bbaa0e81f5997a2dc1414"`
Dec 07 18:55:02.526 INFO running `"docker" "rm" "-f" "e52fc0e763d597d5f2e695093a775392b908e608b95bbaa0e81f5997a2dc1414"`
Dec 07 18:55:02.672 INFO [stdout] e52fc0e763d597d5f2e695093a775392b908e608b95bbaa0e81f5997a2dc1414
Dec 07 18:55:02.674 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-4/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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:02.891 INFO [stdout] d3120c694be27ce65ea379c20b6d9b0f56c5385bb9409fd27badfee8d8978a86
Dec 07 18:55:02.893 INFO running `"docker" "start" "-a" "d3120c694be27ce65ea379c20b6d9b0f56c5385bb9409fd27badfee8d8978a86"`
Dec 07 18:55:03.849 INFO [stderr] usermod: no changes
Dec 07 18:55:04.097 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.22s
Dec 07 18:55:04.107 INFO [stderr]      Running /target/debug/deps/dfw-8dbbb344558e750d
Dec 07 18:55:04.110 INFO [stdout] 
Dec 07 18:55:04.110 INFO [stdout] running 4 tests
Dec 07 18:55:04.111 INFO [stdout] test iptables::tests_iptablesrestore::double_append ... ok
Dec 07 18:55:04.111 INFO [stdout] test iptables::tests_iptablesrestore::restore_set_policy ... ok
Dec 07 18:55:04.111 INFO [stdout] test iptables::tests_iptablesrestore::restore_append ... ok
Dec 07 18:55:04.111 INFO [stdout] test iptables::tests_iptablesrestore::double_append_replace ... ok
Dec 07 18:55:04.111 INFO [stdout] 
Dec 07 18:55:04.111 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 18:55:04.111 INFO [stdout] 
Dec 07 18:55:04.112 INFO [stderr]      Running /target/debug/deps/dfw-dfd9bdbf40f607c8
Dec 07 18:55:04.120 INFO [stdout] 
Dec 07 18:55:04.120 INFO [stdout] running 0 tests
Dec 07 18:55:04.120 INFO [stdout] 
Dec 07 18:55:04.120 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 18:55:04.120 INFO [stdout] 
Dec 07 18:55:04.121 INFO [stderr]      Running /target/debug/deps/dfw-649225689271a4df
Dec 07 18:55:04.122 INFO [stdout] 
Dec 07 18:55:04.122 INFO [stdout] running 0 tests
Dec 07 18:55:04.122 INFO [stdout] 
Dec 07 18:55:04.122 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 18:55:04.122 INFO [stdout] 
Dec 07 18:55:04.123 INFO [stderr]      Running /target/debug/deps/iptables_dummy-81685e7291e1e080
Dec 07 18:55:04.130 INFO [stdout] 
Dec 07 18:55:04.130 INFO [stdout] running 21 tests
Dec 07 18:55:04.134 INFO [stdout] test dummy_append_replace ... ok
Dec 07 18:55:04.134 INFO [stdout] test dummy_append_unique ... ok
Dec 07 18:55:04.134 INFO [stdout] test dummy_chain_exists ... ok
Dec 07 18:55:04.134 INFO [stdout] test dummy_delete_chain ... ok
Dec 07 18:55:04.134 INFO [stdout] test dummy_execute ... ok
Dec 07 18:55:04.134 INFO [stdout] test dummy_flush_chain ... ok
Dec 07 18:55:04.135 INFO [stdout] test dummy_delete_all ... ok
Dec 07 18:55:04.135 INFO [stdout] test dummy_insert ... ok
Dec 07 18:55:04.137 INFO [stdout] test dummy_get_policy ... ok
Dec 07 18:55:04.137 INFO [stdout] test dummy_append ... ok
Dec 07 18:55:04.137 INFO [stdout] test dummy_delete ... ok
Dec 07 18:55:04.137 INFO [stdout] test dummy_list_table ... ok
Dec 07 18:55:04.137 INFO [stdout] test dummy_new_chain ... ok
Dec 07 18:55:04.137 INFO [stdout] test dummy_list ... ok
Dec 07 18:55:04.137 INFO [stdout] test dummy_exists ... ok
Dec 07 18:55:04.137 INFO [stdout] test dummy_insert_unique ... ok
Dec 07 18:55:04.137 INFO [stdout] test dummy_rename_chain ... ok
Dec 07 18:55:04.137 INFO [stdout] test dummy_list_chains ... ok
Dec 07 18:55:04.137 INFO [stdout] test dummy_flush_table ... ok
Dec 07 18:55:04.137 INFO [stdout] test dummy_replace ... ok
Dec 07 18:55:04.137 INFO [stdout] test dummy_set_policy ... ok
Dec 07 18:55:04.137 INFO [stdout] 
Dec 07 18:55:04.137 INFO [stdout] test result: ok. 21 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 18:55:04.137 INFO [stdout] 
Dec 07 18:55:04.138 INFO [stderr]      Running /target/debug/deps/iptables_logger-1da74cb8dc51669c
Dec 07 18:55:04.142 INFO [stdout] 
Dec 07 18:55:04.142 INFO [stdout] running 1 test
Dec 07 18:55:04.142 INFO [stdout] test log_all ... ok
Dec 07 18:55:04.142 INFO [stdout] 
Dec 07 18:55:04.143 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 18:55:04.143 INFO [stdout] 
Dec 07 18:55:04.144 INFO [stderr]      Running /target/debug/deps/logline-4abccb86316ebecb
Dec 07 18:55:04.148 INFO [stdout] 
Dec 07 18:55:04.148 INFO [stdout] running 15 tests
Dec 07 18:55:04.149 INFO [stdout] test regex_ne_regex ... ok
Dec 07 18:55:04.151 INFO [stdout] test regex_ne_self ... ok
Dec 07 18:55:04.152 INFO [stdout] test logline_from_string_without_command ... ok
Dec 07 18:55:04.176 INFO [stdout] test string_eq_self ... ok
Dec 07 18:55:04.176 INFO [stdout] test string_eq_string ... ok
Dec 07 18:55:04.196 INFO [stdout] test string_ne_regex ... ok
Dec 07 18:55:04.198 INFO [stdout] test logline_from_string ... ok
Dec 07 18:55:04.198 INFO [stdout] test logline_from_wrong_string ... ok
Dec 07 18:55:04.199 INFO [stdout] test string_ne_string ... ok
Dec 07 18:55:04.200 INFO [stdout] test logline_from_string_with_eval ... ok
Dec 07 18:55:04.214 INFO [stdout] test string_eq_regex ... ok
Dec 07 18:55:04.214 INFO [stdout] test string_ne_regex_eval ... ok
Dec 07 18:55:04.214 INFO [stdout] test string_eq_regex_eval ... ok
Dec 07 18:55:04.214 INFO [stdout] test logline_from_string_with_wrong_expansion ... ok
Dec 07 18:55:04.229 INFO [stdout] test logline_from_string_with_expansions ... ok
Dec 07 18:55:04.229 INFO [stdout] 
Dec 07 18:55:04.229 INFO [stdout] test result: ok. 15 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 18:55:04.230 INFO [stdout] 
Dec 07 18:55:04.231 INFO [stderr]      Running /target/debug/deps/types-8f8c16c19353e76c
Dec 07 18:55:04.235 INFO [stdout] 
Dec 07 18:55:04.235 INFO [stdout] running 13 tests
Dec 07 18:55:04.259 INFO [stdout] test parse_expose_port_seq_int ... ok
Dec 07 18:55:04.259 INFO [stdout] test parse_expose_port_seq_string ... ok
Dec 07 18:55:04.259 INFO [stdout] test parse_conf_path ... ok
Dec 07 18:55:04.259 INFO [stdout] test parse_conf_file ... ok
Dec 07 18:55:04.259 INFO [stdout] test parse_expose_port_seq_struct ... ok
Dec 07 18:55:04.264 INFO [stdout] test parse_expose_port_single_int ... ok
Dec 07 18:55:04.264 INFO [stdout] test parse_external_network_interfaces_seq ... ok
Dec 07 18:55:04.280 INFO [stdout] test parse_expose_port_single_struct ... ok
Dec 07 18:55:04.281 INFO [stdout] test parse_expose_port_single_string ... ok
Dec 07 18:55:04.281 INFO [stdout] test parse_external_network_interfaces_single ... ok
Dec 07 18:55:04.364 INFO [stdout] test parse_expose_port_string_invalid_int ... ok
Dec 07 18:55:04.364 INFO [stdout] test parse_expose_port_string_invalid_int2 ... ok
Dec 07 18:55:04.364 INFO [stdout] test parse_expose_port_string_invalid_format ... ok
Dec 07 18:55:04.364 INFO [stdout] 
Dec 07 18:55:04.364 INFO [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 18:55:04.364 INFO [stdout] 
Dec 07 18:55:04.372 INFO [stderr]    Doc-tests dfw
Dec 07 18:55:11.192 INFO [stdout] 
Dec 07 18:55:11.192 INFO [stdout] running 2 tests
Dec 07 18:55:28.636 INFO [stdout] test src/types.rs - types::ExposePort::from_str (line 400) ... ok
Dec 07 18:55:29.088 INFO [stdout] test src/types.rs - types::ExposePort::from_str (line 408) ... ok
Dec 07 18:55:29.088 INFO [stdout] 
Dec 07 18:55:29.088 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 18:55:29.088 INFO [stdout] 
Dec 07 18:55:29.141 INFO [stderr] su: No module specific data is present
Dec 07 18:55:29.722 INFO running `"docker" "inspect" "d3120c694be27ce65ea379c20b6d9b0f56c5385bb9409fd27badfee8d8978a86"`
Dec 07 18:55:29.996 INFO running `"docker" "rm" "-f" "d3120c694be27ce65ea379c20b6d9b0f56c5385bb9409fd27badfee8d8978a86"`
Dec 07 18:55:30.362 INFO [stdout] d3120c694be27ce65ea379c20b6d9b0f56c5385bb9409fd27badfee8d8978a86