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

MongoS logs build info twice at startup

    • Type: Icon: Bug Bug
    • Resolution: Fixed
    • Priority: Icon: Minor - P4 Minor - P4
    • 4.2.0-rc3, 4.3.1
    • Affects Version/s: 3.4.0, 3.5.11, 3.6.13, 4.0.10, 4.2.0-rc2
    • Component/s: Internal Code
    • Fully Compatible
    • ALL
    • v4.2
    • Platforms 2017-10-23, Platforms 2017-11-13, Platforms 2017-12-04, Sharding 2019-02-25, Sharding 2019-03-11, Sharding 2019-03-25, Sharding 2019-07-15

      Since 3.3.11 (up to latest stable 3.4.7 and latest devel 3.5.11), mongos logs the build info twice at startup. This is confusing and makes it look like the mongos may have been accidentally started twice at the same time.

      The problem is that printShardingVersionInfo() calls logBuildInfo() in its else branch, but it shouldn't because logProcessDetails() calls logBuildInfo(). This was accidentally introduced in SERVER-22734.

      $ /m/3.3.10/bin/mongos --configdb foobar/localhost
      2017-08-11T16:45:02.947+1000 W SHARDING [main] Running a sharded cluster with fewer than 3 config servers should only be done for testing purposes and is not recommended for production.
      2017-08-11T16:45:02.953+1000 I CONTROL  [main]
      2017-08-11T16:45:02.953+1000 I CONTROL  [main] ** NOTE: This is a development version (3.3.10) of MongoDB.
      2017-08-11T16:45:02.953+1000 I CONTROL  [main] **       Not recommended for production.
      2017-08-11T16:45:02.953+1000 I CONTROL  [main]
      2017-08-11T16:45:02.953+1000 I CONTROL  [main] ** WARNING: Access control is not enabled for the database.
      2017-08-11T16:45:02.953+1000 I CONTROL  [main] **          Read and write access to data and configuration is unrestricted.
      2017-08-11T16:45:02.953+1000 I CONTROL  [main]
      2017-08-11T16:45:02.953+1000 I SHARDING [mongosMain] MongoS version 3.3.10 starting: pid=9450 port=27017 64-bit host=basique (--help for usage)
      2017-08-11T16:45:02.953+1000 I CONTROL  [mongosMain] db version v3.3.10
      2017-08-11T16:45:02.953+1000 I CONTROL  [mongosMain] git version: 4d826acb5648a78d0af0fefac5abe6fbbe7c854a
      2017-08-11T16:45:02.953+1000 I CONTROL  [mongosMain] OpenSSL version: OpenSSL 1.0.2g  1 Mar 2016
      2017-08-11T16:45:02.953+1000 I CONTROL  [mongosMain] allocator: tcmalloc
      2017-08-11T16:45:02.953+1000 I CONTROL  [mongosMain] modules: none
      2017-08-11T16:45:02.953+1000 I CONTROL  [mongosMain] build environment:
      2017-08-11T16:45:02.953+1000 I CONTROL  [mongosMain]     distmod: ubuntu1604
      2017-08-11T16:45:02.953+1000 I CONTROL  [mongosMain]     distarch: x86_64
      2017-08-11T16:45:02.953+1000 I CONTROL  [mongosMain]     target_arch: x86_64
      2017-08-11T16:45:02.953+1000 I CONTROL  [mongosMain] options: { sharding: { configDB: "foobar/localhost" } }
      2017-08-11T16:45:02.989+1000 E NETWORK  [mongosMain] listen(): bind() failed Address already in use for socket: 0.0.0.0:27017
      2017-08-11T16:45:02.989+1000 E NETWORK  [mongosMain]   addr already in use
      2017-08-11T16:45:02.989+1000 E NETWORK  [mongosMain] Failed to set up sockets during startup.
      ...
      
      $ /m/3.3.11/bin/mongos --configdb foobar/localhost
      2017-08-11T16:45:19.359+1000 W SHARDING [main] Running a sharded cluster with fewer than 3 config servers should only be done for testing purposes and is not recommended for production.
      2017-08-11T16:45:19.365+1000 I CONTROL  [main]
      2017-08-11T16:45:19.365+1000 I CONTROL  [main] ** NOTE: This is a development version (3.3.11) of MongoDB.
      2017-08-11T16:45:19.365+1000 I CONTROL  [main] **       Not recommended for production.
      2017-08-11T16:45:19.365+1000 I CONTROL  [main]
      2017-08-11T16:45:19.365+1000 I CONTROL  [main] ** WARNING: Access control is not enabled for the database.
      2017-08-11T16:45:19.365+1000 I CONTROL  [main] **          Read and write access to data and configuration is unrestricted.
      2017-08-11T16:45:19.365+1000 I CONTROL  [main]
      2017-08-11T16:45:19.365+1000 I SHARDING [mongosMain] mongos version v3.3.11
      2017-08-11T16:45:19.365+1000 I CONTROL  [mongosMain] git version: 4e682143bca253a840f07604c0d7c522d48b5c29
      2017-08-11T16:45:19.365+1000 I CONTROL  [mongosMain] OpenSSL version: OpenSSL 1.0.2g  1 Mar 2016
      2017-08-11T16:45:19.365+1000 I CONTROL  [mongosMain] allocator: tcmalloc
      2017-08-11T16:45:19.365+1000 I CONTROL  [mongosMain] modules: none
      2017-08-11T16:45:19.365+1000 I CONTROL  [mongosMain] build environment:
      2017-08-11T16:45:19.365+1000 I CONTROL  [mongosMain]     distmod: ubuntu1604
      2017-08-11T16:45:19.365+1000 I CONTROL  [mongosMain]     distarch: x86_64
      2017-08-11T16:45:19.365+1000 I CONTROL  [mongosMain]     target_arch: x86_64
      2017-08-11T16:45:19.365+1000 I CONTROL  [mongosMain] db version v3.3.11
      2017-08-11T16:45:19.365+1000 I CONTROL  [mongosMain] git version: 4e682143bca253a840f07604c0d7c522d48b5c29
      2017-08-11T16:45:19.365+1000 I CONTROL  [mongosMain] OpenSSL version: OpenSSL 1.0.2g  1 Mar 2016
      2017-08-11T16:45:19.365+1000 I CONTROL  [mongosMain] allocator: tcmalloc
      2017-08-11T16:45:19.365+1000 I CONTROL  [mongosMain] modules: none
      2017-08-11T16:45:19.366+1000 I CONTROL  [mongosMain] build environment:
      2017-08-11T16:45:19.366+1000 I CONTROL  [mongosMain]     distmod: ubuntu1604
      2017-08-11T16:45:19.366+1000 I CONTROL  [mongosMain]     distarch: x86_64
      2017-08-11T16:45:19.366+1000 I CONTROL  [mongosMain]     target_arch: x86_64
      2017-08-11T16:45:19.366+1000 I CONTROL  [mongosMain] options: { sharding: { configDB: "foobar/localhost" } }
      2017-08-11T16:45:19.399+1000 E NETWORK  [mongosMain] listen(): bind() failed Address already in use for socket: 0.0.0.0:27017
      2017-08-11T16:45:19.399+1000 E NETWORK  [mongosMain]   addr already in use
      2017-08-11T16:45:19.399+1000 E NETWORK  [mongosMain] Failed to set up sockets during startup.
      ...
      
      $ /m/3.4.7/bin/mongos --configdb foobar/localhost
      2017-08-11T16:46:05.933+1000 W SHARDING [main] Running a sharded cluster with fewer than 3 config servers should only be done for testing purposes and is not recommended for production.
      2017-08-11T16:46:05.947+1000 I CONTROL  [main]
      2017-08-11T16:46:05.947+1000 I CONTROL  [main] ** WARNING: Access control is not enabled for the database.
      2017-08-11T16:46:05.947+1000 I CONTROL  [main] **          Read and write access to data and configuration is unrestricted.
      2017-08-11T16:46:05.947+1000 I CONTROL  [main]
      2017-08-11T16:46:05.948+1000 I SHARDING [mongosMain] mongos version v3.4.7
      2017-08-11T16:46:05.948+1000 I CONTROL  [mongosMain] git version: cf38c1b8a0a8dca4a11737581beafef4fe120bcd
      2017-08-11T16:46:05.948+1000 I CONTROL  [mongosMain] OpenSSL version: OpenSSL 1.0.2g  1 Mar 2016
      2017-08-11T16:46:05.948+1000 I CONTROL  [mongosMain] allocator: tcmalloc
      2017-08-11T16:46:05.948+1000 I CONTROL  [mongosMain] modules: none
      2017-08-11T16:46:05.948+1000 I CONTROL  [mongosMain] build environment:
      2017-08-11T16:46:05.948+1000 I CONTROL  [mongosMain]     distmod: ubuntu1604
      2017-08-11T16:46:05.948+1000 I CONTROL  [mongosMain]     distarch: x86_64
      2017-08-11T16:46:05.948+1000 I CONTROL  [mongosMain]     target_arch: x86_64
      2017-08-11T16:46:05.948+1000 I CONTROL  [mongosMain] db version v3.4.7
      2017-08-11T16:46:05.948+1000 I CONTROL  [mongosMain] git version: cf38c1b8a0a8dca4a11737581beafef4fe120bcd
      2017-08-11T16:46:05.948+1000 I CONTROL  [mongosMain] OpenSSL version: OpenSSL 1.0.2g  1 Mar 2016
      2017-08-11T16:46:05.948+1000 I CONTROL  [mongosMain] allocator: tcmalloc
      2017-08-11T16:46:05.948+1000 I CONTROL  [mongosMain] modules: none
      2017-08-11T16:46:05.948+1000 I CONTROL  [mongosMain] build environment:
      2017-08-11T16:46:05.948+1000 I CONTROL  [mongosMain]     distmod: ubuntu1604
      2017-08-11T16:46:05.948+1000 I CONTROL  [mongosMain]     distarch: x86_64
      2017-08-11T16:46:05.948+1000 I CONTROL  [mongosMain]     target_arch: x86_64
      2017-08-11T16:46:05.948+1000 I CONTROL  [mongosMain] options: { sharding: { configDB: "foobar/localhost" } }
      2017-08-11T16:46:05.986+1000 E NETWORK  [mongosMain] listen(): bind() failed Address already in use for socket: 0.0.0.0:27017
      2017-08-11T16:46:05.986+1000 E NETWORK  [mongosMain]   addr already in use
      2017-08-11T16:46:05.986+1000 E NETWORK  [mongosMain] Failed to set up sockets during startup.
      2017-08-11T16:46:05.986+1000 I CONTROL  [mongosMain] shutting down with code:48
      
      $ /m/3.5.11/bin/mongos --configdb foobar/localhost
      2017-08-11T16:46:34.645+1000 W SHARDING [main] Running a sharded cluster with fewer than 3 config servers should only be done for testing purposes and is not recommended for production.
      2017-08-11T16:46:34.652+1000 I CONTROL  [main]
      2017-08-11T16:46:34.652+1000 I CONTROL  [main] ** NOTE: This is a development version (3.5.11) of MongoDB.
      2017-08-11T16:46:34.652+1000 I CONTROL  [main] **       Not recommended for production.
      2017-08-11T16:46:34.652+1000 I CONTROL  [main]
      2017-08-11T16:46:34.652+1000 I CONTROL  [main] ** WARNING: Access control is not enabled for the database.
      2017-08-11T16:46:34.652+1000 I CONTROL  [main] **          Read and write access to data and configuration is unrestricted.
      2017-08-11T16:46:34.652+1000 I CONTROL  [main]
      2017-08-11T16:46:34.652+1000 I CONTROL  [main] ** WARNING: This server is bound to localhost.
      2017-08-11T16:46:34.652+1000 I CONTROL  [main] **          Remote systems will be unable to connect to this server.
      2017-08-11T16:46:34.652+1000 I CONTROL  [main] **          Start the server with --bind_ip <address> to specify which IP
      2017-08-11T16:46:34.652+1000 I CONTROL  [main] **          addresses it should serve responses from, or with --bind_ip_all to
      2017-08-11T16:46:34.652+1000 I CONTROL  [main] **          bind to all interfaces. If this behavior is desired, start the
      2017-08-11T16:46:34.652+1000 I CONTROL  [main] **          server with --bind_ip 127.0.0.1 to disable this warning.
      2017-08-11T16:46:34.652+1000 I CONTROL  [main]
      2017-08-11T16:46:34.652+1000 I SHARDING [mongosMain] mongos version v3.5.11
      2017-08-11T16:46:34.653+1000 I CONTROL  [mongosMain] git version: a8a9854b666515d48720cf2b203553954b6a75e6
      2017-08-11T16:46:34.653+1000 I CONTROL  [mongosMain] OpenSSL version: OpenSSL 1.0.2g  1 Mar 2016
      2017-08-11T16:46:34.653+1000 I CONTROL  [mongosMain] allocator: tcmalloc
      2017-08-11T16:46:34.653+1000 I CONTROL  [mongosMain] modules: none
      2017-08-11T16:46:34.653+1000 I CONTROL  [mongosMain] build environment:
      2017-08-11T16:46:34.653+1000 I CONTROL  [mongosMain]     distmod: ubuntu1604
      2017-08-11T16:46:34.653+1000 I CONTROL  [mongosMain]     distarch: x86_64
      2017-08-11T16:46:34.653+1000 I CONTROL  [mongosMain]     target_arch: x86_64
      2017-08-11T16:46:34.653+1000 I CONTROL  [mongosMain] db version v3.5.11
      2017-08-11T16:46:34.653+1000 I CONTROL  [mongosMain] git version: a8a9854b666515d48720cf2b203553954b6a75e6
      2017-08-11T16:46:34.653+1000 I CONTROL  [mongosMain] OpenSSL version: OpenSSL 1.0.2g  1 Mar 2016
      2017-08-11T16:46:34.653+1000 I CONTROL  [mongosMain] allocator: tcmalloc
      2017-08-11T16:46:34.653+1000 I CONTROL  [mongosMain] modules: none
      2017-08-11T16:46:34.653+1000 I CONTROL  [mongosMain] build environment:
      2017-08-11T16:46:34.653+1000 I CONTROL  [mongosMain]     distmod: ubuntu1604
      2017-08-11T16:46:34.653+1000 I CONTROL  [mongosMain]     distarch: x86_64
      2017-08-11T16:46:34.653+1000 I CONTROL  [mongosMain]     target_arch: x86_64
      2017-08-11T16:46:34.653+1000 I CONTROL  [mongosMain] options: { sharding: { configDB: "foobar/localhost" } }
      2017-08-11T16:46:34.653+1000 E SHARDING [mongosMain] Failed to set up listener: SocketException: Address already in use
      2017-08-11T16:46:34.653+1000 I CONTROL  [mongosMain] shutting down with code:48
      

            Assignee:
            kaloian.manassiev@mongodb.com Kaloian Manassiev
            Reporter:
            kevin.pulo@mongodb.com Kevin Pulo
            Votes:
            0 Vote for this issue
            Watchers:
            6 Start watching this issue

              Created:
              Updated:
              Resolved: