Execute prefetch plug-in command taking more than 2 seconds to complete

(imported topic written by KR9P_Ashu_Gupta)

I am deploying MAG action(RedHat patches) end points. The action status mostly shows “Pending Downloads - Waiting for downloads to be mirrored”. I don’t see this behavior though for Windows. This prefetch time is huge in the entire process which increases the action completion time. Can you please suggest why this warning message is showing up on agent and where to start to fix it. Thanks!

e.g log between 19:32 to 19:53 (21 mins), the warning messages wait time is 19 mins.

Agent Log:

At 19:32:44 +0000 -

DownloadsAvailable: true (action id 10488)

At 19:33:01 +0000 -

Warning: execute prefetch plug-in command taking more than 2 seconds to complete. It took 17 seconds.

At 19:33:39 +0000 -

Warning: execute prefetch plug-in command taking more than 2 seconds to complete. It took 38 seconds.

At 19:33:56 +0000 -

Warning: execute prefetch plug-in command taking more than 2 seconds to complete. It took 17 seconds.

At 19:34:32 +0000 -

Warning: execute prefetch plug-in command taking more than 2 seconds to complete. It took 37 seconds.

At 19:34:50 +0000 -

Warning: execute prefetch plug-in command taking more than 2 seconds to complete. It took 17 seconds.

At 19:35:28 +0000 -

Warning: execute prefetch plug-in command taking more than 2 seconds to complete. It took 38 seconds.

At 19:35:51 +0000 -

Warning: execute prefetch plug-in command taking more than 2 seconds to complete. It took 17 seconds.

At 19:36:29 +0000 -

Warning: execute prefetch plug-in command taking more than 2 seconds to complete. It took 38 seconds.

At 19:36:32 +0000 -

DownloadsAvailable: checking for ‘http://usrdter011ccpr1.ssm.sdc.gts.ibm.com:52311/bfmirror/downloads/10488/0

DownloadsAvailable: true (action id 10488)

ActionLogMessage: (action 10488 ) Non-Distributed - DownloadsAvailable

ActionLogMessage: (action 10488 ) Submitting download request

ActionLogMessage: (action 10488 ) Download url: ‘RedHatProtocol://ghostscript-devel-8.15.2-9.3.el5.x86_64.rpm’ (skip non relevant)

ActionLogMessage: (action 10488 ) Download url: ‘RedHatProtocol://libXext-devel-1.0.1-2.1.x86_64.rpm’ (skip non relevant)

ActionLogMessage: (action 10488 ) Download url: ‘RedHatProtocol://libtiff-3.8.2-14.el5_8.x86_64.rpm’

ActionLogMessage: (action 10488 ) Download url: ‘RedHatProtocol://ImageMagick-c+±devel-6.2.8.0-15.el5_8.x86_64.rpm’ (skip non relevant)

ActionLogMessage: (action 10488 ) Download url: ‘RedHatProtocol://bzip2-devel-1.0.3-6.el5_5.x86_64.rpm’ (skip non relevant)

ActionLogMessage: (action 10488 ) Download url: ‘RedHatProtocol://ImageMagick-perl-6.2.8.0-15.el5_8.x86_64.rpm’ (skip non relevant)

ActionLogMessage: (action 10488 ) Download url: ‘RedHatProtocol://ImageMagick-devel-6.2.8.0-15.el5_8.i386.rpm’ (skip non relevant)

ActionLogMessage: (action 10488 ) Download url: ‘RedHatProtocol://libXt-devel-1.0.2-3.2.el5.x86_64.rpm’ (skip non relevant)

ActionLogMessage: (action 10488 ) Download url: ‘RedHatProtocol://mesa-libGL-devel-6.5.1-7.10.el5.x86_64.rpm’ (skip non relevant)

(imported comment written by Niraj Kumar Mishra)

Hi Ashu,

Did you get any resolution for this issue. I am getting the same issue. I have tried out to increase the prefetch plugin timeout seconds but still problem remain same.

Thanks

Niraj

I’m having the same issue. The patches to be installed are more than 50 and the download is taking several hours because after it downloads some files of an action it “checks” every downloaded action and this slows downs all the process. Here is some of the log part:

At 15:40:13 -0300 -
Warning: execute prefetch plug-in command taking more than 2 seconds to complete. It took 9 seconds.
At 15:40:26 -0300 -
ActionLogMessage: (group:11176,action:11197) Non-Distributed - DownloadsAvailable
At 15:40:35 -0300 -
Warning: execute prefetch plug-in command taking more than 2 seconds to complete. It took 9 seconds.
At 15:40:49 -0300 -
ActionLogMessage: (group:11176,action:11198) Non-Distributed - DownloadsAvailable
At 15:40:58 -0300 -
Warning: execute prefetch plug-in command taking more than 2 seconds to complete. It took 9 seconds.
At 15:41:00 -0300 -
Warning: execute prefetch plug-in command taking more than 2 seconds to complete. It took 3 seconds.
At 15:41:15 -0300 -
ActionLogMessage: (group:11176,action:11199) Non-Distributed - DownloadsAvailable
At 15:41:16 -0300 -
ItemizedDownloadsAvailable: true (action id 11200)
ActionLogMessage: (group:11176,action:11200) Non-Distributed - DownloadsAvailable
ActionLogMessage: (group:11176,action:11200) Submitting download request
ActionLogMessage: (group:11176,action:11200) Download url: 'http://software.bigfix.com/download/bes/dep/rhel/yum/6S erver/x86_64/201504130211_primary.sqlite.bz2’
ActionLogMessage: (group:11176,action:11200) Download url: 'http://software.bigfix.com/download/bes/dep/rhel/yum/6S erver/x86_64/201504130211_EDR_PackageSpec.bz2’
ActionLogMessage: (group:11176,action:11200) Download url: 'http://software.bigfix.com/download/bes/dep/rhel/yum/6S erver/x86_64/201504130211_repomd.xml’
At 15:41:18 -0300 -
DownloadCRCPing command received
At 15:41:23 -0300 -
DownloadCRCPing command received
DownloadCRCPing command received
At 15:41:54 -0300 -
Warning: execute prefetch plug-in command taking more than 2 seconds to complete. It took 10 seconds.
At 15:41:56 -0300 -
Warning: execute prefetch plug-in command taking more than 2 seconds to complete. It took 3 seconds.
At 15:42:07 -0300 -
ActionLogMessage: (group:11176,action:11177) Non-Distributed - DownloadsAvailable
At 15:42:16 -0300 -
Warning: execute prefetch plug-in command taking more than 2 seconds to complete. It took 9 seconds.
At 15:42:30 -0300 -
ActionLogMessage: (group:11176,action:11178) Non-Distributed - DownloadsAvailable
At 15:42:39 -0300 -
Warning: execute prefetch plug-in command taking more than 2 seconds to complete. It took 9 seconds.
At 15:42:53 -0300 -
ActionLogMessage: (group:11176,action:11179) Non-Distributed - DownloadsAvailable

Is there a way to fix this?