-- Logs begin at Wed 2020-03-18 00:32:44 UTC, end at Sun 2024-04-14 08:18:58 UTC. -- Apr 14 08:17:02 volumio kernel: Voltage normalised (0x00000000) Apr 14 08:17:04 volumio volumio[1052]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.729&uuid=85fddd28b3d9ebed986b84a41c666215" http://updates.volumio.org:7070/downloader-v1/track-device Apr 14 08:17:04 volumio volumio[1052]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 14 08:17:04 volumio volumio[1052]: Dload Upload Total Spent Left Speed Apr 14 08:17:04 volumio volumio[1052]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Apr 14 08:17:04 volumio volumio[1052]: retrying in 5 seconds, trial 2 Apr 14 08:17:04 volumio volumio[1052]: Volumio Calling Home Apr 14 08:17:18 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Apr 14 08:17:18 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 14 08:17:18 volumio volumio[1052]: info: Disabling I2S DAC: Apr 14 08:17:18 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , disableI2SDAC Apr 14 08:17:18 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 14 08:17:18 volumio volumio[1052]: info: Output device has changed, restarting MPD Apr 14 08:17:18 volumio volumio[1052]: info: Output device has changed, restarting Shairport Sync Apr 14 08:17:18 volumio sudo[1799]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 14 08:17:18 volumio sudo[1799]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 08:17:18 volumio sudo[1801]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 14 08:17:18 volumio sudo[1799]: pam_unix(sudo:session): session closed for user root Apr 14 08:17:18 volumio sudo[1801]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 08:17:18 volumio systemd[1]: Stopping Music Player Daemon... Apr 14 08:17:18 volumio volumio[1052]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 14 08:17:19 volumio systemd[1]: Starting Music Player Daemon... Apr 14 08:17:19 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 14 08:17:19 volumio volumio[1052]: info: Found match in Cards Database: setting mixer PCM for card Audio Jack Apr 14 08:17:19 volumio volumio[1052]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 14 08:17:19 volumio volumio[1052]: info: Updating Volume Controller Parameters: Device: 0 Name: Audio Jack Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 Apr 14 08:17:19 volumio volumio[1052]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 14 08:17:19 volumio volumio[1052]: error: Upnp client error: Error: This socket has been ended by the other party Apr 14 08:17:19 volumio volumio[1052]: info: MPD Permissions set Apr 14 08:17:19 volumio volumio[1052]: error: Raspberry PI Jack Output Enabled Apr 14 08:17:19 volumio sudo[1824]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/alsactl store Apr 14 08:17:19 volumio sudo[1824]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 08:17:19 volumio sudo[1831]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Apr 14 08:17:19 volumio sudo[1831]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 08:17:19 volumio sudo[1824]: pam_unix(sudo:session): session closed for user root Apr 14 08:17:19 volumio sudo[1831]: pam_unix(sudo:session): session closed for user root Apr 14 08:17:19 volumio volumio[1052]: info: No Overlays Loaded Apr 14 08:17:19 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 08:17:19 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 08:17:19 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 08:17:19 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 08:17:19 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 08:17:19 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 08:17:19 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 08:17:19 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 14 08:17:19 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 14 08:17:19 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 14 08:17:19 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 14 08:17:19 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 08:17:19 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 08:17:19 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 08:17:19 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 08:17:19 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 08:17:19 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 08:17:19 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 08:17:19 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 08:17:19 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 14 08:17:19 volumio volumio[1052]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 14 08:17:19 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: system , getExperienceAdvancedSettings Apr 14 08:17:19 volumio volumio[1052]: error: Alsa Settings successfully stored Apr 14 08:17:19 volumio volumio[1052]: info: VolumeController:: Volume=40 Mute =false Apr 14 08:17:19 volumio volumio[1052]: info: CoreStateMachine::pushState Apr 14 08:17:19 volumio volumio[1052]: info: CoreStateMachine::getState Apr 14 08:17:19 volumio volumio[1052]: info: CorePlayQueue::getTrack 0 Apr 14 08:17:19 volumio volumio[1052]: info: CoreCommandRouter::volumioPushState Apr 14 08:17:19 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 08:17:19 volumio volumio[1052]: info: Starting Shairport Sync Apr 14 08:17:19 volumio sudo[1851]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 14 08:17:19 volumio sudo[1851]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 08:17:19 volumio sudo[1851]: pam_unix(sudo:session): session closed for user root Apr 14 08:17:19 volumio sudo[1855]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 14 08:17:19 volumio sudo[1855]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 08:17:19 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 14 08:17:19 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Apr 14 08:17:19 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 14 08:17:19 volumio sudo[1855]: pam_unix(sudo:session): session closed for user root Apr 14 08:17:19 volumio volumio[1052]: info: Shairport-Sync Started Apr 14 08:17:19 volumio systemd[1]: Started Music Player Daemon. Apr 14 08:17:19 volumio sudo[1801]: pam_unix(sudo:session): session closed for user root Apr 14 08:17:20 volumio volumio[1052]: info: Apr 14 08:17:21 volumio volumio[1052]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Apr 14 08:17:21 volumio volumio[1052]: info: CoreStateMachine::getcurrentVolume Apr 14 08:17:21 volumio volumio[1052]: info: CoreCommandRouter::volumioRetrievevolume Apr 14 08:17:21 volumio volumio[1052]: info: VolumeController:: Volume=40 Mute =false Apr 14 08:17:21 volumio volumio[1052]: info: CoreStateMachine::pushState Apr 14 08:17:21 volumio volumio[1052]: info: CoreStateMachine::getState Apr 14 08:17:21 volumio volumio[1052]: info: CorePlayQueue::getTrack 0 Apr 14 08:17:21 volumio volumio[1052]: info: CoreCommandRouter::volumioPushState Apr 14 08:17:21 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 08:17:21 volumio volumio[1052]: info: CoreStateMachine::updateTrackBlock Apr 14 08:17:21 volumio volumio[1052]: info: CorePlayQueue::getTrackBlock Apr 14 08:17:21 volumio volumio[1052]: info: CoreCommandRouter::volumioRetrievevolume Apr 14 08:17:21 volumio sudo[1889]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 14 08:17:21 volumio sudo[1889]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 08:17:21 volumio sudo[1889]: pam_unix(sudo:session): session closed for user root Apr 14 08:17:21 volumio volumio[1052]: info: VolumeController:: Volume=40 Mute =false Apr 14 08:17:21 volumio volumio[1052]: info: CoreStateMachine::pushState Apr 14 08:17:21 volumio volumio[1052]: info: CoreStateMachine::getState Apr 14 08:17:21 volumio volumio[1052]: info: CorePlayQueue::getTrack 0 Apr 14 08:17:21 volumio volumio[1052]: info: CoreCommandRouter::volumioPushState Apr 14 08:17:22 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 08:17:22 volumio sudo[1900]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 14 08:17:22 volumio sudo[1900]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 08:17:22 volumio sudo[1900]: pam_unix(sudo:session): session closed for user root Apr 14 08:17:22 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: system , setExperienceAdvancedSettings Apr 14 08:17:22 volumio volumio[1052]: info: Saving Experience Advanced Settings Apr 14 08:17:22 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Apr 14 08:17:22 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Apr 14 08:17:23 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Apr 14 08:17:23 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Apr 14 08:17:23 volumio sudo[1909]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 14 08:17:23 volumio sudo[1909]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 08:17:23 volumio sudo[1913]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 14 08:17:23 volumio sudo[1913]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 08:17:23 volumio sudo[1913]: pam_unix(sudo:session): session closed for user root Apr 14 08:17:23 volumio volumio[1052]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Apr 14 08:17:23 volumio volumio[1052]: wlan0 Interface doesn't support scanning : Device or resource busy Apr 14 08:17:23 volumio volumio[1052]: info: Cannot use regular scanning, forcing with ap-force Apr 14 08:17:23 volumio sudo[1924]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Apr 14 08:17:23 volumio sudo[1924]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 08:17:23 volumio sudo[1924]: pam_unix(sudo:session): session closed for user root Apr 14 08:17:23 volumio volumio[1052]: command failed: Device or resource busy (-16) Apr 14 08:17:23 volumio volumio[1052]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Apr 14 08:17:23 volumio volumio[1052]: command failed: Device or resource busy (-16) Apr 14 08:17:23 volumio sudo[1909]: pam_unix(sudo:session): session closed for user root Apr 14 08:17:24 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Apr 14 08:17:26 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Apr 14 08:17:55 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: networkfs , addShare Apr 14 08:17:55 volumio volumio[1052]: info: Adding a new share Apr 14 08:17:55 volumio volumio[1052]: info: No correspondence found in configuration for share NAS on IP 192.168.3.16 Apr 14 08:17:55 volumio sudo[1950]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto 192.168.3.16:/volume4/e-video/m /mnt/NAS/NAS Apr 14 08:17:55 volumio sudo[1950]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 08:17:55 volumio sudo[1950]: pam_unix(sudo:session): session closed for user root Apr 14 08:17:55 volumio volumio[1052]: info: ControllerMpd::sendMpdCommand status Apr 14 08:17:55 volumio volumio[1052]: info: Apr 14 08:17:55 volumio volumio[1052]: ---------------------------- MPD announces state update: update Apr 14 08:17:55 volumio volumio[1052]: info: sending command... Apr 14 08:17:55 volumio volumio[1052]: info: ControllerMpd::getState Apr 14 08:17:55 volumio volumio[1052]: info: ControllerMpd::sendMpdCommand status Apr 14 08:17:55 volumio volumio[1052]: info: sending command... Apr 14 08:17:55 volumio volumio[1052]: info: parsing response... Apr 14 08:17:55 volumio volumio[1052]: info: parsing response... Apr 14 08:17:55 volumio volumio[1052]: info: ControllerMpd::parseState Apr 14 08:17:55 volumio volumio[1052]: info: Command Router : Notfying DB Updatetrue Apr 14 08:17:55 volumio volumio[1052]: info: ControllerMpd::parseState Apr 14 08:17:56 volumio volumio[1052]: info: ControllerMpd::pushState Apr 14 08:17:56 volumio volumio[1052]: info: CoreCommandRouter::servicePushState Apr 14 08:17:56 volumio volumio[1052]: info: CoreStateMachine::syncState Apr 14 08:17:56 volumio volumio[1052]: info: CoreStateMachine::pushState Apr 14 08:17:56 volumio volumio[1052]: info: CoreStateMachine::getState Apr 14 08:17:56 volumio volumio[1052]: info: CorePlayQueue::getTrack 0 Apr 14 08:17:56 volumio volumio[1052]: info: CoreCommandRouter::volumioPushState Apr 14 08:17:56 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 08:17:56 volumio volumio[1052]: info: CorePlayQueue::getTrack 0 Apr 14 08:17:56 volumio volumio[1052]: info: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 14 08:17:56 volumio volumio[1052]: info: CURRENT POSITION 0 Apr 14 08:17:56 volumio volumio[1052]: info: CoreStateMachine::syncState stateService stop Apr 14 08:17:56 volumio volumio[1052]: info: CoreStateMachine::syncState currentStatus stop Apr 14 08:17:56 volumio volumio[1052]: info: CoreStateMachine::pushState Apr 14 08:17:56 volumio volumio[1052]: info: CoreStateMachine::getState Apr 14 08:17:56 volumio volumio[1052]: info: CorePlayQueue::getTrack 0 Apr 14 08:17:56 volumio volumio[1052]: info: CoreCommandRouter::volumioPushState Apr 14 08:17:56 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 08:17:56 volumio sudo[1968]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 14 08:17:56 volumio sudo[1968]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 08:17:56 volumio volumio[1052]: info: No code Apr 14 08:17:56 volumio sudo[1968]: pam_unix(sudo:session): session closed for user root Apr 14 08:17:56 volumio volumio[1052]: info: CoreStateMachine::pushState Apr 14 08:17:56 volumio volumio[1052]: info: CoreStateMachine::getState Apr 14 08:17:56 volumio volumio[1052]: info: CorePlayQueue::getTrack 0 Apr 14 08:17:56 volumio volumio[1052]: info: CoreCommandRouter::volumioPushState Apr 14 08:17:56 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 08:17:56 volumio sudo[1973]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 14 08:17:56 volumio sudo[1973]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 08:17:56 volumio sudo[1973]: pam_unix(sudo:session): session closed for user root Apr 14 08:17:56 volumio sudo[1982]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 14 08:17:56 volumio volumio[1052]: info: ------------------------------ 286ms Apr 14 08:17:56 volumio sudo[1982]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 08:17:56 volumio volumio[1052]: info: [1713082676119] Database update started Apr 14 08:17:56 volumio sudo[1982]: pam_unix(sudo:session): session closed for user root Apr 14 08:17:56 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Apr 14 08:18:00 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonation Apr 14 08:18:00 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Apr 14 08:18:00 volumio volumio[1052]: info: Could not detect Volumio Device: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 14 08:18:00 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonationsArray Apr 14 08:18:00 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: wizard , getDoneMessage Apr 14 08:18:00 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Apr 14 08:18:00 volumio volumio[1052]: info: Could not detect Volumio Device: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 14 08:18:03 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction Apr 14 08:18:03 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: system , setShowWizard Apr 14 08:18:03 volumio volumio[1052]: info: Wizard terminated Successfully Apr 14 08:18:14 volumio volumio[1052]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 14 08:18:14 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 14 08:18:14 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 14 08:18:14 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 14 08:18:14 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 08:18:14 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 08:18:14 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 08:18:14 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 08:18:14 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 08:18:14 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 08:18:14 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 08:18:14 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 14 08:18:14 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 14 08:18:14 volumio volumio[1052]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 14 08:18:19 volumio volumio[1052]: info: CoreCommandRouter::volumioGetQueue Apr 14 08:18:19 volumio volumio[1052]: info: CoreStateMachine::getQueue Apr 14 08:18:19 volumio volumio[1052]: info: CorePlayQueue::getQueue Apr 14 08:18:21 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 14 08:18:21 volumio volumio[1052]: info: CURURI: artists:// Apr 14 08:18:22 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 14 08:18:22 volumio volumio[1052]: info: CURURI: music-library Apr 14 08:18:23 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 14 08:18:23 volumio volumio[1052]: info: CURURI: music-library/NAS Apr 14 08:18:24 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 14 08:18:24 volumio volumio[1052]: info: CURURI: music-library/NAS/NAS Apr 14 08:18:25 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 14 08:18:25 volumio volumio[1052]: info: CURURI: music-library/NAS/NAS/蔡琴 Apr 14 08:18:26 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 14 08:18:26 volumio volumio[1052]: info: CURURI: music-library/NAS/NAS/蔡琴/蔡琴 - 试音 蔡琴 2006 - flac 分轨 Apr 14 08:18:28 volumio volumio[1052]: info: CoreCommandRouter::volumioAddQueueItems Apr 14 08:18:28 volumio volumio[1052]: info: CoreStateMachine::addQueueItems Apr 14 08:18:28 volumio volumio[1052]: info: CorePlayQueue::addQueueItems Apr 14 08:18:28 volumio volumio[1052]: info: Adding Item to queue: music-library/NAS/NAS/蔡琴/蔡琴 - 试音 蔡琴 2006 - flac 分轨/01 渡口.flac Apr 14 08:18:28 volumio volumio[1052]: info: Exploding uri music-library/NAS/NAS/蔡琴/蔡琴 - 试音 蔡琴 2006 - flac 分轨/01 渡口.flac in service mpd Apr 14 08:18:28 volumio volumio[1052]: info: ALBUMART /albumart?cacheid=712&web=//extralarge&path=%2Fmnt%2FNAS%2FNAS%2F%E8%94%A1%E7%90%B4%2F%E8%94%A1%E7%90%B4%20-%20%E8%AF%95%E9%9F%B3%20%E8%94%A1%E7%90%B4%202006%20-%20flac%20%E5%88%86%E8%BD%A8%2F01%20%E6%B8%A1%E5%8F%A3.flac&metadata=false Apr 14 08:18:28 volumio volumio[1052]: info: URI /mnt/NAS/NAS/蔡琴/蔡琴 - 试音 蔡琴 2006 - flac 分轨/01 渡口.flac Apr 14 08:18:28 volumio volumio[1052]: info: CorePlayQueue::saveQueue Apr 14 08:18:28 volumio volumio[1052]: info: CoreCommandRouter::volumioPushQueue Apr 14 08:18:28 volumio volumio[1052]: info: CoreStateMachine::updateTrackBlock Apr 14 08:18:28 volumio volumio[1052]: info: CorePlayQueue::getTrackBlock Apr 14 08:18:28 volumio volumio[1052]: info: CoreCommandRouter::volumioPlay Apr 14 08:18:28 volumio volumio[1052]: UNSET VOLATILE Apr 14 08:18:28 volumio volumio[1052]: info: CoreStateMachine::play index 0 Apr 14 08:18:28 volumio volumio[1052]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 14 08:18:28 volumio volumio[1052]: info: CoreStateMachine::stop Apr 14 08:18:28 volumio volumio[1052]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 14 08:18:28 volumio volumio[1052]: UNSET VOLATILE Apr 14 08:18:28 volumio volumio[1052]: info: CoreStateMachine::play index undefined Apr 14 08:18:28 volumio volumio[1052]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 14 08:18:28 volumio volumio[1052]: info: CorePlayQueue::getTrack 0 Apr 14 08:18:28 volumio volumio[1052]: info: CoreStateMachine::startPlaybackTimer Apr 14 08:18:28 volumio volumio[1052]: info: CorePlayQueue::getTrack 0 Apr 14 08:18:28 volumio volumio[1052]: info: ControllerMpd::clearAddPlayTracks NAS/NAS/蔡琴/蔡琴 - 试音 蔡琴 2006 - flac 分轨/01 渡口.flac Apr 14 08:18:28 volumio volumio[1052]: info: ControllerMpd::sendMpdCommand stop Apr 14 08:18:28 volumio volumio[1052]: info: sending command... Apr 14 08:18:28 volumio volumio[1052]: info: parsing response... Apr 14 08:18:28 volumio volumio[1052]: info: ControllerMpd::sendMpdCommand clear Apr 14 08:18:28 volumio volumio[1052]: info: sending command... Apr 14 08:18:28 volumio volumio[1052]: info: Apr 14 08:18:28 volumio volumio[1052]: ---------------------------- MPD announces system playlist update Apr 14 08:18:28 volumio volumio[1052]: info: Ignoring MPD Status Update Apr 14 08:18:28 volumio volumio[1052]: info: parsing response... Apr 14 08:18:28 volumio volumio[1052]: info: ControllerMpd::sendMpdCommand add "NAS/NAS/蔡琴/蔡琴 - 试音 蔡琴 2006 - flac 分轨/01 渡口.flac" Apr 14 08:18:28 volumio volumio[1052]: info: sending command... Apr 14 08:18:28 volumio volumio[1052]: info: Apr 14 08:18:28 volumio volumio[1052]: info: Apr 14 08:18:28 volumio volumio[1052]: ---------------------------- MPD announces system playlist update Apr 14 08:18:28 volumio volumio[1052]: info: Ignoring MPD Status Update Apr 14 08:18:28 volumio volumio[1052]: info: ------------------------------ 12ms Apr 14 08:18:28 volumio volumio[1052]: info: parsing response... Apr 14 08:18:28 volumio volumio[1052]: info: ControllerMpd::sendMpdCommand play Apr 14 08:18:28 volumio volumio[1052]: info: sending command... Apr 14 08:18:28 volumio volumio[1052]: info: ------------------------------ 10ms Apr 14 08:18:28 volumio volumio[1052]: info: parsing response... Apr 14 08:18:28 volumio volumio[1052]: info: Apr 14 08:18:28 volumio volumio[1052]: ---------------------------- MPD announces state update: player Apr 14 08:18:28 volumio volumio[1052]: info: ControllerMpd::getState Apr 14 08:18:28 volumio volumio[1052]: info: ControllerMpd::sendMpdCommand status Apr 14 08:18:28 volumio volumio[1052]: info: sending command... Apr 14 08:18:28 volumio volumio[1052]: info: Apr 14 08:18:28 volumio volumio[1052]: ---------------------------- MPD announces state update: player Apr 14 08:18:28 volumio volumio[1052]: info: ControllerMpd::getState Apr 14 08:18:28 volumio volumio[1052]: info: ControllerMpd::sendMpdCommand status Apr 14 08:18:28 volumio volumio[1052]: info: parsing response... Apr 14 08:18:28 volumio volumio[1052]: info: sending command... Apr 14 08:18:28 volumio volumio[1052]: info: ControllerMpd::parseState Apr 14 08:18:28 volumio volumio[1052]: info: ControllerMpd::sendMpdCommand playlistinfo Apr 14 08:18:28 volumio volumio[1052]: info: sending command... Apr 14 08:18:28 volumio volumio[1052]: info: parsing response... Apr 14 08:18:28 volumio volumio[1052]: info: parsing response... Apr 14 08:18:28 volumio volumio[1052]: info: ControllerMpd::parseState Apr 14 08:18:28 volumio volumio[1052]: info: ControllerMpd::sendMpdCommand playlistinfo Apr 14 08:18:28 volumio volumio[1052]: info: ControllerMpd::parseTrackInfo Apr 14 08:18:28 volumio volumio[1052]: info: sending command... Apr 14 08:18:28 volumio volumio[1052]: info: ControllerMpd::pushState Apr 14 08:18:28 volumio volumio[1052]: info: CoreCommandRouter::servicePushState Apr 14 08:18:28 volumio volumio[1052]: info: CoreStateMachine::syncState Apr 14 08:18:28 volumio volumio[1052]: info: CorePlayQueue::getTrack 0 Apr 14 08:18:28 volumio volumio[1052]: info: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":227,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"566 Kbps","isStreaming":false,"title":"01 渡口.flac","artist":null,"album":null,"uri":"NAS/NAS/蔡琴/蔡琴 - 试音 蔡琴 2006 - flac 分轨/01 渡口.flac","trackType":"flac"} Apr 14 08:18:28 volumio volumio[1052]: info: CURRENT POSITION 0 Apr 14 08:18:28 volumio volumio[1052]: info: CoreStateMachine::syncState stateService play Apr 14 08:18:28 volumio volumio[1052]: info: CoreStateMachine::syncState currentStatus stop Apr 14 08:18:28 volumio volumio[1052]: info: CoreStateMachine::pushState Apr 14 08:18:28 volumio volumio[1052]: info: CoreStateMachine::getState Apr 14 08:18:28 volumio volumio[1052]: info: CorePlayQueue::getTrack 0 Apr 14 08:18:28 volumio volumio[1052]: info: CoreCommandRouter::volumioPushState Apr 14 08:18:28 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 08:18:28 volumio volumio[1052]: info: ------------------------------ 132ms Apr 14 08:18:28 volumio volumio[1052]: info: parsing response... Apr 14 08:18:28 volumio volumio[1052]: info: ControllerMpd::parseTrackInfo Apr 14 08:18:28 volumio volumio[1052]: info: ControllerMpd::pushState Apr 14 08:18:28 volumio volumio[1052]: info: CoreCommandRouter::servicePushState Apr 14 08:18:28 volumio volumio[1052]: info: CoreStateMachine::syncState Apr 14 08:18:28 volumio volumio[1052]: info: CorePlayQueue::getTrack 0 Apr 14 08:18:28 volumio sudo[2112]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 14 08:18:28 volumio volumio[1052]: info: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":227,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"566 Kbps","isStreaming":false,"title":"01 渡口.flac","artist":null,"album":null,"uri":"NAS/NAS/蔡琴/蔡琴 - 试音 蔡琴 2006 - flac 分轨/01 渡口.flac","trackType":"flac"} Apr 14 08:18:28 volumio volumio[1052]: info: CURRENT POSITION 0 Apr 14 08:18:28 volumio volumio[1052]: info: CoreStateMachine::syncState stateService play Apr 14 08:18:28 volumio volumio[1052]: info: CoreStateMachine::syncState currentStatus play Apr 14 08:18:28 volumio volumio[1052]: info: Received an update from plugin. extracting info from payload Apr 14 08:18:28 volumio volumio[1052]: info: CoreStateMachine::pushState Apr 14 08:18:28 volumio volumio[1052]: info: CoreStateMachine::getState Apr 14 08:18:28 volumio volumio[1052]: info: CorePlayQueue::getTrack 0 Apr 14 08:18:28 volumio volumio[1052]: info: CoreCommandRouter::volumioPushState Apr 14 08:18:28 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 08:18:28 volumio sudo[2112]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 08:18:28 volumio volumio[1052]: info: CoreStateMachine::pushState Apr 14 08:18:28 volumio sudo[2112]: pam_unix(sudo:session): session closed for user root Apr 14 08:18:28 volumio volumio[1052]: info: CoreStateMachine::getState Apr 14 08:18:28 volumio volumio[1052]: info: CorePlayQueue::getTrack 0 Apr 14 08:18:28 volumio volumio[1052]: info: CoreCommandRouter::volumioPushState Apr 14 08:18:28 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 08:18:28 volumio volumio[1052]: info: ------------------------------ 282ms Apr 14 08:18:28 volumio sudo[2123]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 14 08:18:28 volumio sudo[2117]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 14 08:18:28 volumio sudo[2117]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 08:18:28 volumio sudo[2117]: pam_unix(sudo:session): session closed for user root Apr 14 08:18:28 volumio sudo[2123]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 08:18:28 volumio sudo[2123]: pam_unix(sudo:session): session closed for user root Apr 14 08:18:35 volumio volumio[1052]: info: VolumeController::SetAlsaVolume56 Apr 14 08:18:35 volumio volumio[1052]: info: CoreStateMachine::pushState Apr 14 08:18:35 volumio volumio[1052]: info: CoreStateMachine::getState Apr 14 08:18:35 volumio volumio[1052]: info: CorePlayQueue::getTrack 0 Apr 14 08:18:35 volumio volumio[1052]: info: CoreCommandRouter::volumioPushState Apr 14 08:18:35 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 08:18:35 volumio sudo[2154]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 14 08:18:35 volumio sudo[2154]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 08:18:35 volumio sudo[2154]: pam_unix(sudo:session): session closed for user root Apr 14 08:18:35 volumio volumio[1052]: info: Apr 14 08:18:35 volumio volumio[1052]: ---------------------------- MPD announces state update: mixer Apr 14 08:18:35 volumio volumio[1052]: info: ControllerMpd::getState Apr 14 08:18:35 volumio volumio[1052]: info: ControllerMpd::sendMpdCommand status Apr 14 08:18:35 volumio volumio[1052]: info: sending command... Apr 14 08:18:35 volumio volumio[1052]: info: parsing response... Apr 14 08:18:35 volumio volumio[1052]: info: ControllerMpd::parseState Apr 14 08:18:35 volumio volumio[1052]: info: ControllerMpd::sendMpdCommand playlistinfo Apr 14 08:18:35 volumio volumio[1052]: info: sending command... Apr 14 08:18:35 volumio volumio[1052]: info: parsing response... Apr 14 08:18:35 volumio volumio[1052]: info: ControllerMpd::parseTrackInfo Apr 14 08:18:35 volumio volumio[1052]: info: ControllerMpd::pushState Apr 14 08:18:35 volumio volumio[1052]: info: CoreCommandRouter::servicePushState Apr 14 08:18:35 volumio volumio[1052]: info: CoreStateMachine::syncState Apr 14 08:18:35 volumio volumio[1052]: info: CorePlayQueue::getTrack 0 Apr 14 08:18:35 volumio volumio[1052]: info: STATE SERVICE {"status":"play","position":0,"seek":7337,"duration":227,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"936 Kbps","isStreaming":false,"title":"01 渡口.flac","artist":null,"album":null,"uri":"NAS/NAS/蔡琴/蔡琴 - 试音 蔡琴 2006 - flac 分轨/01 渡口.flac","trackType":"flac"} Apr 14 08:18:35 volumio volumio[1052]: info: CURRENT POSITION 0 Apr 14 08:18:35 volumio volumio[1052]: info: CoreStateMachine::syncState stateService play Apr 14 08:18:35 volumio volumio[1052]: info: CoreStateMachine::syncState currentStatus play Apr 14 08:18:35 volumio volumio[1052]: info: Received an update from plugin. extracting info from payload Apr 14 08:18:35 volumio volumio[1052]: info: CoreStateMachine::pushState Apr 14 08:18:35 volumio volumio[1052]: info: CoreStateMachine::getState Apr 14 08:18:35 volumio volumio[1052]: info: CorePlayQueue::getTrack 0 Apr 14 08:18:35 volumio volumio[1052]: info: CoreCommandRouter::volumioPushState Apr 14 08:18:35 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 08:18:35 volumio volumio[1052]: info: CoreStateMachine::pushState Apr 14 08:18:35 volumio volumio[1052]: info: CoreStateMachine::getState Apr 14 08:18:35 volumio volumio[1052]: info: CorePlayQueue::getTrack 0 Apr 14 08:18:35 volumio volumio[1052]: info: CoreCommandRouter::volumioPushState Apr 14 08:18:35 volumio volumio[1052]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 08:18:35 volumio sudo[2163]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 14 08:18:35 volumio sudo[2163]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 08:18:35 volumio sudo[2163]: pam_unix(sudo:session): session closed for user root Apr 14 08:18:35 volumio sudo[2168]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 14 08:18:35 volumio volumio[1052]: info: ------------------------------ 103ms Apr 14 08:18:35 volumio sudo[2168]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 08:18:35 volumio sudo[2168]: pam_unix(sudo:session): session closed for user root Apr 14 08:18:55 volumio volumio[1052]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 14 08:18:55 volumio volumio[1052]: { Error: connect ETIMEDOUT 198.27.124.186:80 Apr 14 08:18:55 volumio volumio[1052]: at Object._errnoException (util.js:1022:11) Apr 14 08:18:55 volumio volumio[1052]: at _exceptionWithHostPort (util.js:1044:20) Apr 14 08:18:55 volumio volumio[1052]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Apr 14 08:18:55 volumio volumio[1052]: code: 'ETIMEDOUT', Apr 14 08:18:55 volumio volumio[1052]: errno: 'ETIMEDOUT', Apr 14 08:18:55 volumio volumio[1052]: syscall: 'connect', Apr 14 08:18:55 volumio volumio[1052]: address: '198.27.124.186', Apr 14 08:18:55 volumio volumio[1052]: port: 80 } Apr 14 08:18:55 volumio volumio[1052]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 14 08:18:56 volumio login[917]: pam_lastlog(login:session): file /var/log/lastlog created Apr 14 08:18:56 volumio login[917]: pam_unix(login:session): session opened for user root by LOGIN(uid=0) Apr 14 08:18:56 volumio systemd-logind[770]: New session c1 of user root. Apr 14 08:18:56 volumio systemd[1]: Starting user-0.slice. Apr 14 08:18:56 volumio systemd[1]: Created slice user-0.slice. Apr 14 08:18:56 volumio systemd[1]: Starting Session c1 of user root. Apr 14 08:18:56 volumio systemd[1]: Started Session c1 of user root. Apr 14 08:18:56 volumio systemd[1]: Starting User Manager for UID 0... Apr 14 08:18:56 volumio systemd[2230]: pam_unix(systemd-user:session): session opened for user root by (uid=0) Apr 14 08:18:56 volumio systemd[2230]: Starting Paths. Apr 14 08:18:56 volumio systemd[2230]: Reached target Paths. Apr 14 08:18:56 volumio systemd[2230]: Starting Timers. Apr 14 08:18:56 volumio systemd[2230]: Reached target Timers. Apr 14 08:18:56 volumio systemd[2230]: Starting Sockets. Apr 14 08:18:56 volumio systemd[2230]: Reached target Sockets. Apr 14 08:18:56 volumio systemd[2230]: Starting Basic System. Apr 14 08:18:56 volumio systemd[2230]: Reached target Basic System. Apr 14 08:18:56 volumio systemd[2230]: Starting Default. Apr 14 08:18:56 volumio systemd[2230]: Reached target Default. Apr 14 08:18:56 volumio systemd[2230]: Startup finished in 66ms. Apr 14 08:18:56 volumio systemd[1]: Started User Manager for UID 0. Apr 14 08:18:56 volumio login[2238]: ROOT LOGIN on '/dev/tty1' Apr 14 08:18:58 volumio sudo[2243]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-14 08:17 Apr 14 08:18:58 volumio sudo[2243]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" 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="ba22215fabbe766d668749499a1c25fcefd90f0a" VOLUMIO_FE_VERSION="" VOLUMIO_BE_VERSION="043dcaee624f27d121213b83af11a9f2feac0945" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Mar 18 01:32:43 CET 2020" VOLUMIO_VERSION="2.729" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="5a0b29326faa8f5d0f5fe95d9e58c069"