From: Lars Heineken <Lars.Heineken@gmx.de>
To: alsa-devel@lists.sourceforge.net
Subject: Re: Opening dev/dsp takes very long
Date: Tue, 16 Mar 2004 20:04:27 +0100 [thread overview]
Message-ID: <40574FBB.70306@gmx.de> (raw)
In-Reply-To: <4056BF90.2060005@gmx.de>
-----BEGIN PGP SIGNED MESSAGE-----
Hash: SHA1
Lars Heineken wrote:
| I'll figure out how the script works and make the trace when I get home.
| (~9 hours).
All set, here we go:
The script calls this line:
sox 01.wav -t ossdsp /dev/dsp
After adding an "strace -r" to the beginning I got the following output:
lars@lars-heineken CD-Recorder]$ strace -r sox 01.wav -t ossdsp /dev/dsp
~ 0.000000 execve("/usr//bin/sox", ["sox", "01.wav", "-t", "ossdsp",
"/dev/dsp"], [/* 52 vars */]) = 0
~ 0.000836 uname({sys="Linux", node="lars-heineken.lan", ...}) = 0
~ 0.000339 brk(0) = 0x80a5000
~ 0.000234 old_mmap(NULL, 4096, PROT_READ|PROT_WRITE,
MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x40014000
~ 0.000336 open("/etc/ld.so.preload", O_RDONLY) = -1 ENOENT (No such
file or directory)
~ 0.000445 open("/etc/ld.so.cache", O_RDONLY) = 3
~ 0.000288 fstat64(3, {st_mode=S_IFREG|0644, st_size=69759, ...}) = 0
~ 0.000301 old_mmap(NULL, 69759, PROT_READ, MAP_PRIVATE, 3, 0) =
0x40015000
~ 0.000319 close(3) = 0
~ 0.000227 open("/lib/i686/libm.so.6", O_RDONLY) = 3
~ 0.000325 read(3,
"\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0\0005\0"..., 512) = 512
~ 0.000367 fstat64(3, {st_mode=S_IFREG|0755, st_size=139748, ...}) = 0
~ 0.000264 old_mmap(NULL, 142224, PROT_READ|PROT_EXEC, MAP_PRIVATE,
3, 0) = 0x40027000
~ 0.000275 old_mmap(0x40049000, 4096, PROT_READ|PROT_WRITE,
MAP_PRIVATE|MAP_FIXED, 3, 0x21000) = 0x40049000
~ 0.000352 close(3) = 0
~ 0.000229 open("/usr/lib/libogg.so.0", O_RDONLY) = 3
~ 0.000324 read(3,
"\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0000\20\0"..., 512) = 512
~ 0.000301 fstat64(3, {st_mode=S_IFREG|0755, st_size=14856, ...}) = 0
~ 0.000278 old_mmap(NULL, 13820, PROT_READ|PROT_EXEC, MAP_PRIVATE, 3,
0) = 0x4004a000
~ 0.000271 old_mmap(0x4004d000, 4096, PROT_READ|PROT_WRITE,
MAP_PRIVATE|MAP_FIXED, 3, 0x3000) = 0x4004d000
~ 0.000321 close(3) = 0
~ 0.000236 open("/usr/lib/libvorbis.so.0", O_RDONLY) = 3
~ 0.000323 read(3,
"\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0\220*\0"..., 512) = 512
~ 0.000295 fstat64(3, {st_mode=S_IFREG|0755, st_size=131624, ...}) = 0
~ 0.000259 old_mmap(NULL, 134692, PROT_READ|PROT_EXEC, MAP_PRIVATE,
3, 0) = 0x4004e000
~ 0.000290 old_mmap(0x40068000, 28672, PROT_READ|PROT_WRITE,
MAP_PRIVATE|MAP_FIXED, 3, 0x19000) = 0x40068000
~ 0.000322 close(3) = 0
~ 0.000220 open("/usr/lib/libvorbisfile.so.3", O_RDONLY) = 3
~ 0.000340 read(3,
"\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0\200\26"..., 512) = 512
~ 0.000294 fstat64(3, {st_mode=S_IFREG|0755, st_size=23020, ...}) = 0
~ 0.000260 old_mmap(NULL, 26024, PROT_READ|PROT_EXEC, MAP_PRIVATE, 3,
0) = 0x4006f000
~ 0.000269 old_mmap(0x40075000, 4096, PROT_READ|PROT_WRITE,
MAP_PRIVATE|MAP_FIXED, 3, 0x5000) = 0x40075000
~ 0.000337 close(3) = 0
~ 0.000218 open("/usr/lib/libvorbisenc.so.2", O_RDONLY) = 3
~ 0.000313 read(3,
"\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0@\202\0"..., 512) = 512
~ 0.000322 fstat64(3, {st_mode=S_IFREG|0755, st_size=935152, ...}) = 0
~ 0.000256 old_mmap(NULL, 4096, PROT_READ|PROT_WRITE,
MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x40076000
~ 0.000306 old_mmap(NULL, 949284, PROT_READ|PROT_EXEC, MAP_PRIVATE,
3, 0) = 0x40077000
~ 0.000273 old_mmap(0x40082000, 892928, PROT_READ|PROT_WRITE,
MAP_PRIVATE|MAP_FIXED, 3, 0xb000) = 0x40082000
~ 0.000670 old_mmap(0x4015c000, 11300, PROT_READ|PROT_WRITE,
MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x4015c000
~ 0.000312 close(3) = 0
~ 0.000268 open("/usr/lib/libmad.so.0", O_RDONLY) = 3
~ 0.000346 read(3,
"\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0\340\24"..., 512) = 512
~ 0.000370 fstat64(3, {st_mode=S_IFREG|0755, st_size=88120, ...}) = 0
~ 0.000285 old_mmap(NULL, 91180, PROT_READ|PROT_EXEC, MAP_PRIVATE, 3,
0) = 0x4015f000
~ 0.000275 old_mmap(0x40175000, 4096, PROT_READ|PROT_WRITE,
MAP_PRIVATE|MAP_FIXED, 3, 0x15000) = 0x40175000
~ 0.000329 close(3) = 0
~ 0.000249 open("/lib/i686/libc.so.6", O_RDONLY) = 3
~ 0.000300 read(3,
"\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0\3\0\1\0\0\0\20]\1\000"..., 512) = 512
~ 0.000289 fstat64(3, {st_mode=S_IFREG|0755, st_size=1237568, ...}) = 0
~ 0.000260 old_mmap(NULL, 1242756, PROT_READ|PROT_EXEC, MAP_PRIVATE,
3, 0) = 0x40176000
~ 0.000287 old_mmap(0x402a0000, 12288, PROT_READ|PROT_WRITE,
MAP_PRIVATE|MAP_FIXED, 3, 0x12a000) = 0x402a0000
~ 0.000340 old_mmap(0x402a3000, 9860, PROT_READ|PROT_WRITE,
MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x402a3000
~ 0.000308 close(3) = 0
~ 0.001777 munmap(0x40015000, 69759) = 0
~ 0.001005 brk(0) = 0x80a5000
~ 0.000365 brk(0x80c6000) = 0x80c6000
~ 0.000290 brk(0) = 0x80c6000
~ 0.000384 open("01.wav", O_RDONLY) = 3
~ 0.000466 fstat64(3, {st_mode=S_IFREG|0777, st_size=96, ...}) = 0
~ 0.000382 fstat64(3, {st_mode=S_IFREG|0777, st_size=96, ...}) = 0
~ 0.000321 mmap2(NULL, 4096, PROT_READ|PROT_WRITE,
MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x40015000
~ 0.000356 read(3, "RIFFX\0\0\0WAVEfmt
\20\0\0\0\1\0\2\0D\254\0\0\20\261\2"..., 4096) = 96
~ 0.000395 _llseek(3, 0, [0], SEEK_SET) = 0
~ 0.000287 read(3, "RIFFX\0\0\0WAVEfmt
\20\0\0\0\1\0\2\0D\254\0\0\20\261\2"..., 4096) = 96
~ 0.000406 _llseek(3, 96, [96], SEEK_SET) = 0
~ 0.000302 _llseek(3, 96, [96], SEEK_SET) = 0
~ 0.000272 read(3, "", 4096) = 0
~ 0.000329 _llseek(3, 0, [0], SEEK_SET) = 0
~ 0.000275 read(3, "RIFFX\0\0\0WAVEfmt
\20\0\0\0\1\0\2\0D\254\0\0\20\261\2"..., 44) = 44
~ 0.000339 open("/dev/dsp", O_WRONLY|O_CREAT|O_TRUNC, 0666) = 4
~ 0.000624 fstat64(4, {st_mode=S_IFCHR|0600, st_rdev=makedev(14, 3),
...}) = 0
~ 0.000347 ioctl(4, SNDCTL_TMR_TIMEBASE, 0xbffff4b0) = -1 EINVAL
(Invalid argument)
~ 0.000363 mmap2(NULL, 4096, PROT_READ|PROT_WRITE,
MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x40016000
~ 0.000325 fstat64(4, {st_mode=S_IFCHR|0600, st_rdev=makedev(14, 3),
...}) = 0
~ 0.000347 ioctl(4, SNDCTL_DSP_RESET, 0) = 0
~ 0.000348 ioctl(4, SNDCTL_DSP_GETFMTS, 0xbffff648) = 0
~ 0.516952 ioctl(4, SNDCTL_DSP_SETFMT, 0xbffff648) = 0
~ 0.002426 ioctl(4, SNDCTL_DSP_STEREO, 0xbffff648) = 0
~ 0.002577 ioctl(4, SOUND_PCM_READ_RATE, 0xbffff648) = 0
~ 0.135400 ioctl(4, SNDCTL_DSP_GETBLKSIZE, 0x80a5824) = 0
~ 0.000339 ioctl(4, SNDCTL_DSP_SYNC, 0) = 0
~ 0.000302 munmap(0x40016000, 4096) = 0
~ 0.000325 read(3,
"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 8192) = 52
~ 0.000365 read(3, "", 4096) = 0
~ 0.000323 close(3) = 0
~ 0.000398 munmap(0x40015000, 4096) = 0
~ 0.000602 write(4,
"\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 52) = 52
~ 0.000422 close(4) = 0
~ 0.148631 exit_group(0) = ?
It seems SNDCTL_DSP_SETFMT is to blame, but SNDCTL_DSP_GETBLKSIZE takes
rather long, too.
Does anyone have a clue what might have caused these delays to appear in
alsa 1.00 ?
-----BEGIN PGP SIGNATURE-----
Version: GnuPG v1.2.3 (GNU/Linux)
Comment: Using GnuPG with Mozilla - http://enigmail.mozdev.org
iD8DBQFAV0+7rp9JEomxNXERAp1eAKCTMtv/Xvr4IN5apJRwP+JHOOvaSQCffueJ
1MQD3uNnsHE1jQzb/xDjfv4=
=Yb/b
-----END PGP SIGNATURE-----
-------------------------------------------------------
This SF.Net email is sponsored by: IBM Linux Tutorials
Free Linux tutorial presented by Daniel Robbins, President and CEO of
GenToo technologies. Learn everything from fundamentals to system
administration.http://ads.osdn.com/?ad_id=1470&alloc_id=3638&op=click
next prev parent reply other threads:[~2004-03-16 19:04 UTC|newest]
Thread overview: 17+ messages / expand[flat|nested] mbox.gz Atom feed top
2004-03-13 20:01 Opening dev/dsp takes very long Lars Heineken
2004-03-13 20:24 ` Additional info: " Lars Heineken
2004-03-15 10:35 ` Takashi Iwai
2004-03-15 20:22 ` Lars Heineken
2004-03-16 8:19 ` Clemens Ladisch
2004-03-16 8:49 ` Lars Heineken
2004-03-16 19:04 ` Lars Heineken [this message]
2004-03-19 12:29 ` Lars Heineken
2004-03-19 21:58 ` Lars Heineken
2004-03-19 23:56 ` James Courtier-Dutton
2004-03-20 8:20 ` Lars Heineken
2004-03-20 13:24 ` Jaroslav Kysela
2004-03-20 16:09 ` Lars Heineken
2004-03-20 16:11 ` Jaroslav Kysela
2004-03-20 16:59 ` Lars Heineken
2004-03-20 17:13 ` Tommi Sakari Uimonen
2004-03-20 17:12 ` Jaroslav Kysela
Reply instructions:
You may reply publicly to this message via plain-text email
using any one of the following methods:
* Save the following mbox file, import it into your mail client,
and reply-to-all from there: mbox
Avoid top-posting and favor interleaved quoting:
https://en.wikipedia.org/wiki/Posting_style#Interleaved_style
* Reply using the --to, --cc, and --in-reply-to
switches of git-send-email(1):
git send-email \
--in-reply-to=40574FBB.70306@gmx.de \
--to=lars.heineken@gmx.de \
--cc=alsa-devel@lists.sourceforge.net \
/path/to/YOUR_REPLY
https://kernel.org/pub/software/scm/git/docs/git-send-email.html
* If your mail client supports setting the In-Reply-To header
via mailto: links, try the mailto: link
Be sure your reply has a Subject: header at the top and a blank line
before the message body.
This is a public inbox, see mirroring instructions
for how to clone and mirror all data and code used for this inbox