search

matrix-org / matrix-appservice-irc

Node.js IRC bridge for Matrix
Apache License 2.0
460 stars 149 forks source link

No communication from HS to AS but AS to HS works fine #1785

Closed bugz8unny69 closed 7 months ago

bugz8unny69 commented 7 months ago

No matter how many times I restart Matrix Synapse 1.95 and/or Matrix-Appservice-Irc 1.0.1. Synapse never makes any attempt to contact AS. Is this perhaps why:

2023-11-12 20:31:13,407 - synapse.appservice.scheduler - 110 - INFO - as_scheduler-0 - Starting appservice scheduler
2023-11-12 20:31:13,413 - synapse.appservice.scheduler - 436 - INFO - as_scheduler-0 - Starting recoverer for AS ID cfb15d45abf88cb8ab35a8fca26f2866c1b520fb132841448b33467218b419f8
2023-11-12 20:31:13,413 - synapse.appservice.scheduler - 480 - INFO - as_scheduler-0 - Scheduling retries on cfb15d45abf88cb8ab35a8fca26f2866c1b520fb132841448b33467218b419f8 in 2.000000s
2023-11-12 20:31:13,413 - synapse.appservice.scheduler - 443 - INFO - as_scheduler-0 - Now 1 active recoverers
2023-11-12 20:31:15,413 - synapse.appservice.scheduler - 492 - INFO - as-recoverer-0 - Starting retries on cfb15d45abf88cb8ab35a8fca26f2866c1b520fb132841448b33467218b419f8
2023-11-12 20:31:15,420 - synapse.appservice.scheduler - 501 - INFO - as-recoverer-0 - Retrying transaction 2834574 for AS ID cfb15d45abf88cb8ab35a8fca26f2866c1b520fb132841448b33467218b419f8
2023-11-12 20:31:15,430 - synapse.appservice.api - 397 - WARNING - as-recoverer-0 - push_bulk to http://localhost:8008 received code=404 msg=Not Found
2023-11-12 20:31:15,430 - synapse.appservice.scheduler - 480 - INFO - as-recoverer-0 - Scheduling retries on cfb15d45abf88cb8ab35a8fca26f2866c1b520fb132841448b33467218b419f8 in 4.000000s
2023-11-12 20:31:19,431 - synapse.appservice.scheduler - 492 - INFO - as-recoverer-1 - Starting retries on cfb15d45abf88cb8ab35a8fca26f2866c1b520fb132841448b33467218b419f8
2023-11-12 20:31:19,433 - synapse.appservice.scheduler - 501 - INFO - as-recoverer-1 - Retrying transaction 2834574 for AS ID cfb15d45abf88cb8ab35a8fca26f2866c1b520fb132841448b33467218b419f8
2023-11-12 20:31:19,436 - synapse.appservice.api - 397 - WARNING - as-recoverer-1 - push_bulk to http://localhost:8008 received code=404 msg=Not Found
2023-11-12 20:31:19,436 - synapse.appservice.scheduler - 480 - INFO - as-recoverer-1 - Scheduling retries on cfb15d45abf88cb8ab35a8fca26f2866c1b520fb132841448b33467218b419f8 in 8.000000s
2023-11-12 20:31:27,437 - synapse.appservice.scheduler - 492 - INFO - as-recoverer-2 - Starting retries on cfb15d45abf88cb8ab35a8fca26f2866c1b520fb132841448b33467218b419f8
2023-11-12 20:31:27,439 - synapse.appservice.scheduler - 501 - INFO - as-recoverer-2 - Retrying transaction 2834574 for AS ID cfb15d45abf88cb8ab35a8fca26f2866c1b520fb132841448b33467218b419f8
2023-11-12 20:31:27,442 - synapse.appservice.api - 397 - WARNING - as-recoverer-2 - push_bulk to http://localhost:8008 received code=404 msg=Not Found
2023-11-12 20:31:27,442 - synapse.appservice.scheduler - 480 - INFO - as-recoverer-2 - Scheduling retries on cfb15d45abf88cb8ab35a8fca26f2866c1b520fb132841448b33467218b419f8 in 16.000000s
2023-11-12 20:31:43,443 - synapse.appservice.scheduler - 492 - INFO - as-recoverer-3 - Starting retries on cfb15d45abf88cb8ab35a8fca26f2866c1b520fb132841448b33467218b419f8
2023-11-12 20:31:43,445 - synapse.appservice.scheduler - 501 - INFO - as-recoverer-3 - Retrying transaction 2834574 for AS ID cfb15d45abf88cb8ab35a8fca26f2866c1b520fb132841448b33467218b419f8
2023-11-12 20:31:43,448 - synapse.appservice.api - 397 - WARNING - as-recoverer-3 - push_bulk to http://localhost:8008 received code=404 msg=Not Found
2023-11-12 20:31:43,449 - synapse.appservice.scheduler - 480 - INFO - as-recoverer-3 - Scheduling retries on cfb15d45abf88cb8ab35a8fca26f2866c1b520fb132841448b33467218b419f8 in 32.000000s
2023-11-12 20:32:15,449 - synapse.appservice.scheduler - 492 - INFO - as-recoverer-4 - Starting retries on cfb15d45abf88cb8ab35a8fca26f2866c1b520fb132841448b33467218b419f8
2023-11-12 20:32:15,451 - synapse.appservice.scheduler - 501 - INFO - as-recoverer-4 - Retrying transaction 2834574 for AS ID cfb15d45abf88cb8ab35a8fca26f2866c1b520fb132841448b33467218b419f8
2023-11-12 20:32:15,454 - synapse.appservice.api - 397 - WARNING - as-recoverer-4 - push_bulk to http://localhost:8008 received code=404 msg=Not Found
2023-11-12 20:32:15,455 - synapse.appservice.scheduler - 480 - INFO - as-recoverer-4 - Scheduling retries on cfb15d45abf88cb8ab35a8fca26f2866c1b520fb132841448b33467218b419f8 in 64.000000s
2023-11-12 20:33:19,457 - synapse.appservice.scheduler - 492 - INFO - as-recoverer-5 - Starting retries on cfb15d45abf88cb8ab35a8fca26f2866c1b520fb132841448b33467218b419f8
2023-11-12 20:33:19,459 - synapse.appservice.scheduler - 501 - INFO - as-recoverer-5 - Retrying transaction 2834574 for AS ID cfb15d45abf88cb8ab35a8fca26f2866c1b520fb132841448b33467218b419f8
2023-11-12 20:33:19,462 - synapse.appservice.api - 397 - WARNING - as-recoverer-5 - push_bulk to http://localhost:8008 received code=404 msg=Not Found
2023-11-12 20:33:19,463 - synapse.appservice.scheduler - 480 - INFO - as-recoverer-5 - Scheduling retries on cfb15d45abf88cb8ab35a8fca26f2866c1b520fb132841448b33467218b419f8 in 128.000000s
2023-11-12 20:35:27,464 - synapse.appservice.scheduler - 492 - INFO - as-recoverer-6 - Starting retries on cfb15d45abf88cb8ab35a8fca26f2866c1b520fb132841448b33467218b419f8
2023-11-12 20:35:27,466 - synapse.appservice.scheduler - 501 - INFO - as-recoverer-6 - Retrying transaction 2834574 for AS ID cfb15d45abf88cb8ab35a8fca26f2866c1b520fb132841448b33467218b419f8
2023-11-12 20:35:27,473 - synapse.appservice.api - 397 - WARNING - as-recoverer-6 - push_bulk to http://localhost:8008 received code=404 msg=Not Found
2023-11-12 20:35:27,473 - synapse.appservice.scheduler - 480 - INFO - as-recoverer-6 - Scheduling retries on cfb15d45abf88cb8ab35a8fca26f2866c1b520fb132841448b33467218b419f8 in 256.000000s
PUT /_matrix/app/v1/transactions/2834602 HTTP/1.1
Content-Length: 432
Content-Type: application/json
User-Agent: Synapse/1.95.1
Accept: application/json
Authorization: Bearer xxxxxxxx
Accept-Encoding: gzip
Host: localhost:8008

{"de.sorunome.msc2409.ephemeral":[],"de.sorunome.msc2409.to_device":[],"events":[{"age":1022728,"content":{"membership":"join"},"event_id":"$5aa7qaAAeNAkDPcn9Cv9dPdEsgfc5rs6kLP_7M60voE","origin_server_ts":1699840625338,"room_id":"!IYdPfWIIxwRfCtsdvp:bugzbunny.net","sender":"@bugzbridge:bugzbunny.net","state_key":"@bugzbridge:bugzbunny.net","type":"m.room.member","unsigned":{"age":1022728},"user_id":"@bugzbridge:bugzbunny.net"}]}HTTP/1.1 404 Not Found
Transfer-Encoding: chunked
Server: Synapse/1.95.1
Date: Mon, 13 Nov 2023 02:14:08 GMT
Content-Type: application/json
Cache-Control: no-cache, no-store, must-revalidate
Access-Control-Allow-Origin: *
Access-Control-Allow-Methods: GET, HEAD, POST, PUT, DELETE, OPTIONS
Access-Control-Allow-Headers: X-Requested-With, Content-Type, Authorization, Date
Access-Control-Expose-Headers: Synapse-Trace-Id, Server

{"errcode":"M_UNRECOGNIZED","error":"Unrecognized request"}

Is this an interoperate problem? I recall my AS working fine with older HS and AS. Just when I decided to upgrade everything, have I run into this problem? And I have no way of understanding how to fix it. Any support on this would be greatly appreciated.

asdofindia commented 7 months ago

@bugz8unny69 – can you tell how this was fixed? Is it the older version issue as in https://github.com/matrix-org/matrix-appservice-irc/issues/1768