You signed in with another tab or window. Reload to refresh your session.You signed out in another tab or window. Reload to refresh your session.You switched accounts on another tab or window. Reload to refresh your session.Dismiss alert
I see a long list of errors and warnings in the prod log.
We really need to clean-up some of those and try to fix the PHP warning or PHP or Twig errors we see...
I could make 20+ GitHub Issues out of this single ticket, but that won't help us. And will only cause more overhead. See the list of warnings/errors below under "List of issues".
On which Mbin instance did you find the bug?
kbin.melroy.org
Which Mbin version was running on the instance?
1.7.1
To Reproduce
Steps to reproduce the behavior:
Check-out the log: tail -f var/log/prod-xx-x-x-x.log
And follow it for a while...
Expected behavior
Minimal amount of errors and warnings in the production log. Only some error messages make sense if there is a real error and we still want to keep reporting it to admin of the instance.
Let's just see how much we can resolve in the first 1.7.2 milestone..
{"message":"Uncaught PHP Exception Twig\\Error\\RuntimeError: \"Error rendering \"entry_comment\" component: Expected argument of type \"App\\Entity\\EntryComment\", \"null\" given at property path \"comment\".\" at view.html.twig line 49","context":{"exception":{"class":"Twig\\Error\\RuntimeError","message":"Error rendering \"entry_comment\" component: Expected argument of type \"App\\Entity\\EntryComment\", \"null\" given at property path \"comment\".","code":0,"file":"/var/www/kbin.melroy.org/html/templates/entry/comment/view.html.twig:49","previous":{"class":"Symfony\\Component\\PropertyAccess\\Exception\\InvalidTypeException","message":"Expected argument of type \"App\\Entity\\EntryComment\", \"null\" given at property path \"comment\".","code":0,"file":"/var/www/kbin.melroy.org/html/vendor/symfony/property-access/PropertyAccessor.php:203","previous":{"class":"TypeError","message":"Cannot assign null to property App\\Twig\\Components\\EntryCommentComponent::$comment of type App\\Entity\\EntryComment","code":0,"file":"/var/www/kbin.melroy.org/html/vendor/symfony/property-access/PropertyAccessor.php:520"}}}},"level":500,"level_name":"CRITICAL","channel":"request","datetime":"2024-09-12T12:18:16.360410+02:00","extra":{}}
{"message":"Warning: Undefined array key \"publicKey\"","context":{"exception":{"class":"ErrorException","message":"Warning: Undefined array key \"publicKey\"","code":0,"file":"/var/www/kbin.melroy.org/html/src/Service/ActivityPub/SignatureValidator.php:116"}},"level":400,"level_name":"ERROR","channel":"php","datetime":"2024-09-12T12:19:29.121860+02:00","extra":{}}
{"message":"Warning: Trying to access array offset on null","context":{"exception":{"class":"ErrorException","message":"Warning: Trying to access array offset on null","code":0,"file":"/var/www/kbin.melroy.org/html/src/Service/ActivityPub/SignatureValidator.php:116"}},"level":400,"level_name":"ERROR","channel":"php","datetime":"2024-09-12T12:19:29.122088+02:00","extra":{}}
{"message":"Unable to extract public key for 'https://mastodon.sdf.org/users/TomCox'.","context":{"user":"https://mastodon.sdf.org/users/TomCox"},"level":300,"level_name":"WARNING","channel":"app","datetime":"2024-09-12T12:19:29.122196+02:00","extra":{}}
I added "feddit.de" to block list (in the admin panel). Why do I still see?
{"message":"ApHttpClient:getActorObject get fail: https://feddit.de/u/Hellschwarz, ex: Symfony\\Component\\HttpClient\\Exception\\TransportException: Could not resolve host: feddit.de for \"https://feddit.de/u/Hellschwarz\". - there was an exception while getting the content, Symfony\\Component\\HttpClient\\Exception\\TransportException: Could not resolve host: feddit.de for \"https://feddit.de/u/Hellschwarz\".","context":{"type":"ApHttpClient:getActorObject","address":"https://feddit.de/u/Hellschwarz","e":"Symfony\\Component\\HttpClient\\Exception\\TransportException","msg":"Could not resolve host: feddit.de for \"https://feddit.de/u/Hellschwarz\".","content":"there was an exception while getting the content, Symfony\\Component\\HttpClient\\Exception\\TransportException: Could not resolve host: feddit.de for \"https://feddit.de/u/Hellschwarz\"."},"level":400,"level_name":"ERROR","channel":"app","datetime":"2024-09-12T12:20:37.666017+02:00","extra":{}}
{"message":"Error thrown while handling message App\\Message\\ActivityPub\\UpdateActorMessage. Removing from transport after 7 retries. Error: \"Handling \"App\\Message\\ActivityPub\\UpdateActorMessage\" failed: Could not resolve host: feddit.de for \"https://feddit.de/u/Hellschwarz\".\"","context":{"class":"App\\Message\\ActivityPub\\UpdateActorMessage","message_id":null,"retryCount":7,"error":"Handling \"App\\Message\\ActivityPub\\UpdateActorMessage\" failed: Could not resolve host: feddit.de for \"https://feddit.de/u/Hellschwarz\".","exception":{"class":"Symfony\\Component\\Messenger\\Exception\\HandlerFailedException","message":"Handling \"App\\Message\\ActivityPub\\UpdateActorMessage\" failed: Could not resolve host: feddit.de for \"https://feddit.de/u/Hellschwarz\".","code":0,"file":"/var/www/kbin.melroy.org/html/vendor/symfony/messenger/Middleware/HandleMessageMiddleware.php:124","previous":{"class":"Symfony\\Component\\HttpClient\\Exception\\TransportException","message":"Could not resolve host: feddit.de for \"https://feddit.de/u/Hellschwarz\".","code":0,"file":"/var/www/kbin.melroy.org/html/vendor/symfony/http-client/Response/CommonResponseTrait.php:140"}}},"level":500,"level_name":"CRITICAL","channel":"messenger","datetime":"2024-09-12T12:20:37.666575+02:00","extra":{}}
{"message":"ApHttpClient:getActorObject get fail: https://feddit.de/u/Hellschwarz, ex: Symfony\\Component\\HttpClient\\Exception\\TransportException: Could not resolve host: feddit.de for \"https://feddit.de/u/Hellschwarz\". - there was an exception while getting the content, Symfony\\Component\\HttpClient\\Exception\\TransportException: Could not resolve host: feddit.de for \"https://feddit.de/u/Hellschwarz\".","context":{"type":"ApHttpClient:getActorObject","address":"https://feddit.de/u/Hellschwarz","e":"Symfony\\Component\\HttpClient\\Exception\\TransportException","msg":"Could not resolve host: feddit.de for \"https://feddit.de/u/Hellschwarz\".","content":"there was an exception while getting the content, Symfony\\Component\\HttpClient\\Exception\\TransportException: Could not resolve host: feddit.de for \"https://feddit.de/u/Hellschwarz\"."},"level":400,"level_name":"ERROR","channel":"app","datetime":"2024-09-12T12:20:37.991473+02:00","extra":{}}
{"message":"Error thrown while handling message App\\Message\\ActivityPub\\UpdateActorMessage. Sending for retry #1 using 1800000 ms delay. Error: \"Handling \"App\\Message\\ActivityPub\\UpdateActorMessage\" failed: Could not resolve host: feddit.de for \"https://feddit.de/u/Hellschwarz\".\"","context":{"class":"App\\Message\\ActivityPub\\UpdateActorMessage","message_id":3468087,"retryCount":1,"delay":1800000,"error":"Handling \"App\\Message\\ActivityPub\\UpdateActorMessage\" failed: Could not resolve host: feddit.de for \"https://feddit.de/u/Hellschwarz\".","exception":{"class":"Symfony\\Component\\Messenger\\Exception\\HandlerFailedException","message":"Handling \"App\\Message\\ActivityPub\\UpdateActorMessage\" failed: Could not resolve host: feddit.de for \"https://feddit.de/u/Hellschwarz\".","code":0,"file":"/var/www/kbin.melroy.org/html/vendor/symfony/messenger/Middleware/HandleMessageMiddleware.php:124","previous":{"class":"Symfony\\Component\\HttpClient\\Exception\\TransportException","message":"Could not resolve host: feddit.de for \"https://feddit.de/u/Hellschwarz\".","code":0,"file":"/var/www/kbin.melroy.org/html/vendor/symfony/http-client/Response/CommonResponseTrait.php:140"}}},"level":300,"level_name":"WARNING","channel":"messenger","datetime":"2024-09-12T12:20:37.992118+02:00","extra":{}}
{"message":"could not retrieve all the dependencies of array{\"@context\":[\"https://join-lemmy.org/context.json\",\"https://www.w3.org/ns/activitystreams\"],\"type\":\"Note\",\"id\":\"https://lemmy.world/comment/12312933\",\"attributedTo\":\"https://lemmy.world/u/aaaa\",\"to\":[\"https://www.w3.org/ns/activitystreams#Public\"],\"cc\":[\"https://lemmy.world/c/memes\",\"https://piefed.social/u/socsa\"],\"content\":\"<p>The NSFW tag is part of the mechanism to curate the feed.</p>\\n<p>I’m not sure why people get offended by people wanting to use social media but not wanting to view content that can get them fired. If the content doesn’t bother you, then you shouldn’t filter NSFW content. It’s not like the NSFW tag is censoring the content and preventing you from seeing it if you click it.</p>\\n<p>For people with jobs, why not make it easier to filter the things that companies don’t like? It doesn’t affect you any.</p>\\n\",\"inReplyTo\":\"https://piefed.social/comment/2799685\",\"mediaType\":\"text/html\",\"source\":{\"content\":\"The NSFW tag is part of the mechanism to curate the feed. \\n\\nI'm not sure why people get offended by people wanting to use social media but not wanting to view content that can get them fired. If the content doesn't bother you, then you shouldn't filter NSFW content. It's not like the NSFW tag is censoring the content and preventing you from seeing it if you click it.\\n\\nFor people with jobs, why not make it easier to filter the things that companies don't like? It doesn't affect you any.\",\"mediaType\":\"text/markdown\"},\"published\":\"2024-09-12T05:15:44.456255Z\",\"updated\":\"2024-09-12T05:22:16.215331Z\",\"tag\":[{\"href\":\"https://piefed.social/u/socsa\",\"name\":\"@[email protected]\",\"type\":\"Mention\"}],\"distinguished\":false,\"audience\":\"https://lemmy.world/c/memes\"}","context":{"o":{"@context":["https://join-lemmy.org/context.json","https://www.w3.org/ns/activitystreams"],"type":"Note","id":"https://lemmy.world/comment/12312933","attributedTo":"https://lemmy.world/u/aaaa","to":["https://www.w3.org/ns/activitystreams#Public"],"cc":["https://lemmy.world/c/memes","https://piefed.social/u/socsa"],"content":"<p>The NSFW tag is part of the mechanism to curate the feed.</p>\n<p>I’m not sure why people get offended by people wanting to use social media but not wanting to view content that can get them fired. If the content doesn’t bother you, then you shouldn’t filter NSFW content. It’s not like the NSFW tag is censoring the content and preventing you from seeing it if you click it.</p>\n<p>For people with jobs, why not make it easier to filter the things that companies don’t like? It doesn’t affect you any.</p>\n","inReplyTo":"https://piefed.social/comment/2799685","mediaType":"text/html","source":{"content":"The NSFW tag is part of the mechanism to curate the feed. \n\nI'm not sure why people get offended by people wanting to use social media but not wanting to view content that can get them fired. If the content doesn't bother you, then you shouldn't filter NSFW content. It's not like the NSFW tag is censoring the content and preventing you from seeing it if you click it.\n\nFor people with jobs, why not make it easier to filter the things that companies don't like? It doesn't affect you any.","mediaType":"text/markdown"},"published":"2024-09-12T05:15:44.456255Z","updated":"2024-09-12T05:22:16.215331Z","tag":[{"href":"https://piefed.social/u/socsa","name":"@[email protected]","type":"Mention"}],"distinguished":false,"audience":"https://lemmy.world/c/memes"}},"level":400,"level_name":"ERROR","channel":"app","datetime":"2024-09-12T12:32:54.916901+02:00","extra":{}}
the eigth (BentiGorlich: same as the fourth)
{"message":"Warning: Trying to access array offset on null","context":{"exception":{"class":"ErrorException","message":"Warning: Trying to access array offset on null","code":0,"file":"/var/www/kbin.melroy.org/html/src/Service/ActivityPub/SignatureValidator.php:116"}},"level":400,"level_name":"ERROR","channel":"php","datetime":"2024-09-12T12:39:00.481703+02:00","extra":{}}
{"message":"Warning: Trying to access array offset on null","context":{"exception":{"class":"ErrorException","message":"Warning: Trying to access array offset on null","code":0,"file":"/var/www/kbin.melroy.org/html/src/Service/ActivityPubManager.php:290"}},"level":400,"level_name":"ERROR","channel":"php","datetime":"2024-09-12T12:33:45.029513+02:00","extra":{}}
{"message":"ApHttpClient:getActivityObject get fail: https://social.vivaldi.net/users/OutOfExileIDR/statuses/113105981784505849/activity, ex: App\\Exception\\InvalidApPostException: Invalid status code while getting: https://social.vivaldi.net/users/OutOfExileIDR/statuses/113105981784505849/activity : 404, {\"error\":\"Not Found\"} - {\"error\":\"Not Found\"}","context":{"type":"ApHttpClient:getActivityObject","address":"https://social.vivaldi.net/users/OutOfExileIDR/statuses/113105981784505849/activity","e":"App\\Exception\\InvalidApPostException","msg":"Invalid status code while getting: https://social.vivaldi.net/users/OutOfExileIDR/statuses/113105981784505849/activity : 404, {\"error\":\"Not Found\"}","content":"{\"error\":\"Not Found\"}"},"level":400,"level_name":"ERROR","channel":"app","datetime":"2024-09-12T12:33:50.288473+02:00","extra":{}}
the tenth - same as the 1st.
{"message":"Uncaught PHP Exception Twig\\Error\\RuntimeError: \"Error rendering \"entry_comment\" component: Expected argument of type \"App\\Entity\\EntryComment\", \"null\" given at property path \"comment\".\" at view.html.twig line 49","context":{"exception":{"class":"Twig\\Error\\RuntimeError","message":"Error rendering \"entry_comment\" component: Expected argument of type \"App\\Entity\\EntryComment\", \"null\" given at property path \"comment\".","code":0,"file":"/var/www/kbin.melroy.org/html/templates/entry/comment/view.html.twig:49","previous":{"class":"Symfony\\Component\\PropertyAccess\\Exception\\InvalidTypeException","message":"Expected argument of type \"App\\Entity\\EntryComment\", \"null\" given at property path \"comment\".","code":0,"file":"/var/www/kbin.melroy.org/html/vendor/symfony/property-access/PropertyAccessor.php:203","previous":{"class":"TypeError","message":"Cannot assign null to property App\\Twig\\Components\\EntryCommentComponent::$comment of type App\\Entity\\EntryComment","code":0,"file":"/var/www/kbin.melroy.org/html/vendor/symfony/property-access/PropertyAccessor.php:534"}}}},"level":500,"level_name":"CRITICAL","channel":"request","datetime":"2024-09-12T12:36:13.835930+02:00","extra":{}}
23:13:28 CRITICAL [console] Error thrown while running command"mbin:cache:build". Message: "Liip\ImagineBundle\Command\ResolveCacheCommand::runCacheImageResolve(): Argument #1 ($image) must be of type string, null given, called in /var/www/kbin.melroy.org/html/vendor/liip/imagine-bundle/Command/ResolveCacheCommand.php on line 95" ["exception"=> TypeError { …},"command" =>"mbin:cache:build","message" =>"Liip\ImagineBundle\Command\ResolveCacheCommand::runCacheImageResolve(): Argument #1 ($image) must be of type string, null given, called in /var/www/kbin.melroy.org/html/vendor/liip/imagine-bundle/Command/ResolveCacheCommand.php on line 95"]
{"message":"Uncaught Error: Liip\\ImagineBundle\\Command\\ResolveCacheCommand::runCacheImageResolve(): Argument #1 ($image) must be of type string, null given, called in /var/www/kbin.melroy.org/html/vendor/liip/imagine-bundle/Command/ResolveCacheCommand.php on line 95","context":{"exception":{"class":"TypeError","message":"Liip\\ImagineBundle\\Command\\ResolveCacheCommand::runCacheImageResolve(): Argument #1 ($image) must be of type string, null given, called in /var/www/kbin.melroy.org/html/vendor/liip/imagine-bundle/Command/ResolveCacheCommand.php on line 95","code":0,"file":"/var/www/kbin.melroy.org/html/vendor/liip/imagine-bundle/Command/ResolveCacheCommand.php:104"}},"level":500,"level_name":"CRITICAL","channel":"php","datetime":"2024-09-11T23:13:28.060044+02:00","extra":{}}
the 12th NotFoundHttpException App\Entity\Entry and App\Entity\Post object not found.. :
Full stack trace
[2024-09-12T20:35:38.330174+02:00] request.ERROR: Uncaught PHP Exception Symfony\Component\HttpKernel\Exception\NotFoundHttpException: ""App\Entity\Entry" object not found by "Symfony\Bridge\Doctrine\ArgumentResolver\EntityValueResolver"." at EntityValueResolver.php line 76 {"exception":"[object] (Symfony\\Component\\HttpKernel\\Exception\\NotFoundHttpException(code: 0): \"App\\Entity\\Entry\" object not found by \"Symfony\\Bridge\\Doctrine\\ArgumentResolver\\EntityValueResolver\". at /var/www/kbin.melroy.org/html/vendor/symfony/doctrine-bridge/ArgumentResolver/EntityValueResolver.php:76)
[stacktrace]
#0 /var/www/kbin.melroy.org/html/vendor/symfony/http-kernel/Controller/ArgumentResolver/TraceableValueResolver.php(37): Symfony\\Bridge\\Doctrine\\ArgumentResolver\\EntityValueResolver->resolve()
#1 /var/www/kbin.melroy.org/html/vendor/symfony/http-kernel/Controller/ArgumentResolver.php(90): Symfony\\Component\\HttpKernel\\Controller\\ArgumentResolver\\TraceableValueResolver->resolve()
#2 /var/www/kbin.melroy.org/html/vendor/symfony/http-kernel/Controller/TraceableArgumentResolver.php(33): Symfony\\Component\\HttpKernel\\Controller\\ArgumentResolver->getArguments()
#3 /var/www/kbin.melroy.org/html/vendor/symfony/http-kernel/HttpKernel.php(175): Symfony\\Component\\HttpKernel\\Controller\\TraceableArgumentResolver->getArguments()
#4 /var/www/kbin.melroy.org/html/vendor/symfony/http-kernel/HttpKernel.php(76): Symfony\\Component\\HttpKernel\\HttpKernel->handleRaw()
#5 /var/www/kbin.melroy.org/html/vendor/symfony/http-kernel/Kernel.php(182): Symfony\\Component\\HttpKernel\\HttpKernel->handle()
#6 /var/www/kbin.melroy.org/html/vendor/symfony/runtime/Runner/Symfony/HttpKernelRunner.php(35): Symfony\\Component\\HttpKernel\\Kernel->handle()
#7 /var/www/kbin.melroy.org/html/vendor/autoload_runtime.php(29): Symfony\\Component\\Runtime\\Runner\\Symfony\\HttpKernelRunner->run()
#8 /var/www/kbin.melroy.org/html/public/index.php(7): require_once('...')
#9 {main}
"} []
[2024-09-12T20:35:55.620106+02:00] request.ERROR: Uncaught PHP Exception Symfony\Component\HttpKernel\Exception\NotFoundHttpException: ""App\Entity\Entry" object not found by "Symfony\Bridge\Doctrine\ArgumentResolver\EntityValueResolver"." at EntityValueResolver.php line 76 {"exception":"[object] (Symfony\\Component\\HttpKernel\\Exception\\NotFoundHttpException(code: 0): \"App\\Entity\\Entry\" object not found by \"Symfony\\Bridge\\Doctrine\\ArgumentResolver\\EntityValueResolver\". at /var/www/kbin.melroy.org/html/vendor/symfony/doctrine-bridge/ArgumentResolver/EntityValueResolver.php:76)
[stacktrace]
#0 /var/www/kbin.melroy.org/html/vendor/symfony/http-kernel/Controller/ArgumentResolver/TraceableValueResolver.php(37): Symfony\\Bridge\\Doctrine\\ArgumentResolver\\EntityValueResolver->resolve()
#1 /var/www/kbin.melroy.org/html/vendor/symfony/http-kernel/Controller/ArgumentResolver.php(90): Symfony\\Component\\HttpKernel\\Controller\\ArgumentResolver\\TraceableValueResolver->resolve()
#2 /var/www/kbin.melroy.org/html/vendor/symfony/http-kernel/Controller/TraceableArgumentResolver.php(33): Symfony\\Component\\HttpKernel\\Controller\\ArgumentResolver->getArguments()
#3 /var/www/kbin.melroy.org/html/vendor/symfony/http-kernel/HttpKernel.php(175): Symfony\\Component\\HttpKernel\\Controller\\TraceableArgumentResolver->getArguments()
#4 /var/www/kbin.melroy.org/html/vendor/symfony/http-kernel/HttpKernel.php(76): Symfony\\Component\\HttpKernel\\HttpKernel->handleRaw()
#5 /var/www/kbin.melroy.org/html/vendor/symfony/http-kernel/Kernel.php(182): Symfony\\Component\\HttpKernel\\HttpKernel->handle()
#6 /var/www/kbin.melroy.org/html/vendor/symfony/runtime/Runner/Symfony/HttpKernelRunner.php(35): Symfony\\Component\\HttpKernel\\Kernel->handle()
#7 /var/www/kbin.melroy.org/html/vendor/autoload_runtime.php(29): Symfony\\Component\\Runtime\\Runner\\Symfony\\HttpKernelRunner->run()
#8 /var/www/kbin.melroy.org/html/public/index.php(7): require_once('...')
#9 {main}
And also seems to be related:
[2024-09-12T20:50:38.827422+02:00] request.ERROR: Uncaught PHP Exception Symfony\Component\HttpKernel\Exception\NotFoundHttpException: ""App\Entity\Post" object not found by "Symfony\Bridge\Doctrine\ArgumentResolver\EntityValueResolver"." at EntityValueResolver.php line 76 {"exception":"[object] (Symfony\\Component\\HttpKernel\\Exception\\NotFoundHttpException(code: 0): \"App\\Entity\\Post\" object not found by \"Symfony\\Bridge\\Doctrine\\ArgumentResolver\\EntityValueResolver\". at /var/www/kbin.melroy.org/html/vendor/symfony/doctrine-bridge/ArgumentResolver/EntityValueResolver.php:76)
[stacktrace]
#0 /var/www/kbin.melroy.org/html/vendor/symfony/http-kernel/Controller/ArgumentResolver/TraceableValueResolver.php(37): Symfony\\Bridge\\Doctrine\\ArgumentResolver\\EntityValueResolver->resolve()
#1 /var/www/kbin.melroy.org/html/vendor/symfony/http-kernel/Controller/ArgumentResolver.php(90): Symfony\\Component\\HttpKernel\\Controller\\ArgumentResolver\\TraceableValueResolver->resolve()
#2 /var/www/kbin.melroy.org/html/vendor/symfony/http-kernel/Controller/TraceableArgumentResolver.php(33): Symfony\\Component\\HttpKernel\\Controller\\ArgumentResolver->getArguments()
#3 /var/www/kbin.melroy.org/html/vendor/symfony/http-kernel/HttpKernel.php(175): Symfony\\Component\\HttpKernel\\Controller\\TraceableArgumentResolver->getArguments()
#4 /var/www/kbin.melroy.org/html/vendor/symfony/http-kernel/HttpKernel.php(76): Symfony\\Component\\HttpKernel\\HttpKernel->handleRaw()
#5 /var/www/kbin.melroy.org/html/vendor/symfony/http-kernel/Kernel.php(182): Symfony\\Component\\HttpKernel\\HttpKernel->handle()
#6 /var/www/kbin.melroy.org/html/vendor/symfony/runtime/Runner/Symfony/HttpKernelRunner.php(35): Symfony\\Component\\HttpKernel\\Kernel->handle()
#7 /var/www/kbin.melroy.org/html/vendor/autoload_runtime.php(29): Symfony\\Component\\Runtime\\Runner\\Symfony\\HttpKernelRunner->run()
#8 /var/www/kbin.melroy.org/html/public/index.php(7): require_once('...')
#9 {main}
"} []
17th - User already deleted errors.. Why is this an error? We could just check if the user is present or not, before trying to delete a user which isn't present anyways.
{"message":"Error thrown while handling message App\\Message\\DeleteUserMessage. Removing from transport after 0 retries. Error: \"Handling \"App\\Message\\DeleteUserMessage\" failed: User already deleted\"","context":{"class":"App\\Message\\DeleteUserMessage","message_id":null,"retryCount":0,"error":"Handling \"App\\Message\\DeleteUserMessage\" failed: User already deleted","exception":{"class":"Symfony\\Component\\Messenger\\Exception\\HandlerFailedException","message":"Handling \"App\\Message\\DeleteUserMessage\" failed: User already deleted","code":0,"file":"/var/www/kbin.melroy.org/html/vendor/symfony/messenger/Middleware/HandleMessageMiddleware.php:124","previous":{"class":"Symfony\\Component\\Messenger\\Exception\\UnrecoverableMessageHandlingException","message":"User already deleted","code":0,"file":"/var/www/kbin.melroy.org/html/src/MessageHandler/DeleteUserHandler.php:53"}}},"level":500,"level_name":"CRITICAL","channel":"messenger","datetime":"2024-09-13T12:57:13.578196+02:00","extra":{}}
18th - (running now on the latest main) I still see getActivityObject failed on a domain name that I blocked (because kbin.social is down). I despite I this domain name is part of the federation block list, it still give me 503 errors:
19th - The famous couldnt_find_person. Can we try to debug what this means? Solve the problem? Or handle the error better..?
{"message":"ApHttpClient:getActivityObject get fail: https://lemmy.ca/post/28871883, ex: App\\Exception\\InvalidApPostException: Invalid status code while getting: https://lemmy.ca/post/28871883 : 400, {\"error\":\"couldnt_find_person\"} - {\"error\":\"couldnt_find_person\"}","context":{"type":"ApHttpClient:getActivityObject","address":"https://lemmy.ca/post/28871883","e":"App\\Exception\\InvalidApPostException","msg":"Invalid status code while getting: https://lemmy.ca/post/28871883 : 400, {\"error\":\"couldnt_find_person\"}","content":"{\"error\":\"couldnt_find_person\"}"},"level":400,"level_name":"ERROR","channel":"app","datetime":"2024-09-14T13:05:02.098634+02:00","extra":{}}
20th - Invalid text representation invalid input syntax for type integer: \"{user_id}\":
{"message":"Uncaught PHP Exception Doctrine\\DBAL\\Exception\\DriverException: \"An exception occurred while executing a query: SQLSTATE[22P02]: Invalid text representation: 7 ERROR: invalid input syntax for type integer: \"{user_id}\"\nCONTEXT: unnamed portal parameter $1 = '...'\" at ExceptionConverter.php line 87","context":{"exception":{"class":"Doctrine\\DBAL\\Exception\\DriverException","message":"An exception occurred while executing a query: SQLSTATE[22P02]: Invalid text representation: 7 ERROR: invalid input syntax for type integer: \"{user_id}\"\nCONTEXT: unnamed portal parameter $1 = '...'","code":7,"file":"/var/www/kbin.melroy.org/html/vendor/doctrine/dbal/src/Driver/API/PostgreSQL/ExceptionConverter.php:87","previous":{"class":"Doctrine\\DBAL\\Driver\\PDO\\Exception","message":"SQLSTATE[22P02]: Invalid text representation: 7 ERROR: invalid input syntax for type integer: \"{user_id}\"\nCONTEXT: unnamed portal parameter $1 = '...'","code":7,"file":"/var/www/kbin.melroy.org/html/vendor/doctrine/dbal/src/Driver/PDO/Exception.php:28","previous":{"class":"PDOException","message":"SQLSTATE[22P02]: Invalid text representation: 7 ERROR: invalid input syntax for type integer: \"{user_id}\"\nCONTEXT: unnamed portal parameter $1 = '...'","code":22,"file":"/var/www/kbin.melroy.org/html/vendor/doctrine/dbal/src/Driver/PDO/Statement.php:130"}}}},"level":500,"level_name":"CRITICAL","channel":"request","datetime":"2024-09-16T22:22:06.622198+02:00","extra":{}}
This error also can be seens if the email confirmation URL is wrong or wrongly interpreted by the client or whatever is wrong.. (using the verify/email/.. path):
{"message":"Uncaught PHP Exception Doctrine\\DBAL\\Exception\\DriverException: \"An exception occurred while executing a query: SQLSTATE[22P02]: Invalid text representation: 7 ERROR: invalid input syntax for type integer: \"3D628316\"\nCONTEXT: unnamed portal parameter $1 = '...'\" at ExceptionConverter.php line 87","context":{"exception":{"class":"Doctrine\\DBAL\\Exception\\DriverException","message":"An exception occurred while executing a query: SQLSTATE[22P02]: Invalid text representation: 7 ERROR: invalid input syntax for type integer: \"3D628316\"\nCONTEXT: unnamed portal parameter $1 = '...'","code":7,"file":"/var/www/kbin.melroy.org/html/vendor/doctrine/dbal/src/Driver/API/PostgreSQL/ExceptionConverter.php:87","previous":{"class":"Doctrine\\DBAL\\Driver\\PDO\\Exception","message":"SQLSTATE[22P02]: Invalid text representation: 7 ERROR: invalid input syntax for type integer: \"3D628316\"\nCONTEXT: unnamed portal parameter $1 = '...'","code":7,"file":"/var/www/kbin.melroy.org/html/vendor/doctrine/dbal/src/Driver/PDO/Exception.php:28","previous":{"class":"PDOException","message":"SQLSTATE[22P02]: Invalid text representation: 7 ERROR: invalid input syntax for type integer: \"3D628316\"\nCONTEXT: unnamed portal parameter $1 = '...'","code":22,"file":"/var/www/kbin.melroy.org/html/vendor/doctrine/dbal/src/Driver/PDO/Statement.php:130"}}}},"level":500,"level_name":"CRITICAL","channel":"request","datetime":"2024-09-19T17:08:55.106238+02:00","extra":{}}
The logs are missing a request URL (path) for sure, otherwise it's very hard to debug the above messages, without any clue which kind of request we are talking about. But for sure it could trigger this error above by the confirmation email link.
21st - could not retrieve all the dependencies
{"message":"could not retrieve all the dependencies of https://lemmy.world/comment/12469030","context":{"o":"https://lemmy.world/comment/12469030"},"level":400,"level_name":"ERROR","channel":"app","datetime":"2024-09-20T17:20:25.864264+02:00","extra":{}}
22nd - Fetched remote object https://kbin.melroy.org/u/RmDebArk_5 which was deleted. Is this is error? Can we fix it in a better way? If not, why do we log it?
{"message":"ApHttpClient:post failed: https://sh.itjust.works/inbox, ex: App\\Exception\\InvalidApPostException: Post failed: https://sh.itjust.works/inbox, status code: 400, request body: {\"@context\":\"https:\\/\\/www.w3.org\\/ns\\/activitystreams\",\"id\":\"https:\\/\\/kbin.melroy.org\\/f\\/object\\/a89df69f-9296-4c6d-9f27-085ccfc90539\",\"type\":\"Delete\",\"actor\":\"https:\\/\\/kbin.melroy.org\\/u\\/RmDebArk_5\",\"object\":\"https:\\/\\/kbin.melroy.org\\/u\\/RmDebArk_5\",\"to\":[\"https:\\/\\/www.w3.org\\/ns\\/activitystreams#Public\"],\"cc\":[\"https:\\/\\/kbin.melroy.org\\/u\\/RmDebArk_5\\/followers\"],\"removeData\":true}. Truncated content: {\"error\":\"unknown\",\"message\":\"Fetched remote object https://kbin.melroy.org/u/RmDebArk_5 which was deleted\"}","context":{"type":"ApHttpClient:post","address":"https://sh.itjust.works/inbox","e":"App\\Exception\\InvalidApPostException","msg":"Post failed: https://sh.itjust.works/inbox, status code: 400, request body: {\"@context\":\"https:\\/\\/www.w3.org\\/ns\\/activitystreams\",\"id\":\"https:\\/\\/kbin.melroy.org\\/f\\/object\\/a89df69f-9296-4c6d-9f27-085ccfc90539\",\"type\":\"Delete\",\"actor\":\"https:\\/\\/kbin.melroy.org\\/u\\/RmDebArk_5\",\"object\":\"https:\\/\\/kbin.melroy.org\\/u\\/RmDebArk_5\",\"to\":[\"https:\\/\\/www.w3.org\\/ns\\/activitystreams#Public\"],\"cc\":[\"https:\\/\\/kbin.melroy.org\\/u\\/RmDebArk_5\\/followers\"],\"removeData\":true}","content":"{\"error\":\"unknown\",\"message\":\"Fetched remote object https://kbin.melroy.org/u/RmDebArk_5 which was deleted\"}"},"level":400,"level_name":"ERROR","channel":"app","datetime":"2024-09-20T17:18:18.702108+02:00","extra":{}}
Related:
{"message":"Error thrown while handling message App\\Message\\ActivityPub\\Outbox\\DeliverMessage. Sending for retry #3 using 4800000 ms delay. Error: \"Handling \"App\\Message\\ActivityPub\\Outbox\\DeliverMessage\" failed: Post failed: https://sh.itjust.works/inbox, status code: 400, request body: {\"@context\":\"https:\\/\\/www.w3.org\\/ns\\/activitystreams\",\"id\":\"https:\\/\\/kbin.melroy.org\\/f\\/object\\/a89df69f-9296-4c6d-9f27-085ccfc90539\",\"type\":\"Delete\",\"actor\":\"https:\\/\\/kbin.melroy.org\\/u\\/RmDebArk_5\",\"object\":\"https:\\/\\/kbin.melroy.org\\/u\\/RmDebArk_5\",\"to\":[\"https:\\/\\/www.w3.org\\/ns\\/activitystreams#Public\"],\"cc\":[\"https:\\/\\/kbin.melroy.org\\/u\\/RmDebArk_5\\/followers\"],\"removeData\":true}\"","context":{"class":"App\\Message\\ActivityPub\\Outbox\\DeliverMessage","message_id":null,"retryCount":3,"delay":4800000,"error":"Handling \"App\\Message\\ActivityPub\\Outbox\\DeliverMessage\" failed: Post failed: https://sh.itjust.works/inbox, status code: 400, request body: {\"@context\":\"https:\\/\\/www.w3.org\\/ns\\/activitystreams\",\"id\":\"https:\\/\\/kbin.melroy.org\\/f\\/object\\/a89df69f-9296-4c6d-9f27-085ccfc90539\",\"type\":\"Delete\",\"actor\":\"https:\\/\\/kbin.melroy.org\\/u\\/RmDebArk_5\",\"object\":\"https:\\/\\/kbin.melroy.org\\/u\\/RmDebArk_5\",\"to\":[\"https:\\/\\/www.w3.org\\/ns\\/activitystreams#Public\"],\"cc\":[\"https:\\/\\/kbin.melroy.org\\/u\\/RmDebArk_5\\/followers\"],\"removeData\":true}","exception":{"class":"Symfony\\Component\\Messenger\\Exception\\HandlerFailedException","message":"Handling \"App\\Message\\ActivityPub\\Outbox\\DeliverMessage\" failed: Post failed: https://sh.itjust.works/inbox, status code: 400, request body: {\"@context\":\"https:\\/\\/www.w3.org\\/ns\\/activitystreams\",\"id\":\"https:\\/\\/kbin.melroy.org\\/f\\/object\\/a89df69f-9296-4c6d-9f27-085ccfc90539\",\"type\":\"Delete\",\"actor\":\"https:\\/\\/kbin.melroy.org\\/u\\/RmDebArk_5\",\"object\":\"https:\\/\\/kbin.melroy.org\\/u\\/RmDebArk_5\",\"to\":[\"https:\\/\\/www.w3.org\\/ns\\/activitystreams#Public\"],\"cc\":[\"https:\\/\\/kbin.melroy.org\\/u\\/RmDebArk_5\\/followers\"],\"removeData\":true}","code":0,"file":"/var/www/kbin.melroy.org/html/vendor/symfony/messenger/Middleware/HandleMessageMiddleware.php:124","previous":{"class":"App\\Exception\\InvalidApPostException","message":"Post failed: https://sh.itjust.works/inbox, status code: 400, request body: {\"@context\":\"https:\\/\\/www.w3.org\\/ns\\/activitystreams\",\"id\":\"https:\\/\\/kbin.melroy.org\\/f\\/object\\/a89df69f-9296-4c6d-9f27-085ccfc90539\",\"type\":\"Delete\",\"actor\":\"https:\\/\\/kbin.melroy.org\\/u\\/RmDebArk_5\",\"object\":\"https:\\/\\/kbin.melroy.org\\/u\\/RmDebArk_5\",\"to\":[\"https:\\/\\/www.w3.org\\/ns\\/activitystreams#Public\"],\"cc\":[\"https:\\/\\/kbin.melroy.org\\/u\\/RmDebArk_5\\/followers\"],\"removeData\":true}","code":0,"file":"/var/www/kbin.melroy.org/html/src/Service/ActivityPub/ApHttpClient.php:410"}}},"level":300,"level_name":"WARNING","channel":"messenger","datetime":"2024-09-20T17:18:18.704266+02:00","extra":{}}
{"message":"Uncaught PHP Exception Doctrine\\DBAL\\Exception\\DriverException: \"An exception occurred while executing a query: SQLSTATE[22P02]: Invalid text representation: 7 ERROR: invalid input syntax for type integer: \"el\"\nCONTEXT: unnamed portal parameter $1 = '...'\" at ExceptionConverter.php line 87","context":{"exception":{"class":"Doctrine\\DBAL\\Exception\\DriverException","message":"An exception occurred while executing a query: SQLSTATE[22P02]: Invalid text representation: 7 ERROR: invalid input syntax for type integer: \"el\"\nCONTEXT: unnamed portal parameter $1 = '...'","code":7,"file":"/var/www/kbin.melroy.org/html/vendor/doctrine/dbal/src/Driver/API/PostgreSQL/ExceptionConverter.php:87","previous":{"class":"Doctrine\\DBAL\\Driver\\PDO\\Exception","message":"SQLSTATE[22P02]: Invalid text representation: 7 ERROR: invalid input syntax for type integer: \"el\"\nCONTEXT: unnamed portal parameter $1 = '...'","code":7,"file":"/var/www/kbin.melroy.org/html/vendor/doctrine/dbal/src/Driver/PDO/Exception.php:28","previous":{"class":"PDOException","message":"SQLSTATE[22P02]: Invalid text representation: 7 ERROR: invalid input syntax for type integer: \"el\"\nCONTEXT: unnamed portal parameter $1 = '...'","code":22,"file":"/var/www/kbin.melroy.org/html/vendor/doctrine/dbal/src/Driver/PDO/Statement.php:130"}}}},"level":500,"level_name":"CRITICAL","channel":"request","datetime":"2024-09-29T13:05:17.247414+02:00","extra":{}}
{"message":"Uncaught PHP Exception Doctrine\\DBAL\\Exception\\DriverException: \"An exception occurred while executing a query: SQLSTATE[22P02]: Invalid text representation: 7 ERROR: invalid input syntax for type integer: \"es\"\nCONTEXT: unnamed portal parameter $1 = '...'\" at ExceptionConverter.php line 87","context":{"exception":{"class":"Doctrine\\DBAL\\Exception\\DriverException","message":"An exception occurred while executing a query: SQLSTATE[22P02]: Invalid text representation: 7 ERROR: invalid input syntax for type integer: \"es\"\nCONTEXT: unnamed portal parameter $1 = '...'","code":7,"file":"/var/www/kbin.melroy.org/html/vendor/doctrine/dbal/src/Driver/API/PostgreSQL/ExceptionConverter.php:87","previous":{"class":"Doctrine\\DBAL\\Driver\\PDO\\Exception","message":"SQLSTATE[22P02]: Invalid text representation: 7 ERROR: invalid input syntax for type integer: \"es\"\nCONTEXT: unnamed portal parameter $1 = '...'","code":7,"file":"/var/www/kbin.melroy.org/html/vendor/doctrine/dbal/src/Driver/PDO/Exception.php:28","previous":{"class":"PDOException","message":"SQLSTATE[22P02]: Invalid text representation: 7 ERROR: invalid input syntax for type integer: \"es\"\nCONTEXT: unnamed portal parameter $1 = '...'","code":22,"file":"/var/www/kbin.melroy.org/html/vendor/doctrine/dbal/src/Driver/PDO/Statement.php:130"}}}},"level":500,"level_name":"CRITICAL","channel":"request","datetime":"2024-09-29T13:05:32.198035+02:00","extra":{}}
{"message":"Uncaught PHP Exception Doctrine\\DBAL\\Exception\\DriverException: \"An exception occurred while executing a query: SQLSTATE[22P02]: Invalid text representation: 7 ERROR: invalid input syntax for type integer: \"pt_BR\"\nCONTEXT: unnamed portal parameter $1 = '...'\" at ExceptionConverter.php line 87","context":{"exception":{"class":"Doctrine\\DBAL\\Exception\\DriverException","message":"An exception occurred while executing a query: SQLSTATE[22P02]: Invalid text representation: 7 ERROR: invalid input syntax for type integer: \"pt_BR\"\nCONTEXT: unnamed portal parameter $1 = '...'","code":7,"file":"/var/www/kbin.melroy.org/html/vendor/doctrine/dbal/src/Driver/API/PostgreSQL/ExceptionConverter.php:87","previous":{"class":"Doctrine\\DBAL\\Driver\\PDO\\Exception","message":"SQLSTATE[22P02]: Invalid text representation: 7 ERROR: invalid input syntax for type integer: \"pt_BR\"\nCONTEXT: unnamed portal parameter $1 = '...'","code":7,"file":"/var/www/kbin.melroy.org/html/vendor/doctrine/dbal/src/Driver/PDO/Exception.php:28","previous":{"class":"PDOException","message":"SQLSTATE[22P02]: Invalid text representation: 7 ERROR: invalid input syntax for type integer: \"pt_BR\"\nCONTEXT: unnamed portal parameter $1 = '...'","code":22,"file":"/var/www/kbin.melroy.org/html/vendor/doctrine/dbal/src/Driver/PDO/Statement.php:130"}}}},"level":500,"level_name":"CRITICAL","channel":"request","datetime":"2024-09-29T13:24:05.185252+02:00","extra":{}}
{"message":"Uncaught PHP Exception Doctrine\\DBAL\\Exception\\DriverException: \"An exception occurred while executing a query: SQLSTATE[22P02]: Invalid text representation: 7 ERROR: invalid input syntax for type integer: \"pt\"\nCONTEXT: unnamed portal parameter $1 = '...'\" at ExceptionConverter.php line 87","context":{"exception":{"class":"Doctrine\\DBAL\\Exception\\DriverException","message":"An exception occurred while executing a query: SQLSTATE[22P02]: Invalid text representation: 7 ERROR: invalid input syntax for type integer: \"pt\"\nCONTEXT: unnamed portal parameter $1 = '...'","code":7,"file":"/var/www/kbin.melroy.org/html/vendor/doctrine/dbal/src/Driver/API/PostgreSQL/ExceptionConverter.php:87","previous":{"class":"Doctrine\\DBAL\\Driver\\PDO\\Exception","message":"SQLSTATE[22P02]: Invalid text representation: 7 ERROR: invalid input syntax for type integer: \"pt\"\nCONTEXT: unnamed portal parameter $1 = '...'","code":7,"file":"/var/www/kbin.melroy.org/html/vendor/doctrine/dbal/src/Driver/PDO/Exception.php:28","previous":{"class":"PDOException","message":"SQLSTATE[22P02]: Invalid text representation: 7 ERROR: invalid input syntax for type integer: \"pt\"\nCONTEXT: unnamed portal parameter $1 = '...'","code":22,"file":"/var/www/kbin.melroy.org/html/vendor/doctrine/dbal/src/Driver/PDO/Statement.php:130"}}}},"level":500,"level_name":"CRITICAL","channel":"request","datetime":"2024-09-29T13:27:07.804965+02:00","extra":{}}
{"message":"Uncaught PHP Exception Doctrine\\DBAL\\Exception\\DriverException: \"An exception occurred while executing a query: SQLSTATE[22P02]: Invalid text representation: 7 ERROR: invalid input syntax for type integer: \"el\"\nCONTEXT: unnamed portal parameter $1 = '...'\" at ExceptionConverter.php line 87","context":{"exception":{"class":"Doctrine\\DBAL\\Exception\\DriverException","message":"An exception occurred while executing a query: SQLSTATE[22P02]: Invalid text representation: 7 ERROR: invalid input syntax for type integer: \"el\"\nCONTEXT: unnamed portal parameter $1 = '...'","code":7,"file":"/var/www/kbin.melroy.org/html/vendor/doctrine/dbal/src/Driver/API/PostgreSQL/ExceptionConverter.php:87","previous":{"class":"Doctrine\\DBAL\\Driver\\PDO\\Exception","message":"SQLSTATE[22P02]: Invalid text representation: 7 ERROR: invalid input syntax for type integer: \"el\"\nCONTEXT: unnamed portal parameter $1 = '...'","code":7,"file":"/var/www/kbin.melroy.org/html/vendor/doctrine/dbal/src/Driver/PDO/Exception.php:28","previous":{"class":"PDOException","message":"SQLSTATE[22P02]: Invalid text representation: 7 ERROR: invalid input syntax for type integer: \"el\"\nCONTEXT: unnamed portal parameter $1 = '...'","code":22,"file":"/var/www/kbin.melroy.org/html/vendor/doctrine/dbal/src/Driver/PDO/Statement.php:130"}}}},"level":500,"level_name":"CRITICAL","channel":"request","datetime":"2024-09-29T13:28:07.306013+02:00","extra":{}}
PostgreSQL log:
Press here for more postgresql log info
2024-09-30 22:31:28.256 CEST [89841] kbin@kbin ERROR: invalid input syntax fortype integer: "uk"
2024-09-30 22:31:28.256 CEST [89841] kbin@kbin CONTEXT: unnamed portal parameter $1 = '...'
2024-09-30 22:31:28.256 CEST [89841] kbin@kbin STATEMENT: SELECT t0.body AS body_1, t0.lang AS lang_2, t0.is_adult AS is_adult_3, t0.favourite_count AS favourite_count_4, t0.last_active AS last_active_5, t0.ip AS ip_6, t0.mentions AS mentions_7, t0.id AS id_8, t0.body_ts AS body_ts_9, t0.up_votes AS up_votes_10, t0.down_votes AS down_votes_11, t0.ap_like_count AS ap_like_count_12, t0.ap_dislike_count AS ap_dislike_count_13, t0.ap_share_count AS ap_share_count_14, t0.visibility AS visibility_15, t0.ap_id AS ap_id_16, t0.edited_at AS edited_at_17, t0.created_at AS created_at_18, t0.user_id AS user_id_19, t0.entry_id AS entry_id_20, t0.magazine_id AS magazine_id_21, t0.image_id AS image_id_22, t0.parent_id AS parent_id_23, t0.root_id AS root_id_24 FROM entry_comment t0 WHERE t0.id = $1
2024-09-30 22:31:33.315 CEST [89998] kbin@kbin ERROR: invalid input syntax fortype integer: "zh_TW"
2024-09-30 22:31:33.315 CEST [89998] kbin@kbin CONTEXT: unnamed portal parameter $1 = '...'
2024-09-30 22:31:33.315 CEST [89998] kbin@kbin STATEMENT: SELECT t0.body AS body_1, t0.lang AS lang_2, t0.is_adult AS is_adult_3, t0.favourite_count AS favourite_count_4, t0.last_active AS last_active_5, t0.ip AS ip_6, t0.mentions AS mentions_7, t0.id AS id_8, t0.body_ts AS body_ts_9, t0.up_votes AS up_votes_10, t0.down_votes AS down_votes_11, t0.ap_like_count AS ap_like_count_12, t0.ap_dislike_count AS ap_dislike_count_13, t0.ap_share_count AS ap_share_count_14, t0.visibility AS visibility_15, t0.ap_id AS ap_id_16, t0.edited_at AS edited_at_17, t0.created_at AS created_at_18, t0.user_id AS user_id_19, t0.entry_id AS entry_id_20, t0.magazine_id AS magazine_id_21, t0.image_id AS image_id_22, t0.parent_id AS parent_id_23, t0.root_id AS root_id_24 FROM entry_comment t0 WHERE t0.id = $1
2024-09-30 22:31:46.275 CEST [90266] kbin@kbin ERROR: invalid input syntax fortype integer: "uk"
2024-09-30 22:31:46.275 CEST [90266] kbin@kbin CONTEXT: unnamed portal parameter $1 = '...'
2024-09-30 22:31:46.275 CEST [90266] kbin@kbin STATEMENT: SELECT t0.body AS body_1, t0.lang AS lang_2, t0.is_adult AS is_adult_3, t0.favourite_count AS favourite_count_4, t0.last_active AS last_active_5, t0.ip AS ip_6, t0.mentions AS mentions_7, t0.id AS id_8, t0.body_ts AS body_ts_9, t0.up_votes AS up_votes_10, t0.down_votes AS down_votes_11, t0.ap_like_count AS ap_like_count_12, t0.ap_dislike_count AS ap_dislike_count_13, t0.ap_share_count AS ap_share_count_14, t0.visibility AS visibility_15, t0.ap_id AS ap_id_16, t0.edited_at AS edited_at_17, t0.created_at AS created_at_18, t0.user_id AS user_id_19, t0.entry_id AS entry_id_20, t0.magazine_id AS magazine_id_21, t0.image_id AS image_id_22, t0.parent_id AS parent_id_23, t0.root_id AS root_id_24 FROM entry_comment t0 WHERE t0.id = $1
2024-09-30 22:31:48.404 CEST [90311] kbin@kbin ERROR: invalid input syntax fortype integer: "nl"
2024-09-30 22:31:48.404 CEST [90311] kbin@kbin CONTEXT: unnamed portal parameter $1 = '...'
2024-09-30 22:31:48.404 CEST [90311] kbin@kbin STATEMENT: SELECT t0.body AS body_1, t0.lang AS lang_2, t0.is_adult AS is_adult_3, t0.favourite_count AS favourite_count_4, t0.last_active AS last_active_5, t0.ip AS ip_6, t0.mentions AS mentions_7, t0.id AS id_8, t0.body_ts AS body_ts_9, t0.up_votes AS up_votes_10, t0.down_votes AS down_votes_11, t0.ap_like_count AS ap_like_count_12, t0.ap_dislike_count AS ap_dislike_count_13, t0.ap_share_count AS ap_share_count_14, t0.visibility AS visibility_15, t0.ap_id AS ap_id_16, t0.edited_at AS edited_at_17, t0.created_at AS created_at_18, t0.user_id AS user_id_19, t0.entry_id AS entry_id_20, t0.magazine_id AS magazine_id_21, t0.image_id AS image_id_22, t0.parent_id AS parent_id_23, t0.root_id AS root_id_24 FROM entry_comment t0 WHERE t0.id = $1
2024-09-30 22:32:00.897 CEST [90868] kbin@kbin ERROR: duplicate key value violates unique constraint "uniq_b892fdfb904f155e"
2024-09-30 22:32:00.897 CEST [90868] kbin@kbin DETAIL: Key (ap_id)=(https://beehaw.org/comment/3964470) already exists.
2024-09-30 22:32:00.897 CEST [90868] kbin@kbin STATEMENT: INSERT INTO entry_comment (body, lang, is_adult, favourite_count, last_active, ip, mentions, id, up_votes, down_votes, ap_like_count, ap_dislike_count, ap_share_count, visibility, ap_id, edited_at, created_at, user_id, entry_id, magazine_id, image_id, parent_id, root_id) VALUES ($1, $2, $3, $4, $5, $6, $7, $8, $9, $10, $11, $12, $13, $14, $15, $16, $17, $18, $19, $20, $21, $22, $23)
2024-09-30 22:32:04.114 CEST [90979] root@root FATAL: role "root" does not exist
2024-09-30 22:32:12.169 CEST [91158] kbin@kbin ERROR: invalid input syntax fortype integer: "da"
2024-09-30 22:32:12.169 CEST [91158] kbin@kbin CONTEXT: unnamed portal parameter $1 = '...'
2024-09-30 22:32:12.169 CEST [91158] kbin@kbin STATEMENT: SELECT t0.body AS body_1, t0.lang AS lang_2, t0.is_adult AS is_adult_3, t0.favourite_count AS favourite_count_4, t0.last_active AS last_active_5, t0.ip AS ip_6, t0.mentions AS mentions_7, t0.id AS id_8, t0.body_ts AS body_ts_9, t0.up_votes AS up_votes_10, t0.down_votes AS down_votes_11, t0.ap_like_count AS ap_like_count_12, t0.ap_dislike_count AS ap_dislike_count_13, t0.ap_share_count AS ap_share_count_14, t0.visibility AS visibility_15, t0.ap_id AS ap_id_16, t0.edited_at AS edited_at_17, t0.created_at AS created_at_18, t0.user_id AS user_id_19, t0.entry_id AS entry_id_20, t0.magazine_id AS magazine_id_21, t0.image_id AS image_id_22, t0.parent_id AS parent_id_23, t0.root_id AS root_id_24 FROM entry_comment t0 WHERE t0.id = $1
2024-09-30 22:32:33.857 CEST [92018] kbin@kbin ERROR: invalid input syntax fortype integer: "es"
2024-09-30 22:32:33.857 CEST [92018] kbin@kbin CONTEXT: unnamed portal parameter $1 = '...'
2024-09-30 22:32:33.857 CEST [92018] kbin@kbin STATEMENT: SELECT t0.body AS body_1, t0.lang AS lang_2, t0.is_adult AS is_adult_3, t0.favourite_count AS favourite_count_4, t0.last_active AS last_active_5, t0.ip AS ip_6, t0.mentions AS mentions_7, t0.id AS id_8, t0.body_ts AS body_ts_9, t0.up_votes AS up_votes_10, t0.down_votes AS down_votes_11, t0.ap_like_count AS ap_like_count_12, t0.ap_dislike_count AS ap_dislike_count_13, t0.ap_share_count AS ap_share_count_14, t0.visibility AS visibility_15, t0.ap_id AS ap_id_16, t0.edited_at AS edited_at_17, t0.created_at AS created_at_18, t0.user_id AS user_id_19, t0.entry_id AS entry_id_20, t0.magazine_id AS magazine_id_21, t0.image_id AS image_id_22, t0.parent_id AS parent_id_23, t0.root_id AS root_id_24 FROM entry_comment t0 WHERE t0.id = $1
24th - Still seeing duplicate key value violates unique constraint issues:
the first: I can't reproduce it
the fifth: could be a follow up of the second, but I am not sure
the eigth: same as the fourth
the eleventh: not my area 😅
Describe the bug
I see a long list of errors and warnings in the prod log.
We really need to clean-up some of those and try to fix the PHP warning or PHP or Twig errors we see...
I could make 20+ GitHub Issues out of this single ticket, but that won't help us. And will only cause more overhead. See the list of warnings/errors below under "List of issues".
On which Mbin instance did you find the bug?
kbin.melroy.org
Which Mbin version was running on the instance?
1.7.1
To Reproduce
Steps to reproduce the behavior:
tail -f var/log/prod-xx-x-x-x.log
Expected behavior
Minimal amount of errors and warnings in the production log. Only some error messages make sense if there is a real error and we still want to keep reporting it to admin of the instance.
Let's just see how much we can resolve in the first 1.7.2 milestone..
List of issues
Directly from the production log output:
I added "feddit.de" to block list (in the admin panel). Why do I still see?
Full stack trace
And also seems to be related:
Most seen CSRF IDs causing issues are:
vote
)favourite
)Possible solution directions:
Full stack trace
During my testing in DEV mode:
And from Jerry during PRD mode:
Full stack trace
invalid input syntax for type integer: \"{user_id}\"
:This error also can be seens if the email confirmation URL is wrong or wrongly interpreted by the client or whatever is wrong.. (using the
verify/email/..
path):The logs are missing a request URL (path) for sure, otherwise it's very hard to debug the above messages, without any clue which kind of request we are talking about. But for sure it could trigger this error above by the confirmation email link.
Fetched remote object https://kbin.melroy.org/u/RmDebArk_5 which was deleted
. Is this is error? Can we fix it in a better way? If not, why do we log it?Related:
invalid input syntax for type integer: "el"
(el is a language literal) - PR: Add stricter requirements to existing routes #1150PostgreSQL log:
Press here for more postgresql log info
See also: #1072 (which I will not mention here)
The text was updated successfully, but these errors were encountered: