builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0024 starttime: 1474515240.43 results: success (0) buildid: 20160921181859 builduid: 275328f5aaa44fad95451c7dba401719 revision: f93ac29ad106222f2cd7e55a1d24795f89425dd4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-21 20:34:00.434469) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-21 20:34:00.434964) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-21 20:34:00.435298) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-21 20:34:00.466741) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-09-21 20:34:00.467093) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FR9jUec9FL/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.MYbbF3IHJO/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-09-21 20:34:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.3M=0.001s 2016-09-21 20:34:00 (14.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.144524 ========= master_lag: 3.38 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-09-21 20:34:03.991430) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 20:34:03.991707) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FR9jUec9FL/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.MYbbF3IHJO/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.029731 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 20:34:04.046477) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-09-21 20:34:04.047019) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f93ac29ad106222f2cd7e55a1d24795f89425dd4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f93ac29ad106222f2cd7e55a1d24795f89425dd4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FR9jUec9FL/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.MYbbF3IHJO/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-09-21 20:34:04,126 truncating revision to first 12 chars 2016-09-21 20:34:04,126 Setting DEBUG logging. 2016-09-21 20:34:04,126 attempt 1/10 2016-09-21 20:34:04,126 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f93ac29ad106?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-21 20:34:06,017 unpacking tar archive at: mozilla-aurora-f93ac29ad106/testing/mozharness/ program finished with exit code 0 elapsedTime=2.150417 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-09-21 20:34:06.224704) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-21 20:34:06.225490) ========= script_repo_revision: f93ac29ad106222f2cd7e55a1d24795f89425dd4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-21 20:34:06.226428) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-21 20:34:06.227031) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-21 20:34:06.248417) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-09-21 20:34:06.249211) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FR9jUec9FL/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.MYbbF3IHJO/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 20:34:06 INFO - MultiFileLogger online at 20160921 20:34:06 in /builds/slave/test 20:34:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 20:34:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:34:06 INFO - {'append_to_log': False, 20:34:06 INFO - 'base_work_dir': '/builds/slave/test', 20:34:06 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 20:34:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:34:06 INFO - 'branch': 'Mozilla-Aurora', 20:34:06 INFO - 'buildbot_json_path': 'buildprops.json', 20:34:06 INFO - 'config_files': ('talos/mac_config.py',), 20:34:06 INFO - 'default_actions': ('clobber', 20:34:06 INFO - 'read-buildbot-config', 20:34:06 INFO - 'download-and-extract', 20:34:06 INFO - 'populate-webroot', 20:34:06 INFO - 'create-virtualenv', 20:34:06 INFO - 'install', 20:34:06 INFO - 'run-tests'), 20:34:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:34:06 INFO - 'download_minidump_stackwalk': True, 20:34:06 INFO - 'download_symbols': 'ondemand', 20:34:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:34:06 INFO - 'tooltool.py': '/tools/tooltool.py', 20:34:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:34:06 INFO - '/tools/misc-python/virtualenv.py')}, 20:34:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:34:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:34:06 INFO - 'installer_path': 'installer.exe', 20:34:06 INFO - 'log_level': 'info', 20:34:06 INFO - 'log_name': 'talos', 20:34:06 INFO - 'log_to_console': True, 20:34:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:34:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:34:06 INFO - 'opt_config_files': (), 20:34:06 INFO - 'pip_index': False, 20:34:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:34:06 INFO - 'cmd': ('bash', 20:34:06 INFO - '-c', 20:34:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:34:06 INFO - 'enabled': True, 20:34:06 INFO - 'halt_on_failure': False, 20:34:06 INFO - 'name': 'check_screen_resolution'},), 20:34:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:34:06 INFO - 'cmd': ('bash', 20:34:06 INFO - '-c', 20:34:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:34:06 INFO - 'enabled': True, 20:34:06 INFO - 'halt_on_failure': False, 20:34:06 INFO - 'name': 'check_screen_resolution'},), 20:34:06 INFO - 'run_cmd_checks_enabled': True, 20:34:06 INFO - 'sps_profile': False, 20:34:06 INFO - 'sps_profile_interval': 0, 20:34:06 INFO - 'suite': 'dromaeojs-e10s', 20:34:06 INFO - 'system_bits': '32', 20:34:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:34:06 INFO - 'title': 't-yosemite-r7-0024', 20:34:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:34:06 INFO - 'use_talos_json': True, 20:34:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:34:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:34:06 INFO - 'work_dir': 'build'} 20:34:06 INFO - [mozharness: 2016-09-22 03:34:06.470692Z] Running clobber step. 20:34:06 INFO - Running pre-action listener: _resource_record_pre_action 20:34:06 INFO - Running main action method: clobber 20:34:06 INFO - rmtree: /builds/slave/test/build 20:34:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:34:08 INFO - Running post-action listener: _resource_record_post_action 20:34:08 INFO - [mozharness: 2016-09-22 03:34:08.571377Z] Finished clobber step (success) 20:34:08 INFO - [mozharness: 2016-09-22 03:34:08.571539Z] Running read-buildbot-config step. 20:34:08 INFO - Running pre-action listener: _resource_record_pre_action 20:34:08 INFO - Running main action method: read_buildbot_config 20:34:08 INFO - Using buildbot properties: 20:34:08 INFO - { 20:34:08 INFO - "project": "", 20:34:08 INFO - "product": "firefox", 20:34:08 INFO - "script_repo_revision": "production", 20:34:08 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 20:34:08 INFO - "repository": "", 20:34:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 20:34:08 INFO - "buildid": "20160921181859", 20:34:08 INFO - "pgo_build": "False", 20:34:08 INFO - "basedir": "/builds/slave/test", 20:34:08 INFO - "buildnumber": 71, 20:34:08 INFO - "slavename": "t-yosemite-r7-0024", 20:34:08 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 20:34:08 INFO - "platform": "yosemite_r7", 20:34:08 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 20:34:08 INFO - "branch": "mozilla-aurora", 20:34:08 INFO - "repo_path": "releases/mozilla-aurora", 20:34:08 INFO - "revision": "f93ac29ad106222f2cd7e55a1d24795f89425dd4", 20:34:08 INFO - "stage_platform": "macosx64", 20:34:08 INFO - "builduid": "275328f5aaa44fad95451c7dba401719", 20:34:08 INFO - "slavebuilddir": "test" 20:34:08 INFO - } 20:34:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/dFGFCL_xT56X0MIpuBVzBQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 20:34:08 INFO - Running post-action listener: _resource_record_post_action 20:34:08 INFO - [mozharness: 2016-09-22 03:34:08.575044Z] Finished read-buildbot-config step (success) 20:34:08 INFO - [mozharness: 2016-09-22 03:34:08.575153Z] Running download-and-extract step. 20:34:08 INFO - Running pre-action listener: _resource_record_pre_action 20:34:08 INFO - Running main action method: download_and_extract 20:34:08 INFO - mkdir: /builds/slave/test/build/tests 20:34:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:08 INFO - trying https://queue.taskcluster.net/v1/task/dFGFCL_xT56X0MIpuBVzBQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 20:34:08 INFO - Downloading https://queue.taskcluster.net/v1/task/dFGFCL_xT56X0MIpuBVzBQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 20:34:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dFGFCL_xT56X0MIpuBVzBQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 20:34:09 INFO - Downloaded 1199 bytes. 20:34:09 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 20:34:09 INFO - Using the following test package requirements: 20:34:09 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 20:34:09 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 20:34:09 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 20:34:09 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 20:34:09 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 20:34:09 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 20:34:09 INFO - u'jsshell-mac.zip'], 20:34:09 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 20:34:09 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 20:34:09 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 20:34:09 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 20:34:09 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 20:34:09 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 20:34:09 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 20:34:09 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 20:34:09 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 20:34:09 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 20:34:09 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 20:34:09 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 20:34:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dFGFCL_xT56X0MIpuBVzBQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 20:34:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dFGFCL_xT56X0MIpuBVzBQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 20:34:09 INFO - Fetch https://queue.taskcluster.net/v1/task/dFGFCL_xT56X0MIpuBVzBQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 20:34:10 INFO - Expected file size: 16426248 20:34:17 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 20:34:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dFGFCL_xT56X0MIpuBVzBQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 20:34:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dFGFCL_xT56X0MIpuBVzBQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 20:34:17 INFO - Fetch https://queue.taskcluster.net/v1/task/dFGFCL_xT56X0MIpuBVzBQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 20:34:18 INFO - Expected file size: 16426248 20:34:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dFGFCL_xT56X0MIpuBVzBQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 20:34:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dFGFCL_xT56X0MIpuBVzBQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 20:34:24 INFO - Fetch https://queue.taskcluster.net/v1/task/dFGFCL_xT56X0MIpuBVzBQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 20:34:25 INFO - Expected file size: 14414059 20:34:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:26 INFO - trying https://queue.taskcluster.net/v1/task/dFGFCL_xT56X0MIpuBVzBQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 20:34:26 INFO - Downloading https://queue.taskcluster.net/v1/task/dFGFCL_xT56X0MIpuBVzBQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 20:34:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dFGFCL_xT56X0MIpuBVzBQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 20:34:29 INFO - Downloaded 115245211 bytes. 20:34:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dFGFCL_xT56X0MIpuBVzBQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 20:34:29 INFO - mkdir: /builds/slave/test/properties 20:34:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:34:29 INFO - Writing to file /builds/slave/test/properties/build_url 20:34:29 INFO - Contents: 20:34:29 INFO - build_url:https://queue.taskcluster.net/v1/task/dFGFCL_xT56X0MIpuBVzBQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 20:34:30 INFO - Running post-action listener: _resource_record_post_action 20:34:30 INFO - Running post-action listener: set_extra_try_arguments 20:34:30 INFO - [mozharness: 2016-09-22 03:34:30.042567Z] Finished download-and-extract step (success) 20:34:30 INFO - [mozharness: 2016-09-22 03:34:30.042742Z] Running populate-webroot step. 20:34:30 INFO - Running pre-action listener: _resource_record_pre_action 20:34:30 INFO - Running main action method: populate_webroot 20:34:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:34:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:34:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:34:30 INFO - '--tppagecycles', 20:34:30 INFO - '7'], 20:34:30 INFO - 'tests': ['tsvgm']}}, 20:34:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:34:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:34:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:34:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:34:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:34:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:34:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:30 INFO - 'talos_options': ['--disable-e10s'], 20:34:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:34:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:34:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:30 INFO - 'talos_options': ['--disable-e10s'], 20:34:30 INFO - 'tests': ['damp', 'tps']}, 20:34:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:30 INFO - 'tests': ['damp', 'tps']}, 20:34:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:34:30 INFO - 'tests': ['dromaeo_dom']}, 20:34:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:34:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:34:30 INFO - 'tests': ['basic_compositor_video']}, 20:34:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:34:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:34:30 INFO - 'tests': ['a11yr', 20:34:30 INFO - 'ts_paint', 20:34:30 INFO - 'tpaint', 20:34:30 INFO - 'sessionrestore', 20:34:30 INFO - 'sessionrestore_no_auto_restore', 20:34:30 INFO - 'tabpaint']}, 20:34:30 INFO - 'other-e10s': {'tests': ['a11yr', 20:34:30 INFO - 'ts_paint', 20:34:30 INFO - 'tpaint', 20:34:30 INFO - 'sessionrestore', 20:34:30 INFO - 'sessionrestore_no_auto_restore', 20:34:30 INFO - 'tabpaint']}, 20:34:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:34:30 INFO - 'ts_paint', 20:34:30 INFO - 'tpaint', 20:34:30 INFO - 'sessionrestore', 20:34:30 INFO - 'sessionrestore_no_auto_restore', 20:34:30 INFO - 'tabpaint']}, 20:34:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:34:30 INFO - 'ts_paint', 20:34:30 INFO - 'tpaint', 20:34:30 INFO - 'sessionrestore', 20:34:30 INFO - 'sessionrestore_no_auto_restore', 20:34:30 INFO - 'tabpaint']}, 20:34:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:34:30 INFO - 'tests': ['a11yr', 20:34:30 INFO - 'ts_paint', 20:34:30 INFO - 'tpaint', 20:34:30 INFO - 'sessionrestore', 20:34:30 INFO - 'sessionrestore_no_auto_restore', 20:34:30 INFO - 'tabpaint']}, 20:34:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:34:30 INFO - 'tests': ['a11yr', 20:34:30 INFO - 'ts_paint', 20:34:30 INFO - 'tpaint', 20:34:30 INFO - 'sessionrestore', 20:34:30 INFO - 'sessionrestore_no_auto_restore', 20:34:30 INFO - 'tabpaint']}, 20:34:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:34:30 INFO - 'tests': ['tsvgx', 20:34:30 INFO - 'tsvgr_opacity', 20:34:30 INFO - 'tart', 20:34:30 INFO - 'tscrollx', 20:34:30 INFO - 'cart']}, 20:34:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:34:30 INFO - 'tsvgr_opacity', 20:34:30 INFO - 'tart', 20:34:30 INFO - 'tscrollx', 20:34:30 INFO - 'cart']}, 20:34:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:30 INFO - 'talos_options': ['--disable-e10s'], 20:34:30 INFO - 'tests': ['tp5o']}, 20:34:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:30 INFO - 'tests': ['tp5o']}, 20:34:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:30 INFO - 'talos_options': ['--disable-e10s', 20:34:30 INFO - '--xperf_path', 20:34:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:34:30 INFO - 'tests': ['tp5n']}, 20:34:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:34:30 INFO - 'talos_options': ['--xperf_path', 20:34:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:34:30 INFO - 'tests': ['tp5n']}}, 20:34:30 INFO - 'talos.zip': {'path': '', 20:34:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:34:30 INFO - Running post-action listener: _resource_record_post_action 20:34:30 INFO - [mozharness: 2016-09-22 03:34:30.061507Z] Finished populate-webroot step (success) 20:34:30 INFO - [mozharness: 2016-09-22 03:34:30.061616Z] Running create-virtualenv step. 20:34:30 INFO - Running pre-action listener: _resource_record_pre_action 20:34:30 INFO - Running main action method: create_virtualenv 20:34:30 INFO - Creating virtualenv /builds/slave/test/build/venv 20:34:30 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 20:34:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:34:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:34:30 INFO - Using real prefix '/tools/python27' 20:34:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:34:30 INFO - Installing distribute.............................................................................................................................................................................................done. 20:34:33 INFO - Installing pip.................done. 20:34:33 INFO - Return code: 0 20:34:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:34:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f59490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ecf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd43c974e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d6dd30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bd3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d65b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FR9jUec9FL/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MYbbF3IHJO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:34:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:34:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:34:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FR9jUec9FL/Render', 20:34:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:34:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:34:33 INFO - 'HOME': '/Users/cltbld', 20:34:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:34:33 INFO - 'LOGNAME': 'cltbld', 20:34:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:33 INFO - 'MOZ_NO_REMOTE': '1', 20:34:33 INFO - 'NO_EM_RESTART': '1', 20:34:33 INFO - 'PAGER': '/bin/cat', 20:34:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:34:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:33 INFO - 'PWD': '/builds/slave/test', 20:34:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:34:33 INFO - 'SHELL': '/bin/bash', 20:34:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MYbbF3IHJO/Listeners', 20:34:33 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 20:34:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:34:33 INFO - 'USER': 'cltbld', 20:34:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:34:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:34:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:33 INFO - 'XPC_FLAGS': '0x0', 20:34:33 INFO - 'XPC_SERVICE_NAME': '0', 20:34:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:34:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:34 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 20:34:34 INFO - Cleaning up... 20:34:34 INFO - Return code: 0 20:34:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:34:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f59490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ecf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd43c974e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d6dd30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bd3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d65b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FR9jUec9FL/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MYbbF3IHJO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:34:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:34:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:34:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FR9jUec9FL/Render', 20:34:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:34:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:34:34 INFO - 'HOME': '/Users/cltbld', 20:34:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:34:34 INFO - 'LOGNAME': 'cltbld', 20:34:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:34 INFO - 'MOZ_NO_REMOTE': '1', 20:34:34 INFO - 'NO_EM_RESTART': '1', 20:34:34 INFO - 'PAGER': '/bin/cat', 20:34:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:34:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:34 INFO - 'PWD': '/builds/slave/test', 20:34:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:34:34 INFO - 'SHELL': '/bin/bash', 20:34:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MYbbF3IHJO/Listeners', 20:34:34 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 20:34:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:34:34 INFO - 'USER': 'cltbld', 20:34:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:34:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:34:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:34 INFO - 'XPC_FLAGS': '0x0', 20:34:34 INFO - 'XPC_SERVICE_NAME': '0', 20:34:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:34:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:34 INFO - Downloading/unpacking psutil>=3.1.1 20:34:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:34:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:34:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:34:37 INFO - Installing collected packages: psutil 20:34:37 INFO - Running setup.py install for psutil 20:34:37 INFO - building 'psutil._psutil_osx' extension 20:34:37 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 20:34:38 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 20:34:38 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 20:34:38 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 20:34:38 INFO - building 'psutil._psutil_posix' extension 20:34:38 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 20:34:38 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:34:38 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:34:38 INFO - ^ 20:34:38 INFO - 1 warning generated. 20:34:38 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 20:34:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:34:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:34:39 INFO - Successfully installed psutil 20:34:39 INFO - Cleaning up... 20:34:39 INFO - Return code: 0 20:34:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:34:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f59490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ecf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd43c974e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d6dd30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bd3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d65b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FR9jUec9FL/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MYbbF3IHJO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:34:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:34:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:34:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FR9jUec9FL/Render', 20:34:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:34:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:34:39 INFO - 'HOME': '/Users/cltbld', 20:34:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:34:39 INFO - 'LOGNAME': 'cltbld', 20:34:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:39 INFO - 'MOZ_NO_REMOTE': '1', 20:34:39 INFO - 'NO_EM_RESTART': '1', 20:34:39 INFO - 'PAGER': '/bin/cat', 20:34:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:34:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:39 INFO - 'PWD': '/builds/slave/test', 20:34:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:34:39 INFO - 'SHELL': '/bin/bash', 20:34:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MYbbF3IHJO/Listeners', 20:34:39 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 20:34:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:34:39 INFO - 'USER': 'cltbld', 20:34:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:34:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:34:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:39 INFO - 'XPC_FLAGS': '0x0', 20:34:39 INFO - 'XPC_SERVICE_NAME': '0', 20:34:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:34:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:34:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:34:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:34:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:34:41 INFO - Installing collected packages: mozsystemmonitor 20:34:41 INFO - Running setup.py install for mozsystemmonitor 20:34:42 INFO - Successfully installed mozsystemmonitor 20:34:42 INFO - Cleaning up... 20:34:42 INFO - Return code: 0 20:34:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:34:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f59490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ecf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd43c974e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d6dd30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bd3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d65b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FR9jUec9FL/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MYbbF3IHJO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:34:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:34:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:34:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FR9jUec9FL/Render', 20:34:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:34:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:34:42 INFO - 'HOME': '/Users/cltbld', 20:34:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:34:42 INFO - 'LOGNAME': 'cltbld', 20:34:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:42 INFO - 'MOZ_NO_REMOTE': '1', 20:34:42 INFO - 'NO_EM_RESTART': '1', 20:34:42 INFO - 'PAGER': '/bin/cat', 20:34:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:34:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:42 INFO - 'PWD': '/builds/slave/test', 20:34:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:34:42 INFO - 'SHELL': '/bin/bash', 20:34:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MYbbF3IHJO/Listeners', 20:34:42 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 20:34:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:34:42 INFO - 'USER': 'cltbld', 20:34:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:34:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:34:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:42 INFO - 'XPC_FLAGS': '0x0', 20:34:42 INFO - 'XPC_SERVICE_NAME': '0', 20:34:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:34:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:42 INFO - Downloading/unpacking jsonschema==2.5.1 20:34:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:34:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:45 INFO - Downloading functools32-3.2.3-2.tar.gz 20:34:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:34:45 INFO - warning: no files found matching '*.txt' 20:34:45 INFO - no previously-included directories found matching 'build' 20:34:45 INFO - no previously-included directories found matching 'dist' 20:34:45 INFO - no previously-included directories found matching '.git*' 20:34:45 INFO - Installing collected packages: jsonschema, functools32 20:34:45 INFO - Running setup.py install for functools32 20:34:45 INFO - warning: no files found matching '*.txt' 20:34:45 INFO - no previously-included directories found matching 'build' 20:34:45 INFO - no previously-included directories found matching 'dist' 20:34:45 INFO - no previously-included directories found matching '.git*' 20:34:45 INFO - Successfully installed jsonschema functools32 20:34:45 INFO - Cleaning up... 20:34:45 INFO - Return code: 0 20:34:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:34:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f59490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ecf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd43c974e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d6dd30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bd3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d65b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FR9jUec9FL/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MYbbF3IHJO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:34:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:34:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:34:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FR9jUec9FL/Render', 20:34:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:34:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:34:45 INFO - 'HOME': '/Users/cltbld', 20:34:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:34:45 INFO - 'LOGNAME': 'cltbld', 20:34:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:45 INFO - 'MOZ_NO_REMOTE': '1', 20:34:45 INFO - 'NO_EM_RESTART': '1', 20:34:45 INFO - 'PAGER': '/bin/cat', 20:34:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:34:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:45 INFO - 'PWD': '/builds/slave/test', 20:34:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:34:45 INFO - 'SHELL': '/bin/bash', 20:34:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MYbbF3IHJO/Listeners', 20:34:45 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 20:34:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:34:45 INFO - 'USER': 'cltbld', 20:34:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:34:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:34:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:45 INFO - 'XPC_FLAGS': '0x0', 20:34:45 INFO - 'XPC_SERVICE_NAME': '0', 20:34:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:34:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:34:45 INFO - Cleaning up... 20:34:45 INFO - Return code: 0 20:34:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:34:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f59490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ecf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd43c974e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d6dd30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bd3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d65b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FR9jUec9FL/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MYbbF3IHJO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:34:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:34:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:34:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FR9jUec9FL/Render', 20:34:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:34:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:34:45 INFO - 'HOME': '/Users/cltbld', 20:34:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:34:45 INFO - 'LOGNAME': 'cltbld', 20:34:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:45 INFO - 'MOZ_NO_REMOTE': '1', 20:34:45 INFO - 'NO_EM_RESTART': '1', 20:34:45 INFO - 'PAGER': '/bin/cat', 20:34:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:34:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:45 INFO - 'PWD': '/builds/slave/test', 20:34:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:34:45 INFO - 'SHELL': '/bin/bash', 20:34:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MYbbF3IHJO/Listeners', 20:34:45 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 20:34:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:34:45 INFO - 'USER': 'cltbld', 20:34:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:34:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:34:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:45 INFO - 'XPC_FLAGS': '0x0', 20:34:45 INFO - 'XPC_SERVICE_NAME': '0', 20:34:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:34:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:46 INFO - Downloading/unpacking blobuploader==1.2.4 20:34:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:48 INFO - Downloading blobuploader-1.2.4.tar.gz 20:34:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:34:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:34:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:49 INFO - Downloading docopt-0.6.1.tar.gz 20:34:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:34:50 INFO - Installing collected packages: blobuploader, requests, docopt 20:34:50 INFO - Running setup.py install for blobuploader 20:34:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:34:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:34:50 INFO - Running setup.py install for requests 20:34:50 INFO - Running setup.py install for docopt 20:34:50 INFO - Successfully installed blobuploader requests docopt 20:34:50 INFO - Cleaning up... 20:34:50 INFO - Return code: 0 20:34:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:34:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f59490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ecf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd43c974e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d6dd30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bd3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d65b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FR9jUec9FL/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MYbbF3IHJO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:34:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:34:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:34:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FR9jUec9FL/Render', 20:34:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:34:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:34:50 INFO - 'HOME': '/Users/cltbld', 20:34:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:34:50 INFO - 'LOGNAME': 'cltbld', 20:34:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:50 INFO - 'MOZ_NO_REMOTE': '1', 20:34:50 INFO - 'NO_EM_RESTART': '1', 20:34:50 INFO - 'PAGER': '/bin/cat', 20:34:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:34:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:50 INFO - 'PWD': '/builds/slave/test', 20:34:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:34:50 INFO - 'SHELL': '/bin/bash', 20:34:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MYbbF3IHJO/Listeners', 20:34:50 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 20:34:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:34:50 INFO - 'USER': 'cltbld', 20:34:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:34:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:34:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:50 INFO - 'XPC_FLAGS': '0x0', 20:34:50 INFO - 'XPC_SERVICE_NAME': '0', 20:34:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:34:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:34:51 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-l5Cqk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:34:51 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-tpjZSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:34:51 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-xfRewh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:34:51 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-qLIibL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:34:51 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-6OVpmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:34:51 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-Su29EA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:34:51 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-ZcuQKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:34:51 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-wXROFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:34:51 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-Tnu5iV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:34:52 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-mPCksA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:34:52 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-65UzTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:34:52 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-wtDPMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:34:52 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-UkiGa9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:34:52 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-g5FEJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:34:52 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-QLjNDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:34:52 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-aZD56a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:34:52 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-PwIHP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:34:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:34:52 INFO - Running setup.py install for manifestparser 20:34:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:34:53 INFO - Running setup.py install for mozcrash 20:34:53 INFO - Running setup.py install for mozdebug 20:34:53 INFO - Running setup.py install for mozdevice 20:34:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:34:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:34:53 INFO - Running setup.py install for mozfile 20:34:53 INFO - Running setup.py install for mozhttpd 20:34:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:34:53 INFO - Running setup.py install for mozinfo 20:34:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:34:53 INFO - Running setup.py install for mozInstall 20:34:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:34:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:34:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:34:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:34:54 INFO - Running setup.py install for mozleak 20:34:54 INFO - Running setup.py install for mozlog 20:34:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:34:54 INFO - Running setup.py install for moznetwork 20:34:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:34:54 INFO - Running setup.py install for mozprocess 20:34:54 INFO - Running setup.py install for mozprofile 20:34:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:34:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:34:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:34:54 INFO - Running setup.py install for mozrunner 20:34:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:34:55 INFO - Running setup.py install for mozscreenshot 20:34:55 INFO - Running setup.py install for moztest 20:34:55 INFO - Running setup.py install for mozversion 20:34:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:34:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:34:55 INFO - Cleaning up... 20:34:55 INFO - Return code: 0 20:34:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:34:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f59490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ecf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd43c974e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d6dd30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bd3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d65b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FR9jUec9FL/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MYbbF3IHJO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:34:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:34:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:34:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FR9jUec9FL/Render', 20:34:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:34:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:34:56 INFO - 'HOME': '/Users/cltbld', 20:34:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:34:56 INFO - 'LOGNAME': 'cltbld', 20:34:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:56 INFO - 'MOZ_NO_REMOTE': '1', 20:34:56 INFO - 'NO_EM_RESTART': '1', 20:34:56 INFO - 'PAGER': '/bin/cat', 20:34:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:34:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:56 INFO - 'PWD': '/builds/slave/test', 20:34:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:34:56 INFO - 'SHELL': '/bin/bash', 20:34:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MYbbF3IHJO/Listeners', 20:34:56 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 20:34:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:34:56 INFO - 'USER': 'cltbld', 20:34:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:34:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:34:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:56 INFO - 'XPC_FLAGS': '0x0', 20:34:56 INFO - 'XPC_SERVICE_NAME': '0', 20:34:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:34:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:34:56 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-J9QlSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:34:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 20:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:34:56 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-__CbKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:34:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:34:56 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-K1MT9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:34:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:34:56 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-VL7UJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:34:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:34:57 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-CM3hlQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:34:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 20:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:34:57 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-GiCYnP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:34:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 20:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:34:57 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-om2mId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:34:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 20:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:34:57 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-MKdoJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:34:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 20:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:34:57 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-e3zTJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:34:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 20:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:34:57 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-bT4Tey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:34:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:34:57 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-XizrfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:34:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 20:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:34:57 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-usIzCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:34:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:34:57 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-8ZWs6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:34:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 20:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:34:58 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-pY7UQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:34:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:34:58 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-hSyGSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:34:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 20:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:34:58 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-StaDwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:34:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:34:58 INFO - Running setup.py (path:/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/pip-ImdK_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:34:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 20:34:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:34:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:34:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:34:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:34:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:34:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:35:01 INFO - Downloading blessings-1.6.tar.gz 20:35:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:35:01 INFO - Installing collected packages: blessings 20:35:01 INFO - Running setup.py install for blessings 20:35:01 INFO - Successfully installed blessings 20:35:01 INFO - Cleaning up... 20:35:01 INFO - Return code: 0 20:35:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:35:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:35:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:35:02 INFO - Reading from file tmpfile_stdout 20:35:02 INFO - Current package versions: 20:35:02 INFO - blessings == 1.6 20:35:02 INFO - blobuploader == 1.2.4 20:35:02 INFO - docopt == 0.6.1 20:35:02 INFO - functools32 == 3.2.3-2 20:35:02 INFO - jsonschema == 2.5.1 20:35:02 INFO - manifestparser == 1.1 20:35:02 INFO - mozInstall == 1.12 20:35:02 INFO - mozcrash == 0.17 20:35:02 INFO - mozdebug == 0.1 20:35:02 INFO - mozdevice == 0.48 20:35:02 INFO - mozfile == 1.2 20:35:02 INFO - mozhttpd == 0.7 20:35:02 INFO - mozinfo == 0.9 20:35:02 INFO - mozleak == 0.1 20:35:02 INFO - mozlog == 3.4 20:35:02 INFO - moznetwork == 0.27 20:35:02 INFO - mozprocess == 0.23 20:35:02 INFO - mozprofile == 0.28 20:35:02 INFO - mozrunner == 6.12 20:35:02 INFO - mozscreenshot == 0.1 20:35:02 INFO - mozsystemmonitor == 0.3 20:35:02 INFO - moztest == 0.7 20:35:02 INFO - mozversion == 1.4 20:35:02 INFO - psutil == 3.1.1 20:35:02 INFO - requests == 1.2.3 20:35:02 INFO - wsgiref == 0.1.2 20:35:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:35:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:35:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:35:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:35:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f59490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ecf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd43c974e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d6dd30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bd3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d65b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FR9jUec9FL/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MYbbF3IHJO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:35:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 20:35:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:35:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FR9jUec9FL/Render', 20:35:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:35:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:35:02 INFO - 'HOME': '/Users/cltbld', 20:35:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:35:02 INFO - 'LOGNAME': 'cltbld', 20:35:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:35:02 INFO - 'MOZ_NO_REMOTE': '1', 20:35:02 INFO - 'NO_EM_RESTART': '1', 20:35:02 INFO - 'PAGER': '/bin/cat', 20:35:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:35:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:35:02 INFO - 'PWD': '/builds/slave/test', 20:35:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:35:02 INFO - 'SHELL': '/bin/bash', 20:35:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MYbbF3IHJO/Listeners', 20:35:02 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 20:35:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:35:02 INFO - 'USER': 'cltbld', 20:35:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:35:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:35:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:35:02 INFO - 'XPC_FLAGS': '0x0', 20:35:02 INFO - 'XPC_SERVICE_NAME': '0', 20:35:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:35:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:35:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:35:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 20:35:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 20:35:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:35:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 20:35:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 20:35:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 20:35:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 20:35:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 20:35:02 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:35:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:35:02 INFO - Cleaning up... 20:35:02 INFO - Return code: 0 20:35:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:35:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:35:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:35:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:35:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f59490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ecf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd43c974e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d6dd30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bd3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d65b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FR9jUec9FL/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MYbbF3IHJO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:35:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:35:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:35:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FR9jUec9FL/Render', 20:35:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:35:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:35:02 INFO - 'HOME': '/Users/cltbld', 20:35:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:35:02 INFO - 'LOGNAME': 'cltbld', 20:35:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:35:02 INFO - 'MOZ_NO_REMOTE': '1', 20:35:02 INFO - 'NO_EM_RESTART': '1', 20:35:02 INFO - 'PAGER': '/bin/cat', 20:35:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:35:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:35:02 INFO - 'PWD': '/builds/slave/test', 20:35:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:35:02 INFO - 'SHELL': '/bin/bash', 20:35:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MYbbF3IHJO/Listeners', 20:35:02 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 20:35:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:35:02 INFO - 'USER': 'cltbld', 20:35:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:35:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:35:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:35:02 INFO - 'XPC_FLAGS': '0x0', 20:35:02 INFO - 'XPC_SERVICE_NAME': '0', 20:35:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:35:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:35:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:35:02 INFO - Cleaning up... 20:35:02 INFO - Return code: 0 20:35:02 INFO - Running post-action listener: _resource_record_post_action 20:35:02 INFO - Running post-action listener: _start_resource_monitoring 20:35:02 INFO - Starting resource monitoring. 20:35:02 INFO - [mozharness: 2016-09-22 03:35:02.645234Z] Finished create-virtualenv step (success) 20:35:02 INFO - [mozharness: 2016-09-22 03:35:02.646243Z] Running install step. 20:35:02 INFO - Running pre-action listener: _resource_record_pre_action 20:35:02 INFO - Running main action method: install 20:35:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:35:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:35:02 INFO - Reading from file tmpfile_stdout 20:35:02 INFO - Detecting whether we're running mozinstall >=1.0... 20:35:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:35:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:35:03 INFO - Reading from file tmpfile_stdout 20:35:03 INFO - Output received: 20:35:03 INFO - Usage: mozinstall [options] installer 20:35:03 INFO - Options: 20:35:03 INFO - -h, --help show this help message and exit 20:35:03 INFO - -d DEST, --destination=DEST 20:35:03 INFO - Directory to install application into. [default: 20:35:03 INFO - "/builds/slave/test"] 20:35:03 INFO - --app=APP Application being installed. [default: firefox] 20:35:03 INFO - mkdir: /builds/slave/test/build/application 20:35:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 20:35:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 20:35:35 INFO - Reading from file tmpfile_stdout 20:35:35 INFO - Output received: 20:35:35 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 20:35:35 INFO - Running post-action listener: _resource_record_post_action 20:35:35 INFO - [mozharness: 2016-09-22 03:35:35.495452Z] Finished install step (success) 20:35:35 INFO - [mozharness: 2016-09-22 03:35:35.495631Z] Running run-tests step. 20:35:35 INFO - Running pre-action listener: _resource_record_pre_action 20:35:35 INFO - Running main action method: run_tests 20:35:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:35:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:35:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:35:35 INFO - 2016-09-21 20:35:35.510 screenresolution[1636:7567] starting screenresolution argv=screenresolution get 20:35:35 INFO - 2016-09-21 20:35:35.513 screenresolution[1636:7567] Display 0: 1600x1200x32@60 20:35:35 INFO - 2016-09-21 20:35:35.519 screenresolution[1637:7569] starting screenresolution argv=screenresolution list 20:35:35 INFO - Available Modes on Display 0 20:35:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:35:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:35:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:35:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:35:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:35:35 INFO - Intel Iris: 20:35:35 INFO - Chipset Model: Intel Iris 20:35:35 INFO - Type: GPU 20:35:35 INFO - Bus: Built-In 20:35:35 INFO - VRAM (Dynamic, Max): 1536 MB 20:35:35 INFO - Vendor: Intel (0x8086) 20:35:35 INFO - Device ID: 0x0a2e 20:35:35 INFO - Revision ID: 0x0009 20:35:35 INFO - Displays: 20:35:35 INFO - Display: 20:35:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:35:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:35:35 INFO - Display Serial Number: 1600x1200 60 20:35:35 INFO - Main Display: Yes 20:35:35 INFO - Mirror: Off 20:35:35 INFO - Online: Yes 20:35:35 INFO - Rotation: Supported 20:35:35 INFO - Return code: 0 20:35:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:35:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:35:35 INFO - Python 2.7.3 20:35:35 INFO - Return code: 0 20:35:35 INFO - grabbing minidump binary from tooltool 20:35:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:35:35 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d6dd30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bd3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d65b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:35:35 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 20:35:35 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 20:35:35 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 20:35:35 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:35:35 INFO - Return code: 0 20:35:35 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:35:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:35:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:35:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:35:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:35:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dFGFCL_xT56X0MIpuBVzBQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 20:35:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dFGFCL_xT56X0MIpuBVzBQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0024 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 20:35:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FR9jUec9FL/Render', 20:35:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:35:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:35:35 INFO - 'HOME': '/Users/cltbld', 20:35:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:35:35 INFO - 'LOGNAME': 'cltbld', 20:35:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:35:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:35:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:35:35 INFO - 'MOZ_NO_REMOTE': '1', 20:35:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:35:35 INFO - 'NO_EM_RESTART': '1', 20:35:35 INFO - 'PAGER': '/bin/cat', 20:35:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:35:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:35:35 INFO - 'PWD': '/builds/slave/test', 20:35:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:35:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:35:35 INFO - 'SHELL': '/bin/bash', 20:35:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MYbbF3IHJO/Listeners', 20:35:35 INFO - 'TMPDIR': '/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/', 20:35:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:35:35 INFO - 'USER': 'cltbld', 20:35:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:35:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:35:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:35:35 INFO - 'XPC_FLAGS': '0x0', 20:35:35 INFO - 'XPC_SERVICE_NAME': '0', 20:35:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:35:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dFGFCL_xT56X0MIpuBVzBQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 20:35:36 INFO - mozversion application_buildid: 20160921181859 20:35:36 INFO - mozversion application_changeset: f93ac29ad106222f2cd7e55a1d24795f89425dd4 20:35:36 INFO - mozversion application_display_name: FirefoxDeveloperEdition 20:35:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:35:36 INFO - mozversion application_name: Firefox 20:35:36 INFO - mozversion application_remotingname: firefox-dev 20:35:36 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:35:36 INFO - mozversion application_vendor: Mozilla 20:35:36 INFO - mozversion application_version: 51.0a2 20:35:36 INFO - mozversion platform_buildid: 20160921181859 20:35:36 INFO - mozversion platform_changeset: f93ac29ad106222f2cd7e55a1d24795f89425dd4 20:35:36 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:35:36 INFO - mozversion platform_version: 51.0a2 20:35:36 INFO - using testdate: 1474515336 20:35:36 INFO - actual date: 1474515336 20:35:36 INFO - starting webserver on 'localhost:49272' 20:35:36 INFO - SUITE-START | Running 2 tests 20:35:36 INFO - TEST-START | dromaeo_css 20:35:36 INFO - operating with platform_type : mac_ 20:35:36 INFO - Initialising browser for dromaeo_css test... 20:35:36 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/tmpxQG3WK/profile http://localhost:49272/getInfo.html) 20:35:39 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 20:35:39 INFO - PROCESS | 1647 | colorDepth:24 20:35:39 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 20:35:39 INFO - PROCESS | 1647 | __metrics 20:35:39 ERROR - PROCESS | 1647 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 20:35:39 INFO - TEST-INFO | 1647: exit 0 20:35:39 INFO - Browser initialized. 20:35:39 INFO - Running cycle 1/1 for dromaeo_css test... 20:35:39 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/tmpxQG3WK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:35:51 INFO - PROCESS | 1650 | RSS: Main: 224948224 20:35:51 INFO - PROCESS | 1650 | 20:36:41 INFO - PROCESS | 1650 | 1474515401451 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 20:38:54 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 20:38:55 INFO - PROCESS | 1650 | RSS: Main: 236539904 20:38:55 INFO - PROCESS | 1650 | 20:41:58 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 20:41:58 INFO - PROCESS | 1650 | RSS: Main: 249901056 20:41:58 INFO - PROCESS | 1650 | 20:45:00 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 20:45:01 INFO - PROCESS | 1650 | RSS: Main: 252977152 20:45:01 INFO - PROCESS | 1650 | 20:48:03 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 20:48:03 INFO - PROCESS | 1650 | RSS: Main: 253100032 20:48:03 INFO - PROCESS | 1650 | 20:51:06 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 20:51:07 INFO - PROCESS | 1650 | RSS: Main: 258539520 20:51:07 INFO - PROCESS | 1650 | 20:54:10 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 20:54:10 INFO - PROCESS | 1650 | RSS: Main: 260235264 20:54:10 INFO - PROCESS | 1650 | 20:54:10 INFO - PROCESS | 1650 | __start_tp_report 20:54:10 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 20:54:10 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 20:54:10 INFO - PROCESS | 1650 | |i|pagename|runs| 20:54:10 INFO - PROCESS | 1650 | |0;dojo.html;3427.6572342765726;3429.8971030869066;3443.139215196201;3458.6195518492955;3463.792172469652;5782.797602083928;5843.123531470282;5845.7369418376165;5857.121431785235;5862.88274234515;5800.9129863051985;5861.824145275638;5886.117082437626;5913;5925.200097986771;5270.868228294295;5340.599455040868;5366.087765079946;5390.434004429537;5394.271773310612;5366.490183432567;5380.112281473572;5396.78412863485;5398.865028374283;5407.457356209877;5253.842384728445;5263.789448422059;5381.623286369956;5389.649672771257;5435.130379139338;5284.841454756363;5313.22958171065;5322.547583455411;5328.360596728378;5333.093374126408;5210.348706411699;5261.605379596507;5294.973525132388;5345.33183352081;5369.355677318707;5224.608154388436;5650.434956504317;5859.209006784072;5877.617954832965;5912.201852749867;5159.638825282232;6123.3131248723375;6201.937980620226;6217.937820621826;6261.78083767066;6311.779087731908;6338.683065846689;6345.777897773602;6346;6366.822137904503;5841.4450627190345;5940.524758019348;5947.583669143161;5953.821385358447;5967.820965371089;6347.238331400169;6347.746090156342;6389.6805159741825;6414.839629009312;6426.582272152295;4854.951450485521;5047.621428392885;5079.697150826843;6123.724432400552;6196.287426945959;6161.983272760034;6162.691865406712;6225.003999360171;6328.810135695937;6355.491560675135;6189.566730328924;6246.125542424064;6260.593061451083;6270.090836828635;6278.152449419361;5178.792848286026;6274.1843560337775;6275.278342990523;6301.7164227609865;6304.747810087637;4050.5544390117066;4889.242167464049;4934.506549345037;4950.480199578992;4979.2033274676605;4436.511983681792;4499.685022048425;4502.774861256924;4511.255642818964;4520.141173177086;5903.793367232126;6056.091586262096;6060.515158787286;6077.453029227391;6100.847478813065;6169.198004259418;6248.125262463259;6318.968405157945;6320.778772743024;6329.208848893888;5889.823305300848;5956.642601443928;6017.608855424383;6057.878842423127;6109.572329936951;5505.862353441116;5514.200440936042;5517.089680202722;5521.972390138024;5536.086545719912;6428.035794630843;6478.578892371981;6489.7404103835315;6499.707513161825;6518.5762925410645;6237.500999919905;6247.31279559239;6253;6282.465990390868;6301.779437719658;6450.516211284266;6528.314526974789;6530.738770449128;6535.150430444012;6537.836554086186;5380.623356365017;5800;6297.275813281532;6297.370262973666;6303.275123360689;6161.72272247741;6222.471089957405;6236.18929539157;6241;6272.74909003653;6241.251049873863;6257;6266.655333956676;6278.0269058296035;6285.905711414241;5447.96488667152;6246.156768836149;6251.593646412968;6288.899442597436;6296.212973378328;5825.184474173704;5991.730372133177;6013.6692481913915;6072.453479186895;6144.846378840565;6171.197744293213;6211.534134939988;6257.812265632038;6271.6550589718;6286.497080233479;6136.079588061826;6151.753929842756;6156.630602163885;6159.876802463836;6179.876402472015 20:54:10 INFO - PROCESS | 1650 | |1;ext.html;441.57829273044246;447.5122116892587;492.99429164504414;510.5175609049445;519.7842895198493;36600.633993660056;39766.602333976654;39774.602253977486;39780;40019.79990100049;41368;41661.58338416615;42056.57943420565;42104;42154.78922605383;9574.617015319396;9830.754231144243;9837.458939758311;9858.964808695091;9877.851832222523;8242.876356854622;9698.32111752174;9812.116909478145;9828;9848.852267215998;9837.852432213522;9850.60597576096;9869.259805514579;9875.40747555149;9946.950265248664;9806.803863922752;9810.509474526316;9844.556994935245;9860.950695246549;9863.605455781795;9674.274429417821;9674.613015479372;9707.951460242724;9788.021197880225;9812.165965892907;31284.843575782204;32312;39031;39096.02259943496;39320.80339598284;2806.733360330765;3145.339478709474;3230.5800245967876;3377.1894745261206;3832.2527107214105;29800;29800.254993625334;30586.69413305861;30671.611288891752;31482.37035259282;2779.4163225722623;3141.2932090279733;3293.4236508610898;3433.5536380270655;3435.7251419886347;513493;519590;519699;520654;521674;61958.0706289406;62306;62499.68750156311;62589.687051565365;62907.6854615724;34857.825710871286;35669.1082722934;53489.732551336994;65060;65883.67058164679;16699.33202671904;16843.41048063312;16844.663106737797;16857.91571042137;16954.830451695325;12874.742505149845;12963.22220666763;12985.675358115934;13014.023948203923;13032.739345213042;18889.7166542502;19191.80808191928;19359.806401936083;19366.612667746565;19397.321093761933;7876.133625301212;7952.2842944134145;8000.479968802126;8008.7597372078935;8026.8728786871525;871.2942516561606;1019.1744686803713;1055.6358056470506;1063.7393838509615;1089.1341383600056;27660.308492287855;28128.43743125126;30076.548851767242;30322;30756;815.6900377856496;983.3755565216139;1080.6163811846839;1089.841972913939;1113.4210210690558;15297;15682.529524114294;15796.763048554281;15873.603159921095;16043.278052487665;710819;714626;719027;719360;720769;57536.136957945666;58098.419015809304;58231.8353632925;58307.833843323744;58422.83154336889;1353.4180302469836;1376.5319791271015;1405.058610730813;1405.796159556879;1410.92945352734;29158;29749.256268593457;29978.550321745628;30332.609726276387;30728.692713073477;41356.759297221135;50024.74987625039;50481.74759126181;50555.49444505655;50667;571399;619408;621722;621723;629015;26725.06462273811;26778.330541736614;27170.1848944532;27170.864145679145;27218.82249420002;37391.50433982719;46161.538384617066;46943.530564693916;47066.52933470622;48528.272075919594;30986.535201972438;38419.42370864384;39355;40442.39336410015;40672.983175419664;32613.673863262014;39198.82403527899;39551;39847.203055939295;40670.79664601658;32314.030579082664;32928.83535582307;36099;37591.2481750358;38174.80912595419;25948.610770838073;33461.82883599062;34154.65845341515;35282.294354113284;35354.64645353617;25453.109141179968;25902.35244118912;25985.740142598333;25989.700514973796;26388.868055659597 20:54:10 INFO - PROCESS | 1650 | |2;jquery.html;374.80697440817966;375.19895024123497;381.574544383013;388.4134956216116;402.0210786734302;17163.056031918255;19050.523736906565;20711.964401779907;21361.893190534025;21616.459588510294;20301.59396812063;20624.381268561967;20649.277275295368;20915.37253882382;21210;5521.254630624874;5831.125331200312;6121.479674227674;6143.324234334242;6190.721417536199;3827.291950989062;4066.552679205285;6147.7233524491285;6184.07238914162;6204.007358822567;5830.892130495214;6105.847353816146;6151.415615516541;6191.752329906798;6197.442230199281;5817.1565123057135;5970.522358211333;6158.753649854;6526.641034743087;6788.796336109925;5973.894829456521;5975.372585878507;5982.611130276518;5989.940100598982;5993.430624090704;12882.742345153138;12963.28701921394;13119.475220991244;13217.07480476367;13303.534376296782;2311;2345.2495201535517;2400.471896182837;2857.5856500807267;2988.835614041227;9964.950175249078;9980;10372.481375931173;10413.219008574388;10421.53103110362;1778.1998100854667;1828.7256911463253;1854.8237917397826;1876.0713446843763;1909.713542968552;110922;116581;117570;118421;119958;9342.95328523353;9887.258455615858;9980.051895069957;10001.299909006446;10181.54183061764;12407.131500794858;12483.50065997368;12566.937165314115;12581.496740130475;12624.305663188612;6672.666366681647;7257.346838784535;8027.959860200662;8168.264856162974;8243.05204901432;8014.559199244098;8478.02502712196;8564.400491965502;8653.004904435944;8726.214640682369;3828.770273783582;3904.6095390460728;3926.764394136361;3947.2894878921497;3971.5829837867186;1921.5868588253313;1966.7246585478044;1980.1881228696166;1990.741203643517;3800.239952009609;784.6782819044164;834.9332053435711;861.3453775130946;920.346553946692;951.785848184153;19055.523611909535;20110;21510.892445537673;22352.664710029363;22382.664260036112;931.3340961212765;941.1623654947102;985.5466485416645;995.8572339069581;1004.6985904228702;11290.491927863266;11508.769824603629;11515.827262591069;11519.88480115188;11522.596709115141;602288;611241;612783;613669.9316503389;613703;121209;122178;128869;140613;144800;998.5072316886157;1012.0739523336213;1014.6144465103214;1016.2327442780653;1035.3270374256792;18442;19246;19454;19734.60530789405;19748.605027899073;45173.77413112913;52622.15822446196;57237.71381143068;58511;59425.405745941986;81675.18324816914;82457;85006;87116.1288387108;87316;7030;7156.892646610409;7280.563166210044;7359.926400736138;7391.963040184764;9389.718308450758;12061.457234424297;12690.365481726061;12775.680607984874;12835.743285134058;10975.451227438756;11141.554337826396;11192.552297907992;11302.604408845651;11489;8493.150684931457;8825.896762904636;9628.18160456369;10181.592736290762;11117.610883619034;11188.272762270426;11247.044001259985;11493.770124597295;11499.195056345976;11668.766624667629;7963.357987281177;8047.436679432383;8239.093699693149;8296.792580185544;8331.541765202972;6828.9658551706925;9494.667686630935;10408.115310198718;10619.681409557727;10928.78142437131 20:54:10 INFO - PROCESS | 1650 | |3;mootools.html;1480.1489143742347;1533.1261181126758;1638.4511188751767;1713.614436751731;1831.679456095183;8207.015158181026;8485.10906354833;8719.389642725011;9281.396709213914;9320.067993200684;8738.694145704885;9047.592858321375;9055.456672599632;9207.125323094311;9214.539273036355;2393.1384701507486;2428.00451814756;2428.5264373447185;2431.7932975697086;2435.866027368494;2394.568977584034;2421.4188594737225;2438.085717855804;2444.144549407702;2446.449548851512;2391.988040059797;2422.2733180045916;2430.5989511730545;2436.914707985221;2444.022391043588;2383.797377222938;2385.844920080198;2395.964060539102;2399.3881560202126;2407.8796060197096;2378.4767351182713;2393.1623931623967;2397.0891061396733;2398.220578312038;2404.5671779079757;9099.181073703332;9137.543122843897;9174.908250917471;9187.26501879848;9192.402493837879;5348.117560602496;5456.727163641842;5497.505224529811;5499.202615620753;5532.972335138339;3601.8559257629663;3683.723720720957;3718.7768733876055;3745.382011968022;3780.300644380771;1101.832058018503;1103.8840921703265;1107.1364335818075;1111.2832223216062;1118.6588090632354;12066.457009434509;12095.93952030243;12139.210951288138;12174.330411827346;12192.512299508098;4534.410526631516;4601.28680054592;4732.077244937204;4744.240921452551;4781.928271075936;9354.20489258407;9440.858387124199;9450.669226577036;9455.101765332283;9457.290703197288;5342.652727572696;5350.785968561214;5353.812616558402;5357.249985002103;5367.490088441592;4465.843695470708;4611.700239484423;4839.806407743721;4983.152864013126;5008.048470790538;3861.3049651062515;3884.669803066771;3943.5662077171487;3965.7422267552515;3983.322835118037;1187.893089621938;1194.4804010255393;1197.1978774221293;1206.1255589697575;1207.7886369885234;794.5907857453416;893.7140115163086;922.8200500902394;925.4956048953337;928.5635751196927;5361.222622719683;5891.823245302648;6025.517958563304;6089.847753806191;6219.937800622027;428.5414606371153;448.34765416319175;449.6537665997229;456.65522530489267;459.54734586432335;4005.0387906902133;4028.8388464461677;4048.2105989332385;4052.90571545681;4056.249593825152;10764.762052363922;10979.121670266359;11036.392998385005;11058;11065;10899.964503372166;10947.233693641369;11022.559097636005;11029.558817647365;11034.779304413867;8025.9197408025175;8414.49513029208;8450.366222533212;8452.492850428995;8454.83090338202;6087.604305720114;6097.573169878244;6173.166622505904;6178.567500274938;6191.288001879841;8658.610362533575;9172.761677173496;10311.020453056948;10390.636327728493;10547.683569492927;8681;10013.799724005625;10419.791604167722;10477.37135771856;10496.737581560523;6502.60984340941;7216.639168041682;7393.778186654409;7781.338586220235;7918.089419716806;8488.236058754741;8768.991565969995;8772.736817895473;8782.121787821166;8784.824303514022;7651;7754.379649628129;7789.766307010798;7882.330001949898;7899.960500197462;6237.5009999200865;7625.656845442079;7663.69345226207;7777.72777952769;7785.883211751715;5946.910796337972;7044.964775176091;7181.210066892742;7203.387712044325;7209.4592905533345;5016.347874776256;5091.236314552847;5121.052997290063;5246.842594722164;5302.28419163408;3940.8226629801156;5115.2582875483595;5141.331626888481;5173.249878767633;5267.104592219409 20:54:10 INFO - PROCESS | 1650 | |4;prototype.html;302.2941431756849;305.53863665864543;309.5078824668777;315.1836742836057;315.7000849193267;5348.154886564139;5499.615026948115;5576.9163462547995;5578.378162263734;5604.439556044394;4497.280435130379;5385.838424847251;5459.235707001013;5474.315710536183;5511.889762204763;3669.156403787073;4229.217594744967;4242.2788126018495;4256.9996050928;4264.147170565884;4092.9590704093025;4156.37901218525;4196.39152322913;4230;4251.341042138473;3796.1838204785968;3894.6105389460968;3995.8002099895034;4147.025449019478;4175.4363160973335;3626.476879710528;3680.963190368089;4187.392828039948;4196.748195108304;4198.895027624303;3156.9842150789327;3560;3651.1419816343137;3667.8899633010788;3685.3366394049062;4370.366296886934;4629.861104166846;5278.683279003272;5315.548178404841;5335.413104558495;4288.649075541226;4323.4867796271365;4746.145693775119;4796.834089500912;4805.399325084364;4828.46886842447;4920.655554111214;5493.560515158778;5714.885702285931;5822.854428639275;3564.3940530109944;3663.99240208942;3963.286608410485;3964.960350396488;3993.520777506689;4961.429435614915;4992.625553083533;5975.611585246945;6036.641755604954;6105.664188469633;3568.982155089208;3627.9818600907356;4031.1937612477623;4050.589899010084;4074.633283004544;3378.3412234614507;3740.8877733668032;3827.961720382816;4109.91780164395;4117.138588680898;4757.834330588958;4777.044591081728;4781.772303694992;4801.615870730333;4839.177339852234;4760.381150450419;4823.397075365579;4951.836318465158;5817.200809332233;5875.9118613220835;1198.8501437320335;1328.4885319152197;1377.5454100146928;1428.328685517805;1434.2040167706814;837.6481877611418;929.9023602521773;956.8803899512561;973.5348300807382;991.3258983891023;4525.732794817456;4797.328374027639;5337.066013447631;5457.590680698963;5480.232767412565;4893.95106048942;5629.521490673257;5727.883062802797;5932.525397968152;5956.463918247378;4774.379330686988;5098.949010509921;5420.4850539198715;5455.399906010336;5480.588955828329;2817.7742681933014;2882.30824602094;3139.6970257342946;3156.2740569668645;3173.920651983719;4973.428055773632;5715.685637289906;6254.874902501924;6273.8745225095245;6301.6534090625455;4817.879553011133;4897.608191344684;6048.697565121726;6110.541709371815;6185.443310102112;5758.913616295759;6290.77329920661;6297.937020629735;6303.361126107154;6315.273743519462;4760.6191504678845;5624.690642014565;5729.312482502127;5925.644461332334;5966.880662386641;5584.329880414214;5861.9413805861395;5903.763849445974;5905.320888097924;5920.4671579556325;4862.784303924019;5451.918221226605;5684.403137670651;6026.367231440636;6292.874142517033;3601.819909004592;3738.7382883197915;3889.0666240101605;3932.508436445444;3976.8011599419333;5809.24479817621;5971.850703732442;6010.4838669378905;6044.219658956929;6107.816765497042;4467.6202522785925;5221.326912413445;5804.2744656917885;5864.800699737599;5923.4076592340425;5378.596605254544;5491.203775452457;5744.9946259403605;5897.439743224559;5912.605394815107;5016.749162541932;5144.279800827812;5731.02572562657;5745.942540574708;5819.127130930395;5679.6024278301775;5901.793437229677;5952.970235148797;5979.455613733507;6005;4952.994037414853;4993.926305844116;5476.288082549243;5637.900609381131;5850.385709500441 20:54:10 INFO - PROCESS | 1650 | |5;yui.html;746.216472703661;748.7341993592274;755.939524838013;787.0948409329275;817.1093508076195;15157.621059473518;15487.612809679764;15752.606184845385;15761.60595985101;15796.763048554281;14171;14297.928510357433;14322.641933951656;14323.212223327713;14326.641833954156;678.7488629207201;846.2764336492303;878.4509681449094;878.7846977490524;881.0528681667201;855.1619412975288;857.2284943550823;858.107568129145;863.1454859688894;863.3740538109882;904.1049361132498;919.8850143732034;921.5392303848076;921.5622579274824;924.5654542365078;913.4701872913728;914.7438717159206;916.6287653500343;917.9993806750674;918.5085979001202;681.560393546165;684.260998122027;684.7261095561765;685.5543896467336;687.0793137196181;15261.465848695354;15350.155741434217;15462.149581772997;15500.844991550053;15544.533663990098;11266.211365204439;14131;14176.85823141776;14372.35324410404;14395.496157634538;11544.632257615895;11734.413279336084;11880.287182768976;12066.457009434509;12114.339147778368;3796.4305354196817;3817.2747178036084;3841.42378643203;3955.268275369066;3962.6829853611644;129466.35266823605;130489;130545;132660;135598.6440135596;10727.463626818628;10965.396903170242;10969;11002.009819116318;11025.612839397463;22134.55730885373;22217.888910555343;22298.55402891933;22398.216062437736;22466.988985495693;6937.924621683647;7170.533915295489;7668.696321625337;7950.4832185907735;8084.676612935416;3775.3770627846097;3782.8865134046023;4304.139172165516;4453.309736990772;4499.955000450019;3663.4871118043493;3762.7930463824205;3790.9431358529646;3793.7534060285993;3798.924021519554;680.4284401103097;687.9105716256854;692.6813665713828;693.5284006875373;694.350782018814;522.8222404382528;544.3413469701705;554.1659801997968;570.7346084070927;656.957297775643;9605.895322037915;9675.612975481043;9696.903030969741;9703.708888733348;9863.762392037146;635.4920836979845;654.1300070905684;667.182701191037;670.6847781542667;673.1383828699175;4017.690574147653;4501.662375321798;4661.976690116528;4677.859664210079;4693.882652933704;87248.5637571808;148173;160406.59390109158;167468;175154;91874;92393.53803230941;105050;122567.38716306361;142299;123155;123541.76458235303;124093.13860292103;125028;126280.36859815642;9000.63997440095;9097.863532046893;9098.772530686785;9109.544522773967;9143.451392916446;49697.75151124221;65659;66384.6680766593;67595;70670.93993589998;64822;86528.70206947027;86653.2669346597;101703.49148254211;104498;12800.16798908068;13078.346082696018;13082.28047457399;13151.671208219872;13266.204027758366;15387.61530961735;15450.304736287118;15683.451079212173;15886.364545418515;15893.28480218416;14037.1577705338;14054.718905621627;14156.646083847574;14533.636659083184;14700.779488307899;13799.655008624864;13835.405352841879;13871.791923121364;14097.718045639234;14147.64630884236;13098.2141071536;13176.538821141214;13659.726805463637;13753.174809511062;14216.644583885485;10884;11171.832422513506;11328.830067549157;11796.29222246668;12319.384030798603;11039.00648941567;11499.770004599693;11802.232854864405;11894.881051189723;11896.524139034342 20:54:10 INFO - PROCESS | 1650 | __end_tp_report 20:54:10 INFO - PROCESS | 1650 | __start_cc_report 20:54:10 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,376 20:54:10 INFO - PROCESS | 1650 | __end_cc_report 20:54:10 INFO - PROCESS | 1650 | __startTimestamp1474516450655__endTimestamp 20:54:10 INFO - PROCESS | 1650 | 20:54:10 INFO - PROCESS | 1650 | ------- Summary: start ------- 20:54:10 INFO - PROCESS | 1650 | Number of tests: 6 20:54:10 INFO - PROCESS | 1650 | 20:54:10 INFO - PROCESS | 1650 | [#0] dojo.html Cycles:165 Average:5806.67 Median:6060.52 stddev:662.57 (10.9%) stddev-sans-first:637.78 20:54:10 INFO - PROCESS | 1650 | Values: 3427.7 3429.9 3443.1 3458.6 3463.8 5782.8 5843.1 5845.7 5857.1 5862.9 5800.9 5861.8 5886.1 5913.0 5925.2 5270.9 5340.6 5366.1 5390.4 5394.3 5366.5 5380.1 5396.8 5398.9 5407.5 5253.8 5263.8 5381.6 5389.6 5435.1 5284.8 5313.2 5322.5 5328.4 5333.1 5210.3 5261.6 5295.0 5345.3 5369.4 5224.6 5650.4 5859.2 5877.6 5912.2 5159.6 6123.3 6201.9 6217.9 6261.8 6311.8 6338.7 6345.8 6346.0 6366.8 5841.4 5940.5 5947.6 5953.8 5967.8 6347.2 6347.7 6389.7 6414.8 6426.6 4855.0 5047.6 5079.7 6123.7 6196.3 6162.0 6162.7 6225.0 6328.8 6355.5 6189.6 6246.1 6260.6 6270.1 6278.2 5178.8 6274.2 6275.3 6301.7 6304.7 4050.6 4889.2 4934.5 4950.5 4979.2 4436.5 4499.7 4502.8 4511.3 4520.1 5903.8 6056.1 6060.5 6077.5 6100.8 6169.2 6248.1 6319.0 6320.8 6329.2 5889.8 5956.6 6017.6 6057.9 6109.6 5505.9 5514.2 5517.1 5522.0 5536.1 6428.0 6478.6 6489.7 6499.7 6518.6 6237.5 6247.3 6253.0 6282.5 6301.8 6450.5 6528.3 6530.7 6535.2 6537.8 5380.6 5800.0 6297.3 6297.4 6303.3 6161.7 6222.5 6236.2 6241.0 6272.7 6241.3 6257.0 6266.7 6278.0 6285.9 5448.0 6246.2 6251.6 6288.9 6296.2 5825.2 5991.7 6013.7 6072.5 6144.8 6171.2 6211.5 6257.8 6271.7 6286.5 6136.1 6151.8 6156.6 6159.9 6179.9 20:54:10 INFO - PROCESS | 1650 | 20:54:10 INFO - PROCESS | 1650 | [#1] ext.html Cycles:180 Average:73627.09 Median:39453.00 stddev:166641.11 (422.4%) stddev-sans-first:167017.99 20:54:10 INFO - PROCESS | 1650 | Values: 441.6 447.5 493.0 510.5 519.8 36600.6 39766.6 39774.6 39780.0 40019.8 41368.0 41661.6 42056.6 42104.0 42154.8 9574.6 9830.8 9837.5 9859.0 9877.9 8242.9 9698.3 9812.1 9828.0 9848.9 9837.9 9850.6 9869.3 9875.4 9947.0 9806.8 9810.5 9844.6 9861.0 9863.6 9674.3 9674.6 9708.0 9788.0 9812.2 31284.8 32312.0 39031.0 39096.0 39320.8 2806.7 3145.3 3230.6 3377.2 3832.3 29800.0 29800.3 30586.7 30671.6 31482.4 2779.4 3141.3 3293.4 3433.6 3435.7 513493.0 519590.0 519699.0 520654.0 521674.0 61958.1 62306.0 62499.7 62589.7 62907.7 34857.8 35669.1 53489.7 65060.0 65883.7 16699.3 16843.4 16844.7 16857.9 16954.8 12874.7 12963.2 12985.7 13014.0 13032.7 18889.7 19191.8 19359.8 19366.6 19397.3 7876.1 7952.3 8000.5 8008.8 8026.9 871.3 1019.2 1055.6 1063.7 1089.1 27660.3 28128.4 30076.5 30322.0 30756.0 815.7 983.4 1080.6 1089.8 1113.4 15297.0 15682.5 15796.8 15873.6 16043.3 710819.0 714626.0 719027.0 719360.0 720769.0 57536.1 58098.4 58231.8 58307.8 58422.8 1353.4 1376.5 1405.1 1405.8 1410.9 29158.0 29749.3 29978.6 30332.6 30728.7 41356.8 50024.7 50481.7 50555.5 50667.0 571399.0 619408.0 621722.0 621723.0 629015.0 26725.1 26778.3 27170.2 27170.9 27218.8 37391.5 46161.5 46943.5 47066.5 48528.3 30986.5 38419.4 39355.0 40442.4 40673.0 32613.7 39198.8 39551.0 39847.2 40670.8 32314.0 32928.8 36099.0 37591.2 38174.8 25948.6 33461.8 34154.7 35282.3 35354.6 25453.1 25902.4 25985.7 25989.7 26388.9 20:54:10 INFO - PROCESS | 1650 | 20:54:10 INFO - PROCESS | 1650 | [#2] jquery.html Cycles:180 Average:35155.07 Median:2090.91 stddev:102087.58 (4882.5%) stddev-sans-first:102340.56 20:54:10 INFO - PROCESS | 1650 | Values: 374.8 375.2 381.6 388.4 402.0 17163.1 19050.5 20712.0 21361.9 21616.5 20301.6 20624.4 20649.3 20915.4 21210.0 5521.3 5831.1 6121.5 6143.3 6190.7 3827.3 4066.6 6147.7 6184.1 6204.0 5830.9 6105.8 6151.4 6191.8 6197.4 5817.2 5970.5 6158.8 6526.6 6788.8 5973.9 5975.4 5982.6 5989.9 5993.4 12882.7 12963.3 13119.5 13217.1 13303.5 2311.0 2345.2 2400.5 2857.6 2988.8 9965.0 9980.0 10372.5 10413.2 10421.5 1778.2 1828.7 1854.8 1876.1 1909.7 110922.0 116581.0 117570.0 118421.0 119958.0 9343.0 9887.3 9980.1 10001.3 10181.5 12407.1 12483.5 12566.9 12581.5 12624.3 6672.7 7257.3 8028.0 8168.3 8243.1 8014.6 8478.0 8564.4 8653.0 8726.2 3828.8 3904.6 3926.8 3947.3 3971.6 1921.6 1966.7 1980.2 1990.7 3800.2 784.7 834.9 861.3 920.3 951.8 19055.5 20110.0 21510.9 22352.7 22382.7 931.3 941.2 985.5 995.9 1004.7 11290.5 11508.8 11515.8 11519.9 11522.6 602288.0 611241.0 612783.0 613669.9 613703.0 121209.0 122178.0 128869.0 140613.0 144800.0 998.5 1012.1 1014.6 1016.2 1035.3 18442.0 19246.0 19454.0 19734.6 19748.6 45173.8 52622.2 57237.7 58511.0 59425.4 81675.2 82457.0 85006.0 87116.1 87316.0 7030.0 7156.9 7280.6 7359.9 7392.0 9389.7 12061.5 12690.4 12775.7 12835.7 10975.5 11141.6 11192.6 11302.6 11489.0 8493.2 8825.9 9628.2 10181.6 11117.6 11188.3 11247.0 11493.8 11499.2 11668.8 7963.4 8047.4 8239.1 8296.8 8331.5 6829.0 9494.7 10408.1 10619.7 10928.8 20:54:10 INFO - PROCESS | 1650 | 20:54:10 INFO - PROCESS | 1650 | [#3] mootools.html Cycles:180 Average:5789.09 Median:4911.48 stddev:3280.55 (66.8%) stddev-sans-first:3273.77 20:54:10 INFO - PROCESS | 1650 | Values: 1480.1 1533.1 1638.5 1713.6 1831.7 8207.0 8485.1 8719.4 9281.4 9320.1 8738.7 9047.6 9055.5 9207.1 9214.5 2393.1 2428.0 2428.5 2431.8 2435.9 2394.6 2421.4 2438.1 2444.1 2446.4 2392.0 2422.3 2430.6 2436.9 2444.0 2383.8 2385.8 2396.0 2399.4 2407.9 2378.5 2393.2 2397.1 2398.2 2404.6 9099.2 9137.5 9174.9 9187.3 9192.4 5348.1 5456.7 5497.5 5499.2 5533.0 3601.9 3683.7 3718.8 3745.4 3780.3 1101.8 1103.9 1107.1 1111.3 1118.7 12066.5 12095.9 12139.2 12174.3 12192.5 4534.4 4601.3 4732.1 4744.2 4781.9 9354.2 9440.9 9450.7 9455.1 9457.3 5342.7 5350.8 5353.8 5357.2 5367.5 4465.8 4611.7 4839.8 4983.2 5008.0 3861.3 3884.7 3943.6 3965.7 3983.3 1187.9 1194.5 1197.2 1206.1 1207.8 794.6 893.7 922.8 925.5 928.6 5361.2 5891.8 6025.5 6089.8 6219.9 428.5 448.3 449.7 456.7 459.5 4005.0 4028.8 4048.2 4052.9 4056.2 10764.8 10979.1 11036.4 11058.0 11065.0 10900.0 10947.2 11022.6 11029.6 11034.8 8025.9 8414.5 8450.4 8452.5 8454.8 6087.6 6097.6 6173.2 6178.6 6191.3 8658.6 9172.8 10311.0 10390.6 10547.7 8681.0 10013.8 10419.8 10477.4 10496.7 6502.6 7216.6 7393.8 7781.3 7918.1 8488.2 8769.0 8772.7 8782.1 8784.8 7651.0 7754.4 7789.8 7882.3 7900.0 6237.5 7625.7 7663.7 7777.7 7785.9 5946.9 7045.0 7181.2 7203.4 7209.5 5016.3 5091.2 5121.1 5246.8 5302.3 3940.8 5115.3 5141.3 5173.2 5267.1 20:54:10 INFO - PROCESS | 1650 | 20:54:10 INFO - PROCESS | 1650 | [#4] prototype.html Cycles:180 Average:4636.77 Median:4993.28 stddev:1437.94 (28.8%) stddev-sans-first:1404.69 20:54:10 INFO - PROCESS | 1650 | Values: 302.3 305.5 309.5 315.2 315.7 5348.2 5499.6 5576.9 5578.4 5604.4 4497.3 5385.8 5459.2 5474.3 5511.9 3669.2 4229.2 4242.3 4257.0 4264.1 4093.0 4156.4 4196.4 4230.0 4251.3 3796.2 3894.6 3995.8 4147.0 4175.4 3626.5 3681.0 4187.4 4196.7 4198.9 3157.0 3560.0 3651.1 3667.9 3685.3 4370.4 4629.9 5278.7 5315.5 5335.4 4288.6 4323.5 4746.1 4796.8 4805.4 4828.5 4920.7 5493.6 5714.9 5822.9 3564.4 3664.0 3963.3 3965.0 3993.5 4961.4 4992.6 5975.6 6036.6 6105.7 3569.0 3628.0 4031.2 4050.6 4074.6 3378.3 3740.9 3828.0 4109.9 4117.1 4757.8 4777.0 4781.8 4801.6 4839.2 4760.4 4823.4 4951.8 5817.2 5875.9 1198.9 1328.5 1377.5 1428.3 1434.2 837.6 929.9 956.9 973.5 991.3 4525.7 4797.3 5337.1 5457.6 5480.2 4894.0 5629.5 5727.9 5932.5 5956.5 4774.4 5098.9 5420.5 5455.4 5480.6 2817.8 2882.3 3139.7 3156.3 3173.9 4973.4 5715.7 6254.9 6273.9 6301.7 4817.9 4897.6 6048.7 6110.5 6185.4 5758.9 6290.8 6297.9 6303.4 6315.3 4760.6 5624.7 5729.3 5925.6 5966.9 5584.3 5861.9 5903.8 5905.3 5920.5 4862.8 5451.9 5684.4 6026.4 6292.9 3601.8 3738.7 3889.1 3932.5 3976.8 5809.2 5971.9 6010.5 6044.2 6107.8 4467.6 5221.3 5804.3 5864.8 5923.4 5378.6 5491.2 5745.0 5897.4 5912.6 5016.7 5144.3 5731.0 5745.9 5819.1 5679.6 5901.8 5953.0 5979.5 6005.0 4953.0 4993.9 5476.3 5637.9 5850.4 20:54:10 INFO - PROCESS | 1650 | 20:54:10 INFO - PROCESS | 1650 | [#5] yui.html Cycles:180 Average:25413.51 Median:3769.09 stddev:41110.39 (1090.7%) stddev-sans-first:41183.99 20:54:10 INFO - PROCESS | 1650 | Values: 746.2 748.7 755.9 787.1 817.1 15157.6 15487.6 15752.6 15761.6 15796.8 14171.0 14297.9 14322.6 14323.2 14326.6 678.7 846.3 878.5 878.8 881.1 855.2 857.2 858.1 863.1 863.4 904.1 919.9 921.5 921.6 924.6 913.5 914.7 916.6 918.0 918.5 681.6 684.3 684.7 685.6 687.1 15261.5 15350.2 15462.1 15500.8 15544.5 11266.2 14131.0 14176.9 14372.4 14395.5 11544.6 11734.4 11880.3 12066.5 12114.3 3796.4 3817.3 3841.4 3955.3 3962.7 129466.4 130489.0 130545.0 132660.0 135598.6 10727.5 10965.4 10969.0 11002.0 11025.6 22134.6 22217.9 22298.6 22398.2 22467.0 6937.9 7170.5 7668.7 7950.5 8084.7 3775.4 3782.9 4304.1 4453.3 4500.0 3663.5 3762.8 3790.9 3793.8 3798.9 680.4 687.9 692.7 693.5 694.4 522.8 544.3 554.2 570.7 657.0 9605.9 9675.6 9696.9 9703.7 9863.8 635.5 654.1 667.2 670.7 673.1 4017.7 4501.7 4662.0 4677.9 4693.9 87248.6 148173.0 160406.6 167468.0 175154.0 91874.0 92393.5 105050.0 122567.4 142299.0 123155.0 123541.8 124093.1 125028.0 126280.4 9000.6 9097.9 9098.8 9109.5 9143.5 49697.8 65659.0 66384.7 67595.0 70670.9 64822.0 86528.7 86653.3 101703.5 104498.0 12800.2 13078.3 13082.3 13151.7 13266.2 15387.6 15450.3 15683.5 15886.4 15893.3 14037.2 14054.7 14156.6 14533.6 14700.8 13799.7 13835.4 13871.8 14097.7 14147.6 13098.2 13176.5 13659.7 13753.2 14216.6 10884.0 11171.8 11328.8 11796.3 12319.4 11039.0 11499.8 11802.2 11894.9 11896.5 20:54:10 INFO - PROCESS | 1650 | -------- Summary: end -------- 20:54:10 INFO - PROCESS | 1650 | 20:54:11 INFO - TEST-INFO | 1650: exit 0 20:54:11 INFO - TEST-OK | dromaeo_css | took 1115155ms 20:54:11 INFO - TEST-START | kraken 20:54:11 INFO - operating with platform_type : mac_ 20:54:11 INFO - Initialising browser for kraken test... 20:54:11 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/tmpPv0ZTv/profile http://localhost:49272/getInfo.html) 20:54:13 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 20:54:13 INFO - PROCESS | 1659 | colorDepth:24 20:54:13 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 20:54:13 INFO - PROCESS | 1659 | __metrics 20:54:13 ERROR - PROCESS | 1659 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 20:54:14 INFO - TEST-INFO | 1659: exit 0 20:54:14 INFO - Browser initialized. 20:54:14 INFO - Running cycle 1/1 for kraken test... 20:54:14 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/tmpPv0ZTv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:54:26 INFO - PROCESS | 1661 | RSS: Main: 224534528 20:54:26 INFO - PROCESS | 1661 | 20:54:29 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 20:54:30 INFO - PROCESS | 1661 | RSS: Main: 237531136 20:54:30 INFO - PROCESS | 1661 | 20:54:32 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 20:54:33 INFO - PROCESS | 1661 | RSS: Main: 244985856 20:54:33 INFO - PROCESS | 1661 | 20:54:36 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 20:54:37 INFO - PROCESS | 1661 | RSS: Main: 248737792 20:54:37 INFO - PROCESS | 1661 | 20:54:39 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 20:54:40 INFO - PROCESS | 1661 | RSS: Main: 250441728 20:54:40 INFO - PROCESS | 1661 | 20:54:42 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:54:42 INFO - PROCESS | 1661 | RSS: Main: 250548224 20:54:42 INFO - PROCESS | 1661 | 20:54:45 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 20:54:46 INFO - PROCESS | 1661 | RSS: Main: 251043840 20:54:46 INFO - PROCESS | 1661 | 20:54:49 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 20:54:50 INFO - PROCESS | 1661 | RSS: Main: 251310080 20:54:50 INFO - PROCESS | 1661 | 20:54:52 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 20:54:53 INFO - PROCESS | 1661 | RSS: Main: 251797504 20:54:53 INFO - PROCESS | 1661 | 20:54:55 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:54:55 INFO - PROCESS | 1661 | RSS: Main: 251260928 20:54:55 INFO - PROCESS | 1661 | 20:54:57 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:54:58 INFO - PROCESS | 1661 | RSS: Main: 251326464 20:54:58 INFO - PROCESS | 1661 | 20:55:00 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:55:01 INFO - PROCESS | 1661 | RSS: Main: 251273216 20:55:01 INFO - PROCESS | 1661 | 20:55:04 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:55:04 INFO - PROCESS | 1661 | RSS: Main: 251518976 20:55:04 INFO - PROCESS | 1661 | 20:55:07 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:55:08 INFO - PROCESS | 1661 | RSS: Main: 251719680 20:55:08 INFO - PROCESS | 1661 | 20:55:10 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 20:55:10 INFO - PROCESS | 1661 | RSS: Main: 253472768 20:55:10 INFO - PROCESS | 1661 | 20:55:10 INFO - PROCESS | 1661 | __start_tp_report 20:55:10 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 20:55:10 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 20:55:10 INFO - PROCESS | 1661 | |i|pagename|runs| 20:55:10 INFO - PROCESS | 1661 | |0;ai-astar;106;119;119;120;120;119;118;117;116;119 20:55:10 INFO - PROCESS | 1661 | |1;audio-beat-detection;141;111;109;148;114;111;113;119;178;119 20:55:10 INFO - PROCESS | 1661 | |2;audio-dft;200;204;201;194;230;225;200;199;199;188 20:55:10 INFO - PROCESS | 1661 | |3;audio-fft;82;61;59;93;74;84;86;82;77;59 20:55:10 INFO - PROCESS | 1661 | |4;audio-oscillator;84;82;91;75;71;58;109;63;79;119 20:55:10 INFO - PROCESS | 1661 | |5;imaging-gaussian-blur;88;87;103;133;88;85;88;104;89;86 20:55:10 INFO - PROCESS | 1661 | |6;imaging-darkroom;94;139;96;96;95;137;109;151;106;150 20:55:10 INFO - PROCESS | 1661 | |7;imaging-desaturate;91;95;91;96;95;92;141;150;90;92 20:55:10 INFO - PROCESS | 1661 | |8;json-parse-financial;55;56;56;54;58;59;60;60;60;59 20:55:10 INFO - PROCESS | 1661 | |9;json-stringify-tinderbox;69;75;76;77;72;69;92;61;82;106 20:55:10 INFO - PROCESS | 1661 | |10;stanford-crypto-aes;87;90;86;88;86;86;84;86;92;84 20:55:10 INFO - PROCESS | 1661 | |11;stanford-crypto-ccm;137;165;153;132;157;158;159;140;178;142 20:55:10 INFO - PROCESS | 1661 | |12;stanford-crypto-pbkdf2;167;169;201;239;166;167;165;167;185;232 20:55:10 INFO - PROCESS | 1661 | |13;stanford-crypto-sha256-iterative;70;82;68;61;87;84;88;88;90;94 20:55:10 INFO - PROCESS | 1661 | __end_tp_report 20:55:10 INFO - PROCESS | 1661 | __start_cc_report 20:55:10 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,945 20:55:10 INFO - PROCESS | 1661 | __end_cc_report 20:55:10 INFO - PROCESS | 1661 | __startTimestamp1474516510671__endTimestamp 20:55:10 INFO - PROCESS | 1661 | 20:55:10 INFO - PROCESS | 1661 | ------- Summary: start ------- 20:55:10 INFO - PROCESS | 1661 | Number of tests: 14 20:55:10 INFO - PROCESS | 1661 | 20:55:10 INFO - PROCESS | 1661 | [#0] ai-astar Cycles:10 Average:117.30 Median:119.00 stddev:4.16 (3.5%) stddev-sans-first:1.33 20:55:10 INFO - PROCESS | 1661 | Values: 106.0 119.0 119.0 120.0 120.0 119.0 118.0 117.0 116.0 119.0 20:55:10 INFO - PROCESS | 1661 | 20:55:10 INFO - PROCESS | 1661 | [#1] audio-beat-detection Cycles:10 Average:126.30 Median:119.00 stddev:22.51 (18.9%) stddev-sans-first:23.24 20:55:10 INFO - PROCESS | 1661 | Values: 141.0 111.0 109.0 148.0 114.0 111.0 113.0 119.0 178.0 119.0 20:55:10 INFO - PROCESS | 1661 | 20:55:10 INFO - PROCESS | 1661 | [#2] audio-dft Cycles:10 Average:204.00 Median:200.50 stddev:13.18 (6.6%) stddev-sans-first:13.90 20:55:10 INFO - PROCESS | 1661 | Values: 200.0 204.0 201.0 194.0 230.0 225.0 200.0 199.0 199.0 188.0 20:55:10 INFO - PROCESS | 1661 | 20:55:10 INFO - PROCESS | 1661 | [#3] audio-fft Cycles:10 Average:75.70 Median:82.00 stddev:12.17 (14.8%) stddev-sans-first:12.69 20:55:10 INFO - PROCESS | 1661 | Values: 82.0 61.0 59.0 93.0 74.0 84.0 86.0 82.0 77.0 59.0 20:55:10 INFO - PROCESS | 1661 | 20:55:10 INFO - PROCESS | 1661 | [#4] audio-oscillator Cycles:10 Average:83.10 Median:77.00 stddev:19.11 (24.8%) stddev-sans-first:20.27 20:55:10 INFO - PROCESS | 1661 | Values: 84.0 82.0 91.0 75.0 71.0 58.0 109.0 63.0 79.0 119.0 20:55:10 INFO - PROCESS | 1661 | 20:55:10 INFO - PROCESS | 1661 | [#5] imaging-gaussian-blur Cycles:10 Average:95.10 Median:87.50 stddev:14.97 (17.1%) stddev-sans-first:15.66 20:55:10 INFO - PROCESS | 1661 | Values: 88.0 87.0 103.0 133.0 88.0 85.0 88.0 104.0 89.0 86.0 20:55:10 INFO - PROCESS | 1661 | 20:55:10 INFO - PROCESS | 1661 | [#6] imaging-darkroom Cycles:10 Average:117.30 Median:122.50 stddev:24.06 (19.6%) stddev-sans-first:23.99 20:55:10 INFO - PROCESS | 1661 | Values: 94.0 139.0 96.0 96.0 95.0 137.0 109.0 151.0 106.0 150.0 20:55:10 INFO - PROCESS | 1661 | 20:55:10 INFO - PROCESS | 1661 | [#7] imaging-desaturate Cycles:10 Average:103.30 Median:92.00 stddev:22.43 (24.4%) stddev-sans-first:23.35 20:55:10 INFO - PROCESS | 1661 | Values: 91.0 95.0 91.0 96.0 95.0 92.0 141.0 150.0 90.0 92.0 20:55:10 INFO - PROCESS | 1661 | 20:55:10 INFO - PROCESS | 1661 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:59.00 stddev:2.26 (3.8%) stddev-sans-first:2.18 20:55:10 INFO - PROCESS | 1661 | Values: 55.0 56.0 56.0 54.0 58.0 59.0 60.0 60.0 60.0 59.0 20:55:10 INFO - PROCESS | 1661 | 20:55:10 INFO - PROCESS | 1661 | [#9] json-stringify-tinderbox Cycles:10 Average:77.90 Median:75.50 stddev:12.90 (17.1%) stddev-sans-first:13.27 20:55:10 INFO - PROCESS | 1661 | Values: 69.0 75.0 76.0 77.0 72.0 69.0 92.0 61.0 82.0 106.0 20:55:10 INFO - PROCESS | 1661 | 20:55:10 INFO - PROCESS | 1661 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:86.50 stddev:2.51 (2.9%) stddev-sans-first:2.67 20:55:10 INFO - PROCESS | 1661 | Values: 87.0 90.0 86.0 88.0 86.0 86.0 84.0 86.0 92.0 84.0 20:55:10 INFO - PROCESS | 1661 | 20:55:10 INFO - PROCESS | 1661 | [#11] stanford-crypto-ccm Cycles:10 Average:152.10 Median:157.50 stddev:14.24 (9.0%) stddev-sans-first:14.02 20:55:10 INFO - PROCESS | 1661 | Values: 137.0 165.0 153.0 132.0 157.0 158.0 159.0 140.0 178.0 142.0 20:55:10 INFO - PROCESS | 1661 | 20:55:10 INFO - PROCESS | 1661 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.80 Median:177.00 stddev:28.60 (16.2%) stddev-sans-first:29.52 20:55:10 INFO - PROCESS | 1661 | Values: 167.0 169.0 201.0 239.0 166.0 167.0 165.0 167.0 185.0 232.0 20:55:10 INFO - PROCESS | 1661 | 20:55:10 INFO - PROCESS | 1661 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:81.20 Median:87.50 stddev:10.97 (12.5%) stddev-sans-first:10.86 20:55:10 INFO - PROCESS | 1661 | Values: 70.0 82.0 68.0 61.0 87.0 84.0 88.0 88.0 90.0 94.0 20:55:10 INFO - PROCESS | 1661 | -------- Summary: end -------- 20:55:10 INFO - PROCESS | 1661 | 20:55:11 INFO - TEST-INFO | 1661: exit 0 20:55:11 INFO - TEST-OK | kraken | took 60200ms 20:55:11 INFO - SUITE-END | took 1175s 20:55:11 INFO - Completed test suite (00:19:35) 20:55:11 INFO - javascript benchmark 20:55:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7384.134306101958, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3427.6572342765726, 3429.8971030869066, 3443.139215196201, 3458.6195518492955, 3463.792172469652, 5782.797602083928, 5843.123531470282, 5845.7369418376165, 5857.121431785235, 5862.88274234515, 5800.9129863051985, 5861.824145275638, 5886.117082437626, 5913.0, 5925.200097986771, 5270.868228294295, 5340.599455040868, 5366.087765079946, 5390.434004429537, 5394.271773310612, 5366.490183432567, 5380.112281473572, 5396.78412863485, 5398.865028374283, 5407.457356209877, 5253.842384728445, 5263.789448422059, 5381.623286369956, 5389.649672771257, 5435.130379139338, 5284.841454756363, 5313.22958171065, 5322.547583455411, 5328.360596728378, 5333.093374126408, 5210.348706411699, 5261.605379596507, 5294.973525132388, 5345.33183352081, 5369.355677318707, 5224.608154388436, 5650.434956504317, 5859.209006784072, 5877.617954832965, 5912.201852749867, 5159.638825282232, 6123.3131248723375, 6201.937980620226, 6217.937820621826, 6261.78083767066, 6311.779087731908, 6338.683065846689, 6345.777897773602, 6346.0, 6366.822137904503, 5841.4450627190345, 5940.524758019348, 5947.583669143161, 5953.821385358447, 5967.820965371089, 6347.238331400169, 6347.746090156342, 6389.6805159741825, 6414.839629009312, 6426.582272152295, 4854.951450485521, 5047.621428392885, 5079.697150826843, 6123.724432400552, 6196.287426945959, 6161.983272760034, 6162.691865406712, 6225.003999360171, 6328.810135695937, 6355.491560675135, 6189.566730328924, 6246.125542424064, 6260.593061451083, 6270.090836828635, 6278.152449419361, 5178.792848286026, 6274.1843560337775, 6275.278342990523, 6301.7164227609865, 6304.747810087637, 4050.5544390117066, 4889.242167464049, 4934.506549345037, 4950.480199578992, 4979.2033274676605, 4436.511983681792, 4499.685022048425, 4502.774861256924, 4511.255642818964, 4520.141173177086, 5903.793367232126, 6056.091586262096, 6060.515158787286, 6077.453029227391, 6100.847478813065, 6169.198004259418, 6248.125262463259, 6318.968405157945, 6320.778772743024, 6329.208848893888, 5889.823305300848, 5956.642601443928, 6017.608855424383, 6057.878842423127, 6109.572329936951, 5505.862353441116, 5514.200440936042, 5517.089680202722, 5521.972390138024, 5536.086545719912, 6428.035794630843, 6478.578892371981, 6489.7404103835315, 6499.707513161825, 6518.5762925410645, 6237.500999919905, 6247.31279559239, 6253.0, 6282.465990390868, 6301.779437719658, 6450.516211284266, 6528.314526974789, 6530.738770449128, 6535.150430444012, 6537.836554086186, 5380.623356365017, 5800.0, 6297.275813281532, 6297.370262973666, 6303.275123360689, 6161.72272247741, 6222.471089957405, 6236.18929539157, 6241.0, 6272.74909003653, 6241.251049873863, 6257.0, 6266.655333956676, 6278.0269058296035, 6285.905711414241, 5447.96488667152, 6246.156768836149, 6251.593646412968, 6288.899442597436, 6296.212973378328, 5825.184474173704, 5991.730372133177, 6013.6692481913915, 6072.453479186895, 6144.846378840565, 6171.197744293213, 6211.534134939988, 6257.812265632038, 6271.6550589718, 6286.497080233479, 6136.079588061826, 6151.753929842756, 6156.630602163885, 6159.876802463836, 6179.876402472015], "value": 5765.738186648083, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [441.57829273044246, 447.5122116892587, 492.99429164504414, 510.5175609049445, 519.7842895198493, 36600.633993660056, 39766.602333976654, 39774.602253977486, 39780.0, 40019.79990100049, 41368.0, 41661.58338416615, 42056.57943420565, 42104.0, 42154.78922605383, 9574.617015319396, 9830.754231144243, 9837.458939758311, 9858.964808695091, 9877.851832222523, 8242.876356854622, 9698.32111752174, 9812.116909478145, 9828.0, 9848.852267215998, 9837.852432213522, 9850.60597576096, 9869.259805514579, 9875.40747555149, 9946.950265248664, 9806.803863922752, 9810.509474526316, 9844.556994935245, 9860.950695246549, 9863.605455781795, 9674.274429417821, 9674.613015479372, 9707.951460242724, 9788.021197880225, 9812.165965892907, 31284.843575782204, 32312.0, 39031.0, 39096.02259943496, 39320.80339598284, 2806.733360330765, 3145.339478709474, 3230.5800245967876, 3377.1894745261206, 3832.2527107214105, 29800.0, 29800.254993625334, 30586.69413305861, 30671.611288891752, 31482.37035259282, 2779.4163225722623, 3141.2932090279733, 3293.4236508610898, 3433.5536380270655, 3435.7251419886347, 513493.0, 519590.0, 519699.0, 520654.0, 521674.0, 61958.0706289406, 62306.0, 62499.68750156311, 62589.687051565365, 62907.6854615724, 34857.825710871286, 35669.1082722934, 53489.732551336994, 65060.0, 65883.67058164679, 16699.33202671904, 16843.41048063312, 16844.663106737797, 16857.91571042137, 16954.830451695325, 12874.742505149845, 12963.22220666763, 12985.675358115934, 13014.023948203923, 13032.739345213042, 18889.7166542502, 19191.80808191928, 19359.806401936083, 19366.612667746565, 19397.321093761933, 7876.133625301212, 7952.2842944134145, 8000.479968802126, 8008.7597372078935, 8026.8728786871525, 871.2942516561606, 1019.1744686803713, 1055.6358056470506, 1063.7393838509615, 1089.1341383600056, 27660.308492287855, 28128.43743125126, 30076.548851767242, 30322.0, 30756.0, 815.6900377856496, 983.3755565216139, 1080.6163811846839, 1089.841972913939, 1113.4210210690558, 15297.0, 15682.529524114294, 15796.763048554281, 15873.603159921095, 16043.278052487665, 710819.0, 714626.0, 719027.0, 719360.0, 720769.0, 57536.136957945666, 58098.419015809304, 58231.8353632925, 58307.833843323744, 58422.83154336889, 1353.4180302469836, 1376.5319791271015, 1405.058610730813, 1405.796159556879, 1410.92945352734, 29158.0, 29749.256268593457, 29978.550321745628, 30332.609726276387, 30728.692713073477, 41356.759297221135, 50024.74987625039, 50481.74759126181, 50555.49444505655, 50667.0, 571399.0, 619408.0, 621722.0, 621723.0, 629015.0, 26725.06462273811, 26778.330541736614, 27170.1848944532, 27170.864145679145, 27218.82249420002, 37391.50433982719, 46161.538384617066, 46943.530564693916, 47066.52933470622, 48528.272075919594, 30986.535201972438, 38419.42370864384, 39355.0, 40442.39336410015, 40672.983175419664, 32613.673863262014, 39198.82403527899, 39551.0, 39847.203055939295, 40670.79664601658, 32314.030579082664, 32928.83535582307, 36099.0, 37591.2481750358, 38174.80912595419, 25948.610770838073, 33461.82883599062, 34154.65845341515, 35282.294354113284, 35354.64645353617, 25453.109141179968, 25902.35244118912, 25985.740142598333, 25989.700514973796, 26388.868055659597], "value": 19925.21856748925, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.80697440817966, 375.19895024123497, 381.574544383013, 388.4134956216116, 402.0210786734302, 17163.056031918255, 19050.523736906565, 20711.964401779907, 21361.893190534025, 21616.459588510294, 20301.59396812063, 20624.381268561967, 20649.277275295368, 20915.37253882382, 21210.0, 5521.254630624874, 5831.125331200312, 6121.479674227674, 6143.324234334242, 6190.721417536199, 3827.291950989062, 4066.552679205285, 6147.7233524491285, 6184.07238914162, 6204.007358822567, 5830.892130495214, 6105.847353816146, 6151.415615516541, 6191.752329906798, 6197.442230199281, 5817.1565123057135, 5970.522358211333, 6158.753649854, 6526.641034743087, 6788.796336109925, 5973.894829456521, 5975.372585878507, 5982.611130276518, 5989.940100598982, 5993.430624090704, 12882.742345153138, 12963.28701921394, 13119.475220991244, 13217.07480476367, 13303.534376296782, 2311.0, 2345.2495201535517, 2400.471896182837, 2857.5856500807267, 2988.835614041227, 9964.950175249078, 9980.0, 10372.481375931173, 10413.219008574388, 10421.53103110362, 1778.1998100854667, 1828.7256911463253, 1854.8237917397826, 1876.0713446843763, 1909.713542968552, 110922.0, 116581.0, 117570.0, 118421.0, 119958.0, 9342.95328523353, 9887.258455615858, 9980.051895069957, 10001.299909006446, 10181.54183061764, 12407.131500794858, 12483.50065997368, 12566.937165314115, 12581.496740130475, 12624.305663188612, 6672.666366681647, 7257.346838784535, 8027.959860200662, 8168.264856162974, 8243.05204901432, 8014.559199244098, 8478.02502712196, 8564.400491965502, 8653.004904435944, 8726.214640682369, 3828.770273783582, 3904.6095390460728, 3926.764394136361, 3947.2894878921497, 3971.5829837867186, 1921.5868588253313, 1966.7246585478044, 1980.1881228696166, 1990.741203643517, 3800.239952009609, 784.6782819044164, 834.9332053435711, 861.3453775130946, 920.346553946692, 951.785848184153, 19055.523611909535, 20110.0, 21510.892445537673, 22352.664710029363, 22382.664260036112, 931.3340961212765, 941.1623654947102, 985.5466485416645, 995.8572339069581, 1004.6985904228702, 11290.491927863266, 11508.769824603629, 11515.827262591069, 11519.88480115188, 11522.596709115141, 602288.0, 611241.0, 612783.0, 613669.9316503389, 613703.0, 121209.0, 122178.0, 128869.0, 140613.0, 144800.0, 998.5072316886157, 1012.0739523336213, 1014.6144465103214, 1016.2327442780653, 1035.3270374256792, 18442.0, 19246.0, 19454.0, 19734.60530789405, 19748.605027899073, 45173.77413112913, 52622.15822446196, 57237.71381143068, 58511.0, 59425.405745941986, 81675.18324816914, 82457.0, 85006.0, 87116.1288387108, 87316.0, 7030.0, 7156.892646610409, 7280.563166210044, 7359.926400736138, 7391.963040184764, 9389.718308450758, 12061.457234424297, 12690.365481726061, 12775.680607984874, 12835.743285134058, 10975.451227438756, 11141.554337826396, 11192.552297907992, 11302.604408845651, 11489.0, 8493.150684931457, 8825.896762904636, 9628.18160456369, 10181.592736290762, 11117.610883619034, 11188.272762270426, 11247.044001259985, 11493.770124597295, 11499.195056345976, 11668.766624667629, 7963.357987281177, 8047.436679432383, 8239.093699693149, 8296.792580185544, 8331.541765202972, 6828.9658551706925, 9494.667686630935, 10408.115310198718, 10619.681409557727, 10928.78142437131], "value": 9321.615363868337, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1480.1489143742347, 1533.1261181126758, 1638.4511188751767, 1713.614436751731, 1831.679456095183, 8207.015158181026, 8485.10906354833, 8719.389642725011, 9281.396709213914, 9320.067993200684, 8738.694145704885, 9047.592858321375, 9055.456672599632, 9207.125323094311, 9214.539273036355, 2393.1384701507486, 2428.00451814756, 2428.5264373447185, 2431.7932975697086, 2435.866027368494, 2394.568977584034, 2421.4188594737225, 2438.085717855804, 2444.144549407702, 2446.449548851512, 2391.988040059797, 2422.2733180045916, 2430.5989511730545, 2436.914707985221, 2444.022391043588, 2383.797377222938, 2385.844920080198, 2395.964060539102, 2399.3881560202126, 2407.8796060197096, 2378.4767351182713, 2393.1623931623967, 2397.0891061396733, 2398.220578312038, 2404.5671779079757, 9099.181073703332, 9137.543122843897, 9174.908250917471, 9187.26501879848, 9192.402493837879, 5348.117560602496, 5456.727163641842, 5497.505224529811, 5499.202615620753, 5532.972335138339, 3601.8559257629663, 3683.723720720957, 3718.7768733876055, 3745.382011968022, 3780.300644380771, 1101.832058018503, 1103.8840921703265, 1107.1364335818075, 1111.2832223216062, 1118.6588090632354, 12066.457009434509, 12095.93952030243, 12139.210951288138, 12174.330411827346, 12192.512299508098, 4534.410526631516, 4601.28680054592, 4732.077244937204, 4744.240921452551, 4781.928271075936, 9354.20489258407, 9440.858387124199, 9450.669226577036, 9455.101765332283, 9457.290703197288, 5342.652727572696, 5350.785968561214, 5353.812616558402, 5357.249985002103, 5367.490088441592, 4465.843695470708, 4611.700239484423, 4839.806407743721, 4983.152864013126, 5008.048470790538, 3861.3049651062515, 3884.669803066771, 3943.5662077171487, 3965.7422267552515, 3983.322835118037, 1187.893089621938, 1194.4804010255393, 1197.1978774221293, 1206.1255589697575, 1207.7886369885234, 794.5907857453416, 893.7140115163086, 922.8200500902394, 925.4956048953337, 928.5635751196927, 5361.222622719683, 5891.823245302648, 6025.517958563304, 6089.847753806191, 6219.937800622027, 428.5414606371153, 448.34765416319175, 449.6537665997229, 456.65522530489267, 459.54734586432335, 4005.0387906902133, 4028.8388464461677, 4048.2105989332385, 4052.90571545681, 4056.249593825152, 10764.762052363922, 10979.121670266359, 11036.392998385005, 11058.0, 11065.0, 10899.964503372166, 10947.233693641369, 11022.559097636005, 11029.558817647365, 11034.779304413867, 8025.9197408025175, 8414.49513029208, 8450.366222533212, 8452.492850428995, 8454.83090338202, 6087.604305720114, 6097.573169878244, 6173.166622505904, 6178.567500274938, 6191.288001879841, 8658.610362533575, 9172.761677173496, 10311.020453056948, 10390.636327728493, 10547.683569492927, 8681.0, 10013.799724005625, 10419.791604167722, 10477.37135771856, 10496.737581560523, 6502.60984340941, 7216.639168041682, 7393.778186654409, 7781.338586220235, 7918.089419716806, 8488.236058754741, 8768.991565969995, 8772.736817895473, 8782.121787821166, 8784.824303514022, 7651.0, 7754.379649628129, 7789.766307010798, 7882.330001949898, 7899.960500197462, 6237.5009999200865, 7625.656845442079, 7663.69345226207, 7777.72777952769, 7785.883211751715, 5946.910796337972, 7044.964775176091, 7181.210066892742, 7203.387712044325, 7209.4592905533345, 5016.347874776256, 5091.236314552847, 5121.052997290063, 5246.842594722164, 5302.28419163408, 3940.8226629801156, 5115.2582875483595, 5141.331626888481, 5173.249878767633, 5267.104592219409], "value": 4563.372491689317, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.2941431756849, 305.53863665864543, 309.5078824668777, 315.1836742836057, 315.7000849193267, 5348.154886564139, 5499.615026948115, 5576.9163462547995, 5578.378162263734, 5604.439556044394, 4497.280435130379, 5385.838424847251, 5459.235707001013, 5474.315710536183, 5511.889762204763, 3669.156403787073, 4229.217594744967, 4242.2788126018495, 4256.9996050928, 4264.147170565884, 4092.9590704093025, 4156.37901218525, 4196.39152322913, 4230.0, 4251.341042138473, 3796.1838204785968, 3894.6105389460968, 3995.8002099895034, 4147.025449019478, 4175.4363160973335, 3626.476879710528, 3680.963190368089, 4187.392828039948, 4196.748195108304, 4198.895027624303, 3156.9842150789327, 3560.0, 3651.1419816343137, 3667.8899633010788, 3685.3366394049062, 4370.366296886934, 4629.861104166846, 5278.683279003272, 5315.548178404841, 5335.413104558495, 4288.649075541226, 4323.4867796271365, 4746.145693775119, 4796.834089500912, 4805.399325084364, 4828.46886842447, 4920.655554111214, 5493.560515158778, 5714.885702285931, 5822.854428639275, 3564.3940530109944, 3663.99240208942, 3963.286608410485, 3964.960350396488, 3993.520777506689, 4961.429435614915, 4992.625553083533, 5975.611585246945, 6036.641755604954, 6105.664188469633, 3568.982155089208, 3627.9818600907356, 4031.1937612477623, 4050.589899010084, 4074.633283004544, 3378.3412234614507, 3740.8877733668032, 3827.961720382816, 4109.91780164395, 4117.138588680898, 4757.834330588958, 4777.044591081728, 4781.772303694992, 4801.615870730333, 4839.177339852234, 4760.381150450419, 4823.397075365579, 4951.836318465158, 5817.200809332233, 5875.9118613220835, 1198.8501437320335, 1328.4885319152197, 1377.5454100146928, 1428.328685517805, 1434.2040167706814, 837.6481877611418, 929.9023602521773, 956.8803899512561, 973.5348300807382, 991.3258983891023, 4525.732794817456, 4797.328374027639, 5337.066013447631, 5457.590680698963, 5480.232767412565, 4893.95106048942, 5629.521490673257, 5727.883062802797, 5932.525397968152, 5956.463918247378, 4774.379330686988, 5098.949010509921, 5420.4850539198715, 5455.399906010336, 5480.588955828329, 2817.7742681933014, 2882.30824602094, 3139.6970257342946, 3156.2740569668645, 3173.920651983719, 4973.428055773632, 5715.685637289906, 6254.874902501924, 6273.8745225095245, 6301.6534090625455, 4817.879553011133, 4897.608191344684, 6048.697565121726, 6110.541709371815, 6185.443310102112, 5758.913616295759, 6290.77329920661, 6297.937020629735, 6303.361126107154, 6315.273743519462, 4760.6191504678845, 5624.690642014565, 5729.312482502127, 5925.644461332334, 5966.880662386641, 5584.329880414214, 5861.9413805861395, 5903.763849445974, 5905.320888097924, 5920.4671579556325, 4862.784303924019, 5451.918221226605, 5684.403137670651, 6026.367231440636, 6292.874142517033, 3601.819909004592, 3738.7382883197915, 3889.0666240101605, 3932.508436445444, 3976.8011599419333, 5809.24479817621, 5971.850703732442, 6010.4838669378905, 6044.219658956929, 6107.816765497042, 4467.6202522785925, 5221.326912413445, 5804.2744656917885, 5864.800699737599, 5923.4076592340425, 5378.596605254544, 5491.203775452457, 5744.9946259403605, 5897.439743224559, 5912.605394815107, 5016.749162541932, 5144.279800827812, 5731.02572562657, 5745.942540574708, 5819.127130930395, 5679.6024278301775, 5901.793437229677, 5952.970235148797, 5979.455613733507, 6005.0, 4952.994037414853, 4993.926305844116, 5476.288082549243, 5637.900609381131, 5850.385709500441], "value": 4183.776440839295, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [746.216472703661, 748.7341993592274, 755.939524838013, 787.0948409329275, 817.1093508076195, 15157.621059473518, 15487.612809679764, 15752.606184845385, 15761.60595985101, 15796.763048554281, 14171.0, 14297.928510357433, 14322.641933951656, 14323.212223327713, 14326.641833954156, 678.7488629207201, 846.2764336492303, 878.4509681449094, 878.7846977490524, 881.0528681667201, 855.1619412975288, 857.2284943550823, 858.107568129145, 863.1454859688894, 863.3740538109882, 904.1049361132498, 919.8850143732034, 921.5392303848076, 921.5622579274824, 924.5654542365078, 913.4701872913728, 914.7438717159206, 916.6287653500343, 917.9993806750674, 918.5085979001202, 681.560393546165, 684.260998122027, 684.7261095561765, 685.5543896467336, 687.0793137196181, 15261.465848695354, 15350.155741434217, 15462.149581772997, 15500.844991550053, 15544.533663990098, 11266.211365204439, 14131.0, 14176.85823141776, 14372.35324410404, 14395.496157634538, 11544.632257615895, 11734.413279336084, 11880.287182768976, 12066.457009434509, 12114.339147778368, 3796.4305354196817, 3817.2747178036084, 3841.42378643203, 3955.268275369066, 3962.6829853611644, 129466.35266823605, 130489.0, 130545.0, 132660.0, 135598.6440135596, 10727.463626818628, 10965.396903170242, 10969.0, 11002.009819116318, 11025.612839397463, 22134.55730885373, 22217.888910555343, 22298.55402891933, 22398.216062437736, 22466.988985495693, 6937.924621683647, 7170.533915295489, 7668.696321625337, 7950.4832185907735, 8084.676612935416, 3775.3770627846097, 3782.8865134046023, 4304.139172165516, 4453.309736990772, 4499.955000450019, 3663.4871118043493, 3762.7930463824205, 3790.9431358529646, 3793.7534060285993, 3798.924021519554, 680.4284401103097, 687.9105716256854, 692.6813665713828, 693.5284006875373, 694.350782018814, 522.8222404382528, 544.3413469701705, 554.1659801997968, 570.7346084070927, 656.957297775643, 9605.895322037915, 9675.612975481043, 9696.903030969741, 9703.708888733348, 9863.762392037146, 635.4920836979845, 654.1300070905684, 667.182701191037, 670.6847781542667, 673.1383828699175, 4017.690574147653, 4501.662375321798, 4661.976690116528, 4677.859664210079, 4693.882652933704, 87248.5637571808, 148173.0, 160406.59390109158, 167468.0, 175154.0, 91874.0, 92393.53803230941, 105050.0, 122567.38716306361, 142299.0, 123155.0, 123541.76458235303, 124093.13860292103, 125028.0, 126280.36859815642, 9000.63997440095, 9097.863532046893, 9098.772530686785, 9109.544522773967, 9143.451392916446, 49697.75151124221, 65659.0, 66384.6680766593, 67595.0, 70670.93993589998, 64822.0, 86528.70206947027, 86653.2669346597, 101703.49148254211, 104498.0, 12800.16798908068, 13078.346082696018, 13082.28047457399, 13151.671208219872, 13266.204027758366, 15387.61530961735, 15450.304736287118, 15683.451079212173, 15886.364545418515, 15893.28480218416, 14037.1577705338, 14054.718905621627, 14156.646083847574, 14533.636659083184, 14700.779488307899, 13799.655008624864, 13835.405352841879, 13871.791923121364, 14097.718045639234, 14147.64630884236, 13098.2141071536, 13176.538821141214, 13659.726805463637, 13753.174809511062, 14216.644583885485, 10884.0, 11171.832422513506, 11328.830067549157, 11796.29222246668, 12319.384030798603, 11039.00648941567, 11499.770004599693, 11802.232854864405, 11894.881051189723, 11896.524139034342], "value": 7927.739600602208, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1563.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 119.0, 119.0, 120.0, 120.0, 119.0, 118.0, 117.0, 116.0, 119.0], "value": 117.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 111.0, 109.0, 148.0, 114.0, 111.0, 113.0, 119.0, 178.0, 119.0], "value": 126.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 204.0, 201.0, 194.0, 230.0, 225.0, 200.0, 199.0, 199.0, 188.0], "value": 204.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 61.0, 59.0, 93.0, 74.0, 84.0, 86.0, 82.0, 77.0, 59.0], "value": 75.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 91.0, 75.0, 71.0, 58.0, 109.0, 63.0, 79.0, 119.0], "value": 83.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 103.0, 133.0, 88.0, 85.0, 88.0, 104.0, 89.0, 86.0], "value": 95.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 139.0, 96.0, 96.0, 95.0, 137.0, 109.0, 151.0, 106.0, 150.0], "value": 117.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 95.0, 91.0, 96.0, 95.0, 92.0, 141.0, 150.0, 90.0, 92.0], "value": 103.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 54.0, 58.0, 59.0, 60.0, 60.0, 60.0, 59.0], "value": 57.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 75.0, 76.0, 77.0, 72.0, 69.0, 92.0, 61.0, 82.0, 106.0], "value": 77.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 90.0, 86.0, 88.0, 86.0, 86.0, 84.0, 86.0, 92.0, 84.0], "value": 86.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 165.0, 153.0, 132.0, 157.0, 158.0, 159.0, 140.0, 178.0, 142.0], "value": 152.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 169.0, 201.0, 239.0, 166.0, 167.0, 165.0, 167.0, 185.0, 232.0], "value": 185.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 82.0, 68.0, 61.0, 87.0, 84.0, 88.0, 88.0, 90.0, 94.0], "value": 81.2, "unit": "score"}]}]} 20:55:11 INFO - Return code: 0 20:55:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:55:11 ERROR - # TBPL SUCCESS # 20:55:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:55:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:55:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:55:11 INFO - 2016-09-21 20:55:11.977 screenresolution[1666:10512] starting screenresolution argv=screenresolution get 20:55:11 INFO - 2016-09-21 20:55:11.979 screenresolution[1666:10512] Display 0: 1600x1200x32@60 20:55:11 INFO - 2016-09-21 20:55:11.985 screenresolution[1667:10515] starting screenresolution argv=screenresolution list 20:55:11 INFO - Available Modes on Display 0 20:55:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:55:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:55:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:55:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:55:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:55:12 INFO - Intel Iris: 20:55:12 INFO - Chipset Model: Intel Iris 20:55:12 INFO - Type: GPU 20:55:12 INFO - Bus: Built-In 20:55:12 INFO - VRAM (Dynamic, Max): 1536 MB 20:55:12 INFO - Vendor: Intel (0x8086) 20:55:12 INFO - Device ID: 0x0a2e 20:55:12 INFO - Revision ID: 0x0009 20:55:12 INFO - Displays: 20:55:12 INFO - Display: 20:55:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:55:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:55:12 INFO - Display Serial Number: 1600x1200 60 20:55:12 INFO - Main Display: Yes 20:55:12 INFO - Mirror: Off 20:55:12 INFO - Online: Yes 20:55:12 INFO - Rotation: Supported 20:55:12 INFO - Return code: 0 20:55:12 INFO - Running post-action listener: _resource_record_post_action 20:55:12 INFO - [mozharness: 2016-09-22 03:55:12.225787Z] Finished run-tests step (success) 20:55:12 INFO - Running post-run listener: _resource_record_post_run 20:55:12 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 43934720; Write bytes: 666070016; Read time: 576; Write time: 2177 20:55:12 INFO - TinderboxPrint: CPU usage
54.2% 20:55:12 INFO - TinderboxPrint: I/O read bytes / time
43,934,720 / 576 20:55:12 INFO - TinderboxPrint: I/O write bytes / time
666,070,016 / 2,177 20:55:12 INFO - TinderboxPrint: CPU idle
2,216.2 (45.8%) 20:55:12 INFO - TinderboxPrint: CPU system
977.1 (20.2%) 20:55:12 INFO - TinderboxPrint: CPU user
1,644.4 (34.0%) 20:55:12 INFO - TinderboxPrint: Swap in / out
406,429,696 / 0 20:55:12 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 356446720; Write bytes: 354817536; Read time: 27365; Write time: 723 20:55:12 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 37612544; Write bytes: 301073920; Read time: 496; Write time: 1420 20:55:12 INFO - Running post-run listener: _upload_blobber_files 20:55:12 INFO - Blob upload gear active. 20:55:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:55:12 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:55:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:55:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:55:13 INFO - (blobuploader) - INFO - Open directory for files ... 20:55:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:55:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:55:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:55:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:55:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:55:14 INFO - (blobuploader) - INFO - Done attempting. 20:55:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:55:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:55:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:55:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:55:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:55:15 INFO - (blobuploader) - INFO - Done attempting. 20:55:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:55:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:55:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:55:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:55:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:55:18 INFO - (blobuploader) - INFO - Done attempting. 20:55:18 INFO - (blobuploader) - INFO - Iteration through files over. 20:55:18 INFO - Return code: 0 20:55:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:55:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:55:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/66a6a756b10ba00e1c4d73f843315709d14ff1f98a6e5739ee4ebecd1000e77a42b73e9e7fb65ab8c3cbe7d3242ebc236e53da99197344e8dc785c1315ec900a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/81e0dc2d9218eb0a7149ce9fac1adcf5cbc86c35ff4aaf5a0c5c0337c5dac4baa97d200f02df0fc7b117b983a4626eeda9e0e2f938fc12a913ed538647112b6c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4b288a060f1ecfaa617b7cc8b8d557b420757b82ea6d4295d44318c13ebd026765f018ab38ffcf221b6b811e79b2cc78bfd66651a3e732755dc1bcd2bd93da4f"} 20:55:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:55:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:55:18 INFO - Contents: 20:55:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/66a6a756b10ba00e1c4d73f843315709d14ff1f98a6e5739ee4ebecd1000e77a42b73e9e7fb65ab8c3cbe7d3242ebc236e53da99197344e8dc785c1315ec900a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/81e0dc2d9218eb0a7149ce9fac1adcf5cbc86c35ff4aaf5a0c5c0337c5dac4baa97d200f02df0fc7b117b983a4626eeda9e0e2f938fc12a913ed538647112b6c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4b288a060f1ecfaa617b7cc8b8d557b420757b82ea6d4295d44318c13ebd026765f018ab38ffcf221b6b811e79b2cc78bfd66651a3e732755dc1bcd2bd93da4f"} 20:55:18 INFO - Running post-run listener: copy_logs_to_upload_dir 20:55:18 INFO - Copying logs to upload dir... 20:55:18 INFO - mkdir: /builds/slave/test/build/upload/logs 20:55:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.833530 ========= master_lag: 1.80 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-09-21 20:55:19.883678) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-21 20:55:19.887337) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FR9jUec9FL/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.MYbbF3IHJO/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/66a6a756b10ba00e1c4d73f843315709d14ff1f98a6e5739ee4ebecd1000e77a42b73e9e7fb65ab8c3cbe7d3242ebc236e53da99197344e8dc785c1315ec900a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/81e0dc2d9218eb0a7149ce9fac1adcf5cbc86c35ff4aaf5a0c5c0337c5dac4baa97d200f02df0fc7b117b983a4626eeda9e0e2f938fc12a913ed538647112b6c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4b288a060f1ecfaa617b7cc8b8d557b420757b82ea6d4295d44318c13ebd026765f018ab38ffcf221b6b811e79b2cc78bfd66651a3e732755dc1bcd2bd93da4f"} build_url:https://queue.taskcluster.net/v1/task/dFGFCL_xT56X0MIpuBVzBQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011220 build_url: 'https://queue.taskcluster.net/v1/task/dFGFCL_xT56X0MIpuBVzBQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/66a6a756b10ba00e1c4d73f843315709d14ff1f98a6e5739ee4ebecd1000e77a42b73e9e7fb65ab8c3cbe7d3242ebc236e53da99197344e8dc785c1315ec900a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/81e0dc2d9218eb0a7149ce9fac1adcf5cbc86c35ff4aaf5a0c5c0337c5dac4baa97d200f02df0fc7b117b983a4626eeda9e0e2f938fc12a913ed538647112b6c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4b288a060f1ecfaa617b7cc8b8d557b420757b82ea6d4295d44318c13ebd026765f018ab38ffcf221b6b811e79b2cc78bfd66651a3e732755dc1bcd2bd93da4f"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-21 20:55:19.924001) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 20:55:19.924680) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FR9jUec9FL/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.MYbbF3IHJO/Listeners TMPDIR=/var/folders/cr/txgjfp9j4mnbstqzvq00gdx400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005075 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 20:55:19.976104) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-21 20:55:19.976801) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-21 20:55:19.977469) ========= ========= Total master_lag: 5.30 =========