-- Logs begin at Thu 2025-06-05 09:15:26 UTC, end at Mon 2025-06-09 20:42:11 UTC. -- Jun 09 20:41:22 opera volumio[1367]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 09 20:41:22 opera volumio[1367]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 09 20:41:22 opera volumio[1367]: info: Discovery: Getting this device information Jun 09 20:41:22 opera volumio[1367]: info: CoreCommandRouter::volumioGetState Jun 09 20:41:22 opera volumio[1367]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Jun 09 20:41:22 opera volumio[1367]: info: CoreCommandRouter::executeOnPlugin: system , getConf Jun 09 20:41:22 opera volumio[1367]: info: CoreCommandRouter::executeOnPlugin: system , getConf Jun 09 20:41:26 opera volumio[1367]: info: CALLMETHOD: music_service squeezelite updateSqueezeliteAudioConfig [object Object] Jun 09 20:41:26 opera volumio[1367]: info: CoreCommandRouter::executeOnPlugin: squeezelite , updateSqueezeliteAudioConfig Jun 09 20:41:26 opera volumio[1367]: info: Successfully updated Squeezelite audio configuration Jun 09 20:41:26 opera volumio[1367]: info: New unit-file created! Jun 09 20:41:26 opera sudo[9863]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Jun 09 20:41:26 opera sudo[9863]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 09 20:41:26 opera systemd[1]: Reloading. Jun 09 20:41:26 opera systemd[1]: [/lib/systemd/system/mpd.service:18] Unknown lvalue 'ProtectKernelTunables' in section 'Service' Jun 09 20:41:26 opera systemd[1]: [/lib/systemd/system/mpd.service:19] Unknown lvalue 'ProtectControlGroups' in section 'Service' Jun 09 20:41:26 opera systemd[1]: [/lib/systemd/system/mpd.service:20] Unknown lvalue 'ProtectKernelModules' in section 'Service' Jun 09 20:41:26 opera systemd[1]: [/lib/systemd/system/mpd.service:23] Unknown lvalue 'RestrictNamespaces' in section 'Service' Jun 09 20:41:26 opera systemd[1]: [/lib/systemd/system/volumio-remote-updater-push.service:6] Failed to parse usec_t value, ignoring: infinity Jun 09 20:41:26 opera systemd[1]: Configuration file /lib/systemd/system/volumiobt.service is marked executable. Please remove executable permission bits. Proceeding anyway. Jun 09 20:41:26 opera sudo[9863]: pam_unix(sudo:session): session closed for user root Jun 09 20:41:26 opera volumio[1367]: info: squeezelite reloaded Jun 09 20:41:26 opera sudo[9883]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart squeezelite Jun 09 20:41:26 opera sudo[9883]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 09 20:41:26 opera systemd[1]: Starting Squeezelite lightweight headless Squeezebox emulator... Jun 09 20:41:26 opera systemd[1]: Started Squeezelite lightweight headless Squeezebox emulator. Jun 09 20:41:26 opera squeezelite[9888]: [20:41:26.653649] test_open:281 playback open error: No such file or directory Jun 09 20:41:26 opera squeezelite[9888]: [20:41:26.653743] output_init_common:401 unable to open output device: default:CARD=OnBoard Jun 09 20:41:26 opera sudo[9883]: pam_unix(sudo:session): session closed for user root Jun 09 20:41:26 opera volumio[1367]: info: squeezelite started Jun 09 20:41:26 opera systemd[1]: squeezelite.service holdoff time over, scheduling restart. Jun 09 20:41:26 opera systemd[1]: Stopping Squeezelite lightweight headless Squeezebox emulator... Jun 09 20:41:26 opera systemd[1]: Starting Squeezelite lightweight headless Squeezebox emulator... Jun 09 20:41:26 opera systemd[1]: Started Squeezelite lightweight headless Squeezebox emulator. Jun 09 20:41:26 opera squeezelite[9895]: [20:41:26.967513] test_open:281 playback open error: No such file or directory Jun 09 20:41:26 opera squeezelite[9895]: [20:41:26.968294] output_init_common:401 unable to open output device: default:CARD=OnBoard Jun 09 20:41:27 opera systemd[1]: squeezelite.service holdoff time over, scheduling restart. Jun 09 20:41:27 opera systemd[1]: Stopping Squeezelite lightweight headless Squeezebox emulator... Jun 09 20:41:27 opera systemd[1]: Starting Squeezelite lightweight headless Squeezebox emulator... Jun 09 20:41:27 opera systemd[1]: Started Squeezelite lightweight headless Squeezebox emulator. Jun 09 20:41:27 opera squeezelite[9902]: [20:41:27.218992] test_open:281 playback open error: No such file or directory Jun 09 20:41:27 opera squeezelite[9902]: [20:41:27.219659] output_init_common:401 unable to open output device: default:CARD=OnBoard Jun 09 20:41:27 opera systemd[1]: squeezelite.service holdoff time over, scheduling restart. Jun 09 20:41:27 opera systemd[1]: Stopping Squeezelite lightweight headless Squeezebox emulator... Jun 09 20:41:27 opera systemd[1]: Starting Squeezelite lightweight headless Squeezebox emulator... Jun 09 20:41:27 opera systemd[1]: Started Squeezelite lightweight headless Squeezebox emulator. Jun 09 20:41:27 opera squeezelite[9906]: [20:41:27.462350] test_open:281 playback open error: No such file or directory Jun 09 20:41:27 opera squeezelite[9906]: [20:41:27.462430] output_init_common:401 unable to open output device: default:CARD=OnBoard Jun 09 20:41:27 opera systemd[1]: squeezelite.service holdoff time over, scheduling restart. Jun 09 20:41:27 opera systemd[1]: Stopping Squeezelite lightweight headless Squeezebox emulator... Jun 09 20:41:27 opera systemd[1]: Starting Squeezelite lightweight headless Squeezebox emulator... Jun 09 20:41:27 opera systemd[1]: Started Squeezelite lightweight headless Squeezebox emulator. Jun 09 20:41:27 opera squeezelite[9910]: [20:41:27.711630] test_open:281 playback open error: No such file or directory Jun 09 20:41:27 opera squeezelite[9910]: [20:41:27.711728] output_init_common:401 unable to open output device: default:CARD=OnBoard Jun 09 20:41:27 opera systemd[1]: squeezelite.service holdoff time over, scheduling restart. Jun 09 20:41:27 opera systemd[1]: Stopping Squeezelite lightweight headless Squeezebox emulator... Jun 09 20:41:27 opera systemd[1]: Starting Squeezelite lightweight headless Squeezebox emulator... Jun 09 20:41:27 opera systemd[1]: squeezelite.service start request repeated too quickly, refusing to start. Jun 09 20:41:27 opera systemd[1]: Failed to start Squeezelite lightweight headless Squeezebox emulator. Jun 09 20:41:27 opera systemd[1]: Unit squeezelite.service entered failed state. Jun 09 20:41:48 opera sudo[9958]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 09 20:41:48 opera sudo[9958]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 09 20:41:48 opera sudo[9958]: pam_unix(sudo:session): session closed for user root Jun 09 20:41:48 opera sudo[9962]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 09 20:41:48 opera sudo[9962]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 09 20:41:48 opera sudo[9962]: pam_unix(sudo:session): session closed for user root Jun 09 20:41:49 opera sudo[9976]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 09 20:41:49 opera sudo[9976]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 09 20:41:49 opera sudo[9976]: pam_unix(sudo:session): session closed for user root Jun 09 20:41:49 opera sudo[9980]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 09 20:41:49 opera sudo[9980]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 09 20:41:49 opera sudo[9980]: pam_unix(sudo:session): session closed for user root Jun 09 20:41:49 opera volumio[1367]: info: CoreCommandRouter::volumioGetState Jun 09 20:41:49 opera volumio[1367]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 09 20:41:49 opera volumio[1367]: error: Could not retrieve plugin audio_interface multiroom Jun 09 20:41:49 opera volumio[1367]: info: Listing playlists Jun 09 20:41:49 opera volumio[1367]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 09 20:41:49 opera volumio[1367]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 09 20:41:49 opera volumio[1367]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 09 20:41:49 opera volumio[1367]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 09 20:41:51 opera volumio[1367]: info: CoreCommandRouter::volumioGetVisibleSources Jun 09 20:41:51 opera volumio[1367]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 09 20:41:51 opera volumio[1367]: info: CoreCommandRouter::volumioGetQueue Jun 09 20:41:51 opera volumio[1367]: info: CoreStateMachine::getQueue Jun 09 20:41:51 opera volumio[1367]: info: CorePlayQueue::getQueue Jun 09 20:41:52 opera volumio[1367]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 09 20:41:52 opera volumio[1367]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 09 20:41:52 opera volumio[1367]: info: Discovery: Getting this device information Jun 09 20:41:52 opera volumio[1367]: info: CoreCommandRouter::volumioGetState Jun 09 20:41:52 opera volumio[1367]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Jun 09 20:41:52 opera volumio[1367]: info: CoreCommandRouter::executeOnPlugin: system , getConf Jun 09 20:41:52 opera volumio[1367]: info: CoreCommandRouter::executeOnPlugin: system , getConf Jun 09 20:41:52 opera dhcpd[1400]: DHCPDISCOVER from 48:e7:da:4f:03:21 (opera) via wlan0 Jun 09 20:41:53 opera dhcpd[1400]: DHCPOFFER on 192.168.211.12 to 48:e7:da:4f:03:21 (opera) via wlan0 Jun 09 20:42:05 opera volumio[1367]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri Jun 09 20:42:07 opera volumio[1367]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 09 20:42:07 opera volumio[1367]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jun 09 20:42:07 opera volumio[1367]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jun 09 20:42:07 opera volumio[1367]: error: Could not retrieve plugin system_controller my_volumio Jun 09 20:42:07 opera volumio[1367]: info: Received Get System Version Jun 09 20:42:07 opera volumio[1367]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 09 20:42:08 opera volumio[1367]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri Jun 09 20:42:10 opera volumio[1367]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 09 20:42:10 opera volumio[1367]: info: CoreStateMachine::ClearQueue Jun 09 20:42:10 opera volumio[1367]: info: CoreStateMachine::stop Jun 09 20:42:10 opera volumio[1367]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 09 20:42:10 opera volumio[1367]: verbose: UNSET VOLATILE Jun 09 20:42:10 opera volumio[1367]: info: CoreStateMachine::updateTrackBlock Jun 09 20:42:10 opera volumio[1367]: info: CorePlayQueue::getTrackBlock Jun 09 20:42:10 opera volumio[1367]: info: CoreStateMachine::stPlaybackTimer Jun 09 20:42:10 opera volumio[1367]: info: CoreStateMachine::pushState Jun 09 20:42:10 opera volumio[1367]: info: CorePlayQueue::getTrack 3 Jun 09 20:42:10 opera volumio[1367]: info: CoreCommandRouter::volumioPushState Jun 09 20:42:10 opera volumio[1367]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 09 20:42:10 opera volumio[1367]: info: CoreStateMachine::serviceStop Jun 09 20:42:10 opera volumio[1367]: info: CorePlayQueue::getTrack 3 Jun 09 20:42:10 opera volumio[1367]: info: CoreCommandRouter::serviceStop Jun 09 20:42:10 opera volumio[1367]: info: [1749501730403] ControllerQobuz::stop Jun 09 20:42:10 opera volumio[1367]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 09 20:42:10 opera volumio[1367]: info: ControllerMpd::stop Jun 09 20:42:10 opera volumio[1367]: verbose: ControllerMpd::sendMpdCommand stop Jun 09 20:42:10 opera volumio[1367]: info: CorePlayQueue::clearPlayQueue Jun 09 20:42:10 opera volumio[1367]: info: CorePlayQueue::saveQueue Jun 09 20:42:10 opera volumio[1367]: info: CoreCommandRouter::volumioPushState Jun 09 20:42:10 opera volumio[1367]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 09 20:42:10 opera volumio[1367]: info: CoreCommandRouter::volumioPushQueue Jun 09 20:42:10 opera volumio[1367]: info: CoreStateMachine::addQueueItems Jun 09 20:42:10 opera volumio[1367]: info: CorePlayQueue::addQueueItems Jun 09 20:42:10 opera volumio[1367]: info: Adding Item to queue: webkbs/0 Jun 09 20:42:10 opera volumio[1367]: info: Exploding uri webkbs/0 in service personal_radio Jun 09 20:42:10 opera volumio[1367]: info: Jun 09 20:42:10 opera volumio[1367]: ---------------------------- MPD announces state update: player Jun 09 20:42:10 opera volumio[1367]: info: sendMpdCommand stop took 92 milliseconds Jun 09 20:42:10 opera volumio[1367]: info: ControllerMpd::getState Jun 09 20:42:10 opera volumio[1367]: verbose: ControllerMpd::sendMpdCommand status Jun 09 20:42:10 opera volumio[1367]: info: sendMpdCommand status took 0 milliseconds Jun 09 20:42:10 opera volumio[1367]: verbose: ControllerMpd::parseState Jun 09 20:42:10 opera volumio[1367]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 09 20:42:10 opera volumio[1367]: info: sendMpdCommand playlistinfo took 3 milliseconds Jun 09 20:42:10 opera volumio[1367]: verbose: ControllerMpd::parseTrackInfo Jun 09 20:42:10 opera volumio[1367]: info: ControllerMpd::pushState Jun 09 20:42:10 opera volumio[1367]: info: CoreCommandRouter::servicePushState Jun 09 20:42:10 opera volumio[1367]: info: CoreStateMachine::pushState Jun 09 20:42:10 opera volumio[1367]: info: CoreCommandRouter::volumioPushState Jun 09 20:42:10 opera volumio[1367]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 09 20:42:10 opera volumio[1367]: info: CorePlayQueue::getTrack 3 Jun 09 20:42:10 opera volumio[1367]: 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":"file?uid=2648451&eid=313548717&fmt=7&profile=raw&app_id=539451548&cid=2814801&etsp=1749504919&hmac=5A4HgkJI068f_g5sde8pw3VUB38","artist":null,"album":null,"uri":"https://streaming-qobuz-std.akamaized.net/file?uid=2648451&eid=313548717&fmt=7&profile=raw&app_id=539451548&cid=2814801&etsp=1749504919&hmac=5A4HgkJI068f_g5sde8pw3VUB38","trackType":"qobuz"} Jun 09 20:42:10 opera volumio[1367]: verbose: CURRENT POSITION 3 Jun 09 20:42:10 opera volumio[1367]: info: CoreStateMachine::syncState stateService stop Jun 09 20:42:10 opera volumio[1367]: info: CoreStateMachine::syncState currentStatus stop Jun 09 20:42:10 opera volumio[1367]: info: CoreStateMachine::pushState Jun 09 20:42:10 opera volumio[1367]: info: CoreCommandRouter::volumioPushState Jun 09 20:42:10 opera volumio[1367]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 09 20:42:10 opera volumio[1367]: info: No code Jun 09 20:42:10 opera volumio[1367]: info: CoreStateMachine::pushState Jun 09 20:42:10 opera volumio[1367]: info: CoreCommandRouter::volumioPushState Jun 09 20:42:10 opera volumio[1367]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 09 20:42:10 opera volumio[1367]: info: ------------------------------ 38ms Jun 09 20:42:11 opera volumio[1367]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 09 20:42:11 opera volumio[1367]: ReferenceError: self is not defined Jun 09 20:42:11 opera volumio[1367]: at ControllerPersonalRadio.errorToast (/data/plugins/music_service/personal_radio/index.js:575:22) Jun 09 20:42:11 opera volumio[1367]: at /data/plugins/music_service/personal_radio/index.js:487:12 Jun 09 20:42:11 opera volumio[1367]: at Request.handleRequestResponse [as _callback] (/data/plugins/music_service/personal_radio/node_modules/unirest/index.js:355:15) Jun 09 20:42:11 opera volumio[1367]: at self.callback (/data/plugins/music_service/personal_radio/node_modules/request/request.js:187:22) Jun 09 20:42:11 opera volumio[1367]: at emitOne (events.js:116:13) Jun 09 20:42:11 opera volumio[1367]: at Request.emit (events.js:211:7) Jun 09 20:42:11 opera volumio[1367]: at Request.onRequestError (/data/plugins/music_service/personal_radio/node_modules/request/request.js:813:8) Jun 09 20:42:11 opera volumio[1367]: at emitOne (events.js:116:13) Jun 09 20:42:11 opera volumio[1367]: at ClientRequest.emit (events.js:211:7) Jun 09 20:42:11 opera volumio[1367]: at Socket.socketErrorListener (_http_client.js:387:9) Jun 09 20:42:11 opera volumio[1367]: at emitOne (events.js:116:13) Jun 09 20:42:11 opera volumio[1367]: at Socket.emit (events.js:211:7) Jun 09 20:42:11 opera volumio[1367]: at emitErrorNT (internal/streams/destroy.js:64:8) Jun 09 20:42:11 opera volumio[1367]: at _combinedTickCallback (internal/process/next_tick.js:138:11) Jun 09 20:42:11 opera volumio[1367]: at process._tickCallback (internal/process/next_tick.js:180:9) Jun 09 20:42:11 opera volumio[1367]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 09 20:42:11 opera sudo[10078]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-09 20:41 Jun 09 20:42:11 opera sudo[10078]: 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="047a38c6e11e7058b10d3038ac9dcbff94f92828" VOLUMIO_BE_VERSION="3e944f35d34b575025d16b976b4cb4d9aed53b66" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="opera" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Apr 8 17:29:57 CEST 2022" VOLUMIO_VERSION="1.033" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_VENDOR="Opera Consonance" VOLUMIO_MODEL="X5" VOLUMIO_VENDOR_MODEL="Opera X5" VOLUMIO_HASH="77fa3b0bf86939c934741dd9bb62adcc"