python3 -u test.py
RUN ./ol new -p=test-dir
PUSH conf: {'registry': '/root/open-lambda/test-registry'}
========================================
ping_test
========================================
RUN ./ol worker -p=test-dir --detach
RUN ./ol kill -p=test-dir
{
  "test": "ping_test",
  "params": {},
  "pass": true,
  "seconds": 2.1414694786071777,
  "total_seconds": 2.446720838546753,
  "stats": {
    "pings_per_sec": 466.9732241329056
  },
  "ol-stats": {},
  "conf": {
    "limits": {
      "procs": 10,
      "mem_mb": 50,
      "installer_mem_mb": 200
    },
    "handler_cache_mb": 250,
    "worker_dir": "/root/open-lambda/test-dir/worker",
    "pip_mirror": "",
    "sandbox_config": {},
    "docker_runtime": "",
    "import_cache_mb": 250,
    "server_mode": "lambda",
    "SOCK_base_path": "/root/open-lambda/test-dir/lambda",
    "registry_cache_ms": 5000,
    "Pkgs_dir": "/root/open-lambda/test-dir/lambda/packages",
    "worker_port": "5000",
    "sandbox": "sock",
    "registry": "/root/open-lambda/test-registry"
  },
  "errors": [],
  "worker_tail": [
    "2019/07/06 21:42:37 remove /sys/fs/cgroup/freezer/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:42:37 remove /sys/fs/cgroup/hugetlb/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:42:37 remove /sys/fs/cgroup/memory/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:42:37 remove /sys/fs/cgroup/perf_event/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:42:37 remove /sys/fs/cgroup/systemd/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:42:37 remove /sys/fs/cgroup/pids/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:42:37 save stats to /root/open-lambda/test-dir/worker/stats.json",
    "2019/07/06 21:42:37 remove worker.pid",
    "2019/07/06 21:42:37 exiting",
    ""
  ]
}
PUSH conf: {'import_cache_mb': 0, 'handler_cache_mb': 500}
========================================
install_tests
========================================
RUN ./ol worker -p=test-dir --detach
RUN ./ol kill -p=test-dir
{
  "test": "install_tests",
  "params": {},
  "pass": true,
  "seconds": 11.744552612304688,
  "total_seconds": 11.98290467262268,
  "stats": null,
  "ol-stats": {
    "Channel():ms.avg": 0,
    "Channel():ms.cnt": 11,
    "Create()/acquire-cgroup:ms.avg": 0,
    "Create()/acquire-cgroup:ms.cnt": 11,
    "Create()/acquire-mem:ms.avg": 0,
    "Create()/acquire-mem:ms.cnt": 11,
    "Create()/fresh-proc:ms.avg": 260,
    "Create()/fresh-proc:ms.cnt": 11,
    "Create()/make-root-fs:ms.avg": 1,
    "Create()/make-root-fs:ms.cnt": 11,
    "Create():ms.avg": 262,
    "Create():ms.cnt": 11,
    "Destroy()/detach-root:ms.avg": 0,
    "Destroy()/detach-root:ms.cnt": 11,
    "Destroy()/kill-procs:ms.avg": 1,
    "Destroy()/kill-procs:ms.cnt": 11,
    "Destroy()/remove-root:ms.avg": 0,
    "Destroy()/remove-root:ms.cnt": 11,
    "Destroy():ms.avg": 2,
    "Destroy():ms.cnt": 11,
    "Pause():ms.avg": 3,
    "Pause():ms.cnt": 4,
    "Status():ms.avg": 0,
    "Status():ms.cnt": 7,
    "pip-install:ms.avg": 1331,
    "pip-install:ms.cnt": 7
  },
  "conf": {
    "limits": {
      "procs": 10,
      "mem_mb": 50,
      "installer_mem_mb": 200
    },
    "handler_cache_mb": 500,
    "worker_dir": "/root/open-lambda/test-dir/worker",
    "pip_mirror": "",
    "sandbox_config": {},
    "docker_runtime": "",
    "import_cache_mb": 0,
    "server_mode": "lambda",
    "SOCK_base_path": "/root/open-lambda/test-dir/lambda",
    "registry_cache_ms": 5000,
    "Pkgs_dir": "/root/open-lambda/test-dir/lambda/packages",
    "worker_port": "5000",
    "sandbox": "sock",
    "registry": "/root/open-lambda/test-registry"
  },
  "errors": [],
  "worker_tail": [
    "2019/07/06 21:42:49 remove /sys/fs/cgroup/freezer/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:42:49 remove /sys/fs/cgroup/hugetlb/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:42:49 remove /sys/fs/cgroup/memory/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:42:49 remove /sys/fs/cgroup/perf_event/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:42:49 remove /sys/fs/cgroup/systemd/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:42:49 remove /sys/fs/cgroup/pids/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:42:49 save stats to /root/open-lambda/test-dir/worker/stats.json",
    "2019/07/06 21:42:49 remove worker.pid",
    "2019/07/06 21:42:49 exiting",
    ""
  ]
}
POP conf: {'import_cache_mb': 0, 'handler_cache_mb': 500}
PUSH conf: {'import_cache_mb': 250, 'handler_cache_mb': 250}
========================================
install_tests
========================================
RUN ./ol worker -p=test-dir --detach
RUN ./ol kill -p=test-dir
{
  "test": "install_tests",
  "params": {},
  "pass": true,
  "seconds": 8.329689741134644,
  "total_seconds": 8.55561375617981,
  "stats": null,
  "ol-stats": {
    "Channel():ms.avg": 0,
    "Channel():ms.cnt": 11,
    "Create()/acquire-cgroup:ms.avg": 0,
    "Create()/acquire-cgroup:ms.cnt": 12,
    "Create()/acquire-mem:ms.avg": 0,
    "Create()/acquire-mem:ms.cnt": 12,
    "Create()/fork-proc:ms.avg": 5,
    "Create()/fork-proc:ms.cnt": 4,
    "Create()/fresh-proc:ms.avg": 137,
    "Create()/fresh-proc:ms.cnt": 8,
    "Create()/make-root-fs:ms.avg": 1,
    "Create()/make-root-fs:ms.cnt": 12,
    "Create():ms.avg": 95,
    "Create():ms.cnt": 12,
    "Destroy()/detach-root:ms.avg": 0,
    "Destroy()/detach-root:ms.cnt": 12,
    "Destroy()/kill-procs:ms.avg": 2,
    "Destroy()/kill-procs:ms.cnt": 12,
    "Destroy()/remove-root:ms.avg": 0,
    "Destroy()/remove-root:ms.cnt": 12,
    "Destroy():ms.avg": 2,
    "Destroy():ms.cnt": 15,
    "Pause():ms.avg": 3,
    "Pause():ms.cnt": 4,
    "Status():ms.avg": 0,
    "Status():ms.cnt": 7,
    "evict:ms.avg": 4,
    "evict:ms.cnt": 3,
    "fork():ms.avg": 5,
    "fork():ms.cnt": 4,
    "forkRequest:ms.avg": 5,
    "forkRequest:ms.cnt": 4,
    "move-to-cg-after-fork:ms.avg": 0,
    "move-to-cg-after-fork:ms.cnt": 4,
    "pip-install:ms.avg": 1101,
    "pip-install:ms.cnt": 7
  },
  "conf": {
    "limits": {
      "procs": 10,
      "mem_mb": 50,
      "installer_mem_mb": 200
    },
    "handler_cache_mb": 250,
    "worker_dir": "/root/open-lambda/test-dir/worker",
    "sandbox_config": {},
    "registry": "/root/open-lambda/test-registry",
    "docker_runtime": "",
    "import_cache_mb": 250,
    "server_mode": "lambda",
    "SOCK_base_path": "/root/open-lambda/test-dir/lambda",
    "sandbox": "sock",
    "Pkgs_dir": "/root/open-lambda/test-dir/lambda/packages",
    "worker_port": "5000",
    "registry_cache_ms": 5000,
    "pip_mirror": ""
  },
  "errors": [],
  "worker_tail": [
    "2019/07/06 21:42:57 remove /sys/fs/cgroup/freezer/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:42:57 remove /sys/fs/cgroup/hugetlb/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:42:57 remove /sys/fs/cgroup/memory/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:42:57 remove /sys/fs/cgroup/perf_event/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:42:57 remove /sys/fs/cgroup/systemd/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:42:57 remove /sys/fs/cgroup/pids/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:42:57 save stats to /root/open-lambda/test-dir/worker/stats.json",
    "2019/07/06 21:42:57 remove worker.pid",
    "2019/07/06 21:42:57 exiting",
    ""
  ]
}
POP conf: {'import_cache_mb': 250, 'handler_cache_mb': 250}
PUSH conf: {'import_cache_mb': 0, 'handler_cache_mb': 500, 'sandbox': 'docker'}
========================================
install_tests
========================================
RUN ./ol worker -p=test-dir --detach
RUN ./ol kill -p=test-dir
{
  "test": "install_tests",
  "params": {},
  "pass": true,
  "seconds": 20.13114905357361,
  "total_seconds": 21.18016529083252,
  "stats": null,
  "ol-stats": {
    "Channel():ms.avg": 0,
    "Channel():ms.cnt": 22,
    "Create():ms.avg": 826,
    "Create():ms.cnt": 11,
    "Destroy():ms.avg": 237,
    "Destroy():ms.cnt": 22,
    "Pause():ms.avg": 28,
    "Pause():ms.cnt": 8,
    "Status():ms.avg": 0,
    "Status():ms.cnt": 14,
    "pip-install:ms.avg": 2052,
    "pip-install:ms.cnt": 7
  },
  "conf": {
    "limits": {
      "procs": 10,
      "mem_mb": 50,
      "installer_mem_mb": 200
    },
    "handler_cache_mb": 500,
    "worker_dir": "/root/open-lambda/test-dir/worker",
    "pip_mirror": "",
    "sandbox_config": {},
    "docker_runtime": "",
    "import_cache_mb": 0,
    "server_mode": "lambda",
    "SOCK_base_path": "/root/open-lambda/test-dir/lambda",
    "registry_cache_ms": 5000,
    "Pkgs_dir": "/root/open-lambda/test-dir/lambda/packages",
    "worker_port": "5000",
    "sandbox": "docker",
    "registry": "/root/open-lambda/test-registry"
  },
  "errors": [],
  "worker_tail": [
    "Kill function: install2019/07/06 21:43:18 Destroy() [SB 7]",
    "2019/07/06 21:43:18 Destroy() [SB 7]",
    "Kill function: install22019/07/06 21:43:18 Destroy() [SB 8]",
    "2019/07/06 21:43:18 Destroy() [SB 8]",
    "Kill function: install32019/07/06 21:43:18 Destroy() [SB 10]",
    "2019/07/06 21:43:18 Destroy() [SB 10]",
    "2019/07/06 21:43:19 save stats to /root/open-lambda/test-dir/worker/stats.json",
    "2019/07/06 21:43:19 remove worker.pid",
    "2019/07/06 21:43:19 exiting",
    ""
  ]
}
POP conf: {'import_cache_mb': 0, 'handler_cache_mb': 500, 'sandbox': 'docker'}
========================================
fork_bomb
========================================
RUN ./ol worker -p=test-dir --detach
RUN ./ol kill -p=test-dir
{
  "test": "fork_bomb",
  "params": {},
  "pass": true,
  "seconds": 0.317063570022583,
  "total_seconds": 0.5410611629486084,
  "stats": null,
  "ol-stats": {
    "Channel():ms.avg": 0,
    "Channel():ms.cnt": 1,
    "Create()/acquire-cgroup:ms.avg": 0,
    "Create()/acquire-cgroup:ms.cnt": 2,
    "Create()/acquire-mem:ms.avg": 0,
    "Create()/acquire-mem:ms.cnt": 2,
    "Create()/fork-proc:ms.avg": 6,
    "Create()/fork-proc:ms.cnt": 1,
    "Create()/fresh-proc:ms.avg": 279,
    "Create()/fresh-proc:ms.cnt": 1,
    "Create()/make-root-fs:ms.avg": 2,
    "Create()/make-root-fs:ms.cnt": 2,
    "Create():ms.avg": 145,
    "Create():ms.cnt": 2,
    "Destroy()/detach-root:ms.avg": 1,
    "Destroy()/detach-root:ms.cnt": 2,
    "Destroy()/kill-procs:ms.avg": 0,
    "Destroy()/kill-procs:ms.cnt": 2,
    "Destroy()/remove-root:ms.avg": 0,
    "Destroy()/remove-root:ms.cnt": 2,
    "Destroy():ms.avg": 3,
    "Destroy():ms.cnt": 2,
    "Pause():ms.avg": 4,
    "Pause():ms.cnt": 1,
    "fork():ms.avg": 6,
    "fork():ms.cnt": 1,
    "forkRequest:ms.avg": 4,
    "forkRequest:ms.cnt": 1,
    "move-to-cg-after-fork:ms.avg": 2,
    "move-to-cg-after-fork:ms.cnt": 1
  },
  "conf": {
    "limits": {
      "procs": 10,
      "mem_mb": 50,
      "installer_mem_mb": 200
    },
    "handler_cache_mb": 250,
    "worker_dir": "/root/open-lambda/test-dir/worker",
    "sandbox_config": {},
    "registry": "/root/open-lambda/test-registry",
    "docker_runtime": "",
    "import_cache_mb": 250,
    "server_mode": "lambda",
    "SOCK_base_path": "/root/open-lambda/test-dir/lambda",
    "sandbox": "sock",
    "Pkgs_dir": "/root/open-lambda/test-dir/lambda/packages",
    "worker_port": "5000",
    "registry_cache_ms": 5000,
    "pip_mirror": ""
  },
  "errors": [],
  "worker_tail": [
    "2019/07/06 21:43:19 remove /sys/fs/cgroup/freezer/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:43:19 remove /sys/fs/cgroup/hugetlb/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:43:19 remove /sys/fs/cgroup/memory/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:43:19 remove /sys/fs/cgroup/perf_event/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:43:19 remove /sys/fs/cgroup/systemd/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:43:19 remove /sys/fs/cgroup/pids/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:43:19 save stats to /root/open-lambda/test-dir/worker/stats.json",
    "2019/07/06 21:43:19 remove worker.pid",
    "2019/07/06 21:43:19 exiting",
    ""
  ]
}
========================================
max_mem_alloc
========================================
RUN ./ol worker -p=test-dir --detach
RUN ./ol kill -p=test-dir
{
  "test": "max_mem_alloc",
  "params": {},
  "pass": true,
  "seconds": 0.851834774017334,
  "total_seconds": 1.0798296928405762,
  "stats": null,
  "ol-stats": {
    "Channel():ms.avg": 0,
    "Channel():ms.cnt": 1,
    "Create()/acquire-cgroup:ms.avg": 0,
    "Create()/acquire-cgroup:ms.cnt": 2,
    "Create()/acquire-mem:ms.avg": 0,
    "Create()/acquire-mem:ms.cnt": 2,
    "Create()/fork-proc:ms.avg": 8,
    "Create()/fork-proc:ms.cnt": 1,
    "Create()/fresh-proc:ms.avg": 135,
    "Create()/fresh-proc:ms.cnt": 1,
    "Create()/make-root-fs:ms.avg": 4,
    "Create()/make-root-fs:ms.cnt": 2,
    "Create():ms.avg": 76,
    "Create():ms.cnt": 2,
    "Destroy()/detach-root:ms.avg": 1,
    "Destroy()/detach-root:ms.cnt": 2,
    "Destroy()/kill-procs:ms.avg": 0,
    "Destroy()/kill-procs:ms.cnt": 2,
    "Destroy()/remove-root:ms.avg": 0,
    "Destroy()/remove-root:ms.cnt": 2,
    "Destroy():ms.avg": 2,
    "Destroy():ms.cnt": 2,
    "Pause():ms.avg": 3,
    "Pause():ms.cnt": 1,
    "fork():ms.avg": 7,
    "fork():ms.cnt": 1,
    "forkRequest:ms.avg": 7,
    "forkRequest:ms.cnt": 1,
    "move-to-cg-after-fork:ms.avg": 0,
    "move-to-cg-after-fork:ms.cnt": 1
  },
  "conf": {
    "limits": {
      "procs": 10,
      "mem_mb": 50,
      "installer_mem_mb": 200
    },
    "handler_cache_mb": 250,
    "worker_dir": "/root/open-lambda/test-dir/worker",
    "sandbox_config": {},
    "registry": "/root/open-lambda/test-registry",
    "docker_runtime": "",
    "import_cache_mb": 250,
    "server_mode": "lambda",
    "SOCK_base_path": "/root/open-lambda/test-dir/lambda",
    "sandbox": "sock",
    "Pkgs_dir": "/root/open-lambda/test-dir/lambda/packages",
    "worker_port": "5000",
    "registry_cache_ms": 5000,
    "pip_mirror": ""
  },
  "errors": [],
  "worker_tail": [
    "2019/07/06 21:43:20 remove /sys/fs/cgroup/freezer/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:43:20 remove /sys/fs/cgroup/hugetlb/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:43:20 remove /sys/fs/cgroup/memory/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:43:20 remove /sys/fs/cgroup/perf_event/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:43:20 remove /sys/fs/cgroup/systemd/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:43:20 remove /sys/fs/cgroup/pids/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:43:20 save stats to /root/open-lambda/test-dir/worker/stats.json",
    "2019/07/06 21:43:20 remove worker.pid",
    "2019/07/06 21:43:20 exiting",
    ""
  ]
}
PUSH conf: {'import_cache_mb': 250, 'handler_cache_mb': 250}
========================================
numpy_test
========================================
RUN ./ol worker -p=test-dir --detach
RUN ./ol kill -p=test-dir
{
  "test": "numpy_test",
  "params": {},
  "pass": true,
  "seconds": 10.264518022537231,
  "total_seconds": 10.500930309295654,
  "stats": null,
  "ol-stats": {
    "Channel():ms.avg": 0,
    "Channel():ms.cnt": 5,
    "Create()/acquire-cgroup:ms.avg": 0,
    "Create()/acquire-cgroup:ms.cnt": 6,
    "Create()/acquire-mem:ms.avg": 0,
    "Create()/acquire-mem:ms.cnt": 6,
    "Create()/fork-proc:ms.avg": 5,
    "Create()/fork-proc:ms.cnt": 3,
    "Create()/fresh-proc:ms.avg": 137,
    "Create()/fresh-proc:ms.cnt": 3,
    "Create()/make-root-fs:ms.avg": 3,
    "Create()/make-root-fs:ms.cnt": 6,
    "Create():ms.avg": 75,
    "Create():ms.cnt": 6,
    "Destroy()/detach-root:ms.avg": 0,
    "Destroy()/detach-root:ms.cnt": 6,
    "Destroy()/kill-procs:ms.avg": 2,
    "Destroy()/kill-procs:ms.cnt": 6,
    "Destroy()/remove-root:ms.avg": 0,
    "Destroy()/remove-root:ms.cnt": 6,
    "Destroy():ms.avg": 2,
    "Destroy():ms.cnt": 7,
    "Pause():ms.avg": 4,
    "Pause():ms.cnt": 3,
    "Status():ms.avg": 0,
    "Status():ms.cnt": 2,
    "evict:ms.avg": 6,
    "evict:ms.cnt": 1,
    "fork():ms.avg": 5,
    "fork():ms.cnt": 3,
    "forkRequest:ms.avg": 5,
    "forkRequest:ms.cnt": 3,
    "move-to-cg-after-fork:ms.avg": 0,
    "move-to-cg-after-fork:ms.cnt": 3,
    "pip-install:ms.avg": 4858,
    "pip-install:ms.cnt": 2
  },
  "conf": {
    "limits": {
      "procs": 10,
      "mem_mb": 50,
      "installer_mem_mb": 200
    },
    "handler_cache_mb": 250,
    "worker_dir": "/root/open-lambda/test-dir/worker",
    "sandbox_config": {},
    "registry": "/root/open-lambda/test-registry",
    "docker_runtime": "",
    "import_cache_mb": 250,
    "server_mode": "lambda",
    "SOCK_base_path": "/root/open-lambda/test-dir/lambda",
    "sandbox": "sock",
    "Pkgs_dir": "/root/open-lambda/test-dir/lambda/packages",
    "worker_port": "5000",
    "registry_cache_ms": 5000,
    "pip_mirror": ""
  },
  "errors": [],
  "worker_tail": [
    "2019/07/06 21:43:31 remove /sys/fs/cgroup/freezer/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:43:31 remove /sys/fs/cgroup/hugetlb/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:43:31 remove /sys/fs/cgroup/memory/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:43:31 remove /sys/fs/cgroup/perf_event/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:43:31 remove /sys/fs/cgroup/systemd/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:43:31 remove /sys/fs/cgroup/pids/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:43:31 save stats to /root/open-lambda/test-dir/worker/stats.json",
    "2019/07/06 21:43:31 remove worker.pid",
    "2019/07/06 21:43:31 exiting",
    ""
  ]
}
POP conf: {'import_cache_mb': 250, 'handler_cache_mb': 250}
POP conf: {'registry': '/root/open-lambda/test-registry'}
PUSH conf: {'server_mode': 'sock'}
========================================
sock_churn {'seconds': 15, 'procs': 1, 'fork': True, 'baseline': 0}
========================================
RUN ./ol worker -p=test-dir --detach
RUN ./ol kill -p=test-dir
{
  "test": "sock_churn",
  "params": {
    "seconds": 15,
    "procs": 1,
    "fork": true,
    "baseline": 0
  },
  "pass": true,
  "seconds": 15.161933422088623,
  "total_seconds": 15.389781713485718,
  "stats": {
    "sandboxes_per_sec": 48.93333333333333
  },
  "ol-stats": {
    "Create()/acquire-cgroup:ms.avg": 0,
    "Create()/acquire-cgroup:ms.cnt": 735,
    "Create()/acquire-mem:ms.avg": 0,
    "Create()/acquire-mem:ms.cnt": 735,
    "Create()/fork-proc:ms.avg": 6,
    "Create()/fork-proc:ms.cnt": 734,
    "Create()/fresh-proc:ms.avg": 133,
    "Create()/fresh-proc:ms.cnt": 1,
    "Create()/make-root-fs:ms.avg": 2,
    "Create()/make-root-fs:ms.cnt": 735,
    "Create():ms.avg": 9,
    "Create():ms.cnt": 735,
    "Destroy()/detach-root:ms.avg": 1,
    "Destroy()/detach-root:ms.cnt": 735,
    "Destroy()/kill-procs:ms.avg": 1,
    "Destroy()/kill-procs:ms.cnt": 735,
    "Destroy()/remove-root:ms.avg": 0,
    "Destroy()/remove-root:ms.cnt": 735,
    "Destroy():ms.avg": 1,
    "Destroy():ms.cnt": 1469,
    "fork():ms.avg": 6,
    "fork():ms.cnt": 734,
    "forkRequest:ms.avg": 5,
    "forkRequest:ms.cnt": 734,
    "move-to-cg-after-fork:ms.avg": 0,
    "move-to-cg-after-fork:ms.cnt": 734
  },
  "conf": {
    "limits": {
      "procs": 10,
      "mem_mb": 50,
      "installer_mem_mb": 200
    },
    "handler_cache_mb": 250,
    "worker_dir": "/root/open-lambda/test-dir/worker",
    "sandbox_config": {},
    "registry": "/root/open-lambda/test-dir/registry",
    "docker_runtime": "",
    "import_cache_mb": 250,
    "server_mode": "sock",
    "SOCK_base_path": "/root/open-lambda/test-dir/lambda",
    "sandbox": "sock",
    "Pkgs_dir": "/root/open-lambda/test-dir/lambda/packages",
    "worker_port": "5000",
    "registry_cache_ms": 5000,
    "pip_mirror": ""
  },
  "errors": [],
  "worker_tail": [
    "2019/07/06 21:43:46 remove /sys/fs/cgroup/freezer/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:43:46 remove /sys/fs/cgroup/hugetlb/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:43:46 remove /sys/fs/cgroup/memory/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:43:46 remove /sys/fs/cgroup/perf_event/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:43:46 remove /sys/fs/cgroup/systemd/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:43:46 remove /sys/fs/cgroup/pids/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:43:46 save stats to /root/open-lambda/test-dir/worker/stats.json",
    "2019/07/06 21:43:46 remove worker.pid",
    "2019/07/06 21:43:46 exiting",
    ""
  ]
}
========================================
sock_churn {'seconds': 15, 'procs': 15, 'fork': True, 'baseline': 0}
========================================
RUN ./ol worker -p=test-dir --detach
RUN ./ol kill -p=test-dir
{
  "test": "sock_churn",
  "params": {
    "seconds": 15,
    "procs": 15,
    "fork": true,
    "baseline": 0
  },
  "pass": true,
  "seconds": 15.419114589691162,
  "total_seconds": 15.65003228187561,
  "stats": {
    "sandboxes_per_sec": 48.333333333333336
  },
  "ol-stats": {
    "Create()/acquire-cgroup:ms.avg": 0,
    "Create()/acquire-cgroup:ms.cnt": 726,
    "Create()/acquire-mem:ms.avg": 71,
    "Create()/acquire-mem:ms.cnt": 726,
    "Create()/fork-proc:ms.avg": 44,
    "Create()/fork-proc:ms.cnt": 725,
    "Create()/fresh-proc:ms.avg": 130,
    "Create()/fresh-proc:ms.cnt": 1,
    "Create()/make-root-fs:ms.avg": 2,
    "Create()/make-root-fs:ms.cnt": 726,
    "Create():ms.avg": 119,
    "Create():ms.cnt": 726,
    "Destroy()/detach-root:ms.avg": 1,
    "Destroy()/detach-root:ms.cnt": 726,
    "Destroy()/kill-procs:ms.avg": 8,
    "Destroy()/kill-procs:ms.cnt": 726,
    "Destroy()/remove-root:ms.avg": 0,
    "Destroy()/remove-root:ms.cnt": 726,
    "Destroy():ms.avg": 6,
    "Destroy():ms.cnt": 1451,
    "fork():ms.avg": 44,
    "fork():ms.cnt": 725,
    "forkRequest:ms.avg": 10,
    "forkRequest:ms.cnt": 725,
    "move-to-cg-after-fork:ms.avg": 3,
    "move-to-cg-after-fork:ms.cnt": 725
  },
  "conf": {
    "limits": {
      "procs": 10,
      "mem_mb": 50,
      "installer_mem_mb": 200
    },
    "handler_cache_mb": 250,
    "worker_dir": "/root/open-lambda/test-dir/worker",
    "sandbox_config": {},
    "registry": "/root/open-lambda/test-dir/registry",
    "docker_runtime": "",
    "import_cache_mb": 250,
    "server_mode": "sock",
    "SOCK_base_path": "/root/open-lambda/test-dir/lambda",
    "sandbox": "sock",
    "Pkgs_dir": "/root/open-lambda/test-dir/lambda/packages",
    "worker_port": "5000",
    "registry_cache_ms": 5000,
    "pip_mirror": ""
  },
  "errors": [],
  "worker_tail": [
    "2019/07/06 21:44:02 remove /sys/fs/cgroup/freezer/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:44:02 remove /sys/fs/cgroup/hugetlb/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:44:02 remove /sys/fs/cgroup/memory/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:44:02 remove /sys/fs/cgroup/perf_event/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:44:02 remove /sys/fs/cgroup/systemd/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:44:02 remove /sys/fs/cgroup/pids/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:44:02 save stats to /root/open-lambda/test-dir/worker/stats.json",
    "2019/07/06 21:44:02 remove worker.pid",
    "2019/07/06 21:44:02 exiting",
    ""
  ]
}
POP conf: {'server_mode': 'sock'}
PUSH conf: {'sandbox': 'sock', 'registry_cache_ms': 3000, 'registry': '/tmp/tmpdgtbjvqc'}
========================================
update_code
========================================
RUN ./ol worker -p=test-dir --detach
RUN ./ol kill -p=test-dir
{
  "test": "update_code",
  "params": {},
  "pass": true,
  "seconds": 6.0275421142578125,
  "total_seconds": 6.26280403137207,
  "stats": null,
  "ol-stats": {
    "Channel():ms.avg": 0,
    "Channel():ms.cnt": 3,
    "Create()/acquire-cgroup:ms.avg": 0,
    "Create()/acquire-cgroup:ms.cnt": 4,
    "Create()/acquire-mem:ms.avg": 0,
    "Create()/acquire-mem:ms.cnt": 4,
    "Create()/fork-proc:ms.avg": 8,
    "Create()/fork-proc:ms.cnt": 3,
    "Create()/fresh-proc:ms.avg": 131,
    "Create()/fresh-proc:ms.cnt": 1,
    "Create()/make-root-fs:ms.avg": 3,
    "Create()/make-root-fs:ms.cnt": 4,
    "Create():ms.avg": 43,
    "Create():ms.cnt": 4,
    "Destroy()/detach-root:ms.avg": 0,
    "Destroy()/detach-root:ms.cnt": 4,
    "Destroy()/kill-procs:ms.avg": 0,
    "Destroy()/kill-procs:ms.cnt": 4,
    "Destroy()/remove-root:ms.avg": 0,
    "Destroy()/remove-root:ms.cnt": 4,
    "Destroy():ms.avg": 1,
    "Destroy():ms.cnt": 4,
    "Pause():ms.avg": 0,
    "Pause():ms.cnt": 1713,
    "Unpause():ms.avg": 0,
    "Unpause():ms.cnt": 1710,
    "fork():ms.avg": 8,
    "fork():ms.cnt": 3,
    "forkRequest:ms.avg": 7,
    "forkRequest:ms.cnt": 3,
    "move-to-cg-after-fork:ms.avg": 0,
    "move-to-cg-after-fork:ms.cnt": 3
  },
  "conf": {
    "limits": {
      "procs": 10,
      "mem_mb": 50,
      "installer_mem_mb": 200
    },
    "handler_cache_mb": 250,
    "worker_dir": "/root/open-lambda/test-dir/worker",
    "pip_mirror": "",
    "sandbox_config": {},
    "docker_runtime": "",
    "import_cache_mb": 250,
    "server_mode": "lambda",
    "SOCK_base_path": "/root/open-lambda/test-dir/lambda",
    "registry_cache_ms": 3000,
    "Pkgs_dir": "/root/open-lambda/test-dir/lambda/packages",
    "worker_port": "5000",
    "sandbox": "sock",
    "registry": "/tmp/tmpdgtbjvqc"
  },
  "errors": [],
  "worker_tail": [
    "2019/07/06 21:44:08 remove /sys/fs/cgroup/freezer/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:44:08 remove /sys/fs/cgroup/hugetlb/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:44:08 remove /sys/fs/cgroup/memory/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:44:08 remove /sys/fs/cgroup/perf_event/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:44:08 remove /sys/fs/cgroup/systemd/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:44:08 remove /sys/fs/cgroup/pids/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:44:08 save stats to /root/open-lambda/test-dir/worker/stats.json",
    "2019/07/06 21:44:08 remove worker.pid",
    "2019/07/06 21:44:08 exiting",
    ""
  ]
}
POP conf: {'sandbox': 'sock', 'registry_cache_ms': 3000, 'registry': '/tmp/tmpdgtbjvqc'}
PUSH conf: {'import_cache_mb': 250, 'handler_cache_mb': 250, 'sandbox': 'sock', 'registry': '/root/open-lambda/test-registry'}
========================================
stress_one_lambda {'seconds': 15, 'procs': 1}
========================================
RUN ./ol worker -p=test-dir --detach
RUN ./ol kill -p=test-dir
{
  "test": "stress_one_lambda",
  "params": {
    "seconds": 15,
    "procs": 1
  },
  "pass": true,
  "seconds": 15.044023036956787,
  "total_seconds": 15.270660400390625,
  "stats": {
    "reqs_per_sec": 291.06666666666666
  },
  "ol-stats": {
    "Channel():ms.avg": 0,
    "Channel():ms.cnt": 3,
    "Create()/acquire-cgroup:ms.avg": 0,
    "Create()/acquire-cgroup:ms.cnt": 4,
    "Create()/acquire-mem:ms.avg": 0,
    "Create()/acquire-mem:ms.cnt": 4,
    "Create()/fork-proc:ms.avg": 8,
    "Create()/fork-proc:ms.cnt": 3,
    "Create()/fresh-proc:ms.avg": 132,
    "Create()/fresh-proc:ms.cnt": 1,
    "Create()/make-root-fs:ms.avg": 3,
    "Create()/make-root-fs:ms.cnt": 4,
    "Create():ms.avg": 43,
    "Create():ms.cnt": 4,
    "Destroy()/detach-root:ms.avg": 0,
    "Destroy()/detach-root:ms.cnt": 4,
    "Destroy()/kill-procs:ms.avg": 0,
    "Destroy()/kill-procs:ms.cnt": 4,
    "Destroy()/remove-root:ms.avg": 0,
    "Destroy()/remove-root:ms.cnt": 4,
    "Destroy():ms.avg": 1,
    "Destroy():ms.cnt": 4,
    "Pause():ms.avg": 0,
    "Pause():ms.cnt": 4366,
    "Unpause():ms.avg": 0,
    "Unpause():ms.cnt": 4363,
    "fork():ms.avg": 8,
    "fork():ms.cnt": 3,
    "forkRequest:ms.avg": 7,
    "forkRequest:ms.cnt": 3,
    "move-to-cg-after-fork:ms.avg": 0,
    "move-to-cg-after-fork:ms.cnt": 3
  },
  "conf": {
    "limits": {
      "procs": 10,
      "mem_mb": 50,
      "installer_mem_mb": 200
    },
    "handler_cache_mb": 250,
    "worker_dir": "/root/open-lambda/test-dir/worker",
    "sandbox_config": {},
    "registry": "/root/open-lambda/test-registry",
    "docker_runtime": "",
    "import_cache_mb": 250,
    "server_mode": "lambda",
    "SOCK_base_path": "/root/open-lambda/test-dir/lambda",
    "sandbox": "sock",
    "Pkgs_dir": "/root/open-lambda/test-dir/lambda/packages",
    "worker_port": "5000",
    "registry_cache_ms": 5000,
    "pip_mirror": ""
  },
  "errors": [],
  "worker_tail": [
    "2019/07/06 21:44:23 remove /sys/fs/cgroup/freezer/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:44:23 remove /sys/fs/cgroup/hugetlb/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:44:23 remove /sys/fs/cgroup/memory/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:44:23 remove /sys/fs/cgroup/perf_event/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:44:23 remove /sys/fs/cgroup/systemd/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:44:23 remove /sys/fs/cgroup/pids/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:44:23 save stats to /root/open-lambda/test-dir/worker/stats.json",
    "2019/07/06 21:44:23 remove worker.pid",
    "2019/07/06 21:44:23 exiting",
    ""
  ]
}
========================================
stress_one_lambda {'seconds': 15, 'procs': 2}
========================================
RUN ./ol worker -p=test-dir --detach
RUN ./ol kill -p=test-dir
{
  "test": "stress_one_lambda",
  "params": {
    "seconds": 15,
    "procs": 2
  },
  "pass": true,
  "seconds": 15.046116352081299,
  "total_seconds": 15.273595094680786,
  "stats": {
    "reqs_per_sec": 292.2
  },
  "ol-stats": {
    "Channel():ms.avg": 0,
    "Channel():ms.cnt": 3,
    "Create()/acquire-cgroup:ms.avg": 0,
    "Create()/acquire-cgroup:ms.cnt": 4,
    "Create()/acquire-mem:ms.avg": 0,
    "Create()/acquire-mem:ms.cnt": 4,
    "Create()/fork-proc:ms.avg": 8,
    "Create()/fork-proc:ms.cnt": 3,
    "Create()/fresh-proc:ms.avg": 136,
    "Create()/fresh-proc:ms.cnt": 1,
    "Create()/make-root-fs:ms.avg": 3,
    "Create()/make-root-fs:ms.cnt": 4,
    "Create():ms.avg": 44,
    "Create():ms.cnt": 4,
    "Destroy()/detach-root:ms.avg": 0,
    "Destroy()/detach-root:ms.cnt": 4,
    "Destroy()/kill-procs:ms.avg": 0,
    "Destroy()/kill-procs:ms.cnt": 4,
    "Destroy()/remove-root:ms.avg": 0,
    "Destroy()/remove-root:ms.cnt": 4,
    "Destroy():ms.avg": 1,
    "Destroy():ms.cnt": 4,
    "Pause():ms.avg": 0,
    "Pause():ms.cnt": 3953,
    "Unpause():ms.avg": 0,
    "Unpause():ms.cnt": 3950,
    "fork():ms.avg": 8,
    "fork():ms.cnt": 3,
    "forkRequest:ms.avg": 7,
    "forkRequest:ms.cnt": 3,
    "move-to-cg-after-fork:ms.avg": 0,
    "move-to-cg-after-fork:ms.cnt": 3
  },
  "conf": {
    "limits": {
      "procs": 10,
      "mem_mb": 50,
      "installer_mem_mb": 200
    },
    "handler_cache_mb": 250,
    "worker_dir": "/root/open-lambda/test-dir/worker",
    "sandbox_config": {},
    "registry": "/root/open-lambda/test-registry",
    "docker_runtime": "",
    "import_cache_mb": 250,
    "server_mode": "lambda",
    "SOCK_base_path": "/root/open-lambda/test-dir/lambda",
    "sandbox": "sock",
    "Pkgs_dir": "/root/open-lambda/test-dir/lambda/packages",
    "worker_port": "5000",
    "registry_cache_ms": 5000,
    "pip_mirror": ""
  },
  "errors": [],
  "worker_tail": [
    "2019/07/06 21:44:38 remove /sys/fs/cgroup/freezer/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:44:38 remove /sys/fs/cgroup/hugetlb/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:44:38 remove /sys/fs/cgroup/memory/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:44:38 remove /sys/fs/cgroup/perf_event/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:44:38 remove /sys/fs/cgroup/systemd/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:44:38 remove /sys/fs/cgroup/pids/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:44:38 save stats to /root/open-lambda/test-dir/worker/stats.json",
    "2019/07/06 21:44:38 remove worker.pid",
    "2019/07/06 21:44:38 exiting",
    ""
  ]
}
========================================
stress_one_lambda {'seconds': 15, 'procs': 8}
========================================
RUN ./ol worker -p=test-dir --detach
RUN ./ol kill -p=test-dir
{
  "test": "stress_one_lambda",
  "params": {
    "seconds": 15,
    "procs": 8
  },
  "pass": true,
  "seconds": 15.0650053024292,
  "total_seconds": 15.292056560516357,
  "stats": {
    "reqs_per_sec": 275.0
  },
  "ol-stats": {
    "Channel():ms.avg": 0,
    "Channel():ms.cnt": 3,
    "Create()/acquire-cgroup:ms.avg": 0,
    "Create()/acquire-cgroup:ms.cnt": 4,
    "Create()/acquire-mem:ms.avg": 0,
    "Create()/acquire-mem:ms.cnt": 4,
    "Create()/fork-proc:ms.avg": 7,
    "Create()/fork-proc:ms.cnt": 3,
    "Create()/fresh-proc:ms.avg": 130,
    "Create()/fresh-proc:ms.cnt": 1,
    "Create()/make-root-fs:ms.avg": 3,
    "Create()/make-root-fs:ms.cnt": 4,
    "Create():ms.avg": 42,
    "Create():ms.cnt": 4,
    "Destroy()/detach-root:ms.avg": 0,
    "Destroy()/detach-root:ms.cnt": 4,
    "Destroy()/kill-procs:ms.avg": 0,
    "Destroy()/kill-procs:ms.cnt": 4,
    "Destroy()/remove-root:ms.avg": 0,
    "Destroy()/remove-root:ms.cnt": 4,
    "Destroy():ms.avg": 2,
    "Destroy():ms.cnt": 4,
    "Pause():ms.avg": 0,
    "Pause():ms.cnt": 3100,
    "Unpause():ms.avg": 0,
    "Unpause():ms.cnt": 3097,
    "fork():ms.avg": 7,
    "fork():ms.cnt": 3,
    "forkRequest:ms.avg": 5,
    "forkRequest:ms.cnt": 3,
    "move-to-cg-after-fork:ms.avg": 0,
    "move-to-cg-after-fork:ms.cnt": 3
  },
  "conf": {
    "limits": {
      "procs": 10,
      "mem_mb": 50,
      "installer_mem_mb": 200
    },
    "handler_cache_mb": 250,
    "worker_dir": "/root/open-lambda/test-dir/worker",
    "sandbox_config": {},
    "registry": "/root/open-lambda/test-registry",
    "docker_runtime": "",
    "import_cache_mb": 250,
    "server_mode": "lambda",
    "SOCK_base_path": "/root/open-lambda/test-dir/lambda",
    "sandbox": "sock",
    "Pkgs_dir": "/root/open-lambda/test-dir/lambda/packages",
    "worker_port": "5000",
    "registry_cache_ms": 5000,
    "pip_mirror": ""
  },
  "errors": [],
  "worker_tail": [
    "2019/07/06 21:44:54 remove /sys/fs/cgroup/freezer/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:44:54 remove /sys/fs/cgroup/hugetlb/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:44:54 remove /sys/fs/cgroup/memory/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:44:54 remove /sys/fs/cgroup/perf_event/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:44:54 remove /sys/fs/cgroup/systemd/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:44:54 remove /sys/fs/cgroup/pids/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:44:54 save stats to /root/open-lambda/test-dir/worker/stats.json",
    "2019/07/06 21:44:54 remove worker.pid",
    "2019/07/06 21:44:54 exiting",
    ""
  ]
}
POP conf: {'import_cache_mb': 250, 'handler_cache_mb': 250, 'sandbox': 'sock', 'registry': '/root/open-lambda/test-registry'}
PUSH conf: {'import_cache_mb': 250, 'handler_cache_mb': 250, 'sandbox': 'sock'}
PUSH conf: {'registry': '/tmp/tmp5y2bbdkw'}
========================================
call_each_once_exec {'alloc_mb': 1, 'lambda_count': 100}
========================================
RUN ./ol worker -p=test-dir --detach
RUN ./ol kill -p=test-dir
{
  "test": "call_each_once_exec",
  "params": {
    "alloc_mb": 1,
    "lambda_count": 100
  },
  "pass": true,
  "seconds": 2.4265592098236084,
  "total_seconds": 2.7685322761535645,
  "stats": {
    "reqs_per_sec": 41.21098455476301
  },
  "ol-stats": {
    "Channel():ms.avg": 0,
    "Channel():ms.cnt": 100,
    "Create()/acquire-cgroup:ms.avg": 0,
    "Create()/acquire-cgroup:ms.cnt": 101,
    "Create()/acquire-mem:ms.avg": 0,
    "Create()/acquire-mem:ms.cnt": 101,
    "Create()/fork-proc:ms.avg": 6,
    "Create()/fork-proc:ms.cnt": 100,
    "Create()/fresh-proc:ms.avg": 132,
    "Create()/fresh-proc:ms.cnt": 1,
    "Create()/make-root-fs:ms.avg": 0,
    "Create()/make-root-fs:ms.cnt": 101,
    "Create():ms.avg": 8,
    "Create():ms.cnt": 101,
    "Destroy()/detach-root:ms.avg": 0,
    "Destroy()/detach-root:ms.cnt": 101,
    "Destroy()/kill-procs:ms.avg": 0,
    "Destroy()/kill-procs:ms.cnt": 101,
    "Destroy()/remove-root:ms.avg": 0,
    "Destroy()/remove-root:ms.cnt": 101,
    "Destroy():ms.avg": 0,
    "Destroy():ms.cnt": 178,
    "Pause():ms.avg": 4,
    "Pause():ms.cnt": 100,
    "evict:ms.avg": 0,
    "evict:ms.cnt": 77,
    "fork():ms.avg": 6,
    "fork():ms.cnt": 100,
    "forkRequest:ms.avg": 5,
    "forkRequest:ms.cnt": 100,
    "move-to-cg-after-fork:ms.avg": 0,
    "move-to-cg-after-fork:ms.cnt": 100
  },
  "conf": {
    "limits": {
      "procs": 10,
      "mem_mb": 50,
      "installer_mem_mb": 200
    },
    "handler_cache_mb": 250,
    "worker_dir": "/root/open-lambda/test-dir/worker",
    "pip_mirror": "",
    "sandbox_config": {},
    "docker_runtime": "",
    "import_cache_mb": 250,
    "server_mode": "lambda",
    "SOCK_base_path": "/root/open-lambda/test-dir/lambda",
    "registry_cache_ms": 5000,
    "Pkgs_dir": "/root/open-lambda/test-dir/lambda/packages",
    "worker_port": "5000",
    "sandbox": "sock",
    "registry": "/tmp/tmp5y2bbdkw"
  },
  "errors": [],
  "worker_tail": [
    "2019/07/06 21:44:57 remove /sys/fs/cgroup/freezer/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:44:57 remove /sys/fs/cgroup/hugetlb/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:44:57 remove /sys/fs/cgroup/memory/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:44:57 remove /sys/fs/cgroup/perf_event/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:44:57 remove /sys/fs/cgroup/systemd/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:44:57 remove /sys/fs/cgroup/pids/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:44:57 save stats to /root/open-lambda/test-dir/worker/stats.json",
    "2019/07/06 21:44:57 remove worker.pid",
    "2019/07/06 21:44:57 exiting",
    ""
  ]
}
POP conf: {'registry': '/tmp/tmp5y2bbdkw'}
PUSH conf: {'registry': '/tmp/tmpqd_g6yuw'}
========================================
call_each_once_exec {'alloc_mb': 10, 'lambda_count': 1000}
========================================
RUN ./ol worker -p=test-dir --detach
RUN ./ol kill -p=test-dir
{
  "test": "call_each_once_exec",
  "params": {
    "alloc_mb": 10,
    "lambda_count": 1000
  },
  "pass": true,
  "seconds": 37.38421177864075,
  "total_seconds": 37.637669801712036,
  "stats": {
    "reqs_per_sec": 26.749279768532567
  },
  "ol-stats": {
    "Channel():ms.avg": 0,
    "Channel():ms.cnt": 1000,
    "Create()/acquire-cgroup:ms.avg": 0,
    "Create()/acquire-cgroup:ms.cnt": 1001,
    "Create()/acquire-mem:ms.avg": 0,
    "Create()/acquire-mem:ms.cnt": 1001,
    "Create()/fork-proc:ms.avg": 7,
    "Create()/fork-proc:ms.cnt": 1000,
    "Create()/fresh-proc:ms.avg": 139,
    "Create()/fresh-proc:ms.cnt": 1,
    "Create()/make-root-fs:ms.avg": 0,
    "Create()/make-root-fs:ms.cnt": 1001,
    "Create():ms.avg": 8,
    "Create():ms.cnt": 1001,
    "Destroy()/detach-root:ms.avg": 0,
    "Destroy()/detach-root:ms.cnt": 1001,
    "Destroy()/kill-procs:ms.avg": 3,
    "Destroy()/kill-procs:ms.cnt": 1001,
    "Destroy()/remove-root:ms.avg": 0,
    "Destroy()/remove-root:ms.cnt": 1001,
    "Destroy():ms.avg": 1,
    "Destroy():ms.cnt": 1990,
    "Pause():ms.avg": 10,
    "Pause():ms.cnt": 1000,
    "evict:ms.avg": 3,
    "evict:ms.cnt": 989,
    "fork():ms.avg": 7,
    "fork():ms.cnt": 1000,
    "forkRequest:ms.avg": 5,
    "forkRequest:ms.cnt": 1000,
    "move-to-cg-after-fork:ms.avg": 1,
    "move-to-cg-after-fork:ms.cnt": 1000
  },
  "conf": {
    "limits": {
      "procs": 10,
      "mem_mb": 50,
      "installer_mem_mb": 200
    },
    "handler_cache_mb": 250,
    "worker_dir": "/root/open-lambda/test-dir/worker",
    "sandbox_config": {},
    "registry": "/tmp/tmpqd_g6yuw",
    "docker_runtime": "",
    "import_cache_mb": 250,
    "server_mode": "lambda",
    "SOCK_base_path": "/root/open-lambda/test-dir/lambda",
    "sandbox": "sock",
    "Pkgs_dir": "/root/open-lambda/test-dir/lambda/packages",
    "worker_port": "5000",
    "registry_cache_ms": 5000,
    "pip_mirror": ""
  },
  "errors": [],
  "worker_tail": [
    "2019/07/06 21:45:35 remove /sys/fs/cgroup/freezer/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:45:35 remove /sys/fs/cgroup/hugetlb/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:45:35 remove /sys/fs/cgroup/memory/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:45:35 remove /sys/fs/cgroup/perf_event/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:45:35 remove /sys/fs/cgroup/systemd/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:45:35 remove /sys/fs/cgroup/pids/worker-sock-handlers [CGROUP POOL worker-sock-handlers]",
    "2019/07/06 21:45:35 save stats to /root/open-lambda/test-dir/worker/stats.json",
    "2019/07/06 21:45:35 remove worker.pid",
    "2019/07/06 21:45:35 exiting",
    ""
  ]
}
POP conf: {'registry': '/tmp/tmpqd_g6yuw'}
POP conf: {'import_cache_mb': 250, 'handler_cache_mb': 250, 'sandbox': 'sock'}
PASSED: 15, FAILED: 0