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 54a4e62e26..564df718a3 100644 --- a/oe-build-perf-test.log +++ b/oe-build-perf-test.log @@ -1,26 +1,26 @@ -[2016-11-19 21:00:09,515] INFO: Using Git branch:commit master:7c3a47ed8965c3a3eb90a9a4678d5caedbba6337 (43091) -[2016-11-19 21:00:09,515] INFO: Executing test test1: Measure wall clock of bitbake core-image-sato and size of tmp dir -[2016-11-19 21:00:09,515] INFO: Logging command: bitbake core-image-sato -c fetchall -[2016-11-19 21:05:29,063] INFO: Timing command: bitbake core-image-sato -[2016-11-19 22:06:26,396] INFO: Saving buildstats in JSON format -[2016-11-19 22:07:54,399] INFO: Executing test test12: Measure bitbake virtual/kernel -[2016-11-19 22:07:54,399] INFO: Logging command: bitbake virtual/kernel -c fetchall -[2016-11-19 22:08:10,480] INFO: Logging command: bitbake virtual/kernel -[2016-11-19 22:08:12,608] INFO: Logging command: bitbake virtual/kernel -c cleansstate -[2016-11-19 22:08:24,653] INFO: Timing command: bitbake virtual/kernel -[2016-11-19 22:13:38,497] INFO: Executing test test13: Build core-image-sato with rm_work enabled -[2016-11-19 22:13:38,498] INFO: Logging command: bitbake core-image-sato -c fetchall -[2016-11-19 22:18:24,633] INFO: Timing command: bitbake -R /media/yocto_disk/poky-new-perf/build-perf-test/results-7c3a47e-20161119210004/test13/postfile.conf core-image-sato -[2016-11-19 23:17:50,545] INFO: Saving buildstats in JSON format -[2016-11-19 23:18:01,230] INFO: Executing test test2: Measure bitbake core-image-sato -c rootfs with sstate -[2016-11-19 23:18:01,230] INFO: Logging command: bitbake core-image-sato -c fetchall -[2016-11-19 23:18:31,850] INFO: Logging command: bitbake core-image-sato -[2016-11-19 23:19:35,487] INFO: Timing command: bitbake core-image-sato -c rootfs -[2016-11-19 23:21:51,563] INFO: Executing test test3: Parsing time metrics (bitbake -p) -[2016-11-19 23:21:51,566] INFO: Timing command: bitbake -p -[2016-11-19 23:22:12,875] INFO: Timing command: bitbake -p -[2016-11-19 23:22:26,896] INFO: Timing command: bitbake -p -[2016-11-19 23:22:28,296] INFO: Executing test test4: eSDK metrics -[2016-11-19 23:22:28,296] INFO: Logging command: bitbake core-image-sato -c fetchall -[2016-11-19 23:22:46,368] INFO: Logging command: bitbake core-image-sato -c do_populate_sdk_ext -[2016-11-19 23:47:10,959] INFO: Timing command: /media/yocto_disk/poky-new-perf/build-perf-test/build-7c3a47e-20161119210004/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-7c3a47e-20161119210004/tmp/esdk-deploy +[2016-11-20 01:00:09,296] INFO: Using Git branch:commit master:7c3a47ed8965c3a3eb90a9a4678d5caedbba6337 (43091) +[2016-11-20 01:00:09,296] INFO: Executing test test1: Measure wall clock of bitbake core-image-sato and size of tmp dir +[2016-11-20 01:00:09,297] INFO: Logging command: bitbake core-image-sato -c fetchall +[2016-11-20 01:05:31,558] INFO: Timing command: bitbake core-image-sato +[2016-11-20 02:06:24,000] INFO: Saving buildstats in JSON format +[2016-11-20 02:07:56,290] INFO: Executing test test12: Measure bitbake virtual/kernel +[2016-11-20 02:07:56,290] INFO: Logging command: bitbake virtual/kernel -c fetchall +[2016-11-20 02:08:12,103] INFO: Logging command: bitbake virtual/kernel +[2016-11-20 02:08:14,298] INFO: Logging command: bitbake virtual/kernel -c cleansstate +[2016-11-20 02:08:26,745] INFO: Timing command: bitbake virtual/kernel +[2016-11-20 02:13:38,108] INFO: Executing test test13: Build core-image-sato with rm_work enabled +[2016-11-20 02:13:38,108] INFO: Logging command: bitbake core-image-sato -c fetchall +[2016-11-20 02:18:15,632] INFO: Timing command: bitbake -R /media/yocto_disk/poky-new-perf/build-perf-test/results-7c3a47e-20161120010003/test13/postfile.conf core-image-sato +[2016-11-20 03:17:46,336] INFO: Saving buildstats in JSON format +[2016-11-20 03:17:55,680] INFO: Executing test test2: Measure bitbake core-image-sato -c rootfs with sstate +[2016-11-20 03:17:55,680] INFO: Logging command: bitbake core-image-sato -c fetchall +[2016-11-20 03:18:25,483] INFO: Logging command: bitbake core-image-sato +[2016-11-20 03:19:33,713] INFO: Timing command: bitbake core-image-sato -c rootfs +[2016-11-20 03:21:53,196] INFO: Executing test test3: Parsing time metrics (bitbake -p) +[2016-11-20 03:21:53,198] INFO: Timing command: bitbake -p +[2016-11-20 03:22:14,641] INFO: Timing command: bitbake -p +[2016-11-20 03:22:28,474] INFO: Timing command: bitbake -p +[2016-11-20 03:22:29,862] INFO: Executing test test4: eSDK metrics +[2016-11-20 03:22:29,862] INFO: Logging command: bitbake core-image-sato -c fetchall +[2016-11-20 03:22:47,916] INFO: Logging command: bitbake core-image-sato -c do_populate_sdk_ext +[2016-11-20 03:47:16,090] INFO: Timing command: /media/yocto_disk/poky-new-perf/build-perf-test/build-7c3a47e-20161120010003/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-7c3a47e-20161120010003/tmp/esdk-deploy diff --git a/results.xml b/results.xml index bc5148d5de..9fbe698122 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="10219.389355" timestamp="2016-11-20T02:00:09.515243"> - <testcase classname="oeqa.buildperf.test_basic.Test1P1" description="Measure wall clock of bitbake core-image-sato and size of tmp dir" name="test1" time="4064.881129" timestamp="2016-11-19T21:00:09.515301"> + <testsuite errors="0" failures="0" hostname="ypperf01" name="oeqa.buildperf" skipped="0" tests="6" time="10224.810979" timestamp="2016-11-20T06:00:09.296765"> + <testcase classname="oeqa.buildperf.test_basic.Test1P1" description="Measure wall clock of bitbake core-image-sato and size of tmp dir" name="test1" time="4066.990688" timestamp="2016-11-20T01:00:09.296822"> <sysres legend="bitbake core-image-sato" name="build"> - <time timestamp="2016-11-19T21:05:29.206345">3657.189312</time> - <iostat cancelled_write_bytes="6563381248" rchar="249401063890" read_bytes="4825255936" syscr="95486146" syscw="53927017" wchar="69669321706" write_bytes="42297888768"/> - <rusage ru_inblock="9424328" ru_majflt="15013" ru_maxrss="917612" ru_minflt="1230867041" ru_nivcsw="30143226" ru_nvcsw="27795664" ru_oublock="82613064" ru_stime="3639.816699" ru_utime="22008.180969"/> + <time timestamp="2016-11-20T01:05:31.722527">3652.276826</time> + <iostat cancelled_write_bytes="6523854848" rchar="249288043641" read_bytes="4812226560" syscr="94964199" syscw="53884451" wchar="69659098068" write_bytes="42293497856"/> + <rusage ru_inblock="9398880" ru_majflt="14820" ru_maxrss="917824" ru_minflt="1227341783" ru_nivcsw="29727852" ru_nvcsw="27869158" ru_oublock="82604488" ru_stime="3641.32567" ru_utime="21988.013081"/> </sysres> <diskusage legend="tmpdir" name="tmpdir"> - <size>26679660</size> + <size>26679348</size> </diskusage> </testcase> - <testcase classname="oeqa.buildperf.test_basic.Test1P2" description="Measure bitbake virtual/kernel" name="test12" time="344.101036" timestamp="2016-11-19T22:07:54.396529"> + <testcase classname="oeqa.buildperf.test_basic.Test1P2" description="Measure bitbake virtual/kernel" name="test12" time="341.820234" timestamp="2016-11-20T02:07:56.287606"> <sysres legend="bitbake virtual/kernel" name="build"> - <time timestamp="2016-11-19T22:08:24.676738">313.819398</time> - <iostat cancelled_write_bytes="311025664" rchar="17676681706" read_bytes="813166592" syscr="3939343" syscw="1574082" wchar="2150903940" write_bytes="1927041024"/> - <rusage ru_inblock="1588216" ru_majflt="5063" ru_maxrss="595100" ru_minflt="58494506" ru_nivcsw="264915" ru_nvcsw="705469" ru_oublock="3763752" ru_stime="160.339282" ru_utime="1417.710558"/> + <time timestamp="2016-11-20T02:08:26.784276">311.322055</time> + <iostat cancelled_write_bytes="311025664" rchar="17611249973" read_bytes="817012736" syscr="3928457" syscw="1573972" wchar="2150886150" write_bytes="1927024640"/> + <rusage ru_inblock="1595728" ru_majflt="5043" ru_maxrss="592960" ru_minflt="58498482" ru_nivcsw="262484" ru_nvcsw="705029" ru_oublock="3763720" ru_stime="160.576949" ru_utime="1416.655502"/> </sysres> </testcase> - <testcase classname="oeqa.buildperf.test_basic.Test1P3" description="Build core-image-sato with rm_work enabled" name="test13" time="3862.732712" timestamp="2016-11-19T22:13:38.497643"> + <testcase classname="oeqa.buildperf.test_basic.Test1P3" description="Build core-image-sato with rm_work enabled" name="test13" time="3857.571943" timestamp="2016-11-20T02:13:38.107918"> <sysres legend="bitbakecore-image-sato" name="build"> - <time timestamp="2016-11-19T22:18:24.708647">3565.835654</time> - <iostat cancelled_write_bytes="9718571008" rchar="249675435553" read_bytes="2039734272" syscr="96580136" syscw="54005290" wchar="69871277208" write_bytes="42324353024"/> - <rusage ru_inblock="3983856" ru_majflt="8115" ru_maxrss="917776" ru_minflt="1233520007" ru_nivcsw="32246534" ru_nvcsw="26000974" ru_oublock="82664752" ru_stime="3706.151646" ru_utime="22247.0684"/> + <time timestamp="2016-11-20T02:18:15.700150">3570.634721</time> + <iostat cancelled_write_bytes="9666129920" rchar="249639797912" read_bytes="2096889856" syscr="96539200" syscw="54051859" wchar="69867184137" write_bytes="42315804672"/> + <rusage ru_inblock="4095488" ru_majflt="8109" ru_maxrss="917724" ru_minflt="1236882459" ru_nivcsw="32425598" ru_nvcsw="26133204" ru_oublock="82648056" ru_stime="3716.118666" ru_utime="22268.365061"/> </sysres> <diskusage legend="tmpdir" name="tmpdir"> - <size>6465168</size> + <size>6462532</size> </diskusage> </testcase> - <testcase classname="oeqa.buildperf.test_basic.Test2" description="Measure bitbake core-image-sato -c rootfs with sstate" name="test2" time="230.332968" timestamp="2016-11-19T23:18:01.230432"> + <testcase classname="oeqa.buildperf.test_basic.Test2" description="Measure bitbake core-image-sato -c rootfs with sstate" name="test2" time="237.516039" timestamp="2016-11-20T03:17:55.679940"> <sysres legend="bitbake do_rootfs" name="do_rootfs"> - <time timestamp="2016-11-19T23:19:35.520899">136.041004</time> - <iostat cancelled_write_bytes="149037056" rchar="5027529686" read_bytes="1092079616" syscr="1640821" syscw="1019920" wchar="3691662011" write_bytes="1972817920"/> - <rusage ru_inblock="2132968" ru_majflt="377" ru_maxrss="188748" ru_minflt="15376307" ru_nivcsw="93577" ru_nvcsw="615615" ru_oublock="3853160" ru_stime="56.966041" ru_utime="415.139644"/> + <time timestamp="2016-11-20T03:19:33.770979">139.423668</time> + <iostat cancelled_write_bytes="149073920" rchar="4927268540" read_bytes="1091481600" syscr="1619985" syscw="1019487" wchar="3688737449" write_bytes="1972559872"/> + <rusage ru_inblock="2131800" ru_majflt="373" ru_maxrss="186400" ru_minflt="15523096" ru_nivcsw="92826" ru_nvcsw="617130" ru_oublock="3852656" ru_stime="59.680818" ru_utime="413.85093"/> </sysres> </testcase> - <testcase classname="oeqa.buildperf.test_basic.Test3" description="Parsing time metrics (bitbake -p)" name="test3" time="36.73263" timestamp="2016-11-19T23:21:51.563477"> + <testcase classname="oeqa.buildperf.test_basic.Test3" description="Parsing time metrics (bitbake -p)" name="test3" time="36.666117" timestamp="2016-11-20T03:21:53.196048"> <sysres legend="bitbake -p (no caches)" name="parse_1"> - <time timestamp="2016-11-19T23:21:51.568183">21.303792</time> - <iostat cancelled_write_bytes="1052672" rchar="27554356" read_bytes="0" syscr="8944" syscw="4787" wchar="32750718" write_bytes="16887808"/> - <rusage ru_inblock="0" ru_majflt="0" ru_maxrss="112036" ru_minflt="311129" ru_nivcsw="8149" ru_nvcsw="6283" ru_oublock="32984" ru_stime="0.9629639999999999" ru_utime="160.739503"/> + <time timestamp="2016-11-20T03:21:53.200414">21.437503</time> + <iostat cancelled_write_bytes="1056768" rchar="27656341" read_bytes="0" syscr="8961" syscw="4806" wchar="32826884" write_bytes="16920576"/> + <rusage ru_inblock="0" ru_majflt="0" ru_maxrss="112588" ru_minflt="309020" ru_nivcsw="8116" ru_nvcsw="6136" ru_oublock="33048" ru_stime="0.960537" ru_utime="161.716415"/> </sysres> <sysres legend="bitbake -p (no tmp/cache)" name="parse_2"> - <time timestamp="2016-11-19T23:22:12.877746">14.01731</time> - <iostat cancelled_write_bytes="892928" rchar="27357586" read_bytes="0" syscr="8975" syscw="4796" wchar="32083575" write_bytes="16199680"/> - <rusage ru_inblock="0" ru_majflt="0" ru_maxrss="113272" ru_minflt="282765" ru_nivcsw="7793" ru_nvcsw="6246" ru_oublock="31640" ru_stime="0.931122" ru_utime="102.69112"/> + <time timestamp="2016-11-20T03:22:14.643748">13.829384</time> + <iostat cancelled_write_bytes="888832" rchar="27514307" read_bytes="0" syscr="8984" syscw="4795" wchar="32118455" write_bytes="16216064"/> + <rusage ru_inblock="0" ru_majflt="0" ru_maxrss="113388" ru_minflt="283928" ru_nivcsw="7519" ru_nvcsw="6164" ru_oublock="31672" ru_stime="0.95299" ru_utime="101.209381"/> </sysres> <sysres legend="bitbake -p (cached)" name="parse_3"> - <time timestamp="2016-11-19T23:22:26.898395">1.396265</time> - <iostat cancelled_write_bytes="12288" rchar="20741434" read_bytes="0" syscr="6069" syscw="1515" wchar="744618" write_bytes="380928"/> - <rusage ru_inblock="0" ru_majflt="0" ru_maxrss="95100" ru_minflt="38267" ru_nivcsw="10" ru_nvcsw="7977" ru_oublock="744" ru_stime="0.11763799999999999" ru_utime="1.3819379999999999"/> + <time timestamp="2016-11-20T03:22:28.476329">1.384494</time> + <iostat cancelled_write_bytes="12288" rchar="20765457" read_bytes="0" syscr="6072" syscw="1515" wchar="744542" write_bytes="380928"/> + <rusage ru_inblock="0" ru_majflt="0" ru_maxrss="95076" ru_minflt="38508" ru_nivcsw="8" ru_nvcsw="7860" ru_oublock="744" ru_stime="0.11295699999999999" ru_utime="1.362974"/> </sysres> </testcase> - <testcase classname="oeqa.buildperf.test_basic.Test4" description="eSDK metrics" name="test4" time="1680.608354" timestamp="2016-11-19T23:22:28.296183"> + <testcase classname="oeqa.buildperf.test_basic.Test4" description="eSDK metrics" name="test4" time="1684.245429" timestamp="2016-11-20T03:22:29.862241"> <diskusage legend="eSDK installer" name="installer_bin"> - <size>1440664</size> + <size>1440390</size> </diskusage> <sysres legend="eSDK deploy" name="deploy"> - <time timestamp="2016-11-19T23:47:10.996505">197.481606</time> - <iostat cancelled_write_bytes="752308224" rchar="13652482311" read_bytes="147488768" syscr="3620339" syscw="6957253" wchar="12597122339" write_bytes="6250471424"/> - <rusage ru_inblock="288064" ru_majflt="319" ru_maxrss="240256" ru_minflt="22684701" ru_nivcsw="378224" ru_nvcsw="1944471" ru_oublock="12207952" ru_stime="98.47224" ru_utime="564.224556"/> + <time timestamp="2016-11-20T03:47:16.129628">197.557447</time> + <iostat cancelled_write_bytes="752263168" rchar="13761900605" read_bytes="141508608" syscr="3616668" syscw="6956297" wchar="12596682800" write_bytes="6248075264"/> + <rusage ru_inblock="276384" ru_majflt="318" ru_maxrss="240260" ru_minflt="21252618" ru_nivcsw="393972" ru_nvcsw="1924340" ru_oublock="12203272" ru_stime="94.435963" ru_utime="561.158054"/> </sysres> <diskusage legend="deploy dir" name="deploy_dir"> - <size>5328710</size> + <size>5328551</size> </diskusage> </testcase> </testsuite> |