Better error reporting

[tonistiigi]

• audiosprite checks that ffmpeg doesn't return error but doesn't check for ENOENT.
• if there is any error during spawn, stdout/stderr of the child process should be printed out.

See #13

[ceefour]

👍 the behavior should be better.

ceefour@hendy:~/tmp/Cleanus-OGG/sprite > audiosprite -e ogg,mp3 -f howler -o cleanus-ogg -g 0.3 ../*.ogg
debug: Parsed arguments _=[../Battery_Charging.ogg, ../K3B_Error.ogg, ../K3B_Success.ogg, ../KDE_Desktop10.ogg, ../KDE_Desktop1.ogg, ../KDE_Desktop2.ogg, ../KDE_Desktop3.ogg, ../KDE_Desktop4.ogg, ../KDE_Desktop5.ogg, ../KDE_Desktop6.ogg, ../KDE_Desktop7.ogg, ../KDE_Desktop8.ogg, ../KDE_Desktop9.ogg, ../KDE_Device_Connected.ogg, ../KDE_Device_Disconnected.ogg, ../KDE_Error.ogg, ../KDE_Event2.ogg, ../KDE_Event.ogg, ../KDE_Logout.ogg, ../KDE_pop.ogg, ../KDE_Startup.ogg, ../KDE_Window_Close.ogg, ../KDE_Window_Open.ogg, ../KDE_Window_Shade_Down.ogg, ../KDE_Window_Shade_Up.ogg, ../Kopete_Event.ogg, ../Kopete_Received.ogg, ../Kopete_Sent.ogg, ../Kopete_User_is_Online.ogg, ../LowBatteryAlarm.ogg, ../Window_Iconify.ogg], e=ogg,mp3, export=ogg,mp3, f=howler, format=howler, o=cleanus-ogg, output=cleanus-ogg, g=0.3, gap=0.3, path=, u=, log=info, l=info, autoplay=null, a=null, silence=0, s=0, minlength=0, m=0, samplerate=44100, r=44100, channels=1, c=1, rawparts=, p=, $0=audiosprite
debug: Created temporary file file=/tmp/audiosprite.014362295158207417
debug: Spawn cmd=ffmpeg -version
debug: Start processing file=../Battery_Charging.ogg
debug: Spawn cmd=ffmpeg -i /home/ceefour/tmp/Cleanus-OGG/Battery_Charging.ogg -ar 44100 -ac 1 -f s16le pipe:
util.pump() is deprecated. Use readableStream.pipe() instead.
info: File added OK file=/tmp/audiosprite.22132545709609985, duration=1.044671201814059
info: Silence gap added duration=1.2553287981859411
debug: Start processing file=../K3B_Error.ogg
debug: Spawn cmd=ffmpeg -i /home/ceefour/tmp/Cleanus-OGG/K3B_Error.ogg -ar 44100 -ac 1 -f s16le pipe:
info: File added OK file=/tmp/audiosprite.13487249799072742, duration=2.141814058956916
info: Silence gap added duration=1.1581859410430841
debug: Start processing file=../K3B_Success.ogg
debug: Spawn cmd=ffmpeg -i /home/ceefour/tmp/Cleanus-OGG/K3B_Success.ogg -ar 44100 -ac 1 -f s16le pipe:
info: File added OK file=/tmp/audiosprite.3766818977892399, duration=1.7499773242630385
info: Silence gap added duration=0.5500226757369615
debug: Start processing file=../KDE_Desktop10.ogg
debug: Spawn cmd=ffmpeg -i /home/ceefour/tmp/Cleanus-OGG/KDE_Desktop10.ogg -ar 44100 -ac 1 -f s16le pipe:
info: File added OK file=/tmp/audiosprite.7876935570966452, duration=0.5744671201814059
info: Silence gap added duration=0.725532879818594
debug: Start processing file=../KDE_Desktop1.ogg
debug: Spawn cmd=ffmpeg -i /home/ceefour/tmp/Cleanus-OGG/KDE_Desktop1.ogg -ar 44100 -ac 1 -f s16le pipe:
info: File added OK file=/tmp/audiosprite.7543931272812188, duration=0.5483446712018141
info: Silence gap added duration=0.751655328798186
debug: Start processing file=../KDE_Desktop2.ogg
debug: Spawn cmd=ffmpeg -i /home/ceefour/tmp/Cleanus-OGG/KDE_Desktop2.ogg -ar 44100 -ac 1 -f s16le pipe:
info: File added OK file=/tmp/audiosprite.26619959552772343, duration=0.5483446712018141
info: Silence gap added duration=0.751655328798186
debug: Start processing file=../KDE_Desktop3.ogg
debug: Spawn cmd=ffmpeg -i /home/ceefour/tmp/Cleanus-OGG/KDE_Desktop3.ogg -ar 44100 -ac 1 -f s16le pipe:
info: File added OK file=/tmp/audiosprite.5545179196633399, duration=0.5483446712018141
info: Silence gap added duration=0.751655328798186
debug: Start processing file=../KDE_Desktop4.ogg
debug: Spawn cmd=ffmpeg -i /home/ceefour/tmp/Cleanus-OGG/KDE_Desktop4.ogg -ar 44100 -ac 1 -f s16le pipe:
info: File added OK file=/tmp/audiosprite.7542353158351034, duration=0.5483446712018141
info: Silence gap added duration=0.751655328798186
debug: Start processing file=../KDE_Desktop5.ogg
debug: Spawn cmd=ffmpeg -i /home/ceefour/tmp/Cleanus-OGG/KDE_Desktop5.ogg -ar 44100 -ac 1 -f s16le pipe:
info: File added OK file=/tmp/audiosprite.622084665345028, duration=0.5483446712018141
info: Silence gap added duration=0.751655328798186
debug: Start processing file=../KDE_Desktop6.ogg
debug: Spawn cmd=ffmpeg -i /home/ceefour/tmp/Cleanus-OGG/KDE_Desktop6.ogg -ar 44100 -ac 1 -f s16le pipe:
info: File added OK file=/tmp/audiosprite.173782936995849, duration=0.5483446712018141
info: Silence gap added duration=0.751655328798186
debug: Start processing file=../KDE_Desktop7.ogg
debug: Spawn cmd=ffmpeg -i /home/ceefour/tmp/Cleanus-OGG/KDE_Desktop7.ogg -ar 44100 -ac 1 -f s16le pipe:
info: File added OK file=/tmp/audiosprite.0012624321971088648, duration=0.5483446712018141
info: Silence gap added duration=0.751655328798186
debug: Start processing file=../KDE_Desktop8.ogg
debug: Spawn cmd=ffmpeg -i /home/ceefour/tmp/Cleanus-OGG/KDE_Desktop8.ogg -ar 44100 -ac 1 -f s16le pipe:
info: File added OK file=/tmp/audiosprite.6332280528731644, duration=0.5483446712018141
info: Silence gap added duration=0.751655328798186
debug: Start processing file=../KDE_Desktop9.ogg
debug: Spawn cmd=ffmpeg -i /home/ceefour/tmp/Cleanus-OGG/KDE_Desktop9.ogg -ar 44100 -ac 1 -f s16le pipe:
info: File added OK file=/tmp/audiosprite.5749752067495137, duration=0.6267120181405895
info: Silence gap added duration=0.6732879818594104
debug: Start processing file=../KDE_Device_Connected.ogg
debug: Spawn cmd=ffmpeg -i /home/ceefour/tmp/Cleanus-OGG/KDE_Device_Connected.ogg -ar 44100 -ac 1 -f s16le pipe:
info: File added OK file=/tmp/audiosprite.20169578585773706, duration=1.044671201814059
info: Silence gap added duration=1.2553287981859411
debug: Start processing file=../KDE_Device_Disconnected.ogg
debug: Spawn cmd=ffmpeg -i /home/ceefour/tmp/Cleanus-OGG/KDE_Device_Disconnected.ogg -ar 44100 -ac 1 -f s16le pipe:
info: File added OK file=/tmp/audiosprite.956946864258498, duration=1.0185487528344672
info: Silence gap added duration=1.2814512471655328
debug: Start processing file=../KDE_Error.ogg
debug: Spawn cmd=ffmpeg -i /home/ceefour/tmp/Cleanus-OGG/KDE_Error.ogg -ar 44100 -ac 1 -f s16le pipe:
info: File added OK file=/tmp/audiosprite.18649493507109582, duration=0.7312018140589569
info: Silence gap added duration=0.5687981859410431
debug: Start processing file=../KDE_Event2.ogg
debug: Spawn cmd=ffmpeg -i /home/ceefour/tmp/Cleanus-OGG/KDE_Event2.ogg -ar 44100 -ac 1 -f s16le pipe:
info: File added OK file=/tmp/audiosprite.7731257516425103, duration=0.8095691609977325
info: Silence gap added duration=0.4904308390022675
debug: Start processing file=../KDE_Event.ogg
debug: Spawn cmd=ffmpeg -i /home/ceefour/tmp/Cleanus-OGG/KDE_Event.ogg -ar 44100 -ac 1 -f s16le pipe:
info: File added OK file=/tmp/audiosprite.400481037562713, duration=0.8095691609977325
info: Silence gap added duration=0.4904308390022675
debug: Start processing file=../KDE_Logout.ogg
debug: Spawn cmd=ffmpeg -i /home/ceefour/tmp/Cleanus-OGG/KDE_Logout.ogg -ar 44100 -ac 1 -f s16le pipe:
info: File added OK file=/tmp/audiosprite.7914322479628026, duration=2.820997732426304
info: Silence gap added duration=0.4790022675736962
debug: Start processing file=../KDE_pop.ogg
debug: Spawn cmd=ffmpeg -i /home/ceefour/tmp/Cleanus-OGG/KDE_pop.ogg -ar 44100 -ac 1 -f s16le pipe:
info: File added OK file=/tmp/audiosprite.42137549072504044, duration=0.4960997732426304
info: Silence gap added duration=0.8039002267573696
debug: Start processing file=../KDE_Startup.ogg
debug: Spawn cmd=ffmpeg -i /home/ceefour/tmp/Cleanus-OGG/KDE_Startup.ogg -ar 44100 -ac 1 -f s16le pipe:
info: File added OK file=/tmp/audiosprite.06403044448234141, duration=5.589977324263039
info: Silence gap added duration=0.7100226757369612
debug: Start processing file=../KDE_Window_Close.ogg
debug: Spawn cmd=ffmpeg -i /home/ceefour/tmp/Cleanus-OGG/KDE_Window_Close.ogg -ar 44100 -ac 1 -f s16le pipe:
info: File added OK file=/tmp/audiosprite.36530930432491004, duration=0.5483446712018141
info: Silence gap added duration=0.751655328798186
debug: Start processing file=../KDE_Window_Open.ogg
debug: Spawn cmd=ffmpeg -i /home/ceefour/tmp/Cleanus-OGG/KDE_Window_Open.ogg -ar 44100 -ac 1 -f s16le pipe:
info: File added OK file=/tmp/audiosprite.019994460744783282, duration=0.1565079365079365
info: Silence gap added duration=1.1434920634920636
debug: Start processing file=../KDE_Window_Shade_Down.ogg
debug: Spawn cmd=ffmpeg -i /home/ceefour/tmp/Cleanus-OGG/KDE_Window_Shade_Down.ogg -ar 44100 -ac 1 -f s16le pipe:
info: File added OK file=/tmp/audiosprite.29141633468680084, duration=0.3654875283446712
info: Silence gap added duration=0.9345124716553288
debug: Start processing file=../KDE_Window_Shade_Up.ogg
debug: Spawn cmd=ffmpeg -i /home/ceefour/tmp/Cleanus-OGG/KDE_Window_Shade_Up.ogg -ar 44100 -ac 1 -f s16le pipe:
info: File added OK file=/tmp/audiosprite.4547124393284321, duration=0.31324263038548755
info: Silence gap added duration=0.9867573696145124
debug: Start processing file=../Kopete_Event.ogg
debug: Spawn cmd=ffmpeg -i /home/ceefour/tmp/Cleanus-OGG/Kopete_Event.ogg -ar 44100 -ac 1 -f s16le pipe:
info: File added OK file=/tmp/audiosprite.2244569652248174, duration=1.2797732426303854
info: Silence gap added duration=1.0202267573696147
debug: Start processing file=../Kopete_Received.ogg
debug: Spawn cmd=ffmpeg -i /home/ceefour/tmp/Cleanus-OGG/Kopete_Received.ogg -ar 44100 -ac 1 -f s16le pipe:
info: File added OK file=/tmp/audiosprite.5800625709816813, duration=0.9401814058956917
info: Silence gap added duration=0.35981859410430833
debug: Start processing file=../Kopete_Sent.ogg
debug: Spawn cmd=ffmpeg -i /home/ceefour/tmp/Cleanus-OGG/Kopete_Sent.ogg -ar 44100 -ac 1 -f s16le pipe:
info: File added OK file=/tmp/audiosprite.9119340069591999, duration=0.7573242630385487
info: Silence gap added duration=0.5426757369614512
debug: Start processing file=../Kopete_User_is_Online.ogg
debug: Spawn cmd=ffmpeg -i /home/ceefour/tmp/Cleanus-OGG/Kopete_User_is_Online.ogg -ar 44100 -ac 1 -f s16le pipe:
info: File added OK file=/tmp/audiosprite.622257454553619, duration=0.8618140589569161
info: Silence gap added duration=0.4381859410430839
debug: Start processing file=../LowBatteryAlarm.ogg
debug: Spawn cmd=ffmpeg -i /home/ceefour/tmp/Cleanus-OGG/LowBatteryAlarm.ogg -ar 44100 -ac 1 -f s16le pipe:
info: File added OK file=/tmp/audiosprite.35453224810771644, duration=1.2275283446712018
info: Silence gap added duration=1.0724716553287983
debug: Start processing file=../Window_Iconify.ogg
debug: Spawn cmd=ffmpeg -i /home/ceefour/tmp/Cleanus-OGG/Window_Iconify.ogg -ar 44100 -ac 1 -f s16le pipe:
info: File added OK file=/tmp/audiosprite.48956903093494475, duration=0.4438548752834467
info: Silence gap added duration=0.8561451247165532
debug: Start export format=ogg
debug: Spawn cmd=ffmpeg -y -ac 1 -f s16le -i /tmp/audiosprite.014362295158207417 -acodec libvorbis -f ogg cleanus-ogg.ogg
[1]

ceefour@hendy:~/tmp/Cleanus-OGG/sprite > ffmpeg -y -ac 1 -f s16le -i /tmp/audiosprite.014362295158207417 -acodec libvorbis -f ogg cleanus-ogg.ogg
ffmpeg version 0.8.10-6:0.8.10-0ubuntu0.13.10.1, Copyright (c) 2000-2013 the Libav developers
  built on Feb  6 2014 20:53:28 with gcc 4.8.1
*** THIS PROGRAM IS DEPRECATED ***
This program is only provided for compatibility and will be removed in a future release. Please use avconv instead.
Ignoring attempt to set invalid timebase for st:0
[s16le @ 0x863400] Could not find codec parameters (Audio: pcm_s16le, 1 channels, s16)
[s16le @ 0x863400] Estimating duration from bitrate, this may be inaccurate
/tmp/audiosprite.014362295158207417: could not find codec parameters
[1]