[SERVER-20952] HostnameCanonicalizationWorker spams logs Created: 15/Oct/15  Updated: 07/Apr/23  Resolved: 21/Oct/15

Status: Closed
Project: Core Server
Component/s: Logging, Networking
Affects Version/s: 3.2.0-rc0
Fix Version/s: 3.2.0-rc1

Type: Bug Priority: Major - P3
Reporter: Scott Hernandez (Inactive) Assignee: Spencer Jackson
Resolution: Done Votes: 0
Labels: None
Remaining Estimate: Not Specified
Time Spent: Not Specified
Original Estimate: Not Specified

Issue Links:
Related
is related to SERVER-21757 ServerStatus "advisoryHostFQDNs" shou... Closed
is related to SERVER-22026 Move advisoryFQDNs variable to its ow... Closed
Backwards Compatibility: Fully Compatible
Operating System: ALL
Participants:

 Description   

This should probably only be logged once per instance.

2015-10-15T13:38:08.556-0400 I REPL     [ReplicationExecutor] transition to PRIMARY
2015-10-15T13:38:08.584-0400 W NETWORK  [HostnameCanonicalizationWorker] Failed to obtain name info for an address: nodename nor servname provided, or not known
2015-10-15T13:38:08.589-0400 W NETWORK  [HostnameCanonicalizationWorker] Failed to obtain name info for an address: nodename nor servname provided, or not known
2015-10-15T13:38:08.593-0400 W NETWORK  [HostnameCanonicalizationWorker] Failed to obtain name info for an address: nodename nor servname provided, or not known
2015-10-15T13:38:08.597-0400 W NETWORK  [HostnameCanonicalizationWorker] Failed to obtain name info for an address: nodename nor servname provided, or not known
2015-10-15T13:38:08.601-0400 W NETWORK  [HostnameCanonicalizationWorker] Failed to obtain name info for an address: nodename nor servname provided, or not known
2015-10-15T13:38:08.604-0400 W NETWORK  [HostnameCanonicalizationWorker] Failed to obtain name info for an address: nodename nor servname provided, or not known
2015-10-15T13:38:09.558-0400 I REPL     [rsSync] transition to primary complete; database writes are now permitted
2015-10-15T13:38:15.174-0400 I NETWORK  [initandlisten] connection accepted from 127.0.0.1:55684 #1 (1 connection now open)
2015-10-15T13:39:08.624-0400 W NETWORK  [HostnameCanonicalizationWorker] Failed to obtain name info for an address: nodename nor servname provided, or not known
2015-10-15T13:39:08.628-0400 W NETWORK  [HostnameCanonicalizationWorker] Failed to obtain name info for an address: nodename nor servname provided, or not known
2015-10-15T13:39:08.631-0400 W NETWORK  [HostnameCanonicalizationWorker] Failed to obtain name info for an address: nodename nor servname provided, or not known
2015-10-15T13:39:08.634-0400 W NETWORK  [HostnameCanonicalizationWorker] Failed to obtain name info for an address: nodename nor servname provided, or not known
2015-10-15T13:39:08.636-0400 W NETWORK  [HostnameCanonicalizationWorker] Failed to obtain name info for an address: nodename nor servname provided, or not known
2015-10-15T13:39:08.639-0400 W NETWORK  [HostnameCanonicalizationWorker] Failed to obtain name info for an address: nodename nor servname provided, or not known
2015-10-15T13:40:08.656-0400 W NETWORK  [HostnameCanonicalizationWorker] Failed to obtain name info for an address: nodename nor servname provided, or not known
2015-10-15T13:40:08.661-0400 W NETWORK  [HostnameCanonicalizationWorker] Failed to obtain name info for an address: nodename nor servname provided, or not known
2015-10-15T13:40:08.669-0400 W NETWORK  [HostnameCanonicalizationWorker] Failed to obtain name info for an address: nodename nor servname provided, or not known
2015-10-15T13:40:08.674-0400 W NETWORK  [HostnameCanonicalizationWorker] Failed to obtain name info for an address: nodename nor servname provided, or not known
2015-10-15T13:40:08.699-0400 W NETWORK  [HostnameCanonicalizationWorker] Failed to obtain name info for an address: nodename nor servname provided, or not known
2015-10-15T13:40:08.704-0400 W NETWORK  [HostnameCanonicalizationWorker] Failed to obtain name info for an address: nodename nor servname provided, or not known
2015-10-15T13:41:08.734-0400 W NETWORK  [HostnameCanonicalizationWorker] Failed to obtain name info for an address: nodename nor servname provided, or not known



 Comments   
Comment by rohith [ 18/Mar/16 ]

Hi Ognanian
This issue related to hostfile.
check your host file config ,if it is Linux go to /etc/hosts and comment or remove #::1 hostname line which is related to ipv6 generally which is disabled.
else enable Ipv6 .
after this change restart the service which should be good without any failed events logging.
without enabling Ipv6

Just update host file with
"127.0.0.1 localhost localhost.localdomain"
now restart the service it should good to go.

Thanks

Comment by Spencer Jackson [ 18/Dec/15 ]

Hi Ognian. This warning is probably something you can ignore. It's coming from a background thread which is updating an informational variable in db.serverStatus(), which is slow to compute. The variable won't be updated, but beyond that this warning won't have an effect on your database's operation. I hope this helps!

Comment by Ognian Tschakalov [ 17/Dec/15 ]

Still happens on OS X10.11.2 :
2015-12-16T16:37:14.904+0100 I CONTROL [initandlisten] MongoDB starting : pid=32279 port=27017 dbpath=../db/ 64-bit host=ogi-it-mac.level1.ogi-it.com
2015-12-16T16:37:14.905+0100 I CONTROL [initandlisten] db version v3.2.0
2015-12-16T16:37:14.905+0100 I CONTROL [initandlisten] git version: 45d947729a0315accb6d4f15a6b06be6d9c19fe7
2015-12-16T16:37:14.905+0100 I CONTROL [initandlisten] allocator: system
2015-12-16T16:37:14.905+0100 I CONTROL [initandlisten] modules: none
2015-12-16T16:37:14.905+0100 I CONTROL [initandlisten] build environment:
2015-12-16T16:37:14.905+0100 I CONTROL [initandlisten] distarch: x86_64
2015-12-16T16:37:14.905+0100 I CONTROL [initandlisten] target_arch: x86_64
2015-12-16T16:37:14.905+0100 I CONTROL [initandlisten] options: { config: "../mongodb.conf", net: { http:

{ RESTInterfaceEnabled: true, enabled: true }

}, storage:

{ dbPath: "../db/" }

}
2015-12-16T16:37:14.906+0100 I - [initandlisten] Detected data files in ../db/ created by the 'wiredTiger' storage engine, so setting the active storage engine to 'wiredTiger'.
2015-12-16T16:37:14.907+0100 I STORAGE [initandlisten] wiredtiger_open config: create,cache_size=4G,session_max=20000,eviction=(threads_max=4),config_base=false,statistics=(fast),log=(enabled=true,archive=true,path=journal,compressor=snappy),file_manager=(close_idle_time=100000),checkpoint=(wait=60,log_size=2GB),statistics_log=(wait=0),
2015-12-16T16:37:17.226+0100 I NETWORK [websvr] admin web console waiting for connections on port 28017
2015-12-16T16:37:17.226+0100 I FTDC [initandlisten] Initializing full-time diagnostic data capture with directory '../db/diagnostic.data'
2015-12-16T16:37:17.226+0100 I NETWORK [HostnameCanonicalizationWorker] Starting hostname canonicalization worker
2015-12-16T16:37:17.229+0100 I NETWORK [initandlisten] waiting for connections on port 27017
2015-12-16T16:37:17.697+0100 I NETWORK [initandlisten] connection accepted from 127.0.0.1:52621 #1 (1 connection now open)
.....
2015-12-16T16:37:17.769+0100 I NETWORK [initandlisten] connection accepted from 127.0.0.1:52691 #79 (79 connections now open)
2015-12-16T16:37:17.770+0100 I NETWORK [initandlisten] connection accepted from 127.0.0.1:52690 #80 (80 connections now open)
2015-12-16T19:14:24.014+0100 W NETWORK [HostnameCanonicalizationWorker] Failed to obtain address information for hostname ogi-it-mac.level1.ogi-it.com: nodename nor servname provided, or not known

Do you need more info?
Thanks
Ognian

Comment by Githook User [ 21/Oct/15 ]

Author:

{u'username': u'spencerjackson', u'name': u'Spencer Jackson', u'email': u'spencer.jackson@mongodb.com'}

Message: SERVER-20952+SERVER-20954: Tune generation of canonicalization logs
Branch: master
https://github.com/mongodb/mongo/commit/4e038148f1567e58d17fc6b3df7beef84b2b411d

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