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

syncthingtray test failure #155

Closed
xeruf opened this issue Dec 16, 2022 · 12 comments
Closed

syncthingtray test failure #155

xeruf opened this issue Dec 16, 2022 · 12 comments
Labels

Comments

@xeruf
Copy link

xeruf commented Dec 16, 2022

This reliably happens evey time right now:

==> Starting check()...
[18/22] Building CXX obje...r/tests/application.cpp.o
/home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/tests/application.cpp: In member function ‘void Applica
tionTests::test()’:
/home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/tests/application.cpp:220:10: warning: ignoring return 
value of ‘int chdir(const char*)’ declared with attribute ‘warn_unused_result’ [-Wunused-result]
  220 |     chdir("/tmp/some/path/1");
      |     ~~~~~^~~~~~~~~~~~~~~~~~~~
/home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/tests/application.cpp:222:10: warning: ignoring return 
value of ‘int chdir(const char*)’ declared with attribute ‘warn_unused_result’ [-Wunused-result]
  222 |     chdir("newdir");
      |     ~~~~~^~~~~~~~~~
/home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/tests/application.cpp:246:14: warning: ignoring return 
value of ‘int chdir(const char*)’ declared with attribute ‘warn_unused_result’ [-Wunused-result]
  246 |         chdir(cwd);
      |         ~~~~~^~~~~
[21/22] cd /home/janek/.l....3.1 && /usr/bin/ctest -V
UpdateCTestConfiguration  from :/home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/DartConfiguration.tcl
UpdateCTestConfiguration  from :/home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/DartConfiguration.tcl
Test project /home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1
Constructing a list of tests
Done constructing a list of tests
Updating test list for fixtures
Added 0 tests to meet fixture requirements
Checking test dependency graph...
Checking test dependency graph end
test 1
    Start 1: syncthingconnector_run_tests

1: Test command: /home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/connector/syncthingconnector_tests "-p" "/
home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/connector/testfiles" "-w" "/home/janek/.local/cache/yay/sync
thingtray/src/syncthingtray-1.3.1/connector/testworkingdir"
1: Working Directory: /home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/connector
1: Test timeout computed to be: 10000000
test 3
    Start 3: syncthingwidgets_run_wizard_tests

3: Test command: /home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/widgets/syncthingwidgets_wizard_tests
3: Working Directory: /home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/widgets
3: Test timeout computed to be: 10000000
test 4
    Start 4: syncthingtray_appstream_validation

4: Test command: /usr/bin/appstreamcli "validate" "/home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/tray/res
ources/syncthingtray.appdata.xml"
4: Working Directory: /home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/tray
4: Test timeout computed to be: 10000000
1: /home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/connector/testfiles/
1: /home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/connector/testfiles/
1: ./testfiles/
1: Directory used to store working copies:
1: /home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/connector/testworkingdir/
1: Executing test cases ...
1: .
1:  - Setup configuration for Syncthing tests ...
1:  - Using timeout factor 3
1: 
1:  - Launching Syncthing: syncthing -gui-address=http://127.0.0.1:49217 -gui-apikey=syncthingtestinstance -home=/home/janek/.
local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/connector/testworkingdir/testconfig -no-browser -verbose
1: Info: Launched process, PID: 336810
1: 
1:  - Preparing connection ...
1: 
1:  - Error handling in case of insufficient configuration ...
1:  - Connection error: Connection configuration is insufficient.
1:  - Connection status changed to: disconnected
1: 
1:  - Error handling in case of inavailability ...
1: [start] 2022/12/16 15:51:50 INFO: syncthing v1.22.1 "Fermium Flea" (go1.19.3 linux-amd64) syncthing@archlinux 2022-11-03 07
:35:59 UTC [noupgrade]
1: [start] 2022/12/16 15:51:50 INFO: Generating ECDSA key and certificate for syncthing...
1: [start] 2022/12/16 15:51:50 INFO: Archiving a copy of old config file format at: /home/janek/.local/cache/yay/syncthingtray
/src/syncthingtray-1.3.1/connector/testworkingdir/testconfig/config.xml.v28
1:  - Connection error: Unable to request Syncthing config: Connection refused
1:  - Connection error: Unable to request Syncthing status: Connection refused
1: [2QOBR] 2022/12/16 15:51:50 INFO: My ID: 2QOBR3C-ENMHVBL-C63SF5M-5WYAZOS-2OUS6LX-UDXYW7H-MNR7ILL-TLGFAA6
3: ********* Start testing of WizardTests *********
3: Config: Using QtTest library 5.15.7, Qt 5.15.7 (x86_64-little_endian-lp64 shared (dynamic) release build; by GCC 12.2.0), a
rch unknown
3: QDEBUG : WizardTests::initTestCase() "HOME dir: /tmp/syncthingwidgets_wizard_tests-lBmEuf"
3: PASS   : WizardTests::initTestCase()
3: PASS   : WizardTests::testShowingSettings()
3: QWARN  : WizardTests::testConfiguringLauncher() This plugin does not support propagateSizeHints()
3: QWARN  : WizardTests::testConfiguringLauncher() QFSFileEngine::open: No file name specified
3: Info: Launched process, PID: 336841
3: QWARN  : WizardTests::testConfiguringLauncher() QFSFileEngine::open: No file name specified
3: Info: Launched process, PID: 336847
3: QDEBUG : WizardTests::testConfiguringLauncher() waiting for Syncthing to write config file
1:  - Connection status changed to: disconnected
1:  - Connection status changed to: disconnected
1:  - Connection status changed to: disconnected
1:  - Connection status changed to: disconnected
1:  - Connection error: Unable to request Syncthing config: Connection refused
1:  - Connection error: Unable to request Syncthing status: Connection refused
1: [2QOBR] 2022/12/16 15:51:51 INFO: Single thread SHA256 performance is 430 MB/s using crypto/sha256 (427 MB/s using minio/sh
a256-simd).
1: [2QOBR] 2022/12/16 15:51:51 VERBOSE: Starting up (/home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/connec
tor/testworkingdir/testconfig)
1:  - Connection status changed to: disconnected
1:  - Connection status changed to: disconnected
1:  - Connection status changed to: disconnected
1:  - Connection status changed to: disconnected
1:  - Connection error: Unable to request Syncthing config: Connection refused
1:  - Connection error: Unable to request Syncthing status: Connection refused
1: [2QOBR] 2022/12/16 15:51:52 INFO: Hashing performance is 367.25 MB/s
1: [2QOBR] 2022/12/16 15:51:52 INFO: Running database migration 1...
1: [2QOBR] 2022/12/16 15:51:52 INFO: Running database migration 2...
1: [2QOBR] 2022/12/16 15:51:52 INFO: Running database migration 3...
1: [2QOBR] 2022/12/16 15:51:52 INFO: Running database migration 5...
1: [2QOBR] 2022/12/16 15:51:52 INFO: Running database migration 6...
1: [2QOBR] 2022/12/16 15:51:52 INFO: Running database migration 7...
1: [2QOBR] 2022/12/16 15:51:52 INFO: Running database migration 9...
1: [2QOBR] 2022/12/16 15:51:52 INFO: Running database migration 10...
1: [2QOBR] 2022/12/16 15:51:52 INFO: Running database migration 11...
1: [2QOBR] 2022/12/16 15:51:52 INFO: Running database migration 13...
1: [2QOBR] 2022/12/16 15:51:52 INFO: Running database migration 14...
1: [2QOBR] 2022/12/16 15:51:52 INFO: Running database migration 16...
1: [2QOBR] 2022/12/16 15:51:52 INFO: Running database migration 17...
1: [2QOBR] 2022/12/16 15:51:52 INFO: Running database migration 19...
1: [2QOBR] 2022/12/16 15:51:52 INFO: Compacting database after migration...
1: [2QOBR] 2022/12/16 15:51:52 INFO: Overall send rate is unlimited, receive rate is unlimited
1: [2QOBR] 2022/12/16 15:51:52 INFO: No stored folder metadata for "test1"; recalculating
1: [2QOBR] 2022/12/16 15:51:52 INFO: Using discovery mechanism: global discovery server https://discovery.syncthing.net/v2/?no
announce&id=LYXKCHX-VI3NYZR-ALCJBHF-WMZYSPK-QG6QJA3-MPFYMSO-U56GTUK-NA2MIAW
1: [2QOBR] 2022/12/16 15:51:52 INFO: Using discovery mechanism: global discovery server https://discovery-v4.syncthing.net/v2/
?nolookup&id=LYXKCHX-VI3NYZR-ALCJBHF-WMZYSPK-QG6QJA3-MPFYMSO-U56GTUK-NA2MIAW
1: [2QOBR] 2022/12/16 15:51:52 INFO: Using discovery mechanism: global discovery server https://discovery-v6.syncthing.net/v2/
?nolookup&id=LYXKCHX-VI3NYZR-ALCJBHF-WMZYSPK-QG6QJA3-MPFYMSO-U56GTUK-NA2MIAW
1: [2QOBR] 2022/12/16 15:51:52 INFO: Using discovery mechanism: IPv4 local broadcast discovery on port 21027
1: [2QOBR] 2022/12/16 15:51:52 INFO: Using discovery mechanism: IPv6 local multicast discovery on address [ff12::8384]:21027
1: [2QOBR] 2022/12/16 15:51:52 INFO: TCP listener (127.0.0.1:32452) starting
1: [2QOBR] 2022/12/16 15:51:52 INFO: Ready to synchronize test1 (sendreceive)
1: [2QOBR] 2022/12/16 15:51:52 INFO: Loading HTTPS certificate: open /home/janek/.local/cache/yay/syncthingtray/src/syncthingt
ray-1.3.1/connector/testworkingdir/testconfig/https-cert.pem: no such file or directory
1: [2QOBR] 2022/12/16 15:51:52 INFO: Creating new HTTPS certificate
1: [2QOBR] 2022/12/16 15:51:52 VERBOSE: Listen address tcp://127.0.0.1:32452 resolution has changed: lan addresses: [tcp://127
.0.0.1:32452] wan addresses: [tcp://0.0.0.0:0 tcp://127.0.0.1:32452]
1: [2QOBR] 2022/12/16 15:51:52 VERBOSE: Folder "test1" is now scan-waiting
1: [2QOBR] 2022/12/16 15:51:52 VERBOSE: Folder "test1" is now scanning
1: [2QOBR] 2022/12/16 15:51:52 INFO: Completed initial scan of sendreceive folder test1
1: [2QOBR] 2022/12/16 15:51:52 VERBOSE: Local change detected in folder "test1": modified dir newdir
1: [2QOBR] 2022/12/16 15:51:52 VERBOSE: Local change detected in folder "test1": modified file newdir/yet-another-file.txt
1: [2QOBR] 2022/12/16 15:51:52 VERBOSE: Local change detected in folder "test1": modified file new-file.txt
1: [2QOBR] 2022/12/16 15:51:52 VERBOSE: Folder "test1" is now idle
1: [2QOBR] 2022/12/16 15:51:52 INFO: GUI and API listening on 127.0.0.1:49217
1: [2QOBR] 2022/12/16 15:51:52 INFO: Access the GUI via the following URL: http://127.0.0.1:49217/
1: [2QOBR] 2022/12/16 15:51:52 INFO: My name is "elephant.arch"
1: [2QOBR] 2022/12/16 15:51:52 INFO: Device MMGUI6U-WUEZQCP-XZZ6VYB-LCT4TVC-ER2HAVX-QYT6X7D-S6ZSG2B-323KLQ7 is "Test dev 2" at
 [tcp://192.168.2.2:22001]
1: [2QOBR] 2022/12/16 15:51:52 INFO: Device 6EIS2PN-J2IHWGS-AXS3YUL-HC5FT3K-77ZXTLL-AKQLJ4C-7SWVPUS-AZW4RQ4 is "Test dev 1" at
 [dynamic]
1: [2QOBR] 2022/12/16 15:51:52 VERBOSE: Startup complete
1: [2QOBR] 2022/12/16 15:51:52 VERBOSE: Discovered device D44DUSS-JKYRXL7-MJHCZ5A-WVC6P2H-5A5L55Y-EPKGYA6-HWD44GL-EMNCYQM at [
tcp://172.16.0.241:39271 tcp://172.16.0.37:39271 tcp://172.24.0.1:39271 tcp://172.19.0.1:39271 tcp://172.21.0.1:39271 tcp://17
2.20.0.1:39271 tcp://172.17.77.1:39271 tcp://172.18.0.1:39271 quic://172.16.0.241:39271 quic://172.16.0.37:39271 quic://172.24
.0.1:39271 quic://172.19.0.1:39271 quic://172.21.0.1:39271 quic://172.20.0.1:39271 quic://172.17.77.1:39271 quic://172.18.0.1:
39271]
1: [2QOBR] 2022/12/16 15:51:52 VERBOSE: Discovered device 5HJMFOJ-B64MS5D-EQC6JKV-L23T532-VBUEW2I-UDVIU6U-MZAJQMW-534GNQS at [
tcp://172.16.0.241:22000 tcp://172.16.0.37:22000 tcp://172.24.0.1:22000 tcp://172.19.0.1:22000 tcp://172.21.0.1:22000 tcp://17
2.20.0.1:22000 tcp://172.17.77.1:22000 tcp://172.18.0.1:22000 relay://45.87.155.62:22067/?globalLimitBps=0&id=LDGRIQD-WVZZA2S-
VYEZMFO-KYP5GAM-RH3FXKE-IKNDYST-YHKQ3OV-LWSYZQX&networkTimeout=2m0s&pingInterval=1m0s&providedBy=&sessionLimitBps=0&statusAddr
=%3A22070 quic://172.16.0.241:22000 quic://172.16.0.37:22000 quic://172.24.0.1:22000 quic://172.19.0.1:22000 quic://172.21.0.1
:22000 quic://172.20.0.1:22000 quic://172.17.77.1:22000 quic://172.18.0.1:22000 quic://188.192.136.70:61729]
4: 
4: ✔ Validation was successful.
1/6 Test #4: syncthingtray_appstream_validation .............   Passed    1.72 sec
test 5
    Start 5: syncthingplasmoid_appstream_validation

5: Test command: /usr/bin/appstreamcli "validate" "/home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/plasmoid
/lib/resources/syncthingplasmoid.appdata.xml"
5: Working Directory: /home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/plasmoid/lib
5: Test timeout computed to be: 10000000
1:  - Connection status changed to: disconnected
1:  - Connection status changed to: disconnected
1:  - Connection status changed to: disconnected
1:  - Connection status changed to: disconnected
1:  - Connection error: Unable to request Syncthing status: Host requires authentication
1:  - Connection status changed to: disconnected
1:  - Connection status changed to: disconnected
1: 
1:  - Error handling in case of wrong credentials ...
1:  - Connection error: Unable to request Syncthing config: Host requires authentication
1:  - Connection status changed to: disconnected
1:  - Connection status changed to: disconnected
1: 
1:  - Error handling in case of wrong API key  ...
1: [2QOBR] 2022/12/16 15:51:53 VERBOSE: Login successful for username nobody.
1:  - Connection error: Unable to request Syncthing config: Error transferring http://nobody:supersecret@127.0.0.1:49217/rest/
system/config - server replied: Forbidden
1:  - Connection status changed to: disconnected
1:  - Connection status changed to: disconnected
1: 
1:  - Connecting initially ...
1: [2QOBR] 2022/12/16 15:51:53 VERBOSE: Login successful for username nobody.
1:  - Connection status changed to: connected, paused
1: 
1:  - Reconnecting ...
1:  - Connection status changed to: reconnecting
1: 
1:  - Waiting for dirs/devs after reconnect ...
1:  - Connection status changed to: connected, paused
1: 
1:  - Resuming all devices ...
1: [2QOBR] 2022/12/16 15:51:53 INFO: Resuming MMGUI6U-WUEZQCP-XZZ6VYB-LCT4TVC-ER2HAVX-QYT6X7D-S6ZSG2B-323KLQ7
1: [2QOBR] 2022/12/16 15:51:53 VERBOSE: Device MMGUI6U-WUEZQCP-XZZ6VYB-LCT4TVC-ER2HAVX-QYT6X7D-S6ZSG2B-323KLQ7 was resumed
1:  - Connection status changed to: connected
1: [2QOBR] 2022/12/16 15:51:53 VERBOSE: Configuration was saved
1: 
1:  - Resuming all dirs ...
3: PASS   : WizardTests::testConfiguringLauncher()
3: Info: Launched process, PID: 336884
3: QWARN  : WizardTests::testConfiguringCurrentlyRunningSyncthing() QFSFileEngine::open: No file name specified
1: [2QOBR] 2022/12/16 15:51:53 INFO: No stored folder metadata for "test2"; recalculating
1: [2QOBR] 2022/12/16 15:51:53 INFO: Ready to synchronize "Test dir 2" (test2) (sendreceive)
1: [2QOBR] 2022/12/16 15:51:53 INFO: Unpaused folder "Test dir 2" (test2) (sendreceive)
1: [2QOBR] 2022/12/16 15:51:53 VERBOSE: Folder test2 (Test dir 2) was resumed
1: [2QOBR] 2022/12/16 15:51:53 VERBOSE: Folder "test2" is now scan-waiting
1: [2QOBR] 2022/12/16 15:51:53 VERBOSE: Folder "test2" is now scanning
1: [2QOBR] 2022/12/16 15:51:53 INFO: Completed initial scan of sendreceive folder "Test dir 2" (test2)
1: [2QOBR] 2022/12/16 15:51:53 VERBOSE: Folder "test2" is now idle
1:  - Connection status changed to: connected, scanning
1:  - Connection status changed to: connected
3: FAIL!  : WizardTests::testConfiguringCurrentlyRunningSyncthing() '!cfgCurrentlyRunningRadioButton->isHidden()' returned FAL
SE. ()
3:    Loc: [/home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/widgets/tests/wizard.cpp(334)]
3: QDEBUG : WizardTests::cleanupTestCase() Syncthing log during testrun:
3:  [start] 2022/12/16 15:51:50 INFO: syncthing v1.22.1 "Fermium Flea" (go1.19.3 linux-amd64) syncthing@archlinux 2022-11-03 0
7:35:59 UTC [noupgrade]
3: [start] 2022/12/16 15:51:50 INFO: Generating ECDSA key and certificate for syncthing...
3: [start] 2022/12/16 15:51:50 INFO: Default folder created and/or linked to new config
3: [start] 2022/12/16 15:51:50 INFO: Default config saved. Edit /tmp/syncthingwidgets_wizard_tests-lBmEuf/config.xml to taste 
(with Syncthing stopped) or use the GUI
3: [start] 2022/12/16 15:51:50 INFO: Archiving a copy of old config file format at: /tmp/syncthingwidgets_wizard_tests-lBmEuf/
config.xml.v0
3: [D44DU] 2022/12/16 15:51:50 INFO: My ID: D44DUSS-JKYRXL7-MJHCZ5A-WVC6P2H-5A5L55Y-EPKGYA6-HWD44GL-EMNCYQM
3: [D44DU] 2022/12/16 15:51:51 INFO: Single thread SHA256 performance is 426 MB/s using crypto/sha256 (421 MB/s using minio/sh
a256-simd).
3: [D44DU] 2022/12/16 15:51:52 INFO: Hashing performance is 361.83 MB/s
3: [D44DU] 2022/12/16 15:51:52 INFO: Running database migration 1...
3: [D44DU] 2022/12/16 15:51:52 INFO: Running database migration 2...
3: [D44DU] 2022/12/16 15:51:52 INFO: Running database migration 3...
3: [D44DU] 2022/12/16 15:51:52 INFO: Running database migration 5...
3: [D44DU] 2022/12/16 15:51:52 INFO: Running database migration 6...
3: [D44DU] 2022/12/16 15:51:52 INFO: Running database migration 7...
3: [D44DU] 2022/12/16 15:51:52 INFO: Running database migration 9...
3: [D44DU] 2022/12/16 15:51:52 INFO: Running database migration 10...
3: [D44DU] 2022/12/16 15:51:52 INFO: Running database migration 11...
3: [D44DU] 2022/12/16 15:51:52 INFO: Running database migration 13...
3: [D44DU] 2022/12/16 15:51:52 INFO: Running database migration 14...
3: [D44DU] 2022/12/16 15:51:52 INFO: Running database migration 16...
3: [D44DU] 2022/12/16 15:51:52 INFO: Running database migration 17...
3: [D44DU] 2022/12/16 15:51:52 INFO: Running database migration 19...
3: [D44DU] 2022/12/16 15:51:52 INFO: Compacting database after migration...
3: [D44DU] 2022/12/16 15:51:52 INFO: Overall send rate is unlimited, receive rate is unlimited
3: [D44DU] 2022/12/16 15:51:52 INFO: No stored folder metadata for "default"; recalculating
3: [D44DU] 2022/12/16 15:51:52 INFO: Relay listener (dynamic+https://relays.syncthing.net/endpoint) starting
3: [D44DU] 2022/12/16 15:51:52 INFO: Using discovery mechanism: global discovery server https://discovery.syncthing.net/v2/?no
announce&id=LYXKCHX-VI3NYZR-ALCJBHF-WMZYSPK-QG6QJA3-MPFYMSO-U56GTUK-NA2MIAW
3: [D44DU] 2022/12/16 15:51:52 INFO: Using discovery mechanism: global discovery server https://discovery-v4.syncthing.net/v2/
?nolookup&id=LYXKCHX-VI3NYZR-ALCJBHF-WMZYSPK-QG6QJA3-MPFYMSO-U56GTUK-NA2MIAW
3: [D44DU] 2022/12/16 15:51:52 INFO: Using discovery mechanism: global discovery server https://discovery-v6.syncthing.net/v2/
?nolookup&id=LYXKCHX-VI3NYZR-ALCJBHF-WMZYSPK-QG6QJA3-MPFYMSO-U56GTUK-NA2MIAW
3: [D44DU] 2022/12/16 15:51:52 INFO: Using discovery mechanism: IPv4 local broadcast discovery on port 21027
3: [D44DU] 2022/12/16 15:51:52 INFO: Using discovery mechanism: IPv6 local multicast discovery on address [ff12::8384]:21027
3: [D44DU] 2022/12/16 15:51:52 INFO: Ready to synchronize "Default Folder" (default) (sendreceive)
3: [D44DU] 2022/12/16 15:51:52 INFO: Loading HTTPS certificate: open /tmp/syncthingwidgets_wizard_tests-lBmEuf/https-cert.pem:
 no such file or directory
3: [D44DU] 2022/12/16 15:51:52 INFO: Creating new HTTPS certificate
3: [D44DU] 2022/12/16 15:51:52 INFO: TCP listener ([::]:39271) starting
3: [D44DU] 2022/12/16 15:51:52 INFO: QUIC listener ([::]:39271) starting
3: [D44DU] 2022/12/16 15:51:52 INFO: Completed initial scan of sendreceive folder "Default Folder" (default)
3: [D44DU] 2022/12/16 15:51:52 WARNING: Failed starting API: listen tcp 127.0.0.1:49217: bind: address already in use
3: [D44DU] 2022/12/16 15:51:52 INFO: QUIC listener ([::]:39271) shutting down
3: [D44DU] 2022/12/16 15:51:52 INFO: Detected 1 NAT service
3: [D44DU] 2022/12/16 15:51:52 INFO: Relay listener (dynamic+https://relays.syncthing.net/endpoint) shutting down
3: [D44DU] 2022/12/16 15:51:52 WARNING: Starting API/GUI: listen tcp 127.0.0.1:49217: bind: address already in use
3: [D44DU] 2022/12/16 15:51:53 INFO: TCP listener ([::]:39271) shutting down
3: [D44DU] 2022/12/16 15:51:53 INFO: Exiting
3: 
3: PASS   : WizardTests::cleanupTestCase()
3: Totals: 4 passed, 1 failed, 0 skipped, 0 blacklisted, 2609ms
3: ********* Finished testing of WizardTests *********
1: [2QOBR] 2022/12/16 15:51:53 VERBOSE: Configuration was saved
1: 
1:  - Pause dir 1 ...
1: [2QOBR] 2022/12/16 15:51:53 INFO: Paused folder test1 (sendreceive)
1: [2QOBR] 2022/12/16 15:51:53 VERBOSE: Folder test1 () was paused
1: [2QOBR] 2022/12/16 15:51:53 VERBOSE: Configuration was saved
1: 
1:  - Requesting log ...
2/6 Test #3: syncthingwidgets_run_wizard_tests ..............***Failed    2.84 sec
********* Start testing of WizardTests *********
Config: Using QtTest library 5.15.7, Qt 5.15.7 (x86_64-little_endian-lp64 shared (dynamic) release build; by GCC 12.2.0), arch
 unknown
QDEBUG : WizardTests::initTestCase() "HOME dir: /tmp/syncthingwidgets_wizard_tests-lBmEuf"
PASS   : WizardTests::initTestCase()
PASS   : WizardTests::testShowingSettings()
QWARN  : WizardTests::testConfiguringLauncher() This plugin does not support propagateSizeHints()
QWARN  : WizardTests::testConfiguringLauncher() QFSFileEngine::open: No file name specified
Info: Launched process, PID: 336841
QWARN  : WizardTests::testConfiguringLauncher() QFSFileEngine::open: No file name specified
Info: Launched process, PID: 336847
QDEBUG : WizardTests::testConfiguringLauncher() waiting for Syncthing to write config file
PASS   : WizardTests::testConfiguringLauncher()
Info: Launched process, PID: 336884
QWARN  : WizardTests::testConfiguringCurrentlyRunningSyncthing() QFSFileEngine::open: No file name specified
FAIL!  : WizardTests::testConfiguringCurrentlyRunningSyncthing() '!cfgCurrentlyRunningRadioButton->isHidden()' returned FALSE.
 ()
   Loc: [/home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/widgets/tests/wizard.cpp(334)]
QDEBUG : WizardTests::cleanupTestCase() Syncthing log during testrun:
 [start] 2022/12/16 15:51:50 INFO: syncthing v1.22.1 "Fermium Flea" (go1.19.3 linux-amd64) syncthing@archlinux 2022-11-03 07:3
5:59 UTC [noupgrade]
[start] 2022/12/16 15:51:50 INFO: Generating ECDSA key and certificate for syncthing...
[start] 2022/12/16 15:51:50 INFO: Default folder created and/or linked to new config
[start] 2022/12/16 15:51:50 INFO: Default config saved. Edit /tmp/syncthingwidgets_wizard_tests-lBmEuf/config.xml to taste (wi
th Syncthing stopped) or use the GUI
[start] 2022/12/16 15:51:50 INFO: Archiving a copy of old config file format at: /tmp/syncthingwidgets_wizard_tests-lBmEuf/con
fig.xml.v0
[D44DU] 2022/12/16 15:51:50 INFO: My ID: D44DUSS-JKYRXL7-MJHCZ5A-WVC6P2H-5A5L55Y-EPKGYA6-HWD44GL-EMNCYQM
[D44DU] 2022/12/16 15:51:51 INFO: Single thread SHA256 performance is 426 MB/s using crypto/sha256 (421 MB/s using minio/sha25
6-simd).
[D44DU] 2022/12/16 15:51:52 INFO: Hashing performance is 361.83 MB/s
[D44DU] 2022/12/16 15:51:52 INFO: Running database migration 1...
[D44DU] 2022/12/16 15:51:52 INFO: Running database migration 2...
[D44DU] 2022/12/16 15:51:52 INFO: Running database migration 3...
[D44DU] 2022/12/16 15:51:52 INFO: Running database migration 5...
[D44DU] 2022/12/16 15:51:52 INFO: Running database migration 6...
[D44DU] 2022/12/16 15:51:52 INFO: Running database migration 7...
[D44DU] 2022/12/16 15:51:52 INFO: Running database migration 9...
[D44DU] 2022/12/16 15:51:52 INFO: Running database migration 10...
[D44DU] 2022/12/16 15:51:52 INFO: Running database migration 11...
[D44DU] 2022/12/16 15:51:52 INFO: Running database migration 13...
[D44DU] 2022/12/16 15:51:52 INFO: Running database migration 14...
[D44DU] 2022/12/16 15:51:52 INFO: Running database migration 16...
[D44DU] 2022/12/16 15:51:52 INFO: Running database migration 17...
[D44DU] 2022/12/16 15:51:52 INFO: Running database migration 19...
[D44DU] 2022/12/16 15:51:52 INFO: Compacting database after migration...
[D44DU] 2022/12/16 15:51:52 INFO: Overall send rate is unlimited, receive rate is unlimited
[D44DU] 2022/12/16 15:51:52 INFO: No stored folder metadata for "default"; recalculating
[D44DU] 2022/12/16 15:51:52 INFO: Relay listener (dynamic+https://relays.syncthing.net/endpoint) starting
[D44DU] 2022/12/16 15:51:52 INFO: Using discovery mechanism: global discovery server https://discovery.syncthing.net/v2/?noann
ounce&id=LYXKCHX-VI3NYZR-ALCJBHF-WMZYSPK-QG6QJA3-MPFYMSO-U56GTUK-NA2MIAW
[D44DU] 2022/12/16 15:51:52 INFO: Using discovery mechanism: global discovery server https://discovery-v4.syncthing.net/v2/?no
lookup&id=LYXKCHX-VI3NYZR-ALCJBHF-WMZYSPK-QG6QJA3-MPFYMSO-U56GTUK-NA2MIAW
[D44DU] 2022/12/16 15:51:52 INFO: Using discovery mechanism: global discovery server https://discovery-v6.syncthing.net/v2/?no
lookup&id=LYXKCHX-VI3NYZR-ALCJBHF-WMZYSPK-QG6QJA3-MPFYMSO-U56GTUK-NA2MIAW
[D44DU] 2022/12/16 15:51:52 INFO: Using discovery mechanism: IPv4 local broadcast discovery on port 21027
[D44DU] 2022/12/16 15:51:52 INFO: Using discovery mechanism: IPv6 local multicast discovery on address [ff12::8384]:21027
[D44DU] 2022/12/16 15:51:52 INFO: Ready to synchronize "Default Folder" (default) (sendreceive)
[D44DU] 2022/12/16 15:51:52 INFO: Loading HTTPS certificate: open /tmp/syncthingwidgets_wizard_tests-lBmEuf/https-cert.pem: no
 such file or directory
[D44DU] 2022/12/16 15:51:52 INFO: Creating new HTTPS certificate
[D44DU] 2022/12/16 15:51:52 INFO: TCP listener ([::]:39271) starting
[D44DU] 2022/12/16 15:51:52 INFO: QUIC listener ([::]:39271) starting
[D44DU] 2022/12/16 15:51:52 INFO: Completed initial scan of sendreceive folder "Default Folder" (default)
[D44DU] 2022/12/16 15:51:52 WARNING: Failed starting API: listen tcp 127.0.0.1:49217: bind: address already in use
[D44DU] 2022/12/16 15:51:52 INFO: QUIC listener ([::]:39271) shutting down
[D44DU] 2022/12/16 15:51:52 INFO: Detected 1 NAT service
[D44DU] 2022/12/16 15:51:52 INFO: Relay listener (dynamic+https://relays.syncthing.net/endpoint) shutting down
[D44DU] 2022/12/16 15:51:52 WARNING: Starting API/GUI: listen tcp 127.0.0.1:49217: bind: address already in use
[D44DU] 2022/12/16 15:51:53 INFO: TCP listener ([::]:39271) shutting down
[D44DU] 2022/12/16 15:51:53 INFO: Exiting

PASS   : WizardTests::cleanupTestCase()
Totals: 4 passed, 1 failed, 0 skipped, 0 blacklisted, 2609ms
********* Finished testing of WizardTests *********

test 6
    Start 6: syncthingfileitemaction_appstream_validation

6: Test command: /usr/bin/appstreamcli "validate" "/home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/fileitem
actionplugin/resources/syncthingfileitemaction.appdata.xml"
6: Working Directory: /home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/fileitemactionplugin
6: Test timeout computed to be: 10000000
1: 
1:  - Requesting QR-Code for own device ID ...
1: 
1:  - Disconnecting while there are outstanding requests ...
1:  - Connection status changed to: disconnected
1: 
1:  - Connecting with settings ...
1:  - Connection status changed to: reconnecting
1:  - Connection status changed to: connected
1: 
1:  - Requesting rescan ...
1: [2QOBR] 2022/12/16 15:51:53 VERBOSE: Folder "test2" is now scan-waiting
1: [2QOBR] 2022/12/16 15:51:53 VERBOSE: Folder "test2" is now scanning
1: [2QOBR] 2022/12/16 15:51:53 VERBOSE: Folder "test2" is now idle
1:  - Connection status changed to: connected, scanning
1:  - Connection status changed to: connected
1:  - Connection error: Unable to request rescan: Error transferring http://127.0.0.1:49217/rest/db/scan?folder=non-existing-d
ir&sub=sub/path - server replied: Internal Server Error
1: 
1:  - Changing arbitrary config ...
1: [2QOBR] 2022/12/16 15:51:53 VERBOSE: Configuration was saved
1: 
1:  - Waiting for Syncthing to terminate ...
1: [monitor] 2022/12/16 15:51:53 INFO: Signal 15 received; exiting
1: [2QOBR] 2022/12/16 15:51:53 INFO: Detected 1 NAT service
5: 
5: ✔ Validation was successful.
3/6 Test #5: syncthingplasmoid_appstream_validation .........   Passed    1.22 sec
6: 
6: ✔ Validation was successful.
4/6 Test #6: syncthingfileitemaction_appstream_validation ...   Passed    0.50 sec
1: [2QOBR] 2022/12/16 15:51:54 INFO: TCP listener (127.0.0.1:32452) shutting down
1: [2QOBR] 2022/12/16 15:51:54 INFO: Exiting
1: Info: Launched process 336810 exited with error: No child processes
1: 
1:  - Syncthing terminated with exit code -1.
1: ......
1: 
1: 
1: OK (7 tests)
1: 
1: 
1: Tests successful
5/6 Test #1: syncthingconnector_run_tests ...................   Passed    3.63 sec
test 2
    Start 2: syncthingctl_run_tests

2: Test command: /home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/syncthingctl_tests "-p" "/home/janek/.
local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/testfiles" "-w" "/home/janek/.local/cache/yay/syncthingtray/src/sync
thingtray-1.3.1/cli/testworkingdir" "-a" "/home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/syncthingctl"
2: Working Directory: /home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli
2: Test timeout computed to be: 10000000
2: /home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/testfiles/
2: /home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/testfiles/
2: ./testfiles/
2: Directory used to store working copies:
2: /home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/testworkingdir/
2: Executing test cases ...
2: .
2:  - Setup configuration for Syncthing tests ...
2:  - Using timeout factor 3
2: 
2:  - Launching Syncthing: syncthing -gui-address=http://127.0.0.1:49217 -gui-apikey=syncthingtestinstance -home=/home/janek/.
local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/testworkingdir/testconfig -no-browser -verbose
2: Info: Launched process, PID: 336895
2: 
2: Waiting till Syncthing GUI becomes available ...
2: [start] 2022/12/16 15:51:54 INFO: syncthing v1.22.1 "Fermium Flea" (go1.19.3 linux-amd64) syncthing@archlinux 2022-11-03 07
:35:59 UTC [noupgrade]
2: [start] 2022/12/16 15:51:54 INFO: Generating ECDSA key and certificate for syncthing...
2: [start] 2022/12/16 15:51:54 INFO: Archiving a copy of old config file format at: /home/janek/.local/cache/yay/syncthingtray
/src/syncthingtray-1.3.1/cli/testworkingdir/testconfig/config.xml.v28
2: [2BKBH] 2022/12/16 15:51:54 INFO: My ID: 2BKBHLY-OPWZ7RC-ROGBUM7-2Y7D3QK-FGSH77M-IXQU4QA-MOHTRMN-2MZYEQQ
2: [2BKBH] 2022/12/16 15:51:55 INFO: Single thread SHA256 performance is 425 MB/s using minio/sha256-simd (415 MB/s using cryp
to/sha256).
2: [2BKBH] 2022/12/16 15:51:55 VERBOSE: Starting up (/home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/te
stworkingdir/testconfig)
2: [2BKBH] 2022/12/16 15:51:55 INFO: Hashing performance is 365.06 MB/s
2: [2BKBH] 2022/12/16 15:51:55 INFO: Running database migration 1...
2: [2BKBH] 2022/12/16 15:51:55 INFO: Running database migration 2...
2: [2BKBH] 2022/12/16 15:51:55 INFO: Running database migration 3...
2: [2BKBH] 2022/12/16 15:51:55 INFO: Running database migration 5...
2: [2BKBH] 2022/12/16 15:51:55 INFO: Running database migration 6...
2: [2BKBH] 2022/12/16 15:51:55 INFO: Running database migration 7...
2: [2BKBH] 2022/12/16 15:51:55 INFO: Running database migration 9...
2: [2BKBH] 2022/12/16 15:51:55 INFO: Running database migration 10...
2: [2BKBH] 2022/12/16 15:51:55 INFO: Running database migration 11...
2: [2BKBH] 2022/12/16 15:51:55 INFO: Running database migration 13...
2: [2BKBH] 2022/12/16 15:51:55 INFO: Running database migration 14...
2: [2BKBH] 2022/12/16 15:51:55 INFO: Running database migration 16...
2: [2BKBH] 2022/12/16 15:51:55 INFO: Running database migration 17...
2: [2BKBH] 2022/12/16 15:51:55 INFO: Running database migration 19...
2: [2BKBH] 2022/12/16 15:51:55 INFO: Compacting database after migration...
2: [2BKBH] 2022/12/16 15:51:55 INFO: Overall send rate is unlimited, receive rate is unlimited
2: [2BKBH] 2022/12/16 15:51:55 INFO: No stored folder metadata for "test1"; recalculating
2: [2BKBH] 2022/12/16 15:51:55 INFO: Ready to synchronize test1 (sendreceive)
2: [2BKBH] 2022/12/16 15:51:55 INFO: Using discovery mechanism: global discovery server https://discovery.syncthing.net/v2/?no
announce&id=LYXKCHX-VI3NYZR-ALCJBHF-WMZYSPK-QG6QJA3-MPFYMSO-U56GTUK-NA2MIAW
2: [2BKBH] 2022/12/16 15:51:55 INFO: Using discovery mechanism: global discovery server https://discovery-v4.syncthing.net/v2/
?nolookup&id=LYXKCHX-VI3NYZR-ALCJBHF-WMZYSPK-QG6QJA3-MPFYMSO-U56GTUK-NA2MIAW
2: [2BKBH] 2022/12/16 15:51:55 INFO: Using discovery mechanism: global discovery server https://discovery-v6.syncthing.net/v2/
?nolookup&id=LYXKCHX-VI3NYZR-ALCJBHF-WMZYSPK-QG6QJA3-MPFYMSO-U56GTUK-NA2MIAW
2: [2BKBH] 2022/12/16 15:51:55 INFO: TCP listener (127.0.0.1:32452) starting
2: [2BKBH] 2022/12/16 15:51:55 INFO: Using discovery mechanism: IPv4 local broadcast discovery on port 21027
2: [2BKBH] 2022/12/16 15:51:55 INFO: Using discovery mechanism: IPv6 local multicast discovery on address [ff12::8384]:21027
2: [2BKBH] 2022/12/16 15:51:55 VERBOSE: Listen address tcp://127.0.0.1:32452 resolution has changed: lan addresses: [tcp://127
.0.0.1:32452] wan addresses: [tcp://0.0.0.0:0 tcp://127.0.0.1:32452]
2: [2BKBH] 2022/12/16 15:51:55 VERBOSE: Folder "test1" is now scan-waiting
2: [2BKBH] 2022/12/16 15:51:55 INFO: Loading HTTPS certificate: open /home/janek/.local/cache/yay/syncthingtray/src/syncthingt
ray-1.3.1/cli/testworkingdir/testconfig/https-cert.pem: no such file or directory
2: [2BKBH] 2022/12/16 15:51:55 INFO: Creating new HTTPS certificate
2: [2BKBH] 2022/12/16 15:51:55 VERBOSE: Folder "test1" is now scanning
2: [2BKBH] 2022/12/16 15:51:55 INFO: Completed initial scan of sendreceive folder test1
2: [2BKBH] 2022/12/16 15:51:55 VERBOSE: Folder "test1" is now idle
2: [2BKBH] 2022/12/16 15:51:55 INFO: GUI and API listening on 127.0.0.1:49217
2: [2BKBH] 2022/12/16 15:51:55 INFO: Access the GUI via the following URL: http://127.0.0.1:49217/
2: - /home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/syncthingctl status --api-key syncthingtestinstanc
e --url http://localhost:49217 --no-color
Overall statisticsg to http://localhost:49217 ...
2:    Status                        idle
2:       Global                        0 file(s), 0 dir(s), 0 bytes
2:       Local                         0 file(s), 0 dir(s), 0 bytes
2:    Incoming traffic              0 bytes
2:    Outgoing traffic              0 bytes
2:    Connected to                  no other devices
2:    Uptime                        1 s
2:    Version                       syncthing v1.22.1 "Fermium Flea" (go1.19.3 linux-amd64) syncthing@archlinux 2022-11-03 07:
35:59 UTC [noupgrade]
2: 
2: Directories
2:  - test2
2:    Label                         Test dir 2
2:    Path                          /tmp/some/path/2/
2:    Status                        paused
2:    Shared with                   Test dev 2
2:    Type                          Send & Receive
2:    Ignore permissions            no
2:    Auto-normalize                yes
2:    Rescan interval               365 d, file system watcher disabled
2: 
2:  - test1
2:    Path                          /tmp/some/path/1/
2:    Status                        idle
2:       Global                        0 file(s), 0 dir(s), 0 bytes
2:       Local                         0 file(s), 0 dir(s), 0 bytes
2:    Last scan time                2022-12-16 15:51:55
2:    Shared with                   Test dev 2
2:                                  Test dev 1
2:    Remote progress               all up-to-date
2:       Test dev 2                    0 bytes / 0 bytes (100 %)
2:       Test dev 1                    0 bytes / 0 bytes (100 %)
2:    Type                          Send & Receive
2:    Ignore permissions            no
2:    Auto-normalize                yes
2:    Rescan interval               2 h, file system watcher disabled
2: 
2: Devices
2:  - elephant.arch
2:    ID                            2BKBHLY-OPWZ7RC-ROGBUM7-2Y7D3QK-FGSH77M-IXQU4QA-MOHTRMN-2MZYEQQ
2:    Status                        own device
2:    Addresses                     dynamic
2:    Compression                   metadata
2: 
2:  - Test dev 1
2:    ID                            6EIS2PN-J2IHWGS-AXS3YUL-HC5FT3K-77ZXTLL-AKQLJ4C-7SWVPUS-AZW4RQ4
2:    Status                        disconnected
2:    Addresses                     dynamic
2:    Compression                   metadata
2: 
2:  - Test dev 2
2:    ID                            MMGUI6U-WUEZQCP-XZZ6VYB-LCT4TVC-ER2HAVX-QYT6X7D-S6ZSG2B-323KLQ7
2:    Status                        paused
2:    Addresses                     tcp://192.168.2.2:22001
2:    Compression                   metadata
2: 
2: - /home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/syncthingctl log --api-key syncthingtestinstance -
-url http://localhost:49217
2: 2022-12-16 15:51:54: My ID: 2BKBHLY-OPWZ7RC-ROGBUM7-2Y7D3QK-FGSH77M-IXQU4QA-MOHTRMN-2MZYEQQ
2: 2022-12-16 15:51:55: Single thread SHA256 performance is 425 MB/s using minio/sha256-simd (415 MB/s using crypto/sha256).
2: 2022-12-16 15:51:55: Starting up (/home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/testworkingdir/tes
tconfig)
2: 2022-12-16 15:51:55: Hashing performance is 365.06 MB/s
2: 2022-12-16 15:51:55: Running database migration 1...
2: 2022-12-16 15:51:55: Running database migration 2...
2: 2022-12-16 15:51:55: Running database migration 3...
2: 2022-12-16 15:51:55: Running database migration 5...
2: 2022-12-16 15:51:55: Running database migration 6...
2: 2022-12-16 15:51:55: Running database migration 7...
2: 2022-12-16 15:51:55: ...
2: 2022-12-16 15:51:55: Running database migration 9...
2: 2022-12-16 15:51:55: Running database migration 10...
2: 2022-12-16 15:51:55: Running database migration 11...
2: 2022-12-16 15:51:55: Running database migration 13...
2: 2022-12-16 15:51:55: Running database migration 14...
2: 2022-12-16 15:51:55: Running database migration 16...
2: 2022-12-16 15:51:55: Running database migration 17...
2: 2022-12-16 15:51:55: Running database migration 19...
2: 2022-12-16 15:51:55: Compacting database after migration...
2: 2022-12-16 15:51:55: Overall send rate is unlimited, receive rate is unlimited
2: 2022-12-16 15:51:55: No stored folder metadata for "test1"; recalculating
2: 2022-12-16 15:51:55: Ready to synchronize test1 (sendreceive)
2: 2022-12-16 15:51:55: Using discovery mechanism: global discovery server https://discovery.syncthing.net/v2/?noannounce&id=L
YXKCHX-VI3NYZR-ALCJBHF-WMZYSPK-QG6QJA3-MPFYMSO-U56GTUK-NA2MIAW
2: 2022-12-16 15:51:55: Using discovery mechanism: global discovery server https://discovery-v4.syncthing.net/v2/?nolookup&id=
LYXKCHX-VI3NYZR-ALCJBHF-WMZYSPK-QG6QJA3-MPFYMSO-U56GTUK-NA2MIAW
2: 2022-12-16 15:51:55: Using discovery mechanism: global discovery server https://discovery-v6.syncthing.net/v2/?nolookup&id=
LYXKCHX-VI3NYZR-ALCJBHF-WMZYSPK-QG6QJA3-MPFYMSO-U56GTUK-NA2MIAW
2: 2022-12-16 15:51:55: TCP listener (127.0.0.1:32452) starting
2: 2022-12-16 15:51:55: Using discovery mechanism: IPv4 local broadcast discovery on port 21027
2: 2022-12-16 15:51:55: Using discovery mechanism: IPv6 local multicast discovery on address [ff12::8384]:21027
2: 2022-12-16 15:51:55: Listen address tcp://127.0.0.1:32452 resolution has changed: lan addresses: [tcp://127.0.0.1:32452] wa
n addresses: [tcp://0.0.0.0:0 tcp://127.0.0.1:32452]
2: 2022-12-16 15:51:55: Folder "test1" is now scan-waiting
2: 2022-12-16 15:51:55: Loading HTTPS certificate: open /home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli
/testworkingdir/testconfig/https-cert.pem: no such file or directory
2: 2022-12-16 15:51:55: Creating new HTTPS certificate
2: 2022-12-16 15:51:55: Folder "test1" is now scanning
2: 2022-12-16 15:51:55: Completed initial scan of sendreceive folder test1
2: 2022-12-16 15:51:55: Folder "test1" is now idle
2: 2022-12-16 15:51:55: GUI and API listening on 127.0.0.1:49217
2: 2022-12-16 15:51:55: Access the GUI via the following URL: http://127.0.0.1:49217/
2: 2022-12-16 15:51:55: My name is "elephant.arch"
2: 2022-12-16 15:51:55: Device MMGUI6U-WUEZQCP-XZZ6VYB-LCT4TVC-ER2HAVX-QYT6X7D-S6ZSG2B-323KLQ7 is "Test dev 2" at [tcp://192.1
68.2.2:22001]
2: 2022-12-16 15:51:55: Device 6EIS2PN-J2IHWGS-AXS3YUL-HC5FT3K-77ZXTLL-AKQLJ4C-7SWVPUS-AZW4RQ4 is "Test dev 1" at [dynamic]
2: 2022-12-16 15:51:55: Startup complete
2: - /home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/syncthingctl resume --dir test2
2: - /home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/syncthingctl status --all-dirs
2: - /home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/syncthingctl pause --dir test2
2: - /home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/syncthingctl status --dir test2
2: Directories
2:  - test2
2:    Label                         Test dir 2
2:    Path                          /tmp/some/path/2/
2:    Status                        paused
2:    Shared with                   Test dev 2
2:    Type                          Send & Receive
2:    Ignore permissions            no
2:    Auto-normalize                yes
2:    Rescan interval               365 d, file system watcher disabled
2: 
2: - /home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/syncthingctl cat
2: {
2:     "defaults": {
2:         "device": {
2:             "addresses": [
2:                 "dynamic"
2:             ],
2:             "allowedNetworks": [
2:             ],
2:             "autoAcceptFolders": false,
2:             "certName": "",
2:             "compression": "metadata",
2:             "deviceID": "",
2:             "ignoredFolders": [
2:             ],
2:             "introducedBy": "",
2:             "introducer": false,
2:             "maxRecvKbps": 0,
2:             "maxRequestKiB": 0,
2:             "maxSendKbps": 0,
2:             "name": "",
2:             "paused": false,
2:             "remoteGUIPort": 0,
2:             "skipIntroductionRemovals": false,
2:             "untrusted": false
2:         },
2:         "folder": {
2:             "autoNormalize": true,
2:             "blockPullOrder": "standard",
2:             "caseSensitiveFS": false,
2:             "copiers": 0,
2:             "copyOwnershipFromParent": false,
2:             "copyRangeMethod": "standard",
2:             "devices": [
2:                 {
2:                     "deviceID": "2BKBHLY-OPWZ7RC-ROGBUM7-2Y7D3QK-FGSH77M-IXQU4QA-MOHTRMN-2MZYEQQ",
2:                     "encryptionPassword": "",
2:                     "introducedBy": ""
2:                 }
2:             ],
2:             "disableFsync": false,
2:             "disableSparseFiles": false,
2:             "disableTempIndexes": false,
2:             "filesystemType": "basic",
2:             "fsWatcherDelayS": 10,
2:             "fsWatcherEnabled": true,
2:             "hashers": 0,
2:             "id": "",
2:             "ignoreDelete": false,
2:             "ignorePerms": false,
2:             "junctionsAsDirs": false,
2:             "label": "",
2:             "markerName": ".stfolder",
2:             "maxConcurrentWrites": 2,
2:             "maxConflicts": 10,
2:             "minDiskFree": {
2:                 "unit": "%",
2:                 "value": 1
2:             },
2:             "modTimeWindowS": 0,
2:             "order": "random",
2:             "path": "~",
2:             "paused": false,
2:             "pullerMaxPendingKiB": 0,
2:             "pullerPauseS": 0,
2:             "rescanIntervalS": 3600,
2:             "scanProgressIntervalS": 0,
2:             "sendOwnership": false,
2:             "sendXattrs": false,
2:             "syncOwnership": false,
2:             "syncXattrs": false,
2:             "type": "sendreceive",
2:             "versioning": {
2:                 "cleanupIntervalS": 3600,
2:                 "fsPath": "",
2:                 "fsType": "basic",
2:                 "params": {
2:                 },
2:                 "type": ""
2:             },
2:             "weakHashThresholdPct": 25,
2:             "xattrFilter": {
2:                 "entries": [
2:                 ],
2:                 "maxSingleEntrySize": 1024,
2:                 "maxTotalSize": 4096
2:             }
2:         },
2:         "ignores": {
2:             "lines": [
2:             ]
2:         }
2:     },
2:     "devices": [
2:         {
2:             "addresses": [
2:                 "tcp://192.168.2.2:22001"
2:             ],
2:             "allowedNetworks": [
2:             ],
2:             "autoAcceptFolders": false,
2:             "certName": "",
2:             "compression": "metadata",
2:             "deviceID": "MMGUI6U-WUEZQCP-XZZ6VYB-LCT4TVC-ER2HAVX-QYT6X7D-S6ZSG2B-323KLQ7",
2:             "ignoredFolders": [
2:             ],
2:             "introducedBy": "",
2:             "introducer": false,
2:             "maxRecvKbps": 0,
2:             "maxRequestKiB": 0,
2:             "maxSendKbps": 0,
2:             "name": "Test dev 2",
2:             "paused": true,
2:             "remoteGUIPort": 0,
2:             "skipIntroductionRemovals": false,
2:             "untrusted": false
2:         },
2:         {
2:             "addresses": [
2:                 "dynamic"
2:             ],
2:             "allowedNetworks": [
2:             ],
2:             "autoAcceptFolders": false,
2:             "certName": "",
2:             "compression": "metadata",
2:             "deviceID": "2BKBHLY-OPWZ7RC-ROGBUM7-2Y7D3QK-FGSH77M-IXQU4QA-MOHTRMN-2MZYEQQ",
2:             "ignoredFolders": [
2:             ],
2:             "introducedBy": "",
2:             "introducer": false,
2:             "maxRecvKbps": 0,
2:             "maxRequestKiB": 0,
2:             "maxSendKbps": 0,
2:             "name": "elephant.arch",
2:             "paused": false,
2:             "remoteGUIPort": 0,
2:             "skipIntroductionRemovals": false,
2:             "untrusted": false
2:         },
2:         {
2:             "addresses": [
2:                 "dynamic"
2:             ],
2:             "allowedNetworks": [
2:             ],
2:             "autoAcceptFolders": false,
2:             "certName": "",
2:             "compression": "metadata",
2:             "deviceID": "6EIS2PN-J2IHWGS-AXS3YUL-HC5FT3K-77ZXTLL-AKQLJ4C-7SWVPUS-AZW4RQ4",
2:             "ignoredFolders": [
2:             ],
2:             "introducedBy": "",
2:             "introducer": true,
2:             "maxRecvKbps": 0,
2:             "maxRequestKiB": 0,
2:             "maxSendKbps": 0,
2:             "name": "Test dev 1",
2:             "paused": false,
2:             "remoteGUIPort": 0,
2:             "skipIntroductionRemovals": false,
2:             "untrusted": false
2:         }
2:     ],
2:     "folders": [
2:         {
2:             "autoNormalize": true,
2:             "blockPullOrder": "standard",
2:             "caseSensitiveFS": false,
2:             "copiers": 1,
2:             "copyOwnershipFromParent": false,
2:             "copyRangeMethod": "standard",
2:             "devices": [
2:                 {
2:                     "deviceID": "MMGUI6U-WUEZQCP-XZZ6VYB-LCT4TVC-ER2HAVX-QYT6X7D-S6ZSG2B-323KLQ7",
2:                     "encryptionPassword": "",
2:                     "introducedBy": ""
2:                 },
2:                 {
2:                     "deviceID": "2BKBHLY-OPWZ7RC-ROGBUM7-2Y7D3QK-FGSH77M-IXQU4QA-MOHTRMN-2MZYEQQ",
2:                     "encryptionPassword": "",
2:                     "introducedBy": ""
2:                 },
2:                 {
2:                     "deviceID": "6EIS2PN-J2IHWGS-AXS3YUL-HC5FT3K-77ZXTLL-AKQLJ4C-7SWVPUS-AZW4RQ4",
2:                     "encryptionPassword": "",
2:                     "introducedBy": ""
2:                 }
2:             ],
2:             "disableFsync": false,
2:             "disableSparseFiles": false,
2:             "disableTempIndexes": false,
2:             "filesystemType": "basic",
2:             "fsWatcherDelayS": 10,
2:             "fsWatcherEnabled": false,
2:             "hashers": 0,
2:             "id": "test1",
2:             "ignoreDelete": false,
2:             "ignorePerms": false,
2:             "junctionsAsDirs": true,
2:             "label": "",
2:             "markerName": ".stfolder",
2:             "maxConcurrentWrites": 2,
2:             "maxConflicts": -1,
2:             "minDiskFree": {
2:                 "unit": "%",
2:                 "value": 1
2:             },
2:             "modTimeWindowS": 0,
2:             "order": "random",
2:             "path": "/tmp/some/path/1/",
2:             "paused": false,
2:             "pullerMaxPendingKiB": 2048,
2:             "pullerPauseS": 0,
2:             "rescanIntervalS": 7200,
2:             "scanProgressIntervalS": 0,
2:             "sendOwnership": false,
2:             "sendXattrs": false,
2:             "syncOwnership": false,
2:             "syncXattrs": false,
2:             "type": "sendreceive",
2:             "versioning": {
2:                 "cleanupIntervalS": 3600,
2:                 "fsPath": "",
2:                 "fsType": "basic",
2:                 "params": {
2:                 },
2:                 "type": ""
2:             },
2:             "weakHashThresholdPct": 25,
2:             "xattrFilter": {
2:                 "entries": [
2:                 ],
2:                 "maxSingleEntrySize": 0,
2:                 "maxTotalSize": 0
2:             }
2:         },
2:         {
2:             "autoNormalize": true,
2:             "blockPullOrder": "standard",
2:             "caseSensitiveFS": false,
2:             "copiers": 1,
2:             "copyOwnershipFromParent": false,
2:             "copyRangeMethod": "standard",
2:             "devices": [
2:                 {
2:                     "deviceID": "MMGUI6U-WUEZQCP-XZZ6VYB-LCT4TVC-ER2HAVX-QYT6X7D-S6ZSG2B-323KLQ7",
2:                     "encryptionPassword": "",
2:                     "introducedBy": ""
2:                 },
2:                 {
2:                     "deviceID": "2BKBHLY-OPWZ7RC-ROGBUM7-2Y7D3QK-FGSH77M-IXQU4QA-MOHTRMN-2MZYEQQ",
2:                     "encryptionPassword": "",
2:                     "introducedBy": ""
2:                 }
2:             ],
2:             "disableFsync": false,
2:             "disableSparseFiles": false,
2:             "disableTempIndexes": false,
2:             "filesystemType": "basic",
2:             "fsWatcherDelayS": 10,
2:             "fsWatcherEnabled": false,
2:             "hashers": 0,
2:             "id": "test2",
2:             "ignoreDelete": false,
2:             "ignorePerms": false,
2:             "junctionsAsDirs": true,
2:             "label": "Test dir 2",
2:             "markerName": ".stfolder",
2:             "maxConcurrentWrites": 2,
2:             "maxConflicts": -1,
2:             "minDiskFree": {
2:                 "unit": "%",
2:                 "value": 1
2:             },
2:             "modTimeWindowS": 0,
2:             "order": "random",
2:             "path": "/tmp/some/path/2/",
2:             "paused": true,
2:             "pullerMaxPendingKiB": 2048,
2:             "pullerPauseS": 0,
2:             "rescanIntervalS": 31536000,
2:             "scanProgressIntervalS": 0,
2:             "sendOwnership": false,
2:             "sendXattrs": false,
2:             "syncOwnership": false,
2:             "syncXattrs": false,
2:             "type": "sendreceive",
2:             "versioning": {
2:                 "cleanupIntervalS": 3600,
2:                 "fsPath": "",
2:                 "fsType": "basic",
2:                 "params": {
2:                 },
2:                 "type": ""
2:             },
2:             "weakHashThresholdPct": 25,
2:             "xattrFilter": {
2:                 "entries": [
2:                 ],
2:                 "maxSingleEntrySize": 0,
2:                 "maxTotalSize": 0
2:             }
2:         }
2:     ],
2:     "gui": {
2:         "address": "127.0.0.1:4001",
2:         "apiKey": "syncthingconnectortest",
2:         "authMode": "static",
2:         "debugging": false,
2:         "enabled": true,
2:         "insecureAdminAccess": false,
2:         "insecureAllowFrameLoading": false,
2:         "insecureSkipHostcheck": false,
2:         "password": "$2a$12$35MnbsQgQNn1hzPYK/lWXOaP.U5D2TO0nuuQy2M4gsqJB4ff4q2RK",
2:         "theme": "default",
2:         "unixSocketPermissions": "",
2:         "useTLS": false,
2:         "user": "nobody"
2:     },
2:     "ldap": {
2:         "address": "",
2:         "bindDN": "",
2:         "insecureSkipVerify": false,
2:         "searchBaseDN": "",
2:         "searchFilter": "",
2:         "transport": "plain"
2:     },
2:     "options": {
2:         "alwaysLocalNets": [
2:         ],
2:         "announceLANAddresses": true,
2:         "autoUpgradeIntervalH": 0,
2:         "cacheIgnoredFiles": false,
2:         "connectionLimitEnough": 0,
2:         "connectionLimitMax": 0,
2:         "crURL": "https://crash.syncthing.net/newcrash",
2:         "crashReportingEnabled": true,
2:         "databaseTuning": "auto",
2:         "featureFlags": [
2:         ],
2:         "globalAnnounceEnabled": true,
2:         "globalAnnounceServers": [
2:             "default"
2:         ],
2:         "insecureAllowOldTLSVersions": false,
2:         "keepTemporariesH": 24,
2:         "limitBandwidthInLan": false,
2:         "listenAddresses": [
2:             "tcp://127.0.0.1:32452"
2:         ],
2:         "localAnnounceEnabled": true,
2:         "localAnnounceMCAddr": "[ff12::8384]:21027",
2:         "localAnnouncePort": 21027,
2:         "maxConcurrentIncomingRequestKiB": 0,
2:         "maxFolderConcurrency": 0,
2:         "maxRecvKbps": 0,
2:         "maxSendKbps": 0,
2:         "minHomeDiskFree": {
2:             "unit": "%",
2:             "value": 1
2:         },
2:         "natEnabled": true,
2:         "natLeaseMinutes": 0,
2:         "natRenewalMinutes": 30,
2:         "natTimeoutSeconds": 10,
2:         "overwriteRemoteDeviceNamesOnConnect": false,
2:         "progressUpdateIntervalS": 5,
2:         "reconnectionIntervalS": 60,
2:         "relayReconnectIntervalM": 10,
2:         "relaysEnabled": true,
2:         "releasesURL": "https://upgrades.syncthing.net/meta.json",
2:         "sendFullIndexOnUpgrade": false,
2:         "setLowPriority": true,
2:         "startBrowser": true,
2:         "stunKeepaliveMinS": 20,
2:         "stunKeepaliveStartS": 180,
2:         "stunServers": [
2:             "default"
2:         ],
2:         "tempIndexMinBlocks": 10,
2:         "trafficClass": 0,
2:         "unackedNotificationIDs": [
2:             "fsWatcherNotification",
2:             "crAutoEnabled"
2:         ],
2:         "upgradeToPreReleases": true,
2:         "urAccepted": 2,
2:         "urInitialDelayS": 1800,
2:         "urPostInsecurely": false,
2:         "urSeen": 2,
2:         "urURL": "https://data.syncthing.net/newdata",
2:         "urUniqueId": "fhjO-ICd"
2:     },
2:     "remoteIgnoredDevices": [
2:     ],
2:     "version": 37
2: }
2: - /home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/syncthingctl edit --js-lines assignIfPresent(findF
older('test1'), 'rescanIntervalS', 0);
2: - /home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/syncthingctl status --dir test1
2: Directories
2:  - test1
2:    Path                          /tmp/some/path/1/
2:    Status                        idle
2:       Global                        0 file(s), 0 dir(s), 0 bytes
2:       Local                         0 file(s), 0 dir(s), 0 bytes
2:    Last scan time                2022-12-16 15:51:56
2:    Shared with                   Test dev 2
2:                                  Test dev 1
2:    Remote progress               all up-to-date
2:       Test dev 2                    0 bytes / 0 bytes (100 %)
2:       Test dev 1                    0 bytes / 0 bytes (100 %)
2:    Type                          Send & Receive
2:    Ignore permissions            no
2:    Auto-normalize                yes
2:    Rescan interval               file system watcher and periodic rescan disabled
2: 
2: - /home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/syncthingctl rescan test1
2: - /home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/syncthingctl status --dir test1
2: Directories
2:  - test1
2:    Path                          /tmp/some/path/1/
2:    Status                        idle
2:       Global                        1 file(s), 0 dir(s), 3 bytes
2:       Local                         1 file(s), 0 dir(s), 3 bytes
2:    Last scan time                2022-12-16 15:51:56
2:    Shared with                   Test dev 2
2:                                  Test dev 1
2:    Remote progress               some need bytes
2:       Test dev 1                    0 bytes / 3 bytes (0 %)
2:       Test dev 2                    0 bytes / 3 bytes (0 %)
2:    Type                          Send & Receive
2:    Ignore permissions            no
2:    Auto-normalize                yes
2:    Rescan interval               file system watcher and periodic rescan disabled
2: 
2: - /home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/syncthingctl pwd rescan
2: - /home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/syncthingctl pwd status
2:  - test1
2:    Path                          /tmp/some/path/1/
2:    Status                        idle
2:       Global                        2 file(s), 1 dir(s), 134 bytes
2:       Local                         2 file(s), 1 dir(s), 134 bytes
2:    Last scan time                2022-12-16 15:51:56
2:    Shared with                   Test dev 2
2:                                  Test dev 1
2:    Remote progress               some need bytes
2:       Test dev 1                    0 bytes / 134 bytes (0 %)
2:       Test dev 2                    0 bytes / 134 bytes (0 %)
2:    Type                          Send & Receive
2:    Ignore permissions            no
2:    Auto-normalize                yes
2:    Rescan interval               file system watcher and periodic rescan disabled
2: 
2: 
2:  - Waiting for Syncthing to terminate ...
2: Info: Launched process 336895 exited with error: No child processes
2: 
2:  - Syncthing terminated with exit code -1.
2: 
2: 
2: 
2: OK (1 tests)
2: 
2: 
2: Tests successful
6/6 Test #2: syncthingctl_run_tests .........................   Passed    3.54 sec

83% tests passed, 1 tests failed out of 6

Total Test time (real) =   7.17 sec

The following tests FAILED:
         3 - syncthingwidgets_run_wizard_tests (Failed)
Errors while running CTest
FAILED: connector/CMakeFiles/check /home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/connector/CMakeFiles/che
ck 
cd /home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1 && /usr/bin/ctest -V
ninja: build stopped: subcommand failed.
@Martchus
Copy link
Owner

Looks like the random port used for the test Syncthing instance is already in use for some reason. Maybe a previous test case couldn't terminate it's test instance cleanly or tests are wrongly executed in parallel.

@xeruf
Copy link
Author

xeruf commented Dec 16, 2022

but I tried over 3 times, and it kept on failing :/

@Martchus
Copy link
Owner

Martchus commented Dec 16, 2022

I'm not saying that the problem might not be persistent. I've just been observing the logs - and Syncthing clearly says that the UI port is already in use:

3: [D44DU] 2022/12/16 15:51:52 WARNING: Starting API/GUI: listen tcp 127.0.0.1:49217: bind: address already in use

And that's likely the reason for the test failure:

3: FAIL!  : WizardTests::testConfiguringCurrentlyRunningSyncthing() '!cfgCurrentlyRunningRadioButton->isHidden()' returned FAL
SE. ()
3:    Loc: [/home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/widgets/tests/wizard.cpp(334)]
3: QDEBUG : WizardTests::cleanupTestCase() Syncthing log during testrun:

I don't think the output of the different tests should be interleaved like it is in your logs, e.g.:

1:  - Resuming all dirs ...
3: PASS   : WizardTests::testConfiguringLauncher()
3: Info: Launched process, PID: 336884
3: QWARN  : WizardTests::testConfiguringCurrentlyRunningSyncthing() QFSFileEngine::open: No file name specified
1: [2QOBR] 2022/12/16 15:51:53 INFO: No stored folder metadata for "test2"; recalculating
…
1:  - Connection status changed to: connected
3: FAIL!  : WizardTests::testConfiguringCurrentlyRunningSyncthing() '!cfgCurrentlyRunningRadioButton->isHidden()' returned FAL
SE. ()
3:    Loc: [/home/janek/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/widgets/tests/wizard.cpp(334)]
3: QDEBUG : WizardTests::cleanupTestCase() Syncthing log during testrun:
3:  [start] 2022/12/16 15:51:50 INFO: syncthing v1.22.1 "Fermium Flea" (go1.19.3 linux-amd64) syncthing@archlinux 2022-11-03 0
7:35:59 UTC [noupgrade]

If this interleaving of "1:" and "3:" messages means that those test cases really ran in parallel then this is likely the culprit. Note that in my build environment those log messages never appear interleaved. (Tests should also actually be blocked from running in parallel via a lock so I'm not sure what's going on here.)

@Martchus
Copy link
Owner

Martchus commented Dec 16, 2022

I recommend running the wizard test individually to see whether it passes then or not. I also recommend checking for lingering Syncthing test instances before invoking a test. Sometimes it is also helpful to step though the test with the debugger. Since I cannot reproduce the issue myself and the exact source of the problem isn't immediately obvious I cannot help you much here.

@xeruf
Copy link
Author

xeruf commented Dec 17, 2022

The fact that I globally set CTEST_PARALLEL_LEVEL=3 should not be an issue anymore, I thought you fixed that, right? Because it sounds like it is.

@Martchus
Copy link
Owner

That variable could be the culprit although it should be fixed. Maybe the fix doesn't work as intended.

Since you can reproduce it so reliably, you can try executing the wizard test alone to cross check. I'll also cross check with CTEST_PARALLEL_LEVEL=3 enabled locally (on the full testsuite).

Martchus added a commit to Martchus/syncthingtray that referenced this issue Dec 17, 2022
@Martchus
Copy link
Owner

Martchus commented Dec 17, 2022

The resource lock for the wizard test (that I've only introduced recently) wasn't working, indeed. I've pushed a fix you can try if you like. Note that it would be useful to mention things like CTEST_PARALLEL_LEVEL=3 from the beginning.

@xeruf
Copy link
Author

xeruf commented Dec 17, 2022

I don't often do C++ development, so I didn't have it on my mind so far.
Unfortunately, unexporting the variable did not fix it:

[21/22] cd /home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1 && /usr/bin/ctest -V
UpdateCTestConfiguration  from :/home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/DartConfiguration.tcl
UpdateCTestConfiguration  from :/home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/DartConfiguration.tcl
Test project /home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1
Constructing a list of tests
Done constructing a list of tests
Updating test list for fixtures
Added 0 tests to meet fixture requirements
Checking test dependency graph...
Checking test dependency graph end
test 1
    Start 1: syncthingconnector_run_tests

1: Test command: /home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/connector/syncthingconnector_tests "-p" "/home/janekf/.local/cache/yay/syncthingtray/src
/syncthingtray-1.3.1/connector/testfiles" "-w" "/home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/connector/testworkingdir"
1: Working Directory: /home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/connector
1: Test timeout computed to be: 10000000
test 3
    Start 3: syncthingwidgets_run_wizard_tests

3: Test command: /home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/widgets/syncthingwidgets_wizard_tests
3: Working Directory: /home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/widgets
3: Test timeout computed to be: 10000000
test 4
    Start 4: syncthingtray_appstream_validation

4: Test command: /usr/bin/appstreamcli "validate" "/home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/tray/resources/syncthingtray.appdata.xml"
4: Working Directory: /home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/tray
4: Test timeout computed to be: 10000000
1: /home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/connector/testfiles/
1: /home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/connector/testfiles/
1: ./testfiles/
1: Directory used to store working copies:
1: /home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/connector/testworkingdir/
1: Executing test cases ...
1: .
1:  - Setup configuration for Syncthing tests ...
1:  - Using timeout factor 3
1: 
1:  - Launching Syncthing: syncthing -gui-address=http://127.0.0.1:52250 -gui-apikey=syncthingtestinstance -home=/home/janekf/.local/cache/yay/syncthingtray/src/syncthingtra
y-1.3.1/connector/testworkingdir/testconfig -no-browser -verbose
1: Info: Launched process, PID: 50381
1: 
1:  - Preparing connection ...
1: 
1:  - Error handling in case of insufficient configuration ...
1:  - Connection error: Connection configuration is insufficient.
1:  - Connection status changed to: disconnected
1: 
1:  - Error handling in case of inavailability ...
1: [start] 2022/12/18 00:47:17 INFO: syncthing v1.22.1 "Fermium Flea" (go1.19.3 linux-amd64) syncthing@archlinux 2022-11-03 07:35:59 UTC [noupgrade]
1: [start] 2022/12/18 00:47:17 INFO: Generating ECDSA key and certificate for syncthing...
1: [start] 2022/12/18 00:47:17 INFO: Archiving a copy of old config file format at: /home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/connector/testworking
dir/testconfig/config.xml.v28
1:  - Connection error: Unable to request Syncthing config: Connection refused
1:  - Connection error: Unable to request Syncthing status: Connection refused
1: [F77GG] 2022/12/18 00:47:17 INFO: My ID: F77GG2U-T32AWA6-JOE7GV2-KKWYOYW-65M7FDT-77HCHYK-5AHBPNE-AKAPCAQ
3: ********* Start testing of WizardTests *********
3: Config: Using QtTest library 5.15.7, Qt 5.15.7 (x86_64-little_endian-lp64 shared (dynamic) release build; by GCC 12.2.0), manjaro unknown
3: QDEBUG : WizardTests::initTestCase() "HOME dir: /tmp/syncthingwidgets_wizard_tests-ADBbgD"
3: PASS   : WizardTests::initTestCase()
3: PASS   : WizardTests::testShowingSettings()
3: QWARN  : WizardTests::testConfiguringLauncher() This plugin does not support propagateSizeHints()
3: QWARN  : WizardTests::testConfiguringLauncher() QFSFileEngine::open: No file name specified
3: Info: Launched process, PID: 50442
3: QWARN  : WizardTests::testConfiguringLauncher() QFSFileEngine::open: No file name specified
3: Info: Launched process, PID: 50448
3: QDEBUG : WizardTests::testConfiguringLauncher() waiting for Syncthing to write config file
1:  - Connection status changed to: disconnected
1:  - Connection status changed to: disconnected
1:  - Connection status changed to: disconnected
1:  - Connection status changed to: disconnected
1:  - Connection error: Unable to request Syncthing config: Connection refused
1:  - Connection error: Unable to request Syncthing status: Connection refused
1: [F77GG] 2022/12/18 00:47:18 INFO: Single thread SHA256 performance is 1847 MB/s using minio/sha256-simd (501 MB/s using crypto/sha256).
1: [F77GG] 2022/12/18 00:47:18 VERBOSE: Starting up (/home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/connector/testworkingdir/testconfig)
1:  - Connection status changed to: disconnected
1:  - Connection status changed to: disconnected
1:  - Connection status changed to: disconnected
1:  - Connection status changed to: disconnected
1:  - Connection error: Unable to request Syncthing config: Connection refused
1:  - Connection error: Unable to request Syncthing status: Connection refused
1: [F77GG] 2022/12/18 00:47:19 INFO: Hashing performance is 1147.06 MB/s
1: [F77GG] 2022/12/18 00:47:19 INFO: Running database migration 1...
1: [F77GG] 2022/12/18 00:47:19 INFO: Running database migration 2...
1: [F77GG] 2022/12/18 00:47:19 INFO: Running database migration 3...
1: [F77GG] 2022/12/18 00:47:19 INFO: Running database migration 5...
1: [F77GG] 2022/12/18 00:47:19 INFO: Running database migration 6...
1: [F77GG] 2022/12/18 00:47:19 INFO: Running database migration 7...
1: [F77GG] 2022/12/18 00:47:19 INFO: Running database migration 9...
1: [F77GG] 2022/12/18 00:47:19 INFO: Running database migration 10...
1: [F77GG] 2022/12/18 00:47:19 INFO: Running database migration 11...
1: [F77GG] 2022/12/18 00:47:19 INFO: Running database migration 13...
1: [F77GG] 2022/12/18 00:47:19 INFO: Running database migration 14...
1: [F77GG] 2022/12/18 00:47:19 INFO: Running database migration 16...
1: [F77GG] 2022/12/18 00:47:19 INFO: Running database migration 17...
1: [F77GG] 2022/12/18 00:47:19 INFO: Running database migration 19...
1: [F77GG] 2022/12/18 00:47:19 INFO: Compacting database after migration...
1: [F77GG] 2022/12/18 00:47:19 INFO: Overall send rate is unlimited, receive rate is unlimited
1: [F77GG] 2022/12/18 00:47:19 INFO: No stored folder metadata for "test1"; recalculating
1: [F77GG] 2022/12/18 00:47:19 INFO: Ready to synchronize test1 (sendreceive)
1: [F77GG] 2022/12/18 00:47:19 INFO: Using discovery mechanism: global discovery server https://discovery.syncthing.net/v2/?noannounce&id=LYXKCHX-VI3NYZR-ALCJBHF-WMZYSPK-QG6
QJA3-MPFYMSO-U56GTUK-NA2MIAW
1: [F77GG] 2022/12/18 00:47:19 INFO: Using discovery mechanism: global discovery server https://discovery-v4.syncthing.net/v2/?nolookup&id=LYXKCHX-VI3NYZR-ALCJBHF-WMZYSPK-QG
6QJA3-MPFYMSO-U56GTUK-NA2MIAW
1: [F77GG] 2022/12/18 00:47:19 INFO: Using discovery mechanism: global discovery server https://discovery-v6.syncthing.net/v2/?nolookup&id=LYXKCHX-VI3NYZR-ALCJBHF-WMZYSPK-QG
6QJA3-MPFYMSO-U56GTUK-NA2MIAW
1: [F77GG] 2022/12/18 00:47:19 INFO: Using discovery mechanism: IPv4 local broadcast discovery on port 21027
1: [F77GG] 2022/12/18 00:47:19 INFO: Using discovery mechanism: IPv6 local multicast discovery on address [ff12::8384]:21027
1: [F77GG] 2022/12/18 00:47:19 INFO: TCP listener (127.0.0.1:32452) starting
1: [F77GG] 2022/12/18 00:47:19 VERBOSE: Folder "test1" is now scan-waiting
1: [F77GG] 2022/12/18 00:47:19 VERBOSE: Listen address tcp://127.0.0.1:32452 resolution has changed: lan addresses: [tcp://127.0.0.1:32452] wan addresses: [tcp://0.0.0.0:0 t
cp://127.0.0.1:32452]
1: [F77GG] 2022/12/18 00:47:19 VERBOSE: Folder "test1" is now scanning
1: [F77GG] 2022/12/18 00:47:19 INFO: Loading HTTPS certificate: open /home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/connector/testworkingdir/testconfig/
https-cert.pem: no such file or directory
1: [F77GG] 2022/12/18 00:47:19 INFO: Creating new HTTPS certificate
1: [F77GG] 2022/12/18 00:47:19 INFO: Completed initial scan of sendreceive folder test1
1: [F77GG] 2022/12/18 00:47:19 VERBOSE: Folder "test1" is now idle
1: [F77GG] 2022/12/18 00:47:19 INFO: GUI and API listening on 127.0.0.1:52250
1: [F77GG] 2022/12/18 00:47:19 INFO: Access the GUI via the following URL: http://127.0.0.1:52250/
1: [F77GG] 2022/12/18 00:47:19 INFO: My name is "grasshopper"
1: [F77GG] 2022/12/18 00:47:19 INFO: Device MMGUI6U-WUEZQCP-XZZ6VYB-LCT4TVC-ER2HAVX-QYT6X7D-S6ZSG2B-323KLQ7 is "Test dev 2" at [tcp://192.168.2.2:22001]
1: [F77GG] 2022/12/18 00:47:19 INFO: Device 6EIS2PN-J2IHWGS-AXS3YUL-HC5FT3K-77ZXTLL-AKQLJ4C-7SWVPUS-AZW4RQ4 is "Test dev 1" at [dynamic]
1: [F77GG] 2022/12/18 00:47:19 VERBOSE: Startup complete
1: [F77GG] 2022/12/18 00:47:19 VERBOSE: Discovered device IJMVVEB-KMP4IJ6-ERRFOJ4-AUBSKH7-EFXJEQS-CTV4DLD-REVFSFD-HOXXWA2 at [quic://172.16.0.250:44807 quic://172.17.77.1:44
807 quic://172.18.0.1:44807 quic://172.19.0.1:44807 tcp://172.16.0.250:44807 tcp://172.17.77.1:44807 tcp://172.18.0.1:44807 tcp://172.19.0.1:44807]
1: [F77GG] 2022/12/18 00:47:19 VERBOSE: Discovered device GCSXFQC-DWFY4RF-ALLEFZ3-GXBC2BH-KCB46VZ-LGU4QY4-7RVQXRS-D2WQHQB at [tcp://172.16.0.250:22000 tcp://172.17.77.1:2200
0 tcp://172.18.0.1:22000 tcp://172.19.0.1:22000 relay://85.5.216.91:22067/?id=QVNSFXE-UJVC3L2-4DW6VU7-NFXUFMW-JKCGCN4-QZLPARN-SNBD4YQ-XNQNRQT&networkTimeout=2m0s&pingInterva
l=1m0s&providedBy=IgorNovgorodov&statusAddr=%3A22070 quic://172.16.0.250:22000 quic://172.17.77.1:22000 quic://172.18.0.1:22000 quic://172.19.0.1:22000 quic://188.192.136.70
:22000]
4: 
4: ✔ Validation was successful.
1/6 Test #4: syncthingtray_appstream_validation .............   Passed    1.84 sec
test 5
    Start 5: syncthingplasmoid_appstream_validation

5: Test command: /usr/bin/appstreamcli "validate" "/home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/plasmoid/lib/resources/syncthingplasmoid.appdata.xml"
5: Working Directory: /home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/plasmoid/lib
5: Test timeout computed to be: 10000000
1:  - Connection status changed to: disconnected
1:  - Connection status changed to: disconnected
1:  - Connection status changed to: disconnected
1:  - Connection status changed to: disconnected
1:  - Connection error: Unable to request Syncthing status: Host requires authentication
1:  - Connection status changed to: disconnected
1:  - Connection status changed to: disconnected
1: 
1:  - Error handling in case of wrong credentials ...
1:  - Connection error: Unable to request Syncthing config: Host requires authentication
1:  - Connection status changed to: disconnected
1:  - Connection status changed to: disconnected
1: 
1:  - Error handling in case of wrong API key  ...
3: PASS   : WizardTests::testConfiguringLauncher()
3: Info: Launched process, PID: 50495
3: QWARN  : WizardTests::testConfiguringCurrentlyRunningSyncthing() QFSFileEngine::open: No file name specified
3: FAIL!  : WizardTests::testConfiguringCurrentlyRunningSyncthing() '!cfgCurrentlyRunningRadioButton->isHidden()' returned FALSE. ()
3:    Loc: [/home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/widgets/tests/wizard.cpp(334)]
3: QDEBUG : WizardTests::cleanupTestCase() terminating Syncthing
3: QDEBUG : WizardTests::cleanupTestCase() Syncthing log during testrun:
3:  [start] 2022/12/18 00:47:18 INFO: syncthing v1.22.1 "Fermium Flea" (go1.19.3 linux-amd64) syncthing@archlinux 2022-11-03 07:35:59 UTC [noupgrade]
3: [start] 2022/12/18 00:47:18 INFO: Generating ECDSA key and certificate for syncthing...
3: [start] 2022/12/18 00:47:18 INFO: Default folder created and/or linked to new config
3: [start] 2022/12/18 00:47:18 INFO: Default config saved. Edit /tmp/syncthingwidgets_wizard_tests-ADBbgD/config.xml to taste (with Syncthing stopped) or use the GUI
3: [start] 2022/12/18 00:47:18 INFO: Archiving a copy of old config file format at: /tmp/syncthingwidgets_wizard_tests-ADBbgD/config.xml.v0
3: [IJMVV] 2022/12/18 00:47:18 INFO: My ID: IJMVVEB-KMP4IJ6-ERRFOJ4-AUBSKH7-EFXJEQS-CTV4DLD-REVFSFD-HOXXWA2
3: [IJMVV] 2022/12/18 00:47:19 INFO: Single thread SHA256 performance is 1821 MB/s using minio/sha256-simd (478 MB/s using crypto/sha256).
3: [IJMVV] 2022/12/18 00:47:19 INFO: Hashing performance is 609.83 MB/s
3: [IJMVV] 2022/12/18 00:47:19 INFO: Running database migration 1...
3: [IJMVV] 2022/12/18 00:47:19 INFO: Running database migration 2...
3: [IJMVV] 2022/12/18 00:47:19 INFO: Running database migration 3...
3: [IJMVV] 2022/12/18 00:47:19 INFO: Running database migration 5...
3: [IJMVV] 2022/12/18 00:47:19 INFO: Running database migration 6...
3: [IJMVV] 2022/12/18 00:47:19 INFO: Running database migration 7...
3: [IJMVV] 2022/12/18 00:47:19 INFO: Running database migration 9...
3: [IJMVV] 2022/12/18 00:47:19 INFO: Running database migration 10...
3: [IJMVV] 2022/12/18 00:47:19 INFO: Running database migration 11...
3: [IJMVV] 2022/12/18 00:47:19 INFO: Running database migration 13...
3: [IJMVV] 2022/12/18 00:47:19 INFO: Running database migration 14...
3: [IJMVV] 2022/12/18 00:47:19 INFO: Running database migration 16...
3: [IJMVV] 2022/12/18 00:47:19 INFO: Running database migration 17...
3: [IJMVV] 2022/12/18 00:47:19 INFO: Running database migration 19...
3: [IJMVV] 2022/12/18 00:47:19 INFO: Compacting database after migration...
3: [IJMVV] 2022/12/18 00:47:19 INFO: Overall send rate is unlimited, receive rate is unlimited
3: [IJMVV] 2022/12/18 00:47:19 INFO: No stored folder metadata for "default"; recalculating
3: [IJMVV] 2022/12/18 00:47:19 INFO: Using discovery mechanism: global discovery server https://discovery.syncthing.net/v2/?noannounce&id=LYXKCHX-VI3NYZR-ALCJBHF-WMZYSPK-QG6
QJA3-MPFYMSO-U56GTUK-NA2MIAW
3: [IJMVV] 2022/12/18 00:47:19 INFO: Using discovery mechanism: global discovery server https://discovery-v4.syncthing.net/v2/?nolookup&id=LYXKCHX-VI3NYZR-ALCJBHF-WMZYSPK-QG
6QJA3-MPFYMSO-U56GTUK-NA2MIAW
3: [IJMVV] 2022/12/18 00:47:19 INFO: Relay listener (dynamic+https://relays.syncthing.net/endpoint) starting
3: [IJMVV] 2022/12/18 00:47:19 INFO: Using discovery mechanism: global discovery server https://discovery-v6.syncthing.net/v2/?nolookup&id=LYXKCHX-VI3NYZR-ALCJBHF-WMZYSPK-QG
6QJA3-MPFYMSO-U56GTUK-NA2MIAW
3: [IJMVV] 2022/12/18 00:47:19 INFO: Using discovery mechanism: IPv4 local broadcast discovery on port 21027
3: [IJMVV] 2022/12/18 00:47:19 INFO: Using discovery mechanism: IPv6 local multicast discovery on address [ff12::8384]:21027
3: [IJMVV] 2022/12/18 00:47:19 INFO: Loading HTTPS certificate: open /tmp/syncthingwidgets_wizard_tests-ADBbgD/https-cert.pem: no such file or directory
3: [IJMVV] 2022/12/18 00:47:19 INFO: Creating new HTTPS certificate
3: [IJMVV] 2022/12/18 00:47:19 INFO: TCP listener ([::]:44807) starting
3: [IJMVV] 2022/12/18 00:47:19 INFO: QUIC listener ([::]:44807) starting
3: [IJMVV] 2022/12/18 00:47:19 INFO: Ready to synchronize "Default Folder" (default) (sendreceive)
3: [IJMVV] 2022/12/18 00:47:19 INFO: Completed initial scan of sendreceive folder "Default Folder" (default)
3: [IJMVV] 2022/12/18 00:47:19 WARNING: Failed starting API: listen tcp 127.0.0.1:52250: bind: address already in use
3: [IJMVV] 2022/12/18 00:47:19 INFO: QUIC listener ([::]:44807) shutting down
3: [IJMVV] 2022/12/18 00:47:19 INFO: Detected 0 NAT services
3: [IJMVV] 2022/12/18 00:47:19 INFO: Relay listener (dynamic+https://relays.syncthing.net/endpoint) shutting down
3: [IJMVV] 2022/12/18 00:47:19 WARNING: Starting API/GUI: listen tcp 127.0.0.1:52250: bind: address already in use
3: 
3: PASS   : WizardTests::cleanupTestCase()
3: Totals: 4 passed, 1 failed, 0 skipped, 0 blacklisted, 2122ms
3: ********* Finished testing of WizardTests *********
2/6 Test #3: syncthingwidgets_run_wizard_tests ..............***Failed    2.40 sec
********* Start testing of WizardTests *********
Config: Using QtTest library 5.15.7, Qt 5.15.7 (x86_64-little_endian-lp64 shared (dynamic) release build; by GCC 12.2.0), manjaro unknown
QDEBUG : WizardTests::initTestCase() "HOME dir: /tmp/syncthingwidgets_wizard_tests-ADBbgD"
PASS   : WizardTests::initTestCase()
PASS   : WizardTests::testShowingSettings()
QWARN  : WizardTests::testConfiguringLauncher() This plugin does not support propagateSizeHints()
QWARN  : WizardTests::testConfiguringLauncher() QFSFileEngine::open: No file name specified
Info: Launched process, PID: 50442
QWARN  : WizardTests::testConfiguringLauncher() QFSFileEngine::open: No file name specified
Info: Launched process, PID: 50448
QDEBUG : WizardTests::testConfiguringLauncher() waiting for Syncthing to write config file
PASS   : WizardTests::testConfiguringLauncher()
Info: Launched process, PID: 50495
QWARN  : WizardTests::testConfiguringCurrentlyRunningSyncthing() QFSFileEngine::open: No file name specified
FAIL!  : WizardTests::testConfiguringCurrentlyRunningSyncthing() '!cfgCurrentlyRunningRadioButton->isHidden()' returned FALSE. ()
   Loc: [/home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/widgets/tests/wizard.cpp(334)]
QDEBUG : WizardTests::cleanupTestCase() terminating Syncthing
QDEBUG : WizardTests::cleanupTestCase() Syncthing log during testrun:
 [start] 2022/12/18 00:47:18 INFO: syncthing v1.22.1 "Fermium Flea" (go1.19.3 linux-amd64) syncthing@archlinux 2022-11-03 07:35:59 UTC [noupgrade]
[start] 2022/12/18 00:47:18 INFO: Generating ECDSA key and certificate for syncthing...
[start] 2022/12/18 00:47:18 INFO: Default folder created and/or linked to new config
[start] 2022/12/18 00:47:18 INFO: Default config saved. Edit /tmp/syncthingwidgets_wizard_tests-ADBbgD/config.xml to taste (with Syncthing stopped) or use the GUI
[start] 2022/12/18 00:47:18 INFO: Archiving a copy of old config file format at: /tmp/syncthingwidgets_wizard_tests-ADBbgD/config.xml.v0
[IJMVV] 2022/12/18 00:47:18 INFO: My ID: IJMVVEB-KMP4IJ6-ERRFOJ4-AUBSKH7-EFXJEQS-CTV4DLD-REVFSFD-HOXXWA2
[IJMVV] 2022/12/18 00:47:19 INFO: Single thread SHA256 performance is 1821 MB/s using minio/sha256-simd (478 MB/s using crypto/sha256).
[IJMVV] 2022/12/18 00:47:19 INFO: Hashing performance is 609.83 MB/s
[IJMVV] 2022/12/18 00:47:19 INFO: Running database migration 1...
[IJMVV] 2022/12/18 00:47:19 INFO: Running database migration 2...
[IJMVV] 2022/12/18 00:47:19 INFO: Running database migration 3...
[IJMVV] 2022/12/18 00:47:19 INFO: Running database migration 5...
[IJMVV] 2022/12/18 00:47:19 INFO: Running database migration 6...
[IJMVV] 2022/12/18 00:47:19 INFO: Running database migration 7...
[IJMVV] 2022/12/18 00:47:19 INFO: Running database migration 9...
[IJMVV] 2022/12/18 00:47:19 INFO: Running database migration 10...
[IJMVV] 2022/12/18 00:47:19 INFO: Running database migration 11...
[IJMVV] 2022/12/18 00:47:19 INFO: Running database migration 13...
[IJMVV] 2022/12/18 00:47:19 INFO: Running database migration 14...
[IJMVV] 2022/12/18 00:47:19 INFO: Running database migration 16...
[IJMVV] 2022/12/18 00:47:19 INFO: Running database migration 17...
[IJMVV] 2022/12/18 00:47:19 INFO: Running database migration 19...
[IJMVV] 2022/12/18 00:47:19 INFO: Compacting database after migration...
[IJMVV] 2022/12/18 00:47:19 INFO: Overall send rate is unlimited, receive rate is unlimited
[IJMVV] 2022/12/18 00:47:19 INFO: No stored folder metadata for "default"; recalculating
[IJMVV] 2022/12/18 00:47:19 INFO: Using discovery mechanism: global discovery server https://discovery.syncthing.net/v2/?noannounce&id=LYXKCHX-VI3NYZR-ALCJBHF-WMZYSPK-QG6QJA
3-MPFYMSO-U56GTUK-NA2MIAW
[IJMVV] 2022/12/18 00:47:19 INFO: Using discovery mechanism: global discovery server https://discovery-v4.syncthing.net/v2/?nolookup&id=LYXKCHX-VI3NYZR-ALCJBHF-WMZYSPK-QG6QJ
A3-MPFYMSO-U56GTUK-NA2MIAW
[IJMVV] 2022/12/18 00:47:19 INFO: Relay listener (dynamic+https://relays.syncthing.net/endpoint) starting
[IJMVV] 2022/12/18 00:47:19 INFO: Using discovery mechanism: global discovery server https://discovery-v6.syncthing.net/v2/?nolookup&id=LYXKCHX-VI3NYZR-ALCJBHF-WMZYSPK-QG6QJ
A3-MPFYMSO-U56GTUK-NA2MIAW
[IJMVV] 2022/12/18 00:47:19 INFO: Using discovery mechanism: IPv4 local broadcast discovery on port 21027
[IJMVV] 2022/12/18 00:47:19 INFO: Using discovery mechanism: IPv6 local multicast discovery on address [ff12::8384]:21027
[IJMVV] 2022/12/18 00:47:19 INFO: Loading HTTPS certificate: open /tmp/syncthingwidgets_wizard_tests-ADBbgD/https-cert.pem: no such file or directory
[IJMVV] 2022/12/18 00:47:19 INFO: Creating new HTTPS certificate
[IJMVV] 2022/12/18 00:47:19 INFO: TCP listener ([::]:44807) starting
[IJMVV] 2022/12/18 00:47:19 INFO: QUIC listener ([::]:44807) starting
[IJMVV] 2022/12/18 00:47:19 INFO: Ready to synchronize "Default Folder" (default) (sendreceive)
[IJMVV] 2022/12/18 00:47:19 INFO: Completed initial scan of sendreceive folder "Default Folder" (default)
[IJMVV] 2022/12/18 00:47:19 WARNING: Failed starting API: listen tcp 127.0.0.1:52250: bind: address already in use
[IJMVV] 2022/12/18 00:47:19 INFO: QUIC listener ([::]:44807) shutting down
[IJMVV] 2022/12/18 00:47:19 INFO: Detected 0 NAT services
[IJMVV] 2022/12/18 00:47:19 INFO: Relay listener (dynamic+https://relays.syncthing.net/endpoint) shutting down
[IJMVV] 2022/12/18 00:47:19 WARNING: Starting API/GUI: listen tcp 127.0.0.1:52250: bind: address already in use

PASS   : WizardTests::cleanupTestCase()
Totals: 4 passed, 1 failed, 0 skipped, 0 blacklisted, 2122ms
********* Finished testing of WizardTests *********

test 6
    Start 6: syncthingfileitemaction_appstream_validation

6: Test command: /usr/bin/appstreamcli "validate" "/home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/fileitemactionplugin/resources/syncthingfileitemaction
.appdata.xml"
6: Working Directory: /home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/fileitemactionplugin
6: Test timeout computed to be: 10000000
1: [F77GG] 2022/12/18 00:47:20 VERBOSE: Login successful for username nobody.
1:  - Connection error: Unable to request Syncthing config: Error transferring http://nobody:supersecret@127.0.0.1:52250/rest/system/config - server replied: Forbidden
1:  - Connection status changed to: disconnected
1:  - Connection status changed to: disconnected
1: 
1:  - Connecting initially ...
1:  - Connection status changed to: connected, paused
1: 
1:  - Reconnecting ...
1:  - Connection status changed to: reconnecting
1: 
1:  - Waiting for dirs/devs after reconnect ...
1:  - Connection status changed to: connected, paused
1: 
1:  - Resuming all devices ...
1: [F77GG] 2022/12/18 00:47:20 VERBOSE: Login successful for username nobody.
1: [F77GG] 2022/12/18 00:47:20 INFO: Resuming MMGUI6U-WUEZQCP-XZZ6VYB-LCT4TVC-ER2HAVX-QYT6X7D-S6ZSG2B-323KLQ7
1: [F77GG] 2022/12/18 00:47:20 VERBOSE: Device MMGUI6U-WUEZQCP-XZZ6VYB-LCT4TVC-ER2HAVX-QYT6X7D-S6ZSG2B-323KLQ7 was resumed
1:  - Connection status changed to: connected
1: [F77GG] 2022/12/18 00:47:20 VERBOSE: Configuration was saved
1: 
1:  - Resuming all dirs ...
1: [F77GG] 2022/12/18 00:47:20 INFO: No stored folder metadata for "test2"; recalculating
1: [F77GG] 2022/12/18 00:47:20 INFO: Ready to synchronize "Test dir 2" (test2) (sendreceive)
1: [F77GG] 2022/12/18 00:47:20 INFO: Unpaused folder "Test dir 2" (test2) (sendreceive)
1: [F77GG] 2022/12/18 00:47:20 VERBOSE: Folder test2 (Test dir 2) was resumed
1: [F77GG] 2022/12/18 00:47:20 VERBOSE: Configuration was saved
1: [F77GG] 2022/12/18 00:47:20 VERBOSE: Folder "test2" is now scan-waiting
1: [F77GG] 2022/12/18 00:47:20 VERBOSE: Folder "test2" is now scanning
1: [F77GG] 2022/12/18 00:47:20 INFO: Completed initial scan of sendreceive folder "Test dir 2" (test2)
1: [F77GG] 2022/12/18 00:47:20 VERBOSE: Folder "test2" is now idle
1: 
1:  - Pause dir 1 ...
1: [F77GG] 2022/12/18 00:47:20 INFO: Paused folder test1 (sendreceive)
1: [F77GG] 2022/12/18 00:47:20 VERBOSE: Folder test1 () was paused
1: [F77GG] 2022/12/18 00:47:20 VERBOSE: Configuration was saved
1: 
1:  - Requesting log ...
1: 
1:  - Requesting QR-Code for own device ID ...
1: 
1:  - Disconnecting while there are outstanding requests ...
1:  - Connection status changed to: disconnected
1: 
1:  - Connecting with settings ...
1:  - Connection status changed to: reconnecting
1:  - Connection status changed to: connected
1: 
1:  - Requesting rescan ...
1: [F77GG] 2022/12/18 00:47:20 VERBOSE: Folder "test2" is now scan-waiting
1: [F77GG] 2022/12/18 00:47:20 VERBOSE: Folder "test2" is now scanning
1: [F77GG] 2022/12/18 00:47:20 VERBOSE: Folder "test2" is now idle
1:  - Connection status changed to: connected, scanning
1:  - Connection status changed to: connected
1:  - Connection error: Unable to request rescan: Error transferring http://127.0.0.1:52250/rest/db/scan?folder=non-existing-dir&sub=sub/path - server replied: Internal Serv
er Error
1: 
1:  - Changing arbitrary config ...
1: [F77GG] 2022/12/18 00:47:20 VERBOSE: Configuration was saved
1: 
1:  - Waiting for Syncthing to terminate ...
1: [monitor] 2022/12/18 00:47:20 INFO: Signal 15 received; exiting
1: [F77GG] 2022/12/18 00:47:20 INFO: Detected 1 NAT service
6: 
6: ✔ Validation was successful.
3/6 Test #6: syncthingfileitemaction_appstream_validation ...   Passed    0.90 sec
5: 
5: ✔ Validation was successful.
4/6 Test #5: syncthingplasmoid_appstream_validation .........   Passed    1.47 sec
1: [F77GG] 2022/12/18 00:47:21 INFO: TCP listener (127.0.0.1:32452) shutting down
1: [F77GG] 2022/12/18 00:47:21 INFO: Exiting
1: Info: Launched process 50381 exited with error: No child processes
1: 
1:  - Syncthing terminated with exit code -1.
1: ......
1: 
1: 
1: OK (7 tests)
1: 
1: 
1: Tests successful
5/6 Test #1: syncthingconnector_run_tests ...................   Passed    3.56 sec
test 2
    Start 2: syncthingctl_run_tests

2: Test command: /home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/syncthingctl_tests "-p" "/home/janekf/.local/cache/yay/syncthingtray/src/syncthingtr
ay-1.3.1/cli/testfiles" "-w" "/home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/testworkingdir" "-a" "/home/janekf/.local/cache/yay/syncthingtray/src/s
yncthingtray-1.3.1/cli/syncthingctl"
2: Working Directory: /home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli
2: Test timeout computed to be: 10000000
2: /home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/testfiles/
2: /home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/testfiles/
2: ./testfiles/
2: Directory used to store working copies:
2: /home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/testworkingdir/
2: Executing test cases ...
2: .
2:  - Setup configuration for Syncthing tests ...
2:  - Using timeout factor 3
2: 
2:  - Launching Syncthing: syncthing -gui-address=http://127.0.0.1:52250 -gui-apikey=syncthingtestinstance -home=/home/janekf/.local/cache/yay/syncthingtray/src/syncthingtra
y-1.3.1/cli/testworkingdir/testconfig -no-browser -verbose
2: Info: Launched process, PID: 50521
2: 
2: Waiting till Syncthing GUI becomes available ...
2: [start] 2022/12/18 00:47:21 INFO: syncthing v1.22.1 "Fermium Flea" (go1.19.3 linux-amd64) syncthing@archlinux 2022-11-03 07:35:59 UTC [noupgrade]
2: [start] 2022/12/18 00:47:21 INFO: Generating ECDSA key and certificate for syncthing...
2: [start] 2022/12/18 00:47:21 INFO: Archiving a copy of old config file format at: /home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/testworkingdir/te
stconfig/config.xml.v28
2: [7DSC2] 2022/12/18 00:47:21 INFO: My ID: 7DSC2GN-GGOQ6LM-HCWY6XD-3SO4YP5-YNXIN3O-3TLA3QO-X43H7YE-IIX6JQM
2: [7DSC2] 2022/12/18 00:47:22 INFO: Single thread SHA256 performance is 975 MB/s using minio/sha256-simd (254 MB/s using crypto/sha256).
2: [7DSC2] 2022/12/18 00:47:22 VERBOSE: Starting up (/home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/testworkingdir/testconfig)
2: [7DSC2] 2022/12/18 00:47:22 INFO: Hashing performance is 611.39 MB/s
2: [7DSC2] 2022/12/18 00:47:22 INFO: Running database migration 1...
2: [7DSC2] 2022/12/18 00:47:22 INFO: Running database migration 2...
2: [7DSC2] 2022/12/18 00:47:22 INFO: Running database migration 3...
2: [7DSC2] 2022/12/18 00:47:22 INFO: Running database migration 5...
2: [7DSC2] 2022/12/18 00:47:22 INFO: Running database migration 6...
2: [7DSC2] 2022/12/18 00:47:22 INFO: Running database migration 7...
2: [7DSC2] 2022/12/18 00:47:22 INFO: Running database migration 9...
2: [7DSC2] 2022/12/18 00:47:22 INFO: Running database migration 10...
2: [7DSC2] 2022/12/18 00:47:22 INFO: Running database migration 11...
2: [7DSC2] 2022/12/18 00:47:22 INFO: Running database migration 13...
2: [7DSC2] 2022/12/18 00:47:22 INFO: Running database migration 14...
2: [7DSC2] 2022/12/18 00:47:22 INFO: Running database migration 16...
2: [7DSC2] 2022/12/18 00:47:22 INFO: Running database migration 17...
2: [7DSC2] 2022/12/18 00:47:22 INFO: Running database migration 19...
2: [7DSC2] 2022/12/18 00:47:22 INFO: Compacting database after migration...
2: [7DSC2] 2022/12/18 00:47:22 INFO: Overall send rate is unlimited, receive rate is unlimited
2: [7DSC2] 2022/12/18 00:47:22 INFO: No stored folder metadata for "test1"; recalculating
2: [7DSC2] 2022/12/18 00:47:22 INFO: Using discovery mechanism: global discovery server https://discovery.syncthing.net/v2/?noannounce&id=LYXKCHX-VI3NYZR-ALCJBHF-WMZYSPK-QG6
QJA3-MPFYMSO-U56GTUK-NA2MIAW
2: [7DSC2] 2022/12/18 00:47:22 INFO: Using discovery mechanism: global discovery server https://discovery-v4.syncthing.net/v2/?nolookup&id=LYXKCHX-VI3NYZR-ALCJBHF-WMZYSPK-QG
6QJA3-MPFYMSO-U56GTUK-NA2MIAW
2: [7DSC2] 2022/12/18 00:47:22 INFO: Using discovery mechanism: global discovery server https://discovery-v6.syncthing.net/v2/?nolookup&id=LYXKCHX-VI3NYZR-ALCJBHF-WMZYSPK-QG
6QJA3-MPFYMSO-U56GTUK-NA2MIAW
2: [7DSC2] 2022/12/18 00:47:22 INFO: TCP listener (127.0.0.1:32452) starting
2: [7DSC2] 2022/12/18 00:47:22 INFO: Ready to synchronize test1 (sendreceive)
2: [7DSC2] 2022/12/18 00:47:22 VERBOSE: Listen address tcp://127.0.0.1:32452 resolution has changed: lan addresses: [tcp://127.0.0.1:32452] wan addresses: [tcp://0.0.0.0:0 t
cp://127.0.0.1:32452]
2: [7DSC2] 2022/12/18 00:47:22 INFO: Using discovery mechanism: IPv4 local broadcast discovery on port 21027
2: [7DSC2] 2022/12/18 00:47:22 INFO: Using discovery mechanism: IPv6 local multicast discovery on address [ff12::8384]:21027
2: [7DSC2] 2022/12/18 00:47:22 INFO: Loading HTTPS certificate: open /home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/testworkingdir/testconfig/https-
cert.pem: no such file or directory
2: [7DSC2] 2022/12/18 00:47:22 INFO: Creating new HTTPS certificate
2: [7DSC2] 2022/12/18 00:47:22 VERBOSE: Folder "test1" is now scan-waiting
2: [7DSC2] 2022/12/18 00:47:22 VERBOSE: Folder "test1" is now scanning
2: [7DSC2] 2022/12/18 00:47:22 INFO: Completed initial scan of sendreceive folder test1
2: [7DSC2] 2022/12/18 00:47:22 VERBOSE: Folder "test1" is now idle
2: [7DSC2] 2022/12/18 00:47:22 INFO: GUI and API listening on 127.0.0.1:52250
2: [7DSC2] 2022/12/18 00:47:22 INFO: Access the GUI via the following URL: http://127.0.0.1:52250/
2: [7DSC2] 2022/12/18 00:47:22 INFO: My name is "grasshopper"
2: - /home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/syncthingctl status --api-key syncthingtestinstance --url http://localhost:52250 --no-color
Overall statisticsg to http://localhost:52250 ...
2:    Status                        idle
2:       Global                        0 file(s), 0 dir(s), 0 bytes
2:       Local                         0 file(s), 0 dir(s), 0 bytes
2:    Incoming traffic              0 bytes
2:    Outgoing traffic              0 bytes
2:    Connected to                  no other devices
2:    Uptime                        1 s
2:    Version                       syncthing v1.22.1 "Fermium Flea" (go1.19.3 linux-amd64) syncthing@archlinux 2022-11-03 07:35:59 UTC [noupgrade]
2: 
2: Directories
2:  - test2
2:    Label                         Test dir 2
2:    Path                          /tmp/some/path/2/
2:    Status                        paused
2:    Shared with                   Test dev 2
2:    Type                          Send & Receive
2:    Ignore permissions            no
2:    Auto-normalize                yes
2:    Rescan interval               365 d, file system watcher disabled
2: 
2:  - test1
2:    Path                          /tmp/some/path/1/
2:    Status                        idle
2:       Global                        0 file(s), 0 dir(s), 0 bytes
2:       Local                         0 file(s), 0 dir(s), 0 bytes
2:    Last scan time                2022-12-18 00:47:22
2:    Shared with                   Test dev 2
2:                                  Test dev 1
2:    Remote progress               all up-to-date
2:       Test dev 1                    0 bytes / 0 bytes (100 %)
2:       Test dev 2                    0 bytes / 0 bytes (100 %)
2:    Type                          Send & Receive
2:    Ignore permissions            no
2:    Auto-normalize                yes
2:    Rescan interval               2 h, file system watcher disabled
2: 
2: Devices
2:  - grasshopper
2:    ID                            7DSC2GN-GGOQ6LM-HCWY6XD-3SO4YP5-YNXIN3O-3TLA3QO-X43H7YE-IIX6JQM
2:    Status                        own device
2:    Addresses                     dynamic
2:    Compression                   metadata
2: 
2:  - Test dev 1
2:    ID                            6EIS2PN-J2IHWGS-AXS3YUL-HC5FT3K-77ZXTLL-AKQLJ4C-7SWVPUS-AZW4RQ4
2:    Status                        disconnected
2:    Addresses                     dynamic
2:    Compression                   metadata
2: 
2:  - Test dev 2
2:    ID                            MMGUI6U-WUEZQCP-XZZ6VYB-LCT4TVC-ER2HAVX-QYT6X7D-S6ZSG2B-323KLQ7
2:    Status                        paused
2:    Addresses                     tcp://192.168.2.2:22001
2:    Compression                   metadata
2: 
2: - /home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/syncthingctl log --api-key syncthingtestinstance --url http://localhost:52250
2: 2022-12-18 00:47:21: My ID: 7DSC2GN-GGOQ6LM-HCWY6XD-3SO4YP5-YNXIN3O-3TLA3QO-X43H7YE-IIX6JQM
2: 2022-12-18 00:47:22: Single thread SHA256 performance is 975 MB/s using minio/sha256-simd (254 MB/s using crypto/sha256).
2: 2022-12-18 00:47:22: Starting up (/home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/testworkingdir/testconfig)
2: 2022-12-18 00:47:22: Hashing performance is 611.39 MB/s
2: 2022-12-18 00:47:22: Running database migration 1...
2: 2022-12-18 00:47:22: Running database migration 2...
2: 2022-12-18 00:47:22: Running database migration 3...
2: 2022-12-18 00:47:22: Running database migration 5...
2: 2022-12-18 00:47:22: Running database migration 6...
2: 2022-12-18 00:47:22: Running database migration 7...
2: 2022-12-18 00:47:22: ...
2: 2022-12-18 00:47:22: Running database migration 9...
2: 2022-12-18 00:47:22: Running database migration 10...
2: 2022-12-18 00:47:22: Running database migration 11...
2: 2022-12-18 00:47:22: Running database migration 13...
2: 2022-12-18 00:47:22: Running database migration 14...
2: 2022-12-18 00:47:22: Running database migration 16...
2: 2022-12-18 00:47:22: Running database migration 17...
2: 2022-12-18 00:47:22: Running database migration 19...
2: 2022-12-18 00:47:22: Compacting database after migration...
2: 2022-12-18 00:47:22: Overall send rate is unlimited, receive rate is unlimited
2: 2022-12-18 00:47:22: No stored folder metadata for "test1"; recalculating
2: 2022-12-18 00:47:22: Using discovery mechanism: global discovery server https://discovery.syncthing.net/v2/?noannounce&id=LYXKCHX-VI3NYZR-ALCJBHF-WMZYSPK-QG6QJA3-MPFYMSO-
U56GTUK-NA2MIAW
2: 2022-12-18 00:47:22: Using discovery mechanism: global discovery server https://discovery-v4.syncthing.net/v2/?nolookup&id=LYXKCHX-VI3NYZR-ALCJBHF-WMZYSPK-QG6QJA3-MPFYMSO
-U56GTUK-NA2MIAW
2: 2022-12-18 00:47:22: Using discovery mechanism: global discovery server https://discovery-v6.syncthing.net/v2/?nolookup&id=LYXKCHX-VI3NYZR-ALCJBHF-WMZYSPK-QG6QJA3-MPFYMSO
-U56GTUK-NA2MIAW
2: 2022-12-18 00:47:22: TCP listener (127.0.0.1:32452) starting
2: 2022-12-18 00:47:22: Ready to synchronize test1 (sendreceive)
2: 2022-12-18 00:47:22: Listen address tcp://127.0.0.1:32452 resolution has changed: lan addresses: [tcp://127.0.0.1:32452] wan addresses: [tcp://0.0.0.0:0 tcp://127.0.0.1:3
2452]
2: 2022-12-18 00:47:22: Using discovery mechanism: IPv4 local broadcast discovery on port 21027
2: 2022-12-18 00:47:22: Using discovery mechanism: IPv6 local multicast discovery on address [ff12::8384]:21027
2: 2022-12-18 00:47:22: Loading HTTPS certificate: open /home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/testworkingdir/testconfig/https-cert.pem: no 
such file or directory
2: 2022-12-18 00:47:22: Creating new HTTPS certificate
2: 2022-12-18 00:47:22: Folder "test1" is now scan-waiting
2: 2022-12-18 00:47:22: Folder "test1" is now scanning
2: 2022-12-18 00:47:22: Completed initial scan of sendreceive folder test1
2: 2022-12-18 00:47:22: Folder "test1" is now idle
2: 2022-12-18 00:47:22: GUI and API listening on 127.0.0.1:52250
2: 2022-12-18 00:47:22: Access the GUI via the following URL: http://127.0.0.1:52250/
2: 2022-12-18 00:47:22: My name is "grasshopper"
2: 2022-12-18 00:47:22: Device MMGUI6U-WUEZQCP-XZZ6VYB-LCT4TVC-ER2HAVX-QYT6X7D-S6ZSG2B-323KLQ7 is "Test dev 2" at [tcp://192.168.2.2:22001]
2: 2022-12-18 00:47:22: Device 6EIS2PN-J2IHWGS-AXS3YUL-HC5FT3K-77ZXTLL-AKQLJ4C-7SWVPUS-AZW4RQ4 is "Test dev 1" at [dynamic]
2: 2022-12-18 00:47:22: Startup complete
2: - /home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/syncthingctl resume --dir test2
2: - /home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/syncthingctl status --all-dirs
2: - /home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/syncthingctl pause --dir test2
2: - /home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/syncthingctl status --dir test2
2: Directories
2:  - test2
2:    Label                         Test dir 2
2:    Path                          /tmp/some/path/2/
2:    Status                        paused
2:    Shared with                   Test dev 2
2:    Type                          Send & Receive
2:    Ignore permissions            no
2:    Auto-normalize                yes
2:    Rescan interval               365 d, file system watcher disabled
2: 
2: - /home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/syncthingctl cat
2: {
2:     "defaults": {
2:         "device": {
2:             "addresses": [
2:                 "dynamic"
2:             ],
2:             "allowedNetworks": [
2:             ],
2:             "autoAcceptFolders": false,
2:             "certName": "",
2:             "compression": "metadata",
2:             "deviceID": "",
2:             "ignoredFolders": [
2:             ],
2:             "introducedBy": "",
2:             "introducer": false,
2:             "maxRecvKbps": 0,
2:             "maxRequestKiB": 0,
2:             "maxSendKbps": 0,
2:             "name": "",
2:             "paused": false,
2:             "remoteGUIPort": 0,
2:             "skipIntroductionRemovals": false,
2:             "untrusted": false
2:         },
2:         "folder": {
2:             "autoNormalize": true,
2:             "blockPullOrder": "standard",
2:             "caseSensitiveFS": false,
2:             "copiers": 0,
2:             "copyOwnershipFromParent": false,
2:             "copyRangeMethod": "standard",
2:             "devices": [
2:                 {
2:                     "deviceID": "7DSC2GN-GGOQ6LM-HCWY6XD-3SO4YP5-YNXIN3O-3TLA3QO-X43H7YE-IIX6JQM",
2:                     "encryptionPassword": "",
2:                     "introducedBy": ""
2:                 }
2:             ],
2:             "disableFsync": false,
2:             "disableSparseFiles": false,
2:             "disableTempIndexes": false,
2:             "filesystemType": "basic",
2:             "fsWatcherDelayS": 10,
2:             "fsWatcherEnabled": true,
2:             "hashers": 0,
2:             "id": "",
2:             "ignoreDelete": false,
2:             "ignorePerms": false,
2:             "junctionsAsDirs": false,
2:             "label": "",
2:             "markerName": ".stfolder",
2:             "maxConcurrentWrites": 2,
2:             "maxConflicts": 10,
2:             "minDiskFree": {
2:                 "unit": "%",
2:                 "value": 1
2:             },
2:             "modTimeWindowS": 0,
2:             "order": "random",
2:             "path": "~",
2:             "paused": false,
2:             "pullerMaxPendingKiB": 0,
2:             "pullerPauseS": 0,
2:             "rescanIntervalS": 3600,
2:             "scanProgressIntervalS": 0,
2:             "sendOwnership": false,
2:             "sendXattrs": false,
2:             "syncOwnership": false,
2:             "syncXattrs": false,
2:             "type": "sendreceive",
2:             "versioning": {
2:                 "cleanupIntervalS": 3600,
2:                 "fsPath": "",
2:                 "fsType": "basic",
2:                 "params": {
2:                 },
2:                 "type": ""
2:             },
2:             "weakHashThresholdPct": 25,
2:             "xattrFilter": {
2:                 "entries": [
2:                 ],
2:                 "maxSingleEntrySize": 1024,
2:                 "maxTotalSize": 4096
2:             }
2:         },
2:         "ignores": {
2:             "lines": [
2:             ]
2:         }
2:     },
2:     "devices": [
2:         {
2:             "addresses": [
2:                 "tcp://192.168.2.2:22001"
2:             ],
2:             "allowedNetworks": [
2:             ],
2:             "autoAcceptFolders": false,
2:             "certName": "",
2:             "compression": "metadata",
2:             "deviceID": "MMGUI6U-WUEZQCP-XZZ6VYB-LCT4TVC-ER2HAVX-QYT6X7D-S6ZSG2B-323KLQ7",
2:             "ignoredFolders": [
2:             ],
2:             "introducedBy": "",
2:             "introducer": false,
2:             "maxRecvKbps": 0,
2:             "maxRequestKiB": 0,
2:             "maxSendKbps": 0,
2:             "name": "Test dev 2",
2:             "paused": true,
2:             "remoteGUIPort": 0,
2:             "skipIntroductionRemovals": false,
2:             "untrusted": false
2:         },
2:         {
2:             "addresses": [
2:                 "dynamic"
2:             ],
2:             "allowedNetworks": [
2:             ],
2:             "autoAcceptFolders": false,
2:             "certName": "",
2:             "compression": "metadata",
2:             "deviceID": "6EIS2PN-J2IHWGS-AXS3YUL-HC5FT3K-77ZXTLL-AKQLJ4C-7SWVPUS-AZW4RQ4",
2:             "ignoredFolders": [
2:             ],
2:             "introducedBy": "",
2:             "introducer": true,
2:             "maxRecvKbps": 0,
2:             "maxRequestKiB": 0,
2:             "maxSendKbps": 0,
2:             "name": "Test dev 1",
2:             "paused": false,
2:             "remoteGUIPort": 0,
2:             "skipIntroductionRemovals": false,
2:             "untrusted": false
2:         },
2:         {
2:             "addresses": [
2:                 "dynamic"
2:             ],
2:             "allowedNetworks": [
2:             ],
2:             "autoAcceptFolders": false,
2:             "certName": "",
2:             "compression": "metadata",
2:             "deviceID": "7DSC2GN-GGOQ6LM-HCWY6XD-3SO4YP5-YNXIN3O-3TLA3QO-X43H7YE-IIX6JQM",
2:             "ignoredFolders": [
2:             ],
2:             "introducedBy": "",
2:             "introducer": false,
2:             "maxRecvKbps": 0,
2:             "maxRequestKiB": 0,
2:             "maxSendKbps": 0,
2:             "name": "grasshopper",
2:             "paused": false,
2:             "remoteGUIPort": 0,
2:             "skipIntroductionRemovals": false,
2:             "untrusted": false
2:         }
2:     ],
2:     "folders": [
2:         {
2:             "autoNormalize": true,
2:             "blockPullOrder": "standard",
2:             "caseSensitiveFS": false,
2:             "copiers": 1,
2:             "copyOwnershipFromParent": false,
2:             "copyRangeMethod": "standard",
2:             "devices": [
2:                 {
2:                     "deviceID": "MMGUI6U-WUEZQCP-XZZ6VYB-LCT4TVC-ER2HAVX-QYT6X7D-S6ZSG2B-323KLQ7",
2:                     "encryptionPassword": "",
2:                     "introducedBy": ""
2:                 },
2:                 {
2:                     "deviceID": "6EIS2PN-J2IHWGS-AXS3YUL-HC5FT3K-77ZXTLL-AKQLJ4C-7SWVPUS-AZW4RQ4",
2:                     "encryptionPassword": "",
2:                     "introducedBy": ""
2:                 },
2:                 {
2:                     "deviceID": "7DSC2GN-GGOQ6LM-HCWY6XD-3SO4YP5-YNXIN3O-3TLA3QO-X43H7YE-IIX6JQM",
2:                     "encryptionPassword": "",
2:                     "introducedBy": ""
2:                 }
2:             ],
2:             "disableFsync": false,
2:             "disableSparseFiles": false,
2:             "disableTempIndexes": false,
2:             "filesystemType": "basic",
2:             "fsWatcherDelayS": 10,
2:             "fsWatcherEnabled": false,
2:             "hashers": 0,
2:             "id": "test1",
2:             "ignoreDelete": false,
2:             "ignorePerms": false,
2:             "junctionsAsDirs": true,
2:             "label": "",
2:             "markerName": ".stfolder",
2:             "maxConcurrentWrites": 2,
2:             "maxConflicts": -1,
2:             "minDiskFree": {
2:                 "unit": "%",
2:                 "value": 1
2:             },
2:             "modTimeWindowS": 0,
2:             "order": "random",
2:             "path": "/tmp/some/path/1/",
2:             "paused": false,
2:             "pullerMaxPendingKiB": 2048,
2:             "pullerPauseS": 0,
2:             "rescanIntervalS": 7200,
2:             "scanProgressIntervalS": 0,
2:             "sendOwnership": false,
2:             "sendXattrs": false,
2:             "syncOwnership": false,
2:             "syncXattrs": false,
2:             "type": "sendreceive",
2:             "versioning": {
2:                 "cleanupIntervalS": 3600,
2:                 "fsPath": "",
2:                 "fsType": "basic",
2:                 "params": {
2:                 },
2:                 "type": ""
2:             },
2:             "weakHashThresholdPct": 25,
2:             "xattrFilter": {
2:                 "entries": [
2:                 ],
2:                 "maxSingleEntrySize": 0,
2:                 "maxTotalSize": 0
2:             }
2:         },
2:         {
2:             "autoNormalize": true,
2:             "blockPullOrder": "standard",
2:             "caseSensitiveFS": false,
2:             "copiers": 1,
2:             "copyOwnershipFromParent": false,
2:             "copyRangeMethod": "standard",
2:             "devices": [
2:                 {
2:                     "deviceID": "MMGUI6U-WUEZQCP-XZZ6VYB-LCT4TVC-ER2HAVX-QYT6X7D-S6ZSG2B-323KLQ7",
2:                     "encryptionPassword": "",
2:                     "introducedBy": ""
2:                 },
2:                 {
2:                     "deviceID": "7DSC2GN-GGOQ6LM-HCWY6XD-3SO4YP5-YNXIN3O-3TLA3QO-X43H7YE-IIX6JQM",
2:                     "encryptionPassword": "",
2:                     "introducedBy": ""
2:                 }
2:             ],
2:             "disableFsync": false,
2:             "disableSparseFiles": false,
2:             "disableTempIndexes": false,
2:             "filesystemType": "basic",
2:             "fsWatcherDelayS": 10,
2:             "fsWatcherEnabled": false,
2:             "hashers": 0,
2:             "id": "test2",
2:             "ignoreDelete": false,
2:             "ignorePerms": false,
2:             "junctionsAsDirs": true,
2:             "label": "Test dir 2",
2:             "markerName": ".stfolder",
2:             "maxConcurrentWrites": 2,
2:             "maxConflicts": -1,
2:             "minDiskFree": {
2:                 "unit": "%",
2:                 "value": 1
2:             },
2:             "modTimeWindowS": 0,
2:             "order": "random",
2:             "path": "/tmp/some/path/2/",
2:             "paused": true,
2:             "pullerMaxPendingKiB": 2048,
2:             "pullerPauseS": 0,
2:             "rescanIntervalS": 31536000,
2:             "scanProgressIntervalS": 0,
2:             "sendOwnership": false,
2:             "sendXattrs": false,
2:             "syncOwnership": false,
2:             "syncXattrs": false,
2:             "type": "sendreceive",
2:             "versioning": {
2:                 "cleanupIntervalS": 3600,
2:                 "fsPath": "",
2:                 "fsType": "basic",
2:                 "params": {
2:                 },
2:                 "type": ""
2:             },
2:             "weakHashThresholdPct": 25,
2:             "xattrFilter": {
2:                 "entries": [
2:                 ],
2:                 "maxSingleEntrySize": 0,
2:                 "maxTotalSize": 0
2:             }
2:         }
2:     ],
2:     "gui": {
2:         "address": "127.0.0.1:4001",
2:         "apiKey": "syncthingconnectortest",
2:         "authMode": "static",
2:         "debugging": false,
2:         "enabled": true,
2:         "insecureAdminAccess": false,
2:         "insecureAllowFrameLoading": false,
2:         "insecureSkipHostcheck": false,
2:         "password": "$2a$12$35MnbsQgQNn1hzPYK/lWXOaP.U5D2TO0nuuQy2M4gsqJB4ff4q2RK",
2:         "theme": "default",
2:         "unixSocketPermissions": "",
2:         "useTLS": false,
2:         "user": "nobody"
2:     },
2:     "ldap": {
2:         "address": "",
2:         "bindDN": "",
2:         "insecureSkipVerify": false,
2:         "searchBaseDN": "",
2:         "searchFilter": "",
2:         "transport": "plain"
2:     },
2:     "options": {
2:         "alwaysLocalNets": [
2:         ],
2:         "announceLANAddresses": true,
2:         "autoUpgradeIntervalH": 0,
2:         "cacheIgnoredFiles": false,
2:         "connectionLimitEnough": 0,
2:         "connectionLimitMax": 0,
2:         "crURL": "https://crash.syncthing.net/newcrash",
2:         "crashReportingEnabled": true,
2:         "databaseTuning": "auto",
2:         "featureFlags": [
2:         ],
2:         "globalAnnounceEnabled": true,
2:         "globalAnnounceServers": [
2:             "default"
2:         ],
2:         "insecureAllowOldTLSVersions": false,
2:         "keepTemporariesH": 24,
2:         "limitBandwidthInLan": false,
2:         "listenAddresses": [
2:             "tcp://127.0.0.1:32452"
2:         ],
2:         "localAnnounceEnabled": true,
2:         "localAnnounceMCAddr": "[ff12::8384]:21027",
2:         "localAnnouncePort": 21027,
2:         "maxConcurrentIncomingRequestKiB": 0,
2:         "maxFolderConcurrency": 0,
2:         "maxRecvKbps": 0,
2:         "maxSendKbps": 0,
2:         "minHomeDiskFree": {
2:             "unit": "%",
2:             "value": 1
2:         },
2:         "natEnabled": true,
2:         "natLeaseMinutes": 0,
2:         "natRenewalMinutes": 30,
2:         "natTimeoutSeconds": 10,
2:         "overwriteRemoteDeviceNamesOnConnect": false,
2:         "progressUpdateIntervalS": 5,
2:         "reconnectionIntervalS": 60,
2:         "relayReconnectIntervalM": 10,
2:         "relaysEnabled": true,
2:         "releasesURL": "https://upgrades.syncthing.net/meta.json",
2:         "sendFullIndexOnUpgrade": false,
2:         "setLowPriority": true,
2:         "startBrowser": true,
2:         "stunKeepaliveMinS": 20,
2:         "stunKeepaliveStartS": 180,
2:         "stunServers": [
2:             "default"
2:         ],
2:         "tempIndexMinBlocks": 10,
2:         "trafficClass": 0,
2:         "unackedNotificationIDs": [
2:             "fsWatcherNotification",
2:             "crAutoEnabled"
2:         ],
2:         "upgradeToPreReleases": true,
2:         "urAccepted": 2,
2:         "urInitialDelayS": 1800,
2:         "urPostInsecurely": false,
2:         "urSeen": 2,
2:         "urURL": "https://data.syncthing.net/newdata",
2:         "urUniqueId": "fhjO-ICd"
2:     },
2:     "remoteIgnoredDevices": [
2:     ],
2:     "version": 37
2: }
2: - /home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/syncthingctl edit --js-lines assignIfPresent(findFolder('test1'), 'rescanIntervalS', 0);
2: - /home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/syncthingctl status --dir test1
2: Directories
2:  - test1
2:    Path                          /tmp/some/path/1/
2:    Status                        idle
2:       Global                        0 file(s), 0 dir(s), 0 bytes
2:       Local                         0 file(s), 0 dir(s), 0 bytes
2:    Last scan time                2022-12-18 00:47:23
2:    Shared with                   Test dev 2
2:                                  Test dev 1
2:    Remote progress               all up-to-date
2:       Test dev 1                    0 bytes / 0 bytes (100 %)
2:       Test dev 2                    0 bytes / 0 bytes (100 %)
2:    Type                          Send & Receive
2:    Ignore permissions            no
2:    Auto-normalize                yes
2:    Rescan interval               file system watcher and periodic rescan disabled
2: 
2: - /home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/syncthingctl rescan test1
2: - /home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/syncthingctl status --dir test1
2: Directories
2:  - test1
2:    Path                          /tmp/some/path/1/
2:    Status                        idle
2:       Global                        1 file(s), 0 dir(s), 3 bytes
2:       Local                         1 file(s), 0 dir(s), 3 bytes
2:    Last scan time                2022-12-18 00:47:23
2:    Shared with                   Test dev 2
2:                                  Test dev 1
2:    Remote progress               some need bytes
2:       Test dev 2                    0 bytes / 3 bytes (0 %)
2:       Test dev 1                    0 bytes / 3 bytes (0 %)
2:    Type                          Send & Receive
2:    Ignore permissions            no
2:    Auto-normalize                yes
2:    Rescan interval               file system watcher and periodic rescan disabled
2: 
2: - /home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/syncthingctl pwd rescan
2: - /home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/cli/syncthingctl pwd status
2:  - test1
2:    Path                          /tmp/some/path/1/
2:    Status                        idle
2:       Global                        2 file(s), 1 dir(s), 134 bytes
2:       Local                         2 file(s), 1 dir(s), 134 bytes
2:    Last scan time                2022-12-18 00:47:23
2:    Shared with                   Test dev 2
2:                                  Test dev 1
2:    Remote progress               some need bytes
2:       Test dev 2                    0 bytes / 134 bytes (0 %)
2:       Test dev 1                    0 bytes / 134 bytes (0 %)
2:    Type                          Send & Receive
2:    Ignore permissions            no
2:    Auto-normalize                yes
2:    Rescan interval               file system watcher and periodic rescan disabled
2: 
2: 
2:  - Waiting for Syncthing to terminate ...
2: Info: Launched process 50521 exited with error: No child processes
2: 
2:  - Syncthing terminated with exit code -1.
2: 
2: 
2: 
2: OK (1 tests)
2: 
2: 
2: Tests successful
6/6 Test #2: syncthingctl_run_tests .........................   Passed    2.53 sec

83% tests passed, 1 tests failed out of 6

Total Test time (real) =   6.10 sec

The following tests FAILED:
         3 - syncthingwidgets_run_wizard_tests (Failed)
Errors while running CTest
FAILED: connector/CMakeFiles/check /home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1/connector/CMakeFiles/check 
cd /home/janekf/.local/cache/yay/syncthingtray/src/syncthingtray-1.3.1 && /usr/bin/ctest -V
ninja: build stopped: subcommand failed.

@Martchus
Copy link
Owner

Too bad. Then I'm out of ideas again.

@stale
Copy link

stale bot commented Feb 16, 2023

This issue has been automatically marked as stale because it has not had recent activity. It will be closed if no further activity occurs. Thank you for your contributions.

@stale stale bot added the stale label Feb 16, 2023
@Martchus
Copy link
Owner

Maybe this works on now. I've fixed a race condition on master.

@stale stale bot removed the stale label Feb 16, 2023
@stale
Copy link

stale bot commented Apr 17, 2023

This issue has been automatically marked as stale because it has not had recent activity. It will be closed if no further activity occurs. Thank you for your contributions.

@stale stale bot added the stale label Apr 17, 2023
@stale stale bot closed this as completed Apr 24, 2023
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
Projects
None yet
Development

No branches or pull requests

2 participants