[INFO] fetching crate sqlformat 0.1.8...
[INFO] testing sqlformat-0.1.8 against 1.60.0 for beta-1.61-1
[INFO] extracting crate sqlformat 0.1.8 into /workspace/builds/worker-16/source
[INFO] validating manifest of crates.io crate sqlformat 0.1.8 on toolchain 1.60.0
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.60.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate sqlformat 0.1.8
[INFO] finished tweaking crates.io crate sqlformat 0.1.8
[INFO] tweaked toml for crates.io crate sqlformat 0.1.8 written to /workspace/builds/worker-16/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.60.0" "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" "+1.60.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-16/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-16/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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+1.60.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 1106074d819a2c43197f9c33df5edfc8110957ca3e14dcd14df9afaa758107a2
[INFO] running `Command { std: "docker" "start" "-a" "1106074d819a2c43197f9c33df5edfc8110957ca3e14dcd14df9afaa758107a2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "1106074d819a2c43197f9c33df5edfc8110957ca3e14dcd14df9afaa758107a2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "1106074d819a2c43197f9c33df5edfc8110957ca3e14dcd14df9afaa758107a2", kill_on_drop: false }`
[INFO] [stdout] 1106074d819a2c43197f9c33df5edfc8110957ca3e14dcd14df9afaa758107a2
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-16/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-16/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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+1.60.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 51e9a66847603f0703783558b81e55fed210ef0bc6837693280305c1a72acfb4
[INFO] running `Command { std: "docker" "start" "-a" "51e9a66847603f0703783558b81e55fed210ef0bc6837693280305c1a72acfb4", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling memchr v2.4.1
[INFO] [stderr]    Compiling either v1.6.1
[INFO] [stderr]    Compiling minimal-lexical v0.2.1
[INFO] [stderr]    Compiling unicode_categories v0.1.1
[INFO] [stderr]    Compiling itertools v0.10.3
[INFO] [stderr]    Compiling nom v7.1.1
[INFO] [stderr]    Compiling sqlformat v0.1.8 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 5.62s
[INFO] running `Command { std: "docker" "inspect" "51e9a66847603f0703783558b81e55fed210ef0bc6837693280305c1a72acfb4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "51e9a66847603f0703783558b81e55fed210ef0bc6837693280305c1a72acfb4", kill_on_drop: false }`
[INFO] [stdout] 51e9a66847603f0703783558b81e55fed210ef0bc6837693280305c1a72acfb4
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-16/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-16/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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+1.60.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 89ba7cdda41ec2b2c235b3adbede357caa617967baa9610860523bda950a068b
[INFO] running `Command { std: "docker" "start" "-a" "89ba7cdda41ec2b2c235b3adbede357caa617967baa9610860523bda950a068b", kill_on_drop: false }`
[INFO] [stderr]    Compiling semver v1.0.7
[INFO] [stderr]    Compiling serde v1.0.136
[INFO] [stderr]    Compiling crossbeam-utils v0.8.8
[INFO] [stderr]    Compiling rayon-core v1.9.1
[INFO] [stderr]    Compiling syn v1.0.91
[INFO] [stderr]    Compiling serde_json v1.0.79
[INFO] [stderr]    Compiling regex-automata v0.1.10
[INFO] [stderr]    Compiling serde_derive v1.0.136
[INFO] [stderr]    Compiling plotters-backend v0.3.2
[INFO] [stderr]    Compiling half v1.8.2
[INFO] [stderr]    Compiling regex-syntax v0.6.25
[INFO] [stderr]    Compiling itoa v0.4.8
[INFO] [stderr]    Compiling unindent v0.1.8
[INFO] [stderr]    Compiling oorandom v11.1.3
[INFO] [stderr]    Compiling memoffset v0.6.5
[INFO] [stderr]    Compiling crossbeam-epoch v0.9.8
[INFO] [stderr]    Compiling rayon v1.5.1
[INFO] [stderr]    Compiling clap v2.34.0
[INFO] [stderr]    Compiling num_cpus v1.13.1
[INFO] [stderr]    Compiling csv-core v0.1.10
[INFO] [stderr]    Compiling atty v0.2.14
[INFO] [stderr]    Compiling plotters-svg v0.3.1
[INFO] [stderr]    Compiling indoc v1.0.4
[INFO] [stderr]    Compiling plotters v0.3.1
[INFO] [stderr]    Compiling rustc_version v0.4.0
[INFO] [stderr]    Compiling crossbeam-channel v0.5.4
[INFO] [stderr]    Compiling crossbeam-deque v0.8.1
[INFO] [stderr]    Compiling cast v0.2.7
[INFO] [stderr]    Compiling regex v1.5.5
[INFO] [stderr]    Compiling criterion-plot v0.4.4
[INFO] [stderr]    Compiling bstr v0.2.17
[INFO] [stderr]    Compiling serde_cbor v0.11.2
[INFO] [stderr]    Compiling csv v1.1.6
[INFO] [stderr]    Compiling tinytemplate v1.2.1
[INFO] [stderr]    Compiling criterion v0.3.5
[INFO] [stderr]    Compiling sqlformat v0.1.8 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 15.71s
[INFO] running `Command { std: "docker" "inspect" "89ba7cdda41ec2b2c235b3adbede357caa617967baa9610860523bda950a068b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "89ba7cdda41ec2b2c235b3adbede357caa617967baa9610860523bda950a068b", kill_on_drop: false }`
[INFO] [stdout] 89ba7cdda41ec2b2c235b3adbede357caa617967baa9610860523bda950a068b
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-16/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-16/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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+1.60.0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] c50db5c06280f10a20b030ee44dbb814f98c023a0729a52ac8fed1cf8db6c3bc
[INFO] running `Command { std: "docker" "start" "-a" "c50db5c06280f10a20b030ee44dbb814f98c023a0729a52ac8fed1cf8db6c3bc", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.04s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/sqlformat-2f6c8330a42b68c2)
[INFO] [stdout] 
[INFO] [stdout] running 73 tests
[INFO] [stdout] test tests::it_converts_keywords_to_uppercase_when_option_passed_in ... ok
[INFO] [stdout] test tests::it_formats_alter_table_modify_query ... ok
[INFO] [stdout] test tests::it_formats_alter_table_alter_column_query ... ok
[INFO] [stdout] test tests::it_correctly_indents_create_statement_after_select ... ok
[INFO] [stdout] test tests::it_formats_and_or_operators ... ok
[INFO] [stdout] test tests::it_formats_fetch_first_like_limit ... ok
[INFO] [stdout] test tests::it_formats_case_when_inside_select ... ok
[INFO] [stdout] test tests::it_formats_incomplete_query ... ok
[INFO] [stdout] test tests::it_formats_case_when_with_an_expression ... ok
[INFO] [stdout] test tests::it_breaks_long_parenthesized_lists_to_multiple_lines ... ok
[INFO] [stdout] test tests::it_formats_case_when_with_a_blank_expression ... ok
[INFO] [stdout] test tests::it_formats_limit_of_single_value_and_offset ... ok
[INFO] [stdout] test tests::it_formats_line_comments_followed_by_open_paren ... ok
[INFO] [stdout] test tests::it_formats_insert_without_into ... ok
[INFO] [stdout] test tests::it_formats_line_comments_followed_by_close_paren ... ok
[INFO] [stdout] test tests::it_formats_complex_select ... ok
[INFO] [stdout] test tests::it_formats_limit_with_two_comma_separated_values_on_single_line ... ok
[INFO] [stdout] test tests::it_formats_line_comments_followed_by_semicolon ... ok
[INFO] [stdout] test tests::it_formats_limit_of_single_value_followed_by_another_select_using_commas ... ok
[INFO] [stdout] test tests::it_formats_line_comments_followed_by_comma ... ok
[INFO] [stdout] test tests::it_formats_lonely_semicolon ... ok
[INFO] [stdout] test tests::it_formats_long_double_parenthesized_queries_to_multiple_lines ... ok
[INFO] [stdout] test tests::it_formats_multibyte_chars ... ok
[INFO] [stdout] test tests::it_formats_logical_operators ... ok
[INFO] [stdout] test tests::it_formats_long_create_table ... ok
[INFO] [stdout] test tests::it_formats_select_query_with_cross_apply ... ok
[INFO] [stdout] test tests::it_formats_select_query_with_different_comments ... ok
[INFO] [stdout] test tests::it_formats_select_query_with_cross_join ... ok
[INFO] [stdout] test tests::it_formats_multi_char_operators ... ok
[INFO] [stdout] test tests::it_formats_postgres_specific_operators ... ok
[INFO] [stdout] test tests::it_formats_select_with_top_level_reserved_words ... ok
[INFO] [stdout] test tests::it_formats_query_that_ends_with_open_comment ... ok
[INFO] [stdout] test tests::it_formats_simple_delete_query ... ok
[INFO] [stdout] test tests::it_formats_select_with_complex_where ... ok
[INFO] [stdout] test tests::it_formats_query_with_go_batch_separator ... ok
[INFO] [stdout] test tests::it_formats_short_double_parenthesizes_queries_to_one_line ... ok
[INFO] [stdout] test tests::it_formats_select_query_with_outer_apply ... ok
[INFO] [stdout] test tests::it_formats_short_create_table ... ok
[INFO] [stdout] test tests::it_formats_select_query_with_inner_join ... ok
[INFO] [stdout] test tests::it_formats_simple_select ... ok
[INFO] [stdout] test tests::it_formats_simple_select_with_national_characters_mssql ... ok
[INFO] [stdout] test tests::it_formats_select_query_with_select_query_inside_it ... ok
[INFO] [stdout] test tests::it_formats_simple_insert_query ... ok
[INFO] [stdout] test tests::it_keeps_separation_between_multiple_statements ... ok
[INFO] [stdout] test tests::it_formats_simple_drop_query ... ok
[INFO] [stdout] test tests::it_formats_top_level_and_newline_multi_word_reserved_words_with_inconsistent_spacing ... ok
[INFO] [stdout] test tests::it_ignores_words_case_and_end_inside_other_strings ... ok
[INFO] [stdout] test tests::it_maintains_block_comment_indentation ... ok
[INFO] [stdout] test tests::it_recognizes_at_variables ... ok
[INFO] [stdout] test tests::it_line_breaks_between_queries_with_config ... ok
[INFO] [stdout] test tests::it_preserves_case_of_keywords ... ok
[INFO] [stdout] test tests::it_keeps_short_parenthesized_list_with_nested_parenthesis_on_single_line ... ok
[INFO] [stdout] test tests::it_recognizes_colon_variables ... ok
[INFO] [stdout] test tests::it_formats_single_char_operators ... ok
[INFO] [stdout] test tests::it_recognizes_question_indexed_placeholders_with_param_values ... ok
[INFO] [stdout] test tests::it_recognizes_limit_in_lowercase ... ok
[INFO] [stdout] test tests::it_recognizes_lowercase_case_end ... ok
[INFO] [stdout] test tests::it_recognizes_question_numbered_placeholders_with_param_values ... ok
[INFO] [stdout] test tests::it_formats_simple_set_schema_queries ... ok
[INFO] [stdout] test tests::it_recognizes_dollar_sign_numbered_placeholders ... ok
[INFO] [stdout] test tests::it_recognizes_dollar_sign_numbered_placeholders_with_param_values ... ok
[INFO] [stdout] test tests::it_recognizes_bracketed_strings ... ok
[INFO] [stdout] test tests::it_formats_tricky_line_comments ... ok
[INFO] [stdout] test tests::it_recognizes_question_numbered_placeholders ... ok
[INFO] [stdout] test tests::it_recognizes_at_variables_with_param_values ... ok
[INFO] [stdout] test tests::it_recognizes_escaped_strings ... ok
[INFO] [stdout] test tests::it_recognizes_strings ... ok
[INFO] [stdout] test tests::it_recognizes_colon_variables_with_param_values ... ok
[INFO] [stderr]    Doc-tests sqlformat
[INFO] [stdout] test tests::it_formats_simple_update_query ... ok
[INFO] [stdout] test tests::it_formats_simple_select_query ... ok
[INFO] [stdout] test tests::it_formats_update_query_with_as_part ... ok
[INFO] [stdout] test tests::it_formats_unicode_correctly ... ok
[INFO] [stdout] test tests::it_uses_given_indent_config_for_indentation ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 73 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] running `Command { std: "docker" "inspect" "c50db5c06280f10a20b030ee44dbb814f98c023a0729a52ac8fed1cf8db6c3bc", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c50db5c06280f10a20b030ee44dbb814f98c023a0729a52ac8fed1cf8db6c3bc", kill_on_drop: false }`
[INFO] [stdout] c50db5c06280f10a20b030ee44dbb814f98c023a0729a52ac8fed1cf8db6c3bc