05/08/09 13:49:13 912 Toolkit toolkit.py:691 INFO Service init: have profile None 05/08/09 13:49:13 912 Toolkit toolkit.py:716 INFO Service Initialization Complete. 05/08/09 13:49:13 912 Toolkit venueserver3.py:102 INFO VenueServer running using hostname: USD-venueserv.usd.local 05/08/09 13:49:13 912 Toolkit venueserver3.py:105 INFO Running in secure mode 05/08/09 13:49:13 912 CertificateManager certificatemanager.py:212 DEBUG Opened repository C:\Documents and Settings\Venueserv\Application Data\AccessGrid3\Config\certRepo 05/08/09 13:49:13 912 Toolkit toolkit.py:472 INFO Initialized certificate manager. 05/08/09 13:49:13 912 CertificateManager certificatemanager.py:575 DEBUG Configuring standard environment 05/08/09 13:49:13 912 CertificateManager certificatemanager.py:625 DEBUG Using default identity /O=Access Grid/OU=agdev-ca.mcs.anl.gov/CN=VenueServer/USD-venueserv.usd.edu 05/08/09 13:49:13 912 Toolkit toolkit.py:262 INFO Using unencrypted certificate: C:\Documents and Settings\Venueserv\Application Data\AccessGrid3\Config\certRepo\certificates\d47550f60a65b70c5d129404c9279fd4\3d9b06912172c39276bc034194426a1b\cert.pem C:\Documents and Settings\Venueserv\Application Data\AccessGrid3\Config\certRepo\privatekeys\f346450c606e5140e0be985be9d4d1eb.pem 05/08/09 13:49:13 912 VenueServer venueserver.py:182 DEBUG VenueServer initializing authorization manager. 05/08/09 13:49:13 912 VenueServer venueserver.py:503 DEBUG Reading authorization policy. 05/08/09 13:49:13 912 Toolkit toolkit.py:262 INFO Using unencrypted certificate: C:\Documents and Settings\Venueserv\Application Data\AccessGrid3\Config\certRepo\certificates\d47550f60a65b70c5d129404c9279fd4\3d9b06912172c39276bc034194426a1b\cert.pem C:\Documents and Settings\Venueserv\Application Data\AccessGrid3\Config\certRepo\privatekeys\f346450c606e5140e0be985be9d4d1eb.pem 05/08/09 13:49:13 912 FTPSServer ftpsserver.py:40 DEBUG FTPSServer __init__: path=Data hostname=USD-venueserv.usd.local port=8006 05/08/09 13:49:13 912 FTPSServer ftpsserver.py:77 DEBUG Entered FTPSServer.run_in_thread 05/08/09 13:49:13 580 FTPSServer ftpsserver.py:57 DEBUG Entered FTPSServer.run 05/08/09 13:49:13 912 VenueServer venueserver.py:1353 DEBUG Register service 05/08/09 13:49:13 580 FTPSServer ftps_server.py:338 INFO M2Crypto (Medusa) FTP/TLS server started at Fri May 08 13:49:13 2009 Authz: Hostname: USD-venueserv Port: 8006 05/08/09 13:49:13 912 VenueServer venueserver.py:1353 DEBUG Register service 05/08/09 13:49:13 912 VenueServer venueserver.py:537 DEBUG Reading persisted Venues from: VenueServer.dat 05/08/09 13:49:13 912 VenueServer venueserver.py:542 DEBUG Loading Venue: c0ec25460c706d85cecdcdb4ab4fd7fd 05/08/09 13:49:13 912 VenueServer venue.py:344 DEBUG ------------ STARTING VENUE 05/08/09 13:49:13 912 VenueServer venue.py:383 INFO Venue URI https://USD-venueserv.usd.local:8000/Venues/c0ec25460c706d85cecdcdb4ab4fd7fd 05/08/09 13:49:13 912 VenueServer venue.py:393 DEBUG data store location: Data 05/08/09 13:49:13 912 DataStore datastore.py:227 DEBUG __init__: Datastore path is Data\c0ec25460c706d85cecdcdb4ab4fd7fd 05/08/09 13:49:13 912 DataStore datastore.py:266 DEBUG =================== ENTERED LoadPersistentInfo ================== 05/08/09 13:49:13 912 DataStore datastore.py:267 DEBUG Reading persisted data from: Data\c0ec25460c706d85cecdcdb4ab4fd7fd\DataStore.dat 05/08/09 13:49:13 912 DataStore datastore.py:272 DEBUG Loading a directory in root-dir! 05/08/09 13:49:13 912 DataStore datastore.py:282 DEBUG LoadPersistentInfo: Server Path: Data\c0ec25460c706d85cecdcdb4ab4fd7fd 05/08/09 13:49:13 912 DataStore datastore.py:286 DEBUG Getting file list of ./Data\c0ec25460c706d85cecdcdb4ab4fd7fd\ 05/08/09 13:49:13 912 DataStore datastore.py:296 DEBUG LOADPERSISTENTINFO: Path to use is C:\Documents and Settings\Venueserv\Application Data\AccessGrid3\Data\c0ec25460c706d85cecdcdb4ab4fd7fd 05/08/09 13:49:13 912 DataStore datastore.py:373 DEBUG =================== EXITED LoadPersistentInfo ================== 05/08/09 13:49:13 912 FTPSServer ftpsserver.py:92 DEBUG Entered FTPSServer.GetUploadDescriptor 05/08/09 13:49:13 912 FTPSServer ftpsserver.py:97 DEBUG descriptor = ftps://USD-venueserv.usd.local:8006/c0ec25460c706d85cecdcdb4ab4fd7fd 05/08/09 13:49:13 912 VenueServer venue.py:417 INFO Have upload url: ftps://USD-venueserv.usd.local:8006/c0ec25460c706d85cecdcdb4ab4fd7fd 05/08/09 13:49:13 912 EventService groupmsgservice.py:102 INFO connectionMade None:None 05/08/09 13:49:13 912 EventService groupmsgservice.py:149 INFO addedConnection None:None id:c0ec254608ac69c17a93744bae0cabaa 05/08/09 13:49:13 912 EventClient insecurevenueeventclient.py:60 INFO BaseVenueEventClient made connection. 05/08/09 13:49:13 912 VenueServer venue.py:1156 DEBUG Calling SetConnections. 05/08/09 13:49:13 912 VenueServer venueserver.py:941 INFO initializing with default policy 05/08/09 13:49:13 912 Security authorizationmanager.py:516 INFO Tried to add role that already exists 05/08/09 13:49:13 912 Security authorizationmanager.py:516 INFO Tried to add role that already exists 05/08/09 13:49:13 912 Security authorizationmanager.py:516 INFO Tried to add role that already exists 05/08/09 13:49:13 912 Security authorizationmanager.py:516 INFO Tried to add role that already exists 05/08/09 13:49:13 912 Security authorizationmanager.py:516 INFO Tried to add role that already exists 05/08/09 13:49:13 912 VenueServer venue.py:509 INFO Building auth policy. 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: Enter 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: Exit 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetStreams 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: UpdateLifetime 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: NegotiateCapabilities 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetStaticStreams 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetUploadDescriptor 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: AsVenueDescription 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetRolesForSubject 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: CreateApplication 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: UpdateApplication 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: DestroyApplication 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: UpdateClientProfile 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: AddService 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: RemoveService 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: UpdateService 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetServices 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: AddData 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: UpdateData 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: RemoveData 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetDataStoreInformation 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetDataDescriptions 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: AddNetworkService 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: RemoveNetworkService 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetNetworkServices 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetClients 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetCachedProfiles 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: AddConnection 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: RemoveConnection 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetConnections 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: SetConnections 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetEncryptMedia 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetDescription 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetName 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetApplication 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetApplications 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: AddNetworkLocationToStream 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: RemoveNetworkLocationFromStream 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetEventServiceLocation 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: DetermineSubjectRoles 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: AddNetService 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: RemoveNetService 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: IsAuthorized 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: IsValid 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: AllocateMulticastLocation 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: RecycleMulticastLocation 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetState 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: AddDir 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetDescById 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: RemoveDir 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: HDDump 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetVersion 05/08/09 13:49:13 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetDataSize 05/08/09 13:49:13 912 VenueServer venueserver.py:952 INFO auth policy ? 0 05/08/09 13:49:14 912 Security authorizationmanager.py:568 DEBUG Adding Subject: /O=Access Grid/OU=agdev-ca.mcs.anl.gov/CN=VenueServer/USD-venueserv.usd.edu to Role: Administrators 05/08/09 13:49:14 912 Security authorizationmanager.py:302 DEBUG RequireIdentification: 0 05/08/09 13:49:14 912 VenueServer venue.py:2119 DEBUG CreateApplication: name=AGVCR Launcher - 2008-10-21 07:57:34 AM description=Started by SDSM&T - AGN at 2008-10-21 07:57:34 AM 05/08/09 13:49:14 912 EventService groupmsgservice.py:102 INFO connectionMade None:None 05/08/09 13:49:14 912 EventService groupmsgservice.py:149 INFO addedConnection None:None id:c0ec254608ac69c17ab604bde6639337 05/08/09 13:49:14 912 EventClient insecurevenueeventclient.py:60 INFO BaseVenueEventClient made connection. 05/08/09 13:49:14 912 SharedApplication sharedapplication.py:453 DEBUG Returning channel_id='c0ec254608ac69c17ab5fbd6c36b2378' loc='('USD-venueserv.usd.local', 8002)' 05/08/09 13:49:14 912 VenueServer venue.py:2157 DEBUG CreateApplication: Created id=c0ec25460b98032b6da8f073932e10bc handle=https://USD-venueserv.usd.local:8000/Venues/c0ec25460c706d85cecdcdb4ab4fd7fd/apps/c0ec25460b98032b6da8f073932e10bc 05/08/09 13:49:14 912 VenueServer venueserver.py:542 DEBUG Loading Venue: c0ec2546082c7228fb8c66be5581142e 05/08/09 13:49:14 912 VenueServer venue.py:344 DEBUG ------------ STARTING VENUE 05/08/09 13:49:14 912 VenueServer venue.py:383 INFO Venue URI https://USD-venueserv.usd.local:8000/Venues/c0ec2546082c7228fb8c66be5581142e 05/08/09 13:49:14 912 VenueServer venue.py:393 DEBUG data store location: Data 05/08/09 13:49:14 912 DataStore datastore.py:227 DEBUG __init__: Datastore path is Data\c0ec2546082c7228fb8c66be5581142e 05/08/09 13:49:14 912 DataStore datastore.py:266 DEBUG =================== ENTERED LoadPersistentInfo ================== 05/08/09 13:49:14 912 DataStore datastore.py:267 DEBUG Reading persisted data from: Data\c0ec2546082c7228fb8c66be5581142e\DataStore.dat 05/08/09 13:49:14 912 DataStore datastore.py:272 DEBUG Loading a directory in root-dir! 05/08/09 13:49:14 912 DataStore datastore.py:282 DEBUG LoadPersistentInfo: Server Path: Data\c0ec2546082c7228fb8c66be5581142e 05/08/09 13:49:14 912 DataStore datastore.py:286 DEBUG Getting file list of ./Data\c0ec2546082c7228fb8c66be5581142e\ 05/08/09 13:49:14 912 DataStore datastore.py:296 DEBUG LOADPERSISTENTINFO: Path to use is C:\Documents and Settings\Venueserv\Application Data\AccessGrid3\Data\c0ec2546082c7228fb8c66be5581142e 05/08/09 13:49:14 912 DataStore datastore.py:373 DEBUG =================== EXITED LoadPersistentInfo ================== 05/08/09 13:49:14 912 FTPSServer ftpsserver.py:92 DEBUG Entered FTPSServer.GetUploadDescriptor 05/08/09 13:49:14 912 FTPSServer ftpsserver.py:97 DEBUG descriptor = ftps://USD-venueserv.usd.local:8006/c0ec2546082c7228fb8c66be5581142e 05/08/09 13:49:14 912 VenueServer venue.py:417 INFO Have upload url: ftps://USD-venueserv.usd.local:8006/c0ec2546082c7228fb8c66be5581142e 05/08/09 13:49:14 912 EventService groupmsgservice.py:102 INFO connectionMade None:None 05/08/09 13:49:14 912 EventService groupmsgservice.py:149 INFO addedConnection None:None id:c0ec254608ac69c17ac0c6e40aed1fe8 05/08/09 13:49:14 912 EventClient insecurevenueeventclient.py:60 INFO BaseVenueEventClient made connection. 05/08/09 13:49:14 912 VenueServer venue.py:1156 DEBUG Calling SetConnections. 05/08/09 13:49:14 912 VenueServer venueserver.py:941 INFO initializing with default policy 05/08/09 13:49:14 912 Security authorizationmanager.py:516 INFO Tried to add role that already exists 05/08/09 13:49:14 912 Security authorizationmanager.py:516 INFO Tried to add role that already exists 05/08/09 13:49:14 912 Security authorizationmanager.py:516 INFO Tried to add role that already exists 05/08/09 13:49:14 912 Security authorizationmanager.py:516 INFO Tried to add role that already exists 05/08/09 13:49:14 912 Security authorizationmanager.py:516 INFO Tried to add role that already exists 05/08/09 13:49:14 912 VenueServer venue.py:509 INFO Building auth policy. 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: Enter 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: Exit 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetStreams 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: UpdateLifetime 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: NegotiateCapabilities 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetStaticStreams 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetUploadDescriptor 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: AsVenueDescription 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetRolesForSubject 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: CreateApplication 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: UpdateApplication 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: DestroyApplication 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: UpdateClientProfile 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: AddService 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: RemoveService 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: UpdateService 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetServices 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: AddData 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: UpdateData 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: RemoveData 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetDataStoreInformation 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetDataDescriptions 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: AddNetworkService 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: RemoveNetworkService 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetNetworkServices 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetClients 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetCachedProfiles 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: AddConnection 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: RemoveConnection 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetConnections 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: SetConnections 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetEncryptMedia 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetDescription 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetName 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetApplication 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetApplications 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: AddNetworkLocationToStream 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: RemoveNetworkLocationFromStream 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetEventServiceLocation 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: DetermineSubjectRoles 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: AddNetService 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: RemoveNetService 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: IsAuthorized 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: IsValid 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: AllocateMulticastLocation 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: RecycleMulticastLocation 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetState 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: AddDir 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetDescById 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: RemoveDir 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: HDDump 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetVersion 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetDataSize 05/08/09 13:49:14 912 VenueServer venueserver.py:952 INFO auth policy ? 0 05/08/09 13:49:14 912 Security authorizationmanager.py:568 DEBUG Adding Subject: /O=Access Grid/OU=agdev-ca.mcs.anl.gov/CN=VenueServer/USD-venueserv.usd.edu to Role: Administrators 05/08/09 13:49:14 912 Security authorizationmanager.py:302 DEBUG RequireIdentification: 0 05/08/09 13:49:14 912 VenueServer venueserver.py:710 DEBUG No applications to load for Venue c0ec2546082c7228fb8c66be5581142e 05/08/09 13:49:14 912 VenueServer venueserver.py:542 DEBUG Loading Venue: c0ec2546082c7228d9e0ca9da2e4d9ca 05/08/09 13:49:14 912 VenueServer venue.py:344 DEBUG ------------ STARTING VENUE 05/08/09 13:49:14 912 VenueServer venue.py:383 INFO Venue URI https://USD-venueserv.usd.local:8000/Venues/c0ec2546082c7228d9e0ca9da2e4d9ca 05/08/09 13:49:14 912 VenueServer venue.py:393 DEBUG data store location: Data 05/08/09 13:49:14 912 DataStore datastore.py:227 DEBUG __init__: Datastore path is Data\c0ec2546082c7228d9e0ca9da2e4d9ca 05/08/09 13:49:14 912 DataStore datastore.py:266 DEBUG =================== ENTERED LoadPersistentInfo ================== 05/08/09 13:49:14 912 DataStore datastore.py:267 DEBUG Reading persisted data from: Data\c0ec2546082c7228d9e0ca9da2e4d9ca\DataStore.dat 05/08/09 13:49:14 912 DataStore datastore.py:272 DEBUG Loading a directory in root-dir! 05/08/09 13:49:14 912 DataStore datastore.py:282 DEBUG LoadPersistentInfo: Server Path: Data\c0ec2546082c7228d9e0ca9da2e4d9ca 05/08/09 13:49:14 912 DataStore datastore.py:286 DEBUG Getting file list of ./Data\c0ec2546082c7228d9e0ca9da2e4d9ca\ 05/08/09 13:49:14 912 DataStore datastore.py:296 DEBUG LOADPERSISTENTINFO: Path to use is C:\Documents and Settings\Venueserv\Application Data\AccessGrid3\Data\c0ec2546082c7228d9e0ca9da2e4d9ca 05/08/09 13:49:14 912 DataStore datastore.py:373 DEBUG =================== EXITED LoadPersistentInfo ================== 05/08/09 13:49:14 912 FTPSServer ftpsserver.py:92 DEBUG Entered FTPSServer.GetUploadDescriptor 05/08/09 13:49:14 912 FTPSServer ftpsserver.py:97 DEBUG descriptor = ftps://USD-venueserv.usd.local:8006/c0ec2546082c7228d9e0ca9da2e4d9ca 05/08/09 13:49:14 912 VenueServer venue.py:417 INFO Have upload url: ftps://USD-venueserv.usd.local:8006/c0ec2546082c7228d9e0ca9da2e4d9ca 05/08/09 13:49:14 912 EventService groupmsgservice.py:102 INFO connectionMade None:None 05/08/09 13:49:14 912 EventService groupmsgservice.py:149 INFO addedConnection None:None id:c0ec254608ac69c17ae2a58b5c9cf247 05/08/09 13:49:14 912 EventClient insecurevenueeventclient.py:60 INFO BaseVenueEventClient made connection. 05/08/09 13:49:14 912 VenueServer venue.py:1156 DEBUG Calling SetConnections. 05/08/09 13:49:14 912 VenueServer venueserver.py:941 INFO initializing with default policy 05/08/09 13:49:14 912 Security authorizationmanager.py:516 INFO Tried to add role that already exists 05/08/09 13:49:14 912 Security authorizationmanager.py:516 INFO Tried to add role that already exists 05/08/09 13:49:14 912 Security authorizationmanager.py:516 INFO Tried to add role that already exists 05/08/09 13:49:14 912 Security authorizationmanager.py:516 INFO Tried to add role that already exists 05/08/09 13:49:14 912 Security authorizationmanager.py:516 INFO Tried to add role that already exists 05/08/09 13:49:14 912 VenueServer venue.py:509 INFO Building auth policy. 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: Enter 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: Exit 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetStreams 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: UpdateLifetime 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: NegotiateCapabilities 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetStaticStreams 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetUploadDescriptor 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: AsVenueDescription 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetRolesForSubject 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: CreateApplication 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: UpdateApplication 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: DestroyApplication 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: UpdateClientProfile 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: AddService 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: RemoveService 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: UpdateService 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetServices 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: AddData 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: UpdateData 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: RemoveData 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetDataStoreInformation 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetDataDescriptions 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: AddNetworkService 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: RemoveNetworkService 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetNetworkServices 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetClients 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetCachedProfiles 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: AddConnection 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: RemoveConnection 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetConnections 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: SetConnections 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetEncryptMedia 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetDescription 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetName 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetApplication 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetApplications 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: AddNetworkLocationToStream 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: RemoveNetworkLocationFromStream 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetEventServiceLocation 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: DetermineSubjectRoles 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: AddNetService 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: RemoveNetService 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: IsAuthorized 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: IsValid 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: AllocateMulticastLocation 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: RecycleMulticastLocation 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetState 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: AddDir 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetDescById 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: RemoveDir 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: HDDump 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetVersion 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetDataSize 05/08/09 13:49:14 912 VenueServer venueserver.py:952 INFO auth policy ? 0 05/08/09 13:49:14 912 Security authorizationmanager.py:568 DEBUG Adding Subject: /O=Access Grid/OU=agdev-ca.mcs.anl.gov/CN=VenueServer/USD-venueserv.usd.edu to Role: Administrators 05/08/09 13:49:14 912 Security authorizationmanager.py:302 DEBUG RequireIdentification: 0 05/08/09 13:49:14 912 VenueServer venueserver.py:710 DEBUG No applications to load for Venue c0ec2546082c7228d9e0ca9da2e4d9ca 05/08/09 13:49:14 912 VenueServer venueserver.py:542 DEBUG Loading Venue: c0ec2546082c7228b1d6d59327bec892 05/08/09 13:49:14 912 VenueServer venue.py:344 DEBUG ------------ STARTING VENUE 05/08/09 13:49:14 912 VenueServer venue.py:383 INFO Venue URI https://USD-venueserv.usd.local:8000/Venues/c0ec2546082c7228b1d6d59327bec892 05/08/09 13:49:14 912 VenueServer venue.py:393 DEBUG data store location: Data 05/08/09 13:49:14 912 DataStore datastore.py:227 DEBUG __init__: Datastore path is Data\c0ec2546082c7228b1d6d59327bec892 05/08/09 13:49:14 912 DataStore datastore.py:266 DEBUG =================== ENTERED LoadPersistentInfo ================== 05/08/09 13:49:14 912 DataStore datastore.py:267 DEBUG Reading persisted data from: Data\c0ec2546082c7228b1d6d59327bec892\DataStore.dat 05/08/09 13:49:14 912 DataStore datastore.py:272 DEBUG Loading a directory in root-dir! 05/08/09 13:49:14 912 DataStore datastore.py:282 DEBUG LoadPersistentInfo: Server Path: Data\c0ec2546082c7228b1d6d59327bec892 05/08/09 13:49:14 912 DataStore datastore.py:286 DEBUG Getting file list of ./Data\c0ec2546082c7228b1d6d59327bec892\ 05/08/09 13:49:14 912 DataStore datastore.py:296 DEBUG LOADPERSISTENTINFO: Path to use is C:\Documents and Settings\Venueserv\Application Data\AccessGrid3\Data\c0ec2546082c7228b1d6d59327bec892 05/08/09 13:49:14 912 DataStore datastore.py:373 DEBUG =================== EXITED LoadPersistentInfo ================== 05/08/09 13:49:14 912 FTPSServer ftpsserver.py:92 DEBUG Entered FTPSServer.GetUploadDescriptor 05/08/09 13:49:14 912 FTPSServer ftpsserver.py:97 DEBUG descriptor = ftps://USD-venueserv.usd.local:8006/c0ec2546082c7228b1d6d59327bec892 05/08/09 13:49:14 912 VenueServer venue.py:417 INFO Have upload url: ftps://USD-venueserv.usd.local:8006/c0ec2546082c7228b1d6d59327bec892 05/08/09 13:49:14 912 EventService groupmsgservice.py:102 INFO connectionMade None:None 05/08/09 13:49:14 912 EventService groupmsgservice.py:149 INFO addedConnection None:None id:c0ec254608ac69c17b08a0f348ac0bd3 05/08/09 13:49:14 912 EventClient insecurevenueeventclient.py:60 INFO BaseVenueEventClient made connection. 05/08/09 13:49:14 912 VenueServer venue.py:1156 DEBUG Calling SetConnections. 05/08/09 13:49:14 912 VenueServer venueserver.py:941 INFO initializing with default policy 05/08/09 13:49:14 912 Security authorizationmanager.py:516 INFO Tried to add role that already exists 05/08/09 13:49:14 912 Security authorizationmanager.py:516 INFO Tried to add role that already exists 05/08/09 13:49:14 912 Security authorizationmanager.py:516 INFO Tried to add role that already exists 05/08/09 13:49:14 912 Security authorizationmanager.py:516 INFO Tried to add role that already exists 05/08/09 13:49:14 912 Security authorizationmanager.py:516 INFO Tried to add role that already exists 05/08/09 13:49:14 912 VenueServer venue.py:509 INFO Building auth policy. 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: Enter 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: Exit 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetStreams 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: UpdateLifetime 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: NegotiateCapabilities 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetStaticStreams 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetUploadDescriptor 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: AsVenueDescription 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetRolesForSubject 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: CreateApplication 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: UpdateApplication 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: DestroyApplication 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: UpdateClientProfile 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: AddService 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: RemoveService 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: UpdateService 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetServices 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: AddData 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: UpdateData 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: RemoveData 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetDataStoreInformation 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetDataDescriptions 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: AddNetworkService 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: RemoveNetworkService 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetNetworkServices 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetClients 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetCachedProfiles 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: AddConnection 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: RemoveConnection 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetConnections 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: SetConnections 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetEncryptMedia 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetDescription 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetName 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetApplication 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetApplications 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: AddNetworkLocationToStream 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: RemoveNetworkLocationFromStream 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetEventServiceLocation 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: DetermineSubjectRoles 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: AddNetService 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: RemoveNetService 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: IsAuthorized 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: IsValid 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: AllocateMulticastLocation 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: RecycleMulticastLocation 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetState 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: AddDir 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetDescById 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: RemoveDir 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: HDDump 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetVersion 05/08/09 13:49:14 912 Security authorizationmanager.py:430 ERROR Coudn't find action: GetDataSize 05/08/09 13:49:15 912 VenueServer venueserver.py:952 INFO auth policy ? 0 05/08/09 13:49:15 912 Security authorizationmanager.py:568 DEBUG Adding Subject: /O=Access Grid/OU=agdev-ca.mcs.anl.gov/CN=VenueServer/USD-venueserv.usd.edu to Role: Administrators 05/08/09 13:49:15 912 Security authorizationmanager.py:302 DEBUG RequireIdentification: 0 05/08/09 13:49:15 912 VenueServer venueserver.py:710 DEBUG No applications to load for Venue c0ec2546082c7228b1d6d59327bec892 05/08/09 13:49:15 912 VenueServer venueserver.py:290 DEBUG CFG: Default Venue: c0ec25460c706d85cecdcdb4ab4fd7fd 05/08/09 13:49:15 912 VenueServer venueserver.py:292 DEBUG Setting default venue. 05/08/09 13:49:15 912 VenueServer venueserver.py:1147 INFO Setting default venue; oid=c0ec25460c706d85cecdcdb4ab4fd7fd 05/08/09 13:49:15 912 VenueServer venueserver.py:336 WARNING Performance data configuration incorrect. 05/08/09 13:49:15 1412 VenueServer venueserver.py:829 INFO Checkpoint starting at: Fri May 08 13:49:15 2009 05/08/09 13:49:15 912 VenueServer venueserver.py:373 DEBUG Default Subject: /O=Access Grid/OU=agdev-ca.mcs.anl.gov/CN=VenueServer/USD-venueserv.usd.edu 05/08/09 13:49:15 912 Security authorizationmanager.py:568 DEBUG Adding Subject: /O=Access Grid/OU=agdev-ca.mcs.anl.gov/CN=VenueServer/USD-venueserv.usd.edu to Role: Administrators 05/08/09 13:49:15 912 Security authorizationmanager.py:580 WARNING Not adding subject /O=Access Grid/OU=agdev-ca.mcs.anl.gov/CN=VenueServer/USD-venueserv.usd.edu to role Administrators, it's already there. 05/08/09 13:49:15 912 Toolkit venueserver3.py:121 DEBUG Starting Hosting Environment. 05/08/09 13:49:15 1412 Security authorizationmanager.py:307 DEBUG IsIdentificationRequired returning 0 05/08/09 13:49:15 1412 Security authorizationmanager.py:307 DEBUG IsIdentificationRequired returning 0 05/08/09 13:49:15 1412 Security authorizationmanager.py:307 DEBUG IsIdentificationRequired returning 0 05/08/09 13:49:15 1412 Security authorizationmanager.py:307 DEBUG IsIdentificationRequired returning 0 05/08/09 13:49:15 1412 VenueServer venueserver.py:861 INFO Checkpointing completed at: Fri May 08 13:49:15 2009 05/08/09 13:49:57 3744 Hosting servicecontainer.py:187 ERROR None Traceback (most recent call last): File "C:\Python24\lib\site-packages\M2Crypto\SSL\SSLServer.py", line 29, in handle_request request, client_address = self.get_request() File "C:\Python24\lib\SocketServer.py", line 373, in get_request return self.socket.accept() File "C:\Python24\lib\site-packages\AccessGrid3\AccessGrid\hosting\ZSI\ServiceContainer.py", line 156, in M2CryptoConnectionAccept ret = ssl.accept_ssl() File "C:\Python24\lib\site-packages\M2Crypto\SSL\Connection.py", line 140, in accept_ssl return m2.ssl_accept(self.ssl) SSLError: sslv3 alert certificate expired 05/08/09 13:50:23 912 Toolkit venueserver3.py:128 DEBUG After main loop! 05/08/09 13:50:23 912 Toolkit venueserver3.py:133 DEBUG Stopped Hosting Environment, exiting. 05/08/09 13:50:24 912 Toolkit venueserver3.py:142 DEBUG Thread > 300 0 05/08/09 13:50:24 912 Toolkit venueserver3.py:142 DEBUG Thread > 15 0 05/08/09 13:50:24 912 Toolkit venueserver3.py:142 DEBUG Thread <_MainThread(MainThread, started)> 05/08/09 13:50:24 912 Toolkit venueserver3.py:142 DEBUG Thread