-- Logs begin at Thu 2024-10-03 10:05:20 UTC, end at Sat 2024-10-12 06:18:23 UTC. -- Oct 12 06:18:05 opera systemd[1]: Time has been changed Oct 12 06:18:05 opera volumio[864]: info: Loading plugin "i2s_dacs"... Oct 12 06:18:05 opera volumio[864]: info: I2S DAC not set, start Auto-detection Oct 12 06:18:05 opera volumio[864]: info: Loading plugin "volumiodiscovery"... Oct 12 06:18:05 opera volumio[864]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 12 06:18:05 opera node[864]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 12 06:18:05 opera node[864]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 12 06:18:05 opera node[864]: *** WARNING *** For more information see Oct 12 06:18:05 opera node[864]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 12 06:18:05 opera node[864]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 12 06:18:05 opera node[864]: *** WARNING *** For more information see Oct 12 06:18:05 opera volumio[864]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 12 06:18:05 opera volumio[864]: *** WARNING *** For more information see Oct 12 06:18:05 opera volumio[864]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 12 06:18:05 opera volumio[864]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 12 06:18:05 opera volumio[864]: *** WARNING *** For more information see Oct 12 06:18:05 opera volumio[864]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 12 06:18:05 opera volumio[864]: Discovery: StartAdv! undefined Oct 12 06:18:05 opera volumio[864]: Discovery: Started advertising... Opera - undefined Oct 12 06:18:05 opera volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 12 06:18:05 opera volumio[864]: info: Loading plugin "albumart"... Oct 12 06:18:05 opera volumio[864]: info: Plugin example_plugin is not enabled Oct 12 06:18:05 opera volumio[864]: info: Loading plugin "updater_comm"... Oct 12 06:18:05 opera kernel: TCP checksum Error rx desc-mask[4096] Oct 12 06:18:05 opera kernel: TCP checksum Error rx desc-mask[4096] Oct 12 06:18:05 opera kernel: TCP checksum Error rx desc-mask[4096] Oct 12 06:18:06 opera kernel: TCP checksum Error rx desc-mask[4096] Oct 12 06:18:06 opera kernel: TCP checksum Error rx desc-mask[4096] Oct 12 06:18:06 opera kernel: TCP checksum Error rx desc-mask[4096] Oct 12 06:18:06 opera volumio[864]: info: Plugin mpdemulation is not enabled Oct 12 06:18:06 opera volumio[864]: info: Loading plugin "websocket"... Oct 12 06:18:06 opera kernel: TCP checksum Error rx desc-mask[4096] Oct 12 06:18:06 opera volumio[864]: info: ___________ START PLUGINS ___________ Oct 12 06:18:06 opera volumio[864]: info: PLUGIN START: appearance Oct 12 06:18:06 opera volumio[864]: info: PLUGIN START: webradio Oct 12 06:18:06 opera volumio[864]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 12 06:18:06 opera volumio[864]: info: [1728713886889] CoreMusicLibrary::Adding element Webradio Oct 12 06:18:06 opera volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 12 06:18:06 opera volumio[864]: info: Loading i18n strings for locale zh Oct 12 06:18:06 opera volumio[864]: Updating browse sources language Oct 12 06:18:07 opera volumio[864]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 12 06:18:07 opera volumio[864]: info: CoreCommandRouter::initPlayerControls Oct 12 06:18:07 opera volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 06:18:07 opera volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Oct 12 06:18:07 opera volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 06:18:07 opera volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 06:18:07 opera volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 06:18:07 opera volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 06:18:07 opera volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 06:18:07 opera volumio[864]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 12 06:18:07 opera volumio[864]: info: BOOT COMPLETED Oct 12 06:18:07 opera volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 06:18:07 opera volumio[864]: info: CoreCommandRouter::Close All Modals sent Oct 12 06:18:07 opera volumio[864]: Express server listening on port 3000 Oct 12 06:18:07 opera volumio[864]: Volumio Calling Home Oct 12 06:18:07 opera kernel: TCP checksum Error rx desc-mask[4096] Oct 12 06:18:07 opera volumio[864]: info: CoreStateMachine::resetVolumioState Oct 12 06:18:07 opera volumio[864]: info: CoreStateMachine::getcurrentVolume Oct 12 06:18:07 opera volumio[864]: info: CoreCommandRouter::volumioRetrievevolume Oct 12 06:18:07 opera volumio[864]: info: CoreStateMachine::updateTrackBlock Oct 12 06:18:07 opera volumio[864]: info: CorePlayQueue::getTrackBlock Oct 12 06:18:08 opera volumio[864]: info: Setting Device type: Odroid-C Oct 12 06:18:08 opera volumio[864]: info: Cannot initialize MPD Connection: MPD is not running Oct 12 06:18:08 opera sudo[1104]: pam_unix(sudo:auth): conversation failed Oct 12 06:18:08 opera sudo[1104]: pam_unix(sudo:auth): auth could not identify password for [volumio] Oct 12 06:18:08 opera volumio[864]: info: VolumeController:: Volume=100 Mute =false Oct 12 06:18:08 opera volumio[864]: info: CoreStateMachine::pushState Oct 12 06:18:08 opera volumio[864]: info: CoreStateMachine::getState Oct 12 06:18:08 opera volumio[864]: info: CorePlayQueue::getTrack 0 Oct 12 06:18:08 opera volumio[864]: info: CoreCommandRouter::volumioPushState Oct 12 06:18:08 opera volumio[864]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 06:18:08 opera volumio[864]: info: Pushing Favourites {"service":"mpd","uri":"","favourite":false} Oct 12 06:18:08 opera kernel: TCP checksum Error rx desc-mask[4096] Oct 12 06:18:08 opera volumio[864]: info: Cannot read I2C interface or I2C interface not presentError: Command failed: /usr/bin/sudo /usr/sbin/i2cdetect -y 1 Oct 12 06:18:08 opera volumio[864]: sudo: no tty present and no askpass program specified Oct 12 06:18:08 opera volumio[864]: info: Reloading queue from file Oct 12 06:18:08 opera volumio[864]: info: CoreStateMachine::setRepeat null single undefined Oct 12 06:18:08 opera volumio[864]: info: CoreStateMachine::pushState Oct 12 06:18:08 opera volumio[864]: info: CoreStateMachine::getState Oct 12 06:18:08 opera volumio[864]: info: CorePlayQueue::getTrack 0 Oct 12 06:18:08 opera volumio[864]: info: CoreCommandRouter::volumioPushState Oct 12 06:18:08 opera volumio[864]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 06:18:08 opera volumio[864]: info: CoreStateMachine::setRandom null Oct 12 06:18:08 opera volumio[864]: info: CoreStateMachine::pushState Oct 12 06:18:08 opera volumio[864]: info: CoreStateMachine::getState Oct 12 06:18:08 opera kernel: TCP checksum Error rx desc-mask[4096] Oct 12 06:18:08 opera volumio[864]: info: CorePlayQueue::getTrack 0 Oct 12 06:18:09 opera volumio[864]: info: CoreCommandRouter::volumioPushState Oct 12 06:18:09 opera volumio[864]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 06:18:09 opera volumio[864]: info: Pushing Favourites {"service":"mpd","uri":"mnt/USB/[24-96]/The Genius of Film Music - Hollywood Blockbusters 1960s - 1980s 24-96/01. 20th century Fox Fanfare.flac","favourite":false} Oct 12 06:18:09 opera volumio[864]: info: Pushing Favourites {"service":"mpd","uri":"mnt/USB/[24-96]/The Genius of Film Music - Hollywood Blockbusters 1960s - 1980s 24-96/01. 20th century Fox Fanfare.flac","favourite":false} Oct 12 06:18:09 opera volumio[864]: Discovery: adding 0e717ffc-89bb-41e4-9fa2-8b20312e48ee Oct 12 06:18:09 opera volumio[864]: info: mDNS: Found device Opera Oct 12 06:18:09 opera sudo[1107]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart airplay Oct 12 06:18:09 opera sudo[1107]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 06:18:09 opera systemd[1]: Starting ShairportSync AirTunes receiver... Oct 12 06:18:09 opera systemd[1]: Started ShairportSync AirTunes receiver. Oct 12 06:18:09 opera sudo[1107]: pam_unix(sudo:session): session closed for user root Oct 12 06:18:09 opera shairport-sync[1111]: Successful Startup Oct 12 06:18:09 opera volumio[864]: info: [1728713889322] Shairport-Sync Started Oct 12 06:18:09 opera volumio[864]: Error adding Membership: Error: addMembership EINVAL Oct 12 06:18:09 opera kernel: TCP checksum Error rx desc-mask[4096] Oct 12 06:18:09 opera kernel: TCP checksum Error rx desc-mask[4096] Oct 12 06:18:09 opera kernel: TCP checksum Error rx desc-mask[4096] Oct 12 06:18:09 opera kernel: TCP checksum Error rx desc-mask[4096] Oct 12 06:18:09 opera kernel: TCP checksum Error rx desc-mask[4096] Oct 12 06:18:09 opera kernel: TCP checksum Error rx desc-mask[4096] Oct 12 06:18:09 opera kernel: TCP checksum Error rx desc-mask[4096] Oct 12 06:18:09 opera kernel: TCP checksum Error rx desc-mask[4096] Oct 12 06:18:10 opera kernel: TCP checksum Error rx desc-mask[4096] Oct 12 06:18:11 opera kernel: TCP checksum Error rx desc-mask[4096] Oct 12 06:18:12 opera kernel: WARN::urb_dequeue:964: urb->hcpriv == NULL! urb = e6c27700 status=-104 Oct 12 06:18:12 opera kernel: _hcd_isoc_complete:Uknown urb status -2 Oct 12 06:18:12 opera volumio[864]: info: CoreCommandRouter::Close All Modals sent Oct 12 06:18:12 opera kernel: TCP checksum Error rx desc-mask[4096] Oct 12 06:18:13 opera kernel: TCP checksum Error rx desc-mask[4096] Oct 12 06:18:13 opera volumio[864]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Oct 12 06:18:13 opera volumio[864]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Oct 12 06:18:14 opera kernel: TCP checksum Error rx desc-mask[4096] Oct 12 06:18:14 opera kernel: TCP checksum Error rx desc-mask[4096] Oct 12 06:18:14 opera sudo[1121]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Oct 12 06:18:14 opera sudo[1121]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 06:18:14 opera systemd[1]: Starting UPnP Renderer front-end to MPD... Oct 12 06:18:14 opera systemd[1]: Started UPnP Renderer front-end to MPD. Oct 12 06:18:14 opera sudo[1121]: pam_unix(sudo:session): session closed for user root Oct 12 06:18:14 opera volumio[864]: info: Upmpdcli Daemon Started Oct 12 06:18:14 opera systemd[1]: Starting Music Player Daemon... Oct 12 06:18:14 opera systemd[1]: Started Music Player Daemon. Oct 12 06:18:15 opera volumio-remote-updater[475]: [2024-10-12 06:18:15] [connect] Successful connection Oct 12 06:18:15 opera volumio-remote-updater[475]: [2024-10-12 06:18:15] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1728713895 101 Oct 12 06:18:15 opera volumio[864]: info: CoreCommandRouter::volumioGetState Oct 12 06:18:15 opera volumio[864]: info: CoreStateMachine::getState Oct 12 06:18:15 opera volumio[864]: info: CorePlayQueue::getTrack 0 Oct 12 06:18:16 opera volumio[864]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 12 06:18:16 opera volumio[864]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 12 06:18:16 opera volumio[864]: Plugin multiroom or method getMultiroom not found Oct 12 06:18:16 opera volumio[864]: info: Listing playlists Oct 12 06:18:16 opera volumio[864]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/John%20Mauceri/Genius%20of%20Film%20Music%3A%20Hollywood%201960s%20-%201980s/f0f77802-78ca-4d0b-a175-358c14533dce.jpg' Oct 12 06:18:16 opera volumio[864]: at Error (native) Oct 12 06:18:19 opera kernel: sd 0:0:0:0: [sda] Unhandled sense code Oct 12 06:18:19 opera kernel: sd 0:0:0:0: [sda] Oct 12 06:18:19 opera kernel: Result: hostbyte=0x07 driverbyte=0x08 Oct 12 06:18:19 opera kernel: sd 0:0:0:0: [sda] Oct 12 06:18:19 opera kernel: Sense Key : 0x4 [current] [descriptor] Oct 12 06:18:19 opera kernel: Descriptor sense data with sense descriptors (in hex): Oct 12 06:18:19 opera kernel: 72 04 00 00 00 00 00 0e 09 0c 00 00 00 ff 00 00 Oct 12 06:18:19 opera kernel: 00 00 00 00 40 50 Oct 12 06:18:19 opera kernel: sd 0:0:0:0: [sda] Oct 12 06:18:19 opera kernel: ASC=0x0 ASCQ=0x0 Oct 12 06:18:19 opera kernel: sd 0:0:0:0: [sda] CDB: Oct 12 06:18:19 opera kernel: cdb[0]=0xa1: a1 06 20 00 00 00 00 00 00 e5 00 00 Oct 12 06:18:19 opera kernel: sd 0:0:0:0: [sda] Unhandled sense code Oct 12 06:18:19 opera kernel: sd 0:0:0:0: [sda] Oct 12 06:18:19 opera kernel: Result: hostbyte=0x07 driverbyte=0x08 Oct 12 06:18:19 opera kernel: sd 0:0:0:0: [sda] Oct 12 06:18:19 opera kernel: Sense Key : 0x4 [current] [descriptor] Oct 12 06:18:19 opera kernel: Descriptor sense data with sense descriptors (in hex): Oct 12 06:18:19 opera kernel: 72 04 00 00 00 00 00 0e 09 0c 00 00 00 00 00 00 Oct 12 06:18:19 opera kernel: 00 4f 00 c2 40 50 Oct 12 06:18:19 opera kernel: sd 0:0:0:0: [sda] Oct 12 06:18:19 opera kernel: ASC=0x0 ASCQ=0x0 Oct 12 06:18:19 opera kernel: sd 0:0:0:0: [sda] CDB: Oct 12 06:18:19 opera kernel: cdb[0]=0xa1: a1 06 20 da 00 00 4f c2 00 b0 00 00 Oct 12 06:18:19 opera volumio[864]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 06:18:19 opera volumio[864]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 12 06:18:19 opera volumio[864]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 12 06:18:19 opera volumio[864]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 12 06:18:19 opera volumio[864]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 12 06:18:19 opera volumio[864]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 12 06:18:19 opera volumio[864]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 12 06:18:19 opera volumio[864]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 12 06:18:19 opera volumio[864]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 12 06:18:19 opera volumio[864]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Oct 12 06:18:20 opera kernel: TCP checksum Error rx desc-mask[4096] Oct 12 06:18:22 opera volumio[864]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=odroidc1&variante=opera&version=2.114&uuid=374c3d8bb92de04cb0fd5bf3d5a7aa21" http://updates.volumio.org:7070/downloader-v1/track-device Oct 12 06:18:22 opera volumio[864]: % Total % Received % Xferd Average Speed Time Time Time Current Oct 12 06:18:22 opera volumio[864]: Dload Upload Total Spent Left Speed Oct 12 06:18:22 opera volumio[864]: [551B blob data] Oct 12 06:18:22 opera volumio[864]: retrying in 5 seconds, trial 0 Oct 12 06:18:22 opera volumio[864]: Volumio Calling Home Oct 12 06:18:22 opera volumio[864]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Oct 12 06:18:22 opera volumio[864]: info: ControllerMpd::sendMpdCommand rescan Oct 12 06:18:22 opera volumio[864]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 06:18:22 opera volumio[864]: TypeError: Cannot read property 'then' of undefined Oct 12 06:18:22 opera volumio[864]: at ControllerMpd.sendMpdCommand (/volumio/app/plugins/music_service/mpd/index.js:343:3) Oct 12 06:18:22 opera volumio[864]: at ControllerMpd.rescanDb (/volumio/app/plugins/music_service/mpd/index.js:1802:14) Oct 12 06:18:22 opera volumio[864]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1004:29) Oct 12 06:18:22 opera volumio[864]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:914:24) Oct 12 06:18:22 opera volumio[864]: at emitTwo (events.js:106:13) Oct 12 06:18:22 opera volumio[864]: at Socket.emit (events.js:191:7) Oct 12 06:18:22 opera volumio[864]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Oct 12 06:18:22 opera volumio[864]: at _combinedTickCallback (internal/process/next_tick.js:73:7) Oct 12 06:18:22 opera volumio[864]: at process._tickCallback (internal/process/next_tick.js:104:9) Oct 12 06:18:22 opera volumio[864]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 06:18:23 opera sudo[1148]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-12 06:17 Oct 12 06:18:23 opera sudo[1148]: 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"