Uploaded image for project: 'Core Server'
  1. Core Server
  2. SERVER-9850

replsets/sync_passive.js fails on Windows 32-bit

    • Type: Icon: Bug Bug
    • Resolution: Done
    • Priority: Icon: Major - P3 Major - P3
    • 2.5.1
    • Affects Version/s: 2.5.0
    • Component/s: Testing Infrastructure
    • Environment:
      buildbot Windows 32-bit
      buildbot Nightly Windows 32-bit
    • Fully Compatible
    • Windows

      jstests/replsets/sync_passive.js failed on Windows 32-bit:
      http://buildbot.mongodb.org/builders/Windows%2032-bit/builds/5843/steps/test_9/logs/stdio
      http://buildlogs.mongodb.org/Windows%2032-bit/builds/5843/test/replica%20sets/sync_passive.js

      For some reason, the server on port 31000 didn't finish shutting down in a timely fashion, but the test proceeded anyway, announcing that the server had been stopped when it was in fact still running.

      ReplSetTest stop *** Shutting down mongod in port 31000 ***
       m31000| Mon Jun 03 06:36:00.024 [initandlisten] connection accepted from 127.0.0.1:57852 #13 (5 connections now open)
       m31000| Mon Jun 03 06:36:00.024 [conn13] terminating, shutdown command received
       m31000| Mon Jun 03 06:36:00.024 dbexit: shutdown called
       m31000| Mon Jun 03 06:36:00.024 [conn13] shutdown: going to close listening sockets...
       m31000| Mon Jun 03 06:36:00.024 [conn13] closing listening socket: 476
       m31000| Mon Jun 03 06:36:00.024 [conn13] shutdown: going to flush diaglog...
       m31000| Mon Jun 03 06:36:00.024 [conn13] shutdown: going to close sockets...
       m31000| Mon Jun 03 06:36:00.024 [conn13] shutdown: waiting for fs preallocator...
       m31000| Mon Jun 03 06:36:00.024 [conn13] shutdown: closing all files...
       m31002| Mon Jun 03 06:36:00.024 [conn2] end connection 10.151.17.233:57822 (1 connection now open)
       m31000| Mon Jun 03 06:36:00.024 [conn1] end connection 127.0.0.1:57815 (4 connections now open)
       m31002| Mon Jun 03 06:36:00.024 [rsBackgroundSync] replSet db exception in producer: 10278 dbclient error communicating with server: EC2AMAZ-EXWX6MN:31000
       m31000| Mon Jun 03 06:36:00.024 [conn6] end connection 10.151.17.233:57835 (4 connections now open)
       m31002| Mon Jun 03 06:36:00.024 [rsSyncNotifier] replset tracking exception: exception: 10278 dbclient error communicating with server: EC2AMAZ-EXWX6MN:31000
      Mon Jun 03 06:36:00.024 DBClientCursor::init call() failed
      Mon Jun 03 06:36:01.038 shell: stopped mongo program on port 31000
      // ... snip ...
      ReplSetTest (Re)Starting....
      Mon Jun 03 06:36:25.889 shell: started program mongod.exe --oplogSize 40 --port 31000 --noprealloc --smallfiles --rest --replSet sync_passive --dbpath /data/db/sync_passive-0 --setParameter enableTestCommands=1
       m31000| note: noprealloc may hurt performance in many applications
       m31000| Mon Jun 03 06:36:25.920 
       m31000| Mon Jun 03 06:36:25.920 warning: 32-bit servers don't have journaling enabled by default. Please use --journal if you want durability.
       m31000| Mon Jun 03 06:36:25.920 
       m31000| Mon Jun 03 06:36:25.920 [initandlisten] MongoDB starting : pid=4804 port=31000 dbpath=/data/db/sync_passive-0 32-bit host=EC2AMAZ-EXWX6MN
       m31000| Mon Jun 03 06:36:25.920 [initandlisten] 
       m31000| Mon Jun 03 06:36:25.920 [initandlisten] ** NOTE: This is a development version (2.5.1-pre-) of MongoDB.
       m31000| Mon Jun 03 06:36:25.920 [initandlisten] **       Not recommended for production.
       m31000| Mon Jun 03 06:36:25.920 [initandlisten] 
       m31000| Mon Jun 03 06:36:25.920 [initandlisten] ** NOTE: This is a 32 bit MongoDB binary.
       m31000| Mon Jun 03 06:36:25.920 [initandlisten] **       32 bit builds are limited to less than 2GB of data (or less with --journal).
       m31000| Mon Jun 03 06:36:25.920 [initandlisten] **       Note that journaling defaults to off for 32 bit and is currently off.
       m31000| Mon Jun 03 06:36:25.920 [initandlisten] **       See http://dochub.mongodb.org/core/32bit
       m31000| Mon Jun 03 06:36:25.920 [initandlisten] 
       m31000| Mon Jun 03 06:36:25.920 [initandlisten] db version v2.5.1-pre-
       m31000| Mon Jun 03 06:36:25.920 [initandlisten] git version: 7652fb20c47fb3847a53bb2231ea23ee8e485623
       m31000| Mon Jun 03 06:36:25.920 [initandlisten] build info: windows sys.getwindowsversion(major=6, minor=0, build=6002, platform=2, service_pack='Service Pack 2') BOOST_LIB_VERSION=1_49
       m31000| Mon Jun 03 06:36:25.920 [initandlisten] allocator: system
       m31000| Mon Jun 03 06:36:25.920 [initandlisten] options: { dbpath: "/data/db/sync_passive-0", noprealloc: true, oplogSize: 40, port: 31000, replSet: "sync_passive", rest: true, setParameter: [ "enableTestCommands=1" ], smallfiles: true }
       m31000| ************** 
       m31000| Unclean shutdown detected.
       m31000| Please visit http://dochub.mongodb.org/core/repair for recovery instructions.
       m31000| *************
       m31000| Mon Jun 03 06:36:25.920 [initandlisten] exception in initAndListen: 12596 old lock file, terminating
       m31000| Mon Jun 03 06:36:25.920 dbexit: 
       m31000| Mon Jun 03 06:36:25.920 [initandlisten] shutdown: going to close listening sockets...
       m31000| Mon Jun 03 06:36:25.920 [initandlisten] shutdown: going to flush diaglog...
       m31000| Mon Jun 03 06:36:25.920 [initandlisten] shutdown: going to close sockets...
       m31000| Mon Jun 03 06:36:25.920 [initandlisten] shutdown: waiting for fs preallocator...
       m31000| Mon Jun 03 06:36:25.920 [initandlisten] shutdown: closing all files...
       m31000| Mon Jun 03 06:36:25.920 [initandlisten] closeAllFiles() finished
       m31000| Mon Jun 03 06:36:25.920 dbexit: really exiting now
      

      The shell announced:

      Mon Jun 03 06:36:01.038 shell: stopped mongo program on port 31000

      but the server on port 31000 had not printed "dbexit: really exiting now", so it was still running. This caused the restart to fail, causing the test to fail.

            Assignee:
            tad Tad Marshall
            Reporter:
            tad Tad Marshall
            Votes:
            0 Vote for this issue
            Watchers:
            4 Start watching this issue

              Created:
              Updated:
              Resolved: