Brand New install, DB error 500

[Jhony Perez]

I just finished installing 25.01 RL8 following the guide and Database keeps giving me error 500 and does not show anything running.

Under server --> services it does show as running.

Am I missing something?

Thanks,

[Jhony Perez]

I've verified that mongod is running and the connection is established from user sipx with netstat, on the browser I used the dev tools and it shows a [sipxurl]/sipxconfig/rest/mongoGlobal/ 500 (server error) ManageMongo.js:4054 and 4555.

[Jhony Perez]

Errors from mongod.log

{"t":{"$date":"2026-08-08T10:26:55.188-04:00"},"s":"I", "c":"CONNPOOL", "id":22566, "ctx":"NetworkInterfaceTL-ReplicaSetMonitor-TaskExecutor","msg":"Ending connection due to bad connection status","attr":{"hostAndPort":"voice.domain.local:27017","error":"CallbackCanceled: onInvoke :: caused by :: Callback was canceled","numOpenConns":2}}

{"t":{"$date":"2026-08-08T10:26:55.188-04:00"},"s":"I", "c":"-", "id":4495400, "ctx":"NetworkInterfaceTL-ReplicaSetMonitor-TaskExecutor","msg":"RSM not processing response","attr":{"error":{"code":90,"codeName":"CallbackCanceled","errmsg":"onInvoke :: caused by :: Callback was canceled"},"replicaSet":"sipxecs"}}

{"t":{"$date":"2026-08-08T10:26:55.188-04:00"},"s":"I", "c":"CONNPOOL", "id":22566, "ctx":"NetworkInterfaceTL-ReplicaSetMonitor-TaskExecutor","msg":"Ending connection due to bad connection status","attr":{"hostAndPort":"voice.domain.local:27017","error":"CallbackCanceled: onInvoke :: caused by :: Callback was canceled","numOpenConns":1}}

{"t":{"$date":"2026-08-08T10:26:55.188-04:00"},"s":"I", "c":"ACCESS", "id":5286307, "ctx":"conn4","msg":"Failed to authenticate","attr":{"client":"172.20.40.11:50852","isSpeculative":false,"isClusterMember":false,"mechanism":"","user":"","db":"","error":"AuthenticationAbandoned: Authentication session abandoned, client has likely disconnected","result":337,"metrics":{"conversation_duration":{"micros":746768898,"summary":{}}},"doc":{"driver":{"name":"NetworkInterfaceTL-ReplicaSetMonitor-TaskExecutor","version":"8.2.0"},"os":{"type":"Linux","name":"Rocky Linux release 9.8 (Blue Onyx)","architecture":"x86_64","version":"Kernel 5.14.0-687.36.1.el9_8.x86_64"}},"extraInfo":{}}}

{"t":{"$date":"2026-08-08T10:26:55.188-04:00"},"s":"I", "c":"CONNPOOL", "id":22572, "ctx":"SignalHandler","msg":"Dropping all pooled connections","attr":{"hostAndPort":"voice.domain.local:27017","error":"ShutdownInProgress: Shutting down the connection pool"}}

{"t":{"$date":"2026-08-08T10:26:55.190-04:00"},"s":"I", "c":"ACCESS", "id":5286307, "ctx":"conn1","msg":"Failed to authenticate","attr":{"client":"172.20.40.11:50842","isSpeculative":false,"isClusterMember":false,"mechanism":"","user":"","db":"","error":"AuthenticationAbandoned: Authentication session abandoned, client has likely disconnected","result":337,"metrics":{"conversation_duration":{"micros":746771401,"summary":{}}},"doc":{"driver":{"name":"NetworkInterfaceTL-ReplicaSetMonitor-TaskExecutor","version":"8.2.0"},"os":{"type":"Linux","name":"Rocky Linux release 9.8 (Blue Onyx)","architecture":"x86_64","version":"Kernel 5.14.0-687.36.1.el9_8.x86_64"}},"extraInfo":{}}}

{"t":{"$date":"2026-08-08T10:26:55.192-04:00"},"s":"I", "c":"ACCESS", "id":5286307, "ctx":"conn6","msg":"Failed to authenticate","attr":{"client":"172.20.40.11:50854","isSpeculative":false,"isClusterMember":false,"mechanism":"","user":"","db":"","error":"AuthenticationAbandoned: Authentication session abandoned, client has likely disconnected","result":337,"metrics":{"conversation_duration":{"micros":746769708,"summary":{}}},"doc":{"driver":{"name":"NetworkInterfaceTL-ReplicaSetMonitor-TaskExecutor","version":"8.2.0"},"os":{"type":"Linux","name":"Rocky Linux release 9.8 (Blue Onyx)","architecture":"x86_64","version":"Kernel 5.14.0-687.36.1.el9_8.x86_64"}},"extraInfo":{}}}

{"t":{"$date":"2026-08-08T10:26:55.514-04:00"},"s":"I", "c":"STORAGE", "id":22315, "ctx":"initandlisten","msg":"Opening WiredTiger","attr":{"config":"create,cache_size=3324M,session_max=33000,eviction=(threads_min=4,threads_max=4),config_base=false,statistics=(fast),log=(enabled=true,remove=true,path=journal,compressor=snappy),builtin_extension_config=(zstd=(compression_level=6)),file_manager=(close_idle_time=600,close_scan_interval=10,close_handle_minimum=2000),statistics_log=(wait=0),json_output=(error,message),verbose=[recovery_progress:1,checkpoint_progress:1,compact_progress:1,live_restore_progress:1,backup:0,checkpoint:0,compact:0,eviction:0,fileops:0,history_store:0,live_restore:0,recovery:0,rts:0,salvage:0,tiered:0,timestamp:0,transaction:0,verify:0,log:0],prefetch=(available=true,default=false),"}}

{"t":{"$date":"2026-08-08T10:26:56.393-04:00"},"s":"I", "c":"STORAGE", "id":10158000,"ctx":"initandlisten","msg":"Opening spill WiredTiger","attr":{"config":"create,cache_size=191M,session_max=1024,eviction=(threads_min=1,threads_max=1),eviction_dirty_target=9MB,eviction_dirty_trigger=152MB,eviction_updates_trigger=152MB,config_base=false,statistics=(fast),log=(enabled=false),builtin_extension_config=(zstd=(compression_level=-7)),file_manager=(close_idle_time=600,close_scan_interval=10,close_handle_minimum=2000),statistics_log=(wait=0),json_output=(error,message),verbose=[recovery_progress:1,checkpoint_progress:1,compact_progress:1,live_restore_progress:1,backup:0,checkpoint:0,compact:0,eviction:0,fileops:0,history_store:0,live_restore:0,recovery:0,rts:0,salvage:0,tiered:0,timestamp:0,transaction:0,verify:0,log:0],"}}

{"t":{"$date":"2026-08-08T10:26:56.473-04:00"},"s":"I", "c":"-", "id":4939300, "ctx":"monitoring-keys-for-HMAC","msg":"Failed to refresh key cache","attr":{"error":"ReadConcernMajorityNotAvailableYet: Read concern majority reads are currently not possible.","nextRefreshIntervalMillis":200}}

{"t":{"$date":"2026-08-08T10:26:56.508-04:00"},"s":"I", "c":"-", "id":4939300, "ctx":"monitoring-keys-for-HMAC","msg":"Failed to refresh key cache","attr":{"error":"ReadConcernMajorityNotAvailableYet: Read concern majority reads are currently not possible.","nextRefreshIntervalMillis":400}}

{"t":{"$date":"2026-08-08T10:51:08.019-04:00"},"s":"I", "c":"CONTROL", "id":23377, "ctx":"SignalHandler","msg":"Received signal","attr":{"signal":15,"error":"Terminated"}}

{"t":{"$date":"2026-08-08T10:52:54.089-04:00"},"s":"I", "c":"STORAGE", "id":22315, "ctx":"initandlisten","msg":"Opening WiredTiger","attr":{"config":"create,cache_size=3324M,session_max=33000,eviction=(threads_min=4,threads_max=4),config_base=false,statistics=(fast),log=(enabled=true,remove=true,path=journal,compressor=snappy),builtin_extension_config=(zstd=(compression_level=6)),file_manager=(close_idle_time=600,close_scan_interval=10,close_handle_minimum=2000),statistics_log=(wait=0),json_output=(error,message),verbose=[recovery_progress:1,checkpoint_progress:1,compact_progress:1,live_restore_progress:1,backup:0,checkpoint:0,compact:0,eviction:0,fileops:0,history_store:0,live_restore:0,recovery:0,rts:0,salvage:0,tiered:0,timestamp:0,transaction:0,verify:0,log:0],prefetch=(available=true,default=false),"}}

{"t":{"$date":"2026-08-08T10:52:55.189-04:00"},"s":"I", "c":"STORAGE", "id":10158000,"ctx":"initandlisten","msg":"Opening spill WiredTiger","attr":{"config":"create,cache_size=191M,session_max=1024,eviction=(threads_min=1,threads_max=1),eviction_dirty_target=9MB,eviction_dirty_trigger=152MB,eviction_updates_trigger=152MB,config_base=false,statistics=(fast),log=(enabled=false),builtin_extension_config=(zstd=(compression_level=-7)),file_manager=(close_idle_time=600,close_scan_interval=10,close_handle_minimum=2000),statistics_log=(wait=0),json_output=(error,message),verbose=[recovery_progress:1,checkpoint_progress:1,compact_progress:1,live_restore_progress:1,backup:0,checkpoint:0,compact:0,eviction:0,fileops:0,history_store:0,live_restore:0,recovery:0,rts:0,salvage:0,tiered:0,timestamp:0,transaction:0,verify:0,log:0],"}}

{"t":{"$date":"2026-08-08T10:52:55.367-04:00"},"s":"I", "c":"-", "id":4939300, "ctx":"monitoring-keys-for-HMAC","msg":"Failed to refresh key cache","attr":{"error":"ReadConcernMajorityNotAvailableYet: Read concern majority reads are currently not possible.","nextRefreshIntervalMillis":200}}

{"t":{"$date":"2026-08-08T10:52:55.403-04:00"},"s":"I", "c":"-", "id":4333222, "ctx":"NetworkInterfaceTL-ReplicaSetMonitor-TaskExecutor","msg":"RSM received error response","attr":{"host":"voice.domain.local:27017","error":"HostUnreachable: Error connecting to voice.domain.local:27017 (172.20.40.11:27017) :: caused by :: onInvoke :: caused by :: Connection refused","replicaSet":"sipxecs","response":{}}}

{"t":{"$date":"2026-08-08T10:52:55.403-04:00"},"s":"I", "c":"NETWORK", "id":4712102, "ctx":"NetworkInterfaceTL-ReplicaSetMonitor-TaskExecutor","msg":"Host failed in replica set","attr":{"replicaSet":"sipxecs","host":"voice.domain.local:27017","error":{"code":6,"codeName":"HostUnreachable","errmsg":"Error connecting to voice.domain.local:27017 (172.20.40.11:27017) :: caused by :: onInvoke :: caused by :: Connection refused"},"action":{"dropConnections":true,"requestImmediateCheck":true}}}

{"t":{"$date":"2026-08-08T10:52:55.433-04:00"},"s":"I", "c":"-", "id":4939300, "ctx":"monitoring-keys-for-HMAC","msg":"Failed to refresh key cache","attr":{"error":"ReadConcernMajorityNotAvailableYet: Read concern majority reads are currently not possible.","nextRefreshIntervalMillis":400}}

{"t":{"$date":"2026-08-08T10:53:00.147-04:00"},"s":"I", "c":"CONTROL", "id":23377, "ctx":"SignalHandler","msg":"Received signal","attr":{"signal":15,"error":"Terminated"}}

{"t":{"$date":"2026-08-08T10:53:00.155-04:00"},"s":"I", "c":"CONNPOOL", "id":22566, "ctx":"NetworkInterfaceTL-ReplicaSetMonitor-TaskExecutor","msg":"Ending connection due to bad connection status","attr":{"hostAndPort":"voice.domain.local:27017","error":"CallbackCanceled: onInvoke :: caused by :: Callback was canceled","numOpenConns":1}}

{"t":{"$date":"2026-08-08T10:53:00.155-04:00"},"s":"I", "c":"-", "id":4495400, "ctx":"NetworkInterfaceTL-ReplicaSetMonitor-TaskExecutor","msg":"RSM not processing response","attr":{"error":{"code":90,"codeName":"CallbackCanceled","errmsg":"onInvoke :: caused by :: Callback was canceled"},"replicaSet":"sipxecs"}}

{"t":{"$date":"2026-08-08T10:53:00.155-04:00"},"s":"I", "c":"CONNPOOL", "id":22572, "ctx":"SignalHandler","msg":"Dropping all pooled connections","attr":{"hostAndPort":"voice.domain.local:27017","error":"ShutdownInProgress: Shutting down the connection pool"}}

{"t":{"$date":"2026-08-08T10:53:00.155-04:00"},"s":"I", "c":"ACCESS", "id":5286307, "ctx":"conn7","msg":"Failed to authenticate","attr":{"client":"172.20.40.11:45146","isSpeculative":false,"isClusterMember":false,"mechanism":"","user":"","db":"","error":"AuthenticationAbandoned: Authentication session abandoned, client has likely disconnected","result":337,"metrics":{"conversation_duration":{"micros":4250675,"summary":{}}},"doc":{"driver":{"name":"NetworkInterfaceTL-ReplicaSetMonitor-TaskExecutor","version":"8.2.0"},"os":{"type":"Linux","name":"Rocky Linux release 9.8 (Blue Onyx)","architecture":"x86_64","version":"Kernel 5.14.0-687.36.1.el9_8.x86_64"}},"extraInfo":{}}}

{"t":{"$date":"2026-08-08T10:53:00.166-04:00"},"s":"I", "c":"ACCESS", "id":5286307, "ctx":"conn2","msg":"Failed to authenticate","attr":{"client":"172.20.40.11:45138","isSpeculative":false,"isClusterMember":false,"mechanism":"","user":"","db":"","error":"AuthenticationAbandoned: Authentication session abandoned, client has likely disconnected","result":337,"metrics":{"conversation_duration":{"micros":4263231,"summary":{}}},"doc":{"driver":{"name":"NetworkInterfaceTL-ReplicaSetMonitor-TaskExecutor","version":"8.2.0"},"os":{"type":"Linux","name":"Rocky Linux release 9.8 (Blue Onyx)","architecture":"x86_64","version":"Kernel 5.14.0-687.36.1.el9_8.x86_64"}},"extraInfo":{}}}

{"t":{"$date":"2026-08-08T10:53:00.494-04:00"},"s":"I", "c":"STORAGE", "id":22315, "ctx":"initandlisten","msg":"Opening WiredTiger","attr":{"config":"create,cache_size=3324M,session_max=33000,eviction=(threads_min=4,threads_max=4),config_base=false,statistics=(fast),log=(enabled=true,remove=true,path=journal,compressor=snappy),builtin_extension_config=(zstd=(compression_level=6)),file_manager=(close_idle_time=600,close_scan_interval=10,close_handle_minimum=2000),statistics_log=(wait=0),json_output=(error,message),verbose=[recovery_progress:1,checkpoint_progress:1,compact_progress:1,live_restore_progress:1,backup:0,checkpoint:0,compact:0,eviction:0,fileops:0,history_store:0,live_restore:0,recovery:0,rts:0,salvage:0,tiered:0,timestamp:0,transaction:0,verify:0,log:0],prefetch=(available=true,default=false),"}}

{"t":{"$date":"2026-08-08T10:53:01.096-04:00"},"s":"I", "c":"STORAGE", "id":10158000,"ctx":"initandlisten","msg":"Opening spill WiredTiger","attr":{"config":"create,cache_size=191M,session_max=1024,eviction=(threads_min=1,threads_max=1),eviction_dirty_target=9MB,eviction_dirty_trigger=152MB,eviction_updates_trigger=152MB,config_base=false,statistics=(fast),log=(enabled=false),builtin_extension_config=(zstd=(compression_level=-7)),file_manager=(close_idle_time=600,close_scan_interval=10,close_handle_minimum=2000),statistics_log=(wait=0),json_output=(error,message),verbose=[recovery_progress:1,checkpoint_progress:1,compact_progress:1,live_restore_progress:1,backup:0,checkpoint:0,compact:0,eviction:0,fileops:0,history_store:0,live_restore:0,recovery:0,rts:0,salvage:0,tiered:0,timestamp:0,transaction:0,verify:0,log:0],"}}

{"t":{"$date":"2026-08-08T10:53:01.190-04:00"},"s":"I", "c":"-", "id":4939300, "ctx":"monitoring-keys-for-HMAC","msg":"Failed to refresh key cache","attr":{"error":"ReadConcernMajorityNotAvailableYet: Read concern majority reads are currently not possible.","nextRefreshIntervalMillis":200}}

{"t":{"$date":"2026-08-08T10:53:01.222-04:00"},"s":"I", "c":"-", "id":4333222, "ctx":"NetworkInterfaceTL-ReplicaSetMonitor-TaskExecutor","msg":"RSM received error response","attr":{"host":"voice.domain.local:27017","error":"HostUnreachable: Error connecting to voice.domain.local:27017 (172.20.40.11:27017) :: caused by :: onInvoke :: caused by :: Connection refused","replicaSet":"sipxecs","response":{}}}

{"t":{"$date":"2026-08-08T10:53:01.222-04:00"},"s":"I", "c":"NETWORK", "id":4712102, "ctx":"NetworkInterfaceTL-ReplicaSetMonitor-TaskExecutor","msg":"Host failed in replica set","attr":{"replicaSet":"sipxecs","host":"voice.domain.local:27017","error":{"code":6,"codeName":"HostUnreachable","errmsg":"Error connecting to voice.domain.local:27017 (172.20.40.11:27017) :: caused by :: onInvoke :: caused by :: Connection refused"},"action":{"dropConnections":true,"requestImmediateCheck":true}}}

{"t":{"$date":"2026-08-08T10:53:01.234-04:00"},"s":"I", "c":"-", "id":4939300, "ctx":"monitoring-keys-for-HMAC","msg":"Failed to refresh key cache","attr":{"error":"ReadConcernMajorityNotAvailableYet: Read concern majority reads are currently not possible.","nextRefreshIntervalMillis":400}}

[Support]

Most of those entries seem like normal startup messages, so the issue is probably not with mongo DB itself.

One possible culprit is your OS build is missing an important install dependency, causing a 500 server error.  

In any case, sipxconfig.log is a good place to start, alongside output from systemctl status sipxconfig.

--
You received this message because you are subscribed to the Google Groups "sipxcom-users" group.
To unsubscribe from this group and stop receiving emails from it, send an email to sipxcom-user...@googlegroups.com.
To view this discussion visit https://groups.google.com/d/msgid/sipxcom-users/CAGt6jHENmdmMMUV0oS4bE6ur2BzMX0FXO0G-0zBEXojnYrGmog%40mail.gmail.com.

[OnRelay Support]

As part of standard regression testing for update 9 that was just published, we did a brand new install, and it comes up with no errors after running sipxecs-setup and adding the superadmin password.

So a best guess is still that your environment has some missing dependencies vs ours, and / or perhaps there is an issue with the networking setup there.

Our regression test environment is a GCP E2 2 vCPU, 8GB RAM with the following OS config:

Rocky Linux 9.8 (Blue Onyx)

OS version9.8

OS Config agent version20260624.00-g1.el9

We have found this E2 setup is a minimal HW configuration that is a good base to expose timing and performance / capacity issues. For smaller production servers N2 is probably a better choice.

[Support]

We have bottomed out and fixed this issue. 

It was a combination of a python bug in the mongodb-admin script that caused the SET_MEMBER_META command to have no effect, and a dart script UI error in parsing the json response with the missing member info.

Fix will be included in update 10. 

On Aug 8, 2026, at 6:20 PM, Jhony Perez <jh...@nautus.net> wrote: