08/06/09 13:01:03 932 Toolkit config.py:609 DEBUG System hostname of agn-med.usd.local is valid 08/06/09 13:01:03 932 Toolkit toolkit.py:116 DEBUG Initializing AG Toolkit version 3.1 08/06/09 13:01:03 932 Toolkit toolkit.py:117 INFO Command and arguments: ['C:\\Program Files\\AGTk-3\\bin\\VenueClient3.py'] 08/06/09 13:01:03 932 VenueClient preferences.py:188 DEBUG Preferences.LoadPreferences: open file 08/06/09 13:01:03 932 Toolkit toolkit.py:166 INFO Logfile Name: VenueClient.log 08/06/09 13:01:04 932 Toolkit venueclient3.py:137 INFO wx version is: 2.6.3.3 08/06/09 13:01:04 932 VenueClient venueclient.py:529 DEBUG __StartWebService: service manager: http://agn-med.usd.local:11000/ServiceManager 08/06/09 13:01:04 932 VenueClient venueclient.py:543 DEBUG __StartWebService: node service: http://agn-med.usd.local:11000/NodeService 08/06/09 13:01:04 932 NodeService agnodeservice.py:640 INFO NodeService.GetConfigurations 08/06/09 13:01:04 932 VenueClient venueclient.py:270 DEBUG Loading node configuration: 08/06/09 13:01:04 932 NodeService agnodeservice.py:379 INFO NodeService.LoadConfiguration 08/06/09 13:01:04 932 NodeService agnodeservice.py:398 INFO Trying to load node configuration from: C:\Program Files\AGTk-3\Config\nodeConfig\default 08/06/09 13:01:04 932 NodeService agnodeservice.py:406 DEBUG section: node 08/06/09 13:01:04 932 NodeService agnodeservice.py:408 DEBUG servicemanagers : servicemanager0 08/06/09 13:01:04 932 NodeService agnodeservice.py:406 DEBUG section: serviceconfig0 08/06/09 13:01:04 932 NodeService agnodeservice.py:408 DEBUG Use site id : On 08/06/09 13:01:04 932 NodeService agnodeservice.py:408 DEBUG Silence Suppression : Off 08/06/09 13:01:04 932 NodeService agnodeservice.py:408 DEBUG Start Priority : 5 08/06/09 13:01:04 932 NodeService agnodeservice.py:408 DEBUG Output Gain : 50 08/06/09 13:01:04 932 NodeService agnodeservice.py:408 DEBUG Talk : Off 08/06/09 13:01:04 932 NodeService agnodeservice.py:408 DEBUG Input Gain : 50 08/06/09 13:01:04 932 NodeService agnodeservice.py:406 DEBUG section: servicemanager0 08/06/09 13:01:04 932 NodeService agnodeservice.py:408 DEBUG url : 08/06/09 13:01:04 932 NodeService agnodeservice.py:408 DEBUG builtin : 1 08/06/09 13:01:04 932 NodeService agnodeservice.py:408 DEBUG services : service0 service1 service2 08/06/09 13:01:04 932 NodeService agnodeservice.py:408 DEBUG name : 08/06/09 13:01:04 932 NodeService agnodeservice.py:406 DEBUG section: service2 08/06/09 13:01:04 932 NodeService agnodeservice.py:408 DEBUG packageName : VideoProducerService.zip 08/06/09 13:01:04 932 NodeService agnodeservice.py:408 DEBUG resource : resource2 08/06/09 13:01:04 932 NodeService agnodeservice.py:408 DEBUG serviceConfig : serviceconfig2 08/06/09 13:01:04 932 NodeService agnodeservice.py:406 DEBUG section: service1 08/06/09 13:01:04 932 NodeService agnodeservice.py:408 DEBUG packageName : VideoConsumerService.zip 08/06/09 13:01:04 932 NodeService agnodeservice.py:408 DEBUG serviceConfig : serviceconfig1 08/06/09 13:01:04 932 NodeService agnodeservice.py:406 DEBUG section: service0 08/06/09 13:01:04 932 NodeService agnodeservice.py:408 DEBUG packageName : AudioService.zip 08/06/09 13:01:04 932 NodeService agnodeservice.py:408 DEBUG serviceConfig : serviceconfig0 08/06/09 13:01:04 932 NodeService agnodeservice.py:406 DEBUG section: serviceconfig2 08/06/09 13:01:04 932 NodeService agnodeservice.py:408 DEBUG Frame Rate : 24 08/06/09 13:01:04 932 NodeService agnodeservice.py:408 DEBUG Encoding : h261 08/06/09 13:01:04 932 NodeService agnodeservice.py:408 DEBUG Start Priority : 5 08/06/09 13:01:04 932 NodeService agnodeservice.py:408 DEBUG Standard : PAL 08/06/09 13:01:04 932 NodeService agnodeservice.py:408 DEBUG Bandwidth : 800 08/06/09 13:01:04 932 NodeService agnodeservice.py:408 DEBUG Processor usage : All 08/06/09 13:01:04 932 NodeService agnodeservice.py:408 DEBUG Port : external-in 08/06/09 13:01:04 932 NodeService agnodeservice.py:408 DEBUG Quality : 75 08/06/09 13:01:04 932 NodeService agnodeservice.py:408 DEBUG Stream Name : BisonCam 08/06/09 13:01:04 932 NodeService agnodeservice.py:406 DEBUG section: serviceconfig1 08/06/09 13:01:04 932 NodeService agnodeservice.py:408 DEBUG Start Priority : 7 08/06/09 13:01:04 932 NodeService agnodeservice.py:408 DEBUG Thumbnail Columns : 2 08/06/09 13:01:04 932 NodeService agnodeservice.py:408 DEBUG Processor usage : All 08/06/09 13:01:04 932 NodeService agnodeservice.py:406 DEBUG section: resource2 08/06/09 13:01:04 932 NodeService agnodeservice.py:408 DEBUG name : BisonCam, USB2.0 Vfw 08/06/09 13:01:04 932 NodeService agnodeservice.py:483 DEBUG using builtin service manager at http://agn-med.usd.local:11000/ServiceManager 08/06/09 13:01:04 400 ServiceManager agservicemanager.py:210 INFO AGServiceManager.RemoveServices 08/06/09 13:01:04 324 ServiceManager agservicemanager.py:103 INFO AGServiceManager.AddService 08/06/09 13:01:04 324 ServiceManager agservicemanager.py:343 INFO Installed service version: 3.9, package version: 3.9 08/06/09 13:01:04 324 ServiceManager agservicemanager.py:378 DEBUG Executing service AudioService 08/06/09 13:01:04 324 ServiceManager agservicemanager.py:410 INFO Running Service; options: ['C:\\Documents and Settings\\AGN\\Application Data\\AccessGrid3\\local_services\\AudioService\\AudioService.py', '--port', 62799, '--serviceManagerUri', 'http://agn-med.usd.local:11000/ServiceManager', '--token', 'ceb001630ba418164de5aa8d3b5cf6a7'] 08/06/09 13:01:04 324 ProcessManager processmanager.py:62 DEBUG Creating process: C:\Python24\pythonw.exe "C:\Documents and Settings\AGN\Application Data\AccessGrid3\local_services\AudioService\AudioService.py" --port 62799 --serviceManagerUri http://agn-med.usd.local:11000/ServiceManager --token ceb001630ba418164de5aa8d3b5cf6a7 08/06/09 13:01:04 324 ProcessManager processmanager.py:75 DEBUG Create process returns: (, , 3960, 2832) 08/06/09 13:01:05 2624 ServiceManager agservicemanager.py:234 INFO Service registered: token,url = ceb001630ba418164de5aa8d3b5cf6a7,http://agn-med.usd.local:62799/Services/AudioService.ceb001630f7818164e3b57df41b5dfca 08/06/09 13:01:05 324 ServiceManager agservicemanager.py:422 INFO Service registered: http://agn-med.usd.local:62799/Services/AudioService.ceb001630f7818164e3b57df41b5dfca ceb001630ba418164de5aa8d3b5cf6a7 08/06/09 13:01:05 2544 ServiceManager agservicemanager.py:103 INFO AGServiceManager.AddService 08/06/09 13:01:05 2544 ServiceManager agservicemanager.py:343 INFO Installed service version: 3.1, package version: 3.1 08/06/09 13:01:05 2544 ServiceManager agservicemanager.py:378 DEBUG Executing service VideoConsumerService 08/06/09 13:01:05 2544 ServiceManager agservicemanager.py:410 INFO Running Service; options: ['C:\\Documents and Settings\\AGN\\Application Data\\AccessGrid3\\local_services\\VideoConsumerService\\VideoConsumerService.py', '--port', 55569, '--serviceManagerUri', 'http://agn-med.usd.local:11000/ServiceManager', '--token', 'ceb001630ba418164e5186533475ab78'] 08/06/09 13:01:05 2544 ProcessManager processmanager.py:62 DEBUG Creating process: C:\Python24\pythonw.exe "C:\Documents and Settings\AGN\Application Data\AccessGrid3\local_services\VideoConsumerService\VideoConsumerService.py" --port 55569 --serviceManagerUri http://agn-med.usd.local:11000/ServiceManager --token ceb001630ba418164e5186533475ab78 08/06/09 13:01:05 2544 ProcessManager processmanager.py:75 DEBUG Create process returns: (, , 552, 3216) 08/06/09 13:01:06 1688 ServiceManager agservicemanager.py:234 INFO Service registered: token,url = ceb001630ba418164e5186533475ab78,http://agn-med.usd.local:55569/Services/VideoConsumerService.ceb00163022818164e9fdc86683949e8 08/06/09 13:01:06 2544 ServiceManager agservicemanager.py:422 INFO Service registered: http://agn-med.usd.local:55569/Services/VideoConsumerService.ceb00163022818164e9fdc86683949e8 ceb001630ba418164e5186533475ab78 08/06/09 13:01:06 3408 ServiceManager agservicemanager.py:103 INFO AGServiceManager.AddService 08/06/09 13:01:06 3408 ServiceManager agservicemanager.py:343 INFO Installed service version: 3.8, package version: 3.8 08/06/09 13:01:06 3408 ServiceManager agservicemanager.py:378 DEBUG Executing service VideoProducerService 08/06/09 13:01:06 3408 ServiceManager agservicemanager.py:410 INFO Running Service; options: ['C:\\Documents and Settings\\AGN\\Application Data\\AccessGrid3\\local_services\\VideoProducerService\\VideoProducerService.py', '--port', 61676, '--serviceManagerUri', 'http://agn-med.usd.local:11000/ServiceManager', '--token', 'ceb001630ba418164eb472b28a0cdfc6'] 08/06/09 13:01:06 3408 ProcessManager processmanager.py:62 DEBUG Creating process: C:\Python24\pythonw.exe "C:\Documents and Settings\AGN\Application Data\AccessGrid3\local_services\VideoProducerService\VideoProducerService.py" --port 61676 --serviceManagerUri http://agn-med.usd.local:11000/ServiceManager --token ceb001630ba418164eb472b28a0cdfc6 08/06/09 13:01:06 3408 ProcessManager processmanager.py:75 DEBUG Create process returns: (, , 2244, 2612) 08/06/09 13:01:09 804 ServiceManager agservicemanager.py:234 INFO Service registered: token,url = ceb001630ba418164eb472b28a0cdfc6,http://agn-med.usd.local:61676/Services/VideoProducerService.ceb0016308c418164fccdd43a0936c85 08/06/09 13:01:09 3408 ServiceManager agservicemanager.py:422 INFO Service registered: http://agn-med.usd.local:61676/Services/VideoProducerService.ceb0016308c418164fccdd43a0936c85 ceb001630ba418164eb472b28a0cdfc6 08/06/09 13:01:09 932 VenueClient venueclient.py:365 DEBUG get bridges from registry 08/06/09 13:01:09 932 VenueClient venueclient.py:371 DEBUG Trying bridge registry: http://www.accessgrid.org/registry/peers.txt 08/06/09 13:01:09 932 VenueClient preferences.py:188 DEBUG Preferences.LoadPreferences: open file 08/06/09 13:01:11 932 VenueClient venueclient.py:371 DEBUG Trying bridge registry: http://www.ap-accessgrid.org/registry/peers.txt 08/06/09 13:01:11 932 VenueClient preferences.py:188 DEBUG Preferences.LoadPreferences: open file 08/06/09 13:01:13 932 RegistryClient registryclient.py:66 ERROR Failed to connect to registry hall.vislab.uq.edu.au:8030 Traceback (most recent call last): File "C:\Python24\lib\site-packages\AccessGrid3\AccessGrid\Registry\RegistryClient.py", line 61, in _connectToRegistry if self.PingRegistryPeer(tmpServerProxy) > -1: File "C:\Python24\lib\site-packages\AccessGrid3\AccessGrid\Registry\RegistryClient.py", line 78, in PingRegistryPeer startTime = serverProxy.Ping(time.time()) File "C:\Python24\lib\xmlrpclib.py", line 1096, in __call__ return self.__send(self.__name, args) File "C:\Python24\lib\xmlrpclib.py", line 1383, in __request verbose=self.__verbose File "C:\Python24\lib\xmlrpclib.py", line 1129, in request self.send_content(h, request_body) File "C:\Python24\lib\xmlrpclib.py", line 1243, in send_content connection.endheaders() File "C:\Python24\lib\httplib.py", line 798, in endheaders self._send_output() File "C:\Python24\lib\httplib.py", line 679, in _send_output self.send(msg) File "C:\Python24\lib\httplib.py", line 646, in send self.connect() File "C:\Python24\lib\site-packages\AccessGrid3\AccessGrid\UrllibTransport.py", line 43, in connect raise socket.error, msg error: (10061, 'Connection refused') 08/06/09 13:01:13 932 RegistryClient registryclient.py:70 INFO No bridge registry peers reachable 08/06/09 13:01:13 932 VenueClient venueclient.py:388 ERROR LoadBridges: Can not connect to bridge registry http://www.ap-accessgrid.org/registry/peers.txt Traceback (most recent call last): File "C:\Python24\lib\site-packages\AccessGrid3\AccessGrid\VenueClient.py", line 375, in LoadBridges bridgeList = self.registryClient.LookupBridge() File "C:\Python24\lib\site-packages\AccessGrid3\AccessGrid\Registry\RegistryClient.py", line 135, in LookupBridge bridges = self.serverProxy.LookupBridge() AttributeError: 'NoneType' object has no attribute 'LookupBridge' 08/06/09 13:01:13 932 VenueClient venueclient.py:397 DEBUG connect to bridge 08/06/09 13:01:13 932 VenueClient venueclient.py:401 DEBUG exiting loadbridges 08/06/09 13:01:13 932 NodeService agnodeservice.py:289 INFO NodeService.SetServiceEnabledByMediaType 08/06/09 13:01:13 932 NodeService agnodeservice.py:258 INFO NodeService.GetServices 08/06/09 13:01:13 2964 ServiceManager agservicemanager.py:220 INFO AGServiceManager.GetServices 08/06/09 13:01:13 932 NodeService agnodeservice.py:275 INFO NodeService.SetServiceEnabled 08/06/09 13:01:13 932 NodeService agnodeservice.py:701 INFO NodeService.__SendStreamsToService 08/06/09 13:01:13 932 NodeService agnodeservice.py:705 DEBUG service capabilities: [consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 8000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L8, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L8, 8000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, PCMU, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, PCMU, 8000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, GSM, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, GSM, 8000, 1, None, None, producer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 16000, 1, None, None] 08/06/09 13:01:13 932 NodeService agnodeservice.py:258 INFO NodeService.GetServices 08/06/09 13:01:13 3284 ServiceManager agservicemanager.py:220 INFO AGServiceManager.GetServices 08/06/09 13:01:13 932 NodeService agnodeservice.py:258 INFO NodeService.GetServices 08/06/09 13:01:13 1704 ServiceManager agservicemanager.py:220 INFO AGServiceManager.GetServices 08/06/09 13:01:13 932 NodeService agnodeservice.py:640 INFO NodeService.GetConfigurations 08/06/09 13:01:13 932 CertificateManager certificatemanager.py:212 DEBUG Opened repository C:\Documents and Settings\AGN\Application Data\AccessGrid3\Config\certRepo 08/06/09 13:01:13 932 Toolkit toolkit.py:472 INFO Initialized certificate manager. 08/06/09 13:01:13 932 CertificateManager certificatemanager.py:575 DEBUG Configuring standard environment 08/06/09 13:01:13 932 CertificateManager certificatemanager.py:782 WARNING No identity certs found 08/06/09 13:01:13 932 CertificateManager certificatemanager.py:790 WARNING No default identity certificate found 08/06/09 13:01:13 932 CertificateManager certificatemanager.py:627 DEBUG No default identity found 08/06/09 13:01:13 932 NodeService agnodeservice.py:640 INFO NodeService.GetConfigurations 08/06/09 13:01:13 932 VenueClient preferences.py:188 DEBUG Preferences.LoadPreferences: open file 08/06/09 13:01:50 932 VenueClient venueclientui.py:2141 INFO Entering venue at https://usd-venue.usd.edu:8000/Venues/default 08/06/09 13:01:50 932 VenueClientController venueclientcontroller.py:457 DEBUG VenueClientController calling Venue.EnterVenue 08/06/09 13:01:50 932 VenueClient venueclient.py:1283 DEBUG EnterVenue; url=https://usd-venue.usd.edu:8000/Venues/default type= 08/06/09 13:01:50 932 NodeService agnodeservice.py:663 INFO NodeService.GetCapabilities 08/06/09 13:01:50 932 NodeService agnodeservice.py:258 INFO NodeService.GetServices 08/06/09 13:01:50 1688 ServiceManager agservicemanager.py:220 INFO AGServiceManager.GetServices 08/06/09 13:01:50 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 16000, 1, None, None 08/06/09 13:01:50 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 8000, 1, None, None 08/06/09 13:01:50 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L8, 16000, 1, None, None 08/06/09 13:01:50 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L8, 8000, 1, None, None 08/06/09 13:01:50 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: consumer, audio, ceb001630f7818164e2d01cace7cb1d6, PCMU, 16000, 1, None, None 08/06/09 13:01:50 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: consumer, audio, ceb001630f7818164e2d01cace7cb1d6, PCMU, 8000, 1, None, None 08/06/09 13:01:50 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: consumer, audio, ceb001630f7818164e2d01cace7cb1d6, GSM, 16000, 1, None, None 08/06/09 13:01:50 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: consumer, audio, ceb001630f7818164e2d01cace7cb1d6, GSM, 8000, 1, None, None 08/06/09 13:01:50 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: producer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 16000, 1, None, None 08/06/09 13:01:50 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: consumer, video, ceb00163022818164e9101e336966021, H261, 90000, 1, None, None 08/06/09 13:01:50 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: producer, video, ceb0016308c418164ef401c4b40dc782, H261, 90000, 1, None, None 08/06/09 13:01:50 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: producer, Beacon, 1, ANY, 0, 1, None, None 08/06/09 13:01:50 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: consumer, Beacon, 1, ANY, 0, 1, None, None 08/06/09 13:01:50 932 VenueClient venueclient.py:1320 DEBUG calling __EnterVenue 08/06/09 13:01:50 932 VenueClient venueclient.py:1021 DEBUG EnterVenue: Invoke Venue.Enter 08/06/09 13:01:51 932 VenueClient venueclient.py:1023 DEBUG after Venue.Enter 08/06/09 13:01:51 932 VenueClient venueclient.py:1025 DEBUG EnterVenue: Invoke Venue.getstate 08/06/09 13:01:52 932 VenueClient venueclient.py:1027 DEBUG EnterVenue: done Venue.getstate 08/06/09 13:01:53 932 VenueClient venueclient.py:1061 DEBUG Setting isInVenue flag. 08/06/09 13:01:53 932 VenueClient venueclient.py:1322 DEBUG after __EnterVenue 08/06/09 13:01:53 932 VenueClient venueclientui.py:3182 DEBUG bin.VenueClient::EnterVenue: Enter venue with url: https://usd-venue.usd.edu:8000/Venues/default 08/06/09 13:01:53 3616 VenueClient venueclient.py:593 DEBUG Calling Heartbeat, time now: 1249581713 08/06/09 13:01:53 932 VenueClient venueclientui.py:3249 DEBUG Load Venue data store data 08/06/09 13:01:53 932 VenueClient venueclientui.py:3251 DEBUG Amount of entries: 0 08/06/09 13:01:53 932 VenueClient venueclientui.py:3303 DEBUG Entered venue 08/06/09 13:01:53 932 VenueClientController venueclientcontroller.py:459 DEBUG VenueClientController after Venue.EnterVenue 08/06/09 13:01:53 932 VenueClient venueclientui.py:3570 INFO AddConnections: displayMode = exits 08/06/09 13:01:54 3616 VenueClient venueclient.py:617 DEBUG Next Heartbeat needed within 36s 08/06/09 13:01:54 3616 VenueClient venueclient.py:627 DEBUG heartBeatCounter = 1 08/06/09 13:01:54 3616 JabberClient jabberclient.py:38 INFO Connecting to Jabber Server 'jabber.mcs.anl.gov' ... 08/06/09 13:01:54 932 GroupMsgClient groupmsgclient.py:120 ERROR connection failed: DNS lookup failed: address 'usd-venue.usd.local' not found: (11001, 'getaddrinfo failed'). 08/06/09 13:01:56 3616 bajjer.io io.py:103 DEBUG RECV: 08/06/09 13:01:56 3616 bajjer.serialize serialize.py:64 DEBUG feed parser initialized 08/06/09 13:01:56 3616 bajjer.serialize serialize.py:71 DEBUG start <{http://etherx.jabber.org/streams}stream> level=0 08/06/09 13:01:56 3616 JabberClient jabberclient.py:194 INFO Registering the user 'c0ec25bc07241816436fce232b82dea5@jabber.mcs.anl.gov/default' in jabber server ... 08/06/09 13:01:56 3616 bajjer.io io.py:125 DEBUG SEND: 08/06/09 13:01:56 3616 bajjer.io io.py:167 DEBUG RECV: Choose a username and password to register with this server. 08/06/09 13:01:56 3616 bajjer.serialize serialize.py:71 DEBUG start <{jabber:client}iq> level=1 08/06/09 13:01:56 3616 bajjer.serialize serialize.py:71 DEBUG start <{jabber:iq:register}query> level=2 08/06/09 13:01:56 3616 bajjer.serialize serialize.py:71 DEBUG start <{jabber:iq:register}password> level=3 08/06/09 13:01:56 3616 bajjer.serialize serialize.py:85 DEBUG end <{jabber:iq:register}password> level=3 08/06/09 13:01:56 3616 bajjer.serialize serialize.py:71 DEBUG start <{jabber:iq:register}password> level=3 08/06/09 13:01:56 3616 bajjer.serialize serialize.py:85 DEBUG end <{jabber:iq:register}password> level=3 08/06/09 13:01:56 3616 bajjer.serialize serialize.py:71 DEBUG start <{jabber:iq:register}instructions> level=3 08/06/09 13:01:56 3616 bajjer.serialize serialize.py:85 DEBUG end <{jabber:iq:register}instructions> level=3 08/06/09 13:01:56 3616 bajjer.serialize serialize.py:71 DEBUG start <{jabber:iq:register}name> level=3 08/06/09 13:01:56 3616 bajjer.serialize serialize.py:85 DEBUG end <{jabber:iq:register}name> level=3 08/06/09 13:01:56 3616 bajjer.serialize serialize.py:71 DEBUG start <{jabber:iq:register}email> level=3 08/06/09 13:01:56 3616 bajjer.serialize serialize.py:85 DEBUG end <{jabber:iq:register}email> level=3 08/06/09 13:01:56 3616 bajjer.serialize serialize.py:71 DEBUG start <{jabber:iq:register}username> level=3 08/06/09 13:01:56 3616 bajjer.serialize serialize.py:85 DEBUG end <{jabber:iq:register}username> level=3 08/06/09 13:01:56 3616 bajjer.serialize serialize.py:85 DEBUG end <{jabber:iq:register}query> level=2 08/06/09 13:01:56 3616 bajjer.serialize serialize.py:85 DEBUG end <{jabber:client}iq> level=1 08/06/09 13:01:56 3616 bajjer.io io.py:125 DEBUG SEND: c0ec25bc07241816436fce232b82dea5c0ec25bc07241816436fce232b82dea5 08/06/09 13:01:56 3616 bajjer.io io.py:167 DEBUG RECV: 08/06/09 13:01:56 3616 bajjer.serialize serialize.py:71 DEBUG start <{jabber:client}iq> level=1 08/06/09 13:01:56 3616 bajjer.serialize serialize.py:85 DEBUG end <{jabber:client}iq> level=1 08/06/09 13:01:57 3616 JabberClient jabberclient.py:203 INFO Attempting to log in as c0ec25bc07241816436fce232b82dea5@jabber.mcs.anl.gov/default ... 08/06/09 13:01:57 3616 bajjer.io io.py:125 DEBUG SEND: c0ec25bc07241816436fce232b82dea5 08/06/09 13:01:57 3616 bajjer.io io.py:167 DEBUG RECV: c0ec25bc07241816436fce232b82dea5 08/06/09 13:01:57 3616 bajjer.serialize serialize.py:71 DEBUG start <{jabber:client}iq> level=1 08/06/09 13:01:57 3616 bajjer.serialize serialize.py:71 DEBUG start <{jabber:iq:auth}query> level=2 08/06/09 13:01:57 3616 bajjer.serialize serialize.py:71 DEBUG start <{jabber:iq:auth}username> level=3 08/06/09 13:01:57 3616 bajjer.serialize serialize.py:85 DEBUG end <{jabber:iq:auth}username> level=3 08/06/09 13:01:57 3616 bajjer.serialize serialize.py:71 DEBUG start <{jabber:iq:auth}digest> level=3 08/06/09 13:01:57 3616 bajjer.serialize serialize.py:85 DEBUG end <{jabber:iq:auth}digest> level=3 08/06/09 13:01:57 3616 bajjer.serialize serialize.py:71 DEBUG start <{jabber:iq:auth}password> level=3 08/06/09 13:01:57 3616 bajjer.serialize serialize.py:85 DEBUG end <{jabber:iq:auth}password> level=3 08/06/09 13:01:57 3616 bajjer.serialize serialize.py:71 DEBUG start <{jabber:iq:auth}resource> level=3 08/06/09 13:01:57 3616 bajjer.serialize serialize.py:85 DEBUG end <{jabber:iq:auth}resource> level=3 08/06/09 13:01:57 3616 bajjer.serialize serialize.py:85 DEBUG end <{jabber:iq:auth}query> level=2 08/06/09 13:01:57 3616 bajjer.serialize serialize.py:85 DEBUG end <{jabber:client}iq> level=1 08/06/09 13:01:57 3616 bajjer.stream stream.py:326 DEBUG Recv: 08/06/09 13:01:57 3616 bajjer.stream stream.py:342 DEBUG performing 'digest' authentication 08/06/09 13:01:57 3616 bajjer.io io.py:125 DEBUG SEND: defaultc0ec25bc07241816436fce232b82dea5b1ec7b6867f8ca62b797e64bcfb37439d4b92051 08/06/09 13:01:57 3616 bajjer.io io.py:167 DEBUG RECV: 08/06/09 13:01:57 3616 bajjer.serialize serialize.py:71 DEBUG start <{jabber:client}iq> level=1 08/06/09 13:01:57 3616 bajjer.serialize serialize.py:85 DEBUG end <{jabber:client}iq> level=1 08/06/09 13:01:57 3616 bajjer.stream stream.py:351 DEBUG Authorization succeeded 08/06/09 13:01:57 3616 bajjer.io io.py:125 DEBUG SEND: 08/06/09 13:01:57 3616 bajjer.io io.py:167 DEBUG RECV: 08/06/09 13:01:57 3616 bajjer.serialize serialize.py:71 DEBUG start <{jabber:client}iq> level=1 08/06/09 13:01:57 3616 bajjer.serialize serialize.py:71 DEBUG start <{jabber:iq:roster}query> level=2 08/06/09 13:01:57 3616 bajjer.serialize serialize.py:85 DEBUG end <{jabber:iq:roster}query> level=2 08/06/09 13:01:57 3616 bajjer.serialize serialize.py:85 DEBUG end <{jabber:client}iq> level=1 08/06/09 13:01:57 3616 bajjer.io io.py:125 DEBUG SEND: 08/06/09 13:01:57 3616 JabberClient jabberclient.py:82 DEBUG Sending the presence to 'USD-Venue-Server-Lobby(usd-venue.usd.local)@conference.mcs.anl.gov/USD Med Laptop' of type 'available'... 08/06/09 13:01:57 3616 bajjer.io io.py:125 DEBUG SEND: 08/06/09 13:01:57 3616 VenueClient venueclient.py:1468 DEBUG UpdateNodeService: Method UpdateNodeService called 08/06/09 13:01:57 3616 VenueClient venueclient.py:1520 INFO In UpdateStream: transport=multicast 08/06/09 13:01:57 3616 VenueClient venueclient.py:1520 INFO In UpdateStream: transport=multicast 08/06/09 13:01:57 3616 VenueClient venueclient.py:1520 INFO In UpdateStream: transport=multicast 08/06/09 13:01:57 3616 VenueClient venueclient.py:1500 DEBUG Checking preference and starting beacon 08/06/09 13:01:57 3616 VenueClient venueclient.py:1508 DEBUG Starting beacon 08/06/09 13:01:57 3616 VenueClient venueclient.py:1186 INFO VenueClient.StartBeacon: Address 224.2.255.23/57950 08/06/09 13:01:57 3616 RTPBeacon rtpbeacon.py:278 DEBUG Called Start. 08/06/09 13:01:57 3616 VenueClient venueclient.py:1476 DEBUG Setting node service streams 08/06/09 13:01:57 3616 NodeService agnodeservice.py:329 INFO NodeService.SetStreams 08/06/09 13:01:57 3616 NodeService agnodeservice.py:258 INFO NodeService.GetServices 08/06/09 13:01:57 4000 ServiceManager agservicemanager.py:220 INFO AGServiceManager.GetServices 08/06/09 13:01:57 3616 NodeService agnodeservice.py:342 DEBUG Starting service AudioService (priority 5) 08/06/09 13:01:57 3616 NodeService agnodeservice.py:701 INFO NodeService.__SendStreamsToService 08/06/09 13:01:57 3616 NodeService agnodeservice.py:705 DEBUG service capabilities: [consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 8000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L8, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L8, 8000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, PCMU, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, PCMU, 8000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, GSM, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, GSM, 8000, 1, None, None, producer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 16000, 1, None, None] 08/06/09 13:01:57 3616 NodeService agnodeservice.py:707 DEBUG streamDescriptions: StreamDescription: {'description': None, 'any': [], 'encryptionKey': u'Rijndael/697e9286', 'uri': None, 'encryptionFlag': 1, 'capability': [producer, video, ceb001630f60180254b202ab521035bd, H261, 90000, 1, None, None], 'static': False, 'location': multicast 224.2.194.89 64838 127, 'id': u'c0ec25bc072418024af2a167d13fa105', 'networkLocations': [multicast 224.2.194.89 64838 127], 'name': u'USD Venue Server Lobby'} 08/06/09 13:01:57 3616 NodeService agnodeservice.py:726 DEBUG No stream match! Sending no new streams! 08/06/09 13:01:57 3616 NodeService agnodeservice.py:707 DEBUG streamDescriptions: StreamDescription: {'description': None, 'any': [], 'encryptionKey': u'Rijndael/697e9286', 'uri': None, 'encryptionFlag': 1, 'capability': [producer, Beacon, 1, ANY, 0, 1, None, None, consumer, Beacon, 1, ANY, 0, 1, None, None], 'static': False, 'location': multicast 224.2.255.23 57950 127, 'id': u'c0ec25bc0724181643ed6bd4977dc740', 'networkLocations': [multicast 224.2.255.23 57950 127], 'name': u'USD Venue Server Lobby'} 08/06/09 13:01:57 3616 NodeService agnodeservice.py:726 DEBUG No stream match! Sending no new streams! 08/06/09 13:01:57 3616 NodeService agnodeservice.py:707 DEBUG streamDescriptions: StreamDescription: {'description': None, 'any': [], 'encryptionKey': u'Rijndael/697e9286', 'uri': None, 'encryptionFlag': 1, 'capability': [consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 8000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L8, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L8, 8000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, PCMU, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, PCMU, 8000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, GSM, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, GSM, 8000, 1, None, None, producer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 16000, 1, None, None], 'static': False, 'location': multicast 224.2.216.70 59802 127, 'id': u'c0ec25bc072418164422b67344407dd4', 'networkLocations': [multicast 224.2.216.70 59802 127], 'name': u'USD Venue Server Lobby'} 08/06/09 13:01:57 3616 NodeService agnodeservice.py:721 INFO Sending stream (type=[consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 8000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L8, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L8, 8000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, PCMU, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, PCMU, 8000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, GSM, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, GSM, 8000, 1, None, None, producer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 16000, 1, None, None]) to service: http://agn-med.usd.local:62799/Services/AudioService.ceb001630f7818164e3b57df41b5dfca 08/06/09 13:01:57 3724 bajjer.io io.py:167 DEBUG RECV: Welcome! 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/ Offline Storage 08/06/09 13:01:57 3724 bajjer.serialize serialize.py:71 DEBUG start <{jabber:client}message> level=1 08/06/09 13:01:57 3724 bajjer.serialize serialize.py:71 DEBUG start <{jabber:client}subject> level=2 08/06/09 13:01:57 3724 bajjer.serialize serialize.py:85 DEBUG end <{jabber:client}subject> level=2 08/06/09 13:01:57 3724 bajjer.serialize serialize.py:71 DEBUG start <{jabber:client}body> level=2 08/06/09 13:01:57 3724 bajjer.serialize serialize.py:85 DEBUG end <{jabber:client}body> level=2 08/06/09 13:01:57 3724 bajjer.serialize serialize.py:71 DEBUG start <{jabber:x:delay}x> level=2 08/06/09 13:01:57 3724 bajjer.serialize serialize.py:85 DEBUG end <{jabber:x:delay}x> level=2 08/06/09 13:01:57 3724 bajjer.serialize serialize.py:85 DEBUG end <{jabber:client}message> level=1 08/06/09 13:01:57 3724 JabberClient jabberclient.py:151 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/06/09 13:01:57 3724 bajjer.io io.py:167 DEBUG RECV: 08/06/09 13:01:57 3724 bajjer.serialize serialize.py:71 DEBUG start <{jabber:client}presence> level=1 08/06/09 13:01:57 3724 bajjer.serialize serialize.py:71 DEBUG start <{jabber:client}x> level=2 08/06/09 13:01:57 3724 bajjer.serialize serialize.py:85 DEBUG end <{jabber:client}x> level=2 08/06/09 13:01:57 3724 bajjer.serialize serialize.py:71 DEBUG start <{http://jabber.org/protocol/muc#user}x> level=2 08/06/09 13:01:57 3724 bajjer.serialize serialize.py:71 DEBUG start <{http://jabber.org/protocol/muc#user}item> level=3 08/06/09 13:01:57 3724 bajjer.serialize serialize.py:85 DEBUG end <{http://jabber.org/protocol/muc#user}item> level=3 08/06/09 13:01:57 3724 bajjer.serialize serialize.py:85 DEBUG end <{http://jabber.org/protocol/muc#user}x> level=2 08/06/09 13:01:57 3724 bajjer.serialize serialize.py:85 DEBUG end <{jabber:client}presence> level=1 08/06/09 13:01:57 3724 JabberClient jabberclient.py:171 DEBUG usd-venue-server-lobby(usd-venue.usd.local)@conference.mcs.anl.gov/USD Med Laptop is available (None / None) 08/06/09 13:01:57 3724 VenueClient venueclientui.py:2836 DEBUG add user: USD Med Laptop 08/06/09 13:01:58 3724 bajjer.io io.py:167 DEBUG RECV: usd-venue-server-lobby(usd-venue.usd.local) 08/06/09 13:01:58 3724 bajjer.serialize serialize.py:71 DEBUG start <{jabber:client}message> level=1 08/06/09 13:01:58 3724 bajjer.serialize serialize.py:71 DEBUG start <{jabber:client}body> level=2 08/06/09 13:01:58 3724 bajjer.serialize serialize.py:85 DEBUG end <{jabber:client}body> level=2 08/06/09 13:01:58 3724 bajjer.serialize serialize.py:85 DEBUG end <{jabber:client}message> level=1 08/06/09 13:01:58 3724 JabberClient jabberclient.py:151 DEBUG usd-venue-server-lobby(usd-venue.usd.local)@conference.mcs.anl.go: usd-venue-server-lobby(usd-venue.usd.local) 08/06/09 13:01:58 3724 bajjer.io io.py:167 DEBUG RECV: This room supports the MUC protocol. 08/06/09 13:01:58 3724 bajjer.serialize serialize.py:71 DEBUG start <{jabber:client}message> level=1 08/06/09 13:01:58 3724 bajjer.serialize serialize.py:71 DEBUG start <{jabber:client}body> level=2 08/06/09 13:01:58 3724 bajjer.serialize serialize.py:85 DEBUG end <{jabber:client}body> level=2 08/06/09 13:01:58 3724 bajjer.serialize serialize.py:85 DEBUG end <{jabber:client}message> level=1 08/06/09 13:01:58 3724 bajjer.io io.py:167 DEBUG RECV: USD Med Laptop has joined this session 08/06/09 13:01:58 3724 bajjer.serialize serialize.py:71 DEBUG start <{jabber:client}message> level=1 08/06/09 13:01:58 3724 bajjer.serialize serialize.py:71 DEBUG start <{jabber:client}body> level=2 08/06/09 13:01:58 3724 bajjer.serialize serialize.py:85 DEBUG end <{jabber:client}body> level=2 08/06/09 13:01:58 3724 bajjer.serialize serialize.py:85 DEBUG end <{jabber:client}message> level=1 08/06/09 13:01:58 3724 JabberClient jabberclient.py:151 DEBUG usd-venue-server-lobby(usd-venue.usd.local)@conference.mcs.anl.go: This room supports the MUC protocol. 08/06/09 13:01:58 3724 JabberClient jabberclient.py:151 DEBUG usd-venue-server-lobby(usd-venue.usd.local)@conference.mcs.anl.go: USD Med Laptop has joined this session 08/06/09 13:01:58 3616 NodeService agnodeservice.py:342 DEBUG Starting service VideoProducerService (priority 5) 08/06/09 13:01:58 3616 NodeService agnodeservice.py:701 INFO NodeService.__SendStreamsToService 08/06/09 13:01:58 3616 NodeService agnodeservice.py:705 DEBUG service capabilities: [producer, video, ceb0016308c418164ef401c4b40dc782, H261, 90000, 1, None, None] 08/06/09 13:01:58 3616 NodeService agnodeservice.py:707 DEBUG streamDescriptions: StreamDescription: {'description': None, 'any': [], 'encryptionKey': u'Rijndael/697e9286', 'uri': None, 'encryptionFlag': 1, 'capability': [producer, video, ceb001630f60180254b202ab521035bd, H261, 90000, 1, None, None], 'static': False, 'location': multicast 224.2.194.89 64838 127, 'id': u'c0ec25bc072418024af2a167d13fa105', 'networkLocations': [multicast 224.2.194.89 64838 127], 'name': u'USD Venue Server Lobby'} 08/06/09 13:01:58 3616 NodeService agnodeservice.py:721 INFO Sending stream (type=[producer, video, ceb001630f60180254b202ab521035bd, H261, 90000, 1, None, None]) to service: http://agn-med.usd.local:61676/Services/VideoProducerService.ceb0016308c418164fccdd43a0936c85 08/06/09 13:01:58 3616 NodeService agnodeservice.py:707 DEBUG streamDescriptions: StreamDescription: {'description': None, 'any': [], 'encryptionKey': u'Rijndael/697e9286', 'uri': None, 'encryptionFlag': 1, 'capability': [producer, Beacon, 1, ANY, 0, 1, None, None, consumer, Beacon, 1, ANY, 0, 1, None, None], 'static': False, 'location': multicast 224.2.255.23 57950 127, 'id': u'c0ec25bc0724181643ed6bd4977dc740', 'networkLocations': [multicast 224.2.255.23 57950 127], 'name': u'USD Venue Server Lobby'} 08/06/09 13:01:58 3616 NodeService agnodeservice.py:726 DEBUG No stream match! Sending no new streams! 08/06/09 13:01:58 3616 NodeService agnodeservice.py:707 DEBUG streamDescriptions: StreamDescription: {'description': None, 'any': [], 'encryptionKey': u'Rijndael/697e9286', 'uri': None, 'encryptionFlag': 1, 'capability': [consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 8000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L8, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L8, 8000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, PCMU, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, PCMU, 8000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, GSM, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, GSM, 8000, 1, None, None, producer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 16000, 1, None, None], 'static': False, 'location': multicast 224.2.216.70 59802 127, 'id': u'c0ec25bc072418164422b67344407dd4', 'networkLocations': [multicast 224.2.216.70 59802 127], 'name': u'USD Venue Server Lobby'} 08/06/09 13:01:58 3616 NodeService agnodeservice.py:726 DEBUG No stream match! Sending no new streams! 08/06/09 13:01:58 3616 NodeService agnodeservice.py:342 DEBUG Starting service VideoConsumerService (priority 7) 08/06/09 13:01:58 3616 NodeService agnodeservice.py:701 INFO NodeService.__SendStreamsToService 08/06/09 13:01:58 3616 NodeService agnodeservice.py:705 DEBUG service capabilities: [consumer, video, ceb00163022818164e9101e336966021, H261, 90000, 1, None, None] 08/06/09 13:01:58 3616 NodeService agnodeservice.py:707 DEBUG streamDescriptions: StreamDescription: {'description': None, 'any': [], 'encryptionKey': u'Rijndael/697e9286', 'uri': None, 'encryptionFlag': 1, 'capability': [producer, video, ceb001630f60180254b202ab521035bd, H261, 90000, 1, None, None], 'static': False, 'location': multicast 224.2.194.89 64838 127, 'id': u'c0ec25bc072418024af2a167d13fa105', 'networkLocations': [multicast 224.2.194.89 64838 127], 'name': u'USD Venue Server Lobby'} 08/06/09 13:01:58 3616 NodeService agnodeservice.py:721 INFO Sending stream (type=[producer, video, ceb001630f60180254b202ab521035bd, H261, 90000, 1, None, None]) to service: http://agn-med.usd.local:55569/Services/VideoConsumerService.ceb00163022818164e9fdc86683949e8 08/06/09 13:01:58 3616 NodeService agnodeservice.py:707 DEBUG streamDescriptions: StreamDescription: {'description': None, 'any': [], 'encryptionKey': u'Rijndael/697e9286', 'uri': None, 'encryptionFlag': 1, 'capability': [producer, Beacon, 1, ANY, 0, 1, None, None, consumer, Beacon, 1, ANY, 0, 1, None, None], 'static': False, 'location': multicast 224.2.255.23 57950 127, 'id': u'c0ec25bc0724181643ed6bd4977dc740', 'networkLocations': [multicast 224.2.255.23 57950 127], 'name': u'USD Venue Server Lobby'} 08/06/09 13:01:58 3616 NodeService agnodeservice.py:726 DEBUG No stream match! Sending no new streams! 08/06/09 13:01:58 3616 NodeService agnodeservice.py:707 DEBUG streamDescriptions: StreamDescription: {'description': None, 'any': [], 'encryptionKey': u'Rijndael/697e9286', 'uri': None, 'encryptionFlag': 1, 'capability': [consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 8000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L8, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L8, 8000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, PCMU, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, PCMU, 8000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, GSM, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, GSM, 8000, 1, None, None, producer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 16000, 1, None, None], 'static': False, 'location': multicast 224.2.216.70 59802 127, 'id': u'c0ec25bc072418164422b67344407dd4', 'networkLocations': [multicast 224.2.216.70 59802 127], 'name': u'USD Venue Server Lobby'} 08/06/09 13:01:58 3616 NodeService agnodeservice.py:726 DEBUG No stream match! Sending no new streams! 08/06/09 13:01:58 3616 VenueClient venueclient.py:1141 DEBUG Updating client profile cache. 08/06/09 13:02:09 932 VenueClient venueclientui.py:2141 INFO Entering venue at https://usd-venue.usd.local:8000/Venues/c0ec25bc12c81692cd27b5bb85eee477 08/06/09 13:02:09 932 VenueClient venueclient.py:1410 INFO ExitVenue 08/06/09 13:02:09 932 VenueClient venueclient.py:1451 INFO ExitVenue: Stopping node services 08/06/09 13:02:09 932 NodeService agnodeservice.py:301 INFO NodeService.StopServices 08/06/09 13:02:09 1092 ServiceManager agservicemanager.py:228 INFO AGServiceManager.StopServices 08/06/09 13:02:10 932 NodeService agnodeservice.py:329 INFO NodeService.SetStreams 08/06/09 13:02:10 932 NodeService agnodeservice.py:258 INFO NodeService.GetServices 08/06/09 13:02:10 2744 ServiceManager agservicemanager.py:220 INFO AGServiceManager.GetServices 08/06/09 13:02:10 932 NodeService agnodeservice.py:342 DEBUG Starting service AudioService (priority 5) 08/06/09 13:02:10 932 NodeService agnodeservice.py:701 INFO NodeService.__SendStreamsToService 08/06/09 13:02:10 932 NodeService agnodeservice.py:705 DEBUG service capabilities: [consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 8000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L8, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L8, 8000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, PCMU, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, PCMU, 8000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, GSM, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, GSM, 8000, 1, None, None, producer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 16000, 1, None, None] 08/06/09 13:02:10 932 NodeService agnodeservice.py:342 DEBUG Starting service VideoProducerService (priority 5) 08/06/09 13:02:10 932 NodeService agnodeservice.py:701 INFO NodeService.__SendStreamsToService 08/06/09 13:02:10 932 NodeService agnodeservice.py:705 DEBUG service capabilities: [producer, video, ceb0016308c418164ef401c4b40dc782, H261, 90000, 1, None, None] 08/06/09 13:02:10 932 NodeService agnodeservice.py:342 DEBUG Starting service VideoConsumerService (priority 7) 08/06/09 13:02:10 932 NodeService agnodeservice.py:701 INFO NodeService.__SendStreamsToService 08/06/09 13:02:10 932 NodeService agnodeservice.py:705 DEBUG service capabilities: [consumer, video, ceb00163022818164e9101e336966021, H261, 90000, 1, None, None] 08/06/09 13:02:10 932 VenueClient venueclient.py:1362 DEBUG ExitVenue: cancelling heartbeat timer 08/06/09 13:02:11 932 VenueClient venueclient.py:1381 DEBUG ExitVenue: Stop event client obj 08/06/09 13:02:11 932 VenueClient venueclient.py:1383 DEBUG ExitVenue: Remove event client reference 08/06/09 13:02:11 932 VenueClient venueclient.py:1388 INFO ExitVenue: Stopping text client 08/06/09 13:02:11 932 JabberClient jabberclient.py:82 DEBUG Sending the presence to 'USD-Venue-Server-Lobby(usd-venue.usd.local)@conference.mcs.anl.gov/USD Med Laptop' of type 'unavailable'... 08/06/09 13:02:11 932 bajjer.io io.py:125 DEBUG SEND: 08/06/09 13:02:11 932 RTPBeacon rtpbeacon.py:296 DEBUG Called Stop. 08/06/09 13:02:11 932 VenueClientController venueclientcontroller.py:457 DEBUG VenueClientController calling Venue.EnterVenue 08/06/09 13:02:11 932 VenueClient venueclient.py:1283 DEBUG EnterVenue; url=https://usd-venue.usd.local:8000/Venues/c0ec25bc12c81692cd27b5bb85eee477 type= 08/06/09 13:02:11 932 NodeService agnodeservice.py:663 INFO NodeService.GetCapabilities 08/06/09 13:02:11 932 NodeService agnodeservice.py:258 INFO NodeService.GetServices 08/06/09 13:02:11 3968 ServiceManager agservicemanager.py:220 INFO AGServiceManager.GetServices 08/06/09 13:02:11 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 16000, 1, None, None 08/06/09 13:02:11 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 8000, 1, None, None 08/06/09 13:02:11 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L8, 16000, 1, None, None 08/06/09 13:02:11 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L8, 8000, 1, None, None 08/06/09 13:02:11 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: consumer, audio, ceb001630f7818164e2d01cace7cb1d6, PCMU, 16000, 1, None, None 08/06/09 13:02:11 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: consumer, audio, ceb001630f7818164e2d01cace7cb1d6, PCMU, 8000, 1, None, None 08/06/09 13:02:11 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: consumer, audio, ceb001630f7818164e2d01cace7cb1d6, GSM, 16000, 1, None, None 08/06/09 13:02:11 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: consumer, audio, ceb001630f7818164e2d01cace7cb1d6, GSM, 8000, 1, None, None 08/06/09 13:02:11 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: producer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 16000, 1, None, None 08/06/09 13:02:11 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: consumer, video, ceb00163022818164e9101e336966021, H261, 90000, 1, None, None 08/06/09 13:02:11 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: producer, video, ceb0016308c418164ef401c4b40dc782, H261, 90000, 1, None, None 08/06/09 13:02:11 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: producer, Beacon, 1, ANY, 0, 1, None, None 08/06/09 13:02:11 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: consumer, Beacon, 1, ANY, 0, 1, None, None 08/06/09 13:02:11 932 VenueClient venueclient.py:1320 DEBUG calling __EnterVenue 08/06/09 13:02:11 932 VenueClient venueclient.py:1021 DEBUG EnterVenue: Invoke Venue.Enter 08/06/09 13:02:11 932 VenueClient venueclient.py:1328 ERROR Socket exception entering venue Traceback (most recent call last): File "C:\Python24\lib\site-packages\AccessGrid3\AccessGrid\VenueClient.py", line 1321, in EnterVenue self.__EnterVenue(URL,withcert) File "C:\Python24\lib\site-packages\AccessGrid3\AccessGrid\VenueClient.py", line 1022, in __EnterVenue self.profile.connectionId = self.__venueProxy.Enter( self.profile ) File "C:\Python24\lib\site-packages\AccessGrid3\AccessGrid\interfaces\Venue_client.py", line 38, in Enter self.binding.Send(None, None, request, soapaction="urn:#Enter", **kw) File "C:\Python24\lib\site-packages\ZSI\client.py", line 266, in Send self.h.connect() File "C:\Python24\lib\site-packages\M2Crypto\httpslib.py", line 50, in connect self.sock.connect((self.host, self.port)) File "C:\Python24\lib\site-packages\M2Crypto\SSL\Connection.py", line 165, in connect self.socket.connect(addr) File "", line 1, in connect gaierror: (11001, 'getaddrinfo failed') 08/06/09 13:02:11 1656 RTPBeacon rtpbeacon.py:289 INFO RTPBeacon.UpdateThread exiting 08/06/09 13:02:11 3724 bajjer.io io.py:167 DEBUG RECV: 08/06/09 13:02:11 932 VenueClient venueclientui.py:3182 DEBUG bin.VenueClient::EnterVenue: Enter venue with url: https://usd-venue.usd.local:8000/Venues/c0ec25bc12c81692cd27b5bb85eee477 08/06/09 13:02:11 3724 bajjer.serialize serialize.py:71 DEBUG start <{jabber:client}presence> level=1 08/06/09 13:02:11 932 VenueClient venueclientui.py:3198 DEBUG warningString: getaddrinfo failed 08/06/09 13:02:11 3724 bajjer.serialize serialize.py:71 DEBUG start <{jabber:client}x> level=2 08/06/09 13:02:11 932 VenueClientController venueclientcontroller.py:459 DEBUG VenueClientController after Venue.EnterVenue 08/06/09 13:02:11 3724 bajjer.serialize serialize.py:85 DEBUG end <{jabber:client}x> level=2 08/06/09 13:02:11 3724 bajjer.serialize serialize.py:71 DEBUG start <{http://jabber.org/protocol/muc#user}x> level=2 08/06/09 13:02:11 3724 bajjer.serialize serialize.py:71 DEBUG start <{http://jabber.org/protocol/muc#user}item> level=3 08/06/09 13:02:11 3724 bajjer.serialize serialize.py:85 DEBUG end <{http://jabber.org/protocol/muc#user}item> level=3 08/06/09 13:02:11 3724 bajjer.serialize serialize.py:85 DEBUG end <{http://jabber.org/protocol/muc#user}x> level=2 08/06/09 13:02:11 3724 bajjer.serialize serialize.py:85 DEBUG end <{jabber:client}presence> level=1 08/06/09 13:02:11 3724 JabberClient jabberclient.py:174 DEBUG usd-venue-server-lobby(usd-venue.usd.local)@conference.mcs.anl.gov/USD Med Laptop is unavailable (None / None) 08/06/09 13:02:11 3724 VenueClient venueclientui.py:2850 DEBUG remove user: USD Med Laptop 08/06/09 13:02:11 932 VenueClient venueclientui.py:4013 DEBUG ContentListPanel.RemoveParticipant: Remove participant 08/06/09 13:02:16 932 VenueClient venueclientui.py:2141 INFO Entering venue at https://usd-venue.usd.edu:8000/Venues/default 08/06/09 13:02:16 932 VenueClientController venueclientcontroller.py:457 DEBUG VenueClientController calling Venue.EnterVenue 08/06/09 13:02:16 932 VenueClient venueclient.py:1283 DEBUG EnterVenue; url=https://usd-venue.usd.edu:8000/Venues/default type= 08/06/09 13:02:16 932 NodeService agnodeservice.py:663 INFO NodeService.GetCapabilities 08/06/09 13:02:16 932 NodeService agnodeservice.py:258 INFO NodeService.GetServices 08/06/09 13:02:16 1412 ServiceManager agservicemanager.py:220 INFO AGServiceManager.GetServices 08/06/09 13:02:16 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 16000, 1, None, None 08/06/09 13:02:16 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 8000, 1, None, None 08/06/09 13:02:16 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L8, 16000, 1, None, None 08/06/09 13:02:16 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L8, 8000, 1, None, None 08/06/09 13:02:16 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: consumer, audio, ceb001630f7818164e2d01cace7cb1d6, PCMU, 16000, 1, None, None 08/06/09 13:02:16 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: consumer, audio, ceb001630f7818164e2d01cace7cb1d6, PCMU, 8000, 1, None, None 08/06/09 13:02:16 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: consumer, audio, ceb001630f7818164e2d01cace7cb1d6, GSM, 16000, 1, None, None 08/06/09 13:02:16 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: consumer, audio, ceb001630f7818164e2d01cace7cb1d6, GSM, 8000, 1, None, None 08/06/09 13:02:16 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: producer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 16000, 1, None, None 08/06/09 13:02:16 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: consumer, video, ceb00163022818164e9101e336966021, H261, 90000, 1, None, None 08/06/09 13:02:16 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: producer, video, ceb0016308c418164ef401c4b40dc782, H261, 90000, 1, None, None 08/06/09 13:02:16 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: producer, Beacon, 1, ANY, 0, 1, None, None 08/06/09 13:02:16 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: consumer, Beacon, 1, ANY, 0, 1, None, None 08/06/09 13:02:16 932 VenueClient venueclient.py:1320 DEBUG calling __EnterVenue 08/06/09 13:02:16 932 VenueClient venueclient.py:1021 DEBUG EnterVenue: Invoke Venue.Enter 08/06/09 13:02:16 932 VenueClient venueclient.py:1023 DEBUG after Venue.Enter 08/06/09 13:02:16 932 VenueClient venueclient.py:1025 DEBUG EnterVenue: Invoke Venue.getstate 08/06/09 13:02:16 932 VenueClient venueclient.py:1027 DEBUG EnterVenue: done Venue.getstate 08/06/09 13:02:18 932 VenueClient venueclient.py:1061 DEBUG Setting isInVenue flag. 08/06/09 13:02:18 932 VenueClient venueclient.py:1322 DEBUG after __EnterVenue 08/06/09 13:02:18 932 VenueClient venueclientui.py:3182 DEBUG bin.VenueClient::EnterVenue: Enter venue with url: https://usd-venue.usd.edu:8000/Venues/default 08/06/09 13:02:18 1100 VenueClient venueclient.py:593 DEBUG Calling Heartbeat, time now: 1249581738 08/06/09 13:02:18 932 VenueClient venueclientui.py:3249 DEBUG Load Venue data store data 08/06/09 13:02:18 932 VenueClient venueclientui.py:3251 DEBUG Amount of entries: 0 08/06/09 13:02:18 932 VenueClient venueclientui.py:3303 DEBUG Entered venue 08/06/09 13:02:18 932 VenueClientController venueclientcontroller.py:459 DEBUG VenueClientController after Venue.EnterVenue 08/06/09 13:02:18 932 VenueClient venueclientui.py:3570 INFO AddConnections: displayMode = exits 08/06/09 13:02:18 1100 VenueClient venueclient.py:617 DEBUG Next Heartbeat needed within 36s 08/06/09 13:02:18 1100 VenueClient venueclient.py:627 DEBUG heartBeatCounter = 2 08/06/09 13:02:18 1100 JabberClient jabberclient.py:82 DEBUG Sending the presence to 'USD-Venue-Server-Lobby(usd-venue.usd.local)@conference.mcs.anl.gov/USD Med Laptop' of type 'available'... 08/06/09 13:02:18 1100 bajjer.io io.py:125 DEBUG SEND: 08/06/09 13:02:18 1100 VenueClient venueclient.py:1468 DEBUG UpdateNodeService: Method UpdateNodeService called 08/06/09 13:02:18 1100 VenueClient venueclient.py:1520 INFO In UpdateStream: transport=multicast 08/06/09 13:02:18 1100 VenueClient venueclient.py:1520 INFO In UpdateStream: transport=multicast 08/06/09 13:02:18 1100 VenueClient venueclient.py:1520 INFO In UpdateStream: transport=multicast 08/06/09 13:02:18 1100 VenueClient venueclient.py:1500 DEBUG Checking preference and starting beacon 08/06/09 13:02:18 1100 VenueClient venueclient.py:1504 DEBUG Stopping beacon 08/06/09 13:02:18 1100 RTPBeacon rtpbeacon.py:296 DEBUG Called Stop. 08/06/09 13:02:18 1100 VenueClient venueclient.py:1508 DEBUG Starting beacon 08/06/09 13:02:18 1100 VenueClient venueclient.py:1178 INFO Beacon being reconfigured, stopping running beacon 08/06/09 13:02:18 1100 RTPBeacon rtpbeacon.py:296 DEBUG Called Stop. 08/06/09 13:02:18 1100 VenueClient venueclient.py:1186 INFO VenueClient.StartBeacon: Address 224.2.200.125/51488 08/06/09 13:02:18 1100 RTPBeacon rtpbeacon.py:278 DEBUG Called Start. 08/06/09 13:02:18 1100 VenueClient venueclient.py:1476 DEBUG Setting node service streams 08/06/09 13:02:18 1100 NodeService agnodeservice.py:329 INFO NodeService.SetStreams 08/06/09 13:02:18 1100 NodeService agnodeservice.py:258 INFO NodeService.GetServices 08/06/09 13:02:18 2052 ServiceManager agservicemanager.py:220 INFO AGServiceManager.GetServices 08/06/09 13:02:18 1100 NodeService agnodeservice.py:342 DEBUG Starting service AudioService (priority 5) 08/06/09 13:02:18 1100 NodeService agnodeservice.py:701 INFO NodeService.__SendStreamsToService 08/06/09 13:02:18 1100 NodeService agnodeservice.py:705 DEBUG service capabilities: [consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 8000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L8, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L8, 8000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, PCMU, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, PCMU, 8000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, GSM, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, GSM, 8000, 1, None, None, producer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 16000, 1, None, None] 08/06/09 13:02:18 1100 NodeService agnodeservice.py:707 DEBUG streamDescriptions: StreamDescription: {'description': None, 'any': [], 'encryptionKey': u'Rijndael/697e9286', 'uri': None, 'encryptionFlag': 1, 'capability': [producer, video, ceb001630f60180254b202ab521035bd, H261, 90000, 1, None, None], 'static': False, 'location': multicast 224.2.194.89 64838 127, 'id': u'c0ec25bc072418024af2a167d13fa105', 'networkLocations': [multicast 224.2.194.89 64838 127], 'name': u'USD Venue Server Lobby'} 08/06/09 13:02:18 1100 NodeService agnodeservice.py:726 DEBUG No stream match! Sending no new streams! 08/06/09 13:02:18 1100 NodeService agnodeservice.py:707 DEBUG streamDescriptions: StreamDescription: {'description': None, 'any': [], 'encryptionKey': u'Rijndael/697e9286', 'uri': None, 'encryptionFlag': 1, 'capability': [producer, Beacon, 1, ANY, 0, 1, None, None, consumer, Beacon, 1, ANY, 0, 1, None, None], 'static': False, 'location': multicast 224.2.200.125 51488 127, 'id': u'c0ec25bc072418164d9d4a924ff4cace', 'networkLocations': [multicast 224.2.200.125 51488 127], 'name': u'USD Venue Server Lobby'} 08/06/09 13:02:18 1100 NodeService agnodeservice.py:726 DEBUG No stream match! Sending no new streams! 08/06/09 13:02:18 1100 NodeService agnodeservice.py:707 DEBUG streamDescriptions: StreamDescription: {'description': None, 'any': [], 'encryptionKey': u'Rijndael/697e9286', 'uri': None, 'encryptionFlag': 1, 'capability': [consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 8000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L8, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L8, 8000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, PCMU, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, PCMU, 8000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, GSM, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, GSM, 8000, 1, None, None, producer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 16000, 1, None, None], 'static': False, 'location': multicast 224.2.204.23 49304 127, 'id': u'c0ec25bc072418164dcc39c67ce38049', 'networkLocations': [multicast 224.2.204.23 49304 127], 'name': u'USD Venue Server Lobby'} 08/06/09 13:02:18 1100 NodeService agnodeservice.py:721 INFO Sending stream (type=[consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 8000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L8, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L8, 8000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, PCMU, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, PCMU, 8000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, GSM, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, GSM, 8000, 1, None, None, producer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 16000, 1, None, None]) to service: http://agn-med.usd.local:62799/Services/AudioService.ceb001630f7818164e3b57df41b5dfca 08/06/09 13:02:18 3724 bajjer.io io.py:167 DEBUG RECV: 08/06/09 13:02:18 3724 bajjer.serialize serialize.py:71 DEBUG start <{jabber:client}presence> level=1 08/06/09 13:02:18 3724 bajjer.serialize serialize.py:71 DEBUG start <{jabber:client}x> level=2 08/06/09 13:02:18 3724 bajjer.serialize serialize.py:85 DEBUG end <{jabber:client}x> level=2 08/06/09 13:02:18 3724 bajjer.serialize serialize.py:71 DEBUG start <{http://jabber.org/protocol/muc#user}x> level=2 08/06/09 13:02:18 3724 bajjer.serialize serialize.py:71 DEBUG start <{http://jabber.org/protocol/muc#user}item> level=3 08/06/09 13:02:18 3724 bajjer.serialize serialize.py:85 DEBUG end <{http://jabber.org/protocol/muc#user}item> level=3 08/06/09 13:02:18 3724 bajjer.serialize serialize.py:85 DEBUG end <{http://jabber.org/protocol/muc#user}x> level=2 08/06/09 13:02:18 3724 bajjer.serialize serialize.py:85 DEBUG end <{jabber:client}presence> level=1 08/06/09 13:02:18 3724 JabberClient jabberclient.py:171 DEBUG usd-venue-server-lobby(usd-venue.usd.local)@conference.mcs.anl.gov/USD Med Laptop is available (None / None) 08/06/09 13:02:18 3724 VenueClient venueclientui.py:2836 DEBUG add user: USD Med Laptop 08/06/09 13:02:18 932 GroupMsgClient groupmsgclient.py:120 ERROR connection failed: DNS lookup failed: address 'usd-venue.usd.local' not found: (11001, 'getaddrinfo failed'). 08/06/09 13:02:18 1100 NodeService agnodeservice.py:342 DEBUG Starting service VideoProducerService (priority 5) 08/06/09 13:02:18 1100 NodeService agnodeservice.py:701 INFO NodeService.__SendStreamsToService 08/06/09 13:02:18 1100 NodeService agnodeservice.py:705 DEBUG service capabilities: [producer, video, ceb0016308c418164ef401c4b40dc782, H261, 90000, 1, None, None] 08/06/09 13:02:18 1100 NodeService agnodeservice.py:707 DEBUG streamDescriptions: StreamDescription: {'description': None, 'any': [], 'encryptionKey': u'Rijndael/697e9286', 'uri': None, 'encryptionFlag': 1, 'capability': [producer, video, ceb001630f60180254b202ab521035bd, H261, 90000, 1, None, None], 'static': False, 'location': multicast 224.2.194.89 64838 127, 'id': u'c0ec25bc072418024af2a167d13fa105', 'networkLocations': [multicast 224.2.194.89 64838 127], 'name': u'USD Venue Server Lobby'} 08/06/09 13:02:18 1100 NodeService agnodeservice.py:721 INFO Sending stream (type=[producer, video, ceb001630f60180254b202ab521035bd, H261, 90000, 1, None, None]) to service: http://agn-med.usd.local:61676/Services/VideoProducerService.ceb0016308c418164fccdd43a0936c85 08/06/09 13:02:19 3724 bajjer.io io.py:167 DEBUG RECV: usd-venue-server-lobby(usd-venue.usd.local) 08/06/09 13:02:19 3724 bajjer.serialize serialize.py:71 DEBUG start <{jabber:client}message> level=1 08/06/09 13:02:19 3724 bajjer.serialize serialize.py:71 DEBUG start <{jabber:client}body> level=2 08/06/09 13:02:19 3724 bajjer.serialize serialize.py:85 DEBUG end <{jabber:client}body> level=2 08/06/09 13:02:19 3724 bajjer.serialize serialize.py:85 DEBUG end <{jabber:client}message> level=1 08/06/09 13:02:19 3724 JabberClient jabberclient.py:151 DEBUG usd-venue-server-lobby(usd-venue.usd.local)@conference.mcs.anl.go: usd-venue-server-lobby(usd-venue.usd.local) 08/06/09 13:02:19 3724 bajjer.io io.py:167 DEBUG RECV: This room supports the MUC protocol. 08/06/09 13:02:19 3724 bajjer.serialize serialize.py:71 DEBUG start <{jabber:client}message> level=1 08/06/09 13:02:19 3724 bajjer.serialize serialize.py:71 DEBUG start <{jabber:client}body> level=2 08/06/09 13:02:19 3724 bajjer.serialize serialize.py:85 DEBUG end <{jabber:client}body> level=2 08/06/09 13:02:19 3724 bajjer.serialize serialize.py:85 DEBUG end <{jabber:client}message> level=1 08/06/09 13:02:19 3724 bajjer.io io.py:167 DEBUG RECV: USD Med Laptop has joined this session 08/06/09 13:02:19 3724 bajjer.serialize serialize.py:71 DEBUG start <{jabber:client}message> level=1 08/06/09 13:02:19 3724 bajjer.serialize serialize.py:71 DEBUG start <{jabber:client}body> level=2 08/06/09 13:02:19 3724 bajjer.serialize serialize.py:85 DEBUG end <{jabber:client}body> level=2 08/06/09 13:02:19 3724 bajjer.serialize serialize.py:85 DEBUG end <{jabber:client}message> level=1 08/06/09 13:02:19 3724 JabberClient jabberclient.py:151 DEBUG usd-venue-server-lobby(usd-venue.usd.local)@conference.mcs.anl.go: This room supports the MUC protocol. 08/06/09 13:02:19 3724 JabberClient jabberclient.py:151 DEBUG usd-venue-server-lobby(usd-venue.usd.local)@conference.mcs.anl.go: USD Med Laptop has joined this session 08/06/09 13:02:19 1100 NodeService agnodeservice.py:707 DEBUG streamDescriptions: StreamDescription: {'description': None, 'any': [], 'encryptionKey': u'Rijndael/697e9286', 'uri': None, 'encryptionFlag': 1, 'capability': [producer, Beacon, 1, ANY, 0, 1, None, None, consumer, Beacon, 1, ANY, 0, 1, None, None], 'static': False, 'location': multicast 224.2.200.125 51488 127, 'id': u'c0ec25bc072418164d9d4a924ff4cace', 'networkLocations': [multicast 224.2.200.125 51488 127], 'name': u'USD Venue Server Lobby'} 08/06/09 13:02:19 1100 NodeService agnodeservice.py:726 DEBUG No stream match! Sending no new streams! 08/06/09 13:02:19 1100 NodeService agnodeservice.py:707 DEBUG streamDescriptions: StreamDescription: {'description': None, 'any': [], 'encryptionKey': u'Rijndael/697e9286', 'uri': None, 'encryptionFlag': 1, 'capability': [consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 8000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L8, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L8, 8000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, PCMU, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, PCMU, 8000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, GSM, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, GSM, 8000, 1, None, None, producer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 16000, 1, None, None], 'static': False, 'location': multicast 224.2.204.23 49304 127, 'id': u'c0ec25bc072418164dcc39c67ce38049', 'networkLocations': [multicast 224.2.204.23 49304 127], 'name': u'USD Venue Server Lobby'} 08/06/09 13:02:19 1100 NodeService agnodeservice.py:726 DEBUG No stream match! Sending no new streams! 08/06/09 13:02:19 1100 NodeService agnodeservice.py:342 DEBUG Starting service VideoConsumerService (priority 7) 08/06/09 13:02:19 1100 NodeService agnodeservice.py:701 INFO NodeService.__SendStreamsToService 08/06/09 13:02:19 1100 NodeService agnodeservice.py:705 DEBUG service capabilities: [consumer, video, ceb00163022818164e9101e336966021, H261, 90000, 1, None, None] 08/06/09 13:02:19 1100 NodeService agnodeservice.py:707 DEBUG streamDescriptions: StreamDescription: {'description': None, 'any': [], 'encryptionKey': u'Rijndael/697e9286', 'uri': None, 'encryptionFlag': 1, 'capability': [producer, video, ceb001630f60180254b202ab521035bd, H261, 90000, 1, None, None], 'static': False, 'location': multicast 224.2.194.89 64838 127, 'id': u'c0ec25bc072418024af2a167d13fa105', 'networkLocations': [multicast 224.2.194.89 64838 127], 'name': u'USD Venue Server Lobby'} 08/06/09 13:02:19 1100 NodeService agnodeservice.py:721 INFO Sending stream (type=[producer, video, ceb001630f60180254b202ab521035bd, H261, 90000, 1, None, None]) to service: http://agn-med.usd.local:55569/Services/VideoConsumerService.ceb00163022818164e9fdc86683949e8 08/06/09 13:02:19 1100 NodeService agnodeservice.py:707 DEBUG streamDescriptions: StreamDescription: {'description': None, 'any': [], 'encryptionKey': u'Rijndael/697e9286', 'uri': None, 'encryptionFlag': 1, 'capability': [producer, Beacon, 1, ANY, 0, 1, None, None, consumer, Beacon, 1, ANY, 0, 1, None, None], 'static': False, 'location': multicast 224.2.200.125 51488 127, 'id': u'c0ec25bc072418164d9d4a924ff4cace', 'networkLocations': [multicast 224.2.200.125 51488 127], 'name': u'USD Venue Server Lobby'} 08/06/09 13:02:19 1100 NodeService agnodeservice.py:726 DEBUG No stream match! Sending no new streams! 08/06/09 13:02:19 1100 NodeService agnodeservice.py:707 DEBUG streamDescriptions: StreamDescription: {'description': None, 'any': [], 'encryptionKey': u'Rijndael/697e9286', 'uri': None, 'encryptionFlag': 1, 'capability': [consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 8000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L8, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L8, 8000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, PCMU, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, PCMU, 8000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, GSM, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, GSM, 8000, 1, None, None, producer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 16000, 1, None, None], 'static': False, 'location': multicast 224.2.204.23 49304 127, 'id': u'c0ec25bc072418164dcc39c67ce38049', 'networkLocations': [multicast 224.2.204.23 49304 127], 'name': u'USD Venue Server Lobby'} 08/06/09 13:02:19 1100 NodeService agnodeservice.py:726 DEBUG No stream match! Sending no new streams! 08/06/09 13:02:19 1100 VenueClient venueclient.py:1141 DEBUG Updating client profile cache. 08/06/09 13:02:27 932 VenueClient venueclientui.py:2141 INFO Entering venue at https://usd-venue.usd.local:8000/Venues/c0ec25bc12c81692c1b57540b79b46e1 08/06/09 13:02:27 932 VenueClient venueclient.py:1410 INFO ExitVenue 08/06/09 13:02:27 932 VenueClient venueclient.py:1451 INFO ExitVenue: Stopping node services 08/06/09 13:02:27 932 NodeService agnodeservice.py:301 INFO NodeService.StopServices 08/06/09 13:02:27 3696 ServiceManager agservicemanager.py:228 INFO AGServiceManager.StopServices 08/06/09 13:02:28 932 NodeService agnodeservice.py:329 INFO NodeService.SetStreams 08/06/09 13:02:28 932 NodeService agnodeservice.py:258 INFO NodeService.GetServices 08/06/09 13:02:28 3984 ServiceManager agservicemanager.py:220 INFO AGServiceManager.GetServices 08/06/09 13:02:28 932 NodeService agnodeservice.py:342 DEBUG Starting service AudioService (priority 5) 08/06/09 13:02:28 932 NodeService agnodeservice.py:701 INFO NodeService.__SendStreamsToService 08/06/09 13:02:28 932 NodeService agnodeservice.py:705 DEBUG service capabilities: [consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 8000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L8, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L8, 8000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, PCMU, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, PCMU, 8000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, GSM, 16000, 1, None, None, consumer, audio, ceb001630f7818164e2d01cace7cb1d6, GSM, 8000, 1, None, None, producer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 16000, 1, None, None] 08/06/09 13:02:28 932 NodeService agnodeservice.py:342 DEBUG Starting service VideoProducerService (priority 5) 08/06/09 13:02:28 932 NodeService agnodeservice.py:701 INFO NodeService.__SendStreamsToService 08/06/09 13:02:28 932 NodeService agnodeservice.py:705 DEBUG service capabilities: [producer, video, ceb0016308c418164ef401c4b40dc782, H261, 90000, 1, None, None] 08/06/09 13:02:28 932 NodeService agnodeservice.py:342 DEBUG Starting service VideoConsumerService (priority 7) 08/06/09 13:02:28 932 NodeService agnodeservice.py:701 INFO NodeService.__SendStreamsToService 08/06/09 13:02:28 932 NodeService agnodeservice.py:705 DEBUG service capabilities: [consumer, video, ceb00163022818164e9101e336966021, H261, 90000, 1, None, None] 08/06/09 13:02:28 932 VenueClient venueclient.py:1362 DEBUG ExitVenue: cancelling heartbeat timer 08/06/09 13:02:29 932 VenueClient venueclient.py:1381 DEBUG ExitVenue: Stop event client obj 08/06/09 13:02:29 932 VenueClient venueclient.py:1383 DEBUG ExitVenue: Remove event client reference 08/06/09 13:02:29 932 VenueClient venueclient.py:1388 INFO ExitVenue: Stopping text client 08/06/09 13:02:29 932 JabberClient jabberclient.py:82 DEBUG Sending the presence to 'USD-Venue-Server-Lobby(usd-venue.usd.local)@conference.mcs.anl.gov/USD Med Laptop' of type 'unavailable'... 08/06/09 13:02:29 932 bajjer.io io.py:125 DEBUG SEND: 08/06/09 13:02:29 932 RTPBeacon rtpbeacon.py:296 DEBUG Called Stop. 08/06/09 13:02:29 932 VenueClientController venueclientcontroller.py:457 DEBUG VenueClientController calling Venue.EnterVenue 08/06/09 13:02:29 932 VenueClient venueclient.py:1283 DEBUG EnterVenue; url=https://usd-venue.usd.local:8000/Venues/c0ec25bc12c81692c1b57540b79b46e1 type= 08/06/09 13:02:29 932 NodeService agnodeservice.py:663 INFO NodeService.GetCapabilities 08/06/09 13:02:29 932 NodeService agnodeservice.py:258 INFO NodeService.GetServices 08/06/09 13:02:29 396 ServiceManager agservicemanager.py:220 INFO AGServiceManager.GetServices 08/06/09 13:02:29 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 16000, 1, None, None 08/06/09 13:02:29 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 8000, 1, None, None 08/06/09 13:02:29 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L8, 16000, 1, None, None 08/06/09 13:02:29 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: consumer, audio, ceb001630f7818164e2d01cace7cb1d6, L8, 8000, 1, None, None 08/06/09 13:02:29 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: consumer, audio, ceb001630f7818164e2d01cace7cb1d6, PCMU, 16000, 1, None, None 08/06/09 13:02:29 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: consumer, audio, ceb001630f7818164e2d01cace7cb1d6, PCMU, 8000, 1, None, None 08/06/09 13:02:29 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: consumer, audio, ceb001630f7818164e2d01cace7cb1d6, GSM, 16000, 1, None, None 08/06/09 13:02:29 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: consumer, audio, ceb001630f7818164e2d01cace7cb1d6, GSM, 8000, 1, None, None 08/06/09 13:02:29 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: producer, audio, ceb001630f7818164e2d01cace7cb1d6, L16, 16000, 1, None, None 08/06/09 13:02:29 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: consumer, video, ceb00163022818164e9101e336966021, H261, 90000, 1, None, None 08/06/09 13:02:29 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: producer, video, ceb0016308c418164ef401c4b40dc782, H261, 90000, 1, None, None 08/06/09 13:02:29 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: producer, Beacon, 1, ANY, 0, 1, None, None 08/06/09 13:02:29 932 VenueClient venueclient.py:1295 DEBUG Capability on VenueEnter: consumer, Beacon, 1, ANY, 0, 1, None, None 08/06/09 13:02:29 932 VenueClient venueclient.py:1320 DEBUG calling __EnterVenue 08/06/09 13:02:29 932 VenueClient venueclient.py:1021 DEBUG EnterVenue: Invoke Venue.Enter 08/06/09 13:02:29 932 VenueClient venueclient.py:1328 ERROR Socket exception entering venue Traceback (most recent call last): File "C:\Python24\lib\site-packages\AccessGrid3\AccessGrid\VenueClient.py", line 1321, in EnterVenue self.__EnterVenue(URL,withcert) File "C:\Python24\lib\site-packages\AccessGrid3\AccessGrid\VenueClient.py", line 1022, in __EnterVenue self.profile.connectionId = self.__venueProxy.Enter( self.profile ) File "C:\Python24\lib\site-packages\AccessGrid3\AccessGrid\interfaces\Venue_client.py", line 38, in Enter self.binding.Send(None, None, request, soapaction="urn:#Enter", **kw) File "C:\Python24\lib\site-packages\ZSI\client.py", line 266, in Send self.h.connect() File "C:\Python24\lib\site-packages\M2Crypto\httpslib.py", line 50, in connect self.sock.connect((self.host, self.port)) File "C:\Python24\lib\site-packages\M2Crypto\SSL\Connection.py", line 165, in connect self.socket.connect(addr) File "", line 1, in connect gaierror: (11001, 'getaddrinfo failed') 08/06/09 13:02:29 932 VenueClient venueclientui.py:3182 DEBUG bin.VenueClient::EnterVenue: Enter venue with url: https://usd-venue.usd.local:8000/Venues/c0ec25bc12c81692c1b57540b79b46e1 08/06/09 13:02:29 932 VenueClient venueclientui.py:3198 DEBUG warningString: getaddrinfo failed 08/06/09 13:02:29 932 VenueClientController venueclientcontroller.py:459 DEBUG VenueClientController after Venue.EnterVenue 08/06/09 13:02:29 3724 bajjer.io io.py:167 DEBUG RECV: 08/06/09 13:02:29 3724 bajjer.serialize serialize.py:71 DEBUG start <{jabber:client}presence> level=1 08/06/09 13:02:29 3724 bajjer.serialize serialize.py:71 DEBUG start <{jabber:client}x> level=2 08/06/09 13:02:29 3724 bajjer.serialize serialize.py:85 DEBUG end <{jabber:client}x> level=2 08/06/09 13:02:29 3724 bajjer.serialize serialize.py:71 DEBUG start <{http://jabber.org/protocol/muc#user}x> level=2 08/06/09 13:02:29 3724 bajjer.serialize serialize.py:71 DEBUG start <{http://jabber.org/protocol/muc#user}item> level=3 08/06/09 13:02:29 3724 bajjer.serialize serialize.py:85 DEBUG end <{http://jabber.org/protocol/muc#user}item> level=3 08/06/09 13:02:29 3724 bajjer.serialize serialize.py:85 DEBUG end <{http://jabber.org/protocol/muc#user}x> level=2 08/06/09 13:02:29 3724 bajjer.serialize serialize.py:85 DEBUG end <{jabber:client}presence> level=1 08/06/09 13:02:29 3724 JabberClient jabberclient.py:174 DEBUG usd-venue-server-lobby(usd-venue.usd.local)@conference.mcs.anl.gov/USD Med Laptop is unavailable (None / None) 08/06/09 13:02:29 3724 VenueClient venueclientui.py:2850 DEBUG remove user: USD Med Laptop 08/06/09 13:02:29 932 VenueClient venueclientui.py:4013 DEBUG ContentListPanel.RemoveParticipant: Remove participant 08/06/09 13:02:29 3464 RTPBeacon rtpbeacon.py:289 INFO RTPBeacon.UpdateThread exiting 08/06/09 13:02:34 932 VenueClient venueclientui.py:2694 INFO --------- END VenueClient 08/06/09 13:02:34 932 ServiceManager agservicemanager.py:72 INFO AGServiceManager.Shutdown 08/06/09 13:02:34 932 ServiceManager agservicemanager.py:73 INFO Remove services 08/06/09 13:02:34 932 ServiceManager agservicemanager.py:210 INFO AGServiceManager.RemoveServices 08/06/09 13:02:34 932 ServiceManager agservicemanager.py:163 INFO AGServiceManager.RemoveService 08/06/09 13:02:35 932 ServiceManager agservicemanager.py:163 INFO AGServiceManager.RemoveService 08/06/09 13:02:35 932 ProcessManager processmanager.py:136 WARNING Couldn't terminate process cleanly (258) 08/06/09 13:02:35 932 ServiceManager agservicemanager.py:163 INFO AGServiceManager.RemoveService 08/06/09 13:02:36 932 ProcessManager processmanager.py:136 WARNING Couldn't terminate process cleanly (258) 08/06/09 13:02:36 932 ServiceManager agservicemanager.py:75 INFO Stop network interface 08/06/09 13:02:36 932 RTPBeacon rtpbeacon.py:296 DEBUG Called Stop. 08/06/09 13:02:36 932 VenueClient venueclient.py:1583 INFO Shutting down jabber client 08/06/09 13:02:36 932 VenueClient venueclient.py:1588 INFO Shutting down bridge ping thread