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 f9a5d873a9..ca6c0bb17b 100644 --- a/oe-build-perf-test.log +++ b/oe-build-perf-test.log @@ -1,26 +1,26 @@ -[2016-10-31 16:00:09,513] INFO: Using Git branch:commit master:003b053498aea91fdb8c5418d0d8bbda7b23dbc0 (42888) -[2016-10-31 16:00:09,513] INFO: Executing test test1: Measure wall clock of bitbake core-image-sato and size of tmp dir -[2016-10-31 16:00:09,513] INFO: Logging command: bitbake core-image-sato -c fetchall -[2016-10-31 16:05:29,588] INFO: Timing command: bitbake core-image-sato -[2016-10-31 17:04:18,799] INFO: Saving buildstats in JSON format -[2016-10-31 17:05:48,966] INFO: Executing test test12: Measure bitbake virtual/kernel -[2016-10-31 17:05:48,966] INFO: Logging command: bitbake virtual/kernel -c fetchall -[2016-10-31 17:06:05,102] INFO: Logging command: bitbake virtual/kernel -[2016-10-31 17:06:07,288] INFO: Logging command: bitbake virtual/kernel -c cleansstate -[2016-10-31 17:06:18,929] INFO: Timing command: bitbake virtual/kernel -[2016-10-31 17:11:27,460] INFO: Executing test test13: Build core-image-sato with rm_work enabled -[2016-10-31 17:11:27,460] INFO: Logging command: bitbake core-image-sato -c fetchall -[2016-10-31 17:16:11,034] INFO: Timing command: bitbake -R /media/yocto_disk/poky-new-perf/build-perf-test/results-003b053-20161031160004/test13/postfile.conf core-image-sato -[2016-10-31 18:15:14,136] INFO: Saving buildstats in JSON format -[2016-10-31 18:15:15,705] INFO: Executing test test2: Measure bitbake core-image-sato -c rootfs with sstate -[2016-10-31 18:15:15,705] INFO: Logging command: bitbake core-image-sato -c fetchall -[2016-10-31 18:15:45,399] INFO: Logging command: bitbake core-image-sato -[2016-10-31 18:16:47,309] INFO: Timing command: bitbake core-image-sato -c rootfs -[2016-10-31 18:19:01,805] INFO: Executing test test3: Parsing time metrics (bitbake -p) -[2016-10-31 18:19:01,807] INFO: Timing command: bitbake -p -[2016-10-31 18:19:23,136] INFO: Timing command: bitbake -p -[2016-10-31 18:19:37,080] INFO: Timing command: bitbake -p -[2016-10-31 18:19:38,500] INFO: Executing test test4: eSDK metrics -[2016-10-31 18:19:38,501] INFO: Logging command: bitbake core-image-sato -c fetchall -[2016-10-31 18:19:56,552] INFO: Logging command: bitbake core-image-sato -c do_populate_sdk_ext -[2016-10-31 18:44:46,108] INFO: Timing command: /media/yocto_disk/poky-new-perf/build-perf-test/build-003b053-20161031160004/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-003b053-20161031160004/tmp/esdk-deploy +[2016-10-31 21:00:09,597] INFO: Using Git branch:commit master:003b053498aea91fdb8c5418d0d8bbda7b23dbc0 (42888) +[2016-10-31 21:00:09,597] INFO: Executing test test1: Measure wall clock of bitbake core-image-sato and size of tmp dir +[2016-10-31 21:00:09,597] INFO: Logging command: bitbake core-image-sato -c fetchall +[2016-10-31 21:05:30,825] INFO: Timing command: bitbake core-image-sato +[2016-10-31 22:04:30,576] INFO: Saving buildstats in JSON format +[2016-10-31 22:05:56,009] INFO: Executing test test12: Measure bitbake virtual/kernel +[2016-10-31 22:05:56,010] INFO: Logging command: bitbake virtual/kernel -c fetchall +[2016-10-31 22:06:11,543] INFO: Logging command: bitbake virtual/kernel +[2016-10-31 22:06:13,711] INFO: Logging command: bitbake virtual/kernel -c cleansstate +[2016-10-31 22:06:25,333] INFO: Timing command: bitbake virtual/kernel +[2016-10-31 22:11:23,201] INFO: Executing test test13: Build core-image-sato with rm_work enabled +[2016-10-31 22:11:23,202] INFO: Logging command: bitbake core-image-sato -c fetchall +[2016-10-31 22:16:03,609] INFO: Timing command: bitbake -R /media/yocto_disk/poky-new-perf/build-perf-test/results-003b053-20161031210004/test13/postfile.conf core-image-sato +[2016-10-31 23:15:06,017] INFO: Saving buildstats in JSON format +[2016-10-31 23:15:07,861] INFO: Executing test test2: Measure bitbake core-image-sato -c rootfs with sstate +[2016-10-31 23:15:07,861] INFO: Logging command: bitbake core-image-sato -c fetchall +[2016-10-31 23:15:37,818] INFO: Logging command: bitbake core-image-sato +[2016-10-31 23:16:40,325] INFO: Timing command: bitbake core-image-sato -c rootfs +[2016-10-31 23:18:49,150] INFO: Executing test test3: Parsing time metrics (bitbake -p) +[2016-10-31 23:18:49,152] INFO: Timing command: bitbake -p +[2016-10-31 23:19:10,517] INFO: Timing command: bitbake -p +[2016-10-31 23:19:24,387] INFO: Timing command: bitbake -p +[2016-10-31 23:19:25,803] INFO: Executing test test4: eSDK metrics +[2016-10-31 23:19:25,803] INFO: Logging command: bitbake core-image-sato -c fetchall +[2016-10-31 23:19:43,988] INFO: Logging command: bitbake core-image-sato -c do_populate_sdk_ext +[2016-10-31 23:43:52,899] INFO: Timing command: /media/yocto_disk/poky-new-perf/build-perf-test/build-003b053-20161031210004/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-003b053-20161031210004/tmp/esdk-deploy diff --git a/results.xml b/results.xml index b5478344b2..37369070d0 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="10065.742009" timestamp="2016-10-31T20:00:09.513353"> - <testcase classname="oeqa.buildperf.test_basic.Test1P1" description="Measure wall clock of bitbake core-image-sato and size of tmp dir" name="test1" time="3939.447009" timestamp="2016-10-31T16:00:09.513410"> + <testsuite errors="0" failures="0" hostname="ypperf01" name="oeqa.buildperf" skipped="0" tests="6" time="10014.353772" timestamp="2016-11-01T01:00:09.597270"> + <testcase classname="oeqa.buildperf.test_basic.Test1P1" description="Measure wall clock of bitbake core-image-sato and size of tmp dir" name="test1" time="3946.399393" timestamp="2016-10-31T21:00:09.597328"> <sysres legend="bitbake core-image-sato" name="build"> - <time timestamp="2016-10-31T16:05:29.695676">3529.102872</time> - <iostat cancelled_write_bytes="6435098624" rchar="248668278568" read_bytes="3659436032" syscr="94192114" syscw="54300787" wchar="69840483710" write_bytes="42364530688"/> - <rusage ru_inblock="7147336" ru_majflt="8853" ru_maxrss="917788" ru_minflt="1222457008" ru_nivcsw="30645018" ru_nvcsw="26951678" ru_oublock="82743224" ru_stime="4343.620341" ru_utime="21203.034241"/> + <time timestamp="2016-10-31T21:05:30.979803">3539.595852</time> + <iostat cancelled_write_bytes="6432321536" rchar="248703264636" read_bytes="3765313536" syscr="94294238" syscw="54316585" wchar="69844859155" write_bytes="42363392000"/> + <rusage ru_inblock="7354128" ru_majflt="8847" ru_maxrss="917800" ru_minflt="1219829457" ru_nivcsw="30213270" ru_nvcsw="27366636" ru_oublock="82741000" ru_stime="4360.325663" ru_utime="21178.675379"/> </sysres> <diskusage legend="tmpdir" name="tmpdir"> - <size>26844636</size> + <size>26845316</size> </diskusage> </testcase> - <testcase classname="oeqa.buildperf.test_basic.Test1P2" description="Measure bitbake virtual/kernel" name="test12" time="338.499379" timestamp="2016-10-31T17:05:48.960501"> + <testcase classname="oeqa.buildperf.test_basic.Test1P2" description="Measure bitbake virtual/kernel" name="test12" time="327.204725" timestamp="2016-10-31T22:05:55.996822"> <sysres legend="bitbake virtual/kernel" name="build"> - <time timestamp="2016-10-31T17:06:18.962832">308.495577</time> - <iostat cancelled_write_bytes="311013376" rchar="17640312209" read_bytes="766025728" syscr="3936276" syscw="1574077" wchar="2150645486" write_bytes="1926922240"/> - <rusage ru_inblock="1496144" ru_majflt="4690" ru_maxrss="565272" ru_minflt="58476498" ru_nivcsw="263319" ru_nvcsw="701467" ru_oublock="3763520" ru_stime="174.605381" ru_utime="1408.820557"/> + <time timestamp="2016-10-31T22:06:25.367300">297.831323</time> + <iostat cancelled_write_bytes="311021568" rchar="17599987814" read_bytes="765407232" syscr="3929107" syscw="1574326" wchar="2150634266" write_bytes="1926901760"/> + <rusage ru_inblock="1494936" ru_majflt="4738" ru_maxrss="565744" ru_minflt="58493996" ru_nivcsw="261910" ru_nvcsw="700326" ru_oublock="3763480" ru_stime="169.667062" ru_utime="1404.595552"/> </sysres> </testcase> - <testcase classname="oeqa.buildperf.test_basic.Test1P3" description="Build core-image-sato with rm_work enabled" name="test13" time="3828.245376" timestamp="2016-10-31T17:11:27.459952"> + <testcase classname="oeqa.buildperf.test_basic.Test1P3" description="Build core-image-sato with rm_work enabled" name="test13" time="3824.659573" timestamp="2016-10-31T22:11:23.201716"> <sysres legend="bitbakecore-image-sato" name="build"> - <time timestamp="2016-10-31T17:16:11.082056">3543.053539</time> - <iostat cancelled_write_bytes="9586794496" rchar="248957421430" read_bytes="2019610624" syscr="95717699" syscw="54446440" wchar="70058025666" write_bytes="42384076800"/> - <rusage ru_inblock="3944552" ru_majflt="7835" ru_maxrss="917624" ru_minflt="1224315589" ru_nivcsw="31619184" ru_nvcsw="26598509" ru_oublock="82781400" ru_stime="4401.915554" ru_utime="21435.763696"/> + <time timestamp="2016-10-31T22:16:03.667303">3542.349214</time> + <iostat cancelled_write_bytes="9310978048" rchar="248935854079" read_bytes="2114199552" syscr="95047617" syscw="54420778" wchar="70052084908" write_bytes="42388312064"/> + <rusage ru_inblock="4129296" ru_majflt="7867" ru_maxrss="917652" ru_minflt="1224815749" ru_nivcsw="31744105" ru_nvcsw="26494918" ru_oublock="82789672" ru_stime="4406.382928" ru_utime="21392.873585"/> </sysres> <diskusage legend="tmpdir" name="tmpdir"> - <size>6478232</size> + <size>6480708</size> </diskusage> </testcase> - <testcase classname="oeqa.buildperf.test_basic.Test2" description="Measure bitbake core-image-sato -c rootfs with sstate" name="test2" time="226.099398" timestamp="2016-10-31T18:15:15.705399"> + <testcase classname="oeqa.buildperf.test_basic.Test2" description="Measure bitbake core-image-sato -c rootfs with sstate" name="test2" time="221.288707" timestamp="2016-10-31T23:15:07.861366"> <sysres legend="bitbake do_rootfs" name="do_rootfs"> - <time timestamp="2016-10-31T18:16:47.341527">134.46185</time> - <iostat cancelled_write_bytes="149970944" rchar="4915118249" read_bytes="1100734464" syscr="1630991" syscw="1008339" wchar="3722531050" write_bytes="1989558272"/> - <rusage ru_inblock="2149872" ru_majflt="382" ru_maxrss="182168" ru_minflt="15071387" ru_nivcsw="100372" ru_nvcsw="595782" ru_oublock="3885856" ru_stime="64.260055" ru_utime="414.854227"/> + <time timestamp="2016-10-31T23:16:40.377058">128.771502</time> + <iostat cancelled_write_bytes="145625088" rchar="4917151762" read_bytes="1100947456" syscr="1634060" syscw="1008571" wchar="3721784765" write_bytes="1989804032"/> + <rusage ru_inblock="2150288" ru_majflt="387" ru_maxrss="187484" ru_minflt="14802496" ru_nivcsw="93737" ru_nvcsw="604860" ru_oublock="3886336" ru_stime="59.374271" ru_utime="411.986154"/> </sysres> </testcase> - <testcase classname="oeqa.buildperf.test_basic.Test3" description="Parsing time metrics (bitbake -p)" name="test3" time="36.695859" timestamp="2016-10-31T18:19:01.804871"> + <testcase classname="oeqa.buildperf.test_basic.Test3" description="Parsing time metrics (bitbake -p)" name="test3" time="36.652727" timestamp="2016-10-31T23:18:49.150156"> <sysres legend="bitbake -p (no caches)" name="parse_1"> - <time timestamp="2016-10-31T18:19:01.809314">21.323034</time> - <iostat cancelled_write_bytes="1040384" rchar="27431930" read_bytes="0" syscr="8954" syscw="4819" wchar="32656496" write_bytes="16818176"/> - <rusage ru_inblock="0" ru_majflt="0" ru_maxrss="110720" ru_minflt="318365" ru_nivcsw="8530" ru_nvcsw="6255" ru_oublock="32848" ru_stime="0.960592" ru_utime="160.14197"/> + <time timestamp="2016-10-31T23:18:49.154714">21.358679</time> + <iostat cancelled_write_bytes="1044480" rchar="27406750" read_bytes="0" syscr="8938" syscw="4810" wchar="32678391" write_bytes="16842752"/> + <rusage ru_inblock="0" ru_majflt="0" ru_maxrss="111972" ru_minflt="319502" ru_nivcsw="8068" ru_nvcsw="6262" ru_oublock="32896" ru_stime="0.957649" ru_utime="160.969348"/> </sysres> <sysres legend="bitbake -p (no tmp/cache)" name="parse_2"> - <time timestamp="2016-10-31T18:19:23.137973">13.9414</time> - <iostat cancelled_write_bytes="897024" rchar="27387632" read_bytes="0" syscr="9015" syscw="4824" wchar="32101294" write_bytes="16257024"/> - <rusage ru_inblock="0" ru_majflt="0" ru_maxrss="111124" ru_minflt="292514" ru_nivcsw="7612" ru_nvcsw="6350" ru_oublock="31752" ru_stime="0.929252" ru_utime="101.743614"/> + <time timestamp="2016-10-31T23:19:10.519043">13.867405</time> + <iostat cancelled_write_bytes="892928" rchar="27257091" read_bytes="0" syscr="8967" syscw="4833" wchar="32071143" write_bytes="16236544"/> + <rusage ru_inblock="0" ru_majflt="0" ru_maxrss="112732" ru_minflt="292299" ru_nivcsw="7637" ru_nvcsw="6231" ru_oublock="31712" ru_stime="0.978737" ru_utime="101.086169"/> </sysres> <sysres legend="bitbake -p (cached)" name="parse_3"> - <time timestamp="2016-10-31T18:19:37.082628">1.416748</time> - <iostat cancelled_write_bytes="12288" rchar="20789687" read_bytes="0" syscr="6086" syscw="1530" wchar="744489" write_bytes="385024"/> - <rusage ru_inblock="0" ru_majflt="0" ru_maxrss="95288" ru_minflt="50409" ru_nivcsw="6" ru_nvcsw="7894" ru_oublock="752" ru_stime="0.12196699999999999" ru_utime="1.3975170000000001"/> + <time timestamp="2016-10-31T23:19:24.389735">1.411791</time> + <iostat cancelled_write_bytes="12288" rchar="20771155" read_bytes="0" syscr="6123" syscw="1529" wchar="744365" write_bytes="385024"/> + <rusage ru_inblock="0" ru_majflt="0" ru_maxrss="95244" ru_minflt="50410" ru_nivcsw="13" ru_nvcsw="7796" ru_oublock="752" ru_stime="0.135466" ru_utime="1.378446"/> </sysres> </testcase> - <testcase classname="oeqa.buildperf.test_basic.Test4" description="eSDK metrics" name="test4" time="1696.754504" timestamp="2016-10-31T18:19:38.500797"> + <testcase classname="oeqa.buildperf.test_basic.Test4" description="eSDK metrics" name="test4" time="1658.148033" timestamp="2016-10-31T23:19:25.802948"> <diskusage legend="eSDK installer" name="installer_bin"> - <size>1457311</size> + <size>1456974</size> </diskusage> <sysres legend="eSDK deploy" name="deploy"> - <time timestamp="2016-10-31T18:44:46.137711">188.700267</time> - <iostat cancelled_write_bytes="749268992" rchar="13680384248" read_bytes="147390464" syscr="3619119" syscw="6967152" wchar="12673513167" write_bytes="6279155712"/> - <rusage ru_inblock="287872" ru_majflt="304" ru_maxrss="236704" ru_minflt="20705115" ru_nivcsw="382938" ru_nvcsw="1913720" ru_oublock="12263976" ru_stime="99.988089" ru_utime="554.165798"/> + <time timestamp="2016-10-31T23:43:52.931601">190.601077</time> + <iostat cancelled_write_bytes="751726592" rchar="13809000697" read_bytes="145354752" syscr="3612911" syscw="6966991" wchar="12673725656" write_bytes="6280318976"/> + <rusage ru_inblock="283896" ru_majflt="303" ru_maxrss="243440" ru_minflt="20567170" ru_nivcsw="385282" ru_nvcsw="1909412" ru_oublock="12266248" ru_stime="100.344095" ru_utime="553.539964"/> </sysres> <diskusage legend="deploy dir" name="deploy_dir"> - <size>5359165</size> + <size>5359748</size> </diskusage> </testcase> </testsuite> |