Skip to main content

No Mastodon connection after update to 2021.07

After the upgrade to 2021.07 using the full zip files, I came across a bug which I could fix with help from annando on github.

After that I do not see any php errors but I also do not get any messages from all my mastodon contacts. Can anyone give me a hint about this?

I'm using nginx as webserver and also nginx as reverse proxy in front of it. PHP is 7.3.

!Friendica Support


[2021.09] PHP Fatal Errors · Issue #10473 · friendica/friendica

Please report here any PHP Fatal error message obtained running the 2021.07 stable or 2021.09-dev versions. Closes #10167
GitHub
#10167 !Friendica Support
Martin Winkler
Martin Winkler  
@Michael Vogel I'm not seeing your comment on my instance but I followed your request for one example and copied a little more from the friend.log. But i didn't find anything from the exact same time:

[14/Jul/2021:14:24:04 +0200] "GET /ping?format=json&uid=2&_=1626264997110 HTTP/1.0" 200 60620 "https://fd.winklerfamilie.eu/network" "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/**.**.**.** Safari/537.36"
[14/Jul/2021:14:24:25 +0200] "GET /profile/efelonzrl=%20%D0%A1%D0%BE%D1%80%D0%BE%D0%BA%D0%B8%D0%BD%20%D0%90%D0%BB%D0%B5%D0%BA%D1%81%D0%B5%D0%B9/'s%20profile%20@%20http:/social.feder8.ru/profile/xrev%252?page=76 HTTP/1.0" 404 12825 "-" "Mozilla/5.0 (compatible; MJ12bot/v1.4.8;http://mj12bot.com/)"


2021-07-14T12:24:02Z worker [INFO]: Connection usage (system values) {"used":2,"max":300} - {"file":"Worker.php","line":584,"function":"maxConnectionsReached","uid":"dae44c","process_id":7686}
2021-07-14T12:24:02Z worker [INFO]: No tasks found [] - {"file":"Worker.php","line":875,"function":"nextProcess","uid":"dae44c","process_id":7686}
2021-07-14T12:24:02Z worker [INFO]: Couldn't select a workerqueue entry, quitting process {"pid":7686} - {"file":"Worker.php","line":167,"function":"processQueue","uid":"dae44c","process_id":7686}
2021-07-14T12:24:02Z worker [NOTICE]: Load: 0.43/50 - processes: 0/2/0 (0:2) - maximum: 4/4 [] - {"file":"Worker.php","line":786,"function":"tooMuchWorkers","uid":"ddaf4e","process_id":7684}
2021-07-14T12:24:02Z worker [INFO]: Connection usage (system values) {"used":1,"max":300} - {"file":"Worker.php","line":584,"function":"maxConnectionsReached","uid":"ddaf4e","process_id":7684}
2021-07-14T12:24:02Z worker [INFO]: No tasks found [] - {"file":"Worker.php","line":875,"function":"nextProcess","uid":"ddaf4e","process_id":7684}
2021-07-14T12:24:02Z worker [INFO]: Couldn't select a workerqueue entry, quitting process {"pid":7684} - {"file":"Worker.php","line":167,"function":"processQueue","uid":"ddaf4e","process_id":7684}
2021-07-14T12:24:04Z index [INFO]: No HTTP_SIGNATURE header [] - {"file":"HTTPSignature.php","line":476,"function":"getSigner","uid":"351437","process_id":4145}
@Michael Vogel
Martin Winkler
Martin Winkler  
@Michael Vogel or maybe this is more of what you had in mind? (I'm sorry. I'm not at home right now which makes searching and formating not so easy):

[14/Jul/2021:14:34:35 +0200] "GET /static/identity-v1.jsonld HTTP/1.0" 404 12748 "-" "-"
[14/Jul/2021:14:34:35 +0200] "GET /static/activitystreams.jsonld HTTP/1.0" 404 12752 "-" "-"


2021-07-14T12:34:35Z index [INFO]: Provided GUID found. {"guid":"da014be1-1060-eed9-8688-f31661226866","uri-id":174669} - {"file":"Objects.php","line":56,"function":"rawContent","uid":"f9e7c4","process_id":4145}
2021-07-14T12:34:35Z index [INFO]: Fetching activity {"item":327476} - {"file":"Transmitter.php","line":1043,"function":"createActivityFromItem","uid":"f9e7c4","process_id":4145}
2021-07-14T12:34:35Z index [INFO]: Fetched activity {"item":327476,"uid":2} - {"file":"Transmitter.php","line":1159,"function":"createActivityFromItem","uid":"f9e7c4","process_id":4145}
2021-07-14T12:34:35Z index [NOTICE]: no data for session {"session_id":"0ipj5ne42lga8nkjmvc82k5t5t","uri":"\/static\/identity-v1.jsonld"} - {"file":"Database.php","line":72,"function":"read","uid":"5db843","process_id":20467}
2021-07-14T12:34:35Z index [INFO]: No HTTP_SIGNATURE header [] - {"file":"HTTPSignature.php","line":476,"function":"getSigner","uid":"5db843","process_id":20467}
2021-07-14T12:34:35Z index [WARNING]: JsonLD normalize error [] - {"file":"JsonLD.php","line":110,"function":"normalize","uid":"f9e7c4","process_id":4145}
2021-07-14T12:34:35Z index [NOTICE]: JsonLD normalize error {"messages":["Could not convert input to RDF dataset before normalization.","Could not
expand input before serialization to RDF.","Could not perform JSON-LD expansion.","Could not retrieve a JSON-LD document from the URL: https:\/\/fd
.winklerfamilie.eu\/static\/identity-v1.jsonld"]} - {"file":"JsonLD.php","line":111,"function":"normalize","uid":"f9e7c4","process_id":4145}
2021-07-14T12:34:35Z index [INFO]: JsonLD normalize error {"trace":"#0 \/var\/www\/friendica\/vendor\/friendica\/json-ld\/jsonld.php(159): JsonLdPr
ocessor->normalize(Object(stdClass), Array)\n#1 \/var\/www\/friendica\/src\/Util\/JsonLD.php(100): jsonld_normalize(Object(stdClass), Array)\n#2 \/
var\/www\/friendica\/src\/Util\/LDSignature.php(104): Friendica\\Util\\JsonLD::normalize(Array)\n#3 \/var\/www\/friendica\/src\/Util\/LDSignature.p
hp(78): Friendica\\Util\\LDSignature::hash(Array)\n#4 \/var\/www\/friendica\/src\/Protocol\/ActivityPub\/Transmitter.php(1163): Friendica\\Util\\LD
Signature::sign(Array, Array)\n#5 \/var\/www\/friendica\/src\/Module\/Objects.php(131): Friendica\\Protocol\\ActivityPub\\Transmitter::createActivi
tyFromItem(327476)\n#6 [internal function]: Friendica\\Module\\Objects::rawContent(Array)\n#7 \/var\/www\/friendica\/src\/App\/Module.php(332): cal
l_user_func(Array, Array)\n#8 \/var\/www\/friendica\/src\/App.php(562): Friendica\\App\\Module->run(Object(Friendica\\Core\\L10n), Object(Friendica
\\App\\BaseURL), Object(Friendica\\Util\\Logger\\StreamLogger), Object(Friendica\\Util\\Profiler), Array, Array)\n#9 \/var\/www\/friendica\/index.p
hp(42): Friendica\\App->runFrontend(Object(Friendica\\App\\Module), Object(Friendica\\App\\Router), Object(Friendica\\Core\\PConfig\\JitPConfig), O
bject(Friendica\\Security\\Authentication), Object(Friendica\\App\\Page), 1626266074.9257)\n#10 {main}"} - {"file":"JsonLD.php","line":112,"function":"normalize","uid":"f9e7c4","process_id":4145}
2021-07-14T12:34:35Z index [NOTICE]: no data for session {"session_id":"h5a65d70on08btpab8aoj01230","uri":"\/static\/activitystreams.jsonld"} - {"file":"Database.php","line":72,"function":"read","uid":"22627a","process_id":19976}
2021-07-14T12:34:35Z index [INFO]: No HTTP_SIGNATURE header [] - {"file":"HTTPSignature.php","line":476,"function":"getSigner","uid":"22627a","process_id":19976}
@Michael Vogel
Martin Winkler
Martin Winkler  
@Michael Vogel indeed I see the post from pirati.ca and even some coming from mastodon close before. I do even get a notification saying you commented. But nothing in my timeline.

[14/Jul/2021:15:06:19 +0200] "GET /static/activitystreams.jsonld HTTP/1.0" 404 12752 "-" "-"
[14/Jul/2021:15:06:19 +0200] "POST /inbox HTTP/1.0" 202 0 "-" "http.rb/3.3.0 (Mastodon/3.0.2; +https://pawoo.net/)"
[14/Jul/2021:15:06:55 +0200] "GET /static/activitystreams.jsonld HTTP/1.0" 404 12752 "-" "-"
[14/Jul/2021:15:06:55 +0200] "POST /inbox HTTP/1.0" 202 0 "-" "http.rb/4.4.1 (Mastodon/3.4.1; +https://mastodont.cat/)"
[14/Jul/2021:15:07:00 +0200] "GET /static/activitystreams.jsonld HTTP/1.0" 404 12752 "-" "-"
[14/Jul/2021:15:07:00 +0200] "POST /inbox HTTP/1.0" 202 0 "-" "Friendica 'Siberian Iris' 2021.09-dev-1429; https://pirati.ca"


2021-07-14T13:07:00Z index [NOTICE]: no data for session {"session_id":"jgq2u2p3t74d6lqr0ho76ho615","uri":"\/static\/activitystreams.jsonld"} - {"file":"Database.php","line":72,"function":"read","uid":"dcb05a","process_id":4143}
2021-07-14T13:07:00Z index [INFO]: No HTTP_SIGNATURE header [] - {"file":"HTTPSignature.php","line":476,"function":"getSigner","uid":"dcb05a","process_id":4143}
2021-07-14T13:07:00Z index [ERROR]: compacting error {"line":911,"message":"Could not expand input before compaction."} - {"file":"JsonLD.php","line":168,"function":"compact","uid":"433cce","process_id":4150}
2021-07-14T13:07:00Z index [NOTICE]: Unable to retrieve AP contact for actor - message is discarded {"actor":null} - {"file":"Receiver.php","line":104,"function":"processInbox","uid":"433cce","process_id":4150}
2021-07-14T13:07:00Z index [INFO]: http_status_exit 202 [] - {"file":"System.php","line":125,"function":"httpExit","uid":"433cce","process_id":4150}
@Michael Vogel
Martin Winkler
Martin Winkler  
I will have a look later or tomorrow and come back to you, but I updated the last ~6 versions of friendica with this nginx/proxy/php/mysql setup. And as I said with 2021.04 everything was doing fine.
Martin Winkler
Martin Winkler  
Do you get the "compacting error" all the time?
Yes this messages is all over the place.
https://github.com/friendica/friendica/issues/10254
This is exactly what I see. Thanks for the link.

Do I understand correctly, that this change is merged into dev but not available in 2021.07?
Martin Winkler
Martin Winkler  
Access doesn't seam to be the problem:

root@serverpi:/var/www/friendica/static# ll -d
drwxr-xr-x 2 www-data www-data 4096 Jul  4 20:50 .
root@serverpi:/var/www/friendica/static# ll *v1*
-rw-r--r-- 1 www-data www-data 3622 Jul  4 20:50 identity-v1.jsonld
-rw-r--r-- 1 www-data www-data 2059 Jul  4 20:50 security-v1.jsonld


But I think I'll try to switch to dev using git clone anyway. Until now I used the zip files to upgrade.

Also I'm on Raspberry pi OS 32bit (raspi 4) if this information has anything to with it.
Martin Winkler
Martin Winkler  
Ok. Got it. The static files could not be accessed with my old nginx config. It is the sample from github but don't ask me how old exactly.

This is the "old" rewrite to front controller (I had a quick look in the history: 3+ years ago) which rewrites access to the folder /static also to the front controller:
  # rewrite to front controller as default rule
  location / {
    if ($is_args != "") {
        rewrite ^/(.*) /index.php?pagename=$uri&$args last;
    }
    rewrite ^/(.*) /index.php?pagename=$uri last;
  }

This is the latest rewrite which tries available files first:
  # rewrite to front controller as default rule
  location / {
    try_files $uri /index.php?pagename=$uri&$args;
  }

Thanks again for your fast help @Michael Vogel.
In the future I need to check the nginx config more frequently.
@Michael Vogel
⇧