-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Fri 2024-04-19 18:59:51 CEST. -- Apr 19 18:58:07 volumio volumio-remote-updater[364]: [2024-04-19 18:58:07] [info] asio async_connect error: system:111 (Connection refused) Apr 19 18:58:07 volumio volumio-remote-updater[364]: [2024-04-19 18:58:07] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Apr 19 18:58:07 volumio volumio-remote-updater[364]: [2024-04-19 18:58:07] [error] handle_connect error: Underlying Transport Error Apr 19 18:58:17 volumio volumio-remote-updater[364]: [2024-04-19 18:58:17] [info] asio async_connect error: system:111 (Connection refused) Apr 19 18:58:17 volumio volumio-remote-updater[364]: [2024-04-19 18:58:17] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Apr 19 18:58:17 volumio volumio-remote-updater[364]: [2024-04-19 18:58:17] [error] handle_connect error: Underlying Transport Error Apr 19 18:58:22 volumio sudo[2297]: volumio : TTY=pts/0 ; PWD=/volumio/http ; USER=root ; COMMAND=/bin/systemctl status volumio Apr 19 18:58:22 volumio sudo[2297]: pam_unix(sudo:session): session opened for user root by volumio(uid=0) Apr 19 18:58:22 volumio sudo[2297]: pam_unix(sudo:session): session closed for user root Apr 19 18:58:27 volumio volumio-remote-updater[364]: [2024-04-19 18:58:27] [info] asio async_connect error: system:111 (Connection refused) Apr 19 18:58:27 volumio volumio-remote-updater[364]: [2024-04-19 18:58:27] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Apr 19 18:58:27 volumio volumio-remote-updater[364]: [2024-04-19 18:58:27] [error] handle_connect error: Underlying Transport Error Apr 19 18:58:37 volumio volumio-remote-updater[364]: [2024-04-19 18:58:37] [info] asio async_connect error: system:111 (Connection refused) Apr 19 18:58:37 volumio volumio-remote-updater[364]: [2024-04-19 18:58:37] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Apr 19 18:58:37 volumio volumio-remote-updater[364]: [2024-04-19 18:58:37] [error] handle_connect error: Underlying Transport Error Apr 19 18:58:47 volumio volumio-remote-updater[364]: [2024-04-19 18:58:47] [info] asio async_connect error: system:111 (Connection refused) Apr 19 18:58:47 volumio volumio-remote-updater[364]: [2024-04-19 18:58:47] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Apr 19 18:58:47 volumio volumio-remote-updater[364]: [2024-04-19 18:58:47] [error] handle_connect error: Underlying Transport Error Apr 19 18:58:57 volumio volumio-remote-updater[364]: [2024-04-19 18:58:57] [info] asio async_connect error: system:111 (Connection refused) Apr 19 18:58:57 volumio volumio-remote-updater[364]: [2024-04-19 18:58:57] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Apr 19 18:58:57 volumio volumio-remote-updater[364]: [2024-04-19 18:58:57] [error] handle_connect error: Underlying Transport Error Apr 19 18:59:07 volumio volumio-remote-updater[364]: [2024-04-19 18:59:07] [info] asio async_connect error: system:111 (Connection refused) Apr 19 18:59:07 volumio volumio-remote-updater[364]: [2024-04-19 18:59:07] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Apr 19 18:59:07 volumio volumio-remote-updater[364]: [2024-04-19 18:59:07] [error] handle_connect error: Underlying Transport Error Apr 19 18:59:17 volumio volumio-remote-updater[364]: [2024-04-19 18:59:17] [info] asio async_connect error: system:111 (Connection refused) Apr 19 18:59:17 volumio volumio-remote-updater[364]: [2024-04-19 18:59:17] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Apr 19 18:59:17 volumio volumio-remote-updater[364]: [2024-04-19 18:59:17] [error] handle_connect error: Underlying Transport Error Apr 19 18:59:27 volumio volumio-remote-updater[364]: [2024-04-19 18:59:27] [info] asio async_connect error: system:111 (Connection refused) Apr 19 18:59:27 volumio volumio-remote-updater[364]: [2024-04-19 18:59:27] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Apr 19 18:59:27 volumio volumio-remote-updater[364]: [2024-04-19 18:59:27] [error] handle_connect error: Underlying Transport Error Apr 19 18:59:37 volumio volumio-remote-updater[364]: [2024-04-19 18:59:37] [info] asio async_connect error: system:111 (Connection refused) Apr 19 18:59:37 volumio volumio-remote-updater[364]: [2024-04-19 18:59:37] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Apr 19 18:59:37 volumio volumio-remote-updater[364]: [2024-04-19 18:59:37] [error] handle_connect error: Underlying Transport Error Apr 19 18:59:37 volumio sudo[2387]: volumio : TTY=pts/0 ; PWD=/volumio/http ; USER=root ; COMMAND=/bin/systemctl restart volumio Apr 19 18:59:37 volumio sudo[2387]: pam_unix(sudo:session): session opened for user root by volumio(uid=0) Apr 19 18:59:38 volumio systemd[1]: Started Volumio Backend Module. Apr 19 18:59:38 volumio systemd[1]: Started dynamicswap service. Apr 19 18:59:38 volumio sudo[2387]: pam_unix(sudo:session): session closed for user root Apr 19 18:59:38 volumio systemd[1]: dynamicswap.service: Succeeded. Apr 19 18:59:41 volumio ntpd[546]: 89.58.43.2 local addr 10.0.20.11 -> Apr 19 18:59:42 volumio volumio[2390]: info: ------------------------------------------- Apr 19 18:59:42 volumio volumio[2390]: info: ----- Volumio3 ---- Apr 19 18:59:42 volumio volumio[2390]: info: ------------------------------------------- Apr 19 18:59:42 volumio volumio[2390]: info: ----- System startup ---- Apr 19 18:59:42 volumio volumio[2390]: info: ------------------------------------------- Apr 19 18:59:43 volumio volumio[2390]: info: MYVOLUMIO Environment detected Apr 19 18:59:43 volumio volumio[2390]: info: Plugin folders cleanup Apr 19 18:59:43 volumio volumio[2390]: info: Scanning into folder /volumio/app/plugins/ Apr 19 18:59:43 volumio volumio[2390]: info: Scanning category audio_interface Apr 19 18:59:43 volumio volumio[2390]: info: Scanning category miscellanea Apr 19 18:59:43 volumio volumio[2390]: info: Scanning category music_service Apr 19 18:59:43 volumio volumio[2390]: info: Scanning category plugins.json Apr 19 18:59:43 volumio volumio[2390]: info: Scanning category system_controller Apr 19 18:59:43 volumio volumio[2390]: info: Scanning category user_interface Apr 19 18:59:43 volumio volumio[2390]: info: Scanning into folder /data/plugins/ Apr 19 18:59:43 volumio volumio[2390]: info: Plugin folders cleanup completed Apr 19 18:59:43 volumio volumio[2390]: info: ------------------------------------------- Apr 19 18:59:43 volumio volumio[2390]: info: ----- Core plugins startup ---- Apr 19 18:59:43 volumio volumio[2390]: info: ------------------------------------------- Apr 19 18:59:43 volumio volumio[2390]: info: Loading plugins from folder /volumio/app/plugins/ Apr 19 18:59:43 volumio volumio[2390]: info: Adding plugin upnp to MyMusic Plugins Apr 19 18:59:43 volumio volumio[2390]: info: Adding plugin airplay_emulation to MyMusic Plugins Apr 19 18:59:43 volumio volumio[2390]: info: Adding plugin upnp_browser to MyMusic Plugins Apr 19 18:59:43 volumio volumio[2390]: info: Loading plugins from folder /data/plugins/ Apr 19 18:59:43 volumio volumio[2390]: info: Loading plugin "system"... Apr 19 18:59:44 volumio volumio[2390]: info: Loading plugin "appearance"... Apr 19 18:59:45 volumio volumio[2390]: info: Loading plugin "network"... Apr 19 18:59:45 volumio volumio[2390]: info: Refreshing Cached IP Addresses Apr 19 18:59:46 volumio sudo[2421]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 19 18:59:46 volumio sudo[2421]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 18:59:46 volumio sudo[2421]: pam_unix(sudo:session): session closed for user root Apr 19 18:59:46 volumio volumio[2390]: info: Loading plugin "services"... Apr 19 18:59:46 volumio sudo[2423]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 19 18:59:46 volumio sudo[2423]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 18:59:46 volumio volumio[2390]: info: Loading plugin "alsa_controller"... Apr 19 18:59:46 volumio sudo[2426]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 19 18:59:46 volumio sudo[2423]: pam_unix(sudo:session): session closed for user root Apr 19 18:59:46 volumio sudo[2426]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 18:59:46 volumio sudo[2426]: pam_unix(sudo:session): session closed for user root Apr 19 18:59:46 volumio volumio[2390]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 19 18:59:46 volumio volumio[2390]: info: Loading plugin "wizard"... Apr 19 18:59:46 volumio volumio[2390]: info: Loading plugin "networkfs"... Apr 19 18:59:46 volumio volumio[2390]: info: Cannot mount NAS NAS at system boot, trial number 1 ,retrying in 5 seconds Apr 19 18:59:46 volumio volumio[2390]: info: Starting Udev Watcher for removable devices Apr 19 18:59:46 volumio volumio[2390]: info: Ignoring mount for partition: boot Apr 19 18:59:46 volumio volumio[2390]: info: Ignoring mount for partition: volumio Apr 19 18:59:46 volumio volumio[2390]: info: Ignoring mount for partition: volumio_data Apr 19 18:59:46 volumio volumio[2390]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 19 18:59:46 volumio volumio[2390]: info: Loading plugin "volumio_command_line_client"... Apr 19 18:59:46 volumio volumio[2390]: info: Loading plugin "upnp"... Apr 19 18:59:46 volumio volumio[2390]: info: [1713545986465] Starting Upmpd Daemon Apr 19 18:59:46 volumio volumio[2390]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 19 18:59:46 volumio volumio[2390]: info: Loading plugin "my_music"... Apr 19 18:59:46 volumio volumio[2390]: info: Loading plugin "mpd"... Apr 19 18:59:47 volumio volumio[2390]: info: Loading plugin "upnp_browser"... Apr 19 18:59:47 volumio volumio-remote-updater[364]: [2024-04-19 18:59:47] [connect] Successful connection Apr 19 18:59:47 volumio volumio[2390]: info: Loading plugin "alarm-clock"... Apr 19 18:59:48 volumio volumio[2390]: info: Loading plugin "airplay_emulation"... Apr 19 18:59:48 volumio volumio[2390]: info: Starting Shairport Sync Apr 19 18:59:48 volumio volumio[2390]: info: Loading plugin "last_100"... Apr 19 18:59:48 volumio volumio[2390]: info: Loading plugin "webradio"... Apr 19 18:59:48 volumio volumio[2390]: info: Loading plugin "i2s_dacs"... Apr 19 18:59:48 volumio volumio[2390]: info: I2S DAC not set, start Auto-detection Apr 19 18:59:48 volumio volumio[2390]: info: Loading plugin "volumiodiscovery"... Apr 19 18:59:48 volumio volumio[2390]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 19 18:59:48 volumio node[2390]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 19 18:59:48 volumio volumio[2390]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 19 18:59:48 volumio node[2390]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 19 18:59:48 volumio volumio[2390]: *** WARNING *** For more information see Apr 19 18:59:48 volumio node[2390]: *** WARNING *** For more information see Apr 19 18:59:48 volumio volumio[2390]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 19 18:59:48 volumio node[2390]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 19 18:59:48 volumio volumio[2390]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 19 18:59:48 volumio node[2390]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 19 18:59:48 volumio volumio[2390]: *** WARNING *** For more information see Apr 19 18:59:48 volumio node[2390]: *** WARNING *** For more information see Apr 19 18:59:48 volumio volumio[2390]: info: Applying required configuration parameters for plugin volumiodiscovery Apr 19 18:59:48 volumio volumio[2390]: info: Discovery: Started advertising with name: Volumio Apr 19 18:59:48 volumio volumio[2390]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 19 18:59:48 volumio volumio[2390]: info: Loading plugin "outputs"... Apr 19 18:59:48 volumio volumio[2390]: info: Loading plugin "albumart"... Apr 19 18:59:48 volumio volumio[2390]: info: Plugin example_plugin is not enabled Apr 19 18:59:48 volumio volumio[2390]: info: Loading plugin "inputs"... Apr 19 18:59:48 volumio volumio[2390]: info: Loading plugin "updater_comm"... Apr 19 18:59:49 volumio volumio[2390]: info: Plugin mpdemulation is not enabled Apr 19 18:59:49 volumio volumio[2390]: info: Loading plugin "rest_api"... Apr 19 18:59:49 volumio volumio[2390]: info: Loading plugin "websocket"... Apr 19 18:59:49 volumio volumio[2390]: info: Loading i18n strings for locale de Apr 19 18:59:49 volumio volumio[2390]: Updating browse sources language Apr 19 18:59:49 volumio volumio[2390]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 19 18:59:49 volumio sudo[2446]: volumio : TTY=pts/0 ; PWD=/volumio/http ; USER=root ; COMMAND=/bin/systemctl status volumio Apr 19 18:59:49 volumio sudo[2446]: pam_unix(sudo:session): session opened for user root by volumio(uid=0) Apr 19 18:59:49 volumio sudo[2446]: pam_unix(sudo:session): session closed for user root Apr 19 18:59:49 volumio volumio[2390]: Forking 3 albumart workers Apr 19 18:59:49 volumio volumio[2390]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 18:59:49 volumio volumio[2390]: info: CoreCommandRouter::initPlayerControls Apr 19 18:59:49 volumio volumio[2390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 18:59:49 volumio volumio[2390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 18:59:49 volumio volumio[2390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 18:59:49 volumio volumio[2390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 18:59:49 volumio volumio[2390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 18:59:49 volumio volumio[2390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 18:59:49 volumio volumio[2390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 18:59:49 volumio volumio[2390]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 19 18:59:49 volumio volumio[2390]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 19 18:59:49 volumio volumio[2390]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 19 18:59:49 volumio volumio[2390]: Error: listen EACCES: permission denied 0.0.0.0:443 Apr 19 18:59:49 volumio volumio[2390]: at Server.setupListenHandle [as _listen2] (net.js:1301:21) Apr 19 18:59:49 volumio volumio[2390]: at listenInCluster (net.js:1366:12) Apr 19 18:59:49 volumio volumio[2390]: at Server.listen (net.js:1452:7) Apr 19 18:59:49 volumio volumio[2390]: at Object. (/volumio/http/index.js:352:31) Apr 19 18:59:49 volumio volumio[2390]: at Module._compile (internal/modules/cjs/loader.js:1063:30) Apr 19 18:59:49 volumio volumio[2390]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1092:10) Apr 19 18:59:49 volumio volumio[2390]: at Module.load (internal/modules/cjs/loader.js:928:32) Apr 19 18:59:49 volumio volumio[2390]: at Function.Module._load (internal/modules/cjs/loader.js:769:14) Apr 19 18:59:49 volumio volumio[2390]: at Module.require (internal/modules/cjs/loader.js:952:19) Apr 19 18:59:49 volumio volumio[2390]: at require (internal/modules/cjs/helpers.js:88:18) { Apr 19 18:59:49 volumio volumio[2390]: code: 'EACCES', Apr 19 18:59:49 volumio volumio[2390]: errno: -13, Apr 19 18:59:49 volumio volumio[2390]: syscall: 'listen', Apr 19 18:59:49 volumio volumio[2390]: address: '0.0.0.0', Apr 19 18:59:49 volumio volumio[2390]: port: 443 Apr 19 18:59:49 volumio volumio[2390]: } Apr 19 18:59:49 volumio volumio[2390]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 19 18:59:51 volumio sudo[2478]: volumio : TTY=pts/0 ; PWD=/volumio/http ; USER=root ; COMMAND=/bin/systemctl status volumio Apr 19 18:59:51 volumio sudo[2478]: pam_unix(sudo:session): session opened for user root by volumio(uid=0) Apr 19 18:59:51 volumio volumio[2390]: Starting albumart workers Apr 19 18:59:51 volumio volumio[2390]: Starting albumart workers Apr 19 18:59:51 volumio sudo[2482]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-19 18:58 Apr 19 18:59:51 volumio sudo[2482]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 19 18:59:51 volumio volumio[2390]: Starting albumart workers PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="b51559ff3f3719e35ff52cb9ccf2ff401b5ecb06" VOLUMIO_FE_VERSION="5d5e99f8f803b3ec5fc5e8ca13bb4023600f3eee" VOLUMIO_FE3_VERSION="a6ae210575eae1ff43f06ab71e1cd17576840623" VOLUMIO_BE_VERSION="9f81dc1810002a5ad8861a42d98d57bc06a5d5d3" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 17 Apr 2024 07:54:00 PM CEST" VOLUMIO_VERSION="3.649" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="9c6dee1ade565aed57d77a70a260b988"