Ticket #108: log

File log, 34.1 kB (added by jerro, 16 years ago)
Line 
1 no message buffer overruns
2 jackd 0.111.5
3 Copyright 2001-2005 Paul Davis and others.
4 jackd comes with ABSOLUTELY NO WARRANTY
5 This is free software, and you are welcome to redistribute it
6 under certain conditions; see the file COPYING for details
7
8 JACK compiled with System V SHM support.
9 loading driver ..
10 0404600549:  (ffado.cpp)[  99] ffado_streaming_init: libffado 1.999.27-1165 built May 12 2008 10:57:41
11 0404600757: Debug (Element.cpp)[ 111] setVerboseLevel: Setting verbose level to 6...
12 0404600764: Debug (StreamProcessorManager.cpp)[1208] setVerboseLevel:  Receive processors...
13 0404600769: Debug (StreamProcessorManager.cpp)[1215] setVerboseLevel:  Transmit processors...
14 0404600774: Debug (devicemanager.cpp)[1021] setVerboseLevel: Setting verbose level to 6...
15 0404600781: Debug (DeviceStringParser.cpp)[ 277] isValidString: isvalid? hw:0
16 0404600793: Debug (devicemanager.cpp)[ 205] addSpecString: Adding spec string hw:0
17 0404600797: Debug (DeviceStringParser.cpp)[ 246] parseString: parse: hw:0
18 0404600800: Debug (DeviceStringParser.cpp)[ 251] parseString:  left: hw:0
19 0404600813: Debug (DeviceStringParser.cpp)[  56] parse: parse: hw:0
20 0404600841: Debug (ffado.cpp)[ 141] ffado_streaming_init: setting slave mode to 0
21 0404600851: Debug (ffado.cpp)[ 147] ffado_streaming_init: setting snoop mode to 0
22 0404600906: Debug (devicemanager.cpp)[ 170] initialize: Found 1 firewire adapters (ports)
23 0404600925: Debug (ieee1394service.cpp)[1114] setVerboseLevel: Setting verbose level to 6...
24 0404600933: Debug (ieee1394service.cpp)[ 309] setThreadParameters: Switching IsoManager to (rt=1, prio=14)
25 0404600937: Debug (IsoHandlerManager.cpp)[ 412] setThreadParameters: (0x8072690) switch to: (rt=1, prio=14)...
26 0404600941: Debug (ieee1394service.cpp)[ 315] setThreadParameters: Switching CycleTimerHelper to (rt=1, prio=4)
27 0404600945: Debug (CycleTimerHelper.cpp)[ 242] setThreadParameters: (0x80726d0) switch to: (rt=1, prio=4)...
28 0404600969: Debug (Watchdog.cpp)[ 200] start: (0x8072838) Starting watchdog...
29 0404600976: Debug (Watchdog.cpp)[ 201] start: Create hartbeat task/thread for 0x8072838...
30 0404600987: Debug (Watchdog.cpp)[ 215] start:  hartbeat task: 0x8072870, thread 0x8072890...
31 0404600997: Debug (Watchdog.cpp)[ 217] start: Create check task/thread for 0x8072838...
32 0404601001: Debug (Watchdog.cpp)[ 231] start:  check task: 0x80728b0, thread 0x80728d0...
33 0404640030: Debug (Watchdog.cpp)[ 249] start: (0x8072838) Watchdog running...
34 0404640154: Debug (ieee1394service.cpp)[ 232] initialize: This system supports the raw1394_read_cycle_timer call, using it.
35 0404640198: Debug (CycleTimerHelper.cpp)[ 126] Start: Start 0x80726d0...
36 0404640212: Debug (CycleTimerHelper.cpp)[ 159] initValues: (0x80726d0) Init values...
37 0404640224: Debug (CycleTimerHelper.cpp)[ 166] initValues: Read CTR...
38 0404640239: Debug (CycleTimerHelper.cpp)[ 177] initValues:  read : CTR:  1054200566, local:  1210607048298670
39 0404640252: Debug (CycleTimerHelper.cpp)[ 183] initValues:   ctr   : 0x3ED5D2F6   772366070 (031s 3421cy 0758ticks)
40 0404640265: Debug (CycleTimerHelper.cpp)[ 189] initValues: requesting DLL re-init...
41 0404641299: Debug (CycleTimerHelper.cpp)[ 306] initDLL:  (0x80726d0) First run
42 0404641314: Debug (CycleTimerHelper.cpp)[ 309] initDLL:   usecs/update: 200000, ticks/update: 4915200, m_dll_e2: 4915200.000000
43 0404641338: Debug (CycleTimerHelper.cpp)[ 312] initDLL:   usecs current: 1210607048299728.000000, next: 1210607048499728.000000
44 0404641355: Debug (CycleTimerHelper.cpp)[ 315] initDLL:   ticks current: 772392074.000000, next: 777307274.000000
45 0404641369: Debug (CycleTimerHelper.cpp)[ 199] initValues: ready...
46 0404641384: Debug (Watchdog.cpp)[ 281] registerThread: (0x8072838) Adding thread 0x8078eb8
47 0404651813: Debug (CycleTimerHelper.cpp)[ 206] Init: Initialize 0x80726d0...
48 0404651846: Debug (ieee1394service.cpp)[ 834] addBusResetHandler: Adding busreset handler (0x8078f78)
49 0404651879: Debug (CycleTimerHelper.cpp)[ 381] Execute: (0x80726d0) have to retry CTR read, diff unrealistic: diff: -4655149.000000, max: -1536.000000 (try: 4)
50 0404651898: Debug (CycleTimerHelper.cpp)[ 306] initDLL:  (0x80726d0) First run
51 0404651902: Debug (CycleTimerHelper.cpp)[ 309] initDLL:   usecs/update: 200000, ticks/update: 4915200, m_dll_e2: 4915200.000000
52 0404651907: Debug (CycleTimerHelper.cpp)[ 312] initDLL:   usecs current: 1210607048310329.000000, next: 1210607048510329.000000
53 0404651914: Debug (CycleTimerHelper.cpp)[ 315] initDLL:   ticks current: 772652634.000000, next: 777567834.000000
54 0404653054: Debug (IsoHandlerManager.cpp)[ 441] init: Initializing ISO manager 0x8072690...
55 0404653072: Debug (IsoHandlerManager.cpp)[ 449] init: Create iso thread for 0x8072690 transmit...
56 0404653087: Debug (IsoHandlerManager.cpp)[ 467] init: Create iso thread for 0x8072690 receive...
57 0404653102: Debug (Watchdog.cpp)[ 281] registerThread: (0x8072838) Adding thread 0x8079090
58 0404653127: Debug (Watchdog.cpp)[ 281] registerThread: (0x8072838) Adding thread 0x80791a8
59 0404653141: Debug (PosixThread.cpp)[  97] Start: Create RT thread 0x8079090 with priority 15
60 0404664390: Debug (PosixThread.cpp)[  76] ThreadHandler: ThreadHandler: start 0x8079090
61 0404666045: Debug (PosixThread.cpp)[  97] Start: Create RT thread 0x80791a8 with priority 8
62 0404676363: Debug (PosixThread.cpp)[  76] ThreadHandler: ThreadHandler: start 0x80791a8
63 0404717746: Debug (ieee1394service.cpp)[ 309] setThreadParameters: Switching IsoManager to (rt=1, prio=14)
64 0404717808: Debug (IsoHandlerManager.cpp)[ 412] setThreadParameters: (0x8072690) switch to: (rt=1, prio=14)...
65 0404717822: Debug (PosixThread.cpp)[ 184] AcquireRealTime: (0x8079090) Aquire realtime, prio 15
66 0404717840: Debug (PosixThread.cpp)[ 184] AcquireRealTime: (0x80791a8) Aquire realtime, prio 8
67 0404717854: Debug (ieee1394service.cpp)[ 315] setThreadParameters: Switching CycleTimerHelper to (rt=1, prio=4)
68 0404717867: Debug (CycleTimerHelper.cpp)[ 242] setThreadParameters: (0x80726d0) switch to: (rt=1, prio=4)...
69 0404717881: Debug (PosixThread.cpp)[ 184] AcquireRealTime: (0x8078eb8) Aquire realtime, prio 4
70 0404717916: Debug (ieee1394service.cpp)[ 834] addBusResetHandler: Adding busreset handler (0x80793a8)
71 0404717957: Debug (Element.cpp)[ 111] setVerboseLevel: Setting verbose level to 6...
72 0404717971: Debug (StreamProcessorManager.cpp)[1208] setVerboseLevel:  Receive processors...
73 0404717984: Debug (StreamProcessorManager.cpp)[1215] setVerboseLevel:  Transmit processors...
74 0404718013: Debug (ieee1394service.cpp)[1114] setVerboseLevel: Setting verbose level to 6...
75 0404718026: Debug (devicemanager.cpp)[1021] setVerboseLevel: Setting verbose level to 6...
76 0404718044: Debug (devicemanager.cpp)[ 343] discover: Probing node 0...
77 0404718057: Debug (devicemanager.cpp)[ 346] discover: Skipping local node (0)...
78 0404718069: Debug (devicemanager.cpp)[ 343] discover: Probing node 1...
79 0404723801: Debug (DeviceStringParser.cpp)[ 376] show: DeviceStringParser: 0x8071d98
80 0404723821: Debug (DeviceStringParser.cpp)[ 211] show: string: hw:0
81 0404723833: Debug (DeviceStringParser.cpp)[ 214] show: type: eBusNode
82 0404723844: Debug (DeviceStringParser.cpp)[ 216] show:  Port: 0, Node: -1
83 0404723857: Debug (devicemanager.cpp)[ 448] discover: Probing node 0...
84 0404723869: Debug (devicemanager.cpp)[ 451] discover: Skipping local node (0)...
85 0404723880: Debug (devicemanager.cpp)[ 448] discover: Probing node 1...
86 0404729041: Debug (configrom.cpp)[ 556] printConfigRomDebug: Config ROM
87 0404729057: Debug (configrom.cpp)[ 557] printConfigRomDebug:    Current Node Id:1
88 0404729069: Debug (configrom.cpp)[ 558] printConfigRomDebug:    GUID:           0x0040AB0000C2184B
89 0404729082: Debug (configrom.cpp)[ 559] printConfigRomDebug:    Vendor Name:    EDIROL
90 0404729095: Debug (configrom.cpp)[ 560] printConfigRomDebug:    Model Name:     EDIROL FA-101
91 0404729107: Debug (configrom.cpp)[ 561] printConfigRomDebug:    Node Vendor ID:0x0040ab
92 0404729119: Debug (configrom.cpp)[ 562] printConfigRomDebug:    Model Id:       0x00010048
93 0404729131: Debug (configrom.cpp)[ 563] printConfigRomDebug:    Unit Specifier ID:      0x00a02d
94 0404729143: Debug (configrom.cpp)[ 564] printConfigRomDebug:    Unit version:   0x00010001
95 0404729154: Debug (configrom.cpp)[ 565] printConfigRomDebug:    ISO resource manager:   1
96 0404729166: Debug (configrom.cpp)[ 566] printConfigRomDebug:    Cycle master capable:   1
97 0404729177: Debug (configrom.cpp)[ 567] printConfigRomDebug:    Bus manager capable:    1
98 0404729189: Debug (configrom.cpp)[ 568] printConfigRomDebug:    Cycle clock accuracy:   100
99 0404729201: Debug (configrom.cpp)[ 570] printConfigRomDebug:    Max rec:        6 (max asy payload: 128 bytes)
100 0404729215: Debug (DeviceStringParser.cpp)[ 162] match: match 0x8079408
101 0404729227: Debug (devicemanager.cpp)[ 822] getDriverForDevice: Trying BeBoB...
102 0404729438: Debug (Element.cpp)[ 197] addElement: Adding Element ConfigRom to 0040ab0000c2184b
103 0404729462: Debug (Element.cpp)[ 197] addElement: Adding Element Generic to 0040ab0000c2184b
104 0404729480: Debug (Element.cpp)[ 197] addElement: Adding Element ClockSelect to Generic
105 0404729497: Debug (Element.cpp)[ 197] addElement: Adding Element Nickname to Generic
106 0404729522: Debug (devicemanager.cpp)[ 509] discover: driver found for device 1
107 0404729537: Debug (avc_plug.cpp)[1801] setVerboseLevel: Setting verbose level to 6...
108 0404729549: Debug (Element.cpp)[ 111] setVerboseLevel: Setting verbose level to 6...
109 0404729562: Debug (avc_plug.cpp)[1801] setVerboseLevel: Setting verbose level to 6...
110 0404729570: Debug (avc_unit.cpp)[ 114] setVerboseLevel: Setting verbose level to 6...
111 0404729574: Debug (avc_avdevice.cpp)[ 144] setVerboseLevel: Setting verbose level to 6...
112 0404729578: Debug (bebob_avdevice.cpp)[ 328] setVerboseLevel: Setting verbose level to 6...
113 0404747591: Debug (bebob_avdevice.cpp)[ 408] getConfigurationIdSampleRate: Sample rate 0x04
114 0404751659: Debug (bebob_avdevice.cpp)[ 443] getConfigurationIdNumberOfChannel: Number of channels 0x02
115 0404756022: Debug (bebob_avdevice.cpp)[ 443] getConfigurationIdNumberOfChannel: Number of channels 0x02
116 0404759964: Debug (bebob_avdevice.cpp)[ 477] getConfigurationIdSyncMode: Sync mode 0x6007
117 0404760020: Debug (bebob_avdevice.cpp)[ 564] loadFromCache: filename /home/dani/.ffado/cache/0040ab0000c2184b/60070404.xml
118 0404763692: Debug (serialize_libxml.cpp)[ 226] checkVersion: Cache version: 1.999.27-1160, expected: 1.999.27-1165.
119 0404763736: Debug (serialize_libxml.cpp)[ 231] checkVersion: Cache version not OK.
120 0404763750: Debug (bebob_avdevice.cpp)[ 581] loadFromCache: cache not valid: /home/dani/.ffado/cache/0040ab0000c2184b/60070404.xml
121 0404765578: Debug (bebob_avdevice.cpp)[ 141] discover: found    "EDIROL"         "FA-101"
122 0404769042: Debug (avc_unit.cpp)[ 246] enumerateSubUnits: subunit_id =  0, subunit_type =  1 (Audio)
123 0404769058: Debug (avc_subunit.cpp)[  72] setVerboseLevel: Setting verbose level to 6...
124 0404769066: Debug (avc_subunit.cpp)[  72] setVerboseLevel: Setting verbose level to 6...
125 0404769072: Debug (bebob_avdevice_subunit.cpp)[  83] discover: Discovering BeBoB::AudioSubunit...
126 0404769079: Debug (avc_audiosubunit.cpp)[  55] discover: Discovering BeBoB::AudioSubunit...
127 0404769108: Debug (avc_subunit.cpp)[ 108] discoverPlugs: Discovering plugs...
128 0404773103: Debug (avc_subunit.cpp)[ 124] discoverPlugs: number of source plugs = 1
129 0404773130: Debug (avc_subunit.cpp)[ 126] discoverPlugs: number of destination output plugs = 6
130 0404773142: Debug (avc_subunit.cpp)[ 169] discoverPlugs: Discovering plugs for direction 0...
131 0404778017: Debug (bebob_avplug.cpp)[ 178] discoverPlugType: plug 0 is of type 0 (IsoStream)
132 0404783180: Debug (bebob_avplug.cpp)[ 237] discoverName: plug 0 has name 'ASU Wave Output 1/2'
133 0404788390: Debug (bebob_avplug.cpp)[ 270] discoverNoOfChannels: plug 0 has 2 channels
134 0404793804: Debug (bebob_avplug.cpp)[ 305] discoverChannelPosition: plug 0: channel position information retrieved
135 0404793821: Debug (avc_plug.cpp)[1111] debugOutputClusterInfos: number of channels: 2
136 0404793828: Debug (avc_plug.cpp)[1122] debugOutputClusterInfos: stream position: 0
137 0404793834: Debug (avc_plug.cpp)[1125] debugOutputClusterInfos: location: 1
138 0404793840: Debug (avc_plug.cpp)[1122] debugOutputClusterInfos: stream position: 1
139 0404793845: Debug (avc_plug.cpp)[1125] debugOutputClusterInfos: location: 2
140 0404799262: Debug (bebob_avplug.cpp)[ 399] discoverChannelName: plug 0 stream position 0: channel name = SpdifOut left
141 0404804386: Debug (bebob_avplug.cpp)[ 399] discoverChannelName: plug 0 stream position 1: channel name = SpdifOut right
142 0404809497: Debug (bebob_avplug.cpp)[ 460] discoverClusterInfo: ASU Wave Output 1/2 plug 0: cluster index = 1, portType SPDIF, cluster name = SpdifOut
143 0404815979: Debug (avc_plug.cpp)[ 323] discoverStreamFormat: ASU Wave Output 1/2 plug 0 uses sampling frequency 4, nr of stream infos = 1
144 0404816015: Debug (avc_plug.cpp)[ 344] discoverStreamFormat: number of channels = 2, stream format = 6
145 0404816028: Debug (avc_plug.cpp)[ 375] discoverStreamFormat: ASU Wave Output 1/2 plug 0 cluster info 1 ('SpdifOut'): stream format 6
146 0404823564: Debug (avc_plug.cpp)[ 474] discoverSupportedStreamFormats: [ASU Wave Output 1/2:0] formatInfo[0].m_samplingFrequency = 4
147 0404823582: Debug (avc_plug.cpp)[ 478] discoverSupportedStreamFormats: [ASU Wave Output 1/2:0] formatInfo[0].m_isSyncStream = 0
148 0404823589: Debug (avc_plug.cpp)[ 482] discoverSupportedStreamFormats: [ASU Wave Output 1/2:0] formatInfo[0].m_audioChannels = 2
149 0404823596: Debug (avc_plug.cpp)[ 486] discoverSupportedStreamFormats: [ASU Wave Output 1/2:0] formatInfo[0].m_midiChannels = 0
150 0404829032: Debug (avc_subunit.cpp)[ 194] discoverPlugs: plug 'ASU Wave Output 1/2' found
151 0404829061: Debug (avc_plug.cpp)[  75] Plug: nodeId = 1, subunitType = 1, subunitId = 0, functionBlockType = 255, functionBlockId = 255, addressType = 3, direction = 0, id = 1
152 0404829076: Debug (bebob_avplug.cpp)[  64] Plug: nodeId = 1, subunitType = 1, subunitId = 0, functionBlockType = 255, functionBlockId = 255, addressType = 3, direction = 0, id = 1
153 0404834506: Debug (bebob_avplug.cpp)[ 178] discoverPlugType: plug 1 is of type 0 (IsoStream)
154 0404839813: Debug (bebob_avplug.cpp)[ 237] discoverName: plug 1 has name 'ASU Ext Audio Input 1/2'
155 0404844945: Debug (bebob_avplug.cpp)[ 270] discoverNoOfChannels: plug 1 has 2 channels
156 0404850389: Debug (bebob_avplug.cpp)[ 305] discoverChannelPosition: plug 1: channel position information retrieved
157 0404850417: Debug (avc_plug.cpp)[1111] debugOutputClusterInfos: number of channels: 2
158 0404850430: Debug (avc_plug.cpp)[1122] debugOutputClusterInfos: stream position: 0
159 0404850441: Debug (avc_plug.cpp)[1125] debugOutputClusterInfos: location: 1
160 0404850453: Debug (avc_plug.cpp)[1122] debugOutputClusterInfos: stream position: 1
161 0404850464: Debug (avc_plug.cpp)[1125] debugOutputClusterInfos: location: 2
162 0404855753: Debug (bebob_avplug.cpp)[ 399] discoverChannelName: plug 1 stream position 0: channel name = SpdifIn left
163 0404861058: Debug (bebob_avplug.cpp)[ 399] discoverChannelName: plug 1 stream position 1: channel name = SpdifIn right
164 0404866180: Debug (bebob_avplug.cpp)[ 460] discoverClusterInfo: ASU Ext Audio Input 1/2 plug 1: cluster index = 1, portType SPDIF, cluster name = SpdifIn
165 0404872855: Debug (avc_plug.cpp)[ 323] discoverStreamFormat: ASU Ext Audio Input 1/2 plug 1 uses sampling frequency 4, nr of stream infos = 1
166 0404872872: Debug (avc_plug.cpp)[ 344] discoverStreamFormat: number of channels = 2, stream format = 6
167 0404872885: Debug (avc_plug.cpp)[ 375] discoverStreamFormat: ASU Ext Audio Input 1/2 plug 1 cluster info 1 ('SpdifIn'): stream format 6
168 0404880061: Debug (avc_plug.cpp)[ 474] discoverSupportedStreamFormats: [ASU Ext Audio Input 1/2:1] formatInfo[0].m_samplingFrequency = 4
169 0404880088: Debug (avc_plug.cpp)[ 478] discoverSupportedStreamFormats: [ASU Ext Audio Input 1/2:1] formatInfo[0].m_isSyncStream = 0
170 0404880101: Debug (avc_plug.cpp)[ 482] discoverSupportedStreamFormats: [ASU Ext Audio Input 1/2:1] formatInfo[0].m_audioChannels = 2
171 0404880114: Debug (avc_plug.cpp)[ 486] discoverSupportedStreamFormats: [ASU Ext Audio Input 1/2:1] formatInfo[0].m_midiChannels = 0
172 0404885327: Debug (avc_subunit.cpp)[ 194] discoverPlugs: plug 'ASU Ext Audio Input 1/2' found
173 0404885351: Debug (avc_plug.cpp)[  75] Plug: nodeId = 1, subunitType = 1, subunitId = 0, functionBlockType = 255, functionBlockId = 255, addressType = 3, direction = 0, id = 2
174 0404885363: Debug (bebob_avplug.cpp)[  64] Plug: nodeId = 1, subunitType = 1, subunitId = 0, functionBlockType = 255, functionBlockId = 255, addressType = 3, direction = 0, id = 2
175 0404889805: Debug (bebob_avplug.cpp)[ 178] discoverPlugType: plug 2 is of type 0 (IsoStream)
176 0404894814: Debug (bebob_avplug.cpp)[ 237] discoverName: plug 2 has name 'ASU Ext Audio Input 3/4'
177 0404899406: Debug (bebob_avplug.cpp)[ 270] discoverNoOfChannels: plug 2 has 2 channels
178 0404904359: Debug (bebob_avplug.cpp)[ 305] discoverChannelPosition: plug 2: channel position information retrieved
179 0404904378: Debug (avc_plug.cpp)[1111] debugOutputClusterInfos: number of channels: 2
180 0404904391: Debug (avc_plug.cpp)[1122] debugOutputClusterInfos: stream position: 0
181 0404904403: Debug (avc_plug.cpp)[1125] debugOutputClusterInfos: location: 1
182 0404904415: Debug (avc_plug.cpp)[1122] debugOutputClusterInfos: stream position: 1
183 0404904426: Debug (avc_plug.cpp)[1125] debugOutputClusterInfos: location: 2
184 0404909331: Debug (bebob_avplug.cpp)[ 399] discoverChannelName: plug 2 stream position 0: channel name = MicIn1 left
185 0404914382: Debug (bebob_avplug.cpp)[ 399] discoverChannelName: plug 2 stream position 1: channel name = MicIn1 right
186 0404919702: Debug (bebob_avplug.cpp)[ 460] discoverClusterInfo: ASU Ext Audio Input 3/4 plug 2: cluster index = 1, portType Microphone, cluster name = MicIn1
187 0404926676: Debug (avc_plug.cpp)[ 323] discoverStreamFormat: ASU Ext Audio Input 3/4 plug 2 uses sampling frequency 4, nr of stream infos = 1
188 0404926695: Debug (avc_plug.cpp)[ 344] discoverStreamFormat: number of channels = 2, stream format = 6
189 0404926707: Debug (avc_plug.cpp)[ 375] discoverStreamFormat: ASU Ext Audio Input 3/4 plug 2 cluster info 1 ('MicIn1'): stream format 6
190 0404933984: Debug (avc_plug.cpp)[ 474] discoverSupportedStreamFormats: [ASU Ext Audio Input 3/4:2] formatInfo[0].m_samplingFrequency = 4
191 0404934013: Debug (avc_plug.cpp)[ 478] discoverSupportedStreamFormats: [ASU Ext Audio Input 3/4:2] formatInfo[0].m_isSyncStream = 0
192 0404934027: Debug (avc_plug.cpp)[ 482] discoverSupportedStreamFormats: [ASU Ext Audio Input 3/4:2] formatInfo[0].m_audioChannels = 2
193 0404934039: Debug (avc_plug.cpp)[ 486] discoverSupportedStreamFormats: [ASU Ext Audio Input 3/4:2] formatInfo[0].m_midiChannels = 0
194 0404939934: Debug (avc_subunit.cpp)[ 194] discoverPlugs: plug 'ASU Ext Audio Input 3/4' found
195 0404939997: Debug (avc_plug.cpp)[  75] Plug: nodeId = 1, subunitType = 1, subunitId = 0, functionBlockType = 255, functionBlockId = 255, addressType = 3, direction = 0, id = 3
196 0404940060: Debug (bebob_avplug.cpp)[  64] Plug: nodeId = 1, subunitType = 1, subunitId = 0, functionBlockType = 255, functionBlockId = 255, addressType = 3, direction = 0, id = 3
197 0404944730: Debug (bebob_avplug.cpp)[ 178] discoverPlugType: plug 3 is of type 0 (IsoStream)
198 0404950351: Debug (bebob_avplug.cpp)[ 237] discoverName: plug 3 has name 'ASU Ext Audio Input 5/6'
199 0404955444: Debug (bebob_avplug.cpp)[ 270] discoverNoOfChannels: plug 3 has 2 channels
200 0404960544: Debug (bebob_avplug.cpp)[ 305] discoverChannelPosition: plug 3: channel position information retrieved
201 0404960561: Debug (avc_plug.cpp)[1111] debugOutputClusterInfos: number of channels: 2
202 0404960574: Debug (avc_plug.cpp)[1122] debugOutputClusterInfos: stream position: 0
203 0404960585: Debug (avc_plug.cpp)[1125] debugOutputClusterInfos: location: 1
204 0404960597: Debug (avc_plug.cpp)[1122] debugOutputClusterInfos: stream position: 1
205 0404960608: Debug (avc_plug.cpp)[1125] debugOutputClusterInfos: location: 2
206 0404966914: Debug (bebob_avplug.cpp)[ 399] discoverChannelName: plug 3 stream position 0: channel name = LineIn 3+4 left
207 0404972087: Debug (bebob_avplug.cpp)[ 399] discoverChannelName: plug 3 stream position 1: channel name = LineIn 3+4 right
208 0404977572: Debug (bebob_avplug.cpp)[ 460] discoverClusterInfo: ASU Ext Audio Input 5/6 plug 3: cluster index = 1, portType Line, cluster name = LineIn 3+4
209 0404984542: Debug (avc_plug.cpp)[ 323] discoverStreamFormat: ASU Ext Audio Input 5/6 plug 3 uses sampling frequency 4, nr of stream infos = 1
210 0404984564: Debug (avc_plug.cpp)[ 344] discoverStreamFormat: number of channels = 2, stream format = 6
211 0404984577: Debug (avc_plug.cpp)[ 375] discoverStreamFormat: ASU Ext Audio Input 5/6 plug 3 cluster info 1 ('LineIn 3+4'): stream format 6
212 0404992564: Debug (avc_plug.cpp)[ 474] discoverSupportedStreamFormats: [ASU Ext Audio Input 5/6:3] formatInfo[0].m_samplingFrequency = 4
213 0404992583: Debug (avc_plug.cpp)[ 478] discoverSupportedStreamFormats: [ASU Ext Audio Input 5/6:3] formatInfo[0].m_isSyncStream = 0
214 0404992595: Debug (avc_plug.cpp)[ 482] discoverSupportedStreamFormats: [ASU Ext Audio Input 5/6:3] formatInfo[0].m_audioChannels = 2
215 0404992608: Debug (avc_plug.cpp)[ 486] discoverSupportedStreamFormats: [ASU Ext Audio Input 5/6:3] formatInfo[0].m_midiChannels = 0
216 0404997546: Debug (avc_subunit.cpp)[ 194] discoverPlugs: plug 'ASU Ext Audio Input 5/6' found
217 0404997583: Debug (avc_plug.cpp)[  75] Plug: nodeId = 1, subunitType = 1, subunitId = 0, functionBlockType = 255, functionBlockId = 255, addressType = 3, direction = 0, id = 4
218 0404997599: Debug (bebob_avplug.cpp)[  64] Plug: nodeId = 1, subunitType = 1, subunitId = 0, functionBlockType = 255, functionBlockId = 255, addressType = 3, direction = 0, id = 4
219 0405002378: Debug (bebob_avplug.cpp)[ 178] discoverPlugType: plug 4 is of type 0 (IsoStream)
220 0405008608: Debug (bebob_avplug.cpp)[ 237] discoverName: plug 4 has name 'ASU Ext Audio Input 7/8'
221 0405013632: Debug (bebob_avplug.cpp)[ 270] discoverNoOfChannels: plug 4 has 2 channels
222 0405018508: Debug (bebob_avplug.cpp)[ 305] discoverChannelPosition: plug 4: channel position information retrieved
223 0405018526: Debug (avc_plug.cpp)[1111] debugOutputClusterInfos: number of channels: 2
224 0405018538: Debug (avc_plug.cpp)[1122] debugOutputClusterInfos: stream position: 0
225 0405018550: Debug (avc_plug.cpp)[1125] debugOutputClusterInfos: location: 1
226 0405018561: Debug (avc_plug.cpp)[1122] debugOutputClusterInfos: stream position: 1
227 0405018572: Debug (avc_plug.cpp)[1125] debugOutputClusterInfos: location: 2
228 0405023545: Debug (bebob_avplug.cpp)[ 399] discoverChannelName: plug 4 stream position 0: channel name = LineIn 5+6 left
229 0405028667: Debug (bebob_avplug.cpp)[ 399] discoverChannelName: plug 4 stream position 1: channel name = LineIn 5+6 right
230 0405035278: Debug (bebob_avplug.cpp)[ 460] discoverClusterInfo: ASU Ext Audio Input 7/8 plug 4: cluster index = 1, portType Line, cluster name = LineIn 5+6
231 0405041187: Debug (avc_plug.cpp)[ 323] discoverStreamFormat: ASU Ext Audio Input 7/8 plug 4 uses sampling frequency 4, nr of stream infos = 1
232 0405041215: Debug (avc_plug.cpp)[ 344] discoverStreamFormat: number of channels = 2, stream format = 6
233 0405041227: Debug (avc_plug.cpp)[ 375] discoverStreamFormat: ASU Ext Audio Input 7/8 plug 4 cluster info 1 ('LineIn 5+6'): stream format 6
234 0405048229: Debug (avc_plug.cpp)[ 474] discoverSupportedStreamFormats: [ASU Ext Audio Input 7/8:4] formatInfo[0].m_samplingFrequency = 4
235 0405048245: Debug (avc_plug.cpp)[ 478] discoverSupportedStreamFormats: [ASU Ext Audio Input 7/8:4] formatInfo[0].m_isSyncStream = 0
236 0405048268: Debug (avc_plug.cpp)[ 482] discoverSupportedStreamFormats: [ASU Ext Audio Input 7/8:4] formatInfo[0].m_audioChannels = 2
237 0405048280: Debug (avc_plug.cpp)[ 486] discoverSupportedStreamFormats: [ASU Ext Audio Input 7/8:4] formatInfo[0].m_midiChannels = 0
238 0405054542: Debug (avc_subunit.cpp)[ 194] discoverPlugs: plug 'ASU Ext Audio Input 7/8' found
239 0405054586: Debug (avc_plug.cpp)[  75] Plug: nodeId = 1, subunitType = 1, subunitId = 0, functionBlockType = 255, functionBlockId = 255, addressType = 3, direction = 0, id = 5
240 0405054602: Debug (bebob_avplug.cpp)[  64] Plug: nodeId = 1, subunitType = 1, subunitId = 0, functionBlockType = 255, functionBlockId = 255, addressType = 3, direction = 0, id = 5
241 0405058794: Debug (bebob_avplug.cpp)[ 178] discoverPlugType: plug 5 is of type 0 (IsoStream)
242 0405064331: Debug (bebob_avplug.cpp)[ 237] discoverName: plug 5 has name 'ASU Ext Audio Input 9/10'
243 0405068961: Debug (bebob_avplug.cpp)[ 270] discoverNoOfChannels: plug 5 has 2 channels
244 0405074143: Debug (bebob_avplug.cpp)[ 305] discoverChannelPosition: plug 5: channel position information retrieved
245 0405074161: Debug (avc_plug.cpp)[1111] debugOutputClusterInfos: number of channels: 2
246 0405074173: Debug (avc_plug.cpp)[1122] debugOutputClusterInfos: stream position: 0
247 0405074184: Debug (avc_plug.cpp)[1125] debugOutputClusterInfos: location: 1
248 0405074196: Debug (avc_plug.cpp)[1122] debugOutputClusterInfos: stream position: 1
249 0405074207: Debug (avc_plug.cpp)[1125] debugOutputClusterInfos: location: 2
250 0405079423: Debug (bebob_avplug.cpp)[ 399] discoverChannelName: plug 5 stream position 0: channel name = LineIn 7+8 left
251 0405084821: Debug (bebob_avplug.cpp)[ 399] discoverChannelName: plug 5 stream position 1: channel name = LineIn 7+8 right
252 0405090263: Debug (bebob_avplug.cpp)[ 460] discoverClusterInfo: ASU Ext Audio Input 9/10 plug 5: cluster index = 1, portType Line, cluster name = LineIn 7+8
253 0405097124: Debug (avc_plug.cpp)[ 323] discoverStreamFormat: ASU Ext Audio Input 9/10 plug 5 uses sampling frequency 4, nr of stream infos = 1
254 0405097158: Debug (avc_plug.cpp)[ 344] discoverStreamFormat: number of channels = 2, stream format = 6
255 0405097171: Debug (avc_plug.cpp)[ 375] discoverStreamFormat: ASU Ext Audio Input 9/10 plug 5 cluster info 1 ('LineIn 7+8'): stream format 6
256 0405104789: Debug (avc_plug.cpp)[ 474] discoverSupportedStreamFormats: [ASU Ext Audio Input 9/10:5] formatInfo[0].m_samplingFrequency = 4
257 0405104807: Debug (avc_plug.cpp)[ 478] discoverSupportedStreamFormats: [ASU Ext Audio Input 9/10:5] formatInfo[0].m_isSyncStream = 0
258 0405104819: Debug (avc_plug.cpp)[ 482] discoverSupportedStreamFormats: [ASU Ext Audio Input 9/10:5] formatInfo[0].m_audioChannels = 2
259 0405104831: Debug (avc_plug.cpp)[ 486] discoverSupportedStreamFormats: [ASU Ext Audio Input 9/10:5] formatInfo[0].m_midiChannels = 0
260 0405110420: Debug (avc_subunit.cpp)[ 194] discoverPlugs: plug 'ASU Ext Audio Input 9/10' found
261 0405110442: Debug (avc_subunit.cpp)[ 169] discoverPlugs: Discovering plugs for direction 1...
262 0405110463: Debug (avc_plug.cpp)[  75] Plug: nodeId = 1, subunitType = 1, subunitId = 0, functionBlockType = 255, functionBlockId = 255, addressType = 3, direction = 1, id = 0
263 0405110477: Debug (bebob_avplug.cpp)[  64] Plug: nodeId = 1, subunitType = 1, subunitId = 0, functionBlockType = 255, functionBlockId = 255, addressType = 3, direction = 1, id = 0
264 0405115508: Debug (bebob_avplug.cpp)[ 178] discoverPlugType: plug 0 is of type 0 (IsoStream)
265 0405120931: Debug (bebob_avplug.cpp)[ 237] discoverName: plug 0 has name 'ASU Ext Audio Output 1/2'
266 0405125750: Debug (bebob_avplug.cpp)[ 270] discoverNoOfChannels: plug 0 has 2 channels
267 0405131292: Debug (bebob_avplug.cpp)[ 305] discoverChannelPosition: plug 0: channel position information retrieved
268 0405131313: Debug (avc_plug.cpp)[1111] debugOutputClusterInfos: number of channels: 2
269 0405131325: Debug (avc_plug.cpp)[1122] debugOutputClusterInfos: stream position: 0
270 0405131337: Debug (avc_plug.cpp)[1125] debugOutputClusterInfos: location: 1
271 0405131348: Debug (avc_plug.cpp)[1122] debugOutputClusterInfos: stream position: 1
272 0405131360: Debug (avc_plug.cpp)[1125] debugOutputClusterInfos: location: 2
273 0405136613: Debug (bebob_avplug.cpp)[ 399] discoverChannelName: plug 0 stream position 0: channel name = SpdifIn left
274 0405141988: Debug (bebob_avplug.cpp)[ 399] discoverChannelName: plug 0 stream position 1: channel name = SpdifIn right
275 0405147124: Debug (bebob_avplug.cpp)[ 460] discoverClusterInfo: ASU Ext Audio Output 1/2 plug 0: cluster index = 1, portType SPDIF, cluster name = SpdifIn
276 0405153931: Debug (avc_plug.cpp)[ 323] discoverStreamFormat: ASU Ext Audio Output 1/2 plug 0 uses sampling frequency 4, nr of stream infos = 1
277 0405153962: Debug (avc_plug.cpp)[ 344] discoverStreamFormat: number of channels = 2, stream format = 6
278 0405153975: Debug (avc_plug.cpp)[ 375] discoverStreamFormat: ASU Ext Audio Output 1/2 plug 0 cluster info 1 ('SpdifIn'): stream format 6
279 0405161573: Debug (avc_plug.cpp)[ 474] discoverSupportedStreamFormats: [ASU Ext Audio Output 1/2:0] formatInfo[0].m_samplingFrequency = 4
280 0405161597: Debug (avc_plug.cpp)[ 478] discoverSupportedStreamFormats: [ASU Ext Audio Output 1/2:0] formatInfo[0].m_isSyncStream = 0
281 0405161611: Debug (avc_plug.cpp)[ 482] discoverSupportedStreamFormats: [ASU Ext Audio Output 1/2:0] formatInfo[0].m_audioChannels = 2
282 0405161627: Debug (avc_plug.cpp)[ 486] discoverSupportedStreamFormats: [ASU Ext Audio Output 1/2:0] formatInfo[0].m_midiChannels = 0
283 0405167570: Debug (avc_subunit.cpp)[ 194] discoverPlugs: plug 'ASU Ext Audio Output 1/2' found
284 0405167589: Debug (bebob_avdevice_subunit.cpp)[ 132] discoverFunctionBlocks: Discovering function blocks...
285 0405181326: Debug (bebob_avdevice_subunit.cpp)[ 285] createFunctionBlock: Found a processing subfunction (type 129) which is not supported. It will be ignored.
286 0405181353: Debug (bebob_avdevice_subunit.cpp)[ 285] createFunctionBlock: Found a processing subfunction (type 129) which is not supported. It will be ignored.
287 0405181365: Debug (bebob_avdevice_subunit.cpp)[ 285] createFunctionBlock: Found a processing subfunction (type 129) which is not supported. It will be ignored.
288 0405181377: Debug (bebob_avdevice_subunit.cpp)[ 285] createFunctionBlock: Found a processing subfunction (type 129) which is not supported. It will be ignored.
289 0405181389: Debug (bebob_avdevice_subunit.cpp)[ 285] createFunctionBlock: Found a processing subfunction (type 129) which is not supported. It will be ignored.
290 0405189399: Debug (avc_unit.cpp)[ 246] enumerateSubUnits: subunit_id =  0, subunit_type = 12 (Music)
291 0405189439: Debug (avc_subunit.cpp)[  72] setVerboseLevel: Setting verbose level to 6...
292 0405189453: Debug (avc_subunit.cpp)[  72] setVerboseLevel: Setting verbose level to 6...
293 0405189465: Debug (bebob_avdevice_subunit.cpp)[ 449] discover: Discovering BeBoB::MusicSubunit...
294 0405189477: Debug (avc_musicsubunit.cpp)[  64] discover: Discovering BeBoB::MusicSubunit...
295 0405189489: Debug (avc_subunit.cpp)[ 108] discoverPlugs: Discovering plugs...
296 0405196110: Debug (avc_subunit.cpp)[ 124] discoverPlugs: number of source plugs = 8
297 0405196133: Debug (avc_subunit.cpp)[ 126] discoverPlugs: number of destination output plugs = 9
298 0405196154: Debug (avc_subunit.cpp)[ 169] discoverPlugs: Discovering plugs for direction 0...
299 0405196171: Debug (avc_plug.cpp)[  75] Plug: nodeId = 1, subunitType = 12, subunitId = 0, functionBlockType = 255, functionBlockId = 255, addressType = 3, direction = 0, id = 0
300 0405196186: Debug (bebob_avplug.cpp)[  64] Plug: nodeId = 1, subunitType = 12, subunitId = 0, functionBlockType = 255, functionBlockId = 255, addressType = 3, direction = 0, id = 0
301 0405198711: Error (bebob_avplug.cpp)[ 160] discoverPlugType: plug type command failed
302 0405198732: Error (bebob_avplug.cpp)[  88] discover: discover: Could not discover plug type (1,12,0,0,0)
303 0405198746: Error (avc_subunit.cpp)[ 189] discoverPlugs: plug discover failed
304 0405198757: Error (avc_subunit.cpp)[ 131] discoverPlugs: destination plug discovering failed
305 0405198769: Error (avc_subunit.cpp)[  99] discover: plug discovery failed
306 0405198781: Error (avc_unit.cpp)[ 286] enumerateSubUnits: enumerateSubUnits: Could not discover subunit_id =  0, subunit_type = 12 (Music)
307 0405198807: Error (avc_unit.cpp)[ 178] discover: Could not enumarate sub units
308 0405198820: Error (bebob_avdevice.cpp)[ 145] discover: Could not discover unit
309 0405198845: Error (devicemanager.cpp)[ 521] discover: could not discover device
310 0405198897: Debug (Element.cpp)[ 224] deleteElement: Deleting Element ConfigRom from 0040ab0000c2184b
311 0405198918: Debug (Element.cpp)[ 224] deleteElement: Deleting Element Generic from 0040ab0000c2184b
312 0405198932: Debug (Element.cpp)[ 224] deleteElement: Deleting Element ClockSelect from Generic
313 0405198948: Debug (Element.cpp)[ 224] deleteElement: Deleting Element Nickname from Generic
314 0405198972: Debug (devicemanager.cpp)[ 551] discover: Discovery finished...
315 0405198986: Debug (devicemanager.cpp)[1026] showDeviceInfo: ===== Device Manager =====
316 0405198998: Debug (Element.cpp)[ 103] show: Element DeviceManager
317 0405199027: Debug (devicemanager.cpp)[1034] showDeviceInfo: --- IEEE1394 Service  0 ---
318 0405199047: Debug (ieee1394service.cpp)[1129] show: Port:  0
319 0405199059: Debug (ieee1394service.cpp)[1130] show:  Name: ohci1394
320 0405199071: Debug (ieee1394service.cpp)[1132] show:  CycleTimerHelper: 0x80726d0, IsoManager: 0x8072690, WatchDog: 0x8072838
321 0405199084: Debug (ieee1394service.cpp)[1137] show:  Time: 00786101360 (031s 7892cy 1136ticks)
322 Iso handler info:
323 Dumping IsoHandlerManager Stream handler information...
324  State: 2
325 0405199127: Fatal (ffado.cpp)[ 167] ffado_streaming_init: There are no devices on the bus
326 0405199144: Debug (IsoHandlerManager.cpp)[ 919] stopHandlers: enter...
327 0405199150: Debug (IsoHandlerManager.cpp)[ 783] pruneHandlers: enter...
328 0405199156: Debug (PosixThread.cpp)[ 169] Stop: PosixThread::Stop 0x8079090 (thread: 0xb436bb90)
329 0405205848: Debug (PosixThread.cpp)[  86] ThreadHandler: ThreadHandler: exit 0x8079090
330 0405205918: Debug (PosixThread.cpp)[ 173] Stop: PosixThread::Stopped 0x8079090 (thread: 0xb436bb90)
331 0405205935: Debug (PosixThread.cpp)[ 169] Stop: PosixThread::Stop 0x80791a8 (thread: 0xb3b6ab90)
332 0405207794: Debug (PosixThread.cpp)[  86] ThreadHandler: ThreadHandler: exit 0x80791a8
333 0405207820: Debug (PosixThread.cpp)[ 173] Stop: PosixThread::Stopped 0x80791a8 (thread: 0xb3b6ab90)
334 0405207839: Debug (PosixThread.cpp)[ 169] Stop: PosixThread::Stop 0x8078eb8 (thread: 0xb4b6cb90)
335 0405251978: Debug (PosixThread.cpp)[  86] ThreadHandler: ThreadHandler: exit 0x8078eb8
336 0405252076: Debug (PosixThread.cpp)[ 173] Stop: PosixThread::Stopped 0x8078eb8 (thread: 0xb4b6cb90)
337 0405252125: Debug (ieee1394service.cpp)[ 842] remBusResetHandler: Removing busreset handler (0x8078f78)
338 0405252141: Debug (ieee1394service.cpp)[ 849] remBusResetHandler:  found
339 0405252279: Debug (PosixThread.cpp)[ 155] Kill: PosixThread::Kill 0x80728d0 (thread: 0xb536db90)
340 0405252853: Debug (PosixThread.cpp)[ 159] Kill: PosixThread::Killed 0x80728d0 (thread: 0xb536db90)
341 0405252861: Debug (PosixThread.cpp)[ 155] Kill: PosixThread::Kill 0x8072890 (thread: 0xb5b6eb90)
342 0405253407: Debug (PosixThread.cpp)[ 159] Kill: PosixThread::Killed 0x8072890 (thread: 0xb5b6eb90)
343 firewire ERR: Error creating FFADO streaming device
344 cannot load driver module firewire
345 no message buffer overruns
346 no message buffer overruns
347