[INFO] fetching crate nitinol-sqlite-adaptor 0.1.0...
[INFO] testing nitinol-sqlite-adaptor-0.1.0 against 1.90.0 for beta-1.91-3
[INFO] extracting crate nitinol-sqlite-adaptor 0.1.0 into /workspace/builds/worker-7-tc1/source
[INFO] started tweaking crates.io crate nitinol-sqlite-adaptor 0.1.0
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate nitinol-sqlite-adaptor 0.1.0
[INFO] tweaked toml for crates.io crate nitinol-sqlite-adaptor 0.1.0 written to /workspace/builds/worker-7-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate nitinol-sqlite-adaptor 0.1.0 on toolchain 1.90.0
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.90.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate nitinol-sqlite-adaptor 0.1.0 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.90.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded nitinol-process v0.1.1
[INFO] [stderr]   Downloaded nitinol-core v1.0.0
[INFO] [stderr]   Downloaded tempfile v3.17.1
[INFO] [stderr]   Downloaded nitinol-macro v0.1.0
[INFO] [stderr]   Downloaded nitinol-protocol v0.1.0
[INFO] [stderr]   Downloaded nitinol-persistence v0.1.1
[INFO] [stderr]   Downloaded nitinol v0.4.1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+1.90.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] f6876b9b1109ed1fd89e7a32201d0aeefd4145af09d4b9c29571ef3fcba80cf9
[INFO] running `Command { std: "docker" "start" "-a" "f6876b9b1109ed1fd89e7a32201d0aeefd4145af09d4b9c29571ef3fcba80cf9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "f6876b9b1109ed1fd89e7a32201d0aeefd4145af09d4b9c29571ef3fcba80cf9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f6876b9b1109ed1fd89e7a32201d0aeefd4145af09d4b9c29571ef3fcba80cf9", kill_on_drop: false }`
[INFO] [stdout] f6876b9b1109ed1fd89e7a32201d0aeefd4145af09d4b9c29571ef3fcba80cf9
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/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" "RUSTDOCFLAGS=--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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+1.90.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 4597075a1a79610223501ab9b8392b7092bfefcb3463ba846b34572272d44aba
[INFO] running `Command { std: "docker" "start" "-a" "4597075a1a79610223501ab9b8392b7092bfefcb3463ba846b34572272d44aba", kill_on_drop: false }`
[INFO] [stderr]    Compiling unicode-ident v1.0.17
[INFO] [stderr]    Compiling libc v0.2.170
[INFO] [stderr]    Compiling smallvec v1.14.0
[INFO] [stderr]    Compiling serde v1.0.218
[INFO] [stderr]    Compiling hashbrown v0.15.2
[INFO] [stderr]    Compiling serde_json v1.0.139
[INFO] [stderr]    Compiling futures-util v0.3.31
[INFO] [stderr]    Compiling cc v1.2.15
[INFO] [stderr]    Compiling tracing-core v0.1.33
[INFO] [stderr]    Compiling proc-macro2 v1.0.93
[INFO] [stderr]    Compiling log v0.4.26
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling crypto-common v0.1.6
[INFO] [stderr]    Compiling digest v0.10.7
[INFO] [stderr]    Compiling quote v1.0.38
[INFO] [stderr]    Compiling hashlink v0.10.0
[INFO] [stderr]    Compiling indexmap v2.7.1
[INFO] [stderr]    Compiling spin v0.9.8
[INFO] [stderr]    Compiling syn v2.0.98
[INFO] [stderr]    Compiling rustix v0.38.44
[INFO] [stderr]    Compiling sha2 v0.10.8
[INFO] [stderr]    Compiling flume v0.11.1
[INFO] [stderr]    Compiling atoi v2.0.0
[INFO] [stderr]    Compiling futures-channel v0.3.31
[INFO] [stderr]    Compiling parking_lot_core v0.9.10
[INFO] [stderr]    Compiling socket2 v0.5.8
[INFO] [stderr]    Compiling mio v1.0.3
[INFO] [stderr]    Compiling bitflags v2.8.0
[INFO] [stderr]    Compiling parking_lot v0.12.3
[INFO] [stderr]    Compiling tokio v1.43.0
[INFO] [stderr]    Compiling getrandom v0.3.1
[INFO] [stderr]    Compiling futures-intrusive v0.5.0
[INFO] [stderr]    Compiling libsqlite3-sys v0.30.1
[INFO] [stderr]    Compiling fastrand v2.3.0
[INFO] [stderr]    Compiling hex v0.4.3
[INFO] [stderr]    Compiling futures-executor v0.3.31
[INFO] [stderr]    Compiling tempfile v3.17.1
[INFO] [stderr]    Compiling tokio-stream v0.1.17
[INFO] [stderr]    Compiling synstructure v0.13.1
[INFO] [stderr]    Compiling zerofrom-derive v0.1.5
[INFO] [stderr]    Compiling yoke-derive v0.7.5
[INFO] [stderr]    Compiling zerovec-derive v0.10.3
[INFO] [stderr]    Compiling displaydoc v0.2.5
[INFO] [stderr]    Compiling icu_provider_macros v1.5.0
[INFO] [stderr]    Compiling serde_derive v1.0.218
[INFO] [stderr]    Compiling thiserror-impl v2.0.11
[INFO] [stderr]    Compiling tracing-attributes v0.1.28
[INFO] [stderr]    Compiling async-trait v0.1.86
[INFO] [stderr]    Compiling thiserror v2.0.11
[INFO] [stderr]    Compiling tracing v0.1.41
[INFO] [stderr]    Compiling zerofrom v0.1.5
[INFO] [stderr]    Compiling yoke v0.7.5
[INFO] [stderr]    Compiling zerovec v0.10.4
[INFO] [stderr]    Compiling tinystr v0.7.6
[INFO] [stderr]    Compiling icu_collections v1.5.0
[INFO] [stderr]    Compiling icu_locid v1.5.0
[INFO] [stderr]    Compiling icu_provider v1.5.0
[INFO] [stderr]    Compiling icu_locid_transform v1.5.0
[INFO] [stderr]    Compiling icu_properties v1.5.1
[INFO] [stderr]    Compiling either v1.14.0
[INFO] [stderr]    Compiling serde_urlencoded v0.7.1
[INFO] [stderr]    Compiling nitinol-core v1.0.0
[INFO] [stderr]    Compiling icu_normalizer v1.5.0
[INFO] [stderr]    Compiling idna_adapter v1.2.0
[INFO] [stderr]    Compiling idna v1.0.3
[INFO] [stderr]    Compiling url v2.5.4
[INFO] [stderr]    Compiling sqlx-core v0.8.3
[INFO] [stderr]    Compiling sqlx-sqlite v0.8.3
[INFO] [stderr]    Compiling sqlx-macros-core v0.8.3
[INFO] [stderr]    Compiling sqlx-macros v0.8.3
[INFO] [stderr]    Compiling sqlx v0.8.3
[INFO] [stderr]    Compiling nitinol-protocol v0.1.0
[INFO] [stderr]    Compiling nitinol-sqlite-adaptor v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 1m 32s
[INFO] running `Command { std: "docker" "inspect" "4597075a1a79610223501ab9b8392b7092bfefcb3463ba846b34572272d44aba", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "4597075a1a79610223501ab9b8392b7092bfefcb3463ba846b34572272d44aba", kill_on_drop: false }`
[INFO] [stdout] 4597075a1a79610223501ab9b8392b7092bfefcb3463ba846b34572272d44aba
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/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" "RUSTDOCFLAGS=--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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+1.90.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] f0f4d118c98d2c5ab302ed5c7208041652effe481e52fa55ca6d5a1cbf0200ab
[INFO] running `Command { std: "docker" "start" "-a" "f0f4d118c98d2c5ab302ed5c7208041652effe481e52fa55ca6d5a1cbf0200ab", kill_on_drop: false }`
[INFO] [stderr]    Compiling log v0.4.26
[INFO] [stderr]    Compiling tokio v1.43.0
[INFO] [stderr]    Compiling tokio-macros v2.5.0
[INFO] [stderr]    Compiling darling_core v0.20.10
[INFO] [stderr]    Compiling nitinol v0.4.1
[INFO] [stderr]    Compiling tracing v0.1.41
[INFO] [stderr]    Compiling tracing-log v0.2.0
[INFO] [stderr]    Compiling tracing-subscriber v0.3.19
[INFO] [stderr]    Compiling darling_macro v0.20.10
[INFO] [stderr]    Compiling darling v0.20.10
[INFO] [stderr]    Compiling nitinol-macro v0.1.0
[INFO] [stderr]    Compiling tokio-stream v0.1.17
[INFO] [stderr]    Compiling sqlx-core v0.8.3
[INFO] [stderr]    Compiling nitinol-process v0.1.1
[INFO] [stderr]    Compiling sqlx-sqlite v0.8.3
[INFO] [stderr]    Compiling sqlx-macros-core v0.8.3
[INFO] [stderr]    Compiling sqlx-macros v0.8.3
[INFO] [stderr]    Compiling sqlx v0.8.3
[INFO] [stderr]    Compiling nitinol-protocol v0.1.0
[INFO] [stderr]    Compiling nitinol-persistence v0.1.1
[INFO] [stderr]    Compiling nitinol-sqlite-adaptor v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 49.08s
[INFO] running `Command { std: "docker" "inspect" "f0f4d118c98d2c5ab302ed5c7208041652effe481e52fa55ca6d5a1cbf0200ab", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f0f4d118c98d2c5ab302ed5c7208041652effe481e52fa55ca6d5a1cbf0200ab", kill_on_drop: false }`
[INFO] [stdout] f0f4d118c98d2c5ab302ed5c7208041652effe481e52fa55ca6d5a1cbf0200ab
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/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" "RUSTDOCFLAGS=--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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+1.90.0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 05e7295823a82caa1b870083602735e589dd9a30ac8ffd503cb762ada0b3a353
[INFO] running `Command { std: "docker" "start" "-a" "05e7295823a82caa1b870083602735e589dd9a30ac8ffd503cb762ada0b3a353", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.28s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/nitinol_sqlite_adaptor-50daacc4ea00f097)
[INFO] [stdout] 
[INFO] [stderr]      Running tests/program.rs (/opt/rustwide/target/debug/deps/program-bc059a28fb9148d8)
[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 1 test
[INFO] [stdout] 2025-10-01T11:28:48.297948Z DEBUG connect-eventstore: sqlx::query: summary="PRAGMA foreign_keys = ON; …" db.statement="\n\nPRAGMA foreign_keys = ON; \n" rows_affected=0 rows_returned=0 elapsed=172.98µs elapsed_secs=0.00017298
[INFO] [stdout] 2025-10-01T11:28:48.298557Z DEBUG migrate-eventstore: sqlx::query: summary="CREATE TABLE IF NOT …" db.statement="\n\n\nCREATE TABLE IF NOT EXISTS _sqlx_migrations (\n    version BIGINT PRIMARY KEY,\n    description TEXT NOT NULL,\n    installed_on TIMESTAMP NOT NULL DEFAULT CURRENT_TIMESTAMP,\n    success BOOLEAN NOT NULL,\n    checksum BLOB NOT NULL,\n    execution_time BIGINT NOT NULL\n);\n                \n" rows_affected=0 rows_returned=0 elapsed=304.06µs elapsed_secs=0.00030406
[INFO] [stdout] 2025-10-01T11:28:48.299002Z DEBUG migrate-eventstore: sqlx::query: summary="SELECT version FROM _sqlx_migrations …" db.statement="\n\nSELECT version FROM _sqlx_migrations WHERE success = false ORDER BY version LIMIT 1\n" rows_affected=0 rows_returned=0 elapsed=175.34µs elapsed_secs=0.00017534
[INFO] [stdout] 2025-10-01T11:28:48.299283Z DEBUG migrate-eventstore: sqlx::query: summary="SELECT version, checksum FROM …" db.statement="\n\nSELECT version, checksum FROM _sqlx_migrations ORDER BY version\n" rows_affected=0 rows_returned=0 elapsed=131.44µs elapsed_secs=0.00013144
[INFO] [stdout] 2025-10-01T11:28:48.299717Z DEBUG migrate-eventstore: sqlx::query: summary="CREATE TABLE journal( id …" db.statement="\n\nCREATE TABLE journal(\n    id           TEXT     NOT NULL,\n    sequence_id  INTEGER  NOT NULL,\n    registry_key TEXT     NOT NULL,\n    bytes        BLOB     NOT NULL,\n    created_at   DATETIME NOT NULL DEFAULT CURRENT_TIMESTAMP,\n\n    PRIMARY KEY (id, sequence_id)\n);\n\n" rows_affected=0 rows_returned=0 elapsed=213.62µs elapsed_secs=0.00021362
[INFO] [stdout] 2025-10-01T11:28:48.300020Z DEBUG migrate-eventstore: sqlx::query: summary="INSERT INTO _sqlx_migrations ( …" db.statement="\n\n\n    INSERT INTO _sqlx_migrations ( version, description, success, checksum, execution_time )\n    VALUES ( ?1, ?2, TRUE, ?3, -1 )\n                \n" rows_affected=1 rows_returned=0 elapsed=140.25µs elapsed_secs=0.00014025
[INFO] [stdout] 2025-10-01T11:28:48.300366Z DEBUG migrate-eventstore: sqlx::query: summary="UPDATE _sqlx_migrations SET execution_time …" db.statement="\n\n\n    UPDATE _sqlx_migrations\n    SET execution_time = ?1\n    WHERE version = ?2\n                \n" rows_affected=1 rows_returned=0 elapsed=132.4µs elapsed_secs=0.0001324
[INFO] [stdout] 2025-10-01T11:28:48.300512Z  INFO nitinol_process::registry: Registered: test-entity-1
[INFO] [stdout] 2025-10-01T11:28:48.300624Z DEBUG handle: program: Accept command. published event: Created
[INFO] [stdout] 2025-10-01T11:28:48.301002Z DEBUG apply:write-eventstore: sqlx::query: summary="INSERT INTO journal(id, sequence_id, …" db.statement="\n\n\n            INSERT INTO journal(id, sequence_id, registry_key, bytes, created_at)\n            VALUES ($1, $2, $3, $4, $5)\n        \n" rows_affected=1 rows_returned=0 elapsed=68.32µs elapsed_secs=6.832e-5
[INFO] [stdout] 2025-10-01T11:28:48.301186Z DEBUG apply: program: Entity created.
[INFO] [stdout] 2025-10-01T11:28:51.301545Z DEBUG read-eventstore: sqlx::query: summary="SELECT id, sequence_id, registry_key, …" db.statement="\n\n\n            SELECT\n                id,\n                sequence_id,\n                registry_key,\n                bytes,\n                created_at\n            FROM journal\n            WHERE\n                id LIKE $1\n            AND sequence_id BETWEEN $2 AND $3\n        \n" rows_affected=1 rows_returned=1 elapsed=273.57µs elapsed_secs=0.00027357
[INFO] [stdout] 2025-10-01T11:28:51.301754Z DEBUG program: Payload#entity-event {
[INFO] [stdout]     id: "test-entity-1",
[INFO] [stdout]     sequence: 0,
[INFO] [stdout]     bytes: "<9 bytes>",
[INFO] [stdout]     created_at: 2025-10-01 11:28:48.300671379 +00:00:00,
[INFO] [stdout] }
[INFO] [stdout] test main ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 3.02s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests nitinol_sqlite_adaptor
[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" "05e7295823a82caa1b870083602735e589dd9a30ac8ffd503cb762ada0b3a353", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "05e7295823a82caa1b870083602735e589dd9a30ac8ffd503cb762ada0b3a353", kill_on_drop: false }`
[INFO] [stdout] 05e7295823a82caa1b870083602735e589dd9a30ac8ffd503cb762ada0b3a353