Page MenuHomeSchine - Phabricator

Starmade | NullPointer on server
Closed, FinishedPublic

Description

NullPointer spams to all users. Unsure of what caused this...

[2016-06-05 18:16:19] Sector[34025](-90, 7, -265) Narrowphase of Sector[34025](-90, 7, -265) took: 37
[2016-06-05 18:16:19] [UNIVERSE] WARNING: Sector UPDATE took 510; sectors updated: 297
[2016-06-05 18:16:19] [SERVER][UPDATE] WARNING: UNIVERSE update took 512
[2016-06-05 18:16:19] [SERVER][RAIL] collision time limit reached. Returning to last possible
[2016-06-05 18:16:19] java.lang.NullPointerException
[2016-06-05 18:16:19]   at org.schema.game.common.controller.elements.ElementCollectionManager.updateCollections(SourceFile:350)
[2016-06-05 18:16:19]   at org.schema.game.common.controller.elements.ElementCollectionManager.updateStructure(SourceFile:405)
[2016-06-05 18:16:19]   at org.schema.game.common.controller.elements.ControlBlockElementCollectionManager.updateStructure(SourceFile:180)
[2016-06-05 18:16:19]   at org.schema.game.common.controller.elements.ManagerModuleCollection.update(SourceFile:152)
[2016-06-05 18:16:19]   at org.schema.game.common.controller.elements.ManagerContainer.updateLocal(SourceFile:1746)
[2016-06-05 18:16:19]   at org.schema.game.common.controller.elements.ShipManagerContainer.updateLocal(SourceFile:715)
[2016-06-05 18:16:19]   at obfuscated.Sz.updateLocal(SourceFile:540)
[2016-06-05 18:16:19]   at org.schema.game.server.controller.GameServerController.update(SourceFile:1356)
[2016-06-05 18:16:19]   at org.schema.schine.network.server.ServerController.run(SourceFile:270)
[2016-06-05 18:16:19]   at java.lang.Thread.run(Thread.java:745)
[2016-06-05 18:16:19] java.lang.NullPointerException
[2016-06-05 18:16:19]   at org.schema.game.common.controller.elements.ElementCollectionManager.updateCollections(SourceFile:350)
[2016-06-05 18:16:19]   at org.schema.game.common.controller.elements.ElementCollectionManager.updateStructure(SourceFile:405)
[2016-06-05 18:16:19]   at org.schema.game.common.controller.elements.ControlBlockElementCollectionManager.updateStructure(SourceFile:180)
[2016-06-05 18:16:19]   at org.schema.game.common.controller.elements.ManagerModuleCollection.update(SourceFile:152)
[2016-06-05 18:16:19]   at org.schema.game.common.controller.elements.ManagerContainer.updateLocal(SourceFile:1746)
[2016-06-05 18:16:19]   at org.schema.game.common.controller.elements.ShipManagerContainer.updateLocal(SourceFile:715)
[2016-06-05 18:16:19]   at obfuscated.Sz.updateLocal(SourceFile:540)
[2016-06-05 18:16:19]   at org.schema.game.server.controller.GameServerController.update(SourceFile:1356)
[2016-06-05 18:16:19]   at org.schema.schine.network.server.ServerController.run(SourceFile:270)
[2016-06-05 18:16:19]   at java.lang.Thread.run(Thread.java:745)
[2016-06-05 18:16:19] [SERVER] Exception catched
[2016-06-05 18:16:19] [SERVER][RAIL] collision time limit reached. Returning to last possible
[2016-06-05 18:16:19] [SERVER][RAIL] collision time limit reached. Returning to last possible
[2016-06-05 18:16:19] [SERVER][UPDATE] WARNING: object local update of 717 objects took 81
[2016-06-05 18:16:19] [SEND][SERVERMESSAGE] [SERVERMSG (type 3): [373, NullPointerException]] to RegisteredClient: LordFrostsword (67) [Lord Frostsword]connected: true
[2016-06-05 18:16:19] [SEND][SERVERMESSAGE] [SERVERMSG (type 3): [373, NullPointerException]] to RegisteredClient: SilverOne (80) [LawrenceOfNaboo]connected: true
[2016-06-05 18:16:19] [SEND][SERVERMESSAGE] [SERVERMSG (type 3): [373, NullPointerException]] to RegisteredClient: Runamuck (33) [Runamuck]connected: true
[2016-06-05 18:16:19] [SEND][SERVERMESSAGE] [SERVERMSG (type 3): [373, NullPointerException]] to RegisteredClient: Sachys (82) [Sachys]connected: true
[2016-06-05 18:16:19] [SEND][SERVERMESSAGE] [SERVERMSG (type 3): [373, NullPointerException]] to RegisteredClient: TechPriest (47) [Tech-priest]connected: true
[2016-06-05 18:16:19] [SEND][SERVERMESSAGE] [SERVERMSG (type 3): [373, NullPointerException]] to RegisteredClient: Captainairspeed (77) [captainairspeed]connected: true
[2016-06-05 18:16:19] [SEND][SERVERMESSAGE] [SERVERMSG (type 3): [373, NullPointerException]] to RegisteredClient: archrosscool (81) [archrosscool]connected: true
[2016-06-05 18:16:19] [SEND][SERVERMESSAGE] [SERVERMSG (type 3): [373, NullPointerException]] to RegisteredClient: Nocturna (83) [Nocturna]connected: true
[2016-06-05 18:16:19] [SEND][SERVERMESSAGE] [SERVERMSG (type 3): [373, NullPointerException]] to RegisteredClient: archlouiscool (74) [Archlouiscool]connected: true
[2016-06-05 18:16:19] [SEND][SERVERMESSAGE] [SERVERMSG (type 3): [373, NullPointerException]] to RegisteredClient: spocklin (84) [spocklin]connected: true
[2016-06-05 18:16:19] [SEND][SERVERMESSAGE] [SERVERMSG (type 3): [373, NullPointerException]] to RegisteredClient: Vintron (66) [Vintron]connected: true
[2016-06-05 18:16:19] [SEND][SERVERMESSAGE] [SERVERMSG (type 3): [373, NullPointerException]] to RegisteredClient: Zima1998 (32) [zima1998]connected: true
[2016-06-05 18:16:19] [SEND][SERVERMESSAGE] [SERVERMSG (type 3): [373, NullPointerException]] to RegisteredClient: ErthParadine (31) [Erth Paradine]connected: true
[2016-06-05 18:16:19] [SEND][SERVERMESSAGE] [SERVERMSG (type 3): [373, NullPointerException]] to RegisteredClient: imnapr (76) [imnapr]connected: true

Details

Task Type
Bug
Testing Results
Affected Gamemode(s)
none/unspecified
Reproducible
uncertain
Category
none/unspecified
Hardware/Software/System
OS-Specific
No
Hardware-Specific
No
Video Card Vendor
uncertain
Serverconfig (server.cfg)
<replace this line with the file content>
Clientconfig (settings.cfg)
<replace this line with the file content>

Event Timeline

Restricted Application added a project: Issue Navigation. · View Herald TranscriptJun 5 2016, 6:24 PM
lancake added a subscriber: lancake.Jun 5 2016, 8:08 PM
lancake claimed this task.

-validated-

lancake shifted this object from the S1 Public space to the S3 Starmade space.Jun 5 2016, 8:11 PM
lancake changed the visibility from "Custom Policy" to "Public (No Login Required)".
lancake changed the edit policy from "Task Author" to "Starmade (Project)".
lancake triaged this task as High priority.
Restricted Application added a subscriber: AndyP. · View Herald TranscriptJun 5 2016, 8:11 PM
lancake changed the task status from Open to In Queue (Game).

Don't know how to reproduce, logs might be enough to fix it.
If not, put it on open again.

Restricted Application edited projects, added Starmade, Game Development; removed Issue Navigation. · View Herald TranscriptJun 9 2016, 11:11 AM

Another Case:

[2016-06-10 02:16:22] [SERVER] sending message to SpaceKing: Param: [334]
[2016-06-10 02:16:23] [SERVER] sending message to SpaceKing: Param: [334]
[2016-06-10 02:16:23] [SERVER] sending message to SpaceKing: Param: [334]
[2016-06-10 02:16:23] [SERVER][RAIL] collision time limit reached. Returning to last possible
[2016-06-10 02:16:23] [SERVER] sending message to SpaceKing: Param: [334]
[2016-06-10 02:16:23] [SERVER] sending message to SpaceKing: Param: [334]
[2016-06-10 02:16:23] [ADMIN COMMAND] LOAD_AS_FACTION from RegisteredClient: SpaceKing (5) [TheKingOfSpace]connected: true params: [cdrone_new_2, cdrone_new_2_1465517322838, 10012]
[2016-06-10 02:16:23] [SERVER] FINDING POS TO SPAWN try(0) COLLISION WITH: [ (-855.17053, -256.0724, 270.60062) | (-743.17053, -144.07237, 382.60062) ]: (-823.68567, -179.81712, 351.96976): collisionAABB: self (-838.6736, -200.02019, 326.96976) - (-810.04443, -160.0642, 368.09988);
[2016-06-10 02:16:23] Exiting (normal) because of exception java.lang.NullPointerException
[2016-06-10 02:16:23] java.lang.NullPointerException
[2016-06-10 02:16:23] 	at obfuscated.apN.a(SourceFile:1060)
[2016-06-10 02:16:23] 	at obfuscated.amE.a(SourceFile:347)
[2016-06-10 02:16:23] 	at obfuscated.apI.a(SourceFile:110)
[2016-06-10 02:16:23] 	at obfuscated.apJ.<init>(SourceFile:32)
[2016-06-10 02:16:23] 	at obfuscated.apT.a(SourceFile:22)
[2016-06-10 02:16:23] 	at obfuscated.amE.a(SourceFile:583)
[2016-06-10 02:16:23] 	at obfuscated.amE.a(SourceFile:276)
[2016-06-10 02:16:23] 	at obfuscated.amE.a(SourceFile:283)
[2016-06-10 02:16:23] 	at obfuscated.apr.a(SourceFile:4645)
[2016-06-10 02:16:23] 	at obfuscated.apr.a(SourceFile:2005)
[2016-06-10 02:16:23] 	at org.schema.game.server.controller.GameServerController.update(SourceFile:1023)
[2016-06-10 02:16:23] 	at org.schema.schine.network.server.ServerController.run(SourceFile:270)
[2016-06-10 02:16:23] 	at java.lang.Thread.run(Thread.java:744)
[2016-06-10 02:16:23] [SERVER][SHUTDOWN] shutting down element collection thread
[2016-06-10 02:16:23] [SERVER][SHUTDOWN] shutting down pathfinding threads
[2016-06-10 02:16:23] [SERVER][SHUTDOWN] shutting down universe
[2016-06-10 02:16:23] [SERVER][SHUTDOWN] shutting segment request thread
[2016-06-10 02:16:23] [SERVER][SHUTDOWN] shutting down simulation
[2016-06-10 02:16:23] [SERVER][SHUTDOWN] shutting down active checker
[2016-06-10 02:16:23] [SIMPLANNER] Sleep has been interrupted

Does not look like the same cause, but adding to same report unless its a stated to be different. =)

schema added a subscriber: schema.Jun 11 2016, 9:25 PM

they are different. i need the blueprint this is happening on

Any way to determine what the entity is @schema ?

thats the spawn command: [ADMIN COMMAND] LOAD_AS_FACTION from RegisteredClient: SpaceKing (5) [TheKingOfSpace]connected: true params: [cdrone_new_2, cdrone_new_2_1465517322838, 10012]

the bb's name should be: cdrone_new_2

Ah, you're referring to Andy's update, thanks for clarifying. SpaceKing does not have admin on our server (original report).

the NullPointer of the first logs should be fixed now

@SpaceKing
Can you get a blueprint of the ship?
or try the corrected command to load it.

In T1531#62232, @AndyP wrote:

@SpaceKing
Can you get a blueprint of the ship?
or try the corrected command to load it.

They seem to load fine now.

AndyP moved this task from Unclassed to Archived on the Starmade board.Jun 21 2016, 5:00 PM
AndyP closed this task as Closed.

Okay, closing the issue then.

Restricted Application removed a project: Game Development. · View Herald TranscriptJun 21 2016, 5:01 PM
Restricted Application removed a subscriber: AndyP. · View Herald Transcript