[Bug 240498] net-im/py-matrix-synapse: Cannot start service

bugzilla-noreply at freebsd.org bugzilla-noreply at freebsd.org
Wed Sep 11 12:54:59 UTC 2019


https://bugs.freebsd.org/bugzilla/show_bug.cgi?id=240498

--- Comment #4 from IPTRACE <arkadiusz.majewski at iptrace.pl> ---
# tail -150 /log/app/matrix-synapse/homeserver.log

2019-09-11 14:52:34,818 - root - 226 - WARNING - None - ***** STARTING SERVER
*****
2019-09-11 14:52:34,849 - synapse.util.versionstring - 85 - INFO - None -
Failed to check for git repository: [Errno 2] No such file or directory: 'git':
'git'
2019-09-11 14:52:34,851 - root - 227 - WARNING - None - Server
/usr/local/lib/python3.6/site-packages/synapse/app/homeserver.py version 1.2.1
2019-09-11 14:52:34,851 - root - 228 - INFO - None - Server hostname: my.domain
2019-09-11 14:52:34,852 - twisted - 254 - INFO - None - Redirected
stdout/stderr to logs
2019-09-11 14:52:34,885 - synapse.util.versionstring - 85 - INFO - None -
Failed to check for git repository: [Errno 2] No such file or directory: 'git':
'git'
2019-09-11 14:52:34,887 - synapse.app.homeserver - 359 - INFO - None -
Preparing database: sqlite3...
2019-09-11 14:52:34,893 - synapse.storage.prepare_database - 242 - INFO - None
- Upgrading schema to v55
2019-09-11 14:52:34,894 - synapse.app.homeserver - 377 - INFO - None - Database
prepared in sqlite3.
2019-09-11 14:52:34,895 - synapse.server - 233 - INFO - None - Setting up.
2019-09-11 14:52:34,914 - synapse.storage.event_push_actions - 500 - INFO -
None - Searching for stream ordering 1 month ago
2019-09-11 14:52:34,915 - synapse.storage.event_push_actions - 505 - INFO -
None - Found stream ordering 1 month ago: it's 0
2019-09-11 14:52:34,915 - synapse.storage.event_push_actions - 507 - INFO -
None - Searching for stream ordering 1 day ago
2019-09-11 14:52:34,916 - synapse.storage.event_push_actions - 512 - INFO -
None - Found stream ordering 1 day ago: it's 0
2019-09-11 14:52:34,919 - synapse.server - 237 - INFO - None - Finished setting
up.
2019-09-11 14:52:34,963 - synapse.app.homeserver - 245 - WARNING -  - Starting
daemon.
2019-09-11 14:52:34,966 - synapse.app.homeserver - 106 - INFO -  - Running
2019-09-11 14:52:34,966 - synapse.app.homeserver - 30 - INFO -  - Set file
limit to: 57870
2019-09-11 14:52:34,981 - synapse.federation.federation_server - 814 - INFO - 
- Registering federation query handler for 'profile'
2019-09-11 14:52:34,983 - synapse.push.pusher - 41 - INFO -  - email enable
notifs: False
2019-09-11 14:52:34,988 - synapse.federation.federation_server - 814 - INFO - 
- Registering federation query handler for 'directory'
2019-09-11 14:52:34,990 - synapse.handlers.auth - 84 - INFO -  - Extra
password_providers: []
2019-09-11 14:52:34,992 - synapse.federation.federation_server - 796 - INFO - 
- Registering federation EDU handler for 'm.device_list_update'
2019-09-11 14:52:34,992 - synapse.federation.federation_server - 814 - INFO - 
- Registering federation query handler for 'user_devices'
2019-09-11 14:52:35,030 - synapse.federation.federation_server - 796 - INFO - 
- Registering federation EDU handler for 'm.presence'
2019-09-11 14:52:35,040 - synapse.federation.federation_server - 796 - INFO - 
- Registering federation EDU handler for 'm.typing'
2019-09-11 14:52:35,054 - synapse.handlers.deactivate_account - 149 - INFO -
user_parter_loop-0 - Starting user parter
2019-09-11 14:52:35,058 - synapse.federation.federation_server - 796 - INFO - 
- Registering federation EDU handler for 'm.receipt'
2019-09-11 14:52:35,062 - synapse.federation.federation_server - 814 - INFO - 
- Registering federation query handler for 'client_keys'
2019-09-11 14:52:35,065 - synapse.federation.federation_server - 796 - INFO - 
- Registering federation EDU handler for 'm.direct_to_device'
2019-09-11 14:52:35,106 - synapse.util.versionstring - 85 - INFO -  - Failed to
check for git repository: [Errno 2] No such file or directory: 'git': 'git'
2019-09-11 14:52:35,132 - synapse.util.httpresourcetree - 46 - INFO -  -
Attaching <synapse.rest.ClientRestResource object at 0x805deda90> to path
b'/_matrix/client/api/v1'
2019-09-11 14:52:35,132 - synapse.util.httpresourcetree - 46 - INFO -  -
Attaching <synapse.rest.ClientRestResource object at 0x805deda90> to path
b'/_matrix/client/r0'
2019-09-11 14:52:35,133 - synapse.util.httpresourcetree - 46 - INFO -  -
Attaching <synapse.rest.ClientRestResource object at 0x805deda90> to path
b'/_matrix/client/unstable'
2019-09-11 14:52:35,133 - synapse.util.httpresourcetree - 46 - INFO -  -
Attaching <synapse.rest.ClientRestResource object at 0x805deda90> to path
b'/_matrix/client/v2_alpha'
2019-09-11 14:52:35,133 - synapse.util.httpresourcetree - 46 - INFO -  -
Attaching <synapse.rest.ClientRestResource object at 0x805deda90> to path
b'/_matrix/client/versions'
2019-09-11 14:52:35,134 - synapse.util.httpresourcetree - 46 - INFO -  -
Attaching <synapse.rest.well_known.WellKnownResource object at 0x805f94588> to
path b'/.well-known/matrix/client'
2019-09-11 14:52:35,134 - synapse.util.httpresourcetree - 46 - INFO -  -
Attaching <synapse.rest.admin.AdminRestResource object at 0x805f94748> to path
b'/_synapse/admin'
2019-09-11 14:52:35,134 - synapse.util.httpresourcetree - 46 - INFO -  -
Attaching FilePath('/usr/local/lib/python3.6/site-packages/synapse/static') to
path b'/_matrix/static'
2019-09-11 14:52:35,135 - synapse.util.httpresourcetree - 46 - INFO -  -
Attaching <synapse.rest.media.v1.media_repository.MediaRepositoryResource
object at 0x805e48d30> to path b'/_matrix/media/r0'
2019-09-11 14:52:35,135 - synapse.util.httpresourcetree - 46 - INFO -  -
Attaching <synapse.rest.media.v1.media_repository.MediaRepositoryResource
object at 0x805e48d30> to path b'/_matrix/media/v1'
2019-09-11 14:52:35,135 - synapse.util.httpresourcetree - 46 - INFO -  -
Attaching <synapse.rest.media.v0.content_repository.ContentRepoResource object
at 0x805f94f60> to path b'/_matrix/content'
2019-09-11 14:52:35,136 - synapse.util.httpresourcetree - 46 - INFO -  -
Attaching <synapse.federation.transport.server.TransportLayerServer object at
0x805f6dfd0> to path b'/_matrix/federation'
2019-09-11 14:52:35,136 - synapse.util.httpresourcetree - 46 - INFO -  -
Attaching <synapse.rest.key.v2.KeyApiV2Resource object at 0x805fa3b00> to path
b'/_matrix/key/v2'
2019-09-11 14:52:35,142 - twisted - 254 - ERROR -  - Traceback (most recent
call last):
2019-09-11 14:52:35,142 - twisted - 254 - ERROR -  -   File
"/usr/local/lib/python3.6/site-packages/twisted/internet/tcp.py", line 1361, in
startListening
2019-09-11 14:52:35,143 - twisted - 254 - ERROR -  -     skt.bind(addr)
2019-09-11 14:52:35,143 - twisted - 254 - ERROR -  - PermissionError: [Errno
13] Permission denied
2019-09-11 14:52:35,144 - twisted - 254 - ERROR -  -
2019-09-11 14:52:35,144 - twisted - 254 - ERROR -  - During handling of the
above exception, another exception occurred:
2019-09-11 14:52:35,144 - twisted - 254 - ERROR -  -
2019-09-11 14:52:35,145 - twisted - 254 - ERROR -  - Traceback (most recent
call last):
2019-09-11 14:52:35,145 - twisted - 254 - ERROR -  -   File
"/usr/local/lib/python3.6/site-packages/synapse/app/_base.py", line 259, in
start
2019-09-11 14:52:35,145 - twisted - 254 - ERROR -  -    
hs.start_listening(listeners)
2019-09-11 14:52:35,146 - twisted - 254 - ERROR -  -   File
"/usr/local/lib/python3.6/site-packages/synapse/app/homeserver.py", line 266,
in start_listening
2019-09-11 14:52:35,146 - twisted - 254 - ERROR -  -    
self._listening_services.extend(self._listener_http(config, listener))
2019-09-11 14:52:35,147 - twisted - 254 - ERROR -  -   File
"/usr/local/lib/python3.6/site-packages/synapse/app/homeserver.py", line 152,
in _listener_http
2019-09-11 14:52:35,147 - twisted - 254 - ERROR -  -    
reactor=self.get_reactor(),
2019-09-11 14:52:35,147 - twisted - 254 - ERROR -  -   File
"/usr/local/lib/python3.6/site-packages/synapse/app/_base.py", line 171, in
listen_tcp
2019-09-11 14:52:35,148 - twisted - 254 - ERROR -  -     check_bind_error(e,
address, bind_addresses)
2019-09-11 14:52:35,148 - twisted - 254 - ERROR -  -   File
"/usr/local/lib/python3.6/site-packages/synapse/app/__init__.py", line 49, in
check_bind_error
2019-09-11 14:52:35,149 - twisted - 254 - ERROR -  -     raise e
2019-09-11 14:52:35,149 - twisted - 254 - ERROR -  -   File
"/usr/local/lib/python3.6/site-packages/synapse/app/_base.py", line 169, in
listen_tcp
2019-09-11 14:52:35,149 - twisted - 254 - ERROR -  -    
r.append(reactor.listenTCP(port, factory, backlog, address))
2019-09-11 14:52:35,150 - twisted - 254 - ERROR -  -   File
"/usr/local/lib/python3.6/site-packages/twisted/internet/posixbase.py", line
495, in listenTCP
2019-09-11 14:52:35,150 - twisted - 254 - ERROR -  -     p.startListening()
2019-09-11 14:52:35,150 - twisted - 254 - ERROR -  -   File
"/usr/local/lib/python3.6/site-packages/twisted/internet/tcp.py", line 1363, in
startListening
2019-09-11 14:52:35,151 - twisted - 254 - ERROR -  -     raise
CannotListenError(self.interface, self.port, le)
2019-09-11 14:52:35,151 - twisted - 254 - ERROR -  -
twisted.internet.error.CannotListenError: Couldn't listen on 127.0.0.1:80:
[Errno 13] Permission denied.
2019-09-11 14:52:35,154 - synapse.handlers.deactivate_account - 159 - INFO -
user_parter_loop-0 - User parter finished: stopping
2019-09-11 14:52:35,157 - synapse.handlers.presence - 236 - INFO -
presence.on_shutdown-0 - Performing _on_shutdown. Persisting 0 unpersisted
changes
2019-09-11 14:52:35,160 - synapse.handlers.presence - 247 - INFO -
presence.on_shutdown-0 - Finished _on_shutdown
2019-09-11 14:52:35,241 - twisted - 254 - CRITICAL -  - Unhandled error in
Deferred:
2019-09-11 14:52:35,241 - twisted - 254 - CRITICAL -  -
Traceback (most recent call last):
  File "/usr/local/lib/python3.6/site-packages/twisted/internet/tcp.py", line
1361, in startListening
    skt.bind(addr)
PermissionError: [Errno 13] Permission denied

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "/usr/local/lib/python3.6/site-packages/synapse/app/_base.py", line 259,
in start
    hs.start_listening(listeners)
  File "/usr/local/lib/python3.6/site-packages/synapse/app/homeserver.py", line
266, in start_listening
    self._listening_services.extend(self._listener_http(config, listener))
  File "/usr/local/lib/python3.6/site-packages/synapse/app/homeserver.py", line
152, in _listener_http
    reactor=self.get_reactor(),
  File "/usr/local/lib/python3.6/site-packages/synapse/app/_base.py", line 171,
in listen_tcp
    check_bind_error(e, address, bind_addresses)
  File "/usr/local/lib/python3.6/site-packages/synapse/app/__init__.py", line
49, in check_bind_error
    raise e
  File "/usr/local/lib/python3.6/site-packages/synapse/app/_base.py", line 169,
in listen_tcp
    r.append(reactor.listenTCP(port, factory, backlog, address))
  File "/usr/local/lib/python3.6/site-packages/twisted/internet/posixbase.py",
line 495, in listenTCP
    p.startListening()
  File "/usr/local/lib/python3.6/site-packages/twisted/internet/tcp.py", line
1363, in startListening
    raise CannotListenError(self.interface, self.port, le)
twisted.internet.error.CannotListenError: Couldn't listen on 127.0.0.1:80:
[Errno 13] Permission denied.

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "/usr/local/lib/python3.6/site-packages/twisted/internet/defer.py", line
1418, in _inlineCallbacks
    result = g.send(result)
  File "/usr/local/lib/python3.6/site-packages/synapse/app/homeserver.py", line
435, in start
    _base.start(hs, config.listeners)
  File "/usr/local/lib/python3.6/site-packages/synapse/app/_base.py", line 268,
in start
    sys.exit(1)
SystemExit: 1
2019-09-11 14:52:35,258 - twisted - 254 - INFO -  - Main loop terminated.
2019-09-11 14:52:35,259 - synapse.app.homeserver - 70 - WARNING -  - Stopping
daemon.

-- 
You are receiving this mail because:
You are the assignee for the bug.


More information about the freebsd-ports-bugs mailing list