rkd
April 8, 2022, 2:04am
1
Delta Chat not starting or starting with all black screen. It seems like the issue started after a recent archlinux update. Is this a known issue?
Searching the error online seems like it could be chrome (is deltachat based on chrome?) related. Internet search turned up:
opened 12:55PM - 23 Mar 22 UTC
closed 05:19PM - 23 Mar 22 UTC
browser-chromium
upstream
triaging
**Context:**
- Playwright Version: 1.20.0
- Operating System: Linux
- Node.… js version: 16
- Browser: Chromium
- Extra: CircleCI machine executor (ubuntu-2004:202201-02)
**Describe the bug**
Yesterday we have started observing some weird behaviour of Chromium in our Playwright tests. The chromium seems to have started crashing in a lot of our tests, which leads to errors like this:
- locator.isVisible: Browser closed.
- locator.textContent: Target page, context or browser has been closed
- page.waitForLoadState: Navigation failed because page was closed!
- ...
Under some of those we see a browser log that looks like this:
```
==================== Browser output: ====================
<launching> /home/circleci/.cache/ms-playwright/chromium-978106/chrome-linux/chrome --disable-background-networking --enable-features=NetworkService,NetworkServiceInProcess --disable-background-timer-throttling --disable-backgrounding-occluded-windows --disable-breakpad --disable-client-side-phishing-detection --disable-component-extensions-with-background-pages --disable-default-apps --disable-dev-shm-usage --disable-extensions --disable-features=ImprovedCookieControls,LazyFrameLoading,GlobalMediaControls,DestroyProfileOnBrowserClose,MediaRouter,AcceptCHFrame,AutoExpandDetailsElement --allow-pre-commit-input --disable-hang-monitor --disable-ipc-flooding-protection --disable-popup-blocking --disable-prompt-on-repost --disable-renderer-backgrounding --disable-sync --force-color-profile=srgb --metrics-recording-only --no-first-run --enable-automation --password-store=basic --use-mock-keychain --no-service-autorun --export-tagged-pdf --no-sandbox --disable-extensions-except=/home/circleci/project/packages/tests/playwright/dist/downloads/meta-mask --load-extension=/home/circleci/project/packages/tests/playwright/dist/downloads/meta-mask --user-data-dir=/tmp/userDataDir/0.3206857680105486 --remote-debugging-pipe about:blank
<launched> pid=82836
[pid=82836][err] [82836:82855:0322/182100.844385:ERROR:bus.cc(397)] Failed to connect to the bus: Address does not contain a colon
[pid=82836][err] [82836:82855:0322/182100.844598:ERROR:bus.cc(397)] Failed to connect to the bus: Address does not contain a colon
[pid=82836][err] [82836:82855:0322/182100.891297:ERROR:bus.cc(397)] Failed to connect to the bus: Address does not contain a colon
[pid=82836][err] [82836:82855:0322/182100.891323:ERROR:bus.cc(397)] Failed to connect to the bus: Address does not contain a colon
[pid=82836][err] libva error: vaGetDriverNameByIndex() failed with unknown libva error, driver_name = (null)
[pid=82836][err] [82868:82868:0322/182100.973596:ERROR:viz_main_impl.cc(185)] Exiting GPU process due to errors during initialization
[pid=82836][err] [82836:82855:0322/182101.002030:ERROR:bus.cc(397)] Failed to connect to the bus: Address does not contain a colon
[pid=82836][err] [82836:82855:0322/182101.002070:ERROR:bus.cc(397)] Failed to connect to the bus: Address does not contain a colon
[pid=82836][err] [82836:82951:0322/182101.057487:ERROR:object_proxy.cc(623)] Failed to call method: org.freedesktop.DBus.Properties.Get: object_path= /org/freedesktop/UPower: org.freedesktop.DBus.Error.ServiceUnknown: The name org.freedesktop.UPower was not provided by any .service files
[pid=82836][err] [82836:82951:0322/182101.058226:ERROR:object_proxy.cc(623)] Failed to call method: org.freedesktop.UPower.GetDisplayDevice: object_path= /org/freedesktop/UPower: org.freedesktop.DBus.Error.ServiceUnknown: The name org.freedesktop.UPower was not provided by any .service files
[pid=82836][err] [82836:82951:0322/182101.058403:ERROR:object_proxy.cc(623)] Failed to call method: org.freedesktop.UPower.EnumerateDevices: object_path= /org/freedesktop/UPower: org.freedesktop.DBus.Error.ServiceUnknown: The name org.freedesktop.UPower was not provided by any .service files
[pid=82836][err] libva error: vaGetDriverNameByIndex() failed with unknown libva error, driver_name = (null)
[pid=82836][err] [82949:82949:0322/182101.129098:ERROR:viz_main_impl.cc(185)] Exiting GPU process due to errors during initialization
[pid=82836][err] libva error: vaGetDriverNameByIndex() failed with unknown libva error, driver_name = (null)
[pid=82836][err] [83004:83004:0322/182101.177755:ERROR:gpu_memory_buffer_support_x11.cc(44)] dri3 extension not supported.
[pid=82836][err] [82922:82942:0322/182101.180855:ERROR:command_buffer_proxy_impl.cc(125)] ContextResult::kTransientFailure: Failed to send GpuControl.CreateCommandBuffer.
[pid=82836][err] ALSA lib confmisc.c:767:(parse_card) cannot find card '0'
[pid=82836][err] ALSA lib conf.c:4732:(_snd_config_evaluate) function snd_func_card_driver returned error: No such file or directory
[pid=82836][err] ALSA lib confmisc.c:392:(snd_func_concat) error evaluating strings
[pid=82836][err] ALSA lib conf.c:4732:(_snd_config_evaluate) function snd_func_concat returned error: No such file or directory
[pid=82836][err] ALSA lib confmisc.c:1246:(snd_func_refer) error evaluating name
[pid=82836][err] ALSA lib conf.c:4732:(_snd_config_evaluate) function snd_func_refer returned error: No such file or directory
[pid=82836][err] ALSA lib conf.c:5220:(snd_config_expand) Evaluate error: No such file or directory
[pid=82836][err] ALSA lib pcm.c:2642:(snd_pcm_open_noupdate) Unknown PCM default
[pid=82836][err] [83778:83778:0322/182117.174851:ERROR:alsa_util.cc(204)] PcmOpen: default,No such file or directory
[pid=82836][err] ALSA lib confmisc.c:767:(parse_card) cannot find card '0'
[pid=82836][err] ALSA lib conf.c:4732:(_snd_config_evaluate) function snd_func_card_driver returned error: No such file or directory
[pid=82836][err] ALSA lib confmisc.c:392:(snd_func_concat) error evaluating strings
[pid=82836][err] ALSA lib conf.c:4732:(_snd_config_evaluate) function snd_func_concat returned error: No such file or directory
[pid=82836][err] ALSA lib confmisc.c:1246:(snd_func_refer) error evaluating name
[pid=82836][err] ALSA lib conf.c:4732:(_snd_config_evaluate) function snd_func_refer returned error: No such file or directory
[pid=82836][err] ALSA lib conf.c:5220:(snd_config_expand) Evaluate error: No such file or directory
[pid=82836][err] ALSA lib pcm.c:2642:(snd_pcm_open_noupdate) Unknown PCM default
[pid=82836][err] [83778:83778:0322/182117.175036:ERROR:alsa_util.cc(204)] PcmOpen: plug:default,No such file or directory
[pid=82836][err] [82836:82867:0322/182123.200422:ERROR:ssl_client_socket_impl.cc(996)] handshake failed; returned -1, SSL error code 1, net_error -107
[pid=82836][err] [82836:82867:0322/182123.201133:ERROR:ssl_client_socket_impl.cc(996)] handshake failed; returned -1, SSL error code 1, net_error -107
[pid=82836][err] [82836:82867:0322/182139.141608:ERROR:ssl_client_socket_impl.cc(996)] handshake failed; returned -1, SSL error code 1, net_error -107
[pid=82836][err] [82836:82867:0322/182139.142173:ERROR:ssl_client_socket_impl.cc(996)] handshake failed; returned -1, SSL error code 1, net_error -107
[pid=82836][err] [82836:82867:0322/182139.344108:ERROR:ssl_client_socket_impl.cc(996)] handshake failed; returned -1, SSL error code 1, net_error -107
[pid=82836][err] [82836:82867:0322/182139.345243:ERROR:ssl_client_socket_impl.cc(996)] handshake failed; returned -1, SSL error code 1, net_error -107
[pid=82836][err] [82836:82867:0322/182156.268689:ERROR:ssl_client_socket_impl.cc(996)] handshake failed; returned -1, SSL error code 1, net_error -107
[pid=82836][err] [82836:82867:0322/182156.269680:ERROR:ssl_client_socket_impl.cc(996)] handshake failed; returned -1, SSL error code 1, net_error -107
[pid=82836][err] [0322/182205.584411:ERROR:file_io_posix.cc(144)] open /sys/devices/system/cpu/cpu0/cpufreq/scaling_cur_freq: No such file or directory (2)
[pid=82836][err] [0322/182205.584482:ERROR:file_io_posix.cc(144)] open /sys/devices/system/cpu/cpu0/cpufreq/scaling_max_freq: No such file or directory (2)
[pid=82836][err] Received signal 11 <unknown> 000000000000
[pid=82836][err] #0 0x55f2b932a369 base::debug::CollectStackTrace()
[pid=82836][err] #1 0x55f2b92908c3 base::debug::StackTrace::StackTrace()
[pid=82836][err] #2 0x55f2b9329e71 base::debug::(anonymous namespace)::StackDumpSignalHandler()
[pid=82836][err] #3 0x7f70d280e3c0 (/usr/lib/x86_64-linux-gnu/libpthread-2.31.so+0x153bf)
[pid=82836][err] #4 0x55f2b93465f7 base::internal::PartitionFree()
[pid=82836][err] #5 0x55f2b8ecb91c component_updater::PKIMetadataComponentInstallerPolicy::UpdateNetworkServiceOnUI()
[pid=82836][err] #6 0x55f2b69940df base::internal::ReplyAdapter<>()
[pid=82836][err] #7 0x55f2b5ad4637 base::internal::Invoker<>::RunOnce()
[pid=82836][err] #8 0x55f2b6dfc0ae base::internal::Invoker<>::RunOnce()
[pid=82836][err] #9 0x55f2b9311d79 base::internal::Invoker<>::RunOnce()
[pid=82836][err] #10 0x55f2b92e8bb0 base::TaskAnnotator::RunTaskImpl()
[pid=82836][err] #11 0x55f2b92fca99 base::sequence_manager::internal::ThreadControllerWithMessagePumpImpl::DoWorkImpl()
[pid=82836][err] #12 0x55f2b92fc7bc base::sequence_manager::internal::ThreadControllerWithMessagePumpImpl::DoWork()
[pid=82836][err] #13 0x55f2b92fcf92 base::sequence_manager::internal::ThreadControllerWithMessagePumpImpl::DoWork()
[pid=82836][err] #14 0x55f2b92ac06b base::(anonymous namespace)::WorkSourceDispatch()
[pid=82836][err] #15 0x7f70d26c217d g_main_context_dispatch
[pid=82836][err] #16 0x7f70d26c2400 (/usr/lib/x86_64-linux-gnu/libglib-2.0.so.0.6400.6+0x523ff)
[pid=82836][err] #17 0x7f70d26c24a3 g_main_context_iteration
[pid=82836][err] #18 0x55f2b92abeb3 base::MessagePumpGlib::Run()
[pid=82836][err] #19 0x55f2b92fd1fe base::sequence_manager::internal::ThreadControllerWithMessagePumpImpl::Run()
[pid=82836][err] #20 0x55f2b92ca3ed base::RunLoop::Run()
[pid=82836][err] #21 0x55f2b6d2d2ad content::BrowserMainLoop::RunMainMessageLoop()
[pid=82836][err] #22 0x55f2b6d2eb62 content::BrowserMainRunnerImpl::Run()
[pid=82836][err] #23 0x55f2b6d2ad6c content::BrowserMain()
[pid=82836][err] #24 0x55f2b8e428a8 content::RunBrowserProcessMain()
[pid=82836][err] #25 0x55f2b8e43d0f content::ContentMainRunnerImpl::RunBrowser()
[pid=82836][err] #26 0x55f2b8e4389f content::ContentMainRunnerImpl::Run()
[pid=82836][err] #27 0x55f2b8e40cb4 content::RunContentProcess()
[pid=82836][err] #28 0x55f2b8e415ce content::ContentMain()
[pid=82836][err] #29 0x55f2b5961fed ChromeMain
[pid=82836][err] #30 0x7f70d193b0b3 __libc_start_main
[pid=82836][err] #31 0x55f2b5961dea _start
[pid=82836][err] r8: 00003dce02251280 r9: 00007ffdf4934027 r10: 4c7a39d1bc6ebd73 r11: 0000000000000000
[pid=82836][err] r12: 7465672e6b726f77 r13: 00003dce02251280 r14: 00003dce02aca260 r15: 0000000000000008
[pid=82836][err] di: 000055f2be981910 si: 7465672e6b726f77 bp: 00007ffdf49340e0 bx: 7465672e6b600000
[pid=82836][err] dx: 0000000000000000 ax: 000055f2b93465d0 cx: 0000000000000006 sp: 00007ffdf49340b0
[pid=82836][err] ip: 000055f2b93465f7 efl: 0000000000010206 cgf: 002b000000000033 erf: 0000000000000000
[pid=82836][err] trp: 000000000000000d msk: 0000000000000000 cr2: 0000000000000000
[pid=82836][err] [end of stack trace]
```
We've been running Playwright tests without problems for 1-2 months now, and this suddenly started happening yesterday (at around same time CircleCI had an outage), without any real explanation (no code changes that I could observe that could potentially cause this).
Do you guys have any ideas what the underlying issue could be here, or how we could go about debugging this?
One of the assumptions was the resource saturation, but we tried significantly decreasing the parallelism (from 6 to 2), without success (we use 16 cpu 64gb machines currently).
https://groups.google.com/a/chromium.org/g/chromium-checkins/c/z_6BBIBACJg
OS Arch Linux (deltachat-desktop installed through AUR)
Graphics Card Nvidia GT640 with nvidia-470xx-utils AUR package installed
> deltachat
Logfile: /home/username/.config/DeltaChat/logs/2022-04-07-20-49-29.log
[3057:0407/204929.581510:ERROR:gpu_memory_buffer_support_x11.cc(44)] dri3 extension not supported.
/home/username/.config/DeltaChat/logs/2022-04-07-20-49-29.log
2022-04-08T01:49:29.335Z main/index INFO "" "Deltachat Version 1.27.2 tags/v1.27.2 1649373631473"
2022-04-08T01:49:29.480Z main/deltachat/webxdc WARNING "\n/opt/DeltaChat/electron_app/src/main/deltachat/webxdc.ts:392:9,\nrejected (/opt/DeltaChat/electron_app/tsc-dist/main/deltachat/webxdc.js:6:65)" "webxdc cleanup failed" {"stack":"Error: ENOENT: no such file or directory, scandir '/home/username/.config/DeltaChat/Partitions'","message":"ENOENT: no such file or directory, scandir '/home/username/.config/DeltaChat/Partitions'","errno":-2,"code":"ENOENT","syscall":"scandir","path":"/home/username/.config/DeltaChat/Partitions"}
2022-04-08T01:49:29.492Z main/index INFO "" "cwd /home/username/.config/DeltaChat/accounts"
2022-04-08T01:49:29.503Z main/deltachat INFO "" "Ready, starting accounts io..."
2022-04-08T01:49:29.504Z main/deltachat INFO "" "Started accounts io."
2022-04-08T01:49:29.523Z main/menu INFO "" "rebuilding menu with locale en"
2022-04-08T01:49:29.533Z core/event INFO "" 8 "DC_EVENT_INFO" 0 "src/sql.rs:312: Opened database PathBuf { inner: \"/home/username/.config/DeltaChat/accounts/61d012a10e1d461c98df4e452572f086/dc.db\" }."
2022-04-08T01:49:29.533Z core/event INFO "" 8 "DC_EVENT_INFO" 0 "src/context.rs:198: starting IO"
2022-04-08T01:49:29.533Z core/event INFO "" 8 "DC_EVENT_INFO" 0 "src/scheduler.rs:67: starting inbox loop"
2022-04-08T01:49:29.534Z core/event INFO "" 8 "DC_EVENT_INFO" 0 "src/job.rs:753: loading job for Imap-thread"
2022-04-08T01:49:29.534Z core/event INFO "" 8 "DC_EVENT_INFO" 0 "src/scheduler.rs:255: starting simple loop for configured_mvbox_folder"
2022-04-08T01:49:29.534Z core/event INFO "" 8 "DC_EVENT_INFO" 0 "src/scheduler.rs:292: starting smtp loop"
2022-04-08T01:49:29.534Z core/event INFO "" 8 "DC_EVENT_INFO" 0 "src/job.rs:753: loading job for Smtp-thread"
2022-04-08T01:49:29.534Z core/event INFO "" 8 "DC_EVENT_INFO" 0 "src/scheduler.rs:453: scheduler is running"
2022-04-08T01:49:29.534Z core/event INFO "" 8 "DC_EVENT_INFO" 0 "src/scheduler.rs:330: smtp fake idle - started"
2022-04-08T01:49:29.535Z logger/log-cleanup INFO "" "Successfuly deleted 1 old logfiles"
2022-04-08T01:49:30.728Z core/event INFO "" 8 "DC_EVENT_INFO" 0 "src/imap.rs:672: No new emails in folder DeltaChat"
2022-04-08T01:49:30.731Z core/event INFO "" 8 "DC_EVENT_INFO" 0 "src/imap.rs:672: No new emails in folder INBOX"
2022-04-08T01:49:30.732Z core/event INFO "" 8 "DC_EVENT_INFO" 0 "src/imap/scan_folders.rs:27: Starting full folder scan"
2022-04-08T01:49:31.192Z core/event INFO "" 8 "DC_EVENT_INFO" 0 "src/imap/idle.rs:57: DeltaChat: Idle entering wait-on-remote state"
2022-04-08T01:49:31.208Z core/event INFO "" 8 "DC_EVENT_INFO" 0 "src/imap.rs:672: No new emails in folder Archives"
2022-04-08T01:49:31.440Z core/event INFO "" 8 "DC_EVENT_INFO" 0 "src/imap.rs:672: No new emails in folder Archives/2022"
2022-04-08T01:49:31.673Z core/event INFO "" 8 "DC_EVENT_INFO" 0 "src/imap.rs:672: No new emails in folder Junk"
2022-04-08T01:49:31.907Z core/event INFO "" 8 "DC_EVENT_INFO" 0 "src/imap.rs:672: No new emails in folder Templates"
2022-04-08T01:49:32.140Z core/event INFO "" 8 "DC_EVENT_INFO" 0 "src/imap.rs:672: No new emails in folder Sent"
2022-04-08T01:49:32.374Z core/event INFO "" 8 "DC_EVENT_INFO" 0 "src/imap.rs:672: No new emails in folder Trash"
2022-04-08T01:49:32.606Z core/event INFO "" 8 "DC_EVENT_INFO" 0 "src/imap.rs:672: No new emails in folder Trash/sms"
2022-04-08T01:49:32.842Z core/event INFO "" 8 "DC_EVENT_INFO" 0 "src/imap.rs:672: No new emails in folder INBOX"
2022-04-08T01:49:33.306Z core/event INFO "" 8 "DC_EVENT_INFO" 0 "src/imap/idle.rs:57: INBOX: Idle entering wait-on-remote state"
2 Likes
Can you try installing electron14 and change “electron .” to “electron14 .” in /opt/DeltaChat/deltachat ?
And which AUR package are you using? deltachat-desktop-git (that’s the one we maintain) or deltachat-desktop (community maintained).
1 Like
rkd
April 8, 2022, 3:51pm
3
That worked, thank you very much
deltachat-desktop. didn’t know there were two. why two packages? was it forked? is one development? Which is recommended for stability?
1 Like
xuv
April 10, 2022, 10:36am
4
1 Like
-git is always the newest development version (think nightly) so probably less stable but more fresh. deltachat-desktop is the latest stable version but not maintained by us.
1 Like