Hi, sorry for still having problems :(

first of all, I have an idea, what the problem may be.

May there be a problem, when liquidsoap is being restarted by a cronjob, which starts a script, which stop-starts liquidsoap?
I am asking because I have the feeling, that there were many repititions. This may be, because the playlist hadn't been reloaded because LIQ may have not been restarted. Is that possible?
You can find these scripts at the end of this mail.





If it is not, the following is a desperate cry for help.

Today something strange happened: The music was running in the day-program.
But in the evening (from 19:00h) it stopped again.

This is what is shown in the log:

-----------------------------------------
2010/04/16 05:59:50 [src_8241:4] End of track.
2010/04/16 05:59:50 [src_8241:4] Buffer emptied, starting buffering.
2010/04/16 05:59:51 [src_4449:4] Buffering end of track...
2010/04/16 05:59:51 [src_4449:4] More buffering will be needed.
2010/04/16 06:00:00 [src_4426:3] Finished with "/home/musik/jingles/Jingle 4.mp3"
2010/04/16 06:00:00 [format.mp3:4] close "/home/musik/jingles/Jingle 4.mp3"
2010/04/16 06:00:00 [dayrandom(dot)txt:4] Remaining: 0, queued: 1323000, taking: 1323000
2010/04/16 06:00:00 [format.mp3:4] open "/home/musik/tags/Duran Duran - All She Wants Is.mp3"
2010/04/16 06:00:00 [dayrandom(dot)txt:3] Prepared "/home/musik/tags/Duran Duran - All She Wants Is.mp3" -- RID 12
2010/04/16 06:00:00 [src_4439:3] Switch to src_4438 with forgetful transition.
2010/04/16 06:00:00 [src_4426:4] Activations changed: static=[], dynamic=[src_4439:src_4443:src_4445:src_4447:src_4448:src_4449:src_4451:src_4453:mksafe:output(dot)icecast(dot)lame:output(dot)icecast(dot)lame].
2010/04/16 06:00:00 [src_4438:4] Activations changed: static=[src_4439:src_4443:src_4445:src_4447:src_4448:src_4449:src_4451:src_4453:mksafe:output(dot)icecast(dot)lame:output(dot)icecast(dot)lame], dynamic=[src_4439:src_4443:src_4445:src_4447:src_4448:src_4449:src_4451:src_4453:mksafe:output(dot)icecast(dot)lame:output(dot)icecast(dot)lame].
2010/04/16 06:00:00 [source:4] src_8242 gets down
2010/04/16 06:00:00 [src_4448:4] Activations changed: static=[], dynamic=[src_4449:src_4451:src_4453:mksafe:output(dot)icecast(dot)lame:output(dot)icecast(dot)lame].
2010/04/16 06:00:00 [source:4] src_8241 gets down
2010/04/16 06:00:00 [src_8241:4] Activations changed: static=[], dynamic=[].
2010/04/16 06:00:00 [src_8242:4] Activations changed: static=[], dynamic=[].
2010/04/16 06:00:00 [source:4] src_8248 gets up
2010/04/16 06:00:00 [src_4448:4] Activations changed: static=[src_8248:src_4449:src_4451:src_4453:mksafe:output(dot)icecast(dot)lame:output(dot)icecast(dot)lame], dynamic=[src_4449:src_4451:src_4453:mksafe:output(dot)icecast(dot)lame:output(dot)icecast(dot)lame].
2010/04/16 06:00:00 [source:4] src_8247 gets up
2010/04/16 06:00:00 [src_8247:4] Activations changed: static=[src_8248:src_4449:src_4451:src_4453:mksafe:output(dot)icecast(dot)lame:output(dot)icecast(dot)lame], dynamic=[].
2010/04/16 06:00:00 [src_8248:4] Activations changed: static=[src_4449:src_4451:src_4453:mksafe:output(dot)icecast(dot)lame:output(dot)icecast(dot)lame], dynamic=[].
2010/04/16 06:00:00 [src_4438:3] Switch to dayrandom(dot)txt.
2010/04/16 06:00:00 [dayrandom(dot)txt:4] Activations changed: static=[src_4438:src_4439:src_4443:src_4445:src_4447:src_4448:src_4449:src_4451:src_4453:mksafe:output(dot)icecast(dot)lame:output(dot)icecast(dot)lame], dynamic=[src_4438:src_4439:src_4443:src_4445:src_4447:src_4448:src_4449:src_4451:src_4453:mksafe:output(dot)icecast(dot)lame:output(dot)icecast(dot)lame].
2010/04/16 06:00:00 [src_4453:4] Got metadata at position 0: calling handler...
2010/04/16 06:00:00 [decoder:4] Trying OGG decoder for "/home/musik/tags/Sara Noxx Ft. Project Pitchfork - Earth Song (Original Version).mp3"
2010/04/16 06:00:00 [decoder:4] Trying WAV decoder for "/home/musik/tags/Sara Noxx Ft. Project Pitchfork - Earth Song (Original Version).mp3"
2010/04/16 06:00:00 [decoder:4] Trying MP3 decoder for "/home/musik/tags/Sara Noxx Ft. Project Pitchfork - Earth Song (Original Version).mp3"
2010/04/16 06:00:00 [format.mp3:4] open "/home/musik/tags/Sara Noxx Ft. Project Pitchfork - Earth Song (Original Version).mp3"
2010/04/16 06:00:00 [format.mp3:4] close "/home/musik/tags/Sara Noxx Ft. Project Pitchfork - Earth Song (Original Version).mp3"
2010/04/16 06:00:00 [decoder:3] Decoder MP3 chosed for "/home/musik/tags/Sara Noxx Ft. Project Pitchfork - Earth Song (Original Version).mp3"

----------------------------------------

And later, at 19:00 is this (sorry for that much text) .
very interesting I guess - 2010/04/16 19:05:03 [everandom(dot)txt:1] Failed to prepare track: unresolved request


------------------------------------------
2010/04/16 18:59:45 [stdout:3] <title>Covenant - We Stand Alone</title>
2010/04/16 18:59:45 [stdout:3] <title>Depeche Mode - Boys Say Go!</title>
2010/04/16 18:59:49 [src_9261:4] End of track.
2010/04/16 18:59:49 [src_9261:4] Buffer emptied, starting buffering.
2010/04/16 18:59:50 [src_4449:4] Buffering end of track...
2010/04/16 18:59:50 [src_4449:4] More buffering will be needed.
2010/04/16 19:05:03 [dayrandom(dot)txt:3] Finished with "/home/musik/tags/Covenant - We Stand Alone.mp3"
2010/04/16 19:05:03 [format.mp3:4] close "/home/musik/tags/Covenant - We Stand Alone.mp3"
2010/04/16 19:05:03 [everandom(dot)txt:4] Remaining: 0, queued: 1323000, taking: 1323000
2010/04/16 19:05:03 [everandom(dot)txt:1] Failed to prepare track: unresolved request
2010/04/16 19:05:03 [dayrandom(dot)txt:4] Activations changed: static=[], dynamic=[src_4438:src_4439:src_4443:src_4445:src_4447:src_4448:src_4449:src_4451:src_4453:mksafe:output(dot)icecast(dot)lame:output(dot)icecast(dot)lame].
2010/04/16 19:05:03 [format.mp3:4] open "/home/musik/jingles/Jingle 4.mp3"
2010/04/16 19:05:03 [src_4426:3] Prepared "/home/musik/jingles/Jingle 4.mp3" -- RID 0
2010/04/16 19:05:03 [src_4439:3] Switch to src_4426 with forgetful transition.
2010/04/16 19:05:03 [src_4438:4] Activations changed: static=[], dynamic=[src_4439:src_4443:src_4445:src_4447:src_4448:src_4449:src_4451:src_4453:mksafe:output(dot)icecast(dot)lame:output(dot)icecast(dot)lame].
2010/04/16 19:05:03 [src_4426:4] Activations changed: static=[src_4439:src_4443:src_4445:src_4447:src_4448:src_4449:src_4451:src_4453:mksafe:output(dot)icecast(dot)lame:output(dot)icecast(dot)lame], dynamic=[src_4439:src_4443:src_4445:src_4447:src_4448:src_4449:src_4451:src_4453:mksafe:output(dot)icecast(dot)lame:output(dot)icecast(dot)lame].
2010/04/16 19:05:03 [playlist(dot)pls:4] Remaining: 0, queued: 1323000, taking: 1323000
2010/04/16 19:05:03 [format.mp3:4] open "/home/musik/jingles/Zentriert ins Antlitz - Come in.mp3"
2010/04/16 19:05:03 [playlist(dot)pls:3] Prepared "/home/musik/jingles/Zentriert ins Antlitz - Come in.mp3" -- RID 27
2010/04/16 19:05:03 [src_4443:3] Switch to src_4441 with forgetful transition.
2010/04/16 19:05:03 [src_4439:4] Activations changed: static=[], dynamic=[src_4443:src_4445:src_4447:src_4448:src_4449:src_4451:src_4453:mksafe:output(dot)icecast(dot)lame:output(dot)icecast(dot)lame].
2010/04/16 19:05:03 [src_4441:4] Activations changed: static=[src_4443:src_4445:src_4447:src_4448:src_4449:src_4451:src_4453:mksafe:output(dot)icecast(dot)lame:output(dot)icecast(dot)lame], dynamic=[src_4443:src_4445:src_4447:src_4448:src_4449:src_4451:src_4453:mksafe:output(dot)icecast(dot)lame:output(dot)icecast(dot)lame].
2010/04/16 19:05:03 [source:4] src_9262 gets down
2010/04/16 19:05:03 [src_4448:4] Activations changed: static=[], dynamic=[src_4449:src_4451:src_4453:mksafe:output(dot)icecast(dot)lame:output(dot)icecast(dot)lame].
2010/04/16 19:05:03 [source:4] src_9261 gets down
2010/04/16 19:05:03 [src_9261:4] Activations changed: static=[], dynamic=[].
2010/04/16 19:05:03 [src_9262:4] Activations changed: static=[], dynamic=[].
2010/04/16 19:05:03 [source:4] src_9268 gets up
2010/04/16 19:05:03 [src_4448:4] Activations changed: static=[src_9268:src_4449:src_4451:src_4453:mksafe:output(dot)icecast(dot)lame:output(dot)icecast(dot)lame], dynamic=[src_4449:src_4451:src_4453:mksafe:output(dot)icecast(dot)lame:output(dot)icecast(dot)lame].
2010/04/16 19:05:03 [source:4] src_9267 gets up
2010/04/16 19:05:03 [src_9267:4] Activations changed: static=[src_9268:src_4449:src_4451:src_4453:mksafe:output(dot)icecast(dot)lame:output(dot)icecast(dot)lame], dynamic=[].
2010/04/16 19:05:03 [src_9268:4] Activations changed: static=[src_4449:src_4451:src_4453:mksafe:output(dot)icecast(dot)lame:output(dot)icecast(dot)lame], dynamic=[].
2010/04/16 19:05:03 [src_4453:4] Got metadata at position 0: calling handler...
2010/04/16 19:05:03 [decoder:4] Trying OGG decoder for "/home/musik/jingles/Jingle 6.mp3"
2010/04/16 19:05:03 [decoder:4] Trying WAV decoder for "/home/musik/jingles/Jingle 6.mp3"
2010/04/16 19:05:03 [decoder:4] Trying MP3 decoder for "/home/musik/jingles/Jingle 6.mp3"
2010/04/16 19:05:03 [format.mp3:4] open "/home/musik/jingles/Jingle 6.mp3"
2010/04/16 19:05:03 [format.mp3:4] close "/home/musik/jingles/Jingle 6.mp3"
2010/04/16 19:05:03 [decoder:3] Decoder MP3 chosed for "/home/musik/jingles/Jingle 6.mp3"
2010/04/16 19:05:03 [playlist(dot)pls:4] Remaining: 2759602, queued: 0, adding: 1323000 (RID 40)
2010/04/16 19:05:07 [stderr:3]   % Total    % Received % Xferd  Average Speed   Time    Time     Time  Current
2010/04/16 19:05:07 [stderr:3]                                  Dload  Upload   Total   Spent    Left  Speed
2010/04/16 19:05:07 [stderr:3]    0     0    0     0    0     0      0      0 --:--:-- --:--:-- --:--:--     0 106  1487  106  1487    0     0  13546      0 --:--:-- --:--:-- --:--:-- 13518 106  1487  106  1487    0     0  13526      0 --:--:-- --:--:-- --:--:-- 13518
2010/04/16 19:05:07 [stderr:3]   % Total    % Received % Xferd  Average Speed   Time    Time     Time  Current
2010/04/16 19:05:07 [stderr:3]                                  Dload  Upload   Total   Spent    Left  Speed
2010/04/16 19:05:07 [stderr:3]    0     0    0     0    0     0      0      0 --:--:-- --:--:-- --:--:--     0 106  1487  106  1487    0     0   7707      0 --:--:-- --:--:-- --:--:--  7744
2010/04/16 19:05:07 [stdout:3] <title>Zentriert ins Antlitz - Come in</title>
2010/04/16 19:05:07 [stdout:3] <title>Covenant - We Stand Alone</title>
2010/04/16 19:05:11 [src_9267:4] End of track.
2010/04/16 19:05:11 [src_9267:4] Buffer emptied, starting buffering.
2010/04/16 19:05:12 [src_4449:4] Buffering end of track...
2010/04/16 19:05:12 [src_4449:4] More buffering will be needed.
2010/04/16 19:05:58 [playlist(dot)pls:3] Finished with "/home/musik/jingles/Zentriert ins Antlitz - Come in.mp3"
2010/04/16 19:05:58 [format.mp3:4] close "/home/musik/jingles/Zentriert ins Antlitz - Come in.mp3"
2010/04/16 19:05:58 [src_4443:3] Switch to src_4439 with forgetful transition.
2010/04/16 19:05:58 [src_4441:4] Activations changed: static=[], dynamic=[src_4443:src_4445:src_4447:src_4448:src_4449:src_4451:src_4453:mksafe:output(dot)icecast(dot)lame:output(dot)icecast(dot)lame].
2010/04/16 19:05:58 [src_4439:4] Activations changed: static=[src_4443:src_4445:src_4447:src_4448:src_4449:src_4451:src_4453:mksafe:output(dot)icecast(dot)lame:output(dot)icecast(dot)lame], dynamic=[src_4443:src_4445:src_4447:src_4448:src_4449:src_4451:src_4453:mksafe:output(dot)icecast(dot)lame:output(dot)icecast(dot)lame].
2010/04/16 19:05:58 [source:4] src_9268 gets down
2010/04/16 19:05:58 [src_4448:4] Activations changed: static=[], dynamic=[src_4449:src_4451:src_4453:mksafe:output(dot)icecast(dot)lame:output(dot)icecast(dot)lame].
2010/04/16 19:05:58 [source:4] src_9267 gets down
2010/04/16 19:05:58 [src_9267:4] Activations changed: static=[], dynamic=[].
2010/04/16 19:05:58 [src_9268:4] Activations changed: static=[], dynamic=[].
2010/04/16 19:05:58 [source:4] src_9274 gets up
2010/04/16 19:05:58 [src_4448:4] Activations changed: static=[src_9274:src_4449:src_4451:src_4453:mksafe:output(dot)icecast(dot)lame:output(dot)icecast(dot)lame], dynamic=[src_4449:src_4451:src_4453:mksafe:output(dot)icecast(dot)lame:output(dot)icecast(dot)lame].
2010/04/16 19:05:58 [source:4] src_9273 gets up
2010/04/16 19:05:58 [src_9273:4] Activations changed: static=[src_9274:src_4449:src_4451:src_4453:mksafe:output(dot)icecast(dot)lame:output(dot)icecast(dot)lame], dynamic=[].
2010/04/16 19:05:58 [src_9274:4] Activations changed: static=[src_4449:src_4451:src_4453:mksafe:output(dot)icecast(dot)lame:output(dot)icecast(dot)lame], dynamic=[].
2010/04/16 19:05:59 [src_4453:4] Got metadata at position 0: calling handler...
2010/04/16 19:06:03 [stderr:3]   % Total    % Received % Xferd  Average Speed   Time    Time     Time  Current
2010/04/16 19:06:03 [stderr:3]                                  Dload  Upload   Total   Spent    Left  Speed
2010/04/16 19:06:03 [stderr:3]    0     0    0     0    0     0      0      0 --:--:-- --:--:-- --:--:--     0 105  1472  105  1472    0     0   9494      0 --:--:-- --:--:-- --:--:--  9558
2010/04/16 19:06:03 [stderr:3]   % Total    % Received % Xferd  Average Speed   Time    Time     Time  Current
2010/04/16 19:06:03 [stderr:3]                                  Dload  Upload   Total   Spent    Left  Speed
2010/04/16 19:06:03 [stderr:3]    0     0    0     0    0     0      0      0 --:--:-- --:--:-- --:--:--     0 105  1472  105  1472    0     0   7615      0 --:--:-- --:--:-- --:--:--  7666
2010/04/16 19:06:03 [stdout:3] <title> - Meta-Jingle 4</title>
2010/04/16 19:06:03 [stdout:3] <title>Zentriert ins Antlitz - Come in</title>
2010/04/16 19:06:06 [src_9273:4] End of track.
2010/04/16 19:06:06 [src_9273:4] Buffer emptied, starting buffering.
2010/04/16 19:06:07 [src_4449:4] Buffering end of track...
2010/04/16 19:06:08 [src_4449:4] More buffering will be needed.
2010/04/16 19:06:16 [src_4426:3] Finished with "/home/musik/jingles/Jingle 4.mp3"
2010/04/16 19:06:16 [format.mp3:4] close "/home/musik/jingles/Jingle 4.mp3"
2010/04/16 19:06:16 [format.mp3:4] open "/home/musik/jingles/Jingle 4.mp3"

----------------------------------------------------------

And then there comes Jingle4 again, which means "nothing to play".
And again, when I force-reload liq manually, it works again.
Very strange is, that the day-playlist has worked today, and the evening-pls hasn't

These are the scripts, which copy the files and restart LIQ.
Probably the nested scripts make problems? But LIQ is being completely restarted after the scripts have finished.

24h_script:

------------------------------------ begin ----------------------------------------------------------

#!/bin/bash

/etc/init.d/liquidsoap stop

#Skript, um alle 24 Std die Titel umzukopieren und LIQ neu zu starten

/home/musik/autocopy

/etc/init.d/liquidsoap start

# just to be sure
/etc/init.d/liquidsoap force-reload

------------------------------------- end ----------------------------------------------------------

autocopy-script, which is called by the 24h script:

------------------------------------ begin ----------------------------------------------------------

#!/bin/bash

rm -R /home/musik/tags/*
rm -R /home/musik/abends/*
rm -R /home/musik/nachts/*

#Auf korrekte Kodierung prüfen
convmv -f iso-8859-15 -t utf-8 -r --notest /home/musik

# Python-Script für Tages-Playliste aufrufen
echo ""
echo "Tages-Programm"
echo ""
python /home/musik/autocopy.py -c 150 /home/musik/main/elektro /home/musik/tags
python /home/musik/autocopy.py -c 120 /home/musik/main/elektropop /home/musik/tags
python /home/musik/autocopy.py -c 50 /home/musik/main/wave /home/musik/tags
python /home/musik/autocopy.py -c 40 /home/musik/instrumental/em /home/musik/tags
python /home/musik/autocopy.py -c 50 /home/musik/instrumental/pop /home/musik/tags

# Python-Script für Abend-Playliste aufrufen
echo ""
echo "Abend-Programm"
echo ""
python /home/musik/autocopy.py -c 10 /home/musik/hardcore/bombast /home/musik/abends
python /home/musik/autocopy.py -c 40 /home/musik/hardcore/ebm /home/musik/abends
python /home/musik/autocopy.py -c 80 /home/musik/hardcore/elektro_hart /home/musik/abends
python /home/musik/autocopy.py -c 30 /home/musik/hardcore/elektro_techno /home/musik/abends
python /home/musik/autocopy.py -c 100 /home/musik/hardcore/hellektro /home/musik/abends
python /home/musik/autocopy.py -c 70 /home/musik/hardcore/industrial /home/musik/abends
python /home/musik/autocopy.py -c 70 /home/musik/hardcore/noise /home/musik/abends

# Python-Script für Nacht-Playliste aufrufen
echo ""
echo "Nacht-Programm"
echo ""
python /home/musik/autocopy.py -c 100 /home/musik/instrumental/nachtmusik /home/musik/nachts

rm .random_copy

#Playliste rausschreiben
echo ""
echo "Playlisten rausschreiben"
echo ""
find /home/musik/tags | grep .mp3 | tee /home/musik/tags/playlist.pls
find /home/musik/abends | grep .mp3 | tee /home/musik/abends/playlist.pls
find /home/musik/nachts | grep .mp3 | tee /home/musik/nachts/playlist.pls
find /home/musik/jingles | grep .mp3 | tee /home/musik/jingles/playlist.pls

#Alle Dateien für alle lesbar machen
echo ""
echo "alle Dateien lesbar machen"
echo ""
chmod -R 777 /home/musik/tags
chmod -R 777 /home/musik/abends
chmod -R 777 /home/musik/nachts
chmod -R 777 /home/musik/jingles

chown -R musik:musik /home/musik/tags/*
chown -R musik:musik /home/musik/abends/*
chown -R musik:musik /home/musik/nachts/*
chown -R musik:musik /home/musik/jingles/*

#Playliste noch weiter randomisieren
echo ""
echo "Playlisten randomisieren"
echo ""
sort -R -o /home/musik/tags/playlist2.pls /home/musik/tags/playlist.pls
sort -R -o /home/musik/tags/dayrandom.txt /home/musik/tags/playlist2.pls

sort -R -o /home/musik/abends/playlist2.pls /home/musik/abends/playlist.pls
sort -R -o /home/musik/abends/everandom.txt /home/musik/abends/playlist2.pls

sort -R -o /home/musik/nachts/playlist2.pls /home/musik/nachts/playlist.pls
sort -R -o /home/musik/nachts/nightrandom.txt /home/musik/nachts/playlist2.pls

#Temporäre Dateien löschen
echo ""
echo "alte Playlisten löschen"
echo ""
rm /home/musik/tags/playlist.pls
rm /home/musik/tags/playlist2.pls

rm /home/musik/abends/playlist.pls
rm /home/musik/abends/playlist2.pls

rm /home/musik/nachts/playlist.pls
rm /home/musik/nachts/playlist2.pls

#Alle Dateien für alle lesbar machen
echo ""
echo "Auch Playlisten lesbar machen"
echo ""
chmod -R 777 /home/musik/tags
chmod -R 777 /home/musik/abends
chmod -R 777 /home/musik/nachts

chown -R musik:musik /home/musik/tags/*
chown -R musik:musik /home/musik/abends/*
chown -R musik:musik /home/musik/nachts/*

------------------------------------- end ----------------------------------------------------------



Thanks again
Christian



David Baelde schrieb:
Hi,

Your script looks good. In fact it's really nice, with several cool
features, a pleasure to read ;) I don't see any obvious reason why the
playlist wouldn't start. You're right that it is very puzzling: if it
can play when you start liquidsoap, why can't it switch to it when the
time comes?

I can imagine a possible kind of bug, but I'd be surprised to see this
in recent versions of liquidsoap: what version are you using? I'd say
that you generally should avoid using versions prior to 0.9.1.

Also, could you attach more explicit identifiers to your playlists, so
the logs are clearer? Currently all playlists have the same filename
so same identifier (directory name isn't taken into account for the
identifier). Please add playlist(id="tags",...) and so on and send us
the log again, just to be sure.

Also, if you want to find out which request fails to be prepared,
set("log.level",4) or use --debug. You can also use the server
interface (e.g. over telnet) to inspect requests just after their
death.

This is all very obscure now, but as we get more info, we'll find out
the problem!
  

Hi all,

again, I have a strange problem.
Every night I copy a bulk of new files to be played to three different folders. One folder for the day-program, one for the evening-program and one for the night. After copying the files, the playlists are created automaticly in those folders.
Before copying I stop liquidsoap. Afterwards I start liquidsoap again.

When liquidsoap is started, it should load the playlists and start the music. And indeed, it does.
But: At 6:00am the day-program should start and it does not. Instead of the playlist, the default-file is played.
Night and evening works great, but day doens't.
When I now restart LIQ manually, it works again.

This seems very strange to me, because I haven't found any reason by myself, why it doesn't start automatically.
In the log, there is written:
------------------------------------------------------------------------------
Download Intel&#174; Parallel Studio Eval
Try the new software tools for yourself. Speed compiling, find bugs
proactively, and fine-tune applications for parallel performance.
See why Intel Parallel Studio got high marks during beta.
http://p.sf.net/sfu/intel-sw-dev
_______________________________________________
Savonet-users mailing list
[email protected]
https://lists.sourceforge.net/lists/listinfo/savonet-users

Reply via email to