-- Logs begin at Tue 2025-01-21 02:25:11 UTC, end at Fri 2025-06-06 17:00:37 UTC. -- Jun 06 17:00:26 opera systemd[1]: Time has been changed Jun 06 17:00:27 opera volumio[890]: info: Loading plugin "i2s_dacs"... Jun 06 17:00:27 opera volumio[890]: info: I2S DAC not set, start Auto-detection Jun 06 17:00:27 opera volumio[890]: info: Loading plugin "volumiodiscovery"... Jun 06 17:00:27 opera volumio[890]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 06 17:00:27 opera node[890]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 06 17:00:27 opera volumio[890]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 06 17:00:27 opera node[890]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 06 17:00:27 opera volumio[890]: *** WARNING *** For more information see Jun 06 17:00:27 opera node[890]: *** WARNING *** For more information see Jun 06 17:00:27 opera node[890]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 06 17:00:27 opera node[890]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 06 17:00:27 opera node[890]: *** WARNING *** For more information see Jun 06 17:00:27 opera volumio[890]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 06 17:00:27 opera volumio[890]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 06 17:00:27 opera volumio[890]: *** WARNING *** For more information see Jun 06 17:00:27 opera volumio[890]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 06 17:00:27 opera volumio[890]: Discovery: StartAdv! undefined Jun 06 17:00:27 opera volumio[890]: Discovery: Started advertising... Opera - undefined Jun 06 17:00:27 opera volumio[890]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 06 17:00:27 opera volumio[890]: info: Loading plugin "albumart"... Jun 06 17:00:27 opera volumio[890]: info: Plugin example_plugin is not enabled Jun 06 17:00:27 opera volumio[890]: info: Loading plugin "updater_comm"... Jun 06 17:00:28 opera volumio[890]: info: Plugin mpdemulation is not enabled Jun 06 17:00:28 opera volumio[890]: info: Loading plugin "websocket"... Jun 06 17:00:28 opera volumio[890]: info: ___________ START PLUGINS ___________ Jun 06 17:00:28 opera volumio[890]: info: PLUGIN START: appearance Jun 06 17:00:28 opera volumio[890]: info: PLUGIN START: webradio Jun 06 17:00:28 opera volumio[890]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 06 17:00:28 opera volumio[890]: info: [1749229228368] CoreMusicLibrary::Adding element Webradio Jun 06 17:00:28 opera volumio[890]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 06 17:00:28 opera volumio[890]: info: Loading i18n strings for locale en Jun 06 17:00:28 opera volumio[890]: Updating browse sources language Jun 06 17:00:28 opera volumio[890]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 06 17:00:28 opera volumio[890]: info: CoreCommandRouter::initPlayerControls Jun 06 17:00:28 opera volumio[890]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 06 17:00:28 opera volumio[890]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Jun 06 17:00:28 opera volumio[890]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 06 17:00:28 opera volumio[890]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 06 17:00:28 opera volumio[890]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 06 17:00:28 opera volumio[890]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 06 17:00:28 opera volumio[890]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 06 17:00:28 opera volumio[890]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 06 17:00:28 opera volumio[890]: info: BOOT COMPLETED Jun 06 17:00:28 opera volumio[890]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 06 17:00:28 opera volumio[890]: info: CoreCommandRouter::Close All Modals sent Jun 06 17:00:28 opera volumio[890]: Express server listening on port 3000 Jun 06 17:00:28 opera volumio[890]: Volumio Calling Home Jun 06 17:00:29 opera volumio[890]: info: CoreStateMachine::resetVolumioState Jun 06 17:00:29 opera volumio[890]: info: CoreStateMachine::getcurrentVolume Jun 06 17:00:29 opera volumio[890]: info: CoreCommandRouter::volumioRetrievevolume Jun 06 17:00:29 opera volumio[890]: info: CoreStateMachine::updateTrackBlock Jun 06 17:00:29 opera volumio[890]: info: CorePlayQueue::getTrackBlock Jun 06 17:00:29 opera volumio[890]: info: Setting Device type: Odroid-C Jun 06 17:00:29 opera volumio[890]: info: MPD running with PID517 ,establishing connection Jun 06 17:00:29 opera sudo[1092]: pam_unix(sudo:auth): conversation failed Jun 06 17:00:29 opera sudo[1092]: pam_unix(sudo:auth): auth could not identify password for [volumio] Jun 06 17:00:30 opera volumio[890]: info: Cannot read I2C interface or I2C interface not presentError: Command failed: /usr/bin/sudo /usr/sbin/i2cdetect -y 1 Jun 06 17:00:30 opera volumio[890]: sudo: no tty present and no askpass program specified Jun 06 17:00:30 opera volumio[890]: info: Reloading queue from file Jun 06 17:00:30 opera volumio[890]: info: VolumeController:: Volume=undefined Mute =undefined Jun 06 17:00:30 opera volumio-remote-updater[477]: [2025-06-06 17:00:30] [connect] Successful connection Jun 06 17:00:30 opera volumio[890]: info: CoreStateMachine::pushState Jun 06 17:00:30 opera volumio[890]: info: CoreStateMachine::getState Jun 06 17:00:30 opera volumio[890]: info: CorePlayQueue::getTrack 0 Jun 06 17:00:31 opera volumio[890]: info: CoreCommandRouter::volumioPushState Jun 06 17:00:31 opera volumio[890]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 06 17:00:31 opera volumio[890]: info: CoreStateMachine::setRepeat true single undefined Jun 06 17:00:31 opera volumio[890]: info: CoreStateMachine::pushState Jun 06 17:00:31 opera volumio[890]: info: CoreStateMachine::getState Jun 06 17:00:31 opera volumio[890]: info: CorePlayQueue::getTrack 0 Jun 06 17:00:31 opera volumio[890]: info: CoreCommandRouter::volumioPushState Jun 06 17:00:31 opera volumio[890]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 06 17:00:31 opera volumio[890]: info: CoreStateMachine::setRandom null Jun 06 17:00:31 opera volumio[890]: info: CoreStateMachine::pushState Jun 06 17:00:31 opera volumio[890]: info: CoreStateMachine::getState Jun 06 17:00:31 opera volumio[890]: info: CorePlayQueue::getTrack 0 Jun 06 17:00:31 opera volumio[890]: info: CoreCommandRouter::volumioPushState Jun 06 17:00:31 opera volumio[890]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 06 17:00:31 opera volumio[890]: info: Pushing Favourites {"service":"mpd","uri":"music-library/USB/Maxtor/$RECYCLE.BIN/S-1-5-21-4182394471-2718127994-275331217-1001/$RPKMHRQ/01 Adoniran Barbosa - Praça da Sé.flac","favourite":false} Jun 06 17:00:31 opera volumio[890]: info: Pushing Favourites {"service":"mpd","uri":"music-library/USB/Maxtor/$RECYCLE.BIN/S-1-5-21-4182394471-2718127994-275331217-1001/$RPKMHRQ/01 Adoniran Barbosa - Praça da Sé.flac","favourite":false} Jun 06 17:00:31 opera volumio[890]: info: Pushing Favourites {"service":"mpd","uri":"music-library/USB/Maxtor/$RECYCLE.BIN/S-1-5-21-4182394471-2718127994-275331217-1001/$RPKMHRQ/01 Adoniran Barbosa - Praça da Sé.flac","favourite":false} Jun 06 17:00:31 opera volumio-remote-updater[477]: [2025-06-06 17:00:31] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1749229230 101 Jun 06 17:00:31 opera sudo[1097]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Jun 06 17:00:31 opera sudo[1097]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 06 17:00:31 opera systemd[1]: Starting ShairportSync AirTunes receiver... Jun 06 17:00:31 opera systemd[1]: Started ShairportSync AirTunes receiver. Jun 06 17:00:31 opera sudo[1097]: pam_unix(sudo:session): session closed for user root Jun 06 17:00:31 opera shairport-sync[1099]: Successful Startup Jun 06 17:00:31 opera volumio[890]: Discovery: adding 0e717ffc-89bb-41e4-9fa2-8b20312e48ee Jun 06 17:00:31 opera volumio[890]: info: mDNS: Found device Opera Jun 06 17:00:32 opera volumio[890]: info: [1749229232136] Shairport-Sync Started Jun 06 17:00:32 opera volumio[890]: Error adding Membership: Error: addMembership EINVAL Jun 06 17:00:33 opera volumio[890]: info: CoreCommandRouter::volumioGetState Jun 06 17:00:33 opera volumio[890]: info: CoreStateMachine::getState Jun 06 17:00:33 opera volumio[890]: info: CorePlayQueue::getTrack 0 Jun 06 17:00:33 opera volumio[890]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 06 17:00:33 opera volumio[890]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 06 17:00:33 opera volumio[890]: Plugin multiroom or method getMultiroom not found Jun 06 17:00:33 opera volumio[890]: info: Listing playlists Jun 06 17:00:34 opera kernel: WARN::urb_dequeue:964: urb->hcpriv == NULL! urb = eb590700 status=-104 Jun 06 17:00:34 opera kernel: _hcd_isoc_complete:Uknown urb status -2 Jun 06 17:00:34 opera volumio[890]: info: CoreCommandRouter::Close All Modals sent Jun 06 17:00:34 opera volumio[890]: info: CoreCommandRouter::volumioGetBrowseSources Jun 06 17:00:34 opera volumio[890]: info: CoreCommandRouter::volumioGetQueue Jun 06 17:00:34 opera volumio[890]: info: CoreStateMachine::getQueue Jun 06 17:00:34 opera volumio[890]: info: CorePlayQueue::getQueue Jun 06 17:00:34 opera volumio[890]: info: No input data Jun 06 17:00:34 opera volumio[890]: info: No input data Jun 06 17:00:34 opera volumio[890]: info: No input data Jun 06 17:00:34 opera volumio[890]: info: No input data Jun 06 17:00:34 opera volumio[890]: info: No input data Jun 06 17:00:35 opera volumio[890]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jun 06 17:00:35 opera volumio[890]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jun 06 17:00:35 opera sudo[1120]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jun 06 17:00:35 opera sudo[1120]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 06 17:00:35 opera systemd[1]: Starting UPnP Renderer front-end to MPD... Jun 06 17:00:35 opera systemd[1]: Started UPnP Renderer front-end to MPD. Jun 06 17:00:35 opera sudo[1120]: pam_unix(sudo:session): session closed for user root Jun 06 17:00:35 opera volumio[890]: info: Upmpdcli Daemon Started Jun 06 17:00:36 opera volumio[890]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 06 17:00:36 opera volumio[890]: info: CURURI: artists:// Jun 06 17:00:36 opera volumio[890]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 06 17:00:36 opera volumio[890]: { AssertionError: false == true Jun 06 17:00:36 opera volumio[890]: at MpdClient.sendCommand (/volumio/app/plugins/music_service/mpd/lib/mpd.js:92:9) Jun 06 17:00:36 opera volumio[890]: at ControllerMpd.listArtists (/volumio/app/plugins/music_service/mpd/index.js:3236:17) Jun 06 17:00:36 opera volumio[890]: at ControllerMpd.handleBrowseUri (/volumio/app/plugins/music_service/mpd/index.js:2908:29) Jun 06 17:00:36 opera volumio[890]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1004:29) Jun 06 17:00:36 opera volumio[890]: at CoreMusicLibrary.executeBrowseSource (/volumio/app/musiclibrary.js:319:39) Jun 06 17:00:36 opera volumio[890]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:359:32) Jun 06 17:00:36 opera volumio[890]: at emitTwo (events.js:106:13) Jun 06 17:00:36 opera volumio[890]: at Socket.emit (events.js:191:7) Jun 06 17:00:36 opera volumio[890]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Jun 06 17:00:36 opera volumio[890]: at _combinedTickCallback (internal/process/next_tick.js:73:7) Jun 06 17:00:36 opera volumio[890]: name: 'AssertionError', Jun 06 17:00:36 opera volumio[890]: actual: false, Jun 06 17:00:36 opera volumio[890]: expected: true, Jun 06 17:00:36 opera volumio[890]: operator: '==', Jun 06 17:00:36 opera volumio[890]: message: 'false == true', Jun 06 17:00:36 opera volumio[890]: generatedMessage: true } Jun 06 17:00:36 opera volumio[890]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 06 17:00:37 opera sudo[1131]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-06 16:59 Jun 06 17:00:37 opera sudo[1131]: 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="7bac1c7b678b8c4c610bba4d70a5c16ee62b7e19" VOLUMIO_FE_VERSION="2d80816ad99ca4dfec2998adad5179fd25e874d5" VOLUMIO_BE_VERSION="9ac13199e84bd2c5cf8082565cccc6b80b02df97" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="opera" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon Apr 9 14:59:47 CEST 2018" VOLUMIO_VERSION="2.114" VOLUMIO_HARDWARE="odroidc1"