Open ibrunotome opened 2 years ago
code-distortion
commented
2 years ago Hi Bruno. Thanks for your message! This is the first one.
Adding pgSQL support is something I would like to do. But it isn't high on my priority list as I don't have a need for it, or much pgSQL experience at this stage.
code-distortion
commented
2 years ago Hi Bruno. I took it up as a challenge and added support for PostgreSQL.
If you try the package, I'm interested in feedback on how your experience was.
ibrunotome
commented
2 years ago Tested, took 63.22s to run a test that took 1.33s using DatabaseTransactions trait 😬
my postgres settings:
Just followed your quick start, no changes on configuration file.
ibrunotome
commented
2 years ago Updated the configuration file, used:
'migrations' => false and 'build_databases' => false
results running all tests:
Same as using DatabaseTransactions.
code-distortion
commented
2 years ago Thanks for the response.
Adapt can log a bunch of details about how it builds and reuses the database for each test.
Would you mind adding ADAPT_LOG_LARAVEL=true to your .env.testing file, and copy the output that's added to your storage/logs/laravel.log when you run your test?
The migrations config setting tells Adapt to run your migrations when building the database. I imagine you'll want this turned on, as your database won't have any tables otherwise.
And the build_databases config setting tells Adapt whether to even try building the database or not. You'll want that to be turned on. I know it doesn't sound useful to turn this off, but it lets you use Adapt to handle your browser-testing (e.g. when parallel testing) when you don't have a database.
code-distortion
commented
2 years ago The idea is that When you run a test, and it needs a database for the first time, Adapt builds the database
And then the next time the test runs, the database is re-used
ibrunotome
commented
2 years ago migrations and build_databases with true, part of generated log:
[2022-05-21 16:01:51] testing.DEBUG: ADAPT: Looking for stale things to remove
[2022-05-21 16:01:51] testing.DEBUG: ADAPT: Generated the build-hash - of the files that can be used to build the database (28ms)
[2022-05-21 16:02:52] testing.DEBUG: ADAPT: Nothing found to remove (1.01m)
[2022-05-21 16:02:52] testing.DEBUG: ADAPT: ┌── ADAPT - Preparing a Test-Database ────────────────────────────────────────────┐
[2022-05-21 16:02:52] testing.DEBUG: ADAPT: │ Preparing the database for connection "pgsql" │
[2022-05-21 16:02:52] testing.DEBUG: ADAPT: │ For test "P\Tests\Unit\Actions\BlockUserActionTest::it block user successfully" │
[2022-05-21 16:02:52] testing.DEBUG: ADAPT: └─────────────────────────────────────────────────────────────────────────────────┘
[2022-05-21 16:02:52] testing.DEBUG: ADAPT: ┌── Build Sources ────────────┐
[2022-05-21 16:02:52] testing.DEBUG: ADAPT: │ Pre-migration imports: None │
[2022-05-21 16:02:52] testing.DEBUG: ADAPT: │ Migrations: Yes │
[2022-05-21 16:02:52] testing.DEBUG: ADAPT: │ Seeders: None │
[2022-05-21 16:02:52] testing.DEBUG: ADAPT: │ Snapshots enabled? No │
[2022-05-21 16:02:52] testing.DEBUG: ADAPT: └─────────────────────────────┘
[2022-05-21 16:02:52] testing.DEBUG: ADAPT: ┌── Build Environment ──────────────────────────────────────┐
[2022-05-21 16:02:52] testing.DEBUG: ADAPT: │ Database is reusable? Yes - transaction │
[2022-05-21 16:02:52] testing.DEBUG: ADAPT: │ Using scenarios? Yes │
[2022-05-21 16:02:52] testing.DEBUG: ADAPT: │ For a browser-test? No │
[2022-05-21 16:02:52] testing.DEBUG: ADAPT: │ Verify database after? No │
[2022-05-21 16:02:52] testing.DEBUG: ADAPT: │ Build-hash: "6da5040d1167f82c218d179cd1269344" │
[2022-05-21 16:02:52] testing.DEBUG: ADAPT: │ Snapshot-hash: "7fb646bd1507b9196806e75d7d089292" │
[2022-05-21 16:02:52] testing.DEBUG: ADAPT: │ Scenario-hash: "8b6cd8e1750c1b6b49c53acaf5f6a0da" │
[2022-05-21 16:02:52] testing.DEBUG: ADAPT: └───────────────────────────────────────────────────────────┘
[2022-05-21 16:02:52] testing.DEBUG: ADAPT: ┌── Resolved Database ───────────────────────────┐
[2022-05-21 16:02:52] testing.DEBUG: ADAPT: │ Connection: "pgsql" │
[2022-05-21 16:02:52] testing.DEBUG: ADAPT: │ Driver: "pgsql" │
[2022-05-21 16:02:52] testing.DEBUG: ADAPT: │ Host: "testingpgsql" │
[2022-05-21 16:02:52] testing.DEBUG: ADAPT: │ Database: "testingkuest_6da504_8b6cd8e1750c" │
[2022-05-21 16:02:52] testing.DEBUG: ADAPT: └────────────────────────────────────────────────┘
[2022-05-21 16:02:52] testing.DEBUG: ADAPT: Changed the database for connection "pgsql" to "testingkuest_6da504_8b6cd8e1750c"
[2022-05-21 16:02:52] testing.DEBUG: ADAPT: Database "testingkuest_6da504_8b6cd8e1750c" cannot be reused (80ms)
[2022-05-21 16:02:52] testing.DEBUG: ADAPT: Dropped the existing database (100ms)
[2022-05-21 16:02:52] testing.DEBUG: ADAPT: Created a new database (97ms)
[2022-05-21 16:02:53] testing.DEBUG: ADAPT: Ran migrations (1.12s)
[2022-05-21 16:02:53] testing.DEBUG: ADAPT: Set up re-use meta-data (3ms)
[2022-05-21 16:02:53] testing.DEBUG: ADAPT: Total preparation time for database "testingkuest_6da504_8b6cd8e1750c" (1.43s)
[2022-05-21 16:02:54] testing.DEBUG: ADAPT: ┌── ADAPT - Preparing a Test-Database ──────────────────────────────────────────────┐
[2022-05-21 16:02:54] testing.DEBUG: ADAPT: │ Preparing the database for connection "pgsql" │
[2022-05-21 16:02:54] testing.DEBUG: ADAPT: │ For test "P\Tests\Unit\Actions\CloneKuestActionTest::it clone kuest successfully" │
[2022-05-21 16:02:54] testing.DEBUG: ADAPT: └───────────────────────────────────────────────────────────────────────────────────┘
[2022-05-21 16:02:54] testing.DEBUG: ADAPT: ┌── Build Sources ────────────┐
[2022-05-21 16:02:54] testing.DEBUG: ADAPT: │ Pre-migration imports: None │
[2022-05-21 16:02:54] testing.DEBUG: ADAPT: │ Migrations: Yes │
[2022-05-21 16:02:54] testing.DEBUG: ADAPT: │ Seeders: None │
[2022-05-21 16:02:54] testing.DEBUG: ADAPT: │ Snapshots enabled? No │
[2022-05-21 16:02:54] testing.DEBUG: ADAPT: └─────────────────────────────┘
[2022-05-21 16:02:54] testing.DEBUG: ADAPT: ┌── Build Environment ──────────────────────────────────────┐
[2022-05-21 16:02:54] testing.DEBUG: ADAPT: │ Database is reusable? Yes - transaction │
[2022-05-21 16:02:54] testing.DEBUG: ADAPT: │ Using scenarios? Yes │
[2022-05-21 16:02:54] testing.DEBUG: ADAPT: │ For a browser-test? No │
[2022-05-21 16:02:54] testing.DEBUG: ADAPT: │ Verify database after? No │
[2022-05-21 16:02:54] testing.DEBUG: ADAPT: │ Build-hash: "6da5040d1167f82c218d179cd1269344" │
[2022-05-21 16:02:54] testing.DEBUG: ADAPT: │ Snapshot-hash: "7fb646bd1507b9196806e75d7d089292" │
[2022-05-21 16:02:54] testing.DEBUG: ADAPT: │ Scenario-hash: "8b6cd8e1750c1b6b49c53acaf5f6a0da" │
[2022-05-21 16:02:54] testing.DEBUG: ADAPT: └───────────────────────────────────────────────────────────┘
[2022-05-21 16:02:54] testing.DEBUG: ADAPT: ┌── Resolved Database ───────────────────────────┐
[2022-05-21 16:02:54] testing.DEBUG: ADAPT: │ Connection: "pgsql" │
[2022-05-21 16:02:54] testing.DEBUG: ADAPT: │ Driver: "pgsql" │
[2022-05-21 16:02:54] testing.DEBUG: ADAPT: │ Host: "testingpgsql" │
[2022-05-21 16:02:54] testing.DEBUG: ADAPT: │ Database: "testingkuest_6da504_8b6cd8e1750c" │
[2022-05-21 16:02:54] testing.DEBUG: ADAPT: └────────────────────────────────────────────────┘
[2022-05-21 16:02:54] testing.DEBUG: ADAPT: Changed the database for connection "pgsql" to "testingkuest_6da504_8b6cd8e1750c"
[2022-05-21 16:02:54] testing.DEBUG: ADAPT: Database "testingkuest_6da504_8b6cd8e1750c" cannot be reused (72ms)
[2022-05-21 16:02:59] testing.ERROR: ADAPT: ┌── An Exception Occurred - AdaptBuildException ─────────────────────────────────────────────────────────────────────────┐
[2022-05-21 16:02:59] testing.ERROR: ADAPT: │ Could not drop database "testingkuest_6da504_8b6cd8e1750c" │
[2022-05-21 16:02:59] testing.ERROR: ADAPT: │ │
[2022-05-21 16:02:59] testing.ERROR: ADAPT: │ Previous Exception - PDOException │
[2022-05-21 16:02:59] testing.ERROR: ADAPT: │ SQLSTATE[55006]: Object in use: 7 ERROR: database "testingkuest_6da504_8b6cd8e1750c" is being accessed by other users │
[2022-05-21 16:02:59] testing.ERROR: ADAPT: │ DETAIL: There are 2 other sessions using the database. │
[2022-05-21 16:02:59] testing.ERROR: ADAPT: └────────────────────────────────────────────────────────────────────────────────────────────────────────────────────────┘
[2022-05-21 16:02:59] testing.DEBUG: ADAPT: ┌── ADAPT - Preparing a Test-Database ──────────────────────────────────────────────────────────────┐
[2022-05-21 16:02:59] testing.DEBUG: ADAPT: │ Preparing the database for connection "pgsql" │
[2022-05-21 16:02:59] testing.DEBUG: ADAPT: │ For test "P\Tests\Unit\Actions\Fortify\CreateNewUserTest::it executes CreateNewUser successfully" │
[2022-05-21 16:02:59] testing.DEBUG: ADAPT: └───────────────────────────────────────────────────────────────────────────────────────────────────┘
[2022-05-21 16:02:59] testing.DEBUG: ADAPT: ┌── Build Sources ────────────┐
[2022-05-21 16:02:59] testing.DEBUG: ADAPT: │ Pre-migration imports: None │
[2022-05-21 16:02:59] testing.DEBUG: ADAPT: │ Migrations: Yes │
[2022-05-21 16:02:59] testing.DEBUG: ADAPT: │ Seeders: None │
[2022-05-21 16:02:59] testing.DEBUG: ADAPT: │ Snapshots enabled? No │
[2022-05-21 16:02:59] testing.DEBUG: ADAPT: └─────────────────────────────┘
[2022-05-21 16:02:59] testing.DEBUG: ADAPT: ┌── Build Environment ──────────────────────────────────────┐
[2022-05-21 16:02:59] testing.DEBUG: ADAPT: │ Database is reusable? Yes - transaction │
[2022-05-21 16:02:59] testing.DEBUG: ADAPT: │ Using scenarios? Yes │
[2022-05-21 16:02:59] testing.DEBUG: ADAPT: │ For a browser-test? No │
[2022-05-21 16:02:59] testing.DEBUG: ADAPT: │ Verify database after? No │
[2022-05-21 16:02:59] testing.DEBUG: ADAPT: │ Build-hash: "6da5040d1167f82c218d179cd1269344" │
[2022-05-21 16:02:59] testing.DEBUG: ADAPT: │ Snapshot-hash: "7fb646bd1507b9196806e75d7d089292" │
[2022-05-21 16:02:59] testing.DEBUG: ADAPT: │ Scenario-hash: "8b6cd8e1750c1b6b49c53acaf5f6a0da" │
[2022-05-21 16:02:59] testing.DEBUG: ADAPT: └───────────────────────────────────────────────────────────┘
[2022-05-21 16:02:59] testing.DEBUG: ADAPT: ┌── Resolved Database ───────────────────────────┐
[2022-05-21 16:02:59] testing.DEBUG: ADAPT: │ Connection: "pgsql" │
[2022-05-21 16:02:59] testing.DEBUG: ADAPT: │ Driver: "pgsql" │
[2022-05-21 16:02:59] testing.DEBUG: ADAPT: │ Host: "testingpgsql" │
[2022-05-21 16:02:59] testing.DEBUG: ADAPT: │ Database: "testingkuest_6da504_8b6cd8e1750c" │
[2022-05-21 16:02:59] testing.DEBUG: ADAPT: └────────────────────────────────────────────────┘
[2022-05-21 16:02:59] testing.DEBUG: ADAPT: Changed the database for connection "pgsql" to "testingkuest_6da504_8b6cd8e1750c"
[2022-05-21 16:02:59] testing.DEBUG: ADAPT: Database "testingkuest_6da504_8b6cd8e1750c" cannot be reused (71ms)
[2022-05-21 16:03:04] testing.ERROR: ADAPT: ┌── An Exception Occurred - AdaptBuildException ─────────────────────────────────────────────────────────────────────────┐
[2022-05-21 16:03:04] testing.ERROR: ADAPT: │ Could not drop database "testingkuest_6da504_8b6cd8e1750c" │
[2022-05-21 16:03:04] testing.ERROR: ADAPT: │ │
[2022-05-21 16:03:04] testing.ERROR: ADAPT: │ Previous Exception - PDOException │
[2022-05-21 16:03:04] testing.ERROR: ADAPT: │ SQLSTATE[55006]: Object in use: 7 ERROR: database "testingkuest_6da504_8b6cd8e1750c" is being accessed by other users │
[2022-05-21 16:03:04] testing.ERROR: ADAPT: │ DETAIL: There are 2 other sessions using the database. │
[2022-05-21 16:03:04] testing.ERROR: ADAPT: └────────────────────────────────────────────────────────────────────────────────────────────────────────────────────────┘
ibrunotome
commented
2 years ago Just the first test passed, after more than 1 minute, the other fails, i stopped the execution after like 5 minutes, since all tests should be finished in ~ 140s
code-distortion
commented
2 years ago Thanks. Got it. There's two things happening:
Postgres added the option to force it to close existing connections before dropping a database recently in version 13. From my experience I didn't find that I needed it, but I can see it might be important here. I'll have a look at adding it in.
Do you use any other tools that might also connect to the database?
There are several reasons why it might decide that the database can't be reused. Ultimately it's checking to make sure that the database was left in a clean state, ready for the next test.
I'll also add some extra logging to see why in this case it didn't think the database could be reused.
I'll reply back when I've made the update.
code-distortion
commented
2 years ago Thanks for your help. I've released version 0.10.2 with those changes.
Would you mind updating to this, and perform the same steps. Then copy and paste from the logs again?
And in case it helps, would you mind letting me know which version you use of:
ibrunotome
commented
2 years ago Logs:
[2022-05-25 10:58:51] testing.DEBUG: ADAPT: Looking for stale things to remove
[2022-05-25 10:58:51] testing.DEBUG: ADAPT: Generated the build-hash - of the files that can be used to build the database (57ms)
[2022-05-25 10:59:52] testing.DEBUG: ADAPT: Nothing found to remove (1.01m)
[2022-05-25 10:59:52] testing.DEBUG: ADAPT: ┌── ADAPT - Preparing a Test-Database ────────────────────────────────────────────┐
[2022-05-25 10:59:52] testing.DEBUG: ADAPT: │ Preparing the database for connection "pgsql" │
[2022-05-25 10:59:52] testing.DEBUG: ADAPT: │ For test "P\Tests\Unit\Actions\BlockUserActionTest::it block user successfully" │
[2022-05-25 10:59:52] testing.DEBUG: ADAPT: └─────────────────────────────────────────────────────────────────────────────────┘
[2022-05-25 10:59:52] testing.DEBUG: ADAPT: ┌── Build Sources ────────────┐
[2022-05-25 10:59:52] testing.DEBUG: ADAPT: │ Pre-migration imports: None │
[2022-05-25 10:59:52] testing.DEBUG: ADAPT: │ Migrations: Yes │
[2022-05-25 10:59:52] testing.DEBUG: ADAPT: │ Seeders: None │
[2022-05-25 10:59:52] testing.DEBUG: ADAPT: │ Snapshots enabled? No │
[2022-05-25 10:59:52] testing.DEBUG: ADAPT: └─────────────────────────────┘
[2022-05-25 10:59:52] testing.DEBUG: ADAPT: ┌── Build Environment ──────────────────────────────────────┐
[2022-05-25 10:59:52] testing.DEBUG: ADAPT: │ Database is reusable? Yes - transaction │
[2022-05-25 10:59:52] testing.DEBUG: ADAPT: │ Using scenarios? Yes │
[2022-05-25 10:59:52] testing.DEBUG: ADAPT: │ For a browser-test? No │
[2022-05-25 10:59:52] testing.DEBUG: ADAPT: │ Verify database after? No │
[2022-05-25 10:59:52] testing.DEBUG: ADAPT: │ Build-hash: "6da5040d1167f82c218d179cd1269344" │
[2022-05-25 10:59:52] testing.DEBUG: ADAPT: │ Snapshot-hash: "7fb646bd1507b9196806e75d7d089292" │
[2022-05-25 10:59:52] testing.DEBUG: ADAPT: │ Scenario-hash: "8b6cd8e1750c1b6b49c53acaf5f6a0da" │
[2022-05-25 10:59:52] testing.DEBUG: ADAPT: └───────────────────────────────────────────────────────────┘
[2022-05-25 10:59:52] testing.DEBUG: ADAPT: ┌── Resolved Database ───────────────────────────┐
[2022-05-25 10:59:52] testing.DEBUG: ADAPT: │ Connection: "pgsql" │
[2022-05-25 10:59:52] testing.DEBUG: ADAPT: │ Driver: "pgsql" │
[2022-05-25 10:59:52] testing.DEBUG: ADAPT: │ Host: "testingpgsql" │
[2022-05-25 10:59:52] testing.DEBUG: ADAPT: │ Database: "testingkuest_6da504_8b6cd8e1750c" │
[2022-05-25 10:59:52] testing.DEBUG: ADAPT: └────────────────────────────────────────────────┘
[2022-05-25 10:59:52] testing.DEBUG: ADAPT: Changed the database for connection "pgsql" to "testingkuest_6da504_8b6cd8e1750c"
[2022-05-25 10:59:52] testing.DEBUG: ADAPT: Database "testingkuest_6da504_8b6cd8e1750c" cannot be reused (99ms)
[2022-05-25 10:59:53] testing.DEBUG: ADAPT: (Reason "An exception occurred when reading the re-use info - "SQLSTATE[42P01]: Undefined table: 7 ERROR: relation "adapt" does not exist
LINE 1: SELECT FROM "adapt" LIMIT 1 OFFSET 0
^ (SQL: SELECT FROM "adapt" LIMIT 1 OFFSET 0)"")
[2022-05-25 10:59:53] testing.DEBUG: ADAPT: Dropped the existing database (72ms)
[2022-05-25 10:59:53] testing.DEBUG: ADAPT: Created a new database (169ms)
[2022-05-25 10:59:54] testing.DEBUG: ADAPT: Ran migrations (1.1s)
[2022-05-25 10:59:54] testing.DEBUG: ADAPT: Set up re-use meta-data (3ms)
[2022-05-25 10:59:54] testing.DEBUG: ADAPT: Total preparation time for database "testingkuest_6da504_8b6cd8e1750c" (2.44s)
[2022-05-25 10:59:55] testing.DEBUG: ADAPT: ┌── ADAPT - Preparing a Test-Database ──────────────────────────────────────────────┐
[2022-05-25 10:59:55] testing.DEBUG: ADAPT: │ Preparing the database for connection "pgsql" │
[2022-05-25 10:59:55] testing.DEBUG: ADAPT: │ For test "P\Tests\Unit\Actions\CloneKuestActionTest::it clone kuest successfully" │
[2022-05-25 10:59:55] testing.DEBUG: ADAPT: └───────────────────────────────────────────────────────────────────────────────────┘
[2022-05-25 10:59:55] testing.DEBUG: ADAPT: ┌── Build Sources ────────────┐
[2022-05-25 10:59:55] testing.DEBUG: ADAPT: │ Pre-migration imports: None │
[2022-05-25 10:59:55] testing.DEBUG: ADAPT: │ Migrations: Yes │
[2022-05-25 10:59:55] testing.DEBUG: ADAPT: │ Seeders: None │
[2022-05-25 10:59:55] testing.DEBUG: ADAPT: │ Snapshots enabled? No │
[2022-05-25 10:59:55] testing.DEBUG: ADAPT: └─────────────────────────────┘
[2022-05-25 10:59:55] testing.DEBUG: ADAPT: ┌── Build Environment ──────────────────────────────────────┐
[2022-05-25 10:59:55] testing.DEBUG: ADAPT: │ Database is reusable? Yes - transaction │
[2022-05-25 10:59:55] testing.DEBUG: ADAPT: │ Using scenarios? Yes │
[2022-05-25 10:59:55] testing.DEBUG: ADAPT: │ For a browser-test? No │
[2022-05-25 10:59:55] testing.DEBUG: ADAPT: │ Verify database after? No │
[2022-05-25 10:59:55] testing.DEBUG: ADAPT: │ Build-hash: "6da5040d1167f82c218d179cd1269344" │
[2022-05-25 10:59:55] testing.DEBUG: ADAPT: │ Snapshot-hash: "7fb646bd1507b9196806e75d7d089292" │
[2022-05-25 10:59:55] testing.DEBUG: ADAPT: │ Scenario-hash: "8b6cd8e1750c1b6b49c53acaf5f6a0da" │
[2022-05-25 10:59:55] testing.DEBUG: ADAPT: └───────────────────────────────────────────────────────────┘
[2022-05-25 10:59:55] testing.DEBUG: ADAPT: ┌── Resolved Database ───────────────────────────┐
[2022-05-25 10:59:55] testing.DEBUG: ADAPT: │ Connection: "pgsql" │
[2022-05-25 10:59:55] testing.DEBUG: ADAPT: │ Driver: "pgsql" │
[2022-05-25 10:59:55] testing.DEBUG: ADAPT: │ Host: "testingpgsql" │
[2022-05-25 10:59:55] testing.DEBUG: ADAPT: │ Database: "testingkuest_6da504_8b6cd8e1750c" │
[2022-05-25 10:59:55] testing.DEBUG: ADAPT: └────────────────────────────────────────────────┘
[2022-05-25 10:59:55] testing.DEBUG: ADAPT: Changed the database for connection "pgsql" to "testingkuest_6da504_8b6cd8e1750c"
[2022-05-25 10:59:55] testing.DEBUG: ADAPT: Database "testingkuest_6da504_8b6cd8e1750c" cannot be reused (86ms)
[2022-05-25 10:59:55] testing.DEBUG: ADAPT: (Reason "An exception occurred when reading the re-use info - "SQLSTATE[42P01]: Undefined table: 7 ERROR: relation "adapt" does not exist
LINE 1: SELECT FROM "adapt" LIMIT 1 OFFSET 0
^ (SQL: SELECT FROM "adapt" LIMIT 1 OFFSET 0)"")
[2022-05-25 10:59:56] testing.DEBUG: ADAPT: Dropped the existing database (180ms)
[2022-05-25 10:59:56] testing.DEBUG: ADAPT: Created a new database (89ms)
[2022-05-25 10:59:56] testing.DEBUG: ADAPT: Ran migrations (626ms)
[2022-05-25 10:59:57] testing.DEBUG: ADAPT: Set up re-use meta-data (3ms)
[2022-05-25 10:59:57] testing.DEBUG: ADAPT: Total preparation time for database "testingkuest_6da504_8b6cd8e1750c" (2s)
[2022-05-25 10:59:57] testing.DEBUG: ADAPT: ┌── ADAPT - Preparing a Test-Database ──────────────────────────────────────────────────────────────┐
[2022-05-25 10:59:57] testing.DEBUG: ADAPT: │ Preparing the database for connection "pgsql" │
[2022-05-25 10:59:57] testing.DEBUG: ADAPT: │ For test "P\Tests\Unit\Actions\Fortify\CreateNewUserTest::it executes CreateNewUser successfully" │
[2022-05-25 10:59:57] testing.DEBUG: ADAPT: └───────────────────────────────────────────────────────────────────────────────────────────────────┘
[2022-05-25 10:59:57] testing.DEBUG: ADAPT: ┌── Build Sources ────────────┐
[2022-05-25 10:59:57] testing.DEBUG: ADAPT: │ Pre-migration imports: None │
[2022-05-25 10:59:57] testing.DEBUG: ADAPT: │ Migrations: Yes │
[2022-05-25 10:59:57] testing.DEBUG: ADAPT: │ Seeders: None │
[2022-05-25 10:59:57] testing.DEBUG: ADAPT: │ Snapshots enabled? No │
[2022-05-25 10:59:57] testing.DEBUG: ADAPT: └─────────────────────────────┘
[2022-05-25 10:59:57] testing.DEBUG: ADAPT: ┌── Build Environment ──────────────────────────────────────┐
[2022-05-25 10:59:57] testing.DEBUG: ADAPT: │ Database is reusable? Yes - transaction │
[2022-05-25 10:59:57] testing.DEBUG: ADAPT: │ Using scenarios? Yes │
[2022-05-25 10:59:57] testing.DEBUG: ADAPT: │ For a browser-test? No │
[2022-05-25 10:59:57] testing.DEBUG: ADAPT: │ Verify database after? No │
[2022-05-25 10:59:57] testing.DEBUG: ADAPT: │ Build-hash: "6da5040d1167f82c218d179cd1269344" │
[2022-05-25 10:59:57] testing.DEBUG: ADAPT: │ Snapshot-hash: "7fb646bd1507b9196806e75d7d089292" │
[2022-05-25 10:59:57] testing.DEBUG: ADAPT: │ Scenario-hash: "8b6cd8e1750c1b6b49c53acaf5f6a0da" │
[2022-05-25 10:59:57] testing.DEBUG: ADAPT: └───────────────────────────────────────────────────────────┘
[2022-05-25 10:59:57] testing.DEBUG: ADAPT: ┌── Resolved Database ───────────────────────────┐
[2022-05-25 10:59:58] testing.DEBUG: ADAPT: │ Connection: "pgsql" │
[2022-05-25 10:59:58] testing.DEBUG: ADAPT: │ Driver: "pgsql" │
[2022-05-25 10:59:58] testing.DEBUG: ADAPT: │ Host: "testingpgsql" │
[2022-05-25 10:59:58] testing.DEBUG: ADAPT: │ Database: "testingkuest_6da504_8b6cd8e1750c" │
[2022-05-25 10:59:58] testing.DEBUG: ADAPT: └────────────────────────────────────────────────┘
[2022-05-25 10:59:58] testing.DEBUG: ADAPT: Changed the database for connection "pgsql" to "testingkuest_6da504_8b6cd8e1750c"
[2022-05-25 10:59:58] testing.DEBUG: ADAPT: Database "testingkuest_6da504_8b6cd8e1750c" cannot be reused (84ms)
[2022-05-25 10:59:58] testing.DEBUG: ADAPT: (Reason "An exception occurred when reading the re-use info - "SQLSTATE[42P01]: Undefined table: 7 ERROR: relation "adapt" does not exist
LINE 1: SELECT FROM "adapt" LIMIT 1 OFFSET 0
^ (SQL: SELECT FROM "adapt" LIMIT 1 OFFSET 0)"")
[2022-05-25 10:59:58] testing.DEBUG: ADAPT: Dropped the existing database (176ms)
[2022-05-25 10:59:58] testing.DEBUG: ADAPT: Created a new database (86ms)
[2022-05-25 10:59:59] testing.DEBUG: ADAPT: Ran migrations (609ms)
[2022-05-25 10:59:59] testing.DEBUG: ADAPT: Set up re-use meta-data (3ms)
[2022-05-25 10:59:59] testing.DEBUG: ADAPT: Total preparation time for database "testingkuest_6da504_8b6cd8e1750c" (2.01s)
[2022-05-25 10:59:59] testing.DEBUG: ADAPT: ┌── ADAPT - Preparing a Test-Database ────────────────────────────────────────────────────────────────────────────────────────────┐
[2022-05-25 10:59:59] testing.DEBUG: ADAPT: │ Preparing the database for connection "pgsql" │
[2022-05-25 10:59:59] testing.DEBUG: ADAPT: │ For test "P\Tests\Unit\Actions\Fortify\UpdateUserProfileInformationTest::it executes UpdateUserProfileInformation successfully" │
[2022-05-25 10:59:59] testing.DEBUG: ADAPT: └─────────────────────────────────────────────────────────────────────────────────────────────────────────────────────────────────┘
[2022-05-25 10:59:59] testing.DEBUG: ADAPT: ┌── Build Sources ────────────┐
[2022-05-25 10:59:59] testing.DEBUG: ADAPT: │ Pre-migration imports: None │
[2022-05-25 10:59:59] testing.DEBUG: ADAPT: │ Migrations: Yes │
[2022-05-25 10:59:59] testing.DEBUG: ADAPT: │ Seeders: None │
[2022-05-25 11:00:00] testing.DEBUG: ADAPT: │ Snapshots enabled? No │
[2022-05-25 11:00:00] testing.DEBUG: ADAPT: └─────────────────────────────┘
[2022-05-25 11:00:00] testing.DEBUG: ADAPT: ┌── Build Environment ──────────────────────────────────────┐
[2022-05-25 11:00:00] testing.DEBUG: ADAPT: │ Database is reusable? Yes - transaction │
[2022-05-25 11:00:00] testing.DEBUG: ADAPT: │ Using scenarios? Yes │
[2022-05-25 11:00:00] testing.DEBUG: ADAPT: │ For a browser-test? No │
[2022-05-25 11:00:00] testing.DEBUG: ADAPT: │ Verify database after? No │
[2022-05-25 11:00:00] testing.DEBUG: ADAPT: │ Build-hash: "6da5040d1167f82c218d179cd1269344" │
[2022-05-25 11:00:00] testing.DEBUG: ADAPT: │ Snapshot-hash: "7fb646bd1507b9196806e75d7d089292" │
[2022-05-25 11:00:00] testing.DEBUG: ADAPT: │ Scenario-hash: "8b6cd8e1750c1b6b49c53acaf5f6a0da" │
[2022-05-25 11:00:00] testing.DEBUG: ADAPT: └───────────────────────────────────────────────────────────┘
[2022-05-25 11:00:00] testing.DEBUG: ADAPT: ┌── Resolved Database ───────────────────────────┐
[2022-05-25 11:00:00] testing.DEBUG: ADAPT: │ Connection: "pgsql" │
[2022-05-25 11:00:00] testing.DEBUG: ADAPT: │ Driver: "pgsql" │
[2022-05-25 11:00:00] testing.DEBUG: ADAPT: │ Host: "testingpgsql" │
[2022-05-25 11:00:00] testing.DEBUG: ADAPT: │ Database: "testingkuest_6da504_8b6cd8e1750c" │
[2022-05-25 11:00:00] testing.DEBUG: ADAPT: └────────────────────────────────────────────────┘
[2022-05-25 11:00:00] testing.DEBUG: ADAPT: Changed the database for connection "pgsql" to "testingkuest_6da504_8b6cd8e1750c"
[2022-05-25 11:00:00] testing.DEBUG: ADAPT: Database "testingkuest_6da504_8b6cd8e1750c" cannot be reused (99ms)
[2022-05-25 11:00:00] testing.DEBUG: ADAPT: (Reason "An exception occurred when reading the re-use info - "SQLSTATE[42P01]: Undefined table: 7 ERROR: relation "adapt" does not exist
LINE 1: SELECT FROM "adapt" LIMIT 1 OFFSET 0
^ (SQL: SELECT FROM "adapt" LIMIT 1 OFFSET 0)"")
[2022-05-25 11:00:01] testing.DEBUG: ADAPT: Dropped the existing database (184ms)
[2022-05-25 11:00:01] testing.DEBUG: ADAPT: Created a new database (88ms)
[2022-05-25 11:00:01] testing.DEBUG: ADAPT: Ran migrations (591ms)
[2022-05-25 11:00:01] testing.DEBUG: ADAPT: Set up re-use meta-data (3ms)
[2022-05-25 11:00:01] testing.DEBUG: ADAPT: Total preparation time for database "testingkuest_6da504_8b6cd8e1750c" (2.06s)
[2022-05-25 11:00:02] testing.DEBUG: ADAPT: ┌── ADAPT - Preparing a Test-Database ──────────────────────────────────────────────────────────┐
[2022-05-25 11:00:02] testing.DEBUG: ADAPT: │ Preparing the database for connection "pgsql" │
[2022-05-25 11:00:02] testing.DEBUG: ADAPT: │ For test "P\Tests\Unit\Actions\Kuests\ApplyToKuestActionTest::it apply to kuest successfully" │
[2022-05-25 11:00:02] testing.DEBUG: ADAPT: └───────────────────────────────────────────────────────────────────────────────────────────────┘
[2022-05-25 11:00:02] testing.DEBUG: ADAPT: ┌── Build Sources ────────────┐
[2022-05-25 11:00:02] testing.DEBUG: ADAPT: │ Pre-migration imports: None │
[2022-05-25 11:00:02] testing.DEBUG: ADAPT: │ Migrations: Yes │
[2022-05-25 11:00:02] testing.DEBUG: ADAPT: │ Seeders: None │
[2022-05-25 11:00:02] testing.DEBUG: ADAPT: │ Snapshots enabled? No │
[2022-05-25 11:00:02] testing.DEBUG: ADAPT: └─────────────────────────────┘
[2022-05-25 11:00:02] testing.DEBUG: ADAPT: ┌── Build Environment ──────────────────────────────────────┐
[2022-05-25 11:00:02] testing.DEBUG: ADAPT: │ Database is reusable? Yes - transaction │
[2022-05-25 11:00:02] testing.DEBUG: ADAPT: │ Using scenarios? Yes │
[2022-05-25 11:00:02] testing.DEBUG: ADAPT: │ For a browser-test? No │
[2022-05-25 11:00:02] testing.DEBUG: ADAPT: │ Verify database after? No │
[2022-05-25 11:00:02] testing.DEBUG: ADAPT: │ Build-hash: "6da5040d1167f82c218d179cd1269344" │
[2022-05-25 11:00:02] testing.DEBUG: ADAPT: │ Snapshot-hash: "7fb646bd1507b9196806e75d7d089292" │
[2022-05-25 11:00:02] testing.DEBUG: ADAPT: │ Scenario-hash: "8b6cd8e1750c1b6b49c53acaf5f6a0da" │
[2022-05-25 11:00:02] testing.DEBUG: ADAPT: └───────────────────────────────────────────────────────────┘
[2022-05-25 11:00:02] testing.DEBUG: ADAPT: ┌── Resolved Database ───────────────────────────┐
[2022-05-25 11:00:02] testing.DEBUG: ADAPT: │ Connection: "pgsql" │
[2022-05-25 11:00:02] testing.DEBUG: ADAPT: │ Driver: "pgsql" │
[2022-05-25 11:00:02] testing.DEBUG: ADAPT: │ Host: "testingpgsql" │
[2022-05-25 11:00:02] testing.DEBUG: ADAPT: │ Database: "testingkuest_6da504_8b6cd8e1750c" │
[2022-05-25 11:00:02] testing.DEBUG: ADAPT: └────────────────────────────────────────────────┘
[2022-05-25 11:00:03] testing.DEBUG: ADAPT: Changed the database for connection "pgsql" to "testingkuest_6da504_8b6cd8e1750c"
[2022-05-25 11:00:03] testing.DEBUG: ADAPT: Database "testingkuest_6da504_8b6cd8e1750c" cannot be reused (94ms)
[2022-05-25 11:00:03] testing.DEBUG: ADAPT: (Reason "An exception occurred when reading the re-use info - "SQLSTATE[42P01]: Undefined table: 7 ERROR: relation "adapt" does not exist
LINE 1: SELECT FROM "adapt" LIMIT 1 OFFSET 0
^ (SQL: SELECT FROM "adapt" LIMIT 1 OFFSET 0)"")
[2022-05-25 11:00:03] testing.DEBUG: ADAPT: Dropped the existing database (178ms)
[2022-05-25 11:00:03] testing.DEBUG: ADAPT: Created a new database (89ms)
[2022-05-25 11:00:04] testing.DEBUG: ADAPT: Ran migrations (565ms)
[2022-05-25 11:00:04] testing.DEBUG: ADAPT: Set up re-use meta-data (4ms)
[2022-05-25 11:00:04] testing.DEBUG: ADAPT: Total preparation time for database "testingkuest_6da504_8b6cd8e1750c" (1.99s)
[2022-05-25 11:00:04] testing.DEBUG: ADAPT: ┌── ADAPT - Preparing a Test-Database ─────────────────────────────────────────────────────┐
[2022-05-25 11:00:04] testing.DEBUG: ADAPT: │ Preparing the database for connection "pgsql" │
[2022-05-25 11:00:04] testing.DEBUG: ADAPT: │ For test "P\Tests\Unit\Actions\Kuests\CloneKuestActionTest::it clone kuest successfully" │
[2022-05-25 11:00:04] testing.DEBUG: ADAPT: └──────────────────────────────────────────────────────────────────────────────────────────┘
[2022-05-25 11:00:04] testing.DEBUG: ADAPT: ┌── Build Sources ────────────┐
[2022-05-25 11:00:04] testing.DEBUG: ADAPT: │ Pre-migration imports: None │
[2022-05-25 11:00:04] testing.DEBUG: ADAPT: │ Migrations: Yes │
[2022-05-25 11:00:04] testing.DEBUG: ADAPT: │ Seeders: None │
[2022-05-25 11:00:04] testing.DEBUG: ADAPT: │ Snapshots enabled? No │
[2022-05-25 11:00:04] testing.DEBUG: ADAPT: └─────────────────────────────┘
[2022-05-25 11:00:04] testing.DEBUG: ADAPT: ┌── Build Environment ──────────────────────────────────────┐
[2022-05-25 11:00:04] testing.DEBUG: ADAPT: │ Database is reusable? Yes - transaction │
[2022-05-25 11:00:04] testing.DEBUG: ADAPT: │ Using scenarios? Yes │
[2022-05-25 11:00:04] testing.DEBUG: ADAPT: │ For a browser-test? No │
[2022-05-25 11:00:05] testing.DEBUG: ADAPT: │ Verify database after? No │
[2022-05-25 11:00:05] testing.DEBUG: ADAPT: │ Build-hash: "6da5040d1167f82c218d179cd1269344" │
[2022-05-25 11:00:05] testing.DEBUG: ADAPT: │ Snapshot-hash: "7fb646bd1507b9196806e75d7d089292" │
[2022-05-25 11:00:05] testing.DEBUG: ADAPT: │ Scenario-hash: "8b6cd8e1750c1b6b49c53acaf5f6a0da" │
[2022-05-25 11:00:05] testing.DEBUG: ADAPT: └───────────────────────────────────────────────────────────┘
[2022-05-25 11:00:05] testing.DEBUG: ADAPT: ┌── Resolved Database ───────────────────────────┐
[2022-05-25 11:00:05] testing.DEBUG: ADAPT: │ Connection: "pgsql" │
[2022-05-25 11:00:05] testing.DEBUG: ADAPT: │ Driver: "pgsql" │
[2022-05-25 11:00:05] testing.DEBUG: ADAPT: │ Host: "testingpgsql" │
[2022-05-25 11:00:05] testing.DEBUG: ADAPT: │ Database: "testingkuest_6da504_8b6cd8e1750c" │
[2022-05-25 11:00:05] testing.DEBUG: ADAPT: └────────────────────────────────────────────────┘
[2022-05-25 11:00:05] testing.DEBUG: ADAPT: Changed the database for connection "pgsql" to "testingkuest_6da504_8b6cd8e1750c"
[2022-05-25 11:00:05] testing.DEBUG: ADAPT: Database "testingkuest_6da504_8b6cd8e1750c" cannot be reused (88ms)
[2022-05-25 11:00:05] testing.DEBUG: ADAPT: (Reason "An exception occurred when reading the re-use info - "SQLSTATE[42P01]: Undefined table: 7 ERROR: relation "adapt" does not exist
LINE 1: SELECT FROM "adapt" LIMIT 1 OFFSET 0
^ (SQL: SELECT FROM "adapt" LIMIT 1 OFFSET 0)"")
[2022-05-25 11:00:05] testing.DEBUG: ADAPT: Dropped the existing database (74ms)
[2022-05-25 11:00:05] testing.DEBUG: ADAPT: Created a new database (81ms)
[2022-05-25 11:00:06] testing.DEBUG: ADAPT: Ran migrations (622ms)
[2022-05-25 11:00:06] testing.DEBUG: ADAPT: Set up re-use meta-data (3ms)
[2022-05-25 11:00:06] testing.DEBUG: ADAPT: Total preparation time for database "testingkuest_6da504_8b6cd8e1750c" (2s)
[2022-05-25 11:00:06] testing.DEBUG: ADAPT: ┌── ADAPT - Preparing a Test-Database ───────────────────────────────────────────────────────────────────────────────────────┐
[2022-05-25 11:00:06] testing.DEBUG: ADAPT: │ Preparing the database for connection "pgsql" │
[2022-05-25 11:00:07] testing.DEBUG: ADAPT: │ For test "P\Tests\Unit\Actions\Kuests\FavoriteKuestCategoryActionTest::it favorite unfavorite kuest category successfully" │
[2022-05-25 11:00:07] testing.DEBUG: ADAPT: └────────────────────────────────────────────────────────────────────────────────────────────────────────────────────────────┘
[2022-05-25 11:00:07] testing.DEBUG: ADAPT: ┌── Build Sources ────────────┐
[2022-05-25 11:00:07] testing.DEBUG: ADAPT: │ Pre-migration imports: None │
[2022-05-25 11:00:07] testing.DEBUG: ADAPT: │ Migrations: Yes │
[2022-05-25 11:00:07] testing.DEBUG: ADAPT: │ Seeders: None │
[2022-05-25 11:00:07] testing.DEBUG: ADAPT: │ Snapshots enabled? No │
[2022-05-25 11:00:07] testing.DEBUG: ADAPT: └─────────────────────────────┘
[2022-05-25 11:00:07] testing.DEBUG: ADAPT: ┌── Build Environment ──────────────────────────────────────┐
[2022-05-25 11:00:07] testing.DEBUG: ADAPT: │ Database is reusable? Yes - transaction │
[2022-05-25 11:00:07] testing.DEBUG: ADAPT: │ Using scenarios? Yes │
[2022-05-25 11:00:07] testing.DEBUG: ADAPT: │ For a browser-test? No │
[2022-05-25 11:00:07] testing.DEBUG: ADAPT: │ Verify database after? No │
[2022-05-25 11:00:07] testing.DEBUG: ADAPT: │ Build-hash: "6da5040d1167f82c218d179cd1269344" │
[2022-05-25 11:00:07] testing.DEBUG: ADAPT: │ Snapshot-hash: "7fb646bd1507b9196806e75d7d089292" │
[2022-05-25 11:00:07] testing.DEBUG: ADAPT: │ Scenario-hash: "8b6cd8e1750c1b6b49c53acaf5f6a0da" │
[2022-05-25 11:00:07] testing.DEBUG: ADAPT: └───────────────────────────────────────────────────────────┘
[2022-05-25 11:00:07] testing.DEBUG: ADAPT: ┌── Resolved Database ───────────────────────────┐
[2022-05-25 11:00:07] testing.DEBUG: ADAPT: │ Connection: "pgsql" │
[2022-05-25 11:00:07] testing.DEBUG: ADAPT: │ Driver: "pgsql" │
[2022-05-25 11:00:07] testing.DEBUG: ADAPT: │ Host: "testingpgsql" │
[2022-05-25 11:00:07] testing.DEBUG: ADAPT: │ Database: "testingkuest_6da504_8b6cd8e1750c" │
[2022-05-25 11:00:07] testing.DEBUG: ADAPT: └────────────────────────────────────────────────┘
[2022-05-25 11:00:07] testing.DEBUG: ADAPT: Changed the database for connection "pgsql" to "testingkuest_6da504_8b6cd8e1750c"
[2022-05-25 11:00:07] testing.DEBUG: ADAPT: Database "testingkuest_6da504_8b6cd8e1750c" cannot be reused (80ms)
[2022-05-25 11:00:07] testing.DEBUG: ADAPT: (Reason "An exception occurred when reading the re-use info - "SQLSTATE[42P01]: Undefined table: 7 ERROR: relation "adapt" does not exist
LINE 1: SELECT FROM "adapt" LIMIT 1 OFFSET 0
^ (SQL: SELECT FROM "adapt" LIMIT 1 OFFSET 0)"")
[2022-05-25 11:00:08] testing.DEBUG: ADAPT: Dropped the existing database (181ms)
[2022-05-25 11:00:08] testing.DEBUG: ADAPT: Created a new database (86ms)
[2022-05-25 11:00:08] testing.DEBUG: ADAPT: Ran migrations (638ms)
[2022-05-25 11:00:08] testing.DEBUG: ADAPT: Set up re-use meta-data (3ms)
[2022-05-25 11:00:08] testing.DEBUG: ADAPT: Total preparation time for database "testingkuest_6da504_8b6cd8e1750c" (2.04s)
[2022-05-25 11:00:09] testing.DEBUG: ADAPT: ┌── ADAPT - Preparing a Test-Database ───────────────────────────────────────────────────────────────────────────────────────────────────┐
[2022-05-25 11:00:09] testing.DEBUG: ADAPT: │ Preparing the database for connection "pgsql" │
[2022-05-25 11:00:09] testing.DEBUG: ADAPT: │ For test "P\Tests\Unit\Actions\Kuests\KuestContractRatedAsDissatisfiedActionTest::it successfully rate kuest contract as dissatisfied" │
[2022-05-25 11:00:09] testing.DEBUG: ADAPT: └────────────────────────────────────────────────────────────────────────────────────────────────────────────────────────────────────────┘
[2022-05-25 11:00:09] testing.DEBUG: ADAPT: ┌── Build Sources ────────────┐
[2022-05-25 11:00:09] testing.DEBUG: ADAPT: │ Pre-migration imports: None │
[2022-05-25 11:00:09] testing.DEBUG: ADAPT: │ Migrations: Yes │
[2022-05-25 11:00:09] testing.DEBUG: ADAPT: │ Seeders: None │
[2022-05-25 11:00:09] testing.DEBUG: ADAPT: │ Snapshots enabled? No │
[2022-05-25 11:00:09] testing.DEBUG: ADAPT: └─────────────────────────────┘
[2022-05-25 11:00:09] testing.DEBUG: ADAPT: ┌── Build Environment ──────────────────────────────────────┐
[2022-05-25 11:00:09] testing.DEBUG: ADAPT: │ Database is reusable? Yes - transaction │
[2022-05-25 11:00:09] testing.DEBUG: ADAPT: │ Using scenarios? Yes │
[2022-05-25 11:00:09] testing.DEBUG: ADAPT: │ For a browser-test? No │
[2022-05-25 11:00:09] testing.DEBUG: ADAPT: │ Verify database after? No │
[2022-05-25 11:00:09] testing.DEBUG: ADAPT: │ Build-hash: "6da5040d1167f82c218d179cd1269344" │
[2022-05-25 11:00:09] testing.DEBUG: ADAPT: │ Snapshot-hash: "7fb646bd1507b9196806e75d7d089292" │
[2022-05-25 11:00:09] testing.DEBUG: ADAPT: │ Scenario-hash: "8b6cd8e1750c1b6b49c53acaf5f6a0da" │
[2022-05-25 11:00:09] testing.DEBUG: ADAPT: └───────────────────────────────────────────────────────────┘
[2022-05-25 11:00:09] testing.DEBUG: ADAPT: ┌── Resolved Database ───────────────────────────┐
[2022-05-25 11:00:09] testing.DEBUG: ADAPT: │ Connection: "pgsql" │
[2022-05-25 11:00:09] testing.DEBUG: ADAPT: │ Driver: "pgsql" │
[2022-05-25 11:00:10] testing.DEBUG: ADAPT: │ Host: "testingpgsql" │
[2022-05-25 11:00:10] testing.DEBUG: ADAPT: │ Database: "testingkuest_6da504_8b6cd8e1750c" │
[2022-05-25 11:00:10] testing.DEBUG: ADAPT: └────────────────────────────────────────────────┘
[2022-05-25 11:00:10] testing.DEBUG: ADAPT: Changed the database for connection "pgsql" to "testingkuest_6da504_8b6cd8e1750c"
[2022-05-25 11:00:10] testing.DEBUG: ADAPT: Database "testingkuest_6da504_8b6cd8e1750c" cannot be reused (85ms)
[2022-05-25 11:00:10] testing.DEBUG: ADAPT: (Reason "An exception occurred when reading the re-use info - "SQLSTATE[42P01]: Undefined table: 7 ERROR: relation "adapt" does not exist
LINE 1: SELECT FROM "adapt" LIMIT 1 OFFSET 0
^ (SQL: SELECT FROM "adapt" LIMIT 1 OFFSET 0)"")
[2022-05-25 11:00:10] testing.DEBUG: ADAPT: Dropped the existing database (181ms)
[2022-05-25 11:00:10] testing.DEBUG: ADAPT: Created a new database (87ms)
[2022-05-25 11:00:11] testing.DEBUG: ADAPT: Ran migrations (576ms)
[2022-05-25 11:00:11] testing.DEBUG: ADAPT: Set up re-use meta-data (3ms)
[2022-05-25 11:00:11] testing.DEBUG: ADAPT: Total preparation time for database "testingkuest_6da504_8b6cd8e1750c" (1.95s)
[2022-05-25 11:00:11] testing.DEBUG: ADAPT: ┌── ADAPT - Preparing a Test-Database ────────────────────────────────────────────────────────────────────────────────────────────────┐
[2022-05-25 11:00:11] testing.DEBUG: ADAPT: │ Preparing the database for connection "pgsql" │
[2022-05-25 11:00:11] testing.DEBUG: ADAPT: │ For test "P\Tests\Unit\Actions\Kuests\KuestContractRatedAsMustReviewActionTest::it successfully rate kuest contract as must review" │
[2022-05-25 11:00:11] testing.DEBUG: ADAPT: └─────────────────────────────────────────────────────────────────────────────────────────────────────────────────────────────────────┘
[2022-05-25 11:00:11] testing.DEBUG: ADAPT: ┌── Build Sources ────────────┐
[2022-05-25 11:00:11] testing.DEBUG: ADAPT: │ Pre-migration imports: None │
[2022-05-25 11:00:11] testing.DEBUG: ADAPT: │ Migrations: Yes │
[2022-05-25 11:00:11] testing.DEBUG: ADAPT: │ Seeders: None │
[2022-05-25 11:00:11] testing.DEBUG: ADAPT: │ Snapshots enabled? No │
[2022-05-25 11:00:12] testing.DEBUG: ADAPT: └─────────────────────────────┘
[2022-05-25 11:00:12] testing.DEBUG: ADAPT: ┌── Build Environment ──────────────────────────────────────┐
[2022-05-25 11:00:12] testing.DEBUG: ADAPT: │ Database is reusable? Yes - transaction │
[2022-05-25 11:00:12] testing.DEBUG: ADAPT: │ Using scenarios? Yes │
[2022-05-25 11:00:12] testing.DEBUG: ADAPT: │ For a browser-test? No │
[2022-05-25 11:00:12] testing.DEBUG: ADAPT: │ Verify database after? No │
[2022-05-25 11:00:12] testing.DEBUG: ADAPT: │ Build-hash: "6da5040d1167f82c218d179cd1269344" │
[2022-05-25 11:00:12] testing.DEBUG: ADAPT: │ Snapshot-hash: "7fb646bd1507b9196806e75d7d089292" │
[2022-05-25 11:00:12] testing.DEBUG: ADAPT: │ Scenario-hash: "8b6cd8e1750c1b6b49c53acaf5f6a0da" │
[2022-05-25 11:00:12] testing.DEBUG: ADAPT: └───────────────────────────────────────────────────────────┘
[2022-05-25 11:00:12] testing.DEBUG: ADAPT: ┌── Resolved Database ───────────────────────────┐
[2022-05-25 11:00:12] testing.DEBUG: ADAPT: │ Connection: "pgsql" │
[2022-05-25 11:00:12] testing.DEBUG: ADAPT: │ Driver: "pgsql" │
[2022-05-25 11:00:12] testing.DEBUG: ADAPT: │ Host: "testingpgsql" │
[2022-05-25 11:00:12] testing.DEBUG: ADAPT: │ Database: "testingkuest_6da504_8b6cd8e1750c" │
[2022-05-25 11:00:12] testing.DEBUG: ADAPT: └────────────────────────────────────────────────┘
[2022-05-25 11:00:12] testing.DEBUG: ADAPT: Changed the database for connection "pgsql" to "testingkuest_6da504_8b6cd8e1750c"
[2022-05-25 11:00:12] testing.DEBUG: ADAPT: Database "testingkuest_6da504_8b6cd8e1750c" cannot be reused (90ms)
[2022-05-25 11:00:12] testing.DEBUG: ADAPT: (Reason "An exception occurred when reading the re-use info - "SQLSTATE[42P01]: Undefined table: 7 ERROR: relation "adapt" does not exist
LINE 1: SELECT FROM "adapt" LIMIT 1 OFFSET 0
^ (SQL: SELECT FROM "adapt" LIMIT 1 OFFSET 0)"")
[2022-05-25 11:00:12] testing.DEBUG: ADAPT: Dropped the existing database (178ms)
[2022-05-25 11:00:13] testing.DEBUG: ADAPT: Created a new database (85ms)
[2022-05-25 11:00:13] testing.DEBUG: ADAPT: Ran migrations (570ms)
[2022-05-25 11:00:13] testing.DEBUG: ADAPT: Set up re-use meta-data (3ms)
[2022-05-25 11:00:13] testing.DEBUG: ADAPT: Total preparation time for database "testingkuest_6da504_8b6cd8e1750c" (2.03s)
[2022-05-25 11:00:14] testing.DEBUG: ADAPT: ┌── ADAPT - Preparing a Test-Database ─────────────────────────────────────────────────────────────────────────────────────────────┐
[2022-05-25 11:00:14] testing.DEBUG: ADAPT: │ Preparing the database for connection "pgsql" │
[2022-05-25 11:00:14] testing.DEBUG: ADAPT: │ For test "P\Tests\Unit\Actions\Kuests\KuestContractRatedAsSatisfiedActionTest::it successfully rate kuest contract as satisfied" │
[2022-05-25 11:00:14] testing.DEBUG: ADAPT: └──────────────────────────────────────────────────────────────────────────────────────────────────────────────────────────────────┘
[2022-05-25 11:00:14] testing.DEBUG: ADAPT: ┌── Build Sources ────────────┐
[2022-05-25 11:00:14] testing.DEBUG: ADAPT: │ Pre-migration imports: None │
[2022-05-25 11:00:14] testing.DEBUG: ADAPT: │ Migrations: Yes │
[2022-05-25 11:00:14] testing.DEBUG: ADAPT: │ Seeders: None │
[2022-05-25 11:00:14] testing.DEBUG: ADAPT: │ Snapshots enabled? No │
[2022-05-25 11:00:14] testing.DEBUG: ADAPT: └─────────────────────────────┘
[2022-05-25 11:00:14] testing.DEBUG: ADAPT: ┌── Build Environment ──────────────────────────────────────┐
[2022-05-25 11:00:14] testing.DEBUG: ADAPT: │ Database is reusable? Yes - transaction │
[2022-05-25 11:00:14] testing.DEBUG: ADAPT: │ Using scenarios? Yes │
[2022-05-25 11:00:14] testing.DEBUG: ADAPT: │ For a browser-test? No │
[2022-05-25 11:00:14] testing.DEBUG: ADAPT: │ Verify database after? No │
[2022-05-25 11:00:14] testing.DEBUG: ADAPT: │ Build-hash: "6da5040d1167f82c218d179cd1269344" │
[2022-05-25 11:00:14] testing.DEBUG: ADAPT: │ Snapshot-hash: "7fb646bd1507b9196806e75d7d089292" │
[2022-05-25 11:00:14] testing.DEBUG: ADAPT: │ Scenario-hash: "8b6cd8e1750c1b6b49c53acaf5f6a0da" │
[2022-05-25 11:00:14] testing.DEBUG: ADAPT: └───────────────────────────────────────────────────────────┘
[2022-05-25 11:00:14] testing.DEBUG: ADAPT: ┌── Resolved Database ───────────────────────────┐
[2022-05-25 11:00:14] testing.DEBUG: ADAPT: │ Connection: "pgsql" │
[2022-05-25 11:00:14] testing.DEBUG: ADAPT: │ Driver: "pgsql" │
[2022-05-25 11:00:14] testing.DEBUG: ADAPT: │ Host: "testingpgsql" │
[2022-05-25 11:00:14] testing.DEBUG: ADAPT: │ Database: "testingkuest_6da504_8b6cd8e1750c" │
[2022-05-25 11:00:14] testing.DEBUG: ADAPT: └────────────────────────────────────────────────┘
[2022-05-25 11:00:14] testing.DEBUG: ADAPT: Changed the database for connection "pgsql" to "testingkuest_6da504_8b6cd8e1750c"
[2022-05-25 11:00:15] testing.DEBUG: ADAPT: Database "testingkuest_6da504_8b6cd8e1750c" cannot be reused (99ms)
[2022-05-25 11:00:15] testing.DEBUG: ADAPT: (Reason "An exception occurred when reading the re-use info - "SQLSTATE[42P01]: Undefined table: 7 ERROR: relation "adapt" does not exist
LINE 1: SELECT FROM "adapt" LIMIT 1 OFFSET 0
^ (SQL: SELECT FROM "adapt" LIMIT 1 OFFSET 0)"")
[2022-05-25 11:00:15] testing.DEBUG: ADAPT: Dropped the existing database (182ms)
[2022-05-25 11:00:15] testing.DEBUG: ADAPT: Created a new database (84ms)
[2022-05-25 11:00:16] testing.DEBUG: ADAPT: Ran migrations (586ms)
[2022-05-25 11:00:16] testing.DEBUG: ADAPT: Set up re-use meta-data (3ms)
[2022-05-25 11:00:16] testing.DEBUG: ADAPT: Total preparation time for database "testingkuest_6da504_8b6cd8e1750c" (2.03s)
[2022-05-25 11:00:16] testing.DEBUG: ADAPT: ┌── ADAPT - Preparing a Test-Database ───────────────────────────────────────────────────────────────────────────────────────────────────┐
[2022-05-25 11:00:16] testing.DEBUG: ADAPT: │ Preparing the database for connection "pgsql" │
[2022-05-25 11:00:16] testing.DEBUG: ADAPT: │ For test "P\Tests\Unit\Actions\Kuests\KuestContractRatedAsSatisfiedActionTest::it successfully rate kuest contract as super satisfied" │
[2022-05-25 11:00:16] testing.DEBUG: ADAPT: └────────────────────────────────────────────────────────────────────────────────────────────────────────────────────────────────────────┘
[2022-05-25 11:00:16] testing.DEBUG: ADAPT: ┌── Build Sources ────────────┐
[2022-05-25 11:00:16] testing.DEBUG: ADAPT: │ Pre-migration imports: None │
[2022-05-25 11:00:16] testing.DEBUG: ADAPT: │ Migrations: Yes │
[2022-05-25 11:00:16] testing.DEBUG: ADAPT: │ Seeders: None │
[2022-05-25 11:00:16] testing.DEBUG: ADAPT: │ Snapshots enabled? No │
[2022-05-25 11:00:16] testing.DEBUG: ADAPT: └─────────────────────────────┘
[2022-05-25 11:00:16] testing.DEBUG: ADAPT: ┌── Build Environment ──────────────────────────────────────┐
[2022-05-25 11:00:16] testing.DEBUG: ADAPT: │ Database is reusable? Yes - transaction │
[2022-05-25 11:00:16] testing.DEBUG: ADAPT: │ Using scenarios? Yes │
[2022-05-25 11:00:16] testing.DEBUG: ADAPT: │ For a browser-test? No │
[2022-05-25 11:00:16] testing.DEBUG: ADAPT: │ Verify database after? No │
[2022-05-25 11:00:16] testing.DEBUG: ADAPT: │ Build-hash: "6da5040d1167f82c218d179cd1269344" │
[2022-05-25 11:00:17] testing.DEBUG: ADAPT: │ Snapshot-hash: "7fb646bd1507b9196806e75d7d089292" │
[2022-05-25 11:00:17] testing.DEBUG: ADAPT: │ Scenario-hash: "8b6cd8e1750c1b6b49c53acaf5f6a0da" │
[2022-05-25 11:00:17] testing.DEBUG: ADAPT: └───────────────────────────────────────────────────────────┘
[2022-05-25 11:00:17] testing.DEBUG: ADAPT: ┌── Resolved Database ───────────────────────────┐
[2022-05-25 11:00:17] testing.DEBUG: ADAPT: │ Connection: "pgsql" │
[2022-05-25 11:00:17] testing.DEBUG: ADAPT: │ Driver: "pgsql" │
[2022-05-25 11:00:17] testing.DEBUG: ADAPT: │ Host: "testingpgsql" │
[2022-05-25 11:00:17] testing.DEBUG: ADAPT: │ Database: "testingkuest_6da504_8b6cd8e1750c" │
[2022-05-25 11:00:17] testing.DEBUG: ADAPT: └────────────────────────────────────────────────┘
[2022-05-25 11:00:17] testing.DEBUG: ADAPT: Changed the database for connection "pgsql" to "testingkuest_6da504_8b6cd8e1750c"
[2022-05-25 11:00:17] testing.DEBUG: ADAPT: Database "testingkuest_6da504_8b6cd8e1750c" cannot be reused (95ms)
[2022-05-25 11:00:17] testing.DEBUG: ADAPT: (Reason "An exception occurred when reading the re-use info - "SQLSTATE[42P01]: Undefined table: 7 ERROR: relation "adapt" does not exist
LINE 1: SELECT FROM "adapt" LIMIT 1 OFFSET 0
^ (SQL: SELECT FROM "adapt" LIMIT 1 OFFSET 0)"")
[2022-05-25 11:00:17] testing.DEBUG: ADAPT: Dropped the existing database (180ms)
[2022-05-25 11:00:17] testing.DEBUG: ADAPT: Created a new database (86ms)
[2022-05-25 11:00:18] testing.DEBUG: ADAPT: Ran migrations (578ms)
[2022-05-25 11:00:18] testing.DEBUG: ADAPT: Set up re-use meta-data (3ms)
[2022-05-25 11:00:18] testing.DEBUG: ADAPT: Total preparation time for database "testingkuest_6da504_8b6cd8e1750c" (2.01s)
[2022-05-25 11:00:18] testing.DEBUG: ADAPT: ┌── ADAPT - Preparing a Test-Database ──────────────────────────────────────────────────────────────────────────────┐
[2022-05-25 11:00:18] testing.DEBUG: ADAPT: │ Preparing the database for connection "pgsql" │
[2022-05-25 11:00:18] testing.DEBUG: ADAPT: │ For test "P\Tests\Unit\Actions\Kuests\PublishKuestActionTest::it publish kuest from draft to active successfully" │
[2022-05-25 11:00:18] testing.DEBUG: ADAPT: └───────────────────────────────────────────────────────────────────────────────────────────────────────────────────┘
[2022-05-25 11:00:19] testing.DEBUG: ADAPT: ┌── Build Sources ────────────┐
[2022-05-25 11:00:19] testing.DEBUG: ADAPT: │ Pre-migration imports: None │
[2022-05-25 11:00:19] testing.DEBUG: ADAPT: │ Migrations: Yes │
[2022-05-25 11:00:19] testing.DEBUG: ADAPT: │ Seeders: None │
[2022-05-25 11:00:19] testing.DEBUG: ADAPT: │ Snapshots enabled? No │
[2022-05-25 11:00:19] testing.DEBUG: ADAPT: └─────────────────────────────┘
[2022-05-25 11:00:19] testing.DEBUG: ADAPT: ┌── Build Environment ──────────────────────────────────────┐
Slow "boot" before testing, slow between each test and with errors.
code-distortion
commented
2 years ago Thanks Bruno, I'll have a look at these tonight
code-distortion
commented
2 years ago Hi Bruno. Thanks again for giving this a test. It looks like it's dropping the database now when it tries to, which is a step forward.
[2022-05-25 10:58:51] testing.DEBUG: ADAPT: Looking for stale things to remove
[2022-05-25 10:58:51] testing.DEBUG: ADAPT: Generated the build-hash - of the files that can be used to build the database (57ms)
[2022-05-25 10:59:52] testing.DEBUG: ADAPT: Nothing found to remove (1.01m)This section here is run once at the beginning of the test-run. It's purpose is to clean up old databases when your any of your migrations, seeders or factories change.
It does this by first generating a "build-hash" based on these directories. If any files change, this hash changes.
Then it connects to your database servers (based on your config's available database.connections), and checks each database it finds to see if it was built by Adapt, but built with an old hash. And If so it removes it.
I can see this is taking a long time to search for databases (1 minute!). This indicates to me that you have lots of databases to search through, but 1 minute seems excessive. It might be because of a time-out of some sort.
I'd like to try and add extra logging to show the steps it's taking here in more detail.
In the time being, you can disable this clean-up step by adding ADAPT_REMOVE_STALE_THINGS=false to your .env.testing file.
(You can always run php artisan adapt:remove yourself manually).
The second part of the problem is more confusing. After building a database, Adapt creates the table ____adapt____ and pops some meta-data into it (like the "build-hash" above). It uses this later to determine if it can re-use the database or not.
This is the step where it creates this meta-table:
[2022-05-25 11:00:18] testing.DEBUG: ADAPT: Set up re-use meta-data (3ms)However every time the next test runs, the table doesn't exist!
I've checked that this package can work against PostgreSQL 8.4 - 14, however perhaps the CREATE TABLE query is failing for some reason in your circumstance...
I'd like to add better checking around creation of this table, to try and understand what's happening better.
I'll get back to you when I've had a good think and look through the code, and added in extra checking + logging.
code-distortion
commented
2 years ago Hi Bruno, thanks for your patience. I just wanted to let you know that I haven't forgotten about this.
ibrunotome
commented
2 years ago That's ok, I'm glad to help.
code-distortion
commented
2 years ago Hi Bruno. I reproduced the error you found!
SQLSTATE[42P01]: Undefined table: 7 ERROR: relation "____adapt____" does not exist
LINE 1: SELECT * FROM "____adapt____" LIMIT 1 OFFSET 0
^ (SQL: SELECT * FROM "____adapt____" LIMIT 1 OFFSET 0)I found this happens when using one of Laravel's own database-building traits: RefreshDatabase, DatabaseTransactions or DatabaseMigrations, at the same time as Adapt.
All you need to do is remove Laravel's traits from your tests. They kind of clash when running at the same time.
I've added a check, Adapt now generates an exception if they're present.
I've released a new version 0.11.0, which includes lots of additional logging. I'm still very interested to see where that whole minute is spent at the beginning, when it looks for stale test-databases to remove.
Would you mind updating to this version, and having another try?
I renamed a number of config settings in this release (I don't want to do this often). So if you published the config file before, please re-publish it again:
php artisan vendor:publish --provider="CodeDistortion\Adapt\AdaptLaravelServiceProvider" --tag="config"Previously, I asked you to set ADAPT_REMOVE_STALE_THINGS=false in .env.testing to skip that first minute. Could you please turn it back on?
Also, I added a new log-verbosity setting, with 0 being the lowest and 2 currently being the highest.
ADAPT_REMOVE_STALE_THINGS=true
ADAPT_LOG_LARAVEL=true
ADAPT_LOG_VERBOSITY=2Hi, my Pest.php
<?php
uses(Tests\TestCase::class)->in(__DIR__);My TestCase.php
<?php
namespace Tests;
use CodeDistortion\Adapt\AdaptDatabase;
use Illuminate\Foundation\Testing\TestCase as BaseTestCase;
abstract class TestCase extends BaseTestCase
{
use CreatesApplication;
use AdaptDatabase;
}Config (everything directly in the file, no ENV variables) https://gist.github.com/ibrunotome/da13d4c181f2c8b1cf4a8cff12320564
Result: tests stars only after 1 minute and all them fail.
Log:
[2022-06-13 12:16:37] testing.DEBUG: ADAPT: Looking for stale things to remove
[2022-06-13 12:16:37] testing.DEBUG: ADAPT: Generated a modified-time based build-checksum (8ms)
[2022-06-13 12:16:37] testing.DEBUG: ADAPT: Retrieved database list (connection: "sqlite", driver: "sqlite") (1ms)
[2022-06-13 12:16:37] testing.DEBUG: ADAPT: - No databases were found (0ms)
[2022-06-13 12:17:37] testing.WARNING: ADAPT: Could not retrieve database list (connection: "mysql", driver: "mysql") (1m)
[2022-06-13 12:17:37] testing.WARNING: ADAPT: Could not retrieve database list (connection: "pgsql", driver: "pgsql") (8ms)
[2022-06-13 12:17:37] testing.WARNING: ADAPT: Could not retrieve database list (connection: "sqlsrv", driver: "sqlsrv") (6ms)
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: Retrieved snapshot list (1ms)
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: - No snapshots were found (0ms)
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: Nothing found to remove - total time taken (1m)
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: ┌── ADAPT (v0.11.0) ──────────────────────────────────────────────────────────────┐
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: │ Preparing a database for connection "pgsql" │
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: │ For test "P\Tests\Unit\Actions\BlockUserActionTest::it block user successfully" │
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: └─────────────────────────────────────────────────────────────────────────────────┘
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: ┌── Build Sources ────────┐
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: │ Initial imports: None │
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: │ Migrations: Yes │
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: │ Seeders: None │
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: │ Snapshots enabled? No │
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: └─────────────────────────┘
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: ┌── Build Environment ───────────────────────────────────┐
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: │ Using scenarios? Yes │
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: │ Re-use type: Transaction │
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: │ Verify db after? No │
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: │ For a browser test? No │
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: │ Parallel testing? No │
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: │ Build-checksum: "ffabea4a72a89c09f8cc7f13696983fd" │
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: │ Snapshot-checksum: "33d736a4f21df109325a50b971d11001" │
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: │ Scenario-checksum: "c48f42f878b7d56b39914ce7f8954f08" │
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: └────────────────────────────────────────────────────────┘
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: ┌── Resolved Database ───────────────────────────┐
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: │ Connection: "pgsql" │
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: │ Driver: "pgsql" │
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: │ Host: "testingpgsql" │
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: │ Database: "testingkuest_ffabea_c48f42f878b7" │
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: └────────────────────────────────────────────────┘
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: Changed the database for connection "pgsql" to "testingkuest_ffabea_c48f42f878b7"
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: Database "testingkuest_ffabea_c48f42f878b7" cannot be reused (157ms)
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: (Reason: An exception occurred when reading the re-use info - "SQLSTATE[42P01]: Undefined table: 7 ERROR: relation "adapt" does not exist
LINE 1: SELECT FROM "adapt" LIMIT 1 OFFSET 0
^ (SQL: SELECT FROM "adapt" LIMIT 1 OFFSET 0)")
[2022-06-13 12:17:37] testing.ERROR: ADAPT: ┌── An Exception Occurred - PDOException ───────────────────────────────────────────────────────────┐
[2022-06-13 12:17:37] testing.ERROR: ADAPT: │ SQLSTATE[08006] [7] invalid port number: "0" │
[2022-06-13 12:17:37] testing.ERROR: ADAPT: │ /var/www/vendor/code-distortion/adapt/src/DI/Injectable/Laravel/AbstractLaravelPDO.php on line 34 │
[2022-06-13 12:17:37] testing.ERROR: ADAPT: └───────────────────────────────────────────────────────────────────────────────────────────────────┘
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: ┌── ADAPT (v0.11.0) ────────────────────────────────────────────────────────────────┐
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: │ Preparing a database for connection "pgsql" │
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: │ For test "P\Tests\Unit\Actions\CloneKuestActionTest::it clone kuest successfully" │
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: └───────────────────────────────────────────────────────────────────────────────────┘
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: ┌── Build Sources ────────┐
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: │ Initial imports: None │
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: │ Migrations: Yes │
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: │ Seeders: None │
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: │ Snapshots enabled? No │
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: └─────────────────────────┘
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: ┌── Build Environment ───────────────────────────────────┐
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: │ Using scenarios? Yes │
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: │ Re-use type: Transaction │
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: │ Verify db after? No │
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: │ For a browser test? No │
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: │ Parallel testing? No │
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: │ Build-checksum: "ffabea4a72a89c09f8cc7f13696983fd" │
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: │ Snapshot-checksum: "33d736a4f21df109325a50b971d11001" │
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: │ Scenario-checksum: "c48f42f878b7d56b39914ce7f8954f08" │
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: └────────────────────────────────────────────────────────┘
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: ┌── Resolved Database ───────────────────────────┐
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: │ Connection: "pgsql" │
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: │ Driver: "pgsql" │
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: │ Host: "testingpgsql" │
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: │ Database: "testingkuest_ffabea_c48f42f878b7" │
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: └────────────────────────────────────────────────┘
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: Changed the database for connection "pgsql" to "testingkuest_ffabea_c48f42f878b7"
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: Database "testingkuest_ffabea_c48f42f878b7" cannot be reused (140ms)
[2022-06-13 12:17:37] testing.DEBUG: ADAPT: (Reason: An exception occurred when reading the re-use info - "SQLSTATE[42P01]: Undefined table: 7 ERROR: relation "adapt" does not exist
LINE 1: SELECT FROM "adapt" LIMIT 1 OFFSET 0
^ (SQL: SELECT FROM "adapt" LIMIT 1 OFFSET 0)")
[2022-06-13 12:17:37] testing.ERROR: ADAPT: ┌── An Exception Occurred - PDOException ───────────────────────────────────────────────────────────┐
[2022-06-13 12:17:37] testing.ERROR: ADAPT: │ SQLSTATE[08006] [7] invalid port number: "0" │
[2022-06-13 12:17:37] testing.ERROR: ADAPT: │ /var/www/vendor/code-distortion/adapt/src/DI/Injectable/Laravel/AbstractLaravelPDO.php on line 34 │
[2022-06-13 12:17:37] testing.ERROR: ADAPT: └───────────────────────────────────────────────────────────────────────────────────────────────────┘
ibrunotome
commented
2 years ago P.S: my tests are passing in ~150s without the package (most of them use database)
That's my TestCase without your package:
namespace Tests;
use Illuminate\Foundation\Testing\DatabaseTransactions;
use Illuminate\Foundation\Testing\TestCase as BaseTestCase;
use Illuminate\Support\Facades\DB;
abstract class TestCase extends BaseTestCase
{
use CreatesApplication;
use DatabaseTransactions;
protected function setUp(): void
{
parent::setUp();
DB::transactionLevel() && DB::rollBack();
}
}Thanks very much. Sorry, I was wrong, I was really confident I'd found the cause of the issue. I'm glad I added the check for Laravel's traits, but there's more looking I need to do into Pest.
Regarding the start-up delay, Adapt connects to each connection listed in databases.connections.* from your config - to check for test-databases that were built using a previous version of your migrations, seeders and factories. It's spending 1 minute trying to connect to MySQL.
I'm pretty sure you don't have a MySQL server set up so this particular step is unnecessary. You can skip this by commenting out unused connections from configs/database.php.
I will have a look to see if I can reproduce the delay, and if there's a way to mitigate it.
code-distortion
commented
2 years ago Hi Bruno,
I haven't found any problems when running Pest and PostgreSQL together, however there is something else I've looked in to that might cause the problem you've found.
I was aware of an issue, but it occurred in more obscure circumstances: Adapt chooses the names of its databases dynamically. If Laravel connects to the database before Adapt runs, that connection and database name is maintained, even though Adapt thinks it's picking and choosing a new database to use.
When this happens, Adapt won't work correctly.
I've found a few packages that cause this to happen, but not when running tests from the command-line. These packages connect to the database before Adapt runs when browser test requests come in:
I'm sure there's many more. It's possible that something like this is causing Laravel to connect to the database for you, before your tests run.
To counter this, I've added a check when Adapt boots up, to see if any database connections have already been established. If so, they're disconnected from before proceeding.
After updating to the latest version of Adapt, if you see a line like this in your logs, then we'll know this has been happening.
testing.DEBUG: ADAPT: Disconnecting established database connection "pgsql"Regarding the start-up delay, I've reproduced the 1 minute connection time-out. When the PDO MySQL client tries to connect to a PostgreSQL server, it seems to cause this large delay.
I'm still thinking about how to tackle this problem. This clean-up feature could be disabled as I definitely want users to have a quick first experience when using the package. However, having Adapt clean up old databases is a useful part of the system.
For right now, my previous suggestions are still relevant.
You can avoid the problem by commenting out unused connections in config/database.php
return [
// …
'connections' => [
// 'sqlite' => [
// 'driver' => 'sqlite',
// 'url' => env('DATABASE_URL'),
// 'database' => env('DB_DATABASE', database_path('database.sqlite')),
// 'prefix' => '',
// 'foreign_key_constraints' => env('DB_FOREIGN_KEYS', true),
// ],
//
// 'mysql' => [
// 'driver' => 'mysql',
// 'url' => env('DATABASE_URL'),
// 'host' => env('DB_HOST', '127.0.0.1'),
// 'port' => env('DB_PORT', '3306'),
// 'database' => env('DB_DATABASE', 'forge'),
// 'username' => env('DB_USERNAME', 'forge'),
// 'password' => env('DB_PASSWORD', ''),
// 'unix_socket' => env('DB_SOCKET', ''),
// 'charset' => 'utf8mb4',
// 'collation' => 'utf8mb4_unicode_ci',
// 'prefix' => '',
// 'prefix_indexes' => true,
// 'strict' => true,
// 'engine' => null,
// 'options' => extension_loaded('pdo_mysql') ? array_filter([
// PDO::MYSQL_ATTR_SSL_CA => env('MYSQL_ATTR_SSL_CA'),
// ]) : [],
// ],
'pgsql' => [
'driver' => 'pgsql',
'url' => env('DATABASE_URL'),
'host' => env('DB_HOST', '127.0.0.1'),
'port' => env('DB_PORT', '5432'),
'database' => env('DB_DATABASE', 'forge'),
'username' => env('DB_USERNAME', 'forge'),
'password' => env('DB_PASSWORD', ''),
'charset' => 'utf8',
'prefix' => '',
'prefix_indexes' => true,
'search_path' => 'public',
'sslmode' => 'prefer',
],
// 'sqlsrv' => [
// 'driver' => 'sqlsrv',
// 'url' => env('DATABASE_URL'),
// 'host' => env('DB_HOST', 'localhost'),
// 'port' => env('DB_PORT', '1433'),
// 'database' => env('DB_DATABASE', 'forge'),
// 'username' => env('DB_USERNAME', 'forge'),
// 'password' => env('DB_PASSWORD', ''),
// 'charset' => 'utf8',
// 'prefix' => '',
// 'prefix_indexes' => true,
// // 'encrypt' => env('DB_ENCRYPT', 'yes'),
// // 'trust_server_certificate' => env('DB_TRUST_SERVER_CERTIFICATE', 'false'),
// ],
],
// …
];Or you can disable the clean-up feature by adding this to your .env.testing file:
ADAPT_REMOVE_STALE_THINGS=falseOk, the package starts to work after comment the other database connections, but:
testing.DEBUG: ADAPT: Disconnecting established database connection "pgsql" still appearing (telescope and debugbar disabled)abstract class TestCase extends BaseTestCase
{
use CreatesApplication;
use AdaptDatabase;
protected function setUp(): void
{
parent::setUp();
DB::transactionLevel() && DB::rollBack();
}
}because of: https://github.com/bavix/laravel-wallet/issues/463#issuecomment-1094248201
With this setting, my tests run with 268 seconds with debug enabled, 188 seconds with debug disabled, all tests passed successfully (just to remember, ~154s without your pacakge)
If I remove the setUp:
Tests: 58 failed, 1 skipped, 280 passed Time: 137.91s
(because of that linked issue above)
Anyway, I don't know if this info is relevant 😆
ibrunotome
commented
2 years ago Running with --parallel flag:
Failed to create pgsql database "testingkuest_7bc960_c48f42f878b7_1"
Anyway, i never had good results with parallel test, mostly because almost all of my tests use database.
code-distortion
commented
2 years ago Hi Bruno, Great. It looks like things are progressing.
There's a few things here to unpack (I'm sorry, this response is quite long):
First: I've spun the issue of timing-out when looking for stale databases to remove into a separate issue. I think it's important to look into, but unrelated to the main things happening here.
Secondly: Regarding the message Disconnecting established database connection "pgsql"… "something" is connecting to the database before Adapt runs (perhaps via service-providers). I'm not really sure what at this stage. I'd be interested in finding out more about the types of things that do this. It's hard for Adapt package to detect what's connecting however, as all it can see is that a connection is active when it starts.
Because Adapt is showing the log message, this confirms that this is what was causing the error you found earlier:
SQLSTATE[42P01]: Undefined table: 7 ERROR: relation "____adapt____" does not exist
LINE 1: SELECT * FROM "____adapt____" LIMIT 1 OFFSET 0
^ (SQL: SELECT * FROM "____adapt____" LIMIT 1 OFFSET 0)This now means that Adapt should be able to create and use the database it intends to, which is a great step forward. What I can't be sure of is what the other thing that's connecting to the database is doing, and if this disconnection + connection to a new database will cause a problem for that thing.
debugbar and telescope are just two that I'm aware of that can connect in some circumstances (not when tests run, but when browser-tests make their requests back to the application), but I'm sure there are other things that connect before tests run. If anybody has some info I'm interested to hear.
Thirdly: (I think that the tests that use bavix/laravel-wallet are a special case and I'll address that separately below).
Now that Adapt can create and connect to the correct database properly, I'd like to isolate Adapt away from laravel-wallet for a second, and try a simple test. Would you mind trying this test, and copy the logs here?
/tests/Pest.php
<?php
/*
|--------------------------------------------------------------------------
| Test Case
|--------------------------------------------------------------------------
|
| The closure you provide to your test functions is always bound to a specific PHPUnit test
| case class. By default, that class is "PHPUnit\Framework\TestCase". Of course, you may
| need to change it using the "uses()" function to bind a different classes or traits.
|
*/
uses(Tests\TestCase::class)->in('Feature');/tests/TestCase.php
<?php
namespace Tests;
use Illuminate\Foundation\Testing\TestCase as BaseTestCase;
abstract class TestCase extends BaseTestCase
{
use CreatesApplication;
// i.e. no RefreshDatabase, LazilyRefreshDatabase or DB::rollBack();
}/tests/Feature/CreatesUsersTest.php
<?php
use App\Models\User;
use CodeDistortion\Adapt\AdaptDatabase;
uses(AdaptDatabase::class);
it('creates a user 1', function () {
$user = User::factory()->create();
$this->assertTrue(User::query()->latest('id')->first()->is($user));
});
it('creates a user 2', function () {
$user = User::factory()->create();
$this->assertTrue(User::query()->latest('id')->first()->is($user));
});.env.testing
ADAPT_LOG_LARAVEL=true
ADAPT_LOG_VERBOSITY=2Then run: ./vendor/bin/pest --filter=CreatesUsersTest
Fourthly: I've read the https://github.com/bavix/laravel-wallet/issues/463 thread and here are my observations:
bavix/laravel-wallet uses a transaction internally when it does certain thingsLazilyRefreshDatabase until now so thank you for introducing it to me (it isn't currently mentioned in their documentation). This triggers laravel-wallet's exception because it starts a new transaction later on, after DB::transactionLevel() && DB::rollBack(); tried to roll-back the transaction at the beginningRefreshDatabase and AdaptDatabase start a transaction before your tests start. They do this so it can be rolled back after the test finishes, leaving it in a clean + known-state (and this rollback is quick!). When you add DB::transactionLevel() && DB::rollBack(); to the setUp() method, this transaction is rolled back (i.e. destroyed), and you lose the benefit of it altogether. You're right in your observation, this would give a dirty database for the following tests.I think that looking at the speed of your tests would be the wrong thing to start with here. The crux of the problem is that when testing laravel-wallet, you can't use transactions to restore the database back to a clean state. This happens in other situations too, like when running browser tests, for example.
The only ways to approach this is to use an alternative method to restore the database to the clean state, or to build the database again for each test.
As an alternative method, you could try to return it to a clean state yourself. Like you mentioned, you tried by truncating tables. This gives you the responsibility of making sure the database is clean. It might work well, but I can't really comment or help you with this.
If you want to build the database for each test to be sure it's clean, you have a few options:
DatabaseMigrations trait. It simply runs the migrations before every test that uses it (this is what you'd probably do when running browser-tests, and squashing migrations might help here)AdaptDatabase, but turn transactions off (ADAPT_REUSE_TRANSACTIONS=false in your .env.testing, or $reuseTransaction=false inside your test-class). Adapt will rebuild your database each time - squashing will help here as welluse_snapshots_when_not_reusing_db setting in Adapt's config - and I'm sorry but this is one setting that I'm considering altering the config structure for in a future release)Lastly: Parallel testing - I'm interested to see the logs from a test where Adapt couldn't create the database. (Getting logs from parallel tests is trickier because multiple processes write to it at the same time. You could reduce your test-suite down to a single test, and run that in parallel to make it clearer)
code-distortion
commented
2 years ago Interestingly, bavix/laravel-wallet's use of transactions is the intended use case for using transactions. It's very literally the classic example of some code that wants to debit or credit an account, and ensure that some other things happen as well.
I think it's understandable that they'd want to use transactions.
ibrunotome
commented
2 years ago His package forces to use his own transaction implementation (with cache) https://bavix.github.io/laravel-wallet/#/transaction
(didn't tested your suggestions in the last comment yet)
code-distortion
commented
2 years ago Hi Bruno. I just wanted to thank you. Because of your queries, I've been able to address these problems, which make Adapt more robust:
RefreshDatabase, DatabaseMigrations and DatabaseTransactions aren't used at the same time as AdaptDatabase - doing so would lead to unexpected results. Adapt now throws an exception when detected,I've released a new version of Adapt - 0.12.0. And along with this release I've also created a dedicated site for Adapt's documentation. I think this format has helped me explain the concepts better that a README.md could.
(I'm sorry but the config file's structure has changed again. I wanted to improve the structure, and as far as configs go, doing so sooner is better because less people will be affected. I think this format is easier to understand).
I'm still interested to find out what your experience like is when using Adapt with a Postgres database, when running tests that don't use bavix/laravel-wallet (i.e. tests that don't need transactions themselves).
And I'm still thinking of ways to isolate the problem you found when parallel testing. Having lots of tests that use databases shouldn't really be a reason for tests to fail.
Failed to create pgsql database "testingkuest_7bc960_c48f42f878b7_1"Hi, by the way, what's your real name? 😅
Tested, working good with a nice developer experience using the default settings.
With debug verbosity 2 enabled:
With debug disabled:
Parallel (4 workers) with debug disabled:
(This is the first time in the history that parallel tests was faster than serial tests 😆)
Little bug:
To use your package I must define the pgsql config this way:
'pgsql' => [
'driver' => 'pgsql',
'url' => env('DATABASE_URL'),
'host' => env('DB_HOST', '127.0.0.1'),
'port' => env('DB_WRITE_PORT', 5432),
'sticky' => true,
'database' => env('DB_DATABASE', 'forge'),
'username' => env('DB_USERNAME', 'forge'),
'password' => env('DB_PASSWORD', ''),
'charset' => 'utf8',
'prefix' => '',
'prefix_indexes' => true,
'search_path' => 'public',
'sslmode' => 'prefer',
],With no multiple read connections, as I'm used to doing:
'pgsql' => [
'driver' => 'pgsql',
'url' => env('DATABASE_URL'),
'read' => [
[
'host' => env('DB_HOST', '127.0.0.1'),
'port' => env('DB_REPLICA1_PORT', 5432),
],
[
'host' => env('DB_HOST', '127.0.0.1'),
'port' => env('DB_REPLICA2_PORT', 5432),
],
],
'write' => [
'host' => env('DB_HOST', '127.0.0.1'),
'port' => env('DB_WRITE_PORT', 5432),
],
'sticky' => true,
'database' => env('DB_DATABASE', 'forge'),
'username' => env('DB_USERNAME', 'forge'),
'password' => env('DB_PASSWORD', ''),
'charset' => 'utf8',
'prefix' => '',
'prefix_indexes' => true,
'search_path' => 'public',
'sslmode' => 'prefer',
],I'm not using multiple database connections in local/testing environment, but I use it in production, so this setting was working perfectly for all environments without the Adapt package. The error was like "cannot create database, trying to connect to port 0" or something like that.
I'm still interested to find out what your experience like is when using Adapt with a Postgres database, when running tests that don't use bavix/laravel-wallet (i.e. tests that don't need transactions themselves).
Unfortunately I don't have other use case with postgres here :/
code-distortion
commented
2 years ago Hi Bruno. Great, I'm glad it's working more out-of-the-box for you now.
Don't worry about other use-cases. The feedback you've been able to give from your existing tests has been very valuable.
Thanks for letting me know about the read / write configuration issue. Adapt uses your database details to create new databases etc. But it doesn't yet know about the config structure when using Laravel's read / write option.
I'll have a look in to this.
And, my name is Tim.
Hi, I found your article about fast database tests and then this package, pgsql driver is in your plans?