[INFO] fetching crate smpp 0.1.1... [INFO] testing smpp-0.1.1 against master#432e145bd5a974c5b6f4dd9b352891bd7502b69d for pr-87041 [INFO] extracting crate smpp 0.1.1 into /workspace/builds/worker-9/source [INFO] validating manifest of crates.io crate smpp 0.1.1 on toolchain 432e145bd5a974c5b6f4dd9b352891bd7502b69d [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking crates.io crate smpp 0.1.1 [INFO] finished tweaking crates.io crate smpp 0.1.1 [INFO] tweaked toml for crates.io crate smpp 0.1.1 written to /workspace/builds/worker-9/source/Cargo.toml [INFO] crate crates.io crate smpp 0.1.1 already has a lockfile, it will not be regenerated [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-9/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-9/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 09c1aff010edbc427123e0121729ffc6588eb6cc75aa6fb116d2d94592079e5c [INFO] running `Command { std: "docker" "start" "-a" "09c1aff010edbc427123e0121729ffc6588eb6cc75aa6fb116d2d94592079e5c", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "09c1aff010edbc427123e0121729ffc6588eb6cc75aa6fb116d2d94592079e5c", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "09c1aff010edbc427123e0121729ffc6588eb6cc75aa6fb116d2d94592079e5c", kill_on_drop: false }` [INFO] [stdout] 09c1aff010edbc427123e0121729ffc6588eb6cc75aa6fb116d2d94592079e5c [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-9/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-9/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 1cccc6a9dd73e864513aaac4c1bbfe23059ff501b56a51d1590b04e33f83972f [INFO] running `Command { std: "docker" "start" "-a" "1cccc6a9dd73e864513aaac4c1bbfe23059ff501b56a51d1590b04e33f83972f", kill_on_drop: false }` [INFO] [stderr] Compiling autocfg v1.0.1 [INFO] [stderr] Compiling proc-macro2 v1.0.27 [INFO] [stderr] Compiling unicode-xid v0.2.2 [INFO] [stderr] Compiling syn v1.0.72 [INFO] [stderr] Compiling cfg-if v1.0.0 [INFO] [stderr] Compiling proc-macro-hack v0.5.19 [INFO] [stderr] Compiling serde v1.0.126 [INFO] [stderr] Compiling once_cell v1.5.2 [INFO] [stderr] Compiling termcolor v1.1.2 [INFO] [stderr] Compiling lazy_static v1.4.0 [INFO] [stderr] Compiling ascii v1.0.0 [INFO] [stderr] Compiling signal-hook-registry v1.3.0 [INFO] [stderr] Compiling instant v0.1.9 [INFO] [stderr] Compiling log v0.4.14 [INFO] [stderr] Compiling parking_lot_core v0.8.3 [INFO] [stderr] Compiling mio v0.7.11 [INFO] [stderr] Compiling futures-macro v0.3.15 [INFO] [stderr] Compiling futures-util v0.3.15 [INFO] [stderr] Compiling num-traits v0.2.14 [INFO] [stderr] Compiling tokio v1.6.0 [INFO] [stderr] Compiling env_logger v0.8.3 [INFO] [stderr] Compiling parking_lot v0.11.1 [INFO] [stderr] Compiling quote v1.0.9 [INFO] [stderr] Compiling tokio-macros v1.2.0 [INFO] [stderr] Compiling async-trait v0.1.50 [INFO] [stderr] Compiling num-derive v0.3.3 [INFO] [stderr] Compiling futures-executor v0.3.15 [INFO] [stderr] Compiling futures v0.3.15 [INFO] [stderr] Compiling smpp v0.1.1 (/opt/rustwide/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 33.88s [INFO] running `Command { std: "docker" "inspect" "1cccc6a9dd73e864513aaac4c1bbfe23059ff501b56a51d1590b04e33f83972f", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "1cccc6a9dd73e864513aaac4c1bbfe23059ff501b56a51d1590b04e33f83972f", kill_on_drop: false }` [INFO] [stdout] 1cccc6a9dd73e864513aaac4c1bbfe23059ff501b56a51d1590b04e33f83972f [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-9/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-9/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 8d27c3087fd6cdb70ed5a2472a40e6e1b981032ade8b9ff9407e379d93f05ed0 [INFO] running `Command { std: "docker" "start" "-a" "8d27c3087fd6cdb70ed5a2472a40e6e1b981032ade8b9ff9407e379d93f05ed0", kill_on_drop: false }` [INFO] [stderr] Compiling smpp v0.1.1 (/opt/rustwide/workdir) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 4.66s [INFO] running `Command { std: "docker" "inspect" "8d27c3087fd6cdb70ed5a2472a40e6e1b981032ade8b9ff9407e379d93f05ed0", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "8d27c3087fd6cdb70ed5a2472a40e6e1b981032ade8b9ff9407e379d93f05ed0", kill_on_drop: false }` [INFO] [stdout] 8d27c3087fd6cdb70ed5a2472a40e6e1b981032ade8b9ff9407e379d93f05ed0 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-9/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-9/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] ad8233c220ef038db9e416c7f534900af5b9a900ee51a3b9295f8609f1844da6 [INFO] running `Command { std: "docker" "start" "-a" "ad8233c220ef038db9e416c7f534900af5b9a900ee51a3b9295f8609f1844da6", kill_on_drop: false }` [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.12s [INFO] [stderr] Running unittests (/opt/rustwide/target/debug/deps/smpp-b14a81f14ef46a95) [INFO] [stdout] [INFO] [stdout] running 75 tests [INFO] [stdout] test pdu::check::tests::check_errors_if_read_error ... ok [INFO] [stdout] test pdu::check::tests::check_errors_without_reading_all_if_long_length ... ok [INFO] [stdout] test pdu::formats::tests::read_coctetstring ... ok [INFO] [stdout] test pdu::formats::tests::read_error_coctetstring ... ok [INFO] [stdout] test pdu::formats::tests::read_error_integer4 ... ok [INFO] [stdout] test pdu::formats::tests::read_coctetstring_missing_zero_byte ... ok [INFO] [stdout] test pdu::formats::tests::read_coctetstring_zero_not_included_in_length ... ok [INFO] [stdout] test pdu::formats::tests::read_error_integer1 ... ok [INFO] [stdout] test pdu::check::tests::check_is_ok_if_more_bytes ... ok [INFO] [stdout] test pdu::pdu::tests::parse_bind_transmitter_containing_nonascii_characters ... ok [INFO] [stdout] test pdu::check::tests::check_is_ok_if_exact_bytes ... ok [INFO] [stdout] test pdu::formats::tests::write_integer1 ... ok [INFO] [stdout] test pdu::pdu::tests::parse_bind_transmitter_ending_before_all_fields ... ok [INFO] [stdout] test pdu::pdu::tests::parse_bind_transmitter_with_massive_length ... ok [INFO] [stdout] test pdu::pdu::tests::parse_submit_sm_resp_error_with_message_id_is_an_error ... ok [INFO] [stdout] test pdu::pdu::tests::parse_bind_transmitter_with_too_long_system_id ... ok [INFO] [stdout] test pdu::formats::tests::read_integer1 ... ok [INFO] [stdout] test pdu::formats::tests::read_coctetstring_too_long ... ok [INFO] [stdout] test pdu::formats::tests::write_integer4 ... ok [INFO] [stdout] test pdu::formats::tests::write_octetstring ... ok [INFO] [stdout] test pdu::formats::tests::write_coctetstring ... ok [INFO] [stdout] test pdu::pdu::tests::parse_enquire_link ... ok [INFO] [stdout] test pdu::pdu::tests::parse_enquire_link_resp ... ok [INFO] [stdout] test pdu::pdu::tests::parse_bind_transmitter_hitting_eof_before_end_of_length ... ok [INFO] [stdout] test pdu::pdu::tests::check_is_ok_if_more_bytes ... ok [INFO] [stdout] test pdu::pdu::tests::parse_bind_transmitter_with_length_ending_within_string ... ok [INFO] [stdout] test pdu::check::tests::check_errors_if_short_length ... ok [INFO] [stdout] test pdu::formats::tests::when_reading_octetstring_ending_zero_the_zero_is_included_in_output ... ok [INFO] [stdout] test pdu::pdu::tests::parse_bind_transmitter_with_short_length ... ok [INFO] [stdout] test pdu::pdu::tests::parse_submit_sm_resp_ok_with_message_id ... ok [INFO] [stdout] test pdu::pdu::tests::parse_valid_bind_transceiver ... ok [INFO] [stdout] test pdu::pdu::tests::parse_valid_submit_sm_with_tlvs ... ok [INFO] [stdout] test pdu::pdu::tests::parse_valid_bind_transmitter ... ok [INFO] [stdout] test pdu::pdu::tests::parse_valid_submit_sm_with_short_message_and_no_tlvs ... ok [INFO] [stdout] test pdu::tlvs::tests::getting_nonexistent_tlv_returns_none ... ok [INFO] [stdout] test pdu::tlvs::tests::error_reading_tlv_is_surfaced ... ok [INFO] [stdout] test pdu::tlvs::tests::io_error_reading_tlvs_is_surfaced ... ok [INFO] [stdout] test pdu::tlvs::tests::read_message_payload_tlv ... ok [INFO] [stdout] test pdu::tlvs::tests::read_multiple_tlvs ... ok [INFO] [stdout] test pdu::tlvs::tests::read_tlv_with_length_longer_than_input_fails ... ok [INFO] [stdout] test pdu::tlvs::tests::read_tlv_with_unknown_tag_works ... ok [INFO] [stdout] test pdu::tlvs::tests::reading_malformed_tlvs_is_an_error ... ok [INFO] [stdout] test pdu::tlvs::tests::write_multiple_tlvs ... ok [INFO] [stdout] test pdu::tlvs::tests::write_tlv_with_known_tag ... ok [INFO] [stdout] test pdu::tlvs::tests::write_tlv_with_unknown_tag ... ok [INFO] [stdout] test pdu::tlvs::tests::can_get_existing_tlv_from_list ... ok [INFO] [stdout] test pdu::formats::tests::read_coctetstring_max_length ... ok [INFO] [stdout] test pdu::pdu::tests::parse_valid_bind_receiver_resp ... ok [INFO] [stdout] test pdu::pdu::tests::parse_submit_sm_resp_error_without_message_id ... ok [INFO] [stdout] test pdu::formats::tests::read_integer4 ... ok [INFO] [stdout] test pdu::pdu::tests::parse_valid_bind_receiver ... ok [INFO] [stdout] test pdu::pdu::tests::parse_submit_sm_resp_ok_without_message_id_is_an_error ... ok [INFO] [stdout] test pdu::pdu::tests::parse_valid_bind_transceiver_resp ... ok [INFO] [stdout] test pdu::pdu::tests::parse_valid_bind_transmitter_resp ... ok [INFO] [stdout] test pdu::formats::tests::when_finding_eof_within_octetstring_fail ... ok [INFO] [stdout] test pdu::operations::deliver_sm::tests::when_id_is_in_tlv_and_short_message_tlv_wins ... ok [INFO] [stdout] test pdu::operations::deliver_sm::tests::when_id_is_in_tlv_we_can_extract_it ... ok [INFO] [stdout] test pdu::formats::tests::can_read_octetstring_without_trailing_zero_and_extra_bytes_after ... ok [INFO] [stdout] test pdu::operations::deliver_sm::tests::when_null_terminated_id_is_in_tlv_we_can_extract_it ... ok [INFO] [stdout] test pdu::pdu::tests::check_is_incomplete_if_fewer_bytes ... ok [INFO] [stdout] test pdu::formats::tests::write_octetstring_containing_zeroes ... ok [INFO] [stdout] test pdu::pdu::tests::parse_bind_transmitter_with_nonzero_status ... ok [INFO] [stdout] test pdu::pduparseerror::tests::formatting_unknown_command_id ... ok [INFO] [stdout] test pdu::pdu::tests::parsepdu_resp_error_with_too_large_sequence_number_is_an_error ... ok [INFO] [stdout] test pdu::pdu::tests::parsepdu_resp_error_with_zero_sequence_number_is_an_error ... ok [INFO] [stdout] test pdu::pdu::tests::write_submit_sm_with_message_in_tlvs ... ok [INFO] [stdout] test pdu::pdu::tests::parse_submit_sm_with_too_long_message_length ... ok [INFO] [stdout] test pdu::pdu::tests::parse_valid_deliver_sm_with_empty_short_message_and_no_tlvs ... ok [INFO] [stdout] test pdu::check::tests::check_is_incomplete_if_fewer_bytes ... ok [INFO] [stdout] test pdu::pdu::tests::parse_valid_submit_sm_with_empty_short_message_and_no_tlvs ... ok [INFO] [stdout] test pdu::operations::deliver_sm::tests::when_id_is_at_start_of_short_message_and_no_tlv_we_can_extract_id ... ok [INFO] [stdout] test pdu::operations::deliver_sm::tests::can_parse_short_message_from_appendix_b ... ok [INFO] [stdout] test pdu::pdu::tests::write_deliver_sm_with_short_message_and_no_tlvs ... ok [INFO] [stdout] test pdu::pdu::tests::write_submit_sm_with_short_message_and_no_tlvs ... ok [INFO] [stdout] test pdu::operations::deliver_sm::tests::can_parse_more_realistic_dr_short_messages ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 75 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 0 tests [INFO] [stdout] [INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stderr] Running unittests (/opt/rustwide/target/debug/deps/smsc-dd9e21244b74160d) [INFO] [stderr] Doc-tests smpp [INFO] [stdout] [INFO] [stdout] running 0 tests [INFO] [stdout] [INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "ad8233c220ef038db9e416c7f534900af5b9a900ee51a3b9295f8609f1844da6", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "ad8233c220ef038db9e416c7f534900af5b9a900ee51a3b9295f8609f1844da6", kill_on_drop: false }` [INFO] [stdout] ad8233c220ef038db9e416c7f534900af5b9a900ee51a3b9295f8609f1844da6