Skip to content
This repository has been archived by the owner on Mar 9, 2023. It is now read-only.

Changing Set on multiple Articles extremely slow #16

Closed
kayaj opened this issue Jan 6, 2016 · 5 comments
Closed

Changing Set on multiple Articles extremely slow #16

kayaj opened this issue Jan 6, 2016 · 5 comments

Comments

@kayaj
Copy link

kayaj commented Jan 6, 2016

Hey guys

Great extension, but I have some issues:
I think the changing is extremely slow when changing more than 1 Article.
Is it normal behavior, that it takes approx. 4 seconds per article?

I'm on a very fast SSD server, so I doubt it's the ressources.
Btw: Compiler isn't active.

Best
@davidfuhr
Copy link
Contributor

Could you please run a profiler (xhprof, blackfire, ...) and check the results?

@Stajon
Copy link

Stajon commented Jan 28, 2016

Hey,

I have the same issue.

I noticed that changing is much faster when I disable my Full page cache, which is from the extension Lesti FPC.

Hope it helps to track down the problem?!

Edit: I also need to flush the Magento cache to get the extension work fast.

@sreichel
Copy link
Contributor

I had some time to investigate it ... tested with 20 produtcs (without configurable attributes):

Current version:

Overall Summary
Total Incl. Wall Time (microsec):117,795,948 microsecs
Total Incl. CPU (microsecs):114,251,865 microsecs
Total Incl. MemUse (bytes):21,320,672 bytes
Total Incl. PeakMemUse (bytes):21,928,912 bytes
Number of Function Calls:5,359,566
Function NameCallsCalls%Incl. Wall Time
(microsec)		IWall%Excl. Wall Time
(microsec)		EWall%Incl. CPU
(microsecs)		ICpu%Excl. CPU
(microsec)		ECPU%Incl.
MemUse
(bytes)		IMemUse%Excl.
MemUse
(bytes)		EMemUse%Incl.
PeakMemUse
(bytes)		IPeakMemUse%Excl.
PeakMemUse
(bytes)		EPeakMemUse%
main() 1 0.0% 117,795,948 100.0% 1,456 0.0% 114,251,865 100.0% 1,319 0.0% 21,320,672 100.0% 10,072 0.0% 21,928,912 100.0% 5,016 0.0%
Mage_Eav_Model_Entity_Collection_Abstract::save 1 0.0% 117,037,594 99.4% 283 0.0% 113,522,968 99.4% 323 0.0% 16,931,056 79.4% 1,736 0.0% 17,248,112 78.7% 192 0.0%
Mage_Core_Model_Abstract::save 20 0.0% 117,037,245 99.4% 2,946 0.0% 113,522,578 99.4% 2,601 0.0% 16,927,384 79.4% 13,688 0.1% 17,246,720 78.6% 2,520 0.0%
call_user_func_array 4,222 0.1% 93,339,674 79.2% 89,528 0.1% 90,395,819 79.1% 89,566 0.1% 15,086,488 70.8% 1,102,256 5.2% 13,250,192 60.4% 9,864 0.0%
Mage_Core_Model_Resource_Abstract::commit 20 0.0% 77,145,752 65.5% 1,918 0.0% 74,192,689 64.9% 1,702 0.0% 7,091,408 33.3% -10,992 -0.1% 10,549,768 48.1% 0 0.0%
call_user_func 20 0.0% 77,105,974 65.5% 447 0.0% 74,180,329 64.9% 474 0.0% 7,087,864 33.2% 1,184 0.0% 10,549,768 48.1% 0 0.0%
Mage_Catalog_Model_Product::afterCommitCallback 20 0.0% 77,105,527 65.5% 878 0.0% 74,179,855 64.9% 843 0.0% 7,086,680 33.2% 2,136 0.0% 10,549,768 48.1% 576 0.0%
Mage_Index_Model_Indexer::processEntityAction 20 0.0% 77,091,194 65.4% 1,519 0.0% 74,165,549 64.9% 1,350 0.0% 6,935,672 32.5% -82,504 -0.4% 10,439,672 47.6% 976 0.0%
Mage_Index_Model_Indexer::_runAll 40 0.0% 76,173,061 64.7% 18,733 0.0% 73,307,547 64.2% 17,239 0.0% 6,856,624 32.2% -129,952 -0.6% 10,418,600 47.5% 1,624 0.0%
Mage_Index_Model_Indexer::indexEvent 20 0.0% 67,023,593 56.9% 645 0.0% 64,248,483 56.2% 610 0.0% 4,868,152 22.8% 1,400 0.0% 8,709,328 39.7% 464 0.0%
Mage_Index_Model_Process::processEvent 180 0.0% 66,904,577 56.8% 19,532 0.0% 64,129,579 56.1% 18,456 0.0% 4,864,592 22.8% 26,592 0.1% 8,706,816 39.7% 1,472 0.0%
Mage_Index_Model_Indexer_Abstract::processEvent 160 0.0% 66,705,791 56.6% 4,978 0.0% 63,931,093 56.0% 4,811 0.0% 4,843,792 22.7% 4,584 0.0% 8,660,152 39.5% 1,144 0.0%
Mage_CatalogSearch_Model_Indexer_Fulltext::_processEvent 20 0.0% 33,017,512 28.0% 1,933 0.0% 31,448,623 27.5% 1,715 0.0% 3,220,536 15.1% -8,936 -0.0% 6,744,160 30.8% 0 0.0%
Mage_Catalog_Model_Product_Indexer_Flat::_processEvent 20 0.0% 32,797,418 27.8% 967 0.0% 31,670,288 27.7% 866 0.0% 1,271,472 6.0% 1,952 0.0% 1,290,872 5.9% 0 0.0%
Mage_Catalog_Model_Product_Flat_Indexer::saveProduct 20 0.0% 32,791,826 27.8% 4,160 0.0% 31,665,062 27.7% 3,831 0.0% 1,226,216 5.8% -14,288 -0.1% 1,290,872 5.9% 192 0.0%
Mage_Catalog_Model_Product_Flat_Indexer::saveProduct@1 140 0.0% 32,759,295 27.8% 12,491 0.0% 31,632,689 27.7% 11,305 0.0% 1,219,504 5.7% 3,968 0.0% 1,290,584 5.9% 840 0.0%
Mage_Catalog_Model_Resource_Eav_Mysql4_Product_Flat_Indexer::saveProduct 140 0.0% 31,957,835 27.1% 6,356 0.0% 30,994,798 27.1% 5,650 0.0% 1,137,272 5.3% 2,472 0.0% 1,154,608 5.3% 0 0.0%
Mage_CatalogSearch_Model_Fulltext::rebuildIndex 20 0.0% 29,720,704 25.2% 751 0.0% 28,347,924 24.8% 726 0.0% 2,116,408 9.9% 1,560 0.0% 5,363,176 24.5% 272 0.0%
Mage_CatalogSearch_Model_Mysql4_Fulltext::rebuildIndex 20 0.0% 29,713,941 25.2% 4,530 0.0% 28,341,174 24.8% 3,902 0.0% 2,021,224 9.5% -13,896 -0.1% 5,294,152 24.1% 1,840 0.0%
Mage_CatalogSearch_Model_Mysql4_Fulltext::_rebuildStoreIndex 140 0.0% 29,679,305 25.2% 56,789 0.0% 28,307,152 24.8% 51,977 0.0% 2,015,104 9.5% -5,261,448 -24.7% 5,288,496 24.1% 3,512 0.0%
Mage_Catalog_Model_Resource_Eav_Mysql4_Product_Flat_Indexer::updateEavAttributes 140 0.0% 29,295,539 24.9% 171,591 0.1% 28,398,283 24.9% 154,349 0.1% 834,952 3.9% 2,832 0.0% 853,464 3.9% 0 0.0%
Mage_Catalog_Model_Resource_Eav_Mysql4_Product_Flat_Indexer::updateAttribute 4,620 0.1% 28,663,076 24.3% 809,301 0.7% 27,771,632 24.3% 744,868 0.7% 828,568 3.9% -34,849,584 -163.5% 853,464 3.9% 176 0.0%
Mage_Catalog_Model_Product::_afterSave 20 0.0% 27,076,105 23.0% 1,951 0.0% 26,735,841 23.4% 1,887 0.0% 7,748,776 36.3% 5,296 0.0% 3,580,096 16.3% 1,576 0.0%
Mage_Core_Model_Abstract::_afterSave 40 0.0% 27,034,197 23.0% 2,304 0.0% 26,716,402 23.4% 2,151 0.0% 7,570,504 35.5% -13,064 -0.1% 3,405,904 15.5% 0 0.0%
Mage_CatalogSearch_Model_Mysql4_Fulltext::_prepareProductIndex 135 0.0% 20,601,523 17.5% 663,774 0.6% 20,586,795 18.0% 613,885 0.5% 2,737,760 12.8% -3,452,136 -16.2% 1,932,984 8.8% 9,104 0.0%
Varien_Object::__call 153,832 2.9% 19,647,394 16.7% 7,492,503 6.4% 19,784,077 17.3% 7,237,144 6.3% 386,168 1.8% -9,903,272 -46.4% 413,056 1.9% 78,336 0.4%
Mage::dispatchEvent 838 0.0% 18,943,224 16.1% 43,612 0.0% 18,765,997 16.4% 41,558 0.0% 8,441,664 39.6% 15,008 0.1% 3,670,296 16.7% 11,192 0.1%
Mage_Core_Model_App::dispatchEvent 838 0.0% 18,834,801 16.0% 35,250 0.0% 18,658,411 16.3% 33,268 0.0% 8,424,320 39.5% -124,248 -0.6% 3,646,248 16.6% 26,392 0.1%
Mage_Core_Model_App::_callObserverMethod 220 0.0% 18,654,544 15.8% 7,071 0.0% 18,522,644 16.2% 7,071 0.0% 8,304,264 38.9% 7,144 0.0% 3,372,312 15.4% 3,536 0.0%
Mage_CatalogRule_Model_Observer::applyAllRulesOnProduct 20 0.0% 18,034,554 15.3% 7,728 0.0% 17,939,085 15.7% 6,957 0.0% 7,451,448 34.9% -176,200 -0.8% 2,863,704 13.1% 384 0.0%
Varien_Data_Collection_Db::load 227 0.0% 17,993,552 15.3% 37,749 0.0% 17,925,717 15.7% 34,576 0.0% 10,111,632 47.4% -1,518,984 -7.1% 5,873,768 26.8% 7,768 0.0%
Mage_CatalogSearch_Model_Mysql4_Fulltext::_getAttributeValue 13,758 0.3% 17,348,637 14.7% 1,605,467 1.4% 17,350,649 15.2% 1,486,111 1.3% 4,671,512 21.9% -2,437,264 -11.4% 1,204,912 5.5% 2,816 0.0%
Varien_Data_Collection::getIterator 197 0.0% 17,254,276 14.6% 6,273 0.0% 17,171,144 15.0% 6,251 0.0% 8,134,744 38.2% 84,352 0.4% 3,239,000 14.8% 2,904 0.0%
Mage_Core_Model_App::cleanCache 40 0.0% 16,960,614 14.4% 1,429 0.0% 16,622,113 14.5% 1,311 0.0% 143,848 0.7% 2,400 0.0% 1,897,552 8.7% 184 0.0%
Mage_Core_Model_Cache::clean 40 0.0% 16,952,944 14.4% 1,993 0.0% 16,614,612 14.5% 1,779 0.0% 140,368 0.7% -22,720 -0.1% 1,897,368 8.7% 1,176 0.0%
Varien_Cache_Core::clean 40 0.0% 16,946,958 14.4% 1,352 0.0% 16,608,654 14.5% 1,336 0.0% 136,800 0.6% -21,136 -0.1% 1,891,384 8.6% 520 0.0%
Zend_Cache_Core::clean 40 0.0% 16,941,707 14.4% 1,920 0.0% 16,603,383 14.5% 1,811 0.0% 132,280 0.6% 1,776 0.0% 1,886,792 8.6% 1,656 0.0%
Zend_Cache_Backend_File::clean 40 0.0% 16,930,856 14.4% 1,407 0.0% 16,592,577 14.5% 1,232 0.0% 122,472 0.6% 1,776 0.0% 1,878,088 8.6% 392 0.0%
Zend_Cache_Backend_File::_clean 40 0.0% 16,929,075 14.4% 22,825 0.0% 16,590,900 14.5% 19,487 0.0% 125,280 0.6% -154,200 -0.7% 1,877,096 8.6% 1,176 0.0%
Zend_Cache_Backend_File::_clean@1 600 0.0% 16,884,487 14.3% 2,284,857 1.9% 16,549,222 14.5% 2,077,616 1.8% 184,640 0.9% -19,107,032 -89.6% 1,869,224 8.5% 2,648 0.0%
Mage_CatalogRule_Model_Mysql4_Rule_Collection::_afterLoad 20 0.0% 16,853,413 14.3% 508 0.0% 16,791,650 14.7% 482 0.0% 6,756,376 31.7% 1,184 0.0% 2,570,128 11.7% 0 0.0%
Varien_Data_Collection::walk 20 0.0% 16,852,905 14.3% 2,330 0.0% 16,791,168 14.7% 2,184 0.0% 6,755,192 31.7% -11,904 -0.1% 2,570,128 11.7% 192 0.0%
Mage_Rule_Model_Rule::afterLoad 100 0.0% 16,846,598 14.3% 2,192 0.0% 16,784,941 14.7% 2,246 0.0% 6,752,296 31.7% 6,136 0.0% 2,569,744 11.7% 0 0.0%
Mage_Rule_Model_Rule::_afterLoad 100 0.0% 16,844,406 14.3% 20,425 0.0% 16,782,695 14.7% 18,133 0.0% 6,746,160 31.6% -435,896 -2.0% 2,569,744 11.7% 352 0.0%
Mage_Core_Model_Config::getModelInstance 1,973 0.0% 16,139,225 13.7% 125,226 0.1% 15,781,902 13.8% 117,477 0.1% 11,319,880 53.1% 473,408 2.2% 6,376,552 29.1% 30,720 0.1%
Varien_Db_Adapter_Pdo_Mysql::query 6,718 0.1% 15,842,086 13.4% 461,081 0.4% 13,271,812 11.6% 439,730 0.4% 6,507,040 30.5% -17,803,608 -83.5% 2,687,176 12.3% 8,296 0.0%
Mage::getModel 950 0.0% 15,061,935 12.8% 30,476 0.0% 14,932,393 13.1% 29,007 0.0% 8,087,128 37.9% 19,688 0.1% 3,934,560 17.9% 7,704 0.0%
Varien_Object::getData 231,871 4.3% 13,657,829 11.6% 7,908,886 6.7% 13,821,838 12.1% 7,749,671 6.8% 613,200 2.9% -25,447,496 -119.4% 327,680 1.5% 326,312 1.5%
Mage_Rule_Model_Condition_Abstract::__construct 260 0.0% 13,559,095 11.5% 19,786 0.0% 13,556,740 11.9% 18,477 0.0% 4,582,616 21.5% 2,832 0.0% 1,519,544 6.9% 0 0.0%
Mage_Rule_Model_Condition_Combine::loadArray 100 0.0% 13,346,253 11.3% 10,446 0.0% 13,343,523 11.7% 9,599 0.0% 3,635,056 17.0% 27,032 0.1% 1,670,816 7.6% 0 0.0%
Zend_Db_Adapter_Pdo_Abstract::query 6,718 0.1% 13,163,831 11.2% 232,533 0.2% 10,590,271 9.3% 226,582 0.2% 23,683,608 111.1% 1,680 0.0% 2,101,080 9.6% 3,216 0.0%
Zend_Db_Adapter_Abstract::query 6,718 0.1% 12,846,369 10.9% 423,731 0.4% 10,271,929 9.0% 399,365 0.3% 23,680,360 111.1% 2,248 0.0% 2,096,520 9.6% 2,424 0.0%
Mage_CatalogRule_Model_Rule_Condition_Product::loadAttributeOptions 160 0.0% 11,545,489 9.8% 508,617 0.4% 11,544,392 10.1% 466,607 0.4% 1,439,616 6.8% -867,464 -4.1% 1,493,512 6.8% 173,160 0.8%
Mage_Catalog_Model_Resource_Eav_Attribute::getFrontendInput 63,231 1.2% 9,509,926 8.1% 1,292,019 1.1% 9,568,520 8.4% 1,294,148 1.1% -6,073,408 -28.5% -6,075,392 -28.5% 74,824 0.3% 28,248 0.1%
Mage_Eav_Model_Entity_Attribute_Abstract::getFlatUpdateSelect 4,480 0.1% 9,482,816 8.1% 278,985 0.2% 9,494,023 8.3% 259,496 0.2% 22,902,968 107.4% -224,104 -1.1% 27,312 0.1% 576 0.0%
Mage_Index_Model_Indexer::logEvent 20 0.0% 9,174,061 7.8% 1,932 0.0% 9,083,659 8.0% 1,742 0.0% 2,030,328 9.5% 12,776 0.1% 1,728,392 7.9% 2,720 0.0%
Mage_Catalog_Model_Product::_beforeSave 20 0.0% 9,165,385 7.8% 2,769 0.0% 8,998,380 7.9% 2,458 0.0% 1,124,880 5.3% 18,512 0.1% 2,223,856 10.1% 2,128 0.0%
Mage_Index_Model_Indexer::registerEvent 20 0.0% 9,151,118 7.8% 619 0.0% 9,060,693 7.9% 595 0.0% 1,993,024 9.3% 1,520 0.0% 1,712,392 7.8% 1,200 0.0%
Zend_Cache_Backend_File::_getMetadatas 20,227 0.4% 9,023,982 7.7% 642,036 0.5% 8,841,818 7.7% 608,303 0.5% 460,904 2.2% 3,008 0.0% 680,184 3.1% 720 0.0%
Mage_Index_Model_Process::register 180 0.0% 9,012,267 7.7% 13,463 0.0% 8,921,988 7.8% 12,680 0.0% 1,893,448 8.9% 520 0.0% 1,605,600 7.3% 2,912 0.0%
Mage_Core_Model_Abstract::cleanModelCache 40 0.0% 8,798,248 7.5% 1,262 0.0% 8,619,737 7.5% 1,263 0.0% -37,520 -0.2% -12,136 -0.1% 366,704 1.7% 576 0.0%
Mage_Index_Model_Indexer_Abstract::register 160 0.0% 8,796,882 7.5% 5,049 0.0% 8,739,770 7.6% 4,695 0.0% 918,208 4.3% 5,352 0.0% 768,936 3.5% 4,224 0.0%
Mage_Catalog_Model_Product_Indexer_Eav::_registerEvent 20 0.0% 8,504,742 7.2% 1,052 0.0% 8,502,060 7.4% 1,022 0.0% 441,736 2.1% 1,832 0.0% 315,080 1.4% 672 0.0%
Mage_Catalog_Model_Product_Indexer_Eav::_registerCatalogProductSaveEvent 20 0.0% 8,502,424 7.2% 31,963 0.0% 8,499,776 7.4% 29,465 0.0% 438,240 2.1% -66,784 -0.3% 312,880 1.4% 2,112 0.0%
Mage_Catalog_Model_Product::cleanCache 20 0.0% 8,270,520 7.0% 834 0.0% 8,106,603 7.1% 782 0.0% 284,208 1.3% 1,752 0.0% 1,565,096 7.1% 624 0.0%
Zend_Db_Adapter_Pdo_Abstract::prepare 6,718 0.1% 7,753,711 6.6% 353,522 0.3% 7,757,012 6.8% 332,570 0.3% 21,416,912 100.5% 1,311,112 6.1% 351,472 1.6% 2,120 0.0%
Mage_Catalog_Model_Product::getAttributes 20 0.0% 7,601,748 6.5% 703 0.0% 7,599,077 6.7% 698 0.0% 417,768 2.0% 1,896 0.0% 298,920 1.4% 376 0.0%
Zend_Cache_Backend_File::_loadMetadatas 20,181 0.4% 7,600,698 6.5% 839,573 0.7% 7,450,130 6.5% 782,260 0.7% 24,413,344 114.5% -6,609,888 -31.0% 679,464 3.1% 352 0.0%
Mage_Catalog_Model_Product_Type_Abstract::getEditableAttributes 20 0.0% 7,600,322 6.5% 99,901 0.1% 7,597,655 6.6% 91,474 0.1% 415,048 1.9% -2,113,336 -9.9% 297,808 1.4% 880 0.0%
Zend_Db_Adapter_Abstract::_quoteIdentifierAs 38,409 0.7% 7,185,041 6.1% 2,556,882 2.2% 7,220,832 6.3% 2,438,551 2.1% 5,198,312 24.4% -14,567,288 -68.3% 320,688 1.5% 60,096 0.3%
Mage_Eav_Model_Entity_Attribute_Abstract::usesSource 21,251 0.4% 7,107,750 6.0% 765,110 0.6% 7,129,241 6.2% 734,490 0.6% 1,039,776 4.9% 4,583,632 21.5% 752 0.0% 0 0.0%
Zend_Db_Statement::__construct 6,718 0.1% 7,043,104 6.0% 351,745 0.3% 7,047,270 6.2% 330,714 0.3% 20,100,232 94.3% 1,960 0.0% 343,112 1.6% 1,960 0.0%
Mage_Catalog_Model_Product_Type_Abstract::getSetAttributes 20 0.0% 6,731,684 5.7% 1,697 0.0% 6,728,971 5.9% 1,502 0.0% 416,888 2.0% 6,008 0.0% 295,272 1.3% 1,088 0.0%
Mage_Eav_Model_Entity_Abstract::getSortedAttributes 20 0.0% 6,586,489 5.6% 24,722 0.0% 6,583,765 5.8% 22,824 0.0% 410,032 1.9% 100,464 0.5% 282,512 1.3% 1,152 0.0%
Mage_Eav_Model_Mysql4_Entity_Attribute::getFlatUpdateSelect 4,200 0.1% 6,059,780 5.1% 713,091 0.6% 6,068,403 5.3% 657,704 0.6% 21,561,128 101.1% 1,314,312 6.2% 0 0.0% 0 0.0%
Zend_Db_Statement::_parseParameters 6,718 0.1% 6,047,158 5.1% 253,372 0.2% 6,052,124 5.3% 242,684 0.2% 9,194,376 43.1% -2,541,264 -11.9% 327,576 1.5% 15,200 0.1%
Zend_Db_Statement::_stripQuoted 6,718 0.1% 5,577,199 4.7% 755,281 0.6% 5,581,940 4.9% 710,251 0.6% 6,106,064 28.6% -17,245,784 -80.9% 303,536 1.4% 2,064 0.0%
Mage_Catalog_Model_Resource_Eav_Attribute::isAllowedForRuleCondition 17,280 0.3% 5,418,482 4.6% 644,056 0.5% 5,433,842 4.8% 621,267 0.5% 844,416 4.0% 3,705,056 17.4% 330,968 1.5% 54,840 0.3%
Varien_Db_Select::crossUpdateFromSelect 4,480 0.1% 4,720,754 4.0% 700,735 0.6% 4,724,870 4.1% 651,727 0.6% 2,454,240 11.5% -6,542,248 -30.7% 4,224 0.0% 304 0.0%
uasort 20 0.0% 4,668,691 4.0% 94,634 0.1% 4,668,697 4.1% 88,278 0.1% 5,232 0.0% -458,640 -2.2% 0 0.0% 0 0.0%
Mage_Eav_Model_Entity_Abstract::attributesCompare 9,580 0.2% 4,574,057 3.9% 481,652 0.4% 4,580,419 4.0% 461,052 0.4% 463,872 2.2% 418,688 2.0% 0 0.0% 0 0.0%
Zend_Cache_Backend_File::_fileGetContents 20,190 0.4% 4,535,476 3.9% 1,458,966 1.2% 4,456,060 3.9% 1,351,023 1.2% 4,463,944 20.9% 965,112 4.5% 518,368 2.4% 1,736 0.0%
Mage_Core_Helper_Abstract::__ 7,892 0.1% 4,400,410 3.7% 709,764 0.6% 4,406,496 3.9% 664,261 0.6% 2,444,944 11.5% -2,028,840 -9.5% 51,392 0.2% 3,184 0.0%
Zend_Db_Adapter_Abstract::quote 22,288 0.4% 4,318,686 3.7% 969,980 0.8% 4,336,438 3.8% 932,648 0.8% 1,850,240 8.7% -415,056 -1.9% 118,296 0.5% 50,048 0.2%
Zend_Db_Statement::execute 6,718 0.1% 4,297,052 3.6% 148,046 0.1% 1,727,514 1.5% 147,074 0.1% 2,258,800 10.6% -328,400 -1.5% 1,740,448 7.9% 1,040 0.0%
Zend_Db_Statement_Pdo::_execute 6,718 0.1% 4,149,006 3.5% 159,440 0.1% 1,580,440 1.4% 153,804 0.1% 2,587,200 12.1% 330,576 1.6% 1,739,408 7.9% 1,632 0.0%
Zend_Db_Adapter_Abstract::quoteIdentifier 22,337 0.4% 4,078,192 3.5% 462,028 0.4% 4,096,244 3.6% 459,724 0.4% 3,284,048 15.4% 9,304 0.0% 25,392 0.1% 2,904 0.0%
Mage_Eav_Model_Entity_Abstract::walkAttributes 60 0.0% 4,018,635 3.4% 310,184 0.3% 3,972,646 3.5% 288,138 0.3% 758,936 3.6% -2,386,136 -11.2% 1,191,880 5.4% 45,968 0.2%
PDOStatement::execute 6,718 0.1% 3,989,566 3.4% 3,989,566 3.4% 1,426,636 1.2% 1,426,636 1.2% 2,256,624 10.6% 2,256,624 10.6% 1,737,776 7.9% 1,737,776 7.9%
substr 381,830 7.1% 3,910,075 3.3% 3,910,075 3.3% 4,106,581 3.6% 4,106,581 3.6% 12,875,240 60.4% 12,875,240 60.4% 17,608 0.1% 17,608 0.1%
Zend_Db_Select::_join 11,936 0.2% 3,841,629 3.3% 1,133,823 1.0% 3,855,278 3.4% 1,082,177 0.9% 17,135,528 80.4% 9,826,208 46.1% 393,952 1.8% 74,104 0.3%
Mage_Eav_Model_Entity_Abstract::save 20 0.0% 3,628,188 3.1% 3,095 0.0% 3,574,947 3.1% 2,848 0.0% 895,680 4.2% -761,848 -3.6% 847,536 3.9% 2,480 0.0%
Varien_Db_Select::where 7,298 0.1% 3,517,453 3.0% 310,259 0.3% 3,524,965 3.1% 296,300 0.3% 2,653,288 12.4% -90,280 -0.4% 138,064 0.6% 13,560 0.1%
Varien_Object::getDataUsingMethod 12,960 0.2% 3,511,142 3.0% 400,708 0.3% 3,520,504 3.1% 391,440 0.3% 1,063,584 5.0% 1,152,768 5.4% 0 0.0% 0 0.0%
Zend_Db_Select::_getQuotedTable 11,936 0.2% 3,291,843 2.8% 248,086 0.2% 3,302,607 2.9% 248,184 0.2% 1,333,568 6.3% 1,904 0.0% 62,008 0.3% 872 0.0%
is_array 319,149 6.0% 3,218,151 2.7% 3,218,151 2.7% 3,422,864 3.0% 3,422,864 3.0% 49,272 0.2% 49,272 0.2% 24,296 0.1% 24,296 0.1%
Zend_Db_Select::joinLeft 9,721 0.2% 3,141,758 2.7% 203,613 0.2% 3,153,477 2.8% 204,094 0.2% 14,097,832 66.1% 1,034,848 4.9% 153,856 0.7% 2,496 0.0%
is_null 306,612 5.7% 3,117,952 2.6% 3,117,952 2.6% 3,292,715 2.9% 3,292,715 2.9% 52,168 0.2% 52,168 0.2% 22,288 0.1% 22,288 0.1%
Mage_Core_Model_Translate::translate 7,893 0.1% 3,104,773 2.6% 941,180 0.8% 3,109,736 2.7% 887,230 0.8% 2,426,480 11.4% -729,072 -3.4% 35,408 0.2% 6,152 0.0%
Zend_Db_Select::assemble 1,237 0.0% 3,087,415 2.6% 458,927 0.4% 3,088,286 2.7% 423,997 0.4% 713,120 3.3% -4,369,136 -20.5% 711,672 3.2% 79,176 0.4%

Biggest problems are, for every product:

  1. all pricerules are applied
  2. all indexes are rebuild

First is easily avoidable with $product->setIsMassupdate(true). For the second i set indexing mode to manual and restored previous mode after the collection is saved.

Overall Summary
Total Incl. Wall Time (microsec):35,376,590 microsecs
Total Incl. CPU (microsecs):34,117,463 microsecs
Total Incl. MemUse (bytes):10,945,768 bytes
Total Incl. PeakMemUse (bytes):11,174,864 bytes
Number of Function Calls:1,586,377
Function NameCallsCalls%Incl. Wall Time
(microsec)		IWall%Excl. Wall Time
(microsec)		EWall%Incl. CPU
(microsecs)		ICpu%Excl. CPU
(microsec)		ECPU%Incl.
MemUse
(bytes)		IMemUse%Excl.
MemUse
(bytes)		EMemUse%Incl.
PeakMemUse
(bytes)		IPeakMemUse%Excl.
PeakMemUse
(bytes)		EPeakMemUse%
main() 1 0.0% 35,376,590 100.0% 1,573 0.0% 34,117,463 100.0% 1,358 0.0% 10,945,768 100.0% 14,400 0.1% 11,174,864 100.0% 5,480 0.0%
Mage_Core_Model_Abstract::save 39 0.0% 32,101,995 90.7% 5,580 0.0% 31,388,244 92.0% 5,034 0.0% 4,531,520 41.4% 28,696 0.3% 4,977,352 44.5% 6,480 0.1%
Mage_Eav_Model_Entity_Collection_Abstract::save 1 0.0% 31,914,301 90.2% 237 0.0% 31,227,555 91.5% 226 0.0% 4,307,760 39.4% 1,736 0.0% 4,755,008 42.6% 432 0.0%
Mage_Core_Model_App::cleanCache 40 0.0% 16,719,923 47.3% 1,364 0.0% 16,367,714 48.0% 1,300 0.0% 133,064 1.2% 2,392 0.0% 1,339,424 12.0% 184 0.0%
Mage_Core_Model_Cache::clean 40 0.0% 16,712,900 47.2% 1,782 0.0% 16,360,692 48.0% 1,697 0.0% 129,592 1.2% -22,736 -0.2% 1,339,240 12.0% 1,000 0.0%
Varien_Cache_Core::clean 40 0.0% 16,706,937 47.2% 1,450 0.0% 16,354,717 47.9% 1,366 0.0% 126,040 1.2% -21,136 -0.2% 1,334,208 11.9% 520 0.0%
Zend_Cache_Core::clean 40 0.0% 16,701,493 47.2% 1,950 0.0% 16,349,230 47.9% 1,838 0.0% 122,584 1.1% 1,776 0.0% 1,330,920 11.9% 1,664 0.0%
Zend_Cache_Backend_File::clean 40 0.0% 16,690,646 47.2% 1,296 0.0% 16,338,400 47.9% 1,255 0.0% 115,992 1.1% 1,776 0.0% 1,325,336 11.9% 392 0.0%
Zend_Cache_Backend_File::_clean 40 0.0% 16,688,979 47.2% 23,211 0.1% 16,336,716 47.9% 19,823 0.1% 118,808 1.1% -154,224 -1.4% 1,324,248 11.9% 1,168 0.0%
Zend_Cache_Backend_File::_clean@1 600 0.0% 16,644,011 47.0% 2,328,300 6.6% 16,294,815 47.8% 2,111,239 6.2% 178,424 1.6% -19,658,304 -179.6% 1,315,000 11.8% 2,504 0.0%
Mage_Core_Model_Resource_Abstract::commit 41 0.0% 11,070,110 31.3% 3,571 0.0% 10,740,791 31.5% 3,301 0.0% 2,080,136 19.0% -22,440 -0.2% 1,849,816 16.6% 2,032 0.0%
call_user_func 39 0.0% 10,990,704 31.1% 908 0.0% 10,716,876 31.4% 877 0.0% 2,081,992 19.0% 1,632 0.0% 1,832,336 16.4% 760 0.0%
Mage_Catalog_Model_Product::afterCommitCallback 20 0.0% 10,983,427 31.0% 890 0.0% 10,709,555 31.4% 843 0.0% 2,076,744 19.0% 2,136 0.0% 1,824,856 16.3% 912 0.0%
Mage_Index_Model_Indexer::processEntityAction 20 0.0% 10,973,976 31.0% 1,534 0.0% 10,700,110 31.4% 1,449 0.0% 2,031,144 18.6% -90,552 -0.8% 1,788,072 16.0% 1,456 0.0%
call_user_func_array 3,408 0.2% 10,290,002 29.1% 71,432 0.2% 10,063,367 29.5% 71,671 0.2% 3,282,016 30.0% 907,712 8.3% 1,922,432 17.2% 11,352 0.1%
Mage_Index_Model_Indexer::_runAll 40 0.0% 10,069,607 28.5% 18,855 0.1% 9,843,350 28.9% 17,594 0.1% 1,991,432 18.2% -129,952 -1.2% 1,643,360 14.7% 2,592 0.0%
Mage_Index_Model_Indexer::logEvent 20 0.0% 9,180,904 26.0% 1,877 0.0% 9,179,812 26.9% 1,678 0.0% 2,011,672 18.4% 12,776 0.1% 1,644,096 14.7% 2,720 0.0%
Mage_Index_Model_Indexer::registerEvent 20 0.0% 9,157,427 25.9% 674 0.0% 9,156,350 26.8% 703 0.0% 1,974,368 18.0% 1,520 0.0% 1,628,872 14.6% 1,200 0.0%
Mage_Catalog_Model_Product::_beforeSave 20 0.0% 9,041,225 25.6% 2,718 0.0% 8,862,358 26.0% 2,486 0.0% 976,072 8.9% 18,456 0.2% 1,517,184 13.6% 2,128 0.0%
Mage_Index_Model_Process::register 180 0.0% 9,034,049 25.5% 13,436 0.0% 9,033,138 26.5% 12,688 0.0% 1,949,720 17.8% 520 0.0% 1,578,024 14.1% 2,760 0.0%
Mage_Catalog_Model_Product::_afterSave 20 0.0% 8,867,864 25.1% 1,871 0.0% 8,683,492 25.5% 1,721 0.0% 436,360 4.0% 5,296 0.0% 662,392 5.9% 3,344 0.0%
Mage_Core_Model_Abstract::_afterSave 59 0.0% 8,860,101 25.0% 3,357 0.0% 8,675,785 25.4% 3,174 0.0% 265,104 2.4% -19,576 -0.2% 565,416 5.1% 1,296 0.0%
Mage_Index_Model_Indexer_Abstract::register 160 0.0% 8,859,794 25.0% 5,033 0.0% 8,859,025 26.0% 4,665 0.0% 911,320 8.3% 5,352 0.0% 665,128 6.0% 5,552 0.0%
Mage_Core_Model_Abstract::cleanModelCache 59 0.0% 8,686,249 24.6% 1,778 0.0% 8,509,823 24.9% 1,703 0.0% 103,008 0.9% -12,792 -0.1% 561,216 5.0% 1,024 0.0%
Mage_Catalog_Model_Product_Indexer_Eav::_registerEvent 20 0.0% 8,634,974 24.4% 838 0.0% 8,634,132 25.3% 797 0.0% 438,104 4.0% 1,832 0.0% 304,400 2.7% 672 0.0%
Mage_Catalog_Model_Product_Indexer_Eav::_registerCatalogProductSaveEvent 20 0.0% 8,633,001 24.4% 32,248 0.1% 8,632,173 25.3% 29,655 0.1% 434,608 4.0% -66,976 -0.6% 302,200 2.7% 3,656 0.0%
Zend_Cache_Backend_File::_getMetadatas 20,854 1.3% 8,614,341 24.4% 648,827 1.8% 8,432,778 24.7% 620,239 1.8% 487,760 4.5% 3,008 0.0% 890,376 8.0% 0 0.0%
Mage_Catalog_Model_Product::cleanCache 20 0.0% 8,140,707 23.0% 904 0.0% 7,963,813 23.3% 850 0.0% 133,168 1.2% 1,768 0.0% 868,536 7.8% 624 0.0%
Mage_Catalog_Model_Product::getAttributes 20 0.0% 7,728,115 21.8% 689 0.0% 7,727,516 22.6% 682 0.0% 412,328 3.8% 1,896 0.0% 285,224 2.6% 1,024 0.0%
Mage_Catalog_Model_Product_Type_Abstract::getEditableAttributes 20 0.0% 7,726,788 21.8% 103,612 0.3% 7,726,179 22.6% 95,932 0.3% 409,608 3.7% -2,222,112 -20.3% 283,464 2.5% 4,080 0.0%
Zend_Cache_Backend_File::_loadMetadatas 20,799 1.3% 7,179,786 20.3% 852,678 2.4% 7,029,795 20.6% 797,681 2.3% 25,251,552 230.7% -6,828,992 -62.4% 890,376 8.0% 480 0.0%
Mage_Catalog_Model_Product_Type_Abstract::getSetAttributes 20 0.0% 6,810,774 19.3% 1,656 0.0% 6,810,160 20.0% 1,572 0.0% 421,464 3.9% 5,984 0.1% 275,888 2.5% 1,088 0.0%
Varien_Object::getData 83,633 5.3% 6,743,816 19.1% 3,722,431 10.5% 6,803,588 19.9% 3,615,806 10.6% 286,896 2.6% -31,380,280 -286.7% 38,136 0.3% 36,768 0.3%
Mage_Eav_Model_Entity_Abstract::getSortedAttributes 20 0.0% 6,663,947 18.8% 19,519 0.1% 6,663,433 19.5% 18,476 0.1% 414,632 3.8% 130,976 1.2% 262,784 2.4% 1,152 0.0%
uasort 20 0.0% 5,655,190 16.0% 114,151 0.3% 5,654,804 16.6% 105,315 0.3% 5,232 0.0% -556,560 -5.1% 0 0.0% 0 0.0%
Mage_Eav_Model_Entity_Abstract::attributesCompare 11,620 0.7% 5,541,039 15.7% 580,337 1.6% 5,549,489 16.3% 556,326 1.6% 561,792 5.1% 508,928 4.6% 0 0.0% 0 0.0%
Zend_Cache_Backend_File::_fileGetContents 20,819 1.3% 4,045,772 11.4% 1,484,061 4.2% 3,970,718 11.6% 1,378,660 4.0% 4,626,336 42.3% 998,136 9.1% 594,024 5.3% 1,248 0.0%
Zend_Cache_Backend_File::_isMetadatasFile 41,600 2.6% 3,034,210 8.6% 1,250,918 3.5% 3,016,652 8.8% 1,204,908 3.5% 2,001,592 18.3% -6,952,664 -63.5% 5,816 0.1% 1,392 0.0%
Mage_Eav_Model_Entity_Abstract::save 20 0.0% 2,956,315 8.4% 2,826 0.0% 2,940,366 8.6% 2,585 0.0% 803,680 7.3% -668,944 -6.1% 741,992 6.6% 2,288 0.0%
Flagbit_ChangeAttributeSet_Adminhtml_Catalog_ProductController::_restoreRealtimeIndexer 1 0.0% 2,621,928 7.4% 419 0.0% 2,083,548 6.1% 376 0.0% 1,968,960 18.0% 3,336 0.0% 1,592,760 14.3% 0 0.0%
Mage_Index_Model_Process::reindexAll 2 0.0% 2,527,973 7.1% 212 0.0% 2,001,430 5.9% 187 0.0% 1,961,208 17.9% 4,120 0.0% 1,586,336 14.2% 0 0.0%
Varien_Db_Adapter_Pdo_Mysql::query 862 0.1% 2,488,308 7.0% 66,310 0.2% 1,685,921 4.9% 61,725 0.2% 2,310,832 21.1% -1,275,256 -11.7% 259,928 2.3% 9,448 0.1%
Mage_Catalog_Model_Product_Indexer_Flat::reindexAll 1 0.0% 2,372,491 6.7% 37 0.0% 1,888,835 5.5% 34 0.0% 1,502,096 13.7% 1,488 0.0% 1,528,976 13.7% 336 0.0%
Mage_Catalog_Model_Product_Flat_Indexer::rebuild 1 0.0% 2,371,402 6.7% 32 0.0% 1,887,745 5.5% 31 0.0% 1,458,400 13.3% 1,712 0.0% 1,496,216 13.4% 432 0.0%
Mage_Catalog_Model_Resource_Eav_Mysql4_Product_Flat_Indexer::rebuild 1 0.0% 2,370,091 6.7% 224 0.0% 1,886,431 5.5% 209 0.0% 1,413,344 12.9% 3,056 0.0% 1,453,568 13.0% 1,376 0.0%
Mage_Catalog_Model_Resource_Eav_Mysql4_Product_Flat_Indexer::rebuild@1 7 0.0% 2,357,204 6.7% 775 0.0% 1,875,045 5.5% 656 0.0% 1,369,304 12.5% 6,528 0.1% 1,447,576 13.0% 2,704 0.0%
Zend_Db_Adapter_Pdo_Abstract::query 862 0.1% 2,176,549 6.2% 39,322 0.1% 1,374,802 4.0% 38,852 0.1% 3,314,864 30.3% 1,680 0.0% 131,776 1.2% 1,904 0.0%
Zend_Db_Adapter_Abstract::query 862 0.1% 2,116,082 6.0% 55,032 0.2% 1,313,631 3.9% 52,155 0.2% 3,311,616 30.3% 2,248 0.0% 128,528 1.2% 2,552 0.0%
Mage_Eav_Model_Entity_Abstract::walkAttributes 40 0.0% 2,026,247 5.7% 164,038 0.5% 2,023,295 5.9% 153,056 0.4% 493,328 4.5% -1,257,176 -11.5% 535,304 4.8% 16,048 0.1%
Zend_Cache_Backend_File::_fileNameToId 62,400 3.9% 2,014,572 5.7% 1,285,378 3.6% 2,024,646 5.9% 1,264,369 3.7% 10,528,152 96.2% -4,415,552 -40.3% 4,592 0.0% 2,632 0.0%
Zend_Cache_Backend_File::_metadatasFile 20,841 1.3% 1,996,597 5.6% 648,311 1.8% 1,972,502 5.8% 615,406 1.8% 3,719,832 34.0% -1,568,992 -14.3% 9,368 0.1% 2,424 0.0%
Varien_Object::__call 14,558 0.9% 1,772,670 5.0% 687,706 1.9% 1,783,698 5.2% 663,910 1.9% 73,952 0.7% -858,320 -7.8% 92,968 0.8% 46,688 0.4%
Mage_Catalog_Model_Resource_Eav_Mysql4_Product_Flat_Indexer::updateEavAttributes 7 0.0% 1,761,271 5.0% 9,021 0.0% 1,330,379 3.9% 8,017 0.0% 143,624 1.3% 2,832 0.0% 129,056 1.2% 0 0.0%
is_array 175,352 11.1% 1,741,936 4.9% 1,741,936 4.9% 1,835,983 5.4% 1,835,983 5.4% 38,136 0.3% 38,136 0.3% 23,192 0.2% 23,192 0.2%
Mage_Catalog_Model_Resource_Eav_Mysql4_Product_Flat_Indexer::updateAttribute 231 0.0% 1,728,763 4.9% 37,528 0.1% 1,298,164 3.8% 34,481 0.1% 137,240 1.3% -1,607,112 -14.7% 129,056 1.2% 1,136 0.0%
Mage_Catalog_Model_Resource_Eav_Attribute::getApplyTo 9,400 0.6% 1,473,702 4.2% 386,994 1.1% 1,480,700 4.3% 372,281 1.1% 4,512,832 41.2% 802,936 7.3% 12,496 0.1% 1,816 0.0%
Mage_Catalog_Model_Resource_Eav_Mysql4_Product::_beforeSave 20 0.0% 1,129,906 3.2% 916 0.0% 1,129,749 3.3% 847 0.0% 418,480 3.8% 3,176 0.0% 460,384 4.1% 624 0.0%
Zend_Cache_Backend_File::_path 20,917 1.3% 1,129,343 3.2% 686,090 1.9% 1,122,840 3.3% 659,063 1.9% 2,574,704 23.5% 1,234,464 11.3% 5,968 0.1% 4,672 0.0%
Mage_Eav_Model_Entity_Abstract::_beforeSave 20 0.0% 1,125,572 3.2% 484 0.0% 1,125,444 3.3% 489 0.0% 414,744 3.8% 2,312 0.0% 457,224 4.1% 344 0.0%
Mage_Catalog_Model_Resource_Eav_Mysql4_Product::_afterSave 20 0.0% 1,087,476 3.1% 865 0.0% 1,081,953 3.2% 819 0.0% 130,104 1.2% 2,440 0.0% 105,232 0.9% 672 0.0%
Zend_Db_Statement::execute 862 0.1% 1,018,369 2.9% 18,948 0.1% 216,673 0.6% 18,621 0.1% 556,008 5.1% -40,592 -0.4% 24,200 0.2% 1,040 0.0%
Zend_Db_Statement_Pdo::_execute 862 0.1% 999,421 2.8% 20,589 0.1% 198,052 0.6% 20,125 0.1% 596,600 5.5% 42,768 0.4% 23,160 0.2% 1,424 0.0%
Zend_Db_Adapter_Pdo_Abstract::prepare 862 0.1% 994,373 2.8% 44,499 0.1% 994,517 2.9% 42,218 0.1% 2,750,960 25.1% 167,904 1.5% 99,568 0.9% 3,240 0.0%
is_file 63,077 4.0% 988,894 2.8% 988,894 2.8% 1,016,597 3.0% 1,016,597 3.0% 373,160 3.4% 373,160 3.4% 3,568 0.0% 3,568 0.0%
PDOStatement::execute 862 0.1% 978,832 2.8% 978,832 2.8% 177,927 0.5% 177,927 0.5% 553,832 5.1% 553,832 5.1% 21,736 0.2% 21,736 0.2%
substr 93,516 5.9% 963,217 2.7% 963,217 2.7% 1,006,201 2.9% 1,006,201 2.9% 3,416,680 31.2% 3,416,680 31.2% 4,320 0.0% 4,320 0.0%
Zend_Db_Adapter_Abstract::update 243 0.0% 922,069 2.6% 35,383 0.1% 681,879 2.0% 32,664 0.1% 40,928 0.4% -1,312,064 -12.0% 50,936 0.5% 6,360 0.1%
Mage_Index_Model_Indexer::indexEvent 20 0.0% 914,014 2.6% 660 0.0% 688,812 2.0% 625 0.0% 21,616 0.2% 1,400 0.0% 18,168 0.2% 1,024 0.0%
Zend_Db_Statement::__construct 862 0.1% 904,229 2.6% 45,012 0.1% 904,375 2.7% 41,916 0.1% 2,579,536 23.6% 1,960 0.0% 93,032 0.8% 1,960 0.0%
Mage_Eav_Model_Entity_Abstract::_afterSave 20 0.0% 901,602 2.5% 443 0.0% 898,786 2.6% 446 0.0% 82,024 0.7% 1,128 0.0% 78,424 0.7% 0 0.0%
strpos 88,725 5.6% 894,616 2.5% 894,616 2.5% 942,876 2.8% 942,876 2.8% 11,024 0.1% 11,024 0.1% 9,640 0.1% 9,640 0.1%
Mage_Core_Model_Mysql4_Abstract::save 39 0.0% 884,990 2.5% 7,264 0.0% 860,121 2.5% 6,492 0.0% 209,616 1.9% -28,728 -0.3% 211,240 1.9% 4,360 0.0%
Mage_Core_Model_Abstract::save@1 20 0.0% 877,073 2.5% 3,077 0.0% 829,454 2.4% 2,662 0.0% 86,760 0.8% 13,992 0.1% 123,376 1.1% 3,280 0.0%
Mage_Catalog_Model_Product_Type_Abstract::beforeSave 20 0.0% 862,783 2.4% 909 0.0% 861,169 2.5% 868 0.0% 805,024 7.4% 2,984 0.0% 637,920 5.7% 1,512 0.0%
Mage_Catalog_Model_Product_Type_Abstract::_removeNotApplicableAttributes 20 0.0% 860,952 2.4% 86,758 0.2% 859,315 2.5% 79,846 0.2% 799,392 7.3% -755,248 -6.9% 635,296 5.7% 2,552 0.0%
Mage_Catalog_Model_Product_Indexer_Eav::_attributeIsIndexable 1,524 0.1% 816,742 2.3% 31,391 0.1% 817,820 2.4% 31,034 0.1% 87,936 0.8% 1,280 0.0% 10,168 0.1% 480 0.0%
Mage_Index_Model_Process::processEvent 180 0.0% 796,101 2.3% 5,778 0.0% 570,954 1.7% 5,582 0.0% 18,056 0.2% 31,664 0.3% 14,736 0.1% 672 0.0%
Zend_Cache_Backend_File::_setMetadatas 20,799 1.3% 794,330 2.2% 514,929 1.5% 791,336 2.3% 503,518 1.5% -24,764,488 -226.2% -51,436,064 -469.9% 0 0.0% 0 0.0%
Mage_Catalog_Model_Resource_Eav_Attribute::isIndexable 1,524 0.1% 785,351 2.2% 76,760 0.2% 786,786 2.3% 73,598 0.2% 86,656 0.8% 513,976 4.7% 9,688 0.1% 2,176 0.0%
Zend_Db_Statement::_parseParameters 862 0.1% 776,967 2.2% 42,664 0.1% 777,772 2.3% 41,043 0.1% 1,554,784 14.2% 180,976 1.7% 80,408 0.7% 6,448 0.1%
Zend_Db_Adapter_Abstract::_quoteIdentifierAs 4,721 0.3% 773,422 2.2% 291,705 0.8% 777,354 2.3% 277,781 0.8% 676,904 6.2% -1,748,480 -16.0% 58,928 0.5% 15,232 0.1%
Mage_Index_Model_Process::changeStatus 180 0.0% 763,528 2.2% 5,507 0.0% 538,400 1.6% 5,332 0.0% 7,176 0.1% 1,504 0.0% 13,096 0.1% 936 0.0%
Mage_Catalog_Model_Resource_Eav_Mysql4_Abstract::_isApplicableAttribute 3,440 0.2% 760,470 2.1% 137,001 0.4% 763,143 2.2% 132,783 0.4% 171,576 1.6% -1,378,208 -12.6% 14,528 0.1% 2,008 0.0%
preg_replace 64,355 4.1% 752,312 2.1% 752,312 2.1% 785,313 2.3% 785,313 2.3% 16,236,448 148.3% 16,236,448 148.3% 51,136 0.5% 51,136 0.5%
Mage_Index_Model_Mysql4_Process::updateStatus 180 0.0% 744,833 2.1% 12,932 0.0% 519,701 1.5% 12,094 0.0% 4,856 0.0% -12,136 -0.1% 11,576 0.1% 1,952 0.0%
Zend_Db_Statement::_stripQuoted 862 0.1% 703,431 2.0% 95,691 0.3% 704,051 2.1% 89,515 0.3% 439,152 4.0% -1,466,080 -13.4% 70,336 0.6% 6,216 0.1%
Zend_Db_Adapter_Abstract::quoteIdentifier 3,862 0.2% 666,895 1.9% 77,657 0.2% 670,119 2.0% 77,323 0.2% 569,576 5.2% 10,240 0.1% 20,016 0.2% 2,904 0.0%
fopen 20,835 1.3% 645,761 1.8% 645,761 1.8% 647,447 1.9% 647,447 1.9% 14,790,008 135.1% 14,790,008 135.1% 2,504 0.0% 2,504 0.0%
flock 41,646 2.6% 614,147 1.7% 614,147 1.7% 627,192 1.8% 627,192 1.8% 4,088 0.0% 4,088 0.0% 696 0.0% 696 0.0%
explode 56,974 3.6% 583,777 1.7% 583,777 1.7% 624,034 1.8% 624,034 1.8% 37,418,592 341.9% 37,418,592 341.9% 64,072 0.6% 64,072 0.6%
Varien_Db_Adapter_Pdo_Mysql::insertOnDuplicate 180 0.0% 575,293 1.6% 33,430 0.1% 557,425 1.6% 31,471 0.1% -4,568 -0.0% -1,492,504 -13.6% 24,696 0.2% 5,080 0.0%
stream_get_contents 20,805 1.3% 570,567 1.6% 570,567 1.6% 574,153 1.7% 574,153 1.7% 174,039,920 1590.0% 174,039,920 1590.0% 588,024 5.3% 588,024 5.3%
Mage_Eav_Model_Entity_Attribute_Abstract::isInSet 1,720 0.1% 540,498 1.5% 95,583 0.3% 541,420 1.6% 90,283 0.3% 89,016 0.8% 92,744 0.8% 0 0.0% 0 0.0%
Mage_Catalog_Model_Resource_Eav_Attribute::getAttributeSetInfo 3,442 0.2% 538,247 1.5% 70,624 0.2% 540,087 1.6% 70,010 0.2% 661,344 6.0% 648,608 5.9% 9,872 0.1% 8,712 0.1%
Mage_Catalog_Model_Resource_Eav_Mysql4_Abstract::_isCallableAttributeInstance 3,048 0.2% 528,619 1.5% 153,526 0.4% 530,650 1.6% 144,457 0.4% 155,128 1.4% -118,168 -1.1% 7,912 0.1% 2,152 0.0%
Mage_Index_Model_Mysql4_Event::_afterSave 20 0.0% 525,455 1.5% 6,476 0.0% 510,311 1.5% 5,915 0.0% 2,680 0.0% 10,520 0.1% 0 0.0% 0 0.0%
basename 41,600 2.6% 524,312 1.5% 524,312 1.5% 544,624 1.6% 544,624 1.6% 3,041,016 27.8% 3,041,016 27.8% 864 0.0% 864 0.0%
in_array 47,756 3.0% 500,958 1.4% 500,958 1.4% 524,327 1.5% 524,327 1.5% 13,736 0.1% 13,736 0.1% 7,280 0.1% 7,280 0.1%
Mage_Eav_Model_Entity_Attribute_Abstract::getFlatUpdateSelect 224 0.0% 480,066 1.4% 14,186 0.0% 480,681 1.4% 12,963 0.0% 1,221,000 11.2% -6,464 -0.1% 87,496 0.8% 2,304 0.0%
Mage_Eav_Model_Entity_Attribute_Set::addSetInfo 20 0.0% 446,229 1.3% 60,569 0.2% 446,167 1.3% 57,259 0.2% 147,448 1.3% -443,912 -4.1% 229,168 2.1% 9,712 0.1%

I haven't digged deeper yet, but flushing cache storage before results in:

Overall Summary
Total Incl. Wall Time (microsec):19,367,731 microsecs
Total Incl. CPU (microsecs):18,462,969 microsecs
Total Incl. MemUse (bytes):10,810,888 bytes
Total Incl. PeakMemUse (bytes):11,007,584 bytes
Number of Function Calls:906,276
Function NameCallsCalls%Incl. Wall Time
(microsec)		IWall%Excl. Wall Time
(microsec)		EWall%Incl. CPU
(microsecs)		ICpu%Excl. CPU
(microsec)		ECPU%Incl.
MemUse
(bytes)		IMemUse%Excl.
MemUse
(bytes)		EMemUse%Incl.
PeakMemUse
(bytes)		IPeakMemUse%Excl.
PeakMemUse
(bytes)		EPeakMemUse%
main() 1 0.0% 19,367,731 100.0% 1,786 0.0% 18,462,969 100.0% 1,572 0.0% 10,810,888 100.0% 15,192 0.1% 11,007,584 100.0% 6,936 0.1%
Mage_Core_Model_Abstract::save 39 0.0% 15,797,416 81.6% 5,808 0.0% 15,430,740 83.6% 5,258 0.0% 4,451,792 41.2% 28,720 0.3% 4,558,064 41.4% 6,472 0.1%
Mage_Eav_Model_Entity_Collection_Abstract::save 1 0.0% 15,587,959 80.5% 262 0.0% 15,250,487 82.6% 249 0.0% 4,183,984 38.7% 1,736 0.0% 4,285,944 38.9% 240 0.0%
Mage_Core_Model_Resource_Abstract::commit 41 0.0% 11,392,535 58.8% 4,279 0.0% 11,068,402 59.9% 3,535 0.0% 2,072,504 19.2% -22,528 -0.2% 1,924,592 17.5% 2,224 0.0%
call_user_func 39 0.0% 11,317,747 58.4% 860 0.0% 11,043,364 59.8% 861 0.0% 2,078,560 19.2% 1,632 0.0% 1,910,560 17.4% 760 0.0%
Mage_Catalog_Model_Product::afterCommitCallback 20 0.0% 11,309,983 58.4% 903 0.0% 11,035,557 59.8% 823 0.0% 2,073,312 19.2% 2,136 0.0% 1,903,104 17.3% 912 0.0%
Mage_Index_Model_Indexer::processEntityAction 20 0.0% 11,301,107 58.4% 1,368 0.0% 11,026,713 59.7% 1,324 0.0% 2,027,704 18.8% -90,296 -0.8% 1,865,816 17.0% 1,168 0.0%
call_user_func_array 3,408 0.4% 10,619,664 54.8% 69,529 0.4% 10,391,242 56.3% 68,775 0.4% 3,276,376 30.3% 907,624 8.4% 2,350,464 21.4% 11,592 0.1%
Mage_Index_Model_Indexer::_runAll 40 0.0% 10,403,414 53.7% 18,224 0.1% 10,175,906 55.1% 16,749 0.1% 1,987,624 18.4% -129,880 -1.2% 1,700,064 15.4% 2,744 0.0%
Mage_Index_Model_Indexer::logEvent 20 0.0% 9,508,886 49.1% 1,768 0.0% 9,505,055 51.5% 1,693 0.0% 2,007,920 18.6% 12,776 0.1% 1,701,288 15.5% 2,720 0.0%
Mage_Index_Model_Indexer::registerEvent 20 0.0% 9,486,255 49.0% 699 0.0% 9,482,446 51.4% 625 0.0% 1,970,616 18.2% 1,520 0.0% 1,685,488 15.3% 1,200 0.0%
Mage_Index_Model_Process::register 180 0.0% 9,364,032 48.3% 13,479 0.1% 9,360,532 50.7% 12,674 0.1% 1,945,968 18.0% 520 0.0% 1,625,248 14.8% 2,912 0.0%
Mage_Index_Model_Indexer_Abstract::register 160 0.0% 9,190,825 47.5% 4,969 0.0% 9,187,603 49.8% 4,839 0.0% 924,224 8.5% 5,352 0.0% 718,920 6.5% 5,552 0.1%
Mage_Catalog_Model_Product_Indexer_Eav::_registerEvent 20 0.0% 8,964,952 46.3% 795 0.0% 8,961,623 48.5% 775 0.0% 436,104 4.0% 1,832 0.0% 334,016 3.0% 672 0.0%
Mage_Catalog_Model_Product_Indexer_Eav::_registerCatalogProductSaveEvent 20 0.0% 8,962,949 46.3% 31,670 0.2% 8,959,625 48.5% 29,299 0.2% 432,608 4.0% -67,744 -0.6% 331,816 3.0% 3,656 0.0%
Mage_Catalog_Model_Product::getAttributes 20 0.0% 8,065,133 41.6% 800 0.0% 8,062,251 43.7% 747 0.0% 410,328 3.8% 1,896 0.0% 315,944 2.9% 1,024 0.0%
Mage_Catalog_Model_Product_Type_Abstract::getEditableAttributes 20 0.0% 8,063,741 41.6% 103,405 0.5% 8,060,874 43.7% 94,876 0.5% 407,608 3.8% -2,215,872 -20.5% 314,184 2.9% 4,320 0.0%
Mage_Catalog_Model_Product_Type_Abstract::getSetAttributes 20 0.0% 7,151,779 36.9% 1,680 0.0% 7,149,132 38.7% 1,531 0.0% 413,424 3.8% 5,984 0.1% 305,872 2.8% 1,784 0.0%
Varien_Object::getData 86,353 9.5% 7,044,506 36.4% 3,874,052 20.0% 7,101,195 38.5% 3,771,313 20.4% 266,984 2.5% -33,192,112 -307.0% 44,024 0.4% 42,176 0.4%
Mage_Eav_Model_Entity_Abstract::getSortedAttributes 20 0.0% 7,006,397 36.2% 19,436 0.1% 7,003,771 37.9% 17,926 0.1% 406,592 3.8% 123,064 1.1% 291,872 2.7% 1,672 0.0%
uasort 20 0.0% 5,997,069 31.0% 120,446 0.6% 5,994,749 32.5% 111,223 0.6% 5,232 0.0% -589,200 -5.5% 2,872 0.0% 896 0.0%
Mage_Eav_Model_Entity_Abstract::attributesCompare 12,300 1.4% 5,876,623 30.3% 615,102 3.2% 5,883,526 31.9% 589,775 3.2% 594,432 5.5% 560,768 5.2% 1,976 0.0% 824 0.0%
Mage_Eav_Model_Entity_Abstract::save 20 0.0% 2,948,970 15.2% 2,710 0.0% 2,929,934 15.9% 2,497 0.0% 806,624 7.5% -645,616 -6.0% 1,163,936 10.6% 2,440 0.0%
Flagbit_ChangeAttributeSet_Adminhtml_Catalog_ProductController::_restoreRealtimeIndexer 1 0.0% 2,633,343 13.6% 597 0.0% 2,107,622 11.4% 533 0.0% 1,912,304 17.7% 3,336 0.0% 1,694,616 15.4% 0 0.0%
Mage_Index_Model_Process::reindexAll 2 0.0% 2,533,402 13.1% 253 0.0% 2,020,981 10.9% 222 0.0% 1,904,528 17.6% 4,168 0.0% 1,687,560 15.3% 0 0.0%
Varien_Db_Adapter_Pdo_Mysql::query 868 0.1% 2,503,897 12.9% 66,466 0.3% 1,713,020 9.3% 62,958 0.3% 2,289,688 21.2% -1,271,072 -11.8% 292,680 2.7% 10,192 0.1%
Mage_Catalog_Model_Product_Indexer_Flat::reindexAll 1 0.0% 2,362,776 12.2% 36 0.0% 1,896,526 10.3% 35 0.0% 1,463,304 13.5% 1,488 0.0% 1,442,024 13.1% 336 0.0%
Mage_Catalog_Model_Product_Flat_Indexer::rebuild 1 0.0% 2,361,742 12.2% 63 0.0% 1,895,491 10.3% 40 0.0% 1,419,656 13.1% 1,712 0.0% 1,410,128 12.8% 512 0.0%
Mage_Catalog_Model_Resource_Eav_Mysql4_Product_Flat_Indexer::rebuild 1 0.0% 2,360,417 12.2% 250 0.0% 1,894,157 10.3% 215 0.0% 1,374,552 12.7% 3,056 0.0% 1,366,912 12.4% 1,376 0.0%
Mage_Catalog_Model_Resource_Eav_Mysql4_Product_Flat_Indexer::rebuild@1 7 0.0% 2,340,147 12.1% 701 0.0% 1,876,050 10.2% 622 0.0% 1,331,616 12.3% 6,528 0.1% 1,360,752 12.4% 2,936 0.0%
Zend_Db_Adapter_Pdo_Abstract::query 868 0.1% 2,187,617 11.3% 38,906 0.2% 1,396,265 7.6% 37,355 0.2% 3,290,456 30.4% 1,680 0.0% 149,376 1.4% 1,904 0.0%
Zend_Db_Adapter_Abstract::query 868 0.1% 2,127,855 11.0% 55,525 0.3% 1,336,578 7.2% 52,763 0.3% 3,287,208 30.4% 2,248 0.0% 146,128 1.3% 2,488 0.0%
Mage_Eav_Model_Entity_Abstract::walkAttributes 40 0.0% 2,011,290 10.4% 162,360 0.8% 2,007,563 10.9% 150,253 0.8% 493,200 4.6% -1,253,824 -11.6% 922,144 8.4% 14,896 0.1%
is_array 184,361 20.3% 1,837,271 9.5% 1,837,271 9.5% 1,928,403 10.4% 1,928,403 10.4% 38,120 0.4% 38,120 0.4% 25,728 0.2% 25,728 0.2%
Varien_Object::__call 14,542 1.6% 1,766,067 9.1% 684,039 3.5% 1,777,196 9.6% 660,316 3.6% 76,384 0.7% -857,352 -7.9% 103,544 0.9% 56,992 0.5%
Mage_Catalog_Model_Resource_Eav_Mysql4_Product_Flat_Indexer::updateEavAttributes 7 0.0% 1,752,544 9.0% 9,155 0.0% 1,338,889 7.3% 7,983 0.0% 143,616 1.3% 2,832 0.0% 129,352 1.2% 56 0.0%
Mage_Catalog_Model_Resource_Eav_Mysql4_Product_Flat_Indexer::updateAttribute 231 0.0% 1,720,082 8.9% 37,696 0.2% 1,306,691 7.1% 34,824 0.2% 137,232 1.3% -1,607,112 -14.9% 129,296 1.2% 1,848 0.0%
Mage_Catalog_Model_Resource_Eav_Attribute::getApplyTo 9,400 1.0% 1,468,571 7.6% 384,393 2.0% 1,475,792 8.0% 370,982 2.0% 4,508,920 41.7% 801,856 7.4% 14,200 0.1% 2,312 0.0%
Mage_Catalog_Model_Resource_Eav_Mysql4_Product::_beforeSave 20 0.0% 1,115,779 5.8% 946 0.0% 1,115,319 6.0% 912 0.0% 418,352 3.9% 3,176 0.0% 849,352 7.7% 624 0.0%
Mage_Eav_Model_Entity_Abstract::_beforeSave 20 0.0% 1,111,453 5.7% 557 0.0% 1,110,996 6.0% 503 0.0% 414,616 3.8% 2,312 0.0% 846,112 7.7% 344 0.0%
Mage_Catalog_Model_Resource_Eav_Mysql4_Product::_afterSave 20 0.0% 1,087,095 5.6% 891 0.0% 1,081,518 5.9% 943 0.0% 130,136 1.2% 2,440 0.0% 103,184 0.9% 672 0.0%
Zend_Db_Statement::execute 868 0.1% 1,015,587 5.2% 20,139 0.1% 225,494 1.2% 20,064 0.1% 548,672 5.1% -40,608 -0.4% 27,680 0.3% 1,040 0.0%
Zend_Db_Adapter_Pdo_Abstract::prepare 868 0.1% 1,007,570 5.2% 44,842 0.2% 1,007,463 5.5% 42,529 0.2% 2,733,888 25.3% 168,736 1.6% 113,688 1.0% 3,208 0.0%
Zend_Db_Statement_Pdo::_execute 868 0.1% 995,448 5.1% 21,120 0.1% 205,430 1.1% 19,876 0.1% 589,280 5.5% 42,784 0.4% 26,640 0.2% 1,440 0.0%
PDOStatement::execute 868 0.1% 974,328 5.0% 974,328 5.0% 185,554 1.0% 185,554 1.0% 546,496 5.1% 546,496 5.1% 25,200 0.2% 25,200 0.2%
Mage_Catalog_Model_Product::_beforeSave 20 0.0% 935,863 4.8% 2,382 0.0% 931,817 5.0% 2,208 0.0% 854,712 7.9% 18,448 0.2% 840,104 7.6% 3,584 0.0%
Zend_Db_Adapter_Abstract::update 243 0.0% 930,347 4.8% 35,016 0.2% 690,703 3.7% 31,825 0.2% 39,568 0.4% -1,289,536 -11.9% 57,712 0.5% 4,312 0.0%
strpos 91,457 10.1% 922,918 4.8% 922,918 4.8% 970,176 5.3% 970,176 5.3% 11,024 0.1% 11,024 0.1% 9,352 0.1% 9,352 0.1%
Mage_Index_Model_Indexer::indexEvent 20 0.0% 918,874 4.7% 609 0.0% 695,173 3.8% 611 0.0% 21,560 0.2% 1,400 0.0% 18,256 0.2% 1,024 0.0%
Zend_Db_Statement::__construct 868 0.1% 916,347 4.7% 44,830 0.2% 916,308 5.0% 42,513 0.2% 2,561,632 23.7% 1,960 0.0% 107,104 1.0% 2,024 0.0%
Mage_Core_Model_Mysql4_Abstract::save 39 0.0% 901,822 4.7% 7,528 0.0% 875,705 4.7% 7,028 0.0% 256,288 2.4% -28,704 -0.3% 287,408 2.6% 4,768 0.0%
Mage_Eav_Model_Entity_Abstract::_afterSave 20 0.0% 900,901 4.7% 507 0.0% 897,555 4.9% 485 0.0% 82,024 0.8% 1,128 0.0% 76,376 0.7% 0 0.0%
Mage_Core_Model_Abstract::save@1 20 0.0% 871,593 4.5% 2,694 0.0% 824,737 4.5% 2,449 0.0% 86,872 0.8% 13,992 0.1% 143,952 1.3% 2,112 0.0%
Mage_Catalog_Model_Product_Type_Abstract::beforeSave 20 0.0% 860,802 4.4% 827 0.0% 858,467 4.6% 760 0.0% 804,504 7.4% 2,984 0.0% 805,920 7.3% 1,712 0.0%
Mage_Catalog_Model_Product_Type_Abstract::_removeNotApplicableAttributes 20 0.0% 859,151 4.4% 85,077 0.4% 856,840 4.6% 78,524 0.4% 798,872 7.4% -755,248 -7.0% 803,096 7.3% 3,880 0.0%
Mage_Catalog_Model_Product_Indexer_Eav::_attributeIsIndexable 1,524 0.2% 808,758 4.2% 30,702 0.2% 809,601 4.4% 30,664 0.2% 87,936 0.8% 1,280 0.0% 9,000 0.1% 480 0.0%
Mage_Index_Model_Process::processEvent 180 0.0% 800,481 4.1% 5,940 0.0% 576,857 3.1% 5,923 0.0% 18,000 0.2% 31,664 0.3% 14,824 0.1% 672 0.0%
Zend_Db_Statement::_parseParameters 868 0.1% 788,978 4.1% 43,908 0.2% 788,943 4.3% 41,136 0.2% 1,536,992 14.2% 167,608 1.6% 94,312 0.9% 6,536 0.1%
Zend_Db_Adapter_Abstract::_quoteIdentifierAs 4,739 0.5% 780,806 4.0% 295,997 1.5% 785,081 4.3% 282,238 1.5% 676,848 6.3% -1,743,936 -16.1% 70,984 0.6% 18,864 0.2%
Mage_Catalog_Model_Resource_Eav_Attribute::isIndexable 1,524 0.2% 778,056 4.0% 76,530 0.4% 778,937 4.2% 72,120 0.4% 86,656 0.8% 512,440 4.7% 8,520 0.1% 2,032 0.0%
Mage_Index_Model_Process::changeStatus 180 0.0% 767,560 4.0% 5,687 0.0% 543,829 2.9% 5,610 0.0% 7,120 0.1% 1,504 0.0% 13,184 0.1% 936 0.0%
Mage_Catalog_Model_Resource_Eav_Mysql4_Abstract::_isApplicableAttribute 3,440 0.4% 751,173 3.9% 135,309 0.7% 754,274 4.1% 131,175 0.7% 170,488 1.6% -1,375,584 -12.7% 15,608 0.1% 2,008 0.0%
Mage_Index_Model_Mysql4_Process::updateStatus 180 0.0% 748,887 3.9% 13,134 0.1% 525,089 2.8% 12,495 0.1% 4,800 0.0% -12,136 -0.1% 11,664 0.1% 1,952 0.0%
Zend_Db_Statement::_stripQuoted 868 0.1% 713,857 3.7% 97,350 0.5% 714,270 3.9% 90,989 0.5% 439,456 4.1% -1,468,632 -13.6% 83,896 0.8% 6,368 0.1%
Zend_Db_Adapter_Abstract::quoteIdentifier 3,880 0.4% 675,192 3.5% 79,524 0.4% 678,270 3.7% 79,082 0.4% 570,064 5.3% 10,152 0.1% 29,744 0.3% 5,104 0.0%
explode 59,712 6.6% 608,297 3.1% 608,297 3.1% 648,043 3.5% 648,043 3.5% 39,202,280 362.6% 39,202,280 362.6% 77,792 0.7% 77,792 0.7%
Varien_Db_Adapter_Pdo_Mysql::insertOnDuplicate 180 0.0% 571,433 3.0% 32,626 0.2% 552,114 3.0% 30,228 0.2% -4,024 -0.0% -1,471,248 -13.6% 25,440 0.2% 5,216 0.0%
Mage_Eav_Model_Entity_Attribute_Abstract::isInSet 1,720 0.2% 541,334 2.8% 96,349 0.5% 542,615 2.9% 91,756 0.5% 88,984 0.8% 94,792 0.9% 2,216 0.0% 992 0.0%
Mage_Catalog_Model_Resource_Eav_Attribute::getAttributeSetInfo 3,442 0.4% 536,048 2.8% 69,368 0.4% 538,766 2.9% 69,663 0.4% 655,344 6.1% 642,608 5.9% 10,480 0.1% 9,208 0.1%
Mage_Catalog_Model_Resource_Eav_Mysql4_Abstract::_isCallableAttributeInstance 3,048 0.3% 533,250 2.8% 153,564 0.8% 535,643 2.9% 146,022 0.8% 154,488 1.4% -116,928 -1.1% 7,912 0.1% 2,152 0.0%
Mage_Index_Model_Mysql4_Event::_afterSave 20 0.0% 519,303 2.7% 6,506 0.0% 504,444 2.7% 5,959 0.0% 2,680 0.0% 10,520 0.1% 0 0.0% 0 0.0%
Mage_Eav_Model_Entity_Attribute_Abstract::getFlatUpdateSelect 224 0.0% 481,823 2.5% 13,722 0.1% 482,132 2.6% 12,834 0.1% 1,220,992 11.3% -6,464 -0.1% 87,928 0.8% 2,824 0.0%
Mage_Eav_Model_Entity_Attribute_Set::addSetInfo 20 0.0% 445,954 2.3% 61,112 0.3% 445,799 2.4% 57,135 0.3% 147,352 1.4% -440,032 -4.1% 251,896 2.3% 9,512 0.1%
Varien_Data_Collection_Db::load 136 0.0% 419,983 2.2% 12,075 0.1% 419,454 2.3% 11,408 0.1% 1,943,344 18.0% -882,952 -8.2% 2,347,952 21.3% 6,792 0.1%
Mage_Eav_Model_Config::getAttribute 3,570 0.4% 416,411 2.2% 172,787 0.9% 418,334 2.3% 163,871 0.9% 83,032 0.8% -177,632 -1.6% 97,488 0.9% 9,120 0.1%
Varien_Data_Collection::getColumnValues 3 0.0% 401,657 2.1% 1,883 0.0% 401,264 2.2% 1,759 0.0% 1,697,184 15.7% 23,368 0.2% 2,072,088 18.8% 1,160 0.0%
Zend_Db_Adapter_Abstract::quote 2,242 0.2% 396,800 2.0% 94,477 0.5% 398,225 2.2% 89,745 0.5% 196,816 1.8% -20,968 -0.2% 47,712 0.4% 20,272 0.2%
Mage_Catalog_Model_Resource_Eav_Mysql4_Product_Flat_Indexer::prepareFlatTable 7 0.0% 394,953 2.0% 4,663 0.0% 379,094 2.1% 4,153 0.0% 1,111,392 10.3% -13,448 -0.1% 1,189,224 10.8% 2,064 0.0%
is_null 37,937 4.2% 382,378 2.0% 382,378 2.0% 401,207 2.2% 401,207 2.2% 48,704 0.5% 48,704 0.5% 31,224 0.3% 31,224 0.3%
Mage_Eav_Model_Entity_Abstract::loadAllAttributes 40 0.0% 374,599 1.9% 40,471 0.2% 374,584 2.0% 37,337 0.2% 95,704 0.9% -36,016 -0.3% 106,904 1.0% 23,600 0.2%
Varien_Cache_Core::clean 41 0.0% 352,911 1.8% 1,432 0.0% 344,803 1.9% 1,369 0.0% 10,984 0.1% -20,376 -0.2% 123,520 1.1% 712 0.0%
Zend_Cache_Core::clean 41 0.0% 347,637 1.8% 1,855 0.0% 339,533 1.8% 1,797 0.0% 7,848 0.1% 1,712 0.0% 120,840 1.1% 976 0.0%
Zend_Cache_Backend_File::clean 41 0.0% 336,760 1.7% 1,430 0.0% 328,655 1.8% 1,265 0.0% 4,560 0.0% 1,776 0.0% 119,208 1.1% 600 0.0%
Zend_Cache_Backend_File::_clean 41 0.0% 334,881 1.7% 5,578 0.0% 326,868 1.8% 4,613 0.0% 7,080 0.1% -25,472 -0.2% 118,104 1.1% 1,112 0.0%
Mage_Catalog_Model_Product::_afterSave 20 0.0% 332,071 1.7% 1,889 0.0% 319,953 1.7% 1,732 0.0% 434,424 4.0% 5,288 0.0% 368,984 3.4% 3,976 0.0%
substr 32,273 3.6% 327,623 1.7% 327,623 1.7% 344,726 1.9% 344,726 1.9% 1,127,104 10.4% 1,127,104 10.4% 4,472 0.0% 4,472 0.0%
Mage_Core_Model_Abstract::_afterSave 59 0.0% 324,080 1.7% 3,156 0.0% 311,991 1.7% 2,881 0.0% 264,176 2.4% -19,584 -0.2% 271,320 2.5% 1,488 0.0%
Zend_Cache_Backend_File::_clean@1 92 0.0% 320,826 1.7% 35,199 0.2% 313,804 1.7% 31,726 0.2% 3,680 0.0% -578,120 -5.3% 114,256 1.0% 2,728 0.0%
Mage_Eav_Model_Mysql4_Entity_Attribute::getFlatUpdateSelect 210 0.0% 308,129 1.6% 35,450 0.2% 308,447 1.7% 32,816 0.2% 1,065,264 9.9% 70,760 0.7% 18,048 0.2% 5,040 0.0%
Mage::dispatchEvent 479 0.1% 295,168 1.5% 24,773 0.1% 271,331 1.5% 23,710 0.1% 630,832 5.8% 16,688 0.2% 648,496 5.9% 12,048 0.1%
Mage_Eav_Model_Entity_Abstract::_processSaveData 20 0.0% 293,444 1.5% 4,169 0.0% 281,651 1.5% 3,708 0.0% 225,928 2.1% 32,792 0.3% 70,200 0.6% 2,752 0.0%
Mage_Eav_Model_Entity_Abstract::getAttribute 3,900 0.4% 289,131 1.5% 121,254 0.6% 292,325 1.6% 118,793 0.6% 62,112 0.6% 2,960 0.0% 54,128 0.5% 8,488 0.1%
Zend_Db_Adapter_Abstract::_quoteIdentifier 5,651 0.6% 288,192 1.5% 171,947 0.9% 292,872 1.6% 167,851 0.9% 473,296 4.4% -456,256 -4.2% 32,592 0.3% 18,456 0.2%
Varien_Object::addData 315 0.0% 285,688 1.5% 72,634 0.4% 285,932 1.5% 67,594 0.4% 885,104 8.2% 2,848 0.0% 912,104 8.3% 33,632 0.3%
Mage_Core_Model_Cache::flush 1 0.0% 283,561 1.5% 22 0.0% 278,596 1.5% 22 0.0% 8,160 0.1% 1,064 0.0% 117,584 1.1% 0 0.0%
Mage_Eav_Model_Entity_Attribute_Abstract::getAttributeCode 8,936 1.0% 271,882 1.4% 176,962 0.9% 279,778 1.5% 177,195 1.0% 24,392 0.2% 23,568 0.2% 16,024 0.1% 15,200 0.1%
Varien_Object::setData 8,818 1.0% 262,315 1.4% 174,750 0.9% 269,009 1.5% 176,398 1.0% 729,136 6.7% 728,360 6.7% 923,568 8.4% 922,920 8.4%
Mage_Core_Model_App::dispatchEvent 479 0.1% 234,325 1.2% 17,438 0.1% 210,784 1.1% 16,584 0.1% 611,808 5.7% -23,296 -0.2% 626,736 5.7% 54,360 0.5%
Zend_Db_Adapter_Pdo_Abstract::_quote 2,680 0.3% 230,217 1.2% 125,084 0.6% 232,246 1.3% 119,573 0.6% 206,824 1.9% 122,280 1.1% 6,880 0.1% 3,704 0.0%
Varien_Db_Select::crossUpdateFromSelect 224 0.0% 229,893 1.2% 35,071 0.2% 229,954 1.2% 31,893 0.2% 125,488 1.2% -205,432 -1.9% 18,976 0.2% 5,112 0.0%

From approx. 6 seconds per product to less then 1 :)

@BrocksiNet
Copy link
Contributor

pls re-open when this performance informations by @sreichel are not enough.

@BrocksiNet
Copy link
Contributor

Changes are merged in version 2.1.4.

Sign up for free to subscribe to this conversation on GitHub. Already have an account? Sign in.
Assignees
No one assigned
Labels
None yet
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
5 participants
@davidfuhr @BrocksiNet @kayaj @sreichel @Stajon