Bug 1145710

Summary:	Node sync throwing trace in child pulp logs re: missing resource
Product:	Red Hat Satellite	Reporter:	Bryan Kearney <bkearney>
Component:	Pulp	Assignee:	satellite6-bugs <satellite6-bugs>
Status:	CLOSED DUPLICATE	QA Contact:	Katello QA List <katello-qa-list>
Severity:	low	Docs Contact:
Priority:	medium
Version:	Unspecified	CC:	bkearney, cwelton, jsherril, katello-qa-list, mhrivnak, mmccune, omaciel, pthomas, rbarlow
Target Milestone:	Unspecified	Keywords:	Reopened
Target Release:	Unused
Hardware:	Unspecified
OS:	Unspecified
Whiteboard:
Fixed In Version:		Doc Type:	Bug Fix
Doc Text:		Story Points:	---
Clone Of:	1021563	Environment:
Last Closed:	2015-03-05 21:50:19 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:
Bug Blocks:	950746, 1021563

Comment 1 Michael Hrivnak 2014-11-05 16:20:33 UTC

This appears to be a case of over-eager logging that we believe has been fixed.

Comment 2 Chris Duryee 2014-12-23 20:52:22 UTC

fixed in pulp 2.6.0-0.2.beta

Comment 3 Preethi Thomas 2015-01-29 21:08:36 UTC

verified

[root@cloud-qe-4 ~]# rpm -qa |grep pulp-nodes
pulp-nodes-admin-extensions-2.6.0-0.5.beta.el7.noarch
pulp-nodes-parent-2.6.0-0.5.beta.el7.noarch
pulp-nodes-common-2.6.0-0.5.beta.el7.noarch
[root@cloud-qe-4 ~]# 


No missing resource exception in the consumer's log during node sync

Jan 29 22:05:08 ibm-x3550m3-07 goferd: [INFO][worker-0] gofer.rmi.dispatcher:610 - call: Content.update() sn=8086a36f-7b10-416c-922a-11f6242833a8 data={'task_id': '9c922f7d-97ad-4d13-8845-5df57be0e4a0', 'consumer_id': 'foo'}
Jan 29 22:05:09 ibm-x3550m3-07 pulp: pulp.server.webservices.middleware.exception:INFO: Missing resource(s): repo=pulp-el6
Jan 29 22:05:10 ibm-x3550m3-07 goferd: [INFO][worker-0] pulp_node.handlers.model:384 - Distributor: pulp-el6/yum_distributor, added
Jan 29 22:05:10 ibm-x3550m3-07 goferd: [INFO][worker-0] pulp_node.handlers.model:384 - Distributor: pulp-el6/export_distributor, added
Jan 29 22:05:10 ibm-x3550m3-07 pulp: kombu.transport.qpid:INFO: Connected to qpid with SASL mechanism ANONYMOUS
Jan 29 22:05:10 ibm-x3550m3-07 pulp: celery.worker.strategy:INFO: Received task: pulp.server.async.tasks._queue_reserved_task[205b69ed-1488-4355-a0e0-bd1107b5b3c4]
Jan 29 22:05:10 ibm-x3550m3-07 goferd: [INFO][worker-0] pulp_node.handlers.model:465 - Importer pulp-el6/nodes_http_importer, added
Jan 29 22:05:10 ibm-x3550m3-07 goferd: [INFO][worker-0] pulp_node.handlers.model:186 - Repository: pulp-el6, added
Jan 29 22:05:10 ibm-x3550m3-07 pulp: kombu.transport.qpid:INFO: Connected to qpid with SASL mechanism ANONYMOUS
Jan 29 22:05:10 ibm-x3550m3-07 pulp: celery.worker.strategy:INFO: Received task: pulp.server.managers.repo.importer.set_importer[0aab63e3-9a44-43da-a4d1-4a2568e6f291]
Jan 29 22:05:10 ibm-x3550m3-07 pulp: celery.worker.strategy:INFO: Received task: pulp.server.async.tasks._release_resource[540cefc8-d437-42f3-926f-d7adb4e04d9d]
Jan 29 22:05:10 ibm-x3550m3-07 pulp: celery.worker.job:INFO: Task pulp.server.async.tasks._queue_reserved_task[205b69ed-1488-4355-a0e0-bd1107b5b3c4] succeeded in 0.0850018560013s: None
Jan 29 22:05:10 ibm-x3550m3-07 pulp: celery.worker.strategy:INFO: Received task: pulp.server.async.tasks._queue_reserved_task[cfc806e1-6bc6-4f9c-93eb-fbb94a55df0d]
Jan 29 22:05:10 ibm-x3550m3-07 pulp: celery.worker.strategy:INFO: Received task: pulp.server.tasks.repository.sync_with_auto_publish[985bdbe1-0b19-4d0b-ae94-2309bfb68705]
Jan 29 22:05:10 ibm-x3550m3-07 pulp: celery.worker.job:INFO: Task pulp.server.async.tasks._queue_reserved_task[cfc806e1-6bc6-4f9c-93eb-fbb94a55df0d] succeeded in 0.0354431169981s: None
Jan 29 22:05:10 ibm-x3550m3-07 pulp: celery.worker.job:INFO: Task pulp.server.managers.repo.importer.set_importer[0aab63e3-9a44-43da-a4d1-4a2568e6f291] succeeded in 0.0486039999996s: {'repo_id': u'pulp-el6', '_ns': u'repo_importers', 'importer_type_id': 'nodes_http_importer', 'last_sync': None,...
Jan 29 22:05:10 ibm-x3550m3-07 pulp: celery.worker.strategy:INFO: Received task: pulp.server.async.tasks._release_resource[410e6e21-969b-4103-bbea-095a45750577]
Jan 29 22:05:10 ibm-x3550m3-07 pulp: celery.worker.job:INFO: Task pulp.server.async.tasks._release_resource[540cefc8-d437-42f3-926f-d7adb4e04d9d] succeeded in 0.0424924250001s: None
Jan 29 22:05:10 ibm-x3550m3-07 pulp: requests.packages.urllib3.connectionpool:INFO: Starting new HTTPS connection (1): cloud-qe-4.idmqe.lab.eng.bos.redhat.com
Jan 29 22:05:11 ibm-x3550m3-07 pulp: requests.packages.urllib3.connectionpool:INFO: Starting new HTTPS connection (1): cloud-qe-4.idmqe.lab.eng.bos.redhat.com
Jan 29 22:05:14 ibm-x3550m3-07 pulp: requests.packages.urllib3.connectionpool:INFO: Starting new HTTPS connection (1): cloud-qe-4.idmqe.lab.eng.bos.redhat.com
Jan 29 22:05:14 ibm-x3550m3-07 pulp: requests.packages.urllib3.connectionpool:INFO: Starting new HTTPS connection (1): cloud-qe-4.idmqe.lab.eng.bos.redhat.com
Jan 29 22:05:14 ibm-x3550m3-07 pulp: requests.packages.urllib3.connectionpool:INFO: Starting new HTTPS connection (1): cloud-qe-4.idmqe.lab.eng.bos.redhat.com
Jan 29 22:05:14 ibm-x3550m3-07 pulp: requests.packages.urllib3.connectionpool:INFO: Starting new HTTPS connection (1): cloud-qe-4.idmqe.lab.eng.bos.redhat.com
Jan 29 22:05:14 ibm-x3550m3-07 pulp: requests.packages.urllib3.connectionpool:INFO: Starting new HTTPS connection (1): cloud-qe-4.idmqe.lab.eng.bos.redhat.com
Jan 29 22:05:49 ibm-x3550m3-07 pulp: kombu.transport.qpid:INFO: Connected to qpid with SASL mechanism ANONYMOUS
Jan 29 22:05:49 ibm-x3550m3-07 pulp: celery.worker.strategy:INFO: Received task: pulp.server.async.tasks._queue_reserved_task[d476bfb5-576c-42b6-b25e-33d41895aae0]
Jan 29 22:05:49 ibm-x3550m3-07 pulp: celery.worker.job:INFO: Task pulp.server.tasks.repository.sync_with_auto_publish[985bdbe1-0b19-4d0b-ae94-2309bfb68705] succeeded in 38.594566332s: <pulp.server.async.tasks.TaskResult object at 0x2bbbf50>
Jan 29 22:05:49 ibm-x3550m3-07 pulp: celery.worker.job:INFO: Task pulp.server.async.tasks._release_resource[410e6e21-969b-4103-bbea-095a45750577] succeeded in 0.0143028669991s: None
Jan 29 22:05:49 ibm-x3550m3-07 pulp: celery.worker.strategy:INFO: Received task: pulp.server.managers.repo.publish.publish[cb549815-4696-4881-90b1-d166faa80383]
Jan 29 22:05:49 ibm-x3550m3-07 pulp: celery.worker.job:INFO: Task pulp.server.async.tasks._queue_reserved_task[d476bfb5-576c-42b6-b25e-33d41895aae0] succeeded in 0.0348205640003s: None
Jan 29 22:05:49 ibm-x3550m3-07 pulp: celery.worker.strategy:INFO: Received task: pulp.server.async.tasks._release_resource[be0699a0-070f-4793-846a-c09fd54f0572]
Jan 29 22:05:49 ibm-x3550m3-07 pulp: celery.worker.job:INFO: Task pulp.server.managers.repo.publish.publish[cb549815-4696-4881-90b1-d166faa80383] succeeded in 0.279283960997s: {'exception': None, 'repo_id': u'pulp-el6', 'traceback': None, 'started': '2015-01-29T21:05:49Z', '_ns':...
Jan 29 22:05:49 ibm-x3550m3-07 pulp: celery.worker.job:INFO: Task pulp.server.async.tasks._release_resource[be0699a0-070f-4793-846a-c09fd54f0572] succeeded in 0.00952844700078s: None
Jan 29 22:05:50 ibm-x3550m3-07 goferd: [INFO][worker-0] gofer.agent.rmi:160 - sn=8086a36f-7b10-416c-922a-11f6242833a8 processed in: 42.677 (seconds)

Comment 4 Brian Bouterse 2015-02-28 22:21:24 UTC

Moved to https://pulp.plan.io/issues/537

Comment 5 RHEL Program Management 2015-03-04 11:24:03 UTC

Since this issue was entered in Red Hat Bugzilla, the release flag has been
set to ? to ensure that it is properly evaluated for this release.

Comment 7 Brian Bouterse 2015-03-05 21:50:19 UTC


*** This bug has been marked as a duplicate of bug 1021563 ***