-- Logs begin at Tue 2024-08-20 10:14:08 UTC, end at Wed 2024-08-21 03:24:55 UTC. --
Aug 21 03:23:15 volumio volumio-remote-updater[581]: [2024-08-21 03:23:15] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006]
Aug 21 03:23:20 volumio volumio-remote-updater[581]: [2024-08-21 03:23:20] [connect] Successful connection
Aug 21 03:23:32 volumio volumio-remote-updater[581]: [2024-08-21 03:23:32] [connect] Successful connection
Aug 21 03:23:47 volumio volumio-remote-updater[581]: [2024-08-21 03:23:47] [connect] Successful connection
Aug 21 03:24:02 volumio volumio-remote-updater[581]: [2024-08-21 03:24:02] [connect] Successful connection
Aug 21 03:24:16 volumio kernel: Status code returned 0xc0000128 STATUS_FILE_CLOSED
Aug 21 03:24:16 volumio kernel: CIFS VFS: Send error in read = -9
Aug 21 03:24:16 volumio volumio[8016]: info: Cannot mount NAS PC-MUSIC at system boot, trial number 3 ,retrying in 5 seconds
Aug 21 03:24:16 volumio volumio[8016]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Aug 21 03:24:16 volumio volumio[8016]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 21 03:24:16 volumio volumio[8016]: info: CoreStateMachine::setRepeat null single undefined
Aug 21 03:24:16 volumio volumio[8016]: info: CoreStateMachine::pushState
Aug 21 03:24:16 volumio volumio[8016]: info: CorePlayQueue::getTrack 0
Aug 21 03:24:16 volumio volumio[8016]: info: CoreCommandRouter::volumioPushState
Aug 21 03:24:16 volumio volumio[8016]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 21 03:24:16 volumio volumio[8016]: info: CoreStateMachine::setRandom false
Aug 21 03:24:16 volumio volumio[8016]: info: CoreStateMachine::pushState
Aug 21 03:24:16 volumio volumio[8016]: info: CorePlayQueue::getTrack 0
Aug 21 03:24:16 volumio volumio[8016]: info: CoreCommandRouter::volumioPushState
Aug 21 03:24:16 volumio volumio[8016]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 21 03:24:16 volumio volumio[8016]: Discovery: adding 340a3ec7-be3a-4302-9c31-1f95be929f1b
Aug 21 03:24:16 volumio volumio[8016]: info: mDNS: Found device Volumio
Aug 21 03:24:16 volumio volumio[8016]: info: CoreCommandRouter::volumioGetState
Aug 21 03:24:16 volumio volumio[8016]: info: CorePlayQueue::getTrack 0
Aug 21 03:24:16 volumio volumio[8016]: info: Starting Shairport Sync
Aug 21 03:24:16 volumio volumio[8016]: info: Starting Shairport Sync
Aug 21 03:24:16 volumio sudo[8257]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Aug 21 03:24:16 volumio sudo[8259]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Aug 21 03:24:16 volumio volumio[8016]: Upnp client error: Error: This socket has been ended by the other party
Aug 21 03:24:16 volumio volumio[8016]: Upnp client error: Error: This socket has been ended by the other party
Aug 21 03:24:16 volumio volumio[8016]: Upnp client error: Error: This socket has been ended by the other party
Aug 21 03:24:16 volumio sudo[8257]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 21 03:24:16 volumio sudo[8259]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 21 03:24:16 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Aug 21 03:24:16 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver...
Aug 21 03:24:16 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Aug 21 03:24:16 volumio sudo[8257]: pam_unix(sudo:session): session closed for user root
Aug 21 03:24:16 volumio sudo[8259]: pam_unix(sudo:session): session closed for user root
Aug 21 03:24:16 volumio volumio[8016]: info: Shairport-Sync Started
Aug 21 03:24:16 volumio volumio[8016]: Error adding Membership: Error: addMembership EINVAL
Aug 21 03:24:16 volumio volumio[8016]: info: Shairport-Sync Started
Aug 21 03:24:16 volumio sudo[8286]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Aug 21 03:24:17 volumio sudo[8286]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 21 03:24:17 volumio systemd[1]: Started UPnP Renderer front-end to MPD.
Aug 21 03:24:17 volumio sudo[8286]: pam_unix(sudo:session): session closed for user root
Aug 21 03:24:17 volumio volumio[8016]: info: Upmpdcli Daemon Started
Aug 21 03:24:17 volumio volumio-remote-updater[581]: [2024-08-21 03:24:17] [connect] Successful connection
Aug 21 03:24:17 volumio volumio-remote-updater[581]: [2024-08-21 03:24:17] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1724210657 101
Aug 21 03:24:20 volumio volumio[8016]: error: error
Aug 21 03:24:21 volumio volumio[8016]: info: Cannot mount NAS PC-MUSIC at system boot, trial number 4 ,retrying in 5 seconds
Aug 21 03:24:26 volumio volumio[8016]: info: Cannot mount NAS at system boot, trial number 4 ,stopping
Aug 21 03:24:27 volumio sudo[8315]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Aug 21 03:24:27 volumio sudo[8315]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 21 03:24:27 volumio sudo[8317]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Aug 21 03:24:27 volumio sudo[8315]: pam_unix(sudo:session): session closed for user root
Aug 21 03:24:27 volumio sudo[8317]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 21 03:24:27 volumio volumio[8016]: info: CoreCommandRouter::volumioGetState
Aug 21 03:24:27 volumio volumio[8016]: info: CorePlayQueue::getTrack 0
Aug 21 03:24:27 volumio sudo[8317]: pam_unix(sudo:session): session closed for user root
Aug 21 03:24:27 volumio sudo[8333]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Aug 21 03:24:27 volumio sudo[8333]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 21 03:24:27 volumio sudo[8335]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Aug 21 03:24:27 volumio sudo[8333]: pam_unix(sudo:session): session closed for user root
Aug 21 03:24:27 volumio sudo[8335]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 21 03:24:27 volumio sudo[8335]: pam_unix(sudo:session): session closed for user root
Aug 21 03:24:27 volumio volumio[8016]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.834&uuid=0f46f3c98aeb4e19b4ccfa5de1174292" http://updates.volumio.org:7070/downloader-v1/track-device
Aug 21 03:24:27 volumio volumio[8016]: % Total % Received % Xferd Average Speed Time Time Time Current
Aug 21 03:24:27 volumio volumio[8016]: Dload Upload Total Spent Left Speed
Aug 21 03:24:27 volumio volumio[8016]: [1.3K blob data]
Aug 21 03:24:27 volumio volumio[8016]: retrying in 5 seconds, trial 0
Aug 21 03:24:27 volumio volumio[8016]: Volumio Calling Home
Aug 21 03:24:28 volumio sudo[8356]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Aug 21 03:24:28 volumio sudo[8356]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 21 03:24:28 volumio sudo[8358]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Aug 21 03:24:28 volumio sudo[8356]: pam_unix(sudo:session): session closed for user root
Aug 21 03:24:28 volumio sudo[8358]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 21 03:24:28 volumio sudo[8358]: pam_unix(sudo:session): session closed for user root
Aug 21 03:24:28 volumio volumio[8016]: info: CoreCommandRouter::volumioGetState
Aug 21 03:24:28 volumio volumio[8016]: info: CorePlayQueue::getTrack 0
Aug 21 03:24:28 volumio volumio[8016]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Aug 21 03:24:28 volumio volumio[8016]: info: CoreCommandRouter::volumioGetVisibleSources
Aug 21 03:24:28 volumio volumio[8016]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Aug 21 03:24:28 volumio volumio[8016]: info: Listing playlists
Aug 21 03:24:28 volumio volumio[8016]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Aug 21 03:24:28 volumio volumio[8016]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Aug 21 03:24:28 volumio volumio[8016]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Aug 21 03:24:28 volumio volumio[8016]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Aug 21 03:24:30 volumio volumio[8016]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Aug 21 03:24:31 volumio volumio[8016]: info: CoreCommandRouter::volumioPlay
Aug 21 03:24:31 volumio volumio[8016]: UNSET VOLATILE
Aug 21 03:24:31 volumio volumio[8016]: info: CoreStateMachine::play index undefined
Aug 21 03:24:31 volumio volumio[8016]: info: CoreStateMachine::setConsumeUpdateService undefined
Aug 21 03:24:31 volumio volumio[8016]: info: CorePlayQueue::getTrack 0
Aug 21 03:24:31 volumio volumio[8016]: info: CoreStateMachine::startPlaybackTimer
Aug 21 03:24:31 volumio volumio[8016]: info: CorePlayQueue::getTrack 0
Aug 21 03:24:31 volumio volumio[8016]: verbose: ControllerMpd::clearAddPlayTracks NAS/PC-MUSIC/FLAC-[Hi-Res]/Annar Folleso&Norwegian Radio Orchestra&Ole Kristian Ruud-奥雷 布尔 小提琴协奏曲-[Hi-Res]-96kHz-24bit/01. Sæterjentens Søndag (The Herdgirl’s Sunday).flac
Aug 21 03:24:31 volumio volumio[8016]: verbose: ControllerMpd::sendMpdCommand stop
Aug 21 03:24:31 volumio volumio[8016]: info:
Aug 21 03:24:31 volumio volumio[8016]: ---------------------------- MPD announces state update: player
Aug 21 03:24:31 volumio volumio[8016]: info: ControllerMpd::getState
Aug 21 03:24:31 volumio volumio[8016]: verbose: ControllerMpd::sendMpdCommand status
Aug 21 03:24:31 volumio volumio[8016]: verbose: ControllerMpd::sendMpdCommand clear
Aug 21 03:24:31 volumio volumio[8016]: info:
Aug 21 03:24:31 volumio volumio[8016]: ---------------------------- MPD announces system playlist update
Aug 21 03:24:31 volumio volumio[8016]: info: Ignoring MPD Status Update
Aug 21 03:24:31 volumio volumio[8016]: verbose: ControllerMpd::parseState
Aug 21 03:24:31 volumio volumio[8016]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 21 03:24:31 volumio volumio[8016]: verbose: ControllerMpd::sendMpdCommand add "NAS/PC-MUSIC/FLAC-[Hi-Res]/Annar Folleso&Norwegian Radio Orchestra&Ole Kristian Ruud-奥雷 布尔 小提琴协奏曲-[Hi-Res]-96kHz-24bit/01. Sæterjentens Søndag (The Herdgirl’s Sunday).flac"
Aug 21 03:24:31 volumio volumio[8016]: error: updateQueue error: null
Aug 21 03:24:31 volumio volumio[8016]: info:
Aug 21 03:24:31 volumio volumio[8016]: ---------------------------- MPD announces system playlist update
Aug 21 03:24:31 volumio volumio[8016]: info: Ignoring MPD Status Update
Aug 21 03:24:31 volumio volumio[8016]: info: ------------------------------ 6ms
Aug 21 03:24:31 volumio volumio[8016]: verbose: ControllerMpd::parseTrackInfo
Aug 21 03:24:31 volumio volumio[8016]: verbose: ControllerMpd::sendMpdCommand play
Aug 21 03:24:31 volumio volumio[8016]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Aug 21 03:24:31 volumio volumio[8016]: info: ------------------------------ 14ms
Aug 21 03:24:31 volumio volumio[8016]: info: ------------------------------ 6ms
Aug 21 03:24:31 volumio volumio[8016]: info:
Aug 21 03:24:31 volumio volumio[8016]: ---------------------------- MPD announces state update: player
Aug 21 03:24:31 volumio volumio[8016]: info: ControllerMpd::getState
Aug 21 03:24:31 volumio volumio[8016]: verbose: ControllerMpd::sendMpdCommand status
Aug 21 03:24:31 volumio volumio[8016]: info:
Aug 21 03:24:31 volumio volumio[8016]: ---------------------------- MPD announces state update: player
Aug 21 03:24:31 volumio volumio[8016]: info: ControllerMpd::getState
Aug 21 03:24:31 volumio volumio[8016]: verbose: ControllerMpd::sendMpdCommand status
Aug 21 03:24:31 volumio volumio[8016]: verbose: ControllerMpd::parseState
Aug 21 03:24:31 volumio volumio[8016]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 21 03:24:31 volumio volumio[8016]: verbose: ControllerMpd::parseState
Aug 21 03:24:31 volumio volumio[8016]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 21 03:24:31 volumio volumio[8016]: verbose: ControllerMpd::parseTrackInfo
Aug 21 03:24:31 volumio volumio[8016]: info: ControllerMpd::pushState
Aug 21 03:24:31 volumio volumio[8016]: info: CoreCommandRouter::servicePushState
Aug 21 03:24:31 volumio volumio[8016]: info: CorePlayQueue::getTrack 0
Aug 21 03:24:31 volumio volumio[8016]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":179,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Sæterjentens Søndag (The Herdgirl’s Sunday)","artist":"Annar Follesø / Norwegian Radio Orchestra / Ole Kristian Ruud","album":"OLE BULL Violin Concertos","uri":"NAS/PC-MUSIC/FLAC-[Hi-Res]/Annar Folleso&Norwegian Radio Orchestra&Ole Kristian Ruud-奥雷 布尔 小提琴协奏曲-[Hi-Res]-96kHz-24bit/01. Sæterjentens Søndag (The Herdgirl’s Sunday).flac","trackType":"flac"}
Aug 21 03:24:31 volumio volumio[8016]: verbose: CURRENT POSITION 0
Aug 21 03:24:31 volumio volumio[8016]: info: CoreStateMachine::syncState stateService play
Aug 21 03:24:31 volumio volumio[8016]: info: CoreStateMachine::syncState currentStatus stop
Aug 21 03:24:31 volumio volumio[8016]: info: CoreStateMachine::pushState
Aug 21 03:24:31 volumio volumio[8016]: info: CorePlayQueue::getTrack 0
Aug 21 03:24:31 volumio volumio[8016]: info: CoreCommandRouter::volumioPushState
Aug 21 03:24:31 volumio volumio[8016]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 21 03:24:31 volumio volumio[8016]: info: ------------------------------ 25ms
Aug 21 03:24:31 volumio volumio[8016]: verbose: ControllerMpd::parseTrackInfo
Aug 21 03:24:31 volumio volumio[8016]: info: ControllerMpd::pushState
Aug 21 03:24:31 volumio volumio[8016]: info: CoreCommandRouter::servicePushState
Aug 21 03:24:31 volumio volumio[8016]: info: CorePlayQueue::getTrack 0
Aug 21 03:24:31 volumio volumio[8016]: verbose: STATE SERVICE {"status":"play","position":0,"seek":298,"duration":179,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4544 Kbps","isStreaming":false,"title":"Sæterjentens Søndag (The Herdgirl’s Sunday)","artist":"Annar Follesø / Norwegian Radio Orchestra / Ole Kristian Ruud","album":"OLE BULL Violin Concertos","uri":"NAS/PC-MUSIC/FLAC-[Hi-Res]/Annar Folleso&Norwegian Radio Orchestra&Ole Kristian Ruud-奥雷 布尔 小提琴协奏曲-[Hi-Res]-96kHz-24bit/01. Sæterjentens Søndag (The Herdgirl’s Sunday).flac","trackType":"flac"}
Aug 21 03:24:31 volumio volumio[8016]: verbose: CURRENT POSITION 0
Aug 21 03:24:31 volumio volumio[8016]: info: CoreStateMachine::syncState stateService play
Aug 21 03:24:31 volumio volumio[8016]: info: CoreStateMachine::syncState currentStatus play
Aug 21 03:24:31 volumio volumio[8016]: info: Received an update from plugin. extracting info from payload
Aug 21 03:24:31 volumio volumio[8016]: info: CoreStateMachine::pushState
Aug 21 03:24:31 volumio volumio[8016]: info: CorePlayQueue::getTrack 0
Aug 21 03:24:31 volumio volumio[8016]: info: CoreCommandRouter::volumioPushState
Aug 21 03:24:31 volumio volumio[8016]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 21 03:24:31 volumio volumio[8016]: info: CoreStateMachine::pushState
Aug 21 03:24:31 volumio volumio[8016]: info: CorePlayQueue::getTrack 0
Aug 21 03:24:31 volumio volumio[8016]: info: CoreCommandRouter::volumioPushState
Aug 21 03:24:31 volumio volumio[8016]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 21 03:24:31 volumio volumio[8016]: info: ------------------------------ 35ms
Aug 21 03:24:43 volumio volumio[8016]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.834&uuid=0f46f3c98aeb4e19b4ccfa5de1174292" http://updates.volumio.org:7070/downloader-v1/track-device
Aug 21 03:24:43 volumio volumio[8016]: % Total % Received % Xferd Average Speed Time Time Time Current
Aug 21 03:24:43 volumio volumio[8016]: Dload Upload Total Spent Left Speed
Aug 21 03:24:43 volumio volumio[8016]: [630B blob data]
Aug 21 03:24:43 volumio volumio[8016]: retrying in 5 seconds, trial 1
Aug 21 03:24:43 volumio volumio[8016]: Volumio Calling Home
Aug 21 03:24:47 volumio volumio[8016]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Aug 21 03:24:47 volumio volumio[8016]: info: CURURI: music-library
Aug 21 03:24:47 volumio volumio[8016]: info: CoreCommandRouter::volumioGetQueue
Aug 21 03:24:47 volumio volumio[8016]: info: CoreStateMachine::getQueue
Aug 21 03:24:47 volumio volumio[8016]: info: CorePlayQueue::getQueue
Aug 21 03:24:49 volumio volumio[8016]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Aug 21 03:24:49 volumio volumio[8016]: info: CURURI: music-library/NAS
Aug 21 03:24:50 volumio volumio[8016]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Aug 21 03:24:50 volumio volumio[8016]: info: CURURI: music-library/NAS/PC-MUSIC
Aug 21 03:24:51 volumio volumio[8016]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Aug 21 03:24:51 volumio volumio[8016]: info: CURURI: music-library/NAS/PC-MUSIC/FLAC-[Hi-Res]
Aug 21 03:24:52 volumio volumio[8016]: info: CoreCommandRouter::volumioReplaceandPlayItems
Aug 21 03:24:52 volumio volumio[8016]: info: CoreStateMachine::ClearQueue
Aug 21 03:24:52 volumio volumio[8016]: info: CoreStateMachine::stop
Aug 21 03:24:52 volumio volumio[8016]: info: CoreStateMachine::setConsumeUpdateService undefined
Aug 21 03:24:53 volumio volumio[8016]: UNSET VOLATILE
Aug 21 03:24:53 volumio volumio[8016]: info: CoreStateMachine::stPlaybackTimer
Aug 21 03:24:53 volumio volumio[8016]: info: CoreStateMachine::updateTrackBlock
Aug 21 03:24:53 volumio volumio[8016]: info: CorePlayQueue::getTrackBlock
Aug 21 03:24:53 volumio volumio[8016]: info: CoreStateMachine::pushState
Aug 21 03:24:53 volumio volumio[8016]: info: CorePlayQueue::getTrack 0
Aug 21 03:24:53 volumio volumio[8016]: info: CoreCommandRouter::volumioPushState
Aug 21 03:24:53 volumio volumio[8016]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 21 03:24:53 volumio volumio[8016]: info: CoreStateMachine::serviceStop
Aug 21 03:24:53 volumio volumio[8016]: info: CorePlayQueue::getTrack 0
Aug 21 03:24:53 volumio volumio[8016]: info: CoreCommandRouter::serviceStop
Aug 21 03:24:53 volumio volumio[8016]: info: ControllerMpd::stop
Aug 21 03:24:53 volumio volumio[8016]: verbose: ControllerMpd::sendMpdCommand stop
Aug 21 03:24:53 volumio volumio[8016]: info: CorePlayQueue::clearPlayQueue
Aug 21 03:24:53 volumio volumio[8016]: info: CorePlayQueue::saveQueue
Aug 21 03:24:53 volumio volumio[8016]: info: CoreCommandRouter::volumioPushState
Aug 21 03:24:53 volumio volumio[8016]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 21 03:24:53 volumio volumio[8016]: info: CoreCommandRouter::volumioPushQueue
Aug 21 03:24:53 volumio volumio[8016]: info: CoreStateMachine::addQueueItems
Aug 21 03:24:53 volumio volumio[8016]: info: CorePlayQueue::addQueueItems
Aug 21 03:24:53 volumio volumio[8016]: info: Adding Item to queue: music-library/NAS/PC-MUSIC/FLAC-[Hi-Res]/FictionJunction YUUKA-Destination-[Hi-Res]-96kHz-24bit
Aug 21 03:24:53 volumio volumio[8016]: info: Exploding uri music-library/NAS/PC-MUSIC/FLAC-[Hi-Res]/FictionJunction YUUKA-Destination-[Hi-Res]-96kHz-24bit in service mpd
Aug 21 03:24:53 volumio volumio[8016]: info:
Aug 21 03:24:53 volumio volumio[8016]: ---------------------------- MPD announces state update: player
Aug 21 03:24:53 volumio volumio[8016]: info: ControllerMpd::getState
Aug 21 03:24:53 volumio volumio[8016]: verbose: ControllerMpd::sendMpdCommand status
Aug 21 03:24:53 volumio volumio[8016]: info: ALBUMART /albumart?cacheid=622&web=FictionJunction%20YUUKA/Destination/extralarge&path=%2Fmnt%2FNAS%2FPC-MUSIC%2FFLAC-%5BHi-Res%5D%2FFictionJunction%20YUUKA-Destination-%5BHi-Res%5D-96kHz-24bit%2F01.%20I'm%20here.flac&metadata=false
Aug 21 03:24:53 volumio volumio[8016]: info: URI /mnt/NAS/PC-MUSIC/FLAC-[Hi-Res]/FictionJunction YUUKA-Destination-[Hi-Res]-96kHz-24bit/01. I'm here.flac
Aug 21 03:24:53 volumio volumio[8016]: info: ALBUMART /albumart?cacheid=622&web=FictionJunction%20YUUKA/Destination/extralarge&path=%2Fmnt%2FNAS%2FPC-MUSIC%2FFLAC-%5BHi-Res%5D%2FFictionJunction%20YUUKA-Destination-%5BHi-Res%5D-96kHz-24bit%2F02.%20destination.flac&metadata=false
Aug 21 03:24:53 volumio volumio[8016]: info: URI /mnt/NAS/PC-MUSIC/FLAC-[Hi-Res]/FictionJunction YUUKA-Destination-[Hi-Res]-96kHz-24bit/02. destination.flac
Aug 21 03:24:53 volumio volumio[8016]: info: ALBUMART /albumart?cacheid=622&web=FictionJunction%20YUUKA/Destination/extralarge&path=%2Fmnt%2FNAS%2FPC-MUSIC%2FFLAC-%5BHi-Res%5D%2FFictionJunction%20YUUKA-Destination-%5BHi-Res%5D-96kHz-24bit%2F03.%20nowhere.flac&metadata=false
Aug 21 03:24:53 volumio volumio[8016]: info: URI /mnt/NAS/PC-MUSIC/FLAC-[Hi-Res]/FictionJunction YUUKA-Destination-[Hi-Res]-96kHz-24bit/03. nowhere.flac
Aug 21 03:24:53 volumio volumio[8016]: info: ALBUMART /albumart?cacheid=622&web=FictionJunction%20YUUKA/Destination/extralarge&path=%2Fmnt%2FNAS%2FPC-MUSIC%2FFLAC-%5BHi-Res%5D%2FFictionJunction%20YUUKA-Destination-%5BHi-Res%5D-96kHz-24bit%2F04.%20%E6%9A%81%E3%81%AE%E8%BB%8A.flac&metadata=false
Aug 21 03:24:53 volumio volumio[8016]: info: URI /mnt/NAS/PC-MUSIC/FLAC-[Hi-Res]/FictionJunction YUUKA-Destination-[Hi-Res]-96kHz-24bit/04. 暁の車.flac
Aug 21 03:24:53 volumio volumio[8016]: info: ALBUMART /albumart?cacheid=622&web=FictionJunction%20YUUKA/Destination/extralarge&path=%2Fmnt%2FNAS%2FPC-MUSIC%2FFLAC-%5BHi-Res%5D%2FFictionJunction%20YUUKA-Destination-%5BHi-Res%5D-96kHz-24bit%2F05.%20%E8%AA%B0%E3%82%82%E3%81%84%E3%81%AA%E3%81%84%E5%A0%B4%E6%89%80.flac&metadata=false
Aug 21 03:24:53 volumio volumio[8016]: info: URI /mnt/NAS/PC-MUSIC/FLAC-[Hi-Res]/FictionJunction YUUKA-Destination-[Hi-Res]-96kHz-24bit/05. 誰もいない場所.flac
Aug 21 03:24:53 volumio volumio[8016]: info: ALBUMART /albumart?cacheid=622&web=FictionJunction%20YUUKA/Destination/extralarge&path=%2Fmnt%2FNAS%2FPC-MUSIC%2FFLAC-%5BHi-Res%5D%2FFictionJunction%20YUUKA-Destination-%5BHi-Res%5D-96kHz-24bit%2F06.%20%E8%81%96%E5%A4%9C.flac&metadata=false
Aug 21 03:24:53 volumio volumio[8016]: info: URI /mnt/NAS/PC-MUSIC/FLAC-[Hi-Res]/FictionJunction YUUKA-Destination-[Hi-Res]-96kHz-24bit/06. 聖夜.flac
Aug 21 03:24:53 volumio volumio[8016]: info: ALBUMART /albumart?cacheid=622&web=FictionJunction%20YUUKA/Destination/extralarge&path=%2Fmnt%2FNAS%2FPC-MUSIC%2FFLAC-%5BHi-Res%5D%2FFictionJunction%20YUUKA-Destination-%5BHi-Res%5D-96kHz-24bit%2F07.%20%E3%81%97%E3%81%9A%E3%81%8B%E3%81%AA%E3%81%93%E3%81%A8%E3%81%B0.flac&metadata=false
Aug 21 03:24:53 volumio volumio[8016]: info: URI /mnt/NAS/PC-MUSIC/FLAC-[Hi-Res]/FictionJunction YUUKA-Destination-[Hi-Res]-96kHz-24bit/07. しずかなことば.flac
Aug 21 03:24:53 volumio volumio[8016]: info: ALBUMART /albumart?cacheid=622&web=FictionJunction%20YUUKA/Destination/extralarge&path=%2Fmnt%2FNAS%2FPC-MUSIC%2FFLAC-%5BHi-Res%5D%2FFictionJunction%20YUUKA-Destination-%5BHi-Res%5D-96kHz-24bit%2F08.%20%E3%81%B5%E3%81%9F%E3%82%8A.flac&metadata=false
Aug 21 03:24:53 volumio volumio[8016]: info: URI /mnt/NAS/PC-MUSIC/FLAC-[Hi-Res]/FictionJunction YUUKA-Destination-[Hi-Res]-96kHz-24bit/08. ふたり.flac
Aug 21 03:24:53 volumio volumio[8016]: info: ALBUMART /albumart?cacheid=622&web=FictionJunction%20YUUKA/Destination/extralarge&path=%2Fmnt%2FNAS%2FPC-MUSIC%2FFLAC-%5BHi-Res%5D%2FFictionJunction%20YUUKA-Destination-%5BHi-Res%5D-96kHz-24bit%2F09.%20%E7%9E%B3%E3%81%AE%E6%AC%A0%E7%89%87.flac&metadata=false
Aug 21 03:24:53 volumio volumio[8016]: info: URI /mnt/NAS/PC-MUSIC/FLAC-[Hi-Res]/FictionJunction YUUKA-Destination-[Hi-Res]-96kHz-24bit/09. 瞳の欠片.flac
Aug 21 03:24:53 volumio volumio[8016]: info: ALBUMART /albumart?cacheid=622&web=FictionJunction%20YUUKA/Destination/extralarge&path=%2Fmnt%2FNAS%2FPC-MUSIC%2FFLAC-%5BHi-Res%5D%2FFictionJunction%20YUUKA-Destination-%5BHi-Res%5D-96kHz-24bit%2F10.%20nostalgia.flac&metadata=false
Aug 21 03:24:53 volumio volumio[8016]: info: URI /mnt/NAS/PC-MUSIC/FLAC-[Hi-Res]/FictionJunction YUUKA-Destination-[Hi-Res]-96kHz-24bit/10. nostalgia.flac
Aug 21 03:24:53 volumio volumio[8016]: info: ALBUMART /albumart?cacheid=622&web=FictionJunction%20YUUKA/Destination/extralarge&path=%2Fmnt%2FNAS%2FPC-MUSIC%2FFLAC-%5BHi-Res%5D%2FFictionJunction%20YUUKA-Destination-%5BHi-Res%5D-96kHz-24bit%2F11.%20inside%20your%20heart.flac&metadata=false
Aug 21 03:24:53 volumio volumio[8016]: info: URI /mnt/NAS/PC-MUSIC/FLAC-[Hi-Res]/FictionJunction YUUKA-Destination-[Hi-Res]-96kHz-24bit/11. inside your heart.flac
Aug 21 03:24:53 volumio volumio[8016]: verbose: ControllerMpd::parseState
Aug 21 03:24:53 volumio volumio[8016]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 21 03:24:53 volumio volumio[8016]: info: CorePlayQueue::saveQueue
Aug 21 03:24:53 volumio volumio[8016]: info: CoreCommandRouter::volumioPushQueue
Aug 21 03:24:53 volumio volumio[8016]: info: CoreStateMachine::updateTrackBlock
Aug 21 03:24:53 volumio volumio[8016]: info: CorePlayQueue::getTrackBlock
Aug 21 03:24:53 volumio volumio[8016]: info: CoreCommandRouter::volumioPlay
Aug 21 03:24:53 volumio volumio[8016]: UNSET VOLATILE
Aug 21 03:24:53 volumio volumio[8016]: info: CoreStateMachine::play index 0
Aug 21 03:24:53 volumio volumio[8016]: info: CoreStateMachine::setConsumeUpdateService undefined
Aug 21 03:24:53 volumio volumio[8016]: info: CoreStateMachine::stop
Aug 21 03:24:53 volumio volumio[8016]: info: CoreStateMachine::setConsumeUpdateService undefined
Aug 21 03:24:53 volumio volumio[8016]: UNSET VOLATILE
Aug 21 03:24:53 volumio volumio[8016]: info: CoreStateMachine::play index undefined
Aug 21 03:24:53 volumio volumio[8016]: info: CoreStateMachine::setConsumeUpdateService undefined
Aug 21 03:24:53 volumio volumio[8016]: info: CorePlayQueue::getTrack 0
Aug 21 03:24:53 volumio volumio[8016]: info: CoreStateMachine::startPlaybackTimer
Aug 21 03:24:53 volumio volumio[8016]: info: CorePlayQueue::getTrack 0
Aug 21 03:24:53 volumio volumio[8016]: verbose: ControllerMpd::clearAddPlayTracks NAS/PC-MUSIC/FLAC-[Hi-Res]/FictionJunction YUUKA-Destination-[Hi-Res]-96kHz-24bit/01. I'm here.flac
Aug 21 03:24:53 volumio volumio[8016]: verbose: ControllerMpd::sendMpdCommand stop
Aug 21 03:24:53 volumio volumio[8016]: verbose: ControllerMpd::parseTrackInfo
Aug 21 03:24:53 volumio volumio[8016]: verbose: ControllerMpd::sendMpdCommand clear
Aug 21 03:24:53 volumio volumio[8016]: info: ControllerMpd::pushState
Aug 21 03:24:53 volumio volumio[8016]: info: CoreCommandRouter::servicePushState
Aug 21 03:24:53 volumio volumio[8016]: info: CoreStateMachine::pushState
Aug 21 03:24:53 volumio volumio[8016]: info: CorePlayQueue::getTrack 0
Aug 21 03:24:53 volumio volumio[8016]: info: CoreCommandRouter::volumioPushState
Aug 21 03:24:53 volumio volumio[8016]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 21 03:24:53 volumio volumio[8016]: info: CorePlayQueue::getTrack 0
Aug 21 03:24:53 volumio volumio[8016]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Sæterjentens Søndag (The Herdgirl’s Sunday)","artist":"Annar Follesø / Norwegian Radio Orchestra / Ole Kristian Ruud","album":"OLE BULL Violin Concertos","uri":"NAS/PC-MUSIC/FLAC-[Hi-Res]/Annar Folleso&Norwegian Radio Orchestra&Ole Kristian Ruud-奥雷 布尔 小提琴协奏曲-[Hi-Res]-96kHz-24bit/01. Sæterjentens Søndag (The Herdgirl’s Sunday).flac","trackType":"flac"}
Aug 21 03:24:53 volumio volumio[8016]: verbose: CURRENT POSITION 0
Aug 21 03:24:53 volumio volumio[8016]: info: CoreStateMachine::syncState stateService stop
Aug 21 03:24:53 volumio volumio[8016]: info: CoreStateMachine::syncState currentStatus stop
Aug 21 03:24:53 volumio volumio[8016]: info: CoreStateMachine::pushState
Aug 21 03:24:53 volumio volumio[8016]: info: CorePlayQueue::getTrack 0
Aug 21 03:24:53 volumio volumio[8016]: info: CoreCommandRouter::volumioPushState
Aug 21 03:24:53 volumio volumio[8016]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 21 03:24:53 volumio volumio[8016]: info: No code
Aug 21 03:24:53 volumio volumio[8016]: info: CoreStateMachine::pushState
Aug 21 03:24:53 volumio volumio[8016]: info: CorePlayQueue::getTrack 0
Aug 21 03:24:53 volumio volumio[8016]: info: CoreCommandRouter::volumioPushState
Aug 21 03:24:53 volumio volumio[8016]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 21 03:24:53 volumio volumio[8016]: info: ------------------------------ 33ms
Aug 21 03:24:53 volumio volumio[8016]: info:
Aug 21 03:24:53 volumio volumio[8016]: ---------------------------- MPD announces system playlist update
Aug 21 03:24:53 volumio volumio[8016]: info: Ignoring MPD Status Update
Aug 21 03:24:53 volumio volumio[8016]: verbose: ControllerMpd::sendMpdCommand add "NAS/PC-MUSIC/FLAC-[Hi-Res]/FictionJunction YUUKA-Destination-[Hi-Res]-96kHz-24bit/01. I'm here.flac"
Aug 21 03:24:53 volumio volumio[8016]: error: updateQueue error: null
Aug 21 03:24:53 volumio volumio[8016]: info:
Aug 21 03:24:53 volumio volumio[8016]: ---------------------------- MPD announces system playlist update
Aug 21 03:24:53 volumio volumio[8016]: info: Ignoring MPD Status Update
Aug 21 03:24:53 volumio volumio[8016]: info: ------------------------------ 6ms
Aug 21 03:24:53 volumio volumio[8016]: verbose: ControllerMpd::sendMpdCommand play
Aug 21 03:24:53 volumio volumio[8016]: info: ------------------------------ 3ms
Aug 21 03:24:53 volumio volumio[8016]: info:
Aug 21 03:24:53 volumio volumio[8016]: ---------------------------- MPD announces state update: player
Aug 21 03:24:53 volumio volumio[8016]: info: ControllerMpd::getState
Aug 21 03:24:53 volumio volumio[8016]: verbose: ControllerMpd::sendMpdCommand status
Aug 21 03:24:53 volumio volumio[8016]: info:
Aug 21 03:24:53 volumio volumio[8016]: ---------------------------- MPD announces state update: player
Aug 21 03:24:53 volumio volumio[8016]: info: ControllerMpd::getState
Aug 21 03:24:53 volumio volumio[8016]: verbose: ControllerMpd::sendMpdCommand status
Aug 21 03:24:53 volumio volumio[8016]: verbose: ControllerMpd::parseState
Aug 21 03:24:53 volumio volumio[8016]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 21 03:24:53 volumio volumio[8016]: verbose: ControllerMpd::parseState
Aug 21 03:24:53 volumio volumio[8016]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 21 03:24:53 volumio volumio[8016]: verbose: ControllerMpd::parseTrackInfo
Aug 21 03:24:53 volumio volumio[8016]: info: ControllerMpd::pushState
Aug 21 03:24:53 volumio volumio[8016]: info: CoreCommandRouter::servicePushState
Aug 21 03:24:53 volumio volumio[8016]: info: CorePlayQueue::getTrack 0
Aug 21 03:24:53 volumio volumio[8016]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":300,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4614 Kbps","isStreaming":false,"title":"I'm here","artist":"FictionJunction YUUKA","album":"Destination","uri":"NAS/PC-MUSIC/FLAC-[Hi-Res]/FictionJunction YUUKA-Destination-[Hi-Res]-96kHz-24bit/01. I'm here.flac","trackType":"flac"}
Aug 21 03:24:53 volumio volumio[8016]: verbose: CURRENT POSITION 0
Aug 21 03:24:53 volumio volumio[8016]: info: CoreStateMachine::syncState stateService play
Aug 21 03:24:53 volumio volumio[8016]: info: CoreStateMachine::syncState currentStatus stop
Aug 21 03:24:53 volumio volumio[8016]: info: CoreStateMachine::pushState
Aug 21 03:24:53 volumio volumio[8016]: info: CorePlayQueue::getTrack 0
Aug 21 03:24:53 volumio volumio[8016]: info: CoreCommandRouter::volumioPushState
Aug 21 03:24:53 volumio volumio[8016]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 21 03:24:53 volumio volumio[8016]: info: ------------------------------ 35ms
Aug 21 03:24:53 volumio volumio[8016]: verbose: ControllerMpd::parseTrackInfo
Aug 21 03:24:53 volumio volumio[8016]: info: ControllerMpd::pushState
Aug 21 03:24:53 volumio volumio[8016]: info: CoreCommandRouter::servicePushState
Aug 21 03:24:53 volumio volumio[8016]: info: CorePlayQueue::getTrack 0
Aug 21 03:24:53 volumio volumio[8016]: verbose: STATE SERVICE {"status":"play","position":0,"seek":490,"duration":300,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4614 Kbps","isStreaming":false,"title":"I'm here","artist":"FictionJunction YUUKA","album":"Destination","uri":"NAS/PC-MUSIC/FLAC-[Hi-Res]/FictionJunction YUUKA-Destination-[Hi-Res]-96kHz-24bit/01. I'm here.flac","trackType":"flac"}
Aug 21 03:24:53 volumio volumio[8016]: verbose: CURRENT POSITION 0
Aug 21 03:24:53 volumio volumio[8016]: info: CoreStateMachine::syncState stateService play
Aug 21 03:24:53 volumio volumio[8016]: info: CoreStateMachine::syncState currentStatus play
Aug 21 03:24:53 volumio volumio[8016]: info: Received an update from plugin. extracting info from payload
Aug 21 03:24:53 volumio volumio[8016]: info: CoreStateMachine::pushState
Aug 21 03:24:53 volumio volumio[8016]: info: CorePlayQueue::getTrack 0
Aug 21 03:24:53 volumio volumio[8016]: info: CoreCommandRouter::volumioPushState
Aug 21 03:24:53 volumio volumio[8016]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 21 03:24:53 volumio volumio[8016]: info: CoreStateMachine::pushState
Aug 21 03:24:53 volumio volumio[8016]: info: CorePlayQueue::getTrack 0
Aug 21 03:24:53 volumio volumio[8016]: info: CoreCommandRouter::volumioPushState
Aug 21 03:24:53 volumio volumio[8016]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 21 03:24:53 volumio volumio[8016]: info: ------------------------------ 21ms
Aug 21 03:24:54 volumio volumio[8016]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Aug 21 03:24:54 volumio volumio[8016]: { Error: connect ETIMEDOUT 202.160.128.16:443
Aug 21 03:24:54 volumio volumio[8016]: at Object._errnoException (util.js:1022:11)
Aug 21 03:24:54 volumio volumio[8016]: at _exceptionWithHostPort (util.js:1044:20)
Aug 21 03:24:54 volumio volumio[8016]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14)
Aug 21 03:24:54 volumio volumio[8016]: code: 'ETIMEDOUT',
Aug 21 03:24:54 volumio volumio[8016]: errno: 'ETIMEDOUT',
Aug 21 03:24:54 volumio volumio[8016]: syscall: 'connect',
Aug 21 03:24:54 volumio volumio[8016]: address: '202.160.128.16',
Aug 21 03:24:54 volumio volumio[8016]: port: 443 }
Aug 21 03:24:54 volumio volumio[8016]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Aug 21 03:24:55 volumio sudo[8443]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-21 03:23
Aug 21 03:24:55 volumio sudo[8443]: 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="74e4cc9de715c64d553d35948d017f973a622b6d"
VOLUMIO_FE_VERSION="2be6c28eb9de74ec1f9662ca333f7bd51a232c33"
VOLUMIO_BE_VERSION="259a7f2894e1376413ffac331be84e0e9a6173dd"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu Sep 24 22:42:43 CEST 2020"
VOLUMIO_VERSION="2.834"
VOLUMIO_HARDWARE="pi"
VOLUMIO_HASH="e41ef0f29aa50c1af109d3064a380c69"