8000 [2016/07/28 11:27:21.096434, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8001 ldb: ldb_trace_next_request: (descriptor)->search 8002 [2016/07/28 11:27:21.096456, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8003 ldb: ldb_trace_next_request: (acl)->search 8004 [2016/07/28 11:27:21.096478, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8005 ldb: ldb_trace_next_request: (aclread)->search 8006 [2016/07/28 11:27:21.096501, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8007 ldb: ldb_trace_next_request: (operational)->search 8008 [2016/07/28 11:27:21.096523, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8009 ldb: ldb_trace_next_request: (rdn_name)->search 8010 [2016/07/28 11:27:21.096544, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8011 ldb: ldb_trace_next_request: (extended_dn_out_ldb)->search 8012 [2016/07/28 11:27:21.096565, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8013 ldb: ldb_trace_next_request: (show_deleted)->search 8014 [2016/07/28 11:27:21.096589, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8015 ldb: ldb_trace_next_request: (partition)->search 8016 [2016/07/28 11:27:21.096610, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8017 ldb: ldb_trace_next_request: (tdb)->search 8018 [2016/07/28 11:27:21.096686, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8019 ldb: ldb_trace_next_request: (schema_load)->search 8020 [2016/07/28 11:27:21.096716, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8021 ldb: ldb_trace_next_request: (lazy_commit)->search 8022 [2016/07/28 11:27:21.096738, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8023 ldb: ldb_trace_next_request: (dirsync)->search 8024 [2016/07/28 11:27:21.096760, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8025 ldb: ldb_trace_next_request: (paged_results)->search 8026 [2016/07/28 11:27:21.096782, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8027 ldb: ldb_trace_next_request: (ranged_results)->search 8028 [2016/07/28 11:27:21.096803, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8029 ldb: ldb_trace_next_request: (anr)->search 8030 [2016/07/28 11:27:21.096825, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8031 ldb: ldb_trace_next_request: (server_sort)->search 8032 [2016/07/28 11:27:21.096847, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8033 ldb: ldb_trace_next_request: (asq)->search 8034 [2016/07/28 11:27:21.096868, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8035 ldb: ldb_trace_next_request: (extended_dn_in)->search 8036 [2016/07/28 11:27:21.096911, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8037 ldb: ldb_trace_next_request: (descriptor)->search 8038 [2016/07/28 11:27:21.096937, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8039 ldb: ldb_trace_next_request: (acl)->search 8040 [2016/07/28 11:27:21.096988, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8041 ldb: ldb_trace_next_request: (aclread)->search 8042 [2016/07/28 11:27:21.097014, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8043 ldb: ldb_trace_next_request: (operational)->search 8044 [2016/07/28 11:27:21.097040, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8045 ldb: ldb_trace_next_request: (rdn_name)->search 8046 [2016/07/28 11:27:21.097062, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8047 ldb: ldb_trace_next_request: (extended_dn_out_ldb)->search 8048 [2016/07/28 11:27:21.097097, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8049 ldb: ldb_trace_next_request: (show_deleted)->search 8050 [2016/07/28 11:27:21.097124, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8051 ldb: ldb_trace_next_request: (partition)->search 8052 [2016/07/28 11:27:21.097153, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8053 ldb: partition_request() -> (metadata partition) 8054 [2016/07/28 11:27:21.097176, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8055 ldb: ldb_trace_next_request: (tdb)->search 8056 [2016/07/28 11:27:21.097228, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8057 ldb: partition_request() -> (metadata partition) 8058 [2016/07/28 11:27:21.097253, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8059 ldb: ldb_trace_next_request: (schema_data)->search 8060 [2016/07/28 11:27:21.097276, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8061 ldb: ldb_trace_next_request: (tdb)->search 8062 [2016/07/28 11:27:21.097324, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8063 ldb: partition_request() -> (metadata partition) 8064 [2016/07/28 11:27:21.097348, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8065 ldb: ldb_trace_next_request: (tdb)->search 8066 [2016/07/28 11:27:21.097496, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8067 ldb: partition_request() -> (metadata partition) 8068 [2016/07/28 11:27:21.097525, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8069 ldb: ldb_trace_next_request: (tdb)->search 8070 [2016/07/28 11:27:21.097573, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8071 ldb: partition_request() -> (metadata partition) 8072 [2016/07/28 11:27:21.097598, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8073 ldb: ldb_trace_next_request: (tdb)->search 8074 [2016/07/28 11:27:21.097652, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8075 ldb: partition_request() -> (metadata partition) 8076 [2016/07/28 11:27:21.097676, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8077 ldb: ldb_trace_next_request: (tdb)->search 8078 [2016/07/28 11:27:21.097724, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8079 ldb: ldb_trace_next_request: (descriptor)->search 8080 [2016/07/28 11:27:21.097750, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8081 ldb: ldb_trace_next_request: (acl)->search 8082 [2016/07/28 11:27:21.097804, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8083 ldb: ldb_trace_next_request: (aclread)->search 8084 [2016/07/28 11:27:21.097832, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8085 ldb: ldb_trace_next_request: (operational)->search 8086 [2016/07/28 11:27:21.097866, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8087 ldb: ldb_trace_next_request: (rdn_name)->search 8088 [2016/07/28 11:27:21.097891, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8089 ldb: ldb_trace_next_request: (extended_dn_out_ldb)->search 8090 [2016/07/28 11:27:21.097918, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8091 ldb: ldb_trace_next_request: (show_deleted)->search 8092 [2016/07/28 11:27:21.097944, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8093 ldb: ldb_trace_next_request: (partition)->search 8094 [2016/07/28 11:27:21.098009, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8095 ldb: partition_request() -> (metadata partition) 8096 [2016/07/28 11:27:21.098034, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8097 ldb: ldb_trace_next_request: (tdb)->search 8098 [2016/07/28 11:27:21.098244, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8099 ldb: ldb_trace_response: ENTRY 8100 dn: 8101 dsServiceName: CN=NTDS Settings,CN=SAMBA-01,CN=Servers,CN=Default-First-Site-N 8102 ame,CN=Sites,CN=Configuration,DC=brockley-2016,DC=harte-lyne,DC=ca 8103 8104 8105 8106 [2016/07/28 11:27:21.098297, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8107 ldb: ldb_trace_response: DONE 8108 error: 0 8109 8110 [2016/07/28 11:27:21.098349, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8111 ldb: ldb_trace_next_request: (partition)->search 8112 [2016/07/28 11:27:21.098391, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8113 ldb: partition_request() -> (metadata partition) 8114 [2016/07/28 11:27:21.098415, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8115 ldb: ldb_trace_next_request: (tdb)->search 8116 [2016/07/28 11:27:21.098503, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8117 ldb: ldb_trace_response: ENTRY 8118 dn: CN=NTDS Settings,CN=SAMBA-01,CN=Servers,CN=Default-First-Site-Name,CN=Sites,CN=Configuration,DC=brockley-2016,DC=harte-lyne,DC=ca 8119 8120 8121 8122 [2016/07/28 11:27:21.098547, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8123 ldb: ldb_trace_response: DONE 8124 error: 0 8125 8126 [2016/07/28 11:27:21.098586, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8127 ldb: ldb_trace_next_request: (partition)->search 8128 [2016/07/28 11:27:21.098613, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8129 ldb: partition_request() -> (metadata partition) 8130 [2016/07/28 11:27:21.098635, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8131 ldb: ldb_trace_next_request: (tdb)->search 8132 [2016/07/28 11:27:21.098751, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8133 ldb: ldb_trace_response: ENTRY 8134 dn: DC=brockley-2016,DC=harte-lyne,DC=ca 8135 msDS-Behavior-Version: 4 8136 8137 8138 8139 [2016/07/28 11:27:21.098800, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8140 ldb: ldb_trace_response: DONE 8141 error: 0 8142 8143 [2016/07/28 11:27:21.098852, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8144 ldb: ldb_trace_next_request: (schema_load)->search 8145 [2016/07/28 11:27:21.098881, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8146 ldb: ldb_trace_next_request: (lazy_commit)->search 8147 [2016/07/28 11:27:21.098903, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8148 ldb: ldb_trace_next_request: (dirsync)->search 8149 [2016/07/28 11:27:21.098924, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8150 ldb: ldb_trace_next_request: (paged_results)->search 8151 [2016/07/28 11:27:21.098946, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8152 ldb: ldb_trace_next_request: (ranged_results)->search 8153 [2016/07/28 11:27:21.098993, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8154 ldb: ldb_trace_next_request: (anr)->search 8155 [2016/07/28 11:27:21.099017, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8156 ldb: ldb_trace_next_request: (server_sort)->search 8157 [2016/07/28 11:27:21.099039, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8158 ldb: ldb_trace_next_request: (asq)->search 8159 [2016/07/28 11:27:21.099061, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8160 ldb: ldb_trace_next_request: (extended_dn_in)->search 8161 [2016/07/28 11:27:21.099087, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8162 ldb: ldb_trace_next_request: (descriptor)->search 8163 [2016/07/28 11:27:21.099110, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8164 ldb: ldb_trace_next_request: (acl)->search 8165 [2016/07/28 11:27:21.099137, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8166 ldb: ldb_trace_next_request: (aclread)->search 8167 [2016/07/28 11:27:21.099161, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8168 ldb: ldb_trace_next_request: (operational)->search 8169 [2016/07/28 11:27:21.099190, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8170 ldb: ldb_trace_next_request: (rdn_name)->search 8171 [2016/07/28 11:27:21.099213, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8172 ldb: ldb_trace_next_request: (extended_dn_out_ldb)->search 8173 [2016/07/28 11:27:21.099247, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8174 ldb: ldb_trace_next_request: (show_deleted)->search 8175 [2016/07/28 11:27:21.099271, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8176 ldb: ldb_trace_next_request: (partition)->search 8177 [2016/07/28 11:27:21.099306, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8178 ldb: partition_request() -> (metadata partition) 8179 [2016/07/28 11:27:21.099330, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8180 ldb: ldb_trace_next_request: (tdb)->search 8181 [2016/07/28 11:27:21.099414, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8182 ldb: ldb_trace_response: ENTRY 8183 dn: CN=Partitions,CN=Configuration,DC=brockley-2016,DC=harte-lyne,DC=ca 8184 msDS-Behavior-Version: 4 8185 8186 8187 8188 [2016/07/28 11:27:21.099462, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8189 ldb: ldb_trace_response: DONE 8190 error: 0 8191 8192 [2016/07/28 11:27:21.099506, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8193 ldb: ldb_trace_next_request: (schema_load)->search 8194 [2016/07/28 11:27:21.099534, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8195 ldb: ldb_trace_next_request: (lazy_commit)->search 8196 [2016/07/28 11:27:21.099556, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8197 ldb: ldb_trace_next_request: (dirsync)->search 8198 [2016/07/28 11:27:21.099577, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8199 ldb: ldb_trace_next_request: (paged_results)->search 8200 [2016/07/28 11:27:21.099598, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8201 ldb: ldb_trace_next_request: (ranged_results)->search 8202 [2016/07/28 11:27:21.099620, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8203 ldb: ldb_trace_next_request: (anr)->search 8204 [2016/07/28 11:27:21.099642, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8205 ldb: ldb_trace_next_request: (server_sort)->search 8206 [2016/07/28 11:27:21.099664, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8207 ldb: ldb_trace_next_request: (asq)->search 8208 [2016/07/28 11:27:21.099685, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8209 ldb: ldb_trace_next_request: (extended_dn_in)->search 8210 [2016/07/28 11:27:21.099710, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8211 ldb: ldb_trace_next_request: (descriptor)->search 8212 [2016/07/28 11:27:21.099733, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8213 ldb: ldb_trace_next_request: (acl)->search 8214 [2016/07/28 11:27:21.099754, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8215 ldb: ldb_trace_next_request: (aclread)->search 8216 [2016/07/28 11:27:21.099777, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8217 ldb: ldb_trace_next_request: (operational)->search 8218 [2016/07/28 11:27:21.099799, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8219 ldb: ldb_trace_next_request: (rdn_name)->search 8220 [2016/07/28 11:27:21.099820, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8221 ldb: ldb_trace_next_request: (extended_dn_out_ldb)->search 8222 [2016/07/28 11:27:21.099841, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8223 ldb: ldb_trace_next_request: (show_deleted)->search 8224 [2016/07/28 11:27:21.099865, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8225 ldb: ldb_trace_next_request: (partition)->search 8226 [2016/07/28 11:27:21.099886, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8227 ldb: ldb_trace_next_request: (tdb)->search 8228 [2016/07/28 11:27:21.099959, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8229 ldb: ldb_trace_next_request: (schema_load)->search 8230 [2016/07/28 11:27:21.100014, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8231 ldb: ldb_trace_next_request: (lazy_commit)->search 8232 [2016/07/28 11:27:21.100036, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8233 ldb: ldb_trace_next_request: (dirsync)->search 8234 [2016/07/28 11:27:21.100058, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8235 ldb: ldb_trace_next_request: (paged_results)->search 8236 [2016/07/28 11:27:21.100079, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8237 ldb: ldb_trace_next_request: (ranged_results)->search 8238 [2016/07/28 11:27:21.100101, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8239 ldb: ldb_trace_next_request: (anr)->search 8240 [2016/07/28 11:27:21.100123, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8241 ldb: ldb_trace_next_request: (server_sort)->search 8242 [2016/07/28 11:27:21.100145, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8243 ldb: ldb_trace_next_request: (asq)->search 8244 [2016/07/28 11:27:21.100166, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8245 ldb: ldb_trace_next_request: (extended_dn_in)->search 8246 [2016/07/28 11:27:21.100204, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8247 ldb: ldb_trace_next_request: (descriptor)->search 8248 [2016/07/28 11:27:21.100229, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8249 ldb: ldb_trace_next_request: (acl)->search 8250 [2016/07/28 11:27:21.100256, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8251 ldb: ldb_trace_next_request: (aclread)->search 8252 [2016/07/28 11:27:21.100280, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8253 ldb: ldb_trace_next_request: (operational)->search 8254 [2016/07/28 11:27:21.100304, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8255 ldb: ldb_trace_next_request: (rdn_name)->search 8256 [2016/07/28 11:27:21.100326, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8257 ldb: ldb_trace_next_request: (extended_dn_out_ldb)->search 8258 [2016/07/28 11:27:21.100353, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8259 ldb: ldb_trace_next_request: (show_deleted)->search 8260 [2016/07/28 11:27:21.100378, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8261 ldb: ldb_trace_next_request: (partition)->search 8262 [2016/07/28 11:27:21.100407, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8263 ldb: partition_request() -> (metadata partition) 8264 [2016/07/28 11:27:21.100429, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8265 ldb: ldb_trace_next_request: (tdb)->search 8266 [2016/07/28 11:27:21.100476, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8267 ldb: partition_request() -> (metadata partition) 8268 [2016/07/28 11:27:21.100501, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8269 ldb: ldb_trace_next_request: (schema_data)->search 8270 [2016/07/28 11:27:21.100524, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8271 ldb: ldb_trace_next_request: (tdb)->search 8272 [2016/07/28 11:27:21.100570, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8273 ldb: partition_request() -> (metadata partition) 8274 [2016/07/28 11:27:21.100601, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8275 ldb: ldb_trace_next_request: (tdb)->search 8276 [2016/07/28 11:27:21.100731, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8277 ldb: partition_request() -> (metadata partition) 8278 [2016/07/28 11:27:21.100760, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8279 ldb: ldb_trace_next_request: (tdb)->search 8280 [2016/07/28 11:27:21.100806, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8281 ldb: partition_request() -> (metadata partition) 8282 [2016/07/28 11:27:21.100830, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8283 ldb: ldb_trace_next_request: (tdb)->search 8284 [2016/07/28 11:27:21.100874, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8285 ldb: partition_request() -> (metadata partition) 8286 [2016/07/28 11:27:21.100899, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8287 ldb: ldb_trace_next_request: (tdb)->search 8288 [2016/07/28 11:27:21.100945, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8289 ldb: ldb_trace_next_request: (descriptor)->search 8290 [2016/07/28 11:27:21.100998, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8291 ldb: ldb_trace_next_request: (acl)->search 8292 [2016/07/28 11:27:21.101027, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8293 ldb: ldb_trace_next_request: (aclread)->search 8294 [2016/07/28 11:27:21.101051, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8295 ldb: ldb_trace_next_request: (operational)->search 8296 [2016/07/28 11:27:21.101078, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8297 ldb: ldb_trace_next_request: (rdn_name)->search 8298 [2016/07/28 11:27:21.101100, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8299 ldb: ldb_trace_next_request: (extended_dn_out_ldb)->search 8300 [2016/07/28 11:27:21.101125, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8301 ldb: ldb_trace_next_request: (show_deleted)->search 8302 [2016/07/28 11:27:21.101149, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8303 ldb: ldb_trace_next_request: (partition)->search 8304 [2016/07/28 11:27:21.101192, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8305 ldb: partition_request() -> (metadata partition) 8306 [2016/07/28 11:27:21.101216, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8307 ldb: ldb_trace_next_request: (tdb)->search 8308 [2016/07/28 11:27:21.101329, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8309 ldb: ldb_trace_response: ENTRY 8310 dn: CN=NTDS Settings,CN=SAMBA-01,CN=Servers,CN=Default-First-Site-Name,CN=Sites,CN=Configuration,DC=brockley-2016,DC=harte-lyne,DC=ca 8311 msDS-Behavior-Version: 4 8312 8313 8314 8315 [2016/07/28 11:27:21.101389, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8316 ldb: ldb_trace_response: DONE 8317 error: 0 8318 8319 [2016/07/28 11:27:21.101455, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8320 ldb: ldb_trace_next_request: (schema_load)->search 8321 [2016/07/28 11:27:21.101484, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8322 ldb: ldb_trace_next_request: (lazy_commit)->search 8323 [2016/07/28 11:27:21.101506, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8324 ldb: ldb_trace_next_request: (dirsync)->search 8325 [2016/07/28 11:27:21.101528, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8326 ldb: ldb_trace_next_request: (paged_results)->search 8327 [2016/07/28 11:27:21.101549, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8328 ldb: ldb_trace_next_request: (ranged_results)->search 8329 [2016/07/28 11:27:21.101571, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8330 ldb: ldb_trace_next_request: (anr)->search 8331 [2016/07/28 11:27:21.101594, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8332 ldb: ldb_trace_next_request: (server_sort)->search 8333 [2016/07/28 11:27:21.101615, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8334 ldb: ldb_trace_next_request: (asq)->search 8335 [2016/07/28 11:27:21.101636, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8336 ldb: ldb_trace_next_request: (extended_dn_in)->search 8337 [2016/07/28 11:27:21.101662, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8338 ldb: ldb_trace_next_request: (descriptor)->search 8339 [2016/07/28 11:27:21.101685, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8340 ldb: ldb_trace_next_request: (acl)->search 8341 [2016/07/28 11:27:21.101712, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8342 ldb: ldb_trace_next_request: (aclread)->search 8343 [2016/07/28 11:27:21.101736, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8344 ldb: ldb_trace_next_request: (operational)->search 8345 [2016/07/28 11:27:21.101762, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8346 ldb: ldb_trace_next_request: (rdn_name)->search 8347 [2016/07/28 11:27:21.101784, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8348 ldb: ldb_trace_next_request: (extended_dn_out_ldb)->search 8349 [2016/07/28 11:27:21.101809, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8350 ldb: ldb_trace_next_request: (show_deleted)->search 8351 [2016/07/28 11:27:21.101833, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8352 ldb: ldb_trace_next_request: (partition)->search 8353 [2016/07/28 11:27:21.101870, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8354 ldb: partition_request() -> (metadata partition) 8355 [2016/07/28 11:27:21.101894, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8356 ldb: ldb_trace_next_request: (tdb)->search 8357 [2016/07/28 11:27:21.102003, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8358 ldb: ldb_trace_response: ENTRY 8359 dn: CN=Directory Service,CN=Windows NT,CN=Services,CN=Configuration,DC=brockley-2016,DC=harte-lyne,DC=ca 8360 8361 8362 8363 [2016/07/28 11:27:21.102049, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8364 ldb: ldb_trace_response: DONE 8365 error: 0 8366 8367 [2016/07/28 11:27:21.102109, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8368 ldb: ldb_trace_request: SEARCH 8369 dn: 8370 scope: base 8371 expr: (objectClass=*) 8372 attr: rootDomainNamingContext 8373 attr: configurationNamingContext 8374 attr: schemaNamingContext 8375 attr: defaultNamingContext 8376 control: 8377 8378 [2016/07/28 11:27:21.102173, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8379 ldb: ldb_trace_request: (resolve_oids)->search 8380 [2016/07/28 11:27:21.102203, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8381 ldb: ldb_trace_next_request: (rootdse)->search 8382 [2016/07/28 11:27:21.102232, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8383 ldb: ldb_trace_next_request: (schema_load)->search 8384 [2016/07/28 11:27:21.102257, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8385 ldb: ldb_trace_next_request: (lazy_commit)->search 8386 [2016/07/28 11:27:21.102279, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8387 ldb: ldb_trace_next_request: (dirsync)->search 8388 [2016/07/28 11:27:21.102300, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8389 ldb: ldb_trace_next_request: (paged_results)->search 8390 [2016/07/28 11:27:21.102321, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8391 ldb: ldb_trace_next_request: (ranged_results)->search 8392 [2016/07/28 11:27:21.102344, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8393 ldb: ldb_trace_next_request: (anr)->search 8394 [2016/07/28 11:27:21.102367, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8395 ldb: ldb_trace_next_request: (server_sort)->search 8396 [2016/07/28 11:27:21.102388, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8397 ldb: ldb_trace_next_request: (asq)->search 8398 [2016/07/28 11:27:21.102409, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8399 ldb: ldb_trace_next_request: (extended_dn_in)->search 8400 [2016/07/28 11:27:21.102434, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8401 ldb: ldb_trace_next_request: (descriptor)->search 8402 [2016/07/28 11:27:21.102457, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8403 ldb: ldb_trace_next_request: (acl)->search 8404 [2016/07/28 11:27:21.102479, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8405 ldb: ldb_trace_next_request: (aclread)->search 8406 [2016/07/28 11:27:21.102502, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8407 ldb: ldb_trace_next_request: (operational)->search 8408 [2016/07/28 11:27:21.102571, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8409 ldb: ldb_trace_next_request: (rdn_name)->search 8410 [2016/07/28 11:27:21.102593, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8411 ldb: ldb_trace_next_request: (extended_dn_out_ldb)->search 8412 [2016/07/28 11:27:21.102614, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8413 ldb: ldb_trace_next_request: (show_deleted)->search 8414 [2016/07/28 11:27:21.102638, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8415 ldb: ldb_trace_next_request: (partition)->search 8416 [2016/07/28 11:27:21.102660, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8417 ldb: ldb_trace_next_request: (tdb)->search 8418 [2016/07/28 11:27:21.102817, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8419 ldb: ldb_trace_response: ENTRY 8420 dn: 8421 configurationNamingContext: CN=Configuration,DC=brockley-2016,DC=harte-lyne,DC 8422 =ca 8423 defaultNamingContext: DC=brockley-2016,DC=harte-lyne,DC=ca 8424 rootDomainNamingContext: DC=brockley-2016,DC=harte-lyne,DC=ca 8425 schemaNamingContext: CN=Schema,CN=Configuration,DC=brockley-2016,DC=harte-lyne 8426 ,DC=ca 8427 8428 8429 8430 [2016/07/28 11:27:21.102881, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 8431 ldb: ldb_trace_response: DONE 8432 error: 0 8433 8434 [2016/07/28 11:27:21.102920, 10, pid=24487, effective(0, 0), real(0, 0), class=dfs_samba4] ../source3/modules/vfs_dfs_samba4.c:91(dfs_samba4_connect) 8435 dfs_samba4: connect to service[PROFILES] 8436 [2016/07/28 11:27:21.102985, 5, pid=24487, effective(0, 0), real(0, 0)] ../source3/lib/messages.c:446(messaging_register) 8437 Registering messaging pointer for type 784 - private_data=0x81e4ad8a0 8438 [2016/07/28 11:27:21.103012, 5, pid=24487, effective(0, 0), real(0, 0)] ../source3/lib/messages.c:446(messaging_register) 8439 Registering messaging pointer for type 793 - private_data=0x813c85f60 8440 [2016/07/28 11:27:21.103077, 10, pid=24487, effective(0, 0), real(0, 0)] ../source3/smbd/service.c:164(set_conn_connectpath) 8441 set_conn_connectpath: service PROFILES, connectpath = /var/samba4/BROCKLEY-2016/PROFILES 8442 [2016/07/28 11:27:21.103112, 10, pid=24487, effective(0, 0), real(0, 0)] ../source3/smbd/share_access.c:237(user_ok_token) 8443 user_ok_token: share PROFILES is ok for unix user BROCKLEY-2016\testing11 8444 [2016/07/28 11:27:21.103138, 10, pid=24487, effective(0, 0), real(0, 0)] ../source3/smbd/share_access.c:284(is_share_read_only_for_token) 8445 is_share_read_only_for_user: share PROFILES is read-write for unix user BROCKLEY-2016\testing11 8446 [2016/07/28 11:27:21.103198, 10, pid=24487, effective(0, 0), real(0, 0)] ../libcli/security/access_check.c:337(se_file_access_check) 8447 se_file_access_check: MAX desired = 0x2000000 mapped to 0x1f01ff 8448 [2016/07/28 11:27:21.103283, 4, pid=24487, effective(0, 0), real(0, 0)] ../source3/smbd/sec_ctx.c:321(set_sec_ctx_internal) 8449 setting sec ctx (3000032, 20) - sec_ctx_stack_ndx = 0 8450 [2016/07/28 11:27:21.103313, 5, pid=24487, effective(0, 0), real(0, 0)] ../libcli/security/security_token.c:63(security_token_debug) 8451 Security token SIDs (8): 8452 SID[ 0]: S-1-5-21-3097595537-1381657445-2473589930-1123 8453 SID[ 1]: S-1-5-21-3097595537-1381657445-2473589930-513 8454 SID[ 2]: S-1-5-21-3097595537-1381657445-2473589930-1104 8455 SID[ 3]: S-1-1-0 8456 SID[ 4]: S-1-5-2 8457 SID[ 5]: S-1-5-11 8458 SID[ 6]: S-1-5-32-545 8459 SID[ 7]: S-1-5-32-554 8460 Privileges (0x 800000): 8461 Privilege[ 0]: SeChangeNotifyPrivilege 8462 Rights (0x 400): 8463 Right[ 0]: SeRemoteInteractiveLogonRight 8464 [2016/07/28 11:27:21.103416, 5, pid=24487, effective(0, 0), real(0, 0)] ../source3/auth/token_util.c:639(debug_unix_user_token) 8465 UNIX token of user 3000032 8466 Primary group is 20 and contains 8 supplementary groups 8467 Group[ 0]: 3000032 8468 Group[ 1]: 20 8469 Group[ 2]: 10000 8470 Group[ 3]: 3000013 8471 Group[ 4]: 3000014 8472 Group[ 5]: 3000003 8473 Group[ 6]: 3000009 8474 Group[ 7]: 3000016 8475 [2016/07/28 11:27:21.103507, 5, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/uid.c:363(change_to_user_internal) 8476 Impersonated user: uid=(0,3000032), gid=(0,20) 8477 [2016/07/28 11:27:21.103535, 4, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/sec_ctx.c:321(set_sec_ctx_internal) 8478 setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 8479 [2016/07/28 11:27:21.103557, 5, pid=24487, effective(3000032, 20), real(0, 0)] ../libcli/security/security_token.c:53(security_token_debug) 8480 Security token: (NULL) 8481 [2016/07/28 11:27:21.103577, 5, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/auth/token_util.c:639(debug_unix_user_token) 8482 UNIX token of user 0 8483 Primary group is 0 and contains 0 supplementary groups 8484 [2016/07/28 11:27:21.103615, 5, pid=24487, effective(0, 0), real(0, 0)] ../source3/smbd/uid.c:425(smbd_change_to_root_user) 8485 change_to_root_user: now uid=(0,0) gid=(0,0) 8486 [2016/07/28 11:27:21.103672, 10, pid=24487, effective(0, 0), real(0, 0)] ../source3/smbd/service.c:164(set_conn_connectpath) 8487 set_conn_connectpath: service PROFILES, connectpath = /var/samba4/BROCKLEY-2016/PROFILES 8488 [2016/07/28 11:27:21.103739, 10, pid=24487, effective(0, 0), real(0, 0), class=vfs] ../source3/modules/vfs_default.c:166(vfswrap_fs_capabilities) 8489 vfswrap_fs_capabilities: timestamp resolution of msec available on share PROFILES, directory /var/samba4/BROCKLEY-2016/PROFILES 8490 [2016/07/28 11:27:21.103770, 2, pid=24487, effective(0, 0), real(0, 0)] ../source3/smbd/service.c:872(make_connection_snum) 8491 216.185.71.63 (ipv4:216.185.71.63:64359) connect to service PROFILES initially as user BROCKLEY-2016\testing11 (uid=3000032, gid=20) (pid 24487) 8492 [2016/07/28 11:27:21.103806, 5, pid=24487, effective(0, 0), real(0, 0)] ../lib/dbwrap/dbwrap.c:178(dbwrap_check_lock_order) 8493 check lock order 1 for /var/db/samba4/smbXsrv_tcon_global.tdb 8494 [2016/07/28 11:27:21.103829, 10, pid=24487, effective(0, 0), real(0, 0)] ../lib/dbwrap/dbwrap.c:133(debug_lock_order) 8495 lock order: 1:/var/db/samba4/smbXsrv_tcon_global.tdb 2: 3: 8496 [2016/07/28 11:27:21.103853, 10, pid=24487, effective(0, 0), real(0, 0)] ../lib/dbwrap/dbwrap_tdb.c:59(db_tdb_log_key) 8497 Locking key 7A755D35 8498 [2016/07/28 11:27:21.103880, 10, pid=24487, effective(0, 0), real(0, 0)] ../lib/dbwrap/dbwrap_tdb.c:143(db_tdb_fetch_locked_internal) 8499 Allocated locked data 0x0x81deda360 8500 [2016/07/28 11:27:21.103913, 10, pid=24487, effective(0, 0), real(0, 0)] ../source3/smbd/smbXsrv_tcon.c:678(smbXsrv_tcon_global_store) 8501 [2016/07/28 11:27:21.103931, 10, pid=24487, effective(0, 0), real(0, 0)] ../source3/smbd/smbXsrv_tcon.c:680(smbXsrv_tcon_global_store) 8502 smbXsrv_tcon_global_store: key '7A755D35' stored 8503 [2016/07/28 11:27:21.103954, 1, pid=24487, effective(0, 0), real(0, 0)] ../librpc/ndr/ndr.c:402(ndr_print_debug) 8504 &global_blob: struct smbXsrv_tcon_globalB 8505 version : SMBXSRV_VERSION_0 (0) 8506 seqnum : 0x00000002 (2) 8507 info : union smbXsrv_tcon_globalU(case 0) 8508 info0 : * 8509 info0: struct smbXsrv_tcon_global0 8510 db_rec : * 8511 tcon_global_id : 0x7a755d35 (2054511925) 8512 tcon_wire_id : 0x7a755d35 (2054511925) 8513 server_id: struct server_id 8514 pid : 0x0000000000005fa7 (24487) 8515 task_id : 0x00000000 (0) 8516 vnn : 0xffffffff (4294967295) 8517 unique_id : 0x23f6f22e9d89b472 (2591524917623764082) 8518 creation_time : Thu Jul 28 11:27:21 2016 EDT 8519 share_name : 'PROFILES' 8520 encryption_required : 0x00 (0) 8521 session_global_id : 0xb9b1c66f (3115435631) 8522 [2016/07/28 11:27:21.104141, 10, pid=24487, effective(0, 0), real(0, 0)] ../lib/dbwrap/dbwrap_tdb.c:59(db_tdb_log_key) 8523 Unlocking key 7A755D35 8524 [2016/07/28 11:27:21.104167, 5, pid=24487, effective(0, 0), real(0, 0)] ../lib/dbwrap/dbwrap.c:146(dbwrap_lock_order_state_destructor) 8525 release lock order 1 for /var/db/samba4/smbXsrv_tcon_global.tdb 8526 [2016/07/28 11:27:21.104192, 10, pid=24487, effective(0, 0), real(0, 0)] ../lib/dbwrap/dbwrap.c:133(debug_lock_order) 8527 lock order: 1: 2: 3: 8528 [2016/07/28 11:27:21.104215, 10, pid=24487, effective(0, 0), real(0, 0)] ../source3/smbd/smbXsrv_tcon.c:856(smbXsrv_tcon_update) 8529 [2016/07/28 11:27:21.104231, 10, pid=24487, effective(0, 0), real(0, 0)] ../source3/smbd/smbXsrv_tcon.c:864(smbXsrv_tcon_update) 8530 smbXsrv_tcon_update: global_id (0x7a755d35) stored 8531 [2016/07/28 11:27:21.104251, 1, pid=24487, effective(0, 0), real(0, 0)] ../librpc/ndr/ndr.c:402(ndr_print_debug) 8532 &tcon_blob: struct smbXsrv_tconB 8533 version : SMBXSRV_VERSION_0 (0) 8534 reserved : 0x00000000 (0) 8535 info : union smbXsrv_tconU(case 0) 8536 info0 : * 8537 info0: struct smbXsrv_tcon 8538 table : * 8539 db_rec : NULL 8540 local_id : 0x7a755d35 (2054511925) 8541 global : * 8542 global: struct smbXsrv_tcon_global0 8543 db_rec : NULL 8544 tcon_global_id : 0x7a755d35 (2054511925) 8545 tcon_wire_id : 0x7a755d35 (2054511925) 8546 server_id: struct server_id 8547 pid : 0x0000000000005fa7 (24487) 8548 task_id : 0x00000000 (0) 8549 vnn : 0xffffffff (4294967295) 8550 unique_id : 0x23f6f22e9d89b472 (2591524917623764082) 8551 creation_time : Thu Jul 28 11:27:21 2016 EDT 8552 share_name : 'PROFILES' 8553 encryption_required : 0x00 (0) 8554 session_global_id : 0xb9b1c66f (3115435631) 8555 status : NT_STATUS_OK 8556 idle_time : Thu Jul 28 11:27:21 2016 EDT 8557 compat : * 8558 encryption_desired : 0x00 (0) 8559 [2016/07/28 11:27:21.104482, 10, pid=24487, effective(0, 0), real(0, 0)] ../source3/smbd/smb2_server.c:2680(smbd_smb2_request_done_ex) 8560 smbd_smb2_request_done_ex: idx[1] status[NT_STATUS_OK] body[16] dyn[no:0] at ../source3/smbd/smb2_tcon.c:170 8561 [2016/07/28 11:27:21.104508, 10, pid=24487, effective(0, 0), real(0, 0)] ../source3/smbd/smb2_server.c:906(smb2_set_operation_credit) 8562 smb2_set_operation_credit: requested 1, charge 1, granted 1, current possible/max 482/512, total granted/max/low/range 31/8192/13/31 8563 [2016/07/28 11:27:21.104544, 5, pid=24487, effective(0, 0), real(0, 0)] ../libcli/smb/smb2_signing.c:92(smb2_signing_sign_pdu) 8564 signed SMB2 message 8565 [2016/07/28 11:27:21.106116, 10, pid=24487, effective(0, 0), real(0, 0)] ../source3/smbd/smb2_server.c:3539(smbd_smb2_io_handler) 8566 smbd_smb2_request idx[1] of 5 vectors 8567 [2016/07/28 11:27:21.106146, 10, pid=24487, effective(0, 0), real(0, 0)] ../source3/smbd/smb2_server.c:654(smb2_validate_sequence_number) 8568 smb2_validate_sequence_number: clearing id 13 (position 13) from bitmap 8569 [2016/07/28 11:27:21.106169, 10, pid=24487, effective(0, 0), real(0, 0)] ../source3/smbd/smb2_server.c:2018(smbd_smb2_request_dispatch) 8570 smbd_smb2_request_dispatch: opcode[SMB2_OP_CREATE] mid = 13 8571 [2016/07/28 11:27:21.106217, 4, pid=24487, effective(0, 0), real(0, 0)] ../source3/smbd/sec_ctx.c:321(set_sec_ctx_internal) 8572 setting sec ctx (3000032, 20) - sec_ctx_stack_ndx = 0 8573 [2016/07/28 11:27:21.106252, 5, pid=24487, effective(0, 0), real(0, 0)] ../libcli/security/security_token.c:63(security_token_debug) 8574 Security token SIDs (8): 8575 SID[ 0]: S-1-5-21-3097595537-1381657445-2473589930-1123 8576 SID[ 1]: S-1-5-21-3097595537-1381657445-2473589930-513 8577 SID[ 2]: S-1-5-21-3097595537-1381657445-2473589930-1104 8578 SID[ 3]: S-1-1-0 8579 SID[ 4]: S-1-5-2 8580 SID[ 5]: S-1-5-11 8581 SID[ 6]: S-1-5-32-545 8582 SID[ 7]: S-1-5-32-554 8583 Privileges (0x 800000): 8584 Privilege[ 0]: SeChangeNotifyPrivilege 8585 Rights (0x 400): 8586 Right[ 0]: SeRemoteInteractiveLogonRight 8587 [2016/07/28 11:27:21.106356, 5, pid=24487, effective(0, 0), real(0, 0)] ../source3/auth/token_util.c:639(debug_unix_user_token) 8588 UNIX token of user 3000032 8589 Primary group is 20 and contains 8 supplementary groups 8590 Group[ 0]: 3000032 8591 Group[ 1]: 20 8592 Group[ 2]: 10000 8593 Group[ 3]: 3000013 8594 Group[ 4]: 3000014 8595 Group[ 5]: 3000003 8596 Group[ 6]: 3000009 8597 Group[ 7]: 3000016 8598 [2016/07/28 11:27:21.106436, 5, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/uid.c:363(change_to_user_internal) 8599 Impersonated user: uid=(0,3000032), gid=(0,20) 8600 [2016/07/28 11:27:21.106462, 4, pid=24487, effective(3000032, 20), real(0, 0), class=vfs] ../source3/smbd/vfs.c:844(vfs_ChDir) 8601 vfs_ChDir to /var/samba4/BROCKLEY-2016/PROFILES 8602 [2016/07/28 11:27:21.106521, 4, pid=24487, effective(3000032, 20), real(0, 0), class=vfs] ../source3/smbd/vfs.c:855(vfs_ChDir) 8603 vfs_ChDir got /var/samba4/BROCKLEY-2016/PROFILES 8604 [2016/07/28 11:27:21.106566, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/smb2_create.c:501(smbd_smb2_create_send) 8605 smbd_smb2_create: name[testing11.V2] 8606 [2016/07/28 11:27:21.106595, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/smb2_create.c:917(smbd_smb2_create_send) 8607 smbd_smb2_create_send: open execution phase 8608 [2016/07/28 11:27:21.106622, 5, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/filename.c:257(unix_convert) 8609 unix_convert called on file "testing11.V2" 8610 [2016/07/28 11:27:21.106649, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/statcache.c:244(stat_cache_lookup) 8611 stat_cache_lookup: lookup failed for name [TESTING11.V2] 8612 [2016/07/28 11:27:21.106673, 5, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/filename.c:449(unix_convert) 8613 unix_convert begin: name = testing11.V2, dirpath = , start = testing11.V2 8614 [2016/07/28 11:27:21.106711, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/mangle_hash2.c:418(is_mangled) 8615 is_mangled testing11.V2 ? 8616 [2016/07/28 11:27:21.106735, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/mangle_hash2.c:357(is_mangled_component) 8617 is_mangled_component testing11.V2 (len 12) ? 8618 [2016/07/28 11:27:21.106764, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/mangle_hash2.c:418(is_mangled) 8619 is_mangled testing11.V2 ? 8620 [2016/07/28 11:27:21.106786, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/mangle_hash2.c:357(is_mangled_component) 8621 is_mangled_component testing11.V2 (len 12) ? 8622 [2016/07/28 11:27:21.106850, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/mangle_hash2.c:418(is_mangled) 8623 is_mangled testing11.V2 ? 8624 [2016/07/28 11:27:21.106874, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/mangle_hash2.c:357(is_mangled_component) 8625 is_mangled_component testing11.V2 (len 12) ? 8626 [2016/07/28 11:27:21.106895, 5, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/filename.c:844(unix_convert) 8627 New file testing11.V2 8628 [2016/07/28 11:27:21.106917, 10, pid=24487, effective(3000032, 20), real(0, 0), class=vfs] ../source3/smbd/vfs.c:1160(check_reduced_name) 8629 check_reduced_name [testing11.V2] [/var/samba4/BROCKLEY-2016/PROFILES] 8630 [2016/07/28 11:27:21.107000, 10, pid=24487, effective(3000032, 20), real(0, 0), class=vfs] ../source3/smbd/vfs.c:1220(check_reduced_name) 8631 check_reduced_name realpath [testing11.V2] -> [/var/samba4/BROCKLEY-2016/PROFILES/testing11.V2] 8632 [2016/07/28 11:27:21.107026, 5, pid=24487, effective(3000032, 20), real(0, 0), class=vfs] ../source3/smbd/vfs.c:1307(check_reduced_name) 8633 testing11.V2 reduced to /var/samba4/BROCKLEY-2016/PROFILES/testing11.V2 8634 [2016/07/28 11:27:21.107050, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/open.c:4983(create_file_default) 8635 create_file: access_mask = 0x80 file_attributes = 0x0, share_access = 0x7, create_disposition = 0x1 create_options = 0x200000 oplock_request = 0x0 private_flags = 0x0 root_dir_fid = 0x0, ea_list = 0x0x0, sd = 0x0x0, fname = testing11.V2 8636 [2016/07/28 11:27:21.107080, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/open.c:4460(create_file_unixpath) 8637 create_file_unixpath: access_mask = 0x80 file_attributes = 0x0, share_access = 0x7, create_disposition = 0x1 create_options = 0x200000 oplock_request = 0x0 private_flags = 0x0 ea_list = 0x0x0, sd = 0x0x0, fname = testing11.V2 8638 [2016/07/28 11:27:21.107118, 5, pid=24487, effective(3000032, 20), real(0, 0)] ../lib/dbwrap/dbwrap.c:178(dbwrap_check_lock_order) 8639 check lock order 1 for /var/db/samba4/smbXsrv_open_global.tdb 8640 [2016/07/28 11:27:21.107141, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../lib/dbwrap/dbwrap.c:133(debug_lock_order) 8641 lock order: 1:/var/db/samba4/smbXsrv_open_global.tdb 2: 3: 8642 [2016/07/28 11:27:21.107165, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../lib/dbwrap/dbwrap_tdb.c:59(db_tdb_log_key) 8643 Locking key 15B91035 8644 [2016/07/28 11:27:21.107196, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../lib/dbwrap/dbwrap_tdb.c:143(db_tdb_fetch_locked_internal) 8645 Allocated locked data 0x0x81e31eea0 8646 [2016/07/28 11:27:21.107219, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/smbXsrv_open.c:587(smbXsrv_open_global_verify_record) 8647 smbXsrv_open_global_verify_record: empty value 8648 [2016/07/28 11:27:21.107265, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/smbXsrv_open.c:706(smbXsrv_open_global_store) 8649 smbXsrv_open_global_store: key '15B91035' stored 8650 [2016/07/28 11:27:21.107292, 1, pid=24487, effective(3000032, 20), real(0, 0)] ../librpc/ndr/ndr.c:402(ndr_print_debug) 8651 &global_blob: struct smbXsrv_open_globalB 8652 version : SMBXSRV_VERSION_0 (0) 8653 seqnum : 0x00000001 (1) 8654 info : union smbXsrv_open_globalU(case 0) 8655 info0 : * 8656 info0: struct smbXsrv_open_global0 8657 db_rec : * 8658 server_id: struct server_id 8659 pid : 0x0000000000005fa7 (24487) 8660 task_id : 0x00000000 (0) 8661 vnn : 0xffffffff (4294967295) 8662 unique_id : 0x23f6f22e9d89b472 (2591524917623764082) 8663 open_global_id : 0x15b91035 (364449845) 8664 open_persistent_id : 0x0000000015b91035 (364449845) 8665 open_volatile_id : 0x00000000124d68e6 (307063014) 8666 open_owner : S-1-5-21-3097595537-1381657445-2473589930-1123 8667 open_time : Thu Jul 28 11:27:21 2016 EDT 8668 create_guid : 00000000-0000-0000-0000-000000000000 8669 client_guid : 06e6655c-5335-11e6-9232-001bd31bbdc8 8670 app_instance_id : 00000000-0000-0000-0000-000000000000 8671 disconnect_time : NTTIME(0) 8672 durable_timeout_msec : 0x00000000 (0) 8673 durable : 0x00 (0) 8674 backend_cookie : DATA_BLOB length=0 8675 [2016/07/28 11:27:21.107503, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../lib/dbwrap/dbwrap_tdb.c:59(db_tdb_log_key) 8676 Unlocking key 15B91035 8677 [2016/07/28 11:27:21.107529, 5, pid=24487, effective(3000032, 20), real(0, 0)] ../lib/dbwrap/dbwrap.c:146(dbwrap_lock_order_state_destructor) 8678 release lock order 1 for /var/db/samba4/smbXsrv_open_global.tdb 8679 [2016/07/28 11:27:21.107550, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../lib/dbwrap/dbwrap.c:133(debug_lock_order) 8680 lock order: 1: 2: 3: 8681 [2016/07/28 11:27:21.107573, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/smbXsrv_open.c:880(smbXsrv_open_create) 8682 smbXsrv_open_create: global_id (0x15b91035) stored 8683 [2016/07/28 11:27:21.107593, 1, pid=24487, effective(3000032, 20), real(0, 0)] ../librpc/ndr/ndr.c:402(ndr_print_debug) 8684 &open_blob: struct smbXsrv_openB 8685 version : SMBXSRV_VERSION_0 (0) 8686 reserved : 0x00000000 (0) 8687 info : union smbXsrv_openU(case 0) 8688 info0 : * 8689 info0: struct smbXsrv_open 8690 table : * 8691 db_rec : NULL 8692 local_id : 0x124d68e6 (307063014) 8693 global : * 8694 global: struct smbXsrv_open_global0 8695 db_rec : NULL 8696 server_id: struct server_id 8697 pid : 0x0000000000005fa7 (24487) 8698 task_id : 0x00000000 (0) 8699 vnn : 0xffffffff (4294967295) 8700 unique_id : 0x23f6f22e9d89b472 (2591524917623764082) 8701 open_global_id : 0x15b91035 (364449845) 8702 open_persistent_id : 0x0000000015b91035 (364449845) 8703 open_volatile_id : 0x00000000124d68e6 (307063014) 8704 open_owner : S-1-5-21-3097595537-1381657445-2473589930-1123 8705 open_time : Thu Jul 28 11:27:21 2016 EDT 8706 create_guid : 00000000-0000-0000-0000-000000000000 8707 client_guid : 06e6655c-5335-11e6-9232-001bd31bbdc8 8708 app_instance_id : 00000000-0000-0000-0000-000000000000 8709 disconnect_time : NTTIME(0) 8710 durable_timeout_msec : 0x00000000 (0) 8711 durable : 0x00 (0) 8712 backend_cookie : DATA_BLOB length=0 8713 status : NT_STATUS_OK 8714 idle_time : Thu Jul 28 11:27:21 2016 EDT 8715 compat : NULL 8716 [2016/07/28 11:27:21.107891, 5, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/files.c:128(file_new) 8717 allocated file structure fnum 307063014 (1 used) 8718 [2016/07/28 11:27:21.107918, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/files.c:745(file_name_hash) 8719 file_name_hash: /var/samba4/BROCKLEY-2016/PROFILES/testing11.V2 hash 0xe5e1676d 8720 [2016/07/28 11:27:21.107946, 5, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/dosmode.c:196(unix_mode) 8721 unix_mode(testing11.V2) returning 0644 8722 [2016/07/28 11:27:21.107994, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/open.c:2479(open_file_ntcreate) 8723 open_file_ntcreate: fname=testing11.V2, dos_attrs=0x0 access_mask=0x80 share_access=0x7 create_disposition = 0x1 create_options=0x200000 unix mode=0644 oplock_request=0 private_flags = 0x0 8724 [2016/07/28 11:27:21.108025, 5, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/open.c:2550(open_file_ntcreate) 8725 open_file_ntcreate: FILE_OPEN requested for file testing11.V2 and file doesn't exist. 8726 [2016/07/28 11:27:21.108050, 5, pid=24487, effective(3000032, 20), real(0, 0)] ../lib/dbwrap/dbwrap.c:178(dbwrap_check_lock_order) 8727 check lock order 1 for /var/db/samba4/smbXsrv_open_global.tdb 8728 [2016/07/28 11:27:21.108071, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../lib/dbwrap/dbwrap.c:133(debug_lock_order) 8729 lock order: 1:/var/db/samba4/smbXsrv_open_global.tdb 2: 3: 8730 [2016/07/28 11:27:21.108096, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../lib/dbwrap/dbwrap_tdb.c:59(db_tdb_log_key) 8731 Locking key 15B91035 8732 [2016/07/28 11:27:21.108122, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../lib/dbwrap/dbwrap_tdb.c:143(db_tdb_fetch_locked_internal) 8733 Allocated locked data 0x0x813c89860 8734 [2016/07/28 11:27:21.108153, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../lib/dbwrap/dbwrap_tdb.c:59(db_tdb_log_key) 8735 Unlocking key 15B91035 8736 [2016/07/28 11:27:21.108177, 5, pid=24487, effective(3000032, 20), real(0, 0)] ../lib/dbwrap/dbwrap.c:146(dbwrap_lock_order_state_destructor) 8737 release lock order 1 for /var/db/samba4/smbXsrv_open_global.tdb 8738 [2016/07/28 11:27:21.108201, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../lib/dbwrap/dbwrap.c:133(debug_lock_order) 8739 lock order: 1: 2: 3: 8740 [2016/07/28 11:27:21.108228, 5, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/files.c:554(file_free) 8741 freed files structure 307063014 (0 used) 8742 [2016/07/28 11:27:21.108251, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/open.c:4804(create_file_unixpath) 8743 create_file_unixpath: NT_STATUS_OBJECT_NAME_NOT_FOUND 8744 [2016/07/28 11:27:21.108272, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/open.c:5080(create_file_default) 8745 create_file: NT_STATUS_OBJECT_NAME_NOT_FOUND 8746 [2016/07/28 11:27:21.108298, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/smb2_server.c:2789(smbd_smb2_request_error_ex) 8747 smbd_smb2_request_error_ex: idx[1] status[NT_STATUS_OBJECT_NAME_NOT_FOUND] || at ../source3/smbd/smb2_create.c:293 8748 [2016/07/28 11:27:21.108322, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/smb2_server.c:2680(smbd_smb2_request_done_ex) 8749 smbd_smb2_request_done_ex: idx[1] status[NT_STATUS_OBJECT_NAME_NOT_FOUND] body[8] dyn[yes:1] at ../source3/smbd/smb2_server.c:2837 8750 [2016/07/28 11:27:21.108347, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/smb2_server.c:906(smb2_set_operation_credit) 8751 smb2_set_operation_credit: requested 1, charge 1, granted 1, current possible/max 482/512, total granted/max/low/range 31/8192/14/31 8752 [2016/07/28 11:27:21.108382, 5, pid=24487, effective(3000032, 20), real(0, 0)] ../libcli/smb/smb2_signing.c:92(smb2_signing_sign_pdu) 8753 signed SMB2 message 8754 [2016/07/28 11:27:21.113440, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/smb2_server.c:3539(smbd_smb2_io_handler) 8755 smbd_smb2_request idx[1] of 5 vectors 8756 [2016/07/28 11:27:21.113469, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/smb2_server.c:654(smb2_validate_sequence_number) 8757 smb2_validate_sequence_number: clearing id 14 (position 14) from bitmap 8758 [2016/07/28 11:27:21.113492, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/smb2_server.c:2018(smbd_smb2_request_dispatch) 8759 smbd_smb2_request_dispatch: opcode[SMB2_OP_CREATE] mid = 14 8760 [2016/07/28 11:27:21.113536, 4, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/uid.c:384(change_to_user) 8761 Skipping user change - already user 8762 [2016/07/28 11:27:21.113577, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/smb2_create.c:501(smbd_smb2_create_send) 8763 smbd_smb2_create: name[testing11.V2] 8764 [2016/07/28 11:27:21.113615, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/smb2_create.c:917(smbd_smb2_create_send) 8765 smbd_smb2_create_send: open execution phase 8766 [2016/07/28 11:27:21.113641, 5, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/filename.c:257(unix_convert) 8767 unix_convert called on file "testing11.V2" 8768 [2016/07/28 11:27:21.113668, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/statcache.c:244(stat_cache_lookup) 8769 stat_cache_lookup: lookup failed for name [TESTING11.V2] 8770 [2016/07/28 11:27:21.113691, 5, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/filename.c:449(unix_convert) 8771 unix_convert begin: name = testing11.V2, dirpath = , start = testing11.V2 8772 [2016/07/28 11:27:21.113725, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/mangle_hash2.c:418(is_mangled) 8773 is_mangled testing11.V2 ? 8774 [2016/07/28 11:27:21.113748, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/mangle_hash2.c:357(is_mangled_component) 8775 is_mangled_component testing11.V2 (len 12) ? 8776 [2016/07/28 11:27:21.113776, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/mangle_hash2.c:418(is_mangled) 8777 is_mangled testing11.V2 ? 8778 [2016/07/28 11:27:21.113798, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/mangle_hash2.c:357(is_mangled_component) 8779 is_mangled_component testing11.V2 (len 12) ? 8780 [2016/07/28 11:27:21.113854, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/mangle_hash2.c:418(is_mangled) 8781 is_mangled testing11.V2 ? 8782 [2016/07/28 11:27:21.113879, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/mangle_hash2.c:357(is_mangled_component) 8783 is_mangled_component testing11.V2 (len 12) ? 8784 [2016/07/28 11:27:21.113899, 5, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/filename.c:844(unix_convert) 8785 New file testing11.V2 8786 [2016/07/28 11:27:21.113921, 10, pid=24487, effective(3000032, 20), real(0, 0), class=vfs] ../source3/smbd/vfs.c:1160(check_reduced_name) 8787 check_reduced_name [testing11.V2] [/var/samba4/BROCKLEY-2016/PROFILES] 8788 [2016/07/28 11:27:21.113996, 10, pid=24487, effective(3000032, 20), real(0, 0), class=vfs] ../source3/smbd/vfs.c:1220(check_reduced_name) 8789 check_reduced_name realpath [testing11.V2] -> [/var/samba4/BROCKLEY-2016/PROFILES/testing11.V2] 8790 [2016/07/28 11:27:21.114022, 5, pid=24487, effective(3000032, 20), real(0, 0), class=vfs] ../source3/smbd/vfs.c:1307(check_reduced_name) 8791 testing11.V2 reduced to /var/samba4/BROCKLEY-2016/PROFILES/testing11.V2 8792 [2016/07/28 11:27:21.114044, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/open.c:4983(create_file_default) 8793 create_file: access_mask = 0x100081 file_attributes = 0x80, share_access = 0x3, create_disposition = 0x2 create_options = 0x200001 oplock_request = 0x0 private_flags = 0x0 root_dir_fid = 0x0, ea_list = 0x0x0, sd = 0x0x81e3e28a0, fname = testing11.V2 8794 [2016/07/28 11:27:21.114072, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/open.c:4460(create_file_unixpath) 8795 create_file_unixpath: access_mask = 0x100081 file_attributes = 0x80, share_access = 0x3, create_disposition = 0x2 create_options = 0x200001 oplock_request = 0x0 private_flags = 0x0 ea_list = 0x0x0, sd = 0x0x81e3e28a0, fname = testing11.V2 8796 [2016/07/28 11:27:21.114098, 5, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/open.c:3407(open_directory) 8797 open_directory: opening directory testing11.V2, access_mask = 0x100081, share_access = 0x3 create_options = 0x200001, create_disposition = 0x2, file_attributes = 0x90 8798 [2016/07/28 11:27:21.114126, 5, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/dosmode.c:196(unix_mode) 8799 unix_mode(testing11.V2) returning 0755 8800 [2016/07/28 11:27:21.114156, 10, pid=24487, effective(3000032, 20), real(0, 0), class=vfs] ../source3/modules/vfs_acl_common.c:394(get_nt_acl_internal) 8801 get_nt_acl_internal: name=. 8802 [2016/07/28 11:27:21.114180, 4, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/sec_ctx.c:217(push_sec_ctx) 8803 push_sec_ctx(3000032, 20) : sec_ctx_stack_ndx = 1 8804 [2016/07/28 11:27:21.114208, 4, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/uid.c:491(push_conn_ctx) 8805 push_conn_ctx(3115435631) : conn_ctx_stack_ndx = 0 8806 [2016/07/28 11:27:21.114230, 4, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/sec_ctx.c:321(set_sec_ctx_internal) 8807 setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 8808 [2016/07/28 11:27:21.114251, 5, pid=24487, effective(3000032, 20), real(0, 0)] ../libcli/security/security_token.c:53(security_token_debug) 8809 Security token: (NULL) 8810 [2016/07/28 11:27:21.114270, 5, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/auth/token_util.c:639(debug_unix_user_token) 8811 UNIX token of user 0 8812 Primary group is 0 and contains 0 supplementary groups 8813 [2016/07/28 11:27:21.114341, 4, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/sec_ctx.c:439(pop_sec_ctx) 8814 pop_sec_ctx (3000032, 20) - sec_ctx_stack_ndx = 0 8815 [2016/07/28 11:27:21.114851, 10, pid=24487, effective(3000032, 20), real(0, 0), class=vfs] ../source3/modules/vfs_acl_common.c:494(get_nt_acl_internal) 8816 get_nt_acl_internal: blob hash matches for file . 8817 [2016/07/28 11:27:21.114881, 10, pid=24487, effective(3000032, 20), real(0, 0), class=vfs] ../source3/modules/vfs_acl_common.c:701(get_nt_acl_internal) 8818 get_nt_acl_internal: returning acl for . is: 8819 [2016/07/28 11:27:21.114902, 1, pid=24487, effective(3000032, 20), real(0, 0)] ../librpc/ndr/ndr.c:402(ndr_print_debug) 8820 psd: struct security_descriptor 8821 revision : SECURITY_DESCRIPTOR_REVISION_1 (1) 8822 type : 0x9c04 (39940) 8823 0: SEC_DESC_OWNER_DEFAULTED 8824 0: SEC_DESC_GROUP_DEFAULTED 8825 1: SEC_DESC_DACL_PRESENT 8826 0: SEC_DESC_DACL_DEFAULTED 8827 0: SEC_DESC_SACL_PRESENT 8828 0: SEC_DESC_SACL_DEFAULTED 8829 0: SEC_DESC_DACL_TRUSTED 8830 0: SEC_DESC_SERVER_SECURITY 8831 0: SEC_DESC_DACL_AUTO_INHERIT_REQ 8832 0: SEC_DESC_SACL_AUTO_INHERIT_REQ 8833 1: SEC_DESC_DACL_AUTO_INHERITED 8834 1: SEC_DESC_SACL_AUTO_INHERITED 8835 1: SEC_DESC_DACL_PROTECTED 8836 0: SEC_DESC_SACL_PROTECTED 8837 0: SEC_DESC_RM_CONTROL_VALID 8838 1: SEC_DESC_SELF_RELATIVE 8839 owner_sid : NULL 8840 group_sid : NULL 8841 sacl : NULL 8842 dacl : * 8843 dacl: struct security_acl 8844 revision : SECURITY_ACL_REVISION_NT4 (2) 8845 size : 0x00b0 (176) 8846 num_aces : 0x00000006 (6) 8847 aces: ARRAY(6) 8848 aces: struct security_ace 8849 type : SEC_ACE_TYPE_ACCESS_ALLOWED (0) 8850 flags : 0x03 (3) 8851 1: SEC_ACE_FLAG_OBJECT_INHERIT 8852 1: SEC_ACE_FLAG_CONTAINER_INHERIT 8853 0: SEC_ACE_FLAG_NO_PROPAGATE_INHERIT 8854 0: SEC_ACE_FLAG_INHERIT_ONLY 8855 0: SEC_ACE_FLAG_INHERITED_ACE 8856 0x03: SEC_ACE_FLAG_VALID_INHERIT (3) 8857 0: SEC_ACE_FLAG_SUCCESSFUL_ACCESS 8858 0: SEC_ACE_FLAG_FAILED_ACCESS 8859 size : 0x0024 (36) 8860 access_mask : 0x001f01ff (2032127) 8861 object : union security_ace_object_ctr(case 0) 8862 trustee : S-1-5-21-3097595537-1381657445-2473589930-500 8863 aces: struct security_ace 8864 type : SEC_ACE_TYPE_ACCESS_ALLOWED (0) 8865 flags : 0x00 (0) 8866 0: SEC_ACE_FLAG_OBJECT_INHERIT 8867 0: SEC_ACE_FLAG_CONTAINER_INHERIT 8868 0: SEC_ACE_FLAG_NO_PROPAGATE_INHERIT 8869 0: SEC_ACE_FLAG_INHERIT_ONLY 8870 0: SEC_ACE_FLAG_INHERITED_ACE 8871 0x00: SEC_ACE_FLAG_VALID_INHERIT (0) 8872 0: SEC_ACE_FLAG_SUCCESSFUL_ACCESS 8873 0: SEC_ACE_FLAG_FAILED_ACCESS 8874 size : 0x0014 (20) 8875 access_mask : 0x001200a9 (1179817) 8876 object : union security_ace_object_ctr(case 0) 8877 trustee : S-1-5-11 8878 aces: struct security_ace 8879 type : SEC_ACE_TYPE_ACCESS_ALLOWED (0) 8880 flags : 0x03 (3) 8881 1: SEC_ACE_FLAG_OBJECT_INHERIT 8882 1: SEC_ACE_FLAG_CONTAINER_INHERIT 8883 0: SEC_ACE_FLAG_NO_PROPAGATE_INHERIT 8884 0: SEC_ACE_FLAG_INHERIT_ONLY 8885 0: SEC_ACE_FLAG_INHERITED_ACE 8886 0x03: SEC_ACE_FLAG_VALID_INHERIT (3) 8887 0: SEC_ACE_FLAG_SUCCESSFUL_ACCESS 8888 0: SEC_ACE_FLAG_FAILED_ACCESS 8889 size : 0x0024 (36) 8890 access_mask : 0x001f01ff (2032127) 8891 object : union security_ace_object_ctr(case 0) 8892 trustee : S-1-5-21-3097595537-1381657445-2473589930-512 8893 aces: struct security_ace 8894 type : SEC_ACE_TYPE_ACCESS_ALLOWED (0) 8895 flags : 0x00 (0) 8896 0: SEC_ACE_FLAG_OBJECT_INHERIT 8897 0: SEC_ACE_FLAG_CONTAINER_INHERIT 8898 0: SEC_ACE_FLAG_NO_PROPAGATE_INHERIT 8899 0: SEC_ACE_FLAG_INHERIT_ONLY 8900 0: SEC_ACE_FLAG_INHERITED_ACE 8901 0x00: SEC_ACE_FLAG_VALID_INHERIT (0) 8902 0: SEC_ACE_FLAG_SUCCESSFUL_ACCESS 8903 0: SEC_ACE_FLAG_FAILED_ACCESS 8904 size : 0x0024 (36) 8905 access_mask : 0x001200a9 (1179817) 8906 object : union security_ace_object_ctr(case 0) 8907 trustee : S-1-5-21-3097595537-1381657445-2473589930-513 8908 aces: struct security_ace 8909 type : SEC_ACE_TYPE_ACCESS_ALLOWED (0) 8910 flags : 0x0b (11) 8911 1: SEC_ACE_FLAG_OBJECT_INHERIT 8912 1: SEC_ACE_FLAG_CONTAINER_INHERIT 8913 0: SEC_ACE_FLAG_NO_PROPAGATE_INHERIT 8914 1: SEC_ACE_FLAG_INHERIT_ONLY 8915 0: SEC_ACE_FLAG_INHERITED_ACE 8916 0x0b: SEC_ACE_FLAG_VALID_INHERIT (11) 8917 0: SEC_ACE_FLAG_SUCCESSFUL_ACCESS 8918 0: SEC_ACE_FLAG_FAILED_ACCESS 8919 size : 0x0014 (20) 8920 access_mask : 0x001f01ff (2032127) 8921 object : union security_ace_object_ctr(case 0) 8922 trustee : S-1-3-0 8923 aces: struct security_ace 8924 type : SEC_ACE_TYPE_ACCESS_ALLOWED (0) 8925 flags : 0x03 (3) 8926 1: SEC_ACE_FLAG_OBJECT_INHERIT 8927 1: SEC_ACE_FLAG_CONTAINER_INHERIT 8928 0: SEC_ACE_FLAG_NO_PROPAGATE_INHERIT 8929 0: SEC_ACE_FLAG_INHERIT_ONLY 8930 0: SEC_ACE_FLAG_INHERITED_ACE 8931 0x03: SEC_ACE_FLAG_VALID_INHERIT (3) 8932 0: SEC_ACE_FLAG_SUCCESSFUL_ACCESS 8933 0: SEC_ACE_FLAG_FAILED_ACCESS 8934 size : 0x0014 (20) 8935 access_mask : 0x001f01ff (2032127) 8936 object : union security_ace_object_ctr(case 0) 8937 trustee : S-1-5-18 8938 [2016/07/28 11:27:21.115856, 5, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/open.c:300(check_parent_access) 8939 check_parent_access: access check on directory . for path testing11.V2 for mask 0x4 returned (0x4) NT_STATUS_ACCESS_DENIED 8940 [2016/07/28 11:27:21.115882, 5, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/open.c:3290(mkdir_internal) 8941 mkdir_internal: check_parent_access on directory . for path testing11.V2 returned NT_STATUS_ACCESS_DENIED 8942 [2016/07/28 11:27:21.115904, 2, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/open.c:3459(open_directory) 8943 open_directory: unable to create testing11.V2. Error was NT_STATUS_ACCESS_DENIED 8944 [2016/07/28 11:27:21.115927, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/open.c:4804(create_file_unixpath) 8945 create_file_unixpath: NT_STATUS_ACCESS_DENIED 8946 [2016/07/28 11:27:21.115948, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/open.c:5080(create_file_default) 8947 create_file: NT_STATUS_ACCESS_DENIED 8948 [2016/07/28 11:27:21.116000, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/smb2_server.c:2789(smbd_smb2_request_error_ex) 8949 smbd_smb2_request_error_ex: idx[1] status[NT_STATUS_ACCESS_DENIED] || at ../source3/smbd/smb2_create.c:293 8950 [2016/07/28 11:27:21.116025, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/smb2_server.c:2680(smbd_smb2_request_done_ex) 8951 smbd_smb2_request_done_ex: idx[1] status[NT_STATUS_ACCESS_DENIED] body[8] dyn[yes:1] at ../source3/smbd/smb2_server.c:2837 8952 [2016/07/28 11:27:21.116049, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/smb2_server.c:906(smb2_set_operation_credit) 8953 smb2_set_operation_credit: requested 1, charge 1, granted 1, current possible/max 482/512, total granted/max/low/range 31/8192/15/31 8954 [2016/07/28 11:27:21.116085, 5, pid=24487, effective(3000032, 20), real(0, 0)] ../libcli/smb/smb2_signing.c:92(smb2_signing_sign_pdu) 8955 signed SMB2 message 8956 [2016/07/28 11:27:21.358532, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/smb2_server.c:3539(smbd_smb2_io_handler) 8957 smbd_smb2_request idx[1] of 5 vectors 8958 [2016/07/28 11:27:21.358585, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/smb2_server.c:654(smb2_validate_sequence_number) 8959 smb2_validate_sequence_number: clearing id 15 (position 15) from bitmap 8960 [2016/07/28 11:27:21.358610, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/smb2_server.c:2018(smbd_smb2_request_dispatch) 8961 smbd_smb2_request_dispatch: opcode[SMB2_OP_IOCTL] mid = 15 8962 [2016/07/28 11:27:21.358666, 4, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/sec_ctx.c:321(set_sec_ctx_internal) 8963 setting sec ctx (3000032, 20) - sec_ctx_stack_ndx = 0 8964 [2016/07/28 11:27:21.358694, 5, pid=24487, effective(3000032, 20), real(0, 0)] ../libcli/security/security_token.c:63(security_token_debug) 8965 Security token SIDs (8): 8966 SID[ 0]: S-1-5-21-3097595537-1381657445-2473589930-1123 8967 SID[ 1]: S-1-5-21-3097595537-1381657445-2473589930-513 8968 SID[ 2]: S-1-5-21-3097595537-1381657445-2473589930-1104 8969 SID[ 3]: S-1-1-0 8970 SID[ 4]: S-1-5-2 8971 SID[ 5]: S-1-5-11 8972 SID[ 6]: S-1-5-32-545 8973 SID[ 7]: S-1-5-32-554 8974 Privileges (0x 800000): 8975 Privilege[ 0]: SeChangeNotifyPrivilege 8976 Rights (0x 400): 8977 Right[ 0]: SeRemoteInteractiveLogonRight 8978 [2016/07/28 11:27:21.358802, 5, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/auth/token_util.c:639(debug_unix_user_token) 8979 UNIX token of user 3000032 8980 Primary group is 20 and contains 8 supplementary groups 8981 Group[ 0]: 3000032 8982 Group[ 1]: 20 8983 Group[ 2]: 10000 8984 Group[ 3]: 3000013 8985 Group[ 4]: 3000014 8986 Group[ 5]: 3000003 8987 Group[ 6]: 3000009 8988 Group[ 7]: 3000016 8989 [2016/07/28 11:27:21.358899, 5, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/uid.c:363(change_to_user_internal) 8990 Impersonated user: uid=(0,3000032), gid=(0,20) 8991 [2016/07/28 11:27:21.358927, 4, pid=24487, effective(3000032, 20), real(0, 0), class=vfs] ../source3/smbd/vfs.c:844(vfs_ChDir) 8992 vfs_ChDir to /tmp 8993 [2016/07/28 11:27:21.359019, 4, pid=24487, effective(3000032, 20), real(0, 0), class=vfs] ../source3/smbd/vfs.c:855(vfs_ChDir) 8994 vfs_ChDir got /tmp 8995 [2016/07/28 11:27:21.359048, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/smb2_server.c:1908(smbd_smb2_request_verify_creditcharge) 8996 mid 15, CreditCharge: 1, NeededCharge: 1 8997 [2016/07/28 11:27:21.359072, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/smb2_ioctl.c:394(smbd_smb2_ioctl_send) 8998 smbd_smb2_ioctl: ctl_code[0x00060194] , fnum [fsp is NULL] 8999 [2016/07/28 11:27:21.359101, 8, pid=24487, effective(3000032, 20), real(0, 0), class=dfs_samba4] ../source3/modules/vfs_dfs_samba4.c:116(dfs_samba4_get_referrals) 9000 dfs_samba4: Requested DFS name: \SAMBA-01\NETLOGON utf16-length: 36 9001 [2016/07/28 11:27:21.359126, 8, pid=24487, effective(3000032, 20), real(0, 0)] ../dfs_server/dfs_server_ad.c:814(dfs_server_ad_get_referrals) 9002 Requested DFS name: \SAMBA-01\NETLOGON length: 36 9003 [2016/07/28 11:27:21.359152, 10, pid=24487, effective(3000032, 20), real(0, 0), class=vfs] ../source3/modules/vfs_default.c:184(vfswrap_get_dfs_referrals) 9004 [2016/07/28 11:27:21.359169, 1, pid=24487, effective(3000032, 20), real(0, 0)] ../librpc/ndr/ndr.c:439(ndr_print_function_debug) 9005 dfs_GetDFSReferral: struct dfs_GetDFSReferral 9006 in: struct dfs_GetDFSReferral 9007 req: struct dfs_GetDFSReferral_in 9008 max_referral_level : 0x0004 (4) 9009 servername : '\SAMBA-01\NETLOGON' 9010 [2016/07/28 11:27:21.359225, 10, pid=24487, effective(3000032, 20), real(0, 0), class=msdfs] ../source3/smbd/msdfs.c:116(parse_dfs_path) 9011 parse_dfs_path: temp = |SAMBA-01\NETLOGON| after trimming \'s 9012 [2016/07/28 11:27:21.359248, 10, pid=24487, effective(3000032, 20), real(0, 0), class=msdfs] ../source3/smbd/msdfs.c:141(parse_dfs_path) 9013 parse_dfs_path: hostname: SAMBA-01 9014 [2016/07/28 11:27:21.359270, 10, pid=24487, effective(3000032, 20), real(0, 0), class=msdfs] ../source3/smbd/msdfs.c:183(parse_dfs_path) 9015 parse_dfs_path: servicename: NETLOGON 9016 [2016/07/28 11:27:21.359303, 3, pid=24487, effective(3000032, 20), real(0, 0), class=msdfs] ../source3/smbd/msdfs.c:993(get_referred_path) 9017 get_referred_path: |NETLOGON| in dfs path \SAMBA-01\NETLOGON is not a dfs root. 9018 [2016/07/28 11:27:21.359332, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/smb2_ioctl.c:291(smbd_smb2_request_ioctl_done) 9019 smbd_smb2_request_ioctl_done: smbd_smb2_ioctl_recv returned 0 status NT_STATUS_NOT_FOUND 9020 [2016/07/28 11:27:21.359361, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/smb2_server.c:2789(smbd_smb2_request_error_ex) 9021 smbd_smb2_request_error_ex: idx[1] status[NT_STATUS_NOT_FOUND] || at ../source3/smbd/smb2_ioctl.c:309 9022 [2016/07/28 11:27:21.359386, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/smb2_server.c:2680(smbd_smb2_request_done_ex) 9023 smbd_smb2_request_done_ex: idx[1] status[NT_STATUS_NOT_FOUND] body[8] dyn[yes:1] at ../source3/smbd/smb2_server.c:2837 9024 [2016/07/28 11:27:21.359412, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/smb2_server.c:906(smb2_set_operation_credit) 9025 smb2_set_operation_credit: requested 1, charge 1, granted 1, current possible/max 482/512, total granted/max/low/range 31/8192/16/31 9026 [2016/07/28 11:27:21.359449, 5, pid=24487, effective(3000032, 20), real(0, 0)] ../libcli/smb/smb2_signing.c:92(smb2_signing_sign_pdu) 9027 signed SMB2 message 9028 [2016/07/28 11:27:21.365672, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/smb2_server.c:3539(smbd_smb2_io_handler) 9029 smbd_smb2_request idx[1] of 5 vectors 9030 [2016/07/28 11:27:21.365702, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/smb2_server.c:654(smb2_validate_sequence_number) 9031 smb2_validate_sequence_number: clearing id 16 (position 16) from bitmap 9032 [2016/07/28 11:27:21.365725, 10, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/smb2_server.c:2018(smbd_smb2_request_dispatch) 9033 smbd_smb2_request_dispatch: opcode[SMB2_OP_TCON] mid = 16 9034 [2016/07/28 11:27:21.365763, 4, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/smbd/sec_ctx.c:321(set_sec_ctx_internal) 9035 setting sec ctx (0, 0) - sec_ctx_stack_ndx = 0 9036 [2016/07/28 11:27:21.365785, 5, pid=24487, effective(3000032, 20), real(0, 0)] ../libcli/security/security_token.c:53(security_token_debug) 9037 Security token: (NULL) 9038 [2016/07/28 11:27:21.365805, 5, pid=24487, effective(3000032, 20), real(0, 0)] ../source3/auth/token_util.c:639(debug_unix_user_token) 9039 UNIX token of user 0 9040 Primary group is 0 and contains 0 supplementary groups 9041 [2016/07/28 11:27:21.365847, 5, pid=24487, effective(0, 0), real(0, 0)] ../source3/smbd/uid.c:425(smbd_change_to_root_user) 9042 change_to_root_user: now uid=(0,0) gid=(0,0) 9043 [2016/07/28 11:27:21.365884, 10, pid=24487, effective(0, 0), real(0, 0)] ../source3/smbd/smb2_tcon.c:211(smbd_smb2_tree_connect) 9044 smbd_smb2_tree_connect: path[\\SAMBA-01\NETLOGON] share[NETLOGON] 9045 [2016/07/28 11:27:21.365956, 5, pid=24487, effective(0, 0), real(0, 0)] ../lib/dbwrap/dbwrap.c:178(dbwrap_check_lock_order) 9046 check lock order 1 for /var/db/samba4/smbXsrv_tcon_global.tdb 9047 [2016/07/28 11:27:21.365982, 10, pid=24487, effective(0, 0), real(0, 0)] ../lib/dbwrap/dbwrap.c:133(debug_lock_order) 9048 lock order: 1:/var/db/samba4/smbXsrv_tcon_global.tdb 2: 3: 9049 [2016/07/28 11:27:21.366008, 10, pid=24487, effective(0, 0), real(0, 0)] ../lib/dbwrap/dbwrap_tdb.c:59(db_tdb_log_key) 9050 Locking key A7147965 9051 [2016/07/28 11:27:21.366041, 10, pid=24487, effective(0, 0), real(0, 0)] ../lib/dbwrap/dbwrap_tdb.c:143(db_tdb_fetch_locked_internal) 9052 Allocated locked data 0x0x81e31e660 9053 [2016/07/28 11:27:21.366094, 10, pid=24487, effective(0, 0), real(0, 0)] ../source3/smbd/smbXsrv_tcon.c:678(smbXsrv_tcon_global_store) 9054 [2016/07/28 11:27:21.366113, 10, pid=24487, effective(0, 0), real(0, 0)] ../source3/smbd/smbXsrv_tcon.c:680(smbXsrv_tcon_global_store) 9055 smbXsrv_tcon_global_store: key 'A7147965' stored 9056 [2016/07/28 11:27:21.366136, 1, pid=24487, effective(0, 0), real(0, 0)] ../librpc/ndr/ndr.c:402(ndr_print_debug) 9057 &global_blob: struct smbXsrv_tcon_globalB 9058 version : SMBXSRV_VERSION_0 (0) 9059 seqnum : 0x00000001 (1) 9060 info : union smbXsrv_tcon_globalU(case 0) 9061 info0 : * 9062 info0: struct smbXsrv_tcon_global0 9063 db_rec : * 9064 tcon_global_id : 0xa7147965 (2803136869) 9065 tcon_wire_id : 0xa7147965 (2803136869) 9066 server_id: struct server_id 9067 pid : 0x0000000000005fa7 (24487) 9068 task_id : 0x00000000 (0) 9069 vnn : 0xffffffff (4294967295) 9070 unique_id : 0x23f6f22e9d89b472 (2591524917623764082) 9071 creation_time : Thu Jul 28 11:27:21 2016 EDT 9072 share_name : NULL 9073 encryption_required : 0x00 (0) 9074 session_global_id : 0x00000000 (0) 9075 [2016/07/28 11:27:21.366300, 10, pid=24487, effective(0, 0), real(0, 0)] ../lib/dbwrap/dbwrap_tdb.c:59(db_tdb_log_key) 9076 Unlocking key A7147965 9077 [2016/07/28 11:27:21.366326, 5, pid=24487, effective(0, 0), real(0, 0)] ../lib/dbwrap/dbwrap.c:146(dbwrap_lock_order_state_destructor) 9078 release lock order 1 for /var/db/samba4/smbXsrv_tcon_global.tdb 9079 [2016/07/28 11:27:21.366350, 10, pid=24487, effective(0, 0), real(0, 0)] ../lib/dbwrap/dbwrap.c:133(debug_lock_order) 9080 lock order: 1: 2: 3: 9081 [2016/07/28 11:27:21.366373, 10, pid=24487, effective(0, 0), real(0, 0)] ../source3/smbd/smbXsrv_tcon.c:803(smbXsrv_tcon_create) 9082 [2016/07/28 11:27:21.366388, 10, pid=24487, effective(0, 0), real(0, 0)] ../source3/smbd/smbXsrv_tcon.c:811(smbXsrv_tcon_create) 9083 smbXsrv_tcon_create: global_id (0xa7147965) stored 9084 [2016/07/28 11:27:21.366409, 1, pid=24487, effective(0, 0), real(0, 0)] ../librpc/ndr/ndr.c:402(ndr_print_debug) 9085 &tcon_blob: struct smbXsrv_tconB 9086 version : SMBXSRV_VERSION_0 (0) 9087 reserved : 0x00000000 (0) 9088 info : union smbXsrv_tconU(case 0) 9089 info0 : * 9090 info0: struct smbXsrv_tcon 9091 table : * 9092 db_rec : NULL 9093 local_id : 0xa7147965 (2803136869) 9094 global : * 9095 global: struct smbXsrv_tcon_global0 9096 db_rec : NULL 9097 tcon_global_id : 0xa7147965 (2803136869) 9098 tcon_wire_id : 0xa7147965 (2803136869) 9099 server_id: struct server_id 9100 pid : 0x0000000000005fa7 (24487) 9101 task_id : 0x00000000 (0) 9102 vnn : 0xffffffff (4294967295) 9103 unique_id : 0x23f6f22e9d89b472 (2591524917623764082) 9104 creation_time : Thu Jul 28 11:27:21 2016 EDT 9105 share_name : NULL 9106 encryption_required : 0x00 (0) 9107 session_global_id : 0x00000000 (0) 9108 status : NT_STATUS_INTERNAL_ERROR 9109 idle_time : Thu Jul 28 11:27:21 2016 EDT 9110 compat : NULL 9111 encryption_desired : 0x00 (0) 9112 [2016/07/28 11:27:21.366645, 3, pid=24487, effective(0, 0), real(0, 0)] ../source3/lib/access.c:338(allow_access) 9113 Allowed connection from 216.185.71.63 (216.185.71.63) 9114 [2016/07/28 11:27:21.366676, 10, pid=24487, effective(0, 0), real(0, 0)] ../source3/smbd/share_access.c:237(user_ok_token) 9115 user_ok_token: share netlogon is ok for unix user BROCKLEY-2016\testing11 9116 [2016/07/28 11:27:21.366849, 10, pid=24487, effective(0, 0), real(0, 0)] ../source3/smbd/service.c:164(set_conn_connectpath) 9117 set_conn_connectpath: service netlogon, connectpath = /var/db/samba4/sysvol/brockley-2016.harte-lyne.ca/scripts 9118 [2016/07/28 11:27:21.366883, 3, pid=24487, effective(0, 0), real(0, 0)] ../source3/smbd/service.c:622(make_connection_snum) 9119 Connect path is '/var/db/samba4/sysvol/brockley-2016.harte-lyne.ca/scripts' for service [netlogon] 9120 [2016/07/28 11:27:21.366909, 10, pid=24487, effective(0, 0), real(0, 0)] ../source3/smbd/share_access.c:237(user_ok_token) 9121 user_ok_token: share netlogon is ok for unix user BROCKLEY-2016\testing11 9122 [2016/07/28 11:27:21.366934, 10, pid=24487, effective(0, 0), real(0, 0)] ../source3/smbd/share_access.c:284(is_share_read_only_for_token) 9123 is_share_read_only_for_user: share netlogon is read-write for unix user BROCKLEY-2016\testing11 9124 [2016/07/28 11:27:21.367012, 10, pid=24487, effective(0, 0), real(0, 0)] ../libcli/security/access_check.c:337(se_file_access_check) 9125 se_file_access_check: MAX desired = 0x2000000 mapped to 0x1f01ff 9126 [2016/07/28 11:27:21.367041, 3, pid=24487, effective(0, 0), real(0, 0), class=vfs] ../source3/smbd/vfs.c:113(vfs_init_default) 9127 Initialising default vfs hooks 9128 [2016/07/28 11:27:21.367062, 3, pid=24487, effective(0, 0), real(0, 0), class=vfs] ../source3/smbd/vfs.c:139(vfs_init_custom) 9129 Initialising custom vfs hooks from [/[Default VFS]/] 9130 [2016/07/28 11:27:21.367085, 10, pid=24487, effective(0, 0), real(0, 0), class=vfs] ../source3/smbd/vfs.c:64(vfs_find_backend_entry) 9131 vfs_find_backend_entry called for /[Default VFS]/ 9132 Successfully loaded vfs module [/[Default VFS]/] with the new modules system 9133 [2016/07/28 11:27:21.367114, 3, pid=24487, effective(0, 0), real(0, 0), class=vfs] ../source3/smbd/vfs.c:139(vfs_init_custom) 9134 Initialising custom vfs hooks from [acl_xattr] 9135 [2016/07/28 11:27:21.367136, 10, pid=24487, effective(0, 0), real(0, 0), class=vfs] ../source3/smbd/vfs.c:64(vfs_find_backend_entry) 9136 vfs_find_backend_entry called for acl_xattr 9137 Successfully loaded vfs module [acl_xattr] with the new modules system 9138 [2016/07/28 11:27:21.367163, 3, pid=24487, effective(0, 0), real(0, 0), class=vfs] ../source3/smbd/vfs.c:139(vfs_init_custom) 9139 Initialising custom vfs hooks from [dfs_samba4] 9140 [2016/07/28 11:27:21.367185, 10, pid=24487, effective(0, 0), real(0, 0), class=vfs] ../source3/smbd/vfs.c:64(vfs_find_backend_entry) 9141 vfs_find_backend_entry called for dfs_samba4 9142 Successfully loaded vfs module [dfs_samba4] with the new modules system 9143 [2016/07/28 11:27:21.367226, 2, pid=24487, effective(0, 0), real(0, 0), class=vfs] ../source3/modules/vfs_acl_xattr.c:193(connect_acl_xattr) 9144 connect_acl_xattr: setting 'inherit acls = true' 'dos filemode = true' and 'force unknown acl user = true' for service netlogon 9145 [2016/07/28 11:27:21.367473, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:210(samba_ldb_connect) 9146 [2016/07/28 11:27:21.367606, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9147 ldb: ldb_trace_request: SEARCH 9148 dn: @MODULES 9149 scope: base 9150 expr: (@LIST=*) 9151 attr: @LIST 9152 control: 9153 9154 [2016/07/28 11:27:21.367654, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9155 ldb: ldb_trace_request: (tdb)->search 9156 [2016/07/28 11:27:21.367712, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9157 ldb: ldb_trace_response: ENTRY 9158 dn: @MODULES 9159 @LIST: samba_dsdb 9160 9161 9162 9163 [2016/07/28 11:27:21.367778, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9164 ldb: ldb_trace_next_request: (tdb)->search 9165 [2016/07/28 11:27:21.367833, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9166 ldb: ldb_trace_response: ENTRY 9167 dn: @SAMBA_DSDB 9168 backendType: ldb 9169 9170 9171 9172 [2016/07/28 11:27:21.367886, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9173 ldb: ldb_trace_next_request: (tdb)->search 9174 [2016/07/28 11:27:21.368055, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9175 ldb: ldb_trace_response: ENTRY 9176 dn: @ROOTDSE 9177 configurationNamingContext: CN=Configuration,DC=brockley-2016,DC=harte-lyne,DC 9178 =ca 9179 defaultNamingContext: DC=brockley-2016,DC=harte-lyne,DC=ca 9180 schemaNamingContext: CN=Schema,CN=Configuration,DC=brockley-2016,DC=harte-lyne 9181 ,DC=ca 9182 9183 9184 9185 [2016/07/28 11:27:21.368170, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9186 ldb: ldb_trace_request: SEARCH 9187 dn: 9188 scope: base 9189 expr: (objectClass=*) 9190 attr: rootDomainNamingContext 9191 attr: configurationNamingContext 9192 attr: schemaNamingContext 9193 attr: defaultNamingContext 9194 control: 9195 9196 [2016/07/28 11:27:21.368225, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9197 ldb: ldb_trace_request: (resolve_oids)->search 9198 [2016/07/28 11:27:21.368250, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9199 ldb: ldb_trace_next_request: (rootdse)->search 9200 [2016/07/28 11:27:21.368281, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9201 ldb: ldb_trace_next_request: (schema_load)->search 9202 [2016/07/28 11:27:21.368306, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9203 ldb: ldb_trace_next_request: (lazy_commit)->search 9204 [2016/07/28 11:27:21.368328, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9205 ldb: ldb_trace_next_request: (dirsync)->search 9206 [2016/07/28 11:27:21.368353, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9207 ldb: ldb_trace_next_request: (paged_results)->search 9208 [2016/07/28 11:27:21.368375, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9209 ldb: ldb_trace_next_request: (ranged_results)->search 9210 [2016/07/28 11:27:21.368398, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9211 ldb: ldb_trace_next_request: (anr)->search 9212 [2016/07/28 11:27:21.368421, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9213 ldb: ldb_trace_next_request: (server_sort)->search 9214 [2016/07/28 11:27:21.368443, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9215 ldb: ldb_trace_next_request: (asq)->search 9216 [2016/07/28 11:27:21.368465, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9217 ldb: ldb_trace_next_request: (extended_dn_in)->search 9218 [2016/07/28 11:27:21.368490, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9219 ldb: ldb_trace_next_request: (descriptor)->search 9220 [2016/07/28 11:27:21.368513, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9221 ldb: ldb_trace_next_request: (acl)->search 9222 [2016/07/28 11:27:21.368534, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9223 ldb: ldb_trace_next_request: (aclread)->search 9224 [2016/07/28 11:27:21.368557, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9225 ldb: ldb_trace_next_request: (operational)->search 9226 [2016/07/28 11:27:21.368578, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9227 ldb: ldb_trace_next_request: (rdn_name)->search 9228 [2016/07/28 11:27:21.368599, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9229 ldb: ldb_trace_next_request: (extended_dn_out_ldb)->search 9230 [2016/07/28 11:27:21.368621, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9231 ldb: ldb_trace_next_request: (show_deleted)->search 9232 [2016/07/28 11:27:21.368645, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9233 ldb: ldb_trace_next_request: (partition)->search 9234 [2016/07/28 11:27:21.368667, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9235 ldb: ldb_trace_next_request: (tdb)->search 9236 [2016/07/28 11:27:21.368829, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9237 ldb: ldb_trace_response: ENTRY 9238 dn: 9239 configurationNamingContext: CN=Configuration,DC=brockley-2016,DC=harte-lyne,DC 9240 =ca 9241 defaultNamingContext: DC=brockley-2016,DC=harte-lyne,DC=ca 9242 rootDomainNamingContext: DC=brockley-2016,DC=harte-lyne,DC=ca 9243 schemaNamingContext: CN=Schema,CN=Configuration,DC=brockley-2016,DC=harte-lyne 9244 ,DC=ca 9245 9246 9247 9248 [2016/07/28 11:27:21.368903, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9249 ldb: ldb_trace_response: DONE 9250 error: 0 9251 9252 [2016/07/28 11:27:21.368959, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9253 ldb: ldb_trace_request: REGISTER_CONTROL 9254 1.2.840.113556.1.4.841 9255 control: 9256 9257 [2016/07/28 11:27:21.369019, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9258 ldb: ldb_trace_request: (rootdse)->request 9259 [2016/07/28 11:27:21.369044, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9260 ldb: ldb_trace_response: DONE 9261 error: 0 9262 9263 [2016/07/28 11:27:21.369077, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9264 ldb: ldb_trace_request: REGISTER_CONTROL 9265 1.2.840.113556.1.4.319 9266 control: 9267 9268 [2016/07/28 11:27:21.369108, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9269 ldb: ldb_trace_request: (rootdse)->request 9270 [2016/07/28 11:27:21.369132, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9271 ldb: ldb_trace_response: DONE 9272 error: 0 9273 9274 [2016/07/28 11:27:21.369164, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9275 ldb: ldb_trace_request: REGISTER_CONTROL 9276 1.2.840.113556.1.4.473 9277 control: 9278 9279 [2016/07/28 11:27:21.369195, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9280 ldb: ldb_trace_request: (rootdse)->request 9281 [2016/07/28 11:27:21.369219, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9282 ldb: ldb_trace_response: DONE 9283 error: 0 9284 9285 [2016/07/28 11:27:21.369252, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9286 ldb: ldb_trace_request: REGISTER_CONTROL 9287 1.2.840.113556.1.4.1504 9288 control: 9289 9290 [2016/07/28 11:27:21.369283, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9291 ldb: ldb_trace_request: (rootdse)->request 9292 [2016/07/28 11:27:21.369307, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9293 ldb: ldb_trace_response: DONE 9294 error: 0 9295 9296 [2016/07/28 11:27:21.369340, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9297 ldb: ldb_trace_request: REGISTER_CONTROL 9298 1.2.840.113556.1.4.801 9299 control: 9300 9301 [2016/07/28 11:27:21.369373, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9302 ldb: ldb_trace_request: (rootdse)->request 9303 [2016/07/28 11:27:21.369397, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9304 ldb: ldb_trace_response: DONE 9305 error: 0 9306 9307 [2016/07/28 11:27:21.369429, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9308 ldb: ldb_trace_request: REGISTER_CONTROL 9309 1.2.840.113556.1.4.801 9310 control: 9311 9312 [2016/07/28 11:27:21.369461, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9313 ldb: ldb_trace_request: (rootdse)->request 9314 [2016/07/28 11:27:21.369485, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9315 ldb: ldb_trace_response: DONE 9316 error: 0 9317 9318 [2016/07/28 11:27:21.369525, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9319 ldb: ldb_trace_next_request: (aclread)->search 9320 [2016/07/28 11:27:21.369552, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9321 ldb: ldb_trace_next_request: (operational)->search 9322 [2016/07/28 11:27:21.369577, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9323 ldb: ldb_trace_next_request: (rdn_name)->search 9324 [2016/07/28 11:27:21.369601, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9325 ldb: ldb_trace_next_request: (extended_dn_out_ldb)->search 9326 [2016/07/28 11:27:21.369625, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9327 ldb: ldb_trace_next_request: (show_deleted)->search 9328 [2016/07/28 11:27:21.369651, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9329 ldb: ldb_trace_next_request: (partition)->search 9330 [2016/07/28 11:27:21.369676, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9331 ldb: ldb_trace_next_request: (tdb)->search 9332 [2016/07/28 11:27:21.369750, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9333 ldb: ldb_trace_request: REGISTER_CONTROL 9334 1.2.840.113556.1.4.805 9335 control: 9336 9337 [2016/07/28 11:27:21.369786, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9338 ldb: ldb_trace_request: (rootdse)->request 9339 [2016/07/28 11:27:21.369810, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9340 ldb: ldb_trace_response: DONE 9341 error: 0 9342 9343 [2016/07/28 11:27:21.369853, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9344 ldb: ldb_trace_request: REGISTER_CONTROL 9345 1.2.840.113556.1.4.1338 9346 control: 9347 9348 [2016/07/28 11:27:21.369884, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9349 ldb: ldb_trace_request: (rootdse)->request 9350 [2016/07/28 11:27:21.369908, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9351 ldb: ldb_trace_response: DONE 9352 error: 0 9353 9354 [2016/07/28 11:27:21.369941, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9355 ldb: ldb_trace_request: REGISTER_CONTROL 9356 1.2.840.113556.1.4.529 9357 control: 9358 9359 [2016/07/28 11:27:21.370056, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9360 ldb: ldb_trace_request: (rootdse)->request 9361 [2016/07/28 11:27:21.370084, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9362 ldb: ldb_trace_response: DONE 9363 error: 0 9364 9365 [2016/07/28 11:27:21.370122, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9366 ldb: ldb_trace_request: REGISTER_CONTROL 9367 1.2.840.113556.1.4.417 9368 control: 9369 9370 [2016/07/28 11:27:21.370154, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9371 ldb: ldb_trace_request: (rootdse)->request 9372 [2016/07/28 11:27:21.370178, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9373 ldb: ldb_trace_response: DONE 9374 error: 0 9375 9376 [2016/07/28 11:27:21.370209, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9377 ldb: ldb_trace_request: REGISTER_CONTROL 9378 1.2.840.113556.1.4.2064 9379 control: 9380 9381 [2016/07/28 11:27:21.370263, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9382 ldb: ldb_trace_request: (rootdse)->request 9383 [2016/07/28 11:27:21.370287, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9384 ldb: ldb_trace_response: DONE 9385 error: 0 9386 9387 [2016/07/28 11:27:21.370320, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9388 ldb: ldb_trace_next_request: (tdb)->extended 9389 [2016/07/28 11:27:21.370373, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9390 ldb: ldb_trace_next_request: (tdb)->search 9391 [2016/07/28 11:27:21.370742, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9392 ldb: ldb_trace_response: ENTRY 9393 dn: @PARTITION 9394 replicateEntries: @ATTRIBUTES 9395 replicateEntries: @INDEXLIST 9396 replicateEntries: @OPTIONS 9397 partition: DC=BROCKLEY-2016,DC=HARTE-LYNE,DC=CA:sam.ldb.d/DC%3DBROCKLEY-2016,D 9398 C%3DHARTE-LYNE,DC%3DCA.ldb 9399 partition: CN=CONFIGURATION,DC=BROCKLEY-2016,DC=HARTE-LYNE,DC=CA:sam.ldb.d/CN% 9400 3DCONFIGURATION,DC%3DBROCKLEY-2016,DC%3DHARTE-LYNE,DC%3DCA.ldb 9401 partition: CN=SCHEMA,CN=CONFIGURATION,DC=BROCKLEY-2016,DC=HARTE-LYNE,DC=CA:sam 9402 .ldb.d/CN%3DSCHEMA,CN%3DCONFIGURATION,DC%3DBROCKLEY-2016,DC%3DHARTE-LYNE,DC%3 9403 DCA.ldb 9404 partition: DC=DOMAINDNSZONES,DC=BROCKLEY-2016,DC=HARTE-LYNE,DC=CA:sam.ldb.d/DC 9405 %3DDOMAINDNSZONES,DC%3DBROCKLEY-2016,DC%3DHARTE-LYNE,DC%3DCA.ldb 9406 partition: DC=FORESTDNSZONES,DC=BROCKLEY-2016,DC=HARTE-LYNE,DC=CA:sam.ldb.d/DC 9407 %3DFORESTDNSZONES,DC%3DBROCKLEY-2016,DC%3DHARTE-LYNE,DC%3DCA.ldb 9408 9409 9410 9411 [2016/07/28 11:27:21.371029, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9412 ldb: ldb_trace_request: REGISTER_CONTROL 9413 1.2.840.113556.1.4.1413 9414 control: 9415 9416 [2016/07/28 11:27:21.371069, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9417 ldb: ldb_trace_request: (rootdse)->request 9418 [2016/07/28 11:27:21.371093, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9419 ldb: ldb_trace_response: DONE 9420 error: 0 9421 9422 [2016/07/28 11:27:21.371145, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9423 ldb: ldb_trace_next_request: (tdb)->search 9424 [2016/07/28 11:27:21.371288, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9425 ldb: ldb_trace_response: ENTRY 9426 dn: DC=brockley-2016,DC=harte-lyne,DC=ca 9427 9428 9429 9430 [2016/07/28 11:27:21.371346, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9431 ldb: ldb_trace_request: REGISTER_PARTITION 9432 DC=brockley-2016,DC=harte-lyne,DC=ca 9433 control: 9434 9435 [2016/07/28 11:27:21.371381, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9436 ldb: ldb_trace_request: (rootdse)->request 9437 [2016/07/28 11:27:21.371408, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9438 ldb: ldb_trace_response: DONE 9439 error: 0 9440 9441 [2016/07/28 11:27:21.371550, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9442 ldb: ldb_trace_request: REGISTER_CONTROL 9443 1.2.840.113556.1.4.1413 9444 control: 9445 9446 [2016/07/28 11:27:21.371595, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9447 ldb: ldb_trace_request: (rootdse)->request 9448 [2016/07/28 11:27:21.371619, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9449 ldb: ldb_trace_response: DONE 9450 error: 0 9451 9452 [2016/07/28 11:27:21.371654, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9453 ldb: ldb_trace_next_request: (tdb)->search 9454 [2016/07/28 11:27:21.371749, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9455 ldb: ldb_trace_response: ENTRY 9456 dn: CN=Configuration,DC=brockley-2016,DC=harte-lyne,DC=ca 9457 9458 9459 9460 [2016/07/28 11:27:21.371806, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9461 ldb: ldb_trace_request: REGISTER_PARTITION 9462 CN=Configuration,DC=brockley-2016,DC=harte-lyne,DC=ca 9463 control: 9464 9465 [2016/07/28 11:27:21.371841, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9466 ldb: ldb_trace_request: (rootdse)->request 9467 [2016/07/28 11:27:21.371869, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9468 ldb: ldb_trace_response: DONE 9469 error: 0 9470 9471 [2016/07/28 11:27:21.372069, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9472 ldb: ldb_trace_request: REGISTER_CONTROL 9473 1.2.840.113556.1.4.1413 9474 control: 9475 9476 [2016/07/28 11:27:21.372107, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9477 ldb: ldb_trace_request: (rootdse)->request 9478 [2016/07/28 11:27:21.372131, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9479 ldb: ldb_trace_response: DONE 9480 error: 0 9481 9482 [2016/07/28 11:27:21.372184, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9483 ldb: ldb_trace_next_request: (schema_data)->search 9484 [2016/07/28 11:27:21.372211, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9485 ldb: ldb_trace_next_request: (tdb)->search 9486 [2016/07/28 11:27:21.372341, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9487 ldb: ldb_trace_response: ENTRY 9488 dn: CN=Schema,CN=Configuration,DC=brockley-2016,DC=harte-lyne,DC=ca 9489 9490 9491 9492 [2016/07/28 11:27:21.372401, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9493 ldb: ldb_trace_request: REGISTER_PARTITION 9494 CN=Schema,CN=Configuration,DC=brockley-2016,DC=harte-lyne,DC=ca 9495 control: 9496 9497 [2016/07/28 11:27:21.372436, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9498 ldb: ldb_trace_request: (rootdse)->request 9499 [2016/07/28 11:27:21.372464, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9500 ldb: ldb_trace_response: DONE 9501 error: 0 9502 9503 [2016/07/28 11:27:21.372620, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9504 ldb: ldb_trace_request: REGISTER_CONTROL 9505 1.2.840.113556.1.4.1413 9506 control: 9507 9508 [2016/07/28 11:27:21.372658, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9509 ldb: ldb_trace_request: (rootdse)->request 9510 [2016/07/28 11:27:21.372682, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9511 ldb: ldb_trace_response: DONE 9512 error: 0 9513 9514 [2016/07/28 11:27:21.372716, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9515 ldb: ldb_trace_next_request: (tdb)->search 9516 [2016/07/28 11:27:21.372822, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9517 ldb: ldb_trace_response: ENTRY 9518 dn: DC=DomainDnsZones,DC=brockley-2016,DC=harte-lyne,DC=ca 9519 9520 9521 9522 [2016/07/28 11:27:21.372879, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9523 ldb: ldb_trace_request: REGISTER_PARTITION 9524 DC=DomainDnsZones,DC=brockley-2016,DC=harte-lyne,DC=ca 9525 control: 9526 9527 [2016/07/28 11:27:21.372914, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9528 ldb: ldb_trace_request: (rootdse)->request 9529 [2016/07/28 11:27:21.372941, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9530 ldb: ldb_trace_response: DONE 9531 error: 0 9532 9533 [2016/07/28 11:27:21.373188, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9534 ldb: ldb_trace_request: REGISTER_CONTROL 9535 1.2.840.113556.1.4.1413 9536 control: 9537 9538 [2016/07/28 11:27:21.373235, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9539 ldb: ldb_trace_request: (rootdse)->request 9540 [2016/07/28 11:27:21.373262, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9541 ldb: ldb_trace_response: DONE 9542 error: 0 9543 9544 [2016/07/28 11:27:21.373309, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9545 ldb: ldb_trace_next_request: (tdb)->search 9546 [2016/07/28 11:27:21.373428, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9547 ldb: ldb_trace_response: ENTRY 9548 dn: DC=ForestDnsZones,DC=brockley-2016,DC=harte-lyne,DC=ca 9549 9550 9551 9552 [2016/07/28 11:27:21.373489, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9553 ldb: ldb_trace_request: REGISTER_PARTITION 9554 DC=ForestDnsZones,DC=brockley-2016,DC=harte-lyne,DC=ca 9555 control: 9556 9557 [2016/07/28 11:27:21.373525, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9558 ldb: ldb_trace_request: (rootdse)->request 9559 [2016/07/28 11:27:21.373553, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9560 ldb: ldb_trace_response: DONE 9561 error: 0 9562 9563 [2016/07/28 11:27:21.373588, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9564 ldb: ldb_trace_request: REGISTER_CONTROL 9565 1.2.840.113556.1.4.1339 9566 control: 9567 9568 [2016/07/28 11:27:21.373620, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9569 ldb: ldb_trace_request: (rootdse)->request 9570 [2016/07/28 11:27:21.373644, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9571 ldb: ldb_trace_response: DONE 9572 error: 0 9573 9574 [2016/07/28 11:27:21.373675, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9575 ldb: ldb_trace_request: REGISTER_CONTROL 9576 1.2.840.113556.1.4.1340 9577 control: 9578 9579 [2016/07/28 11:27:21.373707, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9580 ldb: ldb_trace_request: (rootdse)->request 9581 [2016/07/28 11:27:21.373731, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9582 ldb: ldb_trace_response: DONE 9583 error: 0 9584 9585 [2016/07/28 11:27:21.373795, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9586 ldb: ldb_trace_request: REGISTER_CONTROL 9587 1.2.840.113556.1.4.1413 9588 control: 9589 9590 [2016/07/28 11:27:21.373830, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9591 ldb: ldb_trace_request: (rootdse)->request 9592 [2016/07/28 11:27:21.373855, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9593 ldb: ldb_trace_response: DONE 9594 error: 0 9595 9596 [2016/07/28 11:27:21.373890, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9597 ldb: ldb_trace_request: REGISTER_CONTROL 9598 1.2.840.113556.1.4.1341 9599 control: 9600 9601 [2016/07/28 11:27:21.373922, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9602 ldb: ldb_trace_request: (rootdse)->request 9603 [2016/07/28 11:27:21.373946, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9604 ldb: ldb_trace_response: DONE 9605 error: 0 9606 9607 [2016/07/28 11:27:21.374014, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9608 ldb: ldb_trace_next_request: (schema_load)->search 9609 [2016/07/28 11:27:21.374042, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9610 ldb: ldb_trace_next_request: (lazy_commit)->search 9611 [2016/07/28 11:27:21.374065, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9612 ldb: ldb_trace_next_request: (dirsync)->search 9613 [2016/07/28 11:27:21.374087, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9614 ldb: ldb_trace_next_request: (paged_results)->search 9615 [2016/07/28 11:27:21.374109, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9616 ldb: ldb_trace_next_request: (ranged_results)->search 9617 [2016/07/28 11:27:21.374131, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9618 ldb: ldb_trace_next_request: (anr)->search 9619 [2016/07/28 11:27:21.374154, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9620 ldb: ldb_trace_next_request: (server_sort)->search 9621 [2016/07/28 11:27:21.374176, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9622 ldb: ldb_trace_next_request: (asq)->search 9623 [2016/07/28 11:27:21.374197, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9624 ldb: ldb_trace_next_request: (extended_dn_in)->search 9625 [2016/07/28 11:27:21.374224, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9626 ldb: ldb_trace_next_request: (descriptor)->search 9627 [2016/07/28 11:27:21.374247, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9628 ldb: ldb_trace_next_request: (acl)->search 9629 [2016/07/28 11:27:21.374275, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9630 ldb: ldb_trace_next_request: (aclread)->search 9631 [2016/07/28 11:27:21.374300, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9632 ldb: ldb_trace_next_request: (operational)->search 9633 [2016/07/28 11:27:21.374327, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9634 ldb: ldb_trace_next_request: (rdn_name)->search 9635 [2016/07/28 11:27:21.374352, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9636 ldb: ldb_trace_next_request: (extended_dn_out_ldb)->search 9637 [2016/07/28 11:27:21.374377, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9638 ldb: ldb_trace_next_request: (show_deleted)->search 9639 [2016/07/28 11:27:21.374437, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9640 ldb: ldb_trace_request: SEARCH 9641 dn: 9642 scope: base 9643 expr: (|(objectClass=*)(distinguishedName=*)) 9644 attr: dsServiceName 9645 control: 9646 9647 [2016/07/28 11:27:21.374495, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9648 ldb: ldb_trace_request: (resolve_oids)->search 9649 [2016/07/28 11:27:21.374521, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9650 ldb: ldb_trace_next_request: (rootdse)->search 9651 [2016/07/28 11:27:21.374559, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9652 ldb: ldb_trace_next_request: (schema_load)->search 9653 [2016/07/28 11:27:21.374587, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9654 ldb: ldb_trace_next_request: (lazy_commit)->search 9655 [2016/07/28 11:27:21.374627, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9656 ldb: ldb_trace_next_request: (dirsync)->search 9657 [2016/07/28 11:27:21.374650, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9658 ldb: ldb_trace_next_request: (paged_results)->search 9659 [2016/07/28 11:27:21.374672, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9660 ldb: ldb_trace_next_request: (ranged_results)->search 9661 [2016/07/28 11:27:21.374694, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9662 ldb: ldb_trace_next_request: (anr)->search 9663 [2016/07/28 11:27:21.374716, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9664 ldb: ldb_trace_next_request: (server_sort)->search 9665 [2016/07/28 11:27:21.374737, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9666 ldb: ldb_trace_next_request: (asq)->search 9667 [2016/07/28 11:27:21.374758, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9668 ldb: ldb_trace_next_request: (extended_dn_in)->search 9669 [2016/07/28 11:27:21.374784, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9670 ldb: ldb_trace_next_request: (descriptor)->search 9671 [2016/07/28 11:27:21.374807, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9672 ldb: ldb_trace_next_request: (acl)->search 9673 [2016/07/28 11:27:21.374828, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9674 ldb: ldb_trace_next_request: (aclread)->search 9675 [2016/07/28 11:27:21.374852, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9676 ldb: ldb_trace_next_request: (operational)->search 9677 [2016/07/28 11:27:21.374873, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9678 ldb: ldb_trace_next_request: (rdn_name)->search 9679 [2016/07/28 11:27:21.374895, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9680 ldb: ldb_trace_next_request: (extended_dn_out_ldb)->search 9681 [2016/07/28 11:27:21.374916, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9682 ldb: ldb_trace_next_request: (show_deleted)->search 9683 [2016/07/28 11:27:21.374940, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9684 ldb: ldb_trace_next_request: (partition)->search 9685 [2016/07/28 11:27:21.374962, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9686 ldb: ldb_trace_next_request: (tdb)->search 9687 [2016/07/28 11:27:21.375085, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9688 ldb: ldb_trace_next_request: (schema_load)->search 9689 [2016/07/28 11:27:21.375116, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9690 ldb: ldb_trace_next_request: (lazy_commit)->search 9691 [2016/07/28 11:27:21.375139, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9692 ldb: ldb_trace_next_request: (dirsync)->search 9693 [2016/07/28 11:27:21.375160, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9694 ldb: ldb_trace_next_request: (paged_results)->search 9695 [2016/07/28 11:27:21.375182, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9696 ldb: ldb_trace_next_request: (ranged_results)->search 9697 [2016/07/28 11:27:21.375203, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9698 ldb: ldb_trace_next_request: (anr)->search 9699 [2016/07/28 11:27:21.375226, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9700 ldb: ldb_trace_next_request: (server_sort)->search 9701 [2016/07/28 11:27:21.375248, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9702 ldb: ldb_trace_next_request: (asq)->search 9703 [2016/07/28 11:27:21.375269, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9704 ldb: ldb_trace_next_request: (extended_dn_in)->search 9705 [2016/07/28 11:27:21.375321, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9706 ldb: ldb_trace_next_request: (descriptor)->search 9707 [2016/07/28 11:27:21.375350, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9708 ldb: ldb_trace_next_request: (acl)->search 9709 [2016/07/28 11:27:21.375378, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9710 ldb: ldb_trace_next_request: (aclread)->search 9711 [2016/07/28 11:27:21.375402, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9712 ldb: ldb_trace_next_request: (operational)->search 9713 [2016/07/28 11:27:21.375427, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9714 ldb: ldb_trace_next_request: (rdn_name)->search 9715 [2016/07/28 11:27:21.375449, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9716 ldb: ldb_trace_next_request: (extended_dn_out_ldb)->search 9717 [2016/07/28 11:27:21.375478, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9718 ldb: ldb_trace_next_request: (show_deleted)->search 9719 [2016/07/28 11:27:21.375509, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9720 ldb: ldb_trace_next_request: (partition)->search 9721 [2016/07/28 11:27:21.375542, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9722 ldb: partition_request() -> (metadata partition) 9723 [2016/07/28 11:27:21.375565, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9724 ldb: ldb_trace_next_request: (tdb)->search 9725 [2016/07/28 11:27:21.375622, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9726 ldb: partition_request() -> (metadata partition) 9727 [2016/07/28 11:27:21.375648, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9728 ldb: ldb_trace_next_request: (schema_data)->search 9729 [2016/07/28 11:27:21.375671, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9730 ldb: ldb_trace_next_request: (tdb)->search 9731 [2016/07/28 11:27:21.375720, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9732 ldb: partition_request() -> (metadata partition) 9733 [2016/07/28 11:27:21.375745, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9734 ldb: ldb_trace_next_request: (tdb)->search 9735 [2016/07/28 11:27:21.375894, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9736 ldb: partition_request() -> (metadata partition) 9737 [2016/07/28 11:27:21.375923, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9738 ldb: ldb_trace_next_request: (tdb)->search 9739 [2016/07/28 11:27:21.375998, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9740 ldb: partition_request() -> (metadata partition) 9741 [2016/07/28 11:27:21.376023, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9742 ldb: ldb_trace_next_request: (tdb)->search 9743 [2016/07/28 11:27:21.376077, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9744 ldb: partition_request() -> (metadata partition) 9745 [2016/07/28 11:27:21.376102, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9746 ldb: ldb_trace_next_request: (tdb)->search 9747 [2016/07/28 11:27:21.376150, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9748 ldb: ldb_trace_next_request: (descriptor)->search 9749 [2016/07/28 11:27:21.376176, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9750 ldb: ldb_trace_next_request: (acl)->search 9751 [2016/07/28 11:27:21.376204, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9752 ldb: ldb_trace_next_request: (aclread)->search 9753 [2016/07/28 11:27:21.376229, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9754 ldb: ldb_trace_next_request: (operational)->search 9755 [2016/07/28 11:27:21.376253, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9756 ldb: ldb_trace_next_request: (rdn_name)->search 9757 [2016/07/28 11:27:21.376276, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9758 ldb: ldb_trace_next_request: (extended_dn_out_ldb)->search 9759 [2016/07/28 11:27:21.376303, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9760 ldb: ldb_trace_next_request: (show_deleted)->search 9761 [2016/07/28 11:27:21.376328, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9762 ldb: ldb_trace_next_request: (partition)->search 9763 [2016/07/28 11:27:21.376467, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9764 ldb: partition_request() -> (metadata partition) 9765 [2016/07/28 11:27:21.376494, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9766 ldb: ldb_trace_next_request: (tdb)->search 9767 [2016/07/28 11:27:21.376706, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9768 ldb: ldb_trace_response: ENTRY 9769 dn: 9770 dsServiceName: CN=NTDS Settings,CN=SAMBA-01,CN=Servers,CN=Default-First-Site-N 9771 ame,CN=Sites,CN=Configuration,DC=brockley-2016,DC=harte-lyne,DC=ca 9772 9773 9774 9775 [2016/07/28 11:27:21.376759, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9776 ldb: ldb_trace_response: DONE 9777 error: 0 9778 9779 [2016/07/28 11:27:21.376814, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9780 ldb: ldb_trace_next_request: (partition)->search 9781 [2016/07/28 11:27:21.376859, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9782 ldb: partition_request() -> (metadata partition) 9783 [2016/07/28 11:27:21.376882, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9784 ldb: ldb_trace_next_request: (tdb)->search 9785 [2016/07/28 11:27:21.376999, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9786 ldb: ldb_trace_response: ENTRY 9787 dn: CN=NTDS Settings,CN=SAMBA-01,CN=Servers,CN=Default-First-Site-Name,CN=Sites,CN=Configuration,DC=brockley-2016,DC=harte-lyne,DC=ca 9788 9789 9790 9791 [2016/07/28 11:27:21.377043, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9792 ldb: ldb_trace_response: DONE 9793 error: 0 9794 9795 [2016/07/28 11:27:21.377084, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9796 ldb: ldb_trace_next_request: (partition)->search 9797 [2016/07/28 11:27:21.377111, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9798 ldb: partition_request() -> (metadata partition) 9799 [2016/07/28 11:27:21.377133, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9800 ldb: ldb_trace_next_request: (tdb)->search 9801 [2016/07/28 11:27:21.377248, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9802 ldb: ldb_trace_response: ENTRY 9803 dn: DC=brockley-2016,DC=harte-lyne,DC=ca 9804 msDS-Behavior-Version: 4 9805 9806 9807 9808 [2016/07/28 11:27:21.377296, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9809 ldb: ldb_trace_response: DONE 9810 error: 0 9811 9812 [2016/07/28 11:27:21.377347, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9813 ldb: ldb_trace_next_request: (schema_load)->search 9814 [2016/07/28 11:27:21.377379, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9815 ldb: ldb_trace_next_request: (lazy_commit)->search 9816 [2016/07/28 11:27:21.377401, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9817 ldb: ldb_trace_next_request: (dirsync)->search 9818 [2016/07/28 11:27:21.377422, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9819 ldb: ldb_trace_next_request: (paged_results)->search 9820 [2016/07/28 11:27:21.377444, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9821 ldb: ldb_trace_next_request: (ranged_results)->search 9822 [2016/07/28 11:27:21.377466, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9823 ldb: ldb_trace_next_request: (anr)->search 9824 [2016/07/28 11:27:21.377488, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9825 ldb: ldb_trace_next_request: (server_sort)->search 9826 [2016/07/28 11:27:21.377510, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9827 ldb: ldb_trace_next_request: (asq)->search 9828 [2016/07/28 11:27:21.377532, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9829 ldb: ldb_trace_next_request: (extended_dn_in)->search 9830 [2016/07/28 11:27:21.377557, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9831 ldb: ldb_trace_next_request: (descriptor)->search 9832 [2016/07/28 11:27:21.377580, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9833 ldb: ldb_trace_next_request: (acl)->search 9834 [2016/07/28 11:27:21.377607, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9835 ldb: ldb_trace_next_request: (aclread)->search 9836 [2016/07/28 11:27:21.377632, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9837 ldb: ldb_trace_next_request: (operational)->search 9838 [2016/07/28 11:27:21.377658, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9839 ldb: ldb_trace_next_request: (rdn_name)->search 9840 [2016/07/28 11:27:21.377680, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9841 ldb: ldb_trace_next_request: (extended_dn_out_ldb)->search 9842 [2016/07/28 11:27:21.377713, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9843 ldb: ldb_trace_next_request: (show_deleted)->search 9844 [2016/07/28 11:27:21.377737, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9845 ldb: ldb_trace_next_request: (partition)->search 9846 [2016/07/28 11:27:21.377772, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9847 ldb: partition_request() -> (metadata partition) 9848 [2016/07/28 11:27:21.377795, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9849 ldb: ldb_trace_next_request: (tdb)->search 9850 [2016/07/28 11:27:21.377882, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9851 ldb: ldb_trace_response: ENTRY 9852 dn: CN=Partitions,CN=Configuration,DC=brockley-2016,DC=harte-lyne,DC=ca 9853 msDS-Behavior-Version: 4 9854 9855 9856 9857 [2016/07/28 11:27:21.377930, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9858 ldb: ldb_trace_response: DONE 9859 error: 0 9860 9861 [2016/07/28 11:27:21.377998, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9862 ldb: ldb_trace_next_request: (schema_load)->search 9863 [2016/07/28 11:27:21.378026, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9864 ldb: ldb_trace_next_request: (lazy_commit)->search 9865 [2016/07/28 11:27:21.378048, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9866 ldb: ldb_trace_next_request: (dirsync)->search 9867 [2016/07/28 11:27:21.378070, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9868 ldb: ldb_trace_next_request: (paged_results)->search 9869 [2016/07/28 11:27:21.378110, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9870 ldb: ldb_trace_next_request: (ranged_results)->search 9871 [2016/07/28 11:27:21.378132, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9872 ldb: ldb_trace_next_request: (anr)->search 9873 [2016/07/28 11:27:21.378153, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9874 ldb: ldb_trace_next_request: (server_sort)->search 9875 [2016/07/28 11:27:21.378175, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9876 ldb: ldb_trace_next_request: (asq)->search 9877 [2016/07/28 11:27:21.378196, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9878 ldb: ldb_trace_next_request: (extended_dn_in)->search 9879 [2016/07/28 11:27:21.378221, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9880 ldb: ldb_trace_next_request: (descriptor)->search 9881 [2016/07/28 11:27:21.378244, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9882 ldb: ldb_trace_next_request: (acl)->search 9883 [2016/07/28 11:27:21.378266, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9884 ldb: ldb_trace_next_request: (aclread)->search 9885 [2016/07/28 11:27:21.378288, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9886 ldb: ldb_trace_next_request: (operational)->search 9887 [2016/07/28 11:27:21.378310, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9888 ldb: ldb_trace_next_request: (rdn_name)->search 9889 [2016/07/28 11:27:21.378331, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9890 ldb: ldb_trace_next_request: (extended_dn_out_ldb)->search 9891 [2016/07/28 11:27:21.378355, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9892 ldb: ldb_trace_next_request: (show_deleted)->search 9893 [2016/07/28 11:27:21.378379, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9894 ldb: ldb_trace_next_request: (partition)->search 9895 [2016/07/28 11:27:21.378401, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9896 ldb: ldb_trace_next_request: (tdb)->search 9897 [2016/07/28 11:27:21.378474, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9898 ldb: ldb_trace_next_request: (schema_load)->search 9899 [2016/07/28 11:27:21.378504, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9900 ldb: ldb_trace_next_request: (lazy_commit)->search 9901 [2016/07/28 11:27:21.378526, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9902 ldb: ldb_trace_next_request: (dirsync)->search 9903 [2016/07/28 11:27:21.378547, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9904 ldb: ldb_trace_next_request: (paged_results)->search 9905 [2016/07/28 11:27:21.378569, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9906 ldb: ldb_trace_next_request: (ranged_results)->search 9907 [2016/07/28 11:27:21.378591, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9908 ldb: ldb_trace_next_request: (anr)->search 9909 [2016/07/28 11:27:21.378613, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9910 ldb: ldb_trace_next_request: (server_sort)->search 9911 [2016/07/28 11:27:21.378635, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9912 ldb: ldb_trace_next_request: (asq)->search 9913 [2016/07/28 11:27:21.378656, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9914 ldb: ldb_trace_next_request: (extended_dn_in)->search 9915 [2016/07/28 11:27:21.378690, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9916 ldb: ldb_trace_next_request: (descriptor)->search 9917 [2016/07/28 11:27:21.378715, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9918 ldb: ldb_trace_next_request: (acl)->search 9919 [2016/07/28 11:27:21.378741, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9920 ldb: ldb_trace_next_request: (aclread)->search 9921 [2016/07/28 11:27:21.378765, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9922 ldb: ldb_trace_next_request: (operational)->search 9923 [2016/07/28 11:27:21.378790, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9924 ldb: ldb_trace_next_request: (rdn_name)->search 9925 [2016/07/28 11:27:21.378813, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9926 ldb: ldb_trace_next_request: (extended_dn_out_ldb)->search 9927 [2016/07/28 11:27:21.378840, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9928 ldb: ldb_trace_next_request: (show_deleted)->search 9929 [2016/07/28 11:27:21.378865, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9930 ldb: ldb_trace_next_request: (partition)->search 9931 [2016/07/28 11:27:21.378894, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9932 ldb: partition_request() -> (metadata partition) 9933 [2016/07/28 11:27:21.378917, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9934 ldb: ldb_trace_next_request: (tdb)->search 9935 [2016/07/28 11:27:21.378988, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9936 ldb: partition_request() -> (metadata partition) 9937 [2016/07/28 11:27:21.379013, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9938 ldb: ldb_trace_next_request: (schema_data)->search 9939 [2016/07/28 11:27:21.379036, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9940 ldb: ldb_trace_next_request: (tdb)->search 9941 [2016/07/28 11:27:21.379083, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9942 ldb: partition_request() -> (metadata partition) 9943 [2016/07/28 11:27:21.379114, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9944 ldb: ldb_trace_next_request: (tdb)->search 9945 [2016/07/28 11:27:21.379223, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9946 ldb: partition_request() -> (metadata partition) 9947 [2016/07/28 11:27:21.379251, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9948 ldb: ldb_trace_next_request: (tdb)->search 9949 [2016/07/28 11:27:21.379298, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9950 ldb: partition_request() -> (metadata partition) 9951 [2016/07/28 11:27:21.379322, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9952 ldb: ldb_trace_next_request: (tdb)->search 9953 [2016/07/28 11:27:21.379369, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9954 ldb: partition_request() -> (metadata partition) 9955 [2016/07/28 11:27:21.379393, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9956 ldb: ldb_trace_next_request: (tdb)->search 9957 [2016/07/28 11:27:21.379442, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9958 ldb: ldb_trace_next_request: (descriptor)->search 9959 [2016/07/28 11:27:21.379468, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9960 ldb: ldb_trace_next_request: (acl)->search 9961 [2016/07/28 11:27:21.379496, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9962 ldb: ldb_trace_next_request: (aclread)->search 9963 [2016/07/28 11:27:21.379521, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9964 ldb: ldb_trace_next_request: (operational)->search 9965 [2016/07/28 11:27:21.379547, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9966 ldb: ldb_trace_next_request: (rdn_name)->search 9967 [2016/07/28 11:27:21.379569, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9968 ldb: ldb_trace_next_request: (extended_dn_out_ldb)->search 9969 [2016/07/28 11:27:21.379595, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9970 ldb: ldb_trace_next_request: (show_deleted)->search 9971 [2016/07/28 11:27:21.379619, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9972 ldb: ldb_trace_next_request: (partition)->search 9973 [2016/07/28 11:27:21.379658, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9974 ldb: partition_request() -> (metadata partition) 9975 [2016/07/28 11:27:21.379681, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9976 ldb: ldb_trace_next_request: (tdb)->search 9977 [2016/07/28 11:27:21.379779, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9978 ldb: ldb_trace_response: ENTRY 9979 dn: CN=NTDS Settings,CN=SAMBA-01,CN=Servers,CN=Default-First-Site-Name,CN=Sites,CN=Configuration,DC=brockley-2016,DC=harte-lyne,DC=ca 9980 msDS-Behavior-Version: 4 9981 9982 9983 9984 [2016/07/28 11:27:21.379828, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9985 ldb: ldb_trace_response: DONE 9986 error: 0 9987 9988 [2016/07/28 11:27:21.379890, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9989 ldb: ldb_trace_next_request: (schema_load)->search 9990 [2016/07/28 11:27:21.379919, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9991 ldb: ldb_trace_next_request: (lazy_commit)->search 9992 [2016/07/28 11:27:21.379941, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9993 ldb: ldb_trace_next_request: (dirsync)->search 9994 [2016/07/28 11:27:21.379962, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9995 ldb: ldb_trace_next_request: (paged_results)->search 9996 [2016/07/28 11:27:21.380008, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9997 ldb: ldb_trace_next_request: (ranged_results)->search 9998 [2016/07/28 11:27:21.380030, 10, pid=24487, effective(0, 0), real(0, 0), class=ldb] ../lib/ldb-samba/ldb_wrap.c:72(ldb_wrap_debug) 9999 ldb: ldb_trace_next_request: (anr)->search