diff options
-rw-r--r-- | oe-build-perf-test.log | 52 | ||||
-rw-r--r-- | results.xml | 70 |
2 files changed, 61 insertions, 61 deletions
diff --git a/oe-build-perf-test.log b/oe-build-perf-test.log index 23cf6d5421..119a3c39b4 100644 --- a/oe-build-perf-test.log +++ b/oe-build-perf-test.log @@ -1,26 +1,26 @@ -[2017-01-06 11:00:10,531] INFO: Using Git branch:commit master:e016eb10b075e280b4e78a04e47b59a173386421 (43649) -[2017-01-06 11:00:10,532] INFO: Executing test test1: Measure wall clock of bitbake core-image-sato and size of tmp dir -[2017-01-06 11:00:10,532] INFO: Logging command: bitbake core-image-sato -c fetchall -[2017-01-06 11:05:30,577] INFO: Timing command: bitbake core-image-sato -[2017-01-06 12:12:17,985] INFO: Saving buildstats in JSON format -[2017-01-06 12:15:10,710] INFO: Executing test test12: Measure bitbake virtual/kernel -[2017-01-06 12:15:10,711] INFO: Logging command: bitbake virtual/kernel -c fetchall -[2017-01-06 12:15:28,021] INFO: Logging command: bitbake virtual/kernel -[2017-01-06 12:15:31,102] INFO: Logging command: bitbake virtual/kernel -c cleansstate -[2017-01-06 12:15:49,696] INFO: Timing command: bitbake virtual/kernel -[2017-01-06 12:21:27,060] INFO: Executing test test13: Build core-image-sato with rm_work enabled -[2017-01-06 12:21:27,060] INFO: Logging command: bitbake core-image-sato -c fetchall -[2017-01-06 12:32:43,567] INFO: Timing command: bitbake -R /media/yocto_disk/poky-new-perf/build-perf-test/results-e016eb1-20170106110005/test13/postfile.conf core-image-sato -[2017-01-06 13:35:29,924] INFO: Saving buildstats in JSON format -[2017-01-06 13:35:46,131] INFO: Executing test test2: Measure bitbake core-image-sato -c rootfs with sstate -[2017-01-06 13:35:46,131] INFO: Logging command: bitbake core-image-sato -c fetchall -[2017-01-06 13:36:24,413] INFO: Logging command: bitbake core-image-sato -[2017-01-06 13:37:48,586] INFO: Timing command: bitbake core-image-sato -c rootfs -[2017-01-06 13:40:24,898] INFO: Executing test test3: Parsing time metrics (bitbake -p) -[2017-01-06 13:40:24,901] INFO: Timing command: bitbake -p -[2017-01-06 13:40:46,787] INFO: Timing command: bitbake -p -[2017-01-06 13:41:00,870] INFO: Timing command: bitbake -p -[2017-01-06 13:41:02,278] INFO: Executing test test4: eSDK metrics -[2017-01-06 13:41:02,278] INFO: Logging command: bitbake core-image-sato -c fetchall -[2017-01-06 13:41:21,867] INFO: Logging command: bitbake core-image-sato -c do_populate_sdk_ext -[2017-01-06 14:08:09,065] INFO: Timing command: /media/yocto_disk/poky-new-perf/build-perf-test/build-e016eb1-20170106110005/tmp/deploy/sdk/poky-glibc-x86_64-core-image-sato-i586-toolchain-ext-2.2.sh -y -d /media/yocto_disk/poky-new-perf/build-perf-test/build-e016eb1-20170106110005/tmp/esdk-deploy +[2017-01-06 16:00:10,447] INFO: Using Git branch:commit master:e016eb10b075e280b4e78a04e47b59a173386421 (43649) +[2017-01-06 16:00:10,447] INFO: Executing test test1: Measure wall clock of bitbake core-image-sato and size of tmp dir +[2017-01-06 16:00:10,447] INFO: Logging command: bitbake core-image-sato -c fetchall +[2017-01-06 16:05:32,123] INFO: Timing command: bitbake core-image-sato +[2017-01-06 17:12:17,495] INFO: Saving buildstats in JSON format +[2017-01-06 17:14:47,974] INFO: Executing test test12: Measure bitbake virtual/kernel +[2017-01-06 17:14:47,975] INFO: Logging command: bitbake virtual/kernel -c fetchall +[2017-01-06 17:15:04,917] INFO: Logging command: bitbake virtual/kernel +[2017-01-06 17:15:07,986] INFO: Logging command: bitbake virtual/kernel -c cleansstate +[2017-01-06 17:15:26,733] INFO: Timing command: bitbake virtual/kernel +[2017-01-06 17:21:05,909] INFO: Executing test test13: Build core-image-sato with rm_work enabled +[2017-01-06 17:21:05,909] INFO: Logging command: bitbake core-image-sato -c fetchall +[2017-01-06 17:33:22,104] INFO: Timing command: bitbake -R /media/yocto_disk/poky-new-perf/build-perf-test/results-e016eb1-20170106160005/test13/postfile.conf core-image-sato +[2017-01-06 18:36:05,518] INFO: Saving buildstats in JSON format +[2017-01-06 18:36:17,654] INFO: Executing test test2: Measure bitbake core-image-sato -c rootfs with sstate +[2017-01-06 18:36:17,654] INFO: Logging command: bitbake core-image-sato -c fetchall +[2017-01-06 18:36:50,523] INFO: Logging command: bitbake core-image-sato +[2017-01-06 18:38:21,853] INFO: Timing command: bitbake core-image-sato -c rootfs +[2017-01-06 18:41:00,919] INFO: Executing test test3: Parsing time metrics (bitbake -p) +[2017-01-06 18:41:00,922] INFO: Timing command: bitbake -p +[2017-01-06 18:41:22,894] INFO: Timing command: bitbake -p +[2017-01-06 18:41:37,024] INFO: Timing command: bitbake -p +[2017-01-06 18:41:38,429] INFO: Executing test test4: eSDK metrics +[2017-01-06 18:41:38,429] INFO: Logging command: bitbake core-image-sato -c fetchall +[2017-01-06 18:42:00,913] INFO: Logging command: bitbake core-image-sato -c do_populate_sdk_ext +[2017-01-06 19:08:26,491] INFO: Timing command: /media/yocto_disk/poky-new-perf/build-perf-test/build-e016eb1-20170106160005/tmp/deploy/sdk/poky-glibc-x86_64-core-image-sato-i586-toolchain-ext-2.2.sh -y -d /media/yocto_disk/poky-new-perf/build-perf-test/build-e016eb1-20170106160005/tmp/esdk-deploy diff --git a/results.xml b/results.xml index 2bf3e3d0cf..fd3b61eb71 100644 --- a/results.xml +++ b/results.xml @@ -1,68 +1,68 @@ <?xml version="1.0" encoding="utf-8"?> <testsuites> - <testsuite errors="0" failures="0" hostname="ypperf01" name="oeqa.buildperf" skipped="0" tests="6" time="11514.288609" timestamp="2017-01-06T16:00:10.532113"> - <testcase classname="oeqa.buildperf.test_basic.Test1P1" description="Measure wall clock of bitbake core-image-sato and size of tmp dir" name="test1" time="4500.164566" timestamp="2017-01-06T11:00:10.532171"> + <testsuite errors="0" failures="0" hostname="ypperf01" name="oeqa.buildperf" skipped="0" tests="6" time="11519.351777" timestamp="2017-01-06T21:00:10.447413"> + <testcase classname="oeqa.buildperf.test_basic.Test1P1" description="Measure wall clock of bitbake core-image-sato and size of tmp dir" name="test1" time="4477.499638" timestamp="2017-01-06T16:00:10.447472"> <sysres legend="bitbake core-image-sato" name="build"> - <time timestamp="2017-01-06T11:05:30.724809">4007.259664</time> - <iostat cancelled_write_bytes="6654619648" rchar="252705421144" read_bytes="5265104896" syscr="90660544" syscw="55048856" wchar="71004109366" write_bytes="42949992448"/> - <rusage ru_inblock="10283408" ru_majflt="23304" ru_maxrss="917824" ru_minflt="1244356510" ru_nivcsw="28654350" ru_nvcsw="26189073" ru_oublock="83886704" ru_stime="3756.6571" ru_utime="21856.781804"/> + <time timestamp="2017-01-06T16:05:32.254043">4005.24033</time> + <iostat cancelled_write_bytes="6664691712" rchar="252652350130" read_bytes="5296332800" syscr="90614736" syscw="55047351" wchar="71001243893" write_bytes="42947346432"/> + <rusage ru_inblock="10344400" ru_majflt="23291" ru_maxrss="917624" ru_minflt="1244199692" ru_nivcsw="28112348" ru_nvcsw="26483918" ru_oublock="83881536" ru_stime="3738.890059" ru_utime="21821.922326"/> </sysres> <diskusage legend="tmpdir" name="tmpdir"> - <size>27112500</size> + <size>27113164</size> </diskusage> </testcase> - <testcase classname="oeqa.buildperf.test_basic.Test1P2" description="Measure bitbake virtual/kernel" name="test12" time="376.363708" timestamp="2017-01-06T12:15:10.696826"> + <testcase classname="oeqa.buildperf.test_basic.Test1P2" description="Measure bitbake virtual/kernel" name="test12" time="377.962091" timestamp="2017-01-06T17:14:47.947346"> <sysres legend="bitbake virtual/kernel" name="build"> - <time timestamp="2017-01-06T12:15:49.722930">337.336106</time> - <iostat cancelled_write_bytes="311181312" rchar="17627148592" read_bytes="836280320" syscr="4098806" syscw="1573109" wchar="2152528343" write_bytes="1928749056"/> - <rusage ru_inblock="1633360" ru_majflt="4999" ru_maxrss="581284" ru_minflt="58606079" ru_nivcsw="204854" ru_nvcsw="721410" ru_oublock="3767088" ru_stime="160.757073" ru_utime="1407.811827"/> + <time timestamp="2017-01-06T17:15:26.741827">339.166233</time> + <iostat cancelled_write_bytes="311173120" rchar="17657619073" read_bytes="818499584" syscr="4091880" syscw="1572494" wchar="2152610575" write_bytes="1928749056"/> + <rusage ru_inblock="1598632" ru_majflt="5034" ru_maxrss="583652" ru_minflt="58639285" ru_nivcsw="205499" ru_nvcsw="716007" ru_oublock="3767088" ru_stime="158.909303" ru_utime="1408.196579"/> </sysres> </testcase> - <testcase classname="oeqa.buildperf.test_basic.Test1P3" description="Build core-image-sato with rm_work enabled" name="test13" time="4459.070298" timestamp="2017-01-06T12:21:27.060614"> + <testcase classname="oeqa.buildperf.test_basic.Test1P3" description="Build core-image-sato with rm_work enabled" name="test13" time="4511.744882" timestamp="2017-01-06T17:21:05.909513"> <sysres legend="bitbakecore-image-sato" name="build"> - <time timestamp="2017-01-06T12:32:43.634367">3766.289072</time> - <iostat cancelled_write_bytes="9815867392" rchar="252890281270" read_bytes="2150899712" syscr="92039866" syscw="55158966" wchar="71219215431" write_bytes="42972024832"/> - <rusage ru_inblock="4200976" ru_majflt="8180" ru_maxrss="917736" ru_minflt="1246515124" ru_nivcsw="30811425" ru_nvcsw="24558284" ru_oublock="83929736" ru_stime="3792.71267" ru_utime="22204.276135"/> + <time timestamp="2017-01-06T17:33:22.138827">3763.378177</time> + <iostat cancelled_write_bytes="9988984832" rchar="252876972222" read_bytes="2148618240" syscr="91899517" syscw="55138974" wchar="71214346150" write_bytes="42969391104"/> + <rusage ru_inblock="4196520" ru_majflt="8205" ru_maxrss="917656" ru_minflt="1246528697" ru_nivcsw="30433932" ru_nvcsw="24858656" ru_oublock="83924592" ru_stime="3770.241614" ru_utime="22190.834252"/> </sysres> <diskusage legend="tmpdir" name="tmpdir"> - <size>6641640</size> + <size>6639852</size> </diskusage> </testcase> - <testcase classname="oeqa.buildperf.test_basic.Test2" description="Measure bitbake core-image-sato -c rootfs with sstate" name="test2" time="278.767433" timestamp="2017-01-06T13:35:46.130989"> + <testcase classname="oeqa.buildperf.test_basic.Test2" description="Measure bitbake core-image-sato -c rootfs with sstate" name="test2" time="283.264564" timestamp="2017-01-06T18:36:17.654478"> <sysres legend="bitbake do_rootfs" name="do_rootfs"> - <time timestamp="2017-01-06T13:37:48.673413">156.223549</time> - <iostat cancelled_write_bytes="148848640" rchar="5312903425" read_bytes="1150726144" syscr="1515278" syscw="1040904" wchar="3871427263" write_bytes="2071830528"/> - <rusage ru_inblock="2247512" ru_majflt="380" ru_maxrss="188588" ru_minflt="15852616" ru_nivcsw="96440" ru_nvcsw="674977" ru_oublock="4046544" ru_stime="59.533389" ru_utime="416.891403"/> + <time timestamp="2017-01-06T18:38:21.923573">158.994082</time> + <iostat cancelled_write_bytes="155746304" rchar="5030914001" read_bytes="1153425408" syscr="1536653" syscw="1040590" wchar="3869798524" write_bytes="2072408064"/> + <rusage ru_inblock="2252784" ru_majflt="375" ru_maxrss="182224" ru_minflt="15296549" ru_nivcsw="94819" ru_nvcsw="673438" ru_oublock="4047672" ru_stime="61.525069" ru_utime="417.504122"/> </sysres> </testcase> - <testcase classname="oeqa.buildperf.test_basic.Test3" description="Parsing time metrics (bitbake -p)" name="test3" time="37.379853" timestamp="2017-01-06T13:40:24.898494"> + <testcase classname="oeqa.buildperf.test_basic.Test3" description="Parsing time metrics (bitbake -p)" name="test3" time="37.509736" timestamp="2017-01-06T18:41:00.919115"> <sysres legend="bitbake -p (no caches)" name="parse_1"> - <time timestamp="2017-01-06T13:40:24.903162">21.880282</time> - <iostat cancelled_write_bytes="1060864" rchar="27852010" read_bytes="0" syscr="9035" syscw="4805" wchar="32864487" write_bytes="16920576"/> - <rusage ru_inblock="0" ru_majflt="0" ru_maxrss="111996" ru_minflt="314758" ru_nivcsw="8165" ru_nvcsw="6366" ru_oublock="33048" ru_stime="0.991626" ru_utime="164.16933"/> + <time timestamp="2017-01-06T18:41:00.923774">21.966823</time> + <iostat cancelled_write_bytes="1056768" rchar="27850378" read_bytes="0" syscr="9044" syscw="4817" wchar="32918137" write_bytes="16982016"/> + <rusage ru_inblock="0" ru_majflt="0" ru_maxrss="115356" ru_minflt="320015" ru_nivcsw="8170" ru_nvcsw="6395" ru_oublock="33168" ru_stime="1.009765" ru_utime="165.333013"/> </sysres> <sysres legend="bitbake -p (no tmp/cache)" name="parse_2"> - <time timestamp="2017-01-06T13:40:46.788938">14.079799</time> - <iostat cancelled_write_bytes="892928" rchar="27590953" read_bytes="0" syscr="9055" syscw="4804" wchar="32245248" write_bytes="16306176"/> - <rusage ru_inblock="0" ru_majflt="0" ru_maxrss="113428" ru_minflt="290131" ru_nivcsw="7626" ru_nvcsw="6578" ru_oublock="31848" ru_stime="0.903094" ru_utime="102.693681"/> + <time timestamp="2017-01-06T18:41:22.896167">14.126769</time> + <iostat cancelled_write_bytes="892928" rchar="27541781" read_bytes="0" syscr="9044" syscw="4801" wchar="32179504" write_bytes="16252928"/> + <rusage ru_inblock="0" ru_majflt="0" ru_maxrss="113888" ru_minflt="288973" ru_nivcsw="7450" ru_nvcsw="6506" ru_oublock="31744" ru_stime="0.9190119999999999" ru_utime="103.065041"/> </sysres> <sysres legend="bitbake -p (cached)" name="parse_3"> - <time timestamp="2017-01-06T13:41:00.871836">1.405113</time> - <iostat cancelled_write_bytes="12288" rchar="20906823" read_bytes="0" syscr="6165" syscw="1523" wchar="746962" write_bytes="380928"/> - <rusage ru_inblock="0" ru_majflt="0" ru_maxrss="95080" ru_minflt="47604" ru_nivcsw="16" ru_nvcsw="8140" ru_oublock="744" ru_stime="0.13887" ru_utime="1.354849"/> + <time timestamp="2017-01-06T18:41:37.026021">1.401444</time> + <iostat cancelled_write_bytes="12288" rchar="20854320" read_bytes="0" syscr="6141" syscw="1523" wchar="747177" write_bytes="380928"/> + <rusage ru_inblock="0" ru_majflt="0" ru_maxrss="95208" ru_minflt="47637" ru_nivcsw="17" ru_nvcsw="8028" ru_oublock="744" ru_stime="0.11261299999999999" ru_utime="1.384276"/> </sysres> </testcase> - <testcase classname="oeqa.buildperf.test_basic.Test4" description="eSDK metrics" name="test4" time="1862.542235" timestamp="2017-01-06T13:41:02.278419"> + <testcase classname="oeqa.buildperf.test_basic.Test4" description="eSDK metrics" name="test4" time="1831.370183" timestamp="2017-01-06T18:41:38.428936"> <diskusage legend="eSDK installer" name="installer_bin"> - <size>1510577</size> + <size>1510259</size> </diskusage> <sysres legend="eSDK deploy" name="deploy"> - <time timestamp="2017-01-06T14:08:09.117408">235.107391</time> - <iostat cancelled_write_bytes="446779392" rchar="11092908069" read_bytes="365592576" syscr="2179732" syscw="5894593" wchar="12125254456" write_bytes="5771956224"/> - <rusage ru_inblock="714048" ru_majflt="278" ru_maxrss="233660" ru_minflt="16893322" ru_nivcsw="253585" ru_nvcsw="1168851" ru_oublock="11273352" ru_stime="77.781893" ru_utime="487.789839"/> + <time timestamp="2017-01-06T19:08:26.565917">222.736472</time> + <iostat cancelled_write_bytes="446709760" rchar="11090132595" read_bytes="1662226432" syscr="2225866" syscw="5893784" wchar="12123954183" write_bytes="5770489856"/> + <rusage ru_inblock="3246536" ru_majflt="277" ru_maxrss="226940" ru_minflt="16802985" ru_nivcsw="263051" ru_nvcsw="1064000" ru_oublock="11270488" ru_stime="77.927538" ru_utime="493.452236"/> </sysres> <diskusage legend="deploy dir" name="deploy_dir"> - <size>5004068</size> + <size>5003420</size> </diskusage> </testcase> </testsuite> |