<86>Dec 19 03:07:29 userdel[1601997]: delete user 'rooter' <86>Dec 19 03:07:29 userdel[1601997]: removed group 'rooter' owned by 'rooter' <86>Dec 19 03:07:29 userdel[1601997]: removed shadow group 'rooter' owned by 'rooter' <86>Dec 19 03:07:29 groupadd[1602029]: group added to /etc/group: name=rooter, GID=1877 <86>Dec 19 03:07:29 groupadd[1602029]: group added to /etc/gshadow: name=rooter <86>Dec 19 03:07:29 groupadd[1602029]: new group: name=rooter, GID=1877 <86>Dec 19 03:07:29 useradd[1602041]: new user: name=rooter, UID=1877, GID=1877, home=/root, shell=/bin/bash, from=none <86>Dec 19 03:07:29 userdel[1602052]: delete user 'builder' <86>Dec 19 03:07:29 userdel[1602052]: removed group 'builder' owned by 'builder' <86>Dec 19 03:07:29 userdel[1602052]: removed shadow group 'builder' owned by 'builder' <86>Dec 19 03:07:29 groupadd[1602062]: group added to /etc/group: name=builder, GID=1878 <86>Dec 19 03:07:29 groupadd[1602062]: group added to /etc/gshadow: name=builder <86>Dec 19 03:07:29 groupadd[1602062]: new group: name=builder, GID=1878 <86>Dec 19 03:07:29 useradd[1602073]: new user: name=builder, UID=1878, GID=1878, home=/usr/src, shell=/bin/bash, from=none <13>Dec 19 03:07:33 rpmi: libmpdec3-2.5.1-alt3 sisyphus+314490.500.5.1 1675432004 installed <13>Dec 19 03:07:33 rpmi: libgdbm-1.8.3-alt10 sisyphus+346222.200.3.2 1716468404 installed <13>Dec 19 03:07:33 rpmi: libexpat-2.5.0-alt1 sisyphus+346180.200.2.1 1716349835 installed <13>Dec 19 03:07:33 rpmi: libb2-0.98.1-alt1_1 sisyphus+291614.100.1.1 1638962877 installed <13>Dec 19 03:07:33 rpmi: libp11-kit-1:0.25.5-alt1 sisyphus+352553.100.1.1 1720622573 installed <13>Dec 19 03:07:33 rpmi: libtasn1-4.19.0-alt3 sisyphus+327816.100.1.1 1692802615 installed <13>Dec 19 03:07:33 rpmi: rpm-macros-alternatives-0.5.2-alt2 sisyphus+315270.200.2.1 1676457367 installed <13>Dec 19 03:07:33 rpmi: alternatives-0.5.2-alt2 sisyphus+315270.200.2.1 1676457367 installed <13>Dec 19 03:07:33 rpmi: ca-certificates-2024.12.10-alt1 sisyphus+364633.200.3.1 1733918603 installed <13>Dec 19 03:07:33 rpmi: ca-trust-0.2.0-alt1 sisyphus+344843.100.1.1 1712743326 installed <13>Dec 19 03:07:33 rpmi: p11-kit-trust-1:0.25.5-alt1 sisyphus+352553.100.1.1 1720622573 installed <13>Dec 19 03:07:33 rpmi: libcrypto3-3.1.7-alt2 sisyphus+359910.100.1.1 1729080439 installed <13>Dec 19 03:07:33 rpmi: libssl3-3.1.7-alt2 sisyphus+359910.100.1.1 1729080439 installed <13>Dec 19 03:07:33 rpmi: python3-3.12.8-alt1 sisyphus+364336.100.1.1 1733526854 installed <13>Dec 19 03:07:34 rpmi: python3-base-3.12.8-alt1 sisyphus+364336.100.1.1 1733526854 installed <13>Dec 19 03:07:34 rpmi: python3-module-py3dephell-0.3.1-alt1 sisyphus+365261.200.1.1 1734463433 installed <13>Dec 19 03:07:34 rpmi: tests-for-installed-python3-pkgs-0.1.26-alt2 sisyphus+365350.100.1.1 1734517486 installed <13>Dec 19 03:07:34 rpmi: rpm-build-python3-0.1.26-alt2 sisyphus+365350.100.1.1 1734517486 installed <13>Dec 19 03:07:36 rpmi: python3-module-attrs-24.2.0-alt2 sisyphus+355603.200.1.1 1724160494 installed <13>Dec 19 03:07:36 rpmi: python3-module-zope.interface-7.2-alt1 sisyphus+363572.100.1.1 1732797441 installed <13>Dec 19 03:07:36 rpmi: python3-module-idna-3.10-alt1 sisyphus+358681.100.1.1 1727701241 installed <13>Dec 19 03:07:36 rpmi: python3-module-more-itertools-10.5.0-alt1 sisyphus+357221.100.1.1 1725964420 installed <13>Dec 19 03:07:36 rpmi: libtcl-8.6.13-alt1 sisyphus+310696.100.1.1 1669548266 installed <13>Dec 19 03:07:36 rpmi: python3-module-jaraco.functools-4.1.0-alt1 sisyphus+358564.100.1.1 1727528718 installed <13>Dec 19 03:07:36 rpmi: python3-module-pyasn1-0.6.0-alt1 sisyphus+343691.100.1.1 1711530038 installed <13>Dec 19 03:07:36 rpmi: python3-module-multidict-6.1.0-alt1 sisyphus+358658.100.1.1 1727692657 installed <13>Dec 19 03:07:36 rpmi: python3-module-frozenlist-1.5.0-alt1 sisyphus+362047.100.1.1 1731079173 installed <13>Dec 19 03:07:36 rpmi: libsqlite3-3.47.1-alt1 sisyphus+365248.200.3.1 1734527620 installed <13>Dec 19 03:07:36 rpmi: libnspr-1:4.35-alt1 sisyphus+308164.100.1.1 1665397040 installed <13>Dec 19 03:07:36 rpmi: liblmdb-0.9.33-alt1 sisyphus+360625.100.1.1 1729819640 installed <13>Dec 19 03:07:36 rpmi: libcares-1.34.3-alt1 sisyphus+364759.100.1.2 1733934963 installed <13>Dec 19 03:07:36 rpmi: openssl-3.1.7-alt2 sisyphus+359910.100.1.1 1729080439 installed <13>Dec 19 03:07:36 rpmi: cert-sh-functions-1.0.6-alt1 sisyphus+247768.100.1.1 1584089255 installed <13>Dec 19 03:07:36 rpmi: libnss-3.107-alt1 sisyphus+364633.40.3.1 1733918554 installed <13>Dec 19 03:07:36 rpmi: nss-utils-3.107-alt1 sisyphus+364633.40.3.1 1733918554 installed <13>Dec 19 03:07:36 rpmi: python3-modules-sqlite3-3.12.8-alt1 sisyphus+364336.100.1.1 1733526854 installed <13>Dec 19 03:07:36 rpmi: python3-module-aiosignal-1.3.1-alt1 sisyphus+314057.100.1.1 1674561191 installed <13>Dec 19 03:07:36 rpmi: python3-module-pyasn1-modules-0.4.0-alt1 sisyphus+343691.200.1.1 1711530070 installed <13>Dec 19 03:07:37 rpmi: tcl-8.6.13-alt1 sisyphus+310696.100.1.1 1669548266 installed <13>Dec 19 03:07:37 rpmi: python3-module-hyperlink-21.0.0-alt1.1 sisyphus+304836.100.1.1 1659710964 installed <13>Dec 19 03:07:37 rpmi: python3-module-outcome-1.3.0-alt1 sisyphus+332382.100.1.1 1697882349 installed <13>Dec 19 03:07:37 rpmi: chrooted-0.3.12-alt1 sisyphus+327286.5300.14.1 1711487147 installed <13>Dec 19 03:07:37 rpmi: python3-module-sqlparse-0.5.2-alt1 sisyphus+362576.100.1.1 1731657315 installed <13>Dec 19 03:07:37 rpmi: python3-module-markupsafe-1:3.0.2-alt1 sisyphus+360209.100.1.1 1729323052 installed <13>Dec 19 03:07:37 rpmi: python3-module-jinja2-3.1.4-alt1 sisyphus+348267.100.1.1 1715939549 installed <13>Dec 19 03:07:37 rpmi: python3-module-asgiref-3.7.2-alt1 sisyphus+328419.100.1.1 1693492242 installed <13>Dec 19 03:07:37 rpmi: python3-module-urllib3-2:2.2.3-alt1 sisyphus+357427.100.2.1 1726567364 installed <13>Dec 19 03:07:37 rpmi: python3-module-charset-normalizer-3.2.0-alt1 sisyphus+347396.200.2.1 1714733155 installed <13>Dec 19 03:07:37 rpmi: python3-module-requests-2.32.3-alt1 sisyphus+349946.100.1.1 1717059877 installed <13>Dec 19 03:07:37 rpmi: python3-module-propcache-0.2.0-alt1 sisyphus+362002.100.1.1 1731060165 installed <13>Dec 19 03:07:37 rpmi: python3-module-yarl-1.17.1-alt1 sisyphus+362027.100.1.1 1731075379 installed <13>Dec 19 03:07:37 rpmi: python3-module-typing_extensions-4.12.2-alt1 sisyphus+351501.100.1.2 1719296652 installed <13>Dec 19 03:07:37 rpmi: python3-module-priority-2.0.0-alt3 sisyphus+338701.100.1.2 1705988383 installed <13>Dec 19 03:07:37 rpmi: python3-module-hpack-4.0.0-alt1 sisyphus+270376.200.1.1 1618956626 installed <13>Dec 19 03:07:37 rpmi: python3-module-hyperframe-6.0.1-alt1 sisyphus+270376.300.2.1 1618957001 installed <13>Dec 19 03:07:37 rpmi: python3-module-h2-4.1.0-alt1 sisyphus+325714.100.2.2 1690478873 installed <13>Dec 19 03:07:37 rpmi: python3-module-click-8.1.7-alt1 sisyphus+327424.100.2.1 1695395098 installed <13>Dec 19 03:07:37 rpmi: python3-module-incremental-22.10.0-alt1 sisyphus+312706.100.1.1 1672404273 installed <13>Dec 19 03:07:37 rpmi: python3-module-constantly-15.1.0-alt7 sisyphus+338906.100.1.1 1706107088 installed <13>Dec 19 03:07:37 rpmi: python3-module-appdirs-1.4.4-alt2 sisyphus+359005.100.1.1 1728036426 installed <13>Dec 19 03:07:37 rpmi: python3-module-certifi-2024.8.30-alt1 sisyphus+356919.100.1.1 1725546651 installed <13>Dec 19 03:07:37 rpmi: python3-module-wheel-0.45.1-alt1 sisyphus+363326.100.2.1 1732609968 installed <13>Dec 19 03:07:37 rpmi: python3-module-platformdirs-4.3.6-alt1 sisyphus+357787.200.1.1 1726664692 installed <13>Dec 19 03:07:37 rpmi: python3-module-packaging-24.2-alt1 sisyphus+362183.100.1.1 1731315992 installed <13>Dec 19 03:07:37 rpmi: python3-module-jaraco.context-6.0.1-alt1 sisyphus+357809.300.1.1 1726769204 installed <13>Dec 19 03:07:37 rpmi: python3-module-autocommand-2.2.2-alt1.1 sisyphus+339714.100.1.1 1706968174 installed <13>Dec 19 03:07:37 rpmi: python3-module-jaraco.text-4.0.0-alt1 sisyphus+353877.400.2.1 1722250727 installed <13>Dec 19 03:07:37 rpmi: python3-module-jaraco.collections-5.1.0-alt1 sisyphus+357809.200.1.1 1726769173 installed <13>Dec 19 03:07:37 rpmi: python3-module-pkg_resources-1:75.6.0-alt1 sisyphus+363072.100.1.1 1732185054 installed <13>Dec 19 03:07:37 rpmi: python3-module-openid-3.2.0-alt1 sisyphus+278049.100.2.1 1625998936 installed <13>Dec 19 03:07:37 rpmi: python3-module-z3c-3.0.0-alt4 sisyphus+284857.200.1.1 1631109149 installed <13>Dec 19 03:07:37 rpmi: python3-module-zc-1.0.0-alt7 sisyphus+284857.100.1.1 1631109117 installed <13>Dec 19 03:07:37 rpmi: python3-module-zope-3.3.0-alt9 sisyphus+281937.200.4.1 1628175900 installed <13>Dec 19 03:07:37 rpmi: python3-module-zope.event-5.0-alt1.1 sisyphus+325755.140.2.1 1690991538 installed <13>Dec 19 03:07:37 rpmi: python3-module-psutil-5.9.8-alt1 sisyphus+341001.100.1.1 1708284056 installed <13>Dec 19 03:07:37 rpmi: python3-module-objgraph-3.6.2-alt1 sisyphus+359468.100.1.1 1728573508 installed <13>Dec 19 03:07:37 rpmi: python3-module-greenlet-3.1.1-alt1 sisyphus+358881.100.1.1 1727933137 installed <13>Dec 19 03:07:37 rpmi: python3-module-sortedcontainers-2.4.0-alt1 sisyphus+272042.100.1.1 1621262424 installed <13>Dec 19 03:07:37 rpmi: python3-module-sniffio-1.3.1-alt1 sisyphus+341424.100.1.1 1708941879 installed <13>Dec 19 03:07:37 rpmi: python3-module-astor-0.8.1-alt1.1 sisyphus+315877.100.1.1 1677481862 installed <13>Dec 19 03:07:37 rpmi: python3-module-pycparser-2.21-alt1.1 sisyphus+309935.7300.4.1 1668527005 installed <13>Dec 19 03:07:37 rpmi: python3-module-cffi-1.17.1-alt1 sisyphus+357396.100.1.1 1726156476 installed <13>Dec 19 03:07:37 rpmi: python3-module-cryptography-43.0.0-alt1 sisyphus+353417.100.1.1 1721731007 installed <13>Dec 19 03:07:37 rpmi: python3-module-openssl-24.2.1-alt1 sisyphus+353417.200.1.1 1721731036 installed <13>Dec 19 03:07:37 rpmi: python3-module-trio-0.27.0-alt1 sisyphus+360354.100.1.1 1729536849 installed <13>Dec 19 03:07:37 rpmi: python3-module-dns-1:2.6.1-alt1 sisyphus+341811.20.3.1 1709382170 installed <13>Dec 19 03:07:37 rpmi: python3-module-pycares-4.4.0-alt1 sisyphus+347421.100.1.1 1714743573 installed <13>Dec 19 03:07:37 rpmi: python3-module-aiohappyeyeballs-2.4.3-alt1 sisyphus+362038.100.1.1 1731077332 installed <13>Dec 19 03:07:37 rpmi: python3-module-Cheetah-3.4.0-alt1 sisyphus+364093.100.1.1 1733348862 installed <13>Dec 19 03:07:37 rpmi: python3-module-paste-3.10.1-alt1 sisyphus+364772.70.5.1 1733996555 installed <13>Dec 19 03:07:37 rpmi: python3-module-PasteDeploy-1:3.1-alt1 sisyphus+343658.100.1.1 1711471990 installed <13>Dec 19 03:07:37 rpmi: python3-module-PasteScript-1:3.6.0-alt1 sisyphus+364772.100.5.1 1733996584 installed <13>Dec 19 03:07:37 rpmi: libyaml2-0.2.5-alt1 sisyphus+278391.100.1.1 1626094928 installed <13>Dec 19 03:07:37 rpmi: python3-module-yaml-6.0.2-alt1 sisyphus+356896.100.1.1 1725541112 installed <13>Dec 19 03:07:37 rpmi: libuv-1.49.1-alt1 sisyphus+364651.40.2.1 1733856345 installed <13>Dec 19 03:07:37 rpmi: libpython3-3.12.8-alt1 sisyphus+364336.100.1.1 1733526854 installed <13>Dec 19 03:07:37 rpmi: libncurses6-6.3.20220618-alt4 sisyphus+327286.4600.14.1 1711486705 installed <13>Dec 19 03:07:37 rpmi: libtinfo-devel-6.3.20220618-alt4 sisyphus+327286.4600.14.1 1711486705 installed <13>Dec 19 03:07:38 rpmi: libncurses-devel-6.3.20220618-alt4 sisyphus+327286.4600.14.1 1711486705 installed <13>Dec 19 03:07:38 rpmi: python3-dev-3.12.8-alt1 sisyphus+364336.100.1.1 1733526854 installed <13>Dec 19 03:07:38 rpmi: libmaxminddb-1.11.0-alt1 sisyphus+355820.100.1.1 1724384612 installed <13>Dec 19 03:07:38 rpmi: python3-module-MaxMindDB-2.6.2-alt1 sisyphus+351880.100.1.1 1719817162 installed <13>Dec 19 03:07:38 rpmi: libltdl7-2.4.7-alt5 sisyphus+341963.200.3.1 1711659208 installed <13>Dec 19 03:07:38 rpmi: openldap-common-2.6.9-alt1 sisyphus+364781.100.1.1 1733971238 installed <13>Dec 19 03:07:38 rpmi: libverto-0.3.2-alt1_1 sisyphus+321176.2200.10.2 1684803947 installed <13>Dec 19 03:07:38 rpmi: libkeyutils-1.6.3-alt1 sisyphus+346336.200.2.2 1716472658 installed <13>Dec 19 03:07:38 rpmi: libusb-1.0.27-alt1 sisyphus+347412.100.1.1 1714739651 installed <13>Dec 19 03:07:38 rpmi: libhidapi-0.12.0-alt1_1 sisyphus+303213.100.1.1 1657034192 installed <13>Dec 19 03:07:38 rpmi: python3-module-cython-hidapi-0.14.0-alt1.1 sisyphus+333513.54340.73.1 1704651867 installed <13>Dec 19 03:07:38 rpmi: python3-module-serial-3.5-alt3 sisyphus+360600.100.2.1 1729786231 installed <13>Dec 19 03:07:38 rpmi: libevent2.1-2.1.12-alt1 sisyphus+324359.3500.11.1 1689364661 installed <13>Dec 19 03:07:38 rpmi: libev4-4.33-alt3 sisyphus+334335.340.4.1 1699912675 installed <13>Dec 19 03:07:38 rpmi: python3-module-gevent-24.10.3-alt1 sisyphus+361451.100.1.1 1730467200 installed <13>Dec 19 03:07:38 rpmi: libcom_err-1.47.1.0.10.ad56-alt2 sisyphus+363497.200.3.1 1732729908 installed <86>Dec 19 03:07:38 groupadd[1636127]: group added to /etc/group: name=_keytab, GID=999 <86>Dec 19 03:07:38 groupadd[1636127]: group added to /etc/gshadow: name=_keytab <86>Dec 19 03:07:38 groupadd[1636127]: new group: name=_keytab, GID=999 <13>Dec 19 03:07:38 rpmi: libkrb5-1.21.3-alt2 sisyphus+351857.100.1.1 1719735141 installed <86>Dec 19 03:07:38 groupadd[1636471]: group added to /etc/group: name=sasl, GID=998 <86>Dec 19 03:07:38 groupadd[1636471]: group added to /etc/gshadow: name=sasl <86>Dec 19 03:07:38 groupadd[1636471]: new group: name=sasl, GID=998 <13>Dec 19 03:07:39 rpmi: libsasl2-3-2.1.28-alt2 sisyphus+343335.100.1.1 1711112544 installed <13>Dec 19 03:07:39 rpmi: libldap2-2.6.9-alt1 sisyphus+364781.100.1.1 1733971238 installed <13>Dec 19 03:07:39 rpmi: libpq5-17.2-alt1 sisyphus+362974.100.1.1 1732098488 installed <13>Dec 19 03:07:39 rpmi: python3-module-psycopg2-2.9.10-alt1 sisyphus+361099.100.1.1 1730221764 installed <13>Dec 19 03:07:39 rpmi: python3-module-eventlet-0.38.2-alt1 sisyphus+365048.100.1.1 1734193970 installed <13>Dec 19 03:07:39 rpmi: libargon2-20190702-alt1 sisyphus+346050.200.2.1 1716230698 installed <13>Dec 19 03:07:39 rpmi: libpng16-1.6.42-alt2 sisyphus+339555.100.1.1 1706781682 installed <13>Dec 19 03:07:39 rpmi: libbrotlicommon-1.1.0-alt1 sisyphus+328501.100.1.1 1693598419 installed <13>Dec 19 03:07:39 rpmi: libbrotlidec-1.1.0-alt1 sisyphus+328501.100.1.1 1693598419 installed <13>Dec 19 03:07:39 rpmi: libgraphite2-1.3.14-alt2.1 sisyphus+279571.100.1.2 1626605111 installed <13>Dec 19 03:07:39 rpmi: libharfbuzz-10.1.0-alt1 sisyphus+361773.100.1.1 1730824042 installed <13>Dec 19 03:07:39 rpmi: libfreetype-2.13.3-alt1 sisyphus+355656.100.1.1 1724221064 installed <13>Dec 19 03:07:39 rpmi: libfontconfig1-2.15.0-alt1 sisyphus+355771.100.2.3 1724337298 installed <13>Dec 19 03:07:39 rpmi: libXdmcp-1.1.5-alt1 sisyphus+343583.700.1.1 1711441061 installed <13>Dec 19 03:07:39 rpmi: libXau-1.0.11-alt1 sisyphus+311428.100.1.1 1670577439 installed <13>Dec 19 03:07:39 rpmi: libxcb-1.17.0-alt1 sisyphus+345308.200.1.1 1713342004 installed <13>Dec 19 03:07:39 rpmi: libX11-locales-3:1.8.10-alt1 sisyphus+353866.100.1.1 1722240771 installed <13>Dec 19 03:07:39 rpmi: libX11-3:1.8.10-alt1 sisyphus+353866.100.1.1 1722240771 installed <13>Dec 19 03:07:39 rpmi: libXrender-0.9.11-alt1 sisyphus+308841.100.1.1 1666436130 installed <13>Dec 19 03:07:39 rpmi: libXft-2.3.8-alt1 sisyphus+331490.400.1.1 1697023269 installed <13>Dec 19 03:07:39 rpmi: libtk-8.6.13-alt1 sisyphus+310696.200.1.1 1669548530 installed <13>Dec 19 03:07:39 rpmi: tk-8.6.13-alt1 sisyphus+310696.200.1.1 1669548530 installed <13>Dec 19 03:07:39 rpmi: tcl-tix-8.4.3-alt4 sisyphus+277292.300.2.1 1625442550 installed <13>Dec 19 03:07:39 rpmi: python3-modules-tkinter-3.12.8-alt1 sisyphus+364336.100.1.1 1733526854 installed <13>Dec 19 03:07:39 rpmi: python3-module-automat-24.8.1-alt1 sisyphus+355768.100.2.1 1724411664 installed <13>Dec 19 03:07:39 rpmi: python3-module-twisted-logger-24.7.0-alt1 sisyphus+360814.100.1.1 1729934750 installed <13>Dec 19 03:07:39 rpmi: python3-module-twisted-web-24.7.0-alt1 sisyphus+360814.100.1.1 1729934750 installed <13>Dec 19 03:07:39 rpmi: python3-module-twisted-words-24.7.0-alt1 sisyphus+360814.100.1.1 1729934750 installed <13>Dec 19 03:07:39 rpmi: python3-module-twisted-core-24.7.0-alt1 sisyphus+360814.100.1.1 1729934750 installed <13>Dec 19 03:07:39 rpmi: python3-module-twisted-names-24.7.0-alt1 sisyphus+360814.100.1.1 1729934750 installed <13>Dec 19 03:07:39 rpmi: python3-module-tornado-6.4.2-alt1 sisyphus+363445.100.1.1 1732635491 installed <13>Dec 19 03:07:39 rpmi: python3-module-gunicorn-23.0.0-alt1 sisyphus+362920.200.1.1 1732021917 installed <13>Dec 19 03:07:39 rpmi: python3-module-aiohttp-3.10.10-alt1 sisyphus+362035.100.1.3 1731079086 installed <13>Dec 19 03:07:39 rpmi: python3-module-GeoIP2-4.8.1-alt1 sisyphus+362946.100.1.1 1732032825 installed <13>Dec 19 03:07:39 rpmi: python3-module-django-dbbackend-postgresql-5.0.9-alt1 sisyphus+361957.1100.6.1 1731593715 installed <13>Dec 19 03:07:40 rpmi: python3-module-django-5.0.9-alt1 sisyphus+361957.1100.6.1 1731593715 installed <13>Dec 19 03:07:40 rpmi: python3-module-django-dbbackend-sqlite3-5.0.9-alt1 sisyphus+361957.1100.6.1 1731593715 installed <86>Dec 19 03:07:40 useradd[1641640]: failed adding user 'ldap', exit code: 9 <13>Dec 19 03:07:40 rpmi: openldap-servers-2.6.9-alt1 sisyphus+364781.100.1.1 1733971238 installed <13>Dec 19 03:07:40 rpmi: openldap-clients-2.6.9-alt1 sisyphus+364781.100.1.1 1733971238 installed <13>Dec 19 03:07:40 rpmi: python3-module-ldap-3.4.4-alt1 sisyphus+333513.67500.74.1 1704721072 installed <13>Dec 19 03:07:40 rpmi: python3-module-setuptools-1:75.6.0-alt1 sisyphus+363072.100.1.1 1732185054 installed Building target platforms: x86_64 Building for target x86_64 Wrote: /usr/src/in/nosrpm/python3-module-django-auth-ldap-4.8.0-alt1.nosrc.rpm (w1.gzdio) <13>Dec 19 03:07:43 rpmi: python3-module-pyproject-installer-0.5.5-alt1 sisyphus+362541.100.1.1 1731610714 installed Installing python3-module-django-auth-ldap-4.8.0-alt1.src.rpm Building target platforms: x86_64 Building for target x86_64 Executing(%prep): /bin/sh -e /usr/src/tmp/rpm-tmp.39959 + 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.8.0 + echo 'Source #0 (python3-module-django-auth-ldap-4.8.0.tar):' Source #0 (python3-module-django-auth-ldap-4.8.0.tar): + /bin/tar -xf /usr/src/RPM/SOURCES/python3-module-django-auth-ldap-4.8.0.tar + cd python3-module-django-auth-ldap-4.8.0 + /bin/chmod -c -Rf u+rwX,go-w . + exit 0 Executing(%build): /bin/sh -e /usr/src/tmp/rpm-tmp.39959 + umask 022 + /bin/mkdir -p /usr/src/RPM/BUILD + cd /usr/src/RPM/BUILD + cd python3-module-django-auth-ldap-4.8.0 + export 'CFLAGS=-pipe -frecord-gcc-switches -Wall -g -O2 -flto=auto' + CFLAGS='-pipe -frecord-gcc-switches -Wall -g -O2 -flto=auto' + export 'CXXFLAGS=-pipe -frecord-gcc-switches -Wall -g -O2 -flto=auto' + CXXFLAGS='-pipe -frecord-gcc-switches -Wall -g -O2 -flto=auto' + export 'FFLAGS=-pipe -frecord-gcc-switches -Wall -g -O2 -flto=auto' + FFLAGS='-pipe -frecord-gcc-switches -Wall -g -O2 -flto=auto' + /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.8.0 INFO : pyproject_installer.build_cmd._build : Output dir: /usr/src/RPM/BUILD/python3-module-django-auth-ldap-4.8.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.8.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.8.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/lib/django_auth_ldap INFO : root : copying django_auth_ldap/__init__.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/config.py -> build/lib/django_auth_ldap 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 : installing to build/bdist.linux-x86_64/wheel INFO : root : running install INFO : root : running install_lib INFO : root : creating build/bdist.linux-x86_64/wheel INFO : root : creating build/bdist.linux-x86_64/wheel/django_auth_ldap INFO : root : copying build/lib/django_auth_ldap/__init__.py -> build/bdist.linux-x86_64/wheel/./django_auth_ldap INFO : root : copying build/lib/django_auth_ldap/backend.py -> build/bdist.linux-x86_64/wheel/./django_auth_ldap INFO : root : copying build/lib/django_auth_ldap/config.py -> build/bdist.linux-x86_64/wheel/./django_auth_ldap INFO : root : running install_egg_info INFO : root : Copying django_auth_ldap.egg-info to build/bdist.linux-x86_64/wheel/./django_auth_ldap-0.0.0-py3.12.egg-info INFO : root : running install_scripts INFO : root : creating build/bdist.linux-x86_64/wheel/django_auth_ldap-0.0.0.dist-info/WHEEL INFO : wheel : creating '/usr/src/RPM/BUILD/python3-module-django-auth-ldap-4.8.0/dist/.tmp-4h_6ji8v/django_auth_ldap-0.0.0-py3-none-any.whl' and adding 'build/bdist.linux-x86_64/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 : root : removing build/bdist.linux-x86_64/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.39959 + 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:/usr/bin:/bin:/usr/local/bin:/usr/games + cd python3-module-django-auth-ldap-4.8.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.8.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) Splitting links to aliased files under /{,s}bin in /usr/src/tmp/python3-module-django-auth-ldap-buildroot 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-312.opt-1.pyc' => './usr/lib/python3/site-packages/django_auth_ldap/__pycache__/__init__.cpython-312.pyc' './usr/lib/python3/site-packages/django_auth_ldap/__pycache__/__init__.cpython-312.opt-2.pyc' => './usr/lib/python3/site-packages/django_auth_ldap/__pycache__/__init__.cpython-312.opt-1.pyc' './usr/lib/python3/site-packages/django_auth_ldap/__pycache__/backend.cpython-312.opt-1.pyc' => './usr/lib/python3/site-packages/django_auth_ldap/__pycache__/backend.cpython-312.pyc' './usr/lib/python3/site-packages/django_auth_ldap/__pycache__/config.cpython-312.opt-1.pyc' => './usr/lib/python3/site-packages/django_auth_ldap/__pycache__/config.cpython-312.pyc' Executing(%check): /bin/sh -e /usr/src/tmp/rpm-tmp.74748 + umask 022 + /bin/mkdir -p /usr/src/RPM/BUILD + cd /usr/src/RPM/BUILD + cd python3-module-django-auth-ldap-4.8.0 + export BIN=/usr/src/bin:/usr/bin:/bin:/usr/local/bin:/usr/games:/usr/sbin + BIN=/usr/src/bin:/usr/bin:/bin:/usr/local/bin:/usr/games:/usr/sbin + python3 -Wa -b -m django test --settings tests.settings Creating test database for alias 'default'... Found 91 test(s). System check identified no issues (0 silenced). <167>Dec 18 21:07:45 slapd[1674288]: @(#) $OpenLDAP: slapd 2.6.9 (Dec 12 2024 02:17:07) $ openldap <167>Dec 18 21:07:45 slapd[1674288]: slapd starting <167>Dec 18 21:07:46 slapd[1674288]: conn=1000 fd=12 ACCEPT from PATH=/usr/src/RPM/BUILD/python3-module-django-auth-ldap-4.8.0/python-ldap-test-37905/ldapi (PATH=/usr/src/RPM/BUILD/python3-module-django-auth-ldap-4.8.0/python-ldap-test-37905/ldapi) <167>Dec 18 21:07:46 slapd[1674288]: conn=1000 op=0 BIND dn="" method=163 <167>Dec 18 21:07:46 slapd[1674288]: conn=1000 op=0 BIND authcid="gidNumber=1878+uidNumber=1878,cn=peercred,cn=external,cn=auth" authzid="gidNumber=1878+uidNumber=1878,cn=peercred,cn=external,cn=auth" <167>Dec 18 21:07:46 slapd[1674288]: conn=1000 op=0 RESULT tag=97 err=0 qtime=0.000006 etime=0.000276 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1000 op=1 EXT oid=1.3.6.1.4.1.4203.1.11.3 <167>Dec 18 21:07:46 slapd[1674288]: conn=1000 op=2 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1000 fd=12 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1001 fd=12 ACCEPT from IP=127.0.0.1:57278 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1001 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1001 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1001 op=0 RESULT tag=97 err=0 qtime=0.000007 etime=0.000114 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1002 fd=13 ACCEPT from IP=127.0.0.1:57290 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1002 op=0 BIND dn="uid=bob,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1002 op=0 BIND dn="uid=bob,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1002 op=0 RESULT tag=97 err=0 qtime=0.000006 etime=0.000067 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1001 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1001 op=1 RESULT tag=97 err=0 qtime=0.000005 etime=0.000025 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1001 op=2 CMP dn="cn=alice_gon,ou=query_groups,o=test" attr="member" <167>Dec 18 21:07:46 slapd[1674288]: conn=1001 op=2 RESULT tag=111 err=6 qtime=0.000006 etime=0.000043 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1001 op=3 CMP dn="cn=mutual_gon,ou=query_groups,o=test" attr="member" <167>Dec 18 21:07:46 slapd[1674288]: conn=1001 op=3 RESULT tag=111 err=6 qtime=0.000006 etime=0.000036 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1002 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1002 op=1 RESULT tag=97 err=0 qtime=0.000007 etime=0.000038 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1002 op=2 CMP dn="cn=alice_gon,ou=query_groups,o=test" attr="member" <167>Dec 18 21:07:46 slapd[1674288]: conn=1002 op=2 RESULT tag=111 err=5 qtime=0.000009 etime=0.000086 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1001 op=4 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1001 fd=12 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1002 op=3 UNBIND .<167>Dec 18 21:07:46 slapd[1674288]: conn=1002 fd=13 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1003 fd=12 ACCEPT from IP=127.0.0.1:57304 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1003 op=0 BIND dn="cn=charlie_cooper,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1003 op=0 RESULT tag=97 err=0 qtime=0.000006 etime=0.000040 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1003 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1003 op=1 RESULT tag=97 err=0 qtime=0.000006 etime=0.000032 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1003 op=2 SRCH base="cn=charlie_cooper,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 18 21:07:46 slapd[1674288]: conn=1003 op=2 ENTRY dn="cn=charlie_cooper,ou=people,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1003 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000007 etime=0.000149 nentries=1 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1004 fd=13 ACCEPT from IP=127.0.0.1:57310 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1004 op=0 BIND dn="uid=Alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1004 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1004 op=0 RESULT tag=97 err=0 qtime=0.000007 etime=0.000052 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1004 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1004 op=1 RESULT tag=97 err=0 qtime=0.000005 etime=0.000031 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1004 op=2 SRCH base="uid=Alice,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 18 21:07:46 slapd[1674288]: conn=1004 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000006 etime=0.000045 nentries=1 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1005 fd=14 ACCEPT from IP=127.0.0.1:57314 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1005 op=0 BIND dn="uid=bob,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1005 op=0 RESULT tag=97 err=49 qtime=0.000005 etime=0.000029 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1005 op=1 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1005 fd=14 closed .<167>Dec 18 21:07:46 slapd[1674288]: conn=1006 fd=14 ACCEPT from IP=127.0.0.1:57322 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1006 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1006 op=0 RESULT tag=97 err=0 qtime=0.000004 etime=0.000033 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1006 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1006 op=1 RESULT tag=97 err=0 qtime=0.000005 etime=0.000029 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1006 op=2 SRCH base="uid=alice,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 18 21:07:46 slapd[1674288]: conn=1006 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000006 etime=0.000074 nentries=1 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1007 fd=15 ACCEPT from IP=127.0.0.1:57328 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1007 op=0 BIND dn="" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1007 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000028 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1007 op=1 SRCH base="ou=people,o=test" scope=2 deref=0 filter="(uid=not-in-ldap)" <167>Dec 18 21:07:46 slapd[1674288]: conn=1007 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000007 etime=0.000067 nentries=0 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1008 fd=16 ACCEPT from IP=127.0.0.1:57334 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1008 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000029 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1008 op=1 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=*)(member=uid=alice,ou=people,o=test))" <167>Dec 18 21:07:46 slapd[1674288]: conn=1008 op=1 ENTRY dn="cn=staff_gon,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1008 op=1 ENTRY dn="cn=active_gon,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1008 op=1 ENTRY dn="cn=nested_gon,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1008 op=1 ENTRY dn="cn=superuser_gon,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1008 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000005 etime=0.000196 nentries=4 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1009 fd=17 ACCEPT from IP=127.0.0.1:57344 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1009 op=0 BIND dn="" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1009 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000029 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1009 op=1 SRCH base="ou=people,o=test" scope=2 deref=0 filter="(uid=invalid)" <167>Dec 18 21:07:46 slapd[1674288]: conn=1009 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000007 etime=0.000051 nentries=0 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1009 op=2 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1009 fd=17 closed .<167>Dec 18 21:07:46 slapd[1674288]: conn=1010 fd=17 ACCEPT from IP=127.0.0.1:57356 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1010 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1010 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1010 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000064 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1010 op=1 SRCH base="uid=alice,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 18 21:07:46 slapd[1674288]: conn=1010 op=1 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1010 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000008 etime=0.000141 nentries=1 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1011 fd=18 ACCEPT from IP=127.0.0.1:57368 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1011 op=0 BIND dn="cn=charlie_cooper,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1011 op=0 RESULT tag=97 err=0 qtime=0.000006 etime=0.000053 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1011 op=1 SRCH base="ou=people,o=test" scope=2 deref=0 filter="(uid=charlie)" <167>Dec 18 21:07:46 slapd[1674288]: conn=1011 op=1 ENTRY dn="cn=charlie_cooper,ou=people,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1011 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000006 etime=0.000062 nentries=1 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1012 fd=19 ACCEPT from IP=127.0.0.1:57374 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1012 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1012 op=0 RESULT tag=97 err=0 qtime=0.000006 etime=0.000046 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1003 op=3 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1003 fd=12 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1004 fd=13 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1007 op=2 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1007 fd=15 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1011 op=2 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1010 op=2 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1006 op=3 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1011 fd=18 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1010 fd=17 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1008 fd=16 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1006 fd=14 closed .<167>Dec 18 21:07:46 slapd[1674288]: conn=1013 fd=12 ACCEPT from IP=127.0.0.1:57388 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1013 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1013 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1013 op=0 RESULT tag=97 err=0 qtime=0.000013 etime=0.000120 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1013 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1013 op=1 RESULT tag=97 err=0 qtime=0.000007 etime=0.000040 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1013 op=2 SRCH base="uid=alice,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 18 21:07:46 slapd[1674288]: conn=1013 op=2 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1013 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000007 etime=0.000073 nentries=1 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1014 fd=13 ACCEPT from IP=127.0.0.1:57394 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1014 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1014 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1014 op=0 RESULT tag=97 err=0 qtime=0.000004 etime=0.000054 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1015 fd=14 ACCEPT from IP=127.0.0.1:57404 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1015 op=0 RESULT tag=97 err=0 qtime=0.000006 etime=0.000032 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1015 op=1 SRCH base="uid=alice,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 18 21:07:46 slapd[1674288]: conn=1015 op=1 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1015 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000005 etime=0.000111 nentries=1 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1016 fd=15 ACCEPT from IP=127.0.0.1:57412 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1016 op=0 BIND dn="" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1016 op=0 RESULT tag=97 err=0 qtime=0.000008 etime=0.000040 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1016 op=1 SRCH base="uid=bob,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 18 21:07:46 slapd[1674288]: conn=1016 op=1 ENTRY dn="uid=bob,ou=people,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1016 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000007 etime=0.000134 nentries=1 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1017 fd=16 ACCEPT from IP=127.0.0.1:57416 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1017 op=0 BIND dn="uid=Alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1017 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1017 op=0 RESULT tag=97 err=0 qtime=0.000006 etime=0.000142 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1018 fd=17 ACCEPT from IP=127.0.0.1:57432 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1018 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1018 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1018 op=0 RESULT tag=97 err=0 qtime=0.000006 etime=0.000053 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1019 fd=18 ACCEPT from IP=127.0.0.1:57444 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1019 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1019 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1019 op=0 RESULT tag=97 err=0 qtime=0.000006 etime=0.000049 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1019 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1019 op=1 RESULT tag=97 err=0 qtime=0.000006 etime=0.000034 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1019 op=2 CMP dn="cn=active_gon,ou=groups,o=test" attr="member" <167>Dec 18 21:07:46 slapd[1674288]: conn=1019 op=2 RESULT tag=111 err=6 qtime=0.000005 etime=0.000056 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1020 fd=20 ACCEPT from IP=127.0.0.1:57448 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1020 op=0 BIND dn="uid=bob,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1020 op=0 BIND dn="uid=bob,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1020 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000037 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1020 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1020 op=1 RESULT tag=97 err=0 qtime=0.000007 etime=0.000029 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1020 op=2 CMP dn="cn=active_gon,ou=groups,o=test" attr="member" <167>Dec 18 21:07:46 slapd[1674288]: conn=1020 op=2 RESULT tag=111 err=5 qtime=0.000008 etime=0.000055 text= ..<167>Dec 18 21:07:46 slapd[1674288]: conn=1021 fd=21 ACCEPT from IP=127.0.0.1:57454 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1021 op=0 BIND dn="" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1021 op=0 RESULT tag=97 err=0 qtime=0.000007 etime=0.000035 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1021 op=1 SRCH base="ou=people,o=test" scope=2 deref=0 filter="(uid=alice)" <167>Dec 18 21:07:46 slapd[1674288]: conn=1021 op=1 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1021 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000012 etime=0.000140 nentries=1 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1021 op=2 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1021 op=2 RESULT tag=97 err=0 qtime=0.000007 etime=0.000046 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1022 fd=22 ACCEPT from IP=127.0.0.1:57468 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1022 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1022 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1022 op=0 RESULT tag=97 err=0 qtime=0.000013 etime=0.000068 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1023 fd=23 ACCEPT from IP=127.0.0.1:57478 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1023 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1023 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1023 op=0 RESULT tag=97 err=0 qtime=0.000006 etime=0.000037 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1023 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1023 op=1 RESULT tag=97 err=0 qtime=0.000008 etime=0.000036 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1023 op=2 CMP dn="cn=active_gon,ou=groups,o=test" attr="member" <167>Dec 18 21:07:46 slapd[1674288]: conn=1023 op=2 RESULT tag=111 err=6 qtime=0.000005 etime=0.000037 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1023 op=3 CMP dn="cn=empty_gon,ou=groups,o=test" attr="member" <167>Dec 18 21:07:46 slapd[1674288]: conn=1023 op=3 RESULT tag=111 err=5 qtime=0.000012 etime=0.000050 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1023 op=4 CMP dn="cn=staff_gon,ou=groups,o=test" attr="member" <167>Dec 18 21:07:46 slapd[1674288]: conn=1023 op=4 RESULT tag=111 err=6 qtime=0.000008 etime=0.000067 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1023 op=5 CMP dn="cn=superuser_gon,ou=groups,o=test" attr="member" <167>Dec 18 21:07:46 slapd[1674288]: conn=1023 op=5 RESULT tag=111 err=6 qtime=0.000008 etime=0.000052 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1024 fd=24 ACCEPT from IP=127.0.0.1:57492 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1024 op=0 BIND dn="uid=bob,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1024 op=0 BIND dn="uid=bob,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1024 op=0 RESULT tag=97 err=0 qtime=0.000004 etime=0.000048 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1024 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1024 op=2 CMP dn="cn=active_gon,ou=groups,o=test" attr="member" <167>Dec 18 21:07:46 slapd[1674288]: conn=1024 op=2 RESULT tag=111 err=5 qtime=0.000007 etime=0.000045 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1024 op=3 CMP dn="cn=empty_gon,ou=groups,o=test" attr="member" <167>Dec 18 21:07:46 slapd[1674288]: conn=1024 op=3 RESULT tag=111 err=5 qtime=0.000006 etime=0.000029 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1024 op=4 CMP dn="cn=staff_gon,ou=groups,o=test" attr="member" <167>Dec 18 21:07:46 slapd[1674288]: conn=1024 op=4 RESULT tag=111 err=5 qtime=0.000009 etime=0.000060 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1024 op=5 CMP dn="cn=superuser_gon,ou=groups,o=test" attr="member" <167>Dec 18 21:07:46 slapd[1674288]: conn=1024 op=5 RESULT tag=111 err=5 qtime=0.000007 etime=0.000044 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1025 fd=25 ACCEPT from IP=127.0.0.1:57506 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1025 op=0 RESULT tag=97 err=0 qtime=0.000006 etime=0.000029 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1025 op=1 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=*)(member=uid=alice,ou=people,o=test))" <167>Dec 18 21:07:46 slapd[1674288]: conn=1025 op=1 ENTRY dn="cn=staff_gon,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1025 op=1 ENTRY dn="cn=active_gon,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1025 op=1 ENTRY dn="cn=superuser_gon,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1025 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000005 etime=0.000084 nentries=4 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1026 fd=26 ACCEPT from IP=127.0.0.1:57512 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1026 op=0 RESULT tag=97 err=0 qtime=0.000004 etime=0.000026 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1026 op=1 SRCH base="ou=people,o=test" scope=2 deref=0 filter="(uid=alice)" <167>Dec 18 21:07:46 slapd[1674288]: conn=1026 op=1 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1026 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000009 etime=0.000165 nentries=1 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1026 op=2 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1026 op=2 RESULT tag=97 err=0 qtime=0.000005 etime=0.000038 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1013 op=3 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1013 fd=12 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1014 op=1 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1014 fd=13 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1015 op=2 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1017 op=1 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1015 fd=14 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1018 op=1 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1016 fd=15 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1017 fd=16 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1018 fd=17 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1019 fd=18 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1020 op=3 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1021 op=3 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1020 fd=20 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1021 fd=21 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1023 op=6 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1024 op=6 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1023 fd=23 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1022 fd=22 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1025 fd=25 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1024 fd=24 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1027 fd=12 ACCEPT from IP=127.0.0.1:57518 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1027 op=0 BIND dn="" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1027 op=0 RESULT tag=97 err=0 qtime=0.000008 etime=0.000042 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1027 op=1 SRCH base="ou=people,o=test" scope=2 deref=0 filter="(uid=alice)" <167>Dec 18 21:07:46 slapd[1674288]: conn=1027 op=1 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1027 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000005 etime=0.000083 nentries=1 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1027 op=2 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1027 op=2 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1027 op=2 RESULT tag=97 err=0 qtime=0.000028 etime=0.000077 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1028 fd=13 ACCEPT from IP=127.0.0.1:57528 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1028 op=0 BIND dn="" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1028 op=0 RESULT tag=97 err=0 qtime=0.000006 etime=0.000029 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1028 op=1 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=*)(member=uid=bob,ou=people,o=test))" <167>Dec 18 21:07:46 slapd[1674288]: conn=1028 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000007 etime=0.000069 nentries=0 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1029 fd=14 ACCEPT from IP=127.0.0.1:57534 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1029 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1029 op=0 RESULT tag=97 err=0 qtime=0.000007 etime=0.000047 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1030 fd=15 ACCEPT from IP=127.0.0.1:57548 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1030 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000026 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1030 op=1 SRCH base="ou=people,o=test" scope=2 deref=0 filter="(uid=alice)" <167>Dec 18 21:07:46 slapd[1674288]: conn=1030 op=1 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1030 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000004 etime=0.000051 nentries=1 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1030 op=2 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1030 op=2 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1030 op=2 RESULT tag=97 err=0 qtime=0.000006 etime=0.000050 text= ..<167>Dec 18 21:07:46 slapd[1674288]: conn=1031 fd=16 ACCEPT from IP=127.0.0.1:57550 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1031 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1031 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000048 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1031 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1031 op=1 RESULT tag=97 err=0 qtime=0.000008 etime=0.000038 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1031 op=2 SRCH base="uid=Alice,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 18 21:07:46 slapd[1674288]: conn=1031 op=2 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1031 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000008 etime=0.000068 nentries=1 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1032 fd=17 ACCEPT from IP=127.0.0.1:57556 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1032 op=0 BIND dn="uid=Alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1032 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1032 op=0 RESULT tag=97 err=0 qtime=0.000004 etime=0.000057 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1032 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1032 op=1 RESULT tag=97 err=0 qtime=0.000006 etime=0.000032 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1032 op=2 SRCH base="uid=Alice,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 18 21:07:46 slapd[1674288]: conn=1032 op=2 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1032 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000005 etime=0.000094 nentries=1 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1033 fd=18 ACCEPT from IP=127.0.0.1:57558 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1033 op=0 BIND dn="" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1033 op=0 RESULT tag=97 err=0 qtime=0.000009 etime=0.000035 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1033 op=1 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=*)(member=uid=alice,ou=people,o=test))" <167>Dec 18 21:07:46 slapd[1674288]: conn=1033 op=1 ENTRY dn="cn=active_gon,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1033 op=1 ENTRY dn="cn=nested_gon,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1033 op=1 ENTRY dn="cn=superuser_gon,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1033 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000010 etime=0.000150 nentries=4 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1034 fd=20 ACCEPT from IP=127.0.0.1:57564 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1034 op=0 RESULT tag=97 err=0 qtime=0.000015 etime=0.000043 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1034 op=1 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=*)(member=uid=bob,ou=people,o=test))" <167>Dec 18 21:07:46 slapd[1674288]: conn=1034 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000005 etime=0.000074 nentries=0 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1035 fd=21 ACCEPT from IP=127.0.0.1:57580 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1035 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1035 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1035 op=0 RESULT tag=97 err=0 qtime=0.000006 etime=0.000037 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1035 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1035 op=1 RESULT tag=97 err=0 qtime=0.000005 etime=0.000026 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1035 op=2 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=*)(member=uid=alice,ou=people,o=test))" <167>Dec 18 21:07:46 slapd[1674288]: conn=1035 op=2 ENTRY dn="cn=staff_gon,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1035 op=2 ENTRY dn="cn=active_gon,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1035 op=2 ENTRY dn="cn=nested_gon,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1035 op=2 ENTRY dn="cn=superuser_gon,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1035 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000009 etime=0.000219 nentries=4 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1036 fd=22 ACCEPT from IP=127.0.0.1:57594 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1036 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1036 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1036 op=0 RESULT tag=97 err=0 qtime=0.000006 etime=0.000055 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1036 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1036 op=1 RESULT tag=97 err=0 qtime=0.000006 etime=0.000032 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1036 op=2 SRCH base="uid=alice,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 18 21:07:46 slapd[1674288]: conn=1036 op=2 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1036 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000004 etime=0.000038 nentries=1 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1036 op=3 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=posixGroup)(|(gidNumber=1000)(memberUid=alice)))" <167>Dec 18 21:07:46 slapd[1674288]: conn=1036 op=3 ENTRY dn="cn=staff_px,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1036 op=3 ENTRY dn="cn=active_px,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1036 op=3 ENTRY dn="cn=superuser_px,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1036 op=3 SEARCH RESULT tag=101 err=0 qtime=0.000004 etime=0.000159 nentries=3 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1037 fd=23 ACCEPT from IP=127.0.0.1:57598 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1037 op=0 BIND dn="" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1037 op=0 RESULT tag=97 err=0 qtime=0.000004 etime=0.000021 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1037 op=1 SRCH base="uid=alice,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 18 21:07:46 slapd[1674288]: conn=1037 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000006 etime=0.000047 nentries=1 text= <167>Dec 18 21:07:46 slapd[1674288]: 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 18 21:07:46 slapd[1674288]: conn=1037 op=2 ENTRY dn="cn=mirror1,ou=mirror_groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1037 op=2 ENTRY dn="cn=mirror3,ou=mirror_groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1037 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000006 etime=0.000105 nentries=2 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1038 fd=24 ACCEPT from IP=127.0.0.1:57604 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1038 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1038 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1038 op=0 RESULT tag=97 err=0 qtime=0.000007 etime=0.000050 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1038 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1038 op=1 RESULT tag=97 err=0 qtime=0.000004 etime=0.000031 text= <167>Dec 18 21:07:46 slapd[1674288]: 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 18 21:07:46 slapd[1674288]: conn=1038 op=2 ENTRY dn="cn=mirror1,ou=mirror_groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1038 op=2 ENTRY dn="cn=mirror3,ou=mirror_groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1038 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000010 etime=0.000112 nentries=2 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1039 fd=25 ACCEPT from IP=127.0.0.1:57612 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1039 op=0 BIND dn="" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1039 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000031 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1039 op=1 SRCH base="uid=alice,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 18 21:07:46 slapd[1674288]: conn=1039 op=1 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1039 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000005 etime=0.000045 nentries=1 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1027 op=3 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1027 fd=12 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1028 op=2 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1028 fd=13 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1029 op=1 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1030 op=3 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1029 fd=14 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1031 op=3 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1034 op=2 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1032 op=3 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1034 fd=20 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1035 op=3 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1036 op=4 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1032 fd=17 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1035 fd=21 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1038 fd=24 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1030 fd=15 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1037 op=3 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: 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 18 21:07:46 slapd[1674288]: conn=1039 op=2 ENTRY dn="cn=mirror1,ou=mirror_groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1039 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000103 etime=0.000300 nentries=2 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1040 fd=12 ACCEPT from IP=127.0.0.1:57618 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1040 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1040 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1040 op=0 RESULT tag=97 err=0 qtime=0.000007 etime=0.000049 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1040 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1040 op=1 RESULT tag=97 err=0 qtime=0.000007 etime=0.000036 text= <167>Dec 18 21:07:46 slapd[1674288]: 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 18 21:07:46 slapd[1674288]: conn=1040 op=2 ENTRY dn="cn=mirror1,ou=mirror_groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1040 op=2 ENTRY dn="cn=mirror3,ou=mirror_groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1040 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000006 etime=0.000078 nentries=2 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1041 fd=13 ACCEPT from IP=127.0.0.1:57632 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1041 op=0 BIND dn="" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1041 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000036 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1041 op=1 SRCH base="uid=alice,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 18 21:07:46 slapd[1674288]: conn=1041 op=1 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1041 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000010 etime=0.000124 nentries=1 text= <167>Dec 18 21:07:46 slapd[1674288]: 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 18 21:07:46 slapd[1674288]: conn=1041 op=2 ENTRY dn="cn=mirror1,ou=mirror_groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1041 op=2 ENTRY dn="cn=mirror3,ou=mirror_groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1041 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000005 etime=0.000093 nentries=2 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1042 fd=14 ACCEPT from IP=127.0.0.1:57640 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1042 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1042 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1042 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000057 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1042 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1042 op=1 RESULT tag=97 err=0 qtime=0.000007 etime=0.000042 text= <167>Dec 18 21:07:46 slapd[1674288]: 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 18 21:07:46 slapd[1674288]: conn=1042 op=2 ENTRY dn="cn=mirror3,ou=mirror_groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1042 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000009 etime=0.000081 nentries=2 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1043 fd=15 ACCEPT from IP=127.0.0.1:57654 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1043 op=0 BIND dn="" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1043 op=0 RESULT tag=97 err=0 qtime=0.000006 etime=0.000036 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1043 op=1 SRCH base="uid=alice,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 18 21:07:46 slapd[1674288]: conn=1043 op=1 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1043 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000008 etime=0.000059 nentries=1 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1043 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 18 21:07:46 slapd[1674288]: conn=1043 op=2 ENTRY dn="cn=mirror3,ou=mirror_groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1043 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000007 etime=0.000093 nentries=2 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1044 fd=16 ACCEPT from IP=127.0.0.1:57664 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1044 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1044 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1044 op=0 RESULT tag=97 err=0 qtime=0.000004 etime=0.000041 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1044 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1044 op=1 RESULT tag=97 err=0 qtime=0.000006 etime=0.000032 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1044 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 18 21:07:46 slapd[1674288]: conn=1044 op=2 ENTRY dn="cn=mirror3,ou=mirror_groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1044 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000010 etime=0.000090 nentries=2 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1045 fd=17 ACCEPT from IP=127.0.0.1:57670 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1045 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1045 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1045 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000043 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1045 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1045 op=2 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=*)(member=uid=alice,ou=people,o=test))" <167>Dec 18 21:07:46 slapd[1674288]: conn=1045 op=2 ENTRY dn="cn=staff_gon,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1045 op=2 ENTRY dn="cn=active_gon,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1045 op=2 ENTRY dn="cn=superuser_gon,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1045 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000006 etime=0.000132 nentries=4 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1046 fd=18 ACCEPT from IP=127.0.0.1:57682 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1046 op=0 BIND dn="uid=bob,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1046 op=0 RESULT tag=97 err=49 qtime=0.000005 etime=0.000036 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1047 fd=20 ACCEPT from IP=127.0.0.1:57692 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1047 op=0 BIND dn="uid=dreßler,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1047 op=0 BIND dn="uid=dreßler,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1047 op=0 RESULT tag=97 err=0 qtime=0.000006 etime=0.000057 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1047 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1047 op=1 RESULT tag=97 err=0 qtime=0.000005 etime=0.000023 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1047 op=2 CMP dn="cn=dreßler_gon,ou=query_groups,o=test" attr="member" <167>Dec 18 21:07:46 slapd[1674288]: conn=1047 op=2 RESULT tag=111 err=6 qtime=0.000006 etime=0.000045 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1048 fd=21 ACCEPT from IP=127.0.0.1:57704 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1048 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1048 op=0 RESULT tag=97 err=0 qtime=0.000006 etime=0.000042 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1048 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1048 op=1 RESULT tag=97 err=0 qtime=0.000004 etime=0.000033 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1048 op=2 CMP dn="cn=other_gon,ou=moregroups,o=test" attr="member" <167>Dec 18 21:07:46 slapd[1674288]: conn=1048 op=2 RESULT tag=111 err=5 qtime=0.000007 etime=0.000043 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1049 fd=22 ACCEPT from IP=127.0.0.1:57710 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1049 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000033 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1049 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1049 op=1 RESULT tag=97 err=0 qtime=0.000005 etime=0.000030 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1049 op=2 CMP dn="cn=other_gon,ou=moregroups,o=test" attr="member" <167>Dec 18 21:07:46 slapd[1674288]: conn=1049 op=2 RESULT tag=111 err=6 qtime=0.000006 etime=0.000039 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1049 op=4 SRCH base="ou=moregroups,o=test" scope=2 deref=0 filter="(&(objectClass=groupOfNames)(member=uid=bob,ou=people,o=test))" <167>Dec 18 21:07:46 slapd[1674288]: conn=1049 op=3 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=groupOfNames)(member=uid=bob,ou=people,o=test))" <167>Dec 18 21:07:46 slapd[1674288]: conn=1049 op=4 SEARCH RESULT tag=101 err=0 qtime=0.000009 etime=0.000063 nentries=1 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1049 op=3 SEARCH RESULT tag=101 err=0 qtime=0.000017 etime=0.000090 nentries=0 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1050 fd=23 ACCEPT from IP=127.0.0.1:57726 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1050 op=0 BIND dn="" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1050 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000026 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1050 op=1 SRCH base="ou=people,o=test" scope=2 deref=0 filter="(uid=alice)" <167>Dec 18 21:07:46 slapd[1674288]: conn=1050 op=1 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1050 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000005 etime=0.000075 nentries=1 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1050 op=2 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1050 op=2 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1050 op=2 RESULT tag=97 err=0 qtime=0.000006 etime=0.000042 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1051 fd=24 ACCEPT from IP=127.0.0.1:57734 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1051 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1051 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1051 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000045 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1051 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1051 op=1 RESULT tag=97 err=0 qtime=0.000005 etime=0.000028 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1051 op=2 CMP dn="cn=alice_gon,ou=query_groups,o=test" attr="member" .<167>Dec 18 21:07:46 slapd[1674288]: conn=1052 fd=27 ACCEPT from IP=127.0.0.1:57748 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1052 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1052 op=0 RESULT tag=97 err=0 qtime=0.000007 etime=0.000066 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1052 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1052 op=1 RESULT tag=97 err=0 qtime=0.000007 etime=0.000043 text= <167>Dec 18 21:07:46 slapd[1674288]: connection_input: conn=1052 deferring operation: binding <167>Dec 18 21:07:46 slapd[1674288]: conn=1052 op=2 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=*)(|(member=uid=alice,ou=people,o=test)))" <167>Dec 18 21:07:46 slapd[1674288]: conn=1052 op=2 ENTRY dn="cn=staff_gon,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1052 op=2 ENTRY dn="cn=active_gon,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1052 op=2 ENTRY dn="cn=nested_gon,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1052 op=2 ENTRY dn="cn=superuser_gon,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1052 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000096 etime=0.000235 nentries=4 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1052 op=3 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=*)(|(member=cn=staff_gon,ou=groups,o=test)(member=cn=active_gon,ou=groups,o=test)(member=cn=superuser_gon,ou=groups,o=test)(member=cn=nested_gon,ou=groups,o=test)))" <167>Dec 18 21:07:46 slapd[1674288]: conn=1052 op=3 ENTRY dn="cn=parent_gon,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1052 op=3 SEARCH RESULT tag=101 err=0 qtime=0.000006 etime=0.000107 nentries=1 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1052 op=4 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=*)(|(member=cn=parent_gon,ou=groups,o=test)))" <167>Dec 18 21:07:46 slapd[1674288]: conn=1052 op=4 ENTRY dn="cn=circular_gon,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1052 op=4 SEARCH RESULT tag=101 err=0 qtime=0.000005 etime=0.000075 nentries=1 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1052 op=5 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=*)(|(member=cn=circular_gon,ou=groups,o=test)))" <167>Dec 18 21:07:46 slapd[1674288]: conn=1052 op=5 SEARCH RESULT tag=101 err=0 qtime=0.000006 etime=0.000068 nentries=1 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1053 fd=28 ACCEPT from IP=127.0.0.1:57754 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1053 op=0 BIND dn="uid=bob,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1053 op=0 RESULT tag=97 err=0 qtime=0.000006 etime=0.000042 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1053 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1053 op=1 RESULT tag=97 err=0 qtime=0.000006 etime=0.000042 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1053 op=2 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=*)(|(member=uid=bob,ou=people,o=test)))" <167>Dec 18 21:07:46 slapd[1674288]: conn=1053 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000009 etime=0.000059 nentries=0 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1054 fd=29 ACCEPT from IP=127.0.0.1:57770 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1054 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1054 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1054 op=0 RESULT tag=97 err=0 qtime=0.000004 etime=0.000044 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1040 op=3 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1040 fd=12 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1041 op=3 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1041 fd=13 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1042 op=3 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1044 op=3 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1042 fd=14 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1043 op=3 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1043 fd=15 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1044 fd=16 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1045 op=3 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1046 op=1 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1045 fd=17 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1051 op=3 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1048 op=3 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1047 fd=20 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1049 op=5 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1052 op=6 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1049 fd=22 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1046 fd=18 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1051 fd=24 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1048 fd=21 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1052 fd=27 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1053 op=3 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1053 fd=28 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1054 op=1 RESULT tag=97 err=0 qtime=0.000148 etime=0.000169 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1054 op=2 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=groupOfNames)(|(member=uid=alice,ou=people,o=test)))" <167>Dec 18 21:07:46 slapd[1674288]: conn=1054 op=2 ENTRY dn="cn=staff_gon,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1054 op=2 ENTRY dn="cn=active_gon,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1054 op=2 ENTRY dn="cn=nested_gon,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1054 op=2 ENTRY dn="cn=superuser_gon,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1054 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000007 etime=0.000120 nentries=4 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1054 op=3 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=groupOfNames)(|(member=cn=staff_gon,ou=groups,o=test)(member=cn=active_gon,ou=groups,o=test)(member=cn=superuser_gon,ou=groups,o=test)(member=cn=nested_gon,ou=groups,o=test)))" <167>Dec 18 21:07:46 slapd[1674288]: conn=1054 op=3 ENTRY dn="cn=parent_gon,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1054 op=3 SEARCH RESULT tag=101 err=0 qtime=0.000006 etime=0.000074 nentries=1 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1054 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 18 21:07:46 slapd[1674288]: conn=1054 op=4 ENTRY dn="cn=circular_gon,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1054 op=4 SEARCH RESULT tag=101 err=0 qtime=0.000007 etime=0.000082 nentries=1 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1054 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 18 21:07:46 slapd[1674288]: conn=1054 op=5 ENTRY dn="cn=nested_gon,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1054 op=5 SEARCH RESULT tag=101 err=0 qtime=0.000005 etime=0.000064 nentries=1 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1055 fd=12 ACCEPT from IP=127.0.0.1:57772 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1055 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1055 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1055 op=0 RESULT tag=97 err=0 qtime=0.000006 etime=0.000044 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1056 fd=13 ACCEPT from IP=127.0.0.1:57784 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1056 op=0 BIND dn="uid=bob,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1056 op=0 BIND dn="uid=bob,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1056 op=0 RESULT tag=97 err=0 qtime=0.000004 etime=0.000038 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1055 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1055 op=1 RESULT tag=97 err=0 qtime=0.000008 etime=0.000039 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1055 op=2 CMP dn="cn=alice_gon,ou=query_groups,o=test" attr="member" <167>Dec 18 21:07:46 slapd[1674288]: conn=1055 op=2 RESULT tag=111 err=6 qtime=0.000006 etime=0.000045 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1055 op=3 CMP dn="cn=mutual_gon,ou=query_groups,o=test" attr="member" <167>Dec 18 21:07:46 slapd[1674288]: conn=1055 op=3 RESULT tag=111 err=6 qtime=0.000006 etime=0.000039 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1056 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1056 op=1 RESULT tag=97 err=0 qtime=0.000006 etime=0.000030 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1056 op=2 CMP dn="cn=alice_gon,ou=query_groups,o=test" attr="member" <167>Dec 18 21:07:46 slapd[1674288]: conn=1056 op=2 RESULT tag=111 err=5 qtime=0.000006 etime=0.000034 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1056 op=3 CMP dn="cn=bob_gon,ou=query_groups,o=test" attr="member" <167>Dec 18 21:07:46 slapd[1674288]: conn=1056 op=3 RESULT tag=111 err=6 qtime=0.000007 etime=0.000037 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1057 fd=14 ACCEPT from IP=127.0.0.1:57786 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1057 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1057 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1057 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000037 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1057 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1057 op=1 RESULT tag=97 err=0 qtime=0.000008 etime=0.000059 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1057 op=3 SRCH base="ou=moregroups,o=test" scope=2 deref=0 filter="(&(objectClass=groupOfNames)(|(member=uid=alice,ou=people,o=test)))" <167>Dec 18 21:07:46 slapd[1674288]: conn=1057 op=2 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=groupOfNames)(|(member=uid=alice,ou=people,o=test)))" <167>Dec 18 21:07:46 slapd[1674288]: conn=1057 op=3 SEARCH RESULT tag=101 err=0 qtime=0.000012 etime=0.000059 nentries=0 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1057 op=2 ENTRY dn="cn=staff_gon,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1057 op=2 ENTRY dn="cn=active_gon,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1057 op=2 ENTRY dn="cn=nested_gon,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1057 op=2 ENTRY dn="cn=superuser_gon,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1057 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000022 etime=0.000161 nentries=4 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1057 op=4 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=groupOfNames)(|(member=cn=staff_gon,ou=groups,o=test)(member=cn=active_gon,ou=groups,o=test)(member=cn=superuser_gon,ou=groups,o=test)(member=cn=nested_gon,ou=groups,o=test)))" <167>Dec 18 21:07:46 slapd[1674288]: conn=1057 op=4 ENTRY dn="cn=parent_gon,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1057 op=4 SEARCH RESULT tag=101 err=0 qtime=0.000019 etime=0.000083 nentries=1 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1057 op=5 SEARCH RESULT tag=101 err=0 qtime=0.000013 etime=0.000089 nentries=0 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1057 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 18 21:07:46 slapd[1674288]: conn=1057 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 18 21:07:46 slapd[1674288]: conn=1057 op=7 SEARCH RESULT tag=101 err=0 qtime=0.000020 etime=0.000055 nentries=0 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1057 op=6 ENTRY dn="cn=circular_gon,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1057 op=6 SEARCH RESULT tag=101 err=0 qtime=0.000029 etime=0.000104 nentries=1 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1057 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 18 21:07:46 slapd[1674288]: conn=1057 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 18 21:07:46 slapd[1674288]: conn=1057 op=8 ENTRY dn="cn=nested_gon,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1057 op=9 SEARCH RESULT tag=101 err=0 qtime=0.000011 etime=0.000080 nentries=0 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1057 op=8 SEARCH RESULT tag=101 err=0 qtime=0.000017 etime=0.000112 nentries=1 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1058 fd=15 ACCEPT from IP=127.0.0.1:57800 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1058 op=0 BIND dn="uid=bob,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1058 op=0 BIND dn="uid=bob,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1058 op=0 RESULT tag=97 err=0 qtime=0.000006 etime=0.000046 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1058 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1058 op=1 RESULT tag=97 err=0 qtime=0.000005 etime=0.000026 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1058 op=2 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=groupOfNames)(|(member=uid=bob,ou=people,o=test)))" <167>Dec 18 21:07:46 slapd[1674288]: conn=1058 op=3 SRCH base="ou=moregroups,o=test" scope=2 deref=0 filter="(&(objectClass=groupOfNames)(|(member=uid=bob,ou=people,o=test)))" <167>Dec 18 21:07:46 slapd[1674288]: conn=1058 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000005 etime=0.000055 nentries=0 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1058 op=3 ENTRY dn="cn=other_gon,ou=moregroups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1058 op=3 SEARCH RESULT tag=101 err=0 qtime=0.000004 etime=0.000061 nentries=1 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1058 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 18 21:07:46 slapd[1674288]: conn=1058 op=5 SEARCH RESULT tag=101 err=0 qtime=0.000009 etime=0.000052 nentries=0 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1058 op=4 SEARCH RESULT tag=101 err=0 qtime=0.000016 etime=0.000071 nentries=0 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1059 fd=16 ACCEPT from IP=127.0.0.1:57806 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1059 op=0 BIND dn="uid=Alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1059 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1059 op=0 RESULT tag=97 err=0 qtime=0.000006 etime=0.000047 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1060 fd=17 ACCEPT from IP=127.0.0.1:57814 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1060 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1060 op=0 RESULT tag=97 err=0 qtime=0.000006 etime=0.000053 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1061 fd=18 ACCEPT from IP=127.0.0.1:57824 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1061 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1061 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1061 op=0 RESULT tag=97 err=0 qtime=0.000008 etime=0.000066 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1062 fd=20 ACCEPT from IP=127.0.0.1:57836 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1062 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1062 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1062 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000039 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1063 fd=21 ACCEPT from IP=127.0.0.1:57848 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1063 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1063 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1063 op=0 RESULT tag=97 err=0 qtime=0.000004 etime=0.000034 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1064 fd=22 ACCEPT from IP=127.0.0.1:57854 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1064 op=0 BIND dn="uid=bob,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1064 op=0 BIND dn="uid=bob,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1064 op=0 RESULT tag=97 err=0 qtime=0.000006 etime=0.000048 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1064 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1064 op=1 RESULT tag=97 err=0 qtime=0.000006 etime=0.000032 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1064 op=2 SRCH base="uid=bob,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 18 21:07:46 slapd[1674288]: conn=1064 op=2 ENTRY dn="uid=bob,ou=people,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1064 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000005 etime=0.000048 nentries=1 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1065 fd=23 ACCEPT from IP=127.0.0.1:57860 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1065 op=0 BIND dn="" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1065 op=0 RESULT tag=97 err=0 qtime=0.000004 etime=0.000026 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1065 op=1 SRCH base="ou=people,o=test" scope=2 deref=0 filter="(uid=alice)" <167>Dec 18 21:07:46 slapd[1674288]: conn=1065 op=1 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1065 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000005 etime=0.000059 nentries=1 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1065 op=2 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1065 op=2 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1065 op=2 RESULT tag=97 err=0 qtime=0.000007 etime=0.000054 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1066 fd=24 ACCEPT from IP=127.0.0.1:57874 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1066 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1066 op=0 RESULT tag=97 err=0 qtime=0.000006 etime=0.000049 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1066 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1066 op=1 RESULT tag=97 err=0 qtime=0.000006 etime=0.000032 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1067 fd=27 ACCEPT from IP=127.0.0.1:57876 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1067 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1067 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1067 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000048 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1068 fd=28 ACCEPT from IP=127.0.0.1:57890 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1068 op=0 BIND dn="uid=bob,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1068 op=0 RESULT tag=97 err=0 qtime=0.000006 etime=0.000042 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1067 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1067 op=1 RESULT tag=97 err=0 qtime=0.000005 etime=0.000026 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1067 op=2 CMP dn="cn=alice_gon,ou=query_groups,o=test" attr="member" <167>Dec 18 21:07:46 slapd[1674288]: conn=1067 op=2 RESULT tag=111 err=6 qtime=0.000004 etime=0.000028 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1068 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1068 op=1 RESULT tag=97 err=0 qtime=0.000006 etime=0.000032 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1068 op=2 CMP dn="cn=alice_gon,ou=query_groups,o=test" attr="member" <167>Dec 18 21:07:46 slapd[1674288]: conn=1068 op=2 RESULT tag=111 err=5 qtime=0.000005 etime=0.000036 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1068 op=3 CMP dn="cn=bob_gon,ou=query_groups,o=test" attr="member" <167>Dec 18 21:07:46 slapd[1674288]: conn=1068 op=3 RESULT tag=111 err=6 qtime=0.000004 etime=0.000032 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1069 fd=30 ACCEPT from IP=127.0.0.1:57894 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1069 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1069 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1069 op=0 RESULT tag=97 err=0 qtime=0.000004 etime=0.000040 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1070 fd=31 ACCEPT from IP=127.0.0.1:57898 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1070 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1070 op=0 RESULT tag=97 err=53 qtime=0.000005 etime=0.000036 text=unauthenticated bind (DN with no password) disallowed <167>Dec 18 21:07:46 slapd[1674288]: conn=1070 op=1 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1070 fd=31 closed .<167>Dec 18 21:07:46 slapd[1674288]: conn=1071 fd=31 ACCEPT from IP=127.0.0.1:57914 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1071 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1071 op=0 RESULT tag=97 err=53 qtime=0.000022 etime=0.000048 text=unauthenticated bind (DN with no password) disallowed <167>Dec 18 21:07:46 slapd[1674288]: conn=1071 op=1 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1071 fd=31 closed .<167>Dec 18 21:07:46 slapd[1674288]: conn=1072 fd=31 ACCEPT from IP=127.0.0.1:57924 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1072 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1073 fd=32 ACCEPT from IP=127.0.0.1:57928 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1073 op=0 RESULT tag=97 err=0 qtime=0.000006 etime=0.000029 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1073 op=1 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=*)(member=uid=alice,ou=people,o=test))" <167>Dec 18 21:07:46 slapd[1674288]: conn=1073 op=1 ENTRY dn="cn=staff_gon,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1073 op=1 ENTRY dn="cn=active_gon,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1073 op=1 ENTRY dn="cn=nested_gon,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1073 op=1 ENTRY dn="cn=superuser_gon,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1073 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000007 etime=0.000510 nentries=4 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1074 fd=33 ACCEPT from IP=127.0.0.1:57934 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1074 op=0 BIND dn="" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1074 op=0 RESULT tag=97 err=0 qtime=0.000006 etime=0.000028 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1074 op=1 SRCH base="uid=bogus,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 18 21:07:46 slapd[1674288]: conn=1074 op=1 SEARCH RESULT tag=101 err=32 qtime=0.000005 etime=0.000037 nentries=0 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1074 op=2 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1074 fd=33 closed .<167>Dec 18 21:07:46 slapd[1674288]: conn=1075 fd=33 ACCEPT from IP=127.0.0.1:57942 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1075 op=0 BIND dn="uid=bob,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1075 op=0 RESULT tag=97 err=49 qtime=0.000009 etime=0.000047 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1075 op=1 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1075 fd=33 closed .<167>Dec 18 21:07:46 slapd[1674288]: conn=1076 fd=33 ACCEPT from IP=127.0.0.1:57952 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1076 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1076 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1076 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000037 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1076 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1076 op=1 RESULT tag=97 err=0 qtime=0.000008 etime=0.000037 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1076 op=2 SRCH base="uid=alice,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 18 21:07:46 slapd[1674288]: conn=1076 op=2 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1076 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000006 etime=0.000051 nentries=1 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1055 op=4 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1055 fd=12 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1056 op=4 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1056 fd=13 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1057 op=10 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1057 fd=14 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1058 op=6 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1058 fd=15 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1059 op=1 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1060 fd=17 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1061 fd=18 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1062 op=1 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1063 op=1 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1062 fd=20 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1059 fd=16 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1063 fd=21 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1064 op=3 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1065 op=3 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1064 fd=22 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1065 fd=23 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1066 op=2 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1069 op=1 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1069 fd=30 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1068 op=4 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1067 fd=27 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1068 fd=28 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1072 op=1 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1073 op=2 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1072 fd=31 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1076 fd=33 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1073 fd=32 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1077 fd=12 ACCEPT from IP=127.0.0.1:57956 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1077 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1077 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1077 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000040 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1077 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1077 op=1 RESULT tag=97 err=0 qtime=0.000008 etime=0.000039 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1078 fd=13 ACCEPT from IP=127.0.0.1:57958 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1078 op=0 BIND dn="" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1078 op=0 RESULT tag=97 err=0 qtime=0.000008 etime=0.000036 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1078 op=1 SRCH base="uid=alice,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 18 21:07:46 slapd[1674288]: conn=1078 op=1 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1078 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000006 etime=0.000053 nentries=1 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1079 fd=14 ACCEPT from IP=127.0.0.1:57966 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1079 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1079 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000055 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1079 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1079 op=1 RESULT tag=97 err=0 qtime=0.000005 etime=0.000025 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1079 op=2 SRCH base="uid=alice,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 18 21:07:46 slapd[1674288]: conn=1079 op=2 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1079 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000005 etime=0.000050 nentries=1 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1080 fd=15 ACCEPT from IP=127.0.0.1:57976 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1080 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1080 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1080 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000049 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1080 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1080 op=1 BIND dn="" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1080 op=1 RESULT tag=97 err=0 qtime=0.000007 etime=0.000038 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1080 op=2 SRCH base="uid=alice,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 18 21:07:46 slapd[1674288]: conn=1080 op=2 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1080 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000006 etime=0.000069 nentries=1 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1081 fd=16 ACCEPT from IP=127.0.0.1:57978 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1081 op=0 BIND dn="" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1081 op=0 RESULT tag=97 err=0 qtime=0.000007 etime=0.000034 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1081 op=1 SRCH base="uid=alice,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 18 21:07:46 slapd[1674288]: conn=1081 op=1 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1081 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000006 etime=0.000056 nentries=1 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1081 op=2 CMP dn="cn=active_gon,ou=groups,o=test" attr="member" <167>Dec 18 21:07:46 slapd[1674288]: conn=1081 op=2 RESULT tag=111 err=6 qtime=0.000006 etime=0.000040 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1081 op=3 CMP dn="cn=staff_gon,ou=groups,o=test" attr="member" <167>Dec 18 21:07:46 slapd[1674288]: conn=1081 op=3 RESULT tag=111 err=6 qtime=0.000007 etime=0.000044 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1081 op=4 CMP dn="cn=superuser_gon,ou=groups,o=test" attr="member" <167>Dec 18 21:07:46 slapd[1674288]: conn=1081 op=4 RESULT tag=111 err=6 qtime=0.000007 etime=0.000039 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1082 fd=17 ACCEPT from IP=127.0.0.1:57984 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1082 op=0 BIND dn="" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1082 op=0 RESULT tag=97 err=0 qtime=0.000006 etime=0.000036 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1082 op=1 SRCH base="uid=bob,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 18 21:07:46 slapd[1674288]: conn=1082 op=1 ENTRY dn="uid=bob,ou=people,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1082 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000005 etime=0.000054 nentries=1 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1082 op=2 CMP dn="cn=active_gon,ou=groups,o=test" attr="member" <167>Dec 18 21:07:46 slapd[1674288]: conn=1082 op=2 RESULT tag=111 err=5 qtime=0.000006 etime=0.000039 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1082 op=3 CMP dn="cn=staff_gon,ou=groups,o=test" attr="member" <167>Dec 18 21:07:46 slapd[1674288]: conn=1082 op=3 RESULT tag=111 err=5 qtime=0.000007 etime=0.000038 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1082 op=4 CMP dn="cn=superuser_gon,ou=groups,o=test" attr="member" <167>Dec 18 21:07:46 slapd[1674288]: conn=1082 op=4 RESULT tag=111 err=5 qtime=0.000006 etime=0.000039 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1083 fd=18 ACCEPT from IP=127.0.0.1:58000 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1083 op=0 BIND dn="" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1083 op=0 RESULT tag=97 err=0 qtime=0.000004 etime=0.000026 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1083 op=1 SRCH base="uid=alice,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 18 21:07:46 slapd[1674288]: conn=1083 op=1 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1083 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000007 etime=0.000066 nentries=1 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1083 op=2 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=posixGroup)(|(gidNumber=1000)(memberUid=alice)))" <167>Dec 18 21:07:46 slapd[1674288]: conn=1083 op=2 ENTRY dn="cn=staff_px,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1083 op=2 ENTRY dn="cn=active_px,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1083 op=2 ENTRY dn="cn=superuser_px,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1083 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000004 etime=0.000101 nentries=3 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1084 fd=20 ACCEPT from IP=127.0.0.1:58006 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1084 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000031 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1084 op=1 SRCH base="uid=nonposix,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 18 21:07:46 slapd[1674288]: conn=1084 op=1 ENTRY dn="uid=nonposix,ou=people,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1084 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000007 etime=0.000066 nentries=1 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1084 op=2 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(&(objectClass=posixGroup)(memberUid=nonposix))" <167>Dec 18 21:07:46 slapd[1674288]: conn=1084 op=2 ENTRY dn="cn=staff_px,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1084 op=2 ENTRY dn="cn=active_px,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1084 op=2 ENTRY dn="cn=superuser_px,ou=groups,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1084 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000014 etime=0.000122 nentries=3 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1085 fd=21 ACCEPT from IP=127.0.0.1:58014 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1085 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1085 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1085 op=0 RESULT tag=97 err=0 qtime=0.000006 etime=0.000046 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1085 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1085 op=1 RESULT tag=97 err=0 qtime=0.000006 etime=0.000033 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1085 op=2 SRCH base="uid=alice,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 18 21:07:46 slapd[1674288]: conn=1085 op=2 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1085 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000006 etime=0.000055 nentries=1 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1085 op=3 CMP dn="cn=active_px,ou=groups,o=test" attr="memberUid" <167>Dec 18 21:07:46 slapd[1674288]: conn=1085 op=3 RESULT tag=111 err=5 qtime=0.000005 etime=0.000031 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1085 op=4 CMP dn="cn=active_px,ou=groups,o=test" attr="gidNumber" <167>Dec 18 21:07:46 slapd[1674288]: conn=1085 op=4 RESULT tag=111 err=6 qtime=0.000004 etime=0.000028 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1085 op=5 CMP dn="cn=staff_px,ou=groups,o=test" attr="memberUid" <167>Dec 18 21:07:46 slapd[1674288]: conn=1085 op=5 RESULT tag=111 err=6 qtime=0.000005 etime=0.000036 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1085 op=6 CMP dn="cn=superuser_px,ou=groups,o=test" attr="memberUid" <167>Dec 18 21:07:46 slapd[1674288]: conn=1085 op=6 RESULT tag=111 err=6 qtime=0.000007 etime=0.000044 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1086 fd=22 ACCEPT from IP=127.0.0.1:58018 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1086 op=0 BIND dn="uid=bob,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1086 op=0 BIND dn="uid=bob,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1086 op=0 RESULT tag=97 err=0 qtime=0.000006 etime=0.000049 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1086 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1086 op=1 RESULT tag=97 err=0 qtime=0.000006 etime=0.000034 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1086 op=2 SRCH base="uid=bob,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 18 21:07:46 slapd[1674288]: conn=1086 op=2 ENTRY dn="uid=bob,ou=people,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1086 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000005 etime=0.000049 nentries=1 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1086 op=3 CMP dn="cn=active_px,ou=groups,o=test" attr="memberUid" <167>Dec 18 21:07:46 slapd[1674288]: conn=1086 op=3 RESULT tag=111 err=5 qtime=0.000006 etime=0.000040 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1086 op=4 CMP dn="cn=active_px,ou=groups,o=test" attr="gidNumber" <167>Dec 18 21:07:46 slapd[1674288]: conn=1086 op=4 RESULT tag=111 err=5 qtime=0.000004 etime=0.000028 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1086 op=5 CMP dn="cn=staff_px,ou=groups,o=test" attr="memberUid" <167>Dec 18 21:07:46 slapd[1674288]: conn=1086 op=5 RESULT tag=111 err=5 qtime=0.000006 etime=0.000038 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1086 op=6 CMP dn="cn=staff_px,ou=groups,o=test" attr="gidNumber" <167>Dec 18 21:07:46 slapd[1674288]: conn=1086 op=6 RESULT tag=111 err=5 qtime=0.000006 etime=0.000032 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1086 op=7 CMP dn="cn=superuser_px,ou=groups,o=test" attr="memberUid" <167>Dec 18 21:07:46 slapd[1674288]: conn=1086 op=7 RESULT tag=111 err=5 qtime=0.000004 etime=0.000030 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1086 op=8 CMP dn="cn=superuser_px,ou=groups,o=test" attr="gidNumber" <167>Dec 18 21:07:46 slapd[1674288]: conn=1086 op=8 RESULT tag=111 err=5 qtime=0.000007 etime=0.000052 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1087 fd=23 ACCEPT from IP=127.0.0.1:58030 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1087 op=0 BIND dn="uid=nobody,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1087 op=0 BIND dn="uid=nobody,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1087 op=0 RESULT tag=97 err=0 qtime=0.000007 etime=0.000044 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1087 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1087 op=1 BIND dn="" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1087 op=1 RESULT tag=97 err=0 qtime=0.000007 etime=0.000037 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1087 op=2 SRCH base="uid=nobody,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 18 21:07:46 slapd[1674288]: conn=1087 op=2 ENTRY dn="uid=nobody,ou=people,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1087 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000007 etime=0.000059 nentries=1 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1087 op=3 CMP dn="cn=active_px,ou=groups,o=test" attr="memberUid" <167>Dec 18 21:07:46 slapd[1674288]: conn=1087 op=3 RESULT tag=111 err=5 qtime=0.000005 etime=0.000039 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1087 op=4 CMP dn="cn=active_px,ou=groups,o=test" attr="gidNumber" <167>Dec 18 21:07:46 slapd[1674288]: conn=1087 op=4 RESULT tag=111 err=5 qtime=0.000005 etime=0.000030 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1088 fd=24 ACCEPT from IP=127.0.0.1:58034 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1088 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1088 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1088 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000049 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1088 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1088 op=1 BIND dn="" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1088 op=1 RESULT tag=97 err=0 qtime=0.000007 etime=0.000049 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1088 op=2 CMP dn="cn=active_gon,ou=groups,o=test" attr="member" <167>Dec 18 21:07:46 slapd[1674288]: conn=1088 op=2 RESULT tag=111 err=6 qtime=0.000007 etime=0.000042 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1089 fd=27 ACCEPT from IP=127.0.0.1:58048 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1089 op=0 BIND dn="uid=bob,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1089 op=0 BIND dn="uid=bob,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1089 op=0 RESULT tag=97 err=0 qtime=0.000006 etime=0.000052 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1089 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1089 op=1 RESULT tag=97 err=0 qtime=0.000007 etime=0.000034 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1089 op=2 CMP dn="cn=active_gon,ou=groups,o=test" attr="member" <167>Dec 18 21:07:46 slapd[1674288]: conn=1089 op=2 RESULT tag=111 err=5 qtime=0.000007 etime=0.000042 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1090 fd=28 ACCEPT from IP=127.0.0.1:58056 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1090 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1090 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1090 op=0 RESULT tag=97 err=0 qtime=0.000006 etime=0.000041 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1090 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1090 op=1 RESULT tag=97 err=0 qtime=0.000006 etime=0.000035 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1090 op=2 CMP dn="cn=alice_gon,ou=query_groups,o=test" attr="member" <167>Dec 18 21:07:46 slapd[1674288]: conn=1090 op=2 RESULT tag=111 err=6 qtime=0.000006 etime=0.000039 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1090 op=3 CMP dn="cn=mutual_gon,ou=query_groups,o=test" attr="member" <167>Dec 18 21:07:46 slapd[1674288]: conn=1090 op=3 RESULT tag=111 err=6 qtime=0.000005 etime=0.000037 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1091 fd=30 ACCEPT from IP=127.0.0.1:58060 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1091 op=0 BIND dn="uid=bob,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1091 op=0 BIND dn="uid=bob,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1091 op=0 RESULT tag=97 err=0 qtime=0.000006 etime=0.000056 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1091 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1091 op=2 CMP dn="cn=alice_gon,ou=query_groups,o=test" attr="member" <167>Dec 18 21:07:46 slapd[1674288]: conn=1091 op=2 RESULT tag=111 err=5 qtime=0.000005 etime=0.000032 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1092 fd=31 ACCEPT from IP=127.0.0.1:58064 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1092 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1092 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1092 op=0 RESULT tag=97 err=0 qtime=0.000006 etime=0.000048 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1092 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1092 op=1 RESULT tag=97 err=0 qtime=0.000005 etime=0.000023 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1092 op=2 CMP dn="cn=nonexistent,ou=groups,o=test" attr="member" <167>Dec 18 21:07:46 slapd[1674288]: conn=1092 op=2 RESULT tag=111 err=32 qtime=0.000004 etime=0.000026 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1092 op=3 CMP dn="cn=active_gon,ou=groups,o=test" attr="member" <167>Dec 18 21:07:46 slapd[1674288]: conn=1092 op=3 RESULT tag=111 err=6 qtime=0.000003 etime=0.000026 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1093 fd=32 ACCEPT from IP=127.0.0.1:58068 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1093 op=0 BIND dn="uid=bob,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1093 op=0 RESULT tag=97 err=0 qtime=0.000006 etime=0.000044 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1093 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1093 op=1 RESULT tag=97 err=0 qtime=0.000005 etime=0.000033 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1093 op=2 CMP dn="cn=nonexistent,ou=groups,o=test" attr="member" <167>Dec 18 21:07:46 slapd[1674288]: conn=1093 op=2 RESULT tag=111 err=32 qtime=0.000007 etime=0.000050 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1093 op=3 CMP dn="cn=active_gon,ou=groups,o=test" attr="member" <167>Dec 18 21:07:46 slapd[1674288]: conn=1093 op=3 RESULT tag=111 err=5 qtime=0.000006 etime=0.000039 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1078 op=2 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1078 fd=13 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1079 fd=14 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1081 op=5 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1084 op=3 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1080 fd=15 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1082 op=5 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1082 fd=17 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1083 op=3 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1081 fd=16 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1086 op=9 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1085 op=7 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1084 fd=20 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1086 fd=22 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1083 fd=18 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1085 fd=21 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1088 op=3 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1089 op=3 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1087 fd=23 closed .<167>Dec 18 21:07:46 slapd[1674288]: conn=1091 op=3 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1088 fd=24 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1091 fd=30 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1089 fd=27 closed <167>Dec 18 21:07:46 slapd[1674288]: conn=1092 op=4 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1094 fd=13 ACCEPT from IP=127.0.0.1:58082 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1094 op=0 RESULT tag=97 err=0 qtime=0.000004 etime=0.000026 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1094 op=1 SRCH base="ou=people,o=test" scope=2 deref=0 filter="(uid=alice)" <167>Dec 18 21:07:46 slapd[1674288]: conn=1094 op=1 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1094 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000005 etime=0.000061 nentries=1 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1094 op=2 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1094 op=2 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1094 op=2 RESULT tag=97 err=0 qtime=0.000006 etime=0.000048 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1095 fd=14 ACCEPT from IP=127.0.0.1:58090 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1095 op=0 BIND dn="" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1095 op=0 RESULT tag=97 err=0 qtime=0.000009 etime=0.000036 text= <167>Dec 18 21:07:46 slapd[1674288]: connection_input: conn=1095 deferring operation: binding <167>Dec 18 21:07:46 slapd[1674288]: conn=1095 op=1 SRCH base="ou=people,o=test" scope=2 deref=0 filter="(uid=alice)" <167>Dec 18 21:07:46 slapd[1674288]: conn=1095 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000048 etime=0.000115 nentries=1 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1095 op=2 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1095 op=2 RESULT tag=97 err=49 qtime=0.000006 etime=0.000037 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1095 op=3 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1095 fd=14 closed .<167>Dec 18 21:07:46 slapd[1674288]: conn=1096 fd=14 ACCEPT from IP=127.0.0.1:58100 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1096 op=0 BIND dn="" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1096 op=0 RESULT tag=97 err=0 qtime=0.000004 etime=0.000022 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1096 op=1 SRCH base="ou=people,o=test" scope=2 deref=0 filter="(uid=alice\2A)" <167>Dec 18 21:07:46 slapd[1674288]: conn=1096 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000003 etime=0.000030 nentries=0 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1096 op=2 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1096 fd=14 closed .<167>Dec 18 21:07:46 slapd[1674288]: conn=1097 fd=14 ACCEPT from IP=127.0.0.1:58106 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1097 op=0 BIND dn="" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1097 op=0 RESULT tag=97 err=0 qtime=0.000004 etime=0.000020 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1097 op=1 SRCH base="ou=people,o=test" scope=2 deref=0 filter="(uid=*)" <167>Dec 18 21:07:46 slapd[1674288]: conn=1097 op=1 ENTRY dn="uid=bob,ou=people,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1097 op=1 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1097 op=1 ENTRY dn="uid=nobody,ou=people,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1097 op=1 ENTRY dn="uid=dreßler,ou=people,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1097 op=1 ENTRY dn="uid=nonposix,ou=people,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1097 op=1 ENTRY dn="cn=charlie_cooper,ou=people,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1097 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000004 etime=0.000105 nentries=6 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1097 op=2 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1097 fd=14 closed .<167>Dec 18 21:07:46 slapd[1674288]: conn=1098 fd=14 ACCEPT from IP=127.0.0.1:58112 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1098 op=0 BIND dn="" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1098 op=0 RESULT tag=97 err=0 qtime=0.000008 etime=0.000036 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1098 op=1 SRCH base="ou=people,o=test" scope=2 deref=0 filter="(?uidNumber=alice)" <167>Dec 18 21:07:46 slapd[1674288]: conn=1098 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000005 etime=0.000050 nentries=0 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1098 op=2 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1098 fd=14 closed .<167>Dec 18 21:07:46 slapd[1674288]: conn=1099 fd=14 ACCEPT from IP=127.0.0.1:58116 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1099 op=0 BIND dn="uid=bob,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1099 op=0 RESULT tag=97 err=49 qtime=0.000005 etime=0.000030 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1099 op=1 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1099 fd=14 closed .<167>Dec 18 21:07:46 slapd[1674288]: conn=1100 fd=14 ACCEPT from IP=127.0.0.1:58118 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1100 op=0 BIND dn="uid=bob,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1100 op=0 BIND dn="uid=bob,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1100 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000045 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1100 op=1 SRCH base="ou=people,o=test" scope=2 deref=0 filter="(uid=alice)" <167>Dec 18 21:07:46 slapd[1674288]: conn=1100 op=1 ENTRY dn="uid=alice,ou=people,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1100 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000005 etime=0.000072 nentries=1 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1100 op=2 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1100 op=2 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1100 op=2 RESULT tag=97 err=0 qtime=0.000005 etime=0.000040 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1101 fd=15 ACCEPT from IP=127.0.0.1:58132 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1101 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1101 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1101 op=0 RESULT tag=97 err=0 qtime=0.000006 etime=0.000059 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1102 fd=16 ACCEPT from IP=127.0.0.1:58136 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1102 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1102 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1102 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000146 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1103 fd=17 ACCEPT from IP=127.0.0.1:58144 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1103 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1103 op=0 RESULT tag=97 err=49 qtime=0.000006 etime=0.000042 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1103 op=1 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1103 fd=17 closed .<167>Dec 18 21:07:46 slapd[1674288]: conn=1104 fd=17 ACCEPT from IP=127.0.0.1:58154 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1104 op=0 BIND dn="uid=evil_alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1104 op=0 RESULT tag=97 err=49 qtime=0.000004 etime=0.000041 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1105 fd=18 ACCEPT from IP=127.0.0.1:58170 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1105 op=0 BIND dn="uid=alice\2C1,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1105 op=0 RESULT tag=97 err=49 qtime=0.000005 etime=0.000032 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1105 op=1 UNBIND <167>Dec 18 21:07:46 slapd[1674288]: conn=1105 fd=18 closed .<167>Dec 18 21:07:46 slapd[1674288]: conn=1106 fd=18 ACCEPT from IP=127.0.0.1:58186 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1106 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1106 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1106 op=0 RESULT tag=97 err=0 qtime=0.000004 etime=0.000033 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1106 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1106 op=1 RESULT tag=97 err=0 qtime=0.000006 etime=0.000035 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1106 op=2 CMP dn="cn=alice_gon,ou=query_groups,o=test" attr="member" <167>Dec 18 21:07:46 slapd[1674288]: conn=1106 op=2 RESULT tag=111 err=6 qtime=0.000005 etime=0.000041 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1107 fd=20 ACCEPT from IP=127.0.0.1:58196 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1107 op=0 EXT oid=1.3.6.1.4.1.1466.20037 <167>Dec 18 21:07:46 slapd[1674288]: conn=1107 op=0 STARTTLS <167>Dec 18 21:07:46 slapd[1674288]: conn=1107 op=0 RESULT oid= err=0 qtime=0.000006 etime=0.000036 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1107 fd=20 closed (TLS negotiation failure) .<167>Dec 18 21:07:46 slapd[1674288]: conn=1108 fd=20 ACCEPT from IP=127.0.0.1:58202 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1108 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1108 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1108 op=0 RESULT tag=97 err=0 qtime=0.000006 etime=0.000050 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1109 fd=21 ACCEPT from IP=127.0.0.1:58204 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1109 op=0 BIND dn="uid=dreßler,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1109 op=0 BIND dn="uid=dreßler,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1109 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000148 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1109 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1109 op=1 RESULT tag=97 err=0 qtime=0.000007 etime=0.000029 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1109 op=2 SRCH base="uid=dreßler,ou=people,o=test" scope=0 deref=0 filter="(objectClass=*)" <167>Dec 18 21:07:46 slapd[1674288]: conn=1109 op=2 ENTRY dn="uid=dreßler,ou=people,o=test" <167>Dec 18 21:07:46 slapd[1674288]: conn=1109 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000009 etime=0.000071 nentries=1 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1110 fd=22 ACCEPT from IP=127.0.0.1:58218 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1110 op=0 BIND dn="" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1110 op=2 SRCH base="ou=people,o=test" scope=2 deref=0 filter="(uid=alice)" <167>Dec 18 21:07:46 slapd[1674288]: conn=1110 op=1 SRCH base="ou=groups,o=test" scope=2 deref=0 filter="(uid=alice)" <167>Dec 18 21:07:46 slapd[1674288]: conn=1110 op=1 SEARCH RESULT tag=101 err=0 qtime=0.000045 etime=0.000139 nentries=0 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1110 op=2 SEARCH RESULT tag=101 err=0 qtime=0.000021 etime=0.000126 nentries=1 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1110 op=3 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1110 op=3 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1110 op=3 RESULT tag=97 err=0 qtime=0.000006 etime=0.000032 text= .<167>Dec 18 21:07:46 slapd[1674288]: conn=1111 fd=23 ACCEPT from IP=127.0.0.1:58228 (IP=127.0.0.1:37905) <167>Dec 18 21:07:46 slapd[1674288]: conn=1111 op=0 BIND dn="uid=alice,ou=people,o=test" method=128 <167>Dec 18 21:07:46 slapd[1674288]: conn=1111 op=0 BIND dn="uid=alice,ou=people,o=test" mech=SIMPLE bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1111 op=0 RESULT tag=97 err=0 qtime=0.000005 etime=0.000166 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1111 op=1 BIND anonymous mech=implicit bind_ssf=0 ssf=0 <167>Dec 18 21:07:46 slapd[1674288]: conn=1111 op=1 RESULT tag=97 err=0 qtime=0.000006 etime=0.000032 text= <167>Dec 18 21:07:46 slapd[1674288]: conn=1111 op=2 CMP dn="cn=active_gon,ou=groups,o=test" attr="member" <167>Dec 18 21:07:46 slapd[1674288]: conn=1111 op=2 RESULT tag=111 err=6 qtime=0.000009 etime=0.000052 text= ..<167>Dec 18 21:07:46 slapd[1674288]: daemon: shutdown requested and initiated. <167>Dec 18 21:07:46 slapd[1674288]: conn=1077 fd=12 closed (slapd shutdown) <167>Dec 18 21:07:46 slapd[1674288]: conn=1094 fd=13 closed (slapd shutdown) <167>Dec 18 21:07:46 slapd[1674288]: conn=1100 fd=14 closed (slapd shutdown) <167>Dec 18 21:07:46 slapd[1674288]: conn=1101 fd=15 closed (slapd shutdown) <167>Dec 18 21:07:46 slapd[1674288]: conn=1102 fd=16 closed (slapd shutdown) <167>Dec 18 21:07:46 slapd[1674288]: conn=1104 fd=17 closed (slapd shutdown) <167>Dec 18 21:07:46 slapd[1674288]: conn=1106 fd=18 closed (slapd shutdown) <167>Dec 18 21:07:46 slapd[1674288]: conn=1012 fd=19 closed (slapd shutdown) <167>Dec 18 21:07:46 slapd[1674288]: conn=1108 fd=20 closed (slapd shutdown) <167>Dec 18 21:07:46 slapd[1674288]: conn=1109 fd=21 closed (slapd shutdown) <167>Dec 18 21:07:46 slapd[1674288]: conn=1110 fd=22 closed (slapd shutdown) <167>Dec 18 21:07:46 slapd[1674288]: conn=1111 fd=23 closed (slapd shutdown) <167>Dec 18 21:07:46 slapd[1674288]: conn=1039 fd=25 closed (slapd shutdown) <167>Dec 18 21:07:46 slapd[1674288]: conn=1026 fd=26 closed (slapd shutdown) <167>Dec 18 21:07:46 slapd[1674288]: conn=1054 fd=29 closed (slapd shutdown) <167>Dec 18 21:07:46 slapd[1674288]: slapd shutdown: waiting for 0 operations/tasks to finish <167>Dec 18 21:07:46 slapd[1674288]: slapd stopped. ---------------------------------------------------------------------- Ran 91 tests in 0.746s OK Destroying test database for alias 'default'... + exit 0 Processing files: python3-module-django-auth-ldap-4.8.0-alt1 Executing(%doc): /bin/sh -e /usr/src/tmp/rpm-tmp.73887 + umask 022 + /bin/mkdir -p /usr/src/RPM/BUILD + cd /usr/src/RPM/BUILD + cd python3-module-django-auth-ldap-4.8.0 + DOCDIR=/usr/src/tmp/python3-module-django-auth-ldap-buildroot/usr/share/doc/python3-module-django-auth-ldap-4.8.0 + export DOCDIR + rm -rf /usr/src/tmp/python3-module-django-auth-ldap-buildroot/usr/share/doc/python3-module-django-auth-ldap-4.8.0 + /bin/mkdir -p /usr/src/tmp/python3-module-django-auth-ldap-buildroot/usr/share/doc/python3-module-django-auth-ldap-4.8.0 + cp -prL README.rst LICENSE /usr/src/tmp/python3-module-django-auth-ldap-buildroot/usr/share/doc/python3-module-django-auth-ldap-4.8.0 + chmod -R go-w /usr/src/tmp/python3-module-django-auth-ldap-buildroot/usr/share/doc/python3-module-django-auth-ldap-4.8.0 + chmod -R a+rX /usr/src/tmp/python3-module-django-auth-ldap-buildroot/usr/share/doc/python3-module-django-auth-ldap-4.8.0 + exit 0 Finding Provides (using /usr/lib/rpm/find-provides) Executing: /bin/sh -e /usr/src/tmp/rpm-tmp.ik2Yrl 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.Y0SkU7 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.8.0-alt1.noarch.rpm (w2.lzdio) 1.80user 0.87system 0:04.49elapsed 59%CPU (0avgtext+0avgdata 57344maxresident)k 0inputs+0outputs (0major+160797minor)pagefaults 0swaps 5.03user 3.73system 0:24.12elapsed 36%CPU (0avgtext+0avgdata 135612maxresident)k 5656inputs+0outputs (0major+400175minor)pagefaults 0swaps --- python3-module-django-auth-ldap-4.8.0-alt1.noarch.rpm.repo 2024-04-10 14:01:36.000000000 +0000 +++ python3-module-django-auth-ldap-4.8.0-alt1.noarch.rpm.hasher 2024-12-19 03:07:50.587428566 +0000 @@ -43,14 +43,14 @@ 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 1f37b0840bdc275048f9ee0ad08c6b85 +File: /usr/lib/python3/site-packages/django_auth_ldap-0.0.0.dist-info/METADATA 100644 root:root 36d50f97592ce94bb743c90a0ea71620 File: /usr/lib/python3/site-packages/django_auth_ldap/__init__.py 100644 root:root f7e7d62b62be53ff121cea79fd33fc66 File: /usr/lib/python3/site-packages/django_auth_ldap/__pycache__ 40755 root:root -File: /usr/lib/python3/site-packages/django_auth_ldap/__pycache__/__init__.cpython-312.opt-1.pyc 100644 root:root 722fbd145e27a397eeffbb02a6becab0 -File: /usr/lib/python3/site-packages/django_auth_ldap/__pycache__/__init__.cpython-312.opt-2.pyc 100644 root:root 722fbd145e27a397eeffbb02a6becab0 -File: /usr/lib/python3/site-packages/django_auth_ldap/__pycache__/__init__.cpython-312.pyc 100644 root:root 722fbd145e27a397eeffbb02a6becab0 -File: /usr/lib/python3/site-packages/django_auth_ldap/__pycache__/backend.cpython-312.opt-1.pyc 100644 root:root 48a59c45e1e9069b213fcbe7cd3df278 -File: /usr/lib/python3/site-packages/django_auth_ldap/__pycache__/backend.cpython-312.opt-2.pyc 100644 root:root d58ea9c08b58820daf401b3cdf1bf933 -File: /usr/lib/python3/site-packages/django_auth_ldap/__pycache__/backend.cpython-312.pyc 100644 root:root 48a59c45e1e9069b213fcbe7cd3df278 -File: /usr/lib/python3/site-packages/django_auth_ldap/__pycache__/config.cpython-312.opt-1.pyc 100644 root:root 2c4a7c045a96c15a0aa1a33a61390d43 -File: /usr/lib/python3/site-packages/django_auth_ldap/__pycache__/config.cpython-312.opt-2.pyc 100644 root:root 83dd4702aac4ab64d75e27abe68eae08 -File: /usr/lib/python3/site-packages/django_auth_ldap/__pycache__/config.cpython-312.pyc 100644 root:root 2c4a7c045a96c15a0aa1a33a61390d43 +File: /usr/lib/python3/site-packages/django_auth_ldap/__pycache__/__init__.cpython-312.opt-1.pyc 100644 root:root 1e6c0e1a9551a221c10e6fdacd597b17 +File: /usr/lib/python3/site-packages/django_auth_ldap/__pycache__/__init__.cpython-312.opt-2.pyc 100644 root:root 1e6c0e1a9551a221c10e6fdacd597b17 +File: /usr/lib/python3/site-packages/django_auth_ldap/__pycache__/__init__.cpython-312.pyc 100644 root:root 1e6c0e1a9551a221c10e6fdacd597b17 +File: /usr/lib/python3/site-packages/django_auth_ldap/__pycache__/backend.cpython-312.opt-1.pyc 100644 root:root 502a2750f678792aecec71d683fe2e81 +File: /usr/lib/python3/site-packages/django_auth_ldap/__pycache__/backend.cpython-312.opt-2.pyc 100644 root:root c457fdfd72982f9218410d550efbb458 +File: /usr/lib/python3/site-packages/django_auth_ldap/__pycache__/backend.cpython-312.pyc 100644 root:root 502a2750f678792aecec71d683fe2e81 +File: /usr/lib/python3/site-packages/django_auth_ldap/__pycache__/config.cpython-312.opt-1.pyc 100644 root:root 20c4b17a8cf6505a5027b51c3c0bfe4b +File: /usr/lib/python3/site-packages/django_auth_ldap/__pycache__/config.cpython-312.opt-2.pyc 100644 root:root 51c98f58fdd26ede05228fa22cf66583 +File: /usr/lib/python3/site-packages/django_auth_ldap/__pycache__/config.cpython-312.pyc 100644 root:root 20c4b17a8cf6505a5027b51c3c0bfe4b File: /usr/lib/python3/site-packages/django_auth_ldap/backend.py 100644 root:root cd9a631f725c5853f3ba09c80030faf5 @@ -60,2 +60,2 @@ File: /usr/share/doc/python3-module-django-auth-ldap-4.8.0/README.rst 100644 root:root 17bb22d4f45f731c31ca95ae6c5fcc81 -RPMIdentity: 08f96d623189c117d810e385d2f8ccc1dd9ca87845f1c21a38e8610c706b8845a36cb0fcb84d0bb7059ba48a03d6f555a54cbff2cbeeb25ff7d12d1847aaed25 +RPMIdentity: f82eb9dc3cf98524d51032fb43245d7dc1a55015f20db620f5a11ca59bee39a5a2f7b1ec60b15a32cb002e345d0283d1de68d4ecc39f65104144bd791627afd5