Remote follow problem

Hi there,

I have a working server with mastodon (mastodon.init-c.de) running for my workplace. (not docker) But one function doesn’t work so far. No user on my instance including me as admin can follow users from other servers. I get the “We’re sorry, but something went wrong on our end.” on the authorize_interaction popup. No explanation, no nothing. I guess to help me you need some log information. Where to find the logs? What can I do to help you help me?
Best
Martin

If you are running on a platform with systemd, journalctl -u mastodon-web may have more info

I tried again to follow a remote account, to have an actual timestamp and this is the output of journalctl -u mastodon-web:

May 07 07:26:36 mewi-xperiments bundle[2156]: [65978457-ea45-44a3-b7e3-ea272926d88c] method=GET path=/ format=html controller=HomeController action=index status=200 duration=50.22 view=34.58 db=8.57
May 07 07:26:37 mewi-xperiments bundle[2153]: [bd4029d2-82c4-4397-9a46-b02ed5440413] method=GET path=/api/v1/markers format=html controller=Api::V1::MarkersController action=index status=200 duration=26.49 view=0.13 db=14.03
May 07 07:26:37 mewi-xperiments bundle[2156]: [958d4152-63f4-47bd-b202-4fad43819b33] method=GET path=/api/v1/custom_emojis format=html controller=Api::V1::CustomEmojisController action=index status=200 duration=27.88 view=1.07 db=12.22
May 07 07:26:37 mewi-xperiments bundle[2156]: [57f438e9-a18d-47ad-8624-87e5bfa448a6] method=GET path=/api/v1/notifications format=html controller=Api::V1::NotificationsController action=index status=200 duration=114.28 view=56.79 db=14.70
May 07 07:26:37 mewi-xperiments bundle[2153]: [745085a7-30ef-41d9-97a0-29f4e89bd345] method=GET path=/api/v1/timelines/home format=html controller=Api::V1::Timelines::HomeController action=show status=200 duration=138.59 view=75.36 db=20.19
May 07 07:26:37 mewi-xperiments bundle[2153]: [8b010863-3c18-4e13-b229-8539a1ccebd5] method=GET path=/api/v1/suggestions format=html controller=Api::V1::SuggestionsController action=index status=200 duration=12.56 view=0.86 db=2.82
May 07 07:26:37 mewi-xperiments bundle[2156]: [a471a699-6ab0-491b-a97f-bc08977fabb5] method=GET path=/api/v1/follow_requests format=html controller=Api::V1::FollowRequestsController action=index status=200 duration=20.12 view=0.87 db=5.20
May 07 07:26:37 mewi-xperiments bundle[2153]: [fd14a4af-0d84-441b-8357-8cdb1014d4fb] method=GET path=/api/v1/announcements format=html controller=Api::V1::AnnouncementsController action=index status=200 duration=27.55 view=1.83 db=11.68
May 07 07:26:37 mewi-xperiments bundle[2153]: [fef47e9c-c9ca-4484-8fca-0351e8f5e24f] method=GET path=/api/v1/trends format=html controller=Api::V1::TrendsController action=index status=200 duration=31.15 view=0.69 db=15.84
May 07 07:26:37 mewi-xperiments bundle[2153]: [3303db62-1370-4e17-8e99-d970dae85645] method=GET path=/api/v1/filters format=html controller=Api::V1::FiltersController action=index status=200 duration=19.80 view=4.00 db=6.93
May 07 07:26:37 mewi-xperiments bundle[2153]: [a72489a2-13e4-4e1e-85b1-c28fd5726c5c] method=GET path=/api/v1/accounts/relationships format=html controller=Api::V1::Accounts::RelationshipsController action=index status=200 duration=60.42 view=4.10 db=24.>
May 07 07:26:48 mewi-xperiments bundle[2153]: [d3cd1cef-b5e4-4514-9c1f-c5f56a34e42a] [paperclip] Trying to link /tmp/8c766493ca3d4d2aeb4f40cc905fa02920210507-2153-1eoij26.jpg to /tmp/aeb258b829ad235a1f7fdc467310bd0720210507-2153-nedikr.jpg
May 07 07:26:48 mewi-xperiments bundle[2153]: [d3cd1cef-b5e4-4514-9c1f-c5f56a34e42a] Command :: file -b --mime '/tmp/aeb258b829ad235a1f7fdc467310bd0720210507-2153-nedikr.jpg'
May 07 07:26:48 mewi-xperiments bundle[2153]: [d3cd1cef-b5e4-4514-9c1f-c5f56a34e42a] [paperclip] Trying to link /tmp/8c766493ca3d4d2aeb4f40cc905fa02920210507-2153-1eoij26.jpg to /tmp/f39e03b78d9071fe8fafbb948dfe791f20210507-2153-ltmim2.jpg
May 07 07:26:48 mewi-xperiments bundle[2153]: [d3cd1cef-b5e4-4514-9c1f-c5f56a34e42a] [paperclip] Link failed with No such file or directory @ rb_file_s_link - (/tmp/8c766493ca3d4d2aeb4f40cc905fa02920210507-2153-1eoij26.jpg, /tmp/f39e03b78d9071fe8fafbb94>
May 07 07:26:48 mewi-xperiments bundle[2153]: [d3cd1cef-b5e4-4514-9c1f-c5f56a34e42a] method=GET path=/authorize_interaction format=html controller=AuthorizeInteractionsController action=show status=500 error='Errno::ENOENT: No such file or directory @ r>
May 07 07:26:48 mewi-xperiments bundle[2153]: [d3cd1cef-b5e4-4514-9c1f-c5f56a34e42a]
May 07 07:26:48 mewi-xperiments bundle[2153]: [d3cd1cef-b5e4-4514-9c1f-c5f56a34e42a] Errno::ENOENT (No such file or directory @ rb_sysopen - /tmp/8c766493ca3d4d2aeb4f40cc905fa02920210507-2153-1eoij26.jpg):
May 07 07:26:48 mewi-xperiments bundle[2153]: [d3cd1cef-b5e4-4514-9c1f-c5f56a34e42a]
May 07 07:26:48 mewi-xperiments bundle[2153]: [d3cd1cef-b5e4-4514-9c1f-c5f56a34e42a] app/models/concerns/remotable.rb:27:in `public_send'
May 07 07:26:48 mewi-xperiments bundle[2153]: [d3cd1cef-b5e4-4514-9c1f-c5f56a34e42a] app/models/concerns/remotable.rb:27:in `block (2 levels) in remotable_attachment'
May 07 07:26:48 mewi-xperiments bundle[2153]: [d3cd1cef-b5e4-4514-9c1f-c5f56a34e42a] app/lib/request.rb:75:in `perform'
May 07 07:26:48 mewi-xperiments bundle[2153]: [d3cd1cef-b5e4-4514-9c1f-c5f56a34e42a] app/models/concerns/remotable.rb:24:in `block in remotable_attachment'
May 07 07:26:48 mewi-xperiments bundle[2153]: [d3cd1cef-b5e4-4514-9c1f-c5f56a34e42a] app/models/concerns/remotable.rb:44:in `public_send'
May 07 07:26:48 mewi-xperiments bundle[2153]: [d3cd1cef-b5e4-4514-9c1f-c5f56a34e42a] app/models/concerns/remotable.rb:44:in `block in remotable_attachment'
May 07 07:26:48 mewi-xperiments bundle[2153]: [d3cd1cef-b5e4-4514-9c1f-c5f56a34e42a] app/services/activitypub/process_account_service.rb:108:in `set_fetchable_attributes!'
May 07 07:26:48 mewi-xperiments bundle[2153]: [d3cd1cef-b5e4-4514-9c1f-c5f56a34e42a] app/services/activitypub/process_account_service.rb:77:in `update_account'
May 07 07:26:48 mewi-xperiments bundle[2153]: [d3cd1cef-b5e4-4514-9c1f-c5f56a34e42a] app/services/activitypub/process_account_service.rb:28:in `block in call'
May 07 07:26:48 mewi-xperiments bundle[2153]: [d3cd1cef-b5e4-4514-9c1f-c5f56a34e42a] app/services/activitypub/process_account_service.rb:19:in `call'
May 07 07:26:48 mewi-xperiments bundle[2153]: [d3cd1cef-b5e4-4514-9c1f-c5f56a34e42a] app/services/activitypub/fetch_remote_account_service.rb:31:in `call'
May 07 07:26:48 mewi-xperiments bundle[2153]: [d3cd1cef-b5e4-4514-9c1f-c5f56a34e42a] app/services/resolve_url_service.rb:24:in `process_url'
May 07 07:26:48 mewi-xperiments bundle[2153]: [d3cd1cef-b5e4-4514-9c1f-c5f56a34e42a] app/services/resolve_url_service.rb:14:in `call'
May 07 07:26:48 mewi-xperiments bundle[2153]: [d3cd1cef-b5e4-4514-9c1f-c5f56a34e42a] app/controllers/authorize_interactions_controller.rb:41:in `located_resource'
May 07 07:26:48 mewi-xperiments bundle[2153]: [d3cd1cef-b5e4-4514-9c1f-c5f56a34e42a] app/controllers/authorize_interactions_controller.rb:35:in `set_resource'
May 07 07:26:48 mewi-xperiments bundle[2153]: [d3cd1cef-b5e4-4514-9c1f-c5f56a34e42a] app/controllers/concerns/localized.rb:16:in `block in set_locale'
May 07 07:26:48 mewi-xperiments bundle[2153]: [d3cd1cef-b5e4-4514-9c1f-c5f56a34e42a] app/controllers/concerns/localized.rb:15:in `set_locale'
May 07 07:31:38 mewi-xperiments bundle[2156]: [5bab1a48-70e8-49dc-a437-d4b9d8713cf2] method=POST path=/api/v1/markers format=html controller=Api::V1::MarkersController action=create status=200 duration=63.15 view=0.62 db=41.08
May 07 07:33:05 mewi-xperiments bundle[2153]: [202e6fd4-20c9-4fd1-a086-e767b2accae2] method=GET path=/api/v1/markers format=html controller=Api::V1::MarkersController action=index status=200 duration=3.21 view=0.14 db=1.00
May 07 07:33:05 mewi-xperiments bundle[2153]: [f892d79e-1a96-4d41-b4c7-114ca9cd9e31] method=GET path=/api/v1/notifications format=html controller=Api::V1::NotificationsController action=index status=200 duration=11.42 view=0.45 db=4.61
lines 5520-5588/5588 (END)

We are getting there! Seems like strange things are happening in your /tmp directory. Do you know why /tmp/8c766493ca3d4d2aeb4f40cc905fa02920210507-2153-1eoij26.jpg seems to exist and then magically disappers? Did it get created in the first place?

(by the way, your logs are truncated to the right, it’s better do dump it to a file and copy from there)

hi again. Thank you for trying to help. I have no idea, why this .jpg exist nor why it is (or isn’t) created. in my tmp directory I can’t find such a file or any jpg for that matter. Here a new log printout without truncates:

May 07 09:13:45 mewi-xperiments bundle[2156]: [6f97973a-9553-4b92-bddd-e164f094e143] method=GET path=/ format=html controller=HomeController action=index status=200 duration=151.86 view=68.62 db=70.80
May 07 09:13:45 mewi-xperiments bundle[2153]: [7a1ae16f-e83a-46b8-a286-e2b9af9677d8] method=GET path=/api/v1/markers format=html controller=Api::V1::MarkersController action=index status=200 duration=28.60 view=0.16 db=13.51
May 07 09:13:45 mewi-xperiments bundle[2156]: [cbca5fcd-b161-470b-9007-835eb96f1cde] method=GET path=/api/v1/custom_emojis format=html controller=Api::V1::CustomEmojisController action=index status=200 duration=24.38 view=1.03 db=7.83
May 07 09:13:45 mewi-xperiments bundle[2153]: [58043452-48f8-4286-956e-09ea0ad4c5a7] method=GET path=/api/v1/notifications format=html controller=Api::V1::NotificationsController action=index status=200 duration=113.21 view=55.82 db=19.14
May 07 09:13:45 mewi-xperiments bundle[2156]: [72091e88-792d-4623-8312-8ecaedb0fa8c] method=GET path=/api/v1/timelines/home format=html controller=Api::V1::Timelines::HomeController action=show status=200 duration=130.87 view=78.63 db=10.70
May 07 09:13:45 mewi-xperiments bundle[2153]: [ea06664a-d481-4d68-907e-6c0d6f99fdf1] method=GET path=/api/v1/suggestions format=html controller=Api::V1::SuggestionsController action=index status=200 duration=12.25 view=0.83 db=2.81
May 07 09:13:45 mewi-xperiments bundle[2153]: [9492df61-3003-4d4c-9fd6-3b7e87560056] method=GET path=/api/v1/follow_requests format=html controller=Api::V1::FollowRequestsController action=index status=200 duration=15.92 view=0.80 db=4.07
May 07 09:13:45 mewi-xperiments bundle[2156]: [147d44a6-28b3-49e9-a710-6a21e2741d97] method=GET path=/api/v1/announcements format=html controller=Api::V1::AnnouncementsController action=index status=200 duration=22.24 view=2.43 db=10.16
May 07 09:13:45 mewi-xperiments bundle[2156]: [45595dcc-646e-4dab-af7f-dbbe13268fd0] method=GET path=/api/v1/trends format=html controller=Api::V1::TrendsController action=index status=200 duration=28.70 view=0.73 db=11.75
May 07 09:13:45 mewi-xperiments bundle[2153]: [502d95f4-0936-4709-a15c-b2c7ee131673] method=GET path=/api/v1/accounts/relationships format=html controller=Api::V1::Accounts::RelationshipsController action=index status=200 duration=38.99 view=4.17 db=11.72
May 07 09:13:46 mewi-xperiments bundle[2153]: [b1ecbcaa-e35f-4297-a2ca-9920ad08e6b1] method=GET path=/api/v1/filters format=html controller=Api::V1::FiltersController action=index status=200 duration=14.81 view=2.95 db=3.73
May 07 09:13:53 mewi-xperiments bundle[2153]: [a6503bfb-6213-411f-8d21-49dcce7c3bd3] [paperclip] Trying to link /tmp/8c766493ca3d4d2aeb4f40cc905fa02920210507-2153-n5k52w.jpg to /tmp/d6cee2d264fa7ee254409c711ca307a420210507-2153-1jytdgi.jpg
May 07 09:13:53 mewi-xperiments bundle[2153]: [a6503bfb-6213-411f-8d21-49dcce7c3bd3] Command :: file -b --mime '/tmp/d6cee2d264fa7ee254409c711ca307a420210507-2153-1jytdgi.jpg'
May 07 09:13:53 mewi-xperiments bundle[2153]: [a6503bfb-6213-411f-8d21-49dcce7c3bd3] [paperclip] Trying to link /tmp/8c766493ca3d4d2aeb4f40cc905fa02920210507-2153-n5k52w.jpg to /tmp/ec3077bb2999106da7df62fd600537f920210507-2153-14mhsom.jpg
May 07 09:13:53 mewi-xperiments bundle[2153]: [a6503bfb-6213-411f-8d21-49dcce7c3bd3] [paperclip] Link failed with No such file or directory @ rb_file_s_link - (/tmp/8c766493ca3d4d2aeb4f40cc905fa02920210507-2153-n5k52w.jpg, /tmp/ec3077bb2999106da7df62fd600537f920210507-2153-14mhsom.jpg); copying link /tmp/8c766493ca3d4d2aeb4f40cc905fa02920210507-2153-n5k52w.jpg to /tmp/ec3077bb2999106da7df62fd600537f920210507-2153-14mhsom.jpg
May 07 09:13:53 mewi-xperiments bundle[2153]: [a6503bfb-6213-411f-8d21-49dcce7c3bd3] method=GET path=/authorize_interaction format=html controller=AuthorizeInteractionsController action=show status=500 error='Errno::ENOENT: No such file or directory @ rb_sysopen - /tmp/8c766493ca3d4d2aeb4f40cc905fa02920210507-2153-n5k52w.jpg' duration=510.92 view=0.00 db=6.73
May 07 09:13:53 mewi-xperiments bundle[2153]: [a6503bfb-6213-411f-8d21-49dcce7c3bd3]
May 07 09:13:53 mewi-xperiments bundle[2153]: [a6503bfb-6213-411f-8d21-49dcce7c3bd3] Errno::ENOENT (No such file or directory @ rb_sysopen - /tmp/8c766493ca3d4d2aeb4f40cc905fa02920210507-2153-n5k52w.jpg):
May 07 09:13:53 mewi-xperiments bundle[2153]: [a6503bfb-6213-411f-8d21-49dcce7c3bd3]
May 07 09:13:53 mewi-xperiments bundle[2153]: [a6503bfb-6213-411f-8d21-49dcce7c3bd3] app/models/concerns/remotable.rb:27:in `public_send'
May 07 09:13:53 mewi-xperiments bundle[2153]: [a6503bfb-6213-411f-8d21-49dcce7c3bd3] app/models/concerns/remotable.rb:27:in `block (2 levels) in remotable_attachment'
May 07 09:13:53 mewi-xperiments bundle[2153]: [a6503bfb-6213-411f-8d21-49dcce7c3bd3] app/lib/request.rb:75:in `perform'
May 07 09:13:53 mewi-xperiments bundle[2153]: [a6503bfb-6213-411f-8d21-49dcce7c3bd3] app/models/concerns/remotable.rb:24:in `block in remotable_attachment'
May 07 09:13:53 mewi-xperiments bundle[2153]: [a6503bfb-6213-411f-8d21-49dcce7c3bd3] app/models/concerns/remotable.rb:44:in `public_send'
May 07 09:13:53 mewi-xperiments bundle[2153]: [a6503bfb-6213-411f-8d21-49dcce7c3bd3] app/models/concerns/remotable.rb:44:in `block in remotable_attachment'
May 07 09:13:53 mewi-xperiments bundle[2153]: [a6503bfb-6213-411f-8d21-49dcce7c3bd3] app/services/activitypub/process_account_service.rb:108:in `set_fetchable_attributes!'
May 07 09:13:53 mewi-xperiments bundle[2153]: [a6503bfb-6213-411f-8d21-49dcce7c3bd3] app/services/activitypub/process_account_service.rb:77:in `update_account'
May 07 09:13:53 mewi-xperiments bundle[2153]: [a6503bfb-6213-411f-8d21-49dcce7c3bd3] app/services/activitypub/process_account_service.rb:28:in `block in call'
May 07 09:13:53 mewi-xperiments bundle[2153]: [a6503bfb-6213-411f-8d21-49dcce7c3bd3] app/services/activitypub/process_account_service.rb:19:in `call'
May 07 09:13:53 mewi-xperiments bundle[2153]: [a6503bfb-6213-411f-8d21-49dcce7c3bd3] app/services/activitypub/fetch_remote_account_service.rb:31:in `call'
May 07 09:13:53 mewi-xperiments bundle[2153]: [a6503bfb-6213-411f-8d21-49dcce7c3bd3] app/services/resolve_url_service.rb:24:in `process_url'
May 07 09:13:53 mewi-xperiments bundle[2153]: [a6503bfb-6213-411f-8d21-49dcce7c3bd3] app/services/resolve_url_service.rb:14:in `call'
May 07 09:13:53 mewi-xperiments bundle[2153]: [a6503bfb-6213-411f-8d21-49dcce7c3bd3] app/controllers/authorize_interactions_controller.rb:41:in `located_resource'
May 07 09:13:53 mewi-xperiments bundle[2153]: [a6503bfb-6213-411f-8d21-49dcce7c3bd3] app/controllers/authorize_interactions_controller.rb:35:in `set_resource'
May 07 09:13:53 mewi-xperiments bundle[2153]: [a6503bfb-6213-411f-8d21-49dcce7c3bd3] app/controllers/concerns/localized.rb:16:in `block in set_locale'
May 07 09:13:53 mewi-xperiments bundle[2153]: [a6503bfb-6213-411f-8d21-49dcce7c3bd3] app/controllers/concerns/localized.rb:15:in `set_locale'

I think that’s a root cause of the problem you are having but I don’t know how to troubleshoot it further. Tracing filesystem calls with paperclip rubygem source in hand seems to be too much for me now…

This topic was automatically closed 14 days after the last reply. New replies are no longer allowed.