[INFO] fetching crate rusqlite_migration 2.5.0...
[INFO] testing rusqlite_migration-2.5.0 against try#dec9417b8611e34e787a3e4c37686b5131f9e5c5 for pr-154210-2
[INFO] extracting crate rusqlite_migration 2.5.0 into /workspace/builds/worker-4-tc2/source
[INFO] started tweaking crates.io crate rusqlite_migration 2.5.0
[INFO] finished tweaking crates.io crate rusqlite_migration 2.5.0
[INFO] tweaked toml for crates.io crate rusqlite_migration 2.5.0 written to /workspace/builds/worker-4-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate rusqlite_migration 2.5.0 on toolchain dec9417b8611e34e787a3e4c37686b5131f9e5c5
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate rusqlite_migration 2.5.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" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] e9ea12dfc303d7c7d6a6450761a333af91ca9b8c1c30eafa509871033e1e3880
[INFO] running `Command { std: "docker" "start" "-a" "e9ea12dfc303d7c7d6a6450761a333af91ca9b8c1c30eafa509871033e1e3880", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "e9ea12dfc303d7c7d6a6450761a333af91ca9b8c1c30eafa509871033e1e3880", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e9ea12dfc303d7c7d6a6450761a333af91ca9b8c1c30eafa509871033e1e3880", kill_on_drop: false }`
[INFO] [stdout] e9ea12dfc303d7c7d6a6450761a333af91ca9b8c1c30eafa509871033e1e3880
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 7ee1b2bc037903f2de8f3c817d86f86be8be90dade30ea29dd8d6d8d5ffc33da
[INFO] running `Command { std: "docker" "start" "-a" "7ee1b2bc037903f2de8f3c817d86f86be8be90dade30ea29dd8d6d8d5ffc33da", kill_on_drop: false }`
[INFO] [stderr]    Compiling vcpkg v0.2.15
[INFO] [stderr]    Compiling pkg-config v0.3.32
[INFO] [stderr]    Compiling fallible-streaming-iterator v0.1.9
[INFO] [stderr]    Compiling fallible-iterator v0.3.0
[INFO] [stderr]    Compiling smallvec v1.15.0
[INFO] [stderr]    Compiling rusqlite_migration v2.5.0 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling bitflags v2.9.0
[INFO] [stderr]    Compiling log v0.4.29
[INFO] [stderr]    Compiling libsqlite3-sys v0.37.0
[INFO] [stderr]    Compiling rusqlite v0.39.0
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 4.37s
[INFO] running `Command { std: "docker" "inspect" "7ee1b2bc037903f2de8f3c817d86f86be8be90dade30ea29dd8d6d8d5ffc33da", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "7ee1b2bc037903f2de8f3c817d86f86be8be90dade30ea29dd8d6d8d5ffc33da", kill_on_drop: false }`
[INFO] [stdout] 7ee1b2bc037903f2de8f3c817d86f86be8be90dade30ea29dd8d6d8d5ffc33da
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 67273e49e814c94eb14b8fea846d27b89d6266e94f50c248dead7bff6dd4ba93
[INFO] running `Command { std: "docker" "start" "-a" "67273e49e814c94eb14b8fea846d27b89d6266e94f50c248dead7bff6dd4ba93", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.172
[INFO] [stderr]    Compiling bitflags v2.9.0
[INFO] [stderr]    Compiling getrandom v0.3.4
[INFO] [stderr]    Compiling rustix v1.1.2
[INFO] [stderr]    Compiling log v0.4.29
[INFO] [stderr]    Compiling similar v2.7.0
[INFO] [stderr]    Compiling mutants v0.0.4
[INFO] [stderr]    Compiling env_filter v1.0.0
[INFO] [stderr]    Compiling env_logger v0.11.9
[INFO] [stderr]    Compiling rusqlite v0.39.0
[INFO] [stderr]    Compiling console v0.15.11
[INFO] [stderr]    Compiling rusqlite_migration v2.5.0 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling tempfile v3.23.0
[INFO] [stderr]    Compiling insta v1.46.3
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 13.77s
[INFO] running `Command { std: "docker" "inspect" "67273e49e814c94eb14b8fea846d27b89d6266e94f50c248dead7bff6dd4ba93", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "67273e49e814c94eb14b8fea846d27b89d6266e94f50c248dead7bff6dd4ba93", kill_on_drop: false }`
[INFO] [stdout] 67273e49e814c94eb14b8fea846d27b89d6266e94f50c248dead7bff6dd4ba93
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 7428a0153a31828be027acfc813a72385295e84c35f4742dbdb5b4721e688f62
[INFO] running `Command { std: "docker" "start" "-a" "7428a0153a31828be027acfc813a72385295e84c35f4742dbdb5b4721e688f62", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.08s
[INFO] [stdout] 
[INFO] [stdout] running 47 tests
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/rusqlite_migration-5687ccad70a0281a)
[INFO] [stdout] test errors::tests::error_test_source ... ok
[INFO] [stdout] test errors::tests::schema_version_partial_display_test ... ok
[INFO] [stdout] test errors::tests::test_foreign_key_check_error_display ... ok
[INFO] [stdout] test errors::tests::test_hook_conversion_msg ... ok
[INFO] [stdout] test errors::tests::test_migration_definition_error_display ... ok
[INFO] [stdout] test errors::tests::test_migration_enum_eq_not_enough ... ok
[INFO] [stdout] test errors::tests::test_rusqlite_error_conversion ... ok
[INFO] [stdout] test errors::tests::test_rusqlite_error_file_load ... ok
[INFO] [stdout] test errors::tests::test_rusqlite_error_fkc ... ok
[INFO] [stdout] test errors::tests::test_schema_version_error_display ... ok
[INFO] [stdout] test errors::tests::test_specified_schema_version_error ... ok
[INFO] [stdout] test errors::tests::test_rusqlite_error_query ... ok
[INFO] [stdout] test tests::core::empty_migrations_test ... ok
[INFO] [stdout] test tests::core::eq_hook_test ... ok
[INFO] [stdout] test errors::tests::test_unrecognized_errors ... ok
[INFO] [stdout] test tests::core::invalid_migration_multiple_statement_test ... ok
[INFO] [stdout] test tests::core::invalid_migration_statement_test ... ok
[INFO] [stdout] test tests::core::migration_partial_eq_test ... ok
[INFO] [stdout] test tests::core::current_version_gt_max_schema_version_test ... ok
[INFO] [stdout] test tests::core::schema_version_partial_cmp_test ... ok
[INFO] [stdout] test tests::core::min_migrations_test ... ok
[INFO] [stdout] test tests::core::test_build_from_cow ... ok
[INFO] [stdout] test tests::core::test_db_version_to_schema_empty ... ok
[INFO] [stdout] test tests::core::test_db_version_to_schema_two ... ok
[INFO] [stdout] test tests::core::max_migration_test ... ok
[INFO] [stdout] test tests::core::hook_test ... ok
[INFO] [stdout] test tests::core::test_from_iter ... ok
[INFO] [stdout] test tests::core::test_pending_migrations_errors ... ok
[INFO] [stdout] test tests::core::test_missing_down_migration ... ok
[INFO] [stdout] test tests::core::test_pending_migrations ... ok
[INFO] [stdout] test tests::core::user_version_convert_test ... ok
[INFO] [stdout] test tests::core::user_version_migrate_test ... ok
[INFO] [stdout] test tests::core::user_version_start_0_test ... ok
[INFO] [stdout] test tests::core::valid_migration_multiple_statement_test ... ok
[INFO] [stdout] test errors::tests::test_error_source ... ok
[INFO] [stdout] test tests::core::test_migration_hook_debug ... ok
[INFO] [stdout] test tests::fk_check::invalid_down_fk_check_test ... ok
[INFO] [stdout] test tests::fk_check::fk_check_validate_test ... ok
[INFO] [stdout] test errors::tests::test_error_display ... ok
[INFO] [stdout] test tests::fk_check::valid_fk_check_test ... ok
[INFO] [stdout] test tests::core::all_valid_up_test ... ok
[INFO] [stdout] test tests::core::all_valid_down_test ... ok
[INFO] [stdout] test tests::core::test_read_only_db_all_valid ... ok
[INFO] [stdout] test tests::fk_check::invalid_fk_check_test ... ok
[INFO] [stdout] test tests::core::test_user_version_error ... ok
[INFO] [stderr]    Doc-tests rusqlite_migration
[INFO] [stdout] test tests::helpers::all_valid_consistent ... ok
[INFO] [stdout] test tests::display::test_m_display ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 47 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.14s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 16 tests
[INFO] [stdout] test src/lib.rs - (line 94) ... ok
[INFO] [stdout] test src/lib.rs - (line 103) ... ok
[INFO] [stdout] test src/lib.rs - M<'u>::up (line 195) ... ok
[INFO] [stdout] test src/lib.rs - M<'u>::down (line 274) ... ok
[INFO] [stdout] test src/lib.rs - M<'u>::up_with_hook (line 228) ... ok
[INFO] [stdout] test src/lib.rs - M<'u>::foreign_key_check (line 316) ... ok
[INFO] [stdout] test src/lib.rs - Migrations<'m>::current_version (line 506) ... ok
[INFO] [stdout] test src/lib.rs - (line 54) ... ok
[INFO] [stdout] test src/lib.rs - Migrations<'m>::from_slice (line 425) ... ok
[INFO] [stdout] test src/lib.rs - Migrations<'m>::validate (line 911) ... ok
[INFO] [stdout] test src/lib.rs - Migrations<'m>::new (line 407) ... ok
[INFO] [stdout] test src/lib.rs - Migrations<'m>::pending_migrations (line 555) ... ok
[INFO] [stdout] test src/lib.rs - Migrations<'m>::pending_migrations (line 577) ... ok
[INFO] [stdout] test src/lib.rs - Migrations<'m>::to_latest (line 760) ... ok
[INFO] [stdout] test src/lib.rs - Migrations<'m>::to_latest (line 783) ... ok
[INFO] [stdout] test src/lib.rs - Migrations<'m>::to_version (line 845) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 16 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.90s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "7428a0153a31828be027acfc813a72385295e84c35f4742dbdb5b4721e688f62", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "7428a0153a31828be027acfc813a72385295e84c35f4742dbdb5b4721e688f62", kill_on_drop: false }`
[INFO] [stdout] 7428a0153a31828be027acfc813a72385295e84c35f4742dbdb5b4721e688f62