#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
Resolution: | Keywords: crash
--------------------------------+-------------------------------------------
Comment (by MarcinLewandowski):
After upgrade it was working until today. But it hasn't crashed, it just
stopped streaming now (wtf?!?!?!).
Last entries in liquidsoap log:
{{{
2008/01/05 16:43:13 [root:2] We must catchup 3.08 seconds!
2008/01/05 16:43:14 [root:2] We must catchup 1.78 seconds!
2008/01/05 16:43:15 [root:2] We must catchup 0.35 seconds (we've been late
for 100 rounds)!
2008/01/05 16:47:00 [EMAIL PROTECTED]/L13C20:3] Finished with
"/data/accounts/radioart/database/1805"
2008/01/05 16:47:00 [noblank:3] Too much blank, abort track!
2008/01/05 16:47:00 [noblank:3] Too much blank, abort track!
2008/01/05 16:47:00 [EMAIL PROTECTED]/L78C16:3] Analysis: nandB /
nandB (12.00s / 0.00s)
2008/01/05 16:47:00 [xfade_smart:3] Transition: crossed, fade-in, fade-
out.
2008/01/05 16:47:00 [EMAIL PROTECTED]/L13C20:3] Prepared
"/data/accounts/radioart/database/2201" -- rid 40
2008/01/05 16:47:04 [EMAIL PROTECTED]/L13C20:3] Finished with
"/data/accounts/radioart/database/2201"
2008/01/05 16:47:04 [noblank:3] Too much blank, abort track!
2008/01/05 16:47:04 [root:2] We must catchup 4.06 seconds!
2008/01/05 16:47:05 [EMAIL PROTECTED]/L13C20:3] Prepared
"/data/accounts/radioart/database/2356" -- rid 41
2008/01/05 16:47:07 [EMAIL PROTECTED]/L13C20:3] Finished with
"/data/accounts/radioart/database/2356"
2008/01/05 16:47:07 [noblank:3] Too much blank, abort track!
2008/01/05 16:47:07 [root:2] We must catchup 6.21 seconds!
2008/01/05 16:47:07 [EMAIL PROTECTED]/L13C20:3] Prepared
"/data/accounts/radioart/database/7274" -- rid 42
2008/01/05 16:47:08 [root:2] We must catchup 7.65 seconds!
2008/01/05 16:47:09 [root:2] We must catchup 7.30 seconds!
2008/01/05 16:47:10 [root:2] We must catchup 4.59 seconds (we've been late
for 100 rounds)!
2008/01/05 16:47:11 [root:2] We must catchup 1.41 seconds (we've been late
for 100 rounds)!
2008/01/05 16:47:15 [root:2] We must catchup 3.14 seconds!
2008/01/05 16:47:16 [root:2] We must catchup 1.66 seconds (we've been late
for 100 rounds)!
2008/01/05 16:47:17 [root:2] We must catchup 0.18 seconds (we've been late
for 100 rounds)!
2008/01/05 16:52:29 [EMAIL PROTECTED]/L13C20:3] Finished with
"/data/accounts/radioart/database/7274"
2008/01/05 16:52:29 [EMAIL PROTECTED]/L13C20:3] Prepared
"/data/accounts/radioart/database/2299" -- rid 44
2008/01/05 16:52:33 [EMAIL PROTECTED]/L78C16:3] Analysis:
-30.185585dB / -25.499616dB (12.02s / 6.01s)
2008/01/05 16:52:33 [xfade_smart:3] Transition: crossed, fade-out.
2008/01/05 16:52:33 [root:2] We must catchup 4.29 seconds!
2008/01/05 16:52:34 [root:2] We must catchup 0.30 seconds (we've been late
for 100 rounds)!
2008/01/05 16:52:44 [root:2] We must catchup 3.16 seconds!
2008/01/05 16:52:45 [root:2] We must catchup 1.67 seconds (we've been late
for 100 rounds)!
2008/01/05 16:52:46 [root:2] We must catchup 0.14 seconds (we've been late
for 100 rounds)!
2008/01/05 16:57:47 [EMAIL PROTECTED]/L13C20:3] Finished with
"/data/accounts/radioart/database/2299"
2008/01/05 16:57:47 [EMAIL PROTECTED]/L13C20:3] Prepared
"/data/accounts/radioart/database/2108" -- rid 45
2008/01/05 16:57:58 [EMAIL PROTECTED]/L78C16:3] Analysis:
-41.419039dB / -36.978135dB (12.01s / 6.01s)
2008/01/05 16:57:58 [xfade_smart:3] Transition: crossed, no fade-out.
2008/01/05 16:57:58 [root:2] We must catchup 10.85 seconds!
2008/01/05 16:57:59 [root:2] We must catchup 6.44 seconds (we've been late
for 100 rounds)!
2008/01/05 16:58:00 [root:2] We must catchup 2.68 seconds (we've been late
for 100 rounds)!
}}}
Unforunately, I don't have my last icecast log.
ps output
{{{
hosting icecast # ps ax | grep liq
16647 pts/2 Sl+ 4318:37 liquidsoap jedynka.liq
}}}
strace
{{{
hosting icecast # strace -p 16647
Process 16647 attached - interrupt to quit
rt_sigtimedwait([INT TERM],
}}}
After doing Ctrl+C to liquidsoap, strace continued output:
{{{
hosting icecast # strace -p 16647
Process 16647 attached - interrupt to quit
rt_sigtimedwait([INT TERM], 0, 0, 8) = 2
gettimeofday({1199577543, 396214}, NULL) = 0
write(4, "2008/01/06 00:59:03 [main:3] Shu"..., 47) = 47
select(0, [], [], [], {3, 0}) = 0 (Timeout)
rt_sigprocmask(SIG_BLOCK, [VTALRM], [], 8) = 0
rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
gettimeofday({1199577546, 398318}, NULL) = 0
write(4, "2008/01/06 00:59:06 [main:3] Cle"..., 58) = 58
stat64("/data/accounts/radioart/database/2108", {st_mode=S_IFREG|0640,
st_size=4940153, ...}) = 0
time(NULL) = 1199577546
stat64("/data/accounts/radioart/database/504", {st_mode=S_IFREG|0640,
st_size=4892960, ...}) = 0
time(NULL) = 1199577546
stat64("/data/accounts/radioart/database/725", {st_mode=S_IFREG|0640,
st_size=5051723, ...}) = 0
rt_sigprocmask(SIG_BLOCK, [VTALRM], [], 8) = 0
rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
time(NULL) = 1199577546
gettimeofday({1199577546, 463456}, NULL) = 0
write(4, "2008/01/06 00:59:06 >>> LOG END\n", 32) = 32
close(4) = 0
exit_group(0) = ?
Process 16647 detached
}}}
and liquidsoap log was filled with:
{{{
2008/01/06 00:58:02 [1.mp3:2] Shout socket error: timeout, network
failure, server shutdown? Restarting the output in 3 sec
2008/01/06 00:58:02 [root:2] Too much latency! Resetting active sources..
2008/01/06 00:58:02 [1.mp3:3] Connecting mount 1.mp3 for
[EMAIL PROTECTED]
2008/01/06 00:58:02 [1.mp3:2] Unable to connect to icecast server
127.0.0.1:8000!
2008/01/06 00:58:02 [1.mp3:3] Connection failed, will try again in 3 sec.
2008/01/06 00:58:02 [1.mp3:3] Setting up an MP3 encoder...
2008/01/06 00:58:05 [root:2] We must catchup 3.22 seconds!
2008/01/06 00:58:06 [1.mp3:3] Connecting mount 1.mp3 for
[EMAIL PROTECTED]
2008/01/06 00:58:06 [1.mp3:2] Unable to connect to icecast server
127.0.0.1:8000!
2008/01/06 00:58:06 [1.mp3:3] Connection failed, will try again in 3 sec.
2008/01/06 00:58:06 [1.mp3:3] Setting up an MP3 encoder...
2008/01/06 00:58:06 [root:2] We must catchup 1.76 seconds (we've been late
for 100 rounds)!
2008/01/06 00:58:07 [root:2] We must catchup 0.23 seconds (we've been late
for 100 rounds)!
2008/01/06 00:58:10 [1.mp3:3] Connecting mount 1.mp3 for
[EMAIL PROTECTED]
2008/01/06 00:58:10 [1.mp3:3] Connection setup was successful.
2008/01/06 00:58:10 [1.mp3:3] Setting up an MP3 encoder...
2008/01/06 00:59:03 [main:3] Shutdown started!
2008/01/06 00:59:03 [root:2] Root shutdown
2008/01/06 00:59:03 [threads:3] thread "root" exited (2 remaining)
2008/01/06 00:59:06 [main:3] Cleaning downloaded files...
2008/01/06 00:59:06 >>> LOG END
}}}
Also my icecast behaved a bit tricky (it was fully responsible etc. but
it's process had to be killed manually when I restarted it), but even if
there's an icecast server failure, liquidsoap shouldn't hang...
heeelp ;) i need it stable ;)
--
Ticket URL: <http://savonet.rastageeks.org/ticket/72#comment:30>
Savonet <http://savonet.rastageeks.org/>
Let's program our stream !
