[INFO] fetching crate atelier_smithy 0.2.13...
[INFO] testing atelier_smithy-0.2.13 against try#722e1797249a965b6335aebd65d777f917e498f1 for pr-91031
[INFO] extracting crate atelier_smithy 0.2.13 into /workspace/builds/worker-77/source
[INFO] validating manifest of crates.io crate atelier_smithy 0.2.13 on toolchain 722e1797249a965b6335aebd65d777f917e498f1
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "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-77/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" "+722e1797249a965b6335aebd65d777f917e498f1" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded atelier_test v0.1.3
[INFO] [stderr]   Downloaded pest_ascii_tree v0.1.0
[INFO] [stderr]   Downloaded escape_string v0.1.1
[INFO] [stderr]   Downloaded ascii_tree v0.1.1
[INFO] [stderr]   Downloaded atelier_core v0.2.20
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-77/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-77/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] db4727ed074f89a0fd2ebbf85f980049b44bac554fc6deb186b8aabc0fdbee31
[INFO] running `Command { std: "docker" "start" "-a" "db4727ed074f89a0fd2ebbf85f980049b44bac554fc6deb186b8aabc0fdbee31", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "db4727ed074f89a0fd2ebbf85f980049b44bac554fc6deb186b8aabc0fdbee31", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "db4727ed074f89a0fd2ebbf85f980049b44bac554fc6deb186b8aabc0fdbee31", kill_on_drop: false }`
[INFO] [stdout] db4727ed074f89a0fd2ebbf85f980049b44bac554fc6deb186b8aabc0fdbee31
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-77/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-77/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] ff543539373180e1b8ccfbe071a2c5144081f359f3ed8e4733413f334e14b8d1
[INFO] running `Command { std: "docker" "start" "-a" "ff543539373180e1b8ccfbe071a2c5144081f359f3ed8e4733413f334e14b8d1", kill_on_drop: false }`
[INFO] [stderr]    Compiling memchr v2.4.0
[INFO] [stderr]    Compiling autocfg v1.0.1
[INFO] [stderr]    Compiling unicode-xid v0.2.2
[INFO] [stderr]    Compiling libc v0.2.97
[INFO] [stderr]    Compiling syn v1.0.73
[INFO] [stderr]    Compiling ucd-trie v0.1.3
[INFO] [stderr]    Compiling cc v1.0.68
[INFO] [stderr]    Compiling maplit v1.0.2
[INFO] [stderr]    Compiling version_check v0.9.3
[INFO] [stderr]    Compiling gimli v0.24.0
[INFO] [stderr]    Compiling adler v1.0.2
[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 ascii_tree v0.1.1
[INFO] [stderr]    Compiling lazy_static v1.4.0
[INFO] [stderr]    Compiling escape_string v0.1.1
[INFO] [stderr]    Compiling proc-macro2 v1.0.27
[INFO] [stderr]    Compiling pest v2.1.3
[INFO] [stderr]    Compiling error-chain v0.12.4
[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 object v0.25.3
[INFO] [stderr]    Compiling aho-corasick v0.7.18
[INFO] [stderr]    Compiling backtrace v0.3.60
[INFO] [stderr]    Compiling pest_meta v2.1.3
[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 pest_derive v2.1.0
[INFO] [stderr]    Compiling pest_ascii_tree v0.1.0
[INFO] [stderr]    Compiling atelier_core v0.2.20
[INFO] [stderr]    Compiling atelier_smithy v0.2.13 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2m 32s
[INFO] running `Command { std: "docker" "inspect" "ff543539373180e1b8ccfbe071a2c5144081f359f3ed8e4733413f334e14b8d1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ff543539373180e1b8ccfbe071a2c5144081f359f3ed8e4733413f334e14b8d1", kill_on_drop: false }`
[INFO] [stdout] ff543539373180e1b8ccfbe071a2c5144081f359f3ed8e4733413f334e14b8d1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-77/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-77/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 427fe5b7a7d796e6a9cf89f2ada305e1d590c6880e5aad6b8b4c050665867332
[INFO] running `Command { std: "docker" "start" "-a" "427fe5b7a7d796e6a9cf89f2ada305e1d590c6880e5aad6b8b4c050665867332", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling diff v0.1.12
[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 6.34s
[INFO] running `Command { std: "docker" "inspect" "427fe5b7a7d796e6a9cf89f2ada305e1d590c6880e5aad6b8b4c050665867332", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "427fe5b7a7d796e6a9cf89f2ada305e1d590c6880e5aad6b8b4c050665867332", kill_on_drop: false }`
[INFO] [stdout] 427fe5b7a7d796e6a9cf89f2ada305e1d590c6880e5aad6b8b4c050665867332
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-77/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-77/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] def113cc75f095c3e239a03255f1f6aa24b0b4a8b376be2661b60a315ec6050e
[INFO] running `Command { std: "docker" "start" "-a" "def113cc75f095c3e239a03255f1f6aa24b0b4a8b376be2661b60a315ec6050e", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.28s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/atelier_smithy-559b5b7abf4951e7)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test parser::smithy::tests::test_api_level_parser ... ok
[INFO] [stdout] test parser::smithy::tests::test_low_level_parser ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/selector_tests.rs (/opt/rustwide/target/debug/deps/selector_tests-779715c8c07ab65e)
[INFO] [stdout] 
[INFO] [stdout] running 79 tests
[INFO] [stdout] test test_spec_context_values_1 ... ok
[INFO] [stdout] test test_spec_context_values_4 ... ok
[INFO] [stdout] test test_spec_context_values_3 ... ok
[INFO] [stdout] test test_spec_context_values_2 ... ok
[INFO] [stdout] test test_spec_context_values_5 ... ok
[INFO] [stdout] test test_spec_context_values_6 ... ok
[INFO] [stdout] test test_spec_context_values_7 ... ok
[INFO] [stdout] test test_spec_functions_1 ... ok
[INFO] [stdout] test test_spec_id_attribute_2 ... ok
[INFO] [stdout] test test_spec_id_attribute_5 ... ok
[INFO] [stdout] test test_spec_id_attribute_4 ... ok
[INFO] [stdout] test test_spec_id_attribute_7 ... ok
[INFO] [stdout] test test_spec_id_attribute_6 ... ok
[INFO] [stdout] test test_spec_multiple_1 ... ok
[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_4 ... ok
[INFO] [stdout] test test_spec_neighbors_11 ... ok
[INFO] [stdout] test test_spec_neighbors_6 ... ok
[INFO] [stdout] test test_spec_id_attribute_1 ... ok
[INFO] [stdout] test test_spec_neighbors_5 ... ok
[INFO] [stdout] test test_spec_neighbors_10 ... ok
[INFO] [stdout] test test_spec_neighbors_9 ... ok
[INFO] [stdout] test test_spec_neighbors_8 ... ok
[INFO] [stdout] test test_spec_neighbors_7 ... ok
[INFO] [stdout] test test_spec_node_attribute_1 ... ok
[INFO] [stdout] test test_spec_node_attribute_2 ... ok
[INFO] [stdout] test test_spec_node_attribute_3 ... ok
[INFO] [stdout] test test_spec_node_attribute_4 ... ok
[INFO] [stdout] test test_spec_selector_attr_2 ... ok
[INFO] [stdout] test test_spec_selector_attr_3 ... ok
[INFO] [stdout] test test_spec_projection_1 ... ok
[INFO] [stdout] test test_spec_selector_attr_1 ... ok
[INFO] [stdout] test test_spec_projection_2 ... ok
[INFO] [stdout] test test_spec_selector_attr_5 ... ok
[INFO] [stdout] test test_spec_selector_attr_4 ... ok
[INFO] [stdout] test test_spec_selector_attr_6 ... ok
[INFO] [stdout] test test_spec_selector_attr_7 ... ok
[INFO] [stdout] test test_spec_service_attribute_1 ... ok
[INFO] [stdout] test test_spec_service_attribute_2 ... ok
[INFO] [stdout] test test_spec_shape_types_all ... ok
[INFO] [stdout] test test_spec_shape_types_big_decimal ... ok
[INFO] [stdout] test test_spec_service_attribute_3 ... ok
[INFO] [stdout] test test_spec_shape_types_big_integer ... ok
[INFO] [stdout] test test_spec_projection_3 ... ok
[INFO] [stdout] test test_spec_shape_types_byte ... ok
[INFO] [stdout] test test_spec_shape_types_collection ... ok
[INFO] [stdout] test test_spec_shape_types_blob ... ok
[INFO] [stdout] test test_spec_shape_types_boolean ... ok
[INFO] [stdout] test test_spec_service_attribute_4 ... 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_document ... ok
[INFO] [stdout] test test_spec_shape_types_integer ... 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_map ... ok
[INFO] [stdout] test test_spec_shape_types_member ... ok
[INFO] [stdout] test test_spec_shape_types_number ... ok
[INFO] [stdout] test test_spec_shape_types_service ... ok
[INFO] [stdout] test test_spec_shape_types_resource ... ok
[INFO] [stdout] test test_spec_shape_types_operation ... ok
[INFO] [stdout] test test_spec_shape_types_set ... ok
[INFO] [stdout] test test_spec_shape_types_short ... ok
[INFO] [stdout] test test_spec_shape_types_structure ... ok
[INFO] [stdout] test test_spec_shape_types_simple_type ... ok
[INFO] [stdout] test test_spec_shape_types_string ... ok
[INFO] [stdout] test test_spec_shape_types_union ... ok
[INFO] [stdout] test test_spec_shape_types_timestamp ... ok
[INFO] [stdout] test test_spec_trait_attribute_1 ... ok
[INFO] [stdout] test test_spec_trait_attribute_5 ... ok
[INFO] [stdout] test test_spec_trait_attribute_7 ... ok
[INFO] [stdout] test test_spec_trait_attribute_3 ... ok
[INFO] [stdout] test test_spec_trait_attribute_2 ... ok
[INFO] [stdout] test test_spec_trait_attribute_4 ... ok
[INFO] [stdout] test test_spec_trait_attribute_8 ... ok
[INFO] [stdout] test test_spec_trait_attribute_6 ... 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.66s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/smithy_simple_parse_tests.rs (/opt/rustwide/target/debug/deps/smithy_simple_parse_tests-4cc6efbed940c941)
[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_traits_and_comments ... ok
[INFO] [stdout] test simple_shape_with_traits ... ok
[INFO] [stdout] test simple_shape_only ... 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_block_text ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.04s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/smithy_success_tests.rs (/opt/rustwide/target/debug/deps/smithy_success_tests-41f7cb7f7c0a6771)
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test test_mqtt_api_example ... ok
[INFO] [stdout] test test_motd_example ... ok
[INFO] [stdout] test test_weather_example ... ok
[INFO] [stdout] test test_waiters_example ... ok
[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.10s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/smithy_write_motd.rs (/opt/rustwide/target/debug/deps/smithy_write_motd-a1e3e3bd70d2279c)
[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.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/smithy_write_weather.rs (/opt/rustwide/target/debug/deps/smithy_write_weather-c08c1dda2319b89c)
[INFO] [stdout] 
[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] [stderr]    Doc-tests atelier_smithy
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test src/lib.rs - (line 16) ... ok
[INFO] [stdout] test src/lib.rs - (line 32) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 2.66s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "def113cc75f095c3e239a03255f1f6aa24b0b4a8b376be2661b60a315ec6050e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "def113cc75f095c3e239a03255f1f6aa24b0b4a8b376be2661b60a315ec6050e", kill_on_drop: false }`
[INFO] [stdout] def113cc75f095c3e239a03255f1f6aa24b0b4a8b376be2661b60a315ec6050e