veza/veza-backend-api/output.txt

198 lines
20 KiB
Text
Raw Blame History

This file contains invisible Unicode characters

This file contains invisible Unicode characters that are indistinguishable to humans but may be processed differently by a computer. If you think that this is intentional, you can safely ignore this warning. Use the Escape button to reveal them.

=== RUN TestDuplicatePlaylist_Success
2025/12/07 11:23:24 github.com/testcontainers/testcontainers-go - Connected to docker:
Server Version: 28.1.1
API Version: 1.46
Operating System: Fedora Linux 40 (Workstation Edition)
Total Memory: 15703 MB
Testcontainers for Go Version: v0.33.0
Resolved Docker Host: unix:///var/run/docker.sock
Resolved Docker Socket Path: /var/run/docker.sock
Test SessionID: 2b0e6583d78b45c8d90f78a6cbdc9a3c90ee50500a3c76145760dabeffa25f9f
Test ProcessID: 01a186b2-6902-4d82-921b-b87ef18d90ef
2025/12/07 11:23:24 🐳 Creating container for image testcontainers/ryuk:0.8.1
2025/12/07 11:23:31 ✅ Container created: 36247c2b4dbf
2025/12/07 11:23:31 🐳 Starting container: 36247c2b4dbf
2025/12/07 11:23:31 ✅ Container started: 36247c2b4dbf
2025/12/07 11:23:31 ⏳ Waiting for container id 36247c2b4dbf image: testcontainers/ryuk:0.8.1. Waiting for: &{Port:8080/tcp timeout:<nil> PollInterval:100ms skipInternalCheck:false}
2025/12/07 11:23:31 🔔 Container is ready: 36247c2b4dbf
2025/12/07 11:23:31 🐳 Creating container for image postgres:15-alpine
2025/12/07 11:23:41 ✅ Container created: 67a43ba9a0e9
2025/12/07 11:24:37 🐳 Starting container: 67a43ba9a0e9
2025/12/07 11:24:38 ✅ Container started: 67a43ba9a0e9
2025/12/07 11:24:38 ⏳ Waiting for container id 67a43ba9a0e9 image: postgres:15-alpine. Waiting for: &{timeout:<nil> deadline:0xc000474548 Strategies:[0xc0002a2720]}
2025/12/07 11:24:40 🔔 Container is ready: 67a43ba9a0e9
2025/12/07 11:24:42 /home/senke/Documents/veza/veza-backend-api/tests/transactions/playlist_duplicate_transaction_test.go:77 ERROR: null value in column "creator_id" of relation "tracks" violates not-null constraint (SQLSTATE 23502)
[2.079ms] [rows:0] INSERT INTO "tracks" ("id","user_id","title","artist","album","duration","genre","year","file_path","file_size","format","bitrate","sample_rate","waveform_path","cover_art_path","is_public","status","status_message","stream_status","stream_manifest_url","play_count","like_count","created_at","updated_at","deleted_at") VALUES ('0267f30f-8c44-4740-92cc-6a398156486f','243c6a99-0ada-4cd4-b452-00bcc5c5ab8a','Test Track 579c33ac','Test Artist','',180,'',0,'/test/track.mp3',5242880,'mp3',0,0,'','',true,'completed','','pending','',0,0,'2025-12-07 11:24:42.201','2025-12-07 11:24:42.201',NULL)
playlist_duplicate_transaction_test.go:78:
Error Trace: /home/senke/Documents/veza/veza-backend-api/tests/transactions/playlist_duplicate_transaction_test.go:78
/home/senke/Documents/veza/veza-backend-api/tests/transactions/playlist_duplicate_transaction_test.go:96
/home/senke/Documents/veza/veza-backend-api/tests/transactions/playlist_duplicate_transaction_test.go:133
Error: Received unexpected error:
ERROR: null value in column "creator_id" of relation "tracks" violates not-null constraint (SQLSTATE 23502)
Test: TestDuplicatePlaylist_Success
--- FAIL: TestDuplicatePlaylist_Success (78.29s)
=== RUN TestDuplicatePlaylist_RollbackOnPlaylistNotFound
2025/12/07 11:24:42 /home/senke/Documents/veza/veza-backend-api/internal/services/playlist_duplicate_service.go:56 record not found
[2.597ms] [rows:0] SELECT * FROM "playlists" WHERE id = '3c709430-4b7c-41e7-acae-c54469d6b719' AND "playlists"."deleted_at" IS NULL ORDER BY "playlists"."id" LIMIT 1
--- PASS: TestDuplicatePlaylist_RollbackOnPlaylistNotFound (0.81s)
=== RUN TestDuplicatePlaylist_RollbackOnTrackError
2025/12/07 11:24:43 /home/senke/Documents/veza/veza-backend-api/tests/transactions/playlist_duplicate_transaction_test.go:77 ERROR: null value in column "creator_id" of relation "tracks" violates not-null constraint (SQLSTATE 23502)
[1.728ms] [rows:0] INSERT INTO "tracks" ("id","user_id","title","artist","album","duration","genre","year","file_path","file_size","format","bitrate","sample_rate","waveform_path","cover_art_path","is_public","status","status_message","stream_status","stream_manifest_url","play_count","like_count","created_at","updated_at","deleted_at") VALUES ('ff00921f-c219-4ee9-9709-38839d709e7d','298f0470-78eb-4750-85d3-a5300fe677b2','Test Track 8ffde33d','Test Artist','',180,'',0,'/test/track.mp3',5242880,'mp3',0,0,'','',true,'completed','','pending','',0,0,'2025-12-07 11:24:43.737','2025-12-07 11:24:43.737',NULL)
playlist_duplicate_transaction_test.go:78:
Error Trace: /home/senke/Documents/veza/veza-backend-api/tests/transactions/playlist_duplicate_transaction_test.go:78
/home/senke/Documents/veza/veza-backend-api/tests/transactions/playlist_duplicate_transaction_test.go:96
/home/senke/Documents/veza/veza-backend-api/tests/transactions/playlist_duplicate_transaction_test.go:216
Error: Received unexpected error:
ERROR: null value in column "creator_id" of relation "tracks" violates not-null constraint (SQLSTATE 23502)
Test: TestDuplicatePlaylist_RollbackOnTrackError
--- FAIL: TestDuplicatePlaylist_RollbackOnTrackError (0.86s)
=== RUN TestDuplicatePlaylist_Coherence
2025/12/07 11:24:44 /home/senke/Documents/veza/veza-backend-api/tests/transactions/playlist_duplicate_transaction_test.go:77 ERROR: null value in column "creator_id" of relation "tracks" violates not-null constraint (SQLSTATE 23502)
[1.733ms] [rows:0] INSERT INTO "tracks" ("id","user_id","title","artist","album","duration","genre","year","file_path","file_size","format","bitrate","sample_rate","waveform_path","cover_art_path","is_public","status","status_message","stream_status","stream_manifest_url","play_count","like_count","created_at","updated_at","deleted_at") VALUES ('b6e91dd5-9480-4b0c-9d96-9688db99a827','09fb130c-b3c9-4e91-8f8e-2fc60b28b84e','Test Track cf64d0de','Test Artist','',180,'',0,'/test/track.mp3',5242880,'mp3',0,0,'','',true,'completed','','pending','',0,0,'2025-12-07 11:24:44.812','2025-12-07 11:24:44.812',NULL)
playlist_duplicate_transaction_test.go:78:
Error Trace: /home/senke/Documents/veza/veza-backend-api/tests/transactions/playlist_duplicate_transaction_test.go:78
/home/senke/Documents/veza/veza-backend-api/tests/transactions/playlist_duplicate_transaction_test.go:96
/home/senke/Documents/veza/veza-backend-api/tests/transactions/playlist_duplicate_transaction_test.go:274
Error: Received unexpected error:
ERROR: null value in column "creator_id" of relation "tracks" violates not-null constraint (SQLSTATE 23502)
Test: TestDuplicatePlaylist_Coherence
--- FAIL: TestDuplicatePlaylist_Coherence (0.93s)
=== RUN TestDuplicatePlaylist_EmptyPlaylist
logger.go:146: 2025-12-07T11:24:45.590+0100 INFO Playlist duplicated {"original_playlist_id": "90687653-a53b-4ad4-ae42-0bcdd45cd753", "new_playlist_id": "6506ff1f-3424-4fc2-9a5d-d1d18875ceed", "user_id": "5065a477-e86f-4f83-8405-35972c836550", "tracks_count": 0}
--- PASS: TestDuplicatePlaylist_EmptyPlaylist (0.77s)
=== RUN TestAssignRoleToUser_Success
2025/12/07 11:24:46 /home/senke/Documents/veza/veza-backend-api/internal/services/rbac_service.go:175 sql: Scan error on column index 0, name "id": converting driver.Value type string ("11c43f22-4005-4733-a813-ffac46548325") to a uint8: invalid syntax
[0.786ms] [rows:1] SELECT id FROM users WHERE id = '11c43f22-4005-4733-a813-ffac46548325' FOR UPDATE
2025/12/07 11:24:46 /home/senke/Documents/veza/veza-backend-api/internal/services/rbac_service.go:206 record not found
[2.092ms] [rows:0] SELECT * FROM "user_roles" WHERE user_id = '11c43f22-4005-4733-a813-ffac46548325' AND role_id = 'e5a3352f-eee8-43e8-8215-491deaf27ce4' ORDER BY "user_roles"."id" LIMIT 1 FOR UPDATE
logger.go:146: 2025-12-07T11:24:46.255+0100 INFO Role assigned to user successfully {"user_id": "11c43f22-4005-4733-a813-ffac46548325", "role_id": "e5a3352f-eee8-43e8-8215-491deaf27ce4"}
--- PASS: TestAssignRoleToUser_Success (0.68s)
=== RUN TestAssignRoleToUser_RollbackOnUserNotFound
2025/12/07 11:24:46 /home/senke/Documents/veza/veza-backend-api/internal/services/rbac_service.go:186 record not found
[2.512ms] [rows:0] SELECT * FROM "users" WHERE "users"."id" = 'de704f52-1582-4570-820d-e0b1cedc79a1' AND "users"."deleted_at" IS NULL ORDER BY "users"."id" LIMIT 1 FOR UPDATE
--- PASS: TestAssignRoleToUser_RollbackOnUserNotFound (0.57s)
=== RUN TestAssignRoleToUser_RollbackOnRoleNotFound
2025/12/07 11:24:47 /home/senke/Documents/veza/veza-backend-api/internal/services/rbac_service.go:175 sql: Scan error on column index 0, name "id": converting driver.Value type string ("e468e35d-44f9-437c-bbf8-552e5d5c661e") to a uint8: invalid syntax
[0.947ms] [rows:1] SELECT id FROM users WHERE id = 'e468e35d-44f9-437c-bbf8-552e5d5c661e' FOR UPDATE
2025/12/07 11:24:47 /home/senke/Documents/veza/veza-backend-api/internal/services/rbac_service.go:195 record not found
[0.905ms] [rows:0] SELECT * FROM "roles" WHERE "roles"."id" = '2572083a-1f04-4e93-be0e-a8826179cf4f' ORDER BY "roles"."id" LIMIT 1 FOR UPDATE
--- PASS: TestAssignRoleToUser_RollbackOnRoleNotFound (0.49s)
=== RUN TestAssignRoleToUser_RollbackOnDuplicate
2025/12/07 11:24:47 /home/senke/Documents/veza/veza-backend-api/internal/services/rbac_service.go:175 sql: Scan error on column index 0, name "id": converting driver.Value type string ("ace322b8-8940-4b6e-8aba-ff57b157a4b1") to a uint8: invalid syntax
[1.383ms] [rows:1] SELECT id FROM users WHERE id = 'ace322b8-8940-4b6e-8aba-ff57b157a4b1' FOR UPDATE
2025/12/07 11:24:47 /home/senke/Documents/veza/veza-backend-api/internal/services/rbac_service.go:206 record not found
[1.257ms] [rows:0] SELECT * FROM "user_roles" WHERE user_id = 'ace322b8-8940-4b6e-8aba-ff57b157a4b1' AND role_id = '7f6bc073-2e73-4d37-aa45-bea24c55981e' ORDER BY "user_roles"."id" LIMIT 1 FOR UPDATE
logger.go:146: 2025-12-07T11:24:47.899+0100 INFO Role assigned to user successfully {"user_id": "ace322b8-8940-4b6e-8aba-ff57b157a4b1", "role_id": "7f6bc073-2e73-4d37-aa45-bea24c55981e"}
2025/12/07 11:24:47 /home/senke/Documents/veza/veza-backend-api/internal/services/rbac_service.go:175 sql: Scan error on column index 0, name "id": converting driver.Value type string ("ace322b8-8940-4b6e-8aba-ff57b157a4b1") to a uint8: invalid syntax
[0.443ms] [rows:1] SELECT id FROM users WHERE id = 'ace322b8-8940-4b6e-8aba-ff57b157a4b1' FOR UPDATE
--- PASS: TestAssignRoleToUser_RollbackOnDuplicate (0.55s)
=== RUN TestAssignRoleToUser_Concurrency
2025/12/07 11:24:48 /home/senke/Documents/veza/veza-backend-api/internal/services/rbac_service.go:175 sql: Scan error on column index 0, name "id": converting driver.Value type string ("5aefa230-0589-4040-9b83-c120025843db") to a uint8: invalid syntax
[1.428ms] [rows:1] SELECT id FROM users WHERE id = '5aefa230-0589-4040-9b83-c120025843db' FOR UPDATE
2025/12/07 11:24:48 /home/senke/Documents/veza/veza-backend-api/internal/services/rbac_service.go:206 record not found
[2.932ms] [rows:0] SELECT * FROM "user_roles" WHERE user_id = '5aefa230-0589-4040-9b83-c120025843db' AND role_id = '9db728ed-7024-4f0a-98ab-d92897930a7e' ORDER BY "user_roles"."id" LIMIT 1 FOR UPDATE
logger.go:146: 2025-12-07T11:24:48.456+0100 INFO Role assigned to user successfully {"user_id": "5aefa230-0589-4040-9b83-c120025843db", "role_id": "9db728ed-7024-4f0a-98ab-d92897930a7e"}
2025/12/07 11:24:48 /home/senke/Documents/veza/veza-backend-api/internal/services/rbac_service.go:175 sql: Scan error on column index 0, name "id": converting driver.Value type string ("5aefa230-0589-4040-9b83-c120025843db") to a uint8: invalid syntax
[10.655ms] [rows:1] SELECT id FROM users WHERE id = '5aefa230-0589-4040-9b83-c120025843db' FOR UPDATE
2025/12/07 11:24:48 /home/senke/Documents/veza/veza-backend-api/internal/services/rbac_service.go:175 sql: Scan error on column index 0, name "id": converting driver.Value type string ("5aefa230-0589-4040-9b83-c120025843db") to a uint8: invalid syntax
[17.798ms] [rows:1] SELECT id FROM users WHERE id = '5aefa230-0589-4040-9b83-c120025843db' FOR UPDATE
2025/12/07 11:24:48 /home/senke/Documents/veza/veza-backend-api/internal/services/rbac_service.go:175 sql: Scan error on column index 0, name "id": converting driver.Value type string ("5aefa230-0589-4040-9b83-c120025843db") to a uint8: invalid syntax
[21.313ms] [rows:1] SELECT id FROM users WHERE id = '5aefa230-0589-4040-9b83-c120025843db' FOR UPDATE
2025/12/07 11:24:48 /home/senke/Documents/veza/veza-backend-api/internal/services/rbac_service.go:175 sql: Scan error on column index 0, name "id": converting driver.Value type string ("5aefa230-0589-4040-9b83-c120025843db") to a uint8: invalid syntax
[34.158ms] [rows:1] SELECT id FROM users WHERE id = '5aefa230-0589-4040-9b83-c120025843db' FOR UPDATE
2025/12/07 11:24:48 /home/senke/Documents/veza/veza-backend-api/internal/services/rbac_service.go:175 sql: Scan error on column index 0, name "id": converting driver.Value type string ("5aefa230-0589-4040-9b83-c120025843db") to a uint8: invalid syntax
[38.100ms] [rows:1] SELECT id FROM users WHERE id = '5aefa230-0589-4040-9b83-c120025843db' FOR UPDATE
2025/12/07 11:24:48 /home/senke/Documents/veza/veza-backend-api/internal/services/rbac_service.go:175 sql: Scan error on column index 0, name "id": converting driver.Value type string ("5aefa230-0589-4040-9b83-c120025843db") to a uint8: invalid syntax
[48.667ms] [rows:1] SELECT id FROM users WHERE id = '5aefa230-0589-4040-9b83-c120025843db' FOR UPDATE
2025/12/07 11:24:48 /home/senke/Documents/veza/veza-backend-api/internal/services/rbac_service.go:175 sql: Scan error on column index 0, name "id": converting driver.Value type string ("5aefa230-0589-4040-9b83-c120025843db") to a uint8: invalid syntax
[57.975ms] [rows:1] SELECT id FROM users WHERE id = '5aefa230-0589-4040-9b83-c120025843db' FOR UPDATE
2025/12/07 11:24:48 /home/senke/Documents/veza/veza-backend-api/internal/services/rbac_service.go:175 sql: Scan error on column index 0, name "id": converting driver.Value type string ("5aefa230-0589-4040-9b83-c120025843db") to a uint8: invalid syntax
[66.207ms] [rows:1] SELECT id FROM users WHERE id = '5aefa230-0589-4040-9b83-c120025843db' FOR UPDATE
2025/12/07 11:24:48 /home/senke/Documents/veza/veza-backend-api/internal/services/rbac_service.go:175 sql: Scan error on column index 0, name "id": converting driver.Value type string ("5aefa230-0589-4040-9b83-c120025843db") to a uint8: invalid syntax
[74.205ms] [rows:1] SELECT id FROM users WHERE id = '5aefa230-0589-4040-9b83-c120025843db' FOR UPDATE
--- PASS: TestAssignRoleToUser_Concurrency (0.62s)
=== RUN TestAssignRoleToUser_Atomicity
2025/12/07 11:24:49 /home/senke/Documents/veza/veza-backend-api/internal/services/rbac_service.go:175 sql: Scan error on column index 0, name "id": converting driver.Value type string ("7831daac-b1b6-4f94-b075-945ad3e6168d") to a uint8: value out of range
[1.083ms] [rows:1] SELECT id FROM users WHERE id = '7831daac-b1b6-4f94-b075-945ad3e6168d' FOR UPDATE
2025/12/07 11:24:49 /home/senke/Documents/veza/veza-backend-api/internal/services/rbac_service.go:206 record not found
[1.191ms] [rows:0] SELECT * FROM "user_roles" WHERE user_id = '7831daac-b1b6-4f94-b075-945ad3e6168d' AND role_id = 'ec81012f-bc9f-4146-a1ce-494a0fb8700a' ORDER BY "user_roles"."id" LIMIT 1 FOR UPDATE
logger.go:146: 2025-12-07T11:24:49.083+0100 INFO Role assigned to user successfully {"user_id": "7831daac-b1b6-4f94-b075-945ad3e6168d", "role_id": "ec81012f-bc9f-4146-a1ce-494a0fb8700a"}
2025/12/07 11:24:49 /home/senke/Documents/veza/veza-backend-api/internal/services/rbac_service.go:175 sql: Scan error on column index 0, name "id": converting driver.Value type string ("502ddb31-4564-4a7a-8597-23173d6d2bbd") to a uint8: value out of range
[0.603ms] [rows:1] SELECT id FROM users WHERE id = '502ddb31-4564-4a7a-8597-23173d6d2bbd' FOR UPDATE
2025/12/07 11:24:49 /home/senke/Documents/veza/veza-backend-api/internal/services/rbac_service.go:195 record not found
[0.618ms] [rows:0] SELECT * FROM "roles" WHERE "roles"."id" = 'ec81012f-bc9f-4146-a1ce-494a0fb8700a' ORDER BY "roles"."id" LIMIT 1 FOR UPDATE
rbac_transaction_test.go:253:
Error Trace: /home/senke/Documents/veza/veza-backend-api/tests/transactions/rbac_transaction_test.go:253
Error: Not equal:
expected: 1
actual : 0
Test: TestAssignRoleToUser_Atomicity
Messages: First assignment should still exist
--- FAIL: TestAssignRoleToUser_Atomicity (0.56s)
=== RUN TestToggleLike_Success
2025/12/07 11:24:49 /home/senke/Documents/veza/veza-backend-api/internal/core/social/service.go:138 record not found
[3.379ms] [rows:0] SELECT * FROM "likes" WHERE user_id = '2fb8ecb9-d592-4aba-a222-55e83e8b731d' AND target_id = '97ee790e-aa4c-4d89-b7c7-516133e1597e' AND target_type = 'post' ORDER BY "likes"."id" LIMIT 1
--- PASS: TestToggleLike_Success (0.55s)
=== RUN TestToggleLike_Unlike
2025/12/07 11:24:50 /home/senke/Documents/veza/veza-backend-api/internal/core/social/service.go:138 record not found
[4.081ms] [rows:0] SELECT * FROM "likes" WHERE user_id = '76ee046c-be40-47df-8c0b-a57872fcdbae' AND target_id = 'f9a607e2-fd5d-4dbf-a36d-70b1aef98991' AND target_type = 'post' ORDER BY "likes"."id" LIMIT 1
--- PASS: TestToggleLike_Unlike (0.45s)
=== RUN TestToggleLike_RollbackOnError
2025/12/07 11:24:50 /home/senke/Documents/veza/veza-backend-api/internal/core/social/service.go:138 record not found
[3.890ms] [rows:0] SELECT * FROM "likes" WHERE user_id = '38df6295-fd47-444c-9fd4-3ab4791d6da9' AND target_id = 'ecfc6256-afee-4009-ad4e-7c31833fa883' AND target_type = 'post' ORDER BY "likes"."id" LIMIT 1
social_transaction_test.go:190:
Error Trace: /home/senke/Documents/veza/veza-backend-api/tests/transactions/social_transaction_test.go:190
Error: An error is expected but got nil.
Test: TestToggleLike_RollbackOnError
Messages: ToggleLike should fail
--- FAIL: TestToggleLike_RollbackOnError (0.45s)
=== RUN TestToggleLike_Coherence
2025/12/07 11:24:50 /home/senke/Documents/veza/veza-backend-api/internal/core/social/service.go:138 record not found
[3.181ms] [rows:0] SELECT * FROM "likes" WHERE user_id = '1c6256fe-1db0-41f4-a919-039e0703bcb8' AND target_id = '3715ab28-0038-42d9-9b65-4ccbc57f9cf5' AND target_type = 'post' ORDER BY "likes"."id" LIMIT 1
2025/12/07 11:24:50 /home/senke/Documents/veza/veza-backend-api/internal/core/social/service.go:138 record not found
[0.380ms] [rows:0] SELECT * FROM "likes" WHERE user_id = '77d31b5c-5c85-491e-954d-b8f417613126' AND target_id = '3715ab28-0038-42d9-9b65-4ccbc57f9cf5' AND target_type = 'post' ORDER BY "likes"."id" LIMIT 1
--- PASS: TestToggleLike_Coherence (0.44s)
=== RUN TestAddComment_Success
--- PASS: TestAddComment_Success (0.36s)
=== RUN TestAddComment_RollbackOnError
2025/12/07 11:24:51 /home/senke/Documents/veza/veza-backend-api/internal/core/social/service.go:196 record not found
[2.500ms] [rows:0] SELECT * FROM "posts" WHERE id = 'c80e89a9-a3ba-4f4b-89a5-b26a2cfcb01d' AND "posts"."deleted_at" IS NULL ORDER BY "posts"."id" LIMIT 1
--- PASS: TestAddComment_RollbackOnError (0.38s)
=== RUN TestAddComment_Coherence
--- PASS: TestAddComment_Coherence (0.36s)
FAIL
FAIL veza-backend-api/tests/transactions 88.221s
FAIL