[INFO] fetching crate atelier_smithy 0.2.13...
[INFO] testing atelier_smithy-0.2.13 against try#ecabaf78506b7a4668d42dc20268c086b93f0fad for pr-87041
[INFO] extracting crate atelier_smithy 0.2.13 into /workspace/builds/worker-9/source
[INFO] validating manifest of crates.io crate atelier_smithy 0.2.13 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 atelier_smithy 0.2.13
[INFO] finished tweaking crates.io crate atelier_smithy 0.2.13
[INFO] tweaked toml for crates.io crate atelier_smithy 0.2.13 written to /workspace/builds/worker-9/source/Cargo.toml
[INFO] crate crates.io crate atelier_smithy 0.2.13 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] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded pest_ascii_tree v0.1.0
[INFO] [stderr]   Downloaded ascii_tree v0.1.1
[INFO] [stderr]   Downloaded escape_string v0.1.1
[INFO] [stderr]   Downloaded atelier_test v0.1.3
[INFO] [stderr]   Downloaded atelier_core v0.2.20
[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" "+ecabaf78506b7a4668d42dc20268c086b93f0fad" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 953088807c0dcd05dba30f2665bd0290a7c14a382281fa52b19e61057de134c2
[INFO] running `Command { std: "docker" "start" "-a" "953088807c0dcd05dba30f2665bd0290a7c14a382281fa52b19e61057de134c2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "953088807c0dcd05dba30f2665bd0290a7c14a382281fa52b19e61057de134c2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "953088807c0dcd05dba30f2665bd0290a7c14a382281fa52b19e61057de134c2", kill_on_drop: false }`
[INFO] [stdout] 953088807c0dcd05dba30f2665bd0290a7c14a382281fa52b19e61057de134c2
[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" "+ecabaf78506b7a4668d42dc20268c086b93f0fad" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 38ec77bd8c6bd70118df40f8f870738ce1a20a91e369f5a228b147ae29a6576e
[INFO] running `Command { std: "docker" "start" "-a" "38ec77bd8c6bd70118df40f8f870738ce1a20a91e369f5a228b147ae29a6576e", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.27
[INFO] [stderr]    Compiling unicode-xid v0.2.2
[INFO] [stderr]    Compiling autocfg v1.0.1
[INFO] [stderr]    Compiling libc v0.2.97
[INFO] [stderr]    Compiling cc v1.0.68
[INFO] [stderr]    Compiling ucd-trie v0.1.3
[INFO] [stderr]    Compiling adler v1.0.2
[INFO] [stderr]    Compiling maplit v1.0.2
[INFO] [stderr]    Compiling cfg-if v1.0.0
[INFO] [stderr]    Compiling gimli v0.24.0
[INFO] [stderr]    Compiling log v0.4.14
[INFO] [stderr]    Compiling rustc-demangle v0.1.20
[INFO] [stderr]    Compiling unicode-segmentation v1.7.1
[INFO] [stderr]    Compiling regex-syntax v0.6.25
[INFO] [stderr]    Compiling ascii_tree v0.1.1
[INFO] [stderr]    Compiling lazy_static v1.4.0
[INFO] [stderr]    Compiling escape_string v0.1.1
[INFO] [stderr]    Compiling error-chain v0.12.4
[INFO] [stderr]    Compiling object v0.25.3
[INFO] [stderr]    Compiling pest v2.1.3
[INFO] [stderr]    Compiling miniz_oxide v0.4.4
[INFO] [stderr]    Compiling heck v0.3.3
[INFO] [stderr]    Compiling quote v1.0.9
[INFO] [stderr]    Compiling syn v1.0.73
[INFO] [stderr]    Compiling pest_meta v2.1.3
[INFO] [stderr]    Compiling backtrace v0.3.60
[INFO] [stderr]    Compiling regex v1.5.4
[INFO] [stderr]    Compiling addr2line v0.15.2
[INFO] [stderr]    Compiling pest_generator v2.1.3
[INFO] [stderr]    Compiling atelier_core v0.2.20
[INFO] [stderr]    Compiling pest_derive v2.1.0
[INFO] [stderr]    Compiling pest_ascii_tree v0.1.0
[INFO] [stderr]    Compiling atelier_smithy v0.2.13 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 23.23s
[INFO] running `Command { std: "docker" "inspect" "38ec77bd8c6bd70118df40f8f870738ce1a20a91e369f5a228b147ae29a6576e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "38ec77bd8c6bd70118df40f8f870738ce1a20a91e369f5a228b147ae29a6576e", kill_on_drop: false }`
[INFO] [stdout] 38ec77bd8c6bd70118df40f8f870738ce1a20a91e369f5a228b147ae29a6576e
[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" "+ecabaf78506b7a4668d42dc20268c086b93f0fad" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] c9e1016dc6e42c4a7190e94e8103675390ce485785e0f915298b952b86ab68a5
[INFO] running `Command { std: "docker" "start" "-a" "c9e1016dc6e42c4a7190e94e8103675390ce485785e0f915298b952b86ab68a5", kill_on_drop: false }`
[INFO] [stderr]    Compiling ansi_term v0.12.1
[INFO] [stderr]    Compiling pretty_assertions v0.7.2
[INFO] [stderr]    Compiling atelier_test v0.1.3
[INFO] [stderr]    Compiling atelier_smithy v0.2.13 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 13.55s
[INFO] running `Command { std: "docker" "inspect" "c9e1016dc6e42c4a7190e94e8103675390ce485785e0f915298b952b86ab68a5", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c9e1016dc6e42c4a7190e94e8103675390ce485785e0f915298b952b86ab68a5", kill_on_drop: false }`
[INFO] [stdout] c9e1016dc6e42c4a7190e94e8103675390ce485785e0f915298b952b86ab68a5
[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" "+ecabaf78506b7a4668d42dc20268c086b93f0fad" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 3b473063cc2d0225ffbe777b00b2ec43c88458aa638c6e5957962412ab94d5c9
[INFO] running `Command { std: "docker" "start" "-a" "3b473063cc2d0225ffbe777b00b2ec43c88458aa638c6e5957962412ab94d5c9", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.04s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/atelier_smithy-e83c73c574f6890c)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test parser::smithy::tests::test_low_level_parser ... ok
[INFO] [stdout] test parser::smithy::tests::test_api_level_parser ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/selector_tests.rs (/opt/rustwide/target/debug/deps/selector_tests-5e90e6b0dc41b131)
[INFO] [stdout] 
[INFO] [stdout] running 79 tests
[INFO] [stdout] test test_spec_neighbors_1 ... ok
[INFO] [stdout] test test_spec_neighbors_2 ... ok
[INFO] [stdout] test test_spec_neighbors_3 ... ok
[INFO] [stdout] test test_spec_neighbors_6 ... ok
[INFO] [stdout] test test_spec_context_values_7 ... ok
[INFO] [stdout] test test_spec_functions_1 ... ok
[INFO] [stdout] test test_spec_node_attribute_4 ... ok
[INFO] [stdout] test test_spec_neighbors_9 ... ok
[INFO] [stdout] test test_spec_neighbors_10 ... ok
[INFO] [stdout] test test_spec_id_attribute_4 ... ok
[INFO] [stdout] test test_spec_neighbors_4 ... ok
[INFO] [stdout] test test_spec_neighbors_8 ... ok
[INFO] [stdout] test test_spec_id_attribute_5 ... ok
[INFO] [stdout] test test_spec_multiple_1 ... ok
[INFO] [stdout] test test_spec_node_attribute_3 ... ok
[INFO] [stdout] test test_spec_id_attribute_2 ... ok
[INFO] [stdout] test test_spec_id_attribute_6 ... ok
[INFO] [stdout] test test_spec_context_values_1 ... ok
[INFO] [stdout] test test_spec_context_values_4 ... ok
[INFO] [stdout] test test_spec_neighbors_5 ... ok
[INFO] [stdout] test test_spec_node_attribute_2 ... ok
[INFO] [stdout] test test_spec_context_values_3 ... ok
[INFO] [stdout] test test_spec_id_attribute_7 ... ok
[INFO] [stdout] test test_spec_selector_attr_1 ... ok
[INFO] [stdout] test test_spec_selector_attr_6 ... ok
[INFO] [stdout] test test_spec_node_attribute_1 ... ok
[INFO] [stdout] test test_spec_selector_attr_5 ... ok
[INFO] [stdout] test test_spec_neighbors_11 ... ok
[INFO] [stdout] test test_spec_selector_attr_3 ... ok
[INFO] [stdout] test test_spec_shape_types_blob ... ok
[INFO] [stdout] test test_spec_shape_types_boolean ... ok
[INFO] [stdout] test test_spec_shape_types_big_decimal ... ok
[INFO] [stdout] test test_spec_selector_attr_7 ... ok
[INFO] [stdout] test test_spec_service_attribute_4 ... ok
[INFO] [stdout] test test_spec_service_attribute_2 ... ok
[INFO] [stdout] test test_spec_shape_types_big_integer ... ok
[INFO] [stdout] test test_spec_shape_types_all ... ok
[INFO] [stdout] test test_spec_shape_types_byte ... ok
[INFO] [stdout] test test_spec_selector_attr_2 ... ok
[INFO] [stdout] test test_spec_context_values_6 ... ok
[INFO] [stdout] test test_spec_service_attribute_1 ... ok
[INFO] [stdout] test test_spec_context_values_5 ... ok
[INFO] [stdout] test test_spec_shape_types_collection ... ok
[INFO] [stdout] test test_spec_selector_attr_4 ... ok
[INFO] [stdout] test test_spec_service_attribute_3 ... ok
[INFO] [stdout] test test_spec_context_values_2 ... ok
[INFO] [stdout] test test_spec_neighbors_7 ... ok
[INFO] [stdout] test test_spec_id_attribute_1 ... ok
[INFO] [stdout] test test_spec_shape_types_service ... ok
[INFO] [stdout] test test_spec_projection_3 ... ok
[INFO] [stdout] test test_spec_shape_types_number ... ok
[INFO] [stdout] test test_spec_shape_types_map ... ok
[INFO] [stdout] test test_spec_shape_types_member ... ok
[INFO] [stdout] test test_spec_shape_types_long ... ok
[INFO] [stdout] test test_spec_shape_types_float ... ok
[INFO] [stdout] test test_spec_shape_types_list ... ok
[INFO] [stdout] test test_spec_shape_types_double ... ok
[INFO] [stdout] test test_spec_shape_types_integer ... ok
[INFO] [stdout] test test_spec_shape_types_document ... ok
[INFO] [stdout] test test_spec_shape_types_operation ... ok
[INFO] [stdout] test test_spec_shape_types_resource ... ok
[INFO] [stdout] test test_spec_trait_attribute_3 ... ok
[INFO] [stdout] test test_spec_shape_types_short ... ok
[INFO] [stdout] test test_spec_shape_types_simple_type ... ok
[INFO] [stdout] test test_spec_shape_types_set ... ok
[INFO] [stdout] test test_spec_shape_types_structure ... ok
[INFO] [stdout] test test_spec_shape_types_timestamp ... ok
[INFO] [stdout] test test_spec_shape_types_union ... ok
[INFO] [stdout] test test_spec_shape_types_string ... ok
[INFO] [stdout] test test_spec_trait_attribute_6 ... ok
[INFO] [stdout] test test_spec_trait_attribute_5 ... ok
[INFO] [stdout] test test_spec_trait_attribute_4 ... ok
[INFO] [stdout] test test_spec_trait_attribute_1 ... ok
[INFO] [stdout] test test_spec_trait_attribute_8 ... ok
[INFO] [stdout] test test_spec_projection_1 ... ok
[INFO] [stdout] test test_spec_projection_2 ... ok
[INFO] [stdout] test test_spec_trait_attribute_2 ... ok
[INFO] [stdout] test test_spec_trait_attribute_7 ... ok
[INFO] [stdout] test test_spec_shape_types_fail ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 79 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.92s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/smithy_simple_parse_tests.rs (/opt/rustwide/target/debug/deps/smithy_simple_parse_tests-fb0f2b05a137bed5)
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test empty_file ... ok
[INFO] [stdout] test namespace_only ... ok
[INFO] [stdout] test simple_shape_with_block_text ... ok
[INFO] [stdout] test simple_shape_only ... ok
[INFO] [stdout] test simple_shape_with_traits_and_comments ... ok
[INFO] [stdout] test simple_shape_with_block_text_2 ... ok
[INFO] [stdout] test simple_shape_with_traits_and_documentation ... ok
[INFO] [stdout] test simple_shape_with_traits ... ok
[INFO] [stderr]      Running tests/smithy_success_tests.rs (/opt/rustwide/target/debug/deps/smithy_success_tests-6dfdc4ff5d20a082)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test test_mqtt_api_example ... ok
[INFO] [stdout] test test_weather_example ... ok
[INFO] [stdout] test test_motd_example ... ok
[INFO] [stdout] test test_waiters_example ... ok
[INFO] [stderr]      Running tests/smithy_write_motd.rs (/opt/rustwide/target/debug/deps/smithy_write_motd-d87a886d960713a4)
[INFO] [stdout] test test_smithy_prelude ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.13s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test write_motd_model ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/smithy_write_weather.rs (/opt/rustwide/target/debug/deps/smithy_write_weather-a89030a43bfd838d)
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests atelier_smithy
[INFO] [stdout] running 1 test
[INFO] [stdout] test write_weather_example ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test src/lib.rs - (line 32) ... ok
[INFO] [stdout] test src/lib.rs - (line 16) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 2.64s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "3b473063cc2d0225ffbe777b00b2ec43c88458aa638c6e5957962412ab94d5c9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3b473063cc2d0225ffbe777b00b2ec43c88458aa638c6e5957962412ab94d5c9", kill_on_drop: false }`
[INFO] [stdout] 3b473063cc2d0225ffbe777b00b2ec43c88458aa638c6e5957962412ab94d5c9