-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Fri 2024-04-19 10:41:35 UTC. --
Apr 19 10:40:01 volumio wpa_supplicant[773]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=00:00:00:00:00:00 status_code=16
Apr 19 10:40:01 volumio wpa_supplicant[773]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="xuyd2" auth_failures=2 duration=23 reason=CONN_FAILED
Apr 19 10:40:07 volumio sudo[994]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 19 10:40:07 volumio sudo[994]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 19 10:40:07 volumio sudo[994]: pam_unix(sudo:session): session closed for user root
Apr 19 10:40:07 volumio sudo[996]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 19 10:40:07 volumio sudo[996]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 19 10:40:07 volumio sudo[996]: pam_unix(sudo:session): session closed for user root
Apr 19 10:40:07 volumio sudo[999]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Apr 19 10:40:07 volumio sudo[999]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 19 10:40:08 volumio systemd[1]: Started UPnP Renderer front-end to MPD.
Apr 19 10:40:08 volumio sudo[999]: pam_unix(sudo:session): session closed for user root
Apr 19 10:40:08 volumio volumio[856]: info: Upmpdcli Daemon Started
Apr 19 10:40:08 volumio volumio[856]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600
Apr 19 10:40:12 volumio volumio[856]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600
Apr 19 10:40:12 volumio wpa_supplicant[773]: wlan0: Failed to initiate sched scan
Apr 19 10:40:18 volumio volumio[856]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600
Apr 19 10:40:18 volumio wpa_supplicant[773]: wlan0: Failed to initiate sched scan
Apr 19 10:40:24 volumio wpa_supplicant[773]: wlan0: CTRL-EVENT-SSID-REENABLED id=0 ssid="xuyd2"
Apr 19 10:40:24 volumio wpa_supplicant[773]: wlan0: Trying to associate with SSID 'xuyd2'
Apr 19 10:40:25 volumio wpa_supplicant[773]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=00:00:00:00:00:00 status_code=16
Apr 19 10:40:25 volumio wpa_supplicant[773]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="xuyd2" auth_failures=3 duration=46 reason=CONN_FAILED
Apr 19 10:40:28 volumio volumio[856]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600
Apr 19 10:40:29 volumio volumio[856]: error: Plugin system_controller system failed to complete 'onVolumioStart' in a timely fashion
Apr 19 10:40:29 volumio volumio[856]: info: Preparing to generate the ALSA configuration file
Apr 19 10:40:29 volumio volumio[856]: info: Asound.conf file unchanged, so no further update is needed
Apr 19 10:40:29 volumio volumio[856]: info: Output device has changed, restarting MPD
Apr 19 10:40:29 volumio volumio[856]: info: Output device has changed, restarting Shairport Sync
Apr 19 10:40:29 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 19 10:40:29 volumio sudo[1024]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 19 10:40:29 volumio sudo[1024]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 19 10:40:29 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 19 10:40:29 volumio sudo[1024]: pam_unix(sudo:session): session closed for user root
Apr 19 10:40:29 volumio sudo[1026]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 19 10:40:29 volumio sudo[1026]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 19 10:40:29 volumio volumio[856]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 19 10:40:29 volumio volumio[856]: info: ___________ START PLUGINS ___________
Apr 19 10:40:29 volumio volumio[856]: info: ControllerMpd::onStart: Initializing MPD
Apr 19 10:40:29 volumio volumio[856]: info: Creating MPD Configuration file
Apr 19 10:40:29 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 19 10:40:29 volumio volumio[856]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 19 10:40:29 volumio sudo[1034]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 19 10:40:29 volumio sudo[1034]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 19 10:40:29 volumio volumio[856]: info: [1713523229181] CoreMusicLibrary::Adding element 媒体服务器
Apr 19 10:40:29 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 19 10:40:29 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 19 10:40:29 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 19 10:40:29 volumio sudo[1034]: pam_unix(sudo:session): session closed for user root
Apr 19 10:40:29 volumio sudo[1036]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 19 10:40:29 volumio sudo[1036]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 19 10:40:29 volumio systemd[1]: Listening on mpd.socket.
Apr 19 10:40:29 volumio systemd[1]: Starting Music Player Daemon...
Apr 19 10:40:29 volumio volumio[856]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 19 10:40:29 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 19 10:40:29 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 19 10:40:29 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Apr 19 10:40:29 volumio systemd[1]: mpd.service: Succeeded.
Apr 19 10:40:29 volumio systemd[1]: Stopped Music Player Daemon.
Apr 19 10:40:29 volumio systemd[1]: Starting Music Player Daemon...
Apr 19 10:40:29 volumio volumio[856]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 19 10:40:29 volumio volumio[856]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 19 10:40:29 volumio volumio[856]: info: [1713523229269] CoreMusicLibrary::Adding element Last_100
Apr 19 10:40:29 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 19 10:40:29 volumio volumio[856]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 19 10:40:29 volumio volumio[856]: info: [1713523229272] CoreMusicLibrary::Adding element Webradio
Apr 19 10:40:29 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 19 10:40:29 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 19 10:40:29 volumio volumio[856]: info: Volumio Calling Home
Apr 19 10:40:29 volumio volumio[856]: Unhandled rejection Error: No sockets available, cannot start.
Apr 19 10:40:29 volumio volumio[856]: at SsdpClient.SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11)
Apr 19 10:40:29 volumio volumio[856]: at SsdpClient.SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10)
Apr 19 10:40:29 volumio volumio[856]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10
Apr 19 10:40:29 volumio volumio[856]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9)
Apr 19 10:40:29 volumio volumio[856]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18)
Apr 19 10:40:29 volumio volumio[856]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10)
Apr 19 10:40:29 volumio volumio[856]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10)
Apr 19 10:40:29 volumio volumio[856]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17)
Apr 19 10:40:29 volumio volumio[856]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:126:12)
Apr 19 10:40:29 volumio volumio[856]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24)
Apr 19 10:40:29 volumio volumio[856]: at HashMap. (/volumio/app/pluginmanager.js:496:31)
Apr 19 10:40:29 volumio volumio[856]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10)
Apr 19 10:40:29 volumio volumio[856]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7)
Apr 19 10:40:29 volumio volumio[856]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20)
Apr 19 10:40:29 volumio volumio[856]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29)
Apr 19 10:40:29 volumio volumio[856]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
Apr 19 10:40:29 volumio volumio[856]: info: MPD Permissions set
Apr 19 10:40:29 volumio volumio[856]: info: MPD Permissions set
Apr 19 10:40:29 volumio volumio[856]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 2
Apr 19 10:40:29 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 19 10:40:29 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 19 10:40:29 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 19 10:40:29 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 19 10:40:29 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 19 10:40:29 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 19 10:40:29 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 19 10:40:29 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 19 10:40:29 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 19 10:40:29 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 19 10:40:29 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 19 10:40:29 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 19 10:40:29 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 19 10:40:29 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 19 10:40:29 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 19 10:40:29 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 19 10:40:29 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 19 10:40:29 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 19 10:40:29 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 19 10:40:29 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 19 10:40:29 volumio volumio[856]: info: Starting Shairport Sync
Apr 19 10:40:29 volumio volumio[856]: info: Starting Shairport Sync
Apr 19 10:40:29 volumio volumio[856]: info: Starting Shairport Sync
Apr 19 10:40:29 volumio sudo[1059]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 19 10:40:29 volumio sudo[1059]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 19 10:40:29 volumio sudo[1061]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 19 10:40:29 volumio sudo[1061]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 19 10:40:29 volumio sudo[1064]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 19 10:40:29 volumio sudo[1064]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 19 10:40:29 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Apr 19 10:40:29 volumio systemd[1]: shairport-sync.service: Succeeded.
Apr 19 10:40:29 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Apr 19 10:40:29 volumio volumio[856]: info: CoreCommandRouter::volumioGetState
Apr 19 10:40:29 volumio volumio[856]: info: CorePlayQueue::getTrack 0
Apr 19 10:40:29 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Apr 19 10:40:29 volumio sudo[1059]: pam_unix(sudo:session): session closed for user root
Apr 19 10:40:29 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Apr 19 10:40:29 volumio volumio[856]: info: Shairport-Sync Started
Apr 19 10:40:29 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM
Apr 19 10:40:29 volumio systemd[1]: shairport-sync.service: Succeeded.
Apr 19 10:40:29 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Apr 19 10:40:29 volumio volumio[856]: Error adding Membership: Error: addMembership EINVAL
Apr 19 10:40:29 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Apr 19 10:40:29 volumio sudo[1061]: pam_unix(sudo:session): session closed for user root
Apr 19 10:40:29 volumio sudo[1064]: pam_unix(sudo:session): session closed for user root
Apr 19 10:40:29 volumio volumio[856]: info: Shairport-Sync Started
Apr 19 10:40:29 volumio volumio[856]: info: Shairport-Sync Started
Apr 19 10:40:30 volumio mpd[1044]: Apr 19 10:40 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Apr 19 10:40:30 volumio systemd[1]: Started Music Player Daemon.
Apr 19 10:40:30 volumio sudo[1036]: pam_unix(sudo:session): session closed for user root
Apr 19 10:40:30 volumio sudo[1026]: pam_unix(sudo:session): session closed for user root
Apr 19 10:40:30 volumio volumio[856]: info: Completed starting Core Plugins
Apr 19 10:40:30 volumio volumio[856]: info: -------------------------------------------
Apr 19 10:40:30 volumio volumio[856]: info: ----- MyVolumio plugins startup ----
Apr 19 10:40:30 volumio volumio[856]: info: -------------------------------------------
Apr 19 10:40:30 volumio volumio[856]: info: [MyVolumio PluginManager] Fetching plans data....
Apr 19 10:40:30 volumio volumio[856]: error: MPD error: The expression evaluated to a falsy value:
Apr 19 10:40:30 volumio volumio[856]: assert.ok(self.idling)
Apr 19 10:40:30 volumio volumio[856]: error: The expression evaluated to a falsy value:
Apr 19 10:40:30 volumio volumio[856]: assert.ok(self.idling)
Apr 19 10:40:30 volumio volumio[856]: error: updateQueue error: null
Apr 19 10:40:30 volumio volumio[856]: info: MPD running with PID1044
Apr 19 10:40:30 volumio volumio[856]: ,establishing connection
Apr 19 10:40:30 volumio volumio[856]: error: updateQueue error: null
Apr 19 10:40:33 volumio ntpd[692]: error resolving pool 0.debian.pool.ntp.org: System error (-11)
Apr 19 10:40:35 volumio ntpd[692]: error resolving pool 1.debian.pool.ntp.org: System error (-11)
Apr 19 10:40:36 volumio wpa_supplicant[773]: wlan0: Failed to initiate sched scan
Apr 19 10:40:38 volumio ntpd[692]: error resolving pool 2.debian.pool.ntp.org: System error (-11)
Apr 19 10:40:39 volumio ntpd[692]: error resolving pool 3.debian.pool.ntp.org: System error (-11)
Apr 19 10:40:39 volumio volumio[856]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=3.631&uuid=1e345b1b8b3fc316ced1f4235cb3e694" http://updates.volumio.org/downloader-v1/track-device
Apr 19 10:40:39 volumio volumio[856]: % Total % Received % Xferd Average Speed Time Time Time Current
Apr 19 10:40:39 volumio volumio[856]: Dload Upload Total Spent Left Speed
Apr 19 10:40:39 volumio volumio[856]: [132B blob data]
Apr 19 10:40:39 volumio volumio[856]: retrying in 5 seconds, trial 0
Apr 19 10:40:39 volumio volumio[856]: info: Volumio Calling Home
Apr 19 10:40:42 volumio wpa_supplicant[773]: wlan0: Failed to initiate sched scan
Apr 19 10:40:48 volumio wpa_supplicant[773]: wlan0: Failed to initiate sched scan
Apr 19 10:40:49 volumio volumio[856]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=3.631&uuid=1e345b1b8b3fc316ced1f4235cb3e694" http://updates.volumio.org/downloader-v1/track-device
Apr 19 10:40:49 volumio volumio[856]: % Total % Received % Xferd Average Speed Time Time Time Current
Apr 19 10:40:49 volumio volumio[856]: Dload Upload Total Spent Left Speed
Apr 19 10:40:49 volumio volumio[856]: [132B blob data]
Apr 19 10:40:49 volumio volumio[856]: retrying in 5 seconds, trial 1
Apr 19 10:40:49 volumio volumio[856]: info: Volumio Calling Home
Apr 19 10:40:50 volumio volumio[856]: error: MyVolumio Plugin failed to start in a timely fashion
Apr 19 10:40:50 volumio volumio[856]: info: BOOT COMPLETED
Apr 19 10:40:50 volumio volumio[856]: [Metrics] CommandRouter: 55s 976.53ms
Apr 19 10:40:50 volumio volumio[856]: info: CoreCommandRouter::volumiosetStartupVolume
Apr 19 10:40:50 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 19 10:40:50 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 19 10:40:50 volumio volumio[856]: info: CoreCommandRouter::Close All Modals sent
Apr 19 10:40:50 volumio volumio[856]: info: CoreCommandRouter::Close All Modals sent
Apr 19 10:40:51 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Apr 19 10:40:51 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Apr 19 10:40:51 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Apr 19 10:40:54 volumio wpa_supplicant[773]: wlan0: Failed to initiate sched scan
Apr 19 10:40:55 volumio kernel: xhci_hcd 0000:01:00.0: ERROR Transfer event for disabled endpoint slot 5 ep 1
Apr 19 10:40:55 volumio kernel: xhci_hcd 0000:01:00.0: @000000042a1133b0 00000000 00000000 0e000000 05028001
Apr 19 10:40:58 volumio systemd[1]: nmbd.service: Start operation timed out. Terminating.
Apr 19 10:40:58 volumio systemd[1]: nmbd.service: Main process exited, code=killed, status=15/TERM
Apr 19 10:40:58 volumio systemd[1]: nmbd.service: Failed with result 'timeout'.
Apr 19 10:40:58 volumio systemd[1]: Failed to start Samba NMB Daemon.
Apr 19 10:40:58 volumio systemd[1]: Starting Samba Winbind Daemon...
Apr 19 10:40:58 volumio winbindd[1098]: [2024/04/19 10:40:58.305555, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache)
Apr 19 10:40:58 volumio winbindd[1098]: initialize_winbindd_cache: clearing cache and re-creating with version number 2
Apr 19 10:40:58 volumio winbindd[1098]: [2024/04/19 10:40:58.323848, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Apr 19 10:40:58 volumio winbindd[1098]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections
Apr 19 10:40:58 volumio systemd[1]: Started Samba Winbind Daemon.
Apr 19 10:40:58 volumio systemd[1]: Starting Samba SMB Daemon...
Apr 19 10:40:58 volumio winbindd[1098]: [2024/04/19 10:40:58.685949, 0] ../source3/winbindd/wb_lookupsids.c:659(wb_lookupsids_recv)
Apr 19 10:40:58 volumio winbindd[1098]: res_names->count = 3, expected 4
Apr 19 10:40:58 volumio smbd[1102]: [2024/04/19 10:40:58.702317, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Apr 19 10:40:58 volumio smbd[1102]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections
Apr 19 10:40:58 volumio systemd[1]: Started Samba SMB Daemon.
Apr 19 10:40:58 volumio systemd[1]: Reached target Multi-User System.
Apr 19 10:40:58 volumio systemd[1]: Reached target Graphical Interface.
Apr 19 10:40:58 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes...
Apr 19 10:40:58 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded.
Apr 19 10:40:58 volumio systemd[1]: Started Update UTMP about System Runlevel Changes.
Apr 19 10:40:58 volumio systemd[1]: Startup finished in 9.594s (kernel) + 1min 39.593s (userspace) = 1min 49.188s.
Apr 19 10:40:59 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 19 10:40:59 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 19 10:40:59 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Apr 19 10:40:59 volumio volumio[856]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=3.631&uuid=1e345b1b8b3fc316ced1f4235cb3e694" http://updates.volumio.org/downloader-v1/track-device
Apr 19 10:40:59 volumio volumio[856]: % Total % Received % Xferd Average Speed Time Time Time Current
Apr 19 10:40:59 volumio volumio[856]: Dload Upload Total Spent Left Speed
Apr 19 10:40:59 volumio volumio[856]: [132B blob data]
Apr 19 10:40:59 volumio volumio[856]: retrying in 5 seconds, trial 2
Apr 19 10:40:59 volumio volumio[856]: info: Volumio Calling Home
Apr 19 10:41:00 volumio wpa_supplicant[773]: wlan0: Failed to initiate sched scan
Apr 19 10:41:06 volumio wpa_supplicant[773]: wlan0: Failed to initiate sched scan
Apr 19 10:41:12 volumio wpa_supplicant[773]: wlan0: CTRL-EVENT-SSID-REENABLED id=0 ssid="xuyd2"
Apr 19 10:41:12 volumio wpa_supplicant[773]: wlan0: Trying to associate with SSID 'xuyd2'
Apr 19 10:41:13 volumio dhcpcd[785]: wlan0: carrier acquired
Apr 19 10:41:13 volumio dhcpcd[785]: wlan0: connected to Access Point `xuyd2'
Apr 19 10:41:13 volumio wpa_supplicant[773]: wlan0: Associated with 78:60:5b:a2:09:5f
Apr 19 10:41:13 volumio wpa_supplicant[773]: wlan0: CTRL-EVENT-CONNECTED - Connection to 78:60:5b:a2:09:5f completed [id=0 id_str=]
Apr 19 10:41:13 volumio wpa_supplicant[773]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Apr 19 10:41:13 volumio wpa_supplicant[773]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=CN
Apr 19 10:41:13 volumio dhcpcd[785]: DUID 00:01:00:01:2b:b8:6c:3c:b8:27:eb:ec:cb:43
Apr 19 10:41:13 volumio dhcpcd[785]: wlan0: IAID 32:15:4b:86
Apr 19 10:41:13 volumio dhcpcd[785]: wlan0: adding address fe80::dea6:32ff:fe15:4b86
Apr 19 10:41:13 volumio dhcpcd[785]: ipv6_addaddr1: Permission denied
Apr 19 10:41:13 volumio dhcpcd[785]: wlan0: carrier lost
Apr 19 10:41:13 volumio dhcpcd[785]: wlan0: carrier acquired
Apr 19 10:41:13 volumio dhcpcd[785]: wlan0: IAID 32:15:4b:86
Apr 19 10:41:13 volumio dhcpcd[785]: wlan0: rebinding lease of 192.168.11.196
Apr 19 10:41:13 volumio dhcpcd[785]: wlan0: probing address 192.168.11.196/24
Apr 19 10:41:14 volumio dhcpcd[785]: wlan0: soliciting an IPv6 router
Apr 19 10:41:18 volumio dhcpcd[785]: wlan0: leased 192.168.11.196 for 43200 seconds
Apr 19 10:41:18 volumio avahi-daemon[547]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.11.196.
Apr 19 10:41:18 volumio avahi-daemon[547]: New relevant interface wlan0.IPv4 for mDNS.
Apr 19 10:41:18 volumio dhcpcd[785]: wlan0: adding route to 192.168.11.0/24
Apr 19 10:41:18 volumio avahi-daemon[547]: Registering new address record for 192.168.11.196 on wlan0.IPv4.
Apr 19 10:41:18 volumio dhcpcd[785]: wlan0: adding default route via 192.168.11.1
Apr 19 10:41:18 volumio volumio[856]: verbose: New Socket.io Connection to 192.168.11.196 from 192.168.11.139 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.0.0 Safari/537.36 Total Clients: 3
Apr 19 10:41:18 volumio volumio[856]: verbose: New Socket.io Connection to 192.168.11.196 from 192.168.11.139 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.0.0 Safari/537.36 Total Clients: 4
Apr 19 10:41:18 volumio volumio[856]: verbose: New Socket.io Connection to 192.168.11.196 from 192.168.11.139 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.0.0 Safari/537.36 Total Clients: 5
Apr 19 10:41:19 volumio volumio[856]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
Apr 19 10:41:19 volumio volumio[856]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
Apr 19 10:41:19 volumio volumio[856]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
Apr 19 10:41:19 volumio volumio[856]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
Apr 19 10:41:19 volumio volumio[856]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
Apr 19 10:41:19 volumio volumio[856]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
Apr 19 10:41:19 volumio volumio[856]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
Apr 19 10:41:19 volumio volumio[856]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
Apr 19 10:41:19 volumio volumio[856]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
Apr 19 10:41:19 volumio volumio[856]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
Apr 19 10:41:19 volumio volumio[856]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
Apr 19 10:41:19 volumio volumio[856]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
Apr 19 10:41:19 volumio volumio[856]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
Apr 19 10:41:19 volumio volumio[856]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
Apr 19 10:41:19 volumio volumio[856]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
Apr 19 10:41:19 volumio volumio[856]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
Apr 19 10:41:19 volumio volumio[856]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
Apr 19 10:41:19 volumio volumio[856]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
Apr 19 10:41:19 volumio volumio[856]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
Apr 19 10:41:19 volumio volumio[856]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
Apr 19 10:41:19 volumio volumio[856]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
Apr 19 10:41:19 volumio volumio[856]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
Apr 19 10:41:19 volumio volumio[856]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
Apr 19 10:41:19 volumio volumio[856]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
Apr 19 10:41:19 volumio volumio[856]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
Apr 19 10:41:19 volumio volumio[856]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
Apr 19 10:41:19 volumio volumio[856]: info: Adding plugin bluetooth to MyMusic Plugins
Apr 19 10:41:19 volumio volumio[856]: info: Adding plugin multiroom to MyMusic Plugins
Apr 19 10:41:19 volumio volumio[856]: info: Adding plugin metavolumio to MyMusic Plugins
Apr 19 10:41:19 volumio volumio[856]: info: Adding plugin cd_controller to MyMusic Plugins
Apr 19 10:41:19 volumio volumio[856]: info: Adding plugin smart_inputs to MyMusic Plugins
Apr 19 10:41:19 volumio volumio[856]: info: Adding plugin tidalconnect to MyMusic Plugins
Apr 19 10:41:19 volumio volumio[856]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
Apr 19 10:41:20 volumio volumio[856]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
Apr 19 10:41:20 volumio volumio[856]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
Apr 19 10:41:20 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 19 10:41:20 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 19 10:41:20 volumio volumio[856]: info: Starting MyVolumio Remote Streaming Endpoints
Apr 19 10:41:20 volumio volumio[856]: info: MyVolumio login type: Token
Apr 19 10:41:20 volumio volumio[856]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
Apr 19 10:41:20 volumio volumio[856]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
Apr 19 10:41:20 volumio ntpd[692]: Listen normally on 3 wlan0 192.168.11.196:123
Apr 19 10:41:20 volumio ntpd[692]: new interface(s) found: waking up resolver
Apr 19 10:41:21 volumio volumio[856]: info: Starting Streaming Service Transparent Proxy
Apr 19 10:41:21 volumio volumio[856]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Apr 19 10:41:21 volumio volumio[856]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Apr 19 10:41:21 volumio volumio[856]: info: Streaming services startup
Apr 19 10:41:21 volumio volumio[856]: info: Starting Streaming Daemon
Apr 19 10:41:21 volumio sudo[1157]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Apr 19 10:41:21 volumio sudo[1157]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 19 10:41:21 volumio sudo[1157]: pam_unix(sudo:session): session closed for user root
Apr 19 10:41:21 volumio volumio[856]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
Apr 19 10:41:21 volumio volumio[856]: error: Cannot start Volumio Streaming Daemon
Apr 19 10:41:21 volumio volumio[856]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Apr 19 10:41:21 volumio volumio[856]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Apr 19 10:41:21 volumio volumio[856]: info: Discovery: adding 1c0910de-b758-4edc-9cf2-4bde49142e62
Apr 19 10:41:21 volumio volumio[856]: info: Discovery: Found device Volumio
Apr 19 10:41:21 volumio volumio[856]: info: CoreCommandRouter::volumioGetState
Apr 19 10:41:21 volumio volumio[856]: info: CorePlayQueue::getTrack 0
Apr 19 10:41:21 volumio volumio[856]: verbose: New Socket.io Connection to 192.168.11.196 from 192.168.11.139 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.0.0 Safari/537.36 Total Clients: 6
Apr 19 10:41:21 volumio volumio[856]: STREAMING PROXY: Starting server on port 3245
Apr 19 10:41:21 volumio volumio[856]: Node JS runtime: 14
Apr 19 10:41:21 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 19 10:41:21 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 19 10:41:21 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 19 10:41:21 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 19 10:41:21 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 19 10:41:21 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 19 10:41:21 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 19 10:41:21 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 19 10:41:21 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 19 10:41:21 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 19 10:41:21 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 19 10:41:21 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 19 10:41:21 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 19 10:41:21 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 19 10:41:21 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 19 10:41:21 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 19 10:41:21 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 19 10:41:21 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 19 10:41:21 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 19 10:41:21 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 19 10:41:21 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 19 10:41:21 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 19 10:41:21 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 19 10:41:21 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 19 10:41:21 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 19 10:41:21 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 19 10:41:21 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 19 10:41:21 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 19 10:41:21 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 19 10:41:21 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 19 10:41:21 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 19 10:41:21 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 19 10:41:21 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 19 10:41:21 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 19 10:41:21 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 19 10:41:21 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 19 10:41:21 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 19 10:41:21 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 19 10:41:21 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 19 10:41:21 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 19 10:41:21 volumio volumio[856]: info: CoreCommandRouter::volumioGetState
Apr 19 10:41:21 volumio volumio[856]: info: CorePlayQueue::getTrack 0
Apr 19 10:41:21 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Apr 19 10:41:21 volumio volumio[856]: info: Listing playlists
Apr 19 10:41:21 volumio volumio[856]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 19 10:41:21 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 19 10:41:22 volumio volumio[856]: info: CoreCommandRouter::volumioGetQueue
Apr 19 10:41:22 volumio volumio[856]: info: CoreStateMachine::getQueue
Apr 19 10:41:22 volumio volumio[856]: info: CorePlayQueue::getQueue
Apr 19 10:41:22 volumio volumio[1002]: Generating RSA private key, 4096 bit long modulus (2 primes)
Apr 19 10:41:22 volumio volumio[856]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN
Apr 19 10:41:23 volumio volumio[856]: info: MyVolumio token set successfully
Apr 19 10:41:23 volumio volumio[856]: info: MYVOLUMIO: Adding device
Apr 19 10:41:23 volumio volumio[856]: info: MYVOLUMIO: Evaluating Server
Apr 19 10:41:23 volumio volumio[1002]: ..................++++
Apr 19 10:41:24 volumio volumio[856]: info: MyVolumio Plan changed: premium
Apr 19 10:41:24 volumio volumio[856]: info: [MyVolumio PluginManager] Subscribed plan changed to premium
Apr 19 10:41:24 volumio volumio[856]: info: Removing browser output: myVolumio user plan is not superstar
Apr 19 10:41:24 volumio volumio[856]: info: Removing audio output:
Apr 19 10:41:24 volumio volumio[856]: info: MYVOLUMIO: Adding device
Apr 19 10:41:24 volumio volumio[856]: info: MYVOLUMIO: Evaluating Server
Apr 19 10:41:24 volumio volumio[856]: info: Remote config written successfully
Apr 19 10:41:24 volumio volumio[856]: info: Starting Tunnel 1
Apr 19 10:41:24 volumio volumio[856]: info: Starting Tunnel Connection Checker
Apr 19 10:41:24 volumio volumio[856]: info: MYVolumio Device enabled
Apr 19 10:41:24 volumio volumio[856]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins...
Apr 19 10:41:24 volumio volumio[856]: info: MyVolumio status changed
Apr 19 10:41:24 volumio volumio[856]: info: Streaming services startup
Apr 19 10:41:24 volumio volumio[856]: info: Starting Streaming Daemon
Apr 19 10:41:24 volumio sudo[1200]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Apr 19 10:41:24 volumio sudo[1200]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 19 10:41:24 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid
Apr 19 10:41:24 volumio volumio[856]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"...
Apr 19 10:41:24 volumio sudo[1200]: pam_unix(sudo:session): session closed for user root
Apr 19 10:41:24 volumio volumio[856]: info: [1713523284684] Starting BluetoothController
Apr 19 10:41:24 volumio volumio[856]: info: [MyVolumio PluginManager] Loading plugin "multiroom"...
Apr 19 10:41:25 volumio volumio[856]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom
Apr 19 10:41:25 volumio sudo[1203]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom
Apr 19 10:41:25 volumio sudo[1203]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 19 10:41:25 volumio sudo[1203]: pam_unix(sudo:session): session closed for user root
Apr 19 10:41:25 volumio volumio[856]: info: MRS: MultiRoom plugin initialized
Apr 19 10:41:25 volumio volumio[856]: info: MRS: STOPPING SNAPCLIENT
Apr 19 10:41:25 volumio volumio[856]: info: MRS: Snap server stop
Apr 19 10:41:25 volumio sudo[1219]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient
Apr 19 10:41:25 volumio sudo[1219]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 19 10:41:25 volumio volumio[856]: info: MRS: STOPPING volumioStreaming
Apr 19 10:41:25 volumio sudo[1221]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver
Apr 19 10:41:25 volumio sudo[1221]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 19 10:41:25 volumio sudo[1225]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming
Apr 19 10:41:25 volumio sudo[1225]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 19 10:41:25 volumio sudo[1219]: pam_unix(sudo:session): session closed for user root
Apr 19 10:41:26 volumio sudo[1221]: pam_unix(sudo:session): session closed for user root
Apr 19 10:41:26 volumio volumio[856]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"...
Apr 19 10:41:26 volumio sudo[1228]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/*
Apr 19 10:41:26 volumio sudo[1228]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 19 10:41:26 volumio sudo[1228]: pam_unix(sudo:session): session closed for user root
Apr 19 10:41:26 volumio sudo[1225]: pam_unix(sudo:session): session closed for user root
Apr 19 10:41:26 volumio volumio[856]: info: [MyVolumio PluginManager] Loading plugin "manifestui"...
Apr 19 10:41:26 volumio volumio[856]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"...
Apr 19 10:41:26 volumio volumio[856]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"...
Apr 19 10:41:26 volumio volumio[856]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"...
Apr 19 10:41:26 volumio volumio[856]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio
Apr 19 10:41:26 volumio volumio[856]: info: [MyVolumio PluginManager] Loading plugin "tidal"...
Apr 19 10:41:26 volumio volumio[856]: info: [MyVolumio PluginManager] Loading plugin "qobuz"...
Apr 19 10:41:26 volumio volumio[856]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"...
Apr 19 10:41:26 volumio volumio[856]: info: Preparing to generate the ALSA configuration file
Apr 19 10:41:26 volumio volumio[856]: info: Setting Geolocation for MyVolumio to us2
Apr 19 10:41:26 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 19 10:41:26 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 19 10:41:26 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 19 10:41:26 volumio volumio[856]: info: MRS: Removed streaming files
Apr 19 10:41:26 volumio volumio[856]: info: MRS: volumioStreaming STOPPED
Apr 19 10:41:26 volumio volumio[856]: info: MRS: SNAPSERVER STOPPED
Apr 19 10:41:26 volumio volumio[856]: info: MRS: SNAPCLIENT STOPPED
Apr 19 10:41:26 volumio volumio[856]: error: Cannot start Volumio Streaming Daemon
Apr 19 10:41:26 volumio volumio[856]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Apr 19 10:41:26 volumio volumio[856]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Apr 19 10:41:26 volumio volumio[856]: info: Setting Geolocation for MyVolumio to us2
Apr 19 10:41:26 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 19 10:41:26 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 19 10:41:26 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 19 10:41:26 volumio volumio[856]: info: Asound.conf file unchanged, so no further update is needed
Apr 19 10:41:26 volumio volumio[856]: info: Output device has changed, restarting MPD
Apr 19 10:41:26 volumio sudo[1231]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 19 10:41:26 volumio sudo[1231]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 19 10:41:26 volumio volumio[856]: info: Output device has changed, restarting Shairport Sync
Apr 19 10:41:26 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 19 10:41:26 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 19 10:41:26 volumio sudo[1231]: pam_unix(sudo:session): session closed for user root
Apr 19 10:41:26 volumio sudo[1233]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 19 10:41:26 volumio sudo[1233]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 19 10:41:26 volumio systemd[1]: Stopping Music Player Daemon...
Apr 19 10:41:26 volumio volumio[856]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 19 10:41:26 volumio volumio[856]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Apr 19 10:41:26 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 19 10:41:26 volumio volumio[856]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth
Apr 19 10:41:26 volumio volumio[856]: info: [MyVolumio PluginManager] Plugin bluetooth disabled by user. Not starting
Apr 19 10:41:26 volumio volumio[856]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom
Apr 19 10:41:26 volumio volumio[856]: info: [MyVolumio PluginManager] Plugin multiroom disabled by user. Not starting
Apr 19 10:41:26 volumio volumio[856]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio
Apr 19 10:41:26 volumio volumio[856]: info: Adding METAVOLUMIO REST API Endpoints
Apr 19 10:41:26 volumio volumio[856]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio
Apr 19 10:41:26 volumio volumio[856]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio
Apr 19 10:41:26 volumio volumio[856]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio
Apr 19 10:41:26 volumio volumio[856]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio
Apr 19 10:41:26 volumio volumio[856]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui
Apr 19 10:41:26 volumio volumio[856]: info: Adding Manifest REST API Endpoints
Apr 19 10:41:26 volumio volumio[856]: info: Adding manifestui REST Endpoint for plugin: miscellanea/manifestui
Apr 19 10:41:26 volumio volumio[856]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller
Apr 19 10:41:26 volumio volumio[856]: info: Preparing CD Folders
Apr 19 10:41:26 volumio volumio[856]: info: Adding CD REST API Endpoints
Apr 19 10:41:26 volumio volumio[856]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller
Apr 19 10:41:26 volumio volumio[856]: info: Starting UDEV Watcher for CD
Apr 19 10:41:26 volumio volumio[856]: info: Detecting CD presence with UDEV
Apr 19 10:41:26 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices
Apr 19 10:41:26 volumio systemd[1]: mpd.service: Succeeded.
Apr 19 10:41:26 volumio systemd[1]: Stopped Music Player Daemon.
Apr 19 10:41:26 volumio sudo[1243]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /dev/sr0
Apr 19 10:41:26 volumio sudo[1243]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 19 10:41:26 volumio sudo[1243]: pam_unix(sudo:session): session closed for user root
Apr 19 10:41:26 volumio systemd[1]: Starting Music Player Daemon...
Apr 19 10:41:26 volumio sudo[1246]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /dev/sr1
Apr 19 10:41:26 volumio sudo[1246]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 19 10:41:26 volumio sudo[1246]: pam_unix(sudo:session): session closed for user root
Apr 19 10:41:26 volumio volumio[856]: /bin/chmod: cannot access '/dev/sr1': No such file or directory
Apr 19 10:41:26 volumio volumio[856]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 19 10:41:26 volumio volumio[856]: info: [1713523286651] CoreMusicLibrary::Adding element Audio CD
Apr 19 10:41:26 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 19 10:41:26 volumio volumio[856]: Cannot find translation for source Audio CD
Apr 19 10:41:26 volumio volumio[856]: info: Set CD Speed to 4X
Apr 19 10:41:26 volumio volumio[856]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs
Apr 19 10:41:26 volumio volumio[856]: info: [MyVolumio PluginManager] Plugin smart_inputs disabled by user. Not starting
Apr 19 10:41:26 volumio volumio[856]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio
Apr 19 10:41:26 volumio volumio[856]: error: Hi Res Audio Failed Login: Missing Login Data
Apr 19 10:41:26 volumio volumio[856]: info: Adding HIGHRESAUDIO REST API Endpoints
Apr 19 10:41:26 volumio volumio[856]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio
Apr 19 10:41:26 volumio volumio[856]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal
Apr 19 10:41:26 volumio volumio[856]: info: Refreshing TIDAL token
Apr 19 10:41:26 volumio volumio[856]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz
Apr 19 10:41:26 volumio volumio[856]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect
Apr 19 10:41:26 volumio volumio[856]: info: [MyVolumio PluginManager] Plugin tidalconnect disabled by user. Not starting
Apr 19 10:41:26 volumio volumio[856]: info: Stopping AccessToken refresher cron for QOBUZ
Apr 19 10:41:26 volumio volumio[856]: info: AccessToken refresher cron started for QOBUZ
Apr 19 10:41:26 volumio volumio[856]: info: Adding QOBUZ REST API Endpoints
Apr 19 10:41:26 volumio volumio[856]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz
Apr 19 10:41:26 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 19 10:41:26 volumio volumio[856]: error: MPD error: Error: write EPIPE
Apr 19 10:41:26 volumio volumio[856]: error: write EPIPE {"errno":-32,"code":"EPIPE","syscall":"write"}
Apr 19 10:41:26 volumio volumio[1002]: .............................++++
Apr 19 10:41:26 volumio volumio[1002]: e is 65537 (0x010001)
Apr 19 10:41:26 volumio volumio[1002]: writing RSA key
Apr 19 10:41:26 volumio volumio[856]: info: MPD Permissions set
Apr 19 10:41:26 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 19 10:41:26 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 19 10:41:26 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 19 10:41:26 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 19 10:41:26 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 19 10:41:26 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 19 10:41:26 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 19 10:41:26 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 19 10:41:26 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 19 10:41:26 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 19 10:41:26 volumio volumio[856]: info: Starting Shairport Sync
Apr 19 10:41:26 volumio sudo[1300]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 19 10:41:26 volumio sudo[1300]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 19 10:41:26 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Apr 19 10:41:26 volumio systemd[1]: shairport-sync.service: Succeeded.
Apr 19 10:41:26 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Apr 19 10:41:27 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Apr 19 10:41:27 volumio sudo[1300]: pam_unix(sudo:session): session closed for user root
Apr 19 10:41:27 volumio volumio[856]: info: Shairport-Sync Started
Apr 19 10:41:27 volumio mpd[1241]: Apr 19 10:41 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Apr 19 10:41:27 volumio volumio[856]: info: Updating MyVolumio device info
Apr 19 10:41:27 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 19 10:41:27 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 19 10:41:27 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 19 10:41:27 volumio systemd[1]: Started Music Player Daemon.
Apr 19 10:41:27 volumio sudo[1233]: pam_unix(sudo:session): session closed for user root
Apr 19 10:41:27 volumio volumio[856]: info: Successfully Added MyVolumio device
Apr 19 10:41:27 volumio volumio[856]: info: Updating MyVolumio device info
Apr 19 10:41:27 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 19 10:41:27 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 19 10:41:27 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 19 10:41:27 volumio volumio[856]: error: updateQueue error: null
Apr 19 10:41:27 volumio volumio[856]: info: Successfully Added MyVolumio device
Apr 19 10:41:27 volumio volumio[856]: info: Successfully Updated MyVolumio device
Apr 19 10:41:28 volumio volumio[856]: info: Successfully Updated MyVolumio device
Apr 19 10:41:28 volumio volumio[856]: info: Access Token successfully retrieved
Apr 19 10:41:28 volumio kernel: usb usb2-port1: over-current change #1
Apr 19 10:41:28 volumio kernel: usb 2-1: USB disconnect, device number 2
Apr 19 10:41:28 volumio kernel: device offline error, dev sda, sector 0 op 0x1:(WRITE) flags 0x800 phys_seg 0 prio class 2
Apr 19 10:41:28 volumio kernel: device offline error, dev sda, sector 0 op 0x1:(WRITE) flags 0x800 phys_seg 0 prio class 2
Apr 19 10:41:28 volumio volumio[856]: info: Partition removed: {"syspath":"/sys/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-1/2-1:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","ACTION":"remove","DEVLINKS":"/dev/disk/by-id/usb-WDC_WD20_PURX-78P6ZY0_00000000000000000000-0:0-part1 /dev/disk/by-label/NAS-DISK1 /dev/disk/by-partuuid/125036c9-ad37-4263-b015-aeafcd91c2a8 /dev/disk/by-partlabel/primary /dev/disk/by-path/platform-fd500000.pcie-pci-0000:01:00.0-usb-0:1:1.0-scsi-0:0:0:0-part1 /dev/disk/by-uuid/04490adb-fbe6-4546-ab2e-3490bb3ec860","DEVNAME":"/dev/sda1","DEVPATH":"/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-1/2-1:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","DEVTYPE":"partition","DISKSEQ":"26","ID_BUS":"usb","ID_FS_LABEL":"NAS-DISK1","ID_FS_LABEL_ENC":"NAS-DISK1","ID_FS_TYPE":"ext4","ID_FS_USAGE":"filesystem","ID_FS_UUID":"04490adb-fbe6-4546-ab2e-3490bb3ec860","ID_FS_UUID_ENC":"04490adb-fbe6-4546-ab2e-3490bb3ec860","ID_FS_VERSION":"1.0","ID_INSTANCE":"0:0","ID_MODEL":"PURX-78P6ZY0","ID_MODEL_ENC":"PURX-78P6ZY0\\x20\\x20\\x20\\x20","ID_MODEL_ID":"9561","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_NAME":"primary","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"2048","ID_PART_ENTRY_SCHEME":"gpt","ID_PART_ENTRY_SIZE":"3886055425","ID_PART_ENTRY_TYPE":"0fc63daf-8483-4772-8e79-3d69d8477de4","ID_PART_ENTRY_UUID":"125036c9-ad37-4263-b015-aeafcd91c2a8","ID_PART_TABLE_TYPE":"gpt","ID_PART_TABLE_UUID":"41657b78-1edb-47dc-99e7-a2def84d404b","ID_PATH":"platform-fd500000.pcie-pci-0000:01:00.0-usb-0:1:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-fd500000_pcie-pci-0000_01_00_0-usb-0_1_1_0-scsi-0_0_0_0","ID_REVISION":"0105","ID_SERIAL":"WDC_WD20_PURX-78P6ZY0_00000000000000000000-0:0","ID_SERIAL_SHORT":"00000000000000000000","ID_TYPE":"disk","ID_USB_DRIVER":"uas","ID_USB_INTERFACES":":080650:080662:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"WDC_WD20","ID_VENDOR_ENC":"WDC\\x20WD20","ID_VENDOR_ID":"152d","MAJOR":"8","MINOR":"1","PARTN":"1","PARTNAME":"primary","SEQNUM":"1833","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"13728769"}
Apr 19 10:41:28 volumio sudo[1384]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sda1
Apr 19 10:41:28 volumio sudo[1384]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 19 10:41:28 volumio systemd[1]: media-NAS\x2dDISK1.mount: Succeeded.
Apr 19 10:41:28 volumio kernel: EXT4-fs (sda1): unmounting filesystem.
Apr 19 10:41:28 volumio sudo[1384]: pam_unix(sudo:session): session closed for user root
Apr 19 10:41:28 volumio volumio[856]: info: Partition removed: {"syspath":"/sys/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-1/2-1:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda2","ACTION":"remove","DEVLINKS":"/dev/disk/by-partuuid/d4cbb0ab-0f80-4600-9c79-e63d258addd9 /dev/disk/by-label/NAS-eDISK1 /dev/disk/by-uuid/c04124e0-f987-44e7-b06e-f85513ec7a56 /dev/disk/by-partlabel/primary /dev/disk/by-path/platform-fd500000.pcie-pci-0000:01:00.0-usb-0:1:1.0-scsi-0:0:0:0-part2 /dev/disk/by-id/usb-WDC_WD20_PURX-78P6ZY0_00000000000000000000-0:0-part2","DEVNAME":"/dev/sda2","DEVPATH":"/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-1/2-1:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda2","DEVTYPE":"partition","DISKSEQ":"26","ID_BUS":"usb","ID_FS_LABEL":"NAS-eDISK1","ID_FS_LABEL_ENC":"NAS-eDISK1","ID_FS_TYPE":"ext4","ID_FS_USAGE":"filesystem","ID_FS_UUID":"c04124e0-f987-44e7-b06e-f85513ec7a56","ID_FS_UUID_ENC":"c04124e0-f987-44e7-b06e-f85513ec7a56","ID_FS_VERSION":"1.0","ID_INSTANCE":"0:0","ID_MODEL":"PURX-78P6ZY0","ID_MODEL_ENC":"PURX-78P6ZY0\\x20\\x20\\x20\\x20","ID_MODEL_ID":"9561","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_NAME":"primary","ID_PART_ENTRY_NUMBER":"2","ID_PART_ENTRY_OFFSET":"3886059520","ID_PART_ENTRY_SCHEME":"gpt","ID_PART_ENTRY_SIZE":"20969472","ID_PART_ENTRY_TYPE":"0fc63daf-8483-4772-8e79-3d69d8477de4","ID_PART_ENTRY_UUID":"d4cbb0ab-0f80-4600-9c79-e63d258addd9","ID_PART_TABLE_TYPE":"gpt","ID_PART_TABLE_UUID":"41657b78-1edb-47dc-99e7-a2def84d404b","ID_PATH":"platform-fd500000.pcie-pci-0000:01:00.0-usb-0:1:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-fd500000_pcie-pci-0000_01_00_0-usb-0_1_1_0-scsi-0_0_0_0","ID_REVISION":"0105","ID_SERIAL":"WDC_WD20_PURX-78P6ZY0_00000000000000000000-0:0","ID_SERIAL_SHORT":"00000000000000000000","ID_TYPE":"disk","ID_USB_DRIVER":"uas","ID_USB_INTERFACES":":080650:080662:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"WDC_WD20","ID_VENDOR_ENC":"WDC\\x20WD20","ID_VENDOR_ID":"152d","MAJOR":"8","MINOR":"2","PARTN":"2","PARTNAME":"primary","SEQNUM":"1834","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"13711873"}
Apr 19 10:41:28 volumio kernel: usb 1-1-port1: over-current change #1
Apr 19 10:41:28 volumio sudo[1387]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sda2
Apr 19 10:41:28 volumio sudo[1387]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 19 10:41:28 volumio kernel: sd 0:0:0:0: [sda] Synchronizing SCSI cache
Apr 19 10:41:28 volumio systemd[1]: media-NAS\x2deDISK1.mount: Succeeded.
Apr 19 10:41:28 volumio sudo[1387]: pam_unix(sudo:session): session closed for user root
Apr 19 10:41:28 volumio kernel: EXT4-fs (sda2): unmounting filesystem.
Apr 19 10:41:29 volumio kernel: usb 1-1-port2: over-current change #1
Apr 19 10:41:29 volumio sudo[1394]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service
Apr 19 10:41:29 volumio sudo[1394]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 19 10:41:29 volumio systemd[1]: Started MyVolumio SSH Tunnel.
Apr 19 10:41:29 volumio sudo[1394]: pam_unix(sudo:session): session closed for user root
Apr 19 10:41:29 volumio volumio[856]: info: Remote SSH Started
Apr 19 10:41:29 volumio autossh[1397]: port set to 0, monitoring disabled
Apr 19 10:41:29 volumio autossh[1397]: starting ssh (count 1)
Apr 19 10:41:29 volumio autossh[1397]: ssh child pid is 1400
Apr 19 10:41:29 volumio volumio[856]: info: Successfully retrieved User Session From TIDAL
Apr 19 10:41:29 volumio volumio[856]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 7
Apr 19 10:41:29 volumio volumio[856]: info: CoreCommandRouter::volumioGetState
Apr 19 10:41:29 volumio volumio[856]: info: CorePlayQueue::getTrack 0
Apr 19 10:41:29 volumio kernel: sd 0:0:0:0: [sda] Synchronize Cache(10) failed: Result: hostbyte=0x07 driverbyte=DRIVER_OK
Apr 19 10:41:29 volumio volumio[856]: info: Partition removed: {"syspath":"/sys/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-1/2-1:1.0/host0/target0:0:0/0:0:0:1/block/sdb/sdb1","ACTION":"remove","DEVLINKS":"/dev/disk/by-partuuid/d4069d1a-01 /dev/disk/by-id/usb-WDC_WD10_EACS-00D6B1_00000000000000000000-0:1-part1 /dev/disk/by-label/新加卷 /dev/disk/by-uuid/C01CA3381CA327FC /dev/disk/by-path/platform-fd500000.pcie-pci-0000:01:00.0-usb-0:1:1.0-scsi-0:0:0:1-part1","DEVNAME":"/dev/sdb1","DEVPATH":"/devices/platform/scb/fd500000.pcie/pci0000:00/0000:00:00.0/0000:01:00.0/usb2/2-1/2-1:1.0/host0/target0:0:0/0:0:0:1/block/sdb/sdb1","DEVTYPE":"partition","DISKSEQ":"27","ID_BUS":"usb","ID_FS_LABEL":"新加卷","ID_FS_LABEL_ENC":"新加卷","ID_FS_TYPE":"ntfs","ID_FS_USAGE":"filesystem","ID_FS_UUID":"C01CA3381CA327FC","ID_FS_UUID_ENC":"C01CA3381CA327FC","ID_INSTANCE":"0:1","ID_MODEL":"EACS-00D6B1","ID_MODEL_ENC":"EACS-00D6B1\\x20\\x20\\x20\\x20\\x20","ID_MODEL_ID":"9561","ID_PART_ENTRY_DISK":"8:16","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"2048","ID_PART_ENTRY_SCHEME":"dos","ID_PART_ENTRY_SIZE":"1953519616","ID_PART_ENTRY_TYPE":"0x7","ID_PART_ENTRY_UUID":"d4069d1a-01","ID_PART_TABLE_TYPE":"atari","ID_PART_TABLE_UUID":"d4069d1a","ID_PATH":"platform-fd500000.pcie-pci-0000:01:00.0-usb-0:1:1.0-scsi-0:0:0:1","ID_PATH_TAG":"platform-fd500000_pcie-pci-0000_01_00_0-usb-0_1_1_0-scsi-0_0_0_1","ID_REVISION":"0105","ID_SERIAL":"WDC_WD10_EACS-00D6B1_00000000000000000000-0:1","ID_SERIAL_SHORT":"00000000000000000000","ID_TYPE":"disk","ID_USB_DRIVER":"uas","ID_USB_INTERFACES":":080650:080662:","ID_USB_INTERFACE_NUM":"00","ID_VENDOR":"WDC_WD10","ID_VENDOR_ENC":"WDC\\x20WD10","ID_VENDOR_ID":"152d","MAJOR":"8","MINOR":"17","PARTN":"1","SEQNUM":"1845","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"13717638"}
Apr 19 10:41:29 volumio sudo[1402]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sdb1
Apr 19 10:41:29 volumio sudo[1402]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 19 10:41:29 volumio sudo[1402]: pam_unix(sudo:session): session closed for user root
Apr 19 10:41:29 volumio volumio[856]: umount: /dev/sdb1: no mount point specified.
Apr 19 10:41:29 volumio volumio[856]: error: Failed to umount 新加卷: Error: Command failed: /usr/bin/sudo /bin/umount -f "/dev/sdb1"
Apr 19 10:41:29 volumio volumio[856]: umount: /dev/sdb1: no mount point specified.
Apr 19 10:41:29 volumio kernel: sd 0:0:0:1: [sdb] Synchronizing SCSI cache
Apr 19 10:41:29 volumio kernel: usb 1-1.3: reset high-speed USB device number 4 using xhci_hcd
Apr 19 10:41:29 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 19 10:41:29 volumio kernel: usb 1-1-port3: over-current change #1
Apr 19 10:41:29 volumio kernel: sr 1:0:0:0: Power-on or device reset occurred
Apr 19 10:41:29 volumio volumio[856]: info: CoreCommandRouter::volumioGetState
Apr 19 10:41:29 volumio volumio[856]: info: CorePlayQueue::getTrack 0
Apr 19 10:41:29 volumio volumio[856]: info: Clearing queue from CD entries
Apr 19 10:41:29 volumio volumio[856]: info: CoreCommandRouter::volumioPushQueue
Apr 19 10:41:29 volumio volumio[856]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesAudio CD
Apr 19 10:41:29 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 19 10:41:29 volumio volumio[856]: info: Successfully retrieved User Subscription From TIDAL
Apr 19 10:41:29 volumio volumio[856]: info: Adding TIDAL to Browse Sources
Apr 19 10:41:29 volumio volumio[856]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 19 10:41:29 volumio volumio[856]: info: [1713523289991] CoreMusicLibrary::Adding element TIDAL
Apr 19 10:41:29 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 19 10:41:29 volumio volumio[856]: Cannot find translation for source TIDAL
Apr 19 10:41:29 volumio volumio[856]: info: Stopping AccessToken refresher cron
Apr 19 10:41:30 volumio volumio[856]: info: AccessToken refresher cron started
Apr 19 10:41:30 volumio volumio[856]: info: Adding TIDAL REST API Endpoints
Apr 19 10:41:30 volumio volumio[856]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal
Apr 19 10:41:30 volumio kernel: usb 1-1-port4: over-current change #1
Apr 19 10:41:30 volumio volumiossh-tunnel[1396]: Warning: Permanently added '[us2.myvolumio.org]:2222,[137.184.235.84]:2222' (RSA) to the list of known hosts.
Apr 19 10:41:30 volumio kernel: sd 0:0:0:1: [sdb] Synchronize Cache(10) failed: Result: hostbyte=0x07 driverbyte=DRIVER_OK
Apr 19 10:41:30 volumio kernel: usb usb2-port2: over-current change #1
Apr 19 10:41:30 volumio kernel: usb 1-1.1: new high-speed USB device number 6 using xhci_hcd
Apr 19 10:41:30 volumio kernel: usb usb2-port3: over-current change #1
Apr 19 10:41:31 volumio kernel: usb usb2-port4: over-current change #1
Apr 19 10:41:31 volumio kernel: usb usb2-port1: over-current change #2
Apr 19 10:41:31 volumio volumio[856]: info: Error on Writing CDDB entry: Error: Command failed: /usr/bin/abcde -N -a cddb -c /etc/abcdecddb.conf -d /dev/sr0
Apr 19 10:41:31 volumio volumio[856]: [WARNING] something went wrong while querying the CD... Maybe a DATA CD or the CD is not loaded?
Apr 19 10:41:31 volumio volumio[856]: [WARNING] Error trying to calculate disc ids without lead-out information.
Apr 19 10:41:31 volumio kernel: usb 2-1: new SuperSpeed USB device number 3 using xhci_hcd
Apr 19 10:41:31 volumio kernel: usb 2-1: New USB device found, idVendor=152d, idProduct=9561, bcdDevice= 1.05
Apr 19 10:41:31 volumio kernel: usb 2-1: New USB device strings: Mfr=1, Product=2, SerialNumber=5
Apr 19 10:41:31 volumio kernel: usb 2-1: Product: JMS56x Series
Apr 19 10:41:31 volumio kernel: usb 2-1: Manufacturer: JMicron
Apr 19 10:41:31 volumio kernel: usb 2-1: SerialNumber: 00000000000000000000
Apr 19 10:41:31 volumio kernel: scsi host0: uas
Apr 19 10:41:31 volumio kernel: scsi 0:0:0:0: Direct-Access WDC WD20 PURX-78P6ZY0 0105 PQ: 0 ANSI: 6
Apr 19 10:41:31 volumio kernel: scsi 0:0:0:0: Attached scsi generic sg0 type 0
Apr 19 10:41:31 volumio kernel: scsi 0:0:0:1: Direct-Access WDC WD10 EACS-00D6B1 0105 PQ: 0 ANSI: 6
Apr 19 10:41:31 volumio kernel: sd 0:0:0:0: [sda] 3907029168 512-byte logical blocks: (2.00 TB/1.82 TiB)
Apr 19 10:41:31 volumio kernel: sd 0:0:0:0: [sda] Write Protect is off
Apr 19 10:41:31 volumio kernel: sd 0:0:0:0: [sda] Mode Sense: 67 00 10 08
Apr 19 10:41:31 volumio kernel: sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, supports DPO and FUA
Apr 19 10:41:31 volumio kernel: sd 0:0:0:0: [sda] Preferred minimum I/O size 4096 bytes
Apr 19 10:41:31 volumio kernel: sd 0:0:0:0: [sda] Optimal transfer size 33553920 bytes not a multiple of preferred minimum block size (4096 bytes)
Apr 19 10:41:31 volumio kernel: sd 0:0:0:1: Attached scsi generic sg1 type 0
Apr 19 10:41:31 volumio kernel: sd 0:0:0:1: [sdb] 1953525168 512-byte logical blocks: (1.00 TB/932 GiB)
Apr 19 10:41:31 volumio kernel: sd 0:0:0:1: [sdb] Write Protect is off
Apr 19 10:41:31 volumio kernel: sd 0:0:0:1: [sdb] Mode Sense: 67 00 10 08
Apr 19 10:41:31 volumio kernel: sd 0:0:0:1: [sdb] Write cache: enabled, read cache: enabled, supports DPO and FUA
Apr 19 10:41:31 volumio kernel: sda: sda1 sda2
Apr 19 10:41:31 volumio kernel: sd 0:0:0:1: [sdb] Preferred minimum I/O size 4096 bytes
Apr 19 10:41:31 volumio kernel: sd 0:0:0:1: [sdb] Optimal transfer size 33553920 bytes not a multiple of preferred minimum block size (4096 bytes)
Apr 19 10:41:31 volumio kernel: sd 0:0:0:0: [sda] Attached SCSI disk
Apr 19 10:41:32 volumio kernel: sdb: sdb1
Apr 19 10:41:32 volumio kernel: sd 0:0:0:1: [sdb] Attached SCSI disk
Apr 19 10:41:32 volumio volumio[856]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/NAS-DISK1
Apr 19 10:41:32 volumio volumio[856]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/NAS-eDISK1
Apr 19 10:41:33 volumio volumio[856]: info: Mounting Device 新加卷
Apr 19 10:41:33 volumio sudo[1540]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdb1 /mnt/USB/新加卷 -o noatime,dmask=0000,fmask=0000,iocharset=utf8
Apr 19 10:41:33 volumio sudo[1540]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 19 10:41:33 volumio sudo[1540]: pam_unix(sudo:session): session closed for user root
Apr 19 10:41:33 volumio volumio[856]: $MFTMirr does not match $MFT (record 3).
Apr 19 10:41:33 volumio volumio[856]: Failed to mount '/dev/sdb1': Input/output error
Apr 19 10:41:33 volumio volumio[856]: NTFS is either inconsistent, or there is a hardware fault, or it's a
Apr 19 10:41:33 volumio volumio[856]: SoftRAID/FakeRAID hardware. In the first case run chkdsk /f on Windows
Apr 19 10:41:33 volumio volumio[856]: then reboot into Windows twice. The usage of the /f parameter is very
Apr 19 10:41:33 volumio volumio[856]: important! If the device is a SoftRAID/FakeRAID then first activate
Apr 19 10:41:33 volumio volumio[856]: it and mount a different device under the /dev/mapper/ directory, (e.g.
Apr 19 10:41:33 volumio volumio[856]: /dev/mapper/nvidia_eahaabcc1). Please see the 'dmraid' documentation
Apr 19 10:41:33 volumio volumio[856]: for more details.
Apr 19 10:41:33 volumio volumio[856]: error: Failed to mount 新加卷: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sdb1" "/mnt/USB/新加卷" -o noatime,dmask=0000,fmask=0000,iocharset=utf8
Apr 19 10:41:33 volumio volumio[856]: $MFTMirr does not match $MFT (record 3).
Apr 19 10:41:33 volumio volumio[856]: Failed to mount '/dev/sdb1': Input/output error
Apr 19 10:41:33 volumio volumio[856]: NTFS is either inconsistent, or there is a hardware fault, or it's a
Apr 19 10:41:33 volumio volumio[856]: SoftRAID/FakeRAID hardware. In the first case run chkdsk /f on Windows
Apr 19 10:41:33 volumio volumio[856]: then reboot into Windows twice. The usage of the /f parameter is very
Apr 19 10:41:33 volumio volumio[856]: important! If the device is a SoftRAID/FakeRAID then first activate
Apr 19 10:41:33 volumio volumio[856]: it and mount a different device under the /dev/mapper/ directory, (e.g.
Apr 19 10:41:33 volumio volumio[856]: /dev/mapper/nvidia_eahaabcc1). Please see the 'dmraid' documentation
Apr 19 10:41:33 volumio volumio[856]: for more details.
Apr 19 10:41:33 volumio volumio[856]: info: Mounting Device NAS-eDISK1
Apr 19 10:41:33 volumio sudo[1547]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda2 /mnt/USB/NAS-eDISK1 -o noatime
Apr 19 10:41:33 volumio sudo[1547]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 19 10:41:33 volumio sudo[1547]: pam_unix(sudo:session): session closed for user root
Apr 19 10:41:33 volumio kernel: EXT4-fs (sda2): recovery complete
Apr 19 10:41:33 volumio kernel: EXT4-fs (sda2): mounted filesystem with ordered data mode. Quota mode: none.
Apr 19 10:41:33 volumio volumio[856]: info: Mounting Device NAS-DISK1
Apr 19 10:41:33 volumio sudo[1556]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/NAS-DISK1 -o noatime
Apr 19 10:41:33 volumio sudo[1556]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 19 10:41:33 volumio kernel: EXT4-fs (sda1): recovery complete
Apr 19 10:41:33 volumio kernel: EXT4-fs (sda1): mounted filesystem with ordered data mode. Quota mode: none.
Apr 19 10:41:33 volumio sudo[1556]: pam_unix(sudo:session): session closed for user root
Apr 19 10:41:33 volumio volumio[856]: info: Preload queue cleared
Apr 19 10:41:33 volumio volumio[856]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 19 10:41:33 volumio volumio[856]: info: CoreStateMachine::ClearQueue
Apr 19 10:41:33 volumio volumio[856]: info: CoreStateMachine::stop
Apr 19 10:41:33 volumio volumio[856]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 19 10:41:33 volumio volumio[856]: info: CorePlayQueue::clearPlayQueue
Apr 19 10:41:33 volumio volumio[856]: info: CorePlayQueue::saveQueue
Apr 19 10:41:33 volumio volumio[856]: info: CoreCommandRouter::volumioPushQueue
Apr 19 10:41:33 volumio volumio[856]: info: CoreStateMachine::addQueueItems
Apr 19 10:41:33 volumio volumio[856]: info: CorePlayQueue::addQueueItems
Apr 19 10:41:33 volumio volumio[856]: info: Preload queue cleared
Apr 19 10:41:33 volumio volumio[856]: info: Adding Item to queue: music-library/USB/NAS-DISK1/音乐/中国民乐系列/WAV格式/马久越-聆听中国2CD精灵2019民乐WAV
Apr 19 10:41:33 volumio volumio[856]: info: Exploding uri music-library/USB/NAS-DISK1/音乐/中国民乐系列/WAV格式/马久越-聆听中国2CD精灵2019民乐WAV in service mpd
Apr 19 10:41:34 volumio kernel: usb 1-1.2: USB disconnect, device number 3
Apr 19 10:41:34 volumio kernel: usb 1-1.2.2: USB disconnect, device number 5
Apr 19 10:41:34 volumio kernel: usb 1-1.2: new high-speed USB device number 7 using xhci_hcd
Apr 19 10:41:34 volumio kernel: usb 1-1.2: New USB device found, idVendor=1a40, idProduct=0101, bcdDevice= 1.11
Apr 19 10:41:34 volumio kernel: usb 1-1.2: New USB device strings: Mfr=0, Product=1, SerialNumber=0
Apr 19 10:41:34 volumio kernel: usb 1-1.2: Product: USB 2.0 Hub
Apr 19 10:41:34 volumio kernel: hub 1-1.2:1.0: USB hub found
Apr 19 10:41:34 volumio kernel: hub 1-1.2:1.0: 4 ports detected
Apr 19 10:41:35 volumio kernel: usb 1-1.2.2: new high-speed USB device number 8 using xhci_hcd
Apr 19 10:41:35 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Apr 19 10:41:35 volumio kernel: usb 1-1.2.2: New USB device found, idVendor=152a, idProduct=8750, bcdDevice= 1.06
Apr 19 10:41:35 volumio kernel: usb 1-1.2.2: New USB device strings: Mfr=1, Product=3, SerialNumber=2
Apr 19 10:41:35 volumio kernel: usb 1-1.2.2: Product: E50
Apr 19 10:41:35 volumio kernel: usb 1-1.2.2: Manufacturer: Topping
Apr 19 10:41:35 volumio kernel: usb 1-1.2.2: 1:3 : unsupported format bits 0x100000000
Apr 19 10:41:35 volumio volumio[856]: info: Scanning new location : "USB/NAS-DISK1"
Apr 19 10:41:35 volumio kernel: hid-generic 0003:152A:8750.0002: hiddev96,hidraw0: USB HID v1.10 Device [Topping E50] on usb-0000:01:00.0-1.2.2/input3
Apr 19 10:41:35 volumio volumio[856]: info: ALBUMART /albumart?cacheid=58&web=/%E8%81%86%E5%90%AC%E4%B8%AD%E5%9B%BD%C2%B7%E7%B2%BE%E7%81%B5%20CD1/extralarge&path=%2Fmnt%2FUSB%2FNAS-DISK1%2F%E9%9F%B3%E4%B9%90%2F%E4%B8%AD%E5%9B%BD%E6%B0%91%E4%B9%90%E7%B3%BB%E5%88%97%2FWAV%E6%A0%BC%E5%BC%8F%2F%E9%A9%AC%E4%B9%85%E8%B6%8A-%E8%81%86%E5%90%AC%E4%B8%AD%E5%9B%BD2CD%E7%B2%BE%E7%81%B52019%E6%B0%91%E4%B9%90WAV%2F%E9%A9%AC%E4%B9%85%E8%B6%8A-%E8%81%86%E5%90%AC%E4%B8%AD%E5%9B%BD2019%E7%B2%BE%E7%81%B5CD1WAV%2F%E9%A9%AC%E4%B9%85%E8%B6%8A%20-%20%E8%81%86%E5%90%AC%E4%B8%AD%E5%9B%BD%C2%B7%E7%B2%BE%E7%81%B5%20CD1.cue&metadata=false
Apr 19 10:41:35 volumio volumio[856]: info: URI /mnt/USB/NAS-DISK1/音乐/中国民乐系列/WAV格式/马久越-聆听中国2CD精灵2019民乐WAV/马久越-聆听中国2019精灵CD1WAV/马久越 - 聆听中国·精灵 CD1.cue
Apr 19 10:41:35 volumio volumio[856]: info: ALBUMART /albumart?cacheid=58&web=/%E8%81%86%E5%90%AC%E4%B8%AD%E5%9B%BD%C2%B7%E7%B2%BE%E7%81%B5%20CD1/extralarge&path=%2Fmnt%2FUSB%2FNAS-DISK1%2F%E9%9F%B3%E4%B9%90%2F%E4%B8%AD%E5%9B%BD%E6%B0%91%E4%B9%90%E7%B3%BB%E5%88%97%2FWAV%E6%A0%BC%E5%BC%8F%2F%E9%A9%AC%E4%B9%85%E8%B6%8A-%E8%81%86%E5%90%AC%E4%B8%AD%E5%9B%BD2CD%E7%B2%BE%E7%81%B52019%E6%B0%91%E4%B9%90WAV%2F%E9%A9%AC%E4%B9%85%E8%B6%8A-%E8%81%86%E5%90%AC%E4%B8%AD%E5%9B%BD2019%E7%B2%BE%E7%81%B5CD1WAV%2F%E9%A9%AC%E4%B9%85%E8%B6%8A%20-%20%E8%81%86%E5%90%AC%E4%B8%AD%E5%9B%BD%C2%B7%E7%B2%BE%E7%81%B5%20CD1.cue&metadata=false
Apr 19 10:41:35 volumio volumio[856]: info: URI /mnt/USB/NAS-DISK1/音乐/中国民乐系列/WAV格式/马久越-聆听中国2CD精灵2019民乐WAV/马久越-聆听中国2019精灵CD1WAV/马久越 - 聆听中国·精灵 CD1.cue
Apr 19 10:41:35 volumio volumio[856]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 19 10:41:35 volumio volumio[856]: Error: Unable to resolve or reject the same promise twice
Apr 19 10:41:35 volumio volumio[856]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43)
Apr 19 10:41:35 volumio volumio[856]: at /volumio/app/plugins/music_service/mpd/index.js:2568:21
Apr 19 10:41:35 volumio volumio[856]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3)
Apr 19 10:41:35 volumio volumio[856]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12)
Apr 19 10:41:35 volumio volumio[856]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12)
Apr 19 10:41:35 volumio volumio[856]: at Socket.emit (events.js:315:20)
Apr 19 10:41:35 volumio volumio[856]: at addChunk (internal/streams/readable.js:309:12)
Apr 19 10:41:35 volumio volumio[856]: at readableAddChunk (internal/streams/readable.js:280:11)
Apr 19 10:41:35 volumio volumio[856]: at Socket.Readable.push (internal/streams/readable.js:223:10)
Apr 19 10:41:35 volumio volumio[856]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23)
Apr 19 10:41:35 volumio volumio[856]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 19 10:41:35 volumio sudo[1576]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-19 10:40
Apr 19 10:41:35 volumio sudo[1576]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET"
VOLUMIO_VERSION="3.631"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"