[AG-DEV] Custom Node Service Enabling/Disabling Problem
Thomas D. Uram
turam at mcs.anl.gov
Fri Aug 11 10:27:30 CDT 2006
I think services need to inform their callers if an exception occurs.
If they don't,
the 'distributed system' model falls apart, because errors will be
silenced. We
don't handle such errors entirely properly. Yet. AG3.0.2 does continue
to update
services if one of them raises an exception, whereas previously one
failure would
have caused the entire update process to stop. Beyond this improved
behavior,
I'd like for the application to notify the user of problems that occur.
So far, my
plan for this has been for these to appear in some 'user message
notification'
mechanism on the venueclient, which might also allow the user to take some
action (e.g., the audio service has stopped; would you like to restart
it? once or
every time?). Feedback here is welcome.
The error in this case (I've outlined it in a separate response) was due
to a
bad default value in the Capability class.
As for extensibility, we've tried to make all types passed around on the
network
extensible. You should be able to pass around StreamDescriptions with
additional
attributes without causing any problems; if you remove or modify an existing
attribute, you will likely run into problems. _We_ need this
extensibility to
be able to expand the toolkit code going forward, but we also knew that it
would be important to service and app developers, too.
Tom
On 8/10/06 2:55 PM, Brian Corrie wrote:
> Hi All,
>
> An interesting topic this...
>
> One questions is what is the correct behaviour when a Service gets a
> stream description it doesn't expect??? Should it throw an exception?
> Should it ignore it? Not sure what the currently intended model is for
> the AG 3.x implementation... Tom???
>
> One of the things that it would be nice to be able to do is to make a
> StreamDescription extensible. That is, as the creator of a new service
> one may want to send stream descriptions that don't fit the current
> definition. It would be nice if this was possible and that the low
> level service classes didn't throw exceptions when this occurs (I
> think this is what is happening here). Leave it up to the
> implementations of the services to throw exceptions if they can't
> handle the Stream description.
>
> Not sure if my description is clear, but this is something that Todd
> and I have talked about a couple of times...
>
> Is that possible/reasonable/feasible?
>
> Brian
>
>
> Todd Zimmerman wrote:
>> Sorry for the spam - but just realized that it looks like this issue
>> was identified and a fix was
>> made by Michael Braitmaier.
>>
>> The problem was the default None values of rate and code in the
>> Capabilities class. Michael made
>> the default value of codec = "" and rate = 0 - which allows the match
>> function to properly check for
>> matches. This seems to alleviate the issue - but does it raise any
>> other problems??
>>
>> Cheers,
>>
>> Todd
>>
>> Todd Zimmerman wrote:
>>> one more time WITH the logfiles... ;-)
>>>
>>> Todd Zimmerman wrote:
>>>> Oh... I sent them to ag-dev yesterday...
>>>>
>>>> Here's a resend.
>>>>
>>>>
>>>> Looks like the relevent section is:
>>>>
>>>>
>>>> 08/09/2006 11:15:40 AM -1208600896 NodeManagementUIClasses
>>>> NodeManagementUIClasses.py:1043 ERROR
>>>> Error enabling service
>>>> Traceback (most recent call last):
>>>> File
>>>> "/usr/lib/python2.4/site-packages/AccessGrid3/AccessGrid/NodeManagementUIClasses.py",
>>>> line
>>>> 1037, in EnableService
>>>> self.nodeServiceHandle.SetServiceEnabled(service.uri, 1)
>>>> File
>>>> "/usr/lib/python2.4/site-packages/AccessGrid/AGNodeService.py",
>>>> line 278, in SetServiceEnabled
>>>> self.__SendStreamsToService( serviceUri )
>>>> File
>>>> "/usr/lib/python2.4/site-packages/AccessGrid/AGNodeService.py",
>>>> line 723, in
>>>> __SendStreamsToService
>>>> raise SetStreamException(failedSends)
>>>> SetStreamException: Error updating [producer, debug, None, None,
>>>> None, 1, consumer, debug, None,
>>>> None, None, 1]
>>>>
>>>>
>>>>
>>>> Cheers,
>>>>
>>>> Todd
>>>>
>>>> Thomas D. Uram wrote:
>>>>> Any details from logfile?
>>>>>
>>>>>
>>>>>
>>>>> On 8/9/06 1:59 PM, Todd Zimmerman wrote:
>>>>>> Thomas D. Uram wrote:
>>>>>>
>>>>>>
>>>>>>> Also, which platform?
>>>>>>>
>>>>>> Fedora Core 5 running AccessGrid-3.0.2-0.1.20060727cvs
>>>>>>
>>>>>> Cheers,
>>>>>>
>>>>>>
>>>>>> Todd
>>>>>>
>>>>>>
>>>>>>
>>>>>>
>>>>>> ------------------------------------------------------------------------
>>>>>>
>>>>>>
>>>>>> 08/09/06 11:15:07 -1208117568 Toolkit Config.py:559 DEBUG
>>>>>> System hostname of floyd.irmacs.sfu.ca is valid
>>>>>> 08/09/06 11:15:07 -1208117568 Toolkit Toolkit.py:111 DEBUG
>>>>>> Initializing AG Toolkit version 3.0.2
>>>>>> 08/09/06 11:15:07 -1208117568 Toolkit Toolkit.py:112 INFO
>>>>>> Command and arguments:
>>>>>> ['/data/tz/.AccessGrid3/local_services/DebugService/DebugService.py',
>>>>>> '--port', '64864', '--serviceManagerUri',
>>>>>> 'http://floyd.irmacs.sfu.ca:11000/ServiceManager', '--token',
>>>>>> '8e3a358332f86536e976086dbec2c57f']
>>>>>> 08/09/06 11:15:07 -1208117568 VenueClient Preferences.py:180
>>>>>> DEBUG Preferences.LoadPreferences: open file
>>>>>> 08/09/06 11:15:07 -1208117568 Toolkit Toolkit.py:161 INFO
>>>>>> Logfile Name: DebugService.log
>>>>>> 08/09/06 11:15:07 -1208117568 Toolkit Toolkit.py:650 INFO
>>>>>> Service init: have profile None
>>>>>> 08/09/06 11:15:07 -1208117568 Toolkit Toolkit.py:675 INFO
>>>>>> Service Initialization Complete.
>>>>>> 08/09/06 11:15:07 -1208117568 Toolkit AGService.py:363 INFO
>>>>>> Starting Service URI:
>>>>>> http://floyd.irmacs.sfu.ca:64864/Services/DebugService.8e3a3583333a6536e9540206adb5e731
>>>>>>
>>>>>> 08/09/06 11:15:07 -1208117568 Toolkit AGService.py:373 DEBUG
>>>>>> Registering with service manager;
>>>>>> url=http://floyd.irmacs.sfu.ca:11000/ServiceManager
>>>>>> 08/09/06 11:15:07 -1225385056 Toolkit DebugService.py:68
>>>>>> INFO SetIdentity method called
>>>>>> 08/09/06 11:15:12 -1225385056 Toolkit AGService.py:214 INFO
>>>>>> AGService.SetEnabled : enabled = 0
>>>>>> 08/09/06 11:15:12 -1225385056 Toolkit AGService.py:220 INFO
>>>>>> Stopping service
>>>>>> 08/09/06 11:15:12 -1225385056 Toolkit DebugService.py:50
>>>>>> INFO Stop method called
>>>>>> 08/09/06 11:15:14 -1225385056 Toolkit AGService.py:214 INFO
>>>>>> AGService.SetEnabled : enabled = 1
>>>>>> 08/09/06 11:15:15 -1225385056 Toolkit AGService.py:214 INFO
>>>>>> AGService.SetEnabled : enabled = 0
>>>>>> 08/09/06 11:15:15 -1225385056 Toolkit AGService.py:220 INFO
>>>>>> Stopping service
>>>>>> 08/09/06 11:15:15 -1225385056 Toolkit DebugService.py:50
>>>>>> INFO Stop method called
>>>>>> 08/09/06 11:15:17 -1225385056 Toolkit AGService.py:214 INFO
>>>>>> AGService.SetEnabled : enabled = 1
>>>>>> 08/09/06 11:15:23 -1225385056 Toolkit DebugService.py:50
>>>>>> INFO Stop method called
>>>>>> 08/09/06 11:15:30 -1225385056 Toolkit AGService.py:214 INFO
>>>>>> AGService.SetEnabled : enabled = 0
>>>>>> 08/09/06 11:15:30 -1225385056 Toolkit AGService.py:220 INFO
>>>>>> Stopping service
>>>>>> 08/09/06 11:15:30 -1225385056 Toolkit DebugService.py:50
>>>>>> INFO Stop method called
>>>>>> 08/09/06 11:15:38 -1225385056 Toolkit AGService.py:214 INFO
>>>>>> AGService.SetEnabled : enabled = 0
>>>>>> 08/09/06 11:15:38 -1225385056 Toolkit AGService.py:220 INFO
>>>>>> Stopping service
>>>>>> 08/09/06 11:15:38 -1225385056 Toolkit DebugService.py:50
>>>>>> INFO Stop method called
>>>>>> 08/09/06 11:15:55 -1225385056 Toolkit DebugService.py:50
>>>>>> INFO Stop method called
>>>>>> 08/09/06 11:15:58 -1225385056 Toolkit AGService.py:238 INFO
>>>>>> Shut service down
>>>>>> 08/09/06 11:15:58 -1225385056 Toolkit DebugService.py:50
>>>>>> INFO Stop method called
>>>>>> 08/09/06 11:15:58 -1208117568 Toolkit AGService.py:238 INFO
>>>>>> Shut service down
>>>>>> 08/09/06 11:15:58 -1208117568 Toolkit DebugService.py:50
>>>>>> INFO Stop method called
>>>>>>
>>>>>> ------------------------------------------------------------------------
>>>>>>
>>>>>>
>>>>>> 08/09/2006 11:14:55 AM -1208600896 VenueClientController
>>>>>> VenueClientController.py:432 DEBUG VenueClientController calling
>>>>>> Venue.EnterVenue
>>>>>> 08/09/2006 11:14:55 AM -1208600896 VenueClient
>>>>>> VenueClient.py:1015 DEBUG EnterVenue;
>>>>>> url=https://venueserver2.westgrid.ca:8000/Venues/default
>>>>>> 08/09/2006 11:14:55 AM -1208600896 NodeService
>>>>>> AGNodeService.py:658 INFO NodeService.GetCapabilities
>>>>>> 08/09/2006 11:14:55 AM -1208600896 NodeService
>>>>>> AGNodeService.py:257 INFO NodeService.GetServices
>>>>>> 08/09/2006 11:14:55 AM -1225692256 ServiceManager
>>>>>> AGServiceManager.py:218 INFO AGServiceManager.GetServices
>>>>>> 08/09/2006 11:14:55 AM -1208600896 VenueClient
>>>>>> VenueClient.py:1049 DEBUG calling __EnterVenue
>>>>>> 08/09/2006 11:14:55 AM -1208600896 VenueClient
>>>>>> VenueClient.py:806 DEBUG EnterVenue: Invoke Venue.Enter
>>>>>> 08/09/2006 11:14:55 AM -1208600896 VenueClient
>>>>>> VenueClient.py:808 DEBUG after Venue.Enter
>>>>>> 08/09/2006 11:14:55 AM -1208600896 VenueClient
>>>>>> VenueClient.py:810 DEBUG EnterVenue: Invoke Venue.getstate
>>>>>> 08/09/2006 11:14:56 AM -1208600896 VenueClient
>>>>>> VenueClient.py:812 DEBUG EnterVenue: done Venue.getstate
>>>>>> 08/09/2006 11:14:57 AM -1208600896 VenueClient
>>>>>> VenueClient.py:835 DEBUG Setting isInVenue flag.
>>>>>> 08/09/2006 11:14:57 AM -1208600896 VenueClient
>>>>>> VenueClient.py:1051 DEBUG after __EnterVenue
>>>>>> 08/09/2006 11:14:57 AM -1208600896 VenueClient
>>>>>> VenueClientUI.py:2577 DEBUG bin.VenueClient::EnterVenue: Enter
>>>>>> venue with url: https://venueserver2.westgrid.ca:8000/Venues/default
>>>>>> 08/09/2006 11:14:57 AM -1208600896 VenueClient
>>>>>> VenueClientUI.py:2690 DEBUG Entered venue
>>>>>> 08/09/2006 11:14:57 AM -1208600896 VenueClientController
>>>>>> VenueClientController.py:434 DEBUG VenueClientController after
>>>>>> Venue.EnterVenue
>>>>>> 08/09/2006 11:14:57 AM -1225692256 VenueClient
>>>>>> VenueClient.py:450 DEBUG Calling Heartbeat, time now: 1155147297
>>>>>> 08/09/2006 11:14:57 AM -1208600896 VenueClient
>>>>>> VenueClientUI.py:3324 DEBUG ContentListPanel.AddParticipant::
>>>>>> AddParticipant Todd Zimmerman (called from
>>>>>> ('/usr/lib/python2.4/site-packages/wx-2.6-gtk2-unicode/wx/_core.py',
>>>>>> 13535, '<lambda>', 'lambda event: event.callable(*event.args,
>>>>>> **event.kw) )'))
>>>>>> 08/09/2006 11:14:57 AM -1225692256 VenueClient
>>>>>> VenueClient.py:474 DEBUG Next Heartbeat needed within 36s
>>>>>> 08/09/2006 11:14:57 AM -1225692256 JabberClient
>>>>>> JabberClient.py:33 INFO Connecting to Jabber Server
>>>>>> 'jabber.mcs.anl.gov' ...
>>>>>> 08/09/2006 11:14:57 AM -1225692256 bajjer.io io.py:100 DEBUG
>>>>>> RECV: <?xml version='1.0'?><stream:stream
>>>>>> xmlns:stream='http://etherx.jabber.org/streams' id='44DA2621'
>>>>>> xmlns='jabber:client' from='jabber.mcs.anl.gov'>
>>>>>> 08/09/2006 11:14:57 AM -1225692256 bajjer.serialize
>>>>>> serialize.py:65 DEBUG feed parser initialized
>>>>>> 08/09/2006 11:14:57 AM -1225692256 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start
>>>>>> <{http://etherx.jabber.org/streams}stream> level=0
>>>>>> 08/09/2006 11:14:57 AM -1225692256 JabberClient
>>>>>> JabberClient.py:168 INFO Registering the user
>>>>>> '8180087163ff65364de2ad59cc6ba1e9 at jabber.mcs.anl.gov/default' in
>>>>>> jabber server ...
>>>>>> 08/09/2006 11:14:57 AM -1225692256 bajjer.io io.py:122 DEBUG
>>>>>> SEND: <iq type="get"><query xmlns="jabber:iq:register" /></iq>
>>>>>> 08/09/2006 11:14:57 AM -1225692256 bajjer.io io.py:161 DEBUG
>>>>>> RECV: <iq type='result'><query
>>>>>> xmlns='jabber:iq:register'><password/><password/>
>>>>>> <instructions>Choose a username and password to register
>>>>>> with this server.</instructions>
>>>>>> <name/>
>>>>>> <email/>
>>>>>> <username/></query></iq>
>>>>>> 08/09/2006 11:14:57 AM -1225692256 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start <{jabber:client}iq> level=1
>>>>>> 08/09/2006 11:14:57 AM -1225692256 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start <{jabber:iq:register}query> level=2
>>>>>> 08/09/2006 11:14:57 AM -1225692256 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start <{jabber:iq:register}password> level=3
>>>>>> 08/09/2006 11:14:57 AM -1225692256 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end <{jabber:iq:register}password> level=3
>>>>>> 08/09/2006 11:14:57 AM -1225692256 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start <{jabber:iq:register}password> level=3
>>>>>> 08/09/2006 11:14:57 AM -1225692256 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end <{jabber:iq:register}password> level=3
>>>>>> 08/09/2006 11:14:57 AM -1225692256 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start <{jabber:iq:register}instructions>
>>>>>> level=3
>>>>>> 08/09/2006 11:14:57 AM -1225692256 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end <{jabber:iq:register}instructions> level=3
>>>>>> 08/09/2006 11:14:57 AM -1225692256 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start <{jabber:iq:register}name> level=3
>>>>>> 08/09/2006 11:14:57 AM -1225692256 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end <{jabber:iq:register}name> level=3
>>>>>> 08/09/2006 11:14:57 AM -1225692256 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start <{jabber:iq:register}email> level=3
>>>>>> 08/09/2006 11:14:57 AM -1225692256 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end <{jabber:iq:register}email> level=3
>>>>>> 08/09/2006 11:14:57 AM -1225692256 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start <{jabber:iq:register}username> level=3
>>>>>> 08/09/2006 11:14:57 AM -1225692256 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end <{jabber:iq:register}username> level=3
>>>>>> 08/09/2006 11:14:57 AM -1225692256 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end <{jabber:iq:register}query> level=2
>>>>>> 08/09/2006 11:14:57 AM -1225692256 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end <{jabber:client}iq> level=1
>>>>>> 08/09/2006 11:14:57 AM -1225692256 bajjer.io io.py:122 DEBUG
>>>>>> SEND: <iq type="set"><query
>>>>>> xmlns="jabber:iq:register"><username>8180087163ff65364de2ad59cc6ba1e9</username><password>8180087163ff65364de2ad59cc6ba1e9</password></query></iq>
>>>>>>
>>>>>> 08/09/2006 11:14:58 AM -1225692256 bajjer.io io.py:161 DEBUG
>>>>>> RECV: <iq type='result'/>
>>>>>> 08/09/2006 11:14:58 AM -1225692256 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start <{jabber:client}iq> level=1
>>>>>> 08/09/2006 11:14:58 AM -1225692256 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end <{jabber:client}iq> level=1
>>>>>> 08/09/2006 11:14:58 AM -1208600896 GroupMsgClient
>>>>>> GroupMsgClient.py:112 INFO Connected. Connection ID:
>>>>>> 8180087163ff65364de2ad59cc6ba1e9
>>>>>> 08/09/2006 11:14:58 AM -1208600896 EventClient
>>>>>> InsecureVenueEventClient.py:60 INFO BaseVenueEventClient made
>>>>>> connection.
>>>>>> 08/09/2006 11:14:59 AM -1225692256 JabberClient
>>>>>> JabberClient.py:177 INFO Attempting to log in as
>>>>>> 8180087163ff65364de2ad59cc6ba1e9 at jabber.mcs.anl.gov/default ...
>>>>>> 08/09/2006 11:14:59 AM -1225692256 bajjer.io io.py:122 DEBUG
>>>>>> SEND: <iq type="get"><query
>>>>>> xmlns="jabber:iq:auth"><username>8180087163ff65364de2ad59cc6ba1e9</username></query></iq>
>>>>>>
>>>>>> 08/09/2006 11:14:59 AM -1225692256 bajjer.io io.py:161 DEBUG
>>>>>> RECV: <iq type='result'><query
>>>>>> xmlns='jabber:iq:auth'><username>8180087163ff65364de2ad59cc6ba1e9</username><digest/><password/><resource/></query></iq>
>>>>>>
>>>>>> 08/09/2006 11:14:59 AM -1225692256 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start <{jabber:client}iq> level=1
>>>>>> 08/09/2006 11:14:59 AM -1225692256 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start <{jabber:iq:auth}query> level=2
>>>>>> 08/09/2006 11:14:59 AM -1225692256 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start <{jabber:iq:auth}username> level=3
>>>>>> 08/09/2006 11:14:59 AM -1225692256 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end <{jabber:iq:auth}username> level=3
>>>>>> 08/09/2006 11:14:59 AM -1225692256 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start <{jabber:iq:auth}digest> level=3
>>>>>> 08/09/2006 11:14:59 AM -1225692256 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end <{jabber:iq:auth}digest> level=3
>>>>>> 08/09/2006 11:14:59 AM -1225692256 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start <{jabber:iq:auth}password> level=3
>>>>>> 08/09/2006 11:14:59 AM -1225692256 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end <{jabber:iq:auth}password> level=3
>>>>>> 08/09/2006 11:14:59 AM -1225692256 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start <{jabber:iq:auth}resource> level=3
>>>>>> 08/09/2006 11:14:59 AM -1225692256 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end <{jabber:iq:auth}resource> level=3
>>>>>> 08/09/2006 11:14:59 AM -1225692256 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end <{jabber:iq:auth}query> level=2
>>>>>> 08/09/2006 11:14:59 AM -1225692256 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end <{jabber:client}iq> level=1
>>>>>> 08/09/2006 11:14:59 AM -1225692256 bajjer.stream
>>>>>> stream.py:326 DEBUG Recv: <gov.lbl.dsd.bajjer.stanza.Iq object at
>>>>>> 0xb46c2dcc>
>>>>>> 08/09/2006 11:14:59 AM -1225692256 bajjer.stream
>>>>>> stream.py:342 DEBUG performing 'digest' authentication
>>>>>> 08/09/2006 11:14:59 AM -1225692256 bajjer.io io.py:122 DEBUG
>>>>>> SEND: <iq type="set"><query
>>>>>> xmlns="jabber:iq:auth"><resource>default</resource><username>8180087163ff65364de2ad59cc6ba1e9</username><digest>cf40bb3969d2778217e87b01c0948d0cf96ec019</digest></query></iq>
>>>>>>
>>>>>> 08/09/2006 11:14:59 AM -1225692256 bajjer.io io.py:161 DEBUG
>>>>>> RECV: <iq type='result' id='pthsock_client_auth_ID'/>
>>>>>> 08/09/2006 11:14:59 AM -1225692256 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start <{jabber:client}iq> level=1
>>>>>> 08/09/2006 11:14:59 AM -1225692256 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end <{jabber:client}iq> level=1
>>>>>> 08/09/2006 11:14:59 AM -1225692256 bajjer.stream
>>>>>> stream.py:351 DEBUG Authorization succeeded
>>>>>> 08/09/2006 11:14:59 AM -1225692256 bajjer.io io.py:122 DEBUG
>>>>>> SEND: <iq from="8180087163ff65364de2ad59cc6ba1e9"
>>>>>> type="get"><query xmlns="jabber:iq:roster" /></iq>
>>>>>> 08/09/2006 11:14:59 AM -1225692256 bajjer.io io.py:161 DEBUG
>>>>>> RECV: <iq
>>>>>> from='8180087163ff65364de2ad59cc6ba1e9 at jabber.mcs.anl.gov/default'
>>>>>> type='result'><query xmlns='jabber:iq:roster'/></iq>
>>>>>> 08/09/2006 11:14:59 AM -1225692256 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start <{jabber:client}iq> level=1
>>>>>> 08/09/2006 11:14:59 AM -1225692256 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start <{jabber:iq:roster}query> level=2
>>>>>> 08/09/2006 11:14:59 AM -1225692256 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end <{jabber:iq:roster}query> level=2
>>>>>> 08/09/2006 11:14:59 AM -1225692256 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end <{jabber:client}iq> level=1
>>>>>> 08/09/2006 11:14:59 AM -1225692256 bajjer.io io.py:122 DEBUG
>>>>>> SEND: <presence />
>>>>>> 08/09/2006 11:14:59 AM -1225692256 JabberClient
>>>>>> JabberClient.py:73 DEBUG Sending the presence to
>>>>>> 'Main-Lobby(venueserver2.westgrid.ca)@conference.mcs.anl.gov/Todd
>>>>>> Zimmerman' of type 'available'...
>>>>>> 08/09/2006 11:14:59 AM -1225692256 bajjer.io io.py:122 DEBUG
>>>>>> SEND: <presence
>>>>>> to="Main-Lobby(venueserver2.westgrid.ca)@conference.mcs.anl.gov/Todd
>>>>>> Zimmerman" type="available"><x /></presence>
>>>>>> 08/09/2006 11:14:59 AM -1225692256 VenueClient
>>>>>> VenueClient.py:959 INFO VenueClient.StartBeacon: Address
>>>>>> 233.59.192.88/49482
>>>>>> 08/09/2006 11:14:59 AM -1225692256 RTPBeacon RTPBeacon.py:278
>>>>>> DEBUG Called Start.
>>>>>> 08/09/2006 11:14:59 AM -1225692256 VenueClient
>>>>>> VenueClient.py:1231 INFO In UpdateStream: transport=unicast
>>>>>> 08/09/2006 11:14:59 AM -1345344608 bajjer.io io.py:161 DEBUG
>>>>>> RECV: <message from='jabber.mcs.anl.gov'
>>>>>> to='8180087163ff65364de2ad59cc6ba1e9 at jabber.mcs.anl.gov'>
>>>>>> <subject>Welcome!</subject>
>>>>>> <body>Welcome to the Access Grid Jabber server @
>>>>>> jabber.mcs.anl.gov -- we hope you enjoy this service! For
>>>>>> information about how to use Jabber, visit the Jabber User's
>>>>>> Guide at http://jabbermanual.jabberstudio.org/</body>
>>>>>> <x xmlns='jabber:x:delay'
>>>>>> from='8180087163ff65364de2ad59cc6ba1e9 at jabber.mcs.anl.gov'
>>>>>> stamp='20060809T18:14:57'>Offline Storage</x></message>
>>>>>> 08/09/2006 11:14:59 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start <{jabber:client}message> level=1
>>>>>> 08/09/2006 11:14:59 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start <{jabber:client}subject> level=2
>>>>>> 08/09/2006 11:14:59 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end <{jabber:client}subject> level=2
>>>>>> 08/09/2006 11:14:59 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start <{jabber:client}body> level=2
>>>>>> 08/09/2006 11:14:59 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end <{jabber:client}body> level=2
>>>>>> 08/09/2006 11:14:59 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start <{jabber:x:delay}x> level=2
>>>>>> 08/09/2006 11:14:59 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end <{jabber:x:delay}x> level=2
>>>>>> 08/09/2006 11:14:59 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end <{jabber:client}message> level=1
>>>>>> 08/09/2006 11:14:59 AM -1345344608 JabberClient
>>>>>> JabberClient.py:133 DEBUG jabber.mcs.anl.go: Welcome to the
>>>>>> Access Grid Jabber server @ jabber.mcs.anl.gov -- we hope you
>>>>>> enjoy this service! For information about how to use Jabber,
>>>>>> visit the Jabber User's Guide at
>>>>>> http://jabbermanual.jabberstudio.org/
>>>>>> 08/09/2006 11:14:59 AM -1225692256 VenueClient
>>>>>> VenueClient.py:1260 DEBUG Got location from bridge: unicast
>>>>>> milton.mcs.anl.gov 53768
>>>>>> 08/09/2006 11:14:59 AM -1225692256 VenueClient
>>>>>> VenueClient.py:1231 INFO In UpdateStream: transport=unicast
>>>>>> 08/09/2006 11:14:59 AM -1345344608 bajjer.io io.py:161 DEBUG
>>>>>> RECV: <presence
>>>>>> to='8180087163ff65364de2ad59cc6ba1e9 at jabber.mcs.anl.gov/default'
>>>>>> from='main-lobby(venueserver2.westgrid.ca)@conference.mcs.anl.gov/Todd
>>>>>> Zimmerman'><x/><x
>>>>>> xmlns='http://jabber.org/protocol/muc#user'><item
>>>>>> affiliation='none' role='participant'/></x></presence>
>>>>>> 08/09/2006 11:14:59 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start <{jabber:client}presence> level=1
>>>>>> 08/09/2006 11:14:59 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start <{jabber:client}x> level=2
>>>>>> 08/09/2006 11:14:59 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end <{jabber:client}x> level=2
>>>>>> 08/09/2006 11:14:59 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start
>>>>>> <{http://jabber.org/protocol/muc#user}x> level=2
>>>>>> 08/09/2006 11:14:59 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start
>>>>>> <{http://jabber.org/protocol/muc#user}item> level=3
>>>>>> 08/09/2006 11:14:59 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end
>>>>>> <{http://jabber.org/protocol/muc#user}item> level=3
>>>>>> 08/09/2006 11:14:59 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end
>>>>>> <{http://jabber.org/protocol/muc#user}x> level=2
>>>>>> 08/09/2006 11:14:59 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end <{jabber:client}presence> level=1
>>>>>> 08/09/2006 11:14:59 AM -1345344608 JabberClient
>>>>>> JabberClient.py:145 DEBUG
>>>>>> main-lobby(venueserver2.westgrid.ca)@conference.mcs.anl.gov/Todd
>>>>>> Zimmerman is available (None / None)
>>>>>> 08/09/2006 11:14:59 AM -1345344608 VenueClient
>>>>>> VenueClientUI.py:2299 DEBUG add user: Todd Zimmerman
>>>>>> 08/09/2006 11:14:59 AM -1345344608 bajjer.io io.py:161 DEBUG
>>>>>> RECV: <message type='groupchat'
>>>>>> to='8180087163ff65364de2ad59cc6ba1e9 at jabber.mcs.anl.gov/default'
>>>>>> from='main-lobby(venueserver2.westgrid.ca)@conference.mcs.anl.gov'><body>main-lobby(venueserver2.westgrid.ca)</body></message>
>>>>>>
>>>>>> 08/09/2006 11:14:59 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start <{jabber:client}message> level=1
>>>>>> 08/09/2006 11:14:59 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start <{jabber:client}body> level=2
>>>>>> 08/09/2006 11:14:59 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end <{jabber:client}body> level=2
>>>>>> 08/09/2006 11:14:59 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end <{jabber:client}message> level=1
>>>>>> 08/09/2006 11:14:59 AM -1345344608 JabberClient
>>>>>> JabberClient.py:133 DEBUG
>>>>>> main-lobby(venueserver2.westgrid.ca)@conference.mcs.anl.go:
>>>>>> main-lobby(venueserver2.westgrid.ca)
>>>>>> 08/09/2006 11:14:59 AM -1345344608 bajjer.io io.py:161 DEBUG
>>>>>> RECV: <message type='groupchat'
>>>>>> to='8180087163ff65364de2ad59cc6ba1e9 at jabber.mcs.anl.gov/default'
>>>>>> from='main-lobby(venueserver2.westgrid.ca)@conference.mcs.anl.gov'><body>This
>>>>>> room supports the MUC protocol.</body></message>
>>>>>> 08/09/2006 11:14:59 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start <{jabber:client}message> level=1
>>>>>> 08/09/2006 11:14:59 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start <{jabber:client}body> level=2
>>>>>> 08/09/2006 11:14:59 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end <{jabber:client}body> level=2
>>>>>> 08/09/2006 11:14:59 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end <{jabber:client}message> level=1
>>>>>> 08/09/2006 11:14:59 AM -1225692256 VenueClient
>>>>>> VenueClient.py:1260 DEBUG Got location from bridge: unicast
>>>>>> milton.mcs.anl.gov 52884
>>>>>> 08/09/2006 11:14:59 AM -1225692256 VenueClient
>>>>>> VenueClient.py:1231 INFO In UpdateStream: transport=unicast
>>>>>> 08/09/2006 11:14:59 AM -1345344608 bajjer.io io.py:161 DEBUG
>>>>>> RECV: <message type='groupchat'
>>>>>> from='main-lobby(venueserver2.westgrid.ca)@conference.mcs.anl.gov'
>>>>>> to='8180087163ff65364de2ad59cc6ba1e9 at jabber.mcs.anl.gov/default'><body>Todd
>>>>>> Zimmerman has joined this session</body></message>
>>>>>> 08/09/2006 11:14:59 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start <{jabber:client}message> level=1
>>>>>> 08/09/2006 11:14:59 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start <{jabber:client}body> level=2
>>>>>> 08/09/2006 11:14:59 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end <{jabber:client}body> level=2
>>>>>> 08/09/2006 11:14:59 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end <{jabber:client}message> level=1
>>>>>> 08/09/2006 11:14:59 AM -1345344608 JabberClient
>>>>>> JabberClient.py:133 DEBUG
>>>>>> main-lobby(venueserver2.westgrid.ca)@conference.mcs.anl.go: This
>>>>>> room supports the MUC protocol.
>>>>>> 08/09/2006 11:14:59 AM -1345344608 JabberClient
>>>>>> JabberClient.py:133 DEBUG
>>>>>> main-lobby(venueserver2.westgrid.ca)@conference.mcs.anl.go: Todd
>>>>>> Zimmerman has joined this session
>>>>>> 08/09/2006 11:14:59 AM -1225692256 VenueClient
>>>>>> VenueClient.py:1260 DEBUG Got location from bridge: unicast
>>>>>> milton.mcs.anl.gov 52844
>>>>>> 08/09/2006 11:14:59 AM -1225692256 RTPBeacon RTPBeacon.py:296
>>>>>> DEBUG Called Stop.
>>>>>> 08/09/2006 11:14:59 AM -1225692256 VenueClient
>>>>>> VenueClient.py:951 INFO Beacon being reconfigured, stopping
>>>>>> running beacon
>>>>>> 08/09/2006 11:14:59 AM -1225692256 RTPBeacon RTPBeacon.py:296
>>>>>> DEBUG Called Stop.
>>>>>> 08/09/2006 11:14:59 AM -1225692256 VenueClient
>>>>>> VenueClient.py:959 INFO VenueClient.StartBeacon: Address
>>>>>> milton.mcs.anl.gov/52844
>>>>>> 08/09/2006 11:14:59 AM -1225692256 RTPBeacon RTPBeacon.py:278
>>>>>> DEBUG Called Start.
>>>>>> 08/09/2006 11:14:59 AM -1225692256 VenueClient
>>>>>> VenueClient.py:1190 DEBUG UpdateNodeService: Method
>>>>>> UpdateNodeService called
>>>>>> 08/09/2006 11:14:59 AM -1225692256 VenueClient
>>>>>> VenueClient.py:1195 DEBUG Setting node service streams
>>>>>> 08/09/2006 11:14:59 AM -1225692256 NodeService
>>>>>> AGNodeService.py:328 INFO NodeService.SetStreams
>>>>>> 08/09/2006 11:14:59 AM -1225692256 NodeService
>>>>>> AGNodeService.py:257 INFO NodeService.GetServices
>>>>>> 08/09/2006 11:14:59 AM -1387304032 ServiceManager
>>>>>> AGServiceManager.py:218 INFO AGServiceManager.GetServices
>>>>>> 08/09/2006 11:15:00 AM -1225692256 NodeService
>>>>>> AGNodeService.py:695 INFO NodeService.__SendStreamsToService
>>>>>> 08/09/2006 11:15:00 AM -1366324320 RTPBeacon RTPBeacon.py:289
>>>>>> INFO RTPBeacon.UpdateThread exiting
>>>>>> 08/09/2006 11:15:00 AM -1225692256 NodeService
>>>>>> AGNodeService.py:699 DEBUG service capabilities: [consumer,
>>>>>> audio, 8e3a358333096536dec30af9596ae5ae, L16, 16000, 1, consumer,
>>>>>> audio, 8e3a358333096536dec30af9596ae5ae, L16, 8000, 1, consumer,
>>>>>> audio, 8e3a358333096536dec30af9596ae5ae, L8, 16000, 1, consumer,
>>>>>> audio, 8e3a358333096536dec30af9596ae5ae, L8, 8000, 1, consumer,
>>>>>> audio, 8e3a358333096536dec30af9596ae5ae, PCMU, 16000, 1,
>>>>>> consumer, audio, 8e3a358333096536dec30af9596ae5ae, PCMU, 8000, 1,
>>>>>> consumer, audio, 8e3a358333096536dec30af9596ae5ae, GSM, 16000, 1,
>>>>>> consumer, audio, 8e3a358333096536dec30af9596ae5ae, GSM, 8000, 1,
>>>>>> producer, audio, 8e3a358333096536dec30af9596ae5ae, L16, 16000, 1]
>>>>>> 08/09/2006 11:15:00 AM -1225692256 NodeService
>>>>>> AGNodeService.py:713 INFO Sending stream (type=[consumer, audio,
>>>>>> 8180087163ff629be0bebd48a1912f0f, L16, 16000, 1, consumer, audio,
>>>>>> 8180087163ff629be0bebd48a1912f0f, L16, 8000, 1, consumer, audio,
>>>>>> 8180087163ff629be0bebd48a1912f0f, L8, 16000, 1, consumer, audio,
>>>>>> 8180087163ff629be0bebd48a1912f0f, L8, 8000, 1, consumer, audio,
>>>>>> 8180087163ff629be0bebd48a1912f0f, PCMU, 16000, 1, consumer,
>>>>>> audio, 8180087163ff629be0bebd48a1912f0f, PCMU, 8000, 1, consumer,
>>>>>> audio, 8180087163ff629be0bebd48a1912f0f, GSM, 16000, 1, consumer,
>>>>>> audio, 8180087163ff629be0bebd48a1912f0f, GSM, 8000, 1]) to
>>>>>> service:
>>>>>> http://floyd.irmacs.sfu.ca:56488/Services/AudioService.8e3a358333096536decfdc29e8e7216d
>>>>>>
>>>>>> 08/09/2006 11:15:00 AM -1225692256 NodeService
>>>>>> AGNodeService.py:695 INFO NodeService.__SendStreamsToService
>>>>>> 08/09/2006 11:15:00 AM -1225692256 NodeService
>>>>>> AGNodeService.py:699 DEBUG service capabilities: [consumer,
>>>>>> video, 8e3a358333036536de76e51f5b703c18, H261, 90000, 1,
>>>>>> producer, video, 8e3a358333036536de76e51f5b703c18, H261, 90000, 1]
>>>>>> 08/09/2006 11:15:00 AM -1225692256 NodeService
>>>>>> AGNodeService.py:713 INFO Sending stream (type=[consumer, video,
>>>>>> 8180087163ff629be0bbbd489dcbd809, H261, 90000, 1]) to service:
>>>>>> http://floyd.irmacs.sfu.ca:62272/Services/VideoService.8e3a358333036536de95b64fe81b7c08
>>>>>>
>>>>>> 08/09/2006 11:15:00 AM -1225692256 VenueClient
>>>>>> VenueClient.py:914 DEBUG Updating client profile cache.
>>>>>> 08/09/2006 11:15:00 AM -1208600896 VenueClient
>>>>>> VenueClientUI.py:1291 DEBUG VenueClientFrame.ManageNodeCB: open
>>>>>> node management
>>>>>> 08/09/2006 11:15:00 AM -1208600896 VenueClient
>>>>>> VenueClientUI.py:1292 DEBUG nodeservice url:
>>>>>> <AccessGrid.AGNodeService.AGNodeService instance at 0xb6f3518c>
>>>>>> 08/09/2006 11:15:00 AM -1208600896 NodeService
>>>>>> AGNodeService.py:248 INFO NodeService.GetServiceManagers
>>>>>> 08/09/2006 11:15:00 AM -1225692256 ServiceManager
>>>>>> AGServiceManager.py:218 INFO AGServiceManager.GetServices
>>>>>> 08/09/2006 11:15:07 AM -1225692256 ServiceManager
>>>>>> AGServiceManager.py:102 INFO AGServiceManager.AddService
>>>>>> 08/09/2006 11:15:07 AM -1225692256 ServiceManager
>>>>>> AGServiceManager.py:339 INFO Installed service version: 1.1,
>>>>>> package version: 1.1
>>>>>> 08/09/2006 11:15:07 AM -1225692256 ServiceManager
>>>>>> AGServiceManager.py:374 DEBUG Executing service DebugService
>>>>>> 08/09/2006 11:15:07 AM -1225692256 ServiceManager
>>>>>> AGServiceManager.py:406 INFO Running Service; options:
>>>>>> ['/data/tz/.AccessGrid3/local_services/DebugService/DebugService.py',
>>>>>> '--port', 64864, '--serviceManagerUri',
>>>>>> 'http://floyd.irmacs.sfu.ca:11000/ServiceManager', '--token',
>>>>>> '8e3a358332f86536e976086dbec2c57f']
>>>>>> 08/09/2006 11:15:07 AM -1225692256 ServiceManager
>>>>>> AGServiceManager.py:418 INFO Service registered:
>>>>>> http://floyd.irmacs.sfu.ca:64864/Services/DebugService.8e3a3583333a6536e9540206adb5e731
>>>>>> 8e3a358332f86536e976086dbec2c57f
>>>>>> 08/09/2006 11:15:07 AM -1208600896 NodeManagementUIClasses
>>>>>> NodeManagementUIClasses.py:1000 INFO No resources for service
>>>>>> 08/09/2006 11:15:07 AM -1208600896 VenueClient
>>>>>> VenueClientUI.py:1933 INFO OnNodeActivity: got action: add_service
>>>>>> 08/09/2006 11:15:07 AM -1208600896 NodeService
>>>>>> AGNodeService.py:248 INFO NodeService.GetServiceManagers
>>>>>> 08/09/2006 11:15:07 AM -1225692256 ServiceManager
>>>>>> AGServiceManager.py:218 INFO AGServiceManager.GetServices
>>>>>> 08/09/2006 11:15:12 AM -1208600896 NodeService
>>>>>> AGNodeService.py:275 INFO NodeService.SetServiceEnabled
>>>>>> 08/09/2006 11:15:12 AM -1208600896 NodeService
>>>>>> AGNodeService.py:248 INFO NodeService.GetServiceManagers
>>>>>> 08/09/2006 11:15:12 AM -1225692256 ServiceManager
>>>>>> AGServiceManager.py:218 INFO AGServiceManager.GetServices
>>>>>> 08/09/2006 11:15:14 AM -1208600896 NodeManagementUIClasses
>>>>>> NodeManagementUIClasses.py:1036 DEBUG
>>>>>> NodeManagementClientFrame.EnableService: Enabling Service:
>>>>>> DebugService
>>>>>> 08/09/2006 11:15:14 AM -1208600896 NodeService
>>>>>> AGNodeService.py:275 INFO NodeService.SetServiceEnabled
>>>>>> 08/09/2006 11:15:14 AM -1208600896 NodeService
>>>>>> AGNodeService.py:695 INFO NodeService.__SendStreamsToService
>>>>>> 08/09/2006 11:15:14 AM -1208600896 NodeService
>>>>>> AGNodeService.py:699 DEBUG service capabilities: [producer,
>>>>>> debug, None, None, None, 1, consumer, debug, None, None, None, 1]
>>>>>> 08/09/2006 11:15:14 AM -1208600896 NodeService
>>>>>> AGNodeService.py:248 INFO NodeService.GetServiceManagers
>>>>>> 08/09/2006 11:15:14 AM -1225692256 ServiceManager
>>>>>> AGServiceManager.py:218 INFO AGServiceManager.GetServices
>>>>>> 08/09/2006 11:15:15 AM -1208600896 NodeService
>>>>>> AGNodeService.py:275 INFO NodeService.SetServiceEnabled
>>>>>> 08/09/2006 11:15:15 AM -1208600896 NodeService
>>>>>> AGNodeService.py:248 INFO NodeService.GetServiceManagers
>>>>>> 08/09/2006 11:15:15 AM -1225692256 ServiceManager
>>>>>> AGServiceManager.py:218 INFO AGServiceManager.GetServices
>>>>>> 08/09/2006 11:15:16 AM -1208600896 NodeManagementUIClasses
>>>>>> NodeManagementUIClasses.py:1036 DEBUG
>>>>>> NodeManagementClientFrame.EnableService: Enabling Service:
>>>>>> DebugService
>>>>>> 08/09/2006 11:15:17 AM -1208600896 NodeService
>>>>>> AGNodeService.py:275 INFO NodeService.SetServiceEnabled
>>>>>> 08/09/2006 11:15:17 AM -1208600896 NodeService
>>>>>> AGNodeService.py:695 INFO NodeService.__SendStreamsToService
>>>>>> 08/09/2006 11:15:17 AM -1208600896 NodeService
>>>>>> AGNodeService.py:699 DEBUG service capabilities: [producer,
>>>>>> debug, None, None, None, 1, consumer, debug, None, None, None, 1]
>>>>>> 08/09/2006 11:15:17 AM -1208600896 NodeService
>>>>>> AGNodeService.py:248 INFO NodeService.GetServiceManagers
>>>>>> 08/09/2006 11:15:17 AM -1225692256 ServiceManager
>>>>>> AGServiceManager.py:218 INFO AGServiceManager.GetServices
>>>>>> 08/09/2006 11:15:23 AM -1208600896 VenueClient
>>>>>> VenueClient.py:1132 INFO ExitVenue
>>>>>> 08/09/2006 11:15:23 AM -1208600896 VenueClient
>>>>>> VenueClient.py:1173 INFO ExitVenue: Stopping node services
>>>>>> 08/09/2006 11:15:23 AM -1208600896 NodeService
>>>>>> AGNodeService.py:301 INFO NodeService.StopServices
>>>>>> 08/09/2006 11:15:23 AM -1225692256 ServiceManager
>>>>>> AGServiceManager.py:225 INFO AGServiceManager.StopServices
>>>>>> 08/09/2006 11:15:24 AM -1208600896 NodeService
>>>>>> AGNodeService.py:328 INFO NodeService.SetStreams
>>>>>> 08/09/2006 11:15:24 AM -1208600896 NodeService
>>>>>> AGNodeService.py:257 INFO NodeService.GetServices
>>>>>> 08/09/2006 11:15:24 AM -1225692256 ServiceManager
>>>>>> AGServiceManager.py:218 INFO AGServiceManager.GetServices
>>>>>> 08/09/2006 11:15:24 AM -1208600896 NodeService
>>>>>> AGNodeService.py:695 INFO NodeService.__SendStreamsToService
>>>>>> 08/09/2006 11:15:24 AM -1208600896 NodeService
>>>>>> AGNodeService.py:699 DEBUG service capabilities: [consumer,
>>>>>> audio, 8e3a358333096536dec30af9596ae5ae, L16, 16000, 1, consumer,
>>>>>> audio, 8e3a358333096536dec30af9596ae5ae, L16, 8000, 1, consumer,
>>>>>> audio, 8e3a358333096536dec30af9596ae5ae, L8, 16000, 1, consumer,
>>>>>> audio, 8e3a358333096536dec30af9596ae5ae, L8, 8000, 1, consumer,
>>>>>> audio, 8e3a358333096536dec30af9596ae5ae, PCMU, 16000, 1,
>>>>>> consumer, audio, 8e3a358333096536dec30af9596ae5ae, PCMU, 8000, 1,
>>>>>> consumer, audio, 8e3a358333096536dec30af9596ae5ae, GSM, 16000, 1,
>>>>>> consumer, audio, 8e3a358333096536dec30af9596ae5ae, GSM, 8000, 1,
>>>>>> producer, audio, 8e3a358333096536dec30af9596ae5ae, L16, 16000, 1]
>>>>>> 08/09/2006 11:15:24 AM -1208600896 NodeService
>>>>>> AGNodeService.py:695 INFO NodeService.__SendStreamsToService
>>>>>> 08/09/2006 11:15:24 AM -1208600896 NodeService
>>>>>> AGNodeService.py:699 DEBUG service capabilities: [producer,
>>>>>> debug, None, None, None, 1, consumer, debug, None, None, None, 1]
>>>>>> 08/09/2006 11:15:24 AM -1208600896 NodeService
>>>>>> AGNodeService.py:695 INFO NodeService.__SendStreamsToService
>>>>>> 08/09/2006 11:15:24 AM -1208600896 NodeService
>>>>>> AGNodeService.py:699 DEBUG service capabilities: [consumer,
>>>>>> video, 8e3a358333036536de76e51f5b703c18, H261, 90000, 1,
>>>>>> producer, video, 8e3a358333036536de76e51f5b703c18, H261, 90000, 1]
>>>>>> 08/09/2006 11:15:25 AM -1208600896 VenueClient
>>>>>> VenueClient.py:1103 DEBUG ExitVenue: Stop event client obj
>>>>>> 08/09/2006 11:15:25 AM -1208600896 VenueClient
>>>>>> VenueClient.py:1105 DEBUG ExitVenue: Remove event client reference
>>>>>> 08/09/2006 11:15:25 AM -1208600896 VenueClient
>>>>>> VenueClient.py:1110 INFO ExitVenue: Stopping text client
>>>>>> 08/09/2006 11:15:25 AM -1208600896 JabberClient
>>>>>> JabberClient.py:73 DEBUG Sending the presence to
>>>>>> 'Main-Lobby(venueserver2.westgrid.ca)@conference.mcs.anl.gov/Todd
>>>>>> Zimmerman' of type 'unavailable'...
>>>>>> 08/09/2006 11:15:25 AM -1208600896 bajjer.io io.py:122 DEBUG
>>>>>> SEND: <presence
>>>>>> to="Main-Lobby(venueserver2.westgrid.ca)@conference.mcs.anl.gov/Todd
>>>>>> Zimmerman" type="unavailable"><x /></presence>
>>>>>> 08/09/2006 11:15:25 AM -1208600896 RTPBeacon RTPBeacon.py:296
>>>>>> DEBUG Called Stop.
>>>>>> 08/09/2006 11:15:25 AM -1208600896 VenueClientController
>>>>>> VenueClientController.py:432 DEBUG VenueClientController calling
>>>>>> Venue.EnterVenue
>>>>>> 08/09/2006 11:15:25 AM -1208600896 VenueClient
>>>>>> VenueClient.py:1015 DEBUG EnterVenue;
>>>>>> url=https://venueserver2.westgrid.ca:8000/Venues/8e3a35534ae01a166229939b5aed6d47
>>>>>>
>>>>>> 08/09/2006 11:15:25 AM -1208600896 NodeService
>>>>>> AGNodeService.py:658 INFO NodeService.GetCapabilities
>>>>>> 08/09/2006 11:15:25 AM -1208600896 NodeService
>>>>>> AGNodeService.py:257 INFO NodeService.GetServices
>>>>>> 08/09/2006 11:15:25 AM -1334854752 ServiceManager
>>>>>> AGServiceManager.py:218 INFO AGServiceManager.GetServices
>>>>>> 08/09/2006 11:15:25 AM -1345344608 bajjer.io io.py:161 DEBUG
>>>>>> RECV: <presence
>>>>>> to='8180087163ff65364de2ad59cc6ba1e9 at jabber.mcs.anl.gov/default'
>>>>>> type='unavailable'
>>>>>> from='main-lobby(venueserver2.westgrid.ca)@conference.mcs.anl.gov/Todd
>>>>>> Zimmerman'><x/><x
>>>>>> xmlns='http://jabber.org/protocol/muc#user'><item
>>>>>> affiliation='none' role='none'/></x></presence>
>>>>>> 08/09/2006 11:15:25 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start <{jabber:client}presence> level=1
>>>>>> 08/09/2006 11:15:25 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start <{jabber:client}x> level=2
>>>>>> 08/09/2006 11:15:25 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end <{jabber:client}x> level=2
>>>>>> 08/09/2006 11:15:25 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start
>>>>>> <{http://jabber.org/protocol/muc#user}x> level=2
>>>>>> 08/09/2006 11:15:25 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start
>>>>>> <{http://jabber.org/protocol/muc#user}item> level=3
>>>>>> 08/09/2006 11:15:25 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end
>>>>>> <{http://jabber.org/protocol/muc#user}item> level=3
>>>>>> 08/09/2006 11:15:25 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end
>>>>>> <{http://jabber.org/protocol/muc#user}x> level=2
>>>>>> 08/09/2006 11:15:25 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end <{jabber:client}presence> level=1
>>>>>> 08/09/2006 11:15:25 AM -1345344608 JabberClient
>>>>>> JabberClient.py:148 DEBUG
>>>>>> main-lobby(venueserver2.westgrid.ca)@conference.mcs.anl.gov/Todd
>>>>>> Zimmerman is unavailable (None / None)
>>>>>> 08/09/2006 11:15:25 AM -1345344608 VenueClient
>>>>>> VenueClientUI.py:2313 DEBUG remove user: Todd Zimmerman
>>>>>> 08/09/2006 11:15:25 AM -1208600896 VenueClient
>>>>>> VenueClient.py:1049 DEBUG calling __EnterVenue
>>>>>> 08/09/2006 11:15:25 AM -1208600896 VenueClient
>>>>>> VenueClient.py:806 DEBUG EnterVenue: Invoke Venue.Enter
>>>>>> 08/09/2006 11:15:25 AM -1376814176 RTPBeacon RTPBeacon.py:289
>>>>>> INFO RTPBeacon.UpdateThread exiting
>>>>>> 08/09/2006 11:15:25 AM -1208600896 VenueClient
>>>>>> VenueClient.py:808 DEBUG after Venue.Enter
>>>>>> 08/09/2006 11:15:25 AM -1208600896 VenueClient
>>>>>> VenueClient.py:810 DEBUG EnterVenue: Invoke Venue.getstate
>>>>>> 08/09/2006 11:15:26 AM -1208600896 VenueClient
>>>>>> VenueClient.py:812 DEBUG EnterVenue: done Venue.getstate
>>>>>> 08/09/2006 11:15:26 AM -1208600896 VenueClient
>>>>>> VenueClient.py:835 DEBUG Setting isInVenue flag.
>>>>>> 08/09/2006 11:15:26 AM -1208600896 VenueClient
>>>>>> VenueClient.py:1051 DEBUG after __EnterVenue
>>>>>> 08/09/2006 11:15:26 AM -1208600896 VenueClient
>>>>>> VenueClientUI.py:2577 DEBUG bin.VenueClient::EnterVenue: Enter
>>>>>> venue with url:
>>>>>> https://venueserver2.westgrid.ca:8000/Venues/8e3a35534ae01a166229939b5aed6d47
>>>>>>
>>>>>> 08/09/2006 11:15:26 AM -1208600896 VenueClient
>>>>>> VenueClientUI.py:2690 DEBUG Entered venue
>>>>>> 08/09/2006 11:15:26 AM -1208600896 VenueClientController
>>>>>> VenueClientController.py:434 DEBUG VenueClientController after
>>>>>> Venue.EnterVenue
>>>>>> 08/09/2006 11:15:26 AM -1376814176 VenueClient
>>>>>> VenueClient.py:450 DEBUG Calling Heartbeat, time now: 1155147326
>>>>>> 08/09/2006 11:15:26 AM -1208600896 VenueClient
>>>>>> VenueClientUI.py:3340 DEBUG ContentListPanel.RemoveParticipant:
>>>>>> Remove participant
>>>>>> 08/09/2006 11:15:26 AM -1208600896 VenueClient
>>>>>> VenueClientUI.py:3324 DEBUG ContentListPanel.AddParticipant::
>>>>>> AddParticipant Todd Zimmerman (called from
>>>>>> ('/usr/lib/python2.4/site-packages/wx-2.6-gtk2-unicode/wx/_core.py',
>>>>>> 13535, '<lambda>', 'lambda event: event.callable(*event.args,
>>>>>> **event.kw) )'))
>>>>>> 08/09/2006 11:15:27 AM -1376814176 VenueClient
>>>>>> VenueClient.py:474 DEBUG Next Heartbeat needed within 36s
>>>>>> 08/09/2006 11:15:27 AM -1376814176 JabberClient
>>>>>> JabberClient.py:73 DEBUG Sending the presence to
>>>>>> 'AG-Tech-Room(venueserver2.westgrid.ca)@conference.mcs.anl.gov/Todd
>>>>>> Zimmerman' of type 'available'...
>>>>>> 08/09/2006 11:15:27 AM -1376814176 bajjer.io io.py:122 DEBUG
>>>>>> SEND: <presence
>>>>>> to="AG-Tech-Room(venueserver2.westgrid.ca)@conference.mcs.anl.gov/Todd
>>>>>> Zimmerman" type="available"><x /></presence>
>>>>>> 08/09/2006 11:15:27 AM -1376814176 VenueClient
>>>>>> VenueClient.py:951 INFO Beacon being reconfigured, stopping
>>>>>> running beacon
>>>>>> 08/09/2006 11:15:27 AM -1376814176 RTPBeacon RTPBeacon.py:296
>>>>>> DEBUG Called Stop.
>>>>>> 08/09/2006 11:15:27 AM -1376814176 VenueClient
>>>>>> VenueClient.py:959 INFO VenueClient.StartBeacon: Address
>>>>>> 233.59.192.114/63534
>>>>>> 08/09/2006 11:15:27 AM -1376814176 RTPBeacon RTPBeacon.py:278
>>>>>> DEBUG Called Start.
>>>>>> 08/09/2006 11:15:27 AM -1376814176 VenueClient
>>>>>> VenueClient.py:1231 INFO In UpdateStream: transport=unicast
>>>>>> 08/09/2006 11:15:27 AM -1345344608 bajjer.io io.py:161 DEBUG
>>>>>> RECV: <presence
>>>>>> to='8180087163ff65364de2ad59cc6ba1e9 at jabber.mcs.anl.gov/default'
>>>>>> from='ag-tech-room(venueserver2.westgrid.ca)@conference.mcs.anl.gov/Todd
>>>>>> Zimmerman'><x/><x
>>>>>> xmlns='http://jabber.org/protocol/muc#user'><item
>>>>>> affiliation='none' role='participant'/></x></presence>
>>>>>> 08/09/2006 11:15:27 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start <{jabber:client}presence> level=1
>>>>>> 08/09/2006 11:15:27 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start <{jabber:client}x> level=2
>>>>>> 08/09/2006 11:15:27 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end <{jabber:client}x> level=2
>>>>>> 08/09/2006 11:15:27 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start
>>>>>> <{http://jabber.org/protocol/muc#user}x> level=2
>>>>>> 08/09/2006 11:15:27 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start
>>>>>> <{http://jabber.org/protocol/muc#user}item> level=3
>>>>>> 08/09/2006 11:15:27 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end
>>>>>> <{http://jabber.org/protocol/muc#user}item> level=3
>>>>>> 08/09/2006 11:15:27 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end
>>>>>> <{http://jabber.org/protocol/muc#user}x> level=2
>>>>>> 08/09/2006 11:15:27 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end <{jabber:client}presence> level=1
>>>>>> 08/09/2006 11:15:27 AM -1345344608 JabberClient
>>>>>> JabberClient.py:145 DEBUG
>>>>>> ag-tech-room(venueserver2.westgrid.ca)@conference.mcs.anl.gov/Todd
>>>>>> Zimmerman is available (None / None)
>>>>>> 08/09/2006 11:15:27 AM -1345344608 VenueClient
>>>>>> VenueClientUI.py:2299 DEBUG add user: Todd Zimmerman
>>>>>> 08/09/2006 11:15:27 AM -1345344608 bajjer.io io.py:161 DEBUG
>>>>>> RECV: <message type='groupchat'
>>>>>> to='8180087163ff65364de2ad59cc6ba1e9 at jabber.mcs.anl.gov/default'
>>>>>> from='ag-tech-room(venueserver2.westgrid.ca)@conference.mcs.anl.gov'><body>ag-tech-room(venueserver2.westgrid.ca)</body></message>
>>>>>>
>>>>>> 08/09/2006 11:15:27 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start <{jabber:client}message> level=1
>>>>>> 08/09/2006 11:15:27 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start <{jabber:client}body> level=2
>>>>>> 08/09/2006 11:15:27 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end <{jabber:client}body> level=2
>>>>>> 08/09/2006 11:15:27 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end <{jabber:client}message> level=1
>>>>>> 08/09/2006 11:15:27 AM -1345344608 JabberClient
>>>>>> JabberClient.py:133 DEBUG
>>>>>> ag-tech-room(venueserver2.westgrid.ca)@conference.mcs.anl.go:
>>>>>> ag-tech-room(venueserver2.westgrid.ca)
>>>>>> 08/09/2006 11:15:27 AM -1345344608 bajjer.io io.py:161 DEBUG
>>>>>> RECV: <message type='groupchat'
>>>>>> to='8180087163ff65364de2ad59cc6ba1e9 at jabber.mcs.anl.gov/default'
>>>>>> from='ag-tech-room(venueserver2.westgrid.ca)@conference.mcs.anl.gov'><body>This
>>>>>> room supports the MUC protocol.</body></message>
>>>>>> 08/09/2006 11:15:27 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start <{jabber:client}message> level=1
>>>>>> 08/09/2006 11:15:27 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start <{jabber:client}body> level=2
>>>>>> 08/09/2006 11:15:27 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end <{jabber:client}body> level=2
>>>>>> 08/09/2006 11:15:27 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end <{jabber:client}message> level=1
>>>>>> 08/09/2006 11:15:27 AM -1376814176 VenueClient
>>>>>> VenueClient.py:1260 DEBUG Got location from bridge: unicast
>>>>>> milton.mcs.anl.gov 53368
>>>>>> 08/09/2006 11:15:27 AM -1376814176 VenueClient
>>>>>> VenueClient.py:1231 INFO In UpdateStream: transport=unicast
>>>>>> 08/09/2006 11:15:27 AM -1345344608 bajjer.io io.py:161 DEBUG
>>>>>> RECV: <message type='groupchat'
>>>>>> from='ag-tech-room(venueserver2.westgrid.ca)@conference.mcs.anl.gov'
>>>>>> to='8180087163ff65364de2ad59cc6ba1e9 at jabber.mcs.anl.gov/default'><body>Todd
>>>>>> Zimmerman has joined this session</body></message>
>>>>>> 08/09/2006 11:15:27 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start <{jabber:client}message> level=1
>>>>>> 08/09/2006 11:15:27 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start <{jabber:client}body> level=2
>>>>>> 08/09/2006 11:15:27 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end <{jabber:client}body> level=2
>>>>>> 08/09/2006 11:15:27 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end <{jabber:client}message> level=1
>>>>>> 08/09/2006 11:15:27 AM -1345344608 JabberClient
>>>>>> JabberClient.py:133 DEBUG
>>>>>> ag-tech-room(venueserver2.westgrid.ca)@conference.mcs.anl.go:
>>>>>> This room supports the MUC protocol.
>>>>>> 08/09/2006 11:15:27 AM -1208600896 EventClient
>>>>>> InsecureVenueEventClient.py:77 INFO BaseVenueEventClient lost
>>>>>> connection.
>>>>>> 08/09/2006 11:15:27 AM -1345344608 JabberClient
>>>>>> JabberClient.py:133 DEBUG
>>>>>> ag-tech-room(venueserver2.westgrid.ca)@conference.mcs.anl.go:
>>>>>> Todd Zimmerman has joined this session
>>>>>> 08/09/2006 11:15:27 AM -1376814176 VenueClient
>>>>>> VenueClient.py:1260 DEBUG Got location from bridge: unicast
>>>>>> milton.mcs.anl.gov 53100
>>>>>> 08/09/2006 11:15:27 AM -1376814176 VenueClient
>>>>>> VenueClient.py:1231 INFO In UpdateStream: transport=unicast
>>>>>> 08/09/2006 11:15:27 AM -1376814176 VenueClient
>>>>>> VenueClient.py:1260 DEBUG Got location from bridge: unicast
>>>>>> milton.mcs.anl.gov 53004
>>>>>> 08/09/2006 11:15:27 AM -1376814176 VenueClient
>>>>>> VenueClient.py:1231 INFO In UpdateStream: transport=unicast
>>>>>> 08/09/2006 11:15:27 AM -1208600896 GroupMsgClient
>>>>>> GroupMsgClient.py:112 INFO Connected. Connection ID:
>>>>>> 8180087163ff6536598e606758d7f94f
>>>>>> 08/09/2006 11:15:27 AM -1208600896 EventClient
>>>>>> InsecureVenueEventClient.py:60 INFO BaseVenueEventClient made
>>>>>> connection.
>>>>>> 08/09/2006 11:15:28 AM -1376814176 VenueClient
>>>>>> VenueClient.py:1260 DEBUG Got location from bridge: unicast
>>>>>> milton.mcs.anl.gov 52582
>>>>>> 08/09/2006 11:15:28 AM -1376814176 RTPBeacon RTPBeacon.py:296
>>>>>> DEBUG Called Stop.
>>>>>> 08/09/2006 11:15:28 AM -1376814176 VenueClient
>>>>>> VenueClient.py:951 INFO Beacon being reconfigured, stopping
>>>>>> running beacon
>>>>>> 08/09/2006 11:15:28 AM -1376814176 RTPBeacon RTPBeacon.py:296
>>>>>> DEBUG Called Stop.
>>>>>> 08/09/2006 11:15:28 AM -1376814176 VenueClient
>>>>>> VenueClient.py:959 INFO VenueClient.StartBeacon: Address
>>>>>> milton.mcs.anl.gov/52582
>>>>>> 08/09/2006 11:15:28 AM -1376814176 RTPBeacon RTPBeacon.py:278
>>>>>> DEBUG Called Start.
>>>>>> 08/09/2006 11:15:28 AM -1376814176 VenueClient
>>>>>> VenueClient.py:1190 DEBUG UpdateNodeService: Method
>>>>>> UpdateNodeService called
>>>>>> 08/09/2006 11:15:28 AM -1376814176 VenueClient
>>>>>> VenueClient.py:1195 DEBUG Setting node service streams
>>>>>> 08/09/2006 11:15:28 AM -1376814176 NodeService
>>>>>> AGNodeService.py:328 INFO NodeService.SetStreams
>>>>>> 08/09/2006 11:15:28 AM -1376814176 NodeService
>>>>>> AGNodeService.py:257 INFO NodeService.GetServices
>>>>>> 08/09/2006 11:15:28 AM -1398592608 ServiceManager
>>>>>> AGServiceManager.py:218 INFO AGServiceManager.GetServices
>>>>>> 08/09/2006 11:15:28 AM -1376814176 NodeService
>>>>>> AGNodeService.py:695 INFO NodeService.__SendStreamsToService
>>>>>> 08/09/2006 11:15:28 AM -1376814176 NodeService
>>>>>> AGNodeService.py:699 DEBUG service capabilities: [consumer,
>>>>>> audio, 8e3a358333096536dec30af9596ae5ae, L16, 16000, 1, consumer,
>>>>>> audio, 8e3a358333096536dec30af9596ae5ae, L16, 8000, 1, consumer,
>>>>>> audio, 8e3a358333096536dec30af9596ae5ae, L8, 16000, 1, consumer,
>>>>>> audio, 8e3a358333096536dec30af9596ae5ae, L8, 8000, 1, consumer,
>>>>>> audio, 8e3a358333096536dec30af9596ae5ae, PCMU, 16000, 1,
>>>>>> consumer, audio, 8e3a358333096536dec30af9596ae5ae, PCMU, 8000, 1,
>>>>>> consumer, audio, 8e3a358333096536dec30af9596ae5ae, GSM, 16000, 1,
>>>>>> consumer, audio, 8e3a358333096536dec30af9596ae5ae, GSM, 8000, 1,
>>>>>> producer, audio, 8e3a358333096536dec30af9596ae5ae, L16, 16000, 1]
>>>>>> 08/09/2006 11:15:28 AM -1376814176 NodeService
>>>>>> AGNodeService.py:713 INFO Sending stream (type=[consumer, audio,
>>>>>> 8180087163ff629be074b224aad547b3, L16, 16000, 1, consumer, audio,
>>>>>> 8180087163ff629be074b224aad547b3, L16, 8000, 1, consumer, audio,
>>>>>> 8180087163ff629be074b224aad547b3, L8, 16000, 1, consumer, audio,
>>>>>> 8180087163ff629be074b224aad547b3, L8, 8000, 1, consumer, audio,
>>>>>> 8180087163ff629be074b224aad547b3, PCMU, 16000, 1, consumer,
>>>>>> audio, 8180087163ff629be074b224aad547b3, PCMU, 8000, 1, consumer,
>>>>>> audio, 8180087163ff629be074b224aad547b3, GSM, 16000, 1, consumer,
>>>>>> audio, 8180087163ff629be074b224aad547b3, GSM, 8000, 1]) to
>>>>>> service:
>>>>>> http://floyd.irmacs.sfu.ca:56488/Services/AudioService.8e3a358333096536decfdc29e8e7216d
>>>>>>
>>>>>> 08/09/2006 11:15:28 AM -1376814176 NodeService
>>>>>> AGNodeService.py:695 INFO NodeService.__SendStreamsToService
>>>>>> 08/09/2006 11:15:28 AM -1376814176 NodeService
>>>>>> AGNodeService.py:699 DEBUG service capabilities: [producer,
>>>>>> debug, None, None, None, 1, consumer, debug, None, None, None, 1]
>>>>>> 08/09/2006 11:15:28 AM -1376814176 NodeService
>>>>>> AGNodeService.py:718 ERROR Exception in
>>>>>> AGNodeService.__SendStreamsToService.
>>>>>> Traceback (most recent call last):
>>>>>> File
>>>>>> "/usr/lib/python2.4/site-packages/AccessGrid/AGNodeService.py",
>>>>>> line 708, in __SendStreamsToService
>>>>>> if c.matches(cap):
>>>>>> File
>>>>>> "/usr/lib/python2.4/site-packages/AccessGrid3/AccessGrid/Descriptions.py",
>>>>>> line 314, in matches
>>>>>> if (str(self.type) != str(capability.type) or
>>>>>> TypeError: int() argument must be a string or a number
>>>>>> 08/09/2006 11:15:28 AM -1376814176 VenueClient
>>>>>> VenueClient.py:1199 ERROR Error setting streams
>>>>>> Traceback (most recent call last):
>>>>>> File
>>>>>> "/usr/lib/python2.4/site-packages/AccessGrid3/AccessGrid/VenueClient.py",
>>>>>> line 1197, in UpdateNodeService
>>>>>> self.nodeService.SetStreams( self.streamDescList )
>>>>>> File
>>>>>> "/usr/lib/python2.4/site-packages/AccessGrid/AGNodeService.py",
>>>>>> line 340, in SetStreams
>>>>>> self.__SendStreamsToService( service.uri )
>>>>>> File
>>>>>> "/usr/lib/python2.4/site-packages/AccessGrid/AGNodeService.py",
>>>>>> line 723, in __SendStreamsToService
>>>>>> raise SetStreamException(failedSends)
>>>>>> SetStreamException: Error updating [producer, debug, None, None,
>>>>>> None, 1, consumer, debug, None, None, None, 1]
>>>>>>
>>>>>> 08/09/2006 11:15:28 AM -1376814176 VenueClient
>>>>>> VenueClient.py:914 DEBUG Updating client profile cache.
>>>>>> 08/09/2006 11:15:28 AM -1225692256 RTPBeacon RTPBeacon.py:289
>>>>>> INFO RTPBeacon.UpdateThread exiting
>>>>>> 08/09/2006 11:15:30 AM -1208600896 NodeService
>>>>>> AGNodeService.py:275 INFO NodeService.SetServiceEnabled
>>>>>> 08/09/2006 11:15:30 AM -1208600896 NodeService
>>>>>> AGNodeService.py:248 INFO NodeService.GetServiceManagers
>>>>>> 08/09/2006 11:15:30 AM -1225692256 ServiceManager
>>>>>> AGServiceManager.py:218 INFO AGServiceManager.GetServices
>>>>>> 08/09/2006 11:15:35 AM -1208600896 NodeManagementUIClasses
>>>>>> NodeManagementUIClasses.py:1036 DEBUG
>>>>>> NodeManagementClientFrame.EnableService: Enabling Service:
>>>>>> DebugService
>>>>>> 08/09/2006 11:15:35 AM -1208600896 NodeService
>>>>>> AGNodeService.py:275 INFO NodeService.SetServiceEnabled
>>>>>> 08/09/2006 11:15:35 AM -1208600896 NodeService
>>>>>> AGNodeService.py:695 INFO NodeService.__SendStreamsToService
>>>>>> 08/09/2006 11:15:35 AM -1208600896 NodeService
>>>>>> AGNodeService.py:699 DEBUG service capabilities: [producer,
>>>>>> debug, None, None, None, 1, consumer, debug, None, None, None, 1]
>>>>>> 08/09/2006 11:15:35 AM -1208600896 NodeService
>>>>>> AGNodeService.py:718 ERROR Exception in
>>>>>> AGNodeService.__SendStreamsToService.
>>>>>> Traceback (most recent call last):
>>>>>> File
>>>>>> "/usr/lib/python2.4/site-packages/AccessGrid/AGNodeService.py",
>>>>>> line 708, in __SendStreamsToService
>>>>>> if c.matches(cap):
>>>>>> File
>>>>>> "/usr/lib/python2.4/site-packages/AccessGrid3/AccessGrid/Descriptions.py",
>>>>>> line 314, in matches
>>>>>> if (str(self.type) != str(capability.type) or
>>>>>> TypeError: int() argument must be a string or a number
>>>>>> 08/09/2006 11:15:35 AM -1208600896 NodeService
>>>>>> AGNodeService.py:282 ERROR
>>>>>> http://floyd.irmacs.sfu.ca:64864/Services/DebugService.8e3a3583333a6536e9540206adb5e731
>>>>>>
>>>>>> Traceback (most recent call last):
>>>>>> File
>>>>>> "/usr/lib/python2.4/site-packages/AccessGrid/AGNodeService.py",
>>>>>> line 278, in SetServiceEnabled
>>>>>> self.__SendStreamsToService( serviceUri )
>>>>>> File
>>>>>> "/usr/lib/python2.4/site-packages/AccessGrid/AGNodeService.py",
>>>>>> line 723, in __SendStreamsToService
>>>>>> raise SetStreamException(failedSends)
>>>>>> SetStreamException: Error updating [producer, debug, None, None,
>>>>>> None, 1, consumer, debug, None, None, None, 1]
>>>>>>
>>>>>> 08/09/2006 11:15:35 AM -1208600896 NodeManagementUIClasses
>>>>>> NodeManagementUIClasses.py:1043 ERROR Error enabling service
>>>>>> Traceback (most recent call last):
>>>>>> File
>>>>>> "/usr/lib/python2.4/site-packages/AccessGrid3/AccessGrid/NodeManagementUIClasses.py",
>>>>>> line 1037, in EnableService
>>>>>> self.nodeServiceHandle.SetServiceEnabled(service.uri, 1)
>>>>>> File
>>>>>> "/usr/lib/python2.4/site-packages/AccessGrid/AGNodeService.py",
>>>>>> line 278, in SetServiceEnabled
>>>>>> self.__SendStreamsToService( serviceUri )
>>>>>> File
>>>>>> "/usr/lib/python2.4/site-packages/AccessGrid/AGNodeService.py",
>>>>>> line 723, in __SendStreamsToService
>>>>>> raise SetStreamException(failedSends)
>>>>>> SetStreamException: Error updating [producer, debug, None, None,
>>>>>> None, 1, consumer, debug, None, None, None, 1]
>>>>>>
>>>>>> 08/09/2006 11:15:38 AM -1208600896 NodeService
>>>>>> AGNodeService.py:275 INFO NodeService.SetServiceEnabled
>>>>>> 08/09/2006 11:15:38 AM -1208600896 NodeService
>>>>>> AGNodeService.py:248 INFO NodeService.GetServiceManagers
>>>>>> 08/09/2006 11:15:38 AM -1225692256 ServiceManager
>>>>>> AGServiceManager.py:218 INFO AGServiceManager.GetServices
>>>>>> 08/09/2006 11:15:40 AM -1208600896 NodeManagementUIClasses
>>>>>> NodeManagementUIClasses.py:1036 DEBUG
>>>>>> NodeManagementClientFrame.EnableService: Enabling Service:
>>>>>> DebugService
>>>>>> 08/09/2006 11:15:40 AM -1208600896 NodeService
>>>>>> AGNodeService.py:275 INFO NodeService.SetServiceEnabled
>>>>>> 08/09/2006 11:15:40 AM -1208600896 NodeService
>>>>>> AGNodeService.py:695 INFO NodeService.__SendStreamsToService
>>>>>> 08/09/2006 11:15:40 AM -1208600896 NodeService
>>>>>> AGNodeService.py:699 DEBUG service capabilities: [producer,
>>>>>> debug, None, None, None, 1, consumer, debug, None, None, None, 1]
>>>>>> 08/09/2006 11:15:40 AM -1208600896 NodeService
>>>>>> AGNodeService.py:718 ERROR Exception in
>>>>>> AGNodeService.__SendStreamsToService.
>>>>>> Traceback (most recent call last):
>>>>>> File
>>>>>> "/usr/lib/python2.4/site-packages/AccessGrid/AGNodeService.py",
>>>>>> line 708, in __SendStreamsToService
>>>>>> if c.matches(cap):
>>>>>> File
>>>>>> "/usr/lib/python2.4/site-packages/AccessGrid3/AccessGrid/Descriptions.py",
>>>>>> line 314, in matches
>>>>>> if (str(self.type) != str(capability.type) or
>>>>>> TypeError: int() argument must be a string or a number
>>>>>> 08/09/2006 11:15:40 AM -1208600896 NodeService
>>>>>> AGNodeService.py:282 ERROR
>>>>>> http://floyd.irmacs.sfu.ca:64864/Services/DebugService.8e3a3583333a6536e9540206adb5e731
>>>>>>
>>>>>> Traceback (most recent call last):
>>>>>> File
>>>>>> "/usr/lib/python2.4/site-packages/AccessGrid/AGNodeService.py",
>>>>>> line 278, in SetServiceEnabled
>>>>>> self.__SendStreamsToService( serviceUri )
>>>>>> File
>>>>>> "/usr/lib/python2.4/site-packages/AccessGrid/AGNodeService.py",
>>>>>> line 723, in __SendStreamsToService
>>>>>> raise SetStreamException(failedSends)
>>>>>> SetStreamException: Error updating [producer, debug, None, None,
>>>>>> None, 1, consumer, debug, None, None, None, 1]
>>>>>>
>>>>>> 08/09/2006 11:15:40 AM -1208600896 NodeManagementUIClasses
>>>>>> NodeManagementUIClasses.py:1043 ERROR Error enabling service
>>>>>> Traceback (most recent call last):
>>>>>> File
>>>>>> "/usr/lib/python2.4/site-packages/AccessGrid3/AccessGrid/NodeManagementUIClasses.py",
>>>>>> line 1037, in EnableService
>>>>>> self.nodeServiceHandle.SetServiceEnabled(service.uri, 1)
>>>>>> File
>>>>>> "/usr/lib/python2.4/site-packages/AccessGrid/AGNodeService.py",
>>>>>> line 278, in SetServiceEnabled
>>>>>> self.__SendStreamsToService( serviceUri )
>>>>>> File
>>>>>> "/usr/lib/python2.4/site-packages/AccessGrid/AGNodeService.py",
>>>>>> line 723, in __SendStreamsToService
>>>>>> raise SetStreamException(failedSends)
>>>>>> SetStreamException: Error updating [producer, debug, None, None,
>>>>>> None, 1, consumer, debug, None, None, None, 1]
>>>>>>
>>>>>> 08/09/2006 11:15:54 AM -1208600896 VenueClient
>>>>>> VenueClientUI.py:2200 INFO --------- END VenueClient
>>>>>> 08/09/2006 11:15:54 AM -1208600896 VenueClient
>>>>>> VenueClient.py:1132 INFO ExitVenue
>>>>>> 08/09/2006 11:15:54 AM -1208600896 VenueClient
>>>>>> VenueClient.py:1173 INFO ExitVenue: Stopping node services
>>>>>> 08/09/2006 11:15:54 AM -1208600896 NodeService
>>>>>> AGNodeService.py:301 INFO NodeService.StopServices
>>>>>> 08/09/2006 11:15:54 AM -1225692256 ServiceManager
>>>>>> AGServiceManager.py:225 INFO AGServiceManager.StopServices
>>>>>> 08/09/2006 11:15:55 AM -1208600896 NodeService
>>>>>> AGNodeService.py:328 INFO NodeService.SetStreams
>>>>>> 08/09/2006 11:15:55 AM -1208600896 NodeService
>>>>>> AGNodeService.py:257 INFO NodeService.GetServices
>>>>>> 08/09/2006 11:15:55 AM -1225692256 ServiceManager
>>>>>> AGServiceManager.py:218 INFO AGServiceManager.GetServices
>>>>>> 08/09/2006 11:15:55 AM -1208600896 NodeService
>>>>>> AGNodeService.py:695 INFO NodeService.__SendStreamsToService
>>>>>> 08/09/2006 11:15:55 AM -1208600896 NodeService
>>>>>> AGNodeService.py:699 DEBUG service capabilities: [consumer,
>>>>>> audio, 8e3a358333096536dec30af9596ae5ae, L16, 16000, 1, consumer,
>>>>>> audio, 8e3a358333096536dec30af9596ae5ae, L16, 8000, 1, consumer,
>>>>>> audio, 8e3a358333096536dec30af9596ae5ae, L8, 16000, 1, consumer,
>>>>>> audio, 8e3a358333096536dec30af9596ae5ae, L8, 8000, 1, consumer,
>>>>>> audio, 8e3a358333096536dec30af9596ae5ae, PCMU, 16000, 1,
>>>>>> consumer, audio, 8e3a358333096536dec30af9596ae5ae, PCMU, 8000, 1,
>>>>>> consumer, audio, 8e3a358333096536dec30af9596ae5ae, GSM, 16000, 1,
>>>>>> consumer, audio, 8e3a358333096536dec30af9596ae5ae, GSM, 8000, 1,
>>>>>> producer, audio, 8e3a358333096536dec30af9596ae5ae, L16, 16000, 1]
>>>>>> 08/09/2006 11:15:55 AM -1208600896 NodeService
>>>>>> AGNodeService.py:695 INFO NodeService.__SendStreamsToService
>>>>>> 08/09/2006 11:15:56 AM -1208600896 NodeService
>>>>>> AGNodeService.py:699 DEBUG service capabilities: [producer,
>>>>>> debug, None, None, None, 1, consumer, debug, None, None, None, 1]
>>>>>> 08/09/2006 11:15:56 AM -1208600896 NodeService
>>>>>> AGNodeService.py:695 INFO NodeService.__SendStreamsToService
>>>>>> 08/09/2006 11:15:56 AM -1208600896 NodeService
>>>>>> AGNodeService.py:699 DEBUG service capabilities: [consumer,
>>>>>> video, 8e3a358333036536de76e51f5b703c18, H261, 90000, 1,
>>>>>> producer, video, 8e3a358333036536de76e51f5b703c18, H261, 90000, 1]
>>>>>> 08/09/2006 11:15:56 AM -1208600896 VenueClient
>>>>>> VenueClient.py:1103 DEBUG ExitVenue: Stop event client obj
>>>>>> 08/09/2006 11:15:56 AM -1208600896 VenueClient
>>>>>> VenueClient.py:1105 DEBUG ExitVenue: Remove event client reference
>>>>>> 08/09/2006 11:15:56 AM -1208600896 VenueClient
>>>>>> VenueClient.py:1110 INFO ExitVenue: Stopping text client
>>>>>> 08/09/2006 11:15:56 AM -1208600896 JabberClient
>>>>>> JabberClient.py:73 DEBUG Sending the presence to
>>>>>> 'AG-Tech-Room(venueserver2.westgrid.ca)@conference.mcs.anl.gov/Todd
>>>>>> Zimmerman' of type 'unavailable'...
>>>>>> 08/09/2006 11:15:56 AM -1208600896 bajjer.io io.py:122 DEBUG
>>>>>> SEND: <presence
>>>>>> to="AG-Tech-Room(venueserver2.westgrid.ca)@conference.mcs.anl.gov/Todd
>>>>>> Zimmerman" type="unavailable"><x /></presence>
>>>>>> 08/09/2006 11:15:56 AM -1208600896 RTPBeacon RTPBeacon.py:296
>>>>>> DEBUG Called Stop.
>>>>>> 08/09/2006 11:15:56 AM -1208600896 ServiceManager
>>>>>> AGServiceManager.py:70 INFO AGServiceManager.Shutdown
>>>>>> 08/09/2006 11:15:56 AM -1208600896 ServiceManager
>>>>>> AGServiceManager.py:71 INFO Remove services
>>>>>> 08/09/2006 11:15:56 AM -1208600896 ServiceManager
>>>>>> AGServiceManager.py:208 INFO AGServiceManager.RemoveServices
>>>>>> 08/09/2006 11:15:56 AM -1208600896 ServiceManager
>>>>>> AGServiceManager.py:162 INFO AGServiceManager.RemoveService
>>>>>> 08/09/2006 11:15:56 AM -1345344608 bajjer.io io.py:161 DEBUG
>>>>>> RECV: <presence
>>>>>> to='8180087163ff65364de2ad59cc6ba1e9 at jabber.mcs.anl.gov/default'
>>>>>> type='unavailable'
>>>>>> from='ag-tech-room(venueserver2.westgrid.ca)@conference.mcs.anl.gov/Todd
>>>>>> Zimmerman'><x/><x
>>>>>> xmlns='http://jabber.org/protocol/muc#user'><item
>>>>>> affiliation='none' role='none'/></x></presence>
>>>>>> 08/09/2006 11:15:56 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start <{jabber:client}presence> level=1
>>>>>> 08/09/2006 11:15:56 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start <{jabber:client}x> level=2
>>>>>> 08/09/2006 11:15:56 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end <{jabber:client}x> level=2
>>>>>> 08/09/2006 11:15:56 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start
>>>>>> <{http://jabber.org/protocol/muc#user}x> level=2
>>>>>> 08/09/2006 11:15:56 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:72 DEBUG start
>>>>>> <{http://jabber.org/protocol/muc#user}item> level=3
>>>>>> 08/09/2006 11:15:56 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end
>>>>>> <{http://jabber.org/protocol/muc#user}item> level=3
>>>>>> 08/09/2006 11:15:56 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end
>>>>>> <{http://jabber.org/protocol/muc#user}x> level=2
>>>>>> 08/09/2006 11:15:56 AM -1366324320 RTPBeacon RTPBeacon.py:289
>>>>>> INFO RTPBeacon.UpdateThread exiting
>>>>>> 08/09/2006 11:15:56 AM -1345344608 bajjer.serialize
>>>>>> serialize.py:86 DEBUG end <{jabber:client}presence> level=1
>>>>>> 08/09/2006 11:15:56 AM -1345344608 JabberClient
>>>>>> JabberClient.py:148 DEBUG
>>>>>> ag-tech-room(venueserver2.westgrid.ca)@conference.mcs.anl.gov/Todd
>>>>>> Zimmerman is unavailable (None / None)
>>>>>> 08/09/2006 11:15:56 AM -1345344608 VenueClient
>>>>>> VenueClientUI.py:2313 DEBUG remove user: Todd Zimmerman
>>>>>> 08/09/2006 11:15:58 AM -1208600896 ServiceManager
>>>>>> AGServiceManager.py:162 INFO AGServiceManager.RemoveService
>>>>>> 08/09/2006 11:16:00 AM -1208600896 ServiceManager
>>>>>> AGServiceManager.py:162 INFO AGServiceManager.RemoveService
>>>>>> 08/09/2006 11:16:02 AM -1208600896 ServiceManager
>>>>>> AGServiceManager.py:73 INFO Stop network interface
>>>>>> 08/09/2006 11:16:02 AM -1208600896 RTPBeacon RTPBeacon.py:296
>>>>>> DEBUG Called Stop.
>>
>
>
More information about the ag-dev
mailing list