This website uses cookies. By clicking Accept, you consent to the use of cookies. Click Here to learn more about how we use cookies.
Accept
Reject
cancel
Turn on suggestions
Auto-suggest helps you quickly narrow down your search results by suggesting possible matches as you type.
Showing results for 
Search instead for 
Did you mean: 
Help

Head's Up! These forums are read-only. All users and content have migrated. Please join us at community.neo4j.com.

Apoc.periodic.iterate sending CPU to 100%?

christian
Node Clone

‎01-07-2020 08:38 PM

I have a problem where my Neo4j instance CPU keeps going to 100% to the point where the instance has to be restarted to become responsive again. I initially though this is due to some apoc.cypher.mapParallel2 queries I was running but upon inspection of the logs it looks more like a delayed reaction to some apoc.periodic.iterate queries. Does not seem to be an immediate reaction but rather delayed, sometimes by hours. Maybe something running in the background that is then sent over the edge by the apoc.cypher.mapParallel2? Is that possible? Not sure how to upload the entire log here but here is an extract, corresponds to the 100% CPU spike below (before and after, for spike time search for 2020-01-08 02:53 in the log).

2X_3_3c1e1796f17e874597887ab971d6ca5b34851080.png

2020-01-07 09:50:47.862+0000 INFO [o.n.k.i.p.Procedures] starting batching from `
MATCH (n1:OrganizationWord) 
RETURN n1` operation using iteration ` 
SET n1 :OrganizationMatch 
RETURN *` in separate thread
2020-01-07 09:50:49.245+0000 WARN [o.n.k.i.c.VmPauseMonitorComponent] Detected VM stop-the-world pause: {pauseTime=220, gcTime=232, gcCount=1}
2020-01-07 09:51:14.073+0000 INFO [o.n.k.i.p.Procedures] starting batching from `
MATCH (n1:Version) 
RETURN n1` operation using iteration ` 
SET n1 :OrganizationMatch 
RETURN *` in separate thread
2020-01-07 09:51:36.449+0000 INFO [o.n.k.i.p.Procedures] starting batching from `
MATCH (n1:RepositoryAlias) 
RETURN n1` operation using iteration ` 
SET n1 :OrganizationMatch 
RETURN *` in separate thread
2020-01-07 09:51:42.368+0000 INFO [o.n.k.i.p.Procedures] starting batching from `
MATCH (n1:Repository) 
RETURN n1` operation using iteration ` 
SET n1 :OrganizationMatch 
RETURN *` in separate thread
2020-01-07 09:51:47.321+0000 INFO [o.n.k.i.p.Procedures] starting batching from `
MATCH (n1:Project) 
RETURN n1` operation using iteration ` 
SET n1 :OrganizationMatch 
RETURN *` in separate thread
2020-01-07 09:51:51.971+0000 INFO [o.n.k.i.p.Procedures] starting batching from `
MATCH (n1:Folder) 
RETURN n1` operation using iteration ` 
SET n1 :OrganizationMatch 
RETURN *` in separate thread
2020-01-07 09:52:03.840+0000 INFO [o.n.k.i.p.Procedures] starting batching from `
MATCH (n1:FixVersion) 
RETURN n1` operation using iteration ` 
SET n1 :OrganizationMatch 
RETURN *` in separate thread
2020-01-07 09:52:07.846+0000 INFO [o.n.k.i.p.Procedures] starting batching from `
MATCH (n1:Domain) 
RETURN n1` operation using iteration ` 
SET n1 :OrganizationMatch 
RETURN *` in separate thread
2020-01-07 09:52:17.932+0000 INFO [o.n.k.i.p.Procedures] starting batching from `
MATCH (n1:Component) 
RETURN n1` operation using iteration ` 
SET n1 :OrganizationMatch 
RETURN *` in separate thread
2020-01-07 09:52:21.319+0000 INFO [o.n.k.i.p.Procedures] starting batching from `
MATCH (n1:Company:Copper) 
RETURN n1` operation using iteration ` 
SET n1 :OrganizationMatch 
RETURN *` in separate thread
2020-01-07 09:52:24.711+0000 INFO [o.n.k.i.p.Procedures] starting batching from `
MATCH (n1:ChannelAlias) 
RETURN n1` operation using iteration ` 
SET n1 :OrganizationMatch 
RETURN *` in separate thread
2020-01-07 09:52:28.506+0000 INFO [o.n.k.i.p.Procedures] starting batching from `
MATCH (n1:Channel) 
RETURN n1` operation using iteration ` 
SET n1 :OrganizationMatch 
RETURN *` in separate thread
2020-01-07 09:52:33.729+0000 INFO [o.n.k.i.p.Procedures] starting batching from `
MATCH (n1:Organization) 
RETURN n1` operation using iteration ` 
SET n1 :OrganizationMatch 
RETURN *` in separate thread
2020-01-07 09:54:56.405+0000 INFO [o.n.k.i.t.l.c.CheckPointerImpl] Checkpoint triggered by "Scheduled checkpoint for time threshold" @ txId: 28207077 checkpoint started...
2020-01-07 09:55:09.140+0000 INFO [o.n.k.i.s.c.CountsTracker] Rotated counts store at transaction 28207077 to [/data/databases/graph.db/neostore.counts.db.a], from [/data/databases/graph.db/neostore.counts.db.b].
2020-01-07 09:55:15.590+0000 INFO [o.n.k.i.t.l.c.CheckPointerImpl] Checkpoint triggered by "Scheduled checkpoint for time threshold" @ txId: 28207077 checkpoint completed in 19s 184ms
2020-01-07 09:55:15.590+0000 INFO [o.n.k.i.t.l.p.LogPruningImpl] No log version pruned, last checkpoint was made in version 213
2020-01-07 09:56:26.585+0000 WARN [o.n.b.t.p.HouseKeeper] Fatal error occurred when handling a client connection, remote peer unexpectedly closed connection: [id: 0x3103a335, L:/172.17.0.2:7687 - R:/157.47.148.204:44108]
2020-01-07 09:59:44.025+0000 WARN [o.n.b.t.p.HouseKeeper] Fatal error occurred when handling a client connection, remote peer unexpectedly closed connection: [id: 0xe83624ea, L:/172.17.0.2:7687 - R:/107.178.200.194:51967]
2020-01-07 10:08:00.866+0000 WARN [o.n.k.i.c.VmPauseMonitorComponent] Detected VM stop-the-world pause: {pauseTime=158, gcTime=233, gcCount=1}
2020-01-07 10:12:02.129+0000 ERROR [o.n.b.t.p.HouseKeeper] Fatal error occurred when handling a client connection: [id: 0x8b364bdf, L:/172.17.0.2:7687 - R:/157.47.148.204:35197] readAddress(..) failed: Connection timed out
io.netty.channel.unix.Errors$NativeIoException: readAddress(..) failed: Connection timed out
2020-01-07 10:27:23.084+0000 WARN [o.n.k.i.c.VmPauseMonitorComponent] Detected VM stop-the-world pause: {pauseTime=144, gcTime=198, gcCount=1}
2020-01-07 10:29:20.665+0000 WARN [o.n.b.r.MetricsReportingBoltConnection] The client is unauthorized due to authentication failure.
2020-01-07 10:31:31.621+0000 WARN [o.n.k.i.c.VmPauseMonitorComponent] Detected VM stop-the-world pause: {pauseTime=106, gcTime=118, gcCount=1}
2020-01-07 10:32:32.913+0000 WARN [o.n.k.i.c.VmPauseMonitorComponent] Detected VM stop-the-world pause: {pauseTime=148, gcTime=162, gcCount=1}
2020-01-07 10:55:54.496+0000 INFO [o.n.c.i.ExecutionEngine] Discarded stale query from the query cache after 17 seconds: EXPLAIN MATCH (n1:Employee)-[r1:LINKED_TO]->(n2:Organization) 
MERGE (n2)-[r2:PARENT_OF]->(n1) 
SET r2.TimeCreated = r1.TimeCreated 
SET r2.TimeUpdated = datetime() 
SET r2.IdUnique = apoc.create.uuid() 
DELETE r1 
RETURN DISTINCT n1.Name, type(r2), n2.Name
2020-01-07 10:55:55.678+0000 INFO [o.n.k.i.t.l.c.CheckPointerImpl] Checkpoint triggered by "Scheduled checkpoint for time threshold" @ txId: 28207078 checkpoint started...
2020-01-07 10:55:58.269+0000 INFO [o.n.k.i.s.c.CountsTracker] Rotated counts store at transaction 28207078 to [/data/databases/graph.db/neostore.counts.db.b], from [/data/databases/graph.db/neostore.counts.db.a].
2020-01-07 10:55:59.088+0000 INFO [o.n.k.i.t.l.c.CheckPointerImpl] Checkpoint triggered by "Scheduled checkpoint for time threshold" @ txId: 28207078 checkpoint completed in 3s 410ms
2020-01-07 10:55:59.088+0000 INFO [o.n.k.i.t.l.p.LogPruningImpl] No log version pruned, last checkpoint was made in version 213
2020-01-07 10:57:05.029+0000 INFO [o.n.c.i.ExecutionEngine] Discarded stale query from the query cache after 711 seconds: EXPLAIN MATCH (:Employee{IdObject:'cbartens'})-[:PARENT_OF]-(or:Organization) 
RETURN DISTINCT or as result
2020-01-07 10:57:06.766+0000 INFO [o.n.c.i.ExecutionEngine] Discarded stale query from the query cache after 726 seconds: EXPLAIN MATCH (:Employee{IdObject:'cbartens'})<-[:PARENT_OF]-(or:Organization) 
RETURN DISTINCT or as result
2020-01-07 11:19:09.123+0000 INFO [o.n.k.i.t.l.c.CheckPointerImpl] Checkpoint triggered by "Scheduled checkpoint for time threshold" @ txId: 28207079 checkpoint started...
2020-01-07 11:19:13.153+0000 INFO [o.n.k.i.s.c.CountsTracker] Rotated counts store at transaction 28207079 to [/data/databases/graph.db/neostore.counts.db.a], from [/data/databases/graph.db/neostore.counts.db.b].
2020-01-07 11:19:15.148+0000 INFO [o.n.k.i.t.l.c.CheckPointerImpl] Checkpoint triggered by "Scheduled checkpoint for time threshold" @ txId: 28207079 checkpoint completed in 6s 25ms
2020-01-07 11:19:15.148+0000 INFO [o.n.k.i.t.l.p.LogPruningImpl] No log version pruned, last checkpoint was made in version 213
2020-01-07 11:28:03.329+0000 WARN [o.n.k.i.c.VmPauseMonitorComponent] Detected VM stop-the-world pause: {pauseTime=336, gcTime=0, gcCount=0}
2020-01-07 11:34:15.170+0000 INFO [o.n.k.i.t.l.c.CheckPointerImpl] Checkpoint triggered by "Scheduled checkpoint for time threshold" @ txId: 28207080 checkpoint started...
2020-01-07 11:34:19.226+0000 INFO [o.n.k.i.s.c.CountsTracker] Rotated counts store at transaction 28207080 to [/data/databases/graph.db/neostore.counts.db.b], from [/data/databases/graph.db/neostore.counts.db.a].
2020-01-07 11:34:19.907+0000 INFO [o.n.k.i.t.l.c.CheckPointerImpl] Checkpoint triggered by "Scheduled checkpoint for time threshold" @ txId: 28207080 checkpoint completed in 4s 737ms
2020-01-07 11:34:19.907+0000 INFO [o.n.k.i.t.l.p.LogPruningImpl] No log version pruned, last checkpoint was made in version 213
2020-01-07 11:52:19.934+0000 INFO [o.n.k.i.t.l.c.CheckPointerImpl] Checkpoint triggered by "Scheduled checkpoint for time threshold" @ txId: 28207081 checkpoint started...
2020-01-07 11:52:22.250+0000 INFO [o.n.k.i.s.c.CountsTracker] Rotated counts store at transaction 28207081 to [/data/databases/graph.db/neostore.counts.db.a], from [/data/databases/graph.db/neostore.counts.db.b].
2020-01-07 11:52:22.393+0000 INFO [o.n.k.i.t.l.c.CheckPointerImpl] Checkpoint triggered by "Scheduled checkpoint for time threshold" @ txId: 28207081 checkpoint completed in 2s 459ms
2020-01-07 11:52:22.393+0000 INFO [o.n.k.i.t.l.p.LogPruningImpl] No log version pruned, last checkpoint was made in version 213
2020-01-07 12:15:32.426+0000 INFO [o.n.k.i.t.l.c.CheckPointerImpl] Checkpoint triggered by "Scheduled checkpoint for time threshold" @ txId: 28207082 checkpoint started...
2020-01-07 12:15:35.214+0000 INFO [o.n.k.i.s.c.CountsTracker] Rotated counts store at transaction 28207082 to [/data/databases/graph.db/neostore.counts.db.b], from [/data/databases/graph.db/neostore.counts.db.a].
2020-01-07 12:15:36.255+0000 INFO [o.n.k.i.t.l.c.CheckPointerImpl] Checkpoint triggered by "Scheduled checkpoint for time threshold" @ txId: 28207082 checkpoint completed in 3s 829ms
2020-01-07 12:15:36.255+0000 INFO [o.n.k.i.t.l.p.LogPruningImpl] No log version pruned, last checkpoint was made in version 213
2020-01-07 12:56:55.846+0000 WARN [o.n.k.i.c.VmPauseMonitorComponent] Detected VM stop-the-world pause: {pauseTime=734, gcTime=768, gcCount=1}
2020-01-07 13:42:08.408+0000 WARN [o.n.b.r.MetricsReportingBoltConnection] The client is unauthorized due to authentication failure.
2020-01-07 14:02:33.429+0000 WARN [o.n.k.i.c.VmPauseMonitorComponent] Detected VM stop-the-world pause: {pauseTime=163, gcTime=216, gcCount=1}
2020-01-07 14:07:36.418+0000 INFO [o.n.k.i.t.l.c.CheckPointerImpl] Checkpoint triggered by "Scheduled checkpoint for time threshold" @ txId: 28207083 checkpoint started...
2020-01-07 14:07:38.768+0000 INFO [o.n.k.i.s.c.CountsTracker] Rotated counts store at transaction 28207083 to [/data/databases/graph.db/neostore.counts.db.a], from [/data/databases/graph.db/neostore.counts.db.b].
2020-01-07 14:07:39.659+0000 INFO [o.n.k.i.t.l.c.CheckPointerImpl] Checkpoint triggered by "Scheduled checkpoint for time threshold" @ txId: 28207083 checkpoint completed in 3s 241ms
2020-01-07 14:07:39.659+0000 INFO [o.n.k.i.t.l.p.LogPruningImpl] No log version pruned, last checkpoint was made in version 213
2020-01-07 14:22:39.681+0000 INFO [o.n.k.i.t.l.c.CheckPointerImpl] Checkpoint triggered by "Scheduled checkpoint for time threshold" @ txId: 28207792 checkpoint started...
2020-01-07 14:22:42.077+0000 INFO [o.n.k.i.s.c.CountsTracker] Rotated counts store at transaction 28207792 to [/data/databases/graph.db/neostore.counts.db.b], from [/data/databases/graph.db/neostore.counts.db.a].
2020-01-07 14:22:44.311+0000 INFO [o.n.k.i.t.l.c.CheckPointerImpl] Checkpoint triggered by "Scheduled checkpoint for time threshold" @ txId: 28207792 checkpoint completed in 4s 629ms
2020-01-07 14:22:44.311+0000 INFO [o.n.k.i.t.l.p.LogPruningImpl] No log version pruned, last checkpoint was made in version 213
2020-01-07 14:56:01.489+0000 ERROR [o.n.b.t.p.HouseKeeper] Fatal error occurred when handling a client connection: [id: 0x4d1df53e, L:/172.17.0.2:7687 - R:/157.47.139.161:35193] readAddress(..) failed: Connection timed out
io.netty.channel.unix.Errors$NativeIoException: readAddress(..) failed: Connection timed out

[... more of the same ... ]

2020-01-07 16:36:59.223+0000 WARN [o.n.k.i.c.VmPauseMonitorComponent] Detected VM stop-the-world pause: {pauseTime=634, gcTime=635, gcCount=1}
2020-01-07 16:44:38.848+0000 WARN [o.n.k.i.c.VmPauseMonitorComponent] Detected VM stop-the-world pause: {pauseTime=112, gcTime=180, gcCount=1}
2020-01-07 16:51:48.305+0000 ERROR [o.n.b.t.p.HouseKeeper] Fatal error occurred when handling a client connection: [id: 0x2c1287f9, L:/172.17.0.2:7687 - R:/181.199.144.96:4823] readAddress(..) failed: Connection timed out
io.netty.channel.unix.Errors$NativeIoException: readAddress(..) failed: Connection timed out
2020-01-07 16:52:59.025+0000 WARN [o.n.k.i.c.VmPauseMonitorComponent] Detected VM stop-the-world pause: {pauseTime=111, gcTime=178, gcCount=1}
2020-01-07 17:01:18.996+0000 WARN [o.n.k.i.c.VmPauseMonitorComponent] Detected VM stop-the-world pause: {pauseTime=101, gcTime=101, gcCount=1}
2020-01-07 17:25:42.874+0000 WARN [o.n.b.t.p.HouseKeeper] Fatal error occurred when handling a client connection, remote peer unexpectedly closed connection: [id: 0x7a266a67, L:/172.17.0.2:7687 - R:/157.47.184.124:37215]
2020-01-07 17:25:43.344+0000 WARN [o.n.b.t.p.HouseKeeper] Fatal error occurred when handling a client connection, remote peer unexpectedly closed connection: [id: 0x45eed61e, L:/172.17.0.2:7687 - R:/157.47.184.124:1055]
2020-01-07 17:25:45.972+0000 WARN [o.n.b.t.p.HouseKeeper] Fatal error occurred when handling a client connection, remote peer unexpectedly closed connection: [id: 0x40bd56e2, L:/172.17.0.2:7687 - R:/157.47.184.124:44547]
2020-01-07 17:37:42.866+0000 ERROR [o.n.b.t.p.HouseKeeper] Fatal error occurred when handling a client connection: [id: 0xf6e3e959, L:/172.17.0.2:7687 - R:/157.47.184.124:39427] readAddress(..) failed: Connection timed out
io.netty.channel.unix.Errors$NativeIoException: readAddress(..) failed: Connection timed out

[... more of the same ... ]

2020-01-07 19:40:00.849+0000 ERROR [o.n.b.t.p.HouseKeeper] Fatal error occurred when handling a client connection: [id: 0x06914fa2, L:/172.17.0.2:7687 - R:/181.199.144.96:52476] readAddress(..) failed: Connection timed out
io.netty.channel.unix.Errors$NativeIoException: readAddress(..) failed: Connection timed out
2020-01-07 19:48:27.188+0000 WARN [o.n.k.i.c.VmPauseMonitorComponent] Detected VM stop-the-world pause: {pauseTime=734, gcTime=806, gcCount=1}

[... more of the same ... ]

2020-01-08 02:55:18.802+0000 WARN [o.n.k.i.c.VmPauseMonitorComponent] Detected VM stop-the-world pause: {pauseTime=102, gcTime=117, gcCount=1}
2020-01-08 03:16:19.779+0000 INFO [o.n.k.a.DatabaseAvailabilityGuard] Database graph.db is unavailable.
2020-01-08 03:16:19.941+0000 INFO [o.n.g.f.GraphDatabaseFacadeFactory] Shutdown started
2020-01-08 03:16:20.131+0000 INFO [o.n.g.f.GraphDatabaseFacadeFactory] Shutting down 'graph.db' database.
2020-01-08 03:16:20.131+0000 INFO [o.n.g.f.GraphDatabaseFacadeFactory] Shutdown started
2020-01-08 03:20:18.887+0000 INFO [o.n.g.f.m.e.CommunityEditionModule] No locking implementation specified, defaulting to 'forseti'
2020-01-08 03:20:19.447+0000 INFO [o.n.g.f.GraphDatabaseFacadeFactory] Creating 'graph.db' database.
2020-01-08 03:20:19.522+0000 INFO [o.n.k.i.f.StatementLocksFactorySelector] No services implementing StatementLocksFactory found. Using SimpleStatementLocksFactory
2020-01-08 03:20:19.552+0000 INFO [o.n.k.a.DatabaseAvailabilityGuard] Requirement `Database available` makes database graph.db unavailable.
2020-01-08 03:20:19.554+0000 INFO [o.n.k.a.DatabaseAvailabilityGuard] Database graph.db is unavailable.
2020-01-08 03:20:19.603+0000 INFO [o.n.i.d.DiagnosticsManager] --- INITIALIZED diagnostics START ---
2020-01-08 03:20:19.604+0000 INFO [o.n.i.d.DiagnosticsManager] Neo4j Kernel properties:
2020-01-08 03:20:19.604+0000 INFO [o.n.i.d.DiagnosticsManager] dbms.connector.http.enabled=true
2020-01-08 03:20:19.604+0000 INFO [o.n.i.d.DiagnosticsManager] causal_clustering.discovery_listen_address=0.0.0.0:5000
2020-01-08 03:20:19.605+0000 INFO [o.n.i.d.DiagnosticsManager] dbms.logs.query.enabled=true
2020-01-08 03:20:19.605+0000 INFO [o.n.i.d.DiagnosticsManager] dbms.security.auth_enabled=true
2020-01-08 03:20:19.605+0000 INFO [o.n.i.d.DiagnosticsManager] dbms.connector.http.listen_address=0.0.0.0:7474
2020-01-08 03:20:19.605+0000 INFO [o.n.i.d.DiagnosticsManager] unsupported.dbms.directories.neo4j_home=/var/lib/neo4j
2020-01-08 03:20:19.605+0000 INFO [o.n.i.d.DiagnosticsManager] dbms.directories.import=import
2020-01-08 03:20:19.605+0000 INFO [o.n.i.d.DiagnosticsManager] causal_clustering.raft_advertised_address=51e5ecb09221:7000
2020-01-08 03:20:19.605+0000 INFO [o.n.i.d.DiagnosticsManager] dbms.memory.heap.initial_size=20000M
2020-01-08 03:20:19.606+0000 INFO [o.n.i.d.DiagnosticsManager] causal_clustering.raft_listen_address=0.0.0.0:7000
2020-01-08 03:20:19.606+0000 INFO [o.n.i.d.DiagnosticsManager] ACCEPT.LICENSE.AGREEMENT=yes
2020-01-08 03:20:19.606+0000 INFO [o.n.i.d.DiagnosticsManager] dbms.connector.https.enabled=true
2020-01-08 03:20:19.606+0000 INFO [o.n.i.d.DiagnosticsManager] dbms.jvm.additional=-XX:+UseG1GC
2020-01-08 03:20:19.606+0000 INFO [o.n.i.d.DiagnosticsManager] apoc.export.file.enabled=true
2020-01-08 03:20:19.606+0000 INFO [o.n.i.d.DiagnosticsManager] dbms.connectors.default_listen_address=0.0.0.0
2020-01-08 03:20:19.606+0000 INFO [o.n.i.d.DiagnosticsManager] dbms.tx_log.rotation.retention_policy=100M size
2020-01-08 03:20:19.606+0000 INFO [o.n.i.d.DiagnosticsManager] dbms.memory.heap.max_size=20000M
2020-01-08 03:20:19.606+0000 INFO [o.n.i.d.DiagnosticsManager] EDITION=enterprise
2020-01-08 03:20:19.607+0000 INFO [o.n.i.d.DiagnosticsManager] dbms.security.procedures.unrestricted=apoc.*
2020-01-08 03:20:19.607+0000 INFO [o.n.i.d.DiagnosticsManager] dbms.windows_service_name=neo4j
2020-01-08 03:20:19.607+0000 INFO [o.n.i.d.DiagnosticsManager] dbms.connector.https.listen_address=0.0.0.0:7473
2020-01-08 03:20:19.607+0000 INFO [o.n.i.d.DiagnosticsManager] dbms.connector.bolt.listen_address=0.0.0.0:7687
2020-01-08 03:20:19.607+0000 INFO [o.n.i.d.DiagnosticsManager] causal_clustering.transaction_advertised_address=51e5ecb09221:6000
2020-01-08 03:20:19.607+0000 INFO [o.n.i.d.DiagnosticsManager] causal_clustering.discovery_advertised_address=51e5ecb09221:5000
2020-01-08 03:20:19.607+0000 INFO [o.n.i.d.DiagnosticsManager] dbms.memory.pagecache.size=8G
2020-01-08 03:20:19.607+0000 INFO [o.n.i.d.DiagnosticsManager] unsupported.dbms.edition=enterprise
2020-01-08 03:20:19.608+0000 INFO [o.n.i.d.DiagnosticsManager] dbms.directories.logs=/logs
2020-01-08 03:20:19.608+0000 INFO [o.n.i.d.DiagnosticsManager] dbms.connector.bolt.enabled=true
2020-01-08 03:20:19.608+0000 INFO [o.n.i.d.DiagnosticsManager] causal_clustering.transaction_listen_address=0.0.0.0:6000
2020-01-08 03:20:19.608+0000 INFO [o.n.i.d.DiagnosticsManager] wrapper.java.additional=-Dneo4j.ext.udc.source=docker
2020-01-08 03:20:19.608+0000 INFO [o.n.i.d.DiagnosticsManager] HOME=/var/lib/neo4j
2020-01-08 03:20:19.608+0000 INFO [o.n.i.d.DiagnosticsManager] Diagnostics providers:
2020-01-08 03:20:19.608+0000 INFO [o.n.i.d.DiagnosticsManager] org.neo4j.kernel.configuration.Config
2020-01-08 03:20:19.608+0000 INFO [o.n.i.d.DiagnosticsManager] org.neo4j.internal.diagnostics.DiagnosticsManager
2020-01-08 03:20:19.608+0000 INFO [o.n.i.d.DiagnosticsManager] SYSTEM_MEMORY
2020-01-08 03:20:19.609+0000 INFO [o.n.i.d.DiagnosticsManager] JAVA_MEMORY
2020-01-08 03:20:19.609+0000 INFO [o.n.i.d.DiagnosticsManager] OPERATING_SYSTEM
2020-01-08 03:20:19.609+0000 INFO [o.n.i.d.DiagnosticsManager] JAVA_VIRTUAL_MACHINE
2020-01-08 03:20:19.609+0000 INFO [o.n.i.d.DiagnosticsManager] CLASSPATH
2020-01-08 03:20:19.609+0000 INFO [o.n.i.d.DiagnosticsManager] LIBRARY_PATH
2020-01-08 03:20:19.609+0000 INFO [o.n.i.d.DiagnosticsManager] SYSTEM_PROPERTIES
2020-01-08 03:20:19.609+0000 INFO [o.n.i.d.DiagnosticsManager] TIMEZONE_DATABASE
2020-01-08 03:20:19.609+0000 INFO [o.n.i.d.DiagnosticsManager] LINUX_SCHEDULERS
2020-01-08 03:20:19.609+0000 INFO [o.n.i.d.DiagnosticsManager] NETWORK
2020-01-08 03:20:19.609+0000 INFO [o.n.i.d.DiagnosticsManager] System memory information:
2020-01-08 03:20:19.635+0000 INFO [o.n.i.d.DiagnosticsManager] Total Physical memory: 31.41 GB
2020-01-08 03:20:19.636+0000 INFO [o.n.i.d.DiagnosticsManager] Free Physical memory: 10.18 GB
2020-01-08 03:20:19.636+0000 INFO [o.n.i.d.DiagnosticsManager] Committed virtual memory: 23.21 GB
2020-01-08 03:20:19.636+0000 INFO [o.n.i.d.DiagnosticsManager] Total swap space: 0.00 B
2020-01-08 03:20:19.636+0000 INFO [o.n.i.d.DiagnosticsManager] Free swap space: 0.00 B
2020-01-08 03:20:19.636+0000 INFO [o.n.i.d.DiagnosticsManager] JVM memory information:
2020-01-08 03:20:19.637+0000 INFO [o.n.i.d.DiagnosticsManager] Free  memory: 19.49 GB
2020-01-08 03:20:19.637+0000 INFO [o.n.i.d.DiagnosticsManager] Total memory: 19.53 GB
2020-01-08 03:20:19.637+0000 INFO [o.n.i.d.DiagnosticsManager] Max   memory: 19.53 GB
2020-01-08 03:20:19.653+0000 INFO [o.n.i.d.DiagnosticsManager] Garbage Collector: G1 Young Generation: [G1 Eden Space, G1 Survivor Space, G1 Old Gen]
2020-01-08 03:20:19.654+0000 INFO [o.n.i.d.DiagnosticsManager] Garbage Collector: G1 Old Generation: [G1 Eden Space, G1 Survivor Space, G1 Old Gen]
2020-01-08 03:20:19.655+0000 INFO [o.n.i.d.DiagnosticsManager] Memory Pool: Code Cache (Non-heap memory): committed=6.88 MB, used=6.82 MB, max=240.00 MB, threshold=0.00 B
2020-01-08 03:20:19.655+0000 INFO [o.n.i.d.DiagnosticsManager] Memory Pool: Metaspace (Non-heap memory): committed=21.92 MB, used=21.06 MB, max=-1.00 B, threshold=0.00 B
2020-01-08 03:20:19.655+0000 INFO [o.n.i.d.DiagnosticsManager] Memory Pool: Compressed Class Space (Non-heap memory): committed=2.75 MB, used=2.54 MB, max=1.00 GB, threshold=0.00 B
2020-01-08 03:20:19.655+0000 INFO [o.n.i.d.DiagnosticsManager] Memory Pool: G1 Eden Space (Heap memory): committed=1.01 GB, used=16.00 MB, max=-1.00 B, threshold=?
2020-01-08 03:20:19.656+0000 INFO [o.n.i.d.DiagnosticsManager] Memory Pool: G1 Survivor Space (Heap memory): committed=24.00 MB, used=24.00 MB, max=-1.00 B, threshold=?
2020-01-08 03:20:19.656+0000 INFO [o.n.i.d.DiagnosticsManager] Memory Pool: G1 Old Gen (Heap memory): committed=18.50 GB, used=0.00 B, max=19.53 GB, threshold=0.00 B
2020-01-08 03:20:19.656+0000 INFO [o.n.i.d.DiagnosticsManager] Operating system information:
2020-01-08 03:20:19.657+0000 INFO [o.n.i.d.DiagnosticsManager] Operating System: Linux; version: 4.15.0-1050-gcp; arch: amd64; cpus: 4
2020-01-08 03:20:19.657+0000 INFO [o.n.i.d.DiagnosticsManager] Max number of file descriptors: 1048576
2020-01-08 03:20:19.659+0000 INFO [o.n.i.d.DiagnosticsManager] Number of open file descriptors: 203
2020-01-08 03:20:19.664+0000 INFO [o.n.i.d.DiagnosticsManager] Process id: 8@51e5ecb09221
2020-01-08 03:20:19.664+0000 INFO [o.n.i.d.DiagnosticsManager] Byte order: LITTLE_ENDIAN
2020-01-08 03:20:19.669+0000 INFO [o.n.i.d.DiagnosticsManager] Local timezone: Etc/UTC
2020-01-08 03:20:19.669+0000 INFO [o.n.i.d.DiagnosticsManager] JVM information:
2020-01-08 03:20:19.669+0000 INFO [o.n.i.d.DiagnosticsManager] VM Name: OpenJDK 64-Bit Server VM
2020-01-08 03:20:19.669+0000 INFO [o.n.i.d.DiagnosticsManager] VM Vendor: Oracle Corporation
2020-01-08 03:20:19.669+0000 INFO [o.n.i.d.DiagnosticsManager] VM Version: 25.232-b09
2020-01-08 03:20:19.672+0000 INFO [o.n.i.d.DiagnosticsManager] JIT compiler: HotSpot 64-Bit Tiered Compilers
2020-01-08 03:20:19.673+0000 INFO [o.n.i.d.DiagnosticsManager] VM Arguments: [-Xms20000M, -Xmx20000M, -XX:+UseG1GC, -XX:-OmitStackTraceInFastThrow, -XX:+AlwaysPreTouch, -XX:+UnlockExperimentalVMOptions, -XX:+TrustFinalNonStaticFields, -XX:+DisableExplicitGC, -Djdk.tls.ephemeralDHKeySize=2048, -Djdk.tls.rejectClientInitiatedRenegotiation=true, -Dunsupported.dbms.udc.source=docker, -Dfile.encoding=UTF-8]
2020-01-08 03:20:19.673+0000 INFO [o.n.i.d.DiagnosticsManager] Java classpath:
2020-01-08 03:20:19.682+0000 INFO [o.n.i.d.DiagnosticsManager]  [classpath + loader.0] file:/var/lib/neo4j/lib/neo4j-fulltext-index-3.5.14.jar

[... more of the same ... ]

2020-01-08 03:20:19.698+0000 INFO [o.n.i.d.DiagnosticsManager]  [classpath + loader.0] file:/var/lib/neo4j/lib/neo4j-expressions-3.5-3.5.14.jar
2020-01-08 03:20:19.698+0000 INFO [o.n.i.d.DiagnosticsManager] Library path:
2020-01-08 03:20:19.699+0000 INFO [o.n.i.d.DiagnosticsManager] /usr/java/packages/lib/amd64
2020-01-08 03:20:19.699+0000 INFO [o.n.i.d.DiagnosticsManager] /usr/lib64
2020-01-08 03:20:19.699+0000 INFO [o.n.i.d.DiagnosticsManager] /lib64
2020-01-08 03:20:19.699+0000 INFO [o.n.i.d.DiagnosticsManager] /lib
2020-01-08 03:20:19.699+0000 INFO [o.n.i.d.DiagnosticsManager] /usr/lib
2020-01-08 03:20:19.699+0000 INFO [o.n.i.d.DiagnosticsManager] System.properties:
2020-01-08 03:20:19.700+0000 INFO [o.n.i.d.DiagnosticsManager] sun.boot.library.path = /usr/local/openjdk-8/lib/amd64
2020-01-08 03:20:19.700+0000 INFO [o.n.i.d.DiagnosticsManager] jdk.tls.rejectClientInitiatedRenegotiation = true
2020-01-08 03:20:19.700+0000 INFO [o.n.i.d.DiagnosticsManager] path.separator = :
2020-01-08 03:20:19.700+0000 INFO [o.n.i.d.DiagnosticsManager] file.encoding.pkg = sun.io
2020-01-08 03:20:19.700+0000 INFO [o.n.i.d.DiagnosticsManager] sun.java.launcher = SUN_STANDARD
2020-01-08 03:20:19.700+0000 INFO [o.n.i.d.DiagnosticsManager] sun.os.patch.level = unknown
2020-01-08 03:20:19.700+0000 INFO [o.n.i.d.DiagnosticsManager] user.dir = /var/lib/neo4j
2020-01-08 03:20:19.700+0000 INFO [o.n.i.d.DiagnosticsManager] sun.jnu.encoding = UTF-8
2020-01-08 03:20:19.700+0000 INFO [o.n.i.d.DiagnosticsManager] unsupported.dbms.udc.source = docker
2020-01-08 03:20:19.700+0000 INFO [o.n.i.d.DiagnosticsManager] sun.management.compiler = HotSpot 64-Bit Tiered Compilers
2020-01-08 03:20:19.700+0000 INFO [o.n.i.d.DiagnosticsManager] user.home = /var/lib/neo4j
2020-01-08 03:20:19.700+0000 INFO [o.n.i.d.DiagnosticsManager] user.timezone = Etc/UTC
2020-01-08 03:20:19.700+0000 INFO [o.n.i.d.DiagnosticsManager] file.encoding = UTF-8
2020-01-08 03:20:19.701+0000 INFO [o.n.i.d.DiagnosticsManager] user.name = neo4j
2020-01-08 03:20:19.701+0000 INFO [o.n.i.d.DiagnosticsManager] sun.java.command = com.neo4j.server.enterprise.CommercialEntryPoint --home-dir=/var/lib/neo4j --config-dir=/var/lib/neo4j/conf
2020-01-08 03:20:19.701+0000 INFO [o.n.i.d.DiagnosticsManager] sun.arch.data.model = 64
2020-01-08 03:20:19.701+0000 INFO [o.n.i.d.DiagnosticsManager] user.language = en
2020-01-08 03:20:19.701+0000 INFO [o.n.i.d.DiagnosticsManager] awt.toolkit = sun.awt.X11.XToolkit
2020-01-08 03:20:19.701+0000 INFO [o.n.i.d.DiagnosticsManager] jdk.tls.ephemeralDHKeySize = 2048
2020-01-08 03:20:19.701+0000 INFO [o.n.i.d.DiagnosticsManager] file.separator = /
2020-01-08 03:20:19.701+0000 INFO [o.n.i.d.DiagnosticsManager] sun.io.unicode.encoding = UnicodeLittle
2020-01-08 03:20:19.701+0000 INFO [o.n.i.d.DiagnosticsManager] sun.cpu.endian = little
2020-01-08 03:20:19.701+0000 INFO [o.n.i.d.DiagnosticsManager] sun.cpu.isalist = 
2020-01-08 03:20:19.701+0000 INFO [o.n.i.d.DiagnosticsManager] (IANA) TimeZone Database Version:
2020-01-08 03:20:19.762+0000 INFO [o.n.i.d.DiagnosticsManager]   TimeZone version: 2019c (available for 600 zone identifiers)
2020-01-08 03:20:19.763+0000 INFO [o.n.i.d.DiagnosticsManager] Linux scheduler information:
2020-01-08 03:20:19.787+0000 INFO [o.n.i.d.DiagnosticsManager] [none] 
2020-01-08 03:20:19.787+0000 INFO [o.n.i.d.DiagnosticsManager] [none] 
2020-01-08 03:20:19.788+0000 INFO [o.n.i.d.DiagnosticsManager] [none] 
2020-01-08 03:20:19.788+0000 INFO [o.n.i.d.DiagnosticsManager] [none] 
2020-01-08 03:20:19.788+0000 INFO [o.n.i.d.DiagnosticsManager] [none] 
2020-01-08 03:20:19.788+0000 INFO [o.n.i.d.DiagnosticsManager] [none] 
2020-01-08 03:20:19.789+0000 INFO [o.n.i.d.DiagnosticsManager] [none] 
2020-01-08 03:20:19.789+0000 INFO [o.n.i.d.DiagnosticsManager] [none] 
2020-01-08 03:20:19.789+0000 INFO [o.n.i.d.DiagnosticsManager] [none] 
2020-01-08 03:20:19.789+0000 INFO [o.n.i.d.DiagnosticsManager] Network information:
2020-01-08 03:20:19.796+0000 INFO [o.n.i.d.DiagnosticsManager] Interface eth0:
2020-01-08 03:20:19.798+0000 INFO [o.n.i.d.DiagnosticsManager]     address: 172.17.0.2
2020-01-08 03:20:19.798+0000 INFO [o.n.i.d.DiagnosticsManager] Interface lo:
2020-01-08 03:20:19.798+0000 INFO [o.n.i.d.DiagnosticsManager]     address: 127.0.0.1
2020-01-08 03:20:19.798+0000 INFO [o.n.i.d.DiagnosticsManager] --- INITIALIZED diagnostics END ---
2020-01-08 03:20:19.858+0000 INFO [o.n.m.MetricsExtension] Initiating metrics...
2020-01-08 03:20:20.702+0000 INFO [o.n.k.i.s.f.RecordFormatSelector] Selected RecordFormat:StandardV3_4[v0.A.9] record format from store /data/databases/graph.db
2020-01-08 03:20:20.754+0000 INFO [o.n.k.i.s.f.RecordFormatSelector] Selected RecordFormat:StandardV3_4[v0.A.9] record format from store /data/databases/graph.db
2020-01-08 03:20:20.754+0000 INFO [o.n.k.i.s.f.RecordFormatSelector] Format not configured. Selected format from the store: RecordFormat:StandardV3_4[v0.A.9]
2020-01-08 03:20:22.071+0000 INFO [o.n.k.i.i.l.NativeLabelScanStore] Label index cleanup job registered
2020-01-08 03:20:22.075+0000 INFO [o.n.k.i.i.l.NativeLabelScanStore] Label index cleanup job started
2020-01-08 03:20:22.085+0000 INFO [o.n.k.NeoStoreDataSource] No commits found after last check point (which is at LogPosition{logVersion=213, byteOffset=18147610})
2020-01-08 03:20:22.274+0000 INFO [o.n.k.i.i.l.NativeLabelScanStore] Label index cleanup job finished: Number of pages visited: 3587, Number of cleaned crashed pointers: 0, Time spent: 197ms
2020-01-08 03:20:22.274+0000 INFO [o.n.k.i.i.l.NativeLabelScanStore] Label index cleanup job closed
2020-01-08 03:20:22.776+0000 INFO [o.n.k.i.i.s.f.FusionIndexProvider] Schema index cleanup job registered: descriptor=IndexRule[id=3418, descriptor=Index( UNIQUE, :label[17](property[0]) ), provider={key=lucene+native, version=2.0}, owner=4600], indexFile=/data/databases/graph.db/schema/index/lucene_native-2.0/3418/string-1.0/index-3418
2020-01-08 03:20:22.777+0000 INFO [o.n.k.i.i.s.f.FusionIndexProvider] Schema index cleanup job started: descriptor=IndexRule[id=3418, descriptor=Index( UNIQUE, :label[17](property[0]) ), provider={key=lucene+native, version=2.0}, owner=4600], indexFile=/data/databases/graph.db/schema/index/lucene_native-2.0/3418/string-1.0/index-3418
2020-01-08 03:20:22.778+0000 INFO [o.n.k.i.i.s.f.FusionIndexProvider] Schema index cleanup job finished: descriptor=IndexRule[id=3418, descriptor=Index( UNIQUE, :label[17](property[0]) ), provider={key=lucene+native, version=2.0}, owner=4600], indexFile=/data/databases/graph.db/schema/index/lucene_native-2.0/3418/string-1.0/index-3418 Number of pages visited: 2, Number of cleaned crashed pointers: 0, Time spent: 1ms
2020-01-08 03:20:22.778+0000 INFO [o.n.k.i.i.s.f.FusionIndexProvider] Schema index cleanup job closed: descriptor=IndexRule[id=3418, descriptor=Index( UNIQUE, :label[17](property[0]) ), provider={key=lucene+native, version=2.0}, owner=4600], indexFile=/data/databases/graph.db/schema/index/lucene_native-2.0/3418/string-1.0/index-3418
Labels:
0 Kudos
Reply
0 REPLIES 0
Nodes 2022
Nodes
NODES 2022, Neo4j Online Education Summit

All the sessions of the conference are now available online

Watch replays