-- Logs begin at Sat 2024-04-27 08:30:31 UTC, end at Sat 2024-04-27 09:37:08 UTC. --
Apr 27 09:36:13 volumio dhcpcd[1014]: eth0: adding route to 192.168.3.0/24
Apr 27 09:36:13 volumio dhcpcd[1014]: eth0: adding default route via 192.168.3.100
Apr 27 09:36:13 volumio dhcpcd[1014]: eth0: ipv4_addroute: File exists
Apr 27 09:36:13 volumio dhcpcd[1014]: eth0: removing route to 192.168.3.0/24
Apr 27 09:36:41 volumio volumio[1073]: info:
Apr 27 09:36:41 volumio volumio[1073]: ---------------------------- MPD announces system playlist update
Apr 27 09:36:41 volumio volumio[1073]: info: Ignoring MPD Status Update
Apr 27 09:36:41 volumio volumio[1073]: info:
Apr 27 09:36:41 volumio volumio[1073]: ---------------------------- MPD announces state update: player
Apr 27 09:36:41 volumio volumio[1073]: info: ControllerMpd::getState
Apr 27 09:36:41 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status
Apr 27 09:36:41 volumio volumio[1073]: info: ------------------------------ 2ms
Apr 27 09:36:41 volumio volumio[1073]: verbose: ControllerMpd::parseState
Apr 27 09:36:41 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 27 09:36:41 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo
Apr 27 09:36:41 volumio volumio[1073]: info: ControllerMpd::pushState
Apr 27 09:36:41 volumio volumio[1073]: info: CoreCommandRouter::servicePushState
Apr 27 09:36:41 volumio volumio[1073]: In UPNP mode
Apr 27 09:36:41 volumio volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":113371,"duration":114,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"M500000zPTFk35FwOY.mp3?guid=0000000004cb49d2000001871e73f5cf&vkey=83D4363FB7D56B967F3F0ECC7BC6F12C44F757479463BC643D80DDC8F99D81688F433510073E853ED4EF1A01A97ABCDA1B41CC6A8438FE08&uin=1259438298&src=M500002jfKhr3bVG3G.mp3&redirect=1&fromtag=111042","artist":"Xuefei Yang","album":"Striking a Chord","uri":"http://120.234.70.12/amobile.music.tc.qq.com/M500000zPTFk35FwOY.mp3?guid=0000000004cb49d2000001871e73f5cf&vkey=83D4363FB7D56B967F3F0ECC7BC6F12C44F757479463BC643D80DDC8F99D81688F433510073E853ED4EF1A01A97ABCDA1B41CC6A8438FE08&uin=1259438298&src=M500002jfKhr3bVG3G.mp3&redirect=1&fromtag=111042","trackType":""}
Apr 27 09:36:41 volumio volumio[1073]: verbose: CURRENT POSITION 0
Apr 27 09:36:41 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play
Apr 27 09:36:41 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play
Apr 27 09:36:41 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload
Apr 27 09:36:41 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 27 09:36:41 volumio volumio[1073]: info: CoreStateMachine::pushState
Apr 27 09:36:41 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState
Apr 27 09:36:41 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 27 09:36:41 volumio volumio[1073]: info: CoreStateMachine::pushState
Apr 27 09:36:41 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState
Apr 27 09:36:41 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 27 09:36:41 volumio volumio[1073]: info: ------------------------------ 26ms
Apr 27 09:36:41 volumio volumio[1073]: info: CoreCommandRouter::volumioGetQueue
Apr 27 09:36:41 volumio volumio[1073]: info: CoreStateMachine::getQueue
Apr 27 09:36:41 volumio volumio[1073]: info: CorePlayQueue::getQueue
Apr 27 09:36:41 volumio volumio[1073]: info: CoreCommandRouter::volumioGetQueue
Apr 27 09:36:41 volumio volumio[1073]: info: CoreStateMachine::getQueue
Apr 27 09:36:41 volumio volumio[1073]: info: CorePlayQueue::getQueue
Apr 27 09:36:42 volumio volumio[1073]: info:
Apr 27 09:36:42 volumio volumio[1073]: ---------------------------- MPD announces state update: player
Apr 27 09:36:42 volumio volumio[1073]: info: ControllerMpd::getState
Apr 27 09:36:42 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status
Apr 27 09:36:42 volumio volumio[1073]: verbose: ControllerMpd::parseState
Apr 27 09:36:42 volumio volumio[1073]: info: ControllerMpd::pushState
Apr 27 09:36:42 volumio volumio[1073]: info: CoreCommandRouter::servicePushState
Apr 27 09:36:42 volumio volumio[1073]: info: CoreStateMachine::pushState
Apr 27 09:36:42 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState
Apr 27 09:36:42 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 27 09:36:42 volumio volumio[1073]: info: CorePlayQueue::getTrack 0
Apr 27 09:36:42 volumio volumio[1073]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Apr 27 09:36:42 volumio volumio[1073]: verbose: CURRENT POSITION 0
Apr 27 09:36:42 volumio volumio[1073]: info: CoreStateMachine::syncState stateService stop
Apr 27 09:36:42 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play
Apr 27 09:36:42 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState
Apr 27 09:36:42 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 27 09:36:42 volumio volumio[1073]: info: CoreStateMachine::stPlaybackTimer
Apr 27 09:36:42 volumio volumio[1073]: info: ------------------------------ 14ms
Apr 27 09:36:42 volumio volumio[1073]: info: CoreCommandRouter::volumioGetQueue
Apr 27 09:36:42 volumio volumio[1073]: info: CoreStateMachine::getQueue
Apr 27 09:36:42 volumio volumio[1073]: info: CorePlayQueue::getQueue
Apr 27 09:36:42 volumio volumio[1073]: info: Clearing queue after UPNP request
Apr 27 09:36:43 volumio volumio[1073]: info: CoreStateMachine::ClearQueue
Apr 27 09:36:43 volumio volumio[1073]: info: CoreStateMachine::stop
Apr 27 09:36:43 volumio volumio[1073]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 27 09:36:43 volumio volumio[1073]: UNSET VOLATILE
Apr 27 09:36:43 volumio volumio[1073]: info: CorePlayQueue::clearPlayQueue
Apr 27 09:36:43 volumio volumio[1073]: info: CorePlayQueue::saveQueue
Apr 27 09:36:43 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState
Apr 27 09:36:43 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 27 09:36:43 volumio volumio[1073]: info: CoreCommandRouter::volumioPushQueue
Apr 27 09:36:43 volumio volumio[1073]: info:
Apr 27 09:36:43 volumio volumio[1073]: ---------------------------- MPD announces system playlist update
Apr 27 09:36:43 volumio volumio[1073]: info: Ignoring MPD Status Update
Apr 27 09:36:43 volumio volumio[1073]: error: updateQueue error: null
Apr 27 09:36:43 volumio volumio[1073]: info: ------------------------------ 1ms
Apr 27 09:36:43 volumio volumio[1073]: info: Starting UPNP Playback
Apr 27 09:36:43 volumio volumio[1073]: info: Preparing playback through UPNP
Apr 27 09:36:43 volumio volumio[1073]: info: CoreCommandRouter::volumioGetState
Apr 27 09:36:43 volumio volumio[1073]: info: CorePlayQueue::getTrack 0
Apr 27 09:36:43 volumio volumio[1073]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 27 09:36:43 volumio volumio[1073]: info:
Apr 27 09:36:43 volumio volumio[1073]: ---------------------------- MPD announces system playlist update
Apr 27 09:36:43 volumio volumio[1073]: info: Ignoring MPD Status Update
Apr 27 09:36:43 volumio volumio[1073]: info:
Apr 27 09:36:43 volumio volumio[1073]: ---------------------------- MPD announces system playlist update
Apr 27 09:36:43 volumio volumio[1073]: info: Ignoring MPD Status Update
Apr 27 09:36:43 volumio volumio[1073]: info: ------------------------------ 2ms
Apr 27 09:36:43 volumio volumio[1073]: info: ------------------------------ 1ms
Apr 27 09:36:43 volumio volumio[1073]: info:
Apr 27 09:36:43 volumio volumio[1073]: ---------------------------- MPD announces system playlist update
Apr 27 09:36:43 volumio volumio[1073]: info: Ignoring MPD Status Update
Apr 27 09:36:43 volumio volumio[1073]: info: ------------------------------ 1ms
Apr 27 09:36:43 volumio volumio[1073]: info:
Apr 27 09:36:43 volumio volumio[1073]: ---------------------------- MPD announces system playlist update
Apr 27 09:36:43 volumio volumio[1073]: info: Ignoring MPD Status Update
Apr 27 09:36:43 volumio dhcpcd[1014]: eth0: adding route to 192.168.3.0/24
Apr 27 09:36:43 volumio dhcpcd[1014]: eth0: adding default route via 192.168.3.100
Apr 27 09:36:43 volumio dhcpcd[1014]: eth0: ipv4_addroute: File exists
Apr 27 09:36:43 volumio volumio[1073]: info: ------------------------------ 2ms
Apr 27 09:36:43 volumio volumio[1073]: info:
Apr 27 09:36:43 volumio volumio[1073]: ---------------------------- MPD announces system playlist update
Apr 27 09:36:43 volumio volumio[1073]: info: Ignoring MPD Status Update
Apr 27 09:36:43 volumio volumio[1073]: info: ------------------------------ 1ms
Apr 27 09:36:43 volumio volumio[1073]: info:
Apr 27 09:36:43 volumio volumio[1073]: ---------------------------- MPD announces system playlist update
Apr 27 09:36:43 volumio volumio[1073]: info: Ignoring MPD Status Update
Apr 27 09:36:43 volumio volumio[1073]: info: ------------------------------ 1ms
Apr 27 09:36:43 volumio dhcpcd[1014]: eth0: removing route to 192.168.3.0/24
Apr 27 09:36:44 volumio volumio[1073]: info:
Apr 27 09:36:44 volumio volumio[1073]: ---------------------------- MPD announces state update: player
Apr 27 09:36:44 volumio volumio[1073]: info: ControllerMpd::getState
Apr 27 09:36:44 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status
Apr 27 09:36:45 volumio volumio[1073]: verbose: ControllerMpd::parseState
Apr 27 09:36:45 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 27 09:36:45 volumio volumio[1073]: info:
Apr 27 09:36:45 volumio volumio[1073]: ---------------------------- MPD announces state update: player
Apr 27 09:36:45 volumio volumio[1073]: info: ControllerMpd::getState
Apr 27 09:36:45 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand status
Apr 27 09:36:45 volumio volumio[1073]: info:
Apr 27 09:36:45 volumio volumio[1073]: ---------------------------- MPD announces system playlist update
Apr 27 09:36:45 volumio volumio[1073]: info: Ignoring MPD Status Update
Apr 27 09:36:45 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo
Apr 27 09:36:45 volumio volumio[1073]: verbose: ControllerMpd::parseState
Apr 27 09:36:45 volumio volumio[1073]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 27 09:36:45 volumio volumio[1073]: info: ControllerMpd::pushState
Apr 27 09:36:45 volumio volumio[1073]: info: CoreCommandRouter::servicePushState
Apr 27 09:36:45 volumio volumio[1073]: In UPNP mode
Apr 27 09:36:45 volumio volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":175,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"España, Op. 165: No. 2, Tango","artist":"Xuefei Yang","album":"Striking a Chord","uri":"http://120.234.70.12/amobile.music.tc.qq.com/M500001Xa0dk00NxOR.mp3?guid=0000000004cb49d2000001871e73f5cf&vkey=A95C882B53F3A051B95A38E1DE577F391C05F7D87BBFBE16E7BC59194141708EC5141B3B308EB2E9FBADDAD8F6ECC81573FE62CD4382B4DD&uin=1259438298&src=M5000013JRRn1aVugH.mp3&redirect=1&fromtag=111042","trackType":""}
Apr 27 09:36:45 volumio volumio[1073]: verbose: CURRENT POSITION 0
Apr 27 09:36:45 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play
Apr 27 09:36:45 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus stop
Apr 27 09:36:45 volumio volumio[1073]: info: CoreStateMachine::pushState
Apr 27 09:36:45 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState
Apr 27 09:36:45 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 27 09:36:45 volumio volumio[1073]: info: ------------------------------ 418ms
Apr 27 09:36:45 volumio volumio[1073]: info: ------------------------------ 11ms
Apr 27 09:36:45 volumio volumio[1073]: verbose: ControllerMpd::parseTrackInfo
Apr 27 09:36:45 volumio volumio[1073]: info: ControllerMpd::pushState
Apr 27 09:36:45 volumio volumio[1073]: info: CoreCommandRouter::servicePushState
Apr 27 09:36:45 volumio volumio[1073]: In UPNP mode
Apr 27 09:36:45 volumio volumio[1073]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":175,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"España, Op. 165: No. 2, Tango","artist":"Xuefei Yang","album":"Striking a Chord","uri":"http://120.234.70.12/amobile.music.tc.qq.com/M500001Xa0dk00NxOR.mp3?guid=0000000004cb49d2000001871e73f5cf&vkey=A95C882B53F3A051B95A38E1DE577F391C05F7D87BBFBE16E7BC59194141708EC5141B3B308EB2E9FBADDAD8F6ECC81573FE62CD4382B4DD&uin=1259438298&src=M5000013JRRn1aVugH.mp3&redirect=1&fromtag=111042","trackType":""}
Apr 27 09:36:45 volumio volumio[1073]: verbose: CURRENT POSITION 0
Apr 27 09:36:45 volumio volumio[1073]: info: CoreStateMachine::syncState stateService play
Apr 27 09:36:45 volumio volumio[1073]: info: CoreStateMachine::syncState currentStatus play
Apr 27 09:36:45 volumio volumio[1073]: info: Received an update from plugin. extracting info from payload
Apr 27 09:36:45 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 27 09:36:45 volumio volumio[1073]: info: CoreStateMachine::pushState
Apr 27 09:36:45 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState
Apr 27 09:36:45 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 27 09:36:45 volumio volumio[1073]: info: CoreStateMachine::pushState
Apr 27 09:36:45 volumio volumio[1073]: info: CoreCommandRouter::volumioPushState
Apr 27 09:36:45 volumio volumio[1073]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 27 09:36:45 volumio volumio[1073]: info: ------------------------------ 23ms
Apr 27 09:36:45 volumio volumio[1073]: info: CoreCommandRouter::volumioGetQueue
Apr 27 09:36:45 volumio volumio[1073]: info: CoreStateMachine::getQueue
Apr 27 09:36:45 volumio volumio[1073]: info: CorePlayQueue::getQueue
Apr 27 09:36:45 volumio volumio[1073]: info: CoreCommandRouter::volumioGetQueue
Apr 27 09:36:45 volumio volumio[1073]: info: CoreStateMachine::getQueue
Apr 27 09:36:45 volumio volumio[1073]: info: CorePlayQueue::getQueue
Apr 27 09:36:45 volumio volumio[1073]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Xuefei%20Yang/Striking%20a%20Chord/0461b925-7440-454a-84d0-e4d30b4805f9.jpg'
Apr 27 09:37:07 volumio volumio[1073]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 27 09:37:07 volumio volumio[1073]: { Error: connect ETIMEDOUT 205.186.152.122:443
Apr 27 09:37:07 volumio volumio[1073]: at Object._errnoException (util.js:1022:11)
Apr 27 09:37:07 volumio volumio[1073]: at _exceptionWithHostPort (util.js:1044:20)
Apr 27 09:37:07 volumio volumio[1073]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14)
Apr 27 09:37:07 volumio volumio[1073]: code: 'ETIMEDOUT',
Apr 27 09:37:07 volumio volumio[1073]: errno: 'ETIMEDOUT',
Apr 27 09:37:07 volumio volumio[1073]: syscall: 'connect',
Apr 27 09:37:07 volumio volumio[1073]: address: '205.186.152.122',
Apr 27 09:37:07 volumio volumio[1073]: port: 443 }
Apr 27 09:37:07 volumio volumio[1073]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 27 09:37:08 volumio sudo[14099]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-27 09:36
Apr 27 09:37:08 volumio sudo[14099]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 8 (jessie)"
NAME="Debian GNU/Linux"
VERSION_ID="8"
VERSION="8 (jessie)"
ID=debian
HOME_URL="http://www.debian.org/"
SUPPORT_URL="http://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="168ba7444df98cd868db72f24faec0b6346489cc"
VOLUMIO_FE_VERSION="847a48ecf32d35cc502a0053d585d1a69236e391"
VOLUMIO_BE_VERSION="03f7bbd984817e093cac62b7ff876f3c2cfabc1d"
VOLUMIO_ARCH="x86"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue Dec 22 15:00:46 CET 2020"
VOLUMIO_VERSION="2.861"
VOLUMIO_HARDWARE="x86"
VOLUMIO_HASH="b3401e25b8d19b16b1038c2843d2deaf"