-- Logs begin at Wed 2022-01-26 16:46:09 UTC, end at Wed 2025-01-15 18:27:41 UTC. -- Jan 15 18:26:29 opera--rds-1 volumio[1236]: info: Starting UPNP Playback Jan 15 18:26:29 opera--rds-1 volumio[1236]: info: Preparing playback through UPNP Jan 15 18:26:29 opera--rds-1 volumio[1236]: info: Consume mode Jan 15 18:26:29 opera--rds-1 volumio[1236]: info: CoreCommandRouter::volumioGetState Jan 15 18:26:29 opera--rds-1 volumio[1236]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 15 18:26:30 opera--rds-1 volumio[1236]: info: Jan 15 18:26:30 opera--rds-1 volumio[1236]: ---------------------------- MPD announces system playlist update Jan 15 18:26:30 opera--rds-1 volumio[1236]: info: Ignoring MPD Status Update Jan 15 18:26:30 opera--rds-1 volumio[1236]: info: ------------------------------ 2ms Jan 15 18:26:30 opera--rds-1 volumio[1236]: info: Jan 15 18:26:30 opera--rds-1 volumio[1236]: ---------------------------- MPD announces system playlist update Jan 15 18:26:30 opera--rds-1 volumio[1236]: info: Ignoring MPD Status Update Jan 15 18:26:30 opera--rds-1 volumio[1236]: info: ------------------------------ 2ms Jan 15 18:26:30 opera--rds-1 volumio[1236]: info: Jan 15 18:26:30 opera--rds-1 volumio[1236]: ---------------------------- MPD announces system playlist update Jan 15 18:26:30 opera--rds-1 volumio[1236]: info: Ignoring MPD Status Update Jan 15 18:26:30 opera--rds-1 volumio[1236]: info: ------------------------------ 2ms Jan 15 18:26:30 opera--rds-1 volumio[1236]: info: Jan 15 18:26:30 opera--rds-1 volumio[1236]: ---------------------------- MPD announces system playlist update Jan 15 18:26:30 opera--rds-1 volumio[1236]: info: Ignoring MPD Status Update Jan 15 18:26:30 opera--rds-1 volumio[1236]: info: ------------------------------ 2ms Jan 15 18:26:30 opera--rds-1 volumio[1236]: info: Jan 15 18:26:30 opera--rds-1 volumio[1236]: ---------------------------- MPD announces system playlist update Jan 15 18:26:30 opera--rds-1 volumio[1236]: info: Ignoring MPD Status Update Jan 15 18:26:30 opera--rds-1 volumio[1236]: info: ------------------------------ 2ms Jan 15 18:26:30 opera--rds-1 volumio[1236]: info: Jan 15 18:26:30 opera--rds-1 volumio[1236]: ---------------------------- MPD announces system playlist update Jan 15 18:26:30 opera--rds-1 volumio[1236]: info: Ignoring MPD Status Update Jan 15 18:26:30 opera--rds-1 volumio[1236]: info: ------------------------------ 2ms Jan 15 18:26:30 opera--rds-1 volumio[1236]: info: Jan 15 18:26:30 opera--rds-1 volumio[1236]: ---------------------------- MPD announces state update: player Jan 15 18:26:30 opera--rds-1 volumio[1236]: info: ControllerMpd::getState Jan 15 18:26:30 opera--rds-1 volumio[1236]: verbose: ControllerMpd::sendMpdCommand status Jan 15 18:26:30 opera--rds-1 volumio[1236]: info: sendMpdCommand status took 0 milliseconds Jan 15 18:26:30 opera--rds-1 volumio[1236]: verbose: ControllerMpd::parseState Jan 15 18:26:30 opera--rds-1 volumio[1236]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 18:26:30 opera--rds-1 volumio[1236]: info: sendMpdCommand playlistinfo took 5 milliseconds Jan 15 18:26:30 opera--rds-1 volumio[1236]: verbose: ControllerMpd::parseTrackInfo Jan 15 18:26:30 opera--rds-1 volumio[1236]: info: ControllerMpd::pushState Jan 15 18:26:30 opera--rds-1 volumio[1236]: info: CoreCommandRouter::servicePushState Jan 15 18:26:30 opera--rds-1 volumio[1236]: verbose: In UPNP mode Jan 15 18:26:30 opera--rds-1 volumio[1236]: verbose: STATE SERVICE {"status":"play","position":41,"seek":0,"duration":252,"samplerate":"11.28 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Thomas Crown Affair: Les moulins de mon coeur (Arr. Bert van den Brink)","artist":"Legrand","album":"Formidable! (French Chansons)","uri":"http://192.168.31.79:9790/minimserver/*/opera/DSD2561/Formidable/08_The-Thomas-Crown-Affair-Les-moulins-de-mon-coeur-Arr-Bert-van-den-Brink_256fs-2ch.dsf","trackType":"dsf"} Jan 15 18:26:30 opera--rds-1 volumio[1236]: verbose: CURRENT POSITION 0 Jan 15 18:26:30 opera--rds-1 volumio[1236]: info: CoreStateMachine::syncState stateService play Jan 15 18:26:30 opera--rds-1 volumio[1236]: info: CoreStateMachine::syncState currentStatus play Jan 15 18:26:30 opera--rds-1 volumio[1236]: info: Received an update from plugin. extracting info from payload Jan 15 18:26:30 opera--rds-1 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 18:26:30 opera--rds-1 volumio[1236]: info: CoreStateMachine::pushState Jan 15 18:26:30 opera--rds-1 volumio[1236]: info: CoreCommandRouter::volumioPushState Jan 15 18:26:30 opera--rds-1 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 18:26:30 opera--rds-1 volumio[1236]: info: CoreStateMachine::pushState Jan 15 18:26:30 opera--rds-1 volumio[1236]: info: CoreCommandRouter::volumioPushState Jan 15 18:26:30 opera--rds-1 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 18:26:30 opera--rds-1 volumio[1236]: info: ------------------------------ 16ms Jan 15 18:26:30 opera--rds-1 volumio[1236]: info: CoreCommandRouter::volumioGetQueue Jan 15 18:26:30 opera--rds-1 volumio[1236]: info: CoreStateMachine::getQueue Jan 15 18:26:30 opera--rds-1 volumio[1236]: info: CorePlayQueue::getQueue Jan 15 18:26:30 opera--rds-1 volumio[1236]: info: CoreCommandRouter::volumioGetQueue Jan 15 18:26:30 opera--rds-1 volumio[1236]: info: CoreStateMachine::getQueue Jan 15 18:26:30 opera--rds-1 volumio[1236]: info: CorePlayQueue::getQueue Jan 15 18:27:16 opera--rds-1 volumio[1236]: info: Starting UPNP Playback Jan 15 18:27:16 opera--rds-1 volumio[1236]: info: Preparing playback through UPNP Jan 15 18:27:16 opera--rds-1 volumio[1236]: info: Consume mode Jan 15 18:27:16 opera--rds-1 volumio[1236]: info: CoreCommandRouter::volumioGetState Jan 15 18:27:16 opera--rds-1 volumio[1236]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 15 18:27:17 opera--rds-1 volumio[1236]: info: Jan 15 18:27:17 opera--rds-1 volumio[1236]: ---------------------------- MPD announces system playlist update Jan 15 18:27:17 opera--rds-1 volumio[1236]: info: Ignoring MPD Status Update Jan 15 18:27:17 opera--rds-1 volumio[1236]: info: ------------------------------ 2ms Jan 15 18:27:17 opera--rds-1 volumio[1236]: info: Jan 15 18:27:17 opera--rds-1 volumio[1236]: ---------------------------- MPD announces system playlist update Jan 15 18:27:17 opera--rds-1 volumio[1236]: info: Ignoring MPD Status Update Jan 15 18:27:17 opera--rds-1 volumio[1236]: info: ------------------------------ 2ms Jan 15 18:27:17 opera--rds-1 volumio[1236]: info: Jan 15 18:27:17 opera--rds-1 volumio[1236]: ---------------------------- MPD announces system playlist update Jan 15 18:27:17 opera--rds-1 volumio[1236]: info: Ignoring MPD Status Update Jan 15 18:27:17 opera--rds-1 volumio[1236]: info: ------------------------------ 2ms Jan 15 18:27:17 opera--rds-1 volumio[1236]: info: Jan 15 18:27:17 opera--rds-1 volumio[1236]: ---------------------------- MPD announces system playlist update Jan 15 18:27:17 opera--rds-1 volumio[1236]: info: Ignoring MPD Status Update Jan 15 18:27:17 opera--rds-1 volumio[1236]: info: ------------------------------ 2ms Jan 15 18:27:17 opera--rds-1 volumio[1236]: info: Jan 15 18:27:17 opera--rds-1 volumio[1236]: ---------------------------- MPD announces system playlist update Jan 15 18:27:17 opera--rds-1 volumio[1236]: info: Ignoring MPD Status Update Jan 15 18:27:17 opera--rds-1 volumio[1236]: info: ------------------------------ 1ms Jan 15 18:27:17 opera--rds-1 volumio[1236]: info: Jan 15 18:27:17 opera--rds-1 volumio[1236]: ---------------------------- MPD announces system playlist update Jan 15 18:27:17 opera--rds-1 volumio[1236]: info: Ignoring MPD Status Update Jan 15 18:27:17 opera--rds-1 volumio[1236]: info: ------------------------------ 1ms Jan 15 18:27:17 opera--rds-1 volumio[1236]: info: Jan 15 18:27:17 opera--rds-1 volumio[1236]: ---------------------------- MPD announces state update: player Jan 15 18:27:17 opera--rds-1 volumio[1236]: info: ControllerMpd::getState Jan 15 18:27:17 opera--rds-1 volumio[1236]: verbose: ControllerMpd::sendMpdCommand status Jan 15 18:27:17 opera--rds-1 volumio[1236]: info: sendMpdCommand status took 0 milliseconds Jan 15 18:27:17 opera--rds-1 volumio[1236]: verbose: ControllerMpd::parseState Jan 15 18:27:17 opera--rds-1 volumio[1236]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 15 18:27:17 opera--rds-1 volumio[1236]: info: sendMpdCommand playlistinfo took 0 milliseconds Jan 15 18:27:17 opera--rds-1 volumio[1236]: verbose: ControllerMpd::parseTrackInfo Jan 15 18:27:17 opera--rds-1 volumio[1236]: info: ControllerMpd::pushState Jan 15 18:27:17 opera--rds-1 volumio[1236]: info: CoreCommandRouter::servicePushState Jan 15 18:27:17 opera--rds-1 volumio[1236]: verbose: In UPNP mode Jan 15 18:27:17 opera--rds-1 volumio[1236]: verbose: STATE SERVICE {"status":"play","position":42,"seek":0,"duration":155,"samplerate":"11.28 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Three Hungarian Dances: Moderato assai e molto espressivo","artist":"Huijnen & Grotenhuis","album":"Dance!","uri":"http://192.168.31.79:9790/minimserver/*/opera/DSD2561/Huijnen*20*26*20Grotenhuis*20-*20Dance!*20-*20*e8*88*9e*e8*b9*88*ef*bc*81*20(11.2MHz*20DSD)*202022/05.Moderato*20assai*20e*20molto*20espressivo.dsf","trackType":"dsf"} Jan 15 18:27:17 opera--rds-1 volumio[1236]: verbose: CURRENT POSITION 0 Jan 15 18:27:17 opera--rds-1 volumio[1236]: info: CoreStateMachine::syncState stateService play Jan 15 18:27:17 opera--rds-1 volumio[1236]: info: CoreStateMachine::syncState currentStatus play Jan 15 18:27:17 opera--rds-1 volumio[1236]: info: Received an update from plugin. extracting info from payload Jan 15 18:27:17 opera--rds-1 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 15 18:27:17 opera--rds-1 volumio[1236]: info: CoreStateMachine::pushState Jan 15 18:27:17 opera--rds-1 volumio[1236]: info: CoreCommandRouter::volumioPushState Jan 15 18:27:17 opera--rds-1 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 18:27:17 opera--rds-1 volumio[1236]: info: CoreStateMachine::pushState Jan 15 18:27:17 opera--rds-1 volumio[1236]: info: CoreCommandRouter::volumioPushState Jan 15 18:27:17 opera--rds-1 volumio[1236]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 15 18:27:17 opera--rds-1 volumio[1236]: info: ------------------------------ 24ms Jan 15 18:27:17 opera--rds-1 volumio[1236]: info: CoreCommandRouter::volumioGetQueue Jan 15 18:27:17 opera--rds-1 volumio[1236]: info: CoreStateMachine::getQueue Jan 15 18:27:17 opera--rds-1 volumio[1236]: info: CorePlayQueue::getQueue Jan 15 18:27:17 opera--rds-1 volumio[1236]: info: CoreCommandRouter::volumioGetQueue Jan 15 18:27:17 opera--rds-1 volumio[1236]: info: CoreStateMachine::getQueue Jan 15 18:27:17 opera--rds-1 volumio[1236]: info: CorePlayQueue::getQueue Jan 15 18:27:41 opera--rds-1 volumio[1236]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 15 18:27:41 opera--rds-1 volumio[1236]: { Error: connect ETIMEDOUT 108.160.167.156:443 Jan 15 18:27:41 opera--rds-1 volumio[1236]: at Object._errnoException (util.js:1022:11) Jan 15 18:27:41 opera--rds-1 volumio[1236]: at _exceptionWithHostPort (util.js:1044:20) Jan 15 18:27:41 opera--rds-1 volumio[1236]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Jan 15 18:27:41 opera--rds-1 volumio[1236]: code: 'ETIMEDOUT', Jan 15 18:27:41 opera--rds-1 volumio[1236]: errno: 'ETIMEDOUT', Jan 15 18:27:41 opera--rds-1 volumio[1236]: syscall: 'connect', Jan 15 18:27:41 opera--rds-1 volumio[1236]: address: '108.160.167.156', Jan 15 18:27:41 opera--rds-1 volumio[1236]: port: 443 } Jan 15 18:27:41 opera--rds-1 volumio[1236]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 15 18:27:41 opera--rds-1 sudo[28094]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-15 18:26 Jan 15 18:27:41 opera--rds-1 sudo[28094]: 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="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="307f91893fca011201acba9973e1c41bd3a0ad5d" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="opera" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Oct 1 16:18:39 CEST 2021" VOLUMIO_VERSION="1.031" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_VENDOR="Opera Consonance" VOLUMIO_MODEL="X5" VOLUMIO_VENDOR_MODEL="Opera X5" VOLUMIO_HASH="8579bfbfd528c599f57acb0dd7167775"