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 3e4793de05..c31a8ef8a6 100644 --- a/oe-build-perf-test.log +++ b/oe-build-perf-test.log @@ -1,26 +1,26 @@ -[2016-11-07 07:00:08,505] INFO: Using Git branch:commit master:43e652f3d1fee5ce7fad67e6400315eab1b34270 (43025) -[2016-11-07 07:00:08,505] INFO: Executing test test1: Measure wall clock of bitbake core-image-sato and size of tmp dir -[2016-11-07 07:00:08,505] INFO: Logging command: bitbake core-image-sato -c fetchall -[2016-11-07 07:05:20,195] INFO: Timing command: bitbake core-image-sato -[2016-11-07 08:05:34,346] INFO: Saving buildstats in JSON format -[2016-11-07 08:08:01,424] INFO: Executing test test12: Measure bitbake virtual/kernel -[2016-11-07 08:08:01,439] INFO: Logging command: bitbake virtual/kernel -c fetchall -[2016-11-07 08:08:16,792] INFO: Logging command: bitbake virtual/kernel -[2016-11-07 08:08:18,666] INFO: Logging command: bitbake virtual/kernel -c cleansstate -[2016-11-07 08:08:35,532] INFO: Timing command: bitbake virtual/kernel -[2016-11-07 08:13:23,234] INFO: Executing test test13: Build core-image-sato with rm_work enabled -[2016-11-07 08:13:23,235] INFO: Logging command: bitbake core-image-sato -c fetchall -[2016-11-07 08:17:50,110] INFO: Timing command: bitbake -R /media/yocto_disk/poky-new-perf/build-perf-test/results-43e652f-20161107070003/test13/postfile.conf core-image-sato -[2016-11-07 09:17:51,879] INFO: Saving buildstats in JSON format -[2016-11-07 09:18:00,002] INFO: Executing test test2: Measure bitbake core-image-sato -c rootfs with sstate -[2016-11-07 09:18:00,003] INFO: Logging command: bitbake core-image-sato -c fetchall -[2016-11-07 09:18:30,318] INFO: Logging command: bitbake core-image-sato -[2016-11-07 09:19:19,315] INFO: Timing command: bitbake core-image-sato -c rootfs -[2016-11-07 09:21:42,291] INFO: Executing test test3: Parsing time metrics (bitbake -p) -[2016-11-07 09:21:42,293] INFO: Timing command: bitbake -p -[2016-11-07 09:21:58,536] INFO: Timing command: bitbake -p -[2016-11-07 09:22:09,779] INFO: Timing command: bitbake -p -[2016-11-07 09:22:11,006] INFO: Executing test test4: eSDK metrics -[2016-11-07 09:22:11,006] INFO: Logging command: bitbake core-image-sato -c fetchall -[2016-11-07 09:22:25,442] INFO: Logging command: bitbake core-image-sato -c do_populate_sdk_ext -[2016-11-07 09:46:48,144] INFO: Timing command: /media/yocto_disk/poky-new-perf/build-perf-test/build-43e652f-20161107070003/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-43e652f-20161107070003/tmp/esdk-deploy +[2016-11-07 12:00:08,506] INFO: Using Git branch:commit master:43e652f3d1fee5ce7fad67e6400315eab1b34270 (43025) +[2016-11-07 12:00:08,506] INFO: Executing test test1: Measure wall clock of bitbake core-image-sato and size of tmp dir +[2016-11-07 12:00:08,506] INFO: Logging command: bitbake core-image-sato -c fetchall +[2016-11-07 12:05:20,788] INFO: Timing command: bitbake core-image-sato +[2016-11-07 13:05:17,693] INFO: Saving buildstats in JSON format +[2016-11-07 13:08:00,429] INFO: Executing test test12: Measure bitbake virtual/kernel +[2016-11-07 13:08:00,446] INFO: Logging command: bitbake virtual/kernel -c fetchall +[2016-11-07 13:08:15,226] INFO: Logging command: bitbake virtual/kernel +[2016-11-07 13:08:17,062] INFO: Logging command: bitbake virtual/kernel -c cleansstate +[2016-11-07 13:08:31,335] INFO: Timing command: bitbake virtual/kernel +[2016-11-07 13:13:21,782] INFO: Executing test test13: Build core-image-sato with rm_work enabled +[2016-11-07 13:13:21,782] INFO: Logging command: bitbake core-image-sato -c fetchall +[2016-11-07 13:17:43,385] INFO: Timing command: bitbake -R /media/yocto_disk/poky-new-perf/build-perf-test/results-43e652f-20161107120003/test13/postfile.conf core-image-sato +[2016-11-07 14:18:04,615] INFO: Saving buildstats in JSON format +[2016-11-07 14:18:09,364] INFO: Executing test test2: Measure bitbake core-image-sato -c rootfs with sstate +[2016-11-07 14:18:09,364] INFO: Logging command: bitbake core-image-sato -c fetchall +[2016-11-07 14:18:36,974] INFO: Logging command: bitbake core-image-sato +[2016-11-07 14:19:25,963] INFO: Timing command: bitbake core-image-sato -c rootfs +[2016-11-07 14:21:44,375] INFO: Executing test test3: Parsing time metrics (bitbake -p) +[2016-11-07 14:21:44,377] INFO: Timing command: bitbake -p +[2016-11-07 14:22:00,689] INFO: Timing command: bitbake -p +[2016-11-07 14:22:11,887] INFO: Timing command: bitbake -p +[2016-11-07 14:22:13,112] INFO: Executing test test4: eSDK metrics +[2016-11-07 14:22:13,112] INFO: Logging command: bitbake core-image-sato -c fetchall +[2016-11-07 14:22:27,446] INFO: Logging command: bitbake core-image-sato -c do_populate_sdk_ext +[2016-11-07 14:46:42,841] INFO: Timing command: /media/yocto_disk/poky-new-perf/build-perf-test/build-43e652f-20161107120003/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-43e652f-20161107120003/tmp/esdk-deploy diff --git a/results.xml b/results.xml index ac780c3781..140d472225 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="ypperf02" name="oeqa.buildperf" skipped="0" tests="6" time="10201.031374" timestamp="2016-11-07T13:00:08.505413"> - <testcase classname="oeqa.buildperf.test_basic.Test1P1" description="Measure wall clock of bitbake core-image-sato and size of tmp dir" name="test1" time="4072.893229" timestamp="2016-11-07T07:00:08.505461"> + <testsuite errors="0" failures="0" hostname="ypperf02" name="oeqa.buildperf" skipped="0" tests="6" time="10194.994146" timestamp="2016-11-07T18:00:08.506396"> + <testcase classname="oeqa.buildperf.test_basic.Test1P1" description="Measure wall clock of bitbake core-image-sato and size of tmp dir" name="test1" time="4071.898746" timestamp="2016-11-07T12:00:08.506443"> <sysres legend="bitbake core-image-sato" name="build"> - <time timestamp="2016-11-07T07:05:20.338303">3613.962027</time> - <iostat cancelled_write_bytes="8945483776" rchar="248562608308" read_bytes="3819126784" syscr="98772953" syscw="53727193" wchar="69655527162" write_bytes="46105214976"/> - <rusage ru_inblock="7456416" ru_majflt="10298" ru_maxrss="916692" ru_minflt="1213219416" ru_nivcsw="23409230" ru_nvcsw="27081807" ru_oublock="90049248" ru_stime="1552.404" ru_utime="20419.192"/> + <time timestamp="2016-11-07T12:05:20.918138">3596.722118</time> + <iostat cancelled_write_bytes="8948736000" rchar="248486999246" read_bytes="3658399744" syscr="99362096" syscw="53719140" wchar="69662434960" write_bytes="45842673664"/> + <rusage ru_inblock="7142416" ru_majflt="9977" ru_maxrss="916700" ru_minflt="1211886419" ru_nivcsw="23603218" ru_nvcsw="26996873" ru_oublock="89536472" ru_stime="1556.832" ru_utime="20454.296"/> </sysres> <diskusage legend="tmpdir" name="tmpdir"> - <size>26692752</size> + <size>26693456</size> </diskusage> </testcase> - <testcase classname="oeqa.buildperf.test_basic.Test1P2" description="Measure bitbake virtual/kernel" name="test12" time="321.836007" timestamp="2016-11-07T08:08:01.398752"> + <testcase classname="oeqa.buildperf.test_basic.Test1P2" description="Measure bitbake virtual/kernel" name="test12" time="321.376439" timestamp="2016-11-07T13:08:00.405577"> <sysres legend="bitbake virtual/kernel" name="build"> - <time timestamp="2016-11-07T08:08:35.539187">287.686991</time> - <iostat cancelled_write_bytes="314212352" rchar="17511474057" read_bytes="810172416" syscr="3820570" syscw="1545732" wchar="2146554145" write_bytes="1942962176"/> - <rusage ru_inblock="1582304" ru_majflt="4997" ru_maxrss="596060" ru_minflt="55404548" ru_nivcsw="204441" ru_nvcsw="675519" ru_oublock="3794848" ru_stime="73.124" ru_utime="1344.6"/> + <time timestamp="2016-11-07T13:08:31.358332">290.422348</time> + <iostat cancelled_write_bytes="314212352" rchar="17538865753" read_bytes="811479040" syscr="3825561" syscw="1545952" wchar="2146520187" write_bytes="1942953984"/> + <rusage ru_inblock="1584824" ru_majflt="5005" ru_maxrss="594612" ru_minflt="55422668" ru_nivcsw="204386" ru_nvcsw="675850" ru_oublock="3794832" ru_stime="72.888" ru_utime="1342.58"/> </sysres> </testcase> - <testcase classname="oeqa.buildperf.test_basic.Test1P3" description="Build core-image-sato with rm_work enabled" name="test13" time="3876.754817" timestamp="2016-11-07T08:13:23.234815"> + <testcase classname="oeqa.buildperf.test_basic.Test1P3" description="Build core-image-sato with rm_work enabled" name="test13" time="3887.582342" timestamp="2016-11-07T13:13:21.782068"> <sysres legend="bitbakecore-image-sato" name="build"> - <time timestamp="2016-11-07T08:17:50.165641">3601.712758</time> - <iostat cancelled_write_bytes="11809378304" rchar="248823232039" read_bytes="2113785856" syscr="99572062" syscw="53868943" wchar="69870562445" write_bytes="45470228480"/> - <rusage ru_inblock="4128488" ru_majflt="8280" ru_maxrss="916832" ru_minflt="1208363287" ru_nivcsw="24160114" ru_nvcsw="26817311" ru_oublock="88809040" ru_stime="1607.332" ru_utime="20653.504"/> + <time timestamp="2016-11-07T13:17:43.437917">3621.175146</time> + <iostat cancelled_write_bytes="11943784448" rchar="248695250247" read_bytes="2231685120" syscr="99006192" syscw="53885719" wchar="69874488367" write_bytes="45490307072"/> + <rusage ru_inblock="4358760" ru_majflt="7861" ru_maxrss="916632" ru_minflt="1210407147" ru_nivcsw="24132761" ru_nvcsw="26774296" ru_oublock="88848256" ru_stime="1593.224" ru_utime="20610.968"/> </sysres> <diskusage legend="tmpdir" name="tmpdir"> - <size>6484964</size> + <size>6482172</size> </diskusage> </testcase> - <testcase classname="oeqa.buildperf.test_basic.Test2" description="Measure bitbake core-image-sato -c rootfs with sstate" name="test2" time="222.301262" timestamp="2016-11-07T09:17:59.989722"> + <testcase classname="oeqa.buildperf.test_basic.Test2" description="Measure bitbake core-image-sato -c rootfs with sstate" name="test2" time="215.010694" timestamp="2016-11-07T14:18:09.364470"> <sysres legend="bitbake do_rootfs" name="do_rootfs"> - <time timestamp="2016-11-07T09:19:19.361114">142.928937</time> - <iostat cancelled_write_bytes="148000768" rchar="4865423172" read_bytes="1058062336" syscr="1644791" syscw="991957" wchar="3693731520" write_bytes="1975173120"/> - <rusage ru_inblock="2066528" ru_majflt="362" ru_maxrss="191080" ru_minflt="14199476" ru_nivcsw="67697" ru_nvcsw="600649" ru_oublock="3857760" ru_stime="24.028" ru_utime="301.512"/> + <time timestamp="2016-11-07T14:19:26.007862">138.366218</time> + <iostat cancelled_write_bytes="150458368" rchar="4893503393" read_bytes="1051586560" syscr="1558740" syscw="992307" wchar="3693583898" write_bytes="1975635968"/> + <rusage ru_inblock="2053864" ru_majflt="361" ru_maxrss="190704" ru_minflt="14378208" ru_nivcsw="58009" ru_nvcsw="606682" ru_oublock="3858664" ru_stime="22.84" ru_utime="292.468"/> </sysres> </testcase> - <testcase classname="oeqa.buildperf.test_basic.Test3" description="Parsing time metrics (bitbake -p)" name="test3" time="28.715269" timestamp="2016-11-07T09:21:42.291033"> + <testcase classname="oeqa.buildperf.test_basic.Test3" description="Parsing time metrics (bitbake -p)" name="test3" time="28.737266" timestamp="2016-11-07T14:21:44.375224"> <sysres legend="bitbake -p (no caches)" name="parse_1"> - <time timestamp="2016-11-07T09:21:42.294415">16.239846</time> - <iostat cancelled_write_bytes="1052672" rchar="31324200" read_bytes="0" syscr="9611" syscw="4807" wchar="32784235" write_bytes="16875520"/> - <rusage ru_inblock="0" ru_majflt="0" ru_maxrss="113584" ru_minflt="334790" ru_nivcsw="11206" ru_nvcsw="7501" ru_oublock="32960" ru_stime="0.748" ru_utime="120.72"/> + <time timestamp="2016-11-07T14:21:44.379065">16.307312</time> + <iostat cancelled_write_bytes="1060864" rchar="31445045" read_bytes="0" syscr="9619" syscw="4813" wchar="32783159" write_bytes="16863232"/> + <rusage ru_inblock="0" ru_majflt="0" ru_maxrss="111448" ru_minflt="325121" ru_nivcsw="10198" ru_nvcsw="6876" ru_oublock="32936" ru_stime="0.844" ru_utime="121.096"/> </sysres> <sysres legend="bitbake -p (no tmp/cache)" name="parse_2"> - <time timestamp="2016-11-07T09:21:58.538435">11.239875</time> - <iostat cancelled_write_bytes="897024" rchar="31460640" read_bytes="0" syscr="9693" syscw="4799" wchar="32147478" write_bytes="16257024"/> - <rusage ru_inblock="0" ru_majflt="0" ru_maxrss="112884" ru_minflt="303877" ru_nivcsw="9341" ru_nvcsw="9423" ru_oublock="31752" ru_stime="0.6719999999999999" ru_utime="80.164"/> + <time timestamp="2016-11-07T14:22:00.690445">11.195614</time> + <iostat cancelled_write_bytes="901120" rchar="31600411" read_bytes="0" syscr="9715" syscw="4794" wchar="32085796" write_bytes="16183296"/> + <rusage ru_inblock="0" ru_majflt="0" ru_maxrss="112832" ru_minflt="303992" ru_nivcsw="8906" ru_nvcsw="8576" ru_oublock="31608" ru_stime="0.6679999999999999" ru_utime="80.856"/> </sysres> <sysres legend="bitbake -p (cached)" name="parse_3"> - <time timestamp="2016-11-07T09:22:09.780753">1.224568</time> - <iostat cancelled_write_bytes="20480" rchar="24850756" read_bytes="4096" syscr="6752" syscw="1525" wchar="776061" write_bytes="385024"/> - <rusage ru_inblock="8" ru_majflt="0" ru_maxrss="98112" ru_minflt="62859" ru_nivcsw="13" ru_nvcsw="7837" ru_oublock="752" ru_stime="0.092" ru_utime="1.188"/> + <time timestamp="2016-11-07T14:22:11.888273">1.223219</time> + <iostat cancelled_write_bytes="20480" rchar="24768385" read_bytes="0" syscr="6736" syscw="1525" wchar="776061" write_bytes="385024"/> + <rusage ru_inblock="0" ru_majflt="0" ru_maxrss="97316" ru_minflt="62853" ru_nivcsw="14" ru_nvcsw="8001" ru_oublock="752" ru_stime="0.128" ru_utime="1.156"/> </sysres> </testcase> - <testcase classname="oeqa.buildperf.test_basic.Test4" description="eSDK metrics" name="test4" time="1678.530381" timestamp="2016-11-07T09:22:11.006351"> + <testcase classname="oeqa.buildperf.test_basic.Test4" description="eSDK metrics" name="test4" time="1670.38794" timestamp="2016-11-07T14:22:13.112544"> <diskusage legend="eSDK installer" name="installer_bin"> - <size>1449663</size> + <size>1449584</size> </diskusage> <sysres legend="eSDK deploy" name="deploy"> - <time timestamp="2016-11-07T09:46:48.192455">200.962431</time> - <iostat cancelled_write_bytes="767508480" rchar="13689942085" read_bytes="125648896" syscr="3603577" syscw="6932192" wchar="12680172656" write_bytes="6296739840"/> - <rusage ru_inblock="245408" ru_majflt="319" ru_maxrss="240844" ru_minflt="19810830" ru_nivcsw="271879" ru_nvcsw="1844441" ru_oublock="12298320" ru_stime="47.344" ru_utime="519.744"/> + <time timestamp="2016-11-07T14:46:42.887294">200.23578</time> + <iostat cancelled_write_bytes="770531328" rchar="13592778444" read_bytes="136589312" syscr="3586979" syscw="6931944" wchar="12679011676" write_bytes="6298165248"/> + <rusage ru_inblock="266688" ru_majflt="319" ru_maxrss="240844" ru_minflt="20501839" ru_nivcsw="297877" ru_nvcsw="1841905" ru_oublock="12301104" ru_stime="49.084" ru_utime="520.9"/> </sysres> <diskusage legend="deploy dir" name="deploy_dir"> - <size>5356786</size> + <size>5357062</size> </diskusage> </testcase> </testsuite> |