Attachment 931912 Details for Bug 1134882 – build.log

build.log

build.log (text/plain), 89.88 KB, created by Petr Pisar on 2014-08-28 12:02:44 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Petr Pisar

Created: 2014-08-28 12:02:44 UTC

Size: 89.88 KB

patch

obsolete

>Mock Version: 1.1.41
>ENTER do(['bash', '--login', '-c', 'rpmbuild -bs --target x86_64 --nodeps builddir/build/SPECS/perl-MongoDB.spec'], False, '/var/lib/mock/fedorarebuild-x86_64-_W4PVjgQs_/root/', None, 0, True, False, 11527, 997, None, False, {'LANG': 'cs_CZ.UTF-8', 'TERM': 'vt100', 'SHELL': '/bin/bash', 'CCACHE_DIR': '/tmp/ccache', 'HOSTNAME': 'mock', 'PROMPT_COMMAND': 'echo -n "<mock-chroot>"', 'HOME': '/builddir', 'PATH': '/usr/bin:/bin:/usr/sbin:/sbin', 'CCACHE_UMASK': '002'}, logger=<mockbuild.trace_decorator.getLog object at 0x1648790>)
>Executing command: ['bash', '--login', '-c', 'rpmbuild -bs --target x86_64 --nodeps builddir/build/SPECS/perl-MongoDB.spec'] with env {'LANG': 'cs_CZ.UTF-8', 'TERM': 'vt100', 'SHELL': '/bin/bash', 'CCACHE_DIR': '/tmp/ccache', 'HOSTNAME': 'mock', 'PROMPT_COMMAND': 'echo -n "<mock-chroot>"', 'HOME': '/builddir', 'PATH': '/usr/bin:/bin:/usr/sbin:/sbin', 'CCACHE_UMASK': '002'}
>varovÃ¡nÃ: Nemohu zÃskat jmÃ©no poÄÃtaÄe: island
>Sestavuji cÃlovÃ© platformy: x86_64
>Sestavuji pro cÃl x86_64
>ZapsÃ¡no: /builddir/build/SRPMS/perl-MongoDB-0.702.2-5.fc22.src.rpm
>Child return code was: 0
>LEAVE do --> 
>
>ENTER do(['bash', '--login', '-c', 'rpmbuild -bb --target x86_64 --nodeps  builddir/build/SPECS/perl-MongoDB.spec'], False, '/var/lib/mock/fedorarebuild-x86_64-_W4PVjgQs_/root/', None, 0, True, False, 11527, 997, None, False, {'LANG': 'cs_CZ.UTF-8', 'TERM': 'vt100', 'SHELL': '/bin/bash', 'CCACHE_DIR': '/tmp/ccache', 'HOSTNAME': 'mock', 'PROMPT_COMMAND': 'echo -n "<mock-chroot>"', 'HOME': '/builddir', 'PATH': '/usr/bin:/bin:/usr/sbin:/sbin', 'CCACHE_UMASK': '002'}, logger=<mockbuild.trace_decorator.getLog object at 0x1648790>)
>Executing command: ['bash', '--login', '-c', 'rpmbuild -bb --target x86_64 --nodeps  builddir/build/SPECS/perl-MongoDB.spec'] with env {'LANG': 'cs_CZ.UTF-8', 'TERM': 'vt100', 'SHELL': '/bin/bash', 'CCACHE_DIR': '/tmp/ccache', 'HOSTNAME': 'mock', 'PROMPT_COMMAND': 'echo -n "<mock-chroot>"', 'HOME': '/builddir', 'PATH': '/usr/bin:/bin:/usr/sbin:/sbin', 'CCACHE_UMASK': '002'}
>Sestavuji cÃlovÃ© platformy: x86_64
>Sestavuji pro cÃl x86_64
>ProvÃ¡dÄnÃ(%prep): /bin/sh -e /var/tmp/rpm-tmp.9YUNgy
>+ umask 022
>+ cd /builddir/build/BUILD
>+ cd /builddir/build/BUILD
>+ rm -rf MongoDB-0.702.2
>+ /usr/bin/gzip -dc /builddir/build/SOURCES/MongoDB-0.702.2.tar.gz
>+ /usr/bin/tar -xf -
>+ STATUS=0
>+ '[' 0 -ne 0 ']'
>+ cd MongoDB-0.702.2
>+ /usr/bin/chmod -Rf a+rX,u+w,g-w,o-w .
>+ echo 'Patch #0 (0001-disable-JS-err-report-test-for-now.patch):'
>Patch #0 (0001-disable-JS-err-report-test-for-now.patch):
>+ /usr/bin/cat /builddir/build/SOURCES/0001-disable-JS-err-report-test-for-now.patch
>+ /usr/bin/patch -p1 --fuzz=0
>patching file t/db.t
>+ exit 0
>ProvÃ¡dÄnÃ(%build): /bin/sh -e /var/tmp/rpm-tmp.X62NWK
>+ umask 022
>+ cd /builddir/build/BUILD
>+ cd MongoDB-0.702.2
>+ /usr/bin/perl Makefile.PL --ssl --sasl INSTALLDIRS=vendor 'OPTIMIZE=-O2 -g -pipe -Wall -Werror=format-security -Wp,-D_FORTIFY_SOURCE=2 -fexceptions -fstack-protector-strong --param=ssp-buffer-size=4 -grecord-gcc-switches  -m64 -mtune=generic'
>Checking if your kit is complete...
>Looks good
>Generating a Unix-style Makefile
>Writing Makefile for MongoDB
>Writing MYMETA.yml and MYMETA.json
>+ make -j4
>Running Mkbootstrap for MongoDB ()
>/usr/bin/perl "-Iinc" /usr/share/perl5/vendor_perl/ExtUtils/xsubpp  -typemap /usr/share/perl5/ExtUtils/typemap  xs/BSON.xs > xs/BSON.xsc && mv xs/BSON.xsc xs/BSON.c
>/usr/bin/perl "-Iinc" /usr/share/perl5/vendor_perl/ExtUtils/xsubpp  -typemap /usr/share/perl5/ExtUtils/typemap  xs/Cursor.xs > xs/Cursor.xsc && mv xs/Cursor.xsc xs/Cursor.c
>chmod 644 MongoDB.bs
>/usr/bin/perl "-Iinc" /usr/share/perl5/vendor_perl/ExtUtils/xsubpp  -typemap /usr/share/perl5/ExtUtils/typemap  xs/Mongo.xs > xs/Mongo.xsc && mv xs/Mongo.xsc xs/Mongo.c
>cp lib/MongoDB/GridFS.pm blib/lib/MongoDB/GridFS.pm
>cp lib/MongoDB/Examples.pod blib/lib/MongoDB/Examples.pod
>cp lib/MongoDB/Indexing.pod blib/lib/MongoDB/Indexing.pod
>cp lib/MongoDB/Cursor.pm blib/lib/MongoDB/Cursor.pm
>cp lib/MongoDB/BSON/Binary.pm blib/lib/MongoDB/BSON/Binary.pm
>cp lib/MongoDB/Code.pm blib/lib/MongoDB/Code.pm
>cp lib/MongoDB/Collection.pm blib/lib/MongoDB/Collection.pm
>cp lib/MongoDB/DataTypes.pod blib/lib/MongoDB/DataTypes.pod
>cp lib/MongoDB/BSON.pm blib/lib/MongoDB/BSON.pm
>cp lib/MongoDB/MongoClient.pm blib/lib/MongoDB/MongoClient.pm
>cp lib/MongoDB/Database.pm blib/lib/MongoDB/Database.pm
>cp lib/MongoDB.pm blib/lib/MongoDB.pm
>cp lib/MongoDB/DBRef.pm blib/lib/MongoDB/DBRef.pm
>cp lib/MongoDB/Timestamp.pm blib/lib/MongoDB/Timestamp.pm
>cp lib/MongoDB/Connection.pm blib/lib/MongoDB/Connection.pm
>cp lib/MongoDB/OID.pm blib/lib/MongoDB/OID.pm
>cp lib/MongoDB/Tutorial.pod blib/lib/MongoDB/Tutorial.pod
>cp lib/MongoDB/GridFS/File.pm blib/lib/MongoDB/GridFS/File.pm
>/usr/bin/perl "-Iinc" /usr/share/perl5/vendor_perl/ExtUtils/xsubpp  -typemap /usr/share/perl5/ExtUtils/typemap  xs/MongoClient.xs > xs/MongoClient.xsc && mv xs/MongoClient.xsc xs/MongoClient.c
>/usr/bin/perl "-Iinc" /usr/share/perl5/vendor_perl/ExtUtils/xsubpp  -typemap /usr/share/perl5/ExtUtils/typemap  xs/OID.xs > xs/OID.xsc && mv xs/OID.xsc xs/OID.c
>gcc -c  -I.  -D_REENTRANT -D_GNU_SOURCE -fwrapv -fno-strict-aliasing -pipe -fstack-protector -I/usr/local/include -D_LARGEFILE_SOURCE -D_FILE_OFFSET_BITS=64 -O2 -g -pipe -Wall -Werror=format-security -Wp,-D_FORTIFY_SOURCE=2 -fexceptions -fstack-protector-strong --param=ssp-buffer-size=4 -grecord-gcc-switches  -m64 -mtune=generic   -DVERSION=\"0.702.2\" -DXS_VERSION=\"0.702.2\" -o mongo_link.o -DUSE_64_BIT_INT -fPIC "-I/usr/lib64/perl5/CORE"   mongo_link.c
>gcc -c  -I.  -D_REENTRANT -D_GNU_SOURCE -fwrapv -fno-strict-aliasing -pipe -fstack-protector -I/usr/local/include -D_LARGEFILE_SOURCE -D_FILE_OFFSET_BITS=64 -O2 -g -pipe -Wall -Werror=format-security -Wp,-D_FORTIFY_SOURCE=2 -fexceptions -fstack-protector-strong --param=ssp-buffer-size=4 -grecord-gcc-switches  -m64 -mtune=generic   -DVERSION=\"0.702.2\" -DXS_VERSION=\"0.702.2\" -o perl_mongo.o -DUSE_64_BIT_INT -fPIC "-I/usr/lib64/perl5/CORE"   perl_mongo.c
>gcc -c  -I.  -D_REENTRANT -D_GNU_SOURCE -fwrapv -fno-strict-aliasing -pipe -fstack-protector -I/usr/local/include -D_LARGEFILE_SOURCE -D_FILE_OFFSET_BITS=64 -O2 -g -pipe -Wall -Werror=format-security -Wp,-D_FORTIFY_SOURCE=2 -fexceptions -fstack-protector-strong --param=ssp-buffer-size=4 -grecord-gcc-switches  -m64 -mtune=generic   -DVERSION=\"0.702.2\" -DXS_VERSION=\"0.702.2\" -o xs/BSON.o -DUSE_64_BIT_INT -fPIC "-I/usr/lib64/perl5/CORE"   xs/BSON.c
>gcc -c  -I.  -D_REENTRANT -D_GNU_SOURCE -fwrapv -fno-strict-aliasing -pipe -fstack-protector -I/usr/local/include -D_LARGEFILE_SOURCE -D_FILE_OFFSET_BITS=64 -O2 -g -pipe -Wall -Werror=format-security -Wp,-D_FORTIFY_SOURCE=2 -fexceptions -fstack-protector-strong --param=ssp-buffer-size=4 -grecord-gcc-switches  -m64 -mtune=generic   -DVERSION=\"0.702.2\" -DXS_VERSION=\"0.702.2\" -o xs/Cursor.o -DUSE_64_BIT_INT -fPIC "-I/usr/lib64/perl5/CORE"   xs/Cursor.c
>gcc -c  -I.  -D_REENTRANT -D_GNU_SOURCE -fwrapv -fno-strict-aliasing -pipe -fstack-protector -I/usr/local/include -D_LARGEFILE_SOURCE -D_FILE_OFFSET_BITS=64 -O2 -g -pipe -Wall -Werror=format-security -Wp,-D_FORTIFY_SOURCE=2 -fexceptions -fstack-protector-strong --param=ssp-buffer-size=4 -grecord-gcc-switches  -m64 -mtune=generic   -DVERSION=\"0.702.2\" -DXS_VERSION=\"0.702.2\" -o xs/Mongo.o -DUSE_64_BIT_INT -fPIC "-I/usr/lib64/perl5/CORE"   xs/Mongo.c
>gcc -c  -I.  -D_REENTRANT -D_GNU_SOURCE -fwrapv -fno-strict-aliasing -pipe -fstack-protector -I/usr/local/include -D_LARGEFILE_SOURCE -D_FILE_OFFSET_BITS=64 -O2 -g -pipe -Wall -Werror=format-security -Wp,-D_FORTIFY_SOURCE=2 -fexceptions -fstack-protector-strong --param=ssp-buffer-size=4 -grecord-gcc-switches  -m64 -mtune=generic   -DVERSION=\"0.702.2\" -DXS_VERSION=\"0.702.2\" -o xs/MongoClient.o -DUSE_64_BIT_INT -fPIC "-I/usr/lib64/perl5/CORE"   xs/MongoClient.c
>gcc -c  -I.  -D_REENTRANT -D_GNU_SOURCE -fwrapv -fno-strict-aliasing -pipe -fstack-protector -I/usr/local/include -D_LARGEFILE_SOURCE -D_FILE_OFFSET_BITS=64 -O2 -g -pipe -Wall -Werror=format-security -Wp,-D_FORTIFY_SOURCE=2 -fexceptions -fstack-protector-strong --param=ssp-buffer-size=4 -grecord-gcc-switches  -m64 -mtune=generic   -DVERSION=\"0.702.2\" -DXS_VERSION=\"0.702.2\" -o xs/OID.o -DUSE_64_BIT_INT -fPIC "-I/usr/lib64/perl5/CORE"   xs/OID.c
>xs/Mongo.c: In function 'XS_MongoDB_write_query':
>xs/Mongo.xs:63:15: warning: variable 'heval' set but not used [-Wunused-but-set-variable]
>          SV **heval;
>               ^
>xs/Mongo.xs: In function 'XS_MongoDB_write_insert':
>xs/Mongo.xs:110:16: warning: unused variable 'start' [-Wunused-variable]
>            int start = buf.pos-buf.start;
>                ^
>xs/MongoClient.xs: In function 'XS_MongoDB__MongoClient__compile_flags':
>xs/MongoClient.xs:276:18: warning: passing argument 2 of 'Perl_newRV_noinc' from incompatible pointer type
>         RETVAL = newRV_noinc( flags );
>                  ^
>In file included from /usr/lib64/perl5/CORE/perl.h:5115:0,
>                 from ./perl_mongo.h:23,
>                 from xs/MongoClient.xs:17:
>/usr/lib64/perl5/CORE/proto.h:2810:6: note: expected 'struct SV * const' but argument is of type 'struct HV *'
> PERL_CALLCONV SV* Perl_newRV_noinc(pTHX_ SV *const sv)
>      ^
>xs/MongoClient.c:497:7: warning: unused variable 'self' [-Wunused-variable]
>  SV * self = ST(0)
>       ^
>perl_mongo.c: In function 'perl_mongo_regex_flags':
>perl_mongo.c:199:7: warning: unused variable 'pat_sv' [-Wunused-variable]
>   SV *pat_sv   = POPs;
>       ^
>perl_mongo.c: In function 'elem_to_sv':
>perl_mongo.c:450:26: warning: variable 'heval' set but not used [-Wunused-but-set-variable]
>     SV *datetime, *ms, **heval;
>                          ^
>perl_mongo.c: In function 'hv_to_bson':
>perl_mongo.c:1017:24: warning: initialization makes pointer from integer without a cast
>     const char *utf8 = HeUTF8(he);
>                        ^
>perl_mongo.c:1032:13: warning: pointer targets in passing argument 2 of 'Perl_bytes_to_utf8' differ in signedness [-Wpointer-sign]
>       key = bytes_to_utf8(key, &len);
>             ^
>In file included from /usr/lib64/perl5/CORE/perl.h:5115:0,
>                 from perl_mongo.h:23,
>                 from perl_mongo.c:17:
>/usr/lib64/perl5/CORE/proto.h:289:6: note: expected 'const U8 *' but argument is of type 'const char *'
> PERL_CALLCONV U8* Perl_bytes_to_utf8(pTHX_ const U8 *s, STRLEN *len)
>      ^
>perl_mongo.c:1032:11: warning: pointer targets in assignment differ in signedness [-Wpointer-sign]
>       key = bytes_to_utf8(key, &len);
>           ^
>perl_mongo.c: In function 'serialize_regex_flags':
>perl_mongo.c:1626:3: warning: passing argument 1 of 'perl_mongo_regex_flags' from incompatible pointer type
>   perl_mongo_regex_flags( &flags_tmp, sv );
>   ^
>perl_mongo.c:182:12: note: expected 'char *' but argument is of type 'char (*)[8]'
> static int perl_mongo_regex_flags( char *flags_ptr, SV *re ) {
>            ^
>perl_mongo.c:1630:23: warning: comparison between pointer and integer
>     if ( flags_tmp[i] == NULL ) break;
>                       ^
>perl_mongo.c: In function 'perl_mongo_regex_flags':
>perl_mongo.c:204:1: warning: control reaches end of non-void function [-Wreturn-type]
> }
> ^
>rm -f blib/arch/auto/MongoDB/MongoDB.so
>gcc  -shared -O2 -g -pipe -Wall -Werror=format-security -Wp,-D_FORTIFY_SOURCE=2 -fexceptions -fstack-protector-strong --param=ssp-buffer-size=4 -grecord-gcc-switches -m64 -mtune=generic -Wl,-z,relro  xs/BSON.o xs/Cursor.o xs/Mongo.o xs/MongoClient.o xs/OID.o mongo_link.o perl_mongo.o  -o blib/arch/auto/MongoDB/MongoDB.so 	\
>   -lssl -lcrypto -lgsasl -lperl  	\
>  
>chmod 755 blib/arch/auto/MongoDB/MongoDB.so
>/usr/bin/perl "-Iinc" -MExtUtils::Command::MM -e 'cp_nonempty' -- MongoDB.bs blib/arch/auto/MongoDB/MongoDB.bs 644
>Manifying blib/man3/MongoDB.3pm
>Manifying blib/man3/MongoDB::BSON.3pm
>Manifying blib/man3/MongoDB::BSON::Binary.3pm
>Manifying blib/man3/MongoDB::Code.3pm
>Manifying blib/man3/MongoDB::Collection.3pm
>Manifying blib/man3/MongoDB::Connection.3pm
>Manifying blib/man3/MongoDB::Cursor.3pm
>Manifying blib/man3/MongoDB::DBRef.3pm
>Manifying blib/man3/MongoDB::DataTypes.3pm
>Manifying blib/man3/MongoDB::Database.3pm
>Manifying blib/man3/MongoDB::Examples.3pm
>Manifying blib/man3/MongoDB::GridFS.3pm
>Manifying blib/man3/MongoDB::GridFS::File.3pm
>Manifying blib/man3/MongoDB::Indexing.3pm
>Manifying blib/man3/MongoDB::MongoClient.3pm
>Manifying blib/man3/MongoDB::OID.3pm
>Manifying blib/man3/MongoDB::Timestamp.3pm
>Manifying blib/man3/MongoDB::Tutorial.3pm
>+ exit 0
>ProvÃ¡dÄnÃ(%install): /bin/sh -e /var/tmp/rpm-tmp.R1kYh3
>+ umask 022
>+ cd /builddir/build/BUILD
>+ '[' /builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64 '!=' / ']'
>+ rm -rf /builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64
>++ dirname /builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64
>+ mkdir -p /builddir/build/BUILDROOT
>+ mkdir /builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64
>+ cd MongoDB-0.702.2
>+ make pure_install PERL_INSTALL_ROOT=/builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64
>Running Mkbootstrap for MongoDB ()
>chmod 644 MongoDB.bs
>Files found in blib/arch: installing files in blib/lib into architecture dependent library tree
>Installing /builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64/usr/lib64/perl5/vendor_perl/auto/MongoDB/MongoDB.so
>Installing /builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64/usr/lib64/perl5/vendor_perl/MongoDB.pm
>Installing /builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64/usr/lib64/perl5/vendor_perl/MongoDB/DBRef.pm
>Installing /builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64/usr/lib64/perl5/vendor_perl/MongoDB/Indexing.pod
>Installing /builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64/usr/lib64/perl5/vendor_perl/MongoDB/Cursor.pm
>Installing /builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64/usr/lib64/perl5/vendor_perl/MongoDB/GridFS.pm
>Installing /builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64/usr/lib64/perl5/vendor_perl/MongoDB/BSON.pm
>Installing /builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64/usr/lib64/perl5/vendor_perl/MongoDB/Database.pm
>Installing /builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64/usr/lib64/perl5/vendor_perl/MongoDB/Code.pm
>Installing /builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64/usr/lib64/perl5/vendor_perl/MongoDB/Connection.pm
>Installing /builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64/usr/lib64/perl5/vendor_perl/MongoDB/OID.pm
>Installing /builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64/usr/lib64/perl5/vendor_perl/MongoDB/Collection.pm
>Installing /builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64/usr/lib64/perl5/vendor_perl/MongoDB/MongoClient.pm
>Installing /builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64/usr/lib64/perl5/vendor_perl/MongoDB/Examples.pod
>Installing /builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64/usr/lib64/perl5/vendor_perl/MongoDB/DataTypes.pod
>Installing /builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64/usr/lib64/perl5/vendor_perl/MongoDB/Timestamp.pm
>Installing /builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64/usr/lib64/perl5/vendor_perl/MongoDB/Tutorial.pod
>Installing /builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64/usr/lib64/perl5/vendor_perl/MongoDB/GridFS/File.pm
>Installing /builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64/usr/lib64/perl5/vendor_perl/MongoDB/BSON/Binary.pm
>Installing /builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64/usr/share/man/man3/MongoDB::GridFS.3pm
>Installing /builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64/usr/share/man/man3/MongoDB::Timestamp.3pm
>Installing /builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64/usr/share/man/man3/MongoDB::Indexing.3pm
>Installing /builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64/usr/share/man/man3/MongoDB::Collection.3pm
>Installing /builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64/usr/share/man/man3/MongoDB::Connection.3pm
>Installing /builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64/usr/share/man/man3/MongoDB::Database.3pm
>Installing /builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64/usr/share/man/man3/MongoDB::MongoClient.3pm
>Installing /builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64/usr/share/man/man3/MongoDB::Examples.3pm
>Installing /builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64/usr/share/man/man3/MongoDB::GridFS::File.3pm
>Installing /builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64/usr/share/man/man3/MongoDB::BSON.3pm
>Installing /builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64/usr/share/man/man3/MongoDB.3pm
>Installing /builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64/usr/share/man/man3/MongoDB::DataTypes.3pm
>Installing /builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64/usr/share/man/man3/MongoDB::Cursor.3pm
>Installing /builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64/usr/share/man/man3/MongoDB::Code.3pm
>Installing /builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64/usr/share/man/man3/MongoDB::DBRef.3pm
>Installing /builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64/usr/share/man/man3/MongoDB::Tutorial.3pm
>Installing /builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64/usr/share/man/man3/MongoDB::BSON::Binary.3pm
>Installing /builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64/usr/share/man/man3/MongoDB::OID.3pm
>+ find /builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64 -type f -name .packlist -exec rm -f '{}' ';'
>+ find /builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64 -type f -name '*.bs' -size 0 -exec rm -f '{}' ';'
>+ find /builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64 -depth -type d -exec rmdir '{}' ';'
>+ /usr/bin/chmod -Rf a+rX,u+w,g-w,o-w /builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64/usr
>+ /usr/lib/rpm/find-debuginfo.sh --strict-build-id -m --run-dwz --dwz-low-mem-die-limit 10000000 --dwz-max-die-limit 110000000 /builddir/build/BUILD/MongoDB-0.702.2
>extracting debug info from /builddir/build/BUILDROOT/perl-MongoDB-0.702.2-5.fc22.x86_64/usr/lib64/perl5/vendor_perl/auto/MongoDB/MongoDB.so
>dwz: Too few files for multifile optimization
>/usr/lib/rpm/sepdebugcrcfix: Updated 1 CRC32s, 0 CRC32s did match.
>307 blocks
>+ /usr/lib/rpm/check-buildroot
>+ /usr/lib/rpm/brp-compress
>+ /usr/lib/rpm/brp-strip-static-archive /usr/bin/strip
>+ /usr/lib/rpm/brp-python-bytecompile /usr/bin/python 1
>+ /usr/lib/rpm/brp-python-hardlink
>+ /usr/lib/rpm/redhat/brp-java-repack-jars
>ProvÃ¡dÄnÃ(%check): /bin/sh -e /var/tmp/rpm-tmp.YEzy4n
>+ umask 022
>+ cd /builddir/build/BUILD
>+ cd MongoDB-0.702.2
>+ mkdir test_db
>+ mongod --fork --logpath /builddir/build/BUILD/MongoDB-0.702.2/mongod.log --pidfilepath /builddir/build/BUILD/MongoDB-0.702.2/mongod.pid --dbpath /builddir/build/BUILD/MongoDB-0.702.2/test_db/
>about to fork child process, waiting until server is ready for connections.
>forked process: 20414
>child process started successfully, parent exiting
>+ make test
>PERL_DL_NONLAZY=1 /usr/bin/perl "-MExtUtils::Command::MM" "-MTest::Harness" "-e" "undef *Test::Harness::Switches; test_harness(0, 'inc', 'blib/lib', 'blib/arch')" t/*.t t/threads/*.t
>t/bson.t ............ ok
>t/collection.t ...... ok
>t/connection.t ...... ok
>t/cursor.t .......... ok
>t/database.t ........ ok
>t/db.t .............. ok
>t/dbref.t ........... ok
>t/delegation.t ...... ok
>t/dt_types.t ........ ok
>t/fsync.t ........... ok
>recieve an unexpected error from the server: exception: Can't get runner for query { files_id: ObjectId('53ff0c873f30e15152000000'), n: { $gte: 0 } } at /builddir/build/BUILD/MongoDB-0.702.2/blib/lib/MongoDB/GridFS.pm line 236.
># Looks like you planned 62 tests but ran 4.
># Looks like your test exited with 255 just after 4.
>t/gridfs.t .......... 
>Dubious, test returned 255 (wstat 65280, 0xff00)
>Failed 58/62 subtests 
>t/regex.t ........... ok
>t/threads/basic.t ... ok
>t/threads/cursor.t .. ok
>t/threads/oid.t ..... ok
>t/types.t ........... ok
>t/w.t ............... ok
>Test Summary Report
>-------------------
>t/gridfs.t        (Wstat: 65280 Tests: 4 Failed: 0)
>  Non-zero exit status: 255
>  Parse errors: Bad plan.  You planned 62 tests but ran 4.
>Files=17, Tests=522, 29 wallclock secs ( 0.11 usr  0.03 sys + 10.60 cusr  0.80 csys = 11.54 CPU)
>Result: FAIL
>Failed 1/17 test programs. 0/522 subtests failed.
>Makefile:1080: recipe for target 'test_dynamic' failed
>make: *** [test_dynamic] Error 255
>+ test_rc=2
>++ cat mongod.pid
>+ kill 20414
>+ cat mongod.log
>2014-08-28T13:01:59.835+0200 [initandlisten] MongoDB starting : pid=20414 port=27017 dbpath=/builddir/build/BUILD/MongoDB-0.702.2/test_db/ 64-bit host=island
>2014-08-28T13:01:59.835+0200 [initandlisten] db version v2.6.3
>2014-08-28T13:01:59.835+0200 [initandlisten] git version: nogitversion
>2014-08-28T13:01:59.835+0200 [initandlisten] OpenSSL version: OpenSSL 1.0.1i-fips 6 Aug 2014
>2014-08-28T13:01:59.835+0200 [initandlisten] build info: Linux buildhw-11.phx2.fedoraproject.org 3.15.8-200.fc20.x86_64 #1 SMP Fri Aug 1 00:38:50 UTC 2014 x86_64 BOOST_LIB_VERSION=1_55
>2014-08-28T13:01:59.835+0200 [initandlisten] allocator: tcmalloc
>2014-08-28T13:01:59.835+0200 [initandlisten] options: { processManagement: { fork: true, pidFilePath: "/builddir/build/BUILD/MongoDB-0.702.2/mongod.pid" }, storage: { dbPath: "/builddir/build/BUILD/MongoDB-0.702.2/test_db/" }, systemLog: { destination: "file", path: "/builddir/build/BUILD/MongoDB-0.702.2/mongod.log" } }
>2014-08-28T13:01:59.921+0200 [initandlisten] journal dir=/builddir/build/BUILD/MongoDB-0.702.2/test_db/journal
>2014-08-28T13:01:59.922+0200 [initandlisten] recover : no journal files present, no recovery needed
>2014-08-28T13:02:05.550+0200 [initandlisten] preallocateIsFaster=true 60.62
>2014-08-28T13:02:10.632+0200 [initandlisten] preallocateIsFaster=true 50.58
>2014-08-28T13:02:16.696+0200 [initandlisten] preallocateIsFaster=true 47.1
>2014-08-28T13:02:16.919+0200 [initandlisten] preallocateIsFaster check took 16.997 secs
>2014-08-28T13:02:16.919+0200 [initandlisten] preallocating a journal file /builddir/build/BUILD/MongoDB-0.702.2/test_db/journal/prealloc.0
>2014-08-28T13:02:19.355+0200 [initandlisten] 		File Preallocator Progress: 524288000/1073741824	48%
>2014-08-28T13:02:22.065+0200 [initandlisten] 		File Preallocator Progress: 587202560/1073741824	54%
>2014-08-28T13:02:25.022+0200 [initandlisten] 		File Preallocator Progress: 744488960/1073741824	69%
>2014-08-28T13:02:28.340+0200 [initandlisten] 		File Preallocator Progress: 943718400/1073741824	87%
>2014-08-28T13:02:37.858+0200 [initandlisten] preallocating a journal file /builddir/build/BUILD/MongoDB-0.702.2/test_db/journal/prealloc.1
>2014-08-28T13:02:40.135+0200 [initandlisten] 		File Preallocator Progress: 566231040/1073741824	52%
>2014-08-28T13:02:43.091+0200 [initandlisten] 		File Preallocator Progress: 786432000/1073741824	73%
>2014-08-28T13:02:46.039+0200 [initandlisten] 		File Preallocator Progress: 954204160/1073741824	88%
>2014-08-28T13:02:56.387+0200 [initandlisten] preallocating a journal file /builddir/build/BUILD/MongoDB-0.702.2/test_db/journal/prealloc.2
>2014-08-28T13:02:59.108+0200 [initandlisten] 		File Preallocator Progress: 650117120/1073741824	60%
>2014-08-28T13:03:02.019+0200 [initandlisten] 		File Preallocator Progress: 838860800/1073741824	78%
>2014-08-28T13:03:05.065+0200 [initandlisten] 		File Preallocator Progress: 1027604480/1073741824	95%
>2014-08-28T13:03:14.852+0200 [FileAllocator] allocating new datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/local.ns, filling with zeroes...
>2014-08-28T13:03:14.852+0200 [FileAllocator] creating directory /builddir/build/BUILD/MongoDB-0.702.2/test_db/_tmp
>2014-08-28T13:03:15.316+0200 [FileAllocator] done allocating datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/local.ns, size: 16MB,  took 0.35 secs
>2014-08-28T13:03:15.318+0200 [FileAllocator] allocating new datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/local.0, filling with zeroes...
>2014-08-28T13:03:15.434+0200 [FileAllocator] done allocating datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/local.0, size: 64MB,  took 0.115 secs
>2014-08-28T13:03:15.435+0200 [initandlisten] build index on: local.startup_log properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "local.startup_log" }
>2014-08-28T13:03:15.435+0200 [initandlisten] 	 added index to empty collection
>2014-08-28T13:03:15.435+0200 [initandlisten] command local.$cmd command: create { create: "startup_log", size: 10485760, capped: true } ntoreturn:1 keyUpdates:0 numYields:0  reslen:37 583ms
>2014-08-28T13:03:15.436+0200 [initandlisten] waiting for connections on port 27017
>2014-08-28T13:03:20.273+0200 [initandlisten] connection accepted from 127.0.0.1:54139 #1 (1 connection now open)
>2014-08-28T13:03:20.279+0200 [conn1] CMD: drop foo.bar
>2014-08-28T13:03:20.280+0200 [FileAllocator] allocating new datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/foo.ns, filling with zeroes...
>2014-08-28T13:03:20.366+0200 [FileAllocator] done allocating datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/foo.ns, size: 16MB,  took 0.086 secs
>2014-08-28T13:03:20.368+0200 [FileAllocator] allocating new datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/foo.0, filling with zeroes...
>2014-08-28T13:03:20.439+0200 [FileAllocator] done allocating datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/foo.0, size: 64MB,  took 0.07 secs
>2014-08-28T13:03:20.440+0200 [conn1] build index on: foo.bar properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "foo.bar" }
>2014-08-28T13:03:20.441+0200 [conn1] 	 added index to empty collection
>2014-08-28T13:03:20.441+0200 [conn1] insert foo.bar ninserted:1 keyUpdates:0 numYields:0 locks(micros) w:161257 161ms
>2014-08-28T13:03:20.442+0200 [conn1] CMD: drop foo.bar
>2014-08-28T13:03:20.473+0200 [conn1] build index on: foo.bar properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "foo.bar" }
>2014-08-28T13:03:20.473+0200 [conn1] 	 added index to empty collection
>2014-08-28T13:03:20.475+0200 [conn1] CMD: drop foo.bar
>2014-08-28T13:03:20.476+0200 [conn1] build index on: foo.bar properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "foo.bar" }
>2014-08-28T13:03:20.476+0200 [conn1] 	 added index to empty collection
>2014-08-28T13:03:20.480+0200 [conn1] CMD: drop foo.bar
>2014-08-28T13:03:20.481+0200 [conn1] build index on: foo.bar properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "foo.bar" }
>2014-08-28T13:03:20.481+0200 [conn1] 	 added index to empty collection
>2014-08-28T13:03:20.482+0200 [conn1] CMD: drop foo.bar
>2014-08-28T13:03:20.483+0200 [conn1] build index on: foo.bar properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "foo.bar" }
>2014-08-28T13:03:20.483+0200 [conn1] 	 added index to empty collection
>2014-08-28T13:03:20.485+0200 [conn1] CMD: drop foo.bar
>2014-08-28T13:03:20.486+0200 [conn1] build index on: foo.bar properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "foo.bar" }
>2014-08-28T13:03:20.486+0200 [conn1] 	 added index to empty collection
>2014-08-28T13:03:20.494+0200 [conn1] CMD: drop foo.bar
>2014-08-28T13:03:20.496+0200 [conn1] build index on: foo.bar properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "foo.bar" }
>2014-08-28T13:03:20.496+0200 [conn1] 	 added index to empty collection
>2014-08-28T13:03:20.497+0200 [conn1] CMD: drop foo.bar
>2014-08-28T13:03:20.498+0200 [conn1] build index on: foo.bar properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "foo.bar" }
>2014-08-28T13:03:20.499+0200 [conn1] 	 added index to empty collection
>2014-08-28T13:03:20.499+0200 [conn1] CMD: drop foo.bar
>2014-08-28T13:03:20.501+0200 [conn1] build index on: foo.bar properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "foo.bar" }
>2014-08-28T13:03:20.501+0200 [conn1] 	 added index to empty collection
>2014-08-28T13:03:20.502+0200 [conn1] CMD: drop foo.bar
>2014-08-28T13:03:20.503+0200 [conn1] build index on: foo.bar properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "foo.bar" }
>2014-08-28T13:03:20.503+0200 [conn1] 	 added index to empty collection
>2014-08-28T13:03:20.504+0200 [conn1] CMD: drop foo.bar
>2014-08-28T13:03:20.505+0200 [conn1] build index on: foo.bar properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "foo.bar" }
>2014-08-28T13:03:20.505+0200 [conn1] 	 added index to empty collection
>2014-08-28T13:03:20.508+0200 [conn1] CMD: drop foo.bar
>2014-08-28T13:03:20.509+0200 [conn1] build index on: foo.bar properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "foo.bar" }
>2014-08-28T13:03:20.509+0200 [conn1] 	 added index to empty collection
>2014-08-28T13:03:20.512+0200 [conn1] CMD: drop foo.bar
>2014-08-28T13:03:20.514+0200 [conn1] build index on: foo.bar properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "foo.bar" }
>2014-08-28T13:03:20.514+0200 [conn1] 	 added index to empty collection
>2014-08-28T13:03:20.522+0200 [conn1] CMD: drop foo.bar
>2014-08-28T13:03:20.523+0200 [conn1] build index on: foo.bar properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "foo.bar" }
>2014-08-28T13:03:20.523+0200 [conn1] 	 added index to empty collection
>2014-08-28T13:03:20.524+0200 [conn1] dropDatabase foo starting
>2014-08-28T13:03:20.930+0200 [conn1] removeJournalFiles
>2014-08-28T13:03:21.053+0200 [conn1] dropDatabase foo finished
>2014-08-28T13:03:21.053+0200 [conn1] command foo.$cmd command: dropDatabase { dropDatabase: 1 } keyUpdates:0 numYields:0 locks(micros) W:528873 reslen:54 528ms
>2014-08-28T13:03:21.053+0200 [conn1] dropDatabase test_database starting
>2014-08-28T13:03:21.065+0200 [conn1] removeJournalFiles
>2014-08-28T13:03:21.132+0200 [conn1] dropDatabase test_database finished
>2014-08-28T13:03:21.166+0200 [conn1] end connection 127.0.0.1:54139 (0 connections now open)
>2014-08-28T13:03:21.616+0200 [initandlisten] connection accepted from 127.0.0.1:54140 #2 (1 connection now open)
>2014-08-28T13:03:21.623+0200 [conn2] dropDatabase test_database starting
>2014-08-28T13:03:21.623+0200 [conn2] removeJournalFiles
>2014-08-28T13:03:21.661+0200 [conn2] dropDatabase test_database finished
>2014-08-28T13:03:21.662+0200 [conn2] dropDatabase test_database starting
>2014-08-28T13:03:21.662+0200 [conn2] removeJournalFiles
>2014-08-28T13:03:21.702+0200 [conn2] dropDatabase test_database finished
>2014-08-28T13:03:21.703+0200 [FileAllocator] allocating new datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.ns, filling with zeroes...
>2014-08-28T13:03:21.746+0200 [FileAllocator] done allocating datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.ns, size: 16MB,  took 0.042 secs
>2014-08-28T13:03:21.747+0200 [FileAllocator] allocating new datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.0, filling with zeroes...
>2014-08-28T13:03:21.830+0200 [FileAllocator] done allocating datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.0, size: 64MB,  took 0.082 secs
>2014-08-28T13:03:21.831+0200 [conn2] build index on: test_database.test_collection properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test_collection" }
>2014-08-28T13:03:21.831+0200 [conn2] 	 added index to empty collection
>2014-08-28T13:03:21.832+0200 [conn2] insert test_database.test_collection ninserted:1 keyUpdates:0 numYields:0 locks(micros) w:129042 129ms
>2014-08-28T13:03:22.033+0200 [conn2] CMD: validate test_database.test_collection
>2014-08-28T13:03:22.033+0200 [conn2] validating index test_database.test_collection.$_id_
>2014-08-28T13:03:22.034+0200 [conn2] CMD: drop test_database.test_collection
>2014-08-28T13:03:22.035+0200 [conn2] build index on: test_database.test_collection properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test_collection" }
>2014-08-28T13:03:22.035+0200 [conn2] 	 added index to empty collection
>2014-08-28T13:03:22.039+0200 [conn2] CMD: drop test_database.test_collection
>2014-08-28T13:03:22.041+0200 [conn2] build index on: test_database.test_collection properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test_collection" }
>2014-08-28T13:03:22.041+0200 [conn2] 	 added index to empty collection
>2014-08-28T13:03:22.041+0200 [conn2] build index on: test_database.test_collection properties: { v: 1, key: { foo: 1, bar: 1, baz: 1 }, name: "foo_1_bar_1_baz_1", ns: "test_database.test_collection" }
>2014-08-28T13:03:22.042+0200 [conn2] 	 added index to empty collection
>2014-08-28T13:03:22.043+0200 [conn2] build index on: test_database.test_collection properties: { v: 1, key: { foo: 1, bar: 1 }, name: "foo_1_bar_1", ns: "test_database.test_collection" }
>2014-08-28T13:03:22.043+0200 [conn2] 	 added index to empty collection
>2014-08-28T13:03:22.045+0200 [conn2] build index on: test_database.test_collection properties: { v: 1, unique: true, key: { boo: 1 }, name: "boo_1", ns: "test_database.test_collection" }
>2014-08-28T13:03:22.045+0200 [conn2] 	 building index using bulk method
>2014-08-28T13:03:22.045+0200 [conn2] build index done.  scanned 2 total records. 0 secs
>2014-08-28T13:03:22.153+0200 [conn2] insert test_database.test_collection keyUpdates:0 exception: insertDocument :: caused by :: 11000 E11000 duplicate key error index: test_database.test_collection.$boo_1  dup key: { : 2 } code:11000 numYields:0 locks(micros) w:107121 107ms
>2014-08-28T13:03:22.154+0200 [conn2] CMD: dropIndexes test_database.test_collection
>2014-08-28T13:03:22.197+0200 [conn2] CMD: drop test_database.test_collection
>2014-08-28T13:03:22.199+0200 [conn2] build index on: test_database.test_collection properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test_collection" }
>2014-08-28T13:03:22.199+0200 [conn2] 	 added index to empty collection
>2014-08-28T13:03:22.200+0200 [conn2] build index on: test_database.test_collection properties: { v: 1, key: { foo: 1 }, name: "foo_1", ns: "test_database.test_collection" }
>2014-08-28T13:03:22.200+0200 [conn2] 	 added index to empty collection
>2014-08-28T13:03:22.200+0200 [conn2] CMD: drop test_database.test_collection
>2014-08-28T13:03:22.202+0200 [conn2] build index on: test_database.test_collection properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test_collection" }
>2014-08-28T13:03:22.202+0200 [conn2] 	 added index to empty collection
>2014-08-28T13:03:22.202+0200 [conn2] build index on: test_database.test_collection properties: { v: 1, key: { foo: 1, bar: -1, baz: 1 }, name: "foo_1_bar_-1_baz_1", ns: "test_database.test_collection" }
>2014-08-28T13:03:22.202+0200 [conn2] 	 added index to empty collection
>2014-08-28T13:03:22.203+0200 [conn2] build index on: test_database.test_collection properties: { v: 1, key: { foo: 1, bar: 1 }, name: "foo_1_bar_1", ns: "test_database.test_collection" }
>2014-08-28T13:03:22.203+0200 [conn2] 	 added index to empty collection
>2014-08-28T13:03:22.204+0200 [conn2] build index on: test_database.test_collection properties: { v: 1, unique: true, key: { boo: 1 }, name: "boo_1", ns: "test_database.test_collection" }
>2014-08-28T13:03:22.204+0200 [conn2] 	 building index using bulk method
>2014-08-28T13:03:22.205+0200 [conn2] build index done.  scanned 2 total records. 0 secs
>2014-08-28T13:03:22.206+0200 [conn2] CMD: drop test_database.test_collection
>2014-08-28T13:03:22.208+0200 [conn2] build index on: test_database.test_collection properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test_collection" }
>2014-08-28T13:03:22.208+0200 [conn2] 	 added index to empty collection
>2014-08-28T13:03:22.209+0200 [conn2] CMD: drop test_database.test_collection
>2014-08-28T13:03:22.210+0200 [conn2] build index on: test_database.test_collection properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test_collection" }
>2014-08-28T13:03:22.210+0200 [conn2] 	 added index to empty collection
>2014-08-28T13:03:22.212+0200 [conn2] CMD: drop test_database.test_collection
>2014-08-28T13:03:22.213+0200 [conn2] build index on: test_database.test_collection properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test_collection" }
>2014-08-28T13:03:22.213+0200 [conn2] 	 added index to empty collection
>2014-08-28T13:03:22.214+0200 [conn2] CMD: drop test_database.test_collection
>2014-08-28T13:03:22.215+0200 [conn2] build index on: test_database.test_collection properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test_collection" }
>2014-08-28T13:03:22.215+0200 [conn2] 	 added index to empty collection
>2014-08-28T13:03:22.215+0200 [conn2] CMD: drop test_database.test_collection
>2014-08-28T13:03:22.216+0200 [conn2] build index on: test_database.test_collection properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test_collection" }
>2014-08-28T13:03:22.216+0200 [conn2] 	 added index to empty collection
>2014-08-28T13:03:22.217+0200 [conn2] CMD: drop test_database.test_collection
>2014-08-28T13:03:22.218+0200 [conn2] build index on: test_database.test_collection properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test_collection" }
>2014-08-28T13:03:22.218+0200 [conn2] 	 added index to empty collection
>2014-08-28T13:03:22.218+0200 [conn2] build index on: test_database.test_collection properties: { v: 1, key: { sn: 1, ts: -1 }, name: "sn_1_ts_-1", ns: "test_database.test_collection" }
>2014-08-28T13:03:22.218+0200 [conn2] 	 added index to empty collection
>2014-08-28T13:03:22.219+0200 [conn2] CMD: drop test_database.test_collection
>2014-08-28T13:03:22.220+0200 [conn2] build index on: test_database.test_collection properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test_collection" }
>2014-08-28T13:03:22.220+0200 [conn2] 	 added index to empty collection
>2014-08-28T13:03:22.221+0200 [conn2] CMD: drop test_database.test_collection
>2014-08-28T13:03:22.222+0200 [conn2] build index on: test_database.test_collection properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test_collection" }
>2014-08-28T13:03:22.222+0200 [conn2] 	 added index to empty collection
>2014-08-28T13:03:22.224+0200 [conn2] CMD: drop test_database.test_collection
>2014-08-28T13:03:22.224+0200 [conn2] build index on: test_database.test_collection properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test_collection" }
>2014-08-28T13:03:22.224+0200 [conn2] 	 added index to empty collection
>2014-08-28T13:03:22.225+0200 [conn2] CMD: drop test_database.test_collection
>2014-08-28T13:03:22.226+0200 [conn2] build index on: test_database.test_collection properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test_collection" }
>2014-08-28T13:03:22.226+0200 [conn2] 	 added index to empty collection
>2014-08-28T13:03:22.227+0200 [conn2] CMD: drop test_database.test_collection
>2014-08-28T13:03:22.227+0200 [conn2] build index on: test_database.test_collection properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test_collection" }
>2014-08-28T13:03:22.227+0200 [conn2] 	 added index to empty collection
>2014-08-28T13:03:22.230+0200 [conn2] CMD: drop test_database.test_collection
>2014-08-28T13:03:22.230+0200 [conn2] build index on: test_database.test_collection properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test_collection" }
>2014-08-28T13:03:22.230+0200 [conn2] 	 added index to empty collection
>2014-08-28T13:03:22.232+0200 [conn2] CMD: drop test_database.test_collection
>2014-08-28T13:03:22.233+0200 [conn2] build index on: test_database.test_collection properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test_collection" }
>2014-08-28T13:03:22.233+0200 [conn2] 	 added index to empty collection
>2014-08-28T13:03:22.239+0200 [conn2] CMD: drop test_database.test_collection
>2014-08-28T13:03:22.239+0200 [conn2] build index on: test_database.test_collection properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test_collection" }
>2014-08-28T13:03:22.239+0200 [conn2] 	 added index to empty collection
>2014-08-28T13:03:22.240+0200 [conn2] CMD: drop test_database.test_collection
>2014-08-28T13:03:22.241+0200 [conn2] build index on: test_database.test_collection properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test_collection" }
>2014-08-28T13:03:22.241+0200 [conn2] 	 added index to empty collection
>2014-08-28T13:03:22.243+0200 [conn2] CMD: drop test_database.test_collection
>2014-08-28T13:03:22.244+0200 [conn2] build index on: test_database.test_collection properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test_collection" }
>2014-08-28T13:03:22.244+0200 [conn2] 	 added index to empty collection
>2014-08-28T13:03:22.245+0200 [conn2] CMD: drop test_database.test_collection
>2014-08-28T13:03:22.267+0200 [conn2] build index on: test_database.test_collection properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test_collection" }
>2014-08-28T13:03:22.267+0200 [conn2] 	 added index to empty collection
>2014-08-28T13:03:22.268+0200 [conn2] CMD: drop test_database.test_collection
>2014-08-28T13:03:22.269+0200 [conn2] build index on: test_database.test_collection properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test_collection" }
>2014-08-28T13:03:22.269+0200 [conn2] 	 added index to empty collection
>2014-08-28T13:03:22.271+0200 [conn2] CMD: drop test_database.test_collection
>2014-08-28T13:03:22.272+0200 [conn2] build index on: test_database.test_collection properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test_collection" }
>2014-08-28T13:03:22.272+0200 [conn2] 	 added index to empty collection
>2014-08-28T13:03:22.273+0200 [conn2] CMD: drop test_database.test_collection
>2014-08-28T13:03:22.274+0200 [conn2] build index on: test_database.test_collection properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test_collection" }
>2014-08-28T13:03:22.274+0200 [conn2] 	 added index to empty collection
>2014-08-28T13:03:22.275+0200 [conn2] CMD: drop test_database.test_collection
>2014-08-28T13:03:22.276+0200 [conn2] build index on: test_database.test_collection properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test_collection" }
>2014-08-28T13:03:22.276+0200 [conn2] 	 added index to empty collection
>2014-08-28T13:03:22.276+0200 [conn2] build index on: test_database.test_collection properties: { v: 1, key: { x.y: 1 }, name: "foo", ns: "test_database.test_collection" }
>2014-08-28T13:03:22.276+0200 [conn2] 	 added index to empty collection
>2014-08-28T13:03:22.277+0200 [conn2] CMD: drop test_database.test_collection
>2014-08-28T13:03:22.278+0200 [conn2] build index on: test_database.test_collection properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test_collection" }
>2014-08-28T13:03:22.278+0200 [conn2] 	 added index to empty collection
>2014-08-28T13:03:22.283+0200 [conn2] build index on: test_database.test_collection properties: { v: 1, unique: true, key: { y: 1 }, name: "foo", ns: "test_database.test_collection" }
>2014-08-28T13:03:22.283+0200 [conn2] 	 building index using bulk method
>2014-08-28T13:03:22.284+0200 [conn2] index build failed. spec: { v: 1, unique: true, key: { y: 1 }, name: "foo", ns: "test_database.test_collection" } error: 11000 E11000 duplicate key error index: test_database.test_collection.$foo  dup key: { : null }
>2014-08-28T13:03:22.285+0200 [conn2] build index on: test_database.test_collection properties: { v: 1, unique: true, key: { y: 1 }, name: "foo", ns: "test_database.test_collection", sparse: true }
>2014-08-28T13:03:22.285+0200 [conn2] 	 building index using bulk method
>2014-08-28T13:03:22.285+0200 [conn2] build index done.  scanned 20 total records. 0 secs
>2014-08-28T13:03:22.286+0200 [conn2] CMD: drop test_database.test_collection
>2014-08-28T13:03:22.287+0200 [conn2] CMD: drop test_database.test_collection
>2014-08-28T13:03:22.288+0200 [conn2] CMD: drop test_database.test_collection
>2014-08-28T13:03:22.289+0200 [conn2] CMD: drop test_database.test_collection
>2014-08-28T13:03:22.289+0200 [conn2] build index on: test_database.test_collection properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test_collection" }
>2014-08-28T13:03:22.289+0200 [conn2] 	 added index to empty collection
>2014-08-28T13:03:22.290+0200 [conn2] CMD: drop test_database.test_collection
>2014-08-28T13:03:22.291+0200 [conn2] build index on: test_database.test_collection properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test_collection" }
>2014-08-28T13:03:22.291+0200 [conn2] 	 added index to empty collection
>2014-08-28T13:03:22.292+0200 [conn2] CMD: drop test_database.test_collection
>2014-08-28T13:03:22.293+0200 [conn2] CMD: drop test_database.test_collection
>2014-08-28T13:03:22.293+0200 [conn2] build index on: test_database.test_collection properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test_collection" }
>2014-08-28T13:03:22.293+0200 [conn2] 	 added index to empty collection
>2014-08-28T13:03:22.327+0200 [conn2] dropDatabase foo starting
>2014-08-28T13:03:22.603+0200 [conn2] removeJournalFiles
>2014-08-28T13:03:22.729+0200 [conn2] dropDatabase foo finished
>2014-08-28T13:03:22.729+0200 [conn2] command foo.$cmd command: dropDatabase { dropDatabase: 1 } keyUpdates:0 numYields:0 locks(micros) W:417993 reslen:54 418ms
>2014-08-28T13:03:22.729+0200 [conn2] dropDatabase test_database starting
>2014-08-28T13:03:22.745+0200 [conn2] removeJournalFiles
>2014-08-28T13:03:22.789+0200 [conn2] dropDatabase test_database finished
>2014-08-28T13:03:22.789+0200 [conn2] dropDatabase test_database starting
>2014-08-28T13:03:22.804+0200 [conn2] removeJournalFiles
>2014-08-28T13:03:22.830+0200 [conn2] dropDatabase test_database finished
>2014-08-28T13:03:22.835+0200 [conn2] end connection 127.0.0.1:54140 (0 connections now open)
>2014-08-28T13:03:23.324+0200 [initandlisten] connection accepted from 127.0.0.1:54141 #3 (1 connection now open)
>2014-08-28T13:03:23.328+0200 [initandlisten] connection accepted from 127.0.0.1:54143 #4 (2 connections now open)
>2014-08-28T13:03:23.329+0200 [initandlisten] connection accepted from 127.0.0.1:54144 #5 (3 connections now open)
>2014-08-28T13:03:23.330+0200 [initandlisten] connection accepted from 127.0.0.1:54145 #6 (4 connections now open)
>2014-08-28T13:03:23.330+0200 [initandlisten] connection accepted from 127.0.0.1:54146 #7 (5 connections now open)
>2014-08-28T13:03:23.331+0200 [initandlisten] connection accepted from 127.0.0.1:54147 #8 (6 connections now open)
>2014-08-28T13:03:23.332+0200 [initandlisten] connection accepted from 127.0.0.1:54148 #9 (7 connections now open)
>2014-08-28T13:03:23.333+0200 [initandlisten] connection accepted from 127.0.0.1:54151 #10 (8 connections now open)
>2014-08-28T13:03:23.334+0200 [initandlisten] connection accepted from 127.0.0.1:54152 #11 (9 connections now open)
>2014-08-28T13:03:23.335+0200 [initandlisten] connection accepted from 127.0.0.1:54153 #12 (10 connections now open)
>2014-08-28T13:03:23.335+0200 [initandlisten] connection accepted from 127.0.0.1:54154 #13 (11 connections now open)
>2014-08-28T13:03:23.337+0200 [initandlisten] connection accepted from 127.0.0.1:54157 #14 (12 connections now open)
>2014-08-28T13:03:23.338+0200 [initandlisten] connection accepted from 127.0.0.1:54160 #15 (13 connections now open)
>2014-08-28T13:03:23.338+0200 [initandlisten] connection accepted from 127.0.0.1:54161 #16 (14 connections now open)
>2014-08-28T13:03:23.339+0200 [FileAllocator] allocating new datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.ns, filling with zeroes...
>2014-08-28T13:03:23.419+0200 [FileAllocator] done allocating datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.ns, size: 16MB,  took 0.079 secs
>2014-08-28T13:03:23.420+0200 [FileAllocator] allocating new datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.0, filling with zeroes...
>2014-08-28T13:03:23.469+0200 [FileAllocator] done allocating datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.0, size: 64MB,  took 0.049 secs
>2014-08-28T13:03:23.471+0200 [conn9] build index on: test_database.test_collection properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test_collection" }
>2014-08-28T13:03:23.471+0200 [conn9] 	 added index to empty collection
>2014-08-28T13:03:23.471+0200 [conn9] insert test_database.test_collection ninserted:1 keyUpdates:0 numYields:0 locks(micros) w:132387 132ms
>2014-08-28T13:03:23.596+0200 [conn9] dropDatabase test_database starting
>2014-08-28T13:03:23.780+0200 [conn9] removeJournalFiles
>2014-08-28T13:03:23.903+0200 [conn9] dropDatabase test_database finished
>2014-08-28T13:03:23.903+0200 [conn9] command test_database.$cmd command: dropDatabase { dropDatabase: 1 } keyUpdates:0 numYields:0 locks(micros) W:307420 reslen:64 307ms
>2014-08-28T13:03:24.029+0200 [conn9] dropDatabase test_database starting
>2014-08-28T13:03:24.076+0200 [conn9] removeJournalFiles
>2014-08-28T13:03:24.118+0200 [conn9] dropDatabase test_database finished
>2014-08-28T13:03:24.120+0200 [conn9] dropDatabase foo starting
>2014-08-28T13:03:24.135+0200 [conn9] removeJournalFiles
>2014-08-28T13:03:24.194+0200 [conn9] dropDatabase foo finished
>2014-08-28T13:03:24.194+0200 [conn9] dropDatabase test_database starting
>2014-08-28T13:03:24.227+0200 [conn9] removeJournalFiles
>2014-08-28T13:03:24.268+0200 [conn9] dropDatabase test_database finished
>2014-08-28T13:03:24.268+0200 [conn9] dropDatabase test_database starting
>2014-08-28T13:03:24.286+0200 [conn9] removeJournalFiles
>2014-08-28T13:03:24.311+0200 [conn9] dropDatabase test_database finished
>2014-08-28T13:03:24.312+0200 [conn15] end connection 127.0.0.1:54160 (13 connections now open)
>2014-08-28T13:03:24.312+0200 [conn6] end connection 127.0.0.1:54145 (12 connections now open)
>2014-08-28T13:03:24.312+0200 [conn8] end connection 127.0.0.1:54147 (12 connections now open)
>2014-08-28T13:03:24.312+0200 [conn5] end connection 127.0.0.1:54144 (11 connections now open)
>2014-08-28T13:03:24.312+0200 [conn10] end connection 127.0.0.1:54151 (11 connections now open)
>2014-08-28T13:03:24.312+0200 [conn4] end connection 127.0.0.1:54143 (12 connections now open)
>2014-08-28T13:03:24.313+0200 [conn7] end connection 127.0.0.1:54146 (8 connections now open)
>2014-08-28T13:03:24.313+0200 [conn3] end connection 127.0.0.1:54141 (8 connections now open)
>2014-08-28T13:03:24.313+0200 [conn11] end connection 127.0.0.1:54152 (7 connections now open)
>2014-08-28T13:03:24.313+0200 [conn12] end connection 127.0.0.1:54153 (5 connections now open)
>2014-08-28T13:03:24.313+0200 [conn13] end connection 127.0.0.1:54154 (3 connections now open)
>2014-08-28T13:03:24.313+0200 [conn16] end connection 127.0.0.1:54161 (3 connections now open)
>2014-08-28T13:03:24.313+0200 [conn14] end connection 127.0.0.1:54157 (1 connection now open)
>2014-08-28T13:03:24.317+0200 [conn9] end connection 127.0.0.1:54148 (0 connections now open)
>2014-08-28T13:03:24.817+0200 [initandlisten] connection accepted from 127.0.0.1:54162 #17 (1 connection now open)
>2014-08-28T13:03:24.820+0200 [conn17] dropDatabase test_database starting
>2014-08-28T13:03:24.865+0200 [conn17] removeJournalFiles
>2014-08-28T13:03:24.899+0200 [conn17] dropDatabase test_database finished
>2014-08-28T13:03:24.899+0200 [FileAllocator] allocating new datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.ns, filling with zeroes...
>2014-08-28T13:03:24.928+0200 [FileAllocator] done allocating datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.ns, size: 16MB,  took 0.028 secs
>2014-08-28T13:03:24.930+0200 [FileAllocator] allocating new datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.0, filling with zeroes...
>2014-08-28T13:03:24.985+0200 [FileAllocator] done allocating datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.0, size: 64MB,  took 0.054 secs
>2014-08-28T13:03:24.987+0200 [conn17] build index on: test_database.test_collection properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test_collection" }
>2014-08-28T13:03:24.987+0200 [conn17] 	 added index to empty collection
>2014-08-28T13:03:24.995+0200 [conn17] dropDatabase test_database starting
>2014-08-28T13:03:25.354+0200 [conn17] removeJournalFiles
>2014-08-28T13:03:25.467+0200 [conn17] dropDatabase test_database finished
>2014-08-28T13:03:25.467+0200 [conn17] command test_database.$cmd command: dropDatabase { dropDatabase: 1 } keyUpdates:0 numYields:0 locks(micros) W:472477 reslen:64 472ms
>2014-08-28T13:03:25.469+0200 [FileAllocator] allocating new datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.ns, filling with zeroes...
>2014-08-28T13:03:25.554+0200 [FileAllocator] done allocating datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.ns, size: 16MB,  took 0.084 secs
>2014-08-28T13:03:25.555+0200 [FileAllocator] allocating new datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.0, filling with zeroes...
>2014-08-28T13:03:25.607+0200 [FileAllocator] done allocating datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.0, size: 64MB,  took 0.051 secs
>2014-08-28T13:03:25.608+0200 [conn17] build index on: test_database.test_collection properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test_collection" }
>2014-08-28T13:03:25.609+0200 [conn17] 	 added index to empty collection
>2014-08-28T13:03:25.609+0200 [conn17] insert test_database.test_collection ninserted:1 keyUpdates:0 numYields:0 locks(micros) w:139881 139ms
>2014-08-28T13:03:26.044+0200 [conn17] CMD: drop test_database.test
>2014-08-28T13:03:26.046+0200 [conn17] build index on: test_database.test properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test" }
>2014-08-28T13:03:26.046+0200 [conn17] 	 added index to empty collection
>2014-08-28T13:03:26.046+0200 [conn17] build index on: test_database.test properties: { v: 1, key: { sn: 1 }, name: "sn_1", ns: "test_database.test" }
>2014-08-28T13:03:26.046+0200 [conn17] 	 added index to empty collection
>2014-08-28T13:03:26.227+0200 [conn17] CMD: drop test_database.test
>2014-08-28T13:03:26.229+0200 [conn17] build index on: test_database.test properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test" }
>2014-08-28T13:03:26.229+0200 [conn17] 	 added index to empty collection
>2014-08-28T13:03:26.252+0200 [conn17] assertion 17007 Unable to execute query: error processing query: ns=test_database.test limit=0 skip=0
>Tree: $and
>Sort: {}
>Proj: {}
> planner returned error: bad hint ns:test_database.test query:{ $explain: true, $hint: { num: 1 }, query: {} }
>2014-08-28T13:03:26.253+0200 [conn17] CMD: drop test_database.test
>2014-08-28T13:03:26.253+0200 [conn17] CMD: drop test_database.test_collection
>2014-08-28T13:03:26.255+0200 [conn17] build index on: test_database.test_collection properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test_collection" }
>2014-08-28T13:03:26.255+0200 [conn17] 	 added index to empty collection
>2014-08-28T13:03:26.258+0200 [conn17] CMD: drop test_database.test_collection
>2014-08-28T13:03:26.259+0200 [conn17] build index on: test_database.test_collection properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test_collection" }
>2014-08-28T13:03:26.259+0200 [conn17] 	 added index to empty collection
>2014-08-28T13:03:26.260+0200 [conn17] CMD: drop test_database.test_collection
>2014-08-28T13:03:26.261+0200 [conn17] build index on: test_database.test_collection properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test_collection" }
>2014-08-28T13:03:26.261+0200 [conn17] 	 added index to empty collection
>2014-08-28T13:03:26.265+0200 [conn17] CMD: drop test_database.test_collection
>2014-08-28T13:03:26.265+0200 [conn17] build index on: test_database.test_collection properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test_collection" }
>2014-08-28T13:03:26.266+0200 [conn17] 	 added index to empty collection
>2014-08-28T13:03:26.267+0200 [conn17] killcursors: found 0 of 1
>2014-08-28T13:03:26.267+0200 [conn17] dropDatabase test_database starting
>2014-08-28T13:03:26.536+0200 [conn17] removeJournalFiles
>2014-08-28T13:03:26.660+0200 [conn17] dropDatabase test_database finished
>2014-08-28T13:03:26.660+0200 [conn17] command test_database.$cmd command: dropDatabase { dropDatabase: 1 } keyUpdates:0 numYields:0 locks(micros) W:392982 reslen:64 393ms
>2014-08-28T13:03:26.661+0200 [conn17] dropDatabase test_database starting
>2014-08-28T13:03:26.673+0200 [conn17] removeJournalFiles
>2014-08-28T13:03:26.707+0200 [conn17] dropDatabase test_database finished
>2014-08-28T13:03:26.711+0200 [conn17] end connection 127.0.0.1:54162 (0 connections now open)
>2014-08-28T13:03:27.180+0200 [initandlisten] connection accepted from 127.0.0.1:54163 #18 (1 connection now open)
>2014-08-28T13:03:27.183+0200 [conn18] dropDatabase test_database starting
>2014-08-28T13:03:27.228+0200 [conn18] removeJournalFiles
>2014-08-28T13:03:27.253+0200 [conn18] dropDatabase test_database finished
>2014-08-28T13:03:27.254+0200 [conn18] dropDatabase test_database starting
>2014-08-28T13:03:27.254+0200 [conn18] removeJournalFiles
>2014-08-28T13:03:27.286+0200 [conn18] dropDatabase test_database finished
>2014-08-28T13:03:27.287+0200 [FileAllocator] allocating new datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.ns, filling with zeroes...
>2014-08-28T13:03:27.338+0200 [FileAllocator] done allocating datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.ns, size: 16MB,  took 0.05 secs
>2014-08-28T13:03:27.339+0200 [FileAllocator] allocating new datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.0, filling with zeroes...
>2014-08-28T13:03:27.403+0200 [FileAllocator] done allocating datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.0, size: 64MB,  took 0.063 secs
>2014-08-28T13:03:27.404+0200 [conn18] build index on: test_database.test properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test" }
>2014-08-28T13:03:27.404+0200 [conn18] 	 added index to empty collection
>2014-08-28T13:03:27.404+0200 [conn18] insert test_database.test ninserted:1 keyUpdates:0 numYields:0 locks(micros) w:117017 117ms
>2014-08-28T13:03:27.697+0200 [conn18] command test_database.$cmd command: getLastError { getlasterror: 1, fsync: 1 } keyUpdates:0 numYields:0  reslen:106 276ms
>2014-08-28T13:03:27.698+0200 [conn18] dropDatabase foo starting
>2014-08-28T13:03:27.834+0200 [conn18] removeJournalFiles
>2014-08-28T13:03:27.953+0200 [conn18] dropDatabase foo finished
>2014-08-28T13:03:27.953+0200 [conn18] command foo.$cmd command: dropDatabase { dropDatabase: 1 } keyUpdates:0 numYields:0 locks(micros) W:255255 reslen:54 255ms
>2014-08-28T13:03:27.953+0200 [conn18] dropDatabase test_database starting
>2014-08-28T13:03:27.970+0200 [conn18] removeJournalFiles
>2014-08-28T13:03:28.014+0200 [conn18] dropDatabase test_database finished
>2014-08-28T13:03:28.015+0200 [conn18] dropDatabase test_database starting
>2014-08-28T13:03:28.029+0200 [conn18] removeJournalFiles
>2014-08-28T13:03:28.063+0200 [conn18] dropDatabase test_database finished
>2014-08-28T13:03:28.068+0200 [conn18] end connection 127.0.0.1:54163 (0 connections now open)
>2014-08-28T13:03:28.561+0200 [initandlisten] connection accepted from 127.0.0.1:54164 #19 (1 connection now open)
>2014-08-28T13:03:29.022+0200 [conn19] command test_database.$cmd command: eval { $eval: "function(x) { return "hello, "+x; }", args: [ "world" ] } keyUpdates:0 numYields:0 locks(micros) W:432595 reslen:62 432ms
>2014-08-28T13:03:29.024+0200 [conn19] SyntaxError: Unexpected string
>2014-08-28T13:03:29.050+0200 [conn19] dropDatabase test_database starting
>2014-08-28T13:03:29.059+0200 [conn19] removeJournalFiles
>2014-08-28T13:03:29.099+0200 [conn19] dropDatabase test_database finished
>2014-08-28T13:03:29.099+0200 [conn19] dropDatabase test_database starting
>2014-08-28T13:03:29.118+0200 [conn19] removeJournalFiles
>2014-08-28T13:03:29.144+0200 [conn19] dropDatabase test_database finished
>2014-08-28T13:03:29.148+0200 [conn19] end connection 127.0.0.1:54164 (0 connections now open)
>2014-08-28T13:03:29.631+0200 [initandlisten] connection accepted from 127.0.0.1:54165 #20 (1 connection now open)
>2014-08-28T13:03:29.636+0200 [FileAllocator] allocating new datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test.ns, filling with zeroes...
>2014-08-28T13:03:29.682+0200 [FileAllocator] done allocating datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test.ns, size: 16MB,  took 0.046 secs
>2014-08-28T13:03:29.684+0200 [FileAllocator] allocating new datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test.0, filling with zeroes...
>2014-08-28T13:03:29.733+0200 [FileAllocator] done allocating datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test.0, size: 64MB,  took 0.049 secs
>2014-08-28T13:03:29.734+0200 [conn20] build index on: test.test_coll properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test.test_coll" }
>2014-08-28T13:03:29.734+0200 [conn20] 	 added index to empty collection
>2014-08-28T13:03:29.860+0200 [conn20] CMD: drop test.test_coll
>2014-08-28T13:03:29.878+0200 [conn20] build index on: test.test_coll properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test.test_coll" }
>2014-08-28T13:03:29.878+0200 [conn20] 	 added index to empty collection
>2014-08-28T13:03:29.880+0200 [conn20] CMD: drop test.test_coll
>2014-08-28T13:03:29.882+0200 [conn20] build index on: test.some_coll properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test.some_coll" }
>2014-08-28T13:03:29.882+0200 [conn20] 	 added index to empty collection
>2014-08-28T13:03:29.883+0200 [conn20] build index on: test.test_coll properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test.test_coll" }
>2014-08-28T13:03:29.883+0200 [conn20] 	 added index to empty collection
>2014-08-28T13:03:29.886+0200 [conn20] CMD: drop test.test_coll
>2014-08-28T13:03:29.887+0200 [conn20] CMD: drop test.some_coll
>2014-08-28T13:03:29.889+0200 [conn20] build index on: test.test_coll properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test.test_coll" }
>2014-08-28T13:03:29.889+0200 [conn20] 	 added index to empty collection
>2014-08-28T13:03:29.891+0200 [conn20] CMD: drop test.test_coll
>2014-08-28T13:03:29.892+0200 [conn20] dropDatabase test_database starting
>2014-08-28T13:03:30.168+0200 [conn20] removeJournalFiles
>2014-08-28T13:03:30.269+0200 [conn20] dropDatabase test_database finished
>2014-08-28T13:03:30.269+0200 [conn20] command test_database.$cmd command: dropDatabase { dropDatabase: 1 } keyUpdates:0 numYields:0 locks(micros) W:377399 reslen:64 377ms
>2014-08-28T13:03:30.273+0200 [conn20] end connection 127.0.0.1:54165 (0 connections now open)
>2014-08-28T13:03:30.820+0200 [initandlisten] connection accepted from 127.0.0.1:54166 #21 (1 connection now open)
>2014-08-28T13:03:30.822+0200 [initandlisten] connection accepted from 127.0.0.1:54167 #22 (2 connections now open)
>2014-08-28T13:03:30.823+0200 [conn21] dropDatabase test_database starting
>2014-08-28T13:03:30.824+0200 [conn21] removeJournalFiles
>2014-08-28T13:03:30.857+0200 [conn21] dropDatabase test_database finished
>2014-08-28T13:03:30.857+0200 [conn22] end connection 127.0.0.1:54167 (1 connection now open)
>2014-08-28T13:03:30.861+0200 [conn21] end connection 127.0.0.1:54166 (0 connections now open)
>2014-08-28T13:03:31.311+0200 [initandlisten] connection accepted from 127.0.0.1:54168 #23 (1 connection now open)
>2014-08-28T13:03:31.314+0200 [conn23] dropDatabase test_database starting
>2014-08-28T13:03:31.318+0200 [conn23] removeJournalFiles
>2014-08-28T13:03:31.420+0200 [conn23] dropDatabase test_database finished
>2014-08-28T13:03:31.420+0200 [conn23] command test_database.$cmd command: dropDatabase { dropDatabase: 1 } keyUpdates:0 numYields:0 locks(micros) W:105391 reslen:64 105ms
>2014-08-28T13:03:31.421+0200 [FileAllocator] allocating new datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.ns, filling with zeroes...
>2014-08-28T13:03:31.453+0200 [FileAllocator] done allocating datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.ns, size: 16MB,  took 0.032 secs
>2014-08-28T13:03:31.455+0200 [FileAllocator] allocating new datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.0, filling with zeroes...
>2014-08-28T13:03:31.530+0200 [FileAllocator] done allocating datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.0, size: 64MB,  took 0.075 secs
>2014-08-28T13:03:31.532+0200 [conn23] build index on: test_database.test_collection properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test_collection" }
>2014-08-28T13:03:31.532+0200 [conn23] 	 added index to empty collection
>2014-08-28T13:03:31.532+0200 [conn23] insert test_database.test_collection ninserted:1 keyUpdates:0 numYields:0 locks(micros) w:111824 111ms
>2014-08-28T13:03:31.642+0200 [conn23] dropDatabase test_database starting
>2014-08-28T13:03:31.942+0200 [conn23] removeJournalFiles
>2014-08-28T13:03:32.014+0200 [conn23] dropDatabase test_database finished
>2014-08-28T13:03:32.014+0200 [conn23] command test_database.$cmd command: dropDatabase { dropDatabase: 1 } keyUpdates:0 numYields:0 locks(micros) W:371767 reslen:64 371ms
>2014-08-28T13:03:32.015+0200 [FileAllocator] allocating new datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.ns, filling with zeroes...
>2014-08-28T13:03:32.053+0200 [FileAllocator] done allocating datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.ns, size: 16MB,  took 0.038 secs
>2014-08-28T13:03:32.055+0200 [FileAllocator] allocating new datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.0, filling with zeroes...
>2014-08-28T13:03:32.088+0200 [FileAllocator] done allocating datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.0, size: 64MB,  took 0.032 secs
>2014-08-28T13:03:32.089+0200 [conn23] build index on: test_database.test_collection properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test_collection" }
>2014-08-28T13:03:32.089+0200 [conn23] 	 added index to empty collection
>2014-08-28T13:03:32.091+0200 [conn23] dropDatabase test_database starting
>2014-08-28T13:03:32.376+0200 [conn23] removeJournalFiles
>2014-08-28T13:03:32.756+0200 [conn23] dropDatabase test_database finished
>2014-08-28T13:03:32.756+0200 [conn23] command test_database.$cmd command: dropDatabase { dropDatabase: 1 } keyUpdates:0 numYields:0 locks(micros) W:664742 reslen:64 664ms
>2014-08-28T13:03:32.756+0200 [FileAllocator] allocating new datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.ns, filling with zeroes...
>2014-08-28T13:03:32.794+0200 [FileAllocator] done allocating datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.ns, size: 16MB,  took 0.037 secs
>2014-08-28T13:03:32.795+0200 [FileAllocator] allocating new datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.0, filling with zeroes...
>2014-08-28T13:03:32.812+0200 [FileAllocator] done allocating datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.0, size: 64MB,  took 0.016 secs
>2014-08-28T13:03:32.813+0200 [conn23] build index on: test_database.test_collection properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test_collection" }
>2014-08-28T13:03:32.813+0200 [conn23] 	 added index to empty collection
>2014-08-28T13:03:32.835+0200 [conn23] dropDatabase test_database starting
>2014-08-28T13:03:32.997+0200 [conn23] removeJournalFiles
>2014-08-28T13:03:33.053+0200 [conn23] dropDatabase test_database finished
>2014-08-28T13:03:33.053+0200 [conn23] command test_database.$cmd command: dropDatabase { dropDatabase: 1 } keyUpdates:0 numYields:0 locks(micros) W:218888 reslen:64 218ms
>2014-08-28T13:03:33.055+0200 [FileAllocator] allocating new datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.ns, filling with zeroes...
>2014-08-28T13:03:33.084+0200 [FileAllocator] done allocating datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.ns, size: 16MB,  took 0.029 secs
>2014-08-28T13:03:33.085+0200 [FileAllocator] allocating new datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.0, filling with zeroes...
>2014-08-28T13:03:33.101+0200 [FileAllocator] done allocating datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.0, size: 64MB,  took 0.015 secs
>2014-08-28T13:03:33.103+0200 [conn23] build index on: test_database.test_collection properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test_collection" }
>2014-08-28T13:03:33.103+0200 [conn23] 	 added index to empty collection
>2014-08-28T13:03:33.104+0200 [conn23] dropDatabase test_database starting
>2014-08-28T13:03:33.353+0200 [conn23] removeJournalFiles
>2014-08-28T13:03:33.408+0200 [conn23] dropDatabase test_database finished
>2014-08-28T13:03:33.408+0200 [conn23] command test_database.$cmd command: dropDatabase { dropDatabase: 1 } keyUpdates:0 numYields:0 locks(micros) W:304083 reslen:64 304ms
>2014-08-28T13:03:33.409+0200 [FileAllocator] allocating new datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.ns, filling with zeroes...
>2014-08-28T13:03:33.429+0200 [FileAllocator] done allocating datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.ns, size: 16MB,  took 0.02 secs
>2014-08-28T13:03:33.431+0200 [FileAllocator] allocating new datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.0, filling with zeroes...
>2014-08-28T13:03:33.447+0200 [FileAllocator] done allocating datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.0, size: 64MB,  took 0.015 secs
>2014-08-28T13:03:33.448+0200 [conn23] build index on: test_database.test_collection properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test_collection" }
>2014-08-28T13:03:33.448+0200 [conn23] 	 added index to empty collection
>2014-08-28T13:03:33.452+0200 [conn23] dropDatabase test_database starting
>2014-08-28T13:03:33.614+0200 [conn23] removeJournalFiles
>2014-08-28T13:03:33.670+0200 [conn23] dropDatabase test_database finished
>2014-08-28T13:03:33.670+0200 [conn23] command test_database.$cmd command: dropDatabase { dropDatabase: 1 } keyUpdates:0 numYields:0 locks(micros) W:218663 reslen:64 218ms
>2014-08-28T13:03:33.671+0200 [FileAllocator] allocating new datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.ns, filling with zeroes...
>2014-08-28T13:03:33.684+0200 [FileAllocator] done allocating datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.ns, size: 16MB,  took 0.013 secs
>2014-08-28T13:03:33.685+0200 [FileAllocator] allocating new datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.0, filling with zeroes...
>2014-08-28T13:03:33.701+0200 [FileAllocator] done allocating datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.0, size: 64MB,  took 0.015 secs
>2014-08-28T13:03:33.703+0200 [conn23] build index on: test_database.test_collection properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test_collection" }
>2014-08-28T13:03:33.703+0200 [conn23] 	 added index to empty collection
>2014-08-28T13:03:33.708+0200 [conn23] dropDatabase test_database starting
>2014-08-28T13:03:33.899+0200 [conn23] removeJournalFiles
>2014-08-28T13:03:33.956+0200 [conn23] dropDatabase test_database finished
>2014-08-28T13:03:33.956+0200 [conn23] command test_database.$cmd command: dropDatabase { dropDatabase: 1 } keyUpdates:0 numYields:0 locks(micros) W:247949 reslen:64 247ms
>2014-08-28T13:03:33.957+0200 [FileAllocator] allocating new datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.ns, filling with zeroes...
>2014-08-28T13:03:33.986+0200 [FileAllocator] done allocating datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.ns, size: 16MB,  took 0.028 secs
>2014-08-28T13:03:33.988+0200 [FileAllocator] allocating new datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.0, filling with zeroes...
>2014-08-28T13:03:34.004+0200 [FileAllocator] done allocating datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.0, size: 64MB,  took 0.016 secs
>2014-08-28T13:03:34.005+0200 [conn23] build index on: test_database.test_collection properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test_collection" }
>2014-08-28T13:03:34.005+0200 [conn23] 	 added index to empty collection
>2014-08-28T13:03:34.008+0200 [conn23] dropDatabase test_database starting
>2014-08-28T13:03:34.247+0200 [conn23] removeJournalFiles
>2014-08-28T13:03:34.401+0200 [conn23] dropDatabase test_database finished
>2014-08-28T13:03:34.401+0200 [conn23] command test_database.$cmd command: dropDatabase { dropDatabase: 1 } keyUpdates:0 numYields:0 locks(micros) W:393261 reslen:64 393ms
>2014-08-28T13:03:34.406+0200 [conn23] end connection 127.0.0.1:54168 (0 connections now open)
>2014-08-28T13:03:34.870+0200 [initandlisten] connection accepted from 127.0.0.1:54169 #24 (1 connection now open)
>2014-08-28T13:03:34.873+0200 [conn24] CMD fsync: sync:1 lock:0
>2014-08-28T13:03:34.879+0200 [conn24] CMD fsync: sync:0 lock:0
>2014-08-28T13:03:34.880+0200 [conn24] CMD fsync: sync:1 lock:1
>2014-08-28T13:03:34.880+0200 [fsyncLockWorker] removeJournalFiles
>2014-08-28T13:03:34.941+0200 [conn24] db is now locked for snapshotting, no writes allowed. db.fsyncUnlock() to unlock
>2014-08-28T13:03:34.941+0200 [conn24]     For more info see http://dochub.mongodb.org/core/fsynccommand
>2014-08-28T13:03:34.943+0200 [conn24] command: unlock requested
>2014-08-28T13:03:34.944+0200 [conn24] dropDatabase test_database starting
>2014-08-28T13:03:34.944+0200 [conn24] removeJournalFiles
>2014-08-28T13:03:34.966+0200 [conn24] dropDatabase test_database finished
>2014-08-28T13:03:34.971+0200 [conn24] end connection 127.0.0.1:54169 (0 connections now open)
>2014-08-28T13:03:35.478+0200 [initandlisten] connection accepted from 127.0.0.1:54170 #25 (1 connection now open)
>2014-08-28T13:03:35.487+0200 [FileAllocator] allocating new datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/foo.ns, filling with zeroes...
>2014-08-28T13:03:35.552+0200 [FileAllocator] done allocating datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/foo.ns, size: 16MB,  took 0.064 secs
>2014-08-28T13:03:35.553+0200 [FileAllocator] allocating new datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/foo.0, filling with zeroes...
>2014-08-28T13:03:35.644+0200 [FileAllocator] done allocating datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/foo.0, size: 64MB,  took 0.09 secs
>2014-08-28T13:03:35.645+0200 [conn25] build index on: foo.fs.files properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "foo.fs.files" }
>2014-08-28T13:03:35.645+0200 [conn25] 	 added index to empty collection
>2014-08-28T13:03:35.646+0200 [conn25] build index on: foo.fs.files properties: { v: 1, key: { filename: 1 }, name: "filename_1", ns: "foo.fs.files" }
>2014-08-28T13:03:35.646+0200 [conn25] 	 added index to empty collection
>2014-08-28T13:03:35.646+0200 [conn25] insert foo.system.indexes ninserted:1 keyUpdates:0 numYields:0 locks(micros) w:159400 159ms
>2014-08-28T13:03:35.808+0200 [conn25] build index on: foo.fs.chunks properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "foo.fs.chunks" }
>2014-08-28T13:03:35.808+0200 [conn25] 	 added index to empty collection
>2014-08-28T13:03:35.809+0200 [conn25] build index on: foo.fs.chunks properties: { v: 1, unique: true, key: { files_id: 1, n: 1 }, name: "files_id_1_n_1", ns: "foo.fs.chunks" }
>2014-08-28T13:03:35.809+0200 [conn25] 	 added index to empty collection
>2014-08-28T13:03:35.841+0200 [conn25] CMD: drop foo.fs.files
>2014-08-28T13:03:35.844+0200 [conn25] CMD: drop foo.fs.chunks
>2014-08-28T13:03:35.848+0200 [conn25] build index on: foo.bar.files properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "foo.bar.files" }
>2014-08-28T13:03:35.848+0200 [conn25] 	 added index to empty collection
>2014-08-28T13:03:35.849+0200 [conn25] build index on: foo.bar.files properties: { v: 1, key: { filename: 1 }, name: "filename_1", ns: "foo.bar.files" }
>2014-08-28T13:03:35.849+0200 [conn25] 	 added index to empty collection
>2014-08-28T13:03:35.851+0200 [conn25] build index on: foo.bar.chunks properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "foo.bar.chunks" }
>2014-08-28T13:03:35.851+0200 [conn25] 	 added index to empty collection
>2014-08-28T13:03:35.851+0200 [conn25] build index on: foo.bar.chunks properties: { v: 1, unique: true, key: { files_id: 1, n: 1 }, name: "files_id_1_n_1", ns: "foo.bar.chunks" }
>2014-08-28T13:03:35.851+0200 [conn25] 	 added index to empty collection
>2014-08-28T13:03:36.004+0200 [conn25] build index on: foo.fs.chunks properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "foo.fs.chunks" }
>2014-08-28T13:03:36.004+0200 [conn25] 	 added index to empty collection
>2014-08-28T13:03:36.005+0200 [conn25] dropDatabase foo starting
>2014-08-28T13:03:36.188+0200 [conn25] removeJournalFiles
>2014-08-28T13:03:36.259+0200 [conn25] dropDatabase foo finished
>2014-08-28T13:03:36.259+0200 [conn25] command foo.$cmd command: dropDatabase { dropDatabase: 1 } keyUpdates:0 numYields:0 locks(micros) W:253487 reslen:54 253ms
>2014-08-28T13:03:36.259+0200 [conn25] dropDatabase test_database starting
>2014-08-28T13:03:36.260+0200 [conn25] removeJournalFiles
>2014-08-28T13:03:36.282+0200 [conn25] dropDatabase test_database finished
>2014-08-28T13:03:36.287+0200 [conn25] end connection 127.0.0.1:54170 (0 connections now open)
>2014-08-28T13:03:36.749+0200 [initandlisten] connection accepted from 127.0.0.1:54189 #26 (1 connection now open)
>2014-08-28T13:03:36.751+0200 [conn26] dropDatabase test_database starting
>2014-08-28T13:03:36.751+0200 [conn26] removeJournalFiles
>2014-08-28T13:03:36.774+0200 [conn26] dropDatabase test_database finished
>2014-08-28T13:03:36.775+0200 [FileAllocator] allocating new datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.ns, filling with zeroes...
>2014-08-28T13:03:36.791+0200 [FileAllocator] done allocating datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.ns, size: 16MB,  took 0.016 secs
>2014-08-28T13:03:36.793+0200 [FileAllocator] allocating new datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.0, filling with zeroes...
>2014-08-28T13:03:36.809+0200 [FileAllocator] done allocating datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/test_database.0, size: 64MB,  took 0.015 secs
>2014-08-28T13:03:36.810+0200 [conn26] build index on: test_database.test_collection properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "test_database.test_collection" }
>2014-08-28T13:03:36.810+0200 [conn26] 	 added index to empty collection
>2014-08-28T13:03:36.812+0200 [conn26] dropDatabase test_database starting
>2014-08-28T13:03:37.003+0200 [conn26] removeJournalFiles
>2014-08-28T13:03:37.091+0200 [conn26] dropDatabase test_database finished
>2014-08-28T13:03:37.091+0200 [conn26] command test_database.$cmd command: dropDatabase { dropDatabase: 1 } keyUpdates:0 numYields:0 locks(micros) W:278404 reslen:64 278ms
>2014-08-28T13:03:37.095+0200 [conn26] end connection 127.0.0.1:54189 (0 connections now open)
>2014-08-28T13:03:37.559+0200 [initandlisten] connection accepted from 127.0.0.1:54190 #27 (1 connection now open)
>2014-08-28T13:03:37.560+0200 [conn27] CMD: drop moo.kooh
>2014-08-28T13:03:37.611+0200 [initandlisten] connection accepted from 127.0.0.1:54191 #28 (2 connections now open)
>2014-08-28T13:03:37.611+0200 [FileAllocator] allocating new datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/moo.ns, filling with zeroes...
>2014-08-28T13:03:37.630+0200 [FileAllocator] done allocating datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/moo.ns, size: 16MB,  took 0.019 secs
>2014-08-28T13:03:37.632+0200 [FileAllocator] allocating new datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/moo.0, filling with zeroes...
>2014-08-28T13:03:37.648+0200 [FileAllocator] done allocating datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/moo.0, size: 64MB,  took 0.015 secs
>2014-08-28T13:03:37.649+0200 [conn28] build index on: moo.kooh properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "moo.kooh" }
>2014-08-28T13:03:37.650+0200 [conn28] 	 added index to empty collection
>2014-08-28T13:03:37.650+0200 [conn28] end connection 127.0.0.1:54191 (1 connection now open)
>2014-08-28T13:03:37.723+0200 [initandlisten] connection accepted from 127.0.0.1:54192 #29 (2 connections now open)
>2014-08-28T13:03:37.774+0200 [initandlisten] connection accepted from 127.0.0.1:54198 #30 (3 connections now open)
>2014-08-28T13:03:37.824+0200 [initandlisten] connection accepted from 127.0.0.1:54209 #31 (4 connections now open)
>2014-08-28T13:03:37.873+0200 [initandlisten] connection accepted from 127.0.0.1:54224 #32 (5 connections now open)
>2014-08-28T13:03:37.925+0200 [initandlisten] connection accepted from 127.0.0.1:54233 #33 (6 connections now open)
>2014-08-28T13:03:37.975+0200 [initandlisten] connection accepted from 127.0.0.1:54239 #34 (7 connections now open)
>2014-08-28T13:03:38.025+0200 [initandlisten] connection accepted from 127.0.0.1:54240 #35 (8 connections now open)
>2014-08-28T13:03:38.075+0200 [initandlisten] connection accepted from 127.0.0.1:54241 #36 (9 connections now open)
>2014-08-28T13:03:38.126+0200 [initandlisten] connection accepted from 127.0.0.1:54242 #37 (10 connections now open)
>2014-08-28T13:03:38.175+0200 [conn29] end connection 127.0.0.1:54192 (9 connections now open)
>2014-08-28T13:03:38.175+0200 [initandlisten] connection accepted from 127.0.0.1:54243 #38 (10 connections now open)
>2014-08-28T13:03:38.201+0200 [conn30] end connection 127.0.0.1:54198 (9 connections now open)
>2014-08-28T13:03:38.228+0200 [conn31] end connection 127.0.0.1:54209 (8 connections now open)
>2014-08-28T13:03:38.253+0200 [conn32] end connection 127.0.0.1:54224 (7 connections now open)
>2014-08-28T13:03:38.279+0200 [conn33] end connection 127.0.0.1:54233 (6 connections now open)
>2014-08-28T13:03:38.305+0200 [conn34] end connection 127.0.0.1:54239 (5 connections now open)
>2014-08-28T13:03:38.330+0200 [conn35] end connection 127.0.0.1:54240 (4 connections now open)
>2014-08-28T13:03:38.357+0200 [conn36] end connection 127.0.0.1:54241 (3 connections now open)
>2014-08-28T13:03:38.382+0200 [conn37] end connection 127.0.0.1:54242 (2 connections now open)
>2014-08-28T13:03:38.408+0200 [conn38] end connection 127.0.0.1:54243 (1 connection now open)
>2014-08-28T13:03:38.438+0200 [conn27] dropDatabase moo starting
>2014-08-28T13:03:38.533+0200 [conn27] removeJournalFiles
>2014-08-28T13:03:38.588+0200 [conn27] dropDatabase moo finished
>2014-08-28T13:03:38.588+0200 [conn27] command moo.$cmd command: dropDatabase { dropDatabase: 1 } keyUpdates:0 numYields:0 locks(micros) W:149745 reslen:54 149ms
>2014-08-28T13:03:38.588+0200 [conn27] end connection 127.0.0.1:54190 (0 connections now open)
>2014-08-28T13:03:39.076+0200 [initandlisten] connection accepted from 127.0.0.1:54286 #39 (1 connection now open)
>2014-08-28T13:03:39.078+0200 [conn39] CMD: drop affe.tiger
>2014-08-28T13:03:39.078+0200 [FileAllocator] allocating new datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/affe.ns, filling with zeroes...
>2014-08-28T13:03:39.111+0200 [FileAllocator] done allocating datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/affe.ns, size: 16MB,  took 0.032 secs
>2014-08-28T13:03:39.112+0200 [FileAllocator] allocating new datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/affe.0, filling with zeroes...
>2014-08-28T13:03:39.128+0200 [FileAllocator] done allocating datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/affe.0, size: 64MB,  took 0.015 secs
>2014-08-28T13:03:39.129+0200 [conn39] build index on: affe.tiger properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "affe.tiger" }
>2014-08-28T13:03:39.129+0200 [conn39] 	 added index to empty collection
>2014-08-28T13:03:39.322+0200 [initandlisten] connection accepted from 127.0.0.1:54287 #40 (2 connections now open)
>2014-08-28T13:03:39.322+0200 [conn40] end connection 127.0.0.1:54287 (1 connection now open)
>2014-08-28T13:03:40.145+0200 [initandlisten] connection accepted from 127.0.0.1:54288 #41 (2 connections now open)
>2014-08-28T13:03:40.191+0200 [initandlisten] connection accepted from 127.0.0.1:54289 #42 (3 connections now open)
>2014-08-28T13:03:40.237+0200 [initandlisten] connection accepted from 127.0.0.1:54290 #43 (4 connections now open)
>2014-08-28T13:03:40.282+0200 [initandlisten] connection accepted from 127.0.0.1:54291 #44 (5 connections now open)
>2014-08-28T13:03:40.328+0200 [initandlisten] connection accepted from 127.0.0.1:54292 #45 (6 connections now open)
>2014-08-28T13:03:40.376+0200 [initandlisten] connection accepted from 127.0.0.1:54298 #46 (7 connections now open)
>2014-08-28T13:03:40.422+0200 [initandlisten] connection accepted from 127.0.0.1:54300 #47 (8 connections now open)
>2014-08-28T13:03:40.468+0200 [initandlisten] connection accepted from 127.0.0.1:54311 #48 (9 connections now open)
>2014-08-28T13:03:40.514+0200 [initandlisten] connection accepted from 127.0.0.1:54313 #49 (10 connections now open)
>2014-08-28T13:03:40.562+0200 [initandlisten] connection accepted from 127.0.0.1:54314 #50 (11 connections now open)
>2014-08-28T13:03:40.562+0200 [conn41] end connection 127.0.0.1:54288 (10 connections now open)
>2014-08-28T13:03:40.588+0200 [conn42] end connection 127.0.0.1:54289 (9 connections now open)
>2014-08-28T13:03:40.614+0200 [conn43] end connection 127.0.0.1:54290 (8 connections now open)
>2014-08-28T13:03:40.641+0200 [conn44] end connection 127.0.0.1:54291 (7 connections now open)
>2014-08-28T13:03:40.668+0200 [conn45] end connection 127.0.0.1:54292 (6 connections now open)
>2014-08-28T13:03:40.693+0200 [conn46] end connection 127.0.0.1:54298 (5 connections now open)
>2014-08-28T13:03:40.719+0200 [conn47] end connection 127.0.0.1:54300 (4 connections now open)
>2014-08-28T13:03:40.746+0200 [conn48] end connection 127.0.0.1:54311 (3 connections now open)
>2014-08-28T13:03:40.772+0200 [conn49] end connection 127.0.0.1:54313 (2 connections now open)
>2014-08-28T13:03:40.797+0200 [conn50] end connection 127.0.0.1:54314 (1 connection now open)
>2014-08-28T13:03:40.826+0200 [conn39] dropDatabase affe starting
>2014-08-28T13:03:40.913+0200 [conn39] removeJournalFiles
>2014-08-28T13:03:40.959+0200 [conn39] dropDatabase affe finished
>2014-08-28T13:03:40.959+0200 [conn39] command affe.$cmd command: dropDatabase { dropDatabase: 1 } keyUpdates:0 numYields:0 locks(micros) W:132183 reslen:55 132ms
>2014-08-28T13:03:40.965+0200 [conn39] end connection 127.0.0.1:54286 (0 connections now open)
>2014-08-28T13:03:42.743+0200 [initandlisten] connection accepted from 127.0.0.1:54336 #51 (1 connection now open)
>2014-08-28T13:03:42.798+0200 [conn51] CMD: drop x.y
>2014-08-28T13:03:43.803+0200 [FileAllocator] allocating new datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/x.ns, filling with zeroes...
>2014-08-28T13:03:43.824+0200 [FileAllocator] done allocating datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/x.ns, size: 16MB,  took 0.02 secs
>2014-08-28T13:03:43.825+0200 [FileAllocator] allocating new datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/x.0, filling with zeroes...
>2014-08-28T13:03:43.841+0200 [FileAllocator] done allocating datafile /builddir/build/BUILD/MongoDB-0.702.2/test_db/x.0, size: 64MB,  took 0.015 secs
>2014-08-28T13:03:43.843+0200 [conn51] build index on: x.y properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "x.y" }
>2014-08-28T13:03:43.843+0200 [conn51] 	 added index to empty collection
>2014-08-28T13:03:43.915+0200 [conn51] CMD: drop x.y
>2014-08-28T13:03:43.917+0200 [conn51] build index on: x.y properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "x.y" }
>2014-08-28T13:03:43.917+0200 [conn51] 	 added index to empty collection
>2014-08-28T13:03:43.918+0200 [conn51] CMD: drop x.y
>2014-08-28T13:03:43.919+0200 [conn51] build index on: x.y properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "x.y" }
>2014-08-28T13:03:43.919+0200 [conn51] 	 added index to empty collection
>2014-08-28T13:03:43.922+0200 [conn51] CMD: drop x.y
>2014-08-28T13:03:43.923+0200 [conn51] build index on: x.y properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "x.y" }
>2014-08-28T13:03:43.923+0200 [conn51] 	 added index to empty collection
>2014-08-28T13:03:43.968+0200 [conn51] CMD: drop x.y
>2014-08-28T13:03:43.970+0200 [conn51] build index on: x.y properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "x.y" }
>2014-08-28T13:03:43.970+0200 [conn51] 	 added index to empty collection
>2014-08-28T13:03:43.971+0200 [conn51] CMD: drop x.y
>2014-08-28T13:03:43.971+0200 [conn51] build index on: x.y properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "x.y" }
>2014-08-28T13:03:43.971+0200 [conn51] 	 added index to empty collection
>2014-08-28T13:03:43.973+0200 [conn51] CMD: drop x.y
>2014-08-28T13:03:43.974+0200 [conn51] build index on: x.y properties: { v: 1, key: { _id: 1 }, name: "_id_", ns: "x.y" }
>2014-08-28T13:03:43.974+0200 [conn51] 	 added index to empty collection
>2014-08-28T13:03:43.976+0200 [conn51] dropDatabase x starting
>2014-08-28T13:03:44.077+0200 [conn51] removeJournalFiles
>2014-08-28T13:03:44.131+0200 [conn51] dropDatabase x finished
>2014-08-28T13:03:44.131+0200 [conn51] command x.$cmd command: dropDatabase { dropDatabase: 1 } keyUpdates:0 numYields:0 locks(micros) W:154827 reslen:52 154ms
>2014-08-28T13:03:44.132+0200 [conn51] dropDatabase test_database starting
>2014-08-28T13:03:44.132+0200 [conn51] removeJournalFiles
>2014-08-28T13:03:44.145+0200 [conn51] dropDatabase test_database finished
>2014-08-28T13:03:44.149+0200 [conn51] end connection 127.0.0.1:54336 (0 connections now open)
>2014-08-28T13:03:44.606+0200 [initandlisten] connection accepted from 127.0.0.1:54337 #52 (1 connection now open)
>2014-08-28T13:03:44.609+0200 [conn52] dropDatabase test_database starting
>2014-08-28T13:03:44.610+0200 [conn52] removeJournalFiles
>2014-08-28T13:03:44.628+0200 [conn52] dropDatabase test_database finished
>2014-08-28T13:03:44.632+0200 [conn52] end connection 127.0.0.1:54337 (0 connections now open)
>2014-08-28T13:03:44.658+0200 [signalProcessingThread] got signal 15 (Terminated), will terminate after current cmd ends
>2014-08-28T13:03:44.658+0200 [signalProcessingThread] now exiting
>2014-08-28T13:03:44.658+0200 [signalProcessingThread] dbexit: 
>2014-08-28T13:03:44.658+0200 [signalProcessingThread] shutdown: going to close listening sockets...
>2014-08-28T13:03:44.658+0200 [signalProcessingThread] closing listening socket: 8
>2014-08-28T13:03:44.658+0200 [signalProcessingThread] closing listening socket: 9
>2014-08-28T13:03:44.659+0200 [signalProcessingThread] removing socket file: /tmp/mongodb-27017.sock
>2014-08-28T13:03:44.659+0200 [signalProcessingThread] shutdown: going to flush diaglog...
>2014-08-28T13:03:44.659+0200 [signalProcessingThread] shutdown: going to close sockets...
>2014-08-28T13:03:44.659+0200 [signalProcessingThread] shutdown: waiting for fs preallocator...
>2014-08-28T13:03:44.659+0200 [signalProcessingThread] shutdown: lock for final commit...
>2014-08-28T13:03:44.659+0200 [signalProcessingThread] shutdown: final commit...
>2014-08-28T13:03:44.659+0200 [signalProcessingThread] shutdown: closing all files...
>2014-08-28T13:03:44.659+0200 [signalProcessingThread] closeAllFiles() finished
>2014-08-28T13:03:44.659+0200 [signalProcessingThread] journalCleanup...
>2014-08-28T13:03:44.659+0200 [signalProcessingThread] removeJournalFiles
>chyby sestavenÃ RPM:
>+ exit 2
>chyba: Å patnÃ½ nÃ¡vratovÃ½ kÃ³d z /var/tmp/rpm-tmp.YEzy4n (%check)
>    Å patnÃ½ nÃ¡vratovÃ½ kÃ³d z /var/tmp/rpm-tmp.YEzy4n (%check)
>Child return code was: 1
>EXCEPTION: Command failed. See logs for output.
> # ['bash', '--login', '-c', 'rpmbuild -bb --target x86_64 --nodeps  builddir/build/SPECS/perl-MongoDB.spec']
>Traceback (most recent call last):
>  File "/usr/lib/python2.7/site-packages/mockbuild/trace_decorator.py", line 70, in trace
>    result = func(*args, **kw)
>  File "/usr/lib/python2.7/site-packages/mockbuild/util.py", line 378, in do
>    raise mockbuild.exception.Error, ("Command failed. See logs for output.\n # %s" % (command,), child.returncode)
>Error: Command failed. See logs for output.
> # ['bash', '--login', '-c', 'rpmbuild -bb --target x86_64 --nodeps  builddir/build/SPECS/perl-MongoDB.spec']
>LEAVE do --> EXCEPTION RAISED
>

Actions: View

Attachments on bug 1134882: 931912 | 1038081