Project

Profile

Help

Issue #3353 » modularity_on_demand_journalctl.log

milan, 02/23/2018 03:02 PM

 
1
Feb 23 13:14:33 pulp2.dev pulp[24714]: celery.worker.strategy:INFO: Received task: pulp.server.async.tasks._queue_reserved_task[df45f51e-3d5a-4231-bed5-ea86f2f7f9a6]
2
Feb 23 13:14:33 pulp2.dev pulp[24718]: celery.worker.strategy:INFO: Received task: pulp.server.tasks.repository.delete[0ab5b94e-d033-4150-bd7d-c00f2661ea70]
3
Feb 23 13:14:33 pulp2.dev pulp[24942]: celery.app.trace:INFO: [df45f51e] Task pulp.server.async.tasks._queue_reserved_task[df45f51e-3d5a-4231-bed5-ea86f2f7f9a6] succeeded in 0.0146330120042s: None
4
Feb 23 13:14:33 pulp2.dev pulp[24718]: celery.worker.strategy:INFO: Received task: pulp.server.async.tasks._release_resource[95157bc5-045a-48dc-b9fe-c8f850fbd087]
5
Feb 23 13:14:33 pulp2.dev pulp[24938]: celery.app.trace:INFO: [0ab5b94e] Task pulp.server.tasks.repository.delete[0ab5b94e-d033-4150-bd7d-c00f2661ea70] succeeded in 0.388073639944s: <pulp.server.async.tasks.TaskResult object at 0x7fa7c8cc4e90>
6
Feb 23 13:14:33 pulp2.dev pulp[24938]: celery.app.trace:INFO: [95157bc5] Task pulp.server.async.tasks._release_resource[95157bc5-045a-48dc-b9fe-c8f850fbd087] succeeded in 0.00178559194319s: None
7
Feb 23 13:15:01 pulp2.dev pulp[24724]: celery.worker.strategy:INFO: Received task: pulp.server.managers.content.orphan.delete_all_orphans[165331ee-8976-432c-914f-b5d0979ec0a3]
8
Feb 23 13:15:03 pulp2.dev pulp[24988]: celery.app.trace:INFO: [165331ee] Task pulp.server.managers.content.orphan.delete_all_orphans[165331ee-8976-432c-914f-b5d0979ec0a3] succeeded in 2.8444106942s: {'yum_repo_metadata_file': 1}
9
Feb 23 13:16:48 pulp2.dev pulp[24714]: celery.worker.strategy:INFO: Received task: pulp.server.async.tasks._queue_reserved_task[02580283-b016-40b5-b19d-a714c01c0079]
10
Feb 23 13:16:49 pulp2.dev pulp[24718]: celery.worker.strategy:INFO: Received task: pulp.server.managers.repo.publish.publish[91046e77-cc4f-4714-a7d4-c99ee9114de9]
11
Feb 23 13:16:49 pulp2.dev pulp[24942]: celery.app.trace:INFO: [02580283] Task pulp.server.async.tasks._queue_reserved_task[02580283-b016-40b5-b19d-a714c01c0079] succeeded in 0.0124872408342s: None
12
Feb 23 13:16:49 pulp2.dev pulp[24718]: celery.worker.strategy:INFO: Received task: pulp.server.async.tasks._release_resource[02f88ca6-7ae0-4eb1-bb92-5808d6f989f7]
13
Feb 23 13:16:49 pulp2.dev pulp[24938]: celery.app.trace:INFO: [91046e77] Task pulp.server.managers.repo.publish.publish[91046e77-cc4f-4714-a7d4-c99ee9114de9] succeeded in 0.119569655042s: {'exception': None, 'repo_id': 'mod_lazy', 'traceback': None, 'started': '2018-02-23T13:16:49Z', '_ns': 'repo_publish_results', 'completed': datetime.datetime(2018, 2, 23, 13, 16, 49, 133452, tzinfo=<isodate.tzinfo.Utc object at 0x7fa7e71fe990>), 'error_message': None, 'distributor_type_id': 'yum_distributor', 'distributor_id': 'yum_distributor', 'summary': {'generate sqlite': 'SKIPPED', 'initialize_repo_metadata': 'FINISHED', 'rpms': 'FINISHED', 'repoview': 'SKIPPED', 'close_repo_metadata': 'FINISHED', 'errata': 'FINISHED', 'comps': 'FINISHED', 'distribution': 'FINISHED', 'drpms': 'SKIPPED', 'publish_directory': 'FINISHED', 'remove_old_repodata': 'FINISHED', 'metadata': 'FINISHED'}, 'result': 'success', 'id': '5a90144130f252616a7c1a05', 'details': [{'num_processed': 1, 'items_total': 1, 'state': 'FINISHED', 'num_success': 1, 'error_details': [...], 'description': 'Initializing repo metadata', 'num_failures': 0, 'step_id': 'd496971b-6a2f-42a7-9cec-81d0ed78de86', 'step_type': 'initialize_repo_metadata', 'detail...', ...}]}
14
Feb 23 13:16:49 pulp2.dev pulp[24938]: celery.app.trace:INFO: [02f88ca6] Task pulp.server.async.tasks._release_resource[02f88ca6-7ae0-4eb1-bb92-5808d6f989f7] succeeded in 0.00174367101863s: None
15
Feb 23 13:17:52 pulp2.dev pulp[24714]: celery.worker.strategy:INFO: Received task: pulp.server.async.tasks._queue_reserved_task[71f42cae-2053-43f5-9599-a490e797fcf8]
16
Feb 23 13:17:52 pulp2.dev pulp[24718]: celery.worker.strategy:INFO: Received task: pulp.server.managers.repo.sync.sync[0d5e964a-0e95-4b7e-9f40-a54c9eda581b]
17
Feb 23 13:17:52 pulp2.dev pulp[24718]: celery.worker.strategy:INFO: Received task: pulp.server.async.tasks._release_resource[1b4d1810-d3b1-4399-acab-3024dd634cdc]
18
Feb 23 13:17:52 pulp2.dev pulp[24942]: celery.app.trace:INFO: [71f42cae] Task pulp.server.async.tasks._queue_reserved_task[71f42cae-2053-43f5-9599-a490e797fcf8] succeeded in 0.0141198560596s: None
19
Feb 23 13:17:52 pulp2.dev pulp[24938]: pulp_rpm.plugins.importers.yum.sync:INFO: [0d5e964a] Downloading metadata from https://pulp2.dev/pulp/repos/modular_test_copy_all/.
20
Feb 23 13:17:52 pulp2.dev pulp[24938]: nectar.downloaders.threaded:INFO: Download succeeded: https://pulp2.dev/pulp/repos/modular_test_copy_all/repodata/repomd.xml.
21
Feb 23 13:17:53 pulp2.dev pulp[24938]: pulp_rpm.plugins.importers.yum.sync:INFO: [0d5e964a] Parsing metadata.
22
Feb 23 13:17:53 pulp2.dev pulp[24938]: pulp_rpm.plugins.importers.yum.sync:INFO: [0d5e964a] Downloading metadata from https://pulp2.dev/pulp/repos/modular_test_copy_all/.
23
Feb 23 13:17:53 pulp2.dev pulp[24938]: nectar.downloaders.threaded:INFO: Download succeeded: https://pulp2.dev/pulp/repos/modular_test_copy_all/repodata/repomd.xml.
24
Feb 23 13:17:54 pulp2.dev pulp[24938]: pulp_rpm.plugins.importers.yum.sync:INFO: [0d5e964a] Parsing metadata.
25
Feb 23 13:17:54 pulp2.dev pulp[24938]: pulp_rpm.plugins.importers.yum.sync:INFO: [0d5e964a] Downloading metadata from https://pulp2.dev/pulp/repos/modular_test_copy_all/.
26
Feb 23 13:17:54 pulp2.dev pulp[24938]: nectar.downloaders.threaded:INFO: Download succeeded: https://pulp2.dev/pulp/repos/modular_test_copy_all/repodata/repomd.xml.
27
Feb 23 13:17:55 pulp2.dev pulp[24938]: pulp_rpm.plugins.importers.yum.sync:INFO: [0d5e964a] Parsing metadata.
28
Feb 23 13:17:55 pulp2.dev pulp[24938]: pulp_rpm.plugins.importers.yum.sync:INFO: [0d5e964a] Downloading metadata from https://pulp2.dev/pulp/repos/modular_test_copy_all/.
29
Feb 23 13:17:55 pulp2.dev pulp[24938]: nectar.downloaders.threaded:INFO: Download succeeded: https://pulp2.dev/pulp/repos/modular_test_copy_all/repodata/repomd.xml.
30
Feb 23 13:17:56 pulp2.dev pulp[24938]: pulp_rpm.plugins.importers.yum.sync:INFO: [0d5e964a] Parsing metadata.
31
Feb 23 13:17:56 pulp2.dev pulp[24938]: pulp_rpm.plugins.importers.yum.sync:INFO: [0d5e964a] Downloading metadata files.
32
Feb 23 13:17:56 pulp2.dev pulp[24938]: nectar.downloaders.threaded:INFO: Download succeeded: https://pulp2.dev/pulp/repos/modular_test_copy_all/repodata/a27718cc28ec6d71432e0ef3e6da544b7f9d93f6bb7d0a55aacd592d03144b70-comps.xml.
33
Feb 23 13:17:56 pulp2.dev pulp[24938]: nectar.downloaders.threaded:INFO: Download succeeded: https://pulp2.dev/pulp/repos/modular_test_copy_all/repodata/324d9cc556a7d6cd07fa9dcc59384dfdd6a264dbb29e10e3201fe6e5cc7d7201-updateinfo.xml.gz.
34
Feb 23 13:17:57 pulp2.dev pulp[24938]: nectar.downloaders.threaded:INFO: Download succeeded: https://pulp2.dev/pulp/repos/modular_test_copy_all/repodata/142122d4b18d567a9ca9f5d1a9bafe815fccbca267a35038ef070ec40d57445f-modules.yaml.gz.
35
Feb 23 13:17:57 pulp2.dev pulp[24938]: nectar.downloaders.threaded:INFO: Download succeeded: https://pulp2.dev/pulp/repos/modular_test_copy_all/repodata/14ddd445758cc96801e1a26ca04795d9b8ac0de45638896ddc027a2d0ccc34f5-filelists.xml.gz.
36
Feb 23 13:17:57 pulp2.dev pulp[24938]: nectar.downloaders.threaded:INFO: Download succeeded: https://pulp2.dev/pulp/repos/modular_test_copy_all/repodata/2689fced8c6178b671ea1999acf60b74659f297e9d651a96c84d335c43cd12f5-other.xml.gz.
37
Feb 23 13:17:57 pulp2.dev pulp[24938]: nectar.downloaders.threaded:INFO: Download succeeded: https://pulp2.dev/pulp/repos/modular_test_copy_all/repodata/ea3bb77ddb7bd03e57a8cadaba0b3152b573f7228bc2db88a6fa394f4a80ec40-primary.xml.gz.
38
Feb 23 13:17:57 pulp2.dev pulp[24938]: pulp_rpm.plugins.importers.yum.sync:INFO: [0d5e964a] Generating metadata databases.
39
Feb 23 13:18:02 pulp2.dev pulp[24938]: pulp_rpm.plugins.importers.yum.sync:INFO: [0d5e964a] Determining which units need to be downloaded.
40
Feb 23 13:18:31 pulp2.dev pulp[24938]: pulp_rpm.plugins.importers.yum.sync:INFO: [0d5e964a] Downloading additional units.
41
Feb 23 13:18:32 pulp2.dev pulp[24938]: nectar.downloaders.threaded:INFO: Download failed: Download of https://pulp2.dev/pulp/repos/modular_test_copy_all/.treeinfo failed with code 404: Not Found
42
Feb 23 13:18:33 pulp2.dev pulp[24938]: nectar.downloaders.threaded:INFO: Download failed: Download of https://pulp2.dev/pulp/repos/modular_test_copy_all/treeinfo failed with code 404: Not Found
43
Feb 23 13:18:34 pulp2.dev pulp[24938]: pulp_rpm.plugins.importers.yum.sync:INFO: [0d5e964a] Sync complete.
44
Feb 23 13:18:34 pulp2.dev pulp[24714]: celery.worker.strategy:INFO: Received task: pulp.server.async.tasks._queue_reserved_task[18b251fa-b65a-4554-a18f-dcc3cd387574]
45
Feb 23 13:18:34 pulp2.dev pulp[24938]: celery.app.trace:INFO: [0d5e964a] Task pulp.server.managers.repo.sync.sync[0d5e964a-0e95-4b7e-9f40-a54c9eda581b] succeeded in 41.4264435628s: <pulp.server.async.tasks.TaskResult object at 0x7fa7d122b850>
46
Feb 23 13:18:34 pulp2.dev pulp[24938]: celery.app.trace:INFO: [1b4d1810] Task pulp.server.async.tasks._release_resource[1b4d1810-d3b1-4399-acab-3024dd634cdc] succeeded in 0.0017958979588s: None
47
Feb 23 13:18:34 pulp2.dev pulp[24718]: celery.worker.strategy:INFO: Received task: pulp.server.managers.repo.publish.publish[a3f65271-a55a-4353-9ef3-d21f6d9ada43]
48
Feb 23 13:18:34 pulp2.dev pulp[24718]: celery.worker.strategy:INFO: Received task: pulp.server.async.tasks._release_resource[18df1f23-9099-442e-a217-ba8293686d51]
49
Feb 23 13:18:34 pulp2.dev pulp[24942]: celery.app.trace:INFO: [18b251fa] Task pulp.server.async.tasks._queue_reserved_task[18b251fa-b65a-4554-a18f-dcc3cd387574] succeeded in 0.0226199040189s: None
50
Feb 23 13:18:56 pulp2.dev pulp[24938]: celery.app.trace:INFO: [a3f65271] Task pulp.server.managers.repo.publish.publish[a3f65271-a55a-4353-9ef3-d21f6d9ada43] succeeded in 21.954501461s: {'exception': None, 'repo_id': 'mod_lazy', 'traceback': None, 'started': '2018-02-23T13:18:34Z', '_ns': 'repo_publish_results', 'completed': datetime.datetime(2018, 2, 23, 13, 18, 56, 287975, tzinfo=<isodate.tzinfo.Utc object at 0x7fa7e71fe990>), 'error_message': None, 'distributor_type_id': 'yum_distributor', 'distributor_id': 'yum_distributor', 'summary': {'generate sqlite': 'SKIPPED', 'initialize_repo_metadata': 'FINISHED', 'remove_old_repodata': 'FINISHED', 'rpms': 'FINISHED', 'repoview': 'SKIPPED', 'close_repo_metadata': 'FINISHED', 'drpms': 'SKIPPED', 'comps': 'FINISHED', 'distribution': 'FINISHED', 'save_tar': 'FINISHED', 'publish_directory': 'FINISHED', 'errata': 'FINISHED', 'metadata': 'FINISHED'}, 'result': 'success', 'id': '5a9014c030f252616a7c2491', 'details': [{'num_processed': 1, 'items_total': 1, 'state': 'FINISHED', 'num_success': 1, 'error_details': [...], 'description': 'Copying files', 'num_failures': 0, 'step_id': 'f80d772f-3575-43c9-81e8-9a37e47bd7aa', 'step_type': 'save_tar', 'details': , ...}]}
51
Feb 23 13:18:56 pulp2.dev pulp[24938]: celery.app.trace:INFO: [18df1f23] Task pulp.server.async.tasks._release_resource[18df1f23-9099-442e-a217-ba8293686d51] succeeded in 0.0016699351836s: None
52
Feb 23 13:20:05 pulp2.dev pulp[24682]: celery.beat:INFO: Scheduler: Sending due task download_deferred_content (pulp.server.controllers.repository.queue_download_deferred)
53
Feb 23 13:20:05 pulp2.dev pulp[24718]: celery.worker.strategy:INFO: Received task: pulp.server.controllers.repository.queue_download_deferred[aa569535-c8f7-462c-b61a-92b63ccb9f54]
54
Feb 23 13:20:05 pulp2.dev pulp[24721]: celery.worker.strategy:INFO: Received task: pulp.server.controllers.repository.download_deferred[758acabf-876e-4178-8233-7bbe039fcf7e]
55
Feb 23 13:20:05 pulp2.dev pulp[24938]: celery.app.trace:INFO: [aa569535] Task pulp.server.controllers.repository.queue_download_deferred[aa569535-c8f7-462c-b61a-92b63ccb9f54] succeeded in 0.00651995907538s: None
56
Feb 23 13:20:05 pulp2.dev pulp[24959]: celery.app.trace:INFO: [758acabf] Task pulp.server.controllers.repository.download_deferred[758acabf-876e-4178-8233-7bbe039fcf7e] succeeded in 0.0140727329999s: None
57
Feb 23 13:50:05 pulp2.dev pulp[24682]: celery.beat:INFO: Scheduler: Sending due task download_deferred_content (pulp.server.controllers.repository.queue_download_deferred)
58
Feb 23 13:50:05 pulp2.dev pulp[24727]: celery.worker.strategy:INFO: Received task: pulp.server.controllers.repository.queue_download_deferred[adcdae54-239c-4cd4-ac53-60be7e6055b8]
59
Feb 23 13:50:05 pulp2.dev pulp[24724]: celery.worker.strategy:INFO: Received task: pulp.server.controllers.repository.download_deferred[87d2ca0e-c5d7-4af7-b53a-99ea8126cfe6]
60
Feb 23 13:50:05 pulp2.dev pulp[24975]: celery.app.trace:INFO: [adcdae54] Task pulp.server.controllers.repository.queue_download_deferred[adcdae54-239c-4cd4-ac53-60be7e6055b8] succeeded in 0.00875467504375s: None
61
Feb 23 13:50:05 pulp2.dev pulp[24988]: celery.app.trace:INFO: [87d2ca0e] Task pulp.server.controllers.repository.download_deferred[87d2ca0e-c5d7-4af7-b53a-99ea8126cfe6] succeeded in 0.00993506517261s: None
62
Feb 23 13:50:07 pulp2.dev goferd[24649]: [INFO][worker-0] pulp.agent.gofer.pulpplugin:346 - not registered, profile report skipped
(4-4/6)