Closed PJ38 closed 3 years ago
Hey @PJ38, thank you for your report.
I managed to reproduce this issue. Seems like we are throwing an error instead of using a fallback when a password can't be found for the DBMS, which is not how it should work.
We're looking into a solution, but until we have a fix, you can stop the DBMS in two ways without having to restart your device.
The simplest one would be to open PowerShell and run:
Stop-Process -Name Java
If you have other Java processes running it will stop them too though.
The other way is to open the DBMS folder in the terminal (you can do this from Desktop), then run as two separate commands:
powershell
and
Stop-Process -Id $(Get-Content .\run\neo4j-relate.pid)
The fix for this has been merged, it will be included in the next release.
[2021-07-24 16:49:48.839] [info] Retrieving status for DBMS[database-3b42c6eb-e5ce-4db9-9aeb-8d1993747daf]
[2021-07-24 16:49:48.904] [info] Checking ports [2021-07-24 16:49:48.959] [info] Starting Neo4j [2021-07-24 16:49:48.960] [info] Starting DBMS [database-3b42c6eb-e5ce-4db9-9aeb-8d1993747daf] 'v4.2.1'
[2021-07-24 16:49:48.997] [info] Check if neo4j is available on { host: '127.0.0.1', path: '/', port: 11003 } [2021-07-24 16:49:48.998] [info] Check if neo4j is available on { host: '127.0.0.1', path: '/', port: 11004 } [2021-07-24 16:49:51.002] [info] Neo4j @ 11004 is down. connect ECONNREFUSED 127.0.0.1:11004 [2021-07-24 16:49:51.005] [info] Neo4j @ 11003 is down. connect ECONNREFUSED 127.0.0.1:11003
[2021-07-24 16:49:59.186] [info] Online check request: https://dist.neo4j.org/neo4j-desktop/win/latest.yml [2021-07-24 16:49:59.754] [info] Online check response: 200 version: 1.4.7 files
Started facing this error today
Could you attach the output from the DBMS logs? (You can access it by clicking the "Neo4j DBMS logs" link in the error banner)
Since there are 4 different log files , ill post all of their contents
debug log:
2021-07-26 09:07:08.295+0000 INFO [o.n.i.i.l.LabelScanStore] [neo4j/11fddda9] Label index cleanup job registered
2021-07-26 09:07:08.296+0000 INFO [o.n.i.i.l.LabelScanStore] [neo4j/11fddda9] Label index cleanup job started
2021-07-26 09:07:08.298+0000 INFO [o.n.i.i.l.LabelScanStore] [neo4j/11fddda9] Label index cleanup job finished: Number of pages visited: 3, Number of tree nodes: 2, Number of cleaned crashed pointers: 0, Time spent: 1ms
2021-07-26 09:07:08.298+0000 INFO [o.n.i.i.l.LabelScanStore] [neo4j/11fddda9] Label index cleanup job closed
2021-07-26 09:07:08.351+0000 INFO [o.n.k.a.DatabaseAvailabilityGuard] [neo4j/11fddda9] Requirement Database unavailable
makes database neo4j unavailable.
2021-07-26 09:07:08.351+0000 INFO [o.n.k.a.DatabaseAvailabilityGuard] [neo4j/11fddda9] DatabaseId{11fddda9[neo4j]} is unavailable.
2021-07-26 09:07:08.357+0000 INFO [o.n.k.a.DatabaseAvailabilityGuard] [neo4j/11fddda9] Fulfilling of requirement 'Database unavailable' makes database neo4j available.
2021-07-26 09:07:08.358+0000 INFO [o.n.k.a.DatabaseAvailabilityGuard] [neo4j/11fddda9] DatabaseId{11fddda9[neo4j]} is ready.
2021-07-26 09:07:08.358+0000 INFO [o.n.m.DatabaseHealth] [neo4j/11fddda9] Database health set to OK
2021-07-26 09:07:08.359+0000 INFO [c.n.d.DbmsReconciler] Database 'neo4j' transition is complete from INITIAL{db=neo4j/11fddda9} to STARTED{db=neo4j/11fddda9}
2021-07-26 09:07:08.359+0000 INFO [c.n.k.i.p.PageCacheWarmer] [neo4j/11fddda9] Page cache warmup started.
2021-07-26 09:07:08.359+0000 INFO [o.n.b.t.DefaultReconciledTransactionTracker] Enabling with transaction ID 51
2021-07-26 09:07:08.440+0000 INFO [c.n.k.i.p.PageCacheWarmer] [neo4j/11fddda9] Page cache warmup completed. 112 pages loaded. Duration: 80ms. 1.40 pages/ms
2021-07-26 09:07:08.983+0000 INFO [c.n.m.g.GlobalMetricsExtension] Sending metrics to CSV file at C:\Users\dmin.Neo4jDesktop\relate-data\dbmss\dbms-ad69fb39-ee86-4909-aef7-12d73844c3a6\metrics
2021-07-26 09:07:09.445+0000 INFO [o.n.b.BoltServer] Bolt enabled on localhost:11003.
2021-07-26 09:07:09.445+0000 INFO [o.n.s.AbstractNeoWebServer$ServerComponentsLifecycleAdapter] Starting web server
2021-07-26 09:07:11.826+0000 INFO [c.n.s.e.EnterpriseNeoWebServer] Remote interface available at http://localhost:11004/
2021-07-26 09:07:11.826+0000 INFO [o.n.s.AbstractNeoWebServer$ServerComponentsLifecycleAdapter] Web server started.
neo4j log: 2021-07-26 06:01:07.963+0000 INFO Starting... 2021-07-26 06:01:12.776+0000 INFO ======== Neo4j 4.2.1 ======== 2021-07-26 06:01:27.207+0000 INFO Sending metrics to CSV file at C:\Users\dmin.Neo4jDesktop\relate-data\dbmss\dbms-ad69fb39-ee86-4909-aef7-12d73844c3a6\metrics 2021-07-26 06:01:27.236+0000 INFO Bolt enabled on localhost:7687. 2021-07-26 06:01:30.656+0000 INFO Remote interface available at http://localhost:7474/ 2021-07-26 06:01:30.657+0000 INFO Started. 2021-07-26 09:06:42.413+0000 INFO Note that since you did not explicitly set the port in dbms.connector.bolt.advertised_address Neo4j automatically set it to 11003 to match dbms.connector.bolt.listen_address. This behavior may change in the future and we recommend you to explicitly set it. 2021-07-26 09:06:42.419+0000 INFO Note that since you did not explicitly set the port in dbms.connector.http.advertised_address Neo4j automatically set it to 11004 to match dbms.connector.http.listen_address. This behavior may change in the future and we recommend you to explicitly set it. 2021-07-26 09:06:42.422+0000 INFO Starting... 2021-07-26 09:06:49.372+0000 INFO ======== Neo4j 4.2.1 ======== 2021-07-26 09:07:08.983+0000 INFO Sending metrics to CSV file at C:\Users\dmin.Neo4jDesktop\relate-data\dbmss\dbms-ad69fb39-ee86-4909-aef7-12d73844c3a6\metrics 2021-07-26 09:07:09.445+0000 INFO Bolt enabled on localhost:11003. 2021-07-26 09:07:11.825+0000 INFO Remote interface available at http://localhost:11004/ 2021-07-26 09:07:11.826+0000 INFO Started.
security log:
2021-07-26 06:01:12.818+0000 INFO {plugin-com.neo4j.plugin.jwt.auth.JwtAuthPlugin} jwt.auth.private_key=certificates/security.key.pem
2021-07-26 06:01:25.974+0000 INFO Initializing system graph model for component 'security-users' with version -1 and status UNINITIALIZED
2021-07-26 06:01:26.005+0000 INFO Setting up initial user from auth.ini
file: neo4j
2021-07-26 06:01:26.006+0000 INFO Creating new user 'neo4j' (passwordChangeRequired=false, suspended=false)
2021-07-26 06:01:26.131+0000 INFO Setting version for 'security-users' to 2
2021-07-26 06:01:26.152+0000 INFO After initialization of system graph model component 'security-users' have version 2 and status CURRENT
2021-07-26 06:01:26.175+0000 INFO Performing postInitialization step for component 'security-users' with version 2 and status CURRENT
2021-07-26 06:01:26.525+0000 INFO Initializing system graph model for component 'security-privileges' with version -1 and status UNINITIALIZED
2021-07-26 06:01:26.526+0000 INFO Initializing security model with 6 roles
2021-07-26 06:01:27.036+0000 INFO Setting version for 'security-privileges' to 4
2021-07-26 06:01:27.048+0000 INFO Upgrading 'security-privileges' version property from 4 to 5
2021-07-26 06:01:27.073+0000 INFO Upgrading 'security-privileges' version property from 5 to 6
2021-07-26 06:01:27.091+0000 INFO Upgrading 'security-privileges' version property from 6 to 7
2021-07-26 06:01:27.091+0000 INFO Upgrading 'security-privileges' version property from 7 to 8
2021-07-26 06:01:27.161+0000 INFO Assigned admin role to user 'neo4j'.
2021-07-26 06:01:27.170+0000 INFO After initialization of system graph model component 'security-privileges' have version 8 and status CURRENT
2021-07-26 06:01:33.058+0000 INFO {plugin-com.neo4j.plugin.jwt.auth.JwtAuthPlugin} Log in attempted for user 'neo4j'.
2021-07-26 06:01:33.058+0000 ERROR {plugin-com.neo4j.plugin.jwt.auth.JwtAuthPlugin} Invalid serialized unsecured/JWS/JWE object: Missing part delimiters
2021-07-26 06:01:33.064+0000 INFO [neo4j]: logged in
2021-07-26 06:01:35.112+0000 INFO {plugin-com.neo4j.plugin.jwt.auth.JwtAuthPlugin} Log in attempted for user 'neo4j'.
2021-07-26 06:01:35.112+0000 ERROR {plugin-com.neo4j.plugin.jwt.auth.JwtAuthPlugin} Invalid serialized unsecured/JWS/JWE object: Missing part delimiters
2021-07-26 06:01:35.112+0000 INFO [neo4j]: logged in
2021-07-26 06:01:36.502+0000 INFO {plugin-com.neo4j.plugin.jwt.auth.JwtAuthPlugin} Log in attempted for user 'neo4j'.
2021-07-26 06:01:36.502+0000 ERROR {plugin-com.neo4j.plugin.jwt.auth.JwtAuthPlugin} Invalid serialized unsecured/JWS/JWE object: Missing part delimiters
2021-07-26 06:01:36.502+0000 INFO [neo4j]: logged in
2021-07-26 06:01:36.546+0000 INFO {plugin-com.neo4j.plugin.jwt.auth.JwtAuthPlugin} Log in attempted for user 'neo4j'.
2021-07-26 06:01:36.546+0000 ERROR {plugin-com.neo4j.plugin.jwt.auth.JwtAuthPlugin} Invalid serialized unsecured/JWS/JWE object: Missing part delimiters
2021-07-26 06:01:36.546+0000 INFO [neo4j]: logged in
2021-07-26 06:01:38.808+0000 INFO {plugin-com.neo4j.plugin.jwt.auth.JwtAuthPlugin} Log in attempted for user 'neo4j'.
2021-07-26 06:01:38.809+0000 ERROR {plugin-com.neo4j.plugin.jwt.auth.JwtAuthPlugin} Invalid serialized unsecured/JWS/JWE object: Missing part delimiters
2021-07-26 06:01:38.809+0000 INFO [neo4j]: logged in
2021-07-26 06:01:41.325+0000 INFO {plugin-com.neo4j.plugin.jwt.auth.JwtAuthPlugin} Log in attempted for user 'neo4j'.
2021-07-26 06:01:41.326+0000 ERROR {plugin-com.neo4j.plugin.jwt.auth.JwtAuthPlugin} Invalid serialized unsecured/JWS/JWE object: Missing part delimiters
2021-07-26 06:01:41.326+0000 INFO [neo4j]: logged in
2021-07-26 06:01:41.415+0000 INFO {plugin-com.neo4j.plugin.jwt.auth.JwtAuthPlugin} Log in attempted for user 'neo4j'.
2021-07-26 06:01:41.415+0000 ERROR {plugin-com.neo4j.plugin.jwt.auth.JwtAuthPlugin} Invalid serialized unsecured/JWS/JWE object: Missing part delimiters
2021-07-26 06:01:41.416+0000 INFO [neo4j]: logged in
2021-07-26 06:01:41.452+0000 INFO {plugin-com.neo4j.plugin.jwt.auth.JwtAuthPlugin} Log in attempted for user 'neo4j'.
2021-07-26 06:01:41.452+0000 ERROR {plugin-com.neo4j.plugin.jwt.auth.JwtAuthPlugin} Invalid serialized unsecured/JWS/JWE object: Missing part delimiters
2021-07-26 06:01:41.452+0000 INFO [neo4j]: logged in
2021-07-26 06:02:01.257+0000 INFO {plugin-com.neo4j.plugin.jwt.auth.JwtAuthPlugin} Log in attempted for user 'neo4j'.
2021-07-26 06:02:01.257+0000 ERROR {plugin-com.neo4j.plugin.jwt.auth.JwtAuthPlugin} Invalid serialized unsecured/JWS/JWE object: Missing part delimiters
2021-07-26 06:02:01.257+0000 INFO [neo4j]: logged in
2021-07-26 06:02:01.344+0000 INFO {plugin-com.neo4j.plugin.jwt.auth.JwtAuthPlugin} Log in attempted for user 'neo4j'.
2021-07-26 06:02:01.344+0000 ERROR {plugin-com.neo4j.plugin.jwt.auth.JwtAuthPlugin} Invalid serialized unsecured/JWS/JWE object: Missing part delimiters
2021-07-26 06:02:01.344+0000 INFO [neo4j]: logged in
2021-07-26 06:02:01.380+0000 INFO {plugin-com.neo4j.plugin.jwt.auth.JwtAuthPlugin} Log in attempted for user 'neo4j'.
2021-07-26 06:02:01.381+0000 ERROR {plugin-com.neo4j.plugin.jwt.auth.JwtAuthPlugin} Invalid serialized unsecured/JWS/JWE object: Missing part delimiters
2021-07-26 06:02:01.381+0000 INFO [neo4j]: logged in
2021-07-26 06:02:59.539+0000 INFO {plugin-com.neo4j.plugin.jwt.auth.JwtAuthPlugin} Log in attempted for user 'neo4j'.
2021-07-26 06:02:59.540+0000 ERROR {plugin-com.neo4j.plugin.jwt.auth.JwtAuthPlugin} Invalid serialized unsecured/JWS/JWE object: Missing part delimiters
2021-07-26 06:02:59.540+0000 INFO [neo4j]: logged in
2021-07-26 06:03:07.019+0000 INFO {plugin-com.neo4j.plugin.jwt.auth.JwtAuthPlugin} Log in attempted for user 'neo4j'.
2021-07-26 06:03:07.019+0000 ERROR {plugin-com.neo4j.plugin.jwt.auth.JwtAuthPlugin} Invalid serialized unsecured/JWS/JWE object: Missing part delimiters
2021-07-26 06:03:07.019+0000 INFO [neo4j]: logged in
2021-07-26 06:03:11.155+0000 INFO {plugin-com.neo4j.plugin.jwt.auth.JwtAuthPlugin} Log in attempted for user 'neo4j'.
2021-07-26 06:03:11.156+0000 ERROR {plugin-com.neo4j.plugin.jwt.auth.JwtAuthPlugin} Invalid serialized unsecured/JWS/JWE object: Missing part delimiters
2021-07-26 06:03:11.156+0000 INFO [neo4j]: logged in
2021-07-26 09:06:49.466+0000 INFO {plugin-com.neo4j.plugin.jwt.auth.JwtAuthPlugin} jwt.auth.private_key=certificates/security.key.pem
2021-07-26 09:07:08.885+0000 INFO Performing postInitialization step for component 'security-users' with version 2 and status CURRENT
2021-07-26 09:07:08.885+0000 INFO Updating the initial password in component 'security-users'
2021-07-26 09:07:13.348+0000 INFO {plugin-com.neo4j.plugin.jwt.auth.JwtAuthPlugin} Log in attempted for user 'neo4j'.
2021-07-26 09:07:13.348+0000 ERROR {plugin-com.neo4j.plugin.jwt.auth.JwtAuthPlugin} Invalid serialized unsecured/JWS/JWE object: Missing part delimiters
2021-07-26 09:07:13.362+0000 INFO [neo4j]: logged in
2021-07-26 09:07:15.837+0000 INFO {plugin-com.neo4j.plugin.jwt.auth.JwtAuthPlugin} Log in attempted for user 'neo4j'.
2021-07-26 09:07:15.837+0000 ERROR {plugin-com.neo4j.plugin.jwt.auth.JwtAuthPlugin} Invalid serialized unsecured/JWS/JWE object: Missing part delimiters
2021-07-26 09:07:15.838+0000 INFO [neo4j]: logged in
2021-07-26 09:07:17.464+0000 INFO {plugin-com.neo4j.plugin.jwt.auth.JwtAuthPlugin} Log in attempted for user 'neo4j'.
2021-07-26 09:07:17.465+0000 ERROR {plugin-com.neo4j.plugin.jwt.auth.JwtAuthPlugin} Invalid serialized unsecured/JWS/JWE object: Missing part delimiters
2021-07-26 09:07:17.465+0000 INFO [neo4j]: logged in
2021-07-26 09:07:18.985+0000 INFO {plugin-com.neo4j.plugin.jwt.auth.JwtAuthPlugin} Log in attempted for user 'neo4j'.
2021-07-26 09:07:18.985+0000 ERROR {plugin-com.neo4j.plugin.jwt.auth.JwtAuthPlugin} Invalid serialized unsecured/JWS/JWE object: Missing part delimiters
2021-07-26 09:07:18.985+0000 INFO [neo4j]: logged in
2021-07-26 09:07:18.999+0000 INFO {plugin-com.neo4j.plugin.jwt.auth.JwtAuthPlugin} Log in attempted for user 'neo4j'.
2021-07-26 09:07:18.999+0000 ERROR {plugin-com.neo4j.plugin.jwt.auth.JwtAuthPlugin} Invalid serialized unsecured/JWS/JWE object: Missing part delimiters
2021-07-26 09:07:19.000+0000 INFO [neo4j]: logged in
2021-07-26 09:07:20.696+0000 INFO {plugin-com.neo4j.plugin.jwt.auth.JwtAuthPlugin} Log in attempted for user 'neo4j'.
2021-07-26 09:07:20.696+0000 ERROR {plugin-com.neo4j.plugin.jwt.auth.JwtAuthPlugin} Invalid serialized unsecured/JWS/JWE object: Missing part delimiters
2021-07-26 09:07:20.696+0000 INFO [neo4j]: logged in
2021-07-26 09:07:20.746+0000 INFO {plugin-com.neo4j.plugin.jwt.auth.JwtAuthPlugin} Log in attempted for user 'neo4j'.
2021-07-26 09:07:20.747+0000 ERROR {plugin-com.neo4j.plugin.jwt.auth.JwtAuthPlugin} Invalid serialized unsecured/JWS/JWE object: Missing part delimiters
2021-07-26 09:07:20.747+0000 INFO [neo4j]: logged in
2021-07-26 09:07:20.837+0000 INFO {plugin-com.neo4j.plugin.jwt.auth.JwtAuthPlugin} Log in attempted for user 'neo4j'.
2021-07-26 09:07:20.837+0000 ERROR {plugin-com.neo4j.plugin.jwt.auth.JwtAuthPlugin} Invalid serialized unsecured/JWS/JWE object: Missing part delimiters
2021-07-26 09:07:20.837+0000 INFO [neo4j]: logged in
query log:
2021-07-26 06:01:41.329+0000 INFO Query started: id:12 - 0 ms: 0 B - bolt-session bolt tapestry/1.0.0 client/127.0.0.1:56327 server/127.0.0.1:7687> jwt.security.requestAccess
: Caused by: java.lang.NoSuchMethodError: 'java.security.PrivateKey org.neo4j.ssl.PkiUtils.loadPrivateKey(java.io.File, java.lang.String)'
It looks like the version of the JWT plugin installed in your DBMS is not compatible with Neo4j 4.2.1.
Could you delete the JWT plugin from the DBMS plugins folder, and place the correct version of the plugin (https://s3-eu-west-1.amazonaws.com/dist.neo4j.org/relate/neo4j-jwt-addon/neo4j-jwt-addon-1.2.0.jar) there?
New update , right now my dbms startups and stopping are both working unfortunately , my Bloom and Browser both dont go past the loading
[2021-07-20 11:42:03.988] [info] Starting Neo4j [2021-07-20 11:42:03.989] [info] Starting DBMS [database-3b42c6eb-e5ce-4db9-9aeb-8d1993747daf] 'v4.2.1'
[2021-07-20 11:42:04.022] [info] Check if neo4j is available on { host: '127.0.0.1', path: '/', port: 7687 } [2021-07-20 11:42:04.024] [info] Check if neo4j is available on { host: '127.0.0.1', path: '/', port: 7474 } [2021-07-20 11:42:04.027] [info] Neo4j @ 7687 is up and running! [2021-07-20 11:42:04.029] [info] Neo4j @ 7474 is up and running! [2021-07-20 11:42:04.321] [info] reset password error: Neo4jError: Unsupported authentication token, scheme='none' only allowed when auth is disabled: { scheme='none', user_agent='neo4j-desktop/v1.4.7' }
[2021-07-20 11:42:04.350] [info] Stopping Neo4j [2021-07-20 11:42:04.358] [warn] Failed to stop DBMS through Relate Error: Cannot find password for DBMS "980f6639-a03e-4673-90ff-90ae0dcd4d18" at Object.T [as mapDbmsToQueryTarget] (C:\Program Files\Neo4j Desktop\resources\app.asar\dist\main.prod.js:1:238578) at async Object.t.stop (C:\Program Files\Neo4j Desktop\resources\app.asar\dist\main.prod.js:1:160455) at async Object.H [as stop] (C:\Program Files\Neo4j Desktop\resources\app.asar\dist\main.prod.js:1:138125) at async Object.t.resetDbmsPassword (C:\Program Files\Neo4j Desktop\resources\app.asar\dist\main.prod.js:1:164175)
[2021-07-20 11:59:26.615] [info] Check if neo4j is available on { host: '127.0.0.1', path: '/', port: 7687 } [2021-07-20 11:59:26.616] [info] Check if neo4j is available on { host: '127.0.0.1', path: '/', port: 7474 } [2021-07-20 11:59:26.619] [info] Neo4j @ 7687 is up and running! [2021-07-20 11:59:26.622] [info] Neo4j @ 7474 is up and running! [2021-07-20 11:59:27.620] [info] Neo4j Stop timeout. Service not stopped within 60 seconds [2021-07-20 12:00:04.643] [info] Online check request: https://dist.neo4j.org/neo4j-desktop/win/latest.yml [2021-07-20 12:00:04.827] [info] Online check response: 200 version: 1.4.7 files
So, I'm unable to stop a database after starting it, the logs show that DBMS password cannot be found. When I try to change the password (While DBMS is running / DBMS was not started), I get "Neo4j stop timeout" (PS. To stop the DBMS, I need to restart my device)