[INFO] fetching crate smpp-pdu 0.1.4...
[INFO] testing smpp-pdu-0.1.4 against beta-2021-09-08 for beta-1.56-1
[INFO] extracting crate smpp-pdu 0.1.4 into /workspace/builds/worker-3/source
[INFO] validating manifest of crates.io crate smpp-pdu 0.1.4 on toolchain beta-2021-09-08
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2021-09-08" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate smpp-pdu 0.1.4
[INFO] finished tweaking crates.io crate smpp-pdu 0.1.4
[INFO] tweaked toml for crates.io crate smpp-pdu 0.1.4 written to /workspace/builds/worker-3/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2021-09-08" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2021-09-08" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/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:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2021-09-08" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 491c12c64d373b3da6636bf7953c80e20d77d8a5cf42445d68ad5e9976751f42
[INFO] running `Command { std: "docker" "start" "-a" "491c12c64d373b3da6636bf7953c80e20d77d8a5cf42445d68ad5e9976751f42", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "491c12c64d373b3da6636bf7953c80e20d77d8a5cf42445d68ad5e9976751f42", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "491c12c64d373b3da6636bf7953c80e20d77d8a5cf42445d68ad5e9976751f42", kill_on_drop: false }`
[INFO] [stdout] 491c12c64d373b3da6636bf7953c80e20d77d8a5cf42445d68ad5e9976751f42
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/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=warn" "-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:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2021-09-08" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] a5c55992c4b2aad8c64ff0e37a8b066747313a1e26b016880aba521717c2496e
[INFO] running `Command { std: "docker" "start" "-a" "a5c55992c4b2aad8c64ff0e37a8b066747313a1e26b016880aba521717c2496e", kill_on_drop: false }`
[INFO] [stderr]    Compiling syn v1.0.76
[INFO] [stderr]    Compiling bytes v1.1.0
[INFO] [stderr]    Compiling ascii v1.0.0
[INFO] [stderr]    Compiling tokio v1.11.0
[INFO] [stderr]    Compiling tokio-macros v1.3.0
[INFO] [stderr]    Compiling num-derive v0.3.3
[INFO] [stderr]    Compiling smpp-pdu v0.1.4 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 26.07s
[INFO] running `Command { std: "docker" "inspect" "a5c55992c4b2aad8c64ff0e37a8b066747313a1e26b016880aba521717c2496e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a5c55992c4b2aad8c64ff0e37a8b066747313a1e26b016880aba521717c2496e", kill_on_drop: false }`
[INFO] [stdout] a5c55992c4b2aad8c64ff0e37a8b066747313a1e26b016880aba521717c2496e
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/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=warn" "-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:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2021-09-08" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 618dccc0b6d4ce291895b2460b127552338fc49c921f96f2d1a04c11c4ff1c20
[INFO] running `Command { std: "docker" "start" "-a" "618dccc0b6d4ce291895b2460b127552338fc49c921f96f2d1a04c11c4ff1c20", kill_on_drop: false }`
[INFO] [stderr]    Compiling smpp-pdu v0.1.4 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 4.84s
[INFO] running `Command { std: "docker" "inspect" "618dccc0b6d4ce291895b2460b127552338fc49c921f96f2d1a04c11c4ff1c20", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "618dccc0b6d4ce291895b2460b127552338fc49c921f96f2d1a04c11c4ff1c20", kill_on_drop: false }`
[INFO] [stdout] 618dccc0b6d4ce291895b2460b127552338fc49c921f96f2d1a04c11c4ff1c20
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/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=warn" "-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:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2021-09-08" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] aab8a419c572599f04ff76eb6e1b4ee5f0d19fb73525c782a67242f06db0fec6
[INFO] running `Command { std: "docker" "start" "-a" "aab8a419c572599f04ff76eb6e1b4ee5f0d19fb73525c782a67242f06db0fec6", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 2.53s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/smpp_pdu-9c45aaf768aedadd)
[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::check::tests::check_errors_if_short_length ... ok
[INFO] [stdout] test pdu::check::tests::check_is_ok_if_exact_bytes ... ok
[INFO] [stdout] test pdu::check::tests::check_is_incomplete_if_fewer_bytes ... ok
[INFO] [stdout] test pdu::check::tests::check_is_ok_if_more_bytes ... ok
[INFO] [stdout] test pdu::formats::tests::can_read_octetstring_without_trailing_zero_and_extra_bytes_after ... ok
[INFO] [stdout] test pdu::formats::tests::read_coctetstring_max_length ... ok
[INFO] [stdout] test pdu::formats::tests::read_coctetstring_missing_zero_byte ... 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_too_long ... ok
[INFO] [stdout] test pdu::formats::tests::read_integer4 ... ok
[INFO] [stdout] test pdu::formats::tests::read_integer1 ... ok
[INFO] [stdout] test pdu::formats::tests::read_error_integer1 ... ok
[INFO] [stdout] test pdu::formats::tests::write_integer1 ... ok
[INFO] [stdout] test pdu::formats::tests::write_integer4 ... ok
[INFO] [stdout] test pdu::formats::tests::read_coctetstring_zero_not_included_in_length ... ok
[INFO] [stdout] test pdu::formats::tests::when_finding_eof_within_octetstring_fail ... ok
[INFO] [stdout] test pdu::formats::tests::when_reading_octetstring_ending_zero_the_zero_is_included_in_output ... ok
[INFO] [stdout] test pdu::formats::tests::write_octetstring_containing_zeroes ... ok
[INFO] [stdout] test pdu::formats::tests::write_coctetstring ... ok
[INFO] [stdout] test pdu::formats::tests::write_octetstring ... 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_nonzero_status ... ok
[INFO] [stdout] test pdu::pdu::tests::parse_bind_transmitter_containing_nonascii_characters ... 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_bind_transmitter_with_short_length ... ok
[INFO] [stdout] test pdu::pdu::tests::parse_bind_transmitter_with_too_long_system_id ... ok
[INFO] [stdout] test pdu::pdu::tests::parse_bind_transmitter_ending_before_all_fields ... ok
[INFO] [stdout] test pdu::pdu::tests::parse_bind_transmitter_hitting_eof_before_end_of_length ... 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_with_massive_length ... ok
[INFO] [stdout] test pdu::pdu::tests::parse_enquire_link ... ok
[INFO] [stdout] test pdu::pdu::tests::check_is_ok_if_more_bytes ... ok
[INFO] [stdout] test pdu::pdu::tests::check_is_incomplete_if_fewer_bytes ... 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_enquire_link_resp ... ok
[INFO] [stdout] test pdu::operations::deliver_sm::tests::can_parse_short_message_from_appendix_b ... ok
[INFO] [stdout] test pdu::pdu::tests::parse_submit_sm_resp_ok_without_message_id_is_an_error ... 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_bind_transmitter_with_length_ending_within_string ... 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_submit_sm_with_too_long_message_length ... ok
[INFO] [stdout] test pdu::pdu::tests::parse_submit_sm_resp_error_without_message_id ... ok
[INFO] [stdout] test pdu::pdu::tests::parse_valid_submit_sm_with_short_message_and_no_tlvs ... 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_submit_sm_with_empty_short_message_and_no_tlvs ... 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_bind_transceiver_resp ... 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_receiver_resp ... ok
[INFO] [stdout] test pdu::pdu::tests::parse_valid_bind_transceiver ... 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::write_submit_sm_with_short_message_and_no_tlvs ... ok
[INFO] [stdout] test pdu::tlvs::tests::error_reading_tlv_is_surfaced ... 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::getting_nonexistent_tlv_returns_none ... 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::can_get_existing_tlv_from_list ... 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::pdu::tests::parse_valid_bind_receiver ... 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_message_in_tlvs ... ok
[INFO] [stdout] test pdu::operations::deliver_sm::tests::can_parse_more_realistic_dr_short_messages ... ok
[INFO] [stdout] test pdu::pdu::tests::parse_valid_bind_transmitter_resp ... ok
[INFO] [stdout] test pdu::pduparseerror::tests::formatting_unknown_command_id ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 75 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.09s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests smpp-pdu
[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" "aab8a419c572599f04ff76eb6e1b4ee5f0d19fb73525c782a67242f06db0fec6", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "aab8a419c572599f04ff76eb6e1b4ee5f0d19fb73525c782a67242f06db0fec6", kill_on_drop: false }`
[INFO] [stdout] aab8a419c572599f04ff76eb6e1b4ee5f0d19fb73525c782a67242f06db0fec6