Issues with starting VisionX on macOS

[jeffreybos]

Hi!

I want to use VisionX on my macbook but I get the following message. (See attachment)
How can I fix this?

thank you in advance.

[Support@SIB]

Which VisionX Version do you use?

[jeffreybos]

VisionX 10.7

[Support@SIB]

No, this is the MacOS min version. When did you download VisionX?

Which macOS version do you use?

[jeffreybos]

Sorry, it is 5.2.27, i downloaded it last week.

macOS Mojave (10.14.3)

[Support@SIB]

The problem is that the bundled PostgreSql DB won't start. We have successful tests up to macOS High Sierra (10.13.6).

We'll check this asap.

[Support@SIB]

We finished the test and everything is fine in our environment. So, it must be something specific with your setup.

To find out what's going on, please start VisionX manually, with following steps:

Open a terminal and execute:

Code: Select all

open -e /Applications/VisionX.app/Contents/Resources/Java/logging.properties

(opens the log configuration)

Add following at the end:

Code: Select all

com.sibvisions.visionx.DesktopLauncher.level = ALL

(enables logging)

Code: Select all

cd /Applications/VisionX.app/Contents/Resources

(changes the working directory)

(one line, no enter)

Code: Select all

/Applications/VisionX.app/Contents/Resources/runtime/bin/java -jar /Applications/VisionX.app/Contents/Resources/Java/visionxloader.jar

(starts VisionX)

The console output will show additional information about the issue.

[jeffreybos]

I saw that I had a postgres server running locally, I removed it.
Now I get the following notification including logs (see attachement)

Code: Select all

Apr 24, 2019 12:46:28 PM [ FINE        ] Initial WORK dir = /Applications/VisionX.app/Contents/Resources                                      com.sibvisions.visionx.DesktopLauncher main (Line: -1)
Apr 24, 2019 12:46:29 PM [ FINE        ] WORK dir = /Applications/VisionX.app/Contents/Resources                                              com.sibvisions.visionx.DesktopLauncher <init> (Line: -1)
Apr 24, 2019 12:46:29 PM [ FINE        ] RAD dir = /Applications/VisionX.app/Contents/Resources                                               com.sibvisions.visionx.DesktopLauncher <init> (Line: -1)
Apr 24, 2019 12:46:29 PM [ FINE        ] com.sibvisions.visionx.DesktopLauncher <init> (Line: -1)
                                    {[java.runtime.name, Java(TM) SE Runtime Environment], [sun.boot.library.path, /Applications/VisionX.app/Contents/Resources/runtime/jre/lib], [java.vm.version, 25.60-b23], [user.country.format, NL], [com.apple.mrj.application.apple.menu.about.name, VisionX], [gopherProxySet, false], [java.vm.vendor, Oracle Corporation], [java.vendor.url, http://java.oracle.com/], [path.separator, :], [java.vm.name, Java HotSpot(TM) 64-Bit Server VM], [file.encoding.pkg, sun.io], [user.country, GB], [sun.java.launcher, SUN_STANDARD], [sun.os.patch.level, unknown], [java.vm.specification.name, Java Virtual Machine Specification], [user.dir, /Applications/VisionX.app/Contents/Resources], [java.runtime.version, 1.8.0_60-b27], [java.awt.graphicsenv, sun.awt.CGraphicsEnvironment], [Configuration.basedir, /Applications/VisionX.app/Contents/Resources], [java.endorsed.dirs, /Applications/VisionX.app/Contents/Resources/runtime/jre/lib/endorsed], [os.arch, x86_64], [Server.instanceKey, juv3f7nr#1], [java.io.tmpdir, /var/folders/py/jdjvfjqs2k76wf4_jg_5g2r00000gn/T/], [line.separator,
                                    ], [java.vm.specification.vendor, Oracle Corporation], [os.name, Mac OS X], [apple.laf.useScreenMenuBar, true], [visionx.run.proxyPassword, ], [sun.jnu.encoding, UTF-8], [com.apple.mrj.application.live-resize, true], [java.library.path, /Users/bosrocks/Library/Java/Extensions:/Library/Java/Extensions:/Network/Library/Java/Extensions:/System/Library/Java/Extensions:/usr/lib/java:.], [sun.awt.enableExtraMouseButtons, true], [java.specification.name, Java Platform API Specification], [java.class.version, 52.0], [sun.management.compiler, HotSpot 64-Bit Tiered Compilers], [os.version, 10.14.3], [http.nonProxyHosts, local|*.local|169.254/16|*.169.254/16], [user.home, /Users/bosrocks], [user.timezone, Europe/Amsterdam], [java.awt.printerjob, sun.lwawt.macosx.CPrinterJob], [visionx.run.proxyPort, 3128], [file.encoding, UTF-8], [java.specification.version, 1.8], [Server.systemIdentifier, /Applications/VisionX.app/Contents/Resources], [java.class.path, /Applications/VisionX.app/Contents/Resources/Java/visionxloader.jar], [user.name, bosrocks], [com.apple.macos.smallTabs, true], [visionx.run.proxyUsern, ], [java.vm.specification.version, 1.8], [sun.java.command, /Applications/VisionX.app/Contents/Resources/Java/visionxloader.jar], [java.home, /Applications/VisionX.app/Contents/Resources/runtime/jre], [sun.arch.data.model, 64], [com.apple.mrj.application.growbox.intrudes, false], [user.language, en], [java.specification.vendor, Oracle Corporation], [awt.toolkit, sun.lwawt.macosx.LWCToolkit], [java.vm.info, mixed mode], [java.version, 1.8.0_60], [java.ext.dirs, /Users/bosrocks/Library/Java/Extensions:/Applications/VisionX.app/Contents/Resources/runtime/jre/lib/ext:/Library/Java/Extensions:/Network/Library/Java/Extensions:/System/Library/Java/Extensions:/usr/lib/java], [sun.boot.class.path, /Applications/VisionX.app/Contents/Resources/runtime/jre/lib/resources.jar:/Applications/VisionX.app/Contents/Resources/runtime/jre/lib/rt.jar:/Applications/VisionX.app/Contents/Resources/runtime/jre/lib/sunrsasign.jar:/Applications/VisionX.app/Contents/Resources/runtime/jre/lib/jsse.jar:/Applications/VisionX.app/Contents/Resources/runtime/jre/lib/jce.jar:/Applications/VisionX.app/Contents/Resources/runtime/jre/lib/charsets.jar:/Applications/VisionX.app/Contents/Resources/runtime/jre/lib/jfr.jar:/Applications/VisionX.app/Contents/Resources/runtime/jre/classes], [java.vendor, Oracle Corporation], [file.separator, /], [java.vendor.url.bug, http://bugreport.sun.com/bugreport/], [sun.font.fontmanager, sun.font.CFontManager], [sun.io.unicode.encoding, UnicodeBig], [sun.cpu.endian, little], [visionx.run.proxyEnabled, false], [socksNonProxyHosts, local|*.local|169.254/16|*.169.254/16], [visionx.run.proxyHost, ], [ftp.nonProxyHosts, local|*.local|169.254/16|*.169.254/16], [sun.cpu.isalist, ]}
pg_ctl: PID file "/Applications/VisionX.app/Contents/Resources/database/data/postmaster.pid" does not exist
Is server running?
waiting for server to start....Apr 24, 2019 12:46:29 PM [ INFO        ] OUTwaiting for server to start....                                                                   com.sibvisions.visionx.DesktopLauncher <init> (Line: -1)
Apr 24, 2019 12:46:29 PM [ INFO        ] ERR                                                                                                  com.sibvisions.visionx.DesktopLauncher <init> (Line: -1)
Apr 24, 2019 12:46:29 PM [ INFO        ] Reset wait count, because state has changed!                                                         com.sibvisions.visionx.DesktopLauncher <init> (Line: -1)
Apr 24, 2019 12:46:29 PM [ INFO        ] OUTwaiting for server to start....                                                                   com.sibvisions.visionx.DesktopLauncher <init> (Line: -1)
Apr 24, 2019 12:46:29 PM [ INFO        ] ERR                                                                                                  com.sibvisions.visionx.DesktopLauncher <init> (Line: -1)
LOG:  database system was shut down at 2014-12-02 00:34:19 CET
Error: Could not find or load main class com.sibvisions.visionx.TomcatStarter
LOG:  database system is ready to accept connections
LOG:  autovacuum launcher started
 done
server started
Apr 24, 2019 12:46:30 PM [ INFO        ] com.sibvisions.visionx.DesktopLauncher <init> (Line: -1)
                                    OUTwaiting for server to start....LOG:  database system was shut down at 2014-12-02 00:34:19 CET
                                    LOG:  database system is ready to accept connections
                                    LOG:  autovacuum launcher started
                                     done
                                    server started
Apr 24, 2019 12:46:30 PM [ INFO        ] ERR                                                                                                  com.sibvisions.visionx.DesktopLauncher <init> (Line: -1)
Apr 24, 2019 12:46:30 PM [ INFO        ] Reset wait count, because state has changed!                                                         com.sibvisions.visionx.DesktopLauncher <init> (Line: -1)
Apr 24, 2019 12:46:31 PM [ SEVERE      ] org.postgresql.Driver connect
                                    Connection error:

                                    org.postgresql.util.PSQLException: Connection to 127.0.0.1:5432 refused. Check that the hostname and port are correct and that the postmaster is accepting TCP/IP connections.
                                       at org.postgresql.core.v3.ConnectionFactoryImpl.openConnectionImpl(ConnectionFactoryImpl.java:245)
                                       at org.postgresql.core.ConnectionFactory.openConnection(ConnectionFactory.java:49)
                                       at org.postgresql.jdbc.PgConnection.<init>(PgConnection.java:195)
                                       at org.postgresql.Driver.makeConnection(Driver.java:452)
                                       at org.postgresql.Driver.connect(Driver.java:254)
                                       at java.sql.DriverManager.getConnection(DriverManager.java:664)
                                       at java.sql.DriverManager.getConnection(DriverManager.java:208)
                                       at com.sibvisions.rad.persist.jdbc.DBAccess.open(DBAccess.java:2898)
                                       at com.sibvisions.visionx.DesktopLauncher.<init>(Unknown Source)
                                       at com.sibvisions.visionx.DesktopLauncher.main(Unknown Source)
                                       at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
                                       at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
                                       at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
                                       at java.lang.reflect.Method.invoke(Method.java:497)
                                       at com.sibvisions.visionx.Preloader.startDesktopLauncher(Unknown Source)
                                       at com.sibvisions.visionx.Preloader.<init>(Unknown Source)
 bosrocks  …  VisionX.app  Contents  Resources  /Applications/VisionX.app/Contents/Resources/runtime/bin/java -jar /Applications/VisionX.app/Contents/Resources/Java/visionxloader.jar
Apr 24, 2019 12:51:28 PM [ FINE        ] Initial WORK dir = /Applications/VisionX.app/Contents/Resources                                      com.sibvisions.visionx.DesktopLauncher main (Line: -1)
Apr 24, 2019 12:51:30 PM [ FINE        ] WORK dir = /Applications/VisionX.app/Contents/Resources                                              com.sibvisions.visionx.DesktopLauncher <init> (Line: -1)
Apr 24, 2019 12:51:30 PM [ FINE        ] RAD dir = /Applications/VisionX.app/Contents/Resources                                               com.sibvisions.visionx.DesktopLauncher <init> (Line: -1)
Apr 24, 2019 12:51:30 PM [ FINE        ] com.sibvisions.visionx.DesktopLauncher <init> (Line: -1)
                                    {[java.runtime.name, Java(TM) SE Runtime Environment], [sun.boot.library.path, /Applications/VisionX.app/Contents/Resources/runtime/jre/lib], [java.vm.version, 25.60-b23], [user.country.format, NL], [com.apple.mrj.application.apple.menu.about.name, VisionX], [gopherProxySet, false], [java.vm.vendor, Oracle Corporation], [java.vendor.url, http://java.oracle.com/], [path.separator, :], [java.vm.name, Java HotSpot(TM) 64-Bit Server VM], [file.encoding.pkg, sun.io], [user.country, GB], [sun.java.launcher, SUN_STANDARD], [sun.os.patch.level, unknown], [java.vm.specification.name, Java Virtual Machine Specification], [user.dir, /Applications/VisionX.app/Contents/Resources], [java.runtime.version, 1.8.0_60-b27], [java.awt.graphicsenv, sun.awt.CGraphicsEnvironment], [Configuration.basedir, /Applications/VisionX.app/Contents/Resources], [java.endorsed.dirs, /Applications/VisionX.app/Contents/Resources/runtime/jre/lib/endorsed], [os.arch, x86_64], [Server.instanceKey, juv3lnqu#1], [java.io.tmpdir, /var/folders/py/jdjvfjqs2k76wf4_jg_5g2r00000gn/T/], [line.separator,
                                    ], [java.vm.specification.vendor, Oracle Corporation], [os.name, Mac OS X], [apple.laf.useScreenMenuBar, true], [visionx.run.proxyPassword, ], [sun.jnu.encoding, UTF-8], [com.apple.mrj.application.live-resize, true], [java.library.path, /Users/bosrocks/Library/Java/Extensions:/Library/Java/Extensions:/Network/Library/Java/Extensions:/System/Library/Java/Extensions:/usr/lib/java:.], [sun.awt.enableExtraMouseButtons, true], [java.specification.name, Java Platform API Specification], [java.class.version, 52.0], [sun.management.compiler, HotSpot 64-Bit Tiered Compilers], [os.version, 10.14.3], [http.nonProxyHosts, local|*.local|169.254/16|*.169.254/16], [user.home, /Users/bosrocks], [user.timezone, Europe/Amsterdam], [java.awt.printerjob, sun.lwawt.macosx.CPrinterJob], [visionx.run.proxyPort, 3128], [file.encoding, UTF-8], [java.specification.version, 1.8], [Server.systemIdentifier, /Applications/VisionX.app/Contents/Resources], [java.class.path, /Applications/VisionX.app/Contents/Resources/Java/visionxloader.jar], [user.name, bosrocks], [com.apple.macos.smallTabs, true], [visionx.run.proxyUsern, ], [java.vm.specification.version, 1.8], [sun.java.command, /Applications/VisionX.app/Contents/Resources/Java/visionxloader.jar], [java.home, /Applications/VisionX.app/Contents/Resources/runtime/jre], [sun.arch.data.model, 64], [com.apple.mrj.application.growbox.intrudes, false], [user.language, en], [java.specification.vendor, Oracle Corporation], [awt.toolkit, sun.lwawt.macosx.LWCToolkit], [java.vm.info, mixed mode], [java.version, 1.8.0_60], [java.ext.dirs, /Users/bosrocks/Library/Java/Extensions:/Applications/VisionX.app/Contents/Resources/runtime/jre/lib/ext:/Library/Java/Extensions:/Network/Library/Java/Extensions:/System/Library/Java/Extensions:/usr/lib/java], [sun.boot.class.path, /Applications/VisionX.app/Contents/Resources/runtime/jre/lib/resources.jar:/Applications/VisionX.app/Contents/Resources/runtime/jre/lib/rt.jar:/Applications/VisionX.app/Contents/Resources/runtime/jre/lib/sunrsasign.jar:/Applications/VisionX.app/Contents/Resources/runtime/jre/lib/jsse.jar:/Applications/VisionX.app/Contents/Resources/runtime/jre/lib/jce.jar:/Applications/VisionX.app/Contents/Resources/runtime/jre/lib/charsets.jar:/Applications/VisionX.app/Contents/Resources/runtime/jre/lib/jfr.jar:/Applications/VisionX.app/Contents/Resources/runtime/jre/classes], [java.vendor, Oracle Corporation], [file.separator, /], [java.vendor.url.bug, http://bugreport.sun.com/bugreport/], [sun.font.fontmanager, sun.font.CFontManager], [sun.io.unicode.encoding, UnicodeBig], [sun.cpu.endian, little], [visionx.run.proxyEnabled, false], [socksNonProxyHosts, local|*.local|169.254/16|*.169.254/16], [visionx.run.proxyHost, ], [ftp.nonProxyHosts, local|*.local|169.254/16|*.169.254/16], [sun.cpu.isalist, ]}
pg_ctl: PID file "/Applications/VisionX.app/Contents/Resources/database/data/postmaster.pid" does not exist
Is server running?
Apr 24, 2019 12:51:30 PM [ INFO        ] OUT                                                                                                  com.sibvisions.visionx.DesktopLauncher <init> (Line: -1)
Apr 24, 2019 12:51:30 PM [ INFO        ] ERR                                                                                                  com.sibvisions.visionx.DesktopLauncher <init> (Line: -1)
Apr 24, 2019 12:51:30 PM [ INFO        ] Reset wait count, because state has changed!                                                         com.sibvisions.visionx.DesktopLauncher <init> (Line: -1)
Apr 24, 2019 12:51:30 PM [ INFO        ] OUT                                                                                                  com.sibvisions.visionx.DesktopLauncher <init> (Line: -1)
Apr 24, 2019 12:51:30 PM [ INFO        ] ERR                                                                                                  com.sibvisions.visionx.DesktopLauncher <init> (Line: -1)
waiting for server to start....LOG:  database system was shut down at 2019-04-24 12:46:31 CEST
LOG:  database system is ready to accept connections
LOG:  autovacuum launcher started
Error: Could not find or load main class com.sibvisions.visionx.TomcatStarter
Apr 24, 2019 12:51:31 PM [ INFO        ] com.sibvisions.visionx.DesktopLauncher <init> (Line: -1)
                                    OUTwaiting for server to start....LOG:  database system was shut down at 2019-04-24 12:46:31 CEST
                                    LOG:  database system is ready to accept connections
                                    LOG:  autovacuum launcher started
Apr 24, 2019 12:51:31 PM [ INFO        ] ERR                                                                                                  com.sibvisions.visionx.DesktopLauncher <init> (Line: -1)
Apr 24, 2019 12:51:31 PM [ INFO        ] Reset wait count, because state has changed!                                                         com.sibvisions.visionx.DesktopLauncher <init> (Line: -1)
 done
server started
Apr 24, 2019 12:51:31 PM [ SEVERE      ] org.postgresql.Driver connect
                                    Connection error:

                                    org.postgresql.util.PSQLException: Connection to 127.0.0.1:5432 refused. Check that the hostname and port are correct and that the postmaster is accepting TCP/IP connections.
                                       at org.postgresql.core.v3.ConnectionFactoryImpl.openConnectionImpl(ConnectionFactoryImpl.java:245)
                                       at org.postgresql.core.ConnectionFactory.openConnection(ConnectionFactory.java:49)
                                       at org.postgresql.jdbc.PgConnection.<init>(PgConnection.java:195)
                                       at org.postgresql.Driver.makeConnection(Driver.java:452)
                                       at org.postgresql.Driver.connect(Driver.java:254)
                                       at java.sql.DriverManager.getConnection(DriverManager.java:664)
                                       at java.sql.DriverManager.getConnection(DriverManager.java:208)
                                       at com.sibvisions.rad.persist.jdbc.DBAccess.open(DBAccess.java:2898)
                                       at com.sibvisions.visionx.DesktopLauncher.<init>(Unknown Source)
                                       at com.sibvisions.visionx.DesktopLauncher.main(Unknown Source)
                                       at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
                                       at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
                                       at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
                                       at java.lang.reflect.Method.invoke(Method.java:497)
                                       at com.sibvisions.visionx.Preloader.startDesktopLauncher(Unknown Source)
                                       at com.sibvisions.visionx.Preloader.<init>(Unknown Source)
                                       at com.sibvisions.visionx.Preloader.main(Unknown Source)
                                    Caused by: java.net.ConnectException: Connection refused
                                       at java.net.PlainSocketImpl.socketConnect(Native Method)
                                       at java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:350)
                                       at java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:206)
                                       at java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:188)
                                       at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:392)
                                       at java.net.Socket.connect(Socket.java:589)
                                       at org.postgresql.core.PGStream.<init>(PGStream.java:69)
                                       at org.postgresql.core.v3.ConnectionFactoryImpl.openConnectionImpl(ConnectionFactoryImpl.java:156)
                                       ... 16 more
Apr 24, 2019 12:51:31 PM [ SEVERE      ] com.sibvisions.visionx.DesktopLauncher <init> (Line: -1)
                                    javax.rad.persist.DataSourceException: Connection failed! - jdbc:postgresql://127.0.0.1:5432/visionx; Username=visionx; Password set
                                       at com.sibvisions.rad.persist.jdbc.DBAccess.open(DBAccess.java:2937)
                                       at com.sibvisions.visionx.DesktopLauncher.<init>(Unknown Source)
                                       at com.sibvisions.visionx.DesktopLauncher.main(Unknown Source)
                                       at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
                                       at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
                                       at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
                                       at java.lang.reflect.Method.invoke(Method.java:497)
                                       at com.sibvisions.visionx.Preloader.startDesktopLauncher(Unknown Source)
                                       at com.sibvisions.visionx.Preloader.<init>(Unknown Source)
                                       at com.sibvisions.visionx.Preloader.main(Unknown Source)
                                    Caused by: java.sql.SQLException: PostgreSQL-08001: Connection to 127.0.0.1:5432 refused. Check that the hostname and port are correct and that the postmaster is accepting TCP/IP connections.
                                       at org.postgresql.core.v3.ConnectionFactoryImpl.openConnectionImpl(ConnectionFactoryImpl.java:245)
                                       at org.postgresql.core.ConnectionFactory.openConnection(ConnectionFactory.java:49)
                                       at org.postgresql.jdbc.PgConnection.<init>(PgConnection.java:195)
                                       at org.postgresql.Driver.makeConnection(Driver.java:452)
                                       at org.postgresql.Driver.connect(Driver.java:254)
                                       at java.sql.DriverManager.getConnection(DriverManager.java:664)
                                       at java.sql.DriverManager.getConnection(DriverManager.java:208)
                                       at com.sibvisions.rad.persist.jdbc.DBAccess.open(DBAccess.java:2898)
                                       ... 9 more
                                    Caused by: java.net.ConnectException: Connection refused
                                       at java.net.PlainSocketImpl.socketConnect(Native Method)
                                       at java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:350)
                                       at java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:206)
                                       at java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:188)
                                       at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:392)
                                       at java.net.Socket.connect(Socket.java:589)
                                       at org.postgresql.core.PGStream.<init>(PGStream.java:69)
                                       at org.postgresql.core.v3.ConnectionFactoryImpl.openConnectionImpl(ConnectionFactoryImpl.java:156)
                                       ... 16 more
waiting for server to shut down.... done
server stopped
Apr 24, 2019 12:51:44 PM [ SEVERE      ] Application is not initialized! Can't put object with name: PRELOADER                                com.sibvisions.visionx.DesktopLauncher putObject (Line: -1)



[Support@SIB]

Strange because a running DB Server shouldn't be a problem. VisionX checks the free port...
Anyway.

The DB is up and running, but it's not possible to connect!

Is it possible to remove VisionX.app and install it again? Maybe there's something wrong with data directory?

[jeffreybos]

I've tried that several times...
I'll try it on a different macbook.

[Support@SIB]

We tried to reproduce your problem with pre-installed PostgreSQL 10. The db is running on port 5432 and VisionX starts without problems. It sets the port of the embedded db to 5433.

We are curious if it works with another system.

[Support@SIB]

Firewall?