[INFO] fetching crate smpp 0.1.1...
[INFO] testing smpp-0.1.1 against try#ecabaf78506b7a4668d42dc20268c086b93f0fad for pr-87041
[INFO] extracting crate smpp 0.1.1 into /workspace/builds/worker-1/source
[INFO] validating manifest of crates.io crate smpp 0.1.1 on toolchain ecabaf78506b7a4668d42dc20268c086b93f0fad
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+ecabaf78506b7a4668d42dc20268c086b93f0fad" "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-1/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" "+ecabaf78506b7a4668d42dc20268c086b93f0fad" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/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" "+ecabaf78506b7a4668d42dc20268c086b93f0fad" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 8828fe27895484a28bee1234c20ac3ed7f58d5bf516babd985edb23099c2b0f4
[INFO] running `Command { std: "docker" "start" "-a" "8828fe27895484a28bee1234c20ac3ed7f58d5bf516babd985edb23099c2b0f4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "8828fe27895484a28bee1234c20ac3ed7f58d5bf516babd985edb23099c2b0f4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8828fe27895484a28bee1234c20ac3ed7f58d5bf516babd985edb23099c2b0f4", kill_on_drop: false }`
[INFO] [stdout] 8828fe27895484a28bee1234c20ac3ed7f58d5bf516babd985edb23099c2b0f4
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/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" "+ecabaf78506b7a4668d42dc20268c086b93f0fad" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] ce58ae7f0f9d381a3670e1287e520fd43c75152492d95e157d3b644221be2587
[INFO] running `Command { std: "docker" "start" "-a" "ce58ae7f0f9d381a3670e1287e520fd43c75152492d95e157d3b644221be2587", 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 libc v0.2.95
[INFO] [stderr]    Compiling memchr v2.4.0
[INFO] [stderr]    Compiling cfg-if v1.0.0
[INFO] [stderr]    Compiling proc-macro-hack v0.5.19
[INFO] [stderr]    Compiling log v0.4.14
[INFO] [stderr]    Compiling proc-macro-nested v0.1.7
[INFO] [stderr]    Compiling futures-task v0.3.15
[INFO] [stderr]    Compiling futures-channel v0.3.15
[INFO] [stderr]    Compiling futures-sink v0.3.15
[INFO] [stderr]    Compiling pin-project-lite v0.2.6
[INFO] [stderr]    Compiling futures-io v0.3.15
[INFO] [stderr]    Compiling smallvec v1.6.1
[INFO] [stderr]    Compiling slab v0.4.3
[INFO] [stderr]    Compiling async-trait v0.1.50
[INFO] [stderr]    Compiling regex-syntax v0.6.25
[INFO] [stderr]    Compiling humantime v2.1.0
[INFO] [stderr]    Compiling termcolor v1.1.2
[INFO] [stderr]    Compiling ascii v1.0.0
[INFO] [stderr]    Compiling lazy_static v1.4.0
[INFO] [stderr]    Compiling lock_api v0.4.4
[INFO] [stderr]    Compiling instant v0.1.9
[INFO] [stderr]    Compiling futures-macro v0.3.15
[INFO] [stderr]    Compiling futures-util v0.3.15
[INFO] [stderr]    Compiling tokio v1.6.0
[INFO] [stderr]    Compiling num-traits v0.2.14
[INFO] [stderr]    Compiling quote v1.0.9
[INFO] [stderr]    Compiling aho-corasick v0.7.18
[INFO] [stderr]    Compiling parking_lot_core v0.8.3
[INFO] [stderr]    Compiling num_cpus v1.13.0
[INFO] [stderr]    Compiling atty v0.2.14
[INFO] [stderr]    Compiling signal-hook-registry v1.3.0
[INFO] [stderr]    Compiling mio v0.7.11
[INFO] [stderr]    Compiling syn v1.0.72
[INFO] [stderr]    Compiling parking_lot v0.11.1
[INFO] [stderr]    Compiling regex v1.5.4
[INFO] [stderr]    Compiling env_logger v0.8.3
[INFO] [stderr]    Compiling tokio-macros v1.2.0
[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 38.47s
[INFO] running `Command { std: "docker" "inspect" "ce58ae7f0f9d381a3670e1287e520fd43c75152492d95e157d3b644221be2587", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ce58ae7f0f9d381a3670e1287e520fd43c75152492d95e157d3b644221be2587", kill_on_drop: false }`
[INFO] [stdout] ce58ae7f0f9d381a3670e1287e520fd43c75152492d95e157d3b644221be2587
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/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" "+ecabaf78506b7a4668d42dc20268c086b93f0fad" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] e3cc613bc2d91d6892b9ddec602ef8114e3fc2c0f66b859017a142925bd73170
[INFO] running `Command { std: "docker" "start" "-a" "e3cc613bc2d91d6892b9ddec602ef8114e3fc2c0f66b859017a142925bd73170", kill_on_drop: false }`
[INFO] [stderr]    Compiling smpp v0.1.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 4.28s
[INFO] running `Command { std: "docker" "inspect" "e3cc613bc2d91d6892b9ddec602ef8114e3fc2c0f66b859017a142925bd73170", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e3cc613bc2d91d6892b9ddec602ef8114e3fc2c0f66b859017a142925bd73170", kill_on_drop: false }`
[INFO] [stdout] e3cc613bc2d91d6892b9ddec602ef8114e3fc2c0f66b859017a142925bd73170
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/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" "+ecabaf78506b7a4668d42dc20268c086b93f0fad" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 10842363b7414e9b3fe9722407ef7bcf690896d33397a5982915cde1237e9e83
[INFO] running `Command { std: "docker" "start" "-a" "10842363b7414e9b3fe9722407ef7bcf690896d33397a5982915cde1237e9e83", kill_on_drop: false }`
[INFO] [stdout] 
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.05s
[INFO] [stdout] running 75 tests
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/smpp-b14a81f14ef46a95)
[INFO] [stdout] test pdu::check::tests::check_is_incomplete_if_fewer_bytes ... ok
[INFO] [stdout] test pdu::check::tests::check_errors_if_read_error ... ok
[INFO] [stdout] test pdu::check::tests::check_is_ok_if_more_bytes ... ok
[INFO] [stdout] test pdu::check::tests::check_errors_without_reading_all_if_long_length ... ok
[INFO] [stdout] test pdu::check::tests::check_is_ok_if_exact_bytes ... ok
[INFO] [stdout] test pdu::check::tests::check_errors_if_short_length ... ok
[INFO] [stdout] test pdu::formats::tests::read_coctetstring ... 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_id_is_in_tlv_and_short_message_tlv_wins ... ok
[INFO] [stdout] test pdu::pdu::tests::parse_bind_transmitter_with_length_ending_within_string ... ok
[INFO] [stdout] test pdu::pdu::tests::parse_bind_transmitter_with_massive_length ... ok
[INFO] [stdout] test pdu::formats::tests::read_coctetstring_too_long ... 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_integer4 ... ok
[INFO] [stdout] test pdu::pdu::tests::check_is_ok_if_more_bytes ... ok
[INFO] [stdout] test pdu::operations::deliver_sm::tests::when_id_is_in_tlv_we_can_extract_it ... ok
[INFO] [stdout] test pdu::pdu::tests::parse_enquire_link_resp ... 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::parse_bind_transmitter_hitting_eof_before_end_of_length ... ok
[INFO] [stdout] test pdu::formats::tests::read_error_integer1 ... ok
[INFO] [stdout] test pdu::formats::tests::read_integer1 ... ok
[INFO] [stdout] test pdu::pdu::tests::parse_bind_transmitter_with_too_long_system_id ... 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_ending_before_all_fields ... ok
[INFO] [stdout] test pdu::pdu::tests::parse_submit_sm_resp_error_with_message_id_is_an_error ... ok
[INFO] [stdout] test pdu::formats::tests::read_coctetstring_max_length ... 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::pdu::tests::parse_enquire_link ... ok
[INFO] [stdout] test pdu::pdu::tests::check_is_incomplete_if_fewer_bytes ... ok
[INFO] [stdout] test pdu::pdu::tests::parse_bind_transmitter_containing_nonascii_characters ... ok
[INFO] [stdout] test pdu::pdu::tests::parse_submit_sm_resp_ok_with_message_id ... ok
[INFO] [stdout] test pdu::formats::tests::when_finding_eof_within_octetstring_fail ... 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_without_message_id_is_an_error ... 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::formats::tests::write_coctetstring ... 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_short_message_from_appendix_b ... 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::pdu::tests::parse_valid_bind_transmitter_resp ... ok
[INFO] [stdout] test pdu::pdu::tests::parse_valid_submit_sm_with_empty_short_message_and_no_tlvs ... ok
[INFO] [stdout] test pdu::tlvs::tests::can_get_existing_tlv_from_list ... ok
[INFO] [stdout] test pdu::pdu::tests::parsepdu_resp_error_with_zero_sequence_number_is_an_error ... ok
[INFO] [stdout] test pdu::pdu::tests::parse_valid_bind_receiver_resp ... ok
[INFO] [stdout] test pdu::pdu::tests::parse_valid_deliver_sm_with_empty_short_message_and_no_tlvs ... ok
[INFO] [stdout] test pdu::pdu::tests::parse_valid_bind_transmitter ... ok
[INFO] [stdout] test pdu::pdu::tests::parsepdu_resp_error_with_too_large_sequence_number_is_an_error ... ok
[INFO] [stdout] test pdu::pduparseerror::tests::formatting_unknown_command_id ... ok
[INFO] [stdout] test pdu::pdu::tests::parse_valid_bind_transceiver_resp ... ok
[INFO] [stdout] test pdu::pdu::tests::write_deliver_sm_with_short_message_and_no_tlvs ... ok
[INFO] [stdout] test pdu::pdu::tests::parse_valid_submit_sm_with_short_message_and_no_tlvs ... 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_bind_transmitter_with_nonzero_status ... ok
[INFO] [stdout] test pdu::operations::deliver_sm::tests::can_parse_more_realistic_dr_short_messages ... ok
[INFO] [stdout] test pdu::formats::tests::write_octetstring ... ok
[INFO] [stdout] test pdu::formats::tests::write_octetstring_containing_zeroes ... ok
[INFO] [stdout] test pdu::tlvs::tests::error_reading_tlv_is_surfaced ... ok
[INFO] [stdout] test pdu::tlvs::tests::getting_nonexistent_tlv_returns_none ... ok
[INFO] [stdout] test pdu::tlvs::tests::read_multiple_tlvs ... ok
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/smsc-dd9e21244b74160d)
[INFO] [stdout] test pdu::formats::tests::write_integer1 ... ok
[INFO] [stderr]    Doc-tests smpp
[INFO] [stdout] test pdu::pdu::tests::parse_submit_sm_resp_error_without_message_id ... ok
[INFO] [stdout] test pdu::pdu::tests::parse_valid_bind_receiver ... ok
[INFO] [stdout] test pdu::tlvs::tests::io_error_reading_tlvs_is_surfaced ... ok
[INFO] [stdout] test pdu::tlvs::tests::write_multiple_tlvs ... ok
[INFO] [stdout] test pdu::tlvs::tests::read_tlv_with_length_longer_than_input_fails ... ok
[INFO] [stdout] test pdu::tlvs::tests::write_tlv_with_known_tag ... 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::read_message_payload_tlv ... ok
[INFO] [stdout] test pdu::tlvs::tests::write_tlv_with_unknown_tag ... ok
[INFO] [stdout] test pdu::formats::tests::write_integer4 ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 75 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.08s
[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] [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" "10842363b7414e9b3fe9722407ef7bcf690896d33397a5982915cde1237e9e83", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "10842363b7414e9b3fe9722407ef7bcf690896d33397a5982915cde1237e9e83", kill_on_drop: false }`
[INFO] [stdout] 10842363b7414e9b3fe9722407ef7bcf690896d33397a5982915cde1237e9e83