[INFO] fetching crate sekejap-dist 0.19.3...
[INFO] testing sekejap-dist-0.19.3 against 1.100.0-beta.1 for beta-1.100-2
[INFO] extracting crate sekejap-dist 0.19.3 into /workspace/builds/worker-7-tc2/source
[INFO] started tweaking crates.io crate sekejap-dist 0.19.3
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate sekejap-dist 0.19.3
[INFO] tweaked toml for crates.io crate sekejap-dist 0.19.3 written to /workspace/builds/worker-7-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate sekejap-dist 0.19.3 on toolchain 1.100.0-beta.1
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.100.0-beta.1" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate sekejap-dist 0.19.3 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.100.0-beta.1" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr] warning: `package.homepage` is redundant with `package.repository`
[INFO] [stderr]    --> Cargo.toml:95:12
[INFO] [stderr]     |
[INFO] [stderr]  95 | homepage = "https://github.com/sekejapdb/sekejap"
[INFO] [stderr]     |            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] ...
[INFO] [stderr] 100 | repository = "https://github.com/sekejapdb/sekejap"
[INFO] [stderr]     |              --------------------------------------
[INFO] [stderr]     |
[INFO] [stderr]     = note: `cargo::redundant_homepage` is set to `warn` by default
[INFO] [stderr] help: consider removing `package.homepage`
[INFO] [stderr] warning: `sekejap-dist` (manifest) generated 1 warning
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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:3111399a4047eeb3a02b7a90e478d715f38a8c6669b5c4b49d30a17385265909" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] e17314c2d0be4c1a0e8e97eef8beecef2f55624585254a3dc38c5ed705c47db1
[INFO] running `Command { std: "docker" "start" "e17314c2d0be4c1a0e8e97eef8beecef2f55624585254a3dc38c5ed705c47db1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "e17314c2d0be4c1a0e8e97eef8beecef2f55624585254a3dc38c5ed705c47db1", 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" "e17314c2d0be4c1a0e8e97eef8beecef2f55624585254a3dc38c5ed705c47db1" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "e17314c2d0be4c1a0e8e97eef8beecef2f55624585254a3dc38c5ed705c47db1", 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" "e17314c2d0be4c1a0e8e97eef8beecef2f55624585254a3dc38c5ed705c47db1" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr] warning: `package.homepage` is redundant with `package.repository`
[INFO] [stderr]    --> Cargo.toml:95:12
[INFO] [stderr]     |
[INFO] [stderr]  95 | homepage = "https://github.com/sekejapdb/sekejap"
[INFO] [stderr]     |            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] ...
[INFO] [stderr] 100 | repository = "https://github.com/sekejapdb/sekejap"
[INFO] [stderr]     |              --------------------------------------
[INFO] [stderr]     |
[INFO] [stderr]     = note: `cargo::redundant_homepage` is set to `warn` by default
[INFO] [stderr] help: consider removing `package.homepage`
[INFO] [stderr] warning: `sekejap-dist` (manifest) generated 1 warning
[INFO] [stderr]    Compiling serde_core v1.0.229
[INFO] [stderr]    Compiling bitflags v2.13.1
[INFO] [stderr]    Compiling serde_json v1.0.151
[INFO] [stderr]    Compiling byteorder v1.5.0
[INFO] [stderr]    Compiling base64 v0.22.1
[INFO] [stderr]    Compiling inout v0.1.4
[INFO] [stderr]    Compiling getrandom v0.4.3
[INFO] [stderr]    Compiling geographiclib-rs v0.2.7
[INFO] [stderr]    Compiling getrandom v0.2.17
[INFO] [stderr]    Compiling digest v0.10.7
[INFO] [stderr]    Compiling cipher v0.4.4
[INFO] [stderr]    Compiling rustix v1.1.4
[INFO] [stderr]    Compiling hmac v0.12.1
[INFO] [stderr]    Compiling md-5 v0.10.6
[INFO] [stderr]    Compiling sha2 v0.10.9
[INFO] [stderr]    Compiling sha1 v0.10.7
[INFO] [stderr]    Compiling blowfish v0.9.1
[INFO] [stderr]    Compiling bcrypt v0.15.1
[INFO] [stderr]    Compiling tempfile v3.27.0
[INFO] [stderr]    Compiling sekejap-kernel v0.19.3
[INFO] [stderr]    Compiling sekejap-core v0.19.3
[INFO] [stderr]    Compiling sekejap-lang v0.19.3
[INFO] [stderr]    Compiling sekejap-dist v0.19.3 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 42.21s
[INFO] running `Command { std: "docker" "inspect" "e17314c2d0be4c1a0e8e97eef8beecef2f55624585254a3dc38c5ed705c47db1", 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" "e17314c2d0be4c1a0e8e97eef8beecef2f55624585254a3dc38c5ed705c47db1" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr] warning: `package.homepage` is redundant with `package.repository`
[INFO] [stderr]    --> Cargo.toml:95:12
[INFO] [stderr]     |
[INFO] [stderr]  95 | homepage = "https://github.com/sekejapdb/sekejap"
[INFO] [stderr]     |            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] ...
[INFO] [stderr] 100 | repository = "https://github.com/sekejapdb/sekejap"
[INFO] [stderr]     |              --------------------------------------
[INFO] [stderr]     |
[INFO] [stderr]     = note: `cargo::redundant_homepage` is set to `warn` by default
[INFO] [stderr] help: consider removing `package.homepage`
[INFO] [stderr] warning: `sekejap-dist` (manifest) generated 1 warning
[INFO] [stderr]    Compiling crypto-common v0.2.2
[INFO] [stderr]    Compiling tinyvec v1.13.3
[INFO] [stderr]    Compiling generic-array v0.14.7
[INFO] [stderr]    Compiling getrandom v0.4.3
[INFO] [stderr]    Compiling unicode-bidi v0.3.18
[INFO] [stderr]    Compiling unicode-properties v0.1.4
[INFO] [stderr]    Compiling smallvec v1.16.0
[INFO] [stderr]    Compiling fallible-iterator v0.2.0
[INFO] [stderr]    Compiling phf_shared v0.13.1
[INFO] [stderr]    Compiling tokio v1.53.1
[INFO] [stderr]    Compiling futures-task v0.3.34
[INFO] [stderr]    Compiling whoami v2.1.3
[INFO] [stderr]    Compiling syn v3.0.5
[INFO] [stderr]    Compiling futures-util v0.3.34
[INFO] [stderr]    Compiling tempfile v3.27.0
[INFO] [stderr]    Compiling rand v0.10.2
[INFO] [stderr]    Compiling phf v0.13.1
[INFO] [stderr]    Compiling parking_lot_core v0.9.12
[INFO] [stderr]    Compiling parking_lot v0.12.5
[INFO] [stderr]    Compiling sekejap-kernel v0.19.3
[INFO] [stderr]    Compiling unicode-normalization v0.1.25
[INFO] [stderr]    Compiling stringprep v0.1.5
[INFO] [stderr]    Compiling digest v0.11.3
[INFO] [stderr]    Compiling hmac v0.13.0
[INFO] [stderr]    Compiling md-5 v0.11.0
[INFO] [stderr]    Compiling sha2 v0.11.0
[INFO] [stderr]    Compiling crypto-common v0.1.7
[INFO] [stderr]    Compiling block-buffer v0.10.4
[INFO] [stderr]    Compiling inout v0.1.4
[INFO] [stderr]    Compiling cipher v0.4.4
[INFO] [stderr]    Compiling digest v0.10.7
[INFO] [stderr]    Compiling blowfish v0.9.1
[INFO] [stderr]    Compiling bcrypt v0.15.1
[INFO] [stderr]    Compiling sha2 v0.10.9
[INFO] [stderr]    Compiling hmac v0.12.1
[INFO] [stderr]    Compiling sha1 v0.10.7
[INFO] [stderr]    Compiling md-5 v0.10.6
[INFO] [stderr]    Compiling postgres-protocol v0.6.12
[INFO] [stderr]    Compiling postgres-types v0.2.14
[INFO] [stderr]    Compiling sekejap-core v0.19.3
[INFO] [stderr]    Compiling async-trait v0.1.92
[INFO] [stderr]    Compiling tokio-util v0.7.19
[INFO] [stderr]    Compiling tokio-postgres v0.7.18
[INFO] [stderr]    Compiling postgres v0.19.14
[INFO] [stderr]    Compiling sekejap-lang v0.19.3
[INFO] [stderr]    Compiling sekejap-dist v0.19.3 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 42.98s
[INFO] running `Command { std: "docker" "inspect" "e17314c2d0be4c1a0e8e97eef8beecef2f55624585254a3dc38c5ed705c47db1", 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" "e17314c2d0be4c1a0e8e97eef8beecef2f55624585254a3dc38c5ed705c47db1" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr] warning: `package.homepage` is redundant with `package.repository`
[INFO] [stderr]    --> Cargo.toml:95:12
[INFO] [stderr]     |
[INFO] [stderr]  95 | homepage = "https://github.com/sekejapdb/sekejap"
[INFO] [stderr]     |            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] ...
[INFO] [stderr] 100 | repository = "https://github.com/sekejapdb/sekejap"
[INFO] [stderr]     |              --------------------------------------
[INFO] [stderr]     |
[INFO] [stderr]     = note: `cargo::redundant_homepage` is set to `warn` by default
[INFO] [stderr] help: consider removing `package.homepage`
[INFO] [stderr] warning: `sekejap-dist` (manifest) generated 1 warning
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.25s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/build/sekejap-dist/619133026726546a/out/sekejap_dist-619133026726546a)
[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] [stderr]      Running unittests src/cli/collection_inspect.rs (/opt/rustwide/target/debug/build/sekejap-dist/9eed737b4245ca29/out/collection_inspect-9eed737b4245ca29)
[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] [stderr]      Running unittests src/cli/control_tree_audit.rs (/opt/rustwide/target/debug/build/sekejap-dist/d7684ec48304d473/out/control_tree_audit-d7684ec48304d473)
[INFO] [stderr]      Running unittests src/cli/pagewal_repair.rs (/opt/rustwide/target/debug/build/sekejap-dist/88809e255cfcca5f/out/pagewal_repair-88809e255cfcca5f)
[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] [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] [stderr]      Running unittests src/cli/recover.rs (/opt/rustwide/target/debug/build/sekejap-dist/e71d7d7bc1d4f91f/out/recover-e71d7d7bc1d4f91f)
[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] [stderr]      Running unittests src/cli/pg_server.rs (/opt/rustwide/target/debug/build/sekejap-dist/05ac2c299b021bab/out/sekejap_pg-05ac2c299b021bab)
[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] [stderr]      Running unittests src/cli/upgrade.rs (/opt/rustwide/target/debug/build/sekejap-dist/dd60e6435dfa09de/out/sekejap_upgrade-dd60e6435dfa09de)
[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] [stderr]      Running tests/pg_param_bool.rs (/opt/rustwide/target/debug/build/sekejap-dist/b769c307570d0d8d/out/pg_param_bool-b769c307570d0d8d)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test bool_text_reads_as_postgresql_reads_it ... 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/pg_server.rs (/opt/rustwide/target/debug/build/sekejap-dist/2d9f67f01952d430/out/pg_server-2d9f67f01952d430)
[INFO] [stdout] 
[INFO] [stdout] running 10 tests
[INFO] [stdout] test psql_connects_and_runs_a_statement_when_psql_is_installed ... ok
[INFO] [stdout] test a_refused_construct_reaches_the_client_as_0a000_with_the_contracts_reason ... ok
[INFO] [stdout] test listen_delivers_a_notification_after_a_commit_made_on_another_connection ... ok
[INFO] [stdout] test the_dbeaver_connect_sequence_is_answered_and_its_catalog_half_answers_rows ... ok
[INFO] [stdout] test insert_returning_reaches_a_stock_client_as_typed_rows_with_the_insert_tag ... ok
[INFO] [stdout] test a_wire_transaction_rolls_back_or_commits_and_a_second_connection_sees_the_result ... ok
[INFO] [stdout] test a_stock_client_connects_creates_a_table_inserts_with_parameters_and_reads_typed_rows ... ok
[INFO] [stdout] test a_prepared_statement_is_reused_across_executions_and_answers_for_each_parameter ... ok
[INFO] [stdout] test a_cancel_from_a_second_client_stops_the_statement_in_flight_with_57014 has been running for over 60 seconds
[INFO] [stdout] test a_statement_timeout_reaches_the_client_as_57014 has been running for over 60 seconds
[INFO] [stdout] test a_statement_timeout_reaches_the_client_as_57014 ... ok
[INFO] [stdout] test a_cancel_from_a_second_client_stops_the_statement_in_flight_with_57014 ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 102.31s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/pg_wire.rs (/opt/rustwide/target/debug/build/sekejap-dist/72107918cc3f7a4c/out/pg_wire-72107918cc3f7a4c)
[INFO] [stdout] 
[INFO] [stdout] running 40 tests
[INFO] [stdout] test a_bytea_parameter_writes_a_shape_in_text_and_in_binary_format ... ok
[INFO] [stdout] test a_layer_in_a_named_schema_is_found_and_drawn_through_the_wire ... ok
[INFO] [stdout] test a_read_in_a_failed_transaction_block_is_refused_25p02_not_answered ... ok
[INFO] [stdout] test a_parameter_in_a_comment_is_not_a_parameter ... ok
[INFO] [stdout] test a_catalog_query_flows_through_to_the_catalog_views_and_answers_rows ... ok
[INFO] [stdout] test a_bind_that_claims_more_parameters_than_the_frame_holds_is_refused_not_believed ... ok
[INFO] [stdout] test a_client_issued_notify_is_refused_by_name_rather_than_emulated ... ok
[INFO] [stdout] test a_cancel_request_names_the_backend_it_wants_stopped_and_then_closes ... ok
[INFO] [stdout] test a_failed_transaction_block_refuses_a_read_over_the_extended_protocol_too ... ok
[INFO] [stdout] test a_multi_statement_query_runs_in_order_and_stops_at_the_first_error ... ok
[INFO] [stdout] test a_failed_autocommit_statement_leaves_nothing_behind ... ok
[INFO] [stdout] test a_cancelled_statement_arrives_as_57014 ... ok
[INFO] [stdout] test a_declared_cursor_fetches_forward_in_pages_and_then_closes ... ok
[INFO] [stdout] test a_declare_refused_by_cancellation_creates_no_cursor_and_leaves_others_untouched ... ok
[INFO] [stdout] test a_portal_with_a_row_limit_suspends_and_resumes_until_the_rows_run_out ... ok
[INFO] [stdout] test a_refused_construct_arrives_as_0a000_with_the_contracts_named_reason ... ok
[INFO] [stdout] test a_prepared_statement_is_rebound_with_new_parameters_without_being_parsed_again ... ok
[INFO] [stdout] test a_statement_over_a_collection_that_is_not_there_arrives_as_42p01 ... ok
[INFO] [stdout] test a_transaction_reads_its_own_writes ... ok
[INFO] [stdout] test a_truncated_describe_or_close_is_answered_not_a_panic ... ok
[INFO] [stdout] test a_transaction_block_reports_its_status_and_a_rollback_leaves_no_row ... ok
[INFO] [stdout] test a_simple_query_describes_its_columns_from_the_catalog_and_then_sends_the_rows ... ok
[INFO] [stdout] test a_statement_that_outruns_the_timeout_arrives_as_57014_with_the_elapsed_microseconds ... ok
[INFO] [stdout] test an_ssl_request_is_declined_with_one_byte_and_the_session_continues_in_plaintext ... ok
[INFO] [stdout] test an_extended_query_binds_a_declared_parameter_and_returns_the_row_it_names ... ok
[INFO] [stdout] test a_streamed_answer_reaches_the_sink_while_it_runs ... ok
[INFO] [stdout] test ddl_after_writes_in_a_block_is_refused ... ok
[INFO] [stdout] test an_untyped_text_parameter_takes_its_columns_type ... ok
[INFO] [stdout] test describing_a_write_portal_does_not_run_it ... ok
[INFO] [stdout] test st_asbinary_is_a_bytea_column_raw_in_binary_and_hex_in_text ... ok
[INFO] [stdout] test listen_delivers_one_notification_per_listening_channel_after_each_commit_and_none_before ... ok
[INFO] [stdout] test set_local_ef_search_lasts_for_its_transaction_block_on_the_wire ... ok
[INFO] [stdout] test the_canvas_query_answers_through_the_wire ... ok
[INFO] [stdout] test declaring_a_cursor_with_a_name_already_open_is_refused_and_leaves_it_untouched ... ok
[INFO] [stdout] test text_that_does_not_spell_a_statement_arrives_as_42601_at_parse_time ... ok
[INFO] [stdout] test the_fixed_session_rows_a_client_reads_at_connect_are_answered ... ok
[INFO] [stdout] test terminate_closes_the_session_and_rolls_back_a_transaction_still_open ... ok
[INFO] [stdout] test the_startup_exchange_hands_out_the_parameters_and_the_cancel_key_a_client_needs ... ok
[INFO] [stdout] test describing_a_read_portal_leaves_its_execute_streaming ... ok
[INFO] [stdout] test an_idle_reader_connection_does_not_stop_the_log_folding has been running for over 60 seconds
[INFO] [stdout] test an_idle_reader_connection_does_not_stop_the_log_folding ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 40 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 93.61s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/pg_wire_edge_tables.rs (/opt/rustwide/target/debug/build/sekejap-dist/d1b12dbc532b7114/out/pg_wire_edge_tables-d1b12dbc532b7114)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test a_read_of_one_ends_edges_comes_back_as_rows ... ok
[INFO] [stdout] test an_edge_write_the_data_refuses_carries_postgresqls_sqlstate ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 2.77s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/pg_wire_gql.rs (/opt/rustwide/target/debug/build/sekejap-dist/19a0307531575552/out/pg_wire_gql-19a0307531575552)
[INFO] [stdout] 
[INFO] [stdout] running 18 tests
[INFO] [stdout] test an_outer_select_is_described_with_its_parameter_types_and_orders_and_limits ... ok
[INFO] [stdout] test an_undeclared_parameter_takes_the_type_of_its_comparison_and_rebinds ... ok
[INFO] [stdout] test a_binder_error_reaches_the_wire_with_its_postgresql_sqlstate ... ok
[INFO] [stdout] test an_array_agg_column_is_a_postgresql_array_in_text_and_binary ... ok
[INFO] [stdout] test an_outer_selects_unaliased_columns_are_named_as_postgresql_names_them ... ok
[INFO] [stdout] test a_vertical_sum_past_bigint_reaches_the_wire_as_numeric_value_out_of_range ... ok
[INFO] [stdout] test a_simple_query_serves_the_same_statement_with_the_same_types ... ok
[INFO] [stdout] test a_runtime_error_reaches_the_wire_with_its_postgresql_sqlstate ... ok
[INFO] [stdout] test binary_cells_are_encoded_under_the_described_types ... ok
[INFO] [stdout] test a_gql_read_in_a_failed_transaction_block_is_refused_25p02 ... ok
[INFO] [stdout] test a_hybrid_statements_vector_parameter_is_described_as_a_vector_and_binds_from_text ... ok
[INFO] [stdout] test a_portal_refused_part_way_stays_refused_and_never_completes ... ok
[INFO] [stdout] test a_declared_cursor_fetches_a_gql_answer_in_pages_equal_to_the_one_shot_answer ... ok
[INFO] [stdout] test a_portal_with_a_row_limit_pages_a_gql_answer_into_the_one_shot_answer ... ok
[INFO] [stdout] test declaring_a_gql_cursor_with_a_name_already_open_is_refused_and_leaves_it_untouched ... ok
[INFO] [stdout] test describe_types_the_columns_before_a_row_exists_and_a_missing_seed_is_zero_rows ... ok
[INFO] [stdout] test a_statement_timeout_stops_a_gql_walk_with_57014_and_the_connection_stays_usable ... ok
[INFO] [stdout] test a_cancel_request_stops_a_gql_walk_with_57014_and_the_connection_stays_usable ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 18 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 3.63s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/pg_wire_gql_types.rs (/opt/rustwide/target/debug/build/sekejap-dist/06b8f350f27ee9fa/out/pg_wire_gql_types-06b8f350f27ee9fa)
[INFO] [stdout] 
[INFO] [stdout] running 18 tests
[INFO] [stdout] test an_empty_list_is_sent_with_zero_dimensions ... ok
[INFO] [stdout] test an_int8_list_is_sent_with_eight_byte_elements ... ok
[INFO] [stdout] test a_text_list_is_sent_as_a_one_dimensional_binary_array ... ok
[INFO] [stdout] test an_empty_list_is_braces_and_a_null_list_is_a_null_cell ... ok
[INFO] [stdout] test a_text_list_is_written_with_postgresql_array_quoting ... ok
[INFO] [stdout] test a_list_of_times_is_a_postgresql_array_of_times_in_text_and_binary ... ok
[INFO] [stdout] test a_non_array_parameter_decodes_exactly_as_before ... ok
[INFO] [stdout] test a_text_list_round_trips_in_text_and_binary ... ok
[INFO] [stdout] test a_malformed_array_parameter_is_refused_by_name ... ok
[INFO] [stdout] test an_int8_list_round_trips_in_text_and_binary ... ok
[INFO] [stdout] test a_binary_array_parameter_decodes_to_a_json_array ... ok
[INFO] [stdout] test owner_is_none_for_the_sentinel_and_some_for_a_stored_row ... ok
[INFO] [stdout] test jsonb_elements_carry_the_version_stamp ... ok
[INFO] [stdout] test scalar_lists_are_written_in_their_element_text_form ... ok
[INFO] [stdout] test every_list_spelling_maps_to_its_postgresql_array_oid ... ok
[INFO] [stdout] test an_array_parameter_decodes_to_a_json_array ... ok
[INFO] [stdout] test param_types_names_no_position_for_a_statement_that_types_none ... ok
[INFO] [stdout] test only_a_stored_row_has_an_owner_through_sql ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 18 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.98s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/pg_wire_refusals.rs (/opt/rustwide/target/debug/build/sekejap-dist/58ceb56625749a1f/out/pg_wire_refusals-58ceb56625749a1f)
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test the_neighbouring_sqlstates_are_unmoved_by_the_four_new_arms ... ok
[INFO] [stdout] test the_wire_carries_the_whole_reason_and_not_only_the_code ... ok
[INFO] [stdout] test a_named_refusal_the_engine_raises_never_arrives_as_an_internal_error ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.22s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/service.rs (/opt/rustwide/target/debug/build/sekejap-dist/1e463a6e39276b39/out/service-1e463a6e39276b39)
[INFO] [stdout] 
[INFO] [stdout] running 18 tests
[INFO] [stdout] test a_second_service_on_one_directory_is_refused_by_the_stores_own_writer_lock ... ok
[INFO] [stdout] test a_standing_cancel_does_not_stop_the_writer_from_committing ... ok
[INFO] [stdout] test the_key_list_stops_at_the_stated_cap_and_the_event_reports_the_total ... ok
[INFO] [stdout] test publish_now_swaps_the_view_in_one_snapshot_open_and_leaves_the_old_one_intact ... ok
[INFO] [stdout] test a_rolled_back_batch_and_a_dropped_guard_fire_no_event_and_leave_no_rows ... ok
[INFO] [stdout] test a_dropped_writer_leaves_nothing_behind_with_no_subscriber ... ok
[INFO] [stdout] test exactly_one_event_per_committed_batch_and_the_event_never_precedes_durability ... ok
[INFO] [stdout] test a_second_writer_is_refused_by_name_while_the_first_holds_it_and_served_once_it_is_dropped ... ok
[INFO] [stdout] test close_discards_uncommitted_work_and_releases_the_reader_slot ... ok
[INFO] [stdout] test a_reader_keeps_its_old_snapshot_while_a_writer_commits_and_a_later_reader_sees_the_commit ... ok
[INFO] [stdout] test a_work_bound_still_refuses_by_its_own_resource_while_a_deadline_is_also_set ... ok
[INFO] [stdout] test transaction_control_sql_is_refused_through_the_writer_guard ... ok
[INFO] [stdout] test a_commit_becomes_visible_within_the_publish_interval_plus_one_snapshot_open ... FAILED
[INFO] [stdout] test unsubscribing_stops_the_feed_and_an_unlistened_commit_records_nothing ... ok
[INFO] [stdout] test a_cancel_from_another_thread_stops_a_long_scan_and_clearing_it_restores_the_reader ... ok
[INFO] [stdout] test a_statement_past_its_deadline_is_refused_naming_deadline_the_elapsed_micros_and_the_work_so_far ... ok
[INFO] [stdout] test a_subscriber_that_stops_draining_drops_events_past_the_stated_bound_and_counts_them ... ok
[INFO] [stdout] test the_service_folds_its_log_so_writing_never_stops ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- a_commit_becomes_visible_within_the_publish_interval_plus_one_snapshot_open stdout ----
[INFO] [stdout] snapshot open over 4000 rows: [21.555539ms, 20.911689ms, 20.94463ms, 20.32841ms, 20.49444ms], worst 21.555539ms
[INFO] [stdout] 
[INFO] [stdout] thread 'a_commit_becomes_visible_within_the_publish_interval_plus_one_snapshot_open' (1807) panicked at tests/service.rs:296:5:
[INFO] [stdout] assertion `left == right` failed: a read inside the publish interval is stale by design
[INFO] [stdout]   left: 4001
[INFO] [stdout]  right: 4000
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x577bc54367b1 - std[617be2ca0a6fd877]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x577bc54367b1 - std[617be2ca0a6fd877]::backtrace_rs::backtrace::trace_unsynchronized::<std[617be2ca0a6fd877]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x577bc54367b1 - std[617be2ca0a6fd877]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x577bc54367b1 - <<std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a373ad73a504971]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x577bc544ec0a - <core[a373ad73a504971]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x577bc544ec0a - core[a373ad73a504971]::fmt::write
[INFO] [stdout]    6:     0x577bc543ac9c - core[a373ad73a504971]::io::write::default_write_fmt::<alloc[2e1b2a31b91974c5]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/io/write.rs:402:11
[INFO] [stdout]    7:     0x577bc543ac9c - <alloc[2e1b2a31b91974c5]::vec::Vec<u8> as core[a373ad73a504971]::io::write::Write>::write_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/io/write.rs:335:13
[INFO] [stdout]    8:     0x577bc5410e06 - <std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x577bc5410e06 - std[617be2ca0a6fd877]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:289:27
[INFO] [stdout]   10:     0x577bc542e399 - std[617be2ca0a6fd877]::panicking::default_hook
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:313:9
[INFO] [stdout]   11:     0x577bc4727330 - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn for<'a, 'b> core[a373ad73a504971]::ops::function::Fn<(&'a std[617be2ca0a6fd877]::panic::PanicHookInfo<'b>,), Output = ()> + core[a373ad73a504971]::marker::Sync + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::Fn<(&std[617be2ca0a6fd877]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2328:9
[INFO] [stdout]   12:     0x577bc4727330 - test[aada8e7e76ba119b]::test_main_inner::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:137:21
[INFO] [stdout]   13:     0x577bc542e552 - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn for<'a, 'b> core[a373ad73a504971]::ops::function::Fn<(&'a std[617be2ca0a6fd877]::panic::PanicHookInfo<'b>,), Output = ()> + core[a373ad73a504971]::marker::Sync + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::Fn<(&std[617be2ca0a6fd877]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2328:9
[INFO] [stdout]   14:     0x577bc542e552 - std[617be2ca0a6fd877]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:819:13
[INFO] [stdout]   15:     0x577bc5410eb2 - std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:685:13
[INFO] [stdout]   16:     0x577bc5409aa9 - std[617be2ca0a6fd877]::sys::backtrace::__rust_end_short_backtrace::<std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x577bc5411abd - __rustc[ea4f61d10b84890b]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:676:5
[INFO] [stdout]   18:     0x577bc544f42c - core[a373ad73a504971]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x577bc544f323 - core[a373ad73a504971]::panicking::assert_failed_inner
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panicking.rs:447:23
[INFO] [stdout]   20:     0x577bc5449948 - core[a373ad73a504971]::panicking::assert_failed::<usize, usize>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panicking.rs:407:5
[INFO] [stdout]   21:     0x577bc46acd98 - service[7805d3b68e7a8ffe]::a_commit_becomes_visible_within_the_publish_interval_plus_one_snapshot_open
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/service.rs:296:5
[INFO] [stdout]   22:     0x577bc46a2b57 - service[7805d3b68e7a8ffe]::a_commit_becomes_visible_within_the_publish_interval_plus_one_snapshot_open::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/service.rs:252:81
[INFO] [stdout]   23:     0x577bc46d84b6 - <service[7805d3b68e7a8ffe]::a_commit_becomes_visible_within_the_publish_interval_plus_one_snapshot_open::{closure#0} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x577bc471a77b - <fn() -> core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x577bc471a77b - test[aada8e7e76ba119b]::__rust_begin_short_backtrace::<core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>, fn() -> core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:701:18
[INFO] [stdout]   26:     0x577bc4727955 - test[aada8e7e76ba119b]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:724:74
[INFO] [stdout]   27:     0x577bc4727955 - <core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   28:     0x577bc4727955 - std[617be2ca0a6fd877]::panicking::catch_unwind::do_call::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>, core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:573:43
[INFO] [stdout]   29:     0x577bc4727955 - std[617be2ca0a6fd877]::panicking::catch_unwind::<core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>, core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:541:19
[INFO] [stdout]   30:     0x577bc4727955 - std[617be2ca0a6fd877]::panic::catch_unwind::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>, core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panic.rs:359:14
[INFO] [stdout]   31:     0x577bc4727955 - test[aada8e7e76ba119b]::run_test_in_process
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:724:27
[INFO] [stdout]   32:     0x577bc4727955 - test[aada8e7e76ba119b]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:645:43
[INFO] [stdout]   33:     0x577bc4721244 - test[aada8e7e76ba119b]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:675:41
[INFO] [stdout]   34:     0x577bc4721244 - std[617be2ca0a6fd877]::sys::backtrace::__rust_begin_short_backtrace::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   35:     0x577bc472a9e2 - std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   36:     0x577bc472a9e2 - <core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   37:     0x577bc472a9e2 - std[617be2ca0a6fd877]::panicking::catch_unwind::do_call::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:573:43
[INFO] [stdout]   38:     0x577bc472a9e2 - std[617be2ca0a6fd877]::panicking::catch_unwind::<(), core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:541:19
[INFO] [stdout]   39:     0x577bc472a9e2 - std[617be2ca0a6fd877]::panic::catch_unwind::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panic.rs:359:14
[INFO] [stdout]   40:     0x577bc472a9e2 - std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   41:     0x577bc472a9e2 - <std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x577bc5435f2f - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn core[a373ad73a504971]::ops::function::FnOnce<(), Output = ()> + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2314:9
[INFO] [stdout]   43:     0x577bc5435f2f - <std[617be2ca0a6fd877]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/thread/unix.rs:127:17
[INFO] [stdout]   44:     0x79dd71127dfa - <unknown>
[INFO] [stdout]   45:     0x79dd711bb3d4 - clone
[INFO] [stdout]   46:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     a_commit_becomes_visible_within_the_publish_interval_plus_one_snapshot_open
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 17 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 55.07s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--test service`
[INFO] running `Command { std: "docker" "inspect" "e17314c2d0be4c1a0e8e97eef8beecef2f55624585254a3dc38c5ed705c47db1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e17314c2d0be4c1a0e8e97eef8beecef2f55624585254a3dc38c5ed705c47db1", kill_on_drop: false }`
[INFO] [stdout] e17314c2d0be4c1a0e8e97eef8beecef2f55624585254a3dc38c5ed705c47db1
