-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Fri 2024-08-23 20:35:24 CEST. --
Aug 23 20:34:27 volumio ntpd[970]: receive: Unexpected origin timestamp 0xe6e151b6.fb5934d1 does not match aorg 0000000000.00000000 from server@185.163.116.98 xmt 0xea7354b3.a4080faa
Aug 23 20:34:27 volumio ntpd[970]: receive: Unexpected origin timestamp 0xe6e151b6.fb5d02bf does not match aorg 0000000000.00000000 from server@213.202.247.29 xmt 0xea7354b3.a4cef4dd
Aug 23 20:34:27 volumio ntpd[970]: receive: Unexpected origin timestamp 0xe6e151b6.fb5845ba does not match aorg 0000000000.00000000 from server@94.130.184.193 xmt 0xea7354b3.a45e6fff
Aug 23 20:34:27 volumio ntpd[970]: receive: Unexpected origin timestamp 0xe6e151b6.fb5c1deb does not match aorg 0000000000.00000000 from server@128.140.109.119 xmt 0xea7354b3.a4b6bc71
Aug 23 20:34:27 volumio ntpd[970]: receive: Unexpected origin timestamp 0xe6e151b6.fb5b2e04 does not match aorg 0000000000.00000000 from server@167.235.76.111 xmt 0xea7354b3.a4b1ad22
Aug 23 20:34:27 volumio ntpd[970]: receive: Unexpected origin timestamp 0xe6e151b6.fb5742dd does not match aorg 0000000000.00000000 from server@80.153.195.191 xmt 0xea7354b3.a49ea862
Aug 23 20:34:27 volumio ntpd[970]: receive: Unexpected origin timestamp 0xe6e151b6.fb5119e5 does not match aorg 0000000000.00000000 from server@144.91.116.85 xmt 0xea7354b3.a8dcd4f4
Aug 23 20:34:27 volumio volumio[870]: info: Volumio Calling Home
Aug 23 20:34:27 volumio sudo[1162]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/moveallprocesses.sh
Aug 23 20:34:27 volumio sudo[1162]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 23 20:34:28 volumio volumio[870]: info: [now-playing-app] App is listening on port 4004.
Aug 23 20:34:28 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly.
Aug 23 20:34:28 volumio volumio[870]: info: VolumeController:: Volume=80 Mute =false
Aug 23 20:34:28 volumio volumio[870]: info: CoreStateMachine::pushState
Aug 23 20:34:28 volumio volumio[870]: info: CorePlayQueue::getTrack 0
Aug 23 20:34:28 volumio volumio[870]: info: CoreCommandRouter::volumioPushState
Aug 23 20:34:28 volumio volumio[870]: info: MPD Permissions set
Aug 23 20:34:28 volumio volumio[870]: info: MPD Permissions set
Aug 23 20:34:28 volumio volumio-remote-updater[663]: [2024-08-23 20:34:28] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1664537397 101
Aug 23 20:34:28 volumio volumio[870]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 2
Aug 23 20:34:28 volumio volumio[870]: info: Volumio called home
Aug 23 20:34:28 volumio systemd[1]: getty@tty1.service: Current command vanished from the unit file, execution of the command list won't be resumed.
Aug 23 20:34:29 volumio sudo[1123]: pam_unix(sudo:session): session closed for user root
Aug 23 20:34:29 volumio systemd[1]: Starting Daily apt download activities...
Aug 23 20:34:29 volumio systemd[1]: Starting Daily man-db regeneration...
Aug 23 20:34:29 volumio volumio[870]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3
Aug 23 20:34:29 volumio volumio[870]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4
Aug 23 20:34:29 volumio systemd[1]: man-db.service: Succeeded.
Aug 23 20:34:29 volumio systemd[1]: Started Daily man-db regeneration.
Aug 23 20:34:29 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 23 20:34:29 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 23 20:34:29 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 23 20:34:29 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 23 20:34:29 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 23 20:34:29 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 23 20:34:29 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 23 20:34:29 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 23 20:34:29 volumio sudo[1207]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Aug 23 20:34:29 volumio sudo[1207]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 23 20:34:29 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 23 20:34:29 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 23 20:34:29 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 23 20:34:29 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 23 20:34:29 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 23 20:34:29 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 23 20:34:29 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 23 20:34:29 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 23 20:34:29 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 23 20:34:29 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 23 20:34:30 volumio systemd[1]: Started UPnP Renderer front-end to MPD.
Aug 23 20:34:30 volumio sudo[1207]: pam_unix(sudo:session): session closed for user root
Aug 23 20:34:30 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 23 20:34:30 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 23 20:34:30 volumio volumio[870]: info: [LastFM] finished init: Authenticated successfully!
Aug 23 20:34:30 volumio sudo[1162]: pam_unix(sudo:session): session closed for user root
Aug 23 20:34:30 volumio volumio[870]: info: EVO SABRE : systemd cmd daemon-reload : success
Aug 23 20:34:30 volumio mpd[1116]: decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Aug 23 20:34:30 volumio mpd[1116]: output: No 'audio_output' defined in config file
Aug 23 20:34:30 volumio mpd[1116]: output: Successfully detected a sndio audio device
Aug 23 20:34:30 volumio mpd[1116]: zeroconf: No global port, disabling zeroconf
Aug 23 20:34:30 volumio systemd[1]: Started Music Player Daemon.
Aug 23 20:34:30 volumio sudo[1087]: pam_unix(sudo:session): session closed for user root
Aug 23 20:34:30 volumio volumio[870]: info: Upmpdcli Daemon Started
Aug 23 20:34:30 volumio systemd[1]: Starting Shield Volumio Music Services in the User CPU Set...
Aug 23 20:34:30 volumio sudo[1097]: pam_unix(sudo:session): session closed for user root
Aug 23 20:34:30 volumio sudo[1232]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart evo_oled2.service
Aug 23 20:34:30 volumio sudo[1232]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 23 20:34:30 volumio sudo[1236]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart lircd.service
Aug 23 20:34:30 volumio sudo[1236]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 23 20:34:30 volumio volumio[870]: (node:870) [DEP0005] DeprecationWarning: Buffer() is deprecated due to security and usability issues. Please use the Buffer.alloc(), Buffer.allocUnsafe(), or Buffer.from() methods instead.
Aug 23 20:34:30 volumio volumio[870]: (Use `node --trace-deprecation ...` to show where the warning was created)
Aug 23 20:34:30 volumio volumio[870]: (node:870) [DEP0106] DeprecationWarning: crypto.createDecipher is deprecated.
Aug 23 20:34:30 volumio systemd[1]: Started OLED Display Service for EVO SABRE.
Aug 23 20:34:30 volumio lircd[832]: lircd-0.10.1[832]: Notice: caught signal
Aug 23 20:34:30 volumio lircd-0.10.1[832]: Notice: caught signal
Aug 23 20:34:30 volumio sudo[1248]: root : TTY=unknown ; PWD=/data/plugins/system_hardware/audiophonics_evo_sabre/app ; USER=root ; COMMAND=/usr/bin/node /data/plugins/system_hardware/audiophonics_evo_sabre/app/index.js volumio
Aug 23 20:34:30 volumio systemd[1]: Stopping Flexible IR remote input/output application support...
Aug 23 20:34:30 volumio sudo[1248]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 23 20:34:30 volumio systemd[1]: lircd.service: Main process exited, code=killed, status=15/TERM
Aug 23 20:34:30 volumio systemd[1]: lircd.service: Succeeded.
Aug 23 20:34:30 volumio sudo[1232]: pam_unix(sudo:session): session closed for user root
Aug 23 20:34:30 volumio systemd[1]: Stopped Flexible IR remote input/output application support.
Aug 23 20:34:30 volumio systemd[1]: Starting lircd(8) initialization helper tool...
Aug 23 20:34:31 volumio volumio[870]: info: Completed starting Core Plugins
Aug 23 20:34:31 volumio volumio[870]: info: -------------------------------------------
Aug 23 20:34:31 volumio volumio[870]: info: ----- MyVolumio plugins startup ----
Aug 23 20:34:31 volumio volumio[870]: info: -------------------------------------------
Aug 23 20:34:31 volumio volumio[870]: info: [MyVolumio PluginManager] Fetching plans data....
Aug 23 20:34:31 volumio sudo[1250]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/addservice.sh
Aug 23 20:34:31 volumio lircd-setup[1253]: /usr/sbin/lircd-setup:37: DeprecationWarning: The SafeConfigParser class has been renamed to ConfigParser in Python 3.2. This alias will be removed in future versions. Use ConfigParser directly instead.
Aug 23 20:34:31 volumio lircd-setup[1253]: parser = configparser.SafeConfigParser()
Aug 23 20:34:31 volumio volumio[870]: info: Starting Shairport Sync
Aug 23 20:34:31 volumio sudo[1250]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 23 20:34:31 volumio systemd[1]: lircd-setup.service: Succeeded.
Aug 23 20:34:31 volumio systemd[1]: Started lircd(8) initialization helper tool.
Aug 23 20:34:31 volumio volumio[870]: info: Starting Shairport Sync
Aug 23 20:34:31 volumio systemd[1]: Starting Flexible IR remote input/output application support...
Aug 23 20:34:31 volumio lircd-0.10.1[1267]: Info: lircd: Opening log, level: Info
Aug 23 20:34:31 volumio lircd-0.10.1[1267]: Notice: Version: lircd 0.10.1
Aug 23 20:34:31 volumio lircd-0.10.1[1267]: Notice: System info: Linux volumio 6.1.77-v7l+ #1730 SMP Thu Feb 8 15:22:02 GMT 2024 armv7l GNU/Linux
Aug 23 20:34:31 volumio lircd-0.10.1[1267]: Info: Initial device: /dev/lirc0
Aug 23 20:34:31 volumio lircd-0.10.1[1267]: Info: [lirc] protocol is enabled
Aug 23 20:34:31 volumio lircd-0.10.1[1267]: Info: Initial device: /dev/lirc0
Aug 23 20:34:31 volumio lircd-0.10.1[1267]: Info: [lirc] protocol is enabled
Aug 23 20:34:31 volumio lircd-0.10.1[1267]: Notice: Options: driver: default
Aug 23 20:34:31 volumio lircd-0.10.1[1267]: Notice: Options: output: /var/run/lirc/lircd
Aug 23 20:34:31 volumio lircd-0.10.1[1267]: Notice: Options: nodaemon: 1
Aug 23 20:34:31 volumio lircd-0.10.1[1267]: Notice: Options: plugindir: /usr/lib/arm-linux-gnueabihf/lirc/plugins
Aug 23 20:34:31 volumio lircd-0.10.1[1267]: Notice: Options: logfile: syslog
Aug 23 20:34:31 volumio lircd-0.10.1[1267]: Notice: Options: immediate-init: 0
Aug 23 20:34:31 volumio lircd-0.10.1[1267]: Notice: Options: permission: 666
Aug 23 20:34:31 volumio lircd-0.10.1[1267]: Notice: Options: driver-options:
Aug 23 20:34:31 volumio lircd-0.10.1[1267]: Notice: Options: pidfile: /var/run/lirc/lircd.pid
Aug 23 20:34:31 volumio lircd-0.10.1[1267]: Notice: Options: listen: 0
Aug 23 20:34:31 volumio lircd-0.10.1[1267]: Notice: Options: connect: (null)
Aug 23 20:34:31 volumio lircd-0.10.1[1267]: Notice: Options: userelease: 0
Aug 23 20:34:31 volumio lircd-0.10.1[1267]: Notice: Options: effective_user: (null)
Aug 23 20:34:31 volumio lircd-0.10.1[1267]: Notice: Options: release_suffix: _EVUP
Aug 23 20:34:31 volumio lircd-0.10.1[1267]: Notice: Options: allow_simulate: 0
Aug 23 20:34:31 volumio lircd-0.10.1[1267]: Notice: Options: repeat_max: 600
Aug 23 20:34:31 volumio lircd-0.10.1[1267]: Notice: Options: configfile: /etc/lirc/lircd.conf
Aug 23 20:34:31 volumio lircd-0.10.1[1267]: Notice: Options: dynamic_codes: (null)
Aug 23 20:34:31 volumio lircd-0.10.1[1267]: Notice: Current driver: default
Aug 23 20:34:31 volumio lircd-0.10.1[1267]: Notice: Driver API version: 3
Aug 23 20:34:31 volumio lircd-0.10.1[1267]: Notice: Driver version: 0.10.0
Aug 23 20:34:31 volumio lircd-0.10.1[1267]: Notice: Driver info: See file:///usr/share/doc/lirc/plugindocs/default.html
Aug 23 20:34:31 volumio lircd[1267]: lircd-0.10.1[1267]: Info: lircd: Opening log, level: Info
Aug 23 20:34:31 volumio lircd-0.10.1[1267]: Info: lircd: Opening log, level: Info
Aug 23 20:34:31 volumio lircd[1267]: lircd-0.10.1[1267]: Notice: Using systemd fd
Aug 23 20:34:31 volumio lircd-0.10.1[1267]: Notice: Using systemd fd
Aug 23 20:34:31 volumio lircd[1267]: lircd-0.10.1[1267]: Warning: Running as root
Aug 23 20:34:31 volumio lircd-0.10.1[1267]: Warning: Running as root
Aug 23 20:34:31 volumio lircd[1267]: lircd-0.10.1[1267]: Info: Using remote: ApEvo.
Aug 23 20:34:31 volumio lircd-0.10.1[1267]: Info: Using remote: ApEvo.
Aug 23 20:34:31 volumio systemd[1]: Started Flexible IR remote input/output application support.
Aug 23 20:34:31 volumio lircd[1267]: lircd-0.10.1[1267]: Notice: lircd(default) ready, using /var/run/lirc/lircd
Aug 23 20:34:31 volumio lircd-0.10.1[1267]: Notice: lircd(default) ready, using /var/run/lirc/lircd
Aug 23 20:34:31 volumio sudo[1236]: pam_unix(sudo:session): session closed for user root
Aug 23 20:34:31 volumio volumio[870]: info: Starting Shairport Sync
Aug 23 20:34:31 volumio sudo[1269]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=joadmin,password=wertzusein27383!,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.178.27/Multimedia /mnt/NAS/Multimedia
Aug 23 20:34:31 volumio sudo[1269]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 23 20:34:31 volumio sudo[1270]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Aug 23 20:34:31 volumio sudo[1270]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 23 20:34:31 volumio volumio[1235]: cset: --> shielding system active with
Aug 23 20:34:31 volumio volumio[1235]: cset: "system" cpuset of CPUSPEC(3) with 122 tasks running
Aug 23 20:34:31 volumio volumio[1235]: cset: "user" cpuset of CPUSPEC(0-2) with 3 tasks running
Aug 23 20:34:31 volumio sudo[1278]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Aug 23 20:34:31 volumio sudo[1278]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 23 20:34:31 volumio kernel: CIFS: Attempting to mount \\192.168.178.27\Multimedia
Aug 23 20:34:31 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:34:31 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Aug 23 20:34:31 volumio systemd[1]: shairport-sync.service: Succeeded.
Aug 23 20:34:31 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Aug 23 20:34:32 volumio sudo[1285]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Aug 23 20:34:32 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Aug 23 20:34:32 volumio systemd[1]: Started Shield Volumio Music Services in the User CPU Set.
Aug 23 20:34:32 volumio sudo[1270]: pam_unix(sudo:session): session closed for user root
Aug 23 20:34:32 volumio volumio[870]: info: CorePlayQueue::getTrack 0
Aug 23 20:34:32 volumio volumio[870]: info: EVO SABRE : systemd cmd restart evo_oled2.service : success
Aug 23 20:34:32 volumio sudo[1285]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 23 20:34:32 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Aug 23 20:34:32 volumio systemd[1]: shairport-sync.service: Succeeded.
Aug 23 20:34:32 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Aug 23 20:34:32 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Aug 23 20:34:32 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Aug 23 20:34:32 volumio sudo[1278]: pam_unix(sudo:session): session closed for user root
Aug 23 20:34:32 volumio systemd[1]: Reloading.
Aug 23 20:34:32 volumio volumio[870]: error: MPD error: The expression evaluated to a falsy value:
Aug 23 20:34:32 volumio volumio[870]: assert.ok(self.idling)
Aug 23 20:34:32 volumio volumio[870]: error: The expression evaluated to a falsy value:
Aug 23 20:34:32 volumio volumio[870]: assert.ok(self.idling)
Aug 23 20:34:32 volumio volumio[870]: info: Shairport-Sync Started
Aug 23 20:34:32 volumio volumio[870]: Error adding Membership: Error: addMembership EINVAL
Aug 23 20:34:32 volumio volumio[870]: info: EVO SABRE : systemd cmd restart lircd.service : success
Aug 23 20:34:32 volumio volumio[870]: info: MPD running with PID1116
Aug 23 20:34:32 volumio volumio[870]: ,establishing connection
Aug 23 20:34:32 volumio volumio[870]: error: updateQueue error: null
Aug 23 20:34:32 volumio volumio[870]: info: Shairport-Sync Started
Aug 23 20:34:32 volumio volumio[870]: info: Discovery: A device disappeared from network
Aug 23 20:34:32 volumio volumio[870]: info: Discovery: Device volumio disappeared from network
Aug 23 20:34:32 volumio sudo[1325]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart irexec.service
Aug 23 20:34:32 volumio sudo[1325]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 23 20:34:32 volumio volumio[870]: error: updateQueue error: null
Aug 23 20:34:33 volumio volumio[1216]: Generating RSA private key, 4096 bit long modulus (2 primes)
Aug 23 20:34:33 volumio volumio[870]: info: Discovery: adding 40cc1dcc-700a-42c5-a28a-9115ec5dc113
Aug 23 20:34:33 volumio volumio[870]: info: Discovery: Found device Volumio
Aug 23 20:34:33 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:34:33 volumio volumio[870]: info: CorePlayQueue::getTrack 0
Aug 23 20:34:33 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly.
Aug 23 20:34:33 volumio sudo[1269]: pam_unix(sudo:session): session closed for user root
Aug 23 20:34:33 volumio volumio[870]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4
Aug 23 20:34:34 volumio sudo[1250]: pam_unix(sudo:session): session closed for user root
Aug 23 20:34:34 volumio volumio[870]: info: succeeded
Aug 23 20:34:34 volumio systemd[1]: apt-daily.service: Succeeded.
Aug 23 20:34:34 volumio systemd[1]: Started Daily apt download activities.
Aug 23 20:34:34 volumio systemd[1]: shairport-sync.service: Succeeded.
Aug 23 20:34:34 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Aug 23 20:34:34 volumio systemd[1]: Started Handle events from IR remotes decoded by lircd(8).
Aug 23 20:34:34 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Aug 23 20:34:34 volumio sudo[1325]: pam_unix(sudo:session): session closed for user root
Aug 23 20:34:34 volumio volumio[870]: info: EVO SABRE : systemd cmd restart irexec.service : success
Aug 23 20:34:34 volumio sudo[1285]: pam_unix(sudo:session): session closed for user root
Aug 23 20:34:34 volumio lircd[1267]: lircd-0.10.1[1267]: Notice: accepted new client on /var/run/lirc/lircd
Aug 23 20:34:34 volumio lircd[1267]: lircd-0.10.1[1267]: Info: [lirc] protocol is enabled
Aug 23 20:34:34 volumio lircd-0.10.1[1267]: Notice: accepted new client on /var/run/lirc/lircd
Aug 23 20:34:34 volumio lircd-0.10.1[1267]: Info: [lirc] protocol is enabled
Aug 23 20:34:34 volumio volumio[870]: info: Shairport-Sync Started
Aug 23 20:34:35 volumio systemd[1]: Starting Daily apt upgrade and clean activities...
Aug 23 20:34:36 volumio systemd[1]: systemd-fsckd.service: Succeeded.
Aug 23 20:34:36 volumio nmbd[762]: [2024/08/23 20:34:36.814031, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Aug 23 20:34:36 volumio nmbd[762]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.178.40 for name WORKGROUP<1d>.
Aug 23 20:34:36 volumio nmbd[762]: This response was from IP 192.168.178.68, reporting an IP address of 192.168.178.68.
Aug 23 20:34:37 volumio mpd[1116]: exception: No database
Aug 23 20:34:37 volumio volumio[870]: error: Failed LSINFO: Error: [50@0] {lsinfo} No database
Aug 23 20:34:37 volumio systemd[1]: apt-daily-upgrade.service: Succeeded.
Aug 23 20:34:37 volumio systemd[1]: Started Daily apt upgrade and clean activities.
Aug 23 20:34:38 volumio volumio[870]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5
Aug 23 20:34:38 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:34:38 volumio volumio[870]: info: CorePlayQueue::getTrack 0
Aug 23 20:34:38 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:34:38 volumio volumio[870]: info: CorePlayQueue::getTrack 0
Aug 23 20:34:38 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:34:38 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:34:38 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:34:39 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:34:39 volumio volumio[870]: info: CorePlayQueue::getTrack 0
Aug 23 20:34:39 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:34:39 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:34:39 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:34:39 volumio volumio[870]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
Aug 23 20:34:39 volumio volumio[870]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
Aug 23 20:34:39 volumio volumio[870]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
Aug 23 20:34:39 volumio volumio[870]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
Aug 23 20:34:39 volumio volumio[870]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
Aug 23 20:34:39 volumio volumio[870]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
Aug 23 20:34:39 volumio volumio[870]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
Aug 23 20:34:39 volumio volumio[870]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
Aug 23 20:34:39 volumio volumio[870]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
Aug 23 20:34:39 volumio volumio[870]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
Aug 23 20:34:39 volumio volumio[870]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
Aug 23 20:34:39 volumio volumio[870]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
Aug 23 20:34:39 volumio volumio[870]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
Aug 23 20:34:39 volumio volumio[870]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
Aug 23 20:34:39 volumio volumio[870]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
Aug 23 20:34:39 volumio volumio[870]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
Aug 23 20:34:39 volumio volumio[870]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
Aug 23 20:34:39 volumio volumio[870]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
Aug 23 20:34:39 volumio volumio[870]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
Aug 23 20:34:39 volumio volumio[870]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
Aug 23 20:34:39 volumio volumio[870]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
Aug 23 20:34:39 volumio volumio[870]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
Aug 23 20:34:39 volumio volumio[870]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
Aug 23 20:34:39 volumio volumio[870]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
Aug 23 20:34:39 volumio volumio[870]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
Aug 23 20:34:39 volumio volumio[870]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
Aug 23 20:34:39 volumio volumio[870]: info: Adding plugin bluetooth to MyMusic Plugins
Aug 23 20:34:39 volumio volumio[870]: info: Adding plugin multiroom to MyMusic Plugins
Aug 23 20:34:39 volumio volumio[870]: info: Adding plugin metavolumio to MyMusic Plugins
Aug 23 20:34:39 volumio volumio[870]: info: Adding plugin cd_controller to MyMusic Plugins
Aug 23 20:34:39 volumio volumio[870]: info: Adding plugin smart_inputs to MyMusic Plugins
Aug 23 20:34:39 volumio volumio[870]: info: Adding plugin tidalconnect to MyMusic Plugins
Aug 23 20:34:39 volumio volumio[870]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
Aug 23 20:34:40 volumio systemd[1]: systemd-hostnamed.service: Succeeded.
Aug 23 20:34:41 volumio volumio[870]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
Aug 23 20:34:41 volumio volumio[870]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
Aug 23 20:34:41 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 23 20:34:41 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 23 20:34:41 volumio volumio[870]: info: Starting MyVolumio Remote Streaming Endpoints
Aug 23 20:34:41 volumio volumio[870]: info: MyVolumio login type: Token
Aug 23 20:34:41 volumio volumio[870]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
Aug 23 20:34:41 volumio volumio[870]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
Aug 23 20:34:44 volumio volumio[870]: info: Starting Streaming Service Transparent Proxy
Aug 23 20:34:44 volumio volumio[870]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Aug 23 20:34:44 volumio volumio[870]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Aug 23 20:34:44 volumio volumio[870]: info: Streaming services startup
Aug 23 20:34:44 volumio volumio[870]: info: Starting Streaming Daemon
Aug 23 20:34:44 volumio sudo[1445]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Aug 23 20:34:44 volumio volumio[870]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
Aug 23 20:34:44 volumio sudo[1445]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 23 20:34:44 volumio sudo[1445]: pam_unix(sudo:session): session closed for user root
Aug 23 20:34:45 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:34:45 volumio volumio[870]: info: CorePlayQueue::getTrack 0
Aug 23 20:34:45 volumio volumio[870]: error: Cannot start Volumio Streaming Daemon
Aug 23 20:34:45 volumio volumio[870]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Aug 23 20:34:45 volumio volumio[870]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Aug 23 20:34:45 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:34:45 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:34:45 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:34:45 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:34:45 volumio volumio[870]: info: CorePlayQueue::getTrack 0
Aug 23 20:34:45 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:34:45 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:34:45 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:34:45 volumio volumio[870]: error: MyVolumio Custom Token format not valid, refreshing it
Aug 23 20:34:46 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:34:46 volumio volumio[870]: info: CorePlayQueue::getTrack 0
Aug 23 20:34:46 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:34:46 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:34:46 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:34:46 volumio volumio[870]: info: MyVolumio login type: Token
Aug 23 20:34:47 volumio volumio[870]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN
Aug 23 20:34:47 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:34:47 volumio volumio[870]: info: CorePlayQueue::getTrack 0
Aug 23 20:34:47 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:34:47 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:34:47 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:34:47 volumio sudo[1453]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Aug 23 20:34:47 volumio sudo[1453]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 23 20:34:47 volumio sudo[1454]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Aug 23 20:34:47 volumio sudo[1453]: pam_unix(sudo:session): session closed for user root
Aug 23 20:34:47 volumio sudo[1454]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 23 20:34:47 volumio sudo[1454]: pam_unix(sudo:session): session closed for user root
Aug 23 20:34:47 volumio volumio[870]: verbose: New Socket.io Connection to 192.168.178.40 from 192.168.178.22 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:129.0) Gecko/20100101 Firefox/129.0 Engine version: 3 Transport: polling Total Clients: 6
Aug 23 20:34:47 volumio volumio[870]: info: MyVolumio token set successfully
Aug 23 20:34:47 volumio volumio[870]: info: MYVOLUMIO: Adding device
Aug 23 20:34:47 volumio volumio[870]: info: MYVOLUMIO: Evaluating Server
Aug 23 20:34:48 volumio volumio[870]: STREAMING PROXY: Starting server on port 3245
Aug 23 20:34:48 volumio volumio[870]: Node JS runtime: 14
Aug 23 20:34:48 volumio volumio[870]: info: MyVolumio status changed
Aug 23 20:34:48 volumio volumio[870]: info: Streaming services startup
Aug 23 20:34:48 volumio volumio[870]: info: Starting Streaming Daemon
Aug 23 20:34:48 volumio volumio[870]: info: Removing browser output: myVolumio user plan is not superstar
Aug 23 20:34:48 volumio volumio[870]: info: Removing audio output:
Aug 23 20:34:48 volumio volumio[870]: info: Stoppping Tunnel 1
Aug 23 20:34:48 volumio sudo[1475]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Aug 23 20:34:48 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:34:48 volumio volumio[870]: info: CorePlayQueue::getTrack 0
Aug 23 20:34:48 volumio sudo[1475]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 23 20:34:48 volumio sudo[1477]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service
Aug 23 20:34:49 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:34:49 volumio sudo[1475]: pam_unix(sudo:session): session closed for user root
Aug 23 20:34:49 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:34:49 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:34:49 volumio sudo[1477]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 23 20:34:49 volumio volumio[870]: error: Cannot start Volumio Streaming Daemon
Aug 23 20:34:49 volumio volumio[870]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Aug 23 20:34:49 volumio volumio[870]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Aug 23 20:34:49 volumio sudo[1477]: pam_unix(sudo:session): session closed for user root
Aug 23 20:34:49 volumio volumio[870]: info: Remote SSH Stopped
Aug 23 20:34:49 volumio volumio[870]: info: Setting Geolocation for MyVolumio to eu4
Aug 23 20:34:49 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 23 20:34:49 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 23 20:34:49 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 23 20:34:49 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:34:49 volumio volumio[870]: info: CorePlayQueue::getTrack 0
Aug 23 20:34:49 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:34:49 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:34:49 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:34:49 volumio sudo[1482]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Aug 23 20:34:49 volumio sudo[1482]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 23 20:34:49 volumio sudo[1483]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Aug 23 20:34:49 volumio sudo[1482]: pam_unix(sudo:session): session closed for user root
Aug 23 20:34:49 volumio sudo[1483]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 23 20:34:49 volumio sudo[1483]: pam_unix(sudo:session): session closed for user root
Aug 23 20:34:49 volumio volumio[870]: verbose: New Socket.io Connection to 192.168.178.40 from 192.168.178.22 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:129.0) Gecko/20100101 Firefox/129.0 Engine version: 3 Transport: polling Total Clients: 6
Aug 23 20:34:49 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:34:49 volumio volumio[870]: info: CorePlayQueue::getTrack 0
Aug 23 20:34:49 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Aug 23 20:34:49 volumio volumio[870]: info: Listing playlists
Aug 23 20:34:49 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Aug 23 20:34:49 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Aug 23 20:34:49 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Aug 23 20:34:49 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Aug 23 20:34:50 volumio volumio[870]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"}
Aug 23 20:34:50 volumio volumio[870]: info: Updating MyVolumio device info
Aug 23 20:34:50 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 23 20:34:50 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:34:50 volumio volumio[870]: info: CorePlayQueue::getTrack 0
Aug 23 20:34:50 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:34:50 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:34:50 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:34:50 volumio volumio[870]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"}
Aug 23 20:34:51 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Aug 23 20:34:51 volumio volumio[870]: info: Received Get System Info
Aug 23 20:34:51 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 23 20:34:51 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 23 20:34:51 volumio volumio[870]: info: Discovery: Getting this device information
Aug 23 20:34:51 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:34:51 volumio volumio[870]: info: CorePlayQueue::getTrack 0
Aug 23 20:34:51 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 23 20:34:51 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Aug 23 20:34:51 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:34:51 volumio volumio[870]: info: CorePlayQueue::getTrack 0
Aug 23 20:34:51 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:34:51 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:34:51 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:34:52 volumio volumio[1216]: .................................................................................................++++
Aug 23 20:34:52 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:34:52 volumio volumio[870]: info: CorePlayQueue::getTrack 0
Aug 23 20:34:52 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:34:52 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:34:52 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:34:53 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:34:53 volumio volumio[870]: info: CorePlayQueue::getTrack 0
Aug 23 20:34:53 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:34:53 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:34:53 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:34:54 volumio volumio[870]: info: MYVOLUMIO: Adding device
Aug 23 20:34:54 volumio volumio[870]: info: MYVOLUMIO: Evaluating Server
Aug 23 20:34:54 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:34:54 volumio volumio[870]: info: CorePlayQueue::getTrack 0
Aug 23 20:34:54 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:34:54 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:34:54 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:34:54 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Aug 23 20:34:54 volumio volumio[870]: info: Received Get System Info
Aug 23 20:34:54 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 23 20:34:54 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 23 20:34:54 volumio volumio[870]: info: Discovery: Getting this device information
Aug 23 20:34:54 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:34:54 volumio volumio[870]: info: CorePlayQueue::getTrack 0
Aug 23 20:34:54 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 23 20:34:55 volumio volumio[870]: info: Setting Geolocation for MyVolumio to eu4
Aug 23 20:34:55 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 23 20:34:55 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:34:55 volumio volumio[870]: info: CorePlayQueue::getTrack 0
Aug 23 20:34:55 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:34:55 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:34:55 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:34:56 volumio volumio[870]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"}
Aug 23 20:34:56 volumio volumio[870]: info: Updating MyVolumio device info
Aug 23 20:34:56 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 23 20:34:56 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:34:56 volumio volumio[870]: info: CorePlayQueue::getTrack 0
Aug 23 20:34:56 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:34:56 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:34:56 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:34:56 volumio volumio[870]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"}
Aug 23 20:34:56 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Aug 23 20:34:56 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 23 20:34:56 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Aug 23 20:34:56 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Aug 23 20:34:56 volumio volumio[870]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7
Aug 23 20:34:56 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:34:56 volumio volumio[870]: info: CorePlayQueue::getTrack 0
Aug 23 20:34:57 volumio volumio-remote-updater[663]: No test mode
Aug 23 20:34:57 volumio volumio-remote-updater[663]: No alpha test mode
Aug 23 20:34:57 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Aug 23 20:34:57 volumio volumio[870]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES
- Improved translations
- Fix for controlling Volumio device from another one
- Fix for slow playback on RPi5 with HifiBerry DAC
- Improved speed for default albumart
- Fix for HifiBerry DAC detection
- Fix for Supersearch bar on Iphone
- Fix for Network connection on Wizard
NEW ADDITIONS
- Facility for third party UIs
","title":"Update v3.742","updateavailable":true}
Aug 23 20:34:57 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Aug 23 20:34:57 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:34:57 volumio volumio[870]: info: CorePlayQueue::getTrack 0
Aug 23 20:34:57 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:34:57 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:34:57 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:34:58 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:34:58 volumio volumio[870]: info: CorePlayQueue::getTrack 0
Aug 23 20:34:58 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:34:58 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:34:58 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:34:59 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:34:59 volumio volumio[870]: info: CorePlayQueue::getTrack 0
Aug 23 20:34:59 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:34:59 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:34:59 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:35:00 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:35:00 volumio volumio[870]: info: CorePlayQueue::getTrack 0
Aug 23 20:35:00 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:35:00 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:35:00 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:35:01 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:35:01 volumio volumio[870]: info: CorePlayQueue::getTrack 0
Aug 23 20:35:01 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:35:01 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:35:01 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:35:01 volumio volumio[870]: info: CoreCommandRouter::volumioPlay
Aug 23 20:35:01 volumio volumio[870]: info: CoreStateMachine::play index undefined
Aug 23 20:35:01 volumio volumio[870]: info: CoreStateMachine::setConsumeUpdateService undefined
Aug 23 20:35:01 volumio volumio[870]: info: CorePlayQueue::getTrack 0
Aug 23 20:35:01 volumio volumio[870]: info: CoreStateMachine::startPlaybackTimer
Aug 23 20:35:01 volumio volumio[870]: info: CorePlayQueue::getTrack 0
Aug 23 20:35:01 volumio volumio[870]: info: [1724438101719] ControllerWebradio::clearAddPlayTrack
Aug 23 20:35:01 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand stop
Aug 23 20:35:01 volumio volumio[870]: info: sendMpdCommand stop took 2 milliseconds
Aug 23 20:35:01 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand clear
Aug 23 20:35:01 volumio volumio[870]: info: sendMpdCommand clear took 1 milliseconds
Aug 23 20:35:01 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1809057"
Aug 23 20:35:01 volumio volumio[870]: info:
Aug 23 20:35:01 volumio volumio[870]: ---------------------------- MPD announces system playlist update
Aug 23 20:35:01 volumio volumio[870]: info: Ignoring MPD Status Update
Aug 23 20:35:01 volumio volumio[870]: info:
Aug 23 20:35:01 volumio volumio[870]: ---------------------------- MPD announces system playlist update
Aug 23 20:35:01 volumio volumio[870]: info: Ignoring MPD Status Update
Aug 23 20:35:01 volumio volumio[870]: info:
Aug 23 20:35:01 volumio volumio[870]: ---------------------------- MPD announces system playlist update
Aug 23 20:35:01 volumio volumio[870]: info: Ignoring MPD Status Update
Aug 23 20:35:01 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 23 20:35:01 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Aug 23 20:35:01 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Aug 23 20:35:01 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Aug 23 20:35:01 volumio volumio[870]: info: CoreCommandRouter::volumioGetBrowseSources
Aug 23 20:35:01 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Aug 23 20:35:02 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:35:02 volumio volumio[870]: info: CorePlayQueue::getTrack 0
Aug 23 20:35:02 volumio volumio[870]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1809057" took 592 milliseconds
Aug 23 20:35:02 volumio volumio[870]: info: CoreStateMachine::setConsumeUpdateService mpd
Aug 23 20:35:02 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand play
Aug 23 20:35:02 volumio volumio[870]: info:
Aug 23 20:35:02 volumio volumio[870]: ---------------------------- MPD announces system playlist update
Aug 23 20:35:02 volumio volumio[870]: info: Ignoring MPD Status Update
Aug 23 20:35:02 volumio volumio[870]: info: ------------------------------ 594ms
Aug 23 20:35:02 volumio volumio[870]: info: ------------------------------ 592ms
Aug 23 20:35:02 volumio volumio[870]: info: ------------------------------ 576ms
Aug 23 20:35:02 volumio volumio[870]: info:
Aug 23 20:35:02 volumio volumio[870]: ---------------------------- MPD announces system playlist update
Aug 23 20:35:02 volumio volumio[870]: info: Ignoring MPD Status Update
Aug 23 20:35:02 volumio volumio[870]: info:
Aug 23 20:35:02 volumio volumio[870]: ---------------------------- MPD announces system playlist update
Aug 23 20:35:02 volumio volumio[870]: info: Ignoring MPD Status Update
Aug 23 20:35:02 volumio volumio[870]: info: sendMpdCommand play took 5 milliseconds
Aug 23 20:35:02 volumio volumio[870]: info: ------------------------------ 6ms
Aug 23 20:35:02 volumio volumio[870]: info: ------------------------------ 2ms
Aug 23 20:35:02 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:35:02 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:35:02 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:35:02 volumio volumio[870]: info:
Aug 23 20:35:02 volumio volumio[870]: ---------------------------- MPD announces state update: player
Aug 23 20:35:02 volumio volumio[870]: info: ControllerMpd::getState
Aug 23 20:35:02 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 20:35:02 volumio volumio[870]: info:
Aug 23 20:35:02 volumio volumio[870]: ---------------------------- MPD announces state update: player
Aug 23 20:35:02 volumio volumio[870]: info: ControllerMpd::getState
Aug 23 20:35:02 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 20:35:02 volumio volumio[870]: info:
Aug 23 20:35:02 volumio volumio[870]: ---------------------------- MPD announces state update: player
Aug 23 20:35:02 volumio volumio[870]: info: ControllerMpd::getState
Aug 23 20:35:02 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 20:35:02 volumio volumio[870]: info:
Aug 23 20:35:02 volumio volumio[870]: ---------------------------- MPD announces state update: player
Aug 23 20:35:02 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand clearerror
Aug 23 20:35:02 volumio volumio[870]: info: sendMpdCommand status took 6 milliseconds
Aug 23 20:35:02 volumio volumio[870]: info: ControllerMpd::getState
Aug 23 20:35:02 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 20:35:02 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand clearerror
Aug 23 20:35:02 volumio volumio[870]: info: sendMpdCommand status took 6 milliseconds
Aug 23 20:35:02 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand clearerror
Aug 23 20:35:02 volumio volumio[870]: info: sendMpdCommand status took 6 milliseconds
Aug 23 20:35:02 volumio volumio[870]: verbose: ControllerMpd::parseState
Aug 23 20:35:02 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 23 20:35:02 volumio volumio[870]: verbose: ControllerMpd::parseState
Aug 23 20:35:02 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 23 20:35:02 volumio mpd[1116]: exception: Failed to open "default detected output" (sndio); Requested audio params cannot be satisfied
Aug 23 20:35:02 volumio mpd[1116]: player: problems opening audio device while playing "http://54.38.43.201:8057/Costa-Del-Mar-Original"
Aug 23 20:35:02 volumio volumio[870]: verbose: ControllerMpd::parseState
Aug 23 20:35:02 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 23 20:35:02 volumio volumio[870]: info:
Aug 23 20:35:02 volumio volumio[870]: ---------------------------- MPD announces state update: player
Aug 23 20:35:02 volumio volumio[870]: info: ControllerMpd::getState
Aug 23 20:35:02 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 20:35:02 volumio volumio[870]: info:
Aug 23 20:35:02 volumio volumio[870]: ---------------------------- MPD announces state update: player
Aug 23 20:35:02 volumio volumio[870]: info: ControllerMpd::getState
Aug 23 20:35:02 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand status
Aug 23 20:35:02 volumio volumio[870]: info: sendMpdCommand clearerror took 36 milliseconds
Aug 23 20:35:02 volumio volumio[870]: info: sendMpdCommand status took 37 milliseconds
Aug 23 20:35:02 volumio volumio[870]: info: sendMpdCommand clearerror took 36 milliseconds
Aug 23 20:35:02 volumio volumio[870]: info: sendMpdCommand clearerror took 36 milliseconds
Aug 23 20:35:02 volumio volumio[870]: info: sendMpdCommand playlistinfo took 33 milliseconds
Aug 23 20:35:02 volumio volumio[870]: info: sendMpdCommand playlistinfo took 33 milliseconds
Aug 23 20:35:02 volumio volumio[870]: info: sendMpdCommand playlistinfo took 22 milliseconds
Aug 23 20:35:02 volumio volumio[870]: info: sendMpdCommand status took 13 milliseconds
Aug 23 20:35:02 volumio volumio[870]: info: sendMpdCommand status took 4 milliseconds
Aug 23 20:35:02 volumio volumio[870]: verbose: ControllerMpd::parseState
Aug 23 20:35:02 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 23 20:35:02 volumio volumio[870]: verbose: ControllerMpd::parseTrackInfo
Aug 23 20:35:02 volumio volumio[870]: verbose: ControllerMpd::parseTrackInfo
Aug 23 20:35:02 volumio volumio[870]: verbose: ControllerMpd::parseTrackInfo
Aug 23 20:35:02 volumio volumio[870]: verbose: ControllerMpd::parseState
Aug 23 20:35:02 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 23 20:35:02 volumio volumio[870]: verbose: ControllerMpd::parseState
Aug 23 20:35:02 volumio volumio[870]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 23 20:35:02 volumio volumio[870]: info: ControllerMpd::pushState
Aug 23 20:35:02 volumio volumio[870]: info: CoreCommandRouter::servicePushState
Aug 23 20:35:02 volumio volumio[870]: info: CorePlayQueue::getTrack 0
Aug 23 20:35:02 volumio volumio[870]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Costa-Del-Mar-Original","artist":"(#1 - 16/2000) Costa Del Mar (Original)","album":null,"uri":"http://54.38.43.201:8057/Costa-Del-Mar-Original","trackType":""}
Aug 23 20:35:02 volumio volumio[870]: verbose: CURRENT POSITION 0
Aug 23 20:35:02 volumio volumio[870]: info: CoreStateMachine::syncState stateService pause
Aug 23 20:35:02 volumio volumio[870]: info: CoreStateMachine::syncState currentStatus stop
Aug 23 20:35:02 volumio volumio[870]: info: CoreStateMachine::pushState
Aug 23 20:35:02 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 23 20:35:02 volumio volumio[870]: info: CoreCommandRouter::volumioPushState
Aug 23 20:35:02 volumio volumio[870]: info: ControllerMpd::pushState
Aug 23 20:35:02 volumio volumio[870]: info: CoreCommandRouter::servicePushState
Aug 23 20:35:02 volumio volumio[870]: info: CorePlayQueue::getTrack 0
Aug 23 20:35:02 volumio volumio[870]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Costa-Del-Mar-Original","artist":"(#1 - 16/2000) Costa Del Mar (Original)","album":null,"uri":"http://54.38.43.201:8057/Costa-Del-Mar-Original","trackType":""}
Aug 23 20:35:02 volumio volumio[870]: verbose: CURRENT POSITION 0
Aug 23 20:35:02 volumio volumio[870]: info: CoreStateMachine::syncState stateService pause
Aug 23 20:35:02 volumio volumio[870]: info: CoreStateMachine::syncState currentStatus stop
Aug 23 20:35:02 volumio volumio[870]: info: CoreStateMachine::pushState
Aug 23 20:35:02 volumio volumio[870]: info: CoreCommandRouter::volumioPushState
Aug 23 20:35:02 volumio volumio[870]: info: ControllerMpd::pushState
Aug 23 20:35:02 volumio volumio[870]: info: CoreCommandRouter::servicePushState
Aug 23 20:35:02 volumio volumio[870]: info: CorePlayQueue::getTrack 0
Aug 23 20:35:02 volumio volumio[870]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Costa-Del-Mar-Original","artist":"(#1 - 16/2000) Costa Del Mar (Original)","album":null,"uri":"http://54.38.43.201:8057/Costa-Del-Mar-Original","trackType":""}
Aug 23 20:35:02 volumio volumio[870]: verbose: CURRENT POSITION 0
Aug 23 20:35:02 volumio volumio[870]: info: CoreStateMachine::syncState stateService pause
Aug 23 20:35:02 volumio volumio[870]: info: CoreStateMachine::syncState currentStatus stop
Aug 23 20:35:02 volumio volumio[870]: info: CoreStateMachine::pushState
Aug 23 20:35:02 volumio volumio[870]: info: CoreCommandRouter::volumioPushState
Aug 23 20:35:02 volumio volumio[870]: info: ------------------------------ 116ms
Aug 23 20:35:02 volumio volumio[870]: info: ------------------------------ 115ms
Aug 23 20:35:02 volumio volumio[870]: info: ------------------------------ 115ms
Aug 23 20:35:02 volumio volumio[870]: info: sendMpdCommand playlistinfo took 80 milliseconds
Aug 23 20:35:02 volumio volumio[870]: info: sendMpdCommand playlistinfo took 93 milliseconds
Aug 23 20:35:02 volumio volumio[870]: info: sendMpdCommand playlistinfo took 91 milliseconds
Aug 23 20:35:02 volumio volumio[870]: verbose: ControllerMpd::parseTrackInfo
Aug 23 20:35:02 volumio volumio[870]: verbose: ControllerMpd::parseTrackInfo
Aug 23 20:35:02 volumio volumio[870]: verbose: ControllerMpd::parseTrackInfo
Aug 23 20:35:02 volumio volumio[870]: info: ControllerMpd::pushState
Aug 23 20:35:02 volumio volumio[870]: info: CoreCommandRouter::servicePushState
Aug 23 20:35:02 volumio volumio[870]: info: CorePlayQueue::getTrack 0
Aug 23 20:35:02 volumio volumio[870]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Costa-Del-Mar-Original","artist":"(#1 - 16/2000) Costa Del Mar (Original)","album":null,"uri":"http://54.38.43.201:8057/Costa-Del-Mar-Original","trackType":""}
Aug 23 20:35:02 volumio volumio[870]: verbose: CURRENT POSITION 0
Aug 23 20:35:02 volumio volumio[870]: info: CoreStateMachine::syncState stateService pause
Aug 23 20:35:02 volumio volumio[870]: info: CoreStateMachine::syncState currentStatus stop
Aug 23 20:35:02 volumio volumio[870]: info: CoreStateMachine::pushState
Aug 23 20:35:02 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 23 20:35:02 volumio volumio[870]: info: CoreCommandRouter::volumioPushState
Aug 23 20:35:02 volumio volumio[870]: info: ControllerMpd::pushState
Aug 23 20:35:02 volumio volumio[870]: info: CoreCommandRouter::servicePushState
Aug 23 20:35:02 volumio volumio[870]: info: CorePlayQueue::getTrack 0
Aug 23 20:35:02 volumio volumio[870]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Costa-Del-Mar-Original","artist":"(#1 - 16/2000) Costa Del Mar (Original)","album":null,"uri":"http://54.38.43.201:8057/Costa-Del-Mar-Original","trackType":""}
Aug 23 20:35:02 volumio volumio[870]: verbose: CURRENT POSITION 0
Aug 23 20:35:02 volumio volumio[870]: info: CoreStateMachine::syncState stateService pause
Aug 23 20:35:02 volumio volumio[870]: info: CoreStateMachine::syncState currentStatus stop
Aug 23 20:35:02 volumio volumio[870]: info: CoreStateMachine::pushState
Aug 23 20:35:02 volumio volumio[870]: info: CoreCommandRouter::volumioPushState
Aug 23 20:35:02 volumio volumio[870]: info: ControllerMpd::pushState
Aug 23 20:35:02 volumio volumio[870]: info: CoreCommandRouter::servicePushState
Aug 23 20:35:02 volumio volumio[870]: info: CorePlayQueue::getTrack 0
Aug 23 20:35:02 volumio volumio[870]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Costa-Del-Mar-Original","artist":"(#1 - 16/2000) Costa Del Mar (Original)","album":null,"uri":"http://54.38.43.201:8057/Costa-Del-Mar-Original","trackType":""}
Aug 23 20:35:02 volumio volumio[870]: verbose: CURRENT POSITION 0
Aug 23 20:35:02 volumio volumio[870]: info: CoreStateMachine::syncState stateService pause
Aug 23 20:35:02 volumio volumio[870]: info: CoreStateMachine::syncState currentStatus stop
Aug 23 20:35:02 volumio volumio[870]: info: CoreStateMachine::pushState
Aug 23 20:35:02 volumio volumio[870]: info: CoreCommandRouter::volumioPushState
Aug 23 20:35:02 volumio volumio[870]: info: ------------------------------ 182ms
Aug 23 20:35:02 volumio volumio[870]: info: ------------------------------ 163ms
Aug 23 20:35:02 volumio volumio[870]: info: ------------------------------ 154ms
Aug 23 20:35:02 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:35:02 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:35:02 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:35:02 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:35:02 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:35:02 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:35:02 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:35:02 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:35:02 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:35:02 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:35:02 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:35:02 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:35:02 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:35:02 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:35:02 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:35:02 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:35:02 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:35:02 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:35:03 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:35:03 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:35:03 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:35:03 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:35:04 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:35:04 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:35:04 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:35:04 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:35:04 volumio volumio[870]: error: MyVolumio Plugin failed to authenticate in a timely fashion
Aug 23 20:35:04 volumio volumio[870]: info: Completed starting MyVolumio Plugin
Aug 23 20:35:04 volumio volumio[870]: info: BOOT COMPLETED
Aug 23 20:35:04 volumio volumio[870]: [Metrics] CommandRouter: 50s 990.03ms
Aug 23 20:35:04 volumio volumio[870]: info: CoreCommandRouter::volumiosetStartupVolume
Aug 23 20:35:04 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 23 20:35:04 volumio volumio[870]: info: VolumeController:: Setting startup Volume 75
Aug 23 20:35:04 volumio volumio[870]: info: VolumeController::SetAlsaVolume75
Aug 23 20:35:04 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 23 20:35:04 volumio volumio[870]: info: CoreCommandRouter::Close All Modals sent
Aug 23 20:35:04 volumio volumio[870]: info: CoreCommandRouter::Close All Modals sent
Aug 23 20:35:04 volumio volumio[870]: info: CoreStateMachine::pushState
Aug 23 20:35:04 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 23 20:35:04 volumio volumio[870]: info: CoreCommandRouter::volumioPushState
Aug 23 20:35:04 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:35:04 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:35:04 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:35:05 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:35:05 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:35:05 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:35:05 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:35:05 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Aug 23 20:35:05 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Aug 23 20:35:05 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Aug 23 20:35:06 volumio volumio[1216]: .........................................................................................................................++++
Aug 23 20:35:06 volumio volumio[1216]: e is 65537 (0x010001)
Aug 23 20:35:06 volumio volumio[1216]: writing RSA key
Aug 23 20:35:06 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:35:06 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:35:06 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:35:06 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:35:07 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:35:07 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:35:07 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:35:07 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:35:07 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Aug 23 20:35:07 volumio volumio[870]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Aug 23 20:35:07 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Aug 23 20:35:07 volumio volumio[870]: info: Received Get System Version
Aug 23 20:35:07 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Aug 23 20:35:07 volumio volumio[870]: info: Received Get System Info
Aug 23 20:35:07 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 23 20:35:07 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 23 20:35:07 volumio volumio[870]: info: Discovery: Getting this device information
Aug 23 20:35:07 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:35:07 volumio volumio[870]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 23 20:35:08 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:35:08 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:35:08 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:35:08 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:35:09 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:35:09 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:35:09 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:35:09 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:35:10 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:35:10 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:35:10 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:35:10 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:35:11 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:35:11 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:35:11 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:35:11 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:35:12 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:35:12 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:35:12 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:35:12 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:35:13 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:35:13 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:35:13 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:35:13 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:35:14 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:35:14 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:35:14 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:35:14 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:35:15 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:35:15 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:35:15 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:35:15 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:35:16 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:35:16 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:35:16 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:35:16 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:35:17 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:35:17 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:35:17 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:35:17 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:35:18 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:35:18 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:35:18 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:35:18 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:35:19 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:35:19 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:35:19 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:35:19 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:35:20 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:35:20 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:35:20 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:35:20 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:35:21 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:35:21 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:35:21 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:35:21 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:35:22 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:35:22 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:35:22 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:35:22 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:35:23 volumio volumio[870]: info: CoreCommandRouter::volumioGetState
Aug 23 20:35:23 volumio volumio[870]: info: CoreCommandRouter::volumioGetQueue
Aug 23 20:35:23 volumio volumio[870]: info: CoreStateMachine::getQueue
Aug 23 20:35:23 volumio volumio[870]: info: CorePlayQueue::getQueue
Aug 23 20:35:23 volumio volumio[870]: info: ___________ PLUGINS: Run onVolumioReboot Tasks ___________
Aug 23 20:35:23 volumio volumio[870]: info: PLUGIN onReboot : networkfs
Aug 23 20:35:23 volumio sudo[1608]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /mnt/NAS/Multimedia
Aug 23 20:35:23 volumio sudo[1608]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 23 20:35:24 volumio systemd[1]: mnt-NAS-Multimedia.mount: Succeeded.
Aug 23 20:35:24 volumio sudo[1608]: pam_unix(sudo:session): session closed for user root
Aug 23 20:35:24 volumio volumio[870]: info: PLUGIN onReboot : audiophonicsonoff
Aug 23 20:35:24 volumio volumio[870]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Aug 23 20:35:24 volumio volumio[870]: TypeError: Cannot read property 'writeSync' of undefined
Aug 23 20:35:24 volumio volumio[870]: at ControllerAudiophonicsOnOff.onVolumioReboot (/data/plugins/system_controller/audiophonicsonoff/index.js:35:25)
Aug 23 20:35:24 volumio volumio[870]: at PluginManager.onVolumioRebootPlugin (/volumio/app/pluginmanager.js:684:30)
Aug 23 20:35:24 volumio volumio[870]: at HashMap. (/volumio/app/pluginmanager.js:668:31)
Aug 23 20:35:24 volumio volumio[870]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10)
Aug 23 20:35:24 volumio volumio[870]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7)
Aug 23 20:35:24 volumio volumio[870]: at PluginManager.onVolumioReboot (/volumio/app/pluginmanager.js:666:20)
Aug 23 20:35:24 volumio volumio[870]: at CoreCommandRouter.reboot (/volumio/app/index.js:1331:22)
Aug 23 20:35:24 volumio volumio[870]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:857:33)
Aug 23 20:35:24 volumio volumio[870]: at Socket.emit (events.js:315:20)
Aug 23 20:35:24 volumio volumio[870]: at /volumio/node_modules/socket.io/lib/socket.js:528:12
Aug 23 20:35:24 volumio volumio[870]: at processTicksAndRejections (internal/process/task_queues.js:75:11)
Aug 23 20:35:24 volumio volumio[870]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Aug 23 20:35:24 volumio sudo[1620]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-23 20:34
Aug 23 20:35:24 volumio sudo[1620]: 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="4b122b2365bb8c09786cd63b50d1ea6db780eb4e"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST"
VOLUMIO_VERSION="3.703"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"