[Ardour-Users] Adding tracks or busses disconnects Ardour from JACK

[Q]

On 13/10/11 10:28, Colin Fletcher wrote:
> I've no idea what might be going wrong, but have you tried jackd's
> --verbose switch? (I think you can also enable it via QJackCtl's
> 'Verbose messages' setting.) That might give a bit more of a clue to why
> it's failing.
>
> Colin.
>

Thanks for the suggestion Colin. It's a bit difficult to follow the 
messages as there are so many of them. I think I've got all the ones 
from just before creating a new track in an otherwise virtually empty 
test session, to the point shortly after Ardour was disconnected.

Thanks

Q

Jack verbose messages:

load = 1.6123 max usecs: 162.000, spare = 11447.000
load = 1.5728 max usecs: 178.000, spare = 11431.000
server thread back from poll
client event poll on 16 for qjackctl starts at 2023611421
20:01:08.117 JACK connection graph change.
back from client event poll after 61 usecs
registered port ardour:Audio 3/in 1, offset = 0
start poll on 5 fd's
server thread back from poll
client event poll on 16 for qjackctl starts at 2023611746
back from client event poll after 14 usecs
registered port ardour:Audio 3/out 1, offset = 47104
start poll on 5 fd's
server thread back from poll
client event poll on 16 for qjackctl starts at 2023612019
back from client event poll after 17 usecs
registered port ardour:Audio 3/out 2, offset = 49152
start poll on 5 fd's
server thread back from poll
connect system:capture_3 and ardour:Audio 3/in 1 (forward)
client event poll on 19 for ardour starts at 2023612246
back from client event poll after 13 usecs
++ jack_sort_graph
++ jack_rechain_graph():
+++ client is now ardour active ? 1
client ardour: start_fd=7, execution_order=0.
client event poll on 19 for ardour starts at 2023612455
back from client event poll after 13 usecs
client ardour: wait_fd=14, execution_order=1 (last client).
-- jack_rechain_graph()
client event poll on 19 for ardour starts at 2023612555
back from client event poll after 11 usecs
client event poll on 16 for qjackctl starts at 2023612580
back from client event poll after 12 usecs
client event poll on 16 for qjackctl starts at 2023612609
back from client event poll after 379 usecs
client event poll on 19 for ardour starts at 2023613012
back from client event poll after 63 usecs
waking server thread
-- jack_sort_graph
trying to lock graph to remove 1 problems
we have problem clients (problems = 1
++ Removing failed clients ...
client alsa_pcm error status 0
client ardour error status 10000000
removing failed client ardour state = Finished errors = 10000000
removing client "ardour"
removing client "ardour" from the processing chain
client event poll on 16 for qjackctl starts at 2023613146
back from client event poll after 41 usecs
client event poll on 16 for qjackctl starts at 2023613207
back from client event poll after 25 usecs
++ jack_sort_graph
++ jack_rechain_graph():
+++ client is now ardour active ? 1
client ardour: start_fd=7, execution_order=0.
client ardour: wait_fd=14, execution_order=1 (last client).
-- jack_rechain_graph()
client event poll on 16 for qjackctl starts at 2023613355
back from client event poll after 10 usecs
client event poll on 16 for qjackctl starts at 2023613580
-- jack_sort_graph
client event poll on 16 for qjackctl starts at 2023613685
back from client event poll after 9 usecs
DIS-connect ardour:click/out 2 and system:playback_2
++ jack_sort_graph
++ jack_rechain_graph():
+++ client is now ardour active ? 1
client ardour: start_fd=7, execution_order=0.
client ardour: wait_fd=14, execution_order=1 (last client).
-- jack_rechain_graph()
client event poll on 16 for qjackctl starts at 2023613771
back from client event poll after 9 usecs
client event poll on 16 for qjackctl starts at 2023613822
back from client event poll after 10 usecs
-- jack_sort_graph
client event poll on 16 for qjackctl starts at 2023613851
back from client event poll after 9 usecs
DIS-connect ardour:click/out 1 and system:playback_1
++ jack_sort_graph
++ jack_rechain_graph():
+++ client is now ardour active ? 1
client ardour: start_fd=7, execution_order=0.
client ardour: wait_fd=14, execution_order=1 (last client).
-- jack_rechain_graph()
client event poll on 16 for qjackctl starts at 2023613927
back from client event poll after 11 usecs
client event poll on 16 for qjackctl starts at 2023613992
back from client event poll after 26 usecs
-- jack_sort_graph
client event poll on 16 for qjackctl starts at 2023614049
back from client event poll after 7 usecs
DIS-connect ardour:Audio 2/out 2 and ardour:master/in 2
++ jack_sort_graph
++ jack_rechain_graph():
+++ client is now ardour active ? 1
client ardour: start_fd=7, execution_order=0.
client ardour: wait_fd=14, execution_order=1 (last client).
-- jack_rechain_graph()
client event poll on 16 for qjackctl starts at 2023614491
back from client event poll after 7 usecs
client event poll on 16 for qjackctl starts at 2023614509
20:01:08.245 JACK connection change.
back from client event poll after 8 usecs
-- jack_sort_graph
client event poll on 16 for qjackctl starts at 2023614533
back from client event poll after 6 usecs
DIS-connect ardour:Audio 2/out 1 and ardour:master/in 1
++ jack_sort_graph
++ jack_rechain_graph():
+++ client is now ardour active ? 1
client ardour: start_fd=7, execution_order=0.
client ardour: wait_fd=14, execution_order=1 (last client).
-- jack_rechain_graph()
client event poll on 16 for qjackctl starts at 2023614577
back from client event poll after 6 usecs
client event poll on 16 for qjackctl starts at 2023614593
back from client event poll after 8 usecs
-- jack_sort_graph
client event poll on 16 for qjackctl starts at 2023614615
back from client event poll after 6 usecs
DIS-connect system:capture_2 and ardour:Audio 2/in 1
++ jack_sort_graph
++ jack_rechain_graph():
+++ client is now ardour active ? 1
client ardour: start_fd=7, execution_order=0.
client ardour: wait_fd=14, execution_order=1 (last client).
-- jack_rechain_graph()
client event poll on 16 for qjackctl starts at 2023614665
back from client event poll after 6 usecs
client event poll on 16 for qjackctl starts at 2023614680
back from client event poll after 9 usecs
-- jack_sort_graph
client event poll on 16 for qjackctl starts at 2023614703
back from client event poll after 8 usecs
DIS-connect ardour:Audio 1/out 2 and ardour:master/in 2
++ jack_sort_graph
++ jack_rechain_graph():
+++ client is now ardour active ? 1
client ardour: start_fd=7, execution_order=0.
client ardour: wait_fd=14, execution_order=1 (last client).
-- jack_rechain_graph()
client event poll on 16 for qjackctl starts at 2023614747
back from client event poll after 10 usecs
client event poll on 16 for qjackctl starts at 2023614767
back from client event poll after 6 usecs
-- jack_sort_graph
client event poll on 16 for qjackctl starts at 2023614786
back from client event poll after 6 usecs
DIS-connect ardour:Audio 1/out 1 and ardour:master/in 1
++ jack_sort_graph
++ jack_rechain_graph():
client ardour: start_fd=7, execution_order=0.
client ardour: wait_fd=14, execution_order=1 (last client).
-- jack_rechain_graph()
client event poll on 16 for qjackctl starts at 2023614830
back from client event poll after 9 usecs
client event poll on 16 for qjackctl starts at 2023614848
back from client event poll after 6 usecs
client event poll on 16 for qjackctl starts at 2023614869
back from client event poll after 6 usecs
DIS-connect system:capture_1 and ardour:Audio 1/in 1
++ jack_sort_graph
++ jack_rechain_graph():
+++ client is now ardour active ? 1
client ardour: start_fd=7, execution_order=0.
client ardour: wait_fd=14, execution_order=1 (last client).
-- jack_rechain_graph()
client event poll on 16 for qjackctl starts at 2023614913
back from client event poll after 7 usecs
client event poll on 16 for qjackctl starts at 2023614929
back from client event poll after 6 usecs
-- jack_sort_graph
client event poll on 16 for qjackctl starts at 2023614948
back from client event poll after 8 usecs
DIS-connect ardour:auditioner/out 2 and system:playback_2
++ jack_sort_graph
++ jack_rechain_graph():
+++ client is now ardour active ? 1
client ardour: start_fd=7, execution_order=0.
client ardour: wait_fd=14, execution_order=1 (last client).
-- jack_rechain_graph()
client event poll on 16 for qjackctl starts at 2023614997
back from client event poll after 6 usecs
client event poll on 16 for qjackctl starts at 2023615012
back from client event poll after 6 usecs
-- jack_sort_graph
client event poll on 16 for qjackctl starts at 2023615032
back from client event poll after 6 usecs
DIS-connect ardour:auditioner/out 1 and system:playback_1
++ jack_sort_graph
+++ client is now ardour active ? 1
client ardour: start_fd=7, execution_order=0.
client ardour: wait_fd=14, execution_order=1 (last client).
client event poll on 16 for qjackctl starts at 2023615074
back from client event poll after 6 usecs
client event poll on 16 for qjackctl starts at 2023615089
back from client event poll after 6 usecs
-- jack_sort_graph
client event poll on 16 for qjackctl starts at 2023615108
back from client event poll after 6 usecs
DIS-connect ardour:master/out 2 and system:playback_2
++ jack_sort_graph
++ jack_rechain_graph():
client ardour: start_fd=7, execution_order=0.
client ardour: wait_fd=14, execution_order=1 (last client).
-- jack_rechain_graph()
client event poll on 16 for qjackctl starts at 2023615149
back from client event poll after 6 usecs
client event poll on 16 for qjackctl starts at 2023615163
back from client event poll after 6 usecs
-- jack_sort_graph
client event poll on 16 for qjackctl starts at 2023615182
back from client event poll after 6 usecs
DIS-connect ardour:master/out 1 and system:playback_1
++ jack_sort_graph
++ jack_rechain_graph():
+++ client is now ardour active ? 1
client ardour: start_fd=7, execution_order=0.
client ardour: wait_fd=14, execution_order=1 (last client).
-- jack_rechain_graph()
client event poll on 16 for qjackctl starts at 2023615223
back from client event poll after 6 usecs
client event poll on 16 for qjackctl starts at 2023615238
back from client event poll after 6 usecs
client event poll on 16 for qjackctl starts at 2023615257
back from client event poll after 6 usecs
client event poll on 16 for qjackctl starts at 2023615275
back from client event poll after 6 usecs
client event poll on 16 for qjackctl starts at 2023615293
back from client event poll after 6 usecs
+++ deactivate ardour
client qjackctl error status 0
++ jack_sort_graph
++ jack_rechain_graph():
-- jack_rechain_graph()
client event poll on 16 for qjackctl starts at 2023615385
back from client event poll after 3 usecs
client event poll on 16 for qjackctl starts at 2023615397
back from client event poll after 3 usecs
-- jack_sort_graph
-- Removing failed clients ...
after removing clients, problems = 0
start poll on 4 fd's
server thread back from poll
start poll on 4 fd's
server thread back from poll
start poll on 4 fd's
server thread back from poll
start poll on 4 fd's
server thread back from poll
start poll on 4 fd's
server thread back from poll
start poll on 4 fd's
server thread back from poll
start poll on 4 fd's
server thread back from poll
start poll on 4 fd's
server thread back from poll
start poll on 4 fd's
server thread back from poll
start poll on 4 fd's
server thread back from poll
start poll on 4 fd's
server thread back from poll
start poll on 4 fd's
server thread back from poll
start poll on 4 fd's
server thread back from poll
start poll on 4 fd's
server thread back from poll
start poll on 4 fd's
server thread back from poll
start poll on 4 fd's
server thread back from poll
start poll on 4 fd's
server thread back from poll
start poll on 4 fd's
server thread back from poll
start poll on 4 fd's
server thread back from poll
start poll on 4 fd's
server thread back from poll
start poll on 4 fd's
server thread back from poll
start poll on 4 fd's
server thread back from poll
start poll on 4 fd's
server thread back from poll
start poll on 4 fd's
server thread back from poll
start poll on 4 fd's
server thread back from poll
start poll on 4 fd's
server thread back from poll
start poll on 4 fd's
server thread back from poll
start poll on 4 fd's
server thread back from poll
start poll on 4 fd's
server thread back from poll
start poll on 4 fd's
server thread back from poll
start poll on 4 fd's
server thread back from poll
start poll on 4 fd's
server thread back from poll
start poll on 4 fd's
server thread back from poll
start poll on 4 fd's
server thread back from poll
start poll on 4 fd's
server thread back from poll
start poll on 4 fd's
load = 0.8510 max usecs: 15.000, spare = 11594.000
load = 0.5116 max usecs: 20.000, spare = 11589.000
load = 0.4626 max usecs: 48.000, spare = 11561.000
load = 0.3390 max usecs: 25.000, spare = 11584.000
load = 0.3418 max usecs: 40.000, spare = 11569.000
load = 0.3690 max usecs: 46.000, spare = 11563.000
load = 0.2879 max usecs: 24.000, spare = 11585.000