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 48a60bb461..6c77cad2d9 100644 --- a/oe-build-perf-test.log +++ b/oe-build-perf-test.log @@ -1,26 +1,26 @@ -[2016-12-26 01:00:09,548] INFO: Using Git branch:commit master:dbb247cac5fbf7b037e4955f9793828451723924 (43626) -[2016-12-26 01:00:09,548] INFO: Executing test test1: Measure wall clock of bitbake core-image-sato and size of tmp dir -[2016-12-26 01:00:09,548] INFO: Logging command: bitbake core-image-sato -c fetchall -[2016-12-26 01:05:32,250] INFO: Timing command: bitbake core-image-sato -[2016-12-26 02:07:55,483] INFO: Saving buildstats in JSON format -[2016-12-26 02:09:39,076] INFO: Executing test test12: Measure bitbake virtual/kernel -[2016-12-26 02:09:39,077] INFO: Logging command: bitbake virtual/kernel -c fetchall -[2016-12-26 02:09:57,663] INFO: Logging command: bitbake virtual/kernel -[2016-12-26 02:10:00,719] INFO: Logging command: bitbake virtual/kernel -c cleansstate -[2016-12-26 02:10:13,556] INFO: Timing command: bitbake virtual/kernel -[2016-12-26 02:15:31,284] INFO: Executing test test13: Build core-image-sato with rm_work enabled -[2016-12-26 02:15:31,284] INFO: Logging command: bitbake core-image-sato -c fetchall -[2016-12-26 02:20:45,383] INFO: Timing command: bitbake -R /media/yocto_disk/poky-new-perf/build-perf-test/results-dbb247c-20161226010004/test13/postfile.conf core-image-sato -[2016-12-26 03:21:41,813] INFO: Saving buildstats in JSON format -[2016-12-26 03:21:50,716] INFO: Executing test test2: Measure bitbake core-image-sato -c rootfs with sstate -[2016-12-26 03:21:50,716] INFO: Logging command: bitbake core-image-sato -c fetchall -[2016-12-26 03:22:22,174] INFO: Logging command: bitbake core-image-sato -[2016-12-26 03:23:31,911] INFO: Timing command: bitbake core-image-sato -c rootfs -[2016-12-26 03:26:11,547] INFO: Executing test test3: Parsing time metrics (bitbake -p) -[2016-12-26 03:26:11,550] INFO: Timing command: bitbake -p -[2016-12-26 03:26:33,424] INFO: Timing command: bitbake -p -[2016-12-26 03:26:47,604] INFO: Timing command: bitbake -p -[2016-12-26 03:26:49,010] INFO: Executing test test4: eSDK metrics -[2016-12-26 03:26:49,010] INFO: Logging command: bitbake core-image-sato -c fetchall -[2016-12-26 03:27:08,310] INFO: Logging command: bitbake core-image-sato -c do_populate_sdk_ext -[2016-12-26 03:53:02,981] INFO: Timing command: /media/yocto_disk/poky-new-perf/build-perf-test/build-dbb247c-20161226010004/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-dbb247c-20161226010004/tmp/esdk-deploy +[2016-12-27 16:00:19,456] INFO: Using Git branch:commit master:dbb247cac5fbf7b037e4955f9793828451723924 (43626) +[2016-12-27 16:00:19,456] INFO: Executing test test1: Measure wall clock of bitbake core-image-sato and size of tmp dir +[2016-12-27 16:00:19,456] INFO: Logging command: bitbake core-image-sato -c fetchall +[2016-12-27 16:13:26,506] INFO: Timing command: bitbake core-image-sato +[2016-12-27 17:36:46,181] INFO: Saving buildstats in JSON format +[2016-12-27 17:43:54,563] INFO: Executing test test12: Measure bitbake virtual/kernel +[2016-12-27 17:43:54,563] INFO: Logging command: bitbake virtual/kernel -c fetchall +[2016-12-27 17:44:33,960] INFO: Logging command: bitbake virtual/kernel +[2016-12-27 17:44:37,340] INFO: Logging command: bitbake virtual/kernel -c cleansstate +[2016-12-27 17:45:01,007] INFO: Timing command: bitbake virtual/kernel +[2016-12-27 17:52:24,497] INFO: Executing test test13: Build core-image-sato with rm_work enabled +[2016-12-27 17:52:24,498] INFO: Logging command: bitbake core-image-sato -c fetchall +[2016-12-27 18:07:40,834] INFO: Timing command: bitbake -R /media/yocto_disk/poky-new-perf/build-perf-test/results-dbb247c-20161227160008/test13/postfile.conf core-image-sato +[2016-12-27 19:13:44,039] INFO: Saving buildstats in JSON format +[2016-12-27 19:14:25,428] INFO: Executing test test2: Measure bitbake core-image-sato -c rootfs with sstate +[2016-12-27 19:14:25,429] INFO: Logging command: bitbake core-image-sato -c fetchall +[2016-12-27 19:15:04,492] INFO: Logging command: bitbake core-image-sato +[2016-12-27 19:16:08,154] INFO: Timing command: bitbake core-image-sato -c rootfs +[2016-12-27 19:19:18,274] INFO: Executing test test3: Parsing time metrics (bitbake -p) +[2016-12-27 19:19:18,276] INFO: Timing command: bitbake -p +[2016-12-27 19:19:40,694] INFO: Timing command: bitbake -p +[2016-12-27 19:19:54,781] INFO: Timing command: bitbake -p +[2016-12-27 19:19:56,309] INFO: Executing test test4: eSDK metrics +[2016-12-27 19:19:56,309] INFO: Logging command: bitbake core-image-sato -c fetchall +[2016-12-27 19:20:19,060] INFO: Logging command: bitbake core-image-sato -c do_populate_sdk_ext +[2016-12-27 19:53:29,909] INFO: Timing command: /media/yocto_disk/poky-new-perf/build-perf-test/build-dbb247c-20161227160008/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-dbb247c-20161227160008/tmp/esdk-deploy diff --git a/results.xml b/results.xml index cefc5c31c4..ad3b02ba33 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="10523.633608" timestamp="2016-12-26T06:00:09.548588"> - <testcase classname="oeqa.buildperf.test_basic.Test1P1" description="Measure wall clock of bitbake core-image-sato and size of tmp dir" name="test1" time="4169.521632" timestamp="2016-12-26T01:00:09.548646"> + <testsuite errors="0" failures="0" hostname="ypperf01" name="oeqa.buildperf" skipped="0" tests="6" time="14215.856867" timestamp="2016-12-27T21:00:19.456522"> + <testcase classname="oeqa.buildperf.test_basic.Test1P1" description="Measure wall clock of bitbake core-image-sato and size of tmp dir" name="test1" time="6215.007334" timestamp="2016-12-27T16:00:19.456733"> <sysres legend="bitbake core-image-sato" name="build"> - <time timestamp="2016-12-26T01:05:32.398281">3743.074278</time> - <iostat cancelled_write_bytes="6607998976" rchar="252377345871" read_bytes="4885647360" syscr="92051580" syscw="54900504" wchar="70986647592" write_bytes="42945339392"/> - <rusage ru_inblock="9541792" ru_majflt="21298" ru_maxrss="917848" ru_minflt="1239347438" ru_nivcsw="29821515" ru_nvcsw="29233633" ru_oublock="83877616" ru_stime="3737.13103" ru_utime="21906.801667"/> + <time timestamp="2016-12-27T16:13:27.519921">4998.660297</time> + <iostat cancelled_write_bytes="6495514624" rchar="252745433057" read_bytes="6115368960" syscr="90277484" syscw="55002135" wchar="70994512326" write_bytes="42949898240"/> + <rusage ru_inblock="11944080" ru_majflt="26796" ru_maxrss="917868" ru_minflt="1239918975" ru_nivcsw="26641154" ru_nvcsw="29392672" ru_oublock="83886520" ru_stime="3654.466472" ru_utime="21608.642898"/> </sysres> <diskusage legend="tmpdir" name="tmpdir"> - <size>27100356</size> + <size>27106980</size> </diskusage> </testcase> - <testcase classname="oeqa.buildperf.test_basic.Test1P2" description="Measure bitbake virtual/kernel" name="test12" time="352.213183" timestamp="2016-12-26T02:09:39.070914"> + <testcase classname="oeqa.buildperf.test_basic.Test1P2" description="Measure bitbake virtual/kernel" name="test12" time="510.033486" timestamp="2016-12-27T17:43:54.464171"> <sysres legend="bitbake virtual/kernel" name="build"> - <time timestamp="2016-12-26T02:10:13.565474">317.717206</time> - <iostat cancelled_write_bytes="311181312" rchar="17645416074" read_bytes="819650560" syscr="4114000" syscw="1572283" wchar="2152590309" write_bytes="1928724480"/> - <rusage ru_inblock="1600856" ru_majflt="5168" ru_maxrss="600412" ru_minflt="58671747" ru_nivcsw="259132" ru_nvcsw="717411" ru_oublock="3767040" ru_stime="165.61252" ru_utime="1420.329262"/> + <time timestamp="2016-12-27T17:45:01.049757">443.446488</time> + <iostat cancelled_write_bytes="311185408" rchar="17649876996" read_bytes="774266880" syscr="4099146" syscw="1574075" wchar="2152680345" write_bytes="1928908800"/> + <rusage ru_inblock="1512240" ru_majflt="4997" ru_maxrss="582112" ru_minflt="58621616" ru_nivcsw="397553" ru_nvcsw="724568" ru_oublock="3767400" ru_stime="146.656457" ru_utime="1411.635893"/> </sysres> </testcase> - <testcase classname="oeqa.buildperf.test_basic.Test1P3" description="Build core-image-sato with rm_work enabled" name="test13" time="3979.431717" timestamp="2016-12-26T02:15:31.284168"> + <testcase classname="oeqa.buildperf.test_basic.Test1P3" description="Build core-image-sato with rm_work enabled" name="test13" time="4920.771296" timestamp="2016-12-27T17:52:24.497730"> <sysres legend="bitbakecore-image-sato" name="build"> - <time timestamp="2016-12-26T02:20:45.465203">3656.347273</time> - <iostat cancelled_write_bytes="9469530112" rchar="252667445728" read_bytes="2111954944" syscr="92894582" syscw="55054758" wchar="71206074394" write_bytes="42965331968"/> - <rusage ru_inblock="4124912" ru_majflt="8368" ru_maxrss="917612" ru_minflt="1247607127" ru_nivcsw="32415007" ru_nvcsw="27055947" ru_oublock="83916664" ru_stime="3840.067519" ru_utime="22156.612412"/> + <time timestamp="2016-12-27T18:07:40.895750">3963.1426</time> + <iostat cancelled_write_bytes="9816612864" rchar="253056044317" read_bytes="2196590592" syscr="92268659" syscw="55202472" wchar="71218282738" write_bytes="42968678400"/> + <rusage ru_inblock="4290216" ru_majflt="8255" ru_maxrss="917756" ru_minflt="1246153845" ru_nivcsw="33090611" ru_nvcsw="24421622" ru_oublock="83923200" ru_stime="3755.788325" ru_utime="22359.789277"/> </sysres> <diskusage legend="tmpdir" name="tmpdir"> - <size>6637520</size> + <size>6639876</size> </diskusage> </testcase> - <testcase classname="oeqa.buildperf.test_basic.Test2" description="Measure bitbake core-image-sato -c rootfs with sstate" name="test2" time="260.831319" timestamp="2016-12-26T03:21:50.715961"> + <testcase classname="oeqa.buildperf.test_basic.Test2" description="Measure bitbake core-image-sato -c rootfs with sstate" name="test2" time="293.00474" timestamp="2016-12-27T19:14:25.269107"> <sysres legend="bitbake do_rootfs" name="do_rootfs"> - <time timestamp="2016-12-26T03:23:31.944751">159.601079</time> - <iostat cancelled_write_bytes="152743936" rchar="5175624922" read_bytes="1141571584" syscr="1496355" syscw="1042118" wchar="3870792709" write_bytes="2072514560"/> - <rusage ru_inblock="2229632" ru_majflt="377" ru_maxrss="186028" ru_minflt="15853424" ru_nivcsw="116141" ru_nvcsw="716950" ru_oublock="4047880" ru_stime="65.179653" ru_utime="418.484983"/> + <time timestamp="2016-12-27T19:16:08.210179">190.062199</time> + <iostat cancelled_write_bytes="130052096" rchar="5187227933" read_bytes="1118629888" syscr="1523116" syscw="1041734" wchar="3870532645" write_bytes="2071900160"/> + <rusage ru_inblock="2184824" ru_majflt="371" ru_maxrss="185752" ru_minflt="15790114" ru_nivcsw="103060" ru_nvcsw="710486" ru_oublock="4046680" ru_stime="65.069585" ru_utime="399.115327"/> </sysres> </testcase> - <testcase classname="oeqa.buildperf.test_basic.Test3" description="Parsing time metrics (bitbake -p)" name="test3" time="37.463119" timestamp="2016-12-26T03:26:11.547358"> + <testcase classname="oeqa.buildperf.test_basic.Test3" description="Parsing time metrics (bitbake -p)" name="test3" time="38.035504" timestamp="2016-12-27T19:19:18.273920"> <sysres legend="bitbake -p (no caches)" name="parse_1"> - <time timestamp="2016-12-26T03:26:11.551909">21.868391</time> - <iostat cancelled_write_bytes="1064960" rchar="27799717" read_bytes="0" syscr="9030" syscw="4811" wchar="32860572" write_bytes="16957440"/> - <rusage ru_inblock="0" ru_majflt="0" ru_maxrss="113008" ru_minflt="307976" ru_nivcsw="8161" ru_nvcsw="6317" ru_oublock="33120" ru_stime="1.011393" ru_utime="164.928361"/> + <time timestamp="2016-12-27T19:19:18.278428">22.411761</time> + <iostat cancelled_write_bytes="1052672" rchar="27889537" read_bytes="0" syscr="9055" syscw="4808" wchar="32835951" write_bytes="16912384"/> + <rusage ru_inblock="0" ru_majflt="0" ru_maxrss="113136" ru_minflt="315081" ru_nivcsw="16516" ru_nvcsw="6238" ru_oublock="33032" ru_stime="1.124729" ru_utime="166.686013"/> </sysres> <sysres legend="bitbake -p (no tmp/cache)" name="parse_2"> - <time timestamp="2016-12-26T03:26:33.425930">14.176838</time> - <iostat cancelled_write_bytes="888832" rchar="27733131" read_bytes="0" syscr="9089" syscw="4807" wchar="32179190" write_bytes="16265216"/> - <rusage ru_inblock="0" ru_majflt="0" ru_maxrss="113576" ru_minflt="289284" ru_nivcsw="7525" ru_nvcsw="6271" ru_oublock="31768" ru_stime="0.987931" ru_utime="103.503847"/> + <time timestamp="2016-12-27T19:19:40.695828">14.08412</time> + <iostat cancelled_write_bytes="892928" rchar="27766524" read_bytes="0" syscr="9093" syscw="4801" wchar="32209721" write_bytes="16257024"/> + <rusage ru_inblock="0" ru_majflt="0" ru_maxrss="114612" ru_minflt="287064" ru_nivcsw="12897" ru_nvcsw="6444" ru_oublock="31752" ru_stime="1.048641" ru_utime="102.654848"/> </sysres> <sysres legend="bitbake -p (cached)" name="parse_3"> - <time timestamp="2016-12-26T03:26:47.606108">1.402978</time> - <iostat cancelled_write_bytes="12288" rchar="20867276" read_bytes="0" syscr="6160" syscw="1522" wchar="746839" write_bytes="380928"/> - <rusage ru_inblock="0" ru_majflt="0" ru_maxrss="95232" ru_minflt="47483" ru_nivcsw="12" ru_nvcsw="7815" ru_oublock="744" ru_stime="0.135828" ru_utime="1.367666"/> + <time timestamp="2016-12-27T19:19:54.783200">1.52473</time> + <iostat cancelled_write_bytes="12288" rchar="20852641" read_bytes="0" syscr="6151" syscw="1522" wchar="746784" write_bytes="380928"/> + <rusage ru_inblock="0" ru_majflt="0" ru_maxrss="95428" ru_minflt="47608" ru_nivcsw="13" ru_nvcsw="7817" ru_oublock="744" ru_stime="0.125025" ru_utime="1.40668"/> </sysres> </testcase> - <testcase classname="oeqa.buildperf.test_basic.Test4" description="eSDK metrics" name="test4" time="1724.171587" timestamp="2016-12-26T03:26:49.010548"> + <testcase classname="oeqa.buildperf.test_basic.Test4" description="eSDK metrics" name="test4" time="2239.003828" timestamp="2016-12-27T19:19:56.309499"> <diskusage legend="eSDK installer" name="installer_bin"> - <size>1511338</size> + <size>1510299</size> </diskusage> <sysres legend="eSDK deploy" name="deploy"> - <time timestamp="2016-12-26T03:53:03.007203">149.385196</time> - <iostat cancelled_write_bytes="447086592" rchar="11092360936" read_bytes="186281984" syscr="2258040" syscw="5896386" wchar="12124972960" write_bytes="5768585216"/> - <rusage ru_inblock="363832" ru_majflt="273" ru_maxrss="227068" ru_minflt="17318912" ru_nivcsw="393067" ru_nvcsw="1101169" ru_oublock="11266768" ru_stime="78.707512" ru_utime="518.728846"/> + <time timestamp="2016-12-27T19:53:30.010314">224.815768</time> + <iostat cancelled_write_bytes="446771200" rchar="11088435511" read_bytes="689528832" syscr="2177102" syscw="5892786" wchar="12122537878" write_bytes="5771034624"/> + <rusage ru_inblock="1346736" ru_majflt="270" ru_maxrss="227208" ru_minflt="19302043" ru_nivcsw="357185" ru_nvcsw="1087819" ru_oublock="11271552" ru_stime="87.068626" ru_utime="513.004485"/> </sysres> <diskusage legend="deploy dir" name="deploy_dir"> - <size>5002321</size> + <size>5002835</size> </diskusage> </testcase> </testsuite> |