admin@pimusic:~ mopidy -vvvv 2>&1 | tee mopidy.log
INFO 2020-11-11 23:06:00,524 [1785:MainThread] mopidy.__main__
Starting Mopidy 3.0.1
DEBUG 2020-11-11 23:06:00,536 [1785:MainThread] mopidy.ext
Loading entry point: file = mopidy.file:Extension
DEBUG 2020-11-11 23:06:00,538 [1785:MainThread] mopidy.ext
Loaded extension: Mopidy-File 3.0.1
DEBUG 2020-11-11 23:06:00,538 [1785:MainThread] mopidy.ext
Loading entry point: http = mopidy.http:Extension
DEBUG 2020-11-11 23:06:00,540 [1785:MainThread] mopidy.ext
Loaded extension: Mopidy-HTTP 3.0.1
DEBUG 2020-11-11 23:06:00,540 [1785:MainThread] mopidy.ext
Loading entry point: m3u = mopidy.m3u:Extension
DEBUG 2020-11-11 23:06:00,541 [1785:MainThread] mopidy.ext
Loaded extension: Mopidy-M3U 3.0.1
DEBUG 2020-11-11 23:06:00,541 [1785:MainThread] mopidy.ext
Loading entry point: softwaremixer = mopidy.softwaremixer:Extension
DEBUG 2020-11-11 23:06:00,541 [1785:MainThread] mopidy.ext
Loaded extension: Mopidy-SoftwareMixer 3.0.1
DEBUG 2020-11-11 23:06:00,542 [1785:MainThread] mopidy.ext
Loading entry point: stream = mopidy.stream:Extension
DEBUG 2020-11-11 23:06:00,542 [1785:MainThread] mopidy.ext
Loaded extension: Mopidy-Stream 3.0.1
DEBUG 2020-11-11 23:06:00,543 [1785:MainThread] mopidy.ext
Loading entry point: scrobbler = mopidy_scrobbler:Extension
DEBUG 2020-11-11 23:06:00,546 [1785:MainThread] mopidy.ext
Loaded extension: Mopidy-Scrobbler 2.0.0
DEBUG 2020-11-11 23:06:00,547 [1785:MainThread] mopidy.ext
Loading entry point: mopify = mopidy_mopify:MopifyExtension
ERROR 2020-11-11 23:06:00,680 [1785:MainThread] mopidy.ext
Failed to load extension mopify: No module named 'mem'
Traceback (most recent call last):
File "/usr/local/lib/python3.7/dist-packages/mopidy/ext.py", line 209, in load_extensions
extension_class = entry_point.resolve()
File "/usr/lib/python3/dist-packages/pkg_resources/__init__.py", line 2417, in resolve
module = __import__(self.module_name, fromlist=['__name__'], level=0)
File "/usr/local/lib/python3.7/dist-packages/mopidy_mopify/__init__.py", line 7, in <module>
import mem
ModuleNotFoundError: No module named 'mem'
DEBUG 2020-11-11 23:06:00,680 [1785:MainThread] mopidy.ext
Loading entry point: mobile = mopidy_mobile:Extension
DEBUG 2020-11-11 23:06:00,682 [1785:MainThread] mopidy.ext
Loaded extension: Mopidy-Mobile 1.9.1
DEBUG 2020-11-11 23:06:00,682 [1785:MainThread] mopidy.ext
Loading entry point: local = mopidy_local:Extension
DEBUG 2020-11-11 23:06:00,709 [1785:MainThread] mopidy.ext
Loaded extension: Mopidy-Local 3.1.1
DEBUG 2020-11-11 23:06:00,710 [1785:MainThread] mopidy.ext
Loading entry point: iris = mopidy_iris:Extension
DEBUG 2020-11-11 23:06:00,711 [1785:MainThread] mopidy.ext
Loaded extension: Mopidy-Iris 3.54.0
DEBUG 2020-11-11 23:06:00,711 [1785:MainThread] mopidy.ext
Loading entry point: alsamixer = mopidy_alsamixer:Extension
DEBUG 2020-11-11 23:06:00,714 [1785:MainThread] mopidy.ext
Loaded extension: Mopidy-ALSAMixer 2.0.0
DEBUG 2020-11-11 23:06:00,723 [1785:MainThread] mopidy.ext
Loading entry point: spotify = mopidy_spotify:Extension
DEBUG 2020-11-11 23:06:00,726 [1785:MainThread] mopidy.ext
Loaded extension: Mopidy-Spotify 4.0.1
DEBUG 2020-11-11 23:06:00,727 [1785:MainThread] mopidy.ext
Loading entry point: mpd = mopidy_mpd:Extension
DEBUG 2020-11-11 23:06:00,729 [1785:MainThread] mopidy.ext
Loaded extension: Mopidy-MPD 3.0.0
DEBUG 2020-11-11 23:06:00,736 [1785:MainThread] mopidy.ext
Discovered extensions: file, http, m3u, softwaremixer, stream, scrobbler, mobile, local, iris, alsamixer, spotify, mpd
DEBUG 2020-11-11 23:06:00,742 [1785:MainThread] mopidy.config.keyring
Fetching passwords from your keyring failed. Any passwords stored in the keyring will not be available. (org.freedesktop.secrets service not running)
INFO 2020-11-11 23:06:00,743 [1785:MainThread] mopidy.config
Loading config from builtin defaults
DEBUG 2020-11-11 23:06:00,747 [1785:MainThread] mopidy.config
Loading config from file:///etc/xdg/mopidy/mopidy.conf failed; it does not exist
INFO 2020-11-11 23:06:00,748 [1785:MainThread] mopidy.config
Loading config from file:///home/admin/.config/mopidy/mopidy.conf
INFO 2020-11-11 23:06:00,750 [1785:MainThread] mopidy.config
Loading config from command line options
DEBUG 2020-11-11 23:06:00,762 [1785:MainThread] mopidy.ext
Validating extension: file
DEBUG 2020-11-11 23:06:00,763 [1785:MainThread] mopidy.ext
Validating extension: http
DEBUG 2020-11-11 23:06:00,765 [1785:MainThread] mopidy.ext
Validating extension: m3u
DEBUG 2020-11-11 23:06:00,766 [1785:MainThread] mopidy.ext
Validating extension: softwaremixer
DEBUG 2020-11-11 23:06:00,767 [1785:MainThread] mopidy.ext
Validating extension: stream
DEBUG 2020-11-11 23:06:00,768 [1785:MainThread] mopidy.ext
Validating extension: scrobbler
DEBUG 2020-11-11 23:06:00,913 [1785:MainThread] mopidy.ext
Validating extension: mobile
DEBUG 2020-11-11 23:06:00,918 [1785:MainThread] mopidy.ext
Validating extension: local
DEBUG 2020-11-11 23:06:00,995 [1785:MainThread] mopidy.ext
Validating extension: iris
DEBUG 2020-11-11 23:06:01,067 [1785:MainThread] mopidy.ext
Validating extension: alsamixer
DEBUG 2020-11-11 23:06:01,137 [1785:MainThread] mopidy.ext
Validating extension: spotify
DEBUG 2020-11-11 23:06:01,162 [1785:MainThread] mopidy.ext
Validating extension: mpd
INFO 2020-11-11 23:06:01,181 [1785:MainThread] mopidy.__main__
Enabled extensions: mobile, stream, http, alsamixer, m3u, file, mpd, iris, local, softwaremixer
INFO 2020-11-11 23:06:01,181 [1785:MainThread] mopidy.__main__
Disabled extensions: scrobbler, spotify
WARNING 2020-11-11 23:06:01,181 [1785:MainThread] mopidy.__main__
Found scrobbler configuration errors. The extension has been automatically disabled:
WARNING 2020-11-11 23:06:01,181 [1785:MainThread] mopidy.__main__
scrobbler/username must be set.
WARNING 2020-11-11 23:06:01,181 [1785:MainThread] mopidy.__main__
scrobbler/password must be set.
WARNING 2020-11-11 23:06:01,182 [1785:MainThread] mopidy.__main__
Found spotify configuration errors. The extension has been automatically disabled:
WARNING 2020-11-11 23:06:01,182 [1785:MainThread] mopidy.__main__
spotify/username must be set.
WARNING 2020-11-11 23:06:01,182 [1785:MainThread] mopidy.__main__
spotify/password must be set.
WARNING 2020-11-11 23:06:01,182 [1785:MainThread] mopidy.__main__
spotify/client_id must be set.
WARNING 2020-11-11 23:06:01,182 [1785:MainThread] mopidy.__main__
spotify/client_secret must be set.
WARNING 2020-11-11 23:06:01,182 [1785:MainThread] mopidy.__main__
Please fix the extension configuration errors or disable the extensions to silence these messages.
DEBUG 2020-11-11 23:06:01,540 [1785:MainThread] mopidy.commands
Available Mopidy mixers: SoftwareMixer, AlsaMixer
INFO 2020-11-11 23:06:01,541 [1785:MainThread] mopidy.commands
Starting Mopidy mixer: SoftwareMixer
DEBUG 2020-11-11 23:06:01,541 [1785:MainThread] pykka
Registered SoftwareMixer (urn:uuid:8cf738a3-b891-4a80-a677-29683ba22072)
DEBUG 2020-11-11 23:06:01,542 [1785:MainThread] pykka
Starting SoftwareMixer (urn:uuid:8cf738a3-b891-4a80-a677-29683ba22072)
DEBUG 2020-11-11 23:06:01,544 [1785:MainThread] mopidy.commands
Mixer volume left unchanged
INFO 2020-11-11 23:06:01,544 [1785:MainThread] mopidy.commands
Starting Mopidy audio
DEBUG 2020-11-11 23:06:01,544 [1785:MainThread] pykka
Registered Audio (urn:uuid:ec617bae-cb02-43fe-9e91-3a5d1f2f02eb)
DEBUG 2020-11-11 23:06:01,545 [1785:MainThread] pykka
Starting Audio (urn:uuid:ec617bae-cb02-43fe-9e91-3a5d1f2f02eb)
INFO 2020-11-11 23:06:01,547 [1785:MainThread] mopidy.commands
Starting Mopidy backends: FileBackend, M3UBackend, StreamBackend, LocalBackend
DEBUG 2020-11-11 23:06:01,549 [1785:MainThread] pykka
Registered FileBackend (urn:uuid:c0820021-7d07-4e09-8729-a2b05aa35fab)
DEBUG 2020-11-11 23:06:01,549 [1785:MainThread] pykka
Starting FileBackend (urn:uuid:c0820021-7d07-4e09-8729-a2b05aa35fab)
TRACE 2020-11-11 23:06:01,557 [1785:MainThread] mopidy.internal.timer
FileBackend took 9ms
DEBUG 2020-11-11 23:06:01,563 [1785:MainThread] pykka
Registered M3UBackend (urn:uuid:8f67bb24-2557-44a7-bd73-7c974ebe8d22)
DEBUG 2020-11-11 23:06:01,564 [1785:MainThread] pykka
Starting M3UBackend (urn:uuid:8f67bb24-2557-44a7-bd73-7c974ebe8d22)
TRACE 2020-11-11 23:06:01,567 [1785:MainThread] mopidy.internal.timer
M3UBackend took 6ms
INFO 2020-11-11 23:06:01,575 [1785:Audio-2] mopidy.audio.actor
Audio output set to "autoaudiosink"
DEBUG 2020-11-11 23:06:01,585 [1785:MainThread] pykka
Registered StreamBackend (urn:uuid:93c04710-2118-461b-b168-40e37d6a626a)
DEBUG 2020-11-11 23:06:01,585 [1785:MainThread] pykka
Starting StreamBackend (urn:uuid:93c04710-2118-461b-b168-40e37d6a626a)
TRACE 2020-11-11 23:06:01,592 [1785:MainThread] mopidy.internal.timer
StreamBackend took 24ms
DEBUG 2020-11-11 23:06:01,595 [1785:MainThread] pykka
Registered LocalBackend (urn:uuid:5df43b60-dfac-4bd2-a51d-86e84d21030b)
DEBUG 2020-11-11 23:06:01,595 [1785:MainThread] pykka
Starting LocalBackend (urn:uuid:5df43b60-dfac-4bd2-a51d-86e84d21030b)
TRACE 2020-11-11 23:06:01,602 [1785:MainThread] mopidy.internal.timer
LocalBackend took 9ms
INFO 2020-11-11 23:06:01,604 [1785:MainThread] mopidy.commands
Starting Mopidy core
DEBUG 2020-11-11 23:06:01,616 [1785:MainThread] pykka
Registered Core (urn:uuid:0f004993-ee9b-450d-922c-fdb681d6ef8a)
DEBUG 2020-11-11 23:06:01,616 [1785:MainThread] pykka
Starting Core (urn:uuid:0f004993-ee9b-450d-922c-fdb681d6ef8a)
INFO 2020-11-11 23:06:01,626 [1785:MainThread] mopidy.commands
Starting Mopidy frontends: HttpFrontend, IrisFrontend, MpdFrontend
DEBUG 2020-11-11 23:06:01,627 [1785:MainThread] mopidy.http.actor
Starting HTTP server
DEBUG 2020-11-11 23:06:01,628 [1785:MainThread] pykka
Registered HttpFrontend (urn:uuid:af90dd7f-ceb8-4244-8cab-de291df20e47)
DEBUG 2020-11-11 23:06:01,628 [1785:MainThread] pykka
Starting HttpFrontend (urn:uuid:af90dd7f-ceb8-4244-8cab-de291df20e47)
INFO 2020-11-11 23:06:01,628 [1785:HttpFrontend-9] mopidy.http.actor
HTTP server running at [::ffff:127.0.0.1]:6680
TRACE 2020-11-11 23:06:01,629 [1785:MainThread] mopidy.internal.timer
HttpFrontend took 2ms
DEBUG 2020-11-11 23:06:01,629 [1785:MainThread] pykka
Registered IrisFrontend (urn:uuid:32161c2e-a64b-46a1-a10f-45210cc6d5a5)
DEBUG 2020-11-11 23:06:01,629 [1785:MainThread] pykka
Starting IrisFrontend (urn:uuid:32161c2e-a64b-46a1-a10f-45210cc6d5a5)
INFO 2020-11-11 23:06:01,630 [1785:IrisFrontend-10] mopidy_iris.core
Starting Iris 3.54.0
TRACE 2020-11-11 23:06:01,631 [1785:MainThread] mopidy.internal.timer
IrisFrontend took 1ms
DEBUG 2020-11-11 23:06:01,631 [1785:HttpServer] asyncio
Using selector: EpollSelector
ERROR 2020-11-11 23:06:01,632 [1785:MainThread] mopidy.commands
Frontend (MpdFrontend) initialization error: MPD server startup failed: [Errno 98] Address already in use
DEBUG 2020-11-11 23:06:01,635 [1785:HttpServer] mopidy.http.actor
Loaded HTTP extension: mopidy
INFO 2020-11-11 23:06:01,636 [1785:MainThread] mopidy.commands
Starting GLib mainloop
DEBUG 2020-11-11 23:06:01,645 [1785:HttpServer] mopidy.http.actor
Loaded HTTP extension: mobile
DEBUG 2020-11-11 23:06:01,651 [1785:HttpServer] mopidy.http.actor
Loaded HTTP extension: local
DEBUG 2020-11-11 23:06:01,659 [1785:HttpServer] mopidy.http.actor
Loaded HTTP extension: iris
DEBUG 2020-11-11 23:06:01,659 [1785:HttpServer] mopidy.http.actor
Default webclient is mopidy
DEBUG 2020-11-11 23:06:01,659 [1785:HttpServer] mopidy.http.actor
HTTP routes from extensions:
'/mopidy': <class 'mopidy.http.handlers.AddSlashHandler'>
'/mopidy/ws/?': <class 'mopidy.http.handlers.WebSocketHandler'>
'/mopidy/rpc': <class 'mopidy.http.handlers.JsonRpcHandler'>
'/mopidy/(.+)': <class 'mopidy.http.handlers.StaticFileHandler'>
'/mopidy/': <class 'mopidy.http.handlers.ClientListHandler'>
'/mobile': <class 'mopidy.http.handlers.AddSlashHandler'>
'/mobile/': <class 'tornado.web.RedirectHandler'>
'/mobile/(.*\\.html)': <class 'mopidy_mobile.web.IndexHandler'>
'/mobile/(.*\\.json)': <class 'mopidy_mobile.web.IndexHandler'>
'/mobile/(.*)': <class 'mopidy_mobile.web.StaticHandler'>
'/local': <class 'mopidy.http.handlers.AddSlashHandler'>
'/local/(index.html)?': <class 'mopidy_local.web.IndexHandler'>
'/local/(.+)': <class 'mopidy_local.web.ImageHandler'>
'/iris': <class 'mopidy.http.handlers.AddSlashHandler'>
'/iris/http/([^/]*)': <class 'mopidy_iris.handlers.HttpHandler'>
'/iris/ws/?': <class 'mopidy_iris.handlers.WebsocketHandler'>
'/iris/assets/(.*)': <class 'tornado.web.StaticFileHandler'>
'/iris/((.*)(?:css|js|json|map))’: <class ‘tornado.web.StaticFileHandler’>
‘/iris/(.*)’: <class ‘mopidy_iris.handlers.ReactRouterHandler’>
‘/’: <class ‘tornado.web.RedirectHandler’>
DEBUG 2020-11-11 23:06:01,675 [1785:HttpFrontend-9] mopidy.zeroconf
Zeroconf service ‘Mopidy HTTP server on pimusic’ (_http._tcp at []:6680): Published
DEBUG 2020-11-11 23:06:01,683 [1785:HttpFrontend-9] mopidy.zeroconf