[SERVER-7925] jstests/slowNightly/command_line_parsing.js failing - MongoDB Jira

XML

Word

Printable

Details

Type: Bug
Status: Closed
Priority: Major - P3
Resolution: Fixed
Affects Version/s: None
Fix Version/s: 2.3.2
Component/s: Testing Infrastructure
Labels:
- buildbot

Operating System:
ALL

Description

http://buildlogs.mongodb.org/Linux%2064-bit%20DEBUG/builds/1778/test/slow%20nightly/command_line_parsing.js

Thu Dec 13 07:59:41.560 [conn15] CMD: drop test.jstests_capped4

Thu Dec 13 07:59:41.569 [conn15] build index test.jstests_capped4 { _id: 1 }

Thu Dec 13 07:59:41.570 [conn15] build index done.  scanned 0 total records. 0.001 secs

Thu Dec 13 07:59:41.580 [conn15] build index test.jstests_capped4 { i: 1.0 }

Thu Dec 13 07:59:41.581 [conn15] build index done.  scanned 0 total records. 0.001 secs

Thu Dec 13 07:59:42.114 [conn15] CMD: validate test.jstests_capped4

Thu Dec 13 07:59:42.114 [conn15] validating index 0: test.jstests_capped4.$_id_

Thu Dec 13 07:59:42.114 [conn15] validating index 1: test.jstests_capped4.$i_1

Thu Dec 13 07:59:42.119 [conn15] opening db:  admin

Thu Dec 13 07:59:42.119 [conn15] DatabaseHolder::closeAll path:/data/db/sconsTests/

Thu Dec 13 07:59:42.165 [conn15] end connection 127.0.0.1:43793 (0 connections now open)

Thu Dec 13 07:59:42.165 [conn15] thread conn15 stack usage was 24888 bytes,  which is the most so far

Thu Dec 13 07:59:42.334 [initandlisten] connection accepted from 127.0.0.1:43800 #16 (1 connection now open)

Thu Dec 13 07:59:42.334 [conn16] end connection 127.0.0.1:43800 (0 connections now open)

MongoDB shell version: 2.3.2-pre-

Thu Dec 13 07:59:43.136 [initandlisten] connection accepted from 127.0.0.1:43805 #17 (1 connection now open)

connecting to: 127.0.0.1:27999/test

null

startMongod WARNING DELETES DATA DIRECTORY THIS IS FOR TESTING ONLY

Thu Dec 13 07:59:43.156 shell: started program /home/yellow/buildslave/Linux_64bit_DEBUG/mongo/mongod --port 31000 --dbpath /data/db/jstests_slowNightly_command_line_parsing --notablescan --setParameter enableTestCommands=1

 m31000| Thu Dec 13 07:59:43.229 [initandlisten] MongoDB starting : pid=16074 port=31000 dbpath=/data/db/jstests_slowNightly_command_line_parsing 64-bit host=SERVER04

 m31000| Thu Dec 13 07:59:43.229 [initandlisten] _DEBUG build (which is slower)

 m31000| Thu Dec 13 07:59:43.229 [initandlisten]

 m31000| Thu Dec 13 07:59:43.229 [initandlisten] ** NOTE: This is a development version (2.3.2-pre-) of MongoDB.

 m31000| Thu Dec 13 07:59:43.229 [initandlisten] **       Not recommended for production.

 m31000| Thu Dec 13 07:59:43.229 [initandlisten]

 m31000| Thu Dec 13 07:59:43.229 [initandlisten] db version v2.3.2-pre-, pdfile version 4.5

 m31000| Thu Dec 13 07:59:43.229 [initandlisten] git version: 725f626aae2c2701ded3c0f97e7b5aa4c0b65979

 m31000| Thu Dec 13 07:59:43.229 [initandlisten] build info: Linux SERVER04 2.6.35-22-server #33-Ubuntu SMP Sun Sep 19 20:48:58 UTC 2010 x86_64 BOOST_LIB_VERSION=1_49

 m31000| Thu Dec 13 07:59:43.229 [initandlisten] options: { dbpath: "/data/db/jstests_slowNightly_command_line_parsing", notablescan: true, port: 31000, setParameter: [ "enableTestCommands=1" ] }

 m31000| Thu Dec 13 07:59:43.231 [initandlisten] journal dir=/data/db/jstests_slowNightly_command_line_parsing/journal

 m31000| Thu Dec 13 07:59:43.231 [initandlisten] recover : no journal files present, no recovery needed

 m31000| Thu Dec 13 07:59:43.252 [initandlisten] opening db:  local

 m31000| Thu Dec 13 07:59:43.270 [initandlisten]

 m31000| debug have W lock but w would suffice for command create

 m31000| Thu Dec 13 07:59:43.270 [FileAllocator] allocating new datafile /data/db/jstests_slowNightly_command_line_parsing/local.ns, filling with zeroes...

 m31000| Thu Dec 13 07:59:43.270 [FileAllocator] creating directory /data/db/jstests_slowNightly_command_line_parsing/_tmp

 m31000| Thu Dec 13 07:59:43.271 [FileAllocator] done allocating datafile /data/db/jstests_slowNightly_command_line_parsing/local.ns, size: 16MB,  took 0 secs

 m31000| Thu Dec 13 07:59:43.271 [FileAllocator] allocating new datafile /data/db/jstests_slowNightly_command_line_parsing/local.0, filling with zeroes...

 m31000| Thu Dec 13 07:59:43.272 [FileAllocator] done allocating datafile /data/db/jstests_slowNightly_command_line_parsing/local.0, size: 64MB,  took 0 secs

 m31000| Thu Dec 13 07:59:43.272 [initandlisten] datafileheader::init initializing /data/db/jstests_slowNightly_command_line_parsing/local.0 n:0

 m31000| Thu Dec 13 07:59:43.275 [initandlisten] info PageFaultRetryableSection will not yield, already locked upon reaching

 m31000| Thu Dec 13 07:59:43.276 [initandlisten] waiting for connections on port 31000

 m31000| Thu Dec 13 07:59:43.276 [websvr] admin web console waiting for connections on port 32000

 m31000| Thu Dec 13 07:59:43.278 [IndexRebuilder] thread IndexRebuilder stack usage was 7168 bytes,  which is the most so far

 m31000| Thu Dec 13 07:59:43.361 [initandlisten] connection accepted from 127.0.0.1:47954 #1 (1 connection now open)

 m31000| Thu Dec 13 07:59:43.370 [conn1] opening db:  jstests_slowNightly_command_line_parsing

 m31000| Thu Dec 13 07:59:43.370 [FileAllocator] allocating new datafile /data/db/jstests_slowNightly_command_line_parsing/jstests_slowNightly_command_line_parsing.ns, filling with zeroes...

 m31000| Thu Dec 13 07:59:43.371 [FileAllocator] done allocating datafile /data/db/jstests_slowNightly_command_line_parsing/jstests_slowNightly_command_line_parsing.ns, size: 16MB,  took 0 secs

 m31000| Thu Dec 13 07:59:43.371 [FileAllocator] allocating new datafile /data/db/jstests_slowNightly_command_line_parsing/jstests_slowNightly_command_line_parsing.0, filling with zeroes...

 m31000| Thu Dec 13 07:59:43.371 [FileAllocator] done allocating datafile /data/db/jstests_slowNightly_command_line_parsing/jstests_slowNightly_command_line_parsing.0, size: 64MB,  took 0 secs

 m31000| Thu Dec 13 07:59:43.372 [conn1] datafileheader::init initializing /data/db/jstests_slowNightly_command_line_parsing/jstests_slowNightly_command_line_parsing.0 n:0

 m31000| Thu Dec 13 07:59:43.372 [FileAllocator] allocating new datafile /data/db/jstests_slowNightly_command_line_parsing/jstests_slowNightly_command_line_parsing.1, filling with zeroes...

 m31000| Thu Dec 13 07:59:43.372 [FileAllocator] done allocating datafile /data/db/jstests_slowNightly_command_line_parsing/jstests_slowNightly_command_line_parsing.1, size: 128MB,  took 0 secs

 m31000| Thu Dec 13 07:59:43.376 [conn1] build index jstests_slowNightly_command_line_parsing.jstests_slowNightly_command_line_parsing { _id: 1 }

 m31000| Thu Dec 13 07:59:43.378 [conn1] build index done.  scanned 0 total records. 0.002 secs

 m31000| Thu Dec 13 07:59:43.380 [conn1] assertion 10111 table scans not allowed:jstests_slowNightly_command_line_parsing.jstests_slowNightly_command_line_parsing ns:jstests_slowNightly_command_line_parsing.jstests_slowNightly_command_line_parsing query:{ a: 1.0 }

 m31000| Thu Dec 13 07:59:43.380 [conn1] problem detected during query over jstests_slowNightly_command_line_parsing.jstests_slowNightly_command_line_parsing : { $err: "table scans not allowed:jstests_slowNightly_command_line_parsing.jstests_slowNightly_command_line_parsing", code: 10111 }

startMongod WARNING DELETES DATA DIRECTORY THIS IS FOR TESTING ONLY

Thu Dec 13 07:59:43.391 shell: started program /home/yellow/buildslave/Linux_64bit_DEBUG/mongo/mongod --port 31002 --dbpath /data/db/jstests_slowNightly_command_line_parsing2 --config jstests/libs/testconfig --setParameter enableTestCommands=1

 m31002| warning "fastsync" should not be put in your configuration file

 m31002| warning: remove or comment out this line by starting it with '#', skipping now : version = false

 m31002| Thu Dec 13 07:59:43.469 [initandlisten] MongoDB starting : pid=16090 port=31002 dbpath=/data/db/jstests_slowNightly_command_line_parsing2 64-bit host=SERVER04

 m31002| Thu Dec 13 07:59:43.469 [initandlisten] _DEBUG build (which is slower)

 m31002| Thu Dec 13 07:59:43.469 [initandlisten]

 m31002| Thu Dec 13 07:59:43.469 [initandlisten] ** NOTE: This is a development version (2.3.2-pre-) of MongoDB.

 m31002| Thu Dec 13 07:59:43.469 [initandlisten] **       Not recommended for production.

 m31002| Thu Dec 13 07:59:43.469 [initandlisten]

 m31002| Thu Dec 13 07:59:43.469 [initandlisten] db version v2.3.2-pre-, pdfile version 4.5

 m31002| Thu Dec 13 07:59:43.469 [initandlisten] git version: 725f626aae2c2701ded3c0f97e7b5aa4c0b65979

 m31002| Thu Dec 13 07:59:43.469 [initandlisten] build info: Linux SERVER04 2.6.35-22-server #33-Ubuntu SMP Sun Sep 19 20:48:58 UTC 2010 x86_64 BOOST_LIB_VERSION=1_49

 m31002| Thu Dec 13 07:59:43.469 [initandlisten] options: { config: "jstests/libs/testconfig", dbpath: "/data/db/jstests_slowNightly_command_line_parsing2", fastsync: "true", port: 31002, setParameter: [ "enableTestCommands=1" ] }

 m31002| Thu Dec 13 07:59:43.470 [initandlisten] journal dir=/data/db/jstests_slowNightly_command_line_parsing2/journal

 m31002| Thu Dec 13 07:59:43.470 [initandlisten] recover : no journal files present, no recovery needed

 m31002| Thu Dec 13 07:59:43.491 [initandlisten] opening db:  local

 m31002| Thu Dec 13 07:59:43.509 [initandlisten]

 m31002| debug have W lock but w would suffice for command create

 m31002| Thu Dec 13 07:59:43.510 [FileAllocator] allocating new datafile /data/db/jstests_slowNightly_command_line_parsing2/local.ns, filling with zeroes...

 m31002| Thu Dec 13 07:59:43.510 [FileAllocator] creating directory /data/db/jstests_slowNightly_command_line_parsing2/_tmp

 m31002| Thu Dec 13 07:59:43.511 [FileAllocator] done allocating datafile /data/db/jstests_slowNightly_command_line_parsing2/local.ns, size: 16MB,  took 0 secs

 m31002| Thu Dec 13 07:59:43.511 [FileAllocator] allocating new datafile /data/db/jstests_slowNightly_command_line_parsing2/local.0, filling with zeroes...

 m31002| Thu Dec 13 07:59:43.511 [FileAllocator] done allocating datafile /data/db/jstests_slowNightly_command_line_parsing2/local.0, size: 64MB,  took 0 secs

 m31002| Thu Dec 13 07:59:43.512 [initandlisten] datafileheader::init initializing /data/db/jstests_slowNightly_command_line_parsing2/local.0 n:0

 m31002| Thu Dec 13 07:59:43.515 [initandlisten] info PageFaultRetryableSection will not yield, already locked upon reaching

 m31002| Thu Dec 13 07:59:43.516 [initandlisten] waiting for connections on port 31002

 m31002| Thu Dec 13 07:59:43.516 [websvr] admin web console waiting for connections on port 32002

 m31002| Thu Dec 13 07:59:43.518 [IndexRebuilder] thread IndexRebuilder stack usage was 7168 bytes,  which is the most so far

 m31002| Thu Dec 13 07:59:43.593 [initandlisten] connection accepted from 127.0.0.1:59642 #1 (1 connection now open)

assert failed

Error: Printing Stack Trace

    at printStackTrace (src/mongo/shell/utils.js:37:7)

    at doassert (src/mongo/shell/utils.js:58:1)

    at assert (src/mongo/shell/utils.js:66:1)

    at /home/yellow/buildslave/Linux_64bit_DEBUG/mongo/jstests/slowNightly/command_line_parsing.js:21:1

Thu Dec 13 07:59:43.629 exec error: src/mongo/shell/utils.js:59 assert failed

throw msg;

failed to load: /home/yellow/buildslave/Linux_64bit_DEBUG/mongo/jstests/slowNightly/command_line_parsing.js

Thu Dec 13 07:59:45.633 [conn17] end connection 127.0.0.1:43805 (0 connections now open)

Thu Dec 13 07:59:45.924 got signal 15 (Terminated), will terminate after current cmd ends

Thu Dec 13 07:59:45.925 [interruptThread] now exiting

Thu Dec 13 07:59:45.925 dbexit:

Thu Dec 13 07:59:45.925 [interruptThread] shutdown: going to close listening sockets...

Thu Dec 13 07:59:45.925 [interruptThread] closing listening socket: 10

Thu Dec 13 07:59:45.925 [interruptThread] closing listening socket: 11

Thu Dec 13 07:59:45.925 [interruptThread] closing listening socket: 13

Thu Dec 13 07:59:45.925 [interruptThread] removing socket file: /tmp/mongodb-27999.sock

Thu Dec 13 07:59:45.925 [interruptThread] shutdown: going to flush diaglog...

Thu Dec 13 07:59:45.925 [interruptThread] shutdown: going to close sockets...

Thu Dec 13 07:59:45.925 [interruptThread] shutdown: waiting for fs preallocator...

Thu Dec 13 07:59:45.925 [interruptThread] shutdown: lock for final commit...

Thu Dec 13 07:59:45.925 [interruptThread] shutdown: final commit...

Thu Dec 13 07:59:45.925 [interruptThread] shutdown: closing all files...

Thu Dec 13 07:59:45.925 [interruptThread] closeAllFiles() finished

Thu Dec 13 07:59:45.925 [interruptThread] journalCleanup...

Thu Dec 13 07:59:45.925 [interruptThread] removeJournalFiles

Thu Dec 13 07:59:45.934 [interruptThread] shutdown: removing fs lock...

Thu Dec 13 07:59:45.934 dbexit: really exiting now

The test doesn't display what it got back that wasn't equal to what it expected:

// validate command line parameter parsing

port = allocatePorts( 1 )[ 0 ];

var baseName = "jstests_slowNightly_command_line_parsing";

// test notablescan

var m = startMongod( "--port", port, "--dbpath", "/data/db/" + baseName, "--notablescan" );

m.getDB( baseName ).getCollection( baseName ).save( {a:1} );

assert.throws( function() { m.getDB( baseName ).getCollection( baseName ).find( {a:1} ).toArray() } );

// test config file

var m2 = startMongod( "--port", port+2, "--dbpath", "/data/db/" + baseName +"2", "--config", "jstests/libs/testconfig");

var m2result = {

    "parsed" : {

        "config" : "jstests/libs/testconfig",

        "dbpath" : "/data/db/jstests_slowNightly_command_line_parsing2",

        "fastsync" : "true",

        "port" : 31002

};

assert( friendlyEqual(m2result.parsed, m2.getDB("admin").runCommand( "getCmdLineOpts" ).parsed) );

Attachments

Activity

People

Assignee:: Shaun Verch

Reporter:: Tad Marshall

Participants:: auto, Shaun Verch, Tad Marshall

Votes:: 0 Vote for this issue

Watchers:: 3 Start watching this issue

Dates

Created:: Dec 13 2012 02:16:58 PM UTC

Updated:: Jul 11 2016 05:59:22 PM UTC

Resolved:: Dec 14 2012 12:38:55 AM UTC