Now in new log file C:\Condor/log/SchedLog
7/9 10:34:45 (fd:4) (pid:528) 
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> Sockets Registered
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> ~~~~~~~~~~~~~~~~~~~
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> 0: 720 <NULL> DC Command Handler
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> 1: 712 <NULL> DC Command Handler
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> 2: 676 <NULL> DC Command Handler
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> 3: 672 <NULL> DC Command Handler
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> 4: 292 <10.20.12.1:9618> SecManStartCommand::WaitForSocketCallback UPDATE_SCHEDD_AD
7/9 10:34:45 (fd:4) (pid:528) 
7/9 10:34:45 (fd:4) (pid:528) Changed attribute: RunningJobs = 0
7/9 10:34:45 (fd:4) (pid:528) Changed attribute: IdleJobs = 1
7/9 10:34:45 (fd:4) (pid:528) Changed attribute: HeldJobs = 0
7/9 10:34:45 (fd:4) (pid:528) Changed attribute: FlockedJobs = 0
7/9 10:34:45 (fd:4) (pid:528) Changed attribute: Name = "KSCHWARZ@corp.ad.emb"
7/9 10:34:45 (fd:4) (pid:528) Sent ad to central manager for KSCHWARZ@corp.ad.emb
7/9 10:34:45 (fd:4) (pid:528) Trying to update collector <10.3.28.8:9618>
7/9 10:34:45 (fd:4) (pid:528) Attempting to send update via UDP to collector PC284419.corp.ad.emb <10.3.28.8:9618>
7/9 10:34:45 (fd:4) (pid:528) SECMAN: command 11 UPDATE_SUBMITTOR_AD to collector pc284419 from UDP port 3133 (non-blocking).
7/9 10:34:45 (fd:4) (pid:528) SECMAN: using session PC284419:3236:1247146467:11 for {<10.3.28.8:9618>,<11>}.
7/9 10:34:45 (fd:4) (pid:528) SECMAN: found cached session id PC284419:3236:1247146467:11 for {<10.3.28.8:9618>,<11>}.
7/9 10:34:45 (fd:4) (pid:528) SEC_DEBUG_PRINT_KEYS is undefined, using default value of False
MyType = ""
TargetType = ""
OutgoingNegotiation = "PREFERRED"
Subsystem = "SCHEDD"
Command = 60010
AuthCommand = 11
RemoteVersion = "$CondorVersion: 7.2.1 Feb 19 2009 BuildID: 133382 $"
Enact = "YES"
AuthMethodsList = "NTSSPI,KERBEROS"
AuthMethods = "NTSSPI"
CryptoMethods = "3DES,BLOWFISH"
Authentication = "NO"
Encryption = "NO"
Integrity = "NO"
SessionDuration = "86400"
UseSession = "YES"
Sid = "PC284419:3236:1247146467:11"
ValidCommands = "1,11,14,18"
7/9 10:34:45 (fd:4) (pid:528) SECMAN: Security Policy:
MyType = ""
TargetType = ""
OutgoingNegotiation = "PREFERRED"
Subsystem = "SCHEDD"
Command = 60010
AuthCommand = 11
RemoteVersion = "$CondorVersion: 7.2.1 Feb 19 2009 BuildID: 133382 $"
Enact = "YES"
AuthMethodsList = "NTSSPI,KERBEROS"
AuthMethods = "NTSSPI"
CryptoMethods = "3DES,BLOWFISH"
Authentication = "NO"
Encryption = "NO"
Integrity = "NO"
SessionDuration = "86400"
UseSession = "YES"
Sid = "PC284419:3236:1247146467:11"
ValidCommands = "1,11,14,18"
7/9 10:34:45 (fd:4) (pid:528) SECMAN: negotiating security for command 11.
7/9 10:34:45 (fd:4) (pid:528) SECMAN: UDP, m_have_session == 1, peer_can_negotiate == 1
7/9 10:34:45 (fd:4) (pid:528) SECMAN: UDP has session PC284419:3236:1247146467:11.
7/9 10:34:45 (fd:4) (pid:528) SECMAN: sending DC_AUTHENTICATE command
7/9 10:34:45 (fd:4) (pid:528) SECMAN: sending following classad:
MyType = ""
TargetType = ""
OutgoingNegotiation = "PREFERRED"
Subsystem = "SCHEDD"
AuthCommand = 11
Enact = "YES"
AuthMethodsList = "NTSSPI,KERBEROS"
AuthMethods = "NTSSPI"
CryptoMethods = "3DES,BLOWFISH"
Authentication = "NO"
Encryption = "NO"
Integrity = "NO"
SessionDuration = "86400"
UseSession = "YES"
Sid = "PC284419:3236:1247146467:11"
ValidCommands = "1,11,14,18"
RemoteVersion = "$CondorVersion: 7.2.1 Feb 19 2009 BuildID: 133382 $"
ServerCommandSock = "<10.3.28.8:3099>"
Command = 11
7/9 10:34:45 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:45 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:45 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:45 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:45 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:45 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:45 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:45 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:45 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:45 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:45 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:45 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:45 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:45 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:45 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:45 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:45 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:45 (fd:4) (pid:528) SECMAN: startCommand succeeded.
7/9 10:34:45 (fd:4) (pid:528) Authorizing server '*/10.3.28.8'.
7/9 10:34:45 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:45 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:45 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:45 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:45 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:45 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:45 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:45 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:45 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:45 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:45 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:45 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:45 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:45 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:45 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:45 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:45 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:45 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:45 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:45 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:45 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:45 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:45 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:45 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:45 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:45 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:45 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:45 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:45 (fd:4) (pid:528) SEND [1000] <10.3.28.8:3133> <10.3.28.8:9618>
7/9 10:34:45 (fd:4) (pid:528) SEND [451] <10.3.28.8:3133> <10.3.28.8:9618>
7/9 10:34:45 (fd:4) (pid:528) Sent ad to 1 collectors for KSCHWARZ@corp.ad.emb
7/9 10:34:45 (fd:4) (pid:528) Attempting to send update via UDP to collector pc263439.corp.ad.emb <10.20.12.1:9618>
7/9 10:34:45 (fd:4) (pid:528) SECMAN: command 11 UPDATE_SUBMITTOR_AD to collector pc263439 from UDP port 3144 (non-blocking).
7/9 10:34:45 (fd:4) (pid:528) SECMAN: no cached key for {<10.20.12.1:9618>,<11>}.
7/9 10:34:45 (fd:4) (pid:528) SECMAN: Security Policy:
MyType = ""
TargetType = ""
AuthMethods = "NTSSPI,KERBEROS"
CryptoMethods = "3DES,BLOWFISH"
OutgoingNegotiation = "PREFERRED"
Authentication = "OPTIONAL"
Encryption = "OPTIONAL"
Integrity = "OPTIONAL"
Enact = "NO"
Subsystem = "SCHEDD"
ParentUniqueID = "PC284419:2344:1247146273"
ServerPid = 528
SessionDuration = "86400"
7/9 10:34:45 (fd:4) (pid:528) SECMAN: negotiating security for command 11.
7/9 10:34:45 (fd:4) (pid:528) SECMAN: need to start a session via TCP
7/9 10:34:45 (fd:4) (pid:528) SEC_TCP_SESSION_TIMEOUT is undefined, using default value of 20
7/9 10:34:45 (fd:4) (pid:528) non-blocking CONNECT started fd=296 dst=<10.20.12.1:9618>
7/9 10:34:45 (fd:4) (pid:528) SECMAN: command 60010 UPDATE_SUBMITTOR_AD to <10.20.12.1:9618> from TCP port 3145 (non-blocking).
7/9 10:34:45 (fd:4) (pid:528) SECMAN: waiting for TCP connection to <10.20.12.1:9618>.
7/9 10:34:45 (fd:4) (pid:528) 
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> Sockets Registered
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> ~~~~~~~~~~~~~~~~~~~
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> 0: 720 <NULL> DC Command Handler
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> 1: 712 <NULL> DC Command Handler
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> 2: 676 <NULL> DC Command Handler
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> 3: 672 <NULL> DC Command Handler
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> 4: 292 <10.20.12.1:9618> SecManStartCommand::WaitForSocketCallback UPDATE_SCHEDD_AD
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> 5: 296 <10.20.12.1:9618> SecManStartCommand::WaitForSocketCallback UPDATE_SUBMITTOR_AD
7/9 10:34:45 (fd:4) (pid:528) 
7/9 10:34:45 (fd:4) (pid:528) ============ Begin clean_shadow_recs =============
7/9 10:34:45 (fd:4) (pid:528) ============ End clean_shadow_recs =============
7/9 10:34:45 (fd:4) (pid:528) SCHEDD_TIMEOUT_MULTIPLIER is undefined, using default value of 0
7/9 10:34:45 (fd:4) (pid:528) New Daemon obj (startd) name: "NULL", pool: "NULL", addr: "NULL"
7/9 10:34:45 (fd:4) (pid:528) Config 'NEGOTIATOR_INTERVAL': no prefix ==> '30'
7/9 10:34:45 (fd:4) (pid:528) SCHEDD_ASSUME_NEGOTIATOR_GONE is undefined, using default value of 120
7/9 10:34:45 (fd:4) (pid:528) Destroying Daemon object:
7/9 10:34:45 (fd:4) (pid:528) Type: 4 (startd), Name: (null), Addr: (null)
7/9 10:34:45 (fd:4) (pid:528) FullHost: (null), Host: (null), Pool: (null), Port: -1
7/9 10:34:45 (fd:4) (pid:528) IsLocal: N, IdStr: (null), Error: (null)
7/9 10:34:45 (fd:4) (pid:528)  --- End of Daemon object info ---
7/9 10:34:45 (fd:4) (pid:528) In reset_timer(), id=7, time=89, period=0
7/9 10:34:45 (fd:4) (pid:528) in DaemonCore NewTimer()
7/9 10:34:45 (fd:4) (pid:528) In cancel_timer(), id=7
7/9 10:34:45 (fd:4) (pid:528) Renewing timer id 7 for 89 secs
7/9 10:34:45 (fd:4) (pid:528) 
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> Timers
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> ~~~~~~
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> id = 12, when = 1247146518, period = 58, handler_descrip=<PeriodicExpr>
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> id = 13, when = 1247146521, period = 0, handler_descrip=<dc_touch_log_file>
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> id = 8, when = 1247146560, period = 0, handler_descrip=<StartJobs>
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> id = 7, when = 1247146574, period = 0, handler_descrip=<timeout>
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> id = 4, when = 1247146701, period = 240, handler_descrip=<self_monitor>
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> id = 2, when = 1247146761, period = 300, handler_descrip=<check_session_cache>
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> id = 9, when = 1247146770, period = 300, handler_descrip=<sendAlives>
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> id = 6, when = 1247147632, period = 1170, handler_descrip=<DaemonCore::SendAliveToParent>
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> id = 3, when = 1247148262, period = 1801, handler_descrip=<handle_cookie_refresh>
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> id = 11, when = 1247150060, period = 3600, handler_descrip=<CkptWallClock>
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> id = 14, when = 1247175261, period = 0, handler_descrip=<dc_touch_lock_files>
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> id = 5, when = 1247175471, period = 29014, handler_descrip=<DaemonCore::refreshDNS()>
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> id = 10, when = 1247232860, period = 86400, handler_descrip=<CleanJobQueue>
7/9 10:34:45 (fd:4) (pid:528) 
7/9 10:34:45 (fd:4) (pid:528) leaving DaemonCore NewTimer, id=7
7/9 10:34:45 (fd:4) (pid:528) Stashing socket to negotiator for future reuse
7/9 10:34:45 (fd:4) (pid:528) 
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> Sockets Registered
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> ~~~~~~~~~~~~~~~~~~~
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> 0: 720 <NULL> DC Command Handler
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> 1: 712 <NULL> DC Command Handler
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> 2: 676 <NULL> DC Command Handler
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> 3: 672 <NULL> DC Command Handler
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> 4: 292 <10.20.12.1:9618> SecManStartCommand::WaitForSocketCallback UPDATE_SCHEDD_AD
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> 5: 296 <10.20.12.1:9618> SecManStartCommand::WaitForSocketCallback UPDATE_SUBMITTOR_AD
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> 6: 308 <Negotiator Socket> <Negotiator Command>
7/9 10:34:45 (fd:4) (pid:528) 
7/9 10:34:45 (fd:4) (pid:528) Return from HandleReq <doNegotiate> (handler: 2.328s, sec: 0.422s)
7/9 10:34:45 (fd:4) (pid:528) PRIV_CONDOR --> PRIV_CONDOR at ..\src\condor_daemon_core.V6\daemon_core.cpp:3067
7/9 10:34:45 (fd:4) (pid:528) In DaemonCore Timeout()
7/9 10:34:45 (fd:4) (pid:528) 
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> Timers
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> ~~~~~~
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> id = 12, when = 1247146518, period = 58, handler_descrip=<PeriodicExpr>
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> id = 13, when = 1247146521, period = 0, handler_descrip=<dc_touch_log_file>
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> id = 8, when = 1247146560, period = 0, handler_descrip=<StartJobs>
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> id = 7, when = 1247146574, period = 0, handler_descrip=<timeout>
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> id = 4, when = 1247146701, period = 240, handler_descrip=<self_monitor>
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> id = 2, when = 1247146761, period = 300, handler_descrip=<check_session_cache>
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> id = 9, when = 1247146770, period = 300, handler_descrip=<sendAlives>
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> id = 6, when = 1247147632, period = 1170, handler_descrip=<DaemonCore::SendAliveToParent>
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> id = 3, when = 1247148262, period = 1801, handler_descrip=<handle_cookie_refresh>
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> id = 11, when = 1247150060, period = 3600, handler_descrip=<CkptWallClock>
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> id = 14, when = 1247175261, period = 0, handler_descrip=<dc_touch_lock_files>
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> id = 5, when = 1247175471, period = 29014, handler_descrip=<DaemonCore::refreshDNS()>
7/9 10:34:45 (fd:4) (pid:528) DaemonCore--> id = 10, when = 1247232860, period = 86400, handler_descrip=<CleanJobQueue>
7/9 10:34:45 (fd:4) (pid:528) 
7/9 10:34:46 (fd:4) (pid:528) DaemonCore Timeout() Complete, returning 32 
7/9 10:34:46 (fd:4) (pid:528) selector 0012FA74 resetting
7/9 10:34:46 (fd:4) (pid:528) selector 0012FA74 adding fd 720 ()
7/9 10:34:46 (fd:4) (pid:528) selector 0012FA74 adding fd 712 ()
7/9 10:34:46 (fd:4) (pid:528) selector 0012FA74 adding fd 676 ()
7/9 10:34:46 (fd:4) (pid:528) selector 0012FA74 adding fd 672 ()
7/9 10:34:46 (fd:4) (pid:528) selector 0012FA74 adding fd 292 ()
7/9 10:34:46 (fd:4) (pid:528) selector 0012FA74 adding fd 292 ()
7/9 10:34:46 (fd:4) (pid:528) selector 0012FA74 adding fd 296 ()
7/9 10:34:46 (fd:4) (pid:528) selector 0012FA74 adding fd 296 ()
7/9 10:34:46 (fd:4) (pid:528) selector 0012FA74 adding fd 308 ()
7/9 10:34:46 (fd:4) (pid:528) ACCEPT from=<10.3.28.8:3142> newfd=284 to=<10.3.28.8:3099>
7/9 10:34:46 (fd:4) (pid:528) selector 0012F7AC resetting
7/9 10:34:46 (fd:4) (pid:528) condor_read(fd=284 <10.3.28.8:3142>,,size=4,timeout=1,flags=2)
7/9 10:34:46 (fd:4) (pid:528) selector 0012F7AC adding fd 284 ()
7/9 10:34:46 (fd:4) (pid:528) condor_read(): fd=284
7/9 10:34:46 (fd:4) (pid:528) condor_read(): select returned 1
7/9 10:34:46 (fd:4) (pid:528) selector 0012F718 resetting
7/9 10:34:46 (fd:4) (pid:528) condor_read(fd=284 <10.3.28.8:3142>,,size=5,timeout=1,flags=0)
7/9 10:34:46 (fd:4) (pid:528) selector 0012F718 adding fd 284 ()
7/9 10:34:46 (fd:4) (pid:528) condor_read(): fd=284
7/9 10:34:46 (fd:4) (pid:528) condor_read(): select returned 1
7/9 10:34:46 (fd:4) (pid:528) selector 0012F700 resetting
7/9 10:34:46 (fd:4) (pid:528) condor_read(fd=284 <10.3.28.8:3142>,,size=460,timeout=1,flags=0)
7/9 10:34:46 (fd:4) (pid:528) selector 0012F700 adding fd 284 ()
7/9 10:34:46 (fd:4) (pid:528) condor_read(): fd=284
7/9 10:34:46 (fd:4) (pid:528) condor_read(): select returned 1
7/9 10:34:46 (fd:4) (pid:528) DC_AUTHENTICATE: received DC_AUTHENTICATE from <10.3.28.8:3142>
7/9 10:34:46 (fd:4) (pid:528) DC_AUTHENTICATE: received following ClassAd:
MyType = "(unknown type)"
TargetType = "(unknown type)"
AuthMethods = "NTSSPI,KERBEROS"
CryptoMethods = "3DES,BLOWFISH"
OutgoingNegotiation = "PREFERRED"
Authentication = "OPTIONAL"
Encryption = "OPTIONAL"
Integrity = "OPTIONAL"
Enact = "NO"
Subsystem = "MASTER"
ServerPid = 2344
SessionDuration = "86400"
NewSession = "YES"
RemoteVersion = "$CondorVersion: 7.2.1 Feb 19 2009 BuildID: 133382 $"
ServerCommandSock = "<10.3.28.8:2932>"
Command = 60010
AuthCommand = 60000
7/9 10:34:46 (fd:4) (pid:528) DC_AUTHENTICATE: our_policy:
MyType = ""
TargetType = ""
AuthMethods = "NTSSPI,KERBEROS"
CryptoMethods = "3DES,BLOWFISH"
OutgoingNegotiation = "PREFERRED"
Authentication = "OPTIONAL"
Encryption = "OPTIONAL"
Integrity = "OPTIONAL"
Enact = "NO"
Subsystem = "SCHEDD"
ParentUniqueID = "PC284419:2344:1247146273"
ServerPid = 528
SessionDuration = "86400"
7/9 10:34:46 (fd:4) (pid:528) DC_AUTHENTICATE: the_policy:
MyType = ""
TargetType = ""
Authentication = "NO"
Encryption = "NO"
Integrity = "NO"
AuthMethodsList = "NTSSPI,KERBEROS"
AuthMethods = "NTSSPI"
CryptoMethods = "3DES,BLOWFISH"
SessionDuration = "86400"
Enact = "YES"
7/9 10:34:46 (fd:4) (pid:528) SECMAN: Sending following response ClassAd:
MyType = ""
TargetType = ""
Authentication = "NO"
Encryption = "NO"
Integrity = "NO"
AuthMethodsList = "NTSSPI,KERBEROS"
AuthMethods = "NTSSPI"
CryptoMethods = "3DES,BLOWFISH"
SessionDuration = "86400"
Enact = "YES"
RemoteVersion = "$CondorVersion: 7.2.1 Feb 19 2009 BuildID: 133382 $"
7/9 10:34:46 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:46 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:46 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:46 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:46 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:46 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:46 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:46 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:46 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:46 (fd:4) (pid:528) selector 0012F71C resetting
7/9 10:34:46 (fd:4) (pid:528) condor_write(fd=284 <10.3.28.8:3142>,,size=325,timeout=20,flags=0)
7/9 10:34:46 (fd:4) (pid:528) selector 0012F71C adding fd 284 ()
7/9 10:34:46 (fd:4) (pid:528) selector 0012F71C adding fd 284 ()
7/9 10:34:46 (fd:4) (pid:528) selector 0012F71C adding fd 284 ()
7/9 10:34:46 (fd:4) (pid:528) selector 0012F71C adding fd 284 ()
7/9 10:34:46 (fd:4) (pid:528) DC_AUTHENTICATE: not authenticating.
7/9 10:34:46 (fd:4) (pid:528) DC_AUTHENTICATE: sending session ad:
MyType = ""
TargetType = ""
Sid = "PC284419:528:1247146486:1"
ValidCommands = "60000,60008,60017,71003,441,74000,60004,404,421,443,464,478,479,480,481,486,487,488,489,499,502,507,60007,60011,1111,457,471"
7/9 10:34:46 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:46 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:46 (fd:4) (pid:528) selector 0012F71C resetting
7/9 10:34:46 (fd:4) (pid:528) condor_write(fd=284 <10.3.28.8:3142>,,size=244,timeout=20,flags=0)
7/9 10:34:46 (fd:4) (pid:528) selector 0012F71C adding fd 284 ()
7/9 10:34:46 (fd:4) (pid:528) selector 0012F71C adding fd 284 ()
7/9 10:34:46 (fd:4) (pid:528) selector 0012F71C adding fd 284 ()
7/9 10:34:46 (fd:4) (pid:528) selector 0012F71C adding fd 284 ()
7/9 10:34:46 (fd:4) (pid:528) DC_AUTHENTICATE: sent session PC284419:528:1247146486:1 info!
7/9 10:34:46 (fd:4) (pid:528) SEC_SESSION_DURATION_SLOP is undefined, using default value of 20
7/9 10:34:46 (fd:4) (pid:528) DC_AUTHENTICATE: added incoming session id PC284419:528:1247146486:1 to cache for 86420 seconds (return address is <10.3.28.8:2932>).
MyType = ""
TargetType = ""
Authentication = "NO"
Encryption = "NO"
Integrity = "NO"
AuthMethodsList = "NTSSPI,KERBEROS"
AuthMethods = "NTSSPI"
CryptoMethods = "3DES,BLOWFISH"
SessionDuration = "86400"
Enact = "YES"
Subsystem = "MASTER"
ServerCommandSock = "<10.3.28.8:2932>"
ServerPid = 2344
RemoteVersion = "$CondorVersion: 7.2.1 Feb 19 2009 BuildID: 133382 $"
Sid = "PC284419:528:1247146486:1"
ValidCommands = "60000,60008,60017,71003,441,74000,60004,404,421,443,464,478,479,480,481,486,487,488,489,499,502,507,60007,60011,1111,457,471"
7/9 10:34:46 (fd:4) (pid:528) CLOSE <10.3.28.8:3099> fd=284
7/9 10:34:46 (fd:4) (pid:528) PRIV_CONDOR --> PRIV_CONDOR at ..\src\condor_daemon_core.V6\daemon_core.cpp:3067
7/9 10:34:46 (fd:4) (pid:528) selector 0012FA74 resetting
7/9 10:34:46 (fd:4) (pid:528) selector 0012FA74 adding fd 308 ()
7/9 10:34:46 (fd:4) (pid:528) Calling Handler <<Negotiator Command>> for Socket <<Negotiator Socket>>
7/9 10:34:46 (fd:4) (pid:528) Calling Handler <<Negotiator Command>>
7/9 10:34:46 (fd:4) (pid:528) Activity on stashed negotiator socket
7/9 10:34:46 (fd:4) (pid:528) selector 0012F908 resetting
7/9 10:34:46 (fd:4) (pid:528) condor_read(fd=308 <10.3.28.8:3123>,,size=5,timeout=20,flags=0)
7/9 10:34:46 (fd:4) (pid:528) selector 0012F908 adding fd 308 ()
7/9 10:34:46 (fd:4) (pid:528) condor_read(): fd=308
7/9 10:34:46 (fd:4) (pid:528) condor_read(): select returned 1
7/9 10:34:46 (fd:4) (pid:528) condor_read(): recv() returned -1, errno = 10054, assuming failure reading 5 bytes from <10.3.28.8:3123>.
7/9 10:34:46 (fd:4) (pid:528) IO: Failed to read packet header
7/9 10:34:46 (fd:4) (pid:528) Stream::get(int) failed to read padding
7/9 10:34:46 (fd:4) (pid:528) Socket activated, but could not read command
7/9 10:34:46 (fd:4) (pid:528) (Negotiator probably invalidated cached socket)
7/9 10:34:46 (fd:4) (pid:528) Return from Handler <<Negotiator Command>>
7/9 10:34:46 (fd:4) (pid:528) PRIV_CONDOR --> PRIV_CONDOR at ..\src\condor_daemon_core.V6\daemon_core.cpp:3067
7/9 10:34:46 (fd:4) (pid:528) CLOSE <10.3.28.8:3099> fd=308
7/9 10:34:46 (fd:4) (pid:528) Cancel_Socket: cancelled socket 6 <<Negotiator Socket>> 011EE4A0
7/9 10:34:46 (fd:4) (pid:528) 
7/9 10:34:46 (fd:4) (pid:528) DaemonCore--> Sockets Registered
7/9 10:34:46 (fd:4) (pid:528) DaemonCore--> ~~~~~~~~~~~~~~~~~~~
7/9 10:34:46 (fd:4) (pid:528) DaemonCore--> 0: 720 <NULL> DC Command Handler
7/9 10:34:46 (fd:4) (pid:528) DaemonCore--> 1: 712 <NULL> DC Command Handler
7/9 10:34:46 (fd:4) (pid:528) DaemonCore--> 2: 676 <NULL> DC Command Handler
7/9 10:34:46 (fd:4) (pid:528) DaemonCore--> 3: 672 <NULL> DC Command Handler
7/9 10:34:46 (fd:4) (pid:528) DaemonCore--> 4: 292 <10.20.12.1:9618> SecManStartCommand::WaitForSocketCallback UPDATE_SCHEDD_AD
7/9 10:34:46 (fd:4) (pid:528) DaemonCore--> 5: 296 <10.20.12.1:9618> SecManStartCommand::WaitForSocketCallback UPDATE_SUBMITTOR_AD
7/9 10:34:46 (fd:4) (pid:528) 
7/9 10:34:46 (fd:4) (pid:528) In DaemonCore Timeout()
7/9 10:34:46 (fd:4) (pid:528) 
7/9 10:34:46 (fd:4) (pid:528) DaemonCore--> Timers
7/9 10:34:46 (fd:4) (pid:528) DaemonCore--> ~~~~~~
7/9 10:34:46 (fd:4) (pid:528) DaemonCore--> id = 12, when = 1247146518, period = 58, handler_descrip=<PeriodicExpr>
7/9 10:34:46 (fd:4) (pid:528) DaemonCore--> id = 13, when = 1247146521, period = 0, handler_descrip=<dc_touch_log_file>
7/9 10:34:46 (fd:4) (pid:528) DaemonCore--> id = 8, when = 1247146560, period = 0, handler_descrip=<StartJobs>
7/9 10:34:46 (fd:4) (pid:528) DaemonCore--> id = 7, when = 1247146574, period = 0, handler_descrip=<timeout>
7/9 10:34:46 (fd:4) (pid:528) DaemonCore--> id = 4, when = 1247146701, period = 240, handler_descrip=<self_monitor>
7/9 10:34:46 (fd:4) (pid:528) DaemonCore--> id = 2, when = 1247146761, period = 300, handler_descrip=<check_session_cache>
7/9 10:34:46 (fd:4) (pid:528) DaemonCore--> id = 9, when = 1247146770, period = 300, handler_descrip=<sendAlives>
7/9 10:34:46 (fd:4) (pid:528) DaemonCore--> id = 6, when = 1247147632, period = 1170, handler_descrip=<DaemonCore::SendAliveToParent>
7/9 10:34:46 (fd:4) (pid:528) DaemonCore--> id = 3, when = 1247148262, period = 1801, handler_descrip=<handle_cookie_refresh>
7/9 10:34:46 (fd:4) (pid:528) DaemonCore--> id = 11, when = 1247150060, period = 3600, handler_descrip=<CkptWallClock>
7/9 10:34:46 (fd:4) (pid:528) DaemonCore--> id = 14, when = 1247175261, period = 0, handler_descrip=<dc_touch_lock_files>
7/9 10:34:46 (fd:4) (pid:528) DaemonCore--> id = 5, when = 1247175471, period = 29014, handler_descrip=<DaemonCore::refreshDNS()>
7/9 10:34:46 (fd:4) (pid:528) DaemonCore--> id = 10, when = 1247232860, period = 86400, handler_descrip=<CleanJobQueue>
7/9 10:34:46 (fd:4) (pid:528) 
7/9 10:34:46 (fd:4) (pid:528) DaemonCore Timeout() Complete, returning 32 
7/9 10:34:46 (fd:4) (pid:528) selector 0012FA74 resetting
7/9 10:34:46 (fd:4) (pid:528) selector 0012FA74 adding fd 720 ()
7/9 10:34:46 (fd:4) (pid:528) selector 0012FA74 adding fd 712 ()
7/9 10:34:46 (fd:4) (pid:528) selector 0012FA74 adding fd 676 ()
7/9 10:34:46 (fd:4) (pid:528) selector 0012FA74 adding fd 672 ()
7/9 10:34:46 (fd:4) (pid:528) selector 0012FA74 adding fd 292 ()
7/9 10:34:46 (fd:4) (pid:528) selector 0012FA74 adding fd 292 ()
7/9 10:34:46 (fd:4) (pid:528) selector 0012FA74 adding fd 296 ()
7/9 10:34:46 (fd:4) (pid:528) selector 0012FA74 adding fd 296 ()
7/9 10:34:46 (fd:4) (pid:528) RECV 655 bytes at <10.3.28.8:3099> from <10.3.28.8:3140>
7/9 10:34:46 (fd:4) (pid:528) 	Full msg [655 bytes]
7/9 10:34:46 (fd:4) (pid:528) DC_AUTHENTICATE: received UDP packet from <10.3.28.8:3140>.
7/9 10:34:46 (fd:4) (pid:528) DC_AUTHENTICATE: received DC_AUTHENTICATE from <10.3.28.8:3140>
7/9 10:34:46 (fd:4) (pid:528) DC_AUTHENTICATE: received following ClassAd:
MyType = "(unknown type)"
TargetType = "(unknown type)"
ServerPid = 2344
OutgoingNegotiation = "PREFERRED"
Subsystem = "MASTER"
AuthCommand = 60000
Enact = "YES"
AuthMethodsList = "NTSSPI,KERBEROS"
AuthMethods = "NTSSPI"
CryptoMethods = "3DES,BLOWFISH"
Authentication = "NO"
Encryption = "NO"
Integrity = "NO"
SessionDuration = "86400"
UseSession = "YES"
Sid = "PC284419:528:1247146486:1"
ValidCommands = "60000,60008,60017,71003,441,74000,60004,404,421,443,464,478,479,480,481,486,487,488,489,499,502,507,60007,60011,1111,457,471"
RemoteVersion = "$CondorVersion: 7.2.1 Feb 19 2009 BuildID: 133382 $"
ServerCommandSock = "<10.3.28.8:2932>"
Command = 60000
7/9 10:34:46 (fd:4) (pid:528) DC_AUTHENTICATE: resuming session id PC284419:528:1247146486:1 with return address <10.3.28.8:2932>:
7/9 10:34:46 (fd:4) (pid:528) DC_AUTHENTICATE: Cached Session:
MyType = ""
TargetType = ""
Authentication = "NO"
Encryption = "NO"
Integrity = "NO"
AuthMethodsList = "NTSSPI,KERBEROS"
AuthMethods = "NTSSPI"
CryptoMethods = "3DES,BLOWFISH"
SessionDuration = "86400"
Enact = "YES"
Subsystem = "MASTER"
ServerCommandSock = "<10.3.28.8:2932>"
ServerPid = 2344
RemoteVersion = "$CondorVersion: 7.2.1 Feb 19 2009 BuildID: 133382 $"
Sid = "PC284419:528:1247146486:1"
ValidCommands = "60000,60008,60017,71003,441,74000,60004,404,421,443,464,478,479,480,481,486,487,488,489,499,502,507,60007,60011,1111,457,471"
7/9 10:34:46 (fd:4) (pid:528) DC_AUTHENTICATE: setting sock->decode()
7/9 10:34:46 (fd:4) (pid:528) DC_AUTHENTICATE: allowing an empty message for sock.
7/9 10:34:46 (fd:4) (pid:528) DC_AUTHENTICATE: Success.
7/9 10:34:46 (fd:4) (pid:528) IPVERIFY: matched user * from 10.* to allow list
7/9 10:34:46 (fd:4) (pid:528) Adding to resolved authorization table: */10.3.28.8: DAEMON

7/9 10:34:46 (fd:4) (pid:528) PERMISSION GRANTED to unauthenticated user from host 10.3.28.8 for command 60000 (DC_RAISESIGNAL), access level DAEMON: reason: DAEMON authorization policy allows IP address 10.3.28.8; identifiers used for this remote host: 10.3.28.8,PC284419.corp.ad.emb
7/9 10:34:46 (fd:4) (pid:528) Received UDP command 60000 (DC_RAISESIGNAL) from  <10.3.28.8:3140>, access level DAEMON
7/9 10:34:46 (fd:4) (pid:528) Calling HandleReq <HandleSigCommand()> (0)
7/9 10:34:46 (fd:4) (pid:528) DaemonCore: received Signal 15 (SIGTERM), raising event handle_dc_sigterm()
7/9 10:34:46 (fd:4) (pid:528) Return from HandleReq <HandleSigCommand()> (handler: 0.000s, sec: 0.157s)
7/9 10:34:46 (fd:4) (pid:528) PRIV_CONDOR --> PRIV_CONDOR at ..\src\condor_daemon_core.V6\daemon_core.cpp:3067
7/9 10:34:46 (fd:4) (pid:528) Calling Handler <handle_dc_sigterm()> for Signal 15 <SIGTERM>
7/9 10:34:46 (fd:4) (pid:528) Got SIGTERM. Performing graceful shutdown.
7/9 10:34:46 (fd:4) (pid:528) in DaemonCore NewTimer()
7/9 10:34:46 (fd:4) (pid:528) 
7/9 10:34:46 (fd:4) (pid:528) DaemonCore--> Timers
7/9 10:34:46 (fd:4) (pid:528) DaemonCore--> ~~~~~~
7/9 10:34:46 (fd:4) (pid:528) DaemonCore--> id = 12, when = 1247146518, period = 58, handler_descrip=<PeriodicExpr>
7/9 10:34:46 (fd:4) (pid:528) DaemonCore--> id = 13, when = 1247146521, period = 0, handler_descrip=<dc_touch_log_file>
7/9 10:34:46 (fd:4) (pid:528) DaemonCore--> id = 8, when = 1247146560, period = 0, handler_descrip=<StartJobs>
7/9 10:34:46 (fd:4) (pid:528) DaemonCore--> id = 7, when = 1247146574, period = 0, handler_descrip=<timeout>
7/9 10:34:46 (fd:4) (pid:528) DaemonCore--> id = 4, when = 1247146701, period = 240, handler_descrip=<self_monitor>
7/9 10:34:46 (fd:4) (pid:528) DaemonCore--> id = 2, when = 1247146761, period = 300, handler_descrip=<check_session_cache>
7/9 10:34:46 (fd:4) (pid:528) DaemonCore--> id = 9, when = 1247146770, period = 300, handler_descrip=<sendAlives>
7/9 10:34:46 (fd:4) (pid:528) DaemonCore--> id = 6, when = 1247147632, period = 1170, handler_descrip=<DaemonCore::SendAliveToParent>
7/9 10:34:46 (fd:4) (pid:528) DaemonCore--> id = 3, when = 1247148262, period = 1801, handler_descrip=<handle_cookie_refresh>
7/9 10:34:46 (fd:4) (pid:528) DaemonCore--> id = 15, when = 1247148286, period = 0, handler_descrip=<main_shutdown_fast>
7/9 10:34:46 (fd:4) (pid:528) DaemonCore--> id = 11, when = 1247150060, period = 3600, handler_descrip=<CkptWallClock>
7/9 10:34:46 (fd:4) (pid:528) DaemonCore--> id = 14, when = 1247175261, period = 0, handler_descrip=<dc_touch_lock_files>
7/9 10:34:46 (fd:4) (pid:528) DaemonCore--> id = 5, when = 1247175471, period = 29014, handler_descrip=<DaemonCore::refreshDNS()>
7/9 10:34:46 (fd:4) (pid:528) DaemonCore--> id = 10, when = 1247232860, period = 86400, handler_descrip=<CleanJobQueue>
7/9 10:34:46 (fd:4) (pid:528) 
7/9 10:34:46 (fd:4) (pid:528) leaving DaemonCore NewTimer, id=15
7/9 10:34:46 (fd:4) (pid:528) Started timer to call main_shutdown_fast in 1800 seconds
7/9 10:34:46 (fd:4) (pid:528) Now in shutdown_graceful
7/9 10:34:46 (fd:4) (pid:528) CronMgr: 0 jobs alive
7/9 10:34:46 (fd:4) (pid:528) Deleting CronMgr
7/9 10:34:46 (fd:4) (pid:528) ScheddCronMgr: Shutting down
7/9 10:34:46 (fd:4) (pid:528) CronMgr: Killing all jobs
7/9 10:34:46 (fd:4) (pid:528) Cron: Killing all jobs
7/9 10:34:46 (fd:4) (pid:528) ScheddCronMgr: Bye
7/9 10:34:46 (fd:4) (pid:528) Cron: Killing all jobs
7/9 10:34:46 (fd:4) (pid:528) Cron: Deleting all jobs
7/9 10:34:46 (fd:4) (pid:528) CronMgr: bye
7/9 10:34:46 (fd:4) (pid:528) Cron: Killing all jobs
7/9 10:34:46 (fd:4) (pid:528) Cron: Deleting all jobs
7/9 10:34:46 (fd:4) (pid:528) Trying to update collector <10.3.28.8:9618>
7/9 10:34:46 (fd:4) (pid:528) Attempting to send update via UDP to collector PC284419.corp.ad.emb <10.3.28.8:9618>
7/9 10:34:46 (fd:4) (pid:528) SECMAN: command 14 INVALIDATE_SCHEDD_ADS to collector pc284419 from UDP port 3154 (blocking).
7/9 10:34:46 (fd:4) (pid:528) SECMAN: using session PC284419:3236:1247146467:11 for {<10.3.28.8:9618>,<14>}.
7/9 10:34:46 (fd:4) (pid:528) SECMAN: found cached session id PC284419:3236:1247146467:11 for {<10.3.28.8:9618>,<14>}.
7/9 10:34:46 (fd:4) (pid:528) SEC_DEBUG_PRINT_KEYS is undefined, using default value of False
MyType = ""
TargetType = ""
OutgoingNegotiation = "PREFERRED"
Subsystem = "SCHEDD"
Command = 60010
AuthCommand = 11
RemoteVersion = "$CondorVersion: 7.2.1 Feb 19 2009 BuildID: 133382 $"
Enact = "YES"
AuthMethodsList = "NTSSPI,KERBEROS"
AuthMethods = "NTSSPI"
CryptoMethods = "3DES,BLOWFISH"
Authentication = "NO"
Encryption = "NO"
Integrity = "NO"
SessionDuration = "86400"
UseSession = "YES"
Sid = "PC284419:3236:1247146467:11"
ValidCommands = "1,11,14,18"
7/9 10:34:46 (fd:4) (pid:528) SECMAN: Security Policy:
MyType = ""
TargetType = ""
OutgoingNegotiation = "PREFERRED"
Subsystem = "SCHEDD"
Command = 60010
AuthCommand = 11
RemoteVersion = "$CondorVersion: 7.2.1 Feb 19 2009 BuildID: 133382 $"
Enact = "YES"
AuthMethodsList = "NTSSPI,KERBEROS"
AuthMethods = "NTSSPI"
CryptoMethods = "3DES,BLOWFISH"
Authentication = "NO"
Encryption = "NO"
Integrity = "NO"
SessionDuration = "86400"
UseSession = "YES"
Sid = "PC284419:3236:1247146467:11"
ValidCommands = "1,11,14,18"
7/9 10:34:47 (fd:4) (pid:528) SECMAN: negotiating security for command 14.
7/9 10:34:47 (fd:4) (pid:528) SECMAN: UDP, m_have_session == 1, peer_can_negotiate == 1
7/9 10:34:47 (fd:4) (pid:528) SECMAN: UDP has session PC284419:3236:1247146467:11.
7/9 10:34:47 (fd:4) (pid:528) SECMAN: sending DC_AUTHENTICATE command
7/9 10:34:47 (fd:4) (pid:528) SECMAN: sending following classad:
MyType = ""
TargetType = ""
OutgoingNegotiation = "PREFERRED"
Subsystem = "SCHEDD"
AuthCommand = 11
Enact = "YES"
AuthMethodsList = "NTSSPI,KERBEROS"
AuthMethods = "NTSSPI"
CryptoMethods = "3DES,BLOWFISH"
Authentication = "NO"
Encryption = "NO"
Integrity = "NO"
SessionDuration = "86400"
UseSession = "YES"
Sid = "PC284419:3236:1247146467:11"
ValidCommands = "1,11,14,18"
RemoteVersion = "$CondorVersion: 7.2.1 Feb 19 2009 BuildID: 133382 $"
ServerCommandSock = "<10.3.28.8:3099>"
Command = 14
7/9 10:34:47 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:47 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:47 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:47 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:47 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:47 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:47 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:47 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:47 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:47 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:47 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:47 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:47 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:47 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:47 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:47 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:47 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:47 (fd:4) (pid:528) SECMAN: startCommand succeeded.
7/9 10:34:47 (fd:4) (pid:528) Authorizing server '*/10.3.28.8'.
7/9 10:34:47 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:47 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:47 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:47 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:47 (fd:4) (pid:528) SEND [715] <10.3.28.8:3154> <10.3.28.8:9618>
7/9 10:34:47 (fd:4) (pid:528) Trying to update collector <10.3.28.8:9618>
7/9 10:34:47 (fd:4) (pid:528) Attempting to send update via UDP to collector PC284419.corp.ad.emb <10.3.28.8:9618>
7/9 10:34:47 (fd:4) (pid:528) SECMAN: command 18 INVALIDATE_SUBMITTOR_ADS to collector pc284419 from UDP port 3156 (blocking).
7/9 10:34:47 (fd:4) (pid:528) SECMAN: using session PC284419:3236:1247146467:11 for {<10.3.28.8:9618>,<18>}.
7/9 10:34:47 (fd:4) (pid:528) SECMAN: found cached session id PC284419:3236:1247146467:11 for {<10.3.28.8:9618>,<18>}.
7/9 10:34:47 (fd:4) (pid:528) SEC_DEBUG_PRINT_KEYS is undefined, using default value of False
MyType = ""
TargetType = ""
OutgoingNegotiation = "PREFERRED"
Subsystem = "SCHEDD"
Command = 60010
AuthCommand = 11
RemoteVersion = "$CondorVersion: 7.2.1 Feb 19 2009 BuildID: 133382 $"
Enact = "YES"
AuthMethodsList = "NTSSPI,KERBEROS"
AuthMethods = "NTSSPI"
CryptoMethods = "3DES,BLOWFISH"
Authentication = "NO"
Encryption = "NO"
Integrity = "NO"
SessionDuration = "86400"
UseSession = "YES"
Sid = "PC284419:3236:1247146467:11"
ValidCommands = "1,11,14,18"
7/9 10:34:47 (fd:4) (pid:528) SECMAN: Security Policy:
MyType = ""
TargetType = ""
OutgoingNegotiation = "PREFERRED"
Subsystem = "SCHEDD"
Command = 60010
AuthCommand = 11
RemoteVersion = "$CondorVersion: 7.2.1 Feb 19 2009 BuildID: 133382 $"
Enact = "YES"
AuthMethodsList = "NTSSPI,KERBEROS"
AuthMethods = "NTSSPI"
CryptoMethods = "3DES,BLOWFISH"
Authentication = "NO"
Encryption = "NO"
Integrity = "NO"
SessionDuration = "86400"
UseSession = "YES"
Sid = "PC284419:3236:1247146467:11"
ValidCommands = "1,11,14,18"
7/9 10:34:47 (fd:4) (pid:528) SECMAN: negotiating security for command 18.
7/9 10:34:47 (fd:4) (pid:528) SECMAN: UDP, m_have_session == 1, peer_can_negotiate == 1
7/9 10:34:47 (fd:4) (pid:528) SECMAN: UDP has session PC284419:3236:1247146467:11.
7/9 10:34:47 (fd:4) (pid:528) SECMAN: sending DC_AUTHENTICATE command
7/9 10:34:47 (fd:4) (pid:528) SECMAN: sending following classad:
MyType = ""
TargetType = ""
OutgoingNegotiation = "PREFERRED"
Subsystem = "SCHEDD"
AuthCommand = 11
Enact = "YES"
AuthMethodsList = "NTSSPI,KERBEROS"
AuthMethods = "NTSSPI"
CryptoMethods = "3DES,BLOWFISH"
Authentication = "NO"
Encryption = "NO"
Integrity = "NO"
SessionDuration = "86400"
UseSession = "YES"
Sid = "PC284419:3236:1247146467:11"
ValidCommands = "1,11,14,18"
RemoteVersion = "$CondorVersion: 7.2.1 Feb 19 2009 BuildID: 133382 $"
ServerCommandSock = "<10.3.28.8:3099>"
Command = 18
7/9 10:34:47 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:47 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:47 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:47 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:47 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:47 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:47 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:47 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:47 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:47 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:47 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:47 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:47 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:47 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:47 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:47 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:47 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:47 (fd:4) (pid:528) SECMAN: startCommand succeeded.
7/9 10:34:47 (fd:4) (pid:528) Authorizing server '*/10.3.28.8'.
7/9 10:34:47 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:47 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:47 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:47 (fd:4) (pid:528) ENCRYPT_SECRETS is undefined, using default value of True
7/9 10:34:47 (fd:4) (pid:528) SEND [721] <10.3.28.8:3156> <10.3.28.8:9618>
7/9 10:34:47 (fd:4) (pid:528) Attempting to send update via UDP to collector pc263439.corp.ad.emb <10.20.12.1:9618>
7/9 10:34:47 (fd:4) (pid:528) SECMAN: command 18 INVALIDATE_SUBMITTOR_ADS to collector pc263439 from UDP port 3158 (blocking).
7/9 10:34:47 (fd:4) (pid:528) SECMAN: no cached key for {<10.20.12.1:9618>,<18>}.
7/9 10:34:47 (fd:4) (pid:528) SECMAN: Security Policy:
MyType = ""
TargetType = ""
AuthMethods = "NTSSPI,KERBEROS"
CryptoMethods = "3DES,BLOWFISH"
OutgoingNegotiation = "PREFERRED"
Authentication = "OPTIONAL"
Encryption = "OPTIONAL"
Integrity = "OPTIONAL"
Enact = "NO"
Subsystem = "SCHEDD"
ParentUniqueID = "PC284419:2344:1247146273"
ServerPid = 528
SessionDuration = "86400"
7/9 10:34:47 (fd:4) (pid:528) SECMAN: negotiating security for command 18.
7/9 10:34:47 (fd:4) (pid:528) SECMAN: need to start a session via TCP
7/9 10:34:47 (fd:4) (pid:528) SEC_TCP_SESSION_TIMEOUT is undefined, using default value of 20
7/9 10:34:47 (fd:4) (pid:528) selector 0012F504 resetting
7/9 10:34:47 (fd:4) (pid:528) selector 0012F504 resetting
7/9 10:34:47 (fd:4) (pid:528) selector 0012F504 adding fd 284 ()
7/9 10:34:47 (fd:4) (pid:528) selector 0012F504 adding fd 284 ()
7/9 10:35:07 (fd:4) (pid:528) attempt to connect to <10.20.12.1:9618> failed: timed out after 20 seconds.
7/9 10:35:07 (fd:4) (pid:528) SECMAN: couldn't connect via TCP to <10.20.12.1:9618>, failing...
7/9 10:35:07 (fd:4) (pid:528) CLOSE <10.3.28.8:3166> fd=288
7/9 10:35:07 (fd:4) (pid:528) ERROR: SECMAN:2003:TCP auth connection to <10.20.12.1:9618> failed

7/9 10:35:07 (fd:4) (pid:528) Cancel_Socket: cancelled socket 0 <<NULL>> 0116FDC8
7/9 10:35:07 (fd:4) (pid:528) 
7/9 10:35:07 (fd:4) (pid:528) DaemonCore--> Sockets Registered
7/9 10:35:07 (fd:4) (pid:528) DaemonCore--> ~~~~~~~~~~~~~~~~~~~
7/9 10:35:07 (fd:4) (pid:528) DaemonCore--> 0: 296 <10.20.12.1:9618> SecManStartCommand::WaitForSocketCallback UPDATE_SUBMITTOR_AD
7/9 10:35:07 (fd:4) (pid:528) DaemonCore--> 1: 712 <NULL> DC Command Handler
7/9 10:35:07 (fd:4) (pid:528) DaemonCore--> 2: 676 <NULL> DC Command Handler
7/9 10:35:07 (fd:4) (pid:528) DaemonCore--> 3: 672 <NULL> DC Command Handler
7/9 10:35:07 (fd:4) (pid:528) DaemonCore--> 4: 292 <10.20.12.1:9618> SecManStartCommand::WaitForSocketCallback UPDATE_SCHEDD_AD
7/9 10:35:07 (fd:4) (pid:528) 
7/9 10:35:07 (fd:4) (pid:528) CLOSE <10.3.28.8:3099> fd=720
7/9 10:35:07 (fd:4) (pid:528) Cancel_Socket: cancelled socket 0 <<10.20.12.1:9618>> 016ADBE0
7/9 10:35:07 (fd:4) (pid:528) 
7/9 10:35:07 (fd:4) (pid:528) DaemonCore--> Sockets Registered
7/9 10:35:07 (fd:4) (pid:528) DaemonCore--> ~~~~~~~~~~~~~~~~~~~
7/9 10:35:07 (fd:4) (pid:528) DaemonCore--> 0: 292 <10.20.12.1:9618> SecManStartCommand::WaitForSocketCallback UPDATE_SCHEDD_AD
7/9 10:35:07 (fd:4) (pid:528) DaemonCore--> 1: 712 <NULL> DC Command Handler
7/9 10:35:07 (fd:4) (pid:528) DaemonCore--> 2: 676 <NULL> DC Command Handler
7/9 10:35:07 (fd:4) (pid:528) DaemonCore--> 3: 672 <NULL> DC Command Handler
7/9 10:35:07 (fd:4) (pid:528) 
7/9 10:35:07 (fd:4) (pid:528) CLOSE <10.3.28.8:3145> fd=296
7/9 10:35:07 (fd:4) (pid:528) Cancel_Socket: cancelled socket 0 <<10.20.12.1:9618>> 011A03C8
7/9 10:35:07 (fd:4) (pid:528) 
7/9 10:35:07 (fd:4) (pid:528) DaemonCore--> Sockets Registered
7/9 10:35:07 (fd:4) (pid:528) DaemonCore--> ~~~~~~~~~~~~~~~~~~~
7/9 10:35:07 (fd:4) (pid:528) DaemonCore--> 0: 672 <NULL> DC Command Handler
7/9 10:35:07 (fd:4) (pid:528) DaemonCore--> 1: 712 <NULL> DC Command Handler
7/9 10:35:07 (fd:4) (pid:528) DaemonCore--> 2: 676 <NULL> DC Command Handler
7/9 10:35:07 (fd:4) (pid:528) 
7/9 10:35:07 (fd:4) (pid:528) CLOSE <10.3.28.8:3132> fd=292
7/9 10:35:07 (fd:4) (pid:528) Cancel_Socket: cancelled socket 0 <<NULL>> 011A8D50
7/9 10:35:07 (fd:4) (pid:528) 
7/9 10:35:07 (fd:4) (pid:528) DaemonCore--> Sockets Registered
7/9 10:35:07 (fd:4) (pid:528) DaemonCore--> ~~~~~~~~~~~~~~~~~~~
7/9 10:35:07 (fd:4) (pid:528) DaemonCore--> 0: 676 <NULL> DC Command Handler
7/9 10:35:07 (fd:4) (pid:528) DaemonCore--> 1: 712 <NULL> DC Command Handler
7/9 10:35:07 (fd:4) (pid:528) 
7/9 10:35:07 (fd:4) (pid:528) Cancel_Socket: cancelled socket 0 <<NULL>> 011A61F0
7/9 10:35:07 (fd:4) (pid:528) 
7/9 10:35:07 (fd:4) (pid:528) DaemonCore--> Sockets Registered
7/9 10:35:07 (fd:4) (pid:528) DaemonCore--> ~~~~~~~~~~~~~~~~~~~
7/9 10:35:07 (fd:4) (pid:528) DaemonCore--> 0: 712 <NULL> DC Command Handler
7/9 10:35:07 (fd:4) (pid:528) 
7/9 10:35:07 (fd:4) (pid:528) CLOSE <10.3.28.8:3102> fd=676
7/9 10:35:07 (fd:4) (pid:528) Cancel_Socket: cancelled socket 0 <<NULL>> 01176E98
7/9 10:35:07 (fd:4) (pid:528) 
7/9 10:35:07 (fd:4) (pid:528) DaemonCore--> Sockets Registered
7/9 10:35:07 (fd:4) (pid:528) DaemonCore--> ~~~~~~~~~~~~~~~~~~~
7/9 10:35:07 (fd:4) (pid:528) 
7/9 10:35:07 (fd:4) (pid:528) Canceled/Closed 6 socket(s) at shutdown
7/9 10:35:07 (fd:4) (pid:528) All shadows are gone, exiting.
7/9 10:35:07 (fd:4) (pid:528) Removed address file C:\Condor/log/.schedd_address
7/9 10:35:07 (fd:4) (pid:528) Removed local classad file C:\Condor/log/.schedd_classad
7/9 10:35:07 (fd:4) (pid:528) KEYCACHEENTRY: deleted: 011CA088
7/9 10:35:07 (fd:4) (pid:528) KEYCACHEENTRY: deleted: 011CA390
7/9 10:35:07 (fd:4) (pid:528) KEYCACHEENTRY: deleted: 0120AFC0
7/9 10:35:07 (fd:4) (pid:528) KEYCACHEENTRY: deleted: 0121A800
7/9 10:35:07 (fd:4) (pid:528) KEYCACHEENTRY: deleted: 011A35B8
7/9 10:35:07 (fd:4) (pid:528) KEYCACHEENTRY: deleted: 0120A3C8
7/9 10:35:07 (fd:4) (pid:528) KEYCACHE: deleted: 010F8480
7/9 10:35:07 (fd:4) (pid:528) About to tell the ProcD to exit
7/9 10:35:07 (fd:4) (pid:528) Result of "quit" operation from ProcD: SUCCESS
7/9 10:35:07 (fd:4) (pid:528) Destroying Daemon object:
7/9 10:35:07 (fd:4) (pid:528) Type: 5 (collector), Name: pc284419, Addr: <10.3.28.8:9618>
7/9 10:35:07 (fd:4) (pid:528) FullHost: PC284419.corp.ad.emb, Host: PC284419, Pool: pc284419, Port: 9618
7/9 10:35:07 (fd:4) (pid:528) IsLocal: N, IdStr: collector pc284419, Error: (null)
7/9 10:35:07 (fd:4) (pid:528)  --- End of Daemon object info ---
7/9 10:35:07 (fd:4) (pid:528) **** condor_schedd.exe (condor_SCHEDD) pid 528 EXITING WITH STATUS 0
7/9 10:35:07 (fd:4) (pid:528) Destroying Daemon object:
7/9 10:35:07 (fd:4) (pid:528) Type: 5 (collector), Name: pc263439, Addr: <10.20.12.1:9618>
7/9 10:35:07 (fd:4) (pid:528) FullHost: pc263439.corp.ad.emb, Host: pc263439, Pool: pc263439, Port: 9618
7/9 10:35:07 (fd:4) (pid:528) IsLocal: N, IdStr: collector pc263439, Error: Failed to send UDP update command to collector
