<86>Dec 2 05:29:17 userdel[3027644]: delete user 'rooter' <86>Dec 2 05:29:17 userdel[3027644]: removed group 'rooter' owned by 'rooter' <86>Dec 2 05:29:17 userdel[3027644]: removed shadow group 'rooter' owned by 'rooter' <86>Dec 2 05:29:17 groupadd[3027667]: group added to /etc/group: name=rooter, GID=1802 <86>Dec 2 05:29:17 groupadd[3027667]: group added to /etc/gshadow: name=rooter <86>Dec 2 05:29:17 groupadd[3027667]: new group: name=rooter, GID=1802 <86>Dec 2 05:29:17 useradd[3027697]: new user: name=rooter, UID=1802, GID=1802, home=/root, shell=/bin/bash, from=none <86>Dec 2 05:29:17 userdel[3027721]: delete user 'builder' <86>Dec 2 05:29:17 userdel[3027721]: removed group 'builder' owned by 'builder' <86>Dec 2 05:29:17 userdel[3027721]: removed shadow group 'builder' owned by 'builder' <86>Dec 2 05:29:17 groupadd[3027739]: group added to /etc/group: name=builder, GID=1803 <86>Dec 2 05:29:17 groupadd[3027739]: group added to /etc/gshadow: name=builder <86>Dec 2 05:29:17 groupadd[3027739]: new group: name=builder, GID=1803 <86>Dec 2 05:29:17 useradd[3027756]: new user: name=builder, UID=1803, GID=1803, home=/usr/src, shell=/bin/bash, from=none <13>Dec 2 05:29:20 rpmi: libmpdec3-2.5.1-alt3 sisyphus+314490.500.5.1 1675432033 installed <13>Dec 2 05:29:20 rpmi: libgdbm-1.8.3-alt10 sisyphus+278100.1600.1.1 1626059138 installed <13>Dec 2 05:29:20 rpmi: libexpat-2.5.0-alt1 sisyphus+309227.100.1.1 1667075766 installed <13>Dec 2 05:29:20 rpmi: libb2-0.98.1-alt1_1 sisyphus+291614.100.1.1 1638962878 installed <13>Dec 2 05:29:20 rpmi: libp11-kit-1:0.25.3-alt1 sisyphus+334477.100.1.1 1700063204 installed <13>Dec 2 05:29:20 rpmi: libtasn1-4.19.0-alt3 sisyphus+327816.100.1.1 1692802618 installed <13>Dec 2 05:29:20 rpmi: rpm-macros-alternatives-0.5.2-alt2 sisyphus+315270.200.2.1 1676457367 installed <13>Dec 2 05:29:20 rpmi: alternatives-0.5.2-alt2 sisyphus+315270.200.2.1 1676457367 installed <13>Dec 2 05:29:20 rpmi: ca-certificates-2023.07.31-alt1 sisyphus+326137.200.1.1 1690809798 installed <13>Dec 2 05:29:20 rpmi: ca-trust-0.1.4-alt1 sisyphus+308690.100.1.1 1666182992 installed <13>Dec 2 05:29:20 rpmi: p11-kit-trust-1:0.25.3-alt1 sisyphus+334477.100.1.1 1700063204 installed <13>Dec 2 05:29:20 rpmi: libcrypto3-3.1.4-alt1 sisyphus+332632.100.2.1 1698241305 installed <13>Dec 2 05:29:20 rpmi: libssl3-3.1.4-alt1 sisyphus+332632.100.2.1 1698241305 installed <13>Dec 2 05:29:20 rpmi: python3-3.11.6-alt1 sisyphus+331220.100.1.1 1696668078 installed <13>Dec 2 05:29:21 rpmi: python3-base-3.11.6-alt1 sisyphus+331220.100.1.1 1696668078 installed <13>Dec 2 05:29:21 rpmi: python3-module-py3dephell-0.1.0-alt2 sisyphus+328191.600.5.1 1693609196 installed <13>Dec 2 05:29:21 rpmi: tests-for-installed-python3-pkgs-0.1.24-alt2 sisyphus+331059.100.4.1 1696870033 installed <13>Dec 2 05:29:21 rpmi: rpm-build-python3-0.1.24-alt2 sisyphus+331059.100.4.1 1696870033 installed <13>Dec 2 05:29:24 rpmi: python3-module-pkg_resources-1:68.2.2-alt1 sisyphus+329927.100.2.1 1695208272 installed <13>Dec 2 05:29:24 rpmi: python3-module-attrs-23.1.0-alt1 sisyphus+321859.100.1.1 1685027490 installed <13>Dec 2 05:29:24 rpmi: python3-module-idna-3.6-alt1 sisyphus+335330.100.1.2 1701263518 installed <13>Dec 2 05:29:24 rpmi: python3-module-zope.interface-6.0-alt1 sisyphus+326348.600.4.1 1691597456 installed <13>Dec 2 05:29:24 rpmi: python3-module-six-1.16.0-alt2 sisyphus+324249.100.1.1 1688484676 installed <13>Dec 2 05:29:24 rpmi: python3-module-greenlet-3.0.1-alt1 sisyphus+334071.100.1.1 1699560445 installed <13>Dec 2 05:29:24 rpmi: libtcl-8.6.13-alt1 sisyphus+310696.100.1.1 1669548256 installed <13>Dec 2 05:29:24 rpmi: python3-module-pyasn1-0.5.0-alt1 sisyphus+318928.100.2.1 1682330526 installed <13>Dec 2 05:29:24 rpmi: python3-module-multidict-6.0.4-alt1 sisyphus+311250.32340.176.1 1685738354 installed <13>Dec 2 05:29:24 rpmi: python3-module-frozenlist-1.3.3-alt1 sisyphus+311250.30540.176.1 1685737850 installed <13>Dec 2 05:29:24 rpmi: python3-module-charset-normalizer-2.1.1-alt1 sisyphus+311047.100.1.1 1669992940 installed <13>Dec 2 05:29:24 rpmi: libsqlite3-3.44.2-alt1 sisyphus+335409.100.3.3 1701347861 installed <13>Dec 2 05:29:24 rpmi: libnspr-1:4.35-alt1 sisyphus+308164.100.1.1 1665397042 installed <13>Dec 2 05:29:24 rpmi: liblmdb-0.9.31-alt1 sisyphus+330946.40.2.1 1696431544 installed <13>Dec 2 05:29:24 rpmi: libcares-1.19.1-alt1 sisyphus+324326.100.1.1 1688585817 installed <13>Dec 2 05:29:24 rpmi: openssl-3.1.4-alt1 sisyphus+332632.100.2.1 1698241305 installed <13>Dec 2 05:29:24 rpmi: cert-sh-functions-1.0.6-alt1 sisyphus+247768.100.1.1 1584089255 installed <13>Dec 2 05:29:24 rpmi: libnss-3.94.0-alt1 sisyphus+330862.100.1.2 1696335687 installed <13>Dec 2 05:29:24 rpmi: nss-utils-3.94.0-alt1 sisyphus+330862.100.1.2 1696335687 installed <13>Dec 2 05:29:24 rpmi: python3-modules-sqlite3-3.11.6-alt1 sisyphus+331220.100.1.1 1696668078 installed <13>Dec 2 05:29:24 rpmi: python3-module-aiosignal-1.3.1-alt1 sisyphus+314057.100.1.1 1674561191 installed <13>Dec 2 05:29:24 rpmi: python3-module-yarl-1.9.2-alt2 sisyphus+326605.100.1.1 1691404440 installed <13>Dec 2 05:29:24 rpmi: python3-module-pyasn1-modules-0.3.0-alt1 sisyphus+318928.200.2.1 1682330551 installed <13>Dec 2 05:29:25 rpmi: tcl-8.6.13-alt1 sisyphus+310696.100.1.1 1669548256 installed <13>Dec 2 05:29:25 rpmi: python3-module-idna_ssl-1.1.0-alt2 sisyphus+272418.100.1.1 1621876529 installed <13>Dec 2 05:29:25 rpmi: python3-module-hyperlink-21.0.0-alt1.1 sisyphus+304836.100.1.1 1659710964 installed <13>Dec 2 05:29:25 rpmi: python3-module-outcome-1.3.0-alt1 sisyphus+332382.100.1.1 1697882349 installed <13>Dec 2 05:29:25 rpmi: chrooted-0.3.12-alt1 sisyphus+278157.200.2.1 1626055811 installed <13>Dec 2 05:29:25 rpmi: python3-module-sqlparse-0.4.4-alt1 sisyphus+319188.100.1.1 1682328039 installed <13>Dec 2 05:29:25 rpmi: python3-module-markupsafe-1:2.1.3-alt1 sisyphus+323659.100.1.1 1687595160 installed <13>Dec 2 05:29:25 rpmi: python3-module-jinja2-3.1.2-alt1 sisyphus+303664.100.1.1 1657809843 installed <13>Dec 2 05:29:25 rpmi: python3-module-asgiref-3.7.2-alt1 sisyphus+328419.100.1.1 1693492242 installed <13>Dec 2 05:29:25 rpmi: python3-module-click-8.1.7-alt1 sisyphus+327424.100.2.1 1695395098 installed <13>Dec 2 05:29:25 rpmi: python3-module-incremental-22.10.0-alt1 sisyphus+312706.100.1.1 1672404273 installed <13>Dec 2 05:29:25 rpmi: python3-module-constantly-15.1.0-alt6 sisyphus+284854.100.1.1 1631108193 installed <13>Dec 2 05:29:25 rpmi: python3-module-typing_extensions-4.8.0-alt1 sisyphus+332392.100.1.1 1697893352 installed <13>Dec 2 05:29:25 rpmi: python3-module-pygobject-2.28.6-alt13 sisyphus+311250.56700.178.1 1685789723 installed <13>Dec 2 05:29:25 rpmi: python3-module-appdirs-1.4.4-alt1 sisyphus+267613.300.2.1 1620039159 installed <13>Dec 2 05:29:25 rpmi: python3-module-certifi-2023.5.7-alt1 sisyphus+322622.100.1.1 1686217855 installed <13>Dec 2 05:29:25 rpmi: python3-module-openid-3.2.0-alt1 sisyphus+278049.100.2.1 1625998936 installed <13>Dec 2 05:29:25 rpmi: python3-module-z3c-3.0.0-alt4 sisyphus+284857.200.1.1 1631109149 installed <13>Dec 2 05:29:25 rpmi: python3-module-zc-1.0.0-alt7 sisyphus+284857.100.1.1 1631109117 installed <13>Dec 2 05:29:25 rpmi: python3-module-zope-3.3.0-alt9 sisyphus+281937.200.4.1 1628175910 installed <13>Dec 2 05:29:25 rpmi: python3-module-zope.event-5.0-alt1.1 sisyphus+325755.140.2.1 1690991538 installed <13>Dec 2 05:29:25 rpmi: python3-module-packaging-23.2-alt1 sisyphus+330805.100.2.1 1696324248 installed <13>Dec 2 05:29:25 rpmi: python3-module-pycparser-2.21-alt1.1 sisyphus+309935.7300.4.1 1668527005 installed <13>Dec 2 05:29:25 rpmi: python3-module-cffi-1.16.0-alt1 sisyphus+330935.100.2.1 1696495706 installed <13>Dec 2 05:29:25 rpmi: python3-module-cryptography-41.0.7-alt1 sisyphus+335328.100.1.2 1701262411 installed <13>Dec 2 05:29:25 rpmi: python3-module-openssl-23.2.0-alt1 sisyphus+326014.100.1.1 1690659362 installed <13>Dec 2 05:29:25 rpmi: python3-module-urllib3-2:2.1.0-alt1 sisyphus+334413.100.2.1 1700048728 installed <13>Dec 2 05:29:25 rpmi: python3-module-requests-2.31.0-alt1 sisyphus+321663.100.2.1 1684917021 installed <13>Dec 2 05:29:25 rpmi: python3-module-pycares-4.1.2-alt1 sisyphus+311250.45300.178.1 1685783642 installed <13>Dec 2 05:29:25 rpmi: python3-module-astor-0.8.1-alt1.1 sisyphus+315877.100.1.1 1677481862 installed <13>Dec 2 05:29:25 rpmi: python3-module-sortedcontainers-2.4.0-alt1 sisyphus+272042.100.1.1 1621262424 installed <13>Dec 2 05:29:25 rpmi: python3-module-sniffio-1.3.0-alt1 sisyphus+333845.100.3.1 1699533040 installed <13>Dec 2 05:29:25 rpmi: python3-module-trio-0.23.1-alt1 sisyphus+333845.200.3.1 1699533071 installed <13>Dec 2 05:29:25 rpmi: python3-module-dns-1:2.2.0-alt2 sisyphus+320065.60.1.1 1683366881 installed <13>Dec 2 05:29:25 rpmi: python3-module-async-timeout-4.0.3-alt1 sisyphus+329482.100.1.1 1694612611 installed <13>Dec 2 05:29:25 rpmi: python3-module-Cheetah-3.3.3-alt1 sisyphus+332604.100.1.1 1698150527 installed <13>Dec 2 05:29:25 rpmi: python3-module-paste-3.7.1-alt1 sisyphus+332187.100.1.1 1697730831 installed <13>Dec 2 05:29:25 rpmi: python3-module-PasteDeploy-1:3.0.1-alt1 sisyphus+308592.100.1.1 1666070463 installed <13>Dec 2 05:29:25 rpmi: python3-module-PasteScript-1:2.0.2-alt2 sisyphus+272468.100.1.1 1621939313 installed <13>Dec 2 05:29:25 rpmi: libyaml2-0.2.5-alt1 sisyphus+278391.100.1.1 1626094932 installed <13>Dec 2 05:29:25 rpmi: python3-module-yaml-6.0.1-alt1 sisyphus+329508.100.1.1 1694616139 installed <13>Dec 2 05:29:25 rpmi: libuv-1.46.0-alt1 sisyphus+326001.100.1.1 1690655255 installed <13>Dec 2 05:29:25 rpmi: libpython3-3.11.6-alt1 sisyphus+331220.100.1.1 1696668078 installed <13>Dec 2 05:29:25 rpmi: libncurses6-6.3.20220618-alt4 sisyphus+328055.40.2.1 1693213017 installed <13>Dec 2 05:29:25 rpmi: libtinfo-devel-6.3.20220618-alt4 sisyphus+328055.40.2.1 1693213017 installed <13>Dec 2 05:29:25 rpmi: libncurses-devel-6.3.20220618-alt4 sisyphus+328055.40.2.1 1693213017 installed <13>Dec 2 05:29:26 rpmi: python3-dev-3.11.6-alt1 sisyphus+331220.100.1.1 1696668078 installed <13>Dec 2 05:29:26 rpmi: python3-module-setuptools-1:68.2.2-alt1 sisyphus+329927.100.2.1 1695208272 installed <13>Dec 2 05:29:26 rpmi: libmaxminddb-1.7.1-alt1 sisyphus+310839.100.1.1 1669722011 installed <13>Dec 2 05:29:26 rpmi: python3-module-MaxMindDB-2.4.0-alt1 sisyphus+325045.100.1.1 1689589265 installed <13>Dec 2 05:29:26 rpmi: liblz4-1:1.9.4-alt1 sisyphus+309416.100.1.1 1667413000 installed <13>Dec 2 05:29:26 rpmi: libsystemd-1:254.5-alt1.2 sisyphus+331053.100.1.1 1696514800 installed <13>Dec 2 05:29:26 rpmi: libltdl7-2.4.7-alt4 sisyphus+333358.100.1.1 1698858596 installed <13>Dec 2 05:29:26 rpmi: openldap-common-2.6.6-alt1 sisyphus+330946.100.2.1 1696432854 installed <13>Dec 2 05:29:26 rpmi: libverto-0.3.2-alt1_1 sisyphus+321176.2200.10.2 1684806164 installed <13>Dec 2 05:29:26 rpmi: libkeyutils-1.6.3-alt1 sisyphus+266061.100.1.1 1612919567 installed <13>Dec 2 05:29:26 rpmi: libusb-1.0.26-alt2 sisyphus+305525.100.1.1 1660924428 installed <13>Dec 2 05:29:26 rpmi: libhidapi-0.12.0-alt1_1 sisyphus+303213.100.1.1 1657034193 installed <13>Dec 2 05:29:26 rpmi: python3-module-cython-hidapi-0.14.0-alt1 sisyphus+326006.100.1.1 1690656874 installed <13>Dec 2 05:29:26 rpmi: python3-module-serial-3.5-alt2 sisyphus+281995.100.1.1 1628172783 installed <13>Dec 2 05:29:26 rpmi: libevent2.1-2.1.12-alt1 sisyphus+324359.3500.11.1 1689364668 installed <13>Dec 2 05:29:26 rpmi: libev4-4.33-alt3 sisyphus+334335.340.4.1 1699912675 installed <13>Dec 2 05:29:26 rpmi: python3-module-gevent-22.10.2-alt1 sisyphus+311250.61340.178.1 1685796502 installed <13>Dec 2 05:29:26 rpmi: libcom_err-1.46.4.0.5.4cda-alt1 sisyphus+283826.100.1.1 1629975361 installed <86>Dec 2 05:29:26 groupadd[3051507]: group added to /etc/group: name=_keytab, GID=999 <86>Dec 2 05:29:26 groupadd[3051507]: group added to /etc/gshadow: name=_keytab <86>Dec 2 05:29:26 groupadd[3051507]: new group: name=_keytab, GID=999 <13>Dec 2 05:29:26 rpmi: libkrb5-1.21.2-alt1 sisyphus+327265.100.1.1 1692185512 installed <86>Dec 2 05:29:26 groupadd[3051693]: group added to /etc/group: name=sasl, GID=998 <86>Dec 2 05:29:26 groupadd[3051693]: group added to /etc/gshadow: name=sasl <86>Dec 2 05:29:26 groupadd[3051693]: new group: name=sasl, GID=998 <13>Dec 2 05:29:26 rpmi: libsasl2-3-2.1.27-alt2.2 sisyphus+324359.6000.12.1 1689392231 installed <13>Dec 2 05:29:26 rpmi: libldap2-2.6.6-alt1 sisyphus+330946.100.2.1 1696432858 installed <13>Dec 2 05:29:26 rpmi: libpq5-16.1-alt2 sisyphus+335067.4500.2.2 1701150351 installed <13>Dec 2 05:29:26 rpmi: python3-module-psycopg2-2.9.5-alt1 sisyphus+311250.16300.175.1 1685633601 installed <13>Dec 2 05:29:26 rpmi: python3-module-eventlet-0.33.3-alt3 sisyphus+331661.200.2.1 1697210495 installed <13>Dec 2 05:29:26 rpmi: libargon2-20190702-alt1 sisyphus+278291.100.1.1 1626084495 installed <13>Dec 2 05:29:26 rpmi: libpng16-1.6.40-alt1 sisyphus+323732.100.1.1 1687771859 installed <13>Dec 2 05:29:26 rpmi: libbrotlicommon-1.1.0-alt1 sisyphus+328501.100.1.1 1693598420 installed <13>Dec 2 05:29:26 rpmi: libbrotlidec-1.1.0-alt1 sisyphus+328501.100.1.1 1693598420 installed <13>Dec 2 05:29:26 rpmi: libgraphite2-1.3.14-alt2.1 sisyphus+279571.100.1.2 1626605157 installed <13>Dec 2 05:29:27 rpmi: libharfbuzz-8.3.0-alt1 sisyphus+334471.200.2.1 1700075833 installed <13>Dec 2 05:29:27 rpmi: libfreetype-2.13.2-alt1 sisyphus+328677.100.1.1 1693834346 installed <13>Dec 2 05:29:27 rpmi: libfontconfig1-2.14.2-alt8 sisyphus+328444.100.1.1 1693553407 installed <13>Dec 2 05:29:27 rpmi: libXdmcp-1.1.4-alt1 sisyphus+311188.1000.1.1 1670233860 installed <13>Dec 2 05:29:27 rpmi: libXau-1.0.11-alt1 sisyphus+311428.100.1.1 1670577440 installed <13>Dec 2 05:29:27 rpmi: libxcb-1.16-alt1 sisyphus+327325.200.1.1 1692276267 installed <13>Dec 2 05:29:27 rpmi: libX11-locales-3:1.8.7-alt1 sisyphus+330921.200.1.1 1696400315 installed <13>Dec 2 05:29:27 rpmi: libX11-3:1.8.7-alt1 sisyphus+330921.200.1.1 1696400319 installed <13>Dec 2 05:29:27 rpmi: libXrender-0.9.11-alt1 sisyphus+308841.100.1.1 1666436131 installed <13>Dec 2 05:29:27 rpmi: libXft-2.3.8-alt1 sisyphus+331490.400.1.1 1697023273 installed <13>Dec 2 05:29:27 rpmi: libtk-8.6.13-alt1 sisyphus+310696.200.1.1 1669548528 installed <13>Dec 2 05:29:27 rpmi: tk-8.6.13-alt1 sisyphus+310696.200.1.1 1669548528 installed <13>Dec 2 05:29:27 rpmi: tcl-tix-8.4.3-alt4 sisyphus+277292.300.2.1 1625442551 installed <13>Dec 2 05:29:27 rpmi: python3-modules-tkinter-3.11.6-alt1 sisyphus+331220.100.1.1 1696668078 installed <13>Dec 2 05:29:27 rpmi: python3-module-automat-22.10.0-alt1 sisyphus+322927.200.2.1 1686736914 installed <13>Dec 2 05:29:27 rpmi: python3-module-twisted-logger-22.10.0-alt2 sisyphus+325754.100.1.1 1690535804 installed <13>Dec 2 05:29:27 rpmi: python3-module-twisted-core-22.10.0-alt2 sisyphus+325754.100.1.1 1690535804 installed <13>Dec 2 05:29:27 rpmi: python3-module-twisted-names-22.10.0-alt2 sisyphus+325754.100.1.1 1690535804 installed <13>Dec 2 05:29:27 rpmi: python3-module-tornado-6.3.3-alt1.1 sisyphus+329433.100.1.1 1694583816 installed <13>Dec 2 05:29:27 rpmi: python3-module-gunicorn-20.1.0-alt2 sisyphus+297766.100.1.1 1649054912 installed <13>Dec 2 05:29:27 rpmi: python3-module-aiohttp-3.8.5-alt1 sisyphus+329480.100.1.1 1694611987 installed <13>Dec 2 05:29:27 rpmi: python3-module-GeoIP2-4.7.0-alt1 sisyphus+320561.100.1.1 1684172310 installed <13>Dec 2 05:29:27 rpmi: python3-module-django-dbbackend-postgresql-4.2.6-alt1 sisyphus+331106.100.1.1 1696597028 installed <13>Dec 2 05:29:28 rpmi: python3-module-django-4.2.6-alt1 sisyphus+331106.100.1.1 1696597028 installed <13>Dec 2 05:29:28 rpmi: python3-module-django-dbbackend-sqlite3-4.2.6-alt1 sisyphus+331106.100.1.1 1696597028 installed <86>Dec 2 05:29:28 useradd[3057741]: failed adding user 'ldap', exit code: 9 <13>Dec 2 05:29:28 rpmi: openldap-servers-2.6.6-alt1 sisyphus+330946.100.2.1 1696432858 installed <13>Dec 2 05:29:28 rpmi: openldap-clients-2.6.6-alt1 sisyphus+330946.100.2.1 1696432858 installed <13>Dec 2 05:29:28 rpmi: python3-module-ldap-3.4.4-alt1 sisyphus+335255.100.1.1 1701100673 installed <13>Dec 2 05:29:28 rpmi: python3-module-wheel-0.41.3-alt1 sisyphus+333395.100.2.1 1699002471 installed Building target platforms: i586 Building for target i586 Wrote: /usr/src/in/nosrpm/python3-module-django-auth-ldap-4.3.0-alt1.nosrc.rpm (w1.gzdio) <13>Dec 2 05:29:30 rpmi: python3-module-pyproject-installer-0.5.2-alt1 sisyphus+324644.100.2.1 1689089627 installed Installing python3-module-django-auth-ldap-4.3.0-alt1.src.rpm Building target platforms: i586 Building for target i586 Executing(%prep): /bin/sh -e /usr/src/tmp/rpm-tmp.46971 + umask 022 + /bin/mkdir -p /usr/src/RPM/BUILD + cd /usr/src/RPM/BUILD + cd /usr/src/RPM/BUILD + rm -rf python3-module-django-auth-ldap-4.3.0 + echo 'Source #0 (python3-module-django-auth-ldap-4.3.0.tar):' Source #0 (python3-module-django-auth-ldap-4.3.0.tar): + /bin/tar -xf /usr/src/RPM/SOURCES/python3-module-django-auth-ldap-4.3.0.tar + cd python3-module-django-auth-ldap-4.3.0 + /bin/chmod -c -Rf u+rwX,go-w . + exit 0 Executing(%build): /bin/sh -e /usr/src/tmp/rpm-tmp.46971 + umask 022 + /bin/mkdir -p /usr/src/RPM/BUILD + cd /usr/src/RPM/BUILD + cd python3-module-django-auth-ldap-4.3.0 + export 'CFLAGS=-pipe -frecord-gcc-switches -Wall -g -O2 -flto=auto -march=i586 -mtune=generic' + CFLAGS='-pipe -frecord-gcc-switches -Wall -g -O2 -flto=auto -march=i586 -mtune=generic' + export 'CXXFLAGS=-pipe -frecord-gcc-switches -Wall -g -O2 -flto=auto -march=i586 -mtune=generic' + CXXFLAGS='-pipe -frecord-gcc-switches -Wall -g -O2 -flto=auto -march=i586 -mtune=generic' + export 'FFLAGS=-pipe -frecord-gcc-switches -Wall -g -O2 -flto=auto -march=i586 -mtune=generic' + FFLAGS='-pipe -frecord-gcc-switches -Wall -g -O2 -flto=auto -march=i586 -mtune=generic' + /usr/bin/python3 -m pyproject_installer -v build INFO : pyproject_installer.build_cmd._build : Building wheel INFO : pyproject_installer.build_cmd._build : Source tree: /usr/src/RPM/BUILD/python3-module-django-auth-ldap-4.3.0 INFO : pyproject_installer.build_cmd._build : Output dir: /usr/src/RPM/BUILD/python3-module-django-auth-ldap-4.3.0/dist DEBUG : pyproject_installer.lib.build_backend : Validating source path DEBUG : pyproject_installer.lib.build_backend : Checking for PEP517 spec DEBUG : pyproject_installer.lib.build_backend : Parsing configuration file: /usr/src/RPM/BUILD/python3-module-django-auth-ldap-4.3.0/pyproject.toml INFO : backend_caller.py : Calling hook build_wheel in subprocess INFO : backend_caller.py : Build backend: setuptools.build_meta INFO : backend_caller.py : Hook args: ['/usr/src/RPM/BUILD/python3-module-django-auth-ldap-4.3.0/dist'] INFO : backend_caller.py : Hook kwargs: {'config_settings': None} INFO : root : running bdist_wheel INFO : root : running build INFO : root : running build_py INFO : root : creating build INFO : root : creating build/lib INFO : root : creating build/lib/django_auth_ldap INFO : root : copying django_auth_ldap/config.py -> build/lib/django_auth_ldap INFO : root : copying django_auth_ldap/backend.py -> build/lib/django_auth_ldap INFO : root : copying django_auth_ldap/__init__.py -> build/lib/django_auth_ldap INFO : wheel : installing to build/bdist.linux-i686/wheel INFO : root : running install INFO : root : running install_lib INFO : root : creating build/bdist.linux-i686 INFO : root : creating build/bdist.linux-i686/wheel INFO : root : creating build/bdist.linux-i686/wheel/django_auth_ldap INFO : root : copying build/lib/django_auth_ldap/__init__.py -> build/bdist.linux-i686/wheel/django_auth_ldap INFO : root : copying build/lib/django_auth_ldap/backend.py -> build/bdist.linux-i686/wheel/django_auth_ldap INFO : root : copying build/lib/django_auth_ldap/config.py -> build/bdist.linux-i686/wheel/django_auth_ldap INFO : root : running install_egg_info INFO : root : running egg_info INFO : root : creating django_auth_ldap.egg-info INFO : root : writing django_auth_ldap.egg-info/PKG-INFO INFO : root : writing dependency_links to django_auth_ldap.egg-info/dependency_links.txt INFO : root : writing requirements to django_auth_ldap.egg-info/requires.txt INFO : root : writing top-level names to django_auth_ldap.egg-info/top_level.txt INFO : root : writing manifest file 'django_auth_ldap.egg-info/SOURCES.txt' INFO : root : reading manifest file 'django_auth_ldap.egg-info/SOURCES.txt' INFO : root : reading manifest template 'MANIFEST.in' WARNING : root : warning: no previously-included files found matching '.editorconfig' WARNING : root : warning: no previously-included files found matching '.gitignore' WARNING : root : warning: no previously-included files found matching '.readthedocs.yml' WARNING : root : no previously-included directories found matching '.github' INFO : root : adding license file 'LICENSE' INFO : root : writing manifest file 'django_auth_ldap.egg-info/SOURCES.txt' INFO : root : Copying django_auth_ldap.egg-info to build/bdist.linux-i686/wheel/django_auth_ldap-0.0.0-py3.11.egg-info INFO : root : running install_scripts INFO : wheel : creating build/bdist.linux-i686/wheel/django_auth_ldap-0.0.0.dist-info/WHEEL INFO : wheel : creating '/usr/src/RPM/BUILD/python3-module-django-auth-ldap-4.3.0/dist/.tmp-f_kkfji8/django_auth_ldap-0.0.0-py3-none-any.whl' and adding 'build/bdist.linux-i686/wheel' to it INFO : wheel : adding 'django_auth_ldap/__init__.py' INFO : wheel : adding 'django_auth_ldap/backend.py' INFO : wheel : adding 'django_auth_ldap/config.py' INFO : wheel : adding 'django_auth_ldap-0.0.0.dist-info/LICENSE' INFO : wheel : adding 'django_auth_ldap-0.0.0.dist-info/METADATA' INFO : wheel : adding 'django_auth_ldap-0.0.0.dist-info/WHEEL' INFO : wheel : adding 'django_auth_ldap-0.0.0.dist-info/top_level.txt' INFO : wheel : adding 'django_auth_ldap-0.0.0.dist-info/RECORD' INFO : wheel : removing build/bdist.linux-i686/wheel INFO : pyproject_installer.build_cmd._build : Built wheel: django_auth_ldap-0.0.0-py3-none-any.whl + exit 0 Executing(%install): /bin/sh -e /usr/src/tmp/rpm-tmp.82132 + umask 022 + /bin/mkdir -p /usr/src/RPM/BUILD + cd /usr/src/RPM/BUILD + /bin/chmod -Rf u+rwX -- /usr/src/tmp/python3-module-django-auth-ldap-buildroot + : + /bin/rm -rf -- /usr/src/tmp/python3-module-django-auth-ldap-buildroot + PATH=/usr/libexec/rpm-build:/usr/src/bin:/bin:/usr/bin:/usr/X11R6/bin:/usr/games + cd python3-module-django-auth-ldap-4.3.0 + /usr/bin/python3 -m pyproject_installer -v install --destdir=/usr/src/tmp/python3-module-django-auth-ldap-buildroot INFO : pyproject_installer.install_cmd._install : Installing wheel INFO : pyproject_installer.install_cmd._install : Wheel directory: /usr/src/RPM/BUILD/python3-module-django-auth-ldap-4.3.0/dist INFO : pyproject_installer.install_cmd._install : Wheel filename: django_auth_ldap-0.0.0-py3-none-any.whl INFO : pyproject_installer.install_cmd._install : Destination: /usr/src/tmp/python3-module-django-auth-ldap-buildroot DEBUG : pyproject_installer.lib.wheel : Parsing wheel filename DEBUG : pyproject_installer.lib.wheel : Validating wheel file DEBUG : pyproject_installer.lib.wheel : Validating wheel spec version DEBUG : pyproject_installer.lib.wheel : Parsing wheel spec metadata DEBUG : pyproject_installer.lib.wheel : Validating RECORD INFO : pyproject_installer.install_cmd._install : Wheel installation root: /usr/src/tmp/python3-module-django-auth-ldap-buildroot/usr/lib/python3/site-packages INFO : pyproject_installer.install_cmd._install : Extracting wheel DEBUG : pyproject_installer.install_cmd._install : Filtering out not allowed file: django_auth_ldap-0.0.0.dist-info/LICENSE DEBUG : pyproject_installer.install_cmd._install : Filtering out not allowed file: django_auth_ldap-0.0.0.dist-info/WHEEL DEBUG : pyproject_installer.install_cmd._install : Filtering out not allowed file: django_auth_ldap-0.0.0.dist-info/top_level.txt DEBUG : pyproject_installer.install_cmd._install : Filtering out not allowed file: django_auth_ldap-0.0.0.dist-info/RECORD INFO : pyproject_installer.install_cmd._install : Wheel was installed + /usr/lib/rpm/brp-alt Cleaning files in /usr/src/tmp/python3-module-django-auth-ldap-buildroot (auto) Verifying and fixing files in /usr/src/tmp/python3-module-django-auth-ldap-buildroot (binconfig,pkgconfig,libtool,desktop,gnuconfig) Checking contents of files in /usr/src/tmp/python3-module-django-auth-ldap-buildroot/ (default) Compressing files in /usr/src/tmp/python3-module-django-auth-ldap-buildroot (auto) Adjusting library links in /usr/src/tmp/python3-module-django-auth-ldap-buildroot ./usr/lib: (from :0) Verifying ELF objects in /usr/src/tmp/python3-module-django-auth-ldap-buildroot (arch=normal,fhs=normal,lfs=relaxed,lint=relaxed,rpath=normal,stack=normal,textrel=normal,unresolved=normal) Bytecompiling python3 modules in /usr/src/tmp/python3-module-django-auth-ldap-buildroot using /usr/bin/python3 compile /usr/src/tmp/python3-module-django-auth-ldap-buildroot/usr/lib/python3/site-packages/django_auth_ldap/__init__.py compile /usr/src/tmp/python3-module-django-auth-ldap-buildroot/usr/lib/python3/site-packages/django_auth_ldap/backend.py compile /usr/src/tmp/python3-module-django-auth-ldap-buildroot/usr/lib/python3/site-packages/django_auth_ldap/config.py Bytecompiling python3 modules with optimization in /usr/src/tmp/python3-module-django-auth-ldap-buildroot using /usr/bin/python3 -O compile /usr/src/tmp/python3-module-django-auth-ldap-buildroot/usr/lib/python3/site-packages/django_auth_ldap/__init__.py compile /usr/src/tmp/python3-module-django-auth-ldap-buildroot/usr/lib/python3/site-packages/django_auth_ldap/backend.py compile /usr/src/tmp/python3-module-django-auth-ldap-buildroot/usr/lib/python3/site-packages/django_auth_ldap/config.py Bytecompiling python3 modules with optimization-2 in /usr/src/tmp/python3-module-django-auth-ldap-buildroot using /usr/bin/python3 -OO compile /usr/src/tmp/python3-module-django-auth-ldap-buildroot/usr/lib/python3/site-packages/django_auth_ldap/__init__.py compile /usr/src/tmp/python3-module-django-auth-ldap-buildroot/usr/lib/python3/site-packages/django_auth_ldap/backend.py compile /usr/src/tmp/python3-module-django-auth-ldap-buildroot/usr/lib/python3/site-packages/django_auth_ldap/config.py Hardlinking identical .pyc and .opt-?.pyc files './usr/lib/python3/site-packages/django_auth_ldap/__pycache__/__init__.cpython-311.opt-1.pyc' => './usr/lib/python3/site-packages/django_auth_ldap/__pycache__/__init__.cpython-311.pyc' './usr/lib/python3/site-packages/django_auth_ldap/__pycache__/__init__.cpython-311.opt-2.pyc' => './usr/lib/python3/site-packages/django_auth_ldap/__pycache__/__init__.cpython-311.opt-1.pyc' './usr/lib/python3/site-packages/django_auth_ldap/__pycache__/backend.cpython-311.opt-1.pyc' => './usr/lib/python3/site-packages/django_auth_ldap/__pycache__/backend.cpython-311.pyc' './usr/lib/python3/site-packages/django_auth_ldap/__pycache__/config.cpython-311.opt-1.pyc' => './usr/lib/python3/site-packages/django_auth_ldap/__pycache__/config.cpython-311.pyc' Executing(%check): /bin/sh -e /usr/src/tmp/rpm-tmp.82132 + umask 022 + /bin/mkdir -p /usr/src/RPM/BUILD + cd /usr/src/RPM/BUILD + cd python3-module-django-auth-ldap-4.3.0 + export BIN=/usr/src/bin:/bin:/usr/bin:/usr/X11R6/bin:/usr/games:/usr/sbin + BIN=/usr/src/bin:/bin:/usr/bin:/usr/X11R6/bin:/usr/games:/usr/sbin + python3 -Wa -b -m django test --settings tests.settings /usr/lib/python3/site-packages/django/conf/__init__.py:241: RemovedInDjango50Warning: The default value of USE_TZ will change from False to True in Django 5.0. Set USE_TZ to False in your project settings if you want to keep the current default behavior. warnings.warn( Creating test database for alias 'default'... Found 89 test(s). System check identified no issues (0 silenced). <39>Dec 1 23:29:32 slapadd: DIGEST-MD5 common mech free <39>Dec 1 23:29:32 slapadd: DIGEST-MD5 common mech free <39>Dec 1 23:29:32 slapadd: DIGEST-MD5 common mech free <39>Dec 1 23:29:32 slapadd: DIGEST-MD5 common mech free <39>Dec 1 23:29:32 slapadd: DIGEST-MD5 common mech free <167>Dec 1 23:29:32 slapd[3071897]: @(#) $OpenLDAP: slapd 2.6.6 (Oct 4 2023 12:46:41) $ openldap <39>Dec 1 23:29:32 ldapwhoami: DIGEST-MD5 common mech free <167>Dec 1 23:29:32 slapd[3071897]: slapd starting <167>Dec 1 23:29:32 slapd[3071897]: conn=1000 fd=12 ACCEPT from PATH=/usr/src/RPM/BUILD/python3-module-django-auth-ldap-4.3.0/python-ldap-test-40797/ldapi (PATH=/usr/src/RPM/BUILD/python3-module-django-auth-ldap-4.3.0/python-ldap-test-40797/ldapi) <167>Dec 1 23:29:32 slapd[3071897]: conn=1000 op=0 BIND dn="" method=163 <167>Dec 1 23:29:32 slapd[3071897]: conn=1000 op=0 BIND authcid="gidNumber=1803+uidNumber=1803,cn=peercred,cn=external,cn=auth" authzid="gidNumber=1803+uidNumber=1803,cn=peercred,cn=external,cn=auth" <167>Dec 1 23:29:32 slapd[3071897]: conn=1000 op=0 RESULT tag=97 err=0 qtime=0.000038 etime=0.000163 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1000 op=1 EXT oid=1.3.6.1.4.1.4203.1.11.3 <167>Dec 1 23:29:32 slapd[3071897]: conn=1000 op=2 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1000 fd=12 closed <39>Dec 1 23:29:32 ldapwhoami: DIGEST-MD5 common mech free <39>Dec 1 23:29:32 slapadd: DIGEST-MD5 common mech free <167>Dec 1 23:29:32 slapd[3071897]: conn=1001 fd=12 ACCEPT from IP=127.0.0.1:58012 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1001 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1001 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1001 op=0 RESULT tag=97 err=0 qtime=0.000007 etime=0.000113 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1002 fd=13 ACCEPT from IP=127.0.0.1:58016 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1002 op=0 BIND dn="uid=bob,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1002 op=0 BIND dn="uid=bob,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1002 op=0 RESULT tag=97 err=0 qtime=0.000004 etime=0.000043 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1001 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1001 op=1 RESULT tag=97 err=0 qtime=0.000007 etime=0.000047 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1001 op=2 CMP dn="cn=alice_gon,ou=query_groups,o=test" attr="member" <167>Dec 1 23:29:32 slapd[3071897]: conn=1001 op=2 RESULT tag=111 err=6 qtime=0.000007 etime=0.000056 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1001 op=3 CMP dn="cn=mutual_gon,ou=query_groups,o=test" attr="member" <167>Dec 1 23:29:32 slapd[3071897]: conn=1001 op=3 RESULT tag=111 err=6 qtime=0.000008 etime=0.000063 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1002 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1002 op=1 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1002 op=1 RESULT tag=97 err=0 qtime=0.000006 etime=0.000082 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1002 op=2 CMP dn="cn=alice_gon,ou=query_groups,o=test" attr="member" <167>Dec 1 23:29:32 slapd[3071897]: conn=1002 op=2 RESULT tag=111 err=5 qtime=0.000006 etime=0.000043 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1001 op=4 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1001 fd=12 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1002 op=3 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1002 fd=13 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1003 fd=12 ACCEPT from IP=127.0.0.1:58030 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1003 op=0 BIND dn="uid=Alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1003 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1003 op=0 RESULT tag=97 err=0 qtime=0.000006 etime=0.000048 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1003 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1003 op=1 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1003 op=1 RESULT tag=97 err=0 qtime=0.000006 etime=0.000032 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1003 op=2 SRCH base="uid=Alice,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 1 23:29:32 slapd[3071897]: conn=1003 op=2 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1003 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000004 etime=0.000081 nentries=1 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1004 fd=13 ACCEPT from IP=127.0.0.1:58040 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1004 op=0 BIND dn="uid=bob,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1004 op=0 RESULT tag=97 err=49 qtime=0.000005 etime=0.000038 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1004 op=1 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1004 fd=13 closed .<167>Dec 1 23:29:32 slapd[3071897]: conn=1005 fd=13 ACCEPT from IP=127.0.0.1:58054 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1005 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1005 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1005 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000044 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1005 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1005 op=1 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1005 op=1 RESULT tag=97 err=0 qtime=0.000006 etime=0.000030 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1005 op=2 SRCH base="uid=alice,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 1 23:29:32 slapd[3071897]: conn=1005 op=2 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1005 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000005 etime=0.000048 nentries=1 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1006 fd=14 ACCEPT from IP=127.0.0.1:58068 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1006 op=0 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1006 op=0 RESULT tag=97 err=0 qtime=0.000003 etime=0.000022 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1006 op=1 SRCH base="ou=people,o=test" scope=2 deref=0 filter="(uid=not-in-ldap)" <167>Dec 1 23:29:32 slapd[3071897]: conn=1006 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000007 etime=0.000057 nentries=0 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1007 fd=15 ACCEPT from IP=127.0.0.1:58080 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1007 op=0 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1007 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000026 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1007 op=1 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=*)(member=uid=alice,ou=people,o=test))" <167>Dec 1 23:29:32 slapd[3071897]: conn=1007 op=1 ENTRY dn="cn=staff_gon,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1007 op=1 ENTRY dn="cn=active_gon,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1007 op=1 ENTRY dn="cn=nested_gon,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1007 op=1 ENTRY dn="cn=superuser_gon,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1007 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000004 etime=0.000247 nentries=4 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1008 fd=16 ACCEPT from IP=127.0.0.1:58082 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1008 op=0 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1008 op=0 RESULT tag=97 err=0 qtime=0.000004 etime=0.000024 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1008 op=1 SRCH base="ou=people,o=test" scope=2 deref=0 filter="(uid=invalid)" <167>Dec 1 23:29:32 slapd[3071897]: conn=1008 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000005 etime=0.000043 nentries=0 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1008 op=2 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1008 fd=16 closed .<167>Dec 1 23:29:32 slapd[3071897]: conn=1009 fd=16 ACCEPT from IP=127.0.0.1:58092 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1009 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1009 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1009 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000058 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1009 op=1 SRCH base="uid=alice,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 1 23:29:32 slapd[3071897]: conn=1009 op=1 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1009 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000006 etime=0.000077 nentries=1 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1010 fd=17 ACCEPT from IP=127.0.0.1:58100 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1010 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1010 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1010 op=0 RESULT tag=97 err=0 qtime=0.000004 etime=0.000044 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1011 fd=18 ACCEPT from IP=127.0.0.1:58108 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1011 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1011 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1011 op=0 RESULT tag=97 err=0 qtime=0.000003 etime=0.000036 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1003 op=3 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1005 op=3 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1003 fd=12 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1005 fd=13 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1006 op=2 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1006 fd=14 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1010 op=1 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1010 fd=17 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1009 op=2 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1007 op=2 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1009 fd=16 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1007 fd=15 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1011 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1011 op=1 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1011 op=1 RESULT tag=97 err=0 qtime=0.000005 etime=0.000029 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1011 op=2 SRCH base="uid=alice,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 1 23:29:32 slapd[3071897]: conn=1011 op=2 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1011 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000015 etime=0.000153 nentries=1 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1012 fd=12 ACCEPT from IP=127.0.0.1:58120 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1012 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1012 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1012 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000051 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1013 fd=13 ACCEPT from IP=127.0.0.1:58130 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1013 op=0 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1013 op=0 RESULT tag=97 err=0 qtime=0.000004 etime=0.000035 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1013 op=1 SRCH base="uid=alice,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 1 23:29:32 slapd[3071897]: conn=1013 op=1 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1013 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000007 etime=0.000066 nentries=1 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1014 fd=14 ACCEPT from IP=127.0.0.1:58134 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1014 op=0 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1014 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000031 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1014 op=1 SRCH base="uid=bob,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 1 23:29:32 slapd[3071897]: conn=1014 op=1 ENTRY dn="uid=bob,ou=people,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1014 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000005 etime=0.000076 nentries=1 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1015 fd=15 ACCEPT from IP=127.0.0.1:58142 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1015 op=0 BIND dn="uid=Alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1015 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1015 op=0 RESULT tag=97 err=0 qtime=0.000004 etime=0.000054 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1016 fd=16 ACCEPT from IP=127.0.0.1:58144 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1016 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1016 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1016 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000071 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1017 fd=17 ACCEPT from IP=127.0.0.1:58158 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1017 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1017 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000037 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1017 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1017 op=1 RESULT tag=97 err=0 qtime=0.000004 etime=0.000026 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1017 op=2 CMP dn="cn=active_gon,ou=groups,o=test" attr="member" <167>Dec 1 23:29:32 slapd[3071897]: conn=1017 op=2 RESULT tag=111 err=6 qtime=0.000003 etime=0.000027 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1018 fd=19 ACCEPT from IP=127.0.0.1:58164 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1018 op=0 BIND dn="uid=bob,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1018 op=0 BIND dn="uid=bob,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1018 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000042 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1018 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1018 op=1 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1018 op=1 RESULT tag=97 err=0 qtime=0.000005 etime=0.000032 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1018 op=2 CMP dn="cn=active_gon,ou=groups,o=test" attr="member" <167>Dec 1 23:29:32 slapd[3071897]: conn=1018 op=2 RESULT tag=111 err=5 qtime=0.000005 etime=0.000033 text= ..<167>Dec 1 23:29:32 slapd[3071897]: conn=1019 fd=20 ACCEPT from IP=127.0.0.1:58176 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1019 op=0 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1019 op=0 RESULT tag=97 err=0 qtime=0.000004 etime=0.000024 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1019 op=1 SRCH base="ou=people,o=test" scope=2 deref=0 filter="(uid=alice)" <167>Dec 1 23:29:32 slapd[3071897]: conn=1019 op=1 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1019 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000005 etime=0.000209 nentries=1 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1019 op=2 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1019 op=2 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1019 op=2 RESULT tag=97 err=0 qtime=0.000004 etime=0.000038 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1020 fd=21 ACCEPT from IP=127.0.0.1:58188 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1020 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1020 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1020 op=0 RESULT tag=97 err=0 qtime=0.000003 etime=0.000036 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1021 fd=22 ACCEPT from IP=127.0.0.1:58204 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1021 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1021 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1021 op=0 RESULT tag=97 err=0 qtime=0.000003 etime=0.000030 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1021 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1021 op=1 RESULT tag=97 err=0 qtime=0.000007 etime=0.000037 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1021 op=2 CMP dn="cn=active_gon,ou=groups,o=test" attr="member" <167>Dec 1 23:29:32 slapd[3071897]: conn=1021 op=2 RESULT tag=111 err=6 qtime=0.000003 etime=0.000035 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1021 op=3 CMP dn="cn=empty_gon,ou=groups,o=test" attr="member" <167>Dec 1 23:29:32 slapd[3071897]: conn=1021 op=3 RESULT tag=111 err=5 qtime=0.000006 etime=0.000040 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1021 op=4 CMP dn="cn=staff_gon,ou=groups,o=test" attr="member" <167>Dec 1 23:29:32 slapd[3071897]: conn=1021 op=4 RESULT tag=111 err=6 qtime=0.000003 etime=0.000028 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1021 op=5 CMP dn="cn=superuser_gon,ou=groups,o=test" attr="member" <167>Dec 1 23:29:32 slapd[3071897]: conn=1021 op=5 RESULT tag=111 err=6 qtime=0.000005 etime=0.000051 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1022 fd=23 ACCEPT from IP=127.0.0.1:58206 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1022 op=0 BIND dn="uid=bob,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1022 op=0 BIND dn="uid=bob,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1022 op=0 RESULT tag=97 err=0 qtime=0.000004 etime=0.000041 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1022 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1022 op=1 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1022 op=1 RESULT tag=97 err=0 qtime=0.000004 etime=0.000025 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1022 op=2 CMP dn="cn=active_gon,ou=groups,o=test" attr="member" <167>Dec 1 23:29:32 slapd[3071897]: conn=1022 op=2 RESULT tag=111 err=5 qtime=0.000005 etime=0.000030 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1022 op=3 CMP dn="cn=empty_gon,ou=groups,o=test" attr="member" <167>Dec 1 23:29:32 slapd[3071897]: conn=1022 op=3 RESULT tag=111 err=5 qtime=0.000004 etime=0.000032 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1022 op=4 CMP dn="cn=staff_gon,ou=groups,o=test" attr="member" <167>Dec 1 23:29:32 slapd[3071897]: conn=1022 op=4 RESULT tag=111 err=5 qtime=0.000004 etime=0.000032 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1022 op=5 CMP dn="cn=superuser_gon,ou=groups,o=test" attr="member" <167>Dec 1 23:29:32 slapd[3071897]: conn=1022 op=5 RESULT tag=111 err=5 qtime=0.000005 etime=0.000040 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1023 fd=24 ACCEPT from IP=127.0.0.1:58220 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1023 op=0 RESULT tag=97 err=0 qtime=0.000003 etime=0.000019 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1023 op=1 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=*)(member=uid=alice,ou=people,o=test))" <167>Dec 1 23:29:32 slapd[3071897]: conn=1023 op=1 ENTRY dn="cn=staff_gon,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1023 op=1 ENTRY dn="cn=active_gon,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1023 op=1 ENTRY dn="cn=nested_gon,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1023 op=1 ENTRY dn="cn=superuser_gon,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1023 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000006 etime=0.000334 nentries=4 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1024 fd=25 ACCEPT from IP=127.0.0.1:58232 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1024 op=0 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1024 op=0 RESULT tag=97 err=0 qtime=0.000006 etime=0.000037 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1024 op=1 SRCH base="ou=people,o=test" scope=2 deref=0 filter="(uid=alice)" <167>Dec 1 23:29:32 slapd[3071897]: conn=1024 op=1 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1024 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000007 etime=0.000066 nentries=1 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1024 op=2 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1024 op=2 RESULT tag=97 err=0 qtime=0.000005 etime=0.000042 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1012 op=1 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1012 fd=12 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1013 op=2 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1013 fd=13 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1014 fd=14 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1018 op=3 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1015 fd=15 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1019 op=3 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1017 op=3 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1021 op=6 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1019 fd=20 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1016 op=1 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1020 op=1 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1017 fd=17 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1021 fd=22 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1016 fd=16 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1020 fd=21 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1022 op=6 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1023 fd=24 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1022 fd=23 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1018 fd=19 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1025 fd=12 ACCEPT from IP=127.0.0.1:58246 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1025 op=0 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1025 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000020 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1025 op=1 SRCH base="ou=people,o=test" scope=2 deref=0 filter="(uid=alice)" <167>Dec 1 23:29:32 slapd[3071897]: conn=1025 op=1 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1025 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000005 etime=0.000060 nentries=1 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1025 op=2 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1025 op=2 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1025 op=2 RESULT tag=97 err=0 qtime=0.000006 etime=0.000049 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1026 fd=13 ACCEPT from IP=127.0.0.1:58258 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1026 op=0 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1026 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000028 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1026 op=1 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=*)(member=uid=bob,ou=people,o=test))" <167>Dec 1 23:29:32 slapd[3071897]: conn=1026 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000004 etime=0.000158 nentries=0 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1027 fd=14 ACCEPT from IP=127.0.0.1:58264 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1027 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1027 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1027 op=0 RESULT tag=97 err=0 qtime=0.000007 etime=0.000047 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1028 fd=15 ACCEPT from IP=127.0.0.1:58274 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1028 op=0 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1028 op=0 RESULT tag=97 err=0 qtime=0.000007 etime=0.000037 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1028 op=1 SRCH base="ou=people,o=test" scope=2 deref=0 filter="(uid=alice)" <167>Dec 1 23:29:32 slapd[3071897]: conn=1028 op=1 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1028 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000007 etime=0.000091 nentries=1 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1028 op=2 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1028 op=2 RESULT tag=97 err=0 qtime=0.000006 etime=0.000044 text= ..<167>Dec 1 23:29:32 slapd[3071897]: conn=1029 fd=16 ACCEPT from IP=127.0.0.1:58284 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1029 op=0 BIND dn="uid=Alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1029 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1029 op=0 RESULT tag=97 err=0 qtime=0.000003 etime=0.000055 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1029 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1029 op=1 RESULT tag=97 err=0 qtime=0.000009 etime=0.000048 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1029 op=2 SRCH base="uid=Alice,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 1 23:29:32 slapd[3071897]: conn=1029 op=2 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1029 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000006 etime=0.000067 nentries=1 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1030 fd=17 ACCEPT from IP=127.0.0.1:58290 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1030 op=0 BIND dn="uid=Alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1030 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1030 op=0 RESULT tag=97 err=0 qtime=0.000004 etime=0.000041 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1030 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1030 op=1 RESULT tag=97 err=0 qtime=0.000006 etime=0.000034 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1030 op=2 SRCH base="uid=Alice,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 1 23:29:32 slapd[3071897]: conn=1030 op=2 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1030 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000005 etime=0.000097 nentries=1 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1031 fd=19 ACCEPT from IP=127.0.0.1:58302 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1031 op=0 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1031 op=0 RESULT tag=97 err=0 qtime=0.000003 etime=0.000027 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1031 op=1 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=*)(member=uid=alice,ou=people,o=test))" <167>Dec 1 23:29:32 slapd[3071897]: conn=1031 op=1 ENTRY dn="cn=staff_gon,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1031 op=1 ENTRY dn="cn=active_gon,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1031 op=1 ENTRY dn="cn=nested_gon,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1031 op=1 ENTRY dn="cn=superuser_gon,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1031 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000004 etime=0.000082 nentries=4 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1032 fd=20 ACCEPT from IP=127.0.0.1:58314 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1032 op=0 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1032 op=0 RESULT tag=97 err=0 qtime=0.000003 etime=0.000018 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1032 op=1 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=*)(member=uid=bob,ou=people,o=test))" <167>Dec 1 23:29:32 slapd[3071897]: conn=1032 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000006 etime=0.000067 nentries=0 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1033 fd=21 ACCEPT from IP=127.0.0.1:58320 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1033 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1033 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1033 op=0 RESULT tag=97 err=0 qtime=0.000003 etime=0.000038 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1033 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1033 op=1 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1033 op=1 RESULT tag=97 err=0 qtime=0.000006 etime=0.000033 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1033 op=2 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=*)(member=uid=alice,ou=people,o=test))" <167>Dec 1 23:29:32 slapd[3071897]: conn=1033 op=2 ENTRY dn="cn=staff_gon,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1033 op=2 ENTRY dn="cn=active_gon,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1033 op=2 ENTRY dn="cn=nested_gon,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1033 op=2 ENTRY dn="cn=superuser_gon,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1033 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000003 etime=0.000115 nentries=4 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1034 fd=22 ACCEPT from IP=127.0.0.1:58330 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1034 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1034 op=0 RESULT tag=97 err=0 qtime=0.000003 etime=0.000032 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1034 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1034 op=1 RESULT tag=97 err=0 qtime=0.000009 etime=0.000043 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1034 op=2 SRCH base="uid=alice,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 1 23:29:32 slapd[3071897]: conn=1034 op=2 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1034 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000005 etime=0.000051 nentries=1 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1034 op=3 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=posixGroup)(|(gidNumber=1000)(memberUid=alice)))" <167>Dec 1 23:29:32 slapd[3071897]: conn=1034 op=3 ENTRY dn="cn=staff_px,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1034 op=3 ENTRY dn="cn=active_px,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1034 op=3 ENTRY dn="cn=superuser_px,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1034 op=3 SEARCH RESULT tag=101 err=0 qtime=0.000005 etime=0.000278 nentries=3 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1035 fd=23 ACCEPT from IP=127.0.0.1:58336 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1035 op=0 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1035 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000025 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1035 op=1 SRCH base="uid=alice,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 1 23:29:32 slapd[3071897]: conn=1035 op=1 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1035 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000004 etime=0.000048 nentries=1 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1035 op=2 SRCH base="ou=mirror_groups,o=test" scope=2 deref=0 filter="(&(objectClass=groupOfNames)(member=uid=alice,ou=people,o=test))" <167>Dec 1 23:29:32 slapd[3071897]: conn=1035 op=2 ENTRY dn="cn=mirror1,ou=mirror_groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1035 op=2 ENTRY dn="cn=mirror3,ou=mirror_groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1035 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000003 etime=0.000265 nentries=2 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1036 fd=24 ACCEPT from IP=127.0.0.1:58340 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1036 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1036 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1036 op=0 RESULT tag=97 err=0 qtime=0.000004 etime=0.000035 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1036 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1036 op=1 RESULT tag=97 err=0 qtime=0.000004 etime=0.000028 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1036 op=2 SRCH base="ou=mirror_groups,o=test" scope=2 deref=0 filter="(&(objectClass=groupOfNames)(member=uid=alice,ou=people,o=test))" <167>Dec 1 23:29:32 slapd[3071897]: conn=1036 op=2 ENTRY dn="cn=mirror1,ou=mirror_groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1036 op=2 ENTRY dn="cn=mirror3,ou=mirror_groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1036 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000003 etime=0.000071 nentries=2 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1025 op=3 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1025 fd=12 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1026 op=2 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1026 fd=13 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1027 fd=14 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1029 op=3 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1028 op=3 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1029 fd=16 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1028 fd=15 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1031 op=2 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1032 op=2 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1030 fd=17 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1031 fd=19 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1033 fd=21 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1034 op=4 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1032 fd=20 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1034 fd=22 closed .<167>Dec 1 23:29:32 slapd[3071897]: conn=1037 fd=12 ACCEPT from IP=127.0.0.1:58354 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1037 op=0 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1037 op=0 RESULT tag=97 err=0 qtime=0.000006 etime=0.000028 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1037 op=1 SRCH base="uid=alice,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 1 23:29:32 slapd[3071897]: conn=1037 op=1 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1037 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000005 etime=0.000046 nentries=1 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1037 op=2 SRCH base="ou=mirror_groups,o=test" scope=2 deref=0 filter="(&(objectClass=groupOfNames)(member=uid=alice,ou=people,o=test))" <167>Dec 1 23:29:32 slapd[3071897]: conn=1037 op=2 ENTRY dn="cn=mirror1,ou=mirror_groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1037 op=2 ENTRY dn="cn=mirror3,ou=mirror_groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1037 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000005 etime=0.000063 nentries=2 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1038 fd=13 ACCEPT from IP=127.0.0.1:58358 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1038 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1038 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1038 op=0 RESULT tag=97 err=0 qtime=0.000007 etime=0.000044 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1038 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1038 op=1 RESULT tag=97 err=0 qtime=0.000007 etime=0.000043 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1038 op=2 SRCH base="ou=mirror_groups,o=test" scope=2 deref=0 filter="(&(objectClass=groupOfNames)(member=uid=alice,ou=people,o=test))" <167>Dec 1 23:29:32 slapd[3071897]: conn=1038 op=2 ENTRY dn="cn=mirror1,ou=mirror_groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1038 op=2 ENTRY dn="cn=mirror3,ou=mirror_groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1038 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000005 etime=0.000057 nentries=2 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1039 fd=14 ACCEPT from IP=127.0.0.1:58366 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1039 op=0 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1039 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000027 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1039 op=1 SRCH base="uid=alice,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 1 23:29:32 slapd[3071897]: conn=1039 op=1 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1039 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000004 etime=0.000035 nentries=1 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1039 op=2 SRCH base="ou=mirror_groups,o=test" scope=2 deref=0 filter="(&(objectClass=groupOfNames)(member=uid=alice,ou=people,o=test))" <167>Dec 1 23:29:32 slapd[3071897]: conn=1039 op=2 ENTRY dn="cn=mirror1,ou=mirror_groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1039 op=2 ENTRY dn="cn=mirror3,ou=mirror_groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1039 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000005 etime=0.000064 nentries=2 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1040 fd=15 ACCEPT from IP=127.0.0.1:58374 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1040 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1040 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1040 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000034 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1040 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1040 op=1 RESULT tag=97 err=0 qtime=0.000006 etime=0.000030 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1040 op=2 SRCH base="ou=mirror_groups,o=test" scope=2 deref=0 filter="(&(objectClass=groupOfNames)(member=uid=alice,ou=people,o=test))" <167>Dec 1 23:29:32 slapd[3071897]: conn=1040 op=2 ENTRY dn="cn=mirror1,ou=mirror_groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1040 op=2 ENTRY dn="cn=mirror3,ou=mirror_groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1040 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000006 etime=0.000118 nentries=2 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1041 fd=16 ACCEPT from IP=127.0.0.1:58384 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1041 op=0 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1041 op=0 RESULT tag=97 err=0 qtime=0.000004 etime=0.000020 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1041 op=1 SRCH base="uid=alice,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 1 23:29:32 slapd[3071897]: conn=1041 op=1 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1041 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000006 etime=0.000047 nentries=1 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1041 op=2 SRCH base="ou=mirror_groups,o=test" scope=2 deref=0 filter="(&(objectClass=groupOfNames)(member=uid=alice,ou=people,o=test))" <167>Dec 1 23:29:32 slapd[3071897]: conn=1041 op=2 ENTRY dn="cn=mirror1,ou=mirror_groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1041 op=2 ENTRY dn="cn=mirror3,ou=mirror_groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1041 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000005 etime=0.000097 nentries=2 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1042 fd=17 ACCEPT from IP=127.0.0.1:58388 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1042 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1042 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1042 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000045 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1042 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1042 op=1 RESULT tag=97 err=0 qtime=0.000006 etime=0.000038 text= <167>Dec 1 23:29:32 slapd[3071897]: connection_input: conn=1042 deferring operation: binding <167>Dec 1 23:29:32 slapd[3071897]: conn=1042 op=2 SRCH base="ou=mirror_groups,o=test" scope=2 deref=0 filter="(&(objectClass=groupOfNames)(member=uid=alice,ou=people,o=test))" <167>Dec 1 23:29:32 slapd[3071897]: conn=1042 op=2 ENTRY dn="cn=mirror3,ou=mirror_groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1042 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000049 etime=0.000123 nentries=2 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1043 fd=19 ACCEPT from IP=127.0.0.1:58396 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1043 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1043 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1043 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000071 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1043 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1043 op=1 RESULT tag=97 err=0 qtime=0.000006 etime=0.000038 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1043 op=2 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=*)(member=uid=alice,ou=people,o=test))" <167>Dec 1 23:29:32 slapd[3071897]: conn=1043 op=2 ENTRY dn="cn=staff_gon,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1043 op=2 ENTRY dn="cn=active_gon,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1043 op=2 ENTRY dn="cn=nested_gon,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1043 op=2 ENTRY dn="cn=superuser_gon,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1043 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000005 etime=0.000380 nentries=4 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1044 fd=20 ACCEPT from IP=127.0.0.1:58402 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1044 op=0 BIND dn="uid=bob,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1044 op=0 RESULT tag=97 err=49 qtime=0.000006 etime=0.000055 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1045 fd=21 ACCEPT from IP=127.0.0.1:58414 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1045 op=0 BIND dn="uid=dreßler,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1045 op=0 BIND dn="uid=dreßler,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1045 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000066 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1045 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1045 op=1 RESULT tag=97 err=0 qtime=0.000007 etime=0.000037 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1045 op=2 CMP dn="cn=dreßler_gon,ou=query_groups,o=test" attr="member" <167>Dec 1 23:29:32 slapd[3071897]: conn=1045 op=2 RESULT tag=111 err=6 qtime=0.000005 etime=0.000051 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1046 fd=22 ACCEPT from IP=127.0.0.1:58422 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1046 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1046 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1046 op=0 RESULT tag=97 err=0 qtime=0.000004 etime=0.000041 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1046 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1046 op=1 RESULT tag=97 err=0 qtime=0.000022 etime=0.000048 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1046 op=2 CMP dn="cn=other_gon,ou=moregroups,o=test" attr="member" <167>Dec 1 23:29:32 slapd[3071897]: conn=1046 op=2 RESULT tag=111 err=5 qtime=0.000007 etime=0.000057 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1047 fd=26 ACCEPT from IP=127.0.0.1:58424 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1047 op=0 BIND dn="uid=bob,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1047 op=0 BIND dn="uid=bob,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1047 op=0 RESULT tag=97 err=0 qtime=0.000004 etime=0.000037 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1047 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1047 op=1 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1047 op=1 RESULT tag=97 err=0 qtime=0.000004 etime=0.000022 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1047 op=2 CMP dn="cn=other_gon,ou=moregroups,o=test" attr="member" <167>Dec 1 23:29:32 slapd[3071897]: conn=1047 op=2 RESULT tag=111 err=6 qtime=0.000006 etime=0.000047 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1047 op=4 SRCH base="ou=moregroups,o=test" scope=2 deref=0 filter="(&(objectClass=groupOfNames)(member=uid=bob,ou=people,o=test))" <167>Dec 1 23:29:32 slapd[3071897]: conn=1047 op=3 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=groupOfNames)(member=uid=bob,ou=people,o=test))" <167>Dec 1 23:29:32 slapd[3071897]: conn=1047 op=4 ENTRY dn="cn=other_gon,ou=moregroups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1047 op=4 SEARCH RESULT tag=101 err=0 qtime=0.000009 etime=0.000066 nentries=1 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1047 op=3 SEARCH RESULT tag=101 err=0 qtime=0.000018 etime=0.000086 nentries=0 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1048 fd=27 ACCEPT from IP=127.0.0.1:58432 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1048 op=0 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1048 op=0 RESULT tag=97 err=0 qtime=0.000006 etime=0.000031 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1048 op=1 SRCH base="ou=people,o=test" scope=2 deref=0 filter="(uid=alice)" <167>Dec 1 23:29:32 slapd[3071897]: conn=1048 op=1 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1048 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000005 etime=0.000070 nentries=1 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1048 op=2 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1048 op=2 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1048 op=2 RESULT tag=97 err=0 qtime=0.000007 etime=0.000054 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1037 op=3 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1037 fd=12 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1038 op=3 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1038 fd=13 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1039 op=3 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1039 fd=14 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1040 fd=15 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1042 fd=17 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1041 fd=16 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1043 op=3 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1043 fd=19 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1045 op=3 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1045 fd=21 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1047 op=5 UNBIND .<167>Dec 1 23:29:32 slapd[3071897]: conn=1046 fd=22 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1047 fd=26 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1049 fd=12 ACCEPT from IP=127.0.0.1:58440 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1049 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1049 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1049 op=0 RESULT tag=97 err=0 qtime=0.000004 etime=0.000038 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1049 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1049 op=1 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1049 op=1 RESULT tag=97 err=0 qtime=0.000011 etime=0.000047 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1049 op=2 CMP dn="cn=alice_gon,ou=query_groups,o=test" attr="member" <167>Dec 1 23:29:32 slapd[3071897]: conn=1049 op=2 RESULT tag=111 err=6 qtime=0.000008 etime=0.000058 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1050 fd=13 ACCEPT from IP=127.0.0.1:58442 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1050 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1050 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1050 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000054 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1050 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1050 op=1 RESULT tag=97 err=0 qtime=0.000007 etime=0.000038 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1050 op=2 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=*)(|(member=uid=alice,ou=people,o=test)))" <167>Dec 1 23:29:32 slapd[3071897]: conn=1050 op=2 ENTRY dn="cn=staff_gon,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1050 op=2 ENTRY dn="cn=active_gon,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1050 op=2 ENTRY dn="cn=nested_gon,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1050 op=2 ENTRY dn="cn=superuser_gon,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1050 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000007 etime=0.000141 nentries=4 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1050 op=3 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=*)(|(member=cn=nested_gon,ou=groups,o=test)(member=cn=staff_gon,ou=groups,o=test)(member=cn=active_gon,ou=groups,o=test)(member=cn=superuser_gon,ou=groups,o=test)))" <167>Dec 1 23:29:32 slapd[3071897]: conn=1050 op=3 ENTRY dn="cn=parent_gon,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1050 op=3 SEARCH RESULT tag=101 err=0 qtime=0.000006 etime=0.000092 nentries=1 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1050 op=4 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=*)(|(member=cn=parent_gon,ou=groups,o=test)))" <167>Dec 1 23:29:32 slapd[3071897]: conn=1050 op=4 ENTRY dn="cn=circular_gon,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1050 op=4 SEARCH RESULT tag=101 err=0 qtime=0.000005 etime=0.000208 nentries=1 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1050 op=5 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=*)(|(member=cn=circular_gon,ou=groups,o=test)))" <167>Dec 1 23:29:32 slapd[3071897]: conn=1050 op=5 ENTRY dn="cn=nested_gon,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1050 op=5 SEARCH RESULT tag=101 err=0 qtime=0.000006 etime=0.000080 nentries=1 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1051 fd=14 ACCEPT from IP=127.0.0.1:58444 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1051 op=0 BIND dn="uid=bob,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1051 op=0 BIND dn="uid=bob,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1051 op=0 RESULT tag=97 err=0 qtime=0.000004 etime=0.000038 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1051 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1051 op=1 RESULT tag=97 err=0 qtime=0.000007 etime=0.000045 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1051 op=2 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=*)(|(member=uid=bob,ou=people,o=test)))" <167>Dec 1 23:29:32 slapd[3071897]: conn=1051 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000007 etime=0.000057 nentries=0 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1052 fd=15 ACCEPT from IP=127.0.0.1:58450 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1052 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1052 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1052 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000054 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1052 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1052 op=1 RESULT tag=97 err=0 qtime=0.000005 etime=0.000029 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1052 op=2 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=groupOfNames)(|(member=uid=alice,ou=people,o=test)))" <167>Dec 1 23:29:32 slapd[3071897]: conn=1052 op=2 ENTRY dn="cn=staff_gon,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1052 op=2 ENTRY dn="cn=active_gon,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1052 op=2 ENTRY dn="cn=nested_gon,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1052 op=2 ENTRY dn="cn=superuser_gon,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1052 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000008 etime=0.000136 nentries=4 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1052 op=3 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=groupOfNames)(|(member=cn=nested_gon,ou=groups,o=test)(member=cn=staff_gon,ou=groups,o=test)(member=cn=active_gon,ou=groups,o=test)(member=cn=superuser_gon,ou=groups,o=test)))" <167>Dec 1 23:29:32 slapd[3071897]: conn=1052 op=3 ENTRY dn="cn=parent_gon,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1052 op=3 SEARCH RESULT tag=101 err=0 qtime=0.000006 etime=0.000079 nentries=1 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1052 op=4 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=groupOfNames)(|(member=cn=parent_gon,ou=groups,o=test)))" <167>Dec 1 23:29:32 slapd[3071897]: conn=1052 op=4 ENTRY dn="cn=circular_gon,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1052 op=4 SEARCH RESULT tag=101 err=0 qtime=0.000003 etime=0.000059 nentries=1 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1052 op=5 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=groupOfNames)(|(member=cn=circular_gon,ou=groups,o=test)))" <167>Dec 1 23:29:32 slapd[3071897]: conn=1052 op=5 ENTRY dn="cn=nested_gon,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1052 op=5 SEARCH RESULT tag=101 err=0 qtime=0.000004 etime=0.000065 nentries=1 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1053 fd=16 ACCEPT from IP=127.0.0.1:58452 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1053 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1053 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1053 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000051 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1054 fd=17 ACCEPT from IP=127.0.0.1:58464 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1054 op=0 BIND dn="uid=bob,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1054 op=0 BIND dn="uid=bob,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1054 op=0 RESULT tag=97 err=0 qtime=0.000010 etime=0.000069 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1053 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1053 op=1 RESULT tag=97 err=0 qtime=0.000009 etime=0.000042 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1053 op=2 CMP dn="cn=alice_gon,ou=query_groups,o=test" attr="member" <167>Dec 1 23:29:32 slapd[3071897]: conn=1053 op=2 RESULT tag=111 err=6 qtime=0.000006 etime=0.000043 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1053 op=3 CMP dn="cn=mutual_gon,ou=query_groups,o=test" attr="member" <167>Dec 1 23:29:32 slapd[3071897]: conn=1053 op=3 RESULT tag=111 err=6 qtime=0.000007 etime=0.000053 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1054 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1054 op=1 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1054 op=1 RESULT tag=97 err=0 qtime=0.000009 etime=0.000075 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1054 op=2 CMP dn="cn=alice_gon,ou=query_groups,o=test" attr="member" <167>Dec 1 23:29:32 slapd[3071897]: conn=1054 op=2 RESULT tag=111 err=5 qtime=0.000009 etime=0.000055 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1054 op=3 CMP dn="cn=bob_gon,ou=query_groups,o=test" attr="member" <167>Dec 1 23:29:32 slapd[3071897]: conn=1054 op=3 RESULT tag=111 err=6 qtime=0.000007 etime=0.000049 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1055 fd=19 ACCEPT from IP=127.0.0.1:58474 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1055 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1055 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1055 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000039 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1055 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1055 op=1 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1055 op=1 RESULT tag=97 err=0 qtime=0.000005 etime=0.000034 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1055 op=2 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=groupOfNames)(|(member=uid=alice,ou=people,o=test)))" <167>Dec 1 23:29:32 slapd[3071897]: conn=1055 op=3 SRCH base="ou=moregroups,o=test" scope=2 deref=0 filter="(&(objectClass=groupOfNames)(|(member=uid=alice,ou=people,o=test)))" <167>Dec 1 23:29:32 slapd[3071897]: conn=1055 op=2 ENTRY dn="cn=staff_gon,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1055 op=2 ENTRY dn="cn=active_gon,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1055 op=3 SEARCH RESULT tag=101 err=0 qtime=0.000010 etime=0.000071 nentries=0 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1055 op=2 ENTRY dn="cn=nested_gon,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1055 op=2 ENTRY dn="cn=superuser_gon,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1055 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000015 etime=0.000115 nentries=4 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1055 op=4 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=groupOfNames)(|(member=cn=nested_gon,ou=groups,o=test)(member=cn=staff_gon,ou=groups,o=test)(member=cn=active_gon,ou=groups,o=test)(member=cn=superuser_gon,ou=groups,o=test)))" <167>Dec 1 23:29:32 slapd[3071897]: conn=1055 op=4 ENTRY dn="cn=parent_gon,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1055 op=5 SRCH base="ou=moregroups,o=test" scope=2 deref=0 filter="(&(objectClass=groupOfNames)(|(member=cn=nested_gon,ou=groups,o=test)(member=cn=staff_gon,ou=groups,o=test)(member=cn=active_gon,ou=groups,o=test)(member=cn=superuser_gon,ou=groups,o=test)))" <167>Dec 1 23:29:32 slapd[3071897]: conn=1055 op=5 SEARCH RESULT tag=101 err=0 qtime=0.000005 etime=0.000059 nentries=0 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1055 op=7 SRCH base="ou=moregroups,o=test" scope=2 deref=0 filter="(&(objectClass=groupOfNames)(|(member=cn=parent_gon,ou=groups,o=test)))" <167>Dec 1 23:29:32 slapd[3071897]: conn=1055 op=6 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=groupOfNames)(|(member=cn=parent_gon,ou=groups,o=test)))" <167>Dec 1 23:29:32 slapd[3071897]: conn=1055 op=7 SEARCH RESULT tag=101 err=0 qtime=0.000006 etime=0.000037 nentries=0 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1055 op=6 ENTRY dn="cn=circular_gon,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1055 op=6 SEARCH RESULT tag=101 err=0 qtime=0.000011 etime=0.000082 nentries=1 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1055 op=9 SRCH base="ou=moregroups,o=test" scope=2 deref=0 filter="(&(objectClass=groupOfNames)(|(member=cn=circular_gon,ou=groups,o=test)))" <167>Dec 1 23:29:32 slapd[3071897]: conn=1055 op=8 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=groupOfNames)(|(member=cn=circular_gon,ou=groups,o=test)))" <167>Dec 1 23:29:32 slapd[3071897]: conn=1055 op=9 SEARCH RESULT tag=101 err=0 qtime=0.000019 etime=0.000064 nentries=0 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1055 op=8 ENTRY dn="cn=nested_gon,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1055 op=8 SEARCH RESULT tag=101 err=0 qtime=0.000025 etime=0.000106 nentries=1 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1056 fd=20 ACCEPT from IP=127.0.0.1:58484 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1056 op=0 BIND dn="uid=bob,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1056 op=0 BIND dn="uid=bob,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1056 op=0 RESULT tag=97 err=0 qtime=0.000004 etime=0.000040 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1056 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1056 op=1 RESULT tag=97 err=0 qtime=0.000004 etime=0.000022 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1056 op=2 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=groupOfNames)(|(member=uid=bob,ou=people,o=test)))" <167>Dec 1 23:29:32 slapd[3071897]: conn=1056 op=3 SRCH base="ou=moregroups,o=test" scope=2 deref=0 filter="(&(objectClass=groupOfNames)(|(member=uid=bob,ou=people,o=test)))" <167>Dec 1 23:29:32 slapd[3071897]: conn=1056 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000011 etime=0.000042 nentries=0 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1056 op=3 ENTRY dn="cn=other_gon,ou=moregroups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1056 op=3 SEARCH RESULT tag=101 err=0 qtime=0.000006 etime=0.000060 nentries=1 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1056 op=4 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=groupOfNames)(|(member=cn=other_gon,ou=moregroups,o=test)))" <167>Dec 1 23:29:32 slapd[3071897]: conn=1056 op=5 SRCH base="ou=moregroups,o=test" scope=2 deref=0 filter="(&(objectClass=groupOfNames)(|(member=cn=other_gon,ou=moregroups,o=test)))" <167>Dec 1 23:29:32 slapd[3071897]: conn=1056 op=4 SEARCH RESULT tag=101 err=0 qtime=0.000012 etime=0.000045 nentries=0 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1056 op=5 SEARCH RESULT tag=101 err=0 qtime=0.000007 etime=0.000045 nentries=0 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1057 fd=21 ACCEPT from IP=127.0.0.1:58500 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1057 op=0 BIND dn="uid=Alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1057 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1057 op=0 RESULT tag=97 err=0 qtime=0.000008 etime=0.000059 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1058 fd=22 ACCEPT from IP=127.0.0.1:58510 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1058 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1058 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1058 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000047 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1059 fd=26 ACCEPT from IP=127.0.0.1:58512 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1059 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1059 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1059 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000055 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1060 fd=28 ACCEPT from IP=127.0.0.1:58516 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1060 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1060 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1060 op=0 RESULT tag=97 err=0 qtime=0.000004 etime=0.000060 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1061 fd=29 ACCEPT from IP=127.0.0.1:58522 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1061 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1061 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1061 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000044 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1062 fd=30 ACCEPT from IP=127.0.0.1:58538 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1062 op=0 BIND dn="uid=bob,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1062 op=0 BIND dn="uid=bob,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1062 op=0 RESULT tag=97 err=0 qtime=0.000009 etime=0.000072 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1062 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1062 op=1 RESULT tag=97 err=0 qtime=0.000008 etime=0.000043 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1062 op=2 SRCH base="uid=bob,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 1 23:29:32 slapd[3071897]: conn=1062 op=2 ENTRY dn="uid=bob,ou=people,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1062 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000004 etime=0.000046 nentries=1 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1063 fd=31 ACCEPT from IP=127.0.0.1:58550 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1063 op=0 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1063 op=0 RESULT tag=97 err=0 qtime=0.000004 etime=0.000019 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1063 op=1 SRCH base="ou=people,o=test" scope=2 deref=0 filter="(uid=alice)" <167>Dec 1 23:29:32 slapd[3071897]: conn=1063 op=1 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1063 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000003 etime=0.000040 nentries=1 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1063 op=2 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1063 op=2 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1063 op=2 RESULT tag=97 err=0 qtime=0.000006 etime=0.000042 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1064 fd=32 ACCEPT from IP=127.0.0.1:58558 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1064 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1064 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1064 op=0 RESULT tag=97 err=0 qtime=0.000003 etime=0.000031 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1064 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1064 op=1 RESULT tag=97 err=0 qtime=0.000003 etime=0.000018 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1065 fd=33 ACCEPT from IP=127.0.0.1:58574 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1065 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1065 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1065 op=0 RESULT tag=97 err=0 qtime=0.000003 etime=0.000025 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1066 fd=34 ACCEPT from IP=127.0.0.1:58588 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1066 op=0 BIND dn="uid=bob,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1066 op=0 BIND dn="uid=bob,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1066 op=0 RESULT tag=97 err=0 qtime=0.000003 etime=0.000028 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1065 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1065 op=1 RESULT tag=97 err=0 qtime=0.000007 etime=0.000038 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1065 op=2 CMP dn="cn=alice_gon,ou=query_groups,o=test" attr="member" <167>Dec 1 23:29:32 slapd[3071897]: conn=1065 op=2 RESULT tag=111 err=6 qtime=0.000003 etime=0.000026 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1066 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1066 op=1 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1066 op=1 RESULT tag=97 err=0 qtime=0.000003 etime=0.000017 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1066 op=2 CMP dn="cn=alice_gon,ou=query_groups,o=test" attr="member" <167>Dec 1 23:29:32 slapd[3071897]: conn=1066 op=2 RESULT tag=111 err=5 qtime=0.000003 etime=0.000020 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1066 op=3 CMP dn="cn=bob_gon,ou=query_groups,o=test" attr="member" <167>Dec 1 23:29:32 slapd[3071897]: conn=1066 op=3 RESULT tag=111 err=6 qtime=0.000003 etime=0.000020 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1067 fd=35 ACCEPT from IP=127.0.0.1:58600 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1067 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1067 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1067 op=0 RESULT tag=97 err=0 qtime=0.000004 etime=0.000025 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1068 fd=36 ACCEPT from IP=127.0.0.1:58606 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1068 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1068 op=0 RESULT tag=97 err=53 qtime=0.000004 etime=0.000020 text=unauthenticated bind (DN with no password) disallowed <167>Dec 1 23:29:32 slapd[3071897]: conn=1068 op=1 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1068 fd=36 closed .<167>Dec 1 23:29:32 slapd[3071897]: conn=1069 fd=36 ACCEPT from IP=127.0.0.1:58614 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1069 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1069 op=0 RESULT tag=97 err=53 qtime=0.000003 etime=0.000022 text=unauthenticated bind (DN with no password) disallowed <167>Dec 1 23:29:32 slapd[3071897]: conn=1069 op=1 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1069 fd=36 closed .<167>Dec 1 23:29:32 slapd[3071897]: conn=1070 fd=36 ACCEPT from IP=127.0.0.1:58626 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1070 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1070 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1070 op=0 RESULT tag=97 err=0 qtime=0.000003 etime=0.000031 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1071 fd=37 ACCEPT from IP=127.0.0.1:58632 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1071 op=0 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1071 op=0 RESULT tag=97 err=0 qtime=0.000004 etime=0.000016 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1071 op=1 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=*)(member=uid=alice,ou=people,o=test))" <167>Dec 1 23:29:32 slapd[3071897]: conn=1071 op=1 ENTRY dn="cn=staff_gon,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1071 op=1 ENTRY dn="cn=active_gon,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1071 op=1 ENTRY dn="cn=nested_gon,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1071 op=1 ENTRY dn="cn=superuser_gon,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1071 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000002 etime=0.000078 nentries=4 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1072 fd=38 ACCEPT from IP=127.0.0.1:58648 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1072 op=0 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1072 op=0 RESULT tag=97 err=0 qtime=0.000003 etime=0.000015 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1072 op=1 SRCH base="uid=bogus,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 1 23:29:32 slapd[3071897]: conn=1072 op=1 SEARCH RESULT tag=101 err=32 qtime=0.000006 etime=0.000047 nentries=0 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1072 op=2 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1072 fd=38 closed .<167>Dec 1 23:29:32 slapd[3071897]: conn=1073 fd=38 ACCEPT from IP=127.0.0.1:58664 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1073 op=0 BIND dn="uid=bob,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1073 op=0 RESULT tag=97 err=49 qtime=0.000003 etime=0.000027 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1073 op=1 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1073 fd=38 closed .<167>Dec 1 23:29:32 slapd[3071897]: conn=1074 fd=38 ACCEPT from IP=127.0.0.1:58680 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1074 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1074 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1074 op=0 RESULT tag=97 err=0 qtime=0.000004 etime=0.000027 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1074 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1074 op=1 RESULT tag=97 err=0 qtime=0.000007 etime=0.000037 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1074 op=2 SRCH base="uid=alice,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 1 23:29:32 slapd[3071897]: conn=1074 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000003 etime=0.000030 nentries=1 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1049 op=3 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1049 fd=12 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1050 op=6 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1050 fd=13 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1051 op=3 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1051 fd=14 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1052 op=6 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1053 op=4 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1052 fd=15 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1056 op=6 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1056 fd=20 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1055 op=10 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1055 fd=19 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1054 op=4 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1057 op=1 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1054 fd=17 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1053 fd=16 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1059 op=1 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1058 fd=22 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1057 fd=21 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1059 fd=26 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1061 op=1 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1061 fd=29 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1060 op=1 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1060 fd=28 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1062 op=3 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1062 fd=30 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1064 op=2 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1064 fd=32 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1070 op=1 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1067 op=1 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1070 fd=36 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1071 op=2 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1071 fd=37 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1065 op=3 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1074 op=3 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1075 fd=12 ACCEPT from IP=127.0.0.1:58696 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1067 fd=35 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1066 op=4 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1065 fd=33 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1063 op=3 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1074 fd=38 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1075 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1075 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1066 fd=34 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1075 op=0 RESULT tag=97 err=0 qtime=0.000095 etime=0.000137 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1063 fd=31 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1075 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1075 op=1 RESULT tag=97 err=0 qtime=0.000005 etime=0.000023 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1076 fd=13 ACCEPT from IP=127.0.0.1:58712 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1076 op=0 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1076 op=0 RESULT tag=97 err=0 qtime=0.000004 etime=0.000026 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1076 op=1 SRCH base="uid=alice,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 1 23:29:32 slapd[3071897]: conn=1076 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000005 etime=0.000086 nentries=1 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1077 fd=14 ACCEPT from IP=127.0.0.1:58714 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1077 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1077 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1077 op=0 RESULT tag=97 err=0 qtime=0.000003 etime=0.000064 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1077 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1077 op=1 RESULT tag=97 err=0 qtime=0.000007 etime=0.000039 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1077 op=2 SRCH base="uid=alice,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 1 23:29:32 slapd[3071897]: conn=1077 op=2 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1077 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000008 etime=0.000092 nentries=1 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1078 fd=15 ACCEPT from IP=127.0.0.1:58720 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1078 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1078 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1078 op=0 RESULT tag=97 err=0 qtime=0.000006 etime=0.000073 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1078 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1078 op=1 RESULT tag=97 err=0 qtime=0.000006 etime=0.000043 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1078 op=2 SRCH base="uid=alice,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 1 23:29:32 slapd[3071897]: conn=1078 op=2 SRCH attr=* + <167>Dec 1 23:29:32 slapd[3071897]: conn=1078 op=2 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1078 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000005 etime=0.000112 nentries=1 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1079 fd=16 ACCEPT from IP=127.0.0.1:58736 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1079 op=0 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1079 op=0 RESULT tag=97 err=0 qtime=0.000004 etime=0.000027 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1079 op=1 SRCH base="uid=alice,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 1 23:29:32 slapd[3071897]: conn=1079 op=2 CMP dn="cn=active_gon,ou=groups,o=test" attr="member" <167>Dec 1 23:29:32 slapd[3071897]: conn=1079 op=2 RESULT tag=111 err=6 qtime=0.000005 etime=0.000055 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1079 op=3 CMP dn="cn=staff_gon,ou=groups,o=test" attr="member" <167>Dec 1 23:29:32 slapd[3071897]: conn=1079 op=3 RESULT tag=111 err=6 qtime=0.000009 etime=0.000057 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1079 op=4 CMP dn="cn=superuser_gon,ou=groups,o=test" attr="member" <167>Dec 1 23:29:32 slapd[3071897]: conn=1079 op=4 RESULT tag=111 err=6 qtime=0.000007 etime=0.000052 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1080 fd=17 ACCEPT from IP=127.0.0.1:58738 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1080 op=0 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1080 op=0 RESULT tag=97 err=0 qtime=0.000006 etime=0.000034 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1080 op=1 SRCH base="uid=bob,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 1 23:29:32 slapd[3071897]: conn=1080 op=1 ENTRY dn="uid=bob,ou=people,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1080 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000009 etime=0.000124 nentries=1 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1080 op=2 CMP dn="cn=active_gon,ou=groups,o=test" attr="member" <167>Dec 1 23:29:32 slapd[3071897]: conn=1080 op=2 RESULT tag=111 err=5 qtime=0.000005 etime=0.000045 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1080 op=3 CMP dn="cn=staff_gon,ou=groups,o=test" attr="member" <167>Dec 1 23:29:32 slapd[3071897]: conn=1080 op=3 RESULT tag=111 err=5 qtime=0.000004 etime=0.000032 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1080 op=4 CMP dn="cn=superuser_gon,ou=groups,o=test" attr="member" <167>Dec 1 23:29:32 slapd[3071897]: conn=1080 op=4 RESULT tag=111 err=5 qtime=0.000009 etime=0.000055 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1081 fd=19 ACCEPT from IP=127.0.0.1:58752 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1081 op=0 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1081 op=0 RESULT tag=97 err=0 qtime=0.000007 etime=0.000026 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1081 op=1 SRCH base="uid=alice,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 1 23:29:32 slapd[3071897]: conn=1081 op=1 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1081 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000007 etime=0.000076 nentries=1 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1081 op=2 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=posixGroup)(|(gidNumber=1000)(memberUid=alice)))" <167>Dec 1 23:29:32 slapd[3071897]: conn=1081 op=2 ENTRY dn="cn=staff_px,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1081 op=2 ENTRY dn="cn=active_px,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1081 op=2 ENTRY dn="cn=superuser_px,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1081 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000005 etime=0.000268 nentries=3 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1082 fd=20 ACCEPT from IP=127.0.0.1:58762 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1082 op=0 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1082 op=0 RESULT tag=97 err=0 qtime=0.000004 etime=0.000027 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1082 op=1 SRCH base="uid=nonposix,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 1 23:29:32 slapd[3071897]: conn=1082 op=1 ENTRY dn="uid=nonposix,ou=people,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1082 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000005 etime=0.000063 nentries=1 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1082 op=2 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=posixGroup)(memberUid=nonposix))" <167>Dec 1 23:29:32 slapd[3071897]: conn=1082 op=2 ENTRY dn="cn=staff_px,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1082 op=2 ENTRY dn="cn=active_px,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1082 op=2 ENTRY dn="cn=superuser_px,ou=groups,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1082 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000005 etime=0.000307 nentries=3 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1083 fd=21 ACCEPT from IP=127.0.0.1:58764 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1083 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1083 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1083 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000053 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1083 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1083 op=1 RESULT tag=97 err=0 qtime=0.000008 etime=0.000036 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1083 op=2 SRCH base="uid=alice,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 1 23:29:32 slapd[3071897]: conn=1083 op=2 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1083 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000007 etime=0.000056 nentries=1 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1083 op=3 CMP dn="cn=active_px,ou=groups,o=test" attr="memberUid" <167>Dec 1 23:29:32 slapd[3071897]: conn=1083 op=3 RESULT tag=111 err=5 qtime=0.000006 etime=0.000049 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1083 op=4 CMP dn="cn=active_px,ou=groups,o=test" attr="gidNumber" <167>Dec 1 23:29:32 slapd[3071897]: conn=1083 op=4 RESULT tag=111 err=6 qtime=0.000005 etime=0.000044 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1083 op=5 CMP dn="cn=staff_px,ou=groups,o=test" attr="memberUid" <167>Dec 1 23:29:32 slapd[3071897]: conn=1083 op=5 RESULT tag=111 err=6 qtime=0.000004 etime=0.000030 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1083 op=6 CMP dn="cn=superuser_px,ou=groups,o=test" attr="memberUid" <167>Dec 1 23:29:32 slapd[3071897]: conn=1083 op=6 RESULT tag=111 err=6 qtime=0.000007 etime=0.000046 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1084 fd=22 ACCEPT from IP=127.0.0.1:58776 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1084 op=0 BIND dn="uid=bob,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1084 op=0 BIND dn="uid=bob,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1084 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000121 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1084 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1084 op=1 RESULT tag=97 err=0 qtime=0.000006 etime=0.000029 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1084 op=2 SRCH base="uid=bob,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 1 23:29:32 slapd[3071897]: conn=1084 op=2 ENTRY dn="uid=bob,ou=people,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1084 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000004 etime=0.000044 nentries=1 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1084 op=3 CMP dn="cn=active_px,ou=groups,o=test" attr="memberUid" <167>Dec 1 23:29:32 slapd[3071897]: conn=1084 op=3 RESULT tag=111 err=5 qtime=0.000005 etime=0.000044 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1084 op=4 CMP dn="cn=active_px,ou=groups,o=test" attr="gidNumber" <167>Dec 1 23:29:32 slapd[3071897]: conn=1084 op=4 RESULT tag=111 err=5 qtime=0.000004 etime=0.000033 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1084 op=5 CMP dn="cn=staff_px,ou=groups,o=test" attr="memberUid" <167>Dec 1 23:29:32 slapd[3071897]: conn=1084 op=5 RESULT tag=111 err=5 qtime=0.000005 etime=0.000031 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1084 op=6 CMP dn="cn=staff_px,ou=groups,o=test" attr="gidNumber" <167>Dec 1 23:29:32 slapd[3071897]: conn=1084 op=6 RESULT tag=111 err=5 qtime=0.000003 etime=0.000021 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1084 op=7 CMP dn="cn=superuser_px,ou=groups,o=test" attr="memberUid" <167>Dec 1 23:29:32 slapd[3071897]: conn=1084 op=7 RESULT tag=111 err=5 qtime=0.000007 etime=0.000049 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1084 op=8 CMP dn="cn=superuser_px,ou=groups,o=test" attr="gidNumber" <167>Dec 1 23:29:32 slapd[3071897]: conn=1084 op=8 RESULT tag=111 err=5 qtime=0.000007 etime=0.000042 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1085 fd=26 ACCEPT from IP=127.0.0.1:58786 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1085 op=0 BIND dn="uid=nobody,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1085 op=0 BIND dn="uid=nobody,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1085 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000053 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1085 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1085 op=1 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1085 op=1 RESULT tag=97 err=0 qtime=0.000007 etime=0.000043 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1085 op=2 SRCH base="uid=nobody,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 1 23:29:32 slapd[3071897]: conn=1085 op=2 ENTRY dn="uid=nobody,ou=people,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1085 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000008 etime=0.000093 nentries=1 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1085 op=3 CMP dn="cn=active_px,ou=groups,o=test" attr="memberUid" <167>Dec 1 23:29:32 slapd[3071897]: conn=1085 op=3 RESULT tag=111 err=5 qtime=0.000008 etime=0.000044 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1085 op=4 CMP dn="cn=active_px,ou=groups,o=test" attr="gidNumber" <167>Dec 1 23:29:32 slapd[3071897]: conn=1085 op=4 RESULT tag=111 err=5 qtime=0.000005 etime=0.000043 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1086 fd=28 ACCEPT from IP=127.0.0.1:58790 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1086 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1086 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1086 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000044 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1086 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1086 op=1 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1086 op=1 RESULT tag=97 err=0 qtime=0.000004 etime=0.000042 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1086 op=2 CMP dn="cn=active_gon,ou=groups,o=test" attr="member" <167>Dec 1 23:29:32 slapd[3071897]: conn=1086 op=2 RESULT tag=111 err=6 qtime=0.000005 etime=0.000041 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1087 fd=29 ACCEPT from IP=127.0.0.1:58806 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1087 op=0 BIND dn="uid=bob,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1087 op=0 BIND dn="uid=bob,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1087 op=0 RESULT tag=97 err=0 qtime=0.000003 etime=0.000045 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1087 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1087 op=1 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1087 op=1 RESULT tag=97 err=0 qtime=0.000005 etime=0.000030 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1087 op=2 CMP dn="cn=active_gon,ou=groups,o=test" attr="member" <167>Dec 1 23:29:32 slapd[3071897]: conn=1087 op=2 RESULT tag=111 err=5 qtime=0.000004 etime=0.000033 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1088 fd=30 ACCEPT from IP=127.0.0.1:58818 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1088 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1088 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1088 op=0 RESULT tag=97 err=0 qtime=0.000003 etime=0.000047 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1088 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1088 op=1 RESULT tag=97 err=0 qtime=0.000007 etime=0.000034 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1088 op=2 CMP dn="cn=alice_gon,ou=query_groups,o=test" attr="member" <167>Dec 1 23:29:32 slapd[3071897]: conn=1088 op=2 RESULT tag=111 err=6 qtime=0.000004 etime=0.000042 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1088 op=3 CMP dn="cn=mutual_gon,ou=query_groups,o=test" attr="member" <167>Dec 1 23:29:32 slapd[3071897]: conn=1088 op=3 RESULT tag=111 err=6 qtime=0.000004 etime=0.000031 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1089 fd=31 ACCEPT from IP=127.0.0.1:58822 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1089 op=0 BIND dn="uid=bob,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1089 op=0 BIND dn="uid=bob,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1089 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000044 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1089 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1089 op=1 RESULT tag=97 err=0 qtime=0.000006 etime=0.000035 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1089 op=2 CMP dn="cn=alice_gon,ou=query_groups,o=test" attr="member" <167>Dec 1 23:29:32 slapd[3071897]: conn=1089 op=2 RESULT tag=111 err=5 qtime=0.000007 etime=0.000054 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1090 fd=32 ACCEPT from IP=127.0.0.1:58838 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1090 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1090 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1090 op=0 RESULT tag=97 err=0 qtime=0.000003 etime=0.000046 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1090 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1090 op=1 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1090 op=1 RESULT tag=97 err=0 qtime=0.000007 etime=0.000038 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1090 op=2 CMP dn="cn=nonexistent,ou=groups,o=test" attr="member" <167>Dec 1 23:29:32 slapd[3071897]: conn=1090 op=2 RESULT tag=111 err=32 qtime=0.000005 etime=0.000040 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1090 op=3 CMP dn="cn=active_gon,ou=groups,o=test" attr="member" <167>Dec 1 23:29:32 slapd[3071897]: conn=1090 op=3 RESULT tag=111 err=6 qtime=0.000004 etime=0.000052 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1091 fd=33 ACCEPT from IP=127.0.0.1:58844 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1091 op=0 BIND dn="uid=bob,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1091 op=0 BIND dn="uid=bob,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1091 op=0 RESULT tag=97 err=0 qtime=0.000007 etime=0.000046 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1091 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1091 op=1 RESULT tag=97 err=0 qtime=0.000009 etime=0.000052 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1091 op=2 CMP dn="cn=nonexistent,ou=groups,o=test" attr="member" <167>Dec 1 23:29:32 slapd[3071897]: conn=1091 op=2 RESULT tag=111 err=32 qtime=0.000004 etime=0.000032 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1091 op=3 CMP dn="cn=active_gon,ou=groups,o=test" attr="member" <167>Dec 1 23:29:32 slapd[3071897]: conn=1091 op=3 RESULT tag=111 err=5 qtime=0.000005 etime=0.000042 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1076 op=2 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1076 fd=13 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1077 op=3 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1077 fd=14 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1078 op=3 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1083 op=7 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1079 op=5 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1078 fd=15 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1079 fd=16 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1082 op=3 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1083 fd=21 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1080 op=5 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1082 fd=20 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1081 op=3 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1080 fd=17 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1081 fd=19 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1084 op=9 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1086 op=3 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1087 op=3 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1087 fd=29 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1085 op=5 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1088 op=4 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1085 fd=26 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1089 op=3 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1086 fd=28 closed .<167>Dec 1 23:29:32 slapd[3071897]: conn=1089 fd=31 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1091 op=4 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1090 fd=32 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1091 fd=33 closed <167>Dec 1 23:29:32 slapd[3071897]: conn=1092 fd=13 ACCEPT from IP=127.0.0.1:58860 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1092 op=0 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1092 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000030 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1092 op=1 SRCH base="ou=people,o=test" scope=2 deref=0 filter="(uid=alice)" <167>Dec 1 23:29:32 slapd[3071897]: conn=1092 op=1 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1092 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000006 etime=0.000090 nentries=1 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1092 op=2 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1092 op=2 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1092 op=2 RESULT tag=97 err=0 qtime=0.000006 etime=0.000045 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1093 fd=14 ACCEPT from IP=127.0.0.1:58872 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1093 op=0 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1093 op=0 RESULT tag=97 err=0 qtime=0.000007 etime=0.000034 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1093 op=1 SRCH base="ou=people,o=test" scope=2 deref=0 filter="(uid=alice)" <167>Dec 1 23:29:32 slapd[3071897]: conn=1093 op=1 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1093 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000006 etime=0.000082 nentries=1 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1093 op=2 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1093 op=2 RESULT tag=97 err=49 qtime=0.000005 etime=0.000035 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1093 op=3 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1093 fd=14 closed .<167>Dec 1 23:29:32 slapd[3071897]: conn=1094 fd=14 ACCEPT from IP=127.0.0.1:58886 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1094 op=0 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1094 op=0 RESULT tag=97 err=0 qtime=0.000004 etime=0.000022 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1094 op=1 SRCH base="ou=people,o=test" scope=2 deref=0 filter="(uid=alice\2A)" <167>Dec 1 23:29:32 slapd[3071897]: conn=1094 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000006 etime=0.000211 nentries=0 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1094 op=2 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1094 fd=14 closed .<167>Dec 1 23:29:32 slapd[3071897]: conn=1095 fd=14 ACCEPT from IP=127.0.0.1:58898 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1095 op=0 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1095 op=0 RESULT tag=97 err=0 qtime=0.000007 etime=0.000034 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1095 op=1 SRCH base="ou=people,o=test" scope=2 deref=0 filter="(uid=*)" <167>Dec 1 23:29:32 slapd[3071897]: conn=1095 op=1 ENTRY dn="uid=bob,ou=people,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1095 op=1 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1095 op=1 ENTRY dn="uid=nobody,ou=people,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1095 op=1 ENTRY dn="uid=dreßler,ou=people,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1095 op=1 ENTRY dn="uid=nonposix,ou=people,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1095 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000005 etime=0.000137 nentries=5 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1095 op=2 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1095 fd=14 closed .<167>Dec 1 23:29:32 slapd[3071897]: conn=1096 fd=14 ACCEPT from IP=127.0.0.1:58910 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1096 op=0 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1096 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000031 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1096 op=1 SRCH base="ou=people,o=test" scope=2 deref=0 filter="(?uidNumber=alice)" <167>Dec 1 23:29:32 slapd[3071897]: conn=1096 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000008 etime=0.000068 nentries=0 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1096 op=2 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1096 fd=14 closed .<167>Dec 1 23:29:32 slapd[3071897]: conn=1097 fd=14 ACCEPT from IP=127.0.0.1:58924 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1097 op=0 BIND dn="uid=bob,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1097 op=0 RESULT tag=97 err=49 qtime=0.000005 etime=0.000035 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1097 op=1 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1097 fd=14 closed .<167>Dec 1 23:29:32 slapd[3071897]: conn=1098 fd=14 ACCEPT from IP=127.0.0.1:58936 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1098 op=0 BIND dn="uid=bob,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1098 op=0 BIND dn="uid=bob,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1098 op=0 RESULT tag=97 err=0 qtime=0.000006 etime=0.000047 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1098 op=1 SRCH base="ou=people,o=test" scope=2 deref=0 filter="(uid=alice)" <167>Dec 1 23:29:32 slapd[3071897]: conn=1098 op=1 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1098 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000006 etime=0.000057 nentries=1 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1098 op=2 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1098 op=2 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1098 op=2 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1098 op=2 RESULT tag=97 err=0 qtime=0.000005 etime=0.000077 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1099 fd=15 ACCEPT from IP=127.0.0.1:58944 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1099 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1099 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1099 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000045 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1100 fd=16 ACCEPT from IP=127.0.0.1:58948 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1100 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1100 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1100 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000055 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1101 fd=17 ACCEPT from IP=127.0.0.1:58962 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1101 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1101 op=0 RESULT tag=97 err=49 qtime=0.000006 etime=0.000048 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1101 op=1 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1101 fd=17 closed .<167>Dec 1 23:29:32 slapd[3071897]: conn=1102 fd=17 ACCEPT from IP=127.0.0.1:58966 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1102 op=0 BIND dn="uid=evil_alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1102 op=0 RESULT tag=97 err=49 qtime=0.000003 etime=0.000027 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1103 fd=19 ACCEPT from IP=127.0.0.1:58974 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1103 op=0 BIND dn="uid=alice\2C1,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1103 op=0 RESULT tag=97 err=49 qtime=0.000006 etime=0.000044 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1103 op=1 UNBIND <167>Dec 1 23:29:32 slapd[3071897]: conn=1103 fd=19 closed .<167>Dec 1 23:29:32 slapd[3071897]: conn=1104 fd=19 ACCEPT from IP=127.0.0.1:58976 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1104 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1104 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1104 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000052 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1104 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1104 op=1 RESULT tag=97 err=0 qtime=0.000006 etime=0.000032 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1104 op=2 CMP dn="cn=alice_gon,ou=query_groups,o=test" attr="member" <167>Dec 1 23:29:32 slapd[3071897]: conn=1104 op=2 RESULT tag=111 err=6 qtime=0.000006 etime=0.000046 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1105 fd=20 ACCEPT from IP=127.0.0.1:58982 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1105 op=0 EXT oid=1.3.6.1.4.1.1466.20037 <167>Dec 1 23:29:32 slapd[3071897]: conn=1105 op=0 RESULT oid= err=0 qtime=0.000005 etime=0.000032 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1105 fd=20 closed (TLS negotiation failure) .<167>Dec 1 23:29:32 slapd[3071897]: conn=1106 fd=20 ACCEPT from IP=127.0.0.1:58996 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1106 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1106 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1106 op=0 RESULT tag=97 err=0 qtime=0.000006 etime=0.000077 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1107 fd=21 ACCEPT from IP=127.0.0.1:59006 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1107 op=0 BIND dn="uid=dreßler,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1107 op=0 BIND dn="uid=dreßler,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1107 op=0 RESULT tag=97 err=0 qtime=0.000008 etime=0.000057 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1107 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1107 op=1 RESULT tag=97 err=0 qtime=0.000006 etime=0.000042 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1107 op=2 SRCH base="uid=dreßler,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 1 23:29:32 slapd[3071897]: conn=1107 op=2 ENTRY dn="uid=dreßler,ou=people,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1107 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000005 etime=0.000110 nentries=1 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1108 fd=22 ACCEPT from IP=127.0.0.1:59012 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1108 op=0 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1108 op=0 RESULT tag=97 err=0 qtime=0.000006 etime=0.000030 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1108 op=1 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(uid=alice)" <167>Dec 1 23:29:32 slapd[3071897]: conn=1108 op=2 SRCH base="ou=people,o=test" scope=2 deref=0 filter="(uid=alice)" <167>Dec 1 23:29:32 slapd[3071897]: conn=1108 op=2 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 1 23:29:32 slapd[3071897]: conn=1108 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000006 etime=0.000067 nentries=1 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1108 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000005 etime=0.000212 nentries=0 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1108 op=3 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1108 op=3 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1108 op=3 RESULT tag=97 err=0 qtime=0.000005 etime=0.000036 text= .<167>Dec 1 23:29:32 slapd[3071897]: conn=1109 fd=26 ACCEPT from IP=127.0.0.1:59016 (IP=127.0.0.1:40797) <167>Dec 1 23:29:32 slapd[3071897]: conn=1109 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1109 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1109 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000034 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1109 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 1 23:29:32 slapd[3071897]: conn=1109 op=1 BIND dn="" method=128 <167>Dec 1 23:29:32 slapd[3071897]: conn=1109 op=1 RESULT tag=97 err=0 qtime=0.000004 etime=0.000018 text= <167>Dec 1 23:29:32 slapd[3071897]: conn=1109 op=2 CMP dn="cn=active_gon,ou=groups,o=test" attr="member" <167>Dec 1 23:29:32 slapd[3071897]: conn=1109 op=2 RESULT tag=111 err=6 qtime=0.000005 etime=0.000032 text= ..<167>Dec 1 23:29:32 slapd[3071897]: daemon: shutdown requested and initiated. <167>Dec 1 23:29:32 slapd[3071897]: conn=1075 fd=12 closed (slapd shutdown) <167>Dec 1 23:29:32 slapd[3071897]: conn=1092 fd=13 closed (slapd shutdown) <167>Dec 1 23:29:32 slapd[3071897]: conn=1098 fd=14 closed (slapd shutdown) <167>Dec 1 23:29:32 slapd[3071897]: conn=1099 fd=15 closed (slapd shutdown) <167>Dec 1 23:29:32 slapd[3071897]: conn=1100 fd=16 closed (slapd shutdown) <167>Dec 1 23:29:32 slapd[3071897]: conn=1102 fd=17 closed (slapd shutdown) <167>Dec 1 23:29:32 slapd[3071897]: conn=1011 fd=18 closed (slapd shutdown) <167>Dec 1 23:29:32 slapd[3071897]: conn=1104 fd=19 closed (slapd shutdown) <167>Dec 1 23:29:32 slapd[3071897]: conn=1106 fd=20 closed (slapd shutdown) <167>Dec 1 23:29:32 slapd[3071897]: conn=1107 fd=21 closed (slapd shutdown) <167>Dec 1 23:29:32 slapd[3071897]: conn=1108 fd=22 closed (slapd shutdown) <167>Dec 1 23:29:32 slapd[3071897]: conn=1035 fd=23 closed (slapd shutdown) <167>Dec 1 23:29:32 slapd[3071897]: conn=1036 fd=24 closed (slapd shutdown) <167>Dec 1 23:29:32 slapd[3071897]: conn=1024 fd=25 closed (slapd shutdown) <167>Dec 1 23:29:32 slapd[3071897]: conn=1109 fd=26 closed (slapd shutdown) <167>Dec 1 23:29:32 slapd[3071897]: conn=1048 fd=27 closed (slapd shutdown) <167>Dec 1 23:29:32 slapd[3071897]: slapd shutdown: waiting for 0 operations/tasks to finish <39>Dec 1 23:29:32 slapd[3071897]: DIGEST-MD5 common mech free <167>Dec 1 23:29:32 slapd[3071897]: slapd stopped. ---------------------------------------------------------------------- Ran 89 tests in 0.815s OK Destroying test database for alias 'default'... + exit 0 Processing files: python3-module-django-auth-ldap-4.3.0-alt1 Executing(%doc): /bin/sh -e /usr/src/tmp/rpm-tmp.9678 + umask 022 + /bin/mkdir -p /usr/src/RPM/BUILD + cd /usr/src/RPM/BUILD + cd python3-module-django-auth-ldap-4.3.0 + DOCDIR=/usr/src/tmp/python3-module-django-auth-ldap-buildroot/usr/share/doc/python3-module-django-auth-ldap-4.3.0 + export DOCDIR + rm -rf /usr/src/tmp/python3-module-django-auth-ldap-buildroot/usr/share/doc/python3-module-django-auth-ldap-4.3.0 + /bin/mkdir -p /usr/src/tmp/python3-module-django-auth-ldap-buildroot/usr/share/doc/python3-module-django-auth-ldap-4.3.0 + cp -prL README.rst LICENSE /usr/src/tmp/python3-module-django-auth-ldap-buildroot/usr/share/doc/python3-module-django-auth-ldap-4.3.0 + chmod -R go-w /usr/src/tmp/python3-module-django-auth-ldap-buildroot/usr/share/doc/python3-module-django-auth-ldap-4.3.0 + chmod -R a+rX /usr/src/tmp/python3-module-django-auth-ldap-buildroot/usr/share/doc/python3-module-django-auth-ldap-4.3.0 + exit 0 Finding Provides (using /usr/lib/rpm/find-provides) Executing: /bin/sh -e /usr/src/tmp/rpm-tmp.KxVi8R find-provides: running scripts (alternatives,debuginfo,lib,pam,perl,pkgconfig,python,python3,shell) Finding Requires (using /usr/lib/rpm/find-requires) Executing: /bin/sh -e /usr/src/tmp/rpm-tmp.Co4sYz find-requires: running scripts (cpp,debuginfo,files,lib,pam,perl,pkgconfig,pkgconfiglib,python,python3,rpmlib,shebang,shell,static,symlinks,systemd-services) py3prov: detected potential module:django_auth_ldap py3prov: detected potential module:django_auth_ldap py3req:/usr/src/tmp/python3-module-django-auth-ldap-buildroot/usr/lib/python3/site-packages/django_auth_ldap/__init__.py: "django_auth_ldap.version" lines:[[2]]: Ignore for REQ:slight py3req:/usr/src/tmp/python3-module-django-auth-ldap-buildroot/usr/lib/python3/site-packages/django_auth_ldap/backend.py: "django_auth_ldap.config" lines:[58] is possibly a self-providing dependency, skip it Provides: python3(django_auth_ldap), python3(django_auth_ldap.backend), python3(django_auth_ldap.config) Requires: /usr/lib/python3/site-packages, python3(copy) < 0, python3(django.conf) < 0, python3(django.contrib.auth) < 0, python3(django.contrib.auth.models) < 0, python3(django.core.cache) < 0, python3(django.core.exceptions) < 0, python3(django.dispatch) < 0, python3(django.utils.tree) < 0, python3(functools) < 0, python3(ldap) < 0, python3(ldap.filter) < 0, python3(logging) < 0, python3(operator) < 0, python3(pprint) < 0, python3(re) < 0, python3(warnings) < 0 Wrote: /usr/src/RPM/RPMS/noarch/python3-module-django-auth-ldap-4.3.0-alt1.noarch.rpm (w2.lzdio) 2.07user 0.43system 0:04.49elapsed 55%CPU (0avgtext+0avgdata 42616maxresident)k 0inputs+0outputs (0major+127291minor)pagefaults 0swaps 4.29user 1.62system 0:20.11elapsed 29%CPU (0avgtext+0avgdata 126004maxresident)k 62656inputs+0outputs (0major+373747minor)pagefaults 0swaps --- python3-module-django-auth-ldap-4.3.0-alt1.noarch.rpm.repo 2023-06-13 13:51:23.000000000 +0000 +++ python3-module-django-auth-ldap-4.3.0-alt1.noarch.rpm.hasher 2023-12-02 05:29:36.172471520 +0000 @@ -43,3 +43,3 @@ File: /usr/lib/python3/site-packages/django_auth_ldap-0.0.0.dist-info 40755 root:root -File: /usr/lib/python3/site-packages/django_auth_ldap-0.0.0.dist-info/METADATA 100644 root:root 15e7414856437e197a9d1ea7fabd0df7 +File: /usr/lib/python3/site-packages/django_auth_ldap-0.0.0.dist-info/METADATA 100644 root:root d1d8eed517949d16db6ee983a28a8e31 File: /usr/lib/python3/site-packages/django_auth_ldap/__init__.py 100644 root:root f7e7d62b62be53ff121cea79fd33fc66 @@ -49,8 +49,8 @@ File: /usr/lib/python3/site-packages/django_auth_ldap/__pycache__/__init__.cpython-311.pyc 100644 root:root d56f1d5741599a7b543bfb3bcbd902b1 -File: /usr/lib/python3/site-packages/django_auth_ldap/__pycache__/backend.cpython-311.opt-1.pyc 100644 root:root 0eabf32bc96c2ad971914b86cd58d4b7 -File: /usr/lib/python3/site-packages/django_auth_ldap/__pycache__/backend.cpython-311.opt-2.pyc 100644 root:root c8e9fda8af569b019c6832c2e28917a9 -File: /usr/lib/python3/site-packages/django_auth_ldap/__pycache__/backend.cpython-311.pyc 100644 root:root 0eabf32bc96c2ad971914b86cd58d4b7 -File: /usr/lib/python3/site-packages/django_auth_ldap/__pycache__/config.cpython-311.opt-1.pyc 100644 root:root a3ce1bce5449170b37d1a89beca0178d -File: /usr/lib/python3/site-packages/django_auth_ldap/__pycache__/config.cpython-311.opt-2.pyc 100644 root:root df9b0f4d61d1dd5ffa1582691a207151 -File: /usr/lib/python3/site-packages/django_auth_ldap/__pycache__/config.cpython-311.pyc 100644 root:root a3ce1bce5449170b37d1a89beca0178d +File: /usr/lib/python3/site-packages/django_auth_ldap/__pycache__/backend.cpython-311.opt-1.pyc 100644 root:root a178cbaafb4cf804afa29560a4c6bc8b +File: /usr/lib/python3/site-packages/django_auth_ldap/__pycache__/backend.cpython-311.opt-2.pyc 100644 root:root b7a3b0121a1f8a5255a7fd7240171c55 +File: /usr/lib/python3/site-packages/django_auth_ldap/__pycache__/backend.cpython-311.pyc 100644 root:root a178cbaafb4cf804afa29560a4c6bc8b +File: /usr/lib/python3/site-packages/django_auth_ldap/__pycache__/config.cpython-311.opt-1.pyc 100644 root:root 0473872fed607b8ebbb55ed1c9da6434 +File: /usr/lib/python3/site-packages/django_auth_ldap/__pycache__/config.cpython-311.opt-2.pyc 100644 root:root bcbe0a47f91e0738a8fd32f601838bec +File: /usr/lib/python3/site-packages/django_auth_ldap/__pycache__/config.cpython-311.pyc 100644 root:root 0473872fed607b8ebbb55ed1c9da6434 File: /usr/lib/python3/site-packages/django_auth_ldap/backend.py 100644 root:root 4545fea4162c2dccdcbf2e64f41c048f @@ -60,2 +60,2 @@ File: /usr/share/doc/python3-module-django-auth-ldap-4.3.0/README.rst 100644 root:root 17bb22d4f45f731c31ca95ae6c5fcc81 -RPMIdentity: 9350b3a8b5792f5b25bd162991e88d5146b5ec7903e96582215d4041dc526bba352664d8ffe10dba5b629f4aef94804e1977a226faba9bd6b2e202626d300214 +RPMIdentity: 736829a0c356d0f634e198b7eaa3a3347ba3db64a0eb837f32f79c8abd8456e5177d4bbe747702bd4474c8055c8a061e4cd678ab3cbeb3d54b57e3deb0835c55