#72: Liquidsoap crashes in a strange way
-------------------------------+--------------------------------------------
Reporter: MarcinLewandowski | Owner: admin
Type: Bugs | Status: new
Priority: 1 | Milestone:
Component: Liquidsoap | Version: 0.3.5+svn
Keywords: crash |
-------------------------------+--------------------------------------------
Hi, I use liquidsoap 0.3.5 that was working fine for a some time and now
it crashes in a strange way. I hadn't made any significant changes to my
system and liquidsoap configuration. Maybe a bunch of small ones but what
I report is certainly a bug.
It works for a some time, then stops streaming. Liquidsoap's processes
still exist:
{{{
ps axu output:
radioart 28345 0.0 5.9 45720 30676 ? Ss Dec15 0:00
liquidsoap -d jedynka.liq
radioart 28346 0.0 5.9 45720 30676 ? S Dec15 0:01
liquidsoap -d jedynka.liq
radioart 28347 0.0 5.9 45720 30676 ? S Dec15 0:00
liquidsoap -d jedynka.liq
radioart 28348 0.0 5.9 45720 30676 ? S Dec15 0:00
liquidsoap -d jedynka.liq
radioart 28349 0.0 5.9 45720 30676 ? S Dec15 0:00
liquidsoap -d jedynka.liq
radioart 28350 2.0 5.9 45720 30676 ? S Dec15 65:38
liquidsoap -d jedynka.liq
pstree output:
|-liquidsoap(28345)---liquidsoap(28346)-+-liquidsoap(28347)
| |-liquidsoap(28348)
| |-liquidsoap(28349)
| `-liquidsoap(28350)
}}}
but "killall liquidsoap" doesn't work. Everything seems to be OK but it
doesn't kill liquidsoap processes. I have to use ""killall -9 liquidsoap"
to kill them.
Something very interesing is that always before it hangs, I can read
something related to shout socket error:
{{{
2007/12/15 18:03:37 [EMAIL PROTECTED]/L13C20:3] Finished with
"/data/accounts/radioart/database/1499"
2007/12/15 18:03:42 [EMAIL PROTECTED]/L13C20:3] Prepared
"/data/accounts/radioart/database/1448" -- rid 22
2007/12/15 18:04:24 [EMAIL PROTECTED]/L13C20:3] Finished with
"/data/accounts/radioart/database/1448"
2007/12/15 18:04:29 [EMAIL PROTECTED]/L13C20:3] Prepared
"/data/accounts/radioart/database/2348" -- rid 23
2007/12/15 18:04:31 [root:2] We must catchup 2.22 seconds!
2007/12/15 18:04:32 [root:2] We must catchup 0.48 seconds (we've been late
for 100 rounds)!
2007/12/15 18:08:28 [EMAIL PROTECTED]/L13C20:3] Finished with
"/data/accounts/radioart/database/2348"
2007/12/15 18:08:33 [EMAIL PROTECTED]/L13C20:3] Prepared
"/data/accounts/radioart/database/2577" -- rid 24
2007/12/15 18:08:34 [root:2] We must catchup 1.71 seconds!
2007/12/15 18:13:26 [EMAIL PROTECTED]/L13C20:3] Finished with
"/data/accounts/radioart/database/2577"
2007/12/15 18:13:31 [EMAIL PROTECTED]/L13C20:3] Prepared
"/data/accounts/radioart/database/2974" -- rid 25
2007/12/15 18:13:31 [EMAIL PROTECTED]/L13C20:3] Finished with
"/data/accounts/radioart/database/2974"
2007/12/15 18:13:40 [EMAIL PROTECTED]/L13C20:3] Prepared
"/data/accounts/radioart/database/3133" -- rid 26
2007/12/15 18:13:45 [root:2] We must catchup 13.17 seconds!
2007/12/15 18:13:45 [1.mp3:2] Shout socket error: timeout, network
failure, server shutdown? Restarting the output in 3 sec
2007/12/15 18:13:46 [root:2] We must catchup 11.31 seconds (we've been
late for 100 rounds)!
2007/12/15 18:13:47 [root:2] We must catchup 9.51 seconds (we've been late
for 100 rounds)!
2007/12/15 18:13:48 [root:2] We must catchup 7.73 seconds (we've been late
for 100 rounds)!
2007/12/15 18:13:49 [1.mp3:3] Connecting mount 1.mp3 for
[EMAIL PROTECTED]
2007/12/15 18:13:49 [1.mp3:3] Connection setup was successful.
2007/12/15 18:13:49 [1.mp3:3] Setting up an MP3 encoder...
2007/12/15 18:13:49 [root:2] We must catchup 5.68 seconds (we've been late
for 100 rounds)!
2007/12/15 18:13:50 [root:2] We must catchup 2.39 seconds (we've been late
for 100 rounds)!
}}}
In the same icecast log tells:
{{{
[2007-12-15 18:13:40] INFO admin/admin_handle_request Received admin
command metadata on mount "/1.mp3"
[2007-12-15 18:13:40] INFO admin/command_metadata Metadata on mountpoint
/1.mp3 changed to "folder.jpg"
[2007-12-15 18:13:42] INFO admin/admin_handle_request Received admin
command metadata on mount "/1.mp3"
[2007-12-15 18:13:42] INFO admin/command_metadata Metadata on mountpoint
/1.mp3 changed to "John Coltrane - Say It (Over And Over Again)"
[2007-12-15 18:13:42] WARN source/get_next_buffer Disconnecting source
due to socket timeout
[2007-12-15 18:13:42] INFO source/source_shutdown Source "/1.mp3" exiting
[2007-12-15 18:13:42] INFO yp/do_yp_remove clearing up YP entry for
/1.mp3
[2007-12-15 18:13:42] INFO fserve/fserve_client_create checking for file
/1.mp3 (/usr/share/icecast/web/1.mp3)
[2007-12-15 18:13:42] WARN fserve/fserve_client_create req for file
"/usr/share/icecast/web/1.mp3" No such file or directory
[2007-12-15 18:13:42] INFO fserve/fserve_client_create checking for file
/1.mp3 (/usr/share/icecast/web/1.mp3)
[2007-12-15 18:13:42] WARN fserve/fserve_client_create req for file
"/usr/share/icecast/web/1.mp3" No such file or directory
[2007-12-15 18:13:43] INFO fserve/fserve_client_create checking for file
/1.mp3 (/usr/share/icecast/web/1.mp3)
[2007-12-15 18:13:43] WARN fserve/fserve_client_create req for file
"/usr/share/icecast/web/1.mp3" No such file or directory
[2007-12-15 18:13:43] INFO fserve/fserve_client_create checking for file
/1.mp3 (/usr/share/icecast/web/1.mp3)
[2007-12-15 18:13:43] WARN fserve/fserve_client_create req for file
"/usr/share/icecast/web/1.mp3" No such file or directory
[2007-12-15 18:13:44] INFO fserve/fserve_client_create checking for file
/1.mp3 (/usr/share/icecast/web/1.mp3)
[2007-12-15 18:13:44] WARN fserve/fserve_client_create req for file
"/usr/share/icecast/web/1.mp3" No such file or directory
[2007-12-15 18:13:44] INFO fserve/fserve_client_create checking for file
/1.mp3 (/usr/share/icecast/web/1.mp3)
[2007-12-15 18:13:44] WARN fserve/fserve_client_create req for file
"/usr/share/icecast/web/1.mp3" No such file or directory
[2007-12-15 18:13:44] WARN admin/admin_handle_request Admin command
metadata on non-existent source /1.mp3
[2007-12-15 18:13:45] INFO fserve/fserve_client_create checking for file
/1.mp3 (/usr/share/icecast/web/1.mp3)
[2007-12-15 18:13:45] WARN fserve/fserve_client_create req for file
"/usr/share/icecast/web/1.mp3" No such file or directory
[2007-12-15 18:13:45] WARN admin/admin_handle_request Admin command
metadata on non-existent source /1.mp3
[2007-12-15 18:13:48] INFO fserve/fserve_client_create checking for file
/1.mp3 (/usr/share/icecast/web/1.mp3)
[2007-12-15 18:13:48] WARN fserve/fserve_client_create req for file
"/usr/share/icecast/web/1.mp3" No such file or directory
[2007-12-15 18:13:49] INFO connection/_handle_source_request Source
logging in at mountpoint "/1.mp3"
[2007-12-15 18:13:50] INFO source/source_main listener count on /1.mp3
now 1
[2007-12-15 18:14:01] WARN source/get_next_buffer Disconnecting source
due to socket timeout
[2007-12-15 18:14:01] INFO source/source_shutdown Source "/1.mp3" exiting
}}}
It could be caused by the fact, that by mistake, liquidsoap received JPEG
file. Even if it's obviously incorrect, it shouldn't crash in way like
that.
--
Ticket URL: <http://savonet.rastageeks.org/ticket/72>
Savonet <http://savonet.rastageeks.org/>
Let's program our stream !
