[Pulp-list] Pulp-list Digest, Vol 62, Issue 10
Paul Jochum
paul.jochum at alcatel-lucent.com
Mon Jan 12 20:26:28 UTC 2015
On 01/12/2015 02:07 PM, pulp-list-request at redhat.com wrote:
> Message: 2
> Date: Mon, 12 Jan 2015 10:31:02 -0500
> From: Randy Barlow <rbarlow at redhat.com>
> To: pulp-list at redhat.com
> Subject: Re: [Pulp-list] pulp sync - reader can't store
> Message-ID: <54B3E8B6.4020403 at redhat.com>
> Content-Type: text/plain; charset="windows-1252"
>
> On 01/12/2015 09:04 AM, Paul Jochum wrote:
>> Any suggestions on how to fix this?
> Can you show us the server side tracebacks? The PulpExecutionException
> is unfortunately not a useful one, and it will be the second of two. If
> you can show us the traceback that precedes that one, it might be
> helpful. If you are unsure, just capture 50-100 lines of logs around the
> time of the error. Thanks!
>
> -------------- next part --------------
> A non-text attachment was scrubbed...
> Name: signature.asc
> Type: application/pgp-signature
> Size: 819 bytes
> Desc: OpenPGP digital signature
> URL: <https://www.redhat.com/archives/pulp-list/attachments/20150112/92aaf5a4/attachment.bin>
>
> ------------------------------
>
Hi Randy:
I hope I got the correct info from the log file
~/.pulp/server_calls.log, please let me know if I can provide any other
log data.
thanks,
Paul
~/.pulp/server_calls.log:
2015-01-12 08:54:31,306 - INFO - Response body :
{
"exception": null,
"task_type": "pulp.server.tasks.repository.sync_with_auto_publish",
"_href": "/pulp/api/v2/tasks/cdbef36b-22ea-4459-8d8e-4c7649a61127/",
"task_id": "cdbef36b-22ea-4459-8d8e-4c7649a61127",
"tags": [
"pulp:repository:rhel-x86_64-server-7",
"pulp:action:sync"
],
"finish_time": null,
"_ns": "task_status",
"start_time": "2015-01-12T13:54:19Z",
"traceback": null,
"spawned_tasks": [],
"progress_report": {
"yum_importer": {
"content": {
"size_total": 0,
"items_left": 0,
"items_total": 0,
"state": "NOT_STARTED",
"size_left": 0,
"details": {
"rpm_total": 0,
"rpm_done": 0,
"drpm_total": 0,
"drpm_done": 0
},
"error_details": []
},
"comps": {
"state": "NOT_STARTED"
},
"distribution": {
"items_total": 0,
"state": "NOT_STARTED",
"error_details": [],
"items_left": 0
},
"errata": {
"state": "NOT_STARTED"
},
"metadata": {
"state": "IN_PROGRESS"
}
}
},
"queue": "reserved_resource_worker-4 at lss-pulp02.ih.lucent.com.dq",
"state": "running",
"result": null,
"error": null,
"_id": {
"$oid": "54b3d20b54bb070cb246093f"
},
"id": "54b3d20b6a7b404cf71a6cd3"
}
2015-01-12 08:54:32,365 - INFO - GET request to
/pulp/api/v2/tasks/cdbef36b-22ea-4459-8d8e-4c7649a61127/ with parameters
None
2015-01-12 08:54:32,365 - INFO - Response status : 200
2015-01-12 08:54:32,365 - INFO - Response body :
{
"exception": null,
"task_type": "pulp.server.tasks.repository.sync_with_auto_publish",
"_href": "/pulp/api/v2/tasks/cdbef36b-22ea-4459-8d8e-4c7649a61127/",
"task_id": "cdbef36b-22ea-4459-8d8e-4c7649a61127",
"tags": [
"pulp:repository:rhel-x86_64-server-7",
"pulp:action:sync"
],
"finish_time": null,
"_ns": "task_status",
"start_time": "2015-01-12T13:54:19Z",
"traceback": null,
"spawned_tasks": [],
"progress_report": {
"yum_importer": {
"content": {
"size_total": 0,
"items_left": 0,
"items_total": 0,
"state": "NOT_STARTED",
"size_left": 0,
"details": {
"rpm_total": 0,
"rpm_done": 0,
"drpm_total": 0,
"drpm_done": 0
},
"error_details": []
},
"comps": {
"state": "NOT_STARTED"
},
"distribution": {
"items_total": 0,
"state": "NOT_STARTED",
"error_details": [],
"items_left": 0
},
"errata": {
"state": "NOT_STARTED"
},
"metadata": {
"state": "IN_PROGRESS"
}
}
},
"queue": "reserved_resource_worker-4 at lss-pulp02.ih.lucent.com.dq",
"state": "running",
"result": null,
"error": null,
"_id": {
"$oid": "54b3d20b54bb070cb246093f"
},
"id": "54b3d20b6a7b404cf71a6cd3"
}
2015-01-12 08:54:33,424 - INFO - GET request to
/pulp/api/v2/tasks/cdbef36b-22ea-4459-8d8e-4c7649a61127/ with parameters
None
2015-01-12 08:54:33,424 - INFO - Response status : 200
2015-01-12 08:54:33,425 - INFO - Response body :
{
"exception": null,
"task_type": "pulp.server.tasks.repository.sync_with_auto_publish",
"_href": "/pulp/api/v2/tasks/cdbef36b-22ea-4459-8d8e-4c7649a61127/",
"task_id": "cdbef36b-22ea-4459-8d8e-4c7649a61127",
"tags": [
"pulp:repository:rhel-x86_64-server-7",
"pulp:action:sync"
],
"finish_time": null,
"_ns": "task_status",
"start_time": "2015-01-12T13:54:19Z",
"traceback": null,
"spawned_tasks": [],
"progress_report": {
"yum_importer": {
"content": {
"size_total": 0,
"items_left": 0,
"items_total": 0,
"state": "NOT_STARTED",
"size_left": 0,
"details": {
"rpm_total": 0,
"rpm_done": 0,
"drpm_total": 0,
"drpm_done": 0
},
"error_details": []
},
"comps": {
"state": "NOT_STARTED"
},
"distribution": {
"items_total": 0,
"state": "NOT_STARTED",
"error_details": [],
"items_left": 0
},
"errata": {
"state": "NOT_STARTED"
},
"metadata": {
"state": "IN_PROGRESS"
}
}
},
"queue": "reserved_resource_worker-4 at lss-pulp02.ih.lucent.com.dq",
"state": "running",
"result": null,
"error": null,
"_id": {
"$oid": "54b3d20b54bb070cb246093f"
},
"id": "54b3d20b6a7b404cf71a6cd3"
}
Also, the following is from /var/log/messages (if it helps any):
Jan 12 08:54:19 lss-pulp02 pulp: celery.worker.strategy:INFO: Received
task:
pulp.server.async.tasks._reserve_resource[af70f8de-cbd3-4d67-a7d4-be268b7ab24b]
Jan 12 08:54:19 lss-pulp02 pulp: celery.worker.job:INFO: Task
pulp.server.async.tasks._reserve_resource[af70f8de-cbd3-4d67-a7d4-be268b7ab24b]
succeeded in 0.0407113959955s:
u'reserved_resource_worker-4 at lss-pulp02.ih.lucent.com.dq'
Jan 12 08:54:19 lss-pulp02 pulp: celery.worker.strategy:INFO: Received
task:
pulp.server.tasks.repository.sync_with_auto_publish[cdbef36b-22ea-4459-8d8e-4c7649a61127]
Jan 12 08:54:19 lss-pulp02 pulp:
pulp_rpm.plugins.importers.yum.sync:INFO: Downloading metadata from
https://cdn.redhat.com/content/dist/rhel/server/7/7Server/x86_64/os/.
Jan 12 08:54:19 lss-pulp02 pulp:
requests.packages.urllib3.connectionpool:INFO: Starting new HTTPS
connection (1): cdn.redhat.com
Jan 12 08:54:21 lss-pulp02 pulp:
pulp_rpm.plugins.importers.yum.sync:INFO: Parsing metadata.
Jan 12 08:54:21 lss-pulp02 pulp:
pulp_rpm.plugins.importers.yum.sync:INFO: Downloading metadata files.
Jan 12 08:54:21 lss-pulp02 pulp:
requests.packages.urllib3.connectionpool:INFO: Starting new HTTPS
connection (1): cdn.redhat.com
Jan 12 08:54:21 lss-pulp02 pulp:
requests.packages.urllib3.connectionpool:INFO: Starting new HTTPS
connection (1): cdn.redhat.com
Jan 12 08:54:21 lss-pulp02 pulp:
requests.packages.urllib3.connectionpool:INFO: Starting new HTTPS
connection (1): cdn.redhat.com
Jan 12 08:54:21 lss-pulp02 pulp:
requests.packages.urllib3.connectionpool:INFO: Starting new HTTPS
connection (1): cdn.redhat.com
Jan 12 08:54:21 lss-pulp02 pulp:
requests.packages.urllib3.connectionpool:INFO: Starting new HTTPS
connection (1): cdn.redhat.com
Jan 12 08:54:34 lss-pulp02 pulp:
pulp_rpm.plugins.importers.yum.sync:INFO: Generating metadata databases.
Jan 12 08:54:34 lss-pulp02 pulp:
pulp_rpm.plugins.importers.yum.sync:ERROR: sync failed
Jan 12 08:54:34 lss-pulp02 pulp:
pulp_rpm.plugins.importers.yum.sync:ERROR: Traceback (most recent call
last):
Jan 12 08:54:34 lss-pulp02 pulp:
pulp_rpm.plugins.importers.yum.sync:ERROR: File
"/usr/lib/python2.6/site-packages/pulp_rpm/plugins/importers/yum/sync.py",
line 104, in run
Jan 12 08:54:34 lss-pulp02 pulp:
pulp_rpm.plugins.importers.yum.sync:ERROR: metadata_files =
self.get_metadata()
Jan 12 08:54:34 lss-pulp02 pulp:
pulp_rpm.plugins.importers.yum.sync:ERROR: File
"/usr/lib/python2.6/site-packages/pulp_rpm/plugins/importers/yum/sync.py",
line 211, in get_metadata
Jan 12 08:54:34 lss-pulp02 pulp:
pulp_rpm.plugins.importers.yum.sync:ERROR: metadata_files.generate_dbs()
Jan 12 08:54:34 lss-pulp02 pulp:
pulp_rpm.plugins.importers.yum.sync:ERROR: File
"/usr/lib/python2.6/site-packages/pulp_rpm/plugins/importers/yum/repomd/metadata.py",
line 280, in generate_dbs
Jan 12 08:54:34 lss-pulp02 pulp:
pulp_rpm.plugins.importers.yum.sync:ERROR: db_file_handle[db_key] = raw_xml
Jan 12 08:54:34 lss-pulp02 pulp:
pulp_rpm.plugins.importers.yum.sync:ERROR: error: Reader can't store
Jan 12 08:54:34 lss-pulp02 pulp: celery.worker.job:ERROR: Task
pulp.server.tasks.repository.sync_with_auto_publish[cdbef36b-22ea-4459-8d8e-4c7649a61127]
raised unexpected: PulpExecutionException('Importer indicated a failed
response',)
Jan 12 08:54:34 lss-pulp02 pulp: celery.worker.job:ERROR: Traceback
(most recent call last):
Jan 12 08:54:34 lss-pulp02 pulp: celery.worker.job:ERROR: File
"/usr/lib/python2.6/site-packages/celery/app/trace.py", line 240, in
trace_task
Jan 12 08:54:34 lss-pulp02 pulp: celery.worker.job:ERROR: R = retval
= fun(*args, **kwargs)
Jan 12 08:54:34 lss-pulp02 pulp: celery.worker.job:ERROR: File
"/usr/lib/python2.6/site-packages/pulp/server/async/tasks.py", line 315,
in __call__
Jan 12 08:54:34 lss-pulp02 pulp: celery.worker.job:ERROR: return
super(Task, self).__call__(*args, **kwargs)
Jan 12 08:54:34 lss-pulp02 pulp: celery.worker.job:ERROR: File
"/usr/lib/python2.6/site-packages/celery/app/trace.py", line 437, in
__protected_call__
Jan 12 08:54:34 lss-pulp02 pulp: celery.worker.job:ERROR: return
self.run(*args, **kwargs)
Jan 12 08:54:34 lss-pulp02 pulp: celery.worker.job:ERROR: File
"/usr/lib/python2.6/site-packages/pulp/server/tasks/repository.py", line
210, in sync_with_auto_publish
Jan 12 08:54:34 lss-pulp02 pulp: celery.worker.job:ERROR: sync_result =
managers.repo_sync_manager().sync(repo_id, sync_config_override=overrides)
Jan 12 08:54:34 lss-pulp02 pulp: celery.worker.job:ERROR: File
"/usr/lib/python2.6/site-packages/pulp/server/managers/repo/sync.py",
line 113, in sync
Jan 12 08:54:34 lss-pulp02 pulp: celery.worker.job:ERROR: raise
PulpExecutionException(_('Importer indicated a failed response'))
Jan 12 08:54:34 lss-pulp02 pulp: celery.worker.job:ERROR:
PulpExecutionException: Importer indicated a failed response
Jan 12 10:54:36 lss-pulp02 pulp: celery.beat:INFO: Scheduler: Sending
due task reap_expired_documents
(pulp.server.db.reaper.reap_expired_documents)
Jan 12 10:54:36 lss-pulp02 pulp: celery.worker.strategy:INFO: Received
task:
pulp.server.db.reaper.reap_expired_documents[2dd6a858-1afa-4e42-acc3-4fffd603431c]
Jan 12 10:54:36 lss-pulp02 pulp: pulp.server.db.reaper:INFO: The reaper
task is cleaning out old documents from the database.
Jan 12 10:54:36 lss-pulp02 pulp: pulp.server.db.reaper:INFO: The reaper
task has completed.
Jan 12 10:54:36 lss-pulp02 pulp: celery.worker.job:INFO: Task
pulp.server.db.reaper.reap_expired_documents[2dd6a858-1afa-4e42-acc3-4fffd603431c]
succeeded in 0.0408673929924s: None
$
More information about the Pulp-list
mailing list