i have two raspberry pi 3b+ with Volumio running in my house. Both systems are with newest Version. One system is operated via a 7" touchscreen, a second system I control via webbrowser in my home automation with iobroker installation.
i only have a strange behaviour with this (second) system and hope somebody can give me a tip.
In not regular intervals, but always on the hour the stream stops or starts (webradio). That means for example at exactly 9:00 am the WebRadio stream starts by itself and then stops at exactly 11:00 am again by itself. This happens three to four times a day, that the stream starts or stops by itself. But always on the hour at exact XX:00 o’clock.
Is there any log in Volumio that logs the start/pause trigger?
I would not wait until it has happened but start journalctl right now (well, if it happens only on the hour it would probably suffice to start some time before). So you will be able to look what has happened in the moment the stream started and what has happened just before.
Hi,
just started the command, but i do believe i need a little bit more advise, because i don´t see any log entrys from yesterday or the day before
^Cvolumio@wohnzimmer:~$ sudo journalctl -f
– Logs begin at Wed 2020-06-03 08:37:51 UTC. –
Jun 05 15:04:43 wohnzimmer sshd[859]: lastlog_openseek: Couldn’t stat /var/log/lastlog: No such file or directory
Jun 05 15:04:43 wohnzimmer sshd[859]: lastlog_openseek: Couldn’t stat /var/log/lastlog: No such file or directory
Jun 05 15:05:09 wohnzimmer sudo[1048]: volumio : TTY=pts/0 ; PWD=/home/volumio ; USER=root ; COMMAND=/bin/journalctl -f
Jun 05 15:05:09 wohnzimmer sudo[1048]: pam_unix(sudo:session): session opened for user root by volumio(uid=0)
Jun 05 15:06:05 wohnzimmer nmbd[984]: [2020/06/05 15:06:05.010961, 0] …/source3/nmbd/nmbd_namequery.c:109(query_name_response)
Jun 05 15:06:05 wohnzimmer nmbd[984]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.178.52 for name WORKGROUP<1d>.
Jun 05 15:06:05 wohnzimmer nmbd[984]: This response was from IP 192.168.178.69, reporting an IP address of 192.168.178.69.
Jun 05 15:07:44 wohnzimmer sudo[1048]: pam_unix(sudo:session): session closed for user root
Jun 05 15:08:56 wohnzimmer sudo[1659]: volumio : TTY=pts/0 ; PWD=/home/volumio ; USER=root ; COMMAND=/bin/journalctl -f
Jun 05 15:08:56 wohnzimmer sudo[1659]: pam_unix(sudo:session): session opened for user root by volumio(uid=0)
Ok, that works, but what i have seen so far, i never have entries at exact XX:00 hour. And i have seen that i have a wrong time stamp on my volumio (2hours behind).
below there is an excerpt from the logfile where I’m pretty sure that the event was at that time.
Beside that, there are lots of entries which I cannot interpret.
Jun 04 14:41:34 wohnzimmer smbd[21188]: [2020/06/04 14:41:34.681653, 0] …/lib/util/debug.c:603(reopen_logs_internal)
Jun 04 14:41:34 wohnzimmer smbd[21188]: Unable to open new log file ‘/var/log/samba/log.smbd’: No such file or directory
Jun 04 14:41:34 wohnzimmer smbd[21188]: [2020/06/04 14:41:34.704717, 0] …/lib/util/debug.c:603(reopen_logs_internal)
Jun 04 14:41:34 wohnzimmer smbd[21188]: Unable to open new log file ‘/var/log/samba/log.smbd’: No such file or directory
Jun 04 14:43:54 wohnzimmer nmbd[984]: [2020/06/04 14:43:54.006244, 0] …/source3/nmbd/nmbd_namequery.c:109(query_name_response)
Jun 04 14:43:54 wohnzimmer nmbd[984]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.178.52 for name WORKGROUP<1d>.
Jun 04 14:43:54 wohnzimmer nmbd[984]: This response was from IP 192.168.178.69, reporting an IP address of 192.168.178.69.
Jun 04 14:48:54 wohnzimmer nmbd[984]: [2020/06/04 14:48:54.015650, 0] …/source3/nmbd/nmbd_namequery.c:109(query_name_response)
Jun 04 14:48:54 wohnzimmer nmbd[984]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.178.52 for name WORKGROUP<1d>.
Jun 04 14:48:54 wohnzimmer nmbd[984]: This response was from IP 192.168.178.69, reporting an IP address of 192.168.178.69.
Jun 04 14:53:54 wohnzimmer nmbd[984]: [2020/06/04 14:53:54.011482, 0] …/source3/nmbd/nmbd_namequery.c:109(query_name_response)
Jun 04 14:53:54 wohnzimmer nmbd[984]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.178.52 for name WORKGROUP<1d>.
Jun 04 14:53:54 wohnzimmer nmbd[984]: This response was from IP 192.168.178.69, reporting an IP address of 192.168.178.69.
Jun 04 14:56:56 wohnzimmer volumio[1035]: error: error
Jun 04 14:56:56 wohnzimmer volumio[1035]: error: error
Jun 04 14:56:56 wohnzimmer volumio[1035]: error: error
Jun 04 14:58:54 wohnzimmer nmbd[984]: [2020/06/04 14:58:54.052912, 0] …/source3/nmbd/nmbd_namequery.c:109(query_name_response)
Jun 04 14:58:54 wohnzimmer nmbd[984]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.178.52 for name WORKGROUP<1d>.
Jun 04 14:58:54 wohnzimmer nmbd[984]: This response was from IP 192.168.178.69, reporting an IP address of 192.168.178.69.
Jun 04 15:03:54 wohnzimmer nmbd[984]: [2020/06/04 15:03:54.003605, 0] …/source3/nmbd/nmbd_namequery.c:109(query_name_response)
Jun 04 15:03:54 wohnzimmer nmbd[984]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.178.52 for name WORKGROUP<1d>.
Jun 04 15:03:54 wohnzimmer nmbd[984]: This response was from IP 192.168.178.69, reporting an IP address of 192.168.178.69.
Jun 04 15:08:56 wohnzimmer nmbd[984]: [2020/06/04 15:08:56.010138, 0] …/source3/nmbd/nmbd_namequery.c:109(query_name_response)
Jun 04 15:08:56 wohnzimmer nmbd[984]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.178.52 for name WORKGROUP<1d>.
Jun 04 15:08:56 wohnzimmer nmbd[984]: This response was from IP 192.168.178.69, reporting an IP address of 192.168.178.69.
Jun 04 15:13:56 wohnzimmer nmbd[984]: [2020/06/04 15:13:56.047935, 0] …/source3/nmbd/nmbd_namequery.c:109(query_name_response)
Jun 04 15:13:56 wohnzimmer nmbd[984]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.178.52 for name WORKGROUP<1d>.
Jun 04 15:13:56 wohnzimmer nmbd[984]: This response was from IP 192.168.178.69, reporting an IP address of 192.168.178.69.
Assuming the log you posted covers the period of one of the incidents, I don’t see anything which would give me an idea what would cause starting or stopping webradio.
Do you remeber if there was a start or stop action yesterday at 15:00 and what webradio station was involved?
Edit: Maybe watch the log messages while you start / stop webradio by intent just to know what messages you have to search for.
I am pretty sure it was at this time yesterday and it starts the stream. It is a german webradio station (Bayern3). We never have any other station.
Thank you for your help so far. I think i will wait until it happens next time and immediately will start the log when it happens. Do you now any other log command which i could start as well in this case?
Thanks
now I have to come back to you with my problem. It’s funny, now I hadn’t noticed the phenomenon for a few weeks, but yesterday it was intensified again.
i have no idea what is going on but i will summarize it.
I have Volumio running on a raspberry. The system runs all day long. If we want to listen to the stream I start it in the WebUI (touch panel of my home automation, WebUI as link). If the radio should be off we just stop the stream. It always runs only one and the same radio station.
Sometimes 5-10 times a day volumio starts or stops the stream (depending on whether it is running or not), always exactly on the hour. It is definitely not an internet stream problem.
Just like last night at 21:00, 22:00 and 23:00.
I pulled a logfile that recorded the start at 21:00 (and then also the stop of the stream by me at 21:00:58 h). There was no start or stop at 20:00.
Can someone please help me, I can’t find out what stops or starts the Volumio.
I mean to have read out something with MPD. I installed it months ago in my iobroker system and tried to control the Volumio with it. It did not work and I deleted the iobroker adapter.
Should there still be any corpse in there.
