Note: This bug is displayed in read-only format because the product is no longer active in Red Hat Bugzilla.
RHEL Engineering is moving the tracking of its product development work on RHEL 6 through RHEL 9 to Red Hat Jira (issues.redhat.com). If you're a Red Hat customer, please continue to file support cases via the Red Hat customer portal. If you're not, please head to the "RHEL project" in Red Hat Jira and file new tickets here. Individual Bugzilla bugs in the statuses "NEW", "ASSIGNED", and "POST" are being migrated throughout September 2023. Bugs of Red Hat partners with an assigned Engineering Partner Manager (EPM) are migrated in late September as per pre-agreed dates. Bugs against components "kernel", "kernel-rt", and "kpatch" are only migrated if still in "NEW" or "ASSIGNED". If you cannot log in to RH Jira, please consult article #7032570. That failing, please send an e-mail to the RH Jira admins at rh-issues@redhat.com to troubleshoot your issue as a user management inquiry. The email creates a ServiceNow ticket with Red Hat. Individual Bugzilla bugs that are migrated will be moved to status "CLOSED", resolution "MIGRATED", and set with "MigratedToJIRA" in "Keywords". The link to the successor Jira issue will be found under "Links", have a little "two-footprint" icon next to it, and direct you to the "RHEL project" in Red Hat Jira (issue links are of type "https://issues.redhat.com/browse/RHEL-XXXX", where "X" is a digit). This same link will be available in a blue banner at the top of the page informing you that that bug has been migrated.

Bug 866928

Summary: 3.1.z - [vdsm][race] repoStats reports a domain as nonexistant for a long time after domain is unblocked
Product: Red Hat Enterprise Linux 6 Reporter: Gadi Ickowicz <gickowic>
Component: vdsmAssignee: Federico Simoncelli <fsimonce>
Status: CLOSED WORKSFORME QA Contact: Haim <hateya>
Severity: medium Docs Contact:
Priority: unspecified    
Version: 6.3CC: abaron, bazulay, iheim, lpeer, nlevinki, yeylon, ykaul
Target Milestone: rc   
Target Release: ---   
Hardware: All   
OS: Linux   
Whiteboard: storage
Fixed In Version: Doc Type: Bug Fix
Doc Text:
Story Points: ---
Clone Of: Environment:
Last Closed: 2012-11-25 14:44:17 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:
Attachments:
Description Flags
vdsm + engine logs none

Description Gadi Ickowicz 2012-10-16 10:45:05 UTC 
Created attachment 628091 [details]
vdsm + engine logs

Description of problem:
After blocking an ISO domain, sometimes it takes a long time for repoStats to report the domain as valid again after removing the block from IPTables. 

Version-Release number of selected component (if applicable):
vdsm-4.9.6-37.0.el6_3.x86_64

How reproducible:
~10-15%

Steps to Reproduce:
single host setup:
1. Block the connection between host and the ISO storage domain
2. Wait for domain to change to 'code':358 in repoStats (or Inactive in engine)
3. unblock connection
4. wait until vdsm recovers and domain is active again
  
Actual results:
Sometimes it takes a long time to recover from the unblock (about 2-3 minutes)

relevant lines from log:
(unblock was at 10:38)

hread-597::INFO::2012-10-16 10:33:31,536::logUtils::39::dispatcher::(wrapper) Run and protect: repoStats, Return response: {u'b1eb16e3-bab4-41b2-b494-ede5775de80d': {'delay': '0.00251507759094', 'lastCheck': 1350
Thread-604::INFO::2012-10-16 10:33:41,776::logUtils::39::dispatcher::(wrapper) Run and protect: repoStats, Return response: {u'b1eb16e3-bab4-41b2-b494-ede5775de80d': {'delay': '0', 'lastCheck': 1350376420.1520071,
Thread-610::INFO::2012-10-16 10:33:52,051::logUtils::39::dispatcher::(wrapper) Run and protect: repoStats, Return response: {u'b1eb16e3-bab4-41b2-b494-ede5775de80d': {'delay': '0', 'lastCheck': 1350376420.1520071,
Thread-616::INFO::2012-10-16 10:34:02,297::logUtils::39::dispatcher::(wrapper) Run and protect: repoStats, Return response: {u'b1eb16e3-bab4-41b2-b494-ede5775de80d': {'delay': '0', 'lastCheck': 1350376420.1520071,
Thread-622::INFO::2012-10-16 10:34:12,534::logUtils::39::dispatcher::(wrapper) Run and protect: repoStats, Return response: {u'b1eb16e3-bab4-41b2-b494-ede5775de80d': {'delay': '0', 'lastCheck': 1350376420.1520071,
Thread-628::INFO::2012-10-16 10:34:22,785::logUtils::39::dispatcher::(wrapper) Run and protect: repoStats, Return response: {u'b1eb16e3-bab4-41b2-b494-ede5775de80d': {'delay': '0', 'lastCheck': 1350376420.1520071,
Thread-634::INFO::2012-10-16 10:34:33,013::logUtils::39::dispatcher::(wrapper) Run and protect: repoStats, Return response: {u'b1eb16e3-bab4-41b2-b494-ede5775de80d': {'delay': '0', 'lastCheck': 1350376420.1520071,
Thread-644::INFO::2012-10-16 10:34:43,402::logUtils::39::dispatcher::(wrapper) Run and protect: repoStats, Return response: {u'b1eb16e3-bab4-41b2-b494-ede5775de80d': {'delay': '0', 'lastCheck': 1350376420.1520071,
Thread-657::INFO::2012-10-16 10:34:53,773::logUtils::39::dispatcher::(wrapper) Run and protect: repoStats, Return response: {u'b1eb16e3-bab4-41b2-b494-ede5775de80d': {'delay': '0', 'lastCheck': 1350376420.1520071,
Thread-667::INFO::2012-10-16 10:35:04,158::logUtils::39::dispatcher::(wrapper) Run and protect: repoStats, Return response: {u'b1eb16e3-bab4-41b2-b494-ede5775de80d': {'delay': '0', 'lastCheck': 1350376420.1520071,
Thread-677::INFO::2012-10-16 10:35:14,532::logUtils::39::dispatcher::(wrapper) Run and protect: repoStats, Return response: {u'b1eb16e3-bab4-41b2-b494-ede5775de80d': {'delay': '0', 'lastCheck': 1350376420.1520071,
Thread-687::INFO::2012-10-16 10:35:24,944::logUtils::39::dispatcher::(wrapper) Run and protect: repoStats, Return response: {u'b1eb16e3-bab4-41b2-b494-ede5775de80d': {'delay': '0', 'lastCheck': 1350376420.1520071,
Thread-697::INFO::2012-10-16 10:35:35,310::logUtils::39::dispatcher::(wrapper) Run and protect: repoStats, Return response: {u'b1eb16e3-bab4-41b2-b494-ede5775de80d': {'delay': '0', 'lastCheck': 1350376420.1520071,
Thread-707::INFO::2012-10-16 10:35:45,706::logUtils::39::dispatcher::(wrapper) Run and protect: repoStats, Return response: {u'b1eb16e3-bab4-41b2-b494-ede5775de80d': {'delay': '0', 'lastCheck': 1350376420.1520071,
Thread-717::INFO::2012-10-16 10:35:56,010::logUtils::39::dispatcher::(wrapper) Run and protect: repoStats, Return response: {u'b1eb16e3-bab4-41b2-b494-ede5775de80d': {'delay': '0', 'lastCheck': 1350376546.653511,
Thread-723::INFO::2012-10-16 10:36:06,236::logUtils::39::dispatcher::(wrapper) Run and protect: repoStats, Return response: {u'b1eb16e3-bab4-41b2-b494-ede5775de80d': {'delay': '0', 'lastCheck': 1350376546.653511,
Thread-729::INFO::2012-10-16 10:36:16,469::logUtils::39::dispatcher::(wrapper) Run and protect: repoStats, Return response: {u'b1eb16e3-bab4-41b2-b494-ede5775de80d': {'delay': '0', 'lastCheck': 1350376546.653511,
Thread-735::INFO::2012-10-16 10:36:26,694::logUtils::39::dispatcher::(wrapper) Run and protect: repoStats, Return response: {u'b1eb16e3-bab4-41b2-b494-ede5775de80d': {'delay': '0', 'lastCheck': 1350376546.653511,
Thread-741::INFO::2012-10-16 10:36:36,923::logUtils::39::dispatcher::(wrapper) Run and protect: repoStats, Return response: {u'b1eb16e3-bab4-41b2-b494-ede5775de80d': {'delay': '0', 'lastCheck': 1350376546.653511,
Thread-747::INFO::2012-10-16 10:36:47,157::logUtils::39::dispatcher::(wrapper) Run and protect: repoStats, Return response: {u'b1eb16e3-bab4-41b2-b494-ede5775de80d': {'delay': '0', 'lastCheck': 1350376546.653511,
Thread-755::INFO::2012-10-16 10:36:57,400::logUtils::39::dispatcher::(wrapper) Run and protect: repoStats, Return response: {u'b1eb16e3-bab4-41b2-b494-ede5775de80d': {'delay': '0', 'lastCheck': 1350376546.653511,
Thread-761::INFO::2012-10-16 10:37:07,621::logUtils::39::dispatcher::(wrapper) Run and protect: repoStats, Return response: {u'b1eb16e3-bab4-41b2-b494-ede5775de80d': {'delay': '0', 'lastCheck': 1350376546.653511,
Thread-767::INFO::2012-10-16 10:37:17,852::logUtils::39::dispatcher::(wrapper) Run and protect: repoStats, Return response: {u'b1eb16e3-bab4-41b2-b494-ede5775de80d': {'delay': '0', 'lastCheck': 1350376546.653511,
Thread-773::INFO::2012-10-16 10:37:28,037::logUtils::39::dispatcher::(wrapper) Run and protect: repoStats, Return response: {u'b1eb16e3-bab4-41b2-b494-ede5775de80d': {'delay': '0', 'lastCheck': 1350376546.653511,
Thread-779::INFO::2012-10-16 10:37:39,695::logUtils::39::dispatcher::(wrapper) Run and protect: repoStats, Return response: {u'b1eb16e3-bab4-41b2-b494-ede5775de80d': {'delay': '0', 'lastCheck': 1350376546.653511,
Thread-785::INFO::2012-10-16 10:37:49,909::logUtils::39::dispatcher::(wrapper) Run and protect: repoStats, Return response: {u'b1eb16e3-bab4-41b2-b494-ede5775de80d': {'delay': '0', 'lastCheck': 1350376667.949584,
Thread-795::INFO::2012-10-16 10:38:00,125::logUtils::39::dispatcher::(wrapper) Run and protect: repoStats, Return response: {u'b1eb16e3-bab4-41b2-b494-ede5775de80d': {'delay': '0', 'lastCheck': 1350376667.949584,
Thread-802::INFO::2012-10-16 10:38:10,659::logUtils::39::dispatcher::(wrapper) Run and protect: repoStats, Return response: {u'b1eb16e3-bab4-41b2-b494-ede5775de80d': {'delay': '0', 'lastCheck': 1350376667.949584,
Thread-808::INFO::2012-10-16 10:38:20,871::logUtils::39::dispatcher::(wrapper) Run and protect: repoStats, Return response: {u'b1eb16e3-bab4-41b2-b494-ede5775de80d': {'delay': '0', 'lastCheck': 1350376667.949584,
Thread-814::INFO::2012-10-16 10:38:31,127::logUtils::39::dispatcher::(wrapper) Run and protect: repoStats, Return response: {u'b1eb16e3-bab4-41b2-b494-ede5775de80d': {'delay': '0', 'lastCheck': 1350376667.949584,
Thread-820::INFO::2012-10-16 10:38:41,340::logUtils::39::dispatcher::(wrapper) Run and protect: repoStats, Return response: {u'b1eb16e3-bab4-41b2-b494-ede5775de80d': {'delay': '0', 'lastCheck': 1350376667.949584,
Thread-826::INFO::2012-10-16 10:38:51,522::logUtils::39::dispatcher::(wrapper) Run and protect: repoStats, Return response: {u'b1eb16e3-bab4-41b2-b494-ede5775de80d': {'delay': '0', 'lastCheck': 1350376667.949584,
Thread-834::INFO::2012-10-16 10:39:01,726::logUtils::39::dispatcher::(wrapper) Run and protect: repoStats, Return response: {u'b1eb16e3-bab4-41b2-b494-ede5775de80d': {'delay': '0', 'lastCheck': 1350376667.949584,
Thread-840::INFO::2012-10-16 10:39:11,925::logUtils::39::dispatcher::(wrapper) Run and protect: repoStats, Return response: {u'b1eb16e3-bab4-41b2-b494-ede5775de80d': {'delay': '0', 'lastCheck': 1350376667.949584,
Thread-846::INFO::2012-10-16 10:39:22,127::logUtils::39::dispatcher::(wrapper) Run and protect: repoStats, Return response: {u'b1eb16e3-bab4-41b2-b494-ede5775de80d': {'delay': '0', 'lastCheck': 1350376667.949584,
Thread-852::INFO::2012-10-16 10:39:32,335::logUtils::39::dispatcher::(wrapper) Run and protect: repoStats, Return response: {u'b1eb16e3-bab4-41b2-b494-ede5775de80d': {'delay': '0', 'lastCheck': 1350376667.949584,
Thread-858::INFO::2012-10-16 10:39:42,550::logUtils::39::dispatcher::(wrapper) Run and protect: repoStats, Return response: {u'b1eb16e3-bab4-41b2-b494-ede5775de80d': {'delay': '0', 'lastCheck': 1350376667.949584,
Thread-864::INFO::2012-10-16 10:39:52,761::logUtils::39::dispatcher::(wrapper) Run and protect: repoStats, Return response: {u'b1eb16e3-bab4-41b2-b494-ede5775de80d': {'delay': '0', 'lastCheck': 1350376667.949584,
Thread-874::INFO::2012-10-16 10:40:02,998::logUtils::39::dispatcher::(wrapper) Run and protect: repoStats, Return response: {u'b1eb16e3-bab4-41b2-b494-ede5775de80d': {'delay': '0', 'lastCheck': 1350376796.714067,
Thread-883::INFO::2012-10-16 10:40:13,213::logUtils::39::dispatcher::(wrapper) Run and protect: repoStats, Return response: {u'b1eb16e3-bab4-41b2-b494-ede5775de80d': {'delay': '0', 'lastCheck': 1350376796.714067,
Thread-901::INFO::2012-10-16 10:40:23,435::logUtils::39::dispatcher::(wrapper) Run and protect: repoStats, Return response: {u'b1eb16e3-bab4-41b2-b494-ede5775de80d': {'delay': '0.00283217430115', 'lastCheck': 1350
(END)