[INFO] fetching crate graphitesql 0.0.14...
[INFO] testing graphitesql-0.0.14 against 1.98.0-beta.1 for beta-1.98-1
[INFO] extracting crate graphitesql 0.0.14 into /workspace/builds/worker-5-tc2/source
[INFO] started tweaking crates.io crate graphitesql 0.0.14
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate graphitesql 0.0.14
[INFO] tweaked toml for crates.io crate graphitesql 0.0.14 written to /workspace/builds/worker-5-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate graphitesql 0.0.14 on toolchain 1.98.0-beta.1
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.98.0-beta.1" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate graphitesql 0.0.14 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.98.0-beta.1" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,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" "-m" "1610612736" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:3d5ced03c013a94a2f102a4510f48a6e9184255caf5fd8244f58017bde7f5210" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 57c87d7e618edfbaffeba0f16da388b65fc8d98dc7d810e7912703144b533643
[INFO] running `Command { std: "docker" "start" "57c87d7e618edfbaffeba0f16da388b65fc8d98dc7d810e7912703144b533643", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "57c87d7e618edfbaffeba0f16da388b65fc8d98dc7d810e7912703144b533643", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-w" "/opt/rustwide/workdir" "--user" "0:0" "57c87d7e618edfbaffeba0f16da388b65fc8d98dc7d810e7912703144b533643" "/opt/rustwide/cargo-home/bin/cargo" "+1.98.0-beta.1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "57c87d7e618edfbaffeba0f16da388b65fc8d98dc7d810e7912703144b533643", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "57c87d7e618edfbaffeba0f16da388b65fc8d98dc7d810e7912703144b533643" "/opt/rustwide/cargo-home/bin/cargo" "+1.98.0-beta.1" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling graphitesql v0.0.14 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 26.76s
[INFO] running `Command { std: "docker" "inspect" "57c87d7e618edfbaffeba0f16da388b65fc8d98dc7d810e7912703144b533643", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "57c87d7e618edfbaffeba0f16da388b65fc8d98dc7d810e7912703144b533643" "/opt/rustwide/cargo-home/bin/cargo" "+1.98.0-beta.1" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling graphitesql v0.0.14 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 3m 57s
[INFO] running `Command { std: "docker" "inspect" "57c87d7e618edfbaffeba0f16da388b65fc8d98dc7d810e7912703144b533643", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "57c87d7e618edfbaffeba0f16da388b65fc8d98dc7d810e7912703144b533643" "/opt/rustwide/cargo-home/bin/cargo" "+1.98.0-beta.1" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.70s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/graphitesql-e5a517e15a2c34e3)
[INFO] [stdout] 
[INFO] [stdout] running 212 tests
[INFO] [stdout] test btree::page::tests::payload_split_no_overflow_when_small ... ok
[INFO] [stdout] test btree::page::tests::payload_split_overflow_for_large_table_leaf ... ok
[INFO] [stdout] test btree::ptrmap::tests::decode_rejects_bad_type ... ok
[INFO] [stdout] test btree::ptrmap::tests::encode_layout_is_type_then_be_parent ... ok
[INFO] [stdout] test btree::ptrmap::tests::entries_per_page_matches_spec ... ok
[INFO] [stdout] test btree::ptrmap::tests::entry_encode_decode_round_trip ... ok
[INFO] [stdout] test btree::ptrmap::tests::first_ptrmap_covers_run_then_recurs ... ok
[INFO] [stdout] test btree::ptrmap::tests::page1_and_page3_not_ptrmap ... ok
[INFO] [stdout] test btree::ptrmap::tests::page2_is_first_ptrmap_page ... ok
[INFO] [stdout] test btree::ptrmap::tests::page3_entry_lives_on_page2_at_offset_0 ... ok
[INFO] [stdout] test btree::ptrmap::tests::second_ptrmap_run ... ok
[INFO] [stdout] test btree::ptrmap::tests::straddling_a_ptrmap_boundary ... ok
[INFO] [stdout] test btree::ptrmap::tests::type_byte_round_trip ... ok
[INFO] [stdout] test btree::ptrmap::tests::type_byte_values_match_sqlite ... ok
[INFO] [stdout] test btree::ptrmap::tests::unknown_type_byte_rejected ... ok
[INFO] [stdout] test btree::writer::tests::insert_and_scan_back_small ... ok
[INFO] [stdout] test btree::writer::tests::insert_with_overflow_payload ... ok
[INFO] [stdout] test exec::datetime::tests::basic_date ... ok
[INFO] [stdout] test exec::datetime::tests::modifiers ... ok
[INFO] [stdout] test exec::datetime::tests::now_returns_current_date ... ok
[INFO] [stdout] test exec::datetime::tests::null_propagation ... ok
[INFO] [stdout] test exec::datetime::tests::printf_basic ... ok
[INFO] [stdout] test exec::datetime::tests::strftime_codes ... ok
[INFO] [stdout] test exec::datetime::tests::timediff_basic ... ok
[INFO] [stdout] test exec::datetime::tests::unixepoch_modifier ... ok
[INFO] [stdout] test exec::eval::tests::comparison_class_order ... ok
[INFO] [stdout] test exec::eval::tests::concat_preserves_blob_bytes ... ok
[INFO] [stdout] test exec::eval::tests::like_and_glob ... ok
[INFO] [stdout] test exec::eval::tests::shift_and_negate_overflow_do_not_panic ... ok
[INFO] [stdout] test exec::eval::tests::real_formatting ... ok
[INFO] [stdout] test exec::fts5_index_route_tests::bare_term_boolean_tree_match_takes_index_route ... ok
[INFO] [stdout] test exec::fts5_index_route_tests::bare_term_match_takes_index_route ... ok
[INFO] [stdout] test exec::vdbe::tests::arithmetic_and_concat ... ok
[INFO] [stdout] test exec::vdbe::tests::bare_aggregate_join_compiles_and_bails_correctly ... ok
[INFO] [stdout] test exec::vdbe::tests::full_join_two_pass_null_pads_both_sides ... ok
[INFO] [stdout] test exec::vdbe::tests::group_by_join_compiles_and_bails_correctly ... ok
[INFO] [stdout] test exec::vdbe::tests::left_join_null_pads_unmatched_rows ... ok
[INFO] [stdout] test exec::vdbe::tests::nested_loop_join_bails_on_aggregate_and_order_by ... ok
[INFO] [stdout] test exec::vdbe::tests::nested_loop_join_two_cursors ... ok
[INFO] [stdout] test exec::vdbe::tests::rejects_unsupported ... ok
[INFO] [stdout] test format::header::tests::page_size_65536_uses_sentinel_one ... ok
[INFO] [stdout] test format::header::tests::parses_real_sqlite_header ... ok
[INFO] [stdout] test format::header::tests::rejects_bad_magic ... ok
[INFO] [stdout] test format::header::tests::rejects_bad_payload_fraction ... ok
[INFO] [stdout] test format::header::tests::rejects_non_power_of_two_page_size ... ok
[INFO] [stdout] test format::header::tests::round_trips_byte_for_byte ... ok
[INFO] [stdout] test format::record::tests::empty_record_decodes_to_no_columns ... ok
[INFO] [stdout] test format::record::tests::rejects_truncated_body ... ok
[INFO] [stdout] test format::record::tests::round_trip_mixed_values ... ok
[INFO] [stdout] test format::record::tests::three_and_six_byte_ints_sign_extend ... ok
[INFO] [stdout] test fts5_index::tests::decode_doclist_spanning_leaves ... ok
[INFO] [stdout] test fts5_index::tests::decode_doclist_spanning_multi_position ... ok
[INFO] [stdout] test fts5_index::tests::decode_many_terms_one_leaf ... ok
[INFO] [stdout] test fts5_index::tests::decode_mixed_pagination_and_spanning ... ok
[INFO] [stdout] test fts5_index::tests::decode_multi_column_positions ... ok
[INFO] [stdout] test fts5_index::tests::decode_multi_doc_rowid_deltas ... ok
[INFO] [stdout] test fts5_index::tests::decode_multi_leaf_term_pagination ... ok
[INFO] [stdout] test fts5_index::tests::decode_prefix_compressed_terms ... ok
[INFO] [stdout] test fts5_index::tests::decode_single_term_single_doc ... ok
[INFO] [stdout] test fts5_index::tests::decode_term_multiple_positions_one_doc ... ok
[INFO] [stdout] test fts5_index::tests::delete_tombstone_in_poslist_bails ... ok
[INFO] [stdout] test fts5_index::tests::empty_table_structure_and_averages ... ok
[INFO] [stdout] test fts5_index::tests::lookup_bool_tree_empty_index_falls_back ... ok
[INFO] [stdout] test fts5_index::tests::lookup_bool_tree_n_operand_set_ops ... ok
[INFO] [stdout] test fts5_index::tests::lookup_near_empty_index_falls_back ... ok
[INFO] [stdout] test fts5_index::tests::lookup_near_rowids_distance_boundary ... ok
[INFO] [stdout] test fts5_index::tests::lookup_near_rowids_multi_leaf ... ok
[INFO] [stdout] test fts5_index::tests::lookup_near_rowids_requires_same_column ... ok
[INFO] [stdout] test fts5_index::tests::lookup_phrase_empty_index_falls_back ... ok
[INFO] [stdout] test fts5_index::tests::lookup_phrase_in_column_requires_same_column ... ok
[INFO] [stdout] test fts5_index::tests::lookup_phrase_k_column_boundary ... ok
[INFO] [stdout] test fts5_index::tests::lookup_phrase_k_consecutive_run ... ok
[INFO] [stdout] test fts5_index::tests::lookup_phrase_k_repeated_word ... ok
[INFO] [stdout] test fts5_index::tests::lookup_phrase_multi_leaf ... ok
[INFO] [stdout] test fts5_index::tests::lookup_phrase_repeated_word ... ok
[INFO] [stdout] test fts5_index::tests::lookup_phrase_rowids_adjacency ... ok
[INFO] [stdout] test fts5_index::tests::lookup_prefix_rowids_in_column_filters ... ok
[INFO] [stdout] test fts5_index::tests::lookup_prefix_rowids_multi_leaf ... ok
[INFO] [stdout] test fts5_index::tests::lookup_prefix_rowids_unions_matching_terms ... ok
[INFO] [stdout] test fts5_index::tests::lookup_rowids_empty_index_falls_back ... ok
[INFO] [stdout] test fts5_index::tests::lookup_rowids_in_column_filters_by_column ... ok
[INFO] [stdout] test fts5_index::tests::lookup_rowids_in_column_multi_leaf ... ok
[INFO] [stdout] test fts5_index::tests::lookup_rowids_multi_leaf_segment ... ok
[INFO] [stdout] test fts5_index::tests::lookup_rowids_single_segment_present_and_absent ... ok
[INFO] [stdout] test fts5_index::tests::multi_column_poslist_bytes ... ok
[INFO] [stdout] test fts5_index::tests::multiseg_bare_term_unions_across_segments_and_routes ... ok
[INFO] [stdout] test fts5_index::tests::multiseg_boolean_tree_bails_when_a_leaf_overlaps ... ok
[INFO] [stdout] test fts5_index::tests::multiseg_boolean_tree_merges_across_segments ... ok
[INFO] [stdout] test fts5_index::tests::multiseg_near_unions_across_segments_and_routes ... ok
[INFO] [stdout] test fts5_index::tests::multiseg_overlapping_docid_bails_to_scan ... ok
[INFO] [stdout] test fts5_index::tests::multiseg_phrase_cross_term_overlap_bails_to_scan ... ok
[INFO] [stdout] test fts5_index::tests::multiseg_phrase_in_column_across_segments ... ok
[INFO] [stdout] test fts5_index::tests::multiseg_phrase_overlapping_docid_bails_to_scan ... ok
[INFO] [stdout] test fts5_index::tests::multiseg_phrase_tombstone_bails_to_scan ... ok
[INFO] [stdout] test fts5_index::tests::multiseg_prefix_same_doc_two_terms_one_segment_is_not_overlap ... ok
[INFO] [stdout] test fts5_index::tests::multiseg_prefix_unions_across_segments ... ok
[INFO] [stdout] test fts5_index::tests::multiseg_three_term_phrase_across_segments ... ok
[INFO] [stdout] test fts5_index::tests::multiseg_two_term_phrase_unions_across_segments_and_routes ... ok
[INFO] [stdout] test fts5_index::tests::single_term_single_doc_matches_known_bytes ... ok
[INFO] [stdout] test pager::pcache::tests::capacity_is_at_least_one ... ok
[INFO] [stdout] test pager::pcache::tests::evicts_least_recently_used ... ok
[INFO] [stdout] test pager::pcache::tests::invalidate_and_clear ... ok
[INFO] [stdout] test pager::pcache::tests::negative_cache_size_is_kib_of_memory ... ok
[INFO] [stdout] test pager::pcache::tests::never_exceeds_capacity ... ok
[INFO] [stdout] test pager::pcache::tests::positive_cache_size_is_a_page_count ... ok
[INFO] [stdout] test pager::pcache::tests::refresh_does_not_grow_or_evict ... ok
[INFO] [stdout] test pager::pcache::tests::shrinking_capacity_evicts_immediately ... ok
[INFO] [stdout] test pager::tests::caching_returns_shared_bytes ... ok
[INFO] [stdout] test pager::tests::opens_and_reports_geometry ... ok
[INFO] [stdout] test pager::tests::out_of_range_pages_error ... ok
[INFO] [stdout] test pager::tests::page1_body_offset_and_content ... ok
[INFO] [stdout] test pager::write::tests::allocate_and_readback ... ok
[INFO] [stdout] test pager::write::tests::auto_vacuum_header_bytes_match_sqlite ... ok
[INFO] [stdout] test pager::write::tests::create_yields_valid_empty_db ... ok
[INFO] [stdout] test pager::write::tests::journal_recovery_restores_originals ... ok
[INFO] [stdout] test pager::write::tests::multi_segment_journal_recovery ... ok
[INFO] [stdout] test pager::write::tests::rollback_discards_overlay ... ok
[INFO] [stdout] test sql::parser::tests::create_table_and_index ... ok
[INFO] [stdout] test sql::parser::tests::create_table_full_constraint_grammar ... ok
[INFO] [stdout] test sql::parser::tests::create_table_with_table_constraint ... ok
[INFO] [stdout] test sql::parser::tests::create_virtual_table ... ok
[INFO] [stdout] test sql::parser::tests::drop_and_tx_and_pragma ... ok
[INFO] [stdout] test sql::parser::tests::expression_precedence ... ok
[INFO] [stdout] test sql::parser::tests::functions_and_case_and_cast ... ok
[INFO] [stdout] test sql::parser::tests::in_between_is_null_like ... ok
[INFO] [stdout] test sql::parser::tests::insert_forms ... ok
[INFO] [stdout] test sql::parser::tests::multiple_statements ... ok
[INFO] [stdout] test sql::parser::tests::rejects_garbage ... ok
[INFO] [stdout] test sql::parser::tests::select_star ... ok
[INFO] [stdout] test sql::parser::tests::simple_select ... ok
[INFO] [stdout] test sql::parser::tests::update_delete ... ok
[INFO] [stdout] test sql::print::tests::create_table_reparses ... ok
[INFO] [stdout] test sql::token::tests::comments_are_skipped ... ok
[INFO] [stdout] test sql::token::tests::keywords_and_identifiers_are_words ... ok
[INFO] [stdout] test sql::token::tests::number_followed_by_identifier_is_rejected ... ok
[INFO] [stdout] test sql::token::tests::numbers ... ok
[INFO] [stdout] test sql::token::tests::operators ... ok
[INFO] [stdout] test sql::token::tests::parameters ... ok
[INFO] [stdout] test sql::token::tests::quoted_identifiers ... ok
[INFO] [stdout] test sql::token::tests::strings_and_blobs ... ok
[INFO] [stdout] test sql::token::tests::unterminated_string_errors ... ok
[INFO] [stdout] test sql::token::tests::utf8_identifier_preserved ... ok
[INFO] [stdout] test util::float::tests::atan2_signed_zero ... ok
[INFO] [stdout] test util::float::tests::basics ... ok
[INFO] [stdout] test util::float::tests::exp_overflow_underflow ... ok
[INFO] [stdout] test exec::fts5_index_route_tests::column_scoped_bare_term_match_takes_index_route ... FAILED
[INFO] [stdout] test util::float::tests::ln_domain_is_nan ... ok
[INFO] [stdout] test util::float::tests::pow_edges ... ok
[INFO] [stdout] test util::float::tests::sqrt_correctly_rounded ... ok
[INFO] [stdout] test util::float::tests::transcendental ... ok
[INFO] [stdout] test util::varint::tests::decode_rejects_truncated ... ok
[INFO] [stdout] test util::varint::tests::decode_stops_at_first_terminator ... ok
[INFO] [stdout] test util::varint::tests::known_encodings ... ok
[INFO] [stdout] test util::varint::tests::lengths_are_correct ... ok
[INFO] [stdout] test util::varint::tests::round_trips_boundaries ... ok
[INFO] [stdout] test util::varint::tests::signed_round_trip ... ok
[INFO] [stdout] test value::tests::content_lengths ... ok
[INFO] [stdout] test value::tests::serial_type_selection_matches_sqlite ... ok
[INFO] [stdout] test value::tests::value_ref_round_trips ... ok
[INFO] [stdout] test vfs::lock_tests::exclusive_requires_other_readers_to_drain ... ok
[INFO] [stdout] test vfs::lock_tests::many_readers_coexist ... ok
[INFO] [stdout] test vfs::lock_tests::pending_blocks_new_readers ... ok
[INFO] [stdout] test vfs::lock_tests::release_clears_all_held_levels ... ok
[INFO] [stdout] test vfs::lock_tests::reserved_coexists_with_readers_but_is_exclusive_among_writers ... ok
[INFO] [stdout] test vfs::memory::tests::create_write_reopen_roundtrip ... ok
[INFO] [stdout] test vfs::memory::tests::delete_removes_file ... ok
[INFO] [stdout] test vfs::memory::tests::open_missing_without_create_fails ... ok
[INFO] [stdout] test vfs::memory::tests::read_past_end_errors ... ok
[INFO] [stdout] test vfs::memory::tests::write_extends_with_zero_fill ... ok
[INFO] [stdout] test vfs::std_file::tests::open_missing_readonly_errors ... ok
[INFO] [stdout] test vfs::std_file::tests::write_read_truncate_roundtrip ... ok
[INFO] [stdout] test vtab::tests::advance_to_aligns_to_grid ... ok
[INFO] [stdout] test vtab::tests::best_index_pushes_value_constraints ... ok
[INFO] [stdout] test vtab::tests::connect_declares_value_column ... ok
[INFO] [stdout] test vtab::tests::connect_validates_arguments ... ok
[INFO] [stdout] test vtab::tests::cursor_iterates_ascending ... ok
[INFO] [stdout] test vtab::tests::cursor_iterates_descending ... ok
[INFO] [stdout] test vtab::tests::cursor_iterates_with_step ... ok
[INFO] [stdout] test vtab::tests::default_best_index_is_a_full_scan_plan ... ok
[INFO] [stdout] test vtab::tests::dyn_cursor_yields_rows ... ok
[INFO] [stdout] test vtab::tests::dyn_module_end_to_end ... ok
[INFO] [stdout] test vtab::tests::empty_range_yields_no_rows ... ok
[INFO] [stdout] test vtab::tests::filter_equality_stays_on_grid ... ok
[INFO] [stdout] test vtab::tests::filter_narrows_generation ... ok
[INFO] [stdout] test vtab::tests::fts5_anchor_requires_first_token ... ok
[INFO] [stdout] test vtab::tests::fts5_bm25_matches_sqlite ... ok
[INFO] [stdout] test vtab::tests::fts5_boolean_operators_and_precedence ... ok
[INFO] [stdout] test vtab::tests::fts5_column_filters_scope_tokens ... ok
[INFO] [stdout] test vtab::tests::fts5_column_name_skips_options_and_modifiers ... ok
[INFO] [stdout] test vtab::tests::fts5_highlight_wraps_matched_tokens ... ok
[INFO] [stdout] test vtab::tests::fts5_near_proximity_groups ... ok
[INFO] [stdout] test vtab::tests::fts5_phrase_and_prefix_queries ... ok
[INFO] [stdout] test vtab::tests::fts5_phrase_recognizer_shapes ... ok
[INFO] [stdout] test vtab::tests::fts5_phrase_recognizer_stems ... ok
[INFO] [stdout] test vtab::tests::fts5_porter_stem_matches_reference ... ok
[INFO] [stdout] test vtab::tests::fts5_prefix_term_recognizer_shapes ... ok
[INFO] [stdout] test vtab::tests::fts5_prefix_term_recognizer_stems ... ok
[INFO] [stdout] test vtab::tests::fts5_query_matches_are_token_anded ... ok
[INFO] [stdout] test vtab::tests::fts5_tok_config_parses_tokenize_option ... ok
[INFO] [stdout] test util::float::tests::fmod_is_overflow_free ... ok
[INFO] [stdout] test vtab::tests::fts5_tokenizer_splits_and_folds ... ok
[INFO] [stdout] test vtab::tests::registry_register_get_roundtrip ... ok
[INFO] [stdout] test vtab::tests::registry_rejects_duplicate_names ... ok
[INFO] [stdout] test vtab::tests::registry_unregister ... ok
[INFO] [stdout] test vtab::tests::step_zero_is_rejected ... ok
[INFO] [stdout] test vtab::tests::next_keeps_returning_none_after_end ... ok
[INFO] [stdout] test exec::fts5_index_route_tests::non_bare_shapes_stay_on_scan ... ok
[INFO] [stdout] test btree::writer::tests::insert_many_forces_splits ... ok
[INFO] [stdout] test exec::fts5_index_route_tests::k_term_phrase_match_takes_index_route ... ok
[INFO] [stdout] test exec::fts5_index_route_tests::prefix_term_match_takes_index_route ... ok
[INFO] [stdout] test exec::fts5_index_route_tests::two_term_near_match_takes_index_route ... ok
[INFO] [stdout] test exec::fts5_index_route_tests::two_term_phrase_match_takes_index_route ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- exec::fts5_index_route_tests::column_scoped_bare_term_match_takes_index_route stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'exec::fts5_index_route_tests::column_scoped_bare_term_match_takes_index_route' (8436) panicked at src/exec/mod.rs:34716:9:
[INFO] [stdout] assertion `left == right` failed: unknown-column filter must stay on the scan
[INFO] [stdout]   left: 119
[INFO] [stdout]  right: 116
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5a7a49cfc071 - std[73adb7dc35730857]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5a7a49cfc071 - std[73adb7dc35730857]::backtrace_rs::backtrace::trace_unsynchronized::<std[73adb7dc35730857]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5a7a49cfc071 - std[73adb7dc35730857]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5a7a49cfc071 - <<std[73adb7dc35730857]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[6883ba1bc0fe4ed1]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5a7a49d115ea - <core[6883ba1bc0fe4ed1]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5a7a49d115ea - core[6883ba1bc0fe4ed1]::fmt::write
[INFO] [stdout]    6:     0x5a7a49d0061c - std[73adb7dc35730857]::io::default_write_fmt::<alloc[55a36b64bcbf2c0d]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/io/mod.rs:626:11
[INFO] [stdout]    7:     0x5a7a49d0061c - <alloc[55a36b64bcbf2c0d]::vec::Vec<u8> as std[73adb7dc35730857]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/io/mod.rs:1730:13
[INFO] [stdout]    8:     0x5a7a49cda316 - <std[73adb7dc35730857]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5a7a49cda316 - std[73adb7dc35730857]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5a7a49cf41b9 - std[73adb7dc35730857]::panicking::default_hook
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5a7a49c8ed20 - <alloc[55a36b64bcbf2c0d]::boxed::Box<dyn for<'a, 'b> core[6883ba1bc0fe4ed1]::ops::function::Fn<(&'a std[73adb7dc35730857]::panic::PanicHookInfo<'b>,), Output = ()> + core[6883ba1bc0fe4ed1]::marker::Send + core[6883ba1bc0fe4ed1]::marker::Sync> as core[6883ba1bc0fe4ed1]::ops::function::Fn<(&std[73adb7dc35730857]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/alloc/src/boxed.rs:2333:9
[INFO] [stdout]   12:     0x5a7a49c8ed20 - test[980ffaebd391d06d]::test_main_inner::<test[980ffaebd391d06d]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x5a7a49cf4372 - <alloc[55a36b64bcbf2c0d]::boxed::Box<dyn for<'a, 'b> core[6883ba1bc0fe4ed1]::ops::function::Fn<(&'a std[73adb7dc35730857]::panic::PanicHookInfo<'b>,), Output = ()> + core[6883ba1bc0fe4ed1]::marker::Send + core[6883ba1bc0fe4ed1]::marker::Sync> as core[6883ba1bc0fe4ed1]::ops::function::Fn<(&std[73adb7dc35730857]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/alloc/src/boxed.rs:2333:9
[INFO] [stdout]   14:     0x5a7a49cf4372 - std[73adb7dc35730857]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panicking.rs:823:13
[INFO] [stdout]   15:     0x5a7a49cda3c2 - std[73adb7dc35730857]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panicking.rs:688:13
[INFO] [stdout]   16:     0x5a7a49cd1c79 - std[73adb7dc35730857]::sys::backtrace::__rust_end_short_backtrace::<std[73adb7dc35730857]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5a7a49cdafbd - __rustc[a7b7b02e776dd976]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panicking.rs:679:5
[INFO] [stdout]   18:     0x5a7a49d11dec - core[6883ba1bc0fe4ed1]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5a7a49d11d03 - core[6883ba1bc0fe4ed1]::panicking::assert_failed_inner
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/core/src/panicking.rs:434:23
[INFO] [stdout]   20:     0x5a7a49d0cf5d - core[6883ba1bc0fe4ed1]::panicking::assert_failed::<usize, usize>
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/core/src/panicking.rs:394:5
[INFO] [stdout]   21:     0x5a7a49bcb333 - graphitesql[62ef8b23e571a9e0]::exec::fts5_index_route_tests::column_scoped_bare_term_match_takes_index_route
[INFO] [stdout]                                at /opt/rustwide/workdir/src/exec/mod.rs:34716:9
[INFO] [stdout]   22:     0x5a7a49b8aae7 - graphitesql[62ef8b23e571a9e0]::exec::fts5_index_route_tests::column_scoped_bare_term_match_takes_index_route::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/src/exec/mod.rs:34647:57
[INFO] [stdout]   23:     0x5a7a4994ce86 - <graphitesql[62ef8b23e571a9e0]::exec::fts5_index_route_tests::column_scoped_bare_term_match_takes_index_route::{closure#0} as core[6883ba1bc0fe4ed1]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x5a7a49c8205b - <fn() -> core[6883ba1bc0fe4ed1]::result::Result<(), alloc[55a36b64bcbf2c0d]::string::String> as core[6883ba1bc0fe4ed1]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x5a7a49c8205b - test[980ffaebd391d06d]::__rust_begin_short_backtrace::<core[6883ba1bc0fe4ed1]::result::Result<(), alloc[55a36b64bcbf2c0d]::string::String>, fn() -> core[6883ba1bc0fe4ed1]::result::Result<(), alloc[55a36b64bcbf2c0d]::string::String>>
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/test/src/lib.rs:724:18
[INFO] [stdout]   26:     0x5a7a49c8f6a5 - test[980ffaebd391d06d]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/test/src/lib.rs:747:74
[INFO] [stdout]   27:     0x5a7a49c8f6a5 - <core[6883ba1bc0fe4ed1]::panic::unwind_safe::AssertUnwindSafe<test[980ffaebd391d06d]::run_test_in_process::{closure#0}> as core[6883ba1bc0fe4ed1]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   28:     0x5a7a49c8f6a5 - std[73adb7dc35730857]::panicking::catch_unwind::do_call::<core[6883ba1bc0fe4ed1]::panic::unwind_safe::AssertUnwindSafe<test[980ffaebd391d06d]::run_test_in_process::{closure#0}>, core[6883ba1bc0fe4ed1]::result::Result<(), alloc[55a36b64bcbf2c0d]::string::String>>
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panicking.rs:576:43
[INFO] [stdout]   29:     0x5a7a49c8f6a5 - std[73adb7dc35730857]::panicking::catch_unwind::<core[6883ba1bc0fe4ed1]::result::Result<(), alloc[55a36b64bcbf2c0d]::string::String>, core[6883ba1bc0fe4ed1]::panic::unwind_safe::AssertUnwindSafe<test[980ffaebd391d06d]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panicking.rs:544:19
[INFO] [stdout]   30:     0x5a7a49c8f6a5 - std[73adb7dc35730857]::panic::catch_unwind::<core[6883ba1bc0fe4ed1]::panic::unwind_safe::AssertUnwindSafe<test[980ffaebd391d06d]::run_test_in_process::{closure#0}>, core[6883ba1bc0fe4ed1]::result::Result<(), alloc[55a36b64bcbf2c0d]::string::String>>
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panic.rs:359:14
[INFO] [stdout]   31:     0x5a7a49c8f6a5 - test[980ffaebd391d06d]::run_test_in_process
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/test/src/lib.rs:747:27
[INFO] [stdout]   32:     0x5a7a49c8f6a5 - test[980ffaebd391d06d]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/test/src/lib.rs:668:43
[INFO] [stdout]   33:     0x5a7a49c8a154 - test[980ffaebd391d06d]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/test/src/lib.rs:698:41
[INFO] [stdout]   34:     0x5a7a49c8a154 - std[73adb7dc35730857]::sys::backtrace::__rust_begin_short_backtrace::<test[980ffaebd391d06d]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   35:     0x5a7a49c927f2 - std[73adb7dc35730857]::thread::lifecycle::spawn_unchecked::<test[980ffaebd391d06d]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   36:     0x5a7a49c927f2 - <core[6883ba1bc0fe4ed1]::panic::unwind_safe::AssertUnwindSafe<std[73adb7dc35730857]::thread::lifecycle::spawn_unchecked<test[980ffaebd391d06d]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[6883ba1bc0fe4ed1]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   37:     0x5a7a49c927f2 - std[73adb7dc35730857]::panicking::catch_unwind::do_call::<core[6883ba1bc0fe4ed1]::panic::unwind_safe::AssertUnwindSafe<std[73adb7dc35730857]::thread::lifecycle::spawn_unchecked<test[980ffaebd391d06d]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panicking.rs:576:43
[INFO] [stdout]   38:     0x5a7a49c927f2 - std[73adb7dc35730857]::panicking::catch_unwind::<(), core[6883ba1bc0fe4ed1]::panic::unwind_safe::AssertUnwindSafe<std[73adb7dc35730857]::thread::lifecycle::spawn_unchecked<test[980ffaebd391d06d]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panicking.rs:544:19
[INFO] [stdout]   39:     0x5a7a49c927f2 - std[73adb7dc35730857]::panic::catch_unwind::<core[6883ba1bc0fe4ed1]::panic::unwind_safe::AssertUnwindSafe<std[73adb7dc35730857]::thread::lifecycle::spawn_unchecked<test[980ffaebd391d06d]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/panic.rs:359:14
[INFO] [stdout]   40:     0x5a7a49c927f2 - std[73adb7dc35730857]::thread::lifecycle::spawn_unchecked::<test[980ffaebd391d06d]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   41:     0x5a7a49c927f2 - <std[73adb7dc35730857]::thread::lifecycle::spawn_unchecked<test[980ffaebd391d06d]::run_test::{closure#1}, ()>::{closure#1} as core[6883ba1bc0fe4ed1]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x5a7a49cfb8ff - <alloc[55a36b64bcbf2c0d]::boxed::Box<dyn core[6883ba1bc0fe4ed1]::ops::function::FnOnce<(), Output = ()> + core[6883ba1bc0fe4ed1]::marker::Send> as core[6883ba1bc0fe4ed1]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/alloc/src/boxed.rs:2319:9
[INFO] [stdout]   43:     0x5a7a49cfb8ff - <std[73adb7dc35730857]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/6b3fa26749ab40e159b2dd5cf577acaaf5902772/library/std/src/sys/thread/unix.rs:123:17
[INFO] [stdout]   44:     0x7d5b3df36aa4 - <unknown>
[INFO] [stdout]   45:     0x7d5b3dfc3a64 - clone
[INFO] [stdout]   46:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     exec::fts5_index_route_tests::column_scoped_bare_term_match_takes_index_route
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 211 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.62s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] running `Command { std: "docker" "inspect" "57c87d7e618edfbaffeba0f16da388b65fc8d98dc7d810e7912703144b533643", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "57c87d7e618edfbaffeba0f16da388b65fc8d98dc7d810e7912703144b533643", kill_on_drop: false }`
[INFO] [stdout] 57c87d7e618edfbaffeba0f16da388b65fc8d98dc7d810e7912703144b533643
