[AG-TECH] vic works on command line but fails to be started via AG, log output

west suhanic west.suhanic at gmail.com
Wed Jun 22 13:52:27 CDT 2005


Hi Thomas, Natalia et al.

Here is the log output:

05/06/05 14:14:04 2860 Toolkit     toolkit.py:90 DEBUG Initializing AG
Toolkit version 2.3
05/06/05 14:14:04 2860 Toolkit     toolkit.py:132 INFO  Logfile Name:
VideoService.log
05/06/05 14:14:04 2860 Toolkit     toolkit.py:606 INFO  Service init:
have profile None
05/06/05 14:14:04 2860 Toolkit     config.py:196 DEBUG Using
GLOBUS_HOSTNAME=pecot.arc.ulaval.ca as set in the environment
05/06/05 14:14:04 2860 CertificateManager    
certificatemanager.py:257 DEBUG Opened repository C:\Documents and
Settings\pecot\Application Data\AccessGrid\Config\certRepo
05/06/05 14:14:04 2860 Toolkit     toolkit.py:635 INFO  Initialized cert mgmt.
05/06/05 14:14:04 2860 Toolkit     toolkit.py:650 INFO  Loaded profile
and configured with it.
05/06/05 14:14:04 2860 CertificateManager    
certificatemanager.py:734 DEBUG Configuring standard environment
05/06/05 14:14:04 2860 CertificateManager    
certificatemanager.py:802 DEBUG Using default identity
/O=DesignCollaboratory/OU=clr.utoronto.ca/CN=pecot
05/06/05 14:14:04 2860 CertificateManager    
certificatemanager.py:873 DEBUG Initializing environment with proxy
cert for /O=DesignCollaboratory/OU=clr.utoronto.ca/CN=pecot
05/06/05 14:14:04 2860 CertificateManager    
certificatemanager.py:907 DEBUG Looking for identity (unused) None
05/06/05 14:14:04 2860 CertificateManager    
certificatemanager.py:892 DEBUG Configuring for user proxy issued from
/O=DesignCollaboratory/OU=clr.utoronto.ca/CN=pecot
05/06/05 14:14:04 2860 CertificateManager    
certificatemanager.py:895 DEBUG Proxy
C:\DOCUME~1\pecot\LOCALS~1\Temp\proxy will expire 05/06/05 21:09:04
05/06/05 14:14:04 2860 CertificateManager    
certificatemanager.py:1479 DEBUG done, success=1
05/06/05 14:14:04 2860 Toolkit     toolkit.py:654 INFO  Initialized Globus.
05/06/05 14:14:04 2860 Toolkit     toolkit.py:662 INFO  Service
Initialization Complete.
05/06/05 14:14:04 2860 Toolkit     agservice.py:368 INFO  Starting
Service URI: https://pecot.arc.ulaval.ca:52189/Service
05/06/05 14:14:06 1692 Toolkit     videoservice.py:341 INFO 
VideoService.SetResource : Microsoft WDM Image Capture (Win32)
05/06/05 14:14:07 3396 Toolkit     videoservice.py:372 INFO 
SetIdentity: Pierre Cote pierre.cote at arc.ulaval.ca
05/06/05 14:14:08 3528 Toolkit     agservice.py:136 INFO 
ConfigureStream: video sweety.clr.utoronto.ca 58012
05/06/05 14:14:08 3528 Toolkit     videoservice.py:179 INFO  Mapping
windows device: Microsoft WDM Image Capture (Win32)
05/06/05 14:14:08 3528 Toolkit     videoservice.py:304 INFO  Starting
VideoService
05/06/05 14:14:08 3528 Toolkit     videoservice.py:305 INFO  
executable = C:\Documents and Settings\pecot\Application
Data\AccessGrid\local_services\VideoService\vic.exe
05/06/05 14:14:08 3528 Toolkit     videoservice.py:306 INFO   options
= ['-u', 'C:/DOCUME~1/pecot/LOCALS~1/Temp/VideoService_1068.vic',
'-C', '"Video"', 'sweety.clr.utoronto.ca/58012']
05/06/05 14:14:08 3528 ProcessManager     processmanager.py:59 DEBUG
Creating process: C:\Documents and Settings\pecot\Application
Data\AccessGrid\local_services\VideoService\vic.exe -u
C:/DOCUME~1/pecot/LOCALS~1/Temp/VideoService_1068.vic -C "Video"
sweety.clr.utoronto.ca/58012
05/06/05 14:14:08 3528 ProcessManager     processmanager.py:72 DEBUG
Create process returns: (<PyHANDLE object at 0x01597D64>, <PyHANDLE
object at 0x01552374>, 1888, 3112)
05/06/05 14:14:29 3120 Toolkit     agservice.py:190 INFO  Shut service down
05/06/05 14:14:29 3120 ProcessManager     processmanager.py:135 ERROR
couldn't shutdown process <PyHANDLE:768>: (1444, 'PostThreadMessage',
'Identificateur de thread non valide.')
Traceback (most recent call last):
 File "C:\Python23\Lib\site-packages\AccessGrid\Platform\win32\ProcessManager.py",
line 128, in TerminateProcess
   win32api.PostThreadMessage(self.threadid[pid], 18, 0, 0)
error: (1444, 'PostThreadMessage', 'Identificateur de thread non valide.')
05/06/05 14:14:29 3120 ProcessManager     processmanager.py:142 ERROR
couldn't terminate process <PyHANDLE:768>: (5, 'TerminateProcess',
'Acc\xe8s refus\xe9.')
Traceback (most recent call last):
 File "C:\Python23\Lib\site-packages\AccessGrid\Platform\win32\ProcessManager.py",
line 139, in TerminateProcess
   win32process.TerminateProcess(pid, 0)
error: (5, 'TerminateProcess', 'Acc\xe8s refus\xe9.')
05/06/05 14:14:29 980 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/20/05 11:08:58 2980 Toolkit     toolkit.py:90 DEBUG Initializing AG
Toolkit version 2.3
06/20/05 11:08:58 2980 Toolkit     toolkit.py:132 INFO  Logfile Name:
VideoService.log
06/20/05 11:08:58 2980 Toolkit     toolkit.py:606 INFO  Service init:
have profile None
06/20/05 11:08:58 2980 Toolkit     config.py:196 DEBUG Using
GLOBUS_HOSTNAME=132.203.121.100 as set in the environment
06/20/05 11:08:58 2980 CertificateManager    
certificatemanager.py:257 DEBUG Opened repository C:\Documents and
Settings\pecot\Application Data\AccessGrid\Config\certRepo
06/20/05 11:08:58 2980 Toolkit     toolkit.py:635 INFO  Initialized cert mgmt.
06/20/05 11:08:58 2980 Toolkit     toolkit.py:650 INFO  Loaded profile
and configured with it.
06/20/05 11:08:58 2980 CertificateManager    
certificatemanager.py:734 DEBUG Configuring standard environment
06/20/05 11:08:58 2980 CertificateManager    
certificatemanager.py:802 DEBUG Using default identity
/O=DesignCollaboratory/OU=clr.utoronto.ca/CN=Pierre Cote
06/20/05 11:08:58 2980 CertificateManager    
certificatemanager.py:873 DEBUG Initializing environment with proxy
cert for /O=DesignCollaboratory/OU=clr.utoronto.ca/CN=Pierre Cote
06/20/05 11:08:58 2980 CertificateManager    
certificatemanager.py:907 DEBUG Looking for identity (unused) None
06/20/05 11:08:58 2980 CertificateManager    
certificatemanager.py:892 DEBUG Configuring for user proxy issued from
/O=DesignCollaboratory/OU=clr.utoronto.ca/CN=Pierre Cote
06/20/05 11:08:58 2980 CertificateManager    
certificatemanager.py:895 DEBUG Proxy
C:\DOCUME~1\pecot\LOCALS~1\Temp\proxy will expire 06/20/05 16:31:37
06/20/05 11:08:58 2980 CertificateManager    
certificatemanager.py:1479 DEBUG done, success=1
06/20/05 11:08:58 2980 Toolkit     toolkit.py:654 INFO  Initialized Globus.
06/20/05 11:08:58 2980 Toolkit     toolkit.py:662 INFO  Service
Initialization Complete.
06/20/05 11:08:58 2980 Toolkit     agservice.py:368 INFO  Starting
Service URI: https://132.203.121.100:51521/Service
06/20/05 11:08:59 740 Toolkit     videoservice.py:341 INFO 
VideoService.SetResource : Microsoft WDM Image Capture (Win32)
06/20/05 11:09:00 1540 Toolkit     videoservice.py:372 INFO 
SetIdentity: Pierre Cote pierre.cote at arc.ulaval.ca
06/20/05 11:09:01 3064 Toolkit     agservice.py:136 INFO 
ConfigureStream: video sweety.clr.utoronto.ca 58000
06/20/05 11:09:01 3064 Toolkit     videoservice.py:179 INFO  Mapping
windows device: Microsoft WDM Image Capture (Win32)
06/20/05 11:09:01 3064 Toolkit     videoservice.py:304 INFO  Starting
VideoService
06/20/05 11:09:01 3064 Toolkit     videoservice.py:305 INFO  
executable = C:\Documents and Settings\pecot\Application
Data\AccessGrid\local_services\VideoService\vic.exe
06/20/05 11:09:01 3064 Toolkit     videoservice.py:306 INFO   options
= ['-u', 'C:/DOCUME~1/pecot/LOCALS~1/Temp/VideoService_2908.vic',
'-C', '"Video"', 'sweety.clr.utoronto.ca/58000']
06/20/05 11:09:01 3064 ProcessManager     processmanager.py:59 DEBUG
Creating process: C:\Documents and Settings\pecot\Application
Data\AccessGrid\local_services\VideoService\vic.exe -u
C:/DOCUME~1/pecot/LOCALS~1/Temp/VideoService_2908.vic -C "Video"
sweety.clr.utoronto.ca/58000
06/20/05 11:09:01 3064 ProcessManager     processmanager.py:72 DEBUG
Create process returns: (<PyHANDLE object at 0x014BE7AC>, <PyHANDLE
object at 0x0154CE4C>, 1536, 1344)
06/20/05 11:09:51 1728 Toolkit     agservice.py:190 INFO  Shut service down
06/20/05 11:09:51 1728 ProcessManager     processmanager.py:135 ERROR
couldn't shutdown process <PyHANDLE:720>: (1444, 'PostThreadMessage',
'Identificateur de thread non valide.')
Traceback (most recent call last):
 File "C:\Python23\Lib\site-packages\AccessGrid\Platform\win32\ProcessManager.py",
line 128, in TerminateProcess
   win32api.PostThreadMessage(self.threadid[pid], 18, 0, 0)
error: (1444, 'PostThreadMessage', 'Identificateur de thread non valide.')
06/20/05 11:09:51 1728 ProcessManager     processmanager.py:142 ERROR
couldn't terminate process <PyHANDLE:720>: (5, 'TerminateProcess',
'Acc\xe8s refus\xe9.')
Traceback (most recent call last):
 File "C:\Python23\Lib\site-packages\AccessGrid\Platform\win32\ProcessManager.py",
line 139, in TerminateProcess
   win32process.TerminateProcess(pid, 0)
error: (5, 'TerminateProcess', 'Acc\xe8s refus\xe9.')




More information about the ag-tech mailing list