[SERVER-11088] core suite Profiler:BigDoc failing on Enterprise Windows 64-bit Created: 08/Oct/13  Updated: 11/Jul/16  Resolved: 09/Oct/13

Status: Closed
Project: Core Server
Component/s: Testing Infrastructure
Affects Version/s: None
Fix Version/s: 2.5.3

Type: Bug Priority: Critical - P2
Reporter: Matt Kangas Assignee: Benety Goh
Resolution: Done Votes: 0
Labels: buildbot
Remaining Estimate: Not Specified
Time Spent: Not Specified
Original Estimate: Not Specified

Backwards Compatibility: Fully Compatible
Operating System: ALL
Participants:

 Description   

6069172335a0 Enterprise Windows 64-bit core

http://buildlogs.mongodb.org/mci_0.9_enterprise_windows_64/builds/1146/test/core_0/test.exe

2013-10-08T16:43:21.042+0000 [testsuite] Profiler                       | tests:    2 | fails:    2 | assert calls:          6 | time secs:  5.061
	BigDoc	Expected: cursor->more() @src\mongo\dbtests\profile_test.cpp:65
	BigDocWithManyFields	Expected: cursor->more() @src\mongo\dbtests\profile_test.cpp:98

From Eric:

i looked at the failing core test on Windows Enterprise
it appears to be a real issue. we try to generate a very large document and make sure that profiling doesn't fall down
instead, on that windows builder, we make a document that's even too big for BSON itself
i don't know why the document is so much larger on windows than on linux. it's definitely something to investigate

Detailed failure message:

2013-10-08T16:35:26.291+0000 [testsuite] going to run suite: Profiler
2013-10-08T16:35:26.291+0000 [testsuite] 	 going to run test: BigDoc
2013-10-08T16:35:26.291+0000 [testsuite] dropDatabase profilerTestDB starting
2013-10-08T16:35:26.296+0000 [testsuite] removeJournalFiles
2013-10-08T16:35:26.297+0000 [testsuite] dropDatabase profilerTestDB finished
2013-10-08T16:35:26.306+0000 [testsuite] creating profile collection: profilerTestDB.system.profile
2013-10-08T16:35:26.306+0000 [FileAllocator] allocating new datafile /tmp/unittest\profilerTestDB.ns, filling with zeroes...
2013-10-08T16:35:27.201+0000 [FileAllocator] done allocating datafile /tmp/unittest\profilerTestDB.ns, size: 16MB,  took 0.894 secs
2013-10-08T16:35:27.202+0000 [FileAllocator] allocating new datafile /tmp/unittest\profilerTestDB.0, filling with zeroes...
2013-10-08T16:35:28.105+0000 [FileAllocator] done allocating datafile /tmp/unittest\profilerTestDB.0, size: 16MB,  took 0.903 secs
2013-10-08T16:35:28.216+0000 [testsuite] Assertion: 10334:BSONObj size: 33554094 (0x1FFFEAE) is invalid. Size must be between 0 and 16793600(16MB) First element: update: "test"
2013-10-08T16:35:28.784+0000 [testsuite] test.exe    ???
2013-10-08T16:35:28.784+0000 [testsuite] test.exe    ???
2013-10-08T16:35:28.784+0000 [testsuite] test.exe    ???
2013-10-08T16:35:28.784+0000 [testsuite] test.exe    ???
2013-10-08T16:35:28.784+0000 [testsuite] test.exe    ???
2013-10-08T16:35:28.784+0000 [testsuite] test.exe    ???
2013-10-08T16:35:28.784+0000 [testsuite] test.exe    ???
2013-10-08T16:35:28.784+0000 [testsuite] test.exe    ???
2013-10-08T16:35:28.784+0000 [testsuite] test.exe    ???
2013-10-08T16:35:28.784+0000 [testsuite] test.exe    ???
2013-10-08T16:35:28.784+0000 [testsuite] test.exe    ???
2013-10-08T16:35:28.784+0000 [testsuite] test.exe    ???
2013-10-08T16:35:28.784+0000 [testsuite] test.exe    ???
2013-10-08T16:35:28.784+0000 [testsuite] test.exe    ???
2013-10-08T16:35:28.784+0000 [testsuite] test.exe    ???
2013-10-08T16:35:28.784+0000 [testsuite] test.exe    ???
2013-10-08T16:35:28.784+0000 [testsuite] test.exe    ???
2013-10-08T16:35:28.784+0000 [testsuite] test.exe    ???
2013-10-08T16:35:28.784+0000 [testsuite] test.exe    ???
2013-10-08T16:35:28.784+0000 [testsuite] test.exe    ???
2013-10-08T16:35:28.784+0000 [testsuite] 
2013-10-08T16:35:28.794+0000 [testsuite] FAIL: BigDoc	Expected: cursor->more() @src\mongo\dbtests\profile_test.cpp:65
2013-10-08T16:35:28.794+0000 [testsuite] 	 going to run test: BigDocWithManyFields
2013-10-08T16:35:28.794+0000 [testsuite] dropDatabase profilerTestDB starting
2013-10-08T16:35:28.822+0000 [testsuite] removeJournalFiles
2013-10-08T16:35:28.846+0000 [testsuite] dropDatabase profilerTestDB finished
2013-10-08T16:35:28.846+0000 [testsuite] note: not profiling because db went away - probably a close on: profilerTestDB
2013-10-08T16:35:29.152+0000 [testsuite] creating profile collection: profilerTestDB.system.profile
2013-10-08T16:35:29.153+0000 [FileAllocator] allocating new datafile /tmp/unittest\profilerTestDB.ns, filling with zeroes...
2013-10-08 12:35:30 EDT	
2013-10-08T16:35:30.154+0000 [FileAllocator] done allocating datafile /tmp/unittest\profilerTestDB.ns, size: 16MB,  took 1.001 secs
2013-10-08T16:35:30.155+0000 [FileAllocator] allocating new datafile /tmp/unittest\profilerTestDB.0, filling with zeroes...
2013-10-08T16:35:31.124+0000 [FileAllocator] done allocating datafile /tmp/unittest\profilerTestDB.0, size: 16MB,  took 0.968 secs
2013-10-08T16:35:31.273+0000 [testsuite] Assertion: 10334:BSONObj size: 27137946 (0x19E179A) is invalid. Size must be between 0 and 16793600(16MB) First element: update: "test"
2013-10-08T16:35:31.345+0000 [testsuite] test.exe    ???
2013-10-08T16:35:31.345+0000 [testsuite] test.exe    ???
2013-10-08T16:35:31.345+0000 [testsuite] test.exe    ???
2013-10-08T16:35:31.345+0000 [testsuite] test.exe    ???
2013-10-08T16:35:31.345+0000 [testsuite] test.exe    ???
2013-10-08T16:35:31.345+0000 [testsuite] test.exe    ???
2013-10-08T16:35:31.345+0000 [testsuite] test.exe    ???
2013-10-08T16:35:31.345+0000 [testsuite] test.exe    ???
2013-10-08T16:35:31.345+0000 [testsuite] test.exe    ???
2013-10-08T16:35:31.345+0000 [testsuite] test.exe    ???
2013-10-08T16:35:31.345+0000 [testsuite] test.exe    ???
2013-10-08T16:35:31.345+0000 [testsuite] test.exe    ???
2013-10-08T16:35:31.345+0000 [testsuite] test.exe    ???
2013-10-08T16:35:31.345+0000 [testsuite] test.exe    ???
2013-10-08T16:35:31.345+0000 [testsuite] test.exe    ???
2013-10-08T16:35:31.345+0000 [testsuite] test.exe    ???
2013-10-08T16:35:31.345+0000 [testsuite] test.exe    ???
2013-10-08T16:35:31.345+0000 [testsuite] test.exe    ???
2013-10-08T16:35:31.345+0000 [testsuite] test.exe    ???
2013-10-08T16:35:31.345+0000 [testsuite] test.exe    ???
2013-10-08T16:35:31.345+0000 [testsuite] 
2013-10-08T16:35:31.352+0000 [testsuite] FAIL: BigDocWithManyFields	Expected: cursor->more() @src\mongo\dbtests\profile_test.cpp:98
2013-10-08T16:35:31.352+0000 [testsuite] 	 DONE running tests

Earliest build where this failure is visible: 2013/10/03

http://mci.10gen.com/ui/task/mongodb_mongo_master_enterprise_windows_64_96e1074a9b5ee3e6b609adac4cb46fcf599c7298_13_10_03_17_38_07_core_windows_64

Preceding that is a build that says "Success", but I am not sure if the builder was fully functional at that time.

http://mci.10gen.com/ui/task/mongodb_mongo_master_enterprise_windows_64_e01dfe96c73e89fb5e20f55faff4fcbfb54de1b5_13_09_26_01_43_26_core_windows_64

80 commits in the interval e01dfe96c73e..96e1074a9b5e



 Comments   
Comment by Matt Kangas [ 09/Oct/13 ]

Apparently resolved as of 631d431

http://mci.10gen.com/ui/task/mongodb_mongo_master_enterprise_windows_64_631d4312066b143eeec36d7ff2a91448ac53065b_13_10_08_22_28_57_core_windows_64

Commits in the interval from the last visible failure on MCI:

631d431 2013-10-08 18:13 Mathias Stearn     o SERVER-11089 Make test more resilient to reconnects o~
bfb9dee 2013-10-08 15:01 Eliot Horowitz     o SERVER-6405: remove dead code and move things around
340c963 2013-10-08 16:02 Mathias Stearn     o Rip out Expression::toMatcherBson()
4f3813f 2013-10-08 15:49 Mathias Stearn     o Rip out ExpressionFieldRange
62d754f 2013-10-08 15:40 Mathias Stearn     o SERVER-11084 Error when mixing --gcov and --cache
061a086 2013-10-08 13:29 Mathias Stearn     o SERVER-10165 aggregate() shell helper now returns a c~
e04fad1 2013-10-08 16:37 Hari Khalsa        o SERVER-10026 new vs old system spigot
39fc9f4 2013-10-07 19:15 Hari Khalsa        o SERVER-10026 enum >1 plan, prefer plans with more com~
0357798 2013-10-08 16:34 Eric Milkie        o SERVER-10358 temporarily move module.cpp into server_~
d685bf2 2013-10-08 15:33 Andrew Morrow      o SERVER-11056 Fix unused variable warning in non-debug~
dd6872e 2013-10-08 13:53 Joseph J. Piché   o SERVER-8510 Fixing typo directly -> directory in opti~
c70a72b 2013-10-07 19:10 Andrew Morrow      o SERVER-11070 When using libc++, things are never foun~
d1677de 2013-10-08 09:56 Andrew Morrow      o SERVER-11056 Don't assume address uniqueness for dete~

Comment by Benety Goh [ 09/Oct/13 ]

Last night's run seems to be fine:

http://buildlogs.mongodb.org/mci_0.9_enterprise_windows_64/builds/1162/test/core_1/test.exe

I could still try to debug it on Eric's instance

Comment by Eric Milkie [ 08/Oct/13 ]

I have a running instance that you can log in and debug with if you need it.

Generated at Thu Feb 08 03:24:51 UTC 2024 using Jira 9.7.1#970001-sha1:2222b88b221c4928ef0de3161136cc90c8356a66.