PlayTime

PlayTime

38.5k Downloads

Null on interval Check (database error)

GusGold opened this issue ยท 10 comments

commented

Every 60 seconds, I receive a 'SEVERE null' in console. Also, no player times are updated, they are all 0 minutes (and hours).

I am running: CraftBukkit version git-Bukkit-1.6.2-R1.0-2-g317b76b-b2882jnks (MC: 1.6.4) (Implementing API version 1.6.4-R0.1-SNAPSHOT)

And Playtime Version 1.4.1

The contents of user.db is setup up normally, just with playtime, deathtime, onlinetime all set to 0, and If this helps, the id column has a abnormal pattern. For the 7 players currently added, the ids look like: 1,2,3,4,6,10,14

Cheers, Gus.

Also included and error log (with level 3 debug) after deleting users.db and sending /pt reload command:

06.10 09:29:25 [Server] SEVERE at java.lang.Thread.run(Unknown Source)
06.10 09:29:25 [Server] SEVERE at java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
06.10 09:29:25 [Server] SEVERE at java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source)
06.10 09:29:25 [Server] SEVERE at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(Unknown Source)
06.10 09:29:25 [Server] SEVERE at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(Unknown Source)
06.10 09:29:25 [Server] SEVERE at java.util.concurrent.FutureTask.runAndReset(Unknown Source)
06.10 09:29:25 [Server] SEVERE at java.util.concurrent.FutureTask$Sync.innerRunAndReset(Unknown Source)
06.10 09:29:25 [Server] SEVERE at java.util.concurrent.Executors$RunnableAdapter.call(Unknown Source)
06.10 09:29:25 [Server] SEVERE at com.rogue.playtime.runnable.AddRunnable.run(AddRunnable.java:135)
06.10 09:29:25 [Server] SEVERE at com.rogue.playtime.data.sqlite.SQLite.update(SQLite.java:117)
06.10 09:29:25 [Server] SEVERE at org.sqlite.Stmt.executeUpdate(Stmt.java:152)
06.10 09:29:25 [Server] SEVERE at org.sqlite.NativeDB._exec(Native Method)
06.10 09:29:25 [Server] SEVERE at org.sqlite.NativeDB.throwex(NativeDB.java:210)
06.10 09:29:25 [Server] SEVERE java.sql.SQLException: unrecognized token: "`playTime WHERE username IN ('aasebs', 'GusGold')"
06.10 09:29:25 [Server] SEVERE null
06.10 09:29:25 [Server] INFO Open SQLite connections: 1
06.10 09:29:25 [Server] INFO SQL Query for update:\nINSERT OR IGNORE INTO `playTime WHERE username IN ('aasebs', 'GusGold')
06.10 09:29:25 [Server] INFO SQL Query for update:\nINSERT OR IGNORE INTO `playTime` SELECT NULL AS 'column1', 'aasebs' AS 'column2', 0 AS 'column3', 0 AS 'column4', 0 AS 'column5' UNION SELECT NULL, 'GusGold', 0, 0, 0
commented

Yup, this is a fixed bug in 1.4.2. You can find the link below:

http://ci.1ro.co/job/Playtime/

commented

Thank you very much :)

commented

Umm, now, all commands return the Handler -> Busy response, and /pt reload gives

07.10 00:50:55 [Server] INFO ... 15 more
07.10 00:50:55 [Server] INFO at org.bukkit.command.PluginCommand.execute(PluginCommand.java:44)
07.10 00:50:55 [Server] INFO at com.rogue.playtime.command.CommandHandler.onCommand(CommandHandler.java:78)
07.10 00:50:55 [Server] INFO at com.rogue.playtime.command.commands.PTCommand.execute(PTCommand.java:50)
07.10 00:50:55 [Server] INFO at com.rogue.playtime.Playtime.reload(Playtime.java:192)
07.10 00:50:55 [Server] INFO at com.rogue.playtime.lang.Cipher.getString(Cipher.java:133)
07.10 00:50:55 [Server] INFO Caused by: java.lang.NullPointerException: The language files are missing the path. Language: en_US Path: main.this.reloaded
07.10 00:50:55 [Server] INFO at net.minecraft.server.v1_6_R3.ThreadServerApplication.run(SourceFile:583)
07.10 00:50:55 [Server] INFO at net.minecraft.server.v1_6_R3.MinecraftServer.run(MinecraftServer.java:421)
07.10 00:50:55 [Server] INFO at net.minecraft.server.v1_6_R3.MinecraftServer.s(MinecraftServer.java:488)
07.10 00:50:55 [Server] INFO at net.minecraft.server.v1_6_R3.DedicatedServer.t(DedicatedServer.java:227)
07.10 00:50:55 [Server] INFO at net.minecraft.server.v1_6_R3.MinecraftServer.t(MinecraftServer.java:592)
07.10 00:50:55 [Server] INFO at net.minecraft.server.v1_6_R3.DedicatedServerConnection.b(SourceFile:30)
07.10 00:50:55 [Server] INFO at net.minecraft.server.v1_6_R3.ServerConnection.b(SourceFile:37)
07.10 00:50:55 [Server] INFO at net.minecraft.server.v1_6_R3.PlayerConnection.e(PlayerConnection.java:116)
07.10 00:50:55 [Server] INFO at net.minecraft.server.v1_6_R3.NetworkManager.b(NetworkManager.java:296)
07.10 00:50:55 [Server] INFO at net.minecraft.server.v1_6_R3.Packet3Chat.handle(SourceFile:49)
07.10 00:50:55 [Server] INFO at net.minecraft.server.v1_6_R3.PlayerConnection.a(PlayerConnection.java:834)
07.10 00:50:55 [Server] INFO at net.minecraft.server.v1_6_R3.PlayerConnection.chat(PlayerConnection.java:877)
07.10 00:50:55 [Server] INFO at net.minecraft.server.v1_6_R3.PlayerConnection.handleCommand(PlayerConnection.java:959)
07.10 00:50:55 [Server] INFO at org.bukkit.craftbukkit.v1_6_R3.CraftServer.dispatchCommand(CraftServer.java:523)
07.10 00:50:55 [Server] INFO at org.bukkit.command.SimpleCommandMap.dispatch(SimpleCommandMap.java:192)
07.10 00:50:55 [Server] INFO at org.bukkit.command.PluginCommand.execute(PluginCommand.java:46)
07.10 00:50:55 [Server] INFO org.bukkit.command.CommandException: Unhandled exception executing command 'pt' in plugin Playtime v1.4.2
07.10 00:50:55 [Server] SEVERE null

I tried disabling GitHub lang files, but it just returns the same error

commented

I've made a patch to the plugin for that, try downloading it below:

http://ci.1ro.co/jobs/Playtime

commented

Getting a 404 on that page xD

commented

Still getting it unfortunately.

On restart/reload:

07.10 05:28:38 [Server] INFO at net.minecraft.server.v1_6_R3.ThreadServerApplication.run(SourceFile:583)
07.10 05:28:38 [Server] INFO at net.minecraft.server.v1_6_R3.MinecraftServer.run(MinecraftServer.java:393)
07.10 05:28:38 [Server] INFO at net.minecraft.server.v1_6_R3.DedicatedServer.init(DedicatedServer.java:152)
07.10 05:28:38 [Server] INFO at net.minecraft.server.v1_6_R3.MinecraftServer.a(MinecraftServer.java:252)
07.10 05:28:38 [Server] INFO at net.minecraft.server.v1_6_R3.MinecraftServer.f(MinecraftServer.java:292)
07.10 05:28:38 [Server] INFO at net.minecraft.server.v1_6_R3.MinecraftServer.l(MinecraftServer.java:315)
07.10 05:28:38 [Server] INFO at org.bukkit.craftbukkit.v1_6_R3.CraftServer.enablePlugins(CraftServer.java:264)
07.10 05:28:38 [Server] INFO at org.bukkit.craftbukkit.v1_6_R3.CraftServer.loadPlugin(CraftServer.java:282)
07.10 05:28:38 [Server] INFO at org.bukkit.plugin.SimplePluginManager.enablePlugin(SimplePluginManager.java:381)
07.10 05:28:38 [Server] INFO at org.bukkit.plugin.java.JavaPluginLoader.enablePlugin(JavaPluginLoader.java:457)
07.10 05:28:38 [Server] INFO at org.bukkit.plugin.java.JavaPlugin.setEnabled(JavaPlugin.java:217)
07.10 05:28:38 [Server] INFO at com.rogue.playtime.Playtime.onEnable(Playtime.java:154)
07.10 05:28:38 [Server] INFO at com.rogue.playtime.lang.Cipher.getString(Cipher.java:133)
07.10 05:28:38 [Server] INFO java.lang.NullPointerException: The language files are missing the path. Language: en_US Path: main.this.listener
07.10 05:28:38 [Server] SEVERE Error occurred while enabling Playtime v1.4.2 (Is it up to date?)
07.10 05:28:38 [Server] INFO Disabling event system!
07.10 05:28:38 [Server] INFO Enabling Player Handler...
07.10 05:28:38 [Server] INFO Enabling Command Handler...
07.10 05:28:38 [Server] INFO Successfully connected to database!
07.10 05:28:38 [Server] INFO Connecting to SQLite database...
07.10 05:28:38 [Server] SEVERE Flatfile storage is currently broken! Using SQLite...
07.10 05:28:38 [Server] INFO Enabling Data Manager...
07.10 05:28:38 [Server] INFO Enabling executable manager...
07.10 05:28:38 [Server] INFO Enabling Metrics...
07.10 05:28:38 [Server] INFO Enabling Playtime v1.4.2

On any commands:
[Playtime] Playtime is currently busy with an operation, try again in a minute!

On /pt reload:

07.10 05:31:27 [Server] INFO at net.minecraft.server.v1_6_R3.ThreadServerApplication.run(SourceFile:583)
07.10 05:31:27 [Server] INFO at net.minecraft.server.v1_6_R3.MinecraftServer.run(MinecraftServer.java:421)
07.10 05:31:27 [Server] INFO at net.minecraft.server.v1_6_R3.MinecraftServer.s(MinecraftServer.java:488)
07.10 05:31:27 [Server] INFO at net.minecraft.server.v1_6_R3.DedicatedServer.t(DedicatedServer.java:227)
07.10 05:31:27 [Server] INFO at net.minecraft.server.v1_6_R3.MinecraftServer.t(MinecraftServer.java:524)
07.10 05:31:27 [Server] INFO at org.bukkit.craftbukkit.v1_6_R3.scheduler.CraftScheduler.mainThreadHeartbeat(CraftScheduler.java:345)
07.10 05:31:27 [Server] INFO at org.bukkit.craftbukkit.v1_6_R3.scheduler.CraftTask.run(CraftTask.java:53)
07.10 05:31:27 [Server] INFO at com.rogue.playtime.Playtime$1.run(Playtime.java:211)
07.10 05:31:27 [Server] INFO at com.rogue.playtime.Playtime.onEnable(Playtime.java:154)
07.10 05:31:27 [Server] INFO at com.rogue.playtime.lang.Cipher.getString(Cipher.java:133)
07.10 05:31:27 [Server] INFO java.lang.NullPointerException: The language files are missing the path. Language: en_US Path: main.this.listener
07.10 05:31:27 [Server] WARNING Task #24 for Playtime v1.4.2 generated an exception
07.10 05:31:27 [Server] INFO Disabling event system!
07.10 05:31:27 [Server] INFO Enabling Player Handler...
07.10 05:31:27 [Server] INFO Enabling Command Handler...
07.10 05:31:27 [Server] INFO Successfully connected to database!
07.10 05:31:27 [Server] INFO Connecting to SQLite database...
07.10 05:31:27 [Server] SEVERE Flatfile storage is currently broken! Using SQLite...
07.10 05:31:27 [Server] INFO Enabling Data Manager...
07.10 05:31:27 [Server] INFO Enabling executable manager...
07.10 05:31:27 [Server] INFO Enabling Metrics...
07.10 05:31:27 [Server] INFO Loading language manager...
07.10 05:31:27 [Server] INFO Loading Configuration mananger...
commented

Agh, missed a line. Re-submitting a new version, should fix that line

commented
commented

That seems to have sorted it all out,

Cheers