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

MQTT Plugin #2666

Closed
gdg316 opened this issue Sep 15, 2022 · 12 comments
Closed

MQTT Plugin #2666

gdg316 opened this issue Sep 15, 2022 · 12 comments

Comments

@gdg316
Copy link

gdg316 commented Sep 15, 2022

Describe the issue you are experiencing

Works with debugging enabled but without has issues like client unknown Closed connection and Rejected unauthorized user disconnected

What type of installation are you running?

Home Assistant OS

Which operating system are you running on?

Other (e.g., Raspbian/Raspberry Pi OS/Fedora)

Which add-on are you reporting an issue with?

Mosquitto broker

What is the version of the add-on?

6.1.3

Steps to reproduce the issue

Disabling Debugging will reproduce issue

Anything in the Supervisor logs that might be useful for us?

22-09-15 07:27:03 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.IPV4_CONNECTION_PROBLEM/ContextType.SYSTEM
22-09-15 07:27:03 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.DNS_SERVER_FAILED/ContextType.DNS_SERVER
22-09-15 07:27:03 INFO (MainThread) [supervisor.resolution.check] System checks complete
22-09-15 07:27:03 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state CoreState.RUNNING
22-09-15 07:27:04 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete
22-09-15 07:27:04 INFO (MainThread) [supervisor.resolution.fixup] Starting system autofix at state CoreState.RUNNING
22-09-15 07:27:04 INFO (MainThread) [supervisor.resolution.fixup] System autofix complete
22-09-15 07:28:50 INFO (MainThread) [supervisor.homeassistant.api] Updated Home Assistant API token
22-09-15 07:58:51 INFO (MainThread) [supervisor.homeassistant.api] Updated Home Assistant API token
22-09-15 08:27:04 INFO (MainThread) [supervisor.resolution.check] Starting system checks with state CoreState.RUNNING
22-09-15 08:27:04 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.TRUST/ContextType.SUPERVISOR
22-09-15 08:27:04 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.DNS_SERVER_IPV6_ERROR/ContextType.DNS_SERVER
22-09-15 08:27:04 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.FREE_SPACE/ContextType.SYSTEM
22-09-15 08:27:04 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.PWNED/ContextType.ADDON
22-09-15 08:27:04 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.SECURITY/ContextType.CORE
22-09-15 08:27:04 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.IPV4_CONNECTION_PROBLEM/ContextType.SYSTEM
22-09-15 08:27:04 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.DNS_SERVER_FAILED/ContextType.DNS_SERVER
22-09-15 08:27:04 INFO (MainThread) [supervisor.resolution.check] System checks complete
22-09-15 08:27:04 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state CoreState.RUNNING
22-09-15 08:27:04 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete
22-09-15 08:27:04 INFO (MainThread) [supervisor.resolution.fixup] Starting system autofix at state CoreState.RUNNING
22-09-15 08:27:04 INFO (MainThread) [supervisor.resolution.fixup] System autofix complete
22-09-15 08:28:49 INFO (MainThread) [supervisor.updater] Fetching update data from https://version.home-assistant.io/stable.json
22-09-15 08:28:51 INFO (MainThread) [supervisor.homeassistant.api] Updated Home Assistant API token
22-09-15 08:35:29 INFO (MainThread) [supervisor.host.info] Updating local host information
22-09-15 08:35:30 INFO (MainThread) [supervisor.host.services] Updating service information
22-09-15 08:35:30 INFO (MainThread) [supervisor.host.network] Updating local network information
22-09-15 08:35:31 INFO (MainThread) [supervisor.host.sound] Updating PulseAudio information
22-09-15 08:35:31 INFO (MainThread) [supervisor.host.manager] Host information reload completed
22-09-15 08:58:51 INFO (MainThread) [supervisor.homeassistant.api] Updated Home Assistant API token
22-09-15 09:27:04 INFO (MainThread) [supervisor.resolution.check] Starting system checks with state CoreState.RUNNING
22-09-15 09:27:04 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.TRUST/ContextType.SUPERVISOR
22-09-15 09:27:04 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.DNS_SERVER_IPV6_ERROR/ContextType.DNS_SERVER
22-09-15 09:27:04 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.FREE_SPACE/ContextType.SYSTEM
22-09-15 09:27:04 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.PWNED/ContextType.ADDON
22-09-15 09:27:04 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.SECURITY/ContextType.CORE
22-09-15 09:27:04 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.IPV4_CONNECTION_PROBLEM/ContextType.SYSTEM
22-09-15 09:27:04 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.DNS_SERVER_FAILED/ContextType.DNS_SERVER
22-09-15 09:27:04 INFO (MainThread) [supervisor.resolution.check] System checks complete
22-09-15 09:27:04 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state CoreState.RUNNING
22-09-15 09:27:04 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete
22-09-15 09:27:04 INFO (MainThread) [supervisor.resolution.fixup] Starting system autofix at state CoreState.RUNNING
22-09-15 09:27:04 INFO (MainThread) [supervisor.resolution.fixup] System autofix complete
22-09-15 09:28:49 INFO (MainThread) [supervisor.store.git] Update add-on https://github.com/home-assistant/addons repository
22-09-15 09:28:49 INFO (MainThread) [supervisor.store.git] Update add-on https://github.com/hassio-addons/repository repository
22-09-15 09:28:49 INFO (MainThread) [supervisor.store.git] Update add-on https://github.com/tsightler/ring-mqtt-ha-addon repository
22-09-15 09:28:49 INFO (MainThread) [supervisor.store.git] Update add-on https://github.com/esphome/home-assistant-addon repository
22-09-15 09:28:52 INFO (MainThread) [supervisor.homeassistant.api] Updated Home Assistant API token
22-09-15 09:28:52 INFO (MainThread) [supervisor.store] Loading add-ons from store: 67 all - 0 new - 0 remove
22-09-15 09:28:52 INFO (MainThread) [supervisor.store] Loading add-ons from store: 67 all - 0 new - 0 remove
22-09-15 09:58:52 INFO (MainThread) [supervisor.homeassistant.api] Updated Home Assistant API token
22-09-15 10:27:04 INFO (MainThread) [supervisor.resolution.check] Starting system checks with state CoreState.RUNNING
22-09-15 10:27:04 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.TRUST/ContextType.SUPERVISOR
22-09-15 10:27:04 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.DNS_SERVER_IPV6_ERROR/ContextType.DNS_SERVER
22-09-15 10:27:04 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.FREE_SPACE/ContextType.SYSTEM
22-09-15 10:27:04 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.PWNED/ContextType.ADDON
22-09-15 10:27:04 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.SECURITY/ContextType.CORE
22-09-15 10:27:04 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.IPV4_CONNECTION_PROBLEM/ContextType.SYSTEM
22-09-15 10:27:04 INFO (MainThread) [supervisor.resolution.checks.base] Run check for IssueType.DNS_SERVER_FAILED/ContextType.DNS_SERVER
22-09-15 10:27:04 INFO (MainThread) [supervisor.resolution.check] System checks complete
22-09-15 10:27:04 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state CoreState.RUNNING
22-09-15 10:27:04 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete
22-09-15 10:27:04 INFO (MainThread) [supervisor.resolution.fixup] Starting system autofix at state CoreState.RUNNING
22-09-15 10:27:04 INFO (MainThread) [supervisor.resolution.fixup] System autofix complete

Anything in the add-on logs that might be useful for us?

time="2022-09-15T10:29:11-04:00" level=debug msg="Superuser check with backend Files"
time="2022-09-15T10:29:11-04:00" level=debug msg="Superuser check with backend HTTP"
time="2022-09-15T10:29:11-04:00" level=debug msg="http request approved for mqtt-0517"
time="2022-09-15T10:29:11-04:00" level=debug msg="superuser mqtt-0517 acl authenticated with backend HTTP"
time="2022-09-15T10:29:11-04:00" level=debug msg="setting acl cache (granted = true) for mqtt-0517"
time="2022-09-15T10:29:11-04:00" level=debug msg="to auth record: [97 99 108 45 109 113 116 116 45 48 53 49 55 45 114 105 110 103 47 56 57 98 56 49 102 48 102 45 56 57 101 48 45 52 50 53 54 45 98 101 48 57 45 49 100 99 57 48 102 53 49 55 55 102 97 47 108 105 103 104 116 105 110 103 47 56 55 54 98 52 54 51 50 45 49 56 52 54 45 52 50 98 51 45 97 100 100 57 45 57 51 51 98 97 54 55 54 98 52 100 99 47 109 111 116 105 111 110 47 115 116 97 116 101 45 50 80 121 115 89 113 89 87 103 74 83 79 81 72 80 102 86 103 102 103 98 114 45 49 218 57 163 238 94 107 75 13 50 85 191 239 149 96 24 144 175 216 7 9]\n"
time="2022-09-15T10:29:11-04:00" level=debug msg="Acl is true for user mqtt-0517"
time="2022-09-15T10:29:11-04:00" level=debug msg="checking acl cache for mqtt-0517"
time="2022-09-15T10:29:11-04:00" level=debug msg="to auth record: [97 99 108 45 109 113 116 116 45 48 53 49 55 45 114 105 110 103 47 56 57 98 56 49 102 48 102 45 56 57 101 48 45 52 50 53 54 45 98 101 48 57 45 49 100 99 57 48 102 53 49 55 55 102 97 47 108 105 103 104 116 105 110 103 47 56 55 54 98 52 54 51 50 45 49 56 52 54 45 52 50 98 51 45 97 100 100 57 45 57 51 51 98 97 54 55 54 98 52 100 99 47 108 105 103 104 116 47 115 116 97 116 101 45 109 113 116 116 106 115 95 48 48 99 102 98 97 101 54 45 50 218 57 163 238 94 107 75 13 50 85 191 239 149 96 24 144 175 216 7 9]\n"
time="2022-09-15T10:29:11-04:00" level=debug msg="Superuser check with backend Files"
time="2022-09-15T10:29:11-04:00" level=debug msg="Superuser check with backend HTTP"
time="2022-09-15T10:29:11-04:00" level=debug msg="http request approved for mqtt-0517"
time="2022-09-15T10:29:11-04:00" level=debug msg="superuser mqtt-0517 acl authenticated with backend HTTP"
time="2022-09-15T10:29:11-04:00" level=debug msg="setting acl cache (granted = true) for mqtt-0517"
time="2022-09-15T10:29:11-04:00" level=debug msg="to auth record: [97 99 108 45 109 113 116 116 45 48 53 49 55 45 114 105 110 103 47 56 57 98 56 49 102 48 102 45 56 57 101 48 45 52 50 53 54 45 98 101 48 57 45 49 100 99 57 48 102 53 49 55 55 102 97 47 108 105 103 104 116 105 110 103 47 56 55 54 98 52 54 51 50 45 49 56 52 54 45 52 50 98 51 45 97 100 100 57 45 57 51 51 98 97 54 55 54 98 52 100 99 47 108 105 103 104 116 47 115 116 97 116 101 45 109 113 116 116 106 115 95 48 48 99 102 98 97 101 54 45 50 218 57 163 238 94 107 75 13 50 85 191 239 149 96 24 144 175 216 7 9]\n"
time="2022-09-15T10:29:11-04:00" level=debug msg="Acl is true for user mqtt-0517"
time="2022-09-15T10:29:11-04:00" level=debug msg="checking acl cache for mqtt-0517"
time="2022-09-15T10:29:11-04:00" level=debug msg="to auth record: [97 99 108 45 109 113 116 116 45 48 53 49 55 45 114 105 110 103 47 56 57 98 56 49 102 48 102 45 56 57 101 48 45 52 50 53 54 45 98 101 48 57 45 49 100 99 57 48 102 53 49 55 55 102 97 47 108 105 103 104 116 105 110 103 47 56 55 54 98 52 54 51 50 45 49 56 52 54 45 52 50 98 51 45 97 100 100 57 45 57 51 51 98 97 54 55 54 98 52 100 99 47 108 105 103 104 116 47 115 116 97 116 101 45 50 80 121 115 89 113 89 87 103 74 83 79 81 72 80 102 86 103 102 103 98 114 45 49 218 57 163 238 94 107 75 13 50 85 191 239 149 96 24 144 175 216 7 9]\n"
time="2022-09-15T10:29:11-04:00" level=debug msg="Superuser check with backend Files"
time="2022-09-15T10:29:11-04:00" level=debug msg="Superuser check with backend HTTP"
time="2022-09-15T10:29:11-04:00" level=debug msg="http request approved for mqtt-0517"
time="2022-09-15T10:29:11-04:00" level=debug msg="superuser mqtt-0517 acl authenticated with backend HTTP"
time="2022-09-15T10:29:11-04:00" level=debug msg="setting acl cache (granted = true) for mqtt-0517"
time="2022-09-15T10:29:11-04:00" level=debug msg="to auth record: [97 99 108 45 109 113 116 116 45 48 53 49 55 45 114 105 110 103 47 56 57 98 56 49 102 48 102 45 56 57 101 48 45 52 50 53 54 45 98 101 48 57 45 49 100 99 57 48 102 53 49 55 55 102 97 47 108 105 103 104 116 105 110 103 47 56 55 54 98 52 54 51 50 45 49 56 52 54 45 52 50 98 51 45 97 100 100 57 45 57 51 51 98 97 54 55 54 98 52 100 99 47 108 105 103 104 116 47 115 116 97 116 101 45 50 80 121 115 89 113 89 87 103 74 83 79 81 72 80 102 86 103 102 103 98 114 45 49 218 57 163 238 94 107 75 13 50 85 191 239 149 96 24 144 175 216 7 9]\n"
time="2022-09-15T10:29:11-04:00" level=debug msg="Acl is true for user mqtt-0517"
time="2022-09-15T10:29:11-04:00" level=debug msg="checking acl cache for mqtt-0517"
time="2022-09-15T10:29:11-04:00" level=debug msg="to auth record: [97 99 108 45 109 113 116 116 45 48 53 49 55 45 114 105 110 103 47 56 57 98 56 49 102 48 102 45 56 57 101 48 45 52 50 53 54 45 98 101 48 57 45 49 100 99 57 48 102 53 49 55 55 102 97 47 108 105 103 104 116 105 110 103 47 56 55 54 98 52 54 51 50 45 49 56 52 54 45 52 50 98 51 45 97 100 100 57 45 57 51 51 98 97 54 55 54 98 52 100 99 47 108 105 103 104 116 47 98 114 105 103 104 116 110 101 115 115 95 115 116 97 116 101 45 109 113 116 116 106 115 95 48 48 99 102 98 97 101 54 45 50 218 57 163 238 94 107 75 13 50 85 191 239 149 96 24 144 175 216 7 9]\n"
time="2022-09-15T10:29:11-04:00" level=debug msg="Superuser check with backend Files"
time="2022-09-15T10:29:11-04:00" level=debug msg="Superuser check with backend HTTP"
time="2022-09-15T10:29:11-04:00" level=debug msg="http request approved for mqtt-0517"
time="2022-09-15T10:29:11-04:00" level=debug msg="superuser mqtt-0517 acl authenticated with backend HTTP"
time="2022-09-15T10:29:11-04:00" level=debug msg="setting acl cache (granted = true) for mqtt-0517"
time="2022-09-15T10:29:11-04:00" level=debug msg="to auth record: [97 99 108 45 109 113 116 116 45 48 53 49 55 45 114 105 110 103 47 56 57 98 56 49 102 48 102 45 56 57 101 48 45 52 50 53 54 45 98 101 48 57 45 49 100 99 57 48 102 53 49 55 55 102 97 47 108 105 103 104 116 105 110 103 47 56 55 54 98 52 54 51 50 45 49 56 52 54 45 52 50 98 51 45 97 100 100 57 45 57 51 51 98 97 54 55 54 98 52 100 99 47 108 105 103 104 116 47 98 114 105 103 104 116 110 101 115 115 95 115 116 97 116 101 45 109 113 116 116 106 115 95 48 48 99 102 98 97 101 54 45 50 218 57 163 238 94 107 75 13 50 85 191 239 149 96 24 144 175 216 7 9]\n"
time="2022-09-15T10:29:11-04:00" level=debug msg="Acl is true for user mqtt-0517"
time="2022-09-15T10:29:11-04:00" level=debug msg="checking acl cache for mqtt-0517"
time="2022-09-15T10:29:11-04:00" level=debug msg="to auth record: [97 99 108 45 109 113 116 116 45 48 53 49 55 45 114 105 110 103 47 56 57 98 56 49 102 48 102 45 56 57 101 48 45 52 50 53 54 45 98 101 48 57 45 49 100 99 57 48 102 53 49 55 55 102 97 47 108 105 103 104 116 105 110 103 47 56 55 54 98 52 54 51 50 45 49 56 52 54 45 52 50 98 51 45 97 100 100 57 45 57 51 51 98 97 54 55 54 98 52 100 99 47 108 105 103 104 116 47 98 114 105 103 104 116 110 101 115 115 95 115 116 97 116 101 45 50 80 121 115 89 113 89 87 103 74 83 79 81 72 80 102 86 103 102 103 98 114 45 49 218 57 163 238 94 107 75 13 50 85 191 239 149 96 24 144 175 216 7 9]\n"
time="2022-09-15T10:29:11-04:00" level=debug msg="Superuser check with backend Files"
time="2022-09-15T10:29:11-04:00" level=debug msg="Superuser check with backend HTTP"
time="2022-09-15T10:29:11-04:00" level=debug msg="http request approved for mqtt-0517"
time="2022-09-15T10:29:11-04:00" level=debug msg="superuser mqtt-0517 acl authenticated with backend HTTP"
time="2022-09-15T10:29:11-04:00" level=debug msg="setting acl cache (granted = true) for mqtt-0517"
time="2022-09-15T10:29:11-04:00" level=debug msg="to auth record: [97 99 108 45 109 113 116 116 45 48 53 49 55 45 114 105 110 103 47 56 57 98 56 49 102 48 102 45 56 57 101 48 45 52 50 53 54 45 98 101 48 57 45 49 100 99 57 48 102 53 49 55 55 102 97 47 108 105 103 104 116 105 110 103 47 56 55 54 98 52 54 51 50 45 49 56 52 54 45 52 50 98 51 45 97 100 100 57 45 57 51 51 98 97 54 55 54 98 52 100 99 47 108 105 103 104 116 47 98 114 105 103 104 116 110 101 115 115 95 115 116 97 116 101 45 50 80 121 115 89 113 89 87 103 74 83 79 81 72 80 102 86 103 102 103 98 114 45 49 218 57 163 238 94 107 75 13 50 85 191 239 149 96 24 144 175 216 7 9]\n"
time="2022-09-15T10:29:11-04:00" level=debug msg="Acl is true for user mqtt-0517"
time="2022-09-15T10:29:11-04:00" level=debug msg="checking acl cache for mqtt-0517"
time="2022-09-15T10:29:11-04:00" level=debug msg="to auth record: [97 99 108 45 109 113 116 116 45 48 53 49 55 45 114 105 110 103 47 56 57 98 56 49 102 48 102 45 56 57 101 48 45 52 50 53 54 45 98 101 48 57 45 49 100 99 57 48 102 53 49 55 55 102 97 47 108 105 103 104 116 105 110 103 47 56 55 54 98 52 54 51 50 45 49 56 52 54 45 52 50 98 51 45 97 100 100 57 45 57 51 51 98 97 54 55 54 98 52 100 99 47 98 101 97 109 95 100 117 114 97 116 105 111 110 47 115 116 97 116 101 45 109 113 116 116 106 115 95 48 48 99 102 98 97 101 54 45 50 218 57 163 238 94 107 75 13 50 85 191 239 149 96 24 144 175 216 7 9]\n"
time="2022-09-15T10:29:11-04:00" level=debug msg="Superuser check with backend Files"
time="2022-09-15T10:29:11-04:00" level=debug msg="Superuser check with backend HTTP"
time="2022-09-15T10:29:11-04:00" level=debug msg="http request approved for mqtt-0517"
time="2022-09-15T10:29:11-04:00" level=debug msg="superuser mqtt-0517 acl authenticated with backend HTTP"
time="2022-09-15T10:29:11-04:00" level=debug msg="setting acl cache (granted = true) for mqtt-0517"
time="2022-09-15T10:29:11-04:00" level=debug msg="to auth record: [97 99 108 45 109 113 116 116 45 48 53 49 55 45 114 105 110 103 47 56 57 98 56 49 102 48 102 45 56 57 101 48 45 52 50 53 54 45 98 101 48 57 45 49 100 99 57 48 102 53 49 55 55 102 97 47 108 105 103 104 116 105 110 103 47 56 55 54 98 52 54 51 50 45 49 56 52 54 45 52 50 98 51 45 97 100 100 57 45 57 51 51 98 97 54 55 54 98 52 100 99 47 98 101 97 109 95 100 117 114 97 116 105 111 110 47 115 116 97 116 101 45 109 113 116 116 106 115 95 48 48 99 102 98 97 101 54 45 50 218 57 163 238 94 107 75 13 50 85 191 239 149 96 24 144 175 216 7 9]\n"
time="2022-09-15T10:29:11-04:00" level=debug msg="Acl is true for user mqtt-0517"
time="2022-09-15T10:29:11-04:00" level=debug msg="checking acl cache for mqtt-0517"
time="2022-09-15T10:29:11-04:00" level=debug msg="to auth record: [97 99 108 45 109 113 116 116 45 48 53 49 55 45 114 105 110 103 47 56 57 98 56 49 102 48 102 45 56 57 101 48 45 52 50 53 54 45 98 101 48 57 45 49 100 99 57 48 102 53 49 55 55 102 97 47 108 105 103 104 116 105 110 103 47 56 55 54 98 52 54 51 50 45 49 56 52 54 45 52 50 98 51 45 97 100 100 57 45 57 51 51 98 97 54 55 54 98 52 100 99 47 98 101 97 109 95 100 117 114 97 116 105 111 110 47 115 116 97 116 101 45 50 80 121 115 89 113 89 87 103 74 83 79 81 72 80 102 86 103 102 103 98 114 45 49 218 57 163 238 94 107 75 13 50 85 191 239 149 96 24 144 175 216 7 9]\n"
time="2022-09-15T10:29:11-04:00" level=debug msg="Superuser check with backend Files"
time="2022-09-15T10:29:11-04:00" level=debug msg="Superuser check with backend HTTP"
time="2022-09-15T10:29:11-04:00" level=debug msg="http request approved for mqtt-0517"
time="2022-09-15T10:29:11-04:00" level=debug msg="superuser mqtt-0517 acl authenticated with backend HTTP"
time="2022-09-15T10:29:11-04:00" level=debug msg="setting acl cache (granted = true) for mqtt-0517"
time="2022-09-15T10:29:11-04:00" level=debug msg="to auth record: [97 99 108 45 109 113 116 116 45 48 53 49 55 45 114 105 110 103 47 56 57 98 56 49 102 48 102 45 56 57 101 48 45 52 50 53 54 45 98 101 48 57 45 49 100 99 57 48 102 53 49 55 55 102 97 47 108 105 103 104 116 105 110 103 47 56 55 54 98 52 54 51 50 45 49 56 52 54 45 52 50 98 51 45 97 100 100 57 45 57 51 51 98 97 54 55 54 98 52 100 99 47 98 101 97 109 95 100 117 114 97 116 105 111 110 47 115 116 97 116 101 45 50 80 121 115 89 113 89 87 103 74 83 79 81 72 80 102 86 103 102 103 98 114 45 49 218 57 163 238 94 107 75 13 50 85 191 239 149 96 24 144 175 216 7 9]\n"
time="2022-09-15T10:29:11-04:00" level=debug msg="Acl is true for user mqtt-0517"
time="2022-09-15T10:29:11-04:00" level=debug msg="checking acl cache for mqtt-0517"
time="2022-09-15T10:29:11-04:00" level=debug msg="to auth record: [97 99 108 45 109 113 116 116 45 48 53 49 55 45 114 105 110 103 47 56 57 98 56 49 102 48 102 45 56 57 101 48 45 52 50 53 54 45 98 101 48 57 45 49 100 99 57 48 102 53 49 55 55 102 97 47 108 105 103 104 116 105 110 103 47 56 55 54 98 52 54 51 50 45 49 56 52 54 45 52 50 98 51 45 97 100 100 57 45 57 51 51 98 97 54 55 54 98 52 100 99 47 105 110 102 111 47 115 116 97 116 101 45 109 113 116 116 106 115 95 48 48 99 102 98 97 101 54 45 50 218 57 163 238 94 107 75 13 50 85 191 239 149 96 24 144 175 216 7 9]\n"
time="2022-09-15T10:29:11-04:00" level=debug msg="found in cache: mqtt-0517"
time="2022-09-15T10:29:11-04:00" level=debug msg="checking acl cache for mqtt-0517"
time="2022-09-15T10:29:11-04:00" level=debug msg="to auth record: [97 99 108 45 109 113 116 116 45 48 53 49 55 45 114 105 110 103 47 56 57 98 56 49 102 48 102 45 56 57 101 48 45 52 50 53 54 45 98 101 48 57 45 49 100 99 57 48 102 53 49 55 55 102 97 47 108 105 103 104 116 105 110 103 47 56 55 54 98 52 54 51 50 45 49 56 52 54 45 52 50 98 51 45 97 100 100 57 45 57 51 51 98 97 54 55 54 98 52 100 99 47 105 110 102 111 47 115 116 97 116 101 45 50 80 121 115 89 113 89 87 103 74 83 79 81 72 80 102 86 103 102 103 98 114 45 49 218 57 163 238 94 107 75 13 50 85 191 239 149 96 24 144 175 216 7 9]\n"
time="2022-09-15T10:29:11-04:00" level=debug msg="found in cache: mqtt-0517"
time="2022-09-15T10:29:11-04:00" level=debug msg="checking acl cache for mqtt-0517"
time="2022-09-15T10:29:11-04:00" level=debug msg="to auth record: [97 99 108 45 109 113 116 116 45 48 53 49 55 45 114 105 110 103 47 56 57 98 56 49 102 48 102 45 56 57 101 48 45 52 50 53 54 45 98 101 48 57 45 49 100 99 57 48 102 53 49 55 55 102 97 47 108 105 103 104 116 105 110 103 47 56 55 54 98 52 54 51 50 45 49 56 52 54 45 52 50 98 51 45 97 100 100 57 45 57 51 51 98 97 54 55 54 98 52 100 99 47 98 97 116 116 101 114 121 47 97 116 116 114 105 98 117 116 101 115 45 109 113 116 116 106 115 95 48 48 99 102 98 97 101 54 45 50 218 57 163 238 94 107 75 13 50 85 191 239 149 96 24 144 175 216 7 9]\n"
time="2022-09-15T10:29:11-04:00" level=debug msg="found in cache: mqtt-0517"
time="2022-09-15T10:29:11-04:00" level=debug msg="checking acl cache for mqtt-0517"
time="2022-09-15T10:29:11-04:00" level=debug msg="to auth record: [97 99 108 45 109 113 116 116 45 48 53 49 55 45 114 105 110 103 47 56 57 98 56 49 102 48 102 45 56 57 101 48 45 52 50 53 54 45 98 101 48 57 45 49 100 99 57 48 102 53 49 55 55 102 97 47 108 105 103 104 116 105 110 103 47 56 55 54 98 52 54 51 50 45 49 56 52 54 45 52 50 98 51 45 97 100 100 57 45 57 51 51 98 97 54 55 54 98 52 100 99 47 98 97 116 116 101 114 121 47 97 116 116 114 105 98 117 116 101 115 45 50 80 121 115 89 113 89 87 103 74 83 79 81 72 80 102 86 103 102 103 98 114 45 49 218 57 163 238 94 107 75 13 50 85 191 239 149 96 24 144 175 216 7 9]\n"
time="2022-09-15T10:29:11-04:00" level=debug msg="found in cache: mqtt-0517"
2022-09-15 10:29:11: Sending PUBLISH to 2PysYqYWgJSOQHPfVgfgbr (d0, q0, r0, m0, 'ring/89b81f0f-89e0-4256-be09-1dc90f5177fa/lighting/d1895758-de1e-4987-8e45-942a26bfefa4/beam_duration/state', ... (2 bytes))
2022-09-15 10:29:11: Sending PUBACK to mqttjs_00cfbae6 (m8171, rc0)
2022-09-15 10:29:11: Received PUBLISH from mqttjs_00cfbae6 (d0, q1, r0, m8172, 'ring/89b81f0f-89e0-4256-be09-1dc90f5177fa/lighting/d1895758-de1e-4987-8e45-942a26bfefa4/info/state', ... (223 bytes))
2022-09-15 10:29:11: Sending PUBLISH to 2PysYqYWgJSOQHPfVgfgbr (d0, q0, r0, m0, 'ring/89b81f0f-89e0-4256-be09-1dc90f5177fa/lighting/d1895758-de1e-4987-8e45-942a26bfefa4/info/state', ... (223 bytes))
2022-09-15 10:29:11: Sending PUBACK to mqttjs_00cfbae6 (m8172, rc0)
2022-09-15 10:29:11: Received PUBLISH from mqttjs_00cfbae6 (d0, q1, r0, m8173, 'ring/89b81f0f-89e0-4256-be09-1dc90f5177fa/lighting/d1895758-de1e-4987-8e45-942a26bfefa4/battery/attributes', ... (46 bytes))
2022-09-15 10:29:11: Sending PUBLISH to 2PysYqYWgJSOQHPfVgfgbr (d0, q0, r0, m0, 'ring/89b81f0f-89e0-4256-be09-1dc90f5177fa/lighting/d1895758-de1e-4987-8e45-942a26bfefa4/battery/attributes', ... (46 bytes))
2022-09-15 10:29:11: Sending PUBACK to mqttjs_00cfbae6 (m8173, rc0)
2022-09-15 10:29:11: Received PUBLISH from mqttjs_00cfbae6 (d0, q1, r0, m8174, 'ring/89b81f0f-89e0-4256-be09-1dc90f5177fa/lighting/876b4632-1846-42b3-add9-933ba676b4dc/motion/state', ... (3 bytes))
2022-09-15 10:29:11: Sending PUBLISH to 2PysYqYWgJSOQHPfVgfgbr (d0, q0, r0, m0, 'ring/89b81f0f-89e0-4256-be09-1dc90f5177fa/lighting/876b4632-1846-42b3-add9-933ba676b4dc/motion/state', ... (3 bytes))
2022-09-15 10:29:11: Sending PUBACK to mqttjs_00cfbae6 (m8174, rc0)
2022-09-15 10:29:11: Received PUBLISH from mqttjs_00cfbae6 (d0, q1, r0, m8175, 'ring/89b81f0f-89e0-4256-be09-1dc90f5177fa/lighting/876b4632-1846-42b3-add9-933ba676b4dc/light/state', ... (3 bytes))
2022-09-15 10:29:11: Sending PUBLISH to 2PysYqYWgJSOQHPfVgfgbr (d0, q0, r0, m0, 'ring/89b81f0f-89e0-4256-be09-1dc90f5177fa/lighting/876b4632-1846-42b3-add9-933ba676b4dc/light/state', ... (3 bytes))
2022-09-15 10:29:11: Sending PUBACK to mqttjs_00cfbae6 (m8175, rc0)
2022-09-15 10:29:11: Received PUBLISH from mqttjs_00cfbae6 (d0, q1, r0, m8176, 'ring/89b81f0f-89e0-4256-be09-1dc90f5177fa/lighting/876b4632-1846-42b3-add9-933ba676b4dc/light/brightness_state', ... (3 bytes))
2022-09-15 10:29:11: Sending PUBLISH to 2PysYqYWgJSOQHPfVgfgbr (d0, q0, r0, m0, 'ring/89b81f0f-89e0-4256-be09-1dc90f5177fa/lighting/876b4632-1846-42b3-add9-933ba676b4dc/light/brightness_state', ... (3 bytes))
2022-09-15 10:29:11: Sending PUBACK to mqttjs_00cfbae6 (m8176, rc0)
2022-09-15 10:29:11: Received PUBLISH from mqttjs_00cfbae6 (d0, q1, r0, m8177, 'ring/89b81f0f-89e0-4256-be09-1dc90f5177fa/lighting/876b4632-1846-42b3-add9-933ba676b4dc/beam_duration/state', ... (2 bytes))
2022-09-15 10:29:11: Sending PUBLISH to 2PysYqYWgJSOQHPfVgfgbr (d0, q0, r0, m0, 'ring/89b81f0f-89e0-4256-be09-1dc90f5177fa/lighting/876b4632-1846-42b3-add9-933ba676b4dc/beam_duration/state', ... (2 bytes))
2022-09-15 10:29:11: Sending PUBACK to mqttjs_00cfbae6 (m8177, rc0)
2022-09-15 10:29:11: Received PUBLISH from mqttjs_00cfbae6 (d0, q1, r0, m8178, 'ring/89b81f0f-89e0-4256-be09-1dc90f5177fa/lighting/876b4632-1846-42b3-add9-933ba676b4dc/info/state', ... (223 bytes))
2022-09-15 10:29:11: Sending PUBLISH to 2PysYqYWgJSOQHPfVgfgbr (d0, q0, r0, m0, 'ring/89b81f0f-89e0-4256-be09-1dc90f5177fa/lighting/876b4632-1846-42b3-add9-933ba676b4dc/info/state', ... (223 bytes))
2022-09-15 10:29:11: Sending PUBACK to mqttjs_00cfbae6 (m8178, rc0)
2022-09-15 10:29:11: Received PUBLISH from mqttjs_00cfbae6 (d0, q1, r0, m8179, 'ring/89b81f0f-89e0-4256-be09-1dc90f5177fa/lighting/876b4632-1846-42b3-add9-933ba676b4dc/battery/attributes', ... (46 bytes))
2022-09-15 10:29:11: Sending PUBLISH to 2PysYqYWgJSOQHPfVgfgbr (d0, q0, r0, m0, 'ring/89b81f0f-89e0-4256-be09-1dc90f5177fa/lighting/876b4632-1846-42b3-add9-933ba676b4dc/battery/attributes', ... (46 bytes))
2022-09-15 10:29:11: Sending PUBACK to mqttjs_00cfbae6 (m8179, rc0)
2022-09-15 10:30:06: Received PINGREQ from 2PysYqYWgJSOQHPfVgfgbr

Additional information

No response

@gdg316
Copy link
Author

gdg316 commented Sep 15, 2022

Logs with debugging disabled

s6-rc: info: service s6rc-oneshot-runner: starting
s6-rc: info: service s6rc-oneshot-runner successfully started
s6-rc: info: service fix-attrs: starting
s6-rc: info: service fix-attrs successfully started
s6-rc: info: service legacy-cont-init: starting
cont-init: info: running /etc/cont-init.d/mosquitto.sh
[10:58:15] INFO: Setting up user mqtt-0517
[10:58:15] INFO: SSL is not enabled
cont-init: info: /etc/cont-init.d/mosquitto.sh exited 0
cont-init: info: running /etc/cont-init.d/nginx.sh
cont-init: info: /etc/cont-init.d/nginx.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 mosquitto (no readiness notification)
services-up: info: copying legacy longrun nginx (no readiness notification)
s6-rc: info: service legacy-services successfully started
[10:58:16] INFO: Starting NGINX for authentication handling...
[10:58:17] INFO: Starting mosquitto MQTT broker...
2022-09-15 10:58:17: Warning: Mosquitto should not be run as root/administrator.
[10:58:18] INFO: Successfully send discovery information to Home Assistant.
[10:58:18] INFO: Successfully send service information to the Supervisor.

@mdegat01
Copy link
Contributor

I'm confused, what's the issue? Your logs with debugging disabled don't show any errors or anything wrong. Your logs with debugging enabled look fine too. What am I missing?

@gdg316
Copy link
Author

gdg316 commented Sep 17, 2022

It was Cleared up with me what I was seeing was home assistant Supervisor sending and closing connection , The Problem I originally had was Unauthorized user - disconnecting. My Next step is SSL/TLS which I need for info on installing

@gdg316
Copy link
Author

gdg316 commented Sep 17, 2022

But I am Trying to Configure the SSL/TLS for the Mosquitto Broker - Have not come across any walk through or files that I could edit

@gdg316 gdg316 closed this as completed Sep 21, 2022
@gdg316
Copy link
Author

gdg316 commented Sep 23, 2022

2022-09-22 20:57:57: New connection from 172.30.32.1:57280 on port 1883.
error: received null username or password for unpwd check
2022-09-22 20:57:57: Client disconnected, not authorised.
2022-09-22 20:57:58: New connection from 172.30.32.1:57288 on port 1883.
error: received null username or password for unpwd check
2022-09-22 20:57:58: Client disconnected, not authorised.
2022-09-22 20:57:59: New connection from 172.30.32.1:57302 on port 1883.
error: received null username or password for unpwd check
2022-09-22 20:57:59: Client disconnected, not authorised.
2022-09-22 20:58:00: New connection from 172.30.32.1:57316 on port 1883.
error: received null username or password for unpwd check
2022-09-22 20:58:00: Client disconnected, not authorised.
2022-09-22 20:58:01: New connection from 172.30.32.1:57322 on port 1883.
error: received null username or password for unpwd check
2022-09-22 20:58:01: Client disconnected, not authorised.
2022-09-22 20:58:02: New connection from 172.30.32.1:57324 on port 1883.
error: received null username or password for unpwd check
2022-09-22 20:58:02: Client disconnected, not authorised.
2022-09-22 20:58:03: New connection from 172.30.32.1:57336 on port 1883.
error: received null username or password for unpwd check
2022-09-22 20:58:03: Client disconnected, not authorised.
2022-09-22 20:58:04: New connection from 172.30.32.1:58072 on port 1883.
error: received null username or password for unpwd check
2022-09-22 20:58:04: Client disconnected, not authorised.
2022-09-22 20:58:05: New connection from 172.30.32.1:58078 on port 1883.
error: received null username or password for unpwd check
2022-09-22 20:58:05: Client disconnected, not authorised.
2022-09-22 20:58:06: New connection from 172.30.32.1:58084 on port 1883.
error: received null username or password for unpwd check
2022-09-22 20:58:06: Client disconnected, not authorised.
2022-09-22 20:58:08: New connection from 172.30.32.1:58094 on port 1883.
error: received null username or password for unpwd check
2022-09-22 20:58:08: Client disconnected, not authorised.
2022-09-22 20:58:09: New connection from 172.30.32.1:58108 on port 1883.
error: received null username or password for unpwd check
2022-09-22 20:58:09: Client disconnected, not authorised.
2022-09-22 20:58:10: New connection from 172.30.32.1:58112 on port 1883.
error: received null username or password for unpwd check
2022-09-22 20:58:10: Client disconnected, not authorised.
2022-09-22 20:58:11: New connection from 172.30.32.1:58114 on port 1883.
error: received null username or password for unpwd check
2022-09-22 20:58:11: Client disconnected, not authorised.
2022-09-22 20:58:12: New connection from 172.30.32.1:58122 on port 1883.
error: received null username or password for unpwd check
2022-09-22 20:58:12: Client disconnected, not authorised.
2022-09-22 20:58:13: New connection from 172.30.32.1:58124 on port 1883.
error: received null username or password for unpwd check
2022-09-22 20:58:13: Client disconnected, not authorised.
2022-09-22 20:58:14: New connection from 172.30.32.1:58136 on port 1883.
error: received null username or password for unpwd check
2022-09-22 20:58:14: Client disconnected, not authorised.
2022-09-22 20:58:15: New connection from 172.30.32.1:51460 on port 1883.
error: received null username or password for unpwd check
2022-09-22 20:58:15: Client disconnected, not authorised.
2022-09-22 20:58:16: New connection from 172.30.32.1:51474 on port 1883.
error: received null username or password for unpwd check
2022-09-22 20:58:16: Client disconnected, not authorised.
2022-09-22 20:58:17: New connection from 172.30.32.1:51488 on port 1883.
error: received null username or password for unpwd check
2022-09-22 20:58:17: Client disconnected, not authorised.
2022-09-22 20:58:18: New connection from 172.30.32.1:51504 on port 1883.
error: received null username or password for unpwd check
2022-09-22 20:58:18: Client disconnected, not authorised.
2022-09-22 20:58:19: New connection from 172.30.32.1:51518 on port 1883.
error: received null username or password for unpwd check
2022-09-22 20:58:19: Client disconnected, not authorised.
2022-09-22 20:58:20: New connection from 172.30.32.1:51528 on port 1883.
error: received null username or password for unpwd check
2022-09-22 20:58:20: Client disconnected, not authorised.
2022-09-22 20:58:21: New connection from 172.30.32.1:51530 on port 1883.
error: received null username or password for unpwd check
2022-09-22 20:58:21: Client disconnected, not authorised.
2022-09-22 20:58:21: New connection from 172.30.32.2:58908 on port 1883.
2022-09-22 20:58:21: Client closed its connection.
2022-09-22 20:58:22: New connection from 172.30.32.1:51536 on port 1883.
error: received null username or password for unpwd check
2022-09-22 20:58:22: Client disconnected, not authorised.
2022-09-22 20:58:23: New connection from 172.30.32.1:51544 on port 1883.
error: received null username or password for unpwd check
2022-09-22 20:58:23: Client disconnected, not authorised.
2022-09-22 20:58:24: New connection from 172.30.32.1:51554 on port 1883.
error: received null username or password for unpwd check
2022-09-22 20:58:24: Client disconnected, not authorised.
2022-09-22 20:58:25: New connection from 172.30.32.1:33092 on port 1883.
error: received null username or password for unpwd check
2022-09-22 20:58:25: Client disconnected, not authorised.
2022-09-22 20:58:26: New connection from 172.30.32.1:33108 on port 1883.
error: received null username or password for unpwd check
2022-09-22 20:58:26: Client disconnected, not authorised.
2022-09-22 20:58:27: New connection from 172.30.32.1:33122 on port 1883.
error: received null username or password for unpwd check
2022-09-22 20:58:27: Client disconnected, not authorised.
2022-09-22 20:58:28: New connection from 172.30.32.1:33132 on port 1883.
error: received null username or password for unpwd check
2022-09-22 20:58:28: Client disconnected, not authorised.
2022-09-22 20:58:29: New connection from 172.30.32.1:33136 on port 1883.
error: received null username or password for unpwd check
2022-09-22 20:58:29: Client disconnected, not authorised.
2022-09-22 20:58:30: New connection from 172.30.32.1:33140 on port 1883.
error: received null username or password for unpwd check
2022-09-22 20:58:30: Client disconnected, not authorised.
2022-09-22 20:58:31: New connection from 172.30.32.1:33154 on port 1883.
error: received null username or password for unpwd chec

@gdg316 gdg316 reopened this Sep 23, 2022
@gdg316
Copy link
Author

gdg316 commented Sep 25, 2022

Anyone have any answers why this occurred ??

@4noxx
Copy link

4noxx commented Oct 5, 2022

same problem. MQTT Broker will not start---- where can i find a older version?

@gdg316
Copy link
Author

gdg316 commented Oct 6, 2022

same problem. MQTT Broker will not start---- where can i find a older version?

Try rebooting host ??

@gdg316
Copy link
Author

gdg316 commented Oct 6, 2022

@4noxx try rebooting host ??

@ChristophCaina
Copy link

probably the same as
#2634

@SCratORS
Copy link

'error: received null username or password for unpwd chec'
Reinstall your MQTT Broker and MQTT Integration. And wellcome to #2634

@github-actions
Copy link

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.

@github-actions github-actions bot added the stale label Nov 13, 2022
@github-actions github-actions bot closed this as not planned Won't fix, can't repro, duplicate, stale Nov 20, 2022
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Projects
None yet
Development

No branches or pull requests

6 participants