View Issue Details

IDCategoryLast Update
0002012bugs2009-10-20 23:08
ReporterpeppotAssigned To 
Reproducibilityalways 
Status acknowledgedResolutionopen 
Product VersionSVN/2.0-ongoing 
Fixed in Version 
Summary0002012: Malfunctioning plugin caused audio bug, session saved, .ardour file corrupted
DescriptionI'd been working on a session for 5-6 hours, very happy with my work. Was about to add some simple plugins. Did do so to a bus, one of the plugins caused some sort of audio spike, audio stopped working, JAMIN meters topped out.
I saved my session, quit jamin and stopped and started JACK. On re-opening the session I get a "Session did not load successfully" and "Unable to create all required ports".
Cannot open the session any more.
Attaching the offending session
TagsNo tags attached.

Activities

2008-01-06 21:19

 

080104-sm57klon och ultragain-test.ardour (256,646 bytes)

peppot

2008-01-06 21:28

reporter   ~0004622

This error manifests itself differently when
a) jack is already running and
b) when ardour launches jack

In the case of jack already running I get the "Unable to create all required ports" message but when ardour launches jack itself, I get "Session: XML state has no click section"

peppot

2008-01-07 17:44

reporter   ~0004623

[New Thread 0xb2425cb0 (LWP 14224)]
loading bindings from gtk2_ardour/ardour.bindings
[New Thread 0xb1d63b90 (LWP 14226)]
nsd now on page 1
 
 
**** alsa_pcm: xrun of at least 72.235 msecs
 
 
 
**** alsa_pcm: xrun of at least 9.233 msecs
 
 
 
**** alsa_pcm: xrun of at least 11.959 msecs
 
 
 
**** alsa_pcm: xrun of at least 9.299 msecs
 
 
 
**** alsa_pcm: xrun of at least 2.370 msecs
 
 
 
**** alsa_pcm: xrun of at least 20.265 msecs
 
Loading session /media/mjau/inspelningar/080104-sm57klon och ultragain-test using snapshot 080104-sm57klon och ultragain-test (1)
 
 
**** alsa_pcm: xrun of at least 7.735 msecs
 
 
 
**** alsa_pcm: xrun of at least 10.203 msecs
 
 
 
**** alsa_pcm: xrun of at least 5.399 msecs
 
 
 
**** alsa_pcm: xrun of at least 6.543 msecs
 
 
 
**** alsa_pcm: xrun of at least 1.713 msecs
 
 
 
**** alsa_pcm: xrun of at least 4.367 msecs
 
 
 
**** alsa_pcm: xrun of at least 3.293 msecs
 
 
 
**** alsa_pcm: xrun of at least 1.137 msecs
 
 
 
**** alsa_pcm: xrun of at least 0.366 msecs
 
 
 
**** alsa_pcm: xrun of at least 8.561 msecs
 
 
 
**** alsa_pcm: xrun of at least 2.408 msecs
 
 
 
**** alsa_pcm: xrun of at least 4.753 msecs
 
 
 
**** alsa_pcm: xrun of at least 1.672 msecs
 
 
 
**** alsa_pcm: xrun of at least 0.161 msecs
 
[New Thread 0xb2106cb0 (LWP 14227)]
[New Thread 0xb208bcb0 (LWP 14228)]
 
 
**** alsa_pcm: xrun of at least 7.402 msecs
 
duplicate port name in port registration request
[Switching to Thread 0xb61536c0 (LWP 14162)]
 
Catchpoint 1 (exception thrown)
0xb6afa105 in __cxa_throw () from /usr/lib/libstdc++.so.6
(gdb) subgraph starting at ardour timed out (subgraph_wait_fd=17, status = 0, state = Triggered)
 
 
**** alsa_pcm: xrun of at least 490.199 msecs
 
 
(gdb) thread apply all bt
 
Thread 31 (Thread 0xb208bcb0 (LWP 14228)):
#0 0xffffe410 in __kernel_vsyscall ()
0000001 0xb69b64c7 in poll () from /lib/i686/cmov/libc.so.6
#2 0xb7e4272e in ARDOUR::Session::midi_thread_work (this=0x91e2e00) at libs/ardour/session_midi.cc:1220
#3 0xb7e42c81 in ARDOUR::Session::_midi_thread_work (arg=0x91e2e00) at libs/ardour/session_midi.cc:1141
0000004 0xb6b424fb in start_thread () from /lib/i686/cmov/libpthread.so.0
0000005 0xb69c075e in clone () from /lib/i686/cmov/libc.so.6
 
Thread 30 (Thread 0xb2106cb0 (LWP 14227)):
#0 0xffffe410 in __kernel_vsyscall ()
0000001 0xb69b64c7 in poll () from /lib/i686/cmov/libc.so.6
#2 0xb7e246ef in ARDOUR::Session::butler_thread_work (this=0x91e2e00) at libs/ardour/session_butler.cc:176
#3 0xb7e254bb in ARDOUR::Session::_butler_thread_work (arg=0x91e2e00) at libs/ardour/session_butler.cc:157
0000004 0xb6b424fb in start_thread () from /lib/i686/cmov/libpthread.so.0
0000005 0xb69c075e in clone () from /lib/i686/cmov/libc.so.6
 
Thread 29 (Thread 0xb1d63b90 (LWP 14226)):
#0 0xffffe410 in __kernel_vsyscall ()
0000001 0xb69b64c7 in poll () from /lib/i686/cmov/libc.so.6
#2 0xb6b5b5f8 in jack_client_core_wait (client=0x90219e8) at client.c:1340
#3 0xb6b5bbfa in jack_thread_wait (client=0x90219e8, status=0) at client.c:1492
0000004 0xb6b5c685 in jack_client_thread (arg=0x90219e8) at client.c:1539
0000005 0xb6b424fb in start_thread () from /lib/i686/cmov/libpthread.so.0
#6 0xb69c075e in clone () from /lib/i686/cmov/libc.so.6
 
Thread 28 (Thread 0xb2425cb0 (LWP 14224)):
#0 0xffffe410 in __kernel_vsyscall ()
0000001 0xb6b4a196 in nanosleep () from /lib/i686/cmov/libpthread.so.0
#2 0xb759ac22 in g_usleep () from /usr/lib/libglib-2.0.so.0
#3 0xb6e1cd51 in Glib::usleep (microseconds=10000) at libs/glibmm2/glibmm/timer.cc:68
0000004 0xb7cf2b48 in ARDOUR::AudioEngine::meter_thread (this=0x9007dc0) at libs/ardour/audioengine.cc:431
0000005 0xb7cf5940 in sigc::bound_mem_functor0<void, ARDOUR::AudioEngine>::operator() (this=0x8f6db3c)
    at libs/sigc++2/sigc++/functors/mem_fun.h:1781
#6 0xb7cf5962 in sigc::adaptor_functor<sigc::bound_mem_functor0<void, ARDOUR::AudioEngine> >::operator() (
    this=0x8f6db38) at libs/sigc++2/sigc++/adaptors/adaptor_trait.h:251
#7 0xb7cf598e in sigc::internal::slot_call0<sigc::bound_mem_functor0<void, ARDOUR::AudioEngine>, void>::call_it (rep=0x8f6db20) at libs/sigc++2/sigc++/functors/slot.h:103
0000008 0x083ab0dc in sigc::slot0<void>::operator() (this=0x8f7aa10) at libs/sigc++2/sigc++/functors/slot.h:440
0000009 0xb6e3aff1 in call_thread_entry_slot (data=0x8f7aa10) at libs/glibmm2/glibmm/thread.cc:43
0000010 0xb75984bf in ?? () from /usr/lib/libglib-2.0.so.0
0000011 0x08f7aa10 in ?? ()
0000012 0x08fe9#13 0x00000000 in ?? ()
 
Thread 3 (Thread 0xb55d9b90 (LWP 14166)):
#0 0xffffe410 in __kernel_vsyscall ()
0000001 0xb6b46aa5 in pthread_cond_wait@@GLIBC_2.3.2 () from /lib/i686/cmov/libpthread.so.0
#2 0xb6e3a45d in Glib::Cond::wait (this=0x8a21138, mutex=@0xb7f0ee84) at libs/glibmm2/glibmm/thread.cc:362
#3 0xb7e7b329 in peak_thread_work () at libs/ardour/source_factory.cc:61
0000004 0x086d0ca7 in sigc::pointer_functor0<void>::operator() (this=0x8a2cc84)
    at libs/sigc++2/sigc++/functors/ptr_fun.h:77
0000005 0x086d0cbe in sigc::adaptor_functor<sigc::pointer_functor0<void> >::operator() (this=0x8a2cc80)
    at libs/sigc++2/sigc++/adaptors/adaptor_trait.h:251
#6 0x086d0cda in sigc::internal::slot_call0<sigc::pointer_functor0<void>, void>::call_it (rep=0x8a2cc68)
    at libs/sigc++2/sigc++/functors/slot.h:103
#7 0x083ab0dc in sigc::slot0<void>::operator() (this=0x8a2cc58) at libs/sigc++2/sigc++/functors/slot.h:440
0000008 0xb6e3aff1 in call_thread_entry_slot (data=0x8a2cc58) at libs/glibmm2/glibmm/thread.cc:43
0000009 0xb75984bf in ?? () from /usr/lib/libglib-2.0.so.0
0000010 0x08a2cc58 in ?? ()
0000011 0x08a2cc90 in ?? ()
0000012 0x00000000 in ?? ()
 
Thread 2 (Thread 0xb5ddab90 (LWP 14165)):
#0 0xffffe410 in __kernel_vsyscall ()
0000001 0xb6b46aa5 in pthread_cond_wait@@GLIBC_2.3.2 () from /lib/i686/cmov/libpthread.so.0
#2 0xb6e3a45d in Glib::Cond::wait (this=0x8a21138, mutex=@0xb7f0ee84) at libs/glibmm2/glibmm/thread.cc:362
#3 0xb7e7b329 in peak_thread_work () at libs/ardour/source_factory.cc:61
0000004 0x086d0ca7 in sigc::pointer_functor0<void>::operator() (this=0x8a2cb8c)
    at libs/sigc++2/sigc++/functors/ptr_fun.h:77
0000005 0x086d0cbe in sigc::adaptor_functor<sigc::pointer_functor0<void> >::operator() (this=0x8a2cb88)
    at libs/sigc++2/sigc++/adaptors/adaptor_trait.h:251
#6 0x086d0cda in sigc::internal::slot_call0<sigc::pointer_functor0<void>, void>::call_it (rep=0x8a2cb70)
    at libs/sigc++2/sigc++/functors/slot.h:103
#7 0x083ab0dc in sigc::slot0<void>::operator() (this=0x8a2c620) at libs/sigc++2/sigc++/functors/slot.h:440
0000008 0xb6e3aff1 in call_thread_entry_slot (data=0x8a2c620) at libs/glibmm2/glibmm/thread.cc:43
0000009 0xb75984bf in ?? () from /usr/lib/libglib-2.0.so.0
0000010 0x08a2c620 in ?? ()
0000011 0x08a2cb98 in ?? ()
0000012 0x00015080 in ?? ()
0000013 0x00000005 in ?? ()
0000014 0xb68f1b9c in ?? () from /lib/i686/cmov/libc.so.6
#15 0xb6b51ff4 in ?? () from /lib/i686/cmov/libpthread.so.0
0000016 0xb6b44520 in ?? () from /lib/i686/cmov/libpthread.so.0
#17 0xb6b51ff4 in ?? () from /lib/i686/cmov/libpthread.so.0
0000018 0x00000000 in ?? ()
b08 in ?? ()
 
Thread 1 (Thread 0xb61536c0 (LWP 14162)):
#0 0xb6afa105 in __cxa_throw () from /usr/lib/libstdc++.so.6
0000001 0xb7cf266d in ARDOUR::AudioEngine::register_input_port (this=0x9007dc0, type=
      {_symbol = ARDOUR::DataType::AUDIO}, portname=@0xbfc2c764) at libs/ardour/audioengine.cc:512
#2 0xb7d7d0ea in ARDOUR::IO::ensure_io (this=0x9e03f00, nin=2, nout=2, clear=true, src=0x9e03f00)
    at libs/ardour/io.cc:1186
#3 0xb7d7e450 in ARDOUR::IO::create_ports (this=0x9e03f00, node=@0x9e04b58) at libs/ardour/io.cc:1872
0000004 0xb7d7e655 in ARDOUR::IO::ports_became_legal (this=0x9e03f00) at libs/ardour/io.cc:1807
0000005 0xb7d87f6a in sigc::bound_mem_functor0<int, ARDOUR::IO>::operator() (this=0x9e047bc)
    at libs/sigc++2/sigc++/functors/mem_fun.h:1781
#6 0xb7d87f8c in sigc::adaptor_functor<sigc::bound_mem_functor0<int, ARDOUR::IO> >::operator() (
    this=0x9e047b8) at libs/sigc++2/sigc++/adaptors/adaptor_trait.h:251
#7 0xb7d87fb8 in sigc::internal::slot_call0<sigc::bound_mem_functor0<int, ARDOUR::IO>, int>::call_it (
    rep=0x9e047a0) at libs/sigc++2/sigc++/functors/slot.h:103
0000008 0xb7d88d50 in sigc::internal::signal_emit0<int, sigc::nil_>::emit (impl=0x9dd6158)
    at libs/sigc++2/sigc++/signal.h:484
0000009 0xb7d88dfe in sigc::signal0<int, sigc::nil_>::emit (this=0xb7f0eb80) at libs/sigc++2/sigc++/signal.h:1584
0000010 0xb7d88e21 in sigc::signal0<int, sigc::nil_>::operator() (this=0xb7f0eb80)
    at libs/sigc++2/sigc++/signal.h:1588
0000011 0xb7d7755b in ARDOUR::IO::enable_ports () at libs/ardour/io.cc:2376
0000012 0xb7df802e in ARDOUR::Session::hookup_io (this=0x91e2e00) at libs/ardour/session.cc:917
0000013 0xb7dfa0aa in ARDOUR::Session::when_engine_running (this=0x91e2e00) at libs/ardour/session.cc:844
0000014 0xb7e5d8ef in ARDOUR::Session::second_stage_init (this=0x91e2e00, new_session=false)
    at libs/ardour/session_state.cc:322
#15 0xb7e012dc in Session (this=0x91e2e00, eng=@0x9007dc0, fullpath=@0xbfc2cdf0, snapshot_name=@0xbfc2cdf4,
    mix_template=@0xbfc2cdf8) at libs/ardour/session.cc:302
0000016 0x083b77cf in ARDOUR_UI::load_session (this=0x88d4528, path=@0xbfc2ced8, snap_name=@0xbfc2cedc,
    mix_template=@0xbfc2cf54) at gtk2_ardour/ardour_ui.cc:2444
#17 0x083c64f5 in ARDOUR_UI::get_session_parameters (this=0x88d4528, predetermined_path=@0xbfc2d068,
    have_engine=true, should_be_new=false) at gtk2_ardour/ardour_ui.cc:2205
0000018 0x083c79e8 in ARDOUR_UI::startup (this=0x88d4528) at gtk2_ardour/ardour_ui.cc:657
0000019 0x083d06ea in sigc::bound_mem_functor0<void, ARDOUR_UI>::operator() (this=0x8d2ed04)
    at libs/sigc++2/sigc++/functors/mem_fun.h:1781
0000020 0x083d0700 in sigc::adaptor_functor<sigc::bound_mem_functor0<void, ARDOUR_UI> >::operator() (
    this=0x8d2ed00) at libs/sigc++2/sigc++/adaptors/adaptor_trait.h:251
0000021 0x083d071c in sigc::internal::slot_call0<sigc::bound_mem_functor0<void, ARDOUR_UI>, void>::call_it (
    rep=0x8d2ece8) at libs/sigc++2/sigc++/functors/slot.h:103
0000022 0x083d24fb in sigc::internal::signal_emit0<void, sigc::nil_>::emit (impl=0x8d2ea08)
    at libs/sigc++2/sigc++/signal.h:517
0000023 0x083d2590 in sigc::signal0<void, sigc::nil_>::emit (this=0x88d4570) at libs/sigc++2/sigc++/signal.h:1584
#24 0x083d25a3 in sigc::signal0<void, sigc::nil_>::operator() (this=0x88d4570)
    at libs/sigc++2/sigc++/signal.h:1588
0000025 0xb7ab4ffd in Gtkmm2ext::UI::run (this=0x88d4528, old_receiver=@0x88b48bc) at libs/gtkmm2ext/gtk_ui.cc:221
0000026 0x0863710b in main (argc=1, argv=0xbfc2d264) at gtk2_ardour/main.cc:337

peppot

2008-01-07 17:53

reporter   ~0004624

output of up & print portname:

up
0000001 0xb7da666d in ARDOUR::AudioEngine::register_input_port (this=0x9019fa0, type=
      {_symbol = ARDOUR::DataType::AUDIO}, portname=@0xbfddfa54) at libs/ardour/audioengine.cc:512
512 throw PortRegistrationFailure();
(gdb) print portname
$1 = (const string &) @0xbfddfa54: {static npos = 4294967295,
  _M_dataplus = {<std::allocator<char>> = {<__gnu_cxx::new_allocator<char>> = {<No data fields>}, <No data fields>}, _M_p = 0x9e04fec "rhodes/in 1"}}

jack_lsp:

system:capture_1
system:capture_2
system:playback_1
system:playback_2
ardour:master/in 1
ardour:master/in 2
ardour:master/out 1
ardour:master/out 2
ardour:insert 1/in 1
ardour:insert 1/in 2
ardour:insert 1/out 1
ardour:insert 1/out 2
ardour:auditioner/out 1
ardour:auditioner/out 2
ardour:v oh/in 1
ardour:v oh/out 1
ardour:v oh/out 2
ardour:h oh/in 1
ardour:h oh/out 1
ardour:h oh/out 2
ardour:bk/in 1
ardour:bk/out 1
ardour:bk/out 2
ardour:v o/in 1
ardour:v o/out 1
ardour:v o/out 2
ardour:v u/in 1
ardour:v u/out 1
ardour:v u/out 2
ardour:trum/in 1
ardour:trum/in 2
ardour:trum/out 1
ardour:trum/out 2
ardour:elbas b52/in 1
ardour:elbas b52/out 1
ardour:elbas b52/out 2
ardour:elbas sm57/in 1
ardour:elbas sm57/out 1
ardour:elbas sm57/out 2
ardour:elbas 2 b52/in 1
ardour:elbas 2 b52/out 1
ardour:elbas 2 b52/out 2
ardour:elbas 2 sm57/in 1
ardour:elbas 2 sm57/out 1
ardour:elbas 2 sm57/out 2
ardour:clav sm57/in 1
ardour:clav sm57/out 1
ardour:clav sm57/out 2
ardour:rhodes/in 1
ardour:rhodes/out 1
ardour:rhodes/out 2
ardour:monosynth plus vintagedelay/in 1
ardour:monosynth plus vintagedelay/in 2
ardour:monosynth plus vintagedelay/out 1
ardour:monosynth plus vintagedelay/out 2
ardour:sineshaper/in 1
ardour:sineshaper/out 1
ardour:sineshaper/out 2
ardour:bas 1/in 1
ardour:bas 1/in 2
ardour:bas 1/out 1
ardour:bas 1/out 2
ardour:bas 2/in 1
ardour:bas 2/in 2
ardour:bas 2/out 1
ardour:bas 2/out 2
ardour:clav/in 1
ardour:clav/in 2
ardour:clav/out 1
ardour:clav/out 2

peppot

2008-01-07 18:00

reporter   ~0004625

There are two instances of <IO name="rhodes"...

cth103

2009-10-20 23:08

administrator   ~0006811

The session has been corrupted somehow; for me the problem is the two IOs both named rhodes. Difficult to say how this happened, unfortunately. Perhaps ardour ought to have a better stab at loading the session, though; maybe ignoring the problematic second IO.

Issue History

Date Modified Username Field Change
2008-01-06 21:19 peppot New Issue
2008-01-06 21:19 peppot File Added: 080104-sm57klon och ultragain-test.ardour
2008-01-06 21:28 peppot Note Added: 0004622
2008-01-07 17:44 peppot Note Added: 0004623
2008-01-07 17:53 peppot Note Added: 0004624
2008-01-07 18:00 peppot Note Added: 0004625
2009-10-20 23:08 cth103 Note Added: 0006811
2009-10-20 23:08 cth103 Status new => acknowledged