diff options
| -rw-r--r-- | oe-build-perf-test.log | 54 | ||||
| -rw-r--r-- | results.xml | 70 |
2 files changed, 62 insertions, 62 deletions
diff --git a/oe-build-perf-test.log b/oe-build-perf-test.log index 2d79828d2d..b91bc29aa8 100644 --- a/oe-build-perf-test.log +++ b/oe-build-perf-test.log @@ -1,27 +1,27 @@ -[2017-01-02 15:05:11,241] INFO: Using Git branch:commit master:dbb247cac5fbf7b037e4955f9793828451723924 (43626) -[2017-01-02 15:05:11,242] INFO: Executing test test1: Measure wall clock of bitbake core-image-sato and size of tmp dir -[2017-01-02 15:05:11,242] INFO: Logging command: bitbake core-image-sato -c fetchall -[2017-01-02 15:10:30,683] INFO: Timing command: bitbake core-image-sato -[2017-01-02 16:28:29,785] INFO: Saving buildstats in JSON format -[2017-01-02 16:39:44,980] INFO: Executing test test12: Measure bitbake virtual/kernel -[2017-01-02 16:39:44,999] INFO: Logging command: bitbake virtual/kernel -c fetchall -[2017-01-02 16:40:03,790] INFO: Logging command: bitbake virtual/kernel -[2017-01-02 16:40:06,921] INFO: Logging command: bitbake virtual/kernel -c cleansstate -[2017-01-02 16:40:34,418] INFO: Timing command: bitbake virtual/kernel -[2017-01-02 16:46:49,384] INFO: Executing test test13: Build core-image-sato with rm_work enabled -[2017-01-02 16:46:49,384] INFO: Logging command: bitbake core-image-sato -c fetchall -[2017-01-02 17:05:02,345] INFO: Timing command: bitbake -R /home/yocto/poky-perf/build-perf-test/results-dbb247c-20170102150505/test13/postfile.conf core-image-sato -[2017-01-02 18:17:27,207] INFO: Saving buildstats in JSON format -[2017-01-02 18:20:26,764] INFO: Executing test test2: Measure bitbake core-image-sato -c rootfs with sstate -[2017-01-02 18:20:26,764] INFO: Logging command: bitbake core-image-sato -c fetchall -[2017-01-02 18:21:04,754] INFO: Logging command: bitbake core-image-sato -[2017-01-02 18:22:24,815] INFO: Timing command: bitbake core-image-sato -c rootfs -[2017-01-02 18:25:24,990] INFO: Executing test test3: Parsing time metrics (bitbake -p) -[2017-01-02 18:25:25,026] INFO: Timing command: bitbake -p -[2017-01-02 18:25:49,604] INFO: Timing command: bitbake -p -[2017-01-02 18:26:05,407] INFO: Timing command: bitbake -p -[2017-01-02 18:26:06,811] INFO: Executing test test4: eSDK metrics -[2017-01-02 18:26:06,811] INFO: Logging command: bitbake core-image-sato -c fetchall -[2017-01-02 18:26:27,619] INFO: Logging command: bitbake core-image-sato -c do_populate_sdk_ext -[2017-01-02 18:55:38,521] INFO: Timing command: /home/yocto/poky-perf/build-perf-test/build-dbb247c-20170102150505/tmp/deploy/sdk/poky-glibc-x86_64-core-image-sato-i586-toolchain-ext-2.2.sh -y -d /home/yocto/poky-perf/build-perf-test/build-dbb247c-20170102150505/tmp/esdk-deploy -[2017-01-02 18:58:32,887] INFO: Committing test results into /home/yocto/perf-results/results.git ypperf-fedora22/master/qemux86 +[2017-01-02 20:05:11,012] INFO: Using Git branch:commit master:dbb247cac5fbf7b037e4955f9793828451723924 (43626) +[2017-01-02 20:05:11,013] INFO: Executing test test1: Measure wall clock of bitbake core-image-sato and size of tmp dir +[2017-01-02 20:05:11,013] INFO: Logging command: bitbake core-image-sato -c fetchall +[2017-01-02 20:10:31,443] INFO: Timing command: bitbake core-image-sato +[2017-01-02 21:28:27,358] INFO: Saving buildstats in JSON format +[2017-01-02 21:39:24,778] INFO: Executing test test12: Measure bitbake virtual/kernel +[2017-01-02 21:39:24,793] INFO: Logging command: bitbake virtual/kernel -c fetchall +[2017-01-02 21:39:43,929] INFO: Logging command: bitbake virtual/kernel +[2017-01-02 21:39:47,077] INFO: Logging command: bitbake virtual/kernel -c cleansstate +[2017-01-02 21:40:23,233] INFO: Timing command: bitbake virtual/kernel +[2017-01-02 21:46:53,871] INFO: Executing test test13: Build core-image-sato with rm_work enabled +[2017-01-02 21:46:53,872] INFO: Logging command: bitbake core-image-sato -c fetchall +[2017-01-02 22:05:36,472] INFO: Timing command: bitbake -R /home/yocto/poky-perf/build-perf-test/results-dbb247c-20170102200505/test13/postfile.conf core-image-sato +[2017-01-02 23:17:16,444] INFO: Saving buildstats in JSON format +[2017-01-02 23:20:21,878] INFO: Executing test test2: Measure bitbake core-image-sato -c rootfs with sstate +[2017-01-02 23:20:21,879] INFO: Logging command: bitbake core-image-sato -c fetchall +[2017-01-02 23:21:00,224] INFO: Logging command: bitbake core-image-sato +[2017-01-02 23:22:18,492] INFO: Timing command: bitbake core-image-sato -c rootfs +[2017-01-02 23:24:55,064] INFO: Executing test test3: Parsing time metrics (bitbake -p) +[2017-01-02 23:24:55,087] INFO: Timing command: bitbake -p +[2017-01-02 23:25:19,324] INFO: Timing command: bitbake -p +[2017-01-02 23:25:35,113] INFO: Timing command: bitbake -p +[2017-01-02 23:25:36,566] INFO: Executing test test4: eSDK metrics +[2017-01-02 23:25:36,567] INFO: Logging command: bitbake core-image-sato -c fetchall +[2017-01-02 23:25:56,246] INFO: Logging command: bitbake core-image-sato -c do_populate_sdk_ext +[2017-01-02 23:55:28,079] INFO: Timing command: /home/yocto/poky-perf/build-perf-test/build-dbb247c-20170102200505/tmp/deploy/sdk/poky-glibc-x86_64-core-image-sato-i586-toolchain-ext-2.2.sh -y -d /home/yocto/poky-perf/build-perf-test/build-dbb247c-20170102200505/tmp/esdk-deploy +[2017-01-02 23:58:24,903] INFO: Committing test results into /home/yocto/perf-results/results.git ypperf-fedora22/master/qemux86 diff --git a/results.xml b/results.xml index 90d606c0ee..decc289ce0 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="ypperf-fedora22" name="oeqa.buildperf" skipped="0" tests="6" time="14000.082219" timestamp="2017-01-02T13:05:11.242108"> - <testcase classname="oeqa.buildperf.test_basic.Test1P1" description="Measure wall clock of bitbake core-image-sato and size of tmp dir" name="test1" time="5673.720265" timestamp="2017-01-02T15:05:11.242167"> + <testsuite errors="0" failures="0" hostname="ypperf-fedora22" name="oeqa.buildperf" skipped="0" tests="6" time="13992.442247" timestamp="2017-01-02T18:05:11.012936"> + <testcase classname="oeqa.buildperf.test_basic.Test1P1" description="Measure wall clock of bitbake core-image-sato and size of tmp dir" name="test1" time="5653.717382" timestamp="2017-01-02T20:05:11.013000"> <sysres legend="bitbake core-image-sato" name="build"> - <time timestamp="2017-01-02T15:10:30.938226">4677.781288</time> - <iostat cancelled_write_bytes="6624129024" rchar="252157013838" read_bytes="8390197248" syscr="90750646" syscw="55070264" wchar="70798228075" write_bytes="42899140608"/> - <rusage ru_inblock="16382536" ru_majflt="95901" ru_maxrss="917872" ru_minflt="1235123729" ru_nivcsw="29339486" ru_nvcsw="31097981" ru_oublock="83787384" ru_stime="4912.353055" ru_utime="24394.429669"/> + <time timestamp="2017-01-02T20:10:31.720582">4675.322021</time> + <iostat cancelled_write_bytes="6416609280" rchar="252140737116" read_bytes="8566521856" syscr="90679556" syscw="55093930" wchar="70798582700" write_bytes="42899099648"/> + <rusage ru_inblock="16727008" ru_majflt="96982" ru_maxrss="917784" ru_minflt="1239540393" ru_nivcsw="29014358" ru_nvcsw="31970304" ru_oublock="83787304" ru_stime="4850.601747" ru_utime="24320.831794"/> </sysres> <diskusage legend="tmpdir" name="tmpdir"> - <size>27053612</size> + <size>27052048</size> </diskusage> </testcase> - <testcase classname="oeqa.buildperf.test_basic.Test1P2" description="Measure bitbake virtual/kernel" name="test12" time="424.421353" timestamp="2017-01-02T16:39:44.962534"> + <testcase classname="oeqa.buildperf.test_basic.Test1P2" description="Measure bitbake virtual/kernel" name="test12" time="449.117032" timestamp="2017-01-02T21:39:24.754688"> <sysres legend="bitbake virtual/kernel" name="build"> - <time timestamp="2017-01-02T16:40:34.565747">374.816777</time> - <iostat cancelled_write_bytes="297304064" rchar="17605377063" read_bytes="867995648" syscr="4085102" syscw="1565802" wchar="2118738580" write_bytes="1898823680"/> - <rusage ru_inblock="1695216" ru_majflt="5038" ru_maxrss="599524" ru_minflt="58424162" ru_nivcsw="280462" ru_nvcsw="722561" ru_oublock="3708640" ru_stime="167.128705" ru_utime="1567.533914"/> + <time timestamp="2017-01-02T21:40:23.364690">390.505832</time> + <iostat cancelled_write_bytes="297304064" rchar="17598552871" read_bytes="875012096" syscr="4081481" syscw="1565925" wchar="2118748500" write_bytes="1898848256"/> + <rusage ru_inblock="1708944" ru_majflt="5040" ru_maxrss="598820" ru_minflt="58455589" ru_nivcsw="282363" ru_nvcsw="722505" ru_oublock="3708688" ru_stime="166.928105" ru_utime="1564.68483"/> </sysres> </testcase> - <testcase classname="oeqa.buildperf.test_basic.Test1P3" description="Build core-image-sato with rm_work enabled" name="test13" time="5617.364749" timestamp="2017-01-02T16:46:49.383961"> + <testcase classname="oeqa.buildperf.test_basic.Test1P3" description="Build core-image-sato with rm_work enabled" name="test13" time="5607.991396" timestamp="2017-01-02T21:46:53.871784"> <sysres legend="bitbakecore-image-sato" name="build"> - <time timestamp="2017-01-02T17:05:02.396702">4344.650268</time> - <iostat cancelled_write_bytes="9207779328" rchar="252463491022" read_bytes="5366620160" syscr="92352618" syscw="55274539" wchar="71004036240" write_bytes="42916880384"/> - <rusage ru_inblock="10478648" ru_majflt="12903" ru_maxrss="917820" ru_minflt="1243242344" ru_nivcsw="33366825" ru_nvcsw="25905476" ru_oublock="83822032" ru_stime="5070.390985" ru_utime="25119.327257"/> + <time timestamp="2017-01-02T22:05:36.597872">4299.77534</time> + <iostat cancelled_write_bytes="9220038656" rchar="252411593588" read_bytes="5441011712" syscr="92221166" syscw="55222103" wchar="70999875001" write_bytes="42921558016"/> + <rusage ru_inblock="10624184" ru_majflt="12410" ru_maxrss="917880" ru_minflt="1241803956" ru_nivcsw="33167305" ru_nvcsw="26242831" ru_oublock="83831168" ru_stime="5061.533795" ru_utime="25138.494785"/> </sysres> <diskusage legend="tmpdir" name="tmpdir"> - <size>6607924</size> + <size>6608384</size> </diskusage> </testcase> - <testcase classname="oeqa.buildperf.test_basic.Test2" description="Measure bitbake core-image-sato -c rootfs with sstate" name="test2" time="298.241111" timestamp="2017-01-02T18:20:26.748790"> + <testcase classname="oeqa.buildperf.test_basic.Test2" description="Measure bitbake core-image-sato -c rootfs with sstate" name="test2" time="273.200507" timestamp="2017-01-02T23:20:21.863333"> <sysres legend="bitbake do_rootfs" name="do_rootfs"> - <time timestamp="2017-01-02T18:22:24.945801">180.042746</time> - <iostat cancelled_write_bytes="158674944" rchar="5098487536" read_bytes="1120591872" syscr="1610685" syscw="1041117" wchar="3871033166" write_bytes="2076553216"/> - <rusage ru_inblock="2188584" ru_majflt="399" ru_maxrss="173928" ru_minflt="15705665" ru_nivcsw="116172" ru_nvcsw="695862" ru_oublock="4055768" ru_stime="64.578399" ru_utime="446.242918"/> + <time timestamp="2017-01-02T23:22:18.536035">156.52646</time> + <iostat cancelled_write_bytes="154755072" rchar="5203654500" read_bytes="1094389760" syscr="1583078" syscw="1040329" wchar="3868418419" write_bytes="2075865088"/> + <rusage ru_inblock="2137424" ru_majflt="406" ru_maxrss="173912" ru_minflt="15666088" ru_nivcsw="117540" ru_nvcsw="697132" ru_oublock="4054424" ru_stime="64.77748" ru_utime="446.029487"/> </sysres> </testcase> - <testcase classname="oeqa.buildperf.test_basic.Test3" description="Parsing time metrics (bitbake -p)" name="test3" time="41.820872" timestamp="2017-01-02T18:25:24.989972"> + <testcase classname="oeqa.buildperf.test_basic.Test3" description="Parsing time metrics (bitbake -p)" name="test3" time="41.50287" timestamp="2017-01-02T23:24:55.063915"> <sysres legend="bitbake -p (no caches)" name="parse_1"> - <time timestamp="2017-01-02T18:25:25.028117">24.573461</time> - <iostat cancelled_write_bytes="1056768" rchar="26719714" read_bytes="0" syscr="9023" syscw="4727" wchar="30787860" write_bytes="15958016"/> - <rusage ru_inblock="0" ru_majflt="0" ru_maxrss="111828" ru_minflt="308557" ru_nivcsw="8021" ru_nvcsw="6280" ru_oublock="31168" ru_stime="0.97115" ru_utime="186.550242"/> + <time timestamp="2017-01-02T23:24:55.088754">24.231744</time> + <iostat cancelled_write_bytes="1060864" rchar="26739812" read_bytes="0" syscr="9041" syscw="4733" wchar="30716798" write_bytes="15896576"/> + <rusage ru_inblock="0" ru_majflt="0" ru_maxrss="108760" ru_minflt="319108" ru_nivcsw="8200" ru_nvcsw="6311" ru_oublock="31048" ru_stime="1.004683" ru_utime="184.213594"/> </sysres> <sysres legend="bitbake -p (no tmp/cache)" name="parse_2"> - <time timestamp="2017-01-02T18:25:49.606551">15.79995</time> - <iostat cancelled_write_bytes="892928" rchar="26676345" read_bytes="0" syscr="9099" syscw="4721" wchar="30110145" write_bytes="15282176"/> - <rusage ru_inblock="0" ru_majflt="0" ru_maxrss="113776" ru_minflt="287620" ru_nivcsw="7485" ru_nvcsw="6324" ru_oublock="29848" ru_stime="0.935568" ru_utime="116.659103"/> + <time timestamp="2017-01-02T23:25:19.325675">15.786902</time> + <iostat cancelled_write_bytes="897024" rchar="26580677" read_bytes="0" syscr="9060" syscw="4718" wchar="30084946" write_bytes="15269888"/> + <rusage ru_inblock="0" ru_majflt="0" ru_maxrss="113164" ru_minflt="294102" ru_nivcsw="7527" ru_nvcsw="6258" ru_oublock="29824" ru_stime="0.944986" ru_utime="116.92579"/> </sysres> <sysres legend="bitbake -p (cached)" name="parse_3"> - <time timestamp="2017-01-02T18:26:05.409162">1.400335</time> - <iostat cancelled_write_bytes="12288" rchar="19787006" read_bytes="0" syscr="6101" syscw="1498" wchar="641186" write_bytes="356352"/> - <rusage ru_inblock="0" ru_majflt="0" ru_maxrss="94048" ru_minflt="48739" ru_nivcsw="15" ru_nvcsw="8142" ru_oublock="696" ru_stime="0.127457" ru_utime="1.373951"/> + <time timestamp="2017-01-02T23:25:35.115551">1.449971</time> + <iostat cancelled_write_bytes="12288" rchar="19774478" read_bytes="0" syscr="6088" syscw="1498" wchar="641272" write_bytes="356352"/> + <rusage ru_inblock="0" ru_majflt="0" ru_maxrss="94988" ru_minflt="47880" ru_nivcsw="15" ru_nvcsw="9127" ru_oublock="696" ru_stime="0.123748" ru_utime="1.432414"/> </sysres> </testcase> - <testcase classname="oeqa.buildperf.test_basic.Test4" description="eSDK metrics" name="test4" time="1944.491357" timestamp="2017-01-02T18:26:06.810911"> + <testcase classname="oeqa.buildperf.test_basic.Test4" description="eSDK metrics" name="test4" time="1966.844178" timestamp="2017-01-02T23:25:36.566853"> <diskusage legend="eSDK installer" name="installer_bin"> - <size>1511925</size> + <size>1512189</size> </diskusage> <sysres legend="eSDK deploy" name="deploy"> - <time timestamp="2017-01-02T18:55:38.748801">172.017205</time> - <iostat cancelled_write_bytes="424804352" rchar="11064722127" read_bytes="1615704064" syscr="2383960" syscw="5897008" wchar="12126880227" write_bytes="5775974400"/> - <rusage ru_inblock="3155296" ru_majflt="292" ru_maxrss="221032" ru_minflt="18411485" ru_nivcsw="385153" ru_nvcsw="1091034" ru_oublock="11281200" ru_stime="87.932627" ru_utime="551.692917"/> + <time timestamp="2017-01-02T23:55:28.348450">174.566837</time> + <iostat cancelled_write_bytes="424710144" rchar="11065389241" read_bytes="1614626816" syscr="2350375" syscw="5897714" wchar="12127460560" write_bytes="5777199104"/> + <rusage ru_inblock="3153368" ru_majflt="290" ru_maxrss="224692" ru_minflt="18421076" ru_nivcsw="387367" ru_nvcsw="1079268" ru_oublock="11283592" ru_stime="87.813773" ru_utime="551.345878"/> </sysres> <diskusage legend="deploy dir" name="deploy_dir"> - <size>5002099</size> + <size>5002159</size> </diskusage> </testcase> </testsuite> |