ipynb/tutorial: Update Executor tutorial notebook
diff --git a/ipynb/tutorial/04_ExecutorUsage.ipynb b/ipynb/tutorial/04_ExecutorUsage.ipynb
index 03418ab..dd6c53b 100644
--- a/ipynb/tutorial/04_ExecutorUsage.ipynb
+++ b/ipynb/tutorial/04_ExecutorUsage.ipynb
@@ -24,7 +24,7 @@
},
{
"cell_type": "code",
- "execution_count": null,
+ "execution_count": 1,
"metadata": {
"collapsed": true
},
@@ -38,7 +38,7 @@
},
{
"cell_type": "code",
- "execution_count": 1,
+ "execution_count": 2,
"metadata": {
"collapsed": false
},
@@ -59,16 +59,152 @@
"cell_type": "code",
"execution_count": 3,
"metadata": {
- "collapsed": false
+ "collapsed": false,
+ "scrolled": true
},
- "outputs": [],
+ "outputs": [
+ {
+ "name": "stderr",
+ "output_type": "stream",
+ "text": [
+ "2016-11-17 17:00:31,811 INFO : Target - Using base path: /home/bjackman/sources/lisa\n",
+ "2016-11-17 17:00:31,812 INFO : Target - Loading custom (inline) target configuration\n",
+ "2016-11-17 17:00:31,812 DEBUG : Target - Target configuration {'username': 'brendan', 'platform': 'linux', 'host': '192.168.0.1', 'ftrace': {'buffsize': 81920, 'events': ['sched_switch', 'sched_wakeup', 'sched_wakeup_new', 'cpu_frequency']}, 'board': 'juno2', 'modules': ['bl', 'cpufreq'], 'password': 'test0000', 'tools': ['trace-cmd', 'perf'], 'results_dir': 'ExecutorExample'}\n",
+ "2016-11-17 17:00:31,813 INFO : Target - Devlib modules to load: ['bl', 'cpufreq', 'hwmon']\n",
+ "2016-11-17 17:00:31,814 INFO : Target - Connecting linux target:\n",
+ "2016-11-17 17:00:31,815 INFO : Target - username : brendan\n",
+ "2016-11-17 17:00:31,816 INFO : Target - host : 192.168.0.1\n",
+ "2016-11-17 17:00:31,817 INFO : Target - password : \n",
+ "2016-11-17 17:00:31,819 INFO : Target - Connection settings:\n",
+ "2016-11-17 17:00:31,820 INFO : Target - {'username': 'brendan', 'host': '192.168.0.1', 'password': ''}\n",
+ "2016-11-17 17:00:31,821 DEBUG : Target - Setup LINUX target...\n",
+ "2016-11-17 17:00:31,828 DEBUG : Installing module vexpress-u-boot\n",
+ "2016-11-17 17:00:31,829 DEBUG : Installing module vexpress-dtr\n",
+ "2016-11-17 17:00:31,830 DEBUG : Installing module vexpress-vemsd\n",
+ "2016-11-17 17:00:31,831 DEBUG : Logging in brendan@192.168.0.1\n",
+ "2016-11-17 17:00:33,311 DEBUG : id\n",
+ "2016-11-17 17:00:33,722 DEBUG : echo $USER\n",
+ "2016-11-17 17:00:34,128 DEBUG : if [ -e '/home/brendan/devlib-target/bin' ]; then echo 1; else echo 0; fi\n",
+ "2016-11-17 17:00:34,534 DEBUG : ls -1 /home/brendan/devlib-target/bin\n",
+ "2016-11-17 17:00:34,944 DEBUG : cat /proc/cpuinfo\n",
+ "2016-11-17 17:00:35,353 DEBUG : sudo -- sh -c 'ls /'\n",
+ "2016-11-17 17:00:35,901 DEBUG : sudo -- sh -c 'dmidecode -s system-version'\n",
+ "2016-11-17 17:00:36,706 DEBUG : Installing module bl\n",
+ "2016-11-17 17:00:36,808 DEBUG : uname -m\n",
+ "2016-11-17 17:00:37,216 DEBUG : if [ -e '/sys/devices/system/cpu/cpufreq' ]; then echo 1; else echo 0; fi\n",
+ "2016-11-17 17:00:37,523 DEBUG : Installing module cpufreq\n",
+ "2016-11-17 17:00:37,624 DEBUG : if [ -e '/sys/class/hwmon' ]; then echo 1; else echo 0; fi\n",
+ "2016-11-17 17:00:37,931 DEBUG : Installing module hwmon\n",
+ "2016-11-17 17:00:38,033 DEBUG : ls -1 /sys/class/hwmon\n",
+ "2016-11-17 17:00:38,442 DEBUG : if [ -e '/sys/class/hwmon/hwmon0/name' ]; then echo 1; else echo 0; fi\n",
+ "2016-11-17 17:00:38,848 DEBUG : sudo -- sh -c 'cat '\\''/sys/class/hwmon/hwmon0/name'\\'''\n",
+ "2016-11-17 17:00:39,754 DEBUG : ls -1 /sys/class/hwmon/hwmon0/\n",
+ "2016-11-17 17:00:40,166 DEBUG : sudo -- sh -c 'cat '\\''/sys/class/hwmon/hwmon0/curr1_label'\\'''\n",
+ "2016-11-17 17:00:41,072 DEBUG : sudo -- sh -c 'cat '\\''/sys/class/hwmon/hwmon0/curr2_label'\\'''\n",
+ "2016-11-17 17:00:41,977 DEBUG : sudo -- sh -c 'cat '\\''/sys/class/hwmon/hwmon0/curr3_label'\\'''\n",
+ "2016-11-17 17:00:42,882 DEBUG : sudo -- sh -c 'cat '\\''/sys/class/hwmon/hwmon0/curr4_label'\\'''\n",
+ "2016-11-17 17:00:43,788 DEBUG : sudo -- sh -c 'cat '\\''/sys/class/hwmon/hwmon0/energy1_label'\\'''\n",
+ "2016-11-17 17:00:44,694 DEBUG : sudo -- sh -c 'cat '\\''/sys/class/hwmon/hwmon0/energy2_label'\\'''\n",
+ "2016-11-17 17:00:45,599 DEBUG : sudo -- sh -c 'cat '\\''/sys/class/hwmon/hwmon0/energy3_label'\\'''\n",
+ "2016-11-17 17:00:46,505 DEBUG : sudo -- sh -c 'cat '\\''/sys/class/hwmon/hwmon0/energy4_label'\\'''\n",
+ "2016-11-17 17:00:47,410 DEBUG : sudo -- sh -c 'cat '\\''/sys/class/hwmon/hwmon0/in0_label'\\'''\n",
+ "2016-11-17 17:00:48,316 DEBUG : sudo -- sh -c 'cat '\\''/sys/class/hwmon/hwmon0/in1_label'\\'''\n",
+ "2016-11-17 17:00:49,221 DEBUG : sudo -- sh -c 'cat '\\''/sys/class/hwmon/hwmon0/in2_label'\\'''\n",
+ "2016-11-17 17:00:50,126 DEBUG : sudo -- sh -c 'cat '\\''/sys/class/hwmon/hwmon0/in3_label'\\'''\n",
+ "2016-11-17 17:00:51,032 DEBUG : sudo -- sh -c 'cat '\\''/sys/class/hwmon/hwmon0/in4_label'\\'''\n",
+ "2016-11-17 17:00:51,938 DEBUG : sudo -- sh -c 'cat '\\''/sys/class/hwmon/hwmon0/in5_label'\\'''\n",
+ "2016-11-17 17:00:52,843 DEBUG : sudo -- sh -c 'cat '\\''/sys/class/hwmon/hwmon0/in6_label'\\'''\n",
+ "2016-11-17 17:00:53,749 DEBUG : sudo -- sh -c 'cat '\\''/sys/class/hwmon/hwmon0/power1_label'\\'''\n",
+ "2016-11-17 17:00:54,654 DEBUG : sudo -- sh -c 'cat '\\''/sys/class/hwmon/hwmon0/power2_label'\\'''\n",
+ "2016-11-17 17:00:55,560 DEBUG : sudo -- sh -c 'cat '\\''/sys/class/hwmon/hwmon0/power3_label'\\'''\n",
+ "2016-11-17 17:00:56,466 DEBUG : sudo -- sh -c 'cat '\\''/sys/class/hwmon/hwmon0/power4_label'\\'''\n",
+ "2016-11-17 17:00:57,371 DEBUG : sudo -- sh -c 'cat '\\''/sys/class/hwmon/hwmon0/temp1_label'\\'''\n",
+ "2016-11-17 17:00:58,277 DEBUG : sudo -- sh -c 'cat '\\''/sys/class/hwmon/hwmon0/temp2_label'\\'''\n",
+ "2016-11-17 17:00:59,082 DEBUG : Target - Checking target connection...\n",
+ "2016-11-17 17:00:59,083 DEBUG : Target - Target info:\n",
+ "2016-11-17 17:00:59,084 DEBUG : Target - ABI: arm64\n",
+ "2016-11-17 17:00:59,085 DEBUG : Target - CPUs: CpuInfo(['A53', 'A57', 'A57', 'A53', 'A53', 'A53'])\n",
+ "2016-11-17 17:00:59,087 DEBUG : Target - Clusters: [0, 1, 1, 0, 0, 0]\n",
+ "2016-11-17 17:00:59,088 INFO : Target - Initializing target workdir:\n",
+ "2016-11-17 17:00:59,089 INFO : Target - /home/brendan/devlib-target\n",
+ "2016-11-17 17:00:59,190 DEBUG : mkdir -p /home/brendan/devlib-target\n",
+ "2016-11-17 17:00:59,599 DEBUG : mkdir -p /home/brendan/devlib-target/bin\n",
+ "2016-11-17 17:00:59,909 DEBUG : /usr/bin/scp -r /home/bjackman/sources/lisa/libs/devlib/devlib/bin/arm64/busybox brendan@192.168.0.1:/home/brendan/devlib-target/bin/busybox\n",
+ "2016-11-17 17:01:00,410 DEBUG : chmod a+x /home/brendan/devlib-target/bin/busybox\n",
+ "2016-11-17 17:01:00,718 DEBUG : /usr/bin/scp -r /home/bjackman/sources/lisa/libs/devlib/devlib/bin/scripts/shutils brendan@192.168.0.1:/home/brendan/devlib-target/bin/shutils\n",
+ "2016-11-17 17:01:01,202 DEBUG : chmod a+x /home/brendan/devlib-target/bin/shutils\n",
+ "2016-11-17 17:01:01,511 DEBUG : /usr/bin/scp -r /home/bjackman/sources/lisa/tools/arm64/trace-cmd brendan@192.168.0.1:/home/brendan/devlib-target/bin/trace-cmd\n",
+ "2016-11-17 17:01:01,856 DEBUG : chmod a+x /home/brendan/devlib-target/bin/trace-cmd\n",
+ "2016-11-17 17:01:02,164 DEBUG : /usr/bin/scp -r /home/bjackman/sources/lisa/tools/arm64/perf brendan@192.168.0.1:/home/brendan/devlib-target/bin/perf\n",
+ "2016-11-17 17:01:02,549 DEBUG : chmod a+x /home/brendan/devlib-target/bin/perf\n",
+ "2016-11-17 17:01:02,856 DEBUG : Target - Check for module [bl]...\n",
+ "2016-11-17 17:01:02,857 DEBUG : Target - Check for module [cpufreq]...\n",
+ "2016-11-17 17:01:02,858 DEBUG : Target - Check for module [hwmon]...\n",
+ "2016-11-17 17:01:02,860 INFO : Target - Topology:\n",
+ "2016-11-17 17:01:02,861 INFO : Target - [[0, 3, 4, 5], [1, 2]]\n",
+ "2016-11-17 17:01:02,962 DEBUG : sudo -- sh -c 'cat '\\''/sys/devices/system/cpu/online'\\'''\n",
+ "2016-11-17 17:01:03,868 DEBUG : cat /sys/devices/system/cpu/cpu0/cpufreq/scaling_available_frequencies\n",
+ "2016-11-17 17:01:04,276 DEBUG : sudo -- sh -c 'cat '\\''/sys/devices/system/cpu/online'\\'''\n",
+ "2016-11-17 17:01:05,181 DEBUG : cat /sys/devices/system/cpu/cpu1/cpufreq/scaling_available_frequencies\n",
+ "2016-11-17 17:01:05,490 DEBUG : Platform - Trying to load default EM from /home/bjackman/sources/lisa/libs/utils/platforms/juno2.json\n",
+ "2016-11-17 17:01:05,491 DEBUG : Platform - Platform descriptor initialized\n",
+ "{'nrg_model': None, 'clusters': {'big': [1, 2], 'little': [0, 3, 4, 5]}, 'cpus_count': 6, 'freqs': {'big': [450000, 625000, 800000, 950000, 1100000], 'little': [450000, 575000, 700000, 775000, 850000]}, 'topology': [[0, 3, 4, 5], [1, 2]]}\n",
+ "2016-11-17 17:01:05,509 DEBUG : /usr/bin/scp -r /home/bjackman/sources/lisa/libs/devlib/devlib/bin/arm64/trace-cmd brendan@192.168.0.1:/home/brendan/devlib-target/bin/trace-cmd\n",
+ "2016-11-17 17:01:05,949 DEBUG : chmod a+x /home/brendan/devlib-target/bin/trace-cmd\n",
+ "2016-11-17 17:01:06,357 DEBUG : sudo -- sh -c 'cat /sys/kernel/debug/tracing/available_events'\n",
+ "2016-11-17 17:01:07,172 INFO : FTrace - Enabled tracepoints:\n",
+ "2016-11-17 17:01:07,173 INFO : FTrace - sched_switch\n",
+ "2016-11-17 17:01:07,174 INFO : FTrace - sched_wakeup\n",
+ "2016-11-17 17:01:07,175 INFO : FTrace - sched_wakeup_new\n",
+ "2016-11-17 17:01:07,176 INFO : FTrace - cpu_frequency\n",
+ "2016-11-17 17:01:07,177 DEBUG : No RT-App workloads, skipping calibration\n",
+ "2016-11-17 17:01:07,178 WARNING : TestEnv - Wipe previous contents of the results folder:\n",
+ "2016-11-17 17:01:07,179 WARNING : TestEnv - /home/bjackman/sources/lisa/results/ExecutorExample\n",
+ "2016-11-17 17:01:07,181 DEBUG : EnergyMeter - using default energy meter for [juno2]\n",
+ "2016-11-17 17:01:07,182 INFO : HWMon - Scanning for HWMON channels, may take some time...\n",
+ "2016-11-17 17:01:07,184 DEBUG : Discovering available HWMON sensors...\n",
+ "2016-11-17 17:01:07,185 DEBUG : \tAdding sensor scpi_sensors/energy1\n",
+ "2016-11-17 17:01:07,186 DEBUG : \tAdding sensor scpi_sensors/energy2\n",
+ "2016-11-17 17:01:07,187 DEBUG : \tAdding sensor scpi_sensors/energy3\n",
+ "2016-11-17 17:01:07,188 DEBUG : \tAdding sensor scpi_sensors/energy4\n",
+ "2016-11-17 17:01:07,189 DEBUG : \tAdding sensor scpi_sensors/curr1\n",
+ "2016-11-17 17:01:07,191 DEBUG : \tAdding sensor scpi_sensors/curr2\n",
+ "2016-11-17 17:01:07,192 DEBUG : \tAdding sensor scpi_sensors/curr3\n",
+ "2016-11-17 17:01:07,193 DEBUG : \tAdding sensor scpi_sensors/curr4\n",
+ "2016-11-17 17:01:07,194 DEBUG : \tAdding sensor scpi_sensors/temp1\n",
+ "2016-11-17 17:01:07,195 DEBUG : \tAdding sensor scpi_sensors/temp2\n",
+ "2016-11-17 17:01:07,196 DEBUG : \tAdding sensor scpi_sensors/power1\n",
+ "2016-11-17 17:01:07,198 DEBUG : \tAdding sensor scpi_sensors/power2\n",
+ "2016-11-17 17:01:07,199 DEBUG : \tAdding sensor scpi_sensors/power3\n",
+ "2016-11-17 17:01:07,200 DEBUG : \tAdding sensor scpi_sensors/power4\n",
+ "2016-11-17 17:01:07,201 DEBUG : \tAdding sensor scpi_sensors/in0\n",
+ "2016-11-17 17:01:07,202 DEBUG : \tAdding sensor scpi_sensors/in1\n",
+ "2016-11-17 17:01:07,203 DEBUG : \tAdding sensor scpi_sensors/in2\n",
+ "2016-11-17 17:01:07,204 DEBUG : \tAdding sensor scpi_sensors/in3\n",
+ "2016-11-17 17:01:07,205 DEBUG : \tAdding sensor scpi_sensors/in4\n",
+ "2016-11-17 17:01:07,206 DEBUG : \tAdding sensor scpi_sensors/in5\n",
+ "2016-11-17 17:01:07,206 DEBUG : \tAdding sensor scpi_sensors/in6\n",
+ "2016-11-17 17:01:07,207 DEBUG : HWMon - Enabling channels {'kinds': ['energy'], 'sites': ['BOARDLITTLE', 'BOARDBIG']}\n",
+ "2016-11-17 17:01:07,208 INFO : HWMon - Channels selected for energy sampling:\n",
+ "2016-11-17 17:01:07,209 INFO : HWMon - BOARDBIG_energy\n",
+ "2016-11-17 17:01:07,210 INFO : HWMon - BOARDLITTLE_energy\n",
+ "2016-11-17 17:01:07,211 DEBUG : EnergyMeter - Results dir: /home/bjackman/sources/lisa/results/ExecutorExample\n",
+ "2016-11-17 17:01:07,212 INFO : TestEnv - Set results folder to:\n",
+ "2016-11-17 17:01:07,213 INFO : TestEnv - /home/bjackman/sources/lisa/results/ExecutorExample\n",
+ "2016-11-17 17:01:07,214 INFO : TestEnv - Experiment results available also in:\n",
+ "2016-11-17 17:01:07,215 INFO : TestEnv - /home/bjackman/sources/lisa/results_latest\n"
+ ]
+ }
+ ],
"source": [
- "# Setup a target configuration\n",
- "my_target_conf = {\n",
+ "from env import TestEnv\n",
+ "\n",
+ "# Setup a test environment with target configuration\n",
+ "env = TestEnv({\n",
" \n",
" # Target platform and board\n",
" \"platform\" : 'linux',\n",
- " \"board\" : 'aboard',\n",
+ " \"board\" : 'juno2',\n",
" \n",
" # Target board IP/MAC address\n",
" \"host\" : '192.168.0.1',\n",
@@ -77,7 +213,27 @@
" \"username\" : 'root',\n",
" \"password\" : 'test0000',\n",
"\n",
- "}"
+ " # Folder where all the results will be collected\n",
+ " \"results_dir\" : \"ExecutorExample\",\n",
+ " \n",
+ " # FTrace events to collect for all the tests configuration which have\n",
+ " # the \"ftrace\" flag enabled\n",
+ " \"ftrace\" : {\n",
+ " \"events\" : [\n",
+ " \"sched_switch\",\n",
+ " \"sched_wakeup\",\n",
+ " \"sched_wakeup_new\",\n",
+ " \"cpu_frequency\",\n",
+ " ],\n",
+ " \"buffsize\" : 80 * 1024,\n",
+ " },\n",
+ " \n",
+ " # Tools required by the experiments\n",
+ " \"tools\" : [ 'trace-cmd', 'perf' ],\n",
+ " \n",
+ " # Modules required by these experiments\n",
+ " \"modules\" : [ 'bl', 'cpufreq' ],\n",
+ "})"
]
},
{
@@ -98,9 +254,6 @@
"source": [
"my_tests_conf = {\n",
"\n",
- " # Folder where all the results will be collected\n",
- " \"results_dir\" : \"ExecutorExample\",\n",
- "\n",
" # Platform configurations to test\n",
" \"confs\" : [\n",
" {\n",
@@ -144,7 +297,7 @@
" \"class\" : \"profile\",\n",
" \"params\" : {\n",
" \"p20\" : {\n",
- " \"kind\" : \"periodic\",\n",
+ " \"kind\" : \"Periodic\",\n",
" \"params\" : {\n",
" \"duty_cycle_pct\" : 20,\n",
" },\n",
@@ -156,25 +309,6 @@
" \n",
" # Number of iterations for each workload\n",
" \"iterations\" : 1,\n",
- " \n",
- " # FTrace events to collect for all the tests configuration which have\n",
- " # the \"ftrace\" flag enabled\n",
- " \"ftrace\" : {\n",
- " \"events\" : [\n",
- " \"sched_switch\",\n",
- " \"sched_wakeup\",\n",
- " \"sched_wakeup_new\",\n",
- " \"cpu_frequency\",\n",
- " ],\n",
- " \"buffsize\" : 80 * 1024,\n",
- " },\n",
- " \n",
- " # Tools required by the experiments\n",
- " \"tools\" : [ 'trace-cmd', 'perf' ],\n",
- " \n",
- " # Modules required by these experiments\n",
- " \"modules\" : [ 'bl', 'cpufreq' ],\n",
- "\n",
"}"
]
},
@@ -196,140 +330,274 @@
"name": "stderr",
"output_type": "stream",
"text": [
- "10:22:10 INFO : Target - Loading custom (inline) test configuration\n",
- "10:22:10 INFO : Target - Using base path: /home/derkling/Code/lisa\n",
- "10:22:10 INFO : Target - Loading custom (inline) target configuration\n",
- "10:22:10 INFO : Target - Loading custom (inline) test configuration\n",
- "10:22:10 INFO : Target - Devlib modules to load: ['bl', 'cpufreq']\n",
- "10:22:10 INFO : Target - Connecting linux target:\n",
- "10:22:10 INFO : Target - username : root\n",
- "10:22:10 INFO : Target - host : 192.168.0.1\n",
- "10:22:10 INFO : Target - password : test0000\n",
- "10:22:15 INFO : Target - Initializing target workdir:\n",
- "10:22:15 INFO : Target - /root/devlib-target\n",
- "10:22:21 INFO : Target - Topology:\n",
- "10:22:21 INFO : Target - [[0, 3, 4, 5], [1, 2]]\n",
- "10:22:25 INFO : FTrace - Enabled tracepoints:\n",
- "10:22:25 INFO : FTrace - sched_switch\n",
- "10:22:25 INFO : FTrace - sched_wakeup\n",
- "10:22:25 INFO : FTrace - sched_wakeup_new\n",
- "10:22:25 INFO : FTrace - cpu_frequency\n",
- "10:22:25 INFO : TestEnv - Set results folder to:\n",
- "10:22:25 INFO : TestEnv - /home/derkling/Code/lisa/results/ExecutorExample\n",
- "10:22:25 INFO : TestEnv - Experiment results available also in:\n",
- "10:22:25 INFO : TestEnv - /home/derkling/Code/lisa/results_latest\n",
- "10:22:25 INFO : \n",
- "10:22:25 INFO : ################################################################################\n",
- "10:22:25 INFO : Executor - Experiments configuration\n",
- "10:22:25 INFO : ################################################################################\n",
- "10:22:25 INFO : Executor - Configured to run:\n",
- "10:22:25 INFO : Executor - 2 targt configurations:\n",
- "10:22:25 INFO : Executor - base, eas\n",
- "10:22:25 INFO : Executor - 2 workloads (1 iterations each)\n",
- "10:22:25 INFO : Executor - rta, perf\n",
- "10:22:25 INFO : Executor - Total: 4 experiments\n",
- "10:22:25 INFO : Executor - Results will be collected under:\n",
- "10:22:25 INFO : Executor - /home/derkling/Code/lisa/results/ExecutorExample\n"
+ "05:01:07 INFO : Target - Loading custom (inline) test configuration\n",
+ "05:01:07 INFO : \n",
+ "05:01:07 INFO : ################################################################################\n",
+ "05:01:07 INFO : Executor - Experiments configuration\n",
+ "05:01:07 INFO : ################################################################################\n",
+ "05:01:07 INFO : Executor - Configured to run:\n",
+ "05:01:07 INFO : Executor - 2 target configurations:\n",
+ "05:01:07 INFO : Executor - base, eas\n",
+ "05:01:07 INFO : Executor - 2 workloads (1 iterations each)\n",
+ "05:01:07 INFO : Executor - rta, perf\n",
+ "05:01:07 INFO : Executor - Total: 4 experiments\n",
+ "05:01:07 INFO : Executor - Results will be collected under:\n",
+ "05:01:07 INFO : Executor - /home/bjackman/sources/lisa/results/ExecutorExample\n"
]
}
],
"source": [
"from executor import Executor\n",
"\n",
- "executor = Executor(my_target_conf, my_tests_conf)"
+ "executor = Executor(env, my_tests_conf)"
]
},
{
"cell_type": "code",
"execution_count": 6,
"metadata": {
- "collapsed": false
+ "collapsed": false,
+ "scrolled": true
},
"outputs": [
{
"name": "stderr",
"output_type": "stream",
"text": [
- "10:22:25 INFO : \n",
- "10:22:25 INFO : ################################################################################\n",
- "10:22:25 INFO : Executor - Experiments execution\n",
- "10:22:25 INFO : ################################################################################\n",
- "10:22:25 INFO : \n",
- "10:22:25 INFO : ================================================================================\n",
- "10:22:25 INFO : TargetConfig - configuring target for [base] experiments\n",
- "10:22:27 INFO : SchedFeatures - Set scheduler feature: NO_ENERGY_AWARE\n",
- "10:22:27 INFO : CPUFreq - Configuring all CPUs to use [performance] governor\n",
- "10:22:27 INFO : WlGen - Setup new workload rta\n",
- "10:22:27 INFO : RTApp - Workload duration defined by longest task\n",
- "10:22:27 INFO : RTApp - Default policy: SCHED_OTHER\n",
- "10:22:27 INFO : RTApp - ------------------------\n",
- "10:22:27 INFO : RTApp - task [task_p20], sched: using default policy\n",
- "10:22:27 INFO : RTApp - | calibration CPU: 1\n",
- "10:22:27 INFO : RTApp - | loops count: 1\n",
- "10:22:27 INFO : RTApp - + phase_000001: duration 1.000000 [s] (10 loops)\n",
- "10:22:27 INFO : RTApp - | period 100000 [us], duty_cycle 20 %\n",
- "10:22:27 INFO : RTApp - | run_time 20000 [us], sleep_time 80000 [us]\n",
- "10:22:28 INFO : ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~\n",
- "10:22:28 INFO : Executor - Experiment 1/4, [base:rta] 1/1\n",
- "10:22:28 WARNING : Executor - FTrace events collection enabled\n",
- "10:22:34 INFO : WlGen - Workload execution START:\n",
- "10:22:34 INFO : WlGen - /root/devlib-target/bin/rt-app /root/devlib-target/run_dir/rta_00.json\n",
- "10:22:43 INFO : Executor - Collected FTrace binary trace:\n",
- "10:22:43 INFO : Executor - <res_dir>/rtapp:base:rta/1/trace.dat\n",
- "10:22:43 INFO : Executor - Collected FTrace function profiling:\n",
- "10:22:43 INFO : Executor - <res_dir>/rtapp:base:rta/1/trace_stat.json\n",
- "10:22:43 INFO : WlGen - Setup new workload perf\n",
- "10:22:43 INFO : ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~\n",
- "10:22:43 INFO : Executor - Experiment 2/4, [base:perf] 1/1\n",
- "10:22:43 WARNING : Executor - FTrace events collection enabled\n",
- "10:22:49 INFO : WlGen - Workload execution START:\n",
- "10:22:49 INFO : WlGen - /root/devlib-target/bin/perf bench sched messaging --pipe --thread --group 1 --loop 10\n",
- "10:22:50 INFO : PerfBench - Completion time: 0.088000, Performance 11.363636\n",
- "10:22:57 INFO : Executor - Collected FTrace binary trace:\n",
- "10:22:57 INFO : Executor - <res_dir>/perf_bench_messaging:base:perf/1/trace.dat\n",
- "10:22:57 INFO : Executor - Collected FTrace function profiling:\n",
- "10:22:57 INFO : Executor - <res_dir>/perf_bench_messaging:base:perf/1/trace_stat.json\n",
- "10:22:57 INFO : \n",
- "10:22:57 INFO : ================================================================================\n",
- "10:22:57 INFO : TargetConfig - configuring target for [eas] experiments\n",
- "10:22:59 INFO : SchedFeatures - Set scheduler feature: ENERGY_AWARE\n",
- "10:22:59 INFO : CPUFreq - Configuring all CPUs to use [performance] governor\n",
- "10:22:59 INFO : WlGen - Setup new workload rta\n",
- "10:22:59 INFO : RTApp - Workload duration defined by longest task\n",
- "10:22:59 INFO : RTApp - Default policy: SCHED_OTHER\n",
- "10:22:59 INFO : RTApp - ------------------------\n",
- "10:22:59 INFO : RTApp - task [task_p20], sched: using default policy\n",
- "10:22:59 INFO : RTApp - | calibration CPU: 1\n",
- "10:22:59 INFO : RTApp - | loops count: 1\n",
- "10:22:59 INFO : RTApp - + phase_000001: duration 1.000000 [s] (10 loops)\n",
- "10:22:59 INFO : RTApp - | period 100000 [us], duty_cycle 20 %\n",
- "10:22:59 INFO : RTApp - | run_time 20000 [us], sleep_time 80000 [us]\n",
- "10:23:00 INFO : ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~\n",
- "10:23:00 INFO : Executor - Experiment 3/4, [eas:rta] 1/1\n",
- "10:23:00 WARNING : Executor - FTrace events collection enabled\n",
- "10:23:06 INFO : WlGen - Workload execution START:\n",
- "10:23:06 INFO : WlGen - /root/devlib-target/bin/rt-app /root/devlib-target/run_dir/rta_00.json\n",
- "10:23:16 INFO : Executor - Collected FTrace binary trace:\n",
- "10:23:16 INFO : Executor - <res_dir>/rtapp:eas:rta/1/trace.dat\n",
- "10:23:16 INFO : Executor - Collected FTrace function profiling:\n",
- "10:23:16 INFO : Executor - <res_dir>/rtapp:eas:rta/1/trace_stat.json\n",
- "10:23:16 INFO : WlGen - Setup new workload perf\n",
- "10:23:17 INFO : ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~\n",
- "10:23:17 INFO : Executor - Experiment 4/4, [eas:perf] 1/1\n",
- "10:23:17 WARNING : Executor - FTrace events collection enabled\n",
- "10:23:22 INFO : WlGen - Workload execution START:\n",
- "10:23:22 INFO : WlGen - /root/devlib-target/bin/perf bench sched messaging --pipe --thread --group 1 --loop 10\n",
- "10:23:23 INFO : PerfBench - Completion time: 0.119000, Performance 8.403361\n",
- "10:23:31 INFO : Executor - Collected FTrace binary trace:\n",
- "10:23:31 INFO : Executor - <res_dir>/perf_bench_messaging:eas:perf/1/trace.dat\n",
- "10:23:31 INFO : Executor - Collected FTrace function profiling:\n",
- "10:23:31 INFO : Executor - <res_dir>/perf_bench_messaging:eas:perf/1/trace_stat.json\n",
- "10:23:31 INFO : \n",
- "10:23:31 INFO : ################################################################################\n",
- "10:23:31 INFO : Executor - Experiments execution completed\n",
- "10:23:31 INFO : ################################################################################\n",
- "10:23:31 INFO : Executor - Results available in:\n",
- "10:23:31 INFO : Executor - /home/derkling/Code/lisa/results/ExecutorExample\n"
+ "05:01:07 INFO : \n",
+ "05:01:07 INFO : ################################################################################\n",
+ "05:01:07 INFO : Executor - Experiments execution\n",
+ "05:01:07 INFO : ################################################################################\n",
+ "05:01:07 INFO : \n",
+ "05:01:07 INFO : ================================================================================\n",
+ "05:01:07 INFO : TargetConfig - configuring target for [base] experiments\n",
+ "2016-11-17 17:01:07,401 DEBUG : sudo -- sh -c '[ -d /home/brendan/devlib-target/run_dir ] || mkdir /home/brendan/devlib-target/run_dir'\n",
+ "2016-11-17 17:01:08,306 DEBUG : sudo -- sh -c 'grep schedtest /proc/mounts || mount -t tmpfs -o size=1024m schedtest /home/brendan/devlib-target/run_dir'\n",
+ "05:01:09 INFO : SchedFeatures - Set scheduler feature: NO_ENERGY_AWARE\n",
+ "2016-11-17 17:01:09,212 DEBUG : sudo -- sh -c 'echo NO_ENERGY_AWARE > /sys/kernel/debug/sched_features'\n",
+ "05:01:10 INFO : CPUFreq - Configuring all CPUs to use [performance] governor\n",
+ "2016-11-17 17:01:10,118 DEBUG : sudo -- sh -c '/home/brendan/devlib-target/bin/shutils cpufreq_set_all_governors performance'\n",
+ "05:01:10 INFO : WlGen - Setup new workload rta\n",
+ "05:01:10 INFO : RTApp - Workload duration defined by longest task\n",
+ "05:01:10 INFO : RTApp - Default policy: SCHED_OTHER\n",
+ "05:01:10 INFO : RTApp - ------------------------\n",
+ "05:01:10 INFO : RTApp - task [task_p200], sched: using default policy\n",
+ "05:01:10 INFO : RTApp - | calibration CPU: 1\n",
+ "05:01:10 INFO : RTApp - | loops count: 1\n",
+ "05:01:10 INFO : RTApp - + phase_000001: duration 1.000000 [s] (10 loops)\n",
+ "05:01:10 INFO : RTApp - | period 100000 [us], duty_cycle 20 %\n",
+ "05:01:10 INFO : RTApp - | run_time 20000 [us], sleep_time 80000 [us]\n",
+ "2016-11-17 17:01:10,934 DEBUG : /usr/bin/scp -r rta_00.json brendan@192.168.0.1:/home/brendan/devlib-target/run_dir\n",
+ "2016-11-17 17:01:11,184 DEBUG : zcat /proc/config.gz\n",
+ "2016-11-17 17:01:11,706 DEBUG : /home/brendan/devlib-target/bin/busybox uname -a\n",
+ "05:01:12 INFO : WlGen - Setup new workload perf\n",
+ "2016-11-17 17:01:12,149 DEBUG : /home/brendan/devlib-target/bin/busybox uname -a\n",
+ "05:01:12 INFO : ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~\n",
+ "05:01:12 INFO : Executor - Experiment 0/4, [base:rta] 1/1\n",
+ "05:01:12 WARNING : Executor - FTrace events collection enabled\n",
+ "2016-11-17 17:01:12,569 DEBUG : sudo -- sh -c 'echo 81920 > '\\''/sys/kernel/debug/tracing/buffer_size_kb'\\'''\n",
+ "2016-11-17 17:01:13,272 DEBUG : sudo -- sh -c 'cat '\\''/sys/kernel/debug/tracing/buffer_size_kb'\\'''\n",
+ "2016-11-17 17:01:14,178 DEBUG : sudo -- sh -c '/home/brendan/devlib-target/bin/trace-cmd reset'\n",
+ "2016-11-17 17:01:15,707 DEBUG : sudo -- sh -c '/home/brendan/devlib-target/bin/trace-cmd start -e sched_switch -e sched_wakeup -e sched_wakeup_new -e cpu_frequency'\n",
+ "2016-11-17 17:01:17,247 DEBUG : sudo -- sh -c 'echo TRACE_MARKER_START > '\\''/sys/kernel/debug/tracing/trace_marker'\\'''\n",
+ "2016-11-17 17:01:17,850 DEBUG : Trace CPUFreq frequencies\n",
+ "2016-11-17 17:01:17,951 DEBUG : sudo -- sh -c '/home/brendan/devlib-target/bin/shutils cpufreq_trace_all_frequencies'\n",
+ "2016-11-17 17:01:18,857 DEBUG : sudo -- sh -c 'cat '\\''/sys/class/hwmon/hwmon0/energy2_input'\\'''\n",
+ "2016-11-17 17:01:19,762 DEBUG : sudo -- sh -c 'cat '\\''/sys/class/hwmon/hwmon0/energy3_input'\\'''\n",
+ "05:01:20 INFO : WlGen - Workload execution START:\n",
+ "05:01:20 INFO : WlGen - /home/brendan/devlib-target/bin/rt-app /home/brendan/devlib-target/run_dir/rta_00.json 2>&1\n",
+ "2016-11-17 17:01:20,671 DEBUG : /home/brendan/devlib-target/bin/rt-app /home/brendan/devlib-target/run_dir/rta_00.json 2>&1\n",
+ "2016-11-17 17:01:22,087 DEBUG : /usr/bin/scp -r brendan@192.168.0.1:'/home/brendan/devlib-target/run_dir/*task_p200*.log' /home/bjackman/sources/lisa/results/ExecutorExample/rtapp:base:rta/1\n",
+ "2016-11-17 17:01:22,240 DEBUG : /usr/bin/scp -r brendan@192.168.0.1:/home/brendan/devlib-target/run_dir/rta_00.json /home/bjackman/sources/lisa/results/ExecutorExample/rtapp:base:rta/1\n",
+ "2016-11-17 17:01:22,493 DEBUG : sudo -- sh -c 'cat '\\''/sys/class/hwmon/hwmon0/energy2_input'\\'''\n",
+ "2016-11-17 17:01:23,400 DEBUG : sudo -- sh -c 'cat '\\''/sys/class/hwmon/hwmon0/energy3_input'\\'''\n",
+ "2016-11-17 17:01:24,205 DEBUG : Trace CPUFreq frequencies\n",
+ "2016-11-17 17:01:24,307 DEBUG : sudo -- sh -c '/home/brendan/devlib-target/bin/shutils cpufreq_trace_all_frequencies'\n",
+ "2016-11-17 17:01:25,213 DEBUG : sudo -- sh -c 'echo TRACE_MARKER_STOP > '\\''/sys/kernel/debug/tracing/trace_marker'\\'''\n",
+ "2016-11-17 17:01:25,915 DEBUG : sudo -- sh -c '/home/brendan/devlib-target/bin/trace-cmd stop'\n",
+ "2016-11-17 17:01:26,821 DEBUG : sudo -- sh -c '/home/brendan/devlib-target/bin/trace-cmd extract -o /home/brendan/devlib-target/trace.dat'\n",
+ "2016-11-17 17:01:28,593 DEBUG : /usr/bin/scp -r brendan@192.168.0.1:/home/brendan/devlib-target/trace.dat /home/bjackman/sources/lisa/results/ExecutorExample/rtapp:base:rta/1/trace.dat\n",
+ "05:01:35 INFO : Executor - Collected FTrace binary trace:\n",
+ "05:01:35 INFO : Executor - <res_dir>/rtapp:base:rta/1/trace.dat\n",
+ "05:01:35 INFO : Executor - Collected FTrace function profiling:\n",
+ "05:01:35 INFO : Executor - <res_dir>/rtapp:base:rta/1/trace_stat.json\n",
+ "05:01:35 INFO : --------------------------------------------------------------------------------\n",
+ "05:01:35 INFO : ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~\n",
+ "05:01:35 INFO : Executor - Experiment 1/4, [base:perf] 1/1\n",
+ "05:01:35 WARNING : Executor - FTrace events collection enabled\n",
+ "2016-11-17 17:01:35,737 DEBUG : sudo -- sh -c 'echo 81920 > '\\''/sys/kernel/debug/tracing/buffer_size_kb'\\'''\n",
+ "2016-11-17 17:01:36,440 DEBUG : sudo -- sh -c 'cat '\\''/sys/kernel/debug/tracing/buffer_size_kb'\\'''\n",
+ "2016-11-17 17:01:37,346 DEBUG : sudo -- sh -c '/home/brendan/devlib-target/bin/trace-cmd reset'\n",
+ "2016-11-17 17:01:38,888 DEBUG : sudo -- sh -c '/home/brendan/devlib-target/bin/trace-cmd start -e sched_switch -e sched_wakeup -e sched_wakeup_new -e cpu_frequency'\n",
+ "2016-11-17 17:01:40,434 DEBUG : sudo -- sh -c 'echo TRACE_MARKER_START > '\\''/sys/kernel/debug/tracing/trace_marker'\\'''\n",
+ "2016-11-17 17:01:41,037 DEBUG : Trace CPUFreq frequencies\n",
+ "2016-11-17 17:01:41,139 DEBUG : sudo -- sh -c '/home/brendan/devlib-target/bin/shutils cpufreq_trace_all_frequencies'\n",
+ "2016-11-17 17:01:42,045 DEBUG : sudo -- sh -c 'cat '\\''/sys/class/hwmon/hwmon0/energy2_input'\\'''\n",
+ "2016-11-17 17:01:42,951 DEBUG : sudo -- sh -c 'cat '\\''/sys/class/hwmon/hwmon0/energy3_input'\\'''\n",
+ "05:01:43 INFO : WlGen - Workload execution START:\n",
+ "05:01:43 INFO : WlGen - /home/brendan/devlib-target/bin/perf bench sched messaging --pipe --thread --group 1 --loop 10\n",
+ "2016-11-17 17:01:43,859 DEBUG : /home/brendan/devlib-target/bin/perf bench sched messaging --pipe --thread --group 1 --loop 10\n",
+ "05:01:44 INFO : PerfBench - Completion time: 0.012000, Performance 83.333333\n",
+ "2016-11-17 17:01:44,284 DEBUG : sudo -- sh -c 'cat '\\''/sys/class/hwmon/hwmon0/energy2_input'\\'''\n",
+ "2016-11-17 17:01:45,190 DEBUG : sudo -- sh -c 'cat '\\''/sys/class/hwmon/hwmon0/energy3_input'\\'''\n",
+ "2016-11-17 17:01:45,995 DEBUG : Trace CPUFreq frequencies\n",
+ "2016-11-17 17:01:46,097 DEBUG : sudo -- sh -c '/home/brendan/devlib-target/bin/shutils cpufreq_trace_all_frequencies'\n",
+ "2016-11-17 17:01:47,003 DEBUG : sudo -- sh -c 'echo TRACE_MARKER_STOP > '\\''/sys/kernel/debug/tracing/trace_marker'\\'''\n",
+ "2016-11-17 17:01:49,258 DEBUG : sudo -- sh -c '/home/brendan/devlib-target/bin/trace-cmd stop'\n",
+ "2016-11-17 17:01:50,164 DEBUG : sudo -- sh -c '/home/brendan/devlib-target/bin/trace-cmd extract -o /home/brendan/devlib-target/trace.dat'\n",
+ "2016-11-17 17:01:51,947 DEBUG : /usr/bin/scp -r brendan@192.168.0.1:/home/brendan/devlib-target/trace.dat /home/bjackman/sources/lisa/results/ExecutorExample/perf_bench_messaging:base:perf/1/trace.dat\n",
+ "05:01:52 INFO : Executor - Collected FTrace binary trace:\n",
+ "05:01:52 INFO : Executor - <res_dir>/perf_bench_messaging:base:perf/1/trace.dat\n",
+ "05:01:52 INFO : Executor - Collected FTrace function profiling:\n",
+ "05:01:52 INFO : Executor - <res_dir>/perf_bench_messaging:base:perf/1/trace_stat.json\n",
+ "05:01:52 INFO : --------------------------------------------------------------------------------\n",
+ "05:01:52 INFO : \n",
+ "05:01:52 INFO : ================================================================================\n",
+ "05:01:52 INFO : TargetConfig - configuring target for [eas] experiments\n",
+ "2016-11-17 17:01:52,740 DEBUG : sudo -- sh -c '[ -d /home/brendan/devlib-target/run_dir ] || mkdir /home/brendan/devlib-target/run_dir'\n",
+ "2016-11-17 17:01:53,646 DEBUG : sudo -- sh -c 'grep schedtest /proc/mounts || mount -t tmpfs -o size=1024m schedtest /home/brendan/devlib-target/run_dir'\n",
+ "05:01:54 INFO : SchedFeatures - Set scheduler feature: ENERGY_AWARE\n",
+ "2016-11-17 17:01:54,552 DEBUG : sudo -- sh -c 'echo ENERGY_AWARE > /sys/kernel/debug/sched_features'\n",
+ "05:01:55 INFO : CPUFreq - Configuring all CPUs to use [performance] governor\n",
+ "2016-11-17 17:01:55,460 DEBUG : sudo -- sh -c '/home/brendan/devlib-target/bin/shutils cpufreq_set_all_governors performance'\n",
+ "05:01:56 INFO : WlGen - Setup new workload rta\n",
+ "05:01:56 INFO : RTApp - Workload duration defined by longest task\n",
+ "05:01:56 INFO : RTApp - Default policy: SCHED_OTHER\n",
+ "05:01:56 INFO : RTApp - ------------------------\n",
+ "05:01:56 INFO : RTApp - task [task_p200], sched: using default policy\n",
+ "05:01:56 INFO : RTApp - | calibration CPU: 1\n",
+ "05:01:56 INFO : RTApp - | loops count: 1\n",
+ "05:01:56 INFO : RTApp - + phase_000001: duration 1.000000 [s] (10 loops)\n",
+ "05:01:56 INFO : RTApp - | period 100000 [us], duty_cycle 20 %\n",
+ "05:01:56 INFO : RTApp - | run_time 20000 [us], sleep_time 80000 [us]\n",
+ "2016-11-17 17:01:56,276 DEBUG : /usr/bin/scp -r rta_00.json brendan@192.168.0.1:/home/brendan/devlib-target/run_dir\n",
+ "2016-11-17 17:01:56,579 DEBUG : /home/brendan/devlib-target/bin/busybox uname -a\n",
+ "05:01:56 INFO : WlGen - Setup new workload perf\n",
+ "2016-11-17 17:01:57,022 DEBUG : /home/brendan/devlib-target/bin/busybox uname -a\n",
+ "05:01:57 INFO : ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~\n",
+ "05:01:57 INFO : Executor - Experiment 0/4, [base:rta] 1/1\n",
+ "05:01:57 WARNING : Executor - FTrace events collection enabled\n",
+ "2016-11-17 17:01:57,442 DEBUG : sudo -- sh -c 'echo 81920 > '\\''/sys/kernel/debug/tracing/buffer_size_kb'\\'''\n",
+ "2016-11-17 17:01:58,146 DEBUG : sudo -- sh -c 'cat '\\''/sys/kernel/debug/tracing/buffer_size_kb'\\'''\n",
+ "2016-11-17 17:01:59,052 DEBUG : sudo -- sh -c '/home/brendan/devlib-target/bin/trace-cmd reset'\n",
+ "2016-11-17 17:02:00,818 DEBUG : sudo -- sh -c '/home/brendan/devlib-target/bin/trace-cmd start -e sched_switch -e sched_wakeup -e sched_wakeup_new -e cpu_frequency'\n",
+ "2016-11-17 17:02:02,450 DEBUG : sudo -- sh -c 'echo TRACE_MARKER_START > '\\''/sys/kernel/debug/tracing/trace_marker'\\'''\n",
+ "2016-11-17 17:02:03,052 DEBUG : Trace CPUFreq frequencies\n",
+ "2016-11-17 17:02:03,154 DEBUG : sudo -- sh -c '/home/brendan/devlib-target/bin/shutils cpufreq_trace_all_frequencies'\n",
+ "2016-11-17 17:02:04,061 DEBUG : sudo -- sh -c 'cat '\\''/sys/class/hwmon/hwmon0/energy2_input'\\'''\n",
+ "2016-11-17 17:02:04,967 DEBUG : sudo -- sh -c 'cat '\\''/sys/class/hwmon/hwmon0/energy3_input'\\'''\n",
+ "05:02:05 INFO : WlGen - Workload execution START:\n",
+ "05:02:05 INFO : WlGen - /home/brendan/devlib-target/bin/rt-app /home/brendan/devlib-target/run_dir/rta_00.json 2>&1\n",
+ "2016-11-17 17:02:05,875 DEBUG : /home/brendan/devlib-target/bin/rt-app /home/brendan/devlib-target/run_dir/rta_00.json 2>&1\n",
+ "2016-11-17 17:02:07,294 DEBUG : /usr/bin/scp -r brendan@192.168.0.1:'/home/brendan/devlib-target/run_dir/*task_p200*.log' /home/bjackman/sources/lisa/results/ExecutorExample/rtapp:base:rta/1\n",
+ "2016-11-17 17:02:07,464 DEBUG : /usr/bin/scp -r brendan@192.168.0.1:/home/brendan/devlib-target/run_dir/rta_00.json /home/bjackman/sources/lisa/results/ExecutorExample/rtapp:base:rta/1\n",
+ "2016-11-17 17:02:07,734 DEBUG : sudo -- sh -c 'cat '\\''/sys/class/hwmon/hwmon0/energy2_input'\\'''\n",
+ "2016-11-17 17:02:08,640 DEBUG : sudo -- sh -c 'cat '\\''/sys/class/hwmon/hwmon0/energy3_input'\\'''\n",
+ "2016-11-17 17:02:09,446 DEBUG : Trace CPUFreq frequencies\n",
+ "2016-11-17 17:02:09,548 DEBUG : sudo -- sh -c '/home/brendan/devlib-target/bin/shutils cpufreq_trace_all_frequencies'\n",
+ "2016-11-17 17:02:10,453 DEBUG : sudo -- sh -c 'echo TRACE_MARKER_STOP > '\\''/sys/kernel/debug/tracing/trace_marker'\\'''\n",
+ "2016-11-17 17:02:11,156 DEBUG : sudo -- sh -c '/home/brendan/devlib-target/bin/trace-cmd stop'\n",
+ "2016-11-17 17:02:12,062 DEBUG : sudo -- sh -c '/home/brendan/devlib-target/bin/trace-cmd extract -o /home/brendan/devlib-target/trace.dat'\n",
+ "2016-11-17 17:02:14,012 DEBUG : /usr/bin/scp -r brendan@192.168.0.1:/home/brendan/devlib-target/trace.dat /home/bjackman/sources/lisa/results/ExecutorExample/rtapp:base:rta/1/trace.dat\n",
+ "05:02:14 INFO : Executor - Collected FTrace binary trace:\n",
+ "05:02:14 INFO : Executor - <res_dir>/rtapp:base:rta/1/trace.dat\n",
+ "05:02:14 INFO : Executor - Collected FTrace function profiling:\n",
+ "05:02:14 INFO : Executor - <res_dir>/rtapp:base:rta/1/trace_stat.json\n",
+ "05:02:14 INFO : --------------------------------------------------------------------------------\n",
+ "05:02:14 INFO : ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~\n",
+ "05:02:14 INFO : Executor - Experiment 1/4, [base:perf] 1/1\n",
+ "05:02:14 WARNING : Executor - FTrace events collection enabled\n",
+ "2016-11-17 17:02:14,771 DEBUG : sudo -- sh -c 'echo 81920 > '\\''/sys/kernel/debug/tracing/buffer_size_kb'\\'''\n",
+ "2016-11-17 17:02:15,473 DEBUG : sudo -- sh -c 'cat '\\''/sys/kernel/debug/tracing/buffer_size_kb'\\'''\n",
+ "2016-11-17 17:02:16,379 DEBUG : sudo -- sh -c '/home/brendan/devlib-target/bin/trace-cmd reset'\n",
+ "2016-11-17 17:02:18,021 DEBUG : sudo -- sh -c '/home/brendan/devlib-target/bin/trace-cmd start -e sched_switch -e sched_wakeup -e sched_wakeup_new -e cpu_frequency'\n",
+ "2016-11-17 17:02:19,703 DEBUG : sudo -- sh -c 'echo TRACE_MARKER_START > '\\''/sys/kernel/debug/tracing/trace_marker'\\'''\n",
+ "2016-11-17 17:02:20,305 DEBUG : Trace CPUFreq frequencies\n",
+ "2016-11-17 17:02:20,407 DEBUG : sudo -- sh -c '/home/brendan/devlib-target/bin/shutils cpufreq_trace_all_frequencies'\n",
+ "2016-11-17 17:02:21,313 DEBUG : sudo -- sh -c 'cat '\\''/sys/class/hwmon/hwmon0/energy2_input'\\'''\n",
+ "2016-11-17 17:02:22,219 DEBUG : sudo -- sh -c 'cat '\\''/sys/class/hwmon/hwmon0/energy3_input'\\'''\n",
+ "05:02:23 INFO : WlGen - Workload execution START:\n",
+ "05:02:23 INFO : WlGen - /home/brendan/devlib-target/bin/perf bench sched messaging --pipe --thread --group 1 --loop 10\n",
+ "2016-11-17 17:02:23,127 DEBUG : /home/brendan/devlib-target/bin/perf bench sched messaging --pipe --thread --group 1 --loop 10\n",
+ "05:02:23 INFO : PerfBench - Completion time: 0.080000, Performance 12.500000\n",
+ "2016-11-17 17:02:23,628 DEBUG : sudo -- sh -c 'cat '\\''/sys/class/hwmon/hwmon0/energy2_input'\\'''\n",
+ "2016-11-17 17:02:24,534 DEBUG : sudo -- sh -c 'cat '\\''/sys/class/hwmon/hwmon0/energy3_input'\\'''\n",
+ "2016-11-17 17:02:25,340 DEBUG : Trace CPUFreq frequencies\n",
+ "2016-11-17 17:02:25,442 DEBUG : sudo -- sh -c '/home/brendan/devlib-target/bin/shutils cpufreq_trace_all_frequencies'\n",
+ "2016-11-17 17:02:26,347 DEBUG : sudo -- sh -c 'echo TRACE_MARKER_STOP > '\\''/sys/kernel/debug/tracing/trace_marker'\\'''\n",
+ "2016-11-17 17:02:27,050 DEBUG : sudo -- sh -c '/home/brendan/devlib-target/bin/trace-cmd stop'\n",
+ "2016-11-17 17:02:27,956 DEBUG : sudo -- sh -c '/home/brendan/devlib-target/bin/trace-cmd extract -o /home/brendan/devlib-target/trace.dat'\n",
+ "2016-11-17 17:02:30,090 DEBUG : /usr/bin/scp -r brendan@192.168.0.1:/home/brendan/devlib-target/trace.dat /home/bjackman/sources/lisa/results/ExecutorExample/perf_bench_messaging:base:perf/1/trace.dat\n",
+ "05:02:30 INFO : Executor - Collected FTrace binary trace:\n",
+ "05:02:30 INFO : Executor - <res_dir>/perf_bench_messaging:base:perf/1/trace.dat\n",
+ "05:02:30 INFO : Executor - Collected FTrace function profiling:\n",
+ "05:02:30 INFO : Executor - <res_dir>/perf_bench_messaging:base:perf/1/trace_stat.json\n",
+ "05:02:30 INFO : --------------------------------------------------------------------------------\n",
+ "05:02:30 INFO : ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~\n",
+ "05:02:30 INFO : Executor - Experiment 2/4, [eas:rta] 1/1\n",
+ "05:02:30 WARNING : Executor - FTrace events collection enabled\n",
+ "2016-11-17 17:02:30,869 DEBUG : sudo -- sh -c 'echo 81920 > '\\''/sys/kernel/debug/tracing/buffer_size_kb'\\'''\n",
+ "2016-11-17 17:02:31,572 DEBUG : sudo -- sh -c 'cat '\\''/sys/kernel/debug/tracing/buffer_size_kb'\\'''\n",
+ "2016-11-17 17:02:32,478 DEBUG : sudo -- sh -c '/home/brendan/devlib-target/bin/trace-cmd reset'\n",
+ "2016-11-17 17:02:34,271 DEBUG : sudo -- sh -c '/home/brendan/devlib-target/bin/trace-cmd start -e sched_switch -e sched_wakeup -e sched_wakeup_new -e cpu_frequency'\n",
+ "2016-11-17 17:02:35,963 DEBUG : sudo -- sh -c 'echo TRACE_MARKER_START > '\\''/sys/kernel/debug/tracing/trace_marker'\\'''\n",
+ "2016-11-17 17:02:36,565 DEBUG : Trace CPUFreq frequencies\n",
+ "2016-11-17 17:02:36,667 DEBUG : sudo -- sh -c '/home/brendan/devlib-target/bin/shutils cpufreq_trace_all_frequencies'\n",
+ "2016-11-17 17:02:37,573 DEBUG : sudo -- sh -c 'cat '\\''/sys/class/hwmon/hwmon0/energy2_input'\\'''\n",
+ "2016-11-17 17:02:38,479 DEBUG : sudo -- sh -c 'cat '\\''/sys/class/hwmon/hwmon0/energy3_input'\\'''\n",
+ "05:02:39 INFO : WlGen - Workload execution START:\n",
+ "05:02:39 INFO : WlGen - /home/brendan/devlib-target/bin/rt-app /home/brendan/devlib-target/run_dir/rta_00.json 2>&1\n",
+ "2016-11-17 17:02:39,387 DEBUG : /home/brendan/devlib-target/bin/rt-app /home/brendan/devlib-target/run_dir/rta_00.json 2>&1\n",
+ "2016-11-17 17:02:40,807 DEBUG : /usr/bin/scp -r brendan@192.168.0.1:'/home/brendan/devlib-target/run_dir/*task_p200*.log' /home/bjackman/sources/lisa/results/ExecutorExample/rtapp:eas:rta/1\n",
+ "2016-11-17 17:02:40,980 DEBUG : /usr/bin/scp -r brendan@192.168.0.1:/home/brendan/devlib-target/run_dir/rta_00.json /home/bjackman/sources/lisa/results/ExecutorExample/rtapp:eas:rta/1\n",
+ "2016-11-17 17:02:41,231 DEBUG : sudo -- sh -c 'cat '\\''/sys/class/hwmon/hwmon0/energy2_input'\\'''\n",
+ "2016-11-17 17:02:42,137 DEBUG : sudo -- sh -c 'cat '\\''/sys/class/hwmon/hwmon0/energy3_input'\\'''\n",
+ "2016-11-17 17:02:42,943 DEBUG : Trace CPUFreq frequencies\n",
+ "2016-11-17 17:02:43,045 DEBUG : sudo -- sh -c '/home/brendan/devlib-target/bin/shutils cpufreq_trace_all_frequencies'\n",
+ "2016-11-17 17:02:43,950 DEBUG : sudo -- sh -c 'echo TRACE_MARKER_STOP > '\\''/sys/kernel/debug/tracing/trace_marker'\\'''\n",
+ "2016-11-17 17:02:44,653 DEBUG : sudo -- sh -c '/home/brendan/devlib-target/bin/trace-cmd stop'\n",
+ "2016-11-17 17:02:45,559 DEBUG : sudo -- sh -c '/home/brendan/devlib-target/bin/trace-cmd extract -o /home/brendan/devlib-target/trace.dat'\n",
+ "2016-11-17 17:02:47,519 DEBUG : /usr/bin/scp -r brendan@192.168.0.1:/home/brendan/devlib-target/trace.dat /home/bjackman/sources/lisa/results/ExecutorExample/rtapp:eas:rta/1/trace.dat\n",
+ "05:02:48 INFO : Executor - Collected FTrace binary trace:\n",
+ "05:02:48 INFO : Executor - <res_dir>/rtapp:eas:rta/1/trace.dat\n",
+ "05:02:48 INFO : Executor - Collected FTrace function profiling:\n",
+ "05:02:48 INFO : Executor - <res_dir>/rtapp:eas:rta/1/trace_stat.json\n",
+ "05:02:48 INFO : --------------------------------------------------------------------------------\n",
+ "05:02:48 INFO : ~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~\n",
+ "05:02:48 INFO : Executor - Experiment 3/4, [eas:perf] 1/1\n",
+ "05:02:48 WARNING : Executor - FTrace events collection enabled\n",
+ "2016-11-17 17:02:48,276 DEBUG : sudo -- sh -c 'echo 81920 > '\\''/sys/kernel/debug/tracing/buffer_size_kb'\\'''\n",
+ "2016-11-17 17:02:48,979 DEBUG : sudo -- sh -c 'cat '\\''/sys/kernel/debug/tracing/buffer_size_kb'\\'''\n",
+ "2016-11-17 17:02:49,885 DEBUG : sudo -- sh -c '/home/brendan/devlib-target/bin/trace-cmd reset'\n",
+ "2016-11-17 17:02:51,485 DEBUG : sudo -- sh -c '/home/brendan/devlib-target/bin/trace-cmd start -e sched_switch -e sched_wakeup -e sched_wakeup_new -e cpu_frequency'\n",
+ "2016-11-17 17:02:53,160 DEBUG : sudo -- sh -c 'echo TRACE_MARKER_START > '\\''/sys/kernel/debug/tracing/trace_marker'\\'''\n",
+ "2016-11-17 17:02:53,763 DEBUG : Trace CPUFreq frequencies\n",
+ "2016-11-17 17:02:53,865 DEBUG : sudo -- sh -c '/home/brendan/devlib-target/bin/shutils cpufreq_trace_all_frequencies'\n",
+ "2016-11-17 17:02:54,771 DEBUG : sudo -- sh -c 'cat '\\''/sys/class/hwmon/hwmon0/energy2_input'\\'''\n",
+ "2016-11-17 17:02:55,676 DEBUG : sudo -- sh -c 'cat '\\''/sys/class/hwmon/hwmon0/energy3_input'\\'''\n",
+ "05:02:56 INFO : WlGen - Workload execution START:\n",
+ "05:02:56 INFO : WlGen - /home/brendan/devlib-target/bin/perf bench sched messaging --pipe --thread --group 1 --loop 10\n",
+ "2016-11-17 17:02:56,585 DEBUG : /home/brendan/devlib-target/bin/perf bench sched messaging --pipe --thread --group 1 --loop 10\n",
+ "05:02:56 INFO : PerfBench - Completion time: 0.083000, Performance 12.048193\n",
+ "2016-11-17 17:02:57,088 DEBUG : sudo -- sh -c 'cat '\\''/sys/class/hwmon/hwmon0/energy2_input'\\'''\n",
+ "2016-11-17 17:02:57,994 DEBUG : sudo -- sh -c 'cat '\\''/sys/class/hwmon/hwmon0/energy3_input'\\'''\n",
+ "2016-11-17 17:02:58,799 DEBUG : Trace CPUFreq frequencies\n",
+ "2016-11-17 17:02:58,901 DEBUG : sudo -- sh -c '/home/brendan/devlib-target/bin/shutils cpufreq_trace_all_frequencies'\n",
+ "2016-11-17 17:02:59,807 DEBUG : sudo -- sh -c 'echo TRACE_MARKER_STOP > '\\''/sys/kernel/debug/tracing/trace_marker'\\'''\n",
+ "2016-11-17 17:03:00,510 DEBUG : sudo -- sh -c '/home/brendan/devlib-target/bin/trace-cmd stop'\n",
+ "2016-11-17 17:03:01,415 DEBUG : sudo -- sh -c '/home/brendan/devlib-target/bin/trace-cmd extract -o /home/brendan/devlib-target/trace.dat'\n",
+ "2016-11-17 17:03:03,385 DEBUG : /usr/bin/scp -r brendan@192.168.0.1:/home/brendan/devlib-target/trace.dat /home/bjackman/sources/lisa/results/ExecutorExample/perf_bench_messaging:eas:perf/1/trace.dat\n",
+ "05:03:04 INFO : Executor - Collected FTrace binary trace:\n",
+ "05:03:04 INFO : Executor - <res_dir>/perf_bench_messaging:eas:perf/1/trace.dat\n",
+ "05:03:04 INFO : Executor - Collected FTrace function profiling:\n",
+ "05:03:04 INFO : Executor - <res_dir>/perf_bench_messaging:eas:perf/1/trace_stat.json\n",
+ "05:03:04 INFO : --------------------------------------------------------------------------------\n",
+ "05:03:04 INFO : \n",
+ "05:03:04 INFO : ################################################################################\n",
+ "05:03:04 INFO : Executor - Experiments execution completed\n",
+ "05:03:04 INFO : ################################################################################\n",
+ "05:03:04 INFO : Executor - Results available in:\n",
+ "05:03:04 INFO : Executor - /home/bjackman/sources/lisa/results/ExecutorExample\n"
]
}
],
@@ -348,9 +616,10 @@
"name": "stdout",
"output_type": "stream",
"text": [
- "\u001b[01;34m/home/derkling/Code/lisa/results/ExecutorExample\u001b[00m\r\n",
+ "\u001b[01;34m/home/bjackman/sources/lisa/results/ExecutorExample\u001b[00m\r\n",
"├── \u001b[01;34mperf_bench_messaging:base:perf\u001b[00m\r\n",
"│ ├── \u001b[01;34m1\u001b[00m\r\n",
+ "│ │ ├── energy.json\r\n",
"│ │ ├── output.log\r\n",
"│ │ ├── performance.json\r\n",
"│ │ └── trace.dat\r\n",
@@ -359,6 +628,7 @@
"│ └── platform.json\r\n",
"├── \u001b[01;34mperf_bench_messaging:eas:perf\u001b[00m\r\n",
"│ ├── \u001b[01;34m1\u001b[00m\r\n",
+ "│ │ ├── energy.json\r\n",
"│ │ ├── output.log\r\n",
"│ │ ├── performance.json\r\n",
"│ │ └── trace.dat\r\n",
@@ -367,24 +637,26 @@
"│ └── platform.json\r\n",
"├── \u001b[01;34mrtapp:base:rta\u001b[00m\r\n",
"│ ├── \u001b[01;34m1\u001b[00m\r\n",
+ "│ │ ├── energy.json\r\n",
"│ │ ├── output.log\r\n",
"│ │ ├── rta_00.json\r\n",
- "│ │ ├── rt-app-task_p20-0.log\r\n",
+ "│ │ ├── rt-app-task_p200-0.log\r\n",
"│ │ └── trace.dat\r\n",
"│ ├── kernel.config\r\n",
"│ ├── kernel.version\r\n",
"│ └── platform.json\r\n",
"└── \u001b[01;34mrtapp:eas:rta\u001b[00m\r\n",
" ├── \u001b[01;34m1\u001b[00m\r\n",
+ " │ ├── energy.json\r\n",
" │ ├── output.log\r\n",
" │ ├── rta_00.json\r\n",
- " │ ├── rt-app-task_p20-0.log\r\n",
+ " │ ├── rt-app-task_p200-0.log\r\n",
" │ └── trace.dat\r\n",
" ├── kernel.config\r\n",
" ├── kernel.version\r\n",
" └── platform.json\r\n",
"\r\n",
- "8 directories, 26 files\r\n"
+ "8 directories, 30 files\r\n"
]
}
],
@@ -409,7 +681,7 @@
"name": "python",
"nbconvert_exporter": "python",
"pygments_lexer": "ipython2",
- "version": "2.7.9"
+ "version": "2.7.6"
}
},
"nbformat": 4,