-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Sun 2025-06-22 13:13:46 UTC. -- Jun 22 13:12:03 volumio volumio[871]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 22 13:12:03 volumio volumio[871]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jun 22 13:12:03 volumio volumio[871]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jun 22 13:12:03 volumio volumio[871]: info: Error : CoreCommandRouter::executeOnPlugin: No method [retreiveBackendEventStates] in plugin my_volumio Jun 22 13:12:03 volumio volumio[871]: info: Received Get System Version Jun 22 13:12:03 volumio volumio[871]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 22 13:12:20 volumio volumio[871]: info: + geo-tz@8.1.4 Jun 22 13:12:20 volumio volumio[871]: info: added 29 packages from 33 contributors and audited 354 packages in 36.318s Jun 22 13:12:21 volumio volumio[871]: info: Jun 22 13:12:21 volumio volumio[871]: info: 22 packages are looking for funding Jun 22 13:12:21 volumio volumio[871]: info: run `npm fund` for details Jun 22 13:12:21 volumio volumio[871]: info: Jun 22 13:12:21 volumio volumio[871]: info: found 6 vulnerabilities (4 low, 2 high) Jun 22 13:12:21 volumio volumio[871]: info: run `npm audit fix` to fix them, or `npm audit` for details Jun 22 13:12:28 volumio volumio[871]: info: + point-in-polygon-hao@1.1.0 Jun 22 13:12:28 volumio volumio[871]: info: removed 1 package, updated 1 package and audited 354 packages in 6.19s Jun 22 13:12:29 volumio volumio[871]: info: Jun 22 13:12:29 volumio volumio[871]: info: 22 packages are looking for funding Jun 22 13:12:29 volumio volumio[871]: info: run `npm fund` for details Jun 22 13:12:29 volumio volumio[871]: info: Jun 22 13:12:29 volumio volumio[871]: info: found 6 vulnerabilities (4 low, 2 high) Jun 22 13:12:29 volumio volumio[871]: info: run `npm audit fix` to fix them, or `npm audit` for details Jun 22 13:12:29 volumio volumio[871]: info: Creating user directories (if not exist) Jun 22 13:12:29 volumio sudo[2230]: pam_unix(sudo:session): session closed for user root Jun 22 13:12:29 volumio volumio[871]: info: Now Playing plugin installed Jun 22 13:12:29 volumio volumio[871]: Plugin install end detected on script Jun 22 13:12:29 volumio volumio[871]: info: Install script completed Jun 22 13:12:29 volumio volumio[871]: info: Done installing plugin. Jun 22 13:12:29 volumio volumio[871]: info: Enabling plugin now_playing Jun 22 13:12:29 volumio volumio[871]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 22 13:12:29 volumio volumio[871]: info: [{"prettyName":"Contemporary advanced","name":"contemporary_advanced","category":"miscellanea","version":"1.0.6","icon":"fa-lightbulb-o","isManuallyInstalled":true,"enabled":true,"active":true},{"prettyName":"PeppyMeter Screensaver","name":"peppy_screensaver","category":"miscellanea","version":"1.3.0","icon":"fa-lightbulb-o","isManuallyInstalled":true,"enabled":true,"active":true},{"prettyName":"Roon Bridge","name":"RoonBridge","category":"music_service","version":"1.0.0","icon":"fas fa-volume-up","isManuallyInstalled":false,"active":false},{"prettyName":"Squeezelite MC","name":"squeezelite_mc","category":"music_service","version":"1.0.4","icon":"fa-play-circle-o","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"YouTube2","name":"youtube2","category":"music_service","version":"1.3.3","icon":"fa-youtube-play","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"IR Remote Controller","name":"ir_controller","category":"system_hardware","version":"3.4.11","icon":"fa-magic","isManuallyInstalled":false,"active":false},{"prettyName":"Now Playing","name":"now_playing","category":"user_interface","version":"0.7.5","icon":"fa-play-circle","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"Touch Display","name":"touch_display","category":"user_interface","version":"3.3.7","icon":"fa-hand-pointer-o","isManuallyInstalled":false,"enabled":true,"active":true}] Jun 22 13:12:29 volumio volumio[871]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jun 22 13:12:29 volumio volumio[871]: info: Folder /tmp/plugins removed Jun 22 13:12:29 volumio volumio[871]: info: Folder /tmp/downloaded_plugin.zip removed Jun 22 13:12:29 volumio volumio[871]: info: Folder /data/temp removed Jun 22 13:12:46 volumio volumio[871]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 22 13:12:46 volumio volumio[871]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jun 22 13:12:51 volumio volumio[871]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl stop squeezelite || true Jun 22 13:12:51 volumio volumio[871]: info: [squeezelite_mc] Proxy server stopped Jun 22 13:12:51 volumio sudo[2474]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop squeezelite Jun 22 13:12:51 volumio sudo[2474]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:12:51 volumio sudo[2474]: pam_unix(sudo:session): session closed for user root Jun 22 13:12:52 volumio volumio[871]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Jun 22 13:12:52 volumio sudo[2477]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Jun 22 13:12:52 volumio sudo[2477]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:12:52 volumio sudo[2477]: pam_unix(sudo:session): session closed for user root Jun 22 13:12:52 volumio volumio[871]: info: Disabling plugin squeezelite_mc Jun 22 13:12:52 volumio volumio[871]: info: Done. Jun 22 13:12:58 volumio volumio[871]: info: Enabling plugin squeezelite_mc Jun 22 13:12:58 volumio volumio[871]: info: Loading plugin "squeezelite_mc"... Jun 22 13:12:58 volumio volumio[871]: info: PLUGIN START: squeezelite_mc Jun 22 13:12:58 volumio volumio[871]: info: [squeezelite_mc] Starting proxy server... Jun 22 13:12:58 volumio volumio[871]: info: [squeezelite_mc] Proxy server started on port 42033 Jun 22 13:12:58 volumio volumio[871]: info: CoreCommandRouter::volumioRetrievevolume Jun 22 13:12:58 volumio volumio[871]: info: CoreStateMachine::pushState Jun 22 13:12:58 volumio volumio[871]: info: CorePlayQueue::getTrack 0 Jun 22 13:12:58 volumio volumio[871]: info: CoreCommandRouter::volumioPushState Jun 22 13:12:58 volumio volumio[871]: info: [squeezelite_mc] Server discovery started Jun 22 13:12:58 volumio volumio[871]: info: [squeezelite_mc] Player finder started Jun 22 13:12:58 volumio volumio[871]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 13:12:58 volumio volumio[871]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 13:12:58 volumio volumio[871]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 13:12:58 volumio volumio[871]: info: [squeezelite_mc] Executing aplay -D hw:2 --nonblock -f MPEG /dev/zero 2>&1 || true Jun 22 13:12:58 volumio volumio[871]: info: [squeezelite_mc] Server discovered: {"ip":"192.168.110.187","name":"daphile","ver":"8.5.3","uuid":"ffe1fdc1-51d3-41a9-b10f-dce700927bc3","jsonPort":"9000","cliPort":"9090"} Jun 22 13:12:58 volumio volumio[871]: info: [squeezelite_mc] Card 2 supports the following ALSA formats: ["S16_LE","S24_LE"] Jun 22 13:12:58 volumio volumio[871]: info: [squeezelite_mc] Starting Squeezelite service with params: {"type":"basic","playerName":"volumio","dsdFormat":null,"card":"2","mixerType":"Software","mixer":"SoftMaster"} Jun 22 13:12:58 volumio volumio[871]: info: [squeezelite_mc] Executing cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf Jun 22 13:12:59 volumio sudo[2491]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf Jun 22 13:12:59 volumio sudo[2491]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:12:59 volumio sudo[2491]: pam_unix(sudo:session): session closed for user root Jun 22 13:12:59 volumio volumio[871]: info: [squeezelite_mc] Executing alsactl -L -R nrestore Jun 22 13:12:59 volumio sudo[2495]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/alsactl -L -R nrestore Jun 22 13:12:59 volumio sudo[2495]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:12:59 volumio sudo[2495]: pam_unix(sudo:session): session closed for user root Jun 22 13:12:59 volumio volumio[871]: info: [squeezelite_mc] Executing cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/systemd/squeezelite.service.template.out /etc/systemd/system/squeezelite.service Jun 22 13:12:59 volumio sudo[2499]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/systemd/squeezelite.service.template.out /etc/systemd/system/squeezelite.service Jun 22 13:12:59 volumio sudo[2499]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:12:59 volumio sudo[2499]: pam_unix(sudo:session): session closed for user root Jun 22 13:12:59 volumio volumio[871]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl daemon-reload || true Jun 22 13:12:59 volumio sudo[2502]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Jun 22 13:12:59 volumio sudo[2502]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:12:59 volumio systemd[1]: Reloading. Jun 22 13:12:59 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. Jun 22 13:12:59 volumio sudo[2502]: pam_unix(sudo:session): session closed for user root Jun 22 13:12:59 volumio volumio[871]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Jun 22 13:12:59 volumio sudo[2518]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Jun 22 13:12:59 volumio sudo[2518]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:12:59 volumio volumio[871]: info: [squeezelite_mc] Notification listener started Jun 22 13:12:59 volumio volumio[871]: info: [squeezelite_mc] Getting players connected to daphile (192.168.110.187) Jun 22 13:12:59 volumio volumio[871]: info: [squeezelite_mc] Players connected to daphile (192.168.110.187): [{"id":"d8:3a:dd:9c:48:01","uuid":null,"ip":"192.168.110.175","name":"HiRes-AUDIO","server":{"ip":"192.168.110.187","name":"daphile","ver":"8.5.3","uuid":"ffe1fdc1-51d3-41a9-b10f-dce700927bc3","jsonPort":"9000","cliPort":"9090"}},{"id":"bb:bb:31:75:36:96","uuid":null,"ip":"192.168.110.187","name":"Volumio-UPnP/AV","server":{"ip":"192.168.110.187","name":"daphile","ver":"8.5.3","uuid":"ffe1fdc1-51d3-41a9-b10f-dce700927bc3","jsonPort":"9000","cliPort":"9090"}},{"id":"bb:bb:c6:0e:92:49","uuid":null,"ip":"192.168.110.187","name":"[TV] Samsung 6 Series (49)","server":{"ip":"192.168.110.187","name":"daphile","ver":"8.5.3","uuid":"ffe1fdc1-51d3-41a9-b10f-dce700927bc3","jsonPort":"9000","cliPort":"9090"}}] Jun 22 13:12:59 volumio sudo[2518]: pam_unix(sudo:session): session closed for user root Jun 22 13:12:59 volumio volumio[871]: info: [squeezelite_mc] Executing rm /tmp/squeezelite.log Jun 22 13:13:00 volumio sudo[2522]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm /tmp/squeezelite.log Jun 22 13:13:00 volumio sudo[2522]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:13:00 volumio sudo[2522]: pam_unix(sudo:session): session closed for user root Jun 22 13:13:00 volumio volumio[871]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl start squeezelite || true Jun 22 13:13:00 volumio sudo[2525]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start squeezelite Jun 22 13:13:00 volumio sudo[2525]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:13:00 volumio systemd[1]: Starting Squeezelite lightweight headless Squeezebox emulator... Jun 22 13:13:00 volumio systemd[1]: Started Squeezelite lightweight headless Squeezebox emulator. Jun 22 13:13:00 volumio sudo[2525]: pam_unix(sudo:session): session closed for user root Jun 22 13:13:00 volumio systemd[1]: squeezelite.service: Succeeded. Jun 22 13:13:00 volumio systemd[1]: squeezelite.service: Service RestartSec=100ms expired, scheduling restart. Jun 22 13:13:00 volumio systemd[1]: squeezelite.service: Scheduled restart job, restart counter is at 1. Jun 22 13:13:00 volumio systemd[1]: Stopped Squeezelite lightweight headless Squeezebox emulator. Jun 22 13:13:00 volumio systemd[1]: Starting Squeezelite lightweight headless Squeezebox emulator... Jun 22 13:13:00 volumio systemd[1]: Started Squeezelite lightweight headless Squeezebox emulator. Jun 22 13:13:00 volumio systemd[1]: squeezelite.service: Succeeded. Jun 22 13:13:00 volumio systemd[1]: squeezelite.service: Service RestartSec=100ms expired, scheduling restart. Jun 22 13:13:00 volumio systemd[1]: squeezelite.service: Scheduled restart job, restart counter is at 2. Jun 22 13:13:00 volumio systemd[1]: Stopped Squeezelite lightweight headless Squeezebox emulator. Jun 22 13:13:00 volumio systemd[1]: Starting Squeezelite lightweight headless Squeezebox emulator... Jun 22 13:13:00 volumio systemd[1]: Started Squeezelite lightweight headless Squeezebox emulator. Jun 22 13:13:00 volumio systemd[1]: squeezelite.service: Succeeded. Jun 22 13:13:00 volumio volumio[871]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Jun 22 13:13:00 volumio sudo[2534]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Jun 22 13:13:00 volumio sudo[2534]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:13:00 volumio systemd[1]: squeezelite.service: Service RestartSec=100ms expired, scheduling restart. Jun 22 13:13:00 volumio systemd[1]: squeezelite.service: Scheduled restart job, restart counter is at 3. Jun 22 13:13:00 volumio systemd[1]: Stopped Squeezelite lightweight headless Squeezebox emulator. Jun 22 13:13:00 volumio sudo[2534]: pam_unix(sudo:session): session closed for user root Jun 22 13:13:00 volumio systemd[1]: Starting Squeezelite lightweight headless Squeezebox emulator... Jun 22 13:13:00 volumio systemd[1]: Started Squeezelite lightweight headless Squeezebox emulator. Jun 22 13:13:00 volumio systemd[1]: squeezelite.service: Succeeded. Jun 22 13:13:01 volumio systemd[1]: squeezelite.service: Service RestartSec=100ms expired, scheduling restart. Jun 22 13:13:01 volumio systemd[1]: squeezelite.service: Scheduled restart job, restart counter is at 4. Jun 22 13:13:01 volumio systemd[1]: Stopped Squeezelite lightweight headless Squeezebox emulator. Jun 22 13:13:01 volumio systemd[1]: Starting Squeezelite lightweight headless Squeezebox emulator... Jun 22 13:13:01 volumio systemd[1]: Started Squeezelite lightweight headless Squeezebox emulator. Jun 22 13:13:01 volumio systemd[1]: squeezelite.service: Succeeded. Jun 22 13:13:01 volumio volumio[871]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Jun 22 13:13:01 volumio sudo[2543]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Jun 22 13:13:01 volumio sudo[2543]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:13:01 volumio systemd[1]: squeezelite.service: Service RestartSec=100ms expired, scheduling restart. Jun 22 13:13:01 volumio systemd[1]: squeezelite.service: Scheduled restart job, restart counter is at 5. Jun 22 13:13:01 volumio systemd[1]: Stopped Squeezelite lightweight headless Squeezebox emulator. Jun 22 13:13:01 volumio systemd[1]: squeezelite.service: Start request repeated too quickly. Jun 22 13:13:01 volumio systemd[1]: squeezelite.service: Failed with result 'start-limit-hit'. Jun 22 13:13:01 volumio systemd[1]: Failed to start Squeezelite lightweight headless Squeezebox emulator. Jun 22 13:13:01 volumio sudo[2543]: pam_unix(sudo:session): session closed for user root Jun 22 13:13:01 volumio volumio[871]: info: Error: Error Jun 22 13:13:10 volumio volumio[871]: info: Enabling plugin ir_controller Jun 22 13:13:10 volumio volumio[871]: info: Loading plugin "ir_controller"... Jun 22 13:13:10 volumio volumio[871]: info: Applying required configuration parameters for plugin ir_controller Jun 22 13:13:10 volumio volumio[871]: info: PLUGIN START: ir_controller Jun 22 13:13:10 volumio volumio[871]: info: Loading i18n strings for locale vi Jun 22 13:13:10 volumio volumio[871]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Jun 22 13:13:10 volumio volumio[871]: error: ir_controller: Fetching language file: Error: i18n file complementing the system language not found. Jun 22 13:13:10 volumio volumio[871]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 22 13:13:10 volumio sudo[2549]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R a+rwX /etc/lirc/irexec.lircrc /etc/lirc/lirc_options.conf /etc/lirc/lircd.conf /etc/lirc/lircd.conf.d /etc/lirc/lircmd.conf /etc/lirc/lircrc Jun 22 13:13:10 volumio sudo[2549]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:13:11 volumio sudo[2549]: pam_unix(sudo:session): session closed for user root Jun 22 13:13:11 volumio volumio[871]: info: ir_controller: File permissions successfully set on /etc/lirc/*. Jun 22 13:13:11 volumio volumio[871]: info: ir_controller: LIRC correctly updated. Jun 22 13:13:11 volumio volumio[871]: info: ir_controller: HAT did not load /proc/device-tree/ir_receiver! Jun 22 13:13:11 volumio volumio[871]: info: Done. Jun 22 13:13:11 volumio volumio[871]: info: ir_controller: Raspberry Pi revision code: c03115 Jun 22 13:13:11 volumio sudo[2557]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -r -1 Jun 22 13:13:11 volumio sudo[2557]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:13:11 volumio sudo[2557]: pam_unix(sudo:session): session closed for user root Jun 22 13:13:11 volumio sudo[2564]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay gpio-ir gpio_pin=25 gpio_pull=up Jun 22 13:13:11 volumio sudo[2564]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:13:11 volumio kernel: Registered IR keymap rc-rc6-mce Jun 22 13:13:11 volumio sudo[2564]: pam_unix(sudo:session): session closed for user root Jun 22 13:13:11 volumio kernel: IR RC6 protocol handler initialized Jun 22 13:13:11 volumio volumio[871]: info: ir_controller: Overlay gpio-ir gpio_pin=25 gpio_pull=up loaded. Jun 22 13:13:11 volumio kernel: rc rc0: gpio_ir_recv as /devices/platform/ir-receiver@19/rc/rc0 Jun 22 13:13:11 volumio kernel: rc rc0: lirc_dev: driver gpio_ir_recv registered at minor = 0, raw IR receiver, no transmitter Jun 22 13:13:11 volumio kernel: input: gpio_ir_recv as /devices/platform/ir-receiver@19/rc/rc0/input0 Jun 22 13:13:11 volumio sudo[2576]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart lircd.service Jun 22 13:13:11 volumio sudo[2576]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:13:11 volumio systemd[1]: Starting lircd(8) initialization helper tool... Jun 22 13:13:11 volumio lircd-setup[2581]: /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. Jun 22 13:13:11 volumio lircd-setup[2581]: parser = configparser.SafeConfigParser() Jun 22 13:13:11 volumio systemd[1]: lircd-setup.service: Succeeded. Jun 22 13:13:11 volumio systemd[1]: Started lircd(8) initialization helper tool. Jun 22 13:13:11 volumio systemd[1]: Starting Flexible IR remote input/output application support... Jun 22 13:13:11 volumio lircd-0.10.1[2583]: Info: lircd: Opening log, level: Info Jun 22 13:13:11 volumio lircd-0.10.1[2583]: Notice: Version: lircd 0.10.1 Jun 22 13:13:11 volumio lircd-0.10.1[2583]: Notice: System info: Linux volumio 5.10.92-v7l+ #1514 SMP Mon Jan 17 17:38:03 GMT 2022 armv7l GNU/Linux Jun 22 13:13:11 volumio lircd-0.10.1[2583]: Info: Initial device: /dev/lirc0 Jun 22 13:13:11 volumio lircd-0.10.1[2583]: Notice: 'lirc' written to protocols file /sys/class/rc/rc0/protocols Jun 22 13:13:11 volumio lircd-0.10.1[2583]: Info: Initial device: /dev/lirc0 Jun 22 13:13:11 volumio lircd-0.10.1[2583]: Info: [lirc] protocol is enabled Jun 22 13:13:11 volumio lircd-0.10.1[2583]: Notice: Options: driver: default Jun 22 13:13:11 volumio lircd[2583]: lircd-0.10.1[2583]: Info: lircd: Opening log, level: Info Jun 22 13:13:11 volumio lircd-0.10.1[2583]: Notice: Options: output: /var/run/lirc/lircd Jun 22 13:13:11 volumio lircd[2583]: lircd-0.10.1[2583]: Notice: Using systemd fd Jun 22 13:13:11 volumio lircd[2583]: lircd-0.10.1[2583]: Warning: Running as root Jun 22 13:13:11 volumio lircd[2583]: lircd-0.10.1[2583]: Info: Using remote: lircd.conf. Jun 22 13:13:11 volumio lircd-0.10.1[2583]: Notice: Options: nodaemon: 1 Jun 22 13:13:11 volumio lircd-0.10.1[2583]: Notice: Options: plugindir: /usr/lib/arm-linux-gnueabihf/lirc/plugins Jun 22 13:13:11 volumio systemd[1]: Started Flexible IR remote input/output application support. Jun 22 13:13:11 volumio lircd-0.10.1[2583]: Notice: Options: logfile: syslog Jun 22 13:13:11 volumio lircd-0.10.1[2583]: Notice: Options: immediate-init: 0 Jun 22 13:13:11 volumio lircd[2583]: lircd-0.10.1[2583]: Notice: lircd(default) ready, using /var/run/lirc/lircd Jun 22 13:13:11 volumio lircd-0.10.1[2583]: Notice: Options: permission: 666 Jun 22 13:13:11 volumio lircd-0.10.1[2583]: Notice: Options: driver-options: Jun 22 13:13:11 volumio lircd-0.10.1[2583]: Notice: Options: pidfile: /var/run/lirc/lircd.pid Jun 22 13:13:11 volumio lircd-0.10.1[2583]: Notice: Options: listen: 0 Jun 22 13:13:11 volumio lircd-0.10.1[2583]: Notice: Options: connect: (null) Jun 22 13:13:11 volumio lircd-0.10.1[2583]: Notice: Options: userelease: 0 Jun 22 13:13:11 volumio lircd-0.10.1[2583]: Notice: Options: effective_user: (null) Jun 22 13:13:11 volumio lircd-0.10.1[2583]: Notice: Options: release_suffix: _EVUP Jun 22 13:13:11 volumio lircd-0.10.1[2583]: Notice: Options: allow_simulate: 0 Jun 22 13:13:11 volumio lircd-0.10.1[2583]: Notice: Options: repeat_max: 600 Jun 22 13:13:11 volumio lircd-0.10.1[2583]: Notice: Options: configfile: /etc/lirc/lircd.conf Jun 22 13:13:11 volumio lircd-0.10.1[2583]: Notice: Options: dynamic_codes: (null) Jun 22 13:13:11 volumio lircd-0.10.1[2583]: Notice: Current driver: default Jun 22 13:13:11 volumio lircd-0.10.1[2583]: Notice: Driver API version: 3 Jun 22 13:13:11 volumio lircd-0.10.1[2583]: Notice: Driver version: 0.10.0 Jun 22 13:13:11 volumio lircd-0.10.1[2583]: Notice: Driver info: See file:///usr/share/doc/lirc/plugindocs/default.html Jun 22 13:13:11 volumio lircd-0.10.1[2583]: Info: lircd: Opening log, level: Info Jun 22 13:13:11 volumio lircd-0.10.1[2583]: Notice: Using systemd fd Jun 22 13:13:11 volumio lircd-0.10.1[2583]: Warning: Running as root Jun 22 13:13:11 volumio lircd-0.10.1[2583]: Info: Using remote: lircd.conf. Jun 22 13:13:11 volumio volumio[871]: info: ir_controller: systemctl restart lircd.service succeeded. Jun 22 13:13:11 volumio lircd-0.10.1[2583]: Notice: lircd(default) ready, using /var/run/lirc/lircd Jun 22 13:13:11 volumio sudo[2576]: pam_unix(sudo:session): session closed for user root Jun 22 13:13:11 volumio sudo[2588]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart irexec.service Jun 22 13:13:11 volumio sudo[2588]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:13:11 volumio systemd-udevd[2578]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jun 22 13:13:11 volumio systemd-logind[441]: Watching system buttons on /dev/input/event0 (gpio_ir_recv) Jun 22 13:13:11 volumio systemd[1]: Started Handle events from IR remotes decoded by lircd(8). Jun 22 13:13:11 volumio sudo[2588]: pam_unix(sudo:session): session closed for user root Jun 22 13:13:11 volumio lircd[2583]: lircd-0.10.1[2583]: Notice: accepted new client on /var/run/lirc/lircd Jun 22 13:13:11 volumio lircd-0.10.1[2583]: Notice: accepted new client on /var/run/lirc/lircd Jun 22 13:13:11 volumio lircd[2583]: lircd-0.10.1[2583]: Info: [lirc] protocol is enabled Jun 22 13:13:11 volumio lircd-0.10.1[2583]: Info: [lirc] protocol is enabled Jun 22 13:13:11 volumio volumio[871]: info: ir_controller: systemctl restart irexec.service succeeded. Jun 22 13:13:12 volumio sudo[2592]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart lircd.service Jun 22 13:13:12 volumio sudo[2592]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:13:12 volumio lircd[2583]: lircd-0.10.1[2583]: Notice: caught signal Jun 22 13:13:12 volumio lircd-0.10.1[2583]: Notice: caught signal Jun 22 13:13:12 volumio systemd[1]: Stopping Flexible IR remote input/output application support... Jun 22 13:13:12 volumio systemd[1]: lircd.service: Main process exited, code=killed, status=15/TERM Jun 22 13:13:12 volumio systemd[1]: lircd.service: Succeeded. Jun 22 13:13:12 volumio systemd[1]: Stopped Flexible IR remote input/output application support. Jun 22 13:13:12 volumio systemd[1]: irexec.service: Succeeded. Jun 22 13:13:12 volumio systemd[1]: Starting lircd(8) initialization helper tool... Jun 22 13:13:12 volumio lircd-setup[2594]: /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. Jun 22 13:13:12 volumio lircd-setup[2594]: parser = configparser.SafeConfigParser() Jun 22 13:13:12 volumio systemd[1]: lircd-setup.service: Succeeded. Jun 22 13:13:12 volumio systemd[1]: Started lircd(8) initialization helper tool. Jun 22 13:13:12 volumio systemd[1]: Starting Flexible IR remote input/output application support... Jun 22 13:13:12 volumio lircd-0.10.1[2595]: Info: lircd: Opening log, level: Info Jun 22 13:13:12 volumio lircd-0.10.1[2595]: Notice: Version: lircd 0.10.1 Jun 22 13:13:12 volumio lircd-0.10.1[2595]: Notice: System info: Linux volumio 5.10.92-v7l+ #1514 SMP Mon Jan 17 17:38:03 GMT 2022 armv7l GNU/Linux Jun 22 13:13:12 volumio lircd-0.10.1[2595]: Info: Initial device: /dev/lirc0 Jun 22 13:13:12 volumio lircd-0.10.1[2595]: Info: [lirc] protocol is enabled Jun 22 13:13:12 volumio lircd-0.10.1[2595]: Info: Initial device: /dev/lirc0 Jun 22 13:13:12 volumio lircd-0.10.1[2595]: Info: [lirc] protocol is enabled Jun 22 13:13:12 volumio lircd-0.10.1[2595]: Notice: Options: driver: default Jun 22 13:13:12 volumio lircd-0.10.1[2595]: Notice: Options: output: /var/run/lirc/lircd Jun 22 13:13:12 volumio lircd[2595]: lircd-0.10.1[2595]: Info: lircd: Opening log, level: Info Jun 22 13:13:12 volumio lircd[2595]: lircd-0.10.1[2595]: Notice: Using systemd fd Jun 22 13:13:12 volumio lircd[2595]: lircd-0.10.1[2595]: Warning: Running as root Jun 22 13:13:12 volumio lircd-0.10.1[2595]: Notice: Options: nodaemon: 1 Jun 22 13:13:12 volumio lircd[2595]: lircd-0.10.1[2595]: Info: Using remote: lircd.conf. Jun 22 13:13:12 volumio lircd[2595]: lircd-0.10.1[2595]: Notice: lircd(default) ready, using /var/run/lirc/lircd Jun 22 13:13:12 volumio lircd-0.10.1[2595]: Notice: Options: plugindir: /usr/lib/arm-linux-gnueabihf/lirc/plugins Jun 22 13:13:12 volumio systemd[1]: Started Flexible IR remote input/output application support. Jun 22 13:13:12 volumio lircd-0.10.1[2595]: Notice: Options: logfile: syslog Jun 22 13:13:12 volumio lircd-0.10.1[2595]: Notice: Options: immediate-init: 0 Jun 22 13:13:12 volumio lircd-0.10.1[2595]: Notice: Options: permission: 666 Jun 22 13:13:12 volumio lircd-0.10.1[2595]: Notice: Options: driver-options: Jun 22 13:13:12 volumio lircd-0.10.1[2595]: Notice: Options: pidfile: /var/run/lirc/lircd.pid Jun 22 13:13:12 volumio lircd-0.10.1[2595]: Notice: Options: listen: 0 Jun 22 13:13:12 volumio lircd-0.10.1[2595]: Notice: Options: connect: (null) Jun 22 13:13:12 volumio lircd-0.10.1[2595]: Notice: Options: userelease: 0 Jun 22 13:13:12 volumio lircd-0.10.1[2595]: Notice: Options: effective_user: (null) Jun 22 13:13:12 volumio lircd-0.10.1[2595]: Notice: Options: release_suffix: _EVUP Jun 22 13:13:12 volumio lircd-0.10.1[2595]: Notice: Options: allow_simulate: 0 Jun 22 13:13:12 volumio lircd-0.10.1[2595]: Notice: Options: repeat_max: 600 Jun 22 13:13:12 volumio lircd-0.10.1[2595]: Notice: Options: configfile: /etc/lirc/lircd.conf Jun 22 13:13:12 volumio lircd-0.10.1[2595]: Notice: Options: dynamic_codes: (null) Jun 22 13:13:12 volumio lircd-0.10.1[2595]: Notice: Current driver: default Jun 22 13:13:12 volumio lircd-0.10.1[2595]: Notice: Driver API version: 3 Jun 22 13:13:12 volumio lircd-0.10.1[2595]: Notice: Driver version: 0.10.0 Jun 22 13:13:12 volumio lircd-0.10.1[2595]: Notice: Driver info: See file:///usr/share/doc/lirc/plugindocs/default.html Jun 22 13:13:12 volumio lircd-0.10.1[2595]: Info: lircd: Opening log, level: Info Jun 22 13:13:12 volumio lircd-0.10.1[2595]: Notice: Using systemd fd Jun 22 13:13:12 volumio lircd-0.10.1[2595]: Warning: Running as root Jun 22 13:13:12 volumio lircd-0.10.1[2595]: Info: Using remote: lircd.conf. Jun 22 13:13:12 volumio lircd-0.10.1[2595]: Notice: lircd(default) ready, using /var/run/lirc/lircd Jun 22 13:13:12 volumio sudo[2592]: pam_unix(sudo:session): session closed for user root Jun 22 13:13:12 volumio volumio[871]: info: ir_controller: systemctl restart lircd.service succeeded. Jun 22 13:13:12 volumio sudo[2599]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart irexec.service Jun 22 13:13:12 volumio sudo[2599]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 13:13:12 volumio systemd[1]: Started Handle events from IR remotes decoded by lircd(8). Jun 22 13:13:12 volumio sudo[2599]: pam_unix(sudo:session): session closed for user root Jun 22 13:13:12 volumio lircd[2595]: lircd-0.10.1[2595]: Notice: accepted new client on /var/run/lirc/lircd Jun 22 13:13:12 volumio lircd-0.10.1[2595]: Notice: accepted new client on /var/run/lirc/lircd Jun 22 13:13:12 volumio lircd[2595]: lircd-0.10.1[2595]: Info: [lirc] protocol is enabled Jun 22 13:13:12 volumio lircd-0.10.1[2595]: Info: [lirc] protocol is enabled Jun 22 13:13:12 volumio volumio[871]: info: ir_controller: systemctl restart irexec.service succeeded. Jun 22 13:13:14 volumio volumio[871]: info: Enabling plugin now_playing Jun 22 13:13:14 volumio volumio[871]: info: Loading plugin "now_playing"... Jun 22 13:13:14 volumio volumio[871]: error: !!!! WARNING !!!! Jun 22 13:13:14 volumio volumio[871]: error: The plugin user_interface/now_playing failed to load, setting it to stopped. Error: Error: Cannot find module '/data/plugins/user_interface/now_playing/node_modules/geo-tz/dist/geo-tz.js'. Please verify that the package.json has a valid "main" entry Jun 22 13:13:14 volumio volumio[871]: error: Stack trace: Error: Cannot find module '/data/plugins/user_interface/now_playing/node_modules/geo-tz/dist/geo-tz.js'. Please verify that the package.json has a valid "main" entry Jun 22 13:13:14 volumio volumio[871]: at tryPackage (internal/modules/cjs/loader.js:303:19) Jun 22 13:13:14 volumio volumio[871]: at Function.Module._findPath (internal/modules/cjs/loader.js:516:18) Jun 22 13:13:14 volumio volumio[871]: at Function.Module._resolveFilename (internal/modules/cjs/loader.js:867:27) Jun 22 13:13:14 volumio volumio[871]: at Function.Module._load (internal/modules/cjs/loader.js:725:27) Jun 22 13:13:14 volumio volumio[871]: at Module.require (internal/modules/cjs/loader.js:952:19) Jun 22 13:13:14 volumio volumio[871]: at require (internal/modules/cjs/helpers.js:88:18) Jun 22 13:13:14 volumio volumio[871]: at Object. (/data/plugins/user_interface/now_playing/dist/index.js:46:34) Jun 22 13:13:14 volumio volumio[871]: at Module._compile (internal/modules/cjs/loader.js:1063:30) Jun 22 13:13:14 volumio volumio[871]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1092:10) Jun 22 13:13:14 volumio volumio[871]: at Module.load (internal/modules/cjs/loader.js:928:32) Jun 22 13:13:14 volumio volumio[871]: at Function.Module._load (internal/modules/cjs/loader.js:769:14) Jun 22 13:13:14 volumio volumio[871]: at Module.require (internal/modules/cjs/loader.js:952:19) Jun 22 13:13:14 volumio volumio[871]: at require (internal/modules/cjs/helpers.js:88:18) Jun 22 13:13:14 volumio volumio[871]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:235:29) Jun 22 13:13:14 volumio volumio[871]: at Promise._successFn (/volumio/app/pluginmanager.js:1841:19) Jun 22 13:13:14 volumio volumio[871]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jun 22 13:13:14 volumio volumio[871]: error: !!!! WARNING !!!! Jun 22 13:13:14 volumio volumio[871]: info: Done. Jun 22 13:13:28 volumio volumio[871]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 22 13:13:28 volumio volumio[871]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 13:13:40 volumio volumio[871]: info: CALLMETHOD: miscellanea peppy_screensaver savePeppyMeterConf [object Object] Jun 22 13:13:40 volumio volumio[871]: info: CoreCommandRouter::executeOnPlugin: peppy_screensaver , savePeppyMeterConf Jun 22 13:13:40 volumio volumio[871]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 13:13:40 volumio volumio[871]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 22 13:13:40 volumio volumio[871]: error: Failed callmethod call: TypeError: Cannot read property 'broadcastMessage' of null Jun 22 13:13:40 volumio volumio[871]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 13:13:41 volumio volumio[871]: verbose: New Socket.io Connection to 192.168.110.146 from 192.168.110.90 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 15_7_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/15.6.6 Mobile/15E148 Safari/604.1 Total Clients: 7 Jun 22 13:13:45 volumio volumio[871]: info: CALLMETHOD: miscellanea peppy_screensaver savePeppyMeterConf [object Object] Jun 22 13:13:45 volumio volumio[871]: info: CoreCommandRouter::executeOnPlugin: peppy_screensaver , savePeppyMeterConf Jun 22 13:13:45 volumio volumio[871]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 13:13:46 volumio volumio[871]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 22 13:13:46 volumio volumio[871]: TypeError: Cannot read property 'printToastMessage' of null Jun 22 13:13:46 volumio volumio[871]: at /volumio/app/index.js:1175:32 Jun 22 13:13:46 volumio volumio[871]: at fastMap (/volumio/node_modules/fast.js/array/map.js:21:17) Jun 22 13:13:46 volumio volumio[871]: at Function.fastMap [as map] (/volumio/node_modules/fast.js/map.js:18:12) Jun 22 13:13:46 volumio volumio[871]: at CoreCommandRouter.pushToastMessage (/volumio/app/index.js:1173:13) Jun 22 13:13:46 volumio volumio[871]: at Timeout._onTimeout (/data/plugins/miscellanea/peppy_screensaver/index.js:460:28) Jun 22 13:13:46 volumio volumio[871]: at listOnTimeout (internal/timers.js:554:17) Jun 22 13:13:46 volumio volumio[871]: at processTimers (internal/timers.js:497:7) Jun 22 13:13:46 volumio volumio[871]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 22 13:13:46 volumio sudo[2618]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-22 13:12 Jun 22 13:13:46 volumio sudo[2618]: 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="1c5fa5a8788b087ca429be9d10851b25c5cc4f5b" VOLUMIO_FE_VERSION="e5ce74e254a237ac98580c4437c4ed223c7d5cd9" VOLUMIO_FE3_VERSION="a86adf3c7ed2d6c50d9bca768f58ab2f56832dc1" VOLUMIO_BE_VERSION="c8882d89d3d4e0a1571e0dc9701741128f5a1656" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 31 Mar 2022 02:51:41 PM CEST" VOLUMIO_VERSION="3.251" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e83cc5fcd68eb3ee4105ab0b8b3779ea"