Hi everyone,
I'm having problems using AG Toolkit 2.3 on a new Thinkpad T43 running
XP w/ SP2. We've performed installations on several systems using the
same set of files. However, after obtaining a certificate and trying to
enter a venue, it lmost immediately pops up "Can not connect to venue
located at https://vv2.mcs.anl.gov:9000/Venues/default. Please, try
again."
We've consulted the archives and the buglist and found out that there
have been problems with the Thinkpads, but we've changed all the
environmental variables to point to python23 instead of the python22
that comes preloaded from IBM. I've set GLOBUS_HOSTNAME to localhost
even though I'm just trying to use wired ethernet, not WLAN. I've set
PYTHONCASE to _unset_. What else can I try?
When the client is brought up in debug mode this is what's displayed:
C:\Python23\lib\fcntl.py:7: DeprecationWarning: the FCTNL module is
deprecated; please us fcntl
DeprecationWarning>
C:\Python23\lib\termios.py:7: DeprecationWarning: the TERMIOS module is
deprecated; please us termios
DeprecationWarning>
Attached is a portion of the VenueClient log showing one attempt this
morning to connect to a venue.
Thank you for any suggestions!
Anne
/\/\/\/\/\/\/\/\/\/\/\/\/\/\
Anne M. Gorczyca
a...@haystack.mit.edu
M.I.T. Haystack Observatory
Westford, MA 01886
Phone: 781-981-5630
FAX: 781-981-5766
\/\/\/\/\/\/\/\/\/\/\/\/\/\/\
06/09/05 10:12:43 1040 VenueClient venueclientui.py:1599 INFO ---------
END VenueClient
06/09/05 10:12:43 1040 DataStore datastore.py:1577 DEBUG Quitting thread 0
06/09/05 10:12:43 3412 DataStore datastore.py:1518 DEBUG Worker 0 gets cmd
quit
06/09/05 10:12:43 3412 DataStore datastore.py:1531 DEBUG Worker 0 exiting
06/09/05 10:12:43 3416 DataStore datastore.py:1590 INFO
GSIHTTPTransferServer: GSITCPSocket, interrupted I/O operation, most likely
shutting down.
06/09/05 10:12:43 1040 NodeService agnodeservice.py:113 INFO
NodeService.Stop
06/09/05 10:12:43 1040 ServiceManager agservicemanager.py:84 INFO
AGServiceManager.Shutdown
06/09/05 10:12:43 1040 ServiceManager agservicemanager.py:85 INFO Remove
services
06/09/05 10:12:43 1040 ServiceManager agservicemanager.py:379 INFO
AGServiceManager.RemoveServices
06/09/05 10:12:43 1040 ServiceManager agservicemanager.py:87 INFO Stop
network interface
06/09/05 10:12:43 3436 Hosting server.py:65 ERROR Exception in SOAP server
main loop
Traceback (most recent call last):
File "C:\Python23\Lib\site-packages\AccessGrid\hosting\SOAPpy\Server.py",
line 63, in Run
self._server.handle_request()
File "C:\Python23\lib\SocketServer.py", line 217, in handle_request
request, client_address = self.get_request()
File "C:\Python23\Lib\site-packages\SOAPpy\GSIServer.py", line 140, in
get_request
sock, addr = ThreadingGSITCPSocketServer.get_request(self)
File "C:\Python23\Lib\site-packages\pyGlobus\io.py", line 525, in get_request
self.socket.listen()
File "C:\Python23\Lib\site-packages\pyGlobus\io.py", line 857, in listen
raise ex
GSITCPSocketException: an I/O operation was cancelled
06/09/05 10:12:43 1040 Hosting server.py:97 ERROR server_close() failed
Traceback (most recent call last):
File "C:\Python23\Lib\site-packages\AccessGrid\hosting\SOAPpy\Server.py",
line 95, in Stop
self._server.server_close()
File "C:\Python23\Lib\site-packages\pyGlobus\io.py", line 1043, in
server_close
self.socket.close()
File "C:\Python23\Lib\site-packages\pyGlobus\io.py", line 1020, in close
IOBase.close(self)
File "C:\Python23\Lib\site-packages\pyGlobus\io.py", line 176, in close
raise ex
IOBaseException: an uninitialied data structure was passed as argument 1 to
globus_io_register_close
06/09/05 10:12:43 1040 Hosting server.py:97 ERROR server_close() failed
Traceback (most recent call last):
File "C:\Python23\Lib\site-packages\AccessGrid\hosting\SOAPpy\Server.py",
line 95, in Stop
self._server.server_close()
File "C:\Python23\Lib\site-packages\pyGlobus\io.py", line 1043, in
server_close
self.socket.close()
File "C:\Python23\Lib\site-packages\pyGlobus\io.py", line 1020, in close
IOBase.close(self)
File "C:\Python23\Lib\site-packages\pyGlobus\io.py", line 176, in close
raise ex
IOBaseException: an uninitialied data structure was passed as argument 1 to
globus_io_register_close
06/09/05 10:13:23 3008 Toolkit toolkit.py:178 ERROR
Toolkit.__CheckForValidClock: Connection to sntp server at ntp-1.accessgrid.org
failed
Traceback (most recent call last):
File "C:\Python23\Lib\site-packages\AccessGrid\Toolkit.py", line 176, in
__CheckForInvalidClock
serverTime = GetSNTPTime(timeserver, timeout)
File "C:\Python23\Lib\site-packages\AccessGrid\NetUtilities.py", line 43, in
GetSNTPTime
client.sendto( data, (server, 123 ))
gaierror: (7, 'getaddrinfo failed')
06/09/05 10:13:23 3008 Toolkit config.py:196 DEBUG Using
GLOBUS_HOSTNAME=localhost as set in the environment
06/09/05 10:13:23 3008 CertificateManager certificatemanager.py:257 DEBUG
Opened repository C:\Documents and Settings\Sys Admin\Application
Data\AccessGrid\Config\certRepo
06/09/05 10:13:23 3008 Toolkit toolkit.py:395 DEBUG Got repo.
06/09/05 10:13:23 3008 Toolkit toolkit.py:397 DEBUG looking in system ca
dir: C:\Program Files\AGTk-2.3\Config\CAcertificates
06/09/05 10:13:23 3008 Toolkit toolkit.py:401 DEBUG Getting cert: 1c3f2ca8.0
06/09/05 10:13:23 3008 Toolkit toolkit.py:406 WARNING Not importing cert
C:\Program Files\AGTk-2.3\Config\CAcertificates\1c3f2ca8.0
06/09/05 10:13:23 3008 Toolkit toolkit.py:401 DEBUG Getting cert: 45cc9e80.0
06/09/05 10:13:23 3008 Toolkit toolkit.py:406 WARNING Not importing cert
C:\Program Files\AGTk-2.3\Config\CAcertificates\45cc9e80.0
06/09/05 10:13:23 3008 Toolkit toolkit.py:401 DEBUG Getting cert: d1b603c3.0
06/09/05 10:13:23 3008 Toolkit toolkit.py:406 WARNING Not importing cert
C:\Program Files\AGTk-2.3\Config\CAcertificates\d1b603c3.0
06/09/05 10:13:23 3008 Toolkit toolkit.py:401 DEBUG Getting cert: f18fa857.0
06/09/05 10:13:23 3008 Toolkit toolkit.py:406 WARNING Not importing cert
C:\Program Files\AGTk-2.3\Config\CAcertificates\f18fa857.0
06/09/05 10:13:23 3008 Toolkit toolkit.py:410 DEBUG Init'ing globus.
06/09/05 10:13:23 3008 CertificateManager certificatemanager.py:734 DEBUG
Configuring standard environment
06/09/05 10:13:23 3008 CertificateManager certificatemanager.py:802 DEBUG
Using default identity /O=Access
Grid/OU=agdev-ca.mcs.anl.gov/OU=haystack.mit.edu/CN=Anne Gorczyca
06/09/05 10:13:23 3008 CertificateManager certificatemanager.py:873 DEBUG
Initializing environment with proxy cert for /O=Access
Grid/OU=agdev-ca.mcs.anl.gov/OU=haystack.mit.edu/CN=Anne Gorczyca
06/09/05 10:13:23 3008 CertificateManager certificatemanager.py:907 DEBUG
Looking for identity (unused) None
06/09/05 10:13:23 3008 CertificateManager certificatemanager.py:892 DEBUG
Configuring for user proxy issued from /O=Access
Grid/OU=agdev-ca.mcs.anl.gov/OU=haystack.mit.edu/CN=Anne Gorczyca
06/09/05 10:13:23 3008 CertificateManager certificatemanager.py:895 DEBUG
Proxy C:\DOCUME~1\SYSADM~1\LOCALS~1\Temp\proxy will expire 06/09/05 16:10:02
06/09/05 10:13:23 3008 Toolkit toolkit.py:414 DEBUG Done with globus.
06/09/05 10:13:23 3008 VenueClient venueclient.py:284 DEBUG
__StartWebService: venueclient: https://localhost:11000/VenueClient
06/09/05 10:13:23 3008 ServiceManager agservicemanager.py:75 INFO Using
services dir: C:\Documents and Settings\Sys Admin\Application
Data\AccessGrid\local_services
06/09/05 10:13:23 3008 ServiceManager agservicemanager.py:414 INFO
__DiscoverResources
06/09/05 10:13:23 3008 Toolkit config.py:997 INFO Using vfwscan to get
devices
06/09/05 10:13:23 3008 Toolkit config.py:998 DEBUG vfwscanexe =
C:\PROGRA~1\AGTk-2.3\bin\vfwscan.exe
06/09/05 10:13:23 3008 Toolkit config.py:1003 DEBUG filelines = ['Microsoft
WDM Image Capture (Win32)\n']
06/09/05 10:13:23 3008 Toolkit config.py:1031 INFO GetResources:
['Microsoft WDM Image Capture (Win32)']
06/09/05 10:13:23 3008 VenueClient venueclient.py:293 DEBUG
__StartWebService: service manager: https://localhost:11000/ServiceManager
06/09/05 10:13:23 3008 NodeService agnodeservice.py:733 INFO
NodeService.__ReadConfigFile
06/09/05 10:13:23 3008 Toolkit toolkit.py:328 DEBUG Looking for:
C:\Documents and Settings\Sys Admin\Application
Data\AccessGrid\Config\AGNodeService.cfg
06/09/05 10:13:23 3008 Toolkit toolkit.py:333 DEBUG Looking for: C:\Program
Files\AGTk-2.3\Config\AGNodeService.cfg
06/09/05 10:13:23 3008 NodeService agnodeservice.py:741 DEBUG DEFAULT NODE
SERVICE CONFIG: C:\Program Files\AGTk-2.3\Config\AGNodeService.cfg
06/09/05 10:13:23 3008 NodeService agnodeservice.py:745 INFO Reading node
service config file: C:\Program Files\AGTk-2.3\Config\AGNodeService.cfg
06/09/05 10:13:23 3008 VenueClient venueclient.py:299 DEBUG
__StartWebService: node service: https://localhost:11000/NodeService
06/09/05 10:13:23 3008 VenueClient venueclient.py:1317 DEBUG SerNodeUrl:
Set node service url: https://localhost:11000/NodeService
06/09/05 10:13:23 3008 NodeService agnodeservice.py:675 INFO
NodeService.GetDefaultConfiguration
06/09/05 10:13:23 3008 NodeService agnodeservice.py:558 INFO Migration
unnecessary
06/09/05 10:13:23 3008 NodeService agnodeservice.py:351 INFO
NodeService.LoadDefaultConfig
06/09/05 10:13:23 3008 NodeService agnodeservice.py:355 INFO Loading
default node configuration: defaultWindows
06/09/05 10:13:23 3008 NodeService agnodeservice.py:369 INFO
NodeService.LoadConfiguration
06/09/05 10:13:23 3008 NodeService agnodeservice.py:384 INFO Trying to
load node configuration from: C:\Documents and Settings\Sys Admin\Application
Data\AccessGrid\Config\nodeConfig\defaultWindows
06/09/05 10:13:23 3008 NodeService agnodeservice.py:457 INFO
AddServiceManager: Invalid service manager url
(https://localhost:11000/ServiceManager)
06/09/05 10:13:23 3008 NodeService agnodeservice.py:358 ERROR Exception
loading default configuration.
Traceback (most recent call last):
File "C:\Python23\Lib\site-packages\AccessGrid\AGNodeService.py", line 356,
in LoadDefaultConfig
self.LoadConfiguration( self.defaultConfig )
File "C:\Python23\Lib\site-packages\AccessGrid\AGNodeService.py", line 500,
in LoadConfiguration
raise Exception(exceptionText)
Exception: Couldn't reach service manager: localhost:11000
06/09/05 10:13:23 3008 VenueClient venueclient.py:310 ERROR Error loading
default configuration
Traceback (most recent call last):
File "C:\Python23\Lib\site-packages\AccessGrid\VenueClient.py", line 308, in
__StartWebService
self.ns.LoadDefaultConfig()
File "C:\Python23\Lib\site-packages\AccessGrid\AGNodeService.py", line 359,
in LoadDefaultConfig
raise Exception("Failed to load default configuration <%s>" %
Exception: Failed to load default configuration <defaultWindows>
06/09/05 10:13:23 3008 VenueClient venueclient.py:182 DEBUG
__createPersonalDataStore: Creating personal datastore at C:\Documents and
Settings\Sys Admin\Application Data\AccessGrid\Config\personalDataStore using
prefix personalDataStore and port 0
06/09/05 10:13:23 3008 DataStore datastore.py:1500 DEBUG Creating thread 0
06/09/05 10:13:23 3008 DataStore datastore.py:1505 DEBUG Starting thread 0
06/09/05 10:13:23 3088 DataStore datastore.py:1513 DEBUG Worker 0 starting
06/09/05 10:13:23 3008 DataStore datastore.py:1507 DEBUG Waiting thread 0
06/09/05 10:13:23 3008 DataStore datastore.py:1510 DEBUG Done creating
workers
06/09/05 10:13:23 3008 DataStore datastore.py:263 DEBUG Reading persisted
data from: C:\Documents and Settings\Sys Admin\Application
Data\AccessGrid\Config\personalDataStore\DataStore.dat
06/09/05 10:13:23 3008 VenueClient venueclient.py:207 DEBUG
__createPersonalDataStore: Load personal data from file
06/09/05 10:13:23 3008 VenueClientController venueclientcontroller.py:1277
DEBUG There is no personal venues file to load.
06/09/05 10:13:27 3008 VenueClient venueclient.py:803 DEBUG EnterVenue;
url=https://vv2.mcs.anl.gov:9000/Venues/default
06/09/05 10:13:27 3008 CertificateManager certificatemanager.py:907 DEBUG
Looking for identity (unused) None
06/09/05 10:13:27 3008 CertificateManager certificatemanager.py:638 DEBUG
HaveValidProxy: found proxy ident /O=Access
Grid/OU=agdev-ca.mcs.anl.gov/OU=haystack.mit.edu/CN=Anne Gorczyca/CN=proxy
06/09/05 10:13:27 3008 CertificateManager certificatemanager.py:907 DEBUG
Looking for identity (unused) None
06/09/05 10:13:27 3008 CertificateManager certificatemanager.py:638 DEBUG
HaveValidProxy: found proxy ident /O=Access
Grid/OU=agdev-ca.mcs.anl.gov/OU=haystack.mit.edu/CN=Anne Gorczyca/CN=proxy
06/09/05 10:13:27 3008 VenueClient venueclient.py:830 INFO EnterVenue:
Error getting node capabilities
06/09/05 10:13:27 3008 VenueClient venueclient.py:702 DEBUG EnterVenue:
Invoke venue enter
06/09/05 10:13:27 3008 VenueClient venueclient.py:863 ERROR EnterVenue:
failed
Traceback (most recent call last):
File "C:\Python23\Lib\site-packages\AccessGrid\VenueClient.py", line 834, in
EnterVenue
self.__EnterVenue(URL)
File "C:\Python23\Lib\site-packages\AccessGrid\VenueClient.py", line 703, in
__EnterVenue
(venueState, self.privateId, self.streamDescList ) =
self.__venueProxy.Enter( self.profile )
File "C:\Python23\Lib\site-packages\AccessGrid\Venue.py", line 3331, in Enter
(r1, r2, r3) = self.proxy.Enter(profile)
File "C:\Python23\Lib\site-packages\SOAPpy\Client.py", line 453, in __call__
return self.__r_call(*args, **kw)
File "C:\Python23\Lib\site-packages\SOAPpy\Client.py", line 475, in __r_call
self.__hd, self.__ma)
File "C:\Python23\Lib\site-packages\SOAPpy\Client.py", line 338, in __call
config = self.config, noroot = self.noroot)
File "C:\Python23\Lib\site-packages\SOAPpy\SOAPBuilder.py", line 620, in
buildSOAP
return t.build()
File "C:\Python23\Lib\site-packages\SOAPpy\SOAPBuilder.py", line 118, in build
body_ns = self.genns(ns_map, NS.ENV)[0]
File "C:\Python23\Lib\site-packages\SOAPpy\SOAPBuilder.py", line 204, in genns
if type(nsURI) == TupleType: # already a tuple
NameError: global name 'TupleType' is not defined
06/09/05 10:13:27 3008 VenueClient venueclientui.py:1959 DEBUG
bin.VenueClient::EnterVenue: Enter venue with url:
https://vv2.mcs.anl.gov:9000/Venues/default
06/09/05 10:13:27 3008 VenueClient venueclientui.py:1972 DEBUG
warningString:
