-- Logs begin at Sat 2024-06-08 07:39:30 CEST, end at Sun 2024-07-14 10:08:32 CEST. -- Jul 14 10:07:56 volumio ntpd[657]: receive: Unexpected origin timestamp 0xea0e6d65.892ff304 does not match aorg 0000000000.00000000 from server@89.250.197.242 xmt 0xea3e05dc.9ce2ed02 Jul 14 10:07:56 volumio ntpd[657]: receive: Unexpected origin timestamp 0xea0e6d65.894d6d65 does not match aorg 0000000000.00000000 from server@162.159.200.123 xmt 0xea3e05dc.9edc3d9a Jul 14 10:07:56 volumio ntpd[657]: receive: Unexpected origin timestamp 0xea0e6d65.89411b22 does not match aorg 0000000000.00000000 from server@91.227.212.78 xmt 0xea3e05dc.9d2f1c50 Jul 14 10:07:56 volumio ntpd[657]: receive: Unexpected origin timestamp 0xea0e6d65.8946d2b5 does not match aorg 0000000000.00000000 from server@195.46.37.22 xmt 0xea3e05dc.9f2698b1 Jul 14 10:07:56 volumio ntpd[657]: receive: Unexpected origin timestamp 0xea0e6d65.894a31b0 does not match aorg 0000000000.00000000 from server@149.156.70.60 xmt 0xea3e05dc.a0f7e290 Jul 14 10:07:56 volumio ntpd[657]: receive: Unexpected origin timestamp 0xea0e6d65.893d1298 does not match aorg 0000000000.00000000 from server@80.50.102.206 xmt 0xea3e05dc.a44a06c1 Jul 14 10:07:56 volumio systemd[1]: Starting Daily apt download activities... Jul 14 10:07:57 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 14 10:07:57 volumio volumio[739]: info: CURURI: music-library/NAS/NAS Jul 14 10:07:57 volumio volumio[739]: info: Preload queue cleared Jul 14 10:08:00 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 14 10:08:00 volumio volumio[739]: info: CURURI: music-library/NAS/NAS/flac Jul 14 10:08:00 volumio volumio[739]: info: Preload queue cleared Jul 14 10:08:00 volumio volumio[739]: info: Preloading song: music-library/NAS/NAS/flac/Adele - Rolling in the deep.flac Jul 14 10:08:01 volumio systemd[1]: apt-daily.service: Succeeded. Jul 14 10:08:01 volumio systemd[1]: Started Daily apt download activities. Jul 14 10:08:01 volumio systemd[1]: Starting Daily apt upgrade and clean activities... Jul 14 10:08:01 volumio volumio[739]: info: Exploding uri music-library/NAS/NAS/flac/Adele - Rolling in the deep.flac in service mpd Jul 14 10:08:01 volumio volumio[739]: info: ALBUMART /albumart?cacheid=831&web=Adele/21%20(Limited%20Edition)/extralarge&path=%2Fmnt%2FNAS%2FNAS%2Fflac%2FAdele%20-%20Rolling%20in%20the%20deep.flac&metadata=false Jul 14 10:08:01 volumio volumio[739]: info: URI /mnt/NAS/NAS/flac/Adele - Rolling in the deep.flac Jul 14 10:08:03 volumio telegraf[659]: 2024-07-14T08:08:03Z E! [inputs.exec] Error in plugin: exec: exit status 255 for command "/opt/vc/bin/vcgencmd measure_temp": Jul 14 10:08:03 volumio volumio[739]: info: MyVolumio login type: Token Jul 14 10:08:03 volumio telegraf[659]: 2024-07-14T08:08:03Z E! [outputs.influxdb_v2] When writing to [http://192.168.0.18:8086]: Post "http://192.168.0.18:8086/api/v2/write?bucket=rasp-pi&org=m%26m": dial tcp 192.168.0.18:8086: connect: no route to host Jul 14 10:08:03 volumio telegraf[659]: 2024-07-14T08:08:03Z E! [agent] Error writing to outputs.influxdb_v2: failed to send metrics to any configured server(s) Jul 14 10:08:04 volumio volumio[739]: error: MyVolumio Custom Token format not valid, refreshing it Jul 14 10:08:04 volumio systemd[1]: apt-daily-upgrade.service: Succeeded. Jul 14 10:08:04 volumio systemd[1]: Started Daily apt upgrade and clean activities. Jul 14 10:08:04 volumio volumio[739]: info: Discovery: A device disappeared from network Jul 14 10:08:04 volumio volumio[739]: info: Discovery: Device volumio disappeared from network Jul 14 10:08:04 volumio volumio[739]: info: MyVolumio login type: Token Jul 14 10:08:04 volumio volumio[739]: info: Discovery: adding 82894419-1500-4b82-a239-a8fab822c6f6 Jul 14 10:08:04 volumio volumio[739]: info: Discovery: Found device Volumio Jul 14 10:08:04 volumio volumio[739]: info: CoreCommandRouter::volumioGetState Jul 14 10:08:04 volumio volumio[739]: info: CorePlayQueue::getTrack 0 Jul 14 10:08:05 volumio volumio[739]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Jul 14 10:08:06 volumio volumio[739]: info: MyVolumio token set successfully Jul 14 10:08:06 volumio volumio[739]: info: MYVOLUMIO: Adding device Jul 14 10:08:06 volumio volumio[739]: info: MYVOLUMIO: Evaluating Server Jul 14 10:08:06 volumio volumio[739]: info: MyVolumio status changed Jul 14 10:08:06 volumio volumio[739]: info: Streaming services startup Jul 14 10:08:06 volumio volumio[739]: info: Starting Streaming Daemon Jul 14 10:08:06 volumio volumio[739]: info: Removing browser output: myVolumio user plan is not superstar Jul 14 10:08:06 volumio volumio[739]: info: Removing audio output: Jul 14 10:08:06 volumio volumio[739]: info: Stoppping Tunnel 1 Jul 14 10:08:06 volumio sudo[1408]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jul 14 10:08:06 volumio sudo[1408]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 10:08:06 volumio sudo[1410]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Jul 14 10:08:06 volumio sudo[1410]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 14 10:08:06 volumio sudo[1408]: pam_unix(sudo:session): session closed for user root Jul 14 10:08:06 volumio volumio[739]: error: Cannot start Volumio Streaming Daemon Jul 14 10:08:06 volumio volumio[739]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jul 14 10:08:06 volumio volumio[739]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jul 14 10:08:06 volumio sudo[1410]: pam_unix(sudo:session): session closed for user root Jul 14 10:08:06 volumio volumio[739]: info: Remote SSH Stopped Jul 14 10:08:06 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 14 10:08:06 volumio volumio[739]: info: CURURI: music-library/NAS/NAS/flac/marek Jul 14 10:08:07 volumio volumio[739]: info: Preload queue cleared Jul 14 10:08:07 volumio volumio[739]: info: Setting Geolocation for MyVolumio to eu7 Jul 14 10:08:07 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 10:08:07 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 10:08:07 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 10:08:08 volumio volumio[739]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Jul 14 10:08:08 volumio volumio[739]: info: Updating MyVolumio device info Jul 14 10:08:08 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 10:08:09 volumio volumio[739]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Jul 14 10:08:10 volumio telegraf[659]: 2024-07-14T08:08:10Z E! [inputs.exec] Error in plugin: exec: exit status 255 for command "/opt/vc/bin/vcgencmd measure_temp": Jul 14 10:08:12 volumio volumio[739]: info: MYVOLUMIO: Adding device Jul 14 10:08:12 volumio volumio[739]: info: MYVOLUMIO: Evaluating Server Jul 14 10:08:13 volumio volumio[739]: info: Setting Geolocation for MyVolumio to eu4 Jul 14 10:08:13 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 10:08:13 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 10:08:13 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 10:08:13 volumio volumio[739]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Jul 14 10:08:13 volumio telegraf[659]: 2024-07-14T08:08:13Z E! [outputs.influxdb_v2] When writing to [http://192.168.0.18:8086]: Post "http://192.168.0.18:8086/api/v2/write?bucket=rasp-pi&org=m%26m": dial tcp 192.168.0.18:8086: connect: no route to host Jul 14 10:08:13 volumio telegraf[659]: 2024-07-14T08:08:13Z E! [agent] Error writing to outputs.influxdb_v2: failed to send metrics to any configured server(s) Jul 14 10:08:14 volumio volumio[739]: info: Updating MyVolumio device info Jul 14 10:08:14 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 10:08:14 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 10:08:14 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 14 10:08:14 volumio volumio[739]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Jul 14 10:08:15 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 14 10:08:15 volumio volumio[739]: info: CURURI: music-library/NAS/NAS/flac/marek/QUEEN Jul 14 10:08:15 volumio volumio[739]: info: Preload queue cleared Jul 14 10:08:17 volumio volumio[739]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 14 10:08:17 volumio volumio[739]: info: CURURI: music-library/NAS/NAS/flac/marek/QUEEN/Live Albums Jul 14 10:08:18 volumio volumio[739]: info: Preload queue cleared Jul 14 10:08:20 volumio telegraf[659]: 2024-07-14T08:08:20Z E! [inputs.exec] Error in plugin: exec: exit status 255 for command "/opt/vc/bin/vcgencmd measure_temp": Jul 14 10:08:23 volumio telegraf[659]: 2024-07-14T08:08:23Z E! [outputs.influxdb_v2] When writing to [http://192.168.0.18:8086]: Post "http://192.168.0.18:8086/api/v2/write?bucket=rasp-pi&org=m%26m": dial tcp 192.168.0.18:8086: connect: no route to host Jul 14 10:08:23 volumio telegraf[659]: 2024-07-14T08:08:23Z E! [agent] Error writing to outputs.influxdb_v2: failed to send metrics to any configured server(s) Jul 14 10:08:30 volumio telegraf[659]: 2024-07-14T08:08:30Z E! [inputs.exec] Error in plugin: exec: exit status 255 for command "/opt/vc/bin/vcgencmd measure_temp": Jul 14 10:08:31 volumio volumio[739]: info: Preload queue cleared Jul 14 10:08:31 volumio volumio[739]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 14 10:08:31 volumio volumio[739]: info: CoreStateMachine::ClearQueue Jul 14 10:08:31 volumio volumio[739]: info: CoreStateMachine::stop Jul 14 10:08:31 volumio volumio[739]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 14 10:08:31 volumio volumio[739]: info: CorePlayQueue::clearPlayQueue Jul 14 10:08:31 volumio volumio[739]: info: CorePlayQueue::saveQueue Jul 14 10:08:31 volumio volumio[739]: info: CoreCommandRouter::volumioPushQueue Jul 14 10:08:31 volumio volumio[739]: info: CoreStateMachine::addQueueItems Jul 14 10:08:31 volumio volumio[739]: info: CorePlayQueue::addQueueItems Jul 14 10:08:31 volumio volumio[739]: info: Preload queue cleared Jul 14 10:08:31 volumio volumio[739]: info: Adding Item to queue: music-library/NAS/NAS/flac/marek/QUEEN/Live Albums/1986. Queen - Live Magic (1986, EMI, UK, CDP 7 46413 2) Jul 14 10:08:31 volumio volumio[739]: info: Exploding uri music-library/NAS/NAS/flac/marek/QUEEN/Live Albums/1986. Queen - Live Magic (1986, EMI, UK, CDP 7 46413 2) in service mpd Jul 14 10:08:31 volumio volumio[739]: info: ALBUMART /albumart?cacheid=831&web=Queen/Live%20Magic%20(1986%2C%20EMI%2C%20UK%2C%20CDP%207%2046413%202)/extralarge&path=%2Fmnt%2FNAS%2FNAS%2Fflac%2Fmarek%2FQUEEN%2FLive%20Albums%2F1986.%20Queen%20-%20Live%20Magic%20(1986%2C%20EMI%2C%20UK%2C%20CDP%207%2046413%202)%2FQueen%20-%20Live%20Magic.cue&metadata=false Jul 14 10:08:31 volumio volumio[739]: info: URI /mnt/NAS/NAS/flac/marek/QUEEN/Live Albums/1986. Queen - Live Magic (1986, EMI, UK, CDP 7 46413 2)/Queen - Live Magic.cue Jul 14 10:08:31 volumio volumio[739]: info: ALBUMART /albumart?cacheid=831&web=Queen/Live%20Magic%20(1986%2C%20EMI%2C%20UK%2C%20CDP%207%2046413%202)/extralarge&path=%2Fmnt%2FNAS%2FNAS%2Fflac%2Fmarek%2FQUEEN%2FLive%20Albums%2F1986.%20Queen%20-%20Live%20Magic%20(1986%2C%20EMI%2C%20UK%2C%20CDP%207%2046413%202)%2FQueen%20-%20Live%20Magic.cue&metadata=false Jul 14 10:08:31 volumio volumio[739]: info: URI /mnt/NAS/NAS/flac/marek/QUEEN/Live Albums/1986. Queen - Live Magic (1986, EMI, UK, CDP 7 46413 2)/Queen - Live Magic.cue Jul 14 10:08:31 volumio volumio[739]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 14 10:08:31 volumio volumio[739]: Error: Unable to resolve or reject the same promise twice Jul 14 10:08:31 volumio volumio[739]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Jul 14 10:08:31 volumio volumio[739]: at /volumio/app/plugins/music_service/mpd/index.js:2568:21 Jul 14 10:08:31 volumio volumio[739]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Jul 14 10:08:31 volumio volumio[739]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Jul 14 10:08:31 volumio volumio[739]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Jul 14 10:08:31 volumio volumio[739]: at Socket.emit (events.js:315:20) Jul 14 10:08:31 volumio volumio[739]: at addChunk (internal/streams/readable.js:309:12) Jul 14 10:08:31 volumio volumio[739]: at readableAddChunk (internal/streams/readable.js:280:11) Jul 14 10:08:31 volumio volumio[739]: at Socket.Readable.push (internal/streams/readable.js:223:10) Jul 14 10:08:31 volumio volumio[739]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Jul 14 10:08:31 volumio volumio[739]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 14 10:08:32 volumio sudo[1456]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-14 10:07 Jul 14 10:08:32 volumio sudo[1456]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="ef589a0572b08c3d1e9a984ec6a655ef3698e415" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="abe72e92bc7de90ab6193cbc17e21ad2750980a2" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 28 May 2024 12:17:12 PM CEST" VOLUMIO_VERSION="3.695" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="8f37ff40efaaf3752fac55d6a95d61cb"