Dec 15 14:47:40.721 INFO testing fix-rs-0.2.1 against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550 Dec 15 14:47:40.721 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-2/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/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 14:47:41.075 INFO [stdout] 35a834d4ee7b17325295bcd8b5e6015a48a9f23d85f61e3d7ef3bc9c49dfd857 Dec 15 14:47:41.077 INFO running `"docker" "start" "-a" "35a834d4ee7b17325295bcd8b5e6015a48a9f23d85f61e3d7ef3bc9c49dfd857"` Dec 15 14:47:41.907 INFO [stderr] usermod: no changes Dec 15 14:47:42.053 INFO [stderr] Compiling fix-rs-macros v0.2.1 Dec 15 14:47:44.097 INFO [stderr] Compiling fix-rs v0.2.1 (/source) Dec 15 14:47:54.931 INFO [stderr] warning: unused variable: `end_seq_no` Dec 15 14:47:54.931 INFO [stderr] --> src/fixt/engine_thread.rs:1200:25 Dec 15 14:47:54.931 INFO [stderr] | Dec 15 14:47:54.931 INFO [stderr] 1200 | let end_seq_no = if resend_request.end_seq_no > connection.outbound_msg_seq_num || resend_request.end_seq_no == 0 { Dec 15 14:47:54.931 INFO [stderr] | ^^^^^^^^^^ help: consider using `_end_seq_no` instead Dec 15 14:47:54.931 INFO [stderr] | Dec 15 14:47:54.931 INFO [stderr] = note: #[warn(unused_variables)] on by default Dec 15 14:47:54.931 INFO [stderr] Dec 15 14:47:54.931 INFO [stderr] warning: unused variable: `logout` Dec 15 14:47:54.931 INFO [stderr] --> src/fixt/engine_thread.rs:1297:25 Dec 15 14:47:54.931 INFO [stderr] | Dec 15 14:47:54.931 INFO [stderr] 1297 | if let Some(logout) = message.as_any().downcast_ref::() { Dec 15 14:47:54.931 INFO [stderr] | ^^^^^^ help: consider using `_logout` instead Dec 15 14:47:54.931 INFO [stderr] Dec 15 14:47:54.931 INFO [stderr] warning: unused variable: `logging_out_initiator` Dec 15 14:47:54.931 INFO [stderr] --> src/fixt/engine_thread.rs:1308:59 Dec 15 14:47:54.931 INFO [stderr] | Dec 15 14:47:54.931 INFO [stderr] 1308 | &LoggingOutType::ResendRequesting(logging_out_initiator) => { //Remote resent Logout before fully responding to our ResendRequest. Dec 15 14:47:54.931 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^ help: consider using `_logging_out_initiator` instead Dec 15 14:47:54.931 INFO [stderr] Dec 15 14:47:54.931 INFO [stderr] warning: unused variable: `logout` Dec 15 14:47:54.931 INFO [stderr] --> src/fixt/engine_thread.rs:1427:25 Dec 15 14:47:54.931 INFO [stderr] | Dec 15 14:47:54.931 INFO [stderr] 1427 | if let Some(logout) = message.as_any().downcast_ref::() { Dec 15 14:47:54.931 INFO [stderr] | ^^^^^^ help: consider using `_logout` instead Dec 15 14:47:54.931 INFO [stderr] Dec 15 14:47:57.775 INFO [stderr] warning: the feature `attr_literals` has been stable since 1.30.0 and no longer requires an attribute to enable Dec 15 14:47:57.775 INFO [stderr] --> src/lib.rs:26:12 Dec 15 14:47:57.775 INFO [stderr] | Dec 15 14:47:57.775 INFO [stderr] 26 | #![feature(attr_literals)] Dec 15 14:47:57.775 INFO [stderr] | ^^^^^^^^^^^^^ Dec 15 14:47:57.775 INFO [stderr] | Dec 15 14:47:57.775 INFO [stderr] = note: #[warn(stable_features)] on by default Dec 15 14:47:57.775 INFO [stderr] Dec 15 14:47:57.775 INFO [stderr] warning: the feature `proc_macro` has been stable since 1.29.0 and no longer requires an attribute to enable Dec 15 14:47:57.775 INFO [stderr] --> src/lib.rs:28:12 Dec 15 14:47:57.775 INFO [stderr] | Dec 15 14:47:57.775 INFO [stderr] 28 | #![feature(proc_macro)] Dec 15 14:47:57.775 INFO [stderr] | ^^^^^^^^^^ Dec 15 14:47:57.775 INFO [stderr] Dec 15 14:48:14.463 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 32.53s Dec 15 14:48:14.469 INFO [stderr] su: No module specific data is present Dec 15 14:48:15.755 INFO running `"docker" "inspect" "35a834d4ee7b17325295bcd8b5e6015a48a9f23d85f61e3d7ef3bc9c49dfd857"` Dec 15 14:48:16.075 INFO running `"docker" "rm" "-f" "35a834d4ee7b17325295bcd8b5e6015a48a9f23d85f61e3d7ef3bc9c49dfd857"` Dec 15 14:48:16.483 INFO [stdout] 35a834d4ee7b17325295bcd8b5e6015a48a9f23d85f61e3d7ef3bc9c49dfd857 Dec 15 14:48:16.491 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-2/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/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 14:48:16.920 INFO [stdout] ff656189f38ec4cb823314c3c8a4eaa68be7fcd8d42e18d7a1d6286922372772 Dec 15 14:48:16.922 INFO running `"docker" "start" "-a" "ff656189f38ec4cb823314c3c8a4eaa68be7fcd8d42e18d7a1d6286922372772"` Dec 15 14:48:18.339 INFO [stderr] usermod: no changes Dec 15 14:48:18.459 INFO [stderr] Compiling fix-rs v0.2.1 (/source) Dec 15 14:48:30.347 INFO [stderr] warning: the feature `attr_literals` has been stable since 1.30.0 and no longer requires an attribute to enable Dec 15 14:48:30.347 INFO [stderr] --> tests/parser.rs:12:12 Dec 15 14:48:30.347 INFO [stderr] | Dec 15 14:48:30.347 INFO [stderr] 12 | #![feature(attr_literals)] Dec 15 14:48:30.347 INFO [stderr] | ^^^^^^^^^^^^^ Dec 15 14:48:30.347 INFO [stderr] | Dec 15 14:48:30.347 INFO [stderr] = note: #[warn(stable_features)] on by default Dec 15 14:48:30.347 INFO [stderr] Dec 15 14:48:33.403 INFO [stderr] warning: function is never used: `accept_with_timeout` Dec 15 14:48:33.403 INFO [stderr] --> tests/common/mod.rs:158:1 Dec 15 14:48:33.403 INFO [stderr] | Dec 15 14:48:33.403 INFO [stderr] 158 | pub fn accept_with_timeout(listener: &TcpListener,timeout: Duration) -> Option { Dec 15 14:48:33.403 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Dec 15 14:48:33.403 INFO [stderr] | Dec 15 14:48:33.403 INFO [stderr] = note: #[warn(dead_code)] on by default Dec 15 14:48:33.403 INFO [stderr] Dec 15 14:48:33.403 INFO [stderr] warning: function is never used: `recv_bytes_with_timeout` Dec 15 14:48:33.403 INFO [stderr] --> tests/common/mod.rs:172:1 Dec 15 14:48:33.403 INFO [stderr] | Dec 15 14:48:33.403 INFO [stderr] 172 | pub fn recv_bytes_with_timeout(stream: &mut TcpStream,timeout: Duration) -> Option> { Dec 15 14:48:33.403 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Dec 15 14:48:33.403 INFO [stderr] Dec 15 14:48:33.403 INFO [stderr] warning: method is never used: `setup_test_server_with_ver` Dec 15 14:48:33.403 INFO [stderr] --> tests/common/mod.rs:252:5 Dec 15 14:48:33.403 INFO [stderr] | Dec 15 14:48:33.403 INFO [stderr] 252 | pub fn setup_test_server_with_ver(fix_version: FIXVersion,message_version: MessageVersion,message_dictionary: HashMap<&'static [u8],Box>) -> (TestStream,Engine,Connection) { Dec 15 14:48:33.403 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Dec 15 14:48:33.403 INFO [stderr] Dec 15 14:48:33.403 INFO [stderr] warning: method is never used: `setup_test_server` Dec 15 14:48:33.403 INFO [stderr] --> tests/common/mod.rs:273:5 Dec 15 14:48:33.403 INFO [stderr] | Dec 15 14:48:33.403 INFO [stderr] 273 | pub fn setup_test_server(message_dictionary: HashMap<&'static [u8],Box>) -> (TestStream,Engine,Connection) { Dec 15 14:48:33.403 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Dec 15 14:48:33.403 INFO [stderr] Dec 15 14:48:33.403 INFO [stderr] warning: method is never used: `setup_test_server_and_logon_with_ver` Dec 15 14:48:33.403 INFO [stderr] --> tests/common/mod.rs:277:5 Dec 15 14:48:33.403 INFO [stderr] | Dec 15 14:48:33.403 INFO [stderr] 277 | pub fn setup_test_server_and_logon_with_ver(fix_version: FIXVersion,message_version: MessageVersion,message_dictionary: HashMap<&'static [u8],Box>) -> (TestStream,Engine,Connection) { Dec 15 14:48:33.403 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Dec 15 14:48:33.403 INFO [stderr] Dec 15 14:48:33.403 INFO [stderr] warning: method is never used: `setup_test_server_and_logon` Dec 15 14:48:33.403 INFO [stderr] --> tests/common/mod.rs:305:5 Dec 15 14:48:33.403 INFO [stderr] | Dec 15 14:48:33.403 INFO [stderr] 305 | pub fn setup_test_server_and_logon(message_dictionary: HashMap<&'static [u8],Box>) -> (TestStream,Engine,Connection) { Dec 15 14:48:33.403 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Dec 15 14:48:33.403 INFO [stderr] Dec 15 14:48:33.407 INFO [stderr] warning: method is never used: `send_message_with_timeout` Dec 15 14:48:33.407 INFO [stderr] --> tests/common/mod.rs:458:5 Dec 15 14:48:33.407 INFO [stderr] | Dec 15 14:48:33.407 INFO [stderr] 458 | pub fn send_message_with_timeout(&mut self,message: T,timeout: Duration) -> Result<(),usize> { Dec 15 14:48:33.407 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Dec 15 14:48:33.407 INFO [stderr] Dec 15 14:48:33.423 INFO [stderr] warning: the feature `attr_literals` has been stable since 1.30.0 and no longer requires an attribute to enable Dec 15 14:48:33.423 INFO [stderr] --> tests/server.rs:12:12 Dec 15 14:48:33.423 INFO [stderr] | Dec 15 14:48:33.423 INFO [stderr] 12 | #![feature(attr_literals)] Dec 15 14:48:33.423 INFO [stderr] | ^^^^^^^^^^^^^ Dec 15 14:48:33.423 INFO [stderr] | Dec 15 14:48:33.423 INFO [stderr] = note: #[warn(stable_features)] on by default Dec 15 14:48:33.423 INFO [stderr] Dec 15 14:48:33.605 INFO [stderr] warning: unused `std::result::Result` that must be used Dec 15 14:48:33.605 INFO [stderr] --> tests/server.rs:423:5 Dec 15 14:48:33.605 INFO [stderr] | Dec 15 14:48:33.605 INFO [stderr] 423 | test_client.stream.shutdown(Shutdown::Both); Dec 15 14:48:33.605 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Dec 15 14:48:33.605 INFO [stderr] | Dec 15 14:48:33.605 INFO [stderr] = note: #[warn(unused_must_use)] on by default Dec 15 14:48:33.605 INFO [stderr] = note: this `Result` may be an `Err` variant, which should be handled Dec 15 14:48:33.605 INFO [stderr] Dec 15 14:48:39.507 INFO [stderr] warning: unused variable: `message` Dec 15 14:48:39.507 INFO [stderr] --> tests/fixt.rs:51:19 Dec 15 14:48:39.507 INFO [stderr] | Dec 15 14:48:39.507 INFO [stderr] 51 | fn is_logon_valid(message: &Logon) -> bool { Dec 15 14:48:39.507 INFO [stderr] | ^^^^^^^ help: consider using `_message` instead Dec 15 14:48:39.507 INFO [stderr] | Dec 15 14:48:39.507 INFO [stderr] = note: #[warn(unused_variables)] on by default Dec 15 14:48:39.507 INFO [stderr] Dec 15 14:48:39.507 INFO [stderr] warning: unused variable: `orig_sending_time_setup_fn` Dec 15 14:48:39.507 INFO [stderr] --> tests/fixt.rs:505:13 Dec 15 14:48:39.507 INFO [stderr] | Dec 15 14:48:39.507 INFO [stderr] 505 | for mut orig_sending_time_setup_fn in orig_sending_time_setup_fns { Dec 15 14:48:39.507 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^ help: consider using `_orig_sending_time_setup_fn` instead Dec 15 14:48:39.507 INFO [stderr] Dec 15 14:48:39.592 INFO [stderr] warning: variable does not need to be mutable Dec 15 14:48:39.592 INFO [stderr] --> tests/fixt.rs:81:65 Dec 15 14:48:39.592 INFO [stderr] | Dec 15 14:48:39.592 INFO [stderr] 81 | let (_,mut client,connection,logon_message) = do_logon(|mut test_server,message| { Dec 15 14:48:39.592 INFO [stderr] | ----^^^^^^^^^^^ Dec 15 14:48:39.592 INFO [stderr] | | Dec 15 14:48:39.592 INFO [stderr] | help: remove this `mut` Dec 15 14:48:39.592 INFO [stderr] | Dec 15 14:48:39.592 INFO [stderr] = note: #[warn(unused_mut)] on by default Dec 15 14:48:39.592 INFO [stderr] Dec 15 14:48:39.592 INFO [stderr] warning: variable does not need to be mutable Dec 15 14:48:39.592 INFO [stderr] --> tests/fixt.rs:111:67 Dec 15 14:48:39.592 INFO [stderr] | Dec 15 14:48:39.592 INFO [stderr] 111 | let (mut test_server,mut client,connection,_) = do_logon(|mut test_server,message| { Dec 15 14:48:39.592 INFO [stderr] | ----^^^^^^^^^^^ Dec 15 14:48:39.592 INFO [stderr] | | Dec 15 14:48:39.592 INFO [stderr] | help: remove this `mut` Dec 15 14:48:39.593 INFO [stderr] Dec 15 14:48:39.593 INFO [stderr] warning: variable does not need to be mutable Dec 15 14:48:39.593 INFO [stderr] --> tests/fixt.rs:144:67 Dec 15 14:48:39.593 INFO [stderr] | Dec 15 14:48:39.593 INFO [stderr] 144 | let (mut test_server,mut client,connection,_) = do_logon(|mut test_server,message| { Dec 15 14:48:39.593 INFO [stderr] | ----^^^^^^^^^^^ Dec 15 14:48:39.593 INFO [stderr] | | Dec 15 14:48:39.593 INFO [stderr] | help: remove this `mut` Dec 15 14:48:39.594 INFO [stderr] Dec 15 14:48:39.599 INFO [stderr] warning: variable does not need to be mutable Dec 15 14:48:39.599 INFO [stderr] --> tests/fixt.rs:171:67 Dec 15 14:48:39.599 INFO [stderr] | Dec 15 14:48:39.599 INFO [stderr] 171 | let (mut test_server,mut client,connection,_) = do_logon(|mut test_server,_| { Dec 15 14:48:39.599 INFO [stderr] | ----^^^^^^^^^^^ Dec 15 14:48:39.599 INFO [stderr] | | Dec 15 14:48:39.599 INFO [stderr] | help: remove this `mut` Dec 15 14:48:39.599 INFO [stderr] Dec 15 14:48:39.621 INFO [stderr] warning: variable does not need to be mutable Dec 15 14:48:39.621 INFO [stderr] --> tests/fixt.rs:236:101 Dec 15 14:48:39.621 INFO [stderr] | Dec 15 14:48:39.621 INFO [stderr] 236 | let (mut test_client,_engine,_listener,_connection,initial_logon_message) = do_logon(|_|{},|mut engine,connection,logon_message| { Dec 15 14:48:39.621 INFO [stderr] | ----^^^^^^ Dec 15 14:48:39.621 INFO [stderr] | | Dec 15 14:48:39.621 INFO [stderr] | help: remove this `mut` Dec 15 14:48:39.621 INFO [stderr] Dec 15 14:48:39.622 INFO [stderr] warning: variable does not need to be mutable Dec 15 14:48:39.622 INFO [stderr] --> tests/fixt.rs:258:10 Dec 15 14:48:39.622 INFO [stderr] | Dec 15 14:48:39.622 INFO [stderr] 258 | |mut engine,connection,logon_message| { Dec 15 14:48:39.622 INFO [stderr] | ----^^^^^^ Dec 15 14:48:39.622 INFO [stderr] | | Dec 15 14:48:39.622 INFO [stderr] | help: remove this `mut` Dec 15 14:48:39.622 INFO [stderr] Dec 15 14:48:39.627 INFO [stderr] warning: variable does not need to be mutable Dec 15 14:48:39.627 INFO [stderr] --> tests/fixt.rs:294:10 Dec 15 14:48:39.627 INFO [stderr] | Dec 15 14:48:39.627 INFO [stderr] 294 | |mut engine,connection,_| { Dec 15 14:48:39.627 INFO [stderr] | ----^^^^^^ Dec 15 14:48:39.627 INFO [stderr] | | Dec 15 14:48:39.627 INFO [stderr] | help: remove this `mut` Dec 15 14:48:39.627 INFO [stderr] Dec 15 14:48:42.135 INFO [stderr] warning: method is never used: `setup_test_client_and_logon_with_ver` Dec 15 14:48:42.135 INFO [stderr] --> tests/common/mod.rs:338:5 Dec 15 14:48:42.135 INFO [stderr] | Dec 15 14:48:42.135 INFO [stderr] 338 | pub fn setup_test_client_and_logon_with_ver(fix_version: FIXVersion,message_version: MessageVersion,message_dictionary: HashMap<&'static [u8],Box>) -> (TestStream,Engine,Listener,Connection) { Dec 15 14:48:42.135 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Dec 15 14:48:42.135 INFO [stderr] | Dec 15 14:48:42.135 INFO [stderr] = note: #[warn(dead_code)] on by default Dec 15 14:48:42.135 INFO [stderr] Dec 15 14:48:42.135 INFO [stderr] warning: method is never used: `setup_test_client_and_logon` Dec 15 14:48:42.135 INFO [stderr] --> tests/common/mod.rs:372:5 Dec 15 14:48:42.135 INFO [stderr] | Dec 15 14:48:42.135 INFO [stderr] 372 | pub fn setup_test_client_and_logon(message_dictionary: HashMap<&'static [u8],Box>) -> (TestStream,Engine,Listener,Connection) { Dec 15 14:48:42.135 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Dec 15 14:48:42.135 INFO [stderr] Dec 15 14:48:42.135 INFO [stderr] warning: method is never used: `send_message_with_timeout` Dec 15 14:48:42.135 INFO [stderr] --> tests/common/mod.rs:458:5 Dec 15 14:48:42.135 INFO [stderr] | Dec 15 14:48:42.135 INFO [stderr] 458 | pub fn send_message_with_timeout(&mut self,message: T,timeout: Duration) -> Result<(),usize> { Dec 15 14:48:42.135 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Dec 15 14:48:42.135 INFO [stderr] Dec 15 14:48:42.142 INFO [stderr] warning: the feature `attr_literals` has been stable since 1.30.0 and no longer requires an attribute to enable Dec 15 14:48:42.142 INFO [stderr] --> tests/fixt.rs:12:12 Dec 15 14:48:42.142 INFO [stderr] | Dec 15 14:48:42.142 INFO [stderr] 12 | #![feature(attr_literals)] Dec 15 14:48:42.142 INFO [stderr] | ^^^^^^^^^^^^^ Dec 15 14:48:42.142 INFO [stderr] | Dec 15 14:48:42.142 INFO [stderr] = note: #[warn(stable_features)] on by default Dec 15 14:48:42.142 INFO [stderr] Dec 15 14:48:42.254 INFO [stderr] warning: function is never used: `recv_bytes_with_timeout` Dec 15 14:48:42.254 INFO [stderr] --> tests/common/mod.rs:172:1 Dec 15 14:48:42.254 INFO [stderr] | Dec 15 14:48:42.254 INFO [stderr] 172 | pub fn recv_bytes_with_timeout(stream: &mut TcpStream,timeout: Duration) -> Option> { Dec 15 14:48:42.255 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Dec 15 14:48:42.255 INFO [stderr] | Dec 15 14:48:42.255 INFO [stderr] = note: #[warn(dead_code)] on by default Dec 15 14:48:42.255 INFO [stderr] Dec 15 14:48:42.255 INFO [stderr] warning: method is never used: `setup_test_client_with_ver` Dec 15 14:48:42.255 INFO [stderr] --> tests/common/mod.rs:309:5 Dec 15 14:48:42.255 INFO [stderr] | Dec 15 14:48:42.255 INFO [stderr] 309 | pub fn setup_test_client_with_ver(fix_version: FIXVersion,message_version: MessageVersion,message_dictionary: HashMap<&'static [u8],Box>) -> (TestStream,Engine,Listener,Connection) { Dec 15 14:48:42.255 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Dec 15 14:48:42.255 INFO [stderr] Dec 15 14:48:42.255 INFO [stderr] warning: method is never used: `setup_test_client` Dec 15 14:48:42.255 INFO [stderr] --> tests/common/mod.rs:334:5 Dec 15 14:48:42.255 INFO [stderr] | Dec 15 14:48:42.255 INFO [stderr] 334 | pub fn setup_test_client(message_dictionary: HashMap<&'static [u8],Box>) -> (TestStream,Engine,Listener,Connection) { Dec 15 14:48:42.255 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Dec 15 14:48:42.255 INFO [stderr] Dec 15 14:48:42.255 INFO [stderr] warning: method is never used: `setup_test_client_and_logon_with_ver` Dec 15 14:48:42.255 INFO [stderr] --> tests/common/mod.rs:338:5 Dec 15 14:48:42.255 INFO [stderr] | Dec 15 14:48:42.255 INFO [stderr] 338 | pub fn setup_test_client_and_logon_with_ver(fix_version: FIXVersion,message_version: MessageVersion,message_dictionary: HashMap<&'static [u8],Box>) -> (TestStream,Engine,Listener,Connection) { Dec 15 14:48:42.255 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Dec 15 14:48:42.255 INFO [stderr] Dec 15 14:48:42.255 INFO [stderr] warning: method is never used: `setup_test_client_and_logon` Dec 15 14:48:42.255 INFO [stderr] --> tests/common/mod.rs:372:5 Dec 15 14:48:42.255 INFO [stderr] | Dec 15 14:48:42.255 INFO [stderr] 372 | pub fn setup_test_client_and_logon(message_dictionary: HashMap<&'static [u8],Box>) -> (TestStream,Engine,Listener,Connection) { Dec 15 14:48:42.255 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Dec 15 14:48:42.255 INFO [stderr] Dec 15 14:48:42.270 INFO [stderr] warning: the feature `attr_literals` has been stable since 1.30.0 and no longer requires an attribute to enable Dec 15 14:48:42.270 INFO [stderr] --> tests/client.rs:12:12 Dec 15 14:48:42.270 INFO [stderr] | Dec 15 14:48:42.270 INFO [stderr] 12 | #![feature(attr_literals)] Dec 15 14:48:42.270 INFO [stderr] | ^^^^^^^^^^^^^ Dec 15 14:48:42.270 INFO [stderr] | Dec 15 14:48:42.270 INFO [stderr] = note: #[warn(stable_features)] on by default Dec 15 14:48:42.270 INFO [stderr] Dec 15 14:48:50.699 INFO [stderr] warning: unused variable: `end_seq_no` Dec 15 14:48:50.699 INFO [stderr] --> src/fixt/engine_thread.rs:1200:25 Dec 15 14:48:50.699 INFO [stderr] | Dec 15 14:48:50.699 INFO [stderr] 1200 | let end_seq_no = if resend_request.end_seq_no > connection.outbound_msg_seq_num || resend_request.end_seq_no == 0 { Dec 15 14:48:50.699 INFO [stderr] | ^^^^^^^^^^ help: consider using `_end_seq_no` instead Dec 15 14:48:50.699 INFO [stderr] | Dec 15 14:48:50.699 INFO [stderr] = note: #[warn(unused_variables)] on by default Dec 15 14:48:50.699 INFO [stderr] Dec 15 14:48:50.699 INFO [stderr] warning: unused variable: `logout` Dec 15 14:48:50.699 INFO [stderr] --> src/fixt/engine_thread.rs:1297:25 Dec 15 14:48:50.699 INFO [stderr] | Dec 15 14:48:50.699 INFO [stderr] 1297 | if let Some(logout) = message.as_any().downcast_ref::() { Dec 15 14:48:50.699 INFO [stderr] | ^^^^^^ help: consider using `_logout` instead Dec 15 14:48:50.702 INFO [stderr] Dec 15 14:48:50.703 INFO [stderr] warning: unused variable: `logging_out_initiator` Dec 15 14:48:50.703 INFO [stderr] --> src/fixt/engine_thread.rs:1308:59 Dec 15 14:48:50.703 INFO [stderr] | Dec 15 14:48:50.703 INFO [stderr] 1308 | &LoggingOutType::ResendRequesting(logging_out_initiator) => { //Remote resent Logout before fully responding to our ResendRequest. Dec 15 14:48:50.703 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^ help: consider using `_logging_out_initiator` instead Dec 15 14:48:50.703 INFO [stderr] Dec 15 14:48:50.703 INFO [stderr] warning: unused variable: `logout` Dec 15 14:48:50.703 INFO [stderr] --> src/fixt/engine_thread.rs:1427:25 Dec 15 14:48:50.703 INFO [stderr] | Dec 15 14:48:50.703 INFO [stderr] 1427 | if let Some(logout) = message.as_any().downcast_ref::() { Dec 15 14:48:50.703 INFO [stderr] | ^^^^^^ help: consider using `_logout` instead Dec 15 14:48:50.703 INFO [stderr] Dec 15 14:48:53.919 INFO [stderr] warning: the feature `attr_literals` has been stable since 1.30.0 and no longer requires an attribute to enable Dec 15 14:48:53.919 INFO [stderr] --> src/lib.rs:26:12 Dec 15 14:48:53.919 INFO [stderr] | Dec 15 14:48:53.919 INFO [stderr] 26 | #![feature(attr_literals)] Dec 15 14:48:53.919 INFO [stderr] | ^^^^^^^^^^^^^ Dec 15 14:48:53.919 INFO [stderr] | Dec 15 14:48:53.967 INFO [stderr] = note: #[warn(stable_features)] on by default Dec 15 14:48:53.967 INFO [stderr] Dec 15 14:48:53.967 INFO [stderr] warning: the feature `proc_macro` has been stable since 1.29.0 and no longer requires an attribute to enable Dec 15 14:48:53.967 INFO [stderr] --> src/lib.rs:28:12 Dec 15 14:48:53.967 INFO [stderr] | Dec 15 14:48:53.967 INFO [stderr] 28 | #![feature(proc_macro)] Dec 15 14:48:53.967 INFO [stderr] | ^^^^^^^^^^ Dec 15 14:48:53.967 INFO [stderr] Dec 15 14:48:55.548 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 37.18s Dec 15 14:48:55.559 INFO [stderr] su: No module specific data is present Dec 15 14:48:56.299 INFO running `"docker" "inspect" "ff656189f38ec4cb823314c3c8a4eaa68be7fcd8d42e18d7a1d6286922372772"` Dec 15 14:48:56.539 INFO running `"docker" "rm" "-f" "ff656189f38ec4cb823314c3c8a4eaa68be7fcd8d42e18d7a1d6286922372772"` Dec 15 14:48:56.950 INFO [stdout] ff656189f38ec4cb823314c3c8a4eaa68be7fcd8d42e18d7a1d6286922372772 Dec 15 14:48:56.957 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-2/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/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 14:48:57.397 INFO [stdout] ad90a30f593c5e781cdbaa71e3127ed838dad3081a1ffe15d1c0380b0200a49b Dec 15 14:48:57.399 INFO running `"docker" "start" "-a" "ad90a30f593c5e781cdbaa71e3127ed838dad3081a1ffe15d1c0380b0200a49b"` Dec 15 14:48:58.574 INFO [stderr] usermod: no changes Dec 15 14:48:58.703 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.10s Dec 15 14:48:58.703 INFO [stderr] Running /target/debug/deps/fix_rs-1de37739cc84ff62 Dec 15 14:48:58.723 INFO [stdout] Dec 15 14:48:58.723 INFO [stderr] Running /target/debug/deps/client-9759420df31f4bda Dec 15 14:48:58.723 INFO [stdout] running 0 tests Dec 15 14:48:58.723 INFO [stdout] Dec 15 14:48:58.723 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 14:48:58.723 INFO [stdout] Dec 15 14:48:58.725 INFO [stdout] Dec 15 14:48:58.725 INFO [stdout] running 22 tests Dec 15 14:48:58.829 INFO [stdout] test test_logout_and_terminate_wrong_versioned_test_request_immediately_after_logon ... ok Dec 15 14:48:58.875 INFO [stdout] test test_inbound_resend_loop_detection ... ok Dec 15 14:48:58.892 INFO [stdout] test test_message_type_default_application_version ... ok Dec 15 14:48:58.965 INFO [stdout] test test_appl_ver_id ... ok Dec 15 14:48:58.983 INFO [stdout] test test_overflowing_inbound_messages_buffer_does_resume ... ok Dec 15 14:48:58.983 INFO [stdout] test test_default_appl_ver_id ... ok Dec 15 14:48:59.033 INFO [stdout] Shutting down connection after remote logged out cleanly. Dec 15 14:48:59.033 INFO [stdout] test test_recv_logout_with_high_msg_seq_num ... ok Dec 15 14:48:59.039 INFO [stdout] test test_recv_resend_request_invalid_end_seq_no ... ok Dec 15 14:48:59.067 INFO [stdout] test test_respond_to_test_request_immediately_after_logon ... ok Dec 15 14:48:59.179 INFO [stdout] test test_respect_default_appl_ver_id_in_test_request_immediately_after_logon ... ok Dec 15 14:48:59.191 INFO [stdout] test test_send_logout_and_recv_logout_with_high_msg_seq_num ... ok Dec 15 14:48:59.295 INFO [stdout] test test_sender_comp_id ... ok Dec 15 14:48:59.363 INFO [stdout] test test_target_comp_id ... ok Dec 15 14:48:59.379 INFO [stdout] test test_max_message_size ... ok Dec 15 14:48:59.404 INFO [stdout] test test_wrong_sender_comp_id_in_logon_response ... ok Dec 15 14:48:59.427 INFO [stdout] test test_wrong_target_comp_id_in_logon_response ... ok Dec 15 14:48:59.727 INFO [stdout] test test_send_logout_before_logon ... ok Dec 15 14:49:04.531 INFO [stdout] Shutting down connection after remote logged out cleanly. Dec 15 14:49:04.531 INFO [stdout] test test_recv_logout_send_logout_recv_resend_request ... ok Dec 15 14:49:04.743 INFO [stdout] test test_send_logout_and_recv_resend_request ... ok Dec 15 14:49:09.195 INFO [stdout] Shutting down connection after no Logout response before timeout Dec 15 14:49:09.539 INFO [stdout] Shutting down connection after remote logged out cleanly. Dec 15 14:49:09.539 INFO [stdout] test test_recv_logout_with_high_msg_seq_num_and_no_reply ... ok Dec 15 14:49:09.699 INFO [stdout] test test_send_logout_and_recv_logout_with_high_msg_seq_num_and_no_reply ... ok Dec 15 14:49:35.711 INFO [stdout] Shutting down connection after writing to socket resulted in WouldBlock for too long Dec 15 14:49:35.715 INFO [stdout] test test_block_read_when_write_blocks ... ok Dec 15 14:49:35.715 INFO [stderr] Running /target/debug/deps/fixt-520cc34ee4f30da9 Dec 15 14:49:35.715 INFO [stdout] Dec 15 14:49:35.715 INFO [stdout] test result: ok. 22 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 14:49:35.715 INFO [stdout] Dec 15 14:49:35.719 INFO [stdout] Dec 15 14:49:35.719 INFO [stdout] running 21 tests Dec 15 14:49:35.732 INFO [stdout] test test_16B ... ignored Dec 15 14:49:35.735 INFO [stdout] test test_18B ... ok Dec 15 14:49:35.735 INFO [stdout] test test_19B ... ignored Dec 15 14:49:35.747 INFO [stdout] test test_17B ... ok Dec 15 14:49:35.791 INFO [stdout] test test_15B ... ok Dec 15 14:49:35.987 INFO [stdout] Shutting down connection after remote logged out cleanly. Dec 15 14:49:36.182 INFO [stdout] test test_20B ... ok Dec 15 14:49:37.179 INFO [stdout] test test_1S ... ok Dec 15 14:49:37.198 INFO [stdout] test test_3B ... ok Dec 15 14:49:37.287 INFO [stdout] test test_10B ... ok Dec 15 14:49:37.331 INFO [stdout] test test_5B ... ok Dec 15 14:49:37.504 INFO [stdout] test test_1B ... ok Dec 15 14:49:37.579 INFO [stdout] test test_14B ... ok Dec 15 14:49:37.637 INFO [stdout] test test_7B ... ok Dec 15 14:49:37.637 INFO [stdout] test test_9B ... ok Dec 15 14:49:37.914 INFO [stdout] test test_11B ... ok Dec 15 14:49:38.481 INFO [stdout] test test_2B ... ok Dec 15 14:49:43.621 INFO [stdout] test test_8B ... ok Dec 15 14:49:46.500 INFO [stdout] Shutting down connection after no Logout response before timeout Dec 15 14:49:47.003 INFO [stdout] test test_12B ... ok Dec 15 14:49:51.099 INFO [stdout] test test_4B ... ok Dec 15 14:49:52.024 INFO [stdout] Shutting down connection after other side failed to disconnect before timeout Dec 15 14:49:53.625 INFO [stdout] test test_13B ... ok Dec 15 14:49:54.033 INFO [stdout] Shutting down connection after other side failed to respond to TestRequest before timeout Dec 15 14:49:55.434 INFO [stdout] test test_6B ... ok Dec 15 14:49:55.434 INFO [stdout] Dec 15 14:49:55.434 INFO [stdout] test result: ok. 19 passed; 0 failed; 2 ignored; 0 measured; 0 filtered out Dec 15 14:49:55.434 INFO [stdout] Dec 15 14:49:55.439 INFO [stdout] Dec 15 14:49:55.439 INFO [stderr] Running /target/debug/deps/parser-51fc133a88515e3c Dec 15 14:49:55.439 INFO [stdout] running 13 tests Dec 15 14:49:55.463 INFO [stdout] test body_length_second_tag_test ... ok Dec 15 14:49:55.495 INFO [stdout] test appl_ver_id_sixth_tag_test ... ok Dec 15 14:49:55.495 INFO [stdout] test nested_repeating_groups_test ... ok Dec 15 14:49:55.495 INFO [stdout] test length_tag_test ... ok Dec 15 14:49:55.515 INFO [stdout] test msg_type_third_tag_test ... ok Dec 15 14:49:55.515 INFO [stdout] test simple_test ... ok Dec 15 14:49:55.515 INFO [stdout] test no_value_after_tag_test ... ok Dec 15 14:49:55.523 INFO [stdout] test equal_character_in_text_test ... ok Dec 15 14:49:55.567 INFO [stdout] test checksum_tag_test ... ok Dec 15 14:49:55.575 INFO [stdout] test stream_test ... ok Dec 15 14:49:55.579 INFO [stdout] test target_comp_id_fifth_tag_test ... ok Dec 15 14:49:55.579 INFO [stdout] test sender_comp_id_fourth_tag_test ... ok Dec 15 14:49:55.583 INFO [stdout] test repeating_groups_test ... ok Dec 15 14:49:55.583 INFO [stdout] Dec 15 14:49:55.583 INFO [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 14:49:55.583 INFO [stdout] Dec 15 14:49:55.588 INFO [stderr] Running /target/debug/deps/server-feadc1a330506daf Dec 15 14:49:55.589 INFO [stdout] Dec 15 14:49:55.589 INFO [stdout] running 11 tests Dec 15 14:49:55.685 INFO [stdout] test test_connection_terminated_while_approving_logon ... ok Dec 15 14:49:55.711 INFO [stdout] test test_connection_terminated_when_disconnected_with_no_logon ... ok Dec 15 14:49:55.735 INFO [stdout] test test_default_appl_ver_id ... ok Dec 15 14:49:55.789 INFO [stdout] test test_logon_all_fix_versions ... ok Dec 15 14:49:55.791 INFO [stdout] test test_message_type_default_application_version ... ok Dec 15 14:49:55.900 INFO [stdout] test test_appl_ver_id ... ok Dec 15 14:49:56.686 INFO [stdout] test test_approve_already_approved_connection_does_nothing ... ok Dec 15 14:49:56.771 INFO [stdout] test test_wrong_target_comp_id_in_logon ... ok Dec 15 14:50:01.720 INFO [stdout] test test_block_read_while_approving_logon ... ok Dec 15 14:50:05.661 INFO [stdout] Shutting down connection after no initial Logon received before timeout Dec 15 14:50:05.671 INFO [stdout] test test_auto_disconnect_after_no_logon ... ok Dec 15 14:50:08.677 INFO [stdout] test test_heart_bt_int ... ok Dec 15 14:50:08.677 INFO [stdout] Dec 15 14:50:08.677 INFO [stdout] test result: ok. 11 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 14:50:08.677 INFO [stdout] Dec 15 14:50:08.679 INFO [stderr] Doc-tests fix-rs Dec 15 14:50:14.943 INFO [stdout] Dec 15 14:50:14.943 INFO [stdout] running 0 tests Dec 15 14:50:14.943 INFO [stdout] Dec 15 14:50:14.944 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 14:50:14.944 INFO [stdout] Dec 15 14:50:14.987 INFO [stderr] su: No module specific data is present Dec 15 14:50:15.803 INFO running `"docker" "inspect" "ad90a30f593c5e781cdbaa71e3127ed838dad3081a1ffe15d1c0380b0200a49b"` Dec 15 14:50:15.959 INFO running `"docker" "rm" "-f" "ad90a30f593c5e781cdbaa71e3127ed838dad3081a1ffe15d1c0380b0200a49b"` Dec 15 14:50:16.303 INFO [stdout] ad90a30f593c5e781cdbaa71e3127ed838dad3081a1ffe15d1c0380b0200a49b