Bug New Server Auth Error

    C

    cheesekiller

    Joined
    Dec 13, 2014
    Messages
    1
    Reaction score
    0
    I just Started a new server and when i first log in after deleted protected.txt it logs in fine, if i log in a few second after that it works just fine, if i wait a few min and log in it gives me the protected name error.
    I need to use Protected Auth and on the old server it worked just fine without any problems. any ideas?


    11:11:11 [SERVER][LOGIN] new client connected. given id: 2: description: Cheesekiller
    11:11:11 [SERVER][LOGIN] return code 0
    11:11:11 [AUTH] authenticating Cheesekiller; useAuth: true; requireAuth: true
    11:11:11 [SESSION_CALLBACK] verifying player Cheesekiller with token: XlBdUYX6RJZWfU1tGIZw6A
    11:11:11 [OAuth2] Verifying Auth Token 'XlBdUYX6RJZWfU1tGIZw6A'
    11:11:11 [SERVERSOCKET] Connection made. starting new processor 55806, /217.120.167.15; local: 4242, /192.111.132.102, keepalive false
    11:11:11 [SERVER] connection registered (TRunning: 1/1/1) 54
    11:11:11 [SERVER][PROCESSOR] client setup completed for PID: 54. listening for input
    11:11:11 [SERVER] This client is an info ping (server-lists): /217.120.167.15; PID: 54
    11:11:11 [SERVER] Executing scheduled disconnect!; ProcessorID: 54
    11:11:11 [SERVER][DISCONNECT] Client 'Info-Pinger (server-lists)' HAS BEEN DISCONNECTED . PROBE: true; ProcessorID: 54
    11:11:11 [SERVER] PROBE SUCCESSFULLY EXECUTED. STOPPING PROCESSOR. (Ping of a Starter to start server): PID 54
    11:11:11 [SERVERSOCKET] Connection made. starting new processor 55935, /217.120.167.15; local: 4242, /192.111.132.102, keepalive false
    11:11:11 [SERVER] connection registered (TRunning: 1/1/1) 55
    11:11:11 [SERVER][PROCESSOR] client setup completed for PID: 55. listening for input
    11:11:11 [SERVER] This client is an info ping (server-lists): /217.120.167.15; PID: 55
    11:11:11 [SERVER] Executing scheduled disconnect!; ProcessorID: 55
    11:11:11 [SERVER][DISCONNECT] Client 'Info-Pinger (server-lists)' HAS BEEN DISCONNECTED . PROBE: true; ProcessorID: 55
    11:11:11 [SERVER] PROBE SUCCESSFULLY EXECUTED. STOPPING PROCESSOR. (Ping of a Starter to start server): PID 55
    11:11:11 [SERVERPROCESSOR][WARNING} PING timeout warning. resending ping to RegisteredClient: Cheesekiller (2) connected: true Retries left: 12; socket connected: true; socket closed: false; inputShutdown: false; outputShutdown: false; ProcessorID: 53
    11:11:11 [SERVERPROCESSOR][WARNING} PING has been resent to RegisteredClient: Cheesekiller (2) connected: true
    11:11:11 RETRY STATUS: Retries: 11; waiting for pong true (1421612678308/1421612687307); ProcessorID: 53
    11:11:11 RETRY STATUS: Retries: 11; waiting for pong true (1421612679308/1421612687307); ProcessorID: 53
    11:11:11 RETRY STATUS: Retries: 11; waiting for pong true (1421612680308/1421612687307); ProcessorID: 53
    11:11:11 RETRY STATUS: Retries: 11; waiting for pong true (1421612681309/1421612687307); ProcessorID: 53
    11:11:11 RETRY STATUS: Retries: 11; waiting for pong true (1421612682309/1421612687307); ProcessorID: 53
    11:11:11 RETRY STATUS: Retries: 11; waiting for pong true (1421612683309/1421612687307); ProcessorID: 53
    11:11:11 RETRY STATUS: Retries: 11; waiting for pong true (1421612684310/1421612687307); ProcessorID: 53
    11:11:11 RETRY STATUS: Retries: 11; waiting for pong true (1421612685310/1421612687307); ProcessorID: 53
    11:11:11 RETRY STATUS: Retries: 11; waiting for pong true (1421612686310/1421612687307); ProcessorID: 53
    11:11:11 java.lang.IllegalArgumentException: java.net.SocketTimeoutException: Read timed out
    11:11:11 at obfuscated.uK.a(SourceFile:83)
    11:11:11 at org.schema.game.server.controller.GameServerController.authenticate(SourceFile:631)
    11:11:11 at org.schema.schine.network.commands.LoginRequest.login(SourceFile:51)
    11:11:11 at org.schema.schine.network.commands.LoginRequest.run(SourceFile:193)
    11:11:11 at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
    11:11:11 at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
    11:11:11 at java.lang.Thread.run(Thread.java:745)
    11:11:11 Caused by: java.net.SocketTimeoutException: Read timed out
    11:11:11 at java.net.SocketInputStream.socketRead0(Native Method)
    11:11:11 at java.net.SocketInputStream.read(SocketInputStream.java:150)
    11:11:11 at java.net.SocketInputStream.read(SocketInputStream.java:121)
    11:11:11 at sun.security.ssl.InputRecord.readFully(InputRecord.java:465)
    11:11:11 at sun.security.ssl.InputRecord.read(InputRecord.java:503)
    11:11:11 at sun.security.ssl.SSLSocketImpl.readRecord(SSLSocketImpl.java:954)
    11:11:11 at sun.security.ssl.SSLSocketImpl.performInitialHandshake(SSLSocketImpl.java:1343)
    11:11:11 at sun.security.ssl.SSLSocketImpl.startHandshake(SSLSocketImpl.java:1371)
    11:11:11 at sun.security.ssl.SSLSocketImpl.startHandshake(SSLSocketImpl.java:1355)
    11:11:11 at sun.net.www.protocol.https.HttpsClient.afterConnect(HttpsClient.java:563)
    11:11:11 at sun.net.www.protocol.https.AbstractDelegateHttpsURLConnection.connect(AbstractDelegateHttpsURLConnection.java:185)
    11:11:11 at sun.net.www.protocol.http.HttpURLConnection.getOutputStream0(HttpURLConnection.java:1281)
    11:11:11 at sun.net.www.protocol.http.HttpURLConnection.getOutputStream(HttpURLConnection.java:1256)
    11:11:11 at sun.net.www.protocol.https.HttpsURLConnectionImpl.getOutputStream(HttpsURLConnectionImpl.java:250)
    11:11:11 at org.schema.game.common.api.ApiOauthController.a(SourceFile:244)
    11:11:11 at obfuscated.uK.a(SourceFile:34)
    11:11:11 ... 6 more
    11:11:11 [LOGIN] checking user agent: 0: Cheesekiller
    11:11:11 [SERVER][LOGIN] login failed (ERROR_AUTHENTICATION_FAILED): SET CLIENT TO NULL
    11:11:11 [SERVER] Executing scheduled disconnect!; ProcessorID: 53
    11:11:11 [SERVER][DISCONNECT] Client 'null' HAS BEEN DISCONNECTED . PROBE: true; ProcessorID: 53
    11:11:11 [SERVER] COULD NOT UNREGISTER CLIENT null
    11:11:11 [SERVER] PROBE SUCCESSFULLY EXECUTED. STOPPING PROCESSOR. (Ping of a Starter to start server): PID 53
    11:11:11 [SERVERSOCKET] Connection made. starting new processor 55116, /217.224.17.59; local: 4242, /192.111.132.102, keepalive false
    11:11:11 [SERVER] connection registered (TRunning: 0/0/0) 56
    11:11:11 [SERVER][PROCESSOR] client setup completed for PID: 56. listening for input
    11:11:11 [SERVER] This client is an info ping (server-lists): /217.224.17.59; PID: 56
    11:11:11 [SERVER] Executing scheduled disconnect!; ProcessorID: 56
    11:11:11 [SERVER][DISCONNECT] Client 'Info-Pinger (server-lists)' HAS BEEN DISCONNECTED . PROBE: true; ProcessorID: 56
    11:11:11 [SERVER] PROBE SUCCESSFULLY EXECUTED. STOPPING PROCESSOR. (Ping of a Starter to start server): PID 56
    11:11:11 [SERVERSOCKET] Connection made. starting new processor 52473, /23.248.80.180; local: 4242, /192.111.132.102, keepalive false
    11:11:11 [SERVER] connection registered (TRunning: 0/0/0) 57
    11:11:11 [SERVER][PROCESSOR] client setup completed for PID: 57. listening for input
    11:11:11 [SERVER] This client is an info ping (server-lists): /23.248.80.180; PID: 57
    11:11:11 [SERVER] Executing scheduled disconnect!; ProcessorID: 57
    11:11:11 [SERVER][DISCONNECT] Client 'Info-Pinger (server-lists)' HAS BEEN DISCONNECTED . PROBE: true; ProcessorID: 57
    11:11:11 [SERVER] PROBE SUCCESSFULLY EXECUTED. STOPPING PROCESSOR. (Ping of a Starter to start server): PID 57
    11:11:11 [SERVERSOCKET] Connection made. starting new processor 64396, /145.236.3.88; local: 4242, /192.111.132.102, keepalive false
    11:11:11 [SERVER] connection registered (TRunning: 0/0/0) 58
    11:11:11 [SERVER][PROCESSOR] client setup completed for PID: 58. listening for input
    11:11:11 [SERVER] This client is an info ping (server-lists): /145.236.3.88; PID: 58
    11:11:11 [SERVER] Executing scheduled disconnect!; ProcessorID: 58
    11:11:11 [SERVER][DISCONNECT] Client 'Info-Pinger (server-lists)' HAS BEEN DISCONNECTED . PROBE: true; ProcessorID: 58
    11:11:11 [SERVER] PROBE SUCCESSFULLY EXECUTED. STOPPING PROCESSOR. (Ping of a Starter to start server): PID 58
    11:11:11 [SERVERSOCKET] Connection made. starting new processor 56604, /85.179.118.233; local: 4242, /192.111.132.102, keepalive false
    11:11:11 [SERVER] connection registered (TRunning: 0/0/0) 59
    11:11:11 [SERVER][PROCESSOR] client setup completed for PID: 59. listening for input
    11:11:11 [SERVER] This client is an info ping (server-lists): /85.179.118.233; PID: 59
    11:11:11 [SERVER] Executing scheduled disconnect!; ProcessorID: 59
    11:11:11 [SERVER][DISCONNECT] Client 'Info-Pinger (server-lists)' HAS BEEN DISCONNECTED . PROBE: true; ProcessorID: 59
    11:11:11 [SERVER] PROBE SUCCESSFULLY EXECUTED. STOPPING PROCESSOR. (Ping of a Starter to start server): PID 59
     
    AndyP

    AndyP

    Customer Experience Manager
    Joined
    Aug 15, 2013
    Messages
    1,199
    Reaction score
    264
    • Schine
    • Wired for Logic
    This looks like a wrong or invalid saved login, resulting in a failed uplink on auth via server.

    Or the server has no SSL installed and thus cannot call the SSL routines to make a secured connection.

    - Andy
     
    You must log in or register to reply here.
    Top Bottom