Hi Mike, Appreciate the

petter — Fri, 22 Mar 2013 09:37:37 +0000

Hi Mike,

Appreciate the feedback. I tried playing around with the query you had but no luck, The Debug log shows every single user found so I am not sure what the problem is. I see an error early in the log but not sure that it is relevant. My Query looks like this atm:

{mod_shared_roster_ldap,[
{ldap_base, "dc=bgc-jena,dc=mpg,dc=de"},
{ldap_rfilter, "(objectClass=inetOrgPerson)"},
{ldap_groupattr, "ou"},
{ldap_gfilter, "(&(objectClass=inetOrgPerson)(ou=%g))"},
{ldap_memberattr, "cn"},
{ldap_ufilter, "(&(objectClass=inetOrgPerson)(cn=%u))"},
{ldap_filter, ""}
]}

Here is the debug log. I have removed almost all users and such as it is the same thing that repetes itself.

--- DEBUG LOG ---

=INFO REPORT==== 2013-03-22 09:38:27 ===
D(<0.260.0>:ejabberd_captcha:432) : The option captcha_cmd is not configured, but some module wants to use the CAPTCHA feature.

=INFO REPORT==== 2013-03-22 09:38:27 ===
I(<0.276.0>:eldap:983) : LDAP connection on ldapmaster.company.domain.tld:636

=INFO REPORT==== 2013-03-22 09:38:27 ===
I(<0.286.0>:eldap:983) : LDAP connection on ldapmaster.company.domain.tld:636

=INFO REPORT==== 2013-03-22 09:38:27 ===
I(<0.40.0>:cyrsasl_digest:44) : FQDN used to check DIGEST-MD5 SASL authentication: "rb"

=INFO REPORT==== 2013-03-22 09:38:27 ===
D(<0.333.0>:mod_pubsub:175) : pubsub init "company.domain.tld" [{access_createnode,
pubsub_createnode},
{pep_sendlast_offline,
false},
{last_item_cache,
false},
{plugins,
["flat",
"hometree",
"pep"]}]

=INFO REPORT==== 2013-03-22 09:38:27 ===
D(<0.333.0>:mod_pubsub:258) : ** tree plugin is nodetree_tree

=INFO REPORT==== 2013-03-22 09:38:27 ===
D(<0.333.0>:mod_pubsub:262) : ** PEP Mapping : []

=INFO REPORT==== 2013-03-22 09:38:27 ===
D(<0.333.0>:mod_pubsub:269) : ** init flat plugin

=INFO REPORT==== 2013-03-22 09:38:27 ===
D(<0.333.0>:mod_pubsub:269) : ** init hometree plugin

=INFO REPORT==== 2013-03-22 09:38:27 ===
D(<0.333.0>:mod_pubsub:269) : ** init pep plugin

=INFO REPORT==== 2013-03-22 09:38:27 ===
D(<0.333.0>:mod_pubsub:3777) : node_call "hometree" node_to_path [<<"/home">>]

=INFO REPORT==== 2013-03-22 09:38:27 ===
D(<0.333.0>:mod_pubsub:3777) : node_call "hometree" path_to_node [[]]

=INFO REPORT==== 2013-03-22 09:38:27 ===
D(<0.333.0>:mod_pubsub:3777) : node_call "hometree" create_node_permission ["pubsub.company.domain.tld",
"company.domain.tld",
<<"/home">>,
<<>>,
{jid,
[],
"pubsub.company.domain.tld",
[],
[],
"pubsub.company.domain.tld",
[]},
all]

=INFO REPORT==== 2013-03-22 09:38:27 ===
D(<0.333.0>:mod_pubsub:3764) : tree_call "pubsub.company.domain.tld" create_node ["pubsub.company.domain.tld",
<<"/home">>,
"hometree",
{jid,
[],
"pubsub.company.domain.tld",
[],
[],
"pubsub.company.domain.tld",
[]},
[{deliver_payloads,
true},
{notify_config,
false},
{notify_delete,
false},
{notify_retract,
true},
{purge_offline,
false},
{persist_items,
true},
{max_items,
10},
{subscribe,
true},
{access_model,
open},
{roster_groups_allowed,
[]},
{publish_model,
publishers},
{notification_type,
headline},
{max_payload_size,
60000},
{send_last_published_item,
on_sub_and_presence},
{deliver_notifications,
true},
{presence_based_delivery,
false}],
[]]

=INFO REPORT==== 2013-03-22 09:38:27 ===
D(<0.333.0>:mod_pubsub:3777) : node_call "hometree" node_to_path [<<"/home/company.domain.tld">>]

=INFO REPORT==== 2013-03-22 09:38:27 ===
D(<0.333.0>:mod_pubsub:3777) : node_call "hometree" path_to_node [["home"]]

=INFO REPORT==== 2013-03-22 09:38:27 ===
D(<0.333.0>:mod_pubsub:3777) : node_call "hometree" create_node_permission ["pubsub.company.domain.tld",
"company.domain.tld",
<<"/home/company.domain.tld">>,
<<"/home">>,
{jid,
[],
"pubsub.company.domain.tld",
[],
[],
"pubsub.company.domain.tld",
[]},
all]

=INFO REPORT==== 2013-03-22 09:38:27 ===
D(<0.333.0>:mod_pubsub:3764) : tree_call "pubsub.company.domain.tld" create_node ["pubsub.company.domain.tld",
<<"/home/company.domain.tld">>,
"hometree",
{jid,
[],
"pubsub.company.domain.tld",
[],
[],
"pubsub.company.domain.tld",
[]},
[{deliver_payloads,
true},
{notify_config,
false},
{notify_delete,
false},
{notify_retract,
true},
{purge_offline,
false},
{persist_items,
true},
{max_items,
10},
{subscribe,
true},
{access_model,
open},
{roster_groups_allowed,
[]},
{publish_model,
publishers},
{notification_type,
headline},
{max_payload_size,
60000},
{send_last_published_item,
on_sub_and_presence},
{deliver_notifications,
true},
{presence_based_delivery,
false}],
[<<"/home">>]]

=INFO REPORT==== 2013-03-22 09:38:27 ===
D(<0.286.0>:eldap:1032) : Bind Request Message:{'LDAPMessage',1,
{bindRequest,
{'BindRequest',3,
"uid=cyrus,dc=company,dc=domain,dc=tld",
{simple,"mypassword"}}},
asn1_NOVALUE}

=INFO REPORT==== 2013-03-22 09:38:27 ===
D(<0.276.0>:eldap:1032) : Bind Request Message:{'LDAPMessage',1,
{bindRequest,
{'BindRequest',3,
"uid=cyrus,dc=company,dc=domain,dc=tld",
{simple,"mypassword"}}},
asn1_NOVALUE}

=INFO REPORT==== 2013-03-22 09:38:27 ===
D(<0.286.0>:eldap:879) : {'LDAPMessage',1,
{bindResponse,
{'BindResponse',success,[],[],asn1_NOVALUE,
asn1_NOVALUE}},
asn1_NOVALUE}

=INFO REPORT==== 2013-03-22 09:38:27 ===
D(<0.276.0>:eldap:879) : {'LDAPMessage',1,
{bindResponse,
{'BindResponse',success,[],[],asn1_NOVALUE,
asn1_NOVALUE}},
asn1_NOVALUE}

=ERROR REPORT==== 2013-03-22 09:38:27 ===
E(<0.379.0>:eldap_utils:166) : failed to parse LDAP filter:
** Filter: []
** Reason: {error,["syntax error before: ",[]]}

=INFO REPORT==== 2013-03-22 09:38:27 ===
I(<0.384.0>:eldap:983) : LDAP connection on ldapmaster.company.domain.tld:636

=INFO REPORT==== 2013-03-22 09:38:27 ===
I(<0.385.0>:ejabberd_listener:166) : Reusing listening port for 5222

=INFO REPORT==== 2013-03-22 09:38:27 ===
I(<0.386.0>:ejabberd_listener:166) : Reusing listening port for 5269

=INFO REPORT==== 2013-03-22 09:38:27 ===
I(<0.387.0>:ejabberd_listener:166) : Reusing listening port for 5280

=INFO REPORT==== 2013-03-22 09:38:27 ===
I(<0.40.0>:ejabberd_app:72) : ejabberd 2.1.10 is started in the node ejabberd@rb

=INFO REPORT==== 2013-03-22 09:38:27 ===
D(<0.384.0>:eldap:1032) : Bind Request Message:{'LDAPMessage',1,
{bindRequest,
{'BindRequest',3,
"uid=cyrus,dc=company,dc=domain,dc=tld",
{simple,"mypassword"}}},
asn1_NOVALUE}

=INFO REPORT==== 2013-03-22 09:38:27 ===
D(<0.384.0>:eldap:879) : {'LDAPMessage',1,
{bindResponse,
{'BindResponse',success,[],[],asn1_NOVALUE,
asn1_NOVALUE}},
asn1_NOVALUE}

=INFO REPORT==== 2013-03-22 09:38:33 ===
I(<0.385.0>:ejabberd_listener:281) : (#Port<0.2146>) Accepted connection {{10,164,1,100},57097} -> {{141,5,16,185},5222}

=INFO REPORT==== 2013-03-22 09:38:33 ===
D(<0.389.0>:ejabberd_receiver:320) : Received XML on stream = "<?xml version='1.0' ?>"

=INFO REPORT==== 2013-03-22 09:38:33 ===
D(<0.389.0>:ejabberd_receiver:320) : Received XML on stream = ""

=INFO REPORT==== 2013-03-22 09:38:33 ===
D(<0.390.0>:ejabberd_c2s:1553) : Send XML on stream = [60,63,120,109,108,32,
118,101,114,115,105,
111,110,61,39,49,46,48,
39,63,62,60,115,116,
114,101,97,109,58,115,
116,114,101,97,109,32,
120,109,108,110,115,61,
39,106,97,98,98,101,
114,58,99,108,105,101,
110,116,39,32,120,109,
108,110,115,58,115,116,
114,101,97,109,61,39,
104,116,116,112,58,47,
47,101,116,104,101,114,
120,46,106,97,98,98,
101,114,46,111,114,103,
47,115,116,114,101,97,
109,115,39,32,105,100,
61,39,"712439649",39,
32,102,114,111,109,61,
39,"company.domain.tld",
39,
[" version='","1.0",
"'"],
[" xml:lang='","en",
"'"],
62]

=INFO REPORT==== 2013-03-22 09:38:33 ===
D(<0.390.0>:ejabberd_c2s:1553) : Send XML on stream = <<"PLAIN">>

=INFO REPORT==== 2013-03-22 09:38:33 ===
D(<0.389.0>:ejabberd_receiver:320) : Received XML on stream = ""

=INFO REPORT==== 2013-03-22 09:38:33 ===
D(<0.389.0>:shaper:61) : State: {maxrate,1000,0,1363941513414947}, Size=51
M=25.5, I=46.147

=INFO REPORT==== 2013-03-22 09:38:33 ===
D(<0.389.0>:ejabberd_receiver:320) : Received XML on stream = []

=INFO REPORT==== 2013-03-22 09:38:33 ===
D(<0.389.0>:shaper:61) : State: {maxrate,1000,552.5340729344977,
1363941513461098}, Size=0
M=0.0, I=1.898

=INFO REPORT==== 2013-03-22 09:38:33 ===
D(<0.389.0>:ejabberd_receiver:320) : Received XML on stream = []

=INFO REPORT==== 2013-03-22 09:38:33 ===
D(<0.389.0>:shaper:61) : State: {maxrate,1000,276.26703646724883,
1363941513462999}, Size=0
M=0.0, I=44.711

=INFO REPORT==== 2013-03-22 09:38:33 ===
D(<0.389.0>:ejabberd_receiver:320) : Received XML on stream = []

=INFO REPORT==== 2013-03-22 09:38:33 ===
D(<0.389.0>:shaper:61) : State: {maxrate,1000,138.13351823362441,
1363941513507714}, Size=0
M=0.0, I=45.924

=INFO REPORT==== 2013-03-22 09:38:33 ===
D(<0.389.0>:ejabberd_receiver:320) : Received XML on stream = ""

=INFO REPORT==== 2013-03-22 09:38:33 ===
D(<0.389.0>:shaper:61) : State: {maxrate,1000,69.06675911681221,
1363941513553641}, Size=120
M=62.14611539087354, I=76.365

=INFO REPORT==== 2013-03-22 09:38:33 ===
D(<0.390.0>:ejabberd_c2s:1553) : Send XML on stream = [60,63,120,109,108,32,
118,101,114,115,105,
111,110,61,39,49,46,48,
39,63,62,60,115,116,
114,101,97,109,58,115,
116,114,101,97,109,32,
120,109,108,110,115,61,
39,106,97,98,98,101,
114,58,99,108,105,101,
110,116,39,32,120,109,
108,110,115,58,115,116,
114,101,97,109,61,39,
104,116,116,112,58,47,
47,101,116,104,101,114,
120,46,106,97,98,98,
101,114,46,111,114,103,
47,115,116,114,101,97,
109,115,39,32,105,100,
61,39,"4166977752",39,
32,102,114,111,109,61,
39,"company.domain.tld",
39,
[" version='","1.0",
"'"],
[" xml:lang='","en",
"'"],
62]

=INFO REPORT==== 2013-03-22 09:38:33 ===
D(<0.390.0>:ejabberd_c2s:1553) : Send XML on stream = <<"PLAIN">>

=INFO REPORT==== 2013-03-22 09:38:33 ===
D(<0.389.0>:ejabberd_receiver:320) : Received XML on stream = "AGZsYW5pdHoAIVV0YTNXdWwyIS0y"

=INFO REPORT==== 2013-03-22 09:38:33 ===
D(<0.389.0>:shaper:61) : State: {maxrate,1000,0,1363941513630455}, Size=191
M=95.5, I=45.711

=INFO REPORT==== 2013-03-22 09:38:33 ===
D(<0.276.0>:eldap:696) : {searchRequest,
{'SearchRequest',"dc=company,dc=domain,dc=tld",
wholeSubtree,neverDerefAliases,0,0,false,
{'and',
[{equalityMatch,
{'AttributeValueAssertion',"uid","user1"}},
{equalityMatch,
{'AttributeValueAssertion',"objectClass",
"shadowAccount"}}]},
["uid"]}}

=INFO REPORT==== 2013-03-22 09:38:33 ===
D(<0.276.0>:eldap:767) : {searchResEntry,
{'SearchResultEntry',
"uid=user1,dc=company,dc=domain,dc=tld",
[{'PartialAttributeList_SEQOF',"uid",
["user1"]}]}}

=INFO REPORT==== 2013-03-22 09:38:33 ===
D(<0.276.0>:eldap:767) : {searchResDone,
{'LDAPResult',success,[],[],asn1_NOVALUE}}

=INFO REPORT==== 2013-03-22 09:38:33 ===
D(<0.286.0>:eldap:696) : {bindRequest,
{'BindRequest',3,
"uid=user1,dc=company,dc=domain,dc=tld",
{simple,"mypassword"}}}

=INFO REPORT==== 2013-03-22 09:38:33 ===
D(<0.286.0>:eldap:767) : {bindResponse,
{'BindResponse',success,[],[],asn1_NOVALUE,
asn1_NOVALUE}}

=INFO REPORT==== 2013-03-22 09:38:33 ===
D(<0.390.0>:ejabberd_c2s:1553) : Send XML on stream = <<"">>

=INFO REPORT==== 2013-03-22 09:38:33 ===
I(<0.390.0>:ejabberd_c2s:631) : ({socket_state,tls,{tlssock,#Port<0.2146>,#Port<0.2168>},<0.389.0>}) Accepted authentication for user1 by ejabberd_auth_ldap

=INFO REPORT==== 2013-03-22 09:38:33 ===
D(<0.389.0>:ejabberd_receiver:320) : Received XML on stream = ""

=INFO REPORT==== 2013-03-22 09:38:33 ===
D(<0.389.0>:shaper:61) : State: {maxrate,1000,997.7537481063574,
1363941513726170}, Size=120
M=119.73105389346398, I=0.941

=INFO REPORT==== 2013-03-22 09:38:33 ===
D(<0.390.0>:ejabberd_c2s:1553) : Send XML on stream = [60,63,120,109,108,32,
118,101,114,115,105,
111,110,61,39,49,46,48,
39,63,62,60,115,116,
114,101,97,109,58,115,
116,114,101,97,109,32,
120,109,108,110,115,61,
39,106,97,98,98,101,
114,58,99,108,105,101,
110,116,39,32,120,109,
108,110,115,58,115,116,
114,101,97,109,61,39,
104,116,116,112,58,47,
47,101,116,104,101,114,
120,46,106,97,98,98,
101,114,46,111,114,103,
47,115,116,114,101,97,
109,115,39,32,105,100,
61,39,"858277556",39,
32,102,114,111,109,61,
39,"company.domain.tld",
39,
[" version='","1.0",
"'"],
[" xml:lang='","en",
"'"],
62]

=INFO REPORT==== 2013-03-22 09:38:33 ===
D(<0.390.0>:ejabberd_c2s:1553) : Send XML on stream = <<"">>

=INFO REPORT==== 2013-03-22 09:38:33 ===
D(<0.389.0>:ejabberd_receiver:320) : Received XML on stream = "mmmm"

=INFO REPORT==== 2013-03-22 09:38:33 ===
D(<0.389.0>:shaper:61) : State: {maxrate,1000,0,1363941513727506}, Size=122
M=61.0, I=119.611

=INFO REPORT==== 2013-03-22 09:38:33 ===
D(<0.390.0>:ejabberd_c2s:1553) : Send XML on stream = <<"user1@company.domain.tld/mmmm">>

=INFO REPORT==== 2013-03-22 09:38:33 ===
D(<0.389.0>:ejabberd_receiver:320) : Received XML on stream = ""

=INFO REPORT==== 2013-03-22 09:38:33 ===
D(<0.389.0>:shaper:61) : State: {maxrate,1000,509.9737488922701,
1363941513847120}, Size=94
M=63.086136858406086, I=44.399

=INFO REPORT==== 2013-03-22 09:38:33 ===
I(<0.390.0>:ejabberd_c2s:938) : ({socket_state,tls,{tlssock,#Port<0.2146>,#Port<0.2168>},<0.389.0>}) Opened session for user1@company.domain.tld/mmmm

=INFO REPORT==== 2013-03-22 09:38:33 ===
D(<0.390.0>:ejabberd_c2s:1553) : Send XML on stream = <<"">>

=INFO REPORT==== 2013-03-22 09:38:33 ===
D(<0.384.0>:eldap:696) : {searchRequest,
{'SearchRequest',"dc=company,dc=domain,dc=tld",
wholeSubtree,neverDerefAliases,0,5,false,
{equalityMatch,
{'AttributeValueAssertion',"objectClass",
"inetOrgPerson"}},
["ou"]}}

=INFO REPORT==== 2013-03-22 09:38:33 ===
D(<0.384.0>:eldap:767) : {searchResEntry,
{'SearchResultEntry',
"uid=cyrus,dc=company,dc=domain,dc=tld",
[{'PartialAttributeList_SEQOF',"ou",
["DVA"]}]}}

=INFO REPORT==== 2013-03-22 09:38:33 ===
D(<0.384.0>:eldap:767) : {searchResEntry,
{'SearchResultEntry',
"uid=mailadmin,dc=company,dc=domain,dc=tld",[]}}

=INFO REPORT==== 2013-03-22 09:38:33 ===
D(<0.384.0>:eldap:767) : {searchResEntry,
{'SearchResultEntry',
"uid=user2,dc=company,dc=domain,dc=tld",
[{'PartialAttributeList_SEQOF',"ou",
["VER"]}]}}

---> SNIPP

=INFO REPORT==== 2013-03-22 09:38:33 ===
D(<0.384.0>:eldap:767) : {searchResEntry,
{'SearchResultEntry',
"uid=700,ou=addr,uid=user3,dc=company,dc=domain,dc=tld",
[]}}

=INFO REPORT==== 2013-03-22 09:38:33 ===
D(<0.384.0>:eldap:767) : {searchResEntry,
{'SearchResultEntry',
"uid=701,ou=addr,uid=user3,dc=company,dc=domain,dc=tld",
[]}}

---> SNIPP

=INFO REPORT==== 2013-03-22 09:38:33 ===
D(<0.384.0>:eldap:767) : {searchResEntry,
{'SearchResultEntry',
"cn=User Name,ou=addr,uid=user3,dc=company,dc=domain,dc=tld",
[]}}

---> SNIPP

=INFO REPORT==== 2013-03-22 09:38:34 ===
D(<0.389.0>:ejabberd_receiver:320) : Received XML on stream = ""

=INFO REPORT==== 2013-03-22 09:38:34 ===
D(<0.389.0>:shaper:61) : State: {maxrate,1000,0,1363941513891744}, Size=116
M=58.0, I=43.979

=INFO REPORT==== 2013-03-22 09:38:34 ===
D(<0.384.0>:eldap:767) : {searchResEntry,
{'SearchResultEntry',
"cn=New User,ou=addr,uid=uuuu,dc=company,dc=domain,dc=tld",
[]}}

---> SNIPP

=INFO REPORT==== 2013-03-22 09:38:34 ===
D(<0.384.0>:eldap:767) : {searchResEntry,
{'SearchResultEntry',
"uid=shege,dc=company,dc=domain,dc=tld",
[{'PartialAttributeList_SEQOF',"ou",
["VER"]}]}}

---> SNIPP

=INFO REPORT==== 2013-03-22 09:38:34 ===
D(<0.384.0>:eldap:767) : {searchResEntry,
{'SearchResultEntry',
"uid=530,ou=addr,uid=mailadmin,dc=company,dc=domain,dc=tld",
[{'PartialAttributeList_SEQOF',"ou",
["DVA"]}]}}

---> SNIPP

=INFO REPORT==== 2013-03-22 09:38:34 ===
D(<0.389.0>:ejabberd_receiver:320) : Received XML on stream = ""

---> SNIPP

=INFO REPORT==== 2013-03-22 09:38:34 ===
D(<0.384.0>:eldap:767) : {searchResDone,
{'LDAPResult',success,[],[],asn1_NOVALUE}}

=INFO REPORT==== 2013-03-22 09:38:34 ===
D(<0.384.0>:eldap:696) : {searchRequest,
{'SearchRequest',"dc=company,dc=domain,dc=tld",
wholeSubtree,neverDerefAliases,0,5,false,
{'and',
[{equalityMatch,
{'AttributeValueAssertion',"objectClass",
"inetOrgPerson"}},
{equalityMatch,
{'AttributeValueAssertion',"ou",
"org-team City2"}}]},
["ou","ou","cn"]}}

=INFO REPORT==== 2013-03-22 09:38:34 ===
D(<0.384.0>:eldap:767) : {searchResEntry,
{'SearchResultEntry',
"uid=6058,ou=addr,uid=uuuu,dc=company,dc=domain,dc=tld",
[{'PartialAttributeList_SEQOF',"ou",
["org-team City2"]},
{'PartialAttributeList_SEQOF',"cn",
["User Name"]}]}}

=INFO REPORT==== 2013-03-22 09:38:34 ===
D(<0.384.0>:eldap:767) : {searchResDone,
{'LDAPResult',success,[],[],asn1_NOVALUE}}

=INFO REPORT==== 2013-03-22 09:38:34 ===
D(<0.384.0>:eldap:767) : {searchResEntry,
{'SearchResultEntry',
"uid=11289,ou=addr,uid=user,dc=company,dc=domain,dc=tld",
[{'PartialAttributeList_SEQOF',"ou",
["tall tower"]},
{'PartialAttributeList_SEQOF',"cn",
["Fat Eddy"]}]}}

=INFO REPORT==== 2013-03-22 09:38:34 ===
D(<0.384.0>:eldap:767) : {searchResDone,
{'LDAPResult',success,[],[],asn1_NOVALUE}}

=INFO REPORT==== 2013-03-22 09:38:34 ===
D(<0.390.0>:ejabberd_router:313) : route
from {jid,"user1","company.domain.tld","mmmm","user1",
"company.domain.tld","mmmm"}
to {jid,[],"company.domain.tld",[],[],"company.domain.tld",[]}
packet {xmlelement,"iq",
[{"type","get"},
{"id","purple853088d6"},
{"to","company.domain.tld"}],
[{xmlelement,"query",
[{"xmlns","http://jabber.org/protocol/disco#items"}],
[]}]}

=INFO REPORT==== 2013-03-22 09:38:34 ===
D(<0.390.0>:ejabberd_local:300) : local route
from {jid,"user1","company.domain.tld","mmmm","user1",
"company.domain.tld","mmmm"}
to {jid,[],"company.domain.tld",[],[],"company.domain.tld",[]}
packet {xmlelement,"iq",
[{"type","get"},{"id",[...]},{[...],...}],
[{xmlelement,[...],...}]}

=INFO REPORT==== 2013-03-22 09:38:34 ===
D(<0.390.0>:ejabberd_router:313) : route
from {jid,"user1","company.domain.tld","mmmm","user1",
"company.domain.tld","mmmm"}
to {jid,[],"company.domain.tld",[],[],"company.domain.tld",[]}
packet {xmlelement,"iq",
[{"type","get"},
{"id","purple853088d7"},
{"to","company.domain.tld"}],
[{xmlelement,"query",
[{"xmlns","http://jabber.org/protocol/disco#info"}],
[]}]}

=INFO REPORT==== 2013-03-22 09:38:34 ===
D(<0.301.0>:ejabberd_router:313) : route
from {jid,[],"company.domain.tld",[],[],"company.domain.tld",[]}
to {jid,"user1","company.domain.tld","mmmm","user1",
"company.domain.tld","mmmm"}
packet {xmlelement,"iq",
[{"id","purple853088d6"},{"type","result"}],
[{xmlelement,"query",
[{"xmlns","http://jabber.org/protocol/disco#items"}],
[{xmlelement,"item",
[{"jid","conference.company.domain.tld"}],
[]},
{xmlelement,"item",
[{"jid","irc.company.domain.tld"}],
[]},
{xmlelement,"item",
[{"jid","proxy.company.domain.tld"}],
[]},
{xmlelement,"item",
[{"jid","pubsub.company.domain.tld"}],
[]},
{xmlelement,"item",
[{"jid","vjud.company.domain.tld"}],
[]}]}]}

=INFO REPORT==== 2013-03-22 09:38:34 ===
D(<0.301.0>:ejabberd_local:300) : local route
from {jid,[],"company.domain.tld",[],[],"company.domain.tld",[]}
to {jid,"user1","company.domain.tld","mmmm","user1",
"company.domain.tld","mmmm"}
packet {xmlelement,"iq",
[{"id","purple853088d6"},{"type",[...]}],
[{xmlelement,[...],...}]}

=INFO REPORT==== 2013-03-22 09:38:34 ===
D(<0.301.0>:ejabberd_sm:411) : session manager
from {jid,[],"company.domain.tld",[],[],"company.domain.tld",[]}
to {jid,"user1","company.domain.tld","mmmm","user1",
"company.domain.tld","mmmm"}
packet {xmlelement,"iq",
[{"id","purple853088d6"},{"type",[...]}],
[{xmlelement,[...],...}]}

=INFO REPORT==== 2013-03-22 09:38:34 ===
D(<0.301.0>:ejabberd_sm:510) : sending to process <0.390.0>

=INFO REPORT==== 2013-03-22 09:38:34 ===
D(<0.302.0>:ejabberd_router:313) : route
from {jid,[],"company.domain.tld",[],[],"company.domain.tld",[]}
to {jid,"user1","company.domain.tld","mmmm","user1",
"company.domain.tld","mmmm"}
packet {xmlelement,"iq",
[{"id","purple853088d7"},{"type","result"}],
[{xmlelement,"query",
[{"xmlns","http://jabber.org/protocol/disco#info"}],
[{xmlelement,"identity",
[{"category","pubsub"},{"type","pep"}],
[]},
{xmlelement,"identity",
[{"category","server"},{"type","im"},{"name","ejabberd"}],
[]},
{xmlelement,"x",
[{"xmlns","jabber:x:data"},{"type","result"}],
[{xmlelement,"field",
[{"var","FORM_TYPE"},{"type","hidden"}],
[{xmlelement,"value",[],
[{xmlcdata,
"http://jabber.org/network/serverinfo"}]}]}]},
{xmlelement,"feature",
[{"var","http://jabber.org/protocol/commands"}],
[]},
{xmlelement,"feature",
[{"var","http://jabber.org/protocol/disco#info"}],
[]},
{xmlelement,"feature",
[{"var","http://jabber.org/protocol/disco#items"}],
[]},
{xmlelement,"feature",
[{"var","http://jabber.org/protocol/pubsub"}],
[]},
{xmlelement,"feature",
[{"var",
"http://jabber.org/protocol/pubsub#access-authorize"}],
[]},
{xmlelement,"feature",
[{"var","http://jabber.org/protocol/pubsub#access-open"}],
[]},
{xmlelement,"feature",
[{"var",
"http://jabber.org/protocol/pubsub#access-presence"}],
[]},
{xmlelement,"feature",
[{"var",
"http://jabber.org/protocol/pubsub#access-whitelist"}],
[]},
{xmlelement,"feature",
[{"var","http://jabber.org/protocol/pubsub#auto-create"}],
[]},
{xmlelement,"feature",
[{"var",
"http://jabber.org/protocol/pubsub#auto-subscribe"}],
[]},
{xmlelement,"feature",
[{"var","http://jabber.org/protocol/pubsub#collections"}],
[]},
{xmlelement,"feature",
[{"var","http://jabber.org/protocol/pubsub#config-node"}],
[]},
{xmlelement,"feature",
[{"var",
"http://jabber.org/protocol/pubsub#create-and-configure"}],
[]},
{xmlelement,"feature",
[{"var","http://jabber.org/protocol/pubsub#create-nodes"}],
[]},
{xmlelement,"feature",
[{"var","http://jabber.org/protocol/pubsub#delete-items"}],
[]},
{xmlelement,"feature",
[{"var","http://jabber.org/protocol/pubsub#delete-nodes"}],
[]},
{xmlelement,"feature",
[{"var",
"http://jabber.org/protocol/pubsub#filtered-notifications"}],
[]},
{xmlelement,"feature",
[{"var","http://jabber.org/protocol/pubsub#get-pending"}],
[]},
{xmlelement,"feature",
[{"var",
"http://jabber.org/protocol/pubsub#instant-nodes"}],
[]},
{xmlelement,"feature",
[{"var","http://jabber.org/protocol/pubsub#item-ids"}],
[]},
{xmlelement,"feature",
[{"var",
"http://jabber.org/protocol/pubsub#last-published"}],
[]},
{xmlelement,"feature",
[{"var",
"http://jabber.org/protocol/pubsub#manage-subscriptions"}],
[]},
{xmlelement,"feature",
[{"var",
"http://jabber.org/protocol/pubsub#member-affiliation"}],
[]},
{xmlelement,"feature",
[{"var",
"http://jabber.org/protocol/pubsub#modify-affiliations"}],
[]},
{xmlelement,"feature",
[{"var",
"http://jabber.org/protocol/pubsub#multi-subscribe"}],
[]},
{xmlelement,"feature",
[{"var",
"http://jabber.org/protocol/pubsub#outcast-affiliation"}],
[]},
{xmlelement,"feature",
[{"var",
"http://jabber.org/protocol/pubsub#persistent-items"}],
[]},
{xmlelement,"feature",
[{"var",
"http://jabber.org/protocol/pubsub#presence-notifications"}],
[]},
{xmlelement,"feature",
[{"var",
"http://jabber.org/protocol/pubsub#presence-subscribe"}],
[]},
{xmlelement,"feature",
[{"var","http://jabber.org/protocol/pubsub#publish"}],
[]},
{xmlelement,"feature",
[{"var",
"http://jabber.org/protocol/pubsub#publisher-affiliation"}],
[]},
{xmlelement,"feature",
[{"var","http://jabber.org/protocol/pubsub#purge-nodes"}],
[]},
{xmlelement,"feature",
[{"var",
"http://jabber.org/protocol/pubsub#retract-items"}],
[]},
{xmlelement,"feature",
[{"var",
"http://jabber.org/protocol/pubsub#retrieve-affiliations"}],
[]},
{xmlelement,"feature",
[{"var",
"http://jabber.org/protocol/pubsub#retrieve-default"}],
[]},
{xmlelement,"feature",
[{"var",
"http://jabber.org/protocol/pubsub#retrieve-items"}],
[]},
{xmlelement,"feature",
[{"var",
"http://jabber.org/protocol/pubsub#retrieve-subscriptions"}],
[]},
{xmlelement,"feature",
[{"var","http://jabber.org/protocol/pubsub#subscribe"}],
[]},
{xmlelement,"feature",
[{"var",
"http://jabber.org/protocol/pubsub#subscription-notifications"}],
[]},
{xmlelement,"feature",
[{"var",
"http://jabber.org/protocol/pubsub#subscription-options"}],
[]},
{xmlelement,"feature",
[{"var","http://jabber.org/protocol/stats"}],
[]},
{xmlelement,"feature",[{"var","iq"}],[]},
{xmlelement,"feature",[{"var","jabber:iq:last"}],[]},
{xmlelement,"feature",[{"var","jabber:iq:time"}],[]},
{xmlelement,"feature",[{"var","jabber:iq:version"}],[]},
{xmlelement,"feature",[{"var","msgoffline"}],[]},
{xmlelement,"feature",[{"var","presence"}],[]},
{xmlelement,"feature",[{"var","presence-invisible"}],[]},
{xmlelement,"feature",[{"var","urn:xmpp:time"}],[]},
{xmlelement,"feature",[{"var","vcard-temp"}],[]}]}]}

=INFO REPORT==== 2013-03-22 09:38:34 ===
D(<0.390.0>:ejabberd_c2s:1553) : Send XML on stream = <<"">>

=INFO REPORT==== 2013-03-22 09:38:34 ===
D(<0.302.0>:ejabberd_local:300) : local route
from {jid,[],"company.domain.tld",[],[],"company.domain.tld",[]}
to {jid,"user1","company.domain.tld","mmmm","user1",
"company.domain.tld","mmmm"}
packet {xmlelement,"iq",
[{"id","purple853088d7"},{"type",[...]}],
[{xmlelement,[...],...}]}

=INFO REPORT==== 2013-03-22 09:38:34 ===
D(<0.302.0>:ejabberd_sm:411) : session manager
from {jid,[],"company.domain.tld",[],[],"company.domain.tld",[]}
to {jid,"user1","company.domain.tld","mmmm","user1",
"company.domain.tld","mmmm"}
packet {xmlelement,"iq",
[{"id","purple853088d7"},{"type",[...]}],
[{xmlelement,[...],...}]}

=INFO REPORT==== 2013-03-22 09:38:34 ===
D(<0.302.0>:ejabberd_sm:510) : sending to process <0.390.0>

=INFO REPORT==== 2013-03-22 09:38:34 ===
D(<0.390.0>:ejabberd_c2s:1553) : Send XML on stream = <<"http://jabber.org/network/serverinfo">>

=INFO REPORT==== 2013-03-22 09:38:34 ===
D(<0.389.0>:ejabberd_receiver:320) : Received XML on stream = ""

=INFO REPORT==== 2013-03-22 09:38:34 ===
D(<0.389.0>:shaper:61) : State: {maxrate,1000,995.7848227150841,
1363941514064785}, Size=126
M=125.4711169977182, I=701.062

=INFO REPORT==== 2013-03-22 09:38:34 ===
D(<0.390.0>:ejabberd_router:313) : route
from {jid,"user1","company.domain.tld","mmmm","user1",
"company.domain.tld","mmmm"}
to {jid,[],"conference.company.domain.tld",[],[],
"conference.company.domain.tld",[]}
packet {xmlelement,"iq",
[{"type","get"},
{"id","purple853088d8"},
{"to","conference.company.domain.tld"}],
[{xmlelement,"query",
[{"xmlns","http://jabber.org/protocol/disco#info"}],
[]}]}

=INFO REPORT==== 2013-03-22 09:38:34 ===
D(<0.313.0>:ejabberd_router:313) : route
from {jid,[],"conference.company.domain.tld",[],[],
"conference.company.domain.tld",[]}
to {jid,"user1","company.domain.tld","mmmm","user1",
"company.domain.tld","mmmm"}
packet {xmlelement,"iq",
[{"id","purple853088d8"},{"type","result"}],
[{xmlelement,"query",
[{"xmlns","http://jabber.org/protocol/disco#info"}],
[{xmlelement,"identity",
[{"category","conference"},
{"type","text"},
{"name","Chatrooms"}],
[]},
{xmlelement,"feature",
[{"var","http://jabber.org/protocol/disco#info"}],
[]},
{xmlelement,"feature",
[{"var","http://jabber.org/protocol/disco#items"}],
[]},
{xmlelement,"feature",
[{"var","http://jabber.org/protocol/muc"}],
[]},
{xmlelement,"feature",
[{"var","http://jabber.org/protocol/muc#unique"}],
[]},
{xmlelement,"feature",[{"var","jabber:iq:register"}],[]},
{xmlelement,"feature",
[{"var","http://jabber.org/protocol/rsm"}],
[]},
{xmlelement,"feature",[{"var","vcard-temp"}],[]},
{xmlelement,"x",
[{"xmlns","jabber:x:data"},{"type","result"}],
[{xmlelement,"field",
[{"var","FORM_TYPE"},{"type","hidden"}],
[{xmlelement,"value",[],
[{xmlcdata,
"http://jabber.org/network/serverinfo"}]}]}]}]}]}

=INFO REPORT==== 2013-03-22 09:38:34 ===
D(<0.313.0>:ejabberd_local:300) : local route
from {jid,[],"conference.company.domain.tld",[],[],
"conference.company.domain.tld",[]}
to {jid,"user1","company.domain.tld","mmmm","user1",
"company.domain.tld","mmmm"}
packet {xmlelement,"iq",
[{"id","purple853088d8"},{"type",[...]}],
[{xmlelement,[...],...}]}

=INFO REPORT==== 2013-03-22 09:38:34 ===
D(<0.313.0>:ejabberd_sm:411) : session manager
from {jid,[],"conference.company.domain.tld",[],[],
"conference.company.domain.tld",[]}
to {jid,"user1","company.domain.tld","mmmm","user1",
"company.domain.tld","mmmm"}
packet {xmlelement,"iq",
[{"id","purple853088d8"},{"type",[...]}],
[{xmlelement,[...],...}]}

=INFO REPORT==== 2013-03-22 09:38:34 ===
D(<0.313.0>:ejabberd_sm:510) : sending to process <0.390.0>

=INFO REPORT==== 2013-03-22 09:38:34 ===
D(<0.390.0>:ejabberd_c2s:1553) : Send XML on stream = <<"http://jabber.org/network/serverinfo">>

=INFO REPORT==== 2013-03-22 09:38:34 ===
D(<0.389.0>:ejabberd_receiver:320) : Received XML on stream = ""

=INFO REPORT==== 2013-03-22 09:38:34 ===
D(<0.389.0>:shaper:61) : State: {maxrate,1000,587.755690796681,
1363941514765850}, Size=901
M=637.9915954543841, I=45.178

=INFO REPORT==== 2013-03-22 09:38:34 ===
D(<0.390.0>:ejabberd_router:313) : route
from {jid,"user1","company.domain.tld","mmmm","user1",
"company.domain.tld","mmmm"}
to {jid,[],"irc.company.domain.tld",[],[],"irc.company.domain.tld",[]}
packet {xmlelement,"iq",
[{"type","get"},
{"id","purple853088d9"},
{"to","irc.company.domain.tld"}],
[{xmlelement,"query",
[{"xmlns","http://jabber.org/protocol/disco#info"}],
[]}]}

=INFO REPORT==== 2013-03-22 09:38:34 ===
D(<0.390.0>:ejabberd_router:313) : route
from {jid,"user1","company.domain.tld","mmmm","user1",
"company.domain.tld","mmmm"}
to {jid,[],"proxy.company.domain.tld",[],[],"proxy.company.domain.tld",[]}
packet {xmlelement,"iq",
[{"type","get"},
{"id","purple853088da"},
{"to","proxy.company.domain.tld"}],
[{xmlelement,"query",
[{"xmlns","http://jabber.org/protocol/disco#info"}],
[]}]}

=INFO REPORT==== 2013-03-22 09:38:34 ===
D(<0.390.0>:ejabberd_router:313) : route
from {jid,"user1","company.domain.tld","mmmm","user1",
"company.domain.tld","mmmm"}
to {jid,[],"pubsub.company.domain.tld",[],[],"pubsub.company.domain.tld",[]}
packet {xmlelement,"iq",
[{"type","get"},
{"id","purple853088db"},
{"to","pubsub.company.domain.tld"}],
[{xmlelement,"query",
[{"xmlns","http://jabber.org/protocol/disco#info"}],
[]}]}

=INFO REPORT==== 2013-03-22 09:38:34 ===
D(<0.390.0>:ejabberd_router:313) : route
from {jid,"user1","company.domain.tld","mmmm","user1",
"company.domain.tld","mmmm"}
to {jid,[],"vjud.company.domain.tld",[],[],"vjud.company.domain.tld",[]}
packet {xmlelement,"iq",
[{"type","get"},
{"id","purple853088dc"},
{"to","vjud.company.domain.tld"}],
[{xmlelement,"query",
[{"xmlns","http://jabber.org/protocol/disco#info"}],
[]}]}

---> SNIPP

=INFO REPORT==== 2013-03-22 09:38:35 ===
D(<0.390.0>:ejabberd_sm:411) : session manager
from {jid,"user1","company.domain.tld",[],"user1","company.domain.tld",
[]}
to {jid,"user1","company.domain.tld","mmmm","user1",
"company.domain.tld","mmmm"}
packet {xmlelement,"message",
[{"type","headline"}],
[{xmlelement,[...],...},{xmlelement,...}]}

=INFO REPORT==== 2013-03-22 09:38:35 ===
D(<0.390.0>:ejabberd_sm:510) : sending to process <0.390.0>

=INFO REPORT==== 2013-03-22 09:38:35 ===
D(<0.390.0>:ejabberd_c2s:1553) : Send XML on stream = <<"">>

=INFO REPORT==== 2013-03-22 09:38:36 ===
D(<0.392.0>:ejabberd_receiver:320) : Received XML on stream = []

=INFO REPORT==== 2013-03-22 09:38:37 ===
D(<0.392.0>:ejabberd_receiver:320) : Received XML on stream = "<?xml version='1.0'?>zlib"

=INFO REPORT==== 2013-03-22 09:38:48 ===
I(<0.385.0>:ejabberd_listener:281) : (#Port<0.2199>) Accepted connection {{141,5,16,182},64343} -> {{141,5,16,185},5222}

=INFO REPORT==== 2013-03-22 09:38:48 ===
D(<0.403.0>:ejabberd_receiver:320) : Received XML on stream = "<?xml version=\"1.0\" encoding=\"UTF-8\" ?>\n"

=INFO REPORT==== 2013-03-22 09:38:48 ===
D(<0.404.0>:ejabberd_c2s:1553) : Send XML on stream = [60,63,120,109,108,32,
118,101,114,115,105,
111,110,61,39,49,46,48,
39,63,62,60,115,116,
114,101,97,109,58,115,
116,114,101,97,109,32,
120,109,108,110,115,61,
39,106,97,98,98,101,
114,58,99,108,105,101,
110,116,39,32,120,109,
108,110,115,58,115,116,
114,101,97,109,61,39,
104,116,116,112,58,47,
47,101,116,104,101,114,
120,46,106,97,98,98,
101,114,46,111,114,103,
47,115,116,114,101,97,
109,115,39,32,105,100,
61,39,"3530346190",39,
32,102,114,111,109,61,
39,"company.domain.tld",
39,
[" version='","1.0",
"'"],
[" xml:lang='","en",
"'"],
62]

=INFO REPORT==== 2013-03-22 09:38:48 ===
D(<0.404.0>:ejabberd_c2s:1553) : Send XML on stream = <<"PLAIN">>

=INFO REPORT==== 2013-03-22 09:38:48 ===
D(<0.403.0>:ejabberd_receiver:320) : Received XML on stream = ""

=INFO REPORT==== 2013-03-22 09:38:48 ===
D(<0.403.0>:shaper:61) : State: {maxrate,1000,0,1363941528113114}, Size=51
M=25.5, I=1.8

=INFO REPORT==== 2013-03-22 09:38:48 ===
D(<0.403.0>:ejabberd_receiver:320) : Received XML on stream = []

=INFO REPORT==== 2013-03-22 09:38:48 ===
D(<0.403.0>:shaper:61) : State: {maxrate,1000,988.2571793977445,
1363941528138917}, Size=0
M=0.0, I=-23.45

---> SNIPP

=INFO REPORT==== 2013-03-22 09:38:54 ===
D(<0.352.0>:mod_pubsub:3792) : node_action "pubsub.company.domain.tld" "pep" get_entity_subscriptions ["pubsub.company.domain.tld",
{jid,
"vvvv",
"company.domain.tld",
"16714553031363941531916922",
"vvvv",
"company.domain.tld",
"16714553031363941531916922"}]

=INFO REPORT==== 2013-03-22 09:38:54 ===
D(<0.347.0>:ejabberd_sm:510) : sending to process <0.409.0>

=INFO REPORT==== 2013-03-22 09:38:54 ===
D(<0.352.0>:mod_pubsub:3777) : node_call "pep" get_entity_subscriptions ["pubsub.company.domain.tld",
{jid,
"vvvv",
"company.domain.tld",
"16714553031363941531916922",
"vvvv",
"company.domain.tld",
"16714553031363941531916922"}]

=INFO REPORT==== 2013-03-22 09:38:54 ===
D(<0.505.0>:mod_pubsub:3771) : tree_action "pubsub.company.domain.tld" get_nodes [{"vvvv",
"company.domain.tld",
[]},
{jid,
"vvvv",
"company.domain.tld",
"16714553031363941531916922",
"vvvv",
"company.domain.tld",
"16714553031363941531916922"}]

=INFO REPORT==== 2013-03-22 09:38:54 ===
D(<0.505.0>:mod_pubsub:3764) : tree_call "pubsub.company.domain.tld" get_nodes [{"vvvv",
"company.domain.tld",
[]},
{jid,
"vvvv",
"company.domain.tld",
"16714553031363941531916922",
"vvvv",
"company.domain.tld",
"16714553031363941531916922"}]

=INFO REPORT==== 2013-03-22 09:38:54 ===
D(<0.505.0>:mod_pubsub:3792) : node_action {"vvvv","company.domain.tld",[]} "pep" get_items [5,
{"vvvv",
"company.domain.tld",
"16714553031363941531916922"}]

=INFO REPORT==== 2013-03-22 09:38:54 ===
D(<0.505.0>:mod_pubsub:3777) : node_call "pep" get_items [5,
{"vvvv",
"company.domain.tld",
"16714553031363941531916922"}]

=INFO REPORT==== 2013-03-22 09:38:54 ===
D(<0.409.0>:ejabberd_c2s:1553) : Send XML on stream = <<"awayI'm not here right now">>

=INFO REPORT==== 2013-03-22 09:38:54 ===
D(<0.352.0>:mod_pubsub:3792) : node_action "pubsub.company.domain.tld" "flat" get_entity_subscriptions ["pubsub.company.domain.tld",
{jid,
"vvvv",
"company.domain.tld",
"16714553031363941531916922",
"vvvv",
"company.domain.tld",
"16714553031363941531916922"}]

ejabberd - Comments for "mod_shared_roster_ldap not working"

Solution for me was to use

Hi Mike, Appreciate the

It isn't clear how your