Bug 1083089

Summary:	Client logs are filled with gf_ports_reserved warnings for port 54321
Product:	[Community] GlusterFS	Reporter:	vpshastry <vshastry>
Component:	core	Assignee:	Niels de Vos <ndevos>
Status:	CLOSED CURRENTRELEASE	QA Contact:
Severity:	medium	Docs Contact:
Priority:	medium
Version:	mainline	CC:	bugs, mkeir, rhinduja, rhs-bugs, rwheeler, smohan, vbellur
Target Milestone:	---
Target Release:	---
Hardware:	x86_64
OS:	Linux
Whiteboard:
Fixed In Version:	glusterfs-4.1.3 (or later)	Doc Type:	Bug Fix
Doc Text:		Story Points:	---
Clone Of:	971276	Environment:
Last Closed:	2018-08-29 03:35:01 UTC	Type:	Bug
Regression:	---	Mount Type:	---
Documentation:	---	CRM:
Verified Versions:		Category:	---
oVirt Team:	---	RHEL 7.3 requirements from Atomic Host:
Cloudforms Team:	---	Target Upstream Version:
Embargoed:
Bug Depends On:	971276
Bug Blocks:	1050219

Description vpshastry 2014-04-01 13:06:02 UTC

+++ This bug was initially created as a clone of Bug #971276 +++

Description of problem:
=======================

Client logs are filled with following messages

[2013-06-06 06:25:49.595443] W [common-utils.c:2405:gf_ports_reserved] 0-glusterfs-socket: 54321 is not a valid port identifier


neither bricks nor glusterd has the port number 54321 so why the logs reports the port number 54321 as not a valid port identifier.

none of the config files in /var/lib/glusterd contains the port number 54321

local port ranges from
# cat /proc/sys/net/ipv4/ip_local_port_range 
32768	61000



Actual Result:
==============

[2013-06-06 07:37:47.238208] W [socket.c:515:__socket_rwv] 0-bb-rep-client-1: readv on 10.70.36.111:24007 failed (No data available)
[2013-06-06 07:37:47.241734] W [common-utils.c:2405:gf_ports_reserved] 0-glusterfs-socket: 54321 is not a valid port identifier
[2013-06-06 07:37:47.242168] E [socket.c:2158:socket_connect_finish] 0-bb-rep-client-1: connection to 10.70.36.111:49152 failed (Connection refused)
[2013-06-06 07:37:47.242205] W [socket.c:515:__socket_rwv] 0-bb-rep-client-1: readv on 10.70.36.111:49152 failed (No data available)
[2013-06-06 07:37:51.240290] W [common-utils.c:2405:gf_ports_reserved] 0-glusterfs-socket: 54321 is not a valid port identifier
[2013-06-06 07:37:51.242247] I [rpc-clnt.c:1648:rpc_clnt_reconfig] 0-bb-rep-client-1: changing port to 49152 (from 0)
[2013-06-06 07:37:51.242316] W [socket.c:515:__socket_rwv] 0-bb-rep-client-1: readv on 10.70.36.111:24007 failed (No data available)
[2013-06-06 07:37:51.245841] W [common-utils.c:2405:gf_ports_reserved] 0-glusterfs-socket: 54321 is not a valid port identifier
[2013-06-06 07:37:51.246319] E [socket.c:2158:socket_connect_finish] 0-bb-rep-client-1: connection to 10.70.36.111:49152 failed (Connection refused)
[2013-06-06 07:37:51.246355] W [socket.c:515:__socket_rwv] 0-bb-rep-client-1: readv on 10.70.36.111:49152 failed (No data available)
[2013-06-06 07:37:55.244333] W [common-utils.c:2405:gf_ports_reserved] 0-glusterfs-socket: 54321 is not a valid port identifier
[2013-06-06 07:37:55.246161] I [rpc-clnt.c:1648:rpc_clnt_reconfig] 0-bb-rep-client-1: changing port to 49152 (from 0)
[2013-06-06 07:37:55.246237] W [socket.c:515:__socket_rwv] 0-bb-rep-client-1: readv on 10.70.36.111:24007 failed (No data available)
[2013-06-06 07:37:55.249768] W [common-utils.c:2405:gf_ports_reserved] 0-glusterfs-socket: 54321 is not a valid port identifier
[2013-06-06 07:37:55.250332] E [socket.c:2158:socket_connect_finish] 0-bb-rep-client-1: connection to 10.70.36.111:49152 failed (Connection refused)
[2013-06-06 07:37:55.250367] W [socket.c:515:__socket_rwv] 0-bb-rep-client-1: readv on 10.70.36.111:49152 failed (No data available)
[2013-06-06 07:37:59.248485] W [common-utils.c:2405:gf_ports_reserved] 0-glusterfs-socket: 54321 is not a valid port identifier
[2013-06-06 07:37:59.250128] I [rpc-clnt.c:1648:rpc_clnt_reconfig] 0-bb-rep-client-1: changing port to 49152 (from 0)
[2013-06-06 07:37:59.250185] W [socket.c:515:__socket_rwv] 0-bb-rep-client-1: readv on 10.70.36.111:24007 failed (No data available)
[2013-06-06 07:37:59.253694] W [common-utils.c:2405:gf_ports_reserved] 0-glusterfs-socket: 54321 is not a valid port identifier
[2013-06-06 07:37:59.254087] E [socket.c:2158:socket_connect_finish] 0-bb-rep-client-1: connection to 10.70.36.111:49152 failed (Connection refused)
[2013-06-06 07:37:59.254116] W [socket.c:515:__socket_rwv] 0-bb-rep-client-1: readv on 10.70.36.111:49152 failed (No data available)
[2013-06-06 07:38:03.252549] W [common-utils.c:2405:gf_ports_reserved] 0-glusterfs-socket: 54321 is not a valid port identifier
[2013-06-06 07:38:03.254203] I [rpc-clnt.c:1648:rpc_clnt_reconfig] 0-bb-rep-client-1: changing port to 49152 (from 0)
[2013-06-06 07:38:03.254266] W [socket.c:515:__socket_rwv] 0-bb-rep-client-1: readv on 10.70.36.111:24007 failed (No data available)
[2013-06-06 07:38:03.257780] W [common-utils.c:2405:gf_ports_reserved] 0-glusterfs-socket: 54321 is not a valid port identifier
[2013-06-06 07:38:03.258153] E [socket.c:2158:socket_connect_finish] 0-bb-rep-client-1: connection to 10.70.36.111:49152 failed (Connection refused)
[2013-06-06 07:38:03.258181] W [socket.c:515:__socket_rwv] 0-bb-rep-client-1: readv on 10.70.36.111:49152 failed (No data available)
[2013-06-06 07:38:07.256660] W [common-utils.c:2405:gf_ports_reserved] 0-glusterfs-socket: 54321 is not a valid port identifier
[2013-06-06 07:38:07.258620] I [rpc-clnt.c:1648:rpc_clnt_reconfig] 0-bb-rep-client-1: changing port to 49152 (from 0)
[2013-06-06 07:38:07.258686] W [socket.c:515:__socket_rwv] 0-bb-rep-client-1: readv on 10.70.36.111:24007 failed (No data available)
[2013-06-06 07:38:07.262185] W [common-utils.c:2405:gf_ports_reserved] 0-glusterfs-socket: 54321 is not a valid port identifier
[2013-06-06 07:38:07.262600] E [socket.c:2158:socket_connect_finish] 0-bb-rep-client-1: connection to 10.70.36.111:49152 failed (Connection refused)
[2013-06-06 07:38:07.262630] W [socket.c:515:__socket_rwv] 0-bb-rep-client-1: readv on 10.70.36.111:49152 failed (No data available)
[2013-06-06 07:38:11.260734] W [common-utils.c:2405:gf_ports_reserved] 0-glusterfs-socket: 54321 is not a valid port identifier
[2013-06-06 07:38:11.262632] I [rpc-clnt.c:1648:rpc_clnt_reconfig] 0-bb-rep-client-1: changing port to 49152 (from 0)
[2013-06-06 07:38:11.262691] W [socket.c:515:__socket_rwv] 0-bb-rep-client-1: readv on 10.70.36.111:24007 failed (No data available)
[2013-06-06 07:38:11.266189] W [common-utils.c:2405:gf_ports_reserved] 0-glusterfs-socket: 54321 is not a valid port identifier
[2013-06-06 07:38:11.266637] E [socket.c:2158:socket_connect_finish] 0-bb-rep-client-1: connection to 10.70.36.111:49152 failed (Connection refused)
[2013-06-06 07:38:11.266696] W [socket.c:515:__socket_rwv] 0-bb-rep-client-1: readv on 10.70.36.111:49152 failed (No data available)
[2013-06-06 07:38:15.264754] W [common-utils.c:2405:gf_ports_reserved] 0-glusterfs-socket: 54321 is not a valid port identifier
[2013-06-06 07:38:15.266450] I [rpc-clnt.c:1648:rpc_clnt_reconfig] 0-bb-rep-client-1: changing port to 49152 (from 0)
[2013-06-06 07:38:15.266511] W [socket.c:515:__socket_rwv] 0-bb-rep-client-1: readv on 10.70.36.111:24007 failed (No data available)

Comment 1 Anand Avati 2014-04-01 13:07:28 UTC

REVIEW: http://review.gluster.org/7376 (common-utils: changed the port holder to int32_t) posted (#1) for review on master by Varun Shastry (vshastry)

Comment 4 Anand Avati 2014-08-23 09:39:18 UTC

REVIEW: http://review.gluster.org/7376 (common-utils: changed the port holder to uint16_t) posted (#2) for review on master by Niels de Vos (ndevos)

Comment 5 Anand Avati 2015-06-01 09:47:04 UTC

REVIEW: http://review.gluster.org/7376 (common-utils: changed the port holder to uint16_t) posted (#3) for review on master by Niels de Vos (ndevos)

Comment 6 Mike McCune 2016-03-28 23:11:51 UTC

This bug was accidentally moved from POST to MODIFIED via an error in automation, please see mmccune with any questions

Comment 7 Amar Tumballi 2018-08-29 03:35:01 UTC

This update is done in bulk based on the state of the patch and the time since last activity. If the issue is still seen, please reopen the bug.