Hello John,
I have examined /var/log/messages, unfortunately it offers very little
advice on why the packages are beeing skipped. This is happening when
starting the sync task:
Feb 29 12:00:45 <host> pulp: pulp_rpm.plugins.importers.yum.sync:INFO:
Downloading 8185 RPMs.
Feb 29 12:00:50 <host> pulp: requests.packages.urllib3.connectionpool:INFO:
Starting new HTTP connection (1): <proxy-ip>
Feb 29 12:00:52 <host> pulp: requests.packages.urllib3.connectionpool:INFO:
Starting new HTTP connection (1): <proxy-ip>
Feb 29 12:00:52 <host> pulp: requests.packages.urllib3.connectionpool:INFO:
Starting new HTTP connection (1): <proxy-ip>
Feb 29 12:00:52 <host> pulp: requests.packages.urllib3.connectionpool:INFO:
Starting new HTTP connection (1): <proxy-ip>
Feb 29 12:00:52 <host> pulp: requests.packages.urllib3.connectionpool:INFO:
Starting new HTTP connection (1): <proxy-ip>
Feb 29 12:01:20 <host> pulp: nectar.downloaders.threaded:WARNING: Connection
Error - http://mirror.centos.org/centos/7/os/x86_64/Packages/batik-1.8-0.12.svn1230816.el7.noarch.rpm
could not be reached.
After this, puppet-master is generating a massive amount of SELinux error
messages. As it starts five minutes in I'm not sure this is actually
related at all, but I want to document it.
[root@<host> ~]# tail -n2000 /var/log/messages | grep "invalid context"
Feb 29 12:06:47 <host> puppet-master[6293]:
/etc/selinux/targeted/contexts/files/file_contexts: invalid context
system_u:object_r:puppet_etc_t:s0
Feb 29 12:06:47 <host> puppet-master[6293]:
/etc/selinux/targeted/contexts/files/file_contexts: invalid context
system_u:object_r:puppet_etc_t:s0
Feb 29 12:06:47 <host> puppet-master[6293]:
/etc/selinux/targeted/contexts/files/file_contexts: invalid context
system_u:object_r:puppet_etc_t:s0
Feb 29 12:06:47 <host> puppet-master[6293]:
/etc/selinux/targeted/contexts/files/file_contexts: invalid context
system_u:object_r:puppet_etc_t:s0
Feb 29 12:06:47 <host> puppet-master[6293]:
/etc/selinux/targeted/contexts/files/file_contexts: invalid context
system_u:object_r:puppet_var_lib_t:s0
Feb 29 12:06:47 <host> puppet-master[6293]:
/etc/selinux/targeted/contexts/files/file_contexts: invalid context
system_u:object_r:puppet_var_lib_t:s0
Feb 29 12:06:47 <host> puppet-master[6293]:
/etc/selinux/targeted/contexts/files/file_contexts: invalid context
system_u:object_r:puppet_var_lib_t:s0
Feb 29 12:06:47 <host> puppet-master[6293]:
/etc/selinux/targeted/contexts/files/file_contexts: invalid context
system_u:object_r:puppet_var_lib_t:s0
Feb 29 12:06:48 <host> puppet-master[6293]:
/etc/selinux/targeted/contexts/files/file_contexts: invalid context
system_u:object_r:puppet_log_t:s0
Feb 29 12:06:48 <host> puppet-master[6293]:
/etc/selinux/targeted/contexts/files/file_contexts: invalid context
system_u:object_r:puppet_log_t:s0
Feb 29 12:06:48 <host> puppet-master[6293]:
/etc/selinux/targeted/contexts/files/file_contexts: invalid context
system_u:object_r:puppet_log_t:s0
Feb 29 12:06:48 <host> puppet-master[6293]:
/etc/selinux/targeted/contexts/files/file_contexts: invalid context
system_u:object_r:puppet_log_t:s0
[ … ]
[root@<host> ~]# tail -n2000 /var/log/messages | grep "invalid context" |
wc -l
172
After the pulp task finishes, it writes to /var/log/messages again:
Feb 29 12:26:53 <host> pulp: pulp_rpm.plugins.importers.yum.repomd.alternate
:INFO: The content container reported: {'downloads': {'___/primary/___': {
'total_failed': 8128, 'total_succeeded': 57}}, 'total_sources': 0} for base
URL: http://mirror.centos.org/centos/7/os/x86_64/
Feb 29 12:26:53 <host> pulp: pulp_rpm.plugins.importers.yum.sync:INFO:
Downloading additional units.
Feb 29 12:26:53 <host> pulp: requests.packages.urllib3.connectionpool:INFO:
Starting new HTTP connection (1): <proxy-ip>
Feb 29 12:26:57 <host> pulp: pulp_rpm.plugins.importers.yum.sync:INFO: Sync
complete.
Feb 29 12:26:58 <host> pulp: pulp.server.event.http:INFO: (4038-15392) {
'call_report': {u'exception': None, u'task_type': u
'pulp.server.managers.repo.sync.sync', u'task_id': u
'd28c697b-cad9-4cbe-a1e2-3300fbf3b445', u'tags': [u
'pulp:repository:test-CentOS_7-Base', u'pulp:action:sync'], u'finish_time':
None, u'_ns': u'task_status', u'start_time': u'2016-02-29T10:57:13Z', u
'traceback': None, u'spawned_tasks': [], u'progress_report': {u
'yum_importer': {u'content': {u'size_total': 6574173632L, u'items_left': 0,
u'items_total': 8185, u'state': u'FINISHED', u'size_left': 0, u'details': {u
'rpm_total': 8185, u'rpm_done': 8185, u'drpm_total': 0, u'drpm_done': 0}, u
'error_details': [{u'url': u
'http://mirror.centos.org/centos/7/os/x86_64/Packages/batik-1.8-0.12.svn1230816.el7.noarch.rpm'
, u'errors': [u'A connection error occurred']}, {u'url': u
'http://mirror.centos.org/centos/7/os/x86_64/Packages/compat-glew-1.9.0-7.el7.i686.rpm'
, u'errors': [u'Download skipped']}, {u'url': u
'http://mirror.centos.org/centos/7/os/x86_64/Packages/compat-glew-1.9.0-7.el7.x86_64.rpm'
, u'errors': [u'Download skipped']}, {u'url': u
'http://mirror.centos.org/centos/7/os/x86_64/Packages/compat-glibc-2.12-4.el7.centos.x86_64.rpm'
, u'errors': [u'Download skipped']} […]
The list goes on about all 8000+ packages that were skipped. As you can
see, it sucessfully downloaded 57 more packages (I can confirm this as
every re-run adds a few more packages). I have absolutely no idea why it is
possible to download a few more packages. If there is any more I can
provide, I'll do. To be honest, this really confuses me and I'm thinking
about setting up Foreman again (as it's only a test environment anyway) and
check if the problem persists.
Marvin