Project

Profile

Help

Issue #1932 ยป fail-to-sync-sat61-rhel6.txt

Log output from another user who hit the same problem - mhrivnak, 05/23/2016 05:50 PM

 
1
-- Logs begin at Mon 2016-05-23 10:20:25 CEST, end at Mon 2016-05-23 10:47:37 CEST. --
2
May 23 10:47:23 sat62.egolov.example.com pulp[1318]: kombu.transport.qpid:INFO: Connected to qpid with SASL mechanism ANONYMOUS
3
May 23 10:47:23 sat62.egolov.example.com pulp[912]: celery.worker.strategy:INFO: Received task: pulp.server.async.tasks._queue_reserved_task[b5c887d0-67a6-4dba-92b1-972dbd15dc61]
4
May 23 10:47:23 sat62.egolov.example.com pulp[1022]: celery.worker.strategy:INFO: Received task: pulp.server.managers.repo.sync.sync[c3f6b48a-a2c6-4a73-a42b-52a9a882d5f3]
5
May 23 10:47:23 sat62.egolov.example.com pulp[1022]: celery.worker.strategy:INFO: Received task: pulp.server.async.tasks._release_resource[3cc56bef-4db0-4fbb-bb34-7514265d106e]
6
May 23 10:47:23 sat62.egolov.example.com pulp[912]: celery.worker.job:INFO: Task pulp.server.async.tasks._queue_reserved_task[b5c887d0-67a6-4dba-92b1-972dbd15dc61] succeeded in 0.0368095180002s: None
7
May 23 10:47:23 sat62.egolov.example.com pulp[1764]: pulp_rpm.plugins.importers.yum.sync:INFO: Downloading metadata from https://cdn.redhat.com/content/dist/rhel/server/6/6Server/x86_64/satellite/6.1/os/.
8
May 23 10:47:23 sat62.egolov.example.com pulp[1764]: requests.packages.urllib3.connectionpool:INFO: Starting new HTTPS connection (1): cdn.redhat.com
9
May 23 10:47:26 sat62.egolov.example.com pulp[1764]: pulp_rpm.plugins.importers.yum.sync:INFO: Parsing metadata.
10
May 23 10:47:26 sat62.egolov.example.com pulp[1764]: pulp_rpm.plugins.importers.yum.sync:INFO: Downloading metadata from https://cdn.redhat.com/content/dist/rhel/server/6/6Server/x86_64/satellite/6.1/os/.
11
May 23 10:47:26 sat62.egolov.example.com pulp[1764]: requests.packages.urllib3.connectionpool:INFO: Starting new HTTPS connection (1): cdn.redhat.com
12
May 23 10:47:27 sat62.egolov.example.com pulp[1764]: pulp_rpm.plugins.importers.yum.sync:INFO: Parsing metadata.
13
May 23 10:47:27 sat62.egolov.example.com pulp[1764]: pulp_rpm.plugins.importers.yum.sync:INFO: Downloading metadata from https://cdn.redhat.com/content/dist/rhel/server/6/6Server/x86_64/satellite/6.1/os/.
14
May 23 10:47:27 sat62.egolov.example.com pulp[1764]: requests.packages.urllib3.connectionpool:INFO: Starting new HTTPS connection (1): cdn.redhat.com
15
May 23 10:47:28 sat62.egolov.example.com pulp[1764]: pulp_rpm.plugins.importers.yum.sync:INFO: Parsing metadata.
16
May 23 10:47:28 sat62.egolov.example.com pulp[1764]: pulp_rpm.plugins.importers.yum.sync:INFO: Downloading metadata files.
17
May 23 10:47:28 sat62.egolov.example.com pulp[1764]: requests.packages.urllib3.connectionpool:INFO: Starting new HTTPS connection (2): cdn.redhat.com
18
May 23 10:47:28 sat62.egolov.example.com pulp[1764]: requests.packages.urllib3.connectionpool:INFO: Starting new HTTPS connection (3): cdn.redhat.com
19
May 23 10:47:28 sat62.egolov.example.com pulp[1764]: requests.packages.urllib3.connectionpool:INFO: Starting new HTTPS connection (4): cdn.redhat.com
20
May 23 10:47:28 sat62.egolov.example.com pulp[1764]: requests.packages.urllib3.connectionpool:INFO: Starting new HTTPS connection (5): cdn.redhat.com
21
May 23 10:47:30 sat62.egolov.example.com pulp[1764]: pulp_rpm.plugins.importers.yum.sync:INFO: Generating metadata databases.
22
May 23 10:47:32 sat62.egolov.example.com pulp[1764]: pulp_rpm.plugins.importers.yum.sync:INFO: Determining which units need to be downloaded.
23
May 23 10:47:37 sat62.egolov.example.com pulp[1764]: pulp_rpm.plugins.importers.yum.sync:ERROR: (1764-13856) '\xff\xff\xff\xffX{\x14\x06'
24
May 23 10:47:37 sat62.egolov.example.com pulp[1764]: pulp_rpm.plugins.importers.yum.sync:ERROR: (1764-13856) Traceback (most recent call last):
25
May 23 10:47:37 sat62.egolov.example.com pulp[1764]: pulp_rpm.plugins.importers.yum.sync:ERROR: (1764-13856)   File "/usr/lib/python2.7/site-packages/pulp_rpm/plugins/importers/yum/sync.py", line 220, in run
26
May 23 10:47:37 sat62.egolov.example.com pulp[1764]: pulp_rpm.plugins.importers.yum.sync:ERROR: (1764-13856)     self.update_content(metadata_files, url)
27
May 23 10:47:37 sat62.egolov.example.com pulp[1764]: pulp_rpm.plugins.importers.yum.sync:ERROR: (1764-13856)   File "/usr/lib/python2.7/site-packages/pulp_rpm/plugins/importers/yum/sync.py", line 448, in update_content
28
May 23 10:47:37 sat62.egolov.example.com pulp[1764]: pulp_rpm.plugins.importers.yum.sync:ERROR: (1764-13856)     self.download_rpms(metadata_files, rpms_to_download, url)
29
May 23 10:47:37 sat62.egolov.example.com pulp[1764]: pulp_rpm.plugins.importers.yum.sync:ERROR: (1764-13856)   File "/usr/lib/python2.7/site-packages/pulp_rpm/plugins/importers/yum/sync.py", line 636, in download_rpms
30
May 23 10:47:37 sat62.egolov.example.com pulp[1764]: pulp_rpm.plugins.importers.yum.sync:ERROR: (1764-13856)     self.add_rpm_unit(metadata_files, unit)
31
May 23 10:47:37 sat62.egolov.example.com pulp[1764]: pulp_rpm.plugins.importers.yum.sync:ERROR: (1764-13856)   File "/usr/lib/python2.7/site-packages/pulp_rpm/plugins/importers/yum/sync.py", line 589, in add_rpm_unit
32
May 23 10:47:37 sat62.egolov.example.com pulp[1764]: pulp_rpm.plugins.importers.yum.sync:ERROR: (1764-13856)     metadata_files.add_repodata(unit)
33
May 23 10:47:37 sat62.egolov.example.com pulp[1764]: pulp_rpm.plugins.importers.yum.sync:ERROR: (1764-13856)   File "/usr/lib/python2.7/site-packages/pulp_rpm/plugins/importers/yum/repomd/metadata.py", line 338, in add_repodata
34
May 23 10:47:37 sat62.egolov.example.com pulp[1764]: pulp_rpm.plugins.importers.yum.sync:ERROR: (1764-13856)     raw_xml = db_file[db_key]
35
May 23 10:47:37 sat62.egolov.example.com pulp[1764]: pulp_rpm.plugins.importers.yum.sync:ERROR: (1764-13856) KeyError: '\xff\xff\xff\xffX{\x14\x06'
36
May 23 10:47:37 sat62.egolov.example.com pulp[1764]: pulp.server.event.http:INFO: (1764-13856) {"call_report": {"exception": null, "task_type": "pulp.server.managers.repo.sync.sync", "_href": "/pulp/api/v2/tasks/c3f6b48a-a2c6-4a73-a42b-52a9a882d5f3/", "task_id": "c3f6b48a-a2c6-4a73-a42b-52a9a882d5f3", "tags": ["pulp:repository:ACME-Red_Hat_Satellite-Red_Hat_Satellite_6_1_for_RHEL_6_Server_RPMs_x86_64", "pulp:action:sync"], "finish_time": null, "_ns": "task_status", "start_time": "2016-05-23T08:47:23Z", "traceback": null, "spawned_tasks": [], "progress_report": {"yum_importer": {"content": {"size_total": 32359729, "items_left": 24, "items_total": 24, "state": "FAILED", "size_left": 32359729, "details": {"rpm_total": 24, "rpm_done": 0, "drpm_total": 0, "drpm_done": 0}, "error": "'\\xff\\xff\\xff\\xffX{\\x14\\x06'", "error_details": []}, "comps": {"state": "NOT_STARTED"}, "purge_duplicates": {"state": "NOT_STARTED"}, "distribution": {"items_total": 0, "state": "NOT_STARTED", "error_details": [], "items_left": 0}, "errata": {"state": "NOT_STARTED"}, "metadata": {"state": "FINISHED"}}}, "state": "running", "worker_name": "reserved_resource_worker-1@sat62.egolov.example.com", "result": null, "error": null, "_id": {"$oid": "5742c39b31afc2ae41e954a9"}, "id": "5742c39b31afc2ae41e954a9"}, "event_type": "repo.sync.finish", "payload": {"importer_id": "yum_importer", "exception": null, "repo_id": "ACME-Red_Hat_Satellite-Red_Hat_Satellite_6_1_for_RHEL_6_Server_RPMs_x86_64", "traceback": null, "started": "2016-05-23T08:47:23Z", "_ns": "repo_sync_results", "completed": "2016-05-23T08:47:37Z", "importer_type_id": "yum_importer", "error_message": null, "summary": {"content": {"state": "FAILED"}, "comps": {"state": "NOT_STARTED"}, "purge_duplicates": {"state": "NOT_STARTED"}, "distribution": {"state": "NOT_STARTED"}, "errata": {"state": "NOT_STARTED"}, "metadata": {"state": "FINISHED"}}, "added_count": 0, "result": "failed", "updated_count": 637, "details": {"content": {"size_total": 32359729, "items_left": 24, "items_total": 24, "state": "FAILED", "size_left": 32359729,
37
May 23 10:47:37 sat62.egolov.example.com pulp[1764]: pulp.server.event.http:INFO: (1764-13856)  "details": {"rpm_total": 24, "rpm_done": 0, "drpm_total": 0, "drpm_done": 0}, "error": "'\\xff\\xff\\xff\\xffX{\\x14\\x06'", "error_details": []}, "comps": {"state": "NOT_STARTED"}, "purge_duplicates": {"state": "NOT_STARTED"}, "distribution": {"items_total": 0, "state": "NOT_STARTED", "error_details": [], "items_left": 0}, "errata": {"state": "NOT_STARTED"}, "metadata": {"state": "FINISHED"}}, "id": "5742c3a95d7c0606e4c8a380", "removed_count": 0}}
38
May 23 10:47:37 sat62.egolov.example.com pulp[1764]: requests.packages.urllib3.connectionpool:INFO: Starting new HTTPS connection (1): sat62.egolov.example.com
39
May 23 10:47:37 sat62.egolov.example.com pulp[1764]: pulp.server.async.tasks:INFO: Task failed : [c3f6b48a-a2c6-4a73-a42b-52a9a882d5f3]
40
May 23 10:47:37 sat62.egolov.example.com pulp[1022]: celery.worker.job:ERROR: (1022-13856) Task pulp.server.managers.repo.sync.sync[c3f6b48a-a2c6-4a73-a42b-52a9a882d5f3] raised unexpected: PulpExecutionException('Importer indicated a failed response',)
41
May 23 10:47:37 sat62.egolov.example.com pulp[1022]: celery.worker.job:ERROR: (1022-13856) Traceback (most recent call last):
42
May 23 10:47:37 sat62.egolov.example.com pulp[1022]: celery.worker.job:ERROR: (1022-13856)   File "/usr/lib/python2.7/site-packages/celery/app/trace.py", line 240, in trace_task
43
May 23 10:47:37 sat62.egolov.example.com pulp[1022]: celery.worker.job:ERROR: (1022-13856)     R = retval = fun(*args, **kwargs)
44
May 23 10:47:37 sat62.egolov.example.com pulp[1022]: celery.worker.job:ERROR: (1022-13856)   File "/usr/lib/python2.7/site-packages/pulp/server/async/tasks.py", line 473, in __call__
45
May 23 10:47:37 sat62.egolov.example.com pulp[1022]: celery.worker.job:ERROR: (1022-13856)     return super(Task, self).__call__(*args, **kwargs)
46
May 23 10:47:37 sat62.egolov.example.com pulp[1022]: celery.worker.job:ERROR: (1022-13856)   File "/usr/lib/python2.7/site-packages/pulp/server/async/tasks.py", line 103, in __call__
47
May 23 10:47:37 sat62.egolov.example.com pulp[1022]: celery.worker.job:ERROR: (1022-13856)     return super(PulpTask, self).__call__(*args, **kwargs)
48
May 23 10:47:37 sat62.egolov.example.com pulp[1022]: celery.worker.job:ERROR: (1022-13856)   File "/usr/lib/python2.7/site-packages/celery/app/trace.py", line 437, in __protected_call__
49
May 23 10:47:37 sat62.egolov.example.com pulp[1022]: celery.worker.job:ERROR: (1022-13856)     return self.run(*args, **kwargs)
50
May 23 10:47:37 sat62.egolov.example.com pulp[1022]: celery.worker.job:ERROR: (1022-13856)   File "/usr/lib/python2.7/site-packages/pulp/server/controllers/repository.py", line 810, in sync
51
May 23 10:47:37 sat62.egolov.example.com pulp[1022]: celery.worker.job:ERROR: (1022-13856)     raise pulp_exceptions.PulpExecutionException(_('Importer indicated a failed response'))
52
May 23 10:47:37 sat62.egolov.example.com pulp[1022]: celery.worker.job:ERROR: (1022-13856) PulpExecutionException: Importer indicated a failed response
53
May 23 10:47:37 sat62.egolov.example.com pulp[1022]: celery.worker.job:INFO: Task pulp.server.async.tasks._release_resource[3cc56bef-4db0-4fbb-bb34-7514265d106e] succeeded in 0.00672736299998s: None
    (1-1/1)