What steps will reproduce the problem? 1. Connecting with my Telepathy client to Prosody What is the expected output? What do you see instead? I expect no "unhandled local stanza" / "unhandled response" messages in the logs, but I get: ``` stanzarouter: Unhandled local stanza: iq; xmlns=jabber:iq:version hostmanager: Unhandled response sent to local host ${DOMAIN}: <iq type='error' from='${USER}@${DOMAIN}' to='${DOMAIN}' id='25f43eb5-b316-4dcd-89c5-08c65ddbe74e'><error type='cancel'><service-unavailable xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'/></error></iq> stanzarouter: Unhandled local stanza: iq; xmlns=http://jabber.org/protocol/disco#info hostmanager: Unhandled response sent to local host ${DOMAIN}: <iq type='error' from='${USER}@${DOMAIN}' to='${DOMAIN}' id='b744b1c5-dd1f-4d2f-a762-26cbf17fecb7'><error type='cancel'><service-unavailable xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'/></error></iq> ``` What version of the product are you using? On what operating system? Prosody 0.10 hg:9546c629289b, Prosody Modules 2b741e68433b Please provide any additional information below. Debug log excerpt: c2s4046eb38: Client sent opening <stream:stream> to ${DOMAIN} c2s4046eb38: Sent reply <stream:stream> to client c2s4046eb38: Stream encrypted (TLSv1 with DHE-RSA-AES256-SHA) [179B blob data] ${DOMAIN}:auth_ldap2: _M.bind - who: ${LDAP_DN} c2s4046eb38: Authenticated as ${USER}@${DOMAIN} sql: SQL transaction begin [function(mod_storage_sql.lua:112)] sql: SQL transaction success [function(mod_storage_sql.lua:112)] ${DOMAIN}:saslauth: sasl reply: <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/> c2s4046eb38: Client sent opening <stream:stream> to ${DOMAIN} c2s4046eb38: Sent reply <stream:stream> to client c2s4046eb38: Received[c2s_unbound]: <iq type='set' id='19218648'> rostermanager: load_roster: asked for: ${USER}@${DOMAIN} rostermanager: load_roster: loading for new user: ${USER}@${DOMAIN} sql: SQL transaction begin [function(mod_storage_sql.lua:57)] sql: SQL transaction success [function(mod_storage_sql.lua:57)] mod_admin_web: Added client ${USER}@${DOMAIN}/${RESOURCE} c2s4046eb38: Resource bound: ${USER}@${DOMAIN}/${RESOURCE} ${DOMAIN}:log_slow_events: Slow event 'stanza/iq/urn:ietf:params:xml:ns:xmpp-bind:bind' took 2.80s: ip="${REMOTE_IP}", full_jid="${USER}@${DOMAIN}/${RESOURCE}", type="c2s", host="${DOMAIN}", stanza="<iq type='set' id='19218648'><bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'><resource>${RESOURCE}</resource></bind></iq>" socket: ssl handshake of client with id:table: 0x40612858, attempt:3 socket: ssl handshake done c2s4046eb38: Received[c2s]: <iq type='set' id='819658839165'> c2s4046eb38: Received[c2s]: <iq type='get' to='${DOMAIN}' id='832395897963'> sql: SQL transaction begin [function(mod_storage_sql.lua:57)] sql: SQL transaction success [function(mod_storage_sql.lua:57)] c2s4046eb38: Received[c2s]: <iq type='get' to='${USER}@${DOMAIN}' id='831564898169'> c2s4046eb38: Received[c2s]: <iq type='get' id='45956177076'> stanzarouter: Unhandled c2s stanza: iq; xmlns=jabber:iq:privacy c2s4046eb38: Received[c2s]: <presence> ${DOMAIN}:presence_cache: Cache hook, got <presence from='${USER}@${DOMAIN}/${RESOURCE}'> from a c2s c2s4046eb38: Received[c2s]: <iq type='get' id='33093249204'> c2s4046eb38: Received[c2s]: <iq type='get' to='${DOMAIN}' id='33422249480'> c2s4046eb38: Received[c2s]: <iq type='set' id='33673249779'> c2s4046eb38: Received[c2s]: <iq type='set' id='33736249824'> c2s4046eb38: Received[c2s]: <iq type='get' id='37705250724'> c2s4046eb38: Received[c2s]: <iq type='set' id='41354256437'> c2s4046eb38: Received[c2s]: <iq type='get' to='${USER}@${DOMAIN}' id='40971257028'> c2s4046eb38: Received[c2s]: <iq type='get' to='${USER}@${DOMAIN}' id='45780261836'> c2s4046eb38: Received[c2s]: <iq type='result' from='${USER}@${DOMAIN}/${RESOURCE}' to='${USER}@${DOMAIN}' id='disco'> stanzarouter: Discarding iq from c2s of type: result c2s4046eb38: Received[c2s]: <iq type='get' to='${USER}@${DOMAIN}' id='266639268674'> c2s4046eb38: Received[c2s]: <iq type='get' to='${USER}@${DOMAIN}' id='270606270645'> mod_s2s: Attempt to send stanza from %s - a host we don't serve mod_s2s: Attempt to send stanza from %s - a host we don't serve mod_s2s: Attempt to send stanza from %s - a host we don't serve mod_s2s: Attempt to send stanza from %s - a host we don't serve c2s4046eb38: Received[c2s]: <iq type='get' to='proxy.${DOMAIN}' id='303959321373'> c2s4046eb38: Received[c2s]: <iq type='get' to='search.${DOMAIN}' id='303192321608'> c2s4046eb38: Received[c2s]: <iq type='get' to='pubsub.${DOMAIN}' id='303193321656'> c2s4046eb38: Received[c2s]: <iq type='get' to='group.${DOMAIN}' id='303260321711'> c2s4046eb38: Received[c2s]: <presence> ${DOMAIN}:presence_cache: Cache hook, got <presence from='${USER}@${DOMAIN}/${RESOURCE}'> from a c2s c2s4046eb38: Received[c2s]: <iq type='set' id='307221324611'> stanzarouter: Unhandled local stanza: iq; xmlns=jabber:iq:version hostmanager: Unhandled response sent to local host ${DOMAIN}: <iq type='error' from='${USER}@${DOMAIN}' to='${DOMAIN}' id='25f43eb5-b316-4dcd-89c5-08c65ddbe74e'><error type='cancel'><service-unavailable xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'/></error></iq> stanzarouter: Unhandled local stanza: iq; xmlns=http://jabber.org/protocol/disco#info hostmanager: Unhandled response sent to local host ${DOMAIN}: <iq type='error' from='${USER}@${DOMAIN}' to='${DOMAIN}' id='b744b1c5-dd1f-4d2f-a762-26cbf17fecb7'><error type='cancel'><service-unavailable xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'/></error></iq> ${DOMAIN}:mam: Not archiving stanza: <message type='headline' from='${USER}@${DOMAIN}' to='${USER}@${DOMAIN}/${RESOURCE}'> (type) c2s4046eb38: Received[c2s]: <iq type='get' to='proxy.${DOMAIN}' id='274516340032'>
Do you have mod_query_client_ver enabled?
I do.
Pushed some changes to mod_query_client_ver so it handles errors better. https://hg.prosody.im/prosody-modules/rev/20ebfa4ad7f4 & 96eabf8591a6 Please say if this fixes it.
Quiet for a long time, assuming it's fixed.
What steps will reproduce the problem? 1. Connecting with my Telepathy client to Prosody What is the expected output? What do you see instead? I expect no "unhandled local stanza" / "unhandled response" messages in the logs, but I get: ``` stanzarouter: Unhandled local stanza: iq; xmlns=jabber:iq:version hostmanager: Unhandled response sent to local host ${DOMAIN}: <iq type='error' from='${USER}@${DOMAIN}' to='${DOMAIN}' id='25f43eb5-b316-4dcd-89c5-08c65ddbe74e'><error type='cancel'><service-unavailable xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'/></error></iq> stanzarouter: Unhandled local stanza: iq; xmlns=http://jabber.org/protocol/disco#info hostmanager: Unhandled response sent to local host ${DOMAIN}: <iq type='error' from='${USER}@${DOMAIN}' to='${DOMAIN}' id='b744b1c5-dd1f-4d2f-a762-26cbf17fecb7'><error type='cancel'><service-unavailable xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'/></error></iq> ``` What version of the product are you using? On what operating system? Prosody 0.10 hg:9546c629289b, Prosody Modules 2b741e68433b Please provide any additional information below. Debug log excerpt: c2s4046eb38: Client sent opening <stream:stream> to ${DOMAIN} c2s4046eb38: Sent reply <stream:stream> to client c2s4046eb38: Stream encrypted (TLSv1 with DHE-RSA-AES256-SHA) [179B blob data] ${DOMAIN}:auth_ldap2: _M.bind - who: ${LDAP_DN} c2s4046eb38: Authenticated as ${USER}@${DOMAIN} sql: SQL transaction begin [function(mod_storage_sql.lua:112)] sql: SQL transaction success [function(mod_storage_sql.lua:112)] ${DOMAIN}:saslauth: sasl reply: <success xmlns='urn:ietf:params:xml:ns:xmpp-sasl'/> c2s4046eb38: Client sent opening <stream:stream> to ${DOMAIN} c2s4046eb38: Sent reply <stream:stream> to client c2s4046eb38: Received[c2s_unbound]: <iq type='set' id='19218648'> rostermanager: load_roster: asked for: ${USER}@${DOMAIN} rostermanager: load_roster: loading for new user: ${USER}@${DOMAIN} sql: SQL transaction begin [function(mod_storage_sql.lua:57)] sql: SQL transaction success [function(mod_storage_sql.lua:57)] mod_admin_web: Added client ${USER}@${DOMAIN}/${RESOURCE} c2s4046eb38: Resource bound: ${USER}@${DOMAIN}/${RESOURCE} ${DOMAIN}:log_slow_events: Slow event 'stanza/iq/urn:ietf:params:xml:ns:xmpp-bind:bind' took 2.80s: ip="${REMOTE_IP}", full_jid="${USER}@${DOMAIN}/${RESOURCE}", type="c2s", host="${DOMAIN}", stanza="<iq type='set' id='19218648'><bind xmlns='urn:ietf:params:xml:ns:xmpp-bind'><resource>${RESOURCE}</resource></bind></iq>" socket: ssl handshake of client with id:table: 0x40612858, attempt:3 socket: ssl handshake done c2s4046eb38: Received[c2s]: <iq type='set' id='819658839165'> c2s4046eb38: Received[c2s]: <iq type='get' to='${DOMAIN}' id='832395897963'> sql: SQL transaction begin [function(mod_storage_sql.lua:57)] sql: SQL transaction success [function(mod_storage_sql.lua:57)] c2s4046eb38: Received[c2s]: <iq type='get' to='${USER}@${DOMAIN}' id='831564898169'> c2s4046eb38: Received[c2s]: <iq type='get' id='45956177076'> stanzarouter: Unhandled c2s stanza: iq; xmlns=jabber:iq:privacy c2s4046eb38: Received[c2s]: <presence> ${DOMAIN}:presence_cache: Cache hook, got <presence from='${USER}@${DOMAIN}/${RESOURCE}'> from a c2s c2s4046eb38: Received[c2s]: <iq type='get' id='33093249204'> c2s4046eb38: Received[c2s]: <iq type='get' to='${DOMAIN}' id='33422249480'> c2s4046eb38: Received[c2s]: <iq type='set' id='33673249779'> c2s4046eb38: Received[c2s]: <iq type='set' id='33736249824'> c2s4046eb38: Received[c2s]: <iq type='get' id='37705250724'> c2s4046eb38: Received[c2s]: <iq type='set' id='41354256437'> c2s4046eb38: Received[c2s]: <iq type='get' to='${USER}@${DOMAIN}' id='40971257028'> c2s4046eb38: Received[c2s]: <iq type='get' to='${USER}@${DOMAIN}' id='45780261836'> c2s4046eb38: Received[c2s]: <iq type='result' from='${USER}@${DOMAIN}/${RESOURCE}' to='${USER}@${DOMAIN}' id='disco'> stanzarouter: Discarding iq from c2s of type: result c2s4046eb38: Received[c2s]: <iq type='get' to='${USER}@${DOMAIN}' id='266639268674'> c2s4046eb38: Received[c2s]: <iq type='get' to='${USER}@${DOMAIN}' id='270606270645'> mod_s2s: Attempt to send stanza from %s - a host we don't serve mod_s2s: Attempt to send stanza from %s - a host we don't serve mod_s2s: Attempt to send stanza from %s - a host we don't serve mod_s2s: Attempt to send stanza from %s - a host we don't serve c2s4046eb38: Received[c2s]: <iq type='get' to='proxy.${DOMAIN}' id='303959321373'> c2s4046eb38: Received[c2s]: <iq type='get' to='search.${DOMAIN}' id='303192321608'> c2s4046eb38: Received[c2s]: <iq type='get' to='pubsub.${DOMAIN}' id='303193321656'> c2s4046eb38: Received[c2s]: <iq type='get' to='group.${DOMAIN}' id='303260321711'> c2s4046eb38: Received[c2s]: <presence> ${DOMAIN}:presence_cache: Cache hook, got <presence from='${USER}@${DOMAIN}/${RESOURCE}'> from a c2s c2s4046eb38: Received[c2s]: <iq type='set' id='307221324611'> stanzarouter: Unhandled local stanza: iq; xmlns=jabber:iq:version hostmanager: Unhandled response sent to local host ${DOMAIN}: <iq type='error' from='${USER}@${DOMAIN}' to='${DOMAIN}' id='25f43eb5-b316-4dcd-89c5-08c65ddbe74e'><error type='cancel'><service-unavailable xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'/></error></iq> stanzarouter: Unhandled local stanza: iq; xmlns=http://jabber.org/protocol/disco#info hostmanager: Unhandled response sent to local host ${DOMAIN}: <iq type='error' from='${USER}@${DOMAIN}' to='${DOMAIN}' id='b744b1c5-dd1f-4d2f-a762-26cbf17fecb7'><error type='cancel'><service-unavailable xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'/></error></iq> ${DOMAIN}:mam: Not archiving stanza: <message type='headline' from='${USER}@${DOMAIN}' to='${USER}@${DOMAIN}/${RESOURCE}'> (type) c2s4046eb38: Received[c2s]: <iq type='get' to='proxy.${DOMAIN}' id='274516340032'>
Do you have mod_query_client_ver enabled?
ChangesI do.
Pushed some changes to mod_query_client_ver so it handles errors better. https://hg.prosody.im/prosody-modules/rev/20ebfa4ad7f4 & 96eabf8591a6 Please say if this fixes it.
Quiet for a long time, assuming it's fixed.
Changes