addon-traccar icon indicating copy to clipboard operation
addon-traccar copied to clipboard

Occasionally traccar add-on stops working

Open mundeczek opened this issue 2 years ago • 13 comments

Problem

Occasionally traccar stops working and does not show device positions, after login via www only blank page. After restarting the add-on everything is back to normal. Below is a fragment of the traccar add-on log before restart:

2023-08-31 18:04:41  INFO: [redacted] connected
2023-08-31 18:04:42  INFO: [redacted: gt06 < IP redacted] {redacted}
2023-08-31 18:04:52  INFO: [redacted] disconnected
2023-08-31 18:04:55  WARN: Find device error - HikariPool-1 - Connection is not available, request timed out after 30000ms. - SQLTransientConnectionException (... < QueryBuilder:67 < *:140 < DatabaseStorage:72 < Storage:49 < ...)
2023-08-31 18:04:55  WARN: Unknown device - {IMEI redacted} (IP redacted)
2023-08-31 18:05:00  INFO: [redacted] connected
2023-08-31 18:05:00  INFO: [redacted: gt06 < IP redacted] {redacted}
2023-08-31 18:05:12  WARN: Find device error - HikariPool-1 - Connection is not available, request timed out after 30000ms. - SQLTransientConnectionException (... < QueryBuilder:67 < *:140 < DatabaseStorage:72 < Storage:49 < ...)
2023-08-31 18:05:12  WARN: Unknown device - {IMEI redacted} (IP redacted)
2023-08-31 18:05:16  WARN: Scheduled reports error - HikariPool-1 - Connection is not available, request timed out after 30000ms. - SQLTransientConnectionException (... < QueryBuilder:67 < *:140 < DatabaseStorage:72 < TaskReports:76 < ...)
2023-08-31 18:05:25  INFO: [redacted] disconnected
2023-08-31 18:05:30  WARN: Find device error - HikariPool-1 - Connection is not available, request timed out after 30000ms. - SQLTransientConnectionException (... < QueryBuilder:67 < *:140 < DatabaseStorage:72 < Storage:49 < ...)
2023-08-31 18:05:30  WARN: Unknown device - {IMEI redacted} (IP redacted)

After restart log:

s6-rc: info: service s6rc-oneshot-runner: starting
s6-rc: info: service s6rc-oneshot-runner successfully started
s6-rc: info: service base-addon-banner: starting
-----------------------------------------------------------
 Add-on: Traccar
 Modern GPS Tracking Platform
-----------------------------------------------------------
 Add-on version: 0.20.0
 You are running the latest version of this add-on.
 System: Home Assistant OS 10.5  (amd64 / qemux86-64)
 Home Assistant Core: 2023.8.4
 Home Assistant Supervisor: 2023.08.1
-----------------------------------------------------------
 Please, share the above information when looking for help
 or support in, e.g., GitHub, forums or the Discord chat.
-----------------------------------------------------------
s6-rc: info: service base-addon-banner successfully started
s6-rc: info: service fix-attrs: starting
s6-rc: info: service base-addon-log-level: starting
s6-rc: info: service fix-attrs successfully started
Log level is set to INFO
s6-rc: info: service base-addon-log-level successfully started
s6-rc: info: service legacy-cont-init: starting
cont-init: info: running /etc/cont-init.d/mysql.sh
cont-init: info: /etc/cont-init.d/mysql.sh exited 0
cont-init: info: running /etc/cont-init.d/nginx.sh
cont-init: info: /etc/cont-init.d/nginx.sh exited 0
cont-init: info: running /etc/cont-init.d/traccar.sh
cont-init: info: /etc/cont-init.d/traccar.sh exited 0
s6-rc: info: service legacy-cont-init successfully started
s6-rc: info: service legacy-services: starting
services-up: info: copying legacy longrun nginx (no readiness notification)
services-up: info: copying legacy longrun traccar (no readiness notification)
s6-rc: info: service legacy-services successfully started
[20:10:58] INFO: Starting Traccar server...
2023-08-31 20:11:05  INFO: Operating system name: Linux version: 6.1.45 architecture: amd64
2023-08-31 20:11:06  INFO: Java runtime name: OpenJDK 64-Bit Server VM vendor: Alpine version: 11.0.19+7-alpine-r1
2023-08-31 20:11:06  INFO: Memory limit heap: 512mb non-heap: 0mb
2023-08-31 20:11:06  INFO: Character encoding: UTF-8 charset: UTF-8
2023-08-31 20:11:06  INFO: Version: 5.8
2023-08-31 20:11:06  INFO: Starting server...
2023-08-31 20:11:07  INFO: HikariPool-1 - Starting...
2023-08-31 20:11:10  INFO: HikariPool-1 - Added connection com.mysql.cj.jdbc.ConnectionImpl@4bf324f9
2023-08-31 20:11:10  INFO: HikariPool-1 - Start completed.
2023-08-31 20:11:11  INFO: Clearing database change log checksums
2023-08-31 20:11:12  INFO: Successfully acquired change log lock
2023-08-31 20:11:12  INFO: Successfully released change log lock
2023-08-31 20:11:13  INFO: Successfully acquired change log lock
2023-08-31 20:11:21  INFO: Reading from traccar.DATABASECHANGELOG
2023-08-31 20:11:23  INFO: Reading from traccar.DATABASECHANGELOG
Database is up to date, no changesets to execute
2023-08-31 20:11:23  INFO: Reading from traccar.DATABASECHANGELOG
2023-08-31 20:11:23  INFO: UPDATE SUMMARY
2023-08-31 20:11:23  INFO: Run:                          0
2023-08-31 20:11:23  INFO: Previously run:              43
2023-08-31 20:11:23  INFO: Filtered out:                 0
2023-08-31 20:11:23  INFO: -------------------------------
2023-08-31 20:11:23  INFO: Total change sets:           43
UPDATE SUMMARY
Run:                          0
Previously run:              43
Filtered out:                 0
-------------------------------
Total change sets:           43
2023-08-31 20:11:23  INFO: Update summary generated
2023-08-31 20:11:23  INFO: Successfully released change log lock
2023-08-31 20:11:23  INFO: Successfully released change log lock
2023-08-31 20:11:23  INFO: Command execution complete
2023-08-31 20:11:31  INFO: jetty-10.0.15; built: 2023-04-11T17:25:14.480Z; git: 68017dbd00236bb7e187330d7585a059610f661d; jvm 11.0.19+7-alpine-r1
2023-08-31 20:11:31  INFO: Started o.t.w.@4e50ae56{/,null,AVAILABLE}
2023-08-31 20:11:31  INFO: Session workerName=node0
[20:11:32] INFO: Starting NGinx server...
2023-08-31 20:11:35  WARN: JAXBContext implementation could not be found. WADL feature is disabled.
2023-08-31 20:11:39  INFO: Started o.e.j.s.ServletContextHandler@4af0c50{/,null,AVAILABLE}
2023-08-31 20:11:39  INFO: Started ServerConnector@1c84d80a{HTTP/1.1, (http/1.1)}{localhost:18682}
2023-08-31 20:11:39  INFO: Started Server@7272ee51{STARTING}[10.0.15,sto=0] @40728ms
2023-08-31 20:11:39  WARN: No systemd support - Unable to load library 'systemd':
Error loading shared library libsystemd.so: No such file or directory
Error loading shared library libsystemd.so: No such file or directory
Native library (linux-x86-64/libsystemd.so) not found in resource path (tracker-server.jar) - UnsatisfiedLinkError (... < TaskHealthCheck:49 < <gener:-1 < *:-1 < ... < ScheduleManager:46 < ...)
2023-08-31 20:11:40  INFO: [redacted] connected

System Information

version core-2023.8.4
installation_type Home Assistant OS
dev false
hassio true
docker true
user root
virtualenv false
python_version 3.11.4
os_name Linux
os_version 6.1.45
arch x86_64
timezone Europe/Warsaw
config_dir /config
Home Assistant Community Store
GitHub API ok
GitHub Content ok
GitHub Web ok
GitHub API Calls Remaining 5000
Installed Version 1.32.1
Stage running
Available Repositories 1340
Downloaded Repositories 14
Airly
can_reach_server ok
requests_remaining 27
requests_per_day 100
Home Assistant Cloud
logged_in false
can_reach_cert_server ok
can_reach_cloud_auth ok
can_reach_cloud ok
Home Assistant Supervisor
host_os Home Assistant OS 10.5
update_channel stable
supervisor_version supervisor-2023.08.1
agent_version 1.5.1
docker_version 23.0.6
disk_total 62.3 GB
disk_used 22.0 GB
healthy true
supported true
board ova
supervisor_api ok
version_api ok
installed_addons MariaDB (2.6.1), Node-RED (14.4.5), Mosquitto broker (6.2.1), Zigbee2mqtt (1.18.1-1), NGINX Home Assistant SSL proxy (3.5.0), Duck DNS (1.15.0), File editor (5.6.0), Rhasspy Assistant (2.5.11), Alsa & PulseAudio Fix (3.4.1), Traccar (0.20.0), Samba Backup (5.2.0), MPD (1.7.2), Samba share with features (10.0.2.2), Signal Messenger (0.67.1), MaryTTS (1.5.2), motionEye (0.19.1), ESPHome (2023.8.2), Cloudflared (4.2.5), Epic Games Free (f7d1dfdacc198aaada2ea2b69a7cbe3478cb6579-2022-12-26), TooGoodToGo Home Assistant MQTT Bridge (2.5.1.2), Baikal (0.9.3), phpMyAdmin (0.8.7), Nginx Proxy Manager (0.12.3), Terminal & SSH (9.7.1), Log Viewer (0.15.1), Network UPS Tools (0.12.0), Tailscale (0.11.1), Wmbusmeters (W-MBus to MQTT) (1.14.0), HassOS SSH port 22222 Configurator (0.9.1a), SQLite Web (3.9.2), ZeroTier One (0.17.0), rtl_433 (0.4.0), rtl_433 MQTT Auto Discovery (0.6.0), InfluxDB (4.7.0), Grafana (9.0.3)
Dashboards
dashboards 1
resources 8
views 14
mode storage
Recorder
oldest_recorder_run 13 sierpnia 2023 18:53
current_recorder_run 27 sierpnia 2023 15:28
database_engine mysql
database_version 10.5.19

mundeczek avatar Aug 31 '23 18:08 mundeczek

UPDATE: Few days ago besides the information in the logs that I posted in my earlier post, it was also recorded:

[344475.049s][warning][os,thread] Failed to start the native thread for java.lang.Thread "qtp2042188002-19237"
[344475.051s][warning][os,thread] Failed to start thread "Unknown thread" - pthread_create failed (EAGAIN) for attributes: stacksize: 1024k, guardsize: 0k, detached.
[344475.053s][warning][os,thread] Failed to start the native thread for java.lang.Thread "qtp2042188002-19238"
2023-09-18 07:38:48  WARN: Find device error - HikariPool-1 - Connection is not available, request timed out after 30000ms. - SQLTransientConnectionException (... < QueryBuilder:67 < *:140 < DatabaseStorage:72 < Storage:49 < ...)

And in log from MariaDB Add-on:

2023-09-18  7:35:08 3184 [Warning] Aborted connection 3184 to db: 'traccar' user: 'service' host: '172.30.32.1' (Got an error reading communication packets)
2023-09-18  7:41:49 3182 [Warning] Aborted connection 3182 to db: 'traccar' user: 'service' host: '172.30.32.1' (Got an error reading communication packets)
2023-09-18  7:41:49 3174 [Warning] Aborted connection 3174 to db: 'traccar' user: 'service' host: '172.30.32.1' (Got an error reading communication packets)
2023-09-18  7:41:49 3183 [Warning] Aborted connection 3183 to db: 'traccar' user: 'service' host: '172.30.32.1' (Got an error reading communication packets)
2023-09-18  7:41:49 3172 [Warning] Aborted connection 3172 to db: 'traccar' user: 'service' host: '172.30.32.1' (Got an error reading communication packets)
2023-09-18  7:41:49 3173 [Warning] Aborted connection 3173 to db: 'traccar' user: 'service' host: '172.30.32.1' (Got an error reading communication packets)
2023-09-18  7:41:49 3176 [Warning] Aborted connection 3176 to db: 'traccar' user: 'service' host: '172.30.32.1' (Got an error reading communication packets)
2023-09-18  7:41:49 3177 [Warning] Aborted connection 3177 to db: 'traccar' user: 'service' host: '172.30.32.1' (Got an error reading communication packets)
2023-09-18  7:41:49 3175 [Warning] Aborted connection 3175 to db: 'traccar' user: 'service' host: '172.30.32.1' (Got an error reading communication packets)

Between the first post and the current one, Traccar was updated to version 0.21.0. Which as you can see, did not fix the issue, and approximately every week, the add-on stops working, throwing errors and requiring a restart.

mundeczek avatar Sep 21 '23 19:09 mundeczek

I'm also having the same issue with Traccar and MariaDB, did you find a solution?

fyrstyk avatar Oct 09 '23 11:10 fyrstyk

I'm also having the same issue with Traccar and MariaDB, did you find a solution?

Unfortunately I have not found a solution.

mundeczek avatar Oct 09 '23 16:10 mundeczek

same issue here with mariadb connection broke after the update of Traccar addon (edit: not sure if it was Traccar update or any of HA 2023.10.x updates). Current traccar version: 0.21.1

2023-10-26 14:56:56 167 [Warning] Aborted connection 167 to db: 'traccar' user: 'service' host: '172.30.32.1' (Got an error reading communication packets)

Edit #2: today after updating to Operating System 11.1, traccar is back online..

LaurisGale avatar Oct 26 '23 14:10 LaurisGale

So far I managed to do it using automation (of course this is not how it should be solved):

alias: Traccar restart
description: Traccar restart
trigger:
  - platform: time
    at: "04:00:00"
condition: []
action:
  - data:
      addon: a0d7b954_traccar
    service: hassio.addon_restart
mode: single

mundeczek avatar Nov 12 '23 18:11 mundeczek

There hasn't been any activity on this issue recently, so we clean up some of the older and inactive issues. Please make sure to update to the latest version and check if that solves the issue. Let us know if that works for you by leaving a comment 👍 This issue has now been marked as stale and will be closed if no further activity occurs. Thanks!

github-actions[bot] avatar Dec 13 '23 08:12 github-actions[bot]

Keep open

mundeczek avatar Dec 13 '23 11:12 mundeczek

There hasn't been any activity on this issue recently, so we clean up some of the older and inactive issues. Please make sure to update to the latest version and check if that solves the issue. Let us know if that works for you by leaving a comment 👍 This issue has now been marked as stale and will be closed if no further activity occurs. Thanks!

github-actions[bot] avatar Jan 14 '24 08:01 github-actions[bot]

Problem is still not fixed

mundeczek avatar Jan 14 '24 08:01 mundeczek

There hasn't been any activity on this issue recently, so we clean up some of the older and inactive issues. Please make sure to update to the latest version and check if that solves the issue. Let us know if that works for you by leaving a comment 👍 This issue has now been marked as stale and will be closed if no further activity occurs. Thanks!

github-actions[bot] avatar Feb 15 '24 08:02 github-actions[bot]

Keep open

mundeczek avatar Feb 15 '24 14:02 mundeczek

There hasn't been any activity on this issue recently, so we clean up some of the older and inactive issues. Please make sure to update to the latest version and check if that solves the issue. Let us know if that works for you by leaving a comment 👍 This issue has now been marked as stale and will be closed if no further activity occurs. Thanks!

github-actions[bot] avatar Mar 18 '24 08:03 github-actions[bot]

Problem still occurs

mundeczek avatar Mar 18 '24 13:03 mundeczek

There hasn't been any activity on this issue recently, so we clean up some of the older and inactive issues. Please make sure to update to the latest version and check if that solves the issue. Let us know if that works for you by leaving a comment 👍 This issue has now been marked as stale and will be closed if no further activity occurs. Thanks!

github-actions[bot] avatar Apr 18 '24 08:04 github-actions[bot]

Still not working

mundeczek avatar Apr 18 '24 18:04 mundeczek

There hasn't been any activity on this issue recently, so we clean up some of the older and inactive issues. Please make sure to update to the latest version and check if that solves the issue. Let us know if that works for you by leaving a comment 👍 This issue has now been marked as stale and will be closed if no further activity occurs. Thanks!

github-actions[bot] avatar May 20 '24 08:05 github-actions[bot]

Problem still occurs

mundeczek avatar May 28 '24 11:05 mundeczek