CUPS 8.6(4)SU1 Upgrade seems to hang...

[perrymcgrew]

Trying to upgrade my CUPS PUB & SUB from 8.6.4.10000-28 to 8.6.4.11900--1 (both under current VM ESXi 5).   MD5sum'd verified ISO then estacted it to DVD, mounted DVD to to VM and did the Upgrade (no reboot / switch) starting with CUP Pub.  Watched the log and it seems to have finished - DVD ejected etc.  But the OS Admin GUI still says it is running.  Went over the the SUB and repeated the process and it is doing the same thing.  Have a TAC case open since Friday but engineer only asked if I verified the md5 hash - and he is probably off for the weekend.  I would really like to have the system upgraded before Monday.  Is it safe to do the switch and reboot startoing with the PUB?  I am attaching the last part of the log I copied from the OS Admin window....

Thx -- Perry

14:46:32 post_upgrade|========================= Upgrade complete. Awaiting switch to version. =========================|<LVL::Info>
09/07/2012 14:46:32 upgrade_manager.sh|Post-upgrade processing complete|<LVL::Info>
09/07/2012 14:46:32 upgrade_manager.sh|Application install on inactive partition complete|<LVL::Info>
09/07/2012 14:46:32 upgrade_manager.sh|Upgrade complete|<LVL::Info>
09/07/2012 14:46:32 upgrade_manager.sh|Final exit processing with result 0|<LVL::Info>
09/07/2012 14:46:32 upgrade_manager.sh|Calling /common/download/8.6.4.11900-1/Cisco/bin/prepare_grub --phase L2 --action update --basepath /mnt/source/Cisco --active_part /partB --logfile /common/log/install/capture.txt|<LVL::Debug>
09/07/2012 14:46:33 upgrade_manager.sh|(CAPTURE) [12/09/07_14:46:32] prepare_grub: Preparing grub for phase: l2!|<LVL::Debug>
09/07/2012 14:46:33 upgrade_manager.sh|(CAPTURE) [12/09/07_14:46:32] prepare_grub: Setting up GRUB for l2 for update action|<LVL::Debug>
09/07/2012 14:46:33 upgrade_manager.sh|(CAPTURE) [12/09/07_14:46:32] prepare_grub: Checking for serial-console |<LVL::Debug>
09/07/2012 14:46:33 upgrade_manager.sh|(CAPTURE) [12/09/07_14:46:32] prepare_grub: Checking for product specific hpet setting|<LVL::Debug>
09/07/2012 14:46:33 upgrade_manager.sh|(CAPTURE) [12/09/07_14:46:33] prepare_grub: Checking platform type for kernel arg.|<LVL::Debug>
09/07/2012 14:46:33 upgrade_manager.sh|(CAPTURE) [12/09/07_14:46:33] prepare_grub: Detected HWModel=VMware|<LVL::Debug>
09/07/2012 14:46:33 upgrade_manager.sh|(CAPTURE) [12/09/07_14:46:33] prepare_grub: Set kernel parm for platform as: clock=pmtmr divider=4|<LVL::Debug>
09/07/2012 14:46:33 upgrade_manager.sh|(CAPTURE) [12/09/07_14:46:33] prepare_grub: Set kernel parm: enforcing=0|<LVL::Debug>
09/07/2012 14:46:33 upgrade_manager.sh|(CAPTURE) [12/09/07_14:46:33] prepare_grub: Adding kernel-param:  clock=pmtmr divider=4 enforcing=0|<LVL::Debug>

09/07/2012 14:46:33 upgrade_manager.sh|IOWAIT monitor stopped|<LVL::Info>
09/07/2012 14:46:33 upgrade_manager.sh|Exit processing with result 0|<LVL::Info>
09/07/2012 14:46:34 preflight|Starting preflight|<LVL::Info>
09/07/2012 14:46:34 preflight|Validate preflight data|<LVL::Info>
09/07/2012 14:46:34 preflight|Preflight data validation complete|<LVL::Info>
09/07/2012 14:46:34 preflight|Determine upgrade type|<LVL::Info>
09/07/2012 14:46:34 preflight|Active RH version = 5Server|<LVL::Debug>
09/07/2012 14:46:34 preflight|New os version(xml) = 5Server|<LVL::Debug>
09/07/2012 14:46:34 preflight|Upgrade type = L2|<LVL::Debug>
09/07/2012 14:46:34 preflight|Obtain product type|<LVL::Info>
09/07/2012 14:46:34 preflight|Obtained product type CallManager|<LVL::Info>
09/07/2012 14:46:34 preflight|Processing preflight cleanup mode|<LVL::Info>
09/07/2012 14:46:34 preflight|Clear preflight cancel utility|<LVL::Info>
09/07/2012 14:46:34 preflight|Removing /common/cancel_upgrade/preflight_cancel|<LVL::Debug>
09/07/2012 14:46:34 preflight|Execute cleanup preflight commands for CallManager:L2 from /mnt/source/Cisco/install/preflight.xml|<LVL::Info>
09/07/2012 14:46:34 preflight|Found 7 preflight commands to execute|<LVL::Debug>
09/07/2012 14:46:34 preflight|Execute preflight command (1/7): rm -rf /usr/local/platform/conf/dynamicConfig.xml|<LVL::Debug>
09/07/2012 14:46:34 preflight|Preflight command returns 0|<LVL::Debug>
09/07/2012 14:46:34 preflight|Execute preflight command (2/7): cp -f /common/preflight/CM/L2/dynamicConfig.xml /usr/local/platform/conf/dynamicConfig.xml|<LVL::Debug>
09/07/2012 14:46:34 preflight|Preflight command returns 1|<LVL::Debug>
09/07/2012 14:46:34 preflight|(CAPTURE) cp: cannot stat `/common/preflight/CM/L2/dynamicConfig.xml': No such file or directory|<LVL::Debug>
09/07/2012 14:46:34 preflight|Preflight command did not complete (1). Continuing command processing...|<LVL::Warn>
09/07/2012 14:46:34 preflight|Execute preflight command (3/7): rm -rf /usr/local/thirdparty/jakarta-tomcat/webapps/cmplatform/WEB-INF/pages/install/dynamic.jsp|<LVL::Debug>
09/07/2012 14:46:34 preflight|Preflight command returns 0|<LVL::Debug>
09/07/2012 14:46:34 preflight|Execute preflight command (4/7): cp -f /common/preflight/CM/L2/dynamic.jsp /usr/local/thirdparty/jakarta-tomcat/webapps/cmplatform/WEB-INF/pages/install/dynamic.jsp|<LVL::Debug>
09/07/2012 14:46:34 preflight|Preflight command returns 1|<LVL::Debug>
09/07/2012 14:46:34 preflight|(CAPTURE) cp: cannot stat `/common/preflight/CM/L2/dynamic.jsp': No such file or directory|<LVL::Debug>
09/07/2012 14:46:34 preflight|Preflight command did not complete (1). Continuing command processing...|<LVL::Warn>
09/07/2012 14:46:34 preflight|Execute preflight command (5/7): rm -rf /usr/local/thirdparty/jakarta-tomcat/webapps/cmplatform/WEB-INF/pages/install/install-confirm-content.jsp|<LVL::Debug>
09/07/2012 14:46:34 preflight|Preflight command returns 0|<LVL::Debug>
09/07/2012 14:46:35 preflight|Execute preflight command (6/7): cp -f /common/preflight/CM/L2/install-confirm-content.jsp /usr/local/thirdparty/jakarta-tomcat/webapps/cmplatform/WEB-INF/pages/install/install-confirm-content.jsp|<LVL::Debug>
09/07/2012 14:46:35 preflight|Preflight command returns 1|<LVL::Debug>
09/07/2012 14:46:35 preflight|(CAPTURE) cp: cannot stat `/common/preflight/CM/L2/install-confirm-content.jsp': No such file or directory|<LVL::Debug>
09/07/2012 14:46:35 preflight|Preflight command did not complete (1). Continuing command processing...|<LVL::Warn>
09/07/2012 14:46:35 preflight|Execute preflight command (7/7): rm -rf /common/preflight/CM/L2|<LVL::Debug>
09/07/2012 14:46:35 preflight|Preflight command returns 0|<LVL::Debug>
09/07/2012 14:46:35 upgrade_manager.sh|Cleanup RAM disk|<LVL::Info>
09/07/2012 14:46:35 upgrade_manager.sh|Unmount /common/mnt/product_img|<LVL::Debug>
09/07/2012 14:46:35 upgrade_manager.sh|Cleanup mounted DVD or ISO|<LVL::Info>
09/07/2012 14:46:35 upgrade_manager.sh|Found mount point "/mnt/source" for source filesystem /dev/hdc|<LVL::Debug>
09/07/2012 14:46:35 upgrade_manager.sh|Unmount /mnt/source|<LVL::Debug>
09/07/2012 14:46:35 upgrade_manager.sh|Ejecting DVD (/dev/hdc)|<LVL::Debug>
09/07/2012 14:46:38 upgrade_manager.sh|Refresh CLI product properties cache|<LVL::Info>
09/07/2012 14:46:38 upgrade_manager.sh|Refresh hardware cache|<LVL::Info>
09/07/2012 14:46:38 ServerApiManager|INITIALIZE: sam_legacy_mode_init=1|<LVL::Debug>
09/07/2012 14:46:42 ServerApiManager|INITIALIZE: sam_hssi_mode_init=0|<LVL::Debug>
09/07/2012 14:46:47 upgrade_manager.sh|Cleanup exiting - Cached Data: [Vendor= VMware, Inc.
HWModel=VMware
CPUCount=1
CPUType= Intel(R) Xeon(R) CPU E5-2690 0 @ 2.90GHz
CPUSpeed=2900
MEMSize=4096
BIOSVer=PhoenixTechnologiesLTD 6.00 09/21/2011
ObjectId=1.3.6.1.4.1.9.1.1348
OSVersion=UCOS 5.0.0.0-2
SerialNumber= VMware-42 37 e4 c8 ec e5 0b f1-77 9f 5e 9a e0 71 dd 38
VendorOID=1.3.6.1.4.1.674]|<LVL::Info>
09/07/2012 14:46:48 upgrade_install.sh|Process interface file|<LVL::Info>
09/07/2012 14:46:48 upgrade_install.sh|switch=no|<LVL::Debug>
09/07/2012 14:46:48 upgrade_install.sh|notify_clm=yes|<LVL::Debug>
09/07/2012 14:46:48 upgrade_install.sh|Process interface file complete|<LVL::Info>
09/07/2012 14:46:48 upgrade_install.sh|Upgrade manager complete|<LVL::Info>
09/07/2012 14:46:48 upgrade_install.sh|System upgrade complete|<LVL::Info>
09/07/2012 14:46:48 upgrade_install.sh|Cleaning up download...|<LVL::Info>
09/07/2012 14:46:48 upgrade_install.sh|Cleanup upgrade source area.|<LVL::Info>
09/07/2012 14:46:48 upgrade_install.sh|Ejecting DVD (/dev/sda2)|<LVL::Debug>
09/07/2012 14:46:48 upgrade_install.sh|Removing /common/download/8.6.4.11900-1|<LVL::Info>
09/07/2012 14:46:49 upgrade_install.sh|Started auditd...|<LVL::Info>
09/07/2012 14:46:50 upgrade_install.sh|Started setroubleshoot...|<LVL::Info>
09/07/2012 14:46:50 upgrade_install.sh|Changed selinux mode to enforcing|<LVL::Info>
09/07/2012 14:46:50 upgrade_install.sh|No switch to new version|<LVL::Info>
09/07/2012 14:46:50 upgrade_install.sh|IOWAIT monitor stopped|<LVL::Info>
09/07/2012 14:46:52 upgrade_install.sh|Initiated cluster manager to send updated publisher data to subscribers|<LVL::Info>
09/07/2012 14:46:52 upgrade_install.sh|Upgrade Complete -- (0)|<LVL::Info>
09/07/2012 14:46:52 upgrade_install.sh|set_upgrade_result: set to 1|<LVL::Debug>
09/07/2012 14:46:52 upgrade_install.sh|is_upgrade_lock_available: Upgrade lock is not available.|<LVL::Debug>
09/07/2012 14:46:52 upgrade_install.sh|is_upgrade_in_progress: Already locked by this process (pid: 12855).|<LVL::Debug>
09/07/2012 14:46:52 upgrade_install.sh|release_upgrade_lock: Releasing lock (pid: 12855)|<LVL::Debug>

[perrymcgrew]

TAC engineer finally contacted me.  He thought the upgrade went.  Switched version to 8.6.4.11900--1 and it hung. Reverted back ... bit have been having issues with my Jabber clients ever since. Now he seems to think that it is because it is running under VM on DL380-G8 servers even though 8.6.4.10000-28 ran fine.

Has anyone done this upgarde or running this release under a VM?

TIA

[Tommer Catlin]

What kind of issues are you seeing?

[pxrondin]

Hi

I am exactly in the same situation upgrade from 8.6.4.10000-28 to 8.6.4.11900--1 and the last logging message during the installation is the same than you

Its a fresh installation

I have shutdown my server and retry the update .

I will see tomorrow morning if it has been successfull.

If no I will open a TAC Case

I have installed my CUPS on UCS C210M2 , ESXi 5.0

Regards

PR

[vpmaharaj_2]

Hi, did you get it working? I am getting the same error when trying to upgrade from 8.6.2.20000-2 to 8.6.2a SU2. I even tried 8.6.2a SU1.I was suspecting it was something to do with licensing maybe but have not logged a tac case yet. Have uploaded the cop file due to no particular reason but I am still having the problem. The cucm is running on a VM created via the OVA template so the server sizing is correct as well.

[perrymcgrew]

Nope.  I had a TAC case opened as well.  They went ahead and closed it w/o permission!  I complained and they have reopened the case.  But I have not heard from the new Engineer.  

[pxrondin]

Hi

Same thing for me, I had opened a TAC Case and I got a lot of basic questions from the TAC Engineer ( Sometimes I wondered if I was a stupid guy )

At the End he told me to try to shutdown the system, then reload it and then to try a switch version .

It has been successfull.

It seems that this problem is due to a TomCat problem at the end of the upgrade process when the display screen has to be updated to indicate that the upgrade has been successfull.

I have configured Jabber on 2 PC  and all was working fine

Regards

[d.haeni]

Hi Perry,

Did you ever get this resolved? We are stuck pretty much at the same point when updating our cluster from 8.6(4) to 8.6(4)SU2.

Your help is greatly appreciated

/David

[perrymcgrew]

Unfortunately no.  We have been playing a bit of phone tag, but it seems lately that TAC is not doing a good job matching tech's workday hours with my schedule -- which I include in all my TAC cases.

Right now, we are holding up mass deployment of Jabber --- 9.1.x Jabber for Windows clients are proving to be prone to crashing.  Getting many complaints from existing users and have sent in 3 Jabber crash dumps just this week.  They attached a bug ID and I have been told it will be fixed in 9.1.3 -- which is months away!  Official WIndows 8 support is also not coming for several months either.  

I am still looking to push this case to a resolution...we are examining version 9 Call Manager which as you may know, folds CUPS into the Call Manager.  The way Cisco is attacking my current case, we may be at v9 before they resolve this one! 

Perry

[chukkaedovia]

Hi

I seem to be having the same issue on this is with CUCM. I cantr upgrade my subscriber to 8.6.2. 22900-9 from 8.6.2.20000-2

Has anyone found a solution yet.

Ive had to downgrade my Pub for the time being.

Thanks in advance

see extract of install logs below.

.22900-9.sgn.iso" reboot="no" signed="yes"/>|<:DEBUG>

01/24/2012 18:41:39 file_list.sh|(CAPTURE) |<:DEBUG>

01/24/2012 18:41:39 file_list.sh|success|<:INFO>

01/24/2012 18:41:39 file_list.sh|file_list.sh complete (rc=0)|<:INFO>

01/24/2012 18:41:39 file_list.sh|set_upgrade_result: set to 1|<:DEBUG>

01/24/2012 18:41:39 file_list.sh|is_upgrade_lock_available: Upgrade lock is not available.|<:DEBUG>

01/24/2012 18:41:39 file_list.sh|is_upgrade_in_progress: Already locked by this process (pid: 2521).|<:DEBUG>

01/24/2012 18:41:39 file_list.sh|release_upgrade_lock: Releasing lock (pid: 2521)|<:DEBUG>

01/24/2012 18:41:43 upgrade_validate_file.sh|Starting upgrade_validate_file.sh|<:INFO>

01/24/2012 18:41:43 upgrade_validate_file.sh|Parse argument method=local_dvd|<:DEBUG>

01/24/2012 18:41:43 upgrade_validate_file.sh|Parse argument source_dir=/|<:DEBUG>

01/24/2012 18:41:43 upgrade_validate_file.sh|Parse argument file_name=UCSInstall_UCOS_8.6.2.22900-9.sgn.iso|<:DEBUG>

01/24/2012 18:41:43 upgrade_validate_file.sh|Parse argument file_type=patch|<:DEBUG>

01/24/2012 18:41:43 upgrade_validate_file.sh|Parse argument file_signed=yes|<:DEBUG>

01/24/2012 18:41:43 upgrade_validate_file.sh|is_upgrade_lock_available: Upgrade lock is available.|<:DEBUG>

01/24/2012 18:41:43 upgrade_validate_file.sh|is_upgrade_result_available: Result is not available|<:DEBUG>

01/24/2012 18:41:43 upgrade_validate_file.sh|acquire_upgrade_lock: Lock is free, creating lock (pid: 5602)|<:DEBUG>

01/24/2012 18:41:43 upgrade_validate_file.sh|Process local CD/DVD request|<:INFO>

01/24/2012 18:41:43 upgrade_validate_file.sh|Unmount DVD|<:INFO>

01/24/2012 18:41:43 upgrade_validate_file.sh|Mount /dev/cdrom on /mnt/source|<:DEBUG>

01/24/2012 18:41:43 upgrade_validate_file.sh|Get patch size from /mnt/source|<:DEBUG>

01/24/2012 18:41:43 upgrade_validate_file.sh|patch size is 4819527680|<:DEBUG>

01/24/2012 18:41:43 upgrade_validate_file.sh|Check free space|<:INFO>

01/24/2012 18:41:44 upgrade_validate_file.sh|(CAPTURE) Free space: 41965490176, Needed space: 4819527680|<:DEBUG>

01/24/2012 18:41:44 upgrade_validate_file.sh|There is enough space on device to proceed.|<:INFO>

01/24/2012 18:41:44 upgrade_validate_file.sh|Validate isofilename exists on /mnt/source|<:DEBUG>

01/24/2012 18:41:44 upgrade_validate_file.sh|Validate checksum_file exists on /mnt/source|<:DEBUG>

01/24/2012 18:41:44 upgrade_validate_file.sh|Local CD/DVD request complete|<:INFO>

01/24/2012 18:41:44 upgrade_validate_file.sh|success|<:INFO>

01/24/2012 18:41:44 upgrade_validate_file.sh|upgrade_validate_file.sh complete (rc=0)|<:INFO>

01/24/2012 18:41:44 upgrade_validate_file.sh|set_upgrade_result: set to 1|<:DEBUG>

01/24/2012 18:41:44 upgrade_validate_file.sh|is_upgrade_lock_available: Upgrade lock is not available.|<:DEBUG>

01/24/2012 18:41:44 upgrade_validate_file.sh|is_upgrade_in_progress: Already locked by this process (pid: 5602).|<:DEBUG>

01/24/2012 18:41:44 upgrade_validate_file.sh|release_upgrade_lock: Releasing lock (pid: 5602)|<:DEBUG>

01/24/2012 18:41:44 upgrade_validate_file.sh|Unmount DVD|<:INFO>

01/24/2012 18:41:46 upgrade_get_file.sh|Starting upgrade_get_file.sh|<:INFO>

01/24/2012 18:41:46 upgrade_get_file.sh|Parse argument method=local_dvd|<:DEBUG>

01/24/2012 18:41:46 upgrade_get_file.sh|Parse argument source_dir=/|<:DEBUG>

01/24/2012 18:41:46 upgrade_get_file.sh|Parse argument file_name=UCSInstall_UCOS_8.6.2.22900-9.sgn.iso|<:DEBUG>

01/24/2012 18:41:46 upgrade_get_file.sh|Parse argument dest_dir=/common/download/|<:DEBUG>

01/24/2012 18:41:46 upgrade_get_file.sh|Parse argument version=8.6.2.22900-9|<:DEBUG>

01/24/2012 18:41:46 upgrade_get_file.sh|Parse argument file_type=patch|<:DEBUG>

01/24/2012 18:41:46 upgrade_get_file.sh|Parse argument file_signed=yes|<:DEBUG>

01/24/2012 18:41:46 upgrade_get_file.sh|is_upgrade_lock_available: Upgrade lock is available.|<:DEBUG>

01/24/2012 18:41:46 upgrade_get_file.sh|is_upgrade_result_available: Result is not available|<:DEBUG>

01/24/2012 18:41:46 upgrade_get_file.sh|acquire_upgrade_lock: Lock is free, creating lock (pid: 6628)|<:DEBUG>

01/24/2012 18:41:47 upgrade_get_file.sh|Process local CD/DVD request|<:INFO>

01/24/2012 18:41:47 upgrade_get_file.sh|src_file=/mnt/source//UCSInstall_UCOS_8.6.2.22900-9.sgn.iso, dest_file=/common/download/UCSInstall_UCOS_8.6.2.22900-9.sgn.iso, file_type=patch|<:DEBUG>

01/24/2012 18:41:47 upgrade_get_file.sh|Unmounting /mnt/source incase it is mounted|<:DEBUG>

01/24/2012 18:41:47 upgrade_get_file.sh|Mount /dev/cdrom on /mnt/source|<:DEBUG>

01/24/2012 18:41:47 upgrade_get_file.sh|Local CD/DVD request complete|<:INFO>

01/24/2012 18:41:47 upgrade_get_file.sh|Download of iso file RTMTStart|<:NOTICE>

01/24/2012 18:41:47 upgrade_get_file.sh|Create md5 "/common/download/UCSInstall_UCOS_8.6.2.22900-9.sgn.iso.md5"|<:INFO>

01/24/2012 18:41:47 upgrade_get_file.sh|Create md5 complete|<:INFO>

01/24/2012 18:41:47 upgrade_get_file.sh|Authenticate file "/common/download/8.6.2.22900-9/checksum_file.sgn"|<:INFO>

01/24/2012 18:41:47 upgrade_get_file.sh|File authentication complete|<:DEBUG>

01/24/2012 18:41:47 upgrade_get_file.sh|New Upgrade Software; returning|<:INFO>

01/24/2012 18:41:47 upgrade_get_file.sh|Download of iso file RTMTFinish|<:NOTICE>

01/24/2012 18:41:47 upgrade_get_file.sh|Process preflight|<:INFO>

01/24/2012 18:41:47 upgrade_get_file.sh|Checking for preflight script|<:DEBUG>

01/24/2012 18:41:47 upgrade_get_file.sh|Executing preflight /mnt/source/Cisco/install/bin/preflight isolocation=/mnt/source|<:INFO>

01/24/2012 18:41:47 preflight|Starting preflight|<:INFO>

01/24/2012 18:41:47 preflight|Validate preflight data|<:INFO>

01/24/2012 18:41:47 preflight|Preflight data validation complete|<:INFO>

01/24/2012 18:41:47 preflight|Determine upgrade type|<:INFO>

01/24/2012 18:41:47 preflight|Active RH version = 5Server|<:DEBUG>

01/24/2012 18:41:47 preflight|New os version(xml) = 5Server|<:DEBUG>

01/24/2012 18:41:47 preflight|Upgrade type = L2|<:DEBUG>

01/24/2012 18:41:47 preflight|Obtain product type|<:INFO>

01/24/2012 18:41:48 preflight|Obtained product type CallManager|<:INFO>

01/24/2012 18:41:48 preflight|Processing preflight install mode|<:INFO>

01/24/2012 18:41:48 preflight|Set preflight cancel utility|<:INFO>

01/24/2012 18:41:48 preflight|Execute install preflight commands for CallManager:L2 from /mnt/source/Cisco/install/preflight.xml|<:INFO>

01/24/2012 18:41:48 preflight|Found 10 preflight commands to execute|<:DEBUG>

01/24/2012 18:41:48 preflight|Execute preflight command (1/10): mkdir -p /common/preflight/CM/L2|<:DEBUG>

01/24/2012 18:41:48 preflight|Execute preflight command (2/10): cp -f /usr/local/platform/conf/dynamicConfig.xml /common/preflight/CM/L2/dynamicConfig.xml|<:DEBUG>

01/24/2012 18:41:48 preflight|Preflight command returns 1|<:DEBUG>

01/24/2012 18:41:48 preflight|(CAPTURE) cp: cannot stat `/usr/local/platform/conf/dynamicConfig.xml': No such file or directory|<:DEBUG>

01/24/2012 18:41:48 preflight|Preflight command did not complete (1). Continuing command processing...|<:WARN>

01/24/2012 18:41:48 preflight|Execute preflight command (3/10): cp -f /usr/local/thirdparty/jakarta-tomcat/webapps/cmplatform/WEB-INF/pages/install/dynamic.jsp /common/preflight/CM/L2/dynamic.jsp|<:DEBUG>

01/24/2012 18:41:48 preflight|Preflight command returns 0|<:DEBUG>

01/24/2012 18:41:48 preflight|Execute preflight command (4/10): cp -f /usr/local/thirdparty/jakarta-tomcat/webapps/cmplatform/WEB-INF/pages/install/install-confirm-content.jsp /common/preflight/CM/L2/install-confirm-content.jsp|<:DEBUG>

01/24/2012 18:41:48 preflight|Preflight command returns 0|<:DEBUG>

01/24/2012 18:41:49 preflight|Execute preflight command (5/10): cp -f /mnt/source/Cisco/install/dynamicConfig_L2.xml /usr/local/platform/conf/dynamicConfig.xml|<:DEBUG>

01/24/2012 18:41:49 preflight|Preflight command returns 0|<:DEBUG>

01/24/2012 18:41:49 preflight|Execute preflight command (6/10): mkdir -p /usr/local/thirdparty/jakarta-tomcat/webapps/cmplatform/WEB-INF/pages/install|<:DEBUG>

01/24/2012 18:41:49 preflight|Preflight command returns 0|<:DEBUG>

01/24/2012 18:41:49 preflight|Execute preflight command (7/10): cp -f /mnt/source/Cisco/install/dynamic_L2.jsp /usr/local/thirdparty/jakarta-tomcat/webapps/cmplatform/WEB-INF/pages/install/dynamic.jsp|<:DEBUG>

01/24/2012 18:41:49 preflight|Preflight command returns 0|<:DEBUG>

01/24/2012 18:41:49 preflight|Execute preflight command (8/10): cp -f /mnt/source/Cisco/install/install-confirm-content_L2.jsp /usr/local/thirdparty/jakarta-tomcat/webapps/cmplatform/WEB-INF/pages/install/install-confirm-content.jsp|<:DEBUG>

01/24/2012 18:41:49 preflight|Preflight command returns 0|<:DEBUG>

01/24/2012 18:41:49 preflight|Execute preflight command (9/10): /mnt/source/Cisco/install/bin/tempDynamic.preflight /mnt/source/Cisco/install/dynamic_L2.jsp dynamic.jsp|<:DEBUG>

01/24/2012 18:41:49 preflight|Preflight command returns 0|<:DEBUG>

01/24/2012 18:41:49 preflight|(CAPTURE) 01/24/2012 18:41:49  starting tempDynamic.preflight...|<:DEBUG>

01/24/2012 18:41:49 preflight|(CAPTURE) 01/24/2012 18:41:49  Source dir/file = /mnt/source/Cisco/install/dynamic_L2.jsp|<:DEBUG>

01/24/2012 18:41:49 preflight|(CAPTURE) 01/24/2012 18:41:49  Destination file name = dynamic.jsp|<:DEBUG>

01/24/2012 18:41:49 preflight|(CAPTURE) 01/24/2012 18:41:49  Copying /mnt/source/Cisco/install/dynamic_L2.jsp to /usr/local/thirdparty/jakarta-tomcat/temp/2-cmplatform/WEB-INF/pages/install/dynamic.jsp|<:DEBUG>

01/24/2012 18:41:49 preflight|(CAPTURE) 01/24/2012 18:41:49  added/replaced /usr/local/thirdparty/jakarta-tomcat/temp/2-cmplatform/WEB-INF/pages/install/dynamic.jsp successfully|<:DEBUG>

01/24/2012 18:41:49 preflight|(CAPTURE) 01/24/2012 18:41:49  ... tempDynamic.preflight completed|<:DEBUG>

01/24/2012 18:41:49 preflight|Execute preflight command (10/10): /mnt/source/Cisco/install/bin/tempDynamic.preflight /mnt/source/Cisco/install/install-confirm-content_L2.jsp install-confirm-content.jsp|<:DEBUG>

01/24/2012 18:41:49 preflight|Preflight command returns 0|<:DEBUG>

01/24/2012 18:41:49 preflight|(CAPTURE) 01/24/2012 18:41:49  starting tempDynamic.preflight...|<:DEBUG>

01/24/2012 18:41:49 preflight|(CAPTURE) 01/24/2012 18:41:49  Source dir/file = /mnt/source/Cisco/install/install-confirm-content_L2.jsp|<:DEBUG>

01/24/2012 18:41:49 preflight|(CAPTURE) 01/24/2012 18:41:49  Destination file name = install-confirm-content.jsp|<:DEBUG>

01/24/2012 18:41:49 preflight|(CAPTURE) 01/24/2012 18:41:49  Copying /mnt/source/Cisco/install/install-confirm-content_L2.jsp to /usr/local/thirdparty/jakarta-tomcat/temp/2-cmplatform/WEB-INF/pages/install/install-confirm-content.jsp|<:DEBUG>

01/24/2012 18:41:49 preflight|(CAPTURE) 01/24/2012 18:41:49  added/replaced /usr/local/thirdparty/jakarta-tomcat/temp/2-cmplatform/WEB-INF/pages/install/install-confirm-content.jsp successfully|<:DEBUG>

01/24/2012 18:41:49 preflight|(CAPTURE) 01/24/2012 18:41:49  ... tempDynamic.preflight completed|<:DEBUG>

01/24/2012 18:41:49 preflight|Exiting with result 0|<:INFO>

01/24/2012 18:41:49 upgrade_get_file.sh|preflight returns 0|<:DEBUG>

01/24/2012 18:41:49 upgrade_get_file.sh|Preflight completed successfully|<:INFO>

01/24/2012 18:41:50 upgrade_get_file.sh|success|<:INFO>

01/24/2012 18:41:50 upgrade_get_file.sh|upgrade_get_file.sh complete (rc=0)|<:INFO>

01/24/2012 18:41:50 upgrade_get_file.sh|set_upgrade_result: set to 1|<:DEBUG>

01/24/2012 18:41:50 upgrade_get_file.sh|is_upgrade_lock_available: Upgrade lock is not available.|<:DEBUG>

01/24/2012 18:41:50 upgrade_get_file.sh|is_upgrade_in_progress: Already locked by this process (pid: 6628).|<:DEBUG>

01/24/2012 18:41:50 upgrade_get_file.sh|release_upgrade_lock: Releasing lock (pid: 6628)|<:DEBUG>

01/24/2012 18:42:09 sd_cancelInstall.sh|Pre-upgrade cancel/clean-up initiated

01/24/2012 18:42:09 sd_cancelInstall.sh|Canceling active side processes

01/24/2012 18:42:09 sd_cancelInstall.sh|Canceling active side processes done

01/24/2012 18:42:09 sd_cancelInstall.sh|Canceling inactive side processes

01/24/2012 18:42:09 sd_cancelInstall.sh|This is not a COP, so will do IDS shared memory clean up if needed on inactive partition

01/24/2012 18:42:09 sd_cancelInstall.sh|Stopping Partition B IDS

01/24/2012 18:42:24 sd_cancelInstall.sh|Stopped Partition B IDS

01/24/2012 18:42:24 sd_cancelInstall.sh|Request to terminate process 21125

01/24/2012 18:42:24 sd_cancelInstall.sh|Cancel process 21125 (atd)

01/24/2012 18:42:24 sd_cancelInstall.sh|Stop process 21125 (atd)

01/24/2012 18:42:24 sd_cancelInstall.sh|Terminate process 21125 (atd)

01/24/2012 18:42:24 sd_cancelInstall.sh|Waiting 1 seconds for 21125 (atd) to terminate

01/24/2012 18:42:25 sd_cancelInstall.sh|Process 21125 (atd) terminated

01/24/2012 18:42:25 sd_cancelInstall.sh|Canceling inactive side processes done

01/24/2012 18:42:30 upgrade_install.sh|Starting Upgrade -- upgrade_install.sh|<:INFO>

01/24/2012 18:42:30 upgrade_install.sh|Parse argument version=8.6.2.22900-9|<:DEBUG>

01/24/2012 18:42:30 upgrade_install.sh|Parse argument dest_dir=/common/download/|<:DEBUG>

01/24/2012 18:42:30 upgrade_install.sh|Parse argument work_dir=/var/log/install|<:DEBUG>

01/24/2012 18:42:30 upgrade_install.sh|is_upgrade_lock_available: Upgrade lock is available.|<:DEBUG>

01/24/2012 18:42:30 upgrade_install.sh|is_upgrade_result_available: Result is not available|<:DEBUG>

01/24/2012 18:42:30 upgrade_install.sh|acquire_upgrade_lock: Lock is free, creating lock (pid: 12774)|<:DEBUG>

01/24/2012 18:42:33 upgrade_install.sh|Selinux mode prior to upgrade is enforcing|<:INFO>

01/24/2012 18:42:33 upgrade_install.sh|Stopped auditd...|<:INFO>

01/24/2012 18:42:33 upgrade_install.sh|Stopped setroubleshoot...|<:INFO>

01/24/2012 18:42:33 upgrade_install.sh|Changed selinux mode to permissive|<:INFO>

01/24/2012 18:42:33 upgrade_install.sh|Upgrade the system|<:INFO>

01/24/2012 18:42:33 upgrade_install.sh|Copy /mnt/source/Cisco/base_scripts/upgrade_manager.sh to /common/download/8.6.2.22900-9/upgrade_manager.sh|<:INFO>

01/24/2012 18:42:33 upgrade_install.sh|Copy /mnt/source/Cisco/base_scripts/upgrade_manager.sh to /common/download/8.6.2.22900-9/upgrade_manager.sh complete|<:INFO>

01/24/2012 18:42:33 upgrade_install.sh|Start upgrade manager|<:INFO>

01/24/2012 18:42:33 upgrade_install.sh|/common/download/8.6.2.22900-9/upgrade_manager.sh type=upgrade basepath=/common/download/8.6.2.22900-9 file_name= logfile=/var/log/install/install_log_2012-01-24.18.41.35.log resultfile=/var/log/install/upgrade-results.xml work_dir=/var/log/install intf_file=/common/download/8.6.2.22900-9/upgrade_manager.xml to_version=8.6.2.22900-9|<:DEBUG>

01/24/2012 18:42:33 upgrade_manager.sh|Parse argument type=upgrade|<:DEBUG>

01/24/2012 18:42:33 upgrade_manager.sh|Parse argument basepath=/common/download/8.6.2.22900-9|<:DEBUG>

01/24/2012 18:42:33 upgrade_manager.sh|Parse argument file_name=|<:DEBUG>

01/24/2012 18:42:33 upgrade_manager.sh|Parse argument logfile=/var/log/install/install_log_2012-01-24.18.41.35.log|<:DEBUG>

01/24/2012 18:42:33 upgrade_manager.sh|Parse argument resultfile=/var/log/install/upgrade-results.xml|<:DEBUG>

01/24/2012 18:42:33 upgrade_manager.sh|Parse argument work_dir=/var/log/install|<:DEBUG>

01/24/2012 18:42:33 upgrade_manager.sh|Parse argument intf_file=/common/download/8.6.2.22900-9/upgrade_manager.xml|<:DEBUG>

01/24/2012 18:42:33 upgrade_manager.sh|Parse argument to_version=8.6.2.22900-9|<:DEBUG>

01/24/2012 18:42:33 upgrade_manager.sh|upgrade_type="upgrade"|<:DEBUG>

01/24/2012 18:42:33 upgrade_manager.sh|L2 upgrade|<:DEBUG>

01/24/2012 18:42:33 upgrade_manager.sh|Initialize install support functions|<:INFO>

01/24/2012 18:42:33 upgrade_manager.sh|Calling "source /mnt/source/Cisco/install/bin/install_func"|<:DEBUG>

01/24/2012 18:42:33 upgrade_manager.sh|Initialize install support functions complete|<:INFO>

01/24/2012 18:42:33 upgrade_manager.sh|Check for Refresh Upgrade|<:INFO>

01/24/2012 18:42:33 upgrade_manager.sh|Check if /mnt/source/upgradeConfig.xml exists|<:DEBUG>

01/24/2012 18:42:33 upgrade_manager.sh|Checking RedHat release version (5Server, 5Server)|<:DEBUG>

01/24/2012 18:42:33 upgrade_manager.sh|Continue normal upgrade processing|<:INFO>

01/24/2012 18:42:33 upgrade_manager.sh|Setting up cisco specific enviroment|<:INFO>

01/24/2012 18:42:33 upgrade_manager.sh|PATH=/common/download/8.6.2.22900-9/Cisco/bin:/usr/kerberos/sbin:/usr/kerberos/bin:/usr/local/sbin:/sbin:/usr/sbin:/bin:/usr/bin:/sbin:/home/sftpuser:/root/.security|<:DEBUG>

01/24/2012 18:42:33 upgrade_manager.sh|LD_LIBRARY_PATH=/common/download/8.6.2.22900-9/Cisco/lib:/opt/cisco/install/lib:|<:DEBUG>

01/24/2012 18:42:33 upgrade_manager.sh|PYTHONPATH=/common/download/8.6.2.22900-9/Cisco/python:/usr/local/cm/lib:/usr/local/cm/lib:/usr/local/cm/lib:|<:DEBUG>

01/24/2012 18:42:33 upgrade_manager.sh|CISCO_INSTALL_CONF_PATH=/common/download/8.6.2.22900-9/Cisco/install/conf|<:DEBUG>

01/24/2012 18:42:33 upgrade_manager.sh|CISCO_INSTALL_BIN_PATH=/common/download/8.6.2.22900-9/Cisco/bin /opt/cisco/install/bin|<:DEBUG>

01/24/2012 18:42:33 upgrade_manager.sh|CISCO_PLATFORMCONF_PATH=/common/cisco /usr/local/platform/conf|<:DEBUG>

01/24/2012 18:42:33 upgrade_manager.sh|Set logging globals for upgrade|<:INFO>

01/24/2012 18:42:33 upgrade_manager.sh|Before: ILOG_CONTEXT="Upgrade", ILOG_FILE="/var/log/install/install_log_2012-01-24.18.41.35.log", ILOG_RESULTS_FILE="/var/log/install/upgrade-results.xml"|<:DEBUG>

01/24/2012 18:42:33 upgrade_manager.sh|After: ILOG_CONTEXT="Upgrade", ILOG_FILE="/common/log/install/install_log_2012-01-24.18.41.35.log", ILOG_RESULTS_FILE="/common/log/install/upgrade-results.xml"|<:DEBUG>

01/24/2012 18:42:33 upgrade_manager.sh|IOWAIT monitor starting|<:INFO>

01/24/2012 18:42:33 upgrade_manager.sh|Checksum the upgrade from /mnt/source|<:INFO>

01/24/2012 18:42:33 upgrade_manager.sh|Calling sha1sum -c /common/download/8.6.2.22900-9/checksum_file|<:DEBUG>

01/24/2012 18:44:31 upgrade_manager.sh|Checksum complete|<:INFO>

01/24/2012 18:44:31 upgrade_manager.sh|Setup RAM disk for upgrade|<:INFO>

01/24/2012 18:44:31 upgrade_manager.sh|Make product.img mount point|<:INFO>

01/24/2012 18:44:31 upgrade_manager.sh|Calling umount /common/mnt/product_img|<:DEBUG>

01/24/2012 18:44:31 upgrade_manager.sh|Create /common/cisco link to the RAM disk|<:INFO>

01/24/2012 18:44:31 upgrade_manager.sh|Calling rm -rf /common/cisco|<:DEBUG>

01/24/2012 18:44:31 upgrade_manager.sh|Calling ln -s /common/download/8.6.2.22900-9/Cisco /common/cisco|<:DEBUG>

01/24/2012 18:44:31 upgrade_manager.sh|Copy product.img information to the RAM disk|<:INFO>

01/24/2012 18:44:31 upgrade_manager.sh|Calling cp -f /mnt/source/images/product.img /common/download/8.6.2.22900-9/Cisco|<:DEBUG>

01/24/2012 18:44:31 upgrade_manager.sh|Calling mount -o loop /common/download/8.6.2.22900-9/Cisco/product.img /common/mnt/product_img|<:DEBUG>

01/24/2012 18:44:32 upgrade_manager.sh|Calling cd /common/mnt/product_img; find | cpio -pdu -R root.         /common/download/8.6.2.22900-9/Cisco|<:DEBUG>

01/24/2012 18:44:32 upgrade_manager.sh|Calling umount /common/mnt/product_img|<:DEBUG>

01/24/2012 18:44:32 upgrade_manager.sh|Copy install information to the RAM disk|<:INFO>

01/24/2012 18:44:32 upgrade_manager.sh|Calling mkdir -f /common/download/8.6.2.22900-9/Cisco/install|<:DEBUG>

01/24/2012 18:44:32 upgrade_manager.sh|Calling cp -r /mnt/source/Cisco/install/* /common/download/8.6.2.22900-9/Cisco/install|<:DEBUG>

01/24/2012 18:44:32 upgrade_manager.sh|Initialize APIs|<:INFO>

01/24/2012 18:44:32 upgrade_manager.sh|Initialize logging|<:INFO>

01/24/2012 18:44:32 upgrade_manager.sh|Initializing the product API|<:INFO>

01/24/2012 18:44:33 upgrade_manager.sh|Initializing the hardware API|<:INFO>

01/24/2012 18:44:34 ServerApiManager|INITIALIZE: sam_legacy_mode_init=1|<:DEBUG>

01/24/2012 18:44:46 ServerApiManager|INITIALIZE: sam_hssi_mode_init=0|<:DEBUG>

01/24/2012 18:44:46 upgrade_manager.sh|Initializing the history log API|<:INFO>

01/24/2012 18:44:46 upgrade_manager.sh|Initializing the xplatformconfig API|<:INFO>

01/24/2012 18:44:46 upgrade_manager.sh|Initializing the xproduct API|<:INFO>

01/24/2012 18:44:46 upgrade_manager.sh|Initializing the diagnostic dump interface|<:INFO>

01/24/2012 18:44:46 upgrade_manager.sh|Initialize setup functions|<:INFO>

01/24/2012 18:44:46 upgrade_manager.sh|Calling "source /common/download/8.6.2.22900-9/Cisco/install/setup/utils.sh"|<:DEBUG>

01/24/2012 18:44:46 upgrade_manager.sh|Calling "source /common/download/8.6.2.22900-9/Cisco/install/setup/populate_archive.sh"|<:DEBUG>

01/24/2012 18:44:46 upgrade_manager.sh|Initialize setup functions complete|<:INFO>

01/24/2012 18:44:46 upgrade_manager.sh|Getting deployment ID from active side|<:INFO>

01/24/2012 18:44:46 upgrade_manager.sh|Copy /mnt/source/Cisco/base_bin/PlatformXmlUpg to /common/download/8.6.2.22900-9/Cisco/bin|<:INFO>

01/24/2012 18:44:46 upgrade_manager.sh|Calling "cp /mnt/source/Cisco/base_bin/PlatformXmlUpg /common/download/8.6.2.22900-9/Cisco/bin"|<:DEBUG>

01/24/2012 18:44:46 upgrade_manager.sh|Calling /common/download/8.6.2.22900-9/Cisco/bin/PlatformXmlUpg /usr/local/platform/conf/platformConfig.xml /common/cisco/platformConfig.xml|<:DEBUG>

01/24/2012 18:44:46 PlatformXmlUpg|Migrating to version main/5.|<:INFO>

01/24/2012 18:44:46 PlatformXmlUpg|Source file is "/usr/local/platform/conf/platformConfig.xml"|<:INFO>

01/24/2012 18:44:46 PlatformXmlUpg|Destination file is "/common/cisco/platformConfig.xml"|<:INFO>

01/24/2012 18:44:46 PlatformXmlUpg|Found /usr/local/platform/conf/platformConfig.xml.|<:DEBUG>

01/24/2012 18:44:46 PlatformXmlUpg|Copying /usr/local/platform/conf/platformConfig.xml to /common/cisco/platformConfig.xml prior to possible migration.|<:DEBUG>

01/24/2012 18:44:46 PlatformXmlUpg|Populating from /usr/local/platform/conf/platformConfig.xml.|<:INFO>

01/24/2012 18:44:46 PlatformXmlUpg|Wrote 6326 bytes to /common/cisco/platformConfig.xml.|<:DEBUG>

01/24/2012 18:44:46 PlatformXmlUpg|Migrating from version main/5.|<:INFO>

01/24/2012 18:44:46 PlatformXmlUpg|Timezone Tag found: Europe/London, nothing to migrate.|<:WARN>

01/24/2012 18:44:46 PlatformXmlUpg|Migrating application user name...|<:INFO>

01/24/2012 18:44:46 PlatformXmlUpg|Mandatory tag ApplUserUsername not found.  Adding tag using default value of CCMAdministrator|<:INFO>

01/24/2012 18:44:46 PlatformXmlUpg|Migrating NIC settings...|<:INFO>

01/24/2012 18:44:46 PlatformXmlUpg|NIC Auto Negotiate enabled.|<:INFO>

01/24/2012 18:44:46 PlatformXmlUpg|Removing unnecessary tag LocalHostNICSpeed|<:INFO>

01/24/2012 18:44:46 PlatformXmlUpg|Removing unnecessary tag LocalHostNICDuplex|<:INFO>

01/24/2012 18:44:46 PlatformXmlUpg|Removing obsolete NTP client data ...|<:INFO>

01/24/2012 18:44:46 PlatformXmlUpg|First node in the cluster 'no'|<:INFO>

01/24/2012 18:44:46 PlatformXmlUpg|Migrating non-primary node NTP data ...|<:INFO>

01/24/2012 18:44:46 PlatformXmlUpg|Host Name for DataBase 'Colo-LonCCM-01'|<:INFO>

01/24/2012 18:44:46 PlatformXmlUpg|Host IP Addr for DataBase '172.22.97.20'|<:INFO>

01/24/2012 18:44:46 PlatformXmlUpg|Migrating DNS data ...|<:INFO>

01/24/2012 18:44:46 PlatformXmlUpg|Removing transient tags.|<:INFO>

01/24/2012 18:44:46 PlatformXmlUpg|Removing obsolete tags.|<:INFO>

01/24/2012 18:44:46 PlatformXmlUpg|Setting version to main/5.|<:INFO>

01/24/2012 18:44:46 PlatformXmlUpg|Wrote 6536 bytes to /common/cisco/platformConfig.xml.|<:DEBUG>

01/24/2012 18:44:46 PlatformXmlUpg|Migration success|<:DEBUG>

01/24/2012 18:44:46 PlatformXmlUpg|Exiting with code 0|<:DEBUG>

01/24/2012 18:44:47 upgrade_manager.sh|Upgrade (L2) Starting|<:INFO>

01/24/2012 18:44:47 upgrade_manager.sh|(CAPTURE) Mail notification cancelled - smtp server address for email not found! [/common/cisco/platformConfig.xml]|<:DEBUG>

01/24/2012 18:44:47 upgrade_manager.sh|Check if the upgrade is allowed|<:INFO>

01/24/2012 18:44:47 upgrade_manager.sh|Validate hardware for the upgrade|<:INFO>

01/24/2012 18:44:48 upgrade_manager.sh|Hardware is supported for the upgrade|<:INFO>

01/24/2012 18:44:50 upgrade_manager.sh|Validate hardware for "callmanager" deployment|<:INFO>

01/24/2012 18:44:50 upgrade_manager.sh|Hardware is supported for "callmanager" deployment|<:INFO>

01/24/2012 18:44:51 upgrade_manager.sh|Validate from version 8.6.2.20000-2|<:INFO>

01/24/2012 18:44:51 upgrade_manager.sh|Upgrade from 8.6.2.20000-2 allowed|<:INFO>

01/24/2012 18:44:51 upgrade_manager.sh|Validate free space for the upgrade|<:INFO>

01/24/2012 18:44:52 upgrade_manager.sh|(CAPTURE) Free space: 44543241220, Needed space: 5392796535|<:DEBUG>

01/24/2012 18:44:52 upgrade_manager.sh|Free space validation complete|<:INFO>

01/24/2012 18:44:52 upgrade_manager.sh|New version is 8.6.2.22900-9|<:INFO>

01/24/2012 18:44:53 upgrade_manager.sh|Not a restricted to unrestricted upgrade|<:INFO>

01/24/2012 18:44:53 upgrade_manager.sh|Cleanup data from a prior upgrade attempt|<:INFO>

01/24/2012 18:44:53 upgrade_manager.sh|Removing any /grub/boot/grub/grub.conf.recovery|<:DEBUG>

01/24/2012 18:44:53 upgrade_manager.sh|Invalidate upgrade partition|<:INFO>

01/24/2012 18:44:53 upgrade_manager.sh|Clean up rpm any stale __db. files in rpmdb on the to side|<:DEBUG>

01/24/2012 18:44:53 upgrade_manager.sh|Removing any master RPM from /partB|<:DEBUG>

01/24/2012 18:44:54 upgrade_manager.sh|Removing any /partB/etc/opt/cisco/install.conf|<:DEBUG>

01/24/2012 18:44:54 upgrade_manager.sh|Invalidate any product configuration file|<:DEBUG>

01/24/2012 18:44:54 upgrade_manager.sh|Setting product and deployment version attributes in /partB/etc/opt/cisco/install/conf/callmanager_product.conf to 0.0.0.0000-0000|<:DEBUG>

01/24/2012 18:44:54 upgrade_manager.sh|Populate RPMs in RPM archive|<:INFO>

01/24/2012 18:44:54 populate_rpm_archive|Initializing xproduct API|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Initializing xcomponent API|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Initializing xplatformconfig API|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Calling "source /common/cisco/install/setup/utils.sh"|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Parse argument type=os|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Parse argument mode=upgrade|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Parse argument archive_version=8.6.2.22900-9|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Parse argument src_base=/mnt/source|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Parse argument archive_base=/common/rpm-archive|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Parse argument rpms=acpid-1.0.4-9.el5_4.2.i386.rpm audit-1.7.17-3.el5.i386.rpm audit-libs-1.7.17-3.el5.i386.rpm audit-libs-python-1.7.17-3.el5.i386.rpm authconfig-5.3.21-6.el5.i386.rpm basesystem-8.0-5.1.1.noarch.rpm bash-3.2-32.el5.i386.rpm beecrypt-4.1.2-10.1.1.i386.rpm bzip2-libs-1.0.3-6.el5_5.i386.rpm chkconfig-1.3.30.2-2.el5.i386.rpm coreutils-5.97-23.el5_4.2.i386.rpm cpio-2.6-23.el5_4.1.i386.rpm cracklib-2.8.9-3.3.i386.rpm cracklib-dicts-2.8.9-3.3.i386.rpm cryptsetup-luks-1.0.3-5.el5.i386.rpm cyrus-sasl-lib-2.1.22-5.el5_4.3.i386.rpm db4-4.3.29-10.el5.i386.rpm dbus-1.1.2-16.el5_7.i386.rpm dbus-glib-0.73-10.el5_5.i386.rpm dbus-libs-1.1.2-16.el5_7.i386.rpm dbus-python-0.70-9.el5_4.i386.rpm device-mapper-1.02.39-1.el5.i386.rpm device-mapper-event-1.02.39-1.el5.i386.rpm device-mapper-multipath-0.4.7-34.el5.i386.rpm dmraid-1.0.0.rc13-63.el5.i386.rpm dmraid-events-1.0.0.rc13-63.el5.i386.rpm e2fsprogs-1.39-23.el5.i386.rpm e2fsprogs-libs-1.39-23.el5.i386.rpm elfutils-libelf-0.137-3.el5.i386.rpm elfutils-libs-0|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Populate RPM archive for os type, mode upgrade|<:INFO>

01/24/2012 18:44:54 populate_rpm_archive|Populate RPM archive for os type , mode upgrade RTMTStart|<:NOTICE>

01/24/2012 18:44:54 populate_rpm_archive|Initialize global data, mode upgrade|<:INFO>

01/24/2012 18:44:54 populate_rpm_archive|Initialize global data, mode upgrade complete|<:INFO>

01/24/2012 18:44:54 populate_rpm_archive|Initialize command list|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Initialize component data, mode upgrade|<:INFO>

01/24/2012 18:44:54 populate_rpm_archive|Initialize component data, mode upgrade complete|<:INFO>

01/24/2012 18:44:54 populate_rpm_archive|Build the command list for os|<:INFO>

01/24/2012 18:44:54 populate_rpm_archive|Calling "mkdir -p /common/rpm-archive/8.6.2.22900-9/RPMS"|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Copy acpid-1.0.4-9.el5_4.2.i386.rpm to /common/rpm-archive/8.6.2.22900-9/RPMS|<:INFO>

01/24/2012 18:44:54 populate_rpm_archive|Located acpid-1.0.4-9.el5_4.2.i386.rpm in /mnt/source/RedHat/RPMS|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Add "cp /mnt/source/RedHat/RPMS/acpid-1.0.4-9.el5_4.2.i386.rpm /common/rpm-archive/8.6.2.22900-9/RPMS/acpid-1.0.4-9.el5_4.2.i386.rpm" to command list|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Copy audit-1.7.17-3.el5.i386.rpm to /common/rpm-archive/8.6.2.22900-9/RPMS|<:INFO>

01/24/2012 18:44:54 populate_rpm_archive|Located audit-1.7.17-3.el5.i386.rpm in /mnt/source/RedHat/RPMS|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Add "cp /mnt/source/RedHat/RPMS/audit-1.7.17-3.el5.i386.rpm /common/rpm-archive/8.6.2.22900-9/RPMS/audit-1.7.17-3.el5.i386.rpm" to command list|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Copy audit-libs-1.7.17-3.el5.i386.rpm to /common/rpm-archive/8.6.2.22900-9/RPMS|<:INFO>

01/24/2012 18:44:54 populate_rpm_archive|Located audit-libs-1.7.17-3.el5.i386.rpm in /mnt/source/RedHat/RPMS|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Add "cp /mnt/source/RedHat/RPMS/audit-libs-1.7.17-3.el5.i386.rpm /common/rpm-archive/8.6.2.22900-9/RPMS/audit-libs-1.7.17-3.el5.i386.rpm" to command list|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Copy audit-libs-python-1.7.17-3.el5.i386.rpm to /common/rpm-archive/8.6.2.22900-9/RPMS|<:INFO>

01/24/2012 18:44:54 populate_rpm_archive|Located audit-libs-python-1.7.17-3.el5.i386.rpm in /mnt/source/RedHat/RPMS|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Add "cp /mnt/source/RedHat/RPMS/audit-libs-python-1.7.17-3.el5.i386.rpm /common/rpm-archive/8.6.2.22900-9/RPMS/audit-libs-python-1.7.17-3.el5.i386.rpm" to command list|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Copy authconfig-5.3.21-6.el5.i386.rpm to /common/rpm-archive/8.6.2.22900-9/RPMS|<:INFO>

01/24/2012 18:44:54 populate_rpm_archive|Located authconfig-5.3.21-6.el5.i386.rpm in /mnt/source/RedHat/RPMS|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Add "cp /mnt/source/RedHat/RPMS/authconfig-5.3.21-6.el5.i386.rpm /common/rpm-archive/8.6.2.22900-9/RPMS/authconfig-5.3.21-6.el5.i386.rpm" to command list|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Copy basesystem-8.0-5.1.1.noarch.rpm to /common/rpm-archive/8.6.2.22900-9/RPMS|<:INFO>

01/24/2012 18:44:54 populate_rpm_archive|Located basesystem-8.0-5.1.1.noarch.rpm in /mnt/source/RedHat/RPMS|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Add "cp /mnt/source/RedHat/RPMS/basesystem-8.0-5.1.1.noarch.rpm /common/rpm-archive/8.6.2.22900-9/RPMS/basesystem-8.0-5.1.1.noarch.rpm" to command list|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Copy bash-3.2-32.el5.i386.rpm to /common/rpm-archive/8.6.2.22900-9/RPMS|<:INFO>

01/24/2012 18:44:54 populate_rpm_archive|Located bash-3.2-32.el5.i386.rpm in /mnt/source/RedHat/RPMS|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Add "cp /mnt/source/RedHat/RPMS/bash-3.2-32.el5.i386.rpm /common/rpm-archive/8.6.2.22900-9/RPMS/bash-3.2-32.el5.i386.rpm" to command list|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Copy beecrypt-4.1.2-10.1.1.i386.rpm to /common/rpm-archive/8.6.2.22900-9/RPMS|<:INFO>

01/24/2012 18:44:54 populate_rpm_archive|Located beecrypt-4.1.2-10.1.1.i386.rpm in /mnt/source/RedHat/RPMS|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Add "cp /mnt/source/RedHat/RPMS/beecrypt-4.1.2-10.1.1.i386.rpm /common/rpm-archive/8.6.2.22900-9/RPMS/beecrypt-4.1.2-10.1.1.i386.rpm" to command list|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Copy bzip2-libs-1.0.3-6.el5_5.i386.rpm to /common/rpm-archive/8.6.2.22900-9/RPMS|<:INFO>

01/24/2012 18:44:54 populate_rpm_archive|Located bzip2-libs-1.0.3-6.el5_5.i386.rpm in /mnt/source/RedHat/RPMS|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Add "cp /mnt/source/RedHat/RPMS/bzip2-libs-1.0.3-6.el5_5.i386.rpm /common/rpm-archive/8.6.2.22900-9/RPMS/bzip2-libs-1.0.3-6.el5_5.i386.rpm" to command list|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Copy chkconfig-1.3.30.2-2.el5.i386.rpm to /common/rpm-archive/8.6.2.22900-9/RPMS|<:INFO>

01/24/2012 18:44:54 populate_rpm_archive|Located chkconfig-1.3.30.2-2.el5.i386.rpm in /mnt/source/RedHat/RPMS|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Add "cp /mnt/source/RedHat/RPMS/chkconfig-1.3.30.2-2.el5.i386.rpm /common/rpm-archive/8.6.2.22900-9/RPMS/chkconfig-1.3.30.2-2.el5.i386.rpm" to command list|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Copy coreutils-5.97-23.el5_4.2.i386.rpm to /common/rpm-archive/8.6.2.22900-9/RPMS|<:INFO>

01/24/2012 18:44:54 populate_rpm_archive|Located coreutils-5.97-23.el5_4.2.i386.rpm in /mnt/source/RedHat/RPMS|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Add "cp /mnt/source/RedHat/RPMS/coreutils-5.97-23.el5_4.2.i386.rpm /common/rpm-archive/8.6.2.22900-9/RPMS/coreutils-5.97-23.el5_4.2.i386.rpm" to command list|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Copy cpio-2.6-23.el5_4.1.i386.rpm to /common/rpm-archive/8.6.2.22900-9/RPMS|<:INFO>

01/24/2012 18:44:54 populate_rpm_archive|Located cpio-2.6-23.el5_4.1.i386.rpm in /mnt/source/RedHat/RPMS|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Add "cp /mnt/source/RedHat/RPMS/cpio-2.6-23.el5_4.1.i386.rpm /common/rpm-archive/8.6.2.22900-9/RPMS/cpio-2.6-23.el5_4.1.i386.rpm" to command list|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Copy cracklib-2.8.9-3.3.i386.rpm to /common/rpm-archive/8.6.2.22900-9/RPMS|<:INFO>

01/24/2012 18:44:54 populate_rpm_archive|Located cracklib-2.8.9-3.3.i386.rpm in /mnt/source/RedHat/RPMS|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Add "cp /mnt/source/RedHat/RPMS/cracklib-2.8.9-3.3.i386.rpm /common/rpm-archive/8.6.2.22900-9/RPMS/cracklib-2.8.9-3.3.i386.rpm" to command list|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Copy cracklib-dicts-2.8.9-3.3.i386.rpm to /common/rpm-archive/8.6.2.22900-9/RPMS|<:INFO>

01/24/2012 18:44:54 populate_rpm_archive|Located cracklib-dicts-2.8.9-3.3.i386.rpm in /mnt/source/RedHat/RPMS|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Add "cp /mnt/source/RedHat/RPMS/cracklib-dicts-2.8.9-3.3.i386.rpm /common/rpm-archive/8.6.2.22900-9/RPMS/cracklib-dicts-2.8.9-3.3.i386.rpm" to command list|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Copy cryptsetup-luks-1.0.3-5.el5.i386.rpm to /common/rpm-archive/8.6.2.22900-9/RPMS|<:INFO>

01/24/2012 18:44:54 populate_rpm_archive|Located cryptsetup-luks-1.0.3-5.el5.i386.rpm in /mnt/source/RedHat/RPMS|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Add "cp /mnt/source/RedHat/RPMS/cryptsetup-luks-1.0.3-5.el5.i386.rpm /common/rpm-archive/8.6.2.22900-9/RPMS/cryptsetup-luks-1.0.3-5.el5.i386.rpm" to command list|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Copy cyrus-sasl-lib-2.1.22-5.el5_4.3.i386.rpm to /common/rpm-archive/8.6.2.22900-9/RPMS|<:INFO>

01/24/2012 18:44:54 populate_rpm_archive|Located cyrus-sasl-lib-2.1.22-5.el5_4.3.i386.rpm in /mnt/source/RedHat/RPMS|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Add "cp /mnt/source/RedHat/RPMS/cyrus-sasl-lib-2.1.22-5.el5_4.3.i386.rpm /common/rpm-archive/8.6.2.22900-9/RPMS/cyrus-sasl-lib-2.1.22-5.el5_4.3.i386.rpm" to command list|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Copy db4-4.3.29-10.el5.i386.rpm to /common/rpm-archive/8.6.2.22900-9/RPMS|<:INFO>

01/24/2012 18:44:54 populate_rpm_archive|Located db4-4.3.29-10.el5.i386.rpm in /mnt/source/RedHat/RPMS|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Add "cp /mnt/source/RedHat/RPMS/db4-4.3.29-10.el5.i386.rpm /common/rpm-archive/8.6.2.22900-9/RPMS/db4-4.3.29-10.el5.i386.rpm" to command list|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Copy dbus-1.1.2-16.el5_7.i386.rpm to /common/rpm-archive/8.6.2.22900-9/RPMS|<:INFO>

01/24/2012 18:44:54 populate_rpm_archive|Located dbus-1.1.2-16.el5_7.i386.rpm in /mnt/source/RedHat/RPMS|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Add "cp /mnt/source/RedHat/RPMS/dbus-1.1.2-16.el5_7.i386.rpm /common/rpm-archive/8.6.2.22900-9/RPMS/dbus-1.1.2-16.el5_7.i386.rpm" to command list|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Copy dbus-glib-0.73-10.el5_5.i386.rpm to /common/rpm-archive/8.6.2.22900-9/RPMS|<:INFO>

01/24/2012 18:44:54 populate_rpm_archive|Located dbus-glib-0.73-10.el5_5.i386.rpm in /mnt/source/RedHat/RPMS|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Add "cp /mnt/source/RedHat/RPMS/dbus-glib-0.73-10.el5_5.i386.rpm /common/rpm-archive/8.6.2.22900-9/RPMS/dbus-glib-0.73-10.el5_5.i386.rpm" to command list|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Copy dbus-libs-1.1.2-16.el5_7.i386.rpm to /common/rpm-archive/8.6.2.22900-9/RPMS|<:INFO>

01/24/2012 18:44:54 populate_rpm_archive|Located dbus-libs-1.1.2-16.el5_7.i386.rpm in /mnt/source/RedHat/RPMS|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Add "cp /mnt/source/RedHat/RPMS/dbus-libs-1.1.2-16.el5_7.i386.rpm /common/rpm-archive/8.6.2.22900-9/RPMS/dbus-libs-1.1.2-16.el5_7.i386.rpm" to command list|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Copy dbus-python-0.70-9.el5_4.i386.rpm to /common/rpm-archive/8.6.2.22900-9/RPMS|<:INFO>

01/24/2012 18:44:54 populate_rpm_archive|Located dbus-python-0.70-9.el5_4.i386.rpm in /mnt/source/RedHat/RPMS|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Add "cp /mnt/source/RedHat/RPMS/dbus-python-0.70-9.el5_4.i386.rpm /common/rpm-archive/8.6.2.22900-9/RPMS/dbus-python-0.70-9.el5_4.i386.rpm" to command list|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Copy device-mapper-1.02.39-1.el5.i386.rpm to /common/rpm-archive/8.6.2.22900-9/RPMS|<:INFO>

01/24/2012 18:44:54 populate_rpm_archive|Located device-mapper-1.02.39-1.el5.i386.rpm in /mnt/source/RedHat/RPMS|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Add "cp /mnt/source/RedHat/RPMS/device-mapper-1.02.39-1.el5.i386.rpm /common/rpm-archive/8.6.2.22900-9/RPMS/device-mapper-1.02.39-1.el5.i386.rpm" to command list|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Copy device-mapper-event-1.02.39-1.el5.i386.rpm to /common/rpm-archive/8.6.2.22900-9/RPMS|<:INFO>

01/24/2012 18:44:54 populate_rpm_archive|Located device-mapper-event-1.02.39-1.el5.i386.rpm in /mnt/source/RedHat/RPMS|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Add "cp /mnt/source/RedHat/RPMS/device-mapper-event-1.02.39-1.el5.i386.rpm /common/rpm-archive/8.6.2.22900-9/RPMS/device-mapper-event-1.02.39-1.el5.i386.rpm" to command list|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Copy device-mapper-multipath-0.4.7-34.el5.i386.rpm to /common/rpm-archive/8.6.2.22900-9/RPMS|<:INFO>

01/24/2012 18:44:54 populate_rpm_archive|Located device-mapper-multipath-0.4.7-34.el5.i386.rpm in /mnt/source/RedHat/RPMS|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Add "cp /mnt/source/RedHat/RPMS/device-mapper-multipath-0.4.7-34.el5.i386.rpm /common/rpm-archive/8.6.2.22900-9/RPMS/device-mapper-multipath-0.4.7-34.el5.i386.rpm" to command list|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Copy dmraid-1.0.0.rc13-63.el5.i386.rpm to /common/rpm-archive/8.6.2.22900-9/RPMS|<:INFO>

01/24/2012 18:44:54 populate_rpm_archive|Located dmraid-1.0.0.rc13-63.el5.i386.rpm in /mnt/source/RedHat/RPMS|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Add "cp /mnt/source/RedHat/RPMS/dmraid-1.0.0.rc13-63.el5.i386.rpm /common/rpm-archive/8.6.2.22900-9/RPMS/dmraid-1.0.0.rc13-63.el5.i386.rpm" to command list|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Copy dmraid-events-1.0.0.rc13-63.el5.i386.rpm to /common/rpm-archive/8.6.2.22900-9/RPMS|<:INFO>

01/24/2012 18:44:54 populate_rpm_archive|Located dmraid-events-1.0.0.rc13-63.el5.i386.rpm in /mnt/source/RedHat/RPMS|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Add "cp /mnt/source/RedHat/RPMS/dmraid-events-1.0.0.rc13-63.el5.i386.rpm /common/rpm-archive/8.6.2.22900-9/RPMS/dmraid-events-1.0.0.rc13-63.el5.i386.rpm" to command list|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Located e2fsprogs-1.39-23.el5.i386.rpm in /mnt/source/RedHat/RPMS|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Add "cp /mnt/source/RedHat/RPMS/e2fsprogs-1.39-23.el5.i386.rpm /common/rpm-archive/8.6.2.22900-9/RPMS/e2fsprogs-1.39-23.el5.i386.rpm" to command list|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Copy e2fsprogs-libs-1.39-23.el5.i386.rpm to /common/rpm-archive/8.6.2.22900-9/RPMS|<:INFO>

01/24/2012 18:44:54 populate_rpm_archive|Located e2fsprogs-libs-1.39-23.el5.i386.rpm in /mnt/source/RedHat/RPMS|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Add "cp /mnt/source/RedHat/RPMS/e2fsprogs-libs-1.39-23.el5.i386.rpm /common/rpm-archive/8.6.2.22900-9/RPMS/e2fsprogs-libs-1.39-23.el5.i386.rpm" to command list|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Copy elfutils-libelf-0.137-3.el5.i386.rpm to /common/rpm-archive/8.6.2.22900-9/RPMS|<:INFO>

01/24/2012 18:44:54 populate_rpm_archive|Located elfutils-libelf-0.137-3.el5.i386.rpm in /mnt/source/RedHat/RPMS|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Add "cp /mnt/source/RedHat/RPMS/elfutils-libelf-0.137-3.el5.i386.rpm /common/rpm-archive/8.6.2.22900-9/RPMS/elfutils-libelf-0.137-3.el5.i386.rpm" to command list|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Copy elfutils-libs-0.137-3.el5.i386.rpm to /common/rpm-archive/8.6.2.22900-9/RPMS|<:INFO>

01/24/2012 18:44:54 populate_rpm_archive|Located elfutils-libs-0.137-3.el5.i386.rpm in /mnt/source/RedHat/RPMS|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Add "cp /mnt/source/RedHat/RPMS/elfutils-libs-0.137-3.el5.i386.rpm /common/rpm-archive/8.6.2.22900-9/RPMS/elfutils-libs-0.137-3.el5.i386.rpm" to command list|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Copy expat-1.95.8-8.3.el5_4.2.i386.rpm to /common/rpm-archive/8.6.2.22900-9/RPMS|<:INFO>

01/24/2012 18:44:54 populate_rpm_archive|Located expat-1.95.8-8.3.el5_4.2.i386.rpm in /mnt/source/RedHat/RPMS|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Add "cp /mnt/source/RedHat/RPMS/expat-1.95.8-8.3.el5_4.2.i386.rpm /common/rpm-archive/8.6.2.22900-9/RPMS/expat-1.95.8-8.3.el5_4.2.i386.rpm" to command list|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Copy file-4.17-15.el5_3.1.i386.rpm to /common/rpm-archive/8.6.2.22900-9/RPMS|<:INFO>

01/24/2012 18:44:54 populate_rpm_archive|Located file-4.17-15.el5_3.1.i386.rpm in /mnt/source/RedHat/RPMS|<:DEBUG>

01/24/2012 18:44:54 populate_rpm_archive|Add "cp /mnt/source/RedHat/RPMS/file-4.17-15.el5_3.1.i386.rpm /common/rpm-archive/8.6.2.22900-9/RPMS/file-4.17-15.el5_3.1.i38