Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Problems connecting to the DIY client #207

Open
Sineos opened this issue Oct 22, 2022 · 18 comments
Open

Problems connecting to the DIY client #207

Sineos opened this issue Oct 22, 2022 · 18 comments

Comments

@Sineos
Copy link

Sineos commented Oct 22, 2022

I would like to setup SEPIA (framework and DIY client) on a Tinkerboard 2 and a Jabra Speak 510 as audio device.

It seems to be working "half way":

  • I can log in to the web client and control hub
  • Web client text to speech and "hey sepia" works
  • Connecting to clexi works (green LED)
    • CLEXI server says welcome. Info: {"version":"CLEXI Node.js server v0.9.2","xtensions":{"clexi-broadcaster":{"active":true},"clexi-http-events":{"active":true},"runtime-commands":{"active":true},"gpio-interface":{"active":true}}}
  • http://192.168.178.128:9090/clexi/index.html works
  • http://192.168.178.128:9090/clexi/sepia/index.html works
  • Mic and playback test with arecord and aplay is working for the Jabra
  • Reboot is finished with "Hello friend, I'll be ...." output

What is not working:

  • ping all does not return the o1 client
  • logging in does not work from the control hub's terminal

Only indication in the logs:

sepia@tinkerboard-2 ~ $  cat clexi/log-clexi.out
Local date/time at start: 10/22/2022, 1:04:53 PM
Server with ID 'clexi-123' running at: http://127.0.0.1:8080
Hostname: localhost - SSL: false
CLEXI Xtensions loaded: 4
{"level":50,"time":1666443896775,"pid":2481,"hostname":"tinkerboard-2","msg":"Tried to broadcast to unauthorized client. Client should be disconnected already!","v":1}
{"level":50,"time":1666443920201,"pid":2481,"hostname":"tinkerboard-2","msg":"Tried to broadcast to unauthorized client. Client should be disconnected already!","v":1}
{"level":50,"time":1666444023362,"pid":2481,"hostname":"tinkerboard-2","msg":"Tried to broadcast to unauthorized client. Client should be disconnected already!","v":1}
{"level":50,"time":1666444168624,"pid":2481,"hostname":"tinkerboard-2","msg":"Tried to broadcast to unauthorized client. Client should be disconnected already!","v":1}

I also tried to build the dev branches but ended up the same. Any pointer would be appreciated.

@fquirin
Copy link
Contributor

fquirin commented Oct 28, 2022

Hi @Sineos , sorry for the late reply. I was a bit under stress the last days.

192.168.178.128

This is the IP of the DIY client?
Are you running the Control-HUB from localhost or a non SSL address? Just making sure because if you run the Control-HUB via SSL (https://..) you can get a "mixed-content" error when trying to connect to a non-SSL IP.

Reboot is finished with "Hello friend, I'll be ...."

Ending with "ready for setup"? :-)
Can you check the ~/sepia-client/log-run.out for any errors plz.

{"level":50,"time":1666443896775,"pid":2481,"hostname":"tinkerboard-2","msg":"Tried to broadcast to unauthorized client. Client should be disconnected already!","v":1}

That look weird, I've never seen that 🤔 . Maybe it doesn't matter though since the server seems to be running.

@Sineos
Copy link
Author

Sineos commented Oct 28, 2022

Hi @fquirin, thanks for coming back to this.

This is the IP of the DIY client?
Are you running the Control-HUB from localhost or a non SSL address? Just making sure because if you run the Control-HUB via SSL (https://..) you can get a "mixed-content" error when trying to connect to a non-SSL IP.

DIY client and control hub are both running on the same physical machine, a Asus Tinkerboard 2S with 4GB RAM.
All connection attempts to the o1 DIY client were made from non-SSL connections. In my attempts so far I have not been able to make the wss work. The ws connection is established as indicated with the green LED

Ending with "ready for setup"? :-)
Can you check the ~/sepia-client/log-run.out for any errors plz.

Ending with "I'll be right there"
I checked the other logs and saw no errors or anything weird, except the log-clexi.out entries.

@fquirin
Copy link
Contributor

fquirin commented Oct 28, 2022

Ending with "I'll be right there"

That indicates that the client runs into an error and doesn't actually start. If that's the case you should see something in the mentioned log file ~/sepia-client/log-run.out. Can you try once more to start it and then immediately after check the log?

@Sineos
Copy link
Author

Sineos commented Oct 29, 2022

sepia@tinkerboard-2:~$ cat /home/sepia/clexi/log-clexi.out
Local date/time at start: 10/29/2022, 6:01:51 PM
Server with ID 'clexi-123' running at: http://127.0.0.1:8080
Hostname: localhost - SSL: false
CLEXI Xtensions loaded: 4
sepia@tinkerboard-2:~$ cat /home/sepia/sepia-client/log-run.out
Last run attempt: 2022_10_29_18:01:44 - via: run.sh
2022_10_29_18:01:44 - Found sound-cards to play audio: 2
2022_10_29_18:01:44 - Found sound-cards to record audio: 2
2022_10_29_18:01:45 - Pulseaudio: unloaded module 'module-suspend-on-idle'
2022_10_29_18:01:45 - Notifying user (audio message) ...
2022_10_29_18:01:49 - Starting CLEXI ...
2022_10_29_18:01:49 - CLEXI ready
2022_10_29_18:01:51 - Preparing Chromium ...
2022_10_29_18:01:51 - Setting default preferences for Chromium (permissions: mic, location, notifications)
2022_10_29_18:01:51 - Starting Chromium - Mode: 1 - Is RPi4: 0
sepia@tinkerboard-2:~$ cat /home/sepia/sepia-home/sepia-assist-server/log.out
-----------------------------------------
      ___    ___   ___   ___   ___
     |___   |___  |___]   |   |___|
     ____|. |___. |    . _|_. |   |.

    https://sepia-framework.github.io

2022-10-29 18:03:08 LOG - Security policy and manager set.
2022-10-29 18:03:08 LOG - Security sandbox loaded with 6 entries.
2022-10-29 18:03:08 LOG - JAVA_HOME: /usr/lib/jvm/java-11-openjdk-arm64
2022-10-29 18:03:08 LOG - Loading settings from Xtensions/assist.custom.properties... done.
2022-10-29 18:03:08 LOG - --- Running SEPIA-Assist-API with CUSTOM settings ---
2022-10-29 18:03:09 [main] INFO StaticFilesConfiguration - External StaticResourceHandler configured with folder = Xtensions/WebContent
2022-10-29 18:03:09 LOG - Web-server is active and uses folder: Xtensions/WebContent - CORS (files): *
2022-10-29 18:03:09 LOG - Web-server MIME type overwrite: mp4=video/mp4
2022-10-29 18:03:09 LOG - Web-server MIME type overwrite: mp3=audio/mpeg
2022-10-29 18:03:09 LOG - Elasticsearch: found 14 of 14 mapped indices. All good.
2022-10-29 18:03:09 LOG - Loading answers from files 'Xtensions/Assistant/answers/answers_*' for 2 languages...
2022-10-29 18:03:10 LOG - Finished loading answers module in 787 ms.
2022-10-29 18:03:10 LOG - Loading commands from files 'Xtensions/Assistant/commands/teachIt_*' for 2 languages...
2022-10-29 18:03:10 LOG - Finished loading 143(132) predefined commands in 216 ms.
2022-10-29 18:03:10 LOG - Loading commands from files 'Xtensions/Assistant/commands/chats_*' for 2 languages...
2022-10-29 18:03:11 LOG - Finished loading 777(732) predefined chats in 403 ms.
2022-10-29 18:03:11 LOG - Loaded NLU interpretation-chain with 7 steps: [getPersonalCommand, getFixCommandsExactMatch, getChatSmallTalkMatch, getPublicDbSentenceMatch, getKeywordAnalyzerResult, tryPersonalCommandAsFallback, tryChatSmallTalkAsFallback]
2022-10-29 18:03:11 LOG - Running TTS module setup ...
2022-10-29 18:03:13 ERROR - TTS module - MaryTTS server (http://127.0.0.1:59125) did not answer or had no voices installed. Support has been deactivated for now.
2022-10-29 18:03:13 LOG - TTS module - Added 6 'pico' voices.
2022-10-29 18:03:13 LOG - TTS module - Added 5 'espeak' voices.
2022-10-29 18:03:13 LOG - TTS module setup has cleaned up '0' leftover files.
2022-10-29 18:03:13 LOG - TTS module setup successful.
2022-10-29 18:03:13 LOG - Services:News - Loaded 53 outlets with groups for 2 languages from: Xtensions/ServiceProperties/news-outlets.json
2022-10-29 18:03:13 LOG - RssFeedReader - backup restored with 53 feeds. Last modified: 2022.10.29_16:16:49
2022-10-29 18:03:13 LOG - Active workers: 2
2022-10-29 18:03:13 LOG - loading webSocket settings from Xtensions/assist.custom.properties... done.
2022-10-29 18:03:13 LOG - finished loading services mapping for 34 interview modules.
2022-10-29 18:03:13 LOG - Testing services for supported commands...
2022-10-29 18:03:13 LOG - 34 services for 34 commands: All valid!
2022-10-29 18:03:13 LOG - Testing parameters handlers...
2022-10-29 18:03:13 LOG - Parameters:RadioStation - Loaded 92 station arrays with 13 playlists and 7 collections from: Xtensions/ServiceProperties/radio-stations.json
2022-10-29 18:03:13 LOG - ParameterTools - Method 'SmartDevice#deviceNamesScan' has ID: 1
2022-10-29 18:03:13 LOG - 60 parameters: All valid!
2022-10-29 18:03:14 LOG - Server token validated
2022-10-29 18:03:14 LOG - Assistant token validated
2022-10-29 18:03:14 LOG - Added 'admin' and 'assistant' to protected accounts list.
2022-10-29 18:03:14 LOG - Starting Assistant-API server v2.7.0 (custom)
2022-10-29 18:03:14 LOG - date: 29.10.2022 - 16:03:14 - GMT
2022-10-29 18:03:14 LOG - server running on port 20721
2022-10-29 18:03:14 [Thread-3] INFO log - Logging initialized @6906ms to org.eclipse.jetty.util.log.Slf4jLog
2022-10-29 18:03:15 [Thread-3] INFO EmbeddedJettyServer - == Spark has ignited ...
2022-10-29 18:03:15 [Thread-3] INFO EmbeddedJettyServer - >> Listening on 0.0.0.0:20721
2022-10-29 18:03:15 [Thread-3] INFO Server - jetty-9.4.48.v20220622; built: 2022-06-21T20:42:25.880Z; git: 6b67c5719d1f4371b33655ff2d047d24e171e49a; jvm 11.0.16+8-post-Ubuntu-0ubuntu122.04
2022-10-29 18:03:15 [Thread-3] INFO session - DefaultSessionIdManager workerName=node0
2022-10-29 18:03:15 [Thread-3] INFO session - No SessionScavenger set, using defaults
2022-10-29 18:03:15 [Thread-3] INFO session - node0 Scavenging every 660000ms
2022-10-29 18:03:15 [Thread-3] INFO AbstractConnector - Started ServerConnector@1e19ca37{HTTP/1.1, (http/1.1)}{0.0.0.0:20721}
2022-10-29 18:03:15 [Thread-3] INFO Server - Started @7374ms
2022-10-29 18:03:19 LOG - Clients: Checking connection to socket messenger...
2022-10-29 18:03:19 LOG - Clients: Socket messenger found.
2022-10-29 18:03:21 [Thread-2] INFO SocketClientHandler - WEBSOCKET-CLIENT - Connecting to: ws://localhost:20723/messages/
2022-10-29 18:03:21 [WebSocketClient@1918478467-39] INFO SepiaSocketClient - WEBSOCKET-CLIENT: Got connection
2022-10-29 18:03:21 [Thread-24] INFO SepiaSocketClient - WEBSOCKET-CLIENT: Authenticating user: 'uid1005'
2022-10-29 18:03:36 LOG - USER uid1003 used SERVICE timer - TS: 1667059416716 - LANGUAGE: en - CLIENT: b1_chrome_browser_v0.25.0 - API: v2.7.0
2022-10-29 18:03:36 LOG - USER uid1003 used SERVICE events_personal - TS: 1667059416683 - LANGUAGE: en - CLIENT: b1_chrome_browser_v0.25.0 - API: v2.7.0
2022-10-29 18:03:36 LOG - USER uid1003 used SERVICE timer - TS: 1667059416716 - LANGUAGE: en - CLIENT: b1_chrome_browser_v0.25.0 - API: v2.7.0
2022-10-29 18:03:55 LOG - Whitelist user added! User: [email protected] added by: uid1003
2022-10-29 18:04:02 LOG - User 'uid1003' requested creation of new user: [email protected]
2022-10-29 18:04:03 LOG - Status for new user data - uid1007 - cmd-mappings-code: 0
2022-10-29 18:04:04 LOG - Direct-write: new user successfully created - GUUID: uid1007, EMAIL: [email protected]
2022-10-29 18:04:12 LOG - User 'uid1003' requested roles of user: uid1007
2022-10-29 18:04:13 LOG - JSON-Backup-worker: START
2022-10-29 18:04:13 LOG - JSON-Backup-worker: Data has been stored! (1 time(s)) It took (ms): 171, average (ms): 10000
2022-10-29 18:04:30 LOG - User 'uid1003' set new roles for user: uid1007 - Roles: ["user","smarthomeadmin","developer"]

sepia@tinkerboard-2:~$ cat /home/sepia/sepia-home/sepia-websocket-server-java/log.out
-----------------------------------------
      ___    ___   ___   ___   ___
     |___   |___  |___]   |   |___|
     ____|. |___. |    . _|_. |   |.

    https://sepia-framework.github.io

2022-10-29 18:03:16 [main] INFO StartWebSocketServer - -- Running SEPIA-Websocket-Server with CUSTOM settings --
2022-10-29 18:03:16 [main] INFO SocketConfig - loading settings from Xtensions/websocket.custom.properties... done.
2022-10-29 18:03:16 [main] INFO StaticFilesConfiguration - StaticResourceHandler configured with folder = /public
2022-10-29 18:03:16 [main] INFO StartWebSocketServer - Received cluster-data from AssistAPI after 232ms
2022-10-29 18:03:16 LOG - Expecting assistant: Sepia (id: uid1005)
2022-10-29 18:03:17 [Thread-0] INFO log - Logging initialized @1368ms to org.eclipse.jetty.util.log.Slf4jLog
2022-10-29 18:03:17 [Thread-0] INFO EmbeddedJettyServer - == Spark has ignited ...
2022-10-29 18:03:17 [Thread-0] INFO EmbeddedJettyServer - >> Listening on 0.0.0.0:20723
2022-10-29 18:03:17 [Thread-0] INFO Server - jetty-9.4.48.v20220622; built: 2022-06-21T20:42:25.880Z; git: 6b67c5719d1f4371b33655ff2d047d24e171e49a; jvm 11.0.16+8-post-Ubuntu-0ubuntu122.04
2022-10-29 18:03:17 [Thread-0] INFO session - DefaultSessionIdManager workerName=node0
2022-10-29 18:03:17 [Thread-0] INFO session - No SessionScavenger set, using defaults
2022-10-29 18:03:17 [Thread-0] INFO session - node0 Scavenging every 660000ms
2022-10-29 18:03:17 [Thread-0] INFO ContextHandler - Started o.e.j.s.ServletContextHandler@50c9e76c{/,null,AVAILABLE}
2022-10-29 18:03:17 [Thread-0] INFO AbstractConnector - Started ServerConnector@3e270850{HTTP/1.1, (http/1.1)}{0.0.0.0:20723}
2022-10-29 18:03:17 [Thread-0] INFO Server - Started @2014ms
2022-10-29 18:03:17 [main] INFO ChannelsElasticsearchDb - Loaded 3 channels from DB.
2022-10-29 18:03:17 LOG - Welcome to the SEPIA Chat-Server v1.4.0 (custom) - port: 20723
2022-10-29 18:03:17 LOG - Date: 29.10.2022 - 16:03:17 - GMT
2022-10-29 18:03:17 LOG - Initialization complete, lets go!
2022-10-29 18:03:20 [qtp700412710-16] WARN AuthenticationAssistAPI - Authentication failed for user 'uid1003' - original msg.: {"result":"fail","error":"401 not authorized","HTTP_REST_SUCCESS":true}
2022-10-29 18:03:21 [qtp700412710-16] INFO SepiaAuthenticationHandler - Authenticated: uid1005, roles: ["user","assistant"], deviceId: serv1
2022-10-29 18:03:35 [qtp700412710-18] INFO SepiaAuthenticationHandler - Authenticated: uid1003, roles: ["user","tester","translator","developer","seniordev","chiefdev","superuser"], deviceId: b1
2022-10-29 18:03:35 [qtp700412710-18] INFO ChatsElasticsearchDb - getAllChannelsWithMissedMassegesForUser - restored data for user ID 'uid1003' in 174ms.

I cannot see anything wrong in the logs.

From the hub I can connect to the clexi instance (green LED / ws connection) but never get any response.

Broadcaster response: "sent"
Broadcaster event: {"broadcast":{"name":"sepia-client","data":{"deviceId":"o1","call":"test"}}}
Broadcaster response: "sent"
Broadcaster event: {"broadcast":{"name":"sepia-client","data":{"ping":"all"}}}
CLEXI server says welcome. Info: {"version":"CLEXI Node.js server v0.9.2","xtensions":{"clexi-broadcaster":{"active":true},"clexi-http-events":{"active":true},"runtime-commands":{"active":true},"gpio-interface":{"active":true}}}
CLEXI connected
CLEXI connecting ...
- REMOTE MESSAGES -

After reboot, I just get the message "I'll be right there".

@fquirin
Copy link
Contributor

fquirin commented Oct 31, 2022

The logs look good indeed, I can't see any problems. Actually I'm a little bit surprised, are you using a pre-release build of v2.7.0? 😁

There is one thing that the logs don't show and that is if Chromium itself crashed after this line:

2022_10_29_18:01:51 - Starting Chromium - Mode: 1 - Is RPi4: 0

What you can try to get more info is to activate the experimental Chromium log. Open the ~/sepia-client/run.sh and switch the comment on these two lines:

LOG_CLIENT="/dev/null"
#LOG_CLIENT="$(dirname "$SCRIPT_PATH")""/log-client.out"

If you restart the client and check the /home/sepia/sepia-client/log-run.out log again you then hopefully see additional entries coming from Chromium itself.
Maybe the tinkerboard needs the "RPi4: 1" flag to run successfully. If a RPi4 is detected the Chromium run command has an additional --disable-features=VizDisplayCompositor flag.

@Sineos
Copy link
Author

Sineos commented Oct 31, 2022

Thanks for supporting this. Appreciated.

Actually I'm a little bit surprised, are you using a pre-release build of v2.7.0?

I started off with the release version and ran into the same problem as we are discussing now. Switching to dev was an attempt to see if it changes anything

If you restart the client and check the /home/sepia/sepia-client/log-run.out log again you then hopefully see additional entries coming from Chromium itself.

sepia@tinkerboard-2:~$ cat /home/sepia/sepia-client/log-client.out
/usr/bin/chromium-browser: 12: xdg-settings: not found
update.go:85: cannot change mount namespace according to change mount (/var/lib/snapd/hostfs/usr/share/cups/doc-root /usr/share/cups/doc-root none bind,ro 0 0): cannot create directory "/usr/share/cups/doc-root": permission denied
update.go:85: cannot change mount namespace according to change mount (/var/lib/snapd/hostfs/usr/share/gimp/2.0/help /usr/share/gimp/2.0/help none bind,ro 0 0): cannot create directory "/usr/share/gimp/2.0": permission denied
update.go:85: cannot change mount namespace according to change mount (/var/lib/snapd/hostfs/usr/share/gtk-doc /usr/share/gtk-doc none bind,ro 0 0): cannot open directory "/var/lib": permission denied
update.go:85: cannot change mount namespace according to change mount (/var/lib/snapd/hostfs/usr/share/libreoffice/help /usr/share/libreoffice/help none bind,ro 0 0): cannot create directory "/usr/share/libreoffice/help": permission denied
update.go:85: cannot change mount namespace according to change mount (/var/lib/snapd/hostfs/usr/share/xubuntu-docs /usr/share/xubuntu-docs none bind,ro 0 0): cannot open directory "/var/lib": permission denied
/bin/bash: warning: setlocale: LC_ALL: cannot change locale (en_US.UTF-8)
[2407:2407:1031/104338.492462:ERROR:gl_surface_egl.cc(324)] No suitable EGL configs found.
[2407:2407:1031/104338.505413:ERROR:gl_context_egl.cc(143)] eglGetConfigAttrib failed with error EGL_BAD_CONFIG
[2407:2407:1031/104338.514952:ERROR:gl_surface_egl.cc(324)] No suitable EGL configs found.
[2407:2407:1031/104338.515334:ERROR:gl_surface_egl.cc(1107)] eglCreatePbufferSurface failed with error EGL_BAD_CONFIG
[2407:2407:1031/104338.515544:ERROR:gpu_info_collector.cc(80)] gl::GLContext::CreateOffscreenGLSurface failed
[2407:2407:1031/104338.515812:ERROR:gpu_info_collector.cc(348)] Could not create surface for info collection.
[2407:2407:1031/104338.515982:ERROR:gpu_init.cc(86)] CollectGraphicsInfo failed.
[2407:2407:1031/104338.520118:ERROR:viz_main_impl.cc(186)] Exiting GPU process due to errors during initialization
[2594:2594:1031/104339.233441:ERROR:gl_surface_egl.cc(324)] No suitable EGL configs found.
[2594:2594:1031/104339.233828:ERROR:gl_context_egl.cc(143)] eglGetConfigAttrib failed with error EGL_BAD_CONFIG
[2594:2594:1031/104339.234134:ERROR:gl_surface_egl.cc(324)] No suitable EGL configs found.
[2594:2594:1031/104339.234374:ERROR:gl_surface_egl.cc(1107)] eglCreatePbufferSurface failed with error EGL_BAD_CONFIG
[2594:2594:1031/104339.234513:ERROR:gpu_info_collector.cc(80)] gl::GLContext::CreateOffscreenGLSurface failed
[2594:2594:1031/104339.234769:ERROR:gpu_info_collector.cc(348)] Could not create surface for info collection.
[2594:2594:1031/104339.234887:ERROR:gpu_init.cc(86)] CollectGraphicsInfo failed.
[2594:2594:1031/104339.239146:ERROR:viz_main_impl.cc(186)] Exiting GPU process due to errors during initialization
[2620:2620:1031/104339.793791:ERROR:gpu_memory_buffer_support_x11.cc(44)] dri3 extension not supported.

Following the first message, I did apt-get install xdg-utils. This gets rid of the first error but the rest remains:

sepia@tinkerboard-2:~$ cat /home/sepia/sepia-client/log-client.out
update.go:85: cannot change mount namespace according to change mount (/var/lib/snapd/hostfs/usr/share/cups/doc-root /usr/share/cups/doc-root none bind,ro 0 0): cannot create directory "/usr/share/cups/doc-root": permission denied
update.go:85: cannot change mount namespace according to change mount (/var/lib/snapd/hostfs/usr/share/gimp/2.0/help /usr/share/gimp/2.0/help none bind,ro 0 0): cannot create directory "/usr/share/gimp/2.0": permission denied
update.go:85: cannot change mount namespace according to change mount (/var/lib/snapd/hostfs/usr/share/gtk-doc /usr/share/gtk-doc none bind,ro 0 0): cannot open directory "/var/lib": permission denied
update.go:85: cannot change mount namespace according to change mount (/var/lib/snapd/hostfs/usr/share/libreoffice/help /usr/share/libreoffice/help none bind,ro 0 0): cannot create directory "/usr/share/libreoffice/help": permission denied
update.go:85: cannot change mount namespace according to change mount (/var/lib/snapd/hostfs/usr/share/xubuntu-docs /usr/share/xubuntu-docs none bind,ro 0 0): cannot open directory "/var/lib": permission denied
/bin/bash: warning: setlocale: LC_ALL: cannot change locale (en_US.UTF-8)
[2627:2627:1031/104907.837441:ERROR:gl_surface_egl.cc(324)] No suitable EGL configs found.
[2627:2627:1031/104907.846156:ERROR:gl_context_egl.cc(143)] eglGetConfigAttrib failed with error EGL_BAD_CONFIG
[2627:2627:1031/104907.847131:ERROR:gl_surface_egl.cc(324)] No suitable EGL configs found.
[2627:2627:1031/104907.847331:ERROR:gl_surface_egl.cc(1107)] eglCreatePbufferSurface failed with error EGL_BAD_CONFIG
[2627:2627:1031/104907.847437:ERROR:gpu_info_collector.cc(80)] gl::GLContext::CreateOffscreenGLSurface failed
[2627:2627:1031/104907.847526:ERROR:gpu_info_collector.cc(348)] Could not create surface for info collection.
[2627:2627:1031/104907.847621:ERROR:gpu_init.cc(86)] CollectGraphicsInfo failed.
[2627:2627:1031/104907.852013:ERROR:viz_main_impl.cc(186)] Exiting GPU process due to errors during initialization
[2668:2668:1031/104908.633828:ERROR:gl_surface_egl.cc(324)] No suitable EGL configs found.
[2668:2668:1031/104908.634282:ERROR:gl_context_egl.cc(143)] eglGetConfigAttrib failed with error EGL_BAD_CONFIG
[2668:2668:1031/104908.634589:ERROR:gl_surface_egl.cc(324)] No suitable EGL configs found.
[2668:2668:1031/104908.634748:ERROR:gl_surface_egl.cc(1107)] eglCreatePbufferSurface failed with error EGL_BAD_CONFIG
[2668:2668:1031/104908.635219:ERROR:gpu_info_collector.cc(80)] gl::GLContext::CreateOffscreenGLSurface failed
[2668:2668:1031/104908.635658:ERROR:gpu_info_collector.cc(348)] Could not create surface for info collection.
[2668:2668:1031/104908.636186:ERROR:gpu_init.cc(86)] CollectGraphicsInfo failed.
[2668:2668:1031/104908.642297:ERROR:viz_main_impl.cc(186)] Exiting GPU process due to errors during initialization
[2694:2694:1031/104909.205709:ERROR:gpu_memory_buffer_support_x11.cc(44)] dri3 extension not supported.

Maybe the tinkerboard needs the "RPi4: 1" flag to run successfully. If a RPi4 is detected the Chromium run command has an additional --disable-features=VizDisplayCompositor flag.

Where do I set this?
I tried
https://github.com/SEPIA-Framework/sepia-installation-and-setup/blob/58c9f6788858d6eaf1901b025a687211935ac1cb/sepia-client-installation/rpi/sepia-client/run.sh#L145
but this apparently did not work:

sepia@tinkerboard-2:~/sepia-client$ bash run.sh
Starting CLEXI server
RPi model: Asus Tinker Board 2/2S - Is Pi4: 0
Running SEPIA-Client in 'headless' mode. Use SEPIA Control-HUB to connect and control via remote terminal, default URL is: ws://[IP]:9090/clexi

@fquirin
Copy link
Contributor

fquirin commented Nov 1, 2022

I started off with the release version and ran into the same problem as we are discussing now. Switching to dev was an attempt to see if it changes anything

Did you build it with the included scripts? It's nice to see that people actually build their own versions 😀 .

Following the first message, I did apt-get install xdg-utils. This gets rid of the first error but the rest remains: ...

The EGL error looks familiar, it might actually be the reason for the RPI4 flag below, if I remember correctly.

Where do I set this?

It is the right play, but you need to comment out the line below as well or it will be reset:

is_pi4=1
#case "$pi_model" in *"Pi 4"*) is_pi4=1;; *) is_pi4=0;; esac

@Sineos
Copy link
Author

Sineos commented Nov 1, 2022

It changes something but still no luck.

With is_pi4=1

sepia@tinkerboard-2:~$ cat /home/sepia/sepia-client/log-client.out
update.go:85: cannot change mount namespace according to change mount (/var/lib/snapd/hostfs/usr/share/cups/doc-root /usr/share/cups/doc-root none bind,ro 0 0): cannot create directory "/usr/share/cups/doc-root": permission denied
update.go:85: cannot change mount namespace according to change mount (/var/lib/snapd/hostfs/usr/share/gimp/2.0/help /usr/share/gimp/2.0/help none bind,ro 0 0): cannot create directory "/usr/share/gimp/2.0": permission denied
update.go:85: cannot change mount namespace according to change mount (/var/lib/snapd/hostfs/usr/share/gtk-doc /usr/share/gtk-doc none bind,ro 0 0): cannot open directory "/var/lib": permission denied
update.go:85: cannot change mount namespace according to change mount (/var/lib/snapd/hostfs/usr/share/libreoffice/help /usr/share/libreoffice/help none bind,ro 0 0): cannot create directory "/usr/share/libreoffice/help": permission denied
update.go:85: cannot change mount namespace according to change mount (/var/lib/snapd/hostfs/usr/share/xubuntu-docs /usr/share/xubuntu-docs none bind,ro 0 0): cannot open directory "/var/lib": permission denied
/bin/bash: warning: setlocale: LC_ALL: cannot change locale (en_US.utf8)
[2695:2695:1101/131114.550821:ERROR:viz_main_impl.cc(186)] Exiting GPU process due to errors during initialization
[2736:2736:1101/131115.145309:ERROR:viz_main_impl.cc(186)] Exiting GPU process due to errors during initialization
[2762:2762:1101/131115.681293:ERROR:gpu_memory_buffer_support_x11.cc(44)] dri3 extension not supported.
sepia@tinkerboard-2:~$ chromium --version
/bin/bash: warning: setlocale: LC_ALL: cannot change locale (en_US.utf8)
Chromium 106.0.5249.119 snap

With:

#NOTE: It seems there is a new fix for Chromium 98 required: '--use-gl=egl' (https://github.com/RPi-Distro/chromium-browser/issues/28)
default_chrome_flags="$default_chrome_flags --use-gl=egl"
sepia@tinkerboard-2:~$ cat /home/sepia/sepia-client/log-client.out
/bin/bash: warning: setlocale: LC_ALL: cannot change locale (en_US.UTF-8)
[20101:20101:1101/115946.234966:ERROR:gpu_init.cc(521)] Passthrough is not supported, GL is egl, ANGLE is
[20101:20101:1101/115946.277194:ERROR:gpu_memory_buffer_support_x11.cc(44)] dri3 extension not supported.

If I add the --headless flag to the chromium args, then I get a step further but also quits shortly after:

sepia@tinkerboard-2:~/sepia-client$ bash run.sh
Starting CLEXI server
RPi model: Asus Tinker Board 2/2S - Is Pi4: 1
Running SEPIA-Client in 'headless Pi4' mode. Use SEPIA Control-HUB to connect and control via remote terminal, default URL is: ws://[IP]:9090/clexi
Closed SEPIA-Client. Cu later :-)
sepia@tinkerboard-2:~/sepia-client$ nano run.sh
sepia@tinkerboard-2:~/sepia-client$ bash run.sh
Restarting CLEXI server
RPi model: Asus Tinker Board 2/2S - Is Pi4: 0
Running SEPIA-Client in 'headless' mode. Use SEPIA Control-HUB to connect and control via remote terminal, default URL is: ws://[IP]:9090/clexi
Closed SEPIA-Client. Cu later :-)
sepia@tinkerboard-2:~/sepia-client$ cat /home/sepia/sepia-client/log-client.out
/bin/bash: warning: setlocale: LC_ALL: cannot change locale (en_US.utf8)
[1101/132807.862755:WARNING:bluez_dbus_manager.cc(247)] Floss manager not present, cannot set Floss enable/disable.
[1101/132807.947215:WARNING:sandbox_linux.cc(380)] InitializeSandbox() called with multiple threads in process gpu-process.
[1101/132807.967042:ERROR:command_buffer_proxy_impl.cc(128)] ContextResult::kTransientFailure: Failed to send GpuControl.CreateCommandBuffer.
[1101/132808.204528:INFO:CONSOLE(89)] "SepiaFW - LOG - Config: language=en", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (89)
[1101/132808.204887:INFO:CONSOLE(95)] "SepiaFW - LOG - Config: regionCode=en-US", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (95)
[1101/132808.858067:INFO:CONSOLE(855)] "SepiaFW - LOG - Service Worker: Not enabled (you can use 'pwa=true' URL param.)", source: http://localhost:8080/sepia/index.html?isApp=true&isHeadless=true (855)
[1101/132808.859102:INFO:CONSOLE(421)] "SepiaFW - LOG - Loading headless settings for device ...", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (421)
[1101/132808.859312:INFO:CONSOLE(424)] "* host-name", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (424)
[1101/132808.859585:INFO:CONSOLE(424)] "* deviceId", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (424)
[1101/132808.859631:INFO:CONSOLE(424)] "* environment", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (424)
[1101/132808.859673:INFO:CONSOLE(424)] "* deviceLocalSiteData", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (424)
[1101/132808.859777:INFO:CONSOLE(424)] "* mediaDevices", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (424)
[1101/132808.859859:INFO:CONSOLE(424)] "* playerVolume", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (424)
[1101/132808.859892:INFO:CONSOLE(424)] "* microphoneSettings", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (424)
[1101/132808.859930:INFO:CONSOLE(424)] "* deviceSounds", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (424)
[1101/132808.859962:INFO:CONSOLE(424)] "* wakeWordNames", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (424)
[1101/132808.860064:INFO:CONSOLE(424)] "* wakeWordVersion", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (424)
[1101/132808.860110:INFO:CONSOLE(424)] "* voiceEngine", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (424)
[1101/132808.860214:INFO:CONSOLE(424)] "* voiceCustomServerURI", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (424)
[1101/132808.860252:INFO:CONSOLE(424)] "* en-voice", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (424)
[1101/132808.860335:INFO:CONSOLE(424)] "* de-voice", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (424)
[1101/132808.860373:INFO:CONSOLE(424)] "* asrEngine", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (424)
[1101/132808.860442:INFO:CONSOLE(424)] "* asrServerURI", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (424)
[1101/132808.860507:INFO:CONSOLE(424)] "* asrServerUser", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (424)
[1101/132808.860557:INFO:CONSOLE(424)] "* asrServerToken", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (424)
[1101/132808.860595:INFO:CONSOLE(424)] "* en-asrModel", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (424)
[1101/132808.860626:INFO:CONSOLE(424)] "* de-asrModel", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (424)
[1101/132808.860662:INFO:CONSOLE(424)] "* big-screen-mode", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (424)
[1101/132808.860698:INFO:CONSOLE(424)] "* virtualKeyboard", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (424)
[1101/132808.860732:INFO:CONSOLE(424)] "* clexiGpioInterface", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (424)
[1101/132808.860807:INFO:CONSOLE(431)] "SepiaFW - LOG - Loading headless settings for user ...", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (431)
[1101/132808.861010:INFO:CONSOLE(434)] "* clexiSocketURI", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (434)
[1101/132808.861183:INFO:CONSOLE(434)] "* clexiServerId", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (434)
[1101/132808.861229:INFO:CONSOLE(434)] "* clexiConnect", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (434)
[1101/132808.861286:INFO:CONSOLE(434)] "* useRemoteCmdl", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (434)
[1101/132808.861325:INFO:CONSOLE(434)] "* useGamepads", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (434)
[1101/132808.861389:INFO:CONSOLE(434)] "* useBluetoothBeacons", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (434)
[1101/132808.861453:INFO:CONSOLE(434)] "* useBluetoothBeaconsInAoModeOnly", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (434)
[1101/132808.861487:INFO:CONSOLE(434)] "* knownBluetoothBeaconAddresses", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (434)
[1101/132808.861527:INFO:CONSOLE(434)] "* useWakeWord", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (434)
[1101/132808.861559:INFO:CONSOLE(434)] "* autoloadWakeWord", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (434)
[1101/132808.861623:INFO:CONSOLE(434)] "* allowWakeWordDuringStream", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (434)
[1101/132808.861662:INFO:CONSOLE(434)] "* activeSkin", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (434)
[1101/132808.861725:INFO:CONSOLE(434)] "* activeAvatar", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (434)
[1101/132808.861764:INFO:CONSOLE(434)] "* proactiveNotes", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (434)
[1101/132808.861837:INFO:CONSOLE(434)] "* autoGPS", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (434)
[1101/132808.861871:INFO:CONSOLE(434)] "* embeddedPlayerSettings", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (434)
[1101/132808.888867:INFO:CONSOLE(17)] "SepiaFW - LOG - ASR: Supported interfaces: webSpeechAPI=true (cordova=false), webSocketAsr=true.", source: http://localhost:8080/sepia/scripts/sepiaFW.speechRecognition.js (17)
[1101/132808.889136:INFO:CONSOLE(54)] "SepiaFW - LOG - ASR: Using 'native' engine.", source: http://localhost:8080/sepia/scripts/sepiaFW.speechRecognition.js (54)
[1101/132808.892132:INFO:CONSOLE(19)] "SepiaFW - LOG - TTS: Supported interfaces: native=true, sepia=probably.", source: http://localhost:8080/sepia/scripts/sepiaFW.speechSynthesis.js (19)
[1101/132808.892590:INFO:CONSOLE(118)] "SepiaFW - LOG - TTS: Using 'sepia' engine.", source: http://localhost:8080/sepia/scripts/sepiaFW.speechSynthesis.js (118)
[1101/132808.900516:INFO:CONSOLE(205)] "SepiaFW - LOG - Config: broadcasted host=localhost", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (205)
[1101/132808.901151:INFO:CONSOLE(161)] "SepiaFW - LOG - Config: assistAPI=http://localhost:20721/", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (161)
[1101/132808.906211:INFO:CONSOLE(724)] "SepiaFW - LOG - Added pre-my-view-update one-time onAction event of source: setup-mode", source: http://localhost:8080/sepia/scripts/sepiaFW.webSocket.js (724)
[1101/132808.906890:INFO:CONSOLE(277)] "SepiaFW - LOG - Config: broadcasted deviceId=o1", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (277)
[1101/132808.907725:INFO:CONSOLE(18)] "SepiaFW - LOG - Config: clientInfo=app_v0.25.0", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (18)
[1101/132808.927903:INFO:CONSOLE(495)] "SepiaFW - LOG - UI active skin: css/sepiaFW-skin-neo-sepia-dark.css", source: http://localhost:8080/sepia/scripts/sepiaFW.ui.js (495)
[1101/132808.934607:INFO:CONSOLE(564)] "SepiaFW - LOG - UI active avatar: css/sepiaFW-avatar-classic.css", source: http://localhost:8080/sepia/scripts/sepiaFW.ui.js (564)
[1101/132808.934914:INFO:CONSOLE(653)] "SepiaFW - LOG - App settings finished condition: app-settings-tasks", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (653)
[1101/132808.935058:INFO:CONSOLE(655)] "SepiaFW - LOG - App settings complete", source: http://localhost:8080/sepia/scripts/sepiaFW.app.config.js (655)
[1101/132808.935131:INFO:CONSOLE(1337)] "SepiaFW - LOG - UI setup finished condition: load-app-settings", source: http://localhost:8080/sepia/scripts/sepiaFW.ui.js (1337)
[1101/132808.999454:INFO:CONSOLE(716)] "SepiaFW - LOG - Added one-time onAction event of source: tts-voice-setup", source: http://localhost:8080/sepia/scripts/sepiaFW.webSocket.js (716)
[1101/132809.033248:INFO:CONSOLE(1337)] "SepiaFW - LOG - UI setup finished condition: audio-setup", source: http://localhost:8080/sepia/scripts/sepiaFW.ui.js (1337)
[1101/132809.033407:INFO:CONSOLE(1337)] "SepiaFW - LOG - UI setup finished condition: setup-tasks", source: http://localhost:8080/sepia/scripts/sepiaFW.ui.js (1337)
[1101/132809.033467:INFO:CONSOLE(1339)] "SepiaFW - LOG - UI setup complete", source: http://localhost:8080/sepia/scripts/sepiaFW.ui.js (1339)

@fquirin
Copy link
Contributor

fquirin commented Nov 1, 2022

If I add the --headless flag to the chromium args, then I get a step further but also quits shortly after: ...

I think this flag is running Chromium in the background and because of that the run-script jumps to the end immediately. Unfortunately we can't use the integrated 'headless' mode because of limited or missing features (that's why the script uses xvfb).

[2762:2762:1101/131115.681293:ERROR:gpu_memory_buffer_support_x11.cc(44)] dri3 extension not supported.

The Tinkerboard might have a GPU driver problem or the driver has some conflict with Chromium. Can you try the Chromium flag: --disable-gpu?

@Sineos
Copy link
Author

Sineos commented Nov 1, 2022

Can you try the Chromium flag: --disable-gpu?

It seems to start. In the Control-Hub I can connect but no reaction to ping etc

sepia@tinkerboard-2:~/sepia-client$ bash status.sh
Chromium with SEPIA is: active
Xvfb server is: active
CLEXI server is: active
sepia@tinkerboard-2:~/sepia-client$ cat /home/sepia/sepia-client/log-client.out
update.go:85: cannot change mount namespace according to change mount (/var/lib/snapd/hostfs/usr/share/cups/doc-root /usr/share/cups/doc-root none bind,ro 0 0): cannot create directory "/usr/share/cups/doc-root": permission denied
update.go:85: cannot change mount namespace according to change mount (/var/lib/snapd/hostfs/usr/share/gimp/2.0/help /usr/share/gimp/2.0/help none bind,ro 0 0): cannot create directory "/usr/share/gimp/2.0": permission denied
update.go:85: cannot change mount namespace according to change mount (/var/lib/snapd/hostfs/usr/share/gtk-doc /usr/share/gtk-doc none bind,ro 0 0): cannot open directory "/var/lib": permission denied
update.go:85: cannot change mount namespace according to change mount (/var/lib/snapd/hostfs/usr/share/libreoffice/help /usr/share/libreoffice/help none bind,ro 0 0): cannot create directory "/usr/share/libreoffice/help": permission denied
update.go:85: cannot change mount namespace according to change mount (/var/lib/snapd/hostfs/usr/share/xubuntu-docs /usr/share/xubuntu-docs none bind,ro 0 0): cannot open directory "/var/lib": permission denied
/bin/bash: warning: setlocale: LC_ALL: cannot change locale (en_US.utf8)

@fquirin
Copy link
Contributor

fquirin commented Nov 1, 2022

Did you hear the "ready for setup" message this time?

@Sineos
Copy link
Author

Sineos commented Nov 1, 2022

No, only "I'll be right there"

@Sineos
Copy link
Author

Sineos commented Nov 1, 2022

default_chrome_flags="$default_chrome_flags --disable-gpu --disable-software-rasterizer"

acc. to https://stackoverflow.com/questions/69037458/selenium-chromedriver-gives-initializesandbox-called-with-multiple-threads-in

yields:

/bin/bash: warning: setlocale: LC_ALL: cannot change locale (en_US.utf8)
[4806:4806:1101/160533.177198:ERROR:gpu_init.cc(521)] Passthrough is not supported, GL is disabled, ANGLE is

@fquirin
Copy link
Contributor

fquirin commented Nov 1, 2022

InitializeSandbox() called with multiple threads ...

Looking at your logs I think this only happens without --disable-gpu right? I'd remove --disable-software-rasterizer that for now.

Do you have any chance to connect a display to your Tinkerboard?
If so, you can run bash setup.sh from ~/sepia-client and set the client to "pseudo-headless" mode and then observer on a screen if Chromium actually starts 🤔 .

update.go:85: cannot change mount namespace according to change mount (/var/lib/snapd/hostfs/usr/share/cups/doc-root /usr/share/cups/doc-root none bind,ro 0 0): cannot create directory "/usr/share/cups/doc-root": permission denied update.go:85: cannot change mount ...

These messages are very weird, why would Chromium try to access things like /var/lib/snapd/hostfs/usr/share/gimp/2.0/help and run GO code ??
Btw what Linux OS is running on the board?

@Sineos
Copy link
Author

Sineos commented Nov 1, 2022

These messages are very weird, why would Chromium try to access things like /var/lib/snapd/hostfs/usr/share/gimp/2.0/help and run GO code ??

The really strange thing is that these message only appear when booting up with auto-login. When started via run.sh they do not appear.

Btw what Linux OS is running on the board?

Armbian (Ubuntu based)

Do you have any chance to connect a display to your Tinkerboard?

Ok, now it gets really wired. It works in pseudo headless. I get the message "ready for setup" and can work with the o1 client. There is one error message at start.

grafik

Otherwise it looks good:

grafik

sepia@tinkerboard-2:~$ cat /home/sepia/sepia-client/log-client.out
update.go:85: cannot change mount namespace according to change mount (/var/lib/snapd/hostfs/usr/share/cups/doc-root /usr/share/cups/doc-root none bind,ro 0 0): cannot create directory "/usr/share/cups/doc-root": permission denied
update.go:85: cannot change mount namespace according to change mount (/var/lib/snapd/hostfs/usr/share/gimp/2.0/help /usr/share/gimp/2.0/help none bind,ro 0 0): cannot create directory "/usr/share/gimp/2.0": permission denied
update.go:85: cannot change mount namespace according to change mount (/var/lib/snapd/hostfs/usr/share/gtk-doc /usr/share/gtk-doc none bind,ro 0 0): cannot open directory "/var/lib": permission denied
update.go:85: cannot change mount namespace according to change mount (/var/lib/snapd/hostfs/usr/share/libreoffice/help /usr/share/libreoffice/help none bind,ro 0 0): cannot create directory "/usr/share/libreoffice/help": permission denied
update.go:85: cannot change mount namespace according to change mount (/var/lib/snapd/hostfs/usr/share/xubuntu-docs /usr/share/xubuntu-docs none bind,ro 0 0): cannot open directory "/var/lib": permission denied
/bin/bash: warning: setlocale: LC_ALL: cannot change locale (eo_US.UTF-8)
[2382:2562:1101/163941.052525:ERROR:udev_watcher.cc(98)] Failed to begin udev enumeration.
[2382:2771:1101/163952.501625:ERROR:udev_watcher.cc(98)] Failed to begin udev enumeration.

@fquirin
Copy link
Contributor

fquirin commented Nov 1, 2022

The really strange thing is that these message only appear when booting up with auto-login. When started via run.sh they do not appear.

Maybe some OS related things, idk 🤷‍♂️, let's just ignore it for now 😅

Ok, now it gets really wired. It works in pseudo headless. I get the message "ready for setup" and can work with the o1 client. There is one error message at start.

Maybe it was still waiting for the reboot after first successful start. You can try to switch back to "real" 'headless' and observe what happens :-). Maybe it has some issues with 'xvfb', but I would expect error messages visible inside the log in this case.
The extension should be located here: ~/sepia-client/chromium-extensions/sepia-fw/. At least that is the only extension that should be active (it is only relevant when working with displays though).

@Sineos
Copy link
Author

Sineos commented Nov 1, 2022

Ok, not yet there:

  1. Used the "pseudo display" to configure the o1 client
  2. Rebooted
  3. Pseudo display is stuck at "Failed to load extension from ..."
  4. Once the error message is acked the client loading continues and I'm greeted with "ready for setup"

Does it make any difference to run the client headless or pseudo display?
What could be the reason for the error message?
What do I need to do to complete the setup?

@fquirin
Copy link
Contributor

fquirin commented Nov 3, 2022

Does it make any difference to run the client headless or pseudo display?

There are subtile difference, the biggest one being performance since the "pure" headless version emulates a very small display internally. Sometimes services are optimized for display as well and might mention something like "I need to show you the result on a display" in headless, but you can manipulate that behavior with the settings.js I think (environment varaible).

What could be the reason for the error message?

Good question. Maybe something went wrong during installation. Did you check the ~/sepia-client/chromium-extensions/sepia-fw/ folder to see if there actually is a manifest file inside?

What do I need to do to complete the setup?

When you hear the "ready for setup" you can login via the remote terminal of your SEPIA Control-HUB (client connections page) or you can use the display to enter your credentials. Are you using v0.25.0 right now? (if so you have ~8s to abort the automatic-setup at load-up of the client).
In principle you could even switch to non-headless "display" mode completely. This will skip loading the settings.js automatically and you can set-up everything as if you use the client on your desktop browser.

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
None yet
Projects
None yet
Development

No branches or pull requests

2 participants