-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Sun 2024-04-07 23:47:59 UTC. -- Apr 07 23:46:02 volumio-ch ntpd[656]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Apr 07 23:46:17 volumio-ch volumio[3656]: info: Discovery: adding 9b91afe7-4937-4338-9db5-c6b3b5f2ecd9 Apr 07 23:46:17 volumio-ch volumio[3656]: info: Discovery: Found device Volumio-ch Apr 07 23:46:17 volumio-ch volumio[3656]: info: CoreCommandRouter::volumioGetState Apr 07 23:46:17 volumio-ch volumio[3656]: info: CorePlayQueue::getTrack 0 Apr 07 23:46:19 volumio-ch volumio[3656]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 6 Apr 07 23:46:19 volumio-ch volumio[3656]: [yt-cast-receiver] Listening on port 8098 Apr 07 23:46:19 volumio-ch volumio[3656]: info: Completed starting Core Plugins Apr 07 23:46:19 volumio-ch volumio[3656]: info: ------------------------------------------- Apr 07 23:46:19 volumio-ch volumio[3656]: info: ----- MyVolumio plugins startup ---- Apr 07 23:46:19 volumio-ch volumio[3656]: info: ------------------------------------------- Apr 07 23:46:19 volumio-ch volumio[3656]: info: [MyVolumio PluginManager] Fetching plans data.... Apr 07 23:46:19 volumio-ch volumio[3656]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 07 23:46:19 volumio-ch volumio[3656]: ReferenceError: deferred is not defined Apr 07 23:46:19 volumio-ch volumio[3656]: at ClientRequest. (/data/plugins/music_service/youtube2/lib/core/gapi/auth.js:155:13) Apr 07 23:46:19 volumio-ch volumio[3656]: at ClientRequest.emit (events.js:315:20) Apr 07 23:46:19 volumio-ch volumio[3656]: at TLSSocket.socketErrorListener (_http_client.js:469:9) Apr 07 23:46:19 volumio-ch volumio[3656]: at TLSSocket.emit (events.js:315:20) Apr 07 23:46:19 volumio-ch volumio[3656]: at emitErrorNT (internal/streams/destroy.js:106:8) Apr 07 23:46:19 volumio-ch volumio[3656]: at emitErrorCloseNT (internal/streams/destroy.js:74:3) Apr 07 23:46:19 volumio-ch volumio[3656]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Apr 07 23:46:19 volumio-ch volumio[3656]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 07 23:46:21 volumio-ch sudo[3889]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-07 23:45 Apr 07 23:46:21 volumio-ch sudo[3889]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:46:21 volumio-ch sudo[3889]: pam_unix(sudo:session): session closed for user root Apr 07 23:46:30 volumio-ch ntpd[656]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Apr 07 23:46:49 volumio-ch volumio-remote-updater[473]: [2024-04-07 23:46:49] [info] asio async_read_at_least error: system:104 (Connection reset by peer) Apr 07 23:46:49 volumio-ch volumio-remote-updater[473]: [2024-04-07 23:46:49] [error] handle_read_frame error: websocketpp.transport:2 (Underlying Transport Error) Apr 07 23:46:49 volumio-ch volumio-remote-updater[473]: [2024-04-07 23:46:49] [disconnect] Disconnect close local:[1006,Underlying Transport Error] remote:[1006] Apr 07 23:46:49 volumio-ch systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Apr 07 23:46:49 volumio-ch sudo[3704]: pam_unix(sudo:session): session closed for user root Apr 07 23:46:49 volumio-ch systemd[1]: volumio.service: Failed with result 'exit-code'. Apr 07 23:46:49 volumio-ch systemd[1]: Started dynamicswap service. Apr 07 23:46:49 volumio-ch systemd[1]: dynamicswap.service: Succeeded. Apr 07 23:46:50 volumio-ch systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Apr 07 23:46:50 volumio-ch systemd[1]: volumio.service: Scheduled restart job, restart counter is at 12. Apr 07 23:46:50 volumio-ch systemd[1]: Stopped Volumio Backend Module. Apr 07 23:46:50 volumio-ch systemd[1]: Started Volumio Backend Module. Apr 07 23:46:50 volumio-ch systemd[1]: Started dynamicswap service. Apr 07 23:46:50 volumio-ch systemd[1]: dynamicswap.service: Succeeded. Apr 07 23:46:51 volumio-ch volumio[3903]: info: ------------------------------------------- Apr 07 23:46:51 volumio-ch volumio[3903]: info: ----- Volumio3 ---- Apr 07 23:46:51 volumio-ch volumio[3903]: info: ------------------------------------------- Apr 07 23:46:51 volumio-ch volumio[3903]: info: ----- System startup ---- Apr 07 23:46:51 volumio-ch volumio[3903]: info: ------------------------------------------- Apr 07 23:46:52 volumio-ch volumio[3903]: info: MYVOLUMIO Environment detected Apr 07 23:46:52 volumio-ch volumio[3903]: info: Plugin folders cleanup Apr 07 23:46:52 volumio-ch volumio[3903]: info: Scanning into folder /volumio/app/plugins/ Apr 07 23:46:52 volumio-ch volumio[3903]: info: Scanning category audio_interface Apr 07 23:46:52 volumio-ch volumio[3903]: info: Scanning category miscellanea Apr 07 23:46:52 volumio-ch volumio[3903]: info: Scanning category music_service Apr 07 23:46:52 volumio-ch volumio[3903]: info: Scanning category plugins.json Apr 07 23:46:52 volumio-ch volumio[3903]: info: Scanning category system_controller Apr 07 23:46:52 volumio-ch volumio[3903]: info: Scanning category user_interface Apr 07 23:46:52 volumio-ch volumio[3903]: info: Scanning into folder /data/plugins/ Apr 07 23:46:52 volumio-ch volumio[3903]: info: Scanning category music_service Apr 07 23:46:52 volumio-ch volumio[3903]: info: Plugin folders cleanup completed Apr 07 23:46:52 volumio-ch volumio[3903]: info: ------------------------------------------- Apr 07 23:46:52 volumio-ch volumio[3903]: info: ----- Core plugins startup ---- Apr 07 23:46:52 volumio-ch volumio[3903]: info: ------------------------------------------- Apr 07 23:46:52 volumio-ch volumio[3903]: info: Loading plugins from folder /volumio/app/plugins/ Apr 07 23:46:52 volumio-ch volumio[3903]: info: Adding plugin upnp to MyMusic Plugins Apr 07 23:46:52 volumio-ch volumio[3903]: info: Adding plugin airplay_emulation to MyMusic Plugins Apr 07 23:46:52 volumio-ch volumio[3903]: info: Adding plugin upnp_browser to MyMusic Plugins Apr 07 23:46:52 volumio-ch volumio[3903]: info: Loading plugins from folder /data/plugins/ Apr 07 23:46:52 volumio-ch volumio[3903]: info: Loading plugin "system"... Apr 07 23:46:52 volumio-ch volumio[3903]: info: Loading plugin "appearance"... Apr 07 23:46:53 volumio-ch volumio[3903]: info: Loading plugin "network"... Apr 07 23:46:53 volumio-ch volumio[3903]: info: Refreshing Cached IP Addresses Apr 07 23:46:53 volumio-ch volumio[3903]: info: Loading plugin "services"... Apr 07 23:46:53 volumio-ch volumio[3903]: info: Loading plugin "alsa_controller"... Apr 07 23:46:53 volumio-ch volumio[3903]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 07 23:46:54 volumio-ch volumio[3903]: info: Loading plugin "wizard"... Apr 07 23:46:54 volumio-ch volumio[3903]: info: Loading plugin "volumio_command_line_client"... Apr 07 23:46:54 volumio-ch volumio[3903]: info: Loading plugin "upnp"... Apr 07 23:46:54 volumio-ch volumio[3903]: info: [1712533614019] Starting Upmpd Daemon Apr 07 23:46:54 volumio-ch volumio[3903]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 07 23:46:54 volumio-ch volumio[3903]: info: Loading plugin "my_music"... Apr 07 23:46:54 volumio-ch volumio[3903]: info: Loading plugin "mpd"... Apr 07 23:46:54 volumio-ch sudo[3930]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 07 23:46:54 volumio-ch sudo[3928]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 07 23:46:54 volumio-ch sudo[3932]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 07 23:46:54 volumio-ch sudo[3930]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:46:54 volumio-ch sudo[3932]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:46:54 volumio-ch sudo[3928]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:46:54 volumio-ch sudo[3930]: pam_unix(sudo:session): session closed for user root Apr 07 23:46:54 volumio-ch sudo[3928]: pam_unix(sudo:session): session closed for user root Apr 07 23:46:54 volumio-ch volumio[3903]: info: Creating MPD Configuration file Apr 07 23:46:54 volumio-ch volumio[3903]: info: Loading plugin "upnp_browser"... Apr 07 23:46:54 volumio-ch sudo[3941]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 07 23:46:54 volumio-ch sudo[3941]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:46:54 volumio-ch sudo[3941]: pam_unix(sudo:session): session closed for user root Apr 07 23:46:54 volumio-ch sudo[3943]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 07 23:46:54 volumio-ch sudo[3943]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:46:54 volumio-ch systemd[1]: Stopping Music Player Daemon... Apr 07 23:46:54 volumio-ch systemd[1]: mpd.service: Succeeded. Apr 07 23:46:54 volumio-ch systemd[1]: Stopped Music Player Daemon. Apr 07 23:46:54 volumio-ch systemd[1]: Starting Music Player Daemon... Apr 07 23:46:54 volumio-ch volumio[3903]: info: Loading plugin "networkfs"... Apr 07 23:46:54 volumio-ch volumio-remote-updater[473]: [2024-04-07 23:46:54] [connect] Successful connection Apr 07 23:46:55 volumio-ch volumio[3903]: info: Starting Udev Watcher for removable devices Apr 07 23:46:55 volumio-ch sudo[3952]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto 192.168.1.18:/volume1/maMusicSyno /mnt/NAS/Synolouis Apr 07 23:46:55 volumio-ch sudo[3952]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:46:55 volumio-ch sudo[3932]: pam_unix(sudo:session): session closed for user root Apr 07 23:46:55 volumio-ch volumio[3903]: info: Ignoring mount for partition: boot Apr 07 23:46:55 volumio-ch volumio[3903]: info: Ignoring mount for partition: volumio Apr 07 23:46:55 volumio-ch volumio[3903]: info: Ignoring mount for partition: volumio_data Apr 07 23:46:55 volumio-ch volumio[3903]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 07 23:46:55 volumio-ch volumio[3903]: info: Loading plugin "alarm-clock"... Apr 07 23:46:55 volumio-ch volumio[3903]: info: Loading plugin "airplay_emulation"... Apr 07 23:46:55 volumio-ch volumio[3903]: info: Starting Shairport Sync Apr 07 23:46:55 volumio-ch volumio[3903]: info: Loading plugin "last_100"... Apr 07 23:46:55 volumio-ch volumio[3903]: info: Loading plugin "webradio"... Apr 07 23:46:55 volumio-ch volumio[3903]: info: Loading plugin "i2s_dacs"... Apr 07 23:46:55 volumio-ch volumio[3903]: info: Loading plugin "volumiodiscovery"... Apr 07 23:46:55 volumio-ch volumio[3903]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 07 23:46:55 volumio-ch volumio[3903]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 07 23:46:55 volumio-ch node[3903]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 07 23:46:55 volumio-ch volumio[3903]: *** WARNING *** For more information see Apr 07 23:46:55 volumio-ch volumio[3903]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 07 23:46:55 volumio-ch volumio[3903]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 07 23:46:55 volumio-ch volumio[3903]: *** WARNING *** For more information see Apr 07 23:46:55 volumio-ch node[3903]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 07 23:46:55 volumio-ch node[3903]: *** WARNING *** For more information see Apr 07 23:46:55 volumio-ch node[3903]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 07 23:46:55 volumio-ch node[3903]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 07 23:46:55 volumio-ch node[3903]: *** WARNING *** For more information see Apr 07 23:46:55 volumio-ch volumio[3903]: info: Applying required configuration parameters for plugin volumiodiscovery Apr 07 23:46:55 volumio-ch volumio[3903]: info: Discovery: Started advertising with name: Volumio-ch Apr 07 23:46:55 volumio-ch volumio[3903]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 07 23:46:55 volumio-ch volumio[3903]: info: Loading plugin "youtube2"... Apr 07 23:46:56 volumio-ch mpd[3949]: Apr 07 23:46 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 07 23:46:56 volumio-ch mpd[3949]: Apr 07 23:46 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Apr 07 23:46:56 volumio-ch mpd[3949]: Apr 07 23:46 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Apr 07 23:46:56 volumio-ch systemd[1]: Started Music Player Daemon. Apr 07 23:46:56 volumio-ch sudo[3943]: pam_unix(sudo:session): session closed for user root Apr 07 23:46:58 volumio-ch ntpd[656]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Apr 07 23:47:00 volumio-ch volumio[3903]: info: Loading plugin "ytcr"... Apr 07 23:47:01 volumio-ch volumio[3903]: info: Loading plugin "outputs"... Apr 07 23:47:01 volumio-ch volumio[3903]: info: Loading plugin "albumart"... Apr 07 23:47:01 volumio-ch volumio[3903]: info: Plugin example_plugin is not enabled Apr 07 23:47:01 volumio-ch volumio[3903]: info: Loading plugin "inputs"... Apr 07 23:47:01 volumio-ch volumio[3903]: info: Loading plugin "updater_comm"... Apr 07 23:47:01 volumio-ch volumio[3903]: info: Plugin mpdemulation is not enabled Apr 07 23:47:01 volumio-ch volumio[3903]: info: Loading plugin "rest_api"... Apr 07 23:47:01 volumio-ch volumio[3903]: info: Loading plugin "websocket"... Apr 07 23:47:01 volumio-ch volumio[3903]: info: Loading plugin "radio_paradise"... Apr 07 23:47:01 volumio-ch volumio[3903]: Forking 3 albumart workers Apr 07 23:47:01 volumio-ch volumio[3903]: info: Applying required configuration parameters for plugin radio_paradise Apr 07 23:47:01 volumio-ch volumio[3903]: info: [1712533621879] [RadioParadise] API delay: 5 Apr 07 23:47:01 volumio-ch volumio[3903]: info: Loading i18n strings for locale fr Apr 07 23:47:01 volumio-ch volumio[3903]: Updating browse sources language Apr 07 23:47:01 volumio-ch volumio[3903]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 07 23:47:02 volumio-ch volumio[3903]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 07 23:47:02 volumio-ch volumio[3903]: info: CoreCommandRouter::initPlayerControls Apr 07 23:47:02 volumio-ch volumio[3903]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 23:47:02 volumio-ch volumio[3903]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 23:47:02 volumio-ch volumio[3903]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 23:47:02 volumio-ch volumio[3903]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 23:47:02 volumio-ch volumio[3903]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 23:47:02 volumio-ch volumio[3903]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 23:47:02 volumio-ch volumio[3903]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 23:47:02 volumio-ch volumio[3903]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 23:47:02 volumio-ch volumio[3903]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 07 23:47:02 volumio-ch volumio[3903]: Express server listening on port 3000 Apr 07 23:47:02 volumio-ch volumio[3903]: [Metrics] WebUI: 10s 761.09ms Apr 07 23:47:02 volumio-ch volumio[3903]: info: CoreStateMachine::resetVolumioState Apr 07 23:47:02 volumio-ch volumio[3903]: info: CoreStateMachine::getcurrentVolume Apr 07 23:47:02 volumio-ch volumio[3903]: info: CoreCommandRouter::volumioRetrievevolume Apr 07 23:47:02 volumio-ch volumio[3903]: info: MPD Permissions set Apr 07 23:47:02 volumio-ch volumio[3903]: verbose: New Socket.io Connection to 192.168.211.1 from 192.168.211.145 UA: Mozilla/5.0 (X11; Ubuntu; Linux x86_64) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/17.0 Safari/605.1.15 Total Clients: 1 Apr 07 23:47:02 volumio-ch volumio[3903]: verbose: New Socket.io Connection to 192.168.211.1 from 192.168.211.145 UA: Mozilla/5.0 (X11; Ubuntu; Linux x86_64) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/17.0 Safari/605.1.15 Total Clients: 2 Apr 07 23:47:02 volumio-ch volumio[3903]: info: MPD running with PID3949 Apr 07 23:47:02 volumio-ch volumio[3903]: ,establishing connection Apr 07 23:47:02 volumio-ch volumio[3903]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 23:47:02 volumio-ch volumio[3903]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 23:47:02 volumio-ch volumio[3903]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 23:47:02 volumio-ch volumio[3903]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 23:47:02 volumio-ch volumio[3903]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 23:47:02 volumio-ch volumio[3903]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 23:47:02 volumio-ch volumio[3903]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 23:47:02 volumio-ch volumio[3903]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 23:47:02 volumio-ch volumio[3903]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 07 23:47:02 volumio-ch volumio[3903]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 23:47:02 volumio-ch volumio[3903]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 07 23:47:02 volumio-ch volumio[3903]: info: Reloading queue from file Apr 07 23:47:02 volumio-ch volumio[3903]: error: updateQueue error: null Apr 07 23:47:02 volumio-ch volumio[3903]: info: VolumeController:: Volume=49 Mute =false Apr 07 23:47:02 volumio-ch volumio[3903]: info: CoreStateMachine::pushState Apr 07 23:47:02 volumio-ch volumio[3903]: info: CorePlayQueue::getTrack 0 Apr 07 23:47:02 volumio-ch volumio[3903]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 07 23:47:02 volumio-ch volumio[3903]: info: CoreCommandRouter::volumioPushState Apr 07 23:47:02 volumio-ch volumio[3903]: info: CoreStateMachine::updateTrackBlock Apr 07 23:47:02 volumio-ch volumio[3903]: info: CorePlayQueue::getTrackBlock Apr 07 23:47:02 volumio-ch volumio[3903]: info: CoreCommandRouter::volumioRetrievevolume Apr 07 23:47:02 volumio-ch volumio[3903]: info: CoreStateMachine::setRepeat null single undefined Apr 07 23:47:02 volumio-ch volumio[3903]: info: CoreStateMachine::pushState Apr 07 23:47:02 volumio-ch volumio[3903]: info: CorePlayQueue::getTrack 0 Apr 07 23:47:02 volumio-ch volumio[3903]: info: CoreCommandRouter::volumioPushState Apr 07 23:47:02 volumio-ch volumio[3903]: info: CoreStateMachine::setRandom null Apr 07 23:47:02 volumio-ch volumio[3903]: info: CoreStateMachine::pushState Apr 07 23:47:02 volumio-ch volumio[3903]: info: CorePlayQueue::getTrack 0 Apr 07 23:47:02 volumio-ch volumio[3903]: info: CoreCommandRouter::volumioPushState Apr 07 23:47:02 volumio-ch volumio[3903]: info: Setting Device type: Raspberry PI Apr 07 23:47:02 volumio-ch volumio[3903]: Starting albumart workers Apr 07 23:47:02 volumio-ch volumio[3903]: error: updateQueue error: null Apr 07 23:47:02 volumio-ch volumio[3903]: Starting albumart workers Apr 07 23:47:02 volumio-ch volumio[3903]: Starting albumart workers Apr 07 23:47:02 volumio-ch volumio[3903]: info: VolumeController:: Volume=49 Mute =false Apr 07 23:47:03 volumio-ch volumio[3903]: info: CoreStateMachine::pushState Apr 07 23:47:03 volumio-ch volumio[3903]: info: CorePlayQueue::getTrack 0 Apr 07 23:47:03 volumio-ch volumio[3903]: info: CoreCommandRouter::volumioPushState Apr 07 23:47:04 volumio-ch sudo[4034]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 07 23:47:04 volumio-ch sudo[4032]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 07 23:47:04 volumio-ch sudo[4030]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 07 23:47:04 volumio-ch sudo[4032]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:47:04 volumio-ch sudo[4030]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:47:04 volumio-ch sudo[4034]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:47:04 volumio-ch sudo[4032]: pam_unix(sudo:session): session closed for user root Apr 07 23:47:04 volumio-ch sudo[4030]: pam_unix(sudo:session): session closed for user root Apr 07 23:47:04 volumio-ch sudo[4034]: pam_unix(sudo:session): session closed for user root Apr 07 23:47:04 volumio-ch volumio[3903]: info: Upmpdcli Daemon Started Apr 07 23:47:04 volumio-ch volumio[3903]: verbose: New Socket.io Connection to 192.168.211.1 from 192.168.211.145 UA: Mozilla/5.0 (X11; Ubuntu; Linux x86_64) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/17.0 Safari/605.1.15 Total Clients: 3 Apr 07 23:47:04 volumio-ch volumio[3903]: info: CoreCommandRouter::volumioGetState Apr 07 23:47:04 volumio-ch volumio[3903]: info: CorePlayQueue::getTrack 0 Apr 07 23:47:04 volumio-ch volumio[3903]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 07 23:47:04 volumio-ch volumio[3903]: info: Listing playlists Apr 07 23:47:07 volumio-ch volumio-remote-updater[473]: [2024-04-07 23:47:07] [connect] Successful connection Apr 07 23:47:07 volumio-ch volumio-remote-updater[473]: [2024-04-07 23:47:07] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1712533627 101 Apr 07 23:47:07 volumio-ch volumio[3903]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 4 Apr 07 23:47:07 volumio-ch volumio[3903]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNetworkSettings Apr 07 23:47:07 volumio-ch volumio[3903]: info: Saving new wireless network Apr 07 23:47:07 volumio-ch sudo[4039]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/wpa_supplicant/wpa_supplicant.conf Apr 07 23:47:07 volumio-ch sudo[4039]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:47:07 volumio-ch sudo[4039]: pam_unix(sudo:session): session closed for user root Apr 07 23:47:07 volumio-ch volumio[3903]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Apr 07 23:47:07 volumio-ch volumio[3903]: info: Discovery: Restarting Advertising due to device name change Apr 07 23:47:07 volumio-ch sudo[4042]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Apr 07 23:47:07 volumio-ch sudo[4042]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:47:07 volumio-ch dhcpcd[3340]: received SIGTERM, stopping Apr 07 23:47:07 volumio-ch dhcpcd[3340]: wlan0: removing interface Apr 07 23:47:07 volumio-ch systemd[1]: Stopping Wireless Services... Apr 07 23:47:07 volumio-ch avahi-daemon[476]: Withdrawing address record for 192.168.1.14 on wlan0. Apr 07 23:47:07 volumio-ch dhcpcd[3340]: wlan0: deleting route to 192.168.1.0/24 Apr 07 23:47:07 volumio-ch dhcpcd[3340]: wlan0: deleting default route via 192.168.1.1 Apr 07 23:47:07 volumio-ch dnsmasq[856]: reading /etc/resolv.conf Apr 07 23:47:07 volumio-ch dnsmasq[856]: using nameserver 208.67.222.222#53 Apr 07 23:47:07 volumio-ch dnsmasq[856]: using nameserver 208.67.220.220#53 Apr 07 23:47:07 volumio-ch dhcpcd[3340]: eth0: removing interface Apr 07 23:47:07 volumio-ch dhcpcd[3340]: dhcpcd exited Apr 07 23:47:07 volumio-ch systemd[1]: wireless.service: Succeeded. Apr 07 23:47:07 volumio-ch systemd[1]: Stopped Wireless Services. Apr 07 23:47:07 volumio-ch systemd[1]: Starting Wireless Services... Apr 07 23:47:07 volumio-ch volumio[3903]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Apr 07 23:47:08 volumio-ch wireless.js[4059]: Cleaning previous... Apr 07 23:47:08 volumio-ch systemd[1]: Stopping Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Apr 07 23:47:08 volumio-ch volumio[3903]: info: Discovery: adding 9b91afe7-4937-4338-9db5-c6b3b5f2ecd9 Apr 07 23:47:08 volumio-ch volumio[3903]: info: Discovery: Found device Volumio-ch Apr 07 23:47:08 volumio-ch volumio[3903]: info: CoreCommandRouter::volumioGetState Apr 07 23:47:08 volumio-ch volumio[3903]: info: CorePlayQueue::getTrack 0 Apr 07 23:47:08 volumio-ch volumio[3903]: info: Discovery: A device disappeared from network Apr 07 23:47:08 volumio-ch volumio[3903]: info: Discovery: Device volumio-ch disappeared from network Apr 07 23:47:08 volumio-ch sudo[3952]: pam_unix(sudo:session): session closed for user root Apr 07 23:47:08 volumio-ch volumio[3903]: info: Cannot mount NAS Synolouis at system boot, trial number 1 ,retrying in 5 seconds Apr 07 23:47:08 volumio-ch volumio[3903]: info: Completed loading Core Plugins Apr 07 23:47:08 volumio-ch volumio[3903]: info: Preparing to generate the ALSA configuration file Apr 07 23:47:08 volumio-ch volumio[3903]: info: Asound.conf file unchanged, so no further update is needed Apr 07 23:47:08 volumio-ch volumio[3903]: info: Output device has changed, restarting MPD Apr 07 23:47:08 volumio-ch volumio[3903]: info: Output device has changed, restarting Shairport Sync Apr 07 23:47:08 volumio-ch volumio[3903]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 23:47:08 volumio-ch volumio[3903]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 07 23:47:08 volumio-ch volumio[3903]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 07 23:47:08 volumio-ch volumio[3903]: info: ___________ START PLUGINS ___________ Apr 07 23:47:08 volumio-ch volumio[3903]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 07 23:47:08 volumio-ch volumio[3903]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 07 23:47:08 volumio-ch volumio[3903]: info: [1712533628679] CoreMusicLibrary::Adding element Media Servers Apr 07 23:47:08 volumio-ch volumio[3903]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 07 23:47:09 volumio-ch ntpd[656]: Deleting interface #8 wlan0, 192.168.1.14#123, interface stats: received=0, sent=0, dropped=0, active_time=213 secs Apr 07 23:47:09 volumio-ch sudo[4073]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 07 23:47:09 volumio-ch sudo[4075]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 07 23:47:09 volumio-ch sudo[4075]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:47:09 volumio-ch sudo[4073]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:47:09 volumio-ch sudo[4073]: pam_unix(sudo:session): session closed for user root Apr 07 23:47:09 volumio-ch volumio[3903]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 23:47:09 volumio-ch volumio[3903]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 07 23:47:09 volumio-ch systemd[1]: Stopping Music Player Daemon... Apr 07 23:47:09 volumio-ch systemd[1]: mpd.service: Succeeded. Apr 07 23:47:09 volumio-ch systemd[1]: Stopped Music Player Daemon. Apr 07 23:47:09 volumio-ch systemd[1]: Starting Music Player Daemon... Apr 07 23:47:09 volumio-ch volumio[3903]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 07 23:47:09 volumio-ch volumio[3903]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 23:47:09 volumio-ch volumio[3903]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 07 23:47:09 volumio-ch volumio[3903]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 07 23:47:09 volumio-ch volumio[3903]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 07 23:47:09 volumio-ch volumio[3903]: info: [1712533629455] CoreMusicLibrary::Adding element Last_100 Apr 07 23:47:09 volumio-ch volumio[3903]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 07 23:47:09 volumio-ch volumio[3903]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 07 23:47:09 volumio-ch volumio[3903]: info: [1712533629460] CoreMusicLibrary::Adding element Webradio Apr 07 23:47:09 volumio-ch volumio[3903]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 07 23:47:09 volumio-ch volumio[3903]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 07 23:47:09 volumio-ch volumio[3903]: info: [youtube2-auth] Starting auth flow... Apr 07 23:47:09 volumio-ch volumio[3903]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 07 23:47:09 volumio-ch volumio[3903]: info: [1712533629580] CoreMusicLibrary::Adding element YouTube2 Apr 07 23:47:09 volumio-ch volumio[3903]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 07 23:47:09 volumio-ch volumio[3903]: Cannot find translation for source YouTube2 Apr 07 23:47:09 volumio-ch volumio[3903]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 07 23:47:09 volumio-ch volumio[3903]: info: [1712533629599] CoreMusicLibrary::Adding element Radio Paradise Apr 07 23:47:09 volumio-ch volumio[3903]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 07 23:47:09 volumio-ch volumio[3903]: Cannot find translation for source YouTube2 Apr 07 23:47:09 volumio-ch volumio[3903]: Cannot find translation for source Radio Paradise Apr 07 23:47:09 volumio-ch volumio[3903]: info: Volumio Calling Home Apr 07 23:47:09 volumio-ch systemd[1]: hostapd.service: Succeeded. Apr 07 23:47:09 volumio-ch systemd[1]: Stopped Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Apr 07 23:47:09 volumio-ch sudo[4095]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Apr 07 23:47:09 volumio-ch sudo[4095]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:47:09 volumio-ch avahi-daemon[476]: Withdrawing address record for 192.168.211.1 on wlan0. Apr 07 23:47:09 volumio-ch avahi-daemon[476]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Apr 07 23:47:09 volumio-ch volumio[3903]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 07 23:47:09 volumio-ch sudo[4095]: pam_unix(sudo:session): session closed for user root Apr 07 23:47:09 volumio-ch volumio[3903]: ReferenceError: deferred is not defined Apr 07 23:47:09 volumio-ch volumio[3903]: at ClientRequest. (/data/plugins/music_service/youtube2/lib/core/gapi/auth.js:155:13) Apr 07 23:47:09 volumio-ch volumio[3903]: at ClientRequest.emit (events.js:315:20) Apr 07 23:47:09 volumio-ch volumio[3903]: at TLSSocket.socketErrorListener (_http_client.js:469:9) Apr 07 23:47:09 volumio-ch volumio[3903]: at TLSSocket.emit (events.js:315:20) Apr 07 23:47:09 volumio-ch volumio[3903]: at emitErrorNT (internal/streams/destroy.js:106:8) Apr 07 23:47:09 volumio-ch volumio[3903]: at emitErrorCloseNT (internal/streams/destroy.js:74:3) Apr 07 23:47:09 volumio-ch volumio[3903]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Apr 07 23:47:09 volumio-ch volumio[3903]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 07 23:47:09 volumio-ch avahi-daemon[476]: Interface wlan0.IPv4 no longer relevant for mDNS. Apr 07 23:47:09 volumio-ch sudo[4097]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Apr 07 23:47:09 volumio-ch sudo[4097]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:47:10 volumio-ch sudo[4097]: pam_unix(sudo:session): session closed for user root Apr 07 23:47:10 volumio-ch sudo[4075]: pam_unix(sudo:session): session closed for user root Apr 07 23:47:10 volumio-ch wireless.js[4059]: Stopped aP Apr 07 23:47:10 volumio-ch mpd[4089]: Apr 07 23:47 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 07 23:47:10 volumio-ch mpd[4089]: Apr 07 23:47 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Apr 07 23:47:10 volumio-ch mpd[4089]: Apr 07 23:47 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Apr 07 23:47:11 volumio-ch sudo[4112]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Apr 07 23:47:11 volumio-ch ntpd[656]: Deleting interface #7 wlan0, 192.168.211.1#123, interface stats: received=0, sent=0, dropped=0, active_time=222 secs Apr 07 23:47:11 volumio-ch sudo[4112]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:47:11 volumio-ch systemd[1]: Started Music Player Daemon. Apr 07 23:47:11 volumio-ch sudo[4114]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-07 23:46 Apr 07 23:47:11 volumio-ch sudo[4114]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:47:11 volumio-ch sudo[4112]: pam_unix(sudo:session): session closed for user root Apr 07 23:47:11 volumio-ch kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Apr 07 23:47:12 volumio-ch sudo[4120]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Apr 07 23:47:12 volumio-ch sudo[4120]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:47:12 volumio-ch sudo[4120]: pam_unix(sudo:session): session closed for user root Apr 07 23:47:12 volumio-ch sudo[4114]: pam_unix(sudo:session): session closed for user root Apr 07 23:47:12 volumio-ch sudo[4127]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Apr 07 23:47:12 volumio-ch sudo[4127]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:47:12 volumio-ch sudo[4127]: pam_unix(sudo:session): session closed for user root Apr 07 23:47:12 volumio-ch sudo[4131]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Apr 07 23:47:12 volumio-ch sudo[4131]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:47:12 volumio-ch volumio-remote-updater[473]: [2024-04-07 23:47:12] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Apr 07 23:47:12 volumio-ch volumio-remote-updater[473]: [2024-04-07 23:47:12] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Apr 07 23:47:12 volumio-ch systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Apr 07 23:47:12 volumio-ch sudo[4042]: pam_unix(sudo:session): session closed for user root Apr 07 23:47:12 volumio-ch systemd[1]: volumio.service: Failed with result 'exit-code'. Apr 07 23:47:12 volumio-ch systemd[1]: Started dynamicswap service. Apr 07 23:47:12 volumio-ch systemd[1]: dynamicswap.service: Succeeded. Apr 07 23:47:12 volumio-ch systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Apr 07 23:47:12 volumio-ch systemd[1]: volumio.service: Scheduled restart job, restart counter is at 13. Apr 07 23:47:12 volumio-ch systemd[1]: Stopped Volumio Backend Module. Apr 07 23:47:12 volumio-ch systemd[1]: Started dynamicswap service. Apr 07 23:47:12 volumio-ch systemd[1]: dynamicswap.service: Succeeded. Apr 07 23:47:12 volumio-ch sudo[4131]: pam_unix(sudo:session): session closed for user root Apr 07 23:47:12 volumio-ch wireless.js[4059]: Start wireless flow Apr 07 23:47:12 volumio-ch wireless.js[4059]: Stopped hotspot (if there).. Apr 07 23:47:12 volumio-ch sudo[4151]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Apr 07 23:47:12 volumio-ch sudo[4151]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:47:12 volumio-ch sudo[4151]: pam_unix(sudo:session): session closed for user root Apr 07 23:47:12 volumio-ch sudo[4153]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Apr 07 23:47:12 volumio-ch sudo[4153]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:47:12 volumio-ch ntpd[656]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Apr 07 23:47:12 volumio-ch ntpd[656]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Apr 07 23:47:12 volumio-ch ntpd[656]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Apr 07 23:47:12 volumio-ch ntpd[656]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Apr 07 23:47:12 volumio-ch ntpd[656]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Apr 07 23:47:12 volumio-ch ntpd[656]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Apr 07 23:47:12 volumio-ch ntpd[656]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Apr 07 23:47:12 volumio-ch ntpd[656]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Apr 07 23:47:12 volumio-ch ntpd[656]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Apr 07 23:47:13 volumio-ch sudo[4153]: pam_unix(sudo:session): session closed for user root Apr 07 23:47:13 volumio-ch wireless.js[4059]: DHCP IP Apr 07 23:47:13 volumio-ch wireless.js[4059]: Start ap Apr 07 23:47:13 volumio-ch wpa_supplicant[4155]: Successfully initialized wpa_supplicant Apr 07 23:47:14 volumio-ch wireless.js[4059]: trying... Apr 07 23:47:14 volumio-ch sudo[4156]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Apr 07 23:47:14 volumio-ch sudo[4156]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:47:14 volumio-ch kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Apr 07 23:47:14 volumio-ch sudo[4158]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 07 23:47:14 volumio-ch sudo[4158]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:47:14 volumio-ch dhcpcd[4159]: dev: loaded udev Apr 07 23:47:14 volumio-ch sudo[4158]: pam_unix(sudo:session): session closed for user root Apr 07 23:47:14 volumio-ch dhcpcd-run-hooks[4178]: wlan0: starting wpa_supplicant Apr 07 23:47:15 volumio-ch dhcpcd-run-hooks[4183]: wlan0: failed to start wpa_supplicant Apr 07 23:47:15 volumio-ch dhcpcd-run-hooks[4184]: wlan0: Successfully initialized wpa_supplicant nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Ma Apr 07 23:47:15 volumio-ch dhcpcd[4159]: wlan0: connected to Access Point `' Apr 07 23:47:15 volumio-ch dhcpcd[4159]: no interfaces have a carrier Apr 07 23:47:15 volumio-ch dhcpcd[4159]: forked to background, child pid 4195 Apr 07 23:47:15 volumio-ch dhcpcd[4195]: eth0: waiting for carrier Apr 07 23:47:15 volumio-ch dhcpcd[4195]: wlan0: waiting for carrier Apr 07 23:47:15 volumio-ch sudo[4156]: pam_unix(sudo:session): session closed for user root Apr 07 23:47:15 volumio-ch wireless.js[4059]: trying... Apr 07 23:47:15 volumio-ch sudo[4197]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 07 23:47:15 volumio-ch sudo[4197]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:47:15 volumio-ch sudo[4197]: pam_unix(sudo:session): session closed for user root Apr 07 23:47:15 volumio-ch wpa_supplicant[4182]: wlan0: Trying to associate with SSID 'SFR_E881' Apr 07 23:47:16 volumio-ch wireless.js[4059]: trying... Apr 07 23:47:17 volumio-ch dhcpcd[4195]: wlan0: carrier acquired Apr 07 23:47:17 volumio-ch wpa_supplicant[4182]: wlan0: Associated with b4:9d:fd:0a:e8:83 Apr 07 23:47:17 volumio-ch dhcpcd[4195]: wlan0: connected to Access Point `SFR_E881' Apr 07 23:47:17 volumio-ch wpa_supplicant[4182]: wlan0: CTRL-EVENT-CONNECTED - Connection to b4:9d:fd:0a:e8:83 completed [id=0 id_str=] Apr 07 23:47:17 volumio-ch wpa_supplicant[4182]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Apr 07 23:47:17 volumio-ch volumio-remote-updater[473]: [2024-04-07 23:47:17] [info] asio async_connect error: system:111 (Connection refused) Apr 07 23:47:17 volumio-ch volumio-remote-updater[473]: [2024-04-07 23:47:17] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Apr 07 23:47:17 volumio-ch volumio-remote-updater[473]: [2024-04-07 23:47:17] [error] handle_connect error: Underlying Transport Error Apr 07 23:47:17 volumio-ch sudo[4200]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 07 23:47:17 volumio-ch sudo[4200]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:47:17 volumio-ch dhcpcd[4195]: DUID 00:01:00:01:29:d8:62:b6:b8:27:eb:5a:cc:50 Apr 07 23:47:17 volumio-ch dhcpcd[4195]: wlan0: IAID eb:5a:cc:50 Apr 07 23:47:17 volumio-ch dhcpcd[4195]: wlan0: adding address fe80::ba27:ebff:fe5a:cc50 Apr 07 23:47:17 volumio-ch dhcpcd[4195]: ipv6_addaddr1: Permission denied Apr 07 23:47:17 volumio-ch dhcpcd[4195]: wlan0: probing address 192.168.1.14/24 Apr 07 23:47:17 volumio-ch sudo[4200]: pam_unix(sudo:session): session closed for user root Apr 07 23:47:17 volumio-ch wireless.js[4059]: trying... Apr 07 23:47:17 volumio-ch wpa_supplicant[4182]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=FR Apr 07 23:47:17 volumio-ch sudo[4206]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 07 23:47:17 volumio-ch sudo[4206]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:47:17 volumio-ch sudo[4206]: pam_unix(sudo:session): session closed for user root Apr 07 23:47:17 volumio-ch dhcpcd[4195]: wlan0: carrier lost Apr 07 23:47:17 volumio-ch dhcpcd[4195]: wlan0: carrier acquired Apr 07 23:47:17 volumio-ch dhcpcd[4195]: wlan0: IAID eb:5a:cc:50 Apr 07 23:47:17 volumio-ch dhcpcd[4195]: wlan0: probing address 192.168.1.14/24 Apr 07 23:47:18 volumio-ch dhcpcd[4195]: wlan0: soliciting an IPv6 router Apr 07 23:47:18 volumio-ch wireless.js[4059]: trying... Apr 07 23:47:19 volumio-ch sudo[4230]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 07 23:47:19 volumio-ch sudo[4230]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:47:19 volumio-ch sudo[4230]: pam_unix(sudo:session): session closed for user root Apr 07 23:47:19 volumio-ch wireless.js[4059]: trying... Apr 07 23:47:19 volumio-ch sudo[4233]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 07 23:47:19 volumio-ch sudo[4233]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:47:19 volumio-ch sudo[4233]: pam_unix(sudo:session): session closed for user root Apr 07 23:47:20 volumio-ch wireless.js[4059]: trying... Apr 07 23:47:22 volumio-ch sudo[4236]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 07 23:47:22 volumio-ch sudo[4236]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:47:22 volumio-ch sudo[4236]: pam_unix(sudo:session): session closed for user root Apr 07 23:47:22 volumio-ch wireless.js[4059]: trying... Apr 07 23:47:22 volumio-ch sudo[4239]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 07 23:47:22 volumio-ch sudo[4239]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:47:22 volumio-ch sudo[4239]: pam_unix(sudo:session): session closed for user root Apr 07 23:47:22 volumio-ch dhcpcd[4195]: wlan0: using static address 192.168.1.14/24 Apr 07 23:47:22 volumio-ch avahi-daemon[476]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.14. Apr 07 23:47:22 volumio-ch avahi-daemon[476]: New relevant interface wlan0.IPv4 for mDNS. Apr 07 23:47:22 volumio-ch avahi-daemon[476]: Registering new address record for 192.168.1.14 on wlan0.IPv4. Apr 07 23:47:22 volumio-ch dhcpcd[4195]: wlan0: adding route to 192.168.1.0/24 Apr 07 23:47:22 volumio-ch dhcpcd[4195]: wlan0: adding default route via 192.168.1.1 Apr 07 23:47:22 volumio-ch dnsmasq[856]: reading /etc/resolv.conf Apr 07 23:47:22 volumio-ch dnsmasq[856]: using nameserver 192.168.1.1#53 Apr 07 23:47:22 volumio-ch dnsmasq[856]: using nameserver 208.67.222.222#53 Apr 07 23:47:22 volumio-ch dnsmasq[856]: using nameserver 208.67.222.222#53 Apr 07 23:47:22 volumio-ch dnsmasq[856]: using nameserver 208.67.220.220#53 Apr 07 23:47:23 volumio-ch wireless.js[4059]: trying... Apr 07 23:47:24 volumio-ch ntpd[656]: Listen normally on 9 wlan0 192.168.1.14:123 Apr 07 23:47:24 volumio-ch volumio-remote-updater[473]: [2024-04-07 23:47:24] [info] asio async_connect error: system:111 (Connection refused) Apr 07 23:47:24 volumio-ch volumio-remote-updater[473]: [2024-04-07 23:47:24] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Apr 07 23:47:24 volumio-ch volumio-remote-updater[473]: [2024-04-07 23:47:24] [error] handle_connect error: Underlying Transport Error Apr 07 23:47:24 volumio-ch ntpd[656]: new interface(s) found: waking up resolver Apr 07 23:47:24 volumio-ch sudo[4263]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 07 23:47:24 volumio-ch sudo[4263]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:47:24 volumio-ch sudo[4263]: pam_unix(sudo:session): session closed for user root Apr 07 23:47:24 volumio-ch wireless.js[4059]: Connected to: ----SFR_E881 Apr 07 23:47:24 volumio-ch wireless.js[4059]: ---- Apr 07 23:47:24 volumio-ch wireless.js[4059]: trying... Apr 07 23:47:24 volumio-ch sudo[4266]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 07 23:47:24 volumio-ch sudo[4266]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:47:24 volumio-ch sudo[4268]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Apr 07 23:47:24 volumio-ch sudo[4266]: pam_unix(sudo:session): session closed for user root Apr 07 23:47:24 volumio-ch sudo[4268]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:47:24 volumio-ch sudo[4268]: pam_unix(sudo:session): session closed for user root Apr 07 23:47:24 volumio-ch wireless.js[4059]: Connected to: ----SFR_E881 Apr 07 23:47:24 volumio-ch wireless.js[4059]: ---- Apr 07 23:47:24 volumio-ch wireless.js[4059]: ... joined AP, wlan0 IPv4 is 192.168.1.14, ipV6 is undefined Apr 07 23:47:24 volumio-ch wireless.js[4059]: It's done! AP Apr 07 23:47:24 volumio-ch sudo[4272]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 07 23:47:24 volumio-ch sudo[4272]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:47:24 volumio-ch sudo[4272]: pam_unix(sudo:session): session closed for user root Apr 07 23:47:24 volumio-ch wireless.js[4059]: ... joined AP, wlan0 IPv4 is 192.168.1.14, ipV6 is undefined Apr 07 23:47:24 volumio-ch wireless.js[4059]: It's done! AP Apr 07 23:47:24 volumio-ch systemd[1]: Started Wireless Services. Apr 07 23:47:24 volumio-ch kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Apr 07 23:47:24 volumio-ch systemd[1]: Started Volumio Backend Module. Apr 07 23:47:26 volumio-ch volumio[4278]: info: ------------------------------------------- Apr 07 23:47:26 volumio-ch volumio[4278]: info: ----- Volumio3 ---- Apr 07 23:47:26 volumio-ch volumio[4278]: info: ------------------------------------------- Apr 07 23:47:26 volumio-ch volumio[4278]: info: ----- System startup ---- Apr 07 23:47:26 volumio-ch volumio[4278]: info: ------------------------------------------- Apr 07 23:47:27 volumio-ch dnsmasq-dhcp[856]: no address range available for DHCP request via wlan0 Apr 07 23:47:27 volumio-ch volumio[4278]: info: MYVOLUMIO Environment detected Apr 07 23:47:27 volumio-ch volumio[4278]: info: Plugin folders cleanup Apr 07 23:47:27 volumio-ch volumio[4278]: info: Scanning into folder /volumio/app/plugins/ Apr 07 23:47:27 volumio-ch volumio[4278]: info: Scanning category audio_interface Apr 07 23:47:27 volumio-ch volumio[4278]: info: Scanning category miscellanea Apr 07 23:47:27 volumio-ch volumio[4278]: info: Scanning category music_service Apr 07 23:47:27 volumio-ch volumio[4278]: info: Scanning category plugins.json Apr 07 23:47:27 volumio-ch volumio[4278]: info: Scanning category system_controller Apr 07 23:47:27 volumio-ch volumio[4278]: info: Scanning category user_interface Apr 07 23:47:27 volumio-ch volumio[4278]: info: Scanning into folder /data/plugins/ Apr 07 23:47:27 volumio-ch volumio[4278]: info: Scanning category music_service Apr 07 23:47:27 volumio-ch volumio[4278]: info: Plugin folders cleanup completed Apr 07 23:47:27 volumio-ch volumio[4278]: info: ------------------------------------------- Apr 07 23:47:27 volumio-ch volumio[4278]: info: ----- Core plugins startup ---- Apr 07 23:47:27 volumio-ch volumio[4278]: info: ------------------------------------------- Apr 07 23:47:27 volumio-ch volumio[4278]: info: Loading plugins from folder /volumio/app/plugins/ Apr 07 23:47:27 volumio-ch volumio[4278]: info: Adding plugin upnp to MyMusic Plugins Apr 07 23:47:27 volumio-ch volumio[4278]: info: Adding plugin airplay_emulation to MyMusic Plugins Apr 07 23:47:27 volumio-ch volumio[4278]: info: Adding plugin upnp_browser to MyMusic Plugins Apr 07 23:47:27 volumio-ch volumio[4278]: info: Loading plugins from folder /data/plugins/ Apr 07 23:47:27 volumio-ch volumio[4278]: info: Loading plugin "system"... Apr 07 23:47:27 volumio-ch volumio[4278]: info: Loading plugin "appearance"... Apr 07 23:47:28 volumio-ch volumio[4278]: info: Loading plugin "network"... Apr 07 23:47:28 volumio-ch volumio[4278]: info: Refreshing Cached IP Addresses Apr 07 23:47:28 volumio-ch volumio[4278]: info: Loading plugin "services"... Apr 07 23:47:28 volumio-ch volumio[4278]: info: Loading plugin "alsa_controller"... Apr 07 23:47:28 volumio-ch volumio[4278]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 07 23:47:28 volumio-ch volumio[4278]: info: Loading plugin "wizard"... Apr 07 23:47:28 volumio-ch volumio[4278]: info: Loading plugin "volumio_command_line_client"... Apr 07 23:47:28 volumio-ch volumio[4278]: info: Loading plugin "upnp"... Apr 07 23:47:28 volumio-ch volumio[4278]: info: [1712533648919] Starting Upmpd Daemon Apr 07 23:47:28 volumio-ch volumio[4278]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 07 23:47:28 volumio-ch volumio[4278]: info: Loading plugin "my_music"... Apr 07 23:47:28 volumio-ch volumio[4278]: info: Loading plugin "mpd"... Apr 07 23:47:29 volumio-ch volumio[4278]: info: Creating MPD Configuration file Apr 07 23:47:29 volumio-ch volumio[4278]: info: Loading plugin "upnp_browser"... Apr 07 23:47:29 volumio-ch volumio[4278]: info: Loading plugin "networkfs"... Apr 07 23:47:29 volumio-ch sudo[4300]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 07 23:47:29 volumio-ch sudo[4296]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 07 23:47:29 volumio-ch sudo[4296]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:47:29 volumio-ch sudo[4308]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 07 23:47:29 volumio-ch sudo[4308]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:47:29 volumio-ch sudo[4306]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 07 23:47:29 volumio-ch sudo[4298]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 07 23:47:29 volumio-ch sudo[4306]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:47:29 volumio-ch sudo[4300]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:47:29 volumio-ch sudo[4298]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:47:29 volumio-ch volumio[4278]: info: Starting Udev Watcher for removable devices Apr 07 23:47:29 volumio-ch sudo[4298]: pam_unix(sudo:session): session closed for user root Apr 07 23:47:29 volumio-ch sudo[4296]: pam_unix(sudo:session): session closed for user root Apr 07 23:47:29 volumio-ch sudo[4306]: pam_unix(sudo:session): session closed for user root Apr 07 23:47:29 volumio-ch systemd[1]: Stopping Music Player Daemon... Apr 07 23:47:29 volumio-ch sudo[4316]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto 192.168.1.18:/volume1/maMusicSyno /mnt/NAS/Synolouis Apr 07 23:47:29 volumio-ch sudo[4316]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:47:29 volumio-ch systemd[1]: mpd.service: Succeeded. Apr 07 23:47:29 volumio-ch systemd[1]: Stopped Music Player Daemon. Apr 07 23:47:29 volumio-ch systemd[1]: Starting Music Player Daemon... Apr 07 23:47:30 volumio-ch volumio[4278]: info: Ignoring mount for partition: boot Apr 07 23:47:30 volumio-ch volumio[4278]: info: Ignoring mount for partition: volumio Apr 07 23:47:30 volumio-ch volumio[4278]: info: Ignoring mount for partition: volumio_data Apr 07 23:47:30 volumio-ch volumio[4278]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 07 23:47:30 volumio-ch volumio[4278]: info: Loading plugin "alarm-clock"... Apr 07 23:47:30 volumio-ch volumio[4278]: info: Loading plugin "airplay_emulation"... Apr 07 23:47:30 volumio-ch volumio[4278]: info: Starting Shairport Sync Apr 07 23:47:30 volumio-ch volumio[4278]: info: Loading plugin "last_100"... Apr 07 23:47:30 volumio-ch volumio[4278]: info: Loading plugin "webradio"... Apr 07 23:47:30 volumio-ch volumio[4278]: info: Loading plugin "i2s_dacs"... Apr 07 23:47:30 volumio-ch volumio[4278]: info: Loading plugin "volumiodiscovery"... Apr 07 23:47:30 volumio-ch volumio[4278]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 07 23:47:30 volumio-ch volumio[4278]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 07 23:47:30 volumio-ch volumio[4278]: *** WARNING *** For more information see Apr 07 23:47:30 volumio-ch node[4278]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 07 23:47:30 volumio-ch volumio[4278]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 07 23:47:30 volumio-ch volumio[4278]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 07 23:47:30 volumio-ch volumio[4278]: *** WARNING *** For more information see Apr 07 23:47:30 volumio-ch node[4278]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 07 23:47:30 volumio-ch node[4278]: *** WARNING *** For more information see Apr 07 23:47:30 volumio-ch node[4278]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 07 23:47:30 volumio-ch node[4278]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 07 23:47:30 volumio-ch node[4278]: *** WARNING *** For more information see Apr 07 23:47:30 volumio-ch volumio[4278]: info: Applying required configuration parameters for plugin volumiodiscovery Apr 07 23:47:30 volumio-ch volumio[4278]: info: Discovery: Started advertising with name: Volumio-ch Apr 07 23:47:30 volumio-ch volumio[4278]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 07 23:47:30 volumio-ch volumio[4278]: info: Loading plugin "youtube2"... Apr 07 23:47:30 volumio-ch sudo[4300]: pam_unix(sudo:session): session closed for user root Apr 07 23:47:31 volumio-ch mpd[4321]: Apr 07 23:47 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 07 23:47:31 volumio-ch mpd[4321]: Apr 07 23:47 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Apr 07 23:47:31 volumio-ch mpd[4321]: Apr 07 23:47 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Apr 07 23:47:32 volumio-ch systemd[1]: Started Music Player Daemon. Apr 07 23:47:32 volumio-ch sudo[4308]: pam_unix(sudo:session): session closed for user root Apr 07 23:47:34 volumio-ch volumio-remote-updater[473]: [2024-04-07 23:47:34] [connect] Successful connection Apr 07 23:47:35 volumio-ch volumio[4278]: info: Loading plugin "ytcr"... Apr 07 23:47:36 volumio-ch volumio[4278]: info: Loading plugin "outputs"... Apr 07 23:47:36 volumio-ch volumio[4278]: info: Loading plugin "albumart"... Apr 07 23:47:36 volumio-ch volumio[4278]: info: Plugin example_plugin is not enabled Apr 07 23:47:36 volumio-ch volumio[4278]: info: Loading plugin "inputs"... Apr 07 23:47:36 volumio-ch volumio[4278]: info: Loading plugin "updater_comm"... Apr 07 23:47:36 volumio-ch volumio[4278]: info: Plugin mpdemulation is not enabled Apr 07 23:47:36 volumio-ch volumio[4278]: info: Loading plugin "rest_api"... Apr 07 23:47:36 volumio-ch volumio[4278]: info: Loading plugin "websocket"... Apr 07 23:47:36 volumio-ch volumio[4278]: info: Loading plugin "radio_paradise"... Apr 07 23:47:36 volumio-ch volumio[4278]: Forking 3 albumart workers Apr 07 23:47:36 volumio-ch volumio[4278]: info: Applying required configuration parameters for plugin radio_paradise Apr 07 23:47:36 volumio-ch volumio[4278]: info: [1712533656974] [RadioParadise] API delay: 5 Apr 07 23:47:36 volumio-ch volumio[4278]: info: Loading i18n strings for locale fr Apr 07 23:47:37 volumio-ch volumio[4278]: Updating browse sources language Apr 07 23:47:37 volumio-ch volumio[4278]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 07 23:47:37 volumio-ch volumio[4278]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 07 23:47:37 volumio-ch volumio[4278]: info: CoreCommandRouter::initPlayerControls Apr 07 23:47:37 volumio-ch volumio[4278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 23:47:37 volumio-ch volumio[4278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 23:47:37 volumio-ch volumio[4278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 23:47:37 volumio-ch volumio[4278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 23:47:37 volumio-ch volumio[4278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 23:47:37 volumio-ch volumio[4278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 23:47:37 volumio-ch volumio[4278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 23:47:37 volumio-ch volumio[4278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 23:47:37 volumio-ch volumio[4278]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 07 23:47:37 volumio-ch volumio[4278]: Express server listening on port 3000 Apr 07 23:47:37 volumio-ch volumio[4278]: [Metrics] WebUI: 10s 999.02ms Apr 07 23:47:37 volumio-ch volumio[4278]: info: CoreStateMachine::resetVolumioState Apr 07 23:47:37 volumio-ch volumio[4278]: info: CoreStateMachine::getcurrentVolume Apr 07 23:47:37 volumio-ch volumio[4278]: info: CoreCommandRouter::volumioRetrievevolume Apr 07 23:47:37 volumio-ch volumio[4278]: info: MPD Permissions set Apr 07 23:47:37 volumio-ch volumio-remote-updater[473]: [2024-04-07 23:47:37] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1712533654 101 Apr 07 23:47:37 volumio-ch volumio[4278]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 1 Apr 07 23:47:37 volumio-ch volumio[4278]: info: MPD running with PID4321 Apr 07 23:47:37 volumio-ch volumio[4278]: ,establishing connection Apr 07 23:47:37 volumio-ch volumio[4278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 23:47:37 volumio-ch volumio[4278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 23:47:37 volumio-ch volumio[4278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 23:47:37 volumio-ch volumio[4278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 23:47:37 volumio-ch volumio[4278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 23:47:37 volumio-ch volumio[4278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 23:47:37 volumio-ch volumio[4278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 23:47:37 volumio-ch volumio[4278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 23:47:37 volumio-ch volumio[4278]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 07 23:47:37 volumio-ch volumio[4278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 07 23:47:37 volumio-ch volumio[4278]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 07 23:47:37 volumio-ch volumio[4278]: info: Reloading queue from file Apr 07 23:47:37 volumio-ch volumio[4278]: error: updateQueue error: null Apr 07 23:47:37 volumio-ch volumio[4278]: info: CoreStateMachine::setRepeat null single undefined Apr 07 23:47:37 volumio-ch volumio[4278]: info: CoreStateMachine::pushState Apr 07 23:47:37 volumio-ch volumio[4278]: info: CorePlayQueue::getTrack 0 Apr 07 23:47:37 volumio-ch volumio[4278]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 07 23:47:37 volumio-ch volumio[4278]: info: CoreCommandRouter::volumioPushState Apr 07 23:47:37 volumio-ch volumio[4278]: info: CoreStateMachine::setRandom null Apr 07 23:47:37 volumio-ch volumio[4278]: info: CoreStateMachine::pushState Apr 07 23:47:37 volumio-ch volumio[4278]: info: CorePlayQueue::getTrack 0 Apr 07 23:47:37 volumio-ch volumio[4278]: info: CoreCommandRouter::volumioPushState Apr 07 23:47:37 volumio-ch volumio[4278]: info: Setting Device type: Raspberry PI Apr 07 23:47:37 volumio-ch volumio[4278]: info: VolumeController:: Volume=49 Mute =false Apr 07 23:47:37 volumio-ch volumio[4278]: info: CoreStateMachine::pushState Apr 07 23:47:37 volumio-ch volumio[4278]: info: CorePlayQueue::getTrack 0 Apr 07 23:47:37 volumio-ch volumio[4278]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 07 23:47:37 volumio-ch volumio[4278]: info: CoreCommandRouter::volumioPushState Apr 07 23:47:37 volumio-ch volumio[4278]: info: CoreStateMachine::updateTrackBlock Apr 07 23:47:37 volumio-ch volumio[4278]: info: CorePlayQueue::getTrackBlock Apr 07 23:47:37 volumio-ch volumio[4278]: info: CoreCommandRouter::volumioRetrievevolume Apr 07 23:47:37 volumio-ch volumio[4278]: error: updateQueue error: null Apr 07 23:47:38 volumio-ch volumio[4278]: info: Discovery: adding 9b91afe7-4937-4338-9db5-c6b3b5f2ecd9 Apr 07 23:47:38 volumio-ch volumio[4278]: info: Discovery: Found device Volumio-ch Apr 07 23:47:38 volumio-ch volumio[4278]: info: CoreCommandRouter::volumioGetState Apr 07 23:47:38 volumio-ch volumio[4278]: info: CorePlayQueue::getTrack 0 Apr 07 23:47:38 volumio-ch volumio[4278]: Starting albumart workers Apr 07 23:47:38 volumio-ch volumio[4278]: Starting albumart workers Apr 07 23:47:38 volumio-ch volumio[4278]: info: VolumeController:: Volume=49 Mute =false Apr 07 23:47:38 volumio-ch volumio[4278]: info: CoreStateMachine::pushState Apr 07 23:47:38 volumio-ch volumio[4278]: info: CorePlayQueue::getTrack 0 Apr 07 23:47:38 volumio-ch volumio[4278]: info: CoreCommandRouter::volumioPushState Apr 07 23:47:38 volumio-ch volumio[4278]: Starting albumart workers Apr 07 23:47:39 volumio-ch sudo[4398]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 07 23:47:39 volumio-ch sudo[4398]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:47:39 volumio-ch sudo[4402]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 07 23:47:39 volumio-ch sudo[4402]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:47:39 volumio-ch sudo[4400]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 07 23:47:39 volumio-ch sudo[4400]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:47:39 volumio-ch sudo[4398]: pam_unix(sudo:session): session closed for user root Apr 07 23:47:39 volumio-ch sudo[4400]: pam_unix(sudo:session): session closed for user root Apr 07 23:47:39 volumio-ch sudo[4404]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 07 23:47:39 volumio-ch sudo[4404]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:47:39 volumio-ch sudo[4406]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 07 23:47:39 volumio-ch sudo[4406]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:47:39 volumio-ch sudo[4404]: pam_unix(sudo:session): session closed for user root Apr 07 23:47:39 volumio-ch sudo[4402]: pam_unix(sudo:session): session closed for user root Apr 07 23:47:39 volumio-ch sudo[4406]: pam_unix(sudo:session): session closed for user root Apr 07 23:47:39 volumio-ch volumio[4278]: info: Upmpdcli Daemon Started Apr 07 23:47:39 volumio-ch volumio[4278]: verbose: New Socket.io Connection to 192.168.1.14 from 192.168.1.211 UA: Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:124.0) Gecko/20100101 Firefox/124.0 Total Clients: 2 Apr 07 23:47:40 volumio-ch sudo[4413]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 07 23:47:40 volumio-ch sudo[4413]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:47:40 volumio-ch sudo[4413]: pam_unix(sudo:session): session closed for user root Apr 07 23:47:40 volumio-ch sudo[4416]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 07 23:47:40 volumio-ch sudo[4416]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 07 23:47:40 volumio-ch sudo[4416]: pam_unix(sudo:session): session closed for user root Apr 07 23:47:40 volumio-ch volumio[4278]: verbose: New Socket.io Connection to 192.168.1.14 from 192.168.1.211 UA: Mozilla/5.0 (X11; Ubuntu; Linux x86_64; rv:124.0) Gecko/20100101 Firefox/124.0 Total Clients: 3 Apr 07 23:47:40 volumio-ch volumio[4278]: info: CoreCommandRouter::volumioGetState Apr 07 23:47:40 volumio-ch volumio[4278]: info: CorePlayQueue::getTrack 0 Apr 07 23:47:40 volumio-ch volumio[4278]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 07 23:47:40 volumio-ch volumio[4278]: info: Listing playlists Apr 07 23:47:40 volumio-ch volumio[4278]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 07 23:47:40 volumio-ch volumio[4278]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 07 23:47:40 volumio-ch volumio[4278]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 07 23:47:40 volumio-ch volumio[4278]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 07 23:47:41 volumio-ch volumio[4278]: info: CoreCommandRouter::volumioGetVisibleSources Apr 07 23:47:41 volumio-ch volumio[4278]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 07 23:47:41 volumio-ch volumio[4278]: info: CoreCommandRouter::volumioGetQueue Apr 07 23:47:41 volumio-ch volumio[4278]: info: CoreStateMachine::getQueue Apr 07 23:47:41 volumio-ch volumio[4278]: info: CorePlayQueue::getQueue Apr 07 23:47:42 volumio-ch volumio[4278]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 07 23:47:42 volumio-ch volumio[4278]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Apr 07 23:47:43 volumio-ch volumio[4278]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Apr 07 23:47:43 volumio-ch volumio[4278]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 07 23:47:44 volumio-ch volumio[4278]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Apr 07 23:47:48 volumio-ch volumio[4278]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 07 23:47:48 volumio-ch volumio[4278]: info: CURURI: playlists Apr 07 23:47:48 volumio-ch volumio[4278]: info: Listing playlists Apr 07 23:47:48 volumio-ch volumio[4278]: info: Preload queue cleared Apr 07 23:47:50 volumio-ch volumio[4278]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 07 23:47:50 volumio-ch volumio[4278]: info: CURURI: music-library Apr 07 23:47:50 volumio-ch volumio[4278]: info: Preload queue cleared Apr 07 23:47:58 volumio-ch volumio[4278]: info: Preload queue cleared Apr 07 23:47:58 volumio-ch volumio[4278]: info: Preloading song: youtube2/playlists@search=Stranded%20on%20a%20Desert%20Island%20-%20Cozy%20Shelter%20from%20the%20Storm%20-%20Bonfire%20and%20Rain%20Sounds@title=Playlists%20matching%20'Stranded%20on%20a%20Desert%20Island%20-%20Cozy%20Shelter%20from%20the%20Storm%20-%20Bonfire%20and%20Rain%20Sounds'/videos@playlistId=PL55FZKMR4v0R7KLSH0YBw-Mx9Ae56FwVg/video@videoId=ZuICqsitvv4 Apr 07 23:47:58 volumio-ch volumio[4278]: info: Preloading song: youtube2/channels@search=opal%20ocean@title=Channels%20matching%20'opal%20ocean'/playlists@channelId=UCPD4fWo6xpo7AtFgxXDwZHg/videos@playlistId=PLLokJPfI-dBmCUBj4Stb2Fo4tQJZbi6iK/video@videoId=TQ1eHtdVQPQ Apr 07 23:47:58 volumio-ch volumio[4278]: info: Preloading song: youtube2/videos@search=song%20for%20the%20dea@title=Videos%20matching%20'song%20for%20the%20dea'/video@videoId=A6afG0s0LSU Apr 07 23:47:58 volumio-ch volumio[4278]: info: Preloading song: youtube2/playlists@search=Blizzard%20ambiance@title=Playlists%20matching%20'Blizzard%20ambiance'/videos@playlistId=PLcvMpdD6fEhl5_Iw-YBgdAtmaDwn4I94E/video@videoId=vplX-qr4AIE Apr 07 23:47:58 volumio-ch volumio[4278]: info: Preloading song: youtube2/video@videoId=TT70LCNsz7I Apr 07 23:47:58 volumio-ch volumio[4278]: info: Preloading song: youtube2/videos@search=Lucas%20Gitanos%20family@title=Videos%20matching%20'Lucas%20Gitanos%20family'/video@videoId=to2iDSr6_KA Apr 07 23:47:58 volumio-ch volumio[4278]: info: Preloading song: youtube2/videos@search=Tear%20drop@title=Videos%20matching%20'Tear%20drop'/video@videoId=Tb0MC0jFv6M Apr 07 23:47:58 volumio-ch volumio[4278]: info: Preloading song: youtube2/videos@search=Rain%20on%20shelter@title=Videos%20matching%20'Rain%20on%20shelter'/video@videoId=LWhKntdXbPE Apr 07 23:47:58 volumio-ch volumio[4278]: info: Preloading song: youtube2/videos@search=Massive%20attack@title=Videos%20matching%20'Massive%20attack'@pageRef=%7B%22pageToken%22%3A%22%22%2C%22pageOffset%22%3A11%7D/video@videoId=66A_3uwuZ_I Apr 07 23:47:58 volumio-ch volumio[4278]: info: Preloading song: youtube2/videos@search=Pearl%20jam%20immortal@title=Videos%20matching%20'Pearl%20jam%20immortal'/video@videoId=pw4VEW3StIw Apr 07 23:47:58 volumio-ch volumio[4278]: info: Preloading song: youtube2/videos@search=Korn%20twisted@title=Videos%20matching%20'Korn%20twisted'/video@videoId=o7uGPWFwg1I Apr 07 23:47:58 volumio-ch volumio[4278]: info: Preloading song: youtube2/video@videoId=inBKFMB-yPg Apr 07 23:47:58 volumio-ch volumio[4278]: info: Preloading song: youtube2/videos@search=Chriss%20joss%20steam%20jet@title=Videos%20matching%20'Chriss%20joss%20steam%20jet'/video@videoId=INwXCr9CRXA Apr 07 23:47:58 volumio-ch volumio[4278]: info: Preloading song: youtube2/videos@search=Secret%20agent%20man@title=Videos%20matching%20'Secret%20agent%20man'/video@videoId=7hPm4eiiD08 Apr 07 23:47:58 volumio-ch volumio[4278]: info: Preloading song: youtube2/video@videoId=CANB7P8rPOU Apr 07 23:47:58 volumio-ch volumio[4278]: info: Exploding uri youtube2/playlists@search=Stranded%20on%20a%20Desert%20Island%20-%20Cozy%20Shelter%20from%20the%20Storm%20-%20Bonfire%20and%20Rain%20Sounds@title=Playlists%20matching%20'Stranded%20on%20a%20Desert%20Island%20-%20Cozy%20Shelter%20from%20the%20Storm%20-%20Bonfire%20and%20Rain%20Sounds'/videos@playlistId=PL55FZKMR4v0R7KLSH0YBw-Mx9Ae56FwVg/video@videoId=ZuICqsitvv4 in service youtube2 Apr 07 23:47:58 volumio-ch volumio[4278]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 07 23:47:58 volumio-ch volumio[4278]: TypeError: Cannot read property 'explodeUri' of undefined Apr 07 23:47:58 volumio-ch volumio[4278]: at ControllerYouTube2.explodeUri (/data/plugins/music_service/youtube2/index.js:375:34) Apr 07 23:47:58 volumio-ch volumio[4278]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1353:16) Apr 07 23:47:58 volumio-ch volumio[4278]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24) Apr 07 23:47:58 volumio-ch volumio[4278]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19) Apr 07 23:47:58 volumio-ch volumio[4278]: at Timeout._onTimeout (/volumio/app/playqueue.js:146:100) Apr 07 23:47:58 volumio-ch volumio[4278]: at listOnTimeout (internal/timers.js:554:17) Apr 07 23:47:58 volumio-ch volumio[4278]: at processTimers (internal/timers.js:497:7) Apr 07 23:47:58 volumio-ch volumio[4278]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 07 23:47:59 volumio-ch sudo[4428]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-07 23:46 Apr 07 23:47:59 volumio-ch sudo[4428]: pam_unix(sudo:session): session opened for user root by (uid=0) 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="b1c3cf61c2a0027c66bab1eb0a3795f80c1f2e95" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="e3eb3ee5b16063502f3a1735e11a28cfe54a0f46" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sun 25 Jun 2023 07:20:58 PM CEST" VOLUMIO_VERSION="3.512" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="946a42b62509f37b5e7e2d86a2932a62"